0s autopkgtest [13:50:16]: starting date and time: 2025-05-02 13:50:16+0000 0s autopkgtest [13:50:16]: git checkout: 9986aa8c Merge branch 'skia/fix_network_interface' into 'ubuntu/production' 0s autopkgtest [13:50:16]: host juju-7f2275-prod-proposed-migration-environment-21; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.ewuow67g/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:pytest --apt-upgrade python-sql --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=pytest/8.3.5-2 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-21@bos03-s390x-18.secgroup --name adt-questing-s390x-python-sql-20250502-135016-juju-7f2275-prod-proposed-migration-environment-21-72449e1e-302a-490d-9697-06bce9eeeea8 --image adt/ubuntu-questing-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-21 --net-id=net_prod-proposed-migration-s390x -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 109s autopkgtest [13:52:05]: testbed dpkg architecture: s390x 110s autopkgtest [13:52:06]: testbed apt version: 3.0.0 110s autopkgtest [13:52:06]: @@@@@@@@@@@@@@@@@@@@ test bed setup 110s autopkgtest [13:52:06]: testbed release detected to be: None 111s autopkgtest [13:52:07]: updating testbed package index (apt update) 111s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [110 kB] 111s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease 111s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease 111s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease 111s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [44.4 kB] 111s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [171 kB] 112s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [2029 kB] 112s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main s390x Packages [207 kB] 112s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/universe s390x Packages [1182 kB] 112s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/multiverse s390x Packages [9148 B] 112s Fetched 3752 kB in 1s (3171 kB/s) 113s Reading package lists... 113s autopkgtest [13:52:09]: upgrading testbed (apt dist-upgrade and autopurge) 113s Reading package lists... 113s Building dependency tree... 113s Reading state information... 114s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 114s Starting 2 pkgProblemResolver with broken count: 0 114s Done 114s Entering ResolveByKeep 114s 114s Calculating upgrade... 114s The following packages will be upgraded: 114s htop libnpth0t64 nano usb.ids 114s 4 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 114s Need to get 720 kB of archives. 114s After this operation, 3072 B of additional disk space will be used. 114s Get:1 http://ftpmaster.internal/ubuntu questing/main s390x libnpth0t64 s390x 1.8-3 [8778 B] 114s Get:2 http://ftpmaster.internal/ubuntu questing/main s390x nano s390x 8.4-1 [299 kB] 115s Get:3 http://ftpmaster.internal/ubuntu questing/main s390x usb.ids all 2025.04.01-1 [223 kB] 115s Get:4 http://ftpmaster.internal/ubuntu questing/main s390x htop s390x 3.4.1-4 [189 kB] 115s Fetched 720 kB in 1s (1271 kB/s) 115s (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 ... 81472 files and directories currently installed.) 115s Preparing to unpack .../libnpth0t64_1.8-3_s390x.deb ... 115s Unpacking libnpth0t64:s390x (1.8-3) over (1.8-2) ... 115s Setting up libnpth0t64:s390x (1.8-3) ... 115s (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 ... 81472 files and directories currently installed.) 115s Preparing to unpack .../archives/nano_8.4-1_s390x.deb ... 115s Unpacking nano (8.4-1) over (8.3-1) ... 115s Preparing to unpack .../usb.ids_2025.04.01-1_all.deb ... 115s Unpacking usb.ids (2025.04.01-1) over (2025.01.14-1) ... 115s Preparing to unpack .../htop_3.4.1-4_s390x.deb ... 115s Unpacking htop (3.4.1-4) over (3.4.0-2) ... 115s Setting up htop (3.4.1-4) ... 115s Setting up usb.ids (2025.04.01-1) ... 115s Setting up nano (8.4-1) ... 115s Installing new version of config file /etc/nanorc ... 115s Processing triggers for libc-bin (2.41-6ubuntu1) ... 115s Processing triggers for man-db (2.13.0-1) ... 116s Processing triggers for install-info (7.1.1-1) ... 116s Reading package lists... 116s Building dependency tree... 116s Reading state information... 116s Starting pkgProblemResolver with broken count: 0 117s Starting 2 pkgProblemResolver with broken count: 0 117s Done 117s Solving dependencies... 117s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 119s autopkgtest [13:52:15]: testbed running kernel: Linux 6.14.0-15-generic #15-Ubuntu SMP Sun Apr 6 13:39:00 UTC 2025 119s autopkgtest [13:52:15]: @@@@@@@@@@@@@@@@@@@@ apt-source python-sql 121s Get:1 http://ftpmaster.internal/ubuntu questing/universe python-sql 1.5.2-1 (dsc) [2061 B] 121s Get:2 http://ftpmaster.internal/ubuntu questing/universe python-sql 1.5.2-1 (tar) [39.2 kB] 121s Get:3 http://ftpmaster.internal/ubuntu questing/universe python-sql 1.5.2-1 (diff) [4404 B] 121s gpgv: Signature made Wed Oct 9 10:16:38 2024 UTC 121s gpgv: using RSA key AC297E5C46B9D0B61C717681D6D09BE48405BBF6 121s gpgv: Can't check signature: No public key 121s dpkg-source: warning: cannot verify inline signature for ./python-sql_1.5.2-1.dsc: no acceptable signature found 121s autopkgtest [13:52:17]: testing package python-sql version 1.5.2-1 121s autopkgtest [13:52:17]: build not needed 121s autopkgtest [13:52:17]: test command1: preparing testbed 122s Reading package lists... 122s Building dependency tree... 122s Reading state information... 122s Starting pkgProblemResolver with broken count: 0 122s Starting 2 pkgProblemResolver with broken count: 0 122s Done 122s The following NEW packages will be installed: 122s python3-sql 122s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 122s Need to get 32.9 kB of archives. 122s After this operation, 245 kB of additional disk space will be used. 122s Get:1 http://ftpmaster.internal/ubuntu questing/universe s390x python3-sql all 1.5.2-1 [32.9 kB] 123s Fetched 32.9 kB in 0s (149 kB/s) 123s Selecting previously unselected package python3-sql. 123s (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 ... 81472 files and directories currently installed.) 123s Preparing to unpack .../python3-sql_1.5.2-1_all.deb ... 123s Unpacking python3-sql (1.5.2-1) ... 123s Setting up python3-sql (1.5.2-1) ... 124s autopkgtest [13:52:20]: test command1: cd "$AUTOPKGTEST_TMP" ; python3 -c "import sql ; print(sql.__version__)" 124s autopkgtest [13:52:20]: test command1: [----------------------- 124s 1.5.2 124s autopkgtest [13:52:20]: test command1: -----------------------] 125s autopkgtest [13:52:21]: test command1: - - - - - - - - - - results - - - - - - - - - - 125s command1 PASS 125s autopkgtest [13:52:21]: test run-testsuite3: preparing testbed 125s Reading package lists... 125s Building dependency tree... 125s Reading state information... 125s Starting pkgProblemResolver with broken count: 0 125s Starting 2 pkgProblemResolver with broken count: 0 125s Done 126s The following NEW packages will be installed: 126s python3-iniconfig python3-packaging python3-pluggy python3-pytest 126s 0 upgraded, 4 newly installed, 0 to remove and 0 not upgraded. 126s Need to get 331 kB of archives. 126s After this operation, 1654 kB of additional disk space will be used. 126s Get:1 http://ftpmaster.internal/ubuntu questing/universe s390x python3-iniconfig all 1.1.1-2 [6024 B] 126s Get:2 http://ftpmaster.internal/ubuntu questing/main s390x python3-packaging all 24.2-1 [51.5 kB] 126s Get:3 http://ftpmaster.internal/ubuntu questing/universe s390x python3-pluggy all 1.5.0-1 [21.0 kB] 126s Get:4 http://ftpmaster.internal/ubuntu questing-proposed/universe s390x python3-pytest all 8.3.5-2 [252 kB] 126s Fetched 331 kB in 0s (672 kB/s) 126s Selecting previously unselected package python3-iniconfig. 126s (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 ... 81518 files and directories currently installed.) 126s Preparing to unpack .../python3-iniconfig_1.1.1-2_all.deb ... 126s Unpacking python3-iniconfig (1.1.1-2) ... 126s Selecting previously unselected package python3-packaging. 126s Preparing to unpack .../python3-packaging_24.2-1_all.deb ... 126s Unpacking python3-packaging (24.2-1) ... 126s Selecting previously unselected package python3-pluggy. 126s Preparing to unpack .../python3-pluggy_1.5.0-1_all.deb ... 126s Unpacking python3-pluggy (1.5.0-1) ... 126s Selecting previously unselected package python3-pytest. 126s Preparing to unpack .../python3-pytest_8.3.5-2_all.deb ... 126s Unpacking python3-pytest (8.3.5-2) ... 126s Setting up python3-iniconfig (1.1.1-2) ... 126s Setting up python3-packaging (24.2-1) ... 127s Setting up python3-pluggy (1.5.0-1) ... 127s Setting up python3-pytest (8.3.5-2) ... 127s Processing triggers for man-db (2.13.0-1) ... 128s autopkgtest [13:52:24]: test run-testsuite3: [----------------------- 128s ============================= test session starts ============================== 128s platform linux -- Python 3.13.3, pytest-8.3.5, pluggy-1.5.0 128s rootdir: /tmp/autopkgtest.qQBfye/autopkgtest_tmp 128s plugins: typeguard-4.4.2 128s collected 279 items 128s 128s test/tests/test_aggregate.py ................ [ 5%] 128s test/tests/test_alias.py .... [ 7%] 128s test/tests/test_as.py ... [ 8%] 129s test/tests/test_cast.py .. [ 8%] 129s test/tests/test_collate.py .. [ 9%] 129s test/tests/test_column.py .. [ 10%] 129s test/tests/test_combining_query.py .... [ 11%] 129s test/tests/test_conditionals.py ........ [ 14%] 129s test/tests/test_delete.py ......... [ 17%] 129s test/tests/test_excluded.py .. [ 18%] 129s test/tests/test_expression.py .. [ 19%] 129s test/tests/test_flavor.py ........ [ 22%] 129s test/tests/test_for.py ... [ 23%] 129s test/tests/test_from.py ... [ 24%] 129s test/tests/test_from_item.py ..... [ 26%] 129s test/tests/test_functions.py ................. [ 32%] 129s test/tests/test_grouping.py . [ 32%] 129s test/tests/test_insert.py ............................... [ 43%] 129s test/tests/test_join.py ......... [ 46%] 129s test/tests/test_lateral.py .. [ 47%] 129s test/tests/test_literal.py .. [ 48%] 129s test/tests/test_merge.py ............... [ 53%] 129s test/tests/test_operators.py ......................................... [ 68%] 129s test/tests/test_order.py ........ [ 71%] 129s test/tests/test_rollup.py . [ 71%] 129s test/tests/test_select.py ............................................ [ 87%] 129s test/tests/test_table.py .... [ 88%] 129s test/tests/test_update.py .......... [ 92%] 129s test/tests/test_values.py .... [ 93%] 129s test/tests/test_window.py ............ [ 98%] 129s test/tests/test_with.py ..... [100%] 129s 129s ============================= 279 passed in 0.21s ============================== 129s autopkgtest [13:52:25]: test run-testsuite3: -----------------------] 129s autopkgtest [13:52:25]: test run-testsuite3: - - - - - - - - - - results - - - - - - - - - - 129s run-testsuite3 PASS 130s autopkgtest [13:52:26]: @@@@@@@@@@@@@@@@@@@@ summary 130s command1 PASS 130s run-testsuite3 PASS 147s nova [W] Using flock in prodstack6-s390x 147s flock: timeout while waiting to get lock 147s Creating nova instance adt-questing-s390x-python-sql-20250502-135016-juju-7f2275-prod-proposed-migration-environment-21-72449e1e-302a-490d-9697-06bce9eeeea8 from image adt/ubuntu-questing-s390x-server-20250502.img (UUID 632ecfca-a19d-4f3a-af48-b7883fa0ccf2)... 147s nova [W] Timed out waiting for cf0c0800-11b6-42a2-bf96-f201a1a54243 to get deleted.