0s autopkgtest [09:11:40]: starting date and time: 2024-08-26 09:11:40+0000
  0s autopkgtest [09:11:40]: git checkout: fd3bed09 nova: allow more retries for quota issues
  0s autopkgtest [09:11:40]: host juju-7f2275-prod-proposed-migration-environment-3; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.5dprzikf/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:linux-meta,src:linux --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 linux/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 --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-3@bos02-ppc64el-19.secgroup --name adt-oracular-ppc64el-multipath-tools-20240826-091140-juju-7f2275-prod-proposed-migration-environment-3-208292d9-8c11-4b0e-9ec1-3e2bd5d72ec9 --image adt/ubuntu-oracular-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-3 --net-id=net_prod-proposed-migration -e TERM=linux -e ''"'"'http_proxy=http://squid.internal:3128'"'"'' -e ''"'"'https_proxy=http://squid.internal:3128'"'"'' -e ''"'"'no_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,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/
100s autopkgtest [09:13:20]: testbed dpkg architecture: ppc64el
100s autopkgtest [09:13:20]: testbed apt version: 2.9.8
100s autopkgtest [09:13:20]: @@@@@@@@@@@@@@@@@@@@ test bed setup
102s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [126 kB]
102s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [11.1 kB]
103s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [855 kB]
103s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [8408 B]
103s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [59.7 kB]
103s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el Packages [74.7 kB]
103s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el c-n-f Metadata [2184 B]
103s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/restricted ppc64el Packages [1376 B]
103s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/restricted ppc64el c-n-f Metadata [120 B]
103s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/universe ppc64el Packages [756 kB]
103s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/universe ppc64el c-n-f Metadata [19.4 kB]
103s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse ppc64el Packages [5956 B]
103s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse ppc64el c-n-f Metadata [372 B]
105s Fetched 1921 kB in 1s (2017 kB/s)
105s Reading package lists...
133s Reading package lists...
133s Building dependency tree...
133s Reading state information...
133s Calculating upgrade...
133s The following NEW packages will be installed:
133s   libpython3.12t64 linux-headers-6.11.0-4 linux-headers-6.11.0-4-generic
133s   linux-image-6.11.0-4-generic linux-modules-6.11.0-4-generic
133s   linux-modules-extra-6.11.0-4-generic linux-tools-6.11.0-4
133s   linux-tools-6.11.0-4-generic
133s The following packages will be upgraded:
133s   linux-generic linux-headers-generic linux-headers-virtual
133s   linux-image-generic linux-image-virtual linux-libc-dev linux-tools-common
133s   linux-virtual
134s 8 upgraded, 8 newly installed, 0 to remove and 0 not upgraded.
134s Need to get 228 MB of archives.
134s After this operation, 343 MB of additional disk space will be used.
134s Get:1 http://ftpmaster.internal/ubuntu oracular/main ppc64el libpython3.12t64 ppc64el 3.12.5-4 [2560 kB]
134s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-modules-6.11.0-4-generic ppc64el 6.11.0-4.4 [32.8 MB]
136s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-image-6.11.0-4-generic ppc64el 6.11.0-4.4 [63.9 MB]
140s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-modules-extra-6.11.0-4-generic ppc64el 6.11.0-4.4 [105 MB]
147s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-generic ppc64el 6.11.0-4.4 [1728 B]
147s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-image-generic ppc64el 6.11.0-4.4 [10.6 kB]
147s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-virtual ppc64el 6.11.0-4.4 [1720 B]
147s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-image-virtual ppc64el 6.11.0-4.4 [10.6 kB]
147s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-headers-virtual ppc64el 6.11.0-4.4 [1642 B]
147s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-headers-6.11.0-4 all 6.11.0-4.4 [13.9 MB]
148s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-headers-6.11.0-4-generic ppc64el 6.11.0-4.4 [3949 kB]
148s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-headers-generic ppc64el 6.11.0-4.4 [10.5 kB]
148s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-libc-dev ppc64el 6.11.0-4.4 [1648 kB]
148s Get:14 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-tools-common all 6.11.0-4.4 [479 kB]
148s Get:15 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-tools-6.11.0-4 ppc64el 6.11.0-4.4 [4201 kB]
148s Get:16 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-tools-6.11.0-4-generic ppc64el 6.11.0-4.4 [1746 B]
149s Fetched 228 MB in 15s (15.2 MB/s)
149s Selecting previously unselected package libpython3.12t64:ppc64el.
149s (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.)
149s Preparing to unpack .../00-libpython3.12t64_3.12.5-4_ppc64el.deb ...
149s Unpacking libpython3.12t64:ppc64el (3.12.5-4) ...
149s Selecting previously unselected package linux-modules-6.11.0-4-generic.
149s Preparing to unpack .../01-linux-modules-6.11.0-4-generic_6.11.0-4.4_ppc64el.deb ...
149s Unpacking linux-modules-6.11.0-4-generic (6.11.0-4.4) ...
149s Selecting previously unselected package linux-image-6.11.0-4-generic.
149s Preparing to unpack .../02-linux-image-6.11.0-4-generic_6.11.0-4.4_ppc64el.deb ...
149s Unpacking linux-image-6.11.0-4-generic (6.11.0-4.4) ...
150s Selecting previously unselected package linux-modules-extra-6.11.0-4-generic.
150s Preparing to unpack .../03-linux-modules-extra-6.11.0-4-generic_6.11.0-4.4_ppc64el.deb ...
150s Unpacking linux-modules-extra-6.11.0-4-generic (6.11.0-4.4) ...
151s Preparing to unpack .../04-linux-generic_6.11.0-4.4_ppc64el.deb ...
151s Unpacking linux-generic (6.11.0-4.4) over (6.8.0-31.31) ...
151s Preparing to unpack .../05-linux-image-generic_6.11.0-4.4_ppc64el.deb ...
151s Unpacking linux-image-generic (6.11.0-4.4) over (6.8.0-31.31) ...
151s Preparing to unpack .../06-linux-virtual_6.11.0-4.4_ppc64el.deb ...
151s Unpacking linux-virtual (6.11.0-4.4) over (6.8.0-31.31) ...
151s Preparing to unpack .../07-linux-image-virtual_6.11.0-4.4_ppc64el.deb ...
151s Unpacking linux-image-virtual (6.11.0-4.4) over (6.8.0-31.31) ...
151s Preparing to unpack .../08-linux-headers-virtual_6.11.0-4.4_ppc64el.deb ...
151s Unpacking linux-headers-virtual (6.11.0-4.4) over (6.8.0-31.31) ...
151s Selecting previously unselected package linux-headers-6.11.0-4.
151s Preparing to unpack .../09-linux-headers-6.11.0-4_6.11.0-4.4_all.deb ...
151s Unpacking linux-headers-6.11.0-4 (6.11.0-4.4) ...
153s Selecting previously unselected package linux-headers-6.11.0-4-generic.
153s Preparing to unpack .../10-linux-headers-6.11.0-4-generic_6.11.0-4.4_ppc64el.deb ...
153s Unpacking linux-headers-6.11.0-4-generic (6.11.0-4.4) ...
154s Preparing to unpack .../11-linux-headers-generic_6.11.0-4.4_ppc64el.deb ...
154s Unpacking linux-headers-generic (6.11.0-4.4) over (6.8.0-31.31) ...
154s Preparing to unpack .../12-linux-libc-dev_6.11.0-4.4_ppc64el.deb ...
154s Unpacking linux-libc-dev:ppc64el (6.11.0-4.4) over (6.8.0-31.31) ...
155s Preparing to unpack .../13-linux-tools-common_6.11.0-4.4_all.deb ...
155s Unpacking linux-tools-common (6.11.0-4.4) over (6.8.0-31.31) ...
155s Selecting previously unselected package linux-tools-6.11.0-4.
155s Preparing to unpack .../14-linux-tools-6.11.0-4_6.11.0-4.4_ppc64el.deb ...
155s Unpacking linux-tools-6.11.0-4 (6.11.0-4.4) ...
155s Selecting previously unselected package linux-tools-6.11.0-4-generic.
155s Preparing to unpack .../15-linux-tools-6.11.0-4-generic_6.11.0-4.4_ppc64el.deb ...
155s Unpacking linux-tools-6.11.0-4-generic (6.11.0-4.4) ...
155s Setting up linux-libc-dev:ppc64el (6.11.0-4.4) ...
155s Setting up linux-modules-6.11.0-4-generic (6.11.0-4.4) ...
157s Setting up linux-image-6.11.0-4-generic (6.11.0-4.4) ...
159s I: /boot/vmlinux is now a symlink to vmlinux-6.11.0-4-generic
159s I: /boot/initrd.img is now a symlink to initrd.img-6.11.0-4-generic
159s Setting up libpython3.12t64:ppc64el (3.12.5-4) ...
159s Setting up linux-modules-extra-6.11.0-4-generic (6.11.0-4.4) ...
161s Setting up linux-headers-6.11.0-4 (6.11.0-4.4) ...
161s Setting up linux-image-virtual (6.11.0-4.4) ...
161s Setting up linux-tools-common (6.11.0-4.4) ...
161s Setting up linux-tools-6.11.0-4 (6.11.0-4.4) ...
161s Setting up linux-image-generic (6.11.0-4.4) ...
161s Setting up linux-headers-6.11.0-4-generic (6.11.0-4.4) ...
161s Setting up linux-tools-6.11.0-4-generic (6.11.0-4.4) ...
161s Setting up linux-headers-generic (6.11.0-4.4) ...
161s Setting up linux-headers-virtual (6.11.0-4.4) ...
161s Setting up linux-generic (6.11.0-4.4) ...
161s Setting up linux-virtual (6.11.0-4.4) ...
161s Processing triggers for man-db (2.12.1-3) ...
163s Processing triggers for libc-bin (2.40-1ubuntu1) ...
163s Processing triggers for linux-image-6.11.0-4-generic (6.11.0-4.4) ...
163s /etc/kernel/postinst.d/initramfs-tools:
163s update-initramfs: Generating /boot/initrd.img-6.11.0-4-generic
163s W: No lz4 in /usr/bin:/sbin:/bin, using gzip
170s /etc/kernel/postinst.d/zz-update-grub:
170s Sourcing file `/etc/default/grub'
170s Sourcing file `/etc/default/grub.d/50-cloudimg-settings.cfg'
170s Generating grub configuration file ...
170s Found linux image: /boot/vmlinux-6.11.0-4-generic
170s Found initrd image: /boot/initrd.img-6.11.0-4-generic
170s Found linux image: /boot/vmlinux-6.8.0-31-generic
170s Found initrd image: /boot/initrd.img-6.8.0-31-generic
170s Warning: os-prober will not be executed to detect other bootable partitions.
170s Systems on them will not be added to the GRUB boot configuration.
170s Check GRUB_DISABLE_OS_PROBER documentation entry.
170s Adding boot menu entry for UEFI Firmware Settings ...
170s done
171s Reading package lists...
171s Building dependency tree...
171s Reading state information...
171s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
174s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease
175s Hit:2 http://ftpmaster.internal/ubuntu oracular InRelease
175s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease
175s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease
176s Reading package lists...
176s Reading package lists...
176s Building dependency tree...
176s Reading state information...
176s Calculating upgrade...
176s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
176s Reading package lists...
176s Building dependency tree...
176s Reading state information...
177s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
190s Reading package lists...
190s Building dependency tree...
190s Reading state information...
190s linux-generic is already the newest version (6.11.0-4.4).
190s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
193s Reading package lists...
194s Building dependency tree...
194s Reading state information...
194s E: Unable to locate package ^kernel-testing--linux--modules-extra--preferred$
194s E: Couldn't find any package by regex '^kernel-testing--linux--modules-extra--preferred$'
194s Reading package lists...
194s Building dependency tree...
194s Reading state information...
194s E: Unable to locate package ^linux-modules-extra$
194s E: Couldn't find any package by regex '^linux-modules-extra$'
194s autopkgtest [09:14:54]: rebooting testbed after setup commands that affected boot
258s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds...
278s autopkgtest [09:16:18]: testbed running kernel: Linux 6.11.0-4-generic #4-Ubuntu SMP Tue Aug 20 14:54:18 UTC 2024
312s autopkgtest [09:16:52]: @@@@@@@@@@@@@@@@@@@@ apt-source multipath-tools
345s Get:1 http://ftpmaster.internal/ubuntu oracular/main multipath-tools 0.9.9-1ubuntu2 (dsc) [2772 B]
345s Get:2 http://ftpmaster.internal/ubuntu oracular/main multipath-tools 0.9.9-1ubuntu2 (tar) [588 kB]
345s Get:3 http://ftpmaster.internal/ubuntu oracular/main multipath-tools 0.9.9-1ubuntu2 (diff) [42.4 kB]
345s gpgv: Signature made Tue Jul 23 21:24:22 2024 UTC
345s gpgv:                using RSA key D09F8A854F1055BCFC482C4B23566B906047AFC8
345s gpgv: Can't check signature: No public key
345s dpkg-source: warning: cannot verify inline signature for ./multipath-tools_0.9.9-1ubuntu2.dsc: no acceptable signature found
350s autopkgtest [09:17:30]: testing package multipath-tools version 0.9.9-1ubuntu2
355s initramfs            SKIP Test lists explicitly supported architectures, but the current architecture ppc64el isn't listed.
355s autopkgtest [09:17:35]: build not needed
360s initramfs            SKIP Test lists explicitly supported architectures, but the current architecture ppc64el isn't listed.
360s autopkgtest [09:17:40]: test kpartx-file-loopback: preparing testbed
367s Reading package lists...
367s Building dependency tree...
367s Reading state information...
368s Starting pkgProblemResolver with broken count: 0
368s Starting 2 pkgProblemResolver with broken count: 0
368s Done
368s The following additional packages will be installed:
368s   liburing2 qemu-utils
368s Recommended packages:
368s   qemu-block-extra
368s The following NEW packages will be installed:
368s   autopkgtest-satdep liburing2 qemu-utils
368s 0 upgraded, 3 newly installed, 0 to remove and 0 not upgraded.
368s Need to get 2432 kB/2433 kB of archives.
368s After this operation, 16.9 MB of additional disk space will be used.
368s Get:1 /tmp/autopkgtest.sFasib/1-autopkgtest-satdep.deb autopkgtest-satdep ppc64el 0 [720 B]
368s Get:2 http://ftpmaster.internal/ubuntu oracular/main ppc64el liburing2 ppc64el 2.6-1 [26.9 kB]
368s Get:3 http://ftpmaster.internal/ubuntu oracular/main ppc64el qemu-utils ppc64el 1:9.0.2+ds-4ubuntu2 [2405 kB]
370s Fetched 2432 kB in 1s (1812 kB/s)
370s Selecting previously unselected package liburing2:ppc64el.
370s (Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 109843 files and directories currently installed.)
370s Preparing to unpack .../liburing2_2.6-1_ppc64el.deb ...
370s Unpacking liburing2:ppc64el (2.6-1) ...
370s Selecting previously unselected package qemu-utils.
370s Preparing to unpack .../qemu-utils_1%3a9.0.2+ds-4ubuntu2_ppc64el.deb ...
370s Unpacking qemu-utils (1:9.0.2+ds-4ubuntu2) ...
370s Selecting previously unselected package autopkgtest-satdep.
370s Preparing to unpack .../1-autopkgtest-satdep.deb ...
370s Unpacking autopkgtest-satdep (0) ...
370s Setting up liburing2:ppc64el (2.6-1) ...
370s Setting up qemu-utils (1:9.0.2+ds-4ubuntu2) ...
370s Setting up autopkgtest-satdep (0) ...
370s Processing triggers for man-db (2.12.1-3) ...
371s Processing triggers for libc-bin (2.40-1ubuntu1) ...
391s (Reading database ... 109867 files and directories currently installed.)
391s Removing autopkgtest-satdep (0) ...
417s autopkgtest [09:18:37]: test kpartx-file-loopback: [-----------------------
417s Formatting 'foo.img', fmt=raw size=20971520
418s Creating new GPT entries in memory.
418s Warning: The kernel is still using the old partition table.
418s The new table will be used at the next reboot or after you
418s run partprobe(8) or kpartx(8)
418s The operation has completed successfully.
418s add map loop0p1 (252:0): 0 38879 linear 7:0 2048
418s standard_filename: OK
418s del devmap : loop0p1
418s No devices found
418s standard_filename_cleanup: OK
418s Formatting 'fou du FaFa.img', fmt=raw size=20971520
419s Creating new GPT entries in memory.
419s Warning: The kernel is still using the old partition table.
419s The new table will be used at the next reboot or after you
419s run partprobe(8) or kpartx(8)
419s The operation has completed successfully.
419s add map loop0p1 (252:0): 0 38879 linear 7:0 2048
419s filename_with_spaces: OK
419s del devmap : loop0p1
419s No devices found
419s filename_with_spaces_cleanup: OK
420s autopkgtest [09:18:40]: test kpartx-file-loopback: -----------------------]
434s kpartx-file-loopback PASS
434s autopkgtest [09:18:54]: test kpartx-file-loopback:  - - - - - - - - - - results - - - - - - - - - -
435s autopkgtest [09:18:55]: test tgtbasedmpaths: preparing testbed
633s autopkgtest [09:22:13]: testbed dpkg architecture: ppc64el
637s autopkgtest [09:22:17]: testbed apt version: 2.9.8
637s autopkgtest [09:22:17]: @@@@@@@@@@@@@@@@@@@@ test bed setup
642s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [126 kB]
642s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [855 kB]
642s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [11.1 kB]
642s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [59.7 kB]
642s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [8408 B]
642s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el Packages [74.7 kB]
642s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el c-n-f Metadata [2184 B]
642s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/restricted ppc64el Packages [1376 B]
642s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/restricted ppc64el c-n-f Metadata [120 B]
642s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/universe ppc64el Packages [757 kB]
642s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/universe ppc64el c-n-f Metadata [19.4 kB]
642s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse ppc64el Packages [5956 B]
642s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse ppc64el c-n-f Metadata [372 B]
644s Fetched 1922 kB in 1s (2199 kB/s)
644s Reading package lists...
647s Reading package lists...
647s Building dependency tree...
647s Reading state information...
647s Calculating upgrade...
647s The following NEW packages will be installed:
647s   libpython3.12t64 linux-headers-6.11.0-4 linux-headers-6.11.0-4-generic
647s   linux-image-6.11.0-4-generic linux-modules-6.11.0-4-generic
647s   linux-modules-extra-6.11.0-4-generic linux-tools-6.11.0-4
647s   linux-tools-6.11.0-4-generic
647s The following packages will be upgraded:
647s   linux-generic linux-headers-generic linux-headers-virtual
647s   linux-image-generic linux-image-virtual linux-libc-dev linux-tools-common
647s   linux-virtual
648s 8 upgraded, 8 newly installed, 0 to remove and 0 not upgraded.
648s Need to get 228 MB of archives.
648s After this operation, 343 MB of additional disk space will be used.
648s Get:1 http://ftpmaster.internal/ubuntu oracular/main ppc64el libpython3.12t64 ppc64el 3.12.5-4 [2560 kB]
648s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-modules-6.11.0-4-generic ppc64el 6.11.0-4.4 [32.8 MB]
649s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-image-6.11.0-4-generic ppc64el 6.11.0-4.4 [63.9 MB]
651s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-modules-extra-6.11.0-4-generic ppc64el 6.11.0-4.4 [105 MB]
654s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-generic ppc64el 6.11.0-4.4 [1728 B]
654s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-image-generic ppc64el 6.11.0-4.4 [10.6 kB]
654s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-virtual ppc64el 6.11.0-4.4 [1720 B]
654s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-image-virtual ppc64el 6.11.0-4.4 [10.6 kB]
654s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-headers-virtual ppc64el 6.11.0-4.4 [1642 B]
654s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-headers-6.11.0-4 all 6.11.0-4.4 [13.9 MB]
654s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-headers-6.11.0-4-generic ppc64el 6.11.0-4.4 [3949 kB]
654s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-headers-generic ppc64el 6.11.0-4.4 [10.5 kB]
654s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-libc-dev ppc64el 6.11.0-4.4 [1648 kB]
654s Get:14 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-tools-common all 6.11.0-4.4 [479 kB]
654s Get:15 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-tools-6.11.0-4 ppc64el 6.11.0-4.4 [4201 kB]
654s Get:16 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-tools-6.11.0-4-generic ppc64el 6.11.0-4.4 [1746 B]
654s Fetched 228 MB in 7s (34.6 MB/s)
654s Selecting previously unselected package libpython3.12t64:ppc64el.
655s (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.)
655s Preparing to unpack .../00-libpython3.12t64_3.12.5-4_ppc64el.deb ...
655s Unpacking libpython3.12t64:ppc64el (3.12.5-4) ...
655s Selecting previously unselected package linux-modules-6.11.0-4-generic.
655s Preparing to unpack .../01-linux-modules-6.11.0-4-generic_6.11.0-4.4_ppc64el.deb ...
655s Unpacking linux-modules-6.11.0-4-generic (6.11.0-4.4) ...
655s Selecting previously unselected package linux-image-6.11.0-4-generic.
655s Preparing to unpack .../02-linux-image-6.11.0-4-generic_6.11.0-4.4_ppc64el.deb ...
655s Unpacking linux-image-6.11.0-4-generic (6.11.0-4.4) ...
655s Selecting previously unselected package linux-modules-extra-6.11.0-4-generic.
655s Preparing to unpack .../03-linux-modules-extra-6.11.0-4-generic_6.11.0-4.4_ppc64el.deb ...
655s Unpacking linux-modules-extra-6.11.0-4-generic (6.11.0-4.4) ...
656s Preparing to unpack .../04-linux-generic_6.11.0-4.4_ppc64el.deb ...
656s Unpacking linux-generic (6.11.0-4.4) over (6.8.0-31.31) ...
656s Preparing to unpack .../05-linux-image-generic_6.11.0-4.4_ppc64el.deb ...
656s Unpacking linux-image-generic (6.11.0-4.4) over (6.8.0-31.31) ...
656s Preparing to unpack .../06-linux-virtual_6.11.0-4.4_ppc64el.deb ...
656s Unpacking linux-virtual (6.11.0-4.4) over (6.8.0-31.31) ...
656s Preparing to unpack .../07-linux-image-virtual_6.11.0-4.4_ppc64el.deb ...
656s Unpacking linux-image-virtual (6.11.0-4.4) over (6.8.0-31.31) ...
656s Preparing to unpack .../08-linux-headers-virtual_6.11.0-4.4_ppc64el.deb ...
656s Unpacking linux-headers-virtual (6.11.0-4.4) over (6.8.0-31.31) ...
656s Selecting previously unselected package linux-headers-6.11.0-4.
656s Preparing to unpack .../09-linux-headers-6.11.0-4_6.11.0-4.4_all.deb ...
656s Unpacking linux-headers-6.11.0-4 (6.11.0-4.4) ...
659s Selecting previously unselected package linux-headers-6.11.0-4-generic.
659s Preparing to unpack .../10-linux-headers-6.11.0-4-generic_6.11.0-4.4_ppc64el.deb ...
659s Unpacking linux-headers-6.11.0-4-generic (6.11.0-4.4) ...
660s Preparing to unpack .../11-linux-headers-generic_6.11.0-4.4_ppc64el.deb ...
660s Unpacking linux-headers-generic (6.11.0-4.4) over (6.8.0-31.31) ...
660s Preparing to unpack .../12-linux-libc-dev_6.11.0-4.4_ppc64el.deb ...
660s Unpacking linux-libc-dev:ppc64el (6.11.0-4.4) over (6.8.0-31.31) ...
660s Preparing to unpack .../13-linux-tools-common_6.11.0-4.4_all.deb ...
660s Unpacking linux-tools-common (6.11.0-4.4) over (6.8.0-31.31) ...
661s Selecting previously unselected package linux-tools-6.11.0-4.
661s Preparing to unpack .../14-linux-tools-6.11.0-4_6.11.0-4.4_ppc64el.deb ...
661s Unpacking linux-tools-6.11.0-4 (6.11.0-4.4) ...
661s Selecting previously unselected package linux-tools-6.11.0-4-generic.
661s Preparing to unpack .../15-linux-tools-6.11.0-4-generic_6.11.0-4.4_ppc64el.deb ...
661s Unpacking linux-tools-6.11.0-4-generic (6.11.0-4.4) ...
661s Setting up linux-libc-dev:ppc64el (6.11.0-4.4) ...
661s Setting up linux-modules-6.11.0-4-generic (6.11.0-4.4) ...
663s Setting up linux-image-6.11.0-4-generic (6.11.0-4.4) ...
665s I: /boot/vmlinux is now a symlink to vmlinux-6.11.0-4-generic
665s I: /boot/initrd.img is now a symlink to initrd.img-6.11.0-4-generic
665s Setting up libpython3.12t64:ppc64el (3.12.5-4) ...
665s Setting up linux-modules-extra-6.11.0-4-generic (6.11.0-4.4) ...
667s Setting up linux-headers-6.11.0-4 (6.11.0-4.4) ...
667s Setting up linux-image-virtual (6.11.0-4.4) ...
667s Setting up linux-tools-common (6.11.0-4.4) ...
667s Setting up linux-tools-6.11.0-4 (6.11.0-4.4) ...
667s Setting up linux-image-generic (6.11.0-4.4) ...
667s Setting up linux-headers-6.11.0-4-generic (6.11.0-4.4) ...
667s Setting up linux-tools-6.11.0-4-generic (6.11.0-4.4) ...
667s Setting up linux-headers-generic (6.11.0-4.4) ...
667s Setting up linux-headers-virtual (6.11.0-4.4) ...
667s Setting up linux-generic (6.11.0-4.4) ...
667s Setting up linux-virtual (6.11.0-4.4) ...
667s Processing triggers for man-db (2.12.1-3) ...
668s Processing triggers for libc-bin (2.40-1ubuntu1) ...
668s Processing triggers for linux-image-6.11.0-4-generic (6.11.0-4.4) ...
668s /etc/kernel/postinst.d/initramfs-tools:
668s update-initramfs: Generating /boot/initrd.img-6.11.0-4-generic
668s W: No lz4 in /usr/bin:/sbin:/bin, using gzip
675s /etc/kernel/postinst.d/zz-update-grub:
675s Sourcing file `/etc/default/grub'
675s Sourcing file `/etc/default/grub.d/50-cloudimg-settings.cfg'
675s Generating grub configuration file ...
675s Found linux image: /boot/vmlinux-6.11.0-4-generic
675s Found initrd image: /boot/initrd.img-6.11.0-4-generic
675s Found linux image: /boot/vmlinux-6.8.0-31-generic
675s Found initrd image: /boot/initrd.img-6.8.0-31-generic
675s Warning: os-prober will not be executed to detect other bootable partitions.
675s Systems on them will not be added to the GRUB boot configuration.
675s Check GRUB_DISABLE_OS_PROBER documentation entry.
675s Adding boot menu entry for UEFI Firmware Settings ...
675s done
675s Reading package lists...
676s Building dependency tree...
676s Reading state information...
676s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
678s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease
678s Hit:2 http://ftpmaster.internal/ubuntu oracular InRelease
678s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease
678s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease
679s Reading package lists...
679s Reading package lists...
679s Building dependency tree...
679s Reading state information...
680s Calculating upgrade...
680s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
680s Reading package lists...
680s Building dependency tree...
680s Reading state information...
680s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
683s Reading package lists...
684s Building dependency tree...
684s Reading state information...
684s linux-generic is already the newest version (6.11.0-4.4).
684s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
684s Reading package lists...
685s Building dependency tree...
685s Reading state information...
685s E: Unable to locate package ^kernel-testing--linux--modules-extra--preferred$
685s E: Couldn't find any package by regex '^kernel-testing--linux--modules-extra--preferred$'
685s Reading package lists...
685s Building dependency tree...
685s Reading state information...
685s E: Unable to locate package ^linux-modules-extra$
685s E: Couldn't find any package by regex '^linux-modules-extra$'
688s autopkgtest [09:23:08]: rebooting testbed after setup commands that affected boot
724s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds...
789s Reading package lists...
790s Building dependency tree...
790s Reading state information...
790s Starting pkgProblemResolver with broken count: 0
790s Starting 2 pkgProblemResolver with broken count: 0
790s Done
790s The following additional packages will be installed:
790s   fio libboost-iostreams1.83.0 libboost-thread1.83.0 libconfig-general-perl
790s   libdaxctl1 libgfapi0 libgfrpc0 libgfxdr0 libglusterfs0 libisns0t64 libnbd0
790s   libndctl6 libopeniscsiusr libpmem1 libpmemobj1 librados2 librbd1
790s   librdmacm1t64 lsscsi open-iscsi tgt
790s Suggested packages:
790s   fio-examples gnuplot tgt-glusterfs tgt-rbd
790s Recommended packages:
790s   finalrd
790s The following NEW packages will be installed:
790s   autopkgtest-satdep fio libboost-iostreams1.83.0 libboost-thread1.83.0
790s   libconfig-general-perl libdaxctl1 libgfapi0 libgfrpc0 libgfxdr0
790s   libglusterfs0 libisns0t64 libnbd0 libndctl6 libopeniscsiusr libpmem1
790s   libpmemobj1 librados2 librbd1 librdmacm1t64 lsscsi open-iscsi tgt
790s 0 upgraded, 22 newly installed, 0 to remove and 0 not upgraded.
790s Need to get 10.9 MB/10.9 MB of archives.
790s After this operation, 49.6 MB of additional disk space will be used.
790s Get:1 /tmp/autopkgtest.sFasib/2-autopkgtest-satdep.deb autopkgtest-satdep ppc64el 0 [732 B]
790s Get:2 http://ftpmaster.internal/ubuntu oracular/main ppc64el libopeniscsiusr ppc64el 2.1.10-1ubuntu1 [54.9 kB]
790s Get:3 http://ftpmaster.internal/ubuntu oracular/main ppc64el libisns0t64 ppc64el 0.101-1 [117 kB]
790s Get:4 http://ftpmaster.internal/ubuntu oracular/main ppc64el open-iscsi ppc64el 2.1.10-1ubuntu1 [385 kB]
791s Get:5 http://ftpmaster.internal/ubuntu oracular/main ppc64el librdmacm1t64 ppc64el 52.0-2ubuntu1 [80.6 kB]
791s Get:6 http://ftpmaster.internal/ubuntu oracular/universe ppc64el libconfig-general-perl all 2.65-2 [57.1 kB]
791s Get:7 http://ftpmaster.internal/ubuntu oracular/universe ppc64el tgt ppc64el 1:1.0.85-1.2ubuntu1 [254 kB]
791s Get:8 http://ftpmaster.internal/ubuntu oracular/universe ppc64el libgfxdr0 ppc64el 11.1-5ubuntu1 [21.7 kB]
791s Get:9 http://ftpmaster.internal/ubuntu oracular/universe ppc64el libglusterfs0 ppc64el 11.1-5ubuntu1 [308 kB]
791s Get:10 http://ftpmaster.internal/ubuntu oracular/universe ppc64el libgfrpc0 ppc64el 11.1-5ubuntu1 [46.3 kB]
791s Get:11 http://ftpmaster.internal/ubuntu oracular/universe ppc64el libgfapi0 ppc64el 11.1-5ubuntu1 [99.1 kB]
791s Get:12 http://ftpmaster.internal/ubuntu oracular/universe ppc64el libnbd0 ppc64el 1.20.2-2 [98.5 kB]
791s Get:13 http://ftpmaster.internal/ubuntu oracular/main ppc64el libdaxctl1 ppc64el 77-2.2ubuntu1 [23.7 kB]
791s Get:14 http://ftpmaster.internal/ubuntu oracular/main ppc64el libndctl6 ppc64el 77-2.2ubuntu1 [73.4 kB]
791s Get:15 http://ftpmaster.internal/ubuntu oracular/main ppc64el libpmem1 ppc64el 1.13.1-1.1ubuntu2 [41.1 kB]
791s Get:16 http://ftpmaster.internal/ubuntu oracular/main ppc64el libboost-iostreams1.83.0 ppc64el 1.83.0-3.1ubuntu1 [259 kB]
791s Get:17 http://ftpmaster.internal/ubuntu oracular/main ppc64el libboost-thread1.83.0 ppc64el 1.83.0-3.1ubuntu1 [281 kB]
791s Get:18 http://ftpmaster.internal/ubuntu oracular/main ppc64el librados2 ppc64el 19.2.0~is.really.19.1.0-0ubuntu2 [4151 kB]
791s Get:19 http://ftpmaster.internal/ubuntu oracular/main ppc64el libpmemobj1 ppc64el 1.13.1-1.1ubuntu2 [143 kB]
791s Get:20 http://ftpmaster.internal/ubuntu oracular/main ppc64el librbd1 ppc64el 19.2.0~is.really.19.1.0-0ubuntu2 [3684 kB]
791s Get:21 http://ftpmaster.internal/ubuntu oracular/universe ppc64el fio ppc64el 3.37-1 [716 kB]
791s Get:22 http://ftpmaster.internal/ubuntu oracular/main ppc64el lsscsi ppc64el 0.32-1build1 [54.0 kB]
791s Preconfiguring packages ...
791s Fetched 10.9 MB in 1s (10.4 MB/s)
791s Selecting previously unselected package libopeniscsiusr.
792s (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 ... 109843 files and directories currently installed.)
792s Preparing to unpack .../00-libopeniscsiusr_2.1.10-1ubuntu1_ppc64el.deb ...
792s Unpacking libopeniscsiusr (2.1.10-1ubuntu1) ...
792s Selecting previously unselected package libisns0t64:ppc64el.
792s Preparing to unpack .../01-libisns0t64_0.101-1_ppc64el.deb ...
792s Unpacking libisns0t64:ppc64el (0.101-1) ...
792s Selecting previously unselected package open-iscsi.
792s Preparing to unpack .../02-open-iscsi_2.1.10-1ubuntu1_ppc64el.deb ...
792s Unpacking open-iscsi (2.1.10-1ubuntu1) ...
792s Selecting previously unselected package librdmacm1t64:ppc64el.
792s Preparing to unpack .../03-librdmacm1t64_52.0-2ubuntu1_ppc64el.deb ...
792s Unpacking librdmacm1t64:ppc64el (52.0-2ubuntu1) ...
792s Selecting previously unselected package libconfig-general-perl.
792s Preparing to unpack .../04-libconfig-general-perl_2.65-2_all.deb ...
792s Unpacking libconfig-general-perl (2.65-2) ...
792s Selecting previously unselected package tgt.
792s Preparing to unpack .../05-tgt_1%3a1.0.85-1.2ubuntu1_ppc64el.deb ...
792s Unpacking tgt (1:1.0.85-1.2ubuntu1) ...
792s Selecting previously unselected package libgfxdr0:ppc64el.
792s Preparing to unpack .../06-libgfxdr0_11.1-5ubuntu1_ppc64el.deb ...
792s Unpacking libgfxdr0:ppc64el (11.1-5ubuntu1) ...
792s Selecting previously unselected package libglusterfs0:ppc64el.
792s Preparing to unpack .../07-libglusterfs0_11.1-5ubuntu1_ppc64el.deb ...
792s Unpacking libglusterfs0:ppc64el (11.1-5ubuntu1) ...
792s Selecting previously unselected package libgfrpc0:ppc64el.
792s Preparing to unpack .../08-libgfrpc0_11.1-5ubuntu1_ppc64el.deb ...
792s Unpacking libgfrpc0:ppc64el (11.1-5ubuntu1) ...
792s Selecting previously unselected package libgfapi0:ppc64el.
792s Preparing to unpack .../09-libgfapi0_11.1-5ubuntu1_ppc64el.deb ...
792s Unpacking libgfapi0:ppc64el (11.1-5ubuntu1) ...
792s Selecting previously unselected package libnbd0.
792s Preparing to unpack .../10-libnbd0_1.20.2-2_ppc64el.deb ...
792s Unpacking libnbd0 (1.20.2-2) ...
792s Selecting previously unselected package libdaxctl1:ppc64el.
792s Preparing to unpack .../11-libdaxctl1_77-2.2ubuntu1_ppc64el.deb ...
792s Unpacking libdaxctl1:ppc64el (77-2.2ubuntu1) ...
792s Selecting previously unselected package libndctl6:ppc64el.
792s Preparing to unpack .../12-libndctl6_77-2.2ubuntu1_ppc64el.deb ...
792s Unpacking libndctl6:ppc64el (77-2.2ubuntu1) ...
792s Selecting previously unselected package libpmem1:ppc64el.
792s Preparing to unpack .../13-libpmem1_1.13.1-1.1ubuntu2_ppc64el.deb ...
792s Unpacking libpmem1:ppc64el (1.13.1-1.1ubuntu2) ...
792s Selecting previously unselected package libboost-iostreams1.83.0:ppc64el.
792s Preparing to unpack .../14-libboost-iostreams1.83.0_1.83.0-3.1ubuntu1_ppc64el.deb ...
792s Unpacking libboost-iostreams1.83.0:ppc64el (1.83.0-3.1ubuntu1) ...
792s Selecting previously unselected package libboost-thread1.83.0:ppc64el.
792s Preparing to unpack .../15-libboost-thread1.83.0_1.83.0-3.1ubuntu1_ppc64el.deb ...
792s Unpacking libboost-thread1.83.0:ppc64el (1.83.0-3.1ubuntu1) ...
792s Selecting previously unselected package librados2.
792s Preparing to unpack .../16-librados2_19.2.0~is.really.19.1.0-0ubuntu2_ppc64el.deb ...
792s Unpacking librados2 (19.2.0~is.really.19.1.0-0ubuntu2) ...
792s Selecting previously unselected package libpmemobj1:ppc64el.
792s Preparing to unpack .../17-libpmemobj1_1.13.1-1.1ubuntu2_ppc64el.deb ...
792s Unpacking libpmemobj1:ppc64el (1.13.1-1.1ubuntu2) ...
792s Selecting previously unselected package librbd1.
792s Preparing to unpack .../18-librbd1_19.2.0~is.really.19.1.0-0ubuntu2_ppc64el.deb ...
792s Unpacking librbd1 (19.2.0~is.really.19.1.0-0ubuntu2) ...
792s Selecting previously unselected package fio.
792s Preparing to unpack .../19-fio_3.37-1_ppc64el.deb ...
792s Unpacking fio (3.37-1) ...
792s Selecting previously unselected package lsscsi.
792s Preparing to unpack .../20-lsscsi_0.32-1build1_ppc64el.deb ...
792s Unpacking lsscsi (0.32-1build1) ...
792s Selecting previously unselected package autopkgtest-satdep.
792s Preparing to unpack .../21-2-autopkgtest-satdep.deb ...
792s Unpacking autopkgtest-satdep (0) ...
792s Setting up libconfig-general-perl (2.65-2) ...
792s Setting up libisns0t64:ppc64el (0.101-1) ...
792s Setting up libboost-thread1.83.0:ppc64el (1.83.0-3.1ubuntu1) ...
792s Setting up libnbd0 (1.20.2-2) ...
792s Setting up libopeniscsiusr (2.1.10-1ubuntu1) ...
792s Setting up libglusterfs0:ppc64el (11.1-5ubuntu1) ...
792s Setting up libboost-iostreams1.83.0:ppc64el (1.83.0-3.1ubuntu1) ...
792s Setting up lsscsi (0.32-1build1) ...
792s Setting up libdaxctl1:ppc64el (77-2.2ubuntu1) ...
792s Setting up libndctl6:ppc64el (77-2.2ubuntu1) ...
792s Setting up librdmacm1t64:ppc64el (52.0-2ubuntu1) ...
792s Setting up tgt (1:1.0.85-1.2ubuntu1) ...
793s Created symlink '/etc/systemd/system/multi-user.target.wants/tgt.service' → '/usr/lib/systemd/system/tgt.service'.

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

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

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

