0s autopkgtest [14:12:46]: starting date and time: 2025-03-15 14:12:46+0000 0s autopkgtest [14:12:46]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [14:12:46]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work._r2hmom7/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:glibc --apt-upgrade pdfcrack --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=glibc/2.41-1ubuntu2 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-arm64-7.secgroup --name adt-plucky-arm64-pdfcrack-20250315-141246-juju-7f2275-prod-proposed-migration-environment-2-3147c9dc-c61f-48a0-988e-eb181edca5ef --image adt/ubuntu-plucky-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,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com,radosgw.ps5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 169s autopkgtest [14:15:35]: testbed dpkg architecture: arm64 169s autopkgtest [14:15:35]: testbed apt version: 2.9.33 170s autopkgtest [14:15:36]: @@@@@@@@@@@@@@@@@@@@ test bed setup 170s autopkgtest [14:15:36]: testbed release detected to be: None 171s autopkgtest [14:15:37]: updating testbed package index (apt update) 172s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [126 kB] 172s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 172s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 172s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 172s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [404 kB] 172s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [101 kB] 172s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.8 kB] 172s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 Packages [78.2 kB] 172s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 c-n-f Metadata [1976 B] 172s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted arm64 c-n-f Metadata [116 B] 172s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 Packages [346 kB] 173s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 c-n-f Metadata [15.8 kB] 173s Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse arm64 Packages [4948 B] 173s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse arm64 c-n-f Metadata [572 B] 173s Fetched 1094 kB in 1s (801 kB/s) 174s Reading package lists... 175s Reading package lists... 176s Building dependency tree... 176s Reading state information... 176s Calculating upgrade... 176s Calculating upgrade... 177s The following packages will be upgraded: 177s python3-jinja2 strace 177s 2 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 177s Need to get 608 kB of archives. 177s After this operation, 11.3 kB of additional disk space will be used. 177s Get:1 http://ftpmaster.internal/ubuntu plucky/main arm64 strace arm64 6.13+ds-1ubuntu1 [499 kB] 178s Get:2 http://ftpmaster.internal/ubuntu plucky/main arm64 python3-jinja2 all 3.1.5-2ubuntu1 [109 kB] 179s Fetched 608 kB in 1s (645 kB/s) 179s (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 ... 117701 files and directories currently installed.) 179s Preparing to unpack .../strace_6.13+ds-1ubuntu1_arm64.deb ... 179s Unpacking strace (6.13+ds-1ubuntu1) over (6.11-0ubuntu1) ... 179s Preparing to unpack .../python3-jinja2_3.1.5-2ubuntu1_all.deb ... 179s Unpacking python3-jinja2 (3.1.5-2ubuntu1) over (3.1.5-2) ... 179s Setting up python3-jinja2 (3.1.5-2ubuntu1) ... 180s Setting up strace (6.13+ds-1ubuntu1) ... 180s Processing triggers for man-db (2.13.0-1) ... 181s Reading package lists... 181s Building dependency tree... 181s Reading state information... 182s Solving dependencies... 183s The following packages will be REMOVED: 183s libnsl2* libpython3.12-minimal* libpython3.12-stdlib* libpython3.12t64* 183s libunwind8* linux-headers-6.11.0-8* linux-headers-6.11.0-8-generic* 183s linux-image-6.11.0-8-generic* linux-modules-6.11.0-8-generic* 183s linux-tools-6.11.0-8* linux-tools-6.11.0-8-generic* 183s 0 upgraded, 0 newly installed, 11 to remove and 5 not upgraded. 183s After this operation, 267 MB disk space will be freed. 183s (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 ... 117701 files and directories currently installed.) 183s Removing linux-tools-6.11.0-8-generic (6.11.0-8.8) ... 183s Removing linux-tools-6.11.0-8 (6.11.0-8.8) ... 183s Removing libpython3.12t64:arm64 (3.12.9-1) ... 184s Removing libpython3.12-stdlib:arm64 (3.12.9-1) ... 184s Removing libnsl2:arm64 (1.3.0-3build3) ... 184s Removing libpython3.12-minimal:arm64 (3.12.9-1) ... 184s Removing libunwind8:arm64 (1.6.2-3.1) ... 184s Removing linux-headers-6.11.0-8-generic (6.11.0-8.8) ... 184s Removing linux-headers-6.11.0-8 (6.11.0-8.8) ... 186s Removing linux-image-6.11.0-8-generic (6.11.0-8.8) ... 187s I: /boot/vmlinuz.old is now a symlink to vmlinuz-6.14.0-10-generic 187s I: /boot/initrd.img.old is now a symlink to initrd.img-6.14.0-10-generic 187s /etc/kernel/postrm.d/initramfs-tools: 187s update-initramfs: Deleting /boot/initrd.img-6.11.0-8-generic 187s /etc/kernel/postrm.d/zz-flash-kernel: 187s flash-kernel: Kernel 6.11.0-8-generic has been removed. 187s flash-kernel: A higher version (6.14.0-10-generic) is still installed, no reflashing required. 187s /etc/kernel/postrm.d/zz-update-grub: 187s Sourcing file `/etc/default/grub' 187s Sourcing file `/etc/default/grub.d/50-cloudimg-settings.cfg' 187s Generating grub configuration file ... 187s Found linux image: /boot/vmlinuz-6.14.0-10-generic 187s Found initrd image: /boot/initrd.img-6.14.0-10-generic 188s Warning: os-prober will not be executed to detect other bootable partitions. 188s Systems on them will not be added to the GRUB boot configuration. 188s Check GRUB_DISABLE_OS_PROBER documentation entry. 188s Adding boot menu entry for UEFI Firmware Settings ... 188s done 188s Removing linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 188s Processing triggers for libc-bin (2.41-1ubuntu1) ... 188s (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 ... 81650 files and directories currently installed.) 188s Purging configuration files for linux-image-6.11.0-8-generic (6.11.0-8.8) ... 189s Purging configuration files for libpython3.12-minimal:arm64 (3.12.9-1) ... 189s Purging configuration files for linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 189s autopkgtest [14:15:55]: upgrading testbed (apt dist-upgrade and autopurge) 189s Reading package lists... 190s Building dependency tree... 190s Reading state information... 191s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 191s Starting 2 pkgProblemResolver with broken count: 0 191s Done 193s Entering ResolveByKeep 194s 194s Calculating upgrade... 196s The following packages will be upgraded: 196s libc-bin libc-dev-bin libc6 libc6-dev locales 196s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 196s Need to get 9530 kB of archives. 196s After this operation, 0 B of additional disk space will be used. 196s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc6-dev arm64 2.41-1ubuntu2 [1750 kB] 198s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc-dev-bin arm64 2.41-1ubuntu2 [24.0 kB] 198s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc6 arm64 2.41-1ubuntu2 [2910 kB] 201s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc-bin arm64 2.41-1ubuntu2 [600 kB] 202s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 locales all 2.41-1ubuntu2 [4246 kB] 206s Preconfiguring packages ... 206s Fetched 9530 kB in 10s (973 kB/s) 207s (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 ... 81647 files and directories currently installed.) 207s Preparing to unpack .../libc6-dev_2.41-1ubuntu2_arm64.deb ... 207s Unpacking libc6-dev:arm64 (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 207s Preparing to unpack .../libc-dev-bin_2.41-1ubuntu2_arm64.deb ... 207s Unpacking libc-dev-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 207s Preparing to unpack .../libc6_2.41-1ubuntu2_arm64.deb ... 207s Unpacking libc6:arm64 (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 207s Setting up libc6:arm64 (2.41-1ubuntu2) ... 208s (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 ... 81647 files and directories currently installed.) 208s Preparing to unpack .../libc-bin_2.41-1ubuntu2_arm64.deb ... 208s Unpacking libc-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 208s Setting up libc-bin (2.41-1ubuntu2) ... 208s (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 ... 81647 files and directories currently installed.) 208s Preparing to unpack .../locales_2.41-1ubuntu2_all.deb ... 208s Unpacking locales (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 208s Setting up locales (2.41-1ubuntu2) ... 210s Generating locales (this might take a while)... 212s en_US.UTF-8... done 212s Generation complete. 212s Setting up libc-dev-bin (2.41-1ubuntu2) ... 212s Setting up libc6-dev:arm64 (2.41-1ubuntu2) ... 212s Processing triggers for man-db (2.13.0-1) ... 213s Processing triggers for systemd (257.3-1ubuntu3) ... 214s Reading package lists... 215s Building dependency tree... 215s Reading state information... 215s Starting pkgProblemResolver with broken count: 0 215s Starting 2 pkgProblemResolver with broken count: 0 215s Done 216s Solving dependencies... 216s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 217s autopkgtest [14:16:23]: rebooting testbed after setup commands that affected boot 240s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 247s autopkgtest [14:16:53]: testbed running kernel: Linux 6.14.0-10-generic #10-Ubuntu SMP PREEMPT_DYNAMIC Wed Mar 12 15:45:31 UTC 2025 250s autopkgtest [14:16:56]: @@@@@@@@@@@@@@@@@@@@ apt-source pdfcrack 252s Get:1 http://ftpmaster.internal/ubuntu plucky/universe pdfcrack 0.20-1 (dsc) [2083 B] 252s Get:2 http://ftpmaster.internal/ubuntu plucky/universe pdfcrack 0.20-1 (tar) [35.6 kB] 252s Get:3 http://ftpmaster.internal/ubuntu plucky/universe pdfcrack 0.20-1 (asc) [833 B] 252s Get:4 http://ftpmaster.internal/ubuntu plucky/universe pdfcrack 0.20-1 (diff) [15.2 kB] 252s gpgv: Signature made Mon Oct 31 16:50:02 2022 UTC 252s gpgv: using RSA key 357DCB0EEC95A01AEBA1F0D2DE63B9C704EBE9EF 252s gpgv: Can't check signature: No public key 252s dpkg-source: warning: cannot verify inline signature for ./pdfcrack_0.20-1.dsc: no acceptable signature found 252s autopkgtest [14:16:58]: testing package pdfcrack version 0.20-1 253s autopkgtest [14:16:59]: build not needed 253s autopkgtest [14:16:59]: test command1: preparing testbed 254s Reading package lists... 254s Building dependency tree... 254s Reading state information... 255s Starting pkgProblemResolver with broken count: 0 255s Starting 2 pkgProblemResolver with broken count: 0 255s Done 256s The following NEW packages will be installed: 256s pdfcrack 256s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 256s Need to get 33.0 kB of archives. 256s After this operation, 88.1 kB of additional disk space will be used. 256s Get:1 http://ftpmaster.internal/ubuntu plucky/universe arm64 pdfcrack arm64 0.20-1 [33.0 kB] 257s Fetched 33.0 kB in 0s (129 kB/s) 257s Selecting previously unselected package pdfcrack. 257s (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 ... 81647 files and directories currently installed.) 257s Preparing to unpack .../pdfcrack_0.20-1_arm64.deb ... 257s Unpacking pdfcrack (0.20-1) ... 257s Setting up pdfcrack (0.20-1) ... 257s Processing triggers for man-db (2.13.0-1) ... 259s autopkgtest [14:17:05]: test command1: pdfcrack -v 259s autopkgtest [14:17:05]: test command1: [----------------------- 260s pdfcrack version 0.20 260s autopkgtest [14:17:06]: test command1: -----------------------] 260s command1 PASS (superficial) 260s autopkgtest [14:17:06]: test command1: - - - - - - - - - - results - - - - - - - - - - 261s autopkgtest [14:17:07]: test command2: preparing testbed 261s Reading package lists... 262s Building dependency tree... 262s Reading state information... 262s Starting pkgProblemResolver with broken count: 0 262s Starting 2 pkgProblemResolver with broken count: 0 262s Done 263s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 264s autopkgtest [14:17:10]: test command2: pdfcrack -w debian/tests/dict debian/tests/test.pdf 264s autopkgtest [14:17:10]: test command2: [----------------------- 265s PDF version 1.4 265s Security Handler: Standard 265s V: 2 265s R: 3 265s P: -1028 265s Length: 128 265s Encrypted Metadata: True 265s FileID: 37b4e5aac8b679cce02da68ea9416bcc 265s U: 1ecc7c931d02012758cfa8dadef16de800000000000000000000000000000000 265s O: 80d26874981772ec1871e1617183f63cc1b6456110a14432c9aab07e41307c56 265s found user-password: 'table' 265s autopkgtest [14:17:11]: test command2: -----------------------] 266s autopkgtest [14:17:12]: test command2: - - - - - - - - - - results - - - - - - - - - - 266s command2 PASS 266s autopkgtest [14:17:12]: test command3: preparing testbed 266s Reading package lists... 267s Building dependency tree... 267s Reading state information... 267s Starting pkgProblemResolver with broken count: 0 268s Starting 2 pkgProblemResolver with broken count: 0 268s Done 269s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 270s autopkgtest [14:17:16]: test command3: pdfcrack -on 3 debian/tests/new-test.pdf 270s autopkgtest [14:17:16]: test command3: [----------------------- 277s PDF version 1.5 277s Security Handler: Standard 277s V: 2 277s R: 3 277s P: -3904 277s Length: 128 277s Encrypted Metadata: True 277s FileID: bf13750841185b699898eec6145d4763 277s U: 494c6004039f0fb7c0e19e2a83e8d04d00000000000000000000000000000000 277s O: 2d47413003fef119a4370abb99f32f55dd70865f55362c98bf26d7afb186722b 277s found owner-password: 'aB2' 277s found user-password: 'aC3' 277s autopkgtest [14:17:23]: test command3: -----------------------] 278s autopkgtest [14:17:24]: test command3: - - - - - - - - - - results - - - - - - - - - - 278s command3 PASS 278s autopkgtest [14:17:24]: @@@@@@@@@@@@@@@@@@@@ summary 278s command1 PASS (superficial) 278s command2 PASS 278s command3 PASS 297s nova [W] Using flock in prodstack6-arm64 297s flock: timeout while waiting to get lock 297s Creating nova instance adt-plucky-arm64-pdfcrack-20250315-141246-juju-7f2275-prod-proposed-migration-environment-2-3147c9dc-c61f-48a0-988e-eb181edca5ef from image adt/ubuntu-plucky-arm64-server-20250315.img (UUID bd6e766c-b51f-4b53-86d6-23aa4d18f524)... 297s nova [W] Timed out waiting for 14feefd4-d376-4ffd-a5bc-00d59546f5fd to get deleted.