0s autopkgtest [21:56:15]: starting date and time: 2025-02-15 21:56:15+0000 0s autopkgtest [21:56:15]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [21:56:15]: host juju-7f2275-prod-proposed-migration-environment-20; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.clv5c1mr/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:glibc,src:iproute2,src:php-twig,src:postgresql-17,src:postgresql-common,src:roundcube --apt-upgrade entr --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=glibc/2.41-1ubuntu1 iproute2/6.13.0-1ubuntu1 php-twig/3.19.0-1 postgresql-17/17.3-2 postgresql-common/273 roundcube/1.6.10+dfsg-1' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-20@bos03-arm64-18.secgroup --name adt-plucky-arm64-entr-20250215-215615-juju-7f2275-prod-proposed-migration-environment-20-9df65e80-1113-44ff-bf86-c85f2d591f7b --image adt/ubuntu-plucky-arm64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-20 --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/ 148s autopkgtest [21:58:43]: testbed dpkg architecture: arm64 148s autopkgtest [21:58:43]: testbed apt version: 2.9.28 149s autopkgtest [21:58:44]: @@@@@@@@@@@@@@@@@@@@ test bed setup 149s autopkgtest [21:58:44]: testbed release detected to be: None 150s autopkgtest [21:58:45]: updating testbed package index (apt update) 150s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [110 kB] 150s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 150s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 150s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 150s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [13.1 kB] 150s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [828 kB] 151s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [74.3 kB] 151s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [3120 B] 151s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 Packages [163 kB] 151s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted arm64 Packages [7960 B] 151s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 Packages [942 kB] 151s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse arm64 Packages [10.0 kB] 151s Fetched 2151 kB in 1s (2174 kB/s) 152s Reading package lists... 153s Reading package lists... 154s Building dependency tree... 154s Reading state information... 154s Calculating upgrade... 155s The following packages will be upgraded: 155s dash libtasn1-6 libxdmcp6 155s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 155s Need to get 151 kB of archives. 155s After this operation, 17.4 kB of additional disk space will be used. 155s Get:1 http://ftpmaster.internal/ubuntu plucky/main arm64 dash arm64 0.5.12-12ubuntu1 [96.1 kB] 156s Get:2 http://ftpmaster.internal/ubuntu plucky/main arm64 libtasn1-6 arm64 4.20.0-2 [43.9 kB] 156s Get:3 http://ftpmaster.internal/ubuntu plucky/main arm64 libxdmcp6 arm64 1:1.1.5-1 [10.7 kB] 156s Preconfiguring packages ... 156s Fetched 151 kB in 0s (332 kB/s) 157s (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 ... 116609 files and directories currently installed.) 157s Preparing to unpack .../dash_0.5.12-12ubuntu1_arm64.deb ... 157s Unpacking dash (0.5.12-12ubuntu1) over (0.5.12-9ubuntu1) ... 157s Setting up dash (0.5.12-12ubuntu1) ... 157s (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 ... 116609 files and directories currently installed.) 157s Preparing to unpack .../libtasn1-6_4.20.0-2_arm64.deb ... 157s Unpacking libtasn1-6:arm64 (4.20.0-2) over (4.19.0-3build1) ... 157s Preparing to unpack .../libxdmcp6_1%3a1.1.5-1_arm64.deb ... 157s Unpacking libxdmcp6:arm64 (1:1.1.5-1) over (1:1.1.3-0ubuntu6) ... 157s Setting up libxdmcp6:arm64 (1:1.1.5-1) ... 157s Setting up libtasn1-6:arm64 (4.20.0-2) ... 157s Processing triggers for libc-bin (2.40-4ubuntu1) ... 157s Processing triggers for man-db (2.13.0-1) ... 158s Processing triggers for debianutils (5.21) ... 158s Reading package lists... 159s Building dependency tree... 159s Reading state information... 160s 0 upgraded, 0 newly installed, 0 to remove and 6 not upgraded. 160s autopkgtest [21:58:55]: upgrading testbed (apt dist-upgrade and autopurge) 160s Reading package lists... 160s Building dependency tree... 160s Reading state information... 161s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 161s Starting 2 pkgProblemResolver with broken count: 0 161s Done 163s Entering ResolveByKeep 163s 164s The following packages will be upgraded: 164s iproute2 libc-bin libc-dev-bin libc6 libc6-dev locales 164s 6 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 164s Need to get 10.7 MB of archives. 164s After this operation, 358 kB of additional disk space will be used. 164s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc-dev-bin arm64 2.41-1ubuntu1 [24.0 kB] 164s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc6-dev arm64 2.41-1ubuntu1 [1750 kB] 165s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 locales all 2.41-1ubuntu1 [4246 kB] 165s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc6 arm64 2.41-1ubuntu1 [2910 kB] 165s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc-bin arm64 2.41-1ubuntu1 [600 kB] 165s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 iproute2 arm64 6.13.0-1ubuntu1 [1158 kB] 165s Preconfiguring packages ... 166s Fetched 10.7 MB in 1s (11.2 MB/s) 166s (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 ... 116609 files and directories currently installed.) 166s Preparing to unpack .../libc-dev-bin_2.41-1ubuntu1_arm64.deb ... 166s Unpacking libc-dev-bin (2.41-1ubuntu1) over (2.40-4ubuntu1) ... 166s Preparing to unpack .../libc6-dev_2.41-1ubuntu1_arm64.deb ... 166s Unpacking libc6-dev:arm64 (2.41-1ubuntu1) over (2.40-4ubuntu1) ... 166s Preparing to unpack .../locales_2.41-1ubuntu1_all.deb ... 166s Unpacking locales (2.41-1ubuntu1) over (2.40-4ubuntu1) ... 166s Preparing to unpack .../libc6_2.41-1ubuntu1_arm64.deb ... 167s Checking for services that may need to be restarted... 167s Checking init scripts... 167s Checking for services that may need to be restarted... 167s Checking init scripts... 167s Stopping some services possibly affected by the upgrade (will be restarted later): 167s cron: stopping...done. 167s 167s Unpacking libc6:arm64 (2.41-1ubuntu1) over (2.40-4ubuntu1) ... 167s Setting up libc6:arm64 (2.41-1ubuntu1) ... 167s Checking for services that may need to be restarted... 167s Checking init scripts... 167s Restarting services possibly affected by the upgrade: 167s cron: restarting...done. 167s 167s Services restarted successfully. 168s (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 ... 116610 files and directories currently installed.) 168s Preparing to unpack .../libc-bin_2.41-1ubuntu1_arm64.deb ... 168s Unpacking libc-bin (2.41-1ubuntu1) over (2.40-4ubuntu1) ... 168s Setting up libc-bin (2.41-1ubuntu1) ... 168s (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 ... 116610 files and directories currently installed.) 168s Preparing to unpack .../iproute2_6.13.0-1ubuntu1_arm64.deb ... 168s Unpacking iproute2 (6.13.0-1ubuntu1) over (6.10.0-2ubuntu1) ... 169s Setting up iproute2 (6.13.0-1ubuntu1) ... 169s Setting up locales (2.41-1ubuntu1) ... 169s Installing new version of config file /etc/locale.alias ... 170s Generating locales (this might take a while)... 176s en_US.UTF-8... done 176s Generation complete. 176s Setting up libc-dev-bin (2.41-1ubuntu1) ... 176s Setting up libc6-dev:arm64 (2.41-1ubuntu1) ... 176s Processing triggers for man-db (2.13.0-1) ... 178s Processing triggers for systemd (257.2-3ubuntu1) ... 179s Reading package lists... 180s Building dependency tree... 180s Reading state information... 180s Starting pkgProblemResolver with broken count: 0 181s Starting 2 pkgProblemResolver with broken count: 0 181s Done 182s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 185s autopkgtest [21:59:20]: testbed running kernel: Linux 6.12.0-15-generic #15-Ubuntu SMP PREEMPT_DYNAMIC Tue Feb 4 15:49:33 UTC 2025 185s autopkgtest [21:59:20]: @@@@@@@@@@@@@@@@@@@@ apt-source entr 187s Get:1 http://ftpmaster.internal/ubuntu plucky/universe entr 5.6-1 (dsc) [2136 B] 187s Get:2 http://ftpmaster.internal/ubuntu plucky/universe entr 5.6-1 (tar) [23.4 kB] 187s Get:3 http://ftpmaster.internal/ubuntu plucky/universe entr 5.6-1 (asc) [833 B] 187s Get:4 http://ftpmaster.internal/ubuntu plucky/universe entr 5.6-1 (diff) [15.8 kB] 187s gpgv: Signature made Mon Sep 2 19:42:49 2024 UTC 187s gpgv: using RSA key 99B452B11F3C74C3B453E46FBED8449FCEE8DA88 187s gpgv: Can't check signature: No public key 187s dpkg-source: warning: cannot verify inline signature for ./entr_5.6-1.dsc: no acceptable signature found 187s autopkgtest [21:59:22]: testing package entr version 5.6-1 188s autopkgtest [21:59:23]: build not needed 188s autopkgtest [21:59:23]: test print-help-message: preparing testbed 188s Reading package lists... 189s Building dependency tree... 189s Reading state information... 189s Starting pkgProblemResolver with broken count: 0 190s Starting 2 pkgProblemResolver with broken count: 0 190s Done 191s The following NEW packages will be installed: 191s entr 191s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 191s Need to get 22.3 kB of archives. 191s After this operation, 94.2 kB of additional disk space will be used. 191s Get:1 http://ftpmaster.internal/ubuntu plucky/universe arm64 entr arm64 5.6-1 [22.3 kB] 191s Fetched 22.3 kB in 0s (98.1 kB/s) 192s Selecting previously unselected package entr. 192s (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 ... 116611 files and directories currently installed.) 192s Preparing to unpack .../archives/entr_5.6-1_arm64.deb ... 192s Unpacking entr (5.6-1) ... 192s Setting up entr (5.6-1) ... 192s Processing triggers for man-db (2.13.0-1) ... 193s autopkgtest [21:59:28]: test print-help-message: entr -h 2>&1 | grep usage 193s autopkgtest [21:59:28]: test print-help-message: [----------------------- 193s usage: entr [-acdnprsxz] utility [argument [/_] ...] < filenames 194s autopkgtest [21:59:29]: test print-help-message: -----------------------] 194s print-help-message PASS 194s autopkgtest [21:59:29]: test print-help-message: - - - - - - - - - - results - - - - - - - - - - 194s autopkgtest [21:59:29]: test upstream-system-test: preparing testbed 195s Reading package lists... 195s Building dependency tree... 195s Reading state information... 196s Starting pkgProblemResolver with broken count: 0 196s Starting 2 pkgProblemResolver with broken count: 0 196s Done 198s The following NEW packages will be installed: 198s git git-man liberror-perl libsodium23 vim vim-runtime 198s 0 upgraded, 6 newly installed, 0 to remove and 0 not upgraded. 198s Need to get 14.8 MB of archives. 198s After this operation, 70.4 MB of additional disk space will be used. 198s Get:1 http://ftpmaster.internal/ubuntu plucky/main arm64 liberror-perl all 0.17029-2 [25.6 kB] 198s Get:2 http://ftpmaster.internal/ubuntu plucky/main arm64 git-man all 1:2.47.1-1ubuntu1 [1142 kB] 199s Get:3 http://ftpmaster.internal/ubuntu plucky/main arm64 git arm64 1:2.47.1-1ubuntu1 [4203 kB] 199s Get:4 http://ftpmaster.internal/ubuntu plucky/main arm64 libsodium23 arm64 1.0.18-1build3 [119 kB] 199s Get:5 http://ftpmaster.internal/ubuntu plucky/main arm64 vim-runtime all 2:9.1.0861-1ubuntu1 [7455 kB] 199s Get:6 http://ftpmaster.internal/ubuntu plucky/main arm64 vim arm64 2:9.1.0861-1ubuntu1 [1883 kB] 200s Fetched 14.8 MB in 1s (14.6 MB/s) 200s Selecting previously unselected package liberror-perl. 200s (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 ... 116618 files and directories currently installed.) 200s Preparing to unpack .../0-liberror-perl_0.17029-2_all.deb ... 200s Unpacking liberror-perl (0.17029-2) ... 200s Selecting previously unselected package git-man. 200s Preparing to unpack .../1-git-man_1%3a2.47.1-1ubuntu1_all.deb ... 200s Unpacking git-man (1:2.47.1-1ubuntu1) ... 200s Selecting previously unselected package git. 200s Preparing to unpack .../2-git_1%3a2.47.1-1ubuntu1_arm64.deb ... 200s Unpacking git (1:2.47.1-1ubuntu1) ... 200s Selecting previously unselected package libsodium23:arm64. 200s Preparing to unpack .../3-libsodium23_1.0.18-1build3_arm64.deb ... 200s Unpacking libsodium23:arm64 (1.0.18-1build3) ... 200s Selecting previously unselected package vim-runtime. 200s Preparing to unpack .../4-vim-runtime_2%3a9.1.0861-1ubuntu1_all.deb ... 200s Adding 'diversion of /usr/share/vim/vim91/doc/help.txt to /usr/share/vim/vim91/doc/help.txt.vim-tiny by vim-runtime' 200s Adding 'diversion of /usr/share/vim/vim91/doc/tags to /usr/share/vim/vim91/doc/tags.vim-tiny by vim-runtime' 200s Unpacking vim-runtime (2:9.1.0861-1ubuntu1) ... 201s Selecting previously unselected package vim. 201s Preparing to unpack .../5-vim_2%3a9.1.0861-1ubuntu1_arm64.deb ... 201s Unpacking vim (2:9.1.0861-1ubuntu1) ... 201s Setting up libsodium23:arm64 (1.0.18-1build3) ... 201s Setting up liberror-perl (0.17029-2) ... 201s Setting up git-man (1:2.47.1-1ubuntu1) ... 201s Setting up vim-runtime (2:9.1.0861-1ubuntu1) ... 201s Setting up vim (2:9.1.0861-1ubuntu1) ... 201s update-alternatives: using /usr/bin/vim.basic to provide /usr/bin/ex (ex) in auto mode 201s update-alternatives: using /usr/bin/vim.basic to provide /usr/bin/rview (rview) in auto mode 201s update-alternatives: using /usr/bin/vim.basic to provide /usr/bin/rvim (rvim) in auto mode 201s update-alternatives: using /usr/bin/vim.basic to provide /usr/bin/vi (vi) in auto mode 201s update-alternatives: using /usr/bin/vim.basic to provide /usr/bin/view (view) in auto mode 201s update-alternatives: using /usr/bin/vim.basic to provide /usr/bin/vim (vim) in auto mode 201s update-alternatives: using /usr/bin/vim.basic to provide /usr/bin/vimdiff (vimdiff) in auto mode 201s Setting up git (1:2.47.1-1ubuntu1) ... 201s Processing triggers for man-db (2.13.0-1) ... 202s Processing triggers for libc-bin (2.41-1ubuntu1) ... 203s autopkgtest [21:59:38]: test upstream-system-test: ./system_test.sh 203s autopkgtest [21:59:38]: test upstream-system-test: [----------------------- 204s INFO: No ./entr binary found. Testing the system binary /usr/bin/entr instead. 204s INFO: Using entr version: 204s release: 5.6 204s usage: entr [-acdnprsxz] utility [argument [/_] ...] < filenames 227s ..............................s........................................................s........autopkgtest [22:00:01]: test upstream-system-test: -----------------------] 227s . 227s 49 tests PASSED 228s upstream-system-test PASS 228s autopkgtest [22:00:03]: test upstream-system-test: - - - - - - - - - - results - - - - - - - - - - 229s autopkgtest [22:00:04]: @@@@@@@@@@@@@@@@@@@@ summary 229s print-help-message PASS 229s upstream-system-test PASS 272s nova [W] Using flock in prodstack6-arm64 272s flock: timeout while waiting to get lock 272s Creating nova instance adt-plucky-arm64-entr-20250215-215615-juju-7f2275-prod-proposed-migration-environment-20-9df65e80-1113-44ff-bf86-c85f2d591f7b from image adt/ubuntu-plucky-arm64-server-20250215.img (UUID 8f82fa69-4462-4e93-a46b-73be9ea2c381)... 272s nova [W] Timed out waiting for 49080b64-65da-4706-ae6c-b77add63e062 to get deleted.