795s Setting up libpmemobj1:ppc64el (1.13.1-1.1ubuntu2) ...
795s Setting up librbd1 (19.2.0~is.really.19.1.0-0ubuntu2) ...
795s Setting up libgfrpc0:ppc64el (11.1-5ubuntu1) ...
795s Setting up libgfapi0:ppc64el (11.1-5ubuntu1) ...
795s Setting up fio (3.37-1) ...
795s Setting up autopkgtest-satdep (0) ...
795s Processing triggers for man-db (2.12.1-3) ...
796s Processing triggers for initramfs-tools (0.142ubuntu32) ...
796s update-initramfs: Generating /boot/initrd.img-6.11.0-4-generic
796s W: No lz4 in /usr/bin:/sbin:/bin, using gzip
803s Processing triggers for libc-bin (2.40-1ubuntu1) ...
821s (Reading database ... 110084 files and directories currently installed.)
821s Removing autopkgtest-satdep (0) ...
874s autopkgtest [09:26:14]: test tgtbasedmpaths: [-----------------------
875s + targetname=iqn.2016-11.foo.com:target.iscsi
875s + pwd
875s + cwd=/tmp/autopkgtest.sFasib/build.TVn/src
875s + testdir=/mnt/tgtmpathtest
875s + localhost=127.0.0.1
875s + portal=127.0.0.1:3260
875s + maxpaths=4
875s + backfn=backingfile
875s + expectwwid=60000000000000000e00000000010001
875s + testdisk=/dev/disk/by-id/wwn-0x60000000000000000e00000000010001
875s + bglog=/tmp/autopkgtest.sFasib/tgtbasedmpaths-artifacts/test-background.log
875s + fioprep=/tmp/autopkgtest.sFasib/tgtbasedmpaths-artifacts/path-change-prep.fio
875s + fiovrfy=/tmp/autopkgtest.sFasib/tgtbasedmpaths-artifacts/path-change-check.fio
875s + mkdir -p /etc/multipath
875s + echo /360000000000000000e00000000010001/
875s + service tgt restart
875s + truncate --size 100M backingfile
875s + tgtadm --lld iscsi --op new --mode target --tid 1 -T iqn.2016-11.foo.com:target.iscsi
875s + tgtadm --lld iscsi --op bind --mode target --tid 1 -I ALL
875s + tgtadm --lld iscsi --op new --mode logicalunit --tid 1 --lun 1 -b /tmp/autopkgtest.sFasib/build.TVn/src/backingfile
875s + iscsiadm --mode discovery --type sendtargets --portal 127.0.0.1
875s + echo login #1
875s + iscsiadm --mode node --targetname iqn.2016-11.foo.com:target.iscsi --portal 127.0.0.1:3260 --login
875s 127.0.0.1:3260,1 iqn.2016-11.foo.com:target.iscsi
875s login #1
875s + seq 2 4
875s Logging in to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260]
875s Login to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] successful.
875s extra login #2
875s + echo extra login #2
875s + iscsiadm --mode session -r 1 --op new
875s Logging in to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] (multiple)
875s Login to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] successful.
875s extra login #3
875s + echo extra login #3
875s + iscsiadm --mode session -r 1 --op new
875s Logging in to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] (multiple)
875s Login to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] successful.
875s extra login #4
875s + echo extra login #4
875s + iscsiadm --mode session -r 1 --op new
875s Logging in to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] (multiple)
875s Login to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] successful.
875s + udevadm settle
875s + sleep 5
880s Status after initial setup
880s + echo Status after initial setup
880s + tgtadm --lld iscsi --mode target --op show
880s Target 1: iqn.2016-11.foo.com:target.iscsi
880s     System information:
880s         Driver: iscsi
880s         State: ready
880s     I_T nexus information:
880s         I_T nexus: 1
880s             Initiator: iqn.2004-10.com.ubuntu:01:79afc2821a9 alias: autopkgtest
880s             Connection: 0
880s                 IP Address: 127.0.0.1
880s         I_T nexus: 2
880s             Initiator: iqn.2004-10.com.ubuntu:01:79afc2821a9 alias: autopkgtest
880s             Connection: 0
880s                 IP Address: 127.0.0.1
880s         I_T nexus: 3
880s             Initiator: iqn.2004-10.com.ubuntu:01:79afc2821a9 alias: autopkgtest
880s             Connection: 0
880s                 IP Address: 127.0.0.1
880s         I_T nexus: 4
880s             Initiator: iqn.2004-10.com.ubuntu:01:79afc2821a9 alias: autopkgtest
880s             Connection: 0
882s                 IP Address: 127.0.0.1
882s     LUN information:
882s         LUN: 0
882s             Type: controller
882s             SCSI ID: IET     00010000
882s             SCSI SN: beaf10
882s             Size: 0 MB, Block size: 1
882s             Online: Yes
882s             Removable media: No
882s             Prevent removal: No
882s             Readonly: No
882s             SWP: No
882s             Thin-provisioning: No
882s             Backing store type: null
882s             Backing store path: None
882s             Backing store flags: 
882s         LUN: 1
882s             Type: disk
882s             SCSI ID: IET     00010001
882s             SCSI SN: beaf11
882s             Size: 105 MB, Block size: 512
882s             Online: Yes
882s             Removable media: No
882s             Prevent removal: No
882s             Readonly: No
882s             SWP: No
882s             Thin-provisioning: No
882s             Backing store type: rdwr
882s             Backing store path: /tmp/autopkgtest.sFasib/build.TVn/src/backingfile
882s             Backing store flags: 
882s     Account information:
882s     ACL information:
882s         ALL
882s + tgtadm --lld iscsi --op show --mode conn --tid 1
882s Session: 4
882s     Connection: 0
882s         Initiator: iqn.2004-10.com.ubuntu:01:79afc2821a9
882s         IP Address: 127.0.0.1
882s Session: 3
882s     Connection: 0
882s         Initiator: iqn.2004-10.com.ubuntu:01:79afc2821a9
882s         IP Address: 127.0.0.1
882s Session: 2
882s     Connection: 0
882s         Initiator: iqn.2004-10.com.ubuntu:01:79afc2821a9
882s         IP Address: 127.0.0.1
882s Session: 1
882s     Connection: 0
882s         Initiator: iqn.2004-10.com.ubuntu:01:79afc2821a9
882s         IP Address: 127.0.0.1
882s + iscsiadm --mode session -P 1
882s Target: iqn.2016-11.foo.com:target.iscsi (non-flash)
882s 	Current Portal: 127.0.0.1:3260,1
882s 	Persistent Portal: 127.0.0.1:3260,1
882s 		**********
882s 		Interface:
882s 		**********
883s 		Iface Name: default
883s 		Iface Transport: tcp
883s 		Iface Initiatorname: iqn.2004-10.com.ubuntu:01:79afc2821a9
883s 		Iface IPaddress: 127.0.0.1
883s 		Iface HWaddress: default
883s 		Iface Netdev: default
883s 		SID: 1
883s 		iSCSI Connection State: LOGGED IN
883s 		iSCSI Session State: LOGGED_IN
883s 		Internal iscsid Session State: NO CHANGE
883s 
883s 		**********
883s 		Interface:
883s 		**********
883s 		Iface Name: default
883s 		Iface Transport: tcp
883s 		Iface Initiatorname: iqn.2004-10.com.ubuntu:01:79afc2821a9
883s 		Iface IPaddress: 127.0.0.1
883s 		Iface HWaddress: default
883s 		Iface Netdev: default
883s 		SID: 2
883s 		iSCSI Connection State: LOGGED IN
883s 		iSCSI Session State: LOGGED_IN
883s 		Internal iscsid Session State: NO CHANGE
883s 
883s 		**********
883s 		Interface:
883s 		**********
883s 		Iface Name: default
883s 		Iface Transport: tcp
883s 		Iface Initiatorname: iqn.2004-10.com.ubuntu:01:79afc2821a9
883s 		Iface IPaddress: 127.0.0.1
883s 		Iface HWaddress: default
883s 		Iface Netdev: default
883s 		SID: 3
883s 		iSCSI Connection State: LOGGED IN
883s 		iSCSI Session State: LOGGED_IN
883s 		Internal iscsid Session State: NO CHANGE
883s 
883s 		**********
883s 		Interface:
883s 		**********
883s 		Iface Name: default
883s 		Iface Transport: tcp
883s 		Iface Initiatorname: iqn.2004-10.com.ubuntu:01:79afc2821a9
883s 		Iface IPaddress: 127.0.0.1
883s 		Iface HWaddress: default
883s 		Iface Netdev: default
883s 		SID: 4
883s 		iSCSI Connection State: LOGGED IN
883s 		iSCSI Session State: LOGGED_IN
883s 		Internal iscsid Session State: NO CHANGE
883s + lsscsi -liv
883s [0:0:0:0]    disk    QEMU     QEMU HARDDISK    2.5+  /dev/sda   0QEMU_QEMU_HARDDISK_drive-scsi0-0-0-0
883s   state=running queue_depth=128 scsi_level=6 type=0 device_blocked=0 timeout=30
883s   dir: /sys/bus/scsi/devices/0:0:0:0  [/sys/devices/pci0000:00/0000:00:02.0/virtio1/host0/target0:0:0/0:0:0:0]
883s [1:0:0:0]    storage IET      Controller       0001  -          -
883s   state=running queue_depth=32 scsi_level=6 type=12 device_blocked=0 timeout=30
883s   dir: /sys/bus/scsi/devices/1:0:0:0  [/sys/devices/platform/host1/session1/target1:0:0/1:0:0:0]
883s [1:0:0:1]    disk    IET      VIRTUAL-DISK     0001  /dev/sdb   360000000000000000e00000000010001
883s   state=running queue_depth=32 scsi_level=6 type=0 device_blocked=0 timeout=30
883s   dir: /sys/bus/scsi/devices/1:0:0:1  [/sys/devices/platform/host1/session1/target1:0:0/1:0:0:1]
883s [2:0:0:0]    storage IET      Controller       0001  -          -
883s   state=running queue_depth=32 scsi_level=6 type=12 device_blocked=0 timeout=30
883s   dir: /sys/bus/scsi/devices/2:0:0:0  [/sys/devices/platform/host2/session2/target2:0:0/2:0:0:0]
883s [2:0:0:1]    disk    IET      VIRTUAL-DISK     0001  /dev/sdc   360000000000000000e00000000010001
883s   state=running queue_depth=32 scsi_level=6 type=0 device_blocked=0 timeout=30
883s   dir: /sys/bus/scsi/devices/2:0:0:1  [/sys/devices/platform/host2/session2/target2:0:0/2:0:0:1]
883s [3:0:0:0]    storage IET      Controller       0001  -          -
883s   state=running queue_depth=32 scsi_level=6 type=12 device_blocked=0 timeout=30
883s   dir: /sys/bus/scsi/devices/3:0:0:0  [/sys/devices/platform/host3/session3/target3:0:0/3:0:0:0]
883s [3:0:0:1]    disk    IET      VIRTUAL-DISK     0001  /dev/sdd   360000000000000000e00000000010001
883s   state=running queue_depth=32 scsi_level=6 type=0 device_blocked=0 timeout=30
883s   dir: /sys/bus/scsi/devices/3:0:0:1  [/sys/devices/platform/host3/session3/target3:0:0/3:0:0:1]
883s [4:0:0:0]    storage IET      Controller       0001  -          -
883s   state=running queue_depth=32 scsi_level=6 type=12 device_blocked=0 timeout=30
883s   dir: /sys/bus/scsi/devices/4:0:0:0  [/sys/devices/platform/host4/session4/target4:0:0/4:0:0:0]
883s [4:0:0:1]    disk    IET      VIRTUAL-DISK     0001  /dev/sde   33000000100000001
883s   state=running queue_depth=32 scsi_level=6 type=0 device_blocked=0 timeout=30
883s   dir: /sys/bus/scsi/devices/4:0:0:1  [/sys/devices/platform/host4/session4/target4:0:0/4:0:0:1]
883s NVMe module may not be loaded
883s ===== paths list =====
883s uuid hcil    dev dev_t pri dm_st chk_st vend/prod/rev           dev_st 
883s      0:0:0:0 sda 8:0   -1  undef undef  QEMU,QEMU HARDDISK,2.5+ unknown
883s      1:0:0:1 sdb 8:16  -1  undef undef  IET,VIRTUAL-DISK,0001   unknown
883s      2:0:0:1 sdc 8:32  -1  undef undef  IET,VIRTUAL-DISK,0001   unknown
883s      3:0:0:1 sdd 8:48  -1  undef undef  IET,VIRTUAL-DISK,0001   unknown
883s      4:0:0:1 sde 8:64  -1  undef undef  IET,VIRTUAL-DISK,0001   unknown
883s mpatha (360000000000000000e00000000010001) dm-0 IET,VIRTUAL-DISK
883s size=100M features='0' hwhandler='0' wp=rw
883s |-+- policy='service-time 0' prio=1 status=active
883s | `- 1:0:0:1 sdb 8:16 active ready running
883s |-+- policy='service-time 0' prio=1 status=enabled
883s | `- 2:0:0:1 sdc 8:32 active ready running
883s |-+- policy='service-time 0' prio=1 status=enabled
883s | `- 3:0:0:1 sdd 8:48 active ready running
883s `-+- policy='service-time 0' prio=1 status=enabled
883s   `- 4:0:0:1 sde 8:64 active ready running
883s mpatha: 0 204800 multipath 0 0 4 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 service-time 0 1 2 8:64 1 1 
883s /etc/multipath/bindings:# Multipath bindings, Version : 1.0
883s /etc/multipath/bindings:# NOTE: this file is automatically maintained by the multipath program.
883s /etc/multipath/bindings:# You should not need to edit this file in normal circumstances.
883s /etc/multipath/bindings:#
883s /etc/multipath/bindings:# Format:
883s /etc/multipath/bindings:# alias wwid
883s /etc/multipath/bindings:#
883s /etc/multipath/bindings:mpatha 360000000000000000e00000000010001
883s /etc/multipath/wwids:/360000000000000000e00000000010001/
883s ● multipathd.service - Device-Mapper Multipath Device Controller
883s      Loaded: loaded (/usr/lib/systemd/system/multipathd.service; enabled; preset: enabled)
883s      Active: active (running) since Mon 2024-08-26 09:23:38 UTC; 2min 42s ago
883s  Invocation: 307ae97368f4449db98bd5a7530f85c0
883s TriggeredBy: ○ multipathd.socket
883s    Main PID: 339 (multipathd)
883s      Status: "up"
883s       Tasks: 7
883s      Memory: 27.5M (peak: 35.1M)
883s         CPU: 64ms
883s      CGroup: /system.slice/multipathd.service
883s              └─339 /sbin/multipathd -d -s
883s 
883s Aug 26 09:23:38 autopkgtest systemd[1]: Starting multipathd.service - Device-Mapper Multipath Device Controller...
883s Aug 26 09:23:38 autopkgtest multipathd[339]: multipathd v0.9.9: start up
883s Aug 26 09:23:38 autopkgtest multipathd[339]: reconfigure: setting up paths and maps
883s Aug 26 09:23:38 autopkgtest systemd[1]: Started multipathd.service - Device-Mapper Multipath Device Controller.
883s Aug 26 09:26:15 autopkgtest multipathd[339]: updated bindings file /etc/multipath/bindings
883s Aug 26 09:26:15 autopkgtest multipathd[339]: mpatha: addmap [0 204800 multipath 0 0 1 1 service-time 0 1 1 8:16 1]
883s Aug 26 09:26:15 autopkgtest multipathd[339]: sdb [8:16]: path added to devmap mpatha
883s Aug 26 09:26:15 autopkgtest multipathd[339]: mpatha: performing delayed actions
883s Aug 26 09:26:15 autopkgtest multipathd[339]: mpatha: reload [0 204800 multipath 0 0 4 1 service-time 0 1 1 8:16 1 service-time 0 1 1 8:32 1 service-time 0 1 1 8:48 1 service-time 0 1 1 8:64 1]
883s ○ multipathd.socket - multipathd control socket
883s      Loaded: loaded (/usr/lib/systemd/system/multipathd.socket; static)
883s      Active: inactive (dead)
883s    Triggers: ● multipathd.service
883s      Listen: @/org/kernel/linux/storage/multipathd (Stream)
883s list_ndevices: scandir: /sys/class/nvme/: No such file or directory
883s + multipath -v3 -ll
883s 166.533458 | set open fds limit to 1073741816/1073741816
883s 166.533537 | _read_bindings_file: reading /etc/multipath/bindings
883s 166.533570 | loading /usr/lib/multipath/libchecktur.so checker
883s 166.533679 | checker tur: message table size = 4
883s 166.533702 | loading /usr/lib/multipath/libprioconst.so prioritizer
883s 166.533821 | _init_foreign: foreign library "nvme" is not enabled
883s 166.539380 | sda: size = 167772160
883s 166.539547 | sda: vendor = QEMU
883s 166.539587 | sda: product = QEMU HARDDISK
883s 166.539610 | sda: rev = 2.5+
883s 166.540241 | sda: h:b:t:l = 0:0:0:0
883s 166.540550 | sda: tgt_node_name = 
883s 166.540569 | sda: uid_attribute = ID_SERIAL (setting: multipath internal)
883s 166.540573 | sda: recheck_wwid = 1 (setting: multipath.conf defaults/devices section)
883s 166.540727 | sda: 10443 cyl, 255 heads, 63 sectors/track, start at 0
883s 166.540747 | sda: vpd_vendor_id = 0 "undef" (setting: multipath internal)
883s 166.540761 | __sysfs_attr_get_value: attribute '/sys/devices/pci0000:00/0000:00:02.0/virtio1/host0/target0:0:0/0:0:0:0/vpd_pg80' cannot be opened: No such file or directory
883s 166.540766 | failed to read sysfs vpd pg80: No such file or directory
883s 166.541027 | sda: fail to get serial
883s 166.541046 | sda: detect_checker = yes (setting: multipath internal)
883s 166.541080 | sda checker timeout = 30 s (setting: kernel sysfs)
883s 166.541244 | sda: path_checker = tur (setting: multipath internal)
883s 166.541403 | sda: tur state = up
883s 166.541708 | sdb: size = 204800
883s 166.541853 | sdb: vendor = IET
883s 166.541890 | sdb: product = VIRTUAL-DISK
883s 166.541912 | sdb: rev = 0001
883s 166.542508 | sdb: h:b:t:l = 1:0:0:1
883s 166.542874 | sdb: tgt_node_name = iqn.2016-11.foo.com:target.iscsi
883s 166.542892 | sdb: uid_attribute = ID_SERIAL (setting: multipath internal)
883s 166.542894 | sdb: recheck_wwid = 1 (setting: multipath.conf defaults/devices section)
883s 166.543046 | sdb: 1024 cyl, 4 heads, 50 sectors/track, start at 0
883s 166.543065 | sdb: vpd_vendor_id = 0 "undef" (setting: multipath internal)
883s 166.543079 | sdb: serial = beaf11
883s 166.543082 | sdb: detect_checker = yes (setting: multipath internal)
883s 166.543108 | sdb checker timeout = 30 s (setting: kernel sysfs)
883s 166.543463 | sdb: path_checker = tur (setting: multipath internal)
883s 166.543636 | sdb: tur state = up
883s 166.543773 | sdc: size = 204800
883s 166.543917 | sdc: vendor = IET
883s 166.543954 | sdc: product = VIRTUAL-DISK
883s 166.543975 | sdc: rev = 0001
883s 166.544630 | sdc: h:b:t:l = 2:0:0:1
883s 166.545011 | sdc: tgt_node_name = iqn.2016-11.foo.com:target.iscsi
883s 166.545030 | sdc: uid_attribute = ID_SERIAL (setting: multipath internal)
883s 166.545032 | sdc: recheck_wwid = 1 (setting: multipath.conf defaults/devices section)
883s 166.545173 | sdc: 1024 cyl, 4 heads, 50 sectors/track, start at 0
883s 166.545192 | sdc: vpd_vendor_id = 0 "undef" (setting: multipath internal)
883s 166.545205 | sdc: serial = beaf11
883s 166.545208 | sdc: detect_checker = yes (setting: multipath internal)
883s 166.545235 | sdc checker timeout = 30 s (setting: kernel sysfs)
883s 166.545447 | sdc: path_checker = tur (setting: multipath internal)
883s 166.545608 | sdc: tur state = up
883s 166.545749 | sdd: size = 204800
883s 166.545894 | sdd: vendor = IET
883s 166.545931 | sdd: product = VIRTUAL-DISK
883s 166.545952 | sdd: rev = 0001
883s 166.546610 | sdd: h:b:t:l = 3:0:0:1
883s 166.546962 | sdd: tgt_node_name = iqn.2016-11.foo.com:target.iscsi
883s 166.546980 | sdd: uid_attribute = ID_SERIAL (setting: multipath internal)
883s 166.546983 | sdd: recheck_wwid = 1 (setting: multipath.conf defaults/devices section)
883s 166.547130 | sdd: 1024 cyl, 4 heads, 50 sectors/track, start at 0
883s 166.547149 | sdd: vpd_vendor_id = 0 "undef" (setting: multipath internal)
883s 166.547162 | sdd: serial = beaf11
883s 166.547164 | sdd: detect_checker = yes (setting: multipath internal)
883s 166.547199 | sdd checker timeout = 30 s (setting: kernel sysfs)
883s 166.547409 | sdd: path_checker = tur (setting: multipath internal)
883s 166.547576 | sdd: tur state = up
883s 166.547716 | sde: size = 204800
883s 166.547862 | sde: vendor = IET
883s 166.547900 | sde: product = VIRTUAL-DISK
883s 166.547922 | sde: rev = 0001
883s 166.548587 | sde: h:b:t:l = 4:0:0:1
883s 166.548973 | sde: tgt_node_name = iqn.2016-11.foo.com:target.iscsi
883s 166.548992 | sde: uid_attribute = ID_SERIAL (setting: multipath internal)
883s 166.548994 | sde: recheck_wwid = 1 (setting: multipath.conf defaults/devices section)
883s 166.549138 | sde: 1024 cyl, 4 heads, 50 sectors/track, start at 0
883s 166.549157 | sde: vpd_vendor_id = 0 "undef" (setting: multipath internal)
883s 166.549170 | sde: serial = beaf11
883s 166.549173 | sde: detect_checker = yes (setting: multipath internal)
883s 166.549199 | sde checker timeout = 30 s (setting: kernel sysfs)
883s 166.549306 | sde: path_checker = tur (setting: multipath internal)
883s 166.549458 | sde: tur state = up
883s 166.549562 | loop0: device node name blacklisted
883s 166.549662 | loop1: device node name blacklisted
883s 166.549761 | loop2: device node name blacklisted
883s 166.549857 | loop3: device node name blacklisted
883s 166.549937 | loop4: device node name blacklisted
883s 166.550015 | loop5: device node name blacklisted
883s 166.550111 | loop6: device node name blacklisted
883s 166.550206 | loop7: device node name blacklisted
883s 166.550310 | dm-0: device node name blacklisted
883s 166.551451 | multipath-tools v0.9.9 (05/03, 2024)
883s 166.551477 | libdevmapper version 1.02.196
883s 166.551632 | kernel device mapper v4.48.0
883s 166.551662 | DM multipath kernel driver v1.14.0
883s 166.551781 | sdb: size = 204800
883s 166.551801 | sdb: vendor = IET
883s 166.551804 | sdb: product = VIRTUAL-DISK
883s 166.551806 | sdb: rev = 0001
883s 166.552414 | sdb: h:b:t:l = 1:0:0:1
883s 166.552544 | sdb: tgt_node_name = iqn.2016-11.foo.com:target.iscsi
883s 166.552579 | sdb: 1024 cyl, 4 heads, 50 sectors/track, start at 0
883s 166.552581 | sdb: vpd_vendor_id = 0 "undef" (setting: multipath internal)
883s 166.552593 | sdb: serial = beaf11
883s 166.552777 | sdb: tur state = up
883s 166.552796 | sdb: uid = 360000000000000000e00000000010001 (udev)
883s 166.552799 | sdb: detect_prio = yes (setting: multipath internal)
883s 166.552803 | sdb: prio = const (setting: multipath internal)
883s 166.552805 | sdb: prio args = "" (setting: multipath internal)
883s 166.552807 | sdb: const prio = 1
883s 166.552828 | sdc: size = 204800
883s 166.552832 | sdc: vendor = IET
883s 166.552835 | sdc: product = VIRTUAL-DISK
883s 166.552837 | sdc: rev = 0001
883s 166.553421 | sdc: h:b:t:l = 2:0:0:1
883s 166.553544 | sdc: tgt_node_name = iqn.2016-11.foo.com:target.iscsi
883s 166.553578 | sdc: 1024 cyl, 4 heads, 50 sectors/track, start at 0
883s 166.553580 | sdc: vpd_vendor_id = 0 "undef" (setting: multipath internal)
883s 166.553591 | sdc: serial = beaf11
883s 166.553746 | sdc: tur state = up
883s 166.553764 | sdc: uid = 360000000000000000e00000000010001 (udev)
883s 166.553766 | sdc: detect_prio = yes (setting: multipath internal)
883s 166.553769 | sdc: prio = const (setting: multipath internal)
883s 166.553771 | sdc: prio args = "" (setting: multipath internal)
883s 166.553773 | sdc: const prio = 1
883s 166.553794 | sdd: size = 204800
883s 166.553798 | sdd: vendor = IET
883s 166.553800 | sdd: product = VIRTUAL-DISK
883s 166.553804 | sdd: rev = 0001
883s 166.554370 | sdd: h:b:t:l = 3:0:0:1
883s 166.554494 | sdd: tgt_node_name = iqn.2016-11.foo.com:target.iscsi
883s 166.554529 | sdd: 1024 cyl, 4 heads, 50 sectors/track, start at 0
883s 166.554531 | sdd: vpd_vendor_id = 0 "undef" (setting: multipath internal)
883s 166.554542 | sdd: serial = beaf11
883s 166.554653 | sdd: tur state = up
883s 166.554671 | sdd: uid = 360000000000000000e00000000010001 (udev)
883s 166.554673 | sdd: detect_prio = yes (setting: multipath internal)
883s 166.554676 | sdd: prio = const (setting: multipath internal)
883s 166.554678 | sdd: prio args = "" (setting: multipath internal)
883s 166.554680 | sdd: const prio = 1
883s 166.554701 | sde: size = 204800
883s 166.554705 | sde: vendor = IET
883s 166.554707 | sde: product = VIRTUAL-DISK
883s 166.554709 | sde: rev = 0001
883s 166.555273 | sde: h:b:t:l = 4:0:0:1
883s 166.555396 | sde: tgt_node_name = iqn.2016-11.foo.com:target.iscsi
883s 166.555430 | sde: 1024 cyl, 4 heads, 50 sectors/track, start at 0
883s 166.555433 | sde: vpd_vendor_id = 0 "undef" (setting: multipath internal)
883s 166.555444 | sde: serial = beaf11
883s 166.555598 | sde: tur state = up
883s 166.555616 | sde: uid = 360000000000000000e00000000010001 (udev)
883s 166.555618 | sde: detect_prio = yes (setting: multipath internal)
883s 166.555621 | sde: prio = const (setting: multipath internal)
883s 166.555623 | sde: prio args = "" (setting: multipath internal)
883s 166.555625 | sde: const prio = 1
883s 166.556635 | unloading tur checker
883s 166.556741 | unloading const prioritizer
883s + dmsetup table
883s + grep . /etc/multipath/bindings /etc/multipath/wwids
883s + systemctl status multipathd.service
883s + systemctl status multipathd.socket
883s autopkgtest [09:26:23]: test tgtbasedmpaths: -----------------------]
889s autopkgtest [09:26:29]: test tgtbasedmpaths:  - - - - - - - - - - results - - - - - - - - - -
889s tgtbasedmpaths       FAIL non-zero exit status 3
898s autopkgtest [09:26:38]: @@@@@@@@@@@@@@@@@@@@ summary
898s initramfs            SKIP Test lists explicitly supported architectures, but the current architecture ppc64el isn't listed.
898s initramfs            SKIP Test lists explicitly supported architectures, but the current architecture ppc64el isn't listed.
898s kpartx-file-loopback PASS
898s tgtbasedmpaths       FAIL non-zero exit status 3
919s nova [W] Using flock in scalingstack-bos02-ppc64el
919s Creating nova instance adt-oracular-ppc64el-multipath-tools-20240826-091140-juju-7f2275-prod-proposed-migration-environment-3-208292d9-8c11-4b0e-9ec1-3e2bd5d72ec9 from image adt/ubuntu-oracular-ppc64el-server-20240826.img (UUID d6a989c0-b614-44d6-b43e-8efec8e9947a)...
919s nova [W] Using flock in scalingstack-bos02-ppc64el
919s Creating nova instance adt-oracular-ppc64el-multipath-tools-20240826-091140-juju-7f2275-prod-proposed-migration-environment-3-208292d9-8c11-4b0e-9ec1-3e2bd5d72ec9 from image adt/ubuntu-oracular-ppc64el-server-20240826.img (UUID d6a989c0-b614-44d6-b43e-8efec8e9947a)...