0s autopkgtest [04:54:00]: starting date and time: 2025-02-22 04:54:00+0000 0s autopkgtest [04:54:00]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [04:54:00]: host juju-7f2275-prod-proposed-migration-environment-20; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.ztfy7093/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:glib2.0 --apt-upgrade gnuais --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=glib2.0/2.83.4-1 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-20@bos03-s390x-24.secgroup --name adt-plucky-s390x-gnuais-20250222-045359-juju-7f2275-prod-proposed-migration-environment-20-587a7ba1-d22d-493f-8bae-abfaefba6f7d --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/ 101s autopkgtest [04:55:41]: testbed dpkg architecture: s390x 102s autopkgtest [04:55:42]: testbed apt version: 2.9.30ubuntu1 102s autopkgtest [04:55:42]: @@@@@@@@@@@@@@@@@@@@ test bed setup 102s autopkgtest [04:55:42]: testbed release detected to be: None 103s autopkgtest [04:55:43]: updating testbed package index (apt update) 103s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [110 kB] 103s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 103s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 104s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 104s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [80.1 kB] 104s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [508 kB] 104s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [13.5 kB] 104s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [3120 B] 104s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [123 kB] 104s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted s390x Packages [760 B] 104s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [423 kB] 104s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [2816 B] 104s Fetched 1265 kB in 1s (1479 kB/s) 104s Reading package lists... 105s Reading package lists... 105s Building dependency tree... 105s Reading state information... 105s Calculating upgrade... 105s Calculating upgrade... 105s The following packages were automatically installed and are no longer required: 105s libnsl2 libpython3.12-minimal libpython3.12-stdlib libpython3.12t64 105s linux-headers-6.11.0-8 linux-headers-6.11.0-8-generic 105s linux-modules-6.11.0-8-generic linux-tools-6.11.0-8 105s linux-tools-6.11.0-8-generic 105s Use 'sudo apt autoremove' to remove them. 105s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 105s Reading package lists... 106s Building dependency tree... 106s Reading state information... 106s Solving dependencies... 106s The following packages will be REMOVED: 106s libnsl2* libpython3.12-minimal* libpython3.12-stdlib* libpython3.12t64* 106s linux-headers-6.11.0-8* linux-headers-6.11.0-8-generic* 106s linux-modules-6.11.0-8-generic* linux-tools-6.11.0-8* 106s linux-tools-6.11.0-8-generic* 106s 0 upgraded, 0 newly installed, 9 to remove and 3 not upgraded. 106s After this operation, 167 MB disk space will be freed. 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 ... 81030 files and directories currently installed.) 106s Removing linux-tools-6.11.0-8-generic (6.11.0-8.8) ... 106s Removing linux-tools-6.11.0-8 (6.11.0-8.8) ... 106s Removing libpython3.12t64:s390x (3.12.9-1) ... 106s Removing libpython3.12-stdlib:s390x (3.12.9-1) ... 106s Removing libnsl2:s390x (1.3.0-3build3) ... 106s Removing libpython3.12-minimal:s390x (3.12.9-1) ... 106s Removing linux-headers-6.11.0-8-generic (6.11.0-8.8) ... 106s Removing linux-headers-6.11.0-8 (6.11.0-8.8) ... 107s Removing linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 107s Processing triggers for libc-bin (2.40-4ubuntu1) ... 107s (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 ... 55930 files and directories currently installed.) 107s Purging configuration files for libpython3.12-minimal:s390x (3.12.9-1) ... 107s Purging configuration files for linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 107s autopkgtest [04:55:47]: upgrading testbed (apt dist-upgrade and autopurge) 107s Reading package lists... 108s Building dependency tree... 108s Reading state information... 108s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 108s Starting 2 pkgProblemResolver with broken count: 0 108s Done 108s Entering ResolveByKeep 108s 108s Calculating upgrade... 108s The following packages will be upgraded: 108s gir1.2-glib-2.0 libglib2.0-0t64 libglib2.0-data 108s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 108s Need to get 1819 kB of archives. 108s After this operation, 1024 B disk space will be freed. 108s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x gir1.2-glib-2.0 s390x 2.83.4-1 [182 kB] 109s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libglib2.0-0t64 s390x 2.83.4-1 [1584 kB] 109s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libglib2.0-data all 2.83.4-1 [52.9 kB] 109s Fetched 1819 kB in 1s (2863 kB/s) 109s (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 ... 55928 files and directories currently installed.) 109s Preparing to unpack .../gir1.2-glib-2.0_2.83.4-1_s390x.deb ... 109s Unpacking gir1.2-glib-2.0:s390x (2.83.4-1) over (2.83.3-2) ... 109s Preparing to unpack .../libglib2.0-0t64_2.83.4-1_s390x.deb ... 109s Unpacking libglib2.0-0t64:s390x (2.83.4-1) over (2.83.3-2) ... 109s Preparing to unpack .../libglib2.0-data_2.83.4-1_all.deb ... 109s Unpacking libglib2.0-data (2.83.4-1) over (2.83.3-2) ... 109s Setting up libglib2.0-0t64:s390x (2.83.4-1) ... 109s No schema files found: doing nothing. 109s Setting up libglib2.0-data (2.83.4-1) ... 109s Setting up gir1.2-glib-2.0:s390x (2.83.4-1) ... 109s Processing triggers for libc-bin (2.40-4ubuntu1) ... 110s Reading package lists... 110s Building dependency tree... 110s Reading state information... 110s Starting pkgProblemResolver with broken count: 0 110s Starting 2 pkgProblemResolver with broken count: 0 110s Done 110s Solving dependencies... 110s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 110s autopkgtest [04:55:50]: rebooting testbed after setup commands that affected boot 133s autopkgtest [04:56:13]: testbed running kernel: Linux 6.12.0-15-generic #15-Ubuntu SMP Tue Feb 4 15:05:57 UTC 2025 135s autopkgtest [04:56:15]: @@@@@@@@@@@@@@@@@@@@ apt-source gnuais 137s Get:1 http://ftpmaster.internal/ubuntu plucky/universe gnuais 0.3.3-9.1build1 (dsc) [2064 B] 137s Get:2 http://ftpmaster.internal/ubuntu plucky/universe gnuais 0.3.3-9.1build1 (tar) [65.3 kB] 137s Get:3 http://ftpmaster.internal/ubuntu plucky/universe gnuais 0.3.3-9.1build1 (diff) [9460 B] 137s gpgv: Signature made Thu Feb 6 14:05:32 2025 UTC 137s gpgv: using RSA key 63EEFC3DE14D5146CE7F24BF34B8AD7D9529E793 137s gpgv: issuer "lena.voytek@canonical.com" 137s gpgv: Can't check signature: No public key 137s dpkg-source: warning: cannot verify inline signature for ./gnuais_0.3.3-9.1build1.dsc: no acceptable signature found 137s autopkgtest [04:56:17]: testing package gnuais version 0.3.3-9.1build1 137s autopkgtest [04:56:17]: build not needed 138s autopkgtest [04:56:18]: test from-file: preparing testbed 138s Reading package lists... 138s Building dependency tree... 138s Reading state information... 138s Starting pkgProblemResolver with broken count: 0 138s Starting 2 pkgProblemResolver with broken count: 0 138s Done 138s The following NEW packages will be installed: 138s gnuais libasound2-data libasound2t64 libasyncns0 libflac12t64 libmp3lame0 138s libmpg123-0t64 libmysqlclient24 libogg0 libopus0 libpulse0 libsndfile1 138s libvorbis0a libvorbisenc2 libx11-xcb1 mysql-common 139s 0 upgraded, 16 newly installed, 0 to remove and 0 not upgraded. 139s Need to get 5999 kB of archives. 139s After this operation, 16.1 MB of additional disk space will be used. 139s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x libasound2-data all 1.2.13-1build1 [21.1 kB] 139s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x libasound2t64 s390x 1.2.13-1build1 [411 kB] 139s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x mysql-common all 5.8+1.1.1 [6800 B] 139s Get:4 http://ftpmaster.internal/ubuntu plucky/main s390x libmysqlclient24 s390x 8.4.4-0ubuntu1 [1295 kB] 139s Get:5 http://ftpmaster.internal/ubuntu plucky/main s390x libasyncns0 s390x 0.8-6build4 [11.4 kB] 139s Get:6 http://ftpmaster.internal/ubuntu plucky/main s390x libogg0 s390x 1.3.5-3build1 [24.4 kB] 139s Get:7 http://ftpmaster.internal/ubuntu plucky/main s390x libflac12t64 s390x 1.4.3+ds-4 [161 kB] 139s Get:8 http://ftpmaster.internal/ubuntu plucky/main s390x libmp3lame0 s390x 3.100-6build1 [160 kB] 139s Get:9 http://ftpmaster.internal/ubuntu plucky/main s390x libmpg123-0t64 s390x 1.32.10-1 [179 kB] 139s Get:10 http://ftpmaster.internal/ubuntu plucky/main s390x libopus0 s390x 1.5.2-2 [2928 kB] 139s Get:11 http://ftpmaster.internal/ubuntu plucky/main s390x libvorbis0a s390x 1.3.7-2 [112 kB] 139s Get:12 http://ftpmaster.internal/ubuntu plucky/main s390x libvorbisenc2 s390x 1.3.7-2 [80.6 kB] 139s Get:13 http://ftpmaster.internal/ubuntu plucky/main s390x libsndfile1 s390x 1.2.2-2 [238 kB] 139s Get:14 http://ftpmaster.internal/ubuntu plucky/main s390x libx11-xcb1 s390x 2:1.8.10-2 [7954 B] 139s Get:15 http://ftpmaster.internal/ubuntu plucky/main s390x libpulse0 s390x 1:17.0+dfsg1-2ubuntu1 [312 kB] 139s Get:16 http://ftpmaster.internal/ubuntu plucky/universe s390x gnuais s390x 0.3.3-9.1build1 [50.0 kB] 139s Fetched 5999 kB in 1s (7684 kB/s) 140s Selecting previously unselected package libasound2-data. 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 ... 55928 files and directories currently installed.) 140s Preparing to unpack .../00-libasound2-data_1.2.13-1build1_all.deb ... 140s Unpacking libasound2-data (1.2.13-1build1) ... 140s Selecting previously unselected package libasound2t64:s390x. 140s Preparing to unpack .../01-libasound2t64_1.2.13-1build1_s390x.deb ... 140s Unpacking libasound2t64:s390x (1.2.13-1build1) ... 140s Selecting previously unselected package mysql-common. 140s Preparing to unpack .../02-mysql-common_5.8+1.1.1_all.deb ... 140s Unpacking mysql-common (5.8+1.1.1) ... 140s Selecting previously unselected package libmysqlclient24:s390x. 140s Preparing to unpack .../03-libmysqlclient24_8.4.4-0ubuntu1_s390x.deb ... 140s Unpacking libmysqlclient24:s390x (8.4.4-0ubuntu1) ... 140s Selecting previously unselected package libasyncns0:s390x. 140s Preparing to unpack .../04-libasyncns0_0.8-6build4_s390x.deb ... 140s Unpacking libasyncns0:s390x (0.8-6build4) ... 140s Selecting previously unselected package libogg0:s390x. 140s Preparing to unpack .../05-libogg0_1.3.5-3build1_s390x.deb ... 140s Unpacking libogg0:s390x (1.3.5-3build1) ... 140s Selecting previously unselected package libflac12t64:s390x. 140s Preparing to unpack .../06-libflac12t64_1.4.3+ds-4_s390x.deb ... 140s Unpacking libflac12t64:s390x (1.4.3+ds-4) ... 140s Selecting previously unselected package libmp3lame0:s390x. 140s Preparing to unpack .../07-libmp3lame0_3.100-6build1_s390x.deb ... 140s Unpacking libmp3lame0:s390x (3.100-6build1) ... 140s Selecting previously unselected package libmpg123-0t64:s390x. 140s Preparing to unpack .../08-libmpg123-0t64_1.32.10-1_s390x.deb ... 140s Unpacking libmpg123-0t64:s390x (1.32.10-1) ... 140s Selecting previously unselected package libopus0:s390x. 140s Preparing to unpack .../09-libopus0_1.5.2-2_s390x.deb ... 140s Unpacking libopus0:s390x (1.5.2-2) ... 140s Selecting previously unselected package libvorbis0a:s390x. 140s Preparing to unpack .../10-libvorbis0a_1.3.7-2_s390x.deb ... 140s Unpacking libvorbis0a:s390x (1.3.7-2) ... 140s Selecting previously unselected package libvorbisenc2:s390x. 140s Preparing to unpack .../11-libvorbisenc2_1.3.7-2_s390x.deb ... 140s Unpacking libvorbisenc2:s390x (1.3.7-2) ... 140s Selecting previously unselected package libsndfile1:s390x. 140s Preparing to unpack .../12-libsndfile1_1.2.2-2_s390x.deb ... 140s Unpacking libsndfile1:s390x (1.2.2-2) ... 140s Selecting previously unselected package libx11-xcb1:s390x. 140s Preparing to unpack .../13-libx11-xcb1_2%3a1.8.10-2_s390x.deb ... 140s Unpacking libx11-xcb1:s390x (2:1.8.10-2) ... 140s Selecting previously unselected package libpulse0:s390x. 140s Preparing to unpack .../14-libpulse0_1%3a17.0+dfsg1-2ubuntu1_s390x.deb ... 140s Unpacking libpulse0:s390x (1:17.0+dfsg1-2ubuntu1) ... 140s Selecting previously unselected package gnuais. 140s Preparing to unpack .../15-gnuais_0.3.3-9.1build1_s390x.deb ... 140s Unpacking gnuais (0.3.3-9.1build1) ... 140s Setting up libx11-xcb1:s390x (2:1.8.10-2) ... 140s Setting up mysql-common (5.8+1.1.1) ... 140s update-alternatives: using /etc/mysql/my.cnf.fallback to provide /etc/mysql/my.cnf (my.cnf) in auto mode 140s Setting up libogg0:s390x (1.3.5-3build1) ... 140s Setting up libmpg123-0t64:s390x (1.32.10-1) ... 140s Setting up libmysqlclient24:s390x (8.4.4-0ubuntu1) ... 140s Setting up libasound2-data (1.2.13-1build1) ... 140s Setting up libasound2t64:s390x (1.2.13-1build1) ... 140s Setting up libopus0:s390x (1.5.2-2) ... 140s Setting up libvorbis0a:s390x (1.3.7-2) ... 140s Setting up libasyncns0:s390x (0.8-6build4) ... 140s Setting up libflac12t64:s390x (1.4.3+ds-4) ... 140s Setting up libmp3lame0:s390x (3.100-6build1) ... 140s Setting up libvorbisenc2:s390x (1.3.7-2) ... 140s Setting up libsndfile1:s390x (1.2.2-2) ... 140s Setting up libpulse0:s390x (1:17.0+dfsg1-2ubuntu1) ... 140s Setting up gnuais (0.3.3-9.1build1) ... 140s Processing triggers for man-db (2.13.0-1) ... 140s Processing triggers for libc-bin (2.40-4ubuntu1) ... 141s autopkgtest [04:56:21]: test from-file: [----------------------- 141s 2025/02/22 04:57:47.381585 gnuais[1523:4396426856128] NOTICE: Starting up... 141s 2025/02/22 04:57:47.381655 gnuais[1523:4396426856128] INFO: Creating directory: ~/.config/gnuais/ 141s 2025/02/22 04:57:47.381681 gnuais[1523:4396426856128] NOTICE: Using gnuais.conf-example as a starting point for ~/.config/gnuais/config... 141s 2025/02/22 04:57:47.381702 gnuais[1523:4396426856128] NOTICE: DONE creating configuration file (~/.config/gnuais/config). You should edit this file manually! 141s 2025/02/22 04:57:47.381787 gnuais[1523:4396426856128] NOTICE: Reading audio from file: /bin/ls 141s 2025/02/22 04:57:47.381791 gnuais[1523:4396426856128] NOTICE: Started 141s 2025/02/22 04:57:47.381795 gnuais[1523:4396364069056] NOTICE: Listening for connections from gnuais GUI 141s 2025/02/22 04:57:47.381862 gnuais[1523:4396426856128] NOTICE: Level on ch A too high: 99 % 141s 2025/02/22 04:57:47.381923 gnuais[1523:4396426856128] NOTICE: Level on ch B too high: 100 % 141s 2025/02/22 04:57:47.385995 gnuais[1523:4396426856128] NOTICE: Closing down... 141s 2025/02/22 04:57:47.386014 gnuais[1523:4396364069056] NOTICE: Stopped listening for connections from gnuais GUI 141s 2025/02/22 04:57:47.386041 gnuais[1523:4396426856128] INFO: A: Received correctly: 0 packets, wrong CRC: 0 packets, wrong size: 0 packets 141s 2025/02/22 04:57:47.386046 gnuais[1523:4396426856128] INFO: B: Received correctly: 0 packets, wrong CRC: 0 packets, wrong size: 0 packets 141s run: OK 142s autopkgtest [04:56:22]: test from-file: -----------------------] 142s from-file PASS 142s autopkgtest [04:56:22]: test from-file: - - - - - - - - - - results - - - - - - - - - - 142s autopkgtest [04:56:22]: @@@@@@@@@@@@@@@@@@@@ summary 142s from-file PASS 147s nova [W] Using flock in prodstack6-s390x 147s flock: timeout while waiting to get lock 147s Creating nova instance adt-plucky-s390x-gnuais-20250222-045359-juju-7f2275-prod-proposed-migration-environment-20-587a7ba1-d22d-493f-8bae-abfaefba6f7d from image adt/ubuntu-plucky-s390x-server-20250222.img (UUID ae633cda-0dee-481c-9805-d0ef3f3b5166)... 147s nova [W] Timed out waiting for 8e7dbdfc-60c9-4b7b-843a-f5f88ba5c9f7 to get deleted.