0s autopkgtest [18:35:52]: starting date and time: 2025-07-08 18:35:52+0000 0s autopkgtest [18:35:52]: git checkout: 508d4a25 a-v-ssh wait_for_ssh: demote "ssh connection failed" to a debug message 0s autopkgtest [18:35:52]: host juju-7f2275-prod-proposed-migration-environment-20; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.jl605koi/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:podman --apt-upgrade cockpit-podman --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=podman/5.4.2+ds1-2 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-20@bos03-s390x-7.secgroup --name adt-questing-s390x-cockpit-podman-20250708-183551-juju-7f2275-prod-proposed-migration-environment-20-e2ad8b66-7510-4baa-9176-e0ef4716b8ed --image adt/ubuntu-questing-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-20 --net-id=net_prod-proposed-migration-s390x -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 4s Creating nova instance adt-questing-s390x-cockpit-podman-20250708-183551-juju-7f2275-prod-proposed-migration-environment-20-e2ad8b66-7510-4baa-9176-e0ef4716b8ed from image adt/ubuntu-questing-s390x-server-20250708.img (UUID 2dc00079-dd1c-4150-9276-e6f69c55cf18)... 42s autopkgtest [18:36:34]: testbed dpkg architecture: s390x 42s autopkgtest [18:36:34]: testbed apt version: 3.1.3 42s autopkgtest [18:36:34]: @@@@@@@@@@@@@@@@@@@@ test bed setup 43s autopkgtest [18:36:35]: testbed release detected to be: None 43s autopkgtest [18:36:35]: updating testbed package index (apt update) 43s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [249 kB] 44s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease 44s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease 44s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease 44s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [180 kB] 44s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [29.6 kB] 44s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [15.4 kB] 44s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main s390x Packages [48.7 kB] 44s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/universe s390x Packages [156 kB] 44s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/multiverse s390x Packages [4452 B] 44s Fetched 683 kB in 1s (831 kB/s) 45s Reading package lists... 45s autopkgtest [18:36:37]: upgrading testbed (apt dist-upgrade and autopurge) 45s Reading package lists... 45s Building dependency tree... 45s Reading state information... 46s Calculating upgrade... 46s The following NEW packages will be installed: 46s linux-headers-6.15.0-4 linux-headers-6.15.0-4-generic 46s linux-image-6.15.0-4-generic linux-modules-6.15.0-4-generic 46s The following packages will be upgraded: 46s bpftool linux-generic linux-headers-generic linux-headers-virtual 46s linux-image-generic linux-image-virtual linux-libc-dev linux-perf 46s linux-tools-common linux-virtual 46s 10 upgraded, 4 newly installed, 0 to remove and 0 not upgraded. 46s Need to get 67.6 MB of archives. 46s After this operation, 156 MB of additional disk space will be used. 46s Get:1 http://ftpmaster.internal/ubuntu questing/main s390x bpftool s390x 7.6.0+6.15.0-4.4 [1165 kB] 46s Get:2 http://ftpmaster.internal/ubuntu questing/main s390x linux-modules-6.15.0-4-generic s390x 6.15.0-4.4 [34.6 MB] 48s Get:3 http://ftpmaster.internal/ubuntu questing/main s390x linux-image-6.15.0-4-generic s390x 6.15.0-4.4 [9948 kB] 49s Get:4 http://ftpmaster.internal/ubuntu questing/main s390x linux-generic s390x 6.15.0-4.4 [1732 B] 49s Get:5 http://ftpmaster.internal/ubuntu questing/main s390x linux-image-generic s390x 6.15.0-4.4 [11.4 kB] 49s Get:6 http://ftpmaster.internal/ubuntu questing/main s390x linux-virtual s390x 6.15.0-4.4 [1726 B] 49s Get:7 http://ftpmaster.internal/ubuntu questing/main s390x linux-image-virtual s390x 6.15.0-4.4 [11.4 kB] 49s Get:8 http://ftpmaster.internal/ubuntu questing/main s390x linux-headers-virtual s390x 6.15.0-4.4 [1640 B] 49s Get:9 http://ftpmaster.internal/ubuntu questing/main s390x linux-headers-6.15.0-4 all 6.15.0-4.4 [14.4 MB] 50s Get:10 http://ftpmaster.internal/ubuntu questing/main s390x linux-headers-6.15.0-4-generic s390x 6.15.0-4.4 [2925 kB] 50s Get:11 http://ftpmaster.internal/ubuntu questing/main s390x linux-headers-generic s390x 6.15.0-4.4 [11.3 kB] 50s Get:12 http://ftpmaster.internal/ubuntu questing/main s390x linux-libc-dev s390x 6.15.0-4.4 [1772 kB] 50s Get:13 http://ftpmaster.internal/ubuntu questing/main s390x linux-perf s390x 6.15.0-4.4 [2422 kB] 50s Get:14 http://ftpmaster.internal/ubuntu questing/main s390x linux-tools-common all 6.15.0-4.4 [337 kB] 51s Fetched 67.6 MB in 5s (14.3 MB/s) 51s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 82501 files and directories currently installed.) 51s Preparing to unpack .../00-bpftool_7.6.0+6.15.0-4.4_s390x.deb ... 51s Unpacking bpftool (7.6.0+6.15.0-4.4) over (7.6.0+6.15.0-3.3) ... 51s Selecting previously unselected package linux-modules-6.15.0-4-generic. 51s Preparing to unpack .../01-linux-modules-6.15.0-4-generic_6.15.0-4.4_s390x.deb ... 51s Unpacking linux-modules-6.15.0-4-generic (6.15.0-4.4) ... 51s Selecting previously unselected package linux-image-6.15.0-4-generic. 51s Preparing to unpack .../02-linux-image-6.15.0-4-generic_6.15.0-4.4_s390x.deb ... 51s Unpacking linux-image-6.15.0-4-generic (6.15.0-4.4) ... 51s Preparing to unpack .../03-linux-generic_6.15.0-4.4_s390x.deb ... 51s Unpacking linux-generic (6.15.0-4.4) over (6.15.0-3.3+1) ... 51s Preparing to unpack .../04-linux-image-generic_6.15.0-4.4_s390x.deb ... 51s Unpacking linux-image-generic (6.15.0-4.4) over (6.15.0-3.3+1) ... 51s Preparing to unpack .../05-linux-virtual_6.15.0-4.4_s390x.deb ... 51s Unpacking linux-virtual (6.15.0-4.4) over (6.15.0-3.3+1) ... 51s Preparing to unpack .../06-linux-image-virtual_6.15.0-4.4_s390x.deb ... 51s Unpacking linux-image-virtual (6.15.0-4.4) over (6.15.0-3.3+1) ... 51s Preparing to unpack .../07-linux-headers-virtual_6.15.0-4.4_s390x.deb ... 51s Unpacking linux-headers-virtual (6.15.0-4.4) over (6.15.0-3.3+1) ... 51s Selecting previously unselected package linux-headers-6.15.0-4. 51s Preparing to unpack .../08-linux-headers-6.15.0-4_6.15.0-4.4_all.deb ... 51s Unpacking linux-headers-6.15.0-4 (6.15.0-4.4) ... 52s Selecting previously unselected package linux-headers-6.15.0-4-generic. 52s Preparing to unpack .../09-linux-headers-6.15.0-4-generic_6.15.0-4.4_s390x.deb ... 52s Unpacking linux-headers-6.15.0-4-generic (6.15.0-4.4) ... 52s Preparing to unpack .../10-linux-headers-generic_6.15.0-4.4_s390x.deb ... 52s Unpacking linux-headers-generic (6.15.0-4.4) over (6.15.0-3.3+1) ... 52s Preparing to unpack .../11-linux-libc-dev_6.15.0-4.4_s390x.deb ... 52s Unpacking linux-libc-dev:s390x (6.15.0-4.4) over (6.15.0-3.3) ... 52s Preparing to unpack .../12-linux-perf_6.15.0-4.4_s390x.deb ... 52s Unpacking linux-perf (6.15.0-4.4) over (6.15.0-3.3) ... 52s Preparing to unpack .../13-linux-tools-common_6.15.0-4.4_all.deb ... 52s Unpacking linux-tools-common (6.15.0-4.4) over (6.15.0-3.3) ... 52s Setting up bpftool (7.6.0+6.15.0-4.4) ... 52s Setting up linux-headers-6.15.0-4 (6.15.0-4.4) ... 52s Setting up linux-libc-dev:s390x (6.15.0-4.4) ... 52s Setting up linux-headers-6.15.0-4-generic (6.15.0-4.4) ... 52s Setting up linux-perf (6.15.0-4.4) ... 52s Setting up linux-modules-6.15.0-4-generic (6.15.0-4.4) ... 53s Setting up linux-tools-common (6.15.0-4.4) ... 53s Setting up linux-headers-generic (6.15.0-4.4) ... 53s Setting up linux-image-6.15.0-4-generic (6.15.0-4.4) ... 53s I: /boot/vmlinuz.old is now a symlink to vmlinuz-6.15.0-3-generic 53s I: /boot/initrd.img.old is now a symlink to initrd.img-6.15.0-3-generic 53s I: /boot/vmlinuz is now a symlink to vmlinuz-6.15.0-4-generic 53s I: /boot/initrd.img is now a symlink to initrd.img-6.15.0-4-generic 53s Setting up linux-image-virtual (6.15.0-4.4) ... 53s Setting up linux-image-generic (6.15.0-4.4) ... 53s Setting up linux-headers-virtual (6.15.0-4.4) ... 53s Setting up linux-generic (6.15.0-4.4) ... 53s Setting up linux-virtual (6.15.0-4.4) ... 53s Processing triggers for man-db (2.13.1-1) ... 54s Processing triggers for linux-image-6.15.0-4-generic (6.15.0-4.4) ... 54s /etc/kernel/postinst.d/initramfs-tools: 54s update-initramfs: Generating /boot/initrd.img-6.15.0-4-generic 54s W: No lz4 in /usr/bin:/sbin:/bin, using gzip 56s Using config file '/etc/zipl.conf' 56s Building bootmap in '/boot' 56s Adding IPL section 'ubuntu' (default) 56s Preparing boot device for LD-IPL: vda (0000). 56s Done. 56s /etc/kernel/postinst.d/zz-zipl: 56s Using config file '/etc/zipl.conf' 56s Building bootmap in '/boot' 56s Adding IPL section 'ubuntu' (default) 56s Preparing boot device for LD-IPL: vda (0000). 56s Done. 56s Reading package lists... 56s Building dependency tree... 56s Reading state information... 56s Solving dependencies... 57s The following packages will be REMOVED: 57s linux-headers-6.14.0-15* linux-headers-6.14.0-15-generic* 57s linux-image-6.14.0-15-generic* linux-modules-6.14.0-15-generic* 57s linux-modules-extra-6.14.0-15-generic* linux-tools-6.14.0-15* 57s linux-tools-6.14.0-15-generic* wireless-regdb* 57s 0 upgraded, 0 newly installed, 8 to remove and 0 not upgraded. 57s After this operation, 156 MB disk space will be freed. 57s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 107798 files and directories currently installed.) 57s Removing linux-headers-6.14.0-15-generic (6.14.0-15.15) ... 57s Removing linux-headers-6.14.0-15 (6.14.0-15.15) ... 58s Removing linux-image-6.14.0-15-generic (6.14.0-15.15) ... 58s /etc/kernel/postrm.d/initramfs-tools: 58s update-initramfs: Deleting /boot/initrd.img-6.14.0-15-generic 58s /etc/kernel/postrm.d/zz-zipl: 58s Using config file '/etc/zipl.conf' 58s Building bootmap in '/boot' 58s Adding IPL section 'ubuntu' (default) 58s Preparing boot device for LD-IPL: vda (0000). 58s Done. 58s Removing linux-modules-extra-6.14.0-15-generic (6.14.0-15.15) ... 58s Removing linux-modules-6.14.0-15-generic (6.14.0-15.15) ... 58s Removing linux-tools-6.14.0-15-generic (6.14.0-15.15) ... 58s Removing linux-tools-6.14.0-15 (6.14.0-15.15) ... 58s Removing wireless-regdb (2024.10.07-0ubuntu2) ... 58s Processing triggers for man-db (2.13.1-1) ... 58s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 82575 files and directories currently installed.) 58s Purging configuration files for linux-image-6.14.0-15-generic (6.14.0-15.15) ... 58s Purging configuration files for linux-modules-extra-6.14.0-15-generic (6.14.0-15.15) ... 58s Purging configuration files for linux-modules-6.14.0-15-generic (6.14.0-15.15) ... 59s autopkgtest [18:36:51]: rebooting testbed after setup commands that affected boot 73s autopkgtest [18:37:05]: testbed running kernel: Linux 6.15.0-4-generic #4-Ubuntu SMP Fri Jul 4 13:27:29 UTC 2025 75s autopkgtest [18:37:07]: @@@@@@@@@@@@@@@@@@@@ apt-source cockpit-podman 77s Get:1 http://ftpmaster.internal/ubuntu questing/universe cockpit-podman 108-1 (dsc) [2008 B] 77s Get:2 http://ftpmaster.internal/ubuntu questing/universe cockpit-podman 108-1 (tar) [1032 kB] 77s Get:3 http://ftpmaster.internal/ubuntu questing/universe cockpit-podman 108-1 (diff) [5824 B] 77s gpgv: Signature made Sat Jun 28 05:55:51 2025 UTC 77s gpgv: using RSA key 6C4B878B7E631F160557C3CDEE7BDDE4B86B5713 77s gpgv: Can't check signature: No public key 77s dpkg-source: warning: cannot verify inline signature for ./cockpit-podman_108-1.dsc: no acceptable signature found 77s autopkgtest [18:37:09]: testing package cockpit-podman version 108-1 78s autopkgtest [18:37:10]: build not needed 78s autopkgtest [18:37:10]: test smoke: preparing testbed 78s Reading package lists... 79s Building dependency tree... 79s Reading state information... 79s Solving dependencies... 79s The following NEW packages will be installed: 79s cockpit-bridge cockpit-podman cockpit-ws conmon crun dconf-gsettings-backend 79s dconf-service glib-networking glib-networking-common 79s glib-networking-services golang-github-containers-common 79s golang-github-containers-image gsettings-desktop-schemas libdconf1 79s libduktape207 libproxy1v5 libsubid5 libyajl2 netavark podman 79s 0 upgraded, 20 newly installed, 0 to remove and 0 not upgraded. 79s Need to get 33.3 MB of archives. 79s After this operation, 123 MB of additional disk space will be used. 79s Get:1 http://ftpmaster.internal/ubuntu questing/universe s390x cockpit-bridge all 339-1 [389 kB] 79s Get:2 http://ftpmaster.internal/ubuntu questing/universe s390x conmon s390x 2.1.12-4 [38.0 kB] 79s Get:3 http://ftpmaster.internal/ubuntu questing/main s390x libyajl2 s390x 2.1.0-5build1 [22.2 kB] 79s Get:4 http://ftpmaster.internal/ubuntu questing/universe s390x crun s390x 1.20-1syncable1 [461 kB] 79s Get:5 http://ftpmaster.internal/ubuntu questing/universe s390x netavark s390x 1.14.0-2 [5519 kB] 80s Get:6 http://ftpmaster.internal/ubuntu questing/universe s390x golang-github-containers-image all 5.34.2-1 [34.6 kB] 80s Get:7 http://ftpmaster.internal/ubuntu questing/universe s390x golang-github-containers-common all 0.62.2+ds1-2 [44.5 kB] 80s Get:8 http://ftpmaster.internal/ubuntu questing/main s390x libsubid5 s390x 1:4.17.4-2ubuntu1 [27.9 kB] 80s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/universe s390x podman s390x 5.4.2+ds1-2 [24.8 MB] 81s Get:10 http://ftpmaster.internal/ubuntu questing/universe s390x cockpit-podman all 108-1 [563 kB] 81s Get:11 http://ftpmaster.internal/ubuntu questing/main s390x libduktape207 s390x 2.7.0+tests-0ubuntu3 [150 kB] 81s Get:12 http://ftpmaster.internal/ubuntu questing/main s390x libproxy1v5 s390x 0.5.9-1 [27.8 kB] 81s Get:13 http://ftpmaster.internal/ubuntu questing/main s390x glib-networking-common all 2.80.1-1 [6680 B] 81s Get:14 http://ftpmaster.internal/ubuntu questing/main s390x glib-networking-services s390x 2.80.1-1 [12.8 kB] 81s Get:15 http://ftpmaster.internal/ubuntu questing/main s390x libdconf1 s390x 0.40.0-5 [40.0 kB] 81s Get:16 http://ftpmaster.internal/ubuntu questing/main s390x dconf-service s390x 0.40.0-5 [28.4 kB] 81s Get:17 http://ftpmaster.internal/ubuntu questing/main s390x dconf-gsettings-backend s390x 0.40.0-5 [22.8 kB] 81s Get:18 http://ftpmaster.internal/ubuntu questing/main s390x gsettings-desktop-schemas all 48.0-1ubuntu1 [37.6 kB] 81s Get:19 http://ftpmaster.internal/ubuntu questing/main s390x glib-networking s390x 2.80.1-1 [65.5 kB] 81s Get:20 http://ftpmaster.internal/ubuntu questing/universe s390x cockpit-ws s390x 339-1 [1038 kB] 81s Fetched 33.3 MB in 2s (15.6 MB/s) 81s Selecting previously unselected package cockpit-bridge. 81s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 82574 files and directories currently installed.) 81s Preparing to unpack .../00-cockpit-bridge_339-1_all.deb ... 81s Unpacking cockpit-bridge (339-1) ... 81s Selecting previously unselected package conmon. 81s Preparing to unpack .../01-conmon_2.1.12-4_s390x.deb ... 81s Unpacking conmon (2.1.12-4) ... 81s Selecting previously unselected package libyajl2:s390x. 81s Preparing to unpack .../02-libyajl2_2.1.0-5build1_s390x.deb ... 81s Unpacking libyajl2:s390x (2.1.0-5build1) ... 81s Selecting previously unselected package crun. 81s Preparing to unpack .../03-crun_1.20-1syncable1_s390x.deb ... 81s Unpacking crun (1.20-1syncable1) ... 81s Selecting previously unselected package netavark. 81s Preparing to unpack .../04-netavark_1.14.0-2_s390x.deb ... 81s Unpacking netavark (1.14.0-2) ... 81s Selecting previously unselected package golang-github-containers-image. 81s Preparing to unpack .../05-golang-github-containers-image_5.34.2-1_all.deb ... 81s Unpacking golang-github-containers-image (5.34.2-1) ... 81s Selecting previously unselected package golang-github-containers-common. 81s Preparing to unpack .../06-golang-github-containers-common_0.62.2+ds1-2_all.deb ... 81s Unpacking golang-github-containers-common (0.62.2+ds1-2) ... 81s Selecting previously unselected package libsubid5:s390x. 81s Preparing to unpack .../07-libsubid5_1%3a4.17.4-2ubuntu1_s390x.deb ... 81s Unpacking libsubid5:s390x (1:4.17.4-2ubuntu1) ... 81s Selecting previously unselected package podman. 81s Preparing to unpack .../08-podman_5.4.2+ds1-2_s390x.deb ... 81s Unpacking podman (5.4.2+ds1-2) ... 82s Selecting previously unselected package cockpit-podman. 82s Preparing to unpack .../09-cockpit-podman_108-1_all.deb ... 82s Unpacking cockpit-podman (108-1) ... 82s Selecting previously unselected package libduktape207:s390x. 82s Preparing to unpack .../10-libduktape207_2.7.0+tests-0ubuntu3_s390x.deb ... 82s Unpacking libduktape207:s390x (2.7.0+tests-0ubuntu3) ... 82s Selecting previously unselected package libproxy1v5:s390x. 82s Preparing to unpack .../11-libproxy1v5_0.5.9-1_s390x.deb ... 82s Unpacking libproxy1v5:s390x (0.5.9-1) ... 82s Selecting previously unselected package glib-networking-common. 82s Preparing to unpack .../12-glib-networking-common_2.80.1-1_all.deb ... 82s Unpacking glib-networking-common (2.80.1-1) ... 82s Selecting previously unselected package glib-networking-services. 82s Preparing to unpack .../13-glib-networking-services_2.80.1-1_s390x.deb ... 82s Unpacking glib-networking-services (2.80.1-1) ... 82s Selecting previously unselected package libdconf1:s390x. 82s Preparing to unpack .../14-libdconf1_0.40.0-5_s390x.deb ... 82s Unpacking libdconf1:s390x (0.40.0-5) ... 82s Selecting previously unselected package dconf-service. 82s Preparing to unpack .../15-dconf-service_0.40.0-5_s390x.deb ... 82s Unpacking dconf-service (0.40.0-5) ... 82s Selecting previously unselected package dconf-gsettings-backend:s390x. 82s Preparing to unpack .../16-dconf-gsettings-backend_0.40.0-5_s390x.deb ... 82s Unpacking dconf-gsettings-backend:s390x (0.40.0-5) ... 82s Selecting previously unselected package gsettings-desktop-schemas. 82s Preparing to unpack .../17-gsettings-desktop-schemas_48.0-1ubuntu1_all.deb ... 82s Unpacking gsettings-desktop-schemas (48.0-1ubuntu1) ... 82s Selecting previously unselected package glib-networking:s390x. 82s Preparing to unpack .../18-glib-networking_2.80.1-1_s390x.deb ... 82s Unpacking glib-networking:s390x (2.80.1-1) ... 82s Selecting previously unselected package cockpit-ws. 82s Preparing to unpack .../19-cockpit-ws_339-1_s390x.deb ... 82s Unpacking cockpit-ws (339-1) ... 82s Setting up libyajl2:s390x (2.1.0-5build1) ... 82s Setting up libsubid5:s390x (1:4.17.4-2ubuntu1) ... 82s Setting up libdconf1:s390x (0.40.0-5) ... 82s Setting up golang-github-containers-image (5.34.2-1) ... 82s Setting up conmon (2.1.12-4) ... 82s Setting up netavark (1.14.0-2) ... 82s Created symlink '/etc/systemd/system/default.target.wants/netavark-dhcp-proxy.service' → '/usr/lib/systemd/system/netavark-dhcp-proxy.service'. 82s Created symlink '/etc/systemd/system/sockets.target.wants/netavark-dhcp-proxy.socket' → '/usr/lib/systemd/system/netavark-dhcp-proxy.socket'. 82s Created symlink '/etc/systemd/system/firewalld.service.wants/netavark-firewalld-reload.service' → '/usr/lib/systemd/system/netavark-firewalld-reload.service'. 82s Unit /usr/lib/systemd/system/netavark-firewalld-reload.service is added as a dependency to a non-existent unit firewalld.service. 82s Setting up cockpit-bridge (339-1) ... 83s Setting up libduktape207:s390x (2.7.0+tests-0ubuntu3) ... 83s Setting up golang-github-containers-common (0.62.2+ds1-2) ... 83s Setting up glib-networking-common (2.80.1-1) ... 83s Setting up libproxy1v5:s390x (0.5.9-1) ... 83s Setting up crun (1.20-1syncable1) ... 83s Setting up podman (5.4.2+ds1-2) ... 83s Setting up dconf-service (0.40.0-5) ... 83s Setting up glib-networking-services (2.80.1-1) ... 83s Setting up cockpit-podman (108-1) ... 83s Setting up dconf-gsettings-backend:s390x (0.40.0-5) ... 83s Setting up gsettings-desktop-schemas (48.0-1ubuntu1) ... 83s Processing triggers for libc-bin (2.41-6ubuntu2) ... 83s Processing triggers for man-db (2.13.1-1) ... 84s Processing triggers for libglib2.0-0t64:s390x (2.84.3-1) ... 84s Setting up glib-networking:s390x (2.80.1-1) ... 84s Setting up cockpit-ws (339-1) ... 84s Created symlink '/etc/systemd/system/sockets.target.wants/cockpit.socket' → '/usr/lib/systemd/system/cockpit.socket'. 85s autopkgtest [18:37:17]: test smoke: [----------------------- 86s * bridge works and has expected packages 86s base1 /usr/share/cockpit/base1 86s podman Podman containers /usr/share/cockpit/podman 86s static /usr/share/cockpit/static 86s none 86s * socket unit is set up correctly, login page works 86s {"csrf-token":"9a91438c813a93e1ba7d0afc8325c54fc53641ff576bdef60b6724c8ae026997"} 86s * load podman page 86s output does not match ' 87s Jul 08 18:38:23 autopkgtest kernel: NetLabel: Initializing 87s Jul 08 18:38:23 autopkgtest kernel: NetLabel: domain hash size = 128 87s Jul 08 18:38:23 autopkgtest kernel: NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO 87s Jul 08 18:38:23 autopkgtest kernel: NetLabel: unlabeled traffic allowed by default 87s Jul 08 18:38:23 autopkgtest kernel: VFS: Disk quotas dquot_6.6.0 87s Jul 08 18:38:23 autopkgtest kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) 87s Jul 08 18:38:23 autopkgtest kernel: AppArmor: AppArmor Filesystem Enabled 87s Jul 08 18:38:23 autopkgtest kernel: NET: Registered PF_INET protocol family 87s Jul 08 18:38:23 autopkgtest kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) 87s Jul 08 18:38:23 autopkgtest kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) 87s Jul 08 18:38:23 autopkgtest kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) 87s Jul 08 18:38:23 autopkgtest kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) 87s Jul 08 18:38:23 autopkgtest kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) 87s Jul 08 18:38:23 autopkgtest kernel: TCP: Hash tables configured (established 32768 bind 32768) 87s Jul 08 18:38:23 autopkgtest kernel: MPTCP token hash table entries: 4096 (order: 4, 98304 bytes, linear) 87s Jul 08 18:38:23 autopkgtest kernel: UDP hash table entries: 2048 (order: 5, 131072 bytes, linear) 87s Jul 08 18:38:23 autopkgtest kernel: UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear) 87s Jul 08 18:38:23 autopkgtest kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family 87s Jul 08 18:38:23 autopkgtest kernel: NET: Registered PF_XDP protocol family 87s Jul 08 18:38:23 autopkgtest kernel: PCI: CLS 0 bytes, default 256 87s Jul 08 18:38:23 autopkgtest kernel: Trying to unpack rootfs image as initramfs... 87s Jul 08 18:38:23 autopkgtest kernel: Key type cert_store_key registered 87s Jul 08 18:38:23 autopkgtest kernel: kvm-s390: SIE is not available 87s Jul 08 18:38:23 autopkgtest kernel: hypfs: The hardware system does not support hypfs 87s Jul 08 18:38:23 autopkgtest kernel: Initialise system trusted keyrings 87s Jul 08 18:38:23 autopkgtest kernel: Key type blacklist registered 87s Jul 08 18:38:23 autopkgtest kernel: workingset: timestamp_bits=45 max_order=20 bucket_order=0 87s Jul 08 18:38:23 autopkgtest kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher 87s Jul 08 18:38:23 autopkgtest kernel: fuse: init (API version 7.43) 87s Jul 08 18:38:23 autopkgtest kernel: integrity: Platform Keyring initialized 87s Jul 08 18:38:23 autopkgtest kernel: Freeing initrd memory: 23088K 87s Jul 08 18:38:23 autopkgtest kernel: Key type asymmetric registered 87s Jul 08 18:38:23 autopkgtest kernel: Asymmetric key parser 'x509' registered 87s Jul 08 18:38:23 autopkgtest kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) 87s Jul 08 18:38:23 autopkgtest kernel: io scheduler mq-deadline registered 87s Jul 08 18:38:23 autopkgtest kernel: hvc_iucv: The z/VM IUCV HVC device driver cannot be used without z/VM 87s Jul 08 18:38:23 autopkgtest kernel: loop: module loaded 87s Jul 08 18:38:23 autopkgtest kernel: tun: Universal TUN/TAP device driver, 1.6 87s Jul 08 18:38:23 autopkgtest kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. 87s Jul 08 18:38:23 autopkgtest kernel: device-mapper: uevent: version 1.0.3 87s Jul 08 18:38:23 autopkgtest kernel: device-mapper: ioctl: 4.49.0-ioctl (2025-01-17) initialised: dm-devel@lists.linux.dev 87s Jul 08 18:38:23 autopkgtest kernel: cio: Channel measurement facility initialized using format extended (mode autodetected) 87s Jul 08 18:38:23 autopkgtest kernel: drop_monitor: Initializing network drop monitor service 87s Jul 08 18:38:23 autopkgtest kernel: NET: Registered PF_INET6 protocol family 87s Jul 08 18:38:23 autopkgtest kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues 87s Jul 08 18:38:23 autopkgtest kernel: virtio_blk virtio1: [vda] 41943040 512-byte logical blocks (21.5 GB/20.0 GiB) 87s Jul 08 18:38:23 autopkgtest kernel: vda: vda1 87s Jul 08 18:38:23 autopkgtest kernel: Segment Routing with IPv6 87s Jul 08 18:38:23 autopkgtest kernel: In-situ OAM (IOAM) with IPv6 87s Jul 08 18:38:23 autopkgtest kernel: NET: Registered PF_PACKET protocol family 87s Jul 08 18:38:23 autopkgtest kernel: virtio_scsi virtio0: 1/0/0 default/read/poll queues 87s Jul 08 18:38:23 autopkgtest kernel: scsi host0: Virtio SCSI HBA 87s Jul 08 18:38:23 autopkgtest kernel: Key type dns_resolver registered 87s Jul 08 18:38:23 autopkgtest kernel: scsi 0:0:0:0: CD-ROM QEMU QEMU CD-ROM 2.5+ PQ: 0 ANSI: 5 87s Jul 08 18:38:23 autopkgtest kernel: registered taskstats version 1 87s Jul 08 18:38:23 autopkgtest kernel: Loading compiled-in X.509 certificates 87s Jul 08 18:38:23 autopkgtest kernel: Loaded X.509 cert 'Build time autogenerated kernel key: 37d7dd2bfa35c48b749d6a2fd40b8d64eaa03321' 87s Jul 08 18:38:23 autopkgtest kernel: Loaded X.509 cert 'Canonical Ltd. Live Patch Signing 2025 Kmod: d541cef61dc7e793b7eb7e899970a2eef0b5dc8c' 87s Jul 08 18:38:23 autopkgtest kernel: Loaded X.509 cert 'Canonical Ltd. Live Patch Signing: 14df34d1a87cf37625abec039ef2bf521249b969' 87s Jul 08 18:38:23 autopkgtest kernel: Loaded X.509 cert 'Canonical Ltd. Kernel Module Signing: 88f752e560a1e0737e31163a466ad7b70a850c19' 87s Jul 08 18:38:23 autopkgtest kernel: blacklist: Loading compiled-in revocation X.509 certificates 87s Jul 08 18:38:23 autopkgtest kernel: Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing: 61482aa2830d0ab2ad5af10b7250da9033ddcef0' 87s Jul 08 18:38:23 autopkgtest kernel: Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2017): 242ade75ac4a15e50d50c84b0d45ff3eae707a03' 87s Jul 08 18:38:23 autopkgtest kernel: Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (ESM 2018): 365188c1d374d6b07c3c8f240f8ef722433d6a8b' 87s Jul 08 18:38:23 autopkgtest kernel: Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2019): c0746fd6c5da3ae827864651ad66ae47fe24b3e8' 87s Jul 08 18:38:23 autopkgtest kernel: Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v1): a8d54bbb3825cfb94fa13c9f8a594a195c107b8d' 87s Jul 08 18:38:23 autopkgtest kernel: Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v2): 4cf046892d6fd3c9a5b03f98d845f90851dc6a8c' 87s Jul 08 18:38:23 autopkgtest kernel: Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v3): 100437bb6de6e469b581e61cd66bce3ef4ed53af' 87s Jul 08 18:38:23 autopkgtest kernel: Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (Ubuntu Core 2019): c1d57b8f6b743f23ee41f4f7ee292f06eecadfb9' 87s Jul 08 18:38:23 autopkgtest kernel: sr 0:0:0:0: Power-on or device reset occurred 87s Jul 08 18:38:23 autopkgtest kernel: sr 0:0:0:0: [sr0] scsi3-mmc drive: 16x/50x cd/rw xa/form2 cdda tray 87s Jul 08 18:38:23 autopkgtest kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 87s Jul 08 18:38:23 autopkgtest kernel: sr 0:0:0:0: Attached scsi CD-ROM sr0 87s Jul 08 18:38:23 autopkgtest kernel: sr 0:0:0:0: Attached scsi generic sg0 type 5 87s Jul 08 18:38:23 autopkgtest kernel: Demotion targets for Node 0: null 87s Jul 08 18:38:23 autopkgtest kernel: Key type .fscrypt registered 87s Jul 08 18:38:23 autopkgtest kernel: Key type fscrypt-provisioning registered 87s Jul 08 18:38:23 autopkgtest kernel: Key type big_key registered 87s Jul 08 18:38:23 autopkgtest kernel: Key type encrypted registered 87s Jul 08 18:38:23 autopkgtest kernel: AppArmor: AppArmor sha256 policy hashing enabled 87s Jul 08 18:38:23 autopkgtest kernel: ima: No TPM chip found, activating TPM-bypass! 87s Jul 08 18:38:23 autopkgtest kernel: Loading compiled-in module X.509 certificates 87s Jul 08 18:38:23 autopkgtest kernel: Loaded X.509 cert 'Build time autogenerated kernel key: 37d7dd2bfa35c48b749d6a2fd40b8d64eaa03321' 87s Jul 08 18:38:23 autopkgtest kernel: ima: Allocated hash algorithm: sha256 87s Jul 08 18:38:23 autopkgtest kernel: ima: No architecture policies found 87s Jul 08 18:38:23 autopkgtest kernel: evm: Initialising EVM extended attributes: 87s Jul 08 18:38:23 autopkgtest kernel: evm: security.selinux 87s Jul 08 18:38:23 autopkgtest kernel: evm: security.SMACK64 87s Jul 08 18:38:23 autopkgtest kernel: evm: security.SMACK64EXEC 87s Jul 08 18:38:23 autopkgtest kernel: evm: security.SMACK64TRANSMUTE 87s Jul 08 18:38:23 autopkgtest kernel: evm: security.SMACK64MMAP 87s Jul 08 18:38:23 autopkgtest kernel: evm: security.apparmor 87s Jul 08 18:38:23 autopkgtest kernel: evm: security.ima 87s Jul 08 18:38:23 autopkgtest kernel: evm: security.capability 87s Jul 08 18:38:23 autopkgtest kernel: evm: HMAC attrs: 0x1 87s Jul 08 18:38:23 autopkgtest kernel: Freeing unused kernel image (initmem) memory: 1744K 87s Jul 08 18:38:23 autopkgtest kernel: Write protected read-only-after-init data: 164k 87s Jul 08 18:38:23 autopkgtest kernel: Checked W+X mappings: passed, no unexpected W+X pages found 87s Jul 08 18:38:23 autopkgtest kernel: Run /init as init process 87s Jul 08 18:38:23 autopkgtest kernel: with arguments: 87s Jul 08 18:38:23 autopkgtest kernel: /init 87s Jul 08 18:38:23 autopkgtest kernel: with environment: 87s Jul 08 18:38:23 autopkgtest kernel: HOME=/ 87s Jul 08 18:38:23 autopkgtest kernel: TERM=linux 87s Jul 08 18:38:23 autopkgtest kernel: virtio_net virtio2 enc1: renamed from eth0 87s Jul 08 18:38:23 autopkgtest kernel: raid6: vx128x8 gen() 22003 MB/s 87s Jul 08 18:38:23 autopkgtest kernel: raid6: using algorithm vx128x8 gen() 22003 MB/s 87s Jul 08 18:38:23 autopkgtest kernel: raid6: .... xor() 14913 MB/s, rmw enabled 87s Jul 08 18:38:23 autopkgtest kernel: raid6: using s390xc recovery algorithm 87s Jul 08 18:38:23 autopkgtest kernel: xor: automatically using best checksumming function xc 87s Jul 08 18:38:23 autopkgtest kernel: Btrfs loaded, zoned=yes, fsverity=yes 87s Jul 08 18:38:23 autopkgtest kernel: EXT4-fs (vda1): orphan cleanup on readonly fs 87s Jul 08 18:38:23 autopkgtest kernel: EXT4-fs (vda1): mounted filesystem dc6067dc-a9ad-4540-b04e-f51ad04c0e52 ro with ordered data mode. Quota mode: none. 87s Jul 08 18:38:23 autopkgtest systemd[1]: systemd 257.7-1ubuntu1 running in system mode (+PAM +AUDIT +SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK +BTF -XKBCOMMON -UTMP +SYSVINIT +LIBARCHIVE) 87s Jul 08 18:38:23 autopkgtest systemd[1]: Detected virtualization kvm. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Detected architecture s390x. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Hostname set to . 87s Jul 08 18:38:23 autopkgtest systemd[1]: bpf-restrict-fs: BPF LSM hook not enabled in the kernel, BPF LSM not supported. 87s Jul 08 18:38:23 autopkgtest kernel: NET: Registered PF_VSOCK protocol family 87s Jul 08 18:38:23 autopkgtest (sd-exec-[278]: /usr/lib/systemd/system-generators/s390-cpi-vars failed with exit status 1. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Queued start job for default target graphical.target. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Created slice user.slice - User and Session Slice. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Expecting device dev-ttysclp0.device - /dev/ttysclp0... 87s Jul 08 18:38:23 autopkgtest systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Reached target remote-fs.target - Remote File Systems. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Reached target slices.target - Slice Units. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Reached target swap.target - Swaps. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Listening on syslog.socket - Syslog Socket. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Listening on systemd-initctl.socket - initctl Compatibility Named Pipe. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). 87s Jul 08 18:38:23 autopkgtest systemd[1]: Listening on systemd-journald.socket - Journal Sockets. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... 87s Jul 08 18:38:23 autopkgtest systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... 87s Jul 08 18:38:23 autopkgtest systemd[1]: Mounting run-lock.mount - Legacy Locks Directory /run/lock... 87s Jul 08 18:38:23 autopkgtest systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... 87s Jul 08 18:38:23 autopkgtest systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... 87s Jul 08 18:38:23 autopkgtest systemd[1]: Starting systemd-journald.service - Journal Service... 87s Jul 08 18:38:23 autopkgtest systemd[1]: Starting keyboard-setup.service - Set the console keyboard layout... 87s Jul 08 18:38:23 autopkgtest systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... 87s Jul 08 18:38:23 autopkgtest systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... 87s Jul 08 18:38:23 autopkgtest systemd[1]: Starting modprobe@dm_multipath.service - Load Kernel Module dm_multipath... 87s Jul 08 18:38:23 autopkgtest systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... 87s Jul 08 18:38:23 autopkgtest systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... 87s Jul 08 18:38:23 autopkgtest systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... 87s Jul 08 18:38:23 autopkgtest systemd[1]: netplan-ovs-cleanup.service - OpenVSwitch configuration for cleanup was skipped because of an unmet condition check (ConditionFileIsExecutable=/usr/bin/ovs-vsctl). 87s Jul 08 18:38:23 autopkgtest systemd[1]: systemd-fsck-root.service - File System Check on Root Device was skipped because of an unmet condition check (ConditionPathExists=!/run/initramfs/fsck-root). 87s Jul 08 18:38:23 autopkgtest systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). 87s Jul 08 18:38:23 autopkgtest systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... 87s Jul 08 18:38:23 autopkgtest systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... 87s Jul 08 18:38:23 autopkgtest systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... 87s Jul 08 18:38:23 autopkgtest systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... 87s Jul 08 18:38:23 autopkgtest systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Mounted run-lock.mount - Legacy Locks Directory /run/lock. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... 87s Jul 08 18:38:23 autopkgtest systemd[1]: modprobe@configfs.service: Deactivated successfully. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... 87s Jul 08 18:38:23 autopkgtest systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. 87s Jul 08 18:38:23 autopkgtest systemd[1]: modprobe@dm_multipath.service: Deactivated successfully. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Finished modprobe@dm_multipath.service - Load Kernel Module dm_multipath. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. 87s Jul 08 18:38:23 autopkgtest kernel: i2c_dev: i2c /dev entries driver 87s Jul 08 18:38:23 autopkgtest systemd-journald[322]: Collecting audit messages is disabled. 87s Jul 08 18:38:23 autopkgtest systemd-journald[322]: Journal started 87s Jul 08 18:38:23 autopkgtest systemd-journald[322]: Runtime Journal (/run/log/journal/01d67bdab0c44e15aa206227b4cdc3c1) is 4.9M, max 39.9M, 34.9M free. 87s Jul 08 18:38:23 autopkgtest systemd-modules-load[340]: Inserted module 'i2c_dev' 87s Jul 08 18:38:23 autopkgtest systemd[1]: Started systemd-journald.service - Journal Service. 87s Jul 08 18:38:23 autopkgtest kernel: EXT4-fs (vda1): re-mounted dc6067dc-a9ad-4540-b04e-f51ad04c0e52 r/w. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... 87s Jul 08 18:38:23 autopkgtest systemd[1]: modprobe@fuse.service: Deactivated successfully. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... 87s Jul 08 18:38:23 autopkgtest systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. 87s Jul 08 18:38:23 autopkgtest systemd-sysctl[364]: Couldn't write '1' to 'vm/allocate_pgste', ignoring: No such file or directory 87s Jul 08 18:38:23 autopkgtest systemd[1]: Starting multipathd.service - Device-Mapper Multipath Device Controller... 87s Jul 08 18:38:23 autopkgtest systemd[1]: Starting cloud-init-main.service - Cloud-init: Single Process... 87s Jul 08 18:38:23 autopkgtest systemd[1]: systemd-hwdb-update.service - Rebuild Hardware Database was skipped because of an unmet condition check (ConditionNeedsUpdate=/etc). 87s Jul 08 18:38:23 autopkgtest systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... 87s Jul 08 18:38:23 autopkgtest systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... 87s Jul 08 18:38:23 autopkgtest systemd[1]: modprobe@drm.service: Deactivated successfully. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. 87s Jul 08 18:38:23 autopkgtest systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. 87s Jul 08 18:38:23 autopkgtest systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). 87s Jul 08 18:38:23 autopkgtest systemd[1]: systemd-sysusers.service - Create System Users was skipped because no trigger condition checks were met. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Starting systemd-resolved.service - Network Name Resolution... 87s Jul 08 18:38:23 autopkgtest systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... 87s Jul 08 18:38:23 autopkgtest multipathd[368]: multipathd v0.9.9: start up 87s Jul 08 18:38:23 autopkgtest systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... 87s Jul 08 18:38:23 autopkgtest multipathd[368]: reconfigure: setting up paths and maps 87s Jul 08 18:38:23 autopkgtest systemd[1]: Started multipathd.service - Device-Mapper Multipath Device Controller. 87s Jul 08 18:38:23 autopkgtest systemd-journald[322]: Time spent on flushing to /var/log/journal/01d67bdab0c44e15aa206227b4cdc3c1 is 30.668ms for 280 entries. 87s Jul 08 18:38:23 autopkgtest systemd-journald[322]: System Journal (/var/log/journal/01d67bdab0c44e15aa206227b4cdc3c1) is 16M, max 1.9G, 1.9G free. 87s Jul 08 18:38:23 autopkgtest systemd-journald[322]: Received client request to flush runtime journal. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... 87s Jul 08 18:38:23 autopkgtest systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Finished keyboard-setup.service - Set the console keyboard layout. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Reached target local-fs.target - Local File Systems. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Starting apparmor.service - Load AppArmor profiles... 87s Jul 08 18:38:23 autopkgtest systemd[1]: Starting console-setup.service - Set console font and keymap... 87s Jul 08 18:38:23 autopkgtest systemd-udevd[400]: Using default interface naming scheme 'v257'. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Starting plymouth-read-write.service - Tell Plymouth To Write Out Runtime Data... 87s Jul 08 18:38:23 autopkgtest systemd[1]: Starting systemd-binfmt.service - Set Up Additional Binary Formats... 87s Jul 08 18:38:23 autopkgtest apparmor.systemd[403]: Restarting AppArmor 87s Jul 08 18:38:23 autopkgtest systemd[1]: Starting ufw.service - Uncomplicated firewall... 87s Jul 08 18:38:23 autopkgtest systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Finished console-setup.service - Set console font and keymap. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Reached target time-set.target - System Time Set. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... 87s Jul 08 18:38:23 autopkgtest systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 408 (systemd-binfmt) 87s Jul 08 18:38:23 autopkgtest apparmor.systemd[403]: Reloading AppArmor profiles 87s Jul 08 18:38:23 autopkgtest systemd[1]: Finished ufw.service - Uncomplicated firewall. 87s Jul 08 18:38:23 autopkgtest systemd-tmpfiles[419]: /usr/lib/tmpfiles.d/legacy.conf:14: Duplicate line for path "/run/lock", ignoring. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Finished plymouth-read-write.service - Tell Plymouth To Write Out Runtime Data. 87s Jul 08 18:38:23 autopkgtest systemd-timesyncd[384]: Network configuration changed, trying to establish connection. 87s Jul 08 18:38:23 autopkgtest systemd-timesyncd[384]: Network configuration changed, trying to establish connection. 87s Jul 08 18:38:23 autopkgtest systemd-resolved[381]: Positive Trust Anchors: 87s Jul 08 18:38:23 autopkgtest systemd-resolved[381]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d 87s Jul 08 18:38:23 autopkgtest systemd-resolved[381]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 87s Jul 08 18:38:23 autopkgtest systemd-resolved[381]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test 87s Jul 08 18:38:23 autopkgtest systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. 87s Jul 08 18:38:23 autopkgtest systemd[1]: ldconfig.service - Rebuild Dynamic Linker Cache was skipped because no trigger condition checks were met. 87s Jul 08 18:38:23 autopkgtest systemd[1]: systemd-firstboot.service - First Boot Wizard was skipped because of an unmet condition check (ConditionFirstBoot=yes). 87s Jul 08 18:38:23 autopkgtest systemd[1]: first-boot-complete.target - First Boot Complete was skipped because of an unmet condition check (ConditionFirstBoot=yes). 87s Jul 08 18:38:23 autopkgtest systemd[1]: systemd-journal-catalog-update.service - Rebuild Journal Catalog was skipped because of an unmet condition check (ConditionNeedsUpdate=/var). 87s Jul 08 18:38:23 autopkgtest systemd[1]: systemd-machine-id-commit.service - Save Transient machine-id to Disk was skipped because of an unmet condition check (ConditionPathIsMountPoint=/etc/machine-id). 87s Jul 08 18:38:23 autopkgtest systemd[1]: systemd-update-done.service - Update is Completed was skipped because no trigger condition checks were met. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. 87s Jul 08 18:38:23 autopkgtest systemd[1]: plymouth-start.service - Show Plymouth Boot Screen was skipped because of an unmet condition check (ConditionKernelCommandLine=splash). 87s Jul 08 18:38:23 autopkgtest systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. 87s Jul 08 18:38:23 autopkgtest systemd[1]: systemd-ask-password-plymouth.path - Forward Password Requests to Plymouth Directory Watch was skipped because of an unmet condition check (ConditionPathExists=/run/plymouth/pid). 87s Jul 08 18:38:23 autopkgtest systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. 87s Jul 08 18:38:23 autopkgtest kernel: audit: type=1400 audit(1751999903.371:2): apparmor="STATUS" operation="profile_load" profile="unconfined" name="Discord" pid=428 comm="apparmor_parser" 87s Jul 08 18:38:23 autopkgtest kernel: audit: type=1400 audit(1751999903.371:3): apparmor="STATUS" operation="profile_load" profile="unconfined" name="1password" pid=427 comm="apparmor_parser" 87s Jul 08 18:38:23 autopkgtest kernel: audit: type=1400 audit(1751999903.371:4): apparmor="STATUS" operation="profile_load" profile="unconfined" name=4D6F6E676F444220436F6D70617373 pid=430 comm="apparmor_parser" 87s Jul 08 18:38:23 autopkgtest kernel: audit: type=1400 audit(1751999903.371:5): apparmor="STATUS" operation="profile_load" profile="unconfined" name="QtWebEngineProcess" pid=433 comm="apparmor_parser" 87s Jul 08 18:38:23 autopkgtest systemd-resolved[381]: Using system hostname 'autopkgtest'. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Started systemd-resolved.service - Network Name Resolution. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. 87s Jul 08 18:38:23 autopkgtest 55-scsi-sg3_id.rules[454]: WARNING: SCSI device loop6 has no device ID, consider changing .SCSI_ID_SERIAL_SRC in 00-scsi-sg3_config.rules 87s Jul 08 18:38:23 autopkgtest 55-scsi-sg3_id.rules[457]: WARNING: SCSI device loop0 has no device ID, consider changing .SCSI_ID_SERIAL_SRC in 00-scsi-sg3_config.rules 87s Jul 08 18:38:23 autopkgtest 55-scsi-sg3_id.rules[458]: WARNING: SCSI device loop7 has no device ID, consider changing .SCSI_ID_SERIAL_SRC in 00-scsi-sg3_config.rules 87s Jul 08 18:38:23 autopkgtest 55-scsi-sg3_id.rules[459]: WARNING: SCSI device loop2 has no device ID, consider changing .SCSI_ID_SERIAL_SRC in 00-scsi-sg3_config.rules 87s Jul 08 18:38:23 autopkgtest 55-scsi-sg3_id.rules[455]: WARNING: SCSI device loop3 has no device ID, consider changing .SCSI_ID_SERIAL_SRC in 00-scsi-sg3_config.rules 87s Jul 08 18:38:23 autopkgtest 55-scsi-sg3_id.rules[456]: WARNING: SCSI device loop1 has no device ID, consider changing .SCSI_ID_SERIAL_SRC in 00-scsi-sg3_config.rules 87s Jul 08 18:38:23 autopkgtest 55-scsi-sg3_id.rules[466]: WARNING: SCSI device loop4 has no device ID, consider changing .SCSI_ID_SERIAL_SRC in 00-scsi-sg3_config.rules 87s Jul 08 18:38:23 autopkgtest kernel: VFIO - User Level meta-driver version: 0.3 87s Jul 08 18:38:23 autopkgtest kernel: audit: type=1400 audit(1751999903.451:6): apparmor="STATUS" operation="profile_load" profile="unconfined" name="alsamixer" pid=441 comm="apparmor_parser" 87s Jul 08 18:38:23 autopkgtest 55-scsi-sg3_id.rules[471]: WARNING: SCSI device loop5 has no device ID, consider changing .SCSI_ID_SERIAL_SRC in 00-scsi-sg3_config.rules 87s Jul 08 18:38:23 autopkgtest systemd[1]: Found device dev-ttysclp0.device - /dev/ttysclp0. 87s Jul 08 18:38:23 autopkgtest (udev-worker)[447]: enc1: Could not set WakeOnLan to off, ignoring: Operation not supported 87s Jul 08 18:38:23 autopkgtest 55-scsi-sg3_id.rules[489]: WARNING: SCSI device vda has no device ID, consider changing .SCSI_ID_SERIAL_SRC in 00-scsi-sg3_config.rules 87s Jul 08 18:38:23 autopkgtest 55-scsi-sg3_id.rules[492]: WARNING: SCSI device sr0 has no device ID, consider changing .SCSI_ID_SERIAL_SRC in 00-scsi-sg3_config.rules 87s Jul 08 18:38:23 autopkgtest kernel: audit: type=1400 audit(1751999903.511:7): apparmor="STATUS" operation="profile_load" profile="unconfined" name="babeld" pid=479 comm="apparmor_parser" 87s Jul 08 18:38:23 autopkgtest kernel: audit: type=1400 audit(1751999903.521:8): apparmor="STATUS" operation="profile_load" profile="unconfined" name="balena-etcher" pid=499 comm="apparmor_parser" 87s Jul 08 18:38:23 autopkgtest kernel: audit: type=1400 audit(1751999903.521:9): apparmor="STATUS" operation="profile_load" profile="unconfined" name="Xorg" pid=434 comm="apparmor_parser" 87s Jul 08 18:38:23 autopkgtest kernel: audit: type=1400 audit(1751999903.541:10): apparmor="STATUS" operation="profile_load" profile="unconfined" name="bgpd" pid=501 comm="apparmor_parser" 87s Jul 08 18:38:23 autopkgtest systemd[1]: Started cloud-init-main.service - Cloud-init: Single Process. 87s Jul 08 18:38:23 autopkgtest systemd[1]: Starting cloud-init-local.service - Cloud-init: Local Stage (pre-network)... 87s Jul 08 18:38:23 autopkgtest cloud-init[571]: Cloud-init v. 25.2~5g009c4cfd-0ubuntu1 running 'init-local' at Tue, 08 Jul 2025 18:38:23 +0000. Up 3.19 seconds. 87s Jul 08 18:38:23 autopkgtest kernel: ISO 9660 Extensions: Microsoft Joliet Level 3 87s Jul 08 18:38:23 autopkgtest kernel: ISO 9660 Extensions: RRIP_1991A 87s Jul 08 18:38:24 autopkgtest sh[560]: Completed socket interaction for boot stage local 87s Jul 08 18:38:24 autopkgtest systemd[1]: Finished cloud-init-local.service - Cloud-init: Local Stage (pre-network). 87s Jul 08 18:38:24 autopkgtest systemd[1]: Reached target network-pre.target - Preparation for Network. 87s Jul 08 18:38:24 autopkgtest systemd[1]: Starting cloud-init-network.service - Cloud-init: Network Stage... 87s Jul 08 18:38:24 autopkgtest systemd[1]: Starting systemd-networkd.service - Network Configuration... 87s Jul 08 18:38:24 autopkgtest systemd[1]: Mounting proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System... 87s Jul 08 18:38:24 autopkgtest systemd[1]: Mounted proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System. 87s Jul 08 18:38:24 autopkgtest systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 618 ((networkd)) 87s Jul 08 18:38:24 autopkgtest systemd[1]: proc-sys-fs-binfmt_misc.automount: Automount point already active? 87s Jul 08 18:38:24 autopkgtest systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 618 ((networkd)) 87s Jul 08 18:38:24 autopkgtest systemd[1]: proc-sys-fs-binfmt_misc.automount: Automount point already active? 87s Jul 08 18:38:24 autopkgtest cloud-init[571]: Cloud-init v. 25.2~5g009c4cfd-0ubuntu1 running 'init' at Tue, 08 Jul 2025 18:38:24 +0000. Up 3.45 seconds. 87s Jul 08 18:38:24 autopkgtest systemd[1]: Finished systemd-binfmt.service - Set Up Additional Binary Formats. 87s Jul 08 18:38:24 autopkgtest cloud-init[571]: ci-info: +++++++++++++++++++++++++++Net device info++++++++++++++++++++++++++++ 87s Jul 08 18:38:24 autopkgtest cloud-init[571]: ci-info: +--------+-------+-----------+-----------+-------+-------------------+ 87s Jul 08 18:38:24 autopkgtest cloud-init[571]: ci-info: | Device | Up | Address | Mask | Scope | Hw-Address | 87s Jul 08 18:38:24 autopkgtest cloud-init[571]: ci-info: +--------+-------+-----------+-----------+-------+-------------------+ 87s Jul 08 18:38:24 autopkgtest cloud-init[571]: ci-info: | enc1 | False | . | . | . | fa:16:3e:2c:79:0f | 87s Jul 08 18:38:24 autopkgtest cloud-init[571]: ci-info: | lo | True | 127.0.0.1 | 255.0.0.0 | host | . | 87s Jul 08 18:38:24 autopkgtest cloud-init[571]: ci-info: | lo | True | ::1/128 | . | host | . | 87s Jul 08 18:38:24 autopkgtest cloud-init[571]: ci-info: +--------+-------+-----------+-----------+-------+-------------------+ 87s Jul 08 18:38:24 autopkgtest cloud-init[571]: ci-info: +++++++++++++++++++Route IPv6 info+++++++++++++++++++ 87s Jul 08 18:38:24 autopkgtest cloud-init[571]: ci-info: +-------+-------------+---------+-----------+-------+ 87s Jul 08 18:38:24 autopkgtest cloud-init[571]: ci-info: | Route | Destination | Gateway | Interface | Flags | 87s Jul 08 18:38:24 autopkgtest cloud-init[571]: ci-info: +-------+-------------+---------+-----------+-------+ 87s Jul 08 18:38:24 autopkgtest cloud-init[571]: ci-info: +-------+-------------+---------+-----------+-------+ 87s Jul 08 18:38:24 autopkgtest systemd-networkd[618]: /run/systemd/network/10-netplan-enc1.network: MTUBytes= in [Link] section and UseMTU= in [DHCP] section are set. Disabling UseMTU=. 87s Jul 08 18:38:24 autopkgtest systemd-networkd[618]: lo: Link UP 87s Jul 08 18:38:24 autopkgtest systemd-networkd[618]: lo: Gained carrier 87s Jul 08 18:38:24 autopkgtest systemd[1]: Started systemd-networkd.service - Network Configuration. 87s Jul 08 18:38:24 autopkgtest systemd[1]: Reached target network.target - Network. 87s Jul 08 18:38:24 autopkgtest systemd-networkd[618]: enc1: Configuring with /run/systemd/network/10-netplan-enc1.network. 87s Jul 08 18:38:24 autopkgtest systemd-networkd[618]: enc1: Link UP 87s Jul 08 18:38:24 autopkgtest systemd-networkd[618]: enc1: Gained carrier 87s Jul 08 18:38:24 autopkgtest systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... 87s Jul 08 18:38:24 autopkgtest systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... 87s Jul 08 18:38:24 autopkgtest systemd-networkd[618]: enc1: DHCPv4 address 10.145.232.215/24, gateway 10.145.232.1 acquired from 10.145.232.1 87s Jul 08 18:38:24 autopkgtest systemd-timesyncd[384]: Network configuration changed, trying to establish connection. 87s Jul 08 18:38:24 autopkgtest systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. 87s Jul 08 18:38:24 autopkgtest cloud-init[571]: 2025-07-08 18:38:24,356 - loggers.py[DEPRECATED]: Deprecated cloud-config provided: apt_update: Deprecated in version 22.2. Use **package_update** instead., apt_upgrade: Deprecated in version 22.2. Use **package_upgrade** instead. 87s Jul 08 18:38:24 autopkgtest cloud-init[571]: 2025-07-08 18:38:24,356 - schema.py[WARNING]: cloud-config failed schema validation! You may run 'sudo cloud-init schema --system' to check the details. 87s Jul 08 18:38:24 autopkgtest sh[617]: Completed socket interaction for boot stage network 87s Jul 08 18:38:24 autopkgtest systemd[1]: Finished cloud-init-network.service - Cloud-init: Network Stage. 87s Jul 08 18:38:24 autopkgtest systemd[1]: Reached target cloud-config.target - Cloud-config availability. 87s Jul 08 18:38:24 autopkgtest systemd[1]: Listening on cloud-init-hotplugd.socket - cloud-init hotplug hook socket. 87s Jul 08 18:38:24 autopkgtest systemd[1]: Finished apparmor.service - Load AppArmor profiles. 87s Jul 08 18:38:24 autopkgtest systemd[1]: Reached target sysinit.target - System Initialization. 87s Jul 08 18:38:24 autopkgtest systemd[1]: apport-autoreport.path - Process error reports when automatic reporting is enabled (file watch) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/apport/autoreport). 87s Jul 08 18:38:24 autopkgtest systemd[1]: apport-autoreport.timer - Process error reports when automatic reporting is enabled (timer based) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/apport/autoreport). 87s Jul 08 18:38:24 autopkgtest systemd[1]: Started apt-daily.timer - Daily apt download activities. 87s Jul 08 18:38:24 autopkgtest systemd[1]: Started apt-daily-upgrade.timer - Daily apt upgrade and clean activities. 87s Jul 08 18:38:24 autopkgtest systemd[1]: Started dpkg-db-backup.timer - Daily dpkg database backup timer. 87s Jul 08 18:38:24 autopkgtest systemd[1]: Started e2scrub_all.timer - Periodic ext4 Online Metadata Check for All Filesystems. 87s Jul 08 18:38:24 autopkgtest systemd[1]: Started fstrim.timer - Discard unused filesystem blocks once a week. 87s Jul 08 18:38:24 autopkgtest systemd[1]: Started fwupd-refresh.timer - Refresh fwupd metadata regularly. 87s Jul 08 18:38:24 autopkgtest systemd[1]: Started logrotate.timer - Daily rotation of log files. 87s Jul 08 18:38:24 autopkgtest systemd[1]: Started man-db.timer - Daily man-db regeneration. 87s Jul 08 18:38:24 autopkgtest systemd[1]: Started motd-news.timer - Message of the Day. 87s Jul 08 18:38:24 autopkgtest systemd[1]: Started sysstat-collect.timer - Run system activity accounting tool every 10 minutes. 87s Jul 08 18:38:24 autopkgtest systemd[1]: Started sysstat-rotate.timer - Rotate daily system activity data file at midnight. 87s Jul 08 18:38:24 autopkgtest systemd[1]: Started sysstat-summary.timer - Generate summary of yesterday's process accounting. 87s Jul 08 18:38:24 autopkgtest systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. 87s Jul 08 18:38:24 autopkgtest systemd[1]: ua-timer.timer - Ubuntu Pro Timer for running repeated jobs was skipped because of an unmet condition check (ConditionPathExists=/var/lib/ubuntu-advantage/private/machine-token.json). 87s Jul 08 18:38:24 autopkgtest systemd[1]: Reached target paths.target - Path Units. 87s Jul 08 18:38:24 autopkgtest systemd[1]: Reached target timers.target - Timer Units. 87s Jul 08 18:38:24 autopkgtest systemd[1]: apport-forward.socket - Unix socket for apport crash forwarding was skipped because of an unmet condition check (ConditionVirtualization=container). 87s Jul 08 18:38:24 autopkgtest systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. 87s Jul 08 18:38:24 autopkgtest systemd[1]: Starting lxd-installer.socket - Helper to install lxd snap on demand... 87s Jul 08 18:38:24 autopkgtest systemd[1]: Listening on ssh.socket - OpenBSD Secure Shell server socket. 87s Jul 08 18:38:24 autopkgtest systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). 87s Jul 08 18:38:24 autopkgtest systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). 87s Jul 08 18:38:24 autopkgtest systemd[1]: Reached target ssh-access.target - SSH Access Available. 87s Jul 08 18:38:24 autopkgtest systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. 87s Jul 08 18:38:24 autopkgtest systemd[1]: Listening on uuidd.socket - UUID daemon activation socket. 87s Jul 08 18:38:24 autopkgtest systemd[1]: Starting cpi.service - Apply Control Program Identification (CPI)... 87s Jul 08 18:38:24 autopkgtest systemd[1]: Listening on lxd-installer.socket - Helper to install lxd snap on demand. 87s Jul 08 18:38:24 autopkgtest systemd[1]: Reached target sockets.target - Socket Units. 87s Jul 08 18:38:24 autopkgtest systemd[1]: Reached target basic.target - Basic System. 87s Jul 08 18:38:24 autopkgtest systemd[1]: System is tainted: unmerged-bin 87s Jul 08 18:38:24 autopkgtest systemd[1]: Starting apport.service - automatic crash report generation... 87s Jul 08 18:38:24 autopkgtest systemd[1]: Starting cpacfstatsd.service - CPACF statistics collection daemon process for Linux on System z... 87s Jul 08 18:38:24 autopkgtest systemd[1]: Started cron.service - Regular background program processing daemon. 87s Jul 08 18:38:24 autopkgtest systemd[1]: Starting dbus.service - D-Bus System Message Bus... 87s Jul 08 18:38:24 autopkgtest systemd[1]: Started dmesg.service - Save initial kernel messages after boot. 87s Jul 08 18:38:24 autopkgtest cpacfstatsd[716]: cpacfstatsd: CPU-MF counters not available. 87s Jul 08 18:38:24 autopkgtest cpacfstatsd[716]: cpacfstatsd: No crypto counters supported! 87s Jul 08 18:38:24 autopkgtest cpacfstatsd[716]: cpacfstatsd: Running 87s Jul 08 18:38:24 autopkgtest (cron)[712]: cron.service: Referenced but unset environment variable evaluates to an empty string: EXTRA_OPTS 87s Jul 08 18:38:24 autopkgtest systemd[1]: Starting dumpconf.service - Configure dump on panic for System z... 87s Jul 08 18:38:24 autopkgtest systemd[1]: Starting e2scrub_reap.service - Remove Stale Online ext4 Metadata Check Snapshots... 87s Jul 08 18:38:24 autopkgtest systemd[1]: getty-static.service - getty on tty2-tty6 if dbus and logind are not available was skipped because of an unmet condition check (ConditionPathExists=!/usr/bin/dbus-daemon). 87s Jul 08 18:38:24 autopkgtest cron[712]: (CRON) INFO (pidfile fd = 3) 87s Jul 08 18:38:24 autopkgtest cron[712]: (CRON) INFO (Running @reboot jobs) 87s Jul 08 18:38:24 autopkgtest systemd[1]: networkd-dispatcher.service - Dispatcher daemon for systemd-networkd was skipped because no trigger condition checks were met. 87s Jul 08 18:38:24 autopkgtest systemd[1]: Starting opticsmon.service - Monitor health of directly attached PCI NIC optical modules... 87s Jul 08 18:38:24 autopkgtest systemd[1]: Starting rng-tools-debian.service - Hardware RNG entropy gatherer daemon (Debian variant)... 87s Jul 08 18:38:24 autopkgtest systemd[1]: Starting rsyslog.service - System Logging Service... 87s Jul 08 18:38:24 autopkgtest systemd[1]: Starting sysstat.service - Resets System Activity Logs... 87s Jul 08 18:38:24 autopkgtest systemd[1]: Starting systemd-logind.service - User Login Management... 87s Jul 08 18:38:24 autopkgtest systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... 87s Jul 08 18:38:24 autopkgtest systemd[1]: ua-reboot-cmds.service - Ubuntu Pro reboot cmds was skipped because of an unmet condition check (ConditionPathExists=/var/lib/ubuntu-advantage/private/machine-token.json). 87s Jul 08 18:38:24 autopkgtest systemd[1]: Starting udisks2.service - Disk Manager... 87s Jul 08 18:38:24 autopkgtest systemd[1]: Started opticsmon.service - Monitor health of directly attached PCI NIC optical modules. 87s Jul 08 18:38:24 autopkgtest systemd[1]: Started cpacfstatsd.service - CPACF statistics collection daemon process for Linux on System z. 87s Jul 08 18:38:25 autopkgtest systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. 87s Jul 08 18:38:25 autopkgtest systemd[1]: Starting plymouth-quit-wait.service - Hold until boot process finishes up... 87s Jul 08 18:38:25 autopkgtest systemd[1]: Starting plymouth-quit.service - Terminate Plymouth Boot Screen... 87s Jul 08 18:38:25 autopkgtest systemd[1]: Finished cpi.service - Apply Control Program Identification (CPI). 87s Jul 08 18:38:25 autopkgtest dumpconf[715]: stop on panic configured. 87s Jul 08 18:38:25 autopkgtest dbus-daemon[713]: [system] AppArmor D-Bus mediation is enabled 87s Jul 08 18:38:25 autopkgtest systemd[1]: Finished dumpconf.service - Configure dump on panic for System z. 87s Jul 08 18:38:25 autopkgtest systemd[1]: Finished plymouth-quit-wait.service - Hold until boot process finishes up. 87s Jul 08 18:38:25 autopkgtest systemd[1]: Started serial-getty@ttysclp0.service - Serial Getty on ttysclp0. 87s Jul 08 18:38:25 autopkgtest udisksd[732]: udisks daemon version 2.10.1 starting 87s Jul 08 18:38:25 autopkgtest systemd[1]: Starting setvtrgb.service - Set console scheme... 87s Jul 08 18:38:25 autopkgtest systemd[1]: Started dbus.service - D-Bus System Message Bus. 87s Jul 08 18:38:25 autopkgtest rng-tools-debian[757]: not starting: /dev/hwrng is used by the kernel automatically 87s Jul 08 18:38:25 autopkgtest systemd[1]: Finished sysstat.service - Resets System Activity Logs. 87s Jul 08 18:38:25 autopkgtest systemd[1]: Finished plymouth-quit.service - Terminate Plymouth Boot Screen. 87s Jul 08 18:38:25 autopkgtest systemd[1]: rng-tools-debian.service: Skipped due to 'exec-condition'. 87s Jul 08 18:38:25 autopkgtest systemd[1]: Condition check resulted in rng-tools-debian.service - Hardware RNG entropy gatherer daemon (Debian variant) being skipped. 87s Jul 08 18:38:25 autopkgtest systemd[1]: Finished setvtrgb.service - Set console scheme. 87s Jul 08 18:38:25 autopkgtest systemd[1]: Created slice system-getty.slice - Slice /system/getty. 87s Jul 08 18:38:25 autopkgtest systemd[1]: Started getty@tty1.service - Getty on tty1. 87s Jul 08 18:38:25 autopkgtest systemd[1]: Reached target getty.target - Login Prompts. 87s Jul 08 18:38:25 autopkgtest systemd-logind[730]: New seat seat0. 87s Jul 08 18:38:25 autopkgtest systemd[1]: Started systemd-logind.service - User Login Management. 87s Jul 08 18:38:25 autopkgtest systemd[1]: Started udisks2.service - Disk Manager. 87s Jul 08 18:38:25 autopkgtest udisksd[732]: Acquired the name org.freedesktop.UDisks2 on the system message bus 87s Jul 08 18:38:25 autopkgtest systemd[1]: Finished apport.service - automatic crash report generation. 87s Jul 08 18:38:25 autopkgtest systemd[1]: e2scrub_reap.service: Deactivated successfully. 87s Jul 08 18:38:25 autopkgtest systemd[1]: Finished e2scrub_reap.service - Remove Stale Online ext4 Metadata Check Snapshots. 87s Jul 08 18:38:25 autopkgtest rsyslogd[781]: imuxsock: Acquired UNIX socket '/run/systemd/journal/syslog' (fd 3) from systemd. [v8.2412.0] 87s Jul 08 18:38:25 autopkgtest systemd[1]: Started rsyslog.service - System Logging Service. 87s Jul 08 18:38:25 autopkgtest rsyslogd[781]: rsyslogd's groupid changed to 102 87s Jul 08 18:38:25 autopkgtest rsyslogd[781]: rsyslogd's userid changed to 102 87s Jul 08 18:38:25 autopkgtest rsyslogd[781]: [origin software="rsyslogd" swVersion="8.2412.0" x-pid="781" x-info="https://www.rsyslog.com"] start 87s Jul 08 18:38:25 autopkgtest systemd-networkd[618]: enc1: Gained IPv6LL 87s Jul 08 18:38:25 autopkgtest systemd-timesyncd[384]: Network configuration changed, trying to establish connection. 87s Jul 08 18:38:25 autopkgtest systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. 87s Jul 08 18:38:25 autopkgtest systemd[1]: Reached target network-online.target - Network is Online. 87s Jul 08 18:38:25 autopkgtest systemd[1]: Starting cloud-config.service - Cloud-init: Config Stage... 87s Jul 08 18:38:25 autopkgtest systemd[1]: pollinate.service - Pollinate to seed the pseudo random number generator was skipped because of an unmet condition check (ConditionPathExists=!/var/cache/pollinate/seeded). 87s Jul 08 18:38:25 autopkgtest systemd[1]: Starting ssh.service - OpenBSD Secure Shell server... 87s Jul 08 18:38:25 autopkgtest systemd[1]: ubuntu-advantage.service - Ubuntu Pro Background Auto Attach was skipped because no trigger condition checks were met. 87s Jul 08 18:38:25 autopkgtest systemd[1]: Reached target multi-user.target - Multi-User System. 87s Jul 08 18:38:25 autopkgtest systemd[1]: Reached target graphical.target - Graphical Interface. 87s Jul 08 18:38:25 autopkgtest sshd[799]: Server listening on 0.0.0.0 port 22. 87s Jul 08 18:38:25 autopkgtest sshd[799]: Server listening on :: port 22. 87s Jul 08 18:38:25 autopkgtest systemd[1]: Started ssh.service - OpenBSD Secure Shell server. 87s Jul 08 18:38:25 autopkgtest cloud-init[571]: Cloud-init v. 25.2~5g009c4cfd-0ubuntu1 running 'modules:config' at Tue, 08 Jul 2025 18:38:25 +0000. Up 5.03 seconds. 87s Jul 08 18:38:25 autopkgtest sh[797]: Completed socket interaction for boot stage config 87s Jul 08 18:38:25 autopkgtest systemd[1]: Finished cloud-config.service - Cloud-init: Config Stage. 87s Jul 08 18:38:25 autopkgtest systemd[1]: Starting cloud-final.service - Cloud-init: Final Stage... 87s Jul 08 18:38:25 autopkgtest cloud-init[571]: Cloud-init v. 25.2~5g009c4cfd-0ubuntu1 running 'modules:final' at Tue, 08 Jul 2025 18:38:25 +0000. Up 5.17 seconds. 87s Jul 08 18:38:25 autopkgtest cloud-init[571]: Cloud-init v. 25.2~5g009c4cfd-0ubuntu1 finished at Tue, 08 Jul 2025 18:38:25 +0000. Datasource DataSourceConfigDrive [net,ver=2][source=/dev/sr0]. Up 5.24 seconds 87s Jul 08 18:38:25 autopkgtest sh[808]: Completed socket interaction for boot stage final 87s Jul 08 18:38:25 autopkgtest systemd[1]: Finished cloud-final.service - Cloud-init: Final Stage. 87s Jul 08 18:38:25 autopkgtest systemd[1]: Reached target cloud-init.target - Cloud-init target. 87s Jul 08 18:38:25 autopkgtest systemd[1]: Startup finished in 2.180s (kernel) + 3.070s (userspace) = 5.251s. 87s Jul 08 18:38:26 autopkgtest systemd[1]: cloud-init-main.service: Deactivated successfully. 87s Jul 08 18:38:26 autopkgtest systemd[1]: cloud-init-main.service: Unit process 568 (sh) remains running after unit stopped. 87s Jul 08 18:38:26 autopkgtest systemd[1]: cloud-init-main.service: Unit process 571 (tee) remains running after unit stopped. 87s Jul 08 18:38:26 autopkgtest systemd[1]: dmesg.service: Deactivated successfully. 87s Jul 08 18:38:26 autopkgtest sshd-session[802]: Accepted publickey for ubuntu from 10.136.6.173 port 37704 ssh2: RSA SHA256:KtkDhGoO16HDPSyUkvl/zYfdKz7IGxyMacwyeIs6ZGk 87s Jul 08 18:38:26 autopkgtest sshd-session[802]: pam_unix(sshd:session): session opened for user ubuntu(uid=1000) by ubuntu(uid=0) 87s Jul 08 18:38:26 autopkgtest systemd-logind[730]: New session 1 of user ubuntu. 87s Jul 08 18:38:26 autopkgtest systemd[1]: Created slice user-1000.slice - User Slice of UID 1000. 87s Jul 08 18:38:26 autopkgtest systemd[1]: Starting user-runtime-dir@1000.service - User Runtime Directory /run/user/1000... 87s Jul 08 18:38:26 autopkgtest systemd[1]: Finished user-runtime-dir@1000.service - User Runtime Directory /run/user/1000. 87s Jul 08 18:38:26 autopkgtest systemd[1]: Starting user@1000.service - User Manager for UID 1000... 87s Jul 08 18:38:26 autopkgtest (systemd)[834]: pam_unix(systemd-user:session): session opened for user ubuntu(uid=1000) by ubuntu(uid=0) 87s Jul 08 18:38:26 autopkgtest systemd-logind[730]: New session 2 of user ubuntu. 87s Jul 08 18:38:26 autopkgtest systemd[834]: Queued start job for default target default.target. 87s Jul 08 18:38:26 autopkgtest systemd[834]: Created slice app.slice - User Application Slice. 87s Jul 08 18:38:26 autopkgtest systemd[834]: Started launchpadlib-cache-clean.timer - Clean up old files in the Launchpadlib cache. 87s Jul 08 18:38:26 autopkgtest systemd[834]: Reached target paths.target - Paths. 87s Jul 08 18:38:26 autopkgtest systemd[834]: Reached target timers.target - Timers. 87s Jul 08 18:38:26 autopkgtest systemd[834]: Starting dbus.socket - D-Bus User Message Bus Socket... 87s Jul 08 18:38:26 autopkgtest systemd[834]: Listening on dirmngr.socket - GnuPG network certificate management daemon. 87s Jul 08 18:38:26 autopkgtest systemd[834]: Listening on gpg-agent-browser.socket - GnuPG cryptographic agent and passphrase cache (access for web browsers). 87s Jul 08 18:38:26 autopkgtest systemd[834]: Listening on gpg-agent-extra.socket - GnuPG cryptographic agent and passphrase cache (restricted). 87s Jul 08 18:38:26 autopkgtest systemd[834]: Starting gpg-agent-ssh.socket - GnuPG cryptographic agent (ssh-agent emulation)... 87s Jul 08 18:38:26 autopkgtest systemd[834]: Starting gpg-agent.socket - GnuPG cryptographic agent and passphrase cache... 87s Jul 08 18:38:26 autopkgtest systemd[834]: Listening on keyboxd.socket - GnuPG public key management service. 87s Jul 08 18:38:26 autopkgtest systemd[834]: Listening on gpg-agent-ssh.socket - GnuPG cryptographic agent (ssh-agent emulation). 87s Jul 08 18:38:26 autopkgtest systemd[834]: Listening on dbus.socket - D-Bus User Message Bus Socket. 87s Jul 08 18:38:26 autopkgtest systemd[834]: Listening on gpg-agent.socket - GnuPG cryptographic agent and passphrase cache. 87s Jul 08 18:38:26 autopkgtest systemd[834]: Reached target sockets.target - Sockets. 87s Jul 08 18:38:26 autopkgtest systemd[834]: Reached target basic.target - Basic System. 87s Jul 08 18:38:26 autopkgtest systemd[834]: Reached target default.target - Main User Target. 87s Jul 08 18:38:26 autopkgtest systemd[834]: Startup finished in 55ms. 87s Jul 08 18:38:26 autopkgtest systemd[1]: Started user@1000.service - User Manager for UID 1000. 87s Jul 08 18:38:26 autopkgtest systemd[1]: Started session-1.scope - Session 1 of User ubuntu. 87s Jul 08 18:38:26 autopkgtest kernel: fbcon: Taking over console 87s Jul 08 18:38:28 autopkgtest sudo[880]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/bin/true 87s Jul 08 18:38:28 autopkgtest sudo[880]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:28 autopkgtest sudo[880]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:28 autopkgtest sudo[885]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper /bin/sh -ec 'for d in /var/cache /home; do if [ -e $d/autopkgtest-tmpdir.tar ]; then /bin/tar --warning=none --extract --absolute-names -f $d/autopkgtest-tmpdir.tar; /bin/rm $d/autopkgtest-tmpdir.tar; exit 0; fi; done; exit 1' 87s Jul 08 18:38:28 autopkgtest sudo[885]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:28 autopkgtest sudo[885]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:29 autopkgtest sudo[897]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper mkdir -p /tmp/autopkgtest.sAVI0T 87s Jul 08 18:38:29 autopkgtest sudo[897]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:29 autopkgtest sudo[897]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:29 autopkgtest sudo[907]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper sh -ec 'cat >/tmp/autopkgtest.sAVI0T/autopkgtest-reboot; chmod +x -- /tmp/autopkgtest.sAVI0T/autopkgtest-reboot' 87s Jul 08 18:38:29 autopkgtest sudo[907]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:29 autopkgtest sudo[907]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:29 autopkgtest sudo[919]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper chmod -R 0755 -- /tmp/autopkgtest.sAVI0T/autopkgtest-reboot 87s Jul 08 18:38:29 autopkgtest sudo[919]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:29 autopkgtest sudo[919]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:29 autopkgtest sudo[929]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper ln -fns /tmp/autopkgtest.sAVI0T/autopkgtest-reboot /tmp/autopkgtest-reboot 87s Jul 08 18:38:29 autopkgtest sudo[929]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:29 autopkgtest sudo[929]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:29 autopkgtest sudo[939]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper ln -fns /tmp/autopkgtest.sAVI0T/autopkgtest-reboot /sbin/autopkgtest-reboot 87s Jul 08 18:38:29 autopkgtest sudo[939]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:29 autopkgtest sudo[939]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:29 autopkgtest sudo[949]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper mkdir -p /tmp/autopkgtest.sAVI0T 87s Jul 08 18:38:29 autopkgtest sudo[949]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:29 autopkgtest sudo[949]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:30 autopkgtest sudo[959]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper sh -ec 'cat >/tmp/autopkgtest.sAVI0T/autopkgtest-reboot-prepare; chmod +x -- /tmp/autopkgtest.sAVI0T/autopkgtest-reboot-prepare' 87s Jul 08 18:38:30 autopkgtest sudo[959]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:30 autopkgtest sudo[959]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:30 autopkgtest sudo[971]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper chmod -R 0755 -- /tmp/autopkgtest.sAVI0T/autopkgtest-reboot-prepare 87s Jul 08 18:38:30 autopkgtest sudo[971]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:30 autopkgtest sudo[971]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:30 autopkgtest sudo[981]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper ln -fns /tmp/autopkgtest.sAVI0T/autopkgtest-reboot-prepare /tmp/autopkgtest-reboot-prepare 87s Jul 08 18:38:30 autopkgtest sudo[981]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:30 autopkgtest sudo[981]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:30 autopkgtest sudo[991]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper uname -srv 87s Jul 08 18:38:30 autopkgtest sudo[991]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:30 autopkgtest sudo[991]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:30 autopkgtest sudo[1001]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper sh -c 'nproc; cat /proc/cpuinfo 2>/dev/null || true' 87s Jul 08 18:38:30 autopkgtest sudo[1001]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:30 autopkgtest sudo[1001]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:30 autopkgtest sudo[1013]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper sh -ec 'dpkg-query --show -f \'${Package}\\t${Version}\\n\' > /tmp/autopkgtest.sAVI0T/testbed-packages' 87s Jul 08 18:38:30 autopkgtest sudo[1013]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:30 autopkgtest sudo[1013]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:31 autopkgtest sudo[1024]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper sh -ec 'cat /tmp/autopkgtest.sAVI0T/autopkgtest-reboot; chmod +x -- /tmp/autopkgtest.sAVI0T/autopkgtest-reboot' 87s Jul 08 18:38:31 autopkgtest sudo[1045]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:31 autopkgtest sudo[1045]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:31 autopkgtest sudo[1057]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper chmod -R 0755 -- /tmp/autopkgtest.sAVI0T/autopkgtest-reboot 87s Jul 08 18:38:31 autopkgtest sudo[1057]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:31 autopkgtest sudo[1057]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:31 autopkgtest sudo[1067]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper ln -fns /tmp/autopkgtest.sAVI0T/autopkgtest-reboot /tmp/autopkgtest-reboot 87s Jul 08 18:38:31 autopkgtest sudo[1067]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:31 autopkgtest sudo[1067]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:32 autopkgtest sudo[1077]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper ln -fns /tmp/autopkgtest.sAVI0T/autopkgtest-reboot /sbin/autopkgtest-reboot 87s Jul 08 18:38:32 autopkgtest sudo[1077]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:32 autopkgtest sudo[1077]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:32 autopkgtest sudo[1087]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper mkdir -p /tmp/autopkgtest.sAVI0T 87s Jul 08 18:38:32 autopkgtest sudo[1087]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:32 autopkgtest sudo[1087]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:32 autopkgtest sudo[1097]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper sh -ec 'cat >/tmp/autopkgtest.sAVI0T/autopkgtest-reboot-prepare; chmod +x -- /tmp/autopkgtest.sAVI0T/autopkgtest-reboot-prepare' 87s Jul 08 18:38:32 autopkgtest sudo[1097]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:32 autopkgtest sudo[1097]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:32 autopkgtest sudo[1109]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper chmod -R 0755 -- /tmp/autopkgtest.sAVI0T/autopkgtest-reboot-prepare 87s Jul 08 18:38:32 autopkgtest sudo[1109]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:32 autopkgtest sudo[1109]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:32 autopkgtest sudo[1119]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper ln -fns /tmp/autopkgtest.sAVI0T/autopkgtest-reboot-prepare /tmp/autopkgtest-reboot-prepare 87s Jul 08 18:38:32 autopkgtest sudo[1119]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:32 autopkgtest sudo[1119]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:32 autopkgtest sudo[1129]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper uname -srv 87s Jul 08 18:38:32 autopkgtest sudo[1129]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:32 autopkgtest sudo[1129]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:32 autopkgtest sudo[1139]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper apt-cache showsrc --only-source cockpit-podman 87s Jul 08 18:38:32 autopkgtest sudo[1139]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:33 autopkgtest sudo[1139]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:33 autopkgtest sudo[1150]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper apt-cache policy ^cockpit-podman$ 87s Jul 08 18:38:33 autopkgtest sudo[1150]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:33 autopkgtest sudo[1150]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:33 autopkgtest sudo[1162]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper apt-cache show cockpit-podman=108-1 87s Jul 08 18:38:33 autopkgtest sudo[1162]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:33 autopkgtest sudo[1162]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:33 autopkgtest sudo[1174]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper sh -ec 'command -v dpkg-source' 87s Jul 08 18:38:33 autopkgtest sudo[1174]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:33 autopkgtest sudo[1174]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:33 autopkgtest sudo[1184]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper env ADT_TEST_TRIGGERS=podman/5.4.2+ds1-2 sh -ec 'su --shell=/bin/sh ubuntu -c \'set -e; exec 3>&1 >&2; cd /; builddir=$(mktemp -d /tmp/autopkgtest.sAVI0T/build.XXX); cd $builddir; OUT=$(apt-get source -d -q --only-source cockpit-podman=108-1 2>&1) || RC=$?;if [ -n "$RC" ]; then if echo "$OUT" | grep -q "Unable to find a source package"; then exit 1; else exit $RC; fi;fi;echo "$OUT" | grep ^Get: || true;dpkg-source -x cockpit-podman_*.dsc src >/dev/null; chmod -R a+rX .; cd [a-z0-9]*/.; pwd >&3; sed -n "1 {s/).*//; s/ (/\\n/; p}" debian/changelog >&3\'' 87s Jul 08 18:38:33 autopkgtest sudo[1184]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:33 autopkgtest su[1188]: (to ubuntu) root on none 87s Jul 08 18:38:33 autopkgtest su[1188]: pam_unix(su:session): session opened for user ubuntu(uid=1000) by ubuntu(uid=0) 87s Jul 08 18:38:34 autopkgtest su[1188]: pam_unix(su:session): session closed for user ubuntu 87s Jul 08 18:38:34 autopkgtest sudo[1184]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:34 autopkgtest sudo[1219]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper sh -ec 'cd /tmp/autopkgtest.sAVI0T/build.Jk3/src/debian/; tar --warning=none -c . -f -' 87s Jul 08 18:38:34 autopkgtest sudo[1219]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:34 autopkgtest sudo[1219]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:35 autopkgtest sudo[1230]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper sh -ec 'cd /tmp/autopkgtest.sAVI0T/build.Jk3/src/; tar --warning=none -c . -f -' 87s Jul 08 18:38:35 autopkgtest sudo[1230]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:35 autopkgtest sudo[1230]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:35 autopkgtest sudo[1241]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper env DEBIAN_FRONTEND=noninteractive APT_LISTBUGS_FRONTEND=none APT_LISTCHANGES_FRONTEND=none /bin/sh -ec '"$@" 3>&2 2>&1' run_apt_command /usr/bin/eatmydata apt-get --quiet --assume-yes -o=APT::Status-Fd=3 -o=APT::Install-Recommends=false -o=Dpkg::Options::=--force-confnew -o=Debug::pkgProblemResolver=true satisfy 'cockpit-podman, cockpit-ws, curl, adduser' 87s Jul 08 18:38:35 autopkgtest sudo[1241]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:39 autopkgtest systemd[1]: Reload requested from client PID 1468 ('systemctl') (unit session-1.scope)... 87s Jul 08 18:38:39 autopkgtest systemd[1]: Reloading... 87s Jul 08 18:38:39 autopkgtest systemd[1]: Reloading finished in 215 ms. 87s Jul 08 18:38:39 autopkgtest systemd[1]: Listening on netavark-dhcp-proxy.socket - Netavark DHCP proxy socket. 87s Jul 08 18:38:39 autopkgtest systemd[1]: Starting netavark-dhcp-proxy.service - Netavark DHCP proxy service... 87s Jul 08 18:38:39 autopkgtest systemd[1]: Started netavark-firewalld-reload.service - Listen for the firewalld reload event and reapply all netavark firewall rules.. 87s Jul 08 18:38:39 autopkgtest systemd[1]: Started netavark-dhcp-proxy.service - Netavark DHCP proxy service. 87s Jul 08 18:38:41 autopkgtest systemd[1]: Reload requested from client PID 1589 ('systemctl') (unit session-1.scope)... 87s Jul 08 18:38:41 autopkgtest systemd[1]: Reloading... 87s Jul 08 18:38:41 autopkgtest systemd[1]: Reloading finished in 190 ms. 87s Jul 08 18:38:41 autopkgtest systemd[1]: Starting cockpit.socket - Cockpit Web Service Socket... 87s Jul 08 18:38:41 autopkgtest systemd[1]: Listening on cockpit.socket - Cockpit Web Service Socket. 87s Jul 08 18:38:41 autopkgtest systemd[1]: Starting cockpit-issue.service - Cockpit issue updater service... 87s Jul 08 18:38:41 autopkgtest systemd[1]: cockpit-issue.service: Deactivated successfully. 87s Jul 08 18:38:41 autopkgtest systemd[1]: Finished cockpit-issue.service - Cockpit issue updater service. 87s Jul 08 18:38:41 autopkgtest kernel: kauditd_printk_skb: 163 callbacks suppressed 87s Jul 08 18:38:41 autopkgtest kernel: audit: type=1400 audit(1751999921.911:174): apparmor="STATUS" operation="profile_load" profile="unconfined" name="cockpit-desktop" pid=1663 comm="apparmor_parser" 87s Jul 08 18:38:42 autopkgtest sudo[1241]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:42 autopkgtest sudo[1686]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper dpkg-query --show -f ${Status} cockpit-podman 87s Jul 08 18:38:42 autopkgtest sudo[1686]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:42 autopkgtest sudo[1686]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:42 autopkgtest sudo[1696]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper sh -ec 'dpkg-query --show -f \'${Package}\\t${Version}\\n\' > /tmp/autopkgtest.sAVI0T/smoke-packages.all' 87s Jul 08 18:38:42 autopkgtest sudo[1696]: pam_unix(sudo:session): session opened for user root(uid=0) by ubuntu(uid=1000) 87s Jul 08 18:38:42 autopkgtest sudo[1696]: pam_unix(sudo:session): session closed for user root 87s Jul 08 18:38:42 autopkgtest sudo[1707]: ubuntu : PWD=/home/ubuntu ; USER=root ; COMMAND=/tmp/autopkgtest-run-wrapper sh -ec 'cat