0s autopkgtest [10:15:55]: starting date and time: 2025-05-24 10:15:55+0000 0s autopkgtest [10:15:55]: git checkout: 9986aa8c Merge branch 'skia/fix_network_interface' into 'ubuntu/production' 0s autopkgtest [10:15:55]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.clyqonan/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:linux-meta-lowlatency-hwe-5.15,src:linux-lowlatency-hwe-5.15,src:linux-signed-lowlatency-hwe-5.15 --apt-upgrade acpi-call --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=linux-meta-lowlatency-hwe-5.15/5.15.0.142.152~20.04.1 linux-lowlatency-hwe-5.15/5.15.0-142.152~20.04.1 linux-signed-lowlatency-hwe-5.15/5.15.0-142.152~20.04.1' --setup-commands 'apt-get install -y ^kernel-testing--linux\-lowlatency\-hwe\-5\.15--full--preferred$ || apt-get install -y ^linux-image\-lowlatency\-hwe\-5\.15$ ^linux-headers\-lowlatency\-hwe\-5\.15$ || apt-get install -y ^linux-image-generic\-lowlatency\-hwe\-5\.15$ ^linux-headers-generic\-lowlatency\-hwe\-5\.15$' --setup-commands 'apt-get install -y ^kernel-testing--linux\-lowlatency\-hwe\-5\.15--modules-extra--preferred$ || apt-get install -y ^linux-modules-extra\-lowlatency\-hwe\-5\.15$ || :' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-cpu2-ram4-disk20-arm64 --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@sto01-arm64-1.secgroup --name adt-focal-arm64-acpi-call-20250524-100020-juju-7f2275-prod-proposed-migration-environment-15-7ea16a70-92ed-421b-b021-d368a75ec3a6 --image adt/ubuntu-focal-arm64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-15 --net-id=net_prod-autopkgtest-workers-arm64 -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 63s autopkgtest [10:16:58]: testbed dpkg architecture: arm64 63s autopkgtest [10:16:58]: testbed apt version: 2.0.10 64s autopkgtest [10:16:59]: @@@@@@@@@@@@@@@@@@@@ test bed setup 64s autopkgtest [10:16:59]: testbed release detected to be: None 64s autopkgtest [10:16:59]: updating testbed package index (apt update) 65s Hit:1 http://ftpmaster.internal/ubuntu focal InRelease 65s Hit:2 http://ftpmaster.internal/ubuntu focal-updates InRelease 65s Hit:3 http://ftpmaster.internal/ubuntu focal-security InRelease 65s Get:4 http://ftpmaster.internal/ubuntu focal-proposed InRelease [277 kB] 65s Get:5 http://ftpmaster.internal/ubuntu focal-proposed/main Sources [32.7 kB] 65s Get:6 http://ftpmaster.internal/ubuntu focal-proposed/restricted Sources [9344 B] 65s Get:7 http://ftpmaster.internal/ubuntu focal-proposed/universe Sources [6856 B] 65s Get:8 http://ftpmaster.internal/ubuntu focal-proposed/main arm64 Packages [297 kB] 65s Get:9 http://ftpmaster.internal/ubuntu focal-proposed/main arm64 c-n-f Metadata [1708 B] 65s Get:10 http://ftpmaster.internal/ubuntu focal-proposed/restricted arm64 Packages [2936 B] 65s Get:11 http://ftpmaster.internal/ubuntu focal-proposed/restricted arm64 c-n-f Metadata [116 B] 65s Get:12 http://ftpmaster.internal/ubuntu focal-proposed/universe arm64 Packages [44.5 kB] 65s Get:13 http://ftpmaster.internal/ubuntu focal-proposed/universe arm64 c-n-f Metadata [1844 B] 65s Get:14 http://ftpmaster.internal/ubuntu focal-proposed/multiverse arm64 Packages [1020 B] 65s Get:15 http://ftpmaster.internal/ubuntu focal-proposed/multiverse arm64 c-n-f Metadata [116 B] 69s Fetched 675 kB in 1s (900 kB/s) 70s Reading package lists... 71s Reading package lists... 71s Building dependency tree... 71s Reading state information... 71s The following additional packages will be installed: 71s linux-headers-5.15.0-142-lowlatency linux-headers-lowlatency-hwe-20.04 71s linux-image-5.15.0-142-lowlatency linux-image-lowlatency-hwe-20.04 71s linux-lowlatency-hwe-5.15-headers-5.15.0-142 71s linux-modules-5.15.0-142-lowlatency 71s Suggested packages: 71s fdutils linux-doc | linux-lowlatency-hwe-5.15-source-5.15.0 71s linux-lowlatency-hwe-5.15-tools linux-modules-extra-5.15.0-142-lowlatency 71s Recommended packages: 71s thermald 71s The following NEW packages will be installed: 71s linux-headers-5.15.0-142-lowlatency linux-headers-lowlatency-hwe-20.04 71s linux-image-5.15.0-142-lowlatency linux-image-lowlatency-hwe-20.04 71s linux-lowlatency-hwe-20.04 linux-lowlatency-hwe-5.15-headers-5.15.0-142 71s linux-modules-5.15.0-142-lowlatency 71s 0 upgraded, 7 newly installed, 0 to remove and 0 not upgraded. 71s Need to get 111 MB of archives. 71s After this operation, 725 MB of additional disk space will be used. 71s Get:1 http://ftpmaster.internal/ubuntu focal-proposed/main arm64 linux-lowlatency-hwe-5.15-headers-5.15.0-142 all 5.15.0-142.152~20.04.1 [12.0 MB] 72s Get:2 http://ftpmaster.internal/ubuntu focal-proposed/main arm64 linux-headers-5.15.0-142-lowlatency arm64 5.15.0-142.152~20.04.1 [2221 kB] 72s Get:3 http://ftpmaster.internal/ubuntu focal-proposed/main arm64 linux-headers-lowlatency-hwe-20.04 arm64 5.15.0.142.152~20.04.1 [2452 B] 72s Get:4 http://ftpmaster.internal/ubuntu focal-proposed/main arm64 linux-modules-5.15.0-142-lowlatency arm64 5.15.0-142.152~20.04.1 [82.2 MB] 74s Get:5 http://ftpmaster.internal/ubuntu focal-proposed/main arm64 linux-image-5.15.0-142-lowlatency arm64 5.15.0-142.152~20.04.1 [14.7 MB] 74s Get:6 http://ftpmaster.internal/ubuntu focal-proposed/main arm64 linux-image-lowlatency-hwe-20.04 arm64 5.15.0.142.152~20.04.1 [2536 B] 74s Get:7 http://ftpmaster.internal/ubuntu focal-proposed/main arm64 linux-lowlatency-hwe-20.04 arm64 5.15.0.142.152~20.04.1 [1928 B] 74s dpkg-preconfigure: unable to re-open stdin: No such file or directory 74s Fetched 111 MB in 3s (43.6 MB/s) 74s Selecting previously unselected package linux-lowlatency-hwe-5.15-headers-5.15.0-142. 74s (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 ... 67873 files and directories currently installed.) 74s Preparing to unpack .../0-linux-lowlatency-hwe-5.15-headers-5.15.0-142_5.15.0-142.152~20.04.1_all.deb ... 74s Unpacking linux-lowlatency-hwe-5.15-headers-5.15.0-142 (5.15.0-142.152~20.04.1) ... 76s Selecting previously unselected package linux-headers-5.15.0-142-lowlatency. 76s Preparing to unpack .../1-linux-headers-5.15.0-142-lowlatency_5.15.0-142.152~20.04.1_arm64.deb ... 76s Unpacking linux-headers-5.15.0-142-lowlatency (5.15.0-142.152~20.04.1) ... 76s Selecting previously unselected package linux-headers-lowlatency-hwe-20.04. 76s Preparing to unpack .../2-linux-headers-lowlatency-hwe-20.04_5.15.0.142.152~20.04.1_arm64.deb ... 76s Unpacking linux-headers-lowlatency-hwe-20.04 (5.15.0.142.152~20.04.1) ... 76s Selecting previously unselected package linux-modules-5.15.0-142-lowlatency. 76s Preparing to unpack .../3-linux-modules-5.15.0-142-lowlatency_5.15.0-142.152~20.04.1_arm64.deb ... 76s Unpacking linux-modules-5.15.0-142-lowlatency (5.15.0-142.152~20.04.1) ... 82s Selecting previously unselected package linux-image-5.15.0-142-lowlatency. 82s Preparing to unpack .../4-linux-image-5.15.0-142-lowlatency_5.15.0-142.152~20.04.1_arm64.deb ... 82s Unpacking linux-image-5.15.0-142-lowlatency (5.15.0-142.152~20.04.1) ... 82s Selecting previously unselected package linux-image-lowlatency-hwe-20.04. 82s Preparing to unpack .../5-linux-image-lowlatency-hwe-20.04_5.15.0.142.152~20.04.1_arm64.deb ... 82s Unpacking linux-image-lowlatency-hwe-20.04 (5.15.0.142.152~20.04.1) ... 82s Selecting previously unselected package linux-lowlatency-hwe-20.04. 82s Preparing to unpack .../6-linux-lowlatency-hwe-20.04_5.15.0.142.152~20.04.1_arm64.deb ... 82s Unpacking linux-lowlatency-hwe-20.04 (5.15.0.142.152~20.04.1) ... 83s Setting up linux-lowlatency-hwe-5.15-headers-5.15.0-142 (5.15.0-142.152~20.04.1) ... 83s Setting up linux-headers-5.15.0-142-lowlatency (5.15.0-142.152~20.04.1) ... 83s Setting up linux-headers-lowlatency-hwe-20.04 (5.15.0.142.152~20.04.1) ... 83s Setting up linux-modules-5.15.0-142-lowlatency (5.15.0-142.152~20.04.1) ... 84s Setting up linux-image-5.15.0-142-lowlatency (5.15.0-142.152~20.04.1) ... 86s I: /boot/vmlinuz is now a symlink to vmlinuz-5.15.0-142-lowlatency 86s I: /boot/initrd.img is now a symlink to initrd.img-5.15.0-142-lowlatency 86s Setting up linux-image-lowlatency-hwe-20.04 (5.15.0.142.152~20.04.1) ... 86s Setting up linux-lowlatency-hwe-20.04 (5.15.0.142.152~20.04.1) ... 86s Processing triggers for linux-image-5.15.0-142-lowlatency (5.15.0-142.152~20.04.1) ... 86s /etc/kernel/postinst.d/initramfs-tools: 86s update-initramfs: Generating /boot/initrd.img-5.15.0-142-lowlatency 104s flash-kernel: deferring update (trigger activated) 104s /etc/kernel/postinst.d/zz-flash-kernel: 104s flash-kernel: deferring update (trigger activated) 105s /etc/kernel/postinst.d/zz-update-grub: 105s Sourcing file `/etc/default/grub' 105s Sourcing file `/etc/default/grub.d/init-select.cfg' 105s Generating grub configuration file ... 105s Found linux image: /boot/vmlinuz-5.15.0-142-lowlatency 105s Found initrd image: /boot/initrd.img-5.15.0-142-lowlatency 105s Found linux image: /boot/vmlinuz-5.4.0-216-generic 105s Found initrd image: /boot/initrd.img-5.4.0-216-generic 105s Adding boot menu entry for UEFI Firmware Settings 105s done 105s Processing triggers for flash-kernel (3.103ubuntu1~20.04.4) ... 105s Unsupported platform on EFI system, doing nothing. 106s Reading package lists... 106s Building dependency tree... 106s Reading state information... 106s E: Unable to locate package ^kernel-testing--linux-lowlatency-hwe-5.15--modules-extra--preferred$ 106s E: Couldn't find any package by glob '^kernel-testing--linux-lowlatency-hwe-5.15--modules-extra--preferred$' 106s E: Couldn't find any package by regex '^kernel-testing--linux-lowlatency-hwe-5.15--modules-extra--preferred$' 106s Reading package lists... 106s Building dependency tree... 106s Reading state information... 107s E: Unable to locate package ^linux-modules-extra-lowlatency-hwe-5.15$ 107s E: Couldn't find any package by glob '^linux-modules-extra-lowlatency-hwe-5.15$' 107s E: Couldn't find any package by regex '^linux-modules-extra-lowlatency-hwe-5.15$' 107s autopkgtest [10:17:42]: upgrading testbed (apt dist-upgrade and autopurge) 107s Reading package lists... 107s Building dependency tree... 107s Reading state information... 107s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 107s Starting 2 pkgProblemResolver with broken count: 0 107s Done 107s 107s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 107s Reading package lists... 108s Building dependency tree... 108s Reading state information... 108s Starting pkgProblemResolver with broken count: 0 108s Starting 2 pkgProblemResolver with broken count: 0 108s Done 108s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 108s autopkgtest [10:17:43]: rebooting testbed after setup commands that affected boot 129s autopkgtest-virt-ssh [10:18:04]: ------- nova console-log 01e5357d-cf30-43e1-a8aa-cf1db1eb659e (adt-focal-arm64-acpi-call-20250524-100020-juju-7f2275-prod-proposed-migration-environment-15-7ea16a70-92ed-421b-b021-d368a75ec3a6) ------ 129s [2J[01;01H[=3h[2J[01;01HBdsDxe: loading Boot0002 "UEFI Misc Device 2" from PciRoot(0x0)/Pci(0x1,0x3)/Pci(0x0,0x0) 129s BdsDxe: starting Boot0002 "UEFI Misc Device 2" from PciRoot(0x0)/Pci(0x1,0x3)/Pci(0x0,0x0) 129s error: no suitable video mode found. 129s cloudimg-rootfs: clean, 74765/2593280 files, 692349/5217019 blocks 129s [[0;32m OK [0m] Started [0;1;39mShow Plymouth Boot Screen[0m. 129s [[0;32m OK [0m] Started [0;1;39mForward Password R���s to Plymouth Directory Watch[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mLocal Encrypted Volumes[0m. 129s plymouth-start.service 129s [[0;32m OK [0m] Found device [0;1;39m/dev/ttyAMA0[0m. 129s [[0;32m OK [0m] Found device [0;1;39m/dev/disk/by-label/UEFI[0m. 129s [[0;32m OK [0m] Listening on [0;1;39mLoad/Save RF ���itch Status /dev/rfkill Watch[0m. 129s Starting [0;1;39mLoad Kernel Module chromeos_pstore[0m... 129s Starting [0;1;39mLoad Kernel Module pstore_blk[0m... 129s Starting [0;1;39mLoad Kernel Module pstore_zone[0m... 129s [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module chromeos_pstore[0m. 129s [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module pstore_blk[0m. 129s [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module pstore_zone[0m. 129s systemd-udev-settle.service 129s [[0;32m OK [0m] Finished [0;1;39mudev Wait for Complete Device Initialization[0m. 129s Starting [0;1;39mDevice-Mapper Multipath Device Controller[0m... 129s [[0;32m OK [0m] Started [0;1;39mDevice-Mapper Multipath Device Controller[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mLocal File Systems (Pre)[0m. 129s multipathd.service 129s Starting [0;1;39mFile System Check on /dev/disk/by-label/UEFI[0m... 129s [[0;32m OK [0m] Started [0;1;39mFile System Check Daemon to report status[0m. 129s systemd-fsckd.service 129s [[0;32m OK [0m] Finished [0;1;39mFile System Check on /dev/disk/by-label/UEFI[0m. 129s systemd-fsck@dev-disk-by\x2dlabel-UEFI.service 129s Mounting [0;1;39m/boot/efi[0m... 129s [[0;32m OK [0m] Mounted [0;1;39m/boot/efi[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mLocal File Systems[0m. 129s boot-efi.mount 129s Starting [0;1;39mLoad AppArmor profiles[0m... 129s Starting [0;1;39mSet console font and keymap[0m... 129s Starting [0;1;39mCloud-init: Local Stage (pre-network)[0m... 129s Starting [0;1;39mTell Plymouth To Write Out Runtime Data[0m... 129s Starting [0;1;39mCreate Volatile Files and Directories[0m... 129s [[0;32m OK [0m] Finished [0;1;39mSet console font and keymap[0m. 129s console-setup.service 129s [[0;32m OK [0m] Finished [0;1;39mTell Plymouth To Write Out Runtime Data[0m. 129s [[0;32m OK [0m] Finished [0;1;39mCreate Volatile Files and Directories[0m. 129s systemd-tmpfiles-setup.service 129s Starting [0;1;39mNetwork Time Synchronization[0m... 129s Starting [0;1;39mUpdate UTMP about System Boot/Shutdown[0m... 129s [[0;32m OK [0m] Finished [0;1;39mUpdate UTMP about System Boot/Shutdown[0m. 129s systemd-update-utmp.service 129s [[0;32m OK [0m] Finished [0;1;39mLoad AppArmor profiles[0m. 129s apparmor.service 129s [[0;32m OK [0m] Started [0;1;39mNetwork Time Synchronization[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mSystem Time Set[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mSystem Time Synchronized[0m. 129s systemd-timesyncd.service 129s [ 4.515674] cloud-init[447]: Cloud-init v. 24.4.1-0ubuntu0~20.04.2 running 'init-local' at Sat, 24 May 2025 10:16:39 +0000. Up 3.41 seconds. 129s [[0;32m OK [0m] Finished [0;1;39mCloud-init: Local Stage (pre-network)[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mNetwork (Pre)[0m. 129s cloud-init-local.service 129s Starting [0;1;39mNetwork Service[0m... 129s [[0;32m OK [0m] Started [0;1;39mNetwork Service[0m. 129s Starting [0;1;39mWait for Network to be Configured[0m... 129s Starting [0;1;39mNetwork Name Resolution[0m... 129s systemd-networkd.service 129s [[0;32m OK [0m] Started [0;1;39mNetwork Name Resolution[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mNetwork[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mHost and Network Name Lookups[0m. 129s systemd-resolved.service 129s [[0;32m OK [0m] Finished [0;1;39mWait for Network to be Configured[0m. 129s systemd-networkd-wait-online.service 129s Starting [0;1;39mCloud-init: Network Stage[0m... 129s [ 6.126588] cloud-init[510]: Cloud-init v. 24.4.1-0ubuntu0~20.04.2 running 'init' at Sat, 24 May 2025 10:16:41 +0000. Up 5.99 seconds. 129s [ 6.126682] cloud-init[510]: ci-info: ++++++++++++++++++++++++++++++++++++++Net device info+++++++++++++++++++++++++++++++++++++++ 129s [ 6.126707] cloud-init[510]: ci-info: +--------+------+-----------------------------+---------------+--------+-------------------+ 129s [ 6.126738] cloud-init[510]: ci-info: | Device | Up | Address | Mask | Scope | Hw-Address | 129s [ 6.126768] cloud-init[510]: ci-info: +--------+------+-----------------------------+---------------+--------+-------------------+ 129s [ 6.126788] cloud-init[510]: ci-info: | enp1s0 | True | 10.151.35.201 | 255.255.255.0 | global | fa:16:3e:0f:08:13 | 129s [ 6.126813] cloud-init[510]: ci-info: | enp1s0 | True | fe80::f816:3eff:fe0f:813/64 | . | link | fa:16:3e:0f:08:13 | 129s [ 6.126838] cloud-init[510]: ci-info: | lo | True | 127.0.0.1 | 255.0.0.0 | host | . | 129s [ 6.126862] cloud-init[510]: ci-info: | lo | True | ::1/128 | . | host | . | 129s [ 6.126884] cloud-init[510]: ci-info: +--------+------+-----------------------------+---------------+--------+-------------------+ 129s [ 6.126904] cloud-init[510]: ci-info: ++++++++++++++++++++++++++++++++Route IPv4 info++++++++++++++++++++++++++++++++ 129s [ 6.126923] cloud-init[510]: ci-info: +-------+-----------------+-------------+-----------------+-----------+-------+ 129s [ 6.126942] cloud-init[510]: ci-info: | Route | Destination | Gateway | Genmask | Interface | Flags | 129s [ 6.126974] cloud-init[510]: ci-info: +-------+-----------------+-------------+-----------------+-----------+-------+ 129s [ 6.127001] cloud-init[510]: ci-info: | 0 | 0.0.0.0 | 10.151.35.1 | 0.0.0.0 | enp1s0 | UG | 129s [ 6.127025] cloud-init[510]: ci-info: | 1 | 10.151.35.0 | 0.0.0.0 | 255.255.255.0 | enp1s0 | U | 129s [ 6.127045] cloud-init[510]: ci-info: | 2 | 169.254.169.254 | 10.151.35.2 | 255.255.255.255 | enp1s0 | UGH | 129s [ 6.127069] cloud-init[510]: ci-info: +-------+-----------------+-------------+-----------------+-----------+-------+ 129s [ 6.127088] cloud-init[510]: ci-info: +++++++++++++++++++Route IPv6 info+++++++++++++++++++ 129s [ 6.127114] cloud-init[510]: ci-info: +-------+-------------+---------+-----------+-------+ 129s [ 6.127138] cloud-init[510]: ci-info: | Route | Destination | Gateway | Interface | Flags | 129s [ 6.127161] cloud-init[510]: ci-info: +-------+-------------+---------+-----------+-------+ 129s [ 6.127180] cloud-init[510]: ci-info: | 1 | fe80::/64 | :: | enp1s0 | U | 129s [ 6.127213] cloud-init[510]: ci-info: | 3 | local | :: | enp1s0 | U | 129s [ 6.127233] cloud-init[510]: ci-info: | 4 | multicast | :: | enp1s0 | U | 129s [ 6.127252] cloud-init[510]: ci-info: +-------+-------------+---------+-----------+-------+ 129s [ 6.127282] cloud-init[510]: 2025-05-24 10:16:42,047 - schema.py[WARNING]: cloud-config failed schema validation! You may run 'sudo cloud-init schema --system' to check the details. 129s [ 6.745307] cloud-init[510]: Generating public/private rsa key pair. 129s [ 6.745388] cloud-init[510]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key 129s [ 6.745425] cloud-init[510]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub 129s [ 6.745470] cloud-init[510]: The key fingerprint is: 129s [ 6.745514] cloud-init[510]: SHA256:feyCZlp145cDUoHQ9CMJmLTPMbl1CrDjgIxMMABaS9Q root@autopkgtest 129s [ 6.745541] cloud-init[510]: The key's randomart image is: 129s [ 6.745572] cloud-init[510]: +---[RSA 3072]----+ 129s [ 6.745598] cloud-init[510]: |Oo+. .ooo+... | 129s [ 6.745623] cloud-init[510]: |+* oE o+ ooo . | 129s [ 6.745643] cloud-init[510]: |o.+ . + = + = | 129s [ 6.745662] cloud-init[510]: | o + B * . | 129s [ 6.745681] cloud-init[510]: | . S = * | 129s [ 6.745708] cloud-init[510]: | o * o . | 129s [ 6.745733] cloud-init[510]: | = . o + | 129s [ 6.745758] cloud-init[510]: | = . . . | 129s [ 6.745782] cloud-init[510]: | . | 129s [ 6.745802] cloud-init[510]: +----[SHA256]-----+ 129s [ 6.745826] cloud-init[510]: Generating public/private ecdsa key pair. 129s [ 6.745854] cloud-init[510]: Your identification has been saved in /etc/ssh/ssh_host_ecdsa_key 129s [ 6.745879] cloud-init[510]: Your public key has been saved in /etc/ssh/ssh_host_ecdsa_key.pub 129s [ 6.745904] cloud-init[510]: The key fingerprint is: 129s [ 6.745925] cloud-init[510]: SHA256:vmFQ5NZ7lk8Ur6O5HDN5uj0GxwS5SyasiU2F8zwkTQg root@autopkgtest 129s [ 6.745953] cloud-init[510]: The key's randomart image is: 129s [ 6.745974] cloud-init[510]: +---[ECDSA 256]---+ 129s [ 6.746002] cloud-init[510]: | E..=. .. | 129s [ 6.746029] cloud-init[510]: | o=.+ o o | 129s [ 6.746054] cloud-init[510]: | +O. o. .| 129s [ 6.746079] cloud-init[510]: | o. *.+o.. | 129s [ 6.746104] cloud-init[510]: | .+So.=+++ | 129s [ 6.746129] cloud-init[510]: | .o+ oo*o. | 129s [ 6.746150] cloud-init[510]: | + Boo | 129s [ 6.746170] cloud-init[510]: | . o . Oo | 129s [ 6.746197] cloud-init[510]: | . =o.. | 129s [ 6.746222] cloud-init[510]: +----[SHA256]-----+ 129s [ 6.746242] cloud-init[510]: Generating public/private ed25519 key pair. 129s [ 6.746267] cloud-init[510]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key 129s [ 6.746287] cloud-init[510]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub 129s [ 6.746307] cloud-init[510]: The key fingerprint is: 129s [ 6.746330] cloud-init[510]: SHA256:FBfpGvNZ/yGuP1wxgMcCGNFQGbFP/jwzmT3U1A1dSi4 root@autopkgtest 129s [ 6.746358] cloud-init[510]: The key's randomart image is: 129s [ 6.746379] cloud-init[510]: +--[ED25519 256]--+ 129s [ 6.746399] cloud-init[510]: | +O=Boo o.o| 129s [ 6.746419] cloud-init[510]: | . =oo * o+| 129s [ 6.746443] cloud-init[510]: | .o .E + +| 129s [ 6.746478] cloud-init[510]: | .o = .. +.| 129s [ 6.746501] cloud-init[510]: | S= = . .+| 129s [ 6.746521] cloud-init[510]: | . o o.*o | 129s [ 6.746546] cloud-init[510]: | oOo+.| 129s [ 6.746576] cloud-init[510]: | ++ o| 129s [ 6.746601] cloud-init[510]: | .o.. | 129s [ 6.746622] cloud-init[510]: +----[SHA256]-----+ 129s [[0;32m OK [0m] Finished [0;1;39mCloud-init: Network Stage[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mCloud-config availability[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mNetwork is Online[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mSystem Initialization[0m. 129s [[0;32m OK [0m] Started [0;1;39mDaily apt download activities[0m. 129s [[0;32m OK [0m] Started [0;1;39mDaily apt upgrade and clean activities[0m. 129s [[0;32m OK [0m] Started [0;1;39mPeriodic ext4 Onli���ata Check for All Filesystems[0m. 129s [[0;32m OK [0m] Started [0;1;39mDiscard unused blocks once a week[0m. 129s [[0;32m OK [0m] Started [0;1;39mRefresh fwupd metadata regularly[0m. 129s [[0;32m OK [0m] Started [0;1;39mDaily rotation of log files[0m. 129s [[0;32m OK [0m] Started [0;1;39mDaily man-db regeneration[0m. 129s [[0;32m OK [0m] Started [0;1;39mMessage of the Day[0m. 129s [[0;32m OK [0m] Started [0;1;39mDaily Cleanup of Temporary Directories[0m. 129s cloud-init.service 129s [[0;32m OK [0m] Reached target [0;1;39mPaths[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mTimers[0m. 129s [[0;32m OK [0m] Listening on [0;1;39mcloud-init hotplug hook socket[0m. 129s [[0;32m OK [0m] Listening on [0;1;39mD-Bus System Message Bus Socket[0m. 129s [[0;32m OK [0m] Listening on [0;1;39mUUID daemon activation socket[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mSockets[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mBasic System[0m. 129s Starting [0;1;39mLSB: automatic crash report generation[0m... 129s Starting [0;1;39mDeferred execution scheduler[0m... 129s [[0;32m OK [0m] Started [0;1;39mautopkgtest root shell on ttyS1[0m. 129s Starting [0;1;39mCloud-init: Config Stage[0m... 129s [[0;32m OK [0m] Started [0;1;39mRegular background program processing daemon[0m. 129s [[0;32m OK [0m] Started [0;1;39mD-Bus System Message Bus[0m. 129s [[0;32m OK [0m] Started [0;1;39mSave initial kernel messages after boot[0m. 129s Starting [0;1;39mRemove Stale Onli���t4 Metadata Check Snapshots[0m... 129s Starting [0;1;39mRecord successful boot for GRUB[0m... 129s [[0;32m OK [0m] Started [0;1;39mirqbalance daemon[0m. 129s Starting [0;1;39mDispatcher daemon for systemd-networkd[0m... 129s Starting [0;1;39mAuthorization Manager[0m... 129s Starting [0;1;39mPollinate to seed���udo random number generator[0m... 129s [[0;32m OK [0m] Started [0;1;39mAdd entropy to /de���random 's pool a hardware RNG[0m. 129s autopkgtest@ttyS1.service 129s Starting [0;1;39mSystem Logging Service[0m... 129s Starting [0;1;39mLogin Service[0m... 129s Starting [0;1;39mPermit User Sessions[0m... 129s Starting [0;1;39mDisk Manager[0m... 129s [[0;32m OK [0m] Started [0;1;39mDeferred execution scheduler[0m. 129s cron.service 129s dbus.service 129s dmesg.service 129s irqbalance.service 129s rng-tools.service 129s atd.service 129s [[0;32m OK [0m] Finished [0;1;39mRemove Stale Onli���ext4 Metadata Check Snapshots[0m. 129s [[0;32m OK [0m] Finished [0;1;39mPermit User Sessions[0m. 129s systemd-user-sessions.service 129s [[0;32m OK [0m] Started [0;1;39mSystem Logging Service[0m. 129s rsyslog.service 129s [[0;32m OK [0m] Finished [0;1;39mRecord successful boot for GRUB[0m. 129s [[0;32m OK [0m] Started [0;1;39mLSB: automatic crash report generation[0m. 129s apport.service 129s Starting [0;1;39mGRUB failed boot detection[0m... 129s Starting [0;1;39mHold until boot process finishes up[0m... 129s Starting [0;1;39mTerminate Plymouth Boot Screen[0m... 129s [[0;32m OK [0m] Finished [0;1;39mGRUB failed boot detection[0m. 129s [[0;32m OK [0m] Started [0;1;39mLogin Service[0m. 129s systemd-logind.service 129s polkit.service 129s [ 7.666505] cloud-init[651]: Cloud-init v. 24.4.1-0ubuntu0~20.04.2 running 'modules:config' at Sat, 24 May 2025 10:16:43 +0000. Up 7.40 seconds. 129s 129s Ubuntu 20.04.6 LTS autopkgtest ttyAMA0 129s 129s autopkgtest login: [ 17.793091] cloud-init[724]: Hit:1 http://ftpmaster.internal/ubuntu focal InRelease 129s [ 17.819410] cloud-init[724]: Get:2 http://ftpmaster.internal/ubuntu focal-updates InRelease [128 kB] 129s [ 17.853356] cloud-init[724]: Get:3 http://ftpmaster.internal/ubuntu focal-security InRelease [128 kB] 129s [ 18.181579] cloud-init[724]: Fetched 256 kB in 0s (692 kB/s) 129s [ 18.958963] cloud-init[724]: Reading package lists... 129s ci-info: ++++++++++++++++++++++++++++++++++++++++++++++++++++++Authorized keys from /home/ubuntu/.ssh/authorized_keys for user ubuntu+++++++++++++++++++++++++++++++++++++++++++++++++++++++ 129s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+-----------------------------------------------------------+ 129s ci-info: | Keytype | Fingerprint (sha256) | Options | Comment | 129s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+-----------------------------------------------------------+ 129s ci-info: | ssh-rsa | 91:43:c5:c0:08:13:e1:4c:d2:84:a3:93:cc:b6:92:94:24:03:c7:0a:60:b3:34:9d:7f:63:f7:38:37:6f:9d:18 | - | ubuntu@juju-7f2275-prod-proposed-migration-environment-23 | 129s ci-info: | ssh-rsa | e8:35:e0:40:84:e9:20:46:36:c3:0d:24:8f:f7:02:62:a2:c6:f7:f5:5c:ed:3f:df:2b:54:8b:69:97:eb:98:5e | - | ubuntu@juju-7f2275-prod-proposed-migration-environment-15 | 129s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+-----------------------------------------------------------+ 129s <14>May 24 10:16:54 cloud-init: ############################################################# 129s <14>May 24 10:16:54 cloud-init: -----BEGIN SSH HOST KEY FINGERPRINTS----- 129s <14>May 24 10:16:54 cloud-init: 256 SHA256:vmFQ5NZ7lk8Ur6O5HDN5uj0GxwS5SyasiU2F8zwkTQg root@autopkgtest (ECDSA) 129s <14>May 24 10:16:54 cloud-init: 256 SHA256:FBfpGvNZ/yGuP1wxgMcCGNFQGbFP/jwzmT3U1A1dSi4 root@autopkgtest (ED25519) 129s <14>May 24 10:16:54 cloud-init: 3072 SHA256:feyCZlp145cDUoHQ9CMJmLTPMbl1CrDjgIxMMABaS9Q root@autopkgtest (RSA) 129s <14>May 24 10:16:54 cloud-init: -----END SSH HOST KEY FINGERPRINTS----- 129s <14>May 24 10:16:54 cloud-init: ############################################################# 129s -----BEGIN SSH HOST KEY KEYS----- 129s ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBBDN2WpF3eRikRqN3tCZuEidtuKj3Srb/E7DCGZFFuC6vFfVurRBp64gZ24dZSODL21mR6ohcWT5zIlSim7Sqjk= root@autopkgtest 129s ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIMJIy0uNrz/hHqRxRQZVm/oz059g9UN3MLZsTLJsS5Hg root@autopkgtest 129s ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDTNBBcL7MlJhsqDTIqPMUO6FLkeLSiEDXZwRDTuw42jXrOvfUhoCOokcMJV3d+AGIg0TKMADN1Ugba3owOR43pT3T0EJf/kB8Cd62ZPInKcYzjI/WTq9y0itNn3rPTGN7N/IzbhK94tXIF9UsaD+JugSHkZKTMD/q4jhDTSmO+xqhKvZoXpyuko443B1e/lrDTUPXjvrmtaGnDyvdB4qObbixtm4PhQFGPxRh4VM7+3gu7Pw19lMO1bXPOMQQAKSgkUAlnBwhOSRKkg545ZNmvFQEeKu1F6mFAl6E8CtUAR1lI2vzgihFPmzor1Pj3SAJcsTPSgJG9Jg35AL9XWRCoCoDmi9lwC8zRZ/K2CVBzr1O6dH6mP0aI7L7m3yboxqS7G6n50eajGiLW928Cdw3hQBqgn28GTqiFZ/Bpr5BptJdzqab9HQf1DbvkwcEpJrCui8HRAazug2T7PGwXb1OoKaoljgN6Gn2SWvtF1iLrtY/yzgDaGpwxNFzLBE3T/C8= root@autopkgtest 129s -----END SSH HOST KEY KEYS----- 129s [ 19.043984] cloud-init[724]: Cloud-init v. 24.4.1-0ubuntu0~20.04.2 running 'modules:final' at Sat, 24 May 2025 10:16:53 +0000. Up 17.47 seconds. 129s [ 19.045033] cloud-init[724]: Cloud-init v. 24.4.1-0ubuntu0~20.04.2 finished at Sat, 24 May 2025 10:16:54 +0000. Datasource DataSourceOpenStackLocal [net,ver=2]. Up 19.03 seconds 129s [[0;32m OK [0m] Stopped [0;1;39mLSB: automatic crash report generation[0m. 129s [[0;32m OK [0m] Started [0;1;39mShow Plymouth Reboot Screen[0m. 129s plymouth-reboot.service 129s [[0;32m OK [0m] Stopped [0;1;39mUser Manager for UID 1000[0m. 129s Stopping [0;1;39mUser Runtime Directory /run/user/1000[0m... 129s [[0;32m OK [0m] Unmounted [0;1;39m/run/user/1000[0m. 129s [[0;32m OK [0m] Stopped [0;1;39mUser Runtime Directory /run/user/1000[0m. 129s [[0;32m OK [0m] Removed slice [0;1;39mUser Slice of UID 1000[0m. 129s Stopping [0;1;39mD-Bus System Message Bus[0m... 129s Stopping [0;1;39mPermit User Sessions[0m... 129s [[0;32m OK [0m] Stopped [0;1;39mPermit User Sessions[0m. 129s [[0;32m OK [0m] Stopped target [0;1;39mNetwork[0m. 129s [[0;32m OK [0m] Stopped target [0;1;39mRemote File Systems[0m. 129s Stopping [0;1;39mNetwork Name Resolution[0m... 129s [[0;32m OK [0m] Stopped [0;1;39mD-Bus System Message Bus[0m. 129s [[0;32m OK [0m] Stopped [0;1;39mLogin Service[0m. 129s [[0;32m OK [0m] Stopped target [0;1;39mBasic System[0m. 129s [[0;32m OK [0m] Stopped [0;1;39mForward Password R���s to Plymouth Directory Watch[0m. 129s [[0;32m OK [0m] Stopped target [0;1;39mPaths[0m. 129s [[0;32m OK [0m] Stopped target [0;1;39mSlices[0m. 129s [[0;32m OK [0m] Removed slice [0;1;39mUser and Session Slice[0m. 129s [[0;32m OK [0m] Stopped target [0;1;39mSockets[0m. 129s [[0;32m OK [0m] Closed [0;1;39mD-Bus System Message Bus Socket[0m. 129s [[0;32m OK [0m] Closed [0;1;39mSyslog Socket[0m. 129s [[0;32m OK [0m] Closed [0;1;39mUUID daemon activation socket[0m. 129s [[0;32m OK [0m] Stopped target [0;1;39mSystem Initialization[0m. 129s [[0;32m OK [0m] Stopped target [0;1;39mLocal Encrypted Volumes[0m. 129s [[0;32m OK [0m] Stopped [0;1;39mForward Password R���uests to Wall Directory Watch[0m. 129s [[0;32m OK [0m] Stopped target [0;1;39mSwap[0m. 129s [[0;32m OK [0m] Stopped [0;1;39mCloud-init: Network Stage[0m. 129s [[0;32m OK [0m] Stopped [0;1;39mWait for Network to be Configured[0m. 129s Stopping [0;1;39mNetwork Time Synchronization[0m... 129s Stopping [0;1;39mUpdate UTMP about System Boot/Shutdown[0m... 129s [[0;32m OK [0m] Stopped [0;1;39mNetwork Name Resolution[0m. 129s Stopping [0;1;39mNetwork Service[0m... 129s [[0;32m OK [0m] Stopped [0;1;39mNetwork Time Synchronization[0m. 129s [[0;32m OK [0m] Stopped [0;1;39mUpdate UTMP about System Boot/Shutdown[0m. 129s [[0;32m OK [0m] Stopped [0;1;39mCreate Volatile Files and Directories[0m. 129s [[0;32m OK [0m] Stopped target [0;1;39mLocal File Systems[0m. 129s Unmounting [0;1;39m/boot/efi[0m... 129s [[0;32m OK [0m] Stopped [0;1;39mNetwork Service[0m. 129s [[0;32m OK [0m] Stopped target [0;1;39mNetwork (Pre)[0m. 129s [[0;32m OK [0m] Stopped [0;1;39mCloud-init: Local Stage (pre-network)[0m. 129s [[0;32m OK [0m] Stopped [0;1;39mApply Kernel Variables[0m. 129s [[0;32m OK [0m] Stopped [0;1;39mLoad Kernel Modules[0m. 129s [[0;32m OK [0m] Unmounted [0;1;39m/boot/efi[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mUnmount All Filesystems[0m. 129s [[0;32m OK [0m] Stopped [0;1;39mFile System Check on /dev/disk/by-label/UEFI[0m. 129s [[0;32m OK [0m] Removed slice [0;1;39msystem-systemd\x2dfsck.slice[0m. 129s [[0;32m OK [0m] Stopped target [0;1;39mLocal File Systems (Pre)[0m. 129s Stopping [0;1;39mDevice-Mapper Multipath Device Controller[0m... 129s [[0;32m OK [0m] Stopped [0;1;39mCreate Static Device Nodes in /dev[0m. 129s [[0;32m OK [0m] Stopped [0;1;39mCreate System Users[0m. 129s [[0;32m OK [0m] Stopped [0;1;39mRemount Root and Kernel File Systems[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mShutdown[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mFinal Step[0m. 129s [[0;32m OK [0m] Finished [0;1;39mReboot[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mReboot[0m. 129s [ 71.542884] reboot: Restarting system 129s [2J[01;01H[=3h[2J[01;01HBdsDxe: loading Boot0004 "ubuntu" from HD(15,GPT,B9A7C292-6D4B-4AE6-ACE8-F46F28F85A8E,0x800,0x31801)/\EFI\ubuntu\shimaa64.efi 129s BdsDxe: starting Boot0004 "ubuntu" from HD(15,GPT,B9A7C292-6D4B-4AE6-ACE8-F46F28F85A8E,0x800,0x31801)/\EFI\ubuntu\shimaa64.efi 129s error: no suitable video mode found. 129s cloudimg-rootfs: clean, 113283/2593280 files, 956731/5217019 blocks 129s [[0;32m OK [0m] Started [0;1;39mShow Plymouth Boot Screen[0m. 129s [[0;32m OK [0m] Started [0;1;39mForward Password R���s to Plymouth Directory Watch[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mLocal Encrypted Volumes[0m. 129s plymouth-start.service 129s [[0;32m OK [0m] Found device [0;1;39m/dev/ttyAMA0[0m. 129s [[0;32m OK [0m] Listening on [0;1;39mLoad/Save RF ���itch Status /dev/rfkill Watch[0m. 129s Starting [0;1;39mLoad Kernel Module chromeos_pstore[0m... 129s [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module chromeos_pstore[0m. 129s [[0;32m OK [0m] Found device [0;1;39m/dev/disk/by-label/UEFI[0m. 129s systemd-udev-settle.service 129s [[0;32m OK [0m] Finished [0;1;39mudev Wait for Complete Device Initialization[0m. 129s Starting [0;1;39mDevice-Mapper Multipath Device Controller[0m... 129s [[0;32m OK [0m] Started [0;1;39mDevice-Mapper Multipath Device Controller[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mLocal File Systems (Pre)[0m. 129s multipathd.service 129s Starting [0;1;39mFile System Check on /dev/disk/by-label/UEFI[0m... 129s [[0;32m OK [0m] Started [0;1;39mFile System Check Daemon to report status[0m. 129s systemd-fsckd.service 129s [[0;32m OK [0m] Finished [0;1;39mFile System Check on /dev/disk/by-label/UEFI[0m. 129s systemd-fsck@dev-disk-by\x2dlabel-UEFI.service 129s Mounting [0;1;39m/boot/efi[0m... 129s [[0;32m OK [0m] Mounted [0;1;39m/boot/efi[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mLocal File Systems[0m. 129s boot-efi.mount 129s Starting [0;1;39mLoad AppArmor profiles[0m... 129s Starting [0;1;39mSet console font and keymap[0m... 129s Starting [0;1;39mCloud-init: Local Stage (pre-network)[0m... 129s Starting [0;1;39mTell Plymouth To Write Out Runtime Data[0m... 129s Starting [0;1;39mCreate Volatile Files and Directories[0m... 129s [[0;32m OK [0m] Finished [0;1;39mSet console font and keymap[0m. 129s console-setup.service 129s [[0;32m OK [0m] Finished [0;1;39mTell Plymouth To Write Out Runtime Data[0m. 129s [[0;32m OK [0m] Finished [0;1;39mCreate Volatile Files and Directories[0m. 129s Starting [0;1;39mNetwork Time Synchronization[0m... 129s Starting [0;1;39mUpdate UTMP about System Boot/Shutdown[0m... 129s [[0;32m OK [0m] Finished [0;1;39mUpdate UTMP about System Boot/Shutdown[0m. 129s systemd-tmpfiles-setup.service 129s systemd-update-utmp.service 129s [[0;32m OK [0m] Started [0;1;39mNetwork Time Synchronization[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mSystem Time Set[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mSystem Time Synchronized[0m. 129s systemd-timesyncd.service 129s [ 2.751273] cloud-init[444]: Cloud-init v. 24.4.1-0ubuntu0~20.04.2 running 'init-local' at Sat, 24 May 2025 10:17:56 +0000. Up 2.65 seconds. 129s [[0;32m OK [0m] Finished [0;1;39mCloud-init: Local Stage (pre-network)[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mNetwork (Pre)[0m. 129s Starting [0;1;39mNetwork Service[0m... 129s cloud-init-local.service 129s systemd-networkd.service 129s [[0;32m OK [0m] Started [0;1;39mNetwork Service[0m. 129s Starting [0;1;39mWait for Network to be Configured[0m... 129s Starting [0;1;39mNetwork Name Resolution[0m... 129s apparmor.service 129s [[0;32m OK [0m] Finished [0;1;39mLoad AppArmor profiles[0m. 129s systemd-resolved.service 129s [[0;32m OK [0m] Started [0;1;39mNetwork Name Resolution[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mNetwork[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mHost and Network Name Lookups[0m. 129s systemd-networkd-wait-online.service 129s [[0;32m OK [0m] Finished [0;1;39mWait for Network to be Configured[0m. 129s Starting [0;1;39mCloud-init: Network Stage[0m... 129s [ 4.381357] cloud-init[455]: Cloud-init v. 24.4.1-0ubuntu0~20.04.2 running 'init' at Sat, 24 May 2025 10:17:58 +0000. Up 4.24 seconds. 129s [ 4.381466] cloud-init[455]: ci-info: ++++++++++++++++++++++++++++++++++++++Net device info+++++++++++++++++++++++++++++++++++++++ 129s [ 4.381492] cloud-init[455]: ci-info: +--------+------+-----------------------------+---------------+--------+-------------------+ 129s [ 4.381517] cloud-init[455]: ci-info: | Device | Up | Address | Mask | Scope | Hw-Address | 129s [ 4.381538] cloud-init[455]: ci-info: +--------+------+-----------------------------+---------------+--------+-------------------+ 129s [ 4.381558] cloud-init[455]: ci-info: | enp1s0 | True | 10.151.35.201 | 255.255.255.0 | global | fa:16:3e:0f:08:13 | 129s [ 4.381584] cloud-init[455]: ci-info: | enp1s0 | True | fe80::f816:3eff:fe0f:813/64 | . | link | fa:16:3e:0f:08:13 | 129s [ 4.381605] cloud-init[455]: ci-info: | lo | True | 127.0.0.1 | 255.0.0.0 | host | . | 129s [ 4.381628] cloud-init[455]: ci-info: | lo | True | ::1/128 | . | host | . | 129s [ 4.381648] cloud-init[455]: ci-info: +--------+------+-----------------------------+---------------+--------+-------------------+ 129s [ 4.381668] cloud-init[455]: ci-info: ++++++++++++++++++++++++++++++++Route IPv4 info++++++++++++++++++++++++++++++++ 129s [ 4.381692] cloud-init[455]: ci-info: +-------+-----------------+-------------+-----------------+-----------+-------+ 129s [ 4.381716] cloud-init[455]: ci-info: | Route | Destination | Gateway | Genmask | Interface | Flags | 129s [ 4.381736] cloud-init[455]: ci-info: +-------+-----------------+-------------+-----------------+-----------+-------+ 129s [ 4.381759] cloud-init[455]: ci-info: | 0 | 0.0.0.0 | 10.151.35.1 | 0.0.0.0 | enp1s0 | UG | 129s [ 4.381779] cloud-init[455]: ci-info: | 1 | 10.151.35.0 | 0.0.0.0 | 255.255.255.0 | enp1s0 | U | 129s [ 4.381798] cloud-init[455]: ci-info: | 2 | 169.254.169.254 | 10.151.35.2 | 255.255.255.255 | enp1s0 | UGH | 129s [ 4.381819] cloud-init[455]: ci-info: +-------+-----------------+-------------+-----------------+-----------+-------+ 129s [ 4.381838] cloud-init[455]: ci-info: +++++++++++++++++++Route IPv6 info+++++++++++++++++++ 129s [ 4.381862] cloud-init[455]: ci-info: +-------+-------------+---------+-----------+-------+ 129s [ 4.381882] cloud-init[455]: ci-info: | Route | Destination | Gateway | Interface | Flags | 129s [ 4.381901] cloud-init[455]: ci-info: +-------+-------------+---------+-----------+-------+ 129s [ 4.381921] cloud-init[455]: ci-info: | 1 | fe80::/64 | :: | enp1s0 | U | 129s [ 4.381955] cloud-init[455]: ci-info: | 3 | local | :: | enp1s0 | U | 129s [ 4.381977] cloud-init[455]: ci-info: | 4 | multicast | :: | enp1s0 | U | 129s [ 4.381997] cloud-init[455]: ci-info: +-------+-------------+---------+-----------+-------+ 129s [ 4.382074] cloud-init[455]: 2025-05-24 10:17:58,594 - schema.py[WARNING]: cloud-config failed schema validation! You may run 'sudo cloud-init schema --system' to check the details. 129s [[0;32m OK [0m] Finished [0;1;39mCloud-init: Network Stage[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mCloud-config availability[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mNetwork is Online[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mSystem Initialization[0m. 129s cloud-init.service 129s [[0;32m OK [0m] Started [0;1;39mDaily apt download activities[0m. 129s [[0;32m OK [0m] Started [0;1;39mDaily apt upgrade and clean activities[0m. 129s [[0;32m OK [0m] Started [0;1;39mPeriodic ext4 Onli���ata Check for All Filesystems[0m. 129s [[0;32m OK [0m] Started [0;1;39mDiscard unused blocks once a week[0m. 129s [[0;32m OK [0m] Started [0;1;39mRefresh fwupd metadata regularly[0m. 129s [[0;32m OK [0m] Started [0;1;39mDaily rotation of log files[0m. 129s [[0;32m OK [0m] Started [0;1;39mDaily man-db regeneration[0m. 129s [[0;32m OK [0m] Started [0;1;39mMessage of the Day[0m. 129s [[0;32m OK [0m] Started [0;1;39mDaily Cleanup of Temporary Directories[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mPaths[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mTimers[0m. 129s [[0;32m OK [0m] Listening on [0;1;39mcloud-init hotplug hook socket[0m. 129s [[0;32m OK [0m] Listening on [0;1;39mD-Bus System Message Bus Socket[0m. 129s [[0;32m OK [0m] Listening on [0;1;39mUUID daemon activation socket[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mSockets[0m. 129s [[0;32m OK [0m] Reached target [0;1;39mBasic System[0m. 129s Starting [0;1;39mLSB: automatic crash report generation[0m... 129s Starting [0;1;39mDeferred execution scheduler[0m... 129s [[0;32m OK [0m] Started [0;1;39mautopkgtest root shell on ttyS1[0m. 129s autopkgtest@ttyS1.service 129s Starting [0;1;39mCloud-init: Config Stage[0m... 129s [[0;32m OK [0m] Started [0;1;39mRegular background program processing daemon[0m. 129s cron.service 129s [[0;32m OK [0m] Started [0;1;39mD-Bus System Message Bus[0m. 129s [[0;32m OK [0m] Started [0;1;39mSave initial kernel messages after boot[0m. 129s Starting [0;1;39mRemove Stale Onli���t4 Metadata Check Snapshots[0m... 129s dbus.service 129s dmesg.service 129s Starting [0;1;39mRecord successful boot for GRUB[0m... 129s [[0;32m OK [0m] Started [0;1;39mirqbalance daemon[0m. 129s irqbalance.service 129s Starting [0;1;39mDispatcher daemon for systemd-networkd[0m... 129s Starting [0;1;39mAuthorization Manager[0m... 129s Starting [0;1;39mPollinate to seed���udo random number generator[0m... 129s [[0;32m OK [0m] Started [0;1;39mAdd entropy to /de���random 's pool a hardware RNG[0m. 129s Starting [0;1;39mSystem Logging Service[0m... 129s rng-tools.service 129s Starting [0;1;39mLogin Service[0m... 129s Starting [0;1;39mPermit User Sessions[0m... 129s Starting [0;1;39mDisk Manager[0m... 129s [[0;32m OK [0m] Started [0;1;39mDeferred execution scheduler[0m. 129s atd.service 129s [[0;32m OK [0m] Finished [0;1;39mRemove Stale Onli���ext4 Metadata Check Snapshots[0m. 129s [[0;32m OK [0m] Finished [0;1;39mPermit User Sessions[0m. 129s systemd-user-sessions.service 129s [[0;32m OK [0m] Started [0;1;39mSystem Logging Service[0m. 129s rsyslog.service 129s [[0;32m OK [0m] Finished [0;1;39mRecord successful boot for GRUB[0m. 129s [[0;32m OK [0m] Started [0;1;39mAuthorization Manager[0m. 129s polkit.service 129s Starting [0;1;39mModem Manager[0m... 129s Starting [0;1;39mGRUB failed boot detection[0m... 129s Starting [0;1;39mHold until boot process finishes up[0m... 129s Starting [0;1;39mTerminate Plymouth Boot Screen[0m... 129s [[0;32m OK [0m] Started [0;1;39mLSB: automatic crash report generation[0m. 129s apport.service 129s [[0;32m OK [0m] Started [0;1;39mLogin Service[0m. 129s systemd-logind.service 129s [[0;32m OK [0m] Finished [0;1;39mGRUB failed boot detection[0m. 129s [ 5.116226] cloud-init[583]: Cloud-init v. 24.4.1-0ubuntu0~20.04.2 running 'modules:config' at Sat, 24 May 2025 10:17:59 +0000. Up 5.03 seconds. 129s 129s --------------------------------------------------- 129s ------- nova show 01e5357d-cf30-43e1-a8aa-cf1db1eb659e (adt-focal-arm64-acpi-call-20250524-100020-juju-7f2275-prod-proposed-migration-environment-15-7ea16a70-92ed-421b-b021-d368a75ec3a6) ------ 129s +--------------------------------------------+--------------------------------------------------------------------------------------------------------------------------------------------------------+ 129s | Property | Value | 129s +--------------------------------------------+--------------------------------------------------------------------------------------------------------------------------------------------------------+ 129s | OS-DCF:diskConfig | MANUAL | 129s | OS-EXT-AZ:availability_zone | AZ2 | 129s | OS-EXT-SRV-ATTR:host | ps7-ra4-arm64-n1.ps7.canonical.com | 129s | OS-EXT-SRV-ATTR:hostname | adt-focal-arm64-acpi-call-20250524-100020-juju-7f2275-prod-prop | 129s | OS-EXT-SRV-ATTR:hypervisor_hostname | ps7-ra4-arm64-n1.ps7.canonical.com | 129s | OS-EXT-SRV-ATTR:instance_name | instance-00060194 | 129s | OS-EXT-SRV-ATTR:kernel_id | | 129s | OS-EXT-SRV-ATTR:launch_index | 0 | 129s | OS-EXT-SRV-ATTR:ramdisk_id | | 129s | OS-EXT-SRV-ATTR:reservation_id | r-q57i0l0o | 129s | OS-EXT-SRV-ATTR:root_device_name | /dev/vda | 129s | OS-EXT-STS:power_state | 1 | 129s | OS-EXT-STS:task_state | - | 129s | OS-EXT-STS:vm_state | active | 129s | OS-SRV-USG:launched_at | 2025-05-24T10:16:26.000000 | 129s | OS-SRV-USG:terminated_at | - | 129s | accessIPv4 | | 129s | accessIPv6 | | 129s | config_drive | | 129s | created | 2025-05-24T10:16:22Z | 129s | description | - | 129s | flavor:disk | 20 | 129s | flavor:ephemeral | 0 | 129s | flavor:extra_specs | {"aggregate_instance_extra_specs:commit": "arm64", "hw:cpu_policy": "shared", "hw:mem_page_size": "large", "hw:pci_numa_affinity_policy": "preferred"} | 129s | flavor:original_name | autopkgtest-cpu2-ram4-disk20-arm64 | 129s | flavor:ram | 4096 | 129s | flavor:swap | 0 | 129s | flavor:vcpus | 2 | 129s | hostId | 7aa16efb1024cdcb74bbd0a97e766c13c19acad3f4ed94776bde7536 | 129s | id | 01e5357d-cf30-43e1-a8aa-cf1db1eb659e | 129s | image | adt/ubuntu-focal-arm64-server-20250524.img (ca51a752-b375-4af4-a744-29856914844b) | 129s | key_name | testbed-juju-7f2275-prod-proposed-migration-environment-15 | 129s | locked | False | 129s | locked_reason | - | 129s | metadata | {} | 129s | name | adt-focal-arm64-acpi-call-20250524-100020-juju-7f2275-prod-proposed-migration-environment-15-7ea16a70-92ed-421b-b021-d368a75ec3a6 | 129s | net_prod-autopkgtest-workers-arm64 network | 10.151.35.201 | 129s | os-extended-volumes:volumes_attached | [] | 129s | progress | 0 | 129s | security_groups | autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@sto01-arm64-1.secgroup | 129s | server_groups | [] | 129s | status | ACTIVE | 129s | tags | [] | 129s | tenant_id | e27006f5eb9946719a589a78f7f099f8 | 129s | trusted_image_certificates | - | 129s | updated | 2025-05-24T10:16:26Z | 129s | user_id | 5676cac36e4942629c54e24741ff7157 | 129s +--------------------------------------------+--------------------------------------------------------------------------------------------------------------------------------------------------------+ 129s --------------------------------------------------- 129s 135s nova [W] Using flock in prodstack7-arm64 135s Creating nova instance adt-focal-arm64-acpi-call-20250524-100020-juju-7f2275-prod-proposed-migration-environment-15-7ea16a70-92ed-421b-b021-d368a75ec3a6 from image adt/ubuntu-focal-arm64-server-20250524.img (UUID ca51a752-b375-4af4-a744-29856914844b)... 135s nova [W] Timed out waiting for 01e5357d-cf30-43e1-a8aa-cf1db1eb659e to get deleted. 135s autopkgtest [10:18:10]: ERROR: testbed failure: testbed auxverb failed with exit code 255