0s autopkgtest [18:57:57]: starting date and time: 2024-12-23 18:57:57+0000 1s autopkgtest [18:57:58]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 1s autopkgtest [18:57:58]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.0j1xm0wc/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 builder-cpu2-ram4-disk20 --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-8.secgroup --name adt-plucky-amd64-pagekite-20241223-185757-juju-7f2275-prod-proposed-migration-environment-2-1b3404a1-64e8-4771-a5e0-85694581f5cd --image adt/ubuntu-plucky-amd64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration-amd64 -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/ 118s autopkgtest [18:59:55]: testbed dpkg architecture: amd64 118s autopkgtest [18:59:55]: testbed apt version: 2.9.16 119s autopkgtest [18:59:56]: @@@@@@@@@@@@@@@@@@@@ test bed setup 119s autopkgtest [18:59:56]: testbed release detected to be: None 119s autopkgtest [18:59:56]: updating testbed package index (apt update) 120s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 120s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 120s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 120s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 120s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [10.8 kB] 120s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [9708 B] 120s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [52.8 kB] 120s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [574 kB] 120s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main i386 Packages [43.5 kB] 120s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/main amd64 Packages [82.4 kB] 120s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/restricted amd64 Packages [40.1 kB] 120s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/restricted i386 Packages [2408 B] 120s Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/universe i386 Packages [159 kB] 120s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/universe amd64 Packages [447 kB] 120s Get:15 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse i386 Packages [3344 B] 120s Get:16 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse amd64 Packages [9408 B] 121s Fetched 1508 kB in 1s (1773 kB/s) 121s Reading package lists... 122s Reading package lists... 122s Building dependency tree... 122s Reading state information... 122s Calculating upgrade... 122s The following packages will be upgraded: 122s apt apt-utils libapt-pkg6.0t64 publicsuffix 123s 4 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 123s Need to get 2860 kB of archives. 123s After this operation, 50.2 kB disk space will be freed. 123s Get:1 http://ftpmaster.internal/ubuntu plucky/main amd64 libapt-pkg6.0t64 amd64 2.9.18 [1125 kB] 123s Get:2 http://ftpmaster.internal/ubuntu plucky/main amd64 apt amd64 2.9.18 [1377 kB] 123s Get:3 http://ftpmaster.internal/ubuntu plucky/main amd64 apt-utils amd64 2.9.18 [224 kB] 123s Get:4 http://ftpmaster.internal/ubuntu plucky/main amd64 publicsuffix all 20241206.1516-0.1 [135 kB] 123s Fetched 2860 kB in 1s (4199 kB/s) 124s (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 ... 75688 files and directories currently installed.) 124s Preparing to unpack .../libapt-pkg6.0t64_2.9.18_amd64.deb ... 124s Unpacking libapt-pkg6.0t64:amd64 (2.9.18) over (2.9.16) ... 124s Setting up libapt-pkg6.0t64:amd64 (2.9.18) ... 124s (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 ... 75688 files and directories currently installed.) 124s Preparing to unpack .../archives/apt_2.9.18_amd64.deb ... 124s Unpacking apt (2.9.18) over (2.9.16) ... 124s Setting up apt (2.9.18) ... 124s (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 ... 75682 files and directories currently installed.) 124s Preparing to unpack .../apt-utils_2.9.18_amd64.deb ... 124s Unpacking apt-utils (2.9.18) over (2.9.16) ... 124s Preparing to unpack .../publicsuffix_20241206.1516-0.1_all.deb ... 124s Unpacking publicsuffix (20241206.1516-0.1) over (20241025.1547-0.1) ... 124s Setting up apt-utils (2.9.18) ... 124s Setting up publicsuffix (20241206.1516-0.1) ... 124s Processing triggers for man-db (2.13.0-1) ... 126s Processing triggers for libc-bin (2.40-4ubuntu1) ... 127s Reading package lists... 127s Building dependency tree... 127s Reading state information... 127s 0 upgraded, 0 newly installed, 0 to remove and 1 not upgraded. 127s autopkgtest [19:00:04]: upgrading testbed (apt dist-upgrade and autopurge) 127s Reading package lists... 128s Building dependency tree... 128s Reading state information... 128s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 128s Starting 2 pkgProblemResolver with broken count: 0 128s Done 128s Entering ResolveByKeep 128s 128s The following packages will be upgraded: 128s ca-certificates 129s 1 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 129s Need to get 165 kB of archives. 129s After this operation, 11.3 kB of additional disk space will be used. 129s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main amd64 ca-certificates all 20241223 [165 kB] 129s Preconfiguring packages ... 130s Fetched 165 kB in 0s (491 kB/s) 130s (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 ... 75682 files and directories currently installed.) 130s Preparing to unpack .../ca-certificates_20241223_all.deb ... 130s Unpacking ca-certificates (20241223) over (20240203) ... 130s Setting up ca-certificates (20241223) ... 132s Updating certificates in /etc/ssl/certs... 133s rehash: warning: skipping ca-certificates.crt, it does not contain exactly one certificate or CRL 133s 7 added, 1 removed; done. 133s Processing triggers for man-db (2.13.0-1) ... 133s Processing triggers for ca-certificates (20241223) ... 133s Updating certificates in /etc/ssl/certs... 134s 0 added, 0 removed; done. 134s Running hooks in /etc/ca-certificates/update.d... 134s done. 134s Reading package lists... 134s Building dependency tree... 134s Reading state information... 134s Starting pkgProblemResolver with broken count: 0 134s Starting 2 pkgProblemResolver with broken count: 0 134s Done 135s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 135s autopkgtest [19:00:12]: rebooting testbed after setup commands that affected boot 158s autopkgtest [19:00:35]: testbed running kernel: Linux 6.11.0-8-generic #8-Ubuntu SMP PREEMPT_DYNAMIC Mon Sep 16 13:41:20 UTC 2024 161s autopkgtest [19:00:38]: @@@@@@@@@@@@@@@@@@@@ apt-source pagekite 163s Get:1 http://ftpmaster.internal/ubuntu plucky/universe pagekite 1.5.2.201011-2.1ubuntu2 (dsc) [2453 B] 163s Get:2 http://ftpmaster.internal/ubuntu plucky/universe pagekite 1.5.2.201011-2.1ubuntu2 (tar) [690 kB] 163s Get:3 http://ftpmaster.internal/ubuntu plucky/universe pagekite 1.5.2.201011-2.1ubuntu2 (diff) [19.2 kB] 163s gpgv: Signature made Wed Nov 13 09:04:06 2024 UTC 163s gpgv: using RSA key 568BF22A66337CBFC9A6B9B72C83DBC8E9BD0E37 163s gpgv: Can't check signature: No public key 163s dpkg-source: warning: cannot verify inline signature for ./pagekite_1.5.2.201011-2.1ubuntu2.dsc: no acceptable signature found 163s autopkgtest [19:00:40]: testing package pagekite version 1.5.2.201011-2.1ubuntu2 164s autopkgtest [19:00:41]: build not needed 164s autopkgtest [19:00:41]: test test-client-running: preparing testbed 164s Reading package lists... 165s Building dependency tree... 165s Reading state information... 165s Starting pkgProblemResolver with broken count: 0 165s Starting 2 pkgProblemResolver with broken count: 0 165s Done 165s The following NEW packages will be installed: 165s daemon pagekite python3-six python3-socksipychain 165s 0 upgraded, 4 newly installed, 0 to remove and 0 not upgraded. 165s Need to get 247 kB of archives. 165s After this operation, 910 kB of additional disk space will be used. 165s Get:1 http://ftpmaster.internal/ubuntu plucky/main amd64 python3-six all 1.17.0-1 [13.2 kB] 165s Get:2 http://ftpmaster.internal/ubuntu plucky/universe amd64 python3-socksipychain all 2.1.2-2 [19.3 kB] 165s Get:3 http://ftpmaster.internal/ubuntu plucky/universe amd64 daemon amd64 0.8.4-1 [62.7 kB] 165s Get:4 http://ftpmaster.internal/ubuntu plucky/universe amd64 pagekite all 1.5.2.201011-2.1ubuntu2 [152 kB] 166s Fetched 247 kB in 0s (541 kB/s) 166s Selecting previously unselected package python3-six. 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 ... 75688 files and directories currently installed.) 166s Preparing to unpack .../python3-six_1.17.0-1_all.deb ... 166s Unpacking python3-six (1.17.0-1) ... 166s Selecting previously unselected package python3-socksipychain. 166s Preparing to unpack .../python3-socksipychain_2.1.2-2_all.deb ... 166s Unpacking python3-socksipychain (2.1.2-2) ... 166s Selecting previously unselected package daemon. 166s Preparing to unpack .../daemon_0.8.4-1_amd64.deb ... 166s Unpacking daemon (0.8.4-1) ... 166s Selecting previously unselected package pagekite. 166s Preparing to unpack .../pagekite_1.5.2.201011-2.1ubuntu2_all.deb ... 166s Unpacking pagekite (1.5.2.201011-2.1ubuntu2) ... 166s Setting up python3-six (1.17.0-1) ... 166s Setting up daemon (0.8.4-1) ... 166s Setting up python3-socksipychain (2.1.2-2) ... 166s Setting up pagekite (1.5.2.201011-2.1ubuntu2) ... 167s /usr/lib/python3/dist-packages/pagekite/common.py:153: SyntaxWarning: invalid escape sequence '\.' 167s SERVICE_DOMAIN_RE = re.compile('\.(' + '|'.join(SERVICE_DOMAINS) + ')$') 167s /usr/lib/python3/dist-packages/pagekite/pk.py:1242: SyntaxWarning: invalid escape sequence '\.' 167s 'localhost': '((::ffff:)?127\..*|::1)', 167s /usr/lib/python3/dist-packages/pagekite/proto/filters.py:163: SyntaxWarning: invalid escape sequence '\d' 167s HTTP_HEADER = re.compile('(?ism)^(([A-Z]+) ([^\n]+) HTTP/\d+\.\d+\s*)$') 167s /usr/lib/python3/dist-packages/pagekite/proto/filters.py:216: SyntaxWarning: invalid escape sequence '\.' 167s '(?:wp-admin/(?!admin-ajax|css/)|wp-config\.php' 167s /usr/lib/python3/dist-packages/pagekite/proto/filters.py:218: SyntaxWarning: invalid escape sequence '\.' 167s '|system32/|\.\.|\.ht(?:access|pass)' 167s /usr/lib/python3/dist-packages/pagekite/proto/filters.py:222: SyntaxWarning: invalid escape sequence '\.' 167s '|(?:adm[^\n]*|install[^\n]*|setup)\.php)' 167s /usr/lib/python3/dist-packages/pagekite/proto/filters.py:224: SyntaxWarning: invalid escape sequence '\d' 167s ' HTTP/\d+\.\d+\s*)$') 167s /usr/lib/python3/dist-packages/pagekite/proto/selectables.py:656: SyntaxWarning: invalid escape sequence '\s' 167s XMPP_REGEXP = re.compile("<[^>]+\sto=([^\s>]+)[^>]*>") 167s /usr/lib/python3/dist-packages/pagekite/ui/basic.py:57: SyntaxWarning: invalid escape sequence '\.' 167s '(?:\.[a-z0-9!#$%&\'*+/=?^_`{|}~-]+)*@' 167s /usr/lib/python3/dist-packages/pagekite/ui/basic.py:58: SyntaxWarning: invalid escape sequence '\.' 167s '(?:[a-z0-9](?:[a-z0-9-]*[a-z0-9])?\.)*' 167s /usr/lib/python3/dist-packages/pagekite/ui/remote.py:46: SyntaxWarning: invalid escape sequence '\.' 167s '(?:\.[a-z0-9!#$%&\'*+/=?^_`{|}~-]+)*@' 167s /usr/lib/python3/dist-packages/pagekite/ui/remote.py:47: SyntaxWarning: invalid escape sequence '\.' 167s '(?:[a-z0-9](?:[a-z0-9-]*[a-z0-9])?\.)*' 167s Created symlink '/etc/systemd/system/multi-user.target.wants/pagekite.service' → '/usr/lib/systemd/system/pagekite.service'. 167s Processing triggers for man-db (2.13.0-1) ... 169s autopkgtest [19:00:46]: test test-client-running: [----------------------- 169s ● pagekite.service - PageKite 169s Loaded: loaded (/usr/lib/systemd/system/pagekite.service; enabled; preset: enabled) 169s Active: active (running) since Mon 2024-12-23 19:00:46 UTC; 10ms ago 169s Invocation: f332d12e94c14cca900c0f84d02c229b 169s Docs: man:pagekite 169s file:///usr/share/doc/pagekite/README.md.gz 169s https://pagekite.net/ 169s Main PID: 1450 ((pagekite)) 169s Tasks: 1 (limit: 4616) 169s Memory: 1.6M (peak: 1.6M) 169s CPU: 3ms 169s CGroup: /system.slice/pagekite.service 169s └─1450 "(pagekite)" 169s 169s Dec 23 19:00:46 autopkgtest systemd[1]: Started pagekite.service - PageKite. 169s success: service running 170s autopkgtest [19:00:47]: test test-client-running: -----------------------] 170s test-client-running PASS 170s autopkgtest [19:00:47]: test test-client-running: - - - - - - - - - - results - - - - - - - - - - 171s autopkgtest [19:00:48]: test test-tunnel: preparing testbed 171s Reading package lists... 171s Building dependency tree... 171s Reading state information... 171s Starting pkgProblemResolver with broken count: 0 171s Starting 2 pkgProblemResolver with broken count: 0 171s Done 172s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 172s autopkgtest [19:00:49]: test test-tunnel: [----------------------- 172s starting frontend 173s ts=6769b362; t=2024-12-23T19:00:50; 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 173s ts=6769b362; t=2024-12-23T19:00:50; ll=1; listen=:8080; id=s1 173s starting backend 174s ts=6769b363; t=2024-12-23T19:00:51; 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 184s trying to connect to ident server via pagekite 184s ts=6769b36c; t=2024-12-23T19:01:00; ll=2; port=8080; accept=~.1:40800; id=s1 185s success 185s stopping pagekite processes 190s autopkgtest [19:01:07]: test test-tunnel: -----------------------] 190s autopkgtest [19:01:07]: test test-tunnel: - - - - - - - - - - results - - - - - - - - - - 190s test-tunnel PASS 191s autopkgtest [19:01:08]: @@@@@@@@@@@@@@@@@@@@ summary 191s test-client-running PASS 191s test-tunnel PASS 297s nova [W] Skipping flock for amd64 297s Creating nova instance adt-plucky-amd64-pagekite-20241223-185757-juju-7f2275-prod-proposed-migration-environment-2-1b3404a1-64e8-4771-a5e0-85694581f5cd from image adt/ubuntu-plucky-amd64-server-20241223.img (UUID 4467e4af-2c20-4f15-9828-45052f92880f)... 297s nova [W] Timed out waiting for e41c5bbe-b33a-40fe-9611-bddcdc464699 to get deleted.