0s autopkgtest [13:49:27]: starting date and time: 2024-11-07 13:49:27+0000 0s autopkgtest [13:49:27]: git checkout: 0acbae0a WIP show VirtSubproc stderr in real-time 0s autopkgtest [13:49:27]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.4slvg3m_/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:pam --apt-upgrade python-pam --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=pam/1.5.3-7ubuntu3 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@lcy02-19.secgroup --name adt-plucky-amd64-python-pam-20241107-131412-juju-7f2275-prod-proposed-migration-environment-2-3118a7d7-8e7e-4f2a-9531-80112cf6a016 --image adt/ubuntu-plucky-amd64-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'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 349s autopkgtest [13:55:16]: testbed dpkg architecture: amd64 349s autopkgtest [13:55:16]: testbed apt version: 2.9.8 349s autopkgtest [13:55:16]: @@@@@@@@@@@@@@@@@@@@ test bed setup 349s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 349s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [18.1 kB] 349s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [172 kB] 349s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [7016 B] 349s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [1490 kB] 349s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main i386 Packages [182 kB] 349s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/main amd64 Packages [253 kB] 349s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/restricted amd64 Packages [32.6 kB] 349s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/universe amd64 Packages [1234 kB] 349s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/universe i386 Packages [555 kB] 349s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse i386 Packages [15.3 kB] 349s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse amd64 Packages [51.3 kB] 350s Fetched 4085 kB in 1s (7032 kB/s) 350s Reading package lists... 351s Reading package lists... 352s Building dependency tree... 352s Reading state information... 352s Calculating upgrade... 352s The following packages will be upgraded: 352s libpam-modules libpam-modules-bin libpam-runtime libpam0g 352s 4 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 352s Need to get 458 kB of archives. 352s After this operation, 24.6 kB of additional disk space will be used. 352s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main amd64 libpam0g amd64 1.5.3-7ubuntu3 [69.5 kB] 352s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main amd64 libpam-modules-bin amd64 1.5.3-7ubuntu3 [53.7 kB] 352s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main amd64 libpam-modules amd64 1.5.3-7ubuntu3 [294 kB] 352s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/main amd64 libpam-runtime all 1.5.3-7ubuntu3 [40.8 kB] 352s Preconfiguring packages ... 352s Fetched 458 kB in 0s (14.3 MB/s) 353s (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 ... 75323 files and directories currently installed.) 353s Preparing to unpack .../libpam0g_1.5.3-7ubuntu3_amd64.deb ... 353s Unpacking libpam0g:amd64 (1.5.3-7ubuntu3) over (1.5.3-7ubuntu2) ... 353s Setting up libpam0g:amd64 (1.5.3-7ubuntu3) ... 353s (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 ... 75323 files and directories currently installed.) 353s Preparing to unpack .../libpam-modules-bin_1.5.3-7ubuntu3_amd64.deb ... 353s Unpacking libpam-modules-bin (1.5.3-7ubuntu3) over (1.5.3-7ubuntu2) ... 353s Setting up libpam-modules-bin (1.5.3-7ubuntu3) ... 353s pam_namespace.service is a disabled or a static unit not running, not starting it. 353s (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 ... 75323 files and directories currently installed.) 353s Preparing to unpack .../libpam-modules_1.5.3-7ubuntu3_amd64.deb ... 353s Unpacking libpam-modules:amd64 (1.5.3-7ubuntu3) over (1.5.3-7ubuntu2) ... 353s Setting up libpam-modules:amd64 (1.5.3-7ubuntu3) ... 353s (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 ... 75323 files and directories currently installed.) 353s Preparing to unpack .../libpam-runtime_1.5.3-7ubuntu3_all.deb ... 353s Unpacking libpam-runtime (1.5.3-7ubuntu3) over (1.5.3-7ubuntu2) ... 353s Setting up libpam-runtime (1.5.3-7ubuntu3) ... 354s Processing triggers for man-db (2.12.1-3) ... 354s Processing triggers for libc-bin (2.40-1ubuntu3) ... 355s Reading package lists... 355s Building dependency tree... 355s Reading state information... 355s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 355s Hit:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease 355s Get:2 http://ftpmaster.internal/ubuntu plucky InRelease [213 kB] 355s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 355s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 356s Get:5 http://ftpmaster.internal/ubuntu plucky/main Sources [1385 kB] 356s Get:6 http://ftpmaster.internal/ubuntu plucky/multiverse Sources [296 kB] 356s Get:7 http://ftpmaster.internal/ubuntu plucky/universe Sources [20.6 MB] 356s Get:8 http://ftpmaster.internal/ubuntu plucky/main amd64 Packages [1428 kB] 356s Get:9 http://ftpmaster.internal/ubuntu plucky/main i386 Packages [1067 kB] 356s Get:10 http://ftpmaster.internal/ubuntu plucky/universe i386 Packages [8624 kB] 356s Get:11 http://ftpmaster.internal/ubuntu plucky/universe amd64 Packages [15.6 MB] 356s Get:12 http://ftpmaster.internal/ubuntu plucky/multiverse amd64 Packages [252 kB] 359s Fetched 49.5 MB in 4s (13.3 MB/s) 360s Reading package lists... 360s Reading package lists... 360s Building dependency tree... 360s Reading state information... 361s Calculating upgrade... 361s The following packages will be upgraded: 361s libarchive13t64 python3-jaraco.functools python3-typeguard ssh-import-id ufw 361s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 361s Need to get 676 kB of archives. 361s After this operation, 216 kB of additional disk space will be used. 361s Get:1 http://ftpmaster.internal/ubuntu plucky/main amd64 ufw all 0.36.2-8 [170 kB] 361s Get:2 http://ftpmaster.internal/ubuntu plucky/main amd64 libarchive13t64 amd64 3.7.4-1ubuntu1 [456 kB] 361s Get:3 http://ftpmaster.internal/ubuntu plucky/main amd64 python3-jaraco.functools all 4.1.0-1 [11.8 kB] 361s Get:4 http://ftpmaster.internal/ubuntu plucky/main amd64 python3-typeguard all 4.4.1-1 [29.0 kB] 361s Get:5 http://ftpmaster.internal/ubuntu plucky/main amd64 ssh-import-id all 5.11-0ubuntu3 [10.1 kB] 361s Preconfiguring packages ... 361s Fetched 676 kB in 0s (22.0 MB/s) 361s (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 ... 75323 files and directories currently installed.) 361s Preparing to unpack .../archives/ufw_0.36.2-8_all.deb ... 361s Unpacking ufw (0.36.2-8) over (0.36.2-6) ... 361s Preparing to unpack .../libarchive13t64_3.7.4-1ubuntu1_amd64.deb ... 361s Unpacking libarchive13t64:amd64 (3.7.4-1ubuntu1) over (3.7.4-1) ... 361s Preparing to unpack .../python3-jaraco.functools_4.1.0-1_all.deb ... 362s Unpacking python3-jaraco.functools (4.1.0-1) over (4.0.2-1) ... 362s Preparing to unpack .../python3-typeguard_4.4.1-1_all.deb ... 362s Unpacking python3-typeguard (4.4.1-1) over (4.3.0-1) ... 362s Preparing to unpack .../ssh-import-id_5.11-0ubuntu3_all.deb ... 362s Unpacking ssh-import-id (5.11-0ubuntu3) over (5.11-0ubuntu2) ... 362s Setting up python3-jaraco.functools (4.1.0-1) ... 362s Setting up ssh-import-id (5.11-0ubuntu3) ... 362s Setting up python3-typeguard (4.4.1-1) ... 362s Setting up ufw (0.36.2-8) ... 363s Setting up libarchive13t64:amd64 (3.7.4-1ubuntu1) ... 363s Processing triggers for rsyslog (8.2406.0-1ubuntu2) ... 363s Processing triggers for man-db (2.12.1-3) ... 364s Processing triggers for libc-bin (2.40-1ubuntu3) ... 364s Reading package lists... 364s Building dependency tree... 364s Reading state information... 364s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 365s autopkgtest [13:55:32]: rebooting testbed after setup commands that affected boot 368s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 397s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 402s autopkgtest [13:56:09]: testbed running kernel: Linux 6.11.0-8-generic #8-Ubuntu SMP PREEMPT_DYNAMIC Mon Sep 16 13:41:20 UTC 2024 402s autopkgtest [13:56:09]: @@@@@@@@@@@@@@@@@@@@ apt-source python-pam 403s Get:1 http://ftpmaster.internal/ubuntu plucky/main python-pam 0.4.2-18build2 (dsc) [2112 B] 403s Get:2 http://ftpmaster.internal/ubuntu plucky/main python-pam 0.4.2-18build2 (tar) [15.1 kB] 403s Get:3 http://ftpmaster.internal/ubuntu plucky/main python-pam 0.4.2-18build2 (diff) [7056 B] 403s gpgv: Signature made Mon Apr 8 16:18:02 2024 UTC 403s gpgv: using RSA key 4FB588A84C2DDE79A74C77876FA458DD1DB03F71 403s gpgv: issuer "juliank@ubuntu.com" 403s gpgv: Can't check signature: No public key 403s dpkg-source: warning: cannot verify inline signature for ./python-pam_0.4.2-18build2.dsc: no acceptable signature found 403s autopkgtest [13:56:10]: testing package python-pam version 0.4.2-18build2 403s autopkgtest [13:56:10]: build not needed 404s autopkgtest [13:56:11]: test unittest: preparing testbed 404s Reading package lists... 404s Building dependency tree... 404s Reading state information... 405s Starting pkgProblemResolver with broken count: 0 405s Starting 2 pkgProblemResolver with broken count: 0 405s Done 405s The following additional packages will be installed: 405s python3-all python3-pam 405s Suggested packages: 405s python3-pam-dbg 405s The following NEW packages will be installed: 405s autopkgtest-satdep python3-all python3-pam 405s 0 upgraded, 3 newly installed, 0 to remove and 0 not upgraded. 405s Need to get 12.5 kB/13.3 kB of archives. 405s After this operation, 54.3 kB of additional disk space will be used. 405s Get:1 /tmp/autopkgtest.IYb7Oz/1-autopkgtest-satdep.deb autopkgtest-satdep amd64 0 [716 B] 405s Get:2 http://ftpmaster.internal/ubuntu plucky/main amd64 python3-all amd64 3.12.6-0ubuntu1 [886 B] 405s Get:3 http://ftpmaster.internal/ubuntu plucky/main amd64 python3-pam amd64 0.4.2-18build2 [11.7 kB] 405s Fetched 12.5 kB in 0s (291 kB/s) 405s Selecting previously unselected package python3-all. 406s (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 ... 75323 files and directories currently installed.) 406s Preparing to unpack .../python3-all_3.12.6-0ubuntu1_amd64.deb ... 406s Unpacking python3-all (3.12.6-0ubuntu1) ... 406s Selecting previously unselected package python3-pam. 406s Preparing to unpack .../python3-pam_0.4.2-18build2_amd64.deb ... 406s Unpacking python3-pam (0.4.2-18build2) ... 406s Selecting previously unselected package autopkgtest-satdep. 406s Preparing to unpack .../1-autopkgtest-satdep.deb ... 406s Unpacking autopkgtest-satdep (0) ... 406s Setting up python3-pam (0.4.2-18build2) ... 406s Setting up python3-all (3.12.6-0ubuntu1) ... 406s Setting up autopkgtest-satdep (0) ... 408s (Reading database ... 75338 files and directories currently installed.) 408s Removing autopkgtest-satdep (0) ... 408s autopkgtest [13:56:15]: test unittest: [----------------------- 408s Testing with python3.12: 408s 409s autopkgtest [13:56:16]: test unittest: -----------------------] 409s unittest PASS 409s autopkgtest [13:56:16]: test unittest: - - - - - - - - - - results - - - - - - - - - - 409s autopkgtest [13:56:16]: @@@@@@@@@@@@@@@@@@@@ summary 409s unittest PASS 419s virt: nova [W] Skipping flock for amd64 419s virt: Creating nova instance adt-plucky-amd64-python-pam-20241107-131412-juju-7f2275-prod-proposed-migration-environment-2-3118a7d7-8e7e-4f2a-9531-80112cf6a016 from image adt/ubuntu-plucky-amd64-server-20241106.img (UUID 36ba5691-79f0-4abe-85a8-41cb88470e34)... 419s virt: nova [W] nova quota exceeded (attempt #0)