0s autopkgtest [19:21:46]: starting date and time: 2025-05-22 19:21:46+0000 0s autopkgtest [19:21:46]: git checkout: 9986aa8c Merge branch 'skia/fix_network_interface' into 'ubuntu/production' 0s autopkgtest [19:21:46]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.4m9187bk/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 jool --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=linux-meta/5.15.0.142.137 linux-signed/5.15.0-142.152 linux/5.15.0-142.152' --setup-commands 'apt-get install -y ^kernel-testing--linux--full--preferred$ || apt-get install -y ^linux-image$ ^linux-headers$ || apt-get install -y ^linux-image-generic$ ^linux-headers-generic$' --setup-commands 'apt-get install -y ^kernel-testing--linux--modules-extra--preferred$ || apt-get install -y ^linux-modules-extra$ || :' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-cpu2-ram4-disk20-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@sto01-s390x-2.secgroup --name adt-jammy-s390x-jool-20250522-190735-juju-7f2275-prod-proposed-migration-environment-2-a4c03e61-5e6b-44c3-a24c-54bbd4883f30 --image adt/ubuntu-jammy-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-autopkgtest-workers-s390x -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 61s autopkgtest [19:22:47]: testbed dpkg architecture: s390x 62s autopkgtest [19:22:48]: testbed apt version: 2.4.13 62s autopkgtest [19:22:48]: @@@@@@@@@@@@@@@@@@@@ test bed setup 62s autopkgtest [19:22:48]: testbed release detected to be: None 63s autopkgtest [19:22:49]: updating testbed package index (apt update) 63s Hit:1 http://ftpmaster.internal/ubuntu jammy InRelease 63s Hit:2 http://ftpmaster.internal/ubuntu jammy-updates InRelease 63s Hit:3 http://ftpmaster.internal/ubuntu jammy-security InRelease 63s Get:4 http://ftpmaster.internal/ubuntu jammy-proposed InRelease [279 kB] 63s Get:5 http://ftpmaster.internal/ubuntu jammy-proposed/universe Sources [30.9 kB] 63s Get:6 http://ftpmaster.internal/ubuntu jammy-proposed/restricted Sources [8440 B] 63s Get:7 http://ftpmaster.internal/ubuntu jammy-proposed/main Sources [82.6 kB] 63s Get:8 http://ftpmaster.internal/ubuntu jammy-proposed/main s390x Packages [152 kB] 63s Get:9 http://ftpmaster.internal/ubuntu jammy-proposed/main s390x c-n-f Metadata [2532 B] 63s Get:10 http://ftpmaster.internal/ubuntu jammy-proposed/restricted s390x Packages [1704 B] 64s Get:11 http://ftpmaster.internal/ubuntu jammy-proposed/restricted s390x c-n-f Metadata [116 B] 64s Get:12 http://ftpmaster.internal/ubuntu jammy-proposed/universe s390x Packages [41.8 kB] 64s Get:13 http://ftpmaster.internal/ubuntu jammy-proposed/universe s390x c-n-f Metadata [1996 B] 64s Get:14 http://ftpmaster.internal/ubuntu jammy-proposed/multiverse s390x c-n-f Metadata [116 B] 65s Fetched 601 kB in 1s (704 kB/s) 65s Reading package lists... 66s Reading package lists... 66s Building dependency tree... 66s Reading state information... 66s The following additional packages will be installed: 66s linux-headers-5.15.0-142 linux-headers-5.15.0-142-generic 66s linux-headers-generic linux-headers-virtual linux-image-5.15.0-142-generic 66s linux-image-generic linux-image-virtual linux-modules-5.15.0-142-generic 66s linux-modules-extra-5.15.0-142-generic linux-virtual 66s Suggested packages: 66s fdutils linux-doc | linux-source-5.15.0 linux-tools 66s The following NEW packages will be installed: 66s linux-headers-5.15.0-142 linux-headers-5.15.0-142-generic 66s linux-image-5.15.0-142-generic linux-modules-5.15.0-142-generic 66s linux-modules-extra-5.15.0-142-generic 66s The following packages will be upgraded: 66s linux-generic linux-headers-generic linux-headers-virtual 66s linux-image-generic linux-image-virtual linux-virtual 66s 6 upgraded, 5 newly installed, 0 to remove and 1 not upgraded. 66s Need to get 44.7 MB of archives. 66s After this operation, 206 MB of additional disk space will be used. 66s Get:1 http://ftpmaster.internal/ubuntu jammy-proposed/main s390x linux-modules-5.15.0-142-generic s390x 5.15.0-142.152 [14.2 MB] 67s Get:2 http://ftpmaster.internal/ubuntu jammy-proposed/main s390x linux-image-5.15.0-142-generic s390x 5.15.0-142.152 [7971 kB] 67s Get:3 http://ftpmaster.internal/ubuntu jammy-proposed/main s390x linux-modules-extra-5.15.0-142-generic s390x 5.15.0-142.152 [8116 kB] 67s Get:4 http://ftpmaster.internal/ubuntu jammy-proposed/main s390x linux-generic s390x 5.15.0.142.137 [1698 B] 67s Get:5 http://ftpmaster.internal/ubuntu jammy-proposed/main s390x linux-image-generic s390x 5.15.0.142.137 [2428 B] 67s Get:6 http://ftpmaster.internal/ubuntu jammy-proposed/main s390x linux-virtual s390x 5.15.0.142.137 [1672 B] 67s Get:7 http://ftpmaster.internal/ubuntu jammy-proposed/main s390x linux-image-virtual s390x 5.15.0.142.137 [2428 B] 67s Get:8 http://ftpmaster.internal/ubuntu jammy-proposed/main s390x linux-headers-virtual s390x 5.15.0.142.137 [1636 B] 67s Get:9 http://ftpmaster.internal/ubuntu jammy-proposed/main s390x linux-headers-5.15.0-142 all 5.15.0-142.152 [12.3 MB] 67s Get:10 http://ftpmaster.internal/ubuntu jammy-proposed/main s390x linux-headers-5.15.0-142-generic s390x 5.15.0-142.152 [2087 kB] 67s Get:11 http://ftpmaster.internal/ubuntu jammy-proposed/main s390x linux-headers-generic s390x 5.15.0.142.137 [2334 B] 67s dpkg-preconfigure: unable to re-open stdin: No such file or directory 67s Fetched 44.7 MB in 1s (44.5 MB/s) 67s Selecting previously unselected package linux-modules-5.15.0-142-generic. 67s (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 ... 50451 files and directories currently installed.) 67s Preparing to unpack .../00-linux-modules-5.15.0-142-generic_5.15.0-142.152_s390x.deb ... 67s Unpacking linux-modules-5.15.0-142-generic (5.15.0-142.152) ... 68s Selecting previously unselected package linux-image-5.15.0-142-generic. 68s Preparing to unpack .../01-linux-image-5.15.0-142-generic_5.15.0-142.152_s390x.deb ... 68s Unpacking linux-image-5.15.0-142-generic (5.15.0-142.152) ... 68s Selecting previously unselected package linux-modules-extra-5.15.0-142-generic. 68s Preparing to unpack .../02-linux-modules-extra-5.15.0-142-generic_5.15.0-142.152_s390x.deb ... 68s Unpacking linux-modules-extra-5.15.0-142-generic (5.15.0-142.152) ... 68s Preparing to unpack .../03-linux-generic_5.15.0.142.137_s390x.deb ... 68s Unpacking linux-generic (5.15.0.142.137) over (5.15.0.140.135) ... 68s Preparing to unpack .../04-linux-image-generic_5.15.0.142.137_s390x.deb ... 68s Unpacking linux-image-generic (5.15.0.142.137) over (5.15.0.140.135) ... 68s Preparing to unpack .../05-linux-virtual_5.15.0.142.137_s390x.deb ... 68s Unpacking linux-virtual (5.15.0.142.137) over (5.15.0.140.135) ... 68s Preparing to unpack .../06-linux-image-virtual_5.15.0.142.137_s390x.deb ... 68s Unpacking linux-image-virtual (5.15.0.142.137) over (5.15.0.140.135) ... 68s Preparing to unpack .../07-linux-headers-virtual_5.15.0.142.137_s390x.deb ... 68s Unpacking linux-headers-virtual (5.15.0.142.137) over (5.15.0.140.135) ... 68s Selecting previously unselected package linux-headers-5.15.0-142. 68s Preparing to unpack .../08-linux-headers-5.15.0-142_5.15.0-142.152_all.deb ... 68s Unpacking linux-headers-5.15.0-142 (5.15.0-142.152) ... 69s Selecting previously unselected package linux-headers-5.15.0-142-generic. 69s Preparing to unpack .../09-linux-headers-5.15.0-142-generic_5.15.0-142.152_s390x.deb ... 69s Unpacking linux-headers-5.15.0-142-generic (5.15.0-142.152) ... 69s Preparing to unpack .../10-linux-headers-generic_5.15.0.142.137_s390x.deb ... 69s Unpacking linux-headers-generic (5.15.0.142.137) over (5.15.0.140.135) ... 70s Setting up linux-headers-5.15.0-142 (5.15.0-142.152) ... 70s Setting up linux-headers-5.15.0-142-generic (5.15.0-142.152) ... 70s Setting up linux-headers-generic (5.15.0.142.137) ... 70s Setting up linux-headers-virtual (5.15.0.142.137) ... 70s Setting up linux-image-5.15.0-142-generic (5.15.0-142.152) ... 70s I: /boot/vmlinuz is now a symlink to vmlinuz-5.15.0-142-generic 70s I: /boot/initrd.img is now a symlink to initrd.img-5.15.0-142-generic 70s Setting up linux-modules-5.15.0-142-generic (5.15.0-142.152) ... 70s Setting up linux-image-virtual (5.15.0.142.137) ... 70s Setting up linux-modules-extra-5.15.0-142-generic (5.15.0-142.152) ... 70s Setting up linux-image-generic (5.15.0.142.137) ... 70s Setting up linux-generic (5.15.0.142.137) ... 70s Setting up linux-virtual (5.15.0.142.137) ... 70s Processing triggers for linux-image-5.15.0-142-generic (5.15.0-142.152) ... 70s /etc/kernel/postinst.d/initramfs-tools: 70s update-initramfs: Generating /boot/initrd.img-5.15.0-142-generic 70s No lz4 in /usr/bin:/sbin:/bin, using gzip 72s Using config file '/etc/zipl.conf' 72s Building bootmap in '/boot' 72s Adding IPL section 'ubuntu' (default) 72s Preparing boot device: vda (0000). 72s Done. 72s /etc/kernel/postinst.d/zz-zipl: 72s Using config file '/etc/zipl.conf' 72s Building bootmap in '/boot' 72s Adding IPL section 'ubuntu' (default) 72s Preparing boot device: vda (0000). 72s Done. 72s Reading package lists... 73s Building dependency tree... 73s Reading state information... 73s E: Unable to locate package ^kernel-testing--linux--modules-extra--preferred$ 73s E: Couldn't find any package by regex '^kernel-testing--linux--modules-extra--preferred$' 73s Reading package lists... 73s Building dependency tree... 73s Reading state information... 73s E: Unable to locate package ^linux-modules-extra$ 73s E: Couldn't find any package by regex '^linux-modules-extra$' 73s autopkgtest [19:22:59]: upgrading testbed (apt dist-upgrade and autopurge) 73s Reading package lists... 73s Building dependency tree... 73s Reading state information... 73s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 73s Starting 2 pkgProblemResolver with broken count: 0 73s Done 73s Entering ResolveByKeep 73s 74s The following packages will be upgraded: 74s libsqlite3-0 74s 1 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 74s Need to get 631 kB of archives. 74s After this operation, 0 B of additional disk space will be used. 74s Get:1 http://ftpmaster.internal/ubuntu jammy-security/main s390x libsqlite3-0 s390x 3.37.2-2ubuntu0.4 [631 kB] 74s Fetched 631 kB in 0s (2519 kB/s) 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 ... 73407 files and directories currently installed.) 74s Preparing to unpack .../libsqlite3-0_3.37.2-2ubuntu0.4_s390x.deb ... 74s Unpacking libsqlite3-0:s390x (3.37.2-2ubuntu0.4) over (3.37.2-2ubuntu0.3) ... 74s Setting up libsqlite3-0:s390x (3.37.2-2ubuntu0.4) ... 74s Processing triggers for libc-bin (2.35-0ubuntu3.9) ... 75s Reading package lists... 75s Building dependency tree... 75s Reading state information... 75s Starting pkgProblemResolver with broken count: 0 75s Starting 2 pkgProblemResolver with broken count: 0 75s Done 75s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 75s autopkgtest [19:23:01]: rebooting testbed after setup commands that affected boot 79s autopkgtest-virt-ssh [19:23:05]: copydown destination failed, status 255 82s autopkgtest-virt-ssh [19:23:08]: ------- nova console-log a9b5499f-0da8-4bf8-9da5-6d93232e35d1 (adt-jammy-s390x-jool-20250522-190735-juju-7f2275-prod-proposed-migration-environment-2-a4c03e61-5e6b-44c3-a24c-54bbd4883f30) ------ 82s LOADPARM=[ ] 82s Using virtio-blk. 82s Using SCSI scheme. 82s ........ 82s [ 0.214165] Linux version 5.15.0-140-generic (buildd@bos03-s390x-013) (gcc (Ubuntu 11.4.0-1ubuntu1~22.04) 11.4.0, GNU ld (GNU Binutils for Ubuntu) 2.38) #150-Ubuntu SMP Sat Apr 12 06:00:35 UTC 2025 (Ubuntu 5.15.0-140.150-generic 5.15.179) 82s [ 0.214169] setup: Linux is running under KVM in 64-bit mode 82s [ 0.216176] setup: Relocating AMODE31 section of size 0x00003000 82s [ 0.216186] setup: The maximum memory size is 4096MB 82s [ 0.216247] cpu: 2 configured CPUs, 0 standby CPUs 82s [ 0.216335] Write protected kernel read-only data: 19200k 82s [ 0.216379] Zone ranges: 82s [ 0.216381] DMA [mem 0x0000000000000000-0x000000007fffffff] 82s [ 0.216384] Normal [mem 0x0000000080000000-0x00000000ffffffff] 82s [ 0.216387] Movable zone start for each node 82s [ 0.216388] Early memory node ranges 82s [ 0.216389] node 0: [mem 0x0000000000000000-0x00000000ffffffff] 82s [ 0.216392] Initmem setup node 0 [mem 0x0000000000000000-0x00000000ffffffff] 82s [ 0.260686] percpu: Embedded 33 pages/cpu s94976 r8192 d32000 u135168 82s [ 0.260709] Built 1 zonelists, mobility grouping on. Total pages: 1032192 82s [ 0.260711] Policy zone: Normal 82s [ 0.260712] Kernel command line: root=LABEL=cloudimg-rootfs 82s [ 0.262104] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) 82s [ 0.262830] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) 82s [ 0.262839] mem auto-init: stack:off, heap alloc:on, heap free:off 82s [ 0.428391] Memory: 4074540K/4194304K available (12056K kernel code, 2876K rwdata, 7144K rodata, 5220K init, 1248K bss, 119764K reserved, 0K cma-reserved) 82s [ 0.447668] SLUB: HWalign=256, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 82s [ 0.448574] ftrace: allocating 34277 entries in 134 pages 82s [ 0.464211] ftrace: allocated 134 pages with 3 groups 82s [ 0.466124] rcu: Hierarchical RCU implementation. 82s [ 0.466127] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. 82s [ 0.466129] Rude variant of Tasks RCU enabled. 82s [ 0.466130] Tracing variant of Tasks RCU enabled. 82s [ 0.466130] rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies. 82s [ 0.466131] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 82s [ 0.486184] NR_IRQS: 3, nr_irqs: 3, preallocated irqs: 3 82s [ 0.486227] clocksource: tod: mask: 0xffffffffffffffff max_cycles: 0x3b0a9be803b0a9, max_idle_ns: 1805497147909793 ns 82s [ 0.486754] random: crng init done 82s [ 0.486774] Console: colour dummy device 80x25 82s [ 0.486855] printk: console [ttysclp0] enabled 82s [ 0.486897] pid_max: default: 32768 minimum: 301 82s [ 0.486916] LSM: Security Framework initializing 82s [ 0.486925] landlock: Up and running. 82s [ 0.486926] Yama: becoming mindful. 82s [ 0.486961] AppArmor: AppArmor initialized 82s [ 0.486996] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) 82s [ 0.487020] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) 82s [ 0.487532] rcu: Hierarchical SRCU implementation. 82s [ 0.487710] smp: Bringing up secondary CPUs ... 82s [ 0.487995] smp: Brought up 1 node, 2 CPUs 82s [ 0.488427] devtmpfs: initialized 82s [ 0.488606] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns 82s [ 0.488660] futex hash table entries: 512 (order: 5, 131072 bytes, linear) 82s [ 0.488831] NET: Registered PF_NETLINK/PF_ROUTE protocol family 82s [ 0.488869] audit: initializing netlink subsys (disabled) 82s [ 0.488921] audit: type=2000 audit(1747941821.849:1): state=initialized audit_enabled=0 res=1 82s [ 0.488962] Spectre V2 mitigation: etokens 82s [ 0.489871] HugeTLB registered 1.00 MiB page size, pre-allocated 0 pages 82s [ 0.491766] iommu: Default domain type: Translated 82s [ 0.491768] iommu: DMA domain TLB invalidation policy: strict mode 82s [ 0.491831] SCSI subsystem initialized 82s [ 0.491964] NetLabel: Initializing 82s [ 0.491967] NetLabel: domain hash size = 128 82s [ 0.491968] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO 82s [ 0.491996] NetLabel: unlabeled traffic allowed by default 82s [ 0.503885] VFS: Disk quotas dquot_6.6.0 82s [ 0.503894] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) 82s [ 0.503984] AppArmor: AppArmor Filesystem Enabled 82s [ 0.509437] NET: Registered PF_INET protocol family 82s [ 0.509637] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) 82s [ 0.510171] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) 82s [ 0.510268] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) 82s [ 0.510362] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) 82s [ 0.510580] TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) 82s [ 0.510617] TCP: Hash tables configured (established 32768 bind 32768) 82s [ 0.510746] MPTCP token hash table entries: 4096 (order: 4, 98304 bytes, linear) 82s [ 0.510780] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) 82s [ 0.510810] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) 82s [ 0.510830] NET: Registered PF_UNIX/PF_LOCAL protocol family 82s [ 0.510834] NET: Registered PF_XDP protocol family 82s [ 0.511107] Trying to unpack rootfs image as initramfs... 82s [ 0.530042] kvm-s390: SIE is not available 82s [ 0.530055] hypfs: The hardware system does not support hypfs 82s [ 0.530179] Initialise system trusted keyrings 82s [ 0.530185] Key type blacklist registered 82s [ 0.530202] workingset: timestamp_bits=45 max_order=20 bucket_order=0 82s [ 0.530913] zbud: loaded 82s [ 0.531091] squashfs: version 4.0 (2009/01/31) Phillip Lougher 82s [ 0.531164] fuse: init (API version 7.34) 82s [ 0.531253] integrity: Platform Keyring initialized 82s [ 0.541198] Key type asymmetric registered 82s [ 0.541201] Asymmetric key parser 'x509' registered 82s [ 0.541228] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) 82s [ 0.541243] io scheduler mq-deadline registered 82s [ 0.541407] hvc_iucv: The z/VM IUCV HVC device driver cannot be used without z/VM 82s [ 0.542791] loop: module loaded 82s [ 0.542866] tun: Universal TUN/TAP device driver, 1.6 82s [ 0.542890] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. 82s [ 0.542906] device-mapper: uevent: version 1.0.3 82s [ 0.542928] device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com 82s [ 0.542933] drop_monitor: Initializing network drop monitor service 82s [ 0.543041] NET: Registered PF_INET6 protocol family 82s [ 0.656318] Freeing initrd memory: 18524K 82s [ 0.659630] Segment Routing with IPv6 82s [ 0.659638] In-situ OAM (IOAM) with IPv6 82s [ 0.659657] NET: Registered PF_PACKET protocol family 82s [ 0.659690] Key type dns_resolver registered 82s [ 0.659740] cio: Channel measurement facility initialized using format extended (mode autodetected) 82s [ 0.659831] sclp_sd: Store Data request failed (eq=2, di=3, response=0x40f0, flags=0x00, status=0, rc=-5) 82s [ 0.659947] registered taskstats version 1 82s [ 0.661028] Loading compiled-in X.509 certificates 82s [ 0.661893] Loaded X.509 cert 'Build time autogenerated kernel key: f0e1df7c134d7842ae3ef6da132961df8fc389ef' 82s [ 0.662688] Loaded X.509 cert 'Canonical Ltd. Live Patch Signing: 14df34d1a87cf37625abec039ef2bf521249b969' 82s [ 0.663521] Loaded X.509 cert 'Canonical Ltd. Kernel Module Signing: 88f752e560a1e0737e31163a466ad7b70a850c19' 82s [ 0.663523] blacklist: Loading compiled-in revocation X.509 certificates 82s [ 0.663539] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing: 61482aa2830d0ab2ad5af10b7250da9033ddcef0' 82s [ 0.663554] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2017): 242ade75ac4a15e50d50c84b0d45ff3eae707a03' 82s [ 0.663583] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (ESM 2018): 365188c1d374d6b07c3c8f240f8ef722433d6a8b' 82s [ 0.663603] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2019): c0746fd6c5da3ae827864651ad66ae47fe24b3e8' 82s [ 0.663625] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v1): a8d54bbb3825cfb94fa13c9f8a594a195c107b8d' 82s [ 0.663640] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v2): 4cf046892d6fd3c9a5b03f98d845f90851dc6a8c' 82s [ 0.663655] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v3): 100437bb6de6e469b581e61cd66bce3ef4ed53af' 82s [ 0.663670] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (Ubuntu Core 2019): c1d57b8f6b743f23ee41f4f7ee292f06eecadfb9' 82s [ 0.663968] zswap: loaded using pool lzo/zbud 82s [ 0.664128] Key type .fscrypt registered 82s [ 0.664130] Key type fscrypt-provisioning registered 82s [ 0.665569] Key type encrypted registered 82s [ 0.665572] AppArmor: AppArmor sha1 policy hashing enabled 82s [ 0.665577] ima: No TPM chip found, activating TPM-bypass! 82s [ 0.665581] Loading compiled-in module X.509 certificates 82s [ 0.666536] Loaded X.509 cert 'Build time autogenerated kernel key: f0e1df7c134d7842ae3ef6da132961df8fc389ef' 82s [ 0.666540] ima: Allocated hash algorithm: sha1 82s [ 0.666545] ima: No architecture policies found 82s [ 0.666552] evm: Initialising EVM extended attributes: 82s [ 0.666553] evm: security.selinux 82s [ 0.666554] evm: security.SMACK64 82s [ 0.666554] evm: security.SMACK64EXEC 82s [ 0.666555] evm: security.SMACK64TRANSMUTE 82s [ 0.666556] evm: security.SMACK64MMAP 82s [ 0.666557] evm: security.apparmor 82s [ 0.666557] evm: security.ima 82s [ 0.666558] evm: security.capability 82s [ 0.666559] evm: HMAC attrs: 0x1 82s [ 0.667396] Freeing unused kernel image (initmem) memory: 5220K 82s [ 0.667414] Write protected read-only-after-init data: 136k 82s [ 0.667545] Checked W+X mappings: passed, no unexpected W+X pages found 82s [ 0.667547] Run /init as init process 82s Loading, please wait... 82s Starting version 249.11-0ubuntu3.15 82s [ 0.716071] virtio_blk virtio0: [vda] 41943040 512-byte logical blocks (21.5 GB/20.0 GiB) 82s [ 0.717004] vda: vda1 82s [ 0.723999] virtio_net virtio1 enc1: renamed from eth0 82s Begin: Starting firmware auto-configuration ... done. 82s Begin: Loading essential drivers ... done. 82s Begin: Running /scripts/init-premount ... done. 82s Begin: Mounting root file system ... Begin: Running /scripts/local-top ... done. 82s Begin: Running /scripts/local-premount ... [ 1.110009] raid6: vx128x8 gen() 13340 MB/s 82s [ 1.280007] raid6: vx128x8 xor() 13443 MB/s 82s [ 1.280009] raid6: using algorithm vx128x8 gen() 13340 MB/s 82s [ 1.280011] raid6: .... xor() 13443 MB/s, rmw enabled 82s [ 1.280012] raid6: using s390xc recovery algorithm 82s [ 1.284065] xor: automatically using best checksumming function xc 82s [ 1.314628] Btrfs loaded, crc32c=crc32c-vx, zoned=yes, fsverity=yes 82s Scanning for Btrfs filesystems 82s done. 82s Begin: Will now check root file system ... fsck from util-linux 2.37.2 82s [/usr/sbin/fsck.ext4 (1) -- /dev/vda1] fsck.ext4 -a -C0 /dev/vda1 82s cloudimg-rootfs: clean, 57051/2560000 files, 445426/5242619 blocks 82s done. 82s [ 1.342251] EXT4-fs (vda1): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. 82s done. 82s Begin: Running /scripts/local-bottom ... done. 82s Begin: Running /scripts/init-bottom ... done. 82s [ 1.421698] systemd[1]: systemd 249.11-0ubuntu3.15 running in system mode (+PAM +AUDIT +SELINUX +APPARMOR +IMA +SMACK +SECCOMP +GCRYPT +GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) 82s [ 1.421813] systemd[1]: Detected virtualization kvm. 82s [ 1.421815] systemd[1]: Detected architecture s390x. 82s 82s Welcome to [1mUbuntu 22.04.5 LTS[0m! 82s 82s [ 1.423579] systemd[1]: Hostname set to . 82s [ 1.460683] systemd[271]: /usr/lib/systemd/system-generators/s390-cpi-vars failed with exit status 1. 82s [ 1.498588] 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. 82s [ 1.539676] systemd[1]: Queued start job for default target Graphical Interface. 82s [ 1.540220] systemd[1]: Created slice Slice /system/modprobe. 82s [[0;32m OK [0m] Created slice [0;1;39mSlice /system/modprobe[0m. 82s [ 1.540407] systemd[1]: Created slice Slice /system/serial-getty. 82s [[0;32m OK [0m] Created slice [0;1;39mSlice /system/serial-getty[0m. 82s [ 1.540534] systemd[1]: Created slice User and Session Slice. 82s [[0;32m OK [0m] Created slice [0;1;39mUser and Session Slice[0m. 82s [ 1.540587] systemd[1]: Started Forward Password Requests to Wall Directory Watch. 82s [[0;32m OK [0m] Started [0;1;39mForward Password R���uests to Wall Directory Watch[0m. 82s [ 1.540693] systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. 82s [[0;32m OK [0m] Set up automount [0;1;39mArbitrary���s File System Automount Point[0m. 82s [ 1.540766] systemd[1]: Reached target Remote File Systems. 82s [[0;32m OK [0m] Reached target [0;1;39mRemote File Systems[0m. 82s [ 1.540791] systemd[1]: Reached target Slice Units. 82s [[0;32m OK [0m] Reached target [0;1;39mSlice Units[0m. 82s [ 1.540822] systemd[1]: Reached target Swaps. 82s [[0;32m OK [0m] Reached target [0;1;39mSwaps[0m. 82s [ 1.540851] systemd[1]: Reached target Local Verity Protected Volumes. 82s [[0;32m OK [0m] Reached target [0;1;39mLocal Verity Protected Volumes[0m. 82s [ 1.540921] systemd[1]: Listening on multipathd control socket. 82s [[0;32m OK [0m] Listening on [0;1;39mmultipathd control socket[0m. 82s [ 1.540982] systemd[1]: Listening on Syslog Socket. 82s [[0;32m OK [0m] Listening on [0;1;39mSyslog Socket[0m. 82s [ 1.541039] systemd[1]: Listening on fsck to fsckd communication Socket. 82s [[0;32m OK [0m] Listening on [0;1;39mfsck to fsckd communication Socket[0m. 82s [ 1.541079] systemd[1]: Listening on initctl Compatibility Named Pipe. 82s [[0;32m OK [0m] Listening on [0;1;39minitctl Compatibility Named Pipe[0m. 82s [ 1.541178] systemd[1]: Listening on Journal Audit Socket. 82s [[0;32m OK [0m] Listening on [0;1;39mJournal Audit Socket[0m. 82s [ 1.541237] systemd[1]: Listening on Journal Socket (/dev/log). 82s [[0;32m OK [0m] Listening on [0;1;39mJournal Socket (/dev/log)[0m. 82s [ 1.541300] systemd[1]: Listening on Journal Socket. 82s [[0;32m OK [0m] Listening on [0;1;39mJournal Socket[0m. 82s [ 1.541384] systemd[1]: Listening on Network Service Netlink Socket. 82s [[0;32m OK [0m] Listening on [0;1;39mNetwork Service Netlink Socket[0m. 82s [ 1.541449] systemd[1]: Listening on udev Control Socket. 82s [[0;32m OK [0m] Listening on [0;1;39mudev Control Socket[0m. 82s [ 1.541506] systemd[1]: Listening on udev Kernel Socket. 82s [[0;32m OK [0m] Listening on [0;1;39mudev Kernel Socket[0m. 82s [ 1.542025] systemd[1]: Mounting Huge Pages File System... 82s Mounting [0;1;39mHuge Pages File System[0m... 82s [ 1.542459] systemd[1]: Mounting POSIX Message Queue File System... 82s Mounting [0;1;39mPOSIX Message Queue File System[0m... 82s [ 1.542887] systemd[1]: Mounting Kernel Debug File System... 82s Mounting [0;1;39mKernel Debug File System[0m... 82s [ 1.543329] systemd[1]: Mounting Kernel Trace File System... 82s Mounting [0;1;39mKernel Trace File System[0m... 82s [ 1.544120] systemd[1]: Starting Journal Service... 82s Starting [0;1;39mJournal Service[0m... 82s [ 1.544712] systemd[1]: Starting Set the console keyboard layout... 82s Starting [0;1;39mSet the console keyboard layout[0m... 82s [ 1.545198] systemd[1]: Starting Create List of Static Device Nodes... 82s Starting [0;1;39mCreate List of Static Device Nodes[0m... 82s [ 1.545250] systemd[1]: Condition check resulted in LXD - agent being skipped. 82s [ 1.545937] systemd[1]: Starting Load Kernel Module configfs... 82s Starting [0;1;39mLoad Kernel Module configfs[0m... 82s [ 1.546497] systemd[1]: Starting Load Kernel Module drm... 82s Starting [0;1;39mLoad Kernel Module drm[0m... 82s [ 1.547001] systemd[1]: Starting Load Kernel Module efi_pstore... 82s Starting [0;1;39mLoad Kernel Module efi_pstore[0m... 82s [ 1.547985] systemd[1]: Starting Load Kernel Module fuse... 82s Starting [0;1;39mLoad Kernel Module fuse[0m... 82s [ 1.548051] systemd[1]: Condition check resulted in OpenVSwitch configuration for cleanup being skipped. 82s [ 1.548159] systemd[1]: Condition check resulted in File System Check on Root Device being skipped. 82s [ 1.552283] systemd[1]: Starting Load Kernel Modules... 82s Starting [0;1;39mLoad Kernel Modules[0m... 82s [ 1.555223] systemd[1]: Starting Remount Root and Kernel File Systems... 82s Starting [0;1;39mRemount Root and Kernel File Systems[0m... 82s [ 1.555826] systemd[1]: Starting Coldplug All udev Devices... 82s Starting [0;1;39mColdplug All udev Devices[0m... 82s [ 1.565623] systemd[1]: Mounted Huge Pages File System. 82s [[0;32m OK [0m] Mounted [0;1;39mHuge Pages File System[0m. 82s [ 1.565706] systemd[1]: Mounted POSIX Message Queue File System. 82s [[0;32m OK [0m] Mounted [0;1;39mPOSIX Message Queue File System[0m. 82s [ 1.565760] systemd[1]: Mounted Kernel Debug File System. 82s [[0;32m OK [0m] Mounted [0;1;39mKernel Debug File System[0m. 82s [ 1.565807] systemd[1]: Mounted Kernel Trace File System. 82s [[0;32m OK [0m] Mounted [0;1;39mKernel Trace File System[0m. 82s [ 1.565997] systemd[1]: Finished Create List of Static Device Nodes. 82s [[0;32m OK [0m] Finished [0;1;39mCreate List of Static Device Nodes[0m. 82s [ 1.566189] systemd[1]: modprobe@configfs.service: Deactivated successfully. 82s [ 1.566301] systemd[1]: Finished Load Kernel Module configfs. 82s [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module configfs[0m. 82s [ 1.566440] systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. 82s [ 1.566537] systemd[1]: Finished Load Kernel Module efi_pstore. 82s [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module efi_pstore[0m. 82s [ 1.566680] systemd[1]: modprobe@fuse.service: Deactivated successfully. 82s [ 1.566773] systemd[1]: Finished Load Kernel Module fuse. 82s [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module fuse[0m. 82s [ 1.567719] systemd[1]: modprobe@drm.service: Deactivated successfully. 82s [ 1.567811] systemd[1]: Finished Load Kernel Module drm. 82s [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module drm[0m. 82s [ 1.567960] systemd[1]: Finished Load Kernel Modules. 82s [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Modules[0m. 82s [ 1.568354] systemd[1]: Mounting FUSE Control File System... 82s Mounting [0;1;39mFUSE Control File System[0m... 82s [ 1.568686] systemd[1]: Mounting Kernel Configuration File System... 82s Mounting [0;1;39mKernel Configuration File System[0m... 82s [ 1.569048] systemd[1]: Starting Apply Kernel Variables... 82s Starting [0;1;39mApply Kernel Variables[0m... 82s [ 1.577733] systemd[1]: Started Journal Service. 82s [[0;32m OK [0m] Started [0;1;39mJournal Service[0m. 82s [[0;32m OK [0m] Mounted [0;1;39mKernel Configuration File System[0m. 82s [[0;32m OK [0m] Mounted [0;1;39mFUSE Control File System[0m. 82s [[0;32m OK [0m] Finished [0;1;39mColdplug All udev Devices[0m. 82s [[0;32m OK [0m] Finished [0;1;39mRemount Root and Kernel File Systems[0m. 82s Starting [0;1;39mCloud-init: Local Stage (pre-network)[0m... 82s Starting [0;1;39mDevice-Mapper Multipath Device Controller[0m... 82s Starting [0;1;39mFlush Journal to Persistent Storage[0m... 82s Starting [0;1;39mLoad/Save Random Seed[0m... 82s Starting [0;1;39mCreate System Users[0m... 82s [[0;32m OK [0m] Finished [0;1;39mApply Kernel Variables[0m. 82s [[0;32m OK [0m] Finished [0;1;39mCreate System Users[0m. 82s Starting [0;1;39mCreate Static Device Nodes in /dev[0m... 82s [[0;32m OK [0m] Finished [0;1;39mCreate Static Device Nodes in /dev[0m. 82s Starting [0;1;39mRule-based Manage���for Device Events and Files[0m... 82s [[0;32m OK [0m] Finished [0;1;39mLoad/Save Random Seed[0m. 82s [[0;32m OK [0m] Finished [0;1;39mFlush Journal to Persistent Storage[0m. 82s [[0;32m OK [0m] Finished [0;1;39mSet the console keyboard layout[0m. 82s [[0;32m OK [0m] Started [0;1;39mDevice-Mapper Multipath Device Controller[0m. 82s [[0;32m OK [0m] Reached target [0;1;39mPreparation for Local File Systems[0m. 82s [[0;32m OK [0m] Reached target [0;1;39mLocal File Systems[0m. 82s Starting [0;1;39mLoad AppArmor profiles[0m... 82s Starting [0;1;39mSet console font and keymap[0m... 82s Starting [0;1;39mTell Plymouth To Write Out Runtime Data[0m... 82s Starting [0;1;39mSet Up Additional Binary Formats[0m... 82s Starting [0;1;39mCreate Volatile Files and Directories[0m... 82s Starting [0;1;39mUncomplicated firewall[0m... 82s [[0;32m OK [0m] Finished [0;1;39mSet console font and keymap[0m. 82s [[0;32m OK [0m] Finished [0;1;39mUncomplicated firewall[0m. 82s Mounting [0;1;39mArbitrary Executable File Formats File System[0m... 82s [[0;32m OK [0m] Finished [0;1;39mTell Plymouth To Write Out Runtime Data[0m. 82s [[0;32m OK [0m] Finished [0;1;39mCreate Volatile Files and Directories[0m. 82s Starting [0;1;39mNetwork Time Synchronization[0m... 82s Starting [0;1;39mRecord System Boot/Shutdown in UTMP[0m... 82s [[0;32m OK [0m] Finished [0;1;39mRecord System Boot/Shutdown in UTMP[0m. 82s [[0;32m OK [0m] Mounted [0;1;39mArbitrary Executable File Formats File System[0m. 82s [[0;32m OK [0m] Finished [0;1;39mSet Up Additional Binary Formats[0m. 82s [[0;32m OK [0m] Started [0;1;39mRule-based Manager for Device Events and Files[0m. 82s [[0;32m OK [0m] Started [0;1;39mDispatch Password ���ts to Console Directory Watch[0m. 82s [[0;32m OK [0m] Reached target [0;1;39mLocal Encrypted Volumes[0m. 82s [[0;32m OK [0m] Finished [0;1;39mLoad AppArmor profiles[0m. 82s [[0;32m OK [0m] Started [0;1;39mNetwork Time Synchronization[0m. 82s [[0;32m OK [0m] Reached target [0;1;39mSystem Time Set[0m. 82s [[0;32m OK [0m] Found device [0;1;39m/dev/ttysclp0[0m. 82s [ 2.044609] cloud-init[460]: Cloud-init v. 24.4.1-0ubuntu0~22.04.2 running 'init-local' at Thu, 22 May 2025 19:23:43 +0000. Up 2.02 seconds. 82s [[0;32m OK [0m] Finished [0;1;39mCloud-init: Local Stage (pre-network)[0m. 82s [[0;32m OK [0m] Reached target [0;1;39mPreparation for Network[0m. 82s Starting [0;1;39mNetwork Configuration[0m... 82s [[0;32m OK [0m] Started [0;1;39mNetwork Configuration[0m. 82s Starting [0;1;39mWait for Network to be Configured[0m... 82s Starting [0;1;39mNetwork Name Resolution[0m... 82s [[0;32m OK [0m] Started [0;1;39mNetwork Name Resolution[0m. 82s [[0;32m OK [0m] Reached target [0;1;39mNetwork[0m. 82s [[0;32m OK [0m] Reached target [0;1;39mHost and Network Name Lookups[0m. 82s [[0;32m OK [0m] Finished [0;1;39mWait for Network to be Configured[0m. 82s Starting [0;1;39mCloud-init: Network Stage[0m... 82s [ 4.374204] cloud-init[502]: Cloud-init v. 24.4.1-0ubuntu0~22.04.2 running 'init' at Thu, 22 May 2025 19:23:45 +0000. Up 4.35 seconds. 82s [ 4.378799] cloud-init[502]: ci-info: +++++++++++++++++++++++++++++++++++++++Net device info+++++++++++++++++++++++++++++++++++++++ 82s [ 4.378857] cloud-init[502]: ci-info: +--------+------+------------------------------+---------------+--------+-------------------+ 82s [ 4.378903] cloud-init[502]: ci-info: | Device | Up | Address | Mask | Scope | Hw-Address | 82s [ 4.378945] cloud-init[502]: ci-info: +--------+------+------------------------------+---------------+--------+-------------------+ 82s [ 4.378987] cloud-init[502]: ci-info: | enc1 | True | 10.151.37.19 | 255.255.255.0 | global | fa:16:3e:c5:11:b1 | 82s [ 4.379038] cloud-init[502]: ci-info: | enc1 | True | fe80::f816:3eff:fec5:11b1/64 | . | link | fa:16:3e:c5:11:b1 | 82s [ 4.379080] cloud-init[502]: ci-info: | lo | True | 127.0.0.1 | 255.0.0.0 | host | . | 82s [ 4.379125] cloud-init[502]: ci-info: | lo | True | ::1/128 | . | host | . | 82s [ 4.379171] cloud-init[502]: ci-info: +--------+------+------------------------------+---------------+--------+-------------------+ 82s [ 4.379215] cloud-init[502]: ci-info: ++++++++++++++++++++++++++++++++Route IPv4 info++++++++++++++++++++++++++++++++ 82s [ 4.379261] cloud-init[502]: ci-info: +-------+-----------------+-------------+-----------------+-----------+-------+ 82s [ 4.379309] cloud-init[502]: ci-info: | Route | Destination | Gateway | Genmask | Interface | Flags | 82s [ 4.379355] cloud-init[502]: ci-info: +-------+-----------------+-------------+-----------------+-----------+-------+ 82s [ 4.379401] cloud-init[502]: ci-info: | 0 | 0.0.0.0 | 10.151.37.1 | 0.0.0.0 | enc1 | UG | 82s [ 4.379449] cloud-init[502]: ci-info: | 1 | 10.151.11.5 | 10.151.37.1 | 255.255.255.255 | enc1 | UGH | 82s [ 4.379499] cloud-init[502]: ci-info: | 2 | 10.151.11.6 | 10.151.37.1 | 255.255.255.255 | enc1 | UGH | 82s [ 4.379542] cloud-init[502]: ci-info: | 3 | 10.151.11.7 | 10.151.37.1 | 255.255.255.255 | enc1 | UGH | 82s [ 4.379588] cloud-init[502]: ci-info: | 4 | 10.151.37.0 | 0.0.0.0 | 255.255.255.0 | enc1 | U | 82s [ 4.379629] cloud-init[502]: ci-info: | 5 | 10.151.37.1 | 0.0.0.0 | 255.255.255.255 | enc1 | UH | 82s [ 4.379675] cloud-init[502]: ci-info: | 6 | 10.151.37.2 | 0.0.0.0 | 255.255.255.255 | enc1 | UH | 82s [ 4.379721] cloud-init[502]: ci-info: | 7 | 169.254.169.254 | 10.151.37.2 | 255.255.255.255 | enc1 | UGH | 82s [ 4.379770] cloud-init[502]: ci-info: +-------+-----------------+-------------+-----------------+-----------+-------+ 82s [ 4.379813] cloud-init[502]: ci-info: +++++++++++++++++++Route IPv6 info+++++++++++++++++++ 82s [ 4.379883] cloud-init[502]: ci-info: +-------+-------------+---------+-----------+-------+ 82s [ 4.379932] cloud-init[502]: ci-info: | Route | Destination | Gateway | Interface | Flags | 82s [ 4.379976] cloud-init[502]: ci-info: +-------+-------------+---------+-----------+-------+ 82s [ 4.380023] cloud-init[502]: ci-info: | 1 | fe80::/64 | :: | enc1 | U | 82s [ 4.380070] cloud-init[502]: ci-info: | 3 | local | :: | enc1 | U | 82s [ 4.380111] cloud-init[502]: ci-info: | 4 | multicast | :: | enc1 | U | 82s [ 4.380158] cloud-init[502]: ci-info: +-------+-------------+---------+-----------+-------+ 82s [ 4.433100] cloud-init[502]: 2025-05-22 19:23:45,796 - schema.py[WARNING]: cloud-config failed schema validation! You may run 'sudo cloud-init schema --system' to check the details. 82s [ 5.793519] cloud-init[502]: Generating public/private rsa key pair. 82s [ 5.793640] cloud-init[502]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key 82s [ 5.793683] cloud-init[502]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub 82s [ 5.793720] cloud-init[502]: The key fingerprint is: 82s [ 5.793759] cloud-init[502]: SHA256:NgNu2NkhpVf4Mr/ktDzgAQAQLzRzZrH03IJzyYghCAM root@autopkgtest 82s [ 5.793794] cloud-init[502]: The key's randomart image is: 82s [ 5.793828] cloud-init[502]: +---[RSA 3072]----+ 82s [ 5.793864] cloud-init[502]: |EB.B. ... | 82s [ 5.793900] cloud-init[502]: |+oX O oo.. | 82s [ 5.793936] cloud-init[502]: |...= O+.o. | 82s [ 5.793969] cloud-init[502]: | . o+o*o.. | 82s [ 5.794002] cloud-init[502]: | . =.S+ | 82s [ 5.794036] cloud-init[502]: | . .oo+ | 82s [ 5.794069] cloud-init[502]: | . B o | 82s [ 5.794101] cloud-init[502]: | . * | 82s [ 5.794132] cloud-init[502]: | . | 82s [ 5.794163] cloud-init[502]: +----[SHA256]-----+ 82s [ 5.794198] cloud-init[502]: Generating public/private ecdsa key pair. 82s [ 5.794230] cloud-init[502]: Your identification has been saved in /etc/ssh/ssh_host_ecdsa_key 82s [ 5.794261] cloud-init[502]: Your public key has been saved in /etc/ssh/ssh_host_ecdsa_key.pub 82s [ 5.794292] cloud-init[502]: The key fingerprint is: 82s [ 5.794324] cloud-init[502]: SHA256:6+iOdihm0cnsCWbYRqyT7AQexMK3KBJvOKv3pwtanH8 root@autopkgtest 82s [ 5.794359] cloud-init[502]: The key's randomart image is: 82s [ 5.794392] cloud-init[502]: +---[ECDSA 256]---+ 82s [ 5.794428] cloud-init[502]: |o | 82s [ 5.794461] cloud-init[502]: |o+ . | 82s [ 5.794495] cloud-init[502]: |o=o . | 82s [ 5.794528] cloud-init[502]: |*o=. | 82s [ 5.794562] cloud-init[502]: |*X.+ . S | 82s [ 5.794594] cloud-init[502]: |*=B.= . | 82s [ 5.794628] cloud-init[502]: |+==+ o . | 82s [ 5.794659] cloud-init[502]: |.+=o=.Eo | 82s [ 5.794691] cloud-init[502]: |.+ +*O+ . | 82s [ 5.794724] cloud-init[502]: +----[SHA256]-----+ 82s [ 5.794756] cloud-init[502]: Generating public/private ed25519 key pair. 82s [ 5.794789] cloud-init[502]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key 82s [ 5.794824] cloud-init[502]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub 82s [ 5.794858] cloud-init[502]: The key fingerprint is: 82s [ 5.794890] cloud-init[502]: SHA256:HJwlFYF1ndoax+mw0c+NFdytACqFfgHxBwu5vrJ0VFo root@autopkgtest 82s [ 5.794926] cloud-init[502]: The key's randomart image is: 82s [ 5.794958] cloud-init[502]: +--[ED25519 256]--+ 82s [ 5.794990] cloud-init[502]: | +=++B+....o| 82s [ 5.795025] cloud-init[502]: | o=oB .. ooo| 82s [ 5.795056] cloud-init[502]: | ...E.. * o.| 82s [ 5.795091] cloud-init[502]: | o*.o = B .| 82s [ 5.795129] cloud-init[502]: | .o.S O =.| 82s [ 5.795165] cloud-init[502]: | .. o o +| 82s [ 5.795202] cloud-init[502]: | . .. | 82s [ 5.795234] cloud-init[502]: | .... | 82s [ 5.795268] cloud-init[502]: | .o | 82s [ 5.795300] cloud-init[502]: +----[SHA256]-----+ 82s [[0;32m OK [0m] Finished [0;1;39mCloud-init: Network Stage[0m. 82s [[0;32m OK [0m] Reached target [0;1;39mCloud-config availability[0m. 82s [[0;32m OK [0m] Reached target [0;1;39mNetwork is Online[0m. 82s [[0;32m OK [0m] Reached target [0;1;39mSystem Initialization[0m. 82s [[0;32m OK [0m] Started [0;1;39mDaily apt download activities[0m. 82s [[0;32m OK [0m] Started [0;1;39mDaily apt upgrade and clean activities[0m. 82s [[0;32m OK [0m] Started [0;1;39mDaily dpkg database backup timer[0m. 82s [[0;32m OK [0m] Started [0;1;39mPeriodic ext4 Onli���ata Check for All Filesystems[0m. 82s [[0;32m OK [0m] Started [0;1;39mDiscard unused blocks once a week[0m. 82s [[0;32m OK [0m] Started [0;1;39mDaily rotation of log files[0m. 82s [[0;32m OK [0m] Started [0;1;39mDaily man-db regeneration[0m. 82s [[0;32m OK [0m] Started [0;1;39mMessage of the Day[0m. 82s [[0;32m OK [0m] Started [0;1;39mDaily Cleanup of Temporary Directories[0m. 82s [[0;32m OK [0m] Reached target [0;1;39mPath Units[0m. 82s [[0;32m OK [0m] Reached target [0;1;39mTimer Units[0m. 82s [[0;32m OK [0m] Listening on [0;1;39mcloud-init hotplug hook socket[0m. 82s [[0;32m OK [0m] Listening on [0;1;39mD-Bus System Message Bus Socket[0m. 82s [[0;32m OK [0m] Listening on [0;1;39mUUID daemon activation socket[0m. 82s [[0;32m OK [0m] Reached target [0;1;39mSocket Units[0m. 82s [[0;32m OK [0m] Reached target [0;1;39mBasic System[0m. 82s Starting [0;1;39mLSB: automatic crash report generation[0m... 82s Starting [0;1;39mCloud-init: Config Stage[0m... 82s Starting [0;1;39mApply Control Program Identification (CPI)[0m... 82s [[0;32m OK [0m] Started [0;1;39mRegular background program processing daemon[0m. 82s [[0;32m OK [0m] Started [0;1;39mD-Bus System Message Bus[0m. 82s [[0;32m OK [0m] Started [0;1;39mSave initial kernel messages after boot[0m. 82s Starting [0;1;39mConfigure dump on panic for System z[0m... 82s Starting [0;1;39mRemove Stale Onli���t4 Metadata Check Snapshots[0m... 82s [[0;32m OK [0m] Started [0;1;39mirqbalance daemon[0m. 82s Starting [0;1;39mDispatcher daemon for systemd-networkd[0m... 82s Starting [0;1;39mPollinate to seed���udo random number generator[0m... 82s Starting [0;1;39mLSB: rng-tools (Debian variant)[0m... 82s Starting [0;1;39mSystem Logging Service[0m... 82s Starting [0;1;39mUser Login Management[0m... 82s Starting [0;1;39mPermit User Sessions[0m... 82s [[0;32m OK [0m] Finished [0;1;39mConfigure dump on panic for System z[0m. 82s [[0;32m OK [0m] Finished [0;1;39mRemove Stale Onli���ext4 Metadata Check Snapshots[0m. 82s [[0;32m OK [0m] Finished [0;1;39mApply Control Program Identification (CPI)[0m. 82s [[0;32m OK [0m] Started [0;1;39mLSB: automatic crash report generation[0m. 82s [[0;32m OK [0m] Finished [0;1;39mPermit User Sessions[0m. 82s [[0;32m OK [0m] Started [0;1;39mSystem Logging Service[0m. 82s Starting [0;1;39mHold until boot process finishes up[0m... 82s Starting [0;1;39mTerminate Plymouth Boot Screen[0m... 82s [[0;32m OK [0m] Started [0;1;39mLSB: rng-tools (Debian variant)[0m. 82s [[0;32m OK [0m] Finished [0;1;39mHold until boot process finishes up[0m. 82s [[0;32m OK [0m] Started [0;1;39mSerial Getty on ttysclp0[0m. 82s Starting [0;1;39mSet console scheme[0m... 82s [[0;32m OK [0m] Finished [0;1;39mSet console scheme[0m. 82s [[0;32m OK [0m] Created slice [0;1;39mSlice /system/getty[0m. 82s [[0;32m OK [0m] Started [0;1;39mGetty on tty1[0m. 82s [[0;32m OK [0m] Reached target [0;1;39mLogin Prompts[0m. 82s [[0;32m OK [0m] Finished [0;1;39mTerminate Plymouth Boot Screen[0m. 82s [[0;32m OK [0m] Started [0;1;39mUser Login Management[0m. 82s [[0;32m OK [0m] Started [0;1;39mDispatcher daemon for systemd-networkd[0m. 82s [ 6.124673] cloud-init[654]: Cloud-init v. 24.4.1-0ubuntu0~22.04.2 running 'modules:config' at Thu, 22 May 2025 19:23:47 +0000. Up 6.08 seconds. 82s [ 6.240304] cloud-init[654]: 2025-05-22 19:23:47,603 - lifecycle.py[DEPRECATED]: The following config key(s): ['apt_mirror', 'apt_preserve_sources_list'] is deprecated in 22.1 and scheduled to be removed in 27.1. 82s [ 6.240387] cloud-init[654]: 2025-05-22 19:23:47,603 - lifecycle.py[DEPRECATED]: Support for combined old and new apt module keys is deprecated in 22.1 and scheduled to be removed in 27.1. 82s [[0;32m OK [0m] Finished [0;1;39mCloud-init: Config Stage[0m. 82s 82s Ubuntu 22.04.5 LTS autopkgtest ttysclp0 82s 82s autopkgtest login: [ 15.020336] cloud-init[690]: Cloud-init v. 24.4.1-0ubuntu0~22.04.2 running 'modules:final' at Thu, 22 May 2025 19:23:56 +0000. Up 14.98 seconds. 82s [ 15.217340] cloud-init[690]: Hit:1 http://ftpmaster.internal/ubuntu jammy InRelease 82s [ 15.238610] cloud-init[690]: Get:2 http://ftpmaster.internal/ubuntu jammy-updates InRelease [128 kB] 82s [ 15.272866] cloud-init[690]: Get:3 http://ftpmaster.internal/ubuntu jammy-security InRelease [129 kB] 82s [ 15.486440] cloud-init[690]: Get:4 http://ftpmaster.internal/ubuntu jammy-updates/main s390x Packages [1044 kB] 82s [ 15.769082] cloud-init[690]: Get:5 http://ftpmaster.internal/ubuntu jammy-security/main Sources [312 kB] 82s [ 15.802432] cloud-init[690]: Get:6 http://ftpmaster.internal/ubuntu jammy-security/main s390x Packages [839 kB] 82s [ 15.842778] cloud-init[690]: Get:7 http://ftpmaster.internal/ubuntu jammy-security/universe s390x Packages [723 kB] 82s [ 17.323663] cloud-init[690]: Fetched 3175 kB in 2s (1705 kB/s) 82s [ 23.668091] cloud-init[690]: Reading package lists... 82s ci-info: ++++++++++++++++++++++++++++++++++++++++++++++++++++++Authorized keys from /home/ubuntu/.ssh/authorized_keys for user ubuntu+++++++++++++++++++++++++++++++++++++++++++++++++++++++ 82s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+-----------------------------------------------------------+ 82s ci-info: | Keytype | Fingerprint (sha256) | Options | Comment | 82s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+-----------------------------------------------------------+ 82s ci-info: | ssh-rsa | 17:cc:c2:f5:cd:5f:39:1f:0e:64:fd:e4:94:c3:c0:26:c7:b4:8c:54:0d:46:63:3c:16:ae:6f:e1:3e:a2:15:de | - | ubuntu@juju-7f2275-prod-proposed-migration-environment-21 | 82s ci-info: | ssh-rsa | 87:eb:11:e6:d9:4d:64:37:d3:15:bc:fb:70:01:fb:c2:54:4a:7c:f0:03:f0:ca:42:74:a2:5a:a0:67:8b:da:f8 | - | ubuntu@juju-7f2275-prod-proposed-migration-environment-2 | 82s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+-----------------------------------------------------------+ 82s <14>May 22 19:24:05 cloud-init: ############################################################# 82s <14>May 22 19:24:05 cloud-init: -----BEGIN SSH HOST KEY FINGERPRINTS----- 82s <14>May 22 19:24:05 cloud-init: 256 SHA256:6+iOdihm0cnsCWbYRqyT7AQexMK3KBJvOKv3pwtanH8 root@autopkgtest (ECDSA) 82s <14>May 22 19:24:05 cloud-init: 256 SHA256:HJwlFYF1ndoax+mw0c+NFdytACqFfgHxBwu5vrJ0VFo root@autopkgtest (ED25519) 82s <14>May 22 19:24:05 cloud-init: 3072 SHA256:NgNu2NkhpVf4Mr/ktDzgAQAQLzRzZrH03IJzyYghCAM root@autopkgtest (RSA) 82s <14>May 22 19:24:05 cloud-init: -----END SSH HOST KEY FINGERPRINTS----- 82s <14>May 22 19:24:05 cloud-init: ############################################################# 82s -----BEGIN SSH HOST KEY KEYS----- 82s ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBEi4yoUkYmvxl5Eo4kLxkijRvzyx32ZQXys5eWXHlfifdRQe2AKO2CHkZEF7b/5lWW06NnY3lZODIMych0lXx+o= root@autopkgtest 82s ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKv+F2tfSZR7N12j5JuDIo8iuGoHabr5PaAFKoAFOzP3 root@autopkgtest 82s ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQCzmWm9M5kyQpBSliD1f/LPXKvuEOM5ieFGE/ldD8/EjSG9ZzbIIAoePzqTp2FKOctoqA3S18KSGizPsPYj36i112ICrcxuk0r15C7v1tmoct0ED/cijOC9DrWNQvi301fU1TqjJWRT86KINMlBm7iyl/0bxlJ+30HQdOt1kijoUDGj0//y6LKVekra/n/DYntgdDdQN9VIx2ilbCjSAvTxp3LL4vLXtCcTwA8x7F3kdy2AESc0yJil/nC8+y7LOGaTj6SMRx/jX0z6HRi7MYTeTaMXcBH74Xy1yx39UKKfONiIYLPymu4KmgOOrTMvuh89FMNdTxMGovmDOpFxeO8jNTyNG0ZAqm777ZoQiuaADJPI5CNcqHHhORkObUWpfczNc4qlSdK4rrj1vh2I18WWobPTNnlrVZoO3DiHdk3rGPFC7O8csKG4IAxWsYV32aRfGXjU++HhJv/hM2jQQez3e6XOyvKudTKvL+4FFlc0WLcCk2fcYIvSPW1TBmrfVd8= root@autopkgtest 82s -----END SSH HOST KEY KEYS----- 82s [ 24.686221] cloud-init[690]: Cloud-init v. 24.4.1-0ubuntu0~22.04.2 finished at Thu, 22 May 2025 19:24:05 +0000. Datasource DataSourceOpenStackLocal [net,ver=2]. Up 24.62 seconds 82s Stopping [0;1;39mSession 5 of User ubuntu[0m... 82s [[0;32m OK [0m] Removed slice [0;1;39mSlice /system/modprobe[0m. 82s [[0;32m OK [0m] Stopped target [0;1;39mCloud-init target[0m. 82s [[0;32m OK [0m] Stopped target [0;1;39mGraphical Interface[0m. 82s [[0;32m OK [0m] Stopped target [0;1;39mHost and Network Name Lookups[0m. 82s [[0;32m OK [0m] Stopped target [0;1;39mTimer Units[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mDaily apt upgrade and clean activities[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mDaily apt download activities[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mDaily dpkg database backup timer[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mPeriodic ext4 Onli���ata Check for All Filesystems[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mDiscard unused blocks once a week[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mDaily rotation of log files[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mDaily man-db regeneration[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mMessage of the Day[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mDaily Cleanup of Temporary Directories[0m. 82s [[0;32m OK [0m] Stopped target [0;1;39mSystem Time Set[0m. 82s [[0;32m OK [0m] Closed [0;1;39mcloud-init hotplug hook socket[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mCloud-init: Final Stage[0m. 82s [[0;32m OK [0m] Stopped target [0;1;39mMulti-User System[0m. 82s [[0;32m OK [0m] Stopped target [0;1;39mLogin Prompts[0m. 82s Stopping [0;1;39mLSB: automatic crash report generation[0m... 82s [[0;32m OK [0m] Stopped [0;1;39mCloud-init: Config Stage[0m. 82s [[0;32m OK [0m] Stopped target [0;1;39mCloud-config availability[0m. 82s [[0;32m OK [0m] Stopped target [0;1;39mNetwork is Online[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mApply Control Program Identification (CPI)[0m. 82s Stopping [0;1;39mRegular background program processing daemon[0m... 82s Stopping [0;1;39mConfigure dump on panic for System z[0m... 82s Stopping [0;1;39mGetty on tty1[0m... 82s Stopping [0;1;39mirqbalance daemon[0m... 82s Stopping [0;1;39mDispatcher daemon for systemd-networkd[0m... 82s Stopping [0;1;39mPackageKit Daemon[0m... 82s [[0;32m OK [0m] Stopped [0;1;39mTerminate Plymouth Boot Screen[0m. 82s Stopping [0;1;39mAuthorization Manager[0m... 82s Stopping [0;1;39mLSB: rng-tools (Debian variant)[0m... 82s Stopping [0;1;39mSystem Logging Service[0m... 82s Stopping [0;1;39m/usr/bin/sh -c sleep 3; reboot[0m... 82s Stopping [0;1;39mSerial Getty on ttysclp0[0m... 82s Stopping [0;1;39mOpenBSD Secure Shell server[0m... 82s Stopping [0;1;39mLoad/Save Random Seed[0m... 82s [[0;32m OK [0m] Stopped [0;1;39mRegular background program processing daemon[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mirqbalance daemon[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mDispatcher daemon for systemd-networkd[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mSystem Logging Service[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mGetty on tty1[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mOpenBSD Secure Shell server[0m. 82s [[0;32m OK [0m] Stopped [0;1;39m/usr/bin/sh -c sleep 3; reboot[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mConfigure dump on panic for System z[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mLoad/Save Random Seed[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mSession 5 of User ubuntu[0m. 82s [[0;32m OK [0m] Removed slice [0;1;39mSlice /system/getty[0m. 82s Stopping [0;1;39mUser Login Management[0m... 82s Stopping [0;1;39mUser Manager for UID 1000[0m... 82s [[0;32m OK [0m] Stopped [0;1;39mLSB: automatic crash report generation[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mLSB: rng-tools (Debian variant)[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mSerial Getty on ttysclp0[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mPackageKit Daemon[0m. 82s [[0;32m OK [0m] Removed slice [0;1;39mSlice /system/serial-getty[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mHold until boot process finishes up[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mUser Login Management[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mAuthorization Manager[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mUser Manager for UID 1000[0m. 82s Stopping [0;1;39mUser Runtime Directory /run/user/1000[0m... 82s [[0;32m OK [0m] Unmounted [0;1;39m/run/user/1000[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mUser Runtime Directory /run/user/1000[0m. 82s [[0;32m OK [0m] Removed slice [0;1;39mUser Slice of UID 1000[0m. 82s Stopping [0;1;39mPermit User Sessions[0m... 82s [[0;32m OK [0m] Stopped [0;1;39mPermit User Sessions[0m. 82s [[0;32m OK [0m] Stopped target [0;1;39mBasic System[0m. 82s [[0;32m OK [0m] Stopped target [0;1;39mNetwork[0m. 82s [[0;32m OK [0m] Stopped target [0;1;39mPath Units[0m. 82s [[0;32m OK [0m] Stopped target [0;1;39mRemote File Systems[0m. 82s [[0;32m OK [0m] Stopped target [0;1;39mSlice Units[0m. 82s [[0;32m OK [0m] Removed slice [0;1;39mUser and Session Slice[0m. 82s [[0;32m OK [0m] Stopped target [0;1;39mSocket Units[0m. 82s [[0;32m OK [0m] Closed [0;1;39mSyslog Socket[0m. 82s [[0;32m OK [0m] Closed [0;1;39mUUID daemon activation socket[0m. 82s [[0;32m OK [0m] Stopped target [0;1;39mSystem Initialization[0m. 82s [[0;32m OK [0m] Stopped target [0;1;39mLocal Encrypted Volumes[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mDispatch Password ���ts to Console Directory Watch[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mForward Password R���uests to Wall Directory Watch[0m. 82s [[0;32m OK [0m] Stopped target [0;1;39mSwaps[0m. 82s [[0;32m OK [0m] Stopped target [0;1;39mLocal Verity Protected Volumes[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mCloud-init: Network Stage[0m. 82s Stopping [0;1;39mSet Up Additional Binary Formats[0m... 82s [[0;32m OK [0m] Stopped [0;1;39mWait for Network to be Configured[0m. 82s Stopping [0;1;39mNetwork Name Resolution[0m... 82s Stopping [0;1;39mNetwork Time Synchronization[0m... 82s Stopping [0;1;39mRecord System Boot/Shutdown in UTMP[0m... 82s [[0;32m OK [0m] Stopped [0;1;39mSet Up Additional Binary Formats[0m. 82s [[0;32m OK [0m] Unset automount [0;1;39mArbitrary ���s File System Automount Point[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mNetwork Time Synchronization[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mNetwork Name Resolution[0m. 82s Stopping [0;1;39mNetwork Configuration[0m... 82s [[0;32m OK [0m] Stopped [0;1;39mRecord System Boot/Shutdown in UTMP[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mCreate Volatile Files and Directories[0m. 82s [[0;32m OK [0m] Stopped target [0;1;39mLocal File Systems[0m. 82s Unmounting [0;1;39m/run/credentials/systemd-sysusers.service[0m... 82s [[0;32m OK [0m] Unmounted [0;1;39m/run/credentials/systemd-sysusers.service[0m. 82s [[0;32m OK [0m] Stopped target [0;1;39mPreparation for Local File Systems[0m. 82s [[0;32m OK [0m] Reached target [0;1;39mUnmount All Filesystems[0m. 82s Stopping [0;1;39mDevice-Mapper Multipath Device Controller[0m... 82s [[0;32m OK [0m] Stopped [0;1;39mCreate Static Device Nodes in /dev[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mNetwork Configuration[0m. 82s [[0;32m OK [0m] Stopped target [0;1;39mPreparation for Network[0m. 82s [[0;32m OK [0m] Closed [0;1;39mNetwork Service Netlink Socket[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mCloud-init: Local Stage (pre-network)[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mApply Kernel Variables[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mLoad Kernel Modules[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mCreate System Users[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mDevice-Mapper Multipath Device Controller[0m. 82s [[0;32m OK [0m] Stopped [0;1;39mRemount Root and Kernel File Systems[0m. 82s [[0;32m OK [0m] Reached target [0;1;39mSystem Shutdown[0m. 82s [[0;32m OK [0m] Reached target [0;1;39mLate Shutdown Services[0m. 82s [[0;32m OK [0m] Finished [0;1;39mSystem Reboot[0m. 82s [[0;32m OK [0m] Reached target [0;1;39mSystem Reboot[0m. 82s LOADPARM=[ ] 82s Using virtio-blk. 82s Using SCSI scheme. 82s ........ 82s [ 0.085754] Linux version 5.15.0-142-generic (buildd@bos03-s390x-001) (gcc (Ubuntu 11.4.0-1ubuntu1~22.04) 11.4.0, GNU ld (GNU Binutils for Ubuntu) 2.38) #152-Ubuntu SMP Mon May 19 11:00:25 UTC 2025 (Ubuntu 5.15.0-142.152-generic 5.15.180) 82s [ 0.085758] setup: Linux is running under KVM in 64-bit mode 82s [ 0.087741] setup: Relocating AMODE31 section of size 0x00003000 82s [ 0.087744] setup: The maximum memory size is 4096MB 82s [ 0.087769] cpu: 2 configured CPUs, 0 standby CPUs 82s [ 0.087875] Write protected kernel read-only data: 19204k 82s [ 0.087909] Zone ranges: 82s [ 0.087911] DMA [mem 0x0000000000000000-0x000000007fffffff] 82s [ 0.087914] Normal [mem 0x0000000080000000-0x00000000ffffffff] 82s [ 0.087917] Movable zone start for each node 82s [ 0.087918] Early memory node ranges 82s [ 0.087919] node 0: [mem 0x0000000000000000-0x00000000ffffffff] 82s [ 0.087922] Initmem setup node 0 [mem 0x0000000000000000-0x00000000ffffffff] 82s [ 0.116072] percpu: Embedded 33 pages/cpu s94976 r8192 d32000 u135168 82s [ 0.116090] Built 1 zonelists, mobility grouping on. Total pages: 1032192 82s [ 0.116092] Policy zone: Normal 82s [ 0.116093] Kernel command line: root=LABEL=cloudimg-rootfs 82s [ 0.116242] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) 82s [ 0.116349] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) 82s [ 0.116358] mem auto-init: stack:off, heap alloc:on, heap free:off 82s [ 0.235705] Memory: 4072844K/4194304K available (12060K kernel code, 2872K rwdata, 7144K rodata, 5224K init, 1260K bss, 121460K reserved, 0K cma-reserved) 82s [ 0.261390] SLUB: HWalign=256, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 82s [ 0.262577] ftrace: allocating 34283 entries in 134 pages 82s [ 0.276928] ftrace: allocated 134 pages with 3 groups 82s [ 0.279353] rcu: Hierarchical RCU implementation. 82s [ 0.279354] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. 82s [ 0.279355] Rude variant of Tasks RCU enabled. 82s [ 0.279355] Tracing variant of Tasks RCU enabled. 82s [ 0.279356] rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies. 82s [ 0.279357] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 82s [ 0.305229] NR_IRQS: 3, nr_irqs: 3, preallocated irqs: 3 82s [ 0.305251] clocksource: tod: mask: 0xffffffffffffffff max_cycles: 0x3b0a9be803b0a9, max_idle_ns: 1805497147909793 ns 82s [ 0.305978] random: crng init done 82s [ 0.305994] Console: colour dummy device 80x25 82s [ 0.306061] printk: console [ttysclp0] enabled 82s [ 0.306091] pid_max: default: 32768 minimum: 301 82s [ 0.306108] LSM: Security Framework initializing 82s [ 0.306115] landlock: Up and running. 82s [ 0.306116] Yama: becoming mindful. 82s [ 0.306129] AppArmor: AppArmor initialized 82s [ 0.306142] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) 82s [ 0.306149] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) 82s [ 0.306436] rcu: Hierarchical SRCU implementation. 82s [ 0.306544] smp: Bringing up secondary CPUs ... 82s [ 0.306693] smp: Brought up 1 node, 2 CPUs 82s [ 0.306952] devtmpfs: initialized 82s [ 0.307066] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns 82s [ 0.307077] futex hash table entries: 512 (order: 5, 131072 bytes, linear) 82s [ 0.307181] NET: Registered PF_NETLINK/PF_ROUTE protocol family 82s [ 0.307202] audit: initializing netlink subsys (disabled) 82s [ 0.307230] audit: type=2000 audit(1747941866.917:1): state=initialized audit_enabled=0 res=1 82s [ 0.307261] Spectre V2 mitigation: etokens 82s [ 0.307950] HugeTLB registered 1.00 MiB page size, pre-allocated 0 pages 82s [ 0.309080] iommu: Default domain type: Translated 82s [ 0.309081] iommu: DMA domain TLB invalidation policy: strict mode 82s [ 0.309126] SCSI subsystem initialized 82s [ 0.309212] NetLabel: Initializing 82s [ 0.309213] NetLabel: domain hash size = 128 82s [ 0.309213] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO 82s [ 0.309231] NetLabel: unlabeled traffic allowed by default 82s [ 0.317607] VFS: Disk quotas dquot_6.6.0 82s [ 0.317614] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) 82s [ 0.317667] AppArmor: AppArmor Filesystem Enabled 82s [ 0.322870] NET: Registered PF_INET protocol family 82s [ 0.322923] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) 82s [ 0.323415] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) 82s [ 0.323438] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) 82s [ 0.323459] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) 82s [ 0.323527] TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) 82s [ 0.323564] TCP: Hash tables configured (established 32768 bind 32768) 82s [ 0.323601] MPTCP token hash table entries: 4096 (order: 4, 98304 bytes, linear) 82s [ 0.323616] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) 82s [ 0.323628] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) 82s [ 0.323647] NET: Registered PF_UNIX/PF_LOCAL protocol family 82s [ 0.323650] NET: Registered PF_XDP protocol family 82s [ 0.323789] Trying to unpack rootfs image as initramfs... 82s [ 0.330039] kvm-s390: SIE is not available 82s [ 0.330049] hypfs: The hardware system does not support hypfs 82s [ 0.330128] Initialise system trusted keyrings 82s [ 0.330133] Key type blacklist registered 82s [ 0.330155] workingset: timestamp_bits=45 max_order=20 bucket_order=0 82s [ 0.330885] zbud: loaded 82s [ 0.331039] squashfs: version 4.0 (2009/01/31) Phillip Lougher 82s [ 0.340045] fuse: init (API version 7.34) 82s [ 0.340153] integrity: Platform Keyring initialized 82s [ 0.360029] Key type asymmetric registered 82s [ 0.360030] Asymmetric key parser 'x509' registered 82s [ 0.360037] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) 82s [ 0.360060] io scheduler mq-deadline registered 82s [ 0.360147] hvc_iucv: The z/VM IUCV HVC device driver cannot be used without z/VM 82s [ 0.362515] Freeing initrd memory: 20204K 82s [ 0.362857] loop: module loaded 82s [ 0.362899] tun: Universal TUN/TAP device driver, 1.6 82s [ 0.362925] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. 82s [ 0.362938] device-mapper: uevent: version 1.0.3 82s [ 0.362963] device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com 82s [ 0.362968] drop_monitor: Initializing network drop monitor service 82s [ 0.363050] NET: Registered PF_INET6 protocol family 82s [ 0.365735] Segment Routing with IPv6 82s [ 0.365739] In-situ OAM (IOAM) with IPv6 82s [ 0.365755] NET: Registered PF_PACKET protocol family 82s [ 0.365773] Key type dns_resolver registered 82s [ 0.365807] cio: Channel measurement facility initialized using format extended (mode autodetected) 82s [ 0.365877] sclp_sd: Store Data request failed (eq=2, di=3, response=0x40f0, flags=0x00, status=0, rc=-5) 82s [ 0.365978] registered taskstats version 1 82s [ 0.366797] Loading compiled-in X.509 certificates 82s [ 0.367668] Loaded X.509 cert 'Build time autogenerated kernel key: 597069d18f24ffcea1951bedb32bce45747a82b2' 82s [ 0.368449] Loaded X.509 cert 'Canonical Ltd. Live Patch Signing 2025 Kmod: d541cef61dc7e793b7eb7e899970a2eef0b5dc8c' 82s [ 0.369252] Loaded X.509 cert 'Canonical Ltd. Live Patch Signing: 14df34d1a87cf37625abec039ef2bf521249b969' 82s [ 0.370125] Loaded X.509 cert 'Canonical Ltd. Kernel Module Signing: 88f752e560a1e0737e31163a466ad7b70a850c19' 82s [ 0.370126] blacklist: Loading compiled-in revocation X.509 certificates 82s [ 0.370139] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing: 61482aa2830d0ab2ad5af10b7250da9033ddcef0' 82s [ 0.370150] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2017): 242ade75ac4a15e50d50c84b0d45ff3eae707a03' 82s [ 0.370162] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (ESM 2018): 365188c1d374d6b07c3c8f240f8ef722433d6a8b' 82s [ 0.370173] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2019): c0746fd6c5da3ae827864651ad66ae47fe24b3e8' 82s [ 0.370184] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v1): a8d54bbb3825cfb94fa13c9f8a594a195c107b8d' 82s [ 0.370196] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v2): 4cf046892d6fd3c9a5b03f98d845f90851dc6a8c' 82s [ 0.370207] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v3): 100437bb6de6e469b581e61cd66bce3ef4ed53af' 82s [ 0.370218] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (Ubuntu Core 2019): c1d57b8f6b743f23ee41f4f7ee292f06eecadfb9' 82s [ 0.370279] zswap: loaded using pool lzo/zbud 82s [ 0.370347] Key type .fscrypt registered 82s [ 0.370348] Key type fscrypt-provisioning registered 82s [ 0.371653] Key type encrypted registered 82s [ 0.371655] AppArmor: AppArmor sha1 policy hashing enabled 82s [ 0.371658] ima: No TPM chip found, activating TPM-bypass! 82s [ 0.371659] Loading compiled-in module X.509 certificates 82s [ 0.372471] Loaded X.509 cert 'Build time autogenerated kernel key: 597069d18f24ffcea1951bedb32bce45747a82b2' 82s [ 0.372473] ima: Allocated hash algorithm: sha1 82s [ 0.372477] ima: No architecture policies found 82s [ 0.372481] evm: Initialising EVM extended attributes: 82s [ 0.372482] evm: security.selinux 82s [ 0.372483] evm: security.SMACK64 82s [ 0.372484] evm: security.SMACK64EXEC 82s [ 0.372485] evm: security.SMACK64TRANSMUTE 82s [ 0.372485] evm: security.SMACK64MMAP 82s [ 0.372486] evm: security.apparmor 82s [ 0.372487] evm: security.ima 82s [ 0.372487] evm: security.capability 82s [ 0.372488] evm: HMAC attrs: 0x1 82s [ 0.373260] Freeing unused kernel image (initmem) memory: 5224K 82s [ 0.373280] Write protected read-only-after-init data: 136k 82s [ 0.373408] Checked W+X mappings: passed, no unexpected W+X pages found 82s [ 0.373409] Run /init as init process 82s Loading, please wait... 82s Starting version 249.11-0ubuntu3.15 82s [ 0.413259] virtio_blk virtio0: [vda] 41943040 512-byte logical blocks (21.5 GB/20.0 GiB) 82s [ 0.413741] vda: vda1 82s [ 0.430893] virtio_net virtio2 enc1: renamed from eth0 82s Begin: Starting firmware auto-configuration ... done. 82s Begin: Loading essential drivers ... done. 82s Begin: Running /scripts/init-premount ... done. 82s Begin: Mounting root file system ... Begin: Running /scripts/local-top ... done. 82s Begin: Running /scripts/local-premount ... 82s --------------------------------------------------- 82s ------- nova show a9b5499f-0da8-4bf8-9da5-6d93232e35d1 (adt-jammy-s390x-jool-20250522-190735-juju-7f2275-prod-proposed-migration-environment-2-a4c03e61-5e6b-44c3-a24c-54bbd4883f30) ------ 82s +--------------------------------------------+--------------------------------------------------------------------------------------------------------------------------------------------------------+ 82s | Property | Value | 82s +--------------------------------------------+--------------------------------------------------------------------------------------------------------------------------------------------------------+ 82s | OS-DCF:diskConfig | MANUAL | 82s | OS-EXT-AZ:availability_zone | AZ1 | 82s | OS-EXT-SRV-ATTR:host | ps7-ra8-s390x-n7.ps7.canonical.com | 82s | OS-EXT-SRV-ATTR:hostname | adt-jammy-s390x-jool-20250522-190735-juju-7f2275-prod-proposed | 82s | OS-EXT-SRV-ATTR:hypervisor_hostname | ps7-ra8-s390x-n7.ps7.canonical.com | 82s | OS-EXT-SRV-ATTR:instance_name | instance-0005eab0 | 82s | OS-EXT-SRV-ATTR:kernel_id | | 82s | OS-EXT-SRV-ATTR:launch_index | 0 | 82s | OS-EXT-SRV-ATTR:ramdisk_id | | 82s | OS-EXT-SRV-ATTR:reservation_id | r-x06qvvxc | 82s | OS-EXT-SRV-ATTR:root_device_name | /dev/vda | 82s | OS-EXT-STS:power_state | 1 | 82s | OS-EXT-STS:task_state | - | 82s | OS-EXT-STS:vm_state | active | 82s | OS-SRV-USG:launched_at | 2025-05-22T19:22:20.000000 | 82s | OS-SRV-USG:terminated_at | - | 82s | accessIPv4 | | 82s | accessIPv6 | | 82s | config_drive | | 82s | created | 2025-05-22T19:22:06Z | 82s | description | - | 82s | flavor:disk | 20 | 82s | flavor:ephemeral | 0 | 82s | flavor:extra_specs | {"aggregate_instance_extra_specs:commit": "s390x", "hw:cpu_policy": "shared", "hw:mem_page_size": "large", "hw:pci_numa_affinity_policy": "preferred"} | 82s | flavor:original_name | autopkgtest-cpu2-ram4-disk20-s390x | 82s | flavor:ram | 4096 | 82s | flavor:swap | 0 | 82s | flavor:vcpus | 2 | 82s | hostId | 821110e4f4252b99def7b67314f2a8ea6c17eb3496e63cd7669e3057 | 82s | id | a9b5499f-0da8-4bf8-9da5-6d93232e35d1 | 82s | image | adt/ubuntu-jammy-s390x-server-20250522.img (0d0c5875-24ac-49ab-beaf-52b17b4cb70a) | 82s | key_name | testbed-juju-7f2275-prod-proposed-migration-environment-2 | 82s | locked | False | 82s | locked_reason | - | 82s | metadata | {} | 82s | name | adt-jammy-s390x-jool-20250522-190735-juju-7f2275-prod-proposed-migration-environment-2-a4c03e61-5e6b-44c3-a24c-54bbd4883f30 | 82s | net_prod-autopkgtest-workers-s390x network | 10.151.37.19 | 82s | os-extended-volumes:volumes_attached | [] | 82s | progress | 0 | 82s | security_groups | autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@sto01-s390x-2.secgroup | 82s | server_groups | [] | 101s | status | ACTIVE | 101s | tags | [] | 101s | tenant_id | 893eec2fc86d4c948fb8c70f765f14df | 101s | trusted_image_certificates | - | 101s | updated | 2025-05-22T19:22:20Z | 101s | user_id | 9be12b7a7a7444fdba023d067f039a4a | 101s +--------------------------------------------+--------------------------------------------------------------------------------------------------------------------------------------------------------+ 101s --------------------------------------------------- 101s 101s nova [W] Using flock in prodstack7-s390x 101s Creating nova instance adt-jammy-s390x-jool-20250522-190735-juju-7f2275-prod-proposed-migration-environment-2-a4c03e61-5e6b-44c3-a24c-54bbd4883f30 from image adt/ubuntu-jammy-s390x-server-20250522.img (UUID 0d0c5875-24ac-49ab-beaf-52b17b4cb70a)... 101s nova [W] Timed out waiting for a9b5499f-0da8-4bf8-9da5-6d93232e35d1 to get deleted. 101s Unexpected error: 101s Traceback (most recent call last): 101s File "/home/ubuntu/autopkgtest/lib/VirtSubproc.py", line 833, in mainloop 101s command() 101s File "/home/ubuntu/autopkgtest/lib/VirtSubproc.py", line 762, in command 101s r = f(c, ce) 101s File "/home/ubuntu/autopkgtest/lib/VirtSubproc.py", line 822, in cmd_auxverb_debug_fail 101s adtlog.info(caller.hook_debug_fail()) 101s File "/home/ubuntu/autopkgtest/lib/adtlog.py", line 82, in info 101s log(message, 1, timestamp=True, color=4) 101s File "/home/ubuntu/autopkgtest/lib/adtlog.py", line 70, in log 101s sys.stderr.buffer.flush() 101s BlockingIOError: [Errno 11] write could not complete without blocking 101s autopkgtest [19:23:27]: ERROR: testbed failure: sent `close', got `copy-failed', expected `ok...'