17s autopkgtest [10:49:06]: starting date and time: 2024-08-26 10:49:06+0000
 17s autopkgtest [10:49:06]: git checkout: fd3bed09 nova: allow more retries for quota issues
 17s autopkgtest [10:49:06]: host juju-7f2275-prod-proposed-migration-environment-3; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.kfbw1vwm/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:linux-meta --apt-upgrade multipath-tools --timeout-short=300 --timeout-copy=20000 --timeout-test=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=linux-meta/6.11.0-4.4 --setup-commands 'apt-get install -y ^kernel-testing--linux--full--preferred$ || apt-get install -y ^linux-image$ ^linux-headers$ || apt-get install -y ^linux-image-generic$ ^linux-headers-generic$' --setup-commands 'apt-get install -y ^kernel-testing--linux--modules-extra--preferred$ || apt-get install -y ^linux-modules-extra$ || :' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-big-ppc64el --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-3@bos03-ppc64el-9.secgroup --name adt-oracular-ppc64el-multipath-tools-20240826-104846-juju-7f2275-prod-proposed-migration-environment-3-6744efa4-f91e-402d-ba93-f3eb53a14179 --image adt/ubuntu-oracular-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-3 --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/
244s autopkgtest [10:52:53]: testbed dpkg architecture: ppc64el
244s autopkgtest [10:52:53]: testbed apt version: 2.9.8
244s autopkgtest [10:52:53]: @@@@@@@@@@@@@@@@@@@@ test bed setup
246s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [126 kB]
246s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [849 kB]
246s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [8408 B]
246s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [57.9 kB]
246s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [11.1 kB]
246s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el Packages [71.6 kB]
246s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el c-n-f Metadata [2184 B]
246s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/restricted ppc64el Packages [1376 B]
246s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/restricted ppc64el c-n-f Metadata [120 B]
246s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/universe ppc64el Packages [751 kB]
246s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/universe ppc64el c-n-f Metadata [19.4 kB]
246s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse ppc64el Packages [5956 B]
246s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse ppc64el c-n-f Metadata [372 B]
248s Fetched 1905 kB in 1s (1657 kB/s)
248s Reading package lists...
252s Reading package lists...
252s Building dependency tree...
252s Reading state information...
252s Calculating upgrade...
252s The following NEW packages will be installed:
252s   libpython3.12t64 linux-headers-6.11.0-4 linux-headers-6.11.0-4-generic
252s   linux-image-6.11.0-4-generic linux-modules-6.11.0-4-generic
252s   linux-modules-extra-6.11.0-4-generic linux-tools-6.11.0-4
252s   linux-tools-6.11.0-4-generic
252s The following packages will be upgraded:
252s   libsqlite3-0 linux-generic linux-headers-generic linux-headers-virtual
252s   linux-image-generic linux-image-virtual linux-virtual
252s 7 upgraded, 8 newly installed, 0 to remove and 0 not upgraded.
252s Need to get 227 MB of archives.
252s After this operation, 343 MB of additional disk space will be used.
252s Get:1 http://ftpmaster.internal/ubuntu oracular/main ppc64el libsqlite3-0 ppc64el 3.46.1-1 [806 kB]
253s Get:2 http://ftpmaster.internal/ubuntu oracular/main ppc64el libpython3.12t64 ppc64el 3.12.5-4 [2560 kB]
253s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-modules-6.11.0-4-generic ppc64el 6.11.0-4.4 [32.8 MB]
255s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-image-6.11.0-4-generic ppc64el 6.11.0-4.4 [63.9 MB]
258s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-modules-extra-6.11.0-4-generic ppc64el 6.11.0-4.4 [105 MB]
264s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-generic ppc64el 6.11.0-4.4 [1728 B]
264s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-image-generic ppc64el 6.11.0-4.4 [10.6 kB]
264s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-virtual ppc64el 6.11.0-4.4 [1720 B]
264s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-image-virtual ppc64el 6.11.0-4.4 [10.6 kB]
264s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-headers-virtual ppc64el 6.11.0-4.4 [1642 B]
264s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-headers-6.11.0-4 all 6.11.0-4.4 [13.9 MB]
265s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-headers-6.11.0-4-generic ppc64el 6.11.0-4.4 [3949 kB]
265s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-headers-generic ppc64el 6.11.0-4.4 [10.5 kB]
265s Get:14 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-tools-6.11.0-4 ppc64el 6.11.0-4.4 [4201 kB]
266s Get:15 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-tools-6.11.0-4-generic ppc64el 6.11.0-4.4 [1746 B]
266s Fetched 227 MB in 14s (16.8 MB/s)
266s (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 ... 72440 files and directories currently installed.)
266s Preparing to unpack .../00-libsqlite3-0_3.46.1-1_ppc64el.deb ...
266s Unpacking libsqlite3-0:ppc64el (3.46.1-1) over (3.46.0-1) ...
266s Selecting previously unselected package libpython3.12t64:ppc64el.
266s Preparing to unpack .../01-libpython3.12t64_3.12.5-4_ppc64el.deb ...
266s Unpacking libpython3.12t64:ppc64el (3.12.5-4) ...
266s Selecting previously unselected package linux-modules-6.11.0-4-generic.
266s Preparing to unpack .../02-linux-modules-6.11.0-4-generic_6.11.0-4.4_ppc64el.deb ...
266s Unpacking linux-modules-6.11.0-4-generic (6.11.0-4.4) ...
267s Selecting previously unselected package linux-image-6.11.0-4-generic.
267s Preparing to unpack .../03-linux-image-6.11.0-4-generic_6.11.0-4.4_ppc64el.deb ...
267s Unpacking linux-image-6.11.0-4-generic (6.11.0-4.4) ...
267s Selecting previously unselected package linux-modules-extra-6.11.0-4-generic.
267s Preparing to unpack .../04-linux-modules-extra-6.11.0-4-generic_6.11.0-4.4_ppc64el.deb ...
267s Unpacking linux-modules-extra-6.11.0-4-generic (6.11.0-4.4) ...
268s Preparing to unpack .../05-linux-generic_6.11.0-4.4_ppc64el.deb ...
268s Unpacking linux-generic (6.11.0-4.4) over (6.8.0-31.31) ...
268s Preparing to unpack .../06-linux-image-generic_6.11.0-4.4_ppc64el.deb ...
268s Unpacking linux-image-generic (6.11.0-4.4) over (6.8.0-31.31) ...
268s Preparing to unpack .../07-linux-virtual_6.11.0-4.4_ppc64el.deb ...
268s Unpacking linux-virtual (6.11.0-4.4) over (6.8.0-31.31) ...
268s Preparing to unpack .../08-linux-image-virtual_6.11.0-4.4_ppc64el.deb ...
268s Unpacking linux-image-virtual (6.11.0-4.4) over (6.8.0-31.31) ...
268s Preparing to unpack .../09-linux-headers-virtual_6.11.0-4.4_ppc64el.deb ...
268s Unpacking linux-headers-virtual (6.11.0-4.4) over (6.8.0-31.31) ...
268s Selecting previously unselected package linux-headers-6.11.0-4.
268s Preparing to unpack .../10-linux-headers-6.11.0-4_6.11.0-4.4_all.deb ...
268s Unpacking linux-headers-6.11.0-4 (6.11.0-4.4) ...
270s Selecting previously unselected package linux-headers-6.11.0-4-generic.
270s Preparing to unpack .../11-linux-headers-6.11.0-4-generic_6.11.0-4.4_ppc64el.deb ...
270s Unpacking linux-headers-6.11.0-4-generic (6.11.0-4.4) ...
271s Preparing to unpack .../12-linux-headers-generic_6.11.0-4.4_ppc64el.deb ...
271s Unpacking linux-headers-generic (6.11.0-4.4) over (6.8.0-31.31) ...
272s Selecting previously unselected package linux-tools-6.11.0-4.
272s Preparing to unpack .../13-linux-tools-6.11.0-4_6.11.0-4.4_ppc64el.deb ...
272s Unpacking linux-tools-6.11.0-4 (6.11.0-4.4) ...
272s Selecting previously unselected package linux-tools-6.11.0-4-generic.
272s Preparing to unpack .../14-linux-tools-6.11.0-4-generic_6.11.0-4.4_ppc64el.deb ...
272s Unpacking linux-tools-6.11.0-4-generic (6.11.0-4.4) ...
272s Setting up libsqlite3-0:ppc64el (3.46.1-1) ...
272s Setting up linux-modules-6.11.0-4-generic (6.11.0-4.4) ...
274s Setting up linux-image-6.11.0-4-generic (6.11.0-4.4) ...
276s I: /boot/vmlinux is now a symlink to vmlinux-6.11.0-4-generic
276s I: /boot/initrd.img is now a symlink to initrd.img-6.11.0-4-generic
276s Setting up libpython3.12t64:ppc64el (3.12.5-4) ...
276s Setting up linux-modules-extra-6.11.0-4-generic (6.11.0-4.4) ...
278s Setting up linux-headers-6.11.0-4 (6.11.0-4.4) ...
278s Setting up linux-image-virtual (6.11.0-4.4) ...
278s Setting up linux-tools-6.11.0-4 (6.11.0-4.4) ...
278s Setting up linux-image-generic (6.11.0-4.4) ...
278s Setting up linux-headers-6.11.0-4-generic (6.11.0-4.4) ...
278s Setting up linux-tools-6.11.0-4-generic (6.11.0-4.4) ...
278s Setting up linux-headers-generic (6.11.0-4.4) ...
278s Setting up linux-headers-virtual (6.11.0-4.4) ...
278s Setting up linux-generic (6.11.0-4.4) ...
278s Setting up linux-virtual (6.11.0-4.4) ...
278s Processing triggers for libc-bin (2.40-1ubuntu1) ...
278s Processing triggers for linux-image-6.11.0-4-generic (6.11.0-4.4) ...
278s /etc/kernel/postinst.d/initramfs-tools:
278s update-initramfs: Generating /boot/initrd.img-6.11.0-4-generic
278s W: No lz4 in /usr/bin:/sbin:/bin, using gzip
286s /etc/kernel/postinst.d/zz-update-grub:
286s Sourcing file `/etc/default/grub'
286s Sourcing file `/etc/default/grub.d/50-cloudimg-settings.cfg'
286s Generating grub configuration file ...
286s Found linux image: /boot/vmlinux-6.11.0-4-generic
286s Found initrd image: /boot/initrd.img-6.11.0-4-generic
286s Found linux image: /boot/vmlinux-6.8.0-31-generic
286s Found initrd image: /boot/initrd.img-6.8.0-31-generic
286s Warning: os-prober will not be executed to detect other bootable partitions.
286s Systems on them will not be added to the GRUB boot configuration.
286s Check GRUB_DISABLE_OS_PROBER documentation entry.
286s Adding boot menu entry for UEFI Firmware Settings ...
287s done
287s Reading package lists...
287s Building dependency tree...
287s Reading state information...
287s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
288s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease
288s Hit:2 http://ftpmaster.internal/ubuntu oracular InRelease
288s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease
288s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease
289s Reading package lists...
289s Reading package lists...
289s Building dependency tree...
289s Reading state information...
289s Calculating upgrade...
289s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
289s Reading package lists...
289s Building dependency tree...
289s Reading state information...
290s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
291s Reading package lists...
291s Building dependency tree...
291s Reading state information...
291s linux-generic is already the newest version (6.11.0-4.4).
291s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
302s Reading package lists...
302s Building dependency tree...
302s Reading state information...
302s E: Unable to locate package ^kernel-testing--linux--modules-extra--preferred$
302s E: Couldn't find any package by regex '^kernel-testing--linux--modules-extra--preferred$'
302s Reading package lists...
302s Building dependency tree...
302s Reading state information...
302s E: Unable to locate package ^linux-modules-extra$
302s E: Couldn't find any package by regex '^linux-modules-extra$'
303s autopkgtest [10:53:52]: rebooting testbed after setup commands that affected boot
339s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds...
372s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds...
579s autopkgtest [10:58:28]: testbed running kernel: Linux 6.11.0-4-generic #4-Ubuntu SMP Tue Aug 20 14:54:18 UTC 2024
647s autopkgtest [10:59:36]: @@@@@@@@@@@@@@@@@@@@ apt-source multipath-tools
665s Get:1 http://ftpmaster.internal/ubuntu oracular/main multipath-tools 0.9.9-1ubuntu2 (dsc) [2772 B]
665s Get:2 http://ftpmaster.internal/ubuntu oracular/main multipath-tools 0.9.9-1ubuntu2 (tar) [588 kB]
665s Get:3 http://ftpmaster.internal/ubuntu oracular/main multipath-tools 0.9.9-1ubuntu2 (diff) [42.4 kB]
665s gpgv: Signature made Tue Jul 23 21:24:22 2024 UTC
665s gpgv:                using RSA key D09F8A854F1055BCFC482C4B23566B906047AFC8
665s gpgv: Can't check signature: No public key
665s dpkg-source: warning: cannot verify inline signature for ./multipath-tools_0.9.9-1ubuntu2.dsc: no acceptable signature found
665s autopkgtest [10:59:54]: testing package multipath-tools version 0.9.9-1ubuntu2
667s initramfs            SKIP Test lists explicitly supported architectures, but the current architecture ppc64el isn't listed.
667s autopkgtest [10:59:56]: build not needed
685s initramfs            SKIP Test lists explicitly supported architectures, but the current architecture ppc64el isn't listed.
685s autopkgtest [11:00:14]: test kpartx-file-loopback: preparing testbed
702s Reading package lists...
702s Building dependency tree...
702s Reading state information...
703s Starting pkgProblemResolver with broken count: 0
703s Starting 2 pkgProblemResolver with broken count: 0
703s Done
703s The following additional packages will be installed:
703s   liburing2 qemu-utils
703s Recommended packages:
703s   qemu-block-extra
703s The following NEW packages will be installed:
703s   autopkgtest-satdep liburing2 qemu-utils
703s 0 upgraded, 3 newly installed, 0 to remove and 0 not upgraded.
703s Need to get 2432 kB/2433 kB of archives.
703s After this operation, 16.9 MB of additional disk space will be used.
703s Get:1 /tmp/autopkgtest.PXg9mZ/1-autopkgtest-satdep.deb autopkgtest-satdep ppc64el 0 [724 B]
703s Get:2 http://ftpmaster.internal/ubuntu oracular/main ppc64el liburing2 ppc64el 2.6-1 [26.9 kB]
703s Get:3 http://ftpmaster.internal/ubuntu oracular/main ppc64el qemu-utils ppc64el 1:9.0.2+ds-4ubuntu2 [2405 kB]
704s Fetched 2432 kB in 1s (3046 kB/s)
704s Selecting previously unselected package liburing2:ppc64el.
704s (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 ... 109830 files and directories currently installed.)
704s Preparing to unpack .../liburing2_2.6-1_ppc64el.deb ...
704s Unpacking liburing2:ppc64el (2.6-1) ...
704s Selecting previously unselected package qemu-utils.
704s Preparing to unpack .../qemu-utils_1%3a9.0.2+ds-4ubuntu2_ppc64el.deb ...
704s Unpacking qemu-utils (1:9.0.2+ds-4ubuntu2) ...
705s Selecting previously unselected package autopkgtest-satdep.
705s Preparing to unpack .../1-autopkgtest-satdep.deb ...
705s Unpacking autopkgtest-satdep (0) ...
705s Setting up liburing2:ppc64el (2.6-1) ...
705s Setting up qemu-utils (1:9.0.2+ds-4ubuntu2) ...
705s Setting up autopkgtest-satdep (0) ...
705s Processing triggers for man-db (2.12.1-3) ...
706s Processing triggers for libc-bin (2.40-1ubuntu1) ...
716s (Reading database ... 109854 files and directories currently installed.)
716s Removing autopkgtest-satdep (0) ...
718s autopkgtest [11:00:47]: test kpartx-file-loopback: [-----------------------
719s Formatting 'foo.img', fmt=raw size=20971520
720s Creating new GPT entries in memory.
720s Warning: The kernel is still using the old partition table.
720s The new table will be used at the next reboot or after you
720s run partprobe(8) or kpartx(8)
720s The operation has completed successfully.
720s add map loop0p1 (252:0): 0 38879 linear 7:0 2048
720s standard_filename: OK
720s del devmap : loop0p1
720s No devices found
720s standard_filename_cleanup: OK
720s Formatting 'fou du FaFa.img', fmt=raw size=20971520
721s Creating new GPT entries in memory.
721s Warning: The kernel is still using the old partition table.
721s The new table will be used at the next reboot or after you
721s run partprobe(8) or kpartx(8)
721s The operation has completed successfully.
721s add map loop0p1 (252:0): 0 38879 linear 7:0 2048
721s filename_with_spaces: OK
721s del devmap : loop0p1
721s No devices found
721s filename_with_spaces_cleanup: OK
722s autopkgtest [11:00:51]: test kpartx-file-loopback: -----------------------]
735s autopkgtest [11:01:04]: test kpartx-file-loopback:  - - - - - - - - - - results - - - - - - - - - -
735s kpartx-file-loopback PASS
741s autopkgtest [11:01:10]: test tgtbasedmpaths: preparing testbed
915s autopkgtest [11:04:04]: testbed dpkg architecture: ppc64el
915s autopkgtest [11:04:04]: testbed apt version: 2.9.8
915s autopkgtest [11:04:04]: @@@@@@@@@@@@@@@@@@@@ test bed setup
917s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [126 kB]
917s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [849 kB]
917s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [8408 B]
917s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [57.9 kB]
917s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [11.1 kB]
917s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el Packages [71.6 kB]
917s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el c-n-f Metadata [2184 B]
917s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/restricted ppc64el Packages [1376 B]
917s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/restricted ppc64el c-n-f Metadata [120 B]
917s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/universe ppc64el Packages [751 kB]
917s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/universe ppc64el c-n-f Metadata [19.4 kB]
917s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse ppc64el Packages [5956 B]
917s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse ppc64el c-n-f Metadata [372 B]
919s Fetched 1905 kB in 1s (1935 kB/s)
919s Reading package lists...
922s Reading package lists...
922s Building dependency tree...
922s Reading state information...
922s Calculating upgrade...
922s The following NEW packages will be installed:
922s   libpython3.12t64 linux-headers-6.11.0-4 linux-headers-6.11.0-4-generic
922s   linux-image-6.11.0-4-generic linux-modules-6.11.0-4-generic
922s   linux-modules-extra-6.11.0-4-generic linux-tools-6.11.0-4
922s   linux-tools-6.11.0-4-generic
922s The following packages will be upgraded:
922s   libsqlite3-0 linux-generic linux-headers-generic linux-headers-virtual
922s   linux-image-generic linux-image-virtual linux-virtual
923s 7 upgraded, 8 newly installed, 0 to remove and 0 not upgraded.
923s Need to get 227 MB of archives.
923s After this operation, 343 MB of additional disk space will be used.
923s Get:1 http://ftpmaster.internal/ubuntu oracular/main ppc64el libsqlite3-0 ppc64el 3.46.1-1 [806 kB]
923s Get:2 http://ftpmaster.internal/ubuntu oracular/main ppc64el libpython3.12t64 ppc64el 3.12.5-4 [2560 kB]
923s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-modules-6.11.0-4-generic ppc64el 6.11.0-4.4 [32.8 MB]
924s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-image-6.11.0-4-generic ppc64el 6.11.0-4.4 [63.9 MB]
927s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-modules-extra-6.11.0-4-generic ppc64el 6.11.0-4.4 [105 MB]
930s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-generic ppc64el 6.11.0-4.4 [1728 B]
930s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-image-generic ppc64el 6.11.0-4.4 [10.6 kB]
930s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-virtual ppc64el 6.11.0-4.4 [1720 B]
930s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-image-virtual ppc64el 6.11.0-4.4 [10.6 kB]
930s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-headers-virtual ppc64el 6.11.0-4.4 [1642 B]
930s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-headers-6.11.0-4 all 6.11.0-4.4 [13.9 MB]
931s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-headers-6.11.0-4-generic ppc64el 6.11.0-4.4 [3949 kB]
931s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-headers-generic ppc64el 6.11.0-4.4 [10.5 kB]
931s Get:14 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-tools-6.11.0-4 ppc64el 6.11.0-4.4 [4201 kB]
931s Get:15 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-tools-6.11.0-4-generic ppc64el 6.11.0-4.4 [1746 B]
932s Fetched 227 MB in 9s (25.3 MB/s)
932s (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 ... 72440 files and directories currently installed.)
932s Preparing to unpack .../00-libsqlite3-0_3.46.1-1_ppc64el.deb ...
932s Unpacking libsqlite3-0:ppc64el (3.46.1-1) over (3.46.0-1) ...
932s Selecting previously unselected package libpython3.12t64:ppc64el.
932s Preparing to unpack .../01-libpython3.12t64_3.12.5-4_ppc64el.deb ...
932s Unpacking libpython3.12t64:ppc64el (3.12.5-4) ...
932s Selecting previously unselected package linux-modules-6.11.0-4-generic.
932s Preparing to unpack .../02-linux-modules-6.11.0-4-generic_6.11.0-4.4_ppc64el.deb ...
932s Unpacking linux-modules-6.11.0-4-generic (6.11.0-4.4) ...
932s Selecting previously unselected package linux-image-6.11.0-4-generic.
932s Preparing to unpack .../03-linux-image-6.11.0-4-generic_6.11.0-4.4_ppc64el.deb ...
932s Unpacking linux-image-6.11.0-4-generic (6.11.0-4.4) ...
933s Selecting previously unselected package linux-modules-extra-6.11.0-4-generic.
933s Preparing to unpack .../04-linux-modules-extra-6.11.0-4-generic_6.11.0-4.4_ppc64el.deb ...
933s Unpacking linux-modules-extra-6.11.0-4-generic (6.11.0-4.4) ...
934s Preparing to unpack .../05-linux-generic_6.11.0-4.4_ppc64el.deb ...
934s Unpacking linux-generic (6.11.0-4.4) over (6.8.0-31.31) ...
934s Preparing to unpack .../06-linux-image-generic_6.11.0-4.4_ppc64el.deb ...
934s Unpacking linux-image-generic (6.11.0-4.4) over (6.8.0-31.31) ...
934s Preparing to unpack .../07-linux-virtual_6.11.0-4.4_ppc64el.deb ...
934s Unpacking linux-virtual (6.11.0-4.4) over (6.8.0-31.31) ...
934s Preparing to unpack .../08-linux-image-virtual_6.11.0-4.4_ppc64el.deb ...
934s Unpacking linux-image-virtual (6.11.0-4.4) over (6.8.0-31.31) ...
934s Preparing to unpack .../09-linux-headers-virtual_6.11.0-4.4_ppc64el.deb ...
934s Unpacking linux-headers-virtual (6.11.0-4.4) over (6.8.0-31.31) ...
934s Selecting previously unselected package linux-headers-6.11.0-4.
934s Preparing to unpack .../10-linux-headers-6.11.0-4_6.11.0-4.4_all.deb ...
934s Unpacking linux-headers-6.11.0-4 (6.11.0-4.4) ...
936s Selecting previously unselected package linux-headers-6.11.0-4-generic.
936s Preparing to unpack .../11-linux-headers-6.11.0-4-generic_6.11.0-4.4_ppc64el.deb ...
936s Unpacking linux-headers-6.11.0-4-generic (6.11.0-4.4) ...
937s Preparing to unpack .../12-linux-headers-generic_6.11.0-4.4_ppc64el.deb ...
937s Unpacking linux-headers-generic (6.11.0-4.4) over (6.8.0-31.31) ...
937s Selecting previously unselected package linux-tools-6.11.0-4.
937s Preparing to unpack .../13-linux-tools-6.11.0-4_6.11.0-4.4_ppc64el.deb ...
937s Unpacking linux-tools-6.11.0-4 (6.11.0-4.4) ...
937s Selecting previously unselected package linux-tools-6.11.0-4-generic.
937s Preparing to unpack .../14-linux-tools-6.11.0-4-generic_6.11.0-4.4_ppc64el.deb ...
937s Unpacking linux-tools-6.11.0-4-generic (6.11.0-4.4) ...
937s Setting up libsqlite3-0:ppc64el (3.46.1-1) ...
937s Setting up linux-modules-6.11.0-4-generic (6.11.0-4.4) ...
939s Setting up linux-image-6.11.0-4-generic (6.11.0-4.4) ...
942s I: /boot/vmlinux is now a symlink to vmlinux-6.11.0-4-generic
942s I: /boot/initrd.img is now a symlink to initrd.img-6.11.0-4-generic
942s Setting up libpython3.12t64:ppc64el (3.12.5-4) ...
942s Setting up linux-modules-extra-6.11.0-4-generic (6.11.0-4.4) ...
944s Setting up linux-headers-6.11.0-4 (6.11.0-4.4) ...
944s Setting up linux-image-virtual (6.11.0-4.4) ...
944s Setting up linux-tools-6.11.0-4 (6.11.0-4.4) ...
944s Setting up linux-image-generic (6.11.0-4.4) ...
944s Setting up linux-headers-6.11.0-4-generic (6.11.0-4.4) ...
944s Setting up linux-tools-6.11.0-4-generic (6.11.0-4.4) ...
944s Setting up linux-headers-generic (6.11.0-4.4) ...
944s Setting up linux-headers-virtual (6.11.0-4.4) ...
944s Setting up linux-generic (6.11.0-4.4) ...
944s Setting up linux-virtual (6.11.0-4.4) ...
944s Processing triggers for libc-bin (2.40-1ubuntu1) ...
944s Processing triggers for linux-image-6.11.0-4-generic (6.11.0-4.4) ...
944s /etc/kernel/postinst.d/initramfs-tools:
944s update-initramfs: Generating /boot/initrd.img-6.11.0-4-generic
944s W: No lz4 in /usr/bin:/sbin:/bin, using gzip
951s /etc/kernel/postinst.d/zz-update-grub:
951s Sourcing file `/etc/default/grub'
951s Sourcing file `/etc/default/grub.d/50-cloudimg-settings.cfg'
951s Generating grub configuration file ...
951s Found linux image: /boot/vmlinux-6.11.0-4-generic
952s Found initrd image: /boot/initrd.img-6.11.0-4-generic
952s Found linux image: /boot/vmlinux-6.8.0-31-generic
952s Found initrd image: /boot/initrd.img-6.8.0-31-generic
952s Warning: os-prober will not be executed to detect other bootable partitions.
952s Systems on them will not be added to the GRUB boot configuration.
952s Check GRUB_DISABLE_OS_PROBER documentation entry.
952s Adding boot menu entry for UEFI Firmware Settings ...
952s done
952s Reading package lists...
952s Building dependency tree...
952s Reading state information...
952s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
953s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease
953s Hit:2 http://ftpmaster.internal/ubuntu oracular InRelease
953s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease
953s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease
954s Reading package lists...
954s Reading package lists...
954s Building dependency tree...
954s Reading state information...
954s Calculating upgrade...
954s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
954s Reading package lists...
955s Building dependency tree...
955s Reading state information...
955s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
955s Reading package lists...
955s Building dependency tree...
955s Reading state information...
955s linux-generic is already the newest version (6.11.0-4.4).
955s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
960s Reading package lists...
961s Building dependency tree...
961s Reading state information...
961s E: Unable to locate package ^kernel-testing--linux--modules-extra--preferred$
961s E: Couldn't find any package by regex '^kernel-testing--linux--modules-extra--preferred$'
961s Reading package lists...
961s Building dependency tree...
961s Reading state information...
961s E: Unable to locate package ^linux-modules-extra$
961s E: Couldn't find any package by regex '^linux-modules-extra$'
961s autopkgtest [11:04:50]: rebooting testbed after setup commands that affected boot
1009s Reading package lists...
1010s Building dependency tree...
1010s Reading state information...
1010s Starting pkgProblemResolver with broken count: 0
1010s Starting 2 pkgProblemResolver with broken count: 0
1010s Done
1010s The following additional packages will be installed:
1010s   fio libboost-iostreams1.83.0 libboost-thread1.83.0 libconfig-general-perl
1010s   libdaxctl1 libgfapi0 libgfrpc0 libgfxdr0 libglusterfs0 libisns0t64 libnbd0
1010s   libndctl6 libopeniscsiusr libpmem1 libpmemobj1 librados2 librbd1
1010s   librdmacm1t64 lsscsi open-iscsi tgt
1010s Suggested packages:
1010s   fio-examples gnuplot tgt-glusterfs tgt-rbd
1010s Recommended packages:
1010s   finalrd
1010s The following NEW packages will be installed:
1010s   autopkgtest-satdep fio libboost-iostreams1.83.0 libboost-thread1.83.0
1010s   libconfig-general-perl libdaxctl1 libgfapi0 libgfrpc0 libgfxdr0
1010s   libglusterfs0 libisns0t64 libnbd0 libndctl6 libopeniscsiusr libpmem1
1010s   libpmemobj1 librados2 librbd1 librdmacm1t64 lsscsi open-iscsi tgt
1010s 0 upgraded, 22 newly installed, 0 to remove and 0 not upgraded.
1010s Need to get 10.9 MB/10.9 MB of archives.
1010s After this operation, 49.6 MB of additional disk space will be used.
1010s Get:1 /tmp/autopkgtest.PXg9mZ/2-autopkgtest-satdep.deb autopkgtest-satdep ppc64el 0 [732 B]
1010s Get:2 http://ftpmaster.internal/ubuntu oracular/main ppc64el libopeniscsiusr ppc64el 2.1.10-1ubuntu1 [54.9 kB]
1011s Get:3 http://ftpmaster.internal/ubuntu oracular/main ppc64el libisns0t64 ppc64el 0.101-1 [117 kB]
1011s Get:4 http://ftpmaster.internal/ubuntu oracular/main ppc64el open-iscsi ppc64el 2.1.10-1ubuntu1 [385 kB]
1011s Get:5 http://ftpmaster.internal/ubuntu oracular/main ppc64el librdmacm1t64 ppc64el 52.0-2ubuntu1 [80.6 kB]
1011s Get:6 http://ftpmaster.internal/ubuntu oracular/universe ppc64el libconfig-general-perl all 2.65-2 [57.1 kB]
1011s Get:7 http://ftpmaster.internal/ubuntu oracular/universe ppc64el tgt ppc64el 1:1.0.85-1.2ubuntu1 [254 kB]
1011s Get:8 http://ftpmaster.internal/ubuntu oracular/universe ppc64el libgfxdr0 ppc64el 11.1-5ubuntu1 [21.7 kB]
1011s Get:9 http://ftpmaster.internal/ubuntu oracular/universe ppc64el libglusterfs0 ppc64el 11.1-5ubuntu1 [308 kB]
1011s Get:10 http://ftpmaster.internal/ubuntu oracular/universe ppc64el libgfrpc0 ppc64el 11.1-5ubuntu1 [46.3 kB]
1011s Get:11 http://ftpmaster.internal/ubuntu oracular/universe ppc64el libgfapi0 ppc64el 11.1-5ubuntu1 [99.1 kB]
1011s Get:12 http://ftpmaster.internal/ubuntu oracular/universe ppc64el libnbd0 ppc64el 1.20.2-2 [98.5 kB]
1011s Get:13 http://ftpmaster.internal/ubuntu oracular/main ppc64el libdaxctl1 ppc64el 77-2.2ubuntu1 [23.7 kB]
1011s Get:14 http://ftpmaster.internal/ubuntu oracular/main ppc64el libndctl6 ppc64el 77-2.2ubuntu1 [73.4 kB]
1011s Get:15 http://ftpmaster.internal/ubuntu oracular/main ppc64el libpmem1 ppc64el 1.13.1-1.1ubuntu2 [41.1 kB]
1011s Get:16 http://ftpmaster.internal/ubuntu oracular/main ppc64el libboost-iostreams1.83.0 ppc64el 1.83.0-3.1ubuntu1 [259 kB]
1011s Get:17 http://ftpmaster.internal/ubuntu oracular/main ppc64el libboost-thread1.83.0 ppc64el 1.83.0-3.1ubuntu1 [281 kB]
1011s Get:18 http://ftpmaster.internal/ubuntu oracular/main ppc64el librados2 ppc64el 19.2.0~is.really.19.1.0-0ubuntu2 [4151 kB]
1011s Get:19 http://ftpmaster.internal/ubuntu oracular/main ppc64el libpmemobj1 ppc64el 1.13.1-1.1ubuntu2 [143 kB]
1011s Get:20 http://ftpmaster.internal/ubuntu oracular/main ppc64el librbd1 ppc64el 19.2.0~is.really.19.1.0-0ubuntu2 [3684 kB]
1011s Get:21 http://ftpmaster.internal/ubuntu oracular/universe ppc64el fio ppc64el 3.37-1 [716 kB]
1011s Get:22 http://ftpmaster.internal/ubuntu oracular/main ppc64el lsscsi ppc64el 0.32-1build1 [54.0 kB]
1012s Preconfiguring packages ...
1012s Fetched 10.9 MB in 1s (9981 kB/s)
1012s Selecting previously unselected package libopeniscsiusr.
1012s (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 ... 109830 files and directories currently installed.)
1012s Preparing to unpack .../00-libopeniscsiusr_2.1.10-1ubuntu1_ppc64el.deb ...
1012s Unpacking libopeniscsiusr (2.1.10-1ubuntu1) ...
1012s Selecting previously unselected package libisns0t64:ppc64el.
1012s Preparing to unpack .../01-libisns0t64_0.101-1_ppc64el.deb ...
1012s Unpacking libisns0t64:ppc64el (0.101-1) ...
1012s Selecting previously unselected package open-iscsi.
1012s Preparing to unpack .../02-open-iscsi_2.1.10-1ubuntu1_ppc64el.deb ...
1012s Unpacking open-iscsi (2.1.10-1ubuntu1) ...
1012s Selecting previously unselected package librdmacm1t64:ppc64el.
1012s Preparing to unpack .../03-librdmacm1t64_52.0-2ubuntu1_ppc64el.deb ...
1012s Unpacking librdmacm1t64:ppc64el (52.0-2ubuntu1) ...
1012s Selecting previously unselected package libconfig-general-perl.
1012s Preparing to unpack .../04-libconfig-general-perl_2.65-2_all.deb ...
1012s Unpacking libconfig-general-perl (2.65-2) ...
1012s Selecting previously unselected package tgt.
1012s Preparing to unpack .../05-tgt_1%3a1.0.85-1.2ubuntu1_ppc64el.deb ...
1012s Unpacking tgt (1:1.0.85-1.2ubuntu1) ...
1012s Selecting previously unselected package libgfxdr0:ppc64el.
1012s Preparing to unpack .../06-libgfxdr0_11.1-5ubuntu1_ppc64el.deb ...
1012s Unpacking libgfxdr0:ppc64el (11.1-5ubuntu1) ...
1012s Selecting previously unselected package libglusterfs0:ppc64el.
1012s Preparing to unpack .../07-libglusterfs0_11.1-5ubuntu1_ppc64el.deb ...
1012s Unpacking libglusterfs0:ppc64el (11.1-5ubuntu1) ...
1012s Selecting previously unselected package libgfrpc0:ppc64el.
1012s Preparing to unpack .../08-libgfrpc0_11.1-5ubuntu1_ppc64el.deb ...
1012s Unpacking libgfrpc0:ppc64el (11.1-5ubuntu1) ...
1012s Selecting previously unselected package libgfapi0:ppc64el.
1012s Preparing to unpack .../09-libgfapi0_11.1-5ubuntu1_ppc64el.deb ...
1012s Unpacking libgfapi0:ppc64el (11.1-5ubuntu1) ...
1012s Selecting previously unselected package libnbd0.
1012s Preparing to unpack .../10-libnbd0_1.20.2-2_ppc64el.deb ...
1012s Unpacking libnbd0 (1.20.2-2) ...
1012s Selecting previously unselected package libdaxctl1:ppc64el.
1012s Preparing to unpack .../11-libdaxctl1_77-2.2ubuntu1_ppc64el.deb ...
1012s Unpacking libdaxctl1:ppc64el (77-2.2ubuntu1) ...
1012s Selecting previously unselected package libndctl6:ppc64el.
1012s Preparing to unpack .../12-libndctl6_77-2.2ubuntu1_ppc64el.deb ...
1012s Unpacking libndctl6:ppc64el (77-2.2ubuntu1) ...
1012s Selecting previously unselected package libpmem1:ppc64el.
1012s Preparing to unpack .../13-libpmem1_1.13.1-1.1ubuntu2_ppc64el.deb ...
1012s Unpacking libpmem1:ppc64el (1.13.1-1.1ubuntu2) ...
1012s Selecting previously unselected package libboost-iostreams1.83.0:ppc64el.
1012s Preparing to unpack .../14-libboost-iostreams1.83.0_1.83.0-3.1ubuntu1_ppc64el.deb ...
1012s Unpacking libboost-iostreams1.83.0:ppc64el (1.83.0-3.1ubuntu1) ...
1012s Selecting previously unselected package libboost-thread1.83.0:ppc64el.
1012s Preparing to unpack .../15-libboost-thread1.83.0_1.83.0-3.1ubuntu1_ppc64el.deb ...
1012s Unpacking libboost-thread1.83.0:ppc64el (1.83.0-3.1ubuntu1) ...
1012s Selecting previously unselected package librados2.
1012s Preparing to unpack .../16-librados2_19.2.0~is.really.19.1.0-0ubuntu2_ppc64el.deb ...
1012s Unpacking librados2 (19.2.0~is.really.19.1.0-0ubuntu2) ...
1013s Selecting previously unselected package libpmemobj1:ppc64el.
1013s Preparing to unpack .../17-libpmemobj1_1.13.1-1.1ubuntu2_ppc64el.deb ...
1013s Unpacking libpmemobj1:ppc64el (1.13.1-1.1ubuntu2) ...
1013s Selecting previously unselected package librbd1.
1013s Preparing to unpack .../18-librbd1_19.2.0~is.really.19.1.0-0ubuntu2_ppc64el.deb ...
1013s Unpacking librbd1 (19.2.0~is.really.19.1.0-0ubuntu2) ...
1013s Selecting previously unselected package fio.
1013s Preparing to unpack .../19-fio_3.37-1_ppc64el.deb ...
1013s Unpacking fio (3.37-1) ...
1013s Selecting previously unselected package lsscsi.
1013s Preparing to unpack .../20-lsscsi_0.32-1build1_ppc64el.deb ...
1013s Unpacking lsscsi (0.32-1build1) ...
1013s Selecting previously unselected package autopkgtest-satdep.
1013s Preparing to unpack .../21-2-autopkgtest-satdep.deb ...
1013s Unpacking autopkgtest-satdep (0) ...
1013s Setting up libconfig-general-perl (2.65-2) ...
1013s Setting up libisns0t64:ppc64el (0.101-1) ...
1013s Setting up libboost-thread1.83.0:ppc64el (1.83.0-3.1ubuntu1) ...
1013s Setting up libnbd0 (1.20.2-2) ...
1013s Setting up libopeniscsiusr (2.1.10-1ubuntu1) ...
1013s Setting up libglusterfs0:ppc64el (11.1-5ubuntu1) ...
1013s Setting up libboost-iostreams1.83.0:ppc64el (1.83.0-3.1ubuntu1) ...
1013s Setting up lsscsi (0.32-1build1) ...
1013s Setting up libdaxctl1:ppc64el (77-2.2ubuntu1) ...
1013s Setting up libndctl6:ppc64el (77-2.2ubuntu1) ...
1013s Setting up librdmacm1t64:ppc64el (52.0-2ubuntu1) ...
1013s Setting up tgt (1:1.0.85-1.2ubuntu1) ...
1013s Created symlink '/etc/systemd/system/multi-user.target.wants/tgt.service' → '/usr/lib/systemd/system/tgt.service'.

