0s autopkgtest [10:28:31]: starting date and time: 2024-08-31 10:28:31+0000
  0s autopkgtest [10:28:31]: git checkout: fd3bed09 nova: allow more retries for quota issues
  0s autopkgtest [10:28:31]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.vbwfpvq1/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-5.5 linux/6.11.0-5.5' --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-2@bos03-ppc64el-22.secgroup --name adt-oracular-ppc64el-multipath-tools-20240831-102831-juju-7f2275-prod-proposed-migration-environment-2-67cd8263-bba4-4572-9983-8e9ab60846f1 --image adt/ubuntu-oracular-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration-ppc64el -e TERM=linux -e ''"'"'http_proxy=http://squid.internal:3128'"'"'' -e ''"'"'https_proxy=http://squid.internal:3128'"'"'' -e ''"'"'no_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/
 59s autopkgtest [10:29:30]: testbed dpkg architecture: ppc64el
 59s autopkgtest [10:29:30]: testbed apt version: 2.9.8
 59s autopkgtest [10:29:30]: @@@@@@@@@@@@@@@@@@@@ test bed setup
 60s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [126 kB]
 60s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [719 kB]
 60s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [8372 B]
 60s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [45.7 kB]
 60s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [11.1 kB]
 60s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el Packages [55.2 kB]
 60s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el c-n-f Metadata [1444 B]
 60s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/restricted ppc64el Packages [1376 B]
 60s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/restricted ppc64el c-n-f Metadata [120 B]
 60s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/universe ppc64el Packages [660 kB]
 60s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/universe ppc64el c-n-f Metadata [18.1 kB]
 60s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse ppc64el Packages [5956 B]
 61s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse ppc64el c-n-f Metadata [372 B]
 64s Fetched 1653 kB in 1s (1830 kB/s)
 64s Reading package lists...
 66s Reading package lists...
 66s Building dependency tree...
 66s Reading state information...
 67s Calculating upgrade...
 67s The following NEW packages will be installed:
 67s   libpython3.12t64 linux-headers-6.11.0-5 linux-headers-6.11.0-5-generic
 67s   linux-image-6.11.0-5-generic linux-modules-6.11.0-5-generic
 67s   linux-modules-extra-6.11.0-5-generic linux-tools-6.11.0-5
 67s   linux-tools-6.11.0-5-generic
 67s The following packages will be upgraded:
 67s   linux-firmware linux-generic linux-headers-generic linux-headers-virtual
 67s   linux-image-generic linux-image-virtual linux-libc-dev linux-tools-common
 67s   linux-virtual
 67s 9 upgraded, 8 newly installed, 0 to remove and 0 not upgraded.
 67s Need to get 722 MB of archives.
 67s After this operation, 343 MB of additional disk space will be used.
 67s Get:1 http://ftpmaster.internal/ubuntu oracular/main ppc64el libpython3.12t64 ppc64el 3.12.5-4 [2560 kB]
 68s Get:2 http://ftpmaster.internal/ubuntu oracular/main ppc64el linux-firmware ppc64el 20240826.git2cdc11a7-0ubuntu2 [494 MB]
 91s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-modules-6.11.0-5-generic ppc64el 6.11.0-5.5 [32.8 MB]
 92s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-image-6.11.0-5-generic ppc64el 6.11.0-5.5 [63.9 MB]
 95s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-modules-extra-6.11.0-5-generic ppc64el 6.11.0-5.5 [105 MB]
