0s autopkgtest [16:02:39]: starting date and time: 2024-08-13 16:02:39+0000 0s autopkgtest [16:02:39]: git checkout: fd3bed09 nova: allow more retries for quota issues 0s autopkgtest [16:02:39]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.enrxu3__/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:libseccomp --apt-upgrade stenographer --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=libseccomp/2.5.5-1ubuntu4 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-arm64-12.secgroup --name adt-oracular-arm64-stenographer-20240813-160239-juju-7f2275-prod-proposed-migration-environment-2-2fc21ac2-bdc9-4861-98f9-ee44ae116217 --image adt/ubuntu-oracular-arm64-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/ 289s autopkgtest [16:07:28]: testbed dpkg architecture: arm64 289s autopkgtest [16:07:28]: testbed apt version: 2.9.7 289s autopkgtest [16:07:28]: @@@@@@@@@@@@@@@@@@@@ test bed setup 290s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [126 kB] 290s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [8452 B] 291s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [96.1 kB] 291s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [749 kB] 291s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [10.3 kB] 291s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 Packages [157 kB] 291s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 c-n-f Metadata [6120 B] 291s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/restricted arm64 Packages [44.8 kB] 291s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/restricted arm64 c-n-f Metadata [372 B] 291s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/universe arm64 Packages [774 kB] 291s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/universe arm64 c-n-f Metadata [20.4 kB] 291s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse arm64 Packages [12.1 kB] 291s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse arm64 c-n-f Metadata [532 B] 292s Fetched 2005 kB in 1s (1498 kB/s) 292s Reading package lists... 296s Reading package lists... 296s Building dependency tree... 296s Reading state information... 297s Calculating upgrade... 297s The following packages will be upgraded: 297s libseccomp2 298s 1 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 298s Need to get 51.4 kB of archives. 298s After this operation, 0 B of additional disk space will be used. 298s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 libseccomp2 arm64 2.5.5-1ubuntu4 [51.4 kB] 299s Fetched 51.4 kB in 0s (132 kB/s) 300s (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 ... 78308 files and directories currently installed.) 300s Preparing to unpack .../libseccomp2_2.5.5-1ubuntu4_arm64.deb ... 300s Unpacking libseccomp2:arm64 (2.5.5-1ubuntu4) over (2.5.5-1ubuntu3) ... 300s Setting up libseccomp2:arm64 (2.5.5-1ubuntu4) ... 300s Processing triggers for libc-bin (2.39-0ubuntu9) ... 300s Reading package lists... 300s Building dependency tree... 300s Reading state information... 301s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 302s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 302s Hit:2 http://ftpmaster.internal/ubuntu oracular InRelease 302s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease 302s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease 303s Reading package lists... 303s Reading package lists... 304s Building dependency tree... 304s Reading state information... 304s Calculating upgrade... 305s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 305s Reading package lists... 305s Building dependency tree... 305s Reading state information... 306s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 310s autopkgtest [16:07:49]: testbed running kernel: Linux 6.8.0-31-generic #31-Ubuntu SMP PREEMPT_DYNAMIC Sat Apr 20 02:32:42 UTC 2024 310s autopkgtest [16:07:49]: @@@@@@@@@@@@@@@@@@@@ apt-source stenographer 317s Get:1 http://ftpmaster.internal/ubuntu oracular/universe stenographer 1.0.1-6 (dsc) [2753 B] 317s Get:2 http://ftpmaster.internal/ubuntu oracular/universe stenographer 1.0.1-6 (tar) [149 kB] 317s Get:3 http://ftpmaster.internal/ubuntu oracular/universe stenographer 1.0.1-6 (diff) [14.9 kB] 318s gpgv: Signature made Sat Jul 13 13:00:01 2024 UTC 318s gpgv: using RSA key 5B34BA5AAB5507E903426E85E8D37AE2F09F4872 318s gpgv: Can't check signature: No public key 318s dpkg-source: warning: cannot verify inline signature for ./stenographer_1.0.1-6.dsc: no acceptable signature found 319s autopkgtest [16:07:58]: testing package stenographer version 1.0.1-6 320s autopkgtest [16:07:59]: build not needed 323s autopkgtest [16:08:02]: test run-example: preparing testbed 328s Reading package lists... 335s Building dependency tree... 335s Reading state information... 336s Starting pkgProblemResolver with broken count: 0 336s Starting 2 pkgProblemResolver with broken count: 0 336s Done 337s The following additional packages will be installed: 337s libleveldb1d libsnappy1v5 net-tools stenographer stenographer-client 337s stenographer-common 339s The following NEW packages will be installed: 339s autopkgtest-satdep libleveldb1d libsnappy1v5 net-tools stenographer 339s stenographer-client stenographer-common 340s 0 upgraded, 7 newly installed, 0 to remove and 0 not upgraded. 340s Need to get 3798 kB/3799 kB of archives. 340s After this operation, 12.7 MB of additional disk space will be used. 340s Get:1 /tmp/autopkgtest.IJ5ILn/1-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [752 B] 348s Get:2 http://ftpmaster.internal/ubuntu oracular/main arm64 libsnappy1v5 arm64 1.2.1-1 [30.4 kB] 348s Get:3 http://ftpmaster.internal/ubuntu oracular/universe arm64 libleveldb1d arm64 1.23-5build1 [124 kB] 348s Get:4 http://ftpmaster.internal/ubuntu oracular/main arm64 net-tools arm64 2.10-1.1ubuntu1 [207 kB] 348s Get:5 http://ftpmaster.internal/ubuntu oracular/universe arm64 stenographer-common all 1.0.1-6 [20.9 kB] 348s Get:6 http://ftpmaster.internal/ubuntu oracular/universe arm64 stenographer arm64 1.0.1-6 [3411 kB] 348s Get:7 http://ftpmaster.internal/ubuntu oracular/universe arm64 stenographer-client all 1.0.1-6 [5288 B] 355s Fetched 3798 kB in 10s (395 kB/s) 355s Selecting previously unselected package libsnappy1v5:arm64. 355s (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 ... 78308 files and directories currently installed.) 355s Preparing to unpack .../0-libsnappy1v5_1.2.1-1_arm64.deb ... 355s Unpacking libsnappy1v5:arm64 (1.2.1-1) ... 355s Selecting previously unselected package libleveldb1d:arm64. 356s Preparing to unpack .../1-libleveldb1d_1.23-5build1_arm64.deb ... 356s Unpacking libleveldb1d:arm64 (1.23-5build1) ... 356s Selecting previously unselected package net-tools. 356s Preparing to unpack .../2-net-tools_2.10-1.1ubuntu1_arm64.deb ... 356s Unpacking net-tools (2.10-1.1ubuntu1) ... 356s Selecting previously unselected package stenographer-common. 356s Preparing to unpack .../3-stenographer-common_1.0.1-6_all.deb ... 356s Unpacking stenographer-common (1.0.1-6) ... 356s Selecting previously unselected package stenographer. 356s Preparing to unpack .../4-stenographer_1.0.1-6_arm64.deb ... 356s Unpacking stenographer (1.0.1-6) ... 356s Selecting previously unselected package stenographer-client. 356s Preparing to unpack .../5-stenographer-client_1.0.1-6_all.deb ... 356s Unpacking stenographer-client (1.0.1-6) ... 356s Selecting previously unselected package autopkgtest-satdep. 356s Preparing to unpack .../6-1-autopkgtest-satdep.deb ... 356s Unpacking autopkgtest-satdep (0) ... 356s Setting up net-tools (2.10-1.1ubuntu1) ... 356s Setting up stenographer-common (1.0.1-6) ... 356s info: Selecting UID from range 100 to 999 ... 356s 356s info: Selecting GID from range 100 to 999 ... 356s info: Adding system user `stenographer' (UID 107) ... 356s info: Adding new group `stenographer' (GID 108) ... 356s info: Adding new user `stenographer' (UID 107) with group `stenographer' ... 357s info: Not creating home directory `/var/lib/stenographer'. 357s Generating CA state 359s Generating key/cert for 'client' 360s Generating key/cert for 'server' 362s Ignoring -days without -x509; not generating a certificate 362s Using configuration from /tmp/stenossl.BqHxVmnrXth7 362s Check that the request matches the signature 362s Signature ok 362s The Subject's Distinguished Name is as follows 362s countryName :PRINTABLE:'XX' 362s organizationName :ASN.1 12:'Stenographer' 362s commonName :ASN.1 12:'127.0.0.1_client' 362s Certificate is to be certified until Dec 29 16:08:40 2051 GMT (9999 days) 362s 362s Write out database with 1 new entries 362s Database updated 362s Ignoring -days without -x509; not generating a certificate 362s Using configuration from /tmp/stenossl.BqHxVmnrXth7 362s Check that the request matches the signature 362s Signature ok 362s The Subject's Distinguished Name is as follows 362s countryName :PRINTABLE:'XX' 362s organizationName :ASN.1 12:'Stenographer' 362s commonName :ASN.1 12:'127.0.0.1' 362s Certificate is to be certified until Dec 29 16:08:42 2051 GMT (9999 days) 362s 362s Write out database with 1 new entries 362s Database updated 362s Setting up stenographer-client (1.0.1-6) ... 362s Setting up libsnappy1v5:arm64 (1.2.1-1) ... 362s Setting up libleveldb1d:arm64 (1.23-5build1) ... 362s Setting up stenographer (1.0.1-6) ... 362s setcap on /usr/sbin/stenotype worked. 362s Setting up autopkgtest-satdep (0) ... 362s Processing triggers for man-db (2.12.1-2) ... 363s Processing triggers for libc-bin (2.39-0ubuntu9) ... 368s (Reading database ... 78392 files and directories currently installed.) 368s Removing autopkgtest-satdep (0) ... 369s autopkgtest [16:08:48]: test run-example: [----------------------- 370s Filesystem info: 370s Filesystem Type Size Used Avail Use% Mounted on 370s /dev/vda1 ext4 19G 2.2G 17G 12% / 370s Kernel IP routing table 370s Destination Gateway Genmask Flags Metric Ref Use Iface 370s 0.0.0.0 10.145.243.1 0.0.0.0 UG 100 0 0 enp1s0 370s 10.145.243.0 0.0.0.0 255.255.255.0 U 100 0 0 enp1s0 370s 10.145.243.1 0.0.0.0 255.255.255.255 UH 100 0 0 enp1s0 370s 10.145.243.2 0.0.0.0 255.255.255.255 UH 100 0 0 enp1s0 370s 91.189.91.131 10.145.243.1 255.255.255.255 UGH 100 0 0 enp1s0 370s 91.189.91.132 10.145.243.1 255.255.255.255 UGH 100 0 0 enp1s0 370s 169.254.169.254 10.145.243.2 255.255.255.255 UGH 100 0 0 enp1s0 370s Using interface enp1s0 391s ● stenographer.service - packet capture to disk 391s Loaded: loaded (/usr/lib/systemd/system/stenographer.service; disabled; preset: enabled) 391s Active: active (running) since Tue 2024-08-13 16:08:50 UTC; 20s ago 391s Invocation: 68987fd0b5b94ef9a9600a70c29f7d9f 391s Docs: https://github.com/google/stenographer 391s https://github.com/google/stenographer/blob/master/DESIGN.md 391s https://github.com/google/stenographer/blob/master/INSTALL.md 391s Main PID: 2403 (stenographer) 391s Tasks: 13 (limit: 4555) 391s Memory: 9.6M (peak: 10.1M) 391s CPU: 498ms 391s CGroup: /system.slice/stenographer.service 391s ├─2403 /usr/sbin/stenographer 391s └─2410 /usr/sbin/stenotype --blocks=256 --seccomp=none --threads=1 --dir=/tmp/stenographer2551136793 --iface=enp1s0 391s 391s Aug 13 16:08:50 autopkgtest systemd[1]: Started stenographer.service - packet capture to disk. 391s active 395s % Total % Received % Xferd Average Speed Time Time Time Current 395s Dload Upload Total Spent Left Speed 399s 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 0 0 0 0 0 0 0 0 --:--:-- 0:00:01 --:--:-- 0 0 0 0 0 0 0 0 0 --:--:-- 0:00:02 --:--:-- 0 0 0 0 0 0 0 0 0 --:--:-- 0:00:03 --:--:-- 0 0 0 0 0 0 0 0 0 --:--:-- 0:00:04 --:--:-- 0 100 271 100 271 0 0 52 0 0:00:05 0:00:05 --:--:-- 55 100 271 100 271 0 0 52 0 0:00:05 0:00:05 --:--:-- 67 580s ● stenographer.service - packet capture to disk 580s Loaded: loaded (/usr/lib/systemd/system/stenographer.service; disabled; preset: enabled) 580s Active: active (running) since Tue 2024-08-13 16:08:50 UTC; 3min 28s ago 580s Invocation: 68987fd0b5b94ef9a9600a70c29f7d9f 580s Docs: https://github.com/google/stenographer 580s https://github.com/google/stenographer/blob/master/DESIGN.md 580s https://github.com/google/stenographer/blob/master/INSTALL.md 580s Main PID: 2403 (stenographer) 580s Tasks: 13 (limit: 4555) 580s Memory: 9.7M (peak: 10.2M) 580s CPU: 636ms 580s CGroup: /system.slice/stenographer.service 580s ├─2403 /usr/sbin/stenographer 580s └─2410 /usr/sbin/stenotype --blocks=256 --seccomp=none --threads=1 --dir=/tmp/stenographer2551136793 --iface=enp1s0 580s 580s Aug 13 16:08:50 autopkgtest systemd[1]: Started stenographer.service - packet capture to disk. 580s tcp 0 0 127.0.0.1:1234 0.0.0.0:* LISTEN 2403/stenographer 580s Running stenographer query 'after 5m ago', piping to 'tcpdump ' 580s reading from file /dev/stdin, link-type EN10MB (Ethernet), snapshot length 65536 581s 16:08:50.987603 ARP, Request who-has 10.145.243.206 tell _gateway, length 28 581s 16:08:54.062754 ARP, Request who-has 10.145.243.89 tell _gateway, length 28 581s 16:08:54.582927 IP6 autopkgtest > ip6-allrouters: ICMP6, router solicitation, length 16 581s 16:08:56.325440 ARP, Request who-has 10.145.243.58 tell _gateway, length 28 581s 16:08:56.325611 ARP, Request who-has 10.145.243.58 tell _gateway, length 28 581s 16:08:56.505528 ARP, Request who-has 10.145.243.58 tell _gateway, length 28 581s 16:08:56.821895 ARP, Request who-has 10.145.243.58 tell _gateway, length 28 581s 16:08:57.430732 ARP, Request who-has 10.145.243.58 tell _gateway, length 28 581s 16:08:58.617529 ARP, Request who-has 10.145.243.58 tell _gateway, length 28 581s 16:09:01.174064 ARP, Request who-has 10.145.243.58 tell _gateway, length 28 581s 16:09:03.536844 ARP, Request who-has 10.145.243.89 tell _gateway, length 28 581s 16:09:04.485714 IP autopkgtest.38742 > prod-ntp-4.ntp1.ps5.canonical.com.ntp: NTPv4, Client, length 48 581s 16:09:05.790825 IP prod-ntp-4.ntp1.ps5.canonical.com.ntp > autopkgtest.38742: NTPv4, Server, length 48 581s 16:09:06.037739 ARP, Request who-has 10.145.243.58 tell _gateway, length 28 581s 16:09:07.631181 ARP, Request who-has 10.145.243.203 tell _gateway, length 28 581s 16:09:10.581311 IP autopkgtest.ssh > 10.136.6.184.52458: Flags [P.], seq 731020824:731021764, ack 2441627024, win 249, options [nop,nop,TS val 828930524 ecr 1617032817], length 940 581s 16:09:10.678173 IP autopkgtest.ssh > 10.136.6.184.52458: Flags [P.], seq 940:984, ack 1, win 249, options [nop,nop,TS val 828930620 ecr 1617032817], length 44 581s 16:09:10.882163 IP autopkgtest.ssh > 10.136.6.184.52458: Flags [P.], seq 940:984, ack 1, win 249, options [nop,nop,TS val 828930824 ecr 1617032817], length 44 581s 16:09:11.267672 IP autopkgtest.ssh > 10.136.6.184.52458: Flags [P.], seq 0:984, ack 1, win 249, options [nop,nop,TS val 828931210 ecr 1617032817], length 984 581s 16:09:11.958611 IP autopkgtest.ssh > 10.136.6.184.52458: Flags [P.], seq 0:984, ack 1, win 249, options [nop,nop,TS val 828931901 ecr 1617032817], length 984 581s 16:09:13.202836 IP autopkgtest.ssh > 10.136.6.184.52458: Flags [P.], seq 0:984, ack 1, win 249, options [nop,nop,TS val 828933145 ecr 1617032817], length 984 581s 16:09:15.260751 IP autopkgtest.40465 > csb-recursive-nameserver2.canonical.com.domain: 7191+ [1au] A? squid.internal. (43) 581s 16:09:15.260835 IP autopkgtest.36567 > csb-recursive-nameserver2.canonical.com.domain: 11949+ [1au] AAAA? squid.internal. (43) 581s 16:09:15.632228 IP autopkgtest.ssh > 10.136.6.184.52458: Flags [P.], seq 0:984, ack 1, win 249, options [nop,nop,TS val 828935575 ecr 1617032817], length 984 581s 16:09:15.830383 IP 10.136.6.184.52458 > autopkgtest.ssh: Flags [.], ack 984, win 21318, options [nop,nop,TS val 1617054387 ecr 828931901], length 0 581s 16:09:15.830405 IP autopkgtest.ssh > 10.136.6.184.52458: Flags [P.], seq 984:1384, ack 1, win 249, options [nop,nop,TS val 828935773 ecr 1617054387], length 400 581s 16:09:15.907705 IP 10.136.6.184.52458 > autopkgtest.ssh: Flags [.], ack 1384, win 21318, options [nop,nop,TS val 1617058260 ecr 828935773], length 0 581s 16:09:16.232913 IP 10.136.6.184.52458 > autopkgtest.ssh: Flags [.], ack 984, win 21318, options [nop,nop,TS val 1617056170 ecr 828933145,nop,nop,sack 1 {0:984}], length 0 581s 16:09:16.232931 IP autopkgtest.ssh > 10.136.6.184.52458: Flags [.], ack 1, win 249, options [nop,nop,TS val 828936175 ecr 1617058260], length 0 581s 16:09:16.233145 IP 10.136.6.184.52458 > autopkgtest.ssh: Flags [.], ack 984, win 21318, options [nop,nop,TS val 1617058064 ecr 828935575,nop,nop,sack 1 {0:984}], length 0 581s 16:09:16.233145 IP 10.136.6.184.52458 > autopkgtest.ssh: Flags [.], ack 984, win 21318, options [nop,nop,TS val 1617055632 ecr 828933145,nop,nop,sack 1 {0:984}], length 0 581s 16:09:16.463760 IP autopkgtest.ssh > 10.136.6.184.52458: Flags [P.], seq 1384:1508, ack 1, win 249, options [nop,nop,TS val 828936406 ecr 1617058260], length 124 581s 16:09:16.539814 IP 10.136.6.184.52458 > autopkgtest.ssh: Flags [.], ack 1508, win 21318, options [nop,nop,TS val 1617058893 ecr 828936406], length 0 581s 16:09:17.468651 IP autopkgtest.ssh > 10.136.6.184.52458: Flags [P.], seq 1508:1632, ack 1, win 249, options [nop,nop,TS val 828937411 ecr 1617058893], length 124 581s 16:09:17.542330 IP 10.136.6.184.52458 > autopkgtest.ssh: Flags [.], ack 1632, win 21318, options [nop,nop,TS val 1617059897 ecr 828937411], length 0 581s 16:09:18.305316 ARP, Request who-has 10.145.243.206 tell _gateway, length 28 581s 16:09:18.305482 ARP, Request who-has 10.145.243.58 tell _gateway, length 28 581s 16:09:18.471786 IP autopkgtest.ssh > 10.136.6.184.52458: Flags [P.], seq 1632:1756, ack 1, win 249, options [nop,nop,TS val 828938414 ecr 1617059897], length 124 581s 16:09:18.543827 IP 10.136.6.184.52458 > autopkgtest.ssh: Flags [.], ack 1756, win 21318, options [nop,nop,TS val 1617060899 ecr 828938414], length 0 581s 16:09:19.051848 IP csb-recursive-nameserver2.canonical.com.domain > autopkgtest.36567: 11949 0/1/1 (116) 581s 16:09:19.051849 IP csb-recursive-nameserver2.canonical.com.domain > autopkgtest.40465: 7191 2/0/1 A 185.125.188.86, A 185.125.188.85 (75) 581s 16:09:19.072456 IP autopkgtest.42060 > internal-proxy-1.canonical.com.3128: Flags [S], seq 1950648367, win 32120, options [mss 1460,sackOK,TS val 1468527775 ecr 0,nop,wscale 7], length 0 581s 16:09:19.119544 IP 10.136.6.184.52458 > autopkgtest.ssh: Flags [.], ack 1756, win 21318, options [nop,nop,TS val 1617061475 ecr 828938414,nop,nop,sack 1 {0:940}], length 0 581s 16:09:19.119544 IP 10.136.6.184.52458 > autopkgtest.ssh: Flags [.], ack 1756, win 21318, options [nop,nop,TS val 1617061475 ecr 828938414,nop,nop,sack 1 {940:984}], length 0 581s 16:09:19.119544 IP 10.136.6.184.52458 > autopkgtest.ssh: Flags [.], ack 1756, win 21318, options [nop,nop,TS val 1617061475 ecr 828938414,nop,nop,sack 1 {940:984}], length 0 581s 16:09:19.162939 IP internal-proxy-1.canonical.com.3128 > autopkgtest.42060: Flags [S.], seq 1302192591, ack 1950648368, win 62230, options [mss 8902,sackOK,TS val 2803375560 ecr 1468527775,nop,wscale 7], length 0 581s 16:09:19.162973 IP autopkgtest.42060 > internal-proxy-1.canonical.com.3128: Flags [.], ack 1, win 251, options [nop,nop,TS val 1468527865 ecr 2803375560], length 0 581s 16:09:19.189098 IP autopkgtest.42060 > internal-proxy-1.canonical.com.3128: Flags [P.], seq 1:129, ack 1, win 251, options [nop,nop,TS val 1468527891 ecr 2803375560], length 128 581s 16:09:19.261657 IP internal-proxy-1.canonical.com.3128 > autopkgtest.42060: Flags [.], ack 129, win 486, options [nop,nop,TS val 2803375675 ecr 1468527891], length 0 581s 16:09:19.440400 IP internal-proxy-1.canonical.com.3128 > autopkgtest.42060: Flags [P.], seq 1:531, ack 129, win 486, options [nop,nop,TS val 2803375854 ecr 1468527891], length 530 581s 16:09:19.440400 IP internal-proxy-1.canonical.com.3128 > autopkgtest.42060: Flags [P.], seq 531:802, ack 129, win 486, options [nop,nop,TS val 2803375854 ecr 1468527891], length 271 581s 16:09:19.440440 IP autopkgtest.42060 > internal-proxy-1.canonical.com.3128: Flags [.], ack 531, win 249, options [nop,nop,TS val 1468528143 ecr 2803375854], length 0 581s 16:09:19.440460 IP autopkgtest.42060 > internal-proxy-1.canonical.com.3128: Flags [.], ack 802, win 249, options [nop,nop,TS val 1468528143 ecr 2803375854], length 0 581s 16:09:19.447897 IP autopkgtest.42060 > internal-proxy-1.canonical.com.3128: Flags [F.], seq 129, ack 802, win 249, options [nop,nop,TS val 1468528150 ecr 2803375854], length 0 581s 16:09:19.448341 IP autopkgtest.ssh > 10.136.6.184.52458: Flags [P.], seq 1756:1960, ack 1, win 249, options [nop,nop,TS val 828939391 ecr 1617061475], length 204 581s 16:09:19.520463 IP internal-proxy-1.canonical.com.3128 > autopkgtest.42060: Flags [F.], seq 802, ack 130, win 486, options [nop,nop,TS val 2803375933 ecr 1468528150], length 0 581s 16:09:19.520491 IP autopkgtest.42060 > internal-proxy-1.canonical.com.3128: Flags [.], ack 803, win 249, options [nop,nop,TS val 1468528223 ecr 2803375933], length 0 581s 16:09:19.521429 IP 10.136.6.184.52458 > autopkgtest.ssh: Flags [.], ack 1960, win 21318, options [nop,nop,TS val 1617061876 ecr 828939391], length 0 581s 16:09:24.012216 ARP, Request who-has 10.145.243.89 tell _gateway, length 28 581s 16:09:25.907549 IP6 fe80::fc16:3eff:fe5a:cd72 > ip6-allrouters: ICMP6, router solicitation, length 16 581s 16:09:29.857712 ARP, Request who-has csb-recursive-nameserver1.canonical.com tell 10.145.243.201, length 28 581s 16:09:30.882838 ARP, Request who-has csb-recursive-nameserver1.canonical.com tell 10.145.243.201, length 28 581s 16:09:31.906645 ARP, Request who-has csb-recursive-nameserver1.canonical.com tell 10.145.243.201, length 28 581s 16:09:36.087032 ARP, Request who-has 10.145.243.58 tell _gateway, length 28 581s 16:09:37.985605 IP autopkgtest.37725 > prod-ntp-4.ntp1.ps5.canonical.com.ntp: NTPv4, Client, length 48 581s 16:09:38.338891 IP prod-ntp-4.ntp1.ps5.canonical.com.ntp > autopkgtest.37725: NTPv4, Server, length 48 581s 16:10:09.308438 IP autopkgtest.37413 > prod-ntp-4.ntp1.ps5.canonical.com.ntp: NTPv4, Client, length 48 581s 16:10:09.388175 IP prod-ntp-4.ntp1.ps5.canonical.com.ntp > autopkgtest.37413: NTPv4, Server, length 48 581s 16:10:14.485242 ARP, Request who-has _gateway tell autopkgtest, length 28 581s 16:10:15.509313 ARP, Request who-has _gateway tell autopkgtest, length 28 581s 16:10:16.199060 ARP, Reply _gateway is-at fa:16:3e:8a:f0:cc (oui Unknown), length 28 581s 16:10:16.199529 ARP, Reply _gateway is-at fa:16:3e:8a:f0:cc (oui Unknown), length 28 581s 16:10:55.806547 ARP, Request who-has 10.145.243.31 tell _gateway, length 28 581s 16:10:55.806747 ARP, Request who-has 10.145.243.31 tell _gateway, length 28 581s 16:10:55.921913 ARP, Request who-has 10.145.243.31 tell _gateway, length 28 581s 16:10:56.234204 ARP, Request who-has 10.145.243.31 tell _gateway, length 28 581s 16:10:56.343262 IP6 autopkgtest > ip6-allrouters: ICMP6, router solicitation, length 16 581s 16:10:56.844601 ARP, Request who-has 10.145.243.31 tell _gateway, length 28 581s 16:10:58.024955 ARP, Request who-has 10.145.243.31 tell _gateway, length 28 581s 16:11:00.585535 ARP, Request who-has 10.145.243.31 tell _gateway, length 28 581s 16:11:05.502064 ARP, Request who-has 10.145.243.31 tell _gateway, length 28 581s 16:11:13.556597 IP autopkgtest.60392 > prod-ntp-4.ntp1.ps5.canonical.com.ntp: NTPv4, Client, length 48 581s 16:11:15.782772 ARP, Request who-has 10.145.243.31 tell _gateway, length 28 581s 16:11:15.866317 IP prod-ntp-4.ntp1.ps5.canonical.com.ntp > autopkgtest.60392: NTPv4, Server, length 48 581s 16:11:18.997672 ARP, Request who-has _gateway tell autopkgtest, length 28 581s 16:11:19.226556 ARP, Reply _gateway is-at fa:16:3e:8a:f0:cc (oui Unknown), length 28 581s 16:11:21.051160 ARP, Request who-has 10.145.243.120 tell _gateway, length 28 581s 16:11:21.051298 ARP, Request who-has 10.145.243.120 tell _gateway, length 28 581s 16:11:21.234215 ARP, Request who-has 10.145.243.120 tell _gateway, length 28 581s 16:11:21.532125 ARP, Request who-has 10.145.243.120 tell _gateway, length 28 581s 16:11:22.152326 ARP, Request who-has 10.145.243.120 tell _gateway, length 28 581s 16:11:23.324550 ARP, Request who-has 10.145.243.120 tell _gateway, length 28 581s 16:11:25.728914 ARP, Request who-has 10.145.243.120 tell _gateway, length 28 581s 16:11:30.595223 ARP, Request who-has 10.145.243.120 tell _gateway, length 28 581s 16:11:35.405296 ARP, Request who-has 10.145.243.31 tell _gateway, length 28 581s 16:11:40.060593 ARP, Request who-has 10.145.243.120 tell _gateway, length 28 581s 16:11:40.660061 ARP, Request who-has 10.145.243.193 tell _gateway, length 28 581s 16:11:40.660294 ARP, Request who-has 10.145.243.193 tell _gateway, length 28 581s 16:11:40.847413 ARP, Request who-has 10.145.243.193 tell _gateway, length 28 581s 16:11:41.167429 ARP, Request who-has 10.145.243.193 tell _gateway, length 28 581s 16:11:41.781840 ARP, Request who-has 10.145.243.193 tell _gateway, length 28 581s 16:11:42.953644 ARP, Request who-has 10.145.243.193 tell _gateway, length 28 581s 16:11:45.396613 ARP, Request who-has 10.145.243.193 tell _gateway, length 28 581s 16:11:48.059045 IP autopkgtest.36859 > prod-ntp-4.ntp1.ps5.canonical.com.ntp: NTPv4, Client, length 48 581s 16:11:50.249785 ARP, Request who-has 10.145.243.193 tell _gateway, length 28 581s 16:11:52.831305 IP prod-ntp-4.ntp1.ps5.canonical.com.ntp > autopkgtest.36859: NTPv4, Server, length 48 581s 16:11:53.301717 ARP, Request who-has _gateway tell autopkgtest, length 28 581s 16:11:53.302552 ARP, Reply _gateway is-at fa:16:3e:8a:f0:cc (oui Unknown), length 28 582s autopkgtest [16:12:21]: test run-example: -----------------------] 582s run-example PASS 582s autopkgtest [16:12:21]: test run-example: - - - - - - - - - - results - - - - - - - - - - 583s autopkgtest [16:12:22]: @@@@@@@@@@@@@@@@@@@@ summary 583s run-example PASS 627s nova [W] Skipping flock in bos03-arm64 627s Creating nova instance adt-oracular-arm64-stenographer-20240813-160239-juju-7f2275-prod-proposed-migration-environment-2-2fc21ac2-bdc9-4861-98f9-ee44ae116217 from image adt/ubuntu-oracular-arm64-server-20240812.img (UUID ee584f3a-237c-469f-b9f4-8d1251cd9f9f)...