0s autopkgtest [01:59:23]: starting date and time: 2024-09-04 01:59:23+0000 0s autopkgtest [01:59:23]: git checkout: fd3bed09 nova: allow more retries for quota issues 0s autopkgtest [01:59:23]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.cvmrzm2z/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:initramfs-tools --apt-upgrade multipath-tools --timeout-short=300 --timeout-copy=20000 --timeout-test=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=initramfs-tools/0.142ubuntu33 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-big-ppc64el --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-ppc64el-1.secgroup --name adt-oracular-ppc64el-multipath-tools-20240904-015922-juju-7f2275-prod-proposed-migration-environment-2-2139fcca-c2b8-4176-8870-4eac5849c647 --image adt/ubuntu-oracular-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration-ppc64el -e TERM=linux -e ''"'"'http_proxy=http://squid.internal:3128'"'"'' -e ''"'"'https_proxy=http://squid.internal:3128'"'"'' -e ''"'"'no_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 144s autopkgtest [02:01:47]: testbed dpkg architecture: ppc64el 145s autopkgtest [02:01:48]: testbed apt version: 2.9.8 145s autopkgtest [02:01:48]: @@@@@@@@@@@@@@@@@@@@ test bed setup 146s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [126 kB] 146s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [45.8 kB] 146s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [8372 B] 146s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [11.1 kB] 146s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [699 kB] 146s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el Packages [94.3 kB] 146s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el c-n-f Metadata [1400 B] 146s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/restricted ppc64el Packages [1376 B] 146s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/restricted ppc64el c-n-f Metadata [120 B] 146s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/universe ppc64el Packages [659 kB] 146s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/universe ppc64el c-n-f Metadata [16.6 kB] 146s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse ppc64el Packages [5700 B] 146s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse ppc64el c-n-f Metadata [372 B] 150s Fetched 1669 kB in 1s (1727 kB/s) 150s Reading package lists... 153s Reading package lists... 153s Building dependency tree... 153s Reading state information... 153s Calculating upgrade... 153s The following packages will be upgraded: 153s dracut-install initramfs-tools initramfs-tools-bin initramfs-tools-core 153s os-prober 154s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 154s Need to get 132 kB of archives. 154s After this operation, 64.5 kB disk space will be freed. 154s Get:1 http://ftpmaster.internal/ubuntu oracular/main ppc64el dracut-install ppc64el 103-1ubuntu2 [37.1 kB] 154s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el initramfs-tools all 0.142ubuntu33 [7912 B] 154s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el initramfs-tools-core all 0.142ubuntu33 [50.2 kB] 154s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el initramfs-tools-bin ppc64el 0.142ubuntu33 [22.4 kB] 154s Get:5 http://ftpmaster.internal/ubuntu oracular/main ppc64el os-prober ppc64el 1.83ubuntu1 [14.2 kB] 154s Fetched 132 kB in 0s (312 kB/s) 155s (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 ... 72413 files and directories currently installed.) 155s Preparing to unpack .../dracut-install_103-1ubuntu2_ppc64el.deb ... 155s Unpacking dracut-install (103-1ubuntu2) over (102-3ubuntu4) ... 155s Preparing to unpack .../initramfs-tools_0.142ubuntu33_all.deb ... 155s Unpacking initramfs-tools (0.142ubuntu33) over (0.142ubuntu32) ... 155s Preparing to unpack .../initramfs-tools-core_0.142ubuntu33_all.deb ... 155s Unpacking initramfs-tools-core (0.142ubuntu33) over (0.142ubuntu32) ... 155s Preparing to unpack .../initramfs-tools-bin_0.142ubuntu33_ppc64el.deb ... 155s Unpacking initramfs-tools-bin (0.142ubuntu33) over (0.142ubuntu32) ... 155s Preparing to unpack .../os-prober_1.83ubuntu1_ppc64el.deb ... 155s Unpacking os-prober (1.83ubuntu1) over (1.83) ... 155s Setting up os-prober (1.83ubuntu1) ... 155s Setting up dracut-install (103-1ubuntu2) ... 155s Setting up initramfs-tools-bin (0.142ubuntu33) ... 155s Setting up initramfs-tools-core (0.142ubuntu33) ... 155s Setting up initramfs-tools (0.142ubuntu33) ... 155s update-initramfs: deferring update (trigger activated) 155s Processing triggers for man-db (2.12.1-3) ... 156s Processing triggers for initramfs-tools (0.142ubuntu33) ... 156s update-initramfs: Generating /boot/initrd.img-6.8.0-31-generic 156s W: No lz4 in /usr/bin:/sbin:/bin, using gzip 165s Reading package lists... 165s Building dependency tree... 165s Reading state information... 165s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 166s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 166s Hit:2 http://ftpmaster.internal/ubuntu oracular InRelease 166s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease 166s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease 167s Reading package lists... 167s Reading package lists... 167s Building dependency tree... 167s Reading state information... 168s Calculating upgrade... 168s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 168s Reading package lists... 168s Building dependency tree... 168s Reading state information... 168s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 169s autopkgtest [02:02:12]: rebooting testbed after setup commands that affected boot 173s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 198s autopkgtest [02:02:41]: testbed running kernel: Linux 6.8.0-31-generic #31-Ubuntu SMP Sat Apr 20 00:05:55 UTC 2024 201s autopkgtest [02:02:44]: @@@@@@@@@@@@@@@@@@@@ apt-source multipath-tools 205s Get:1 http://ftpmaster.internal/ubuntu oracular/main multipath-tools 0.9.9-1ubuntu2 (dsc) [2772 B] 205s Get:2 http://ftpmaster.internal/ubuntu oracular/main multipath-tools 0.9.9-1ubuntu2 (tar) [588 kB] 205s Get:3 http://ftpmaster.internal/ubuntu oracular/main multipath-tools 0.9.9-1ubuntu2 (diff) [42.4 kB] 205s gpgv: Signature made Tue Jul 23 21:24:22 2024 UTC 205s gpgv: using RSA key D09F8A854F1055BCFC482C4B23566B906047AFC8 205s gpgv: Can't check signature: No public key 205s dpkg-source: warning: cannot verify inline signature for ./multipath-tools_0.9.9-1ubuntu2.dsc: no acceptable signature found 206s autopkgtest [02:02:49]: testing package multipath-tools version 0.9.9-1ubuntu2 206s initramfs SKIP Test lists explicitly supported architectures, but the current architecture ppc64el isn't listed. 206s autopkgtest [02:02:49]: build not needed 207s autopkgtest [02:02:50]: test kpartx-file-loopback: preparing testbed 207s initramfs SKIP Test lists explicitly supported architectures, but the current architecture ppc64el isn't listed. 208s Reading package lists... 208s Building dependency tree... 208s Reading state information... 208s Starting pkgProblemResolver with broken count: 0 208s Starting 2 pkgProblemResolver with broken count: 0 208s Done 209s The following additional packages will be installed: 209s liburing2 qemu-utils 209s Recommended packages: 209s qemu-block-extra 209s The following NEW packages will be installed: 209s autopkgtest-satdep liburing2 qemu-utils 209s 0 upgraded, 3 newly installed, 0 to remove and 0 not upgraded. 209s Need to get 2432 kB/2433 kB of archives. 209s After this operation, 16.9 MB of additional disk space will be used. 209s Get:1 /tmp/autopkgtest.q4cQAG/1-autopkgtest-satdep.deb autopkgtest-satdep ppc64el 0 [720 B] 209s Get:2 http://ftpmaster.internal/ubuntu oracular/main ppc64el liburing2 ppc64el 2.6-1 [26.9 kB] 209s Get:3 http://ftpmaster.internal/ubuntu oracular/main ppc64el qemu-utils ppc64el 1:9.0.2+ds-4ubuntu2 [2405 kB] 210s Fetched 2432 kB in 1s (3623 kB/s) 210s Selecting previously unselected package liburing2:ppc64el. 210s (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 ... 72411 files and directories currently installed.) 210s Preparing to unpack .../liburing2_2.6-1_ppc64el.deb ... 210s Unpacking liburing2:ppc64el (2.6-1) ... 210s Selecting previously unselected package qemu-utils. 210s Preparing to unpack .../qemu-utils_1%3a9.0.2+ds-4ubuntu2_ppc64el.deb ... 210s Unpacking qemu-utils (1:9.0.2+ds-4ubuntu2) ... 210s Selecting previously unselected package autopkgtest-satdep. 210s Preparing to unpack .../1-autopkgtest-satdep.deb ... 210s Unpacking autopkgtest-satdep (0) ... 210s Setting up liburing2:ppc64el (2.6-1) ... 210s Setting up qemu-utils (1:9.0.2+ds-4ubuntu2) ... 210s Setting up autopkgtest-satdep (0) ... 210s Processing triggers for man-db (2.12.1-3) ... 212s Processing triggers for libc-bin (2.40-1ubuntu1) ... 214s (Reading database ... 72435 files and directories currently installed.) 214s Removing autopkgtest-satdep (0) ... 215s autopkgtest [02:02:58]: test kpartx-file-loopback: [----------------------- 215s Formatting 'foo.img', fmt=raw size=20971520 216s Creating new GPT entries in memory. 216s Warning: The kernel is still using the old partition table. 216s The new table will be used at the next reboot or after you 216s run partprobe(8) or kpartx(8) 216s The operation has completed successfully. 216s add map loop0p1 (252:0): 0 38879 linear 7:0 2048 216s standard_filename: OK 216s del devmap : loop0p1 216s No devices found 216s standard_filename_cleanup: OK 216s Formatting 'fou du FaFa.img', fmt=raw size=20971520 217s Creating new GPT entries in memory. 217s Warning: The kernel is still using the old partition table. 217s The new table will be used at the next reboot or after you 217s run partprobe(8) or kpartx(8) 217s The operation has completed successfully. 217s add map loop0p1 (252:0): 0 38879 linear 7:0 2048 217s filename_with_spaces: OK 217s del devmap : loop0p1 217s No devices found 217s filename_with_spaces_cleanup: OK 218s autopkgtest [02:03:01]: test kpartx-file-loopback: -----------------------] 218s autopkgtest [02:03:01]: test kpartx-file-loopback: - - - - - - - - - - results - - - - - - - - - - 218s kpartx-file-loopback PASS 219s autopkgtest [02:03:02]: test tgtbasedmpaths: preparing testbed 294s autopkgtest [02:04:17]: testbed dpkg architecture: ppc64el 294s autopkgtest [02:04:17]: testbed apt version: 2.9.8 294s autopkgtest [02:04:17]: @@@@@@@@@@@@@@@@@@@@ test bed setup 295s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [126 kB] 296s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [699 kB] 296s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [8372 B] 296s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [45.8 kB] 296s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [11.1 kB] 296s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el Packages [94.3 kB] 296s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el c-n-f Metadata [1400 B] 296s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/restricted ppc64el Packages [1376 B] 296s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/restricted ppc64el c-n-f Metadata [120 B] 296s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/universe ppc64el Packages [659 kB] 296s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/universe ppc64el c-n-f Metadata [16.6 kB] 296s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse ppc64el Packages [5700 B] 296s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse ppc64el c-n-f Metadata [372 B] 299s Fetched 1669 kB in 1s (1827 kB/s) 299s Reading package lists... 302s Reading package lists... 302s Building dependency tree... 302s Reading state information... 302s Calculating upgrade... 302s The following packages will be upgraded: 302s dracut-install initramfs-tools initramfs-tools-bin initramfs-tools-core 302s os-prober 303s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 303s Need to get 132 kB of archives. 303s After this operation, 64.5 kB disk space will be freed. 303s Get:1 http://ftpmaster.internal/ubuntu oracular/main ppc64el dracut-install ppc64el 103-1ubuntu2 [37.1 kB] 303s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el initramfs-tools all 0.142ubuntu33 [7912 B] 303s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el initramfs-tools-core all 0.142ubuntu33 [50.2 kB] 303s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el initramfs-tools-bin ppc64el 0.142ubuntu33 [22.4 kB] 303s Get:5 http://ftpmaster.internal/ubuntu oracular/main ppc64el os-prober ppc64el 1.83ubuntu1 [14.2 kB] 303s Fetched 132 kB in 0s (371 kB/s) 304s (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 ... 72413 files and directories currently installed.) 304s Preparing to unpack .../dracut-install_103-1ubuntu2_ppc64el.deb ... 304s Unpacking dracut-install (103-1ubuntu2) over (102-3ubuntu4) ... 304s Preparing to unpack .../initramfs-tools_0.142ubuntu33_all.deb ... 304s Unpacking initramfs-tools (0.142ubuntu33) over (0.142ubuntu32) ... 304s Preparing to unpack .../initramfs-tools-core_0.142ubuntu33_all.deb ... 304s Unpacking initramfs-tools-core (0.142ubuntu33) over (0.142ubuntu32) ... 304s Preparing to unpack .../initramfs-tools-bin_0.142ubuntu33_ppc64el.deb ... 304s Unpacking initramfs-tools-bin (0.142ubuntu33) over (0.142ubuntu32) ... 304s Preparing to unpack .../os-prober_1.83ubuntu1_ppc64el.deb ... 304s Unpacking os-prober (1.83ubuntu1) over (1.83) ... 304s Setting up os-prober (1.83ubuntu1) ... 304s Setting up dracut-install (103-1ubuntu2) ... 304s Setting up initramfs-tools-bin (0.142ubuntu33) ... 304s Setting up initramfs-tools-core (0.142ubuntu33) ... 304s Setting up initramfs-tools (0.142ubuntu33) ... 304s update-initramfs: deferring update (trigger activated) 304s Processing triggers for man-db (2.12.1-3) ... 305s Processing triggers for initramfs-tools (0.142ubuntu33) ... 305s update-initramfs: Generating /boot/initrd.img-6.8.0-31-generic 305s W: No lz4 in /usr/bin:/sbin:/bin, using gzip 314s Reading package lists... 314s Building dependency tree... 314s Reading state information... 315s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 315s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 315s Hit:2 http://ftpmaster.internal/ubuntu oracular InRelease 315s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease 315s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease 316s Reading package lists... 316s Reading package lists... 316s Building dependency tree... 316s Reading state information... 317s Calculating upgrade... 317s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 317s Reading package lists... 317s Building dependency tree... 317s Reading state information... 317s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 317s autopkgtest [02:04:40]: rebooting testbed after setup commands that affected boot 321s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 352s Reading package lists... 352s Building dependency tree... 352s Reading state information... 352s Starting pkgProblemResolver with broken count: 0 352s Starting 2 pkgProblemResolver with broken count: 0 352s Done 352s The following additional packages will be installed: 352s fio libboost-iostreams1.83.0 libboost-thread1.83.0 libconfig-general-perl 352s libdaxctl1 libgfapi0 libgfrpc0 libgfxdr0 libglusterfs0 libisns0t64 libnbd0 352s libndctl6 libopeniscsiusr libpmem1 libpmemobj1 librados2 librbd1 352s librdmacm1t64 lsscsi open-iscsi tgt 352s Suggested packages: 352s fio-examples gnuplot tgt-glusterfs tgt-rbd 352s Recommended packages: 352s finalrd 352s The following NEW packages will be installed: 352s autopkgtest-satdep fio libboost-iostreams1.83.0 libboost-thread1.83.0 352s libconfig-general-perl libdaxctl1 libgfapi0 libgfrpc0 libgfxdr0 352s libglusterfs0 libisns0t64 libnbd0 libndctl6 libopeniscsiusr libpmem1 352s libpmemobj1 librados2 librbd1 librdmacm1t64 lsscsi open-iscsi tgt 352s 0 upgraded, 22 newly installed, 0 to remove and 0 not upgraded. 352s Need to get 10.9 MB/11.0 MB of archives. 352s After this operation, 49.6 MB of additional disk space will be used. 352s Get:1 /tmp/autopkgtest.q4cQAG/2-autopkgtest-satdep.deb autopkgtest-satdep ppc64el 0 [732 B] 353s Get:2 http://ftpmaster.internal/ubuntu oracular/main ppc64el libopeniscsiusr ppc64el 2.1.10-1ubuntu1 [54.9 kB] 353s Get:3 http://ftpmaster.internal/ubuntu oracular/main ppc64el libisns0t64 ppc64el 0.101-1 [117 kB] 353s Get:4 http://ftpmaster.internal/ubuntu oracular/main ppc64el open-iscsi ppc64el 2.1.10-1ubuntu1 [385 kB] 353s Get:5 http://ftpmaster.internal/ubuntu oracular/main ppc64el librdmacm1t64 ppc64el 52.0-2ubuntu1 [80.6 kB] 353s Get:6 http://ftpmaster.internal/ubuntu oracular/universe ppc64el libconfig-general-perl all 2.65-2 [57.1 kB] 353s Get:7 http://ftpmaster.internal/ubuntu oracular/universe ppc64el tgt ppc64el 1:1.0.85-1.2ubuntu1 [254 kB] 353s Get:8 http://ftpmaster.internal/ubuntu oracular/universe ppc64el libgfxdr0 ppc64el 11.1-5ubuntu1 [21.7 kB] 353s Get:9 http://ftpmaster.internal/ubuntu oracular/universe ppc64el libglusterfs0 ppc64el 11.1-5ubuntu1 [308 kB] 353s Get:10 http://ftpmaster.internal/ubuntu oracular/universe ppc64el libgfrpc0 ppc64el 11.1-5ubuntu1 [46.3 kB] 353s Get:11 http://ftpmaster.internal/ubuntu oracular/universe ppc64el libgfapi0 ppc64el 11.1-5ubuntu1 [99.1 kB] 353s Get:12 http://ftpmaster.internal/ubuntu oracular/universe ppc64el libnbd0 ppc64el 1.20.2-2 [98.5 kB] 353s Get:13 http://ftpmaster.internal/ubuntu oracular/main ppc64el libdaxctl1 ppc64el 77-2.2ubuntu1 [23.7 kB] 353s Get:14 http://ftpmaster.internal/ubuntu oracular/main ppc64el libndctl6 ppc64el 77-2.2ubuntu1 [73.4 kB] 353s Get:15 http://ftpmaster.internal/ubuntu oracular/main ppc64el libpmem1 ppc64el 1.13.1-1.1ubuntu2 [41.1 kB] 353s Get:16 http://ftpmaster.internal/ubuntu oracular/main ppc64el libboost-iostreams1.83.0 ppc64el 1.83.0-3.1ubuntu2 [259 kB] 353s Get:17 http://ftpmaster.internal/ubuntu oracular/main ppc64el libboost-thread1.83.0 ppc64el 1.83.0-3.1ubuntu2 [281 kB] 353s Get:18 http://ftpmaster.internal/ubuntu oracular/main ppc64el librados2 ppc64el 19.2.0~is.really.19.1.0-0ubuntu2 [4151 kB] 353s Get:19 http://ftpmaster.internal/ubuntu oracular/main ppc64el libpmemobj1 ppc64el 1.13.1-1.1ubuntu2 [143 kB] 353s Get:20 http://ftpmaster.internal/ubuntu oracular/main ppc64el librbd1 ppc64el 19.2.0~is.really.19.1.0-0ubuntu2 [3684 kB] 354s Get:21 http://ftpmaster.internal/ubuntu oracular/universe ppc64el fio ppc64el 3.37-1 [716 kB] 354s Get:22 http://ftpmaster.internal/ubuntu oracular/main ppc64el lsscsi ppc64el 0.32-1build1 [54.0 kB] 354s Preconfiguring packages ... 354s Fetched 10.9 MB in 1s (9326 kB/s) 354s Selecting previously unselected package libopeniscsiusr. 354s (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 ... 72411 files and directories currently installed.) 354s Preparing to unpack .../00-libopeniscsiusr_2.1.10-1ubuntu1_ppc64el.deb ... 354s Unpacking libopeniscsiusr (2.1.10-1ubuntu1) ... 354s Selecting previously unselected package libisns0t64:ppc64el. 354s Preparing to unpack .../01-libisns0t64_0.101-1_ppc64el.deb ... 354s Unpacking libisns0t64:ppc64el (0.101-1) ... 354s Selecting previously unselected package open-iscsi. 354s Preparing to unpack .../02-open-iscsi_2.1.10-1ubuntu1_ppc64el.deb ... 354s Unpacking open-iscsi (2.1.10-1ubuntu1) ... 355s Selecting previously unselected package librdmacm1t64:ppc64el. 355s Preparing to unpack .../03-librdmacm1t64_52.0-2ubuntu1_ppc64el.deb ... 355s Unpacking librdmacm1t64:ppc64el (52.0-2ubuntu1) ... 355s Selecting previously unselected package libconfig-general-perl. 355s Preparing to unpack .../04-libconfig-general-perl_2.65-2_all.deb ... 355s Unpacking libconfig-general-perl (2.65-2) ... 355s Selecting previously unselected package tgt. 355s Preparing to unpack .../05-tgt_1%3a1.0.85-1.2ubuntu1_ppc64el.deb ... 355s Unpacking tgt (1:1.0.85-1.2ubuntu1) ... 355s Selecting previously unselected package libgfxdr0:ppc64el. 355s Preparing to unpack .../06-libgfxdr0_11.1-5ubuntu1_ppc64el.deb ... 355s Unpacking libgfxdr0:ppc64el (11.1-5ubuntu1) ... 355s Selecting previously unselected package libglusterfs0:ppc64el. 355s Preparing to unpack .../07-libglusterfs0_11.1-5ubuntu1_ppc64el.deb ... 355s Unpacking libglusterfs0:ppc64el (11.1-5ubuntu1) ... 355s Selecting previously unselected package libgfrpc0:ppc64el. 355s Preparing to unpack .../08-libgfrpc0_11.1-5ubuntu1_ppc64el.deb ... 355s Unpacking libgfrpc0:ppc64el (11.1-5ubuntu1) ... 355s Selecting previously unselected package libgfapi0:ppc64el. 355s Preparing to unpack .../09-libgfapi0_11.1-5ubuntu1_ppc64el.deb ... 355s Unpacking libgfapi0:ppc64el (11.1-5ubuntu1) ... 355s Selecting previously unselected package libnbd0. 355s Preparing to unpack .../10-libnbd0_1.20.2-2_ppc64el.deb ... 355s Unpacking libnbd0 (1.20.2-2) ... 355s Selecting previously unselected package libdaxctl1:ppc64el. 355s Preparing to unpack .../11-libdaxctl1_77-2.2ubuntu1_ppc64el.deb ... 355s Unpacking libdaxctl1:ppc64el (77-2.2ubuntu1) ... 355s Selecting previously unselected package libndctl6:ppc64el. 355s Preparing to unpack .../12-libndctl6_77-2.2ubuntu1_ppc64el.deb ... 355s Unpacking libndctl6:ppc64el (77-2.2ubuntu1) ... 355s Selecting previously unselected package libpmem1:ppc64el. 355s Preparing to unpack .../13-libpmem1_1.13.1-1.1ubuntu2_ppc64el.deb ... 355s Unpacking libpmem1:ppc64el (1.13.1-1.1ubuntu2) ... 355s Selecting previously unselected package libboost-iostreams1.83.0:ppc64el. 355s Preparing to unpack .../14-libboost-iostreams1.83.0_1.83.0-3.1ubuntu2_ppc64el.deb ... 355s Unpacking libboost-iostreams1.83.0:ppc64el (1.83.0-3.1ubuntu2) ... 355s Selecting previously unselected package libboost-thread1.83.0:ppc64el. 355s Preparing to unpack .../15-libboost-thread1.83.0_1.83.0-3.1ubuntu2_ppc64el.deb ... 355s Unpacking libboost-thread1.83.0:ppc64el (1.83.0-3.1ubuntu2) ... 355s Selecting previously unselected package librados2. 355s Preparing to unpack .../16-librados2_19.2.0~is.really.19.1.0-0ubuntu2_ppc64el.deb ... 355s Unpacking librados2 (19.2.0~is.really.19.1.0-0ubuntu2) ... 355s Selecting previously unselected package libpmemobj1:ppc64el. 355s Preparing to unpack .../17-libpmemobj1_1.13.1-1.1ubuntu2_ppc64el.deb ... 355s Unpacking libpmemobj1:ppc64el (1.13.1-1.1ubuntu2) ... 355s Selecting previously unselected package librbd1. 355s Preparing to unpack .../18-librbd1_19.2.0~is.really.19.1.0-0ubuntu2_ppc64el.deb ... 355s Unpacking librbd1 (19.2.0~is.really.19.1.0-0ubuntu2) ... 355s Selecting previously unselected package fio. 355s Preparing to unpack .../19-fio_3.37-1_ppc64el.deb ... 355s Unpacking fio (3.37-1) ... 355s Selecting previously unselected package lsscsi. 355s Preparing to unpack .../20-lsscsi_0.32-1build1_ppc64el.deb ... 355s Unpacking lsscsi (0.32-1build1) ... 355s Selecting previously unselected package autopkgtest-satdep. 355s Preparing to unpack .../21-2-autopkgtest-satdep.deb ... 355s Unpacking autopkgtest-satdep (0) ... 355s Setting up libconfig-general-perl (2.65-2) ... 355s Setting up libisns0t64:ppc64el (0.101-1) ... 355s Setting up libboost-thread1.83.0:ppc64el (1.83.0-3.1ubuntu2) ... 355s Setting up libnbd0 (1.20.2-2) ... 355s Setting up libopeniscsiusr (2.1.10-1ubuntu1) ... 355s Setting up libglusterfs0:ppc64el (11.1-5ubuntu1) ... 355s Setting up libboost-iostreams1.83.0:ppc64el (1.83.0-3.1ubuntu2) ... 355s Setting up lsscsi (0.32-1build1) ... 355s Setting up libdaxctl1:ppc64el (77-2.2ubuntu1) ... 355s Setting up libndctl6:ppc64el (77-2.2ubuntu1) ... 355s Setting up librdmacm1t64:ppc64el (52.0-2ubuntu1) ... 355s Setting up tgt (1:1.0.85-1.2ubuntu1) ... 356s Created symlink '/etc/systemd/system/multi-user.target.wants/tgt.service' → '/usr/lib/systemd/system/tgt.service'. 356s Setting up libpmem1:ppc64el (1.13.1-1.1ubuntu2) ... 356s Setting up libgfxdr0:ppc64el (11.1-5ubuntu1) ... 356s Setting up librados2 (19.2.0~is.really.19.1.0-0ubuntu2) ... 356s Setting up open-iscsi (2.1.10-1ubuntu1) ... 357s Created symlink '/etc/systemd/system/sockets.target.wants/iscsid.socket' → '/usr/lib/systemd/system/iscsid.socket'. 357s Created symlink '/etc/systemd/system/iscsi.service' → '/usr/lib/systemd/system/open-iscsi.service'. 357s Created symlink '/etc/systemd/system/sysinit.target.wants/open-iscsi.service' → '/usr/lib/systemd/system/open-iscsi.service'. 358s Setting up libpmemobj1:ppc64el (1.13.1-1.1ubuntu2) ... 358s Setting up librbd1 (19.2.0~is.really.19.1.0-0ubuntu2) ... 358s Setting up libgfrpc0:ppc64el (11.1-5ubuntu1) ... 358s Setting up libgfapi0:ppc64el (11.1-5ubuntu1) ... 358s Setting up fio (3.37-1) ... 358s Setting up autopkgtest-satdep (0) ... 358s Processing triggers for man-db (2.12.1-3) ... 360s Processing triggers for initramfs-tools (0.142ubuntu33) ... 360s update-initramfs: Generating /boot/initrd.img-6.8.0-31-generic 360s W: No lz4 in /usr/bin:/sbin:/bin, using gzip 369s Processing triggers for libc-bin (2.40-1ubuntu1) ... 372s (Reading database ... 72652 files and directories currently installed.) 372s Removing autopkgtest-satdep (0) ... 375s autopkgtest [02:05:38]: test tgtbasedmpaths: [----------------------- 375s + targetname=iqn.2016-11.foo.com:target.iscsi 375s + pwd 375s + cwd=/tmp/autopkgtest.q4cQAG/build.GKT/src 375s + testdir=/mnt/tgtmpathtest 375s + localhost=127.0.0.1 375s + portal=127.0.0.1:3260 375s + maxpaths=4 375s + backfn=backingfile 375s + expectwwid=60000000000000000e00000000010001 375s + testdisk=/dev/disk/by-id/wwn-0x60000000000000000e00000000010001 375s + bglog=/tmp/autopkgtest.q4cQAG/tgtbasedmpaths-artifacts/test-background.log 375s + fioprep=/tmp/autopkgtest.q4cQAG/tgtbasedmpaths-artifacts/path-change-prep.fio 375s + fiovrfy=/tmp/autopkgtest.q4cQAG/tgtbasedmpaths-artifacts/path-change-check.fio 375s + mkdir -p /etc/multipath 375s + echo /360000000000000000e00000000010001/ 375s + service tgt restart 375s + truncate --size 100M backingfile 375s + tgtadm --lld iscsi --op new --mode target --tid 1 -T iqn.2016-11.foo.com:target.iscsi 375s + tgtadm --lld iscsi --op bind --mode target --tid 1 -I ALL 375s + tgtadm --lld iscsi --op new --mode logicalunit --tid 1 --lun 1 -b /tmp/autopkgtest.q4cQAG/build.GKT/src/backingfile 375s + iscsiadm --mode discovery --type sendtargets --portal 127.0.0.1 376s 127.0.0.1:3260,1 iqn.2016-11.foo.com:target.iscsi 376s login #1 376s + echo login #1 376s + iscsiadm --mode node --targetname iqn.2016-11.foo.com:target.iscsi --portal 127.0.0.1:3260 --login 376s + seq 2 4 376s Logging in to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] 376s Login to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] successful. 376s extra login #2 376s + echo extra login #2 376s + iscsiadm --mode session -r 1 --op new 376s + echo extra login #3 376s + iscsiadm --mode session -r 1 --op new 376s Logging in to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] (multiple) 376s Login to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] successful. 376s extra login #3 376s Logging in to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] (multiple) 376s Login to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] successful. 376s extra login #4 376s + echo extra login #4 376s + iscsiadm --mode session -r 1 --op new 376s Logging in to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] (multiple) 376s Login to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] successful. 376s + udevadm settle 376s + sleep 5 381s Status after initial setup 381s Target 1: iqn.2016-11.foo.com:target.iscsi 381s System information: 381s Driver: iscsi 381s State: ready 381s I_T nexus information: 381s I_T nexus: 1 381s Initiator: iqn.2004-10.com.ubuntu:01:5f10e56a236 alias: autopkgtest 381s Connection: 0 381s IP Address: 127.0.0.1 381s I_T nexus: 2 381s Initiator: iqn.2004-10.com.ubuntu:01:5f10e56a236 alias: autopkgtest 381s Connection: 0 381s IP Address: 127.0.0.1 381s I_T nexus: 3 381s Initiator: iqn.2004-10.com.ubuntu:01:5f10e56a236 alias: autopkgtest 381s Connection: 0 381s IP Address: 127.0.0.1 381s I_T nexus: 4 381s Initiator: iqn.2004-10.com.ubuntu:01:5f10e56a236 alias: autopkgtest 381s Connection: 0 381s IP Address: 127.0.0.1 381s LUN information: 381s LUN: 0 381s Type: controller 381s SCSI ID: IET 00010000 381s SCSI SN: beaf10 381s Size: 0 MB, Block size: 1 381s Online: Yes 381s Removable media: No 381s Prevent removal: No 381s Readonly: No 381s SWP: No 381s Thin-provisioning: No 381s Backing store type: null 381s Backing store path: None 381s Backing store flags: 381s LUN: 1 381s Type: disk 381s SCSI ID: IET 00010001 381s SCSI SN: beaf11 381s Size: 105 MB, Block size: 512 381s Online: Yes 381s Removable media: No 381s Prevent removal: No 381s Readonly: No 381s SWP: No 381s Thin-provisioning: No 381s Backing store type: rdwr 381s Backing store path: /tmp/autopkgtest.q4cQAG/build.GKT/src/backingfile 381s Backing store flags: 381s Account information: 381s ACL information: 381s ALL 381s Session: 4 381s Connection: 0 381s Initiator: iqn.2004-10.com.ubuntu:01:5f10e56a236 381s IP Address: 127.0.0.1 381s Session: 3 381s Connection: 0 381s Initiator: iqn.2004-10.com.ubuntu:01:5f10e56a236 381s IP Address: 127.0.0.1 381s Session: 2 381s Connection: 0 381s Initiator: iqn.2004-10.com.ubuntu:01:5f10e56a236 381s IP Address: 127.0.0.1 381s Session: 1 381s Connection: 0 381s Initiator: iqn.2004-10.com.ubuntu:01:5f10e56a236 381s IP Address: 127.0.0.1 381s + echo Status after initial setup 381s + tgtadm --lld iscsi --mode target --op show 381s + tgtadm --lld iscsi --op show --mode conn --tid 1 381s + iscsiadm --mode session -P 1 381s + lsscsi -liv 381s list_ndevices: scandir: /sys/class/nvme/: No such file or directory 381s + multipath -v3 -ll 381s Target: iqn.2016-11.foo.com:target.iscsi (non-flash) 381s Current Portal: 127.0.0.1:3260,1 381s Persistent Portal: 127.0.0.1:3260,1 381s ********** 381s Interface: 381s ********** 381s Iface Name: default 381s Iface Transport: tcp 381s Iface Initiatorname: iqn.2004-10.com.ubuntu:01:5f10e56a236 381s Iface IPaddress: 127.0.0.1 381s Iface HWaddress: default 381s Iface Netdev: default 381s SID: 1 381s iSCSI Connection State: LOGGED IN 381s iSCSI Session State: LOGGED_IN 381s Internal iscsid Session State: NO CHANGE 381s 381s ********** 381s Interface: 381s ********** 381s Iface Name: default 381s Iface Transport: tcp 381s Iface Initiatorname: iqn.2004-10.com.ubuntu:01:5f10e56a236 381s Iface IPaddress: 127.0.0.1 381s Iface HWaddress: default 381s Iface Netdev: default 381s SID: 2 381s iSCSI Connection State: LOGGED IN 381s iSCSI Session State: LOGGED_IN 381s Internal iscsid Session State: NO CHANGE 381s 381s ********** 381s Interface: 381s ********** 381s Iface Name: default 381s Iface Transport: tcp 381s Iface Initiatorname: iqn.2004-10.com.ubuntu:01:5f10e56a236 381s Iface IPaddress: 127.0.0.1 381s Iface HWaddress: default 381s Iface Netdev: default 381s SID: 3 381s iSCSI Connection State: LOGGED IN 381s iSCSI Session State: LOGGED_IN 381s Internal iscsid Session State: NO CHANGE 381s 381s ********** 381s Interface: 381s ********** 381s Iface Name: default 381s Iface Transport: tcp 381s Iface Initiatorname: iqn.2004-10.com.ubuntu:01:5f10e56a236 381s Iface IPaddress: 127.0.0.1 381s Iface HWaddress: default 381s Iface Netdev: default 381s SID: 4 381s iSCSI Connection State: LOGGED IN 381s iSCSI Session State: LOGGED_IN 381s Internal iscsid Session State: NO CHANGE 381s [0:0:0:0] storage IET Controller 0001 - - 381s state=running queue_depth=32 scsi_level=6 type=12 device_blocked=0 timeout=30 381s dir: /sys/bus/scsi/devices/0:0:0:0 [/sys/devices/platform/host0/session1/target0:0:0/0:0:0:0] 381s [0:0:0:1] disk IET VIRTUAL-DISK 0001 /dev/sda 360000000000000000e00000000010001 381s state=running queue_depth=32 scsi_level=6 type=0 device_blocked=0 timeout=30 381s dir: /sys/bus/scsi/devices/0:0:0:1 [/sys/devices/platform/host0/session1/target0:0:0/0:0:0:1] 381s [1:0:0:0] storage IET Controller 0001 - - 381s state=running queue_depth=32 scsi_level=6 type=12 device_blocked=0 timeout=30 381s dir: /sys/bus/scsi/devices/1:0:0:0 [/sys/devices/platform/host1/session2/target1:0:0/1:0:0:0] 381s [1:0:0:1] disk IET VIRTUAL-DISK 0001 /dev/sdb 360000000000000000e00000000010001 381s state=running queue_depth=32 scsi_level=6 type=0 device_blocked=0 timeout=30 381s dir: /sys/bus/scsi/devices/1:0:0:1 [/sys/devices/platform/host1/session2/target1:0:0/1:0:0:1] 381s [2:0:0:0] storage IET Controller 0001 - - 381s state=running queue_depth=32 scsi_level=6 type=12 device_blocked=0 timeout=30 381s dir: /sys/bus/scsi/devices/2:0:0:0 [/sys/devices/platform/host2/session3/target2:0:0/2:0:0:0] 381s [2:0:0:1] disk IET VIRTUAL-DISK 0001 /dev/sdc 33000000100000001 381s state=running queue_depth=32 scsi_level=6 type=0 device_blocked=0 timeout=30 381s dir: /sys/bus/scsi/devices/2:0:0:1 [/sys/devices/platform/host2/session3/target2:0:0/2:0:0:1] 381s [3:0:0:0] storage IET Controller 0001 - - 381s state=running queue_depth=32 scsi_level=6 type=12 device_blocked=0 timeout=30 381s dir: /sys/bus/scsi/devices/3:0:0:0 [/sys/devices/platform/host3/session4/target3:0:0/3:0:0:0] 381s [3:0:0:1] disk IET VIRTUAL-DISK 0001 /dev/sdd 360000000000000000e00000000010001 381s state=running queue_depth=32 scsi_level=6 type=0 device_blocked=0 timeout=30 381s dir: /sys/bus/scsi/devices/3:0:0:1 [/sys/devices/platform/host3/session4/target3:0:0/3:0:0:1] 381s NVMe module may not be loaded 381s 49.874419 | set open fds limit to 1073741816/1073741816 381s 49.874494 | _read_bindings_file: reading /etc/multipath/bindings 381s 49.874530 | loading /usr/lib/multipath/libchecktur.so checker 381s 49.874639 | checker tur: message table size = 4 381s 49.874649 | loading /usr/lib/multipath/libprioconst.so prioritizer 381s 49.874803 | _init_foreign: foreign library "nvme" is not enabled 381s 49.881497 | vda: device node name blacklisted 381s 49.881797 | sda: size = 204800 381s 49.881922 | sda: vendor = IET 381s 49.881942 | sda: product = VIRTUAL-DISK 381s 49.881962 | sda: rev = 0001 381s 49.882638 | sda: h:b:t:l = 0:0:0:1 381s 49.882973 | sda: tgt_node_name = iqn.2016-11.foo.com:target.iscsi 381s 49.882979 | sda: uid_attribute = ID_SERIAL (setting: multipath internal) 381s 49.882982 | sda: recheck_wwid = 1 (setting: multipath.conf defaults/devices section) 381s 49.883148 | sda: 1024 cyl, 4 heads, 50 sectors/track, start at 0 381s 49.883151 | sda: vpd_vendor_id = 0 "undef" (setting: multipath internal) 381s 49.883166 | sda: serial = beaf11 381s 49.883169 | sda: detect_checker = yes (setting: multipath internal) 381s 49.883195 | sda checker timeout = 30 s (setting: kernel sysfs) 381s 49.884069 | sda: path_checker = tur (setting: multipath internal) 381s 49.885698 | sda: tur state = up 381s 49.885842 | sdb: size = 204800 381s 49.885967 | sdb: vendor = IET 381s 49.885987 | sdb: product = VIRTUAL-DISK 381s 49.886006 | sdb: rev = 0001 381s 49.886648 | sdb: h:b:t:l = 1:0:0:1 381s 49.887004 | sdb: tgt_node_name = iqn.2016-11.foo.com:target.iscsi 381s 49.887008 | sdb: uid_attribute = ID_SERIAL (setting: multipath internal) 381s 49.887011 | sdb: recheck_wwid = 1 (setting: multipath.conf defaults/devices section) 381s 49.887150 | sdb: 1024 cyl, 4 heads, 50 sectors/track, start at 0 381s 49.887153 | sdb: vpd_vendor_id = 0 "undef" (setting: multipath internal) 381s 49.887166 | sdb: serial = beaf11 381s 49.887168 | sdb: detect_checker = yes (setting: multipath internal) 381s 49.887193 | sdb checker timeout = 30 s (setting: kernel sysfs) 381s 49.888054 | sdb: path_checker = tur (setting: multipath internal) 381s 49.889210 | sdb: tur state = up 381s 49.889359 | sdc: size = 204800 381s 49.889512 | sdc: vendor = IET 381s 49.889535 | sdc: product = VIRTUAL-DISK 381s 49.889559 | sdc: rev = 0001 381s 49.890272 | sdc: h:b:t:l = 2:0:0:1 381s 49.890735 | sdc: tgt_node_name = iqn.2016-11.foo.com:target.iscsi 381s 49.890740 | sdc: uid_attribute = ID_SERIAL (setting: multipath internal) 381s 49.890749 | sdc: recheck_wwid = 1 (setting: multipath.conf defaults/devices section) 381s 49.890915 | sdc: 1024 cyl, 4 heads, 50 sectors/track, start at 0 381s 49.890919 | sdc: vpd_vendor_id = 0 "undef" (setting: multipath internal) 381s 49.890933 | sdc: serial = beaf11 381s 49.890936 | sdc: detect_checker = yes (setting: multipath internal) 381s 49.890966 | sdc checker timeout = 30 s (setting: kernel sysfs) 381s 49.891896 | sdc: path_checker = tur (setting: multipath internal) 381s 49.893155 | sdc: tur state = up 381s 49.893312 | sdd: size = 204800 381s 49.893464 | sdd: vendor = IET 381s 49.893488 | sdd: product = VIRTUAL-DISK 381s 49.893511 | sdd: rev = 0001 381s 49.894326 | sdd: h:b:t:l = 3:0:0:1 381s 49.894747 | sdd: tgt_node_name = iqn.2016-11.foo.com:target.iscsi 381s 49.894752 | sdd: uid_attribute = ID_SERIAL (setting: multipath internal) 381s 49.894755 | sdd: recheck_wwid = 1 (setting: multipath.conf defaults/devices section) 381s 49.894921 | sdd: 1024 cyl, 4 heads, 50 sectors/track, start at 0 381s 49.894925 | sdd: vpd_vendor_id = 0 "undef" (setting: multipath internal) 381s 49.894939 | sdd: serial = beaf11 381s 49.894942 | sdd: detect_checker = yes (setting: multipath internal) 381s 49.894972 | sdd checker timeout = 30 s (setting: kernel sysfs) 381s 49.896084 | sdd: path_checker = tur (setting: multipath internal) 381s 49.897473 | sdd: tur state = up 381s 49.897593 | loop0: device node name blacklisted 381s 49.897696 | loop1: device node name blacklisted 381s 49.897795 | loop2: device node name blacklisted 381s 49.897892 | loop3: device node name blacklisted 381s 49.897990 | loop4: device node name blacklisted 381s 49.898086 | loop5: device node name blacklisted 381s 49.898186 | loop6: device node name blacklisted 381s 49.898283 | loop7: device node name blacklisted 381s 49.898387 | dm-0: device node name blacklisted 381s 49.899715 | multipath-tools v0.9.9 (05/03, 2024) 381s 49.899729 | libdevmapper version 1.02.196 381s 49.899907 | kernel device mapper v4.48.0 381s 49.899921 | DM multipath kernel driver v1.14.0 381s 49.900075 | sda: size = 204800 381s 49.900089 | sda: vendor = IET 381s 49.900093 | sda: product = VIRTUAL-DISK 381s 49.900096 | sda: rev = 0001 381s 49.900845 | sda: h:b:t:l = 0:0:0:1 381s 49.900984 | sda: tgt_node_name = iqn.2016-11.foo.com:target.iscsi 381s 49.901006 | sda: 1024 cyl, 4 heads, 50 sectors/track, start at 0 381s 49.901009 | sda: vpd_vendor_id = 0 "undef" (setting: multipath internal) 381s 49.901023 | sda: serial = beaf11 381s 49.901941 | sda: tur state = up 381s 49.901949 | sda: uid = 360000000000000000e00000000010001 (udev) 381s 49.901952 | sda: detect_prio = yes (setting: multipath internal) 381s 49.901957 | sda: prio = const (setting: multipath internal) 381s 49.901959 | sda: prio args = "" (setting: multipath internal) 381s 49.901962 | sda: const prio = 1 381s 49.901991 | sdb: size = 204800 381s 49.901997 | sdb: vendor = IET 381s 49.902000 | sdb: product = VIRTUAL-DISK 381s 49.902003 | sdb: rev = 0001 381s 49.902775 | sdb: h:b:t:l = 1:0:0:1 381s 49.902914 | sdb: tgt_node_name = iqn.2016-11.foo.com:target.iscsi 381s 49.902936 | sdb: 1024 cyl, 4 heads, 50 sectors/track, start at 0 381s 49.902940 | sdb: vpd_vendor_id = 0 "undef" (setting: multipath internal) 381s 49.902955 | sdb: serial = beaf11 381s 49.903920 | sdb: tur state = up 381s 49.903927 | sdb: uid = 360000000000000000e00000000010001 (udev) 381s 49.903930 | sdb: detect_prio = yes (setting: multipath internal) 381s 49.903933 | sdb: prio = const (setting: multipath internal) 381s 49.903936 | sdb: prio args = "" (setting: multipath internal) 381s 49.903939 | sdb: const prio = 1 381s 49.903967 | sdc: size = 204800 381s 49.903973 | sdc: vendor = IET 381s 49.903976 | sdc: product = VIRTUAL-DISK 381s 49.903979 | sdc: rev = 0001 381s 49.904685 | sdc: h:b:t:l = 2:0:0:1 381s 49.904826 | sdc: tgt_node_name = iqn.2016-11.foo.com:target.iscsi 381s 49.904851 | sdc: 1024 cyl, 4 heads, 50 sectors/track, start at 0 381s 49.904855 | sdc: vpd_vendor_id = 0 "undef" (setting: multipath internal) 381s 49.904869 | sdc: serial = beaf11 381s 49.905726 | sdc: tur state = up 381s 49.905734 | sdc: uid = 360000000000000000e00000000010001 (udev) 381s 49.905736 | sdc: detect_prio = yes (setting: multipath internal) 381s 49.905739 | sdc: prio = const (setting: multipath internal) 381s 49.905741 | sdc: prio args = "" (setting: multipath internal) 381s 49.905744 | sdc: const prio = 1 381s 49.905769 | sdd: size = 204800 381s 49.905775 | sdd: vendor = IET 381s 49.905778 | sdd: product = VIRTUAL-DISK 381s 49.905781 | sdd: rev = 0001 381s 49.906512 | sdd: h:b:t:l = 3:0:0:1 381s 49.906642 | sdd: tgt_node_name = iqn.2016-11.foo.com:target.iscsi 381s 49.906663 | sdd: 1024 cyl, 4 heads, 50 sectors/track, start at 0 381s 49.906666 | sdd: vpd_vendor_id = 0 "undef" (setting: multipath internal) 381s 49.906678 | sdd: serial = beaf11 381s 49.907538 | sdd: tur state = up 381s 49.907544 | sdd: uid = 360000000000000000e00000000010001 (udev) 381s 49.907547 | sdd: detect_prio = yes (setting: multipath internal) 381s 49.907549 | sdd: prio = const (setting: multipath internal) 381s 49.907552 | sdd: prio args = "" (setting: multipath internal) 381s 49.907554 | sdd: const prio = 1 381s 49.908448 | unloading tur checker 381s 49.908509 | unloading const prioritizer 381s + dmsetup table 381s + grep . /etc/multipath/bindings /etc/multipath/wwids 381s + systemctl status multipathd.service 381s ===== paths list ===== 381s uuid hcil dev dev_t pri dm_st chk_st vend/prod/rev dev_st 381s 0:0:0:1 sda 8:0 -1 undef undef IET,VIRTUAL-DISK,0001 unknown 381s 1:0:0:1 sdb 8:16 -1 undef undef IET,VIRTUAL-DISK,0001 unknown 381s 2:0:0:1 sdc 8:32 -1 undef undef IET,VIRTUAL-DISK,0001 unknown 381s 3:0:0:1 sdd 8:48 -1 undef undef IET,VIRTUAL-DISK,0001 unknown 381s mpatha (360000000000000000e00000000010001) dm-0 IET,VIRTUAL-DISK 381s size=100M features='0' hwhandler='0' wp=rw 381s |-+- policy='service-time 0' prio=1 status=active 381s | `- 0:0:0:1 sda 8:0 active ready running 381s |-+- policy='service-time 0' prio=1 status=enabled 381s | `- 1:0:0:1 sdb 8:16 active ready running 381s |-+- policy='service-time 0' prio=1 status=enabled 381s | `- 2:0:0:1 sdc 8:32 active ready running 381s `-+- policy='service-time 0' prio=1 status=enabled 381s `- 3:0:0:1 sdd 8:48 active ready running 381s 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:32 1 1 service-time 0 1 2 8:48 1 1 381s /etc/multipath/bindings:# Multipath bindings, Version : 1.0 381s /etc/multipath/bindings:# NOTE: this file is automatically maintained by the multipath program. 381s /etc/multipath/bindings:# You should not need to edit this file in normal circumstances. 381s /etc/multipath/bindings:# 381s /etc/multipath/bindings:# Format: 381s /etc/multipath/bindings:# alias wwid 381s /etc/multipath/bindings:# 381s /etc/multipath/bindings:mpatha 360000000000000000e00000000010001 381s /etc/multipath/wwids:/360000000000000000e00000000010001/ 381s ● multipathd.service - Device-Mapper Multipath Device Controller 381s Loaded: loaded (/usr/lib/systemd/system/multipathd.service; enabled; preset: enabled) 381s Active: active (running) since Wed 2024-09-04 02:04:57 UTC; 46s ago 381s Invocation: 4a054c04b76f4ac59478b5fdebac11aa 381s TriggeredBy: ○ multipathd.socket 381s Main PID: 307 (multipathd) 381s Status: "up" 381s Tasks: 7 381s Memory: 28M (peak: 38.1M) 381s CPU: 46ms 381s CGroup: /system.slice/multipathd.service 381s └─307 /sbin/multipathd -d -s 381s 381s Sep 04 02:04:57 autopkgtest multipathd[307]: multipathd v0.9.9: start up 381s Sep 04 02:04:57 autopkgtest multipathd[307]: reconfigure: setting up paths and maps 381s Sep 04 02:04:57 autopkgtest systemd[1]: Started multipathd.service - Device-Mapper Multipath Device Controller. 381s Sep 04 02:05:39 autopkgtest multipathd[307]: updated bindings file /etc/multipath/bindings 381s Sep 04 02:05:39 autopkgtest multipathd[307]: mpatha: addmap [0 204800 multipath 0 0 1 1 service-time 0 1 1 8:0 1] 381s Sep 04 02:05:39 autopkgtest multipathd[307]: sda [8:0]: path added to devmap mpatha 381s Sep 04 02:05:39 autopkgtest multipathd[307]: mpatha: performing delayed actions 381s Sep 04 02:05:39 autopkgtest multipathd[307]: 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:32 1 service-time 0 1 1 8:48 1] 381s ○ multipathd.socket - multipathd control socket 381s Loaded: loaded (/usr/lib/systemd/system/multipathd.socket; static) 381s Active: inactive (dead) 381s Triggers: ● multipathd.service 381s Listen: @/org/kernel/linux/storage/multipathd (Stream) 381s + systemctl status multipathd.socket 381s autopkgtest [02:05:44]: test tgtbasedmpaths: -----------------------] 382s autopkgtest [02:05:45]: test tgtbasedmpaths: - - - - - - - - - - results - - - - - - - - - - 382s tgtbasedmpaths FAIL non-zero exit status 3 382s autopkgtest [02:05:45]: @@@@@@@@@@@@@@@@@@@@ summary 382s initramfs SKIP Test lists explicitly supported architectures, but the current architecture ppc64el isn't listed. 382s initramfs SKIP Test lists explicitly supported architectures, but the current architecture ppc64el isn't listed. 382s kpartx-file-loopback PASS 382s tgtbasedmpaths FAIL non-zero exit status 3 388s nova [W] Using flock in prodstack6-ppc64el 388s Creating nova instance adt-oracular-ppc64el-multipath-tools-20240904-015922-juju-7f2275-prod-proposed-migration-environment-2-2139fcca-c2b8-4176-8870-4eac5849c647 from image adt/ubuntu-oracular-ppc64el-server-20240903.img (UUID f0cdb5b2-c780-4e24-8a7a-2f56e2f15745)... 388s nova [W] Using flock in prodstack6-ppc64el 388s Creating nova instance adt-oracular-ppc64el-multipath-tools-20240904-015922-juju-7f2275-prod-proposed-migration-environment-2-2139fcca-c2b8-4176-8870-4eac5849c647 from image adt/ubuntu-oracular-ppc64el-server-20240903.img (UUID f0cdb5b2-c780-4e24-8a7a-2f56e2f15745)...