0s autopkgtest [18:58:40]: starting date and time: 2024-12-23 18:58:40+0000 0s autopkgtest [18:58:40]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [18:58:40]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.efsol4f6/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 --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@bos03-arm64-39.secgroup --name adt-plucky-arm64-pagekite-20241223-185840-juju-7f2275-prod-proposed-migration-environment-15-d3c3ad72-80f9-4971-8168-85bd0e78441e --image adt/ubuntu-plucky-arm64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-15 --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/ 328s autopkgtest [19:04:08]: testbed dpkg architecture: arm64 328s autopkgtest [19:04:08]: testbed apt version: 2.9.16 328s autopkgtest [19:04:08]: @@@@@@@@@@@@@@@@@@@@ test bed setup 328s autopkgtest [19:04:08]: testbed release detected to be: None 329s autopkgtest [19:04:09]: updating testbed package index (apt update) 329s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 330s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 330s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 330s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 330s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [10.8 kB] 330s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [52.8 kB] 330s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [574 kB] 330s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [9708 B] 330s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 Packages [78.9 kB] 330s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted arm64 Packages [57.8 kB] 330s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 Packages [450 kB] 330s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse arm64 Packages [9356 B] 330s Fetched 1317 kB in 1s (1572 kB/s) 331s Reading package lists... 332s Reading package lists... 332s Building dependency tree... 332s Reading state information... 332s Calculating upgrade... 333s The following packages will be upgraded: 333s apt apt-utils libapt-pkg6.0t64 publicsuffix 333s 4 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 333s Need to get 2675 kB of archives. 333s After this operation, 58.4 kB disk space will be freed. 333s Get:1 http://ftpmaster.internal/ubuntu plucky/main arm64 libapt-pkg6.0t64 arm64 2.9.18 [1016 kB] 334s Get:2 http://ftpmaster.internal/ubuntu plucky/main arm64 apt arm64 2.9.18 [1318 kB] 334s Get:3 http://ftpmaster.internal/ubuntu plucky/main arm64 apt-utils arm64 2.9.18 [207 kB] 334s Get:4 http://ftpmaster.internal/ubuntu plucky/main arm64 publicsuffix all 20241206.1516-0.1 [135 kB] 334s Fetched 2675 kB in 1s (3803 kB/s) 334s (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 ... 80069 files and directories currently installed.) 334s Preparing to unpack .../libapt-pkg6.0t64_2.9.18_arm64.deb ... 334s Unpacking libapt-pkg6.0t64:arm64 (2.9.18) over (2.9.16) ... 335s Setting up libapt-pkg6.0t64:arm64 (2.9.18) ... 335s (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 ... 80069 files and directories currently installed.) 335s Preparing to unpack .../archives/apt_2.9.18_arm64.deb ... 335s Unpacking apt (2.9.18) over (2.9.16) ... 335s Setting up apt (2.9.18) ... 336s (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 ... 80063 files and directories currently installed.) 336s Preparing to unpack .../apt-utils_2.9.18_arm64.deb ... 336s Unpacking apt-utils (2.9.18) over (2.9.16) ... 336s Preparing to unpack .../publicsuffix_20241206.1516-0.1_all.deb ... 336s Unpacking publicsuffix (20241206.1516-0.1) over (20241025.1547-0.1) ... 336s Setting up apt-utils (2.9.18) ... 336s Setting up publicsuffix (20241206.1516-0.1) ... 336s Processing triggers for man-db (2.13.0-1) ... 338s Processing triggers for libc-bin (2.40-4ubuntu1) ... 339s Reading package lists... 339s Building dependency tree... 339s Reading state information... 340s 0 upgraded, 0 newly installed, 0 to remove and 1 not upgraded. 340s autopkgtest [19:04:20]: upgrading testbed (apt dist-upgrade and autopurge) 340s Reading package lists... 340s Building dependency tree... 340s Reading state information... 341s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 341s Starting 2 pkgProblemResolver with broken count: 0 341s Done 342s Entering ResolveByKeep 342s 342s The following packages will be upgraded: 342s ca-certificates 343s 1 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 343s Need to get 165 kB of archives. 343s After this operation, 11.3 kB of additional disk space will be used. 343s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 ca-certificates all 20241223 [165 kB] 343s Preconfiguring packages ... 344s Fetched 165 kB in 0s (420 kB/s) 344s (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 ... 80063 files and directories currently installed.) 344s Preparing to unpack .../ca-certificates_20241223_all.deb ... 344s Unpacking ca-certificates (20241223) over (20240203) ... 344s Setting up ca-certificates (20241223) ... 347s Updating certificates in /etc/ssl/certs... 349s rehash: warning: skipping ca-certificates.crt, it does not contain exactly one certificate or CRL 349s 7 added, 1 removed; done. 349s Processing triggers for man-db (2.13.0-1) ... 349s Processing triggers for ca-certificates (20241223) ... 349s Updating certificates in /etc/ssl/certs... 350s 0 added, 0 removed; done. 350s Running hooks in /etc/ca-certificates/update.d... 350s done. 350s Reading package lists... 351s Building dependency tree... 351s Reading state information... 351s Starting pkgProblemResolver with broken count: 0 351s Starting 2 pkgProblemResolver with broken count: 0 351s Done 352s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 352s autopkgtest [19:04:32]: rebooting testbed after setup commands that affected boot 376s autopkgtest [19:04:56]: testbed running kernel: Linux 6.11.0-8-generic #8-Ubuntu SMP PREEMPT_DYNAMIC Mon Sep 16 14:19:41 UTC 2024 378s autopkgtest [19:04:58]: @@@@@@@@@@@@@@@@@@@@ apt-source pagekite 380s Get:1 http://ftpmaster.internal/ubuntu plucky/universe pagekite 1.5.2.201011-2.1ubuntu2 (dsc) [2453 B] 380s Get:2 http://ftpmaster.internal/ubuntu plucky/universe pagekite 1.5.2.201011-2.1ubuntu2 (tar) [690 kB] 380s Get:3 http://ftpmaster.internal/ubuntu plucky/universe pagekite 1.5.2.201011-2.1ubuntu2 (diff) [19.2 kB] 381s gpgv: Signature made Wed Nov 13 09:04:06 2024 UTC 381s gpgv: using RSA key 568BF22A66337CBFC9A6B9B72C83DBC8E9BD0E37 381s gpgv: Can't check signature: No public key 381s dpkg-source: warning: cannot verify inline signature for ./pagekite_1.5.2.201011-2.1ubuntu2.dsc: no acceptable signature found 381s autopkgtest [19:05:01]: testing package pagekite version 1.5.2.201011-2.1ubuntu2 381s autopkgtest [19:05:01]: build not needed 382s autopkgtest [19:05:02]: test test-client-running: preparing testbed 382s Reading package lists... 382s Building dependency tree... 382s Reading state information... 383s Starting pkgProblemResolver with broken count: 0 383s Starting 2 pkgProblemResolver with broken count: 0 383s Done 383s The following NEW packages will be installed: 383s daemon pagekite python3-six python3-socksipychain 384s 0 upgraded, 4 newly installed, 0 to remove and 0 not upgraded. 384s Need to get 247 kB of archives. 384s After this operation, 939 kB of additional disk space will be used. 384s Get:1 http://ftpmaster.internal/ubuntu plucky/main arm64 python3-six all 1.17.0-1 [13.2 kB] 384s Get:2 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-socksipychain all 2.1.2-2 [19.3 kB] 384s Get:3 http://ftpmaster.internal/ubuntu plucky/universe arm64 daemon arm64 0.8.4-1 [63.0 kB] 384s Get:4 http://ftpmaster.internal/ubuntu plucky/universe arm64 pagekite all 1.5.2.201011-2.1ubuntu2 [152 kB] 384s Fetched 247 kB in 0s (577 kB/s) 384s Selecting previously unselected package python3-six. 385s (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 ... 80069 files and directories currently installed.) 385s Preparing to unpack .../python3-six_1.17.0-1_all.deb ... 385s Unpacking python3-six (1.17.0-1) ... 385s Selecting previously unselected package python3-socksipychain. 385s Preparing to unpack .../python3-socksipychain_2.1.2-2_all.deb ... 385s Unpacking python3-socksipychain (2.1.2-2) ... 385s Selecting previously unselected package daemon. 385s Preparing to unpack .../daemon_0.8.4-1_arm64.deb ... 385s Unpacking daemon (0.8.4-1) ... 385s Selecting previously unselected package pagekite. 385s Preparing to unpack .../pagekite_1.5.2.201011-2.1ubuntu2_all.deb ... 385s Unpacking pagekite (1.5.2.201011-2.1ubuntu2) ... 385s Setting up python3-six (1.17.0-1) ... 385s Setting up daemon (0.8.4-1) ... 385s Setting up python3-socksipychain (2.1.2-2) ... 385s Setting up pagekite (1.5.2.201011-2.1ubuntu2) ... 385s /usr/lib/python3/dist-packages/pagekite/common.py:153: SyntaxWarning: invalid escape sequence '\.' 385s SERVICE_DOMAIN_RE = re.compile('\.(' + '|'.join(SERVICE_DOMAINS) + ')$') 385s /usr/lib/python3/dist-packages/pagekite/pk.py:1242: SyntaxWarning: invalid escape sequence '\.' 385s 'localhost': '((::ffff:)?127\..*|::1)', 385s /usr/lib/python3/dist-packages/pagekite/proto/filters.py:163: SyntaxWarning: invalid escape sequence '\d' 385s HTTP_HEADER = re.compile('(?ism)^(([A-Z]+) ([^\n]+) HTTP/\d+\.\d+\s*)$') 385s /usr/lib/python3/dist-packages/pagekite/proto/filters.py:216: SyntaxWarning: invalid escape sequence '\.' 385s '(?:wp-admin/(?!admin-ajax|css/)|wp-config\.php' 385s /usr/lib/python3/dist-packages/pagekite/proto/filters.py:218: SyntaxWarning: invalid escape sequence '\.' 385s '|system32/|\.\.|\.ht(?:access|pass)' 385s /usr/lib/python3/dist-packages/pagekite/proto/filters.py:222: SyntaxWarning: invalid escape sequence '\.' 385s '|(?:adm[^\n]*|install[^\n]*|setup)\.php)' 385s /usr/lib/python3/dist-packages/pagekite/proto/filters.py:224: SyntaxWarning: invalid escape sequence '\d' 385s ' HTTP/\d+\.\d+\s*)$') 385s /usr/lib/python3/dist-packages/pagekite/proto/selectables.py:656: SyntaxWarning: invalid escape sequence '\s' 385s XMPP_REGEXP = re.compile("<[^>]+\sto=([^\s>]+)[^>]*>") 385s /usr/lib/python3/dist-packages/pagekite/ui/basic.py:57: SyntaxWarning: invalid escape sequence '\.' 385s '(?:\.[a-z0-9!#$%&\'*+/=?^_`{|}~-]+)*@' 385s /usr/lib/python3/dist-packages/pagekite/ui/basic.py:58: SyntaxWarning: invalid escape sequence '\.' 385s '(?:[a-z0-9](?:[a-z0-9-]*[a-z0-9])?\.)*' 385s /usr/lib/python3/dist-packages/pagekite/ui/remote.py:46: SyntaxWarning: invalid escape sequence '\.' 385s '(?:\.[a-z0-9!#$%&\'*+/=?^_`{|}~-]+)*@' 385s /usr/lib/python3/dist-packages/pagekite/ui/remote.py:47: SyntaxWarning: invalid escape sequence '\.' 385s '(?:[a-z0-9](?:[a-z0-9-]*[a-z0-9])?\.)*' 386s Created symlink '/etc/systemd/system/multi-user.target.wants/pagekite.service' → '/usr/lib/systemd/system/pagekite.service'. 386s Processing triggers for man-db (2.13.0-1) ... 388s autopkgtest [19:05:08]: test test-client-running: [----------------------- 388s ● pagekite.service - PageKite 388s Loaded: loaded (/usr/lib/systemd/system/pagekite.service; enabled; preset: enabled) 388s Active: active (running) since Mon 2024-12-23 19:05:09 UTC; 12ms ago 388s Invocation: 5cc092ac37334f2fa649eeaa0d23683c 388s Docs: man:pagekite 388s file:///usr/share/doc/pagekite/README.md.gz 388s https://pagekite.net/ 388s Main PID: 1449 ((pagekite)) 388s Tasks: 1 (limit: 4559) 388s Memory: 1.5M (peak: 1.5M) 388s CPU: 5ms 388s CGroup: /system.slice/pagekite.service 388s └─1449 "(pagekite)" 388s 388s Dec 23 19:05:09 autopkgtest systemd[1]: Started pagekite.service - PageKite. 388s success: service running 389s autopkgtest [19:05:09]: test test-client-running: -----------------------] 389s test-client-running PASS 389s autopkgtest [19:05:09]: test test-client-running: - - - - - - - - - - results - - - - - - - - - - 390s autopkgtest [19:05:10]: test test-tunnel: preparing testbed 390s Reading package lists... 390s Building dependency tree... 390s Reading state information... 391s Starting pkgProblemResolver with broken count: 0 391s Starting 2 pkgProblemResolver with broken count: 0 391s Done 391s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 392s autopkgtest [19:05:12]: test test-tunnel: [----------------------- 393s starting frontend 393s ts=6769b469; t=2024-12-23T19:05: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=--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 393s ts=6769b469; t=2024-12-23T19:05:13; ll=1; listen=:8080; id=s1 394s starting backend 394s ts=6769b46a; t=2024-12-23T19:05:14; 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 404s trying to connect to ident server via pagekite 404s ts=6769b474; t=2024-12-23T19:05:24; ll=2; port=8080; accept=~.1:41408; id=s1 405s success 405s stopping pagekite processes 415s autopkgtest [19:05:30]: test test-tunnel: -----------------------] 415s test-tunnel PASS 415s autopkgtest [19:05:35]: test test-tunnel: - - - - - - - - - - results - - - - - - - - - - 415s autopkgtest [19:05:35]: @@@@@@@@@@@@@@@@@@@@ summary 415s test-client-running PASS 415s test-tunnel PASS 433s nova [W] Using flock in prodstack6-arm64 433s flock: timeout while waiting to get lock 433s Creating nova instance adt-plucky-arm64-pagekite-20241223-185840-juju-7f2275-prod-proposed-migration-environment-15-d3c3ad72-80f9-4971-8168-85bd0e78441e from image adt/ubuntu-plucky-arm64-server-20241223.img (UUID 0a1f1247-ff45-4854-bea5-f355787441f0)... 433s nova [W] Timed out waiting for 00974967-cd3e-4c50-8ee4-81b4f0f3d3bb to get deleted.