0s autopkgtest [07:38:49]: starting date and time: 2024-07-13 07:38:49+0000 0s autopkgtest [07:38:49]: git checkout: fd3bed09 nova: allow more retries for quota issues 0s autopkgtest [07:38:49]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.hdfaarin/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:glibc --apt-upgrade stenographer --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=glibc/2.39-3.1ubuntu3 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-arm64-55.secgroup --name adt-oracular-arm64-stenographer-20240713-073849-juju-7f2275-prod-proposed-migration-environment-2-f2964b4c-50eb-47fc-86c4-e7baf3bf6332 --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/ 195s autopkgtest [07:42:04]: testbed dpkg architecture: arm64 196s autopkgtest [07:42:05]: testbed apt version: 2.9.6 196s autopkgtest [07:42:05]: @@@@@@@@@@@@@@@@@@@@ test bed setup 197s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [126 kB] 198s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [2576 B] 199s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [8548 B] 199s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [375 kB] 199s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [51.3 kB] 199s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 Packages [112 kB] 199s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 c-n-f Metadata [2116 B] 199s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/restricted arm64 Packages [43.9 kB] 199s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/restricted arm64 c-n-f Metadata [364 B] 199s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/universe arm64 Packages [421 kB] 199s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/universe arm64 c-n-f Metadata [8752 B] 199s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse arm64 Packages [7596 B] 199s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse arm64 c-n-f Metadata [276 B] 206s Fetched 1159 kB in 3s (414 kB/s) 206s Reading package lists... 213s Reading package lists... 214s Building dependency tree... 214s Reading state information... 214s Calculating upgrade... 215s The following packages will be upgraded: 215s libc-bin libc-dev-bin libc-devtools libc6 libc6-dev locales 216s 6 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 216s Need to get 9208 kB of archives. 216s After this operation, 29.7 kB disk space will be freed. 216s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 libc-devtools arm64 2.39-3.1ubuntu3 [27.7 kB] 216s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 libc6-dev arm64 2.39-3.1ubuntu3 [1591 kB] 217s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 libc-dev-bin arm64 2.39-3.1ubuntu3 [19.7 kB] 217s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 libc6 arm64 2.39-3.1ubuntu3 [2770 kB] 217s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 libc-bin arm64 2.39-3.1ubuntu3 [579 kB] 217s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 locales all 2.39-3.1ubuntu3 [4220 kB] 222s Preconfiguring packages ... 223s Fetched 9208 kB in 1s (6186 kB/s) 224s (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 ... 78392 files and directories currently installed.) 224s Preparing to unpack .../libc-devtools_2.39-3.1ubuntu3_arm64.deb ... 224s Unpacking libc-devtools (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 225s Preparing to unpack .../libc6-dev_2.39-3.1ubuntu3_arm64.deb ... 225s Unpacking libc6-dev:arm64 (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 225s Preparing to unpack .../libc-dev-bin_2.39-3.1ubuntu3_arm64.deb ... 225s Unpacking libc-dev-bin (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 226s Preparing to unpack .../libc6_2.39-3.1ubuntu3_arm64.deb ... 227s Unpacking libc6:arm64 (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 228s Setting up libc6:arm64 (2.39-3.1ubuntu3) ... 229s Error: Could not restart systemd, systemd binary not working 230s (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 ... 78392 files and directories currently installed.) 230s Preparing to unpack .../libc-bin_2.39-3.1ubuntu3_arm64.deb ... 230s Unpacking libc-bin (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 230s Setting up libc-bin (2.39-3.1ubuntu3) ... 230s (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 ... 78392 files and directories currently installed.) 230s Preparing to unpack .../locales_2.39-3.1ubuntu3_all.deb ... 230s Unpacking locales (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 232s Setting up locales (2.39-3.1ubuntu3) ... 233s Generating locales (this might take a while)... 236s en_US.UTF-8... done 236s Generation complete. 237s Setting up libc-dev-bin (2.39-3.1ubuntu3) ... 237s Setting up libc-devtools (2.39-3.1ubuntu3) ... 237s Setting up libc6-dev:arm64 (2.39-3.1ubuntu3) ... 237s Processing triggers for man-db (2.12.1-2) ... 239s Processing triggers for systemd (256-1ubuntu1) ... 242s Reading package lists... 242s Building dependency tree... 242s Reading state information... 243s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 244s Hit:1 http://ftpmaster.internal/ubuntu oracular InRelease 244s Hit:2 http://ftpmaster.internal/ubuntu oracular-updates InRelease 244s Hit:3 http://ftpmaster.internal/ubuntu oracular-security InRelease 244s Hit:4 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 247s Reading package lists... 247s Reading package lists... 248s Building dependency tree... 248s Reading state information... 248s Calculating upgrade... 249s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 249s Reading package lists... 249s Building dependency tree... 249s Reading state information... 250s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 255s autopkgtest [07:43:04]: testbed running kernel: Linux 6.8.0-31-generic #31-Ubuntu SMP PREEMPT_DYNAMIC Sat Apr 20 02:32:42 UTC 2024 255s autopkgtest [07:43:04]: @@@@@@@@@@@@@@@@@@@@ apt-source stenographer 262s Get:1 http://ftpmaster.internal/ubuntu oracular/universe stenographer 1.0.1-4 (dsc) [2753 B] 262s Get:2 http://ftpmaster.internal/ubuntu oracular/universe stenographer 1.0.1-4 (tar) [149 kB] 262s Get:3 http://ftpmaster.internal/ubuntu oracular/universe stenographer 1.0.1-4 (diff) [14.1 kB] 263s gpgv: Signature made Sat May 4 00:20:45 2024 UTC 263s gpgv: using RSA key 5B34BA5AAB5507E903426E85E8D37AE2F09F4872 263s gpgv: Can't check signature: No public key 263s dpkg-source: warning: cannot verify inline signature for ./stenographer_1.0.1-4.dsc: no acceptable signature found 266s autopkgtest [07:43:15]: testing package stenographer version 1.0.1-4 266s autopkgtest [07:43:15]: build not needed 267s autopkgtest [07:43:16]: test run-example: preparing testbed 269s Reading package lists... 269s Building dependency tree... 269s Reading state information... 269s Starting pkgProblemResolver with broken count: 0 269s Starting 2 pkgProblemResolver with broken count: 0 269s Done 270s The following additional packages will be installed: 270s libleveldb1d libsnappy1v5 net-tools stenographer stenographer-client 270s stenographer-common 270s The following NEW packages will be installed: 270s autopkgtest-satdep libleveldb1d libsnappy1v5 net-tools stenographer 270s stenographer-client stenographer-common 270s 0 upgraded, 7 newly installed, 0 to remove and 0 not upgraded. 270s Need to get 3801 kB/3802 kB of archives. 270s After this operation, 12.7 MB of additional disk space will be used. 270s Get:1 /tmp/autopkgtest.fOFSSx/1-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [744 B] 271s Get:2 http://ftpmaster.internal/ubuntu oracular/main arm64 libsnappy1v5 arm64 1.2.1-1 [30.4 kB] 271s Get:3 http://ftpmaster.internal/ubuntu oracular/universe arm64 libleveldb1d arm64 1.23-5build1 [124 kB] 271s Get:4 http://ftpmaster.internal/ubuntu oracular/main arm64 net-tools arm64 2.10-1.1ubuntu1 [207 kB] 271s Get:5 http://ftpmaster.internal/ubuntu oracular/universe arm64 stenographer-common all 1.0.1-4 [20.5 kB] 271s Get:6 http://ftpmaster.internal/ubuntu oracular/universe arm64 stenographer arm64 1.0.1-4 [3414 kB] 271s Get:7 http://ftpmaster.internal/ubuntu oracular/universe arm64 stenographer-client all 1.0.1-4 [5290 B] 273s Fetched 3801 kB in 1s (3482 kB/s) 274s Selecting previously unselected package libsnappy1v5:arm64. 274s (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 ... 78392 files and directories currently installed.) 274s Preparing to unpack .../0-libsnappy1v5_1.2.1-1_arm64.deb ... 274s Unpacking libsnappy1v5:arm64 (1.2.1-1) ... 274s Selecting previously unselected package libleveldb1d:arm64. 275s Preparing to unpack .../1-libleveldb1d_1.23-5build1_arm64.deb ... 275s Unpacking libleveldb1d:arm64 (1.23-5build1) ... 275s Selecting previously unselected package net-tools. 275s Preparing to unpack .../2-net-tools_2.10-1.1ubuntu1_arm64.deb ... 275s Unpacking net-tools (2.10-1.1ubuntu1) ... 275s Selecting previously unselected package stenographer-common. 277s Preparing to unpack .../3-stenographer-common_1.0.1-4_all.deb ... 277s Unpacking stenographer-common (1.0.1-4) ... 277s Selecting previously unselected package stenographer. 278s Preparing to unpack .../4-stenographer_1.0.1-4_arm64.deb ... 279s Unpacking stenographer (1.0.1-4) ... 279s Selecting previously unselected package stenographer-client. 281s Preparing to unpack .../5-stenographer-client_1.0.1-4_all.deb ... 281s Unpacking stenographer-client (1.0.1-4) ... 282s Selecting previously unselected package autopkgtest-satdep. 283s Preparing to unpack .../6-1-autopkgtest-satdep.deb ... 283s Unpacking autopkgtest-satdep (0) ... 284s Setting up net-tools (2.10-1.1ubuntu1) ... 284s Setting up stenographer-common (1.0.1-4) ... 284s info: Selecting UID from range 100 to 999 ... 284s 286s info: Selecting GID from range 100 to 999 ... 286s info: Adding system user `stenographer' (UID 107) ... 286s info: Adding new group `stenographer' (GID 114) ... 287s info: Adding new user `stenographer' (UID 107) with group `stenographer' ... 287s info: Not creating home directory `/var/lib/stenographer'. 289s Generating CA state 298s Generating key/cert for 'client' 306s Generating key/cert for 'server' 309s Setting up stenographer-client (1.0.1-4) ... 309s Setting up libsnappy1v5:arm64 (1.2.1-1) ... 309s Setting up libleveldb1d:arm64 (1.23-5build1) ... 309s Setting up stenographer (1.0.1-4) ... 309s setcap on /usr/sbin/stenotype worked. 310s Setting up autopkgtest-satdep (0) ... 310s Processing triggers for man-db (2.12.1-2) ... 311s Processing triggers for libc-bin (2.39-3.1ubuntu3) ... 317s (Reading database ... 78476 files and directories currently installed.) 317s Removing autopkgtest-satdep (0) ... 318s autopkgtest [07:44:07]: test run-example: [----------------------- 319s Filesystem info: 319s Filesystem Type Size Used Avail Use% Mounted on 319s /dev/vda1 ext4 19G 2.2G 17G 12% / 319s Kernel IP routing table 319s Destination Gateway Genmask Flags Metric Ref Use Iface 319s 0.0.0.0 10.145.243.1 0.0.0.0 UG 100 0 0 enp1s0 319s 10.145.243.0 0.0.0.0 255.255.255.0 U 100 0 0 enp1s0 319s 10.145.243.1 0.0.0.0 255.255.255.255 UH 100 0 0 enp1s0 319s 10.145.243.2 0.0.0.0 255.255.255.255 UH 100 0 0 enp1s0 319s 91.189.91.131 10.145.243.1 255.255.255.255 UGH 100 0 0 enp1s0 319s 91.189.91.132 10.145.243.1 255.255.255.255 UGH 100 0 0 enp1s0 319s 169.254.169.254 10.145.243.2 255.255.255.255 UGH 100 0 0 enp1s0 319s Using interface enp1s0 339s ● stenographer.service - packet capture to disk 339s Loaded: loaded (/usr/lib/systemd/system/stenographer.service; disabled; preset: enabled) 339s Active: active (running) since Sat 2024-07-13 07:44:08 UTC; 20s ago 339s Invocation: 15204375e9024c5d9e2153d273aa97b4 339s Docs: https://github.com/google/stenographer 339s https://github.com/google/stenographer/blob/master/DESIGN.md 339s https://github.com/google/stenographer/blob/master/INSTALL.md 339s Main PID: 3242 (stenographer) 339s Tasks: 12 (limit: 4556) 339s Memory: 9.6M (peak: 9.9M) 339s CPU: 1.574s 339s CGroup: /system.slice/stenographer.service 339s ├─3242 /usr/sbin/stenographer 339s └─3248 /usr/sbin/stenotype --blocks=256 --seccomp=none --threads=1 --dir=/tmp/stenographer1988923457 --iface=enp1s0 339s 339s Jul 13 07:44:08 autopkgtest systemd[1]: Started stenographer.service - packet capture to disk. 339s active 340s % Total % Received % Xferd Average Speed Time Time Time Current 340s Dload Upload Total Spent Left Speed 340s 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 100 271 100 271 0 0 516 0 --:--:-- --:--:-- --:--:-- 532 520s ● stenographer.service - packet capture to disk 520s Loaded: loaded (/usr/lib/systemd/system/stenographer.service; disabled; preset: enabled) 520s Active: active (running) since Sat 2024-07-13 07:44:08 UTC; 3min 21s ago 520s Invocation: 15204375e9024c5d9e2153d273aa97b4 520s Docs: https://github.com/google/stenographer 520s https://github.com/google/stenographer/blob/master/DESIGN.md 520s https://github.com/google/stenographer/blob/master/INSTALL.md 520s Main PID: 3242 (stenographer) 520s Tasks: 12 (limit: 4556) 520s Memory: 9.7M (peak: 10.1M) 520s CPU: 1.695s 520s CGroup: /system.slice/stenographer.service 520s ├─3242 /usr/sbin/stenographer 520s └─3248 /usr/sbin/stenotype --blocks=256 --seccomp=none --threads=1 --dir=/tmp/stenographer1988923457 --iface=enp1s0 520s 520s Jul 13 07:44:08 autopkgtest systemd[1]: Started stenographer.service - packet capture to disk. 520s tcp 0 0 127.0.0.1:1234 0.0.0.0:* LISTEN 3242/stenographer 520s Running stenographer query 'after 5m ago', piping to 'tcpdump ' 521s reading from file /dev/stdin, link-type EN10MB (Ethernet), snapshot length 65536 521s 07:44:12.441657 ARP, Request who-has 10.145.243.204 tell _gateway, length 28 521s 07:44:18.144995 ARP, Request who-has 10.145.243.211 tell _gateway, length 28 521s 07:44:18.145020 ARP, Request who-has 10.145.243.211 tell _gateway, length 28 521s 07:44:18.310161 ARP, Request who-has 10.145.243.211 tell _gateway, length 28 521s 07:44:18.601971 ARP, Request who-has 10.145.243.211 tell _gateway, length 28 521s 07:44:19.181917 ARP, Request who-has 10.145.243.211 tell _gateway, length 28 521s 07:44:20.334038 ARP, Request who-has 10.145.243.211 tell _gateway, length 28 521s 07:44:22.633613 ARP, Request who-has 10.145.243.211 tell _gateway, length 28 521s 07:44:23.545929 IP6 fe80::fc16:3eff:fe96:b412 > ip6-allrouters: ICMP6, router solicitation, length 16 521s 07:44:27.241685 ARP, Request who-has 10.145.243.211 tell _gateway, length 28 521s 07:44:28.476603 IP autopkgtest.ssh > 10.136.6.184.42228: Flags [P.], seq 1316921444:1316922384, ack 2173014211, win 249, options [nop,nop,TS val 3278346688 ecr 1093985618], length 940 521s 07:44:28.477611 IP autopkgtest.ssh > 10.136.6.184.42228: Flags [P.], seq 940:984, ack 1, win 249, options [nop,nop,TS val 3278346689 ecr 1093985618], length 44 521s 07:44:28.542525 IP 10.136.6.184.42228 > autopkgtest.ssh: Flags [.], ack 940, win 24561, options [nop,nop,TS val 1094005941 ecr 3278346688], length 0 521s 07:44:28.542946 IP 10.136.6.184.42228 > autopkgtest.ssh: Flags [.], ack 984, win 24561, options [nop,nop,TS val 1094005941 ecr 3278346689], length 0 521s 07:44:29.092973 IP autopkgtest.ssh > 10.136.6.184.42228: Flags [P.], seq 984:1260, ack 1, win 249, options [nop,nop,TS val 3278347305 ecr 1094005941], length 276 521s 07:44:29.158676 IP 10.136.6.184.42228 > autopkgtest.ssh: Flags [.], ack 1260, win 24561, options [nop,nop,TS val 1094006557 ecr 3278347305], length 0 521s 07:44:29.199156 IP autopkgtest.42588 > csb-recursive-nameserver1.canonical.com.domain: 48271+ [1au] A? squid.internal. (43) 521s 07:44:29.203716 IP csb-recursive-nameserver1.canonical.com.domain > autopkgtest.42588: 48271 2/0/1 A 185.125.188.86, A 185.125.188.85 (75) 521s 07:44:29.232203 IP autopkgtest.56484 > csb-recursive-nameserver1.canonical.com.domain: 55616+ [1au] AAAA? squid.internal. (43) 521s 07:44:29.232968 IP csb-recursive-nameserver1.canonical.com.domain > autopkgtest.56484: 55616 0/1/1 (116) 521s 07:44:29.264093 IP autopkgtest.42100 > internal-proxy-1.canonical.com.3128: Flags [S], seq 524190421, win 32120, options [mss 1460,sackOK,TS val 1581044157 ecr 0,nop,wscale 7], length 0 521s 07:44:29.336594 IP internal-proxy-1.canonical.com.3128 > autopkgtest.42100: Flags [S.], seq 3694001849, ack 524190422, win 62230, options [mss 8902,sackOK,TS val 2489952043 ecr 1581044157,nop,wscale 7], length 0 521s 07:44:29.336621 IP autopkgtest.42100 > internal-proxy-1.canonical.com.3128: Flags [.], ack 1, win 251, options [nop,nop,TS val 1581044229 ecr 2489952043], length 0 521s 07:44:29.336689 IP autopkgtest.42100 > internal-proxy-1.canonical.com.3128: Flags [P.], seq 1:129, ack 1, win 251, options [nop,nop,TS val 1581044229 ecr 2489952043], length 128 521s 07:44:29.403743 IP internal-proxy-1.canonical.com.3128 > autopkgtest.42100: Flags [.], ack 129, win 486, options [nop,nop,TS val 2489952116 ecr 1581044229], length 0 521s 07:44:29.553496 IP internal-proxy-1.canonical.com.3128 > autopkgtest.42100: Flags [P.], seq 1:531, ack 129, win 486, options [nop,nop,TS val 2489952266 ecr 1581044229], length 530 521s 07:44:29.553496 IP internal-proxy-1.canonical.com.3128 > autopkgtest.42100: Flags [P.], seq 531:802, ack 129, win 486, options [nop,nop,TS val 2489952266 ecr 1581044229], length 271 521s 07:44:29.553520 IP autopkgtest.42100 > internal-proxy-1.canonical.com.3128: Flags [.], ack 531, win 249, options [nop,nop,TS val 1581044446 ecr 2489952266], length 0 521s 07:44:29.553538 IP autopkgtest.42100 > internal-proxy-1.canonical.com.3128: Flags [.], ack 802, win 249, options [nop,nop,TS val 1581044446 ecr 2489952266], length 0 521s 07:44:29.581940 IP autopkgtest.42100 > internal-proxy-1.canonical.com.3128: Flags [F.], seq 129, ack 802, win 249, options [nop,nop,TS val 1581044475 ecr 2489952266], length 0 521s 07:44:29.582129 IP autopkgtest.ssh > 10.136.6.184.42228: Flags [P.], seq 1260:1384, ack 1, win 249, options [nop,nop,TS val 3278347794 ecr 1094006557], length 124 521s 07:44:29.647561 IP 10.136.6.184.42228 > autopkgtest.ssh: Flags [.], ack 1384, win 24561, options [nop,nop,TS val 1094007046 ecr 3278347794], length 0 521s 07:44:29.647585 IP internal-proxy-1.canonical.com.3128 > autopkgtest.42100: Flags [F.], seq 802, ack 130, win 486, options [nop,nop,TS val 2489952360 ecr 1581044475], length 0 521s 07:44:29.647601 IP autopkgtest.42100 > internal-proxy-1.canonical.com.3128: Flags [.], ack 803, win 249, options [nop,nop,TS val 1581044540 ecr 2489952360], length 0 521s 07:44:31.897445 ARP, Request who-has 10.145.243.204 tell _gateway, length 28 521s 07:44:36.457773 ARP, Request who-has 10.145.243.211 tell _gateway, length 28 521s 07:44:39.545141 ARP, Request who-has 10.145.243.155 tell _gateway, length 28 521s 07:44:39.545209 ARP, Request who-has 10.145.243.155 tell _gateway, length 28 521s 07:44:39.545535 ARP, Request who-has 10.145.243.155 tell _gateway, length 28 521s 07:44:39.709822 ARP, Request who-has 10.145.243.155 tell _gateway, length 28 521s 07:44:40.025662 ARP, Request who-has 10.145.243.155 tell _gateway, length 28 521s 07:44:40.573819 ARP, Request who-has 10.145.243.155 tell _gateway, length 28 521s 07:44:40.605446 ARP, Request who-has 10.145.243.155 tell _gateway, length 28 521s 07:44:41.753778 ARP, Request who-has 10.145.243.155 tell _gateway, length 28 521s 07:44:42.586064 ARP, Request who-has 10.145.243.155 tell _gateway, length 28 521s 07:44:44.198030 ARP, Request who-has 10.145.243.155 tell _gateway, length 28 521s 07:44:46.454522 ARP, Request who-has 10.145.243.193 tell _gateway, length 28 521s 07:44:46.454588 ARP, Request who-has 10.145.243.193 tell _gateway, length 28 521s 07:44:46.613164 ARP, Request who-has 10.145.243.193 tell _gateway, length 28 521s 07:44:46.745811 ARP, Request who-has 10.145.243.155 tell _gateway, length 28 521s 07:44:46.905197 ARP, Request who-has 10.145.243.193 tell _gateway, length 28 521s 07:44:47.481889 ARP, Request who-has 10.145.243.193 tell _gateway, length 28 521s 07:44:48.633819 ARP, Request who-has 10.145.243.193 tell _gateway, length 28 521s 07:44:48.797579 ARP, Request who-has 10.145.243.155 tell _gateway, length 28 521s 07:44:49.164915 ARP, Request who-has 10.145.243.206 tell _gateway, length 28 521s 07:44:49.164969 ARP, Request who-has 10.145.243.206 tell _gateway, length 28 521s 07:44:49.329567 ARP, Request who-has 10.145.243.206 tell _gateway, length 28 521s 07:44:49.641472 ARP, Request who-has 10.145.243.206 tell _gateway, length 28 521s 07:44:50.217540 ARP, Request who-has 10.145.243.206 tell _gateway, length 28 521s 07:44:50.976904 IP6 autopkgtest > ip6-allrouters: ICMP6, router solicitation, length 16 521s 07:44:51.097414 ARP, Request who-has 10.145.243.193 tell _gateway, length 28 521s 07:44:51.375019 ARP, Request who-has 10.145.243.206 tell _gateway, length 28 521s 07:44:53.865584 ARP, Request who-has 10.145.243.206 tell _gateway, length 28 521s 07:44:55.705587 ARP, Request who-has 10.145.243.193 tell _gateway, length 28 521s 07:44:55.920559 ARP, Request who-has 10.145.243.211 tell _gateway, length 28 521s 07:44:58.009372 ARP, Request who-has 10.145.243.155 tell _gateway, length 28 521s 07:44:58.473990 ARP, Request who-has 10.145.243.206 tell _gateway, length 28 521s 07:45:04.921505 ARP, Request who-has 10.145.243.193 tell _gateway, length 28 521s 07:45:07.694235 ARP, Request who-has 10.145.243.206 tell _gateway, length 28 521s 07:45:16.956679 ARP, Request who-has 10.145.243.155 tell _gateway, length 28 521s 07:45:17.130562 IP autopkgtest.36794 > prod-ntp-4.ntp1.ps5.canonical.com.ntp: NTPv4, Client, length 48 521s 07:45:17.203274 IP prod-ntp-4.ntp1.ps5.canonical.com.ntp > autopkgtest.36794: NTPv4, Server, length 48 521s 07:45:22.515014 ARP, Request who-has _gateway tell autopkgtest, length 28 521s 07:45:22.519754 ARP, Reply _gateway is-at fa:16:3e:8a:f0:cc (oui Unknown), length 28 521s 07:45:23.097393 ARP, Request who-has 10.145.243.193 tell _gateway, length 28 521s 07:45:26.633521 ARP, Request who-has 10.145.243.206 tell _gateway, length 28 521s 07:45:50.053405 ARP, Request who-has 10.145.243.117 tell _gateway, length 28 521s 07:45:50.053406 ARP, Request who-has 10.145.243.117 tell _gateway, length 28 522s 07:45:50.208422 ARP, Request who-has 10.145.243.117 tell _gateway, length 28 522s 07:45:50.520478 ARP, Request who-has 10.145.243.117 tell _gateway, length 28 522s 07:45:51.097083 ARP, Request who-has 10.145.243.117 tell _gateway, length 28 522s 07:45:52.248405 ARP, Request who-has 10.145.243.117 tell _gateway, length 28 522s 07:45:54.588156 ARP, Request who-has 10.145.243.117 tell _gateway, length 28 522s 07:45:58.470869 ARP, Request who-has 10.145.243.226 tell _gateway, length 28 522s 07:45:58.470914 ARP, Request who-has 10.145.243.226 tell _gateway, length 28 522s 07:45:58.627933 ARP, Request who-has 10.145.243.226 tell _gateway, length 28 522s 07:45:58.936384 ARP, Request who-has 10.145.243.226 tell _gateway, length 28 522s 07:45:59.193055 ARP, Request who-has 10.145.243.117 tell _gateway, length 28 522s 07:45:59.434311 ARP, Request who-has 10.145.243.73 tell _gateway, length 28 522s 07:45:59.434454 ARP, Request who-has 10.145.243.73 tell _gateway, length 28 522s 07:45:59.512892 ARP, Request who-has 10.145.243.226 tell _gateway, length 28 522s 07:45:59.600792 ARP, Request who-has 10.145.243.73 tell _gateway, length 28 522s 07:45:59.912944 ARP, Request who-has 10.145.243.73 tell _gateway, length 28 522s 07:46:00.488797 ARP, Request who-has 10.145.243.73 tell _gateway, length 28 522s 07:46:00.679056 ARP, Request who-has 10.145.243.226 tell _gateway, length 28 522s 07:46:01.640650 ARP, Request who-has 10.145.243.73 tell _gateway, length 28 522s 07:46:03.037284 ARP, Request who-has 10.145.243.226 tell _gateway, length 28 522s 07:46:04.011177 ARP, Request who-has 10.145.243.73 tell _gateway, length 28 522s 07:46:07.643516 ARP, Request who-has 10.145.243.226 tell _gateway, length 28 522s 07:46:08.408698 ARP, Request who-has 10.145.243.117 tell _gateway, length 28 522s 07:46:08.616393 ARP, Request who-has 10.145.243.73 tell _gateway, length 28 522s 07:46:13.773105 ARP, Request who-has csb-recursive-nameserver1.canonical.com tell 10.145.243.64, length 28 522s 07:46:14.775829 ARP, Request who-has csb-recursive-nameserver1.canonical.com tell 10.145.243.64, length 28 522s 07:46:15.799785 ARP, Request who-has csb-recursive-nameserver1.canonical.com tell 10.145.243.64, length 28 522s 07:46:16.855767 ARP, Request who-has 10.145.243.226 tell _gateway, length 28 522s 07:46:17.832489 ARP, Request who-has 10.145.243.73 tell _gateway, length 28 522s 07:46:26.584284 ARP, Request who-has 10.145.243.117 tell _gateway, length 28 522s 07:46:35.791194 ARP, Request who-has 10.145.243.120 tell _gateway, length 28 522s 07:46:35.791236 ARP, Request who-has 10.145.243.120 tell _gateway, length 28 522s 07:46:35.951524 ARP, Request who-has 10.145.243.120 tell _gateway, length 28 522s 07:46:36.247453 ARP, Request who-has 10.145.243.120 tell _gateway, length 28 522s 07:46:36.263924 ARP, Request who-has 10.145.243.73 tell _gateway, length 28 522s 07:46:36.824194 ARP, Request who-has 10.145.243.120 tell _gateway, length 28 522s 07:46:36.827589 ARP, Request who-has 10.145.243.226 tell _gateway, length 28 522s 07:46:37.978563 ARP, Request who-has 10.145.243.120 tell _gateway, length 28 522s 07:46:40.407508 ARP, Request who-has 10.145.243.120 tell _gateway, length 28 522s 07:46:45.022712 ARP, Request who-has 10.145.243.120 tell _gateway, length 28 522s 07:46:54.231378 ARP, Request who-has 10.145.243.120 tell _gateway, length 28 522s 07:47:00.440208 IP6 autopkgtest > ip6-allrouters: ICMP6, router solicitation, length 16 522s autopkgtest [07:47:31]: test run-example: -----------------------] 523s autopkgtest [07:47:31]: test run-example: - - - - - - - - - - results - - - - - - - - - - 523s run-example PASS 523s autopkgtest [07:47:32]: @@@@@@@@@@@@@@@@@@@@ summary 523s run-example PASS 577s nova [W] Skipping flock in bos03-arm64 577s Creating nova instance adt-oracular-arm64-stenographer-20240713-073849-juju-7f2275-prod-proposed-migration-environment-2-f2964b4c-50eb-47fc-86c4-e7baf3bf6332 from image adt/ubuntu-oracular-arm64-server-20240713.img (UUID 3c579e1a-9694-4cfa-8fb2-317ade717652)...