0s autopkgtest [19:09:58]: starting date and time: 2025-03-15 19:09:58+0000 0s autopkgtest [19:09:58]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [19:09:58]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.kfzv402f/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:glibc --apt-upgrade smcroute --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-2@bos03-s390x-32.secgroup --name adt-plucky-s390x-smcroute-20250315-190958-juju-7f2275-prod-proposed-migration-environment-2-2aced350-4bf1-4ba3-b3a2-f3aa8518582f --image adt/ubuntu-plucky-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --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/ 123s autopkgtest [19:12:01]: testbed dpkg architecture: s390x 124s autopkgtest [19:12:02]: testbed apt version: 2.9.33 124s autopkgtest [19:12:02]: @@@@@@@@@@@@@@@@@@@@ test bed setup 124s autopkgtest [19:12:02]: testbed release detected to be: None 125s autopkgtest [19:12:03]: updating testbed package index (apt update) 126s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [126 kB] 126s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 126s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 126s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 126s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [369 kB] 126s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [45.1 kB] 126s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [14.5 kB] 126s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [77.3 kB] 126s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x c-n-f Metadata [1824 B] 126s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted s390x c-n-f Metadata [116 B] 126s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [314 kB] 127s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x c-n-f Metadata [13.3 kB] 127s Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [3532 B] 127s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x c-n-f Metadata [240 B] 127s Fetched 965 kB in 1s (690 kB/s) 127s Reading package lists... 128s Reading package lists... 128s Building dependency tree... 128s Reading state information... 128s Calculating upgrade... 128s Calculating upgrade... 128s The following packages were automatically installed and are no longer required: 128s libnsl2 libpython3.12-minimal libpython3.12-stdlib libpython3.12t64 128s linux-headers-6.11.0-8 linux-headers-6.11.0-8-generic 128s linux-modules-6.11.0-8-generic linux-tools-6.11.0-8 128s linux-tools-6.11.0-8-generic 128s Use 'sudo apt autoremove' to remove them. 128s The following packages will be upgraded: 128s pinentry-curses python3-jinja2 strace 129s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 129s Need to get 652 kB of archives. 129s After this operation, 27.6 kB of additional disk space will be used. 129s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x strace s390x 6.13+ds-1ubuntu1 [500 kB] 129s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x pinentry-curses s390x 1.3.1-2ubuntu3 [42.9 kB] 129s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x python3-jinja2 all 3.1.5-2ubuntu1 [109 kB] 130s Fetched 652 kB in 1s (691 kB/s) 130s (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.) 130s Preparing to unpack .../strace_6.13+ds-1ubuntu1_s390x.deb ... 130s Unpacking strace (6.13+ds-1ubuntu1) over (6.11-0ubuntu1) ... 130s Preparing to unpack .../pinentry-curses_1.3.1-2ubuntu3_s390x.deb ... 130s Unpacking pinentry-curses (1.3.1-2ubuntu3) over (1.3.1-2ubuntu2) ... 130s Preparing to unpack .../python3-jinja2_3.1.5-2ubuntu1_all.deb ... 130s Unpacking python3-jinja2 (3.1.5-2ubuntu1) over (3.1.5-2) ... 130s Setting up pinentry-curses (1.3.1-2ubuntu3) ... 130s Setting up python3-jinja2 (3.1.5-2ubuntu1) ... 130s Setting up strace (6.13+ds-1ubuntu1) ... 130s Processing triggers for man-db (2.13.0-1) ... 131s Reading package lists... 131s Building dependency tree... 131s Reading state information... 131s Solving dependencies... 131s The following packages will be REMOVED: 131s libnsl2* libpython3.12-minimal* libpython3.12-stdlib* libpython3.12t64* 131s linux-headers-6.11.0-8* linux-headers-6.11.0-8-generic* 131s linux-modules-6.11.0-8-generic* linux-tools-6.11.0-8* 131s linux-tools-6.11.0-8-generic* 131s 0 upgraded, 0 newly installed, 9 to remove and 5 not upgraded. 131s After this operation, 167 MB disk space will be freed. 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 Removing linux-tools-6.11.0-8-generic (6.11.0-8.8) ... 131s Removing linux-tools-6.11.0-8 (6.11.0-8.8) ... 131s Removing libpython3.12t64:s390x (3.12.9-1) ... 131s Removing libpython3.12-stdlib:s390x (3.12.9-1) ... 131s Removing libnsl2:s390x (1.3.0-3build3) ... 131s Removing libpython3.12-minimal:s390x (3.12.9-1) ... 131s Removing linux-headers-6.11.0-8-generic (6.11.0-8.8) ... 131s Removing linux-headers-6.11.0-8 (6.11.0-8.8) ... 132s Removing linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 132s Processing triggers for libc-bin (2.41-1ubuntu1) ... 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 ... 56328 files and directories currently installed.) 132s Purging configuration files for libpython3.12-minimal:s390x (3.12.9-1) ... 132s Purging configuration files for linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 132s autopkgtest [19:12:10]: upgrading testbed (apt dist-upgrade and autopurge) 133s Reading package lists... 133s Building dependency tree... 133s Reading state information... 133s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 133s Starting 2 pkgProblemResolver with broken count: 0 133s Done 133s Entering ResolveByKeep 133s 133s Calculating upgrade... 133s The following packages will be upgraded: 133s libc-bin libc-dev-bin libc6 libc6-dev locales 133s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 133s Need to get 9512 kB of archives. 133s After this operation, 8192 B of additional disk space will be used. 133s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc6-dev s390x 2.41-1ubuntu2 [1678 kB] 135s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc-dev-bin s390x 2.41-1ubuntu2 [24.3 kB] 135s 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] 143s Preconfiguring packages ... 143s Fetched 9512 kB in 9s (1025 kB/s) 143s (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.) 143s Preparing to unpack .../libc6-dev_2.41-1ubuntu2_s390x.deb ... 143s Unpacking libc6-dev:s390x (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 143s Preparing to unpack .../libc-dev-bin_2.41-1ubuntu2_s390x.deb ... 143s Unpacking libc-dev-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 143s Preparing to unpack .../libc6_2.41-1ubuntu2_s390x.deb ... 143s Unpacking libc6:s390x (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 143s Setting up libc6:s390x (2.41-1ubuntu2) ... 143s (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.) 143s Preparing to unpack .../libc-bin_2.41-1ubuntu2_s390x.deb ... 143s Unpacking libc-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 143s Setting up libc-bin (2.41-1ubuntu2) ... 143s (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.) 143s Preparing to unpack .../locales_2.41-1ubuntu2_all.deb ... 143s Unpacking locales (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 143s Setting up locales (2.41-1ubuntu2) ... 144s Generating locales (this might take a while)... 145s en_US.UTF-8... done 145s Generation complete. 145s Setting up libc-dev-bin (2.41-1ubuntu2) ... 145s Setting up libc6-dev:s390x (2.41-1ubuntu2) ... 145s Processing triggers for man-db (2.13.0-1) ... 145s Processing triggers for systemd (257.3-1ubuntu3) ... 146s Reading package lists... 146s Building dependency tree... 146s Reading state information... 146s Starting pkgProblemResolver with broken count: 0 146s Starting 2 pkgProblemResolver with broken count: 0 146s Done 146s Solving dependencies... 146s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 147s autopkgtest [19:12:25]: rebooting testbed after setup commands that affected boot 160s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 167s autopkgtest [19:12:45]: testbed running kernel: Linux 6.14.0-10-generic #10-Ubuntu SMP Wed Mar 12 14:53:49 UTC 2025 169s autopkgtest [19:12:47]: @@@@@@@@@@@@@@@@@@@@ apt-source smcroute 171s Get:1 http://ftpmaster.internal/ubuntu plucky/universe smcroute 2.5.7-1 (dsc) [2053 B] 171s Get:2 http://ftpmaster.internal/ubuntu plucky/universe smcroute 2.5.7-1 (tar) [261 kB] 171s Get:3 http://ftpmaster.internal/ubuntu plucky/universe smcroute 2.5.7-1 (diff) [10.3 kB] 171s gpgv: Signature made Sun May 12 13:02:43 2024 UTC 171s gpgv: using RSA key A3EBB41FC5ABD675CEE41C45EA6CA6B951B85139 171s gpgv: Can't check signature: No public key 171s dpkg-source: warning: cannot verify inline signature for ./smcroute_2.5.7-1.dsc: no acceptable signature found 171s autopkgtest [19:12:49]: testing package smcroute version 2.5.7-1 172s autopkgtest [19:12:50]: build not needed 172s autopkgtest [19:12:50]: test daemon-init-scripts: preparing testbed 172s Reading package lists... 173s Building dependency tree... 173s Reading state information... 173s Starting pkgProblemResolver with broken count: 0 173s Starting 2 pkgProblemResolver with broken count: 0 173s Done 173s The following NEW packages will be installed: 173s libipc-system-simple-perl smcroute 173s 0 upgraded, 2 newly installed, 0 to remove and 0 not upgraded. 173s Need to get 88.1 kB of archives. 173s After this operation, 222 kB of additional disk space will be used. 173s Get:1 http://ftpmaster.internal/ubuntu plucky/universe s390x smcroute s390x 2.5.7-1 [65.8 kB] 173s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x libipc-system-simple-perl all 1.30-2 [22.3 kB] 174s Fetched 88.1 kB in 0s (215 kB/s) 174s Selecting previously unselected package smcroute. 174s (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.) 174s Preparing to unpack .../smcroute_2.5.7-1_s390x.deb ... 174s Unpacking smcroute (2.5.7-1) ... 174s Selecting previously unselected package libipc-system-simple-perl. 174s Preparing to unpack .../libipc-system-simple-perl_1.30-2_all.deb ... 174s Unpacking libipc-system-simple-perl (1.30-2) ... 174s Setting up libipc-system-simple-perl (1.30-2) ... 174s Setting up smcroute (2.5.7-1) ... 174s Created symlink '/etc/systemd/system/multi-user.target.wants/smcroute.service' → '/usr/lib/systemd/system/smcroute.service'. 174s Created symlink '/etc/systemd/system/multi-user.target.wants/smcroute-helper.service' → '/usr/lib/systemd/system/smcroute-helper.service'. 174s Processing triggers for man-db (2.13.0-1) ... 176s autopkgtest [19:12:54]: test daemon-init-scripts: [----------------------- 176s 1..11 176s ok 1 - Starting smcroute (via systemctl): smcroute.service. 176s # 176s ok 2 - smcroute is running (pid 1390) 176s ok 3 - stopping smcroute 176s ok 4 - smcroute is really stopped 176s ok 5 - stopping smcroute twice in a row 176s ok 6 - smcroute is really stopped 176s ok 7 - starting smcroute 176s ok 8 - smcroute is really running (pid 1560) 176s ok 9 - smcroute pid changed (1560 != 1390) 176s ok 10 - starting smcroute twice in a row 176s ok 11 - smcroute is really running (pid 1560) 177s autopkgtest [19:12:55]: test daemon-init-scripts: -----------------------] 177s daemon-init-scripts PASS 177s autopkgtest [19:12:55]: test daemon-init-scripts: - - - - - - - - - - results - - - - - - - - - - 177s autopkgtest [19:12:55]: test mr-cache-ipv4: preparing testbed 178s Reading package lists... 178s Building dependency tree... 178s Reading state information... 178s Starting pkgProblemResolver with broken count: 0 178s Starting 2 pkgProblemResolver with broken count: 0 178s Done 178s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 179s autopkgtest [19:12:57]: test mr-cache-ipv4: [----------------------- 179s 1..9 179s ok 1 - smcroute is running (pid 1560) 179s ok 2 - At least one multicast capable interface found: enc1 179s ok 3 - Multicast routing cache is empty 179s ok 4 - adding multicast route 10.0.0.1->enc1->enc1->224.0.1.20 doesn't fail (return code: 0) 179s ok 5 - adding multicast route 10.0.0.1->enc1->enc1->224.0.1.20 doesn't generate any console output 179s ok 6 - Multicast routing cache now contains one entry 179s # Group Origin Iif Pkts Bytes Wrong Oifs 179s # E0000114 0A000001 0 0 0 0 0:1 179s ok 7 - removing multicast route 10.0.0.1->enc1->enc1->224.0.1.20 doesn't fail (return code: 0) 179s ok 8 - removing multicast route 10.0.0.1->enc1->enc1->224.0.1.20 doesn't generate any console output 179s ok 9 - Multicast routing cache is empty again 179s autopkgtest [19:12:57]: test mr-cache-ipv4: -----------------------] 180s mr-cache-ipv4 PASS 180s autopkgtest [19:12:58]: test mr-cache-ipv4: - - - - - - - - - - results - - - - - - - - - - 180s autopkgtest [19:12:58]: test mr-cache-ipv6: preparing testbed 180s Reading package lists... 180s Building dependency tree... 180s Reading state information... 180s Starting pkgProblemResolver with broken count: 0 181s Starting 2 pkgProblemResolver with broken count: 0 181s Done 181s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 181s autopkgtest [19:12:59]: test mr-cache-ipv6: [----------------------- 182s 1..9 182s ok 1 - smcroute is running (pid 1560) 182s ok 2 - At least one multicast capable interface found: enc1 182s ok 3 - Multicast routing cache is empty 182s ok 4 - adding multicast route fc00::1->enc1->enc1->ff01:0:0:0:0:0:0:114 doesn't fail (return code: 0) 182s ok 5 - adding multicast route fc00::1->enc1->enc1->ff01:0:0:0:0:0:0:114 doesn't generate any console output 182s ok 6 - Multicast routing cache now contains one entry 182s # Group Origin Iif Pkts Bytes Wrong Oifs 182s # ff01:0000:0000:0000:0000:0000:0000:0114 fc00:0000:0000:0000:0000:0000:0000:0001 0 0 0 0 0:1 182s ok 7 - removing multicast route fc00::1->enc1->enc1->ff01:0:0:0:0:0:0:114 doesn't fail (return code: 0) 182s ok 8 - removing multicast route fc00::1->enc1->enc1->ff01:0:0:0:0:0:0:114 doesn't generate any console output 182s ok 9 - Multicast routing cache is empty again 182s autopkgtest [19:13:00]: test mr-cache-ipv6: -----------------------] 182s mr-cache-ipv6 PASS 182s autopkgtest [19:13:00]: test mr-cache-ipv6: - - - - - - - - - - results - - - - - - - - - - 183s autopkgtest [19:13:01]: @@@@@@@@@@@@@@@@@@@@ summary 183s daemon-init-scripts PASS 183s mr-cache-ipv4 PASS 183s mr-cache-ipv6 PASS 188s nova [W] Using flock in prodstack6-s390x 188s flock: timeout while waiting to get lock 188s Creating nova instance adt-plucky-s390x-smcroute-20250315-190958-juju-7f2275-prod-proposed-migration-environment-2-2aced350-4bf1-4ba3-b3a2-f3aa8518582f from image adt/ubuntu-plucky-s390x-server-20250315.img (UUID 3d3557fa-fd0f-4bba-9b89-8d5964e09f61)... 188s nova [W] Timed out waiting for 5ebf1ef7-6036-43fc-8105-7dfa29784d65 to get deleted.