0s autopkgtest [05:07:13]: starting date and time: 2026-02-05 05:07:13+0000 0s autopkgtest [05:07:13]: git checkout: 4b346b80 nova: make wait_reboot return success even when a no-op 0s autopkgtest [05:07:13]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.r6trubrt/out --timeout-copy=6000 --needs-internet=try --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:glibc,src:chiark-tcl --apt-upgrade poc-streamer --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=glibc/2.42-2ubuntu5 chiark-tcl/1.3.7build1' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-cpu2-ram4-disk20-arm64 --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@sto01-arm64-7.secgroup --name adt-resolute-arm64-poc-streamer-20260205-050713-juju-7f2275-prod-proposed-migration-environment-15-5489ab86-bf8e-47d0-bdff-fcb6d1f1e3f0 --image adt/ubuntu-resolute-arm64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-15 --net-id=net_prod-autopkgtest-workers-arm64 -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 4s Creating nova instance adt-resolute-arm64-poc-streamer-20260205-050713-juju-7f2275-prod-proposed-migration-environment-15-5489ab86-bf8e-47d0-bdff-fcb6d1f1e3f0 from image adt/ubuntu-resolute-arm64-server-20260204.img (UUID f58d981d-b271-4157-b9b1-fd704695563c)... 92s autopkgtest [05:08:45]: testbed dpkg architecture: arm64 92s autopkgtest [05:08:45]: testbed apt version: 3.1.14 93s autopkgtest [05:08:46]: @@@@@@@@@@@@@@@@@@@@ test bed setup 97s autopkgtest [05:08:46]: testbed release detected to be: None 97s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease [124 kB] 97s autopkgtest [05:08:47]: updating testbed package index (apt update) 97s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 97s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 97s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 97s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/universe Sources [1719 kB] 97s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/main Sources [227 kB] 97s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/restricted Sources [5260 B] 97s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse Sources [35.4 kB] 97s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main arm64 Packages [265 kB] 97s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/main arm64 c-n-f Metadata [7328 B] 97s Get:11 http://ftpmaster.internal/ubuntu resolute-proposed/restricted arm64 Packages [52.9 kB] 97s Get:12 http://ftpmaster.internal/ubuntu resolute-proposed/restricted arm64 c-n-f Metadata [328 B] 97s Get:13 http://ftpmaster.internal/ubuntu resolute-proposed/universe arm64 Packages [1481 kB] 97s Get:14 http://ftpmaster.internal/ubuntu resolute-proposed/universe arm64 c-n-f Metadata [40.2 kB] 97s Get:15 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse arm64 Packages [26.0 kB] 97s Get:16 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse arm64 c-n-f Metadata [776 B] 100s Fetched 3984 kB in 2s (1936 kB/s) 101s Reading package lists... 102s Hit:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease 102s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 102s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 102s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 103s Reading package lists... 103s Reading package lists... 103s Building dependency tree... 103s Reading state information... 103s Calculating upgrade... 104s The following packages will be upgraded: 104s libc-bin libc-gconv-modules-extra libc6 locales pollinate python3-linkify-it 104s python3-referencing sed 104s 8 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 104s Need to get 8110 kB of archives. 104s After this operation, 0 B of additional disk space will be used. 104s Get:1 http://ftpmaster.internal/ubuntu resolute/main arm64 sed arm64 4.9-2build3 [193 kB] 104s Get:2 http://ftpmaster.internal/ubuntu resolute-proposed/main arm64 libc-gconv-modules-extra arm64 2.42-2ubuntu5 [1413 kB] 104s Get:3 http://ftpmaster.internal/ubuntu resolute-proposed/main arm64 libc6 arm64 2.42-2ubuntu5 [1594 kB] 104s Get:4 http://ftpmaster.internal/ubuntu resolute-proposed/main arm64 libc-bin arm64 2.42-2ubuntu5 [599 kB] 104s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/main arm64 locales all 2.42-2ubuntu5 [4255 kB] 104s Get:6 http://ftpmaster.internal/ubuntu resolute/main arm64 python3-linkify-it all 2.0.3-1ubuntu3 [19.4 kB] 104s Get:7 http://ftpmaster.internal/ubuntu resolute/main arm64 pollinate all 4.33-4ubuntu5 [14.0 kB] 104s Get:8 http://ftpmaster.internal/ubuntu resolute/main arm64 python3-referencing all 0.36.2-1ubuntu2 [22.2 kB] 105s dpkg-preconfigure: unable to re-open stdin: No such file or directory 105s Fetched 8110 kB in 1s (11.0 MB/s) 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 ... 89360 files and directories currently installed.) 105s Preparing to unpack .../sed_4.9-2build3_arm64.deb ... 105s Unpacking sed (4.9-2build3) over (4.9-2build2) ... 105s Setting up sed (4.9-2build3) ... 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 ... 89360 files and directories currently installed.) 105s Preparing to unpack .../libc-gconv-modules-extra_2.42-2ubuntu5_arm64.deb ... 105s Unpacking libc-gconv-modules-extra:arm64 (2.42-2ubuntu5) over (2.42-2ubuntu4) ... 105s Setting up libc-gconv-modules-extra:arm64 (2.42-2ubuntu5) ... 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 ... 89360 files and directories currently installed.) 105s Preparing to unpack .../libc6_2.42-2ubuntu5_arm64.deb ... 106s Unpacking libc6:arm64 (2.42-2ubuntu5) over (2.42-2ubuntu4) ... 106s Setting up libc6:arm64 (2.42-2ubuntu5) ... 106s (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 ... 89360 files and directories currently installed.) 106s Preparing to unpack .../libc-bin_2.42-2ubuntu5_arm64.deb ... 106s Unpacking libc-bin (2.42-2ubuntu5) over (2.42-2ubuntu4) ... 106s Setting up libc-bin (2.42-2ubuntu5) ... 106s (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 ... 89360 files and directories currently installed.) 106s Preparing to unpack .../locales_2.42-2ubuntu5_all.deb ... 106s Unpacking locales (2.42-2ubuntu5) over (2.42-2ubuntu4) ... 107s Preparing to unpack .../python3-linkify-it_2.0.3-1ubuntu3_all.deb ... 107s Unpacking python3-linkify-it (2.0.3-1ubuntu3) over (2.0.3-1ubuntu2) ... 107s Preparing to unpack .../pollinate_4.33-4ubuntu5_all.deb ... 107s Unpacking pollinate (4.33-4ubuntu5) over (4.33-4ubuntu4) ... 107s Preparing to unpack .../python3-referencing_0.36.2-1ubuntu2_all.deb ... 107s Unpacking python3-referencing (0.36.2-1ubuntu2) over (0.36.2-1ubuntu1) ... 107s Setting up locales (2.42-2ubuntu5) ... 107s Generating locales (this might take a while)... 110s en_US.UTF-8... done 110s Generation complete. 110s Setting up pollinate (4.33-4ubuntu5) ... 120s Setting up python3-linkify-it (2.0.3-1ubuntu3) ... 120s Setting up python3-referencing (0.36.2-1ubuntu2) ... 120s Processing triggers for man-db (2.13.1-1) ... 121s Processing triggers for install-info (7.2-5) ... 122s Processing triggers for systemd (259-1ubuntu3) ... 123s autopkgtest [05:09:16]: upgrading testbed (apt dist-upgrade and autopurge) 123s Reading package lists... 123s Building dependency tree... 123s Reading state information... 123s Calculating upgrade... 124s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 124s Reading package lists... 124s Building dependency tree... 124s Reading state information... 124s Solving dependencies... 125s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 125s autopkgtest [05:09:18]: rebooting testbed after setup commands that affected boot 164s autopkgtest [05:09:57]: testbed running kernel: Linux 6.18.0-9-generic #9-Ubuntu SMP PREEMPT_DYNAMIC Mon Jan 12 16:41:39 UTC 2026 168s autopkgtest [05:10:01]: @@@@@@@@@@@@@@@@@@@@ apt-source poc-streamer 175s Get:1 http://ftpmaster.internal/ubuntu resolute/universe poc-streamer 0.4.2-7build1 (dsc) [1960 B] 175s Get:2 http://ftpmaster.internal/ubuntu resolute/universe poc-streamer 0.4.2-7build1 (tar) [108 kB] 175s Get:3 http://ftpmaster.internal/ubuntu resolute/universe poc-streamer 0.4.2-7build1 (diff) [72.2 kB] 175s gpgv: Signature made Wed Dec 17 21:42:50 2025 UTC 175s gpgv: using RSA key 25E3FF2D7F469DBE7D0D4E50AFCFEC8E669CE1C2 175s gpgv: Can't check signature: No public key 175s dpkg-source: warning: cannot verify inline signature for ./poc-streamer_0.4.2-7build1.dsc: no acceptable signature found 176s autopkgtest [05:10:09]: testing package poc-streamer version 0.4.2-7build1 190s autopkgtest [05:10:23]: build not needed 202s autopkgtest [05:10:35]: test command1: preparing testbed 203s Reading package lists... 203s Building dependency tree... 203s Reading state information... 203s Solving dependencies... 203s The following NEW packages will be installed: 203s libfl2 poc-streamer 204s 0 upgraded, 2 newly installed, 0 to remove and 0 not upgraded. 204s Need to get 94.5 kB of archives. 204s After this operation, 897 kB of additional disk space will be used. 204s Get:1 http://ftpmaster.internal/ubuntu resolute/main arm64 libfl2 arm64 2.6.4-8.2build2 [9826 B] 204s Get:2 http://ftpmaster.internal/ubuntu resolute/universe arm64 poc-streamer arm64 0.4.2-7build1 [84.7 kB] 204s Fetched 94.5 kB in 1s (142 kB/s) 204s Selecting previously unselected package libfl2:arm64. 205s (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 ... 89360 files and directories currently installed.) 205s Preparing to unpack .../libfl2_2.6.4-8.2build2_arm64.deb ... 205s Unpacking libfl2:arm64 (2.6.4-8.2build2) ... 205s Selecting previously unselected package poc-streamer. 205s Preparing to unpack .../poc-streamer_0.4.2-7build1_arm64.deb ... 205s Unpacking poc-streamer (0.4.2-7build1) ... 205s Setting up libfl2:arm64 (2.6.4-8.2build2) ... 205s Setting up poc-streamer (0.4.2-7build1) ... 205s Processing triggers for man-db (2.13.1-1) ... 205s Processing triggers for libc-bin (2.42-2ubuntu5) ... 206s autopkgtest [05:10:39]: test command1: timeout 300 mp3cue 206s autopkgtest [05:10:39]: test command1: [----------------------- 207s Usage: mp3cue -c cuefile mp3file 207s -c cuefile: cut according to cue file 207s autopkgtest [05:10:40]: test command1: -----------------------] 208s command1 PASS (superficial) 208s autopkgtest [05:10:41]: test command1: - - - - - - - - - - results - - - - - - - - - - 208s autopkgtest [05:10:41]: test command2: preparing testbed 208s Reading package lists... 208s Building dependency tree... 208s Reading state information... 208s Solving dependencies... 209s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 212s autopkgtest [05:10:45]: test command2: mp3cut | grep Usage 212s autopkgtest [05:10:45]: test command2: [----------------------- 213s Usage: mp3cut [-o outputfile] [-T title] [-A artist] [-N album-name] [-t [hh:]mm:ss[+ms]-[hh:]mm:ss[+ms]] mp3 [-t ...] mp3 213s autopkgtest [05:10:46]: test command2: -----------------------] 214s command2 PASS (superficial) 214s autopkgtest [05:10:47]: test command2: - - - - - - - - - - results - - - - - - - - - - 215s autopkgtest [05:10:48]: test command3: preparing testbed 215s Reading package lists... 215s Building dependency tree... 215s Reading state information... 216s Solving dependencies... 216s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 217s autopkgtest [05:10:50]: test command3: mp3length 2>&1 | grep Usage 217s autopkgtest [05:10:50]: test command3: [----------------------- 217s Usage: mp3length mp3file 217s autopkgtest [05:10:50]: test command3: -----------------------] 218s autopkgtest [05:10:51]: test command3: - - - - - - - - - - results - - - - - - - - - - 218s command3 PASS (superficial) 219s autopkgtest [05:10:52]: test command4: preparing testbed 220s Reading package lists... 220s Building dependency tree... 220s Reading state information... 220s Solving dependencies... 220s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 223s autopkgtest [05:10:56]: test command4: timeout 3m pob-2250 2>&1 | grep bind 223s autopkgtest [05:10:56]: test command4: [----------------------- 224s bind: Invalid argument 224s autopkgtest [05:10:57]: test command4: -----------------------] 225s autopkgtest [05:10:58]: test command4: - - - - - - - - - - results - - - - - - - - - - 225s command4 PASS (superficial) 226s autopkgtest [05:10:59]: test command5: preparing testbed 226s Reading package lists... 227s Building dependency tree... 227s Reading state information... 227s Solving dependencies... 227s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 229s autopkgtest [05:11:02]: test command5: timeout 3m pob-3119 2>&1 | grep bind 229s autopkgtest [05:11:02]: test command5: [----------------------- 229s bind: Invalid argument 229s autopkgtest [05:11:02]: test command5: -----------------------] 230s command5 PASS (superficial) 230s autopkgtest [05:11:03]: test command5: - - - - - - - - - - results - - - - - - - - - - 230s autopkgtest [05:11:03]: test command6: preparing testbed 231s Reading package lists... 231s Building dependency tree... 231s Reading state information... 231s Solving dependencies... 231s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 232s autopkgtest [05:11:05]: test command6: timeout 3m pob-fec 2>&1 | grep bind 232s autopkgtest [05:11:05]: test command6: [----------------------- 233s bind: Invalid argument 233s autopkgtest [05:11:06]: test command6: -----------------------] 233s autopkgtest [05:11:06]: test command6: - - - - - - - - - - results - - - - - - - - - - 233s command6 PASS (superficial) 234s autopkgtest [05:11:07]: test command7: preparing testbed 234s Reading package lists... 234s Building dependency tree... 234s Reading state information... 234s Solving dependencies... 235s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 236s autopkgtest [05:11:09]: test command7: poc-2250 2>&1 | grep Usage 236s autopkgtest [05:11:09]: test command7: [----------------------- 236s Usage: ./poc [-s address] [-p port] [-q] [-t ttl] files... 236s autopkgtest [05:11:09]: test command7: -----------------------] 237s command7 PASS (superficial) 237s autopkgtest [05:11:10]: test command7: - - - - - - - - - - results - - - - - - - - - - 238s autopkgtest [05:11:11]: test command8: preparing testbed 239s Reading package lists... 239s Building dependency tree... 239s Reading state information... 239s Solving dependencies... 239s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 240s autopkgtest [05:11:13]: test command8: poc-3119 2>&1 | grep Usage 240s autopkgtest [05:11:13]: test command8: [----------------------- 240s Usage: ./poc [-s address] [-p port] [-q] [-t ttl] [-6]files... 241s autopkgtest [05:11:14]: test command8: -----------------------] 243s command8 PASS (superficial) 243s autopkgtest [05:11:16]: test command8: - - - - - - - - - - results - - - - - - - - - - 243s autopkgtest [05:11:16]: test command9: preparing testbed 243s Reading package lists... 244s Building dependency tree... 244s Reading state information... 244s Solving dependencies... 244s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 246s autopkgtest [05:11:19]: test command9: poc-fec 2>&1 | grep Usage 246s autopkgtest [05:11:19]: test command9: [----------------------- 246s Usage: ./poc-fec [-s address] [-p port] [-k fec_k] [-n fec_n] [-q] [-t ttl] [-6] files... 247s autopkgtest [05:11:20]: test command9: -----------------------] 247s command9 PASS (superficial) 247s autopkgtest [05:11:20]: test command9: - - - - - - - - - - results - - - - - - - - - - 247s autopkgtest [05:11:20]: test command10: preparing testbed 248s Reading package lists... 248s Building dependency tree... 248s Reading state information... 248s Solving dependencies... 248s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 249s autopkgtest [05:11:22]: test command10: poc-http 2>&1 | grep Usage 249s autopkgtest [05:11:22]: test command10: [----------------------- 250s Usage: ./poc-http [-s address] [-p port] [-q] [-c clients] [-6] files... 250s autopkgtest [05:11:23]: test command10: -----------------------] 251s autopkgtest [05:11:24]: test command10: - - - - - - - - - - results - - - - - - - - - - 251s command10 PASS (superficial) 251s autopkgtest [05:11:24]: test command11: preparing testbed 251s Reading package lists... 251s Building dependency tree... 251s Reading state information... 251s Solving dependencies... 252s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 253s autopkgtest [05:11:26]: test command11: pogg-http 2>&1 | grep Usage 253s autopkgtest [05:11:26]: test command11: [----------------------- 254s Usage: ./pogg-http [-s address] [-p port] [-q] [-c clients] [-6] files... 254s autopkgtest [05:11:27]: test command11: -----------------------] 255s command11 PASS (superficial) 255s autopkgtest [05:11:28]: test command11: - - - - - - - - - - results - - - - - - - - - - 255s autopkgtest [05:11:28]: test command12: preparing testbed 256s Reading package lists... 256s Building dependency tree... 256s Reading state information... 256s Solving dependencies... 256s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 257s autopkgtest [05:11:30]: test command12: cp debian/tests/debian-ci-eriberto.mp3 $AUTOPKGTEST_TMP; mp3cut -o $AUTOPKGTEST_TMP/final.mp3 -T New_Test -A Eriberto -N My_Album -t 00:00:02-00:00:04 $AUTOPKGTEST_TMP/debian-ci-eriberto.mp3; mp3length $AUTOPKGTEST_TMP/final.mp3 | egrep '00:00:0[12]' || exit 1 257s autopkgtest [05:11:30]: test command12: [----------------------- 257s /tmp/autopkgtest.YbNCHW/autopkgtest_tmp/final.mp3 written 257s Writing to /tmp/autopkgtest.YbNCHW/autopkgtest_tmp/final.mp3 257s Extracting 00:00:02+000-00:00:04+000 from /tmp/autopkgtest.YbNCHW/autopkgtest_tmp/debian-ci-eriberto.mp3 257s Length of /tmp/autopkgtest.YbNCHW/autopkgtest_tmp/final.mp3: 00:00:01+928 258s autopkgtest [05:11:31]: test command12: -----------------------] 258s autopkgtest [05:11:31]: test command12: - - - - - - - - - - results - - - - - - - - - - 258s command12 PASS 258s autopkgtest [05:11:31]: @@@@@@@@@@@@@@@@@@@@ summary 258s command1 PASS (superficial) 258s command2 PASS (superficial) 258s command3 PASS (superficial) 258s command4 PASS (superficial) 258s command5 PASS (superficial) 258s command6 PASS (superficial) 258s command7 PASS (superficial) 258s command8 PASS (superficial) 258s command9 PASS (superficial) 258s command10 PASS (superficial) 258s command11 PASS (superficial) 258s command12 PASS