0s autopkgtest [22:13:58]: starting date and time: 2025-02-15 22:13:58+0000 0s autopkgtest [22:13:58]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [22:13:58]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.sid64taa/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:glibc,src:iproute2,src:php-twig,src:postgresql-17,src:postgresql-common,src:roundcube --apt-upgrade firebird3.0 --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=glibc/2.41-1ubuntu1 iproute2/6.13.0-1ubuntu1 php-twig/3.19.0-1 postgresql-17/17.3-2 postgresql-common/273 roundcube/1.6.10+dfsg-1' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-arm64-1.secgroup --name adt-plucky-arm64-firebird3.0-20250215-221357-juju-7f2275-prod-proposed-migration-environment-2-07a89e4a-86ca-4684-9f8d-a3c708763755 --image adt/ubuntu-plucky-arm64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration -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/ 166s autopkgtest [22:16:44]: testbed dpkg architecture: arm64 167s autopkgtest [22:16:45]: testbed apt version: 2.9.28 167s autopkgtest [22:16:45]: @@@@@@@@@@@@@@@@@@@@ test bed setup 167s autopkgtest [22:16:45]: testbed release detected to be: None 168s autopkgtest [22:16:46]: updating testbed package index (apt update) 169s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [110 kB] 169s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 169s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 169s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 169s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [74.3 kB] 169s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [3120 B] 169s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [13.1 kB] 169s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [828 kB] 170s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 Packages [163 kB] 170s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted arm64 Packages [7960 B] 170s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 Packages [942 kB] 170s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse arm64 Packages [10.0 kB] 170s Fetched 2151 kB in 1s (1806 kB/s) 171s Reading package lists... 172s Reading package lists... 173s Building dependency tree... 173s Reading state information... 174s Calculating upgrade... 175s The following packages will be upgraded: 175s dash libtasn1-6 libxdmcp6 175s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 175s Need to get 151 kB of archives. 175s After this operation, 17.4 kB of additional disk space will be used. 175s Get:1 http://ftpmaster.internal/ubuntu plucky/main arm64 dash arm64 0.5.12-12ubuntu1 [96.1 kB] 175s Get:2 http://ftpmaster.internal/ubuntu plucky/main arm64 libtasn1-6 arm64 4.20.0-2 [43.9 kB] 175s Get:3 http://ftpmaster.internal/ubuntu plucky/main arm64 libxdmcp6 arm64 1:1.1.5-1 [10.7 kB] 176s Preconfiguring packages ... 176s Fetched 151 kB in 1s (292 kB/s) 177s (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 ... 116609 files and directories currently installed.) 177s Preparing to unpack .../dash_0.5.12-12ubuntu1_arm64.deb ... 177s Unpacking dash (0.5.12-12ubuntu1) over (0.5.12-9ubuntu1) ... 177s Setting up dash (0.5.12-12ubuntu1) ... 177s (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 ... 116609 files and directories currently installed.) 177s Preparing to unpack .../libtasn1-6_4.20.0-2_arm64.deb ... 177s Unpacking libtasn1-6:arm64 (4.20.0-2) over (4.19.0-3build1) ... 177s Preparing to unpack .../libxdmcp6_1%3a1.1.5-1_arm64.deb ... 177s Unpacking libxdmcp6:arm64 (1:1.1.5-1) over (1:1.1.3-0ubuntu6) ... 177s Setting up libxdmcp6:arm64 (1:1.1.5-1) ... 177s Setting up libtasn1-6:arm64 (4.20.0-2) ... 177s Processing triggers for libc-bin (2.40-4ubuntu1) ... 177s Processing triggers for man-db (2.13.0-1) ... 178s Processing triggers for debianutils (5.21) ... 179s Reading package lists... 179s Building dependency tree... 179s Reading state information... 180s 0 upgraded, 0 newly installed, 0 to remove and 6 not upgraded. 180s autopkgtest [22:16:58]: upgrading testbed (apt dist-upgrade and autopurge) 181s Reading package lists... 181s Building dependency tree... 181s Reading state information... 182s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 182s Starting 2 pkgProblemResolver with broken count: 0 182s Done 183s Entering ResolveByKeep 184s 185s The following packages will be upgraded: 185s iproute2 libc-bin libc-dev-bin libc6 libc6-dev locales 185s 6 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 185s Need to get 10.7 MB of archives. 185s After this operation, 358 kB of additional disk space will be used. 185s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc-dev-bin arm64 2.41-1ubuntu1 [24.0 kB] 185s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc6-dev arm64 2.41-1ubuntu1 [1750 kB] 186s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 locales all 2.41-1ubuntu1 [4246 kB] 186s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc6 arm64 2.41-1ubuntu1 [2910 kB] 186s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc-bin arm64 2.41-1ubuntu1 [600 kB] 186s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 iproute2 arm64 6.13.0-1ubuntu1 [1158 kB] 187s Preconfiguring packages ... 187s Fetched 10.7 MB in 2s (5938 kB/s) 187s (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 ... 116609 files and directories currently installed.) 187s Preparing to unpack .../libc-dev-bin_2.41-1ubuntu1_arm64.deb ... 187s Unpacking libc-dev-bin (2.41-1ubuntu1) over (2.40-4ubuntu1) ... 187s Preparing to unpack .../libc6-dev_2.41-1ubuntu1_arm64.deb ... 187s Unpacking libc6-dev:arm64 (2.41-1ubuntu1) over (2.40-4ubuntu1) ... 188s Preparing to unpack .../locales_2.41-1ubuntu1_all.deb ... 188s Unpacking locales (2.41-1ubuntu1) over (2.40-4ubuntu1) ... 188s Preparing to unpack .../libc6_2.41-1ubuntu1_arm64.deb ... 188s Checking for services that may need to be restarted... 188s Checking init scripts... 188s Checking for services that may need to be restarted... 188s Checking init scripts... 188s Stopping some services possibly affected by the upgrade (will be restarted later): 189s cron: stopping...done. 189s 189s Unpacking libc6:arm64 (2.41-1ubuntu1) over (2.40-4ubuntu1) ... 189s Setting up libc6:arm64 (2.41-1ubuntu1) ... 189s Checking for services that may need to be restarted... 189s Checking init scripts... 189s Restarting services possibly affected by the upgrade: 189s cron: restarting...done. 189s 189s Services restarted successfully. 189s (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 ... 116610 files and directories currently installed.) 189s Preparing to unpack .../libc-bin_2.41-1ubuntu1_arm64.deb ... 189s Unpacking libc-bin (2.41-1ubuntu1) over (2.40-4ubuntu1) ... 190s Setting up libc-bin (2.41-1ubuntu1) ... 190s (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 ... 116610 files and directories currently installed.) 190s Preparing to unpack .../iproute2_6.13.0-1ubuntu1_arm64.deb ... 190s Unpacking iproute2 (6.13.0-1ubuntu1) over (6.10.0-2ubuntu1) ... 191s Setting up iproute2 (6.13.0-1ubuntu1) ... 191s Setting up locales (2.41-1ubuntu1) ... 191s Installing new version of config file /etc/locale.alias ... 193s Generating locales (this might take a while)... 196s en_US.UTF-8... done 196s Generation complete. 196s Setting up libc-dev-bin (2.41-1ubuntu1) ... 196s Setting up libc6-dev:arm64 (2.41-1ubuntu1) ... 196s Processing triggers for man-db (2.13.0-1) ... 197s Processing triggers for systemd (257.2-3ubuntu1) ... 198s Reading package lists... 199s Building dependency tree... 199s Reading state information... 200s Starting pkgProblemResolver with broken count: 0 200s Starting 2 pkgProblemResolver with broken count: 0 200s Done 201s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 204s autopkgtest [22:17:22]: testbed running kernel: Linux 6.12.0-15-generic #15-Ubuntu SMP PREEMPT_DYNAMIC Tue Feb 4 15:49:33 UTC 2025 204s autopkgtest [22:17:22]: @@@@@@@@@@@@@@@@@@@@ apt-source firebird3.0 212s Get:1 http://ftpmaster.internal/ubuntu plucky/universe firebird3.0 3.0.12.ds7-11 (dsc) [2632 B] 212s Get:2 http://ftpmaster.internal/ubuntu plucky/universe firebird3.0 3.0.12.ds7-11 (tar) [3425 kB] 212s Get:3 http://ftpmaster.internal/ubuntu plucky/universe firebird3.0 3.0.12.ds7-11 (diff) [109 kB] 212s gpgv: Signature made Sat Feb 8 11:43:11 2025 UTC 212s gpgv: using RSA key AEA0C44ECB056E93630D9D33DBBE9D4D99D2A004 212s gpgv: Can't check signature: No public key 212s dpkg-source: warning: cannot verify inline signature for ./firebird3.0_3.0.12.ds7-11.dsc: no acceptable signature found 213s autopkgtest [22:17:31]: testing package firebird3.0 version 3.0.12.ds7-11 214s autopkgtest [22:17:32]: build not needed 216s autopkgtest [22:17:34]: test assorted-tools: preparing testbed 216s Reading package lists... 217s Building dependency tree... 217s Reading state information... 217s Starting pkgProblemResolver with broken count: 0 218s Starting 2 pkgProblemResolver with broken count: 0 218s Done 219s The following NEW packages will be installed: 219s firebird-utils firebird3.0-common firebird3.0-common-doc 219s firebird3.0-examples firebird3.0-server-core firebird3.0-utils 219s firebird4.0-common firebird4.0-common-doc libfbclient2 libib-util 219s libtommath1 219s 0 upgraded, 11 newly installed, 0 to remove and 0 not upgraded. 219s Need to get 4763 kB of archives. 219s After this operation, 16.2 MB of additional disk space will be used. 219s Get:1 http://ftpmaster.internal/ubuntu plucky/universe arm64 firebird4.0-common-doc all 4.0.5.3140.ds6-15 [28.3 kB] 219s Get:2 http://ftpmaster.internal/ubuntu plucky/universe arm64 firebird3.0-common-doc all 3.0.12.ds7-11 [30.5 kB] 219s Get:3 http://ftpmaster.internal/ubuntu plucky/universe arm64 firebird3.0-common all 3.0.12.ds7-11 [17.2 kB] 219s Get:4 http://ftpmaster.internal/ubuntu plucky/universe arm64 firebird4.0-common all 4.0.5.3140.ds6-15 [18.5 kB] 219s Get:5 http://ftpmaster.internal/ubuntu plucky/universe arm64 libtommath1 arm64 1.3.0-1 [59.1 kB] 219s Get:6 http://ftpmaster.internal/ubuntu plucky/universe arm64 libfbclient2 arm64 4.0.5.3140.ds6-15 [857 kB] 219s Get:7 http://ftpmaster.internal/ubuntu plucky/universe arm64 firebird3.0-utils arm64 3.0.12.ds7-11 [972 kB] 220s Get:8 http://ftpmaster.internal/ubuntu plucky/universe arm64 firebird-utils all 4.0.5.3140.ds6-15 [3714 B] 220s Get:9 http://ftpmaster.internal/ubuntu plucky/universe arm64 firebird3.0-examples all 3.0.12.ds7-11 [119 kB] 220s Get:10 http://ftpmaster.internal/ubuntu plucky/universe arm64 libib-util arm64 4.0.5.3140.ds6-15 [3468 B] 220s Get:11 http://ftpmaster.internal/ubuntu plucky/universe arm64 firebird3.0-server-core arm64 3.0.12.ds7-11 [2653 kB] 220s Fetched 4763 kB in 1s (5376 kB/s) 221s Selecting previously unselected package firebird4.0-common-doc. 221s (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 ... 116611 files and directories currently installed.) 221s Preparing to unpack .../00-firebird4.0-common-doc_4.0.5.3140.ds6-15_all.deb ... 221s Unpacking firebird4.0-common-doc (4.0.5.3140.ds6-15) ... 221s Selecting previously unselected package firebird3.0-common-doc. 221s Preparing to unpack .../01-firebird3.0-common-doc_3.0.12.ds7-11_all.deb ... 221s Unpacking firebird3.0-common-doc (3.0.12.ds7-11) ... 221s Selecting previously unselected package firebird3.0-common. 221s Preparing to unpack .../02-firebird3.0-common_3.0.12.ds7-11_all.deb ... 221s Unpacking firebird3.0-common (3.0.12.ds7-11) ... 221s Selecting previously unselected package firebird4.0-common. 221s Preparing to unpack .../03-firebird4.0-common_4.0.5.3140.ds6-15_all.deb ... 221s Unpacking firebird4.0-common (4.0.5.3140.ds6-15) ... 221s Selecting previously unselected package libtommath1:arm64. 221s Preparing to unpack .../04-libtommath1_1.3.0-1_arm64.deb ... 221s Unpacking libtommath1:arm64 (1.3.0-1) ... 221s Selecting previously unselected package libfbclient2:arm64. 221s Preparing to unpack .../05-libfbclient2_4.0.5.3140.ds6-15_arm64.deb ... 221s Unpacking libfbclient2:arm64 (4.0.5.3140.ds6-15) ... 221s Selecting previously unselected package firebird3.0-utils. 221s Preparing to unpack .../06-firebird3.0-utils_3.0.12.ds7-11_arm64.deb ... 221s Unpacking firebird3.0-utils (3.0.12.ds7-11) ... 221s Selecting previously unselected package firebird-utils. 221s Preparing to unpack .../07-firebird-utils_4.0.5.3140.ds6-15_all.deb ... 221s Unpacking firebird-utils (4.0.5.3140.ds6-15) ... 221s Selecting previously unselected package firebird3.0-examples. 221s Preparing to unpack .../08-firebird3.0-examples_3.0.12.ds7-11_all.deb ... 221s Unpacking firebird3.0-examples (3.0.12.ds7-11) ... 222s Selecting previously unselected package libib-util:arm64. 222s Preparing to unpack .../09-libib-util_4.0.5.3140.ds6-15_arm64.deb ... 222s Unpacking libib-util:arm64 (4.0.5.3140.ds6-15) ... 222s Selecting previously unselected package firebird3.0-server-core:arm64. 222s Preparing to unpack .../10-firebird3.0-server-core_3.0.12.ds7-11_arm64.deb ... 222s Unpacking firebird3.0-server-core:arm64 (3.0.12.ds7-11) ... 222s Setting up libtommath1:arm64 (1.3.0-1) ... 222s Setting up firebird4.0-common-doc (4.0.5.3140.ds6-15) ... 222s Setting up firebird3.0-common-doc (3.0.12.ds7-11) ... 222s Setting up firebird3.0-common (3.0.12.ds7-11) ... 222s Configuring /etc/firebird/3.0/service-port.conf to use port 3050 222s Setting up firebird4.0-common (4.0.5.3140.ds6-15) ... 222s Configuring /etc/firebird/4.0/service-port.conf to use port 3051 222s Setting up libib-util:arm64 (4.0.5.3140.ds6-15) ... 222s Setting up firebird3.0-examples (3.0.12.ds7-11) ... 222s Setting up libfbclient2:arm64 (4.0.5.3140.ds6-15) ... 222s Setting up firebird3.0-server-core:arm64 (3.0.12.ds7-11) ... 222s Setting up firebird-utils (4.0.5.3140.ds6-15) ... 222s Setting up firebird3.0-utils (3.0.12.ds7-11) ... 222s update-alternatives: using /usr/share/firebird/3.0/man/man8/firebird.8.gz to provide /usr/share/man/man8/firebird.8.gz (firebird) in auto mode 222s Processing triggers for libc-bin (2.41-1ubuntu1) ... 222s Processing triggers for man-db (2.13.0-1) ... 225s autopkgtest [22:17:43]: test assorted-tools: [----------------------- 225s V: Creating employee.fdb via isql-fb -i 228s V: Backing up 228s V: Restoring the backup 229s V: Extracting definition of employee.fdb via isql-fb -a 229s V: Checking the size of employee.sql 229s -rw-rw-r-- 1 ubuntu ubuntu 21663 Feb 15 22:17 employee.sql 229s V: Running fbstat on employee.fdb 229s 229s Database "/tmp/autopkgtest.jEuwXl/assorted-tools-artifacts/employee.fdb" 229s Gstat execution time Sat Feb 15 22:17:47 2025 229s 229s Database header page information: 229s Flags 0 229s Generation 161 229s System Change Number 0 229s Page size 8192 229s ODS version 12.0 229s Oldest transaction 155 229s Oldest active 156 229s Oldest snapshot 156 229s Next transaction 156 229s Sequence number 0 229s Next attachment ID 9 229s Implementation HW=ARM64 little-endian OS=Linux CC=gcc 229s Shadow count 0 229s Page buffers 0 229s Next header page 0 229s Database dialect 3 229s Creation date Feb 15, 2025 22:17:43 229s Attributes force write 229s 229s Variable header data: 229s *END* 229s 229s 229s Database file sequence: 229s File /tmp/autopkgtest.jEuwXl/assorted-tools-artifacts/employee.fdb is the only file 229s 229s Analyzing database pages ... 229s COUNTRY (128) 229s Primary pointer page: 182, Index root page: 183 229s Pointer pages: 1, data page slots: 1 229s Data pages: 1, average fill: 8% 229s Primary pages: 1, secondary pages: 0, swept pages: 0 229s Empty pages: 0, full pages: 0 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index RDB$PRIMARY1 (0) 229s Root page: 186, depth: 1, leaf buckets: 1, nodes: 16 229s Average node length: 10.44, total dup: 0, max dup: 0 229s Average key length: 8.62, compression ratio: 0.80 229s Average prefix length: 0.44, average data length: 6.44 229s Clustering factor: 1, ratio: 0.06 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s CUSTOMER (137) 229s Primary pointer page: 253, Index root page: 254 229s Pointer pages: 1, data page slots: 1 229s Data pages: 1, average fill: 26% 229s Primary pages: 1, secondary pages: 0, swept pages: 1 229s Empty pages: 0, full pages: 0 229s Fill distribution: 229s 0 - 19% = 0 229s 20 - 39% = 1 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index CUSTNAMEX (2) 229s Root page: 268, depth: 1, leaf buckets: 1, nodes: 15 229s Average node length: 19.87, total dup: 0, max dup: 0 229s Average key length: 18.27, compression ratio: 0.90 229s Average prefix length: 0.60, average data length: 15.87 229s Clustering factor: 1, ratio: 0.07 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index CUSTREGION (3) 229s Root page: 275, depth: 1, leaf buckets: 1, nodes: 15 229s Average node length: 21.27, total dup: 0, max dup: 0 229s Average key length: 20.20, compression ratio: 0.97 229s Average prefix length: 2.33, average data length: 17.27 229s Clustering factor: 1, ratio: 0.07 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index RDB$FOREIGN23 (1) 229s Root page: 256, depth: 1, leaf buckets: 1, nodes: 15 229s Average node length: 8.60, total dup: 4, max dup: 4 229s Average key length: 6.93, compression ratio: 0.83 229s Average prefix length: 0.87, average data length: 4.87 229s Clustering factor: 1, ratio: 0.07 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index RDB$PRIMARY22 (0) 229s Root page: 255, depth: 1, leaf buckets: 1, nodes: 15 229s Average node length: 4.20, total dup: 0, max dup: 0 229s Average key length: 3.13, compression ratio: 0.96 229s Average prefix length: 1.87, average data length: 1.13 229s Clustering factor: 1, ratio: 0.07 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s DEPARTMENT (130) 229s Primary pointer page: 206, Index root page: 207 229s Pointer pages: 1, data page slots: 1 229s Data pages: 1, average fill: 24% 229s Primary pages: 1, secondary pages: 0, swept pages: 1 229s Empty pages: 0, full pages: 0 229s Fill distribution: 229s 0 - 19% = 0 229s 20 - 39% = 1 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index BUDGETX (3) 229s Root page: 276, depth: 1, leaf buckets: 1, nodes: 21 229s Average node length: 9.05, total dup: 7, max dup: 3 229s Average key length: 8.00, compression ratio: 1.12 229s Average prefix length: 3.62, average data length: 5.38 229s Clustering factor: 1, ratio: 0.05 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index RDB$4 (0) 229s Root page: 208, depth: 1, leaf buckets: 1, nodes: 21 229s Average node length: 17.95, total dup: 0, max dup: 0 229s Average key length: 16.57, compression ratio: 1.16 229s Average prefix length: 5.29, average data length: 13.95 229s Clustering factor: 1, ratio: 0.05 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index RDB$FOREIGN10 (4) 229s Root page: 219, depth: 1, leaf buckets: 1, nodes: 21 229s Average node length: 4.29, total dup: 3, max dup: 3 229s Average key length: 3.24, compression ratio: 0.60 229s Average prefix length: 0.81, average data length: 1.14 229s Clustering factor: 1, ratio: 0.05 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index RDB$FOREIGN6 (2) 229s Root page: 210, depth: 1, leaf buckets: 1, nodes: 21 229s Average node length: 4.10, total dup: 13, max dup: 4 229s Average key length: 2.95, compression ratio: 0.97 229s Average prefix length: 2.05, average data length: 0.81 229s Clustering factor: 1, ratio: 0.05 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index RDB$PRIMARY5 (1) 229s Root page: 209, depth: 1, leaf buckets: 1, nodes: 21 229s Average node length: 5.24, total dup: 0, max dup: 0 229s Average key length: 4.05, compression ratio: 0.74 229s Average prefix length: 1.29, average data length: 1.71 229s Clustering factor: 1, ratio: 0.05 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s EMPLOYEE (131) 229s Primary pointer page: 212, Index root page: 213 229s Pointer pages: 1, data page slots: 1 229s Data pages: 1, average fill: 44% 229s Primary pages: 1, secondary pages: 0, swept pages: 1 229s Empty pages: 0, full pages: 0 229s Fill distribution: 229s 0 - 19% = 0 229s 20 - 39% = 0 229s 40 - 59% = 1 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index NAMEX (3) 229s Root page: 277, depth: 1, leaf buckets: 1, nodes: 42 229s Average node length: 19.52, total dup: 0, max dup: 0 229s Average key length: 18.50, compression ratio: 0.96 229s Average prefix length: 2.17, average data length: 15.52 229s Clustering factor: 1, ratio: 0.02 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index RDB$FOREIGN8 (1) 229s Root page: 215, depth: 1, leaf buckets: 1, nodes: 42 229s Average node length: 4.07, total dup: 23, max dup: 4 229s Average key length: 2.98, compression ratio: 1.01 229s Average prefix length: 2.19, average data length: 0.81 229s Clustering factor: 1, ratio: 0.02 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index RDB$FOREIGN9 (2) 229s Root page: 216, depth: 1, leaf buckets: 1, nodes: 42 229s Average node length: 10.43, total dup: 15, max dup: 4 229s Average key length: 9.40, compression ratio: 1.68 229s Average prefix length: 9.05, average data length: 6.79 229s Clustering factor: 1, ratio: 0.02 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index RDB$PRIMARY7 (0) 229s Root page: 214, depth: 1, leaf buckets: 1, nodes: 42 229s Average node length: 4.62, total dup: 0, max dup: 0 229s Average key length: 3.60, compression ratio: 0.69 229s Average prefix length: 1.17, average data length: 1.31 229s Clustering factor: 1, ratio: 0.02 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s EMPLOYEE_PROJECT (134) 229s Primary pointer page: 226, Index root page: 227 229s Pointer pages: 1, data page slots: 1 229s Data pages: 1, average fill: 10% 229s Primary pages: 1, secondary pages: 0, swept pages: 0 229s Empty pages: 0, full pages: 0 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index RDB$FOREIGN15 (1) 229s Root page: 229, depth: 1, leaf buckets: 1, nodes: 28 229s Average node length: 4.29, total dup: 6, max dup: 2 229s Average key length: 3.25, compression ratio: 0.74 229s Average prefix length: 1.36, average data length: 1.04 229s Clustering factor: 1, ratio: 0.04 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index RDB$FOREIGN16 (2) 229s Root page: 230, depth: 1, leaf buckets: 1, nodes: 28 229s Average node length: 4.04, total dup: 23, max dup: 9 229s Average key length: 2.89, compression ratio: 1.73 229s Average prefix length: 4.14, average data length: 0.86 229s Clustering factor: 1, ratio: 0.04 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index RDB$PRIMARY14 (0) 229s Root page: 228, depth: 1, leaf buckets: 1, nodes: 28 229s Average node length: 13.11, total dup: 0, max dup: 0 229s Average key length: 12.07, compression ratio: 0.99 229s Average prefix length: 2.89, average data length: 9.11 229s Clustering factor: 1, ratio: 0.04 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s JOB (129) 229s Primary pointer page: 189, Index root page: 190 229s Pointer pages: 1, data page slots: 2 229s Data pages: 2, average fill: 43% 229s Primary pages: 1, secondary pages: 1, swept pages: 0 229s Empty pages: 0, full pages: 0 229s Fill distribution: 229s 0 - 19% = 0 229s 20 - 39% = 1 229s 40 - 59% = 1 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index MAXSALX (2) 229s Root page: 278, depth: 1, leaf buckets: 1, nodes: 31 229s Average node length: 14.74, total dup: 5, max dup: 1 229s Average key length: 13.71, compression ratio: 1.37 229s Average prefix length: 7.87, average data length: 10.90 229s Clustering factor: 1, ratio: 0.03 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index MINSALX (3) 229s Root page: 279, depth: 1, leaf buckets: 1, nodes: 31 229s Average node length: 14.06, total dup: 7, max dup: 2 229s Average key length: 13.03, compression ratio: 1.44 229s Average prefix length: 8.48, average data length: 10.29 229s Clustering factor: 1, ratio: 0.03 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index RDB$FOREIGN3 (1) 229s Root page: 200, depth: 1, leaf buckets: 1, nodes: 31 229s Average node length: 4.61, total dup: 24, max dup: 20 229s Average key length: 3.39, compression ratio: 1.23 229s Average prefix length: 2.77, average data length: 1.39 229s Clustering factor: 1, ratio: 0.03 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index RDB$PRIMARY2 (0) 229s Root page: 191, depth: 1, leaf buckets: 1, nodes: 31 229s Average node length: 14.45, total dup: 0, max dup: 0 229s Average key length: 13.42, compression ratio: 1.24 229s Average prefix length: 6.19, average data length: 10.45 229s Clustering factor: 1, ratio: 0.03 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s PROJECT (133) 229s Primary pointer page: 220, Index root page: 221 229s Pointer pages: 1, data page slots: 2 229s Data pages: 2, average fill: 7% 229s Primary pages: 1, secondary pages: 1, swept pages: 0 229s Empty pages: 0, full pages: 0 229s Fill distribution: 229s 0 - 19% = 2 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index PRODTYPEX (3) 229s Root page: 288, depth: 1, leaf buckets: 1, nodes: 6 229s Average node length: 26.50, total dup: 0, max dup: 0 229s Average key length: 25.33, compression ratio: 1.05 229s Average prefix length: 4.17, average data length: 22.50 229s Clustering factor: 1, ratio: 0.17 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index RDB$11 (0) 229s Root page: 222, depth: 1, leaf buckets: 1, nodes: 6 229s Average node length: 17.33, total dup: 0, max dup: 0 229s Average key length: 15.50, compression ratio: 0.88 229s Average prefix length: 0.33, average data length: 13.33 229s Clustering factor: 1, ratio: 0.17 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index RDB$FOREIGN13 (2) 229s Root page: 224, depth: 1, leaf buckets: 1, nodes: 6 229s Average node length: 4.67, total dup: 0, max dup: 0 229s Average key length: 3.50, compression ratio: 0.57 229s Average prefix length: 0.67, average data length: 1.33 229s Clustering factor: 1, ratio: 0.17 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index RDB$PRIMARY12 (1) 229s Root page: 223, depth: 1, leaf buckets: 1, nodes: 6 229s Average node length: 8.83, total dup: 0, max dup: 0 229s Average key length: 7.00, compression ratio: 0.71 229s Average prefix length: 0.17, average data length: 4.83 229s Clustering factor: 1, ratio: 0.17 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s PROJ_DEPT_BUDGET (135) 229s Primary pointer page: 231, Index root page: 240 229s Pointer pages: 1, data page slots: 1 229s Data pages: 1, average fill: 12% 229s Primary pages: 1, secondary pages: 0, swept pages: 0 229s Empty pages: 0, full pages: 0 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index RDB$FOREIGN18 (1) 229s Root page: 242, depth: 1, leaf buckets: 1, nodes: 24 229s Average node length: 3.92, total dup: 15, max dup: 5 229s Average key length: 2.79, compression ratio: 1.07 229s Average prefix length: 2.29, average data length: 0.71 229s Clustering factor: 1, ratio: 0.04 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index RDB$FOREIGN19 (2) 229s Root page: 243, depth: 1, leaf buckets: 1, nodes: 24 229s Average node length: 4.21, total dup: 19, max dup: 8 229s Average key length: 3.04, compression ratio: 1.64 229s Average prefix length: 4.00, average data length: 1.00 229s Clustering factor: 1, ratio: 0.04 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index RDB$PRIMARY17 (0) 229s Root page: 241, depth: 1, leaf buckets: 1, nodes: 24 229s Average node length: 10.71, total dup: 0, max dup: 0 229s Average key length: 9.67, compression ratio: 1.97 229s Average prefix length: 12.17, average data length: 6.83 229s Clustering factor: 1, ratio: 0.04 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s SALARY_HISTORY (136) 229s Primary pointer page: 246, Index root page: 247 229s Pointer pages: 1, data page slots: 1 229s Data pages: 1, average fill: 30% 229s Primary pages: 1, secondary pages: 0, swept pages: 0 229s Empty pages: 0, full pages: 0 229s Fill distribution: 229s 0 - 19% = 0 229s 20 - 39% = 1 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index CHANGEX (2) 229s Root page: 289, depth: 1, leaf buckets: 1, nodes: 49 229s Average node length: 3.37, total dup: 46, max dup: 21 229s Average key length: 2.35, compression ratio: 2.98 229s Average prefix length: 6.69, average data length: 0.31 229s Clustering factor: 1, ratio: 0.02 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index RDB$FOREIGN21 (1) 229s Root page: 249, depth: 1, leaf buckets: 1, nodes: 49 229s Average node length: 4.12, total dup: 16, max dup: 2 229s Average key length: 3.10, compression ratio: 0.75 229s Average prefix length: 1.43, average data length: 0.90 229s Clustering factor: 1, ratio: 0.02 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index RDB$PRIMARY20 (0) 229s Root page: 248, depth: 1, leaf buckets: 1, nodes: 49 229s Average node length: 22.29, total dup: 0, max dup: 0 229s Average key length: 21.27, compression ratio: 1.06 229s Average prefix length: 4.31, average data length: 18.29 229s Clustering factor: 1, ratio: 0.02 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index UPDATERX (3) 229s Root page: 290, depth: 1, leaf buckets: 1, nodes: 49 229s Average node length: 3.35, total dup: 46, max dup: 28 229s Average key length: 2.29, compression ratio: 2.48 229s Average prefix length: 5.39, average data length: 0.29 229s Clustering factor: 1, ratio: 0.02 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s SALES (138) 229s Primary pointer page: 259, Index root page: 260 229s Pointer pages: 1, data page slots: 1 229s Data pages: 1, average fill: 35% 229s Primary pages: 1, secondary pages: 0, swept pages: 0 229s Empty pages: 0, full pages: 0 229s Fill distribution: 229s 0 - 19% = 0 229s 20 - 39% = 1 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index NEEDX (3) 229s Root page: 291, depth: 1, leaf buckets: 1, nodes: 33 229s Average node length: 5.97, total dup: 11, max dup: 6 229s Average key length: 4.94, compression ratio: 1.10 229s Average prefix length: 2.88, average data length: 2.55 229s Clustering factor: 1, ratio: 0.03 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index QTYX (4) 229s Root page: 292, depth: 1, leaf buckets: 1, nodes: 33 229s Average node length: 5.06, total dup: 11, max dup: 3 229s Average key length: 4.03, compression ratio: 3.23 229s Average prefix length: 11.18, average data length: 1.85 229s Clustering factor: 1, ratio: 0.03 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index RDB$FOREIGN25 (1) 229s Root page: 262, depth: 1, leaf buckets: 1, nodes: 33 229s Average node length: 3.55, total dup: 18, max dup: 4 229s Average key length: 2.52, compression ratio: 1.19 229s Average prefix length: 2.48, average data length: 0.52 229s Clustering factor: 1, ratio: 0.03 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index RDB$FOREIGN26 (2) 229s Root page: 263, depth: 1, leaf buckets: 1, nodes: 33 229s Average node length: 3.67, total dup: 25, max dup: 7 229s Average key length: 2.64, compression ratio: 1.01 229s Average prefix length: 2.21, average data length: 0.45 229s Clustering factor: 1, ratio: 0.03 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index RDB$PRIMARY24 (0) 229s Root page: 261, depth: 1, leaf buckets: 1, nodes: 33 229s Average node length: 8.45, total dup: 0, max dup: 0 229s Average key length: 7.42, compression ratio: 1.08 229s Average prefix length: 3.52, average data length: 4.48 229s Clustering factor: 1, ratio: 0.03 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Index SALESTATX (5) 229s Root page: 293, depth: 1, leaf buckets: 1, nodes: 33 229s Average node length: 4.06, total dup: 27, max dup: 14 229s Average key length: 3.03, compression ratio: 3.56 229s Average prefix length: 9.82, average data length: 0.97 229s Clustering factor: 1, ratio: 0.03 229s Fill distribution: 229s 0 - 19% = 1 229s 20 - 39% = 0 229s 40 - 59% = 0 229s 60 - 79% = 0 229s 80 - 99% = 0 229s 229s Gstat completion time Sat Feb 15 22:17:47 2025 229s 229s V: Running gfix -v 229s autopkgtest [22:17:47]: test assorted-tools: -----------------------] 230s autopkgtest [22:17:48]: test assorted-tools: - - - - - - - - - - results - - - - - - - - - - 230s assorted-tools PASS 231s autopkgtest [22:17:49]: @@@@@@@@@@@@@@@@@@@@ summary 231s assorted-tools PASS 250s nova [W] Using flock in prodstack6-arm64 250s Creating nova instance adt-plucky-arm64-firebird3.0-20250215-221357-juju-7f2275-prod-proposed-migration-environment-2-07a89e4a-86ca-4684-9f8d-a3c708763755 from image adt/ubuntu-plucky-arm64-server-20250215.img (UUID 8f82fa69-4462-4e93-a46b-73be9ea2c381)... 250s nova [W] Timed out waiting for e46ca00a-c9c1-497b-9875-e8860bd29d66 to get deleted.