0s autopkgtest [03:54:45]: starting date and time: 2025-05-02 03:54:45+0000 0s autopkgtest [03:54:45]: git checkout: 9986aa8c Merge branch 'skia/fix_network_interface' into 'ubuntu/production' 0s autopkgtest [03:54:45]: host juju-7f2275-prod-proposed-migration-environment-21; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.fwq0vm7r/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:firebird3.0 --apt-upgrade firebird4.0 --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=firebird3.0/3.0.12.ds7-13 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-21@bos03-s390x-16.secgroup --name adt-questing-s390x-firebird4.0-20250502-035445-juju-7f2275-prod-proposed-migration-environment-21-6b9c6480-6bca-4d1b-848d-e013fe756da6 --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/ 98s autopkgtest [03:56:23]: testbed dpkg architecture: s390x 98s autopkgtest [03:56:23]: testbed apt version: 3.0.0 98s autopkgtest [03:56:23]: @@@@@@@@@@@@@@@@@@@@ test bed setup 99s autopkgtest [03:56:24]: testbed release detected to be: None 99s autopkgtest [03:56:24]: updating testbed package index (apt update) 100s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [110 kB] 100s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease 100s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease 100s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease 100s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [190 kB] 100s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [2281 kB] 100s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [57.4 kB] 100s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main s390x Packages [216 kB] 100s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/universe s390x Packages [1061 kB] 100s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/multiverse s390x Packages [15.9 kB] 101s Fetched 3931 kB in 1s (3105 kB/s) 101s Reading package lists... 102s autopkgtest [03:56:27]: upgrading testbed (apt dist-upgrade and autopurge) 102s Reading package lists... 102s Building dependency tree... 102s Reading state information... 102s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 102s Starting 2 pkgProblemResolver with broken count: 0 102s Done 103s Entering ResolveByKeep 103s 103s Calculating upgrade... 103s The following packages will be upgraded: 103s dpkg dpkg-dev libdpkg-perl 103s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 103s Need to get 2667 kB of archives. 103s After this operation, 1024 B of additional disk space will be used. 103s Get:1 http://ftpmaster.internal/ubuntu questing/main s390x dpkg s390x 1.22.18ubuntu3 [1297 kB] 103s Get:2 http://ftpmaster.internal/ubuntu questing/main s390x dpkg-dev all 1.22.18ubuntu3 [1089 kB] 104s Get:3 http://ftpmaster.internal/ubuntu questing/main s390x libdpkg-perl all 1.22.18ubuntu3 [281 kB] 104s Fetched 2667 kB in 1s (3763 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 ... 81472 files and directories currently installed.) 104s Preparing to unpack .../dpkg_1.22.18ubuntu3_s390x.deb ... 104s Unpacking dpkg (1.22.18ubuntu3) over (1.22.18ubuntu2) ... 104s Setting up dpkg (1.22.18ubuntu3) ... 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 ... 81472 files and directories currently installed.) 104s Preparing to unpack .../dpkg-dev_1.22.18ubuntu3_all.deb ... 104s Unpacking dpkg-dev (1.22.18ubuntu3) over (1.22.18ubuntu2) ... 104s Preparing to unpack .../libdpkg-perl_1.22.18ubuntu3_all.deb ... 104s Unpacking libdpkg-perl (1.22.18ubuntu3) over (1.22.18ubuntu2) ... 104s Setting up libdpkg-perl (1.22.18ubuntu3) ... 104s Setting up dpkg-dev (1.22.18ubuntu3) ... 104s Processing triggers for man-db (2.13.0-1) ... 106s Reading package lists... 106s Building dependency tree... 106s Reading state information... 106s Starting pkgProblemResolver with broken count: 0 106s Starting 2 pkgProblemResolver with broken count: 0 106s Done 106s Solving dependencies... 106s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 107s autopkgtest [03:56:32]: rebooting testbed after setup commands that affected boot 126s autopkgtest [03:56:51]: testbed running kernel: Linux 6.14.0-15-generic #15-Ubuntu SMP Sun Apr 6 13:39:00 UTC 2025 128s autopkgtest [03:56:53]: @@@@@@@@@@@@@@@@@@@@ apt-source firebird4.0 135s Get:1 http://ftpmaster.internal/ubuntu questing/universe firebird4.0 4.0.5.3140.ds6-16 (dsc) [2860 B] 135s Get:2 http://ftpmaster.internal/ubuntu questing/universe firebird4.0 4.0.5.3140.ds6-16 (tar) [3965 kB] 135s Get:3 http://ftpmaster.internal/ubuntu questing/universe firebird4.0 4.0.5.3140.ds6-16 (diff) [101 kB] 135s gpgv: Signature made Mon Feb 17 08:03:03 2025 UTC 135s gpgv: using RSA key AEA0C44ECB056E93630D9D33DBBE9D4D99D2A004 135s gpgv: Can't check signature: No public key 135s dpkg-source: warning: cannot verify inline signature for ./firebird4.0_4.0.5.3140.ds6-16.dsc: no acceptable signature found 135s autopkgtest [03:57:00]: testing package firebird4.0 version 4.0.5.3140.ds6-16 136s autopkgtest [03:57:01]: build not needed 138s autopkgtest [03:57:03]: test assorted-tools: 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 139s The following NEW packages will be installed: 139s firebird-utils firebird4.0-common firebird4.0-common-doc 139s firebird4.0-examples firebird4.0-server-core firebird4.0-utils 139s libabsl20230802 libfbclient2 libre2-11 libtomcrypt1 libtommath1 139s 0 upgraded, 11 newly installed, 0 to remove and 0 not upgraded. 139s Need to get 8185 kB of archives. 139s After this operation, 32.3 MB of additional disk space will be used. 139s Get:1 http://ftpmaster.internal/ubuntu questing/universe s390x firebird4.0-common-doc all 4.0.5.3140.ds6-16 [28.3 kB] 139s Get:2 http://ftpmaster.internal/ubuntu questing/universe s390x firebird4.0-common all 4.0.5.3140.ds6-16 [18.5 kB] 139s Get:3 http://ftpmaster.internal/ubuntu questing/universe s390x libtommath1 s390x 1.3.0-1 [57.1 kB] 139s Get:4 http://ftpmaster.internal/ubuntu questing/universe s390x libfbclient2 s390x 4.0.5.3140.ds6-16 [970 kB] 139s Get:5 http://ftpmaster.internal/ubuntu questing/main s390x libabsl20230802 s390x 20230802.1-4.2 [530 kB] 139s Get:6 http://ftpmaster.internal/ubuntu questing/main s390x libre2-11 s390x 20240501-3build1 [185 kB] 139s Get:7 http://ftpmaster.internal/ubuntu questing/universe s390x firebird4.0-utils s390x 4.0.5.3140.ds6-16 [1530 kB] 139s Get:8 http://ftpmaster.internal/ubuntu questing/universe s390x firebird-utils all 4.0.5.3140.ds6-16 [3714 B] 139s Get:9 http://ftpmaster.internal/ubuntu questing/universe s390x firebird4.0-examples all 4.0.5.3140.ds6-16 [387 kB] 139s Get:10 http://ftpmaster.internal/ubuntu questing/universe s390x libtomcrypt1 s390x 1.18.2+dfsg-7build1 [432 kB] 139s Get:11 http://ftpmaster.internal/ubuntu questing/universe s390x firebird4.0-server-core s390x 4.0.5.3140.ds6-16 [4043 kB] 140s Fetched 8185 kB in 1s (6587 kB/s) 140s Selecting previously unselected package firebird4.0-common-doc. 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 ... 81472 files and directories currently installed.) 140s Preparing to unpack .../00-firebird4.0-common-doc_4.0.5.3140.ds6-16_all.deb ... 140s Unpacking firebird4.0-common-doc (4.0.5.3140.ds6-16) ... 140s Selecting previously unselected package firebird4.0-common. 140s Preparing to unpack .../01-firebird4.0-common_4.0.5.3140.ds6-16_all.deb ... 140s Unpacking firebird4.0-common (4.0.5.3140.ds6-16) ... 140s Selecting previously unselected package libtommath1:s390x. 140s Preparing to unpack .../02-libtommath1_1.3.0-1_s390x.deb ... 140s Unpacking libtommath1:s390x (1.3.0-1) ... 140s Selecting previously unselected package libfbclient2:s390x. 140s Preparing to unpack .../03-libfbclient2_4.0.5.3140.ds6-16_s390x.deb ... 140s Unpacking libfbclient2:s390x (4.0.5.3140.ds6-16) ... 140s Selecting previously unselected package libabsl20230802:s390x. 140s Preparing to unpack .../04-libabsl20230802_20230802.1-4.2_s390x.deb ... 140s Unpacking libabsl20230802:s390x (20230802.1-4.2) ... 140s Selecting previously unselected package libre2-11:s390x. 140s Preparing to unpack .../05-libre2-11_20240501-3build1_s390x.deb ... 140s Unpacking libre2-11:s390x (20240501-3build1) ... 140s Selecting previously unselected package firebird4.0-utils. 140s Preparing to unpack .../06-firebird4.0-utils_4.0.5.3140.ds6-16_s390x.deb ... 140s Unpacking firebird4.0-utils (4.0.5.3140.ds6-16) ... 140s Selecting previously unselected package firebird-utils. 140s Preparing to unpack .../07-firebird-utils_4.0.5.3140.ds6-16_all.deb ... 140s Unpacking firebird-utils (4.0.5.3140.ds6-16) ... 140s Selecting previously unselected package firebird4.0-examples. 140s Preparing to unpack .../08-firebird4.0-examples_4.0.5.3140.ds6-16_all.deb ... 140s Unpacking firebird4.0-examples (4.0.5.3140.ds6-16) ... 140s Selecting previously unselected package libtomcrypt1:s390x. 140s Preparing to unpack .../09-libtomcrypt1_1.18.2+dfsg-7build1_s390x.deb ... 140s Unpacking libtomcrypt1:s390x (1.18.2+dfsg-7build1) ... 140s Selecting previously unselected package firebird4.0-server-core:s390x. 140s Preparing to unpack .../10-firebird4.0-server-core_4.0.5.3140.ds6-16_s390x.deb ... 140s Unpacking firebird4.0-server-core:s390x (4.0.5.3140.ds6-16) ... 141s Setting up libtommath1:s390x (1.3.0-1) ... 141s Setting up firebird4.0-common-doc (4.0.5.3140.ds6-16) ... 141s Setting up firebird4.0-common (4.0.5.3140.ds6-16) ... 141s Configuring /etc/firebird/4.0/service-port.conf to use port 3050 141s Setting up libabsl20230802:s390x (20230802.1-4.2) ... 141s Setting up libtomcrypt1:s390x (1.18.2+dfsg-7build1) ... 141s Setting up firebird4.0-examples (4.0.5.3140.ds6-16) ... 141s Setting up libre2-11:s390x (20240501-3build1) ... 141s Setting up libfbclient2:s390x (4.0.5.3140.ds6-16) ... 141s Setting up firebird4.0-server-core:s390x (4.0.5.3140.ds6-16) ... 141s Setting up firebird-utils (4.0.5.3140.ds6-16) ... 141s Setting up firebird4.0-utils (4.0.5.3140.ds6-16) ... 141s update-alternatives: using /usr/share/firebird/4.0/man/man8/firebird.8.gz to provide /usr/share/man/man8/firebird.8.gz (firebird) in auto mode 141s Processing triggers for libc-bin (2.41-6ubuntu1) ... 141s Processing triggers for man-db (2.13.0-1) ... 142s autopkgtest [03:57:07]: test assorted-tools: [----------------------- 143s V: Creating employee.fdb via isql-fb -i 143s V: Backing up 143s V: Restoring the backup 144s V: Extracting definition of employee.fdb via isql-fb -a 144s V: Checking the size of employee.sql 144s -rw-rw-r-- 1 ubuntu ubuntu 21525 May 2 03:58 employee.sql 144s V: Running fbstat on employee.fdb 144s 144s Database "/tmp/autopkgtest.scZrCs/assorted-tools-artifacts/employee.fdb" 144s Gstat execution time Fri May 2 03:58:34 2025 144s 144s Database header page information: 144s Flags 0 144s Generation 162 144s System Change Number 0 144s Page size 8192 144s ODS version 13.0 144s Oldest transaction 155 144s Oldest active 156 144s Oldest snapshot 156 144s Next transaction 156 144s Sequence number 0 144s Next attachment ID 9 144s Implementation HW=s390x big-endian OS=Linux CC=gcc 144s Shadow count 0 144s Page buffers 0 144s Next header page 0 144s Database dialect 3 144s Creation date May 2, 2025 3:58:33 144s Attributes force write 144s 144s Variable header data: 144s Database GUID: {08628B92-1277-4634-9781-113DEE6B2998} 144s *END* 144s 144s 144s Database file sequence: 144s File /tmp/autopkgtest.scZrCs/assorted-tools-artifacts/employee.fdb is the only file 144s 144s Analyzing database pages ... 144s COUNTRY (128) 144s Primary pointer page: 222, Index root page: 223 144s Pointer pages: 1, data page slots: 1 144s Data pages: 1, average fill: 8% 144s Primary pages: 1, secondary pages: 0, swept pages: 0 144s Empty pages: 0, full pages: 0 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index RDB$PRIMARY1 (0) 144s Root page: 226, depth: 1, leaf buckets: 1, nodes: 16 144s Average node length: 10.44, total dup: 0, max dup: 0 144s Average key length: 8.62, compression ratio: 0.80 144s Average prefix length: 0.44, average data length: 6.44 144s Clustering factor: 1, ratio: 0.06 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s CUSTOMER (137) 144s Primary pointer page: 276, Index root page: 277 144s Pointer pages: 1, data page slots: 1 144s Data pages: 1, average fill: 25% 144s Primary pages: 1, secondary pages: 0, swept pages: 1 144s Empty pages: 0, full pages: 0 144s Fill distribution: 144s 0 - 19% = 0 144s 20 - 39% = 1 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index CUSTNAMEX (2) 144s Root page: 290, depth: 1, leaf buckets: 1, nodes: 15 144s Average node length: 19.87, total dup: 0, max dup: 0 144s Average key length: 18.27, compression ratio: 0.90 144s Average prefix length: 0.60, average data length: 15.87 144s Clustering factor: 1, ratio: 0.07 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index CUSTREGION (3) 144s Root page: 291, depth: 1, leaf buckets: 1, nodes: 15 144s Average node length: 21.27, total dup: 0, max dup: 0 144s Average key length: 20.20, compression ratio: 0.97 144s Average prefix length: 2.33, average data length: 17.27 144s Clustering factor: 1, ratio: 0.07 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index RDB$FOREIGN23 (1) 144s Root page: 279, depth: 1, leaf buckets: 1, nodes: 15 144s Average node length: 8.60, total dup: 4, max dup: 4 144s Average key length: 6.93, compression ratio: 0.83 144s Average prefix length: 0.87, average data length: 4.87 144s Clustering factor: 1, ratio: 0.07 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index RDB$PRIMARY22 (0) 144s Root page: 278, depth: 1, leaf buckets: 1, nodes: 15 144s Average node length: 4.20, total dup: 0, max dup: 0 144s Average key length: 3.13, compression ratio: 0.96 144s Average prefix length: 1.87, average data length: 1.13 144s Clustering factor: 1, ratio: 0.07 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s DEPARTMENT (130) 144s Primary pointer page: 236, Index root page: 237 144s Pointer pages: 1, data page slots: 1 144s Data pages: 1, average fill: 23% 144s Primary pages: 1, secondary pages: 0, swept pages: 1 144s Empty pages: 0, full pages: 0 144s Fill distribution: 144s 0 - 19% = 0 144s 20 - 39% = 1 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index BUDGETX (3) 144s Root page: 298, depth: 1, leaf buckets: 1, nodes: 21 144s Average node length: 9.05, total dup: 7, max dup: 3 144s Average key length: 8.00, compression ratio: 1.12 144s Average prefix length: 3.62, average data length: 5.38 144s Clustering factor: 1, ratio: 0.05 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index RDB$4 (0) 144s Root page: 238, depth: 1, leaf buckets: 1, nodes: 21 144s Average node length: 17.95, total dup: 0, max dup: 0 144s Average key length: 16.57, compression ratio: 1.16 144s Average prefix length: 5.29, average data length: 13.95 144s Clustering factor: 1, ratio: 0.05 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index RDB$FOREIGN10 (4) 144s Root page: 250, depth: 1, leaf buckets: 1, nodes: 21 144s Average node length: 4.29, total dup: 3, max dup: 3 144s Average key length: 3.24, compression ratio: 0.60 144s Average prefix length: 0.81, average data length: 1.14 144s Clustering factor: 1, ratio: 0.05 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index RDB$FOREIGN6 (2) 144s Root page: 240, depth: 1, leaf buckets: 1, nodes: 21 144s Average node length: 4.10, total dup: 13, max dup: 4 144s Average key length: 2.95, compression ratio: 0.97 144s Average prefix length: 2.05, average data length: 0.81 144s Clustering factor: 1, ratio: 0.05 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index RDB$PRIMARY5 (1) 144s Root page: 239, depth: 1, leaf buckets: 1, nodes: 21 144s Average node length: 5.24, total dup: 0, max dup: 0 144s Average key length: 4.05, compression ratio: 0.74 144s Average prefix length: 1.29, average data length: 1.71 144s Clustering factor: 1, ratio: 0.05 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s EMPLOYEE (131) 144s Primary pointer page: 243, Index root page: 244 144s Pointer pages: 1, data page slots: 1 144s Data pages: 1, average fill: 42% 144s Primary pages: 1, secondary pages: 0, swept pages: 1 144s Empty pages: 0, full pages: 0 144s Fill distribution: 144s 0 - 19% = 0 144s 20 - 39% = 0 144s 40 - 59% = 1 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index NAMEX (3) 144s Root page: 299, depth: 1, leaf buckets: 1, nodes: 42 144s Average node length: 19.52, total dup: 0, max dup: 0 144s Average key length: 18.50, compression ratio: 0.96 144s Average prefix length: 2.17, average data length: 15.52 144s Clustering factor: 1, ratio: 0.02 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index RDB$FOREIGN8 (1) 144s Root page: 246, depth: 1, leaf buckets: 1, nodes: 42 144s Average node length: 4.07, total dup: 23, max dup: 4 144s Average key length: 2.98, compression ratio: 1.01 144s Average prefix length: 2.19, average data length: 0.81 144s Clustering factor: 1, ratio: 0.02 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index RDB$FOREIGN9 (2) 144s Root page: 247, depth: 1, leaf buckets: 1, nodes: 42 144s Average node length: 10.43, total dup: 15, max dup: 4 144s Average key length: 9.40, compression ratio: 1.68 144s Average prefix length: 9.05, average data length: 6.79 144s Clustering factor: 1, ratio: 0.02 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index RDB$PRIMARY7 (0) 144s Root page: 245, depth: 1, leaf buckets: 1, nodes: 42 144s Average node length: 4.62, total dup: 0, max dup: 0 144s Average key length: 3.60, compression ratio: 0.69 144s Average prefix length: 1.17, average data length: 1.31 144s Clustering factor: 1, ratio: 0.02 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s EMPLOYEE_PROJECT (134) 144s Primary pointer page: 257, Index root page: 258 144s Pointer pages: 1, data page slots: 1 144s Data pages: 1, average fill: 10% 144s Primary pages: 1, secondary pages: 0, swept pages: 0 144s Empty pages: 0, full pages: 0 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index RDB$FOREIGN15 (1) 144s Root page: 260, depth: 1, leaf buckets: 1, nodes: 28 144s Average node length: 4.29, total dup: 6, max dup: 2 144s Average key length: 3.25, compression ratio: 0.74 144s Average prefix length: 1.36, average data length: 1.04 144s Clustering factor: 1, ratio: 0.04 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index RDB$FOREIGN16 (2) 144s Root page: 261, depth: 1, leaf buckets: 1, nodes: 28 144s Average node length: 4.04, total dup: 23, max dup: 9 144s Average key length: 2.89, compression ratio: 1.73 144s Average prefix length: 4.14, average data length: 0.86 144s Clustering factor: 1, ratio: 0.04 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index RDB$PRIMARY14 (0) 144s Root page: 259, depth: 1, leaf buckets: 1, nodes: 28 144s Average node length: 13.11, total dup: 0, max dup: 0 144s Average key length: 12.07, compression ratio: 0.99 144s Average prefix length: 2.89, average data length: 9.11 144s Clustering factor: 1, ratio: 0.04 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s JOB (129) 144s Primary pointer page: 229, Index root page: 230 144s Pointer pages: 1, data page slots: 2 144s Data pages: 2, average fill: 43% 144s Primary pages: 1, secondary pages: 1, swept pages: 0 144s Empty pages: 0, full pages: 0 144s Fill distribution: 144s 0 - 19% = 0 144s 20 - 39% = 1 144s 40 - 59% = 1 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index MAXSALX (2) 144s Root page: 300, depth: 1, leaf buckets: 1, nodes: 31 144s Average node length: 14.74, total dup: 5, max dup: 1 144s Average key length: 13.71, compression ratio: 1.37 144s Average prefix length: 7.87, average data length: 10.90 144s Clustering factor: 1, ratio: 0.03 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index MINSALX (3) 144s Root page: 301, depth: 1, leaf buckets: 1, nodes: 31 144s Average node length: 14.06, total dup: 7, max dup: 2 144s Average key length: 13.03, compression ratio: 1.44 144s Average prefix length: 8.48, average data length: 10.29 144s Clustering factor: 1, ratio: 0.03 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index RDB$FOREIGN3 (1) 144s Root page: 232, depth: 1, leaf buckets: 1, nodes: 31 144s Average node length: 4.61, total dup: 24, max dup: 20 144s Average key length: 3.39, compression ratio: 1.23 144s Average prefix length: 2.77, average data length: 1.39 144s Clustering factor: 1, ratio: 0.03 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index RDB$PRIMARY2 (0) 144s Root page: 231, depth: 1, leaf buckets: 1, nodes: 31 144s Average node length: 14.45, total dup: 0, max dup: 0 144s Average key length: 13.42, compression ratio: 1.24 144s Average prefix length: 6.19, average data length: 10.45 144s Clustering factor: 1, ratio: 0.03 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s PROJECT (133) 144s Primary pointer page: 251, Index root page: 252 144s Pointer pages: 1, data page slots: 2 144s Data pages: 2, average fill: 7% 144s Primary pages: 1, secondary pages: 1, swept pages: 0 144s Empty pages: 0, full pages: 0 144s Fill distribution: 144s 0 - 19% = 2 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index PRODTYPEX (3) 144s Root page: 302, depth: 1, leaf buckets: 1, nodes: 6 144s Average node length: 26.50, total dup: 0, max dup: 0 144s Average key length: 25.33, compression ratio: 1.05 144s Average prefix length: 4.17, average data length: 22.50 144s Clustering factor: 1, ratio: 0.17 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index RDB$11 (0) 144s Root page: 253, depth: 1, leaf buckets: 1, nodes: 6 144s Average node length: 17.33, total dup: 0, max dup: 0 144s Average key length: 15.50, compression ratio: 0.88 144s Average prefix length: 0.33, average data length: 13.33 144s Clustering factor: 1, ratio: 0.17 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index RDB$FOREIGN13 (2) 144s Root page: 255, depth: 1, leaf buckets: 1, nodes: 6 144s Average node length: 4.67, total dup: 0, max dup: 0 144s Average key length: 3.50, compression ratio: 0.57 144s Average prefix length: 0.67, average data length: 1.33 144s Clustering factor: 1, ratio: 0.17 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index RDB$PRIMARY12 (1) 144s Root page: 254, depth: 1, leaf buckets: 1, nodes: 6 144s Average node length: 8.83, total dup: 0, max dup: 0 144s Average key length: 7.00, compression ratio: 0.71 144s Average prefix length: 0.17, average data length: 4.83 144s Clustering factor: 1, ratio: 0.17 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s PROJ_DEPT_BUDGET (135) 144s Primary pointer page: 265, Index root page: 266 144s Pointer pages: 1, data page slots: 1 144s Data pages: 1, average fill: 11% 144s Primary pages: 1, secondary pages: 0, swept pages: 0 144s Empty pages: 0, full pages: 0 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index RDB$FOREIGN18 (1) 144s Root page: 268, depth: 1, leaf buckets: 1, nodes: 24 144s Average node length: 3.92, total dup: 15, max dup: 5 144s Average key length: 2.79, compression ratio: 1.07 144s Average prefix length: 2.29, average data length: 0.71 144s Clustering factor: 1, ratio: 0.04 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index RDB$FOREIGN19 (2) 144s Root page: 269, depth: 1, leaf buckets: 1, nodes: 24 144s Average node length: 4.21, total dup: 19, max dup: 8 144s Average key length: 3.04, compression ratio: 1.64 144s Average prefix length: 4.00, average data length: 1.00 144s Clustering factor: 1, ratio: 0.04 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index RDB$PRIMARY17 (0) 144s Root page: 267, depth: 1, leaf buckets: 1, nodes: 24 144s Average node length: 10.71, total dup: 0, max dup: 0 144s Average key length: 9.67, compression ratio: 1.97 144s Average prefix length: 12.17, average data length: 6.83 144s Clustering factor: 1, ratio: 0.04 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s SALARY_HISTORY (136) 144s Primary pointer page: 270, Index root page: 271 144s Pointer pages: 1, data page slots: 1 144s Data pages: 1, average fill: 29% 144s Primary pages: 1, secondary pages: 0, swept pages: 0 144s Empty pages: 0, full pages: 0 144s Fill distribution: 144s 0 - 19% = 0 144s 20 - 39% = 1 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index CHANGEX (2) 144s Root page: 303, depth: 1, leaf buckets: 1, nodes: 49 144s Average node length: 3.37, total dup: 46, max dup: 21 144s Average key length: 2.35, compression ratio: 2.98 144s Average prefix length: 6.69, average data length: 0.31 144s Clustering factor: 1, ratio: 0.02 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index RDB$FOREIGN21 (1) 144s Root page: 273, depth: 1, leaf buckets: 1, nodes: 49 144s Average node length: 4.12, total dup: 16, max dup: 2 144s Average key length: 3.10, compression ratio: 0.75 144s Average prefix length: 1.43, average data length: 0.90 144s Clustering factor: 1, ratio: 0.02 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index RDB$PRIMARY20 (0) 144s Root page: 272, depth: 1, leaf buckets: 1, nodes: 49 144s Average node length: 22.29, total dup: 0, max dup: 0 144s Average key length: 21.27, compression ratio: 1.06 144s Average prefix length: 4.31, average data length: 18.29 144s Clustering factor: 1, ratio: 0.02 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index UPDATERX (3) 144s Root page: 304, depth: 1, leaf buckets: 1, nodes: 49 144s Average node length: 3.35, total dup: 46, max dup: 28 144s Average key length: 2.29, compression ratio: 2.48 144s Average prefix length: 5.39, average data length: 0.29 144s Clustering factor: 1, ratio: 0.02 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s SALES (138) 144s Primary pointer page: 283, Index root page: 284 144s Pointer pages: 1, data page slots: 1 144s Data pages: 1, average fill: 34% 144s Primary pages: 1, secondary pages: 0, swept pages: 0 144s Empty pages: 0, full pages: 0 144s Fill distribution: 144s 0 - 19% = 0 144s 20 - 39% = 1 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index NEEDX (3) 144s Root page: 305, depth: 1, leaf buckets: 1, nodes: 33 144s Average node length: 5.97, total dup: 11, max dup: 6 144s Average key length: 4.94, compression ratio: 1.10 144s Average prefix length: 2.88, average data length: 2.55 144s Clustering factor: 1, ratio: 0.03 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index QTYX (4) 144s Root page: 306, depth: 1, leaf buckets: 1, nodes: 33 144s Average node length: 5.06, total dup: 11, max dup: 3 144s Average key length: 4.03, compression ratio: 3.23 144s Average prefix length: 11.18, average data length: 1.85 144s Clustering factor: 1, ratio: 0.03 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index RDB$FOREIGN25 (1) 144s Root page: 286, depth: 1, leaf buckets: 1, nodes: 33 144s Average node length: 3.55, total dup: 18, max dup: 4 144s Average key length: 2.52, compression ratio: 1.19 144s Average prefix length: 2.48, average data length: 0.52 144s Clustering factor: 1, ratio: 0.03 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index RDB$FOREIGN26 (2) 144s Root page: 287, depth: 1, leaf buckets: 1, nodes: 33 144s Average node length: 3.67, total dup: 25, max dup: 7 144s Average key length: 2.64, compression ratio: 1.01 144s Average prefix length: 2.21, average data length: 0.45 144s Clustering factor: 1, ratio: 0.03 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index RDB$PRIMARY24 (0) 144s Root page: 285, depth: 1, leaf buckets: 1, nodes: 33 144s Average node length: 8.45, total dup: 0, max dup: 0 144s Average key length: 7.42, compression ratio: 1.08 144s Average prefix length: 3.52, average data length: 4.48 144s Clustering factor: 1, ratio: 0.03 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Index SALESTATX (5) 144s Root page: 307, depth: 1, leaf buckets: 1, nodes: 33 144s Average node length: 4.06, total dup: 27, max dup: 14 144s Average key length: 3.03, compression ratio: 3.56 144s Average prefix length: 9.82, average data length: 0.97 144s Clustering factor: 1, ratio: 0.03 144s Fill distribution: 144s 0 - 19% = 1 144s 20 - 39% = 0 144s 40 - 59% = 0 144s 60 - 79% = 0 144s 80 - 99% = 0 144s 144s Gstat completion time Fri May 2 03:58:34 2025 144s 144s V: Running gfix -v 144s V: Some big math 144s create table tbl1(fld1 int128); 144s insert into tbl1 values(12345); 144s select * from tbl1; 144s 144s FLD1 144s ============================================= 144s 12345 144s 144s autopkgtest [03:57:09]: test assorted-tools: -----------------------] 145s autopkgtest [03:57:10]: test assorted-tools: - - - - - - - - - - results - - - - - - - - - - 145s assorted-tools PASS 152s autopkgtest [03:57:17]: @@@@@@@@@@@@@@@@@@@@ summary 152s assorted-tools PASS 170s nova [W] Using flock in prodstack6-s390x 170s Creating nova instance adt-questing-s390x-firebird4.0-20250502-035445-juju-7f2275-prod-proposed-migration-environment-21-6b9c6480-6bca-4d1b-848d-e013fe756da6 from image adt/ubuntu-questing-s390x-server-20250501.img (UUID 06a11845-48a4-4c28-9288-51dd7b757c52)... 170s nova [W] Timed out waiting for ac05f1d4-defd-413b-b377-adf999b16cb5 to get deleted.