101s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-generic ppc64el 6.11.0-5.5 [1730 B]
101s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-image-generic ppc64el 6.11.0-5.5 [10.6 kB]
101s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-virtual ppc64el 6.11.0-5.5 [1718 B]
101s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-image-virtual ppc64el 6.11.0-5.5 [10.6 kB]
101s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-headers-virtual ppc64el 6.11.0-5.5 [1638 B]
101s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-headers-6.11.0-5 all 6.11.0-5.5 [13.9 MB]
102s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-headers-6.11.0-5-generic ppc64el 6.11.0-5.5 [3948 kB]
102s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-headers-generic ppc64el 6.11.0-5.5 [10.5 kB]
102s Get:14 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-libc-dev ppc64el 6.11.0-5.5 [1649 kB]
102s Get:15 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-tools-common all 6.11.0-5.5 [479 kB]
102s Get:16 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-tools-6.11.0-5 ppc64el 6.11.0-5.5 [4201 kB]
103s Get:17 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-tools-6.11.0-5-generic ppc64el 6.11.0-5.5 [1736 B]
103s Fetched 722 MB in 36s (20.0 MB/s)
103s Selecting previously unselected package libpython3.12t64:ppc64el.
105s (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 ... 72412 files and directories currently installed.)
105s Preparing to unpack .../00-libpython3.12t64_3.12.5-4_ppc64el.deb ...
105s Unpacking libpython3.12t64:ppc64el (3.12.5-4) ...
105s Preparing to unpack .../01-linux-firmware_20240826.git2cdc11a7-0ubuntu2_ppc64el.deb ...
105s Unpacking linux-firmware (20240826.git2cdc11a7-0ubuntu2) over (20240826.git2cdc11a7-0ubuntu1) ...
110s Selecting previously unselected package linux-modules-6.11.0-5-generic.
110s Preparing to unpack .../02-linux-modules-6.11.0-5-generic_6.11.0-5.5_ppc64el.deb ...
110s Unpacking linux-modules-6.11.0-5-generic (6.11.0-5.5) ...
110s Selecting previously unselected package linux-image-6.11.0-5-generic.
110s Preparing to unpack .../03-linux-image-6.11.0-5-generic_6.11.0-5.5_ppc64el.deb ...
110s Unpacking linux-image-6.11.0-5-generic (6.11.0-5.5) ...
110s Selecting previously unselected package linux-modules-extra-6.11.0-5-generic.
110s Preparing to unpack .../04-linux-modules-extra-6.11.0-5-generic_6.11.0-5.5_ppc64el.deb ...
110s Unpacking linux-modules-extra-6.11.0-5-generic (6.11.0-5.5) ...
111s Preparing to unpack .../05-linux-generic_6.11.0-5.5_ppc64el.deb ...
111s Unpacking linux-generic (6.11.0-5.5) over (6.8.0-31.31) ...
111s Preparing to unpack .../06-linux-image-generic_6.11.0-5.5_ppc64el.deb ...
111s Unpacking linux-image-generic (6.11.0-5.5) over (6.8.0-31.31) ...
111s Preparing to unpack .../07-linux-virtual_6.11.0-5.5_ppc64el.deb ...
111s Unpacking linux-virtual (6.11.0-5.5) over (6.8.0-31.31) ...
111s Preparing to unpack .../08-linux-image-virtual_6.11.0-5.5_ppc64el.deb ...
111s Unpacking linux-image-virtual (6.11.0-5.5) over (6.8.0-31.31) ...
111s Preparing to unpack .../09-linux-headers-virtual_6.11.0-5.5_ppc64el.deb ...
111s Unpacking linux-headers-virtual (6.11.0-5.5) over (6.8.0-31.31) ...
111s Selecting previously unselected package linux-headers-6.11.0-5.
111s Preparing to unpack .../10-linux-headers-6.11.0-5_6.11.0-5.5_all.deb ...
111s Unpacking linux-headers-6.11.0-5 (6.11.0-5.5) ...
114s Selecting previously unselected package linux-headers-6.11.0-5-generic.
114s Preparing to unpack .../11-linux-headers-6.11.0-5-generic_6.11.0-5.5_ppc64el.deb ...
114s Unpacking linux-headers-6.11.0-5-generic (6.11.0-5.5) ...
115s Preparing to unpack .../12-linux-headers-generic_6.11.0-5.5_ppc64el.deb ...
115s Unpacking linux-headers-generic (6.11.0-5.5) over (6.8.0-31.31) ...
115s Preparing to unpack .../13-linux-libc-dev_6.11.0-5.5_ppc64el.deb ...
115s Unpacking linux-libc-dev:ppc64el (6.11.0-5.5) over (6.8.0-31.31) ...
115s Preparing to unpack .../14-linux-tools-common_6.11.0-5.5_all.deb ...
115s Unpacking linux-tools-common (6.11.0-5.5) over (6.8.0-31.31) ...
115s Selecting previously unselected package linux-tools-6.11.0-5.
115s Preparing to unpack .../15-linux-tools-6.11.0-5_6.11.0-5.5_ppc64el.deb ...
115s Unpacking linux-tools-6.11.0-5 (6.11.0-5.5) ...
115s Selecting previously unselected package linux-tools-6.11.0-5-generic.
115s Preparing to unpack .../16-linux-tools-6.11.0-5-generic_6.11.0-5.5_ppc64el.deb ...
115s Unpacking linux-tools-6.11.0-5-generic (6.11.0-5.5) ...
116s Setting up linux-firmware (20240826.git2cdc11a7-0ubuntu2) ...
116s Setting up linux-libc-dev:ppc64el (6.11.0-5.5) ...
116s Setting up libpython3.12t64:ppc64el (3.12.5-4) ...
116s Setting up linux-modules-6.11.0-5-generic (6.11.0-5.5) ...
118s Setting up linux-modules-extra-6.11.0-5-generic (6.11.0-5.5) ...
120s Setting up linux-headers-6.11.0-5 (6.11.0-5.5) ...
120s Setting up linux-tools-common (6.11.0-5.5) ...
120s Setting up linux-image-6.11.0-5-generic (6.11.0-5.5) ...
122s I: /boot/vmlinux is now a symlink to vmlinux-6.11.0-5-generic
122s I: /boot/initrd.img is now a symlink to initrd.img-6.11.0-5-generic
122s Setting up linux-headers-6.11.0-5-generic (6.11.0-5.5) ...
122s Setting up linux-headers-generic (6.11.0-5.5) ...
122s Setting up linux-image-virtual (6.11.0-5.5) ...
122s Setting up linux-tools-6.11.0-5 (6.11.0-5.5) ...
122s Setting up linux-image-generic (6.11.0-5.5) ...
122s Setting up linux-headers-virtual (6.11.0-5.5) ...
122s Setting up linux-generic (6.11.0-5.5) ...
122s Setting up linux-tools-6.11.0-5-generic (6.11.0-5.5) ...
122s Setting up linux-virtual (6.11.0-5.5) ...
122s Processing triggers for man-db (2.12.1-3) ...
127s Processing triggers for libc-bin (2.40-1ubuntu1) ...
127s Processing triggers for initramfs-tools (0.142ubuntu32) ...
127s update-initramfs: Generating /boot/initrd.img-6.8.0-31-generic
127s W: No lz4 in /usr/bin:/sbin:/bin, using gzip
140s Processing triggers for linux-image-6.11.0-5-generic (6.11.0-5.5) ...
140s /etc/kernel/postinst.d/initramfs-tools:
140s update-initramfs: Generating /boot/initrd.img-6.11.0-5-generic
140s W: No lz4 in /usr/bin:/sbin:/bin, using gzip
149s /etc/kernel/postinst.d/zz-update-grub:
149s Sourcing file `/etc/default/grub'
149s Sourcing file `/etc/default/grub.d/50-cloudimg-settings.cfg'
149s Generating grub configuration file ...
150s Found linux image: /boot/vmlinux-6.11.0-5-generic
150s Found initrd image: /boot/initrd.img-6.11.0-5-generic
150s Found linux image: /boot/vmlinux-6.8.0-31-generic
150s Found initrd image: /boot/initrd.img-6.8.0-31-generic
150s Warning: os-prober will not be executed to detect other bootable partitions.
150s Systems on them will not be added to the GRUB boot configuration.
150s Check GRUB_DISABLE_OS_PROBER documentation entry.
150s Adding boot menu entry for UEFI Firmware Settings ...
150s done
151s Reading package lists...
151s Building dependency tree...
151s Reading state information...
151s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
152s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease
152s Hit:2 http://ftpmaster.internal/ubuntu oracular InRelease
152s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease
152s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease
153s Reading package lists...
153s Reading package lists...
153s Building dependency tree...
153s Reading state information...
153s Calculating upgrade...
153s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
153s Reading package lists...
153s Building dependency tree...
153s Reading state information...
154s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
154s Reading package lists...
154s Building dependency tree...
154s Reading state information...
154s linux-generic is already the newest version (6.11.0-5.5).
154s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
154s Reading package lists...
155s Building dependency tree...
155s Reading state information...
155s E: Unable to locate package ^kernel-testing--linux--modules-extra--preferred$
155s E: Couldn't find any package by regex '^kernel-testing--linux--modules-extra--preferred$'
155s Reading package lists...
155s Building dependency tree...
155s Reading state information...
155s E: Unable to locate package ^linux-modules-extra$
155s E: Couldn't find any package by regex '^linux-modules-extra$'
155s autopkgtest [10:31:06]: rebooting testbed after setup commands that affected boot
159s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds...
192s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds...
200s autopkgtest [10:31:51]: testbed running kernel: Linux 6.11.0-5-generic #5-Ubuntu SMP Mon Aug 26 21:16:43 UTC 2024
202s autopkgtest [10:31:53]: @@@@@@@@@@@@@@@@@@@@ apt-source multipath-tools
207s Get:1 http://ftpmaster.internal/ubuntu oracular/main multipath-tools 0.9.9-1ubuntu2 (dsc) [2772 B]
207s Get:2 http://ftpmaster.internal/ubuntu oracular/main multipath-tools 0.9.9-1ubuntu2 (tar) [588 kB]
207s Get:3 http://ftpmaster.internal/ubuntu oracular/main multipath-tools 0.9.9-1ubuntu2 (diff) [42.4 kB]
208s gpgv: Signature made Tue Jul 23 21:24:22 2024 UTC
208s gpgv:                using RSA key D09F8A854F1055BCFC482C4B23566B906047AFC8
208s gpgv: Can't check signature: No public key
208s dpkg-source: warning: cannot verify inline signature for ./multipath-tools_0.9.9-1ubuntu2.dsc: no acceptable signature found
208s autopkgtest [10:31:59]: testing package multipath-tools version 0.9.9-1ubuntu2
208s initramfs            SKIP Test lists explicitly supported architectures, but the current architecture ppc64el isn't listed.
208s autopkgtest [10:31:59]: build not needed
209s initramfs            SKIP Test lists explicitly supported architectures, but the current architecture ppc64el isn't listed.
209s autopkgtest [10:32:00]: test kpartx-file-loopback: preparing testbed
210s Reading package lists...
210s Building dependency tree...
210s Reading state information...
210s Starting pkgProblemResolver with broken count: 0
210s Starting 2 pkgProblemResolver with broken count: 0
210s Done
210s The following additional packages will be installed:
210s   liburing2 qemu-utils
210s Recommended packages:
210s   qemu-block-extra
210s The following NEW packages will be installed:
210s   autopkgtest-satdep liburing2 qemu-utils
210s 0 upgraded, 3 newly installed, 0 to remove and 0 not upgraded.
210s Need to get 2432 kB/2433 kB of archives.
210s After this operation, 16.9 MB of additional disk space will be used.
210s Get:1 /tmp/autopkgtest.DWbgRx/1-autopkgtest-satdep.deb autopkgtest-satdep ppc64el 0 [720 B]
211s Get:2 http://ftpmaster.internal/ubuntu oracular/main ppc64el liburing2 ppc64el 2.6-1 [26.9 kB]
211s Get:3 http://ftpmaster.internal/ubuntu oracular/main ppc64el qemu-utils ppc64el 1:9.0.2+ds-4ubuntu2 [2405 kB]
212s Fetched 2432 kB in 1s (3506 kB/s)
212s Selecting previously unselected package liburing2:ppc64el.
213s (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 ... 109816 files and directories currently installed.)
213s Preparing to unpack .../liburing2_2.6-1_ppc64el.deb ...
213s Unpacking liburing2:ppc64el (2.6-1) ...
213s Selecting previously unselected package qemu-utils.
213s Preparing to unpack .../qemu-utils_1%3a9.0.2+ds-4ubuntu2_ppc64el.deb ...
213s Unpacking qemu-utils (1:9.0.2+ds-4ubuntu2) ...
213s Selecting previously unselected package autopkgtest-satdep.
213s Preparing to unpack .../1-autopkgtest-satdep.deb ...
213s Unpacking autopkgtest-satdep (0) ...
213s Setting up liburing2:ppc64el (2.6-1) ...
213s Setting up qemu-utils (1:9.0.2+ds-4ubuntu2) ...
213s Setting up autopkgtest-satdep (0) ...
213s Processing triggers for man-db (2.12.1-3) ...
219s Processing triggers for libc-bin (2.40-1ubuntu1) ...
223s (Reading database ... 109840 files and directories currently installed.)
223s Removing autopkgtest-satdep (0) ...
224s autopkgtest [10:32:15]: test kpartx-file-loopback: [-----------------------
224s Formatting 'foo.img', fmt=raw size=20971520
225s Creating new GPT entries in memory.
225s Warning: The kernel is still using the old partition table.
225s The new table will be used at the next reboot or after you
225s run partprobe(8) or kpartx(8)
225s The operation has completed successfully.
225s add map loop0p1 (252:0): 0 38879 linear 7:0 2048
225s standard_filename: OK
225s del devmap : loop0p1
225s No devices found
225s standard_filename_cleanup: OK
225s Formatting 'fou du FaFa.img', fmt=raw size=20971520
226s Creating new GPT entries in memory.
226s Warning: The kernel is still using the old partition table.
226s The new table will be used at the next reboot or after you
226s run partprobe(8) or kpartx(8)
226s The operation has completed successfully.
226s add map loop0p1 (252:0): 0 38879 linear 7:0 2048
226s filename_with_spaces: OK
226s del devmap : loop0p1
226s No devices found
226s filename_with_spaces_cleanup: OK
227s autopkgtest [10:32:18]: test kpartx-file-loopback: -----------------------]
227s autopkgtest [10:32:18]: test kpartx-file-loopback:  - - - - - - - - - - results - - - - - - - - - -
227s kpartx-file-loopback PASS
228s autopkgtest [10:32:19]: test tgtbasedmpaths: preparing testbed
291s autopkgtest [10:33:22]: testbed dpkg architecture: ppc64el
291s autopkgtest [10:33:22]: testbed apt version: 2.9.8
291s autopkgtest [10:33:22]: @@@@@@@@@@@@@@@@@@@@ test bed setup
292s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [126 kB]
293s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [8372 B]
293s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [45.7 kB]
293s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [719 kB]
293s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [11.1 kB]
293s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el Packages [55.2 kB]
293s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el c-n-f Metadata [1444 B]
293s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/restricted ppc64el Packages [1376 B]
293s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/restricted ppc64el c-n-f Metadata [120 B]
293s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/universe ppc64el Packages [656 kB]
293s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/universe ppc64el c-n-f Metadata [18.1 kB]
293s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse ppc64el Packages [5956 B]
293s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse ppc64el c-n-f Metadata [372 B]
296s Fetched 1648 kB in 1s (1609 kB/s)
296s Reading package lists...
299s Reading package lists...
299s Building dependency tree...
299s Reading state information...
299s Calculating upgrade...
299s The following NEW packages will be installed:
299s   libpython3.12t64 linux-headers-6.11.0-5 linux-headers-6.11.0-5-generic
299s   linux-image-6.11.0-5-generic linux-modules-6.11.0-5-generic
299s   linux-modules-extra-6.11.0-5-generic linux-tools-6.11.0-5
299s   linux-tools-6.11.0-5-generic
299s The following packages will be upgraded:
299s   linux-firmware linux-generic linux-headers-generic linux-headers-virtual
299s   linux-image-generic linux-image-virtual linux-libc-dev linux-tools-common
299s   linux-virtual
299s 9 upgraded, 8 newly installed, 0 to remove and 0 not upgraded.
299s Need to get 722 MB of archives.
299s After this operation, 343 MB of additional disk space will be used.
299s Get:1 http://ftpmaster.internal/ubuntu oracular/main ppc64el libpython3.12t64 ppc64el 3.12.5-4 [2560 kB]
300s Get:2 http://ftpmaster.internal/ubuntu oracular/main ppc64el linux-firmware ppc64el 20240826.git2cdc11a7-0ubuntu2 [494 MB]
333s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-modules-6.11.0-5-generic ppc64el 6.11.0-5.5 [32.8 MB]
335s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-image-6.11.0-5-generic ppc64el 6.11.0-5.5 [63.9 MB]
339s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-modules-extra-6.11.0-5-generic ppc64el 6.11.0-5.5 [105 MB]
347s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-generic ppc64el 6.11.0-5.5 [1730 B]
347s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-image-generic ppc64el 6.11.0-5.5 [10.6 kB]
347s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-virtual ppc64el 6.11.0-5.5 [1718 B]
347s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-image-virtual ppc64el 6.11.0-5.5 [10.6 kB]
347s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-headers-virtual ppc64el 6.11.0-5.5 [1638 B]
347s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-headers-6.11.0-5 all 6.11.0-5.5 [13.9 MB]
348s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-headers-6.11.0-5-generic ppc64el 6.11.0-5.5 [3948 kB]
348s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-headers-generic ppc64el 6.11.0-5.5 [10.5 kB]
348s Get:14 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-libc-dev ppc64el 6.11.0-5.5 [1649 kB]
349s Get:15 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-tools-common all 6.11.0-5.5 [479 kB]
349s Get:16 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-tools-6.11.0-5 ppc64el 6.11.0-5.5 [4201 kB]
349s Get:17 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el linux-tools-6.11.0-5-generic ppc64el 6.11.0-5.5 [1736 B]
349s Fetched 722 MB in 50s (14.5 MB/s)
349s Selecting previously unselected package libpython3.12t64:ppc64el.
351s (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 ... 72412 files and directories currently installed.)
351s Preparing to unpack .../00-libpython3.12t64_3.12.5-4_ppc64el.deb ...
351s Unpacking libpython3.12t64:ppc64el (3.12.5-4) ...
351s Preparing to unpack .../01-linux-firmware_20240826.git2cdc11a7-0ubuntu2_ppc64el.deb ...
351s Unpacking linux-firmware (20240826.git2cdc11a7-0ubuntu2) over (20240826.git2cdc11a7-0ubuntu1) ...
356s Selecting previously unselected package linux-modules-6.11.0-5-generic.
356s Preparing to unpack .../02-linux-modules-6.11.0-5-generic_6.11.0-5.5_ppc64el.deb ...
356s Unpacking linux-modules-6.11.0-5-generic (6.11.0-5.5) ...
356s Selecting previously unselected package linux-image-6.11.0-5-generic.
356s Preparing to unpack .../03-linux-image-6.11.0-5-generic_6.11.0-5.5_ppc64el.deb ...
356s Unpacking linux-image-6.11.0-5-generic (6.11.0-5.5) ...
356s Selecting previously unselected package linux-modules-extra-6.11.0-5-generic.
356s Preparing to unpack .../04-linux-modules-extra-6.11.0-5-generic_6.11.0-5.5_ppc64el.deb ...
356s Unpacking linux-modules-extra-6.11.0-5-generic (6.11.0-5.5) ...
357s Preparing to unpack .../05-linux-generic_6.11.0-5.5_ppc64el.deb ...
357s Unpacking linux-generic (6.11.0-5.5) over (6.8.0-31.31) ...
357s Preparing to unpack .../06-linux-image-generic_6.11.0-5.5_ppc64el.deb ...
357s Unpacking linux-image-generic (6.11.0-5.5) over (6.8.0-31.31) ...
357s Preparing to unpack .../07-linux-virtual_6.11.0-5.5_ppc64el.deb ...
357s Unpacking linux-virtual (6.11.0-5.5) over (6.8.0-31.31) ...
357s Preparing to unpack .../08-linux-image-virtual_6.11.0-5.5_ppc64el.deb ...
357s Unpacking linux-image-virtual (6.11.0-5.5) over (6.8.0-31.31) ...
357s Preparing to unpack .../09-linux-headers-virtual_6.11.0-5.5_ppc64el.deb ...
357s Unpacking linux-headers-virtual (6.11.0-5.5) over (6.8.0-31.31) ...
357s Selecting previously unselected package linux-headers-6.11.0-5.
357s Preparing to unpack .../10-linux-headers-6.11.0-5_6.11.0-5.5_all.deb ...
357s Unpacking linux-headers-6.11.0-5 (6.11.0-5.5) ...
360s Selecting previously unselected package linux-headers-6.11.0-5-generic.
360s Preparing to unpack .../11-linux-headers-6.11.0-5-generic_6.11.0-5.5_ppc64el.deb ...
360s Unpacking linux-headers-6.11.0-5-generic (6.11.0-5.5) ...
361s Preparing to unpack .../12-linux-headers-generic_6.11.0-5.5_ppc64el.deb ...
361s Unpacking linux-headers-generic (6.11.0-5.5) over (6.8.0-31.31) ...
361s Preparing to unpack .../13-linux-libc-dev_6.11.0-5.5_ppc64el.deb ...
361s Unpacking linux-libc-dev:ppc64el (6.11.0-5.5) over (6.8.0-31.31) ...
362s Preparing to unpack .../14-linux-tools-common_6.11.0-5.5_all.deb ...
362s Unpacking linux-tools-common (6.11.0-5.5) over (6.8.0-31.31) ...
362s Selecting previously unselected package linux-tools-6.11.0-5.
362s Preparing to unpack .../15-linux-tools-6.11.0-5_6.11.0-5.5_ppc64el.deb ...
362s Unpacking linux-tools-6.11.0-5 (6.11.0-5.5) ...
362s Selecting previously unselected package linux-tools-6.11.0-5-generic.
362s Preparing to unpack .../16-linux-tools-6.11.0-5-generic_6.11.0-5.5_ppc64el.deb ...
362s Unpacking linux-tools-6.11.0-5-generic (6.11.0-5.5) ...
362s Setting up linux-firmware (20240826.git2cdc11a7-0ubuntu2) ...
362s Setting up linux-libc-dev:ppc64el (6.11.0-5.5) ...
362s Setting up libpython3.12t64:ppc64el (3.12.5-4) ...
362s Setting up linux-modules-6.11.0-5-generic (6.11.0-5.5) ...
364s Setting up linux-modules-extra-6.11.0-5-generic (6.11.0-5.5) ...
366s Setting up linux-headers-6.11.0-5 (6.11.0-5.5) ...
366s Setting up linux-tools-common (6.11.0-5.5) ...
366s Setting up linux-image-6.11.0-5-generic (6.11.0-5.5) ...
368s I: /boot/vmlinux is now a symlink to vmlinux-6.11.0-5-generic
368s I: /boot/initrd.img is now a symlink to initrd.img-6.11.0-5-generic
368s Setting up linux-headers-6.11.0-5-generic (6.11.0-5.5) ...
368s Setting up linux-headers-generic (6.11.0-5.5) ...
368s Setting up linux-image-virtual (6.11.0-5.5) ...
368s Setting up linux-tools-6.11.0-5 (6.11.0-5.5) ...
368s Setting up linux-image-generic (6.11.0-5.5) ...
368s Setting up linux-headers-virtual (6.11.0-5.5) ...
368s Setting up linux-generic (6.11.0-5.5) ...
368s Setting up linux-tools-6.11.0-5-generic (6.11.0-5.5) ...
368s Setting up linux-virtual (6.11.0-5.5) ...
368s Processing triggers for man-db (2.12.1-3) ...
376s Processing triggers for libc-bin (2.40-1ubuntu1) ...
376s Processing triggers for initramfs-tools (0.142ubuntu32) ...
376s update-initramfs: Generating /boot/initrd.img-6.8.0-31-generic
377s W: No lz4 in /usr/bin:/sbin:/bin, using gzip
391s Processing triggers for linux-image-6.11.0-5-generic (6.11.0-5.5) ...
391s /etc/kernel/postinst.d/initramfs-tools:
391s update-initramfs: Generating /boot/initrd.img-6.11.0-5-generic
391s W: No lz4 in /usr/bin:/sbin:/bin, using gzip
401s /etc/kernel/postinst.d/zz-update-grub:
401s Sourcing file `/etc/default/grub'
401s Sourcing file `/etc/default/grub.d/50-cloudimg-settings.cfg'
401s Generating grub configuration file ...
401s Found linux image: /boot/vmlinux-6.11.0-5-generic
401s Found initrd image: /boot/initrd.img-6.11.0-5-generic
402s Found linux image: /boot/vmlinux-6.8.0-31-generic
402s Found initrd image: /boot/initrd.img-6.8.0-31-generic
402s Warning: os-prober will not be executed to detect other bootable partitions.
402s Systems on them will not be added to the GRUB boot configuration.
402s Check GRUB_DISABLE_OS_PROBER documentation entry.
402s Adding boot menu entry for UEFI Firmware Settings ...
402s done
402s Reading package lists...
403s Building dependency tree...
403s Reading state information...
403s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
403s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease
404s Hit:2 http://ftpmaster.internal/ubuntu oracular InRelease
404s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease
404s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease
405s Reading package lists...
405s Reading package lists...
405s Building dependency tree...
405s Reading state information...
405s Calculating upgrade...
405s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
405s Reading package lists...
405s Building dependency tree...
405s Reading state information...
406s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
406s Reading package lists...
406s Building dependency tree...
406s Reading state information...
406s linux-generic is already the newest version (6.11.0-5.5).
406s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
406s Reading package lists...
407s Building dependency tree...
407s Reading state information...
407s E: Unable to locate package ^kernel-testing--linux--modules-extra--preferred$
407s E: Couldn't find any package by regex '^kernel-testing--linux--modules-extra--preferred$'
407s Reading package lists...
407s Building dependency tree...
407s Reading state information...
407s E: Unable to locate package ^linux-modules-extra$
407s E: Couldn't find any package by regex '^linux-modules-extra$'
407s autopkgtest [10:35:18]: rebooting testbed after setup commands that affected boot
411s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds...
444s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds...
456s Reading package lists...
456s Building dependency tree...
456s Reading state information...
457s Starting pkgProblemResolver with broken count: 0
457s Starting 2 pkgProblemResolver with broken count: 0
457s Done
457s The following additional packages will be installed:
457s   fio libboost-iostreams1.83.0 libboost-thread1.83.0 libconfig-general-perl
457s   libdaxctl1 libgfapi0 libgfrpc0 libgfxdr0 libglusterfs0 libisns0t64 libnbd0
457s   libndctl6 libopeniscsiusr libpmem1 libpmemobj1 librados2 librbd1
457s   librdmacm1t64 lsscsi open-iscsi tgt
457s Suggested packages:
457s   fio-examples gnuplot tgt-glusterfs tgt-rbd
457s Recommended packages:
457s   finalrd
457s The following NEW packages will be installed:
457s   autopkgtest-satdep fio libboost-iostreams1.83.0 libboost-thread1.83.0
457s   libconfig-general-perl libdaxctl1 libgfapi0 libgfrpc0 libgfxdr0
457s   libglusterfs0 libisns0t64 libnbd0 libndctl6 libopeniscsiusr libpmem1
457s   libpmemobj1 librados2 librbd1 librdmacm1t64 lsscsi open-iscsi tgt
457s 0 upgraded, 22 newly installed, 0 to remove and 0 not upgraded.
457s Need to get 10.9 MB/11.0 MB of archives.
457s After this operation, 49.6 MB of additional disk space will be used.
457s Get:1 /tmp/autopkgtest.DWbgRx/2-autopkgtest-satdep.deb autopkgtest-satdep ppc64el 0 [732 B]
457s Get:2 http://ftpmaster.internal/ubuntu oracular/main ppc64el libopeniscsiusr ppc64el 2.1.10-1ubuntu1 [54.9 kB]
457s Get:3 http://ftpmaster.internal/ubuntu oracular/main ppc64el libisns0t64 ppc64el 0.101-1 [117 kB]
457s Get:4 http://ftpmaster.internal/ubuntu oracular/main ppc64el open-iscsi ppc64el 2.1.10-1ubuntu1 [385 kB]
458s Get:5 http://ftpmaster.internal/ubuntu oracular/main ppc64el librdmacm1t64 ppc64el 52.0-2ubuntu1 [80.6 kB]
458s Get:6 http://ftpmaster.internal/ubuntu oracular/universe ppc64el libconfig-general-perl all 2.65-2 [57.1 kB]
458s Get:7 http://ftpmaster.internal/ubuntu oracular/universe ppc64el tgt ppc64el 1:1.0.85-1.2ubuntu1 [254 kB]
458s Get:8 http://ftpmaster.internal/ubuntu oracular/universe ppc64el libgfxdr0 ppc64el 11.1-5ubuntu1 [21.7 kB]
458s Get:9 http://ftpmaster.internal/ubuntu oracular/universe ppc64el libglusterfs0 ppc64el 11.1-5ubuntu1 [308 kB]
458s Get:10 http://ftpmaster.internal/ubuntu oracular/universe ppc64el libgfrpc0 ppc64el 11.1-5ubuntu1 [46.3 kB]
458s Get:11 http://ftpmaster.internal/ubuntu oracular/universe ppc64el libgfapi0 ppc64el 11.1-5ubuntu1 [99.1 kB]
458s Get:12 http://ftpmaster.internal/ubuntu oracular/universe ppc64el libnbd0 ppc64el 1.20.2-2 [98.5 kB]
458s Get:13 http://ftpmaster.internal/ubuntu oracular/main ppc64el libdaxctl1 ppc64el 77-2.2ubuntu1 [23.7 kB]
458s Get:14 http://ftpmaster.internal/ubuntu oracular/main ppc64el libndctl6 ppc64el 77-2.2ubuntu1 [73.4 kB]
458s Get:15 http://ftpmaster.internal/ubuntu oracular/main ppc64el libpmem1 ppc64el 1.13.1-1.1ubuntu2 [41.1 kB]
458s Get:16 http://ftpmaster.internal/ubuntu oracular/main ppc64el libboost-iostreams1.83.0 ppc64el 1.83.0-3.1ubuntu2 [259 kB]
458s Get:17 http://ftpmaster.internal/ubuntu oracular/main ppc64el libboost-thread1.83.0 ppc64el 1.83.0-3.1ubuntu2 [281 kB]
458s Get:18 http://ftpmaster.internal/ubuntu oracular/main ppc64el librados2 ppc64el 19.2.0~is.really.19.1.0-0ubuntu2 [4151 kB]
458s Get:19 http://ftpmaster.internal/ubuntu oracular/main ppc64el libpmemobj1 ppc64el 1.13.1-1.1ubuntu2 [143 kB]
458s Get:20 http://ftpmaster.internal/ubuntu oracular/main ppc64el librbd1 ppc64el 19.2.0~is.really.19.1.0-0ubuntu2 [3684 kB]
458s Get:21 http://ftpmaster.internal/ubuntu oracular/universe ppc64el fio ppc64el 3.37-1 [716 kB]
458s Get:22 http://ftpmaster.internal/ubuntu oracular/main ppc64el lsscsi ppc64el 0.32-1build1 [54.0 kB]
459s Preconfiguring packages ...
459s Fetched 10.9 MB in 1s (10.6 MB/s)
459s Selecting previously unselected package libopeniscsiusr.
460s (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 ... 109816 files and directories currently installed.)
460s Preparing to unpack .../00-libopeniscsiusr_2.1.10-1ubuntu1_ppc64el.deb ...
460s Unpacking libopeniscsiusr (2.1.10-1ubuntu1) ...
460s Selecting previously unselected package libisns0t64:ppc64el.
460s Preparing to unpack .../01-libisns0t64_0.101-1_ppc64el.deb ...
460s Unpacking libisns0t64:ppc64el (0.101-1) ...
460s Selecting previously unselected package open-iscsi.
460s Preparing to unpack .../02-open-iscsi_2.1.10-1ubuntu1_ppc64el.deb ...
460s Unpacking open-iscsi (2.1.10-1ubuntu1) ...
460s Selecting previously unselected package librdmacm1t64:ppc64el.
460s Preparing to unpack .../03-librdmacm1t64_52.0-2ubuntu1_ppc64el.deb ...
460s Unpacking librdmacm1t64:ppc64el (52.0-2ubuntu1) ...
460s Selecting previously unselected package libconfig-general-perl.
460s Preparing to unpack .../04-libconfig-general-perl_2.65-2_all.deb ...
460s Unpacking libconfig-general-perl (2.65-2) ...
460s Selecting previously unselected package tgt.
460s Preparing to unpack .../05-tgt_1%3a1.0.85-1.2ubuntu1_ppc64el.deb ...
460s Unpacking tgt (1:1.0.85-1.2ubuntu1) ...
460s Selecting previously unselected package libgfxdr0:ppc64el.
460s Preparing to unpack .../06-libgfxdr0_11.1-5ubuntu1_ppc64el.deb ...
460s Unpacking libgfxdr0:ppc64el (11.1-5ubuntu1) ...
460s Selecting previously unselected package libglusterfs0:ppc64el.
460s Preparing to unpack .../07-libglusterfs0_11.1-5ubuntu1_ppc64el.deb ...
460s Unpacking libglusterfs0:ppc64el (11.1-5ubuntu1) ...
460s Selecting previously unselected package libgfrpc0:ppc64el.
460s Preparing to unpack .../08-libgfrpc0_11.1-5ubuntu1_ppc64el.deb ...
460s Unpacking libgfrpc0:ppc64el (11.1-5ubuntu1) ...
460s Selecting previously unselected package libgfapi0:ppc64el.
460s Preparing to unpack .../09-libgfapi0_11.1-5ubuntu1_ppc64el.deb ...
460s Unpacking libgfapi0:ppc64el (11.1-5ubuntu1) ...
460s Selecting previously unselected package libnbd0.
460s Preparing to unpack .../10-libnbd0_1.20.2-2_ppc64el.deb ...
460s Unpacking libnbd0 (1.20.2-2) ...
460s Selecting previously unselected package libdaxctl1:ppc64el.
460s Preparing to unpack .../11-libdaxctl1_77-2.2ubuntu1_ppc64el.deb ...
460s Unpacking libdaxctl1:ppc64el (77-2.2ubuntu1) ...
460s Selecting previously unselected package libndctl6:ppc64el.
460s Preparing to unpack .../12-libndctl6_77-2.2ubuntu1_ppc64el.deb ...
460s Unpacking libndctl6:ppc64el (77-2.2ubuntu1) ...
460s Selecting previously unselected package libpmem1:ppc64el.
460s Preparing to unpack .../13-libpmem1_1.13.1-1.1ubuntu2_ppc64el.deb ...
460s Unpacking libpmem1:ppc64el (1.13.1-1.1ubuntu2) ...
460s Selecting previously unselected package libboost-iostreams1.83.0:ppc64el.
460s Preparing to unpack .../14-libboost-iostreams1.83.0_1.83.0-3.1ubuntu2_ppc64el.deb ...
460s Unpacking libboost-iostreams1.83.0:ppc64el (1.83.0-3.1ubuntu2) ...
460s Selecting previously unselected package libboost-thread1.83.0:ppc64el.
460s Preparing to unpack .../15-libboost-thread1.83.0_1.83.0-3.1ubuntu2_ppc64el.deb ...
460s Unpacking libboost-thread1.83.0:ppc64el (1.83.0-3.1ubuntu2) ...
460s Selecting previously unselected package librados2.
460s Preparing to unpack .../16-librados2_19.2.0~is.really.19.1.0-0ubuntu2_ppc64el.deb ...
460s Unpacking librados2 (19.2.0~is.really.19.1.0-0ubuntu2) ...
461s Selecting previously unselected package libpmemobj1:ppc64el.
461s Preparing to unpack .../17-libpmemobj1_1.13.1-1.1ubuntu2_ppc64el.deb ...
461s Unpacking libpmemobj1:ppc64el (1.13.1-1.1ubuntu2) ...
461s Selecting previously unselected package librbd1.
461s Preparing to unpack .../18-librbd1_19.2.0~is.really.19.1.0-0ubuntu2_ppc64el.deb ...
461s Unpacking librbd1 (19.2.0~is.really.19.1.0-0ubuntu2) ...
461s Selecting previously unselected package fio.
461s Preparing to unpack .../19-fio_3.37-1_ppc64el.deb ...
461s Unpacking fio (3.37-1) ...
461s Selecting previously unselected package lsscsi.
461s Preparing to unpack .../20-lsscsi_0.32-1build1_ppc64el.deb ...
461s Unpacking lsscsi (0.32-1build1) ...
461s Selecting previously unselected package autopkgtest-satdep.
461s Preparing to unpack .../21-2-autopkgtest-satdep.deb ...
461s Unpacking autopkgtest-satdep (0) ...
461s Setting up libconfig-general-perl (2.65-2) ...
461s Setting up libisns0t64:ppc64el (0.101-1) ...
461s Setting up libboost-thread1.83.0:ppc64el (1.83.0-3.1ubuntu2) ...
461s Setting up libnbd0 (1.20.2-2) ...
461s Setting up libopeniscsiusr (2.1.10-1ubuntu1) ...
461s Setting up libglusterfs0:ppc64el (11.1-5ubuntu1) ...
461s Setting up libboost-iostreams1.83.0:ppc64el (1.83.0-3.1ubuntu2) ...
461s Setting up lsscsi (0.32-1build1) ...
461s Setting up libdaxctl1:ppc64el (77-2.2ubuntu1) ...
461s Setting up libndctl6:ppc64el (77-2.2ubuntu1) ...
461s Setting up librdmacm1t64:ppc64el (52.0-2ubuntu1) ...
461s Setting up tgt (1:1.0.85-1.2ubuntu1) ...
461s Created symlink '/etc/systemd/system/multi-user.target.wants/tgt.service' → '/usr/lib/systemd/system/tgt.service'.

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

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

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

