0s autopkgtest [19:18:50]: starting date and time: 2024-12-23 19:18:50+0000 0s autopkgtest [19:18:50]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [19:18:50]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.wdxk4308/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:ca-certificates --apt-upgrade pagekite --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=ca-certificates/20241223 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-ppc64el --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-ppc64el-5.secgroup --name adt-plucky-ppc64el-pagekite-20241223-191850-juju-7f2275-prod-proposed-migration-environment-2-2f6fc42a-c7f8-4044-a3f4-bf9b9e3d7cb9 --image adt/ubuntu-plucky-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration-ppc64el -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/ 77s autopkgtest [19:20:07]: testbed dpkg architecture: ppc64el 77s autopkgtest [19:20:07]: testbed apt version: 2.9.16 78s autopkgtest [19:20:08]: @@@@@@@@@@@@@@@@@@@@ test bed setup 78s autopkgtest [19:20:08]: testbed release detected to be: None 79s autopkgtest [19:20:09]: updating testbed package index (apt update) 79s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 79s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 79s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 79s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 79s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [574 kB] 80s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [52.8 kB] 80s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [10.8 kB] 80s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [9708 B] 80s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el Packages [61.8 kB] 80s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted ppc64el Packages [756 B] 80s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe ppc64el Packages [440 kB] 80s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse ppc64el Packages [3108 B] 80s Fetched 1227 kB in 1s (1407 kB/s) 81s Reading package lists... 81s Reading package lists... 82s Building dependency tree... 82s Reading state information... 82s Calculating upgrade... 82s The following packages will be upgraded: 82s apt apt-utils dracut-install libapt-pkg6.0t64 libftdi1-2 publicsuffix 82s 6 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 82s Need to get 2953 kB of archives. 82s After this operation, 58.4 kB disk space will be freed. 82s Get:1 http://ftpmaster.internal/ubuntu plucky/main ppc64el libapt-pkg6.0t64 ppc64el 2.9.18 [1140 kB] 83s Get:2 http://ftpmaster.internal/ubuntu plucky/main ppc64el apt ppc64el 2.9.18 [1377 kB] 83s Get:3 http://ftpmaster.internal/ubuntu plucky/main ppc64el apt-utils ppc64el 2.9.18 [229 kB] 83s Get:4 http://ftpmaster.internal/ubuntu plucky/main ppc64el publicsuffix all 20241206.1516-0.1 [135 kB] 83s Get:5 http://ftpmaster.internal/ubuntu plucky/main ppc64el dracut-install ppc64el 105-2ubuntu5 [38.7 kB] 83s Get:6 http://ftpmaster.internal/ubuntu plucky/main ppc64el libftdi1-2 ppc64el 1.5-8 [32.2 kB] 83s Fetched 2953 kB in 1s (4207 kB/s) 83s (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 ... 73909 files and directories currently installed.) 83s Preparing to unpack .../libapt-pkg6.0t64_2.9.18_ppc64el.deb ... 83s Unpacking libapt-pkg6.0t64:ppc64el (2.9.18) over (2.9.16) ... 83s Setting up libapt-pkg6.0t64:ppc64el (2.9.18) ... 83s (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 ... 73909 files and directories currently installed.) 83s Preparing to unpack .../apt_2.9.18_ppc64el.deb ... 83s Unpacking apt (2.9.18) over (2.9.16) ... 84s Setting up apt (2.9.18) ... 84s (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 ... 73903 files and directories currently installed.) 84s Preparing to unpack .../apt-utils_2.9.18_ppc64el.deb ... 84s Unpacking apt-utils (2.9.18) over (2.9.16) ... 84s Preparing to unpack .../publicsuffix_20241206.1516-0.1_all.deb ... 84s Unpacking publicsuffix (20241206.1516-0.1) over (20241025.1547-0.1) ... 84s Preparing to unpack .../dracut-install_105-2ubuntu5_ppc64el.deb ... 84s Unpacking dracut-install (105-2ubuntu5) over (105-2ubuntu3) ... 84s Preparing to unpack .../libftdi1-2_1.5-8_ppc64el.deb ... 84s Unpacking libftdi1-2:ppc64el (1.5-8) over (1.5-7build1) ... 84s Setting up apt-utils (2.9.18) ... 84s Setting up libftdi1-2:ppc64el (1.5-8) ... 84s Setting up dracut-install (105-2ubuntu5) ... 84s Setting up publicsuffix (20241206.1516-0.1) ... 84s Processing triggers for man-db (2.13.0-1) ... 86s Processing triggers for libc-bin (2.40-4ubuntu1) ... 87s Reading package lists... 88s Building dependency tree... 88s Reading state information... 88s 0 upgraded, 0 newly installed, 0 to remove and 1 not upgraded. 88s autopkgtest [19:20:18]: upgrading testbed (apt dist-upgrade and autopurge) 88s Reading package lists... 88s Building dependency tree... 88s Reading state information... 88s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 89s Starting 2 pkgProblemResolver with broken count: 0 89s Done 89s Entering ResolveByKeep 89s 89s The following packages will be upgraded: 89s ca-certificates 89s 1 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 89s Need to get 165 kB of archives. 89s After this operation, 11.3 kB of additional disk space will be used. 89s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el ca-certificates all 20241223 [165 kB] 90s Preconfiguring packages ... 90s Fetched 165 kB in 0s (482 kB/s) 90s (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 ... 73903 files and directories currently installed.) 90s Preparing to unpack .../ca-certificates_20241223_all.deb ... 90s Unpacking ca-certificates (20241223) over (20240203) ... 91s Setting up ca-certificates (20241223) ... 92s Updating certificates in /etc/ssl/certs... 93s rehash: warning: skipping ca-certificates.crt, it does not contain exactly one certificate or CRL 93s 7 added, 1 removed; done. 93s Processing triggers for man-db (2.13.0-1) ... 94s Processing triggers for ca-certificates (20241223) ... 94s Updating certificates in /etc/ssl/certs... 94s 0 added, 0 removed; done. 94s Running hooks in /etc/ca-certificates/update.d... 94s done. 94s Reading package lists... 95s Building dependency tree... 95s Reading state information... 95s Starting pkgProblemResolver with broken count: 0 95s Starting 2 pkgProblemResolver with broken count: 0 95s Done 95s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 95s autopkgtest [19:20:25]: rebooting testbed after setup commands that affected boot 126s autopkgtest [19:20:56]: testbed running kernel: Linux 6.11.0-8-generic #8-Ubuntu SMP Mon Sep 16 13:49:23 UTC 2024 129s autopkgtest [19:20:59]: @@@@@@@@@@@@@@@@@@@@ apt-source pagekite 131s Get:1 http://ftpmaster.internal/ubuntu plucky/universe pagekite 1.5.2.201011-2.1ubuntu2 (dsc) [2453 B] 131s Get:2 http://ftpmaster.internal/ubuntu plucky/universe pagekite 1.5.2.201011-2.1ubuntu2 (tar) [690 kB] 131s Get:3 http://ftpmaster.internal/ubuntu plucky/universe pagekite 1.5.2.201011-2.1ubuntu2 (diff) [19.2 kB] 131s gpgv: Signature made Wed Nov 13 09:04:06 2024 UTC 131s gpgv: using RSA key 568BF22A66337CBFC9A6B9B72C83DBC8E9BD0E37 131s gpgv: Can't check signature: No public key 131s dpkg-source: warning: cannot verify inline signature for ./pagekite_1.5.2.201011-2.1ubuntu2.dsc: no acceptable signature found 131s autopkgtest [19:21:01]: testing package pagekite version 1.5.2.201011-2.1ubuntu2 132s autopkgtest [19:21:02]: build not needed 132s autopkgtest [19:21:02]: test test-client-running: preparing testbed 132s Reading package lists... 133s Building dependency tree... 133s Reading state information... 133s Starting pkgProblemResolver with broken count: 0 133s Starting 2 pkgProblemResolver with broken count: 0 133s Done 133s The following NEW packages will be installed: 133s daemon pagekite python3-six python3-socksipychain 133s 0 upgraded, 4 newly installed, 0 to remove and 0 not upgraded. 133s Need to get 256 kB of archives. 133s After this operation, 1005 kB of additional disk space will be used. 133s Get:1 http://ftpmaster.internal/ubuntu plucky/main ppc64el python3-six all 1.17.0-1 [13.2 kB] 133s Get:2 http://ftpmaster.internal/ubuntu plucky/universe ppc64el python3-socksipychain all 2.1.2-2 [19.3 kB] 133s Get:3 http://ftpmaster.internal/ubuntu plucky/universe ppc64el daemon ppc64el 0.8.4-1 [72.1 kB] 134s Get:4 http://ftpmaster.internal/ubuntu plucky/universe ppc64el pagekite all 1.5.2.201011-2.1ubuntu2 [152 kB] 134s Fetched 256 kB in 0s (604 kB/s) 134s Selecting previously unselected package python3-six. 134s (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 ... 73909 files and directories currently installed.) 134s Preparing to unpack .../python3-six_1.17.0-1_all.deb ... 134s Unpacking python3-six (1.17.0-1) ... 134s Selecting previously unselected package python3-socksipychain. 134s Preparing to unpack .../python3-socksipychain_2.1.2-2_all.deb ... 134s Unpacking python3-socksipychain (2.1.2-2) ... 134s Selecting previously unselected package daemon. 134s Preparing to unpack .../daemon_0.8.4-1_ppc64el.deb ... 134s Unpacking daemon (0.8.4-1) ... 134s Selecting previously unselected package pagekite. 134s Preparing to unpack .../pagekite_1.5.2.201011-2.1ubuntu2_all.deb ... 134s Unpacking pagekite (1.5.2.201011-2.1ubuntu2) ... 134s Setting up python3-six (1.17.0-1) ... 134s Setting up daemon (0.8.4-1) ... 134s Setting up python3-socksipychain (2.1.2-2) ... 134s Setting up pagekite (1.5.2.201011-2.1ubuntu2) ... 135s /usr/lib/python3/dist-packages/pagekite/common.py:153: SyntaxWarning: invalid escape sequence '\.' 135s SERVICE_DOMAIN_RE = re.compile('\.(' + '|'.join(SERVICE_DOMAINS) + ')$') 135s /usr/lib/python3/dist-packages/pagekite/pk.py:1242: SyntaxWarning: invalid escape sequence '\.' 135s 'localhost': '((::ffff:)?127\..*|::1)', 135s /usr/lib/python3/dist-packages/pagekite/proto/filters.py:163: SyntaxWarning: invalid escape sequence '\d' 135s HTTP_HEADER = re.compile('(?ism)^(([A-Z]+) ([^\n]+) HTTP/\d+\.\d+\s*)$') 135s /usr/lib/python3/dist-packages/pagekite/proto/filters.py:216: SyntaxWarning: invalid escape sequence '\.' 135s '(?:wp-admin/(?!admin-ajax|css/)|wp-config\.php' 135s /usr/lib/python3/dist-packages/pagekite/proto/filters.py:218: SyntaxWarning: invalid escape sequence '\.' 135s '|system32/|\.\.|\.ht(?:access|pass)' 135s /usr/lib/python3/dist-packages/pagekite/proto/filters.py:222: SyntaxWarning: invalid escape sequence '\.' 135s '|(?:adm[^\n]*|install[^\n]*|setup)\.php)' 135s /usr/lib/python3/dist-packages/pagekite/proto/filters.py:224: SyntaxWarning: invalid escape sequence '\d' 135s ' HTTP/\d+\.\d+\s*)$') 135s /usr/lib/python3/dist-packages/pagekite/proto/selectables.py:656: SyntaxWarning: invalid escape sequence '\s' 135s XMPP_REGEXP = re.compile("<[^>]+\sto=([^\s>]+)[^>]*>") 135s /usr/lib/python3/dist-packages/pagekite/ui/basic.py:57: SyntaxWarning: invalid escape sequence '\.' 135s '(?:\.[a-z0-9!#$%&\'*+/=?^_`{|}~-]+)*@' 135s /usr/lib/python3/dist-packages/pagekite/ui/basic.py:58: SyntaxWarning: invalid escape sequence '\.' 135s '(?:[a-z0-9](?:[a-z0-9-]*[a-z0-9])?\.)*' 135s /usr/lib/python3/dist-packages/pagekite/ui/remote.py:46: SyntaxWarning: invalid escape sequence '\.' 135s '(?:\.[a-z0-9!#$%&\'*+/=?^_`{|}~-]+)*@' 135s /usr/lib/python3/dist-packages/pagekite/ui/remote.py:47: SyntaxWarning: invalid escape sequence '\.' 135s '(?:[a-z0-9](?:[a-z0-9-]*[a-z0-9])?\.)*' 135s Created symlink '/etc/systemd/system/multi-user.target.wants/pagekite.service' → '/usr/lib/systemd/system/pagekite.service'. 135s Processing triggers for man-db (2.13.0-1) ... 137s autopkgtest [19:21:07]: test test-client-running: [----------------------- 138s ● pagekite.service - PageKite 138s Loaded: loaded (/usr/lib/systemd/system/pagekite.service; enabled; preset: enabled) 138s Active: active (running) since Mon 2024-12-23 19:21:08 UTC; 12ms ago 138s Invocation: fac7d1c88abd4311a1447da262580e98 138s Docs: man:pagekite 138s file:///usr/share/doc/pagekite/README.md.gz 138s https://pagekite.net/ 138s Main PID: 1610 ((pagekite)) 138s Tasks: 1 (limit: 4743) 138s Memory: 8M (peak: 8M) 138s CPU: 4ms 138s CGroup: /system.slice/pagekite.service 138s └─1610 "(pagekite)" 138s 138s Dec 23 19:21:08 autopkgtest systemd[1]: Started pagekite.service - PageKite. 138s success: service running 139s autopkgtest [19:21:09]: test test-client-running: -----------------------] 139s autopkgtest [19:21:09]: test test-client-running: - - - - - - - - - - results - - - - - - - - - - 139s test-client-running PASS 140s autopkgtest [19:21:10]: test test-tunnel: preparing testbed 140s Reading package lists... 140s Building dependency tree... 140s Reading state information... 140s Starting pkgProblemResolver with broken count: 0 140s Starting 2 pkgProblemResolver with broken count: 0 140s Done 140s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 141s autopkgtest [19:21:11]: test test-tunnel: [----------------------- 141s starting frontend 141s ts=6769b828; t=2024-12-23T19:21:12; ll=0; started=/usr/bin/pagekite; version=1.5.2.201011; platform=linux; python=3.12.8 (main, Dec 13 2024, 13:19:48) [GCC 14.2.0]; argv=--isfrontend --ports=8080 --protos=http --domain=http:autopkgtest:foo; ca_certs=/etc/ssl/certs/ca-certificates.crt; send_always_buffers=False; tunnel_socket_blocks=False; optfile_.SELF/defaults.cfg=ok 141s ts=6769b828; t=2024-12-23T19:21:12; ll=1; listen=:8080; id=s1 142s starting backend 142s ts=6769b829; t=2024-12-23T19:21:13; ll=0; started=/usr/bin/pagekite; version=1.5.2.201011; platform=linux; python=3.12.8 (main, Dec 13 2024, 13:19:48) [GCC 14.2.0]; argv=--frontend=autopkgtest:8080 --service_on=http:autopkgtest:localhost:113:foo; ca_certs=/etc/ssl/certs/ca-certificates.crt; send_always_buffers=False; tunnel_socket_blocks=False; optfile_.SELF/defaults.cfg=ok 152s trying to connect to ident server via pagekite 152s ts=6769b833; t=2024-12-23T19:21:23; ll=2; port=8080; accept=~.1:55898; id=s1 153s success 153s stopping pagekite processes 159s autopkgtest [19:21:29]: test test-tunnel: -----------------------] 159s test-tunnel PASS 159s autopkgtest [19:21:29]: test test-tunnel: - - - - - - - - - - results - - - - - - - - - - 160s autopkgtest [19:21:30]: @@@@@@@@@@@@@@@@@@@@ summary 160s test-client-running PASS 160s test-tunnel PASS 165s nova [W] Using flock in prodstack6-ppc64el 165s Creating nova instance adt-plucky-ppc64el-pagekite-20241223-191850-juju-7f2275-prod-proposed-migration-environment-2-2f6fc42a-c7f8-4044-a3f4-bf9b9e3d7cb9 from image adt/ubuntu-plucky-ppc64el-server-20241222.img (UUID 39d7dd55-6bbb-4a21-8e42-da56aa53b79f)... 165s nova [W] Timed out waiting for ff87de73-5e07-4d9d-ab21-3cc5c9b2f9dc to get deleted.