0s autopkgtest [04:27:18]: starting date and time: 2025-05-02 04:27:18+0000 0s autopkgtest [04:27:18]: git checkout: 9986aa8c Merge branch 'skia/fix_network_interface' into 'ubuntu/production' 0s autopkgtest [04:27:18]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.qey4wutu/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-ppc64el --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@bos03-ppc64el-11.secgroup --name adt-questing-ppc64el-firebird4.0-20250502-042718-juju-7f2275-prod-proposed-migration-environment-15-8fbccb99-e73c-407e-8b76-e9bfda648409 --image adt/ubuntu-questing-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-15 --net-id=net_prod-proposed-migration-ppc64el -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 138s autopkgtest [04:29:36]: testbed dpkg architecture: ppc64el 139s autopkgtest [04:29:37]: testbed apt version: 3.0.0 139s autopkgtest [04:29:37]: @@@@@@@@@@@@@@@@@@@@ test bed setup 139s autopkgtest [04:29:37]: testbed release detected to be: None 140s autopkgtest [04:29:38]: updating testbed package index (apt update) 140s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [110 kB] 141s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease 141s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease 141s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease 141s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [190 kB] 141s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [57.4 kB] 141s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [2281 kB] 141s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main ppc64el Packages [210 kB] 141s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/universe ppc64el Packages [1198 kB] 141s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/multiverse ppc64el Packages [16.5 kB] 142s Fetched 4062 kB in 2s (2517 kB/s) 144s Reading package lists... 144s autopkgtest [04:29:42]: upgrading testbed (apt dist-upgrade and autopurge) 145s Reading package lists... 145s Building dependency tree... 145s Reading state information... 146s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 146s Starting 2 pkgProblemResolver with broken count: 0 146s Done 147s Entering ResolveByKeep 147s 147s Calculating upgrade... 147s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 148s Reading package lists... 148s Building dependency tree... 148s Reading state information... 149s Starting pkgProblemResolver with broken count: 0 149s Starting 2 pkgProblemResolver with broken count: 0 149s Done 150s Solving dependencies... 150s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 153s autopkgtest [04:29:51]: testbed running kernel: Linux 6.14.0-15-generic #15-Ubuntu SMP Sun Apr 6 14:52:42 UTC 2025 153s autopkgtest [04:29:51]: @@@@@@@@@@@@@@@@@@@@ apt-source firebird4.0 163s Get:1 http://ftpmaster.internal/ubuntu questing/universe firebird4.0 4.0.5.3140.ds6-16 (dsc) [2860 B] 163s Get:2 http://ftpmaster.internal/ubuntu questing/universe firebird4.0 4.0.5.3140.ds6-16 (tar) [3965 kB] 163s Get:3 http://ftpmaster.internal/ubuntu questing/universe firebird4.0 4.0.5.3140.ds6-16 (diff) [101 kB] 164s gpgv: Signature made Mon Feb 17 08:03:03 2025 UTC 164s gpgv: using RSA key AEA0C44ECB056E93630D9D33DBBE9D4D99D2A004 164s gpgv: Can't check signature: No public key 164s dpkg-source: warning: cannot verify inline signature for ./firebird4.0_4.0.5.3140.ds6-16.dsc: no acceptable signature found 164s autopkgtest [04:30:02]: testing package firebird4.0 version 4.0.5.3140.ds6-16 165s autopkgtest [04:30:03]: build not needed 170s autopkgtest [04:30:08]: test assorted-tools: preparing testbed 170s Reading package lists... 170s Building dependency tree... 170s Reading state information... 171s Starting pkgProblemResolver with broken count: 0 171s Starting 2 pkgProblemResolver with broken count: 0 171s Done 171s The following NEW packages will be installed: 171s firebird-utils firebird4.0-common firebird4.0-common-doc 171s firebird4.0-examples firebird4.0-server-core firebird4.0-utils 171s libabsl20230802 libfbclient2 libre2-11 libtomcrypt1 libtommath1 172s 0 upgraded, 11 newly installed, 0 to remove and 0 not upgraded. 172s Need to get 8206 kB of archives. 172s After this operation, 40.9 MB of additional disk space will be used. 172s Get:1 http://ftpmaster.internal/ubuntu questing/universe ppc64el firebird4.0-common-doc all 4.0.5.3140.ds6-16 [28.3 kB] 172s Get:2 http://ftpmaster.internal/ubuntu questing/universe ppc64el firebird4.0-common all 4.0.5.3140.ds6-16 [18.5 kB] 172s Get:3 http://ftpmaster.internal/ubuntu questing/universe ppc64el libtommath1 ppc64el 1.3.0-1 [77.7 kB] 172s Get:4 http://ftpmaster.internal/ubuntu questing/universe ppc64el libfbclient2 ppc64el 4.0.5.3140.ds6-16 [928 kB] 172s Get:5 http://ftpmaster.internal/ubuntu questing/main ppc64el libabsl20230802 ppc64el 20230802.1-4.2 [608 kB] 172s Get:6 http://ftpmaster.internal/ubuntu questing/main ppc64el libre2-11 ppc64el 20240501-3build1 [183 kB] 172s Get:7 http://ftpmaster.internal/ubuntu questing/universe ppc64el firebird4.0-utils ppc64el 4.0.5.3140.ds6-16 [1540 kB] 172s Get:8 http://ftpmaster.internal/ubuntu questing/universe ppc64el firebird-utils all 4.0.5.3140.ds6-16 [3714 B] 172s Get:9 http://ftpmaster.internal/ubuntu questing/universe ppc64el firebird4.0-examples all 4.0.5.3140.ds6-16 [387 kB] 172s Get:10 http://ftpmaster.internal/ubuntu questing/universe ppc64el libtomcrypt1 ppc64el 1.18.2+dfsg-7build1 [503 kB] 172s Get:11 http://ftpmaster.internal/ubuntu questing/universe ppc64el firebird4.0-server-core ppc64el 4.0.5.3140.ds6-16 [3928 kB] 173s Fetched 8206 kB in 1s (8796 kB/s) 173s Selecting previously unselected package firebird4.0-common-doc. 173s (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 ... 107206 files and directories currently installed.) 173s Preparing to unpack .../00-firebird4.0-common-doc_4.0.5.3140.ds6-16_all.deb ... 173s Unpacking firebird4.0-common-doc (4.0.5.3140.ds6-16) ... 173s Selecting previously unselected package firebird4.0-common. 173s Preparing to unpack .../01-firebird4.0-common_4.0.5.3140.ds6-16_all.deb ... 173s Unpacking firebird4.0-common (4.0.5.3140.ds6-16) ... 173s Selecting previously unselected package libtommath1:ppc64el. 173s Preparing to unpack .../02-libtommath1_1.3.0-1_ppc64el.deb ... 173s Unpacking libtommath1:ppc64el (1.3.0-1) ... 174s Selecting previously unselected package libfbclient2:ppc64el. 174s Preparing to unpack .../03-libfbclient2_4.0.5.3140.ds6-16_ppc64el.deb ... 174s Unpacking libfbclient2:ppc64el (4.0.5.3140.ds6-16) ... 174s Selecting previously unselected package libabsl20230802:ppc64el. 174s Preparing to unpack .../04-libabsl20230802_20230802.1-4.2_ppc64el.deb ... 174s Unpacking libabsl20230802:ppc64el (20230802.1-4.2) ... 174s Selecting previously unselected package libre2-11:ppc64el. 174s Preparing to unpack .../05-libre2-11_20240501-3build1_ppc64el.deb ... 174s Unpacking libre2-11:ppc64el (20240501-3build1) ... 174s Selecting previously unselected package firebird4.0-utils. 174s Preparing to unpack .../06-firebird4.0-utils_4.0.5.3140.ds6-16_ppc64el.deb ... 174s Unpacking firebird4.0-utils (4.0.5.3140.ds6-16) ... 174s Selecting previously unselected package firebird-utils. 174s Preparing to unpack .../07-firebird-utils_4.0.5.3140.ds6-16_all.deb ... 174s Unpacking firebird-utils (4.0.5.3140.ds6-16) ... 174s Selecting previously unselected package firebird4.0-examples. 174s Preparing to unpack .../08-firebird4.0-examples_4.0.5.3140.ds6-16_all.deb ... 174s Unpacking firebird4.0-examples (4.0.5.3140.ds6-16) ... 174s Selecting previously unselected package libtomcrypt1:ppc64el. 174s Preparing to unpack .../09-libtomcrypt1_1.18.2+dfsg-7build1_ppc64el.deb ... 174s Unpacking libtomcrypt1:ppc64el (1.18.2+dfsg-7build1) ... 174s Selecting previously unselected package firebird4.0-server-core:ppc64el. 174s Preparing to unpack .../10-firebird4.0-server-core_4.0.5.3140.ds6-16_ppc64el.deb ... 174s Unpacking firebird4.0-server-core:ppc64el (4.0.5.3140.ds6-16) ... 174s Setting up libtommath1:ppc64el (1.3.0-1) ... 174s Setting up firebird4.0-common-doc (4.0.5.3140.ds6-16) ... 174s Setting up firebird4.0-common (4.0.5.3140.ds6-16) ... 174s Configuring /etc/firebird/4.0/service-port.conf to use port 3050 174s Setting up libabsl20230802:ppc64el (20230802.1-4.2) ... 174s Setting up libtomcrypt1:ppc64el (1.18.2+dfsg-7build1) ... 174s Setting up firebird4.0-examples (4.0.5.3140.ds6-16) ... 174s Setting up libre2-11:ppc64el (20240501-3build1) ... 174s Setting up libfbclient2:ppc64el (4.0.5.3140.ds6-16) ... 174s Setting up firebird4.0-server-core:ppc64el (4.0.5.3140.ds6-16) ... 174s Setting up firebird-utils (4.0.5.3140.ds6-16) ... 174s Setting up firebird4.0-utils (4.0.5.3140.ds6-16) ... 174s 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 174s Processing triggers for libc-bin (2.41-6ubuntu1) ... 174s Processing triggers for man-db (2.13.0-1) ... 178s autopkgtest [04:30:16]: test assorted-tools: [----------------------- 178s V: Creating employee.fdb via isql-fb -i 182s V: Backing up 182s V: Restoring the backup 182s V: Extracting definition of employee.fdb via isql-fb -a 182s V: Checking the size of employee.sql 182s -rw-rw-r-- 1 ubuntu ubuntu 21525 May 2 04:30 employee.sql 182s V: Running fbstat on employee.fdb 183s 183s Database "/tmp/autopkgtest.HiX8IY/assorted-tools-artifacts/employee.fdb" 183s Gstat execution time Fri May 2 04:30:20 2025 183s 183s Database header page information: 183s Flags 0 183s Generation 162 183s System Change Number 0 183s Page size 8192 183s ODS version 13.0 183s Oldest transaction 155 183s Oldest active 156 183s Oldest snapshot 156 183s Next transaction 156 183s Sequence number 0 183s Next attachment ID 9 183s Implementation HW=PowerPC64el little-endian OS=Linux CC=gcc 183s Shadow count 0 183s Page buffers 0 183s Next header page 0 183s Database dialect 3 183s Creation date May 2, 2025 4:30:16 183s Attributes force write 183s 183s Variable header data: 183s Database GUID: {EED5CB99-6940-45A6-B1DB-2267E92818D1} 183s *END* 183s 183s 183s Database file sequence: 183s File /tmp/autopkgtest.HiX8IY/assorted-tools-artifacts/employee.fdb is the only file 183s 183s Analyzing database pages ... 183s COUNTRY (128) 183s Primary pointer page: 222, Index root page: 223 183s Pointer pages: 1, data page slots: 1 183s Data pages: 1, average fill: 8% 183s Primary pages: 1, secondary pages: 0, swept pages: 0 183s Empty pages: 0, full pages: 0 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index RDB$PRIMARY1 (0) 183s Root page: 226, depth: 1, leaf buckets: 1, nodes: 16 183s Average node length: 10.44, total dup: 0, max dup: 0 183s Average key length: 8.62, compression ratio: 0.80 183s Average prefix length: 0.44, average data length: 6.44 183s Clustering factor: 1, ratio: 0.06 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s CUSTOMER (137) 183s Primary pointer page: 277, Index root page: 278 183s Pointer pages: 1, data page slots: 1 183s Data pages: 1, average fill: 26% 183s Primary pages: 1, secondary pages: 0, swept pages: 1 183s Empty pages: 0, full pages: 0 183s Fill distribution: 183s 0 - 19% = 0 183s 20 - 39% = 1 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index CUSTNAMEX (2) 183s Root page: 291, depth: 1, leaf buckets: 1, nodes: 15 183s Average node length: 19.87, total dup: 0, max dup: 0 183s Average key length: 18.27, compression ratio: 0.90 183s Average prefix length: 0.60, average data length: 15.87 183s Clustering factor: 1, ratio: 0.07 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index CUSTREGION (3) 183s Root page: 292, depth: 1, leaf buckets: 1, nodes: 15 183s Average node length: 21.27, total dup: 0, max dup: 0 183s Average key length: 20.20, compression ratio: 0.97 183s Average prefix length: 2.33, average data length: 17.27 183s Clustering factor: 1, ratio: 0.07 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index RDB$FOREIGN23 (1) 183s Root page: 280, depth: 1, leaf buckets: 1, nodes: 15 183s Average node length: 8.60, total dup: 4, max dup: 4 183s Average key length: 6.93, compression ratio: 0.83 183s Average prefix length: 0.87, average data length: 4.87 183s Clustering factor: 1, ratio: 0.07 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index RDB$PRIMARY22 (0) 183s Root page: 279, depth: 1, leaf buckets: 1, nodes: 15 183s Average node length: 4.20, total dup: 0, max dup: 0 183s Average key length: 3.13, compression ratio: 0.96 183s Average prefix length: 1.87, average data length: 1.13 183s Clustering factor: 1, ratio: 0.07 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s DEPARTMENT (130) 183s Primary pointer page: 236, Index root page: 237 183s Pointer pages: 1, data page slots: 1 183s Data pages: 1, average fill: 24% 183s Primary pages: 1, secondary pages: 0, swept pages: 1 183s Empty pages: 0, full pages: 0 183s Fill distribution: 183s 0 - 19% = 0 183s 20 - 39% = 1 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index BUDGETX (3) 183s Root page: 298, depth: 1, leaf buckets: 1, nodes: 21 183s Average node length: 9.05, total dup: 7, max dup: 3 183s Average key length: 8.00, compression ratio: 1.12 183s Average prefix length: 3.62, average data length: 5.38 183s Clustering factor: 1, ratio: 0.05 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index RDB$4 (0) 183s Root page: 238, depth: 1, leaf buckets: 1, nodes: 21 183s Average node length: 17.95, total dup: 0, max dup: 0 183s Average key length: 16.57, compression ratio: 1.16 183s Average prefix length: 5.29, average data length: 13.95 183s Clustering factor: 1, ratio: 0.05 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index RDB$FOREIGN10 (4) 183s Root page: 250, depth: 1, leaf buckets: 1, nodes: 21 183s Average node length: 4.29, total dup: 3, max dup: 3 183s Average key length: 3.24, compression ratio: 0.60 183s Average prefix length: 0.81, average data length: 1.14 183s Clustering factor: 1, ratio: 0.05 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index RDB$FOREIGN6 (2) 183s Root page: 240, depth: 1, leaf buckets: 1, nodes: 21 183s Average node length: 4.10, total dup: 13, max dup: 4 183s Average key length: 2.95, compression ratio: 0.97 183s Average prefix length: 2.05, average data length: 0.81 183s Clustering factor: 1, ratio: 0.05 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index RDB$PRIMARY5 (1) 183s Root page: 239, depth: 1, leaf buckets: 1, nodes: 21 183s Average node length: 5.24, total dup: 0, max dup: 0 183s Average key length: 4.05, compression ratio: 0.74 183s Average prefix length: 1.29, average data length: 1.71 183s Clustering factor: 1, ratio: 0.05 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s EMPLOYEE (131) 183s Primary pointer page: 243, Index root page: 244 183s Pointer pages: 1, data page slots: 1 183s Data pages: 1, average fill: 44% 183s Primary pages: 1, secondary pages: 0, swept pages: 1 183s Empty pages: 0, full pages: 0 183s Fill distribution: 183s 0 - 19% = 0 183s 20 - 39% = 0 183s 40 - 59% = 1 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index NAMEX (3) 183s Root page: 299, depth: 1, leaf buckets: 1, nodes: 42 183s Average node length: 19.52, total dup: 0, max dup: 0 183s Average key length: 18.50, compression ratio: 0.96 183s Average prefix length: 2.17, average data length: 15.52 183s Clustering factor: 1, ratio: 0.02 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index RDB$FOREIGN8 (1) 183s Root page: 246, depth: 1, leaf buckets: 1, nodes: 42 183s Average node length: 4.07, total dup: 23, max dup: 4 183s Average key length: 2.98, compression ratio: 1.01 183s Average prefix length: 2.19, average data length: 0.81 183s Clustering factor: 1, ratio: 0.02 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index RDB$FOREIGN9 (2) 183s Root page: 247, depth: 1, leaf buckets: 1, nodes: 42 183s Average node length: 10.43, total dup: 15, max dup: 4 183s Average key length: 9.40, compression ratio: 1.68 183s Average prefix length: 9.05, average data length: 6.79 183s Clustering factor: 1, ratio: 0.02 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index RDB$PRIMARY7 (0) 183s Root page: 245, depth: 1, leaf buckets: 1, nodes: 42 183s Average node length: 4.62, total dup: 0, max dup: 0 183s Average key length: 3.60, compression ratio: 0.69 183s Average prefix length: 1.17, average data length: 1.31 183s Clustering factor: 1, ratio: 0.02 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s EMPLOYEE_PROJECT (134) 183s Primary pointer page: 258, Index root page: 259 183s Pointer pages: 1, data page slots: 1 183s Data pages: 1, average fill: 10% 183s Primary pages: 1, secondary pages: 0, swept pages: 0 183s Empty pages: 0, full pages: 0 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index RDB$FOREIGN15 (1) 183s Root page: 261, depth: 1, leaf buckets: 1, nodes: 28 183s Average node length: 4.29, total dup: 6, max dup: 2 183s Average key length: 3.25, compression ratio: 0.74 183s Average prefix length: 1.36, average data length: 1.04 183s Clustering factor: 1, ratio: 0.04 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index RDB$FOREIGN16 (2) 183s Root page: 262, depth: 1, leaf buckets: 1, nodes: 28 183s Average node length: 4.04, total dup: 23, max dup: 9 183s Average key length: 2.89, compression ratio: 1.73 183s Average prefix length: 4.14, average data length: 0.86 183s Clustering factor: 1, ratio: 0.04 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index RDB$PRIMARY14 (0) 183s Root page: 260, depth: 1, leaf buckets: 1, nodes: 28 183s Average node length: 13.11, total dup: 0, max dup: 0 183s Average key length: 12.07, compression ratio: 0.99 183s Average prefix length: 2.89, average data length: 9.11 183s Clustering factor: 1, ratio: 0.04 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s JOB (129) 183s Primary pointer page: 229, Index root page: 230 183s Pointer pages: 1, data page slots: 2 183s Data pages: 2, average fill: 43% 183s Primary pages: 1, secondary pages: 1, swept pages: 0 183s Empty pages: 0, full pages: 0 183s Fill distribution: 183s 0 - 19% = 0 183s 20 - 39% = 1 183s 40 - 59% = 1 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index MAXSALX (2) 183s Root page: 300, depth: 1, leaf buckets: 1, nodes: 31 183s Average node length: 14.74, total dup: 5, max dup: 1 183s Average key length: 13.71, compression ratio: 1.37 183s Average prefix length: 7.87, average data length: 10.90 183s Clustering factor: 1, ratio: 0.03 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index MINSALX (3) 183s Root page: 301, depth: 1, leaf buckets: 1, nodes: 31 183s Average node length: 14.06, total dup: 7, max dup: 2 183s Average key length: 13.03, compression ratio: 1.44 183s Average prefix length: 8.48, average data length: 10.29 183s Clustering factor: 1, ratio: 0.03 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index RDB$FOREIGN3 (1) 183s Root page: 232, depth: 1, leaf buckets: 1, nodes: 31 183s Average node length: 4.61, total dup: 24, max dup: 20 183s Average key length: 3.39, compression ratio: 1.23 183s Average prefix length: 2.77, average data length: 1.39 183s Clustering factor: 1, ratio: 0.03 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index RDB$PRIMARY2 (0) 183s Root page: 231, depth: 1, leaf buckets: 1, nodes: 31 183s Average node length: 14.45, total dup: 0, max dup: 0 183s Average key length: 13.42, compression ratio: 1.24 183s Average prefix length: 6.19, average data length: 10.45 183s Clustering factor: 1, ratio: 0.03 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s PROJECT (133) 183s Primary pointer page: 251, Index root page: 252 183s Pointer pages: 1, data page slots: 2 183s Data pages: 2, average fill: 7% 183s Primary pages: 1, secondary pages: 1, swept pages: 0 183s Empty pages: 0, full pages: 0 183s Fill distribution: 183s 0 - 19% = 2 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index PRODTYPEX (3) 183s Root page: 302, depth: 1, leaf buckets: 1, nodes: 6 183s Average node length: 26.50, total dup: 0, max dup: 0 183s Average key length: 25.33, compression ratio: 1.05 183s Average prefix length: 4.17, average data length: 22.50 183s Clustering factor: 1, ratio: 0.17 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index RDB$11 (0) 183s Root page: 253, depth: 1, leaf buckets: 1, nodes: 6 183s Average node length: 17.33, total dup: 0, max dup: 0 183s Average key length: 15.50, compression ratio: 0.88 183s Average prefix length: 0.33, average data length: 13.33 183s Clustering factor: 1, ratio: 0.17 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index RDB$FOREIGN13 (2) 183s Root page: 255, depth: 1, leaf buckets: 1, nodes: 6 183s Average node length: 4.67, total dup: 0, max dup: 0 183s Average key length: 3.50, compression ratio: 0.57 183s Average prefix length: 0.67, average data length: 1.33 183s Clustering factor: 1, ratio: 0.17 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index RDB$PRIMARY12 (1) 183s Root page: 254, depth: 1, leaf buckets: 1, nodes: 6 183s Average node length: 8.83, total dup: 0, max dup: 0 183s Average key length: 7.00, compression ratio: 0.71 183s Average prefix length: 0.17, average data length: 4.83 183s Clustering factor: 1, ratio: 0.17 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s PROJ_DEPT_BUDGET (135) 183s Primary pointer page: 265, Index root page: 266 183s Pointer pages: 1, data page slots: 1 183s Data pages: 1, average fill: 12% 183s Primary pages: 1, secondary pages: 0, swept pages: 0 183s Empty pages: 0, full pages: 0 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index RDB$FOREIGN18 (1) 183s Root page: 268, depth: 1, leaf buckets: 1, nodes: 24 183s Average node length: 3.92, total dup: 15, max dup: 5 183s Average key length: 2.79, compression ratio: 1.07 183s Average prefix length: 2.29, average data length: 0.71 183s Clustering factor: 1, ratio: 0.04 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index RDB$FOREIGN19 (2) 183s Root page: 269, depth: 1, leaf buckets: 1, nodes: 24 183s Average node length: 4.21, total dup: 19, max dup: 8 183s Average key length: 3.04, compression ratio: 1.64 183s Average prefix length: 4.00, average data length: 1.00 183s Clustering factor: 1, ratio: 0.04 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index RDB$PRIMARY17 (0) 183s Root page: 267, depth: 1, leaf buckets: 1, nodes: 24 183s Average node length: 10.71, total dup: 0, max dup: 0 183s Average key length: 9.67, compression ratio: 1.97 183s Average prefix length: 12.17, average data length: 6.83 183s Clustering factor: 1, ratio: 0.04 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s SALARY_HISTORY (136) 183s Primary pointer page: 270, Index root page: 271 183s Pointer pages: 1, data page slots: 1 183s Data pages: 1, average fill: 30% 183s Primary pages: 1, secondary pages: 0, swept pages: 0 183s Empty pages: 0, full pages: 0 183s Fill distribution: 183s 0 - 19% = 0 183s 20 - 39% = 1 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index CHANGEX (2) 183s Root page: 303, depth: 1, leaf buckets: 1, nodes: 49 183s Average node length: 3.37, total dup: 46, max dup: 21 183s Average key length: 2.35, compression ratio: 2.98 183s Average prefix length: 6.69, average data length: 0.31 183s Clustering factor: 1, ratio: 0.02 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index RDB$FOREIGN21 (1) 183s Root page: 273, depth: 1, leaf buckets: 1, nodes: 49 183s Average node length: 4.12, total dup: 16, max dup: 2 183s Average key length: 3.10, compression ratio: 0.75 183s Average prefix length: 1.43, average data length: 0.90 183s Clustering factor: 1, ratio: 0.02 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index RDB$PRIMARY20 (0) 183s Root page: 272, depth: 1, leaf buckets: 1, nodes: 49 183s Average node length: 22.29, total dup: 0, max dup: 0 183s Average key length: 21.27, compression ratio: 1.06 183s Average prefix length: 4.31, average data length: 18.29 183s Clustering factor: 1, ratio: 0.02 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index UPDATERX (3) 183s Root page: 304, depth: 1, leaf buckets: 1, nodes: 49 183s Average node length: 3.35, total dup: 46, max dup: 28 183s Average key length: 2.29, compression ratio: 2.48 183s Average prefix length: 5.39, average data length: 0.29 183s Clustering factor: 1, ratio: 0.02 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s SALES (138) 183s Primary pointer page: 284, Index root page: 285 183s Pointer pages: 1, data page slots: 1 183s Data pages: 1, average fill: 35% 183s Primary pages: 1, secondary pages: 0, swept pages: 0 183s Empty pages: 0, full pages: 0 183s Fill distribution: 183s 0 - 19% = 0 183s 20 - 39% = 1 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index NEEDX (3) 183s Root page: 305, depth: 1, leaf buckets: 1, nodes: 33 183s Average node length: 5.97, total dup: 11, max dup: 6 183s Average key length: 4.94, compression ratio: 1.10 183s Average prefix length: 2.88, average data length: 2.55 183s Clustering factor: 1, ratio: 0.03 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index QTYX (4) 183s Root page: 306, depth: 1, leaf buckets: 1, nodes: 33 183s Average node length: 5.06, total dup: 11, max dup: 3 183s Average key length: 4.03, compression ratio: 3.23 183s Average prefix length: 11.18, average data length: 1.85 183s Clustering factor: 1, ratio: 0.03 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index RDB$FOREIGN25 (1) 183s Root page: 287, depth: 1, leaf buckets: 1, nodes: 33 183s Average node length: 3.55, total dup: 18, max dup: 4 183s Average key length: 2.52, compression ratio: 1.19 183s Average prefix length: 2.48, average data length: 0.52 183s Clustering factor: 1, ratio: 0.03 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index RDB$FOREIGN26 (2) 183s Root page: 288, depth: 1, leaf buckets: 1, nodes: 33 183s Average node length: 3.67, total dup: 25, max dup: 7 183s Average key length: 2.64, compression ratio: 1.01 183s Average prefix length: 2.21, average data length: 0.45 183s Clustering factor: 1, ratio: 0.03 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index RDB$PRIMARY24 (0) 183s Root page: 286, depth: 1, leaf buckets: 1, nodes: 33 183s Average node length: 8.45, total dup: 0, max dup: 0 183s Average key length: 7.42, compression ratio: 1.08 183s Average prefix length: 3.52, average data length: 4.48 183s Clustering factor: 1, ratio: 0.03 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Index SALESTATX (5) 183s Root page: 307, depth: 1, leaf buckets: 1, nodes: 33 183s Average node length: 4.06, total dup: 27, max dup: 14 183s Average key length: 3.03, compression ratio: 3.56 183s Average prefix length: 9.82, average data length: 0.97 183s Clustering factor: 1, ratio: 0.03 183s Fill distribution: 183s 0 - 19% = 1 183s 20 - 39% = 0 183s 40 - 59% = 0 183s 60 - 79% = 0 183s 80 - 99% = 0 183s 183s Gstat completion time Fri May 2 04:30:21 2025 183s 183s V: Running gfix -v 183s V: Some big math 183s create table tbl1(fld1 int128); 183s insert into tbl1 values(12345); 183s select * from tbl1; 183s 183s FLD1 183s ============================================= 183s 12345 183s 183s autopkgtest [04:30:21]: test assorted-tools: -----------------------] 184s assorted-tools PASS 184s autopkgtest [04:30:22]: test assorted-tools: - - - - - - - - - - results - - - - - - - - - - 185s autopkgtest [04:30:23]: @@@@@@@@@@@@@@@@@@@@ summary 185s assorted-tools PASS 203s nova [W] Using flock in prodstack6-ppc64el 203s Creating nova instance adt-questing-ppc64el-firebird4.0-20250502-042718-juju-7f2275-prod-proposed-migration-environment-15-8fbccb99-e73c-407e-8b76-e9bfda648409 from image adt/ubuntu-questing-ppc64el-server-20250502.img (UUID 7a0939ac-dfd3-4678-92e9-ba08dcd47f5c)... 203s nova [W] Timed out waiting for 092499a4-27cd-4ddc-8514-679e158442f3 to get deleted.