1014s Setting up libpmem1:ppc64el (1.13.1-1.1ubuntu2) ...
1014s Setting up libgfxdr0:ppc64el (11.1-5ubuntu1) ...
1014s Setting up librados2 (19.2.0~is.really.19.1.0-0ubuntu2) ...
1014s Setting up open-iscsi (2.1.10-1ubuntu1) ...
1014s Created symlink '/etc/systemd/system/sockets.target.wants/iscsid.socket' → '/usr/lib/systemd/system/iscsid.socket'.

1015s Created symlink '/etc/systemd/system/iscsi.service' → '/usr/lib/systemd/system/open-iscsi.service'.

1015s Created symlink '/etc/systemd/system/sysinit.target.wants/open-iscsi.service' → '/usr/lib/systemd/system/open-iscsi.service'.

1015s Setting up libpmemobj1:ppc64el (1.13.1-1.1ubuntu2) ...
1015s Setting up librbd1 (19.2.0~is.really.19.1.0-0ubuntu2) ...
1015s Setting up libgfrpc0:ppc64el (11.1-5ubuntu1) ...
1015s Setting up libgfapi0:ppc64el (11.1-5ubuntu1) ...
1015s Setting up fio (3.37-1) ...
1016s Setting up autopkgtest-satdep (0) ...
1016s Processing triggers for man-db (2.12.1-3) ...
1017s Processing triggers for initramfs-tools (0.142ubuntu32) ...
1017s update-initramfs: Generating /boot/initrd.img-6.11.0-4-generic
1017s W: No lz4 in /usr/bin:/sbin:/bin, using gzip
1025s Processing triggers for libc-bin (2.40-1ubuntu1) ...
1029s (Reading database ... 110071 files and directories currently installed.)
1029s Removing autopkgtest-satdep (0) ...
1034s autopkgtest [11:06:03]: test tgtbasedmpaths: [-----------------------
1035s + targetname=iqn.2016-11.foo.com:target.iscsi
1035s + pwd
1035s + cwd=/tmp/autopkgtest.PXg9mZ/build.M5q/src
1035s + testdir=/mnt/tgtmpathtest
1035s + localhost=127.0.0.1
1035s + portal=127.0.0.1:3260
1035s + maxpaths=4
1035s + backfn=backingfile
1035s + expectwwid=60000000000000000e00000000010001
1035s + testdisk=/dev/disk/by-id/wwn-0x60000000000000000e00000000010001
1035s + bglog=/tmp/autopkgtest.PXg9mZ/tgtbasedmpaths-artifacts/test-background.log
1035s + fioprep=/tmp/autopkgtest.PXg9mZ/tgtbasedmpaths-artifacts/path-change-prep.fio
1035s + fiovrfy=/tmp/autopkgtest.PXg9mZ/tgtbasedmpaths-artifacts/path-change-check.fio
1035s + mkdir -p /etc/multipath
1035s + echo /360000000000000000e00000000010001/
1035s + service tgt restart
1035s + truncate --size 100M backingfile
1035s + tgtadm --lld iscsi --op new --mode target --tid 1 -T iqn.2016-11.foo.com:target.iscsi
1035s + tgtadm --lld iscsi --op bind --mode target --tid 1 -I ALL
1035s + tgtadm --lld iscsi --op new --mode logicalunit --tid 1 --lun 1 -b /tmp/autopkgtest.PXg9mZ/build.M5q/src/backingfile
1035s + iscsiadm --mode discovery --type sendtargets --portal 127.0.0.1
1035s 127.0.0.1:3260,1 iqn.2016-11.foo.com:target.iscsi
1035s login #1
1035s + echo login #1
1035s + iscsiadm --mode node --targetname iqn.2016-11.foo.com:target.iscsi --portal 127.0.0.1:3260 --login
1035s Logging in to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260]
1035s Login to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] successful.
1035s + seq 2 4
1035s extra login #2
1035s + echo extra login #2
1035s + iscsiadm --mode session -r 1 --op new
1035s Logging in to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] (multiple)
1035s Login to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] successful.
1035s extra login #3
1035s + echo extra login #3
1035s + iscsiadm --mode session -r 1 --op new
1035s + echo extra login #4
1035s + iscsiadm --mode session -r 1 --op new
1035s Logging in to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] (multiple)
1035s Login to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] successful.
1035s extra login #4
1035s Logging in to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] (multiple)
1035s Login to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] successful.
1035s + udevadm settle
1035s + sleep 5
1040s + echo Status after initial setup
1040s + tgtadm --lld iscsi --mode target --op show
1040s Status after initial setup
1040s Target 1: iqn.2016-11.foo.com:target.iscsi
1040s     System information:
1040s         Driver: iscsi
1040s         State: ready
1040s     I_T nexus information:
1040s         I_T nexus: 1
1040s             Initiator: iqn.2004-10.com.ubuntu:01:7c887dadef1f alias: autopkgtest
1040s             Connection: 0
1040s                 IP Address: 127.0.0.1
1040s         I_T nexus: 2
1040s             Initiator: iqn.2004-10.com.ubuntu:01:7c887dadef1f alias: autopkgtest
1040s             Connection: 0
1040s                 IP Address: 127.0.0.1
1040s         I_T nexus: 3
1040s             Initiator: iqn.2004-10.com.ubuntu:01:7c887dadef1f alias: autopkgtest
1040s             Connection: 0
1040s                 IP Address: 127.0.0.1
1040s         I_T nexus: 4
1040s             Initiator: iqn.2004-10.com.ubuntu:01:7c887dadef1f alias: autopkgtest
1040s             Connection: 0
1040s                 IP Address: 127.0.0.1
1040s     LUN information:
1040s         LUN: 0
1040s             Type: controller
1040s             SCSI ID: IET     00010000
1040s             SCSI SN: beaf10
1040s             Size: 0 MB, Block size: 1
1040s             Online: Yes
1040s             Removable media: No
1040s             Prevent removal: No
1040s             Readonly: No
1040s             SWP: No
1040s             Thin-provisioning: No
1040s             Backing store type: null
1040s             Backing store path: None
1040s             Backing store flags: 
1040s         LUN: 1
1040s             Type: disk
1040s             SCSI ID: IET     00010001
1040s             SCSI SN: beaf11
1040s             Size: 105 MB, Block size: 512
1040s             Online: Yes
1040s             Removable media: No
1040s             Prevent removal: No
1040s             Readonly: No
1040s             SWP: No
1040s             Thin-provisioning: No
1040s             Backing store type: rdwr
1040s             Backing store path: /tmp/autopkgtest.PXg9mZ/build.M5q/src/backingfile
1040s             Backing store flags: 
1040s     Account information:
1040s     ACL information:
1040s         ALL
1040s + tgtadm --lld iscsi --op show --mode conn --tid 1
1040s Session: 4
1040s     Connection: 0
1040s         Initiator: iqn.2004-10.com.ubuntu:01:7c887dadef1f
1040s         IP Address: 127.0.0.1
1040s Session: 3
1040s     Connection: 0
1040s         Initiator: iqn.2004-10.com.ubuntu:01:7c887dadef1f
1040s         IP Address: 127.0.0.1
1040s Session: 2
1040s     Connection: 0
1040s         Initiator: iqn.2004-10.com.ubuntu:01:7c887dadef1f
1040s         IP Address: 127.0.0.1
1040s Session: 1
1040s     Connection: 0
1040s         Initiator: iqn.2004-10.com.ubuntu:01:7c887dadef1f
1040s         IP Address: 127.0.0.1
1040s Target: iqn.2016-11.foo.com:target.iscsi (non-flash)
1040s 	Current Portal: 127.0.0.1:3260,1
1040s 	Persistent Portal: 127.0.0.1:3260,1
1040s 		**********
1040s 		Interface:
1040s 		**********
1040s 		Iface Name: default
1040s 		Iface Transport: tcp
1040s 		Iface Initiatorname: iqn.2004-10.com.ubuntu:01:7c887dadef1f
1040s 		Iface IPaddress: 127.0.0.1
1040s 		Iface HWaddress: default
1040s 		Iface Netdev: default
1040s 		SID: 1
1040s 		iSCSI Connection State: LOGGED IN
1040s 		iSCSI Session State: LOGGED_IN
1040s 		Internal iscsid Session State: NO CHANGE
1040s 
1040s 		**********
1040s 		Interface:
1040s 		**********
1040s 		Iface Name: default
1040s 		Iface Transport: tcp
1040s 		Iface Initiatorname: iqn.2004-10.com.ubuntu:01:7c887dadef1f
1040s 		Iface IPaddress: 127.0.0.1
1040s 		Iface HWaddress: default
1040s 		Iface Netdev: default
1040s 		SID: 2
1040s 		iSCSI Connection State: LOGGED IN
1040s 		iSCSI Session State: LOGGED_IN
1040s 		Internal iscsid Session State: NO CHANGE
1040s 
1040s 		**********
1040s 		Interface:
1040s 		**********
1040s 		Iface Name: default
1040s 		Iface Transport: tcp
1040s 		Iface Initiatorname: iqn.2004-10.com.ubuntu:01:7c887dadef1f
1040s 		Iface IPaddress: 127.0.0.1
1040s 		Iface HWaddress: default
1040s 		Iface Netdev: default
1040s 		SID: 3
1040s 		iSCSI Connection State: LOGGED IN
1040s 		iSCSI Session State: LOGGED_IN
1040s 		Internal iscsid Session State: NO CHANGE
1040s 
1040s 		**********
1040s 		Interface:
1040s 		**********
1040s 		Iface Name: default
1040s 		Iface Transport: tcp
1040s 		Iface Initiatorname: iqn.2004-10.com.ubuntu:01:7c887dadef1f
1040s 		Iface IPaddress: 127.0.0.1
1040s 		Iface HWaddress: default
1040s 		Iface Netdev: default
1040s 		SID: 4
1040s 		iSCSI Connection State: LOGGED IN
1040s 		iSCSI Session State: LOGGED_IN
1040s 		Internal iscsid Session State: NO CHANGE
1040s + iscsiadm --mode session -P 1
1040s + lsscsi -liv
1040s [0:0:0:0]    storage IET      Controller       0001  -          -
1040s   state=running queue_depth=32 scsi_level=6 type=12 device_blocked=0 timeout=30
1040s   dir: /sys/bus/scsi/devices/0:0:0:0  [/sys/devices/platform/host0/session1/target0:0:0/0:0:0:0]
1040s [0:0:0:1]    disk    IET      VIRTUAL-DISK     0001  /dev/sda   360000000000000000e00000000010001
1040s   state=running queue_depth=32 scsi_level=6 type=0 device_blocked=0 timeout=30
1040s   dir: /sys/bus/scsi/devices/0:0:0:1  [/sys/devices/platform/host0/session1/target0:0:0/0:0:0:1]
1040s [1:0:0:0]    storage IET      Controller       0001  -          -
1040s   state=running queue_depth=32 scsi_level=6 type=12 device_blocked=0 timeout=30
1040s   dir: /sys/bus/scsi/devices/1:0:0:0  [/sys/devices/platform/host1/session2/target1:0:0/1:0:0:0]
1040s [1:0:0:1]    disk    IET      VIRTUAL-DISK     0001  /dev/sdb   360000000000000000e00000000010001
1040s   state=running queue_depth=32 scsi_level=6 type=0 device_blocked=0 timeout=30
1040s   dir: /sys/bus/scsi/devices/1:0:0:1  [/sys/devices/platform/host1/session2/target1:0:0/1:0:0:1]
1040s [2:0:0:0]    storage IET      Controller       0001  -          -
1040s   state=running queue_depth=32 scsi_level=6 type=12 device_blocked=0 timeout=30
1040s   dir: /sys/bus/scsi/devices/2:0:0:0  [/sys/devices/platform/host2/session3/target2:0:0/2:0:0:0]
1040s [2:0:0:1]    disk    IET      VIRTUAL-DISK     0001  /dev/sdc   360000000000000000e00000000010001
1040s   state=running queue_depth=32 scsi_level=6 type=0 device_blocked=0 timeout=30
1040s   dir: /sys/bus/scsi/devices/2:0:0:1  [/sys/devices/platform/host2/session3/target2:0:0/2:0:0:1]
1040s [3:0:0:0]    storage IET      Controller       0001  -          -
1040s   state=running queue_depth=32 scsi_level=6 type=12 device_blocked=0 timeout=30
1040s   dir: /sys/bus/scsi/devices/3:0:0:0  [/sys/devices/platform/host3/session4/target3:0:0/3:0:0:0]
1040s [3:0:0:1]    disk    IET      VIRTUAL-DISK     0001  /dev/sdd   33000000100000001
1040s   state=running queue_depth=32 scsi_level=6 type=0 device_blocked=0 timeout=30
1040s   dir: /sys/bus/scsi/devices/3:0:0:1  [/sys/devices/platform/host3/session4/target3:0:0/3:0:0:1]
1040s NVMe module may not be loaded
1040s list_ndevices: scandir: /sys/class/nvme/: No such file or directory
1040s + multipath -v3 -ll
1040s 65.004520 | set open fds limit to 1073741816/1073741816
1040s 65.004555 | _read_bindings_file: reading /etc/multipath/bindings
1040s 65.004578 | loading /usr/lib/multipath/libchecktur.so checker
1040s 65.004664 | checker tur: message table size = 4
1040s 65.004671 | loading /usr/lib/multipath/libprioconst.so prioritizer
1040s 65.004770 | _init_foreign: foreign library "nvme" is not enabled
1040s 65.009771 | vda: device node name blacklisted
1040s 65.010179 | sda: size = 204800
1040s 65.010337 | sda: vendor = IET
1040s 65.010377 | sda: product = VIRTUAL-DISK
1040s 65.010416 | sda: rev = 0001
1040s 65.011155 | sda: h:b:t:l = 0:0:0:1
1040s 65.011579 | sda: tgt_node_name = iqn.2016-11.foo.com:target.iscsi
1040s 65.011610 | sda: uid_attribute = ID_SERIAL (setting: multipath internal)
1040s 65.011629 | sda: recheck_wwid = 1 (setting: multipath.conf defaults/devices section)
1040s 65.011811 | sda: 1024 cyl, 4 heads, 50 sectors/track, start at 0
1040s 65.011833 | sda: vpd_vendor_id = 0 "undef" (setting: multipath internal)
1040s 65.011864 | sda: serial = beaf11
1040s 65.011882 | sda: detect_checker = yes (setting: multipath internal)
1040s 65.011925 | sda checker timeout = 30 s (setting: kernel sysfs)
1040s 65.012183 | sda: path_checker = tur (setting: multipath internal)
1040s 65.012328 | sda: tur state = up
1040s 65.012480 | sdb: size = 204800
1040s 65.012632 | sdb: vendor = IET
1040s 65.012675 | sdb: product = VIRTUAL-DISK
1040s 65.012714 | sdb: rev = 0001
1040s 65.013398 | sdb: h:b:t:l = 1:0:0:1
1040s 65.013829 | sdb: tgt_node_name = iqn.2016-11.foo.com:target.iscsi
1040s 65.013852 | sdb: uid_attribute = ID_SERIAL (setting: multipath internal)
1040s 65.013871 | sdb: recheck_wwid = 1 (setting: multipath.conf defaults/devices section)
1040s 65.014030 | sdb: 1024 cyl, 4 heads, 50 sectors/track, start at 0
1040s 65.014052 | sdb: vpd_vendor_id = 0 "undef" (setting: multipath internal)
1040s 65.014080 | sdb: serial = beaf11
1040s 65.014099 | sdb: detect_checker = yes (setting: multipath internal)
1040s 65.014142 | sdb checker timeout = 30 s (setting: kernel sysfs)
1040s 65.014308 | sdb: path_checker = tur (setting: multipath internal)
1040s 65.014432 | sdb: tur state = up
1040s 65.014578 | sdc: size = 204800
1040s 65.014727 | sdc: vendor = IET
1040s 65.014767 | sdc: product = VIRTUAL-DISK
1040s 65.014806 | sdc: rev = 0001
1040s 65.015467 | sdc: h:b:t:l = 2:0:0:1
1040s 65.015841 | sdc: tgt_node_name = iqn.2016-11.foo.com:target.iscsi
1040s 65.015863 | sdc: uid_attribute = ID_SERIAL (setting: multipath internal)
1040s 65.015882 | sdc: recheck_wwid = 1 (setting: multipath.conf defaults/devices section)
1040s 65.016104 | sdc: 1024 cyl, 4 heads, 50 sectors/track, start at 0
1040s 65.016134 | sdc: vpd_vendor_id = 0 "undef" (setting: multipath internal)
1040s 65.016169 | sdc: serial = beaf11
1040s 65.016190 | sdc: detect_checker = yes (setting: multipath internal)
1040s 65.016234 | sdc checker timeout = 30 s (setting: kernel sysfs)
1040s 65.016382 | sdc: path_checker = tur (setting: multipath internal)
1040s 65.016503 | sdc: tur state = up
1040s 65.016654 | sdd: size = 204800
1040s 65.016808 | sdd: vendor = IET
1040s 65.016848 | sdd: product = VIRTUAL-DISK
1040s 65.016888 | sdd: rev = 0001
1040s 65.017576 | sdd: h:b:t:l = 3:0:0:1
1040s 65.017937 | sdd: tgt_node_name = iqn.2016-11.foo.com:target.iscsi
1040s 65.017958 | sdd: uid_attribute = ID_SERIAL (setting: multipath internal)
1040s 65.017977 | sdd: recheck_wwid = 1 (setting: multipath.conf defaults/devices section)
1040s 65.018135 | sdd: 1024 cyl, 4 heads, 50 sectors/track, start at 0
1040s 65.018156 | sdd: vpd_vendor_id = 0 "undef" (setting: multipath internal)
1040s 65.018185 | sdd: serial = beaf11
1040s 65.018204 | sdd: detect_checker = yes (setting: multipath internal)
1040s 65.018250 | sdd checker timeout = 30 s (setting: kernel sysfs)
1040s 65.018375 | sdd: path_checker = tur (setting: multipath internal)
1040s 65.018471 | sdd: tur state = up
1040s 65.018581 | loop0: device node name blacklisted
1040s 65.018684 | loop1: device node name blacklisted
1040s 65.018784 | loop2: device node name blacklisted
1040s 65.018883 | loop3: device node name blacklisted
1040s 65.018988 | loop4: device node name blacklisted
1040s 65.019094 | loop5: device node name blacklisted
1040s 65.019197 | loop6: device node name blacklisted
1040s 65.019297 | loop7: device node name blacklisted
1040s 65.019402 | dm-0: device node name blacklisted
1040s 65.020566 | multipath-tools v0.9.9 (05/03, 2024)
1040s 65.020603 | libdevmapper version 1.02.196
1040s 65.020756 | kernel device mapper v4.48.0
1040s 65.020786 | DM multipath kernel driver v1.14.0
1040s 65.020904 | sdc: size = 204800
1040s 65.020928 | sdc: vendor = IET
1040s 65.020947 | sdc: product = VIRTUAL-DISK
1040s 65.020966 | sdc: rev = 0001
1040s 65.021590 | sdc: h:b:t:l = 2:0:0:1
1040s 65.021722 | sdc: tgt_node_name = iqn.2016-11.foo.com:target.iscsi
1040s 65.021760 | sdc: 1024 cyl, 4 heads, 50 sectors/track, start at 0
1040s 65.021779 | sdc: vpd_vendor_id = 0 "undef" (setting: multipath internal)
1040s 65.021808 | sdc: serial = beaf11
1040s 65.021901 | sdc: tur state = up
1040s 65.021923 | sdc: uid = 360000000000000000e00000000010001 (udev)
1040s 65.021942 | sdc: detect_prio = yes (setting: multipath internal)
1040s 65.021961 | sdc: prio = const (setting: multipath internal)
1040s 65.021980 | sdc: prio args = "" (setting: multipath internal)
1040s 65.021998 | sdc: const prio = 1
1040s 65.022036 | sdb: size = 204800
1040s 65.022058 | sdb: vendor = IET
1040s 65.022077 | sdb: product = VIRTUAL-DISK
1040s 65.022095 | sdb: rev = 0001
1040s 65.022690 | sdb: h:b:t:l = 1:0:0:1
1040s 65.022824 | sdb: tgt_node_name = iqn.2016-11.foo.com:target.iscsi
1040s 65.022864 | sdb: 1024 cyl, 4 heads, 50 sectors/track, start at 0
1040s 65.022884 | sdb: vpd_vendor_id = 0 "undef" (setting: multipath internal)
1040s 65.022913 | sdb: serial = beaf11
1040s 65.023017 | sdb: tur state = up
1040s 65.023038 | sdb: uid = 360000000000000000e00000000010001 (udev)
1040s 65.023057 | sdb: detect_prio = yes (setting: multipath internal)
1040s 65.023076 | sdb: prio = const (setting: multipath internal)
1040s 65.023096 | sdb: prio args = "" (setting: multipath internal)
1040s 65.023114 | sdb: const prio = 1
1040s 65.023150 | sda: size = 204800
1040s 65.023172 | sda: vendor = IET
1040s 65.023191 | sda: product = VIRTUAL-DISK
1040s 65.023209 | sda: rev = 0001
1040s 65.023800 | sda: h:b:t:l = 0:0:0:1
1040s 65.023928 | sda: tgt_node_name = iqn.2016-11.foo.com:target.iscsi
1040s 65.023965 | sda: 1024 cyl, 4 heads, 50 sectors/track, start at 0
1040s 65.023986 | sda: vpd_vendor_id = 0 "undef" (setting: multipath internal)
1040s 65.024110 | sda: serial = beaf11
1040s 65.024221 | sda: tur state = up
1040s 65.024243 | sda: uid = 360000000000000000e00000000010001 (udev)
1040s 65.024262 | sda: detect_prio = yes (setting: multipath internal)
1040s 65.024281 | sda: prio = const (setting: multipath internal)
1040s 65.024299 | sda: prio args = "" (setting: multipath internal)
1040s 65.024318 | sda: const prio = 1
1040s 65.024356 | sdd: size = 204800
1040s 65.024378 | sdd: vendor = IET
1040s 65.024397 | sdd: product = VIRTUAL-DISK
1040s 65.024416 | sdd: rev = 0001
1040s 65.025005 | sdd: h:b:t:l = 3:0:0:1
1040s 65.025137 | sdd: tgt_node_name = iqn.2016-11.foo.com:target.iscsi
1040s 65.025176 | sdd: 1024 cyl, 4 heads, 50 sectors/track, start at 0
1040s 65.025198 | sdd: vpd_vendor_id = 0 "undef" (setting: multipath internal)
1040s 65.025227 | sdd: serial = beaf11
1040s 65.025317 | sdd: tur state = up
1040s 65.025339 | sdd: uid = 360000000000000000e00000000010001 (udev)
1040s 65.025373 | sdd: detect_prio = yes (setting: multipath internal)
1040s 65.025391 | ===== paths list =====
1040s uuid hcil    dev dev_t pri dm_st chk_st vend/prod/rev         dev_st 
1040s      0:0:0:1 sda 8:0   -1  undef undef  IET,VIRTUAL-DISK,0001 unknown
1040s      1:0:0:1 sdb 8:16  -1  undef undef  IET,VIRTUAL-DISK,0001 unknown
1040s      2:0:0:1 sdc 8:32  -1  undef undef  IET,VIRTUAL-DISK,0001 unknown
1040s      3:0:0:1 sdd 8:48  -1  undef undef  IET,VIRTUAL-DISK,0001 unknown
1040s mpatha (360000000000000000e00000000010001) dm-0 IET,VIRTUAL-DISK
1040s size=100M features='0' hwhandler='0' wp=rw
1040s |-+- policy='service-time 0' prio=1 status=active
1040s | `- 2:0:0:1 sdc 8:32 active ready running
1040s |-+- policy='service-time 0' prio=1 status=enabled
1040s | `- 1:0:0:1 sdb 8:16 active ready running
1040s |-+- policy='service-time 0' prio=1 status=enabled
1040s | `- 0:0:0:1 sda 8:0  active ready running
1040s `-+- policy='service-time 0' prio=1 status=enabled
1040s   `- 3:0:0:1 sdd 8:48 active ready running
1040s mpatha: 0 204800 multipath 0 0 4 1 service-time 0 1 2 8:32 1 1 service-time 0 1 2 8:16 1 1 service-time 0 1 2 8:0 1 1 service-time 0 1 2 8:48 1 1 
1040s /etc/multipath/bindings:# Multipath bindings, Version : 1.0
1040s /etc/multipath/bindings:# NOTE: this file is automatically maintained by the multipath program.
1040s /etc/multipath/bindings:# You should not need to edit this file in normal circumstances.
1040s /etc/multipath/bindings:#
1040s /etc/multipath/bindings:# Format:
1040s /etc/multipath/bindings:# alias wwid
1040s /etc/multipath/bindings:#
1040s /etc/multipath/bindings:mpatha 360000000000000000e00000000010001
1040s /etc/multipath/wwids:/360000000000000000e00000000010001/
1040s sdd: prio = const (setting: multipath internal)
1040s 65.025409 | sdd: prio args = "" (setting: multipath internal)
1040s 65.025427 | sdd: const prio = 1
1040s 65.026209 | unloading tur checker
1040s 65.026262 | unloading const prioritizer
1040s + dmsetup table
1040s + grep . /etc/multipath/bindings /etc/multipath/wwids
1040s + systemctl status multipathd.service
1040s ● multipathd.service - Device-Mapper Multipath Device Controller
1040s      Loaded: loaded (/usr/lib/systemd/system/multipathd.service; enabled; preset: enabled)
1040s      Active: active (running) since Mon 2024-08-26 11:05:07 UTC; 1min 2s ago
1040s  Invocation: 07c5f764309a4856a9aed1f0c07b3579
1040s TriggeredBy: ○ multipathd.socket
1040s    Main PID: 331 (multipathd)
1040s      Status: "up"
1040s       Tasks: 7
1040s      Memory: 27.6M (peak: 35.1M)
1040s         CPU: 35ms
1040s      CGroup: /system.slice/multipathd.service
1040s              └─331 /sbin/multipathd -d -s
1040s 
1040s Aug 26 11:05:07 autopkgtest systemd[1]: Starting multipathd.service - Device-Mapper Multipath Device Controller...
1040s Aug 26 11:05:07 autopkgtest multipathd[331]: multipathd v0.9.9: start up
1040s Aug 26 11:05:07 autopkgtest multipathd[331]: reconfigure: setting up paths and maps
1040s Aug 26 11:05:07 autopkgtest systemd[1]: Started multipathd.service - Device-Mapper Multipath Device Controller.
1040s Aug 26 11:06:04 autopkgtest multipathd[331]: updated bindings file /etc/multipath/bindings
1040s Aug 26 11:06:04 autopkgtest multipathd[331]: mpatha: addmap [0 204800 multipath 0 0 1 1 service-time 0 1 1 8:32 1]
1040s Aug 26 11:06:04 autopkgtest multipathd[331]: sdc [8:32]: path added to devmap mpatha
1040s Aug 26 11:06:04 autopkgtest multipathd[331]: mpatha: performing delayed actions
1040s Aug 26 11:06:04 autopkgtest multipathd[331]: mpatha: reload [0 204800 multipath 0 0 4 1 service-time 0 1 1 8:32 1 service-time 0 1 1 8:16 1 service-time 0 1 1 8:0 1 service-time 0 1 1 8:48 1]
1040s ○ multipathd.socket - multipathd control socket
1040s      Loaded: loaded (/usr/lib/systemd/system/multipathd.socket; static)
1040s      Active: inactive (dead)
1040s    Triggers: ● multipathd.service
1040s      Listen: @/org/kernel/linux/storage/multipathd (Stream)
1040s + systemctl status multipathd.socket
1041s autopkgtest [11:06:10]: test tgtbasedmpaths: -----------------------]
1041s tgtbasedmpaths       FAIL non-zero exit status 3
1041s autopkgtest [11:06:10]: test tgtbasedmpaths:  - - - - - - - - - - results - - - - - - - - - -
1042s autopkgtest [11:06:11]: @@@@@@@@@@@@@@@@@@@@ summary
1042s initramfs            SKIP Test lists explicitly supported architectures, but the current architecture ppc64el isn't listed.
1042s initramfs            SKIP Test lists explicitly supported architectures, but the current architecture ppc64el isn't listed.
1042s kpartx-file-loopback PASS
1042s tgtbasedmpaths       FAIL non-zero exit status 3
1058s nova [W] Using flock in prodstack6-ppc64el
1058s Creating nova instance adt-oracular-ppc64el-multipath-tools-20240826-104846-juju-7f2275-prod-proposed-migration-environment-3-6744efa4-f91e-402d-ba93-f3eb53a14179 from image adt/ubuntu-oracular-ppc64el-server-20240826.img (UUID a599eb16-5c62-4863-a2b1-e23deea6df81)...
1058s nova [W] Using flock in prodstack6-ppc64el
1058s Creating nova instance adt-oracular-ppc64el-multipath-tools-20240826-104846-juju-7f2275-prod-proposed-migration-environment-3-6744efa4-f91e-402d-ba93-f3eb53a14179 from image adt/ubuntu-oracular-ppc64el-server-20240826.img (UUID a599eb16-5c62-4863-a2b1-e23deea6df81)...