0s autopkgtest [15:28:10]: starting date and time: 2024-03-16 15:28:10+0000 0s autopkgtest [15:28:10]: git checkout: b506e79c ssh-setup/nova: fix ARCH having two lines of data 0s autopkgtest [15:28:10]: host juju-7f2275-prod-proposed-migration-environment-3; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.7hj5jwux/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --setup-commands /home/ubuntu/autopkgtest/setup-commands/setup-testbed --apt-pocket=proposed=src:systemd,src:clevis,src:collectd,src:curl,src:dbus,src:dpdk,src:glib2.0,src:gnutls28,src:gpsd,src:libmicrohttpd,src:libpsl,src:libreswan,src:libvirt-dbus,src:netplan.io,src:nettle,src:nix,src:openssh,src:openssl,src:orthanc-python,src:samba,src:suricata --apt-upgrade multipath-tools --timeout-short=300 --timeout-copy=20000 --timeout-test=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=systemd/255.4-1ubuntu5 clevis/19-6build1 collectd/5.12.0-17.1build1 curl/8.5.0-2ubuntu7 dbus/1.14.10-4ubuntu2 dpdk/23.11-1build2 glib2.0/2.79.3-3ubuntu5 gnutls28/3.8.3-1.1ubuntu2 gpsd/3.25-3ubuntu2 libmicrohttpd/1.0.0-2.1ubuntu1 libpsl/0.21.2-1.1 libreswan/4.12-1ubuntu2 libvirt-dbus/1.4.1-3ubuntu2 netplan.io/1.0-1 nettle/3.9.1-2.2 nix/2.18.1+dfsg-1ubuntu4 openssh/1:9.6p1-3ubuntu8 openssl/3.0.13-0ubuntu1 orthanc-python/4.1+ds-2build3 samba/2:4.19.5+dfsg-4ubuntu3 suricata/1:7.0.3-1build1' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-big --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-3@bos03-arm64-22.secgroup --name adt-noble-arm64-multipath-tools-20240316-152810-juju-7f2275-prod-proposed-migration-environment-3 --image adt/ubuntu-noble-arm64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-3 --net-id=net_prod-proposed-migration -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,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 93s autopkgtest [15:29:43]: testbed dpkg architecture: arm64 93s autopkgtest [15:29:43]: testbed apt version: 2.7.12 93s autopkgtest [15:29:43]: @@@@@@@@@@@@@@@@@@@@ test bed setup 94s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [117 kB] 94s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [51.4 kB] 95s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [473 kB] 95s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [3694 kB] 95s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [6540 B] 95s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 Packages [646 kB] 95s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 c-n-f Metadata [3144 B] 95s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted arm64 Packages [33.6 kB] 95s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted arm64 c-n-f Metadata [116 B] 95s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe arm64 Packages [4005 kB] 95s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/universe arm64 c-n-f Metadata [8528 B] 95s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/multiverse arm64 Packages [55.6 kB] 95s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/multiverse arm64 c-n-f Metadata [116 B] 97s Fetched 9095 kB in 2s (4305 kB/s) 98s Reading package lists... 102s Reading package lists... 102s Building dependency tree... 102s Reading state information... 103s Calculating upgrade... 104s The following package was automatically installed and is no longer required: 104s libnetplan0 104s Use 'sudo apt autoremove' to remove it. 104s The following packages will be REMOVED: 104s libglib2.0-0 libssl3 104s The following NEW packages will be installed: 104s libglib2.0-0t64 libnetplan1 libssl3t64 xdg-user-dirs 104s The following packages have been kept back: 104s curl 104s The following packages will be upgraded: 104s dbus dbus-bin dbus-daemon dbus-session-bus-common dbus-system-bus-common 104s dbus-user-session gir1.2-glib-2.0 libdbus-1-3 libglib2.0-data libnss-systemd 104s libpam-systemd libsystemd-shared libsystemd0 libudev1 netplan-generator 104s netplan.io openssh-client openssh-server openssh-sftp-server openssl 104s python3-netplan systemd systemd-dev systemd-resolved systemd-sysv 104s systemd-timesyncd ubuntu-minimal ubuntu-standard udev 104s 29 upgraded, 4 newly installed, 2 to remove and 1 not upgraded. 104s Need to get 15.5 MB of archives. 104s After this operation, 1128 kB of additional disk space will be used. 104s Get:1 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 gir1.2-glib-2.0 arm64 2.79.3-3ubuntu5 [182 kB] 105s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 python3-netplan arm64 1.0-1 [21.5 kB] 105s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 netplan-generator arm64 1.0-1 [58.8 kB] 105s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 netplan.io arm64 1.0-1 [65.4 kB] 105s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 libglib2.0-0t64 arm64 2.79.3-3ubuntu5 [1527 kB] 105s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 openssl arm64 3.0.13-0ubuntu1 [983 kB] 105s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 systemd-resolved arm64 255.4-1ubuntu5 [291 kB] 105s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 systemd-dev all 255.4-1ubuntu5 [103 kB] 105s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 libssl3t64 arm64 3.0.13-0ubuntu1 [1770 kB] 105s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 systemd arm64 255.4-1ubuntu5 [3403 kB] 105s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 udev arm64 255.4-1ubuntu5 [1852 kB] 105s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 systemd-sysv arm64 255.4-1ubuntu5 [11.9 kB] 105s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 libnss-systemd arm64 255.4-1ubuntu5 [154 kB] 105s Get:14 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 libpam-systemd arm64 255.4-1ubuntu5 [232 kB] 105s Get:15 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 openssh-sftp-server arm64 1:9.6p1-3ubuntu9 [36.8 kB] 105s Get:16 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 openssh-server arm64 1:9.6p1-3ubuntu9 [501 kB] 105s Get:17 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 openssh-client arm64 1:9.6p1-3ubuntu9 [884 kB] 105s Get:18 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 systemd-timesyncd arm64 255.4-1ubuntu5 [34.8 kB] 105s Get:19 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 libsystemd-shared arm64 255.4-1ubuntu5 [2016 kB] 105s Get:20 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 libudev1 arm64 255.4-1ubuntu5 [173 kB] 105s Get:21 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 dbus-session-bus-common all 1.14.10-4ubuntu2 [80.3 kB] 105s Get:22 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 dbus-user-session arm64 1.14.10-4ubuntu2 [9960 B] 105s Get:23 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 libsystemd0 arm64 255.4-1ubuntu5 [424 kB] 105s Get:24 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 dbus-daemon arm64 1.14.10-4ubuntu2 [115 kB] 105s Get:25 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 dbus-bin arm64 1.14.10-4ubuntu2 [38.8 kB] 105s Get:26 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 dbus-system-bus-common all 1.14.10-4ubuntu2 [81.5 kB] 105s Get:27 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 dbus arm64 1.14.10-4ubuntu2 [23.9 kB] 105s Get:28 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 libdbus-1-3 arm64 1.14.10-4ubuntu2 [210 kB] 105s Get:29 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 libglib2.0-data all 2.79.3-3ubuntu5 [46.6 kB] 105s Get:30 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 libnetplan1 arm64 1.0-1 [117 kB] 105s Get:31 http://ftpmaster.internal/ubuntu noble/main arm64 ubuntu-minimal arm64 1.536 [10.7 kB] 105s Get:32 http://ftpmaster.internal/ubuntu noble/main arm64 xdg-user-dirs arm64 0.18-1 [18.1 kB] 105s Get:33 http://ftpmaster.internal/ubuntu noble/main arm64 ubuntu-standard arm64 1.536 [10.7 kB] 106s Preconfiguring packages ... 107s Fetched 15.5 MB in 1s (11.3 MB/s) 107s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 74758 files and directories currently installed.) 107s Preparing to unpack .../gir1.2-glib-2.0_2.79.3-3ubuntu5_arm64.deb ... 107s Unpacking gir1.2-glib-2.0:arm64 (2.79.3-3ubuntu5) over (2.79.2-1~ubuntu1) ... 107s Preparing to unpack .../python3-netplan_1.0-1_arm64.deb ... 107s Unpacking python3-netplan (1.0-1) over (0.107.1-3) ... 107s Preparing to unpack .../netplan-generator_1.0-1_arm64.deb ... 107s Adding 'diversion of /lib/systemd/system-generators/netplan to /lib/systemd/system-generators/netplan.usr-is-merged by netplan-generator' 107s Unpacking netplan-generator (1.0-1) over (0.107.1-3) ... 107s Preparing to unpack .../netplan.io_1.0-1_arm64.deb ... 107s Unpacking netplan.io (1.0-1) over (0.107.1-3) ... 108s dpkg: libglib2.0-0:arm64: dependency problems, but removing anyway as you requested: 108s udisks2 depends on libglib2.0-0 (>= 2.77.0). 108s shared-mime-info depends on libglib2.0-0 (>= 2.75.3). 108s python3-gi depends on libglib2.0-0 (>= 2.77.0). 108s python3-dbus depends on libglib2.0-0 (>= 2.16.0). 108s libxmlb2:arm64 depends on libglib2.0-0 (>= 2.54.0). 108s libvolume-key1:arm64 depends on libglib2.0-0 (>= 2.18.0). 108s libudisks2-0:arm64 depends on libglib2.0-0 (>= 2.75.3). 108s libqrtr-glib0:arm64 depends on libglib2.0-0 (>= 2.56). 108s libqmi-proxy depends on libglib2.0-0 (>= 2.30.0). 108s libqmi-glib5:arm64 depends on libglib2.0-0 (>= 2.54.0). 108s libpolkit-gobject-1-0:arm64 depends on libglib2.0-0 (>= 2.38.0). 108s libpolkit-agent-1-0:arm64 depends on libglib2.0-0 (>= 2.38.0). 108s libnetplan0:arm64 depends on libglib2.0-0 (>= 2.75.3). 108s libmm-glib0:arm64 depends on libglib2.0-0 (>= 2.62.0). 108s libmbim-proxy depends on libglib2.0-0 (>= 2.56). 108s libmbim-glib4:arm64 depends on libglib2.0-0 (>= 2.56). 108s libjson-glib-1.0-0:arm64 depends on libglib2.0-0 (>= 2.75.3). 108s libjcat1:arm64 depends on libglib2.0-0 (>= 2.75.3). 108s libgusb2:arm64 depends on libglib2.0-0 (>= 2.75.3). 108s libgudev-1.0-0:arm64 depends on libglib2.0-0 (>= 2.38.0). 108s libgirepository-1.0-1:arm64 depends on libglib2.0-0 (>= 2.79.0). 108s libfwupd2:arm64 depends on libglib2.0-0 (>= 2.79.0). 108s libblockdev3:arm64 depends on libglib2.0-0 (>= 2.42.2). 108s libblockdev-utils3:arm64 depends on libglib2.0-0 (>= 2.75.3). 108s libblockdev-swap3:arm64 depends on libglib2.0-0 (>= 2.42.2). 108s libblockdev-part3:arm64 depends on libglib2.0-0 (>= 2.42.2). 108s libblockdev-nvme3:arm64 depends on libglib2.0-0 (>= 2.42.2). 108s libblockdev-mdraid3:arm64 depends on libglib2.0-0 (>= 2.42.2). 108s libblockdev-loop3:arm64 depends on libglib2.0-0 (>= 2.42.2). 108s libblockdev-fs3:arm64 depends on libglib2.0-0 (>= 2.42.2). 108s libblockdev-crypto3:arm64 depends on libglib2.0-0 (>= 2.42.2). 108s fwupd depends on libglib2.0-0 (>= 2.79.0). 108s bolt depends on libglib2.0-0 (>= 2.56.0). 108s 108s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 74760 files and directories currently installed.) 108s Removing libglib2.0-0:arm64 (2.79.2-1~ubuntu1) ... 108s Selecting previously unselected package libglib2.0-0t64:arm64. 108s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 74735 files and directories currently installed.) 108s Preparing to unpack .../libglib2.0-0t64_2.79.3-3ubuntu5_arm64.deb ... 108s libglib2.0-0t64.preinst: Removing /var/lib/dpkg/info/libglib2.0-0:arm64.postrm to avoid loss of /usr/share/glib-2.0/schemas/gschemas.compiled... 108s removed '/var/lib/dpkg/info/libglib2.0-0:arm64.postrm' 108s Unpacking libglib2.0-0t64:arm64 (2.79.3-3ubuntu5) ... 108s Preparing to unpack .../openssl_3.0.13-0ubuntu1_arm64.deb ... 108s Unpacking openssl (3.0.13-0ubuntu1) over (3.0.10-1ubuntu4) ... 108s Preparing to unpack .../systemd-resolved_255.4-1ubuntu5_arm64.deb ... 108s Unpacking systemd-resolved (255.4-1ubuntu5) over (255.2-3ubuntu2) ... 108s Preparing to unpack .../systemd-dev_255.4-1ubuntu5_all.deb ... 108s Unpacking systemd-dev (255.4-1ubuntu5) over (255.2-3ubuntu2) ... 108s dpkg: libssl3:arm64: dependency problems, but removing anyway as you requested: 108s wget depends on libssl3 (>= 3.0.0). 108s u-boot-tools depends on libssl3 (>= 3.0.0). 108s tnftp depends on libssl3 (>= 3.0.0). 108s tcpdump depends on libssl3 (>= 3.0.0). 108s systemd depends on libssl3 (>= 3.0.0). 108s sudo depends on libssl3 (>= 3.0.0). 108s sbsigntool depends on libssl3 (>= 3.0.0). 108s rsync depends on libssl3 (>= 3.0.0). 108s python3-cryptography depends on libssl3 (>= 3.0.0). 108s openssh-server depends on libssl3 (>= 3.0.10). 108s openssh-client depends on libssl3 (>= 3.0.10). 108s mtd-utils depends on libssl3 (>= 3.0.0). 108s mokutil depends on libssl3 (>= 3.0.0). 108s linux-headers-6.8.0-11-generic depends on libssl3 (>= 3.0.0). 108s libsystemd-shared:arm64 depends on libssl3 (>= 3.0.0). 108s libssh-4:arm64 depends on libssl3 (>= 3.0.0). 108s libsasl2-modules:arm64 depends on libssl3 (>= 3.0.0). 108s libsasl2-2:arm64 depends on libssl3 (>= 3.0.0). 108s libpython3.12-minimal:arm64 depends on libssl3 (>= 3.0.0). 108s libnvme1 depends on libssl3 (>= 3.0.0). 108s libkrb5-3:arm64 depends on libssl3 (>= 3.0.0). 108s libkmod2:arm64 depends on libssl3 (>= 3.0.0). 108s libfido2-1:arm64 depends on libssl3 (>= 3.0.0). 108s libcurl4:arm64 depends on libssl3 (>= 3.0.0). 108s libcryptsetup12:arm64 depends on libssl3 (>= 3.0.0). 108s kmod depends on libssl3 (>= 3.0.0). 108s dhcpcd-base depends on libssl3 (>= 3.0.0). 108s bind9-libs:arm64 depends on libssl3 (>= 3.0.0). 108s 108s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 74760 files and directories currently installed.) 108s Removing libssl3:arm64 (3.0.10-1ubuntu4) ... 108s Selecting previously unselected package libssl3t64:arm64. 108s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 74749 files and directories currently installed.) 108s Preparing to unpack .../libssl3t64_3.0.13-0ubuntu1_arm64.deb ... 108s Unpacking libssl3t64:arm64 (3.0.13-0ubuntu1) ... 108s Setting up libssl3t64:arm64 (3.0.13-0ubuntu1) ... 109s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 74762 files and directories currently installed.) 109s Preparing to unpack .../systemd_255.4-1ubuntu5_arm64.deb ... 109s Unpacking systemd (255.4-1ubuntu5) over (255.2-3ubuntu2) ... 109s Preparing to unpack .../udev_255.4-1ubuntu5_arm64.deb ... 109s Unpacking udev (255.4-1ubuntu5) over (255.2-3ubuntu2) ... 109s Preparing to unpack .../libsystemd-shared_255.4-1ubuntu5_arm64.deb ... 109s Unpacking libsystemd-shared:arm64 (255.4-1ubuntu5) over (255.2-3ubuntu2) ... 109s Setting up libsystemd-shared:arm64 (255.4-1ubuntu5) ... 109s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 74762 files and directories currently installed.) 110s Preparing to unpack .../libsystemd0_255.4-1ubuntu5_arm64.deb ... 110s Unpacking libsystemd0:arm64 (255.4-1ubuntu5) over (255.2-3ubuntu2) ... 110s Setting up libsystemd0:arm64 (255.4-1ubuntu5) ... 110s Setting up systemd-dev (255.4-1ubuntu5) ... 110s Setting up systemd (255.4-1ubuntu5) ... 111s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 74762 files and directories currently installed.) 111s Preparing to unpack .../0-systemd-sysv_255.4-1ubuntu5_arm64.deb ... 111s Unpacking systemd-sysv (255.4-1ubuntu5) over (255.2-3ubuntu2) ... 111s Preparing to unpack .../1-libnss-systemd_255.4-1ubuntu5_arm64.deb ... 111s Unpacking libnss-systemd:arm64 (255.4-1ubuntu5) over (255.2-3ubuntu2) ... 111s Preparing to unpack .../2-libpam-systemd_255.4-1ubuntu5_arm64.deb ... 111s Unpacking libpam-systemd:arm64 (255.4-1ubuntu5) over (255.2-3ubuntu2) ... 111s Preparing to unpack .../3-openssh-sftp-server_1%3a9.6p1-3ubuntu9_arm64.deb ... 111s Unpacking openssh-sftp-server (1:9.6p1-3ubuntu9) over (1:9.6p1-3ubuntu2) ... 111s Preparing to unpack .../4-openssh-server_1%3a9.6p1-3ubuntu9_arm64.deb ... 111s Unpacking openssh-server (1:9.6p1-3ubuntu9) over (1:9.6p1-3ubuntu2) ... 111s Preparing to unpack .../5-openssh-client_1%3a9.6p1-3ubuntu9_arm64.deb ... 111s Unpacking openssh-client (1:9.6p1-3ubuntu9) over (1:9.6p1-3ubuntu2) ... 111s Preparing to unpack .../6-systemd-timesyncd_255.4-1ubuntu5_arm64.deb ... 111s Unpacking systemd-timesyncd (255.4-1ubuntu5) over (255.2-3ubuntu2) ... 111s Preparing to unpack .../7-libudev1_255.4-1ubuntu5_arm64.deb ... 111s Unpacking libudev1:arm64 (255.4-1ubuntu5) over (255.2-3ubuntu2) ... 111s Setting up libudev1:arm64 (255.4-1ubuntu5) ... 112s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 74762 files and directories currently installed.) 112s Preparing to unpack .../00-dbus-session-bus-common_1.14.10-4ubuntu2_all.deb ... 112s Unpacking dbus-session-bus-common (1.14.10-4ubuntu2) over (1.14.10-4ubuntu1) ... 112s Preparing to unpack .../01-dbus-user-session_1.14.10-4ubuntu2_arm64.deb ... 112s Unpacking dbus-user-session (1.14.10-4ubuntu2) over (1.14.10-4ubuntu1) ... 112s Preparing to unpack .../02-dbus-daemon_1.14.10-4ubuntu2_arm64.deb ... 112s Unpacking dbus-daemon (1.14.10-4ubuntu2) over (1.14.10-4ubuntu1) ... 112s Preparing to unpack .../03-dbus-bin_1.14.10-4ubuntu2_arm64.deb ... 112s Unpacking dbus-bin (1.14.10-4ubuntu2) over (1.14.10-4ubuntu1) ... 112s Preparing to unpack .../04-dbus-system-bus-common_1.14.10-4ubuntu2_all.deb ... 112s Unpacking dbus-system-bus-common (1.14.10-4ubuntu2) over (1.14.10-4ubuntu1) ... 113s Preparing to unpack .../05-dbus_1.14.10-4ubuntu2_arm64.deb ... 113s Unpacking dbus (1.14.10-4ubuntu2) over (1.14.10-4ubuntu1) ... 113s Preparing to unpack .../06-libdbus-1-3_1.14.10-4ubuntu2_arm64.deb ... 113s Unpacking libdbus-1-3:arm64 (1.14.10-4ubuntu2) over (1.14.10-4ubuntu1) ... 114s Preparing to unpack .../07-libglib2.0-data_2.79.3-3ubuntu5_all.deb ... 114s Unpacking libglib2.0-data (2.79.3-3ubuntu5) over (2.79.2-1~ubuntu1) ... 114s Selecting previously unselected package libnetplan1:arm64. 114s Preparing to unpack .../08-libnetplan1_1.0-1_arm64.deb ... 114s Unpacking libnetplan1:arm64 (1.0-1) ... 114s Preparing to unpack .../09-ubuntu-minimal_1.536_arm64.deb ... 114s Unpacking ubuntu-minimal (1.536) over (1.535) ... 114s Selecting previously unselected package xdg-user-dirs. 115s Preparing to unpack .../10-xdg-user-dirs_0.18-1_arm64.deb ... 115s Unpacking xdg-user-dirs (0.18-1) ... 115s Preparing to unpack .../11-ubuntu-standard_1.536_arm64.deb ... 115s Unpacking ubuntu-standard (1.536) over (1.535) ... 115s Setting up systemd-sysv (255.4-1ubuntu5) ... 115s Setting up xdg-user-dirs (0.18-1) ... 115s Setting up openssh-client (1:9.6p1-3ubuntu9) ... 115s Setting up libnss-systemd:arm64 (255.4-1ubuntu5) ... 115s Setting up libglib2.0-0t64:arm64 (2.79.3-3ubuntu5) ... 115s No schema files found: doing nothing. 115s Setting up libglib2.0-data (2.79.3-3ubuntu5) ... 115s Setting up libdbus-1-3:arm64 (1.14.10-4ubuntu2) ... 115s Setting up systemd-timesyncd (255.4-1ubuntu5) ... 118s Setting up udev (255.4-1ubuntu5) ... 119s Setting up gir1.2-glib-2.0:arm64 (2.79.3-3ubuntu5) ... 119s Setting up dbus-session-bus-common (1.14.10-4ubuntu2) ... 119s Setting up dbus-system-bus-common (1.14.10-4ubuntu2) ... 119s Setting up openssl (3.0.13-0ubuntu1) ... 119s Setting up dbus-bin (1.14.10-4ubuntu2) ... 119s Setting up openssh-sftp-server (1:9.6p1-3ubuntu9) ... 119s Setting up openssh-server (1:9.6p1-3ubuntu9) ... 119s Replacing config file /etc/ssh/sshd_config with new version 121s Created symlink /etc/systemd/system/ssh.service.requires/ssh.socket → /usr/lib/systemd/system/ssh.socket. 124s Setting up dbus-daemon (1.14.10-4ubuntu2) ... 124s Setting up libnetplan1:arm64 (1.0-1) ... 124s Setting up dbus (1.14.10-4ubuntu2) ... 124s A reboot is required to replace the running dbus-daemon. 124s Please reboot the system when convenient. 125s Setting up libpam-systemd:arm64 (255.4-1ubuntu5) ... 125s Setting up python3-netplan (1.0-1) ... 125s Setting up netplan-generator (1.0-1) ... 125s Removing 'diversion of /lib/systemd/system-generators/netplan to /lib/systemd/system-generators/netplan.usr-is-merged by netplan-generator' 125s Setting up systemd-resolved (255.4-1ubuntu5) ... 126s Setting up ubuntu-standard (1.536) ... 126s Setting up netplan.io (1.0-1) ... 126s Setting up dbus-user-session (1.14.10-4ubuntu2) ... 126s Setting up ubuntu-minimal (1.536) ... 126s Processing triggers for ufw (0.36.2-5) ... 126s Processing triggers for man-db (2.12.0-3) ... 127s Processing triggers for initramfs-tools (0.142ubuntu20) ... 127s update-initramfs: Generating /boot/initrd.img-6.8.0-11-generic 127s W: No lz4 in /usr/bin:/sbin:/bin, using gzip 148s System running in EFI mode, skipping. 148s Processing triggers for libc-bin (2.39-0ubuntu2) ... 149s Reading package lists... 149s Building dependency tree... 149s Reading state information... 149s The following packages will be REMOVED: 149s libnetplan0* 150s 0 upgraded, 0 newly installed, 1 to remove and 1 not upgraded. 150s After this operation, 357 kB disk space will be freed. 150s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 74778 files and directories currently installed.) 150s Removing libnetplan0:arm64 (0.107.1-3) ... 150s Processing triggers for libc-bin (2.39-0ubuntu2) ... 152s sh: Attempting to set up Debian/Ubuntu apt sources automatically 152s sh: Distribution appears to be Ubuntu 153s Reading package lists... 153s Building dependency tree... 153s Reading state information... 154s eatmydata is already the newest version (131-1). 154s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 154s Reading package lists... 154s Building dependency tree... 154s Reading state information... 155s dbus is already the newest version (1.14.10-4ubuntu2). 155s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 155s Reading package lists... 155s Building dependency tree... 155s Reading state information... 156s rng-tools-debian is already the newest version (2.4). 156s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 156s Reading package lists... 156s Building dependency tree... 156s Reading state information... 156s The following packages will be REMOVED: 156s cloud-init* python3-configobj* python3-debconf* 157s 0 upgraded, 0 newly installed, 3 to remove and 0 not upgraded. 157s After this operation, 3252 kB disk space will be freed. 157s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 74774 files and directories currently installed.) 157s Removing cloud-init (24.1.1-0ubuntu1) ... 157s Removing python3-configobj (5.0.8-3) ... 157s Removing python3-debconf (1.5.86) ... 158s Processing triggers for man-db (2.12.0-3) ... 158s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 74385 files and directories currently installed.) 158s Purging configuration files for cloud-init (24.1.1-0ubuntu1) ... 159s dpkg: warning: while removing cloud-init, directory '/etc/cloud/cloud.cfg.d' not empty so not removed 159s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ... 159s invoke-rc.d: policy-rc.d denied execution of try-restart. 159s Reading package lists... 159s Building dependency tree... 159s Reading state information... 160s linux-generic is already the newest version (6.8.0-11.11+1). 160s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 161s Hit:1 http://ftpmaster.internal/ubuntu noble InRelease 161s Hit:2 http://ftpmaster.internal/ubuntu noble-updates InRelease 161s Hit:3 http://ftpmaster.internal/ubuntu noble-security InRelease 165s Reading package lists... 165s Reading package lists... 165s Building dependency tree... 165s Reading state information... 166s Calculating upgrade... 166s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 166s Reading package lists... 166s Building dependency tree... 166s Reading state information... 167s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 167s autopkgtest [15:30:57]: rebooting testbed after setup commands that affected boot 205s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 214s autopkgtest [15:31:44]: testbed running kernel: Linux 6.8.0-11-generic #11-Ubuntu SMP PREEMPT_DYNAMIC Wed Feb 14 02:53:31 UTC 2024 217s autopkgtest [15:31:47]: @@@@@@@@@@@@@@@@@@@@ apt-source multipath-tools 223s Get:1 http://ftpmaster.internal/ubuntu noble/main multipath-tools 0.9.4-5ubuntu3 (dsc) [2733 B] 223s Get:2 http://ftpmaster.internal/ubuntu noble/main multipath-tools 0.9.4-5ubuntu3 (tar) [554 kB] 223s Get:3 http://ftpmaster.internal/ubuntu noble/main multipath-tools 0.9.4-5ubuntu3 (diff) [42.6 kB] 224s gpgv: Signature made Wed Sep 6 23:15:24 2023 UTC 224s gpgv: using RSA key 8A2044F84F716A85B77FF76311DF4294CCA39893 224s gpgv: Can't check signature: No public key 224s dpkg-source: warning: cannot verify inline signature for ./multipath-tools_0.9.4-5ubuntu3.dsc: no acceptable signature found 224s autopkgtest [15:31:54]: testing package multipath-tools version 0.9.4-5ubuntu3 225s autopkgtest [15:31:55]: build not needed 225s autopkgtest [15:31:55]: test kpartx-file-loopback: preparing testbed 226s Reading package lists... 227s Building dependency tree... 227s Reading state information... 227s Starting pkgProblemResolver with broken count: 0 227s Starting 2 pkgProblemResolver with broken count: 0 227s Done 228s The following additional packages will be installed: 228s liburing2 qemu-utils 228s Recommended packages: 228s qemu-block-extra 228s The following NEW packages will be installed: 228s autopkgtest-satdep liburing2 qemu-utils 228s 0 upgraded, 3 newly installed, 0 to remove and 0 not upgraded. 228s Need to get 2062 kB/2063 kB of archives. 228s After this operation, 11.7 MB of additional disk space will be used. 228s Get:1 /tmp/autopkgtest.phKdtC/1-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [720 B] 228s Get:2 http://ftpmaster.internal/ubuntu noble/main arm64 liburing2 arm64 2.5-1 [21.5 kB] 229s Get:3 http://ftpmaster.internal/ubuntu noble/main arm64 qemu-utils arm64 1:8.2.1+ds-1ubuntu1 [2041 kB] 230s Fetched 2062 kB in 1s (2910 kB/s) 230s Selecting previously unselected package liburing2:arm64. 230s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 74330 files and directories currently installed.) 230s Preparing to unpack .../liburing2_2.5-1_arm64.deb ... 230s Unpacking liburing2:arm64 (2.5-1) ... 230s Selecting previously unselected package qemu-utils. 230s Preparing to unpack .../qemu-utils_1%3a8.2.1+ds-1ubuntu1_arm64.deb ... 230s Unpacking qemu-utils (1:8.2.1+ds-1ubuntu1) ... 231s Selecting previously unselected package autopkgtest-satdep. 231s Preparing to unpack .../1-autopkgtest-satdep.deb ... 231s Unpacking autopkgtest-satdep (0) ... 231s Setting up liburing2:arm64 (2.5-1) ... 231s Setting up qemu-utils (1:8.2.1+ds-1ubuntu1) ... 231s Setting up autopkgtest-satdep (0) ... 231s Processing triggers for man-db (2.12.0-3) ... 232s Processing triggers for libc-bin (2.39-0ubuntu2) ... 237s (Reading database ... 74350 files and directories currently installed.) 237s Removing autopkgtest-satdep (0) ... 238s autopkgtest [15:32:08]: test kpartx-file-loopback: [----------------------- 238s Formatting 'foo.img', fmt=raw size=20971520 239s Creating new GPT entries in memory. 239s Warning: The kernel is still using the old partition table. 239s The new table will be used at the next reboot or after you 239s run partprobe(8) or kpartx(8) 239s The operation has completed successfully. 240s add map loop0p1 (252:0): 0 38879 linear 7:0 2048 240s standard_filename: OK 240s del devmap : loop0p1 240s No devices found 240s standard_filename_cleanup: OK 240s Formatting 'fou du FaFa.img', fmt=raw size=20971520 241s Creating new GPT entries in memory. 241s Warning: The kernel is still using the old partition table. 241s The new table will be used at the next reboot or after you 241s run partprobe(8) or kpartx(8) 241s The operation has completed successfully. 241s add map loop0p1 (252:0): 0 38879 linear 7:0 2048 241s filename_with_spaces: OK 241s del devmap : loop0p1 241s No devices found 241s filename_with_spaces_cleanup: OK 242s autopkgtest [15:32:12]: test kpartx-file-loopback: -----------------------] 242s kpartx-file-loopback PASS 242s autopkgtest [15:32:12]: test kpartx-file-loopback: - - - - - - - - - - results - - - - - - - - - - 243s autopkgtest [15:32:13]: test tgtbasedmpaths: preparing testbed 360s autopkgtest [15:34:10]: testbed dpkg architecture: arm64 360s autopkgtest [15:34:10]: testbed apt version: 2.7.12 360s autopkgtest [15:34:10]: @@@@@@@@@@@@@@@@@@@@ test bed setup 360s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [117 kB] 361s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [51.4 kB] 361s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [473 kB] 361s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [3694 kB] 361s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [6540 B] 361s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 Packages [646 kB] 361s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 c-n-f Metadata [3144 B] 361s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted arm64 Packages [33.6 kB] 361s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted arm64 c-n-f Metadata [116 B] 361s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe arm64 Packages [4005 kB] 361s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/universe arm64 c-n-f Metadata [8528 B] 361s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/multiverse arm64 Packages [55.6 kB] 361s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/multiverse arm64 c-n-f Metadata [116 B] 363s Fetched 9095 kB in 2s (5292 kB/s) 364s Reading package lists... 366s Reading package lists... 367s Building dependency tree... 367s Reading state information... 367s Calculating upgrade... 368s The following package was automatically installed and is no longer required: 368s libnetplan0 368s Use 'sudo apt autoremove' to remove it. 368s The following packages will be REMOVED: 368s libglib2.0-0 libssl3 368s The following NEW packages will be installed: 368s libglib2.0-0t64 libnetplan1 libssl3t64 xdg-user-dirs 368s The following packages have been kept back: 368s curl 368s The following packages will be upgraded: 368s dbus dbus-bin dbus-daemon dbus-session-bus-common dbus-system-bus-common 368s dbus-user-session gir1.2-glib-2.0 libdbus-1-3 libglib2.0-data libnss-systemd 368s libpam-systemd libsystemd-shared libsystemd0 libudev1 netplan-generator 368s netplan.io openssh-client openssh-server openssh-sftp-server openssl 368s python3-netplan systemd systemd-dev systemd-resolved systemd-sysv 368s systemd-timesyncd ubuntu-minimal ubuntu-standard udev 368s 29 upgraded, 4 newly installed, 2 to remove and 1 not upgraded. 368s Need to get 15.5 MB of archives. 368s After this operation, 1128 kB of additional disk space will be used. 368s Get:1 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 gir1.2-glib-2.0 arm64 2.79.3-3ubuntu5 [182 kB] 369s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 python3-netplan arm64 1.0-1 [21.5 kB] 369s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 netplan-generator arm64 1.0-1 [58.8 kB] 369s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 netplan.io arm64 1.0-1 [65.4 kB] 369s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 libglib2.0-0t64 arm64 2.79.3-3ubuntu5 [1527 kB] 369s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 openssl arm64 3.0.13-0ubuntu1 [983 kB] 369s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 systemd-resolved arm64 255.4-1ubuntu5 [291 kB] 369s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 systemd-dev all 255.4-1ubuntu5 [103 kB] 369s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 libssl3t64 arm64 3.0.13-0ubuntu1 [1770 kB] 369s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 systemd arm64 255.4-1ubuntu5 [3403 kB] 369s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 udev arm64 255.4-1ubuntu5 [1852 kB] 369s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 systemd-sysv arm64 255.4-1ubuntu5 [11.9 kB] 369s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 libnss-systemd arm64 255.4-1ubuntu5 [154 kB] 369s Get:14 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 libpam-systemd arm64 255.4-1ubuntu5 [232 kB] 369s Get:15 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 openssh-sftp-server arm64 1:9.6p1-3ubuntu9 [36.8 kB] 369s Get:16 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 openssh-server arm64 1:9.6p1-3ubuntu9 [501 kB] 369s Get:17 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 openssh-client arm64 1:9.6p1-3ubuntu9 [884 kB] 369s Get:18 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 systemd-timesyncd arm64 255.4-1ubuntu5 [34.8 kB] 369s Get:19 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 libsystemd-shared arm64 255.4-1ubuntu5 [2016 kB] 369s Get:20 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 libudev1 arm64 255.4-1ubuntu5 [173 kB] 369s Get:21 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 dbus-session-bus-common all 1.14.10-4ubuntu2 [80.3 kB] 369s Get:22 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 dbus-user-session arm64 1.14.10-4ubuntu2 [9960 B] 369s Get:23 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 libsystemd0 arm64 255.4-1ubuntu5 [424 kB] 369s Get:24 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 dbus-daemon arm64 1.14.10-4ubuntu2 [115 kB] 369s Get:25 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 dbus-bin arm64 1.14.10-4ubuntu2 [38.8 kB] 369s Get:26 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 dbus-system-bus-common all 1.14.10-4ubuntu2 [81.5 kB] 369s Get:27 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 dbus arm64 1.14.10-4ubuntu2 [23.9 kB] 369s Get:28 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 libdbus-1-3 arm64 1.14.10-4ubuntu2 [210 kB] 369s Get:29 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 libglib2.0-data all 2.79.3-3ubuntu5 [46.6 kB] 369s Get:30 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 libnetplan1 arm64 1.0-1 [117 kB] 369s Get:31 http://ftpmaster.internal/ubuntu noble/main arm64 ubuntu-minimal arm64 1.536 [10.7 kB] 369s Get:32 http://ftpmaster.internal/ubuntu noble/main arm64 xdg-user-dirs arm64 0.18-1 [18.1 kB] 369s Get:33 http://ftpmaster.internal/ubuntu noble/main arm64 ubuntu-standard arm64 1.536 [10.7 kB] 370s Preconfiguring packages ... 370s Fetched 15.5 MB in 1s (10.3 MB/s) 370s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 74758 files and directories currently installed.) 370s Preparing to unpack .../gir1.2-glib-2.0_2.79.3-3ubuntu5_arm64.deb ... 370s Unpacking gir1.2-glib-2.0:arm64 (2.79.3-3ubuntu5) over (2.79.2-1~ubuntu1) ... 370s Preparing to unpack .../python3-netplan_1.0-1_arm64.deb ... 370s Unpacking python3-netplan (1.0-1) over (0.107.1-3) ... 371s Preparing to unpack .../netplan-generator_1.0-1_arm64.deb ... 371s Adding 'diversion of /lib/systemd/system-generators/netplan to /lib/systemd/system-generators/netplan.usr-is-merged by netplan-generator' 371s Unpacking netplan-generator (1.0-1) over (0.107.1-3) ... 371s Preparing to unpack .../netplan.io_1.0-1_arm64.deb ... 371s Unpacking netplan.io (1.0-1) over (0.107.1-3) ... 371s dpkg: libglib2.0-0:arm64: dependency problems, but removing anyway as you requested: 371s udisks2 depends on libglib2.0-0 (>= 2.77.0). 371s shared-mime-info depends on libglib2.0-0 (>= 2.75.3). 371s python3-gi depends on libglib2.0-0 (>= 2.77.0). 371s python3-dbus depends on libglib2.0-0 (>= 2.16.0). 371s libxmlb2:arm64 depends on libglib2.0-0 (>= 2.54.0). 371s libvolume-key1:arm64 depends on libglib2.0-0 (>= 2.18.0). 371s libudisks2-0:arm64 depends on libglib2.0-0 (>= 2.75.3). 371s libqrtr-glib0:arm64 depends on libglib2.0-0 (>= 2.56). 371s libqmi-proxy depends on libglib2.0-0 (>= 2.30.0). 371s libqmi-glib5:arm64 depends on libglib2.0-0 (>= 2.54.0). 371s libpolkit-gobject-1-0:arm64 depends on libglib2.0-0 (>= 2.38.0). 371s libpolkit-agent-1-0:arm64 depends on libglib2.0-0 (>= 2.38.0). 371s libnetplan0:arm64 depends on libglib2.0-0 (>= 2.75.3). 371s libmm-glib0:arm64 depends on libglib2.0-0 (>= 2.62.0). 371s libmbim-proxy depends on libglib2.0-0 (>= 2.56). 371s libmbim-glib4:arm64 depends on libglib2.0-0 (>= 2.56). 371s libjson-glib-1.0-0:arm64 depends on libglib2.0-0 (>= 2.75.3). 371s libjcat1:arm64 depends on libglib2.0-0 (>= 2.75.3). 371s libgusb2:arm64 depends on libglib2.0-0 (>= 2.75.3). 371s libgudev-1.0-0:arm64 depends on libglib2.0-0 (>= 2.38.0). 371s libgirepository-1.0-1:arm64 depends on libglib2.0-0 (>= 2.79.0). 371s libfwupd2:arm64 depends on libglib2.0-0 (>= 2.79.0). 371s libblockdev3:arm64 depends on libglib2.0-0 (>= 2.42.2). 371s libblockdev-utils3:arm64 depends on libglib2.0-0 (>= 2.75.3). 371s libblockdev-swap3:arm64 depends on libglib2.0-0 (>= 2.42.2). 371s libblockdev-part3:arm64 depends on libglib2.0-0 (>= 2.42.2). 371s libblockdev-nvme3:arm64 depends on libglib2.0-0 (>= 2.42.2). 371s libblockdev-mdraid3:arm64 depends on libglib2.0-0 (>= 2.42.2). 371s libblockdev-loop3:arm64 depends on libglib2.0-0 (>= 2.42.2). 371s libblockdev-fs3:arm64 depends on libglib2.0-0 (>= 2.42.2). 371s libblockdev-crypto3:arm64 depends on libglib2.0-0 (>= 2.42.2). 371s fwupd depends on libglib2.0-0 (>= 2.79.0). 371s bolt depends on libglib2.0-0 (>= 2.56.0). 371s 371s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 74760 files and directories currently installed.) 371s Removing libglib2.0-0:arm64 (2.79.2-1~ubuntu1) ... 371s Selecting previously unselected package libglib2.0-0t64:arm64. 371s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 74735 files and directories currently installed.) 371s Preparing to unpack .../libglib2.0-0t64_2.79.3-3ubuntu5_arm64.deb ... 371s libglib2.0-0t64.preinst: Removing /var/lib/dpkg/info/libglib2.0-0:arm64.postrm to avoid loss of /usr/share/glib-2.0/schemas/gschemas.compiled... 371s removed '/var/lib/dpkg/info/libglib2.0-0:arm64.postrm' 371s Unpacking libglib2.0-0t64:arm64 (2.79.3-3ubuntu5) ... 371s Preparing to unpack .../openssl_3.0.13-0ubuntu1_arm64.deb ... 371s Unpacking openssl (3.0.13-0ubuntu1) over (3.0.10-1ubuntu4) ... 371s Preparing to unpack .../systemd-resolved_255.4-1ubuntu5_arm64.deb ... 371s Unpacking systemd-resolved (255.4-1ubuntu5) over (255.2-3ubuntu2) ... 371s Preparing to unpack .../systemd-dev_255.4-1ubuntu5_all.deb ... 371s Unpacking systemd-dev (255.4-1ubuntu5) over (255.2-3ubuntu2) ... 371s dpkg: libssl3:arm64: dependency problems, but removing anyway as you requested: 371s wget depends on libssl3 (>= 3.0.0). 371s u-boot-tools depends on libssl3 (>= 3.0.0). 371s tnftp depends on libssl3 (>= 3.0.0). 371s tcpdump depends on libssl3 (>= 3.0.0). 371s systemd depends on libssl3 (>= 3.0.0). 371s sudo depends on libssl3 (>= 3.0.0). 371s sbsigntool depends on libssl3 (>= 3.0.0). 371s rsync depends on libssl3 (>= 3.0.0). 371s python3-cryptography depends on libssl3 (>= 3.0.0). 371s openssh-server depends on libssl3 (>= 3.0.10). 371s openssh-client depends on libssl3 (>= 3.0.10). 371s mtd-utils depends on libssl3 (>= 3.0.0). 371s mokutil depends on libssl3 (>= 3.0.0). 371s linux-headers-6.8.0-11-generic depends on libssl3 (>= 3.0.0). 371s libsystemd-shared:arm64 depends on libssl3 (>= 3.0.0). 371s libssh-4:arm64 depends on libssl3 (>= 3.0.0). 371s libsasl2-modules:arm64 depends on libssl3 (>= 3.0.0). 371s libsasl2-2:arm64 depends on libssl3 (>= 3.0.0). 371s libpython3.12-minimal:arm64 depends on libssl3 (>= 3.0.0). 371s libnvme1 depends on libssl3 (>= 3.0.0). 371s libkrb5-3:arm64 depends on libssl3 (>= 3.0.0). 371s libkmod2:arm64 depends on libssl3 (>= 3.0.0). 371s libfido2-1:arm64 depends on libssl3 (>= 3.0.0). 371s libcurl4:arm64 depends on libssl3 (>= 3.0.0). 371s libcryptsetup12:arm64 depends on libssl3 (>= 3.0.0). 371s kmod depends on libssl3 (>= 3.0.0). 371s dhcpcd-base depends on libssl3 (>= 3.0.0). 371s bind9-libs:arm64 depends on libssl3 (>= 3.0.0). 371s 372s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 74760 files and directories currently installed.) 372s Removing libssl3:arm64 (3.0.10-1ubuntu4) ... 372s Selecting previously unselected package libssl3t64:arm64. 372s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 74749 files and directories currently installed.) 372s Preparing to unpack .../libssl3t64_3.0.13-0ubuntu1_arm64.deb ... 372s Unpacking libssl3t64:arm64 (3.0.13-0ubuntu1) ... 372s Setting up libssl3t64:arm64 (3.0.13-0ubuntu1) ... 372s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 74762 files and directories currently installed.) 372s Preparing to unpack .../systemd_255.4-1ubuntu5_arm64.deb ... 372s Unpacking systemd (255.4-1ubuntu5) over (255.2-3ubuntu2) ... 372s Preparing to unpack .../udev_255.4-1ubuntu5_arm64.deb ... 372s Unpacking udev (255.4-1ubuntu5) over (255.2-3ubuntu2) ... 372s Preparing to unpack .../libsystemd-shared_255.4-1ubuntu5_arm64.deb ... 372s Unpacking libsystemd-shared:arm64 (255.4-1ubuntu5) over (255.2-3ubuntu2) ... 372s Setting up libsystemd-shared:arm64 (255.4-1ubuntu5) ... 372s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 74762 files and directories currently installed.) 372s Preparing to unpack .../libsystemd0_255.4-1ubuntu5_arm64.deb ... 372s Unpacking libsystemd0:arm64 (255.4-1ubuntu5) over (255.2-3ubuntu2) ... 372s Setting up libsystemd0:arm64 (255.4-1ubuntu5) ... 372s Setting up systemd-dev (255.4-1ubuntu5) ... 372s Setting up systemd (255.4-1ubuntu5) ... 374s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 74762 files and directories currently installed.) 374s Preparing to unpack .../0-systemd-sysv_255.4-1ubuntu5_arm64.deb ... 374s Unpacking systemd-sysv (255.4-1ubuntu5) over (255.2-3ubuntu2) ... 374s Preparing to unpack .../1-libnss-systemd_255.4-1ubuntu5_arm64.deb ... 374s Unpacking libnss-systemd:arm64 (255.4-1ubuntu5) over (255.2-3ubuntu2) ... 374s Preparing to unpack .../2-libpam-systemd_255.4-1ubuntu5_arm64.deb ... 374s Unpacking libpam-systemd:arm64 (255.4-1ubuntu5) over (255.2-3ubuntu2) ... 374s Preparing to unpack .../3-openssh-sftp-server_1%3a9.6p1-3ubuntu9_arm64.deb ... 374s Unpacking openssh-sftp-server (1:9.6p1-3ubuntu9) over (1:9.6p1-3ubuntu2) ... 374s Preparing to unpack .../4-openssh-server_1%3a9.6p1-3ubuntu9_arm64.deb ... 374s Unpacking openssh-server (1:9.6p1-3ubuntu9) over (1:9.6p1-3ubuntu2) ... 374s Preparing to unpack .../5-openssh-client_1%3a9.6p1-3ubuntu9_arm64.deb ... 374s Unpacking openssh-client (1:9.6p1-3ubuntu9) over (1:9.6p1-3ubuntu2) ... 374s Preparing to unpack .../6-systemd-timesyncd_255.4-1ubuntu5_arm64.deb ... 374s Unpacking systemd-timesyncd (255.4-1ubuntu5) over (255.2-3ubuntu2) ... 374s Preparing to unpack .../7-libudev1_255.4-1ubuntu5_arm64.deb ... 374s Unpacking libudev1:arm64 (255.4-1ubuntu5) over (255.2-3ubuntu2) ... 374s Setting up libudev1:arm64 (255.4-1ubuntu5) ... 374s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 74762 files and directories currently installed.) 374s Preparing to unpack .../00-dbus-session-bus-common_1.14.10-4ubuntu2_all.deb ... 374s Unpacking dbus-session-bus-common (1.14.10-4ubuntu2) over (1.14.10-4ubuntu1) ... 374s Preparing to unpack .../01-dbus-user-session_1.14.10-4ubuntu2_arm64.deb ... 374s Unpacking dbus-user-session (1.14.10-4ubuntu2) over (1.14.10-4ubuntu1) ... 374s Preparing to unpack .../02-dbus-daemon_1.14.10-4ubuntu2_arm64.deb ... 374s Unpacking dbus-daemon (1.14.10-4ubuntu2) over (1.14.10-4ubuntu1) ... 374s Preparing to unpack .../03-dbus-bin_1.14.10-4ubuntu2_arm64.deb ... 374s Unpacking dbus-bin (1.14.10-4ubuntu2) over (1.14.10-4ubuntu1) ... 374s Preparing to unpack .../04-dbus-system-bus-common_1.14.10-4ubuntu2_all.deb ... 374s Unpacking dbus-system-bus-common (1.14.10-4ubuntu2) over (1.14.10-4ubuntu1) ... 374s Preparing to unpack .../05-dbus_1.14.10-4ubuntu2_arm64.deb ... 374s Unpacking dbus (1.14.10-4ubuntu2) over (1.14.10-4ubuntu1) ... 374s Preparing to unpack .../06-libdbus-1-3_1.14.10-4ubuntu2_arm64.deb ... 374s Unpacking libdbus-1-3:arm64 (1.14.10-4ubuntu2) over (1.14.10-4ubuntu1) ... 374s Preparing to unpack .../07-libglib2.0-data_2.79.3-3ubuntu5_all.deb ... 374s Unpacking libglib2.0-data (2.79.3-3ubuntu5) over (2.79.2-1~ubuntu1) ... 374s Selecting previously unselected package libnetplan1:arm64. 374s Preparing to unpack .../08-libnetplan1_1.0-1_arm64.deb ... 374s Unpacking libnetplan1:arm64 (1.0-1) ... 375s Preparing to unpack .../09-ubuntu-minimal_1.536_arm64.deb ... 375s Unpacking ubuntu-minimal (1.536) over (1.535) ... 375s Selecting previously unselected package xdg-user-dirs. 375s Preparing to unpack .../10-xdg-user-dirs_0.18-1_arm64.deb ... 375s Unpacking xdg-user-dirs (0.18-1) ... 375s Preparing to unpack .../11-ubuntu-standard_1.536_arm64.deb ... 375s Unpacking ubuntu-standard (1.536) over (1.535) ... 375s Setting up systemd-sysv (255.4-1ubuntu5) ... 375s Setting up xdg-user-dirs (0.18-1) ... 375s Setting up openssh-client (1:9.6p1-3ubuntu9) ... 375s Setting up libnss-systemd:arm64 (255.4-1ubuntu5) ... 375s Setting up libglib2.0-0t64:arm64 (2.79.3-3ubuntu5) ... 375s No schema files found: doing nothing. 375s Setting up libglib2.0-data (2.79.3-3ubuntu5) ... 375s Setting up libdbus-1-3:arm64 (1.14.10-4ubuntu2) ... 375s Setting up systemd-timesyncd (255.4-1ubuntu5) ... 376s Setting up udev (255.4-1ubuntu5) ... 377s Setting up gir1.2-glib-2.0:arm64 (2.79.3-3ubuntu5) ... 377s Setting up dbus-session-bus-common (1.14.10-4ubuntu2) ... 377s Setting up dbus-system-bus-common (1.14.10-4ubuntu2) ... 377s Setting up openssl (3.0.13-0ubuntu1) ... 377s Setting up dbus-bin (1.14.10-4ubuntu2) ... 377s Setting up openssh-sftp-server (1:9.6p1-3ubuntu9) ... 377s Setting up openssh-server (1:9.6p1-3ubuntu9) ... 377s Replacing config file /etc/ssh/sshd_config with new version 379s Created symlink /etc/systemd/system/ssh.service.requires/ssh.socket → /usr/lib/systemd/system/ssh.socket. 380s Setting up dbus-daemon (1.14.10-4ubuntu2) ... 380s Setting up libnetplan1:arm64 (1.0-1) ... 380s Setting up dbus (1.14.10-4ubuntu2) ... 380s A reboot is required to replace the running dbus-daemon. 380s Please reboot the system when convenient. 380s Setting up libpam-systemd:arm64 (255.4-1ubuntu5) ... 381s Setting up python3-netplan (1.0-1) ... 381s Setting up netplan-generator (1.0-1) ... 381s Removing 'diversion of /lib/systemd/system-generators/netplan to /lib/systemd/system-generators/netplan.usr-is-merged by netplan-generator' 381s Setting up systemd-resolved (255.4-1ubuntu5) ... 382s Setting up ubuntu-standard (1.536) ... 382s Setting up netplan.io (1.0-1) ... 382s Setting up dbus-user-session (1.14.10-4ubuntu2) ... 382s Setting up ubuntu-minimal (1.536) ... 382s Processing triggers for ufw (0.36.2-5) ... 382s Processing triggers for man-db (2.12.0-3) ... 383s Processing triggers for initramfs-tools (0.142ubuntu20) ... 383s update-initramfs: Generating /boot/initrd.img-6.8.0-11-generic 383s W: No lz4 in /usr/bin:/sbin:/bin, using gzip 397s System running in EFI mode, skipping. 397s Processing triggers for libc-bin (2.39-0ubuntu2) ... 397s Reading package lists... 398s Building dependency tree... 398s Reading state information... 398s The following packages will be REMOVED: 398s libnetplan0* 399s 0 upgraded, 0 newly installed, 1 to remove and 1 not upgraded. 399s After this operation, 357 kB disk space will be freed. 399s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 74778 files and directories currently installed.) 399s Removing libnetplan0:arm64 (0.107.1-3) ... 399s Processing triggers for libc-bin (2.39-0ubuntu2) ... 400s sh: Attempting to set up Debian/Ubuntu apt sources automatically 400s sh: Distribution appears to be Ubuntu 401s Reading package lists... 401s Building dependency tree... 401s Reading state information... 402s eatmydata is already the newest version (131-1). 402s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 402s Reading package lists... 402s Building dependency tree... 402s Reading state information... 403s dbus is already the newest version (1.14.10-4ubuntu2). 403s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 403s Reading package lists... 403s Building dependency tree... 403s Reading state information... 404s rng-tools-debian is already the newest version (2.4). 404s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 404s Reading package lists... 404s Building dependency tree... 404s Reading state information... 404s The following packages will be REMOVED: 404s cloud-init* python3-configobj* python3-debconf* 405s 0 upgraded, 0 newly installed, 3 to remove and 0 not upgraded. 405s After this operation, 3252 kB disk space will be freed. 405s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 74774 files and directories currently installed.) 405s Removing cloud-init (24.1.1-0ubuntu1) ... 405s Removing python3-configobj (5.0.8-3) ... 406s Removing python3-debconf (1.5.86) ... 406s Processing triggers for man-db (2.12.0-3) ... 406s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 74385 files and directories currently installed.) 406s Purging configuration files for cloud-init (24.1.1-0ubuntu1) ... 406s dpkg: warning: while removing cloud-init, directory '/etc/cloud/cloud.cfg.d' not empty so not removed 407s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ... 407s invoke-rc.d: policy-rc.d denied execution of try-restart. 407s Reading package lists... 407s Building dependency tree... 407s Reading state information... 408s linux-generic is already the newest version (6.8.0-11.11+1). 408s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 408s Hit:1 http://ftpmaster.internal/ubuntu noble InRelease 408s Hit:2 http://ftpmaster.internal/ubuntu noble-updates InRelease 408s Hit:3 http://ftpmaster.internal/ubuntu noble-security InRelease 411s Reading package lists... 411s Reading package lists... 411s Building dependency tree... 411s Reading state information... 412s Calculating upgrade... 412s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 412s Reading package lists... 412s Building dependency tree... 412s Reading state information... 413s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 413s autopkgtest [15:35:03]: rebooting testbed after setup commands that affected boot 445s Reading package lists... 446s Building dependency tree... 446s Reading state information... 446s Starting pkgProblemResolver with broken count: 0 446s Starting 2 pkgProblemResolver with broken count: 0 446s Done 447s The following additional packages will be installed: 447s fio libboost-iostreams1.83.0 libboost-thread1.83.0 libconfig-general-perl 447s libdaxctl1 libgfapi0 libgfrpc0 libgfxdr0 libglusterfs0 libisns0 libnbd0 447s libndctl6 libopeniscsiusr libpmem1 libpmemobj1 librados2 librbd1 librdmacm1 447s lsscsi open-iscsi tgt 447s Suggested packages: 447s fio-examples gnuplot tgt-glusterfs tgt-rbd 447s Recommended packages: 447s finalrd 447s The following NEW packages will be installed: 447s autopkgtest-satdep fio libboost-iostreams1.83.0 libboost-thread1.83.0 447s libconfig-general-perl libdaxctl1 libgfapi0 libgfrpc0 libgfxdr0 447s libglusterfs0 libisns0 libnbd0 libndctl6 libopeniscsiusr libpmem1 447s libpmemobj1 librados2 librbd1 librdmacm1 lsscsi open-iscsi tgt 447s 0 upgraded, 22 newly installed, 0 to remove and 0 not upgraded. 447s Need to get 10.2 MB/10.2 MB of archives. 447s After this operation, 43.0 MB of additional disk space will be used. 447s Get:1 /tmp/autopkgtest.phKdtC/2-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [728 B] 447s Get:2 http://ftpmaster.internal/ubuntu noble/main arm64 libopeniscsiusr arm64 2.1.9-3ubuntu1 [47.2 kB] 447s Get:3 http://ftpmaster.internal/ubuntu noble/main arm64 libisns0 arm64 0.101-0.2 [93.8 kB] 447s Get:4 http://ftpmaster.internal/ubuntu noble/main arm64 open-iscsi arm64 2.1.9-3ubuntu1 [336 kB] 447s Get:5 http://ftpmaster.internal/ubuntu noble/main arm64 librdmacm1 arm64 50.0-1 [70.4 kB] 448s Get:6 http://ftpmaster.internal/ubuntu noble/universe arm64 libconfig-general-perl all 2.65-2 [57.1 kB] 448s Get:7 http://ftpmaster.internal/ubuntu noble/universe arm64 tgt arm64 1:1.0.85-1.1ubuntu2 [232 kB] 448s Get:8 http://ftpmaster.internal/ubuntu noble/universe arm64 libgfxdr0 arm64 11.1-4 [19.3 kB] 448s Get:9 http://ftpmaster.internal/ubuntu noble/universe arm64 libglusterfs0 arm64 11.1-4 [266 kB] 448s Get:10 http://ftpmaster.internal/ubuntu noble/universe arm64 libgfrpc0 arm64 11.1-4 [41.0 kB] 448s Get:11 http://ftpmaster.internal/ubuntu noble/universe arm64 libgfapi0 arm64 11.1-4 [78.4 kB] 448s Get:12 http://ftpmaster.internal/ubuntu noble/universe arm64 libnbd0 arm64 1.18.2-1build1 [87.3 kB] 448s Get:13 http://ftpmaster.internal/ubuntu noble/main arm64 libdaxctl1 arm64 77-2ubuntu1 [21.1 kB] 448s Get:14 http://ftpmaster.internal/ubuntu noble/main arm64 libndctl6 arm64 77-2ubuntu1 [63.1 kB] 448s Get:15 http://ftpmaster.internal/ubuntu noble/main arm64 libpmem1 arm64 1.13.1-1.1 [35.4 kB] 448s Get:16 http://ftpmaster.internal/ubuntu noble/main arm64 libboost-iostreams1.83.0 arm64 1.83.0-2ubuntu1 [339 kB] 448s Get:17 http://ftpmaster.internal/ubuntu noble/main arm64 libboost-thread1.83.0 arm64 1.83.0-2ubuntu1 [358 kB] 448s Get:18 http://ftpmaster.internal/ubuntu noble/main arm64 librados2 arm64 18.2.0-0ubuntu7 [3645 kB] 448s Get:19 http://ftpmaster.internal/ubuntu noble/main arm64 libpmemobj1 arm64 1.13.1-1.1 [115 kB] 448s Get:20 http://ftpmaster.internal/ubuntu noble/main arm64 librbd1 arm64 18.2.0-0ubuntu7 [3659 kB] 448s Get:21 http://ftpmaster.internal/ubuntu noble/universe arm64 fio arm64 3.36-1 [589 kB] 448s Get:22 http://ftpmaster.internal/ubuntu noble/main arm64 lsscsi arm64 0.32-1 [48.4 kB] 448s Preconfiguring packages ... 448s Fetched 10.2 MB in 1s (10.4 MB/s) 449s Selecting previously unselected package libopeniscsiusr. 449s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 74330 files and directories currently installed.) 449s Preparing to unpack .../00-libopeniscsiusr_2.1.9-3ubuntu1_arm64.deb ... 449s Unpacking libopeniscsiusr (2.1.9-3ubuntu1) ... 449s Selecting previously unselected package libisns0:arm64. 449s Preparing to unpack .../01-libisns0_0.101-0.2_arm64.deb ... 449s Unpacking libisns0:arm64 (0.101-0.2) ... 449s Selecting previously unselected package open-iscsi. 449s Preparing to unpack .../02-open-iscsi_2.1.9-3ubuntu1_arm64.deb ... 449s Unpacking open-iscsi (2.1.9-3ubuntu1) ... 449s Selecting previously unselected package librdmacm1:arm64. 449s Preparing to unpack .../03-librdmacm1_50.0-1_arm64.deb ... 449s Unpacking librdmacm1:arm64 (50.0-1) ... 449s Selecting previously unselected package libconfig-general-perl. 449s Preparing to unpack .../04-libconfig-general-perl_2.65-2_all.deb ... 449s Unpacking libconfig-general-perl (2.65-2) ... 449s Selecting previously unselected package tgt. 449s Preparing to unpack .../05-tgt_1%3a1.0.85-1.1ubuntu2_arm64.deb ... 449s Unpacking tgt (1:1.0.85-1.1ubuntu2) ... 449s Selecting previously unselected package libgfxdr0:arm64. 449s Preparing to unpack .../06-libgfxdr0_11.1-4_arm64.deb ... 449s Unpacking libgfxdr0:arm64 (11.1-4) ... 449s Selecting previously unselected package libglusterfs0:arm64. 449s Preparing to unpack .../07-libglusterfs0_11.1-4_arm64.deb ... 449s Unpacking libglusterfs0:arm64 (11.1-4) ... 449s Selecting previously unselected package libgfrpc0:arm64. 449s Preparing to unpack .../08-libgfrpc0_11.1-4_arm64.deb ... 449s Unpacking libgfrpc0:arm64 (11.1-4) ... 449s Selecting previously unselected package libgfapi0:arm64. 449s Preparing to unpack .../09-libgfapi0_11.1-4_arm64.deb ... 449s Unpacking libgfapi0:arm64 (11.1-4) ... 449s Selecting previously unselected package libnbd0. 449s Preparing to unpack .../10-libnbd0_1.18.2-1build1_arm64.deb ... 449s Unpacking libnbd0 (1.18.2-1build1) ... 449s Selecting previously unselected package libdaxctl1:arm64. 449s Preparing to unpack .../11-libdaxctl1_77-2ubuntu1_arm64.deb ... 449s Unpacking libdaxctl1:arm64 (77-2ubuntu1) ... 449s Selecting previously unselected package libndctl6:arm64. 449s Preparing to unpack .../12-libndctl6_77-2ubuntu1_arm64.deb ... 449s Unpacking libndctl6:arm64 (77-2ubuntu1) ... 449s Selecting previously unselected package libpmem1:arm64. 449s Preparing to unpack .../13-libpmem1_1.13.1-1.1_arm64.deb ... 449s Unpacking libpmem1:arm64 (1.13.1-1.1) ... 449s Selecting previously unselected package libboost-iostreams1.83.0:arm64. 449s Preparing to unpack .../14-libboost-iostreams1.83.0_1.83.0-2ubuntu1_arm64.deb ... 449s Unpacking libboost-iostreams1.83.0:arm64 (1.83.0-2ubuntu1) ... 449s Selecting previously unselected package libboost-thread1.83.0:arm64. 449s Preparing to unpack .../15-libboost-thread1.83.0_1.83.0-2ubuntu1_arm64.deb ... 449s Unpacking libboost-thread1.83.0:arm64 (1.83.0-2ubuntu1) ... 449s Selecting previously unselected package librados2. 449s Preparing to unpack .../16-librados2_18.2.0-0ubuntu7_arm64.deb ... 449s Unpacking librados2 (18.2.0-0ubuntu7) ... 449s Selecting previously unselected package libpmemobj1:arm64. 450s Preparing to unpack .../17-libpmemobj1_1.13.1-1.1_arm64.deb ... 450s Unpacking libpmemobj1:arm64 (1.13.1-1.1) ... 450s Selecting previously unselected package librbd1. 450s Preparing to unpack .../18-librbd1_18.2.0-0ubuntu7_arm64.deb ... 450s Unpacking librbd1 (18.2.0-0ubuntu7) ... 450s Selecting previously unselected package fio. 450s Preparing to unpack .../19-fio_3.36-1_arm64.deb ... 450s Unpacking fio (3.36-1) ... 450s Selecting previously unselected package lsscsi. 450s Preparing to unpack .../20-lsscsi_0.32-1_arm64.deb ... 450s Unpacking lsscsi (0.32-1) ... 450s Selecting previously unselected package autopkgtest-satdep. 450s Preparing to unpack .../21-2-autopkgtest-satdep.deb ... 450s Unpacking autopkgtest-satdep (0) ... 450s Setting up librdmacm1:arm64 (50.0-1) ... 450s Setting up libconfig-general-perl (2.65-2) ... 450s Setting up libboost-thread1.83.0:arm64 (1.83.0-2ubuntu1) ... 450s Setting up libnbd0 (1.18.2-1build1) ... 450s Setting up libopeniscsiusr (2.1.9-3ubuntu1) ... 450s Setting up libglusterfs0:arm64 (11.1-4) ... 450s Setting up libboost-iostreams1.83.0:arm64 (1.83.0-2ubuntu1) ... 450s Setting up lsscsi (0.32-1) ... 450s Setting up libdaxctl1:arm64 (77-2ubuntu1) ... 450s Setting up libisns0:arm64 (0.101-0.2) ... 450s Setting up libndctl6:arm64 (77-2ubuntu1) ... 450s Setting up tgt (1:1.0.85-1.1ubuntu2) ... 450s Created symlink /etc/systemd/system/multi-user.target.wants/tgt.service → /usr/lib/systemd/system/tgt.service. 452s Setting up libpmem1:arm64 (1.13.1-1.1) ... 452s Setting up libgfxdr0:arm64 (11.1-4) ... 452s Setting up librados2 (18.2.0-0ubuntu7) ... 452s Setting up open-iscsi (2.1.9-3ubuntu1) ... 453s Created symlink /etc/systemd/system/sockets.target.wants/iscsid.socket → /usr/lib/systemd/system/iscsid.socket. 453s Created symlink /etc/systemd/system/iscsi.service → /usr/lib/systemd/system/open-iscsi.service. 453s Created symlink /etc/systemd/system/sysinit.target.wants/open-iscsi.service → /usr/lib/systemd/system/open-iscsi.service. 453s Setting up libpmemobj1:arm64 (1.13.1-1.1) ... 453s Setting up librbd1 (18.2.0-0ubuntu7) ... 453s Setting up libgfrpc0:arm64 (11.1-4) ... 453s Setting up libgfapi0:arm64 (11.1-4) ... 453s Setting up fio (3.36-1) ... 454s Setting up autopkgtest-satdep (0) ... 454s Processing triggers for man-db (2.12.0-3) ... 455s Processing triggers for initramfs-tools (0.142ubuntu20) ... 455s update-initramfs: Generating /boot/initrd.img-6.8.0-11-generic 455s W: No lz4 in /usr/bin:/sbin:/bin, using gzip 470s System running in EFI mode, skipping. 470s Processing triggers for libc-bin (2.39-0ubuntu2) ... 474s (Reading database ... 74568 files and directories currently installed.) 474s Removing autopkgtest-satdep (0) ... 476s autopkgtest [15:36:06]: test tgtbasedmpaths: [----------------------- 476s + targetname=iqn.2016-11.foo.com:target.iscsi 476s + pwd 476s + cwd=/tmp/autopkgtest.phKdtC/build.ZJl/src 476s + testdir=/mnt/tgtmpathtest 476s + localhost=127.0.0.1 476s + portal=127.0.0.1:3260 476s + maxpaths=4 476s + backfn=backingfile 476s + expectwwid=60000000000000000e00000000010001 476s + testdisk=/dev/disk/by-id/wwn-0x60000000000000000e00000000010001 476s + bglog=/tmp/autopkgtest.phKdtC/tgtbasedmpaths-artifacts/test-background.log 476s + fioprep=/tmp/autopkgtest.phKdtC/tgtbasedmpaths-artifacts/path-change-prep.fio 476s + fiovrfy=/tmp/autopkgtest.phKdtC/tgtbasedmpaths-artifacts/path-change-check.fio 476s + service tgt restart 477s + truncate --size 100M backingfile 477s + tgtadm --lld iscsi --op new --mode target --tid 1 -T iqn.2016-11.foo.com:target.iscsi 477s + tgtadm --lld iscsi --op bind --mode target --tid 1 -I ALL 477s + tgtadm --lld iscsi --op new --mode logicalunit --tid 1 --lun 1 -b /tmp/autopkgtest.phKdtC/build.ZJl/src/backingfile 477s + iscsiadm --mode discovery --type sendtargets --portal 127.0.0.1 477s 127.0.0.1:3260,1 iqn.2016-11.foo.com:target.iscsi 477s login #1 477s + echo login #1 477s + iscsiadm --mode node --targetname iqn.2016-11.foo.com:target.iscsi --portal 127.0.0.1:3260 --login 477s Logging in to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] 477s Login to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] successful. 477s + seq 2 4 477s extra login #2 477s + echo extra login #2 477s + iscsiadm --mode session -r 1 --op new 477s Logging in to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] (multiple) 477s Login to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] successful. 477s extra login #3 477s + echo extra login #3 477s + iscsiadm --mode session -r 1 --op new 477s Logging in to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] (multiple) 477s Login to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] successful. 477s extra login #4 477s + echo extra login #4 477s + iscsiadm --mode session -r 1 --op new 477s Logging in to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] (multiple) 477s Login to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] successful. 477s + udevadm settle 478s + sleep 5 483s Status after initial setup 483s + echo Status after initial setup 483s + tgtadm --lld iscsi --mode target --op show 483s + tgtadm --lldTarget 1: iqn.2016-11.foo.com:target.iscsi 483s System information: 483s Driver: iscsi 483s State: ready 483s I_T nexus information: 483s I_T nexus: 1 483s Initiator: iqn.2004-10.com.ubuntu:01:7767d33bf963 alias: autopkgtest 483s Connection: 0 483s IP Address: 127.0.0.1 483s I_T nexus: 2 483s Initiator: iqn.2004-10.com.ubuntu:01:7767d33bf963 alias: autopkgtest 483s Connection: 0 483s IP Address: 127.0.0.1 483s I_T nexus: 3 483s Initiator: iqn.2004-10.com.ubuntu:01:7767d33bf963 alias: autopkgtest 483s Connection: 0 483s IP Address: 127.0.0.1 483s I_T nexus: 4 483s Initiator: iqn.2004-10.com.ubuntu:01:7767d33bf963 alias: autopkgtest 483s Connection: 0 483s IP Address: 127.0.0.1 483s LUN information: 483s LUN: 0 483s Type: controller 483s SCSI ID: IET 00010000 483s SCSI SN: beaf10 483s Size: 0 MB, Block size: 1 483s Online: Yes 483s Removable media: No 483s Prevent removal: No 483s Readonly: No 483s SWP: No 483s Thin-provisioning: No 483s Backing store type: null 483s Backing store path: None 483s Backing store flags: 483s LUN: 1 483s Type: disk 483s SCSI ID: IET 00010001 483s SCSI SN: beaf11 483s Size: 105 MB, Block size: 512 483s Online: Yes 483s Removable media: No 483s Prevent removal: No 483s Readonly: No 483s SWP: No 483s Thin-provisioning: No 483s Backing store type: rdwr 483s Backing store path: /tmp/autopkgtest.phKdtC/build.ZJl/src/backingfile 483s Backing store flags: 483s Account information: 483s ACL information: 483s ALL 483s iscsi --op show --mode conn --tid 1 483s + Session: 4 483s Connection: 0 483s Initiator: iqn.2004-10.com.ubuntu:01:7767d33bf963 483s IP Address: 127.0.0.1 483s Session: 3 483s Connection: 0 483s Initiator: iqn.2004-10.com.ubuntu:01:7767d33bf963 483s IP Address: 127.0.0.1 483s Session: 2 483s Connection: 0 483s Initiator: iqn.2004-10.com.ubuntu:01:7767d33bf963 483s IP Address: 127.0.0.1 483s Session: 1 483s Connection: 0 483s Initiator: iqn.2004-10.com.ubuntu:01:7767d33bf963 483s IP Address: 127.0.0.1 483s iscsiadm --mode session -P 1 483s Target: iqn.2016-11.foo.com:target.iscsi (non-flash) 483s Current Portal: 127.0.0.1:3260,1 483s Persistent Portal: 127.0.0.1:3260,1 483s ********** 483s Interface: 483s ********** 483s Iface Name: default 483s Iface Transport: tcp 483s Iface Initiatorname: iqn.2004-10.com.ubuntu:01:7767d33bf963 483s Iface IPaddress: 127.0.0.1 483s Iface HWaddress: default 483s Iface Netdev: default 483s SID: 1 483s iSCSI Connection State: LOGGED IN 483s iSCSI Session State: LOGGED_IN 483s Internal iscsid Session State: NO CHANGE 483s 483s ********** 483s Interface: 483s ********** 483s Iface Name: default 483s Iface Transport: tcp 483s Iface Initiatorname: iqn.2004-10.com.ubuntu:01:7767d33bf963 483s Iface IPaddress: 127.0.0.1 483s Iface HWaddress: default 483s Iface Netdev: default 483s SID: 2 483s iSCSI Connection State: LOGGED IN 483s iSCSI Session State: LOGGED_IN 483s Internal iscsid Session State: NO CHANGE 483s 483s ********** 483s Interface: 483s ********** 483s Iface Name: default 483s Iface Transport: tcp 483s Iface Initiatorname: iqn.2004-10.com.ubuntu:01:7767d33bf963 483s Iface IPaddress: 127.0.0.1 483s Iface HWaddress: default 483s Iface Netdev: default 483s SID: 3 483s iSCSI Connection State: LOGGED IN 483s iSCSI Session State: LOGGED_IN 483s Internal iscsid Session State: NO CHANGE 483s 483s ********** 483s Interface: 483s ********** 483s Iface Name: default 483s Iface Transport: tcp 483s Iface Initiatorname: iqn.2004-10.com.ubuntu:01:7767d33bf963 483s Iface IPaddress: 127.0.0.1 483s Iface HWaddress: default 483s Iface Netdev: default 483s SID: 4 483s iSCSI Connection State: LOGGED IN 483s iSCSI Session State: LOGGED_IN 483s Internal iscsid Session State: NO CHANGE 483s [0:0:0:0] storage IET Controller 0001 - - 483s state=running queue_depth=32 scsi_level=6 type=12 device_blocked=0 timeout=30 483s dir: /sys/bus/scsi/devices/0:0:0:0 [/sys/devices/platform/host0/session1/target0:0:0/0:0:0:0] 483s [0:0:0:1] disk IET VIRTUAL-DISK 0001 /dev/sda 360000000000000000e00000000010001 483s state=running queue_depth=32 scsi_level=6 type=0 device_blocked=0 timeout=30 483s dir: /sys/bus/scsi/devices/0:0:0:1 [/sys/devices/platform/host0/session1/target0:0:0/0:0:0:1] 483s [1:0:0:0] storage IET Controller 0001 - - 483s state=running queue_depth=32 scsi_level=6 type=12 device_blocked=0 timeout=30 483s dir: /sys/bus/scsi/devices/1:0:0:0 [/sys/devices/platform/host1/session2/target1:0:0/1:0:0:0] 483s [1:0:0:1] disk IET VIRTUAL-DISK 0001 /dev/sdb 360000000000000000e00000000010001 483s state=running queue_depth=32 scsi_level=6 type=0 device_blocked=0 timeout=30 483s dir: /sys/bus/scsi/devices/1:0:0:1 [/sys/devices/platform/host1/session2/target1:0:0/1:0:0:1] 483s [2:0:0:0] storage IET Controller 0001 - - 483s state=running queue_depth=32 scsi_level=6 type=12 device_blocked=0 timeout=30 483s dir: /sys/bus/scsi/devices/2:0:0:0 [/sys/devices/platform/host2/session3/target2:0:0/2:0:0:0] 483s [2:0:0:1] disk IET VIRTUAL-DISK 0001 /dev/sdc 33000000100000001 483s state=running queue_depth=32 scsi_level=6 type=0 device_blocked=0 timeout=30 483s dir: /sys/bus/scsi/devices/2:0:0:1 [/sys/devices/platform/host2/session3/target2:0:0/2:0:0:1] 483s [3:0:0:0] storage IET Controller 0001 - - 483s state=running queue_depth=32 scsi_level=6 type=12 device_blocked=0 timeout=30 483s dir: /sys/bus/scsi/devices/3:0:0:0 [/sys/devices/platform/host3/session4/target3:0:0/3:0:0:0] 483s [3:0:0:1] disk IET VIRTUAL-DISK 0001 /dev/sdd 360000000000000000e00000000010001 483s state=running queue_depth=32 scsi_level=6 type=0 device_blocked=0 timeout=30 483s dir: /sys/bus/scsi/devices/3:0:0:1 [/sys/devices/platform/host3/session4/target3:0:0/3:0:0:1] 483s NVMe module may not be loaded 483s + lsscsi -liv 483s list_ndevices: scandir: /sys/class/nvme/: No such file or directory 483s + multipath -v3 -ll 483s 55.881367 | set open fds limit to 1048576/1048576 483s 55.881439 | loading /lib/multipath/libchecktur.so checker 483s 55.881548 | checker tur: message table size = 3 483s 55.881563 | loading /lib/multipath/libprioconst.so prioritizer 483s 55.881644 | _init_foreign: foreign library "nvme" is not enabled 483s 55.884795 | vda: device node name blacklisted 483s 55.885044 | sda: size = 204800 483s 55.885131 | sda: vendor = IET 483s 55.885149 | sda: product = VIRTUAL-DISK 483s 55.885159 | sda: rev = 0001 483s 55.885697 | sda: h:b:t:l = 0:0:0:1 483s 55.885901 | sda: tgt_node_name = iqn.2016-11.foo.com:target.iscsi 483s 55.885911 | sda: uid_attribute = ID_SERIAL (setting: multipath internal) 483s 55.885913 | sda: recheck_wwid = 1 (setting: multipath.conf defaults/devices section) 483s 55.886088 | sda: 1024 cyl, 4 heads, 50 sectors/track, start at 0 483s 55.886098 | sda: vpd_vendor_id = 0 "undef" (setting: multipath internal) 483s 55.886109 | sda: serial = beaf11 483s 55.886111 | sda: detect_checker = yes (setting: multipath internal) 483s 55.886387 | sda: path_checker = tur (setting: multipath internal) 483s 55.886400 | sda: checker timeout = 30 s (setting: kernel sysfs) 483s 55.886504 | sda: tur state = up 483s 55.886619 | sdb: size = 204800 483s 55.886698 | sdb: vendor = IET 483s 55.886712 | sdb: product = VIRTUAL-DISK 483s 55.886727 | sdb: rev = 0001 483s 55.887287 | sdb: h:b:t:l = 1:0:0:1 483s 55.887505 | sdb: tgt_node_name = iqn.2016-11.foo.com:target.iscsi 483s 55.887515 | sdb: uid_attribute = ID_SERIAL (setting: multipath internal) 483s 55.887516 | sdb: recheck_wwid = 1 (setting: multipath.conf defaults/devices section) 483s 55.887657 | sdb: 1024 cyl, 4 heads, 50 sectors/track, start at 0 483s 55.887667 | sdb: vpd_vendor_id = 0 "undef" (setting: multipath internal) 483s 55.887678 | sdb: serial = beaf11 483s 55.887680 | sdb: detect_checker = yes (setting: multipath internal) 483s 55.887866 | sdb: path_checker = tur (setting: multipath internal) 483s 55.887878 | sdb: checker timeout = 30 s (setting: kernel sysfs) 483s 55.887977 | sdb: tur state = up 483s 55.888086 | sdc: size = 204800 483s 55.888178 | sdc: vendor = IET 483s 55.888192 | sdc: product = VIRTUAL-DISK 483s 55.888209 | sdc: rev = 0001 483s 55.888757 | sdc: h:b:t:l = 2:0:0:1 483s 55.888991 | sdc: tgt_node_name = iqn.2016-11.foo.com:target.iscsi 483s 55.889002 | sdc: uid_attribute = ID_SERIAL (setting: multipath internal) 483s 55.889003 | sdc: recheck_wwid = 1 (setting: multipath.conf defaults/devices section) 483s 55.889372 | sdc: 1024 cyl, 4 heads, 50 sectors/track, start at 0 483s 55.889384 | sdc: vpd_vendor_id = 0 "undef" (setting: multipath internal) 483s 55.889403 | sdc: serial = beaf11 483s 55.889405 | sdc: detect_checker = yes (setting: multipath internal) 483s 55.889526 | sdc: path_checker = tur (setting: multipath internal) 483s 55.889536 | sdc: checker timeout = 30 s (setting: kernel sysfs) 483s 55.889671 | sdc: tur state = up 483s 55.889773 | sdd: size = 204800 483s 55.889851 | sdd: vendor = IET 483s 55.889865 | sdd: product = VIRTUAL-DISK 483s 55.889879 | sdd: rev = 0001 483s 55.890381 | sdd: h:b:t:l = 3:0:0:1 483s 55.890584 | sdd: tgt_node_name = iqn.2016-11.foo.com:target.iscsi 483s 55.890590 | sdd: uid_attribute = ID_SERIAL (setting: multipath internal) 483s 55.890592 | sdd: recheck_wwid = 1 (setting: multipath.conf defaults/devices section) 483s 55.890872 | sdd: 1024 cyl, 4 heads, 50 sectors/track, start at 0 483s 55.890880 | sdd: vpd_vendor_id = 0 "undef" (setting: multipath internal) 483s 55.890893 | sdd: serial = beaf11 483s 55.890899 | sdd: detect_checker = yes (setting: multipath internal) 483s 55.891020 | sdd: path_checker = tur (setting: multipath internal) 483s 55.891027 | sdd: checker timeout = 30 s (setting: kernel sysfs) 483s 55.891111 | sdd: tur state = up 483s 55.891186 | loop0: device node name blacklisted 483s 55.891239 | loop1: device node name blacklisted 483s 55.891287 | loop2: device node name blacklisted 483s 55.891334 | loop3: device node name blacklisted 483s 55.891381 | loop4: device node name blacklisted 483s 55.891427 | loop5: device node name blacklisted 483s 55.891473 | loop6: device node name blacklisted 483s 55.891519 | loop7: device node name blacklisted 483s 55.891573 | dm-0: device node name blacklisted 483s 55.892325 | multipath-tools v0.9.4 (12/19, 2022) 483s 55.892352 | libdevmapper version 1.02.185 483s 55.892466 | kernel device mapper v4.48.0 483s 55.892481 | DM multipath kernel driver v1.14.0 483s 55.892605 | sda: size = 204800 483s 55.892615 | sda: vendor = IET 483s 55.892617 | sda: product = VIRTUAL-DISK 483s 55.892618 | sda: rev = 0001 483s 55.893159 | sda: h:b:t:l = 0:0:0:1 483s 55.893262 | sda: tgt_node_name = iqn.2016-11.foo.com:target.iscsi 483s 55.893284 | sda: 1024 cyl, 4 heads, 50 sectors/track, start at 0 483s 55.893286 | sda: vpd_vendor_id = 0 "undef" (setting: multipath internal) 483s 55.893296 | sda: serial = beaf11 483s 55.893415 | sda: tur state = up 483s 55.893426 | sda: uid = 360000000000000000e00000000010001 (udev) 483s 55.893428 | sda: detect_prio = yes (setting: multipath internal) 483s 55.893432 | sda: prio = const (setting: multipath internal) 483s 55.893436 | sda: prio args = "" (setting: multipath internal) 483s 55.893438 | sda: const prio = 1 483s 55.893463 | sdb: size = 204800 483s 55.893470 | sdb: vendor = IET 483s 55.893472 | sdb: product = VIRTUAL-DISK 483s 55.893474 | sdb: rev = 0001 483s 55.893962 | sdb: h:b:t:l = 1:0:0:1 483s 55.894045 | sdb: tgt_node_name = iqn.2016-11.foo.com:target.iscsi 483s 55.894066 | sdb: 1024 cyl, 4 heads, 50 sectors/track, start at 0 483s 55.894068 | sdb: vpd_vendor_id = 0 "undef" (setting: multipath internal) 483s 55.894076 | sdb: serial = beaf11 483s 55.894192 | sdb: tur state = up 483s 55.894199 | sdb: uid = 360000000000000000e00000000010001 (udev) 483s 55.894201 | sdb: detect_prio = yes (setting: multipath internal) 483s 55.894202 | sdb: prio = const (setting: multipath internal) 483s 55.894203 | sdb: prio args = "" (setting: multipath internal) 483s 55.894205 | sdb: const prio = 1 483s 55.894224 | sdd: size = 204800 483s 55.894230 | sdd: vendor = IET 483s 55.894232 | sdd: product = VIRTUAL-DISK 483s 55.894233 | sdd: rev = 0001 483s 55.894712 | sdd: h:b:t:l = 3:0:0:1 483s 55.894791 | sdd: tgt_node_name = iqn.2016-11.foo.com:target.iscsi 483s 55.894806 | sdd: 1024 cyl, 4 heads, 50 sectors/track, start at 0 483s 55.894810 | sdd: vpd_vendor_id = 0 "undef" (setting: multipath internal) 483s 55.894818 | sdd: serial = beaf11 483s 55.894898 | sdd: tur state = up 483s 55.894905 | sdd: uid = 360000000000000000e00000000010001 (udev) 483s 55.894907 | sdd: detect_prio = yes (setting: multipath internal) 483s 55.894909 | sdd: prio = const (setting: multipath internal) 483s 55.894910 | sdd: prio args = "" (setting: multipath internal) 483s 55.894911 | sdd: const prio = 1 483s 55.894930 | sdc: size = 204800 483s 55.894937 | sdc: vendor = IET 483s 55.894939 | sdc: product = VIRTUAL-DISK 483s 55.894941 | sdc: rev = 0001 483s 55.895417 | sdc: h:b:t:l = 2:0:0:1 483s 55.895495 | sdc: tgt_node_name = iqn.2016-11.foo.com:target.iscsi 483s 55.895510 | sdc: 1024 cyl, 4 heads, 50 sectors/track, start at 0 483s 55.895514 | sdc: vpd_vendor_id = 0 "undef" (setting: multipath internal) 483s 55.895522 | sdc: serial = beaf11 483s 55.895621 | sdc: tur state = up 483s 55.895628 | sdc: uid = 360000000000000000e00000000010001 (udev) 483s 55.895630 | sdc: detect_prio = yes (setting: multipath internal) 483s 55.895631 | sdc: prio = const (setting: multipath internal) 483s 55.895632 | sdc: prio args = "" (setting: multipath internal) 483s 55.895633 | sdc: const prio = 1 483s 55.896290 | unloading tur checker 483s 55.896348 | unloading const prioritizer 483s + dmsetup table 483s + echo Test WWN should now point to DM 483s + readlink /dev/disk/by-id/wwn-0x60000000000000000e00000000010001 483s + grep dm 483s + mkfs.ext4 -F /dev/disk/by-id/wwn-0x60000000000000000e00000000010001 483s mke2fs 1.47.0 (5-Feb-2023) 483s ===== paths list ===== 483s uuid hcil dev dev_t pri dm_st chk_st vend/prod/rev dev_st 483s 0:0:0:1 sda 8:0 -1 undef undef IET,VIRTUAL-DISK unknown 483s 1:0:0:1 sdb 8:16 -1 undef undef IET,VIRTUAL-DISK unknown 483s 2:0:0:1 sdc 8:32 -1 undef undef IET,VIRTUAL-DISK unknown 483s 3:0:0:1 sdd 8:48 -1 undef undef IET,VIRTUAL-DISK unknown 483s mpatha (360000000000000000e00000000010001) dm-0 IET,VIRTUAL-DISK 483s size=100M features='0' hwhandler='0' wp=rw 483s |-+- policy='service-time 0' prio=1 status=active 483s | `- 0:0:0:1 sda 8:0 active ready running 483s |-+- policy='service-time 0' prio=1 status=enabled 483s | `- 1:0:0:1 sdb 8:16 active ready running 483s |-+- policy='service-time 0' prio=1 status=enabled 483s | `- 3:0:0:1 sdd 8:48 active ready running 483s `-+- policy='service-time 0' prio=1 status=enabled 483s `- 2:0:0:1 sdc 8:32 active ready running 483s mpatha: 0 204800 multipath 0 0 4 1 service-time 0 1 2 8:0 1 1 service-time 0 1 2 8:16 1 1 service-time 0 1 2 8:48 1 1 service-time 0 1 2 8:32 1 1 483s Test WWN should now point to DM 483s ../../dm-0 483s Creating filesystem with 25600 4k blocks and 25600 inodes 483s 483s Allocating group tables: 0/1 done 483s Writing inode tables: 0/1 done 483s Creating journal (1024 blocks): done 483s Writing superblocks and filesystem accounting information: 0/1 + udevadm settle 483s done 483s 483s + sleep 3s 486s + mkdir -p /mnt/tgtmpathtest 486s + mount /dev/disk/by-id/wwn-0x60000000000000000e00000000010001 /mnt/tgtmpathtest 486s + cat 486s + cat 486s + fio --max-jobs=4 /tmp/autopkgtest.phKdtC/tgtbasedmpaths-artifacts/path-change-prep.fio 486s write-phase: (g=0): rw=write, bs=(R) 64.0KiB-64.0KiB, (W) 64.0KiB-64.0KiB, (T) 64.0KiB-64.0KiB, ioengine=sync, iodepth=1 486s fio-3.36 486s Starting 1 thread 486s write-phase: Laying out IO file (1 file / 17592186044415MiB) 487s fio: io_u error on file /mnt/tgtmpathtest/datafile.tmp: No space left on device: write offset=91881472, buflen=65536 487s 487s write-phase: (groupid=0, jobs=1): err= 0: pid=6381: Sat Mar 16 15:36:17 2024 487s write: IOPS=4102, BW=256MiB/s (269MB/s)(87.6MiB/342msec); 0 zone resets 487s clat (usec): min=188, max=2642, avg=239.17, stdev=111.26 487s lat (usec): min=190, max=2644, avg=242.50, stdev=111.31 487s clat percentiles (usec): 487s | 1.00th=[ 202], 5.00th=[ 206], 10.00th=[ 210], 20.00th=[ 215], 487s | 30.00th=[ 219], 40.00th=[ 223], 50.00th=[ 227], 60.00th=[ 231], 487s | 70.00th=[ 239], 80.00th=[ 245], 90.00th=[ 258], 95.00th=[ 273], 487s | 99.00th=[ 408], 99.50th=[ 510], 99.90th=[ 2442], 99.95th=[ 2638], 487s | 99.99th=[ 2638] 487s lat (usec) : 250=85.74%, 500=13.54%, 750=0.21%, 1000=0.14% 487s lat (msec) : 2=0.07%, 4=0.21% 487s cpu : usr=0.88%, sys=10.23%, ctx=1404, majf=0, minf=0 487s IO depths : 1=100.0%, 2=0.0%, 4=0.0%, 8=0.0%, 16=0.0%, 32=0.0%, >=64=0.0% 487s submit : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0% 487s complete : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0% 487s issued rwts: total=0,1403,0,0 short=0,0,0,0 dropped=0,0,0,0 487s latency : target=0, window=0, percentile=100.00%, depth=1 487s 487s Run status group 0 (all jobs): 487s WRITE: bw=256MiB/s (269MB/s), 256MiB/s-256MiB/s (269MB/s-269MB/s), io=87.6MiB (91.9MB), run=342-342msec 487s 487s Disk stats (read/write): 487s dm-0: ios=1/600, sectors=8/76800, merge=0/0, ticks=0/139, in_queue=139, util=62.04%, aggrios=0/351, aggsectors=2/44884, aggrmerge=0/0, aggrticks=0/76, aggrin_queue=76, aggrutil=75.32% 487s sdd: ios=0/0, sectors=0/0, merge=0/0, ticks=0/0, in_queue=0, util=0.00% 487s sdb: ios=0/0, sectors=0/0, merge=0/0, ticks=0/0, in_queue=0, util=0.00% 487s sdc: ios=0/0, sectors=0/0, merge=0/0, ticks=0/0, in_queue=0, util=0.00% 487s sda: ios=1/1404, sectors=8/179536, merge=0/0, ticks=0/306, in_queue=307, util=75.32% 487s Starting the path changes in background 487s + echo Starting the path changes in background 487s + date +Pre FIO %H:%M:%S.%N 487s Pre FIO 15:36:17.187319561 487s + fio --max-jobs=4 /tmp/autopkgtest.phKdtC/tgtbasedmpaths-artifacts/path-change-check.fio 487s verify-phase: (g=0): rw=read, bs=(R) 64.0KiB-64.0KiB, (W) 64.0KiB-64.0KiB, (T) 64.0KiB-64.0KiB, ioengine=sync, iodepth=1 487s fio-3.36 487s Starting 1 thread 668s 668s verify-phase: (groupid=0, jobs=1): err= 0: pid=6392: Sat Mar 16 15:39:17 2024 668s read: IOPS=6057, BW=379MiB/s (397MB/s)(66.6GiB/180254msec) 668s clat (usec): min=82, max=322026, avg=156.30, stdev=654.10 668s lat (usec): min=83, max=322026, avg=156.48, stdev=654.11 668s clat percentiles (usec): 668s | 1.00th=[ 103], 5.00th=[ 114], 10.00th=[ 121], 20.00th=[ 129], 668s | 30.00th=[ 135], 40.00th=[ 139], 50.00th=[ 145], 60.00th=[ 149], 668s | 70.00th=[ 157], 80.00th=[ 165], 90.00th=[ 182], 95.00th=[ 204], 668s | 99.00th=[ 330], 99.50th=[ 388], 99.90th=[ 586], 99.95th=[ 963], 668s | 99.99th=[ 9765] 668s bw ( KiB/s): min=68224, max=499328, per=100.00%, avg=388786.49, stdev=66943.35, samples=359 668s iops : min= 1066, max= 7802, avg=6074.69, stdev=1045.99, samples=359 668s lat (usec) : 100=0.48%, 250=96.98%, 500=2.39%, 750=0.09%, 1000=0.02% 668s lat (msec) : 2=0.02%, 4=0.01%, 10=0.02%, 20=0.01%, 50=0.01% 668s lat (msec) : 100=0.01%, 250=0.01%, 500=0.01% 668s cpu : usr=6.02%, sys=11.28%, ctx=1092033, majf=0, minf=16 668s IO depths : 1=100.0%, 2=0.0%, 4=0.0%, 8=0.0%, 16=0.0%, 32=0.0%, >=64=0.0% 668s submit : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0% 668s complete : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0% 668s issued rwts: total=1091879,0,0,0 short=0,0,0,0 dropped=0,0,0,0 668s latency : target=0, window=0, percentile=100.00%, depth=1 668s 668s Run status group 0 (all jobs): 668s READ: bw=379MiB/s (397MB/s), 379MiB/s-379MiB/s (397MB/s-397MB/s), io=66.6GiB (71.6GB), run=180254-180254msec 668s 668s Disk stats (read/write): 668s dm-0: ios=1092705/9, sectors=139762528/12912, merge=0/8, ticks=168147/118, in_queue=168370, util=99.59%, aggrios=82176/2, aggsectors=10509976/3228, aggrmerge=0/0, aggrticks=10762/3, aggrin_queue=10764, aggrutil=98.80% 668s sdd: ios=199302/4, sectors=25492480/48, merge=0/0, ticks=25857/1, in_queue=25858, util=59.94% 668s sdb: ios=67060/0, sectors=8573152/0, merge=0/0, ticks=8755/0, in_queue=8754, util=50.37% 668s sdc: ios=0/0, sectors=0/0, merge=0/0, ticks=0/0, in_queue=0, util=0.00% 668s sda: ios=62345/4, sectors=7974272/12864, merge=0/0, ticks=8436/12, in_queue=8447, util=98.80% 668s + date +Post FIO %H:%M:%S.%N 668s Post FIO 15:39:18.589208791 668s FIO verify test with changing paths - OK 668s Report log of background activity 668s + echo FIO verify test with changing paths - OK 668s + echo Report log of background activity 668s + cat /tmp/autopkgtest.phKdtC/tgtbasedmpaths-artifacts/test-background.log 668s + iscsiadm --mode session 668s tcp: [1] 127.0.0.1:3260,1 iqn.2016-11.foo.com:target.iscsi (non-flash) 668s tcp: [2] 127.0.0.1:3260,1 iqn.2016-11.foo.com:target.iscsi (non-flash) 668s tcp: [3] 127.0.0.1:3260,1 iqn.2016-11.foo.com:target.iscsi (non-flash) 668s tcp: [4] 127.0.0.1:3260,1 iqn.2016-11.foo.com:target.iscsi (non-flash) 668s + sleep 10s 668s + date +MP report (expect 4) %H:%M:%S.%N 668s MP report (expect 4) 15:36:27.221340827 668s + multipath -ll 668s mpatha (360000000000000000e00000000010001) dm-0 IET,VIRTUAL-DISK 668s size=100M features='0' hwhandler='0' wp=rw 668s |-+- policy='service-time 0' prio=1 status=active 668s | `- 0:0:0:1 sda 8:0 active ready running 668s |-+- policy='service-time 0' prio=1 status=enabled 668s | `- 1:0:0:1 sdb 8:16 active ready running 668s |-+- policy='service-time 0' prio=1 status=enabled 668s | `- 3:0:0:1 sdd 8:48 active ready running 668s `-+- policy='service-time 0' prio=1 status=enabled 668s `- 2:0:0:1 sdc 8:32 active ready running 668s + date +UN-plug path 1 %H:%M:%S.%N 668s UN-plug path 1 15:36:27.269458519 668s + iscsiadm --mode session -r 1 -u 668s Logging out of session [sid: 1, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] 668s Logout of [sid: 1, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] successful. 668s + iscsiadm --mode session 668s tcp: [2] 127.0.0.1:3260,1 iqn.2016-11.foo.com:target.iscsi (non-flash) 668s tcp: [3] 127.0.0.1:3260,1 iqn.2016-11.foo.com:target.iscsi (non-flash) 668s tcp: [4] 127.0.0.1:3260,1 iqn.2016-11.foo.com:target.iscsi (non-flash) 668s + sleep 10s 668s + date +MP report (expect 3) %H:%M:%S.%N 668s MP report (expect 3) 15:36:37.511618184 668s + multipath -ll 668s mpatha (360000000000000000e00000000010001) dm-0 IET,VIRTUAL-DISK 668s size=100M features='0' hwhandler='0' wp=rw 668s |-+- policy='service-time 0' prio=1 status=active 668s | `- 1:0:0:1 sdb 8:16 active ready running 668s |-+- policy='service-time 0' prio=1 status=enabled 668s | `- 3:0:0:1 sdd 8:48 active ready running 668s `-+- policy='service-time 0' prio=1 status=enabled 668s `- 2:0:0:1 sdc 8:32 active ready running 668s + date +UN-plug path 2 %H:%M:%S.%N 668s UN-plug path 2 15:36:37.590851868 668s + iscsiadm --mode session -r 2 -u 668s Logging out of session [sid: 2, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] 668s Logout of [sid: 2, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] successful. 668s + iscsiadm --mode session 668s tcp: [3] 127.0.0.1:3260,1 iqn.2016-11.foo.com:target.iscsi (non-flash) 668s tcp: [4] 127.0.0.1:3260,1 iqn.2016-11.foo.com:target.iscsi (non-flash) 668s + sleep 10s 668s + date +MP report (expect 2) %H:%M:%S.%N 668s MP report (expect 2) 15:36:47.907096945 668s + multipath -ll 668s mpatha (360000000000000000e00000000010001) dm-0 IET,VIRTUAL-DISK 668s size=100M features='0' hwhandler='0' wp=rw 668s |-+- policy='service-time 0' prio=1 status=active 668s | `- 3:0:0:1 sdd 8:48 active ready running 668s `-+- policy='service-time 0' prio=1 status=enabled 668s `- 2:0:0:1 sdc 8:32 active ready running 668s + date +UN-plug path 3 %H:%M:%S.%N 668s UN-plug path 3 15:36:47.990165627 668s + iscsiadm --mode session -r 3 -u 668s Logging out of session [sid: 3, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] 668s Logout of [sid: 3, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] successful. 668s + iscsiadm --mode session 668s tcp: [4] 127.0.0.1:3260,1 iqn.2016-11.foo.com:target.iscsi (non-flash) 668s + sleep 10s 668s + date +MP report (expect 1) %H:%M:%S.%N 668s MP report (expect 1) 15:36:58.151699777 668s + multipath -ll 668s mpatha (360000000000000000e00000000010001) dm-0 IET,VIRTUAL-DISK 668s size=100M features='0' hwhandler='0' wp=rw 668s `-+- policy='service-time 0' prio=1 status=active 668s `- 3:0:0:1 sdd 8:48 active ready running 668s + date +Add paths 5/6/7/8 %H:%M:%S.%N 668s Add paths 5/6/7/8 15:36:58.161234482 668s + iscsiadm --mode session -r 4 --op new 668s Logging in to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] (multiple) 668s Login to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] successful. 668s + iscsiadm --mode session -r 4 --op new 668s Logging in to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] (multiple) 668s Login to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] successful. 668s + iscsiadm --mode session -r 4 --op new 668s Logging in to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] (multiple) 668s Login to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] successful. 668s + iscsiadm --mode session -r 4 --op new 668s Logging in to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] (multiple) 668s Login to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] successful. 668s + iscsiadm --mode session 668s tcp: [4] 127.0.0.1:3260,1 iqn.2016-11.foo.com:target.iscsi (non-flash) 668s tcp: [5] 127.0.0.1:3260,1 iqn.2016-11.foo.com:target.iscsi (non-flash) 668s tcp: [6] 127.0.0.1:3260,1 iqn.2016-11.foo.com:target.iscsi (non-flash) 668s tcp: [7] 127.0.0.1:3260,1 iqn.2016-11.foo.com:target.iscsi (non-flash) 668s tcp: [8] 127.0.0.1:3260,1 iqn.2016-11.foo.com:target.iscsi (non-flash) 668s + sleep 10s 668s + date +MP report (expect 5) %H:%M:%S.%N 668s MP report (expect 5) 15:37:08.284785090 668s + multipath -ll 668s mpatha (360000000000000000e00000000010001) dm-0 IET,VIRTUAL-DISK 668s size=100M features='0' hwhandler='0' wp=rw 668s |-+- policy='service-time 0' prio=1 status=active 668s | `- 3:0:0:1 sdd 8:48 active ready running 668s |-+- policy='service-time 0' prio=1 status=enabled 668s | `- 1:0:0:1 sdb 8:16 active ready running 668s |-+- policy='service-time 0' prio=1 status=enabled 668s | `- 2:0:0:1 sdc 8:32 active ready running 668s |-+- policy='service-time 0' prio=1 status=enabled 668s | `- 0:0:0:1 sda 8:0 active ready running 668s `-+- policy='service-time 0' prio=1 status=enabled 668s `- 4:0:0:1 sde 8:64 active ready running 668s + date +UN-plug multiple paths 4/7/8 %H:%M:%S.%N 668s UN-plug multiple paths 4/7/8 15:37:08.305823719 668s + iscsiadm --mode session -r 4 -u 668s Logging out of session [sid: 4, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] 668s Logout of [sid: 4, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] successful. 668s + iscsiadm --mode session -r 7 -u 668s Logging out of session [sid: 7, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] 668s Logout of [sid: 7, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] successful. 668s + iscsiadm --mode session -r 8 -u 668s Logging out of session [sid: 8, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] 668s Logout of [sid: 8, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] successful. 668s + iscsiadm --mode session 668s tcp: [5] 127.0.0.1:3260,1 iqn.2016-11.foo.com:target.iscsi (non-flash) 668s tcp: [6] 127.0.0.1:3260,1 iqn.2016-11.foo.com:target.iscsi (non-flash) 668s + sleep 10s 668s + date +Restart multipath daemon %H:%M:%S.%N 668s Restart multipath daemon 15:37:18.623270515 668s + systemctl restart multipathd 668s + sleep 10s 668s + date +Final background report (expect 2) %H:%M:%S.%N 668s Final background report (expect 2) 15:37:28.739545184 668s + multipath -ll 668s mpatha (360000000000000000e00000000010001) dm-0 IET,VIRTUAL-DISK 668s size=100M features='0' hwhandler='0' wp=rw 668s |-+- policy='service-time 0' prio=1 status=active 668s | `- 1:0:0:1 sdb 8:16 active ready running 668s `-+- policy='service-time 0' prio=1 status=enabled 668s `- 0:0:0:1 sda 8:0 active ready running 668s + sync 668s + umount /dev/disk/by-id/wwn-0x60000000000000000e00000000010001 668s Final stats 668s + echo Final stats 668s + iscsiadm --mode session --stats 668s Stats for session [sid: 5, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] 668s iSCSI SNMP: 668s txdata_octets: 7512 668s rxdata_octets: 1098068 668s noptx_pdus: 0 668s scsicmd_pdus: 127 668s tmfcmd_pdus: 0 668s login_pdus: 0 668s text_pdus: 0 668s dataout_pdus: 0 668s logout_pdus: 0 668s snack_pdus: 0 668s noprx_pdus: 0 668s scsirsp_pdus: 127 668s tmfrsp_pdus: 0 668s textrsp_pdus: 0 668s datain_pdus: 104 668s logoutrsp_pdus: 0 668s r2t_pdus: 0 668s async_pdus: 0 668s rjt_pdus: 0 668s digest_err: 0 668s timeout_err: 0 668s iSCSI Extended: 668s tx_sendpage_failures: 0 668s rx_discontiguous_hdr: 0 668s eh_abort_cnt: 0 668s Stats for session [sid: 6, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] 668s iSCSI SNMP: 668s txdata_octets: 36647544 668s rxdata_octets: 50011547252 668s noptx_pdus: 0 668s scsicmd_pdus: 763223 668s tmfcmd_pdus: 0 668s login_pdus: 0 668s text_pdus: 0 668s dataout_pdus: 0 668s logout_pdus: 0 668s snack_pdus: 0 668s noprx_pdus: 0 668s scsirsp_pdus: 763223 668s tmfrsp_pdus: 0 668s textrsp_pdus: 0 668s datain_pdus: 763188 668s logoutrsp_pdus: 0 668s r2t_pdus: 0 668s async_pdus: 0 668s rjt_pdus: 0 668s digest_err: 0 668s timeout_err: 0 668s iSCSI Extended: 668s tx_sendpage_failures: 0 668s rx_discontiguous_hdr: 0 668s eh_abort_cnt: 0 668s + journalctl --no-pager -u multipathd 668s Mar 14 09:32:47 adtubuntu-noble-arm64-server-20240312-img-adt-prepare multipathd[285]: multipathd v0.9.4: start up 668s Mar 14 09:32:47 adtubuntu-noble-arm64-server-20240312-img-adt-prepare multipathd[285]: reconfigure: setting up paths and maps 668s Mar 14 09:32:46 adtubuntu-noble-arm64-server-20240312-img-adt-prepare systemd[1]: Started multipathd.service - Device-Mapper Multipath Device Controller. 668s Mar 14 09:33:44 adtubuntu-noble-arm64-server-20240313-img-adt-prepare multipathd[285]: multipathd: shut down 668s Mar 14 09:33:44 adtubuntu-noble-arm64-server-20240313-img-adt-prepare systemd[1]: Stopping multipathd.service - Device-Mapper Multipath Device Controller... 668s Mar 14 09:33:44 adtubuntu-noble-arm64-server-20240313-img-adt-prepare systemd[1]: multipathd.service: Deactivated successfully. 668s Mar 14 09:33:44 adtubuntu-noble-arm64-server-20240313-img-adt-prepare systemd[1]: Stopped multipathd.service - Device-Mapper Multipath Device Controller. 668s -- Boot 1caf890379ef42e1ac6b0374db474b8f -- 668s Mar 14 09:33:58 adtubuntu-noble-arm64-server-20240313-img-adt-prepare multipathd[286]: multipathd v0.9.4: start up 668s Mar 14 09:33:58 adtubuntu-noble-arm64-server-20240313-img-adt-prepare multipathd[286]: reconfigure: setting up paths and maps 668s Mar 14 09:33:58 adtubuntu-noble-arm64-server-20240313-img-adt-prepare systemd[1]: Started multipathd.service - Device-Mapper Multipath Device Controller. 668s Mar 14 09:34:07 adtubuntu-noble-arm64-server-20240313-img-adt-prepare systemd[1]: Stopping multipathd.service - Device-Mapper Multipath Device Controller... 668s Mar 14 09:34:07 adtubuntu-noble-arm64-server-20240313-img-adt-prepare multipathd[286]: multipathd: shut down 668s Mar 14 09:34:07 adtubuntu-noble-arm64-server-20240313-img-adt-prepare systemd[1]: multipathd.service: Deactivated successfully. 668s Mar 14 09:34:07 adtubuntu-noble-arm64-server-20240313-img-adt-prepare systemd[1]: Stopped multipathd.service - Device-Mapper Multipath Device Controller. 668s -- Boot bbe6ed183d884161bc03f0888fafb785 -- 668s Mar 16 15:33:48 adtubuntu-noble-arm64-server-20240313-img-adt-prepare multipathd[314]: multipathd v0.9.4: start up 668s Mar 16 15:33:48 adtubuntu-noble-arm64-server-20240313-img-adt-prepare multipathd[314]: reconfigure: setting up paths and maps 668s Mar 16 15:33:48 adtubuntu-noble-arm64-server-20240313-img-adt-prepare systemd[1]: Started multipathd.service - Device-Mapper Multipath Device Controller. 668s Mar 16 15:35:06 autopkgtest systemd[1]: Stopping multipathd.service - Device-Mapper Multipath Device Controller... 668s Mar 16 15:35:06 autopkgtest multipathd[314]: multipathd: shut down 668s Mar 16 15:35:06 autopkgtest systemd[1]: multipathd.service: Deactivated successfully. 668s Mar 16 15:35:06 autopkgtest systemd[1]: Stopped multipathd.service - Device-Mapper Multipath Device Controller. 668s -- Boot ad5f72c332a347a495abd8e24ed92fe5 -- 668s Mar 16 15:35:20 autopkgtest multipathd[304]: multipathd v0.9.4: start up 668s Mar 16 15:35:20 autopkgtest multipathd[304]: reconfigure: setting up paths and maps 668s Mar 16 15:35:20 autopkgtest systemd[1]: Started multipathd.service - Device-Mapper Multipath Device Controller. 668s Mar 16 15:36:07 autopkgtest multipathd[304]: mpatha: addmap [0 204800 multipath 0 0 2 1 service-time 0 1 1 8:0 1 service-time 0 1 1 8:16 1] 668s Mar 16 15:36:07 autopkgtest multipathd[304]: sdb [8:16]: path added to devmap mpatha 668s Mar 16 15:36:08 autopkgtest multipathd[304]: mpatha: performing delayed actions 668s Mar 16 15:36:08 autopkgtest multipathd[304]: mpatha: reload [0 204800 multipath 0 0 4 1 service-time 0 1 1 8:0 1 service-time 0 1 1 8:16 1 service-time 0 1 1 8:48 1 service-time 0 1 1 8:32 1] 668s Mar 16 15:36:27 autopkgtest multipathd[304]: mpatha: reload [0 204800 multipath 0 0 3 1 service-time 0 1 1 8:16 1 service-time 0 1 1 8:48 1 service-time 0 1 1 8:32 1] 668s Mar 16 15:36:27 autopkgtest multipathd[304]: check_removed_paths: sda: freeing path in removed state 668s Mar 16 15:36:27 autopkgtest multipathd[304]: 8:0: path removed from map mpatha 668s Mar 16 15:36:37 autopkgtest multipathd[304]: sdb: mark as failed 668s Mar 16 15:36:37 autopkgtest multipathd[304]: mpatha: remaining active paths: 2 668s Mar 16 15:36:37 autopkgtest multipathd[304]: mpatha: reload [0 204800 multipath 0 0 2 1 service-time 0 1 1 8:48 1 service-time 0 1 1 8:32 1] 668s Mar 16 15:36:37 autopkgtest multipathd[304]: check_removed_paths: sdb: freeing path in removed state 668s Mar 16 15:36:37 autopkgtest multipathd[304]: 8:16: path removed from map mpatha 668s Mar 16 15:36:48 autopkgtest multipathd[304]: mpatha: reload [0 204800 multipath 0 0 1 1 service-time 0 1 1 8:48 1] 668s Mar 16 15:36:48 autopkgtest multipathd[304]: check_removed_paths: sdc: freeing path in removed state 668s Mar 16 15:36:48 autopkgtest multipathd[304]: 8:32: path removed from map mpatha 668s Mar 16 15:36:58 autopkgtest multipathd[304]: mpatha: reload [0 204800 multipath 0 0 2 1 service-time 0 1 1 8:48 1 service-time 0 1 1 8:16 1] 668s Mar 16 15:36:58 autopkgtest multipathd[304]: sdb [8:16]: path added to devmap mpatha 668s Mar 16 15:36:58 autopkgtest multipathd[304]: mpatha: reload [0 204800 multipath 0 0 3 1 service-time 0 1 1 8:48 1 service-time 0 1 1 8:16 1 service-time 0 1 1 8:32 1] 668s Mar 16 15:36:58 autopkgtest multipathd[304]: sdc [8:32]: path added to devmap mpatha 668s Mar 16 15:36:58 autopkgtest multipathd[304]: mpatha: reload [0 204800 multipath 0 0 4 1 service-time 0 1 1 8:48 1 service-time 0 1 1 8:16 1 service-time 0 1 1 8:32 1 service-time 0 1 1 8:0 1] 668s Mar 16 15:36:58 autopkgtest multipathd[304]: sda [8:0]: path added to devmap mpatha 668s Mar 16 15:36:58 autopkgtest multipathd[304]: mpatha: reload [0 204800 multipath 0 0 5 1 service-time 0 1 1 8:48 1 service-time 0 1 1 8:16 1 service-time 0 1 1 8:32 1 service-time 0 1 1 8:0 1 service-time 0 1 1 8:64 1] 668s Mar 16 15:36:58 autopkgtest multipathd[304]: sde [8:64]: path added to devmap mpatha 668s Mar 16 15:37:08 autopkgtest multipathd[304]: mpatha: reload [0 204800 multipath 0 0 4 1 service-time 0 1 1 8:16 1 service-time 0 1 1 8:32 1 service-time 0 1 1 8:0 1 service-time 0 1 1 8:64 1] 668s Mar 16 15:37:08 autopkgtest multipathd[304]: check_removed_paths: sdd: freeing path in removed state 668s Mar 16 15:37:08 autopkgtest multipathd[304]: 8:48: path removed from map mpatha 668s Mar 16 15:37:08 autopkgtest multipathd[304]: mpatha: reload [0 204800 multipath 0 0 3 1 service-time 0 1 1 8:16 1 service-time 0 1 1 8:0 1 service-time 0 1 1 8:64 1] 668s Mar 16 15:37:08 autopkgtest multipathd[304]: check_removed_paths: sdc: freeing path in removed state 668s Mar 16 15:37:08 autopkgtest multipathd[304]: 8:32: path removed from map mpatha 668s Mar 16 15:37:08 autopkgtest multipathd[304]: mpatha: reload [0 204800 multipath 0 0 2 1 service-time 0 1 1 8:16 1 service-time 0 1 1 8:0 1] 668s Mar 16 15:37:08 autopkgtest multipathd[304]: check_removed_paths: sde: freeing path in removed state 668s Mar 16 15:37:08 autopkgtest multipathd[304]: 8:64: path removed from map mpatha 668s Mar 16 15:37:18 autopkgtest systemd[1]: Stopping multipathd.service - Device-Mapper Multipath Device Controller... 668s Mar 16 15:37:18 autopkgtest multipathd[304]: multipathd: shut down 668s Mar 16 15:37:18 autopkgtest systemd[1]: multipathd.service: Deactivated successfully. 668s Mar 16 15:37:18 autopkgtest systemd[1]: Stopped multipathd.service - Device-Mapper Multipath Device Controller. 668s Mar 16 15:37:18 autopkgtest systemd[1]: Starting multipathd.service - Device-Mapper Multipath Device Controller... 668s Mar 16 15:37:18 autopkgtest multipathd[6730]: multipathd v0.9.4: start up 668s Mar 16 15:37:18 autopkgtest multipathd[6730]: reconfigure: setting up paths and maps 668s Mar 16 15:37:18 autopkgtest systemd[1]: Started multipathd.service - Device-Mapper Multipath Device Controller. 668s Check final path status 668s + echo Check final path status 668s + multipath -ll 668s mpatha (360000000000000000e00000000010001) dm-0 IET,VIRTUAL-DISK 668s size=100M features='0' hwhandler='0' wp=rw 668s |-+- policy='service-time 0' prio=1 status=active 668s | `- 1:0:0:1 sdb 8:16 active ready running 668s `-+- policy='service-time 0' prio=1 status=enabled 668s `- 0:0:0:1 sda 8:0 active ready running 668s + + grep --count status= 668s multipath -ll 668s + diskc=2 668s + + multipath -ll 668s grep --count status=active 668s + diska=1 668s + multipath -ll 668s + grep --count status=enabled 668s OK 668s + diske=1 668s + [ 2 -ne 2 -o 1 -ne 1 -o 1 -ne 1 ] 668s + echo OK 668s + iscsiadm --mode node --targetname iqn.2016-11.foo.com:target.iscsi --portal 127.0.0.1:3260 --logout 669s Logging out of session [sid: 5, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] 669s Logging out of session [sid: 6, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] 669s Logout of [sid: 5, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] successful. 669s Logout of [sid: 6, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] successful. 669s + tgtadm --lld iscsi --op delete --mode logicalunit --tid 1 --lun 1 669s autopkgtest [15:39:19]: test tgtbasedmpaths: -----------------------] 670s autopkgtest [15:39:20]: test tgtbasedmpaths: - - - - - - - - - - results - - - - - - - - - - 670s tgtbasedmpaths PASS 670s autopkgtest [15:39:20]: @@@@@@@@@@@@@@@@@@@@ summary 670s kpartx-file-loopback PASS 670s tgtbasedmpaths PASS 688s Creating nova instance adt-noble-arm64-multipath-tools-20240316-152810-juju-7f2275-prod-proposed-migration-environment-3 from image adt/ubuntu-noble-arm64-server-20240314.img (UUID 7faf5f09-d335-4346-a441-4eab2f9c04fe)... 688s Creating nova instance adt-noble-arm64-multipath-tools-20240316-152810-juju-7f2275-prod-proposed-migration-environment-3 from image adt/ubuntu-noble-arm64-server-20240314.img (UUID 7faf5f09-d335-4346-a441-4eab2f9c04fe)...