0s autopkgtest [19:28:32]: starting date and time: 2024-11-15 19:28:32+0000 0s autopkgtest [19:28:32]: git checkout: 6f3be7a8 Fix armhf LXD image generation for plucky 0s autopkgtest [19:28:32]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.jmnhaom8/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.3-2ubuntu3~22.04.1' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@bos03-arm64-24.secgroup --name adt-jammy-arm64-stenographer-20241115-192832-juju-7f2275-prod-proposed-migration-environment-15-559908c2-c5da-4972-8267-fad28bf4b2ea --image adt/ubuntu-jammy-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'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 74s autopkgtest [19:29:46]: testbed dpkg architecture: arm64 74s autopkgtest [19:29:46]: testbed apt version: 2.4.13 74s autopkgtest [19:29:46]: @@@@@@@@@@@@@@@@@@@@ test bed setup 75s Get:1 http://ftpmaster.internal/ubuntu jammy-proposed InRelease [279 kB] 75s Get:2 http://ftpmaster.internal/ubuntu jammy-proposed/main Sources [34.4 kB] 75s Get:3 http://ftpmaster.internal/ubuntu jammy-proposed/restricted Sources [4732 B] 75s Get:4 http://ftpmaster.internal/ubuntu jammy-proposed/universe Sources [22.0 kB] 75s Get:5 http://ftpmaster.internal/ubuntu jammy-proposed/main arm64 Packages [220 kB] 75s Get:6 http://ftpmaster.internal/ubuntu jammy-proposed/main arm64 c-n-f Metadata [1748 B] 75s Get:7 http://ftpmaster.internal/ubuntu jammy-proposed/restricted arm64 Packages [296 kB] 75s Get:8 http://ftpmaster.internal/ubuntu jammy-proposed/restricted arm64 c-n-f Metadata [412 B] 75s Get:9 http://ftpmaster.internal/ubuntu jammy-proposed/universe arm64 Packages [72.2 kB] 75s Get:10 http://ftpmaster.internal/ubuntu jammy-proposed/universe arm64 c-n-f Metadata [1308 B] 75s Get:11 http://ftpmaster.internal/ubuntu jammy-proposed/multiverse arm64 c-n-f Metadata [208 B] 79s Fetched 933 kB in 1s (1239 kB/s) 79s Reading package lists... 81s Reading package lists... 82s Building dependency tree... 82s Reading state information... 82s Calculating upgrade... 82s The following packages will be upgraded: 82s libseccomp2 83s 1 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 83s Need to get 47.9 kB of archives. 83s After this operation, 4096 B of additional disk space will be used. 83s Get:1 http://ftpmaster.internal/ubuntu jammy-proposed/main arm64 libseccomp2 arm64 2.5.3-2ubuntu3~22.04.1 [47.9 kB] 83s Fetched 47.9 kB in 0s (169 kB/s) 83s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 102243 files and directories currently installed.) 83s Preparing to unpack .../libseccomp2_2.5.3-2ubuntu3~22.04.1_arm64.deb ... 83s Unpacking libseccomp2:arm64 (2.5.3-2ubuntu3~22.04.1) over (2.5.3-2ubuntu2) ... 83s Setting up libseccomp2:arm64 (2.5.3-2ubuntu3~22.04.1) ... 83s Processing triggers for libc-bin (2.35-0ubuntu3.8) ... 84s Reading package lists... 84s Building dependency tree... 84s Reading state information... 84s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 85s Hit:1 http://ftpmaster.internal/ubuntu jammy InRelease 85s Hit:2 http://ftpmaster.internal/ubuntu jammy-updates InRelease 85s Hit:3 http://ftpmaster.internal/ubuntu jammy-security InRelease 85s Hit:4 http://ftpmaster.internal/ubuntu jammy-proposed InRelease 86s Reading package lists... 86s Reading package lists... 87s Building dependency tree... 87s Reading state information... 87s Calculating upgrade... 87s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 87s Reading package lists... 88s Building dependency tree... 88s Reading state information... 88s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 91s autopkgtest [19:30:03]: testbed running kernel: Linux 5.15.0-125-generic #135-Ubuntu SMP Fri Sep 27 13:56:10 UTC 2024 93s autopkgtest [19:30:05]: @@@@@@@@@@@@@@@@@@@@ apt-source stenographer 97s Get:1 http://ftpmaster.internal/ubuntu jammy-updates/universe stenographer 1.0.1-2ubuntu0.22.04.2 (dsc) [2746 B] 97s Get:2 http://ftpmaster.internal/ubuntu jammy-updates/universe stenographer 1.0.1-2ubuntu0.22.04.2 (tar) [149 kB] 97s Get:3 http://ftpmaster.internal/ubuntu jammy-updates/universe stenographer 1.0.1-2ubuntu0.22.04.2 (diff) [14.4 kB] 97s gpgv: Signature made Wed May 3 08:39:13 2023 UTC 97s gpgv: using RSA key B35EBCD35C6717BC0ADEB08AEC873ACED468723C 97s gpgv: issuer "nishit.majithia@canonical.com" 97s gpgv: Can't check signature: No public key 97s dpkg-source: warning: cannot verify signature ./stenographer_1.0.1-2ubuntu0.22.04.2.dsc 98s autopkgtest [19:30:10]: testing package stenographer version 1.0.1-2ubuntu0.22.04.2 98s autopkgtest [19:30:10]: build not needed 99s autopkgtest [19:30:11]: test run-example: preparing testbed 102s Reading package lists... 102s Building dependency tree... 102s Reading state information... 102s Starting pkgProblemResolver with broken count: 0 103s Starting 2 pkgProblemResolver with broken count: 0 103s Done 103s The following additional packages will be installed: 103s jq libjq1 libleveldb1d libonig5 libsnappy1v5 net-tools stenographer 103s stenographer-client stenographer-common 103s The following NEW packages will be installed: 103s autopkgtest-satdep jq libjq1 libleveldb1d libonig5 libsnappy1v5 net-tools 103s stenographer stenographer-client stenographer-common 103s 0 upgraded, 10 newly installed, 0 to remove and 0 not upgraded. 103s Need to get 3906 kB/3907 kB of archives. 103s After this operation, 12.3 MB of additional disk space will be used. 103s Get:1 /tmp/autopkgtest.TGIexs/1-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [748 B] 104s Get:2 http://ftpmaster.internal/ubuntu jammy/main arm64 libonig5 arm64 6.9.7.1-2build1 [169 kB] 104s Get:3 http://ftpmaster.internal/ubuntu jammy/main arm64 libjq1 arm64 1.6-2.1ubuntu3 [125 kB] 104s Get:4 http://ftpmaster.internal/ubuntu jammy/main arm64 jq arm64 1.6-2.1ubuntu3 [52.1 kB] 104s Get:5 http://ftpmaster.internal/ubuntu jammy/main arm64 libsnappy1v5 arm64 1.1.8-1build3 [17.2 kB] 104s Get:6 http://ftpmaster.internal/ubuntu jammy/universe arm64 libleveldb1d arm64 1.23-3build1 [123 kB] 104s Get:7 http://ftpmaster.internal/ubuntu jammy/main arm64 net-tools arm64 1.60+git20181103.0eebece-1ubuntu5 [207 kB] 104s Get:8 http://ftpmaster.internal/ubuntu jammy-updates/universe arm64 stenographer-common all 1.0.1-2ubuntu0.22.04.2 [20.8 kB] 104s Get:9 http://ftpmaster.internal/ubuntu jammy-updates/universe arm64 stenographer arm64 1.0.1-2ubuntu0.22.04.2 [3186 kB] 104s Get:10 http://ftpmaster.internal/ubuntu jammy-updates/universe arm64 stenographer-client all 1.0.1-2ubuntu0.22.04.2 [5292 B] 105s Fetched 3906 kB in 1s (5428 kB/s) 105s Selecting previously unselected package libonig5:arm64. 105s (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 ... 102243 files and directories currently installed.) 105s Preparing to unpack .../0-libonig5_6.9.7.1-2build1_arm64.deb ... 105s Unpacking libonig5:arm64 (6.9.7.1-2build1) ... 105s Selecting previously unselected package libjq1:arm64. 105s Preparing to unpack .../1-libjq1_1.6-2.1ubuntu3_arm64.deb ... 105s Unpacking libjq1:arm64 (1.6-2.1ubuntu3) ... 105s Selecting previously unselected package jq. 105s Preparing to unpack .../2-jq_1.6-2.1ubuntu3_arm64.deb ... 105s Unpacking jq (1.6-2.1ubuntu3) ... 105s Selecting previously unselected package libsnappy1v5:arm64. 105s Preparing to unpack .../3-libsnappy1v5_1.1.8-1build3_arm64.deb ... 105s Unpacking libsnappy1v5:arm64 (1.1.8-1build3) ... 105s Selecting previously unselected package libleveldb1d:arm64. 105s Preparing to unpack .../4-libleveldb1d_1.23-3build1_arm64.deb ... 105s Unpacking libleveldb1d:arm64 (1.23-3build1) ... 105s Selecting previously unselected package net-tools. 105s Preparing to unpack .../5-net-tools_1.60+git20181103.0eebece-1ubuntu5_arm64.deb ... 105s Unpacking net-tools (1.60+git20181103.0eebece-1ubuntu5) ... 105s Selecting previously unselected package stenographer-common. 105s Preparing to unpack .../6-stenographer-common_1.0.1-2ubuntu0.22.04.2_all.deb ... 105s Unpacking stenographer-common (1.0.1-2ubuntu0.22.04.2) ... 105s Selecting previously unselected package stenographer. 105s Preparing to unpack .../7-stenographer_1.0.1-2ubuntu0.22.04.2_arm64.deb ... 105s Unpacking stenographer (1.0.1-2ubuntu0.22.04.2) ... 105s Selecting previously unselected package stenographer-client. 105s Preparing to unpack .../8-stenographer-client_1.0.1-2ubuntu0.22.04.2_all.deb ... 105s Unpacking stenographer-client (1.0.1-2ubuntu0.22.04.2) ... 105s Selecting previously unselected package autopkgtest-satdep. 105s Preparing to unpack .../9-1-autopkgtest-satdep.deb ... 105s Unpacking autopkgtest-satdep (0) ... 105s Setting up net-tools (1.60+git20181103.0eebece-1ubuntu5) ... 105s Setting up libsnappy1v5:arm64 (1.1.8-1build3) ... 105s Setting up libonig5:arm64 (6.9.7.1-2build1) ... 105s Setting up libleveldb1d:arm64 (1.23-3build1) ... 105s Setting up libjq1:arm64 (1.6-2.1ubuntu3) ... 105s Setting up jq (1.6-2.1ubuntu3) ... 105s Setting up stenographer-common (1.0.1-2ubuntu0.22.04.2) ... 105s Adding system user `stenographer' (UID 111) ... 105s Adding new group `stenographer' (GID 116) ... 105s Adding new user `stenographer' (UID 111) with group `stenographer' ... 105s ERROR: ld.so: object 'libeatmydata.so' from LD_PRELOAD cannot be preloaded (cannot open shared object file): ignored. 105s Not creating home directory `/var/lib/stenographer'. 105s Generating CA state 110s Generating key/cert for 'client' 115s Generating key/cert for 'server' 119s Setting up stenographer-client (1.0.1-2ubuntu0.22.04.2) ... 119s Setting up stenographer (1.0.1-2ubuntu0.22.04.2) ... 119s setcap on /usr/sbin/stenotype worked. 119s Setting up autopkgtest-satdep (0) ... 119s Processing triggers for man-db (2.10.2-1) ... 120s Processing triggers for libc-bin (2.35-0ubuntu3.8) ... 123s (Reading database ... 102345 files and directories currently installed.) 123s Removing autopkgtest-satdep (0) ... 123s autopkgtest [19:30:35]: test run-example: [----------------------- 124s Using interface enp1s0 124s ● stenographer.service - packet capture to disk 124s Loaded: loaded (/lib/systemd/system/stenographer.service; disabled; vendor preset: enabled) 124s Active: active (running) since Fri 2024-11-15 19:30:36 UTC; 17ms ago 124s Docs: https://github.com/google/stenographer 124s https://github.com/google/stenographer/blob/master/DESIGN.md 124s https://github.com/google/stenographer/blob/master/INSTALL.md 124s Main PID: 2487 (stenographer) 124s Tasks: 2 (limit: 4567) 124s Memory: 720.0K 124s CPU: 9ms 124s CGroup: /system.slice/stenographer.service 124s └─2487 /usr/sbin/stenographer 124s 124s Nov 15 19:30:36 autopkgtest systemd[1]: Started packet capture to disk. 124s active 124s % Total % Received % Xferd Average Speed Time Time Time Current 124s Dload Upload Total Spent Left Speed 124s 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 100 271 100 271 0 0 602 0 --:--:-- --:--:-- --:--:-- 603 304s ● stenographer.service - packet capture to disk 304s Loaded: loaded (/lib/systemd/system/stenographer.service; disabled; vendor preset: enabled) 304s Active: active (running) since Fri 2024-11-15 19:30:36 UTC; 3min 0s ago 304s Docs: https://github.com/google/stenographer 304s https://github.com/google/stenographer/blob/master/DESIGN.md 304s https://github.com/google/stenographer/blob/master/INSTALL.md 304s Main PID: 2487 (stenographer) 304s Tasks: 13 (limit: 4567) 304s Memory: 9.8M 304s CPU: 98ms 304s CGroup: /system.slice/stenographer.service 304s ├─2487 /usr/sbin/stenographer 304s └─2498 /usr/sbin/stenotype --blocks=256 --seccomp=none --threads=1 --dir=/tmp/stenographer509428664 --iface=enp1s0 304s 304s Nov 15 19:30:36 autopkgtest systemd[1]: Started packet capture to disk. 304s tcp 0 0 127.0.0.1:1234 0.0.0.0:* LISTEN 2487/stenographer 304s Running stenographer query 'after 5m ago', piping to 'tcpdump ' 304s reading from file /dev/stdin, link-type EN10MB (Ethernet), snapshot length 65536 305s 19:30:36.272462 IP 10.136.6.18.38188 > autopkgtest.ssh: Flags [.], ack 1039581205, win 24562, options [nop,nop,TS val 3528055583 ecr 1220242275], length 0 305s 19:30:36.272494 IP autopkgtest.ssh > 10.136.6.18.38188: Flags [P.], seq 6421:9169, ack 0, win 501, options [nop,nop,TS val 1220242359 ecr 3528055583], length 2748 305s 19:30:36.272528 IP autopkgtest.ssh > 10.136.6.18.38188: Flags [P.], seq 9169:10385, ack 0, win 501, options [nop,nop,TS val 1220242359 ecr 3528055583], length 1216 305s 19:30:36.272953 IP 10.136.6.18.38188 > autopkgtest.ssh: Flags [.], ack 89, win 24562, options [nop,nop,TS val 3528055583 ecr 1220242295], length 0 305s 19:30:36.273807 IP 10.136.6.18.38188 > autopkgtest.ssh: Flags [.], ack 177, win 24562, options [nop,nop,TS val 3528055584 ecr 1220242295], length 0 305s 19:30:36.273893 IP 10.136.6.18.38188 > autopkgtest.ssh: Flags [.], ack 353, win 24562, options [nop,nop,TS val 3528055584 ecr 1220242295], length 0 305s 19:30:36.274179 IP 10.136.6.18.38188 > autopkgtest.ssh: Flags [.], ack 441, win 24562, options [nop,nop,TS val 3528055584 ecr 1220242295], length 0 305s 19:30:36.274350 IP 10.136.6.18.38188 > autopkgtest.ssh: Flags [.], ack 617, win 24562, options [nop,nop,TS val 3528055584 ecr 1220242295], length 0 305s 19:30:36.274350 IP 10.136.6.18.38188 > autopkgtest.ssh: Flags [.], ack 705, win 24562, options [nop,nop,TS val 3528055584 ecr 1220242295], length 0 305s 19:30:36.274350 IP 10.136.6.18.38188 > autopkgtest.ssh: Flags [.], ack 837, win 24562, options [nop,nop,TS val 3528055584 ecr 1220242295], length 0 305s 19:30:36.274350 IP 10.136.6.18.38188 > autopkgtest.ssh: Flags [.], ack 925, win 24562, options [nop,nop,TS val 3528055584 ecr 1220242295], length 0 305s 19:30:36.300710 IP internal-proxy-0.canonical.com.3128 > autopkgtest.58814: Flags [S.], seq 540352134, ack 642230081, win 62230, options [mss 8902,sackOK,TS val 1120780568 ecr 2972870600,nop,wscale 7], length 0 305s 19:30:36.300742 IP autopkgtest.58814 > internal-proxy-0.canonical.com.3128: Flags [.], ack 1, win 502, options [nop,nop,TS val 2972870685 ecr 1120780568], length 0 305s 19:30:36.300825 IP autopkgtest.58814 > internal-proxy-0.canonical.com.3128: Flags [P.], seq 1:130, ack 1, win 502, options [nop,nop,TS val 2972870685 ecr 1120780568], length 129 305s 19:30:36.314844 IP 10.136.6.18.38188 > autopkgtest.ssh: Flags [.], ack 6421, win 24562, options [nop,nop,TS val 3528055625 ecr 1220242336], length 0 305s 19:30:36.336416 IP 10.136.6.18.38188 > autopkgtest.ssh: Flags [.], ack 9169, win 24562, options [nop,nop,TS val 3528055647 ecr 1220242359], length 0 305s 19:30:36.366784 IP internal-proxy-0.canonical.com.3128 > autopkgtest.58814: Flags [.], ack 130, win 486, options [nop,nop,TS val 1120780643 ecr 2972870685], length 0 305s 19:30:36.378695 IP 10.136.6.18.38188 > autopkgtest.ssh: Flags [.], ack 10385, win 24562, options [nop,nop,TS val 3528055689 ecr 1220242359], length 0 305s 19:30:36.657795 IP internal-proxy-0.canonical.com.3128 > autopkgtest.58814: Flags [P.], seq 1:531, ack 130, win 486, options [nop,nop,TS val 1120780934 ecr 2972870685], length 530 305s 19:30:36.657795 IP internal-proxy-0.canonical.com.3128 > autopkgtest.58814: Flags [P.], seq 531:802, ack 130, win 486, options [nop,nop,TS val 1120780934 ecr 2972870685], length 271 305s 19:30:36.657836 IP autopkgtest.58814 > internal-proxy-0.canonical.com.3128: Flags [.], ack 531, win 500, options [nop,nop,TS val 2972871042 ecr 1120780934], length 0 305s 19:30:36.657856 IP autopkgtest.58814 > internal-proxy-0.canonical.com.3128: Flags [.], ack 802, win 500, options [nop,nop,TS val 2972871042 ecr 1120780934], length 0 305s 19:30:36.658874 IP autopkgtest.58814 > internal-proxy-0.canonical.com.3128: Flags [F.], seq 130, ack 802, win 501, options [nop,nop,TS val 2972871043 ecr 1120780934], length 0 305s 19:30:36.659205 IP autopkgtest.ssh > 10.136.6.18.38188: Flags [P.], seq 10385:10509, ack 0, win 501, options [nop,nop,TS val 1220242746 ecr 3528055689], length 124 305s 19:30:36.724076 IP 10.136.6.18.38188 > autopkgtest.ssh: Flags [.], ack 10509, win 24562, options [nop,nop,TS val 3528056034 ecr 1220242746], length 0 305s 19:30:36.729531 IP internal-proxy-0.canonical.com.3128 > autopkgtest.58814: Flags [F.], seq 802, ack 131, win 486, options [nop,nop,TS val 1120781006 ecr 2972871043], length 0 305s 19:30:36.729547 IP autopkgtest.58814 > internal-proxy-0.canonical.com.3128: Flags [.], ack 803, win 501, options [nop,nop,TS val 2972871114 ecr 1120781006], length 0 305s 19:30:52.567805 LLDP, length 217: autopkgtest.local 305s 19:31:12.828722 IP autopkgtest.41355 > alphyn.canonical.com.ntp: NTPv4, Client, length 48 305s 19:31:12.834087 IP alphyn.canonical.com.ntp > autopkgtest.41355: NTPv4, Server, length 48 305s 19:31:17.871149 ARP, Request who-has _gateway tell autopkgtest, length 28 305s 19:31:17.881058 ARP, Reply _gateway is-at fa:16:3e:8a:f0:cc (oui Unknown), length 28 305s 19:31:26.635232 IP6 fe80::fc16:3eff:feae:461e > ip6-allrouters: ICMP6, router solicitation, length 16 305s 19:31:27.298356 IP6 autopkgtest > ip6-allrouters: ICMP6, router solicitation, length 16 305s autopkgtest [19:33:37]: test run-example: -----------------------] 306s run-example PASS 306s autopkgtest [19:33:38]: test run-example: - - - - - - - - - - results - - - - - - - - - - 306s autopkgtest [19:33:38]: @@@@@@@@@@@@@@@@@@@@ summary 306s run-example PASS 317s nova [W] Skipping flock in bos03-arm64 317s Creating nova instance adt-jammy-arm64-stenographer-20241115-192832-juju-7f2275-prod-proposed-migration-environment-15-559908c2-c5da-4972-8267-fad28bf4b2ea from image adt/ubuntu-jammy-arm64-server-20241115.img (UUID 5e331b54-6f2d-4b69-8769-f99a4b7a9a90)...