  0s autopkgtest [19:28:18]: starting date and time: 2025-03-15 19:28:18+0000
  0s autopkgtest [19:28:18]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production'
  0s autopkgtest [19:28:18]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.jr3nk7ju/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:glibc --apt-upgrade cluster-glue --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=glibc/2.41-1ubuntu2 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-ppc64el --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-ppc64el-7.secgroup --name adt-plucky-ppc64el-cluster-glue-20250315-185039-juju-7f2275-prod-proposed-migration-environment-2-d746fd76-5d61-4272-bb8d-b878e0d712bb --image adt/ubuntu-plucky-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration-ppc64el -e TERM=linux -e ''"'"'http_proxy=http://squid.internal:3128'"'"'' -e ''"'"'https_proxy=http://squid.internal:3128'"'"'' -e ''"'"'no_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com,radosgw.ps5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/
 88s autopkgtest [19:29:46]: testbed dpkg architecture: ppc64el
 88s autopkgtest [19:29:46]: testbed apt version: 2.9.33
 88s autopkgtest [19:29:46]: @@@@@@@@@@@@@@@@@@@@ test bed setup
 89s autopkgtest [19:29:47]: testbed release detected to be: None
 89s autopkgtest [19:29:47]: updating testbed package index (apt update)
 90s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [126 kB]
 90s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease
 90s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease
 90s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease
 90s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [14.5 kB]
 90s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [45.1 kB]
 90s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [369 kB]
 90s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el Packages [78.8 kB]
 90s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el c-n-f Metadata [1884 B]
 90s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted ppc64el c-n-f Metadata [120 B]
 90s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe ppc64el Packages [320 kB]
 90s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/universe ppc64el c-n-f Metadata [14.4 kB]
 90s Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse ppc64el Packages [13.9 kB]
 90s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse ppc64el c-n-f Metadata [484 B]
 91s Fetched 984 kB in 1s (1098 kB/s)
 92s Reading package lists...
 92s Reading package lists...
 92s Building dependency tree...
 92s Reading state information...
 93s Calculating upgrade...
 93s Calculating upgrade...
 93s The following NEW packages will be installed:
 93s   bpftool linux-headers-6.14.0-10 linux-headers-6.14.0-10-generic
 93s   linux-image-6.14.0-10-generic linux-modules-6.14.0-10-generic
 93s   linux-modules-extra-6.14.0-10-generic linux-perf linux-tools-6.14.0-10
 93s   linux-tools-6.14.0-10-generic
 93s The following packages will be upgraded:
 93s   cloud-init cloud-init-base libmm-glib0 libpython3.13 libpython3.13-minimal
 93s   libpython3.13-stdlib linux-generic linux-headers-generic
 93s   linux-headers-virtual linux-image-generic linux-image-virtual linux-libc-dev
 93s   linux-tools-common linux-virtual pinentry-curses python3-jinja2 python3.13
 93s   python3.13-gdbm python3.13-minimal strace
 93s 20 upgraded, 9 newly installed, 0 to remove and 0 not upgraded.
 93s Need to get 241 MB of archives.
 93s After this operation, 339 MB of additional disk space will be used.
 93s Get:1 http://ftpmaster.internal/ubuntu plucky/main ppc64el python3.13 ppc64el 3.13.2-2 [735 kB]
 93s Get:2 http://ftpmaster.internal/ubuntu plucky/main ppc64el python3.13-minimal ppc64el 3.13.2-2 [2503 kB]
 94s Get:3 http://ftpmaster.internal/ubuntu plucky/main ppc64el libpython3.13 ppc64el 3.13.2-2 [2534 kB]
 94s Get:4 http://ftpmaster.internal/ubuntu plucky/main ppc64el libpython3.13-stdlib ppc64el 3.13.2-2 [2109 kB]
 94s Get:5 http://ftpmaster.internal/ubuntu plucky/main ppc64el libpython3.13-minimal ppc64el 3.13.2-2 [885 kB]
 94s Get:6 http://ftpmaster.internal/ubuntu plucky/main ppc64el strace ppc64el 6.13+ds-1ubuntu1 [493 kB]
 94s Get:7 http://ftpmaster.internal/ubuntu plucky/main ppc64el linux-tools-common all 6.14.0-10.10 [295 kB]
 94s Get:8 http://ftpmaster.internal/ubuntu plucky/main ppc64el bpftool ppc64el 7.6.0+6.14.0-10.10 [1177 kB]
 94s Get:9 http://ftpmaster.internal/ubuntu plucky/main ppc64el python3-jinja2 all 3.1.5-2ubuntu1 [109 kB]
 94s Get:10 http://ftpmaster.internal/ubuntu plucky/main ppc64el cloud-init-base all 25.1-0ubuntu3 [616 kB]
 94s Get:11 http://ftpmaster.internal/ubuntu plucky/main ppc64el libmm-glib0 ppc64el 1.23.4-0ubuntu3 [278 kB]
 94s Get:12 http://ftpmaster.internal/ubuntu plucky/main ppc64el linux-modules-6.14.0-10-generic ppc64el 6.14.0-10.10 [33.8 MB]
 96s Get:13 http://ftpmaster.internal/ubuntu plucky/main ppc64el linux-image-6.14.0-10-generic ppc64el 6.14.0-10.10 [64.1 MB]
