0s autopkgtest [06:06:32]: starting date and time: 2024-11-27 06:06:32+0000 0s autopkgtest [06:06:32]: git checkout: 0acbae0a WIP show VirtSubproc stderr in real-time 0s autopkgtest [06:06:32]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.o82rxuo3/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:pg-fact-loader,src:postgresql-17,src:pglogical,src:postgresql-common,src:pglogical-ticker --apt-upgrade pg-fact-loader --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=pg-fact-loader/2.0.1-4 postgresql-17/17.2-1 pglogical/2.4.5-1 postgresql-common/267 pglogical-ticker/1.4.1-8' -- 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-pg-fact-loader-20241127-060632-juju-7f2275-prod-proposed-migration-environment-2-39c05508-a315-443e-8cef-dc94af5b877a --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'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 45s autopkgtest [06:07:17]: testbed dpkg architecture: s390x 45s autopkgtest [06:07:17]: testbed apt version: 2.9.8 45s autopkgtest [06:07:17]: @@@@@@@@@@@@@@@@@@@@ test bed setup 45s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 46s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [13.6 kB] 46s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [53.8 kB] 46s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [9708 B] 46s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [789 kB] 46s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [75.3 kB] 46s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/restricted s390x Packages [928 B] 46s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [596 kB] 46s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [6612 B] 46s Fetched 1620 kB in 1s (2099 kB/s) 46s Reading package lists... 48s Reading package lists... 48s Building dependency tree... 48s Reading state information... 48s Calculating upgrade... 48s The following package was automatically installed and is no longer required: 48s libsgutils2-1.46-2 48s Use 'sudo apt autoremove' to remove it. 48s The following NEW packages will be installed: 48s appstream cloud-init-base gir1.2-packagekitglib-1.0 libappstream5 48s libduktape207 libglib2.0-bin libgstreamer1.0-0 libpackagekit-glib2-18 48s libsgutils2-1.48 libstemmer0d packagekit packagekit-tools polkitd 48s python3-distro-info python3-jaraco.text python3-software-properties 48s sgml-base software-properties-common unattended-upgrades xml-core 48s The following packages will be upgraded: 48s apt apt-utils bash bpftrace cloud-init curl debconf debconf-i18n distro-info 49s dracut-install gir1.2-girepository-2.0 gir1.2-glib-2.0 hostname init 49s init-system-helpers libapt-pkg6.0t64 libaudit-common libaudit1 49s libcurl3t64-gnutls libcurl4t64 libgirepository-1.0-1 libglib2.0-0t64 49s libglib2.0-data liblzma5 libpam-modules libpam-modules-bin libpam-runtime 49s libpam0g libperl5.40 libplymouth5 libpolkit-agent-1-0 libpolkit-gobject-1-0 49s libselinux1 libsemanage-common libsemanage2 linux-base lto-disabled-list 49s lxd-installer openssh-client openssh-server openssh-sftp-server perl 49s perl-base perl-modules-5.40 pinentry-curses plymouth 49s plymouth-theme-ubuntu-text python-apt-common python3-apt python3-blinker 49s python3-debconf python3-jsonschema-specifications python3-pkg-resources 49s python3-rpds-py python3-setuptools python3-yaml sg3-utils sg3-utils-udev 49s ubuntu-kernel-accessories ubuntu-minimal ubuntu-standard vim-common vim-tiny 49s wget xxd xz-utils 49s 66 upgraded, 20 newly installed, 0 to remove and 0 not upgraded. 49s Need to get 29.9 MB of archives. 49s After this operation, 12.9 MB of additional disk space will be used. 49s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x bash s390x 5.2.32-1ubuntu2 [845 kB] 49s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x hostname s390x 3.25 [11.2 kB] 49s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x libperl5.40 s390x 5.40.0-8 [4986 kB] 49s Get:4 http://ftpmaster.internal/ubuntu plucky/main s390x perl s390x 5.40.0-8 [262 kB] 49s Get:5 http://ftpmaster.internal/ubuntu plucky/main s390x perl-base s390x 5.40.0-8 [1971 kB] 49s Get:6 http://ftpmaster.internal/ubuntu plucky/main s390x perl-modules-5.40 all 5.40.0-8 [3214 kB] 50s Get:7 http://ftpmaster.internal/ubuntu plucky/main s390x init-system-helpers all 1.67ubuntu1 [39.1 kB] 50s Get:8 http://ftpmaster.internal/ubuntu plucky/main s390x liblzma5 s390x 5.6.3-1 [145 kB] 50s Get:9 http://ftpmaster.internal/ubuntu plucky/main s390x libapt-pkg6.0t64 s390x 2.9.14ubuntu1 [1091 kB] 50s Get:10 http://ftpmaster.internal/ubuntu plucky/main s390x apt s390x 2.9.14ubuntu1 [1375 kB] 50s Get:11 http://ftpmaster.internal/ubuntu plucky/main s390x apt-utils s390x 2.9.14ubuntu1 [215 kB] 50s Get:12 http://ftpmaster.internal/ubuntu plucky/main s390x libaudit-common all 1:4.0.2-2ubuntu1 [6578 B] 50s Get:13 http://ftpmaster.internal/ubuntu plucky/main s390x libaudit1 s390x 1:4.0.2-2ubuntu1 [52.5 kB] 50s Get:14 http://ftpmaster.internal/ubuntu plucky/main s390x debconf-i18n all 1.5.87ubuntu1 [204 kB] 50s Get:15 http://ftpmaster.internal/ubuntu plucky/main s390x python3-debconf all 1.5.87ubuntu1 [4156 B] 50s Get:16 http://ftpmaster.internal/ubuntu plucky/main s390x debconf all 1.5.87ubuntu1 [124 kB] 50s Get:17 http://ftpmaster.internal/ubuntu plucky/main s390x libpam0g s390x 1.5.3-7ubuntu4 [70.0 kB] 50s Get:18 http://ftpmaster.internal/ubuntu plucky/main s390x libselinux1 s390x 3.7-3ubuntu1 [85.2 kB] 50s Get:19 http://ftpmaster.internal/ubuntu plucky/main s390x libpam-modules-bin s390x 1.5.3-7ubuntu4 [56.2 kB] 50s Get:20 http://ftpmaster.internal/ubuntu plucky/main s390x libpam-modules s390x 1.5.3-7ubuntu4 [294 kB] 50s Get:21 http://ftpmaster.internal/ubuntu plucky/main s390x init s390x 1.67ubuntu1 [6428 B] 50s Get:22 http://ftpmaster.internal/ubuntu plucky/main s390x openssh-sftp-server s390x 1:9.9p1-3ubuntu2 [38.2 kB] 50s Get:23 http://ftpmaster.internal/ubuntu plucky/main s390x openssh-server s390x 1:9.9p1-3ubuntu2 [552 kB] 50s Get:24 http://ftpmaster.internal/ubuntu plucky/main s390x openssh-client s390x 1:9.9p1-3ubuntu2 [955 kB] 50s Get:25 http://ftpmaster.internal/ubuntu plucky/main s390x libpam-runtime all 1.5.3-7ubuntu4 [40.8 kB] 50s Get:26 http://ftpmaster.internal/ubuntu plucky/main s390x sgml-base all 1.31 [11.4 kB] 50s Get:27 http://ftpmaster.internal/ubuntu plucky/main s390x libsemanage-common all 3.7-2build1 [7186 B] 50s Get:28 http://ftpmaster.internal/ubuntu plucky/main s390x libsemanage2 s390x 3.7-2build1 [97.1 kB] 50s Get:29 http://ftpmaster.internal/ubuntu plucky/main s390x distro-info s390x 1.12 [20.0 kB] 50s Get:30 http://ftpmaster.internal/ubuntu plucky/main s390x gir1.2-girepository-2.0 s390x 1.82.0-2 [25.0 kB] 50s Get:31 http://ftpmaster.internal/ubuntu plucky/main s390x gir1.2-glib-2.0 s390x 2.82.2-3 [180 kB] 50s Get:32 http://ftpmaster.internal/ubuntu plucky/main s390x libglib2.0-0t64 s390x 2.82.2-3 [1575 kB] 50s Get:33 http://ftpmaster.internal/ubuntu plucky/main s390x libgirepository-1.0-1 s390x 1.82.0-2 [84.9 kB] 50s Get:34 http://ftpmaster.internal/ubuntu plucky/main s390x libglib2.0-data all 2.82.2-3 [51.7 kB] 50s Get:35 http://ftpmaster.internal/ubuntu plucky/main s390x python-apt-common all 2.9.0ubuntu2 [20.3 kB] 50s Get:36 http://ftpmaster.internal/ubuntu plucky/main s390x python3-apt s390x 2.9.0ubuntu2 [185 kB] 50s Get:37 http://ftpmaster.internal/ubuntu plucky/main s390x python3-yaml s390x 6.0.2-1build1 [188 kB] 50s Get:38 http://ftpmaster.internal/ubuntu plucky/main s390x vim-tiny s390x 2:9.1.0861-1ubuntu1 [664 kB] 50s Get:39 http://ftpmaster.internal/ubuntu plucky/main s390x vim-common all 2:9.1.0861-1ubuntu1 [395 kB] 50s Get:40 http://ftpmaster.internal/ubuntu plucky/main s390x ubuntu-minimal s390x 1.544 [11.3 kB] 50s Get:41 http://ftpmaster.internal/ubuntu plucky/main s390x xxd s390x 2:9.1.0861-1ubuntu1 [66.6 kB] 50s Get:42 http://ftpmaster.internal/ubuntu plucky/main s390x libplymouth5 s390x 24.004.60-2ubuntu4 [150 kB] 50s Get:43 http://ftpmaster.internal/ubuntu plucky/main s390x plymouth-theme-ubuntu-text s390x 24.004.60-2ubuntu4 [10.1 kB] 50s Get:44 http://ftpmaster.internal/ubuntu plucky/main s390x plymouth s390x 24.004.60-2ubuntu4 [144 kB] 50s Get:45 http://ftpmaster.internal/ubuntu plucky/main s390x python3-distro-info all 1.12 [7754 B] 50s Get:46 http://ftpmaster.internal/ubuntu plucky/main s390x wget s390x 1.24.5-2ubuntu1 [369 kB] 50s Get:47 http://ftpmaster.internal/ubuntu plucky/main s390x xz-utils s390x 5.6.3-1 [273 kB] 50s Get:48 http://ftpmaster.internal/ubuntu plucky/main s390x ubuntu-standard s390x 1.544 [11.3 kB] 50s Get:49 http://ftpmaster.internal/ubuntu plucky/main s390x libcurl3t64-gnutls s390x 8.11.0-1ubuntu2 [386 kB] 50s Get:50 http://ftpmaster.internal/ubuntu plucky/main s390x libstemmer0d s390x 2.2.0-4build1 [174 kB] 50s Get:51 http://ftpmaster.internal/ubuntu plucky/main s390x libappstream5 s390x 1.0.3-1 [238 kB] 50s Get:52 http://ftpmaster.internal/ubuntu plucky/main s390x appstream s390x 1.0.3-1 [69.2 kB] 50s Get:53 http://ftpmaster.internal/ubuntu plucky/main s390x bpftrace s390x 0.21.2-2ubuntu3 [1718 kB] 50s Get:54 http://ftpmaster.internal/ubuntu plucky/main s390x cloud-init all 24.4-0ubuntu1 [2088 B] 50s Get:55 http://ftpmaster.internal/ubuntu plucky/main s390x cloud-init-base all 24.4-0ubuntu1 [612 kB] 50s Get:56 http://ftpmaster.internal/ubuntu plucky/main s390x curl s390x 8.11.0-1ubuntu2 [249 kB] 50s Get:57 http://ftpmaster.internal/ubuntu plucky/main s390x libcurl4t64 s390x 8.11.0-1ubuntu2 [390 kB] 50s Get:58 http://ftpmaster.internal/ubuntu plucky/main s390x dracut-install s390x 105-2ubuntu3 [36.0 kB] 50s Get:59 http://ftpmaster.internal/ubuntu plucky/main s390x libpackagekit-glib2-18 s390x 1.3.0-2 [117 kB] 50s Get:60 http://ftpmaster.internal/ubuntu plucky/main s390x gir1.2-packagekitglib-1.0 s390x 1.3.0-2 [25.2 kB] 50s Get:61 http://ftpmaster.internal/ubuntu plucky/main s390x libduktape207 s390x 2.7.0+tests-0ubuntu3 [150 kB] 50s Get:62 http://ftpmaster.internal/ubuntu plucky/main s390x libglib2.0-bin s390x 2.82.2-3 [99.3 kB] 50s Get:63 http://ftpmaster.internal/ubuntu plucky/main s390x libgstreamer1.0-0 s390x 1.24.9-1 [1213 kB] 50s Get:64 http://ftpmaster.internal/ubuntu plucky/main s390x libpolkit-agent-1-0 s390x 125-2ubuntu1 [17.3 kB] 50s Get:65 http://ftpmaster.internal/ubuntu plucky/main s390x libpolkit-gobject-1-0 s390x 125-2ubuntu1 [48.4 kB] 50s Get:66 http://ftpmaster.internal/ubuntu plucky/main s390x libsgutils2-1.48 s390x 1.48-0ubuntu1 [120 kB] 50s Get:67 http://ftpmaster.internal/ubuntu plucky/main s390x linux-base all 4.10.1ubuntu1 [34.8 kB] 50s Get:68 http://ftpmaster.internal/ubuntu plucky/main s390x lto-disabled-list all 54 [12.2 kB] 50s Get:69 http://ftpmaster.internal/ubuntu plucky/main s390x lxd-installer all 10 [5264 B] 50s Get:70 http://ftpmaster.internal/ubuntu plucky/main s390x xml-core all 0.19 [20.3 kB] 50s Get:71 http://ftpmaster.internal/ubuntu plucky/main s390x polkitd s390x 125-2ubuntu1 [96.1 kB] 50s Get:72 http://ftpmaster.internal/ubuntu plucky/main s390x packagekit s390x 1.3.0-2 [448 kB] 51s Get:73 http://ftpmaster.internal/ubuntu plucky/main s390x packagekit-tools s390x 1.3.0-2 [28.2 kB] 51s Get:74 http://ftpmaster.internal/ubuntu plucky/main s390x pinentry-curses s390x 1.3.1-0ubuntu2 [42.3 kB] 51s Get:75 http://ftpmaster.internal/ubuntu plucky/main s390x python3-blinker all 1.9.0-1 [10.7 kB] 51s Get:76 http://ftpmaster.internal/ubuntu plucky/main s390x python3-jaraco.text all 4.0.0-1 [11.5 kB] 51s Get:77 http://ftpmaster.internal/ubuntu plucky/main s390x python3-rpds-py s390x 0.21.0-2ubuntu1 [368 kB] 51s Get:78 http://ftpmaster.internal/ubuntu plucky/main s390x python3-jsonschema-specifications all 2023.12.1-2 [9116 B] 51s Get:79 http://ftpmaster.internal/ubuntu plucky/main s390x python3-pkg-resources all 75.2.0-1 [134 kB] 51s Get:80 http://ftpmaster.internal/ubuntu plucky/main s390x python3-setuptools all 75.2.0-1 [657 kB] 51s Get:81 http://ftpmaster.internal/ubuntu plucky/main s390x python3-software-properties all 0.105 [30.3 kB] 51s Get:82 http://ftpmaster.internal/ubuntu plucky/main s390x sg3-utils s390x 1.48-0ubuntu1 [1027 kB] 51s Get:83 http://ftpmaster.internal/ubuntu plucky/main s390x sg3-utils-udev all 1.48-0ubuntu1 [6608 B] 51s Get:84 http://ftpmaster.internal/ubuntu plucky/main s390x software-properties-common all 0.105 [16.5 kB] 51s Get:85 http://ftpmaster.internal/ubuntu plucky/main s390x ubuntu-kernel-accessories s390x 1.544 [11.0 kB] 51s Get:86 http://ftpmaster.internal/ubuntu plucky/main s390x unattended-upgrades all 2.9.1+nmu4ubuntu1 [51.2 kB] 51s Preconfiguring packages ... 51s Fetched 29.9 MB in 2s (13.7 MB/s) 51s (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 ... 55541 files and directories currently installed.) 51s Preparing to unpack .../bash_5.2.32-1ubuntu2_s390x.deb ... 51s Unpacking bash (5.2.32-1ubuntu2) over (5.2.32-1ubuntu1) ... 51s Setting up bash (5.2.32-1ubuntu2) ... 51s update-alternatives: using /usr/share/man/man7/bash-builtins.7.gz to provide /usr/share/man/man7/builtins.7.gz (builtins.7.gz) in auto mode 51s (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 ... 55541 files and directories currently installed.) 51s Preparing to unpack .../hostname_3.25_s390x.deb ... 51s Unpacking hostname (3.25) over (3.23+nmu2ubuntu2) ... 51s Setting up hostname (3.25) ... 51s (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 ... 55541 files and directories currently installed.) 51s Preparing to unpack .../libperl5.40_5.40.0-8_s390x.deb ... 51s Unpacking libperl5.40:s390x (5.40.0-8) over (5.40.0-7) ... 51s Preparing to unpack .../perl_5.40.0-8_s390x.deb ... 51s Unpacking perl (5.40.0-8) over (5.40.0-7) ... 52s Preparing to unpack .../perl-base_5.40.0-8_s390x.deb ... 52s Unpacking perl-base (5.40.0-8) over (5.40.0-7) ... 52s Setting up perl-base (5.40.0-8) ... 52s (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 ... 55541 files and directories currently installed.) 52s Preparing to unpack .../perl-modules-5.40_5.40.0-8_all.deb ... 52s Unpacking perl-modules-5.40 (5.40.0-8) over (5.40.0-7) ... 52s Preparing to unpack .../init-system-helpers_1.67ubuntu1_all.deb ... 52s Unpacking init-system-helpers (1.67ubuntu1) over (1.66ubuntu1) ... 52s Setting up init-system-helpers (1.67ubuntu1) ... 52s (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 ... 55541 files and directories currently installed.) 52s Preparing to unpack .../liblzma5_5.6.3-1_s390x.deb ... 52s Unpacking liblzma5:s390x (5.6.3-1) over (5.6.2-2) ... 52s Setting up liblzma5:s390x (5.6.3-1) ... 52s (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 ... 55541 files and directories currently installed.) 52s Preparing to unpack .../libapt-pkg6.0t64_2.9.14ubuntu1_s390x.deb ... 52s Unpacking libapt-pkg6.0t64:s390x (2.9.14ubuntu1) over (2.9.8) ... 52s Setting up libapt-pkg6.0t64:s390x (2.9.14ubuntu1) ... 52s (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 ... 55541 files and directories currently installed.) 52s Preparing to unpack .../apt_2.9.14ubuntu1_s390x.deb ... 52s Unpacking apt (2.9.14ubuntu1) over (2.9.8) ... 52s Setting up apt (2.9.14ubuntu1) ... 53s (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 ... 55533 files and directories currently installed.) 53s Preparing to unpack .../apt-utils_2.9.14ubuntu1_s390x.deb ... 53s Unpacking apt-utils (2.9.14ubuntu1) over (2.9.8) ... 53s Preparing to unpack .../libaudit-common_1%3a4.0.2-2ubuntu1_all.deb ... 53s Unpacking libaudit-common (1:4.0.2-2ubuntu1) over (1:4.0.1-1ubuntu2) ... 53s Setting up libaudit-common (1:4.0.2-2ubuntu1) ... 53s (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 ... 55533 files and directories currently installed.) 53s Preparing to unpack .../libaudit1_1%3a4.0.2-2ubuntu1_s390x.deb ... 53s Unpacking libaudit1:s390x (1:4.0.2-2ubuntu1) over (1:4.0.1-1ubuntu2) ... 53s Setting up libaudit1:s390x (1:4.0.2-2ubuntu1) ... 53s (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 ... 55533 files and directories currently installed.) 53s Preparing to unpack .../debconf-i18n_1.5.87ubuntu1_all.deb ... 53s Unpacking debconf-i18n (1.5.87ubuntu1) over (1.5.86ubuntu1) ... 53s Preparing to unpack .../python3-debconf_1.5.87ubuntu1_all.deb ... 53s Unpacking python3-debconf (1.5.87ubuntu1) over (1.5.86ubuntu1) ... 53s Preparing to unpack .../debconf_1.5.87ubuntu1_all.deb ... 53s Unpacking debconf (1.5.87ubuntu1) over (1.5.86ubuntu1) ... 53s Setting up debconf (1.5.87ubuntu1) ... 53s (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 ... 55533 files and directories currently installed.) 53s Preparing to unpack .../libpam0g_1.5.3-7ubuntu4_s390x.deb ... 53s Unpacking libpam0g:s390x (1.5.3-7ubuntu4) over (1.5.3-7ubuntu2) ... 53s Setting up libpam0g:s390x (1.5.3-7ubuntu4) ... 53s (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 ... 55533 files and directories currently installed.) 53s Preparing to unpack .../libselinux1_3.7-3ubuntu1_s390x.deb ... 53s Unpacking libselinux1:s390x (3.7-3ubuntu1) over (3.5-2ubuntu5) ... 53s Setting up libselinux1:s390x (3.7-3ubuntu1) ... 53s (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 ... 55533 files and directories currently installed.) 53s Preparing to unpack .../libpam-modules-bin_1.5.3-7ubuntu4_s390x.deb ... 53s Unpacking libpam-modules-bin (1.5.3-7ubuntu4) over (1.5.3-7ubuntu2) ... 53s Setting up libpam-modules-bin (1.5.3-7ubuntu4) ... 53s pam_namespace.service is a disabled or a static unit not running, not starting it. 53s (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 ... 55533 files and directories currently installed.) 53s Preparing to unpack .../libpam-modules_1.5.3-7ubuntu4_s390x.deb ... 53s Unpacking libpam-modules:s390x (1.5.3-7ubuntu4) over (1.5.3-7ubuntu2) ... 53s Setting up libpam-modules:s390x (1.5.3-7ubuntu4) ... 53s (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 ... 55533 files and directories currently installed.) 53s Preparing to unpack .../init_1.67ubuntu1_s390x.deb ... 53s Unpacking init (1.67ubuntu1) over (1.66ubuntu1) ... 53s Preparing to unpack .../openssh-sftp-server_1%3a9.9p1-3ubuntu2_s390x.deb ... 53s Unpacking openssh-sftp-server (1:9.9p1-3ubuntu2) over (1:9.7p1-7ubuntu5) ... 53s Preparing to unpack .../openssh-server_1%3a9.9p1-3ubuntu2_s390x.deb ... 54s Unpacking openssh-server (1:9.9p1-3ubuntu2) over (1:9.7p1-7ubuntu5) ... 54s Preparing to unpack .../openssh-client_1%3a9.9p1-3ubuntu2_s390x.deb ... 54s Unpacking openssh-client (1:9.9p1-3ubuntu2) over (1:9.7p1-7ubuntu5) ... 54s Preparing to unpack .../libpam-runtime_1.5.3-7ubuntu4_all.deb ... 54s Unpacking libpam-runtime (1.5.3-7ubuntu4) over (1.5.3-7ubuntu2) ... 54s Setting up libpam-runtime (1.5.3-7ubuntu4) ... 54s Selecting previously unselected package sgml-base. 54s (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 ... 55535 files and directories currently installed.) 54s Preparing to unpack .../sgml-base_1.31_all.deb ... 54s Unpacking sgml-base (1.31) ... 54s Preparing to unpack .../libsemanage-common_3.7-2build1_all.deb ... 54s Unpacking libsemanage-common (3.7-2build1) over (3.5-1build6) ... 54s Setting up libsemanage-common (3.7-2build1) ... 54s (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 ... 55561 files and directories currently installed.) 54s Preparing to unpack .../libsemanage2_3.7-2build1_s390x.deb ... 54s Unpacking libsemanage2:s390x (3.7-2build1) over (3.5-1build6) ... 54s Setting up libsemanage2:s390x (3.7-2build1) ... 54s (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 ... 55561 files and directories currently installed.) 54s Preparing to unpack .../00-distro-info_1.12_s390x.deb ... 54s Unpacking distro-info (1.12) over (1.9) ... 54s Preparing to unpack .../01-gir1.2-girepository-2.0_1.82.0-2_s390x.deb ... 54s Unpacking gir1.2-girepository-2.0:s390x (1.82.0-2) over (1.80.1-4) ... 54s Preparing to unpack .../02-gir1.2-glib-2.0_2.82.2-3_s390x.deb ... 54s Unpacking gir1.2-glib-2.0:s390x (2.82.2-3) over (2.82.1-0ubuntu1) ... 54s Preparing to unpack .../03-libglib2.0-0t64_2.82.2-3_s390x.deb ... 54s Unpacking libglib2.0-0t64:s390x (2.82.2-3) over (2.82.1-0ubuntu1) ... 54s Preparing to unpack .../04-libgirepository-1.0-1_1.82.0-2_s390x.deb ... 54s Unpacking libgirepository-1.0-1:s390x (1.82.0-2) over (1.80.1-4) ... 54s Preparing to unpack .../05-libglib2.0-data_2.82.2-3_all.deb ... 54s Unpacking libglib2.0-data (2.82.2-3) over (2.82.1-0ubuntu1) ... 54s Preparing to unpack .../06-python-apt-common_2.9.0ubuntu2_all.deb ... 54s Unpacking python-apt-common (2.9.0ubuntu2) over (2.9.0ubuntu1) ... 54s Preparing to unpack .../07-python3-apt_2.9.0ubuntu2_s390x.deb ... 54s Unpacking python3-apt (2.9.0ubuntu2) over (2.9.0ubuntu1) ... 54s Preparing to unpack .../08-python3-yaml_6.0.2-1build1_s390x.deb ... 54s Unpacking python3-yaml (6.0.2-1build1) over (6.0.2-1) ... 54s Preparing to unpack .../09-vim-tiny_2%3a9.1.0861-1ubuntu1_s390x.deb ... 54s Unpacking vim-tiny (2:9.1.0861-1ubuntu1) over (2:9.1.0777-1ubuntu1) ... 54s Preparing to unpack .../10-vim-common_2%3a9.1.0861-1ubuntu1_all.deb ... 54s Unpacking vim-common (2:9.1.0861-1ubuntu1) over (2:9.1.0777-1ubuntu1) ... 54s Preparing to unpack .../11-ubuntu-minimal_1.544_s390x.deb ... 54s Unpacking ubuntu-minimal (1.544) over (1.543) ... 54s Preparing to unpack .../12-xxd_2%3a9.1.0861-1ubuntu1_s390x.deb ... 54s Unpacking xxd (2:9.1.0861-1ubuntu1) over (2:9.1.0777-1ubuntu1) ... 54s Preparing to unpack .../13-libplymouth5_24.004.60-2ubuntu4_s390x.deb ... 54s Unpacking libplymouth5:s390x (24.004.60-2ubuntu4) over (24.004.60-1ubuntu11) ... 54s Preparing to unpack .../14-plymouth-theme-ubuntu-text_24.004.60-2ubuntu4_s390x.deb ... 54s Unpacking plymouth-theme-ubuntu-text (24.004.60-2ubuntu4) over (24.004.60-1ubuntu11) ... 54s Preparing to unpack .../15-plymouth_24.004.60-2ubuntu4_s390x.deb ... 54s Unpacking plymouth (24.004.60-2ubuntu4) over (24.004.60-1ubuntu11) ... 54s Selecting previously unselected package python3-distro-info. 54s Preparing to unpack .../16-python3-distro-info_1.12_all.deb ... 54s Unpacking python3-distro-info (1.12) ... 54s Preparing to unpack .../17-wget_1.24.5-2ubuntu1_s390x.deb ... 54s Unpacking wget (1.24.5-2ubuntu1) over (1.24.5-1ubuntu2) ... 54s Preparing to unpack .../18-xz-utils_5.6.3-1_s390x.deb ... 54s Unpacking xz-utils (5.6.3-1) over (5.6.2-2) ... 54s Preparing to unpack .../19-ubuntu-standard_1.544_s390x.deb ... 54s Unpacking ubuntu-standard (1.544) over (1.543) ... 54s Preparing to unpack .../20-libcurl3t64-gnutls_8.11.0-1ubuntu2_s390x.deb ... 54s Unpacking libcurl3t64-gnutls:s390x (8.11.0-1ubuntu2) over (8.9.1-2ubuntu2) ... 54s Selecting previously unselected package libstemmer0d:s390x. 54s Preparing to unpack .../21-libstemmer0d_2.2.0-4build1_s390x.deb ... 54s Unpacking libstemmer0d:s390x (2.2.0-4build1) ... 54s Selecting previously unselected package libappstream5:s390x. 54s Preparing to unpack .../22-libappstream5_1.0.3-1_s390x.deb ... 54s Unpacking libappstream5:s390x (1.0.3-1) ... 54s Selecting previously unselected package appstream. 54s Preparing to unpack .../23-appstream_1.0.3-1_s390x.deb ... 54s Unpacking appstream (1.0.3-1) ... 54s Preparing to unpack .../24-bpftrace_0.21.2-2ubuntu3_s390x.deb ... 54s Unpacking bpftrace (0.21.2-2ubuntu3) over (0.21.2-2ubuntu2) ... 54s Preparing to unpack .../25-cloud-init_24.4-0ubuntu1_all.deb ... 54s Unpacking cloud-init (24.4-0ubuntu1) over (24.4~3+really24.3.1-0ubuntu4) ... 55s dpkg: warning: unable to delete old directory '/etc/cloud/templates': Directory not empty 55s dpkg: warning: unable to delete old directory '/etc/cloud/cloud.cfg.d': Directory not empty 55s dpkg: warning: unable to delete old directory '/etc/cloud': Directory not empty 55s Selecting previously unselected package cloud-init-base. 55s Preparing to unpack .../26-cloud-init-base_24.4-0ubuntu1_all.deb ... 55s Unpacking cloud-init-base (24.4-0ubuntu1) ... 55s Preparing to unpack .../27-curl_8.11.0-1ubuntu2_s390x.deb ... 55s Unpacking curl (8.11.0-1ubuntu2) over (8.9.1-2ubuntu2) ... 55s Preparing to unpack .../28-libcurl4t64_8.11.0-1ubuntu2_s390x.deb ... 55s Unpacking libcurl4t64:s390x (8.11.0-1ubuntu2) over (8.9.1-2ubuntu2) ... 55s Preparing to unpack .../29-dracut-install_105-2ubuntu3_s390x.deb ... 55s Unpacking dracut-install (105-2ubuntu3) over (105-1ubuntu1) ... 55s Selecting previously unselected package libpackagekit-glib2-18:s390x. 55s Preparing to unpack .../30-libpackagekit-glib2-18_1.3.0-2_s390x.deb ... 55s Unpacking libpackagekit-glib2-18:s390x (1.3.0-2) ... 55s Selecting previously unselected package gir1.2-packagekitglib-1.0. 55s Preparing to unpack .../31-gir1.2-packagekitglib-1.0_1.3.0-2_s390x.deb ... 55s Unpacking gir1.2-packagekitglib-1.0 (1.3.0-2) ... 55s Selecting previously unselected package libduktape207:s390x. 55s Preparing to unpack .../32-libduktape207_2.7.0+tests-0ubuntu3_s390x.deb ... 55s Unpacking libduktape207:s390x (2.7.0+tests-0ubuntu3) ... 55s Selecting previously unselected package libglib2.0-bin. 55s Preparing to unpack .../33-libglib2.0-bin_2.82.2-3_s390x.deb ... 55s Unpacking libglib2.0-bin (2.82.2-3) ... 55s Selecting previously unselected package libgstreamer1.0-0:s390x. 55s Preparing to unpack .../34-libgstreamer1.0-0_1.24.9-1_s390x.deb ... 55s Unpacking libgstreamer1.0-0:s390x (1.24.9-1) ... 55s Preparing to unpack .../35-libpolkit-agent-1-0_125-2ubuntu1_s390x.deb ... 55s Unpacking libpolkit-agent-1-0:s390x (125-2ubuntu1) over (124-2ubuntu1) ... 55s Preparing to unpack .../36-libpolkit-gobject-1-0_125-2ubuntu1_s390x.deb ... 55s Unpacking libpolkit-gobject-1-0:s390x (125-2ubuntu1) over (124-2ubuntu1) ... 55s Selecting previously unselected package libsgutils2-1.48:s390x. 55s Preparing to unpack .../37-libsgutils2-1.48_1.48-0ubuntu1_s390x.deb ... 55s Unpacking libsgutils2-1.48:s390x (1.48-0ubuntu1) ... 55s Preparing to unpack .../38-linux-base_4.10.1ubuntu1_all.deb ... 55s Unpacking linux-base (4.10.1ubuntu1) over (4.5ubuntu9) ... 55s Preparing to unpack .../39-lto-disabled-list_54_all.deb ... 55s Unpacking lto-disabled-list (54) over (53) ... 55s Preparing to unpack .../40-lxd-installer_10_all.deb ... 55s Unpacking lxd-installer (10) over (9) ... 55s Selecting previously unselected package xml-core. 55s Preparing to unpack .../41-xml-core_0.19_all.deb ... 55s Unpacking xml-core (0.19) ... 55s Selecting previously unselected package polkitd. 55s Preparing to unpack .../42-polkitd_125-2ubuntu1_s390x.deb ... 55s Unpacking polkitd (125-2ubuntu1) ... 55s Selecting previously unselected package packagekit. 55s Preparing to unpack .../43-packagekit_1.3.0-2_s390x.deb ... 55s Unpacking packagekit (1.3.0-2) ... 55s Selecting previously unselected package packagekit-tools. 55s Preparing to unpack .../44-packagekit-tools_1.3.0-2_s390x.deb ... 55s Unpacking packagekit-tools (1.3.0-2) ... 55s Preparing to unpack .../45-pinentry-curses_1.3.1-0ubuntu2_s390x.deb ... 55s Unpacking pinentry-curses (1.3.1-0ubuntu2) over (1.2.1-3ubuntu5) ... 55s Preparing to unpack .../46-python3-blinker_1.9.0-1_all.deb ... 55s Unpacking python3-blinker (1.9.0-1) over (1.8.2-1) ... 55s Selecting previously unselected package python3-jaraco.text. 55s Preparing to unpack .../47-python3-jaraco.text_4.0.0-1_all.deb ... 55s Unpacking python3-jaraco.text (4.0.0-1) ... 55s Preparing to unpack .../48-python3-rpds-py_0.21.0-2ubuntu1_s390x.deb ... 55s Unpacking python3-rpds-py (0.21.0-2ubuntu1) over (0.20.0-0ubuntu3) ... 55s Preparing to unpack .../49-python3-jsonschema-specifications_2023.12.1-2_all.deb ... 55s Unpacking python3-jsonschema-specifications (2023.12.1-2) over (2023.12.1-1ubuntu1) ... 55s Preparing to unpack .../50-python3-pkg-resources_75.2.0-1_all.deb ... 55s Unpacking python3-pkg-resources (75.2.0-1) over (74.1.2-1) ... 55s Preparing to unpack .../51-python3-setuptools_75.2.0-1_all.deb ... 55s Unpacking python3-setuptools (75.2.0-1) over (74.1.2-1) ... 56s Selecting previously unselected package python3-software-properties. 56s Preparing to unpack .../52-python3-software-properties_0.105_all.deb ... 56s Unpacking python3-software-properties (0.105) ... 56s Preparing to unpack .../53-sg3-utils_1.48-0ubuntu1_s390x.deb ... 56s Unpacking sg3-utils (1.48-0ubuntu1) over (1.46-3ubuntu5) ... 56s Preparing to unpack .../54-sg3-utils-udev_1.48-0ubuntu1_all.deb ... 56s Unpacking sg3-utils-udev (1.48-0ubuntu1) over (1.46-3ubuntu5) ... 56s Selecting previously unselected package software-properties-common. 56s Preparing to unpack .../55-software-properties-common_0.105_all.deb ... 56s Unpacking software-properties-common (0.105) ... 56s Preparing to unpack .../56-ubuntu-kernel-accessories_1.544_s390x.deb ... 56s Unpacking ubuntu-kernel-accessories (1.544) over (1.543) ... 56s Selecting previously unselected package unattended-upgrades. 56s Preparing to unpack .../57-unattended-upgrades_2.9.1+nmu4ubuntu1_all.deb ... 56s Unpacking unattended-upgrades (2.9.1+nmu4ubuntu1) ... 56s Setting up python3-pkg-resources (75.2.0-1) ... 56s Setting up pinentry-curses (1.3.1-0ubuntu2) ... 56s Setting up distro-info (1.12) ... 56s Setting up lto-disabled-list (54) ... 56s Setting up ubuntu-kernel-accessories (1.544) ... 56s Setting up apt-utils (2.9.14ubuntu1) ... 56s Setting up linux-base (4.10.1ubuntu1) ... 56s Setting up wget (1.24.5-2ubuntu1) ... 56s Setting up init (1.67ubuntu1) ... 56s Setting up libcurl4t64:s390x (8.11.0-1ubuntu2) ... 56s Setting up bpftrace (0.21.2-2ubuntu3) ... 56s Setting up openssh-client (1:9.9p1-3ubuntu2) ... 56s Setting up python3-debconf (1.5.87ubuntu1) ... 56s Setting up libcurl3t64-gnutls:s390x (8.11.0-1ubuntu2) ... 56s Setting up libsgutils2-1.48:s390x (1.48-0ubuntu1) ... 56s Setting up python3-yaml (6.0.2-1build1) ... 56s Setting up debconf-i18n (1.5.87ubuntu1) ... 56s Setting up cloud-init-base (24.4-0ubuntu1) ... 57s Setting up xxd (2:9.1.0861-1ubuntu1) ... 57s Setting up libglib2.0-0t64:s390x (2.82.2-3) ... 57s No schema files found: doing nothing. 57s Setting up libglib2.0-data (2.82.2-3) ... 57s Setting up vim-common (2:9.1.0861-1ubuntu1) ... 57s Setting up python3-jaraco.text (4.0.0-1) ... 57s Setting up xz-utils (5.6.3-1) ... 57s Setting up gir1.2-glib-2.0:s390x (2.82.2-3) ... 57s Setting up lxd-installer (10) ... 58s Setting up python3-rpds-py (0.21.0-2ubuntu1) ... 58s Setting up python-apt-common (2.9.0ubuntu2) ... 58s Setting up dracut-install (105-2ubuntu3) ... 58s Setting up perl-modules-5.40 (5.40.0-8) ... 58s Setting up libduktape207:s390x (2.7.0+tests-0ubuntu3) ... 58s Setting up libplymouth5:s390x (24.004.60-2ubuntu4) ... 58s Setting up libgirepository-1.0-1:s390x (1.82.0-2) ... 58s Setting up sgml-base (1.31) ... 58s Setting up curl (8.11.0-1ubuntu2) ... 58s Setting up libstemmer0d:s390x (2.2.0-4build1) ... 58s Setting up python3-jsonschema-specifications (2023.12.1-2) ... 58s Setting up python3-distro-info (1.12) ... 58s Setting up libpolkit-gobject-1-0:s390x (125-2ubuntu1) ... 58s Setting up libgstreamer1.0-0:s390x (1.24.9-1) ... 58s Setcap worked! gst-ptp-helper is not suid! 58s Setting up sg3-utils (1.48-0ubuntu1) ... 58s Setting up python3-blinker (1.9.0-1) ... 58s Setting up openssh-sftp-server (1:9.9p1-3ubuntu2) ... 58s Setting up cloud-init (24.4-0ubuntu1) ... 58s Setting up python3-setuptools (75.2.0-1) ... 59s Setting up openssh-server (1:9.9p1-3ubuntu2) ... 59s Installing new version of config file /etc/ssh/moduli ... 59s Replacing config file /etc/ssh/sshd_config with new version 60s Setting up plymouth (24.004.60-2ubuntu4) ... 60s update-rc.d: warning: start and stop actions are no longer supported; falling back to defaults 60s update-rc.d: warning: start and stop actions are no longer supported; falling back to defaults 60s Setting up python3-apt (2.9.0ubuntu2) ... 60s Setting up libglib2.0-bin (2.82.2-3) ... 60s Setting up libpackagekit-glib2-18:s390x (1.3.0-2) ... 60s Setting up libappstream5:s390x (1.0.3-1) ... 60s Setting up vim-tiny (2:9.1.0861-1ubuntu1) ... 60s Setting up ubuntu-standard (1.544) ... 60s Setting up sg3-utils-udev (1.48-0ubuntu1) ... 60s update-initramfs: deferring update (trigger activated) 60s Setting up libperl5.40:s390x (5.40.0-8) ... 60s Setting up gir1.2-packagekitglib-1.0 (1.3.0-2) ... 60s Setting up unattended-upgrades (2.9.1+nmu4ubuntu1) ... 60s 60s Creating config file /etc/apt/apt.conf.d/20auto-upgrades with new version 60s 60s Creating config file /etc/apt/apt.conf.d/50unattended-upgrades with new version 60s Created symlink '/etc/systemd/system/multi-user.target.wants/unattended-upgrades.service' → '/usr/lib/systemd/system/unattended-upgrades.service'. 61s Synchronizing state of unattended-upgrades.service with SysV service script with /usr/lib/systemd/systemd-sysv-install. 61s Executing: /usr/lib/systemd/systemd-sysv-install enable unattended-upgrades 61s Setting up perl (5.40.0-8) ... 61s Setting up appstream (1.0.3-1) ... 61s ✔ Metadata cache was updated successfully. 61s Setting up python3-software-properties (0.105) ... 61s Setting up gir1.2-girepository-2.0:s390x (1.82.0-2) ... 61s Setting up xml-core (0.19) ... 61s Setting up libpolkit-agent-1-0:s390x (125-2ubuntu1) ... 61s Setting up ubuntu-minimal (1.544) ... 61s Processing triggers for dbus (1.14.10-4ubuntu5) ... 61s Processing triggers for debianutils (5.21) ... 62s Processing triggers for install-info (7.1.1-1) ... 62s Processing triggers for initramfs-tools (0.142ubuntu35) ... 62s update-initramfs: Generating /boot/initrd.img-6.11.0-8-generic 62s W: No lz4 in /usr/bin:/sbin:/bin, using gzip 63s Using config file '/etc/zipl.conf' 63s Building bootmap in '/boot' 63s Adding IPL section 'ubuntu' (default) 63s Preparing boot device for LD-IPL: vda (0000). 63s Done. 63s Processing triggers for libc-bin (2.40-1ubuntu3) ... 63s Processing triggers for rsyslog (8.2406.0-1ubuntu2) ... 64s Processing triggers for ufw (0.36.2-8) ... 64s Processing triggers for man-db (2.13.0-1) ... 65s Setting up plymouth-theme-ubuntu-text (24.004.60-2ubuntu4) ... 65s Processing triggers for sgml-base (1.31) ... 65s Setting up polkitd (125-2ubuntu1) ... 65s Setting up packagekit (1.3.0-2) ... 65s Created symlink '/etc/systemd/user/sockets.target.wants/pk-debconf-helper.socket' → '/usr/lib/systemd/user/pk-debconf-helper.socket'. 65s Setting up packagekit-tools (1.3.0-2) ... 65s Setting up software-properties-common (0.105) ... 65s Processing triggers for initramfs-tools (0.142ubuntu35) ... 65s update-initramfs: Generating /boot/initrd.img-6.11.0-8-generic 65s W: No lz4 in /usr/bin:/sbin:/bin, using gzip 67s Using config file '/etc/zipl.conf' 67s Building bootmap in '/boot' 67s Adding IPL section 'ubuntu' (default) 67s Preparing boot device for LD-IPL: vda (0000). 67s Done. 67s Processing triggers for dbus (1.14.10-4ubuntu5) ... 68s Reading package lists... 68s Building dependency tree... 68s Reading state information... 68s The following packages will be REMOVED: 68s libsgutils2-1.46-2* 68s 0 upgraded, 0 newly installed, 1 to remove and 0 not upgraded. 68s After this operation, 294 kB disk space will be freed. 68s (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 ... 55918 files and directories currently installed.) 68s Removing libsgutils2-1.46-2:s390x (1.46-3ubuntu5) ... 68s Processing triggers for libc-bin (2.40-1ubuntu3) ... 68s Reading package lists... 69s Building dependency tree... 69s Reading state information... 69s The following packages will be REMOVED: 69s python3-distro-info* unattended-upgrades* 69s 0 upgraded, 0 newly installed, 2 to remove and 0 not upgraded. 69s After this operation, 465 kB disk space will be freed. 69s (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 ... 55913 files and directories currently installed.) 69s Removing unattended-upgrades (2.9.1+nmu4ubuntu1) ... 69s Removing python3-distro-info (1.12) ... 69s Processing triggers for man-db (2.13.0-1) ... 69s (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 ... 55876 files and directories currently installed.) 69s Purging configuration files for unattended-upgrades (2.9.1+nmu4ubuntu1) ... 70s dpkg: warning: while removing unattended-upgrades, directory '/var/log/unattended-upgrades' not empty so not removed 70s dpkg: warning: while removing unattended-upgrades, directory '/lib/systemd/system-sleep' not empty so not removed 70s Hit:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease 70s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 70s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 70s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 71s Reading package lists... 71s Reading package lists... 71s Building dependency tree... 71s Reading state information... 71s Calculating upgrade... 71s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 72s Reading package lists... 72s Building dependency tree... 72s Reading state information... 72s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 72s autopkgtest [06:07:44]: rebooting testbed after setup commands that affected boot 76s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 89s autopkgtest [06:08:01]: testbed running kernel: Linux 6.11.0-8-generic #8-Ubuntu SMP Mon Sep 16 12:49:35 UTC 2024 92s autopkgtest [06:08:04]: @@@@@@@@@@@@@@@@@@@@ apt-source pg-fact-loader 93s Get:1 http://ftpmaster.internal/ubuntu plucky/universe pg-fact-loader 2.0.1-4 (dsc) [2295 B] 93s Get:2 http://ftpmaster.internal/ubuntu plucky/universe pg-fact-loader 2.0.1-4 (tar) [277 kB] 93s Get:3 http://ftpmaster.internal/ubuntu plucky/universe pg-fact-loader 2.0.1-4 (diff) [3756 B] 93s gpgv: Signature made Tue Sep 17 16:27:43 2024 UTC 93s gpgv: using RSA key 5C48FE6157F49179597087C64C5A6BAB12D2A7AE 93s gpgv: Can't check signature: No public key 93s dpkg-source: warning: cannot verify inline signature for ./pg-fact-loader_2.0.1-4.dsc: no acceptable signature found 93s autopkgtest [06:08:05]: testing package pg-fact-loader version 2.0.1-4 94s autopkgtest [06:08:06]: build not needed 94s autopkgtest [06:08:06]: test installcheck: preparing testbed 95s Reading package lists... 95s Building dependency tree... 95s Reading state information... 95s Starting pkgProblemResolver with broken count: 0 95s Starting 2 pkgProblemResolver with broken count: 0 95s Done 96s The following additional packages will be installed: 96s libio-pty-perl libipc-run-perl libjson-perl libpq5 libxslt1.1 postgresql-17 96s postgresql-17-pg-fact-loader postgresql-17-pglogical 96s postgresql-17-pglogical-ticker postgresql-client-17 postgresql-client-common 96s postgresql-common ssl-cert 96s Suggested packages: 96s postgresql-doc-17 96s Recommended packages: 96s libjson-xs-perl 96s The following NEW packages will be installed: 96s autopkgtest-satdep libio-pty-perl libipc-run-perl libjson-perl libpq5 96s libxslt1.1 postgresql-17 postgresql-17-pg-fact-loader 96s postgresql-17-pglogical postgresql-17-pglogical-ticker postgresql-client-17 96s postgresql-client-common postgresql-common ssl-cert 96s 0 upgraded, 14 newly installed, 0 to remove and 0 not upgraded. 96s Need to get 19.4 MB/19.4 MB of archives. 96s After this operation, 57.5 MB of additional disk space will be used. 96s Get:1 /tmp/autopkgtest.GxExHx/1-autopkgtest-satdep.deb autopkgtest-satdep s390x 0 [744 B] 96s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x libjson-perl all 4.10000-1 [81.9 kB] 96s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x libio-pty-perl s390x 1:1.20-1build3 [31.6 kB] 96s Get:4 http://ftpmaster.internal/ubuntu plucky/main s390x libipc-run-perl all 20231003.0-2 [91.5 kB] 96s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x postgresql-client-common all 267 [37.1 kB] 96s Get:6 http://ftpmaster.internal/ubuntu plucky/main s390x ssl-cert all 1.1.3ubuntu1 [18.7 kB] 96s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x postgresql-common all 267 [162 kB] 96s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libpq5 s390x 17.2-1 [146 kB] 96s Get:9 http://ftpmaster.internal/ubuntu plucky/main s390x libxslt1.1 s390x 1.1.39-0exp1ubuntu1 [169 kB] 96s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x postgresql-client-17 s390x 17.2-1 [1342 kB] 96s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x postgresql-17 s390x 17.2-1 [16.9 MB] 97s Get:12 http://ftpmaster.internal/ubuntu plucky/universe s390x postgresql-17-pg-fact-loader s390x 2.0.1-4 [42.2 kB] 97s Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x postgresql-17-pglogical s390x 2.4.5-1 [391 kB] 97s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x postgresql-17-pglogical-ticker s390x 1.4.1-8 [21.5 kB] 97s Preconfiguring packages ... 97s Fetched 19.4 MB in 1s (18.6 MB/s) 97s Selecting previously unselected package libjson-perl. 97s (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.) 97s Preparing to unpack .../00-libjson-perl_4.10000-1_all.deb ... 97s Unpacking libjson-perl (4.10000-1) ... 97s Selecting previously unselected package libio-pty-perl. 97s Preparing to unpack .../01-libio-pty-perl_1%3a1.20-1build3_s390x.deb ... 97s Unpacking libio-pty-perl (1:1.20-1build3) ... 97s Selecting previously unselected package libipc-run-perl. 97s Preparing to unpack .../02-libipc-run-perl_20231003.0-2_all.deb ... 97s Unpacking libipc-run-perl (20231003.0-2) ... 97s Selecting previously unselected package postgresql-client-common. 97s Preparing to unpack .../03-postgresql-client-common_267_all.deb ... 97s Unpacking postgresql-client-common (267) ... 97s Selecting previously unselected package ssl-cert. 97s Preparing to unpack .../04-ssl-cert_1.1.3ubuntu1_all.deb ... 97s Unpacking ssl-cert (1.1.3ubuntu1) ... 97s Selecting previously unselected package postgresql-common. 97s Preparing to unpack .../05-postgresql-common_267_all.deb ... 97s Adding 'diversion of /usr/bin/pg_config to /usr/bin/pg_config.libpq-dev by postgresql-common' 97s Unpacking postgresql-common (267) ... 97s Selecting previously unselected package libpq5:s390x. 97s Preparing to unpack .../06-libpq5_17.2-1_s390x.deb ... 97s Unpacking libpq5:s390x (17.2-1) ... 97s Selecting previously unselected package libxslt1.1:s390x. 97s Preparing to unpack .../07-libxslt1.1_1.1.39-0exp1ubuntu1_s390x.deb ... 97s Unpacking libxslt1.1:s390x (1.1.39-0exp1ubuntu1) ... 97s Selecting previously unselected package postgresql-client-17. 97s Preparing to unpack .../08-postgresql-client-17_17.2-1_s390x.deb ... 97s Unpacking postgresql-client-17 (17.2-1) ... 97s Selecting previously unselected package postgresql-17. 97s Preparing to unpack .../09-postgresql-17_17.2-1_s390x.deb ... 97s Unpacking postgresql-17 (17.2-1) ... 97s Selecting previously unselected package postgresql-17-pg-fact-loader. 97s Preparing to unpack .../10-postgresql-17-pg-fact-loader_2.0.1-4_s390x.deb ... 97s Unpacking postgresql-17-pg-fact-loader (2.0.1-4) ... 97s Selecting previously unselected package postgresql-17-pglogical. 97s Preparing to unpack .../11-postgresql-17-pglogical_2.4.5-1_s390x.deb ... 97s Unpacking postgresql-17-pglogical (2.4.5-1) ... 97s Selecting previously unselected package postgresql-17-pglogical-ticker. 97s Preparing to unpack .../12-postgresql-17-pglogical-ticker_1.4.1-8_s390x.deb ... 97s Unpacking postgresql-17-pglogical-ticker (1.4.1-8) ... 97s Selecting previously unselected package autopkgtest-satdep. 97s Preparing to unpack .../13-1-autopkgtest-satdep.deb ... 97s Unpacking autopkgtest-satdep (0) ... 97s Setting up libio-pty-perl (1:1.20-1build3) ... 97s Setting up libpq5:s390x (17.2-1) ... 97s Setting up ssl-cert (1.1.3ubuntu1) ... 98s Created symlink '/etc/systemd/system/multi-user.target.wants/ssl-cert.service' → '/usr/lib/systemd/system/ssl-cert.service'. 98s Setting up libipc-run-perl (20231003.0-2) ... 98s Setting up libjson-perl (4.10000-1) ... 98s Setting up libxslt1.1:s390x (1.1.39-0exp1ubuntu1) ... 98s Setting up postgresql-client-common (267) ... 98s Setting up postgresql-client-17 (17.2-1) ... 98s update-alternatives: using /usr/share/postgresql/17/man/man1/psql.1.gz to provide /usr/share/man/man1/psql.1.gz (psql.1.gz) in auto mode 98s Setting up postgresql-common (267) ... 99s 99s Creating config file /etc/postgresql-common/createcluster.conf with new version 99s Building PostgreSQL dictionaries from installed myspell/hunspell packages... 99s Removing obsolete dictionary files: 99s Created symlink '/etc/systemd/system/multi-user.target.wants/postgresql.service' → '/usr/lib/systemd/system/postgresql.service'. 99s Setting up postgresql-17 (17.2-1) ... 100s Creating new PostgreSQL cluster 17/main ... 100s /usr/lib/postgresql/17/bin/initdb -D /var/lib/postgresql/17/main --auth-local peer --auth-host scram-sha-256 --no-instructions 100s The files belonging to this database system will be owned by user "postgres". 100s This user must also own the server process. 100s 100s The database cluster will be initialized with locale "C.UTF-8". 100s The default database encoding has accordingly been set to "UTF8". 100s The default text search configuration will be set to "english". 100s 100s Data page checksums are disabled. 100s 100s fixing permissions on existing directory /var/lib/postgresql/17/main ... ok 100s creating subdirectories ... ok 100s selecting dynamic shared memory implementation ... posix 100s selecting default "max_connections" ... 100 100s selecting default "shared_buffers" ... 128MB 100s selecting default time zone ... Etc/UTC 100s creating configuration files ... ok 100s running bootstrap script ... ok 100s performing post-bootstrap initialization ... ok 100s syncing data to disk ... ok 103s Setting up postgresql-17-pglogical (2.4.5-1) ... 103s Setting up postgresql-17-pg-fact-loader (2.0.1-4) ... 103s Setting up postgresql-17-pglogical-ticker (1.4.1-8) ... 103s Setting up autopkgtest-satdep (0) ... 103s Processing triggers for man-db (2.13.0-1) ... 104s Processing triggers for libc-bin (2.40-1ubuntu3) ... 105s (Reading database ... 57978 files and directories currently installed.) 105s Removing autopkgtest-satdep (0) ... 106s autopkgtest [06:08:18]: test installcheck: [----------------------- 106s ### PostgreSQL 17 installcheck ### 106s Creating new PostgreSQL cluster 17/regress ... 109s echo "# +++ regress install-check in +++" && /usr/lib/postgresql/17/lib/pgxs/src/makefiles/../../src/test/regress/pg_regress --inputdir=./ --bindir='/usr/lib/postgresql/17/bin' --dbname=contrib_regression 01_create_ext 02_schema 03_audit 04_seeds 05_pgl_setup 06_basic_workers 07_launch_worker 08_fact_table_deps 09_purge 10_delete 11_more_data 12_no_proid 13_cutoff_no_dep_on_filter 14_null_key 15_source_change_date 16_1_2_features 17_1_3_features 109s # +++ regress install-check in +++ 109s # using postmaster on localhost, port 5433 109s ok 1 - 01_create_ext 192 ms 109s ok 2 - 02_schema 80 ms 109s ok 3 - 03_audit 31 ms 109s ok 4 - 04_seeds 49 ms 109s ok 5 - 05_pgl_setup 23 ms 123s ok 6 - 06_basic_workers 13610 ms 124s ok 7 - 07_launch_worker 1421 ms 128s not ok 8 - 08_fact_table_deps 4192 ms 129s not ok 9 - 09_purge 234 ms 149s not ok 10 - 10_delete 20297 ms 159s not ok 11 - 11_more_data 9802 ms 176s not ok 12 - 12_no_proid 16928 ms 230s not ok 13 - 13_cutoff_no_dep_on_filter 54138 ms 267s not ok 14 - 14_null_key 36727 ms 284s not ok 15 - 15_source_change_date 17472 ms 310s not ok 16 - 16_1_2_features 25938 ms 316s not ok 17 - 17_1_3_features 5711 ms 316s 1..17 316s # 10 of 17 tests failed. 316s # The differences that caused some tests to fail can be viewed in the file "/tmp/autopkgtest.GxExHx/build.Qsl/src/regression.diffs". 316s # A copy of the test summary that you see above is saved in the file "/tmp/autopkgtest.GxExHx/build.Qsl/src/regression.out". 316s make: *** [/usr/lib/postgresql/17/lib/pgxs/src/makefiles/pgxs.mk:436: installcheck] Error 1 316s *** /tmp/pg_virtualenv.w3eb7B/log/postgresql-17-regress.log (last 100 lines) *** 316s /**** 316s This SQL also nearly matches that for the queue_table_deps but would be a little ugly to try to DRY up 316s ****/ 316s , update_key_fact_dep AS ( 316s SELECT qdwr.fact_table_dep_queue_table_dep_id, 316s qdwr.fact_table_id, 316s COALESCE(mu.last_cutoff_id, qdwr.last_cutoff_id) AS last_cutoff_id, 316s qdwr.maximum_cutoff_time AS last_cutoff_source_time 316s FROM fact_loader.queue_deps_all qdwr 316s LEFT JOIN new_metadata_fact_dep mu ON mu.fact_table_dep_queue_table_dep_id = qdwr.fact_table_dep_queue_table_dep_id 316s WHERE qdwr.fact_table_id = 2 316s --Include dependent fact tables only 316s AND qdwr.fact_table_dep_id IS NOT NULL 316s ) 316s 316s , updated_queue_table_deps AS ( 316s UPDATE fact_loader.queue_table_deps qtd 316s SET last_cutoff_id = uk.last_cutoff_id, 316s last_cutoff_source_time = uk.last_cutoff_source_time 316s FROM update_key uk 316s WHERE qtd.queue_table_dep_id = uk.queue_table_dep_id 316s RETURNING qtd.*) 316s 316s , updated_fact_table_deps AS ( 316s UPDATE fact_loader.fact_table_dep_queue_table_deps ftd 316s SET last_cutoff_id = uk.last_cutoff_id, 316s last_cutoff_source_time = uk.last_cutoff_source_time 316s FROM update_key_fact_dep uk 316s WHERE ftd.fact_table_dep_queue_table_dep_id = uk.fact_table_dep_queue_table_dep_id 316s RETURNING uk.*) 316s 316s UPDATE fact_loader.fact_tables ft 316s SET last_refresh_source_cutoff = uqtd.last_cutoff_source_time, 316s last_refresh_attempted_at = now(), 316s last_refresh_succeeded = TRUE 316s FROM 316s (SELECT fact_table_id, last_cutoff_source_time 316s FROM updated_queue_table_deps 316s --Must use UNION to get only distinct values 316s UNION 316s SELECT fact_table_id, last_cutoff_source_time 316s FROM updated_fact_table_deps) uqtd 316s WHERE uqtd.fact_table_id = ft.fact_table_id; 316s 316s 2024-11-27 06:09:50.158 UTC [3652] ubuntu@contrib_regression CONTEXT: PL/pgSQL function fact_loader.load(integer) line 65 at RAISE 316s SQL statement "SELECT fact_loader.load(p_fact_table_id)" 316s PL/pgSQL function fact_loader.try_load(integer) line 40 at PERFORM 316s PL/pgSQL function fact_loader.worker() line 16 at IF 316s 2024-11-27 06:09:50.177 UTC [3652] ubuntu@contrib_regression DEBUG: time to inline: 0.000s, opt: 0.005s, emit: 0.000s 316s 2024-11-27 06:09:50.430 UTC [3652] ubuntu@contrib_regression DEBUG: time to inline: 0.000s, opt: 0.005s, emit: 0.252s 316s 2024-11-27 06:09:50.433 UTC [3652] ubuntu@contrib_regression DEBUG: time to inline: 0.000s, opt: 0.005s, emit: 0.253s 316s 2024-11-27 06:09:50.448 UTC [3652] ubuntu@contrib_regression DEBUG: time to inline: 0.000s, opt: 0.003s, emit: 0.000s 316s 2024-11-27 06:09:50.627 UTC [3652] ubuntu@contrib_regression DEBUG: drop auto-cascades to sequence process_queue_process_queue_id_seq 316s 2024-11-27 06:09:50.627 UTC [3652] ubuntu@contrib_regression CONTEXT: SQL statement "DISCARD TEMP" 316s PL/pgSQL function fact_loader.worker() line 19 at SQL statement 316s 2024-11-27 06:09:50.627 UTC [3652] ubuntu@contrib_regression DEBUG: drop auto-cascades to type process_queue 316s 2024-11-27 06:09:50.627 UTC [3652] ubuntu@contrib_regression CONTEXT: SQL statement "DISCARD TEMP" 316s PL/pgSQL function fact_loader.worker() line 19 at SQL statement 316s 2024-11-27 06:09:50.627 UTC [3652] ubuntu@contrib_regression DEBUG: drop auto-cascades to type process_queue[] 316s 2024-11-27 06:09:50.627 UTC [3652] ubuntu@contrib_regression CONTEXT: SQL statement "DISCARD TEMP" 316s PL/pgSQL function fact_loader.worker() line 19 at SQL statement 316s 2024-11-27 06:09:50.627 UTC [3652] ubuntu@contrib_regression DEBUG: drop auto-cascades to default value for column process_queue_id of table process_queue 316s 2024-11-27 06:09:50.627 UTC [3652] ubuntu@contrib_regression CONTEXT: SQL statement "DISCARD TEMP" 316s PL/pgSQL function fact_loader.worker() line 19 at SQL statement 316s 2024-11-27 06:09:50.627 UTC [3652] ubuntu@contrib_regression DEBUG: drop auto-cascades to toast table pg_toast_temp_10.pg_toast_17550 316s 2024-11-27 06:09:50.627 UTC [3652] ubuntu@contrib_regression CONTEXT: SQL statement "DISCARD TEMP" 316s PL/pgSQL function fact_loader.worker() line 19 at SQL statement 316s 2024-11-27 06:09:50.627 UTC [3652] ubuntu@contrib_regression DEBUG: drop auto-cascades to index pg_toast_temp_10.pg_toast_17550_index 316s 2024-11-27 06:09:50.627 UTC [3652] ubuntu@contrib_regression CONTEXT: SQL statement "DISCARD TEMP" 316s PL/pgSQL function fact_loader.worker() line 19 at SQL statement 316s 2024-11-27 06:09:50.627 UTC [3652] ubuntu@contrib_regression DEBUG: drop cascades to table process_queue 316s 2024-11-27 06:09:50.627 UTC [3652] ubuntu@contrib_regression CONTEXT: SQL statement "DISCARD TEMP" 316s PL/pgSQL function fact_loader.worker() line 19 at SQL statement 316s 2024-11-27 06:11:04.805 UTC [3711] ubuntu@contrib_regression ERROR: No worky 316s 2024-11-27 06:11:04.805 UTC [3711] ubuntu@contrib_regression CONTEXT: PL/pgSQL function inline_code_block line 4 at RAISE 316s 2024-11-27 06:11:04.805 UTC [3711] ubuntu@contrib_regression STATEMENT: DO $$ 316s BEGIN 316s IF NOT (SELECT COUNT(1) FROM fact_loader.gathered_queued_changes((SELECT fact_table_id FROM fact_loader.fact_tables WHERE fact_table_relid = 'test_fact.customers_history_uktime_fact'::REGCLASS))) = 18 THEN 316s RAISE EXCEPTION '%', 'No worky'; 316s END IF; 316s END$$; 316s 2024-11-27 06:11:16.574 UTC [3718] ubuntu@contrib_regression LOG: ADDING fact_loader_batch_id COLUMN TO queue table test_fact_audit_raw.orders_fact_audit: 316s ALTER TABLE test_fact_audit_raw.orders_fact_audit 316s ADD COLUMN fact_loader_batch_id 316s BIGINT 316s DEFAULT nextval('fact_loader.batch_id'); 316s 316s 2024-11-27 06:11:16.574 UTC [3718] ubuntu@contrib_regression CONTEXT: PL/pgSQL function fact_loader.add_batch_id_fields() line 29 at RAISE 316s 2024-11-27 06:11:16.574 UTC [3718] ubuntu@contrib_regression STATEMENT: SELECT fact_loader.add_batch_id_fields(); 316s 2024-11-27 06:11:39.322 UTC [3718] ubuntu@contrib_regression ERROR: relation "try1" does not exist at character 15 316s 2024-11-27 06:11:39.322 UTC [3718] ubuntu@contrib_regression STATEMENT: SELECT * FROM try1; 316s 2024-11-27 06:11:48.090 UTC [3732] ubuntu@contrib_regression ERROR: No worky 316s 2024-11-27 06:11:48.090 UTC [3732] ubuntu@contrib_regression CONTEXT: PL/pgSQL function inline_code_block line 5 at RAISE 316s 2024-11-27 06:11:48.090 UTC [3732] ubuntu@contrib_regression STATEMENT: DO $$ 316s BEGIN 316s IF NOT (SELECT COUNT(1) FROM fact_loader.raw_queued_changes(1)) = 24 316s OR NOT (SELECT COUNT(1) FROM fact_loader.gathered_queued_changes(1)) = 1 THEN 316s RAISE EXCEPTION '%', 'No worky'; 316s END IF; 316s END$$; 316s Dropping cluster 17/regress ... 316s **** regression.diffs **** 316s diff -U3 /tmp/autopkgtest.GxExHx/build.Qsl/src/expected/08_fact_table_deps.out /tmp/autopkgtest.GxExHx/build.Qsl/src/results/08_fact_table_deps.out 316s --- /tmp/autopkgtest.GxExHx/build.Qsl/src/expected/08_fact_table_deps.out 2023-10-09 21:27:17.000000000 +0000 316s +++ /tmp/autopkgtest.GxExHx/build.Qsl/src/results/08_fact_table_deps.out 2024-11-27 06:08:40.922312703 +0000 316s @@ -13,13 +13,9 @@ 316s SELECT order_id, customer_id, phone, age, max_order_date, min_total 316s FROM test_fact.customersorders_fact 316s ORDER BY order_id; 316s - order_id | customer_id | phone | age | max_order_date | min_total 316s -----------+-------------+------------+-----+----------------+----------- 316s - 1 | 1 | 0001234561 | 35 | 04-10-2018 | 100.00 316s - 2 | 3 | 0001234563 | 35 | 04-11-2018 | 200.00 316s - 3 | 5 | 0001234565 | 35 | 04-12-2018 | 2000.00 316s - 4 | 1 | 0001234561 | 35 | 04-13-2018 | 100.00 316s -(4 rows) 316s + order_id | customer_id | phone | age | max_order_date | min_total 316s +----------+-------------+-------+-----+----------------+----------- 316s +(0 rows) 316s 316s SELECT fact_loader.worker(); 316s worker 316s @@ -30,13 +26,9 @@ 316s SELECT order_id, customer_id, order_date, total, is_reorder, num_emails, num_read 316s FROM test_fact.order_emails_fact 316s ORDER BY order_id; 316s - order_id | customer_id | order_date | total | is_reorder | num_emails | num_read 316s -----------+-------------+------------+---------+------------+------------+---------- 316s - 1 | 1 | 04-10-2018 | 100.00 | f | 0 | 316s - 2 | 3 | 04-11-2018 | 200.00 | f | 0 | 316s - 3 | 5 | 04-12-2018 | 2000.00 | f | 1 | 1 316s - 4 | 1 | 04-13-2018 | 100.00 | t | 0 | 316s -(4 rows) 316s + order_id | customer_id | order_date | total | is_reorder | num_emails | num_read 316s +----------+-------------+------------+-------+------------+------------+---------- 316s +(0 rows) 316s 316s /**** 316s Nested fact table deps 316s @@ -52,8 +44,5 @@ 316s ORDER BY customer_id; 316s customer_id | rows_in_customersorders_fact 316s -------------+------------------------------ 316s - 1 | 2 316s - 3 | 1 316s - 5 | 1 316s -(3 rows) 316s +(0 rows) 316s 316s diff -U3 /tmp/autopkgtest.GxExHx/build.Qsl/src/expected/09_purge.out /tmp/autopkgtest.GxExHx/build.Qsl/src/results/09_purge.out 316s --- /tmp/autopkgtest.GxExHx/build.Qsl/src/expected/09_purge.out 2023-10-09 21:27:17.000000000 +0000 316s +++ /tmp/autopkgtest.GxExHx/build.Qsl/src/results/09_purge.out 2024-11-27 06:08:41.162312703 +0000 316s @@ -18,6 +18,6 @@ 316s SELECT COUNT(1) FROM test_audit_raw.customers_audit; 316s count 316s ------- 316s - 4 316s + 14 316s (1 row) 316s 316s diff -U3 /tmp/autopkgtest.GxExHx/build.Qsl/src/expected/10_delete.out /tmp/autopkgtest.GxExHx/build.Qsl/src/results/10_delete.out 316s --- /tmp/autopkgtest.GxExHx/build.Qsl/src/expected/10_delete.out 2023-10-09 21:27:17.000000000 +0000 316s +++ /tmp/autopkgtest.GxExHx/build.Qsl/src/results/10_delete.out 2024-11-27 06:09:01.452428362 +0000 316s @@ -85,12 +85,9 @@ 316s SELECT order_id, customer_id, phone, age, max_order_date, min_total 316s FROM test_fact.customersorders_fact 316s ORDER BY order_id; 316s - order_id | customer_id | phone | age | max_order_date | min_total 316s -----------+-------------+------------+-----+----------------+----------- 316s - 1 | 1 | 0001234561 | 35 | 04-10-2018 | 100.00 316s - 3 | 5 | 0001234565 | 35 | 04-12-2018 | 2000.00 316s - 4 | 1 | 0001234561 | 35 | 04-13-2018 | 100.00 316s -(3 rows) 316s + order_id | customer_id | phone | age | max_order_date | min_total 316s +----------+-------------+-------+-----+----------------+----------- 316s +(0 rows) 316s 316s SELECT email_id, read, promo_count 316s FROM test_fact.emails_fact 316s @@ -103,12 +100,9 @@ 316s SELECT order_id, customer_id, order_date, total, is_reorder, num_emails, num_read 316s FROM test_fact.order_emails_fact 316s ORDER BY order_id; 316s - order_id | customer_id | order_date | total | is_reorder | num_emails | num_read 316s -----------+-------------+------------+---------+------------+------------+---------- 316s - 1 | 1 | 04-10-2018 | 100.00 | f | 0 | 316s - 3 | 5 | 04-12-2018 | 2000.00 | f | 1 | 1 316s - 4 | 1 | 04-13-2018 | 100.00 | t | 0 | 316s -(3 rows) 316s + order_id | customer_id | order_date | total | is_reorder | num_emails | num_read 316s +----------+-------------+------------+-------+------------+------------+---------- 316s +(0 rows) 316s 316s SELECT customer_id, as_of_date, total_orders, last_order_date 316s FROM test_fact.customer_order_history_fact 316s @@ -117,22 +111,21 @@ 316s -------------+-------------------------+--------------+----------------- 316s 1 | [04-10-2018,04-13-2018) | 1 | 04-10-2018 316s 1 | [04-13-2018,infinity) | 2 | 04-13-2018 316s + 3 | [04-11-2018,infinity) | 1 | 04-11-2018 316s 5 | [04-12-2018,infinity) | 1 | 04-12-2018 316s -(3 rows) 316s +(4 rows) 316s 316s SELECT customer_id, rows_in_customersorders_fact 316s FROM test_fact.customersorders_summary_fact 316s ORDER BY customer_id; 316s customer_id | rows_in_customersorders_fact 316s -------------+------------------------------ 316s - 1 | 2 316s - 5 | 1 316s -(2 rows) 316s +(0 rows) 316s 316s SELECT COUNT(1) FROM test_audit_raw.customers_audit; 316s count 316s ------- 316s - 5 316s + 15 316s (1 row) 316s 316s --We call this explicitly, because the worker will take the default add_interval of 1 hour, thus 316s @@ -146,7 +139,7 @@ 316s SELECT COUNT(1) FROM test_audit_raw.customers_audit; 316s count 316s ------- 316s - 0 316s + 15 316s (1 row) 316s 316s DELETE FROM test.reorders; 316s @@ -211,10 +204,7 @@ 316s SELECT order_id, customer_id, order_date, total, is_reorder, num_emails, num_read 316s FROM test_fact.order_emails_fact 316s ORDER BY order_id; 316s - order_id | customer_id | order_date | total | is_reorder | num_emails | num_read 316s -----------+-------------+------------+---------+------------+------------+---------- 316s - 1 | 1 | 04-10-2018 | 100.00 | f | 0 | 316s - 3 | 5 | 04-12-2018 | 2000.00 | f | 1 | 1 316s - 4 | 1 | 04-13-2018 | 100.00 | f | 0 | 316s -(3 rows) 316s + order_id | customer_id | order_date | total | is_reorder | num_emails | num_read 316s +----------+-------------+------------+-------+------------+------------+---------- 316s +(0 rows) 316s 316s diff -U3 /tmp/autopkgtest.GxExHx/build.Qsl/src/expected/11_more_data.out /tmp/autopkgtest.GxExHx/build.Qsl/src/results/11_more_data.out 316s --- /tmp/autopkgtest.GxExHx/build.Qsl/src/expected/11_more_data.out 2023-10-09 21:27:17.000000000 +0000 316s +++ /tmp/autopkgtest.GxExHx/build.Qsl/src/results/11_more_data.out 2024-11-27 06:09:11.264323177 +0000 316s @@ -120,8 +120,9 @@ 316s -------------+-------------------------+--------------+----------------- 316s 1 | [04-10-2018,04-13-2018) | 1 | 04-10-2018 316s 1 | [04-13-2018,infinity) | 2 | 04-13-2018 316s + 3 | [04-11-2018,infinity) | 1 | 04-11-2018 316s 5 | [04-12-2018,infinity) | 1 | 04-12-2018 316s -(3 rows) 316s +(4 rows) 316s 316s SELECT customer_id, rows_in_customersorders_fact 316s FROM test_fact.customersorders_summary_fact 316s diff -U3 /tmp/autopkgtest.GxExHx/build.Qsl/src/expected/12_no_proid.out /tmp/autopkgtest.GxExHx/build.Qsl/src/results/12_no_proid.out 316s --- /tmp/autopkgtest.GxExHx/build.Qsl/src/expected/12_no_proid.out 2023-10-09 21:27:17.000000000 +0000 316s +++ /tmp/autopkgtest.GxExHx/build.Qsl/src/results/12_no_proid.out 2024-11-27 06:09:28.195748245 +0000 316s @@ -46,7 +46,7 @@ 316s ORDER BY email_id; 316s email_id | read | promo_count 316s ----------+------+------------- 316s - 1 | f | 1 316s + 1 | t | 1 316s (1 row) 316s 316s SELECT test.tick(); 316s @@ -75,7 +75,7 @@ 316s SELECT COUNT(1) FROM test_audit_raw.emails_audit; 316s count 316s ------- 316s - 0 316s + 6 316s (1 row) 316s 316s /**** 316s diff -U3 /tmp/autopkgtest.GxExHx/build.Qsl/src/expected/13_cutoff_no_dep_on_filter.out /tmp/autopkgtest.GxExHx/build.Qsl/src/results/13_cutoff_no_dep_on_filter.out 316s --- /tmp/autopkgtest.GxExHx/build.Qsl/src/expected/13_cutoff_no_dep_on_filter.out 2023-10-09 21:27:17.000000000 +0000 316s +++ /tmp/autopkgtest.GxExHx/build.Qsl/src/results/13_cutoff_no_dep_on_filter.out 2024-11-27 06:10:22.336336913 +0000 316s @@ -9,7 +9,7 @@ 316s SELECT COUNT(1) FROM test_audit_raw.customers_audit; 316s count 316s ------- 316s - 9 316s + 24 316s (1 row) 316s 316s SELECT test.tick(); 316s @@ -73,6 +73,6 @@ 316s SELECT COUNT(1) FROM test_audit_raw.customers_audit; 316s count 316s ------- 316s - 0 316s + 24 316s (1 row) 316s 316s diff -U3 /tmp/autopkgtest.GxExHx/build.Qsl/src/expected/14_null_key.out /tmp/autopkgtest.GxExHx/build.Qsl/src/results/14_null_key.out 316s --- /tmp/autopkgtest.GxExHx/build.Qsl/src/expected/14_null_key.out 2023-10-09 21:27:17.000000000 +0000 316s +++ /tmp/autopkgtest.GxExHx/build.Qsl/src/results/14_null_key.out 2024-11-27 06:10:59.057982508 +0000 316s @@ -9,7 +9,7 @@ 316s SELECT COUNT(1) FROM test_audit_raw.orders_audit; 316s count 316s ------- 316s - 1 316s + 9 316s (1 row) 316s 316s /**** 316s @@ -53,7 +53,7 @@ 316s SELECT COUNT(1) FROM test_audit_raw.orders_audit; 316s count 316s ------- 316s - 1 316s + 9 316s (1 row) 316s 316s TRUNCATE test_audit_raw.orders_audit; 316s diff -U3 /tmp/autopkgtest.GxExHx/build.Qsl/src/expected/15_source_change_date.out /tmp/autopkgtest.GxExHx/build.Qsl/src/results/15_source_change_date.out 316s --- /tmp/autopkgtest.GxExHx/build.Qsl/src/expected/15_source_change_date.out 2023-10-09 21:27:17.000000000 +0000 316s +++ /tmp/autopkgtest.GxExHx/build.Qsl/src/results/15_source_change_date.out 2024-11-27 06:11:16.531082064 +0000 316s @@ -173,6 +173,8 @@ 316s RAISE EXCEPTION '%', 'No worky'; 316s END IF; 316s END$$; 316s +ERROR: No worky 316s +CONTEXT: PL/pgSQL function inline_code_block line 4 at RAISE 316s SELECT fact_loader.worker(); 316s worker 316s -------- 316s @@ -180,36 +182,18 @@ 316s (1 row) 316s 316s SELECT * FROM test_fact.customers_history_uktime_fact ORDER BY upper(as_of_date), customer_id; 316s - customer_id | as_of_date | customer_number | phone | age 316s --------------+-------------------------+-----------------+------------+----- 316s - 1 | [04-22-2018,04-24-2018) | cust201811 | 0001234561 | 35 316s - 2 | [04-22-2018,04-24-2018) | cust201821 | 0001234562 | 42 316s - 4 | [04-22-2018,04-24-2018) | cust201841 | 0001234564 | 35 316s - 5 | [04-22-2018,04-24-2018) | cust201851 | 0001234565 | 35 316s - 6 | [04-22-2018,04-25-2018) | cust201861 | 0001234566 | 35 316s - 7 | [04-22-2018,04-25-2018) | cust201871 | 0001234567 | 35 316s - 8 | [04-22-2018,04-25-2018) | cust201881 | 0001234568 | 35 316s - 9 | [04-22-2018,04-25-2018) | cust201891 | 0001234569 | 35 316s - 10 | [04-22-2018,04-25-2018) | cust2018101 | 0001234577 | 35 316s - 6 | [04-25-2018,04-26-2018) | cust201861cd | 0001234566 | 35 316s - 7 | [04-25-2018,04-26-2018) | cust201871cd | 0001234567 | 35 316s - 8 | [04-25-2018,04-26-2018) | cust201881cd | 0001234568 | 35 316s - 9 | [04-25-2018,04-26-2018) | cust201891cd | 0001234569 | 35 316s - 10 | [04-25-2018,04-26-2018) | cust2018101cd | 0001234577 | 35 316s - 1 | [04-24-2018,04-27-2018) | cust201811abe | 0001234561 | 35 316s - 2 | [04-24-2018,04-27-2018) | cust201821abe | 0001234562 | 42 316s - 4 | [04-24-2018,04-27-2018) | cust201841abe | 0001234564 | 35 316s - 5 | [04-24-2018,04-27-2018) | cust201851abe | 0001234565 | 35 316s - 1 | [04-27-2018,infinity) | cust201811abe | 0001234561 | 35 316s - 2 | [04-27-2018,infinity) | cust201821abe | 0001234562 | 42 316s - 4 | [04-27-2018,infinity) | cust201841abe | 0001234564 | 35 316s - 5 | [04-27-2018,infinity) | cust201851abe | 0001234565 | 35 316s - 6 | [04-26-2018,infinity) | cust201861cd | 0001234566 | 35 316s - 7 | [04-26-2018,infinity) | cust201871cd | 0001234567 | 35 316s - 8 | [04-26-2018,infinity) | cust201881cd | 0001234568 | 35 316s - 9 | [04-26-2018,infinity) | cust201891cd | 0001234569 | 35 316s - 10 | [04-26-2018,infinity) | cust2018101cd | 0001234577 | 35 316s -(27 rows) 316s + customer_id | as_of_date | customer_number | phone | age 316s +-------------+-----------------------+-----------------+------------+----- 316s + 1 | [04-22-2018,infinity) | cust201811 | 0001234561 | 35 316s + 2 | [04-22-2018,infinity) | cust201821 | 0001234562 | 42 316s + 4 | [04-22-2018,infinity) | cust201841 | 0001234564 | 35 316s + 5 | [04-22-2018,infinity) | cust201851 | 0001234565 | 35 316s + 6 | [04-22-2018,infinity) | cust201861 | 0001234566 | 35 316s + 7 | [04-22-2018,infinity) | cust201871 | 0001234567 | 35 316s + 8 | [04-22-2018,infinity) | cust201881 | 0001234568 | 35 316s + 9 | [04-22-2018,infinity) | cust201891 | 0001234569 | 35 316s + 10 | [04-22-2018,infinity) | cust2018101 | 0001234577 | 35 316s +(9 rows) 316s 316s --Let's verify the current records are the same as the actual table 316s SELECT customer_id, customer_number, phone, age FROM test.customers 316s @@ -217,17 +201,8 @@ 316s SELECT customer_id, customer_number, phone, age FROM test_fact.customers_history_uktime_fact 316s WHERE upper(as_of_date) = 'infinity' 316s ORDER BY customer_id; 316s - customer_id | customer_number | phone | age 316s --------------+-----------------+------------+----- 316s - 1 | cust201811abe | 0001234561 | 35 316s - 2 | cust201821abe | 0001234562 | 42 316s - 4 | cust201841abe | 0001234564 | 35 316s - 5 | cust201851abe | 0001234565 | 35 316s - 6 | cust201861cd | 0001234566 | 35 316s - 7 | cust201871cd | 0001234567 | 35 316s - 8 | cust201881cd | 0001234568 | 35 316s - 9 | cust201891cd | 0001234569 | 35 316s - 10 | cust2018101cd | 0001234577 | 35 316s -(9 rows) 316s + customer_id | customer_number | phone | age 316s +-------------+-----------------+-------+----- 316s +(0 rows) 316s 316s UPDATE fact_loader.fact_tables SET force_worker_priority = FALSE WHERE fact_table_relid = 'test_fact.customers_history_uktime_fact'::REGCLASS; 316s diff -U3 /tmp/autopkgtest.GxExHx/build.Qsl/src/expected/16_1_2_features.out /tmp/autopkgtest.GxExHx/build.Qsl/src/results/16_1_2_features.out 316s --- /tmp/autopkgtest.GxExHx/build.Qsl/src/expected/16_1_2_features.out 2024-11-27 06:09:31.000000000 +0000 316s +++ /tmp/autopkgtest.GxExHx/build.Qsl/src/results/16_1_2_features.out 2024-11-27 06:11:42.474473762 +0000 316s @@ -172,10 +172,11 @@ 316s fact_table_relid, 316s CASE WHEN current_setting('server_version_num')::INT >= 110000 THEN REPLACE(messages::TEXT, 'types', 'type(s)')::JSONB ELSE messages END 316s FROM fact_loader.unresolved_failures; 316s - fact_table_id | fact_table_relid | messages 316s ----------------+-----------------------------+------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------- 316s - 9 | test_fact.orders_fact_chain | {"Hint": "No operator matches the given name and argument type(s). You might need to add explicit type casts.", "Context": "PL/pgSQL function test_fact.orders_fact_chain_merge(integer) line 4 at SQL statement\nSQL statement \"\nSELECT process_queue_id, test_fact.orders_fact_chain_merge(key_value::integer)\nFROM (\n/****\nMust wrap this to execute in order of ids\n***/\nSELECT *\nFROM process_queue\nWHERE process_queue_id BETWEEN 1 AND 1\n AND fact_table_id = 9\n AND proid = 'test_fact.orders_fact_chain_merge'::REGPROC\nORDER BY process_queue_id) q;\n\"\nPL/pgSQL function fact_loader.load(integer) line 56 at EXECUTE\nSQL statement \"SELECT fact_loader.load(p_fact_table_id)\"\nPL/pgSQL function fact_loader.try_load(integer) line 40 at PERFORM\nPL/pgSQL function fact_loader.worker() line 16 at IF", "Message": "operator does not exist: integer = jsonb"} 316s -(1 row) 316s + fact_table_id | fact_table_relid | messages 316s +---------------+-----------------------------------------+------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------- 316s + 8 | test_fact.customers_history_uktime_fact | {"Hint": "No function matches the given name and argument type(s). You might need to add explicit type casts.", "Context": "PL/pgSQL function fact_loader.load(integer) line 56 at EXECUTE\nSQL statement \"SELECT fact_loader.load(p_fact_table_id)\"\nPL/pgSQL function fact_loader.try_load(integer) line 40 at PERFORM\nPL/pgSQL function fact_loader.worker() line 16 at IF", "Message": "function test_fact.customers_history_uktime_fact_delete(integer, date) does not exist"} 316s + 9 | test_fact.orders_fact_chain | {"Hint": "No operator matches the given name and argument type(s). You might need to add explicit type casts.", "Context": "PL/pgSQL function test_fact.orders_fact_chain_merge(integer) line 4 at SQL statement\nSQL statement \"\nSELECT process_queue_id, test_fact.orders_fact_chain_merge(key_value::integer)\nFROM (\n/****\nMust wrap this to execute in order of ids\n***/\nSELECT *\nFROM process_queue\nWHERE process_queue_id BETWEEN 1 AND 1\n AND fact_table_id = 9\n AND proid = 'test_fact.orders_fact_chain_merge'::REGPROC\nORDER BY process_queue_id) q;\n\"\nPL/pgSQL function fact_loader.load(integer) line 56 at EXECUTE\nSQL statement \"SELECT fact_loader.load(p_fact_table_id)\"\nPL/pgSQL function fact_loader.try_load(integer) line 40 at PERFORM\nPL/pgSQL function fact_loader.worker() line 16 at IF", "Message": "operator does not exist: integer = jsonb"} 316s +(2 rows) 316s 316s --No data 316s SELECT order_id, customer_id, order_date, total, is_reorder 316s @@ -210,9 +211,10 @@ 316s fact_table_relid, 316s messages 316s FROM fact_loader.unresolved_failures; 316s - fact_table_id | fact_table_relid | messages 316s ----------------+------------------+---------- 316s -(0 rows) 316s + fact_table_id | fact_table_relid | messages 316s +---------------+-----------------------------------------+-------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------- 316s + 8 | test_fact.customers_history_uktime_fact | {"Hint": "No function matches the given name and argument types. You might need to add explicit type casts.", "Context": "PL/pgSQL function fact_loader.load(integer) line 56 at EXECUTE\nSQL statement \"SELECT fact_loader.load(p_fact_table_id)\"\nPL/pgSQL function fact_loader.try_load(integer) line 40 at PERFORM\nPL/pgSQL function fact_loader.worker() line 16 at IF", "Message": "function test_fact.customers_history_uktime_fact_delete(integer, date) does not exist"} 316s +(1 row) 316s 316s --1 row 316s SELECT order_id, customer_id, order_date, total, is_reorder 316s @@ -226,7 +228,6 @@ 316s --This is NOT a new feature but a new test coverage - testing concurrency. 316s \! psql contrib_regression -c 'BEGIN; SELECT fact_loader.worker() INTO try1; SELECT pg_sleep(2); COMMIT;' & 316s SELECT pg_sleep(1); 316s -NOTICE: table "process_queue" does not exist, skipping 316s pg_sleep 316s ---------- 316s 316s @@ -235,25 +236,15 @@ 316s \! psql contrib_regression -c ' SELECT fact_loader.worker() INTO try2;' 316s SELECT 1 316s SELECT pg_sleep(4); 316s -BEGIN 316s -SELECT 1 316s - pg_sleep 316s ----------- 316s - 316s -(1 row) 316s - 316s -COMMIT 316s pg_sleep 316s ---------- 316s 316s (1 row) 316s 316s SELECT * FROM try1; 316s - worker 316s --------- 316s - t 316s -(1 row) 316s - 316s +ERROR: relation "try1" does not exist 316s +LINE 1: SELECT * FROM try1; 316s + ^ 316s SELECT * FROM try2; 316s worker 316s -------- 316s @@ -299,7 +290,16 @@ 316s $BODY$ 316s LANGUAGE plpgsql; 316s UPDATE fact_loader.fact_tables SET enabled = FALSE; 316s +NOTICE: table "process_queue" does not exist, skipping 316s +BEGIN 316s +SELECT 1 316s BEGIN; --Keep the same transaction time to make these tests possible 316s + pg_sleep 316s +---------- 316s + 316s +(1 row) 316s + 316s +COMMIT 316s INSERT INTO fact_loader.fact_tables (fact_table_relid, enabled, priority, use_daily_schedule, daily_scheduled_time, daily_scheduled_tz, daily_scheduled_proid) 316s VALUES ('test_fact.daily_customers_fact', TRUE, 10, TRUE, now() + interval '1 second', 'America/Chicago', 'test_fact.daily_customers_fact_merge'::REGPROC); 316s UPDATE fact_loader.fact_tables SET enabled = TRUE WHERE fact_table_relid = 'test_fact.daily_customers_fact'::REGCLASS; 316s diff -U3 /tmp/autopkgtest.GxExHx/build.Qsl/src/expected/17_1_3_features.out /tmp/autopkgtest.GxExHx/build.Qsl/src/results/17_1_3_features.out 316s --- /tmp/autopkgtest.GxExHx/build.Qsl/src/expected/17_1_3_features.out 2023-10-09 21:27:17.000000000 +0000 316s +++ /tmp/autopkgtest.GxExHx/build.Qsl/src/results/17_1_3_features.out 2024-11-27 06:11:48.185106530 +0000 316s @@ -30,6 +30,8 @@ 316s RAISE EXCEPTION '%', 'No worky'; 316s END IF; 316s END$$; 316s +ERROR: No worky 316s +CONTEXT: PL/pgSQL function inline_code_block line 5 at RAISE 316s --Count could be different if we are doing FROMVERSION=1.2 or lower but should be at least 50 (actually should be 66 for 1.2 and 76 for 1.3) 316s SELECT COUNT(1) > 50 AS got_enough_logs FROM fact_loader.fact_table_refresh_logs; 316s got_enough_logs 316s @@ -45,7 +47,7 @@ 316s SELECT COUNT(1) FROM fact_loader.fact_table_refresh_logs; 316s count 316s ------- 316s - 2 316s + 3 316s (1 row) 316s 316s ROLLBACK; 316s ### End 17 installcheck (FAILED with exit code 1) ### 316s autopkgtest [06:11:48]: test installcheck: -----------------------] 317s installcheck FAIL non-zero exit status 1 317s autopkgtest [06:11:49]: test installcheck: - - - - - - - - - - results - - - - - - - - - - 317s autopkgtest [06:11:49]: @@@@@@@@@@@@@@@@@@@@ summary 317s installcheck FAIL non-zero exit status 1 322s virt: nova [W] Using flock in prodstack6-s390x 322s virt: Creating nova instance adt-plucky-s390x-pg-fact-loader-20241127-060632-juju-7f2275-prod-proposed-migration-environment-2-39c05508-a315-443e-8cef-dc94af5b877a from image adt/ubuntu-plucky-s390x-server-20241119.img (UUID 0efe7a44-24e0-44d8-af6e-8997f14b87bd)...