0s autopkgtest [16:57:31]: starting date and time: 2025-03-15 16:57:31+0000 0s autopkgtest [16:57:31]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [16:57:31]: host juju-7f2275-prod-proposed-migration-environment-9; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.pgsoxl4x/out --timeout-copy=6000 --setup-commands 'ln -s /dev/null /etc/systemd/system/bluetooth.service; printf "http_proxy=http://squid.internal:3128\nhttps_proxy=http://squid.internal:3128\nno_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\n" >> /etc/environment' --apt-pocket=proposed=src:glibc --apt-upgrade roguenarok --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=glibc/2.41-1ubuntu2 -- lxd -r lxd-armhf-10.145.243.160 lxd-armhf-10.145.243.160:autopkgtest/ubuntu/plucky/armhf 20s autopkgtest [16:57:51]: testbed dpkg architecture: armhf 22s autopkgtest [16:57:53]: testbed apt version: 2.9.33 26s autopkgtest [16:57:57]: @@@@@@@@@@@@@@@@@@@@ test bed setup 28s autopkgtest [16:57:59]: testbed release detected to be: None 35s autopkgtest [16:58:06]: updating testbed package index (apt update) 37s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [126 kB] 37s Get:2 http://ftpmaster.internal/ubuntu plucky InRelease [257 kB] 37s Get:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease [126 kB] 38s Get:4 http://ftpmaster.internal/ubuntu plucky-security InRelease [126 kB] 38s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.8 kB] 38s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [99.7 kB] 38s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [379 kB] 38s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/main armhf Packages [114 kB] 38s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main armhf c-n-f Metadata [1832 B] 38s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted armhf c-n-f Metadata [116 B] 38s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe armhf Packages [312 kB] 39s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/universe armhf c-n-f Metadata [11.1 kB] 39s Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse armhf Packages [3472 B] 39s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse armhf c-n-f Metadata [240 B] 39s Get:15 http://ftpmaster.internal/ubuntu plucky/multiverse Sources [299 kB] 39s Get:16 http://ftpmaster.internal/ubuntu plucky/main Sources [1394 kB] 41s Get:17 http://ftpmaster.internal/ubuntu plucky/universe Sources [21.0 MB] 63s Get:18 http://ftpmaster.internal/ubuntu plucky/main armhf Packages [1378 kB] 65s Get:19 http://ftpmaster.internal/ubuntu plucky/main armhf c-n-f Metadata [29.4 kB] 65s Get:20 http://ftpmaster.internal/ubuntu plucky/restricted armhf c-n-f Metadata [108 B] 65s Get:21 http://ftpmaster.internal/ubuntu plucky/universe armhf Packages [15.1 MB] 80s Get:22 http://ftpmaster.internal/ubuntu plucky/multiverse armhf Packages [172 kB] 82s Fetched 41.0 MB in 45s (909 kB/s) 83s Reading package lists... 89s autopkgtest [16:59:00]: upgrading testbed (apt dist-upgrade and autopurge) 91s Reading package lists... 91s Building dependency tree... 91s Reading state information... 92s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 92s Starting 2 pkgProblemResolver with broken count: 0 92s Done 92s Entering ResolveByKeep 93s 93s Calculating upgrade... 93s The following packages will be upgraded: 93s libc-bin libc6 locales pinentry-curses python3-jinja2 sos strace 94s 7 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 94s Need to get 8683 kB of archives. 94s After this operation, 23.6 kB of additional disk space will be used. 94s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main armhf libc6 armhf 2.41-1ubuntu2 [2932 kB] 97s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main armhf libc-bin armhf 2.41-1ubuntu2 [545 kB] 97s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main armhf locales all 2.41-1ubuntu2 [4246 kB] 102s Get:4 http://ftpmaster.internal/ubuntu plucky/main armhf strace armhf 6.13+ds-1ubuntu1 [445 kB] 102s Get:5 http://ftpmaster.internal/ubuntu plucky/main armhf pinentry-curses armhf 1.3.1-2ubuntu3 [40.6 kB] 102s Get:6 http://ftpmaster.internal/ubuntu plucky/main armhf python3-jinja2 all 3.1.5-2ubuntu1 [109 kB] 102s Get:7 http://ftpmaster.internal/ubuntu plucky/main armhf sos all 4.9.0-5 [365 kB] 103s Preconfiguring packages ... 103s Fetched 8683 kB in 9s (928 kB/s) 104s (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 ... 64655 files and directories currently installed.) 104s Preparing to unpack .../libc6_2.41-1ubuntu2_armhf.deb ... 104s Unpacking libc6:armhf (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 104s Setting up libc6:armhf (2.41-1ubuntu2) ... 104s (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 ... 64655 files and directories currently installed.) 104s Preparing to unpack .../libc-bin_2.41-1ubuntu2_armhf.deb ... 104s Unpacking libc-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 104s Setting up libc-bin (2.41-1ubuntu2) ... 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 ... 64655 files and directories currently installed.) 105s Preparing to unpack .../locales_2.41-1ubuntu2_all.deb ... 105s Unpacking locales (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 105s Preparing to unpack .../strace_6.13+ds-1ubuntu1_armhf.deb ... 105s Unpacking strace (6.13+ds-1ubuntu1) over (6.11-0ubuntu1) ... 105s Preparing to unpack .../pinentry-curses_1.3.1-2ubuntu3_armhf.deb ... 105s Unpacking pinentry-curses (1.3.1-2ubuntu3) over (1.3.1-2ubuntu2) ... 105s Preparing to unpack .../python3-jinja2_3.1.5-2ubuntu1_all.deb ... 105s Unpacking python3-jinja2 (3.1.5-2ubuntu1) over (3.1.5-2) ... 105s Preparing to unpack .../archives/sos_4.9.0-5_all.deb ... 105s Unpacking sos (4.9.0-5) over (4.9.0-4) ... 105s Setting up sos (4.9.0-5) ... 106s Setting up pinentry-curses (1.3.1-2ubuntu3) ... 106s Setting up locales (2.41-1ubuntu2) ... 107s Generating locales (this might take a while)... 109s en_US.UTF-8... done 109s Generation complete. 109s Setting up python3-jinja2 (3.1.5-2ubuntu1) ... 109s Setting up strace (6.13+ds-1ubuntu1) ... 109s Processing triggers for man-db (2.13.0-1) ... 110s Processing triggers for systemd (257.3-1ubuntu3) ... 113s Reading package lists... 113s Building dependency tree... 113s Reading state information... 114s Starting pkgProblemResolver with broken count: 0 114s Starting 2 pkgProblemResolver with broken count: 0 114s Done 114s Solving dependencies... 115s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 117s autopkgtest [16:59:28]: rebooting testbed after setup commands that affected boot 156s autopkgtest [17:00:07]: testbed running kernel: Linux 6.8.0-52-generic #53~22.04.1-Ubuntu SMP PREEMPT_DYNAMIC Wed Jan 15 18:10:51 UTC 2 181s autopkgtest [17:00:32]: @@@@@@@@@@@@@@@@@@@@ apt-source roguenarok 192s Get:1 http://ftpmaster.internal/ubuntu plucky/universe roguenarok 1.0.1-3 (dsc) [1994 B] 192s Get:2 http://ftpmaster.internal/ubuntu plucky/universe roguenarok 1.0.1-3 (tar) [280 kB] 192s Get:3 http://ftpmaster.internal/ubuntu plucky/universe roguenarok 1.0.1-3 (diff) [7564 B] 192s gpgv: Signature made Mon Jan 17 13:04:18 2022 UTC 192s gpgv: using RSA key F1F007320A035541F0A663CA578A0494D1C646D1 192s gpgv: issuer "tille@debian.org" 192s gpgv: Can't check signature: No public key 192s dpkg-source: warning: cannot verify inline signature for ./roguenarok_1.0.1-3.dsc: no acceptable signature found 192s autopkgtest [17:00:43]: testing package roguenarok version 1.0.1-3 194s autopkgtest [17:00:45]: build not needed 196s autopkgtest [17:00:47]: test run-unit-test: preparing testbed 198s Reading package lists... 198s Building dependency tree... 198s Reading state information... 199s Starting pkgProblemResolver with broken count: 0 199s Starting 2 pkgProblemResolver with broken count: 0 199s Done 200s The following NEW packages will be installed: 200s roguenarok 200s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 200s Need to get 192 kB of archives. 200s After this operation, 2188 kB of additional disk space will be used. 200s Get:1 http://ftpmaster.internal/ubuntu plucky/universe armhf roguenarok armhf 1.0.1-3 [192 kB] 201s Fetched 192 kB in 1s (352 kB/s) 201s Selecting previously unselected package roguenarok. 201s (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 ... 64655 files and directories currently installed.) 201s Preparing to unpack .../roguenarok_1.0.1-3_armhf.deb ... 201s Unpacking roguenarok (1.0.1-3) ... 201s Setting up roguenarok (1.0.1-3) ... 201s Processing triggers for man-db (2.13.0-1) ... 209s autopkgtest [17:01:00]: test run-unit-test: [----------------------- 211s 211s This is RogueNaRok version 1.0 released by Andre J. Aberer in 2011-10-25. 211s 211s Found a total of 150 taxa in first tree of tree collection 150.bs 211s Expecting all remaining trees in collection to have the same taxon set 211s 211s mode: optimization on consensus tree. Bipartition is part of consensus, if it occurs in more than 500 trees 211s [0.058818] initialisation done (initScore = 0.570381, numBip=4183) 211s [0.000632] sorting bipartition profile 211s [0.019494] computed / updated events 211s [0.000056] combined events 211s [0.000462] calculated per dropset improvement 211s [0.000521] executed the merging events 211s >9 Species172 1.238000 0.578803 211s [0.000412] sorting bipartition profile 211s [0.003761] computed / updated events 211s [0.000044] combined events 211s [0.000302] calculated per dropset improvement 211s [0.000394] executed the merging events 211s >89 Species099 0.801000 0.584252 211s [0.000337] sorting bipartition profile 211s [0.002095] computed / updated events 211s [0.000038] combined events 211s [0.000288] calculated per dropset improvement 211s [0.000463] executed the merging events 211s >16 Species028 0.712000 0.589095 211s [0.000396] sorting bipartition profile 211s [0.001748] computed / updated events 211s [0.000037] combined events 211s [0.000286] calculated per dropset improvement 211s [0.000423] executed the merging events 211s >43 Species077 0.592000 0.593122 211s [0.000467] sorting bipartition profile 211s [0.002857] computed / updated events 211s [0.000037] combined events 211s [0.000258] calculated per dropset improvement 211s [0.000450] executed the merging events 211s >148 Species137 0.539000 0.596789 211s [0.000422] sorting bipartition profile 211s [0.004627] computed / updated events 211s [0.000038] combined events 211s [0.000220] calculated per dropset improvement 211s [0.000353] executed the merging events 211s >22 Species095 0.318000 0.598952 211s [0.000330] sorting bipartition profile 211s [0.001244] computed / updated events 211s [0.000028] combined events 211s [0.000221] calculated per dropset improvement 211s [0.000360] executed the merging events 211s >38 Species106 0.318000 0.601116 211s [0.000355] sorting bipartition profile 211s [0.001811] computed / updated events 211s [0.000032] combined events 211s [0.000199] calculated per dropset improvement 211s [0.000356] executed the merging events 211s >8 Species025 0.292000 0.603102 211s [0.000384] sorting bipartition profile 211s [0.001793] computed / updated events 211s [0.000031] combined events 211s [0.000227] calculated per dropset improvement 211s [0.000333] executed the merging events 211s >23 Species019 0.405000 0.605857 211s [0.000327] sorting bipartition profile 211s [0.001542] computed / updated events 211s [0.000033] combined events 211s [0.000238] calculated per dropset improvement 211s [0.000276] executed the merging events 211s >60 Species121 0.223000 0.607374 211s [0.000313] sorting bipartition profile 211s [0.001114] computed / updated events 211s [0.000028] combined events 211s [0.000208] calculated per dropset improvement 211s [0.000272] executed the merging events 211s >29 Species006 0.196000 0.608707 211s [0.000356] sorting bipartition profile 211s [0.001103] computed / updated events 211s [0.000028] combined events 211s [0.000205] calculated per dropset improvement 211s [0.000258] executed the merging events 211s >5 Species026 0.109000 0.609449 211s [0.000298] sorting bipartition profile 211s [0.000632] computed / updated events 211s [0.000026] combined events 211s [0.000158] calculated per dropset improvement 211s [0.000304] executed the merging events 211s >31 Species154 0.101000 0.610136 211s [0.000360] sorting bipartition profile 211s [0.001125] computed / updated events 211s [0.000034] combined events 211s [0.000181] calculated per dropset improvement 211s [0.000268] executed the merging events 211s >37 Species186 0.088000 0.610735 211s [0.000311] sorting bipartition profile 211s [0.000308] computed / updated events 211s [0.000015] combined events 211s [0.000145] calculated per dropset improvement 211s [0.000323] executed the merging events 211s >57 Species053 0.085000 0.611313 211s [0.000357] sorting bipartition profile 211s [0.001168] computed / updated events 211s [0.000028] combined events 211s [0.000187] calculated per dropset improvement 211s [0.000242] executed the merging events 211s >80 Species086 0.074000 0.611816 211s [0.000296] sorting bipartition profile 211s [0.000626] computed / updated events 211s [0.000025] combined events 211s [0.000161] calculated per dropset improvement 211s [0.000256] executed the merging events 211s >104 Species014 0.068000 0.612279 211s [0.000340] sorting bipartition profile 211s [0.001449] computed / updated events 211s [0.000083] combined events 211s [0.000154] calculated per dropset improvement 211s [0.000227] executed the merging events 211s >65 Species027 0.065000 0.612721 211s [0.000310] sorting bipartition profile 211s [0.000534] computed / updated events 211s [0.000023] combined events 211s [0.000154] calculated per dropset improvement 211s [0.000291] executed the merging events 211s >95 Species120 0.034000 0.612952 211s [0.000373] sorting bipartition profile 211s [0.001593] computed / updated events 211s [0.000034] combined events 211s [0.000153] calculated per dropset improvement 211s [0.000305] executed the merging events 211s >96 Species122 0.034000 0.613184 211s [0.000363] sorting bipartition profile 211s [0.002016] computed / updated events 211s [0.000031] combined events 211s [0.000147] calculated per dropset improvement 211s [0.000200] executed the merging events 211s >83 Species126 0.015000 0.613286 211s [0.000315] sorting bipartition profile 211s [0.000692] computed / updated events 211s [0.000023] combined events 211s [0.000161] calculated per dropset improvement 211s [0.000228] executed the merging events 211s >75 Species070 0.015000 0.613388 211s [0.000311] sorting bipartition profile 211s [0.000816] computed / updated events 211s [0.000043] combined events 211s [0.000139] calculated per dropset improvement 211s [0.000196] executed the merging events 211s >97 Species191 0.004000 0.613415 211s [0.000315] sorting bipartition profile 211s [0.001431] computed / updated events 211s [0.000027] combined events 211s [0.000124] calculated per dropset improvement 211s [0.000206] executed the merging events 211s >147 Species175 0.002000 0.613429 211s [0.000329] sorting bipartition profile 211s [0.000962] computed / updated events 211s [0.000023] combined events 211s [0.000121] calculated per dropset improvement 211s [0.000192] executed the merging events 211s >100 Species022 0.535000 0.617068 211s [0.000277] sorting bipartition profile 211s [0.000706] computed / updated events 211s [0.000021] combined events 211s [0.000118] calculated per dropset improvement 211s [0.000153] executed the merging events 211s >98 Species132 0.026000 0.617245 211s [0.000282] sorting bipartition profile 211s [0.000491] computed / updated events 211s [0.000019] combined events 211s [0.000114] calculated per dropset improvement 211s [0.000163] executed the merging events 211s >58 Species187 0.001000 0.617252 211s [0.000306] sorting bipartition profile 211s [0.000543] computed / updated events 211s [0.000020] combined events 211s [0.000117] calculated per dropset improvement 211s total time elapsed: 0.141373 211s 211s This is RogueNaRok version 1.0 released by Andre J. Aberer in 2011-10-25. 211s 211s Found a total of 150 taxa in first tree of tree collection 150.bs 211s Expecting all remaining trees in collection to have the same taxon set 211s 211s mode: optimization of support of ML tree bipartitions in the bootstrap tree set. 211s [0.058975] initialisation done (initScore = 0.658408, numBip=4183) 211s [0.000562] sorting bipartition profile 211s [0.020904] computed / updated events 211s [0.000063] combined events 211s [0.000663] calculated per dropset improvement 211s [0.000608] executed the merging events 211s >43 Species077 0.337000 0.660701 211s [0.000431] sorting bipartition profile 211s [0.003586] computed / updated events 211s [0.000053] combined events 211s [0.000431] calculated per dropset improvement 211s [0.000499] executed the merging events 211s >9 Species172 0.264000 0.662497 211s [0.000414] sorting bipartition profile 211s [0.003599] computed / updated events 211s [0.000055] combined events 211s [0.000417] calculated per dropset improvement 211s [0.000474] executed the merging events 211s >23 Species019 0.238000 0.664116 211s [0.000382] sorting bipartition profile 211s [0.002841] computed / updated events 211s [0.000040] combined events 211s [0.000408] calculated per dropset improvement 211s [0.000514] executed the merging events 211s >148 Species137 0.237000 0.665728 211s [0.000407] sorting bipartition profile 211s [0.004722] computed / updated events 211s [0.000045] combined events 211s [0.000394] calculated per dropset improvement 211s [0.000471] executed the merging events 211s >147 Species175 0.204000 0.667116 211s [0.000419] sorting bipartition profile 211s [0.003733] computed / updated events 211s [0.000040] combined events 211s [0.000373] calculated per dropset improvement 211s [0.000380] executed the merging events 211s >27 Species042 0.181000 0.668347 211s [0.000322] sorting bipartition profile 211s [0.001761] computed / updated events 211s [0.000030] combined events 211s [0.000307] calculated per dropset improvement 211s [0.000422] executed the merging events 211s >16 Species028 0.107000 0.669075 211s [0.000366] sorting bipartition profile 211s [0.001380] computed / updated events 211s [0.000031] combined events 211s [0.000319] calculated per dropset improvement 211s total time elapsed: 0.111899 211s RogueNaRok_droppedRogues.id1: OK 211s RogueNaRok_droppedRogues.id2: OK 212s autopkgtest [17:01:03]: test run-unit-test: -----------------------] 215s run-unit-test PASS 215s autopkgtest [17:01:06]: test run-unit-test: - - - - - - - - - - results - - - - - - - - - - 219s autopkgtest [17:01:10]: @@@@@@@@@@@@@@@@@@@@ summary 219s run-unit-test PASS