0s autopkgtest [22:22:36]: starting date and time: 2025-02-15 22:22:36+0000
  0s autopkgtest [22:22:36]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production'
  0s autopkgtest [22:22:36]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.edtd17de/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 firebird4.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-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-s390x-12.secgroup --name adt-plucky-s390x-firebird4.0-20250215-222236-juju-7f2275-prod-proposed-migration-environment-2-21ce05e0-c31f-4ef5-bec4-d8ffb168f826 --image adt/ubuntu-plucky-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration-s390x -e TERM=linux -e ''"'"'http_proxy=http://squid.internal:3128'"'"'' -e ''"'"'https_proxy=http://squid.internal:3128'"'"'' -e ''"'"'no_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com,radosgw.ps5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/
109s autopkgtest [22:24:25]: testbed dpkg architecture: s390x
109s autopkgtest [22:24:25]: testbed apt version: 2.9.28
109s autopkgtest [22:24:25]: @@@@@@@@@@@@@@@@@@@@ test bed setup
110s autopkgtest [22:24:26]: testbed release detected to be: None
110s autopkgtest [22:24:26]: updating testbed package index (apt update)
111s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [110 kB]
111s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease
111s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease
111s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease
111s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [828 kB]
112s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [74.3 kB]
112s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [3120 B]
112s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [13.1 kB]
112s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [163 kB]
112s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted s390x Packages [760 B]
112s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [876 kB]
112s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [3740 B]
112s Fetched 2073 kB in 1s (1939 kB/s)
112s Reading package lists...
113s Reading package lists...
113s Building dependency tree...
113s Reading state information...
113s Calculating upgrade...
114s The following packages were automatically installed and are no longer required:
114s   libnsl2 libpython3.12-minimal libpython3.12-stdlib libpython3.12t64
114s   linux-headers-6.11.0-8 linux-headers-6.11.0-8-generic
114s   linux-modules-6.11.0-8-generic linux-tools-6.11.0-8
114s   linux-tools-6.11.0-8-generic
114s Use 'sudo apt autoremove' to remove them.
114s The following packages will be upgraded:
114s   dash gcc-14-base libatomic1 libgcc-s1 libstdc++6 libtasn1-6 libxdmcp6
114s 7 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
114s Need to get 1155 kB of archives.
114s After this operation, 16.4 kB of additional disk space will be used.
114s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x dash s390x 0.5.12-12ubuntu1 [100 kB]
114s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x libatomic1 s390x 14.2.0-17ubuntu1 [9430 B]
114s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x gcc-14-base s390x 14.2.0-17ubuntu1 [53.5 kB]
114s Get:4 http://ftpmaster.internal/ubuntu plucky/main s390x libstdc++6 s390x 14.2.0-17ubuntu1 [896 kB]
114s Get:5 http://ftpmaster.internal/ubuntu plucky/main s390x libgcc-s1 s390x 14.2.0-17ubuntu1 [35.9 kB]
114s Get:6 http://ftpmaster.internal/ubuntu plucky/main s390x libtasn1-6 s390x 4.20.0-2 [48.6 kB]
114s Get:7 http://ftpmaster.internal/ubuntu plucky/main s390x libxdmcp6 s390x 1:1.1.5-1 [11.0 kB]
115s Preconfiguring packages ...
115s Fetched 1155 kB in 1s (1704 kB/s)
115s (Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 80969 files and directories currently installed.)
115s Preparing to unpack .../dash_0.5.12-12ubuntu1_s390x.deb ...
115s Unpacking dash (0.5.12-12ubuntu1) over (0.5.12-9ubuntu1) ...
115s Setting up dash (0.5.12-12ubuntu1) ...
115s (Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 80969 files and directories currently installed.)
115s Preparing to unpack .../libatomic1_14.2.0-17ubuntu1_s390x.deb ...
115s Unpacking libatomic1:s390x (14.2.0-17ubuntu1) over (14.2.0-16ubuntu1) ...
115s Preparing to unpack .../gcc-14-base_14.2.0-17ubuntu1_s390x.deb ...
115s Unpacking gcc-14-base:s390x (14.2.0-17ubuntu1) over (14.2.0-16ubuntu1) ...
115s Setting up gcc-14-base:s390x (14.2.0-17ubuntu1) ...
115s (Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 80969 files and directories currently installed.)
115s Preparing to unpack .../libstdc++6_14.2.0-17ubuntu1_s390x.deb ...
115s Unpacking libstdc++6:s390x (14.2.0-17ubuntu1) over (14.2.0-16ubuntu1) ...
115s Setting up libstdc++6:s390x (14.2.0-17ubuntu1) ...
115s (Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 80969 files and directories currently installed.)
115s Preparing to unpack .../libgcc-s1_14.2.0-17ubuntu1_s390x.deb ...
115s Unpacking libgcc-s1:s390x (14.2.0-17ubuntu1) over (14.2.0-16ubuntu1) ...
115s Setting up libgcc-s1:s390x (14.2.0-17ubuntu1) ...
115s (Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 80969 files and directories currently installed.)
115s Preparing to unpack .../libtasn1-6_4.20.0-2_s390x.deb ...
115s Unpacking libtasn1-6:s390x (4.20.0-2) over (4.19.0-3build1) ...
115s Preparing to unpack .../libxdmcp6_1%3a1.1.5-1_s390x.deb ...
115s Unpacking libxdmcp6:s390x (1:1.1.5-1) over (1:1.1.3-0ubuntu6) ...
115s Setting up libxdmcp6:s390x (1:1.1.5-1) ...
115s Setting up libatomic1:s390x (14.2.0-17ubuntu1) ...
115s Setting up libtasn1-6:s390x (4.20.0-2) ...
115s Processing triggers for libc-bin (2.40-4ubuntu1) ...
115s Processing triggers for man-db (2.13.0-1) ...
115s Processing triggers for debianutils (5.21) ...
116s Reading package lists...
116s Building dependency tree...
116s Reading state information...
116s The following packages will be REMOVED:
116s   libnsl2* libpython3.12-minimal* libpython3.12-stdlib* libpython3.12t64*
116s   linux-headers-6.11.0-8* linux-headers-6.11.0-8-generic*
116s   linux-modules-6.11.0-8-generic* linux-tools-6.11.0-8*
116s   linux-tools-6.11.0-8-generic*
116s 0 upgraded, 0 newly installed, 9 to remove and 6 not upgraded.
116s After this operation, 167 MB disk space will be freed.
116s (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 ... 80969 files and directories currently installed.)
116s Removing linux-tools-6.11.0-8-generic (6.11.0-8.8) ...
116s Removing linux-tools-6.11.0-8 (6.11.0-8.8) ...
116s Removing libpython3.12t64:s390x (3.12.9-1) ...
116s Removing libpython3.12-stdlib:s390x (3.12.9-1) ...
116s Removing libnsl2:s390x (1.3.0-3build3) ...
116s Removing libpython3.12-minimal:s390x (3.12.9-1) ...
116s Removing linux-headers-6.11.0-8-generic (6.11.0-8.8) ...
116s Removing linux-headers-6.11.0-8 (6.11.0-8.8) ...
117s Removing linux-modules-6.11.0-8-generic (6.11.0-8.8) ...
117s Processing triggers for libc-bin (2.40-4ubuntu1) ...
118s (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 ... 55869 files and directories currently installed.)
118s Purging configuration files for libpython3.12-minimal:s390x (3.12.9-1) ...
118s Purging configuration files for linux-modules-6.11.0-8-generic (6.11.0-8.8) ...
118s autopkgtest [22:24:34]: upgrading testbed (apt dist-upgrade and autopurge)
118s Reading package lists...
118s Building dependency tree...
118s Reading state information...
118s Calculating upgrade...Starting pkgProblemResolver with broken count: 0
118s Starting 2 pkgProblemResolver with broken count: 0
118s Done
119s Entering ResolveByKeep
119s 
119s The following packages will be upgraded:
119s   iproute2 libc-bin libc-dev-bin libc6 libc6-dev locales
119s 6 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
119s Need to get 10.7 MB of archives.
119s After this operation, 305 kB of additional disk space will be used.
119s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc-dev-bin s390x 2.41-1ubuntu1 [24.3 kB]
119s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc6-dev s390x 2.41-1ubuntu1 [1679 kB]
119s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x locales all 2.41-1ubuntu1 [4246 kB]
120s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc6 s390x 2.41-1ubuntu1 [2891 kB]
120s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc-bin s390x 2.41-1ubuntu1 [672 kB]
120s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x iproute2 s390x 6.13.0-1ubuntu1 [1174 kB]
120s Preconfiguring packages ...
120s Fetched 10.7 MB in 1s (11.3 MB/s)
120s (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 ... 55867 files and directories currently installed.)
120s Preparing to unpack .../libc-dev-bin_2.41-1ubuntu1_s390x.deb ...
120s Unpacking libc-dev-bin (2.41-1ubuntu1) over (2.40-4ubuntu1) ...
120s Preparing to unpack .../libc6-dev_2.41-1ubuntu1_s390x.deb ...
120s Unpacking libc6-dev:s390x (2.41-1ubuntu1) over (2.40-4ubuntu1) ...
120s Preparing to unpack .../locales_2.41-1ubuntu1_all.deb ...
120s Unpacking locales (2.41-1ubuntu1) over (2.40-4ubuntu1) ...
120s Preparing to unpack .../libc6_2.41-1ubuntu1_s390x.deb ...
120s Checking for services that may need to be restarted...
120s Checking init scripts...
120s Checking for services that may need to be restarted...
120s Checking init scripts...
120s Stopping some services possibly affected by the upgrade (will be restarted later):
121s   cron: stopping...done.
121s 
121s Unpacking libc6:s390x (2.41-1ubuntu1) over (2.40-4ubuntu1) ...
121s Setting up libc6:s390x (2.41-1ubuntu1) ...
121s Checking for services that may need to be restarted...
121s Checking init scripts...
121s Restarting services possibly affected by the upgrade:
121s   cron: restarting...done.
121s 
121s Services restarted successfully.
121s (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 ... 55868 files and directories currently installed.)
121s Preparing to unpack .../libc-bin_2.41-1ubuntu1_s390x.deb ...
121s Unpacking libc-bin (2.41-1ubuntu1) over (2.40-4ubuntu1) ...
121s Setting up libc-bin (2.41-1ubuntu1) ...
121s (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 ... 55868 files and directories currently installed.)
121s Preparing to unpack .../iproute2_6.13.0-1ubuntu1_s390x.deb ...
121s Unpacking iproute2 (6.13.0-1ubuntu1) over (6.10.0-2ubuntu1) ...
121s Setting up iproute2 (6.13.0-1ubuntu1) ...
121s Setting up locales (2.41-1ubuntu1) ...
121s Installing new version of config file /etc/locale.alias ...
121s Generating locales (this might take a while)...
123s   en_US.UTF-8... done
123s Generation complete.
123s Setting up libc-dev-bin (2.41-1ubuntu1) ...
123s Setting up libc6-dev:s390x (2.41-1ubuntu1) ...
123s Processing triggers for man-db (2.13.0-1) ...
123s Processing triggers for systemd (257.2-3ubuntu1) ...
124s Reading package lists...
124s Building dependency tree...
124s Reading state information...
125s Starting pkgProblemResolver with broken count: 0
125s Starting 2 pkgProblemResolver with broken count: 0
125s Done
125s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
125s autopkgtest [22:24:41]: rebooting testbed after setup commands that affected boot
144s autopkgtest [22:25:00]: testbed running kernel: Linux 6.12.0-15-generic #15-Ubuntu SMP Tue Feb  4 15:05:57 UTC 2025
148s autopkgtest [22:25:04]: @@@@@@@@@@@@@@@@@@@@ apt-source firebird4.0
158s Get:1 http://ftpmaster.internal/ubuntu plucky/universe firebird4.0 4.0.5.3140.ds6-15 (dsc) [2860 B]
158s Get:2 http://ftpmaster.internal/ubuntu plucky/universe firebird4.0 4.0.5.3140.ds6-15 (tar) [3965 kB]
158s Get:3 http://ftpmaster.internal/ubuntu plucky/universe firebird4.0 4.0.5.3140.ds6-15 (diff) [101 kB]
158s gpgv: Signature made Sat Feb  8 11:59:35 2025 UTC
158s gpgv:                using RSA key AEA0C44ECB056E93630D9D33DBBE9D4D99D2A004
158s gpgv: Can't check signature: No public key
158s dpkg-source: warning: cannot verify inline signature for ./firebird4.0_4.0.5.3140.ds6-15.dsc: no acceptable signature found
158s autopkgtest [22:25:14]: testing package firebird4.0 version 4.0.5.3140.ds6-15
159s autopkgtest [22:25:15]: build not needed
164s autopkgtest [22:25:20]: test assorted-tools: preparing testbed
164s Reading package lists...
165s Building dependency tree...
165s Reading state information...
165s Starting pkgProblemResolver with broken count: 0
165s Starting 2 pkgProblemResolver with broken count: 0
165s Done
165s The following NEW packages will be installed:
165s   firebird-utils firebird4.0-common firebird4.0-common-doc
165s   firebird4.0-examples firebird4.0-server-core firebird4.0-utils
165s   libabsl20230802 libfbclient2 libre2-11 libtomcrypt1 libtommath1
165s 0 upgraded, 11 newly installed, 0 to remove and 0 not upgraded.
165s Need to get 8184 kB of archives.
165s After this operation, 32.3 MB of additional disk space will be used.
165s Get:1 http://ftpmaster.internal/ubuntu plucky/universe s390x firebird4.0-common-doc all 4.0.5.3140.ds6-15 [28.3 kB]
165s Get:2 http://ftpmaster.internal/ubuntu plucky/universe s390x firebird4.0-common all 4.0.5.3140.ds6-15 [18.5 kB]
165s Get:3 http://ftpmaster.internal/ubuntu plucky/universe s390x libtommath1 s390x 1.3.0-1 [57.1 kB]
165s Get:4 http://ftpmaster.internal/ubuntu plucky/universe s390x libfbclient2 s390x 4.0.5.3140.ds6-15 [970 kB]
166s Get:5 http://ftpmaster.internal/ubuntu plucky/main s390x libabsl20230802 s390x 20230802.1-4ubuntu2 [529 kB]
166s Get:6 http://ftpmaster.internal/ubuntu plucky/main s390x libre2-11 s390x 20240501-3build1 [185 kB]
166s Get:7 http://ftpmaster.internal/ubuntu plucky/universe s390x firebird4.0-utils s390x 4.0.5.3140.ds6-15 [1530 kB]
166s Get:8 http://ftpmaster.internal/ubuntu plucky/universe s390x firebird-utils all 4.0.5.3140.ds6-15 [3714 B]
166s Get:9 http://ftpmaster.internal/ubuntu plucky/universe s390x firebird4.0-examples all 4.0.5.3140.ds6-15 [387 kB]
166s Get:10 http://ftpmaster.internal/ubuntu plucky/universe s390x libtomcrypt1 s390x 1.18.2+dfsg-7build1 [432 kB]
166s Get:11 http://ftpmaster.internal/ubuntu plucky/universe s390x firebird4.0-server-core s390x 4.0.5.3140.ds6-15 [4043 kB]
166s Fetched 8184 kB in 1s (8141 kB/s)
166s Selecting previously unselected package firebird4.0-common-doc.
166s (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 ... 55869 files and directories currently installed.)
166s Preparing to unpack .../00-firebird4.0-common-doc_4.0.5.3140.ds6-15_all.deb ...
166s Unpacking firebird4.0-common-doc (4.0.5.3140.ds6-15) ...
166s Selecting previously unselected package firebird4.0-common.
166s Preparing to unpack .../01-firebird4.0-common_4.0.5.3140.ds6-15_all.deb ...
166s Unpacking firebird4.0-common (4.0.5.3140.ds6-15) ...
166s Selecting previously unselected package libtommath1:s390x.
166s Preparing to unpack .../02-libtommath1_1.3.0-1_s390x.deb ...
166s Unpacking libtommath1:s390x (1.3.0-1) ...
166s Selecting previously unselected package libfbclient2:s390x.
166s Preparing to unpack .../03-libfbclient2_4.0.5.3140.ds6-15_s390x.deb ...
166s Unpacking libfbclient2:s390x (4.0.5.3140.ds6-15) ...
166s Selecting previously unselected package libabsl20230802:s390x.
166s Preparing to unpack .../04-libabsl20230802_20230802.1-4ubuntu2_s390x.deb ...
166s Unpacking libabsl20230802:s390x (20230802.1-4ubuntu2) ...
166s Selecting previously unselected package libre2-11:s390x.
166s Preparing to unpack .../05-libre2-11_20240501-3build1_s390x.deb ...
166s Unpacking libre2-11:s390x (20240501-3build1) ...
166s Selecting previously unselected package firebird4.0-utils.
166s Preparing to unpack .../06-firebird4.0-utils_4.0.5.3140.ds6-15_s390x.deb ...
166s Unpacking firebird4.0-utils (4.0.5.3140.ds6-15) ...
166s Selecting previously unselected package firebird-utils.
166s Preparing to unpack .../07-firebird-utils_4.0.5.3140.ds6-15_all.deb ...
166s Unpacking firebird-utils (4.0.5.3140.ds6-15) ...
167s Selecting previously unselected package firebird4.0-examples.
167s Preparing to unpack .../08-firebird4.0-examples_4.0.5.3140.ds6-15_all.deb ...
167s Unpacking firebird4.0-examples (4.0.5.3140.ds6-15) ...
167s Selecting previously unselected package libtomcrypt1:s390x.
167s Preparing to unpack .../09-libtomcrypt1_1.18.2+dfsg-7build1_s390x.deb ...
167s Unpacking libtomcrypt1:s390x (1.18.2+dfsg-7build1) ...
167s Selecting previously unselected package firebird4.0-server-core:s390x.
167s Preparing to unpack .../10-firebird4.0-server-core_4.0.5.3140.ds6-15_s390x.deb ...
167s Unpacking firebird4.0-server-core:s390x (4.0.5.3140.ds6-15) ...
167s Setting up libtommath1:s390x (1.3.0-1) ...
167s Setting up firebird4.0-common-doc (4.0.5.3140.ds6-15) ...
167s Setting up firebird4.0-common (4.0.5.3140.ds6-15) ...
167s Configuring /etc/firebird/4.0/service-port.conf to use port 3050
167s Setting up libabsl20230802:s390x (20230802.1-4ubuntu2) ...
167s Setting up libtomcrypt1:s390x (1.18.2+dfsg-7build1) ...
167s Setting up firebird4.0-examples (4.0.5.3140.ds6-15) ...
167s Setting up libre2-11:s390x (20240501-3build1) ...
167s Setting up libfbclient2:s390x (4.0.5.3140.ds6-15) ...
167s Setting up firebird4.0-server-core:s390x (4.0.5.3140.ds6-15) ...
167s Setting up firebird-utils (4.0.5.3140.ds6-15) ...
167s Setting up firebird4.0-utils (4.0.5.3140.ds6-15) ...
167s 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
167s Processing triggers for libc-bin (2.41-1ubuntu1) ...
167s Processing triggers for man-db (2.13.0-1) ...
169s autopkgtest [22:25:25]: test assorted-tools: [-----------------------
169s V: Creating employee.fdb via isql-fb -i
170s V: Backing up
170s V: Restoring the backup
170s V: Extracting definition of employee.fdb via isql-fb -a
170s V: Checking the size of employee.sql
170s -rw-rw-r-- 1 ubuntu ubuntu 21525 Feb 15 22:25 employee.sql
170s V: Running fbstat on employee.fdb
170s 
170s Database "/tmp/autopkgtest.O6R3yI/assorted-tools-artifacts/employee.fdb"
170s Gstat execution time Sat Feb 15 22:25:26 2025
170s 
170s Database header page information:
170s 	Flags			0
170s 	Generation		162
170s 	System Change Number	0
170s 	Page size		8192
170s 	ODS version		13.0
170s 	Oldest transaction	155
170s 	Oldest active		156
170s 	Oldest snapshot		156
170s 	Next transaction	156
170s 	Sequence number		0
170s 	Next attachment ID	9
170s 	Implementation		HW=s390x big-endian OS=Linux CC=gcc
170s 	Shadow count		0
170s 	Page buffers		0
170s 	Next header page	0
170s 	Database dialect	3
170s 	Creation date		Feb 15, 2025 22:25:25
170s 	Attributes		force write
170s 
170s     Variable header data:
170s 	Database GUID:	{76DF442D-5F99-4BD1-BA7F-B3DF4C55EBB5}
170s 	*END*
170s 
170s 
170s Database file sequence:
170s File /tmp/autopkgtest.O6R3yI/assorted-tools-artifacts/employee.fdb is the only file
170s 
170s Analyzing database pages ...
170s COUNTRY (128)
170s     Primary pointer page: 222, Index root page: 223
170s     Pointer pages: 1, data page slots: 1
170s     Data pages: 1, average fill: 8%
170s     Primary pages: 1, secondary pages: 0, swept pages: 0
170s     Empty pages: 0, full pages: 0
170s     Fill distribution:
170s 	 0 - 19% = 1
170s 	20 - 39% = 0
170s 	40 - 59% = 0
170s 	60 - 79% = 0
170s 	80 - 99% = 0
170s 
170s     Index RDB$PRIMARY1 (0)
170s 	Root page: 226, depth: 1, leaf buckets: 1, nodes: 16
170s 	Average node length: 10.44, total dup: 0, max dup: 0
170s 	Average key length: 8.62, compression ratio: 0.80
170s 	Average prefix length: 0.44, average data length: 6.44
170s 	Clustering factor: 1, ratio: 0.06
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s CUSTOMER (137)
170s     Primary pointer page: 276, Index root page: 277
170s     Pointer pages: 1, data page slots: 1
170s     Data pages: 1, average fill: 25%
170s     Primary pages: 1, secondary pages: 0, swept pages: 1
170s     Empty pages: 0, full pages: 0
170s     Fill distribution:
170s 	 0 - 19% = 0
170s 	20 - 39% = 1
170s 	40 - 59% = 0
170s 	60 - 79% = 0
170s 	80 - 99% = 0
170s 
170s     Index CUSTNAMEX (2)
170s 	Root page: 290, depth: 1, leaf buckets: 1, nodes: 15
170s 	Average node length: 19.87, total dup: 0, max dup: 0
170s 	Average key length: 18.27, compression ratio: 0.90
170s 	Average prefix length: 0.60, average data length: 15.87
170s 	Clustering factor: 1, ratio: 0.07
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s     Index CUSTREGION (3)
170s 	Root page: 291, depth: 1, leaf buckets: 1, nodes: 15
170s 	Average node length: 21.27, total dup: 0, max dup: 0
170s 	Average key length: 20.20, compression ratio: 0.97
170s 	Average prefix length: 2.33, average data length: 17.27
170s 	Clustering factor: 1, ratio: 0.07
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s     Index RDB$FOREIGN23 (1)
170s 	Root page: 279, depth: 1, leaf buckets: 1, nodes: 15
170s 	Average node length: 8.60, total dup: 4, max dup: 4
170s 	Average key length: 6.93, compression ratio: 0.83
170s 	Average prefix length: 0.87, average data length: 4.87
170s 	Clustering factor: 1, ratio: 0.07
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s     Index RDB$PRIMARY22 (0)
170s 	Root page: 278, depth: 1, leaf buckets: 1, nodes: 15
170s 	Average node length: 4.20, total dup: 0, max dup: 0
170s 	Average key length: 3.13, compression ratio: 0.96
170s 	Average prefix length: 1.87, average data length: 1.13
170s 	Clustering factor: 1, ratio: 0.07
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s DEPARTMENT (130)
170s     Primary pointer page: 236, Index root page: 237
170s     Pointer pages: 1, data page slots: 1
170s     Data pages: 1, average fill: 23%
170s     Primary pages: 1, secondary pages: 0, swept pages: 1
170s     Empty pages: 0, full pages: 0
170s     Fill distribution:
170s 	 0 - 19% = 0
170s 	20 - 39% = 1
170s 	40 - 59% = 0
170s 	60 - 79% = 0
170s 	80 - 99% = 0
170s 
170s     Index BUDGETX (3)
170s 	Root page: 298, depth: 1, leaf buckets: 1, nodes: 21
170s 	Average node length: 9.05, total dup: 7, max dup: 3
170s 	Average key length: 8.00, compression ratio: 1.12
170s 	Average prefix length: 3.62, average data length: 5.38
170s 	Clustering factor: 1, ratio: 0.05
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s     Index RDB$4 (0)
170s 	Root page: 238, depth: 1, leaf buckets: 1, nodes: 21
170s 	Average node length: 17.95, total dup: 0, max dup: 0
170s 	Average key length: 16.57, compression ratio: 1.16
170s 	Average prefix length: 5.29, average data length: 13.95
170s 	Clustering factor: 1, ratio: 0.05
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s     Index RDB$FOREIGN10 (4)
170s 	Root page: 250, depth: 1, leaf buckets: 1, nodes: 21
170s 	Average node length: 4.29, total dup: 3, max dup: 3
170s 	Average key length: 3.24, compression ratio: 0.60
170s 	Average prefix length: 0.81, average data length: 1.14
170s 	Clustering factor: 1, ratio: 0.05
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s     Index RDB$FOREIGN6 (2)
170s 	Root page: 240, depth: 1, leaf buckets: 1, nodes: 21
170s 	Average node length: 4.10, total dup: 13, max dup: 4
170s 	Average key length: 2.95, compression ratio: 0.97
170s 	Average prefix length: 2.05, average data length: 0.81
170s 	Clustering factor: 1, ratio: 0.05
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s     Index RDB$PRIMARY5 (1)
170s 	Root page: 239, depth: 1, leaf buckets: 1, nodes: 21
170s 	Average node length: 5.24, total dup: 0, max dup: 0
170s 	Average key length: 4.05, compression ratio: 0.74
170s 	Average prefix length: 1.29, average data length: 1.71
170s 	Clustering factor: 1, ratio: 0.05
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s EMPLOYEE (131)
170s     Primary pointer page: 243, Index root page: 244
170s     Pointer pages: 1, data page slots: 1
170s     Data pages: 1, average fill: 42%
170s     Primary pages: 1, secondary pages: 0, swept pages: 1
170s     Empty pages: 0, full pages: 0
170s     Fill distribution:
170s 	 0 - 19% = 0
170s 	20 - 39% = 0
170s 	40 - 59% = 1
170s 	60 - 79% = 0
170s 	80 - 99% = 0
170s 
170s     Index NAMEX (3)
170s 	Root page: 299, depth: 1, leaf buckets: 1, nodes: 42
170s 	Average node length: 19.52, total dup: 0, max dup: 0
170s 	Average key length: 18.50, compression ratio: 0.96
170s 	Average prefix length: 2.17, average data length: 15.52
170s 	Clustering factor: 1, ratio: 0.02
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s     Index RDB$FOREIGN8 (1)
170s 	Root page: 246, depth: 1, leaf buckets: 1, nodes: 42
170s 	Average node length: 4.07, total dup: 23, max dup: 4
170s 	Average key length: 2.98, compression ratio: 1.01
170s 	Average prefix length: 2.19, average data length: 0.81
170s 	Clustering factor: 1, ratio: 0.02
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s     Index RDB$FOREIGN9 (2)
170s 	Root page: 247, depth: 1, leaf buckets: 1, nodes: 42
170s 	Average node length: 10.43, total dup: 15, max dup: 4
170s 	Average key length: 9.40, compression ratio: 1.68
170s 	Average prefix length: 9.05, average data length: 6.79
170s 	Clustering factor: 1, ratio: 0.02
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s     Index RDB$PRIMARY7 (0)
170s 	Root page: 245, depth: 1, leaf buckets: 1, nodes: 42
170s 	Average node length: 4.62, total dup: 0, max dup: 0
170s 	Average key length: 3.60, compression ratio: 0.69
170s 	Average prefix length: 1.17, average data length: 1.31
170s 	Clustering factor: 1, ratio: 0.02
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s EMPLOYEE_PROJECT (134)
170s     Primary pointer page: 257, Index root page: 258
170s     Pointer pages: 1, data page slots: 1
170s     Data pages: 1, average fill: 10%
170s     Primary pages: 1, secondary pages: 0, swept pages: 0
170s     Empty pages: 0, full pages: 0
170s     Fill distribution:
170s 	 0 - 19% = 1
170s 	20 - 39% = 0
170s 	40 - 59% = 0
170s 	60 - 79% = 0
170s 	80 - 99% = 0
170s 
170s     Index RDB$FOREIGN15 (1)
170s 	Root page: 260, depth: 1, leaf buckets: 1, nodes: 28
170s 	Average node length: 4.29, total dup: 6, max dup: 2
170s 	Average key length: 3.25, compression ratio: 0.74
170s 	Average prefix length: 1.36, average data length: 1.04
170s 	Clustering factor: 1, ratio: 0.04
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s     Index RDB$FOREIGN16 (2)
170s 	Root page: 261, depth: 1, leaf buckets: 1, nodes: 28
170s 	Average node length: 4.04, total dup: 23, max dup: 9
170s 	Average key length: 2.89, compression ratio: 1.73
170s 	Average prefix length: 4.14, average data length: 0.86
170s 	Clustering factor: 1, ratio: 0.04
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s     Index RDB$PRIMARY14 (0)
170s 	Root page: 259, depth: 1, leaf buckets: 1, nodes: 28
170s 	Average node length: 13.11, total dup: 0, max dup: 0
170s 	Average key length: 12.07, compression ratio: 0.99
170s 	Average prefix length: 2.89, average data length: 9.11
170s 	Clustering factor: 1, ratio: 0.04
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s JOB (129)
170s     Primary pointer page: 229, Index root page: 230
170s     Pointer pages: 1, data page slots: 2
170s     Data pages: 2, average fill: 43%
170s     Primary pages: 1, secondary pages: 1, swept pages: 0
170s     Empty pages: 0, full pages: 0
170s     Fill distribution:
170s 	 0 - 19% = 0
170s 	20 - 39% = 1
170s 	40 - 59% = 1
170s 	60 - 79% = 0
170s 	80 - 99% = 0
170s 
170s     Index MAXSALX (2)
170s 	Root page: 300, depth: 1, leaf buckets: 1, nodes: 31
170s 	Average node length: 14.74, total dup: 5, max dup: 1
170s 	Average key length: 13.71, compression ratio: 1.37
170s 	Average prefix length: 7.87, average data length: 10.90
170s 	Clustering factor: 1, ratio: 0.03
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s     Index MINSALX (3)
170s 	Root page: 301, depth: 1, leaf buckets: 1, nodes: 31
170s 	Average node length: 14.06, total dup: 7, max dup: 2
170s 	Average key length: 13.03, compression ratio: 1.44
170s 	Average prefix length: 8.48, average data length: 10.29
170s 	Clustering factor: 1, ratio: 0.03
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s     Index RDB$FOREIGN3 (1)
170s 	Root page: 232, depth: 1, leaf buckets: 1, nodes: 31
170s 	Average node length: 4.61, total dup: 24, max dup: 20
170s 	Average key length: 3.39, compression ratio: 1.23
170s 	Average prefix length: 2.77, average data length: 1.39
170s 	Clustering factor: 1, ratio: 0.03
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s     Index RDB$PRIMARY2 (0)
170s 	Root page: 231, depth: 1, leaf buckets: 1, nodes: 31
170s 	Average node length: 14.45, total dup: 0, max dup: 0
170s 	Average key length: 13.42, compression ratio: 1.24
170s 	Average prefix length: 6.19, average data length: 10.45
170s 	Clustering factor: 1, ratio: 0.03
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s PROJECT (133)
170s     Primary pointer page: 251, Index root page: 252
170s     Pointer pages: 1, data page slots: 2
170s     Data pages: 2, average fill: 7%
170s     Primary pages: 1, secondary pages: 1, swept pages: 0
170s     Empty pages: 0, full pages: 0
170s     Fill distribution:
170s 	 0 - 19% = 2
170s 	20 - 39% = 0
170s 	40 - 59% = 0
170s 	60 - 79% = 0
170s 	80 - 99% = 0
170s 
170s     Index PRODTYPEX (3)
170s 	Root page: 302, depth: 1, leaf buckets: 1, nodes: 6
170s 	Average node length: 26.50, total dup: 0, max dup: 0
170s 	Average key length: 25.33, compression ratio: 1.05
170s 	Average prefix length: 4.17, average data length: 22.50
170s 	Clustering factor: 1, ratio: 0.17
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s     Index RDB$11 (0)
170s 	Root page: 253, depth: 1, leaf buckets: 1, nodes: 6
170s 	Average node length: 17.33, total dup: 0, max dup: 0
170s 	Average key length: 15.50, compression ratio: 0.88
170s 	Average prefix length: 0.33, average data length: 13.33
170s 	Clustering factor: 1, ratio: 0.17
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s     Index RDB$FOREIGN13 (2)
170s 	Root page: 255, depth: 1, leaf buckets: 1, nodes: 6
170s 	Average node length: 4.67, total dup: 0, max dup: 0
170s 	Average key length: 3.50, compression ratio: 0.57
170s 	Average prefix length: 0.67, average data length: 1.33
170s 	Clustering factor: 1, ratio: 0.17
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s     Index RDB$PRIMARY12 (1)
170s 	Root page: 254, depth: 1, leaf buckets: 1, nodes: 6
170s 	Average node length: 8.83, total dup: 0, max dup: 0
170s 	Average key length: 7.00, compression ratio: 0.71
170s 	Average prefix length: 0.17, average data length: 4.83
170s 	Clustering factor: 1, ratio: 0.17
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s PROJ_DEPT_BUDGET (135)
170s     Primary pointer page: 265, Index root page: 266
170s     Pointer pages: 1, data page slots: 1
170s     Data pages: 1, average fill: 11%
170s     Primary pages: 1, secondary pages: 0, swept pages: 0
170s     Empty pages: 0, full pages: 0
170s     Fill distribution:
170s 	 0 - 19% = 1
170s 	20 - 39% = 0
170s 	40 - 59% = 0
170s 	60 - 79% = 0
170s 	80 - 99% = 0
170s 
170s     Index RDB$FOREIGN18 (1)
170s 	Root page: 268, depth: 1, leaf buckets: 1, nodes: 24
170s 	Average node length: 3.92, total dup: 15, max dup: 5
170s 	Average key length: 2.79, compression ratio: 1.07
170s 	Average prefix length: 2.29, average data length: 0.71
170s 	Clustering factor: 1, ratio: 0.04
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s     Index RDB$FOREIGN19 (2)
170s 	Root page: 269, depth: 1, leaf buckets: 1, nodes: 24
170s 	Average node length: 4.21, total dup: 19, max dup: 8
170s 	Average key length: 3.04, compression ratio: 1.64
170s 	Average prefix length: 4.00, average data length: 1.00
170s 	Clustering factor: 1, ratio: 0.04
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s     Index RDB$PRIMARY17 (0)
170s 	Root page: 267, depth: 1, leaf buckets: 1, nodes: 24
170s 	Average node length: 10.71, total dup: 0, max dup: 0
170s 	Average key length: 9.67, compression ratio: 1.97
170s 	Average prefix length: 12.17, average data length: 6.83
170s 	Clustering factor: 1, ratio: 0.04
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s SALARY_HISTORY (136)
170s     Primary pointer page: 270, Index root page: 271
170s     Pointer pages: 1, data page slots: 1
170s     Data pages: 1, average fill: 29%
170s     Primary pages: 1, secondary pages: 0, swept pages: 0
170s     Empty pages: 0, full pages: 0
170s     Fill distribution:
170s 	 0 - 19% = 0
170s 	20 - 39% = 1
170s 	40 - 59% = 0
170s 	60 - 79% = 0
170s 	80 - 99% = 0
170s 
170s     Index CHANGEX (2)
170s 	Root page: 303, depth: 1, leaf buckets: 1, nodes: 49
170s 	Average node length: 3.37, total dup: 46, max dup: 21
170s 	Average key length: 2.35, compression ratio: 2.98
170s 	Average prefix length: 6.69, average data length: 0.31
170s 	Clustering factor: 1, ratio: 0.02
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s     Index RDB$FOREIGN21 (1)
170s 	Root page: 273, depth: 1, leaf buckets: 1, nodes: 49
170s 	Average node length: 4.12, total dup: 16, max dup: 2
170s 	Average key length: 3.10, compression ratio: 0.75
170s 	Average prefix length: 1.43, average data length: 0.90
170s 	Clustering factor: 1, ratio: 0.02
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s     Index RDB$PRIMARY20 (0)
170s 	Root page: 272, depth: 1, leaf buckets: 1, nodes: 49
170s 	Average node length: 22.29, total dup: 0, max dup: 0
170s 	Average key length: 21.27, compression ratio: 1.06
170s 	Average prefix length: 4.31, average data length: 18.29
170s 	Clustering factor: 1, ratio: 0.02
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s     Index UPDATERX (3)
170s 	Root page: 304, depth: 1, leaf buckets: 1, nodes: 49
170s 	Average node length: 3.35, total dup: 46, max dup: 28
170s 	Average key length: 2.29, compression ratio: 2.48
170s 	Average prefix length: 5.39, average data length: 0.29
170s 	Clustering factor: 1, ratio: 0.02
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s SALES (138)
170s     Primary pointer page: 283, Index root page: 284
170s     Pointer pages: 1, data page slots: 1
170s     Data pages: 1, average fill: 34%
170s     Primary pages: 1, secondary pages: 0, swept pages: 0
170s     Empty pages: 0, full pages: 0
170s     Fill distribution:
170s 	 0 - 19% = 0
170s 	20 - 39% = 1
170s 	40 - 59% = 0
170s 	60 - 79% = 0
170s 	80 - 99% = 0
170s 
170s     Index NEEDX (3)
170s 	Root page: 305, depth: 1, leaf buckets: 1, nodes: 33
170s 	Average node length: 5.97, total dup: 11, max dup: 6
170s 	Average key length: 4.94, compression ratio: 1.10
170s 	Average prefix length: 2.88, average data length: 2.55
170s 	Clustering factor: 1, ratio: 0.03
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s     Index QTYX (4)
170s 	Root page: 306, depth: 1, leaf buckets: 1, nodes: 33
170s 	Average node length: 5.06, total dup: 11, max dup: 3
170s 	Average key length: 4.03, compression ratio: 3.23
170s 	Average prefix length: 11.18, average data length: 1.85
170s 	Clustering factor: 1, ratio: 0.03
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s     Index RDB$FOREIGN25 (1)
170s 	Root page: 286, depth: 1, leaf buckets: 1, nodes: 33
170s 	Average node length: 3.55, total dup: 18, max dup: 4
170s 	Average key length: 2.52, compression ratio: 1.19
170s 	Average prefix length: 2.48, average data length: 0.52
170s 	Clustering factor: 1, ratio: 0.03
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s     Index RDB$FOREIGN26 (2)
170s 	Root page: 287, depth: 1, leaf buckets: 1, nodes: 33
170s 	Average node length: 3.67, total dup: 25, max dup: 7
170s 	Average key length: 2.64, compression ratio: 1.01
170s 	Average prefix length: 2.21, average data length: 0.45
170s 	Clustering factor: 1, ratio: 0.03
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s     Index RDB$PRIMARY24 (0)
170s 	Root page: 285, depth: 1, leaf buckets: 1, nodes: 33
170s 	Average node length: 8.45, total dup: 0, max dup: 0
170s 	Average key length: 7.42, compression ratio: 1.08
170s 	Average prefix length: 3.52, average data length: 4.48
170s 	Clustering factor: 1, ratio: 0.03
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s     Index SALESTATX (5)
170s 	Root page: 307, depth: 1, leaf buckets: 1, nodes: 33
170s 	Average node length: 4.06, total dup: 27, max dup: 14
170s 	Average key length: 3.03, compression ratio: 3.56
170s 	Average prefix length: 9.82, average data length: 0.97
170s 	Clustering factor: 1, ratio: 0.03
170s 	Fill distribution:
170s 	     0 - 19% = 1
170s 	    20 - 39% = 0
170s 	    40 - 59% = 0
170s 	    60 - 79% = 0
170s 	    80 - 99% = 0
170s 
170s Gstat completion time Sat Feb 15 22:25:26 2025
170s 
170s V: Running gfix -v
170s V: Some big math
170s create table tbl1(fld1 int128);
170s insert into tbl1 values(12345);
171s select * from tbl1;
171s 
171s                                          FLD1 
171s ============================================= 
171s                                         12345 
171s 
171s autopkgtest [22:25:27]: test assorted-tools: -----------------------]
171s assorted-tools       PASS
171s autopkgtest [22:25:27]: test assorted-tools:  - - - - - - - - - - results - - - - - - - - - -
172s autopkgtest [22:25:28]: @@@@@@@@@@@@@@@@@@@@ summary
172s assorted-tools       PASS
179s nova [W] Using flock in prodstack6-s390x
179s flock: timeout while waiting to get lock
179s Creating nova instance adt-plucky-s390x-firebird4.0-20250215-222236-juju-7f2275-prod-proposed-migration-environment-2-21ce05e0-c31f-4ef5-bec4-d8ffb168f826 from image adt/ubuntu-plucky-s390x-server-20250215.img (UUID 099dc609-2061-4009-a65b-d554466baca0)...
179s nova [W] Timed out waiting for 80fa2ffd-5924-4ac7-ba61-ab784f3233e0 to get deleted.