0s autopkgtest [07:39:28]: starting date and time: 2024-08-11 07:39:28+0000 0s autopkgtest [07:39:28]: git checkout: fd3bed09 nova: allow more retries for quota issues 0s autopkgtest [07:39:28]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.t96wbxcy/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:systemd,src:dbus,src:openssh --apt-upgrade openssh --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=systemd/255.4-1ubuntu8.4 dbus/1.14.10-4ubuntu4.1 openssh/1:9.6p1-3ubuntu13.5' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-s390x-26.secgroup --name adt-noble-s390x-openssh-20240811-071606-juju-7f2275-prod-proposed-migration-environment-2-1db7b189-f427-4a58-9252-bd34d9ea7cce --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/ 432s nova [W] Using flock in prodstack6-s390x 432s Creating nova instance adt-noble-s390x-openssh-20240811-071606-juju-7f2275-prod-proposed-migration-environment-2-1db7b189-f427-4a58-9252-bd34d9ea7cce from image adt/ubuntu-noble-s390x-server-20240713.img (UUID 920ef23d-06ec-432b-945e-a14b2b94e2bd)... 432s nova [E] Timed out waiting for ssh. Aborting! Console log: 432s ------- nova console-log cad2e2a2-5593-469f-85ac-de84c73972ef (adt-noble-s390x-openssh-20240811-071606-juju-7f2275-prod-proposed-migration-environment-2-1db7b189-f427-4a58-9252-bd34d9ea7cce) ------ 432s LOADPARM=[ ] 432s Using virtio-blk. 432s Using SCSI scheme. 432s .......... 432s [ 0.138826] 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) 432s [ 0.138828] setup: Linux is running under KVM in 64-bit mode 432s [ 0.141862] setup: The maximum memory size is 4096MB 432s [ 0.141864] setup: Relocating AMODE31 section of size 0x00003000 432s [ 0.141923] cpu: 2 configured CPUs, 0 standby CPUs 432s [ 0.141999] Write protected kernel read-only data: 22736k 432s [ 0.142014] Zone ranges: 432s [ 0.142015] DMA [mem 0x0000000000000000-0x000000007fffffff] 432s [ 0.142017] Normal [mem 0x0000000080000000-0x00000000ffffffff] 432s [ 0.142019] Movable zone start for each node 432s [ 0.142020] Early memory node ranges 432s [ 0.142020] node 0: [mem 0x0000000000000000-0x00000000ffffffff] 432s [ 0.142022] Initmem setup node 0 [mem 0x0000000000000000-0x00000000ffffffff] 432s [ 0.176128] percpu: Embedded 52 pages/cpu s88832 r8192 d115968 u212992 432s [ 0.176145] Kernel command line: root=LABEL=cloudimg-rootfs 432s [ 0.176550] random: crng init done 432s [ 0.177998] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) 432s [ 0.178723] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) 432s [ 0.178732] Fallback order for Node 0: 0 432s [ 0.178734] Built 1 zonelists, mobility grouping on. Total pages: 1032192 432s [ 0.178735] Policy zone: Normal 432s [ 0.178736] mem auto-init: stack:all(zero), heap alloc:on, heap free:off 432s [ 0.258986] Memory: 4070168K/4194304K available (15076K kernel code, 3616K rwdata, 7660K rodata, 6532K init, 1064K bss, 124136K reserved, 0K cma-reserved) 432s [ 0.259689] SLUB: HWalign=256, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 432s [ 0.259697] ftrace: allocating 38864 entries in 152 pages 432s [ 0.274524] ftrace: allocated 152 pages with 3 groups 432s [ 0.274751] rcu: Hierarchical RCU implementation. 432s [ 0.274751] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. 432s [ 0.274752] Rude variant of Tasks RCU enabled. 432s [ 0.274752] Tracing variant of Tasks RCU enabled. 432s [ 0.274753] rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies. 432s [ 0.274753] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 432s [ 0.278446] NR_IRQS: 3, nr_irqs: 3, preallocated irqs: 3 432s [ 0.278460] rcu: srcu_init: Setting srcu_struct sizes based on contention. 432s [ 0.278482] clocksource: tod: mask: 0xffffffffffffffff max_cycles: 0x3b0a9be803b0a9, max_idle_ns: 1805497147909793 ns 432s [ 0.278640] Console: colour dummy device 80x25 432s [ 0.278672] printk: legacy console [ttysclp0] enabled 432s [ 0.278718] pid_max: default: 32768 minimum: 301 432s [ 0.278752] LSM: initializing lsm=lockdown,capability,landlock,yama,apparmor,integrity 432s [ 0.278764] landlock: Up and running. 432s [ 0.278765] Yama: becoming mindful. 432s [ 0.278813] AppArmor: AppArmor initialized 432s [ 0.278867] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) 432s [ 0.278891] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) 432s [ 0.279393] RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1. 432s [ 0.279422] RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1. 432s [ 0.279469] rcu: Hierarchical SRCU implementation. 432s [ 0.279470] rcu: Max phase no-delay instances is 1000. 432s [ 0.279596] smp: Bringing up secondary CPUs ... 432s [ 0.279853] smp: Brought up 1 node, 2 CPUs 432s [ 0.280220] devtmpfs: initialized 432s [ 0.280445] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns 432s [ 0.280492] futex hash table entries: 512 (order: 5, 131072 bytes, linear) 432s [ 0.280701] NET: Registered PF_NETLINK/PF_ROUTE protocol family 432s [ 0.280755] audit: initializing netlink subsys (disabled) 432s [ 0.280812] audit: type=2000 audit(1723362144.872:1): state=initialized audit_enabled=0 res=1 432s [ 0.280852] Spectre V2 mitigation: etokens 432s [ 0.281231] HugeTLB: registered 1.00 MiB page size, pre-allocated 0 pages 432s [ 0.281233] HugeTLB: 12 KiB vmemmap can be freed for a 1.00 MiB page 432s [ 0.281637] iommu: Default domain type: Translated 432s [ 0.281638] iommu: DMA domain TLB invalidation policy: strict mode 432s [ 0.281692] SCSI subsystem initialized 432s [ 0.281704] pps_core: LinuxPPS API ver. 1 registered 432s [ 0.281705] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti 432s [ 0.282041] NetLabel: Initializing 432s [ 0.282042] NetLabel: domain hash size = 128 432s [ 0.282043] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO 432s [ 0.282054] NetLabel: unlabeled traffic allowed by default 432s [ 0.285503] VFS: Disk quotas dquot_6.6.0 432s [ 0.285512] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) 432s [ 0.287758] AppArmor: AppArmor Filesystem Enabled 432s [ 0.288737] NET: Registered PF_INET protocol family 432s [ 0.288938] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) 432s [ 0.298521] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) 432s [ 0.298534] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) 432s [ 0.298546] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) 432s [ 0.298604] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) 432s [ 0.298650] TCP: Hash tables configured (established 32768 bind 32768) 432s [ 0.298678] MPTCP token hash table entries: 4096 (order: 4, 98304 bytes, linear) 432s [ 0.298689] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) 432s [ 0.298697] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) 432s [ 0.298732] NET: Registered PF_UNIX/PF_LOCAL protocol family 432s [ 0.298736] NET: Registered PF_XDP protocol family 432s [ 0.298779] Trying to unpack rootfs image as initramfs... 432s [ 0.310280] Key type cert_store_key registered 432s [ 0.310362] kvm-s390: SIE is not available 432s [ 0.310384] hypfs: The hardware system does not support hypfs 432s [ 0.310559] Initialise system trusted keyrings 432s [ 0.310575] Key type blacklist registered 432s [ 0.310608] workingset: timestamp_bits=45 max_order=20 bucket_order=0 432s [ 0.310620] zbud: loaded 432s [ 0.310887] squashfs: version 4.0 (2009/01/31) Phillip Lougher 432s [ 0.310944] fuse: init (API version 7.39) 432s [ 0.311056] integrity: Platform Keyring initialized 432s [ 0.320223] Key type asymmetric registered 432s [ 0.320224] Asymmetric key parser 'x509' registered 432s [ 0.320261] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) 432s [ 0.320301] io scheduler mq-deadline registered 432s [ 0.330240] hvc_iucv: The z/VM IUCV HVC device driver cannot be used without z/VM 432s [ 0.331435] loop: module loaded 432s [ 0.331594] tun: Universal TUN/TAP device driver, 1.6 432s [ 0.331610] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. 432s [ 0.331615] device-mapper: uevent: version 1.0.3 432s [ 0.331642] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com 432s [ 0.331678] cio: Channel measurement facility initialized using format extended (mode autodetected) 432s [ 0.331897] drop_monitor: Initializing network drop monitor service 432s [ 0.331992] NET: Registered PF_INET6 protocol family 432s [ 0.332087] sclp_sd: Store Data request failed (eq=2, di=3, response=0x40f0, flags=0x00, status=0, rc=-5) 432s [ 0.332566] virtio_blk virtio0: 1/0/0 default/read/poll queues 432s [ 0.333720] virtio_blk virtio0: [vda] 41943040 512-byte logical blocks (21.5 GB/20.0 GiB) 432s [ 0.334723] vda: vda1 432s [ 0.351402] Freeing initrd memory: 17292K 432s [ 0.354749] Segment Routing with IPv6 432s [ 0.354756] In-situ OAM (IOAM) with IPv6 432s [ 0.354778] NET: Registered PF_PACKET protocol family 432s [ 0.354834] Key type dns_resolver registered 432s [ 0.355631] registered taskstats version 1 432s [ 0.355727] Loading compiled-in X.509 certificates 432s [ 0.356539] Loaded X.509 cert 'Build time autogenerated kernel key: f6aa641e5e1077928d0349b6d83e21865034f5e7' 432s [ 0.357268] Loaded X.509 cert 'Canonical Ltd. Live Patch Signing: 14df34d1a87cf37625abec039ef2bf521249b969' 432s [ 0.358004] Loaded X.509 cert 'Canonical Ltd. Kernel Module Signing: 88f752e560a1e0737e31163a466ad7b70a850c19' 432s [ 0.358006] blacklist: Loading compiled-in revocation X.509 certificates 432s [ 0.358023] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing: 61482aa2830d0ab2ad5af10b7250da9033ddcef0' 432s [ 0.358047] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2017): 242ade75ac4a15e50d50c84b0d45ff3eae707a03' 432s [ 0.358058] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (ESM 2018): 365188c1d374d6b07c3c8f240f8ef722433d6a8b' 432s [ 0.358071] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2019): c0746fd6c5da3ae827864651ad66ae47fe24b3e8' 432s [ 0.358082] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v1): a8d54bbb3825cfb94fa13c9f8a594a195c107b8d' 432s [ 0.358095] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v2): 4cf046892d6fd3c9a5b03f98d845f90851dc6a8c' 432s [ 0.358106] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v3): 100437bb6de6e469b581e61cd66bce3ef4ed53af' 432s [ 0.358118] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (Ubuntu Core 2019): c1d57b8f6b743f23ee41f4f7ee292f06eecadfb9' 432s [ 0.361095] Key type .fscrypt registered 432s [ 0.361096] Key type fscrypt-provisioning registered 432s [ 0.368267] Key type encrypted registered 432s [ 0.368270] AppArmor: AppArmor sha256 policy hashing enabled 432s [ 0.368278] ima: No TPM chip found, activating TPM-bypass! 432s [ 0.368280] Loading compiled-in module X.509 certificates 432s [ 0.369005] Loaded X.509 cert 'Build time autogenerated kernel key: f6aa641e5e1077928d0349b6d83e21865034f5e7' 432s [ 0.369007] ima: Allocated hash algorithm: sha256 432s [ 0.369014] ima: No architecture policies found 432s [ 0.369019] evm: Initialising EVM extended attributes: 432s [ 0.369020] evm: security.selinux 432s [ 0.369021] evm: security.SMACK64 432s [ 0.369021] evm: security.SMACK64EXEC 432s [ 0.369022] evm: security.SMACK64TRANSMUTE 432s [ 0.369023] evm: security.SMACK64MMAP 432s [ 0.369024] evm: security.apparmor 432s [ 0.369024] evm: security.ima 432s [ 0.369025] evm: security.capability 432s [ 0.369026] evm: HMAC attrs: 0x1 432s [ 0.369974] Freeing unused kernel image (initmem) memory: 6532K 432s [ 0.370004] Write protected read-only-after-init data: 148k 432s [ 0.370142] Checked W+X mappings: passed, no unexpected W+X pages found 432s [ 0.370145] Run /init as init process 432s Loading, please wait... 432s Starting systemd-udevd version 255.4-1ubuntu8.1 432s [ 0.398153] virtio_net virtio1 enc1: renamed from eth0 432s Begin: Starting firmware auto-configuration ... done. 432s Begin: Loading essential drivers ... done. 432s Begin: Running /scripts/init-premount ... done. 432s Begin: Mounting root file system ... Begin: Running /scripts/local-top ... done. 432s Begin: Running /scripts/local-premount ... [ 1.800001] raid6: vx128x8 gen() 22308 MB/s 432s [ 1.800004] raid6: using algorithm vx128x8 gen() 22308 MB/s 432s [ 1.970001] raid6: .... xor() 15112 MB/s, rmw enabled 432s [ 1.970003] raid6: using s390xc recovery algorithm 432s [ 1.970967] xor: automatically using best checksumming function xc 432s [ 1.998688] Btrfs loaded, zoned=yes, fsverity=yes 432s Scanning for Btrfs filesystems 432s done. 432s Begin: Will now check root file system ... fsck from util-linux 2.39.3 432s [/usr/sbin/fsck.ext4 (1) -- /dev/vda1] fsck.ext4 -a -C0 /dev/vda1 432s cloudimg-rootfs: clean, 85699/2560000 files, 618255/5242619 blocks 432s done. 432s [ 2.016973] EXT4-fs (vda1): mounted filesystem 3a20b47e-d5d8-4abe-a992-c1cb771ee648 ro with ordered data mode. Quota mode: none. 432s done. 432s Begin: Running /scripts/local-bottom ... done. 432s Begin: Running /scripts/init-bottom ... done. 432s [ 2.082379] 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) 432s [ 2.082384] systemd[1]: Detected virtualization kvm. 432s [ 2.082386] systemd[1]: Detected architecture s390x. 432s 432s Welcome to [1mUbuntu 24.04 LTS[0m! 432s 432s [ 2.083113] systemd[1]: Hostname set to . 432s [ 2.136359] (sd-exec-[238]: /usr/lib/systemd/system-generators/s390-cpi-vars failed with exit status 1. 432s [ 2.166604] 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. 432s [ 2.168737] 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. 432s [ 2.224840] systemd[1]: Queued start job for default target graphical.target. 432s [ 2.270520] systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. 432s [[0;32m OK [0m] Created slice [0;1;39msystem-modprobe.slice[0m - Slice /system/modprobe. 432s [ 2.270750] systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. 432s [[0;32m OK [0m] Created slice [0;1;39msystem-serial\x2dget���slice[0m - Slice /system/serial-getty. 432s [ 2.270879] systemd[1]: Created slice user.slice - User and Session Slice. 432s [[0;32m OK [0m] Created slice [0;1;39muser.slice[0m - User and Session Slice. 432s [ 2.270930] systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. 432s [[0;32m OK [0m] Started [0;1;39msystemd-ask-password-wall.���[0md Requests to Wall Directory Watch. 432s [ 2.271037] systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. 432s [[0;32m OK [0m] Set up automount [0;1;39mproc-sys-fs-binfm���[0mormats File System Automount Point. 432s [ 2.271067] systemd[1]: Expecting device dev-ttysclp0.device - /dev/ttysclp0... 432s Expecting device [0;1;39mdev-ttysclp0.device[0m - /dev/ttysclp0... 432s [ 2.271099] systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. 432s [[0;32m OK [0m] Reached target [0;1;39mintegritysetup.targ���[0m Local Integrity Protected Volumes. 432s [ 2.271138] systemd[1]: Reached target remote-fs.target - Remote File Systems. 432s [[0;32m OK [0m] Reached target [0;1;39mremote-fs.target[0m - Remote File Systems. 432s [ 2.271162] systemd[1]: Reached target slices.target - Slice Units. 432s [[0;32m OK [0m] Reached target [0;1;39mslices.target[0m - Slice Units. 432s [ 2.271190] systemd[1]: Reached target swap.target - Swaps. 432s [[0;32m OK [0m] Reached target [0;1;39mswap.target[0m - Swaps. 432s [ 2.271221] systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. 432s [[0;32m OK [0m] Reached target [0;1;39mveritysetup.target[0m - Local Verity Protected Volumes. 432s [ 2.271306] systemd[1]: Listening on multipathd.socket - multipathd control socket. 432s [[0;32m OK [0m] Listening on [0;1;39mmultipathd.socket[0m - multipathd control socket. 432s [ 2.271375] systemd[1]: Listening on syslog.socket - Syslog Socket. 432s [[0;32m OK [0m] Listening on [0;1;39msyslog.socket[0m - Syslog Socket. 432s [ 2.271432] systemd[1]: Listening on systemd-fsckd.socket - fsck to fsckd communication Socket. 432s [[0;32m OK [0m] Listening on [0;1;39msystemd-fsckd.socket[0m ���fsck to fsckd communication Socket. 432s [ 2.271476] systemd[1]: Listening on systemd-initctl.socket - initctl Compatibility Named Pipe. 432s [[0;32m OK [0m] Listening on [0;1;39msystemd-initctl.socke���[0m- initctl Compatibility Named Pipe. 432s [ 2.271536] systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). 432s [[0;32m OK [0m] Listening on [0;1;39msystemd-journald-dev-���socket[0m - Journal Socket (/dev/log). 432s [ 2.271604] systemd[1]: Listening on systemd-journald.socket - Journal Socket. 432s [[0;32m OK [0m] Listening on [0;1;39msystemd-journald.socket[0m - Journal Socket. 432s [ 2.271693] systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. 432s [[0;32m OK [0m] Listening on [0;1;39msystemd-networkd.socket[0m - Network Service Netlink Socket. 432s [ 2.271774] systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. 432s [[0;32m OK [0m] Listening on [0;1;39msystemd-udevd-control.socket[0m - udev Control Socket. 432s [ 2.271837] systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. 432s [[0;32m OK [0m] Listening on [0;1;39msystemd-udevd-kernel.socket[0m - udev Kernel Socket. 432s [ 2.272383] systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... 432s Mounting [0;1;39mdev-hugepages.mount[0m - Huge Pages File System... 432s [ 2.274299] systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... 432s Mounting [0;1;39mdev-mqueue.mount[0m - POSIX Message Queue File System... 432s [ 2.275019] systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... 432s Mounting [0;1;39msys-kernel-debug.mount[0m - Kernel Debug File System... 432s [ 2.276935] systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... 432s Mounting [0;1;39msys-kernel-tracing.mount[0m - Kernel Trace File System... 432s [ 2.279066] systemd[1]: Starting keyboard-setup.service - Set the console keyboard layout... 432s Starting [0;1;39mkeyboard-setup.service[0m - Set the console keyboard layout... 432s [ 2.279435] systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... 432s Starting [0;1;39mkmod-static-nodes.service[0m���eate List of Static Device Nodes... 432s [ 2.280725] systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... 432s Starting [0;1;39mmodprobe@configfs.service[0m - Load Kernel Module configfs... 432s [ 2.281093] systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... 432s Starting [0;1;39mmodprobe@dm_mod.service[0m - Load Kernel Module dm_mod... 432s [ 2.285074] systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... 432s Starting [0;1;39mmodprobe@drm.service[0m - Load Kernel Module drm... 432s [ 2.285468] systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... 432s Starting [0;1;39mmodprobe@efi_pstore.servi���[0m - Load Kernel Module efi_pstore... 432s [ 2.289101] systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... 432s Starting [0;1;39mmodprobe@fuse.service[0m - Load Kernel Module fuse... 432s [ 2.289645] systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... 432s Starting [0;1;39mmodprobe@loop.service[0m - Load Kernel Module loop... 432s [ 2.289686] systemd[1]: netplan-ovs-cleanup.service - OpenVSwitch configuration for cleanup was skipped because of an unmet condition check (ConditionFileIsExecutable=/usr/bin/ovs-vsctl). 432s [ 2.289757] 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). 432s [ 2.291766] systemd[1]: Starting systemd-journald.service - Journal Service... 432s Starting [0;1;39msystemd-journald.service[0m - Journal Service... 432s [ 2.312155] systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... 432s Starting [0;1;39msystemd-modules-load.service[0m - Load Kernel Modules... 432s [ 2.312516] systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... 432s Starting [0;1;39msystemd-remount-fs.servic���[0munt Root and Kernel File Systems... 432s [ 2.314127] systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... 432s Starting [0;1;39msystemd-udev-trigger.service[0m - Coldplug All udev Devices... 432s [ 2.314741] systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. 432s [[0;32m OK [0m] Mounted [0;1;39mdev-hugepages.mount[0m - Huge Pages File System. 432s [ 2.314799] systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. 432s [[0;32m OK [0m] Mounted [0;1;39mdev-mqueue.mount[0m - POSIX Message Queue File System. 432s [ 2.314848] systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. 432s [[0;32m OK [0m] Mounted [0;1;39msys-kernel-debug.mount[0m - Kernel Debug File System. 432s [ 2.314896] systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. 432s [[0;32m OK [0m] Mounted [0;1;39msys-kernel-tracing.mount[0m - Kernel Trace File System. 432s [ 2.314992] systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. 432s [[0;32m OK [0m] Finished [0;1;39mkmod-static-nodes.service[0m���Create List of Static Device Nodes. 432s [ 2.315134] systemd[1]: modprobe@configfs.service: Deactivated successfully. 432s [ 2.315193] systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. 432s [[0;32m OK [0m] Finished [0;1;39mmodprobe@configfs.service[0m - Load Kernel Module configfs. 432s [ 2.315325] systemd[1]: modprobe@dm_mod.service: Deactivated successfully. 432s [ 2.315381] systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. 432s [[0;32m OK [0m] Finished [0;1;39mmodprobe@dm_mod.service[0m - Load Kernel Module dm_mod. 432s [ 2.315506] systemd[1]: modprobe@drm.service: Deactivated successfully. 432s [ 2.315562] systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. 432s [[0;32m OK [0m] Finished [0;1;39mmodprobe@drm.service[0m - Load Kernel Module drm. 432s [ 2.315688] systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. 432s [ 2.315744] systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. 432s [[0;32m OK [0m] Finished [0;1;39mmodprobe@efi_pstore.service[0m - Load Kernel Module efi_pstore. 432s [ 2.315870] systemd[1]: modprobe@fuse.service: Deactivated successfully. 432s [ 2.315925] systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. 432s [[0;32m OK [0m] Finished [0;1;39mmodprobe@fuse.service[0m - Load Kernel Module fuse. 432s [ 2.316047] systemd[1]: modprobe@loop.service: Deactivated successfully. 432s [ 2.316103] systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. 432s [[0;32m OK [0m] Finished [0;1;39mmodprobe@loop.service[0m - Load Kernel Module loop. 432s [ 2.330186] systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... 432s Mounting [0;1;39msys-fs-fuse-connections.mount[0m - FUSE Control File System... 432s [ 2.331482] systemd-journald[289]: Collecting audit messages is disabled. 432s [ 2.334396] systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... 432s Mounting [0;1;39msys-kernel-config.mount[0m - Kernel Configuration File System... 432s [ 2.334441] systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. 432s [ 2.344816] systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... 432s Starting [0;1;39msystemd-tmpfiles-setup-de���[0m Device Nodes in /dev gracefully... 432s [ 2.345138] systemd[1]: Started systemd-journald.service - Journal Service. 432s [[0;32m OK [0m] Started [0;1;39msystemd-journald.service[0m - Journal Service. 432s [[0;32m OK [0m] Finished [0;1;39msystemd-modules-load.service[0m - Load Kernel Modules. 432s [[0;32m OK [0m] Finished [0;1;39msystemd-udev-trigger.service[0m - Coldplug All udev Devices. 432s [[0;32m OK [0m] Mounted [0;1;39msys-fs-fuse-connections.mount[0m - FUSE Control File System. 432s [[0;32m OK [0m] Mounted [0;1;39msys-kernel-config.mount[0m - Kernel Configuration File System. 432s Starting [0;1;39msystemd-sysctl.service[0m - Apply Kernel Variables... 432s [ 2.350790] EXT4-fs (vda1): re-mounted 3a20b47e-d5d8-4abe-a992-c1cb771ee648 r/w. Quota mode: none. 432s [[0;32m OK [0m] Finished [0;1;39msystemd-remount-fs.servic���[0mmount Root and Kernel File Systems. 432s Starting [0;1;39mcloud-init-local.service[0m ��� cloud-init job (pre-networking)... 432s Starting [0;1;39mmultipathd.service[0m - Devi���pper Multipath Device Controller... 432s Starting [0;1;39msystemd-journal-flush.ser���[0msh Journal to Persistent Storage... 432s Starting [0;1;39msystemd-random-seed.service[0m - Load/Save OS Random Seed... 432s [[0;32m OK [0m] Finished [0;1;39mkeyboard-setup.service[0m - Set the console keyboard layout. 432s [[0;32m OK [0m] Finished [0;1;39msystemd-tmpfiles-setup-de���[0mic Device Nodes in /dev gracefully. 432s [[0;32m OK [0m] Finished [0;1;39msystemd-sysctl.service[0m - Apply Kernel Variables. 432s Starting [0;1;39msystemd-tmpfiles-setup-de���[0meate Static Device Nodes in /dev... 432s [[0;32m OK [0m] Finished [0;1;39msystemd-tmpfiles-setup-de���[0mCreate Static Device Nodes in /dev. 432s Starting [0;1;39msystemd-udevd.service[0m - R���ager for Device Events and Files... 432s [[0;32m OK [0m] Started [0;1;39mmultipathd.service[0m - Devic���Mapper Multipath Device Controller. 432s [[0;32m OK [0m] Reached target [0;1;39mlocal-fs-pre.target[0m���Preparation for Local File Systems. 432s [[0;32m OK [0m] Reached target [0;1;39mlocal-fs.target[0m - Local File Systems. 432s [[0;32m OK [0m] Listening on [0;1;39msystemd-sysext.socket[0m���tension Image Management (Varlink). 432s Starting [0;1;39mapparmor.service[0m - Load AppArmor profiles... 432s Starting [0;1;39mconsole-setup.service[0m - Set console font and keymap... 432s Starting [0;1;39mplymouth-read-write.servi���[0mymouth To Write Out Runtime Data... 432s Starting [0;1;39msystemd-binfmt.service[0m - Set Up Additional Binary Formats... 432s Starting [0;1;39mufw.service[0m - Uncomplicated firewall... 432s Mounting [0;1;39mproc-sys-fs-binfmt_misc.m���[0mcutable File Formats File System... 432s [[0;32m OK [0m] Finished [0;1;39msystemd-random-seed.service[0m - Load/Save OS Random Seed. 432s [[0;32m OK [0m] Finished [0;1;39mufw.service[0m - Uncomplicated firewall. 432s [[0;32m OK [0m] Mounted [0;1;39mproc-sys-fs-binfmt_misc.mo���[0mxecutable File Formats File System. 432s [[0;32m OK [0m] Finished [0;1;39mplymouth-read-write.servi���[0mPlymouth To Write Out Runtime Data. 432s [[0;32m OK [0m] Finished [0;1;39mconsole-setup.service[0m - Set console font and keymap. 432s [[0;32m OK [0m] Finished [0;1;39msystemd-binfmt.service[0m - Set Up Additional Binary Formats. 432s [[0;32m OK [0m] Finished [0;1;39msystemd-journal-flush.ser���[0mlush Journal to Persistent Storage. 432s Starting [0;1;39msystemd-tmpfiles-setup.se���[0me Volatile Files and Directories... 432s [[0;32m OK [0m] Finished [0;1;39msystemd-tmpfiles-setup.se���[0mate Volatile Files and Directories. 432s Starting [0;1;39msystemd-resolved.service[0m - Network Name Resolution... 432s Starting [0;1;39msystemd-timesyncd.service[0m - Network Time Synchronization... 432s Starting [0;1;39msystemd-update-utmp.servi���[0mord System Boot/Shutdown in UTMP... 432s [[0;32m OK [0m] Started [0;1;39msystemd-udevd.service[0m - Ru���anager for Device Events and Files. 432s [[0;32m OK [0m] Started [0;1;39msystemd-ask-password-conso���[0mequests to Console Directory Watch. 432s [[0;32m OK [0m] Reached target [0;1;39mcryptsetup.target[0m - Local Encrypted Volumes. 432s [[0;32m OK [0m] Finished [0;1;39msystemd-update-utmp.servi���[0mecord System Boot/Shutdown in UTMP. 432s [[0;32m OK [0m] Found device [0;1;39mdev-ttysclp0.device[0m - /dev/ttysclp0. 432s [[0;32m OK [0m] Started [0;1;39msystemd-timesyncd.service[0m - Network Time Synchronization. 432s [[0;32m OK [0m] Reached target [0;1;39mtime-set.target[0m - System Time Set. 432s [[0;32m OK [0m] Started [0;1;39msystemd-resolved.service[0m - Network Name Resolution. 432s [[0;32m OK [0m] Reached target [0;1;39mnss-lookup.target[0m - Host and Network Name Lookups. 432s [[0;32m OK [0m] Finished [0;1;39mapparmor.service[0m - Load AppArmor profiles. 432s [ 2.834333] cloud-init[535]: Cloud-init v. 24.1.3-0ubuntu3.3 running 'init-local' at Sun, 11 Aug 2024 07:42:27 +0000. Up 2.82 seconds. 432s [ 11.287252] cloud-init[535]: 2024-08-11 07:42:35,881 - url_helper.py[ERROR]: Timed out, no response from urls: ['http://[fe80::a9fe:a9fe]/openstack', 'http://169.254.169.254/openstack'] 432s [ 11.289206] cloud-init[535]: 2024-08-11 07:42:35,883 - util.py[WARNING]: No active metadata service found 432s [[0;32m OK [0m] Finished [0;1;39mcloud-init-local.service[0m ���al cloud-init job (pre-networking). 432s [[0;32m OK [0m] Reached target [0;1;39mnetwork-pre.target[0m - Preparation for Network. 432s Starting [0;1;39msystemd-networkd.service[0m - Network Configuration... 432s [[0;32m OK [0m] Started [0;1;39msystemd-networkd.service[0m - Network Configuration. 432s [[0;32m OK [0m] Reached target [0;1;39mnetwork.target[0m - Network. 432s Starting [0;1;39msystemd-networkd-wait-onl���[0mait for Network to be Configured... 432s [[0;32m OK [0m] Finished [0;1;39msystemd-networkd-wait-onl���[0m Wait for Network to be Configured. 432s Starting [0;1;39mcloud-init.service[0m - Init���t job (metadata service crawler)... 432s [ 13.491802] cloud-init[611]: Cloud-init v. 24.1.3-0ubuntu3.3 running 'init' at Sun, 11 Aug 2024 07:41:11 +0000. Up 13.47 seconds. 432s [ 13.495874] cloud-init[611]: ci-info: +++++++++++++++++++++++++++++++++++++++Net device info+++++++++++++++++++++++++++++++++++++++ 432s [ 13.495915] cloud-init[611]: ci-info: +--------+------+------------------------------+---------------+--------+-------------------+ 432s [ 13.495945] cloud-init[611]: ci-info: | Device | Up | Address | Mask | Scope | Hw-Address | 432s [ 13.495980] cloud-init[611]: ci-info: +--------+------+------------------------------+---------------+--------+-------------------+ 432s [ 13.496009] cloud-init[611]: ci-info: | enc1 | True | 10.145.232.138 | 255.255.255.0 | global | fa:16:3e:e1:ef:b6 | 432s [ 13.496038] cloud-init[611]: ci-info: | enc1 | True | fe80::f816:3eff:fee1:efb6/64 | . | link | fa:16:3e:e1:ef:b6 | 432s [ 13.496065] cloud-init[611]: ci-info: | lo | True | 127.0.0.1 | 255.0.0.0 | host | . | 432s [ 13.496091] cloud-init[611]: ci-info: | lo | True | ::1/128 | . | host | . | 432s [ 13.496118] cloud-init[611]: ci-info: +--------+------+------------------------------+---------------+--------+-------------------+ 432s [ 13.496145] cloud-init[611]: ci-info: ++++++++++++++++++++++++++++++++Route IPv4 info+++++++++++++++++++++++++++++++++ 432s [ 13.496172] cloud-init[611]: ci-info: +-------+-----------------+--------------+-----------------+-----------+-------+ 432s [ 13.496201] cloud-init[611]: ci-info: | Route | Destination | Gateway | Genmask | Interface | Flags | 432s [ 13.496228] cloud-init[611]: ci-info: +-------+-----------------+--------------+-----------------+-----------+-------+ 432s [ 13.496257] cloud-init[611]: ci-info: | 0 | 0.0.0.0 | 10.145.232.1 | 0.0.0.0 | enc1 | UG | 432s [ 13.496284] cloud-init[611]: ci-info: | 1 | 10.145.232.0 | 0.0.0.0 | 255.255.255.0 | enc1 | U | 432s [ 13.496312] cloud-init[611]: ci-info: | 2 | 10.145.232.1 | 0.0.0.0 | 255.255.255.255 | enc1 | UH | 432s [ 13.496339] cloud-init[611]: ci-info: | 3 | 10.145.232.2 | 0.0.0.0 | 255.255.255.255 | enc1 | UH | 432s [ 13.496365] cloud-init[611]: ci-info: | 4 | 91.189.91.131 | 10.145.232.1 | 255.255.255.255 | enc1 | UGH | 432s [ 13.496392] cloud-init[611]: ci-info: | 5 | 91.189.91.132 | 10.145.232.1 | 255.255.255.255 | enc1 | UGH | 432s [ 13.496420] cloud-init[611]: ci-info: | 6 | 169.254.169.254 | 10.145.232.2 | 255.255.255.255 | enc1 | UGH | 432s [ 13.496445] cloud-init[611]: ci-info: +-------+-----------------+--------------+-----------------+-----------+-------+ 432s [ 13.496474] cloud-init[611]: ci-info: +++++++++++++++++++Route IPv6 info+++++++++++++++++++ 432s [ 13.496500] cloud-init[611]: ci-info: +-------+-------------+---------+-----------+-------+ 432s [ 13.496525] cloud-init[611]: ci-info: | Route | Destination | Gateway | Interface | Flags | 432s [ 13.496553] cloud-init[611]: ci-info: +-------+-------------+---------+-----------+-------+ 432s [ 13.496578] cloud-init[611]: ci-info: | 0 | fe80::/64 | :: | enc1 | U | 432s [ 13.496605] cloud-init[611]: ci-info: | 2 | local | :: | enc1 | U | 432s [ 13.496631] cloud-init[611]: ci-info: | 3 | multicast | :: | enc1 | U | 432s [ 13.496657] cloud-init[611]: ci-info: +-------+-------------+---------+-----------+-------+ 432s [ 20.887208] cloud-init[611]: 2024-08-11 07:41:18,766 - url_helper.py[ERROR]: Timed out, no response from urls: ['http://[fe80::a9fe:a9fe]/openstack', 'http://169.254.169.254/openstack'] 432s [ 20.887397] cloud-init[611]: 2024-08-11 07:41:18,766 - util.py[WARNING]: No active metadata service found 432s [[0;32m OK [0m] Stopped [0;1;39msystemd-networkd-wait-onli���[0m Wait for Network to be Configured. 432s Stopping [0;1;39msystemd-networkd-wait-onl���[0mait for Network to be Configured... 432s Stopping [0;1;39msystemd-networkd.service[0m - Network Configuration... 432s [[0;32m OK [0m] Stopped [0;1;39msystemd-networkd.service[0m - Network Configuration. 432s Starting [0;1;39msystemd-networkd.service[0m - Network Configuration... 432s [[0;32m OK [0m] Started [0;1;39msystemd-networkd.service[0m - Network Configuration. 432s Starting [0;1;39msystemd-networkd-wait-onl���[0mait for Network to be Configured... 432s [ 21.379516] cloud-init[611]: 2024-08-11 07:41:19,259 - activators.py[WARNING]: Running ['netplan', 'apply'] resulted in stderr output: Failed to connect to system bus: No such file or directory 432s [ 21.379561] cloud-init[611]: Falling back to a hard restart of systemd-networkd.service 432s [[0;32m OK [0m] Finished [0;1;39msystemd-networkd-wait-onl���[0m Wait for Network to be Configured. 432s [ 22.518286] cloud-init[611]: Generating public/private rsa key pair. 432s [ 22.518343] cloud-init[611]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key 432s [ 22.518376] cloud-init[611]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub 432s [ 22.518407] cloud-init[611]: The key fingerprint is: 432s [ 22.518437] cloud-init[611]: SHA256:Un5G3SqysyrMImMDiqfYcOQmfcAOHfU8KQf+vBe3ZkA root@auto-syncubuntu-noble-24-04-s390x-server-20240710-disk1-img-ad 432s [ 22.518468] cloud-init[611]: The key's randomart image is: 432s [ 22.518505] cloud-init[611]: +---[RSA 3072]----+ 432s [ 22.518537] cloud-init[611]: | o | 432s [ 22.518566] cloud-init[611]: | o + . . . | 432s [ 22.518596] cloud-init[611]: | . o * E . . . | 432s [ 22.518625] cloud-init[611]: | o . = = . . | 432s [ 22.518657] cloud-init[611]: |. = + S = . | 432s [ 22.518687] cloud-init[611]: |.* . o O o | 432s [ 22.518717] cloud-init[611]: |* *o. . + + | 432s [ 22.518745] cloud-init[611]: |*Oo.+ . = | 432s [ 22.518775] cloud-init[611]: |+=o. .... | 432s [ 22.518804] cloud-init[611]: +----[SHA256]-----+ 432s [ 22.518834] cloud-init[611]: Generating public/private ecdsa key pair. 432s [ 22.518864] cloud-init[611]: Your identification has been saved in /etc/ssh/ssh_host_ecdsa_key 432s [ 22.518894] cloud-init[611]: Your public key has been saved in /etc/ssh/ssh_host_ecdsa_key.pub 432s [ 22.518924] cloud-init[611]: The key fingerprint is: 432s [ 22.518953] cloud-init[611]: SHA256:rPnV4Gdb5VuiAUUNp4oUS/jZlqA9at5caHZPxFb3hZg root@auto-syncubuntu-noble-24-04-s390x-server-20240710-disk1-img-ad 432s [ 22.518982] cloud-init[611]: The key's randomart image is: 432s [ 22.519012] cloud-init[611]: +---[ECDSA 256]---+ 432s [ 22.519042] cloud-init[611]: | .o o=.. | 432s [ 22.519073] cloud-init[611]: | ...o .Eo+ o| 432s [ 22.519101] cloud-init[611]: | +o+ oo. .o| 432s [ 22.519153] cloud-init[611]: | .o=.+o+ .| 432s [ 22.519182] cloud-init[611]: | .S++o .| 432s [ 22.519211] cloud-init[611]: | oo+.o+. o | 432s [ 22.519240] cloud-init[611]: | oo= ooo= o o| 432s [ 22.519270] cloud-init[611]: | ..o. o.= .o| 432s [ 22.519298] cloud-init[611]: | . o . | 432s [ 22.519328] cloud-init[611]: +----[SHA256]-----+ 432s [ 22.519356] cloud-init[611]: Generating public/private ed25519 key pair. 432s [ 22.519385] cloud-init[611]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key 432s [ 22.519414] cloud-init[611]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub 432s [ 22.519443] cloud-init[611]: The key fingerprint is: 432s [ 22.519470] cloud-init[611]: SHA256:gXqBrymntBMPfm0NEmBlvsvtSrFU1dNFhM0ClbUq2Y8 root@auto-syncubuntu-noble-24-04-s390x-server-20240710-disk1-img-ad 432s [ 22.519499] cloud-init[611]: The key's randomart image is: 432s [ 22.519528] cloud-init[611]: +--[ED25519 256]--+ 432s [ 22.519558] cloud-init[611]: | .o ...+.X= | 432s [ 22.519586] cloud-init[611]: | oo . o o = o. | 432s [ 22.519615] cloud-init[611]: | . .o + . . .. | 432s [ 22.519644] cloud-init[611]: | .= . . o . | 432s [ 22.519672] cloud-init[611]: | =.o S o o | 432s [ 22.519700] cloud-init[611]: | oo.O. . o | 432s [ 22.519729] cloud-init[611]: | .o+Oo.o E . | 432s [ 22.519759] cloud-init[611]: | .o*o.o . | 432s [ 22.519787] cloud-init[611]: | oo.o. | 432s [ 22.519817] cloud-init[611]: +----[SHA256]-----+ 432s [[0;32m OK [0m] Finished [0;1;39mcloud-init.service[0m - Init���nit job (metadata service crawler). 432s [[0;32m OK [0m] Reached target [0;1;39mcloud-config.target[0m - Cloud-config availability. 432s [[0;32m OK [0m] Reached target [0;1;39mnetwork-online.target[0m - Network is Online. 432s [[0;32m OK [0m] Reached target [0;1;39msysinit.target[0m - System Initialization. 432s [[0;32m OK [0m] Started [0;1;39mapt-daily.timer[0m - Daily apt download activities. 432s [[0;32m OK [0m] Started [0;1;39mapt-daily-upgrade.timer[0m - ���y apt upgrade and clean activities. 432s [[0;32m OK [0m] Started [0;1;39mdpkg-db-backup.timer[0m - Daily dpkg database backup timer. 432s [[0;32m OK [0m] Started [0;1;39me2scrub_all.timer[0m - Period���Metadata Check for All Filesystems. 432s [[0;32m OK [0m] Started [0;1;39mfstrim.timer[0m - Discard unused filesystem blocks once a week. 432s [[0;32m OK [0m] Started [0;1;39mfwupd-refresh.timer[0m - Refresh fwupd metadata regularly. 432s [[0;32m OK [0m] Started [0;1;39mlogrotate.timer[0m - Daily rotation of log files. 432s [[0;32m OK [0m] Started [0;1;39mman-db.timer[0m - Daily man-db regeneration. 432s [[0;32m OK [0m] Started [0;1;39mmotd-news.timer[0m - Message of the Day. 432s [[0;32m OK [0m] Started [0;1;39msysstat-collect.timer[0m - Ru���y accounting tool every 10 minutes. 432s [[0;32m OK [0m] Started [0;1;39msysstat-summary.timer[0m - Ge��� of yesterday's process accounting. 432s [[0;32m OK [0m] Started [0;1;39msystemd-tmpfiles-clean.tim���[0my Cleanup of Temporary Directories. 432s [[0;32m OK [0m] Reached target [0;1;39mpaths.target[0m - Path Units. 432s [[0;32m OK [0m] Reached target [0;1;39mtimers.target[0m - Timer Units. 432s [[0;32m OK [0m] Listening on [0;1;39mcloud-init-hotplugd.s���t[0m - cloud-init hotplug hook socket. 432s [[0;32m OK [0m] Listening on [0;1;39mdbus.socket[0m - D-Bus System Message Bus Socket. 432s Starting [0;1;39mlxd-installer.socket[0m - He���er to install lxd snap on demand... 432s [[0;32m OK [0m] Listening on [0;1;39mssh.socket[0m - OpenBSD Secure Shell server socket. 432s [[0;32m OK [0m] Listening on [0;1;39muuidd.socket[0m - UUID daemon activation socket. 432s Starting [0;1;39mcpi.service[0m - Apply Control Program Identification (CPI)... 432s [[0;32m OK [0m] Listening on [0;1;39mlxd-installer.socket[0m ���lper to install lxd snap on demand. 432s [[0;32m OK [0m] Reached target [0;1;39msockets.target[0m - Socket Units. 432s [[0;32m OK [0m] Reached target [0;1;39mbasic.target[0m - Basic System. 432s Starting [0;1;39msystemd-logind.service[0m - User Login Management... 432s Starting [0;1;39mapport.service[0m - automatic crash report generation... 432s Starting [0;1;39mcloud-config.service[0m - Ap���ttings specified in cloud-config... 432s [[0;32m OK [0m] Started [0;1;39mcron.service[0m - Regular background program processing daemon. 432s Starting [0;1;39mdbus.service[0m - D-Bus System Message Bus... 432s [[0;32m OK [0m] Started [0;1;39mdmesg.service[0m - Save initial kernel messages after boot. 432s Starting [0;1;39mdpkg-db-backup.service[0m - ���ily dpkg database backup service... 432s Starting [0;1;39mdumpconf.service[0m - Configure dump on panic for System z... 432s Starting [0;1;39me2scrub_reap.service[0m - Re���ne ext4 Metadata Check Snapshots... 432s Starting [0;1;39mrc-local.service[0m - /etc/rc.local Compatibility... 432s Starting [0;1;39mrng-tools-debian.service[0m - LSB: rng-tools (Debian variant)... 432s Starting [0;1;39mrsyslog.service[0m - System Logging Service... 432s Starting [0;1;39msysstat.service[0m - Resets System Activity Logs... 432s Starting [0;1;39mudisks2.service[0m - Disk Manager... 432s Starting [0;1;39mlogrotate.service[0m - Rotate log files... 432s [[0;32m OK [0m] Started [0;1;39mdbus.service[0m - D-Bus System Message Bus. 432s [[0;32m OK [0m] Started [0;1;39msystemd-logind.service[0m - User Login Management. 432s [[0;32m OK [0m] Finished [0;1;39mcpi.service[0m - Apply Control Program Identification (CPI). 432s [[0;32m OK [0m] Finished [0;1;39mdumpconf.service[0m - Configure dump on panic for System z. 432s [[0;32m OK [0m] Finished [0;1;39msysstat.service[0m - Resets System Activity Logs. 432s [[0;32m OK [0m] Started [0;1;39mrc-local.service[0m - /etc/rc.local Compatibility. 432s [[0;32m OK [0m] Finished [0;1;39mlogrotate.service[0m - Rotate log files. 432s [[0;32m OK [0m] Finished [0;1;39mdpkg-db-backup.service[0m - Daily dpkg database backup service. 432s [[0;32m OK [0m] Started [0;1;39mrng-tools-debian.service[0m - LSB: rng-tools (Debian variant). 432s [[0;32m OK [0m] Started [0;1;39mudisks2.service[0m - Disk Manager. 432s [[0;32m OK [0m] Finished [0;1;39me2scrub_reap.service[0m - Re���line ext4 Metadata Check Snapshots. 432s [[0;32m OK [0m] Started [0;1;39mrsyslog.service[0m - System Logging Service. 432s [[0;32m OK [0m] Finished [0;1;39mapport.service[0m - automatic crash report generation. 432s [ 22.954292] cloud-init[857]: Cloud-init v. 24.1.3-0ubuntu3.3 running 'modules:config' at Sun, 11 Aug 2024 07:41:20 +0000. Up 22.92 seconds. 432s [ 23.066595] cloud-init[857]: 2024-08-11 07:41:20,946 - 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. 432s [ 23.066651] cloud-init[857]: 2024-08-11 07:41:20,946 - 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. 432s [[0;32m OK [0m] Finished [0;1;39mcloud-config.service[0m - Ap���settings specified in cloud-config. 432s Starting [0;1;39msystemd-user-sessions.service[0m - Permit User Sessions... 432s [[0;32m OK [0m] Finished [0;1;39msystemd-user-sessions.service[0m - Permit User Sessions. 432s Starting [0;1;39mplymouth-quit-wait.servic���[0md until boot process finishes up... 432s Starting [0;1;39mplymouth-quit.service[0m - Terminate Plymouth Boot Screen... 432s [[0;32m OK [0m] Finished [0;1;39mplymouth-quit-wait.servic���[0mold until boot process finishes up. 432s [[0;32m OK [0m] Started [0;1;39mserial-getty@ttysclp0.service[0m - Serial Getty on ttysclp0. 432s Starting [0;1;39msetvtrgb.service[0m - Set console scheme... 432s [[0;32m OK [0m] Finished [0;1;39msetvtrgb.service[0m - Set console scheme. 432s [[0;32m OK [0m] Created slice [0;1;39msystem-getty.slice[0m - Slice /system/getty. 432s [[0;32m OK [0m] Started [0;1;39mgetty@tty1.service[0m - Getty on tty1. 432s [[0;32m OK [0m] Reached target [0;1;39mgetty.target[0m - Login Prompts. 432s [[0;32m OK [0m] Finished [0;1;39mplymouth-quit.service[0m - Terminate Plymouth Boot Screen. 432s [[0;32m OK [0m] Reached target [0;1;39mmulti-user.target[0m - Multi-User System. 432s [[0;32m OK [0m] Reached target [0;1;39mgraphical.target[0m - Graphical Interface. 432s Starting [0;1;39mcloud-final.service[0m - Execute cloud user/final scripts... 432s Starting [0;1;39msystemd-update-utmp-runle���[0m- Record Runlevel Change in UTMP... 432s [[0;32m OK [0m] Finished [0;1;39msystemd-update-utmp-runle���e[0m - Record Runlevel Change in UTMP. 432s [ 23.399506] cloud-init[895]: Cloud-init v. 24.1.3-0ubuntu3.3 running 'modules:final' at Sun, 11 Aug 2024 07:41:21 +0000. Up 23.37 seconds. 432s ci-info: ++++++++++++++++++++++++++++++++++++++++++++++++++++++Authorized keys from /home/ubuntu/.ssh/authorized_keys for user ubuntu++++++++++++++++++++++++++++++++++++++++++++++++++++++ 432s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+----------------------------------------------------------+ 432s ci-info: | Keytype | Fingerprint (sha256) | Options | Comment | 432s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+----------------------------------------------------------+ 432s 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 | 432s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+----------------------------------------------------------+ 432s <14>Aug 11 07:41:21 cloud-init: ############################################################# 432s <14>Aug 11 07:41:21 cloud-init: -----BEGIN SSH HOST KEY FINGERPRINTS----- 432s <14>Aug 11 07:41:21 cloud-init: 256 SHA256:rPnV4Gdb5VuiAUUNp4oUS/jZlqA9at5caHZPxFb3hZg root@auto-syncubuntu-noble-24-04-s390x-server-20240710-disk1-img-ad (ECDSA) 432s <14>Aug 11 07:41:21 cloud-init: 256 SHA256:gXqBrymntBMPfm0NEmBlvsvtSrFU1dNFhM0ClbUq2Y8 root@auto-syncubuntu-noble-24-04-s390x-server-20240710-disk1-img-ad (ED25519) 432s <14>Aug 11 07:41:21 cloud-init: 3072 SHA256:Un5G3SqysyrMImMDiqfYcOQmfcAOHfU8KQf+vBe3ZkA root@auto-syncubuntu-noble-24-04-s390x-server-20240710-disk1-img-ad (RSA) 432s <14>Aug 11 07:41:21 cloud-init: -----END SSH HOST KEY FINGERPRINTS----- 432s <14>Aug 11 07:41:21 cloud-init: ############################################################# 432s -----BEGIN SSH HOST KEY KEYS----- 432s ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBFZnnpR6gbZfz6vzgswFxlamXuF1qFUfA40OPVk7bd8oPlDRcE3A1BIge9EBJtvjny4NYy9huKfzZpfZZZwx69Q= root@auto-syncubuntu-noble-24-04-s390x-server-20240710-disk1-img-ad 432s ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIJt7EOhCnM+MftCSV0htB0e/wNQudNLEeDAaLl9/j4em root@auto-syncubuntu-noble-24-04-s390x-server-20240710-disk1-img-ad 432s ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDSU6B5Lqvuwb5cur5h+xKJT/fcixSx2KSRjIrkK9UN/ocJn52UfjKMjaAOL71KCkJ/U1wD1l4CrJVIyJS6Tt5KwUYnALu0joZPMUnBQI1aaZ+EH7qw3IDHcO9SdGMszrdNo9FCTEqBfxZV6ilHmcSyVAjymkMyEqWMG1J/VuDO4aCW0ma2MdhgLEKSSlmDXLR7vYBL65PBvL7lFqvSzI+b4MQkreDd09geFv/kSDw3lx3drXLjwOixxK8aitMt40gl8hYfjfEdTovpVaTtmXNXSqh166zEWDRTLOrQCkjInhVww1jSkSyce/HLyLDVGWzkctftd0ko2nzDIUwqIFTm8KsDDDjpLLGEodUDBGT2FRcPf/+dyYdT+xyUUF4nkdXG1oT9bK/78+9E2TAWYhORGwRubc7shPj0SDEs9aVsIVKz8AapRTesio7m7V4wRpz4NlpbChvWi09cAQ+2X6XFhqijCbmN+Eg+c0D+K0SKH9I+hLa9xQxpJmCJSNw5yYs= root@auto-syncubuntu-noble-24-04-s390x-server-20240710-disk1-img-ad 432s -----END SSH HOST KEY KEYS----- 432s [ 23.459372] cloud-init[895]: Cloud-init v. 24.1.3-0ubuntu3.3 finished at Sun, 11 Aug 2024 07:41:21 +0000. Datasource DataSourceNone. Up 23.45 seconds 432s [ 23.459619] cloud-init[895]: 2024-08-11 07:41:21,339 - cc_final_message.py[WARNING]: Used fallback datasource 432s [[0;32m OK [0m] Finished [0;1;39mcloud-final.service[0m - Execute cloud user/final scripts. 432s [[0;32m OK [0m] Reached target [0;1;39mcloud-init.target[0m - Cloud-init target. 432s 432s Ubuntu 24.04 LTS auto-syncubuntu-noble-24-04-s390x-server-20240710-disk1-img-ad ttysclp0 432s 432s auto-syncubuntu-noble-24-04-s390x-server-20240710-disk1-img-ad login: 432s --------------------------------------------------- 432s ------- nova show cad2e2a2-5593-469f-85ac-de84c73972ef (adt-noble-s390x-openssh-20240811-071606-juju-7f2275-prod-proposed-migration-environment-2-1db7b189-f427-4a58-9252-bd34d9ea7cce) ------ 432s +-------------------------------------------+--------------------------------------------------------------------------------------------------------------------------------+ 432s | Property | Value | 432s +-------------------------------------------+--------------------------------------------------------------------------------------------------------------------------------+ 432s | OS-DCF:diskConfig | MANUAL | 432s | OS-EXT-AZ:availability_zone | availability-zone-z15 | 432s | OS-EXT-SRV-ATTR:host | ps6-s390x-n5.ps6.canonical.com | 432s | OS-EXT-SRV-ATTR:hostname | adt-noble-s390x-openssh-20240811-071606-juju-7f2275-prod-propos | 432s | OS-EXT-SRV-ATTR:hypervisor_hostname | ps6-s390x-n5.ps6.canonical.com | 432s | OS-EXT-SRV-ATTR:instance_name | instance-00216c0b | 432s | OS-EXT-SRV-ATTR:kernel_id | | 432s | OS-EXT-SRV-ATTR:launch_index | 0 | 432s | OS-EXT-SRV-ATTR:ramdisk_id | | 432s | OS-EXT-SRV-ATTR:reservation_id | r-ld08v6gl | 432s | OS-EXT-SRV-ATTR:root_device_name | /dev/vda | 432s | OS-EXT-STS:power_state | 1 | 432s | OS-EXT-STS:task_state | - | 432s | OS-EXT-STS:vm_state | active | 432s | OS-SRV-USG:launched_at | 2024-08-11T07:40:57.000000 | 432s | OS-SRV-USG:terminated_at | - | 432s | accessIPv4 | | 432s | accessIPv6 | | 432s | config_drive | | 432s | created | 2024-08-11T07:40:52Z | 432s | description | - | 432s | flavor:disk | 20 | 432s | flavor:ephemeral | 0 | 432s | flavor:extra_specs | {"aggregate_instance_extra_specs:commit": "builder-s390x", "hw_rng:allowed": "True"} | 432s | flavor:original_name | autopkgtest-s390x | 432s | flavor:ram | 4096 | 432s | flavor:swap | 0 | 432s | flavor:vcpus | 2 | 432s | hostId | 567faa6fb4d32b3b2972398a4b1abda65450402a99b402b3c5ea0538 | 432s | id | cad2e2a2-5593-469f-85ac-de84c73972ef | 432s | image | adt/ubuntu-noble-s390x-server-20240713.img (920ef23d-06ec-432b-945e-a14b2b94e2bd) | 432s | key_name | testbed-juju-7f2275-prod-proposed-migration-environment-2 | 432s | locked | False | 432s | locked_reason | - | 432s | metadata | {} | 432s | name | adt-noble-s390x-openssh-20240811-071606-juju-7f2275-prod-proposed-migration-environment-2-1db7b189-f427-4a58-9252-bd34d9ea7cce | 432s | net_prod-proposed-migration-s390x network | 10.145.232.138 | 432s | os-extended-volumes:volumes_attached | [] | 432s | progress | 0 | 432s | security_groups | autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-s390x-26.secgroup | 432s | server_groups | [] | 432s | status | ACTIVE | 432s | tags | [] | 432s | tenant_id | ad292334f14047cc96e9c50587dfe285 | 432s | trusted_image_certificates | - | 432s | updated | 2024-08-11T07:40:58Z | 432s | user_id | fda033b8c7ea463db1c3747f74a59d10 | 432s +-------------------------------------------+--------------------------------------------------------------------------------------------------------------------------------+ 432s --------------------------------------------------- 432s nova [E] No UUID given. Instance won't be deleted! 432s : 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-26.secgroup --name adt-noble-s390x-openssh-20240811-071606-juju-7f2275-prod-proposed-migration-environment-2-1db7b189-f427-4a58-9252-bd34d9ea7cce --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/ 432s autopkgtest [07:46:40]: ERROR: testbed failure: unexpected eof from the testbed