10s autopkgtest [08:34:48]: starting date and time: 2024-08-10 08:34:48+0000 10s autopkgtest [08:34:48]: git checkout: fd3bed09 nova: allow more retries for quota issues 10s autopkgtest [08:34:48]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.rod9j_r6/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:e2fsprogs --apt-upgrade openssh --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=e2fsprogs/1.47.0-2.4~exp1ubuntu4.1' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-s390x-16.secgroup --name adt-noble-s390x-openssh-20240810-075350-juju-7f2275-prod-proposed-migration-environment-2-b34d2e9b-8488-440f-8f23-365443517c38 --image adt/ubuntu-noble-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration-s390x -e TERM=linux -e ''"'"'http_proxy=http://squid.internal:3128'"'"'' -e ''"'"'https_proxy=http://squid.internal:3128'"'"'' -e ''"'"'no_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 598s nova [W] Using flock in prodstack6-s390x 598s Creating nova instance adt-noble-s390x-openssh-20240810-075350-juju-7f2275-prod-proposed-migration-environment-2-b34d2e9b-8488-440f-8f23-365443517c38 from image adt/ubuntu-noble-s390x-server-20240713.img (UUID 920ef23d-06ec-432b-945e-a14b2b94e2bd)... 598s nova [E] Timed out waiting for ssh. Aborting! Console log: 598s ------- nova console-log 25f673fe-51fc-4028-89cf-56306b38885d (adt-noble-s390x-openssh-20240810-075350-juju-7f2275-prod-proposed-migration-environment-2-b34d2e9b-8488-440f-8f23-365443517c38) ------ 598s LOADPARM=[ ] 598s Using virtio-blk. 598s Using SCSI scheme. 598s .......... 598s [ 0.135870] Linux version 6.8.0-38-generic (buildd@bos02-s390x-012) (s390x-linux-gnu-gcc-13 (Ubuntu 13.2.0-23ubuntu4) 13.2.0, GNU ld (GNU Binutils for Ubuntu) 2.42) #38-Ubuntu SMP Fri Jun 7 14:30:57 UTC 2024 (Ubuntu 6.8.0-38.38-generic 6.8.8) 598s [ 0.135872] setup: Linux is running under KVM in 64-bit mode 598s [ 0.138958] setup: The maximum memory size is 4096MB 598s [ 0.138960] setup: Relocating AMODE31 section of size 0x00003000 598s [ 0.139022] cpu: 2 configured CPUs, 0 standby CPUs 598s [ 0.139073] Write protected kernel read-only data: 22736k 598s [ 0.139087] Zone ranges: 598s [ 0.139087] DMA [mem 0x0000000000000000-0x000000007fffffff] 598s [ 0.139090] Normal [mem 0x0000000080000000-0x00000000ffffffff] 598s [ 0.139092] Movable zone start for each node 598s [ 0.139093] Early memory node ranges 598s [ 0.139093] node 0: [mem 0x0000000000000000-0x00000000ffffffff] 598s [ 0.139095] Initmem setup node 0 [mem 0x0000000000000000-0x00000000ffffffff] 598s [ 0.170738] percpu: Embedded 52 pages/cpu s88832 r8192 d115968 u212992 598s [ 0.170754] Kernel command line: root=LABEL=cloudimg-rootfs 598s [ 0.171173] random: crng init done 598s [ 0.172498] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) 598s [ 0.173158] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) 598s [ 0.173167] Fallback order for Node 0: 0 598s [ 0.173169] Built 1 zonelists, mobility grouping on. Total pages: 1032192 598s [ 0.173170] Policy zone: Normal 598s [ 0.173171] mem auto-init: stack:all(zero), heap alloc:on, heap free:off 598s [ 0.253820] Memory: 4070172K/4194304K available (15076K kernel code, 3616K rwdata, 7660K rodata, 6532K init, 1064K bss, 124132K reserved, 0K cma-reserved) 598s [ 0.254508] SLUB: HWalign=256, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 598s [ 0.254516] ftrace: allocating 38864 entries in 152 pages 598s [ 0.269630] ftrace: allocated 152 pages with 3 groups 598s [ 0.269849] rcu: Hierarchical RCU implementation. 598s [ 0.269849] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. 598s [ 0.269850] Rude variant of Tasks RCU enabled. 598s [ 0.269851] Tracing variant of Tasks RCU enabled. 598s [ 0.269851] rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies. 598s [ 0.269851] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 598s [ 0.273607] NR_IRQS: 3, nr_irqs: 3, preallocated irqs: 3 598s [ 0.273619] rcu: srcu_init: Setting srcu_struct sizes based on contention. 598s [ 0.273638] clocksource: tod: mask: 0xffffffffffffffff max_cycles: 0x3b0a9be803b0a9, max_idle_ns: 1805497147909793 ns 598s [ 0.273849] Console: colour dummy device 80x25 598s [ 0.273886] printk: legacy console [ttysclp0] enabled 598s [ 0.273932] pid_max: default: 32768 minimum: 301 598s [ 0.273964] LSM: initializing lsm=lockdown,capability,landlock,yama,apparmor,integrity 598s [ 0.273978] landlock: Up and running. 598s [ 0.273979] Yama: becoming mindful. 598s [ 0.274042] AppArmor: AppArmor initialized 598s [ 0.274087] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) 598s [ 0.274111] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) 598s [ 0.274608] RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1. 598s [ 0.274637] RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1. 598s [ 0.274680] rcu: Hierarchical SRCU implementation. 598s [ 0.274681] rcu: Max phase no-delay instances is 1000. 598s [ 0.274813] smp: Bringing up secondary CPUs ... 598s [ 0.275039] smp: Brought up 1 node, 2 CPUs 598s [ 0.275374] devtmpfs: initialized 598s [ 0.275597] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns 598s [ 0.275642] futex hash table entries: 512 (order: 5, 131072 bytes, linear) 598s [ 0.275852] NET: Registered PF_NETLINK/PF_ROUTE protocol family 598s [ 0.275894] audit: initializing netlink subsys (disabled) 598s [ 0.275950] audit: type=2000 audit(1723279059.281:1): state=initialized audit_enabled=0 res=1 598s [ 0.275989] Spectre V2 mitigation: etokens 598s [ 0.282872] HugeTLB: registered 1.00 MiB page size, pre-allocated 0 pages 598s [ 0.282874] HugeTLB: 12 KiB vmemmap can be freed for a 1.00 MiB page 598s [ 0.283235] iommu: Default domain type: Translated 598s [ 0.283236] iommu: DMA domain TLB invalidation policy: strict mode 598s [ 0.283294] SCSI subsystem initialized 598s [ 0.283304] pps_core: LinuxPPS API ver. 1 registered 598s [ 0.283305] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti 598s [ 0.283706] NetLabel: Initializing 598s [ 0.283707] NetLabel: domain hash size = 128 598s [ 0.283708] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO 598s [ 0.283721] NetLabel: unlabeled traffic allowed by default 598s [ 0.287152] VFS: Disk quotas dquot_6.6.0 598s [ 0.287160] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) 598s [ 0.287247] AppArmor: AppArmor Filesystem Enabled 598s [ 0.288903] NET: Registered PF_INET protocol family 598s [ 0.289094] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) 598s [ 0.298285] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) 598s [ 0.298299] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) 598s [ 0.298311] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) 598s [ 0.298372] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) 598s [ 0.298418] TCP: Hash tables configured (established 32768 bind 32768) 598s [ 0.298448] MPTCP token hash table entries: 4096 (order: 4, 98304 bytes, linear) 598s [ 0.298459] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) 598s [ 0.298471] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) 598s [ 0.298494] NET: Registered PF_UNIX/PF_LOCAL protocol family 598s [ 0.298498] NET: Registered PF_XDP protocol family 598s [ 0.298619] Key type cert_store_key registered 598s [ 0.298657] Trying to unpack rootfs image as initramfs... 598s [ 0.310020] kvm-s390: SIE is not available 598s [ 0.310038] hypfs: The hardware system does not support hypfs 598s [ 0.310145] Initialise system trusted keyrings 598s [ 0.310149] Key type blacklist registered 598s [ 0.310176] workingset: timestamp_bits=45 max_order=20 bucket_order=0 598s [ 0.310181] zbud: loaded 598s [ 0.310405] squashfs: version 4.0 (2009/01/31) Phillip Lougher 598s [ 0.310477] fuse: init (API version 7.39) 598s [ 0.310549] integrity: Platform Keyring initialized 598s [ 0.319791] Key type asymmetric registered 598s [ 0.319792] Asymmetric key parser 'x509' registered 598s [ 0.319804] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) 598s [ 0.330042] io scheduler mq-deadline registered 598s [ 0.330384] hvc_iucv: The z/VM IUCV HVC device driver cannot be used without z/VM 598s [ 0.331477] loop: module loaded 598s [ 0.331633] tun: Universal TUN/TAP device driver, 1.6 598s [ 0.331655] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. 598s [ 0.331660] device-mapper: uevent: version 1.0.3 598s [ 0.331690] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com 598s [ 0.331896] cio: Channel measurement facility initialized using format extended (mode autodetected) 598s [ 0.332086] drop_monitor: Initializing network drop monitor service 598s [ 0.332174] NET: Registered PF_INET6 protocol family 598s [ 0.332244] sclp_sd: Store Data request failed (eq=2, di=3, response=0x40f0, flags=0x00, status=0, rc=-5) 598s [ 0.333278] virtio_blk virtio1: 1/0/0 default/read/poll queues 598s [ 0.334330] virtio_blk virtio1: [vda] 41943040 512-byte logical blocks (21.5 GB/20.0 GiB) 598s [ 0.335104] vda: vda1 598s [ 0.360683] Freeing initrd memory: 17292K 598s [ 0.363763] Segment Routing with IPv6 598s [ 0.363769] In-situ OAM (IOAM) with IPv6 598s [ 0.363785] NET: Registered PF_PACKET protocol family 598s [ 0.363806] Key type dns_resolver registered 598s [ 0.364588] registered taskstats version 1 598s [ 0.364680] Loading compiled-in X.509 certificates 598s [ 0.365482] Loaded X.509 cert 'Build time autogenerated kernel key: f6aa641e5e1077928d0349b6d83e21865034f5e7' 598s [ 0.366211] Loaded X.509 cert 'Canonical Ltd. Live Patch Signing: 14df34d1a87cf37625abec039ef2bf521249b969' 598s [ 0.366964] Loaded X.509 cert 'Canonical Ltd. Kernel Module Signing: 88f752e560a1e0737e31163a466ad7b70a850c19' 598s [ 0.366966] blacklist: Loading compiled-in revocation X.509 certificates 598s [ 0.366983] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing: 61482aa2830d0ab2ad5af10b7250da9033ddcef0' 598s [ 0.366996] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2017): 242ade75ac4a15e50d50c84b0d45ff3eae707a03' 598s [ 0.367007] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (ESM 2018): 365188c1d374d6b07c3c8f240f8ef722433d6a8b' 598s [ 0.367018] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2019): c0746fd6c5da3ae827864651ad66ae47fe24b3e8' 598s [ 0.367029] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v1): a8d54bbb3825cfb94fa13c9f8a594a195c107b8d' 598s [ 0.367040] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v2): 4cf046892d6fd3c9a5b03f98d845f90851dc6a8c' 598s [ 0.367053] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v3): 100437bb6de6e469b581e61cd66bce3ef4ed53af' 598s [ 0.367068] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (Ubuntu Core 2019): c1d57b8f6b743f23ee41f4f7ee292f06eecadfb9' 598s [ 0.369941] Key type .fscrypt registered 598s [ 0.369942] Key type fscrypt-provisioning registered 598s [ 0.376789] Key type encrypted registered 598s [ 0.376791] AppArmor: AppArmor sha256 policy hashing enabled 598s [ 0.376798] ima: No TPM chip found, activating TPM-bypass! 598s [ 0.376801] Loading compiled-in module X.509 certificates 598s [ 0.377524] Loaded X.509 cert 'Build time autogenerated kernel key: f6aa641e5e1077928d0349b6d83e21865034f5e7' 598s [ 0.377526] ima: Allocated hash algorithm: sha256 598s [ 0.377533] ima: No architecture policies found 598s [ 0.377538] evm: Initialising EVM extended attributes: 598s [ 0.377538] evm: security.selinux 598s [ 0.377539] evm: security.SMACK64 598s [ 0.377540] evm: security.SMACK64EXEC 598s [ 0.377541] evm: security.SMACK64TRANSMUTE 598s [ 0.377542] evm: security.SMACK64MMAP 598s [ 0.377542] evm: security.apparmor 598s [ 0.377543] evm: security.ima 598s [ 0.377544] evm: security.capability 598s [ 0.377544] evm: HMAC attrs: 0x1 598s [ 0.378670] Freeing unused kernel image (initmem) memory: 6532K 598s [ 0.378695] Write protected read-only-after-init data: 148k 598s [ 0.378831] Checked W+X mappings: passed, no unexpected W+X pages found 598s [ 0.378834] Run /init as init process 598s Loading, please wait... 598s Starting systemd-udevd version 255.4-1ubuntu8.1 598s [ 0.410763] virtio_net virtio0 enc1: renamed from eth0 598s Begin: Starting firmware auto-configuration ... done. 598s Begin: Loading essential drivers ... done. 598s Begin: Running /scripts/init-premount ... done. 598s Begin: Mounting root file system ... Begin: Running /scripts/local-top ... done. 598s Begin: Running /scripts/local-premount ... [ 1.810003] raid6: vx128x8 gen() 22167 MB/s 598s [ 1.810009] raid6: using algorithm vx128x8 gen() 22167 MB/s 598s [ 1.980001] raid6: .... xor() 15004 MB/s, rmw enabled 598s [ 1.980005] raid6: using s390xc recovery algorithm 598s [ 1.980990] xor: automatically using best checksumming function xc 598s [ 2.007191] Btrfs loaded, zoned=yes, fsverity=yes 598s Scanning for Btrfs filesystems 598s done. 598s Begin: Will now check root file system ... fsck from util-linux 2.39.3 598s [/usr/sbin/fsck.ext4 (1) -- /dev/vda1] fsck.ext4 -a -C0 /dev/vda1 598s cloudimg-rootfs: clean, 85699/2560000 files, 618255/5242619 blocks 598s done. 598s [ 2.024653] EXT4-fs (vda1): mounted filesystem 3a20b47e-d5d8-4abe-a992-c1cb771ee648 ro with ordered data mode. Quota mode: none. 598s done. 598s Begin: Running /scripts/local-bottom ... done. 598s Begin: Running /scripts/init-bottom ... done. 598s [ 2.094037] systemd[1]: systemd 255.4-1ubuntu8.1 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 +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) 598s [ 2.094042] systemd[1]: Detected virtualization kvm. 598s [ 2.094045] systemd[1]: Detected architecture s390x. 598s 598s Welcome to [1mUbuntu 24.04 LTS[0m! 598s 598s [ 2.094811] systemd[1]: Hostname set to . 598s [ 2.167381] (sd-exec-[238]: /usr/lib/systemd/system-generators/s390-cpi-vars failed with exit status 1. 598s [ 2.190468] systemd[1]: Configuration file /run/systemd/system/systemd-networkd-wait-online.service.d/10-netplan.conf is marked world-inaccessible. This has no effect as configuration data is accessible via APIs without restrictions. Proceeding anyway. 598s [ 2.192600] 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. 598s [ 2.250767] systemd[1]: Queued start job for default target graphical.target. 598s [ 2.300528] systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. 598s [[0;32m OK [0m] Created slice [0;1;39msystem-modprobe.slice[0m - Slice /system/modprobe. 598s [ 2.300781] systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. 598s [[0;32m OK [0m] Created slice [0;1;39msystem-serial\x2dget���slice[0m - Slice /system/serial-getty. 598s [ 2.300921] systemd[1]: Created slice user.slice - User and Session Slice. 598s [[0;32m OK [0m] Created slice [0;1;39muser.slice[0m - User and Session Slice. 598s [ 2.300973] systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. 598s [[0;32m OK [0m] Started [0;1;39msystemd-ask-password-wall.���[0md Requests to Wall Directory Watch. 598s [ 2.301093] systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. 598s [[0;32m OK [0m] Set up automount [0;1;39mproc-sys-fs-binfm���[0mormats File System Automount Point. 598s [ 2.301124] systemd[1]: Expecting device dev-ttysclp0.device - /dev/ttysclp0... 598s Expecting device [0;1;39mdev-ttysclp0.device[0m - /dev/ttysclp0... 598s [ 2.301161] systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. 598s [[0;32m OK [0m] Reached target [0;1;39mintegritysetup.targ���[0m Local Integrity Protected Volumes. 598s [ 2.301201] systemd[1]: Reached target remote-fs.target - Remote File Systems. 598s [[0;32m OK [0m] Reached target [0;1;39mremote-fs.target[0m - Remote File Systems. 598s [ 2.301224] systemd[1]: Reached target slices.target - Slice Units. 598s [[0;32m OK [0m] Reached target [0;1;39mslices.target[0m - Slice Units. 598s [ 2.301253] systemd[1]: Reached target swap.target - Swaps. 598s [[0;32m OK [0m] Reached target [0;1;39mswap.target[0m - Swaps. 598s [ 2.301284] systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. 598s [[0;32m OK [0m] Reached target [0;1;39mveritysetup.target[0m - Local Verity Protected Volumes. 598s [ 2.301376] systemd[1]: Listening on multipathd.socket - multipathd control socket. 598s [[0;32m OK [0m] Listening on [0;1;39mmultipathd.socket[0m - multipathd control socket. 598s [ 2.301449] systemd[1]: Listening on syslog.socket - Syslog Socket. 598s [[0;32m OK [0m] Listening on [0;1;39msyslog.socket[0m - Syslog Socket. 598s [ 2.301509] systemd[1]: Listening on systemd-fsckd.socket - fsck to fsckd communication Socket. 598s [[0;32m OK [0m] Listening on [0;1;39msystemd-fsckd.socket[0m ���fsck to fsckd communication Socket. 598s [ 2.301557] systemd[1]: Listening on systemd-initctl.socket - initctl Compatibility Named Pipe. 598s [[0;32m OK [0m] Listening on [0;1;39msystemd-initctl.socke���[0m- initctl Compatibility Named Pipe. 598s [ 2.301630] systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). 598s [[0;32m OK [0m] Listening on [0;1;39msystemd-journald-dev-���socket[0m - Journal Socket (/dev/log). 598s [ 2.301700] systemd[1]: Listening on systemd-journald.socket - Journal Socket. 598s [[0;32m OK [0m] Listening on [0;1;39msystemd-journald.socket[0m - Journal Socket. 598s [ 2.301797] systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. 598s [[0;32m OK [0m] Listening on [0;1;39msystemd-networkd.socket[0m - Network Service Netlink Socket. 598s [ 2.301878] systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. 598s [[0;32m OK [0m] Listening on [0;1;39msystemd-udevd-control.socket[0m - udev Control Socket. 598s [ 2.301940] systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. 598s [[0;32m OK [0m] Listening on [0;1;39msystemd-udevd-kernel.socket[0m - udev Kernel Socket. 598s [ 2.302487] systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... 598s Mounting [0;1;39mdev-hugepages.mount[0m - Huge Pages File System... 598s [ 2.304509] systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... 598s Mounting [0;1;39mdev-mqueue.mount[0m - POSIX Message Queue File System... 598s [ 2.304826] systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... 598s Mounting [0;1;39msys-kernel-debug.mount[0m - Kernel Debug File System... 598s [ 2.306591] systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... 598s Mounting [0;1;39msys-kernel-tracing.mount[0m - Kernel Trace File System... 598s [ 2.307161] systemd[1]: Starting keyboard-setup.service - Set the console keyboard layout... 598s Starting [0;1;39mkeyboard-setup.service[0m - Set the console keyboard layout... 598s [ 2.311970] systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... 598s Starting [0;1;39mkmod-static-nodes.service[0m���eate List of Static Device Nodes... 598s [ 2.312368] systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... 598s Starting [0;1;39mmodprobe@configfs.service[0m - Load Kernel Module configfs... 598s [ 2.313133] systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... 598s Starting [0;1;39mmodprobe@dm_mod.service[0m - Load Kernel Module dm_mod... 598s [ 2.313503] systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... 598s Starting [0;1;39mmodprobe@drm.service[0m - Load Kernel Module drm... 598s [ 2.318628] systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... 598s Starting [0;1;39mmodprobe@efi_pstore.servi���[0m - Load Kernel Module efi_pstore... 598s [ 2.320585] systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... 598s Starting [0;1;39mmodprobe@fuse.service[0m - Load Kernel Module fuse... 598s [ 2.323118] systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... 598s Starting [0;1;39mmodprobe@loop.service[0m - Load Kernel Module loop... 598s [ 2.323160] systemd[1]: netplan-ovs-cleanup.service - OpenVSwitch configuration for cleanup was skipped because of an unmet condition check (ConditionFileIsExecutable=/usr/bin/ovs-vsctl). 598s [ 2.323294] systemd[1]: systemd-fsck-root.service - File System Check on Root Device was skipped because of an unmet condition check (ConditionPathExists=!/run/initramfs/fsck-root). 598s [ 2.324475] systemd[1]: Starting systemd-journald.service - Journal Service... 598s Starting [0;1;39msystemd-journald.service[0m - Journal Service... 598s [ 2.329723] systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... 598s Starting [0;1;39msystemd-modules-load.service[0m - Load Kernel Modules... 598s [ 2.330106] systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... 598s Starting [0;1;39msystemd-remount-fs.servic���[0munt Root and Kernel File Systems... 598s [ 2.334487] systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... 598s Starting [0;1;39msystemd-udev-trigger.service[0m - Coldplug All udev Devices... 598s [ 2.335123] systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. 598s [[0;32m OK [0m] Mounted [0;1;39mdev-hugepages.mount[0m - Huge Pages File System. 598s [ 2.335199] systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. 598s [[0;32m OK [0m] Mounted [0;1;39mdev-mqueue.mount[0m - POSIX Message Queue File System. 598s [ 2.335262] systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. 598s [[0;32m OK [0m] Mounted [0;1;39msys-kernel-debug.mount[0m - Kernel Debug File System. 598s [ 2.335322] systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. 598s [[0;32m OK [0m] Mounted [0;1;39msys-kernel-tracing.mount[0m - Kernel Trace File System. 598s [ 2.335428] systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. 598s [[0;32m OK [0m] Finished [0;1;39mkmod-static-nodes.service[0m���Create List of Static Device Nodes. 598s [ 2.335594] systemd[1]: modprobe@configfs.service: Deactivated successfully. 598s [ 2.335658] systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. 598s [[0;32m OK [0m] Finished [0;1;39mmodprobe@configfs.service[0m - Load Kernel Module configfs. 598s [ 2.335793] systemd[1]: modprobe@dm_mod.service: Deactivated successfully. 598s [ 2.335850] systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. 598s [[0;32m OK [0m] Finished [0;1;39mmodprobe@dm_mod.service[0m - Load Kernel Module dm_mod. 598s [ 2.336526] systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. 598s [ 2.340208] systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. 598s [[0;32m OK [0m] Finished [0;1;39mmodprobe@efi_pstore.service[0m - Load Kernel Module efi_pstore. 598s [ 2.340351] systemd[1]: modprobe@fuse.service: Deactivated successfully. 598s [ 2.340410] systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. 598s [[0;32m OK [0m] Finished [0;1;39mmodprobe@fuse.service[0m - Load Kernel Module fuse. 598s [ 2.340543] systemd[1]: modprobe@loop.service: Deactivated successfully. 598s [ 2.340599] systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. 598s [[0;32m OK [0m] Finished [0;1;39mmodprobe@loop.service[0m - Load Kernel Module loop. 598s [ 2.347430] systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... 598s Mounting [0;1;39msys-fs-fuse-connections.mount[0m - FUSE Control File System... 598s [ 2.368366] systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... 598s Mounting [0;1;39msys-kernel-config.mount[0m - Kernel Configuration File System... 598s [ 2.368420] systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. 598s [ 2.370228] systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... 598s Starting [0;1;39msystemd-tmpfiles-setup-de���[0m Device Nodes in /dev gracefully... 598s [ 2.370638] systemd[1]: modprobe@drm.service: Deactivated successfully. 598s [ 2.370709] systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. 598s [[0;32m OK [0m] Finished [0;1;39mmodprobe@drm.service[0m - Load Kernel Module drm. 598s [ 2.370843] systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. 598s [[0;32m OK [0m] Finished [0;1;39msystemd-modules-load.service[0m - Load Kernel Modules. 598s [ 2.370952] systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. 598s [[0;32m OK [0m] Finished [0;1;39msystemd-udev-trigger.service[0m - Coldplug All udev Devices. 598s [ 2.372880] systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. 598s [[0;32m OK [0m] Mounted [0;1;39msys-fs-fuse-connections.mount[0m - FUSE Control File System. 598s [ 2.374186] systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... 598s Starting [0;1;39msystemd-sysctl.service[0m - Apply Kernel Variables... 598s [ 2.374470] systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. 598s [[0;32m OK [0m] Mounted [0;1;39msys-kernel-config.mount[0m - Kernel Configuration File System. 598s [ 2.374591] systemd-journald[290]: Collecting audit messages is disabled. 598s [ 2.378574] systemd[1]: Started systemd-journald.service - Journal Service. 598s [[0;32m OK [0m] Started [0;1;39msystemd-journald.service[0m - Journal Service. 598s [[0;32m OK [0m] Finished [0;1;39msystemd-sysctl.service[0m - Apply Kernel Variables. 598s [[0;32m OK [0m] Finished [0;1;39msystemd-tmpfiles-setup-de���[0mic Device Nodes in /dev gracefully. 598s [[0;32m OK [0m] Finished [0;1;39mkeyboard-setup.service[0m - Set the console keyboard layout. 598s [[0;32m OK [0m] Finished [0;1;39msystemd-remount-fs.servic���[0mmount Root and Kernel File Systems. 598s Starting [0;1;39mcloud-init-local.service[0m ��� cloud-init job (pre-networking)... 598s Starting [0;1;39mmultipathd.service[0m - Devi���pper Multipath Device Controller... 598s Starting [0;1;39msystemd-journal-flush.ser���[0msh Journal to Persistent Storage... 598s Starting [0;1;39msystemd-random-seed.service[0m - Load/Save OS Random Seed... 598s Starting [0;1;39msystemd-tmpfiles-setup-de���[0meate Static Device Nodes in /dev... 598s [[0;32m OK [0m] Finished [0;1;39msystemd-tmpfiles-setup-de���[0mCreate Static Device Nodes in /dev. 598s Starting [0;1;39msystemd-udevd.service[0m - R���ager for Device Events and Files... 598s [[0;32m OK [0m] Finished [0;1;39msystemd-journal-flush.ser���[0mlush Journal to Persistent Storage. 598s [[0;32m OK [0m] Started [0;1;39mmultipathd.service[0m - Devic���Mapper Multipath Device Controller. 598s [[0;32m OK [0m] Reached target [0;1;39mlocal-fs-pre.target[0m���Preparation for Local File Systems. 598s [[0;32m OK [0m] Reached target [0;1;39mlocal-fs.target[0m - Local File Systems. 598s [[0;32m OK [0m] Listening on [0;1;39msystemd-sysext.socket[0m���tension Image Management (Varlink). 598s Starting [0;1;39mapparmor.service[0m - Load AppArmor profiles... 598s Starting [0;1;39mconsole-setup.service[0m - Set console font and keymap... 598s Starting [0;1;39mplymouth-read-write.servi���[0mymouth To Write Out Runtime Data... 598s Starting [0;1;39msystemd-binfmt.service[0m - Set Up Additional Binary Formats... 598s Starting [0;1;39msystemd-tmpfiles-setup.se���[0me Volatile Files and Directories... 598s Starting [0;1;39mufw.service[0m - Uncomplicated firewall... 598s [[0;32m OK [0m] Finished [0;1;39msystemd-random-seed.service[0m - Load/Save OS Random Seed. 598s [[0;32m OK [0m] Finished [0;1;39mconsole-setup.service[0m - Set console font and keymap. 598s Mounting [0;1;39mproc-sys-fs-binfmt_misc.m���[0mcutable File Formats File System... 598s [[0;32m OK [0m] Finished [0;1;39mufw.service[0m - Uncomplicated firewall. 598s [[0;32m OK [0m] Finished [0;1;39mplymouth-read-write.servi���[0mPlymouth To Write Out Runtime Data. 598s [[0;32m OK [0m] Mounted [0;1;39mproc-sys-fs-binfmt_misc.mo���[0mxecutable File Formats File System. 598s [[0;32m OK [0m] Started [0;1;39msystemd-udevd.service[0m - Ru���anager for Device Events and Files. 598s [[0;32m OK [0m] Finished [0;1;39msystemd-binfmt.service[0m - Set Up Additional Binary Formats. 598s [[0;32m OK [0m] Started [0;1;39msystemd-ask-password-conso���[0mequests to Console Directory Watch. 598s [[0;32m OK [0m] Reached target [0;1;39mcryptsetup.target[0m - Local Encrypted Volumes. 598s [[0;32m OK [0m] Finished [0;1;39msystemd-tmpfiles-setup.se���[0mate Volatile Files and Directories. 598s Starting [0;1;39msystemd-resolved.service[0m - Network Name Resolution... 598s Starting [0;1;39msystemd-timesyncd.service[0m - Network Time Synchronization... 598s Starting [0;1;39msystemd-update-utmp.servi���[0mord System Boot/Shutdown in UTMP... 598s [[0;32m OK [0m] Finished [0;1;39msystemd-update-utmp.servi���[0mecord System Boot/Shutdown in UTMP. 598s [[0;32m OK [0m] Found device [0;1;39mdev-ttysclp0.device[0m - /dev/ttysclp0. 598s [[0;32m OK [0m] Started [0;1;39msystemd-timesyncd.service[0m - Network Time Synchronization. 598s [[0;32m OK [0m] Reached target [0;1;39mtime-set.target[0m - System Time Set. 598s [[0;32m OK [0m] Started [0;1;39msystemd-resolved.service[0m - Network Name Resolution. 598s [[0;32m OK [0m] Reached target [0;1;39mnss-lookup.target[0m - Host and Network Name Lookups. 598s [[0;32m OK [0m] Finished [0;1;39mapparmor.service[0m - Load AppArmor profiles. 598s [ 2.870054] cloud-init[537]: Cloud-init v. 24.1.3-0ubuntu3.3 running 'init-local' at Sat, 10 Aug 2024 08:37:41 +0000. Up 2.85 seconds. 598s [ 14.050394] cloud-init[537]: 2024-08-10 08:37:53,057 - url_helper.py[ERROR]: Timed out, no response from urls: ['http://[fe80::a9fe:a9fe]/openstack', 'http://169.254.169.254/openstack'] 598s [ 14.052649] cloud-init[537]: 2024-08-10 08:37:53,060 - util.py[WARNING]: No active metadata service found 598s [[0;32m OK [0m] Finished [0;1;39mcloud-init-local.service[0m ���al cloud-init job (pre-networking). 598s [[0;32m OK [0m] Reached target [0;1;39mnetwork-pre.target[0m - Preparation for Network. 598s Starting [0;1;39msystemd-networkd.service[0m - Network Configuration... 598s [[0;32m OK [0m] Started [0;1;39msystemd-networkd.service[0m - Network Configuration. 598s [[0;32m OK [0m] Reached target [0;1;39mnetwork.target[0m - Network. 598s Starting [0;1;39msystemd-networkd-wait-onl���[0mait for Network to be Configured... 598s [[0;32m OK [0m] Finished [0;1;39msystemd-networkd-wait-onl���[0m Wait for Network to be Configured. 598s Starting [0;1;39mcloud-init.service[0m - Init���t job (metadata service crawler)... 598s [ 15.903180] cloud-init[613]: Cloud-init v. 24.1.3-0ubuntu3.3 running 'init' at Sat, 10 Aug 2024 08:36:28 +0000. Up 15.89 seconds. 598s [ 15.907438] cloud-init[613]: ci-info: +++++++++++++++++++++++++++++++++++++++Net device info+++++++++++++++++++++++++++++++++++++++ 598s [ 15.907496] cloud-init[613]: ci-info: +--------+------+------------------------------+---------------+--------+-------------------+ 598s [ 15.907532] cloud-init[613]: ci-info: | Device | Up | Address | Mask | Scope | Hw-Address | 598s [ 15.907561] cloud-init[613]: ci-info: +--------+------+------------------------------+---------------+--------+-------------------+ 598s [ 15.907589] cloud-init[613]: ci-info: | enc1 | True | 10.145.232.18 | 255.255.255.0 | global | fa:16:3e:74:a8:7f | 598s [ 15.907619] cloud-init[613]: ci-info: | enc1 | True | fe80::f816:3eff:fe74:a87f/64 | . | link | fa:16:3e:74:a8:7f | 598s [ 15.907653] cloud-init[613]: ci-info: | lo | True | 127.0.0.1 | 255.0.0.0 | host | . | 598s [ 15.907681] cloud-init[613]: ci-info: | lo | True | ::1/128 | . | host | . | 598s [ 15.907710] cloud-init[613]: ci-info: +--------+------+------------------------------+---------------+--------+-------------------+ 598s [ 15.907736] cloud-init[613]: ci-info: ++++++++++++++++++++++++++++++++Route IPv4 info+++++++++++++++++++++++++++++++++ 598s [ 15.907765] cloud-init[613]: ci-info: +-------+-----------------+--------------+-----------------+-----------+-------+ 598s [ 15.907791] cloud-init[613]: ci-info: | Route | Destination | Gateway | Genmask | Interface | Flags | 598s [ 15.907818] cloud-init[613]: ci-info: +-------+-----------------+--------------+-----------------+-----------+-------+ 598s [ 15.907848] cloud-init[613]: ci-info: | 0 | 0.0.0.0 | 10.145.232.1 | 0.0.0.0 | enc1 | UG | 598s [ 15.907875] cloud-init[613]: ci-info: | 1 | 10.145.232.0 | 0.0.0.0 | 255.255.255.0 | enc1 | U | 598s [ 15.907902] cloud-init[613]: ci-info: | 2 | 10.145.232.1 | 0.0.0.0 | 255.255.255.255 | enc1 | UH | 598s [ 15.907931] cloud-init[613]: ci-info: | 3 | 10.145.232.2 | 0.0.0.0 | 255.255.255.255 | enc1 | UH | 598s [ 15.907956] cloud-init[613]: ci-info: | 4 | 91.189.91.131 | 10.145.232.1 | 255.255.255.255 | enc1 | UGH | 598s [ 15.907985] cloud-init[613]: ci-info: | 5 | 91.189.91.132 | 10.145.232.1 | 255.255.255.255 | enc1 | UGH | 598s [ 15.908012] cloud-init[613]: ci-info: | 6 | 169.254.169.254 | 10.145.232.2 | 255.255.255.255 | enc1 | UGH | 598s [ 15.908038] cloud-init[613]: ci-info: +-------+-----------------+--------------+-----------------+-----------+-------+ 598s [ 15.908066] cloud-init[613]: ci-info: +++++++++++++++++++Route IPv6 info+++++++++++++++++++ 598s [ 15.908093] cloud-init[613]: ci-info: +-------+-------------+---------+-----------+-------+ 598s [ 15.908119] cloud-init[613]: ci-info: | Route | Destination | Gateway | Interface | Flags | 598s [ 15.908146] cloud-init[613]: ci-info: +-------+-------------+---------+-----------+-------+ 598s [ 15.908173] cloud-init[613]: ci-info: | 0 | fe80::/64 | :: | enc1 | U | 598s [ 15.908202] cloud-init[613]: ci-info: | 2 | local | :: | enc1 | U | 598s [ 15.908229] cloud-init[613]: ci-info: | 3 | multicast | :: | enc1 | U | 598s [ 15.908256] cloud-init[613]: ci-info: +-------+-------------+---------+-----------+-------+ 598s [ 25.916307] cloud-init[613]: 2024-08-10 08:36:38,204 - url_helper.py[ERROR]: Timed out, no response from urls: ['http://[fe80::a9fe:a9fe]/openstack', 'http://169.254.169.254/openstack'] 598s [ 25.916483] cloud-init[613]: 2024-08-10 08:36:38,204 - util.py[WARNING]: No active metadata service found 598s [[0;32m OK [0m] Stopped [0;1;39msystemd-networkd-wait-onli���[0m Wait for Network to be Configured. 598s Stopping [0;1;39msystemd-networkd-wait-onl���[0mait for Network to be Configured... 598s Stopping [0;1;39msystemd-networkd.service[0m - Network Configuration... 598s [[0;32m OK [0m] Stopped [0;1;39msystemd-networkd.service[0m - Network Configuration. 598s Starting [0;1;39msystemd-networkd.service[0m - Network Configuration... 598s [[0;32m OK [0m] Started [0;1;39msystemd-networkd.service[0m - Network Configuration. 598s Starting [0;1;39msystemd-networkd-wait-onl���[0mait for Network to be Configured... 598s [ 26.440917] cloud-init[613]: 2024-08-10 08:36:38,729 - activators.py[WARNING]: Running ['netplan', 'apply'] resulted in stderr output: Failed to connect to system bus: No such file or directory 598s [ 26.440976] cloud-init[613]: Falling back to a hard restart of systemd-networkd.service 598s [[0;32m OK [0m] Finished [0;1;39msystemd-networkd-wait-onl���[0m Wait for Network to be Configured. 598s [ 27.308994] cloud-init[613]: Generating public/private rsa key pair. 598s [ 27.309128] cloud-init[613]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key 598s [ 27.309175] cloud-init[613]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub 598s [ 27.309216] cloud-init[613]: The key fingerprint is: 598s [ 27.309247] cloud-init[613]: SHA256:w6qYoRiOEqka4HAidLZmNmk153IkursdtoIzl1ubbU4 root@auto-syncubuntu-noble-24-04-s390x-server-20240710-disk1-img-ad 598s [ 27.309278] cloud-init[613]: The key's randomart image is: 598s [ 27.309311] cloud-init[613]: +---[RSA 3072]----+ 598s [ 27.309340] cloud-init[613]: | | 598s [ 27.309368] cloud-init[613]: | | 598s [ 27.309396] cloud-init[613]: | . o + o | 598s [ 27.309425] cloud-init[613]: |. o = *. | 598s [ 27.309453] cloud-init[613]: |=..X . oS | 598s [ 27.309480] cloud-init[613]: |Bo= o o. . | 598s [ 27.309509] cloud-init[613]: |+oo..+.E | 598s [ 27.309538] cloud-init[613]: |*B B=.B. | 598s [ 27.309566] cloud-init[613]: |B.*+==oo | 598s [ 27.309594] cloud-init[613]: +----[SHA256]-----+ 598s [ 27.309623] cloud-init[613]: Generating public/private ecdsa key pair. 598s [ 27.309651] cloud-init[613]: Your identification has been saved in /etc/ssh/ssh_host_ecdsa_key 598s [ 27.309679] cloud-init[613]: Your public key has been saved in /etc/ssh/ssh_host_ecdsa_key.pub 598s [ 27.309728] cloud-init[613]: The key fingerprint is: 598s [ 27.309759] cloud-init[613]: SHA256:oBVof9XSSTN6OwdNCD3eKxKviz2Aymintu7mybRAkw8 root@auto-syncubuntu-noble-24-04-s390x-server-20240710-disk1-img-ad 598s [ 27.309789] cloud-init[613]: The key's randomart image is: 598s [ 27.309817] cloud-init[613]: +---[ECDSA 256]---+ 598s [ 27.309845] cloud-init[613]: | .. .*+o. | 598s [ 27.309873] cloud-init[613]: | o . o.B= | 598s [ 27.309900] cloud-init[613]: | . .o ..ooo. | 598s [ 27.309928] cloud-init[613]: | . o... ...o. | 598s [ 27.309955] cloud-init[613]: | E . oS oo .. | 598s [ 27.309982] cloud-init[613]: |. + . . . oo. | 598s [ 27.310015] cloud-init[613]: |. .+ . . o . | 598s [ 27.310043] cloud-init[613]: | +=o+ oo | 598s [ 27.310071] cloud-init[613]: | BX+ . oo | 598s [ 27.310100] cloud-init[613]: +----[SHA256]-----+ 598s [ 27.310127] cloud-init[613]: Generating public/private ed25519 key pair. 598s [ 27.310156] cloud-init[613]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key 598s [ 27.310185] cloud-init[613]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub 598s [ 27.310213] cloud-init[613]: The key fingerprint is: 598s [ 27.310241] cloud-init[613]: SHA256:3l/afPJC9vk8XqZEyDd4EUpQu840TX4mJNy6pFbATSE root@auto-syncubuntu-noble-24-04-s390x-server-20240710-disk1-img-ad 598s [ 27.310269] cloud-init[613]: The key's randomart image is: 598s [ 27.310296] cloud-init[613]: +--[ED25519 256]--+ 598s [ 27.310325] cloud-init[613]: | Eo=.. | 598s [ 27.310353] cloud-init[613]: | . * + . | 598s [ 27.310382] cloud-init[613]: | o * = | 598s [ 27.310410] cloud-init[613]: | o @ . | 598s [ 27.310438] cloud-init[613]: | S @ O o| 598s [ 27.310465] cloud-init[613]: | . . B *o= | 598s [ 27.310493] cloud-init[613]: | . + +oo.+| 598s [ 27.310520] cloud-init[613]: | . . *o*+| 598s [ 27.310547] cloud-init[613]: | o =**| 598s [ 27.310574] cloud-init[613]: +----[SHA256]-----+ 598s [[0;32m OK [0m] Finished [0;1;39mcloud-init.service[0m - Init���nit job (metadata service crawler). 598s [[0;32m OK [0m] Reached target [0;1;39mcloud-config.target[0m - Cloud-config availability. 598s [[0;32m OK [0m] Reached target [0;1;39mnetwork-online.target[0m - Network is Online. 598s [[0;32m OK [0m] Reached target [0;1;39msysinit.target[0m - System Initialization. 598s [[0;32m OK [0m] Started [0;1;39mapt-daily.timer[0m - Daily apt download activities. 598s [[0;32m OK [0m] Started [0;1;39mapt-daily-upgrade.timer[0m - ���y apt upgrade and clean activities. 598s [[0;32m OK [0m] Started [0;1;39mdpkg-db-backup.timer[0m - Daily dpkg database backup timer. 598s [[0;32m OK [0m] Started [0;1;39me2scrub_all.timer[0m - Period���Metadata Check for All Filesystems. 598s [[0;32m OK [0m] Started [0;1;39mfstrim.timer[0m - Discard unused filesystem blocks once a week. 598s [[0;32m OK [0m] Started [0;1;39mfwupd-refresh.timer[0m - Refresh fwupd metadata regularly. 598s [[0;32m OK [0m] Started [0;1;39mlogrotate.timer[0m - Daily rotation of log files. 598s [[0;32m OK [0m] Started [0;1;39mman-db.timer[0m - Daily man-db regeneration. 598s [[0;32m OK [0m] Started [0;1;39mmotd-news.timer[0m - Message of the Day. 598s [[0;32m OK [0m] Started [0;1;39msysstat-collect.timer[0m - Ru���y accounting tool every 10 minutes. 598s [[0;32m OK [0m] Started [0;1;39msysstat-summary.timer[0m - Ge��� of yesterday's process accounting. 598s [[0;32m OK [0m] Started [0;1;39msystemd-tmpfiles-clean.tim���[0my Cleanup of Temporary Directories. 598s [[0;32m OK [0m] Reached target [0;1;39mpaths.target[0m - Path Units. 598s [[0;32m OK [0m] Reached target [0;1;39mtimers.target[0m - Timer Units. 598s [[0;32m OK [0m] Listening on [0;1;39mcloud-init-hotplugd.s���t[0m - cloud-init hotplug hook socket. 598s [[0;32m OK [0m] Listening on [0;1;39mdbus.socket[0m - D-Bus System Message Bus Socket. 598s Starting [0;1;39mlxd-installer.socket[0m - He���er to install lxd snap on demand... 598s [[0;32m OK [0m] Listening on [0;1;39mssh.socket[0m - OpenBSD Secure Shell server socket. 598s [[0;32m OK [0m] Listening on [0;1;39muuidd.socket[0m - UUID daemon activation socket. 598s Starting [0;1;39mcpi.service[0m - Apply Control Program Identification (CPI)... 598s [[0;32m OK [0m] Listening on [0;1;39mlxd-installer.socket[0m ���lper to install lxd snap on demand. 598s [[0;32m OK [0m] Reached target [0;1;39msockets.target[0m - Socket Units. 598s [[0;32m OK [0m] Reached target [0;1;39mbasic.target[0m - Basic System. 598s Starting [0;1;39msystemd-logind.service[0m - User Login Management... 598s Starting [0;1;39mapport.service[0m - automatic crash report generation... 598s Starting [0;1;39mcloud-config.service[0m - Ap���ttings specified in cloud-config... 598s [[0;32m OK [0m] Started [0;1;39mcron.service[0m - Regular background program processing daemon. 598s Starting [0;1;39mdbus.service[0m - D-Bus System Message Bus... 598s [[0;32m OK [0m] Started [0;1;39mdmesg.service[0m - Save initial kernel messages after boot. 598s Starting [0;1;39mdpkg-db-backup.service[0m - ���ily dpkg database backup service... 598s Starting [0;1;39mdumpconf.service[0m - Configure dump on panic for System z... 598s Starting [0;1;39me2scrub_all.service[0m - Onl���tadata Check for All Filesystems... 598s Starting [0;1;39me2scrub_reap.service[0m - Re���ne ext4 Metadata Check Snapshots... 598s Starting [0;1;39mrc-local.service[0m - /etc/rc.local Compatibility... 598s Starting [0;1;39mrng-tools-debian.service[0m - LSB: rng-tools (Debian variant)... 598s Starting [0;1;39mrsyslog.service[0m - System Logging Service... 598s Starting [0;1;39msysstat.service[0m - Resets System Activity Logs... 598s Starting [0;1;39mudisks2.service[0m - Disk Manager... 598s Starting [0;1;39mlogrotate.service[0m - Rotate log files... 598s [[0;32m OK [0m] Started [0;1;39mdbus.service[0m - D-Bus System Message Bus. 598s [[0;32m OK [0m] Finished [0;1;39mcpi.service[0m - Apply Control Program Identification (CPI). 598s [[0;32m OK [0m] Finished [0;1;39mdumpconf.service[0m - Configure dump on panic for System z. 598s [[0;32m OK [0m] Finished [0;1;39me2scrub_all.service[0m - Onl���Metadata Check for All Filesystems. 598s [[0;32m OK [0m] Finished [0;1;39msysstat.service[0m - Resets System Activity Logs. 598s [[0;32m OK [0m] Started [0;1;39mrng-tools-debian.service[0m - LSB: rng-tools (Debian variant). 598s [[0;32m OK [0m] Started [0;1;39mrc-local.service[0m - /etc/rc.local Compatibility. 598s [[0;32m OK [0m] Started [0;1;39msystemd-logind.service[0m - User Login Management. 598s [[0;32m OK [0m] Finished [0;1;39mlogrotate.service[0m - Rotate log files. 598s [[0;32m OK [0m] Finished [0;1;39me2scrub_reap.service[0m - Re���line ext4 Metadata Check Snapshots. 598s [[0;32m OK [0m] Finished [0;1;39mdpkg-db-backup.service[0m - Daily dpkg database backup service. 598s [[0;32m OK [0m] Started [0;1;39mudisks2.service[0m - Disk Manager. 598s [[0;32m OK [0m] Started [0;1;39mrsyslog.service[0m - System Logging Service. 598s [[0;32m OK [0m] Finished [0;1;39mapport.service[0m - automatic crash report generation. 598s [ 27.758252] cloud-init[858]: Cloud-init v. 24.1.3-0ubuntu3.3 running 'modules:config' at Sat, 10 Aug 2024 08:36:40 +0000. Up 27.73 seconds. 598s [ 27.871722] cloud-init[858]: 2024-08-10 08:36:40,160 - log.py[DEPRECATED]: The following config key(s): ['apt_preserve_sources_list'] is deprecated in 22.1 and scheduled to be removed in 27.1. 598s [ 27.871795] cloud-init[858]: 2024-08-10 08:36:40,160 - log.py[DEPRECATED]: Support for combined old and new apt module keys is deprecated in 22.1 and scheduled to be removed in 27.1. 598s [[0;32m OK [0m] Finished [0;1;39mcloud-config.service[0m - Ap���settings specified in cloud-config. 598s Starting [0;1;39msystemd-user-sessions.service[0m - Permit User Sessions... 598s [[0;32m OK [0m] Finished [0;1;39msystemd-user-sessions.service[0m - Permit User Sessions. 598s Starting [0;1;39mplymouth-quit-wait.servic���[0md until boot process finishes up... 598s Starting [0;1;39mplymouth-quit.service[0m - Terminate Plymouth Boot Screen... 598s [[0;32m OK [0m] Finished [0;1;39mplymouth-quit-wait.servic���[0mold until boot process finishes up. 598s [[0;32m OK [0m] Started [0;1;39mserial-getty@ttysclp0.service[0m - Serial Getty on ttysclp0. 598s Starting [0;1;39msetvtrgb.service[0m - Set console scheme... 598s [[0;32m OK [0m] Finished [0;1;39msetvtrgb.service[0m - Set console scheme. 598s [[0;32m OK [0m] Created slice [0;1;39msystem-getty.slice[0m - Slice /system/getty. 598s [[0;32m OK [0m] Started [0;1;39mgetty@tty1.service[0m - Getty on tty1. 598s [[0;32m OK [0m] Reached target [0;1;39mgetty.target[0m - Login Prompts. 598s [[0;32m OK [0m] Finished [0;1;39mplymouth-quit.service[0m - Terminate Plymouth Boot Screen. 598s [[0;32m OK [0m] Reached target [0;1;39mmulti-user.target[0m - Multi-User System. 598s [[0;32m OK [0m] Reached target [0;1;39mgraphical.target[0m - Graphical Interface. 598s Starting [0;1;39mcloud-final.service[0m - Execute cloud user/final scripts... 598s Starting [0;1;39msystemd-update-utmp-runle���[0m- Record Runlevel Change in UTMP... 598s [[0;32m OK [0m] Finished [0;1;39msystemd-update-utmp-runle���e[0m - Record Runlevel Change in UTMP. 598s Starting [0;1;39mssh.service[0m - OpenBSD Secure Shell server... 598s [[0;32m OK [0m] Started [0;1;39mssh.service[0m - OpenBSD Secure Shell server. 598s [ 28.199094] cloud-init[901]: Cloud-init v. 24.1.3-0ubuntu3.3 running 'modules:final' at Sat, 10 Aug 2024 08:36:40 +0000. Up 28.17 seconds. 598s ci-info: ++++++++++++++++++++++++++++++++++++++++++++++++++++++Authorized keys from /home/ubuntu/.ssh/authorized_keys for user ubuntu++++++++++++++++++++++++++++++++++++++++++++++++++++++ 598s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+----------------------------------------------------------+ 598s ci-info: | Keytype | Fingerprint (sha256) | Options | Comment | 598s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+----------------------------------------------------------+ 598s ci-info: | ssh-rsa | 61:a6:32:29:64:e5:f7:31:49:10:12:b9:1b:7b:be:31:18:f7:58:f2:6d:fa:f1:29:94:57:74:27:de:8f:50:1c | - | ubuntu@juju-7f2275-prod-proposed-migration-environment-3 | 598s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+----------------------------------------------------------+ 598s <14>Aug 10 08:36:40 cloud-init: ############################################################# 598s <14>Aug 10 08:36:40 cloud-init: -----BEGIN SSH HOST KEY FINGERPRINTS----- 598s <14>Aug 10 08:36:40 cloud-init: 256 SHA256:oBVof9XSSTN6OwdNCD3eKxKviz2Aymintu7mybRAkw8 root@auto-syncubuntu-noble-24-04-s390x-server-20240710-disk1-img-ad (ECDSA) 598s <14>Aug 10 08:36:40 cloud-init: 256 SHA256:3l/afPJC9vk8XqZEyDd4EUpQu840TX4mJNy6pFbATSE root@auto-syncubuntu-noble-24-04-s390x-server-20240710-disk1-img-ad (ED25519) 598s <14>Aug 10 08:36:40 cloud-init: 3072 SHA256:w6qYoRiOEqka4HAidLZmNmk153IkursdtoIzl1ubbU4 root@auto-syncubuntu-noble-24-04-s390x-server-20240710-disk1-img-ad (RSA) 598s <14>Aug 10 08:36:40 cloud-init: -----END SSH HOST KEY FINGERPRINTS----- 598s <14>Aug 10 08:36:40 cloud-init: ############################################################# 598s -----BEGIN SSH HOST KEY KEYS----- 598s ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBHbBBdCI/PknQzxyMqy+LD/8t+WDnaGgu/aNSikHSdm6/LjoDhvx0xctdCUK22/XNeJRoCXc9o0Pqy/wWGJIrsQ= root@auto-syncubuntu-noble-24-04-s390x-server-20240710-disk1-img-ad 598s ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIH8n2fkcIBGbDM1844LA5CDV6ptVZQFJRbXyOv/XdBQT root@auto-syncubuntu-noble-24-04-s390x-server-20240710-disk1-img-ad 598s ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQCYp37pBYQ8Oiqmnv6SSh/jdBQI6+/Buy3tJoGf/L9cbCLp8tVeMqa7gZ/UyOidbes20XutnEiC4lIxWjZMYdbqygqHKHhbpR0CKfxd4iCMfCAoB6ahLeT0kHG2UFfivvKaqdlYDYLEllR5mI8vjDwLur8Dc2/FhPPzdcChu4bj3sJfNTxz2R8omhswu7K3G20oJaV5MgX7Smfw3WuaIPerE4+nfzlTaf0lsss3XHczbHm46P8bUZy50tljlpgWM7q+Wjq0FJb5uY+xB2bwl82Hv6JZIirJES2Bb7gH56htTzwWWdW+Tl/vcJXGXftbkvakqRkwG154AotAQsMFxxo+0QH/FQXAsvZyUoywAXDdrNuAtODXIF9C4kIVnal4gXwYhg3Q11FqDtQj0HbuM9Yta8epRp5lohv2szxeAJW1cR7uyN/V5LKlkFojtqYIrroNrYkNtRquM2R+yx1cy8XG/wWWQI8PaVAxK2gOzv9ldt6izMr/yHtest+cl997TGU= root@auto-syncubuntu-noble-24-04-s390x-server-20240710-disk1-img-ad 598s -----END SSH HOST KEY KEYS----- 598s [ 28.261995] cloud-init[901]: Cloud-init v. 24.1.3-0ubuntu3.3 finished at Sat, 10 Aug 2024 08:36:40 +0000. Datasource DataSourceNone. Up 28.25 seconds 598s [ 28.267088] cloud-init[901]: 2024-08-10 08:36:40,550 - cc_final_message.py[WARNING]: Used fallback datasource 598s [[0;32m OK [0m] Finished [0;1;39mcloud-final.service[0m - Execute cloud user/final scripts. 598s [[0;32m OK [0m] Reached target [0;1;39mcloud-init.target[0m - Cloud-init target. 598s 598s Ubuntu 24.04 LTS auto-syncubuntu-noble-24-04-s390x-server-20240710-disk1-img-ad ttysclp0 598s 598s auto-syncubuntu-noble-24-04-s390x-server-20240710-disk1-img-ad login: 598s --------------------------------------------------- 598s ------- nova show 25f673fe-51fc-4028-89cf-56306b38885d (adt-noble-s390x-openssh-20240810-075350-juju-7f2275-prod-proposed-migration-environment-2-b34d2e9b-8488-440f-8f23-365443517c38) ------ 598s +-------------------------------------------+--------------------------------------------------------------------------------------------------------------------------------+ 598s | Property | Value | 598s +-------------------------------------------+--------------------------------------------------------------------------------------------------------------------------------+ 598s | OS-DCF:diskConfig | MANUAL | 598s | OS-EXT-AZ:availability_zone | availability-zone-z15 | 598s | OS-EXT-SRV-ATTR:host | ps6-s390x-n4.ps6.canonical.com | 598s | OS-EXT-SRV-ATTR:hostname | adt-noble-s390x-openssh-20240810-075350-juju-7f2275-prod-propos | 598s | OS-EXT-SRV-ATTR:hypervisor_hostname | ps6-s390x-n4.ps6.canonical.com | 598s | OS-EXT-SRV-ATTR:instance_name | instance-0020f5cc | 598s | OS-EXT-SRV-ATTR:kernel_id | | 598s | OS-EXT-SRV-ATTR:launch_index | 0 | 598s | OS-EXT-SRV-ATTR:ramdisk_id | | 598s | OS-EXT-SRV-ATTR:reservation_id | r-hx4o8lo2 | 598s | OS-EXT-SRV-ATTR:root_device_name | /dev/vda | 598s | OS-EXT-STS:power_state | 1 | 598s | OS-EXT-STS:task_state | - | 598s | OS-EXT-STS:vm_state | active | 598s | OS-SRV-USG:launched_at | 2024-08-10T08:36:12.000000 | 598s | OS-SRV-USG:terminated_at | - | 598s | accessIPv4 | | 598s | accessIPv6 | | 598s | config_drive | | 598s | created | 2024-08-10T08:36:07Z | 598s | description | - | 598s | flavor:disk | 20 | 598s | flavor:ephemeral | 0 | 598s | flavor:extra_specs | {"aggregate_instance_extra_specs:commit": "builder-s390x", "hw_rng:allowed": "True"} | 598s | flavor:original_name | autopkgtest-s390x | 598s | flavor:ram | 4096 | 598s | flavor:swap | 0 | 598s | flavor:vcpus | 2 | 598s | hostId | baba9125a518c658db1c561534b6ecab48f209bec42aa64c59ba01fe | 598s | id | 25f673fe-51fc-4028-89cf-56306b38885d | 598s | image | adt/ubuntu-noble-s390x-server-20240713.img (920ef23d-06ec-432b-945e-a14b2b94e2bd) | 598s | key_name | testbed-juju-7f2275-prod-proposed-migration-environment-2 | 598s | locked | False | 598s | locked_reason | - | 598s | metadata | {} | 598s | name | adt-noble-s390x-openssh-20240810-075350-juju-7f2275-prod-proposed-migration-environment-2-b34d2e9b-8488-440f-8f23-365443517c38 | 598s | net_prod-proposed-migration-s390x network | 10.145.232.18 | 598s | os-extended-volumes:volumes_attached | [] | 598s | progress | 0 | 598s | security_groups | autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-s390x-16.secgroup | 598s | server_groups | [] | 598s | status | ACTIVE | 598s | tags | [] | 598s | tenant_id | ad292334f14047cc96e9c50587dfe285 | 598s | trusted_image_certificates | - | 598s | updated | 2024-08-10T08:36:12Z | 598s | user_id | fda033b8c7ea463db1c3747f74a59d10 | 598s +-------------------------------------------+--------------------------------------------------------------------------------------------------------------------------------+ 598s --------------------------------------------------- 600s nova [E] No UUID given. Instance won't be deleted! 600s : failure: setup script failed with code 1: /home/ubuntu/autopkgtest/ssh-setup/nova open --flavor autopkgtest-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-s390x-16.secgroup --name adt-noble-s390x-openssh-20240810-075350-juju-7f2275-prod-proposed-migration-environment-2-b34d2e9b-8488-440f-8f23-365443517c38 --image adt/ubuntu-noble-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration-s390x -e TERM=linux -e 'http_proxy=http://squid.internal:3128' -e 'https_proxy=http://squid.internal:3128' -e 'no_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com' --mirror=http://ftpmaster.internal/ubuntu/ 600s autopkgtest [08:44:38]: ERROR: testbed failure: unexpected eof from the testbed