100s Get:14 http://ftpmaster.internal/ubuntu plucky/main ppc64el linux-modules-extra-6.14.0-10-generic ppc64el 6.14.0-10.10 [107 MB]
111s Get:15 http://ftpmaster.internal/ubuntu plucky/main ppc64el linux-generic ppc64el 6.14.0-10.10 [1736 B]
111s Get:16 http://ftpmaster.internal/ubuntu plucky/main ppc64el linux-image-generic ppc64el 6.14.0-10.10 [11.1 kB]
111s Get:17 http://ftpmaster.internal/ubuntu plucky/main ppc64el linux-virtual ppc64el 6.14.0-10.10 [1722 B]
111s Get:18 http://ftpmaster.internal/ubuntu plucky/main ppc64el linux-image-virtual ppc64el 6.14.0-10.10 [11.1 kB]
111s Get:19 http://ftpmaster.internal/ubuntu plucky/main ppc64el linux-headers-virtual ppc64el 6.14.0-10.10 [1646 B]
111s Get:20 http://ftpmaster.internal/ubuntu plucky/main ppc64el linux-headers-6.14.0-10 all 6.14.0-10.10 [14.2 MB]
113s Get:21 http://ftpmaster.internal/ubuntu plucky/main ppc64el linux-headers-6.14.0-10-generic ppc64el 6.14.0-10.10 [4074 kB]
114s Get:22 http://ftpmaster.internal/ubuntu plucky/main ppc64el linux-headers-generic ppc64el 6.14.0-10.10 [11.0 kB]
114s Get:23 http://ftpmaster.internal/ubuntu plucky/main ppc64el linux-libc-dev ppc64el 6.14.0-10.10 [1710 kB]
114s Get:24 http://ftpmaster.internal/ubuntu plucky/main ppc64el linux-perf ppc64el 6.14.0-10.10 [2552 kB]
115s Get:25 http://ftpmaster.internal/ubuntu plucky/main ppc64el linux-tools-6.14.0-10 ppc64el 6.14.0-10.10 [1267 kB]
115s Get:26 http://ftpmaster.internal/ubuntu plucky/main ppc64el linux-tools-6.14.0-10-generic ppc64el 6.14.0-10.10 [830 B]
115s Get:27 http://ftpmaster.internal/ubuntu plucky/main ppc64el pinentry-curses ppc64el 1.3.1-2ubuntu3 [44.3 kB]
115s Get:28 http://ftpmaster.internal/ubuntu plucky/main ppc64el python3.13-gdbm ppc64el 3.13.2-2 [32.2 kB]
115s Get:29 http://ftpmaster.internal/ubuntu plucky/main ppc64el cloud-init all 25.1-0ubuntu3 [2100 B]
115s Preconfiguring packages ...
116s Fetched 241 MB in 22s (10.8 MB/s)
116s (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 ... 107193 files and directories currently installed.)
116s Preparing to unpack .../00-python3.13_3.13.2-2_ppc64el.deb ...
116s Unpacking python3.13 (3.13.2-2) over (3.13.2-1) ...
116s Preparing to unpack .../01-python3.13-minimal_3.13.2-2_ppc64el.deb ...
116s Unpacking python3.13-minimal (3.13.2-2) over (3.13.2-1) ...
116s Preparing to unpack .../02-libpython3.13_3.13.2-2_ppc64el.deb ...
116s Unpacking libpython3.13:ppc64el (3.13.2-2) over (3.13.2-1) ...
116s Preparing to unpack .../03-libpython3.13-stdlib_3.13.2-2_ppc64el.deb ...
116s Unpacking libpython3.13-stdlib:ppc64el (3.13.2-2) over (3.13.2-1) ...
116s Preparing to unpack .../04-libpython3.13-minimal_3.13.2-2_ppc64el.deb ...
116s Unpacking libpython3.13-minimal:ppc64el (3.13.2-2) over (3.13.2-1) ...
116s Preparing to unpack .../05-strace_6.13+ds-1ubuntu1_ppc64el.deb ...
116s Unpacking strace (6.13+ds-1ubuntu1) over (6.11-0ubuntu1) ...
116s Preparing to unpack .../06-linux-tools-common_6.14.0-10.10_all.deb ...
116s Unpacking linux-tools-common (6.14.0-10.10) over (6.14.0-7.7) ...
116s Selecting previously unselected package bpftool.
116s Preparing to unpack .../07-bpftool_7.6.0+6.14.0-10.10_ppc64el.deb ...
116s Unpacking bpftool (7.6.0+6.14.0-10.10) ...
116s Preparing to unpack .../08-python3-jinja2_3.1.5-2ubuntu1_all.deb ...
117s Unpacking python3-jinja2 (3.1.5-2ubuntu1) over (3.1.5-2) ...
117s Preparing to unpack .../09-cloud-init-base_25.1-0ubuntu3_all.deb ...
117s Unpacking cloud-init-base (25.1-0ubuntu3) over (25.1-0ubuntu2) ...
117s Preparing to unpack .../10-libmm-glib0_1.23.4-0ubuntu3_ppc64el.deb ...
117s Unpacking libmm-glib0:ppc64el (1.23.4-0ubuntu3) over (1.23.4-0ubuntu2) ...
117s Selecting previously unselected package linux-modules-6.14.0-10-generic.
117s Preparing to unpack .../11-linux-modules-6.14.0-10-generic_6.14.0-10.10_ppc64el.deb ...
117s Unpacking linux-modules-6.14.0-10-generic (6.14.0-10.10) ...
117s Selecting previously unselected package linux-image-6.14.0-10-generic.
117s Preparing to unpack .../12-linux-image-6.14.0-10-generic_6.14.0-10.10_ppc64el.deb ...
117s Unpacking linux-image-6.14.0-10-generic (6.14.0-10.10) ...
118s Selecting previously unselected package linux-modules-extra-6.14.0-10-generic.
118s Preparing to unpack .../13-linux-modules-extra-6.14.0-10-generic_6.14.0-10.10_ppc64el.deb ...
118s Unpacking linux-modules-extra-6.14.0-10-generic (6.14.0-10.10) ...
119s Preparing to unpack .../14-linux-generic_6.14.0-10.10_ppc64el.deb ...
119s Unpacking linux-generic (6.14.0-10.10) over (6.14.0-7.7+1) ...
119s Preparing to unpack .../15-linux-image-generic_6.14.0-10.10_ppc64el.deb ...
119s Unpacking linux-image-generic (6.14.0-10.10) over (6.14.0-7.7+1) ...
119s Preparing to unpack .../16-linux-virtual_6.14.0-10.10_ppc64el.deb ...
119s Unpacking linux-virtual (6.14.0-10.10) over (6.14.0-7.7+1) ...
119s Preparing to unpack .../17-linux-image-virtual_6.14.0-10.10_ppc64el.deb ...
119s Unpacking linux-image-virtual (6.14.0-10.10) over (6.14.0-7.7+1) ...
119s Preparing to unpack .../18-linux-headers-virtual_6.14.0-10.10_ppc64el.deb ...
119s Unpacking linux-headers-virtual (6.14.0-10.10) over (6.14.0-7.7+1) ...
119s Selecting previously unselected package linux-headers-6.14.0-10.
119s Preparing to unpack .../19-linux-headers-6.14.0-10_6.14.0-10.10_all.deb ...
119s Unpacking linux-headers-6.14.0-10 (6.14.0-10.10) ...
121s Selecting previously unselected package linux-headers-6.14.0-10-generic.
121s Preparing to unpack .../20-linux-headers-6.14.0-10-generic_6.14.0-10.10_ppc64el.deb ...
121s Unpacking linux-headers-6.14.0-10-generic (6.14.0-10.10) ...
123s Preparing to unpack .../21-linux-headers-generic_6.14.0-10.10_ppc64el.deb ...
123s Unpacking linux-headers-generic (6.14.0-10.10) over (6.14.0-7.7+1) ...
123s Preparing to unpack .../22-linux-libc-dev_6.14.0-10.10_ppc64el.deb ...
123s Unpacking linux-libc-dev:ppc64el (6.14.0-10.10) over (6.14.0-7.7) ...
123s Selecting previously unselected package linux-perf.
123s Preparing to unpack .../23-linux-perf_6.14.0-10.10_ppc64el.deb ...
123s Unpacking linux-perf (6.14.0-10.10) ...
123s Selecting previously unselected package linux-tools-6.14.0-10.
123s Preparing to unpack .../24-linux-tools-6.14.0-10_6.14.0-10.10_ppc64el.deb ...
123s Unpacking linux-tools-6.14.0-10 (6.14.0-10.10) ...
123s Selecting previously unselected package linux-tools-6.14.0-10-generic.
123s Preparing to unpack .../25-linux-tools-6.14.0-10-generic_6.14.0-10.10_ppc64el.deb ...
123s Unpacking linux-tools-6.14.0-10-generic (6.14.0-10.10) ...
123s Preparing to unpack .../26-pinentry-curses_1.3.1-2ubuntu3_ppc64el.deb ...
123s Unpacking pinentry-curses (1.3.1-2ubuntu3) over (1.3.1-2ubuntu2) ...
123s Preparing to unpack .../27-python3.13-gdbm_3.13.2-2_ppc64el.deb ...
123s Unpacking python3.13-gdbm (3.13.2-2) over (3.13.2-1) ...
123s Preparing to unpack .../28-cloud-init_25.1-0ubuntu3_all.deb ...
123s Unpacking cloud-init (25.1-0ubuntu3) over (25.1-0ubuntu2) ...
123s Setting up linux-headers-6.14.0-10 (6.14.0-10.10) ...
123s Setting up pinentry-curses (1.3.1-2ubuntu3) ...
123s Setting up linux-headers-6.14.0-10-generic (6.14.0-10.10) ...
123s Setting up bpftool (7.6.0+6.14.0-10.10) ...
123s Setting up linux-libc-dev:ppc64el (6.14.0-10.10) ...
123s Setting up linux-headers-generic (6.14.0-10.10) ...
123s Setting up libpython3.13-minimal:ppc64el (3.13.2-2) ...
123s Setting up python3-jinja2 (3.1.5-2ubuntu1) ...
123s Setting up strace (6.13+ds-1ubuntu1) ...
123s Setting up linux-modules-6.14.0-10-generic (6.14.0-10.10) ...
125s Setting up libmm-glib0:ppc64el (1.23.4-0ubuntu3) ...
125s Setting up python3.13-minimal (3.13.2-2) ...
126s Setting up linux-tools-common (6.14.0-10.10) ...
126s Setting up libpython3.13-stdlib:ppc64el (3.13.2-2) ...
126s Setting up python3.13-gdbm (3.13.2-2) ...
126s Setting up libpython3.13:ppc64el (3.13.2-2) ...
126s Setting up linux-tools-6.14.0-10 (6.14.0-10.10) ...
126s Setting up linux-headers-virtual (6.14.0-10.10) ...
126s Setting up python3.13 (3.13.2-2) ...
127s Setting up linux-image-6.14.0-10-generic (6.14.0-10.10) ...
129s I: /boot/vmlinux.old is now a symlink to vmlinux-6.14.0-7-generic
129s I: /boot/initrd.img.old is now a symlink to initrd.img-6.14.0-7-generic
129s I: /boot/vmlinux is now a symlink to vmlinux-6.14.0-10-generic
129s I: /boot/initrd.img is now a symlink to initrd.img-6.14.0-10-generic
129s Setting up cloud-init-base (25.1-0ubuntu3) ...
131s Setting up linux-modules-extra-6.14.0-10-generic (6.14.0-10.10) ...
133s Setting up linux-perf (6.14.0-10.10) ...
133s Setting up linux-tools-6.14.0-10-generic (6.14.0-10.10) ...
133s Setting up linux-image-virtual (6.14.0-10.10) ...
133s Setting up linux-image-generic (6.14.0-10.10) ...
133s Setting up cloud-init (25.1-0ubuntu3) ...
133s Setting up linux-generic (6.14.0-10.10) ...
133s Setting up linux-virtual (6.14.0-10.10) ...
133s Processing triggers for rsyslog (8.2412.0-2ubuntu2) ...
133s Processing triggers for systemd (257.3-1ubuntu3) ...
133s Processing triggers for man-db (2.13.0-1) ...
134s Processing triggers for libc-bin (2.41-1ubuntu1) ...
134s Processing triggers for linux-image-6.14.0-10-generic (6.14.0-10.10) ...
134s /etc/kernel/postinst.d/initramfs-tools:
134s update-initramfs: Generating /boot/initrd.img-6.14.0-10-generic
134s W: No lz4 in /usr/bin:/sbin:/bin, using gzip
143s /etc/kernel/postinst.d/zz-update-grub:
143s Sourcing file `/etc/default/grub'
143s Sourcing file `/etc/default/grub.d/50-cloudimg-settings.cfg'
143s Generating grub configuration file ...
143s Found linux image: /boot/vmlinux-6.14.0-10-generic
143s Found initrd image: /boot/initrd.img-6.14.0-10-generic
143s Found linux image: /boot/vmlinux-6.14.0-7-generic
143s Found initrd image: /boot/initrd.img-6.14.0-7-generic
143s Found linux image: /boot/vmlinux-6.11.0-8-generic
143s Found initrd image: /boot/initrd.img-6.11.0-8-generic
143s Warning: os-prober will not be executed to detect other bootable partitions.
143s Systems on them will not be added to the GRUB boot configuration.
143s Check GRUB_DISABLE_OS_PROBER documentation entry.
143s Adding boot menu entry for UEFI Firmware Settings ...
143s done
143s Reading package lists...
144s Building dependency tree...
144s Reading state information...
144s Solving dependencies...
144s The following packages will be REMOVED:
144s   libnsl2* libpython3.12-minimal* libpython3.12-stdlib* libpython3.12t64*
144s   libunwind8* linux-headers-6.11.0-8* linux-headers-6.11.0-8-generic*
144s   linux-image-6.11.0-8-generic* linux-modules-6.11.0-8-generic*
144s   linux-modules-extra-6.14.0-7-generic* linux-tools-6.11.0-8*
144s   linux-tools-6.11.0-8-generic*
144s 0 upgraded, 0 newly installed, 12 to remove and 5 not upgraded.
144s After this operation, 363 MB disk space will be freed.
144s (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 ... 145124 files and directories currently installed.)
144s Removing linux-tools-6.11.0-8-generic (6.11.0-8.8) ...
144s Removing linux-tools-6.11.0-8 (6.11.0-8.8) ...
144s Removing libpython3.12t64:ppc64el (3.12.9-1) ...
144s Removing libpython3.12-stdlib:ppc64el (3.12.9-1) ...
144s Removing libnsl2:ppc64el (1.3.0-3build3) ...
144s Removing libpython3.12-minimal:ppc64el (3.12.9-1) ...
144s Removing libunwind8:ppc64el (1.6.2-3.1) ...
144s Removing linux-headers-6.11.0-8-generic (6.11.0-8.8) ...
145s Removing linux-headers-6.11.0-8 (6.11.0-8.8) ...
147s Removing linux-image-6.11.0-8-generic (6.11.0-8.8) ...
147s /etc/kernel/postrm.d/initramfs-tools:
147s update-initramfs: Deleting /boot/initrd.img-6.11.0-8-generic
147s /etc/kernel/postrm.d/zz-update-grub:
147s Sourcing file `/etc/default/grub'
147s Sourcing file `/etc/default/grub.d/50-cloudimg-settings.cfg'
147s Generating grub configuration file ...
147s Found linux image: /boot/vmlinux-6.14.0-10-generic
147s Found initrd image: /boot/initrd.img-6.14.0-10-generic
147s Found linux image: /boot/vmlinux-6.14.0-7-generic
147s Found initrd image: /boot/initrd.img-6.14.0-7-generic
147s Warning: os-prober will not be executed to detect other bootable partitions.
147s Systems on them will not be added to the GRUB boot configuration.
147s Check GRUB_DISABLE_OS_PROBER documentation entry.
147s Adding boot menu entry for UEFI Firmware Settings ...
147s done
147s Removing linux-modules-6.11.0-8-generic (6.11.0-8.8) ...
147s Removing linux-modules-extra-6.14.0-7-generic (6.14.0-7.7) ...
149s Processing triggers for libc-bin (2.41-1ubuntu1) ...
149s (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 ... 106967 files and directories currently installed.)
149s Purging configuration files for linux-image-6.11.0-8-generic (6.11.0-8.8) ...
149s Purging configuration files for libpython3.12-minimal:ppc64el (3.12.9-1) ...
149s Purging configuration files for linux-modules-extra-6.14.0-7-generic (6.14.0-7.7) ...
149s Purging configuration files for linux-modules-6.11.0-8-generic (6.11.0-8.8) ...
149s autopkgtest [19:30:47]: upgrading testbed (apt dist-upgrade and autopurge)
149s Reading package lists...
149s Building dependency tree...
149s Reading state information...
150s Calculating upgrade...Starting pkgProblemResolver with broken count: 0
150s Starting 2 pkgProblemResolver with broken count: 0
150s Done
150s Entering ResolveByKeep
150s 
150s Calculating upgrade...
151s The following packages will be upgraded:
151s   libc-bin libc-dev-bin libc6 libc6-dev locales
151s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
151s Need to get 10.3 MB of archives.
151s After this operation, 1024 B of additional disk space will be used.
151s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el libc6-dev ppc64el 2.41-1ubuntu2 [2046 kB]
152s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el libc-dev-bin ppc64el 2.41-1ubuntu2 [25.3 kB]
152s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el libc6 ppc64el 2.41-1ubuntu2 [3243 kB]
153s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el libc-bin ppc64el 2.41-1ubuntu2 [742 kB]
153s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el locales all 2.41-1ubuntu2 [4246 kB]
156s Preconfiguring packages ...
156s Fetched 10.3 MB in 5s (2181 kB/s)
156s (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 ... 106964 files and directories currently installed.)
156s Preparing to unpack .../libc6-dev_2.41-1ubuntu2_ppc64el.deb ...
156s Unpacking libc6-dev:ppc64el (2.41-1ubuntu2) over (2.41-1ubuntu1) ...
156s Preparing to unpack .../libc-dev-bin_2.41-1ubuntu2_ppc64el.deb ...
156s Unpacking libc-dev-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ...
156s Preparing to unpack .../libc6_2.41-1ubuntu2_ppc64el.deb ...
156s Unpacking libc6:ppc64el (2.41-1ubuntu2) over (2.41-1ubuntu1) ...
156s Setting up libc6:ppc64el (2.41-1ubuntu2) ...
156s (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 ... 106964 files and directories currently installed.)
156s Preparing to unpack .../libc-bin_2.41-1ubuntu2_ppc64el.deb ...
156s Unpacking libc-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ...
157s Setting up libc-bin (2.41-1ubuntu2) ...
157s (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 ... 106964 files and directories currently installed.)
157s Preparing to unpack .../locales_2.41-1ubuntu2_all.deb ...
157s Unpacking locales (2.41-1ubuntu2) over (2.41-1ubuntu1) ...
157s Setting up locales (2.41-1ubuntu2) ...
157s Generating locales (this might take a while)...
159s   en_US.UTF-8... done
159s Generation complete.
159s Setting up libc-dev-bin (2.41-1ubuntu2) ...
159s Setting up libc6-dev:ppc64el (2.41-1ubuntu2) ...
159s Processing triggers for man-db (2.13.0-1) ...
159s Processing triggers for systemd (257.3-1ubuntu3) ...
160s Reading package lists...
161s Building dependency tree...
161s Reading state information...
161s Starting pkgProblemResolver with broken count: 0
161s Starting 2 pkgProblemResolver with broken count: 0
161s Done
161s Solving dependencies...
161s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
161s autopkgtest [19:30:59]: rebooting testbed after setup commands that affected boot
198s autopkgtest [19:31:36]: testbed running kernel: Linux 6.14.0-10-generic #10-Ubuntu SMP Wed Mar 12 16:05:46 UTC 2025
201s autopkgtest [19:31:39]: @@@@@@@@@@@@@@@@@@@@ apt-source cluster-glue
209s Get:1 http://ftpmaster.internal/ubuntu plucky/main cluster-glue 1.0.12-24ubuntu2 (dsc) [3327 B]
209s Get:2 http://ftpmaster.internal/ubuntu plucky/main cluster-glue 1.0.12-24ubuntu2 (tar) [491 kB]
209s Get:3 http://ftpmaster.internal/ubuntu plucky/main cluster-glue 1.0.12-24ubuntu2 (diff) [55.5 kB]
209s gpgv: Signature made Tue Mar  4 17:03:30 2025 UTC
209s gpgv:                using RSA key 25E3FF2D7F469DBE7D0D4E50AFCFEC8E669CE1C2
209s gpgv: Can't check signature: No public key
209s dpkg-source: warning: cannot verify inline signature for ./cluster-glue_1.0.12-24ubuntu2.dsc: no acceptable signature found
209s dpkg-source: warning: diff 'src/debian/patches/ubuntu/lp1895355-b7bed186-Dev-update-permissions-for-ec2.patch' doesn't contain any patch
209s autopkgtest [19:31:47]: testing package cluster-glue version 1.0.12-24ubuntu2
213s autopkgtest [19:31:51]: build not needed
217s autopkgtest [19:31:55]: test user: preparing testbed
217s Reading package lists...
217s Building dependency tree...
217s Reading state information...
218s Starting pkgProblemResolver with broken count: 0
218s Starting 2 pkgProblemResolver with broken count: 0
218s Done
218s The following NEW packages will be installed:
218s   cluster-glue liblrm2t64 libltdl7 libopenhpi3 libopenipmi0t64 libpils2t64
218s   libplumb2t64 libplumbgpl2t64 libsnmp-base libsnmp40t64 libstonith1t64
218s   libtimedate-perl
218s 0 upgraded, 12 newly installed, 0 to remove and 0 not upgraded.
218s Need to get 2660 kB of archives.
218s After this operation, 13.9 MB of additional disk space will be used.
218s Get:1 http://ftpmaster.internal/ubuntu plucky/main ppc64el libltdl7 ppc64el 2.5.4-4 [50.3 kB]
218s Get:2 http://ftpmaster.internal/ubuntu plucky/main ppc64el libpils2t64 ppc64el 1.0.12-24ubuntu2 [23.9 kB]
218s Get:3 http://ftpmaster.internal/ubuntu plucky/main ppc64el libplumb2t64 ppc64el 1.0.12-24ubuntu2 [94.6 kB]
218s Get:4 http://ftpmaster.internal/ubuntu plucky/main ppc64el liblrm2t64 ppc64el 1.0.12-24ubuntu2 [19.0 kB]
218s Get:5 http://ftpmaster.internal/ubuntu plucky/universe ppc64el libopenhpi3 ppc64el 3.8.0-2.3 [150 kB]
218s Get:6 http://ftpmaster.internal/ubuntu plucky/main ppc64el libopenipmi0t64 ppc64el 2.0.33-2 [597 kB]
219s Get:7 http://ftpmaster.internal/ubuntu plucky/main ppc64el libplumbgpl2t64 ppc64el 1.0.12-24ubuntu2 [10.2 kB]
219s Get:8 http://ftpmaster.internal/ubuntu plucky/main ppc64el libsnmp-base all 5.9.4+dfsg-1.1ubuntu7 [206 kB]
219s Get:9 http://ftpmaster.internal/ubuntu plucky/main ppc64el libsnmp40t64 ppc64el 5.9.4+dfsg-1.1ubuntu7 [1171 kB]
219s Get:10 http://ftpmaster.internal/ubuntu plucky/main ppc64el libstonith1t64 ppc64el 1.0.12-24ubuntu2 [15.8 kB]
219s Get:11 http://ftpmaster.internal/ubuntu plucky/main ppc64el libtimedate-perl all 2.3300-2 [34.0 kB]
219s Get:12 http://ftpmaster.internal/ubuntu plucky/universe ppc64el cluster-glue ppc64el 1.0.12-24ubuntu2 [288 kB]
219s Fetched 2660 kB in 1s (3286 kB/s)
219s Selecting previously unselected package libltdl7:ppc64el.
219s (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 ... 106964 files and directories currently installed.)
219s Preparing to unpack .../00-libltdl7_2.5.4-4_ppc64el.deb ...
219s Unpacking libltdl7:ppc64el (2.5.4-4) ...
219s Selecting previously unselected package libpils2t64.
219s Preparing to unpack .../01-libpils2t64_1.0.12-24ubuntu2_ppc64el.deb ...
219s Unpacking libpils2t64 (1.0.12-24ubuntu2) ...
219s Selecting previously unselected package libplumb2t64.
219s Preparing to unpack .../02-libplumb2t64_1.0.12-24ubuntu2_ppc64el.deb ...
219s Unpacking libplumb2t64 (1.0.12-24ubuntu2) ...
219s Selecting previously unselected package liblrm2t64.
219s Preparing to unpack .../03-liblrm2t64_1.0.12-24ubuntu2_ppc64el.deb ...
219s Unpacking liblrm2t64 (1.0.12-24ubuntu2) ...
219s Selecting previously unselected package libopenhpi3.
219s Preparing to unpack .../04-libopenhpi3_3.8.0-2.3_ppc64el.deb ...
219s Unpacking libopenhpi3 (3.8.0-2.3) ...
219s Selecting previously unselected package libopenipmi0t64:ppc64el.
219s Preparing to unpack .../05-libopenipmi0t64_2.0.33-2_ppc64el.deb ...
219s Unpacking libopenipmi0t64:ppc64el (2.0.33-2) ...
219s Selecting previously unselected package libplumbgpl2t64.
219s Preparing to unpack .../06-libplumbgpl2t64_1.0.12-24ubuntu2_ppc64el.deb ...
219s Unpacking libplumbgpl2t64 (1.0.12-24ubuntu2) ...
219s Selecting previously unselected package libsnmp-base.
219s Preparing to unpack .../07-libsnmp-base_5.9.4+dfsg-1.1ubuntu7_all.deb ...
219s Unpacking libsnmp-base (5.9.4+dfsg-1.1ubuntu7) ...
219s Selecting previously unselected package libsnmp40t64:ppc64el.
219s Preparing to unpack .../08-libsnmp40t64_5.9.4+dfsg-1.1ubuntu7_ppc64el.deb ...
219s Unpacking libsnmp40t64:ppc64el (5.9.4+dfsg-1.1ubuntu7) ...
220s Selecting previously unselected package libstonith1t64.
220s Preparing to unpack .../09-libstonith1t64_1.0.12-24ubuntu2_ppc64el.deb ...
220s Unpacking libstonith1t64 (1.0.12-24ubuntu2) ...
220s Selecting previously unselected package libtimedate-perl.
220s Preparing to unpack .../10-libtimedate-perl_2.3300-2_all.deb ...
220s Unpacking libtimedate-perl (2.3300-2) ...
220s Selecting previously unselected package cluster-glue.
220s Preparing to unpack .../11-cluster-glue_1.0.12-24ubuntu2_ppc64el.deb ...
220s Unpacking cluster-glue (1.0.12-24ubuntu2) ...
220s Setting up libsnmp-base (5.9.4+dfsg-1.1ubuntu7) ...
220s Setting up libopenipmi0t64:ppc64el (2.0.33-2) ...
220s Setting up libplumbgpl2t64 (1.0.12-24ubuntu2) ...
220s Setting up libltdl7:ppc64el (2.5.4-4) ...
220s Setting up libtimedate-perl (2.3300-2) ...
220s Setting up libopenhpi3 (3.8.0-2.3) ...
220s Setting up libpils2t64 (1.0.12-24ubuntu2) ...
220s Setting up libplumb2t64 (1.0.12-24ubuntu2) ...
220s Setting up libsnmp40t64:ppc64el (5.9.4+dfsg-1.1ubuntu7) ...
220s Setting up liblrm2t64 (1.0.12-24ubuntu2) ...
220s Setting up libstonith1t64 (1.0.12-24ubuntu2) ...
220s Setting up cluster-glue (1.0.12-24ubuntu2) ...
220s info: Selecting GID from range 100 to 999 ...
220s info: Adding group `haclient' (GID 108) ...
220s info: The home dir /var/lib/pacemaker you specified can't be accessed: No such file or directory
220s 
220s info: Selecting UID from range 100 to 999 ...
220s 
220s info: Adding system user `hacluster' (UID 107) ...
220s info: Adding new user `hacluster' (UID 107) with group `haclient' ...
220s info: Not creating home directory `/var/lib/pacemaker'.
220s Created symlink '/etc/systemd/system/multi-user.target.wants/logd.service' → '/usr/lib/systemd/system/logd.service'.
221s Processing triggers for man-db (2.13.0-1) ...
222s Processing triggers for libc-bin (2.41-1ubuntu2) ...
223s autopkgtest [19:32:01]: test user: [-----------------------
223s uid=107(hacluster) gid=108(haclient) groups=108(haclient)
223s autopkgtest [19:32:01]: test user: -----------------------]
224s user                 PASS
224s autopkgtest [19:32:02]: test user:  - - - - - - - - - - results - - - - - - - - - -
224s autopkgtest [19:32:02]: test ipctest: preparing testbed
224s Reading package lists...
225s Building dependency tree...
225s Reading state information...
225s Starting pkgProblemResolver with broken count: 0
225s Starting 2 pkgProblemResolver with broken count: 0
225s Done
225s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
226s autopkgtest [19:32:04]: test ipctest: [-----------------------
226s Mar 15 19:32:04 autopkgtest ipctest: [2174]: info: Echo server: 10000 reps pid 2174.
226s Mar 15 19:32:04 autopkgtest ipctest: [2175]: info: Echo client: 10000 reps pid 2175.
227s Mar 15 19:32:05 autopkgtest ipctest: [2175]: info: echoclient: 0 errors
228s Mar 15 19:32:06 autopkgtest ipctest: [2174]: info: echoserver: 0 errors
228s Mar 15 19:32:06 autopkgtest ipctest: [2176]: info: Asyn echo server: 10000 reps pid 2176.
228s Mar 15 19:32:06 autopkgtest ipctest: [2177]: info: Async Echo client: 10000 reps pid 2177.
228s Mar 15 19:32:06 autopkgtest ipctest: [2176]: info: asyn_echoserver: 0 errors
228s Mar 15 19:32:06 autopkgtest ipctest: [2177]: info: Async echoclient: 0 errors, 10000 reads, 10000 writes
228s Mar 15 19:32:06 autopkgtest ipctest: [2178]: info: Mainloop echo server: 10000 reps pid 2178.
228s Mar 15 19:32:06 autopkgtest ipctest: [2179]: info: Mainloop echo client: 10000 reps pid 2179.
228s Mar 15 19:32:06 autopkgtest ipctest: [2179]: info: Mainloop echo client: 0 errors, 10000 read 10000 written
228s 
228s (process:2178): GLib-CRITICAL **: 19:32:06.756: Source ID 1 was not found when attempting to remove it
228s Mar 15 19:32:06 autopkgtest ipctest: [2178]: info: Mainloop echo server: 0 errors
228s Mar 15 19:32:06 autopkgtest ipctest: [2178]: info: TOTAL errors: 0
229s autopkgtest [19:32:07]: test ipctest: -----------------------]
229s autopkgtest [19:32:07]: test ipctest:  - - - - - - - - - - results - - - - - - - - - -
229s ipctest              PASS
229s autopkgtest [19:32:07]: test logd: preparing testbed
230s Reading package lists...
230s Building dependency tree...
230s Reading state information...
230s Starting pkgProblemResolver with broken count: 0
230s Starting 2 pkgProblemResolver with broken count: 0
230s Done
230s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
231s autopkgtest [19:32:09]: test logd: [-----------------------
231s === service ===
231s ● logd.service - ha_logd logging daemon
231s      Loaded: loaded (/usr/lib/systemd/system/logd.service; enabled; preset: enabled)
231s      Active: active (running) since Sat 2025-03-15 19:32:09 UTC; 11ms ago
231s  Invocation: 79c17f90bac74d7188814ec4607e83a9
231s        Docs: man:ha_logd(8)
231s     Process: 2336 ExecStartPre=/bin/rm -f /run/logd.pid (code=exited, status=0/SUCCESS)
231s    Main PID: 2338 (ha_logd)
231s       Tasks: 2 (limit: 4740)
231s      Memory: 3.2M (peak: 8.4M)
231s         CPU: 8ms
231s      CGroup: /system.slice/logd.service
231s              ├─2338 "ha_logd: read process"
231s              └─2342 "ha_logd: write process"
231s 
231s Mar 15 19:32:09 autopkgtest systemd[1]: Starting logd.service - ha_logd logging daemon...
231s Mar 15 19:32:09 autopkgtest systemd[1]: Started logd.service - ha_logd logging daemon.
231s Mar 15 19:32:09 autopkgtest logd[2338]: [2338]: info: logd started with /etc/logd.cf.
231s === ha_logger ===
231s 2025-03-15T19:32:09.873366+00:00 autopkgtest cluster: [2343]: autopkgtest-message
231s === logtest ===
231s sending Message 0
231s sending Message 1
231s sending Message 2
231s sending Message 3
231s sending Message 4
231s sending Message 5
231s sending Message 6
231s sending Message 7
231s sending Message 8
231s sending Message 9
231s 2025-03-15T19:32:09.878109+00:00 autopkgtest logtest: [2345]: info: total message dropped: 0
232s autopkgtest [19:32:10]: test logd: -----------------------]
232s autopkgtest [19:32:10]: test logd:  - - - - - - - - - - results - - - - - - - - - -
232s logd                 PASS
233s autopkgtest [19:32:11]: test stonith-null: preparing testbed
324s autopkgtest [19:33:42]: testbed dpkg architecture: ppc64el
324s autopkgtest [19:33:42]: testbed apt version: 2.9.33
325s autopkgtest [19:33:43]: @@@@@@@@@@@@@@@@@@@@ test bed setup
325s autopkgtest [19:33:43]: testbed release detected to be: plucky
326s autopkgtest [19:33:44]: updating testbed package index (apt update)
326s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [126 kB]
327s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease
327s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease
327s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease
327s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [14.5 kB]
327s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [45.1 kB]
327s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [369 kB]
327s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el Packages [78.8 kB]
327s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el c-n-f Metadata [1884 B]
327s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted ppc64el c-n-f Metadata [120 B]
327s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe ppc64el Packages [320 kB]
327s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/universe ppc64el c-n-f Metadata [14.4 kB]
327s Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse ppc64el Packages [13.9 kB]
327s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse ppc64el c-n-f Metadata [484 B]
327s Fetched 984 kB in 1s (1095 kB/s)
328s Reading package lists...
329s Reading package lists...
329s Building dependency tree...
329s Reading state information...
329s Calculating upgrade...
329s Calculating upgrade...
330s The following NEW packages will be installed:
330s   bpftool linux-headers-6.14.0-10 linux-headers-6.14.0-10-generic
330s   linux-image-6.14.0-10-generic linux-modules-6.14.0-10-generic
330s   linux-modules-extra-6.14.0-10-generic linux-perf linux-tools-6.14.0-10
330s   linux-tools-6.14.0-10-generic
330s The following packages will be upgraded:
330s   cloud-init cloud-init-base libmm-glib0 libpython3.13 libpython3.13-minimal
330s   libpython3.13-stdlib linux-generic linux-headers-generic
330s   linux-headers-virtual linux-image-generic linux-image-virtual linux-libc-dev
330s   linux-tools-common linux-virtual pinentry-curses python3-jinja2 python3.13
330s   python3.13-gdbm python3.13-minimal strace
330s 20 upgraded, 9 newly installed, 0 to remove and 0 not upgraded.
330s Need to get 241 MB of archives.
330s After this operation, 339 MB of additional disk space will be used.
330s Get:1 http://ftpmaster.internal/ubuntu plucky/main ppc64el python3.13 ppc64el 3.13.2-2 [735 kB]
330s Get:2 http://ftpmaster.internal/ubuntu plucky/main ppc64el python3.13-minimal ppc64el 3.13.2-2 [2503 kB]
330s Get:3 http://ftpmaster.internal/ubuntu plucky/main ppc64el libpython3.13 ppc64el 3.13.2-2 [2534 kB]
330s Get:4 http://ftpmaster.internal/ubuntu plucky/main ppc64el libpython3.13-stdlib ppc64el 3.13.2-2 [2109 kB]
331s Get:5 http://ftpmaster.internal/ubuntu plucky/main ppc64el libpython3.13-minimal ppc64el 3.13.2-2 [885 kB]
331s Get:6 http://ftpmaster.internal/ubuntu plucky/main ppc64el strace ppc64el 6.13+ds-1ubuntu1 [493 kB]
331s Get:7 http://ftpmaster.internal/ubuntu plucky/main ppc64el linux-tools-common all 6.14.0-10.10 [295 kB]
331s Get:8 http://ftpmaster.internal/ubuntu plucky/main ppc64el bpftool ppc64el 7.6.0+6.14.0-10.10 [1177 kB]
331s Get:9 http://ftpmaster.internal/ubuntu plucky/main ppc64el python3-jinja2 all 3.1.5-2ubuntu1 [109 kB]
331s Get:10 http://ftpmaster.internal/ubuntu plucky/main ppc64el cloud-init-base all 25.1-0ubuntu3 [616 kB]
331s Get:11 http://ftpmaster.internal/ubuntu plucky/main ppc64el libmm-glib0 ppc64el 1.23.4-0ubuntu3 [278 kB]
331s Get:12 http://ftpmaster.internal/ubuntu plucky/main ppc64el linux-modules-6.14.0-10-generic ppc64el 6.14.0-10.10 [33.8 MB]
332s Get:13 http://ftpmaster.internal/ubuntu plucky/main ppc64el linux-image-6.14.0-10-generic ppc64el 6.14.0-10.10 [64.1 MB]
333s Get:14 http://ftpmaster.internal/ubuntu plucky/main ppc64el linux-modules-extra-6.14.0-10-generic ppc64el 6.14.0-10.10 [107 MB]
336s Get:15 http://ftpmaster.internal/ubuntu plucky/main ppc64el linux-generic ppc64el 6.14.0-10.10 [1736 B]
336s Get:16 http://ftpmaster.internal/ubuntu plucky/main ppc64el linux-image-generic ppc64el 6.14.0-10.10 [11.1 kB]
336s Get:17 http://ftpmaster.internal/ubuntu plucky/main ppc64el linux-virtual ppc64el 6.14.0-10.10 [1722 B]
336s Get:18 http://ftpmaster.internal/ubuntu plucky/main ppc64el linux-image-virtual ppc64el 6.14.0-10.10 [11.1 kB]
336s Get:19 http://ftpmaster.internal/ubuntu plucky/main ppc64el linux-headers-virtual ppc64el 6.14.0-10.10 [1646 B]
336s Get:20 http://ftpmaster.internal/ubuntu plucky/main ppc64el linux-headers-6.14.0-10 all 6.14.0-10.10 [14.2 MB]
336s Get:21 http://ftpmaster.internal/ubuntu plucky/main ppc64el linux-headers-6.14.0-10-generic ppc64el 6.14.0-10.10 [4074 kB]
336s Get:22 http://ftpmaster.internal/ubuntu plucky/main ppc64el linux-headers-generic ppc64el 6.14.0-10.10 [11.0 kB]
336s Get:23 http://ftpmaster.internal/ubuntu plucky/main ppc64el linux-libc-dev ppc64el 6.14.0-10.10 [1710 kB]
337s Get:24 http://ftpmaster.internal/ubuntu plucky/main ppc64el linux-perf ppc64el 6.14.0-10.10 [2552 kB]
337s Get:25 http://ftpmaster.internal/ubuntu plucky/main ppc64el linux-tools-6.14.0-10 ppc64el 6.14.0-10.10 [1267 kB]
337s Get:26 http://ftpmaster.internal/ubuntu plucky/main ppc64el linux-tools-6.14.0-10-generic ppc64el 6.14.0-10.10 [830 B]
337s Get:27 http://ftpmaster.internal/ubuntu plucky/main ppc64el pinentry-curses ppc64el 1.3.1-2ubuntu3 [44.3 kB]
337s Get:28 http://ftpmaster.internal/ubuntu plucky/main ppc64el python3.13-gdbm ppc64el 3.13.2-2 [32.2 kB]
337s Get:29 http://ftpmaster.internal/ubuntu plucky/main ppc64el cloud-init all 25.1-0ubuntu3 [2100 B]
337s Preconfiguring packages ...
337s Fetched 241 MB in 7s (34.0 MB/s)
337s (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 ... 107193 files and directories currently installed.)
337s Preparing to unpack .../00-python3.13_3.13.2-2_ppc64el.deb ...
337s Unpacking python3.13 (3.13.2-2) over (3.13.2-1) ...
337s Preparing to unpack .../01-python3.13-minimal_3.13.2-2_ppc64el.deb ...
337s Unpacking python3.13-minimal (3.13.2-2) over (3.13.2-1) ...
337s Preparing to unpack .../02-libpython3.13_3.13.2-2_ppc64el.deb ...
337s Unpacking libpython3.13:ppc64el (3.13.2-2) over (3.13.2-1) ...
338s Preparing to unpack .../03-libpython3.13-stdlib_3.13.2-2_ppc64el.deb ...
338s Unpacking libpython3.13-stdlib:ppc64el (3.13.2-2) over (3.13.2-1) ...
338s Preparing to unpack .../04-libpython3.13-minimal_3.13.2-2_ppc64el.deb ...
338s Unpacking libpython3.13-minimal:ppc64el (3.13.2-2) over (3.13.2-1) ...
338s Preparing to unpack .../05-strace_6.13+ds-1ubuntu1_ppc64el.deb ...
338s Unpacking strace (6.13+ds-1ubuntu1) over (6.11-0ubuntu1) ...
338s Preparing to unpack .../06-linux-tools-common_6.14.0-10.10_all.deb ...
338s Unpacking linux-tools-common (6.14.0-10.10) over (6.14.0-7.7) ...
338s Selecting previously unselected package bpftool.
338s Preparing to unpack .../07-bpftool_7.6.0+6.14.0-10.10_ppc64el.deb ...
338s Unpacking bpftool (7.6.0+6.14.0-10.10) ...
338s Preparing to unpack .../08-python3-jinja2_3.1.5-2ubuntu1_all.deb ...
338s Unpacking python3-jinja2 (3.1.5-2ubuntu1) over (3.1.5-2) ...
338s Preparing to unpack .../09-cloud-init-base_25.1-0ubuntu3_all.deb ...
338s Unpacking cloud-init-base (25.1-0ubuntu3) over (25.1-0ubuntu2) ...
339s Preparing to unpack .../10-libmm-glib0_1.23.4-0ubuntu3_ppc64el.deb ...
339s Unpacking libmm-glib0:ppc64el (1.23.4-0ubuntu3) over (1.23.4-0ubuntu2) ...
339s Selecting previously unselected package linux-modules-6.14.0-10-generic.
339s Preparing to unpack .../11-linux-modules-6.14.0-10-generic_6.14.0-10.10_ppc64el.deb ...
339s Unpacking linux-modules-6.14.0-10-generic (6.14.0-10.10) ...
339s Selecting previously unselected package linux-image-6.14.0-10-generic.
339s Preparing to unpack .../12-linux-image-6.14.0-10-generic_6.14.0-10.10_ppc64el.deb ...
339s Unpacking linux-image-6.14.0-10-generic (6.14.0-10.10) ...
339s Selecting previously unselected package linux-modules-extra-6.14.0-10-generic.
339s Preparing to unpack .../13-linux-modules-extra-6.14.0-10-generic_6.14.0-10.10_ppc64el.deb ...
339s Unpacking linux-modules-extra-6.14.0-10-generic (6.14.0-10.10) ...
340s Preparing to unpack .../14-linux-generic_6.14.0-10.10_ppc64el.deb ...
340s Unpacking linux-generic (6.14.0-10.10) over (6.14.0-7.7+1) ...
340s Preparing to unpack .../15-linux-image-generic_6.14.0-10.10_ppc64el.deb ...
340s Unpacking linux-image-generic (6.14.0-10.10) over (6.14.0-7.7+1) ...
340s Preparing to unpack .../16-linux-virtual_6.14.0-10.10_ppc64el.deb ...
340s Unpacking linux-virtual (6.14.0-10.10) over (6.14.0-7.7+1) ...
340s Preparing to unpack .../17-linux-image-virtual_6.14.0-10.10_ppc64el.deb ...
340s Unpacking linux-image-virtual (6.14.0-10.10) over (6.14.0-7.7+1) ...
340s Preparing to unpack .../18-linux-headers-virtual_6.14.0-10.10_ppc64el.deb ...
340s Unpacking linux-headers-virtual (6.14.0-10.10) over (6.14.0-7.7+1) ...
340s Selecting previously unselected package linux-headers-6.14.0-10.
340s Preparing to unpack .../19-linux-headers-6.14.0-10_6.14.0-10.10_all.deb ...
340s Unpacking linux-headers-6.14.0-10 (6.14.0-10.10) ...
343s Selecting previously unselected package linux-headers-6.14.0-10-generic.
343s Preparing to unpack .../20-linux-headers-6.14.0-10-generic_6.14.0-10.10_ppc64el.deb ...
343s Unpacking linux-headers-6.14.0-10-generic (6.14.0-10.10) ...
344s Preparing to unpack .../21-linux-headers-generic_6.14.0-10.10_ppc64el.deb ...
344s Unpacking linux-headers-generic (6.14.0-10.10) over (6.14.0-7.7+1) ...
344s Preparing to unpack .../22-linux-libc-dev_6.14.0-10.10_ppc64el.deb ...
344s Unpacking linux-libc-dev:ppc64el (6.14.0-10.10) over (6.14.0-7.7) ...
344s Selecting previously unselected package linux-perf.
344s Preparing to unpack .../23-linux-perf_6.14.0-10.10_ppc64el.deb ...
344s Unpacking linux-perf (6.14.0-10.10) ...
344s Selecting previously unselected package linux-tools-6.14.0-10.
344s Preparing to unpack .../24-linux-tools-6.14.0-10_6.14.0-10.10_ppc64el.deb ...
344s Unpacking linux-tools-6.14.0-10 (6.14.0-10.10) ...
344s Selecting previously unselected package linux-tools-6.14.0-10-generic.
344s Preparing to unpack .../25-linux-tools-6.14.0-10-generic_6.14.0-10.10_ppc64el.deb ...
344s Unpacking linux-tools-6.14.0-10-generic (6.14.0-10.10) ...
344s Preparing to unpack .../26-pinentry-curses_1.3.1-2ubuntu3_ppc64el.deb ...
344s Unpacking pinentry-curses (1.3.1-2ubuntu3) over (1.3.1-2ubuntu2) ...
344s Preparing to unpack .../27-python3.13-gdbm_3.13.2-2_ppc64el.deb ...
344s Unpacking python3.13-gdbm (3.13.2-2) over (3.13.2-1) ...
344s Preparing to unpack .../28-cloud-init_25.1-0ubuntu3_all.deb ...
344s Unpacking cloud-init (25.1-0ubuntu3) over (25.1-0ubuntu2) ...
344s Setting up linux-headers-6.14.0-10 (6.14.0-10.10) ...
344s Setting up pinentry-curses (1.3.1-2ubuntu3) ...
344s Setting up linux-headers-6.14.0-10-generic (6.14.0-10.10) ...
344s Setting up bpftool (7.6.0+6.14.0-10.10) ...
344s Setting up linux-libc-dev:ppc64el (6.14.0-10.10) ...
344s Setting up linux-headers-generic (6.14.0-10.10) ...
344s Setting up libpython3.13-minimal:ppc64el (3.13.2-2) ...
344s Setting up python3-jinja2 (3.1.5-2ubuntu1) ...
345s Setting up strace (6.13+ds-1ubuntu1) ...
345s Setting up linux-modules-6.14.0-10-generic (6.14.0-10.10) ...
346s Setting up libmm-glib0:ppc64el (1.23.4-0ubuntu3) ...
346s Setting up python3.13-minimal (3.13.2-2) ...
347s Setting up linux-tools-common (6.14.0-10.10) ...
347s Setting up libpython3.13-stdlib:ppc64el (3.13.2-2) ...
347s Setting up python3.13-gdbm (3.13.2-2) ...
347s Setting up libpython3.13:ppc64el (3.13.2-2) ...
347s Setting up linux-tools-6.14.0-10 (6.14.0-10.10) ...
347s Setting up linux-headers-virtual (6.14.0-10.10) ...
347s Setting up python3.13 (3.13.2-2) ...
348s Setting up linux-image-6.14.0-10-generic (6.14.0-10.10) ...
350s I: /boot/vmlinux.old is now a symlink to vmlinux-6.14.0-7-generic
350s I: /boot/initrd.img.old is now a symlink to initrd.img-6.14.0-7-generic
350s I: /boot/vmlinux is now a symlink to vmlinux-6.14.0-10-generic
350s I: /boot/initrd.img is now a symlink to initrd.img-6.14.0-10-generic
350s Setting up cloud-init-base (25.1-0ubuntu3) ...
352s Setting up linux-modules-extra-6.14.0-10-generic (6.14.0-10.10) ...
354s Setting up linux-perf (6.14.0-10.10) ...
354s Setting up linux-tools-6.14.0-10-generic (6.14.0-10.10) ...
354s Setting up linux-image-virtual (6.14.0-10.10) ...
354s Setting up linux-image-generic (6.14.0-10.10) ...
354s Setting up cloud-init (25.1-0ubuntu3) ...
354s Setting up linux-generic (6.14.0-10.10) ...
354s Setting up linux-virtual (6.14.0-10.10) ...
354s Processing triggers for rsyslog (8.2412.0-2ubuntu2) ...
354s Processing triggers for systemd (257.3-1ubuntu3) ...
354s Processing triggers for man-db (2.13.0-1) ...
356s Processing triggers for libc-bin (2.41-1ubuntu1) ...
356s Processing triggers for linux-image-6.14.0-10-generic (6.14.0-10.10) ...
356s /etc/kernel/postinst.d/initramfs-tools:
356s update-initramfs: Generating /boot/initrd.img-6.14.0-10-generic
356s W: No lz4 in /usr/bin:/sbin:/bin, using gzip
364s /etc/kernel/postinst.d/zz-update-grub:
364s Sourcing file `/etc/default/grub'
364s Sourcing file `/etc/default/grub.d/50-cloudimg-settings.cfg'
364s Generating grub configuration file ...
364s Found linux image: /boot/vmlinux-6.14.0-10-generic
364s Found initrd image: /boot/initrd.img-6.14.0-10-generic
364s Found linux image: /boot/vmlinux-6.14.0-7-generic
364s Found initrd image: /boot/initrd.img-6.14.0-7-generic
364s Found linux image: /boot/vmlinux-6.11.0-8-generic
364s Found initrd image: /boot/initrd.img-6.11.0-8-generic
365s Warning: os-prober will not be executed to detect other bootable partitions.
365s Systems on them will not be added to the GRUB boot configuration.
365s Check GRUB_DISABLE_OS_PROBER documentation entry.
365s Adding boot menu entry for UEFI Firmware Settings ...
365s done
365s Reading package lists...
365s Building dependency tree...
365s Reading state information...
365s Solving dependencies...
365s The following packages will be REMOVED:
365s   libnsl2* libpython3.12-minimal* libpython3.12-stdlib* libpython3.12t64*
365s   libunwind8* linux-headers-6.11.0-8* linux-headers-6.11.0-8-generic*
365s   linux-image-6.11.0-8-generic* linux-modules-6.11.0-8-generic*
365s   linux-modules-extra-6.14.0-7-generic* linux-tools-6.11.0-8*
365s   linux-tools-6.11.0-8-generic*
365s 0 upgraded, 0 newly installed, 12 to remove and 5 not upgraded.
365s After this operation, 363 MB disk space will be freed.
366s (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 ... 145124 files and directories currently installed.)
366s Removing linux-tools-6.11.0-8-generic (6.11.0-8.8) ...
366s Removing linux-tools-6.11.0-8 (6.11.0-8.8) ...
366s Removing libpython3.12t64:ppc64el (3.12.9-1) ...
366s Removing libpython3.12-stdlib:ppc64el (3.12.9-1) ...
366s Removing libnsl2:ppc64el (1.3.0-3build3) ...
366s Removing libpython3.12-minimal:ppc64el (3.12.9-1) ...
366s Removing libunwind8:ppc64el (1.6.2-3.1) ...
366s Removing linux-headers-6.11.0-8-generic (6.11.0-8.8) ...
366s Removing linux-headers-6.11.0-8 (6.11.0-8.8) ...
368s Removing linux-image-6.11.0-8-generic (6.11.0-8.8) ...
368s /etc/kernel/postrm.d/initramfs-tools:
368s update-initramfs: Deleting /boot/initrd.img-6.11.0-8-generic
368s /etc/kernel/postrm.d/zz-update-grub:
368s Sourcing file `/etc/default/grub'
368s Sourcing file `/etc/default/grub.d/50-cloudimg-settings.cfg'
368s Generating grub configuration file ...
369s Found linux image: /boot/vmlinux-6.14.0-10-generic
369s Found initrd image: /boot/initrd.img-6.14.0-10-generic
369s Found linux image: /boot/vmlinux-6.14.0-7-generic
369s Found initrd image: /boot/initrd.img-6.14.0-7-generic
369s Warning: os-prober will not be executed to detect other bootable partitions.
369s Systems on them will not be added to the GRUB boot configuration.
369s Check GRUB_DISABLE_OS_PROBER documentation entry.
369s Adding boot menu entry for UEFI Firmware Settings ...
369s done
369s Removing linux-modules-6.11.0-8-generic (6.11.0-8.8) ...
369s Removing linux-modules-extra-6.14.0-7-generic (6.14.0-7.7) ...
370s Processing triggers for libc-bin (2.41-1ubuntu1) ...
370s (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 ... 106967 files and directories currently installed.)
370s Purging configuration files for linux-image-6.11.0-8-generic (6.11.0-8.8) ...
370s Purging configuration files for libpython3.12-minimal:ppc64el (3.12.9-1) ...
370s Purging configuration files for linux-modules-extra-6.14.0-7-generic (6.14.0-7.7) ...
370s Purging configuration files for linux-modules-6.11.0-8-generic (6.11.0-8.8) ...
371s autopkgtest [19:34:29]: upgrading testbed (apt dist-upgrade and autopurge)
371s Reading package lists...
371s Building dependency tree...
371s Reading state information...
371s Calculating upgrade...Starting pkgProblemResolver with broken count: 0
371s Starting 2 pkgProblemResolver with broken count: 0
371s Done
372s Entering ResolveByKeep
372s 
372s Calculating upgrade...
372s The following packages will be upgraded:
372s   libc-bin libc-dev-bin libc6 libc6-dev locales
372s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
372s Need to get 10.3 MB of archives.
372s After this operation, 1024 B of additional disk space will be used.
372s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el libc6-dev ppc64el 2.41-1ubuntu2 [2046 kB]
373s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el libc-dev-bin ppc64el 2.41-1ubuntu2 [25.3 kB]
373s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el libc6 ppc64el 2.41-1ubuntu2 [3243 kB]
373s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el libc-bin ppc64el 2.41-1ubuntu2 [742 kB]
373s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el locales all 2.41-1ubuntu2 [4246 kB]
374s Preconfiguring packages ...
374s Fetched 10.3 MB in 2s (5614 kB/s)
374s (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 ... 106964 files and directories currently installed.)
374s Preparing to unpack .../libc6-dev_2.41-1ubuntu2_ppc64el.deb ...
374s Unpacking libc6-dev:ppc64el (2.41-1ubuntu2) over (2.41-1ubuntu1) ...
374s Preparing to unpack .../libc-dev-bin_2.41-1ubuntu2_ppc64el.deb ...
374s Unpacking libc-dev-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ...
374s Preparing to unpack .../libc6_2.41-1ubuntu2_ppc64el.deb ...
374s Unpacking libc6:ppc64el (2.41-1ubuntu2) over (2.41-1ubuntu1) ...
375s Setting up libc6:ppc64el (2.41-1ubuntu2) ...
375s (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 ... 106964 files and directories currently installed.)
375s Preparing to unpack .../libc-bin_2.41-1ubuntu2_ppc64el.deb ...
375s Unpacking libc-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ...
375s Setting up libc-bin (2.41-1ubuntu2) ...
375s (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 ... 106964 files and directories currently installed.)
375s Preparing to unpack .../locales_2.41-1ubuntu2_all.deb ...
375s Unpacking locales (2.41-1ubuntu2) over (2.41-1ubuntu1) ...
375s Setting up locales (2.41-1ubuntu2) ...
376s Generating locales (this might take a while)...
377s   en_US.UTF-8... done
377s Generation complete.
377s Setting up libc-dev-bin (2.41-1ubuntu2) ...
377s Setting up libc6-dev:ppc64el (2.41-1ubuntu2) ...
377s Processing triggers for man-db (2.13.0-1) ...
378s Processing triggers for systemd (257.3-1ubuntu3) ...
379s Reading package lists...
379s Building dependency tree...
379s Reading state information...
379s Starting pkgProblemResolver with broken count: 0
379s Starting 2 pkgProblemResolver with broken count: 0
379s Done
380s Solving dependencies...
380s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
380s autopkgtest [19:34:38]: rebooting testbed after setup commands that affected boot
414s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds...
425s Reading package lists...
425s Building dependency tree...
425s Reading state information...
425s Starting pkgProblemResolver with broken count: 0
425s Starting 2 pkgProblemResolver with broken count: 0
425s Done
426s The following NEW packages will be installed:
426s   cluster-glue liblrm2t64 libltdl7 libopenhpi3 libopenipmi0t64 libpils2t64
426s   libplumb2t64 libplumbgpl2t64 libsnmp-base libsnmp40t64 libstonith1t64
426s   libtimedate-perl
426s 0 upgraded, 12 newly installed, 0 to remove and 0 not upgraded.
426s Need to get 2660 kB of archives.
426s After this operation, 13.9 MB of additional disk space will be used.
426s Get:1 http://ftpmaster.internal/ubuntu plucky/main ppc64el libltdl7 ppc64el 2.5.4-4 [50.3 kB]
426s Get:2 http://ftpmaster.internal/ubuntu plucky/main ppc64el libpils2t64 ppc64el 1.0.12-24ubuntu2 [23.9 kB]
426s Get:3 http://ftpmaster.internal/ubuntu plucky/main ppc64el libplumb2t64 ppc64el 1.0.12-24ubuntu2 [94.6 kB]
426s Get:4 http://ftpmaster.internal/ubuntu plucky/main ppc64el liblrm2t64 ppc64el 1.0.12-24ubuntu2 [19.0 kB]
426s Get:5 http://ftpmaster.internal/ubuntu plucky/universe ppc64el libopenhpi3 ppc64el 3.8.0-2.3 [150 kB]
426s Get:6 http://ftpmaster.internal/ubuntu plucky/main ppc64el libopenipmi0t64 ppc64el 2.0.33-2 [597 kB]
427s Get:7 http://ftpmaster.internal/ubuntu plucky/main ppc64el libplumbgpl2t64 ppc64el 1.0.12-24ubuntu2 [10.2 kB]
427s Get:8 http://ftpmaster.internal/ubuntu plucky/main ppc64el libsnmp-base all 5.9.4+dfsg-1.1ubuntu7 [206 kB]
427s Get:9 http://ftpmaster.internal/ubuntu plucky/main ppc64el libsnmp40t64 ppc64el 5.9.4+dfsg-1.1ubuntu7 [1171 kB]
427s Get:10 http://ftpmaster.internal/ubuntu plucky/main ppc64el libstonith1t64 ppc64el 1.0.12-24ubuntu2 [15.8 kB]
427s Get:11 http://ftpmaster.internal/ubuntu plucky/main ppc64el libtimedate-perl all 2.3300-2 [34.0 kB]
427s Get:12 http://ftpmaster.internal/ubuntu plucky/universe ppc64el cluster-glue ppc64el 1.0.12-24ubuntu2 [288 kB]
427s Fetched 2660 kB in 1s (2426 kB/s)
427s Selecting previously unselected package libltdl7:ppc64el.
427s (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 ... 106964 files and directories currently installed.)
427s Preparing to unpack .../00-libltdl7_2.5.4-4_ppc64el.deb ...
427s Unpacking libltdl7:ppc64el (2.5.4-4) ...
427s Selecting previously unselected package libpils2t64.
427s Preparing to unpack .../01-libpils2t64_1.0.12-24ubuntu2_ppc64el.deb ...
427s Unpacking libpils2t64 (1.0.12-24ubuntu2) ...
427s Selecting previously unselected package libplumb2t64.
427s Preparing to unpack .../02-libplumb2t64_1.0.12-24ubuntu2_ppc64el.deb ...
427s Unpacking libplumb2t64 (1.0.12-24ubuntu2) ...
427s Selecting previously unselected package liblrm2t64.
427s Preparing to unpack .../03-liblrm2t64_1.0.12-24ubuntu2_ppc64el.deb ...
427s Unpacking liblrm2t64 (1.0.12-24ubuntu2) ...
427s Selecting previously unselected package libopenhpi3.
427s Preparing to unpack .../04-libopenhpi3_3.8.0-2.3_ppc64el.deb ...
427s Unpacking libopenhpi3 (3.8.0-2.3) ...
427s Selecting previously unselected package libopenipmi0t64:ppc64el.
427s Preparing to unpack .../05-libopenipmi0t64_2.0.33-2_ppc64el.deb ...
427s Unpacking libopenipmi0t64:ppc64el (2.0.33-2) ...
427s Selecting previously unselected package libplumbgpl2t64.
427s Preparing to unpack .../06-libplumbgpl2t64_1.0.12-24ubuntu2_ppc64el.deb ...
427s Unpacking libplumbgpl2t64 (1.0.12-24ubuntu2) ...
427s Selecting previously unselected package libsnmp-base.
427s Preparing to unpack .../07-libsnmp-base_5.9.4+dfsg-1.1ubuntu7_all.deb ...
427s Unpacking libsnmp-base (5.9.4+dfsg-1.1ubuntu7) ...
427s Selecting previously unselected package libsnmp40t64:ppc64el.
427s Preparing to unpack .../08-libsnmp40t64_5.9.4+dfsg-1.1ubuntu7_ppc64el.deb ...
427s Unpacking libsnmp40t64:ppc64el (5.9.4+dfsg-1.1ubuntu7) ...
428s Selecting previously unselected package libstonith1t64.
428s Preparing to unpack .../09-libstonith1t64_1.0.12-24ubuntu2_ppc64el.deb ...
428s Unpacking libstonith1t64 (1.0.12-24ubuntu2) ...
428s Selecting previously unselected package libtimedate-perl.
428s Preparing to unpack .../10-libtimedate-perl_2.3300-2_all.deb ...
428s Unpacking libtimedate-perl (2.3300-2) ...
428s Selecting previously unselected package cluster-glue.
428s Preparing to unpack .../11-cluster-glue_1.0.12-24ubuntu2_ppc64el.deb ...
428s Unpacking cluster-glue (1.0.12-24ubuntu2) ...
428s Setting up libsnmp-base (5.9.4+dfsg-1.1ubuntu7) ...
428s Setting up libopenipmi0t64:ppc64el (2.0.33-2) ...
428s Setting up libplumbgpl2t64 (1.0.12-24ubuntu2) ...
428s Setting up libltdl7:ppc64el (2.5.4-4) ...
428s Setting up libtimedate-perl (2.3300-2) ...
428s Setting up libopenhpi3 (3.8.0-2.3) ...
428s Setting up libpils2t64 (1.0.12-24ubuntu2) ...
428s Setting up libplumb2t64 (1.0.12-24ubuntu2) ...
428s Setting up libsnmp40t64:ppc64el (5.9.4+dfsg-1.1ubuntu7) ...
428s Setting up liblrm2t64 (1.0.12-24ubuntu2) ...
428s Setting up libstonith1t64 (1.0.12-24ubuntu2) ...
428s Setting up cluster-glue (1.0.12-24ubuntu2) ...
428s info: Selecting GID from range 100 to 999 ...
428s info: Adding group `haclient' (GID 108) ...
428s info: The home dir /var/lib/pacemaker you specified can't be accessed: No such file or directory
428s 
428s info: Selecting UID from range 100 to 999 ...
428s 
428s info: Adding system user `hacluster' (UID 107) ...
428s info: Adding new user `hacluster' (UID 107) with group `haclient' ...
428s info: Not creating home directory `/var/lib/pacemaker'.
428s Created symlink '/etc/systemd/system/multi-user.target.wants/logd.service' → '/usr/lib/systemd/system/logd.service'.
429s Processing triggers for man-db (2.13.0-1) ...
429s Processing triggers for libc-bin (2.41-1ubuntu2) ...
434s autopkgtest [19:35:32]: test stonith-null: [-----------------------
435s === list ===
435s apcmaster
435s apcmastersnmp
435s apcsmart
435s baytech
435s bladehpi
435s cyclades
435s drac3
435s external/drac5
435s external/dracmc-telnet
435s external/ec2
435s external/hetzner
435s external/hmchttp
435s external/ibmrsa
435s external/ibmrsa-telnet
435s external/ipmi
435s external/ippower9258
435s external/kdumpcheck
435s external/libvirt
435s external/nut
435s external/rackpdu
435s external/riloe
435s external/ssh
435s external/vcenter
435s external/vmware
435s external/xen0
435s external/xen0-ha
435s ibmhmc
435s ipmilan
435s meatware
435s null
435s nw_rpc100s
435s rcd_serial
435s rps10
435s ssh
435s suicide
435s wti_mpc
435s wti_nps
435s 
435s === metadata ===
435s <?xml version="1.0"?>
435s <!DOCTYPE resource-agent SYSTEM "ra-api-1.dtd">
435s <resource-agent name="null">
435s <version>1.0</version>
435s <longdesc lang="en">
435s Dummy (do-nothing) STONITH device
435s FOR TESTING ONLY!
435s </longdesc>
435s <shortdesc lang="en">NULL STONITH device</shortdesc>
435s <parameters><parameter name="hostlist" unique="0" required="1"><content type="string" />
435s <shortdesc lang="en">
435s Hostlist</shortdesc>
435s <longdesc lang="en">
435s The list of hosts that the STONITH device controls</longdesc>
435s </parameter>
435s </parameters>
435s <actions>
435s <action name="start"   timeout="20" />
435s <action name="stop"    timeout="15" />
435s <action name="status"  timeout="20" />
435s <action name="monitor" timeout="20" interval="3600" />
435s <action name="meta-data"  timeout="15" />
435s </actions>
435s <special tag="heartbeat">
435s <version>2.0</version>
435s </special>
435s </resource-agent>
435s 
435s === status ===
435s Mar 15 19:35:33 autopkgtest stonith: [1626]: debug: null device OK.
435s autopkgtest
435s 
435s === reset ===
435s Mar 15 19:35:33 autopkgtest stonith: [1627]: info: Host null-reset: autopkgtest
435s autopkgtest [19:35:33]: test stonith-null: -----------------------]
436s autopkgtest [19:35:34]: test stonith-null:  - - - - - - - - - - results - - - - - - - - - -
436s stonith-null         PASS
436s autopkgtest [19:35:34]: test stonith-suicide: preparing testbed
436s Reading package lists...
436s Building dependency tree...
436s Reading state information...
436s Starting pkgProblemResolver with broken count: 0
436s Starting 2 pkgProblemResolver with broken count: 0
436s Done
437s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
438s autopkgtest [19:35:35]: test stonith-suicide: [-----------------------
438s === list ===
438s apcmaster
438s apcmastersnmp
438s apcsmart
438s baytech
438s bladehpi
438s cyclades
438s drac3
438s external/drac5
438s external/dracmc-telnet
438s external/ec2
438s external/hetzner
438s external/hmchttp
438s external/ibmrsa
438s external/ibmrsa-telnet
438s external/ipmi
438s external/ippower9258
438s external/kdumpcheck
438s external/libvirt
438s external/nut
438s external/rackpdu
438s external/riloe
438s external/ssh
438s external/vcenter
438s external/vmware
438s external/xen0
438s external/xen0-ha
438s ibmhmc
438s ipmilan
438s meatware
438s null
438s nw_rpc100s
438s rcd_serial
438s rps10
438s ssh
438s suicide
438s wti_mpc
438s wti_nps
438s 
438s === metadata ===
438s <?xml version="1.0"?>
438s <!DOCTYPE resource-agent SYSTEM "ra-api-1.dtd">
438s <resource-agent name="suicide">
438s <version>1.0</version>
438s <longdesc lang="en">
438s Virtual device to reboot/powerdown itself.
438s 
438s </longdesc>
438s <shortdesc lang="en">Suicide STONITH device</shortdesc>
438s <parameters></parameters>
438s <actions>
438s <action name="start"   timeout="20" />
438s <action name="stop"    timeout="15" />
438s <action name="status"  timeout="20" />
438s <action name="monitor" timeout="20" interval="3600" />
438s <action name="meta-data"  timeout="15" />
438s </actions>
438s <special tag="heartbeat">
438s <version>2.0</version>
438s </special>
438s </resource-agent>
438s 
438s === status ===
438s Mar 15 19:35:36 autopkgtest stonith: [1780]: debug: suicide device OK.
438s autopkgtest
438s 
438s === reset ===
438s Killed
438s autopkgtest [19:35:36]: test process requested preparation for reboot with marker fenced
438s autopkgtest-virt-ssh [19:35:36]: state saved, waiting for testbed to reboot...
744s nova [W] Using flock in prodstack6-ppc64el
744s Creating nova instance adt-plucky-ppc64el-cluster-glue-20250315-185039-juju-7f2275-prod-proposed-migration-environment-2-d746fd76-5d61-4272-bb8d-b878e0d712bb from image adt/ubuntu-plucky-ppc64el-server-20250314.img (UUID 0d1e0e85-c651-4838-b55c-eb9eeda2180e)...
744s nova [W] Timed out waiting for 12c02581-bf28-4b73-a02d-231f1075a703 to get deleted.
744s nova [W] Using flock in prodstack6-ppc64el
744s Creating nova instance adt-plucky-ppc64el-cluster-glue-20250315-185039-juju-7f2275-prod-proposed-migration-environment-2-d746fd76-5d61-4272-bb8d-b878e0d712bb from image adt/ubuntu-plucky-ppc64el-server-20250314.img (UUID 0d1e0e85-c651-4838-b55c-eb9eeda2180e)...
744s ------- nova console-log bd17a101-5efc-4e28-b5ae-9b5f6bb19ca7 (adt-plucky-ppc64el-cluster-glue-20250315-185039-juju-7f2275-prod-proposed-migration-environment-2-d746fd76-5d61-4272-bb8d-b878e0d712bb) ------
744s vice...
744s          Starting [0;1;39msystemd-journald.service[0m - Journal Service...
744s [    2.728957] systemd[1]: Starting keyboard-setup.service - Set the console keyboard layout...
744s          Starting [0;1;39mkeyboard-setup.service[0m - Set the console keyboard layout...
744s [    2.731060] systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes...
744s          Starting [0;1;39mkmod-static-nodes.service[0m���eate List of Static Device Nodes...
744s [    2.732750] systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs...
744s          Starting [0;1;39mmodprobe@configfs.service[0m - Load Kernel Module configfs...
744s [    2.734996] systemd[1]: Starting modprobe@dm_multipath.service - Load Kernel Module dm_multipath...
744s          Starting [0;1;39mmodprobe@dm_multipath.ser���[0m Load Kernel Module dm_multipath...
744s [    2.737192] systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm...
744s          Starting [0;1;39mmodprobe@drm.service[0m - Load Kernel Module drm...
744s [    2.745116] systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
744s          Starting [0;1;39mmodprobe@efi_pstore.servi���[0m - Load Kernel Module efi_pstore...
744s [    2.749259] systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse...
744s          Starting [0;1;39mmodprobe@fuse.service[0m - Load Kernel Module fuse...
744s [    2.749611] systemd[1]: netplan-ovs-cleanup.service - OpenVSwitch configuration for cleanup was skipped because of an unmet condition check (ConditionFileIsExecutable=/usr/bin/ovs-vsctl).
744s [    2.749830] 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).
744s [    2.749951] 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).
744s [    2.767756] systemd-journald[263]: Collecting audit messages is disabled.
744s [    2.781384] systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules...
744s          Starting [0;1;39msystemd-modules-load.service[0m - Load Kernel Modules...
744s [    2.785192] systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems...
744s          Starting [0;1;39msystemd-remount-fs.servic���[0munt Root and Kernel File Systems...
744s [    2.788206] systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials...
744s          Starting [0;1;39msystemd-udev-load-credent���[0mLoad udev Rules from Credentials...
744s [    2.793175] systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices...
744s          Starting [0;1;39msystemd-udev-trigger.service[0m - Coldplug All udev Devices...
744s [    2.807168] systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System.
744s [[0;32m  OK  [0m] Mounted [0;1;39mdev-hugepages.mount[0m - Huge Pages File System.
744s [    2.807599] systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System.
744s [[0;32m  OK  [0m] Mounted [0;1;39mdev-mqueue.mount[0m - POSIX Message Queue File System.
744s [    2.807966] systemd[1]: Mounted run-lock.mount - Legacy Locks Directory /run/lock.
744s [[0;32m  OK  [0m] Mounted [0;1;39mrun-lock.mount[0m - Legacy Locks Directory /run/lock.
744s [    2.808310] systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System.
744s [[0;32m  OK  [0m] Mounted [0;1;39msys-kernel-debug.mount[0m - Kernel Debug File System.
744s [    2.808651] systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System.
744s [[0;32m  OK  [0m] Mounted [0;1;39msys-kernel-tracing.mount[0m - Kernel Trace File System.
744s [    2.813217] systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes.
744s [[0;32m  OK  [0m] Finished [0;1;39mkmod-static-nodes.service[0m���Create List of Static Device Nodes.
744s [    2.814563] systemd[1]: modprobe@configfs.service: Deactivated successfully.
744s [    2.814890] systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs.
744s [[0;32m  OK  [0m] Finished [0;1;39mmodprobe@configfs.service[0m - Load Kernel Module configfs.
744s [    2.815615] systemd[1]: modprobe@drm.service: Deactivated successfully.
744s [    2.815953] systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm.
744s [[0;32m  OK  [0m] Finished [0;1;39mmodprobe@drm.service[0m - Load Kernel Module drm.
744s [    2.816591] systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
744s [    2.816924] systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
744s [[0;32m  OK  [0m] Finished [0;1;39mmodprobe@efi_pstore.service[0m - Load Kernel Module efi_pstore.
744s [    2.818309] systemd[1]: modprobe@dm_multipath.service: Deactivated successfully.
744s [    2.818627] systemd[1]: Finished modprobe@dm_multipath.service - Load Kernel Module dm_multipath.
744s [[0;32m  OK  [0m] Finished [0;1;39mmodprobe@dm_multipath.ser���[0m - Load Kernel Module dm_multipath.
744s [    2.819499] systemd[1]: Started systemd-journald.service - Journal Service.
744s [[0;32m  OK  [0m] Started [0;1;39msystemd-journald.service[0m - Journal Service.
744s [[0;32m  OK  [0m] Finished [0;1;39mmodprobe@fuse.service[0m - Load Kernel Module fuse.
744s [[0;32m  OK  [0m] Finished [0;1;39msystemd-modules-load.service[0m - Load Kernel Modules.
744s          Mounting [0;1;39msys-fs-fuse-connections.mount[0m - FUSE Control File System...
744s          Mounting [0;1;39msys-kernel-config.mount[0m - Kernel Configuration File System...
744s [    2.848845] EXT4-fs (vda1): re-mounted cc18d838-3721-4f67-b9bc-edb63f4f5973 r/w. Quota mode: none.
744s          Starting [0;1;39msystemd-sysctl.service[0m - Apply Kernel Variables...
744s          Starting [0;1;39msystemd-tmpfiles-setup-de���[0m Device Nodes in /dev gracefully...
744s [[0;32m  OK  [0m] Finished [0;1;39mkeyboard-setup.service[0m - Set the console keyboard layout.
744s [[0;32m  OK  [0m] Finished [0;1;39msystemd-remount-fs.servic���[0mmount Root and Kernel File Systems.
744s [[0;32m  OK  [0m] Finished [0;1;39msystemd-udev-load-credent���[0m- Load udev Rules from Credentials.
744s [[0;32m  OK  [0m] Mounted [0;1;39msys-fs-fuse-connections.mount[0m - FUSE Control File System.
744s [[0;32m  OK  [0m] Mounted [0;1;39msys-kernel-config.mount[0m - Kernel Configuration File System.
744s          Starting [0;1;39mmultipathd.service[0m - Devi���pper Multipath Device Controller...
744s          Starting [0;1;39mcloud-init-main.service[0m - Cloud-init: Single Process...
744s          Starting [0;1;39msystemd-journal-flush.ser���[0msh Journal to Persistent Storage...
744s          Starting [0;1;39msystemd-random-seed.service[0m - Load/Save OS Random Seed...
744s [[0;32m  OK  [0m] Started [0;1;39mmultipathd.service[0m - Devic���Mapper Multipath Device Controller.
744s [    2.935343] systemd-journald[263]: Received client request to flush runtime journal.
744s [[0;32m  OK  [0m] Finished [0;1;39msystemd-sysctl.service[0m - Apply Kernel Variables.
744s [[0;32m  OK  [0m] Finished [0;1;39msystemd-udev-trigger.service[0m - Coldplug All udev Devices.
744s [[0;32m  OK  [0m] Finished [0;1;39msystemd-tmpfiles-setup-de���[0mic Device Nodes in /dev gracefully.
744s          Starting [0;1;39msystemd-resolved.service[0m - Network Name Resolution...
744s          Starting [0;1;39msystemd-timesyncd.service[0m - Network Time Synchronization...
744s          Starting [0;1;39msystemd-tmpfiles-setup-de���[0meate Static Device Nodes in /dev...
744s [[0;32m  OK  [0m] Finished [0;1;39msystemd-journal-flush.ser���[0mlush Journal to Persistent Storage.
744s [[0;32m  OK  [0m] Finished [0;1;39msystemd-random-seed.service[0m - Load/Save OS Random Seed.
744s [[0;32m  OK  [0m] Finished [0;1;39msystemd-tmpfiles-setup-de���[0mCreate Static Device Nodes in /dev.
744s [[0;32m  OK  [0m] Reached target [0;1;39mlocal-fs-pre.target[0m���Preparation for Local File Systems.
744s [[0;32m  OK  [0m] Reached target [0;1;39mlocal-fs.target[0m - Local File Systems.
744s [[0;32m  OK  [0m] Listening on [0;1;39msystemd-sysext.socket[0m��� System Extension Image Management.
744s          Starting [0;1;39mapparmor.service[0m - Load AppArmor profiles...
744s          Starting [0;1;39mconsole-setup.service[0m - Set console font and keymap...
744s          Starting [0;1;39mplymouth-read-write.servi���[0mymouth To Write Out Runtime Data...
744s          Starting [0;1;39msystemd-binfmt.service[0m - Set Up Additional Binary Formats...
744s          Starting [0;1;39msystemd-tmpfiles-setup.se���[0mate System Files and Directories...
744s          Starting [0;1;39msystemd-udevd.service[0m - R���ager for Device Events and Files...
744s          Starting [0;1;39mufw.service[0m - Uncomplicated firewall...
744s [[0;32m  OK  [0m] Finished [0;1;39mplymouth-read-write.servi���[0mPlymouth To Write Out Runtime Data.
744s [[0;32m  OK  [0m] Finished [0;1;39mconsole-setup.service[0m - Set console font and keymap.
744s [[0;32m  OK  [0m] Finished [0;1;39mufw.service[0m - Uncomplicated firewall.
744s [[0;32m  OK  [0m] Started [0;1;39msystemd-timesyncd.service[0m - Network Time Synchronization.
744s [[0;32m  OK  [0m] Reached target [0;1;39mtime-set.target[0m - System Time Set.
744s [[0;32m  OK  [0m] Finished [0;1;39msystemd-tmpfiles-setup.se���[0mreate System Files and Directories.
744s [[0;32m  OK  [0m] Started [0;1;39msystemd-resolved.service[0m - Network Name Resolution.
744s [[0;32m  OK  [0m] Reached target [0;1;39mnss-lookup.target[0m - Host and Network Name Lookups.
744s [[0;32m  OK  [0m] Started [0;1;39msystemd-udevd.service[0m - Ru���anager for Device Events and Files.
744s [[0;32m  OK  [0m] Started [0;1;39msystemd-ask-password-conso���[0mequests to Console Directory Watch.
744s [[0;32m  OK  [0m] Reached target [0;1;39mcryptsetup.target[0m - Local Encrypted Volumes.
744s [[0;32m  OK  [0m] Found device [0;1;39mdev-hvc0.device[0m - /dev/hvc0.
744s [[0;32m  OK  [0m] Finished [0;1;39mapparmor.service[0m - Load AppArmor profiles.
744s          Mounting [0;1;39mproc-sys-fs-binfmt_misc.m���[0mcutable File Formats File System...
744s [[0;32m  OK  [0m] Started [0;1;39mcloud-init-main.service[0m - Cloud-init: Single Process.
744s          Starting [0;1;39mcloud-init-local.service[0m ���-init: Local Stage (pre-network)...
744s [[0;32m  OK  [0m] Mounted [0;1;39mproc-sys-fs-binfmt_misc.mo���[0mxecutable File Formats File System.
744s [[0;32m  OK  [0m] Finished [0;1;39msystemd-binfmt.service[0m - Set Up Additional Binary Formats.
744s [[0;32m  OK  [0m] Listening on [0;1;39msystemd-rfkill.socket[0m���ll Switch Status /dev/rfkill Watch.
744s [    3.922882] cloud-init[704]: Cloud-init v. 25.1-0ubuntu2 running 'init-local' at Sat, 15 Mar 2025 19:33:16 +0000. Up 3.90 seconds.
744s [   17.188205] sh[684]: Completed socket interaction for boot stage local
744s [[0;32m  OK  [0m] Finished [0;1;39mcloud-init-local.service[0m ���ud-init: Local Stage (pre-network).
744s [[0;32m  OK  [0m] Reached target [0;1;39mnetwork-pre.target[0m - Preparation for Network.
744s          Starting [0;1;39mcloud-init-network.service[0m - Cloud-init: Network Stage...
744s          Starting [0;1;39msystemd-networkd.service[0m - Network Configuration...
744s [   17.239673] cloud-init[704]: Cloud-init v. 25.1-0ubuntu2 running 'init' at Sat, 15 Mar 2025 19:33:29 +0000. Up 17.22 seconds.
744s [   17.251426] cloud-init[704]: ci-info: +++++++++++++++++++++++++++Net device info++++++++++++++++++++++++++++
744s [   17.251753] cloud-init[704]: ci-info: +--------+-------+-----------+-----------+-------+-------------------+
744s [   17.252160] cloud-init[704]: ci-info: | Device |   Up  |  Address  |    Mask   | Scope |     Hw-Address    |
744s [   17.256069] cloud-init[704]: ci-info: +--------+-------+-----------+-----------+-------+-------------------+
744s [   17.256244] cloud-init[704]: ci-info: | enp0s1 | False |     .     |     .     |   .   | fa:16:3e:77:ca:89 |
744s [   17.256462] cloud-init[704]: ci-info: |   lo   |  True | 127.0.0.1 | 255.0.0.0 |  host |         .         |
744s [   17.256661] cloud-init[704]: ci-info: |   lo   |  True |  ::1/128  |     .     |  host |         .         |
744s [   17.256856] cloud-init[704]: ci-info: +--------+-------+-----------+-----------+-------+-------------------+
744s [   17.257048] cloud-init[704]: ci-info: +++++++++++++++++++Route IPv6 info+++++++++++++++++++
744s [   17.257216] cloud-init[704]: ci-info: +-------+-------------+---------+-----------+-------+
744s [   17.257385] cloud-init[704]: ci-info: | Route | Destination | Gateway | Interface | Flags |
744s [   17.257550] cloud-init[704]: ci-info: +-------+-------------+---------+-----------+-------+
744s [   17.257715] cloud-init[704]: ci-info: +-------+-------------+---------+-----------+-------+
744s [[0;32m  OK  [0m] Started [0;1;39msystemd-networkd.service[0m - Network Configuration.
744s [[0;32m  OK  [0m] Reached target [0;1;39mnetwork.target[0m - Network.
744s          Starting [0;1;39msystemd-networkd-persiste���[0mtent Storage in systemd-networkd...
744s          Starting [0;1;39msystemd-networkd-wait-onl���[0mait for Network to be Configured...
744s [   17.323859] cloud-init[704]: 2025-03-15 19:33:29,481 - 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.
744s [   17.324398] cloud-init[704]: 2025-03-15 19:33:29,482 - schema.py[WARNING]: cloud-config failed schema validation! You may run 'sudo cloud-init schema --system' to check the details.
744s [[0;32m  OK  [0m] Finished [0;1;39msystemd-networkd-persiste���[0mistent Storage in systemd-networkd.
744s [   17.678027] sh[798]: Completed socket interaction for boot stage network
744s [[0;32m  OK  [0m] Finished [0;1;39mcloud-init-network.service[0m - Cloud-init: Network Stage.
744s [[0;32m  OK  [0m] Reached target [0;1;39mcloud-config.target[0m - Cloud-config availability.
744s [[0;32m  OK  [0m] Reached target [0;1;39msysinit.target[0m - System Initialization.
744s [[0;32m  OK  [0m] Started [0;1;39mapt-daily.timer[0m - Daily apt download activities.
744s [[0;32m  OK  [0m] Started [0;1;39mapt-daily-upgrade.timer[0m - ���y apt upgrade and clean activities.
744s [[0;32m  OK  [0m] Started [0;1;39mdpkg-db-backup.timer[0m - Daily dpkg database backup timer.
744s [[0;32m  OK  [0m] Started [0;1;39me2scrub_all.timer[0m - Period���Metadata Check for All Filesystems.
744s [[0;32m  OK  [0m] Started [0;1;39mfstrim.timer[0m - Discard unused filesystem blocks once a week.
744s [[0;32m  OK  [0m] Started [0;1;39mfwupd-refresh.timer[0m - Refresh fwupd metadata regularly.
744s [[0;32m  OK  [0m] Started [0;1;39mlogrotate.timer[0m - Daily rotation of log files.
744s [[0;32m  OK  [0m] Started [0;1;39mman-db.timer[0m - Daily man-db regeneration.
744s [[0;32m  OK  [0m] Started [0;1;39mmotd-news.timer[0m - Message of the Day.
744s [[0;32m  OK  [0m] Started [0;1;39msysstat-collect.timer[0m - Ru���y accounting tool every 10 minutes.
744s [[0;32m  OK  [0m] Started [0;1;39msysstat-rotate.timer[0m - Rot���tem activity data file at midnight.
744s [[0;32m  OK  [0m] Started [0;1;39msysstat-summary.timer[0m - Ge��� of yesterday's process accounting.
744s [[0;32m  OK  [0m] Started [0;1;39msystemd-tmpfiles-clean.tim���[0my Cleanup of Temporary Directories.
744s [[0;32m  OK  [0m] Reached target [0;1;39mboot-complete.target[0m - Boot Completion Check.
744s [[0;32m  OK  [0m] Reached target [0;1;39mpaths.target[0m - Path Units.
744s [[0;32m  OK  [0m] Reached target [0;1;39mtimers.target[0m - Timer Units.
744s [[0;32m  OK  [0m] Listening on [0;1;39mcloud-init-hotplugd.s���t[0m - cloud-init hotplug hook socket.
744s [[0;32m  OK  [0m] Listening on [0;1;39mdbus.socket[0m - D-Bus System Message Bus Socket.
744s          Starting [0;1;39mlxd-installer.socket[0m - He���er to install lxd snap on demand...
744s [[0;32m  OK  [0m] Listening on [0;1;39mssh.socket[0m - OpenBSD Secure Shell server socket.
744s [[0;32m  OK  [0m] Listening on [0;1;39msshd-unix-local.socke���[0mtemd-ssh-generator, AF_UNIX Local).
744s [[0;32m  OK  [0m] Listening on [0;1;39msshd-vsock.socket[0m - O��� (systemd-ssh-generator, AF_VSOCK).
744s [[0;32m  OK  [0m] Reached target [0;1;39mssh-access.target[0m - SSH Access Available.
744s [[0;32m  OK  [0m] Listening on [0;1;39msystemd-hostnamed.socket[0m - Hostname Service Socket.
744s [[0;32m  OK  [0m] Listening on [0;1;39muuidd.socket[0m - UUID daemon activation socket.
744s [[0;32m  OK  [0m] Listening on [0;1;39mlxd-installer.socket[0m ���lper to install lxd snap on demand.
744s [[0;32m  OK  [0m] Reached target [0;1;39msockets.target[0m - Socket Units.
744s [[0;32m  OK  [0m] Reached target [0;1;39mbasic.target[0m - Basic System.
744s          Starting [0;1;39mapport.service[0m - automatic crash report generation...
744s [[0;32m  OK  [0m] Started [0;1;39mautopkgtest@hvc1.service[0m - autopkgtest root shell on hvc1.
744s [[0;32m  OK  [0m] Started [0;1;39mautopkgtest@ttyS1.service[0m - autopkgtest root shell on ttyS1.
744s [[0;32m  OK  [0m] Started [0;1;39mcron.service[0m - Regular background program processing daemon.
744s          Starting [0;1;39mdbus.service[0m - D-Bus System Message Bus...
744s [[0;32m  OK  [0m] Started [0;1;39mdmesg.service[0m - Save initial kernel messages after boot.
744s          Starting [0;1;39mdpkg-db-backup.service[0m - ���ily dpkg database backup service...
744s          Starting [0;1;39me2scrub_reap.service[0m - Re���ne ext4 Metadata Check Snapshots...
744s          Starting [0;1;39mgrub-common.service[0m - Record successful boot for GRUB...
744s          Starting [0;1;39miprdump.service[0m - IBM Power Raid dump daemon...
744s          Starting [0;1;39mrng-tools-debian.service[0m ���gatherer daemon (Debian variant)...
744s          Starting [0;1;39mrsyslog.service[0m - System Logging Service...
744s          Starting [0;1;39mrtas_errd.service[0m - ppc64���platform error handling) Service...
744s          Starting [0;1;39msysstat.service[0m - Resets System Activity Logs...
744s          Starting [0;1;39msystemd-logind.service[0m - User Login Management...
744s          Starting [0;1;39msystemd-user-sessions.service[0m - Permit User Sessions...
744s          Starting [0;1;39mudisks2.service[0m - Disk Manager...
744s [[0;32m  OK  [0m] Started [0;1;39miprdump.service[0m - IBM Power Raid dump daemon.
744s [[0;32m  OK  [0m] Finished [0;1;39msystemd-user-sessions.service[0m - Permit User Sessions.
744s          Starting [0;1;39miprinit.service[0m - IBM Power Raid init daemon...
744s          Starting [0;1;39miprupdate.service[0m - IBM Power Raid update daemon...
744s [[0;32m  OK  [0m] Started [0;1;39mrtas_errd.service[0m - ppc64-��� (platform error handling) Service.
744s [[0;32m  OK  [0m] Finished [0;1;39me2scrub_reap.service[0m - Re���line ext4 Metadata Check Snapshots.
744s [[0;32m  OK  [0m] Started [0;1;39miprupdate.service[0m - IBM Power Raid update daemon.
744s [[0;32m  OK  [0m] Started [0;1;39miprinit.service[0m - IBM Power Raid init daemon.
744s [[0;32m  OK  [0m] Reached target [0;1;39miprutils.target[0m - IBM Power Raid utilities.
744s [[0;32m  OK  [0m] Finished [0;1;39mgrub-common.service[0m - Record successful boot for GRUB.
744s          Starting [0;1;39mgrub-initrd-fallback.service[0m - GRUB failed boot detection...
744s [[0;32m  OK  [0m] Finished [0;1;39msysstat.service[0m - Resets System Activity Logs.
744s [[0;32m  OK  [0m] Started [0;1;39msystemd-logind.service[0m - User Login Management.
744s [[0;32m  OK  [0m] Started [0;1;39mdbus.service[0m - D-Bus System Message Bus.
744s [[0;32m  OK  [0m] Finished [0;1;39mdpkg-db-backup.service[0m - Daily dpkg database backup service.
744s [[0;32m  OK  [0m] Finished [0;1;39mgrub-initrd-fallback.service[0m - GRUB failed boot detection.
744s [[0;32m  OK  [0m] Started [0;1;39mudisks2.service[0m - Disk Manager.
744s [[0;32m  OK  [0m] Finished [0;1;39mapport.service[0m - automatic crash report generation.
744s [[0;32m  OK  [0m] Started [0;1;39mrsyslog.service[0m - System Logging Service.
744s [[0;32m  OK  [0m] Finished [0;1;39msystemd-networkd-wait-onl���[0m Wait for Network to be Configured.
744s [[0;32m  OK  [0m] Reached target [0;1;39mnetwork-online.target[0m - Network is Online.
744s          Starting [0;1;39mcloud-config.service[0m - Cloud-init: Config Stage...
744s          Starting [0;1;39mrc-local.service[0m - /etc/rc.local Compatibility...
744s          Starting [0;1;39mssh.service[0m - OpenBSD Secure Shell server...
744s [[0;32m  OK  [0m] Started [0;1;39mrc-local.service[0m - /etc/rc.local Compatibility.
744s          Starting [0;1;39mplymouth-quit-wait.servic���[0md until boot process finishes up...
744s          Starting [0;1;39mplymouth-quit.service[0m - Terminate Plymouth Boot Screen...
744s [[0;32m  OK  [0m] Started [0;1;39mssh.service[0m - OpenBSD Secure Shell server.
744s [[0;32m  OK  [0m] Finished [0;1;39mplymouth-quit-wait.servic���[0mold until boot process finishes up.
744s [[0;32m  OK  [0m] Started [0;1;39mserial-getty@hvc0.service[0m - Serial Getty on hvc0.
744s          Starting [0;1;39msetvtrgb.service[0m - Set console scheme...
744s [[0;32m  OK  [0m] Finished [0;1;39mplymouth-quit.service[0m - Terminate Plymouth Boot Screen.
744s [   18.600523] cloud-init[704]: Cloud-init v. 25.1-0ubuntu2 running 'modules:config' at Sat, 15 Mar 2025 19:33:30 +0000. Up 18.53 seconds.
744s [[0;32m  OK  [0m] Finished [0;1;39msetvtrgb.service[0m - Set console scheme.
744s [[0;32m  OK  [0m] Created slice [0;1;39msystem-getty.slice[0m - Slice /system/getty.
744s [[0;32m  OK  [0m] Started [0;1;39mgetty@tty1.service[0m - Getty on tty1.
744s [[0;32m  OK  [0m] Reached target [0;1;39mgetty.target[0m - Login Prompts.
744s [[0;32m  OK  [0m] Reached target [0;1;39mmulti-user.target[0m - Multi-User System.
744s [[0;32m  OK  [0m] Reached target [0;1;39mgraphical.target[0m - Graphical Interface.
744s [   18.619822] cloud-init[704]: 2025-03-15 19:33:30,777 - lifecycle.py[DEPRECATED]: The following config key(s): ['apt_mirror', 'apt_preserve_sources_list'] is deprecated in 22.1 and scheduled to be removed in 27.1.
744s [   18.620461] cloud-init[704]: 2025-03-15 19:33:30,777 - lifecycle.py[DEPRECATED]: Support for combined old and new apt module keys is deprecated in 22.1 and scheduled to be removed in 27.1.
744s [   18.635359] sh[1000]: Completed socket interaction for boot stage config
744s [[0;32m  OK  [0m] Finished [0;1;39mcloud-config.service[0m - Cloud-init: Config Stage.
744s          Starting [0;1;39mcloud-final.service[0m - Cloud-init: Final Stage...
744s [   18.714708] cloud-init[704]: Cloud-init v. 25.1-0ubuntu2 running 'modules:final' at Sat, 15 Mar 2025 19:33:30 +0000. Up 18.68 seconds.
744s          Starting [0;1;39mapt-news.service[0m - Update APT News...
744s          Starting [0;1;39mesm-cache.service[0m - Update the local ESM caches...
744s [[0;32m  OK  [0m] Finished [0;1;39mesm-cache.service[0m - Update the local ESM caches.
744s [   18.985829] cloud-init[704]: Get:1 http://ftpmaster.internal/ubuntu plucky InRelease [257 kB]
744s [   19.394241] cloud-init[704]: Get:2 http://ftpmaster.internal/ubuntu plucky-updates InRelease [126 kB]
744s [   19.491598] cloud-init[704]: Get:3 http://ftpmaster.internal/ubuntu plucky-security InRelease [126 kB]
744s [   19.590149] cloud-init[704]: Get:4 http://ftpmaster.internal/ubuntu plucky/universe Sources [21.0 MB]
744s [[0;32m  OK  [0m] Created slice [0;1;39muser-1000.slice[0m - User Slice of UID 1000.
744s          Starting [0;1;39muser-runtime-dir@1000.ser���[0mRuntime Directory /run/user/1000...
744s [[0;32m  OK  [0m] Finished [0;1;39muser-runtime-dir@1000.ser���[0mr Runtime Directory /run/user/1000.
744s          Starting [0;1;39muser@1000.service[0m - User Manager for UID 1000...
744s [[0;32m  OK  [0m] Started [0;1;39muser@1000.service[0m - User Manager for UID 1000.
744s [[0;32m  OK  [0m] Started [0;1;39msession-1.scope[0m - Session 1 of User ubuntu.
744s [[0;32m  OK  [0m] Started [0;1;39msession-3.scope[0m - Session 3 of User ubuntu.
744s [   21.448905] cloud-init[704]: Get:5 http://ftpmaster.internal/ubuntu plucky/main Sources [1394 kB]
744s [   21.562001] cloud-init[704]: Get:6 http://ftpmaster.internal/ubuntu plucky/restricted Sources [16.9 kB]
744s [   21.563545] cloud-init[704]: Get:7 http://ftpmaster.internal/ubuntu plucky/multiverse Sources [299 kB]
744s [   21.584734] cloud-init[704]: Get:8 http://ftpmaster.internal/ubuntu plucky/main ppc64el Packages [1419 kB]
744s [   21.756926] cloud-init[704]: Get:9 http://ftpmaster.internal/ubuntu plucky/main ppc64el c-n-f Metadata [31.5 kB]
744s [   21.758146] cloud-init[704]: Get:10 http://ftpmaster.internal/ubuntu plucky/restricted ppc64el c-n-f Metadata [108 B]
744s [   21.759388] cloud-init[704]: Get:11 http://ftpmaster.internal/ubuntu plucky/universe ppc64el Packages [15.7 MB]
744s [!p]104[?7h[6n[32766;32766H[6n[   22.764923] cloud-init[704]: Get:12 http://ftpmaster.internal/ubuntu plucky/multiverse ppc64el Packages [185 kB]
744s [   22.769009] cloud-init[704]: Get:13 http://ftpmaster.internal/ubuntu plucky-updates/main ppc64el c-n-f Metadata [112 B]
744s [   22.770484] cloud-init[704]: Get:14 http://ftpmaster.internal/ubuntu plucky-updates/restricted ppc64el c-n-f Metadata [116 B]
744s [   22.776305] cloud-init[704]: Get:15 http://ftpmaster.internal/ubuntu plucky-updates/universe ppc64el c-n-f Metadata [116 B]
744s [   22.776539] cloud-init[704]: Get:16 http://ftpmaster.internal/ubuntu plucky-updates/multiverse ppc64el c-n-f Metadata [116 B]
744s [   22.776777] cloud-init[704]: Get:17 http://ftpmaster.internal/ubuntu plucky-security/main ppc64el c-n-f Metadata [112 B]
744s [   22.776978] cloud-init[704]: Get:18 http://ftpmaster.internal/ubuntu plucky-security/restricted ppc64el c-n-f Metadata [120 B]
744s [   22.777197] cloud-init[704]: Get:19 http://ftpmaster.internal/ubuntu plucky-security/universe ppc64el c-n-f Metadata [116 B]
744s [   22.777427] cloud-init[704]: Get:20 http://ftpmaster.internal/ubuntu plucky-security/multiverse ppc64el c-n-f Metadata [120 B]
744s [!p]104[?7h[6n[32766;32766H[6n
744s Ubuntu Plucky Puffin (development branch) autopkgtest hvc0
744s 
744s autopkgtest login: [   26.685180] cloud-init[704]: Fetched 40.6 MB in 8s (5295 kB/s)
744s [   27.475910] cloud-init[704]: Reading package lists...
744s ci-info: ++++++++++++++++++++++++++++++++++++++++++++++++++++++Authorized keys from /home/ubuntu/.ssh/authorized_keys for user ubuntu++++++++++++++++++++++++++++++++++++++++++++++++++++++
744s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+----------------------------------------------------------+
744s ci-info: | Keytype |                                       Fingerprint (sha256)                                      | Options |                         Comment                          |
744s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+----------------------------------------------------------+
744s ci-info: | ssh-rsa | 87:eb:11:e6:d9:4d:64:37:d3:15:bc:fb:70:01:fb:c2:54:4a:7c:f0:03:f0:ca:42:74:a2:5a:a0:67:8b:da:f8 |    -    | ubuntu@juju-7f2275-prod-proposed-migration-environment-2 |
744s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+----------------------------------------------------------+
744s <14>Mar 15 19:33:39 cloud-init: #############################################################
744s <14>Mar 15 19:33:39 cloud-init: -----BEGIN SSH HOST KEY FINGERPRINTS-----
744s <14>Mar 15 19:33:39 cloud-init: 256 SHA256:/l/OHdWqmES2e1TA66p+8/E/ZRSnglWY591cNjiceng root@autopkgtest (ECDSA)
744s <14>Mar 15 19:33:39 cloud-init: 256 SHA256:r1vu473twgQCxqMn3rq212dHsSHC17SaMzcof7c/uXE root@autopkgtest (ED25519)
744s <14>Mar 15 19:33:39 cloud-init: 3072 SHA256:9l/+oQgCsFPfbVVxnDfcEFHhTpHtdsUMdP6GSIGbTUw root@autopkgtest (RSA)
744s <14>Mar 15 19:33:39 cloud-init: -----END SSH HOST KEY FINGERPRINTS-----
744s <14>Mar 15 19:33:39 cloud-init: #############################################################
744s -----BEGIN SSH HOST KEY KEYS-----
744s ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBLvPkmkbS+vBkSicUIOy8VaNsuFCM5zydtb+0tEOW9ZjiipPyTTeGjUQazA0+ymVglv6SDcsO333lhmfGmtgo9Y= root@autopkgtest
744s ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIMC5dh3cvxyAtWvA1jNcoveWqsTcaSNXawpIdrFYwJbn root@autopkgtest
744s ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQCuvSVPdmfqQBE8RBtRBY49F+xUqj4m6Zvo3AZizoV17rY/yEZrfIc22OU+AU8BgG1NtDWcS5lP9p43pfQtvtsBWhUZMmDfp3oK9pxeNT5A8ZVSdKzychRK+Z8ltg5SLX2ELv+9oEW7C0fnFoaRVNMn3AtScrHG/YB69jDYpm+pNy9B7ba9X7PiDpMOx3ycTaQktVeWw3kF3cMrF1D989g/cXEgnCXBpJ1nQExbQIbEhySqWbeWA+uiYzLWIW0FwO+HYHUxUk1+2qDLG3BXrRUP0TszpfRgD4YbMeED+2NHVxB3DTcrTfAw10286rFkgQQz1bUjmujQRC6wtRckqqswmt1dFUubnHggup9K2np1qavd08Z5vlXUlm3VGNK02c+e2rBGdgZA20wGmaUyiZocHRBNrRsHeZIJbrhobT/oYGGq1DMKGvhhRdR/5aYxf2OuqtXx9TA2+QmR5cs3MCqBLwHzkRTjAYv35jb57ew/JGL8CQvBy2G34HGpDePNC9U= root@autopkgtest
744s -----END SSH HOST KEY KEYS-----
744s [   27.527678] cloud-init[704]: Cloud-init v. 25.1-0ubuntu2 finished at Sat, 15 Mar 2025 19:33:39 +0000. Datasource DataSourceOpenStackLocal [net,ver=2].  Up 27.52 seconds
744s [   27.528083] sh[1041]: Completed socket interaction for boot stage final
744s [   27.528387] cloud-init[704]: Generating public/private rsa key pair.
744s [   27.528528] cloud-init[704]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key
744s [   27.529061] cloud-init[704]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub
744s [   27.529209] cloud-init[704]: The key fingerprint is:
744s [   27.529331] cloud-init[704]: SHA256:9l/+oQgCsFPfbVVxnDfcEFHhTpHtdsUMdP6GSIGbTUw root@autopkgtest
744s [   27.529473] cloud-init[704]: The key's randomart image is:
744s [   27.532193] cloud-init[704]: +---[RSA 3072]----+
744s [   27.532331] cloud-init[704]: |           +E.B#@|
744s [   27.532432] cloud-init[704]: |          . o.oB@|
744s [   27.532528] cloud-init[704]: |   . .     =.. +=|
744s [   27.532623] cloud-init[704]: |    + . . +.o.o.=|
744s [   27.532719] cloud-init[704]: |   o . .S. o. .o+|
744s [   27.532813] cloud-init[704]: |    . .. ..    . |
744s [   27.532899] cloud-init[704]: |       . ..   .. |
744s [   27.532991] cloud-init[704]: |        . ...o. .|
744s [   27.533085] cloud-init[704]: |           ......|
744s [   27.533199] cloud-init[704]: +----[SHA256]-----+
744s [   27.533316] cloud-init[704]: Generating public/private ecdsa key pair.
744s [   27.533454] cloud-init[704]: Your identification has been saved in /etc/ssh/ssh_host_ecdsa_key
744s [   27.533573] cloud-init[704]: Your public key has been saved in /etc/ssh/ssh_host_ecdsa_key.pub
744s [   27.533697] cloud-init[704]: The key fingerprint is:
744s [   27.533795] cloud-init[704]: SHA256:/l/OHdWqmES2e1TA66p+8/E/ZRSnglWY591cNjiceng root@autopkgtest
744s [   27.533938] cloud-init[704]: The key's randomart image is:
744s [   27.534056] cloud-init[704]: +---[ECDSA 256]---+
744s [   27.534150] cloud-init[704]: |           ..++  |
744s [   27.534247] cloud-init[704]: |            *=.o+|
744s [   27.534342] cloud-init[704]: |           oo=.=*|
744s [   27.534434] cloud-init[704]: |          .ooE+ *|
744s [   27.534530] cloud-init[704]: |        S o.oo .o|
744s [   27.534661] cloud-init[704]: |       . o .o  .+|
744s [   27.534756] cloud-init[704]: |        . oo. oo.|
744s [   27.534853] cloud-init[704]: |         o++.B o.|
744s [   27.534949] cloud-init[704]: |       .oo==+ +.+|
744s [   27.535044] cloud-init[704]: +----[SHA256]-----+
744s [   27.535140] cloud-init[704]: Generating public/private ed25519 key pair.
744s [   27.535261] cloud-init[704]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key
744s [   27.535393] cloud-init[704]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub
744s [   27.535512] cloud-init[704]: The key fingerprint is:
744s [   27.535610] cloud-init[704]: SHA256:r1vu473twgQCxqMn3rq212dHsSHC17SaMzcof7c/uXE root@autopkgtest
744s [   27.535735] cloud-init[704]: The key's randomart image is:
744s [   27.535835] cloud-init[704]: +--[ED25519 256]--+
744s [   27.535929] cloud-init[704]: |     .           |
744s [   27.536022] cloud-init[704]: |      =     .    |
744s [   27.536117] cloud-init[704]: |     o +   o .   |
744s [   27.536199] cloud-init[704]: |    o . + + =    |
744s [   27.536441] cloud-init[704]: |   . +  S+ * +   |
744s [   27.536536] cloud-init[704]: |    . . ..* *    |
744s [   27.536632] cloud-init[704]: |     . . ooB . .E|
744s [   27.536729] cloud-init[704]: |    o . .+=.=..oo|
744s [   27.536826] cloud-init[704]: |   .o+  o*++o=+++|
744s [   27.536918] cloud-init[704]: +----[SHA256]-----+
744s          Stopping [0;1;39msystemd-networkd-persiste���[0mtent Storage in systemd-networkd...
744s [[0;32m  OK  [0m] Stopped [0;1;39msystemd-networkd-wait-onli���[0m Wait for Network to be Configured.
744s          Stopping [0;1;39msystemd-networkd-wait-onl���[0mait for Network to be Configured...
744s [[0;32m  OK  [0m] Stopped [0;1;39msystemd-networkd-persisten���[0mistent Storage in systemd-networkd.
744s          Stopping [0;1;39msystemd-networkd.service[0m - Network Configuration...
744s [[0;32m  OK  [0m] Stopped [0;1;39msystemd-networkd.service[0m - Network Configuration.
744s          Starting [0;1;39msystemd-networkd.service[0m - Network Configuration...
744s [[0;32m  OK  [0m] Started [0;1;39msystemd-networkd.service[0m - Network Configuration.
744s          Starting [0;1;39msystemd-networkd-persiste���[0mtent Storage in systemd-networkd...
744s          Starting [0;1;39msystemd-networkd-wait-onl���[0mait for Network to be Configured...
744s          Stopping [0;1;39msystemd-journald.service[0m - Journal Service...
744s [[0;32m  OK  [0m] Stopped [0;1;39msystemd-journald.service[0m - Journal Service.
744s          Starting [0;1;39msystemd-journald.service[0m - Journal Service...
744s [[0;32m  OK  [0m] Finished [0;1;39msystemd-networkd-persiste���[0mistent Storage in systemd-networkd.
744s [[0;32m  OK  [0m] Finished [0;1;39msystemd-networkd-wait-onl���[0m Wait for Network to be Configured.
744s [[0;32m  OK  [0m] Started [0;1;39msystemd-journald.service[0m - Journal Service.
744s [[0;32m  OK  [0m] Started [0;1;39mrun-p8247-i8248.service[0m - ���] /usr/bin/sh -c "sleep 3; reboot".
744s [[0;32m  OK  [0m] Stopped [0;1;39mrun-p8247-i8248.service[0m - ���] /usr/bin/sh -c "sleep 3; reboot".
744s [[0;32m  OK  [0m] Removed slice [0;1;39msystem-autopkgtest.slice[0m - Slice /system/autopkgtest.
744s [[0;32m  OK  [0m] Removed slice [0;1;39msystem-modprobe.slice[0m - Slice /system/modprobe.
744s [[0;32m  OK  [0m] Stopped target [0;1;39mboot-complete.target[0m - Boot Completion Check.
744s [[0;32m  OK  [0m] Stopped target [0;1;39mcloud-init.target[0m - Cloud-init target.
744s [[0;32m  OK  [0m] Stopped target [0;1;39mgraphical.target[0m - Graphical Interface.
744s [[0;32m  OK  [0m] Stopped target [0;1;39miprutils.target[0m - IBM Power Raid utilities.
744s [[0;32m  OK  [0m] Stopped target [0;1;39mnss-lookup.target[0m - Host and Network Name Lookups.
744s [[0;32m  OK  [0m] Stopped target [0;1;39mssh-access.target[0m - SSH Access Available.
744s [[0;32m  OK  [0m] Stopped target [0;1;39mtimers.target[0m - Timer Units.
744s [[0;32m  OK  [0m] Stopped [0;1;39mapt-daily-upgrade.timer[0m - ���y apt upgrade and clean activities.
744s [[0;32m  OK  [0m] Stopped [0;1;39mapt-daily.timer[0m - Daily apt download activities.
744s [[0;32m  OK  [0m] Stopped [0;1;39mdpkg-db-backup.timer[0m - Daily dpkg database backup timer.
744s [[0;32m  OK  [0m] Stopped [0;1;39me2scrub_all.timer[0m - Period���Metadata Check for All Filesystems.
744s [[0;32m  OK  [0m] Stopped [0;1;39mfstrim.timer[0m - Discard unused filesystem blocks once a week.
744s [[0;32m  OK  [0m] Stopped [0;1;39mfwupd-refresh.timer[0m - Refresh fwupd metadata regularly.
744s [[0;32m  OK  [0m] Stopped [0;1;39mlogrotate.timer[0m - Daily rotation of log files.
744s [[0;32m  OK  [0m] Stopped [0;1;39mman-db.timer[0m - Daily man-db regeneration.
744s [[0;32m  OK  [0m] Stopped [0;1;39mmotd-news.timer[0m - Message of the Day.
744s [[0;32m  OK  [0m] Stopped [0;1;39msysstat-collect.timer[0m - Ru���y accounting tool every 10 minutes.
744s [[0;32m  OK  [0m] Stopped [0;1;39msysstat-rotate.timer[0m - Rot���tem activity data file at midnight.
744s [[0;32m  OK  [0m] Stopped [0;1;39msysstat-summary.timer[0m - Ge��� of yesterday's process accounting.
744s [[0;32m  OK  [0m] Stopped [0;1;39msystemd-tmpfiles-clean.tim���[0my Cleanup of Temporary Directories.
744s [[0;32m  OK  [0m] Stopped target [0;1;39mtime-set.target[0m - System Time Set.
744s [[0;32m  OK  [0m] Closed [0;1;39mcloud-init-hotplugd.socket[0m - cloud-init hotplug hook socket.
744s [[0;32m  OK  [0m] Closed [0;1;39msystemd-rfkill.socket[0m - Loa���ll Switch Status /dev/rfkill Watch.
744s [[0;32m  OK  [0m] Stopped [0;1;39mcloud-final.service[0m - Cloud-init: Final Stage.
744s [[0;32m  OK  [0m] Stopped target [0;1;39mmulti-user.target[0m - Multi-User System.
744s [[0;32m  OK  [0m] Stopped target [0;1;39mgetty.target[0m - Login Prompts.
744s          Stopping [0;1;39mapport.service[0m - automatic crash report generation...
744s [[0;32m  OK  [0m] Stopped [0;1;39mcloud-config.service[0m - Cloud-init: Config Stage.
744s [[0;32m  OK  [0m] Stopped target [0;1;39mcloud-config.target[0m - Cloud-config availability.
744s          Stopping [0;1;39mcron.service[0m - Regular ba���ground program processing daemon...
744s          Stopping [0;1;39mgetty@tty1.service[0m - Getty on tty1...
744s          Stopping [0;1;39miprinit.service[0m - IBM Power Raid init daemon...
744s          Stopping [0;1;39miprupdate.service[0m - IBM Power Raid update daemon...
744s [[0;32m  OK  [0m] Stopped [0;1;39mplymouth-quit.service[0m - Terminate Plymouth Boot Screen.
744s          Stopping [0;1;39mrsyslog.service[0m - System Logging Service...
744s          Stopping [0;1;39mrtas_errd.service[0m - ppc64���platform error handling) Service...
744s          Stopping [0;1;39mserial-getty@hvc0.service[0m - Serial Getty on hvc0...
744s          Stopping [0;1;39mssh.service[0m - OpenBSD Secure Shell server...
744s [[0;32m  OK  [0m] Stopped [0;1;39msysstat.service[0m - Resets System Activity Logs.
744s          Stopping [0;1;39msystemd-networkd-persiste���[0mtent Storage in systemd-networkd...
744s          Stopping [0;1;39msystemd-random-seed.service[0m - Load/Save OS Random Seed...
744s [[0;32m  OK  [0m] Stopped [0;1;39msystemd-udev-load-credenti���[0m- Load udev Rules from Credentials.
744s          Stopping [0;1;39mudisks2.service[0m - Disk Manager...
744s          Stopping [0;1;39muser@1000.service[0m - User Manager for UID 1000...
744s [[0;32m  OK  [0m] Stopped [0;1;39mcron.service[0m - Regular background program processing daemon.
744s [[0;32m  OK  [0m] Stopped [0;1;39mrtas_errd.service[0m - ppc64-��� (platform error handling) Service.
744s [[0;32m  OK  [0m] Stopped [0;1;39miprupdate.service[0m - IBM Power Raid update daemon.
744s [[0;32m  OK  [0m] Stopped [0;1;39miprinit.service[0m - IBM Power Raid init daemon.
744s [[0;32m  OK  [0m] Stopped [0;1;39mssh.service[0m - OpenBSD Secure Shell server.
744s [[0;32m  OK  [0m] Stopped [0;1;39mserial-getty@hvc0.service[0m - Serial Getty on hvc0.
744s [!p]104[?7h[6n[32766;32766H[6n[[0;32m  OK  [0m] Stopped [0;1;39mudisks2.service[0m - Disk Manager.
744s [[0;32m  OK  [0m] Stopped [0;1;39mgetty@tty1.service[0m - Getty on tty1.
744s [[0;32m  OK  [0m] Stopped [0;1;39mapt-news.service[0m - Update APT News.
744s [[0;32m  OK  [0m] Stopped [0;1;39muser@1000.service[0m - User Manager for UID 1000.
744s [[0;32m  OK  [0m] Stopped [0;1;39mrsyslog.service[0m - System Logging Service.
744s [[0;32m  OK  [0m] Stopped [0;1;39mapport.service[0m - automatic crash report generation.
744s [[0;32m  OK  [0m] Stopped [0;1;39msystemd-random-seed.service[0m - Load/Save OS Random Seed.
744s [[0;32m  OK  [0m] Removed slice [0;1;39msystem-getty.slice[0m - Slice /system/getty.
744s [[0;32m  OK  [0m] Removed slice [0;1;39msystem-serial\x2dget���slice[0m - Slice /system/serial-getty.
744s          Stopping [0;1;39miprdump.service[0m - IBM Power Raid dump daemon...
744s [[0;32m  OK  [0m] Stopped [0;1;39mplymouth-quit-wait.service[0m���old until boot process finishes up.
744s [[0;32m  OK  [0m] Stopped [0;1;39mrc-local.service[0m - /etc/rc.local Compatibility.
744s [[0;32m  OK  [0m] Stopped target [0;1;39mnetwork-online.target[0m - Network is Online.
744s [[0;32m  OK  [0m] Stopped [0;1;39msystemd-networkd-wait-onli���[0m Wait for Network to be Configured.
744s          Stopping [0;1;39msystemd-user-sessions.service[0m - Permit User Sessions...
744s          Stopping [0;1;39muser-runtime-dir@1000.ser���[0mRuntime Directory /run/user/1000...
744s [[0;32m  OK  [0m] Stopped [0;1;39miprdump.service[0m - IBM Power Raid dump daemon.
744s [[0;32m  OK  [0m] Stopped [0;1;39msystemd-user-sessions.service[0m - Permit User Sessions.
744s [[0;32m  OK  [0m] Unmounted [0;1;39mrun-user-1000.mount[0m - /run/user/1000.
744s [[0;32m  OK  [0m] Stopped [0;1;39msystemd-networkd-persisten���[0mistent Storage in systemd-networkd.
744s [[0;32m  OK  [0m] Stopped [0;1;39muser-runtime-dir@1000.serv���[0mr Runtime Directory /run/user/1000.
744s [[0;32m  OK  [0m] Removed slice [0;1;39muser-1000.slice[0m - User Slice of UID 1000.
744s [[0;32m  OK  [0m] Stopped target [0;1;39mnetwork.target[0m - Network.
744s [[0;32m  OK  [0m] Stopped target [0;1;39mremote-fs.target[0m - Remote File Systems.
744s          Stopping [0;1;39msystemd-logind.service[0m - User Login Management...
744s          Stopping [0;1;39msystemd-networkd.service[0m - Network Configuration...
744s [[0;32m  OK  [0m] Stopped [0;1;39msystemd-logind.service[0m - User Login Management.
744s [[0;32m  OK  [0m] Stopped [0;1;39msystemd-networkd.service[0m - Network Configuration.
744s [[0;32m  OK  [0m] Stopped target [0;1;39mbasic.target[0m - Basic System.
744s [[0;32m  OK  [0m] Stopped target [0;1;39mnetwork-pre.target[0m - Preparation for Network.
744s [[0;32m  OK  [0m] Stopped target [0;1;39mpaths.target[0m - Path Units.
744s [[0;32m  OK  [0m] Stopped target [0;1;39mslices.target[0m - Slice Units.
744s [[0;32m  OK  [0m] Removed slice [0;1;39muser.slice[0m - User and Session Slice.
744s [[0;32m  OK  [0m] Stopped target [0;1;39msockets.target[0m - Socket Units.
744s [[0;32m  OK  [0m] Closed [0;1;39mlxd-installer.socket[0m - Helper to install lxd snap on demand.
744s [[0;32m  OK  [0m] Closed [0;1;39mssh.socket[0m - OpenBSD Secure Shell server socket.
744s [[0;32m  OK  [0m] Closed [0;1;39msshd-unix-local.socket[0m - Op���temd-ssh-generator, AF_UNIX Local).
744s [[0;32m  OK  [0m] Closed [0;1;39msshd-vsock.socket[0m - OpenSSH��� (systemd-ssh-generator, AF_VSOCK).
744s [[0;32m  OK  [0m] Closed [0;1;39msyslog.socket[0m - Syslog Socket.
744s [[0;32m  OK  [0m] Closed [0;1;39msystemd-hostnamed.socket[0m - Hostname Service Socket.
744s [[0;32m  OK  [0m] Closed [0;1;39msystemd-networkd.socket[0m - Network Service Netlink Socket.
744s [[0;32m  OK  [0m] Closed [0;1;39muuidd.socket[0m - UUID daemon activation socket.
744s [[0;32m  OK  [0m] Stopped target [0;1;39msysinit.target[0m - System Initialization.
744s [[0;32m  OK  [0m] Stopped target [0;1;39mcryptsetup.target[0m - Local Encrypted Volumes.
744s [[0;32m  OK  [0m] Stopped [0;1;39msystemd-ask-password-conso���[0mequests to Console Directory Watch.
744s [[0;32m  OK  [0m] Stopped [0;1;39msystemd-ask-password-wall.���[0md Requests to Wall Directory Watch.
744s [[0;32m  OK  [0m] Stopped target [0;1;39mintegritysetup.targ���[0m Local Integrity Protected Volumes.
744s [[0;32m  OK  [0m] Stopped target [0;1;39mswap.target[0m - Swaps.
744s [[0;32m  OK  [0m] Stopped target [0;1;39mveritysetup.target[0m - Local Verity Protected Volumes.
744s [[0;32m  OK  [0m] Stopped [0;1;39mcloud-init-network.service[0m - Cloud-init: Network Stage.
744s [[0;32m  OK  [0m] Stopped [0;1;39mcloud-init-local.service[0m -���ud-init: Local Stage (pre-network).
744s          Stopping [0;1;39msystemd-binfmt.service[0m - Set Up Additional Binary Formats...
744s          Stopping [0;1;39msystemd-resolved.service[0m - Network Name Resolution...
744s          Stopping [0;1;39msystemd-timesyncd.service[0m - Network Time Synchronization...
744s [[0;32m  OK  [0m] Stopped [0;1;39msystemd-tmpfiles-setup.ser���[0mreate System Files and Directories.
744s [[0;32m  OK  [0m] Stopped [0;1;39msystemd-timesyncd.service[0m - Network Time Synchronization.
744s [[0;32m  OK  [0m] Stopped [0;1;39msystemd-resolved.service[0m - Network Name Resolution.
744s [[0;32m  OK  [0m] Stopped [0;1;39msystemd-binfmt.service[0m - Set Up Additional Binary Formats.
744s [[0;32m  OK  [0m] Unset automount [0;1;39mproc-sys-fs-binfmt���[0mormats File System Automount Point.
744s [[0;32m  OK  [0m] Stopped target [0;1;39mlocal-fs.target[0m - Local File Systems.
744s [[0;32m  OK  [0m] Stopped target [0;1;39mlocal-fs-pre.target[0m���Preparation for Local File Systems.
744s          Unmounting [0;1;39mrun-lock.mount[0m - Legacy Locks Directory /run/lock...
744s          Stopping [0;1;39mmultipathd.service[0m - Devi���pper Multipath Device Controller...
744s [[0;32m  OK  [0m] Stopped [0;1;39msystemd-sysctl.service[0m - Apply Kernel Variables.
744s [[0;32m  OK  [0m] Stopped [0;1;39msystemd-modules-load.service[0m - Load Kernel Modules.
744s [[0;32m  OK  [0m] Stopped [0;1;39msystemd-tmpfiles-setup-dev���[0mCreate Static Device Nodes in /dev.
744s [[0;32m  OK  [0m] Stopped [0;1;39msystemd-tmpfiles-setup-dev���[0mic Device Nodes in /dev gracefully.
744s [[0;32m  OK  [0m] Unmounted [0;1;39mrun-lock.mount[0m - Legacy Locks Directory /run/lock.
744s [[0;32m  OK  [0m] Reached target [0;1;39mumount.target[0m - Unmount All Filesystems.
744s [[0;32m  OK  [0m] Stopped [0;1;39mmultipathd.service[0m - Devic���Mapper Multipath Device Controller.
744s [[0;32m  OK  [0m] Stopped [0;1;39msystemd-remount-fs.service[0m���mount Root and Kernel File Systems.
744s [[0;32m  OK  [0m] Reached target [0;1;39mshutdown.target[0m - System Shutdown.
744s [[0;32m  OK  [0m] Reached target [0;1;39mfinal.target[0m - Late Shutdown Services.
744s [[0;32m  OK  [0m] Finished [0;1;39msystemd-reboot.service[0m - System Reboot.
744s [[0;32m  OK  [0m] Reached target [0;1;39mreboot.target[0m - System Reboot.
744s [   90.515328] reboot: Restarting system
744s 
744s 
744s SLOF[0m[?25l **********************************************************************
744s [1mQEMU Starting
744s [0m Build Date = Oct 22 2024 05:33:28
744s  FW Version = release 20210711
744s  Press "s" to enter Open Firmware.
744s 
744s [0m[?25hC0000C0100C0120C0140C0200C0240C0260C02E0C0300C0320C0340C0360C0370C0380C0371C0373C0374C03F0C0400C0480C04C0C04D0C0500Populating /vdevice methods
744s Populating /vdevice/vty@30000000
744s Populating /vdevice/nvram@71000000
744s C05A0Populating /pci@800000020000000
744s                      00 0800 (D) : 1af4 1000    virtio [ net ]
744s                      00 1000 (D) : 1b36 000d    serial bus [ usb-xhci ]
744s                      00 1800 (D) : 1af4 1003    virtio [ serial ]
744s                      00 2000 (D) : 1af4 1001    virtio [ block ]
744s                      00 2800 (D) : 1af4 1002    legacy-device*
744s                      00 3000 (D) : 1af4 1005    legacy-device*
744s                      00 3800 (D) : 1234 1111    qemu vga
744s C0600C06C0C0700C0800C0880C0890C08A0C08A8Installing QEMU fb
744s 
744s 
744s 
744s C08B0Scanning USB 
744s   XHCI: Initializing
744s     USB Keyboard 
744s     USB mouse 
744s C08C0C08D0No console specified using screen & keyboard
744s C08E0C08E8C08FF     
744s   Welcome to Open Firmware
744s 
744s   Copyright (c) 2004, 2017 IBM Corporation All rights reserved.
744s   This program and the accompanying materials are made available
744s   under the terms of the BSD License available at
744s   http://www.opensource.org/licenses/bsd-license.php
744s 
744s 
744s Trying to load:  from: /pci@800000020000000/scsi@4 ...   Successfully loaded
744s Linux ppc64le
744s #10-Ubuntu SMP W[    0.000000] radix-mmu: Page sizes from device-tree:
744s [    0.000000] radix-mmu: Page size shift = 12 AP=0x0
744s [    0.000000] radix-mmu: Page size shift = 16 AP=0x5
744s [    0.000000] radix-mmu: Page size shift = 21 AP=0x1
744s [    0.000000] radix-mmu: Page size shift = 30 AP=0x2
744s [    0.000000] Activating Kernel Userspace Access Prevention
744s [    0.000000] Activating Kernel Userspace Execution Prevention
744s [    0.000000] radix-mmu: Mapped 0x0000000000000000-0x0000000003a00000 with 2.00 MiB pages (exec)
744s [    0.000000] radix-mmu: Mapped 0x0000000003a00000-0x0000000040000000 with 2.00 MiB pages
744s [    0.000000] radix-mmu: Mapped 0x0000000040000000-0x0000000100000000 with 1.00 GiB pages
744s [    0.000000] lpar: Using radix MMU under hypervisor
744s [    0.000000] Linux version 6.14.0-10-generic (buildd@bos03-ppc64el-029) (powerpc64le-linux-gnu-gcc-14 (Ubuntu 14.2.0-17ubuntu3) 14.2.0, GNU ld (GNU Binutils for Ubuntu) 2.44) #10-Ubuntu SMP Wed Mar 12 16:05:46 UTC 2025 (Ubuntu 6.14.0-10.10-generic 6.14.0-rc6)
744s [    0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT
744s [    0.000000] Secure boot mode disabled
744s [    0.000000] Found initrd at 0xc000000006200000:0xc000000009957ec0
744s [    0.000000] Hardware name: IBM pSeries (emulated by qemu) POWER9 (architected) 0x4e1203 0xf000005 of:SLOF,HEAD hv:linux,kvm pSeries
744s [    0.000000] Partition configured for 2 cpus.
744s [    0.000000] CPU maps initialized for 1 thread per core
744s [    0.000000] numa: Partition configured for 1 NUMA nodes.
744s [    0.000000] -----------------------------------------------------
744s [    0.000000] phys_mem_size     = 0x100000000
744s [    0.000000] dcache_bsize      = 0x80
744s [    0.000000] icache_bsize      = 0x80
744s [    0.000000] cpu_features      = 0x0001c06b8f4f9187
744s [    0.000000]   possible        = 0x003ffbfbcf5fb187
744s [    0.000000]   always          = 0x0000000380008181
744s [    0.000000] cpu_user_features = 0xdc0065c2 0xaef00000
744s [    0.000000] mmu_features      = 0x3c007641
744s [    0.000000] firmware_features = 0x00000285455a445f
744s [    0.000000] vmalloc start     = 0xc008000000000000
744s [    0.000000] IO start          = 0xc00a000000000000
744s [    0.000000] vmemmap start     = 0xc00c000000000000
744s [    0.000000] -----------------------------------------------------
744s [    0.000000] NODE_DATA(0) allocated [mem 0xfff94280-0xfff9bfff]
744s [    0.000000] rfi-flush: fallback displacement flush available
744s [    0.000000] rfi-flush: ori type flush available
744s [    0.000000] rfi-flush: mttrig type flush available
744s [    0.000000] count-cache-flush: hardware flush enabled.
744s [    0.000000] link-stack-flush: software flush enabled.
744s [    0.000000] stf-barrier: eieio barrier available
744s [    0.000000] PPC64 nvram contains 65536 bytes
744s [    0.000000] barrier-nospec: using ORI speculation barrier
744s [    0.000000] Zone ranges:
744s [    0.000000]   Normal   [mem 0x0000000000000000-0x00000000ffffffff]
744s [    0.000000]   Device   empty
744s [    0.000000] Movable zone start for each node
744s [    0.000000] Early memory node ranges
744s [    0.000000]   node   0: [mem 0x0000000000000000-0x00000000ffffffff]
744s [    0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x00000000ffffffff]
744s [    0.000000] percpu: Embedded 4 pages/cpu s129176 r0 d132968 u262144
744s [    0.000000] Kernel command line: BOOT_IMAGE=/boot/vmlinux-6.14.0-10-generic root=UUID=cc18d838-3721-4f67-b9bc-edb63f4f5973 ro console=hvc0 earlyprintk
744s [    0.000000] Unknown kernel command line parameters "earlyprintk BOOT_IMAGE=/boot/vmlinux-6.14.0-10-generic", will be passed to user space.
744s [    0.000000] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes
744s [    0.000000] Dentry cache hash table entries: 524288 (order: 6, 4194304 bytes, linear)
744s [    0.000000] Inode-cache hash table entries: 262144 (order: 5, 2097152 bytes, linear)
744s [    0.000000] Fallback order for Node 0: 0 
744s [    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 65536
744s [    0.000000] Policy zone: Normal
744s [    0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off
744s [    0.000000] SLUB: HWalign=128, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
744s [    0.000000] ftrace: allocating 54097 entries in 20 pages
744s [    0.000000] ftrace: allocated 20 pages with 2 groups
744s [    0.000000] rcu: Hierarchical RCU implementation.
744s [    0.000000] rcu: 	RCU restricting CPUs from NR_CPUS=2048 to nr_cpu_ids=2.
744s [    0.000000] 	Rude variant of Tasks RCU enabled.
744s [    0.000000] 	Tracing variant of Tasks RCU enabled.
744s [    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
744s [    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
744s [    0.000000] RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.
744s [    0.000000] RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.
744s [    0.000000] NR_IRQS: 512, nr_irqs: 512, preallocated irqs: 16
744s [    0.000000] xive: Using IRQ range [0-1]
744s [    0.000000] xive: Interrupt handling initialized with spapr backend
744s [    0.000000] xive: Using priority 6 for all interrupts
744s [    0.000000] xive: Using 64kB queues
744s [    0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.
744s [    0.000001] time_init: 56 bit decrementer (max: 7fffffffffffff)
744s [    0.000004] clocksource: timebase: mask: 0xffffffffffffffff max_cycles: 0x761537d007, max_idle_ns: 440795202126 ns
744s [    0.000008] clocksource: timebase mult[1f40000] shift[24] registered
744s [    0.000293] Console: colour dummy device 80x25
744s [    0.004459] pid_max: default: 32768 minimum: 301
744s [    0.013824] LSM: initializing lsm=lockdown,capability,landlock,yama,apparmor,ima,evm
744s [    0.016444] landlock: Up and running.
744s [    0.016446] Yama: becoming mindful.
744s [    0.017039] AppArmor: AppArmor initialized
744s [    0.019993] Mount-cache hash table entries: 8192 (order: 0, 65536 bytes, linear)
744s [    0.020000] Mountpoint-cache hash table entries: 8192 (order: 0, 65536 bytes, linear)
744s [    0.025199] POWER9 performance monitor hardware support registered
744s [    0.025238] rcu: Hierarchical SRCU implementation.
744s [    0.025239] rcu: 	Max phase no-delay instances is 1000.
744s [    0.028161] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level
744s [    0.036141] smp: Bringing up secondary CPUs ...
744s [    0.053075] smp: Brought up 1 node, 2 CPUs
744s [    0.053087] numa: Node 0 CPUs: 0-1
744s [    0.053448] Memory: 4019968K/4194304K available (26048K kernel code, 4288K rwdata, 23104K rodata, 8768K init, 1783K bss, 149440K reserved, 0K cma-reserved)
744s [    0.055014] devtmpfs: initialized
744s [    0.055912] PCI host bridge /pci@800000020000000  ranges:
744s [    0.055919]   IO 0x0000200000000000..0x000020000000ffff -> 0x0000000000000000
744s [    0.055923]  MEM 0x0000200080000000..0x00002000ffffffff -> 0x0000000080000000 
744s [    0.055925]  MEM 0x0000210000000000..0x000021ffffffffff -> 0x0000210000000000 
744s [    0.056041] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
744s [    0.056049] futex hash table entries: 512 (order: 0, 65536 bytes, linear)
744s [    0.063228] pinctrl core: initialized pinctrl subsystem
744s [    0.064547] NET: Registered PF_NETLINK/PF_ROUTE protocol family
744s [    0.064756] audit: initializing netlink subsys (disabled)
744s [    0.064960] thermal_sys: Registered thermal governor 'fair_share'
744s [    0.064961] thermal_sys: Registered thermal governor 'bang_bang'
744s [    0.064962] thermal_sys: Registered thermal governor 'step_wise'
744s [    0.064963] thermal_sys: Registered thermal governor 'user_space'
744s [    0.064964] thermal_sys: Registered thermal governor 'power_allocator'
744s [    0.064983] audit: type=2000 audit(1742067292.064:1): state=initialized audit_enabled=0 res=1
744s [    0.064991] cpuidle: using governor ladder
744s [    0.064995] cpuidle: using governor menu
744s [    0.065228] pstore: Using crash dump compression: deflate
744s [    0.065230] pstore: Registered nvram as persistent store backend
744s [    0.065524] EEH: pSeries platform initialized
744s [    0.068370] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.
744s [    0.114168] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
744s [    0.114172] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page
744s [    0.114174] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
744s [    0.114175] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page
744s [    0.143571] iommu: Default domain type: Translated
744s [    0.143575] iommu: DMA domain TLB invalidation policy: strict mode
744s [    0.144065] SCSI subsystem initialized
744s [    0.144204] usbcore: registered new interface driver usbfs
744s [    0.144211] usbcore: registered new interface driver hub
744s [    0.144218] usbcore: registered new device driver usb
744s [    0.144256] pps_core: LinuxPPS API ver. 1 registered
744s [    0.144257] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
744s [    0.144260] PTP clock support registered
744s [    0.144386] EDAC MC: Ver: 3.0.0
744s [    0.144949] NetLabel: Initializing
744s [    0.144950] NetLabel:  domain hash size = 128
744s [    0.144951] NetLabel:  protocols = UNLABELED CIPSOv4 CALIPSO
744s [    0.144968] NetLabel:  unlabeled traffic allowed by default
744s [    0.145039] mctp: management component transport protocol core
744s [    0.145040] NET: Registered PF_MCTP protocol family
744s [    0.145051] PCI: Probing PCI hardware
744s [    0.146862] PCI host bridge to bus 0000:00
744s [    0.146865] pci_bus 0000:00: root bus resource [io  0x10000-0x1ffff] (bus address [0x0000-0xffff])
744s [    0.146868] pci_bus 0000:00: root bus resource [mem 0x200080000000-0x2000ffffffff] (bus address [0x80000000-0xffffffff])
744s [    0.146871] pci_bus 0000:00: root bus resource [mem 0x210000000000-0x21ffffffffff 64bit]
744s [    0.146873] pci_bus 0000:00: root bus resource [bus 00-ff]
744s [    0.147008] pci 0000:00:01.0: No hypervisor support for SR-IOV on this device, IOV BARs disabled.
744s [    0.147396] pci 0000:00:02.0: No hypervisor support for SR-IOV on this device, IOV BARs disabled.
744s [    0.147646] pci 0000:00:03.0: No hypervisor support for SR-IOV on this device, IOV BARs disabled.
744s [    0.148064] pci 0000:00:04.0: No hypervisor support for SR-IOV on this device, IOV BARs disabled.
744s [    0.148473] pci 0000:00:05.0: No hypervisor support for SR-IOV on this device, IOV BARs disabled.
744s [    0.148861] pci 0000:00:06.0: No hypervisor support for SR-IOV on this device, IOV BARs disabled.
744s [    0.149207] pci 0000:00:07.0: No hypervisor support for SR-IOV on this device, IOV BARs disabled.
744s [    0.151422] IOMMU table initialized, virtual merging enabled
744s [    0.151791] pci_bus 0000:00: resource 4 [io  0x10000-0x1ffff]
744s [    0.151793] pci_bus 0000:00: resource 5 [mem 0x200080000000-0x2000ffffffff]
744s [    0.151795] pci_bus 0000:00: resource 6 [mem 0x210000000000-0x21ffffffffff 64bit]
744s [    0.151882] pci 0000:00:01.0: ibm,query-pe-dma-windows(2026) 800 8000000 20000000 returned 0, lb=80000000 ps=7 wn=1
744s [    0.151915] pci 0000:00:01.0: Adding to iommu group 0
744s [    0.152134] pci 0000:00:02.0: Adding to iommu group 0
744s [    0.152223] pci 0000:00:03.0: Adding to iommu group 0
744s [    0.152410] pci 0000:00:04.0: Adding to iommu group 0
744s [    0.152599] pci 0000:00:05.0: Adding to iommu group 0
744s [    0.152738] pci 0000:00:06.0: Adding to iommu group 0
744s [    0.152878] pci 0000:00:07.0: Adding to iommu group 0
744s [    0.152909] EEH: No capable adapters found: recovery disabled.
744s [    0.152974] pci 0000:00:07.0: vgaarb: setting as boot VGA device
744s [    0.152976] pci 0000:00:07.0: vgaarb: bridge control possible
744s [    0.152977] pci 0000:00:07.0: vgaarb: VGA device added: decodes=io+mem,owns=mem,locks=none
744s [    0.152979] vgaarb: loaded
744s [    0.153150] clocksource: Switched to clocksource timebase
744s [    0.162609] VFS: Disk quotas dquot_6.6.0
744s [    0.163032] VFS: Dquot-cache hash table entries: 8192 (order 0, 65536 bytes)
744s [    0.163475] AppArmor: AppArmor Filesystem Enabled
744s [    0.166407] NET: Registered PF_INET protocol family
744s [    0.166478] IP idents hash table entries: 65536 (order: 3, 524288 bytes, linear)
744s [    0.184071] tcp_listen_portaddr_hash hash table entries: 4096 (order: 0, 65536 bytes, linear)
744s [    0.184099] Table-perturb hash table entries: 65536 (order: 2, 262144 bytes, linear)
744s [    0.184139] TCP established hash table entries: 32768 (order: 2, 262144 bytes, linear)
744s [    0.184200] TCP bind hash table entries: 32768 (order: 4, 1048576 bytes, linear)
744s [    0.184267] TCP: Hash tables configured (established 32768 bind 32768)
744s [    0.184855] MPTCP token hash table entries: 4096 (order: 0, 98304 bytes, linear)
744s [    0.184928] UDP hash table entries: 2048 (order: 1, 131072 bytes, linear)
744s [    0.184957] UDP-Lite hash table entries: 2048 (order: 1, 131072 bytes, linear)
744s [    0.185523] NET: Registered PF_UNIX/PF_LOCAL protocol family
744s [    0.185549] NET: Registered PF_XDP protocol family
744s [    0.185867] PCI: CLS 0 bytes, default 128
744s [    0.185926] Trying to unpack rootfs image as initramfs...
744s [    0.211076] Initialise system trusted keyrings
744s [    0.211094] Key type blacklist registered
744s [    0.211172] workingset: timestamp_bits=38 max_order=16 bucket_order=0
744s [    0.211246] zbud: loaded
744s [    0.240181] squashfs: version 4.0 (2009/01/31) Phillip Lougher
744s [    0.249751] fuse: init (API version 7.42)
744s [    0.250099] integrity: Platform Keyring initialized
744s [    0.250109] integrity: Machine keyring initialized
744s [    0.262483] Key type asymmetric registered
744s [    0.262487] Asymmetric key parser 'x509' registered
744s [    0.262796] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 243)
744s [    0.266889] io scheduler mq-deadline registered
744s [    0.269003] ledtrig-cpu: registered to indicate activity on CPUs
744s [    0.269245] virtio-pci 0000:00:01.0: enabling device (0100 -> 0103)
744s [    0.269913] virtio-pci 0000:00:01.0: ibm,query-pe-dma-windows(2026) 800 8000000 20000000 returned 0, lb=80000000 ps=7 wn=1
744s [    0.270278] virtio-pci 0000:00:01.0: ibm,create-pe-dma-window(2027) 800 8000000 20000000 18 20 returned 0 (liobn = 0x80000001 starting addr = 8000000 0)
744s [    0.271020] virtio-pci 0000:00:03.0: enabling device (0100 -> 0103)
744s [    0.272186] virtio-pci 0000:00:04.0: enabling device (0100 -> 0103)
744s [    0.273352] virtio-pci 0000:00:05.0: enabling device (0100 -> 0103)
744s [    0.274393] virtio-pci 0000:00:06.0: enabling device (0100 -> 0103)
744s [    0.276363] printk: legacy console [hvc0] enabled
744s [    0.282806] Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled
744s [    0.435458] Freeing initrd memory: 56640K
744s [    0.438800] Non-volatile memory driver v1.3
744s [    0.438833] Linux agpgart interface v0.103
744s [    0.440767] loop: module loaded
744s [    0.440905] virtio_blk virtio2: 2/0/0 default/read/poll queues
744s [    0.441832] virtio_blk virtio2: [vda] 41943040 512-byte logical blocks (21.5 GB/20.0 GiB)
744s [    0.443130]  vda: vda1 vda2
744s [    0.443606] tun: Universal TUN/TAP device driver, 1.6
744s [    0.445502] PPP generic driver version 2.4.2
744s [    0.445890] xhci_hcd 0000:00:02.0: xHCI Host Controller
744s [    0.445922] xhci_hcd 0000:00:02.0: new USB bus registered, assigned bus number 1
744s [    0.446254] xhci_hcd 0000:00:02.0: hcc params 0x00087001 hci version 0x100 quirks 0x0000000000000010
744s [    0.446880] xhci_hcd 0000:00:02.0: xHCI Host Controller
744s [    0.446907] xhci_hcd 0000:00:02.0: new USB bus registered, assigned bus number 2
744s [    0.446942] xhci_hcd 0000:00:02.0: Host supports USB 3.0 SuperSpeed
744s [    0.447049] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.14
744s [    0.447085] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
744s [    0.447119] usb usb1: Product: xHCI Host Controller
744s [    0.447142] usb usb1: Manufacturer: Linux 6.14.0-10-generic xhci-hcd
744s [    0.447171] usb usb1: SerialNumber: 0000:00:02.0
744s [    0.447368] hub 1-0:1.0: USB hub found
744s [    0.447417] hub 1-0:1.0: 4 ports detected
744s [    0.447732] usb usb2: We don't know the algorithms for LPM for this host, disabling LPM.
744s [    0.447794] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.14
744s [    0.447829] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
744s [    0.447863] usb usb2: Product: xHCI Host Controller
744s [    0.447886] usb usb2: Manufacturer: Linux 6.14.0-10-generic xhci-hcd
744s [    0.447913] usb usb2: SerialNumber: 0000:00:02.0
744s [    0.448031] hub 2-0:1.0: USB hub found
744s [    0.448077] hub 2-0:1.0: 4 ports detected
744s [    0.448404] mousedev: PS/2 mouse device common for all mice
744s [    0.448517] rtc-generic rtc-generic: registered as rtc0
744s [    0.448553] rtc-generic rtc-generic: setting system clock to 2025-03-15T19:34:52 UTC (1742067292)
744s [    0.448600] i2c_dev: i2c /dev entries driver
744s [    0.448682] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
744s [    0.448778] device-mapper: uevent: version 1.0.3
744s [    0.448876] device-mapper: ioctl: 4.49.0-ioctl (2025-01-17) initialised: dm-devel@lists.linux.dev
744s [    0.448989] drop_monitor: Initializing network drop monitor service
744s [    0.450048] NET: Registered PF_INET6 protocol family
744s [    0.456140] Segment Routing with IPv6
744s [    0.456212] In-situ OAM (IOAM) with IPv6
744s [    0.456282] NET: Registered PF_PACKET protocol family
744s [    0.456432] Key type dns_resolver registered
744s [    0.456533] secvar-sysfs: Failed to retrieve secvar operations
744s [    0.458962] registered taskstats version 1
744s [    0.459276] Loading compiled-in X.509 certificates
744s [    0.460073] Loaded X.509 cert 'Build time autogenerated kernel key: 68f3ca1b0052badadc08d959a8508b900f1c01d7'
744s [    0.460685] Loaded X.509 cert 'Canonical Ltd. Live Patch Signing: 14df34d1a87cf37625abec039ef2bf521249b969'
744s [    0.461323] Loaded X.509 cert 'Canonical Ltd. Kernel Module Signing: 88f752e560a1e0737e31163a466ad7b70a850c19'
744s [    0.461369] blacklist: Loading compiled-in revocation X.509 certificates
744s [    0.461451] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing: 61482aa2830d0ab2ad5af10b7250da9033ddcef0'
744s [    0.461513] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2017): 242ade75ac4a15e50d50c84b0d45ff3eae707a03'
744s [    0.461573] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (ESM 2018): 365188c1d374d6b07c3c8f240f8ef722433d6a8b'
744s [    0.461652] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2019): c0746fd6c5da3ae827864651ad66ae47fe24b3e8'
750s [    0.461712] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v1): a8d54bbb3825cfb94fa13c9f8a594a195c107b8d'
750s [    0.461775] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v2): 4cf046892d6fd3c9a5b03f98d845f90851dc6a8c'
750s [    0.461834] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v3): 100437bb6de6e469b581e61cd66bce3ef4ed53af'
750s [    0.461902] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (Ubuntu Core 2019): c1d57b8f6b743f23ee41f4f7ee292f06eecadfb9'
750s [    0.468713] Demotion targets for Node 0: null
750s [    0.469885] Key type .fscrypt registered
750s [    0.469909] Key type fscrypt-provisioning registered
750s [    0.482522] Key type encrypted registered
750s [    0.482583] AppArmor: AppArmor sha256 policy hashing enabled
750s [    0.482632] Secure boot mode disabled
750s [    0.482653] ima: No TPM chip found, activating TPM-bypass!
750s [    0.482684] Loading compiled-in module X.509 certificates
750s [    0.483312] Loaded X.509 cert 'Build time autogenerated kernel key: 68f3ca1b0052badadc08d959a8508b900f1c01d7'
750s [    0.483361] ima: Allocated hash algorithm: sha256
750s [    0.483404] Secure boot mode disabled
750s [    0.483428] Trusted boot mode disabled
750s [    0.483446] ima: No architecture policies found
750s [    0.483487] evm: Initialising EVM extended attributes:
750s [    0.483510] evm: security.selinux
750s [    0.483528] evm: security.SMACK64
750s [    0.483545] evm: security.SMACK64EXEC
750s [    0.483562] evm: security.SMACK64TRANSMUTE
750s [    0.483579] evm: security.SMACK64MMAP
750s [    0.483597] evm: security.apparmor
750s [    0.483614] evm: security.ima
750s [    0.483631] evm: security.capability
750s [    0.483648] evm: HMAC attrs: 0x1
750s [    0.483682] SED: plpks not available
750s [    0.498405] clk: Disabling unused clocks
750s [    0.498457] PM: genpd: Disabling unused power domains
750s [    0.498653] integrity: Unable to open file: /etc/keys/x509_evm.der (-2)
750s [    0.501119] Freeing unused kernel image (initmem) memory: 8768K
750s [    0.501980] Checked W+X mappings: passed, no W+X pages found
750s [    0.502018] Run /init as init process
750s Loading, please wait...
750s Starting systemd-udevd version 257.3-1ubuntu3
750s [    0.616162] [drm] Found bochs VGA, ID 0xb0c5.
750s [    0.616211] [drm] Framebuffer size 16384 kB @ 0x200081000000, mmio @ 0x200082000000.
750s [    0.618362] random: crng init done
750s [    0.618769] virtio_net virtio0 enp0s1: renamed from eth0
750s [    0.619043] [drm] Initialized bochs-drm 1.0.0 for 0000:00:07.0 on minor 0
750s [    0.644530] fbcon: Deferring console take-over
750s [    0.644597] bochs-drm 0000:00:07.0: [drm] fb0: bochs-drmdrmfb frame buffer device
750s [    0.697178] usb 1-1: new high-speed USB device number 2 using xhci_hcd
750s [    0.834294] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00
750s [    0.834384] usb 1-1: New USB device strings: Mfr=1, Product=4, SerialNumber=11
750s [    0.834439] usb 1-1: Product: QEMU USB Keyboard
750s [    0.834477] usb 1-1: Manufacturer: QEMU
750s [    0.834507] usb 1-1: SerialNumber: 68284-pci@800000020000000:02.0-1
750s [    0.953218] usb 1-2: new high-speed USB device number 3 using xhci_hcd
750s [    1.089856] usb 1-2: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00
750s [    1.089916] usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=9
750s [    1.089951] usb 1-2: Product: QEMU USB Mouse
750s [    1.089976] usb 1-2: Manufacturer: QEMU
750s [    1.089996] usb 1-2: SerialNumber: 89126-pci@800000020000000:02.0-2
750s [    1.103843] hid: raw HID events driver (C) Jiri Kosina
750s [    1.111407] usbcore: registered new interface driver usbhid
750s [    1.111446] usbhid: USB HID core driver
750s [    1.114585] input: QEMU QEMU USB Keyboard as /devices/pci0000:00/0000:00:02.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input0
750s [    1.169590] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:02.0-1/input0
750s [    1.170000] input: QEMU QEMU USB Mouse as /devices/pci0000:00/0000:00:02.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input1
750s [    1.170432] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Mouse] on usb-0000:00:02.0-2/input0
750s Begin: Loading essential drivers ... done.
750s Begin: Running /scripts/init-premounnova [W] Timed out waiting for bd17a101-5efc-4e28-b5ae-9b5f6bb19ca7 to get deleted.
750s Unexpected error:
750s Traceback (most recent call last):
750s   File "/home/ubuntu/autopkgtest/virt/autopkgtest-virt-ssh", line 481, in hook_wait_reboot
750s     wait_port_down(sshconfig['hostname'], port, 300)
750s   File "/home/ubuntu/autopkgtest/virt/autopkgtest-virt-ssh", line 456, in wait_port_down
750s     time.sleep(0.1)
750s   File "/home/ubuntu/autopkgtest/lib/VirtSubproc.py", line 75, in alarm_handler
750s     raise Timeout(to)
750s VirtSubproc.Timeout: 300
750s 
750s During handling of the above exception, another exception occurred:
750s 
750s Traceback (most recent call last):
750s   File "/home/ubuntu/autopkgtest/lib/VirtSubproc.py", line 833, in mainloop
750s     command()
750s   File "/home/ubuntu/autopkgtest/lib/VirtSubproc.py", line 762, in command
750s     r = f(c, ce)
750s   File "/home/ubuntu/autopkgtest/lib/VirtSubproc.py", line 457, in cmd_reboot
750s     caller.hook_wait_reboot(**wait_reboot_args)
750s   File "/home/ubuntu/autopkgtest/virt/autopkgtest-virt-ssh", line 483, in hook_wait_reboot
750s     execute_setup_script('debug-failure', fail_ok=True)
750s   File "/home/ubuntu/autopkgtest/virt/autopkgtest-virt-ssh", line 209, in execute_setup_script
750s     sys.stderr.write(err)
750s BlockingIOError: [Errno 11] write could not complete without blocking
750s autopkgtest [19:40:48]: ERROR: testbed failure: unexpected eof from the testbed