0s autopkgtest [15:27:49]: starting date and time: 2025-11-12 15:27:49+0000 0s autopkgtest [15:27:49]: git checkout: 4b346b80 nova: make wait_reboot return success even when a no-op 0s autopkgtest [15:27:49]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.iuirx75i/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:linux-meta,src:linux --apt-upgrade casper --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=linux-meta/6.8.0-88.89 linux/6.8.0-88.89' --setup-commands 'apt-get install -y ^kernel-testing--linux--full--preferred$ || apt-get install -y ^linux-image$ ^linux-headers$ || apt-get install -y ^linux-image-generic$ ^linux-headers-generic$' --setup-commands 'apt-get install -y ^kernel-testing--linux--modules-extra--preferred$ || apt-get install -y ^linux-modules-extra$ || :' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-cpu2-ram4-disk20-amd64 --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@sto01-1.secgroup --name adt-noble-amd64-casper-20251112-152749-juju-7f2275-prod-proposed-migration-environment-15-c445b0ef-fef5-4eb1-a92c-14970eb43267 --image adt/ubuntu-noble-amd64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-15 --net-id=net_prod-autopkgtest-workers-amd64 -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 3s Creating nova instance adt-noble-amd64-casper-20251112-152749-juju-7f2275-prod-proposed-migration-environment-15-c445b0ef-fef5-4eb1-a92c-14970eb43267 from image adt/ubuntu-noble-amd64-server-20251112.img (UUID 40e20540-eedf-46a6-8124-40e8d42a6186)... 37s autopkgtest [15:28:26]: testbed dpkg architecture: amd64 37s autopkgtest [15:28:26]: testbed apt version: 2.8.3 37s autopkgtest [15:28:26]: @@@@@@@@@@@@@@@@@@@@ test bed setup 37s autopkgtest [15:28:26]: testbed release detected to be: None 38s autopkgtest [15:28:27]: updating testbed package index (apt update) 38s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [265 kB] 38s Hit:2 http://ftpmaster.internal/ubuntu noble InRelease 38s Hit:3 http://ftpmaster.internal/ubuntu noble-updates InRelease 38s Hit:4 http://ftpmaster.internal/ubuntu noble-security InRelease 38s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [9156 B] 38s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [44.3 kB] 38s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [42.6 kB] 38s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [90.6 kB] 38s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 Packages [478 kB] 38s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/main i386 Packages [82.5 kB] 38s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 c-n-f Metadata [2380 B] 38s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/restricted i386 Packages [21.0 kB] 38s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/restricted amd64 Packages [1011 kB] 39s Get:14 http://ftpmaster.internal/ubuntu noble-proposed/restricted amd64 c-n-f Metadata [444 B] 39s Get:15 http://ftpmaster.internal/ubuntu noble-proposed/universe i386 Packages [51.2 kB] 39s Get:16 http://ftpmaster.internal/ubuntu noble-proposed/universe amd64 Packages [111 kB] 39s Get:17 http://ftpmaster.internal/ubuntu noble-proposed/universe amd64 c-n-f Metadata [2328 B] 39s Get:18 http://ftpmaster.internal/ubuntu noble-proposed/multiverse i386 Packages [752 B] 39s Get:19 http://ftpmaster.internal/ubuntu noble-proposed/multiverse amd64 Packages [5288 B] 39s Get:20 http://ftpmaster.internal/ubuntu noble-proposed/multiverse amd64 c-n-f Metadata [284 B] 40s Fetched 2218 kB in 1s (2484 kB/s) 40s Reading package lists... 41s Hit:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease 41s Hit:2 http://ftpmaster.internal/ubuntu noble InRelease 41s Hit:3 http://ftpmaster.internal/ubuntu noble-updates InRelease 41s Hit:4 http://ftpmaster.internal/ubuntu noble-security InRelease 42s Reading package lists... 42s Reading package lists... 42s Building dependency tree... 42s Reading state information... 42s Calculating upgrade... 42s The following NEW packages will be installed: 42s linux-headers-6.8.0-88 linux-headers-6.8.0-88-generic 42s linux-image-6.8.0-88-generic linux-modules-6.8.0-88-generic 42s linux-modules-extra-6.8.0-88-generic linux-tools-6.8.0-88 42s linux-tools-6.8.0-88-generic 42s The following packages will be upgraded: 42s linux-generic linux-headers-generic linux-headers-virtual 42s linux-image-generic linux-image-virtual linux-libc-dev linux-tools-common 42s linux-virtual 42s 8 upgraded, 7 newly installed, 0 to remove and 0 not upgraded. 42s Need to get 194 MB of archives. 42s After this operation, 302 MB of additional disk space will be used. 42s Get:1 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 linux-modules-6.8.0-88-generic amd64 6.8.0-88.89 [39.4 MB] 44s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 linux-image-6.8.0-88-generic amd64 6.8.0-88.89 [14.8 MB] 44s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 linux-modules-extra-6.8.0-88-generic amd64 6.8.0-88.89 [113 MB] 46s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 linux-generic amd64 6.8.0-88.89 [1700 B] 46s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 linux-image-generic amd64 6.8.0-88.89 [11.0 kB] 46s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 linux-virtual amd64 6.8.0-88.89 [1698 B] 46s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 linux-image-virtual amd64 6.8.0-88.89 [10.9 kB] 46s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 linux-headers-virtual amd64 6.8.0-88.89 [1650 B] 46s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 linux-headers-6.8.0-88 all 6.8.0-88.89 [14.0 MB] 46s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 linux-headers-6.8.0-88-generic amd64 6.8.0-88.89 [4164 kB] 46s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 linux-headers-generic amd64 6.8.0-88.89 [10.8 kB] 46s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 linux-libc-dev amd64 6.8.0-88.89 [1932 kB] 47s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 linux-tools-common all 6.8.0-88.89 [773 kB] 47s Get:14 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 linux-tools-6.8.0-88 amd64 6.8.0-88.89 [5433 kB] 47s Get:15 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 linux-tools-6.8.0-88-generic amd64 6.8.0-88.89 [1814 B] 47s debconf: unable to initialize frontend: Dialog 47s debconf: (Dialog frontend will not work on a dumb terminal, an emacs shell buffer, or without a controlling terminal.) 47s debconf: falling back to frontend: Readline 47s debconf: unable to initialize frontend: Readline 47s debconf: (This frontend requires a controlling tty.) 47s debconf: falling back to frontend: Teletype 47s dpkg-preconfigure: unable to re-open stdin: 47s Fetched 194 MB in 5s (41.8 MB/s) 47s Selecting previously unselected package linux-modules-6.8.0-88-generic. 47s (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 ... 74790 files and directories currently installed.) 47s Preparing to unpack .../00-linux-modules-6.8.0-88-generic_6.8.0-88.89_amd64.deb ... 47s Unpacking linux-modules-6.8.0-88-generic (6.8.0-88.89) ... 47s Selecting previously unselected package linux-image-6.8.0-88-generic. 47s Preparing to unpack .../01-linux-image-6.8.0-88-generic_6.8.0-88.89_amd64.deb ... 47s Unpacking linux-image-6.8.0-88-generic (6.8.0-88.89) ... 48s Selecting previously unselected package linux-modules-extra-6.8.0-88-generic. 48s Preparing to unpack .../02-linux-modules-extra-6.8.0-88-generic_6.8.0-88.89_amd64.deb ... 48s Unpacking linux-modules-extra-6.8.0-88-generic (6.8.0-88.89) ... 49s Preparing to unpack .../03-linux-generic_6.8.0-88.89_amd64.deb ... 49s Unpacking linux-generic (6.8.0-88.89) over (6.8.0-87.88) ... 49s Preparing to unpack .../04-linux-image-generic_6.8.0-88.89_amd64.deb ... 49s Unpacking linux-image-generic (6.8.0-88.89) over (6.8.0-87.88) ... 49s Preparing to unpack .../05-linux-virtual_6.8.0-88.89_amd64.deb ... 49s Unpacking linux-virtual (6.8.0-88.89) over (6.8.0-87.88) ... 49s Preparing to unpack .../06-linux-image-virtual_6.8.0-88.89_amd64.deb ... 49s Unpacking linux-image-virtual (6.8.0-88.89) over (6.8.0-87.88) ... 49s Preparing to unpack .../07-linux-headers-virtual_6.8.0-88.89_amd64.deb ... 49s Unpacking linux-headers-virtual (6.8.0-88.89) over (6.8.0-87.88) ... 49s Selecting previously unselected package linux-headers-6.8.0-88. 49s Preparing to unpack .../08-linux-headers-6.8.0-88_6.8.0-88.89_all.deb ... 49s Unpacking linux-headers-6.8.0-88 (6.8.0-88.89) ... 51s Selecting previously unselected package linux-headers-6.8.0-88-generic. 51s Preparing to unpack .../09-linux-headers-6.8.0-88-generic_6.8.0-88.89_amd64.deb ... 51s Unpacking linux-headers-6.8.0-88-generic (6.8.0-88.89) ... 52s Preparing to unpack .../10-linux-headers-generic_6.8.0-88.89_amd64.deb ... 52s Unpacking linux-headers-generic (6.8.0-88.89) over (6.8.0-87.88) ... 52s Preparing to unpack .../11-linux-libc-dev_6.8.0-88.89_amd64.deb ... 52s Unpacking linux-libc-dev:amd64 (6.8.0-88.89) over (6.8.0-87.88) ... 52s Preparing to unpack .../12-linux-tools-common_6.8.0-88.89_all.deb ... 52s Unpacking linux-tools-common (6.8.0-88.89) over (6.8.0-87.88) ... 52s Selecting previously unselected package linux-tools-6.8.0-88. 52s Preparing to unpack .../13-linux-tools-6.8.0-88_6.8.0-88.89_amd64.deb ... 52s Unpacking linux-tools-6.8.0-88 (6.8.0-88.89) ... 53s Selecting previously unselected package linux-tools-6.8.0-88-generic. 53s Preparing to unpack .../14-linux-tools-6.8.0-88-generic_6.8.0-88.89_amd64.deb ... 53s Unpacking linux-tools-6.8.0-88-generic (6.8.0-88.89) ... 53s Setting up linux-libc-dev:amd64 (6.8.0-88.89) ... 53s Setting up linux-headers-6.8.0-88 (6.8.0-88.89) ... 53s Setting up linux-modules-6.8.0-88-generic (6.8.0-88.89) ... 54s Setting up linux-tools-common (6.8.0-88.89) ... 54s Setting up linux-image-6.8.0-88-generic (6.8.0-88.89) ... 55s I: /boot/vmlinuz is now a symlink to vmlinuz-6.8.0-88-generic 55s I: /boot/initrd.img is now a symlink to initrd.img-6.8.0-88-generic 55s Setting up linux-modules-extra-6.8.0-88-generic (6.8.0-88.89) ... 57s Setting up linux-tools-6.8.0-88 (6.8.0-88.89) ... 57s Setting up linux-headers-6.8.0-88-generic (6.8.0-88.89) ... 57s Setting up linux-image-virtual (6.8.0-88.89) ... 57s Setting up linux-image-generic (6.8.0-88.89) ... 57s Setting up linux-tools-6.8.0-88-generic (6.8.0-88.89) ... 57s Setting up linux-headers-generic (6.8.0-88.89) ... 57s Setting up linux-headers-virtual (6.8.0-88.89) ... 57s Setting up linux-generic (6.8.0-88.89) ... 57s Setting up linux-virtual (6.8.0-88.89) ... 57s Processing triggers for man-db (2.12.0-4build2) ... 57s Processing triggers for linux-image-6.8.0-88-generic (6.8.0-88.89) ... 57s /etc/kernel/postinst.d/initramfs-tools: 57s update-initramfs: Generating /boot/initrd.img-6.8.0-88-generic 62s /etc/kernel/postinst.d/zz-update-grub: 62s Sourcing file `/etc/default/grub' 62s Sourcing file `/etc/default/grub.d/50-cloudimg-settings.cfg' 62s Sourcing file `/etc/default/grub.d/90-autopkgtest.cfg' 62s Generating grub configuration file ... 62s Found linux image: /boot/vmlinuz-6.8.0-88-generic 62s Found initrd image: /boot/initrd.img-6.8.0-88-generic 62s Found linux image: /boot/vmlinuz-6.8.0-87-generic 62s Found initrd image: /boot/initrd.img-6.8.0-87-generic 62s Warning: os-prober will not be executed to detect other bootable partitions. 62s Systems on them will not be added to the GRUB boot configuration. 62s Check GRUB_DISABLE_OS_PROBER documentation entry. 62s Adding boot menu entry for UEFI Firmware Settings ... 62s done 63s Reading package lists... 63s Building dependency tree... 63s Reading state information... 63s The following additional packages will be installed: 63s libdbus-glib-1-2 libduktape207 libimobiledevice6 libplist-2.0-4 63s libupower-glib3 libusbmuxd6 linux-headers-generic-6.8 63s linux-image-generic-6.8 polkitd sgml-base thermald upower usbmuxd xml-core 63s Suggested packages: 63s libusbmuxd-tools polkitd-pkla sgml-base-doc debhelper 63s The following NEW packages will be installed: 63s libdbus-glib-1-2 libduktape207 libimobiledevice6 libplist-2.0-4 63s libupower-glib3 libusbmuxd6 linux-generic-6.8 linux-headers-generic-6.8 63s linux-image-generic-6.8 polkitd sgml-base thermald upower usbmuxd xml-core 63s 0 upgraded, 15 newly installed, 0 to remove and 0 not upgraded. 63s Need to get 875 kB of archives. 63s After this operation, 2992 kB of additional disk space will be used. 63s Get:1 http://ftpmaster.internal/ubuntu noble/main amd64 sgml-base all 1.31 [11.4 kB] 63s Get:2 http://ftpmaster.internal/ubuntu noble/main amd64 libdbus-glib-1-2 amd64 0.112-3build2 [64.2 kB] 63s Get:3 http://ftpmaster.internal/ubuntu noble/main amd64 libduktape207 amd64 2.7.0+tests-0ubuntu3 [143 kB] 63s Get:4 http://ftpmaster.internal/ubuntu noble/main amd64 libplist-2.0-4 amd64 2.3.0-1~exp2build2 [48.0 kB] 63s Get:5 http://ftpmaster.internal/ubuntu noble/main amd64 libusbmuxd6 amd64 2.0.2-4build3 [20.3 kB] 63s Get:6 http://ftpmaster.internal/ubuntu noble/main amd64 libimobiledevice6 amd64 1.3.0-8.1build3 [70.3 kB] 63s Get:7 http://ftpmaster.internal/ubuntu noble/main amd64 libupower-glib3 amd64 1.90.3-1 [39.0 kB] 63s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 linux-image-generic-6.8 amd64 6.8.0-88.89 [11.0 kB] 63s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 linux-headers-generic-6.8 amd64 6.8.0-88.89 [10.8 kB] 63s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 linux-generic-6.8 amd64 6.8.0-88.89 [1746 B] 63s Get:11 http://ftpmaster.internal/ubuntu noble/main amd64 xml-core all 0.19 [20.3 kB] 63s Get:12 http://ftpmaster.internal/ubuntu noble-updates/main amd64 polkitd amd64 124-2ubuntu1.24.04.2 [95.2 kB] 63s Get:13 http://ftpmaster.internal/ubuntu noble-updates/main amd64 thermald amd64 2.5.6-2ubuntu0.24.04.2 [213 kB] 63s Get:14 http://ftpmaster.internal/ubuntu noble/main amd64 upower amd64 1.90.3-1 [84.4 kB] 63s Get:15 http://ftpmaster.internal/ubuntu noble/main amd64 usbmuxd amd64 1.1.1-5~exp3ubuntu2 [42.0 kB] 63s debconf: unable to initialize frontend: Dialog 63s debconf: (Dialog frontend will not work on a dumb terminal, an emacs shell buffer, or without a controlling terminal.) 63s debconf: falling back to frontend: Readline 63s debconf: unable to initialize frontend: Readline 63s debconf: (This frontend requires a controlling tty.) 63s debconf: falling back to frontend: Teletype 63s dpkg-preconfigure: unable to re-open stdin: 63s Fetched 875 kB in 0s (5123 kB/s) 63s Selecting previously unselected package sgml-base. 63s (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 ... 112796 files and directories currently installed.) 63s Preparing to unpack .../00-sgml-base_1.31_all.deb ... 63s Unpacking sgml-base (1.31) ... 64s Selecting previously unselected package libdbus-glib-1-2:amd64. 64s Preparing to unpack .../01-libdbus-glib-1-2_0.112-3build2_amd64.deb ... 64s Unpacking libdbus-glib-1-2:amd64 (0.112-3build2) ... 64s Selecting previously unselected package libduktape207:amd64. 64s Preparing to unpack .../02-libduktape207_2.7.0+tests-0ubuntu3_amd64.deb ... 64s Unpacking libduktape207:amd64 (2.7.0+tests-0ubuntu3) ... 64s Selecting previously unselected package libplist-2.0-4:amd64. 64s Preparing to unpack .../03-libplist-2.0-4_2.3.0-1~exp2build2_amd64.deb ... 64s Unpacking libplist-2.0-4:amd64 (2.3.0-1~exp2build2) ... 64s Selecting previously unselected package libusbmuxd6:amd64. 64s Preparing to unpack .../04-libusbmuxd6_2.0.2-4build3_amd64.deb ... 64s Unpacking libusbmuxd6:amd64 (2.0.2-4build3) ... 64s Selecting previously unselected package libimobiledevice6:amd64. 64s Preparing to unpack .../05-libimobiledevice6_1.3.0-8.1build3_amd64.deb ... 64s Unpacking libimobiledevice6:amd64 (1.3.0-8.1build3) ... 64s Selecting previously unselected package libupower-glib3:amd64. 64s Preparing to unpack .../06-libupower-glib3_1.90.3-1_amd64.deb ... 64s Unpacking libupower-glib3:amd64 (1.90.3-1) ... 64s Selecting previously unselected package linux-image-generic-6.8. 64s Preparing to unpack .../07-linux-image-generic-6.8_6.8.0-88.89_amd64.deb ... 64s Unpacking linux-image-generic-6.8 (6.8.0-88.89) ... 64s Selecting previously unselected package linux-headers-generic-6.8. 64s Preparing to unpack .../08-linux-headers-generic-6.8_6.8.0-88.89_amd64.deb ... 64s Unpacking linux-headers-generic-6.8 (6.8.0-88.89) ... 64s Selecting previously unselected package linux-generic-6.8. 64s Preparing to unpack .../09-linux-generic-6.8_6.8.0-88.89_amd64.deb ... 64s Unpacking linux-generic-6.8 (6.8.0-88.89) ... 64s Selecting previously unselected package xml-core. 64s Preparing to unpack .../10-xml-core_0.19_all.deb ... 64s Unpacking xml-core (0.19) ... 64s Selecting previously unselected package polkitd. 64s Preparing to unpack .../11-polkitd_124-2ubuntu1.24.04.2_amd64.deb ... 64s Unpacking polkitd (124-2ubuntu1.24.04.2) ... 64s Selecting previously unselected package thermald. 64s Preparing to unpack .../12-thermald_2.5.6-2ubuntu0.24.04.2_amd64.deb ... 64s Unpacking thermald (2.5.6-2ubuntu0.24.04.2) ... 64s Selecting previously unselected package upower. 64s Preparing to unpack .../13-upower_1.90.3-1_amd64.deb ... 64s Unpacking upower (1.90.3-1) ... 64s Selecting previously unselected package usbmuxd. 64s Preparing to unpack .../14-usbmuxd_1.1.1-5~exp3ubuntu2_amd64.deb ... 64s info: The home dir /var/lib/usbmux you specified can't be accessed: No such file or directory 64s 64s info: Selecting UID from range 100 to 999 ... 64s 64s info: Adding system user `usbmux' (UID 108) ... 64s info: Adding new user `usbmux' (UID 108) with group `plugdev' ... 64s info: Not creating home directory `/var/lib/usbmux'. 64s Unpacking usbmuxd (1.1.1-5~exp3ubuntu2) ... 64s Setting up linux-headers-generic-6.8 (6.8.0-88.89) ... 64s Setting up linux-image-generic-6.8 (6.8.0-88.89) ... 64s Setting up libdbus-glib-1-2:amd64 (0.112-3build2) ... 64s Setting up linux-generic-6.8 (6.8.0-88.89) ... 64s Setting up libplist-2.0-4:amd64 (2.3.0-1~exp2build2) ... 64s Setting up libduktape207:amd64 (2.7.0+tests-0ubuntu3) ... 64s Setting up libusbmuxd6:amd64 (2.0.2-4build3) ... 64s Setting up libupower-glib3:amd64 (1.90.3-1) ... 64s Setting up sgml-base (1.31) ... 64s Setting up libimobiledevice6:amd64 (1.3.0-8.1build3) ... 64s Setting up thermald (2.5.6-2ubuntu0.24.04.2) ... 64s Created symlink /etc/systemd/system/dbus-org.freedesktop.thermald.service → /usr/lib/systemd/system/thermald.service. 64s Created symlink /etc/systemd/system/multi-user.target.wants/thermald.service → /usr/lib/systemd/system/thermald.service. 64s Setting up upower (1.90.3-1) ... 65s upower.service is a disabled or a static unit, not starting it. 65s Setting up usbmuxd (1.1.1-5~exp3ubuntu2) ... 65s usbmuxd.service is a disabled or a static unit, not starting it. 65s Setting up xml-core (0.19) ... 65s Processing triggers for libc-bin (2.39-0ubuntu8.6) ... 65s Processing triggers for man-db (2.12.0-4build2) ... 66s Processing triggers for dbus (1.14.10-4ubuntu4.1) ... 66s Processing triggers for udev (255.4-1ubuntu8.11) ... 66s Processing triggers for sgml-base (1.31) ... 66s Setting up polkitd (124-2ubuntu1.24.04.2) ... 66s Reading package lists... 67s Building dependency tree... 67s Reading state information... 67s E: Unable to locate package ^kernel-testing--linux--modules-extra--preferred$ 67s E: Couldn't find any package by regex '^kernel-testing--linux--modules-extra--preferred$' 67s Reading package lists... 67s Building dependency tree... 67s Reading state information... 67s E: Unable to locate package ^linux-modules-extra$ 67s E: Couldn't find any package by regex '^linux-modules-extra$' 67s autopkgtest [15:28:56]: upgrading testbed (apt dist-upgrade and autopurge) 67s Reading package lists... 67s Building dependency tree... 67s Reading state information... 68s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 68s Starting 2 pkgProblemResolver with broken count: 0 68s Done 68s Entering ResolveByKeep 68s 68s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 68s Reading package lists... 69s Building dependency tree... 69s Reading state information... 69s Starting pkgProblemResolver with broken count: 0 69s Starting 2 pkgProblemResolver with broken count: 0 69s Done 69s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 69s autopkgtest [15:28:58]: rebooting testbed after setup commands that affected boot 95s autopkgtest [15:29:24]: testbed running kernel: Linux 6.8.0-88-generic #89-Ubuntu SMP PREEMPT_DYNAMIC Sat Oct 11 01:02:46 UTC 2025 98s autopkgtest [15:29:27]: @@@@@@@@@@@@@@@@@@@@ apt-source casper 99s Get:1 http://ftpmaster.internal/ubuntu noble/main casper 1.498 (dsc) [1742 B] 99s Get:2 http://ftpmaster.internal/ubuntu noble/main casper 1.498 (tar) [107 kB] 99s gpgv: Signature made Thu Apr 18 22:28:05 2024 UTC 99s gpgv: using RSA key 5C7ABEA20F8630459CC8C8B5E27F2CF8458C2FA4 99s gpgv: Can't check signature: No public key 99s dpkg-source: warning: cannot verify inline signature for ./casper_1.498.dsc: no acceptable signature found 99s autopkgtest [15:29:28]: testing package casper version 1.498 100s autopkgtest [15:29:29]: build not needed 100s autopkgtest [15:29:29]: test boot: preparing testbed 100s Reading package lists... 100s Building dependency tree... 100s Reading state information... 101s Starting pkgProblemResolver with broken count: 0 101s Starting 2 pkgProblemResolver with broken count: 0 101s Done 101s The following NEW packages will be installed: 101s acl casper cifs-utils finalrd ipxe-qemu libasound2-data libasound2t64 101s libbrlapi0.8 libcacard0 libdaxctl1 libfdt1 libndctl6 libpcsclite1 101s libpixman-1-0 libpmem1 librdmacm1t64 libslirp0 libtalloc2 liburing2 101s libusbredirparser1t64 libwbclient0 localechooser-data qemu-system 101s qemu-system-arm qemu-system-common qemu-system-data qemu-system-mips 101s qemu-system-misc qemu-system-ppc qemu-system-s390x qemu-system-sparc 101s qemu-system-x86 seabios squashfs-tools user-setup 101s 0 upgraded, 35 newly installed, 0 to remove and 0 not upgraded. 101s Need to get 122 MB of archives. 101s After this operation, 510 MB of additional disk space will be used. 101s Get:1 http://ftpmaster.internal/ubuntu noble-updates/main amd64 acl amd64 2.3.2-1build1.1 [39.4 kB] 101s Get:2 http://ftpmaster.internal/ubuntu noble/main amd64 libtalloc2 amd64 2.4.2-1build2 [27.3 kB] 101s Get:3 http://ftpmaster.internal/ubuntu noble-updates/main amd64 libwbclient0 amd64 2:4.19.5+dfsg-4ubuntu9.4 [71.7 kB] 101s Get:4 http://ftpmaster.internal/ubuntu noble-updates/main amd64 cifs-utils amd64 2:7.0-2ubuntu0.2 [96.6 kB] 101s Get:5 http://ftpmaster.internal/ubuntu noble/main amd64 finalrd all 9build1 [7306 B] 101s Get:6 http://ftpmaster.internal/ubuntu noble/main amd64 ipxe-qemu all 1.21.1+git-20220113.fbbdc3926-0ubuntu2 [1565 kB] 102s Get:7 http://ftpmaster.internal/ubuntu noble-updates/main amd64 libasound2-data all 1.2.11-1ubuntu0.1 [21.1 kB] 102s Get:8 http://ftpmaster.internal/ubuntu noble-updates/main amd64 libasound2t64 amd64 1.2.11-1ubuntu0.1 [399 kB] 102s Get:9 http://ftpmaster.internal/ubuntu noble/main amd64 libbrlapi0.8 amd64 6.6-4ubuntu5 [31.4 kB] 102s Get:10 http://ftpmaster.internal/ubuntu noble/main amd64 libpcsclite1 amd64 2.0.3-1build1 [21.4 kB] 102s Get:11 http://ftpmaster.internal/ubuntu noble/main amd64 libcacard0 amd64 1:2.8.0-3build4 [36.5 kB] 102s Get:12 http://ftpmaster.internal/ubuntu noble/main amd64 libdaxctl1 amd64 77-2ubuntu2 [21.4 kB] 102s Get:13 http://ftpmaster.internal/ubuntu noble/main amd64 libndctl6 amd64 77-2ubuntu2 [62.8 kB] 102s Get:14 http://ftpmaster.internal/ubuntu noble/main amd64 libpixman-1-0 amd64 0.42.2-1build1 [279 kB] 102s Get:15 http://ftpmaster.internal/ubuntu noble/main amd64 libpmem1 amd64 1.13.1-1.1ubuntu2 [84.8 kB] 102s Get:16 http://ftpmaster.internal/ubuntu noble-updates/main amd64 librdmacm1t64 amd64 50.0-2ubuntu0.2 [70.7 kB] 102s Get:17 http://ftpmaster.internal/ubuntu noble/main amd64 libslirp0 amd64 4.7.0-1ubuntu3 [63.8 kB] 102s Get:18 http://ftpmaster.internal/ubuntu noble/main amd64 liburing2 amd64 2.5-1build1 [21.1 kB] 102s Get:19 http://ftpmaster.internal/ubuntu noble/main amd64 libusbredirparser1t64 amd64 0.13.0-2.1build1 [16.5 kB] 102s Get:20 http://ftpmaster.internal/ubuntu noble/main amd64 localechooser-data all 2.89ubuntu6 [153 kB] 102s Get:21 http://ftpmaster.internal/ubuntu noble/main amd64 libfdt1 amd64 1.7.0-2build1 [20.1 kB] 102s Get:22 http://ftpmaster.internal/ubuntu noble-updates/main amd64 qemu-system-common amd64 1:8.2.2+ds-0ubuntu1.10 [1254 kB] 102s Get:23 http://ftpmaster.internal/ubuntu noble-updates/main amd64 qemu-system-data all 1:8.2.2+ds-0ubuntu1.10 [1794 kB] 103s Get:24 http://ftpmaster.internal/ubuntu noble-updates/main amd64 qemu-system-arm amd64 1:8.2.2+ds-0ubuntu1.10 [10.9 MB] 104s Get:25 http://ftpmaster.internal/ubuntu noble-updates/main amd64 qemu-system-mips amd64 1:8.2.2+ds-0ubuntu1.10 [16.3 MB] 104s Get:26 http://ftpmaster.internal/ubuntu noble-updates/main amd64 qemu-system-ppc amd64 1:8.2.2+ds-0ubuntu1.10 [9106 kB] 105s Get:27 http://ftpmaster.internal/ubuntu noble-updates/main amd64 qemu-system-sparc amd64 1:8.2.2+ds-0ubuntu1.10 [6294 kB] 105s Get:28 http://ftpmaster.internal/ubuntu noble/main amd64 seabios all 1.16.3-2 [175 kB] 105s Get:29 http://ftpmaster.internal/ubuntu noble-updates/main amd64 qemu-system-x86 amd64 1:8.2.2+ds-0ubuntu1.10 [11.2 MB] 106s Get:30 http://ftpmaster.internal/ubuntu noble-updates/main amd64 qemu-system-s390x amd64 1:8.2.2+ds-0ubuntu1.10 [3434 kB] 106s Get:31 http://ftpmaster.internal/ubuntu noble-updates/main amd64 qemu-system-misc amd64 1:8.2.2+ds-0ubuntu1.10 [57.8 MB] 109s Get:32 http://ftpmaster.internal/ubuntu noble-updates/main amd64 qemu-system amd64 1:8.2.2+ds-0ubuntu1.10 [57.4 kB] 109s Get:33 http://ftpmaster.internal/ubuntu noble/main amd64 squashfs-tools amd64 1:4.6.1-1build1 [189 kB] 109s Get:34 http://ftpmaster.internal/ubuntu noble/main amd64 user-setup all 1.95ubuntu1 [138 kB] 109s Get:35 http://ftpmaster.internal/ubuntu noble/main amd64 casper amd64 1.498 [58.0 kB] 109s Preconfiguring packages ... 109s debconf: Unknown template field 'help', in stanza #4 of /var/cache/debconf/tmp.ci/localechooser-data.template.qWIaMh 109s 109s debconf: Unknown template field 'help', in stanza #28 of /var/cache/debconf/tmp.ci/localechooser-data.template.qWIaMh 109s 109s debconf: Unknown template field 'help', in stanza #31 of /var/cache/debconf/tmp.ci/localechooser-data.template.qWIaMh 109s 109s Fetched 122 MB in 8s (15.9 MB/s) 109s Selecting previously unselected package acl. 109s (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 ... 112993 files and directories currently installed.) 109s Preparing to unpack .../00-acl_2.3.2-1build1.1_amd64.deb ... 109s Unpacking acl (2.3.2-1build1.1) ... 109s Selecting previously unselected package libtalloc2:amd64. 109s Preparing to unpack .../01-libtalloc2_2.4.2-1build2_amd64.deb ... 109s Unpacking libtalloc2:amd64 (2.4.2-1build2) ... 109s Selecting previously unselected package libwbclient0:amd64. 109s Preparing to unpack .../02-libwbclient0_2%3a4.19.5+dfsg-4ubuntu9.4_amd64.deb ... 109s Unpacking libwbclient0:amd64 (2:4.19.5+dfsg-4ubuntu9.4) ... 109s Selecting previously unselected package cifs-utils. 109s Preparing to unpack .../03-cifs-utils_2%3a7.0-2ubuntu0.2_amd64.deb ... 109s Unpacking cifs-utils (2:7.0-2ubuntu0.2) ... 109s Selecting previously unselected package finalrd. 109s Preparing to unpack .../04-finalrd_9build1_all.deb ... 109s Unpacking finalrd (9build1) ... 109s Selecting previously unselected package ipxe-qemu. 109s Preparing to unpack .../05-ipxe-qemu_1.21.1+git-20220113.fbbdc3926-0ubuntu2_all.deb ... 109s Unpacking ipxe-qemu (1.21.1+git-20220113.fbbdc3926-0ubuntu2) ... 109s Selecting previously unselected package libasound2-data. 109s Preparing to unpack .../06-libasound2-data_1.2.11-1ubuntu0.1_all.deb ... 109s Unpacking libasound2-data (1.2.11-1ubuntu0.1) ... 109s Selecting previously unselected package libasound2t64:amd64. 109s Preparing to unpack .../07-libasound2t64_1.2.11-1ubuntu0.1_amd64.deb ... 109s Unpacking libasound2t64:amd64 (1.2.11-1ubuntu0.1) ... 109s Selecting previously unselected package libbrlapi0.8:amd64. 109s Preparing to unpack .../08-libbrlapi0.8_6.6-4ubuntu5_amd64.deb ... 109s Unpacking libbrlapi0.8:amd64 (6.6-4ubuntu5) ... 109s Selecting previously unselected package libpcsclite1:amd64. 109s Preparing to unpack .../09-libpcsclite1_2.0.3-1build1_amd64.deb ... 109s Unpacking libpcsclite1:amd64 (2.0.3-1build1) ... 109s Selecting previously unselected package libcacard0:amd64. 109s Preparing to unpack .../10-libcacard0_1%3a2.8.0-3build4_amd64.deb ... 109s Unpacking libcacard0:amd64 (1:2.8.0-3build4) ... 109s Selecting previously unselected package libdaxctl1:amd64. 109s Preparing to unpack .../11-libdaxctl1_77-2ubuntu2_amd64.deb ... 109s Unpacking libdaxctl1:amd64 (77-2ubuntu2) ... 109s Selecting previously unselected package libndctl6:amd64. 109s Preparing to unpack .../12-libndctl6_77-2ubuntu2_amd64.deb ... 109s Unpacking libndctl6:amd64 (77-2ubuntu2) ... 109s Selecting previously unselected package libpixman-1-0:amd64. 109s Preparing to unpack .../13-libpixman-1-0_0.42.2-1build1_amd64.deb ... 109s Unpacking libpixman-1-0:amd64 (0.42.2-1build1) ... 109s Selecting previously unselected package libpmem1:amd64. 109s Preparing to unpack .../14-libpmem1_1.13.1-1.1ubuntu2_amd64.deb ... 109s Unpacking libpmem1:amd64 (1.13.1-1.1ubuntu2) ... 109s Selecting previously unselected package librdmacm1t64:amd64. 109s Preparing to unpack .../15-librdmacm1t64_50.0-2ubuntu0.2_amd64.deb ... 109s Unpacking librdmacm1t64:amd64 (50.0-2ubuntu0.2) ... 109s Selecting previously unselected package libslirp0:amd64. 109s Preparing to unpack .../16-libslirp0_4.7.0-1ubuntu3_amd64.deb ... 109s Unpacking libslirp0:amd64 (4.7.0-1ubuntu3) ... 109s Selecting previously unselected package liburing2:amd64. 109s Preparing to unpack .../17-liburing2_2.5-1build1_amd64.deb ... 109s Unpacking liburing2:amd64 (2.5-1build1) ... 109s Selecting previously unselected package libusbredirparser1t64:amd64. 109s Preparing to unpack .../18-libusbredirparser1t64_0.13.0-2.1build1_amd64.deb ... 109s Unpacking libusbredirparser1t64:amd64 (0.13.0-2.1build1) ... 109s Selecting previously unselected package localechooser-data. 109s Preparing to unpack .../19-localechooser-data_2.89ubuntu6_all.deb ... 109s Unpacking localechooser-data (2.89ubuntu6) ... 109s Selecting previously unselected package libfdt1:amd64. 109s Preparing to unpack .../20-libfdt1_1.7.0-2build1_amd64.deb ... 109s Unpacking libfdt1:amd64 (1.7.0-2build1) ... 109s Selecting previously unselected package qemu-system-common. 109s Preparing to unpack .../21-qemu-system-common_1%3a8.2.2+ds-0ubuntu1.10_amd64.deb ... 109s Unpacking qemu-system-common (1:8.2.2+ds-0ubuntu1.10) ... 110s Selecting previously unselected package qemu-system-data. 110s Preparing to unpack .../22-qemu-system-data_1%3a8.2.2+ds-0ubuntu1.10_all.deb ... 110s Unpacking qemu-system-data (1:8.2.2+ds-0ubuntu1.10) ... 110s Selecting previously unselected package qemu-system-arm. 110s Preparing to unpack .../23-qemu-system-arm_1%3a8.2.2+ds-0ubuntu1.10_amd64.deb ... 110s Unpacking qemu-system-arm (1:8.2.2+ds-0ubuntu1.10) ... 110s Selecting previously unselected package qemu-system-mips. 110s Preparing to unpack .../24-qemu-system-mips_1%3a8.2.2+ds-0ubuntu1.10_amd64.deb ... 110s Unpacking qemu-system-mips (1:8.2.2+ds-0ubuntu1.10) ... 110s Selecting previously unselected package qemu-system-ppc. 110s Preparing to unpack .../25-qemu-system-ppc_1%3a8.2.2+ds-0ubuntu1.10_amd64.deb ... 110s Unpacking qemu-system-ppc (1:8.2.2+ds-0ubuntu1.10) ... 110s Selecting previously unselected package qemu-system-sparc. 110s Preparing to unpack .../26-qemu-system-sparc_1%3a8.2.2+ds-0ubuntu1.10_amd64.deb ... 110s Unpacking qemu-system-sparc (1:8.2.2+ds-0ubuntu1.10) ... 110s Selecting previously unselected package seabios. 110s Preparing to unpack .../27-seabios_1.16.3-2_all.deb ... 110s Unpacking seabios (1.16.3-2) ... 110s Selecting previously unselected package qemu-system-x86. 110s Preparing to unpack .../28-qemu-system-x86_1%3a8.2.2+ds-0ubuntu1.10_amd64.deb ... 110s Unpacking qemu-system-x86 (1:8.2.2+ds-0ubuntu1.10) ... 110s Selecting previously unselected package qemu-system-s390x. 110s Preparing to unpack .../29-qemu-system-s390x_1%3a8.2.2+ds-0ubuntu1.10_amd64.deb ... 110s Unpacking qemu-system-s390x (1:8.2.2+ds-0ubuntu1.10) ... 110s Selecting previously unselected package qemu-system-misc. 110s Preparing to unpack .../30-qemu-system-misc_1%3a8.2.2+ds-0ubuntu1.10_amd64.deb ... 110s Unpacking qemu-system-misc (1:8.2.2+ds-0ubuntu1.10) ... 111s Selecting previously unselected package qemu-system. 111s Preparing to unpack .../31-qemu-system_1%3a8.2.2+ds-0ubuntu1.10_amd64.deb ... 111s Unpacking qemu-system (1:8.2.2+ds-0ubuntu1.10) ... 111s Selecting previously unselected package squashfs-tools. 111s Preparing to unpack .../32-squashfs-tools_1%3a4.6.1-1build1_amd64.deb ... 111s Unpacking squashfs-tools (1:4.6.1-1build1) ... 111s Selecting previously unselected package user-setup. 111s Preparing to unpack .../33-user-setup_1.95ubuntu1_all.deb ... 111s Unpacking user-setup (1.95ubuntu1) ... 111s Selecting previously unselected package casper. 111s Preparing to unpack .../34-casper_1.498_amd64.deb ... 111s Unpacking casper (1.498) ... 111s Setting up libpixman-1-0:amd64 (0.42.2-1build1) ... 111s Setting up squashfs-tools (1:4.6.1-1build1) ... 111s Setting up libfdt1:amd64 (1.7.0-2build1) ... 111s Setting up finalrd (9build1) ... 111s Created symlink /etc/systemd/system/sysinit.target.wants/finalrd.service → /usr/lib/systemd/system/finalrd.service. 112s Setting up libwbclient0:amd64 (2:4.19.5+dfsg-4ubuntu9.4) ... 112s Setting up acl (2.3.2-1build1.1) ... 112s Setting up libtalloc2:amd64 (2.4.2-1build2) ... 112s Setting up libasound2-data (1.2.11-1ubuntu0.1) ... 112s Setting up libasound2t64:amd64 (1.2.11-1ubuntu0.1) ... 112s Setting up libpcsclite1:amd64 (2.0.3-1build1) ... 112s Setting up libdaxctl1:amd64 (77-2ubuntu2) ... 112s Setting up qemu-system-data (1:8.2.2+ds-0ubuntu1.10) ... 112s Setting up seabios (1.16.3-2) ... 112s Setting up libslirp0:amd64 (4.7.0-1ubuntu3) ... 112s Setting up libusbredirparser1t64:amd64 (0.13.0-2.1build1) ... 112s Setting up ipxe-qemu (1.21.1+git-20220113.fbbdc3926-0ubuntu2) ... 112s Setting up libndctl6:amd64 (77-2ubuntu2) ... 112s Setting up librdmacm1t64:amd64 (50.0-2ubuntu0.2) ... 112s Setting up localechooser-data (2.89ubuntu6) ... 112s Setting up libbrlapi0.8:amd64 (6.6-4ubuntu5) ... 112s Setting up user-setup (1.95ubuntu1) ... 112s Setting up liburing2:amd64 (2.5-1build1) ... 112s Setting up libpmem1:amd64 (1.13.1-1.1ubuntu2) ... 112s Setting up cifs-utils (2:7.0-2ubuntu0.2) ... 112s update-alternatives: using /usr/lib/x86_64-linux-gnu/cifs-utils/idmapwb.so to provide /etc/cifs-utils/idmap-plugin (idmap-plugin) in auto mode 112s Setting up libcacard0:amd64 (1:2.8.0-3build4) ... 112s Setting up casper (1.498) ... 112s update-initramfs: deferring update (trigger activated) 112s Created symlink /etc/systemd/system/final.target.wants/casper.service → /usr/lib/systemd/system/casper.service. 112s Created symlink /etc/systemd/system/multi-user.target.wants/casper-md5check.service → /usr/lib/systemd/system/casper-md5check.service. 112s Setting up qemu-system-common (1:8.2.2+ds-0ubuntu1.10) ... 112s Created symlink /etc/systemd/system/multi-user.target.wants/qemu-kvm.service → /usr/lib/systemd/system/qemu-kvm.service. 112s Setting up qemu-system-mips (1:8.2.2+ds-0ubuntu1.10) ... 112s Setting up qemu-system-sparc (1:8.2.2+ds-0ubuntu1.10) ... 112s Setting up qemu-system-x86 (1:8.2.2+ds-0ubuntu1.10) ... 112s Setting up qemu-system-ppc (1:8.2.2+ds-0ubuntu1.10) ... 112s Setting up qemu-system-misc (1:8.2.2+ds-0ubuntu1.10) ... 112s Setting up qemu-system-arm (1:8.2.2+ds-0ubuntu1.10) ... 112s Setting up qemu-system-s390x (1:8.2.2+ds-0ubuntu1.10) ... 112s Setting up qemu-system (1:8.2.2+ds-0ubuntu1.10) ... 112s Processing triggers for man-db (2.12.0-4build2) ... 113s Processing triggers for libc-bin (2.39-0ubuntu8.6) ... 113s Processing triggers for initramfs-tools (0.142ubuntu25.5) ... 113s update-initramfs: Generating /boot/initrd.img-6.8.0-88-generic 120s autopkgtest [15:29:49]: test boot: [----------------------- 120s ++ dpkg --print-architecture 120s + arch=amd64 120s + '[' amd64 = amd64 ']' 120s + ./debian/tests/download-image 120s + '[' '!' -f images/root.squashfs ']' 120s ++ lsb_release -sc 120s + series=noble 120s ++ dpkg --print-architecture 120s + url=http://cloud-images.ubuntu.com/noble/current/noble-server-cloudimg-amd64.squashfs 120s + mkdir -p images 120s ++ curl --silent --write-out '%{http_code}\n' --output images/root.squashfs http://cloud-images.ubuntu.com/noble/current/noble-server-cloudimg-amd64.squashfs 125s + status=200 125s + '[' 200 = 404 ']' 125s + ret=0 125s + '[' 0 -eq 100 ']' 125s + '[' 0 -ne 0 ']' 125s + set -e 125s + basecmdline='boot=casper console=ttyS0' 125s ++ dpkg -l linux-image-generic 125s ++ awk '/^ii/ { print $3 }' 125s ++ sed -e 's/+.*//; s/\.[0-9]\+$//; s/\.\([0-9]\+\)$/-\1/' 125s + kvers=6.8.0-88-generic 125s ++ echo /boot/vmlinuz-6.8.0-88-generic 125s + kernel=/boot/vmlinuz-6.8.0-88-generic 125s + mkinitramfs -o casper-initrd 6.8.0-88-generic 130s + _loop_devs=() 130s + _mounts=() 130s ++ date -ud 'tomorrow 0:00' +%s 130s ++ date +%s 130s + secs_til_tomorrow=30601 130s + '[' 30601 -le 1800 ']' 130s ++ date -uIdate 130s + D=2025-11-12 130s + TESTS='test_basic test_auto_log_persistence test_clean_log_directory_each_boot 130s test_explicit_persistence test_implicit_then_explicit_persistence 130s test_mbr_preservation test_no_persistence test_todisk test_uses_casper_rw_partition' 130s + for f in $TESTS 130s + eval test_basic 130s ++ test_basic 130s ++ echo '### Running basic test' 130s ++ ./debian/tests/prep-image image.img ' 130s o lsblk.txt lsblk 130s o add-user-agent.txt cat /etc/pollinate/add-user-agent' ' 130s mkdir -p .disk 130s echo -n '\''Ubuntu-Server 19.10 "Eoan Ermine" - Alpha amd64 (20190829)'\'' > .disk/info 130s ' 130s + IMAGE=image.img 130s + rm -rf tmp 130s + mkdir -p tmp 130s + mount -t tmpfs none tmp/ 130s + mkdir -p tmp/overlay tmp/work tmp/root tmp/mnt 130s ### Running basic test 130s + mount -t squashfs images/root.squashfs tmp/root 130s + mount -t overlay overlay -o lowerdir=tmp/root,upperdir=tmp/overlay,workdir=tmp/work tmp/mnt 130s + rm -f tmp/mnt/sbin/init 130s + cat 130s + echo ' 130s o lsblk.txt lsblk 130s o add-user-agent.txt cat /etc/pollinate/add-user-agent' 130s + cat 130s + chmod u+x tmp/mnt/sbin/init 130s + umount tmp/mnt 130s + umount tmp/root 130s + mksquashfs tmp/overlay tmp/overlay.squashfs 130s Parallel mksquashfs: Using 2 processors 130s Creating 4.0 filesystem on tmp/overlay.squashfs, block size 131072. 130s [===================================================================|] 1/1 100%+ rm -rf image.img 130s 130s 130s Exportable Squashfs 4.0 filesystem, gzip compressed, data block size 131072 130s compressed data, compressed metadata, compressed fragments, 130s compressed xattrs, compressed ids 130s duplicates are removed 130s Filesystem size 0.61 Kbytes (0.00 Mbytes) 130s 67.97% of uncompressed filesystem size (0.90 Kbytes) 130s Inode table size 73 bytes (0.07 Kbytes) 130s 47.40% of uncompressed inode table size (154 bytes) 130s Directory table size 49 bytes (0.05 Kbytes) 130s 67.12% of uncompressed directory table size (73 bytes) 130s Xattr table size 89 bytes (0.09 Kbytes) 130s 47.09% of uncompressed xattr table size (189 bytes) 130s Number of duplicate files found 0 130s Number of inodes 4 130s Number of files 1 130s Number of fragments 1 130s Number of symbolic links 0 130s Number of device nodes 0 130s Number of fifo nodes 0 130s Number of socket nodes 0 130s Number of directories 3 130s Number of hard-links 0 130s Number of ids (unique uids + gids) 1 130s Number of uids 1 130s root (0) 130s Number of gids 1 130s root (0) 130s + truncate -s 1G image.img 130s + parted --script --align optimal image.img -- mklabel gpt mkpart primary ext4 1MiB -2048s 130s ++ losetup -Pf --show image.img 130s + dev=/dev/loop0 130s + mke2fs -L rootfs -q /dev/loop0p1 130s + mkdir -p tmp/mnt 130s + mount /dev/loop0p1 tmp/mnt 130s + '[' -n ' 130s mkdir -p .disk 130s echo -n '\''Ubuntu-Server 19.10 "Eoan Ermine" - Alpha amd64 (20190829)'\'' > .disk/info 130s ' ']' 130s + cd tmp/mnt 130s + eval ' 130s mkdir -p .disk 130s echo -n '\''Ubuntu-Server 19.10 "Eoan Ermine" - Alpha amd64 (20190829)'\'' > .disk/info 130s ' 130s ++ mkdir -p .disk 130s ++ echo -n 'Ubuntu-Server 19.10 "Eoan Ermine" - Alpha amd64 (20190829)' 130s + mkdir tmp/mnt/casper 130s + cp images/root.squashfs tmp/mnt/casper/0_root.squashfs 131s + cp tmp/overlay.squashfs tmp/mnt/casper/1_overlay.squashfs 131s + umount tmp/mnt 131s + umount tmp 131s + losetup -d /dev/loop0 131s ++ run image.img '' 131s ++ image=image.img 131s ++ shift 131s ++ cmdline='boot=casper console=ttyS0 ' 131s ++ shift 131s ++ ./debian/tests/run-image kernel=/boot/vmlinuz-6.8.0-88-generic initrd=casper-initrd image=image.img 'cmdline=boot=casper console=ttyS0 ' output=result 131s + '[' 5 -gt 0 ']' 131s + case $1 in 131s + KERNEL=/boot/vmlinuz-6.8.0-88-generic 131s + shift 131s + '[' 4 -gt 0 ']' 131s + case $1 in 131s + INITRD=casper-initrd 131s + shift 131s + '[' 3 -gt 0 ']' 131s + case $1 in 131s + IMAGES=image.img 131s + shift 131s + '[' 2 -gt 0 ']' 131s + case $1 in 131s + CMDLINE='boot=casper console=ttyS0 ' 131s + shift 131s + '[' 1 -gt 0 ']' 131s + case $1 in 131s + OUTPUT=result 131s + shift 131s + '[' 0 -gt 0 ']' 131s + archopts=() 131s + case $(uname -m) in 131s ++ uname -m 131s ++ uname -m 131s + qemu=qemu-system-x86_64 131s + devices= 131s + id=0 131s + for IMG in $IMAGES 131s + devices=' -drive if=none,file=image.img,format=raw,id=stick0 -device usb-storage,bus=xhci.0,drive=stick0' 131s + id=1 131s + tee qemu-output.txt 131s + tr -d '\r' 131s + timeout --foreground 10m qemu-system-x86_64 -m 1024m -kernel /boot/vmlinuz-6.8.0-88-generic -initrd casper-initrd -append 'boot=casper console=ttyS0 ' -device nec-usb-xhci,id=xhci -drive if=none,file=image.img,format=raw,id=stick0 -device usb-storage,bus=xhci.0,drive=stick0 -nographic -monitor none 133s c[?7lSeaBIOS (version 1.16.3-debian-1.16.3-2) 133s 133s 133s iPXE (https://ipxe.org) 00:03.0 CA00 PCI2.10 PnP PMM+3EFCADB0+3EF0ADB0 CA00 133s Press Ctrl-B to configure iPXE (PCI 00:03.0)... 133s 133s 133s Booting from ROM..c[?7l[ 0.000000] Linux version 6.8.0-88-generic (buildd@lcy02-amd64-004) (x86_64-linux-gnu-gcc-13 (Ubuntu 13.3.0-6ubuntu2~24.04) 13.3.0, GNU ld (GNU Binutils for Ubuntu) 2.42) #89-Ubuntu SMP PREEMPT_DYNAMIC Sat Oct 11 01:02:46 UTC 2025 (Ubuntu 6.8.0-88.89-generic 6.8.12) 133s [ 0.000000] Command line: boot=casper console=ttyS0 133s [ 0.000000] KERNEL supported cpus: 133s [ 0.000000] Intel GenuineIntel 133s [ 0.000000] AMD AuthenticAMD 133s [ 0.000000] Hygon HygonGenuine 133s [ 0.000000] Centaur CentaurHauls 133s [ 0.000000] zhaoxin Shanghai 133s [ 0.000000] BIOS-provided physical RAM map: 133s [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable 133s [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved 133s [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved 133s [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffdefff] usable 133s [ 0.000000] BIOS-e820: [mem 0x000000003ffdf000-0x000000003fffffff] reserved 133s [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved 133s [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved 133s [ 0.000000] NX (Execute Disable) protection: active 133s [ 0.000000] APIC: Static calls initialized 133s [ 0.000000] SMBIOS 3.0.0 present. 133s [ 0.000000] DMI: QEMU Ubuntu 24.04 PC (i440FX + PIIX, 1996), BIOS 1.16.3-debian-1.16.3-2 04/01/2014 133s [ 0.000000] tsc: Fast TSC calibration using PIT 133s [ 0.000000] tsc: Detected 2396.394 MHz processor 133s [ 0.014071] AGP: No AGP bridge found 133s [ 0.014294] last_pfn = 0x3ffdf max_arch_pfn = 0x400000000 133s [ 0.014930] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs 133s [ 0.015136] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT 133s [ 0.034080] found SMP MP-table at [mem 0x000f5470-0x000f547f] 133s [ 0.039242] RAMDISK: [mem 0x3be52000-0x3ffcffff] 133s [ 0.042819] ACPI: Early table checksum verification disabled 133s [ 0.043227] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS ) 133s [ 0.043500] ACPI: RSDT 0x000000003FFE1C58 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) 133s [ 0.044108] ACPI: FACP 0x000000003FFE1B0C 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) 133s [ 0.044776] ACPI: DSDT 0x000000003FFE0040 001ACC (v01 BOCHS BXPC 00000001 BXPC 00000001) 133s [ 0.044858] ACPI: FACS 0x000000003FFE0000 000040 133s [ 0.044910] ACPI: APIC 0x000000003FFE1B80 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) 133s [ 0.044938] ACPI: HPET 0x000000003FFE1BF8 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) 133s [ 0.044966] ACPI: WAET 0x000000003FFE1C30 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) 133s [ 0.045069] ACPI: Reserving FACP table memory at [mem 0x3ffe1b0c-0x3ffe1b7f] 133s [ 0.045089] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe1b0b] 133s [ 0.045098] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f] 133s [ 0.045105] ACPI: Reserving APIC table memory at [mem 0x3ffe1b80-0x3ffe1bf7] 133s [ 0.045112] ACPI: Reserving HPET table memory at [mem 0x3ffe1bf8-0x3ffe1c2f] 133s [ 0.045119] ACPI: Reserving WAET table memory at [mem 0x3ffe1c30-0x3ffe1c57] 133s [ 0.047450] No NUMA configuration found 133s [ 0.047476] Faking a node at [mem 0x0000000000000000-0x000000003ffdefff] 133s [ 0.048088] NODE_DATA(0) allocated [mem 0x3be27000-0x3be51fff] 133s [ 0.051234] Zone ranges: 133s [ 0.051261] DMA [mem 0x0000000000001000-0x0000000000ffffff] 133s [ 0.051341] DMA32 [mem 0x0000000001000000-0x000000003ffdefff] 133s [ 0.051354] Normal empty 133s [ 0.051372] Device empty 133s [ 0.051386] Movable zone start for each node 133s [ 0.051413] Early memory node ranges 133s [ 0.051438] node 0: [mem 0x0000000000001000-0x000000000009efff] 133s [ 0.051570] node 0: [mem 0x0000000000100000-0x000000003ffdefff] 133s [ 0.051758] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffdefff] 133s [ 0.052783] On node 0, zone DMA: 1 pages in unavailable ranges 133s [ 0.052993] On node 0, zone DMA: 97 pages in unavailable ranges 133s [ 0.058802] On node 0, zone DMA32: 33 pages in unavailable ranges 133s [ 0.059327] ACPI: PM-Timer IO Port: 0x608 133s [ 0.059737] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) 133s [ 0.060189] IOAPIC[0]: apic_id 0, version 32, address 0xfec00000, GSI 0-23 133s [ 0.060292] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) 133s [ 0.060567] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) 133s [ 0.060625] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) 133s [ 0.060711] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) 133s [ 0.060721] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) 133s [ 0.060912] ACPI: Using ACPI (MADT) for SMP configuration information 133s [ 0.060957] ACPI: HPET id: 0x8086a201 base: 0xfed00000 133s [ 0.061227] smpboot: Allowing 1 CPUs, 0 hotplug CPUs 133s [ 0.061933] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] 133s [ 0.061975] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x0009ffff] 133s [ 0.061998] PM: hibernation: Registered nosave memory: [mem 0x000a0000-0x000effff] 133s [ 0.062019] PM: hibernation: Registered nosave memory: [mem 0x000f0000-0x000fffff] 133s [ 0.062129] [mem 0x40000000-0xfffbffff] available for PCI devices 133s [ 0.062185] Booting paravirtualized kernel on bare hardware 133s [ 0.062429] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns 133s [ 0.062988] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 133s [ 0.064175] percpu: Embedded 86 pages/cpu s229376 r8192 d114688 u2097152 133s [ 0.065480] Kernel command line: boot=casper console=ttyS0 133s [ 0.066281] Unknown kernel command line parameters "boot=casper", will be passed to user space. 133s [ 0.066756] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) 133s [ 0.066909] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) 133s [ 0.069468] Fallback order for Node 0: 0 133s [ 0.069863] Built 1 zonelists, mobility grouping on. Total pages: 257759 133s [ 0.069891] Policy zone: DMA32 133s [ 0.070380] mem auto-init: stack:all(zero), heap alloc:on, heap free:off 133s [ 0.070506] AGP: Checking aperture... 133s [ 0.071763] AGP: No AGP bridge found 133s [ 0.082652] Memory: 908288K/1048052K available (22528K kernel code, 4441K rwdata, 14384K rodata, 4912K init, 4796K bss, 139504K reserved, 0K cma-reserved) 133s [ 0.264437] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 133s [ 0.267302] ftrace: allocating 58192 entries in 228 pages 133s [ 0.307821] ftrace: allocated 228 pages with 4 groups 133s [ 0.317093] Dynamic Preempt: voluntary 133s [ 0.320851] rcu: Preemptible hierarchical RCU implementation. 133s [ 0.320887] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=1. 133s [ 0.320981] Trampoline variant of Tasks RCU enabled. 133s [ 0.320989] Rude variant of Tasks RCU enabled. 133s [ 0.320995] Tracing variant of Tasks RCU enabled. 133s [ 0.321097] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. 133s [ 0.321123] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 133s [ 0.322281] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. 133s [ 0.322313] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. 133s [ 0.322325] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. 133s [ 0.346145] NR_IRQS: 524544, nr_irqs: 256, preallocated irqs: 16 133s [ 0.354745] rcu: srcu_init: Setting srcu_struct sizes based on contention. 133s [ 0.360918] Console: colour VGA+ 80x25 133s [ 0.362361] printk: legacy console [ttyS0] enabled 133s [ 0.377934] ACPI: Core revision 20230628 133s [ 0.383877] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns 133s [ 0.388652] APIC: Switch to symmetric I/O mode setup 133s [ 0.393320] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 134s [ 0.399236] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x228ae90d690, max_idle_ns: 440795311746 ns 134s [ 0.399912] Calibrating delay loop (skipped), value calculated using timer frequency.. 4792.78 BogoMIPS (lpj=2396394) 134s [ 0.403890] process: using AMD E400 aware idle routine 134s [ 0.404195] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 134s [ 0.404347] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 134s [ 0.404736] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization 134s [ 0.405076] Spectre V2 : Mitigation: Retpolines 134s [ 0.405182] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch 134s [ 0.405377] Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT 134s [ 0.406280] x86/fpu: x87 FPU will use FXSAVE 134s [ 0.785940] Freeing SMP alternatives memory: 48K 134s [ 0.786881] pid_max: default: 32768 minimum: 301 134s [ 0.797364] LSM: initializing lsm=lockdown,capability,landlock,yama,apparmor,integrity 134s [ 0.799463] landlock: Up and running. 134s [ 0.799561] Yama: becoming mindful. 134s [ 0.803654] AppArmor: AppArmor initialized 134s [ 0.808115] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) 134s [ 0.808376] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) 134s [ 0.937594] smpboot: CPU0: AMD QEMU Virtual CPU version 2.5+ (family: 0xf, model: 0x6b, stepping: 0x1) 134s [ 0.945999] Performance Events: PMU not available due to virtualization, using software events only. 134s [ 0.947154] signal: max sigframe size: 1440 134s [ 0.948659] rcu: Hierarchical SRCU implementation. 134s [ 0.948809] rcu: Max phase no-delay instances is 400. 134s [ 0.957855] NMI watchdog: Perf NMI watchdog permanently disabled 134s [ 0.958965] smp: Bringing up secondary CPUs ... 134s [ 0.960807] smp: Brought up 1 node, 1 CPU 134s [ 0.960939] smpboot: Max logical packages: 1 134s [ 0.961132] smpboot: Total of 1 processors activated (4792.78 BogoMIPS) 134s [ 0.973227] devtmpfs: initialized 134s [ 0.976155] x86/mm: Memory block size: 128MB 134s [ 0.983160] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns 134s [ 0.983790] futex hash table entries: 256 (order: 2, 16384 bytes, linear) 134s [ 0.988324] pinctrl core: initialized pinctrl subsystem 134s [ 0.994436] PM: RTC time: 15:30:02, date: 2025-11-12 134s [ 1.004612] NET: Registered PF_NETLINK/PF_ROUTE protocol family 134s [ 1.008092] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations 134s [ 1.008663] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations 134s [ 1.008930] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations 134s [ 1.009246] audit: initializing netlink subsys (disabled) 134s [ 1.010886] audit: type=2000 audit(1762961401.622:1): state=initialized audit_enabled=0 res=1 134s [ 1.015881] thermal_sys: Registered thermal governor 'fair_share' 134s [ 1.015916] thermal_sys: Registered thermal governor 'bang_bang' 134s [ 1.016057] thermal_sys: Registered thermal governor 'step_wise' 134s [ 1.016175] thermal_sys: Registered thermal governor 'user_space' 134s [ 1.016295] thermal_sys: Registered thermal governor 'power_allocator' 134s [ 1.016747] cpuidle: using governor ladder 134s [ 1.017093] cpuidle: using governor menu 134s [ 1.018521] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 134s [ 1.021505] PCI: Using configuration type 1 for base access 134s [ 1.023692] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. 134s [ 1.113800] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages 134s [ 1.114040] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page 134s [ 1.134822] ACPI: Added _OSI(Module Device) 134s [ 1.134951] ACPI: Added _OSI(Processor Device) 134s [ 1.135044] ACPI: Added _OSI(3.0 _SCP Extensions) 134s [ 1.135143] ACPI: Added _OSI(Processor Aggregator Device) 134s [ 1.150866] ACPI: 1 ACPI AML tables successfully acquired and loaded 134s [ 1.167507] ACPI: _OSC evaluation for CPUs failed, trying _PDC 134s [ 1.169699] ACPI: Interpreter enabled 134s [ 1.170752] ACPI: PM: (supports S0 S3 S4 S5) 134s [ 1.170897] ACPI: Using IOAPIC for interrupt routing 134s [ 1.172270] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug 134s [ 1.172488] PCI: Using E820 reservations for host bridge windows 134s [ 1.174126] ACPI: Enabled 2 GPEs in block 00 to 0F 134s [ 1.206354] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) 134s [ 1.208032] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI EDR HPX-Type3] 134s [ 1.208372] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] 134s [ 1.209166] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended configuration space under this bridge 134s [ 1.214746] acpiphp: Slot [3] registered 134s [ 1.214965] acpiphp: Slot [4] registered 134s [ 1.215123] acpiphp: Slot [5] registered 134s [ 1.215307] acpiphp: Slot [6] registered 134s [ 1.215457] acpiphp: Slot [7] registered 134s [ 1.215627] acpiphp: Slot [8] registered 134s [ 1.215785] acpiphp: Slot [9] registered 134s [ 1.215927] acpiphp: Slot [10] registered 134s [ 1.216065] acpiphp: Slot [11] registered 134s [ 1.216203] acpiphp: Slot [12] registered 134s [ 1.216360] acpiphp: Slot [13] registered 134s [ 1.216528] acpiphp: Slot [14] registered 134s [ 1.216661] acpiphp: Slot [15] registered 134s [ 1.216819] acpiphp: Slot [16] registered 134s [ 1.216956] acpiphp: Slot [17] registered 134s [ 1.217093] acpiphp: Slot [18] registered 134s [ 1.217209] acpiphp: Slot [19] registered 134s [ 1.217379] acpiphp: Slot [20] registered 134s [ 1.217521] acpiphp: Slot [21] registered 134s [ 1.217740] acpiphp: Slot [22] registered 134s [ 1.217895] acpiphp: Slot [23] registered 134s [ 1.218033] acpiphp: Slot [24] registered 134s [ 1.218169] acpiphp: Slot [25] registered 134s [ 1.218305] acpiphp: Slot [26] registered 134s [ 1.218468] acpiphp: Slot [27] registered 134s [ 1.218637] acpiphp: Slot [28] registered 134s [ 1.218789] acpiphp: Slot [29] registered 134s [ 1.218928] acpiphp: Slot [30] registered 134s [ 1.219081] acpiphp: Slot [31] registered 134s [ 1.219461] PCI host bridge to bus 0000:00 134s [ 1.219698] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] 134s [ 1.219954] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] 134s [ 1.220084] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] 134s [ 1.220257] pci_bus 0000:00: root bus resource [mem 0x40000000-0xfebfffff window] 134s [ 1.220416] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window] 134s [ 1.220699] pci_bus 0000:00: root bus resource [bus 00-ff] 134s [ 1.221999] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint 134s [ 1.226069] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint 134s [ 1.226790] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint 134s [ 1.227662] pci 0000:00:01.1: BAR 4 [io 0xc040-0xc04f] 134s [ 1.227859] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk 134s [ 1.228017] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk 134s [ 1.228164] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk 134s [ 1.228313] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk 134s [ 1.229095] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint 134s [ 1.229606] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI 134s [ 1.229799] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB 134s [ 1.230428] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint 134s [ 1.231614] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] 134s [ 1.231831] pci 0000:00:02.0: BAR 2 [mem 0xfebb4000-0xfebb4fff] 134s [ 1.231960] pci 0000:00:02.0: ROM [mem 0xfeba0000-0xfebaffff pref] 134s [ 1.232319] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] 134s [ 1.233153] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000 conventional PCI endpoint 134s [ 1.234137] pci 0000:00:03.0: BAR 0 [mem 0xfeb80000-0xfeb9ffff] 134s [ 1.234612] pci 0000:00:03.0: BAR 1 [io 0xc000-0xc03f] 134s [ 1.234739] pci 0000:00:03.0: ROM [mem 0xfeb00000-0xfeb7ffff pref] 134s [ 1.241805] pci 0000:00:04.0: [1033:0194] type 00 class 0x0c0330 conventional PCI endpoint 134s [ 1.242285] pci 0000:00:04.0: BAR 0 [mem 0xfebb0000-0xfebb3fff 64bit] 134s [ 1.250876] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 134s [ 1.251738] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 134s [ 1.252357] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 134s [ 1.253051] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 134s [ 1.253419] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 134s [ 1.257184] iommu: Default domain type: Translated 134s [ 1.257326] iommu: DMA domain TLB invalidation policy: lazy mode 134s [ 1.259986] SCSI subsystem initialized 134s [ 1.261434] ACPI: bus type USB registered 134s [ 1.261824] usbcore: registered new interface driver usbfs 134s [ 1.262120] usbcore: registered new interface driver hub 134s [ 1.262321] usbcore: registered new device driver usb 134s [ 1.262776] pps_core: LinuxPPS API ver. 1 registered 134s [ 1.262893] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti 134s [ 1.263114] PTP clock support registered 134s [ 1.263934] EDAC MC: Ver: 3.0.0 134s [ 1.272830] NetLabel: Initializing 134s [ 1.272942] NetLabel: domain hash size = 128 134s [ 1.273040] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO 134s [ 1.273833] NetLabel: unlabeled traffic allowed by default 134s [ 1.277311] mctp: management component transport protocol core 134s [ 1.277465] NET: Registered PF_MCTP protocol family 134s [ 1.277958] PCI: Using ACPI for IRQ routing 134s [ 1.279842] pci 0000:00:02.0: vgaarb: setting as boot VGA device 134s [ 1.280016] pci 0000:00:02.0: vgaarb: bridge control possible 134s [ 1.280171] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none 134s [ 1.280368] vgaarb: loaded 134s [ 1.281788] hpet: 3 channels of 0 reserved for per-cpu timers 134s [ 1.282139] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 134s [ 1.282324] hpet0: 3 comparators, 64-bit 100.000000 MHz counter 134s [ 1.287161] clocksource: Switched to clocksource tsc-early 134s [ 1.295582] VFS: Disk quotas dquot_6.6.0 134s [ 1.296994] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) 134s [ 1.301198] AppArmor: AppArmor Filesystem Enabled 134s [ 1.301621] pnp: PnP ACPI init 134s [ 1.305756] pnp: PnP ACPI: found 6 devices 134s [ 1.327829] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns 134s [ 1.329284] NET: Registered PF_INET protocol family 134s [ 1.330235] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) 134s [ 1.394620] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) 134s [ 1.395036] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) 134s [ 1.395287] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) 134s [ 1.395688] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) 134s [ 1.396058] TCP: Hash tables configured (established 8192 bind 8192) 134s [ 1.397670] MPTCP token hash table entries: 1024 (order: 2, 24576 bytes, linear) 134s [ 1.398191] UDP hash table entries: 512 (order: 2, 16384 bytes, linear) 134s [ 1.398540] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear) 134s [ 1.399994] NET: Registered PF_UNIX/PF_LOCAL protocol family 134s [ 1.400408] NET: Registered PF_XDP protocol family 134s [ 1.401280] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] 134s [ 1.401428] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] 134s [ 1.401566] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] 134s [ 1.401703] pci_bus 0000:00: resource 7 [mem 0x40000000-0xfebfffff window] 134s [ 1.401882] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window] 134s [ 1.402530] pci 0000:00:01.0: PIIX3: Enabling Passive Release 134s [ 1.402875] pci 0000:00:00.0: Limiting direct PCI/PCI transfers 134s [ 1.562687] ACPI: \_SB_.LNKD: Enabled at IRQ 11 134s [ 1.721726] pci 0000:00:04.0: quirk_usb_early_handoff+0x0/0x190 took 311105 usecs 134s [ 1.722229] PCI: CLS 0 bytes, default 64 134s [ 1.728338] Trying to unpack rootfs image as initramfs... 134s [ 1.734369] Initialise system trusted keyrings 135s [ 1.738771] Key type blacklist registered 135s [ 1.739662] workingset: timestamp_bits=36 max_order=18 bucket_order=0 135s [ 1.739946] zbud: loaded 135s [ 1.758939] squashfs: version 4.0 (2009/01/31) Phillip Lougher 135s [ 1.768180] fuse: init (API version 7.39) 135s [ 1.775618] integrity: Platform Keyring initialized 135s [ 1.776013] integrity: Machine keyring initialized 135s [ 1.895563] Key type asymmetric registered 135s [ 1.895781] Asymmetric key parser 'x509' registered 135s [ 1.896185] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 243) 135s [ 1.898946] io scheduler mq-deadline registered 135s [ 1.905077] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 135s [ 1.912512] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 135s [ 1.919357] ACPI: button: Power Button [PWRF] 135s [ 1.928022] Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled 135s [ 1.977940] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A 135s [ 2.018233] Linux agpgart interface v0.103 135s [ 2.059026] loop: module loaded 135s [ 2.077070] scsi host0: ata_piix 135s [ 2.080827] scsi host1: ata_piix 135s [ 2.081268] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc040 irq 14 lpm-pol 0 135s [ 2.081561] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc048 irq 15 lpm-pol 0 135s [ 2.086947] ACPI: bus type drm_connector registered 135s [ 2.092739] tun: Universal TUN/TAP device driver, 1.6 135s [ 2.093712] PPP generic driver version 2.4.2 135s [ 2.098546] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 135s [ 2.105578] serio: i8042 KBD port at 0x60,0x64 irq 1 135s [ 2.105873] serio: i8042 AUX port at 0x60,0x64 irq 12 135s [ 2.108509] mousedev: PS/2 mouse device common for all mice 135s [ 2.112119] rtc_cmos 00:05: RTC can wake from S4 135s [ 2.116800] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 135s [ 2.120116] rtc_cmos 00:05: registered as rtc0 135s [ 2.121983] rtc_cmos 00:05: setting system clock to 2025-11-12T15:30:03 UTC (1762961403) 135s [ 2.124339] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs 135s [ 2.125561] i2c_dev: i2c /dev entries driver 135s [ 2.126000] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. 135s [ 2.127577] device-mapper: uevent: version 1.0.3 135s [ 2.129563] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com 135s [ 2.130014] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled 135s [ 2.131911] ledtrig-cpu: registered to indicate activity on CPUs 135s [ 2.133190] drop_monitor: Initializing network drop monitor service 135s [ 2.137076] NET: Registered PF_INET6 protocol family 135s [ 2.244562] ata2: found unknown device (class 0) 135s [ 2.248900] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 135s [ 2.263855] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 135s [ 2.285675] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray 135s [ 2.286040] cdrom: Uniform CD-ROM driver Revision: 3.20 135s [ 2.297584] sr 1:0:0:0: Attached scsi generic sg0 type 5 135s [ 2.636176] Freeing initrd memory: 67064K 135s [ 2.788887] tsc: Refined TSC clocksource calibration: 2396.383 MHz 135s [ 2.789471] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x228ade90bd5, max_idle_ns: 440795250562 ns 135s [ 2.789778] clocksource: Switched to clocksource tsc 135s [ 2.847074] Segment Routing with IPv6 135s [ 2.847562] In-situ OAM (IOAM) with IPv6 135s [ 2.848138] NET: Registered PF_PACKET protocol family 135s [ 2.848681] Key type dns_resolver registered 135s [ 2.851373] IPI shorthand broadcast: enabled 135s [ 2.865892] sched_clock: Marking stable (2833034667, 32359560)->(2869491019, -4096792) 135s [ 2.868131] registered taskstats version 1 135s [ 2.870575] Loading compiled-in X.509 certificates 135s [ 2.879873] Loaded X.509 cert 'Build time autogenerated kernel key: 3c10d2cce41e4e020037eb894f94af5dd81a8c9c' 135s [ 2.881580] Loaded X.509 cert 'Canonical Ltd. Live Patch Signing 2025 Kmod: d541cef61dc7e793b7eb7e899970a2eef0b5dc8c' 140s [ 2.883087] Loaded X.509 cert 'Canonical Ltd. Live Patch Signing: 14df34d1a87cf37625abec039ef2bf521249b969' 140s [ 2.884767] Loaded X.509 cert 'Canonical Ltd. Kernel Module Signing: 88f752e560a1e0737e31163a466ad7b70a850c19' 140s [ 2.885030] blacklist: Loading compiled-in revocation X.509 certificates 140s [ 2.886292] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing: 61482aa2830d0ab2ad5af10b7250da9033ddcef0' 140s [ 2.886739] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2017): 242ade75ac4a15e50d50c84b0d45ff3eae707a03' 140s [ 2.887049] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (ESM 2018): 365188c1d374d6b07c3c8f240f8ef722433d6a8b' 140s [ 2.887445] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2019): c0746fd6c5da3ae827864651ad66ae47fe24b3e8' 140s [ 2.887744] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v1): a8d54bbb3825cfb94fa13c9f8a594a195c107b8d' 140s [ 2.888036] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v2): 4cf046892d6fd3c9a5b03f98d845f90851dc6a8c' 140s [ 2.888356] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v3): 100437bb6de6e469b581e61cd66bce3ef4ed53af' 140s [ 2.888766] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (Ubuntu Core 2019): c1d57b8f6b743f23ee41f4f7ee292f06eecadfb9' 140s [ 2.915585] Key type .fscrypt registered 140s [ 2.915710] Key type fscrypt-provisioning registered 140s [ 3.272944] Key type encrypted registered 140s [ 3.273154] AppArmor: AppArmor sha256 policy hashing enabled 140s [ 3.273795] ima: No TPM chip found, activating TPM-bypass! 140s [ 3.274054] Loading compiled-in module X.509 certificates 140s [ 3.275901] Loaded X.509 cert 'Build time autogenerated kernel key: 3c10d2cce41e4e020037eb894f94af5dd81a8c9c' 140s [ 3.276195] ima: Allocated hash algorithm: sha256 140s [ 3.278439] ima: No architecture policies found 140s [ 3.279025] evm: Initialising EVM extended attributes: 140s [ 3.279166] evm: security.selinux 140s [ 3.279253] evm: security.SMACK64 140s [ 3.279325] evm: security.SMACK64EXEC 140s [ 3.279420] evm: security.SMACK64TRANSMUTE 140s [ 3.279562] evm: security.SMACK64MMAP 140s [ 3.279634] evm: security.apparmor 140s [ 3.279705] evm: security.ima 140s [ 3.279762] evm: security.capability 140s [ 3.279843] evm: HMAC attrs: 0x1 140s [ 3.282369] PM: Magic number: 1:3:538 140s [ 3.282709] tty ttyS18: hash matches 140s [ 3.282798] port serial8250:0.17: hash matches 140s [ 3.283957] powernow_k8: Power state transitions not supported 140s [ 3.336842] RAS: Correctable Errors collector initialized. 140s [ 3.338787] clk: Disabling unused clocks 140s [ 3.351818] Freeing unused decrypted memory: 2028K 140s [ 3.427319] Freeing unused kernel image (initmem) memory: 4912K 140s [ 3.427665] Write protecting the kernel read-only data: 38912k 140s [ 3.430141] Freeing unused kernel image (rodata/data gap) memory: 2000K 140s [ 3.568591] x86/mm: Checked W+X mappings: passed, no W+X pages found. 140s [ 3.569002] Run /init as init process 140s Loading, please wait... 140s Starting systemd-udevd version 255.4-1ubuntu8.11 140s [ 5.322270] Floppy drive(s): fd0 is 2.88M AMI BIOS 140s [ 5.344061] FDC 0 is a S82078B 140s [ 5.383313] e1000: Intel(R) PRO/1000 Network Driver 140s [ 5.383542] e1000: Copyright (c) 1999-2006 Intel Corporation. 140s [ 5.460002] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console 140s [ 5.472688] Console: switching to colour dummy device 80x25 140s [ 5.485585] [drm] Found bochs VGA, ID 0xb0c5. 140s [ 5.485707] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebb4000. 140s [ 5.510338] [drm] Found EDID data blob. 140s [ 5.551502] [drm] Initialized bochs-drm 1.0.0 20130925 for 0000:00:02.0 on minor 0 140s [ 5.657344] fbcon: bochs-drmdrmfb (fb0) is primary device 140s [ 5.825237] Console: switching to colour frame buffer device 160x50 140s [ 5.909121] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device 140s [ 6.511372] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3 140s [ 7.002083] xhci_hcd 0000:00:04.0: xHCI Host Controller 140s [ 7.003104] ACPI: \_SB_.LNKC: Enabled at IRQ 10 140s [ 7.004164] xhci_hcd 0000:00:04.0: new USB bus registered, assigned bus number 1 148s [ 7.008306] xhci_hcd 0000:00:04.0: hcc params 0x00080001 hci version 0x100 quirks 0x0000000000000014 148s [ 7.014520] xhci_hcd 0000:00:04.0: xHCI Host Controller 148s [ 7.014653] xhci_hcd 0000:00:04.0: new USB bus registered, assigned bus number 2 148s [ 7.014848] xhci_hcd 0000:00:04.0: Host supports USB 3.0 SuperSpeed 148s [ 7.018341] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.08 148s [ 7.018601] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 148s [ 7.018744] usb usb1: Product: xHCI Host Controller 148s [ 7.018844] usb usb1: Manufacturer: Linux 6.8.0-88-generic xhci-hcd 148s [ 7.018969] usb usb1: SerialNumber: 0000:00:04.0 148s [ 7.023261] hub 1-0:1.0: USB hub found 148s [ 7.024369] hub 1-0:1.0: 4 ports detected 148s [ 7.032218] usb usb2: We don't know the algorithms for LPM for this host, disabling LPM. 148s [ 7.032764] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.08 148s [ 7.032921] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 148s [ 7.033066] usb usb2: Product: xHCI Host Controller 148s [ 7.033160] usb usb2: Manufacturer: Linux 6.8.0-88-generic xhci-hcd 148s [ 7.033268] usb usb2: SerialNumber: 0000:00:04.0 148s [ 7.036176] hub 2-0:1.0: USB hub found 148s [ 7.040550] hub 2-0:1.0: 4 ports detected 148s [ 7.364100] e1000 0000:00:03.0 eth0: (PCI:33MHz:32-bit) 52:54:00:12:34:56 148s [ 7.364680] e1000 0000:00:03.0 eth0: Intel(R) PRO/1000 Network Connection 148s [ 7.376828] usb 2-1: new SuperSpeed USB device number 2 using xhci_hcd 148s [ 7.388002] e1000 0000:00:03.0 ens3: renamed from eth0 148s [ 7.393088] usb 2-1: New USB device found, idVendor=46f4, idProduct=0001, bcdDevice= 0.00 148s [ 7.393260] usb 2-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 148s [ 7.393385] usb 2-1: Product: QEMU USB HARDDRIVE 148s [ 7.393540] usb 2-1: Manufacturer: QEMU 148s [ 7.393630] usb 2-1: SerialNumber: 1-0000:00:04.0-1 148s [ 7.434852] usb-storage 2-1:1.0: USB Mass Storage device detected 148s [ 7.438195] scsi host2: usb-storage 2-1:1.0 148s [ 7.439878] usbcore: registered new interface driver usb-storage 148s [ 7.449136] usbcore: registered new interface driver uas 148s Begin: Loading essential drivers ... done. 148s Begin: Running /scripts/init-premount ... done. 148s Begin: Mounting root file system ... Begin: Running /scripts/nfs-top ... done. 148s Begin: Running /scripts/nfs-premount ... done. 148s [ 8.493112] scsi 2:0:0:0: Direct-Access QEMU QEMU HARDDISK 2.5+ PQ: 0 ANSI: 5 148s [ 8.508783] sd 2:0:0:0: Attached scsi generic sg1 type 0 148s [ 8.514775] sd 2:0:0:0: [sda] 2097152 512-byte logical blocks: (1.07 GB/1.00 GiB) 148s [ 8.515370] sd 2:0:0:0: [sda] Write Protect is off 148s [ 8.517682] sd 2:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA 148s [ 8.574317] sda: sda1 148s [ 8.583367] sd 2:0:0:0: [sda] Attached SCSI disk 148s Begin: Running /scripts/casper-premount ... done. 148s done. 148s /init: line 38: can't open /dev/sr0: No medium found 148s /init: line 38: can't open /dev/sr0: No medium found 148s [ 10.373083] EXT4-fs (sda1): mounting ext2 file system using the ext4 subsystem 148s [ 10.380802] EXT4-fs (sda1): mounted filesystem ff025976-2856-42fb-8efb-f29bd80b9e50 ro without journal. Quota mode: none. 148s [ 10.401758] EXT4-fs (sda1): unmounting filesystem ff025976-2856-42fb-8efb-f29bd80b9e50. 148s [ 10.664644] EXT4-fs (sda1): mounting ext2 file system using the ext4 subsystem 148s [ 10.666705] EXT4-fs (sda1): mounted filesystem ff025976-2856-42fb-8efb-f29bd80b9e50 ro without journal. Quota mode: none. 148s [ 10.913862] loop0: detected capacity change from 0 to 543320 148s [ 11.095932] loop1: detected capacity change from 0 to 8 148s [ 11.164968] overlayfs: null uuid detected in lower fs '/', falling back to xino=off,index=off,nfs_export=off. 148s done. 148s Begin: Creating debconf-communicate fifo mechanism ... [ 11.617673] evm: overlay not supported 148s [ 11.950795] random: crng init done 148s done. 148s Begin: Running /scripts/casper-bottom ... Begin: Moving mount points... ... done. 148s Begin: Configuring fstab... ... done. 148s Begin: Setting up locales... ... done. 148s Begin: Setting up automatic login... ... done. 148s Begin: Setting hostname... ... done. 156s Begin: Setting up console keyboard... ... done. 156s Begin: Applying desktop settings... ... done. 156s Begin: Regenerating SSL certificate... ... done. 156s Begin: Loading preseed file... ... done. 156s Begin: Adding live session user... ... chroot: can't execute '/usr/lib/user-setup/user-setup-apply': No such file or directory 156s passwd: user 'ubuntu-server' does not exist 156s done. 156s Begin: Setting up init... ... done. 156s Begin: Configuring accessibility options... ... done. 156s Begin: Disabling update-notifier... ... done. 156s Begin: Enabling detection of crashes... ... done. 156s Begin: Disabling unnecessary KDE services... ... done. 156s Begin: Disabling the lock screen for LXQt (LP: #2000787)... ... done. 156s Begin: Adding APT-CDROM source... ... Using CD-ROM mount point /cdrom/ 156s Identifying... [7534f90c69601f1aecb1e3411139cf39-2] 156s Scanning disc for index files... 156s Found 0 package indexes, 0 source indexes, 0 translation indexes and 0 signatures 156s E: Unable to locate any package files, perhaps this is not a Debian Disc or the wrong architecture? 156s E: No CD-ROM could be auto-detected or found using the default mount point. 156s You may try the --cdrom option to set the CD-ROM mount point. 156s See 'man apt-cdrom' for more information about the CD-ROM auto-detection and mount point. 156s done. 156s Begin: Possibly disabling update-initramfs (useless on a live CD)... ... done. 156s Begin: Grant administrative PolicyKit privileges to default user... ... done. 156s Begin: Configuring jackd2... ... done. 156s Begin: Disabling gnome-initial-setup... ... chown: invalid user: 'ubuntu-server.ubuntu-server' 156s done. 156s Begin: Disabling security unattended-upgrades... ... done. 156s Begin: Disabling snap refresh... ... done. 156s Begin: Overriding 71-nvidia.rules... ... done. 156s Begin: Configuring pollinate... ... done. 156s Begin: Setting up networking for ubuntu-server... ... done. 156s Begin: Disabling ibus-mozc auto setup... ... chown: invalid user: 'ubuntu-server.ubuntu-server' 156s done. 156s Begin: Set up the installer log directory for adm users... ... done. 156s Begin: Tweaks for the desktop image... ... done. 156s done. 156s Begin: Running /scripts/nfs-bottom ... done. 156s Begin: Running /scripts/init-bottom ... done. 156s + o lsblk.txt lsblk 156s + f=lsblk.txt 156s + shift 156s + echo --FILE lsblk.txt FILE-- 156s --FILE lsblk.txt FILE-- 156s + eval lsblk 156s + lsblk 156s + sed -e s/^/--OUT lsblk.txt BEGIN-- /g -e s/$/ --END--/g 156s --OUT lsblk.txt BEGIN-- NAME MAJ:MIN RM SIZE RO TYPE MOUNTPOINTS --END-- 156s --OUT lsblk.txt BEGIN-- fd0 2:0 1 4K 0 disk --END-- 156s --OUT lsblk.txt BEGIN-- loop0 7:0 0 265.3M 1 loop /rofs --END-- 156s --OUT lsblk.txt BEGIN-- loop1 7:1 0 4K 1 loop --END-- 156s --OUT lsblk.txt BEGIN-- sda 8:0 0 1G 0 disk --END-- 156s --OUT lsblk.txt BEGIN-- `-sda1 8:1 0 1022M 0 part /cdrom --END-- 156s --OUT lsblk.txt BEGIN-- sr0 11:0 1 1024M 0 rom --END-- 156s + o add-user-agent.txt cat /etc/pollinate/add-user-agent 156s + f=add-user-agent.txt 156s + shift 156s + echo --FILE add-user-agent.txt FILE-- 156s --FILE add-user-agent.txt FILE-- 156s + eval cat /etc/pollinate/add-user-agent 156s + cat /etc/pollinate/add-user-agent 156s + sed -e s/^/--OUT add-user-agent.txt BEGIN-- /g -e s/$/ --END--/g 156s --OUT add-user-agent.txt BEGIN-- live/20190829 --END-- 156s + exec /lib/systemd/systemd-shutdown poweroff 156s Syncing filesystems and block devices. 156s Sending SIGTERM to remaining processes... 156s Failed to get cgroup path of process 101, ignoring: No medium found 156s Sending SIGKILL to remaining processes... 156s Unmounting file systems. 156s Unmounting '/usr/lib/modules'. 156s Remounting '/' read-only with options 'lowerdir=/1_overlay.squashfs:/0_root.squashfs,upperdir=/cow/upper,workdir=/cow/work,uuid=on,xino=off,nouserxattr'. 156s Unmounting '/rofs'. 156s Unmounting '/cdrom'. 156s Failed to unmount /cdrom: Device or resource busy 156s Moving mount /cdrom to /run/shutdown/mounts/8965fe7dd8a75fea. 156s Unmounting '/run/shutdown/mounts/8965fe7dd8a75fea'. 156s Failed to unmount /run/shutdown/mounts/8965fe7dd8a75fea: Device or resource busy 156s Not all file systems unmounted, 1 left. 156s Deactivating swaps. 156s All swaps deactivated. 156s Detaching loop devices. 156s Detaching loopback /dev/loop1. 156s Could not detach loopback /dev/loop1: Device or resource busy 156s Detaching loopback /dev/loop0. 157s Could not detach loopback /dev/loop0: Device or resource busy 157s Not all loop devices detached, 2 left. 157s Stopping MD devices. 157s All MD devices stopped. 157s Detaching DM devices. 157s All DM devices detached. 157s Unmounting file systems. 157s Unmounting '/run/shutdown/mounts/8965fe7dd8a75fea'. 157s Failed to unmount /run/shutdown/mounts/8965fe7dd8a75fea: Device or resource busy 157s Not all file systems unmounted, 1 left. 157s Detaching loop devices. 157s Detaching loopback /dev/loop1. 157s Could not detach loopback /dev/loop1: Device or resource busy 157s Detaching loopback /dev/loop0. 157s Could not detach loopback /dev/loop0: Device or resource busy 157s Not all loop devices detached, 2 left. 157s Unmounting file systems. 157s Unmounting '/run/shutdown/mounts/8965fe7dd8a75fea'. 157s Failed to unmount /run/shutdown/mounts/8965fe7dd8a75fea: Device or resource busy 157s Not all file systems unmounted, 1 left. 157s Detaching loop devices. 157s Detaching loopback /dev/loop1. 157s Could not detach loopback /dev/loop1: Device or resource busy 157s Detaching loopback /dev/loop0. 157s Could not detach loopback /dev/loop0: Device or resource busy 157s Not all loop devices detached, 2 left. 157s Cannot finalize remaining file systems, loop devices, continuing. 157s Unable to finalize remaining file systems, loop devices, ignoring. 157s Syncing filesystems and block devices. 157s Powering off. 157s [ 23.891876] sd 2:0:0:0: [sda] Synchronizing SCSI cache 157s [ 24.218205] ACPI: PM: Preparing to enter system sleep state S5 157s [ 24.219865] reboot: Power down 157s + rm -rf result 157s + mkdir result 157s + set -x 157s + grep -e '^--FILE .* FILE--$' qemu-output.txt 157s + read LINE 157s ++ echo --FILE lsblk.txt FILE-- 157s ++ sed -e 's/--FILE \(.*\) FILE--.*/\1/' 157s + filename=lsblk.txt 157s + touch result/lsblk.txt 157s + read LINE 157s ++ echo --FILE add-user-agent.txt FILE-- 157s ++ sed -e 's/--FILE \(.*\) FILE--.*/\1/' 157s + filename=add-user-agent.txt 157s + touch result/add-user-agent.txt 157s + read LINE 157s + grep -e '^--OUT .* BEGIN-- .* --END--$' qemu-output.txt 157s + read LINE 157s ++ echo --OUT lsblk.txt BEGIN-- NAME MAJ:MIN RM SIZE RO TYPE MOUNTPOINTS --END-- 157s ++ sed -e 's/--OUT \(.*\) BEGIN--.*/\1/' 157s + filename=lsblk.txt 157s ++ echo --OUT lsblk.txt BEGIN-- NAME MAJ:MIN RM SIZE RO TYPE MOUNTPOINTS --END-- 157s ++ sed -e 's/--OUT .* BEGIN-- \(.*\) --END--/\1/' 157s + content='NAME MAJ:MIN RM SIZE RO TYPE MOUNTPOINTS' 157s + echo 'NAME MAJ:MIN RM SIZE RO TYPE MOUNTPOINTS' 157s + read LINE 157s ++ echo --OUT lsblk.txt BEGIN-- fd0 2:0 1 4K 0 disk --END-- 157s ++ sed -e 's/--OUT \(.*\) BEGIN--.*/\1/' 157s + filename=lsblk.txt 157s ++ echo --OUT lsblk.txt BEGIN-- fd0 2:0 1 4K 0 disk --END-- 157s ++ sed -e 's/--OUT .* BEGIN-- \(.*\) --END--/\1/' 157s + content='fd0 2:0 1 4K 0 disk' 157s + echo 'fd0 2:0 1 4K 0 disk' 157s + read LINE 157s ++ echo --OUT lsblk.txt BEGIN-- loop0 7:0 0 265.3M 1 loop /rofs --END-- 157s ++ sed -e 's/--OUT \(.*\) BEGIN--.*/\1/' 157s + filename=lsblk.txt 157s ++ echo --OUT lsblk.txt BEGIN-- loop0 7:0 0 265.3M 1 loop /rofs --END-- 157s ++ sed -e 's/--OUT .* BEGIN-- \(.*\) --END--/\1/' 157s + content='loop0 7:0 0 265.3M 1 loop /rofs' 157s + echo 'loop0 7:0 0 265.3M 1 loop /rofs' 157s + read LINE 157s ++ echo --OUT lsblk.txt BEGIN-- loop1 7:1 0 4K 1 loop --END-- 157s ++ sed -e 's/--OUT \(.*\) BEGIN--.*/\1/' 157s + filename=lsblk.txt 157s ++ echo --OUT lsblk.txt BEGIN-- loop1 7:1 0 4K 1 loop --END-- 157s ++ sed -e 's/--OUT .* BEGIN-- \(.*\) --END--/\1/' 157s + content='loop1 7:1 0 4K 1 loop' 157s + echo 'loop1 7:1 0 4K 1 loop' 157s + read LINE 157s ++ echo --OUT lsblk.txt BEGIN-- sda 8:0 0 1G 0 disk --END-- 157s ++ sed -e 's/--OUT \(.*\) BEGIN--.*/\1/' 157s + filename=lsblk.txt 157s ++ echo --OUT lsblk.txt BEGIN-- sda 8:0 0 1G 0 disk --END-- 157s ++ sed -e 's/--OUT .* BEGIN-- \(.*\) --END--/\1/' 157s + content='sda 8:0 0 1G 0 disk' 157s + echo 'sda 8:0 0 1G 0 disk' 157s + read LINE 157s ++ echo --OUT lsblk.txt BEGIN-- '`-sda1' 8:1 0 1022M 0 part /cdrom --END-- 157s ++ sed -e 's/--OUT \(.*\) BEGIN--.*/\1/' 157s + filename=lsblk.txt 157s ++ echo --OUT lsblk.txt BEGIN-- '`-sda1' 8:1 0 1022M 0 part /cdrom --END-- 157s ++ sed -e 's/--OUT .* BEGIN-- \(.*\) --END--/\1/' 157s + content='`-sda1 8:1 0 1022M 0 part /cdrom' 157s + echo '`-sda1 8:1 0 1022M 0 part /cdrom' 157s + read LINE 157s ++ echo --OUT lsblk.txt BEGIN-- sr0 11:0 1 1024M 0 rom --END-- 157s ++ sed -e 's/--OUT \(.*\) BEGIN--.*/\1/' 157s + filename=lsblk.txt 157s ++ echo --OUT lsblk.txt BEGIN-- sr0 11:0 1 1024M 0 rom --END-- 157s ++ sed -e 's/--OUT .* BEGIN-- \(.*\) --END--/\1/' 157s + content='sr0 11:0 1 1024M 0 rom' 157s + echo 'sr0 11:0 1 1024M 0 rom' 157s + read LINE 157s ++ echo --OUT add-user-agent.txt BEGIN-- live/20190829 --END-- 157s ++ sed -e 's/--OUT \(.*\) BEGIN--.*/\1/' 157s + filename=add-user-agent.txt 157s ++ echo --OUT add-user-agent.txt BEGIN-- live/20190829 --END-- 157s ++ sed -e 's/--OUT .* BEGIN-- \(.*\) --END--/\1/' 157s + content=live/20190829 157s + echo live/20190829 157s + read LINE 157s ++ grep -q /rofs result/lsblk.txt 157s ++ grep -q '^live/20190829$' result/add-user-agent.txt 157s + cleanup_mounts_and_devices 157s + _mounts=() 157s + _loop_devs=() 157s ### Testing auto log persistence 157s + for f in $TESTS 158s + eval test_auto_log_persistence 158s ++ test_auto_log_persistence 158s ++ echo '### Testing auto log persistence' 158s ++ ./debian/tests/prep-image image.img 'touch /var/log/hello /var/crash/report.crash' 158s + IMAGE=image.img 158s + rm -rf tmp 158s + mkdir -p tmp 158s + mount -t tmpfs none tmp/ 158s + mkdir -p tmp/overlay tmp/work tmp/root tmp/mnt 158s + mount -t squashfs images/root.squashfs tmp/root 158s + mount -t overlay overlay -o lowerdir=tmp/root,upperdir=tmp/overlay,workdir=tmp/work tmp/mnt 158s + rm -f tmp/mnt/sbin/init 158s + cat 158s + echo 'touch /var/log/hello /var/crash/report.crash' 158s + cat 158s Parallel mksquashfs: Using 2 processors 158s Creating 4.0 filesystem on tmp/overlay.squashfs, block size 131072. 158s [===================================================================|] 1/1 100% 158s 158s Exportable Squashfs 4.0 filesystem, gzip compressed, data block size 131072 158s compressed data, compressed metadata, compressed fragments, 158s compressed xattrs, compressed ids 158s duplicates are removed 158s Filesystem size 0.60 Kbytes (0.00 Mbytes) 158s 68.49% of uncompressed filesystem size (0.87 Kbytes) 158s Inode table size 72 bytes (0.07 Kbytes) 158s 46.75% of uncompressed inode table size (154 bytes) 158s Directory table size 49 bytes (0.05 Kbytes) 158s 67.12% of uncompressed directory table size (73 bytes) 158s Xattr table size 89 bytes (0.09 Kbytes) 158s 47.09% of uncompressed xattr table size (189 bytes) 158s Number of duplicate files found 0 158s Number of inodes 4 158s Number of files 1 158s Number of fragments 1 158s Number of symbolic links 0 158s Number of device nodes 0 158s Number of fifo nodes 0 158s Number of socket nodes 0 158s Number of directories 3 158s Number of hard-links 0 158s Number of ids (unique uids + gids) 1 158s Number of uids 1 158s root (0) 158s Number of gids 1 158s root (0) 158s + chmod u+x tmp/mnt/sbin/init 158s + umount tmp/mnt 158s + umount tmp/root 158s + mksquashfs tmp/overlay tmp/overlay.squashfs 158s + rm -rf image.img 158s + truncate -s 1G image.img 158s + parted --script --align optimal image.img -- mklabel gpt mkpart primary ext4 1MiB -2048s 158s ++ losetup -Pf --show image.img 158s + dev=/dev/loop0 158s + mke2fs -L rootfs -q /dev/loop0p1 158s The file /dev/loop0p1 does not exist and no size was specified. 158s autopkgtest [15:30:26]: test boot: -----------------------] 158s autopkgtest [15:30:27]: test boot: - - - - - - - - - - results - - - - - - - - - - 158s boot FAIL non-zero exit status 1 158s autopkgtest [15:30:27]: @@@@@@@@@@@@@@@@@@@@ summary 158s boot FAIL non-zero exit status 1 159s rm: cannot remove '/tmp/autopkgtest.byzVRO/build.nH8/src/tmp': Device or resource busy