463s Setting up libpmemobj1:ppc64el (1.13.1-1.1ubuntu2) ...
463s Setting up librbd1 (19.2.0~is.really.19.1.0-0ubuntu2) ...
463s Setting up libgfrpc0:ppc64el (11.1-5ubuntu1) ...
463s Setting up libgfapi0:ppc64el (11.1-5ubuntu1) ...
463s Setting up fio (3.37-1) ...
464s Setting up autopkgtest-satdep (0) ...
464s Processing triggers for man-db (2.12.1-3) ...
470s Processing triggers for initramfs-tools (0.142ubuntu32) ...
470s update-initramfs: Generating /boot/initrd.img-6.11.0-5-generic
470s W: No lz4 in /usr/bin:/sbin:/bin, using gzip
482s Processing triggers for libc-bin (2.40-1ubuntu1) ...
486s (Reading database ... 110057 files and directories currently installed.)
486s Removing autopkgtest-satdep (0) ...
488s autopkgtest [10:36:39]: test tgtbasedmpaths: [-----------------------
488s + targetname=iqn.2016-11.foo.com:target.iscsi
488s + pwd
488s + cwd=/tmp/autopkgtest.DWbgRx/build.fwv/src
488s + testdir=/mnt/tgtmpathtest
488s + localhost=127.0.0.1
488s + portal=127.0.0.1:3260
488s + maxpaths=4
488s + backfn=backingfile
488s + expectwwid=60000000000000000e00000000010001
488s + testdisk=/dev/disk/by-id/wwn-0x60000000000000000e00000000010001
488s + bglog=/tmp/autopkgtest.DWbgRx/tgtbasedmpaths-artifacts/test-background.log
488s + fioprep=/tmp/autopkgtest.DWbgRx/tgtbasedmpaths-artifacts/path-change-prep.fio
488s + fiovrfy=/tmp/autopkgtest.DWbgRx/tgtbasedmpaths-artifacts/path-change-check.fio
488s + mkdir -p /etc/multipath
488s + echo /360000000000000000e00000000010001/
488s + service tgt restart
489s + truncate --size 100M backingfile
489s + tgtadm --lld iscsi --op new --mode target --tid 1 -T iqn.2016-11.foo.com:target.iscsi
489s + tgtadm --lld iscsi --op bind --mode target --tid 1 -I ALL
489s + tgtadm --lld iscsi --op new --mode logicalunit --tid 1 --lun 1 -b /tmp/autopkgtest.DWbgRx/build.fwv/src/backingfile
489s + iscsiadm --mode discovery --type sendtargets --portal 127.0.0.1
489s 127.0.0.1:3260,1 iqn.2016-11.foo.com:target.iscsi
489s login #1
489s + echo login #1
489s + iscsiadm --mode node --targetname iqn.2016-11.foo.com:target.iscsi --portal 127.0.0.1:3260 --login
489s Logging in to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260]
489s Login to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] successful.
489s + seq 2 4
489s extra login #2
489s + echo extra login #2
489s + iscsiadm --mode session -r 1 --op new
489s Logging in to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] (multiple)
489s Login to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] successful.
489s extra login #3
489s + echo extra login #3
489s + iscsiadm --mode session -r 1 --op new
489s Logging in to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] (multiple)
489s Login to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] successful.
489s extra login #4
489s + echo extra login #4
489s + iscsiadm --mode session -r 1 --op new
489s Logging in to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] (multiple)
489s Login to [iface: default, target: iqn.2016-11.foo.com:target.iscsi, portal: 127.0.0.1,3260] successful.
489s + udevadm settle
489s + sleep 5
494s Status after initial setup
494s Target 1: iqn.2016-11.foo.com:target.iscsi
494s     System information:
494s         Driver: iscsi
494s         State: ready
494s     I_T nexus information:
494s         I_T nexus: 1
494s             Initiator: iqn.2004-10.com.ubuntu:01:f9cdab51f93 alias: autopkgtest
494s             Connection: 0
494s                 IP Address: 127.0.0.1
494s         I_T nexus: 2
494s             Initiator: iqn.2004-10.com.ubuntu:01:f9cdab51f93 alias: autopkgtest
494s             Connection: 0
494s                 IP Address: 127.0.0.1
494s         I_T nexus: 3
494s             Initiator: iqn.2004-10.com.ubuntu:01:f9cdab51f93 alias: autopkgtest
494s             Connection: 0
494s                 IP Address: 127.0.0.1
494s         I_T nexus: 4
494s             Initiator: iqn.2004-10.com.ubuntu:01:f9cdab51f93 alias: autopkgtest
494s             Connection: 0
494s                 IP Address: 127.0.0.1
494s     LUN information:
494s         LUN: 0
494s             Type: controller
494s             SCSI ID: IET     00010000
494s             SCSI SN: beaf10
494s             Size: 0 MB, Block size: 1
494s             Online: Yes
494s             Removable media: No
494s             Prevent removal: No
494s             Readonly: No
494s             SWP: No
494s             Thin-provisioning: No
494s             Backing store type: null
494s             Backing store path: None
494s             Backing store flags: 
494s         LUN: 1
494s             Type: disk
494s             SCSI ID: IET     00010001
494s             SCSI SN: beaf11
494s             Size: 105 MB, Block size: 512
494s             Online: Yes
494s             Removable media: No
494s             Prevent removal: No
494s             Readonly: No
494s             SWP: No
494s             Thin-provisioning: No
494s             Backing store type: rdwr
494s             Backing store path: /tmp/autopkgtest.DWbgRx/build.fwv/src/backingfile
494s             Backing store flags: 
494s     Account information:
494s     ACL information:
494s         ALL
494s + echo Status after initial setup
494s + tgtadm --lld iscsi --mode target --op show
494s + tgtadm --lld iscsi --op show --mode conn --tid 1
494s Session: 4
494s     Connection: 0
494s         Initiator: iqn.2004-10.com.ubuntu:01:f9cdab51f93
494s         IP Address: 127.0.0.1
494s Session: 3
494s     Connection: 0
494s         Initiator: iqn.2004-10.com.ubuntu:01:f9cdab51f93
494s         IP Address: 127.0.0.1
494s Session: 2
494s     Connection: 0
494s         Initiator: iqn.2004-10.com.ubuntu:01:f9cdab51f93
494s         IP Address: 127.0.0.1
494s Session: 1
494s     Connection: 0
494s         Initiator: iqn.2004-10.com.ubuntu:01:f9cdab51f93
494s         IP Address: 127.0.0.1
494s + iscsiadm --mode session -P 1
494s Target: iqn.2016-11.foo.com:target.iscsi (non-flash)
494s 	Current Portal: 127.0.0.1:3260,1
494s 	Persistent Portal: 127.0.0.1:3260,1
494s 		**********
494s 		Interface:
494s 		**********
494s 		Iface Name: default
494s 		Iface Transport: tcp
494s 		Iface Initiatorname: iqn.2004-10.com.ubuntu:01:f9cdab51f93
494s 		Iface IPaddress: 127.0.0.1
494s 		Iface HWaddress: default
494s 		Iface Netdev: default
494s 		SID: 1
494s 		iSCSI Connection State: LOGGED IN
494s 		iSCSI Session State: LOGGED_IN
494s 		Internal iscsid Session State: NO CHANGE
494s 
494s 		**********
494s 		Interface:
494s 		**********
494s 		Iface Name: default
494s 		Iface Transport: tcp
494s 		Iface Initiatorname: iqn.2004-10.com.ubuntu:01:f9cdab51f93
494s 		Iface IPaddress: 127.0.0.1
494s 		Iface HWaddress: default
494s 		Iface Netdev: default
494s 		SID: 2
494s 		iSCSI Connection State: LOGGED IN
494s 		iSCSI Session State: LOGGED_IN
494s 		Internal iscsid Session State: NO CHANGE
494s 
494s 		**********
494s 		Interface:
494s 		**********
494s 		Iface Name: default
494s 		Iface Transport: tcp
494s 		Iface Initiatorname: iqn.2004-10.com.ubuntu:01:f9cdab51f93
494s 		Iface IPaddress: 127.0.0.1
494s 		Iface HWaddress: default
494s 		Iface Netdev: default
494s 		SID: 3
494s 		iSCSI Connection State: LOGGED IN
494s 		iSCSI Session State: LOGGED_IN
494s 		Internal iscsid Session State: NO CHANGE
494s 
494s 		**********
494s 		Interface:
494s 		**********
494s 		Iface Name: default
494s 		Iface Transport: tcp
494s 		Iface Initiatorname: iqn.2004-10.com.ubuntu:01:f9cdab51f93
494s 		Iface IPaddress: 127.0.0.1
494s 		Iface HWaddress: default
494s 		Iface Netdev: default
494s 		SID: 4
494s 		iSCSI Connection State: LOGGED IN
494s 		iSCSI Session State: LOGGED_IN
494s 		Internal iscsid Session State: NO CHANGE
494s + lsscsi -liv
494s list_ndevices: scandir: /sys/class/nvme/: No such file or directory
494s + multipath -v3 -ll
494s [0:0:0:0]    storage IET      Controller       0001  -          -
494s   state=running queue_depth=32 scsi_level=6 type=12 device_blocked=0 timeout=30
494s   dir: /sys/bus/scsi/devices/0:0:0:0  [/sys/devices/platform/host0/session1/target0:0:0/0:0:0:0]
494s [0:0:0:1]    disk    IET      VIRTUAL-DISK     0001  /dev/sda   360000000000000000e00000000010001
494s   state=running queue_depth=32 scsi_level=6 type=0 device_blocked=0 timeout=30
494s   dir: /sys/bus/scsi/devices/0:0:0:1  [/sys/devices/platform/host0/session1/target0:0:0/0:0:0:1]
494s [1:0:0:0]    storage IET      Controller       0001  -          -
494s   state=running queue_depth=32 scsi_level=6 type=12 device_blocked=0 timeout=30
494s   dir: /sys/bus/scsi/devices/1:0:0:0  [/sys/devices/platform/host1/session2/target1:0:0/1:0:0:0]
494s [1:0:0:1]    disk    IET      VIRTUAL-DISK     0001  /dev/sdb   360000000000000000e00000000010001
494s   state=running queue_depth=32 scsi_level=6 type=0 device_blocked=0 timeout=30
494s   dir: /sys/bus/scsi/devices/1:0:0:1  [/sys/devices/platform/host1/session2/target1:0:0/1:0:0:1]
494s [2:0:0:0]    storage IET      Controller       0001  -          -
494s   state=running queue_depth=32 scsi_level=6 type=12 device_blocked=0 timeout=30
494s   dir: /sys/bus/scsi/devices/2:0:0:0  [/sys/devices/platform/host2/session3/target2:0:0/2:0:0:0]
494s [2:0:0:1]    disk    IET      VIRTUAL-DISK     0001  /dev/sdc   360000000000000000e00000000010001
494s   state=running queue_depth=32 scsi_level=6 type=0 device_blocked=0 timeout=30
494s   dir: /sys/bus/scsi/devices/2:0:0:1  [/sys/devices/platform/host2/session3/target2:0:0/2:0:0:1]
494s [3:0:0:0]    storage IET      Controller       0001  -          -
494s   state=running queue_depth=32 scsi_level=6 type=12 device_blocked=0 timeout=30
494s   dir: /sys/bus/scsi/devices/3:0:0:0  [/sys/devices/platform/host3/session4/target3:0:0/3:0:0:0]
494s [3:0:0:1]    disk    IET      VIRTUAL-DISK     0001  /dev/sdd   33000000100000001
494s   state=running queue_depth=32 scsi_level=6 type=0 device_blocked=0 timeout=30
494s   dir: /sys/bus/scsi/devices/3:0:0:1  [/sys/devices/platform/host3/session4/target3:0:0/3:0:0:1]
494s NVMe module may not be loaded
494s 66.079977 | set open fds limit to 1073741816/1073741816
494s 66.080065 | _read_bindings_file: reading /etc/multipath/bindings
494s 66.080106 | loading /usr/lib/multipath/libchecktur.so checker
494s 66.080212 | checker tur: message table size = 4
494s 66.080223 | loading /usr/lib/multipath/libprioconst.so prioritizer
494s 66.080350 | _init_foreign: foreign library "nvme" is not enabled
494s 66.086493 | vda: device node name blacklisted
494s 66.086765 | sda: size = 204800
494s 66.086896 | sda: vendor = IET
494s 66.086919 | sda: product = VIRTUAL-DISK
494s 66.086940 | sda: rev = 0001
494s 66.087638 | sda: h:b:t:l = 0:0:0:1
494s 66.087983 | sda: tgt_node_name = iqn.2016-11.foo.com:target.iscsi
494s 66.087987 | sda: uid_attribute = ID_SERIAL (setting: multipath internal)
494s 66.087990 | sda: recheck_wwid = 1 (setting: multipath.conf defaults/devices section)
494s 66.088177 | sda: 1024 cyl, 4 heads, 50 sectors/track, start at 0
494s 66.088185 | sda: vpd_vendor_id = 0 "undef" (setting: multipath internal)
494s 66.088199 | sda: serial = beaf11
494s 66.088202 | sda: detect_checker = yes (setting: multipath internal)
494s 66.088229 | sda checker timeout = 30 s (setting: kernel sysfs)
494s 66.088412 | sda: path_checker = tur (setting: multipath internal)
494s 66.088532 | sda: tur state = up
494s 66.088662 | sdb: size = 204800
494s 66.088794 | sdb: vendor = IET
494s 66.088817 | sdb: product = VIRTUAL-DISK
494s 66.088838 | sdb: rev = 0001
494s 66.089518 | sdb: h:b:t:l = 1:0:0:1
494s 66.089866 | sdb: tgt_node_name = iqn.2016-11.foo.com:target.iscsi
494s 66.089870 | sdb: uid_attribute = ID_SERIAL (setting: multipath internal)
494s 66.089872 | sdb: recheck_wwid = 1 (setting: multipath.conf defaults/devices section)
494s 66.090021 | sdb: 1024 cyl, 4 heads, 50 sectors/track, start at 0
494s 66.090025 | sdb: vpd_vendor_id = 0 "undef" (setting: multipath internal)
494s 66.090037 | sdb: serial = beaf11
494s 66.090040 | sdb: detect_checker = yes (setting: multipath internal)
494s 66.090066 | sdb checker timeout = 30 s (setting: kernel sysfs)
494s 66.090176 | sdb: path_checker = tur (setting: multipath internal)
494s 66.090249 | sdb: tur state = up
494s 66.090378 | sdc: size = 204800
494s 66.090510 | sdc: vendor = IET
494s 66.090532 | sdc: product = VIRTUAL-DISK
494s 66.090553 | sdc: rev = 0001
494s 66.091223 | sdc: h:b:t:l = 2:0:0:1
494s 66.091581 | sdc: tgt_node_name = iqn.2016-11.foo.com:target.iscsi
494s 66.091585 | sdc: uid_attribute = ID_SERIAL (setting: multipath internal)
494s 66.091588 | sdc: recheck_wwid = 1 (setting: multipath.conf defaults/devices section)
494s 66.091732 | sdc: 1024 cyl, 4 heads, 50 sectors/track, start at 0
494s 66.091736 | sdc: vpd_vendor_id = 0 "undef" (setting: multipath internal)
494s 66.091748 | sdc: serial = beaf11
494s 66.091751 | sdc: detect_checker = yes (setting: multipath internal)
494s 66.091777 | sdc checker timeout = 30 s (setting: kernel sysfs)
494s 66.091884 | sdc: path_checker = tur (setting: multipath internal)
494s 66.091956 | sdc: tur state = up
494s 66.092148 | sdd: size = 204800
494s 66.092283 | sdd: vendor = IET
494s 66.092304 | sdd: product = VIRTUAL-DISK
494s 66.092325 | sdd: rev = 0001
494s 66.093015 | sdd: h:b:t:l = 3:0:0:1
494s 66.093334 | sdd: tgt_node_name = iqn.2016-11.foo.com:target.iscsi
494s 66.093337 | sdd: uid_attribute = ID_SERIAL (setting: multipath internal)
494s 66.093339 | sdd: recheck_wwid = 1 (setting: multipath.conf defaults/devices section)
494s 66.093474 | sdd: 1024 cyl, 4 heads, 50 sectors/track, start at 0
494s 66.093476 | sdd: vpd_vendor_id = 0 "undef" (setting: multipath internal)
494s 66.093488 | sdd: serial = beaf11
494s 66.093490 | sdd: detect_checker = yes (setting: multipath internal)
494s 66.093514 | sdd checker timeout = 30 s (setting: kernel sysfs)
494s 66.093618 | sdd: path_checker = tur (setting: multipath internal)
494s 66.093685 | sdd: tur state = up
494s 66.093777 | loop0: device node name blacklisted
494s 66.093856 | loop1: device node name blacklisted
494s 66.093932 | loop2: device node name blacklisted
494s 66.094006 | loop3: device node name blacklisted
494s 66.094080 | loop4: device node name blacklisted
494s 66.094153 | loop5: device node name blacklisted
494s 66.094227 | loop6: device node name blacklisted
494s 66.094300 | loop7: device node name blacklisted
494s 66.094379 | dm-0: device node name blacklisted
494s 66.095366 | multipath-tools v0.9.9 (05/03, 2024)
494s 66.095375 | libdevmapper version 1.02.196
494s 66.095505 | kernel device mapper v4.48.0
494s 66.095515 | DM multipath kernel driver v1.14.0
494s 66.095611 | sda: size = 204800
494s 66.095615 | sda: vendor = IET
494s 66.095618 | sda: product = VIRTUAL-DISK
494s 66.095620 | sda: rev = 0001
494s 66.096224 | sda: h:b:t:l = 0:0:0:1
494s 66.096339 | sda: tgt_node_name = iqn.2016-11.foo.com:target.iscsi
494s 66.096356 | sda: 1024 cyl, 4 heads, 50 sectors/track, start at 0
494s 66.096359 | sda: vpd_vendor_id = 0 "undef" (setting: multipath internal)
494s 66.096370 | sda: serial = beaf11
494s 66.096441 | sda: tur state = up
494s 66.096447 | sda: uid = 360000000000000000e00000000010001 (udev)
494s 66.096453 | sda: detect_prio = yes (setting: multipath internal)
494s 66.096457 | sda: prio = const (setting: multipath internal)
494s 66.096459 | sda: prio args = "" (setting: multipath internal)
494s 66.096461 | sda: const prio = 1
494s 66.096482 | sdb: size = 204800
494s 66.096486 | sdb: vendor = IET
494s 66.096488 | sdb: product = VIRTUAL-DISK
494s 66.096491 | sdb: rev = 0001
494s 66.097053 | sdb: h:b:t:l = 1:0:0:1
494s 66.097161 | sdb: tgt_node_name = iqn.2016-11.foo.com:target.iscsi
494s 66.097179 | sdb: 1024 cyl, 4 heads, 50 sectors/track, start at 0
494s 66.097181 | sdb: vpd_vendor_id = 0 "undef" (setting: multipath internal)
494s 66.097192 | sdb: serial = beaf11
494s 66.097261 | sdb: tur state = up
494s 66.097267 | sdb: uid = 360000000000000000e00000000010001 (udev)
494s 66.097271 | sdb: detect_prio = yes (setting: multipath internal)
494s 66.097275 | sdb: prio = const (setting: multipath internal)
494s 66.097277 | sdb: prio args = "" (setting: multipath internal)
494s 66.097279 | sdb: const prio = 1
494s 66.097299 | sdc: size = 204800
494s 66.097303 | sdc: vendor = IET
494s 66.097305 | sdc: product = VIRTUAL-DISK
494s 66.097307 | sdc: rev = 0001
494s ===== paths list =====
494s uuid hcil    dev dev_t pri dm_st chk_st vend/prod/rev         dev_st 
494s      0:0:0:1 sda 8:0   -1  undef undef  IET,VIRTUAL-DISK,0001 unknown
494s      1:0:0:1 sdb 8:16  -1  undef undef  IET,VIRTUAL-DISK,0001 unknown
494s      2:0:0:1 sdc 8:32  -1  undef undef  IET,VIRTUAL-DISK,0001 unknown
494s      3:0:0:1 sdd 8:48  -1  undef undef  IET,VIRTUAL-DISK,0001 unknown
494s mpatha (360000000000000000e00000000010001) dm-0 IET,VIRTUAL-DISK
494s size=100M features='0' hwhandler='0' wp=rw
494s |-+- policy='service-time 0' prio=1 status=active
494s | `- 0:0:0:1 sda 8:0  active ready running
494s |-+- policy='service-time 0' prio=1 status=enabled
494s | `- 1:0:0:1 sdb 8:16 active ready running
494s |-+- policy='service-time 0' prio=1 status=enabled
494s | `- 2:0:0:1 sdc 8:32 active ready running
494s `-+- policy='service-time 0' prio=1 status=enabled
494s   `- 3:0:0:1 sdd 8:48 active ready running
494s mpatha: 0 204800 multipath 0 0 4 1 service-time 0 1 2 8:0 1 1 service-time 0 1 2 8:16 1 1 service-time 0 1 2 8:32 1 1 service-time 0 1 2 8:48 1 1 
494s /etc/multipath/bindings:# Multipath bindings, Version : 1.0
494s /etc/multipath/bindings:# NOTE: this file is automatically maintained by the multipath program.
494s /etc/multipath/bindings:# You should not need to edit this file in normal circumstances.
494s /etc/multipath/bindings:#
494s /etc/multipath/bindings:# Format:
494s /etc/multipath/bindings:# alias wwid
494s /etc/multipath/bindings:#
494s /etc/multipath/bindings:mpatha 360000000000000000e00000000010001
494s /etc/multipath/wwids:/360000000000000000e00000000010001/
494s ● multipathd.service - Device-Mapper Multipath Device Controller
494s      Loaded: loaded (/usr/lib/systemd/system/multipathd.service; enabled; preset: enabled)
494s      Active: active (running) since Sat 2024-08-31 10:35:43 UTC; 1min 1s ago
494s  Invocation: b6bc95a781704f03af599ace17794d3c
494s TriggeredBy: ○ multipathd.socket
494s    Main PID: 330 (multipathd)
494s      Status: "up"
494s       Tasks: 7
494s      Memory: 27.8M (peak: 35.2M)
494s         CPU: 40ms
494s      CGroup: /system.slice/multipathd.service
494s              └─330 /sbin/multipathd -d -s
494s 
494s Aug 31 10:35:43 autopkgtest systemd[1]: Starting multipathd.service - Device-Mapper Multipath Device Controller...
494s Aug 31 10:35:43 autopkgtest multipathd[330]: multipathd v0.9.9: start up
494s Aug 31 10:35:43 autopkgtest multipathd[330]: reconfigure: setting up paths and maps
494s Aug 31 10:35:43 autopkgtest systemd[1]: Started multipathd.service - Device-Mapper Multipath Device Controller.
494s Aug 31 10:36:40 autopkgtest multipathd[330]: updated bindings file /etc/multipath/bindings
494s Aug 31 10:36:40 autopkgtest multipathd[330]: mpatha: addmap [0 204800 multipath 0 0 1 1 service-time 0 1 1 8:0 1]
494s Aug 31 10:36:40 autopkgtest multipathd[330]: sda [8:0]: path added to devmap mpatha
494s Aug 31 10:36:40 autopkgtest multipathd[330]: mpatha: performing delayed actions
494s Aug 31 10:36:40 autopkgtest multipathd[330]: mpatha: reload [0 204800 multipath 0 0 4 1 service-time 0 1 1 8:0 1 service-time 0 1 1 8:16 1 service-time 0 1 1 8:32 1 service-time 0 1 1 8:48 1]
494s ○ multipathd.socket - multipathd control socket
494s      Loaded: loaded (/usr/lib/systemd/system/multipathd.socket; static)
494s      Active: inactive (dead)
494s    Triggers: ● multipathd.service
494s      Listen: @/org/kernel/linux/storage/multipathd (Stream)
494s 66.097858 | sdc: h:b:t:l = 2:0:0:1
494s 66.097964 | sdc: tgt_node_name = iqn.2016-11.foo.com:target.iscsi
494s 66.097981 | sdc: 1024 cyl, 4 heads, 50 sectors/track, start at 0
494s 66.097984 | sdc: vpd_vendor_id = 0 "undef" (setting: multipath internal)
494s 66.097994 | sdc: serial = beaf11
494s 66.098063 | sdc: tur state = up
494s 66.098069 | sdc: uid = 360000000000000000e00000000010001 (udev)
494s 66.098074 | sdc: detect_prio = yes (setting: multipath internal)
494s 66.098076 | sdc: prio = const (setting: multipath internal)
494s 66.098079 | sdc: prio args = "" (setting: multipath internal)
494s 66.098081 | sdc: const prio = 1
494s 66.098101 | sdd: size = 204800
494s 66.098104 | sdd: vendor = IET
494s 66.098107 | sdd: product = VIRTUAL-DISK
494s 66.098109 | sdd: rev = 0001
494s 66.098658 | sdd: h:b:t:l = 3:0:0:1
494s 66.098764 | sdd: tgt_node_name = iqn.2016-11.foo.com:target.iscsi
494s 66.098781 | sdd: 1024 cyl, 4 heads, 50 sectors/track, start at 0
494s 66.098784 | sdd: vpd_vendor_id = 0 "undef" (setting: multipath internal)
494s 66.098795 | sdd: serial = beaf11
494s 66.098863 | sdd: tur state = up
494s 66.098869 | sdd: uid = 360000000000000000e00000000010001 (udev)
494s 66.098872 | sdd: detect_prio = yes (setting: multipath internal)
494s 66.098877 | sdd: prio = const (setting: multipath internal)
494s 66.098879 | sdd: prio args = "" (setting: multipath internal)
494s 66.098881 | sdd: const prio = 1
494s 66.099575 | unloading tur checker
494s 66.099595 | unloading const prioritizer
494s + dmsetup table
494s + grep . /etc/multipath/bindings /etc/multipath/wwids
494s + systemctl status multipathd.service
494s + systemctl status multipathd.socket
494s autopkgtest [10:36:45]: test tgtbasedmpaths: -----------------------]
495s autopkgtest [10:36:46]: test tgtbasedmpaths:  - - - - - - - - - - results - - - - - - - - - -
495s tgtbasedmpaths       FAIL non-zero exit status 3
495s autopkgtest [10:36:46]: @@@@@@@@@@@@@@@@@@@@ summary
495s initramfs            SKIP Test lists explicitly supported architectures, but the current architecture ppc64el isn't listed.
495s initramfs            SKIP Test lists explicitly supported architectures, but the current architecture ppc64el isn't listed.
495s kpartx-file-loopback PASS
495s tgtbasedmpaths       FAIL non-zero exit status 3
499s nova [W] Using flock in prodstack6-ppc64el
499s Creating nova instance adt-oracular-ppc64el-multipath-tools-20240831-102831-juju-7f2275-prod-proposed-migration-environment-2-67cd8263-bba4-4572-9983-8e9ab60846f1 from image adt/ubuntu-oracular-ppc64el-server-20240830.img (UUID 81071ea1-26a7-45bd-b2ed-544778fe3d54)...
499s nova [W] Using flock in prodstack6-ppc64el
499s Creating nova instance adt-oracular-ppc64el-multipath-tools-20240831-102831-juju-7f2275-prod-proposed-migration-environment-2-67cd8263-bba4-4572-9983-8e9ab60846f1 from image adt/ubuntu-oracular-ppc64el-server-20240830.img (UUID 81071ea1-26a7-45bd-b2ed-544778fe3d54)...