0s autopkgtest [23:18:08]: starting date and time: 2024-03-19 23:18:08+0000
0s autopkgtest [23:18:08]: git checkout: 4a1cd702 l/adt_testbed: don't blame the testbed for unsolvable build deps
0s autopkgtest [23:18:08]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.ri1gb14i/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@bos02-arm64-20.secgroup --name adt-noble-arm64-libpam-mount-20240319-224006-juju-7f2275-prod-proposed-migration-environment-2 --image adt/ubuntu-noble-arm64-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://ftpmaster.internal/ubuntu/
132s autopkgtest [23:20:20]: testbed dpkg architecture: arm64
133s autopkgtest [23:20:21]: testbed apt version: 2.7.12
133s autopkgtest [23:20:21]: @@@@@@@@@@@@@@@@@@@@ test bed setup
134s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [117 kB]
135s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [6540 B]
135s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [52.7 kB]
135s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [492 kB]
136s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [3797 kB]
136s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 Packages [666 kB]
136s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 c-n-f Metadata [3144 B]
136s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted arm64 Packages [41.7 kB]
136s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted arm64 c-n-f Metadata [116 B]
136s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe arm64 Packages [4152 kB]
136s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/universe arm64 c-n-f Metadata [8528 B]
136s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/multiverse arm64 Packages [56.7 kB]
136s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/multiverse arm64 c-n-f Metadata [116 B]
146s Fetched 9393 kB in 5s (1928 kB/s)
147s Reading package lists...
152s Reading package lists...
153s Building dependency tree...
153s Reading state information...
154s Calculating upgrade...
155s The following packages will be REMOVED:
155s libglib2.0-0 libssl3
155s The following NEW packages will be installed:
155s libglib2.0-0t64 libssl3t64 xdg-user-dirs
155s The following packages will be upgraded:
155s gir1.2-glib-2.0 libglib2.0-data openssh-client openssh-server
155s openssh-sftp-server openssl
156s 6 upgraded, 3 newly installed, 2 to remove and 0 not upgraded.
156s Need to get 5973 kB of archives.
156s After this operation, 802 kB of additional disk space will be used.
156s Get:1 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 gir1.2-glib-2.0 arm64 2.79.3-3ubuntu5 [182 kB]
156s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 libglib2.0-0t64 arm64 2.79.3-3ubuntu5 [1527 kB]
157s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 openssl arm64 3.0.13-0ubuntu2 [985 kB]
157s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 openssh-sftp-server arm64 1:9.6p1-3ubuntu11 [36.8 kB]
157s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 openssh-server arm64 1:9.6p1-3ubuntu11 [501 kB]
157s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 openssh-client arm64 1:9.6p1-3ubuntu11 [884 kB]
157s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 libssl3t64 arm64 3.0.13-0ubuntu2 [1793 kB]
158s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 libglib2.0-data all 2.79.3-3ubuntu5 [46.6 kB]
158s Get:9 http://ftpmaster.internal/ubuntu noble/main arm64 xdg-user-dirs arm64 0.18-1 [18.1 kB]
159s Preconfiguring packages ...
159s Fetched 5973 kB in 2s (2646 kB/s)
159s (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 ... 75850 files and directories currently installed.)
159s Preparing to unpack .../gir1.2-glib-2.0_2.79.3-3ubuntu5_arm64.deb ...
159s Unpacking gir1.2-glib-2.0:arm64 (2.79.3-3ubuntu5) over (2.79.2-1~ubuntu1) ...
160s dpkg: libglib2.0-0:arm64: dependency problems, but removing anyway as you requested:
160s udisks2 depends on libglib2.0-0 (>= 2.77.0).
160s shared-mime-info depends on libglib2.0-0 (>= 2.75.3).
160s python3-gi depends on libglib2.0-0 (>= 2.77.0).
160s python3-dbus depends on libglib2.0-0 (>= 2.16.0).
160s netplan.io depends on libglib2.0-0 (>= 2.70.0).
160s netplan-generator depends on libglib2.0-0 (>= 2.70.0).
160s libxmlb2:arm64 depends on libglib2.0-0 (>= 2.54.0).
160s libvolume-key1:arm64 depends on libglib2.0-0 (>= 2.18.0).
160s libudisks2-0:arm64 depends on libglib2.0-0 (>= 2.75.3).
160s libqrtr-glib0:arm64 depends on libglib2.0-0 (>= 2.56).
160s libqmi-proxy depends on libglib2.0-0 (>= 2.30.0).
160s libqmi-glib5:arm64 depends on libglib2.0-0 (>= 2.54.0).
160s libpolkit-gobject-1-0:arm64 depends on libglib2.0-0 (>= 2.38.0).
160s libpolkit-agent-1-0:arm64 depends on libglib2.0-0 (>= 2.38.0).
160s libnetplan0:arm64 depends on libglib2.0-0 (>= 2.75.3).
160s libmm-glib0:arm64 depends on libglib2.0-0 (>= 2.62.0).
160s libmbim-proxy depends on libglib2.0-0 (>= 2.56).
160s libmbim-glib4:arm64 depends on libglib2.0-0 (>= 2.56).
160s libjson-glib-1.0-0:arm64 depends on libglib2.0-0 (>= 2.75.3).
160s libjcat1:arm64 depends on libglib2.0-0 (>= 2.75.3).
160s libgusb2:arm64 depends on libglib2.0-0 (>= 2.75.3).
160s libgudev-1.0-0:arm64 depends on libglib2.0-0 (>= 2.38.0).
160s libgirepository-1.0-1:arm64 depends on libglib2.0-0 (>= 2.79.0).
160s libfwupd2:arm64 depends on libglib2.0-0 (>= 2.79.0).
160s libblockdev3:arm64 depends on libglib2.0-0 (>= 2.42.2).
160s libblockdev-utils3:arm64 depends on libglib2.0-0 (>= 2.75.3).
160s libblockdev-swap3:arm64 depends on libglib2.0-0 (>= 2.42.2).
160s libblockdev-part3:arm64 depends on libglib2.0-0 (>= 2.42.2).
160s libblockdev-nvme3:arm64 depends on libglib2.0-0 (>= 2.42.2).
160s libblockdev-mdraid3:arm64 depends on libglib2.0-0 (>= 2.42.2).
160s libblockdev-loop3:arm64 depends on libglib2.0-0 (>= 2.42.2).
160s libblockdev-fs3:arm64 depends on libglib2.0-0 (>= 2.42.2).
160s libblockdev-crypto3:arm64 depends on libglib2.0-0 (>= 2.42.2).
160s fwupd depends on libglib2.0-0 (>= 2.79.0).
160s bolt depends on libglib2.0-0 (>= 2.56.0).
160s
160s (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 ... 75850 files and directories currently installed.)
160s Removing libglib2.0-0:arm64 (2.79.2-1~ubuntu1) ...
160s Selecting previously unselected package libglib2.0-0t64:arm64.
160s (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 ... 75825 files and directories currently installed.)
160s Preparing to unpack .../libglib2.0-0t64_2.79.3-3ubuntu5_arm64.deb ...
160s libglib2.0-0t64.preinst: Removing /var/lib/dpkg/info/libglib2.0-0:arm64.postrm to avoid loss of /usr/share/glib-2.0/schemas/gschemas.compiled...
160s removed '/var/lib/dpkg/info/libglib2.0-0:arm64.postrm'
160s Unpacking libglib2.0-0t64:arm64 (2.79.3-3ubuntu5) ...
160s Preparing to unpack .../openssl_3.0.13-0ubuntu2_arm64.deb ...
160s Unpacking openssl (3.0.13-0ubuntu2) over (3.0.10-1ubuntu4) ...
161s Preparing to unpack .../openssh-sftp-server_1%3a9.6p1-3ubuntu11_arm64.deb ...
161s Unpacking openssh-sftp-server (1:9.6p1-3ubuntu11) over (1:9.6p1-3ubuntu2) ...
161s Preparing to unpack .../openssh-server_1%3a9.6p1-3ubuntu11_arm64.deb ...
161s Unpacking openssh-server (1:9.6p1-3ubuntu11) over (1:9.6p1-3ubuntu2) ...
161s Preparing to unpack .../openssh-client_1%3a9.6p1-3ubuntu11_arm64.deb ...
161s Unpacking openssh-client (1:9.6p1-3ubuntu11) over (1:9.6p1-3ubuntu2) ...
162s dpkg: libssl3:arm64: dependency problems, but removing anyway as you requested:
162s wget depends on libssl3 (>= 3.0.0).
162s u-boot-tools depends on libssl3 (>= 3.0.0).
162s tnftp depends on libssl3 (>= 3.0.0).
162s tcpdump depends on libssl3 (>= 3.0.0).
162s systemd-resolved depends on libssl3 (>= 3.0.0).
162s systemd depends on libssl3 (>= 3.0.0).
162s sudo depends on libssl3 (>= 3.0.0).
162s sbsigntool depends on libssl3 (>= 3.0.0).
162s rsync depends on libssl3 (>= 3.0.0).
162s python3-cryptography depends on libssl3 (>= 3.0.0).
162s mtd-utils depends on libssl3 (>= 3.0.0).
162s mokutil depends on libssl3 (>= 3.0.0).
162s linux-headers-6.8.0-11-generic depends on libssl3 (>= 3.0.0).
162s libsystemd-shared:arm64 depends on libssl3 (>= 3.0.0).
162s libssh-4:arm64 depends on libssl3 (>= 3.0.0).
162s libsasl2-modules:arm64 depends on libssl3 (>= 3.0.0).
162s libsasl2-2:arm64 depends on libssl3 (>= 3.0.0).
162s libpython3.12-minimal:arm64 depends on libssl3 (>= 3.0.0).
162s libpython3.11-minimal:arm64 depends on libssl3 (>= 3.0.0).
162s libnvme1 depends on libssl3 (>= 3.0.0).
162s libkrb5-3:arm64 depends on libssl3 (>= 3.0.0).
162s libkmod2:arm64 depends on libssl3 (>= 3.0.0).
162s libfido2-1:arm64 depends on libssl3 (>= 3.0.0).
162s libcurl4:arm64 depends on libssl3 (>= 3.0.0).
162s libcryptsetup12:arm64 depends on libssl3 (>= 3.0.0).
162s kmod depends on libssl3 (>= 3.0.0).
162s dhcpcd-base depends on libssl3 (>= 3.0.0).
162s bind9-libs:arm64 depends on libssl3 (>= 3.0.0).
162s
162s (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 ... 75850 files and directories currently installed.)
162s Removing libssl3:arm64 (3.0.10-1ubuntu4) ...
162s Selecting previously unselected package libssl3t64:arm64.
162s (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 ... 75839 files and directories currently installed.)
162s Preparing to unpack .../libssl3t64_3.0.13-0ubuntu2_arm64.deb ...
162s Unpacking libssl3t64:arm64 (3.0.13-0ubuntu2) ...
162s Preparing to unpack .../libglib2.0-data_2.79.3-3ubuntu5_all.deb ...
162s Unpacking libglib2.0-data (2.79.3-3ubuntu5) over (2.79.2-1~ubuntu1) ...
162s Selecting previously unselected package xdg-user-dirs.
162s Preparing to unpack .../xdg-user-dirs_0.18-1_arm64.deb ...
162s Unpacking xdg-user-dirs (0.18-1) ...
162s Setting up xdg-user-dirs (0.18-1) ...
162s Setting up libssl3t64:arm64 (3.0.13-0ubuntu2) ...
162s Setting up openssh-client (1:9.6p1-3ubuntu11) ...
162s Setting up libglib2.0-0t64:arm64 (2.79.3-3ubuntu5) ...
162s No schema files found: doing nothing.
162s Setting up libglib2.0-data (2.79.3-3ubuntu5) ...
162s Setting up gir1.2-glib-2.0:arm64 (2.79.3-3ubuntu5) ...
162s Setting up openssl (3.0.13-0ubuntu2) ...
162s Setting up openssh-sftp-server (1:9.6p1-3ubuntu11) ...
162s Setting up openssh-server (1:9.6p1-3ubuntu11) ...
163s Replacing config file /etc/ssh/sshd_config with new version
169s Created symlink /etc/systemd/system/ssh.service.requires/ssh.socket → /usr/lib/systemd/system/ssh.socket.
176s Processing triggers for ufw (0.36.2-5) ...
177s Processing triggers for man-db (2.12.0-3) ...
178s Processing triggers for libc-bin (2.39-0ubuntu2) ...
179s Reading package lists...
180s Building dependency tree...
180s Reading state information...
182s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
182s Hit:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease
183s Hit:2 http://ftpmaster.internal/ubuntu noble InRelease
183s Hit:3 http://ftpmaster.internal/ubuntu noble-updates InRelease
183s Hit:4 http://ftpmaster.internal/ubuntu noble-security InRelease
188s Reading package lists...
188s Reading package lists...
189s Building dependency tree...
189s Reading state information...
190s Calculating upgrade...
191s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
191s Reading package lists...
192s Building dependency tree...
192s Reading state information...
194s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
195s autopkgtest [23:21:23]: rebooting testbed after setup commands that affected boot
360s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds...
369s autopkgtest [23:24:17]: testbed running kernel: Linux 6.8.0-11-generic #11-Ubuntu SMP PREEMPT_DYNAMIC Wed Feb 14 02:53:31 UTC 2024
373s autopkgtest [23:24:21]: @@@@@@@@@@@@@@@@@@@@ apt-source libpam-mount
379s Get:1 http://ftpmaster.internal/ubuntu noble/main libpam-mount 2.20-3 (dsc) [2196 B]
379s Get:2 http://ftpmaster.internal/ubuntu noble/main libpam-mount 2.20-3 (tar) [325 kB]
379s Get:3 http://ftpmaster.internal/ubuntu noble/main libpam-mount 2.20-3 (diff) [29.0 kB]
380s gpgv: Signature made Sun Dec 17 05:49:05 2023 UTC
380s gpgv: using RSA key 73B299CBD4EEADDCC017E87A5BFFDCC258E69433
380s gpgv: Can't check signature: No public key
380s dpkg-source: warning: cannot verify inline signature for ./libpam-mount_2.20-3.dsc: no acceptable signature found
380s autopkgtest [23:24:28]: testing package libpam-mount version 2.20-3
381s autopkgtest [23:24:29]: build not needed
383s autopkgtest [23:24:31]: test local-luks: preparing testbed
387s Reading package lists...
388s Building dependency tree...
388s Reading state information...
389s Starting pkgProblemResolver with broken count: 0
390s Starting 2 pkgProblemResolver with broken count: 0
390s Done
391s The following additional packages will be installed:
391s cryptsetup hxtools libhx32 libpam-mount libpam-mount-bin
391s Suggested packages:
391s keyutils cifs-utils davfs2 sshfs
391s Recommended packages:
391s cryptsetup-initramfs
392s The following NEW packages will be installed:
392s autopkgtest-satdep cryptsetup hxtools libhx32 libpam-mount libpam-mount-bin
392s 0 upgraded, 6 newly installed, 0 to remove and 0 not upgraded.
392s Need to get 439 kB/440 kB of archives.
392s After this operation, 2495 kB of additional disk space will be used.
392s Get:1 /tmp/autopkgtest.XLAuQd/1-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [764 B]
392s Get:2 http://ftpmaster.internal/ubuntu noble/main arm64 cryptsetup arm64 2:2.7.0-1ubuntu1 [208 kB]
392s Get:3 http://ftpmaster.internal/ubuntu noble/main arm64 libhx32 arm64 4.19-1 [43.1 kB]
392s Get:4 http://ftpmaster.internal/ubuntu noble/universe arm64 hxtools arm64 20231224-2 [97.4 kB]
393s Get:5 http://ftpmaster.internal/ubuntu noble/main arm64 libpam-mount arm64 2.20-3 [61.6 kB]
393s Get:6 http://ftpmaster.internal/ubuntu noble/main arm64 libpam-mount-bin arm64 2.20-3 [29.1 kB]
394s Preconfiguring packages ...
394s Fetched 439 kB in 1s (494 kB/s)
394s Selecting previously unselected package cryptsetup.
394s (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 ... 75866 files and directories currently installed.)
395s Preparing to unpack .../0-cryptsetup_2%3a2.7.0-1ubuntu1_arm64.deb ...
395s Unpacking cryptsetup (2:2.7.0-1ubuntu1) ...
395s Selecting previously unselected package libhx32:arm64.
395s Preparing to unpack .../1-libhx32_4.19-1_arm64.deb ...
395s Unpacking libhx32:arm64 (4.19-1) ...
395s Selecting previously unselected package hxtools.
395s Preparing to unpack .../2-hxtools_20231224-2_arm64.deb ...
395s Unpacking hxtools (20231224-2) ...
395s Selecting previously unselected package libpam-mount:arm64.
395s Preparing to unpack .../3-libpam-mount_2.20-3_arm64.deb ...
395s Unpacking libpam-mount:arm64 (2.20-3) ...
395s Selecting previously unselected package libpam-mount-bin.
395s Preparing to unpack .../4-libpam-mount-bin_2.20-3_arm64.deb ...
395s Unpacking libpam-mount-bin (2.20-3) ...
395s Selecting previously unselected package autopkgtest-satdep.
395s Preparing to unpack .../5-1-autopkgtest-satdep.deb ...
395s Unpacking autopkgtest-satdep (0) ...
395s Setting up libhx32:arm64 (4.19-1) ...
395s Setting up cryptsetup (2:2.7.0-1ubuntu1) ...
399s Setting up hxtools (20231224-2) ...
399s Setting up libpam-mount:arm64 (2.20-3) ...
399s Setting up libpam-mount-bin (2.20-3) ...
399s Setting up autopkgtest-satdep (0) ...
399s Processing triggers for man-db (2.12.0-3) ...
401s Processing triggers for libc-bin (2.39-0ubuntu2) ...
411s (Reading database ... 76117 files and directories currently installed.)
411s Removing autopkgtest-satdep (0) ...
412s autopkgtest [23:25:00]: test local-luks: [-----------------------
413s + echo libpam-mount is working
413s + openssl passwd -1 alice
413s + useradd -m --password $1$H40rsLmC$boRyyM4wGGkHd8isyIHzK0 alice
413s + printf alice
413s + ssh-keygen -t rsa -N -f test.key
415s Generating public/private rsa key pair.
415s Your identification has been saved in test.key
415s Your public key has been saved in test.key.pub
415s The key fingerprint is:
415s SHA256:FQIlzz5T6Bhu0dvQN2XsYivCiCtamegWBAm/+3T8vXc root@autopkgtest
415s The key's randomart image is:
415s +---[RSA 3072]----+
415s |o. ooo . .o |
415s |o. = + . o. |
415s |. . o * + o. |
415s | . . . * * .o.. |
415s |. . .+oS .. o |
415s | o +.o. oo. . |
415s |. * ..o . . |
415s |.o.o.. . . . E |
415s |oo .. . oo . |
415s +----[SHA256]-----+
415s + mkdir -p /home/alice/.ssh
415s + chown alice:alice /home/alice/.ssh
415s + cp test.key.pub /home/alice/.ssh/authorized_keys
415s + mkdir -p /home/alice/img-luks1 /home/alice/img-luks2
415s + chown alice:alice /home/alice/.ssh/authorized_keys /home/alice/img-luks1 /home/alice/img-luks2
415s + createluks 1 luks
415s + id=1
415s + type=luks
415s + mktemp --directory
415s + tdir=/tmp/tmp.KrvfLcPpvY
415s + fallocate -l 32M /tmp/disk-l1.img
415s + cryptsetup luksFormat --batch-mode --verbose --force-password --key-file=/home/alice/alice.key --type luks /tmp/disk-l1.img
427s Key slot 0 created.
427s Command successful.
427s + cryptsetup open --type luks --batch-mode --verbose --key-file=/home/alice/alice.key /tmp/disk-l1.img img-luks1
429s No usable token is available.
429s Key slot 0 unlocked.
429s Command successful.
429s + mkfs.ext4 -L IMG-LUKS1 /dev/mapper/img-luks1
430s mke2fs 1.47.0 (5-Feb-2023)
430s Creating filesystem with 4096 4k blocks and 4096 inodes
430s
430s Allocating group tables: 0/1 done
430s Writing inode tables: 0/1 done
430s Creating journal (1024 blocks): done
430s Writing superblocks and filesystem accounting information: 0/1 done
430s
430s + mount /dev/mapper/img-luks1 /tmp/tmp.KrvfLcPpvY
430s + echo libpam-mount is working
430s + umount /dev/mapper/img-luks1
430s + cryptsetup close img-luks1
430s + createluks 2 luks2
430s + id=2
430s + type=luks2
430s + mktemp --directory
430s + tdir=/tmp/tmp.Kdyg8HDREH
430s + fallocate -l 32M /tmp/disk-l2.img
430s + cryptsetup luksFormat --batch-mode --verbose --force-password --key-file=/home/alice/alice.key --type luks2 /tmp/disk-l2.img
440s Key slot 0 created.
440s Command successful.
440s + cryptsetup open --type luks2 --batch-mode --verbose --key-file=/home/alice/alice.key /tmp/disk-l2.img img-luks2
442s No usable token is available.
442s Key slot 0 unlocked.
442s Command successful.
442s + mkfs.ext4 -L IMG-LUKS2 /dev/mapper/img-luks2
442s mke2fs 1.47.0 (5-Feb-2023)
442s Creating filesystem with 4096 4k blocks and 4096 inodes
442s
442s Allocating group tables: 0/1 done
442s Writing inode tables: 0/1 done
442s Creating journal (1024 blocks): done
442s Writing superblocks and filesystem accounting information: 0/1 done
442s
442s + mount /dev/mapper/img-luks2 /tmp/tmp.Kdyg8HDREH
442s + echo libpam-mount is working
442s + umount /dev/mapper/img-luks2
442s + cryptsetup close img-luks2
442s + checkluks 1
442s + id=1
442s + mktemp
442s + bckp=/tmp/tmp.3AwPWJ8t9x
442s + cp /etc/security/pam_mount.conf.xml /tmp/tmp.3AwPWJ8t9x
442s + sed -i -e s/debug enable="0"/debug enable="1"/ /etc/security/pam_mount.conf.xml
442s + sed -i -e //a /etc/security/pam_mount.conf.xml
442s + ssh -o StrictHostKeyChecking=no -i test.key alice@localhost ls -laF ~/img-luks1/testfile
443s Warning: Permanently added 'localhost' (ED25519) to the list of known hosts.
446s -rw-r--r-- 1 root root 24 Mar 19 23:25 /home/alice/img-luks1/testfile
446s + sleep 5s
451s + ssh -o StrictHostKeyChecking=no -i test.key alice@localhost mount
451s + grep img-luks1
454s /dev/mapper/_tmp_disk_l1_img on /home/alice/img-luks1 type ext4 (rw,relatime,helper=crypt)
454s + sleep 5s
459s + sed -i -e s/pam_mount.so\s*$/pam_mount.so disable_interactive/ /etc/pam.d/common-auth
459s + sed -i -e s/pam_mount.so\s*$/pam_mount.so disable_interactive/ /etc/pam.d/common-session
459s + su --login --command cat ~/img-luks1/testfile alice
459s (pam_mount.c:568): pam_mount 2.20: entering session stage
459s (mount.c:264): Mount info: globalconf, user=alice
459s (mount.c:678): Password will be sent to helper as-is.
459s command: 'mount' '-t' 'crypt' '-ofsk_cipher=none' '-ofsk_hash=md5' '-okeyfile=/home/alice/alice.key' '/tmp/disk-l1.img' '/home/alice/img-luks1'
462s (mount.c:567): 26 31 0:24 / /sys rw,nosuid,nodev,noexec,relatime shared:7 - sysfs sysfs rw
462s (mount.c:567): 27 31 0:25 / /proc rw,nosuid,nodev,noexec,relatime shared:13 - proc proc rw
462s (mount.c:567): 28 31 0:5 / /dev rw,nosuid,relatime shared:2 - devtmpfs udev rw,size=691116k,nr_inodes=172779,mode=755,inode64
462s (mount.c:567): 29 28 0:26 / /dev/pts rw,nosuid,noexec,relatime shared:3 - devpts devpts rw,gid=5,mode=620,ptmxmode=000
462s (mount.c:567): 30 31 0:27 / /run rw,nosuid,nodev,noexec,relatime shared:5 - tmpfs tmpfs rw,size=148840k,mode=755,inode64
462s (mount.c:567): 31 1 8:1 / / rw,relatime shared:1 - ext4 /dev/sda1 rw,discard,errors=remount-ro,commit=30
462s (mount.c:567): 32 26 0:6 / /sys/kernel/security rw,nosuid,nodev,noexec,relatime shared:8 - securityfs securityfs rw
462s (mount.c:567): 33 28 0:28 / /dev/shm rw,nosuid,nodev shared:4 - tmpfs tmpfs rw,inode64
462s (mount.c:567): 34 30 0:29 / /run/lock rw,nosuid,nodev,noexec,relatime shared:6 - tmpfs tmpfs rw,size=5120k,inode64
462s (mount.c:567): 35 26 0:30 / /sys/fs/cgroup rw,nosuid,nodev,noexec,relatime shared:9 - cgroup2 cgroup2 rw,nsdelegate,memory_recursiveprot
462s (mount.c:567): 36 26 0:31 / /sys/fs/pstore rw,nosuid,nodev,noexec,relatime shared:10 - pstore pstore rw
462s (mount.c:567): 37 26 0:32 / /sys/firmware/efi/efivars rw,nosuid,nodev,noexec,relatime shared:11 - efivarfs efivarfs rw
462s (mount.c:567): 38 26 0:33 / /sys/fs/bpf rw,nosuid,nodev,noexec,relatime shared:12 - bpf bpf rw,mode=700
462s (mount.c:567): 39 27 0:34 / /proc/sys/fs/binfmt_misc rw,relatime shared:14 - autofs systemd-1 rw,fd=32,pgrp=1,timeout=0,minproto=5,maxproto=5,direct,pipe_ino=4413
462s (mount.c:567): 40 28 0:35 / /dev/hugepages rw,nosuid,nodev,relatime shared:15 - hugetlbfs hugetlbfs rw,pagesize=2M
462s (mount.c:567): 41 28 0:22 / /dev/mqueue rw,nosuid,nodev,noexec,relatime shared:16 - mqueue mqueue rw
462s (mount.c:567): 42 26 0:7 / /sys/kernel/debug rw,nosuid,nodev,noexec,relatime shared:17 - debugfs debugfs rw
462s (mount.c:567): 43 26 0:12 / /sys/kernel/tracing rw,nosuid,nodev,noexec,relatime shared:18 - tracefs tracefs rw
462s (mount.c:567): 44 26 0:36 / /sys/fs/fuse/connections rw,nosuid,nodev,noexec,relatime shared:19 - fusectl fusectl rw
462s (mount.c:567): 45 26 0:23 / /sys/kernel/config rw,nosuid,nodev,noexec,relatime shared:20 - configfs configfs rw
462s (mount.c:567): 47 31 259:0 / /boot rw,relatime shared:30 - ext4 /dev/sda16 rw
462s (mount.c:567): 49 47 8:15 / /boot/efi rw,relatime shared:46 - vfat /dev/sda15 rw,fmask=0077,dmask=0077,codepage=437,iocharset=iso8859-1,shortname=mixed,errors=remount-ro
462s (mount.c:567): 51 39 0:37 / /proc/sys/fs/binfmt_misc rw,nosuid,nodev,noexec,relatime shared:48 - binfmt_misc binfmt_misc rw
462s (mount.c:567): 57 30 0:48 / /run/user/1000 rw,nosuid,nodev,relatime shared:210 - tmpfs tmpfs rw,size=148836k,nr_inodes=37209,mode=700,uid=1000,gid=1000,inode64
462s (mount.c:567): 92 30 0:45 / /run/user/1001 rw,nosuid,nodev,relatime shared:212 - tmpfs tmpfs rw,size=148836k,nr_inodes=37209,mode=700,uid=1001,gid=1001,inode64
462s (mount.c:567): 56 31 252:0 / /home/alice/img-luks1 rw,relatime shared:174 - ext4 /dev/mapper/_tmp_disk_l1_img rw
462s command: 'pmvarrun' '-u' 'alice' '-o' '1'
462s (pmvarrun.c:261): parsed count value 0
462s (pam_mount.c:441): pmvarrun says login count is 1
462s (pam_mount.c:660): done opening session (ret=0)
462s (pam_mount.c:116): Clean global config (1073741824)
462s (pam_mount.c:706): received order to close things
462s command: 'pmvarrun' '-u' 'alice' '-o' '-1'
462s (pmvarrun.c:261): parsed count value 1
462s (pam_mount.c:441): pmvarrun says login count is 0
462s (mount.c:904): going to unmount
462s (mount.c:264): Mount info: globalconf, user=alice
462s command: 'ofl' '-k0' '/home/alice/img-luks1'
462s command: 'umount' '/home/alice/img-luks1'
462s (pam_mount.c:743): pam_mount execution complete
462s (pam_mount.c:116): Clean global config (0)
462s + sleep 5s
467s + cmp expected luks1
467s + ssh -o StrictHostKeyChecking=no -i test.key alice@localhost cat ~/img-luks1/testfile
471s + sleep 5s
476s + cmp expected luks1
476s + cp /tmp/tmp.3AwPWJ8t9x /etc/security/pam_mount.conf.xml
476s + checkluks 2
476s + id=2
476s + mktemp
476s + bckp=/tmp/tmp.JA1ynIeygj
476s + cp /etc/security/pam_mount.conf.xml /tmp/tmp.JA1ynIeygj
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-luks2/testfile
479s -rw-r--r-- 1 root root 24 Mar 19 23:25 /home/alice/img-luks2/testfile
479s + sleep 5s
484s + + grep img-luks2
484s ssh -o StrictHostKeyChecking=no -i test.key alice@localhost mount
487s /dev/mapper/_tmp_disk_l2_img on /home/alice/img-luks2 type ext4 (rw,relatime,helper=crypt)
487s + sleep 5s
492s + sed -i -e s/pam_mount.so\s*$/pam_mount.so disable_interactive/ /etc/pam.d/common-auth
492s + sed -i -e s/pam_mount.so\s*$/pam_mount.so disable_interactive/ /etc/pam.d/common-session
492s + su --login --command cat ~/img-luks2/testfile alice
492s (pam_mount.c:568): pam_mount 2.20: entering session stage
492s (mount.c:264): Mount info: globalconf, user=alice
492s (mount.c:678): Password will be sent to helper as-is.
492s command: 'mount' '-t' 'crypt' '-ofsk_cipher=none' '-ofsk_hash=md5' '-okeyfile=/home/alice/alice.key' '/tmp/disk-l2.img' '/home/alice/img-luks2'
494s (mount.c:567): 26 31 0:24 / /sys rw,nosuid,nodev,noexec,relatime shared:7 - sysfs sysfs rw
494s (mount.c:567): 27 31 0:25 / /proc rw,nosuid,nodev,noexec,relatime shared:13 - proc proc rw
494s (mount.c:567): 28 31 0:5 / /dev rw,nosuid,relatime shared:2 - devtmpfs udev rw,size=691116k,nr_inodes=172779,mode=755,inode64
494s (mount.c:567): 29 28 0:26 / /dev/pts rw,nosuid,noexec,relatime shared:3 - devpts devpts rw,gid=5,mode=620,ptmxmode=000
494s (mount.c:567): 30 31 0:27 / /run rw,nosuid,nodev,noexec,relatime shared:5 - tmpfs tmpfs rw,size=148840k,mode=755,inode64
494s (mount.c:567): 31 1 8:1 / / rw,relatime shared:1 - ext4 /dev/sda1 rw,discard,errors=remount-ro,commit=30
494s (mount.c:567): 32 26 0:6 / /sys/kernel/security rw,nosuid,nodev,noexec,relatime shared:8 - securityfs securityfs rw
494s (mount.c:567): 33 28 0:28 / /dev/shm rw,nosuid,nodev shared:4 - tmpfs tmpfs rw,inode64
494s (mount.c:567): 34 30 0:29 / /run/lock rw,nosuid,nodev,noexec,relatime shared:6 - tmpfs tmpfs rw,size=5120k,inode64
494s (mount.c:567): 35 26 0:30 / /sys/fs/cgroup rw,nosuid,nodev,noexec,relatime shared:9 - cgroup2 cgroup2 rw,nsdelegate,memory_recursiveprot
494s (mount.c:567): 36 26 0:31 / /sys/fs/pstore rw,nosuid,nodev,noexec,relatime shared:10 - pstore pstore rw
494s (mount.c:567): 37 26 0:32 / /sys/firmware/efi/efivars rw,nosuid,nodev,noexec,relatime shared:11 - efivarfs efivarfs rw
494s (mount.c:567): 38 26 0:33 / /sys/fs/bpf rw,nosuid,nodev,noexec,relatime shared:12 - bpf bpf rw,mode=700
494s (mount.c:567): 39 27 0:34 / /proc/sys/fs/binfmt_misc rw,relatime shared:14 - autofs systemd-1 rw,fd=32,pgrp=1,timeout=0,minproto=5,maxproto=5,direct,pipe_ino=4413
494s (mount.c:567): 40 28 0:35 / /dev/hugepages rw,nosuid,nodev,relatime shared:15 - hugetlbfs hugetlbfs rw,pagesize=2M
494s (mount.c:567): 41 28 0:22 / /dev/mqueue rw,nosuid,nodev,noexec,relatime shared:16 - mqueue mqueue rw
494s (mount.c:567): 42 26 0:7 / /sys/kernel/debug rw,nosuid,nodev,noexec,relatime shared:17 - debugfs debugfs rw
494s (mount.c:567): 43 26 0:12 / /sys/kernel/tracing rw,nosuid,nodev,noexec,relatime shared:18 - tracefs tracefs rw
494s (mount.c:567): 44 26 0:36 / /sys/fs/fuse/connections rw,nosuid,nodev,noexec,relatime shared:19 - fusectl fusectl rw
494s (mount.c:567): 45 26 0:23 / /sys/kernel/config rw,nosuid,nodev,noexec,relatime shared:20 - configfs configfs rw
494s (mount.c:567): 47 31 259:0 / /boot rw,relatime shared:30 - ext4 /dev/sda16 rw
494s (mount.c:567): 49 47 8:15 / /boot/efi rw,relatime shared:46 - vfat /dev/sda15 rw,fmask=0077,dmask=0077,codepage=437,iocharset=iso8859-1,shortname=mixed,errors=remount-ro
494s (mount.c:567): 51 39 0:37 / /proc/sys/fs/binfmt_misc rw,nosuid,nodev,noexec,relatime shared:48 - binfmt_misc binfmt_misc rw
494s (mount.c:567): 57 30 0:48 / /run/user/1000 rw,nosuid,nodev,relatime shared:210 - tmpfs tmpfs rw,size=148836k,nr_inodes=37209,mode=700,uid=1000,gid=1000,inode64
494s (mount.c:567): 92 30 0:45 / /run/user/1001 rw,nosuid,nodev,relatime shared:212 - tmpfs tmpfs rw,size=148836k,nr_inodes=37209,mode=700,uid=1001,gid=1001,inode64
494s (mount.c:567): 56 31 252:0 / /home/alice/img-luks2 rw,relatime shared:174 - ext4 /dev/mapper/_tmp_disk_l2_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-luks2'
494s command: 'umount' '/home/alice/img-luks2'
494s (pam_mount.c:743): pam_mount execution complete
494s (pam_mount.c:116): Clean global config (0)
494s + sleep 5s
499s + cmp expected luks2
499s + ssh -o StrictHostKeyChecking=no -i test.key alice@localhost cat ~/img-luks2/testfile
503s + sleep 5s
508s + cmp expected luks2
508s + cp /tmp/tmp.JA1ynIeygj /etc/security/pam_mount.conf.xml
508s autopkgtest [23:26:36]: test local-luks: -----------------------]
509s autopkgtest [23:26:37]: test local-luks: - - - - - - - - - - results - - - - - - - - - -
509s local-luks PASS
510s autopkgtest [23:26:38]: @@@@@@@@@@@@@@@@@@@@ summary
510s local-luks PASS
525s Creating nova instance adt-noble-arm64-libpam-mount-20240319-224006-juju-7f2275-prod-proposed-migration-environment-2 from image adt/ubuntu-noble-arm64-server-20240319.img (UUID bfed3386-9aa1-4bc1-82f0-b2c10d5a6a9e)...