0s autopkgtest [19:19:41]: starting date and time: 2025-05-22 19:19:41+0000 0s autopkgtest [19:19:41]: git checkout: 9986aa8c Merge branch 'skia/fix_network_interface' into 'ubuntu/production' 0s autopkgtest [19:19:41]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.cnfk2owx/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:linux-meta,src:linux-signed,src:linux --apt-upgrade glibc --timeout-short=300 --timeout-copy=20000 --timeout-test=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=linux-meta/5.4.0.218.210 linux-signed/5.4.0-218.238 linux/5.4.0-218.238' --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-cpu4-ram16-disk100-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@sto01-s390x-1.secgroup --name adt-focal-s390x-glibc-20250522-190457-juju-7f2275-prod-proposed-migration-environment-15-e87580a5-85a7-47f7-844c-96d4736d2bd9 --image adt/ubuntu-focal-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-15 --net-id=net_prod-autopkgtest-workers-s390x -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 64s autopkgtest [19:20:45]: testbed dpkg architecture: s390x 64s autopkgtest [19:20:45]: testbed apt version: 2.0.10 65s autopkgtest [19:20:46]: @@@@@@@@@@@@@@@@@@@@ test bed setup 65s autopkgtest [19:20:46]: testbed release detected to be: None 65s autopkgtest [19:20:46]: updating testbed package index (apt update) 66s Hit:1 http://ftpmaster.internal/ubuntu focal InRelease 66s Hit:2 http://ftpmaster.internal/ubuntu focal-updates InRelease 66s Hit:3 http://ftpmaster.internal/ubuntu focal-security InRelease 66s Get:4 http://ftpmaster.internal/ubuntu focal-proposed InRelease [277 kB] 66s Get:5 http://ftpmaster.internal/ubuntu focal-proposed/main Sources [31.2 kB] 66s Get:6 http://ftpmaster.internal/ubuntu focal-proposed/restricted Sources [7976 B] 66s Get:7 http://ftpmaster.internal/ubuntu focal-proposed/universe Sources [6856 B] 66s Get:8 http://ftpmaster.internal/ubuntu focal-proposed/main s390x Packages [145 kB] 66s Get:9 http://ftpmaster.internal/ubuntu focal-proposed/main s390x c-n-f Metadata [1676 B] 66s Get:10 http://ftpmaster.internal/ubuntu focal-proposed/restricted s390x Packages [1524 B] 66s Get:11 http://ftpmaster.internal/ubuntu focal-proposed/restricted s390x c-n-f Metadata [116 B] 66s Get:12 http://ftpmaster.internal/ubuntu focal-proposed/universe s390x Packages [33.1 kB] 66s Get:13 http://ftpmaster.internal/ubuntu focal-proposed/universe s390x c-n-f Metadata [1776 B] 67s Get:14 http://ftpmaster.internal/ubuntu focal-proposed/multiverse s390x Packages [760 B] 67s Get:15 http://ftpmaster.internal/ubuntu focal-proposed/multiverse s390x c-n-f Metadata [116 B] 68s Fetched 507 kB in 1s (688 kB/s) 68s Reading package lists... 69s Reading package lists... 69s Building dependency tree... 69s Reading state information... 69s The following additional packages will be installed: 69s linux-headers-5.4.0-218 linux-headers-5.4.0-218-generic 69s linux-headers-generic linux-headers-virtual linux-image-5.4.0-218-generic 69s linux-image-generic linux-image-virtual linux-modules-5.4.0-218-generic 69s linux-modules-extra-5.4.0-218-generic linux-virtual 69s Suggested packages: 69s fdutils linux-doc | linux-source-5.4.0 linux-tools 69s The following NEW packages will be installed: 69s linux-headers-5.4.0-218 linux-headers-5.4.0-218-generic 69s linux-image-5.4.0-218-generic linux-modules-5.4.0-218-generic 69s linux-modules-extra-5.4.0-218-generic 69s The following packages will be upgraded: 69s linux-generic linux-headers-generic linux-headers-virtual 69s linux-image-generic linux-image-virtual linux-virtual 69s 6 upgraded, 5 newly installed, 0 to remove and 1 not upgraded. 69s Need to get 34.8 MB of archives. 69s After this operation, 163 MB of additional disk space will be used. 69s Get:1 http://ftpmaster.internal/ubuntu focal-proposed/main s390x linux-modules-5.4.0-218-generic s390x 5.4.0-218.238 [9463 kB] 70s Get:2 http://ftpmaster.internal/ubuntu focal-proposed/main s390x linux-image-5.4.0-218-generic s390x 5.4.0-218.238 [7632 kB] 70s Get:3 http://ftpmaster.internal/ubuntu focal-proposed/main s390x linux-modules-extra-5.4.0-218-generic s390x 5.4.0-218.238 [6137 kB] 70s Get:4 http://ftpmaster.internal/ubuntu focal-proposed/main s390x linux-generic s390x 5.4.0.218.210 [1900 B] 70s Get:5 http://ftpmaster.internal/ubuntu focal-proposed/main s390x linux-image-generic s390x 5.4.0.218.210 [2440 B] 70s Get:6 http://ftpmaster.internal/ubuntu focal-proposed/main s390x linux-virtual s390x 5.4.0.218.210 [1876 B] 70s Get:7 http://ftpmaster.internal/ubuntu focal-proposed/main s390x linux-image-virtual s390x 5.4.0.218.210 [2448 B] 70s Get:8 http://ftpmaster.internal/ubuntu focal-proposed/main s390x linux-headers-virtual s390x 5.4.0.218.210 [1840 B] 70s Get:9 http://ftpmaster.internal/ubuntu focal-proposed/main s390x linux-headers-5.4.0-218 all 5.4.0-218.238 [11.0 MB] 70s Get:10 http://ftpmaster.internal/ubuntu focal-proposed/main s390x linux-headers-5.4.0-218-generic s390x 5.4.0-218.238 [565 kB] 70s Get:11 http://ftpmaster.internal/ubuntu focal-proposed/main s390x linux-headers-generic s390x 5.4.0.218.210 [2344 B] 70s dpkg-preconfigure: unable to re-open stdin: No such file or directory 70s Fetched 34.8 MB in 1s (41.0 MB/s) 70s Selecting previously unselected package linux-modules-5.4.0-218-generic. 70s (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 ... 48791 files and directories currently installed.) 70s Preparing to unpack .../00-linux-modules-5.4.0-218-generic_5.4.0-218.238_s390x.deb ... 70s Unpacking linux-modules-5.4.0-218-generic (5.4.0-218.238) ... 71s Selecting previously unselected package linux-image-5.4.0-218-generic. 71s Preparing to unpack .../01-linux-image-5.4.0-218-generic_5.4.0-218.238_s390x.deb ... 71s Unpacking linux-image-5.4.0-218-generic (5.4.0-218.238) ... 72s Selecting previously unselected package linux-modules-extra-5.4.0-218-generic. 72s Preparing to unpack .../02-linux-modules-extra-5.4.0-218-generic_5.4.0-218.238_s390x.deb ... 72s Unpacking linux-modules-extra-5.4.0-218-generic (5.4.0-218.238) ... 72s Preparing to unpack .../03-linux-generic_5.4.0.218.210_s390x.deb ... 72s Unpacking linux-generic (5.4.0.218.210) over (5.4.0.216.208) ... 72s Preparing to unpack .../04-linux-image-generic_5.4.0.218.210_s390x.deb ... 72s Unpacking linux-image-generic (5.4.0.218.210) over (5.4.0.216.208) ... 72s Preparing to unpack .../05-linux-virtual_5.4.0.218.210_s390x.deb ... 72s Unpacking linux-virtual (5.4.0.218.210) over (5.4.0.216.208) ... 73s Preparing to unpack .../06-linux-image-virtual_5.4.0.218.210_s390x.deb ... 73s Unpacking linux-image-virtual (5.4.0.218.210) over (5.4.0.216.208) ... 73s Preparing to unpack .../07-linux-headers-virtual_5.4.0.218.210_s390x.deb ... 73s Unpacking linux-headers-virtual (5.4.0.218.210) over (5.4.0.216.208) ... 73s Selecting previously unselected package linux-headers-5.4.0-218. 73s Preparing to unpack .../08-linux-headers-5.4.0-218_5.4.0-218.238_all.deb ... 73s Unpacking linux-headers-5.4.0-218 (5.4.0-218.238) ... 74s Selecting previously unselected package linux-headers-5.4.0-218-generic. 74s Preparing to unpack .../09-linux-headers-5.4.0-218-generic_5.4.0-218.238_s390x.deb ... 74s Unpacking linux-headers-5.4.0-218-generic (5.4.0-218.238) ... 74s Preparing to unpack .../10-linux-headers-generic_5.4.0.218.210_s390x.deb ... 74s Unpacking linux-headers-generic (5.4.0.218.210) over (5.4.0.216.208) ... 74s Setting up linux-headers-5.4.0-218 (5.4.0-218.238) ... 74s Setting up linux-modules-5.4.0-218-generic (5.4.0-218.238) ... 74s Setting up linux-headers-5.4.0-218-generic (5.4.0-218.238) ... 74s Setting up linux-image-5.4.0-218-generic (5.4.0-218.238) ... 74s I: /boot/vmlinuz is now a symlink to vmlinuz-5.4.0-218-generic 74s I: /boot/initrd.img is now a symlink to initrd.img-5.4.0-218-generic 74s Setting up linux-image-virtual (5.4.0.218.210) ... 74s Setting up linux-headers-generic (5.4.0.218.210) ... 74s Setting up linux-modules-extra-5.4.0-218-generic (5.4.0-218.238) ... 75s Setting up linux-image-generic (5.4.0.218.210) ... 75s Setting up linux-headers-virtual (5.4.0.218.210) ... 75s Setting up linux-generic (5.4.0.218.210) ... 75s Setting up linux-virtual (5.4.0.218.210) ... 75s Processing triggers for linux-image-5.4.0-218-generic (5.4.0-218.238) ... 75s /etc/kernel/postinst.d/initramfs-tools: 75s update-initramfs: Generating /boot/initrd.img-5.4.0-218-generic 78s Using config file '/etc/zipl.conf' 78s Building bootmap in '/boot' 78s Adding IPL section 'ubuntu' (default) 78s Preparing boot device: vda (0000). 78s Done. 78s /etc/kernel/postinst.d/zz-zipl: 78s Using config file '/etc/zipl.conf' 78s Building bootmap in '/boot' 78s Adding IPL section 'ubuntu' (default) 78s Preparing boot device: vda (0000). 78s Done. 79s Reading package lists... 79s Building dependency tree... 79s Reading state information... 79s E: Unable to locate package ^kernel-testing--linux--modules-extra--preferred$ 79s E: Couldn't find any package by regex '^kernel-testing--linux--modules-extra--preferred$' 79s Reading package lists... 79s Building dependency tree... 79s Reading state information... 79s E: Unable to locate package ^linux-modules-extra$ 79s E: Couldn't find any package by regex '^linux-modules-extra$' 79s autopkgtest [19:21:00]: upgrading testbed (apt dist-upgrade and autopurge) 79s Reading package lists... 79s Building dependency tree... 79s Reading state information... 79s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 79s Starting 2 pkgProblemResolver with broken count: 0 79s Done 79s 79s The following packages will be upgraded: 79s libsqlite3-0 79s 1 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 79s Need to get 509 kB of archives. 79s After this operation, 0 B of additional disk space will be used. 79s Get:1 http://ftpmaster.internal/ubuntu focal-security/main s390x libsqlite3-0 s390x 3.31.1-4ubuntu0.7 [509 kB] 80s Fetched 509 kB in 0s (31.7 MB/s) 80s (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 ... 71593 files and directories currently installed.) 80s Preparing to unpack .../libsqlite3-0_3.31.1-4ubuntu0.7_s390x.deb ... 80s Unpacking libsqlite3-0:s390x (3.31.1-4ubuntu0.7) over (3.31.1-4ubuntu0.6) ... 80s Setting up libsqlite3-0:s390x (3.31.1-4ubuntu0.7) ... 80s Processing triggers for libc-bin (2.31-0ubuntu9.17) ... 80s Reading package lists... 80s Building dependency tree... 80s Reading state information... 80s Starting pkgProblemResolver with broken count: 0 80s Starting 2 pkgProblemResolver with broken count: 0 80s Done 80s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 81s autopkgtest [19:21:02]: rebooting testbed after setup commands that affected boot 84s autopkgtest-virt-ssh [19:21:05]: copydown destination failed, status 255 88s autopkgtest-virt-ssh [19:21:09]: ------- nova console-log 061fd612-1851-4c5b-8c2e-5e9f31b904ac (adt-focal-s390x-glibc-20250522-190457-juju-7f2275-prod-proposed-migration-environment-15-e87580a5-85a7-47f7-844c-96d4736d2bd9) ------ 88s LOADPARM=[ ] 88s Using virtio-blk. 88s Using SCSI scheme. 88s ........ 88s [ 0.091088] Linux version 5.4.0-216-generic (buildd@bos03-s390x-013) (gcc version 9.4.0 (Ubuntu 9.4.0-1ubuntu1~20.04.2)) #236-Ubuntu SMP Fri Apr 11 19:54:56 UTC 2025 (Ubuntu 5.4.0-216.236-generic 5.4.291) 88s [ 0.091091] setup.289988: Linux is running under KVM in 64-bit mode 88s [ 0.092425] setup.b050d0: The maximum memory size is 16384MB 88s [ 0.092447] numa.196305: NUMA mode: plain 88s [ 0.092499] cpu.33a262: 4 configured CPUs, 0 standby CPUs 88s [ 0.092586] Write protected kernel read-only data: 15000k 88s [ 0.092704] Zone ranges: 88s [ 0.092705] DMA [mem 0x0000000000000000-0x000000007fffffff] 88s [ 0.092706] Normal [mem 0x0000000080000000-0x00000003ffffffff] 88s [ 0.092708] Movable zone start for each node 88s [ 0.092709] Early memory node ranges 88s [ 0.092710] node 0: [mem 0x0000000000000000-0x00000003ffffffff] 88s [ 0.092712] Initmem setup node 0 [mem 0x0000000000000000-0x00000003ffffffff] 88s [ 0.385849] percpu: Embedded 34 pages/cpu s98816 r8192 d32256 u139264 88s [ 0.385868] Built 1 zonelists, mobility grouping on. Total pages: 4128768 88s [ 0.385868] Policy zone: Normal 88s [ 0.385870] Kernel command line: root=LABEL=cloudimg-rootfs 88s [ 0.391211] Dentry cache hash table entries: 2097152 (order: 12, 16777216 bytes, linear) 88s [ 0.393889] Inode-cache hash table entries: 1048576 (order: 11, 8388608 bytes, linear) 88s [ 0.393891] mem auto-init: stack:off, heap alloc:on, heap free:off 88s [ 1.621549] Memory: 16451744K/16777216K available (9260K kernel code, 1712K rwdata, 5736K rodata, 3456K init, 952K bss, 325472K reserved, 0K cma-reserved) 88s [ 1.636188] SLUB: HWalign=256, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 88s [ 1.637094] ftrace: allocating 29801 entries in 117 pages 88s [ 1.642205] ftrace: allocated 117 pages with 5 groups 88s [ 1.643975] rcu: Hierarchical RCU implementation. 88s [ 1.643976] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. 88s [ 1.643977] Tasks RCU enabled. 88s [ 1.643978] rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies. 88s [ 1.643979] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 88s [ 1.655302] NR_IRQS: 3, nr_irqs: 3, preallocated irqs: 3 88s [ 1.655362] clocksource: tod: mask: 0xffffffffffffffff max_cycles: 0x3b0a9be803b0a9, max_idle_ns: 1805497147909793 ns 88s [ 1.655869] random: crng init done 88s [ 1.655890] Console: colour dummy device 80x25 88s [ 1.655955] printk: console [ttysclp0] enabled 88s [ 1.656006] pid_max: default: 32768 minimum: 301 88s [ 1.656025] LSM: Security Framework initializing 88s [ 1.656031] Yama: becoming mindful. 88s [ 1.656070] AppArmor: AppArmor initialized 88s [ 1.656294] Mount-cache hash table entries: 32768 (order: 6, 262144 bytes, linear) 88s [ 1.656390] Mountpoint-cache hash table entries: 32768 (order: 6, 262144 bytes, linear) 88s [ 1.656407] *** VALIDATE tmpfs *** 88s [ 1.656550] *** VALIDATE proc *** 88s [ 1.656594] *** VALIDATE cgroup1 *** 88s [ 1.656596] *** VALIDATE cgroup2 *** 88s [ 1.656859] rcu: Hierarchical SRCU implementation. 88s [ 1.657104] smp: Bringing up secondary CPUs ... 88s [ 1.657860] smp: Brought up 1 node, 4 CPUs 88s [ 1.659895] devtmpfs: initialized 88s [ 1.660286] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns 88s [ 1.660383] futex hash table entries: 1024 (order: 6, 262144 bytes, linear) 88s [ 1.660528] NET: Registered protocol family 16 88s [ 1.660550] audit: initializing netlink subsys (disabled) 88s [ 1.660599] audit: type=2000 audit(1747941753.801:1): state=initialized audit_enabled=0 res=1 88s [ 1.660636] Spectre V2 mitigation: etokens 88s [ 1.661602] HugeTLB registered 1.00 MiB page size, pre-allocated 0 pages 88s [ 1.663431] iommu: Default domain type: Translated 88s [ 1.663492] SCSI subsystem initialized 88s [ 1.663699] NetLabel: Initializing 88s [ 1.663700] NetLabel: domain hash size = 128 88s [ 1.663700] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO 88s [ 1.663709] NetLabel: unlabeled traffic allowed by default 88s [ 1.676896] *** VALIDATE bpf *** 88s [ 1.676940] VFS: Disk quotas dquot_6.6.0 88s [ 1.676951] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) 88s [ 1.676964] *** VALIDATE ramfs *** 88s [ 1.676966] *** VALIDATE hugetlbfs *** 88s [ 1.677039] AppArmor: AppArmor Filesystem Enabled 88s [ 1.677619] NET: Registered protocol family 2 88s [ 1.678399] IP idents hash table entries: 262144 (order: 9, 2097152 bytes, vmalloc) 88s [ 1.680139] tcp_listen_portaddr_hash hash table entries: 8192 (order: 5, 131072 bytes, linear) 88s [ 1.680622] TCP established hash table entries: 131072 (order: 8, 1048576 bytes, linear) 88s [ 1.681074] TCP bind hash table entries: 65536 (order: 8, 1048576 bytes, linear) 88s [ 1.681146] TCP: Hash tables configured (established 131072 bind 65536) 88s [ 1.681292] UDP hash table entries: 8192 (order: 6, 262144 bytes, linear) 88s [ 1.681401] UDP-Lite hash table entries: 8192 (order: 6, 262144 bytes, linear) 88s [ 1.681436] NET: Registered protocol family 1 88s [ 1.681442] NET: Registered protocol family 44 88s [ 1.681490] Trying to unpack rootfs image as initramfs... 88s [ 1.725882] Freeing initrd memory: 16252K 88s [ 1.726026] kvm-s390.a3074b: SIE is not available 88s [ 1.726040] hypfs.7f5705: The hardware system does not support hypfs 88s [ 1.726137] Initialise system trusted keyrings 88s [ 1.726143] Key type blacklist registered 88s [ 1.726175] workingset: timestamp_bits=42 max_order=22 bucket_order=0 88s [ 1.726872] zbud: loaded 88s [ 1.727106] squashfs: version 4.0 (2009/01/31) Phillip Lougher 88s [ 1.727189] fuse: init (API version 7.31) 88s [ 1.727198] *** VALIDATE fuse *** 88s [ 1.727199] *** VALIDATE fuse *** 88s [ 1.727243] Platform Keyring initialized 88s [ 1.730625] Key type asymmetric registered 88s [ 1.730626] Asymmetric key parser 'x509' registered 88s [ 1.730629] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) 88s [ 1.730675] io scheduler mq-deadline registered 88s [ 1.730780] hvc_iucv.691dff: The z/VM IUCV HVC device driver cannot be used without z/VM 88s [ 2.090057] loop: module loaded 88s [ 2.090107] tun: Universal TUN/TAP device driver, 1.6 88s [ 2.090146] device-mapper: uevent: version 1.0.3 88s [ 2.090171] device-mapper: ioctl: 4.41.0-ioctl (2019-09-16) initialised: dm-devel@redhat.com 88s [ 2.090241] cio.b5d5f6: Channel measurement facility initialized using format extended (mode autodetected) 88s [ 2.090319] sclp_sd.ef2911: Store Data request failed (eq=2, di=3, response=0x40f0, flags=0x00, status=0, rc=-5) 88s [ 2.090376] drop_monitor: Initializing network drop monitor service 88s [ 2.090478] NET: Registered protocol family 10 88s [ 2.093722] Segment Routing with IPv6 88s [ 2.093737] NET: Registered protocol family 17 88s [ 2.093763] Key type dns_resolver registered 88s [ 2.093803] registered taskstats version 1 88s [ 2.093807] Loading compiled-in X.509 certificates 88s [ 2.094702] Loaded X.509 cert 'Build time autogenerated kernel key: 5fe0e94ce0eae2d03b7d181e41599c69aebc8827' 88s [ 2.095497] Loaded X.509 cert 'Canonical Ltd. Live Patch Signing: 14df34d1a87cf37625abec039ef2bf521249b969' 88s [ 2.096305] Loaded X.509 cert 'Canonical Ltd. Kernel Module Signing: 88f752e560a1e0737e31163a466ad7b70a850c19' 88s [ 2.096306] blacklist: Loading compiled-in revocation X.509 certificates 88s [ 2.096321] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing: 61482aa2830d0ab2ad5af10b7250da9033ddcef0' 88s [ 2.096333] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2017): 242ade75ac4a15e50d50c84b0d45ff3eae707a03' 88s [ 2.096345] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (ESM 2018): 365188c1d374d6b07c3c8f240f8ef722433d6a8b' 88s [ 2.096357] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2019): c0746fd6c5da3ae827864651ad66ae47fe24b3e8' 88s [ 2.096368] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v1): a8d54bbb3825cfb94fa13c9f8a594a195c107b8d' 88s [ 2.096382] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v2): 4cf046892d6fd3c9a5b03f98d845f90851dc6a8c' 88s [ 2.096394] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v3): 100437bb6de6e469b581e61cd66bce3ef4ed53af' 88s [ 2.096406] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (Ubuntu Core 2019): c1d57b8f6b743f23ee41f4f7ee292f06eecadfb9' 88s [ 2.096421] zswap: loaded using pool lzo/zbud 88s [ 2.096507] Key type ._fscrypt registered 88s [ 2.096508] Key type .fscrypt registered 88s [ 2.099565] Key type big_key registered 88s [ 2.100797] Key type encrypted registered 88s [ 2.100800] AppArmor: AppArmor sha1 policy hashing enabled 88s [ 2.100804] ima: No TPM chip found, activating TPM-bypass! 88s [ 2.100806] ima: Allocated hash algorithm: sha1 88s [ 2.100812] ima: No architecture policies found 88s [ 2.100817] evm: Initialising EVM extended attributes: 88s [ 2.100817] evm: security.selinux 88s [ 2.100818] evm: security.SMACK64 88s [ 2.100818] evm: security.SMACK64EXEC 88s [ 2.100818] evm: security.SMACK64TRANSMUTE 88s [ 2.100819] evm: security.SMACK64MMAP 88s [ 2.100819] evm: security.apparmor 88s [ 2.100820] evm: security.ima 88s [ 2.100820] evm: security.capability 88s [ 2.100821] evm: HMAC attrs: 0x1 88s [ 2.101369] Freeing unused kernel memory: 3456K 88s [ 2.140071] Write protected read-only-after-init data: 88k 88s [ 2.140073] Run /init as init process 88s Loading, please wait... 88s Starting version 245.4-4ubuntu3.24 88s [ 2.170747] virtio_blk virtio0: [vda] 209715200 512-byte logical blocks (107 GB/100 GiB) 88s [ 2.171908] virtio_net virtio2 enc1: renamed from eth0 88s [ 2.221008] vda: vda1 88s Begin: Starting firmware auto-configuration ... done. 88s Begin: Loading essential drivers ... done. 88s Begin: Running /scripts/init-premount ... done. 88s Begin: Mounting root file system ... Begin: Running /scripts/local-top ... done. 88s Begin: Running /scripts/local-premount ... [ 2.510073] raid6: vx128x8 gen() 21844 MB/s 88s [ 2.630074] raid6: vx128x8 xor() 12744 MB/s 88s [ 2.630076] raid6: using algorithm vx128x8 gen() 21844 MB/s 88s [ 2.630076] raid6: .... xor() 12744 MB/s, rmw enabled 88s [ 2.630077] raid6: using s390xc recovery algorithm 88s [ 2.634135] xor: automatically using best checksumming function xc 88s [ 2.651716] Btrfs loaded, crc32c=crc32c-vx 88s Scanning for Btrfs filesystems 88s done. 88s Begin: Will now check root file system ... fsck from util-linux 2.34 88s [/usr/sbin/fsck.ext4 (1) -- /dev/vda1] fsck.ext4 -a -C0 /dev/vda1 88s cloudimg-rootfs: clean, 55359/2560000 files, 414685/5242619 blocks 88s done. 88s [ 2.675626] EXT4-fs (vda1): mounted filesystem with ordered data mode. Opts: (null) 88s done. 88s Begin: Running /scripts/local-bottom ... done. 88s Begin: Running /scripts/init-bottom ... done. 88s [ 2.765189] systemd[1]: systemd 245.4-4ubuntu3.24 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=hybrid) 88s [ 2.765294] systemd[1]: Detected virtualization kvm. 88s [ 2.765333] systemd[1]: Detected architecture s390x. 88s 88s Welcome to [1mUbuntu 20.04.6 LTS[0m! 88s 88s [ 2.813083] systemd[1]: Set hostname to . 88s [ 2.846899] systemd[290]: /usr/lib/systemd/system-generators/s390-cpi-vars failed with exit status 1. 88s [ 2.877937] systemd[1]: Configuration file /run/systemd/system/netplan-ovs-cleanup.service is marked world-inaccessible. This has no effect as configuration data is accessible via APIs without restrictions. Proceeding anyway. 88s [ 2.922319] systemd[1]: Created slice system-modprobe.slice. 88s [[0;32m OK [0m] Created slice [0;1;39msystem-modprobe.slice[0m. 88s [ 2.922505] systemd[1]: Created slice system-serial\x2dgetty.slice. 88s [[0;32m OK [0m] Created slice [0;1;39msystem-serial\x2dgetty.slice[0m. 88s [ 2.922650] systemd[1]: Created slice User and Session Slice. 88s [[0;32m OK [0m] Created slice [0;1;39mUser and Session Slice[0m. 88s [ 2.922720] systemd[1]: Started Forward Password Requests to Wall Directory Watch. 88s [[0;32m OK [0m] Started [0;1;39mForward Password R���uests to Wall Directory Watch[0m. 88s [ 2.922916] systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. 88s [[0;32m OK [0m] Set up automount [0;1;39mArbitrary���s File System Automount Point[0m. 88s [ 2.923046] systemd[1]: Reached target Remote File Systems. 88s [[0;32m OK [0m] Reached target [0;1;39mRemote File Systems[0m. 88s [ 2.923111] systemd[1]: Reached target Slices. 88s [[0;32m OK [0m] Reached target [0;1;39mSlices[0m. 88s [ 2.923163] systemd[1]: Reached target Swap. 88s [[0;32m OK [0m] Reached target [0;1;39mSwap[0m. 88s [ 2.923259] systemd[1]: Listening on multipathd control socket. 88s [[0;32m OK [0m] Listening on [0;1;39mmultipathd control socket[0m. 88s [ 2.923341] systemd[1]: Listening on Syslog Socket. 88s [[0;32m OK [0m] Listening on [0;1;39mSyslog Socket[0m. 88s [ 2.923422] systemd[1]: Listening on fsck to fsckd communication Socket. 88s [[0;32m OK [0m] Listening on [0;1;39mfsck to fsckd communication Socket[0m. 88s [ 2.923489] systemd[1]: Listening on initctl Compatibility Named Pipe. 88s [[0;32m OK [0m] Listening on [0;1;39minitctl Compatibility Named Pipe[0m. 88s [ 2.923609] systemd[1]: Listening on Journal Audit Socket. 88s [[0;32m OK [0m] Listening on [0;1;39mJournal Audit Socket[0m. 88s [ 2.923690] systemd[1]: Listening on Journal Socket (/dev/log). 88s [[0;32m OK [0m] Listening on [0;1;39mJournal Socket (/dev/log)[0m. 88s [ 2.923773] systemd[1]: Listening on Journal Socket. 88s [[0;32m OK [0m] Listening on [0;1;39mJournal Socket[0m. 88s [ 2.923875] systemd[1]: Listening on Network Service Netlink Socket. 88s [[0;32m OK [0m] Listening on [0;1;39mNetwork Service Netlink Socket[0m. 88s [ 2.923979] systemd[1]: Listening on udev Control Socket. 88s [[0;32m OK [0m] Listening on [0;1;39mudev Control Socket[0m. 88s [ 2.924048] systemd[1]: Listening on udev Kernel Socket. 88s [[0;32m OK [0m] Listening on [0;1;39mudev Kernel Socket[0m. 88s [ 2.924550] systemd[1]: Mounting Huge Pages File System... 88s Mounting [0;1;39mHuge Pages File System[0m... 88s [ 2.925170] systemd[1]: Mounting POSIX Message Queue File System... 88s Mounting [0;1;39mPOSIX Message Queue File System[0m... 88s [ 2.925906] systemd[1]: Mounting Kernel Debug File System... 88s Mounting [0;1;39mKernel Debug File System[0m... 88s [ 2.926539] systemd[1]: Mounting Kernel Trace File System... 88s Mounting [0;1;39mKernel Trace File System[0m... 88s [ 2.928002] systemd[1]: Starting Journal Service... 88s Starting [0;1;39mJournal Service[0m... 88s [ 2.928624] systemd[1]: Starting Set the console keyboard layout... 88s Starting [0;1;39mSet the console keyboard layout[0m... 88s [ 2.929345] systemd[1]: Starting Create list of static device nodes for the current kernel... 88s Starting [0;1;39mCreate list of st���odes for the current kernel[0m... 88s [ 2.930050] systemd[1]: Starting Load Kernel Module chromeos_pstore... 88s Starting [0;1;39mLoad Kernel Module chromeos_pstore[0m... 88s [ 2.930713] systemd[1]: Starting Load Kernel Module drm... 88s Starting [0;1;39mLoad Kernel Module drm[0m... 88s [ 2.931397] systemd[1]: Starting Load Kernel Module efi_pstore... 88s Starting [0;1;39mLoad Kernel Module efi_pstore[0m... 88s [ 2.931972] systemd[1]: Starting Load Kernel Module pstore_blk... 88s Starting [0;1;39mLoad Kernel Module pstore_blk[0m... 88s [ 2.932652] systemd[1]: Starting Load Kernel Module pstore_zone... 88s Starting [0;1;39mLoad Kernel Module pstore_zone[0m... 88s [ 2.933321] systemd[1]: Starting Load Kernel Module ramoops... 88s Starting [0;1;39mLoad Kernel Module ramoops[0m... 88s [ 2.933416] systemd[1]: Condition check resulted in OpenVSwitch configuration for cleanup being skipped. 88s [ 2.935402] systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. 88s [ 2.935419] systemd[1]: Condition check resulted in File System Check on Root Device being skipped. 88s [ 2.936056] systemd[1]: Starting Load Kernel Modules... 88s Starting [0;1;39mLoad Kernel Modules[0m... 88s [ 2.936637] systemd[1]: Starting Remount Root and Kernel File Systems... 88s Starting [0;1;39mRemount Root and Kernel File Systems[0m... 88s [ 2.937170] systemd[1]: Starting udev Coldplug all Devices... 88s Starting [0;1;39mudev Coldplug all Devices[0m... 88s [ 2.937752] systemd[1]: Starting Uncomplicated firewall... 88s Starting [0;1;39mUncomplicated firewall[0m... 88s [ 2.938908] systemd[1]: Mounted Huge Pages File System. 88s [[0;32m OK [0m] Mounted [0;1;39mHuge Pages File System[0m. 88s [ 2.939017] systemd[1]: Mounted POSIX Message Queue File System. 88s [[0;32m OK [0m] Mounted [0;1;39mPOSIX Message Queue File System[0m. 88s [ 2.939101] systemd[1]: Mounted Kernel Debug File System. 88s [[0;32m OK [0m] Mounted [0;1;39mKernel Debug File System[0m. 88s [ 2.939201] systemd[1]: Mounted Kernel Trace File System. 88s [[0;32m OK [0m] Mounted [0;1;39mKernel Trace File System[0m. 88s [ 2.939529] systemd[1]: Finished Create list of static device nodes for the current kernel. 88s [[0;32m OK [0m] Finished [0;1;39mCreate list of st��� nodes for the current kernel[0m. 88s [ 2.939772] systemd[1]: modprobe@chromeos_pstore.service: Succeeded. 88s [ 2.940100] systemd[1]: Finished Load Kernel Module chromeos_pstore. 88s [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module chromeos_pstore[0m. 88s [ 2.940348] systemd[1]: modprobe@efi_pstore.service: Succeeded. 88s [ 2.940658] systemd[1]: Finished Load Kernel Module efi_pstore. 88s [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module efi_pstore[0m. 88s [ 2.940870] systemd[1]: modprobe@pstore_blk.service: Succeeded. 88s [ 2.941307] systemd[1]: Finished Load Kernel Module pstore_blk. 88s [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module pstore_blk[0m. 88s [ 2.941527] systemd[1]: modprobe@pstore_zone.service: Succeeded. 88s [ 2.941978] systemd[1]: Finished Load Kernel Module pstore_zone. 88s [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module pstore_zone[0m. 88s [ 2.942194] systemd[1]: modprobe@ramoops.service: Succeeded. 88s [ 2.942402] systemd[1]: Finished Load Kernel Module ramoops. 88s [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module ramoops[0m. 88s [ 2.942711] systemd[1]: Finished Load Kernel Modules. 88s [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Modules[0m. 88s [ 2.943429] systemd[1]: Mounting FUSE Control File System... 88s Mounting [0;1;39mFUSE Control File System[0m... 88s [ 2.944248] systemd[1]: Mounting Kernel Configuration File System... 88s Mounting [0;1;39mKernel Configuration File System[0m... 88s [ 2.945495] systemd[1]: Starting Apply Kernel Variables... 88s Starting [0;1;39mApply Kernel Variables[0m... 88s [ 2.946366] systemd[1]: Started Journal Service. 88s [[0;32m OK [0m] Started [0;1;39mJournal Service[0m. 88s [[0;32m OK [0m] Finished [0;1;39mUncomplicated firewall[0m. 88s [[0;32m OK [0m] Mounted [0;1;39mKernel Configuration File System[0m. 88s [ 2.951417] EXT4-fs (vda1): re-mounted. Opts: (null) 88s [[0;32m OK [0m] Finished [0;1;39mRemount Root and Kernel File Systems[0m. 88s Starting [0;1;39mFlush Journal to Persistent Storage[0m... 88s Starting [0;1;39mLoad/Save Random Seed[0m... 88s Starting [0;1;39mCreate System Users[0m... 88s [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module drm[0m. 88s [[0;32m OK [0m] Finished [0;1;39mudev Coldplug all Devices[0m. 88s [ 2.960385] systemd-journald[333]: Received client request to flush runtime journal. 88s [[0;32m OK [0m] Mounted [0;1;39mFUSE Control File System[0m. 88s Starting [0;1;39mudev Wait for Complete Device Initialization[0m... 88s [[0;32m OK [0m] Finished [0;1;39mCreate System Users[0m. 88s Starting [0;1;39mCreate Static Device Nodes in /dev[0m... 88s [[0;32m OK [0m] Finished [0;1;39mApply Kernel Variables[0m. 88s [[0;32m OK [0m] Finished [0;1;39mCreate Static Device Nodes in /dev[0m. 88s Starting [0;1;39mudev Kernel Device Manager[0m... 88s [[0;32m OK [0m] Finished [0;1;39mFlush Journal to Persistent Storage[0m. 88s [[0;32m OK [0m] Finished [0;1;39mLoad/Save Random Seed[0m. 88s [[0;32m OK [0m] Finished [0;1;39mSet the console keyboard layout[0m. 88s [[0;32m OK [0m] Started [0;1;39mudev Kernel Device Manager[0m. 88s [[0;32m OK [0m] Started [0;1;39mDispatch Password ���ts to Console Directory Watch[0m. 88s [[0;32m OK [0m] Reached target [0;1;39mLocal Encrypted Volumes[0m. 88s Starting [0;1;39mLoad Kernel Module chromeos_pstore[0m... 88s Starting [0;1;39mLoad Kernel Module efi_pstore[0m... 88s Starting [0;1;39mLoad Kernel Module pstore_blk[0m... 88s Starting [0;1;39mLoad Kernel Module pstore_zone[0m... 88s Starting [0;1;39mLoad Kernel Module ramoops[0m... 88s [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module efi_pstore[0m. 88s [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module pstore_blk[0m. 88s [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module pstore_zone[0m. 88s [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module ramoops[0m. 88s [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module chromeos_pstore[0m. 88s [[0;32m OK [0m] Found device [0;1;39m/dev/ttysclp0[0m. 88s [[0;32m OK [0m] Finished [0;1;39mudev Wait for Complete Device Initialization[0m. 88s Starting [0;1;39mDevice-Mapper Multipath Device Controller[0m... 88s [[0;32m OK [0m] Started [0;1;39mDevice-Mapper Multipath Device Controller[0m. 88s [[0;32m OK [0m] Reached target [0;1;39mLocal File Systems (Pre)[0m. 88s [[0;32m OK [0m] Reached target [0;1;39mLocal File Systems[0m. 88s Starting [0;1;39mLoad AppArmor profiles[0m... 88s Starting [0;1;39mSet console font and keymap[0m... 88s Starting [0;1;39mApply Control Program Identification (CPI)[0m... 88s Starting [0;1;39mCloud-init: Local Stage (pre-network)[0m... 88s Starting [0;1;39mTell Plymouth To Write Out Runtime Data[0m... 88s Starting [0;1;39mCreate Volatile Files and Directories[0m... 88s [[0;32m OK [0m] Finished [0;1;39mSet console font and keymap[0m. 88s [[0;32m OK [0m] Finished [0;1;39mCreate Volatile Files and Directories[0m. 88s Starting [0;1;39mNetwork Time Synchronization[0m... 88s Starting [0;1;39mUpdate UTMP about System Boot/Shutdown[0m... 88s [[0;32m OK [0m] Finished [0;1;39mTell Plymouth To Write Out Runtime Data[0m. 88s [[0;32m OK [0m] Finished [0;1;39mUpdate UTMP about System Boot/Shutdown[0m. 88s [[0;32m OK [0m] Finished [0;1;39mApply Control Program Identification (CPI)[0m. 88s [[0;32m OK [0m] Started [0;1;39mNetwork Time Synchronization[0m. 88s [[0;32m OK [0m] Reached target [0;1;39mSystem Time Set[0m. 88s [[0;32m OK [0m] Reached target [0;1;39mSystem Time Synchronized[0m. 88s [[0;32m OK [0m] Finished [0;1;39mLoad AppArmor profiles[0m. 88s [ 4.932755] cloud-init[501]: Cloud-init v. 24.4.1-0ubuntu0~20.04.2 running 'init-local' at Thu, 22 May 2025 19:22:35 +0000. Up 3.70 seconds. 88s [[0;32m OK [0m] Finished [0;1;39mCloud-init: Local Stage (pre-network)[0m. 88s [[0;32m OK [0m] Reached target [0;1;39mNetwork (Pre)[0m. 88s Starting [0;1;39mNetwork Service[0m... 88s [[0;32m OK [0m] Started [0;1;39mNetwork Service[0m. 88s Starting [0;1;39mWait for Network to be Configured[0m... 88s Starting [0;1;39mNetwork Name Resolution[0m... 88s [[0;32m OK [0m] Started [0;1;39mNetwork Name Resolution[0m. 88s [[0;32m OK [0m] Reached target [0;1;39mNetwork[0m. 88s [[0;32m OK [0m] Reached target [0;1;39mHost and Network Name Lookups[0m. 88s [[0;32m OK [0m] Finished [0;1;39mWait for Network to be Configured[0m. 88s Starting [0;1;39mCloud-init: Network Stage[0m... 88s [ 6.556319] cloud-init[568]: Cloud-init v. 24.4.1-0ubuntu0~20.04.2 running 'init' at Thu, 22 May 2025 19:22:38 +0000. Up 6.46 seconds. 88s [ 6.556428] cloud-init[568]: ci-info: +++++++++++++++++++++++++++++++++++++++Net device info+++++++++++++++++++++++++++++++++++++++ 88s [ 6.556483] cloud-init[568]: ci-info: +--------+------+------------------------------+---------------+--------+-------------------+ 88s [ 6.556535] cloud-init[568]: ci-info: | Device | Up | Address | Mask | Scope | Hw-Address | 88s [ 6.556581] cloud-init[568]: ci-info: +--------+------+------------------------------+---------------+--------+-------------------+ 88s [ 6.556633] cloud-init[568]: ci-info: | enc1 | True | 10.151.37.126 | 255.255.255.0 | global | fa:16:3e:b0:63:62 | 88s [ 6.556687] cloud-init[568]: ci-info: | enc1 | True | fe80::f816:3eff:feb0:6362/64 | . | link | fa:16:3e:b0:63:62 | 88s [ 6.556736] cloud-init[568]: ci-info: | lo | True | 127.0.0.1 | 255.0.0.0 | host | . | 88s [ 6.556788] cloud-init[568]: ci-info: | lo | True | ::1/128 | . | host | . | 88s [ 6.556839] cloud-init[568]: ci-info: +--------+------+------------------------------+---------------+--------+-------------------+ 88s [ 6.556889] cloud-init[568]: ci-info: ++++++++++++++++++++++++++++++++Route IPv4 info++++++++++++++++++++++++++++++++ 88s [ 6.556941] cloud-init[568]: ci-info: +-------+-----------------+-------------+-----------------+-----------+-------+ 88s [ 6.556990] cloud-init[568]: ci-info: | Route | Destination | Gateway | Genmask | Interface | Flags | 88s [ 6.557039] cloud-init[568]: ci-info: +-------+-----------------+-------------+-----------------+-----------+-------+ 88s [ 6.557090] cloud-init[568]: ci-info: | 0 | 0.0.0.0 | 10.151.37.1 | 0.0.0.0 | enc1 | UG | 88s [ 6.557139] cloud-init[568]: ci-info: | 1 | 10.151.37.0 | 0.0.0.0 | 255.255.255.0 | enc1 | U | 88s [ 6.557191] cloud-init[568]: ci-info: | 2 | 169.254.169.254 | 10.151.37.2 | 255.255.255.255 | enc1 | UGH | 88s [ 6.557240] cloud-init[568]: ci-info: +-------+-----------------+-------------+-----------------+-----------+-------+ 88s [ 6.557289] cloud-init[568]: ci-info: +++++++++++++++++++Route IPv6 info+++++++++++++++++++ 88s [ 6.557338] cloud-init[568]: ci-info: +-------+-------------+---------+-----------+-------+ 88s [ 6.557386] cloud-init[568]: ci-info: | Route | Destination | Gateway | Interface | Flags | 88s [ 6.557436] cloud-init[568]: ci-info: +-------+-------------+---------+-----------+-------+ 88s [ 6.557489] cloud-init[568]: ci-info: | 1 | fe80::/64 | :: | enc1 | U | 88s [ 6.557539] cloud-init[568]: ci-info: | 3 | local | :: | enc1 | U | 88s [ 6.557588] cloud-init[568]: ci-info: | 4 | multicast | :: | enc1 | U | 88s [ 6.557639] cloud-init[568]: ci-info: +-------+-------------+---------+-----------+-------+ 88s [ 6.557688] cloud-init[568]: 2025-05-22 19:22:38,702 - schema.py[WARNING]: cloud-config failed schema validation! You may run 'sudo cloud-init schema --system' to check the details. 88s [ 7.296236] cloud-init[568]: Generating public/private rsa key pair. 88s [ 7.296327] cloud-init[568]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key 88s [ 7.296384] cloud-init[568]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub 88s [ 7.296440] cloud-init[568]: The key fingerprint is: 88s [ 7.296493] cloud-init[568]: SHA256:lHBC9ulQm+2DXjO2NkJFseMhB5CK1gTFFGwwV4Tika0 root@autopkgtest 88s [ 7.296547] cloud-init[568]: The key's randomart image is: 88s [ 7.296598] cloud-init[568]: +---[RSA 3072]----+ 88s [ 7.296650] cloud-init[568]: | +X=*Oo+ o. | 88s [ 7.296702] cloud-init[568]: | +oB..* O . | 88s [ 7.296754] cloud-init[568]: | . O .. O B | 88s [ 7.296805] cloud-init[568]: | E o + B o | 88s [ 7.296857] cloud-init[568]: | . S O | 88s [ 7.296914] cloud-init[568]: | o o = | 88s [ 7.296969] cloud-init[568]: | o + | 88s [ 7.297023] cloud-init[568]: | o . | 88s [ 7.297077] cloud-init[568]: | | 88s [ 7.297131] cloud-init[568]: +----[SHA256]-----+ 88s [ 7.297186] cloud-init[568]: Generating public/private ecdsa key pair. 88s [ 7.297240] cloud-init[568]: Your identification has been saved in /etc/ssh/ssh_host_ecdsa_key 88s [ 7.297295] cloud-init[568]: Your public key has been saved in /etc/ssh/ssh_host_ecdsa_key.pub 88s [ 7.297347] cloud-init[568]: The key fingerprint is: 88s [ 7.297399] cloud-init[568]: SHA256:l4hWQ/TQ3PIAG/xITkNMyaJvYaSywAipjp3S5VNdPvU root@autopkgtest 88s [ 7.297452] cloud-init[568]: The key's randomart image is: 88s [ 7.297501] cloud-init[568]: +---[ECDSA 256]---+ 88s [ 7.297554] cloud-init[568]: | . BO= . | 88s [ 7.297607] cloud-init[568]: |o o.O=* o | 88s [ 7.297661] cloud-init[568]: |= + *+*.= . | 88s [ 7.297714] cloud-init[568]: |+.. + +o+o+.. E | 88s [ 7.297769] cloud-init[568]: |o+ * +o.S o. | 88s [ 7.297823] cloud-init[568]: |o.= o.o . | 88s [ 7.297876] cloud-init[568]: | . o | 88s [ 7.297928] cloud-init[568]: | | 88s [ 7.297979] cloud-init[568]: | | 88s [ 7.298032] cloud-init[568]: +----[SHA256]-----+ 88s [ 7.298083] cloud-init[568]: Generating public/private ed25519 key pair. 88s [ 7.298137] cloud-init[568]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key 88s [ 7.298191] cloud-init[568]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub 88s [ 7.298243] cloud-init[568]: The key fingerprint is: 88s [ 7.298294] cloud-init[568]: SHA256:qCtnIWlUAgBCOocE1arQMK+RfNVzhcjS4AUWmxQ5OVI root@autopkgtest 88s [ 7.298348] cloud-init[568]: The key's randomart image is: 88s [ 7.298399] cloud-init[568]: +--[ED25519 256]--+ 88s [ 7.298453] cloud-init[568]: |@=...E@.. o. | 88s [ 7.298506] cloud-init[568]: |*...*B+* o | 88s [ 7.298558] cloud-init[568]: |=*.+o++ o | 88s [ 7.298612] cloud-init[568]: |++=. . | 88s [ 7.298665] cloud-init[568]: |.=.. . S | 88s [ 7.298718] cloud-init[568]: |o + .. | 88s [ 7.298769] cloud-init[568]: | . ... | 88s [ 7.298821] cloud-init[568]: | . o. | 88s [ 7.298872] cloud-init[568]: | +. | 88s [ 7.298925] cloud-init[568]: +----[SHA256]-----+ 88s [[0;32m OK [0m] Finished [0;1;39mCloud-init: Network Stage[0m. 88s [[0;32m OK [0m] Reached target [0;1;39mCloud-config availability[0m. 88s [[0;32m OK [0m] Reached target [0;1;39mNetwork is Online[0m. 88s [[0;32m OK [0m] Reached target [0;1;39mSystem Initialization[0m. 88s [[0;32m OK [0m] Started [0;1;39mDaily apt download activities[0m. 88s [[0;32m OK [0m] Started [0;1;39mDaily apt upgrade and clean activities[0m. 88s [[0;32m OK [0m] Started [0;1;39mPeriodic ext4 Onli���ata Check for All Filesystems[0m. 88s [[0;32m OK [0m] Started [0;1;39mDiscard unused blocks once a week[0m. 88s [[0;32m OK [0m] Started [0;1;39mRefresh fwupd metadata regularly[0m. 88s [[0;32m OK [0m] Started [0;1;39mDaily rotation of log files[0m. 88s [[0;32m OK [0m] Started [0;1;39mDaily man-db regeneration[0m. 88s [[0;32m OK [0m] Started [0;1;39mMessage of the Day[0m. 88s [[0;32m OK [0m] Started [0;1;39mDaily Cleanup of Temporary Directories[0m. 88s [[0;32m OK [0m] Reached target [0;1;39mPaths[0m. 88s [[0;32m OK [0m] Reached target [0;1;39mTimers[0m. 88s [[0;32m OK [0m] Listening on [0;1;39mcloud-init hotplug hook socket[0m. 88s [[0;32m OK [0m] Listening on [0;1;39mD-Bus System Message Bus Socket[0m. 88s [[0;32m OK [0m] Listening on [0;1;39mUUID daemon activation socket[0m. 88s [[0;32m OK [0m] Reached target [0;1;39mSockets[0m. 88s [[0;32m OK [0m] Reached target [0;1;39mBasic System[0m. 88s Starting [0;1;39mLSB: automatic crash report generation[0m... 88s Starting [0;1;39mDeferred execution scheduler[0m... 88s Starting [0;1;39mCloud-init: Config Stage[0m... 88s [[0;32m OK [0m] Started [0;1;39mRegular background program processing daemon[0m. 88s [[0;32m OK [0m] Started [0;1;39mD-Bus System Message Bus[0m. 88s [[0;32m OK [0m] Started [0;1;39mSave initial kernel messages after boot[0m. 88s Starting [0;1;39mConfigure dump on panic for System z[0m... 88s Starting [0;1;39mRemove Stale Onli���t4 Metadata Check Snapshots[0m... 88s [[0;32m OK [0m] Started [0;1;39mirqbalance daemon[0m. 88s Starting [0;1;39mDispatcher daemon for systemd-networkd[0m... 88s Starting [0;1;39mAuthorization Manager[0m... 88s Starting [0;1;39mPollinate to seed���udo random number generator[0m... 88s [[0;32m OK [0m] Started [0;1;39mAdd entropy to /de���random 's pool a hardware RNG[0m. 88s Starting [0;1;39mSystem Logging Service[0m... 88s Starting [0;1;39mLogin Service[0m... 88s Starting [0;1;39mPermit User Sessions[0m... 88s Starting [0;1;39mDisk Manager[0m... 88s [[0;32m OK [0m] Started [0;1;39mDeferred execution scheduler[0m. 88s [[0;32m OK [0m] Finished [0;1;39mConfigure dump on panic for System z[0m. 88s [[0;32m OK [0m] Finished [0;1;39mPermit User Sessions[0m. 88s Starting [0;1;39mHold until boot process finishes up[0m... 88s Starting [0;1;39mTerminate Plymouth Boot Screen[0m... 88s [[0;32m OK [0m] Started [0;1;39mSystem Logging Service[0m. 88s [[0;32m OK [0m] Finished [0;1;39mHold until boot process finishes up[0m. 88s [[0;32m OK [0m] Started [0;1;39mSerial Getty on ttysclp0[0m. 88s Starting [0;1;39mSet console scheme[0m... 88s [[0;32m OK [0m] Started [0;1;39mLSB: automatic crash report generation[0m. 88s [[0;32m OK [0m] Finished [0;1;39mSet console scheme[0m. 88s [[0;32m OK [0m] Created slice [0;1;39msystem-getty.slice[0m. 88s [[0;32m OK [0m] Started [0;1;39mGetty on tty1[0m. 88s [[0;32m OK [0m] Reached target [0;1;39mLogin Prompts[0m. 88s [[0;32m OK [0m] Finished [0;1;39mTerminate Plymouth Boot Screen[0m. 88s [[0;32m OK [0m] Started [0;1;39mAuthorization Manager[0m. 88s Starting [0;1;39mModem Manager[0m... 88s [[0;32m OK [0m] Started [0;1;39mLogin Service[0m. 88s [[0;32m OK [0m] Finished [0;1;39mRemove Stale Onli���ext4 Metadata Check Snapshots[0m. 88s [[0;32m OK [0m] Started [0;1;39mDisk Manager[0m. 88s [[0;32m OK [0m] Started [0;1;39mDispatcher daemon for systemd-networkd[0m. 88s [[0;32m OK [0m] Started [0;1;39mModem Manager[0m. 88s [ 7.801718] cloud-init[735]: Cloud-init v. 24.4.1-0ubuntu0~20.04.2 running 'modules:config' at Thu, 22 May 2025 19:22:39 +0000. Up 7.61 seconds. 88s [[0;32m OK [0m] Finished [0;1;39mCloud-init: Config Stage[0m. 88s 88s Ubuntu 20.04.6 LTS autopkgtest ttysclp0 88s 88s autopkgtest login: [ 17.996989] cloud-init[810]: Hit:1 http://ftpmaster.internal/ubuntu focal InRelease 88s [ 18.023877] cloud-init[810]: Get:2 http://ftpmaster.internal/ubuntu focal-updates InRelease [128 kB] 88s [ 18.058537] cloud-init[810]: Get:3 http://ftpmaster.internal/ubuntu focal-security InRelease [128 kB] 88s [ 18.197599] cloud-init[810]: Get:4 http://ftpmaster.internal/ubuntu focal-updates/main Sources [634 kB] 88s [ 18.484464] cloud-init[810]: Get:5 http://ftpmaster.internal/ubuntu focal-updates/main s390x Packages [1559 kB] 88s [ 18.696091] cloud-init[810]: Get:6 http://ftpmaster.internal/ubuntu focal-updates/universe s390x Packages [972 kB] 88s [ 18.783562] cloud-init[810]: Get:7 http://ftpmaster.internal/ubuntu focal-security/main Sources [336 kB] 88s [ 18.790013] cloud-init[810]: Get:8 http://ftpmaster.internal/ubuntu focal-security/main s390x Packages [1279 kB] 88s [ 18.824307] cloud-init[810]: Get:9 http://ftpmaster.internal/ubuntu focal-security/universe s390x Packages [765 kB] 88s [ 22.535807] cloud-init[810]: Fetched 5800 kB in 4s (1630 kB/s) 88s [ 24.401727] cloud-init[810]: Reading package lists... 88s ci-info: ++++++++++++++++++++++++++++++++++++++++++++++++++++++Authorized keys from /home/ubuntu/.ssh/authorized_keys for user ubuntu+++++++++++++++++++++++++++++++++++++++++++++++++++++++ 88s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+-----------------------------------------------------------+ 88s ci-info: | Keytype | Fingerprint (sha256) | Options | Comment | 88s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+-----------------------------------------------------------+ 88s 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 | 88s 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 | 88s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+-----------------------------------------------------------+ 88s <14>May 22 19:22:57 cloud-init: ############################################################# 88s <14>May 22 19:22:57 cloud-init: -----BEGIN SSH HOST KEY FINGERPRINTS----- 88s <14>May 22 19:22:57 cloud-init: 256 SHA256:l4hWQ/TQ3PIAG/xITkNMyaJvYaSywAipjp3S5VNdPvU root@autopkgtest (ECDSA) 88s <14>May 22 19:22:57 cloud-init: 256 SHA256:qCtnIWlUAgBCOocE1arQMK+RfNVzhcjS4AUWmxQ5OVI root@autopkgtest (ED25519) 88s <14>May 22 19:22:57 cloud-init: 3072 SHA256:lHBC9ulQm+2DXjO2NkJFseMhB5CK1gTFFGwwV4Tika0 root@autopkgtest (RSA) 88s <14>May 22 19:22:57 cloud-init: -----END SSH HOST KEY FINGERPRINTS----- 88s <14>May 22 19:22:57 cloud-init: ############################################################# 88s -----BEGIN SSH HOST KEY KEYS----- 88s ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBE22pDQAa+zc+qvNsioXeL3bJ1lv7nOCzAjzE+5P9oLjNIfIiQPG++yQgbKq8X+QbPyK7DUdH2v2CV3mssa4o34= root@autopkgtest 88s ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFjxOnRJHO5yvb+IQ4NSrPlHwnrAqGsVIFTbKIai0AyB root@autopkgtest 88s ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQCiv8SP2JPEf16N+9QUTuzr4BRV0ZZMk5VTEt2ai0G+kGqtlD7sD/p8x1fVF1OcKkKGxqTmzOxOGdfydb6S6qikBuKOFfRdpgwUXYVcE/PUWAJoIgJ++8H2V4eQrcxbA3aEGB0LS+qLVD8t35TUEq3XQ/l6QAzVxWwCO+5hgF7lzofayfDFBRDhjb+Ey+BgYshvEaP5S6kVK1oub68QmJQc19XlwgmbvYQzxPW7Qqkpt/dhlQqiBKt+ii7gjBsxO21KBe979RnEULPnIr6SrupMsYess1bINVZOSRTz8MeYOe5G1NHXYBq+LXhjZfrqvyDuusDezEb7uJFX+eSBEXyiWmsXR9UGYdQivRRMfOFFiVVrii9hT5Bs+GL+tpxCTvVMalb12weZ2j4B/6AQJe0yUr4Pur121lM7TYARvRRDjMVDeCrRjT0XCHZXnlBrvF13nrPs+UL8JNO5BHNmRD+lTADrXndpyQJm/VQ9Hx1ITNtE8gGNa1pwMMk2QSdhVjU= root@autopkgtest 88s -----END SSH HOST KEY KEYS----- 88s [ 25.140302] cloud-init[810]: Cloud-init v. 24.4.1-0ubuntu0~20.04.2 running 'modules:final' at Thu, 22 May 2025 19:22:49 +0000. Up 17.74 seconds. 88s [ 25.144227] cloud-init[810]: Cloud-init v. 24.4.1-0ubuntu0~20.04.2 finished at Thu, 22 May 2025 19:22:57 +0000. Datasource DataSourceOpenStackLocal [net,ver=2]. Up 25.13 seconds 88s Stopping [0;1;39mSession 5 of user ubuntu[0m. 88s [[0;32m OK [0m] Removed slice [0;1;39msystem-modprobe.slice[0m. 88s [[0;32m OK [0m] Stopped target [0;1;39mCloud-init target[0m. 88s [[0;32m OK [0m] Stopped target [0;1;39mGraphical Interface[0m. 88s [[0;32m OK [0m] Stopped target [0;1;39mHost and Network Name Lookups[0m. 88s [[0;32m OK [0m] Stopped target [0;1;39mTimers[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mDaily apt upgrade and clean activities[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mDaily apt download activities[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mPeriodic ext4 Onli���ata Check for All Filesystems[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mDiscard unused blocks once a week[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mRefresh fwupd metadata regularly[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mDaily rotation of log files[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mDaily man-db regeneration[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mMessage of the Day[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mDaily Cleanup of Temporary Directories[0m. 88s [[0;32m OK [0m] Closed [0;1;39mcloud-init hotplug hook socket[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mCloud-init: Final Stage[0m. 88s [[0;32m OK [0m] Stopped target [0;1;39mMulti-User System[0m. 88s [[0;32m OK [0m] Stopped target [0;1;39mLogin Prompts[0m. 88s [[0;32m OK [0m] Stopped target [0;1;39mSystem Time Synchronized[0m. 88s [[0;32m OK [0m] Stopped target [0;1;39mSystem Time Set[0m. 88s Stopping [0;1;39mModem Manager[0m... 88s Stopping [0;1;39mLSB: automatic crash report generation[0m... 88s Stopping [0;1;39mDeferred execution scheduler[0m... 88s [[0;32m OK [0m] Stopped [0;1;39mCloud-init: Config Stage[0m. 88s [[0;32m OK [0m] Stopped target [0;1;39mCloud-config availability[0m. 88s [[0;32m OK [0m] Stopped target [0;1;39mNetwork is Online[0m. 88s Stopping [0;1;39mRegular background program processing daemon[0m... 88s Stopping [0;1;39mConfigure dump on panic for System z[0m... 88s Stopping [0;1;39mGetty on tty1[0m... 88s Stopping [0;1;39mirqbalance daemon[0m... 88s Stopping [0;1;39mDispatcher daemon for systemd-networkd[0m... 88s Stopping [0;1;39mPackageKit Daemon[0m... 88s Stopping [0;1;39mAdd entropy to /d���ndom 's pool a hardware RNG[0m... 88s Stopping [0;1;39mSystem Logging Service[0m... 88s Stopping [0;1;39m/usr/bin/sh -c sleep 3; reboot[0m... 88s Stopping [0;1;39mSerial Getty on ttysclp0[0m... 88s Stopping [0;1;39mOpenBSD Secure Shell server[0m... 88s Stopping [0;1;39mLoad/Save Random Seed[0m... 88s Stopping [0;1;39mDisk Manager[0m... 88s [[0;32m OK [0m] Stopped [0;1;39mRegular background program processing daemon[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mirqbalance daemon[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mDispatcher daemon for systemd-networkd[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mAdd entropy to /de���random 's pool a hardware RNG[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mSystem Logging Service[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mDeferred execution scheduler[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mGetty on tty1[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mModem Manager[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mOpenBSD Secure Shell server[0m. 88s [[0;32m OK [0m] Stopped [0;1;39m/usr/bin/sh -c sleep 3; reboot[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mConfigure dump on panic for System z[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mLoad/Save Random Seed[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mSession 5 of user ubuntu[0m. 88s [[0;32m OK [0m] Removed slice [0;1;39msystem-getty.slice[0m. 88s Stopping [0;1;39mAuthorization Manager[0m... 88s Stopping [0;1;39mLogin Service[0m... 88s Stopping [0;1;39mUser Manager for UID 1000[0m... 88s [[0;32m OK [0m] Stopped [0;1;39mLSB: automatic crash report generation[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mSerial Getty on ttysclp0[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mPackageKit Daemon[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mLogin Service[0m. 88s [[0;32m OK [0m] Removed slice [0;1;39msystem-serial\x2dgetty.slice[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mAuthorization Manager[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mDisk Manager[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mUser Manager for UID 1000[0m. 88s Stopping [0;1;39mUser Runtime Directory /run/user/1000[0m... 88s [[0;32m OK [0m] Unmounted [0;1;39m/run/user/1000[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mUser Runtime Directory /run/user/1000[0m. 88s [[0;32m OK [0m] Removed slice [0;1;39mUser Slice of UID 1000[0m. 88s [[0;32m OK [0m] Reached target [0;1;39mUnmount All Filesystems[0m. 88s Stopping [0;1;39mD-Bus System Message Bus[0m... 88s Stopping [0;1;39mPermit User Sessions[0m... 88s [[0;32m OK [0m] Stopped [0;1;39mD-Bus System Message Bus[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mPermit User Sessions[0m. 88s [[0;32m OK [0m] Stopped target [0;1;39mBasic System[0m. 88s [[0;32m OK [0m] Stopped target [0;1;39mNetwork[0m. 88s [[0;32m OK [0m] Stopped target [0;1;39mPaths[0m. 88s [[0;32m OK [0m] Stopped target [0;1;39mRemote File Systems[0m. 88s [[0;32m OK [0m] Stopped target [0;1;39mSlices[0m. 88s [[0;32m OK [0m] Removed slice [0;1;39mUser and Session Slice[0m. 88s [[0;32m OK [0m] Stopped target [0;1;39mSockets[0m. 88s [[0;32m OK [0m] Closed [0;1;39mD-Bus System Message Bus Socket[0m. 88s [[0;32m OK [0m] Closed [0;1;39mSyslog Socket[0m. 88s [[0;32m OK [0m] Closed [0;1;39mUUID daemon activation socket[0m. 88s [[0;32m OK [0m] Stopped target [0;1;39mSystem Initialization[0m. 88s [[0;32m OK [0m] Stopped target [0;1;39mLocal Encrypted Volumes[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mDispatch Password ���ts to Console Directory Watch[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mForward Password R���uests to Wall Directory Watch[0m. 88s [[0;32m OK [0m] Stopped target [0;1;39mSwap[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mCloud-init: Network Stage[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mWait for Network to be Configured[0m. 88s Stopping [0;1;39mNetwork Name Resolution[0m... 88s Stopping [0;1;39mNetwork Time Synchronization[0m... 88s Stopping [0;1;39mUpdate UTMP about System Boot/Shutdown[0m... 88s [[0;32m OK [0m] Stopped [0;1;39mNetwork Time Synchronization[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mUpdate UTMP about System Boot/Shutdown[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mNetwork Name Resolution[0m. 88s Stopping [0;1;39mNetwork Service[0m... 88s [[0;32m OK [0m] Stopped [0;1;39mCreate Volatile Files and Directories[0m. 88s [[0;32m OK [0m] Stopped target [0;1;39mLocal File Systems[0m. 88s [[0;32m OK [0m] Stopped target [0;1;39mLocal File Systems (Pre)[0m. 88s Stopping [0;1;39mDevice-Mapper Multipath Device Controller[0m... 88s [[0;32m OK [0m] Stopped [0;1;39mCreate Static Device Nodes in /dev[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mDevice-Mapper Multipath Device Controller[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mNetwork Service[0m. 88s [[0;32m OK [0m] Stopped target [0;1;39mNetwork (Pre)[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mCloud-init: Local Stage (pre-network)[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mApply Kernel Variables[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mLoad Kernel Modules[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mCreate System Users[0m. 88s [[0;32m OK [0m] Stopped [0;1;39mRemount Root and Kernel File Systems[0m. 88s [[0;32m OK [0m] Reached target [0;1;39mShutdown[0m. 88s [[0;32m OK [0m] Reached target [0;1;39mFinal Step[0m. 88s [[0;32m OK [0m] Finished [0;1;39mReboot[0m. 88s [[0;32m OK [0m] Reached target [0;1;39mReboot[0m. 88s LOADPARM=[ ] 88s Using virtio-blk. 88s Using SCSI scheme. 88s ....... 88s [ 0.031893] Linux version 5.4.0-218-generic (buildd@bos03-s390x-013) (gcc version 9.4.0 (Ubuntu 9.4.0-1ubuntu1~20.04.2)) #238-Ubuntu SMP Mon May 19 10:41:27 UTC 2025 (Ubuntu 5.4.0-218.238-generic 5.4.292) 88s [ 0.031896] setup.289988: Linux is running under KVM in 64-bit mode 88s [ 0.033238] setup.b050d0: The maximum memory size is 16384MB 88s [ 0.033248] numa.196305: NUMA mode: plain 88s [ 0.033264] cpu.33a262: 4 configured CPUs, 0 standby CPUs 88s [ 0.033340] Write protected kernel read-only data: 15000k 88s [ 0.033447] Zone ranges: 88s [ 0.033448] DMA [mem 0x0000000000000000-0x000000007fffffff] 88s [ 0.033450] Normal [mem 0x0000000080000000-0x00000003ffffffff] 88s [ 0.033451] Movable zone start for each node 88s [ 0.033452] Early memory node ranges 88s [ 0.033453] node 0: [mem 0x0000000000000000-0x00000003ffffffff] 88s [ 0.033455] Initmem setup node 0 [mem 0x0000000000000000-0x00000003ffffffff] 88s [ 0.163050] percpu: Embedded 34 pages/cpu s98816 r8192 d32256 u139264 88s [ 0.163068] Built 1 zonelists, mobility grouping on. Total pages: 4128768 88s [ 0.163068] Policy zone: Normal 88s [ 0.163069] Kernel command line: root=LABEL=cloudimg-rootfs 88s [ 0.163802] Dentry cache hash table entries: 2097152 (order: 12, 16777216 bytes, linear) 88s [ 0.164301] Inode-cache hash table entries: 1048576 (order: 11, 8388608 bytes, linear) 88s [ 0.164302] mem auto-init: stack:off, heap alloc:on, heap free:off 88s [ 0.713330] Memory: 16451744K/16777216K available (9260K kernel code, 1712K rwdata, 5736K rodata, 3460K init, 948K bss, 325472K reserved, 0K cma-reserved) 88s [ 0.728032] SLUB: HWalign=256, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 88s [ 0.728937] ftrace: allocating 29804 entries in 117 pages 88s [ 0.734079] ftrace: allocated 117 pages with 5 groups 88s [ 0.735731] rcu: Hierarchical RCU implementation. 88s [ 0.735732] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. 88s [ 0.735733] Tasks RCU enabled. 88s [ 0.735734] rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies. 88s [ 0.735734] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 88s [ 0.804044] NR_IRQS: 3, nr_irqs: 3, preallocated irqs: 3 88s [ 0.804094] clocksource: tod: mask: 0xffffffffffffffff max_cycles: 0x3b0a9be803b0a9, max_idle_ns: 1805497147909793 ns 88s [ 0.804630] random: crng init done 88s [ 0.804651] Console: colour dummy device 80x25 88s [ 0.804711] printk: console [ttysclp0] enabled 88s [ 0.804754] pid_max: default: 32768 minimum: 301 88s [ 0.804773] LSM: Security Framework initializing 88s [ 0.804779] Yama: becoming mindful. 88s [ 0.804798] AppArmor: AppArmor initialized 88s [ 0.804826] Mount-cache hash table entries: 32768 (order: 6, 262144 bytes, linear) 88s [ 0.804847] Mountpoint-cache hash table entries: 32768 (order: 6, 262144 bytes, linear) 88s [ 0.804857] *** VALIDATE tmpfs *** 88s [ 0.804964] *** VALIDATE proc *** 88s [ 0.805001] *** VALIDATE cgroup1 *** 88s [ 0.805003] *** VALIDATE cgroup2 *** 88s [ 0.805140] rcu: Hierarchical SRCU implementation. 88s [ 0.805323] smp: Bringing up secondary CPUs ... 88s [ 0.805813] smp: Brought up 1 node, 4 CPUs 88s [ 0.808270] devtmpfs: initialized 88s [ 0.808598] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns 88s [ 0.808620] futex hash table entries: 1024 (order: 6, 262144 bytes, linear) 88s [ 0.808730] NET: Registered protocol family 16 88s [ 0.808750] audit: initializing netlink subsys (disabled) 88s [ 0.808789] audit: type=2000 audit(1747941801.526:1): state=initialized audit_enabled=0 res=1 88s [ 0.808818] Spectre V2 mitigation: etokens 88s [ 0.809627] HugeTLB registered 1.00 MiB page size, pre-allocated 0 pages 88s [ 0.810834] iommu: Default domain type: Translated 88s [ 0.810884] SCSI subsystem initialized 88s [ 0.811051] NetLabel: Initializing 88s [ 0.811052] NetLabel: domain hash size = 128 88s [ 0.811052] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO 88s [ 0.811061] NetLabel: unlabeled traffic allowed by default 88s [ 0.821825] *** VALIDATE bpf *** 88s [ 0.821872] VFS: Disk quotas dquot_6.6.0 88s [ 0.821881] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) 88s [ 0.821894] *** VALIDATE ramfs *** 88s [ 0.821896] *** VALIDATE hugetlbfs *** 88s [ 0.821942] AppArmor: AppArmor Filesystem Enabled 88s [ 0.823319] NET: Registered protocol family 2 88s [ 0.823622] IP idents hash table entries: 262144 (order: 9, 2097152 bytes, vmalloc) 88s 88s --------------------------------------------------- 88s ------- nova show 061fd612-1851-4c5b-8c2e-5e9f31b904ac (adt-focal-s390x-glibc-20250522-190457-juju-7f2275-prod-proposed-migration-environment-15-e87580a5-85a7-47f7-844c-96d4736d2bd9) ------ 88s +--------------------------------------------+--------------------------------------------------------------------------------------------------------------------------------------------------------+ 88s | Property | Value | 88s +--------------------------------------------+--------------------------------------------------------------------------------------------------------------------------------------------------------+ 88s | OS-DCF:diskConfig | MANUAL | 88s | OS-EXT-AZ:availability_zone | AZ2 | 88s | OS-EXT-SRV-ATTR:host | ps7-ra9-s390x-n7.ps7.canonical.com | 88s | OS-EXT-SRV-ATTR:hostname | adt-focal-s390x-glibc-20250522-190457-juju-7f2275-prod-proposed | 88s | OS-EXT-SRV-ATTR:hypervisor_hostname | ps7-ra9-s390x-n7.ps7.canonical.com | 88s | OS-EXT-SRV-ATTR:instance_name | instance-0005eaa4 | 88s | OS-EXT-SRV-ATTR:kernel_id | | 88s | OS-EXT-SRV-ATTR:launch_index | 0 | 88s | OS-EXT-SRV-ATTR:ramdisk_id | | 88s | OS-EXT-SRV-ATTR:reservation_id | r-nbo0qetg | 88s | OS-EXT-SRV-ATTR:root_device_name | /dev/vda | 88s | OS-EXT-STS:power_state | 1 | 88s | OS-EXT-STS:task_state | - | 88s | OS-EXT-STS:vm_state | active | 88s | OS-SRV-USG:launched_at | 2025-05-22T19:20:17.000000 | 88s | OS-SRV-USG:terminated_at | - | 88s | accessIPv4 | | 88s | accessIPv6 | | 88s | config_drive | | 88s | created | 2025-05-22T19:20:00Z | 88s | description | - | 88s | flavor:disk | 100 | 88s | flavor:ephemeral | 0 | 88s | flavor:extra_specs | {"aggregate_instance_extra_specs:commit": "s390x", "hw:cpu_policy": "shared", "hw:mem_page_size": "large", "hw:pci_numa_affinity_policy": "preferred"} | 88s | flavor:original_name | autopkgtest-cpu4-ram16-disk100-s390x | 88s | flavor:ram | 16384 | 88s | flavor:swap | 0 | 88s | flavor:vcpus | 4 | 88s | hostId | 67cf7a2289df0926adccda9c93000b81444d79e608367d52ff716096 | 88s | id | 061fd612-1851-4c5b-8c2e-5e9f31b904ac | 88s | image | adt/ubuntu-focal-s390x-server-20250522.img (bd1d2cb9-3d15-470c-a0e9-ba68e2dcb046) | 88s | key_name | testbed-juju-7f2275-prod-proposed-migration-environment-15 | 88s | locked | False | 88s | locked_reason | - | 88s | metadata | {} | 88s | name | adt-focal-s390x-glibc-20250522-190457-juju-7f2275-prod-proposed-migration-environment-15-e87580a5-85a7-47f7-844c-96d4736d2bd9 | 88s | net_prod-autopkgtest-workers-s390x network | 10.151.37.126 | 88s | os-extended-volumes:volumes_attached | [] | 88s | progress | 0 | 88s | security_groups | autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@sto01-s390x-1.secgroup | 88s | server_groups | [] | 88s | status | ACTIVE | 88s | tags | [] | 88s | tenant_id | 893eec2fc86d4c948fb8c70f765f14df | 88s | trusted_image_certificates | - | 88s | updated | 2025-05-22T19:20:18Z | 88s | user_id | 9be12b7a7a7444fdba023d067f039a4a | 88s +--------------------------------------------+--------------------------------------------------------------------------------------------------------------------------------------------------------+ 88s --------------------------------------------------- 88s 94s nova [W] Using flock in prodstack7-s390x 94s Creating nova instance adt-focal-s390x-glibc-20250522-190457-juju-7f2275-prod-proposed-migration-environment-15-e87580a5-85a7-47f7-844c-96d4736d2bd9 from image adt/ubuntu-focal-s390x-server-20250522.img (UUID bd1d2cb9-3d15-470c-a0e9-ba68e2dcb046)... 94s nova [W] Timed out waiting for 061fd612-1851-4c5b-8c2e-5e9f31b904ac to get deleted. 94s autopkgtest [19:21:15]: ERROR: testbed failure: sent `auxverb_debug_fail', got `copy-failed', expected `ok...'