0s autopkgtest [16:21:11]: starting date and time: 2025-03-15 16:21:11+0000 0s autopkgtest [16:21:11]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [16:21:11]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.6ivqqbg4/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:glibc --apt-upgrade opus-tools --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-1.secgroup --name adt-plucky-s390x-opus-tools-20250315-162110-juju-7f2275-prod-proposed-migration-environment-2-9287e1ab-07c7-4957-94f4-16aeb28b6f3e --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/ 132s autopkgtest [16:23:23]: testbed dpkg architecture: s390x 132s autopkgtest [16:23:23]: testbed apt version: 2.9.33 132s autopkgtest [16:23:23]: @@@@@@@@@@@@@@@@@@@@ test bed setup 132s autopkgtest [16:23:23]: testbed release detected to be: None 133s autopkgtest [16:23:24]: updating testbed package index (apt update) 134s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [126 kB] 134s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 134s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 134s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 134s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [379 kB] 134s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [99.7 kB] 135s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.8 kB] 135s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [113 kB] 135s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x c-n-f Metadata [1824 B] 135s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted s390x c-n-f Metadata [116 B] 135s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [320 kB] 135s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x c-n-f Metadata [13.4 kB] 135s Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [3776 B] 135s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x c-n-f Metadata [240 B] 135s Fetched 1073 kB in 2s (639 kB/s) 136s Reading package lists... 137s Reading package lists... 137s Building dependency tree... 137s Reading state information... 137s Calculating upgrade... 137s Calculating upgrade... 137s The following packages were automatically installed and are no longer required: 137s libnsl2 libpython3.12-minimal libpython3.12-stdlib libpython3.12t64 137s linux-headers-6.11.0-8 linux-headers-6.11.0-8-generic 137s linux-modules-6.11.0-8-generic linux-tools-6.11.0-8 137s linux-tools-6.11.0-8-generic 137s Use 'sudo apt autoremove' to remove them. 137s The following packages will be upgraded: 137s pinentry-curses python3-jinja2 strace 137s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 137s Need to get 652 kB of archives. 137s After this operation, 27.6 kB of additional disk space will be used. 137s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x strace s390x 6.13+ds-1ubuntu1 [500 kB] 138s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x pinentry-curses s390x 1.3.1-2ubuntu3 [42.9 kB] 138s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x python3-jinja2 all 3.1.5-2ubuntu1 [109 kB] 138s Fetched 652 kB in 1s (616 kB/s) 138s (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.) 138s Preparing to unpack .../strace_6.13+ds-1ubuntu1_s390x.deb ... 138s Unpacking strace (6.13+ds-1ubuntu1) over (6.11-0ubuntu1) ... 138s Preparing to unpack .../pinentry-curses_1.3.1-2ubuntu3_s390x.deb ... 138s Unpacking pinentry-curses (1.3.1-2ubuntu3) over (1.3.1-2ubuntu2) ... 138s Preparing to unpack .../python3-jinja2_3.1.5-2ubuntu1_all.deb ... 138s Unpacking python3-jinja2 (3.1.5-2ubuntu1) over (3.1.5-2) ... 138s Setting up pinentry-curses (1.3.1-2ubuntu3) ... 138s Setting up python3-jinja2 (3.1.5-2ubuntu1) ... 139s Setting up strace (6.13+ds-1ubuntu1) ... 139s Processing triggers for man-db (2.13.0-1) ... 139s Reading package lists... 139s Building dependency tree... 139s Reading state information... 139s Solving dependencies... 139s The following packages will be REMOVED: 139s libnsl2* libpython3.12-minimal* libpython3.12-stdlib* libpython3.12t64* 139s linux-headers-6.11.0-8* linux-headers-6.11.0-8-generic* 139s linux-modules-6.11.0-8-generic* linux-tools-6.11.0-8* 139s linux-tools-6.11.0-8-generic* 140s 0 upgraded, 0 newly installed, 9 to remove and 5 not upgraded. 140s After this operation, 167 MB disk space will be freed. 140s (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.) 140s Removing linux-tools-6.11.0-8-generic (6.11.0-8.8) ... 140s Removing linux-tools-6.11.0-8 (6.11.0-8.8) ... 140s Removing libpython3.12t64:s390x (3.12.9-1) ... 140s Removing libpython3.12-stdlib:s390x (3.12.9-1) ... 140s Removing libnsl2:s390x (1.3.0-3build3) ... 140s Removing libpython3.12-minimal:s390x (3.12.9-1) ... 140s Removing linux-headers-6.11.0-8-generic (6.11.0-8.8) ... 140s Removing linux-headers-6.11.0-8 (6.11.0-8.8) ... 141s Removing linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 141s Processing triggers for libc-bin (2.41-1ubuntu1) ... 141s (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.) 141s Purging configuration files for libpython3.12-minimal:s390x (3.12.9-1) ... 141s Purging configuration files for linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 141s autopkgtest [16:23:32]: upgrading testbed (apt dist-upgrade and autopurge) 141s Reading package lists... 141s Building dependency tree... 141s Reading state information... 141s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 141s Starting 2 pkgProblemResolver with broken count: 0 141s Done 142s Entering ResolveByKeep 142s 142s Calculating upgrade... 142s The following packages will be upgraded: 142s libc-bin libc-dev-bin libc6 libc6-dev locales 142s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 142s Need to get 9512 kB of archives. 142s After this operation, 8192 B of additional disk space will be used. 142s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc6-dev s390x 2.41-1ubuntu2 [1678 kB] 144s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc-dev-bin s390x 2.41-1ubuntu2 [24.3 kB] 144s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc6 s390x 2.41-1ubuntu2 [2892 kB] 147s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc-bin s390x 2.41-1ubuntu2 [671 kB] 148s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x locales all 2.41-1ubuntu2 [4246 kB] 153s Preconfiguring packages ... 153s Fetched 9512 kB in 11s (887 kB/s) 153s (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.) 153s Preparing to unpack .../libc6-dev_2.41-1ubuntu2_s390x.deb ... 153s Unpacking libc6-dev:s390x (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 153s Preparing to unpack .../libc-dev-bin_2.41-1ubuntu2_s390x.deb ... 153s Unpacking libc-dev-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 153s Preparing to unpack .../libc6_2.41-1ubuntu2_s390x.deb ... 153s Unpacking libc6:s390x (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 153s Setting up libc6:s390x (2.41-1ubuntu2) ... 153s (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.) 153s Preparing to unpack .../libc-bin_2.41-1ubuntu2_s390x.deb ... 153s Unpacking libc-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 153s Setting up libc-bin (2.41-1ubuntu2) ... 153s (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.) 153s Preparing to unpack .../locales_2.41-1ubuntu2_all.deb ... 153s Unpacking locales (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 154s Setting up locales (2.41-1ubuntu2) ... 154s Generating locales (this might take a while)... 155s en_US.UTF-8... done 155s Generation complete. 155s Setting up libc-dev-bin (2.41-1ubuntu2) ... 155s Setting up libc6-dev:s390x (2.41-1ubuntu2) ... 155s Processing triggers for man-db (2.13.0-1) ... 156s Processing triggers for systemd (257.3-1ubuntu3) ... 157s Reading package lists... 157s Building dependency tree... 157s Reading state information... 157s Starting pkgProblemResolver with broken count: 0 157s Starting 2 pkgProblemResolver with broken count: 0 157s Done 157s Solving dependencies... 157s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 157s autopkgtest [16:23:48]: rebooting testbed after setup commands that affected boot 177s autopkgtest [16:24:08]: testbed running kernel: Linux 6.14.0-10-generic #10-Ubuntu SMP Wed Mar 12 14:53:49 UTC 2025 180s autopkgtest [16:24:11]: @@@@@@@@@@@@@@@@@@@@ apt-source opus-tools 182s Get:1 http://ftpmaster.internal/ubuntu plucky/universe opus-tools 0.2-1build4 (dsc) [2250 B] 182s Get:2 http://ftpmaster.internal/ubuntu plucky/universe opus-tools 0.2-1build4 (tar) [458 kB] 182s Get:3 http://ftpmaster.internal/ubuntu plucky/universe opus-tools 0.2-1build4 (diff) [5780 B] 182s gpgv: Signature made Sat Mar 15 03:38:46 2025 UTC 182s gpgv: using RSA key 5C7ABEA20F8630459CC8C8B5E27F2CF8458C2FA4 182s gpgv: Can't check signature: No public key 182s dpkg-source: warning: cannot verify inline signature for ./opus-tools_0.2-1build4.dsc: no acceptable signature found 182s autopkgtest [16:24:13]: testing package opus-tools version 0.2-1build4 183s autopkgtest [16:24:14]: build not needed 185s autopkgtest [16:24:16]: test enc-dec: preparing testbed 185s Reading package lists... 185s Building dependency tree... 185s Reading state information... 186s Starting pkgProblemResolver with broken count: 0 186s Starting 2 pkgProblemResolver with broken count: 0 186s Done 186s The following NEW packages will be installed: 186s libflac14 libogg0 libopus0 libopusenc0 libopusfile0 opus-tools puredata-doc 186s 0 upgraded, 7 newly installed, 0 to remove and 0 not upgraded. 186s Need to get 8257 kB of archives. 186s After this operation, 11.0 MB of additional disk space will be used. 186s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x libogg0 s390x 1.3.5-3build1 [24.4 kB] 186s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x libflac14 s390x 1.5.0+ds-2 [172 kB] 186s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x libopus0 s390x 1.5.2-2 [2928 kB] 190s Get:4 http://ftpmaster.internal/ubuntu plucky/universe s390x libopusenc0 s390x 0.2.1-2build1 [29.0 kB] 190s Get:5 http://ftpmaster.internal/ubuntu plucky/universe s390x libopusfile0 s390x 0.12-4build3 [48.0 kB] 190s Get:6 http://ftpmaster.internal/ubuntu plucky/universe s390x opus-tools s390x 0.2-1build4 [63.8 kB] 190s Get:7 http://ftpmaster.internal/ubuntu plucky/universe s390x puredata-doc all 0.55.2+ds-1 [4992 kB] 196s Fetched 8257 kB in 10s (814 kB/s) 196s Selecting previously unselected package libogg0:s390x. 196s (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.) 196s Preparing to unpack .../0-libogg0_1.3.5-3build1_s390x.deb ... 196s Unpacking libogg0:s390x (1.3.5-3build1) ... 196s Selecting previously unselected package libflac14:s390x. 196s Preparing to unpack .../1-libflac14_1.5.0+ds-2_s390x.deb ... 196s Unpacking libflac14:s390x (1.5.0+ds-2) ... 196s Selecting previously unselected package libopus0:s390x. 196s Preparing to unpack .../2-libopus0_1.5.2-2_s390x.deb ... 196s Unpacking libopus0:s390x (1.5.2-2) ... 196s Selecting previously unselected package libopusenc0:s390x. 196s Preparing to unpack .../3-libopusenc0_0.2.1-2build1_s390x.deb ... 196s Unpacking libopusenc0:s390x (0.2.1-2build1) ... 196s Selecting previously unselected package libopusfile0:s390x. 196s Preparing to unpack .../4-libopusfile0_0.12-4build3_s390x.deb ... 196s Unpacking libopusfile0:s390x (0.12-4build3) ... 196s Selecting previously unselected package opus-tools. 196s Preparing to unpack .../5-opus-tools_0.2-1build4_s390x.deb ... 196s Unpacking opus-tools (0.2-1build4) ... 196s Selecting previously unselected package puredata-doc. 196s Preparing to unpack .../6-puredata-doc_0.55.2+ds-1_all.deb ... 196s Unpacking puredata-doc (0.55.2+ds-1) ... 196s Setting up libogg0:s390x (1.3.5-3build1) ... 196s Setting up puredata-doc (0.55.2+ds-1) ... 196s Setting up libopus0:s390x (1.5.2-2) ... 196s Setting up libflac14:s390x (1.5.0+ds-2) ... 196s Setting up libopusfile0:s390x (0.12-4build3) ... 196s Setting up libopusenc0:s390x (0.2.1-2build1) ... 196s Setting up opus-tools (0.2-1build4) ... 196s Processing triggers for libc-bin (2.41-1ubuntu2) ... 196s Processing triggers for man-db (2.13.0-1) ... 198s autopkgtest [16:24:29]: test enc-dec: [----------------------- 198s Encoding using libopus 1.5.2 (audio) 198s ----------------------------------------------------- 198s Input: 44.1 kHz, 1 channel 198s Output: 1 channel (1 uncoupled) 198s 20ms packets, 64 kbit/s VBR 198s Preskip: 312 198s 198s [|] 0% 00:00:00.00 0x realtime, 0 kbit/s Encoding complete 198s ----------------------------------------------------- 198s Encoded: 1.42 seconds 198s Runtime: 0 seconds 198s Wrote: 16127 bytes, 71 packets, 4 pages 198s Bitrate: 85.3127 kbit/s (without overhead) 198s Instant rates: 32 to 120.4 kbit/s 198s (80 to 301 bytes per packet) 198s Overhead: 6.1% (container+metadata) 198s 198s Decoding to 44100 Hz (1 channel) 198s Encoded with libopus 1.5.2, libopusenc 0.2.1 198s ENCODER=opusenc from opus-tools 0.2 198s [|] 00:00:00 [|] 00:00:01 Decoding complete. 198s autopkgtest [16:24:29]: test enc-dec: -----------------------] 199s autopkgtest [16:24:30]: test enc-dec: - - - - - - - - - - results - - - - - - - - - - 199s enc-dec PASS 199s autopkgtest [16:24:30]: test enc-info: preparing testbed 199s Reading package lists... 199s Building dependency tree... 199s Reading state information... 200s Starting pkgProblemResolver with broken count: 0 200s Starting 2 pkgProblemResolver with broken count: 0 200s Done 200s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 201s autopkgtest [16:24:32]: test enc-info: [----------------------- 201s ================== encoding /usr/share/puredata/doc/sound/voice.wav =================== 201s Encoding using libopus 1.5.2 (audio) 201s ----------------------------------------------------- 201s Input: 44.1 kHz, 1 channel 201s Output: 1 channel (1 uncoupled) 201s 20ms packets, 64 kbit/s VBR 201s Preskip: 312 201s 201s [|] 0% 00:00:00.00 0x realtime, 0 kbit/s ================= info on test.opus ===================== 201s Processing file "test.opus"... 201s 201s New logical stream (#1, serial: 596dfc05): type opus 201s Encoded with libopus 1.5.2, libopusenc 0.2.1 201s User comments section follows... 201s ENCODER=opusenc from opus-tools 0.2 201s Opus stream 1: 201s Pre-skip: 312 201s Playback gain: 0 dB 201s Channels: 1 201s Original sample rate: 44100 Hz 201s Packet duration: 20.0ms (max), 20.0ms (avg), 20.0ms (min) 201s Page duration: 1000.0ms (max), 710.0ms (avg), 420.0ms (min) 201s Total data length: 16127 bytes (overhead: 6.1%) 201s Playback length: 0m:01.407s 201s Average bitrate: 91.65 kbit/s, w/o overhead: 86.06 kbit/s 201s Logical stream 1 ended 201s Encoding complete 201s ----------------------------------------------------- 201s Encoded: 1.42 seconds 201s Runtime: 0 seconds 201s Wrote: 16127 bytes, 71 packets, 4 pages 201s Bitrate: 85.3127 kbit/s (without overhead) 201s Instant rates: 32 to 120.4 kbit/s 201s (80 to 301 bytes per packet) 201s Overhead: 6.1% (container+metadata) 201s 201s autopkgtest [16:24:32]: test enc-info: -----------------------] 202s enc-info PASS 202s autopkgtest [16:24:33]: test enc-info: - - - - - - - - - - results - - - - - - - - - - 202s autopkgtest [16:24:33]: @@@@@@@@@@@@@@@@@@@@ summary 202s enc-dec PASS 202s enc-info PASS 220s nova [W] Using flock in prodstack6-s390x 220s Creating nova instance adt-plucky-s390x-opus-tools-20250315-162110-juju-7f2275-prod-proposed-migration-environment-2-9287e1ab-07c7-4957-94f4-16aeb28b6f3e from image adt/ubuntu-plucky-s390x-server-20250315.img (UUID 3d3557fa-fd0f-4bba-9b89-8d5964e09f61)... 220s nova [W] Timed out waiting for 16e627cd-86e3-48e6-90af-53fec1a291bb to get deleted.