0s autopkgtest [23:44:04]: starting date and time: 2025-04-30 23:44:04+0000 0s autopkgtest [23:44:04]: git checkout: 9986aa8c Merge branch 'skia/fix_network_interface' into 'ubuntu/production' 0s autopkgtest [23:44:04]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.44f5d_t2/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:openldap --apt-upgrade bind9 --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=openldap/2.5.19+dfsg-0ubuntu0.22.04.1 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-cpu2-ram4-disk20-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@sto01-s390x-9.secgroup --name adt-jammy-s390x-bind9-20250430-232907-juju-7f2275-prod-proposed-migration-environment-15-dc4bd38f-afce-4ffc-abbe-74bf5fafac8d --image adt/ubuntu-jammy-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/ 73s autopkgtest [23:45:17]: testbed dpkg architecture: s390x 73s autopkgtest [23:45:17]: testbed apt version: 2.4.13 73s autopkgtest [23:45:17]: @@@@@@@@@@@@@@@@@@@@ test bed setup 73s autopkgtest [23:45:17]: testbed release detected to be: None 74s autopkgtest [23:45:18]: updating testbed package index (apt update) 74s Hit:1 http://ftpmaster.internal/ubuntu jammy InRelease 74s Hit:2 http://ftpmaster.internal/ubuntu jammy-updates InRelease 74s Hit:3 http://ftpmaster.internal/ubuntu jammy-security InRelease 74s Get:4 http://ftpmaster.internal/ubuntu jammy-proposed InRelease [279 kB] 74s Get:5 http://ftpmaster.internal/ubuntu jammy-proposed/main Sources [99.4 kB] 74s Get:6 http://ftpmaster.internal/ubuntu jammy-proposed/restricted Sources [26.0 kB] 75s Get:7 http://ftpmaster.internal/ubuntu jammy-proposed/multiverse Sources [4732 B] 75s Get:8 http://ftpmaster.internal/ubuntu jammy-proposed/universe Sources [29.0 kB] 75s Get:9 http://ftpmaster.internal/ubuntu jammy-proposed/main s390x Packages [165 kB] 75s Get:10 http://ftpmaster.internal/ubuntu jammy-proposed/main s390x c-n-f Metadata [2532 B] 75s Get:11 http://ftpmaster.internal/ubuntu jammy-proposed/restricted s390x Packages [2892 B] 75s Get:12 http://ftpmaster.internal/ubuntu jammy-proposed/restricted s390x c-n-f Metadata [116 B] 75s Get:13 http://ftpmaster.internal/ubuntu jammy-proposed/universe s390x Packages [46.3 kB] 75s Get:14 http://ftpmaster.internal/ubuntu jammy-proposed/universe s390x c-n-f Metadata [1996 B] 75s Get:15 http://ftpmaster.internal/ubuntu jammy-proposed/multiverse s390x c-n-f Metadata [116 B] 79s Fetched 657 kB in 1s (734 kB/s) 80s Reading package lists... 80s autopkgtest [23:45:24]: upgrading testbed (apt dist-upgrade and autopurge) 81s Reading package lists... 81s Building dependency tree... 81s Reading state information... 81s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 81s Starting 2 pkgProblemResolver with broken count: 0 81s Done 81s Entering ResolveByKeep 81s 81s The following packages will be upgraded: 81s distro-info-data ethtool libarchive13 libldap-2.5-0 libldap-common libxml2 81s openssh-client openssh-server openssh-sftp-server ubuntu-advantage-tools 81s ubuntu-pro-client ubuntu-pro-client-l10n 81s 12 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 81s Need to get 3030 kB of archives. 81s After this operation, 105 kB of additional disk space will be used. 81s Get:1 http://ftpmaster.internal/ubuntu jammy-updates/main s390x openssh-sftp-server s390x 1:8.9p1-3ubuntu0.13 [36.5 kB] 81s Get:2 http://ftpmaster.internal/ubuntu jammy-updates/main s390x openssh-server s390x 1:8.9p1-3ubuntu0.13 [406 kB] 81s Get:3 http://ftpmaster.internal/ubuntu jammy-updates/main s390x openssh-client s390x 1:8.9p1-3ubuntu0.13 [843 kB] 82s Get:4 http://ftpmaster.internal/ubuntu jammy-updates/main s390x distro-info-data all 0.52ubuntu0.9 [5336 B] 82s Get:5 http://ftpmaster.internal/ubuntu jammy-updates/main s390x libxml2 s390x 2.9.13+dfsg-1ubuntu0.7 [713 kB] 82s Get:6 http://ftpmaster.internal/ubuntu jammy-updates/main s390x ubuntu-pro-client-l10n s390x 35.1ubuntu0~22.04 [20.6 kB] 82s Get:7 http://ftpmaster.internal/ubuntu jammy-updates/main s390x ubuntu-pro-client s390x 35.1ubuntu0~22.04 [235 kB] 82s Get:8 http://ftpmaster.internal/ubuntu jammy-updates/main s390x ubuntu-advantage-tools all 35.1ubuntu0~22.04 [10.9 kB] 82s Get:9 http://ftpmaster.internal/ubuntu jammy-updates/main s390x ethtool s390x 1:5.16-1ubuntu0.2 [198 kB] 82s Get:10 http://ftpmaster.internal/ubuntu jammy-updates/main s390x libarchive13 s390x 3.6.0-1ubuntu1.4 [367 kB] 82s Get:11 http://ftpmaster.internal/ubuntu jammy-proposed/main s390x libldap-2.5-0 s390x 2.5.19+dfsg-0ubuntu0.22.04.1 [178 kB] 82s Get:12 http://ftpmaster.internal/ubuntu jammy-proposed/main s390x libldap-common all 2.5.19+dfsg-0ubuntu0.22.04.1 [16.1 kB] 82s Preconfiguring packages ... 82s Fetched 3030 kB in 0s (10.6 MB/s) 82s (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 ... 73073 files and directories currently installed.) 82s Preparing to unpack .../00-openssh-sftp-server_1%3a8.9p1-3ubuntu0.13_s390x.deb ... 82s Unpacking openssh-sftp-server (1:8.9p1-3ubuntu0.13) over (1:8.9p1-3ubuntu0.11) ... 82s Preparing to unpack .../01-openssh-server_1%3a8.9p1-3ubuntu0.13_s390x.deb ... 82s Unpacking openssh-server (1:8.9p1-3ubuntu0.13) over (1:8.9p1-3ubuntu0.11) ... 82s Preparing to unpack .../02-openssh-client_1%3a8.9p1-3ubuntu0.13_s390x.deb ... 82s Unpacking openssh-client (1:8.9p1-3ubuntu0.13) over (1:8.9p1-3ubuntu0.11) ... 83s Preparing to unpack .../03-distro-info-data_0.52ubuntu0.9_all.deb ... 83s Unpacking distro-info-data (0.52ubuntu0.9) over (0.52ubuntu0.8) ... 83s Preparing to unpack .../04-libxml2_2.9.13+dfsg-1ubuntu0.7_s390x.deb ... 83s Unpacking libxml2:s390x (2.9.13+dfsg-1ubuntu0.7) over (2.9.13+dfsg-1ubuntu0.6) ... 83s Preparing to unpack .../05-ubuntu-pro-client-l10n_35.1ubuntu0~22.04_s390x.deb ... 83s Unpacking ubuntu-pro-client-l10n (35.1ubuntu0~22.04) over (34~22.04) ... 83s Preparing to unpack .../06-ubuntu-pro-client_35.1ubuntu0~22.04_s390x.deb ... 83s Unpacking ubuntu-pro-client (35.1ubuntu0~22.04) over (34~22.04) ... 83s Preparing to unpack .../07-ubuntu-advantage-tools_35.1ubuntu0~22.04_all.deb ... 83s Unpacking ubuntu-advantage-tools (35.1ubuntu0~22.04) over (34~22.04) ... 84s Preparing to unpack .../08-ethtool_1%3a5.16-1ubuntu0.2_s390x.deb ... 84s Unpacking ethtool (1:5.16-1ubuntu0.2) over (1:5.16-1ubuntu0.1) ... 84s Preparing to unpack .../09-libarchive13_3.6.0-1ubuntu1.4_s390x.deb ... 84s Unpacking libarchive13:s390x (3.6.0-1ubuntu1.4) over (3.6.0-1ubuntu1.3) ... 84s Preparing to unpack .../10-libldap-2.5-0_2.5.19+dfsg-0ubuntu0.22.04.1_s390x.deb ... 84s Unpacking libldap-2.5-0:s390x (2.5.19+dfsg-0ubuntu0.22.04.1) over (2.5.18+dfsg-0ubuntu0.22.04.3) ... 84s Preparing to unpack .../11-libldap-common_2.5.19+dfsg-0ubuntu0.22.04.1_all.deb ... 84s Unpacking libldap-common (2.5.19+dfsg-0ubuntu0.22.04.1) over (2.5.18+dfsg-0ubuntu0.22.04.3) ... 84s Setting up distro-info-data (0.52ubuntu0.9) ... 84s Setting up openssh-client (1:8.9p1-3ubuntu0.13) ... 84s Setting up libldap-common (2.5.19+dfsg-0ubuntu0.22.04.1) ... 84s Setting up libldap-2.5-0:s390x (2.5.19+dfsg-0ubuntu0.22.04.1) ... 84s Setting up libxml2:s390x (2.9.13+dfsg-1ubuntu0.7) ... 84s Setting up ubuntu-pro-client (35.1ubuntu0~22.04) ... 84s Installing new version of config file /etc/apparmor.d/ubuntu_pro_apt_news ... 84s Installing new version of config file /etc/apt/apt.conf.d/20apt-esm-hook.conf ... 87s Setting up ethtool (1:5.16-1ubuntu0.2) ... 87s Setting up ubuntu-pro-client-l10n (35.1ubuntu0~22.04) ... 87s Setting up openssh-sftp-server (1:8.9p1-3ubuntu0.13) ... 87s Setting up openssh-server (1:8.9p1-3ubuntu0.13) ... 88s rescue-ssh.target is a disabled or a static unit not running, not starting it. 88s ssh.socket is a disabled or a static unit not running, not starting it. 88s Setting up libarchive13:s390x (3.6.0-1ubuntu1.4) ... 88s Setting up ubuntu-advantage-tools (35.1ubuntu0~22.04) ... 89s Processing triggers for ufw (0.36.1-4ubuntu0.1) ... 89s Processing triggers for man-db (2.10.2-1) ... 89s Processing triggers for libc-bin (2.35-0ubuntu3.9) ... 90s Reading package lists... 90s Building dependency tree... 90s Reading state information... 90s Starting pkgProblemResolver with broken count: 0 90s Starting 2 pkgProblemResolver with broken count: 0 90s Done 90s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 90s autopkgtest [23:45:34]: rebooting testbed after setup commands that affected boot 94s autopkgtest-virt-ssh [23:45:38]: copydown destination failed, status 255 98s autopkgtest-virt-ssh [23:45:42]: ------- nova console-log 1ffc7f5c-996d-41f9-8738-193862194ecf (adt-jammy-s390x-bind9-20250430-232907-juju-7f2275-prod-proposed-migration-environment-15-dc4bd38f-afce-4ffc-abbe-74bf5fafac8d) ------ 98s LOADPARM=[ ] 98s Using virtio-blk. 98s Using SCSI scheme. 98s ........ 98s [ 0.211413] Linux version 5.15.0-138-generic (buildd@bos03-s390x-037) (gcc (Ubuntu 11.4.0-1ubuntu1~22.04) 11.4.0, GNU ld (GNU Binutils for Ubuntu) 2.38) #148-Ubuntu SMP Fri Mar 14 19:03:02 UTC 2025 (Ubuntu 5.15.0-138.148-generic 5.15.178) 98s [ 0.211418] setup: Linux is running under KVM in 64-bit mode 98s [ 0.268329] setup: Relocating AMODE31 section of size 0x00003000 98s [ 0.268341] setup: The maximum memory size is 4096MB 98s [ 0.268421] cpu: 2 configured CPUs, 0 standby CPUs 98s [ 0.268647] Write protected kernel read-only data: 18844k 98s [ 0.268744] Zone ranges: 98s [ 0.268746] DMA [mem 0x0000000000000000-0x000000007fffffff] 98s [ 0.268750] Normal [mem 0x0000000080000000-0x00000000ffffffff] 98s [ 0.268787] Movable zone start for each node 98s [ 0.268789] Early memory node ranges 98s [ 0.268790] node 0: [mem 0x0000000000000000-0x00000000ffffffff] 98s [ 0.268794] Initmem setup node 0 [mem 0x0000000000000000-0x00000000ffffffff] 98s [ 0.465714] percpu: Embedded 33 pages/cpu s94976 r8192 d32000 u135168 98s [ 0.465751] Built 1 zonelists, mobility grouping on. Total pages: 1032192 98s [ 0.465754] Policy zone: Normal 98s [ 0.465755] Kernel command line: root=LABEL=cloudimg-rootfs 98s [ 0.467817] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) 98s [ 0.468943] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) 98s [ 0.468981] mem auto-init: stack:off, heap alloc:on, heap free:off 98s [ 0.759627] Memory: 4074580K/4194304K available (12052K kernel code, 3216K rwdata, 6792K rodata, 5216K init, 1252K bss, 119724K reserved, 0K cma-reserved) 98s [ 0.785862] SLUB: HWalign=256, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 98s [ 0.787078] ftrace: allocating 34263 entries in 134 pages 98s [ 0.802815] ftrace: allocated 134 pages with 3 groups 98s [ 0.805420] rcu: Hierarchical RCU implementation. 98s [ 0.805422] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. 98s [ 0.805424] Rude variant of Tasks RCU enabled. 98s [ 0.805425] Tracing variant of Tasks RCU enabled. 98s [ 0.805426] rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies. 98s [ 0.805427] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 98s [ 0.832062] NR_IRQS: 3, nr_irqs: 3, preallocated irqs: 3 98s [ 0.832113] clocksource: tod: mask: 0xffffffffffffffff max_cycles: 0x3b0a9be803b0a9, max_idle_ns: 1805497147909793 ns 98s [ 0.832838] random: crng init done 98s [ 0.832862] Console: colour dummy device 80x25 98s [ 0.832948] printk: console [ttysclp0] enabled 98s [ 0.832993] pid_max: default: 32768 minimum: 301 98s [ 0.833013] LSM: Security Framework initializing 98s [ 0.833021] landlock: Up and running. 98s [ 0.833022] Yama: becoming mindful. 98s [ 0.833057] AppArmor: AppArmor initialized 98s [ 0.833092] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) 98s [ 0.833117] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) 98s [ 0.833635] rcu: Hierarchical SRCU implementation. 98s [ 0.833818] smp: Bringing up secondary CPUs ... 98s [ 0.834052] smp: Brought up 1 node, 2 CPUs 98s [ 0.834756] devtmpfs: initialized 98s [ 0.834991] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns 98s [ 0.835059] futex hash table entries: 512 (order: 5, 131072 bytes, linear) 98s [ 0.835234] NET: Registered PF_NETLINK/PF_ROUTE protocol family 98s [ 0.835292] audit: initializing netlink subsys (disabled) 98s [ 0.835354] audit: type=2000 audit(1746056794.787:1): state=initialized audit_enabled=0 res=1 98s [ 0.835407] Spectre V2 mitigation: etokens 98s [ 0.836393] HugeTLB registered 1.00 MiB page size, pre-allocated 0 pages 98s [ 0.838097] iommu: Default domain type: Translated 98s [ 0.838099] iommu: DMA domain TLB invalidation policy: strict mode 98s [ 0.838164] SCSI subsystem initialized 98s [ 0.838277] NetLabel: Initializing 98s [ 0.838277] NetLabel: domain hash size = 128 98s [ 0.838278] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO 98s [ 0.838320] NetLabel: unlabeled traffic allowed by default 98s [ 0.850175] VFS: Disk quotas dquot_6.6.0 98s [ 0.850184] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) 98s [ 0.850272] AppArmor: AppArmor Filesystem Enabled 98s [ 0.855711] NET: Registered PF_INET protocol family 98s [ 0.855913] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) 98s [ 0.856445] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) 98s [ 0.856543] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) 98s [ 0.856639] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) 98s [ 0.856843] TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) 98s [ 0.856880] TCP: Hash tables configured (established 32768 bind 32768) 98s [ 0.857004] MPTCP token hash table entries: 4096 (order: 4, 98304 bytes, linear) 98s [ 0.857037] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) 98s [ 0.857068] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) 98s [ 0.857089] NET: Registered PF_UNIX/PF_LOCAL protocol family 98s [ 0.857094] NET: Registered PF_XDP protocol family 98s [ 0.857360] Trying to unpack rootfs image as initramfs... 98s [ 0.870108] kvm-s390: SIE is not available 98s [ 0.870122] hypfs: The hardware system does not support hypfs 98s [ 0.870223] Initialise system trusted keyrings 98s [ 0.870228] Key type blacklist registered 98s [ 0.870261] workingset: timestamp_bits=45 max_order=20 bucket_order=0 98s [ 0.871144] zbud: loaded 98s [ 0.871345] squashfs: version 4.0 (2009/01/31) Phillip Lougher 98s [ 0.871441] fuse: init (API version 7.34) 98s [ 0.871559] integrity: Platform Keyring initialized 98s [ 0.890029] Key type asymmetric registered 98s [ 0.890031] Asymmetric key parser 'x509' registered 98s [ 0.890073] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) 98s [ 0.890089] io scheduler mq-deadline registered 98s [ 0.890309] hvc_iucv: The z/VM IUCV HVC device driver cannot be used without z/VM 98s [ 0.891521] loop: module loaded 98s [ 0.891573] tun: Universal TUN/TAP device driver, 1.6 98s [ 0.891590] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. 98s [ 0.891607] device-mapper: uevent: version 1.0.3 98s [ 0.891626] device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com 98s [ 0.891647] drop_monitor: Initializing network drop monitor service 98s [ 0.891744] NET: Registered PF_INET6 protocol family 98s [ 1.087068] Freeing initrd memory: 18516K 98s [ 1.090357] Segment Routing with IPv6 98s [ 1.090370] In-situ OAM (IOAM) with IPv6 98s [ 1.090395] NET: Registered PF_PACKET protocol family 98s [ 1.090430] Key type dns_resolver registered 98s [ 1.090479] cio: Channel measurement facility initialized using format extended (mode autodetected) 98s [ 1.090589] sclp_sd: Store Data request failed (eq=2, di=3, response=0x40f0, flags=0x00, status=0, rc=-5) 98s [ 1.090720] registered taskstats version 1 98s [ 1.091705] Loading compiled-in X.509 certificates 98s [ 1.092593] Loaded X.509 cert 'Build time autogenerated kernel key: 219af449bf893fdddc7ba637bb6f32b2d67b0d15' 98s [ 1.093390] Loaded X.509 cert 'Canonical Ltd. Live Patch Signing: 14df34d1a87cf37625abec039ef2bf521249b969' 98s [ 1.094205] Loaded X.509 cert 'Canonical Ltd. Kernel Module Signing: 88f752e560a1e0737e31163a466ad7b70a850c19' 98s [ 1.094206] blacklist: Loading compiled-in revocation X.509 certificates 98s [ 1.094222] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing: 61482aa2830d0ab2ad5af10b7250da9033ddcef0' 98s [ 1.094234] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2017): 242ade75ac4a15e50d50c84b0d45ff3eae707a03' 98s [ 1.094246] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (ESM 2018): 365188c1d374d6b07c3c8f240f8ef722433d6a8b' 98s [ 1.094257] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2019): c0746fd6c5da3ae827864651ad66ae47fe24b3e8' 98s [ 1.094270] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v1): a8d54bbb3825cfb94fa13c9f8a594a195c107b8d' 98s [ 1.094282] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v2): 4cf046892d6fd3c9a5b03f98d845f90851dc6a8c' 98s [ 1.094293] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v3): 100437bb6de6e469b581e61cd66bce3ef4ed53af' 98s [ 1.094319] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (Ubuntu Core 2019): c1d57b8f6b743f23ee41f4f7ee292f06eecadfb9' 98s [ 1.094538] zswap: loaded using pool lzo/zbud 98s [ 1.094668] Key type .fscrypt registered 98s [ 1.094669] Key type fscrypt-provisioning registered 98s [ 1.096071] Key type encrypted registered 98s [ 1.096075] AppArmor: AppArmor sha1 policy hashing enabled 98s [ 1.096081] ima: No TPM chip found, activating TPM-bypass! 98s [ 1.096084] Loading compiled-in module X.509 certificates 98s [ 1.096895] Loaded X.509 cert 'Build time autogenerated kernel key: 219af449bf893fdddc7ba637bb6f32b2d67b0d15' 98s [ 1.096897] ima: Allocated hash algorithm: sha1 98s [ 1.096903] ima: No architecture policies found 98s [ 1.096909] evm: Initialising EVM extended attributes: 98s [ 1.096910] evm: security.selinux 98s [ 1.096911] evm: security.SMACK64 98s [ 1.096912] evm: security.SMACK64EXEC 98s [ 1.096913] evm: security.SMACK64TRANSMUTE 98s [ 1.096913] evm: security.SMACK64MMAP 98s [ 1.096914] evm: security.apparmor 98s [ 1.096915] evm: security.ima 98s [ 1.096915] evm: security.capability 98s [ 1.096916] evm: HMAC attrs: 0x1 98s [ 1.097786] Freeing unused kernel image (initmem) memory: 5216K 98s [ 1.097806] Write protected read-only-after-init data: 136k 98s [ 1.097926] Checked W+X mappings: passed, no unexpected W+X pages found 98s [ 1.097928] Run /init as init process 98s Loading, please wait... 98s Starting version 249.11-0ubuntu3.15 98s [ 1.137953] virtio_blk virtio0: [vda] 41943040 512-byte logical blocks (21.5 GB/20.0 GiB) 98s [ 1.138545] vda: vda1 98s [ 1.157577] virtio_net virtio1 enc1: renamed from eth0 98s Begin: Starting firmware auto-configuration ... done. 98s Begin: Loading essential drivers ... done. 98s Begin: Running /scripts/init-premount ... done. 98s Begin: Mounting root file system ... Begin: Running /scripts/local-top ... done. 98s Begin: Running /scripts/local-premount ... [ 1.540002] raid6: vx128x8 gen() 12140 MB/s 98s [ 1.767885] raid6: vx128x8 xor() 13255 MB/s 98s [ 1.767889] raid6: using algorithm vx128x8 gen() 12140 MB/s 98s [ 1.767890] raid6: .... xor() 13255 MB/s, rmw enabled 98s [ 1.767891] raid6: using s390xc recovery algorithm 98s [ 1.772026] xor: automatically using best checksumming function xc 98s [ 1.858997] Btrfs loaded, crc32c=crc32c-vx, zoned=yes, fsverity=yes 98s Scanning for Btrfs filesystems 98s done. 98s Begin: Will now check root file system ... fsck from util-linux 2.37.2 98s [/usr/sbin/fsck.ext4 (1) -- /dev/vda1] fsck.ext4 -a -C0 /dev/vda1 98s cloudimg-rootfs: clean, 79688/2560000 files, 507217/5242619 blocks 98s done. 98s [ 1.885375] EXT4-fs (vda1): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. 98s done. 98s Begin: Running /scripts/local-bottom ... done. 98s Begin: Running /scripts/init-bottom ... done. 98s [ 1.967652] 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) 98s [ 1.967788] systemd[1]: Detected virtualization kvm. 98s [ 1.967790] systemd[1]: Detected architecture s390x. 98s 98s Welcome to [1mUbuntu 22.04.5 LTS[0m! 98s 98s [ 1.969424] systemd[1]: Hostname set to . 98s [ 2.000073] systemd[273]: /usr/lib/systemd/system-generators/s390-cpi-vars failed with exit status 1. 98s [ 2.040883] 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. 98s [ 2.082384] systemd[1]: Queued start job for default target Graphical Interface. 98s [ 2.082961] systemd[1]: Created slice Slice /system/modprobe. 98s [[0;32m OK [0m] Created slice [0;1;39mSlice /system/modprobe[0m. 98s [ 2.083149] systemd[1]: Created slice Slice /system/serial-getty. 98s [[0;32m OK [0m] Created slice [0;1;39mSlice /system/serial-getty[0m. 98s [ 2.083278] systemd[1]: Created slice User and Session Slice. 98s [[0;32m OK [0m] Created slice [0;1;39mUser and Session Slice[0m. 98s [ 2.083331] systemd[1]: Started Forward Password Requests to Wall Directory Watch. 98s [[0;32m OK [0m] Started [0;1;39mForward Password R���uests to Wall Directory Watch[0m. 98s [ 2.083440] systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. 98s [[0;32m OK [0m] Set up automount [0;1;39mArbitrary���s File System Automount Point[0m. 98s [ 2.083519] systemd[1]: Reached target Remote File Systems. 98s [[0;32m OK [0m] Reached target [0;1;39mRemote File Systems[0m. 98s [ 2.083545] systemd[1]: Reached target Slice Units. 98s [[0;32m OK [0m] Reached target [0;1;39mSlice Units[0m. 98s [ 2.083575] systemd[1]: Reached target Swaps. 98s [[0;32m OK [0m] Reached target [0;1;39mSwaps[0m. 98s [ 2.083607] systemd[1]: Reached target Local Verity Protected Volumes. 98s [[0;32m OK [0m] Reached target [0;1;39mLocal Verity Protected Volumes[0m. 98s [ 2.083679] systemd[1]: Listening on multipathd control socket. 98s [[0;32m OK [0m] Listening on [0;1;39mmultipathd control socket[0m. 98s [ 2.083739] systemd[1]: Listening on Syslog Socket. 98s [[0;32m OK [0m] Listening on [0;1;39mSyslog Socket[0m. 98s [ 2.083796] systemd[1]: Listening on fsck to fsckd communication Socket. 98s [[0;32m OK [0m] Listening on [0;1;39mfsck to fsckd communication Socket[0m. 98s [ 2.083837] systemd[1]: Listening on initctl Compatibility Named Pipe. 98s [[0;32m OK [0m] Listening on [0;1;39minitctl Compatibility Named Pipe[0m. 98s [ 2.083939] systemd[1]: Listening on Journal Audit Socket. 98s [[0;32m OK [0m] Listening on [0;1;39mJournal Audit Socket[0m. 98s [ 2.083997] systemd[1]: Listening on Journal Socket (/dev/log). 98s [[0;32m OK [0m] Listening on [0;1;39mJournal Socket (/dev/log)[0m. 98s [ 2.084075] systemd[1]: Listening on Journal Socket. 98s [[0;32m OK [0m] Listening on [0;1;39mJournal Socket[0m. 98s [ 2.084160] systemd[1]: Listening on Network Service Netlink Socket. 98s [[0;32m OK [0m] Listening on [0;1;39mNetwork Service Netlink Socket[0m. 98s [ 2.084228] systemd[1]: Listening on udev Control Socket. 98s [[0;32m OK [0m] Listening on [0;1;39mudev Control Socket[0m. 98s [ 2.084284] systemd[1]: Listening on udev Kernel Socket. 98s [[0;32m OK [0m] Listening on [0;1;39mudev Kernel Socket[0m. 98s [ 2.084640] systemd[1]: Mounting Huge Pages File System... 98s Mounting [0;1;39mHuge Pages File System[0m... 98s [ 2.085041] systemd[1]: Mounting POSIX Message Queue File System... 98s Mounting [0;1;39mPOSIX Message Queue File System[0m... 98s [ 2.085490] systemd[1]: Mounting Kernel Debug File System... 98s Mounting [0;1;39mKernel Debug File System[0m... 98s [ 2.085928] systemd[1]: Mounting Kernel Trace File System... 98s Mounting [0;1;39mKernel Trace File System[0m... 98s [ 2.086706] systemd[1]: Starting Journal Service... 98s Starting [0;1;39mJournal Service[0m... 98s [ 2.087250] systemd[1]: Starting Set the console keyboard layout... 98s Starting [0;1;39mSet the console keyboard layout[0m... 98s [ 2.087803] systemd[1]: Starting Create List of Static Device Nodes... 98s Starting [0;1;39mCreate List of Static Device Nodes[0m... 98s [ 2.087880] systemd[1]: Condition check resulted in LXD - agent being skipped. 98s [ 2.088360] systemd[1]: Starting Load Kernel Module configfs... 98s Starting [0;1;39mLoad Kernel Module configfs[0m... 98s [ 2.089663] systemd[1]: Starting Load Kernel Module drm... 98s Starting [0;1;39mLoad Kernel Module drm[0m... 98s [ 2.090058] systemd[1]: Starting Load Kernel Module efi_pstore... 98s Starting [0;1;39mLoad Kernel Module efi_pstore[0m... 98s [ 2.090442] systemd[1]: Starting Load Kernel Module fuse... 98s Starting [0;1;39mLoad Kernel Module fuse[0m... 98s [ 2.090490] systemd[1]: Condition check resulted in OpenVSwitch configuration for cleanup being skipped. 98s [ 2.090564] systemd[1]: Condition check resulted in File System Check on Root Device being skipped. 98s [ 2.092817] systemd[1]: Starting Load Kernel Modules... 98s Starting [0;1;39mLoad Kernel Modules[0m... 98s [ 2.093182] systemd[1]: Starting Remount Root and Kernel File Systems... 98s Starting [0;1;39mRemount Root and Kernel File Systems[0m... 98s [ 2.093559] systemd[1]: Starting Coldplug All udev Devices... 98s Starting [0;1;39mColdplug All udev Devices[0m... 98s [ 2.094326] systemd[1]: Mounted Huge Pages File System. 98s [[0;32m OK [0m] Mounted [0;1;39mHuge Pages File System[0m. 98s [ 2.094389] systemd[1]: Mounted POSIX Message Queue File System. 98s [[0;32m OK [0m] Mounted [0;1;39mPOSIX Message Queue File System[0m. 98s [ 2.094441] systemd[1]: Mounted Kernel Debug File System. 98s [[0;32m OK [0m] Mounted [0;1;39mKernel Debug File System[0m. 98s [ 2.094486] systemd[1]: Mounted Kernel Trace File System. 98s [[0;32m OK [0m] Mounted [0;1;39mKernel Trace File System[0m. 98s [ 2.094633] systemd[1]: Finished Create List of Static Device Nodes. 98s [[0;32m OK [0m] Finished [0;1;39mCreate List of Static Device Nodes[0m. 98s [ 2.094799] systemd[1]: modprobe@configfs.service: Deactivated successfully. 98s [ 2.094891] systemd[1]: Finished Load Kernel Module configfs. 98s [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module configfs[0m. 98s [ 2.095021] systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. 98s [ 2.095108] systemd[1]: Finished Load Kernel Module efi_pstore. 98s [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module efi_pstore[0m. 98s [ 2.095241] systemd[1]: modprobe@fuse.service: Deactivated successfully. 98s [ 2.095327] systemd[1]: Finished Load Kernel Module fuse. 98s [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module fuse[0m. 98s [ 2.095723] systemd[1]: Mounting FUSE Control File System... 98s Mounting [0;1;39mFUSE Control File System[0m... 98s [ 2.096166] systemd[1]: Mounting Kernel Configuration File System... 98s Mounting [0;1;39mKernel Configuration File System[0m... 98s [ 2.098363] systemd[1]: Mounted Kernel Configuration File System. 98s [[0;32m OK [0m] Mounted [0;1;39mKernel Configuration File System[0m. 98s [ 2.098532] systemd[1]: Mounted FUSE Control File System. 98s [[0;32m OK [0m] Mounted [0;1;39mFUSE Control File System[0m. 98s [ 2.104794] systemd[1]: Finished Load Kernel Modules. 98s [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Modules[0m. 98s [ 2.105500] systemd[1]: Starting Apply Kernel Variables... 98s Starting [0;1;39mApply Kernel Variables[0m... 98s [ 2.105944] EXT4-fs (vda1): re-mounted. Opts: discard,errors=remount-ro. Quota mode: none. 98s [ 2.108697] systemd[1]: Finished Remount Root and Kernel File Systems. 98s [[0;32m OK [0m] Finished [0;1;39mRemount Root and Kernel File Systems[0m. 98s [ 2.110161] systemd[1]: Starting Cloud-init: Local Stage (pre-network)... 98s Starting [0;1;39mCloud-init: Local Stage (pre-network)[0m... 98s [ 2.110631] systemd[1]: Starting Device-Mapper Multipath Device Controller... 98s Starting [0;1;39mDevice-Mapper Multipath Device Controller[0m... 98s [ 2.110962] systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. 98s Starting [0;1;39mLoad/Save Random Seed[0m... 98s Starting [0;1;39mCreate System Users[0m... 98s [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module drm[0m. 98s [[0;32m OK [0m] Finished [0;1;39mColdplug All udev Devices[0m. 98s [[0;32m OK [0m] Finished [0;1;39mCreate System Users[0m. 98s [[0;32m OK [0m] Finished [0;1;39mApply Kernel Variables[0m. 98s Starting [0;1;39mCreate Static Device Nodes in /dev[0m... 98s [[0;32m OK [0m] Started [0;1;39mJournal Service[0m. 98s Starting [0;1;39mFlush Journal to Persistent Storage[0m... 98s [[0;32m OK [0m] Finished [0;1;39mCreate Static Device Nodes in /dev[0m. 98s Starting [0;1;39mRule-based Manage���for Device Events and Files[0m... 98s [[0;32m OK [0m] Finished [0;1;39mLoad/Save Random Seed[0m. 98s [[0;32m OK [0m] Finished [0;1;39mFlush Journal to Persistent Storage[0m. 98s [[0;32m OK [0m] Started [0;1;39mDevice-Mapper Multipath Device Controller[0m. 98s [[0;32m OK [0m] Started [0;1;39mRule-based Manager for Device Events and Files[0m. 98s [[0;32m OK [0m] Finished [0;1;39mSet the console keyboard layout[0m. 98s [[0;32m OK [0m] Reached target [0;1;39mPreparation for Local File Systems[0m. 98s [[0;32m OK [0m] Reached target [0;1;39mLocal File Systems[0m. 98s Starting [0;1;39mLoad AppArmor profiles[0m... 98s Starting [0;1;39mSet console font and keymap[0m... 98s Starting [0;1;39mTell Plymouth To Write Out Runtime Data[0m... 98s [[0;32m OK [0m] Started [0;1;39mDispatch Password ���ts to Console Directory Watch[0m. 98s [[0;32m OK [0m] Reached target [0;1;39mLocal Encrypted Volumes[0m. 98s Starting [0;1;39mSet Up Additional Binary Formats[0m... 98s Starting [0;1;39mCreate Volatile Files and Directories[0m... 98s Starting [0;1;39mUncomplicated firewall[0m... 98s [[0;32m OK [0m] Finished [0;1;39mSet console font and keymap[0m. 98s Mounting [0;1;39mArbitrary Executable File Formats File System[0m... 98s [[0;32m OK [0m] Finished [0;1;39mUncomplicated firewall[0m. 98s [[0;32m OK [0m] Finished [0;1;39mCreate Volatile Files and Directories[0m. 98s Starting [0;1;39mNetwork Time Synchronization[0m... 98s Starting [0;1;39mRecord System Boot/Shutdown in UTMP[0m... 98s [[0;32m OK [0m] Finished [0;1;39mTell Plymouth To Write Out Runtime Data[0m. 98s [[0;32m OK [0m] Mounted [0;1;39mArbitrary Executable File Formats File System[0m. 98s [[0;32m OK [0m] Finished [0;1;39mSet Up Additional Binary Formats[0m. 98s [[0;32m OK [0m] Finished [0;1;39mRecord System Boot/Shutdown in UTMP[0m. 98s [[0;32m OK [0m] Finished [0;1;39mLoad AppArmor profiles[0m. 98s [[0;32m OK [0m] Started [0;1;39mNetwork Time Synchronization[0m. 98s [[0;32m OK [0m] Reached target [0;1;39mSystem Time Set[0m. 98s [[0;32m OK [0m] Found device [0;1;39m/dev/ttysclp0[0m. 98s [ 2.600391] cloud-init[464]: Cloud-init v. 24.4.1-0ubuntu0~22.04.2 running 'init-local' at Wed, 30 Apr 2025 23:46:36 +0000. Up 2.58 seconds. 98s [[0;32m OK [0m] Finished [0;1;39mCloud-init: Local Stage (pre-network)[0m. 98s [[0;32m OK [0m] Reached target [0;1;39mPreparation for Network[0m. 98s Starting [0;1;39mNetwork Configuration[0m... 98s [[0;32m OK [0m] Started [0;1;39mNetwork Configuration[0m. 98s Starting [0;1;39mWait for Network to be Configured[0m... 98s Starting [0;1;39mNetwork Name Resolution[0m... 98s [[0;32m OK [0m] Started [0;1;39mNetwork Name Resolution[0m. 98s [[0;32m OK [0m] Reached target [0;1;39mNetwork[0m. 98s [[0;32m OK [0m] Reached target [0;1;39mHost and Network Name Lookups[0m. 98s [[0;32m OK [0m] Finished [0;1;39mWait for Network to be Configured[0m. 98s Starting [0;1;39mCloud-init: Network Stage[0m... 98s [ 6.004251] cloud-init[506]: Cloud-init v. 24.4.1-0ubuntu0~22.04.2 running 'init' at Wed, 30 Apr 2025 23:46:39 +0000. Up 5.98 seconds. 98s [ 6.008912] cloud-init[506]: ci-info: ++++++++++++++++++++++++++++++++++++++Net device info+++++++++++++++++++++++++++++++++++++++ 98s [ 6.008955] cloud-init[506]: ci-info: +--------+------+-----------------------------+---------------+--------+-------------------+ 98s [ 6.008994] cloud-init[506]: ci-info: | Device | Up | Address | Mask | Scope | Hw-Address | 98s [ 6.009026] cloud-init[506]: ci-info: +--------+------+-----------------------------+---------------+--------+-------------------+ 98s [ 6.009059] cloud-init[506]: ci-info: | enc1 | True | 10.151.37.90 | 255.255.255.0 | global | fa:16:3e:15:06:80 | 98s [ 6.009092] cloud-init[506]: ci-info: | enc1 | True | fe80::f816:3eff:fe15:680/64 | . | link | fa:16:3e:15:06:80 | 98s [ 6.009123] cloud-init[506]: ci-info: | lo | True | 127.0.0.1 | 255.0.0.0 | host | . | 98s [ 6.009156] cloud-init[506]: ci-info: | lo | True | ::1/128 | . | host | . | 98s [ 6.009188] cloud-init[506]: ci-info: +--------+------+-----------------------------+---------------+--------+-------------------+ 98s [ 6.009218] cloud-init[506]: ci-info: ++++++++++++++++++++++++++++++++Route IPv4 info++++++++++++++++++++++++++++++++ 98s [ 6.009252] cloud-init[506]: ci-info: +-------+-----------------+-------------+-----------------+-----------+-------+ 98s [ 6.009284] cloud-init[506]: ci-info: | Route | Destination | Gateway | Genmask | Interface | Flags | 98s [ 6.009319] cloud-init[506]: ci-info: +-------+-----------------+-------------+-----------------+-----------+-------+ 98s [ 6.009352] cloud-init[506]: ci-info: | 0 | 0.0.0.0 | 10.151.37.1 | 0.0.0.0 | enc1 | UG | 98s [ 6.009387] cloud-init[506]: ci-info: | 1 | 10.151.11.5 | 10.151.37.1 | 255.255.255.255 | enc1 | UGH | 98s [ 6.009421] cloud-init[506]: ci-info: | 2 | 10.151.11.6 | 10.151.37.1 | 255.255.255.255 | enc1 | UGH | 98s [ 6.009457] cloud-init[506]: ci-info: | 3 | 10.151.11.7 | 10.151.37.1 | 255.255.255.255 | enc1 | UGH | 98s [ 6.009492] cloud-init[506]: ci-info: | 4 | 10.151.37.0 | 0.0.0.0 | 255.255.255.0 | enc1 | U | 98s [ 6.009523] cloud-init[506]: ci-info: | 5 | 10.151.37.1 | 0.0.0.0 | 255.255.255.255 | enc1 | UH | 98s [ 6.009555] cloud-init[506]: ci-info: | 6 | 10.151.37.2 | 0.0.0.0 | 255.255.255.255 | enc1 | UH | 98s [ 6.009587] cloud-init[506]: ci-info: | 7 | 169.254.169.254 | 10.151.37.2 | 255.255.255.255 | enc1 | UGH | 98s [ 6.009623] cloud-init[506]: ci-info: +-------+-----------------+-------------+-----------------+-----------+-------+ 98s [ 6.009657] cloud-init[506]: ci-info: +++++++++++++++++++Route IPv6 info+++++++++++++++++++ 98s [ 6.009689] cloud-init[506]: ci-info: +-------+-------------+---------+-----------+-------+ 98s [ 6.009723] cloud-init[506]: ci-info: | Route | Destination | Gateway | Interface | Flags | 98s [ 6.009756] cloud-init[506]: ci-info: +-------+-------------+---------+-----------+-------+ 98s [ 6.009788] cloud-init[506]: ci-info: | 1 | fe80::/64 | :: | enc1 | U | 98s [ 6.009821] cloud-init[506]: ci-info: | 3 | local | :: | enc1 | U | 98s [ 6.009851] cloud-init[506]: ci-info: | 4 | multicast | :: | enc1 | U | 98s [ 6.009888] cloud-init[506]: ci-info: +-------+-------------+---------+-----------+-------+ 98s [ 6.063416] cloud-init[506]: 2025-04-30 23:46:40,019 - schema.py[WARNING]: cloud-config failed schema validation! You may run 'sudo cloud-init schema --system' to check the details. 98s [ 7.906334] cloud-init[506]: Generating public/private rsa key pair. 98s [ 7.906477] cloud-init[506]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key 98s [ 7.906520] cloud-init[506]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub 98s [ 7.906559] cloud-init[506]: The key fingerprint is: 98s [ 7.906594] cloud-init[506]: SHA256:Gx0H2bWGwUNh0uj6dc0Ht1pC+NYqYV7G7lILTwCP+SY root@autopkgtest 98s [ 7.906633] cloud-init[506]: The key's randomart image is: 98s [ 7.906672] cloud-init[506]: +---[RSA 3072]----+ 98s [ 7.906711] cloud-init[506]: | oB=o. | 98s [ 7.906749] cloud-init[506]: | .o+=o . | 98s [ 7.906787] cloud-init[506]: | .* +.o | 98s [ 7.906821] cloud-init[506]: | +.* o. .| 98s [ 7.906856] cloud-init[506]: | S.o = .=.| 98s [ 7.906892] cloud-init[506]: | .E *.X.++| 98s [ 7.906928] cloud-init[506]: | ..=.@.* .| 98s [ 7.906963] cloud-init[506]: | .+ * | 98s [ 7.906996] cloud-init[506]: | +. | 98s [ 7.907031] cloud-init[506]: +----[SHA256]-----+ 98s [ 7.907066] cloud-init[506]: Generating public/private ecdsa key pair. 98s [ 7.907102] cloud-init[506]: Your identification has been saved in /etc/ssh/ssh_host_ecdsa_key 98s [ 7.907134] cloud-init[506]: Your public key has been saved in /etc/ssh/ssh_host_ecdsa_key.pub 98s [ 7.907170] cloud-init[506]: The key fingerprint is: 98s [ 7.907205] cloud-init[506]: SHA256:/GEcJlwvbDM8zGGpHImIGwkht4MI4TOE5a550Ba7fSg root@autopkgtest 98s [ 7.907241] cloud-init[506]: The key's randomart image is: 98s [ 7.907273] cloud-init[506]: +---[ECDSA 256]---+ 98s [ 7.907311] cloud-init[506]: |B*oo . . .+. | 98s [ 7.907343] cloud-init[506]: |B++.. ..oB.o | 98s [ 7.907377] cloud-init[506]: |o+=o .oo& . | 98s [ 7.907409] cloud-init[506]: | o++ .o= * | 98s [ 7.907446] cloud-init[506]: |. = S + | 98s [ 7.907479] cloud-init[506]: | = o . o . | 98s [ 7.907513] cloud-init[506]: |o E o . . | 98s [ 7.907548] cloud-init[506]: | . . . | 98s [ 7.907581] cloud-init[506]: | | 98s [ 7.907613] cloud-init[506]: +----[SHA256]-----+ 98s [ 7.907647] cloud-init[506]: Generating public/private ed25519 key pair. 98s [ 7.907684] cloud-init[506]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key 98s [ 7.907719] cloud-init[506]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub 98s [ 7.907754] cloud-init[506]: The key fingerprint is: 98s [ 7.907791] cloud-init[506]: SHA256:NXOnlhbQd5P0F8pY2PnfO6q5sxYyt0ABiVPrTEsp9Tk root@autopkgtest 98s [ 7.907826] cloud-init[506]: The key's randomart image is: 98s [ 7.907860] cloud-init[506]: +--[ED25519 256]--+ 98s [ 7.907898] cloud-init[506]: | o+o ..o.oo.| 98s [ 7.907933] cloud-init[506]: | o..+..o=ooo+| 98s [ 7.907969] cloud-init[506]: | ..= E=.o+o.+| 98s [ 7.908009] cloud-init[506]: | * .o.+ = ..| 98s [ 7.908041] cloud-init[506]: | +S = o| 98s [ 7.908076] cloud-init[506]: | + = o| 98s [ 7.908109] cloud-init[506]: | = o .| 98s [ 7.908143] cloud-init[506]: | +. o | 98s [ 7.908176] cloud-init[506]: | .==.. .| 98s [ 7.908210] cloud-init[506]: +----[SHA256]-----+ 98s [[0;32m OK [0m] Finished [0;1;39mCloud-init: Network Stage[0m. 98s [[0;32m OK [0m] Reached target [0;1;39mCloud-config availability[0m. 98s [[0;32m OK [0m] Reached target [0;1;39mNetwork is Online[0m. 98s [[0;32m OK [0m] Reached target [0;1;39mSystem Initialization[0m. 98s [[0;32m OK [0m] Started [0;1;39mDaily apt download activities[0m. 98s [[0;32m OK [0m] Started [0;1;39mDaily apt upgrade and clean activities[0m. 98s [[0;32m OK [0m] Started [0;1;39mDaily dpkg database backup timer[0m. 98s [[0;32m OK [0m] Started [0;1;39mPeriodic ext4 Onli���ata Check for All Filesystems[0m. 98s [[0;32m OK [0m] Started [0;1;39mDiscard unused blocks once a week[0m. 98s [[0;32m OK [0m] Started [0;1;39mDaily rotation of log files[0m. 98s [[0;32m OK [0m] Started [0;1;39mDaily man-db regeneration[0m. 98s [[0;32m OK [0m] Started [0;1;39mMessage of the Day[0m. 98s [[0;32m OK [0m] Started [0;1;39mDaily Cleanup of Temporary Directories[0m. 98s [[0;32m OK [0m] Reached target [0;1;39mPath Units[0m. 98s [[0;32m OK [0m] Reached target [0;1;39mTimer Units[0m. 98s [[0;32m OK [0m] Listening on [0;1;39mcloud-init hotplug hook socket[0m. 98s [[0;32m OK [0m] Listening on [0;1;39mD-Bus System Message Bus Socket[0m. 98s [[0;32m OK [0m] Listening on [0;1;39mUUID daemon activation socket[0m. 98s [[0;32m OK [0m] Reached target [0;1;39mSocket Units[0m. 98s [[0;32m OK [0m] Reached target [0;1;39mBasic System[0m. 98s Starting [0;1;39mLSB: automatic crash report generation[0m... 98s Starting [0;1;39mCloud-init: Config Stage[0m... 98s Starting [0;1;39mApply Control Program Identification (CPI)[0m... 98s [[0;32m OK [0m] Started [0;1;39mRegular background program processing daemon[0m. 98s [[0;32m OK [0m] Started [0;1;39mD-Bus System Message Bus[0m. 98s [[0;32m OK [0m] Started [0;1;39mSave initial kernel messages after boot[0m. 98s Starting [0;1;39mConfigure dump on panic for System z[0m... 98s Starting [0;1;39mRemove Stale Onli���t4 Metadata Check Snapshots[0m... 98s [[0;32m OK [0m] Started [0;1;39mirqbalance daemon[0m. 98s Starting [0;1;39mDispatcher daemon for systemd-networkd[0m... 98s Starting [0;1;39mPollinate to seed���udo random number generator[0m... 98s Starting [0;1;39mLSB: rng-tools (Debian variant)[0m... 98s Starting [0;1;39mSystem Logging Service[0m... 98s Starting [0;1;39mUser Login Management[0m... 98s Starting [0;1;39mPermit User Sessions[0m... 98s [[0;32m OK [0m] Finished [0;1;39mApply Control Program Identification (CPI)[0m. 98s [[0;32m OK [0m] Finished [0;1;39mConfigure dump on panic for System z[0m. 98s [[0;32m OK [0m] Finished [0;1;39mRemove Stale Onli���ext4 Metadata Check Snapshots[0m. 98s Starting [0;1;39mRotate log files[0m... 98s [[0;32m OK [0m] Started [0;1;39mSystem Logging Service[0m. 98s [[0;32m OK [0m] Finished [0;1;39mPermit User Sessions[0m. 98s [[0;32m OK [0m] Started [0;1;39mLSB: automatic crash report generation[0m. 98s Starting [0;1;39mHold until boot process finishes up[0m... 98s Starting [0;1;39mTerminate Plymouth Boot Screen[0m... 98s [[0;32m OK [0m] Started [0;1;39mLSB: rng-tools (Debian variant)[0m. 98s [[0;32m OK [0m] Finished [0;1;39mHold until boot process finishes up[0m. 98s [[0;32m OK [0m] Started [0;1;39mSerial Getty on ttysclp0[0m. 98s Starting [0;1;39mSet console scheme[0m... 98s [[0;32m OK [0m] Finished [0;1;39mSet console scheme[0m. 98s [[0;32m OK [0m] Created slice [0;1;39mSlice /system/getty[0m. 98s [[0;32m OK [0m] Started [0;1;39mGetty on tty1[0m. 98s [[0;32m OK [0m] Reached target [0;1;39mLogin Prompts[0m. 98s [[0;32m OK [0m] Finished [0;1;39mTerminate Plymouth Boot Screen[0m. 98s [[0;32m OK [0m] Finished [0;1;39mRotate log files[0m. 98s [[0;32m OK [0m] Started [0;1;39mUser Login Management[0m. 98s [[0;32m OK [0m] Started [0;1;39mDispatcher daemon for systemd-networkd[0m. 98s [ 8.326681] cloud-init[664]: Cloud-init v. 24.4.1-0ubuntu0~22.04.2 running 'modules:config' at Wed, 30 Apr 2025 23:46:42 +0000. Up 8.28 seconds. 98s [ 8.438223] cloud-init[664]: 2025-04-30 23:46:42,394 - 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. 98s [ 8.438368] cloud-init[664]: 2025-04-30 23:46:42,394 - 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. 98s [[0;32m OK [0m] Finished [0;1;39mCloud-init: Config Stage[0m. 98s 98s Ubuntu 22.04.5 LTS autopkgtest ttysclp0 98s 98s autopkgtest login: [ 17.288459] cloud-init[699]: Cloud-init v. 24.4.1-0ubuntu0~22.04.2 running 'modules:final' at Wed, 30 Apr 2025 23:46:51 +0000. Up 17.23 seconds. 98s [ 17.594863] cloud-init[699]: Hit:1 http://ftpmaster.internal/ubuntu jammy InRelease 98s [ 17.619590] cloud-init[699]: Get:2 http://ftpmaster.internal/ubuntu jammy-updates InRelease [128 kB] 98s [ 17.673881] cloud-init[699]: Get:3 http://ftpmaster.internal/ubuntu jammy-security InRelease [129 kB] 98s [ 18.060031] cloud-init[699]: Get:4 http://ftpmaster.internal/ubuntu jammy-updates/universe Sources [444 kB] 98s [ 18.178795] cloud-init[699]: Get:5 http://ftpmaster.internal/ubuntu jammy-updates/main Sources [546 kB] 98s [ 18.314027] cloud-init[699]: Get:6 http://ftpmaster.internal/ubuntu jammy-updates/restricted Sources [78.3 kB] 98s [ 18.492615] cloud-init[699]: Get:7 http://ftpmaster.internal/ubuntu jammy-updates/main s390x Packages [1024 kB] 98s [ 18.509365] cloud-init[699]: Get:8 http://ftpmaster.internal/ubuntu jammy-updates/universe s390x Packages [937 kB] 98s [ 18.703565] cloud-init[699]: Get:9 http://ftpmaster.internal/ubuntu jammy-security/restricted Sources [73.1 kB] 98s [ 18.703669] cloud-init[699]: Get:10 http://ftpmaster.internal/ubuntu jammy-security/main Sources [309 kB] 98s [ 18.708634] cloud-init[699]: Get:11 http://ftpmaster.internal/ubuntu jammy-security/universe Sources [291 kB] 98s [ 18.756404] cloud-init[699]: Get:12 http://ftpmaster.internal/ubuntu jammy-security/main s390x Packages [818 kB] 98s [ 18.867588] cloud-init[699]: Get:13 http://ftpmaster.internal/ubuntu jammy-security/universe s390x Packages [722 kB] 98s [ 21.250317] cloud-init[699]: Fetched 5499 kB in 3s (1770 kB/s) 98s [ 22.455241] cloud-init[699]: Reading package lists... 98s ci-info: ++++++++++++++++++++++++++++++++++++++++++++++++++++++Authorized keys from /home/ubuntu/.ssh/authorized_keys for user ubuntu+++++++++++++++++++++++++++++++++++++++++++++++++++++++ 98s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+-----------------------------------------------------------+ 98s ci-info: | Keytype | Fingerprint (sha256) | Options | Comment | 98s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+-----------------------------------------------------------+ 98s 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 | 98s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+-----------------------------------------------------------+ 98s <14>Apr 30 23:46:56 cloud-init: ############################################################# 98s <14>Apr 30 23:46:56 cloud-init: -----BEGIN SSH HOST KEY FINGERPRINTS----- 98s <14>Apr 30 23:46:56 cloud-init: 256 SHA256:/GEcJlwvbDM8zGGpHImIGwkht4MI4TOE5a550Ba7fSg root@autopkgtest (ECDSA) 98s <14>Apr 30 23:46:56 cloud-init: 256 SHA256:NXOnlhbQd5P0F8pY2PnfO6q5sxYyt0ABiVPrTEsp9Tk root@autopkgtest (ED25519) 98s <14>Apr 30 23:46:56 cloud-init: 3072 SHA256:Gx0H2bWGwUNh0uj6dc0Ht1pC+NYqYV7G7lILTwCP+SY root@autopkgtest (RSA) 98s <14>Apr 30 23:46:56 cloud-init: -----END SSH HOST KEY FINGERPRINTS----- 98s <14>Apr 30 23:46:56 cloud-init: ############################################################# 98s -----BEGIN SSH HOST KEY KEYS----- 98s ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBMfZjbYQ4rxYHiqLRDlc8qE+HYhLNGSGvgj1/Co1x1N/1Jj2px5BHQnRJLJAy5xAi35GaMvMQ8qWJQCoqhSAtMI= root@autopkgtest 98s ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDmTJn+kFNeG13Qhxzo6NwYdvBEqmW/cc6iu+YBnx1GL root@autopkgtest 98s ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDp0NJOrZ3ZGBudUYjzuIfuoLQUFDLRSKFTCBuynak8Sc2Y/milymVy83033hf4KQEbAi7VQeeArFLHHSPecDtRYk4xtqbwHPKeXTPU8Ru0r1Vh2QZcTTUu9V1Gn5omkgBVc3/amZSw1RMkSoV4ucUVg+pE3muNWN/KqesDdRWV9+F0OyVhcLoaU+ss8PpWFFVbrGaKxZBv9oEgTG+ZoOYSNXW3JjQXunvGNN8s5QCNl/rsRonuXKOaJmVE5TDh1dMqA5OsxYfMtYBenbSA51/YINapudowBtlJxelO3k0KtHfYcC0MHlvZUjZC4oeZh+1zwjGGJgZiJkSTGBPU59As06Bq8g2Wkh1t8fzjxi25Jf0b8nwpaFg7Bfgk06p58ou3GxuMZWwAD6O0d5dDBt49w76CWmbbaRMzYRbtFzH90wiU04L7rCbkoAoNPeMQfA5Y2/FbKjlmxZQMrDeFTYnPCzrBBQgLPbN5JhXUnJFXX+ViXQXzhGHDbDVcpN4zNfU= root@autopkgtest 98s -----END SSH HOST KEY KEYS----- 98s [ 22.582120] cloud-init[699]: Cloud-init v. 24.4.1-0ubuntu0~22.04.2 finished at Wed, 30 Apr 2025 23:46:56 +0000. Datasource DataSourceOpenStackLocal [net,ver=2]. Up 22.57 seconds 98s Starting [0;1;39mOnline ext4 Metad���a Check for All Filesystems[0m... 98s [[0;32m OK [0m] Finished [0;1;39mOnline ext4 Metadata Check for All Filesystems[0m. 98s Stopping [0;1;39mOpenBSD Secure Shell server[0m... 98s [[0;32m OK [0m] Stopped [0;1;39mOpenBSD Secure Shell server[0m. 98s Starting [0;1;39mOpenBSD Secure Shell server[0m... 98s [[0;32m OK [0m] Started [0;1;39mOpenBSD Secure Shell server[0m. 98s [[0;32m OK [0m] Started [0;1;39m/usr/bin/sh -c sleep 3; reboot[0m. 98s [[0;32m OK [0m] Started [0;1;39mSession 5 of User ubuntu[0m. 98s Stopping [0;1;39mSession 5 of User ubuntu[0m... 98s [[0;32m OK [0m] Removed slice [0;1;39mSlice /system/modprobe[0m. 98s [[0;32m OK [0m] Stopped target [0;1;39mCloud-init target[0m. 98s [[0;32m OK [0m] Stopped target [0;1;39mGraphical Interface[0m. 98s [[0;32m OK [0m] Stopped target [0;1;39mHost and Network Name Lookups[0m. 98s [[0;32m OK [0m] Stopped target [0;1;39mTimer Units[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mDaily apt upgrade and clean activities[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mDaily apt download activities[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mDaily dpkg database backup timer[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mPeriodic ext4 Onli���ata Check for All Filesystems[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mDiscard unused blocks once a week[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mDaily rotation of log files[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mDaily man-db regeneration[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mMessage of the Day[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mDaily Cleanup of Temporary Directories[0m. 98s [[0;32m OK [0m] Stopped target [0;1;39mSystem Time Set[0m. 98s [[0;32m OK [0m] Closed [0;1;39mcloud-init hotplug hook socket[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mCloud-init: Final Stage[0m. 98s [[0;32m OK [0m] Stopped target [0;1;39mMulti-User System[0m. 98s [[0;32m OK [0m] Stopped target [0;1;39mLogin Prompts[0m. 98s Stopping [0;1;39mLSB: automatic crash report generation[0m... 98s [[0;32m OK [0m] Stopped [0;1;39mCloud-init: Config Stage[0m. 98s [[0;32m OK [0m] Stopped target [0;1;39mCloud-config availability[0m. 98s [[0;32m OK [0m] Stopped target [0;1;39mNetwork is Online[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mApply Control Program Identification (CPI)[0m. 98s Stopping [0;1;39mRegular background program processing daemon[0m... 98s Stopping [0;1;39mConfigure dump on panic for System z[0m... 98s Stopping [0;1;39mGetty on tty1[0m... 98s Stopping [0;1;39mirqbalance daemon[0m... 98s Stopping [0;1;39mDispatcher daemon for systemd-networkd[0m... 98s Stopping [0;1;39mPackageKit Daemon[0m... 98s [[0;32m OK [0m] Stopped [0;1;39mTerminate Plymouth Boot Screen[0m. 98s Stopping [0;1;39mAuthorization Manager[0m... 98s Stopping [0;1;39mLSB: rng-tools (Debian variant)[0m... 98s Stopping [0;1;39mSystem Logging Service[0m... 98s Stopping [0;1;39m/usr/bin/sh -c sleep 3; reboot[0m... 98s Stopping [0;1;39mSerial Getty on ttysclp0[0m... 98s Stopping [0;1;39mOpenBSD Secure Shell server[0m... 98s Stopping [0;1;39mLoad/Save Random Seed[0m... 98s [[0;32m OK [0m] Stopped [0;1;39mRegular background program processing daemon[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mirqbalance daemon[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mDispatcher daemon for systemd-networkd[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mSystem Logging Service[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mGetty on tty1[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mUpdate APT News[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mUpdate the local ESM caches[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mOpenBSD Secure Shell server[0m. 98s [[0;32m OK [0m] Stopped [0;1;39m/usr/bin/sh -c sleep 3; reboot[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mConfigure dump on panic for System z[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mLoad/Save Random Seed[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mSession 5 of User ubuntu[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mLSB: automatic crash report generation[0m. 98s [[0;32m OK [0m] Removed slice [0;1;39mSlice /system/getty[0m. 98s Stopping [0;1;39mUser Login Management[0m... 98s Stopping [0;1;39mUser Manager for UID 1000[0m... 98s [[0;32m OK [0m] Stopped [0;1;39mPackageKit Daemon[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mLSB: rng-tools (Debian variant)[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mSerial Getty on ttysclp0[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mAuthorization Manager[0m. 98s [[0;32m OK [0m] Removed slice [0;1;39mSlice /system/serial-getty[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mHold until boot process finishes up[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mUser Manager for UID 1000[0m. 98s Stopping [0;1;39mUser Runtime Directory /run/user/1000[0m... 98s [[0;32m OK [0m] Unmounted [0;1;39m/run/user/1000[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mUser Runtime Directory /run/user/1000[0m. 98s [[0;32m OK [0m] Removed slice [0;1;39mUser Slice of UID 1000[0m. 98s Stopping [0;1;39mPermit User Sessions[0m... 98s [[0;32m OK [0m] Stopped [0;1;39mPermit User Sessions[0m. 98s [[0;32m OK [0m] Stopped target [0;1;39mNetwork[0m. 98s [[0;32m OK [0m] Stopped target [0;1;39mRemote File Systems[0m. 98s Stopping [0;1;39mNetwork Name Resolution[0m... 98s [[0;32m OK [0m] Stopped [0;1;39mUser Login Management[0m. 98s [[0;32m OK [0m] Stopped target [0;1;39mBasic System[0m. 98s [[0;32m OK [0m] Stopped target [0;1;39mPath Units[0m. 98s [[0;32m OK [0m] Stopped target [0;1;39mSlice Units[0m. 98s [[0;32m OK [0m] Removed slice [0;1;39mUser and Session Slice[0m. 98s [[0;32m OK [0m] Stopped target [0;1;39mSocket Units[0m. 98s [[0;32m OK [0m] Closed [0;1;39mSyslog Socket[0m. 98s [[0;32m OK [0m] Closed [0;1;39mUUID daemon activation socket[0m. 98s [[0;32m OK [0m] Stopped target [0;1;39mSystem Initialization[0m. 98s [[0;32m OK [0m] Stopped target [0;1;39mLocal Encrypted Volumes[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mDispatch Password ���ts to Console Directory Watch[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mForward Password R���uests to Wall Directory Watch[0m. 98s [[0;32m OK [0m] Stopped target [0;1;39mSwaps[0m. 98s [[0;32m OK [0m] Stopped target [0;1;39mLocal Verity Protected Volumes[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mCloud-init: Network Stage[0m. 98s Stopping [0;1;39mSet Up Additional Binary Formats[0m... 98s [[0;32m OK [0m] Stopped [0;1;39mWait for Network to be Configured[0m. 98s Stopping [0;1;39mNetwork Time Synchronization[0m... 98s Stopping [0;1;39mRecord System Boot/Shutdown in UTMP[0m... 98s [[0;32m OK [0m] Stopped [0;1;39mNetwork Name Resolution[0m. 98s Stopping [0;1;39mNetwork Configuration[0m... 98s [[0;32m OK [0m] Stopped [0;1;39mSet Up Additional Binary Formats[0m. 98s [[0;32m OK [0m] Unset automount [0;1;39mArbitrary ���s File System Automount Point[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mRecord System Boot/Shutdown in UTMP[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mNetwork Configuration[0m. 98s [[0;32m OK [0m] Stopped target [0;1;39mPreparation for Network[0m. 98s [[0;32m OK [0m] Closed [0;1;39mNetwork Service Netlink Socket[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mCloud-init: Local Stage (pre-network)[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mApply Kernel Variables[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mLoad Kernel Modules[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mNetwork Time Synchronization[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mCreate Volatile Files and Directories[0m. 98s [[0;32m OK [0m] Stopped target [0;1;39mLocal File Systems[0m. 98s Unmounting [0;1;39m/run/credentials/systemd-sysusers.service[0m... 98s [[0;32m OK [0m] Unmounted [0;1;39m/run/credentials/systemd-sysusers.service[0m. 98s [[0;32m OK [0m] Stopped target [0;1;39mPreparation for Local File Systems[0m. 98s [[0;32m OK [0m] Reached target [0;1;39mUnmount All Filesystems[0m. 98s Stopping [0;1;39mDevice-Mapper Multipath Device Controller[0m... 98s [[0;32m OK [0m] Stopped [0;1;39mCreate Static Device Nodes in /dev[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mCreate System Users[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mDevice-Mapper Multipath Device Controller[0m. 98s [[0;32m OK [0m] Stopped [0;1;39mRemount Root and Kernel File Systems[0m. 98s [[0;32m OK [0m] Reached target [0;1;39mSystem Shutdown[0m. 98s [[0;32m OK [0m] Reached target [0;1;39mLate Shutdown Services[0m. 98s [[0;32m OK [0m] Finished [0;1;39mSystem Reboot[0m. 98s [[0;32m OK [0m] Reached target [0;1;39mSystem Reboot[0m. 98s LOADPARM=[ ] 98s Using virtio-blk. 98s Using SCSI scheme. 98s ........ 98s [ 0.085475] Linux version 5.15.0-138-generic (buildd@bos03-s390x-037) (gcc (Ubuntu 11.4.0-1ubuntu1~22.04) 11.4.0, GNU ld (GNU Binutils for Ubuntu) 2.38) #148-Ubuntu SMP Fri Mar 14 19:03:02 UTC 2025 (Ubuntu 5.15.0-138.148-generic 5.15.178) 98s [ 0.085480] setup: Linux is running under KVM in 64-bit mode 98s [ 0.087539] setup: Relocating AMODE31 section of size 0x00003000 98s [ 0.087543] setup: The maximum memory size is 4096MB 98s [ 0.087569] cpu: 2 configured CPUs, 0 standby CPUs 98s [ 0.087664] Write protected kernel read-only data: 18844k 98s [ 0.087699] Zone ranges: 98s [ 0.087700] DMA [mem 0x0000000000000000-0x000000007fffffff] 98s [ 0.087704] Normal [mem 0x0000000080000000-0x00000000ffffffff] 98s [ 0.087707] Movable zone start for each node 98s [ 0.087708] Early memory node ranges 98s [ 0.087709] node 0: [mem 0x0000000000000000-0x00000000ffffffff] 98s [ 0.087712] Initmem setup node 0 [mem 0x0000000000000000-0x00000000ffffffff] 98s [ 0.117254] percpu: Embedded 33 pages/cpu s94976 r8192 d32000 u135168 98s [ 0.117273] Built 1 zonelists, mobility grouping on. Total pages: 1032192 98s [ 0.117275] Policy zone: Normal 98s [ 0.117276] Kernel command line: root=LABEL=cloudimg-rootfs 98s [ 0.117504] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) 98s [ 0.117626] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) 98s [ 0.117634] mem auto-init: stack:off, heap alloc:on, heap free:off 98s [ 0.295309] Memory: 4074580K/4194304K available (12052K kernel code, 3216K rwdata, 6792K rodata, 5216K init, 1252K bss, 119724K reserved, 0K cma-reserved) 98s [ 0.314462] SLUB: HWalign=256, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 98s [ 0.315353] ftrace: allocating 34263 entries in 134 pages 98s [ 0.330545] ftrace: allocated 134 pages with 3 groups 98s [ 0.332325] rcu: Hierarchical RCU implementation. 98s [ 0.332326] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. 98s [ 0.332327] Rude variant of Tasks RCU enabled. 98s [ 0.332328] Tracing variant of Tasks RCU enabled. 98s [ 0.332329] rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies. 98s [ 0.332330] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 98s [ 0.352287] NR_IRQS: 3, nr_irqs: 3, preallocated irqs: 3 98s [ 0.352322] clocksource: tod: mask: 0xffffffffffffffff max_cycles: 0x3b0a9be803b0a9, max_idle_ns: 1805497147909793 ns 98s [ 0.352865] random: crng init done 98s [ 0.352885] Console: colour dummy device 80x25 98s [ 0.352958] printk: console [ttysclp0] enabled 98s [ 0.352994] pid_max: default: 32768 minimum: 301 98s [ 0.353013] LSM: Security Framework initializing 98s [ 0.353020] landlock: Up and running. 98s [ 0.353021] Yama: becoming mindful. 98s [ 0.353037] AppArmor: AppArmor initialized 98s [ 0.353053] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) 98s [ 0.353060] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) 98s [ 0.353383] rcu: Hierarchical SRCU implementation. 98s [ 0.353518] smp: Bringing up secondary CPUs ... 98s [ 0.353673] smp: Brought up 1 node, 2 CPUs 98s [ 0.354161] devtmpfs: initialized 98s [ 0.354283] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns 98s [ 0.354295] futex hash table entries: 512 (order: 5, 131072 bytes, linear) 98s [ 0.354404] NET: Registered PF_NETLINK/PF_ROUTE protocol family 98s [ 0.354427] audit: initializing netlink subsys (disabled) 98s [ 0.354454] audit: type=2000 audit(1746056843.043:1): state=initialized audit_enabled=0 res=1 98s [ 0.354488] Spectre V2 mitigation: etokens 98s [ 0.355173] HugeTLB registered 1.00 MiB page size, pre-allocated 0 pages 98s [ 0.356224] iommu: Default domain type: Translated 98s [ 0.356226] iommu: DMA domain TLB invalidation policy: strict mode 98s [ 0.356272] SCSI subsystem initialized 98s [ 0.356361] NetLabel: Initializing 98s [ 0.356361] NetLabel: domain hash size = 128 98s [ 0.356362] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO 98s [ 0.356383] NetLabel: unlabeled traffic allowed by default 98s [ 0.365310] VFS: Disk quotas dquot_6.6.0 98s [ 0.365320] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) 98s [ 0.365380] AppArmor: AppArmor Filesystem Enabled 98s [ 0.366702] NET: Registered PF_INET protocol family 98s [ 0.366755] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) 98s [ 0.367264] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) 98s [ 0.367288] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) 98s [ 0.367311] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) 98s [ 0.367378] TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) 98s [ 0.367416] TCP: Hash tables configured (established 32768 bind 32768) 98s [ 0.367455] MPTCP token hash table entries: 4096 (order: 4, 98304 bytes, linear) 98s [ 0.367472] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) 98s [ 0.367483] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) 98s [ 0.367503] NET: Registered PF_UNIX/PF_LOCAL protocol family 98s [ 0.367507] NET: Registered PF_XDP protocol family 98s [ 0.367683] Trying to unpack rootfs image as initramfs... 98s [ 0.370112] kvm-s390: SIE is not available 98s [ 0.370132] hypfs: The hardware system does not support hypfs 98s [ 0.370252] Initialise system trusted keyrings 98s [ 0.370258] Key type blacklist registered 98s [ 0.370297] workingset: timestamp_bits=45 max_order=20 bucket_order=0 98s [ 0.371028] zbud: loaded 98s [ 0.371193] squashfs: version 4.0 (2009/01/31) Phillip Lougher 98s [ 0.380267] fuse: init (API version 7.34) 98s [ 0.380383] integrity: Platform Keyring initialized 98s [ 0.400067] Key type asymmetric registered 98s [ 0.400070] Asymmetric key parser 'x509' registered 98s [ 0.400083] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) 98s [ 0.400100] io scheduler mq-deadline registered 98s [ 0.400557] hvc_iucv: The z/VM IUCV HVC device driver cannot be used without z/VM 98s [ 0.403251] loop: module loaded 98s [ 0.403568] tun: Universal TUN/TAP device driver, 1.6 98s [ 0.403911] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. 98s [ 0.403927] device-mapper: uevent: version 1.0.3 98s [ 0.404274] device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com 98s [ 0.404281] drop_monitor: Initializing network drop monitor service 98s [ 0.404368] NET: Registered PF_INET6 protocol family 98s [ 0.506486] Freeing initrd memory: 18516K 98s [ 0.509184] Segment Routing with IPv6 98s [ 0.509192] In-situ OAM (IOAM) with IPv6 98s [ 0.509210] NET: Registered PF_PACKET protocol family 98s [ 0.509234] Key type dns_resolver registered 98s [ 0.509272] cio: Channel measurement facility initialized using format extended (mode autodetected) 98s [ 0.509356] sclp_sd: Store Data request failed (eq=2, di=3, response=0x40f0, flags=0x00, status=0, rc=-5) 98s [ 0.509447] registered taskstats version 1 98s [ 0.510399] Loading compiled-in X.509 certificates 98s [ 0.511269] Loaded X.509 cert 'Build time autogenerated kernel key: 219af449bf893fdddc7ba637bb6f32b2d67b0d15' 98s [ 0.512072] Loaded X.509 cert 'Canonical Ltd. Live Patch Signing: 14df34d1a87cf37625abec039ef2bf521249b969' 98s [ 0.512886] Loaded X.509 cert 'Canonical Ltd. Kernel Module Signing: 88f752e560a1e0737e31163a466ad7b70a850c19' 98s [ 0.512887] blacklist: Loading compiled-in revocation X.509 certificates 98s [ 0.512900] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing: 61482aa2830d0ab2ad5af10b7250da9033ddcef0' 98s [ 0.512911] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2017): 242ade75ac4a15e50d50c84b0d45ff3eae707a03' 98s [ 0.512924] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (ESM 2018): 365188c1d374d6b07c3c8f240f8ef722433d6a8b' 98s [ 0.512939] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2019): c0746fd6c5da3ae827864651ad66ae47fe24b3e8' 98s [ 0.512950] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v1): a8d54bbb3825cfb94fa13c9f8a594a195c107b8d' 98s [ 0.512961] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v2): 4cf046892d6fd3c9a5b03f98d845f90851dc6a8c' 98s [ 0.512973] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v3): 100437bb6de6e469b581e61cd66bce3ef4ed53af' 98s [ 0.512987] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (Ubuntu Core 2019): c1d57b8f6b743f23ee41f4f7ee292f06eecadfb9' 98s [ 0.513057] zswap: loaded using pool lzo/zbud 98s [ 0.513137] Key type .fscrypt registered 98s [ 0.513138] Key type fscrypt-provisioning registered 98s [ 0.514373] Key type encrypted registered 98s [ 0.514375] AppArmor: AppArmor sha1 policy hashing enabled 98s [ 0.514379] ima: No TPM chip found, activating TPM-bypass! 98s [ 0.514381] Loading compiled-in module X.509 certificates 98s [ 0.515175] Loaded X.509 cert 'Build time autogenerated kernel key: 219af449bf893fdddc7ba637bb6f32b2d67b0d15' 98s [ 0.515177] ima: Allocated hash algorithm: sha1 98s [ 0.515181] ima: No architecture policies found 98s [ 0.515189] evm: Initialising EVM extended attributes: 98s [ 0.515190] evm: security.selinux 98s [ 0.515190] evm: security.SMACK64 98s [ 0.515191] evm: security.SMACK64EXEC 98s [ 0.515192] evm: security.SMACK64TRANSMUTE 98s [ 0.515193] evm: security.SMACK64MMAP 98s [ 0.515193] evm: security.apparmor 98s [ 0.515194] evm: security.ima 98s [ 0.515195] evm: security.capability 98s [ 0.515195] evm: HMAC attrs: 0x1 98s [ 0.516014] Freeing unused kernel image (initmem) memory: 5216K 98s [ 0.516035] Write protected read-only-after-init data: 136k 98s [ 0.516156] Checked W+X mappings: passed, no unexpected W+X pages found 98s [ 0.516159] Run /init as init process 98s Loading, please wait... 98s Starting version 249.11-0ubuntu3.15 98s [ 0.571429] virtio_net virtio1 enc1: renamed from eth0 98s [ 0.573628] virtio_blk virtio0: [vda] 41943040 512-byte logical blocks (21.5 GB/20.0 GiB) 98s [ 0.574073] vda: vda1 98s Begin: Starting firmware auto-configuration ... done. 98s 98s --------------------------------------------------- 98s ------- nova show 1ffc7f5c-996d-41f9-8738-193862194ecf (adt-jammy-s390x-bind9-20250430-232907-juju-7f2275-prod-proposed-migration-environment-15-dc4bd38f-afce-4ffc-abbe-74bf5fafac8d) ------ 98s +--------------------------------------------+--------------------------------------------------------------------------------------------------------------------------------------------------------+ 98s | Property | Value | 98s +--------------------------------------------+--------------------------------------------------------------------------------------------------------------------------------------------------------+ 98s | OS-DCF:diskConfig | MANUAL | 98s | OS-EXT-AZ:availability_zone | AZ3 | 98s | OS-EXT-SRV-ATTR:host | ps7-ra10-s390x-n3.ps7.canonical.com | 98s | OS-EXT-SRV-ATTR:hostname | adt-jammy-s390x-bind9-20250430-232907-juju-7f2275-prod-proposed | 98s | OS-EXT-SRV-ATTR:hypervisor_hostname | ps7-ra10-s390x-n3.ps7.canonical.com | 98s | OS-EXT-SRV-ATTR:instance_name | instance-0002bdf4 | 98s | OS-EXT-SRV-ATTR:kernel_id | | 98s | OS-EXT-SRV-ATTR:launch_index | 0 | 98s | OS-EXT-SRV-ATTR:ramdisk_id | | 98s | OS-EXT-SRV-ATTR:reservation_id | r-nx75xgyk | 98s | OS-EXT-SRV-ATTR:root_device_name | /dev/vda | 98s | OS-EXT-STS:power_state | 1 | 98s | OS-EXT-STS:task_state | - | 98s | OS-EXT-STS:vm_state | active | 98s | OS-SRV-USG:launched_at | 2025-04-30T23:44:50.000000 | 98s | OS-SRV-USG:terminated_at | - | 98s | accessIPv4 | | 98s | accessIPv6 | | 98s | config_drive | | 98s | created | 2025-04-30T23:44:45Z | 98s | description | - | 98s | flavor:disk | 20 | 98s | flavor:ephemeral | 0 | 98s | flavor:extra_specs | {"aggregate_instance_extra_specs:commit": "s390x", "hw:cpu_policy": "shared", "hw:mem_page_size": "large", "hw:pci_numa_affinity_policy": "preferred"} | 98s | flavor:original_name | autopkgtest-cpu2-ram4-disk20-s390x | 98s | flavor:ram | 4096 | 98s | flavor:swap | 0 | 98s | flavor:vcpus | 2 | 98s | hostId | 649f4f6956d4820f21e2de08c83c4fe30e814ddf05c8f73e11c623db | 98s | id | 1ffc7f5c-996d-41f9-8738-193862194ecf | 98s | image | adt/ubuntu-jammy-s390x-server-20250422.img (370cb0a5-ee1b-49b1-886e-5c2c6f797ab7) | 98s | key_name | testbed-juju-7f2275-prod-proposed-migration-environment-15 | 98s | locked | False | 98s | locked_reason | - | 98s | metadata | {} | 123s | name | adt-jammy-s390x-bind9-20250430-232907-juju-7f2275-prod-proposed-migration-environment-15-dc4bd38f-afce-4ffc-abbe-74bf5fafac8d | 123s | net_prod-autopkgtest-workers-s390x network | 10.151.37.90 | 123s | os-extended-volumes:volumes_attached | [] | 123s | progress | 0 | 123s | security_groups | autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@sto01-s390x-9.secgroup | 123s | server_groups | [] | 123s | status | ACTIVE | 123s | tags | [] | 123s | tenant_id | 893eec2fc86d4c948fb8c70f765f14df | 123s | trusted_image_certificates | - | 123s | updated | 2025-04-30T23:44:50Z | 123s | user_id | 9be12b7a7a7444fdba023d067f039a4a | 123s +--------------------------------------------+--------------------------------------------------------------------------------------------------------------------------------------------------------+ 123s --------------------------------------------------- 123s 123s nova [W] Using flock in prodstack7-s390x 123s Creating nova instance adt-jammy-s390x-bind9-20250430-232907-juju-7f2275-prod-proposed-migration-environment-15-dc4bd38f-afce-4ffc-abbe-74bf5fafac8d from image adt/ubuntu-jammy-s390x-server-20250422.img (UUID 370cb0a5-ee1b-49b1-886e-5c2c6f797ab7)... 123s nova [W] Timed out waiting for 1ffc7f5c-996d-41f9-8738-193862194ecf to get deleted. 123s Unexpected error: 123s Traceback (most recent call last): 123s File "/home/ubuntu/autopkgtest/lib/VirtSubproc.py", line 833, in mainloop 123s command() 123s File "/home/ubuntu/autopkgtest/lib/VirtSubproc.py", line 762, in command 123s r = f(c, ce) 123s File "/home/ubuntu/autopkgtest/lib/VirtSubproc.py", line 822, in cmd_auxverb_debug_fail 123s adtlog.info(caller.hook_debug_fail()) 123s File "/home/ubuntu/autopkgtest/lib/adtlog.py", line 82, in info 123s log(message, 1, timestamp=True, color=4) 123s File "/home/ubuntu/autopkgtest/lib/adtlog.py", line 70, in log 123s sys.stderr.buffer.flush() 123s BlockingIOError: [Errno 11] write could not complete without blocking 123s autopkgtest [23:46:07]: ERROR: testbed failure: sent `auxverb_debug_fail', got `copy-failed', expected `ok...'