0s autopkgtest [23:12:37]: starting date and time: 2024-03-19 23:12:37+0000
0s autopkgtest [23:12:37]: git checkout: 4a1cd702 l/adt_testbed: don't blame the testbed for unsolvable build deps
0s autopkgtest [23:12:37]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.gzsmlk0n/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:openssh,src:at-spi2-core,src:glib2.0,src:gtk+3.0,src:openssl --apt-upgrade libpam-mount --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=openssh/1:9.6p1-3ubuntu11 at-spi2-core/2.51.90-3 glib2.0/2.79.3-3ubuntu5 gtk+3.0/3.24.41-1.1ubuntu1 openssl/3.0.13-0ubuntu2' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos01-ppc64el-20.secgroup --name adt-noble-ppc64el-libpam-mount-20240319-224735-juju-7f2275-prod-proposed-migration-environment-2 --image adt/ubuntu-noble-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration -e TERM=linux -e ''"'"'http_proxy=http://squid.internal:3128'"'"'' -e ''"'"'https_proxy=http://squid.internal:3128'"'"'' -e ''"'"'no_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'"'"'' --mirror=http://us.ports.ubuntu.com/ubuntu-ports/
236s autopkgtest [23:16:33]: testbed dpkg architecture: ppc64el
236s autopkgtest [23:16:33]: testbed apt version: 2.7.12
236s autopkgtest [23:16:33]: @@@@@@@@@@@@@@@@@@@@ test bed setup
237s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [117 kB]
237s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [6540 B]
237s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [3797 kB]
238s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [492 kB]
238s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [52.7 kB]
238s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el Packages [655 kB]
238s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el c-n-f Metadata [3116 B]
238s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted ppc64el Packages [1372 B]
238s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted ppc64el c-n-f Metadata [116 B]
238s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe ppc64el Packages [4078 kB]
238s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/universe ppc64el c-n-f Metadata [8652 B]
238s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/multiverse ppc64el Packages [47.7 kB]
238s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/multiverse ppc64el c-n-f Metadata [116 B]
242s Fetched 9259 kB in 2s (3847 kB/s)
242s Reading package lists...
245s Reading package lists...
245s Building dependency tree...
245s Reading state information...
245s Calculating upgrade...
245s The following packages will be REMOVED:
245s libglib2.0-0 libssl3
245s The following NEW packages will be installed:
245s libglib2.0-0t64 libssl3t64 xdg-user-dirs
245s The following packages will be upgraded:
245s gir1.2-glib-2.0 libglib2.0-data openssh-client openssh-server
245s openssh-sftp-server openssl ubuntu-minimal ubuntu-standard
245s 8 upgraded, 3 newly installed, 2 to remove and 0 not upgraded.
245s Need to get 6977 kB of archives.
245s After this operation, 933 kB of additional disk space will be used.
245s Get:1 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el gir1.2-glib-2.0 ppc64el 2.79.3-3ubuntu5 [182 kB]
246s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el libglib2.0-0t64 ppc64el 2.79.3-3ubuntu5 [1773 kB]
246s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el openssl ppc64el 3.0.13-0ubuntu2 [1026 kB]
246s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el openssh-sftp-server ppc64el 1:9.6p1-3ubuntu11 [43.7 kB]
246s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el openssh-server ppc64el 1:9.6p1-3ubuntu11 [627 kB]
246s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el openssh-client ppc64el 1:9.6p1-3ubuntu11 [1112 kB]
246s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el libssl3t64 ppc64el 3.0.13-0ubuntu2 [2125 kB]
246s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el libglib2.0-data all 2.79.3-3ubuntu5 [46.6 kB]
246s Get:9 http://ftpmaster.internal/ubuntu noble/main ppc64el ubuntu-minimal ppc64el 1.536build1 [10.7 kB]
246s Get:10 http://ftpmaster.internal/ubuntu noble/main ppc64el xdg-user-dirs ppc64el 0.18-1 [20.0 kB]
246s Get:11 http://ftpmaster.internal/ubuntu noble/main ppc64el ubuntu-standard ppc64el 1.536build1 [10.7 kB]
246s Preconfiguring packages ...
246s Fetched 6977 kB in 1s (7223 kB/s)
247s (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 ... 70095 files and directories currently installed.)
247s Preparing to unpack .../gir1.2-glib-2.0_2.79.3-3ubuntu5_ppc64el.deb ...
247s Unpacking gir1.2-glib-2.0:ppc64el (2.79.3-3ubuntu5) over (2.79.2-1~ubuntu1) ...
247s dpkg: libglib2.0-0:ppc64el: dependency problems, but removing anyway as you requested:
247s udisks2 depends on libglib2.0-0 (>= 2.77.0).
247s shared-mime-info depends on libglib2.0-0 (>= 2.75.3).
247s python3-gi depends on libglib2.0-0 (>= 2.77.0).
247s python3-dbus depends on libglib2.0-0 (>= 2.16.0).
247s netplan.io depends on libglib2.0-0 (>= 2.70.0).
247s netplan-generator depends on libglib2.0-0 (>= 2.70.0).
247s libxmlb2:ppc64el depends on libglib2.0-0 (>= 2.54.0).
247s libvolume-key1:ppc64el depends on libglib2.0-0 (>= 2.18.0).
247s libudisks2-0:ppc64el depends on libglib2.0-0 (>= 2.75.3).
247s libqrtr-glib0:ppc64el depends on libglib2.0-0 (>= 2.56).
247s libqmi-proxy depends on libglib2.0-0 (>= 2.30.0).
247s libqmi-glib5:ppc64el depends on libglib2.0-0 (>= 2.54.0).
247s libpolkit-gobject-1-0:ppc64el depends on libglib2.0-0 (>= 2.38.0).
247s libpolkit-agent-1-0:ppc64el depends on libglib2.0-0 (>= 2.38.0).
247s libnetplan0:ppc64el depends on libglib2.0-0 (>= 2.75.3).
247s libmm-glib0:ppc64el depends on libglib2.0-0 (>= 2.62.0).
247s libmbim-proxy depends on libglib2.0-0 (>= 2.56).
247s libmbim-glib4:ppc64el depends on libglib2.0-0 (>= 2.56).
247s libjson-glib-1.0-0:ppc64el depends on libglib2.0-0 (>= 2.75.3).
247s libjcat1:ppc64el depends on libglib2.0-0 (>= 2.75.3).
247s libgusb2:ppc64el depends on libglib2.0-0 (>= 2.75.3).
247s libgudev-1.0-0:ppc64el depends on libglib2.0-0 (>= 2.38.0).
247s libgirepository-1.0-1:ppc64el depends on libglib2.0-0 (>= 2.79.0).
247s libfwupd2:ppc64el depends on libglib2.0-0 (>= 2.79.0).
247s libblockdev3:ppc64el depends on libglib2.0-0 (>= 2.42.2).
247s libblockdev-utils3:ppc64el depends on libglib2.0-0 (>= 2.75.3).
247s libblockdev-swap3:ppc64el depends on libglib2.0-0 (>= 2.42.2).
247s libblockdev-part3:ppc64el depends on libglib2.0-0 (>= 2.42.2).
247s libblockdev-nvme3:ppc64el depends on libglib2.0-0 (>= 2.42.2).
247s libblockdev-mdraid3:ppc64el depends on libglib2.0-0 (>= 2.42.2).
247s libblockdev-loop3:ppc64el depends on libglib2.0-0 (>= 2.42.2).
247s libblockdev-fs3:ppc64el depends on libglib2.0-0 (>= 2.42.2).
247s libblockdev-crypto3:ppc64el depends on libglib2.0-0 (>= 2.42.2).
247s fwupd depends on libglib2.0-0 (>= 2.79.0).
247s bolt depends on libglib2.0-0 (>= 2.56.0).
247s
247s (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 ... 70095 files and directories currently installed.)
247s Removing libglib2.0-0:ppc64el (2.79.2-1~ubuntu1) ...
247s Selecting previously unselected package libglib2.0-0t64:ppc64el.
247s (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 ... 70070 files and directories currently installed.)
247s Preparing to unpack .../libglib2.0-0t64_2.79.3-3ubuntu5_ppc64el.deb ...
247s libglib2.0-0t64.preinst: Removing /var/lib/dpkg/info/libglib2.0-0:ppc64el.postrm to avoid loss of /usr/share/glib-2.0/schemas/gschemas.compiled...
247s removed '/var/lib/dpkg/info/libglib2.0-0:ppc64el.postrm'
247s Unpacking libglib2.0-0t64:ppc64el (2.79.3-3ubuntu5) ...
247s Preparing to unpack .../openssl_3.0.13-0ubuntu2_ppc64el.deb ...
247s Unpacking openssl (3.0.13-0ubuntu2) over (3.0.10-1ubuntu4) ...
247s Preparing to unpack .../openssh-sftp-server_1%3a9.6p1-3ubuntu11_ppc64el.deb ...
247s Unpacking openssh-sftp-server (1:9.6p1-3ubuntu11) over (1:9.6p1-3ubuntu2) ...
247s Preparing to unpack .../openssh-server_1%3a9.6p1-3ubuntu11_ppc64el.deb ...
247s Unpacking openssh-server (1:9.6p1-3ubuntu11) over (1:9.6p1-3ubuntu2) ...
247s Preparing to unpack .../openssh-client_1%3a9.6p1-3ubuntu11_ppc64el.deb ...
247s Unpacking openssh-client (1:9.6p1-3ubuntu11) over (1:9.6p1-3ubuntu2) ...
247s dpkg: libssl3:ppc64el: dependency problems, but removing anyway as you requested:
247s wget depends on libssl3 (>= 3.0.0).
247s tnftp depends on libssl3 (>= 3.0.0).
247s tcpdump depends on libssl3 (>= 3.0.0).
247s systemd-resolved depends on libssl3 (>= 3.0.0).
247s systemd depends on libssl3 (>= 3.0.0).
247s sudo depends on libssl3 (>= 3.0.0).
247s rsync depends on libssl3 (>= 3.0.0).
247s python3-cryptography depends on libssl3 (>= 3.0.0).
247s linux-headers-6.8.0-11-generic depends on libssl3 (>= 3.0.0).
247s libsystemd-shared:ppc64el depends on libssl3 (>= 3.0.0).
247s libssh-4:ppc64el depends on libssl3 (>= 3.0.0).
247s libsasl2-modules:ppc64el depends on libssl3 (>= 3.0.0).
247s libsasl2-2:ppc64el depends on libssl3 (>= 3.0.0).
247s libpython3.12-minimal:ppc64el depends on libssl3 (>= 3.0.0).
247s libpython3.11-minimal:ppc64el depends on libssl3 (>= 3.0.0).
247s libnvme1 depends on libssl3 (>= 3.0.0).
247s libkrb5-3:ppc64el depends on libssl3 (>= 3.0.0).
247s libkmod2:ppc64el depends on libssl3 (>= 3.0.0).
247s libfido2-1:ppc64el depends on libssl3 (>= 3.0.0).
247s libcurl4:ppc64el depends on libssl3 (>= 3.0.0).
247s libcryptsetup12:ppc64el depends on libssl3 (>= 3.0.0).
247s kmod depends on libssl3 (>= 3.0.0).
247s dhcpcd-base depends on libssl3 (>= 3.0.0).
247s bind9-libs:ppc64el depends on libssl3 (>= 3.0.0).
247s
247s (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 ... 70095 files and directories currently installed.)
247s Removing libssl3:ppc64el (3.0.10-1ubuntu4) ...
247s Selecting previously unselected package libssl3t64:ppc64el.
247s (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 ... 70084 files and directories currently installed.)
247s Preparing to unpack .../libssl3t64_3.0.13-0ubuntu2_ppc64el.deb ...
247s Unpacking libssl3t64:ppc64el (3.0.13-0ubuntu2) ...
247s Preparing to unpack .../libglib2.0-data_2.79.3-3ubuntu5_all.deb ...
247s Unpacking libglib2.0-data (2.79.3-3ubuntu5) over (2.79.2-1~ubuntu1) ...
247s Preparing to unpack .../ubuntu-minimal_1.536build1_ppc64el.deb ...
247s Unpacking ubuntu-minimal (1.536build1) over (1.536) ...
247s Selecting previously unselected package xdg-user-dirs.
247s Preparing to unpack .../xdg-user-dirs_0.18-1_ppc64el.deb ...
247s Unpacking xdg-user-dirs (0.18-1) ...
247s Preparing to unpack .../ubuntu-standard_1.536build1_ppc64el.deb ...
247s Unpacking ubuntu-standard (1.536build1) over (1.536) ...
247s Setting up ubuntu-minimal (1.536build1) ...
247s Setting up xdg-user-dirs (0.18-1) ...
247s Setting up libssl3t64:ppc64el (3.0.13-0ubuntu2) ...
247s Setting up openssh-client (1:9.6p1-3ubuntu11) ...
247s Setting up ubuntu-standard (1.536build1) ...
247s Setting up libglib2.0-0t64:ppc64el (2.79.3-3ubuntu5) ...
247s No schema files found: doing nothing.
247s Setting up libglib2.0-data (2.79.3-3ubuntu5) ...
247s Setting up gir1.2-glib-2.0:ppc64el (2.79.3-3ubuntu5) ...
247s Setting up openssl (3.0.13-0ubuntu2) ...
247s Setting up openssh-sftp-server (1:9.6p1-3ubuntu11) ...
247s Setting up openssh-server (1:9.6p1-3ubuntu11) ...
247s Replacing config file /etc/ssh/sshd_config with new version
250s Created symlink /etc/systemd/system/ssh.service.requires/ssh.socket → /usr/lib/systemd/system/ssh.socket.
252s Processing triggers for ufw (0.36.2-5) ...
252s Processing triggers for man-db (2.12.0-3) ...
253s Processing triggers for libc-bin (2.39-0ubuntu2) ...
253s Reading package lists...
253s Building dependency tree...
253s Reading state information...
253s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
254s Hit:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease
254s Hit:2 http://ftpmaster.internal/ubuntu noble InRelease
254s Hit:3 http://ftpmaster.internal/ubuntu noble-updates InRelease
254s Hit:4 http://ftpmaster.internal/ubuntu noble-security InRelease
255s Reading package lists...
255s Reading package lists...
256s Building dependency tree...
256s Reading state information...
256s Calculating upgrade...
256s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
256s Reading package lists...
256s Building dependency tree...
256s Reading state information...
256s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
257s autopkgtest [23:16:54]: rebooting testbed after setup commands that affected boot
431s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds...
442s autopkgtest [23:19:59]: testbed running kernel: Linux 6.8.0-11-generic #11-Ubuntu SMP Wed Feb 14 00:33:03 UTC 2024
445s autopkgtest [23:20:02]: @@@@@@@@@@@@@@@@@@@@ apt-source libpam-mount
447s Get:1 http://ftpmaster.internal/ubuntu noble/main libpam-mount 2.20-3 (dsc) [2196 B]
447s Get:2 http://ftpmaster.internal/ubuntu noble/main libpam-mount 2.20-3 (tar) [325 kB]
447s Get:3 http://ftpmaster.internal/ubuntu noble/main libpam-mount 2.20-3 (diff) [29.0 kB]
447s gpgv: Signature made Sun Dec 17 05:49:05 2023 UTC
447s gpgv: using RSA key 73B299CBD4EEADDCC017E87A5BFFDCC258E69433
447s gpgv: Can't check signature: No public key
447s dpkg-source: warning: cannot verify inline signature for ./libpam-mount_2.20-3.dsc: no acceptable signature found
448s autopkgtest [23:20:05]: testing package libpam-mount version 2.20-3
448s autopkgtest [23:20:05]: build not needed
450s autopkgtest [23:20:07]: test local-luks: preparing testbed
451s Reading package lists...
451s Building dependency tree...
451s Reading state information...
452s Starting pkgProblemResolver with broken count: 0
452s Starting 2 pkgProblemResolver with broken count: 0
452s Done
452s The following additional packages will be installed:
452s cryptsetup hxtools libhx32 libpam-mount libpam-mount-bin
452s Suggested packages:
452s keyutils cifs-utils davfs2 sshfs
452s Recommended packages:
452s cryptsetup-initramfs
452s The following NEW packages will be installed:
452s autopkgtest-satdep cryptsetup hxtools libhx32 libpam-mount libpam-mount-bin
452s 0 upgraded, 6 newly installed, 0 to remove and 0 not upgraded.
452s Need to get 468 kB/469 kB of archives.
452s After this operation, 2497 kB of additional disk space will be used.
452s Get:1 /tmp/autopkgtest.MEKjm3/1-autopkgtest-satdep.deb autopkgtest-satdep ppc64el 0 [764 B]
452s Get:2 http://ftpmaster.internal/ubuntu noble/main ppc64el cryptsetup ppc64el 2:2.7.0-1ubuntu1 [208 kB]
453s Get:3 http://ftpmaster.internal/ubuntu noble/main ppc64el libhx32 ppc64el 4.19-1 [53.5 kB]
453s Get:4 http://ftpmaster.internal/ubuntu noble/universe ppc64el hxtools ppc64el 20231224-2 [106 kB]
453s Get:5 http://ftpmaster.internal/ubuntu noble/main ppc64el libpam-mount ppc64el 2.20-3 [67.8 kB]
453s Get:6 http://ftpmaster.internal/ubuntu noble/main ppc64el libpam-mount-bin ppc64el 2.20-3 [32.0 kB]
453s Preconfiguring packages ...
453s Fetched 468 kB in 1s (739 kB/s)
453s Selecting previously unselected package cryptsetup.
453s (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 ... 70111 files and directories currently installed.)
453s Preparing to unpack .../0-cryptsetup_2%3a2.7.0-1ubuntu1_ppc64el.deb ...
453s Unpacking cryptsetup (2:2.7.0-1ubuntu1) ...
453s Selecting previously unselected package libhx32:ppc64el.
453s Preparing to unpack .../1-libhx32_4.19-1_ppc64el.deb ...
453s Unpacking libhx32:ppc64el (4.19-1) ...
453s Selecting previously unselected package hxtools.
453s Preparing to unpack .../2-hxtools_20231224-2_ppc64el.deb ...
453s Unpacking hxtools (20231224-2) ...
453s Selecting previously unselected package libpam-mount:ppc64el.
453s Preparing to unpack .../3-libpam-mount_2.20-3_ppc64el.deb ...
453s Unpacking libpam-mount:ppc64el (2.20-3) ...
453s Selecting previously unselected package libpam-mount-bin.
453s Preparing to unpack .../4-libpam-mount-bin_2.20-3_ppc64el.deb ...
453s Unpacking libpam-mount-bin (2.20-3) ...
453s Selecting previously unselected package autopkgtest-satdep.
453s Preparing to unpack .../5-1-autopkgtest-satdep.deb ...
453s Unpacking autopkgtest-satdep (0) ...
453s Setting up libhx32:ppc64el (4.19-1) ...
453s Setting up cryptsetup (2:2.7.0-1ubuntu1) ...
454s Setting up hxtools (20231224-2) ...
454s Setting up libpam-mount:ppc64el (2.20-3) ...
454s Setting up libpam-mount-bin (2.20-3) ...
454s Setting up autopkgtest-satdep (0) ...
454s Processing triggers for man-db (2.12.0-3) ...
455s Processing triggers for libc-bin (2.39-0ubuntu2) ...
458s (Reading database ... 70362 files and directories currently installed.)
458s Removing autopkgtest-satdep (0) ...
459s autopkgtest [23:20:15]: test local-luks: [-----------------------
459s + echo libpam-mount is working
459s + openssl passwd -1 alice
459s + useradd -m --password $1$M4JuuRad$ohNG1mBcqc57/r9f5/vsD/ alice
459s + printf alice
459s + ssh-keygen -t rsa -N -f test.key
460s Generating public/private rsa key pair.
460s Your identification has been saved in test.key
460s Your public key has been saved in test.key.pub
460s The key fingerprint is:
460s SHA256:p2t6AyoKFFgJAVyQJoFqAII1ik/no1jkn0Xx37tzq8U root@autopkgtest
460s The key's randomart image is:
460s +---[RSA 3072]----+
460s |&*Bo . |
460s |O*.. o |
460s |O.o . . . |
460s |.*.o . . . |
460s |..+ o . S o . |
460s |.o o +. o o |
460s |o . o. .. . E |
460s |. . . +. .o. |
460s |.. . .+.. o+.. |
460s +----[SHA256]-----+
460s + mkdir -p /home/alice/.ssh
460s + chown alice:alice /home/alice/.ssh
460s + cp test.key.pub /home/alice/.ssh/authorized_keys
460s + mkdir -p /home/alice/img-luks1 /home/alice/img-luks2
460s + chown alice:alice /home/alice/.ssh/authorized_keys /home/alice/img-luks1 /home/alice/img-luks2
460s + createluks 1 luks
460s + id=1
460s + type=luks
460s + mktemp --directory
460s + tdir=/tmp/tmp.hpps3nHa8E
460s + fallocate -l 32M /tmp/disk-l1.img
460s + cryptsetup luksFormat --batch-mode --verbose --force-password --key-file=/home/alice/alice.key --type luks /tmp/disk-l1.img
466s Key slot 0 created.
466s Command successful.
466s + cryptsetup open --type luks --batch-mode --verbose --key-file=/home/alice/alice.key /tmp/disk-l1.img img-luks1
468s No usable token is available.
468s Key slot 0 unlocked.
468s Command successful.
468s + mkfs.ext4 -L IMG-LUKS1 /dev/mapper/img-luks1
468s mke2fs 1.47.0 (5-Feb-2023)
468s Creating filesystem with 4096 4k blocks and 4096 inodes
468s
468s Allocating group tables: 0/1 done
468s Writing inode tables: 0/1 done
468s Creating journal (1024 blocks): done
468s Writing superblocks and filesystem accounting information: 0/1 done
468s
468s + mount /dev/mapper/img-luks1 /tmp/tmp.hpps3nHa8E
468s + echo libpam-mount is working
468s + umount /dev/mapper/img-luks1
468s + cryptsetup close img-luks1
468s + createluks 2 luks2
468s + id=2
468s + type=luks2
468s + mktemp --directory
468s + tdir=/tmp/tmp.WMFU7MtobI
468s + fallocate -l 32M /tmp/disk-l2.img
468s + cryptsetup luksFormat --batch-mode --verbose --force-password --key-file=/home/alice/alice.key --type luks2 /tmp/disk-l2.img
474s + cryptsetup open --type luks2 --batch-mode --verbose --key-file=/home/alice/alice.key /tmp/disk-l2.img img-luks2
474s Key slot 0 created.
474s Command successful.
476s + No usable token is available.
476s Key slot 0 unlocked.
476s Command successful.
476s mkfs.ext4 -L IMG-LUKS2 /dev/mapper/img-luks2
476s mke2fs 1.47.0 (5-Feb-2023)
476s Creating filesystem with 4096 4k blocks and 4096 inodes
476s
476s Allocating group tables: 0/1 done
476s + mount /dev/mapper/img-luks2 /tmp/tmp.WMFU7MtobI
476s + echo libpam-mount is working
476s + umount /dev/mapper/img-luks2
476s + cryptsetup close img-luks2
476s Writing inode tables: 0/1 done
476s Creating journal (1024 blocks): done
476s Writing superblocks and filesystem accounting information: 0/1 done
476s
476s + checkluks 1
476s + id=1
476s + mktemp
476s + bckp=/tmp/tmp.4ATeIcjPS7
476s + cp /etc/security/pam_mount.conf.xml /tmp/tmp.4ATeIcjPS7
476s + sed -i -e s/debug enable="0"/debug enable="1"/ /etc/security/pam_mount.conf.xml
476s + sed -i -e //a /etc/security/pam_mount.conf.xml
476s + ssh -o StrictHostKeyChecking=no -i test.key alice@localhost ls -laF ~/img-luks1/testfile
476s Warning: Permanently added 'localhost' (ED25519) to the list of known hosts.
479s -rw-r--r-- 1 root root 24 Mar 19 23:20 /home/alice/img-luks1/testfile
479s + sleep 5s
484s + ssh -o StrictHostKeyChecking=no -i test.key alice@localhost mount
484s + grep img-luks1
486s /dev/mapper/_tmp_disk_l1_img on /home/alice/img-luks1 type ext4 (rw,relatime,helper=crypt)
486s + sleep 5s
491s + sed -i -e s/pam_mount.so\s*$/pam_mount.so disable_interactive/ /etc/pam.d/common-auth
491s + sed -i -e s/pam_mount.so\s*$/pam_mount.so disable_interactive/ /etc/pam.d/common-session
491s + su --login --command cat ~/img-luks1/testfile alice
491s (pam_mount.c:568): pam_mount 2.20: entering session stage
491s (mount.c:264): Mount info: globalconf, user=alice
491s (mount.c:678): Password will be sent to helper as-is.
491s command: 'mount' '-t' 'crypt' '-ofsk_cipher=none' '-ofsk_hash=md5' '-okeyfile=/home/alice/alice.key' '/tmp/disk-l1.img' '/home/alice/img-luks1'
494s (mount.c:567): 23 28 0:21 / /sys rw,nosuid,nodev,noexec,relatime shared:7 - sysfs sysfs rw
494s (mount.c:567): 24 28 0:22 / /proc rw,nosuid,nodev,noexec,relatime shared:12 - proc proc rw
494s (mount.c:567): 25 28 0:5 / /dev rw,nosuid,relatime shared:2 - devtmpfs udev rw,size=692096k,nr_inodes=10814,mode=755,inode64
494s (mount.c:567): 26 25 0:23 / /dev/pts rw,nosuid,noexec,relatime shared:3 - devpts devpts rw,gid=5,mode=620,ptmxmode=000
494s (mount.c:567): 27 28 0:24 / /run rw,nosuid,nodev,noexec,relatime shared:5 - tmpfs tmpfs rw,size=144448k,mode=755,inode64
494s (mount.c:567): 28 1 8:1 / / rw,relatime shared:1 - ext4 /dev/sda1 rw,discard,errors=remount-ro,commit=30
494s (mount.c:567): 29 23 0:6 / /sys/kernel/security rw,nosuid,nodev,noexec,relatime shared:8 - securityfs securityfs rw
494s (mount.c:567): 30 25 0:25 / /dev/shm rw,nosuid,nodev shared:4 - tmpfs tmpfs rw,inode64
494s (mount.c:567): 31 27 0:26 / /run/lock rw,nosuid,nodev,noexec,relatime shared:6 - tmpfs tmpfs rw,size=5120k,inode64
494s (mount.c:567): 32 23 0:27 / /sys/fs/cgroup rw,nosuid,nodev,noexec,relatime shared:9 - cgroup2 cgroup2 rw,nsdelegate,memory_recursiveprot
494s (mount.c:567): 33 23 0:28 / /sys/fs/pstore rw,nosuid,nodev,noexec,relatime shared:10 - pstore pstore rw
494s (mount.c:567): 34 23 0:29 / /sys/fs/bpf rw,nosuid,nodev,noexec,relatime shared:11 - bpf bpf rw,mode=700
494s (mount.c:567): 35 24 0:30 / /proc/sys/fs/binfmt_misc rw,relatime shared:13 - autofs systemd-1 rw,fd=32,pgrp=1,timeout=0,minproto=5,maxproto=5,direct,pipe_ino=2803
494s (mount.c:567): 36 25 0:31 / /dev/hugepages rw,nosuid,nodev,relatime shared:14 - hugetlbfs hugetlbfs rw,pagesize=2M
494s (mount.c:567): 37 25 0:19 / /dev/mqueue rw,nosuid,nodev,noexec,relatime shared:15 - mqueue mqueue rw
494s (mount.c:567): 38 23 0:7 / /sys/kernel/debug rw,nosuid,nodev,noexec,relatime shared:16 - debugfs debugfs rw
494s (mount.c:567): 39 23 0:12 / /sys/kernel/tracing rw,nosuid,nodev,noexec,relatime shared:17 - tracefs tracefs rw
494s (mount.c:567): 40 23 0:32 / /sys/fs/fuse/connections rw,nosuid,nodev,noexec,relatime shared:18 - fusectl fusectl rw
494s (mount.c:567): 41 23 0:20 / /sys/kernel/config rw,nosuid,nodev,noexec,relatime shared:19 - configfs configfs rw
494s (mount.c:567): 43 35 0:33 / /proc/sys/fs/binfmt_misc rw,nosuid,nodev,noexec,relatime shared:29 - binfmt_misc binfmt_misc rw
494s (mount.c:567): 49 27 0:44 / /run/user/1000 rw,nosuid,nodev,relatime shared:192 - tmpfs tmpfs rw,size=144384k,nr_inodes=36096,mode=700,uid=1000,gid=1000,inode64
494s (mount.c:567): 60 27 0:41 / /run/user/1001 rw,nosuid,nodev,relatime shared:194 - tmpfs tmpfs rw,size=144384k,nr_inodes=36096,mode=700,uid=1001,gid=1001,inode64
494s (mount.c:567): 48 28 252:0 / /home/alice/img-luks1 rw,relatime shared:159 - ext4 /dev/mapper/_tmp_disk_l1_img rw
494s command: 'pmvarrun' '-u' 'alice' '-o' '1'
494s (pmvarrun.c:261): parsed count value 0
494s (pam_mount.c:441): pmvarrun says login count is 1
494s (pam_mount.c:660): done opening session (ret=0)
494s (pam_mount.c:116): Clean global config (1073741824)
494s (pam_mount.c:706): received order to close things
494s command: 'pmvarrun' '-u' 'alice' '-o' '-1'
494s (pmvarrun.c:261): parsed count value 1
494s (pam_mount.c:441): pmvarrun says login count is 0
494s (mount.c:904): going to unmount
494s (mount.c:264): Mount info: globalconf, user=alice
494s command: 'ofl' '-k0' '/home/alice/img-luks1'
494s command: 'umount' '/home/alice/img-luks1'
494s (pam_mount.c:743): pam_mount execution complete
494s (pam_mount.c:116): Clean global config (0)
494s + sleep 5s
499s + cmp expected luks1
499s + ssh -o StrictHostKeyChecking=no -i test.key alice@localhost cat ~/img-luks1/testfile
501s + sleep 5s
506s + cmp expected luks1
506s + cp /tmp/tmp.4ATeIcjPS7 /etc/security/pam_mount.conf.xml
506s + checkluks 2
506s + id=2
506s + mktemp
506s + bckp=/tmp/tmp.WGGJvXpqkL
506s + cp /etc/security/pam_mount.conf.xml /tmp/tmp.WGGJvXpqkL
506s + sed -i -e s/debug enable="0"/debug enable="1"/ /etc/security/pam_mount.conf.xml
506s + sed -i -e //a /etc/security/pam_mount.conf.xml
506s + ssh -o StrictHostKeyChecking=no -i test.key alice@localhost ls -laF ~/img-luks2/testfile
509s -rw-r--r-- 1 root root 24 Mar 19 23:20 /home/alice/img-luks2/testfile
509s + sleep 5s
514s + + grep img-luks2
514s ssh -o StrictHostKeyChecking=no -i test.key alice@localhost mount
516s /dev/mapper/_tmp_disk_l2_img on /home/alice/img-luks2 type ext4 (rw,relatime,helper=crypt)
516s + sleep 5s
521s + sed -i -e s/pam_mount.so\s*$/pam_mount.so disable_interactive/ /etc/pam.d/common-auth
521s + sed -i -e s/pam_mount.so\s*$/pam_mount.so disable_interactive/ /etc/pam.d/common-session
521s + su --login --command cat ~/img-luks2/testfile alice
521s (pam_mount.c:568): pam_mount 2.20: entering session stage
521s (mount.c:264): Mount info: globalconf, user=alice
521s (mount.c:678): Password will be sent to helper as-is.
521s command: 'mount' '-t' 'crypt' '-ofsk_cipher=none' '-ofsk_hash=md5' '-okeyfile=/home/alice/alice.key' '/tmp/disk-l2.img' '/home/alice/img-luks2'
523s (mount.c:567): 23 28 0:21 / /sys rw,nosuid,nodev,noexec,relatime shared:7 - sysfs sysfs rw
523s (mount.c:567): 24 28 0:22 / /proc rw,nosuid,nodev,noexec,relatime shared:12 - proc proc rw
523s (mount.c:567): 25 28 0:5 / /dev rw,nosuid,relatime shared:2 - devtmpfs udev rw,size=692096k,nr_inodes=10814,mode=755,inode64
523s (mount.c:567): 26 25 0:23 / /dev/pts rw,nosuid,noexec,relatime shared:3 - devpts devpts rw,gid=5,mode=620,ptmxmode=000
523s (mount.c:567): 27 28 0:24 / /run rw,nosuid,nodev,noexec,relatime shared:5 - tmpfs tmpfs rw,size=144448k,mode=755,inode64
523s (mount.c:567): 28 1 8:1 / / rw,relatime shared:1 - ext4 /dev/sda1 rw,discard,errors=remount-ro,commit=30
523s (mount.c:567): 29 23 0:6 / /sys/kernel/security rw,nosuid,nodev,noexec,relatime shared:8 - securityfs securityfs rw
523s (mount.c:567): 30 25 0:25 / /dev/shm rw,nosuid,nodev shared:4 - tmpfs tmpfs rw,inode64
523s (mount.c:567): 31 27 0:26 / /run/lock rw,nosuid,nodev,noexec,relatime shared:6 - tmpfs tmpfs rw,size=5120k,inode64
523s (mount.c:567): 32 23 0:27 / /sys/fs/cgroup rw,nosuid,nodev,noexec,relatime shared:9 - cgroup2 cgroup2 rw,nsdelegate,memory_recursiveprot
523s (mount.c:567): 33 23 0:28 / /sys/fs/pstore rw,nosuid,nodev,noexec,relatime shared:10 - pstore pstore rw
523s (mount.c:567): 34 23 0:29 / /sys/fs/bpf rw,nosuid,nodev,noexec,relatime shared:11 - bpf bpf rw,mode=700
523s (mount.c:567): 35 24 0:30 / /proc/sys/fs/binfmt_misc rw,relatime shared:13 - autofs systemd-1 rw,fd=32,pgrp=1,timeout=0,minproto=5,maxproto=5,direct,pipe_ino=2803
523s (mount.c:567): 36 25 0:31 / /dev/hugepages rw,nosuid,nodev,relatime shared:14 - hugetlbfs hugetlbfs rw,pagesize=2M
523s (mount.c:567): 37 25 0:19 / /dev/mqueue rw,nosuid,nodev,noexec,relatime shared:15 - mqueue mqueue rw
523s (mount.c:567): 38 23 0:7 / /sys/kernel/debug rw,nosuid,nodev,noexec,relatime shared:16 - debugfs debugfs rw
523s (mount.c:567): 39 23 0:12 / /sys/kernel/tracing rw,nosuid,nodev,noexec,relatime shared:17 - tracefs tracefs rw
523s (mount.c:567): 40 23 0:32 / /sys/fs/fuse/connections rw,nosuid,nodev,noexec,relatime shared:18 - fusectl fusectl rw
523s (mount.c:567): 41 23 0:20 / /sys/kernel/config rw,nosuid,nodev,noexec,relatime shared:19 - configfs configfs rw
523s (mount.c:567): 43 35 0:33 / /proc/sys/fs/binfmt_misc rw,nosuid,nodev,noexec,relatime shared:29 - binfmt_misc binfmt_misc rw
523s (mount.c:567): 49 27 0:44 / /run/user/1000 rw,nosuid,nodev,relatime shared:192 - tmpfs tmpfs rw,size=144384k,nr_inodes=36096,mode=700,uid=1000,gid=1000,inode64
523s (mount.c:567): 60 27 0:41 / /run/user/1001 rw,nosuid,nodev,relatime shared:194 - tmpfs tmpfs rw,size=144384k,nr_inodes=36096,mode=700,uid=1001,gid=1001,inode64
523s (mount.c:567): 48 28 252:0 / /home/alice/img-luks2 rw,relatime shared:159 - ext4 /dev/mapper/_tmp_disk_l2_img rw
523s command: 'pmvarrun' '-u' 'alice' '-o' '1'
523s (pmvarrun.c:261): parsed count value 0
523s (pam_mount.c:441): pmvarrun says login count is 1
523s (pam_mount.c:660): done opening session (ret=0)
524s (pam_mount.c:116): Clean global config (1073741824)
524s (pam_mount.c:706): received order to close things
524s command: 'pmvarrun' '-u' 'alice' '-o' '-1'
524s (pmvarrun.c:261): parsed count value 1
524s (pam_mount.c:441): pmvarrun says login count is 0
524s (mount.c:904): going to unmount
524s (mount.c:264): Mount info: globalconf, user=alice
524s command: 'ofl' '-k0' '/home/alice/img-luks2'
524s command: 'umount' '/home/alice/img-luks2'
524s (pam_mount.c:743): pam_mount execution complete
524s (pam_mount.c:116): Clean global config (0)
524s + sleep 5s
529s + cmp expected luks2
529s + ssh -o StrictHostKeyChecking=no -i test.key alice@localhost cat ~/img-luks2/testfile
531s + sleep 5s
536s + cmp expected luks2
536s + cp /tmp/tmp.WGGJvXpqkL /etc/security/pam_mount.conf.xml
536s autopkgtest [23:21:33]: test local-luks: -----------------------]
537s autopkgtest [23:21:34]: test local-luks: - - - - - - - - - - results - - - - - - - - - -
537s local-luks PASS
537s autopkgtest [23:21:34]: @@@@@@@@@@@@@@@@@@@@ summary
537s local-luks PASS
554s Creating nova instance adt-noble-ppc64el-libpam-mount-20240319-224735-juju-7f2275-prod-proposed-migration-environment-2 from image adt/ubuntu-noble-ppc64el-server-20240319.img (UUID 9d87beed-6c32-481f-958d-7469e26317f3)...