1s autopkgtest [19:19:04]: starting date and time: 2025-03-15 19:19:04+0000 1s autopkgtest [19:19:04]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 1s autopkgtest [19:19:04]: host juju-7f2275-prod-proposed-migration-environment-20; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.hu7b3rhg/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.41-1ubuntu2 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-20@bos03-s390x-21.secgroup --name adt-plucky-s390x-stenographer-20250315-191903-juju-7f2275-prod-proposed-migration-environment-20-668c153f-bcf9-45cd-a400-d1f57f1b6ead --image adt/ubuntu-plucky-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-20 --net-id=net_prod-proposed-migration-s390x -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/ 125s autopkgtest [19:21:08]: testbed dpkg architecture: s390x 125s autopkgtest [19:21:08]: testbed apt version: 2.9.33 126s autopkgtest [19:21:09]: @@@@@@@@@@@@@@@@@@@@ test bed setup 126s autopkgtest [19:21:09]: testbed release detected to be: None 126s autopkgtest [19:21:09]: updating testbed package index (apt update) 127s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [126 kB] 127s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 127s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 127s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 127s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [14.5 kB] 127s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [369 kB] 128s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [45.1 kB] 128s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [77.3 kB] 128s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x c-n-f Metadata [1824 B] 128s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted s390x c-n-f Metadata [116 B] 128s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [314 kB] 128s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x c-n-f Metadata [13.3 kB] 128s Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [3532 B] 128s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x c-n-f Metadata [240 B] 128s Fetched 965 kB in 1s (773 kB/s) 129s Reading package lists... 129s Reading package lists... 129s Building dependency tree... 129s Reading state information... 129s Calculating upgrade... 130s Calculating upgrade... 130s The following packages were automatically installed and are no longer required: 130s libnsl2 libpython3.12-minimal libpython3.12-stdlib libpython3.12t64 130s linux-headers-6.11.0-8 linux-headers-6.11.0-8-generic 130s linux-modules-6.11.0-8-generic linux-tools-6.11.0-8 130s linux-tools-6.11.0-8-generic 130s Use 'sudo apt autoremove' to remove them. 130s The following packages will be upgraded: 130s pinentry-curses python3-jinja2 strace 130s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 130s Need to get 652 kB of archives. 130s After this operation, 27.6 kB of additional disk space will be used. 130s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x strace s390x 6.13+ds-1ubuntu1 [500 kB] 130s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x pinentry-curses s390x 1.3.1-2ubuntu3 [42.9 kB] 130s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x python3-jinja2 all 3.1.5-2ubuntu1 [109 kB] 131s Fetched 652 kB in 1s (743 kB/s) 131s (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 ... 81428 files and directories currently installed.) 131s Preparing to unpack .../strace_6.13+ds-1ubuntu1_s390x.deb ... 131s Unpacking strace (6.13+ds-1ubuntu1) over (6.11-0ubuntu1) ... 131s Preparing to unpack .../pinentry-curses_1.3.1-2ubuntu3_s390x.deb ... 131s Unpacking pinentry-curses (1.3.1-2ubuntu3) over (1.3.1-2ubuntu2) ... 131s Preparing to unpack .../python3-jinja2_3.1.5-2ubuntu1_all.deb ... 131s Unpacking python3-jinja2 (3.1.5-2ubuntu1) over (3.1.5-2) ... 131s Setting up pinentry-curses (1.3.1-2ubuntu3) ... 131s Setting up python3-jinja2 (3.1.5-2ubuntu1) ... 131s Setting up strace (6.13+ds-1ubuntu1) ... 131s Processing triggers for man-db (2.13.0-1) ... 132s Reading package lists... 132s Building dependency tree... 132s Reading state information... 132s Solving dependencies... 132s The following packages will be REMOVED: 132s libnsl2* libpython3.12-minimal* libpython3.12-stdlib* libpython3.12t64* 132s linux-headers-6.11.0-8* linux-headers-6.11.0-8-generic* 132s linux-modules-6.11.0-8-generic* linux-tools-6.11.0-8* 132s linux-tools-6.11.0-8-generic* 132s 0 upgraded, 0 newly installed, 9 to remove and 5 not upgraded. 132s After this operation, 167 MB disk space will be freed. 132s (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 ... 81428 files and directories currently installed.) 132s Removing linux-tools-6.11.0-8-generic (6.11.0-8.8) ... 132s Removing linux-tools-6.11.0-8 (6.11.0-8.8) ... 132s Removing libpython3.12t64:s390x (3.12.9-1) ... 132s Removing libpython3.12-stdlib:s390x (3.12.9-1) ... 132s Removing libnsl2:s390x (1.3.0-3build3) ... 132s Removing libpython3.12-minimal:s390x (3.12.9-1) ... 132s Removing linux-headers-6.11.0-8-generic (6.11.0-8.8) ... 132s Removing linux-headers-6.11.0-8 (6.11.0-8.8) ... 133s Removing linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 133s Processing triggers for libc-bin (2.41-1ubuntu1) ... 133s (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 ... 56328 files and directories currently installed.) 133s Purging configuration files for libpython3.12-minimal:s390x (3.12.9-1) ... 133s Purging configuration files for linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 134s autopkgtest [19:21:17]: upgrading testbed (apt dist-upgrade and autopurge) 134s Reading package lists... 134s Building dependency tree... 134s Reading state information... 134s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 134s Starting 2 pkgProblemResolver with broken count: 0 134s Done 134s Entering ResolveByKeep 134s 134s Calculating upgrade... 135s The following packages will be upgraded: 135s libc-bin libc-dev-bin libc6 libc6-dev locales 135s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 135s Need to get 9512 kB of archives. 135s After this operation, 8192 B of additional disk space will be used. 135s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc6-dev s390x 2.41-1ubuntu2 [1678 kB] 136s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc-dev-bin s390x 2.41-1ubuntu2 [24.3 kB] 136s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc6 s390x 2.41-1ubuntu2 [2892 kB] 138s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc-bin s390x 2.41-1ubuntu2 [671 kB] 138s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x locales all 2.41-1ubuntu2 [4246 kB] 142s Preconfiguring packages ... 142s Fetched 9512 kB in 7s (1389 kB/s) 142s (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 ... 56326 files and directories currently installed.) 142s Preparing to unpack .../libc6-dev_2.41-1ubuntu2_s390x.deb ... 142s Unpacking libc6-dev:s390x (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 142s Preparing to unpack .../libc-dev-bin_2.41-1ubuntu2_s390x.deb ... 142s Unpacking libc-dev-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 142s Preparing to unpack .../libc6_2.41-1ubuntu2_s390x.deb ... 142s Unpacking libc6:s390x (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 142s Setting up libc6:s390x (2.41-1ubuntu2) ... 142s (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 ... 56326 files and directories currently installed.) 142s Preparing to unpack .../libc-bin_2.41-1ubuntu2_s390x.deb ... 142s Unpacking libc-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 142s Setting up libc-bin (2.41-1ubuntu2) ... 142s (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 ... 56326 files and directories currently installed.) 142s Preparing to unpack .../locales_2.41-1ubuntu2_all.deb ... 142s Unpacking locales (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 142s Setting up locales (2.41-1ubuntu2) ... 143s Generating locales (this might take a while)... 144s en_US.UTF-8... done 144s Generation complete. 144s Setting up libc-dev-bin (2.41-1ubuntu2) ... 144s Setting up libc6-dev:s390x (2.41-1ubuntu2) ... 144s Processing triggers for man-db (2.13.0-1) ... 144s Processing triggers for systemd (257.3-1ubuntu3) ... 145s Reading package lists... 145s Building dependency tree... 145s Reading state information... 145s Starting pkgProblemResolver with broken count: 0 145s Starting 2 pkgProblemResolver with broken count: 0 145s Done 146s Solving dependencies... 146s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 146s autopkgtest [19:21:29]: rebooting testbed after setup commands that affected boot 164s autopkgtest [19:21:47]: testbed running kernel: Linux 6.14.0-10-generic #10-Ubuntu SMP Wed Mar 12 14:53:49 UTC 2025 166s autopkgtest [19:21:49]: @@@@@@@@@@@@@@@@@@@@ apt-source stenographer 169s Get:1 http://ftpmaster.internal/ubuntu plucky/universe stenographer 1.0.1-7 (dsc) [2753 B] 169s Get:2 http://ftpmaster.internal/ubuntu plucky/universe stenographer 1.0.1-7 (tar) [149 kB] 169s Get:3 http://ftpmaster.internal/ubuntu plucky/universe stenographer 1.0.1-7 (diff) [15.1 kB] 169s gpgv: Signature made Wed Aug 7 05:05:27 2024 UTC 169s gpgv: using RSA key 5B34BA5AAB5507E903426E85E8D37AE2F09F4872 169s gpgv: Can't check signature: No public key 169s dpkg-source: warning: cannot verify inline signature for ./stenographer_1.0.1-7.dsc: no acceptable signature found 169s autopkgtest [19:21:52]: testing package stenographer version 1.0.1-7 171s autopkgtest [19:21:54]: build not needed 176s autopkgtest [19:21:59]: test run-example: preparing testbed 177s Reading package lists... 177s Building dependency tree... 177s Reading state information... 177s Starting pkgProblemResolver with broken count: 0 177s Starting 2 pkgProblemResolver with broken count: 0 177s Done 177s The following NEW packages will be installed: 177s libleveldb1d libsnappy1v5 net-tools stenographer stenographer-client 177s stenographer-common 177s 0 upgraded, 6 newly installed, 0 to remove and 0 not upgraded. 177s Need to get 4391 kB of archives. 177s After this operation, 15.3 MB of additional disk space will be used. 177s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x libsnappy1v5 s390x 1.2.1-1 [33.0 kB] 177s Get:2 http://ftpmaster.internal/ubuntu plucky/universe s390x libleveldb1d s390x 1.23-5build1 [134 kB] 177s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x net-tools s390x 2.10-1.1ubuntu1 [207 kB] 178s Get:4 http://ftpmaster.internal/ubuntu plucky/universe s390x stenographer-common all 1.0.1-7 [21.0 kB] 178s Get:5 http://ftpmaster.internal/ubuntu plucky/universe s390x stenographer s390x 1.0.1-7 [3990 kB] 180s Get:6 http://ftpmaster.internal/ubuntu plucky/universe s390x stenographer-client all 1.0.1-7 [5288 B] 180s Fetched 4391 kB in 3s (1432 kB/s) 180s Selecting previously unselected package libsnappy1v5:s390x. 180s (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 ... 56326 files and directories currently installed.) 180s Preparing to unpack .../0-libsnappy1v5_1.2.1-1_s390x.deb ... 180s Unpacking libsnappy1v5:s390x (1.2.1-1) ... 180s Selecting previously unselected package libleveldb1d:s390x. 180s Preparing to unpack .../1-libleveldb1d_1.23-5build1_s390x.deb ... 180s Unpacking libleveldb1d:s390x (1.23-5build1) ... 180s Selecting previously unselected package net-tools. 181s Preparing to unpack .../2-net-tools_2.10-1.1ubuntu1_s390x.deb ... 181s Unpacking net-tools (2.10-1.1ubuntu1) ... 181s Selecting previously unselected package stenographer-common. 181s Preparing to unpack .../3-stenographer-common_1.0.1-7_all.deb ... 181s Unpacking stenographer-common (1.0.1-7) ... 181s Selecting previously unselected package stenographer. 181s Preparing to unpack .../4-stenographer_1.0.1-7_s390x.deb ... 181s Unpacking stenographer (1.0.1-7) ... 181s Selecting previously unselected package stenographer-client. 181s Preparing to unpack .../5-stenographer-client_1.0.1-7_all.deb ... 181s Unpacking stenographer-client (1.0.1-7) ... 181s Setting up net-tools (2.10-1.1ubuntu1) ... 181s Setting up stenographer-common (1.0.1-7) ... 181s info: Selecting UID from range 100 to 999 ... 181s 181s info: Selecting GID from range 100 to 999 ... 181s info: Adding system user `stenographer' (UID 107) ... 181s info: Adding new group `stenographer' (GID 110) ... 181s info: Adding new user `stenographer' (UID 107) with group `stenographer' ... 181s info: Not creating home directory `/var/lib/stenographer'. 181s Generating CA state 182s Generating key/cert for 'client' 182s Generating key/cert for 'server' 185s Warning: Ignoring -days without -x509; not generating a certificate 185s Using configuration from /tmp/stenossl.568cXcosiaXY 185s Check that the request matches the signature 185s Signature ok 185s The Subject's Distinguished Name is as follows 185s countryName :PRINTABLE:'XX' 185s organizationName :ASN.1 12:'Stenographer' 185s commonName :ASN.1 12:'127.0.0.1_client' 185s Certificate is to be certified until Jul 30 19:23:31 2052 GMT (9999 days) 185s 185s Write out database with 1 new entries 185s Database updated 185s Warning: Ignoring -days without -x509; not generating a certificate 185s Using configuration from /tmp/stenossl.568cXcosiaXY 185s Check that the request matches the signature 185s Signature ok 185s The Subject's Distinguished Name is as follows 185s countryName :PRINTABLE:'XX' 185s organizationName :ASN.1 12:'Stenographer' 185s commonName :ASN.1 12:'127.0.0.1' 185s Certificate is to be certified until Jul 30 19:23:33 2052 GMT (9999 days) 185s 185s Write out database with 1 new entries 185s Database updated 185s Setting up stenographer-client (1.0.1-7) ... 185s Setting up libsnappy1v5:s390x (1.2.1-1) ... 185s Setting up libleveldb1d:s390x (1.23-5build1) ... 185s Setting up stenographer (1.0.1-7) ... 185s setcap on /usr/sbin/stenotype worked. 185s Processing triggers for man-db (2.13.0-1) ... 186s Processing triggers for libc-bin (2.41-1ubuntu2) ... 187s autopkgtest [19:22:10]: test run-example: [----------------------- 187s Filesystem info: 187s Filesystem Type Size Used Avail Use% Mounted on 187s /dev/vda1 ext4 20G 1.8G 18G 10% / 187s Kernel IP routing table 187s Destination Gateway Genmask Flags Metric Ref Use Iface 187s 0.0.0.0 10.145.232.1 0.0.0.0 UG 100 0 0 enc1 187s 10.145.232.0 0.0.0.0 255.255.255.0 U 100 0 0 enc1 187s 10.145.232.1 0.0.0.0 255.255.255.255 UH 100 0 0 enc1 187s 10.145.232.2 0.0.0.0 255.255.255.255 UH 100 0 0 enc1 187s 91.189.91.131 10.145.232.1 255.255.255.255 UGH 100 0 0 enc1 187s 91.189.91.132 10.145.232.1 255.255.255.255 UGH 100 0 0 enc1 187s 169.254.169.254 10.145.232.2 255.255.255.255 UGH 100 0 0 enc1 187s Using interface enc1 207s ● stenographer.service - packet capture to disk 207s Loaded: loaded (/usr/lib/systemd/system/stenographer.service; disabled; preset: enabled) 207s Active: active (running) since Sat 2025-03-15 19:23:36 UTC; 1min 5s left 207s Invocation: 50f86f6673eb4c49ab6c739811cecf10 207s Docs: https://github.com/google/stenographer 207s https://github.com/google/stenographer/blob/master/DESIGN.md 207s https://github.com/google/stenographer/blob/master/INSTALL.md 207s Main PID: 1588 (stenographer) 207s Tasks: 13 (limit: 4768) 207s Memory: 9.5M (peak: 9.9M) 207s CPU: 54ms 207s CGroup: /system.slice/stenographer.service 207s ├─1588 /usr/sbin/stenographer 207s └─1596 /usr/sbin/stenotype --blocks=256 --seccomp=none --threads=1 --dir=/tmp/stenographer1004921081 --iface=enc1 207s 207s Mar 15 19:23:36 autopkgtest systemd[1]: Started stenographer.service - packet capture to disk. 207s active 207s % Total % Received % Xferd Average Speed Time Time Time Current 207s Dload Upload Total Spent Left Speed 208s 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 100 271 100 271 0 0 799 0 --:--:-- --:--:-- --:--:-- 801 388s ● stenographer.service - packet capture to disk 388s Loaded: loaded (/usr/lib/systemd/system/stenographer.service; disabled; preset: enabled) 388s Active: active (running) since Sat 2025-03-15 19:23:36 UTC; 1min 54s ago 388s Invocation: 50f86f6673eb4c49ab6c739811cecf10 388s Docs: https://github.com/google/stenographer 388s https://github.com/google/stenographer/blob/master/DESIGN.md 388s https://github.com/google/stenographer/blob/master/INSTALL.md 388s Main PID: 1588 (stenographer) 388s Tasks: 13 (limit: 4768) 388s Memory: 9.6M (peak: 10M) 388s CPU: 84ms 388s CGroup: /system.slice/stenographer.service 388s ├─1588 /usr/sbin/stenographer 388s └─1596 /usr/sbin/stenotype --blocks=256 --seccomp=none --threads=1 --dir=/tmp/stenographer1004921081 --iface=enc1 388s 388s Mar 15 19:23:36 autopkgtest systemd[1]: Started stenographer.service - packet capture to disk. 388s tcp 0 0 127.0.0.1:1234 0.0.0.0:* LISTEN 1588/stenographer 388s Running stenographer query 'after 5m ago', piping to 'tcpdump ' 388s reading from file /dev/stdin, link-type EN10MB (Ethernet), snapshot length 65536 388s 19:23:39.332750 IP6 autopkgtest > ip6-allrouters: ICMP6, router solicitation, length 16 388s 19:23:40.176624 IP autopkgtest.43790 > csb-recursive-nameserver1.canonical.com.domain: 22547+ [1au] A? ntp.ubuntu.com. (43) 388s 19:23:40.176690 IP autopkgtest.53279 > csb-recursive-nameserver1.canonical.com.domain: 30394+ [1au] AAAA? ntp.ubuntu.com. (43) 388s 19:23:40.178322 IP csb-recursive-nameserver1.canonical.com.domain > autopkgtest.43790: 22547 4/0/1 A 185.125.190.56, A 185.125.190.58, A 91.189.91.157, A 185.125.190.57 (107) 388s 19:23:40.181918 IP csb-recursive-nameserver1.canonical.com.domain > autopkgtest.53279: 30394 3/0/1 AAAA 2620:2d:4000:1::41, AAAA 2620:2d:4000:1::40, AAAA 2620:2d:4000:1::3f (127) 388s 19:23:40.182160 IP autopkgtest.51317 > prod-ntp-3.ntp1.ps5.canonical.com.ntp: NTPv4, Client, length 48 388s 19:23:40.253241 IP prod-ntp-3.ntp1.ps5.canonical.com.ntp > autopkgtest.51317: NTPv4, Server, length 48 388s 19:22:15.773990 ARP, Request who-has 10.145.232.59 tell _gateway, length 28 388s 19:22:15.774165 ARP, Request who-has 10.145.232.59 tell _gateway, length 28 388s 19:22:15.895362 ARP, Request who-has 10.145.232.59 tell _gateway, length 28 388s 19:22:16.176655 ARP, Request who-has 10.145.232.59 tell _gateway, length 28 388s 19:22:16.783660 ARP, Request who-has 10.145.232.59 tell _gateway, length 28 388s 19:22:17.876400 ARP, Request who-has 10.145.232.59 tell _gateway, length 28 388s 19:22:20.248800 ARP, Request who-has 10.145.232.59 tell _gateway, length 28 388s 19:22:20.654080 IP6 fe80::fc16:3eff:fe6f:12e0 > ip6-allrouters: ICMP6, router solicitation, length 16 388s 19:22:24.865649 ARP, Request who-has 10.145.232.59 tell _gateway, length 28 388s 19:22:30.623679 IP autopkgtest.ssh > 10.136.6.173.35854: Flags [P.], seq 2322448907:2322449847, ack 2517298822, win 384, options [nop,nop,TS val 1168957351 ecr 1455983722], length 940 388s 19:22:30.626824 IP autopkgtest.ssh > 10.136.6.173.35854: Flags [P.], seq 940:984, ack 1, win 384, options [nop,nop,TS val 1168957354 ecr 1455983722], length 44 388s 19:22:30.643216 IP autopkgtest.ssh > 10.136.6.173.35854: Flags [P.], seq 984:1204, ack 1, win 384, options [nop,nop,TS val 1168957370 ecr 1455983722], length 220 388s 19:22:30.643242 IP autopkgtest.ssh > 10.136.6.173.35854: Flags [P.], seq 1204:1304, ack 1, win 384, options [nop,nop,TS val 1168957370 ecr 1455983722], length 100 388s 19:22:30.643476 IP autopkgtest.58275 > csb-recursive-nameserver1.canonical.com.domain: 61317+ [1au] A? squid.internal. (43) 388s 19:22:30.643532 IP autopkgtest.58485 > csb-recursive-nameserver1.canonical.com.domain: 7207+ [1au] AAAA? squid.internal. (43) 388s 19:22:30.643827 IP csb-recursive-nameserver1.canonical.com.domain > autopkgtest.58275: 61317 2/0/1 A 185.125.188.86, A 185.125.188.85 (75) 388s 19:22:30.644366 IP csb-recursive-nameserver1.canonical.com.domain > autopkgtest.58485: 7207 0/1/1 (116) 388s 19:22:30.644553 IP autopkgtest.51628 > internal-proxy-1.canonical.com.3128: Flags [S], seq 1901358918, win 64240, options [mss 1460,sackOK,TS val 3492580398 ecr 0,nop,wscale 7], length 0 388s 19:22:30.688925 IP 10.136.6.173.35854 > autopkgtest.ssh: Flags [.], ack 940, win 24567, options [nop,nop,TS val 1456003705 ecr 1168957351], length 0 388s 19:22:30.691322 IP 10.136.6.173.35854 > autopkgtest.ssh: Flags [.], ack 984, win 24567, options [nop,nop,TS val 1456003707 ecr 1168957354], length 0 388s 19:22:30.707352 IP 10.136.6.173.35854 > autopkgtest.ssh: Flags [.], ack 1204, win 24567, options [nop,nop,TS val 1456003723 ecr 1168957370], length 0 388s 19:22:30.707352 IP 10.136.6.173.35854 > autopkgtest.ssh: Flags [.], ack 1304, win 24567, options [nop,nop,TS val 1456003723 ecr 1168957370], length 0 388s 19:22:30.741004 IP internal-proxy-1.canonical.com.3128 > autopkgtest.51628: Flags [S.], seq 3144304450, ack 1901358919, win 62230, options [mss 8902,sackOK,TS val 2555506706 ecr 3492580398,nop,wscale 7], length 0 388s 19:22:30.741047 IP autopkgtest.51628 > internal-proxy-1.canonical.com.3128: Flags [.], ack 1, win 502, options [nop,nop,TS val 3492580494 ecr 2555506706], length 0 388s 19:22:30.741181 IP autopkgtest.51628 > internal-proxy-1.canonical.com.3128: Flags [P.], seq 1:130, ack 1, win 502, options [nop,nop,TS val 3492580494 ecr 2555506706], length 129 388s 19:22:30.806465 IP internal-proxy-1.canonical.com.3128 > autopkgtest.51628: Flags [.], ack 130, win 486, options [nop,nop,TS val 2555506800 ecr 3492580494], length 0 388s 19:22:30.981697 IP internal-proxy-1.canonical.com.3128 > autopkgtest.51628: Flags [P.], seq 1:531, ack 130, win 486, options [nop,nop,TS val 2555506975 ecr 3492580494], length 530 388s 19:22:30.981761 IP autopkgtest.51628 > internal-proxy-1.canonical.com.3128: Flags [.], ack 531, win 500, options [nop,nop,TS val 3492580735 ecr 2555506975], length 0 388s 19:22:30.981882 IP internal-proxy-1.canonical.com.3128 > autopkgtest.51628: Flags [P.], seq 531:802, ack 130, win 486, options [nop,nop,TS val 2555506975 ecr 3492580494], length 271 388s 19:22:30.981891 IP autopkgtest.51628 > internal-proxy-1.canonical.com.3128: Flags [.], ack 802, win 500, options [nop,nop,TS val 3492580735 ecr 2555506975], length 0 388s 19:22:30.982102 IP autopkgtest.51628 > internal-proxy-1.canonical.com.3128: Flags [F.], seq 130, ack 802, win 501, options [nop,nop,TS val 3492580735 ecr 2555506975], length 0 388s 19:22:30.982134 IP autopkgtest.ssh > 10.136.6.173.35854: Flags [P.], seq 1304:1428, ack 1, win 384, options [nop,nop,TS val 1168957709 ecr 1456003723], length 124 388s 19:22:31.047056 IP 10.136.6.173.35854 > autopkgtest.ssh: Flags [.], ack 1428, win 24567, options [nop,nop,TS val 1456004063 ecr 1168957709], length 0 388s 19:22:31.051668 IP internal-proxy-1.canonical.com.3128 > autopkgtest.51628: Flags [F.], seq 802, ack 131, win 486, options [nop,nop,TS val 2555507045 ecr 3492580735], length 0 388s 19:22:31.051695 IP autopkgtest.51628 > internal-proxy-1.canonical.com.3128: Flags [.], ack 803, win 501, options [nop,nop,TS val 3492580805 ecr 2555507045], length 0 388s 19:22:33.807745 ARP, Request who-has 10.145.232.59 tell _gateway, length 28 388s 19:22:44.887772 IP6 autopkgtest > ip6-allrouters: ICMP6, router solicitation, length 16 388s 19:22:46.876330 IP autopkgtest.57747 > prod-ntp-3.ntp1.ps5.canonical.com.ntp: NTPv4, Client, length 48 388s 19:22:46.944676 IP prod-ntp-3.ntp1.ps5.canonical.com.ntp > autopkgtest.57747: NTPv4, Server, length 48 388s 19:22:52.061861 ARP, Request who-has 10.145.232.59 tell _gateway, length 28 388s 19:22:53.269953 ARP, Request who-has 10.145.232.106 tell _gateway, length 28 388s 19:22:53.270134 ARP, Request who-has 10.145.232.106 tell _gateway, length 28 388s 19:22:53.425370 ARP, Request who-has 10.145.232.106 tell _gateway, length 28 388s 19:22:53.717391 ARP, Request who-has 10.145.232.106 tell _gateway, length 28 388s 19:22:54.293454 ARP, Request who-has 10.145.232.106 tell _gateway, length 28 388s 19:22:55.410305 ARP, Request who-has 10.145.232.106 tell _gateway, length 28 388s 19:22:58.086358 ARP, Request who-has 10.145.232.106 tell _gateway, length 28 388s 19:23:02.546868 ARP, Request who-has 10.145.232.106 tell _gateway, length 28 388s 19:23:11.557498 ARP, Request who-has 10.145.232.106 tell _gateway, length 28 388s 19:23:12.085983 ARP, Request who-has 10.145.232.196 tell _gateway, length 28 388s 19:23:12.086189 ARP, Request who-has 10.145.232.196 tell _gateway, length 28 388s 19:23:12.252991 ARP, Request who-has 10.145.232.196 tell _gateway, length 28 388s 19:23:12.564765 ARP, Request who-has 10.145.232.196 tell _gateway, length 28 388s 19:23:13.150804 ARP, Request who-has 10.145.232.196 tell _gateway, length 28 388s 19:23:14.289930 ARP, Request who-has 10.145.232.196 tell _gateway, length 28 388s 19:23:16.566911 ARP, Request who-has 10.145.232.196 tell _gateway, length 28 388s 19:23:21.215530 ARP, Request who-has 10.145.232.196 tell _gateway, length 28 388s 19:23:30.388999 ARP, Request who-has 10.145.232.196 tell _gateway, length 28 388s 19:23:30.903556 ARP, Request who-has 10.145.232.106 tell _gateway, length 28 388s 19:23:44.940484 IP6 autopkgtest > ip6-allrouters: ICMP6, router solicitation, length 16 388s 19:23:50.458280 ARP, Request who-has 10.145.232.196 tell _gateway, length 28 388s 19:23:51.126290 IP autopkgtest.41467 > prod-ntp-3.ntp1.ps5.canonical.com.ntp: NTPv4, Client, length 48 388s 19:23:51.252009 IP prod-ntp-3.ntp1.ps5.canonical.com.ntp > autopkgtest.41467: NTPv4, Server, length 48 388s 19:23:52.053933 ARP, Request who-has 10.145.232.191 tell _gateway, length 28 388s 19:23:52.054123 ARP, Request who-has 10.145.232.191 tell _gateway, length 28 388s 19:23:52.163906 ARP, Request who-has 10.145.232.191 tell _gateway, length 28 388s 19:23:52.473711 ARP, Request who-has 10.145.232.191 tell _gateway, length 28 388s 19:23:53.054386 ARP, Request who-has 10.145.232.191 tell _gateway, length 28 388s 19:23:54.171050 ARP, Request who-has 10.145.232.191 tell _gateway, length 28 388s 19:23:56.133577 ARP, Request who-has _gateway tell autopkgtest, length 28 388s 19:23:56.136847 ARP, Reply _gateway is-at fa:16:3e:74:9a:d5 (oui Unknown), length 28 388s 19:23:56.501802 ARP, Request who-has 10.145.232.191 tell _gateway, length 28 388s 19:24:01.112407 ARP, Request who-has 10.145.232.191 tell _gateway, length 28 388s 19:24:07.747822 ARP, Request who-has 10.145.232.85 tell _gateway, length 28 388s 19:24:08.916675 ARP, Request who-has 10.145.232.85 tell _gateway, length 28 388s 19:24:10.087783 ARP, Request who-has 10.145.232.191 tell _gateway, length 28 388s 19:24:11.360221 ARP, Request who-has 10.145.232.85 tell _gateway, length 28 388s 19:24:15.995335 ARP, Request who-has 10.145.232.85 tell _gateway, length 28 388s 19:24:18.432097 IP6 fe80::fc16:3eff:fe6f:12e0 > ip6-allrouters: ICMP6, router solicitation, length 16 388s 19:24:25.334433 ARP, Request who-has 10.145.232.85 tell _gateway, length 28 389s autopkgtest [19:25:32]: test run-example: -----------------------] 389s run-example PASS 389s autopkgtest [19:25:32]: test run-example: - - - - - - - - - - results - - - - - - - - - - 390s autopkgtest [19:25:33]: @@@@@@@@@@@@@@@@@@@@ summary 390s run-example PASS 406s nova [W] Using flock in prodstack6-s390x 406s Creating nova instance adt-plucky-s390x-stenographer-20250315-191903-juju-7f2275-prod-proposed-migration-environment-20-668c153f-bcf9-45cd-a400-d1f57f1b6ead from image adt/ubuntu-plucky-s390x-server-20250315.img (UUID 3d3557fa-fd0f-4bba-9b89-8d5964e09f61)... 406s nova [W] Timed out waiting for 1f57bad5-1401-4da8-b479-d868f6bf1bc9 to get deleted.