0s autopkgtest [08:36:10]: starting date and time: 2025-05-02 08:36:10+0000
  0s autopkgtest [08:36:10]: git checkout: 9986aa8c Merge branch 'skia/fix_network_interface' into 'ubuntu/production'
  0s autopkgtest [08:36:10]: host juju-7f2275-prod-proposed-migration-environment-21; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.od2na7er/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:ucf --apt-upgrade bacula --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=ucf/3.0051 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-21@bos03-s390x-19.secgroup --name adt-questing-s390x-bacula-20250502-083610-juju-7f2275-prod-proposed-migration-environment-21-1b0e9945-158c-4107-af0d-ed7dd5534a87 --image adt/ubuntu-questing-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-21 --net-id=net_prod-proposed-migration-s390x -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/
 75s autopkgtest [08:37:25]: testbed dpkg architecture: s390x
 75s autopkgtest [08:37:25]: testbed apt version: 3.0.0
 76s autopkgtest [08:37:26]: @@@@@@@@@@@@@@@@@@@@ test bed setup
 76s autopkgtest [08:37:26]: testbed release detected to be: None
 76s autopkgtest [08:37:26]: updating testbed package index (apt update)
 77s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [110 kB]
 77s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease
 77s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease
 77s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease
 77s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [44.4 kB]
 77s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [175 kB]
 77s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [2076 kB]
 78s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main s390x Packages [208 kB]
 78s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/universe s390x Packages [1079 kB]
 78s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/multiverse s390x Packages [9148 B]
 78s Fetched 3701 kB in 1s (3088 kB/s)
 79s Reading package lists...
 79s autopkgtest [08:37:29]: upgrading testbed (apt dist-upgrade and autopurge)
 79s Reading package lists...
 79s Building dependency tree...
 79s Reading state information...
 80s Calculating upgrade...Starting pkgProblemResolver with broken count: 0
 80s Starting 2 pkgProblemResolver with broken count: 0
 80s Done
 80s Entering ResolveByKeep
 80s 
 80s Calculating upgrade...
 80s The following packages will be upgraded:
 80s   htop nano ucf
 80s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
 80s Need to get 532 kB of archives.
 80s After this operation, 4096 B of additional disk space will be used.
 80s Get:1 http://ftpmaster.internal/ubuntu questing-proposed/main s390x ucf all 3.0051 [43.6 kB]
 80s Get:2 http://ftpmaster.internal/ubuntu questing/main s390x nano s390x 8.4-1 [299 kB]
 81s Get:3 http://ftpmaster.internal/ubuntu questing/main s390x htop s390x 3.4.1-4 [189 kB]
 81s Preconfiguring packages ...
 81s Fetched 532 kB in 1s (977 kB/s)
 81s (Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 81472 files and directories currently installed.)
 81s Preparing to unpack .../archives/ucf_3.0051_all.deb ...
 81s Unpacking ucf (3.0051) over (3.0050) ...
 81s Preparing to unpack .../archives/nano_8.4-1_s390x.deb ...
 81s Unpacking nano (8.4-1) over (8.3-1) ...
 81s Preparing to unpack .../htop_3.4.1-4_s390x.deb ...
 81s Unpacking htop (3.4.1-4) over (3.4.0-2) ...
 81s Setting up htop (3.4.1-4) ...
 81s Setting up ucf (3.0051) ...
 81s Setting up nano (8.4-1) ...
 81s Installing new version of config file /etc/nanorc ...
 81s Processing triggers for man-db (2.13.0-1) ...
 82s Processing triggers for install-info (7.1.1-1) ...
 82s Reading package lists...
 82s Building dependency tree...
 82s Reading state information...
 82s Starting pkgProblemResolver with broken count: 0
 82s Starting 2 pkgProblemResolver with broken count: 0
 82s Done
 83s Solving dependencies...
 83s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
 85s autopkgtest [08:37:35]: testbed running kernel: Linux 6.14.0-15-generic #15-Ubuntu SMP Sun Apr  6 13:39:00 UTC 2025
 85s autopkgtest [08:37:35]: @@@@@@@@@@@@@@@@@@@@ apt-source bacula
 95s Get:1 http://ftpmaster.internal/ubuntu questing/universe bacula 13.0.4-4build1 (dsc) [3402 B]
 95s Get:2 http://ftpmaster.internal/ubuntu questing/universe bacula 13.0.4-4build1 (tar) [6227 kB]
 95s Get:3 http://ftpmaster.internal/ubuntu questing/universe bacula 13.0.4-4build1 (diff) [111 kB]
 95s gpgv: Signature made Thu Feb  6 13:54:27 2025 UTC
 95s gpgv:                using RSA key 63EEFC3DE14D5146CE7F24BF34B8AD7D9529E793
 95s gpgv:                issuer "lena.voytek@canonical.com"
 95s gpgv: Can't check signature: No public key
 95s dpkg-source: warning: cannot verify inline signature for ./bacula_13.0.4-4build1.dsc: no acceptable signature found
 95s autopkgtest [08:37:45]: testing package bacula version 13.0.4-4build1
 97s autopkgtest [08:37:47]: build not needed
100s autopkgtest [08:37:50]: test backup-test-pgsql: preparing testbed
100s Reading package lists...
100s Building dependency tree...
100s Reading state information...
100s Starting pkgProblemResolver with broken count: 0
100s Starting 2 pkgProblemResolver with broken count: 0
100s Done
101s The following NEW packages will be installed:
101s   bacula bacula-bscan bacula-client bacula-common bacula-common-pgsql
101s   bacula-console bacula-director bacula-director-pgsql bacula-fd bacula-sd
101s   bacula-server bsd-mailx dbconfig-common dbconfig-pgsql libio-pty-perl
101s   libipc-run-perl libjson-perl libllvm20 liblockfile-bin liblockfile1 libpq5
101s   libxslt1.1 mtx postfix postgresql postgresql-17 postgresql-client
101s   postgresql-client-17 postgresql-client-common postgresql-common
101s   postgresql-common-dev ssl-cert
101s 0 upgraded, 32 newly installed, 0 to remove and 0 not upgraded.
101s Need to get 53.6 MB of archives.
101s After this operation, 224 MB of additional disk space will be used.
101s Get:1 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-common s390x 13.0.4-4build1 [854 kB]
101s Get:2 http://ftpmaster.internal/ubuntu questing/main s390x libpq5 s390x 17.4-1 [147 kB]
101s Get:3 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-common-pgsql s390x 13.0.4-4build1 [15.6 kB]
101s Get:4 http://ftpmaster.internal/ubuntu questing/universe s390x dbconfig-common all 2.0.24 [596 kB]
101s Get:5 http://ftpmaster.internal/ubuntu questing/main s390x postgresql-client-common all 274 [47.6 kB]
101s Get:6 http://ftpmaster.internal/ubuntu questing/main s390x postgresql-client-17 s390x 17.4-1 [1367 kB]
101s Get:7 http://ftpmaster.internal/ubuntu questing/main s390x postgresql-client all 17+274 [13.3 kB]
101s Get:8 http://ftpmaster.internal/ubuntu questing/universe s390x dbconfig-pgsql all 2.0.24 [914 B]
101s Get:9 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-director-pgsql all 13.0.4-4build1 [34.0 kB]
101s Get:10 http://ftpmaster.internal/ubuntu questing/main s390x postfix s390x 3.9.1-10ubuntu1 [1305 kB]
101s Get:11 http://ftpmaster.internal/ubuntu questing/main s390x liblockfile-bin s390x 1.17-2 [11.5 kB]
101s Get:12 http://ftpmaster.internal/ubuntu questing/main s390x liblockfile1 s390x 1.17-2 [6970 B]
101s Get:13 http://ftpmaster.internal/ubuntu questing/main s390x bsd-mailx s390x 8.1.2-0.20220412cvs-1build1 [69.7 kB]
101s Get:14 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-director s390x 13.0.4-4build1 [379 kB]
101s Get:15 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-fd s390x 13.0.4-4build1 [144 kB]
101s Get:16 http://ftpmaster.internal/ubuntu questing/main s390x mtx s390x 1.3.12-18 [43.2 kB]
101s Get:17 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-sd s390x 13.0.4-4build1 [151 kB]
101s Get:18 http://ftpmaster.internal/ubuntu questing/main s390x libjson-perl all 4.10000-1 [81.9 kB]
101s Get:19 http://ftpmaster.internal/ubuntu questing/main s390x libio-pty-perl s390x 1:1.20-1build3 [31.6 kB]
102s Get:20 http://ftpmaster.internal/ubuntu questing/main s390x libipc-run-perl all 20231003.0-2 [91.5 kB]
102s Get:21 http://ftpmaster.internal/ubuntu questing/main s390x postgresql-common-dev all 274 [73.0 kB]
102s Get:22 http://ftpmaster.internal/ubuntu questing/main s390x ssl-cert all 1.1.3ubuntu1 [18.7 kB]
102s Get:23 http://ftpmaster.internal/ubuntu questing/main s390x postgresql-common all 274 [101 kB]
102s Get:24 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-console s390x 13.0.4-4build1 [28.6 kB]
102s Get:25 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-client all 13.0.4-4build1 [23.5 kB]
102s Get:26 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-bscan s390x 13.0.4-4build1 [24.7 kB]
102s Get:27 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-server all 13.0.4-4build1 [23.4 kB]
102s Get:28 http://ftpmaster.internal/ubuntu questing/universe s390x bacula all 13.0.4-4build1 [1036 B]
102s Get:29 http://ftpmaster.internal/ubuntu questing/main s390x libllvm20 s390x 1:20.1.2-0ubuntu1 [31.4 MB]
102s Get:30 http://ftpmaster.internal/ubuntu questing/main s390x libxslt1.1 s390x 1.1.39-0exp1ubuntu4 [170 kB]
102s Get:31 http://ftpmaster.internal/ubuntu questing/main s390x postgresql-17 s390x 17.4-1 [16.3 MB]
103s Get:32 http://ftpmaster.internal/ubuntu questing/main s390x postgresql all 17+274 [14.4 kB]
103s Preconfiguring packages ...
103s /var/cache/debconf/tmp.ci/postgresql.config.KUuiEH: 12: pg_lsclusters: not found
103s Fetched 53.6 MB in 2s (23.7 MB/s)
103s Selecting previously unselected package bacula-common.
103s (Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 81472 files and directories currently installed.)
103s Preparing to unpack .../00-bacula-common_13.0.4-4build1_s390x.deb ...
104s Adding user 'bacula'... Ok.
104s Unpacking bacula-common (13.0.4-4build1) ...
104s Selecting previously unselected package libpq5:s390x.
104s Preparing to unpack .../01-libpq5_17.4-1_s390x.deb ...
104s Unpacking libpq5:s390x (17.4-1) ...
104s Selecting previously unselected package bacula-common-pgsql.
104s Preparing to unpack .../02-bacula-common-pgsql_13.0.4-4build1_s390x.deb ...
104s Unpacking bacula-common-pgsql (13.0.4-4build1) ...
104s Selecting previously unselected package dbconfig-common.
104s Preparing to unpack .../03-dbconfig-common_2.0.24_all.deb ...
104s Unpacking dbconfig-common (2.0.24) ...
104s Selecting previously unselected package postgresql-client-common.
104s Preparing to unpack .../04-postgresql-client-common_274_all.deb ...
104s Unpacking postgresql-client-common (274) ...
104s Selecting previously unselected package postgresql-client-17.
104s Preparing to unpack .../05-postgresql-client-17_17.4-1_s390x.deb ...
104s Unpacking postgresql-client-17 (17.4-1) ...
104s Selecting previously unselected package postgresql-client.
104s Preparing to unpack .../06-postgresql-client_17+274_all.deb ...
104s Unpacking postgresql-client (17+274) ...
104s Selecting previously unselected package dbconfig-pgsql.
104s Preparing to unpack .../07-dbconfig-pgsql_2.0.24_all.deb ...
104s Unpacking dbconfig-pgsql (2.0.24) ...
104s Selecting previously unselected package bacula-director-pgsql.
104s Preparing to unpack .../08-bacula-director-pgsql_13.0.4-4build1_all.deb ...
104s Unpacking bacula-director-pgsql (13.0.4-4build1) ...
104s Selecting previously unselected package postfix.
104s Preparing to unpack .../09-postfix_3.9.1-10ubuntu1_s390x.deb ...
104s Unpacking postfix (3.9.1-10ubuntu1) ...
104s Selecting previously unselected package liblockfile-bin.
104s Preparing to unpack .../10-liblockfile-bin_1.17-2_s390x.deb ...
104s Unpacking liblockfile-bin (1.17-2) ...
104s Selecting previously unselected package liblockfile1:s390x.
104s Preparing to unpack .../11-liblockfile1_1.17-2_s390x.deb ...
104s Unpacking liblockfile1:s390x (1.17-2) ...
104s Selecting previously unselected package bsd-mailx.
104s Preparing to unpack .../12-bsd-mailx_8.1.2-0.20220412cvs-1build1_s390x.deb ...
104s Unpacking bsd-mailx (8.1.2-0.20220412cvs-1build1) ...
104s Selecting previously unselected package bacula-director.
104s Preparing to unpack .../13-bacula-director_13.0.4-4build1_s390x.deb ...
104s Unpacking bacula-director (13.0.4-4build1) ...
104s Selecting previously unselected package bacula-fd.
104s Preparing to unpack .../14-bacula-fd_13.0.4-4build1_s390x.deb ...
104s Unpacking bacula-fd (13.0.4-4build1) ...
104s Selecting previously unselected package mtx.
104s Preparing to unpack .../15-mtx_1.3.12-18_s390x.deb ...
104s Unpacking mtx (1.3.12-18) ...
104s Selecting previously unselected package bacula-sd.
104s Preparing to unpack .../16-bacula-sd_13.0.4-4build1_s390x.deb ...
104s Unpacking bacula-sd (13.0.4-4build1) ...
104s Selecting previously unselected package libjson-perl.
104s Preparing to unpack .../17-libjson-perl_4.10000-1_all.deb ...
104s Unpacking libjson-perl (4.10000-1) ...
104s Selecting previously unselected package libio-pty-perl.
104s Preparing to unpack .../18-libio-pty-perl_1%3a1.20-1build3_s390x.deb ...
104s Unpacking libio-pty-perl (1:1.20-1build3) ...
104s Selecting previously unselected package libipc-run-perl.
104s Preparing to unpack .../19-libipc-run-perl_20231003.0-2_all.deb ...
104s Unpacking libipc-run-perl (20231003.0-2) ...
104s Selecting previously unselected package postgresql-common-dev.
104s Preparing to unpack .../20-postgresql-common-dev_274_all.deb ...
104s Unpacking postgresql-common-dev (274) ...
104s Selecting previously unselected package ssl-cert.
104s Preparing to unpack .../21-ssl-cert_1.1.3ubuntu1_all.deb ...
104s Unpacking ssl-cert (1.1.3ubuntu1) ...
104s Selecting previously unselected package postgresql-common.
104s Preparing to unpack .../22-postgresql-common_274_all.deb ...
104s Adding 'diversion of /usr/bin/pg_config to /usr/bin/pg_config.libpq-dev by postgresql-common'
104s Unpacking postgresql-common (274) ...
104s Selecting previously unselected package bacula-console.
104s Preparing to unpack .../23-bacula-console_13.0.4-4build1_s390x.deb ...
104s Unpacking bacula-console (13.0.4-4build1) ...
104s Selecting previously unselected package bacula-client.
104s Preparing to unpack .../24-bacula-client_13.0.4-4build1_all.deb ...
104s Unpacking bacula-client (13.0.4-4build1) ...
104s Selecting previously unselected package bacula-bscan.
104s Preparing to unpack .../25-bacula-bscan_13.0.4-4build1_s390x.deb ...
104s Unpacking bacula-bscan (13.0.4-4build1) ...
104s Selecting previously unselected package bacula-server.
104s Preparing to unpack .../26-bacula-server_13.0.4-4build1_all.deb ...
104s Unpacking bacula-server (13.0.4-4build1) ...
104s Selecting previously unselected package bacula.
104s Preparing to unpack .../27-bacula_13.0.4-4build1_all.deb ...
104s Unpacking bacula (13.0.4-4build1) ...
104s Selecting previously unselected package libllvm20:s390x.
104s Preparing to unpack .../28-libllvm20_1%3a20.1.2-0ubuntu1_s390x.deb ...
104s Unpacking libllvm20:s390x (1:20.1.2-0ubuntu1) ...
105s Selecting previously unselected package libxslt1.1:s390x.
105s Preparing to unpack .../29-libxslt1.1_1.1.39-0exp1ubuntu4_s390x.deb ...
105s Unpacking libxslt1.1:s390x (1.1.39-0exp1ubuntu4) ...
105s Selecting previously unselected package postgresql-17.
105s Preparing to unpack .../30-postgresql-17_17.4-1_s390x.deb ...
105s Unpacking postgresql-17 (17.4-1) ...
105s Selecting previously unselected package postgresql.
105s Preparing to unpack .../31-postgresql_17+274_all.deb ...
105s Unpacking postgresql (17+274) ...
105s Setting up postgresql-client-common (274) ...
105s Setting up liblockfile-bin (1.17-2) ...
105s Setting up libio-pty-perl (1:1.20-1build3) ...
105s Setting up libpq5:s390x (17.4-1) ...
105s Setting up mtx (1.3.12-18) ...
105s Setting up dbconfig-common (2.0.24) ...
105s Creating config file /etc/dbconfig-common/config with new version
105s Setting up bacula-common (13.0.4-4build1) ...
105s Setting up bacula-sd (13.0.4-4build1) ...
105s Creating config file /etc/default/bacula-sd with new version
106s Creating config file /etc/bacula/bacula-sd.conf with new version
106s Created symlink '/etc/systemd/system/multi-user.target.wants/bacula-sd.service' → '/usr/lib/systemd/system/bacula-sd.service'.

106s Setting up ssl-cert (1.1.3ubuntu1) ...
107s Created symlink '/etc/systemd/system/multi-user.target.wants/ssl-cert.service' → '/usr/lib/systemd/system/ssl-cert.service'.

107s Setting up libllvm20:s390x (1:20.1.2-0ubuntu1) ...
107s Setting up libipc-run-perl (20231003.0-2) ...
107s Setting up bacula-console (13.0.4-4build1) ...
107s Creating config file /etc/bacula/bconsole.conf with new version
107s Setting up postfix (3.9.1-10ubuntu1) ...
107s Created symlink '/etc/systemd/system/multi-user.target.wants/postfix.service' → '/usr/lib/systemd/system/postfix.service'.

107s info: Selecting UID from range 100 to 999 ...
107s 
107s info: Selecting GID from range 100 to 999 ...
107s info: Adding system user `postfix' (UID 108) ...
107s info: Adding new group `postfix' (GID 114) ...
107s info: Adding new user `postfix' (UID 108) with group `postfix' ...
107s info: Not creating home directory `/var/spool/postfix'.
107s info: Selecting GID from range 100 to 999 ...
107s info: Adding group `postdrop' (GID 115) ...
107s Creating /etc/postfix/dynamicmaps.cf
108s setting myhostname: autopkgtest.local
108s setting alias maps
108s setting alias database
108s changing /etc/mailname to autopkgtest.local
108s setting myorigin
108s setting destinations: $myhostname, autopkgtest.local, localhost.local, , localhost
108s setting relayhost: 
108s setting mynetworks: 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128
108s clearing mailbox_command
108s setting mailbox_size_limit: 0
108s setting recipient_delimiter: +
110s setting inet_interfaces: all
112s setting inet_protocols: all
112s /etc/aliases does not exist, creating it.
112s WARNING: /etc/aliases exists, but does not have a root alias.
112s 
112s Postfix (main.cf) is now set up with a default configuration.  If you need to 
112s make changes, edit /etc/postfix/main.cf (and others) as needed.  To view 
112s Postfix configuration values, see postconf(1).
112s 
112s After modifying main.cf, be sure to run 'systemctl reload postfix'.
112s 
114s Setting up libjson-perl (4.10000-1) ...
114s Setting up libxslt1.1:s390x (1.1.39-0exp1ubuntu4) ...
114s Setting up liblockfile1:s390x (1.17-2) ...
114s Setting up bacula-fd (13.0.4-4build1) ...
114s Creating config file /etc/default/bacula-fd with new version
114s Creating config file /etc/bacula/bacula-fd.conf with new version
115s Created symlink '/etc/systemd/system/multi-user.target.wants/bacula-fd.service' → '/usr/lib/systemd/system/bacula-fd.service'.

115s Setting up postgresql-common-dev (274) ...
115s Setting up bacula-client (13.0.4-4build1) ...
115s Setting up postgresql-client-17 (17.4-1) ...
115s 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
115s Setting up dbconfig-pgsql (2.0.24) ...
115s Setting up bacula-common-pgsql (13.0.4-4build1) ...
115s Setting up bsd-mailx (8.1.2-0.20220412cvs-1build1) ...
115s update-alternatives: using /usr/bin/bsd-mailx to provide /usr/bin/mailx (mailx) in auto mode
115s Setting up postgresql-common (274) ...
115s Creating config file /etc/postgresql-common/createcluster.conf with new version
115s Building PostgreSQL dictionaries from installed myspell/hunspell packages...
115s Removing obsolete dictionary files:
116s Created symlink '/etc/systemd/system/multi-user.target.wants/postgresql.service' → '/usr/lib/systemd/system/postgresql.service'.

116s Setting up bacula-bscan (13.0.4-4build1) ...
116s Setting up postgresql-17 (17.4-1) ...
117s Creating new PostgreSQL cluster 17/main ...
117s /usr/lib/postgresql/17/bin/initdb -D /var/lib/postgresql/17/main --auth-local peer --auth-host scram-sha-256 --no-instructions
117s The files belonging to this database system will be owned by user "postgres".
117s This user must also own the server process.
117s 
117s The database cluster will be initialized with locale "C.UTF-8".
117s The default database encoding has accordingly been set to "UTF8".
117s The default text search configuration will be set to "english".
117s 
117s Data page checksums are disabled.
117s 
117s fixing permissions on existing directory /var/lib/postgresql/17/main ... ok
117s creating subdirectories ... ok
117s selecting dynamic shared memory implementation ... posix
117s selecting default "max_connections" ... 100
117s selecting default "shared_buffers" ... 128MB
117s selecting default time zone ... Etc/UTC
117s creating configuration files ... ok
117s running bootstrap script ... ok
117s performing post-bootstrap initialization ... ok
117s syncing data to disk ... ok
120s Setting up bacula-director-pgsql (13.0.4-4build1) ...
120s dbconfig-common: writing config to /etc/dbconfig-common/bacula-director-pgsql.conf
120s Creating config file /etc/dbconfig-common/bacula-director-pgsql.conf with new version
120s creating postgres user bacula:  success.
120s verifying creation of user: success.
120s creating database bacula: success.
120s verifying database bacula exists: success.
120s populating database via administrative sql...  done.
121s populating database via sql...  done.
121s dbconfig-common: flushing administrative password
121s Setting up postgresql-client (17+274) ...
121s Setting up bacula-director (13.0.4-4build1) ...
121s Creating config file /etc/default/bacula-dir with new version
121s Creating config file /etc/bacula/bacula-dir.conf with new version
121s Creating config file /etc/bacula/scripts/delete_catalog_backup with new version
121s Creating config file /etc/bacula/scripts/make_catalog_backup with new version
122s Created symlink '/etc/systemd/system/bacula-dir.service' → '/usr/lib/systemd/system/bacula-director.service'.

122s Created symlink '/etc/systemd/system/multi-user.target.wants/bacula-director.service' → '/usr/lib/systemd/system/bacula-director.service'.

122s Setting up postgresql (17+274) ...
122s Setting up bacula-server (13.0.4-4build1) ...
122s Setting up bacula (13.0.4-4build1) ...
122s Processing triggers for rsyslog (8.2412.0-2ubuntu2) ...
122s Processing triggers for ufw (0.36.2-9) ...
122s Processing triggers for man-db (2.13.0-1) ...
123s Processing triggers for libc-bin (2.41-6ubuntu1) ...
123s Processing triggers for postfix (3.9.1-10ubuntu1) ...
123s Restarting postfix
125s autopkgtest [08:38:15]: test backup-test-pgsql: [-----------------------
125s + apt-get -y install debconf-utils
125s Reading package lists...
125s Building dependency tree...
125s Reading state information...
125s Solving dependencies...
125s The following NEW packages will be installed:
125s   debconf-utils
125s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded.
125s Need to get 49.5 kB of archives.
125s After this operation, 99.3 kB of additional disk space will be used.
125s Get:1 http://ftpmaster.internal/ubuntu questing/universe s390x debconf-utils all 1.5.87ubuntu1 [49.5 kB]
126s Fetched 49.5 kB in 0s (161 kB/s)
126s Selecting previously unselected package debconf-utils.
126s (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 ... 84284 files and directories currently installed.)
126s Preparing to unpack .../debconf-utils_1.5.87ubuntu1_all.deb ...
126s Unpacking debconf-utils (1.5.87ubuntu1) ...
126s Setting up debconf-utils (1.5.87ubuntu1) ...
126s Processing triggers for man-db (2.13.0-1) ...
126s + debconf-get-selections
126s + debconf-set-selections
126s + awk '$3=="password"{print}'
127s + for pkg in bacula-director-mysql bacula-director-pgsql
127s ++ dpkg-query --showformat '${db:Status-Status}' -W bacula-director-mysql
127s + pkg_status=not-installed
127s + '[' not-installed = installed ']'
127s + for pkg in bacula-director-mysql bacula-director-pgsql
127s ++ dpkg-query --showformat '${db:Status-Status}' -W bacula-director-pgsql
127s + pkg_status=installed
127s + '[' installed = installed ']'
127s + echo 'bacula-director-pgsql bacula-director-pgsql/dbconfig-reinstall boolean true'
127s + debconf-set-selections
127s + DEBIAN_FRONTEND=noninteractive
127s + dpkg-reconfigure bacula-director-pgsql
127s dbconfig-common: writing config to /etc/dbconfig-common/bacula-director-pgsql.conf
127s bacula already exists and has privileges on bacula.
127s dbconfig-common: dumping pgsql database bacula to /var/tmp/bacula-director-pgsql.bacula.2025-05-02-08.38.pgsql.nnFJb4.
127s dbconfig-common: dropping old pgsql database bacula.
127s dropping database bacula: success.
127s verifying database bacula was dropped: success.
128s creating database bacula: success.
128s verifying database bacula exists: success.
128s populating database via administrative sql...  done.
128s populating database via sql...  done.
128s dbconfig-common: flushing administrative password
128s + echo 'start testing ... '
128s start testing ... 
128s + echo 'USER: root'
128s USER: root
128s + DBTYPE=pgsql
128s + echo 'DBTYPE: pgsql'
128s DBTYPE: pgsql
128s + echo '--------- configuring Bacula daemons -----------'
128s --------- configuring Bacula daemons -----------
128s + FILECHGRDIR=/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr
128s + RESTOREDIR=/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-restores
128s + mkdir -p /tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr
128s + chown -R bacula:tape /tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr
128s + sed -i s%/nonexistent/path/to/file/archive/dir%/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr% /etc/bacula/bacula-sd.conf
128s + sed -i 's%Where = /nonexistent/path/to/file/archive/dir/bacula-restores%Where = /tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-restores%' /etc/bacula/bacula-dir.conf
128s + sed -i 's/signature = MD5/signature = SHA1/' /etc/bacula/bacula-dir.conf
128s + sed -i 's/signature = MD5/signature = SHA1\naclsupport = yes/' /etc/bacula/bacula-dir.conf
128s + echo '--------- restarting services ----------- '
128s --------- restarting services ----------- 
128s + service bacula-director restart
128s + service bacula-sd restart
128s + service bacula-fd restart
128s + sleep 10
138s + echo '--------- checking services ----------- '
138s --------- checking services ----------- 
138s + service bacula-director status
138s ● bacula-director.service - Bacula Director Daemon service
138s      Loaded: loaded (/usr/lib/systemd/system/bacula-director.service; enabled; preset: enabled)
138s      Active: active (running) since Fri 2025-05-02 08:38:18 UTC; 10s ago
138s  Invocation: dfa9c2750ee44f7fb942ee95f0aa2bef
138s        Docs: man:bacula-dir(8)
138s     Process: 7538 ExecStartPre=/usr/sbin/bacula-dir -t -c $CONFIG (code=exited, status=0/SUCCESS)
138s    Main PID: 7542 (bacula-dir)
138s       Tasks: 5 (limit: 4767)
138s      Memory: 2.3M (peak: 2.5M)
138s         CPU: 49ms
138s      CGroup: /system.slice/bacula-director.service
138s              └─7542 /usr/sbin/bacula-dir -fP -c /etc/bacula/bacula-dir.conf
138s 
138s May 02 08:38:18 autopkgtest systemd[1]: Starting bacula-director.service - Bacula Director Daemon service...
138s May 02 08:38:18 autopkgtest systemd[1]: Started bacula-director.service - Bacula Director Daemon service.
138s + service bacula-sd status
138s ● bacula-sd.service - Bacula Storage Daemon service
138s      Loaded: loaded (/usr/lib/systemd/system/bacula-sd.service; enabled; preset: enabled)
138s      Active: active (running) since Fri 2025-05-02 08:38:18 UTC; 10s ago
138s  Invocation: 7f96491397114fb3bcab66f7bfd28948
138s        Docs: man:bacula-sd(8)
138s     Process: 7553 ExecStartPre=/usr/sbin/bacula-sd -t -c $CONFIG (code=exited, status=0/SUCCESS)
138s    Main PID: 7555 (bacula-sd)
138s       Tasks: 3 (limit: 4767)
138s      Memory: 1.9M (peak: 2.2M)
138s         CPU: 18ms
138s      CGroup: /system.slice/bacula-sd.service
138s              └─7555 /usr/sbin/bacula-sd -fP -c /etc/bacula/bacula-sd.conf
138s 
138s May 02 08:38:18 autopkgtest systemd[1]: Starting bacula-sd.service - Bacula Storage Daemon service...
138s May 02 08:38:18 autopkgtest systemd[1]: Started bacula-sd.service - Bacula Storage Daemon service.
138s + service bacula-fd status
138s ● bacula-fd.service - Bacula File Daemon service
138s      Loaded: loaded (/usr/lib/systemd/system/bacula-fd.service; enabled; preset: enabled)
138s      Active: active (running) since Fri 2025-05-02 08:38:18 UTC; 10s ago
138s  Invocation: 37d71b8a3bf4431f848fe8612f13feac
138s        Docs: man:bacula-fd(8)
138s     Process: 7563 ExecStartPre=/usr/sbin/bacula-fd -t -c $CONFIG (code=exited, status=0/SUCCESS)
138s    Main PID: 7564 (bacula-fd)
138s       Tasks: 3 (limit: 4767)
138s      Memory: 1.6M (peak: 1.9M)
138s         CPU: 13ms
138s      CGroup: /system.slice/bacula-fd.service
138s              └─7564 /usr/sbin/bacula-fd -fP -c /etc/bacula/bacula-fd.conf
138s 
138s May 02 08:38:18 autopkgtest systemd[1]: Starting bacula-fd.service - Bacula File Daemon service...
138s May 02 08:38:18 autopkgtest systemd[1]: Started bacula-fd.service - Bacula File Daemon service.
138s + ps auwwwx
138s + grep '[b]acula'
138s bacula      7542  0.1  0.3 316824 13776 ?        Ssl  08:38   0:00 /usr/sbin/bacula-dir -fP -c /etc/bacula/bacula-dir.conf
138s bacula      7555  0.0  0.2 239820 10668 ?        Ssl  08:38   0:00 /usr/sbin/bacula-sd -fP -c /etc/bacula/bacula-sd.conf
138s root        7564  0.0  0.2 165972 10000 ?        Ssl  08:38   0:00 /usr/sbin/bacula-fd -fP -c /etc/bacula/bacula-fd.conf
138s + echo '----- create some file to test backup / restore ----'
138s ----- create some file to test backup / restore ----
138s + BACKUP_TEST_FILE=/usr/sbin/bacula-backup.test
138s + echo 'bacula restore test'
139s + chown nobody:shadow /usr/sbin/bacula-backup.test
139s + chmod 2755 /usr/sbin/bacula-backup.test
139s + echo '---- status of all daemons ----'
139s ---- status of all daemons ----
139s + echo -e 'status all'
139s + bconsole
139s Connecting to Director localhost:9101
139s 1000 OK: 10002 autopkgtest-dir Version: 13.0.4 (12 February 2024)
139s Enter a period to cancel a command.
139s status all
139s autopkgtest-dir Version: 13.0.4 (12 February 2024) s390x-ibm-linux-gnu ubuntu 25.04
139s Daemon started 02-May-25 08:38, conf reloaded 02-May-2025 08:38:18
139s  Jobs: run=0, running=0 mode=0,0
139s  Crypto: fips=N/A crypto=OpenSSL 3.4.0 22 Oct 2024
139s  Heap: heap=831,488 smbytes=335,470 max_bytes=335,470 bufs=395 max_bufs=395
139s  Res: njobs=3 nclients=1 nstores=2 npools=3 ncats=1 nfsets=2 nscheds=2
139s 
139s Scheduled Jobs:
139s Level          Type     Pri  Scheduled          Job Name           Volume
139s ===================================================================================
139s Incremental    Backup    10  02-May-25 23:05    BackupClient1      *unknown*
139s Full           Backup    11  02-May-25 23:10    BackupCatalog      *unknown*
139s ====
139s 
139s Running Jobs:
139s Console connected using TLS at 02-May-25 08:38
139s No Jobs running.
139s ====
139s No Terminated Jobs.
139s ====
139s Connecting to Storage daemon File1 at localhost:9103
139s 
139s autopkgtest-sd Version: 13.0.4 (12 February 2024) s390x-ibm-linux-gnu ubuntu 25.04
139s Daemon started 02-May-25 08:38. Jobs: run=0, running=0.
139s  Ulimits: nofile=1024 memlock=unlimited status=nofile
139s  Heap: heap=643,072 smbytes=228,774 max_bytes=350,074 bufs=267 max_bufs=268
139s  Sizes: boffset_t=8 size_t=8 int32_t=4 int64_t=8 mode=0,0 newbsr=0
139s  Crypto: fips=N/A crypto=OpenSSL 3.4.0 22 Oct 2024
139s  Res: ndevices=4 nautochgr=2
139s 
139s Running Jobs:
139s Director connected using TLS at: 02-May-25 08:38
139s No Jobs running.
139s ====
139s 
139s Jobs waiting to reserve a drive:
139s ====
139s 
139s Terminated Jobs:
139s ====
139s 
139s Device status:
139s Autochanger "FileChgr1" with devices:
139s    "FileChgr1-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
139s    "FileChgr1-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
139s Autochanger "FileChgr2" with devices:
139s    "FileChgr2-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
139s    "FileChgr2-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
139s 
139s Device File: "FileChgr1-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
139s    Drive 0 is not loaded.
139s    Available Space=18.22 GB
139s ==
139s 
139s Device File: "FileChgr1-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
139s    Drive 0 is not loaded.
139s    Available Space=18.22 GB
139s ==
139s 
139s Device File: "FileChgr2-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
139s    Drive 0 is not loaded.
139s    Available Space=18.22 GB
139s ==
139s 
139s Device File: "FileChgr2-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
139s    Drive 0 is not loaded.
139s    Available Space=18.22 GB
139s ==
139s ====
139s 
139s Used Volume status:
139s ====
139s 
139s ====
139s 
139s Connecting to Client autopkgtest-fd at localhost:9102
139s 
139s autopkgtest-fd Version: 13.0.4 (12 February 2024)  s390x-ibm-linux-gnu ubuntu 25.04
139s Daemon started 02-May-25 08:38. Jobs: run=0 running=0.
139s  Heap: heap=536,576 smbytes=197,902 max_bytes=197,919 bufs=101 max_bufs=101
139s  Sizes: boffset_t=8 size_t=8 debug=0 trace=0 mode=0,0 bwlimit=0kB/s
139s  Crypto: fips=N/A crypto=OpenSSL 3.4.0 22 Oct 2024
139s  Plugin: bpipe-fd.so(2) 
139s 
139s Running Jobs:
139s Director connected using TLS at: 02-May-25 08:38
139s No Jobs running.
139s ====
139s 
139s Terminated Jobs:
139s ====
139s + echo
139s 
139s + echo '---- label a volume ----'
139s ---- label a volume ----
139s + echo -e 'label volume=testvol pool=File storage=File1 drive=0 slot=0'
139s + bconsole
139s Connecting to Director localhost:9101
139s 1000 OK: 10002 autopkgtest-dir Version: 13.0.4 (12 February 2024)
139s Enter a period to cancel a command.
139s label volume=testvol pool=File storage=File1 drive=0 slot=0
139s Automatically selected Catalog: MyCatalog
139s Using Catalog "MyCatalog"
139s Connecting to Storage daemon File1 at localhost:9103 ...
139s Sending label command for Volume "testvol" Slot 0 ...
139s 3000 OK label. VolBytes=226 VolABytes=0 VolType=1 Volume="testvol" Device="FileChgr1-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
139s Catalog record for Volume "testvol", Slot 0  successfully created.
139s Requesting to mount FileChgr1 ...
139s 3906 File device ""FileChgr1-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)" is always mounted.
139s + echo
139s 
139s + echo '----- create some file to test backup / restore ----'
139s ----- create some file to test backup / restore ----
139s + echo 'bacula restore test'
139s + echo
139s 
139s + echo '------ trigger backup job -----'
139s ------ trigger backup job -----
139s + echo -e 'run job=BackupClient1 yes\rwait'
139s + bconsole
139s + grep 'Job queued. JobId='
142s Job queued. JobId=1
142s + echo 'status all'
142s + bconsole
142s Connecting to Director localhost:9101
142s 1000 OK: 10002 autopkgtest-dir Version: 13.0.4 (12 February 2024)
142s Enter a period to cancel a command.
142s status all
142s autopkgtest-dir Version: 13.0.4 (12 February 2024) s390x-ibm-linux-gnu ubuntu 25.04
142s Daemon started 02-May-25 08:38, conf reloaded 02-May-2025 08:38:18
142s  Jobs: run=1, running=0 mode=0,0
142s  Crypto: fips=N/A crypto=OpenSSL 3.4.0 22 Oct 2024
142s  Heap: heap=831,488 smbytes=465,818 max_bytes=491,679 bufs=459 max_bufs=510
142s  Res: njobs=3 nclients=1 nstores=2 npools=3 ncats=1 nfsets=2 nscheds=2
142s 
142s Scheduled Jobs:
142s Level          Type     Pri  Scheduled          Job Name           Volume
142s ===================================================================================
142s Incremental    Backup    10  02-May-25 23:05    BackupClient1      testvol
142s Full           Backup    11  02-May-25 23:10    BackupCatalog      testvol
142s ====
142s 
142s Running Jobs:
142s Console connected using TLS at 02-May-25 08:38
142s No Jobs running.
142s ====
142s 
142s Terminated Jobs:
142s  JobId  Level     Files      Bytes   Status   Finished        Name 
142s ====================================================================
142s      1  Full         592    29.52 M  OK       02-May-25 08:38 BackupClient1
142s 
142s ====
142s Connecting to Storage daemon File1 at localhost:9103
142s 
143s autopkgtest-sd Version: 13.0.4 (12 February 2024) s390x-ibm-linux-gnu ubuntu 25.04
143s Daemon started 02-May-25 08:38. Jobs: run=1, running=0.
143s  Ulimits: nofile=1024 memlock=unlimited status=nofile
143s  Heap: heap=643,072 smbytes=709,405 max_bytes=1,002,145 bufs=284 max_bufs=305
143s  Sizes: boffset_t=8 size_t=8 int32_t=4 int64_t=8 mode=0,0 newbsr=0
143s  Crypto: fips=N/A crypto=OpenSSL 3.4.0 22 Oct 2024
143s  Res: ndevices=4 nautochgr=2
143s 
143s Running Jobs:
143s Director connected using TLS at: 02-May-25 08:38
143s No Jobs running.
143s ====
143s 
143s Jobs waiting to reserve a drive:
143s ====
143s 
143s Terminated Jobs:
143s  JobId  Level    Files      Bytes   Status   Finished        Name 
143s ===================================================================
143s      1  Full        592    29.58 M  OK       02-May-25 08:38 BackupClient1
143s ====
143s 
143s Device status:
143s Autochanger "FileChgr1" with devices:
143s    "FileChgr1-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
143s    "FileChgr1-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
143s Autochanger "FileChgr2" with devices:
143s    "FileChgr2-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
143s    "FileChgr2-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
143s 
143s Device File: "FileChgr1-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
143s    Drive 0 is not loaded.
143s    Available Space=18.19 GB
143s ==
143s 
143s Device File: "FileChgr1-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
143s    Drive 0 is not loaded.
143s    Available Space=18.19 GB
143s ==
143s 
143s Device File: "FileChgr2-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
143s    Drive 0 is not loaded.
143s    Available Space=18.19 GB
143s ==
143s 
143s Device File: "FileChgr2-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
143s    Drive 0 is not loaded.
143s    Available Space=18.19 GB
143s ==
143s ====
143s 
143s Used Volume status:
143s ====
143s 
143s Attr spooling: 0 active jobs, 122,991 bytes; 1 total jobs, 122,991 max bytes.
143s ====
143s 
143s Connecting to Client autopkgtest-fd at localhost:9102
143s 
143s autopkgtest-fd Version: 13.0.4 (12 February 2024)  s390x-ibm-linux-gnu ubuntu 25.04
143s Daemon started 02-May-25 08:38. Jobs: run=1 running=0.
143s  Heap: heap=536,576 smbytes=400,466 max_bytes=662,269 bufs=116 max_bufs=150
143s  Sizes: boffset_t=8 size_t=8 debug=0 trace=0 mode=0,0 bwlimit=0kB/s
143s  Crypto: fips=N/A crypto=OpenSSL 3.4.0 22 Oct 2024
143s  Plugin: bpipe-fd.so(2) 
143s 
143s Running Jobs:
143s Director connected using TLS at: 02-May-25 08:38
143s No Jobs running.
143s ====
143s 
143s Terminated Jobs:
143s  JobId  Level    Files      Bytes   Status   Finished        Name 
143s ===================================================================
143s      1  Full        592    29.52 M  OK       02-May-25 08:38 BackupClient1
143s ====
143s You have messages.
143s + echo
143s 
143s + echo '------ trigger restore job -----'
143s ------ trigger restore job -----
143s + echo -e 'restore select current\rls\rmark usr\rdone\ryes\rwait'
143s + bconsole
143s Connecting to Director localhost:9101
143s 1000 OK: 10002 autopkgtest-dir Version: 13.0.4 (12 February 2024)
143s Enter a period to cancel a command.
143s restore select current
143s Automatically selected Catalog: MyCatalog
143s Using Catalog "MyCatalog"
143s Automatically selected Client: autopkgtest-fd
143s Automatically selected FileSet: Full Set
143s +-------+-------+----------+------------+---------------------+------------+
143s | jobid | level | jobfiles | jobbytes   | starttime           | volumename |
143s +-------+-------+----------+------------+---------------------+------------+
143s |     1 | F     |      592 | 29,524,409 | 2025-05-02 08:38:31 | testvol    |
143s +-------+-------+----------+------------+---------------------+------------+
143s You have selected the following JobId: 1
143s 
143s Building directory tree for JobId(s) 1 ...  +++++++++++++++++++++++++++++++++++++++++++++++++
143s 591 files inserted into the tree.
143s 
143s You are now entering file selection mode where you add (mark) and
143s remove (unmark) files to be restored. No files are initially added, unless
143s you used the "all" keyword on the command line.
143s Enter "done" to leave this mode.
143s 
143s cwd is: /
143s $ ls
143s usr/
143s $ mark usr
143s 592 files marked.
143s $ done
143s Bootstrap records written to /var/lib/bacula/autopkgtest-dir.restore.1.bsr
143s 
143s The Job will require the following (*=>InChanger):
143s    Volume(s)                 Storage(s)                SD Device(s)
143s ===========================================================================
143s    
143s     testvol                   File1                     FileChgr1                
143s 
143s Volumes marked with "*" are in the Autochanger.
143s 
143s 
143s 592 files selected to be restored.
143s 
143s Using Catalog "MyCatalog"
143s Run Restore job
143s JobName:         RestoreFiles
143s Bootstrap:       /var/lib/bacula/autopkgtest-dir.restore.1.bsr
143s Where:           /tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-restores
143s Replace:         Always
143s FileSet:         Full Set
143s Backup Client:   autopkgtest-fd
143s Restore Client:  autopkgtest-fd
143s Storage:         File1
143s When:            2025-05-02 08:38:33
143s Catalog:         MyCatalog
143s Priority:        10
143s Plugin Options:  *None*
143s OK to run? (yes/mod/no): yes
143s Job queued. JobId=2
143s You have messages.
143s wait
146s + echo 'status all'
146s + bconsole
146s Connecting to Director localhost:9101
146s 1000 OK: 10002 autopkgtest-dir Version: 13.0.4 (12 February 2024)
146s Enter a period to cancel a command.
146s status all
146s autopkgtest-dir Version: 13.0.4 (12 February 2024) s390x-ibm-linux-gnu ubuntu 25.04
146s Daemon started 02-May-25 08:38, conf reloaded 02-May-2025 08:38:18
146s  Jobs: run=2, running=0 mode=0,0
146s  Crypto: fips=N/A crypto=OpenSSL 3.4.0 22 Oct 2024
146s  Heap: heap=770,048 smbytes=465,782 max_bytes=1,672,601 bufs=461 max_bufs=523
146s  Res: njobs=3 nclients=1 nstores=2 npools=3 ncats=1 nfsets=2 nscheds=2
146s 
146s Scheduled Jobs:
146s Level          Type     Pri  Scheduled          Job Name           Volume
146s ===================================================================================
146s Incremental    Backup    10  02-May-25 23:05    BackupClient1      testvol
146s Full           Backup    11  02-May-25 23:10    BackupCatalog      testvol
146s ====
146s 
146s Running Jobs:
146s Console connected using TLS at 02-May-25 08:38
146s No Jobs running.
146s ====
146s 
146s Terminated Jobs:
146s  JobId  Level     Files      Bytes   Status   Finished        Name 
146s ====================================================================
146s      1  Full         592    29.52 M  OK       02-May-25 08:38 BackupClient1
146s      2  Restore      592    29.52 M  OK       02-May-25 08:38 RestoreFiles
146s 
146s ====
146s Connecting to Storage daemon File1 at localhost:9103
146s 
146s autopkgtest-sd Version: 13.0.4 (12 February 2024) s390x-ibm-linux-gnu ubuntu 25.04
146s Daemon started 02-May-25 08:38. Jobs: run=2, running=0.
146s  Ulimits: nofile=1024 memlock=unlimited status=nofile
146s  Heap: heap=536,576 smbytes=639,566 max_bytes=1,002,145 bufs=277 max_bufs=315
146s  Sizes: boffset_t=8 size_t=8 int32_t=4 int64_t=8 mode=0,0 newbsr=0
146s  Crypto: fips=N/A crypto=OpenSSL 3.4.0 22 Oct 2024
146s  Res: ndevices=4 nautochgr=2
146s 
146s Running Jobs:
146s Director connected using TLS at: 02-May-25 08:38
146s No Jobs running.
146s ====
146s 
146s Jobs waiting to reserve a drive:
146s ====
146s 
146s Terminated Jobs:
146s  JobId  Level    Files      Bytes   Status   Finished        Name 
146s ===================================================================
146s      1  Full        592    29.58 M  OK       02-May-25 08:38 BackupClient1
146s      2  Rest        592    29.58 M  OK       02-May-25 08:38 RestoreFiles
146s ====
146s 
146s Device status:
146s Autochanger "FileChgr1" with devices:
146s    "FileChgr1-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
146s    "FileChgr1-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
146s Autochanger "FileChgr2" with devices:
146s    "FileChgr2-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
146s    "FileChgr2-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
146s 
146s Device File: "FileChgr1-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
146s    Drive 0 is not loaded.
146s    Available Space=18.16 GB
146s ==
146s 
146s Device File: "FileChgr1-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
146s    Drive 0 is not loaded.
146s    Available Space=18.16 GB
146s ==
146s 
146s Device File: "FileChgr2-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
146s    Drive 0 is not loaded.
146s    Available Space=18.16 GB
146s ==
146s 
146s Device File: "FileChgr2-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
146s    Drive 0 is not loaded.
146s    Available Space=18.16 GB
146s ==
146s ====
146s 
146s Used Volume status:
146s ====
146s 
146s Attr spooling: 0 active jobs, 122,991 bytes; 1 total jobs, 122,991 max bytes.
146s ====
146s 
146s Connecting to Client autopkgtest-fd at localhost:9102
146s 
146s autopkgtest-fd Version: 13.0.4 (12 February 2024)  s390x-ibm-linux-gnu ubuntu 25.04
146s Daemon started 02-May-25 08:38. Jobs: run=2 running=0.
146s  Heap: heap=528,384 smbytes=239,997 max_bytes=1,114,034 bufs=102 max_bufs=150
146s  Sizes: boffset_t=8 size_t=8 debug=0 trace=0 mode=0,0 bwlimit=0kB/s
146s  Crypto: fips=N/A crypto=OpenSSL 3.4.0 22 Oct 2024
146s  Plugin: bpipe-fd.so(2) 
146s 
146s Running Jobs:
146s Director connected using TLS at: 02-May-25 08:38
146s No Jobs running.
146s ====
146s 
146s Terminated Jobs:
146s  JobId  Level    Files      Bytes   Status   Finished        Name 
146s ===================================================================
146s      1  Full        592    29.52 M  OK       02-May-25 08:38 BackupClient1
146s      2  Rest        592    29.52 M  OK       02-May-25 08:38 RestoreFiles
146s ====
146s You have messages.
146s + grep 'bacula restore test' /tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-restores//usr/sbin/bacula-backup.test
146s bacula restore test
146s + echo
146s 
146s + echo '------ compare original and restore ------'
146s ------ compare original and restore ------
146s + debian/tests/scripts/diff.pl -s /usr/sbin -d /tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-restores/usr/sbin --acl --attr
148s + echo
148s 
148s + echo '------ backup-test end ------'
148s ------ backup-test end ------
149s autopkgtest [08:38:39]: test backup-test-pgsql: -----------------------]
149s backup-test-pgsql    PASS
149s autopkgtest [08:38:39]: test backup-test-pgsql:  - - - - - - - - - - results - - - - - - - - - -
150s autopkgtest [08:38:40]: test program-test-pgsql: preparing testbed
256s autopkgtest [08:40:26]: testbed dpkg architecture: s390x
256s autopkgtest [08:40:26]: testbed apt version: 3.0.0
256s autopkgtest [08:40:26]: @@@@@@@@@@@@@@@@@@@@ test bed setup
257s autopkgtest [08:40:27]: testbed release detected to be: questing
257s autopkgtest [08:40:27]: updating testbed package index (apt update)
258s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [110 kB]
258s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease
258s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease
258s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease
258s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [2076 kB]
258s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [175 kB]
258s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [44.4 kB]
258s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main s390x Packages [208 kB]
258s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/universe s390x Packages [1079 kB]
259s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/multiverse s390x Packages [9148 B]
259s Fetched 3701 kB in 1s (2837 kB/s)
259s Reading package lists...
260s autopkgtest [08:40:30]: upgrading testbed (apt dist-upgrade and autopurge)
260s Reading package lists...
260s Building dependency tree...
260s Reading state information...
260s Calculating upgrade...Starting pkgProblemResolver with broken count: 0
260s Starting 2 pkgProblemResolver with broken count: 0
260s Done
261s Entering ResolveByKeep
261s 
261s Calculating upgrade...
261s The following packages will be upgraded:
261s   htop nano ucf
261s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
261s Need to get 532 kB of archives.
261s After this operation, 4096 B of additional disk space will be used.
261s Get:1 http://ftpmaster.internal/ubuntu questing-proposed/main s390x ucf all 3.0051 [43.6 kB]
261s Get:2 http://ftpmaster.internal/ubuntu questing/main s390x nano s390x 8.4-1 [299 kB]
261s Get:3 http://ftpmaster.internal/ubuntu questing/main s390x htop s390x 3.4.1-4 [189 kB]
262s Preconfiguring packages ...
262s Fetched 532 kB in 1s (935 kB/s)
262s (Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 81472 files and directories currently installed.)
262s Preparing to unpack .../archives/ucf_3.0051_all.deb ...
262s Unpacking ucf (3.0051) over (3.0050) ...
262s Preparing to unpack .../archives/nano_8.4-1_s390x.deb ...
262s Unpacking nano (8.4-1) over (8.3-1) ...
262s Preparing to unpack .../htop_3.4.1-4_s390x.deb ...
262s Unpacking htop (3.4.1-4) over (3.4.0-2) ...
262s Setting up htop (3.4.1-4) ...
262s Setting up ucf (3.0051) ...
262s Setting up nano (8.4-1) ...
262s Installing new version of config file /etc/nanorc ...
262s Processing triggers for man-db (2.13.0-1) ...
263s Processing triggers for install-info (7.1.1-1) ...
263s Reading package lists...
263s Building dependency tree...
263s Reading state information...
263s Starting pkgProblemResolver with broken count: 0
263s Starting 2 pkgProblemResolver with broken count: 0
263s Done
263s Solving dependencies...
263s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
266s Reading package lists...
266s Building dependency tree...
266s Reading state information...
266s Starting pkgProblemResolver with broken count: 0
266s Starting 2 pkgProblemResolver with broken count: 0
266s Done
266s The following NEW packages will be installed:
266s   bacula bacula-bscan bacula-client bacula-common bacula-common-pgsql
266s   bacula-console bacula-director bacula-director-pgsql bacula-fd bacula-sd
266s   bacula-server bsd-mailx dbconfig-common dbconfig-pgsql libio-pty-perl
266s   libipc-run-perl libjson-perl libllvm20 liblockfile-bin liblockfile1 libpq5
266s   libxslt1.1 mtx postfix postgresql postgresql-17 postgresql-client
266s   postgresql-client-17 postgresql-client-common postgresql-common
266s   postgresql-common-dev ssl-cert
267s 0 upgraded, 32 newly installed, 0 to remove and 0 not upgraded.
267s Need to get 53.6 MB of archives.
267s After this operation, 224 MB of additional disk space will be used.
267s Get:1 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-common s390x 13.0.4-4build1 [854 kB]
267s Get:2 http://ftpmaster.internal/ubuntu questing/main s390x libpq5 s390x 17.4-1 [147 kB]
267s Get:3 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-common-pgsql s390x 13.0.4-4build1 [15.6 kB]
267s Get:4 http://ftpmaster.internal/ubuntu questing/universe s390x dbconfig-common all 2.0.24 [596 kB]
267s Get:5 http://ftpmaster.internal/ubuntu questing/main s390x postgresql-client-common all 274 [47.6 kB]
267s Get:6 http://ftpmaster.internal/ubuntu questing/main s390x postgresql-client-17 s390x 17.4-1 [1367 kB]
267s Get:7 http://ftpmaster.internal/ubuntu questing/main s390x postgresql-client all 17+274 [13.3 kB]
267s Get:8 http://ftpmaster.internal/ubuntu questing/universe s390x dbconfig-pgsql all 2.0.24 [914 B]
267s Get:9 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-director-pgsql all 13.0.4-4build1 [34.0 kB]
267s Get:10 http://ftpmaster.internal/ubuntu questing/main s390x postfix s390x 3.9.1-10ubuntu1 [1305 kB]
268s Get:11 http://ftpmaster.internal/ubuntu questing/main s390x liblockfile-bin s390x 1.17-2 [11.5 kB]
268s Get:12 http://ftpmaster.internal/ubuntu questing/main s390x liblockfile1 s390x 1.17-2 [6970 B]
268s Get:13 http://ftpmaster.internal/ubuntu questing/main s390x bsd-mailx s390x 8.1.2-0.20220412cvs-1build1 [69.7 kB]
268s Get:14 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-director s390x 13.0.4-4build1 [379 kB]
268s Get:15 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-fd s390x 13.0.4-4build1 [144 kB]
268s Get:16 http://ftpmaster.internal/ubuntu questing/main s390x mtx s390x 1.3.12-18 [43.2 kB]
268s Get:17 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-sd s390x 13.0.4-4build1 [151 kB]
268s Get:18 http://ftpmaster.internal/ubuntu questing/main s390x libjson-perl all 4.10000-1 [81.9 kB]
268s Get:19 http://ftpmaster.internal/ubuntu questing/main s390x libio-pty-perl s390x 1:1.20-1build3 [31.6 kB]
268s Get:20 http://ftpmaster.internal/ubuntu questing/main s390x libipc-run-perl all 20231003.0-2 [91.5 kB]
268s Get:21 http://ftpmaster.internal/ubuntu questing/main s390x postgresql-common-dev all 274 [73.0 kB]
268s Get:22 http://ftpmaster.internal/ubuntu questing/main s390x ssl-cert all 1.1.3ubuntu1 [18.7 kB]
268s Get:23 http://ftpmaster.internal/ubuntu questing/main s390x postgresql-common all 274 [101 kB]
268s Get:24 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-console s390x 13.0.4-4build1 [28.6 kB]
268s Get:25 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-client all 13.0.4-4build1 [23.5 kB]
268s Get:26 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-bscan s390x 13.0.4-4build1 [24.7 kB]
268s Get:27 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-server all 13.0.4-4build1 [23.4 kB]
268s Get:28 http://ftpmaster.internal/ubuntu questing/universe s390x bacula all 13.0.4-4build1 [1036 B]
268s Get:29 http://ftpmaster.internal/ubuntu questing/main s390x libllvm20 s390x 1:20.1.2-0ubuntu1 [31.4 MB]
269s Get:30 http://ftpmaster.internal/ubuntu questing/main s390x libxslt1.1 s390x 1.1.39-0exp1ubuntu4 [170 kB]
269s Get:31 http://ftpmaster.internal/ubuntu questing/main s390x postgresql-17 s390x 17.4-1 [16.3 MB]
270s Get:32 http://ftpmaster.internal/ubuntu questing/main s390x postgresql all 17+274 [14.4 kB]
270s Preconfiguring packages ...
270s /var/cache/debconf/tmp.ci/postgresql.config.v7yEnx: 12: pg_lsclusters: not found
270s Fetched 53.6 MB in 4s (15.1 MB/s)
270s Selecting previously unselected package bacula-common.
270s (Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 81472 files and directories currently installed.)
270s Preparing to unpack .../00-bacula-common_13.0.4-4build1_s390x.deb ...
271s Adding user 'bacula'... Ok.
271s Unpacking bacula-common (13.0.4-4build1) ...
271s Selecting previously unselected package libpq5:s390x.
271s Preparing to unpack .../01-libpq5_17.4-1_s390x.deb ...
271s Unpacking libpq5:s390x (17.4-1) ...
271s Selecting previously unselected package bacula-common-pgsql.
271s Preparing to unpack .../02-bacula-common-pgsql_13.0.4-4build1_s390x.deb ...
271s Unpacking bacula-common-pgsql (13.0.4-4build1) ...
271s Selecting previously unselected package dbconfig-common.
271s Preparing to unpack .../03-dbconfig-common_2.0.24_all.deb ...
271s Unpacking dbconfig-common (2.0.24) ...
271s Selecting previously unselected package postgresql-client-common.
271s Preparing to unpack .../04-postgresql-client-common_274_all.deb ...
271s Unpacking postgresql-client-common (274) ...
271s Selecting previously unselected package postgresql-client-17.
271s Preparing to unpack .../05-postgresql-client-17_17.4-1_s390x.deb ...
271s Unpacking postgresql-client-17 (17.4-1) ...
271s Selecting previously unselected package postgresql-client.
271s Preparing to unpack .../06-postgresql-client_17+274_all.deb ...
271s Unpacking postgresql-client (17+274) ...
271s Selecting previously unselected package dbconfig-pgsql.
271s Preparing to unpack .../07-dbconfig-pgsql_2.0.24_all.deb ...
271s Unpacking dbconfig-pgsql (2.0.24) ...
271s Selecting previously unselected package bacula-director-pgsql.
271s Preparing to unpack .../08-bacula-director-pgsql_13.0.4-4build1_all.deb ...
271s Unpacking bacula-director-pgsql (13.0.4-4build1) ...
271s Selecting previously unselected package postfix.
271s Preparing to unpack .../09-postfix_3.9.1-10ubuntu1_s390x.deb ...
271s Unpacking postfix (3.9.1-10ubuntu1) ...
271s Selecting previously unselected package liblockfile-bin.
271s Preparing to unpack .../10-liblockfile-bin_1.17-2_s390x.deb ...
271s Unpacking liblockfile-bin (1.17-2) ...
271s Selecting previously unselected package liblockfile1:s390x.
271s Preparing to unpack .../11-liblockfile1_1.17-2_s390x.deb ...
271s Unpacking liblockfile1:s390x (1.17-2) ...
271s Selecting previously unselected package bsd-mailx.
271s Preparing to unpack .../12-bsd-mailx_8.1.2-0.20220412cvs-1build1_s390x.deb ...
271s Unpacking bsd-mailx (8.1.2-0.20220412cvs-1build1) ...
271s Selecting previously unselected package bacula-director.
271s Preparing to unpack .../13-bacula-director_13.0.4-4build1_s390x.deb ...
271s Unpacking bacula-director (13.0.4-4build1) ...
271s Selecting previously unselected package bacula-fd.
271s Preparing to unpack .../14-bacula-fd_13.0.4-4build1_s390x.deb ...
271s Unpacking bacula-fd (13.0.4-4build1) ...
271s Selecting previously unselected package mtx.
271s Preparing to unpack .../15-mtx_1.3.12-18_s390x.deb ...
271s Unpacking mtx (1.3.12-18) ...
271s Selecting previously unselected package bacula-sd.
271s Preparing to unpack .../16-bacula-sd_13.0.4-4build1_s390x.deb ...
271s Unpacking bacula-sd (13.0.4-4build1) ...
271s Selecting previously unselected package libjson-perl.
271s Preparing to unpack .../17-libjson-perl_4.10000-1_all.deb ...
271s Unpacking libjson-perl (4.10000-1) ...
271s Selecting previously unselected package libio-pty-perl.
271s Preparing to unpack .../18-libio-pty-perl_1%3a1.20-1build3_s390x.deb ...
271s Unpacking libio-pty-perl (1:1.20-1build3) ...
271s Selecting previously unselected package libipc-run-perl.
271s Preparing to unpack .../19-libipc-run-perl_20231003.0-2_all.deb ...
271s Unpacking libipc-run-perl (20231003.0-2) ...
271s Selecting previously unselected package postgresql-common-dev.
271s Preparing to unpack .../20-postgresql-common-dev_274_all.deb ...
271s Unpacking postgresql-common-dev (274) ...
271s Selecting previously unselected package ssl-cert.
271s Preparing to unpack .../21-ssl-cert_1.1.3ubuntu1_all.deb ...
271s Unpacking ssl-cert (1.1.3ubuntu1) ...
271s Selecting previously unselected package postgresql-common.
271s Preparing to unpack .../22-postgresql-common_274_all.deb ...
271s Adding 'diversion of /usr/bin/pg_config to /usr/bin/pg_config.libpq-dev by postgresql-common'
271s Unpacking postgresql-common (274) ...
271s Selecting previously unselected package bacula-console.
271s Preparing to unpack .../23-bacula-console_13.0.4-4build1_s390x.deb ...
271s Unpacking bacula-console (13.0.4-4build1) ...
271s Selecting previously unselected package bacula-client.
271s Preparing to unpack .../24-bacula-client_13.0.4-4build1_all.deb ...
271s Unpacking bacula-client (13.0.4-4build1) ...
271s Selecting previously unselected package bacula-bscan.
271s Preparing to unpack .../25-bacula-bscan_13.0.4-4build1_s390x.deb ...
271s Unpacking bacula-bscan (13.0.4-4build1) ...
271s Selecting previously unselected package bacula-server.
271s Preparing to unpack .../26-bacula-server_13.0.4-4build1_all.deb ...
271s Unpacking bacula-server (13.0.4-4build1) ...
271s Selecting previously unselected package bacula.
271s Preparing to unpack .../27-bacula_13.0.4-4build1_all.deb ...
271s Unpacking bacula (13.0.4-4build1) ...
271s Selecting previously unselected package libllvm20:s390x.
271s Preparing to unpack .../28-libllvm20_1%3a20.1.2-0ubuntu1_s390x.deb ...
271s Unpacking libllvm20:s390x (1:20.1.2-0ubuntu1) ...
272s Selecting previously unselected package libxslt1.1:s390x.
272s Preparing to unpack .../29-libxslt1.1_1.1.39-0exp1ubuntu4_s390x.deb ...
272s Unpacking libxslt1.1:s390x (1.1.39-0exp1ubuntu4) ...
272s Selecting previously unselected package postgresql-17.
272s Preparing to unpack .../30-postgresql-17_17.4-1_s390x.deb ...
272s Unpacking postgresql-17 (17.4-1) ...
272s Selecting previously unselected package postgresql.
272s Preparing to unpack .../31-postgresql_17+274_all.deb ...
272s Unpacking postgresql (17+274) ...
272s Setting up postgresql-client-common (274) ...
272s Setting up liblockfile-bin (1.17-2) ...
272s Setting up libio-pty-perl (1:1.20-1build3) ...
272s Setting up libpq5:s390x (17.4-1) ...
272s Setting up mtx (1.3.12-18) ...
272s Setting up dbconfig-common (2.0.24) ...
272s Creating config file /etc/dbconfig-common/config with new version
272s Setting up bacula-common (13.0.4-4build1) ...
272s Setting up bacula-sd (13.0.4-4build1) ...
272s Creating config file /etc/default/bacula-sd with new version
272s Creating config file /etc/bacula/bacula-sd.conf with new version
273s Created symlink '/etc/systemd/system/multi-user.target.wants/bacula-sd.service' → '/usr/lib/systemd/system/bacula-sd.service'.

273s Setting up ssl-cert (1.1.3ubuntu1) ...
274s Created symlink '/etc/systemd/system/multi-user.target.wants/ssl-cert.service' → '/usr/lib/systemd/system/ssl-cert.service'.

274s Setting up libllvm20:s390x (1:20.1.2-0ubuntu1) ...
274s Setting up libipc-run-perl (20231003.0-2) ...
274s Setting up bacula-console (13.0.4-4build1) ...
274s Creating config file /etc/bacula/bconsole.conf with new version
274s Setting up postfix (3.9.1-10ubuntu1) ...
274s Created symlink '/etc/systemd/system/multi-user.target.wants/postfix.service' → '/usr/lib/systemd/system/postfix.service'.

275s info: Selecting UID from range 100 to 999 ...
275s 
275s info: Selecting GID from range 100 to 999 ...
275s info: Adding system user `postfix' (UID 108) ...
275s info: Adding new group `postfix' (GID 114) ...
275s info: Adding new user `postfix' (UID 108) with group `postfix' ...
275s info: Not creating home directory `/var/spool/postfix'.
275s info: Selecting GID from range 100 to 999 ...
275s info: Adding group `postdrop' (GID 115) ...
275s Creating /etc/postfix/dynamicmaps.cf
275s setting myhostname: autopkgtest.local
275s setting alias maps
275s setting alias database
275s changing /etc/mailname to autopkgtest.local
275s setting myorigin
275s setting destinations: $myhostname, autopkgtest.local, localhost.local, , localhost
275s setting relayhost: 
275s setting mynetworks: 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128
275s clearing mailbox_command
275s setting mailbox_size_limit: 0
275s setting recipient_delimiter: +
277s setting inet_interfaces: all
279s setting inet_protocols: all
279s /etc/aliases does not exist, creating it.
279s WARNING: /etc/aliases exists, but does not have a root alias.
279s 
279s Postfix (main.cf) is now set up with a default configuration.  If you need to 
279s make changes, edit /etc/postfix/main.cf (and others) as needed.  To view 
279s Postfix configuration values, see postconf(1).
279s 
279s After modifying main.cf, be sure to run 'systemctl reload postfix'.
279s 
281s Setting up libjson-perl (4.10000-1) ...
281s Setting up libxslt1.1:s390x (1.1.39-0exp1ubuntu4) ...
281s Setting up liblockfile1:s390x (1.17-2) ...
281s Setting up bacula-fd (13.0.4-4build1) ...
281s Creating config file /etc/default/bacula-fd with new version
281s Creating config file /etc/bacula/bacula-fd.conf with new version
282s Created symlink '/etc/systemd/system/multi-user.target.wants/bacula-fd.service' → '/usr/lib/systemd/system/bacula-fd.service'.

282s Setting up postgresql-common-dev (274) ...
282s Setting up bacula-client (13.0.4-4build1) ...
282s Setting up postgresql-client-17 (17.4-1) ...
282s 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
282s Setting up dbconfig-pgsql (2.0.24) ...
282s Setting up bacula-common-pgsql (13.0.4-4build1) ...
282s Setting up bsd-mailx (8.1.2-0.20220412cvs-1build1) ...
282s update-alternatives: using /usr/bin/bsd-mailx to provide /usr/bin/mailx (mailx) in auto mode
282s Setting up postgresql-common (274) ...
283s Creating config file /etc/postgresql-common/createcluster.conf with new version
283s Building PostgreSQL dictionaries from installed myspell/hunspell packages...
283s Removing obsolete dictionary files:
283s Created symlink '/etc/systemd/system/multi-user.target.wants/postgresql.service' → '/usr/lib/systemd/system/postgresql.service'.

283s Setting up bacula-bscan (13.0.4-4build1) ...
283s Setting up postgresql-17 (17.4-1) ...
284s Creating new PostgreSQL cluster 17/main ...
284s /usr/lib/postgresql/17/bin/initdb -D /var/lib/postgresql/17/main --auth-local peer --auth-host scram-sha-256 --no-instructions
284s The files belonging to this database system will be owned by user "postgres".
284s This user must also own the server process.
284s 
284s The database cluster will be initialized with locale "C.UTF-8".
284s The default database encoding has accordingly been set to "UTF8".
284s The default text search configuration will be set to "english".
284s 
284s Data page checksums are disabled.
284s 
284s fixing permissions on existing directory /var/lib/postgresql/17/main ... ok
284s creating subdirectories ... ok
284s selecting dynamic shared memory implementation ... posix
284s selecting default "max_connections" ... 100
284s selecting default "shared_buffers" ... 128MB
284s selecting default time zone ... Etc/UTC
284s creating configuration files ... ok
284s running bootstrap script ... ok
284s performing post-bootstrap initialization ... ok
284s syncing data to disk ... ok
287s Setting up bacula-director-pgsql (13.0.4-4build1) ...
287s dbconfig-common: writing config to /etc/dbconfig-common/bacula-director-pgsql.conf
287s Creating config file /etc/dbconfig-common/bacula-director-pgsql.conf with new version
287s creating postgres user bacula:  success.
287s verifying creation of user: success.
288s creating database bacula: success.
288s verifying database bacula exists: success.
288s populating database via administrative sql...  done.
288s populating database via sql...  done.
288s dbconfig-common: flushing administrative password
288s Setting up postgresql-client (17+274) ...
288s Setting up bacula-director (13.0.4-4build1) ...
288s Creating config file /etc/default/bacula-dir with new version
288s Creating config file /etc/bacula/bacula-dir.conf with new version
288s Creating config file /etc/bacula/scripts/delete_catalog_backup with new version
288s Creating config file /etc/bacula/scripts/make_catalog_backup with new version
289s Created symlink '/etc/systemd/system/bacula-dir.service' → '/usr/lib/systemd/system/bacula-director.service'.

289s Created symlink '/etc/systemd/system/multi-user.target.wants/bacula-director.service' → '/usr/lib/systemd/system/bacula-director.service'.

289s Setting up postgresql (17+274) ...
289s Setting up bacula-server (13.0.4-4build1) ...
289s Setting up bacula (13.0.4-4build1) ...
289s Processing triggers for rsyslog (8.2412.0-2ubuntu2) ...
289s Processing triggers for ufw (0.36.2-9) ...
289s Processing triggers for man-db (2.13.0-1) ...
290s Processing triggers for libc-bin (2.41-6ubuntu1) ...
290s Processing triggers for postfix (3.9.1-10ubuntu1) ...
290s Restarting postfix
297s autopkgtest [08:41:07]: test program-test-pgsql: [-----------------------
297s + echo '----- start testing -----'
297s ----- start testing -----
297s + echo 'USER: root'
297s USER: root
297s + DBTYPE=pgsql
297s + echo '---- Preparing test files ----'
297s ---- Preparing test files ----
297s + DATAFILE=/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/datafile
297s + cat
297s + echo
297s 
297s + echo '---- Testing /usr/sbin/bregex ----'
297s ---- Testing /usr/sbin/bregex ----
297s + echo -en 'line . of the message\r'
297s + /usr/sbin/bregex -f /tmp/autopkgtest.qRgwYF/autopkgtest_tmp/datafile
297s Enter regex pattern:     2: This is line 1 of the message.
297s     3: This is line 2 of the message.
297s     4: This is line 3 of the message.
297s     5: This is line 4 of the message.
297s Enter regex pattern: + echo
297s 
297s + echo '---- Testing /usr/sbin/bwild ----'
297s ---- Testing /usr/sbin/bwild ----
297s + echo -en '*line ? of the message.\r'
297s + /usr/sbin/bwild -f /tmp/autopkgtest.qRgwYF/autopkgtest_tmp/datafile
297s Enter a wild-card:     2: This is line 1 of the message.
297s     3: This is line 2 of the message.
297s     4: This is line 3 of the message.
297s     5: This is line 4 of the message.
297s Enter a wild-card: + echo
297s 
297s + echo '---- Testing /usr/sbin/bbconsjson ----'
297s ---- Testing /usr/sbin/bbconsjson ----
297s + /usr/sbin/bbconsjson
297s [
297s {
297s   "Director": {
297s     "Name": "autopkgtest-dir",
297s     "DirPort": 9101,
297s     "Address": "localhost",
297s     "Password": "4RSDYGiF6mftvvNSz-N3-woPywrraqosD"
297s    }
297s }
297s ]
297s + echo
297s 
297s + echo '---- Testing /usr/sbin/bdirjson ----'
297s ---- Testing /usr/sbin/bdirjson ----
297s + /usr/sbin/bdirjson
297s [
297s {
297s   "Director": {
297s     "Name": "autopkgtest-dir",
297s     "Messages": "Daemon",
297s     "DirAddress": "127.0.0.1",
297s     "QueryFile": "/etc/bacula/scripts/query.sql",
297s     "WorkingDirectory": "/var/lib/bacula",
297s     "PidDirectory": "/run/bacula",
297s     "MaximumConcurrentJobs": 20,
297s     "Password": "4RSDYGiF6mftvvNSz-N3-woPywrraqosD"
297s   }
297s },
297s {
297s   "Client": {
297s     "Name": "autopkgtest-fd",
297s     "Address": "localhost",
297s     "FdPort": 9102,
297s     "Password": "hVDqA2NOvmyBQ-6p30qZueujCp7V8Po7u",
297s     "Catalog": "MyCatalog",
297s     "FileRetention": 5184000,
297s     "JobRetention": 15552000,
297s     "AutoPrune": true
297s   }
297s },
297s {
297s   "Job": {
297s     "Name": "BackupCatalog",
297s     "Type": "Backup",
297s     "Level": "Full",
297s     "Messages": "Standard",
297s     "Storage": ["File1"],
297s     "Pool": "File",
297s     "Client": "autopkgtest-fd",
297s     "Fileset": "Catalog",
297s     "Schedule": "WeeklyCycleAfterBackup",
297s     "JobDefs": "DefaultJob",
297s     "WriteBootstrap": "/var/lib/bacula/%n.bsr",
297s     "SpoolAttributes": true,
297s     "Runscript": [
297s       {
297s         "RunsWhen": "Before",
297s         "RunsOnClient": false,
297s         "Command": "/etc/bacula/scripts/make_catalog_backup.pl MyCatalog"
297s       },
297s       {
297s         "RunsWhen": "After",
297s         "RunsOnClient": false,
297s         "Command": "/etc/bacula/scripts/delete_catalog_backup"
297s       }
297s     ]
297s ,
297s     "Priority": 11
297s   }
297s },
297s {
297s   "Job": {
297s     "Name": "BackupClient1",
297s     "Type": "Backup",
297s     "Level": "Incremental",
297s     "Messages": "Standard",
297s     "Storage": ["File1"],
297s     "Pool": "File",
297s     "Client": "autopkgtest-fd",
297s     "Fileset": "Full Set",
297s     "Schedule": "WeeklyCycle",
297s     "JobDefs": "DefaultJob",
297s     "WriteBootstrap": "/var/lib/bacula/%c.bsr",
297s     "SpoolAttributes": true,
297s     "Priority": 10
297s   }
297s },
297s {
297s   "Job": {
297s     "Name": "RestoreFiles",
297s     "Type": "Restore",
297s     "Messages": "Standard",
297s     "Storage": ["File1"],
297s     "Pool": "File",
297s     "Client": "autopkgtest-fd",
297s     "Fileset": "Full Set",
297s     "Where": "/nonexistent/path/to/file/archive/dir/bacula-restores"
297s   }
297s },
297s {
297s   "Storage": {
297s     "Name": "File1",
297s     "SdPort": 9103,
297s     "Address": "localhost",
297s     "Password": "NDCkR9BfwuAAN0HO8Z3DEFSeWFzM9QDa9",
297s     "Device": ["FileChgr1"],
297s     "MediaType": "File1",
297s     "Autochanger": "File1",
297s     "MaximumConcurrentJobs": 10
297s   }
297s },
297s {
297s   "Storage": {
297s     "Name": "File2",
297s     "SdPort": 9103,
297s     "Address": "localhost",
297s     "Password": "NDCkR9BfwuAAN0HO8Z3DEFSeWFzM9QDa9",
297s     "Device": ["FileChgr2"],
297s     "MediaType": "File2",
297s     "Autochanger": "File2",
297s     "MaximumConcurrentJobs": 10
297s   }
297s },
297s {
297s   "Catalog": {
297s     "Name": "MyCatalog",
297s     "Address": "localhost",
297s     "Password": "OLKPx8MRFcUQ",
297s     "User": "bacula",
297s     "DbName": "bacula"
297s   }
297s },
297s {
297s   "Schedule": {
297s     "Name": "WeeklyCycle",
297s     "Run": [
297s      {
297s       "Level": "Full",
297s       "Level": "Full",
297s       "Level": "Full",
297s       "Hour": [23],
297s       "Minute": 5,
297s       "Day": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30],
297s       "Month": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11],
297s       "DayOfWeek": [0],
297s       "WeekOfMonth": [0],
297s       "WeekOfYear": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31, 32, 33, 34, 35, 36, 37, 38, 39, 40, 41, 42, 43, 44, 45, 46, 47, 48, 49, 50, 51, 52, 53]
297s      },
297s      {
297s       "Level": "Differential",
297s       "Level": "Differential",
297s       "Level": "Differential",
297s       "Hour": [23],
297s       "Minute": 5,
297s       "Day": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30],
297s       "Month": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11],
297s       "DayOfWeek": [0],
297s       "WeekOfMonth": [1, 2, 3, 4],
297s       "WeekOfYear": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31, 32, 33, 34, 35, 36, 37, 38, 39, 40, 41, 42, 43, 44, 45, 46, 47, 48, 49, 50, 51, 52, 53]
297s      },
297s      {
297s       "Level": "Incremental",
297s       "Level": "Incremental",
297s       "Level": "Incremental",
297s       "Hour": [23],
297s       "Minute": 5,
297s       "Day": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30],
297s       "Month": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11],
297s       "DayOfWeek": [1, 2, 3, 4, 5, 6],
297s       "WeekOfMonth": [0, 1, 2, 3, 4, 5],
297s       "WeekOfYear": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31, 32, 33, 34, 35, 36, 37, 38, 39, 40, 41, 42, 43, 44, 45, 46, 47, 48, 49, 50, 51, 52, 53]
297s      }
297s     ]
297s   }
297s },
297s {
297s   "Schedule": {
297s     "Name": "WeeklyCycleAfterBackup",
297s     "Run": [
297s      {
297s       "Level": "Full",
297s       "Level": "Full",
297s       "Level": "Full",
297s       "Hour": [23],
297s       "Minute": 10,
297s       "Day": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30],
297s       "Month": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11],
297s       "DayOfWeek": [0, 1, 2, 3, 4, 5, 6],
297s       "WeekOfMonth": [0, 1, 2, 3, 4, 5],
297s       "WeekOfYear": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31, 32, 33, 34, 35, 36, 37, 38, 39, 40, 41, 42, 43, 44, 45, 46, 47, 48, 49, 50, 51, 52, 53]
297s      }
297s     ]
297s   }
297s },
297s {
297s   "Fileset": {
297s     "Name": "Catalog",
297s     "Include": [{
297s       "File": ["/var/lib/bacula/bacula.sql"],
297s       "Options": [ 
297s        {
297s          "Signature": "Md5"
297s        }
297s       ]
297s     }]
297s   }
297s },
297s {
297s   "Fileset": {
297s     "Name": "Full Set",
297s     "Include": [{
297s       "File": ["/usr/sbin"],
297s       "Options": [ 
297s        {
297s          "Signature": "Md5"
297s        }
297s       ]
297s     }],
297s     "Exclude": {
297s       "File":  ["/var/lib/bacula", "/nonexistent/path/to/file/archive/dir", "/proc", "/tmp", "/sys", "/.journal", "/.fsck"]
297s     }
297s   }
297s },
297s {
297s   "Pool": {
297s     "Name": "Default",
297s     "PoolType": "Backup",
297s     "MaximumVolumes": 100,
297s     "MaximumVolumeBytes": 53687091200,
297s     "VolumeRetention": 31536000,
297s     "AutoPrune": true,
297s     "Recycle": true
297s   }
297s },
297s {
297s   "Pool": {
297s     "Name": "File",
297s     "PoolType": "Backup",
297s     "LabelFormat": "Vol-",
297s     "MaximumVolumes": 100,
297s     "MaximumVolumeBytes": 53687091200,
297s     "VolumeRetention": 31536000,
297s     "AutoPrune": true,
297s     "Recycle": true
297s   }
297s },
297s {
297s   "Pool": {
297s     "Name": "Scratch",
297s     "PoolType": "Backup"
297s   }
297s },
297s {
297s   "Messages": {
297s     "Name": "Daemon",
297s     "MailCommand": "/usr/sbin/bsmtp -h localhost -f \"(Bacula) <%r>\" -s \"Bacula daemon message\" %r",
297s     "Destinations": [
297s       {
297s         "Type": "Mail",
297s         "MsgTypes": ["All","!Skipped"],
297s         "Where": ["root"],
297s         "Command": "/usr/sbin/bsmtp -h localhost -f \"(Bacula) <%r>\" -s \"Bacula daemon message\" %r"
297s       },
297s       {
297s         "Type": "Append",
297s         "MsgTypes": ["All","!Skipped"],
297s         "Where": ["/var/log/bacula/bacula.log"]
297s       },
297s       {
297s         "Type": "Console",
297s         "MsgTypes": ["All","!Skipped"]
297s       }
297s     ]
297s   }
297s },
297s {
297s   "Messages": {
297s     "Name": "Standard",
297s     "MailCommand": "/usr/sbin/bsmtp -h localhost -f \"(Bacula) <%r>\" -s \"Bacula: %t %e of %c %l\" %r",
297s     "OperatorCommand": "/usr/sbin/bsmtp -h localhost -f \"(Bacula) <%r>\" -s \"Bacula: Intervention needed for %j\" %r",
297s     "Destinations": [
297s       {
297s         "Type": "Mail",
297s         "MsgTypes": ["All","!Skipped"],
297s         "Where": ["root"],
297s         "Command": "/usr/sbin/bsmtp -h localhost -f \"(Bacula) <%r>\" -s \"Bacula: %t %e of %c %l\" %r"
297s       },
297s       {
297s         "Type": "Append",
297s         "MsgTypes": ["All","!Skipped"],
297s         "Where": ["/var/log/bacula/bacula.log"]
297s       },
297s       {
297s         "Type": "Console",
297s         "MsgTypes": ["All","!Skipped"]
297s       },
297s       {
297s         "Type": "Operator",
297s         "MsgTypes": ["Mount"],
297s         "Where": ["root"],
297s         "Command": "/usr/sbin/bsmtp -h localhost -f \"(Bacula) <%r>\" -s \"Bacula: Intervention needed for %j\" %r"
297s       },
297s       {
297s         "Type": "Catalog",
297s         "MsgTypes": ["All"]
297s       }
297s     ]
297s   }
297s },
297s {
297s   "Console": {
297s     "Name": "autopkgtest-mon",
297s     "Password": "FEzSI7CFe6_EW-_hNOH-f5Fn6rs_8I-xn",
297s     "CommandAcl": ["status", ".status"]
297s   }
297s },
297s {
297s   "JobDefs": {
297s     "Name": "DefaultJob",
297s     "Type": "Backup",
297s     "Level": "Incremental",
297s     "Messages": "Standard",
297s     "Storage": ["File1"],
297s     "Pool": "File",
297s     "Client": "autopkgtest-fd",
297s     "Fileset": "Full Set",
297s     "Schedule": "WeeklyCycle",
297s     "WriteBootstrap": "/var/lib/bacula/%c.bsr",
297s     "SpoolAttributes": true,
297s     "Priority": 10
297s   }
297s }
297s ]
297s + echo
297s 
297s + echo '---- Testing /usr/sbin/bfdjson ----'
297s ---- Testing /usr/sbin/bfdjson ----
297s + /usr/sbin/bfdjson
297s [{
297s   "Director": {
297s     "Name": "autopkgtest-dir",
297s     "Password": "hVDqA2NOvmyBQ-6p30qZueujCp7V8Po7u"
297s   }
297s },
297s {
297s   "Director": {
297s     "Name": "autopkgtest-mon",
297s     "Password": "KsbVOGHS-TLzeSjbvar-GQTLyOeAx7nmv",
297s     "Monitor": true
297s   }
297s },
297s {
297s   "FileDaemon": {
297s     "Name": "autopkgtest-fd",
297s     "FdAddress": "127.0.0.1",
297s     "WorkingDirectory": "/var/lib/bacula",
297s     "PidDirectory": "/run/bacula",
297s     "PluginDirectory": "/usr/lib/bacula",
297s     "MaximumConcurrentJobs": 20
297s   }
297s },
297s {
297s   "Messages": {
297s     "Name": "Standard",
297s     "Destinations": [
297s       {
297s         "Type": "Director",
297s         "MsgTypes": ["All","!Skipped","!Restored","!Verified"],
297s         "Where": ["autopkgtest-dir"]
297s       }
297s     ]
297s   }
297s }
297s ]
297s + echo
297s 
297s + echo '---- Testing /usr/sbin/bsdjson ----'
297s ---- Testing /usr/sbin/bsdjson ----
297s + /usr/sbin/bsdjson
297s [
297s {
297s   "Director": {
297s     "Name": "autopkgtest-dir",
297s     "Password": "NDCkR9BfwuAAN0HO8Z3DEFSeWFzM9QDa9"
297s   }
297s },
297s {
297s   "Director": {
297s     "Name": "autopkgtest-mon",
297s     "Password": "q5DtosXpbHTXsm1T-aHWFEmkM8U7jNAZi",
297s     "Monitor": true
297s   }
297s },
297s {
297s   "Storage": {
297s     "Name": "autopkgtest-sd",
297s     "SdAddress": "127.0.0.1",
297s     "WorkingDirectory": "/var/lib/bacula",
297s     "PidDirectory": "/run/bacula",
297s     "PluginDirectory": "/usr/lib/bacula",
297s     "MaximumConcurrentJobs": 20
297s   }
297s },
297s {
297s   "Device": {
297s     "Name": "FileChgr1-Dev1",
297s     "MediaType": "File1",
297s     "ArchiveDevice": "/nonexistent/path/to/file/archive/dir",
297s     "RemovableMedia": false,
297s     "RandomAccess": true,
297s     "AutomaticMount": true,
297s     "LabelMedia": true,
297s     "AlwaysOpen": false,
297s     "MaximumConcurrentJobs": 5
297s   }
297s },
297s {
297s   "Device": {
297s     "Name": "FileChgr1-Dev2",
297s     "MediaType": "File1",
297s     "ArchiveDevice": "/nonexistent/path/to/file/archive/dir",
297s     "RemovableMedia": false,
297s     "RandomAccess": true,
297s     "AutomaticMount": true,
297s     "LabelMedia": true,
297s     "AlwaysOpen": false,
297s     "MaximumConcurrentJobs": 5
297s   }
297s },
297s {
297s   "Device": {
297s     "Name": "FileChgr2-Dev1",
297s     "MediaType": "File2",
297s     "ArchiveDevice": "/nonexistent/path/to/file/archive/dir",
297s     "RemovableMedia": false,
297s     "RandomAccess": true,
297s     "AutomaticMount": true,
297s     "LabelMedia": true,
297s     "AlwaysOpen": false,
297s     "MaximumConcurrentJobs": 5
297s   }
297s },
297s {
297s   "Device": {
297s     "Name": "FileChgr2-Dev2",
297s     "MediaType": "File2",
297s     "ArchiveDevice": "/nonexistent/path/to/file/archive/dir",
297s     "RemovableMedia": false,
297s     "RandomAccess": true,
297s     "AutomaticMount": true,
297s     "LabelMedia": true,
297s     "AlwaysOpen": false,
297s     "MaximumConcurrentJobs": 5
297s   }
297s },
297s {
297s   "Messages": {
297s     "Name": "Standard",
297s     "Destinations": [
297s       {
297s         "Type": "Director",
297s         "MsgTypes": ["All"],
297s         "Where": ["autopkgtest-dir"]
297s       }
297s     ]
297s   }
297s },
297s {
297s   "Autochanger": {
297s     "Name": "FileChgr1",
297s     "Device": ["FileChgr1-Dev1", "FileChgr1-Dev2"],
297s     "ChangerDevice": "/dev/null",
297s     "ChangerCommand": ""
297s   }
297s },
297s {
297s   "Autochanger": {
297s     "Name": "FileChgr2",
297s     "Device": ["FileChgr2-Dev1", "FileChgr2-Dev2"],
297s     "ChangerDevice": "/dev/null",
297s     "ChangerCommand": ""
297s   }
297s }
297s ]
297s autopkgtest [08:41:07]: test program-test-pgsql: -----------------------]
298s autopkgtest [08:41:08]: test program-test-pgsql:  - - - - - - - - - - results - - - - - - - - - -
298s program-test-pgsql   PASS
298s autopkgtest [08:41:08]: test backup-test-mysql: preparing testbed
390s autopkgtest [08:42:40]: testbed dpkg architecture: s390x
390s autopkgtest [08:42:40]: testbed apt version: 3.0.0
390s autopkgtest [08:42:40]: @@@@@@@@@@@@@@@@@@@@ test bed setup
390s autopkgtest [08:42:40]: testbed release detected to be: questing
391s autopkgtest [08:42:41]: updating testbed package index (apt update)
391s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [110 kB]
392s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease
392s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease
392s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease
392s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [44.4 kB]
392s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [175 kB]
392s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [2076 kB]
392s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main s390x Packages [208 kB]
392s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/universe s390x Packages [1079 kB]
392s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/multiverse s390x Packages [9148 B]
393s Fetched 3701 kB in 1s (3088 kB/s)
393s Reading package lists...
394s autopkgtest [08:42:44]: upgrading testbed (apt dist-upgrade and autopurge)
394s Reading package lists...
394s Building dependency tree...
394s Reading state information...
394s Calculating upgrade...Starting pkgProblemResolver with broken count: 0
394s Starting 2 pkgProblemResolver with broken count: 0
394s Done
394s Entering ResolveByKeep
394s 
395s Calculating upgrade...
395s The following packages will be upgraded:
395s   htop nano ucf
395s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
395s Need to get 532 kB of archives.
395s After this operation, 4096 B of additional disk space will be used.
395s Get:1 http://ftpmaster.internal/ubuntu questing-proposed/main s390x ucf all 3.0051 [43.6 kB]
395s Get:2 http://ftpmaster.internal/ubuntu questing/main s390x nano s390x 8.4-1 [299 kB]
395s Get:3 http://ftpmaster.internal/ubuntu questing/main s390x htop s390x 3.4.1-4 [189 kB]
395s Preconfiguring packages ...
395s Fetched 532 kB in 1s (995 kB/s)
396s (Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 81472 files and directories currently installed.)
396s Preparing to unpack .../archives/ucf_3.0051_all.deb ...
396s Unpacking ucf (3.0051) over (3.0050) ...
396s Preparing to unpack .../archives/nano_8.4-1_s390x.deb ...
396s Unpacking nano (8.4-1) over (8.3-1) ...
396s Preparing to unpack .../htop_3.4.1-4_s390x.deb ...
396s Unpacking htop (3.4.1-4) over (3.4.0-2) ...
396s Setting up htop (3.4.1-4) ...
396s Setting up ucf (3.0051) ...
396s Setting up nano (8.4-1) ...
396s Installing new version of config file /etc/nanorc ...
396s Processing triggers for man-db (2.13.0-1) ...
396s Processing triggers for install-info (7.1.1-1) ...
396s Reading package lists...
397s Building dependency tree...
397s Reading state information...
397s Starting pkgProblemResolver with broken count: 0
397s Starting 2 pkgProblemResolver with broken count: 0
397s Done
397s Solving dependencies...
397s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
399s Reading package lists...
400s Building dependency tree...
400s Reading state information...
400s Starting pkgProblemResolver with broken count: 0
400s Starting 2 pkgProblemResolver with broken count: 0
400s Done
400s The following NEW packages will be installed:
400s   bacula bacula-bscan bacula-client bacula-common bacula-common-mysql
400s   bacula-console bacula-director bacula-director-mysql bacula-fd bacula-sd
400s   bacula-server bsd-mailx dbconfig-common dbconfig-mysql dbconfig-pgsql
400s   default-mysql-client default-mysql-server liblockfile-bin liblockfile1
400s   libmecab2 libmysqlclient24 libpq5 libprotobuf-lite32t64 mtx mysql-client
400s   mysql-client-core mysql-common mysql-server mysql-server-core postfix
400s   postgresql-client postgresql-client-17 postgresql-client-common
400s 0 upgraded, 33 newly installed, 0 to remove and 0 not upgraded.
400s Need to get 30.8 MB of archives.
400s After this operation, 205 MB of additional disk space will be used.
400s Get:1 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-common s390x 13.0.4-4build1 [854 kB]
400s Get:2 http://ftpmaster.internal/ubuntu questing/main s390x mysql-common all 5.8+1.1.1ubuntu1 [6922 B]
400s Get:3 http://ftpmaster.internal/ubuntu questing/main s390x libmysqlclient24 s390x 8.4.4-0ubuntu2 [1295 kB]
400s Get:4 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-common-mysql s390x 13.0.4-4build1 [12.2 kB]
400s Get:5 http://ftpmaster.internal/ubuntu questing/universe s390x dbconfig-common all 2.0.24 [596 kB]
400s Get:6 http://ftpmaster.internal/ubuntu questing/main s390x mysql-client-core s390x 8.4.4-0ubuntu2 [2222 kB]
401s Get:7 http://ftpmaster.internal/ubuntu questing/main s390x mysql-client s390x 8.4.4-0ubuntu2 [9122 B]
401s Get:8 http://ftpmaster.internal/ubuntu questing/universe s390x default-mysql-client all 1.1.1ubuntu1 [3072 B]
401s Get:9 http://ftpmaster.internal/ubuntu questing/universe s390x dbconfig-mysql all 2.0.24 [938 B]
401s Get:10 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-director-mysql all 13.0.4-4build1 [32.3 kB]
401s Get:11 http://ftpmaster.internal/ubuntu questing/main s390x postfix s390x 3.9.1-10ubuntu1 [1305 kB]
401s Get:12 http://ftpmaster.internal/ubuntu questing/main s390x liblockfile-bin s390x 1.17-2 [11.5 kB]
401s Get:13 http://ftpmaster.internal/ubuntu questing/main s390x liblockfile1 s390x 1.17-2 [6970 B]
401s Get:14 http://ftpmaster.internal/ubuntu questing/main s390x bsd-mailx s390x 8.1.2-0.20220412cvs-1build1 [69.7 kB]
401s Get:15 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-director s390x 13.0.4-4build1 [379 kB]
401s Get:16 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-fd s390x 13.0.4-4build1 [144 kB]
401s Get:17 http://ftpmaster.internal/ubuntu questing/main s390x mtx s390x 1.3.12-18 [43.2 kB]
401s Get:18 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-sd s390x 13.0.4-4build1 [151 kB]
401s Get:19 http://ftpmaster.internal/ubuntu questing/main s390x libmecab2 s390x 0.996-15.1build2 [214 kB]
401s Get:20 http://ftpmaster.internal/ubuntu questing/main s390x libprotobuf-lite32t64 s390x 3.21.12-10build2 [238 kB]
401s Get:21 http://ftpmaster.internal/ubuntu questing/main s390x mysql-server-core s390x 8.4.4-0ubuntu2 [20.1 MB]
402s Get:22 http://ftpmaster.internal/ubuntu questing/main s390x mysql-server s390x 8.4.4-0ubuntu2 [1369 kB]
402s Get:23 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-console s390x 13.0.4-4build1 [28.6 kB]
402s Get:24 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-client all 13.0.4-4build1 [23.5 kB]
402s Get:25 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-bscan s390x 13.0.4-4build1 [24.7 kB]
402s Get:26 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-server all 13.0.4-4build1 [23.4 kB]
402s Get:27 http://ftpmaster.internal/ubuntu questing/universe s390x bacula all 13.0.4-4build1 [1036 B]
402s Get:28 http://ftpmaster.internal/ubuntu questing/main s390x libpq5 s390x 17.4-1 [147 kB]
402s Get:29 http://ftpmaster.internal/ubuntu questing/main s390x postgresql-client-common all 274 [47.6 kB]
402s Get:30 http://ftpmaster.internal/ubuntu questing/main s390x postgresql-client-17 s390x 17.4-1 [1367 kB]
402s Get:31 http://ftpmaster.internal/ubuntu questing/main s390x postgresql-client all 17+274 [13.3 kB]
402s Get:32 http://ftpmaster.internal/ubuntu questing/universe s390x dbconfig-pgsql all 2.0.24 [914 B]
402s Get:33 http://ftpmaster.internal/ubuntu questing/universe s390x default-mysql-server all 1.1.1ubuntu1 [3088 B]
402s Preconfiguring packages ...
402s Fetched 30.8 MB in 2s (15.4 MB/s)
402s Selecting previously unselected package bacula-common.
402s (Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 81472 files and directories currently installed.)
402s Preparing to unpack .../00-bacula-common_13.0.4-4build1_s390x.deb ...
402s Adding user 'bacula'... Ok.
402s Unpacking bacula-common (13.0.4-4build1) ...
402s Selecting previously unselected package mysql-common.
402s Preparing to unpack .../01-mysql-common_5.8+1.1.1ubuntu1_all.deb ...
402s Unpacking mysql-common (5.8+1.1.1ubuntu1) ...
402s Selecting previously unselected package libmysqlclient24:s390x.
402s Preparing to unpack .../02-libmysqlclient24_8.4.4-0ubuntu2_s390x.deb ...
402s Unpacking libmysqlclient24:s390x (8.4.4-0ubuntu2) ...
402s Selecting previously unselected package bacula-common-mysql.
402s Preparing to unpack .../03-bacula-common-mysql_13.0.4-4build1_s390x.deb ...
402s Unpacking bacula-common-mysql (13.0.4-4build1) ...
402s Selecting previously unselected package dbconfig-common.
402s Preparing to unpack .../04-dbconfig-common_2.0.24_all.deb ...
402s Unpacking dbconfig-common (2.0.24) ...
402s Selecting previously unselected package mysql-client-core.
402s Preparing to unpack .../05-mysql-client-core_8.4.4-0ubuntu2_s390x.deb ...
402s Unpacking mysql-client-core (8.4.4-0ubuntu2) ...
403s Selecting previously unselected package mysql-client.
403s Preparing to unpack .../06-mysql-client_8.4.4-0ubuntu2_s390x.deb ...
403s Unpacking mysql-client (8.4.4-0ubuntu2) ...
403s Selecting previously unselected package default-mysql-client.
403s Preparing to unpack .../07-default-mysql-client_1.1.1ubuntu1_all.deb ...
403s Unpacking default-mysql-client (1.1.1ubuntu1) ...
403s Selecting previously unselected package dbconfig-mysql.
403s Preparing to unpack .../08-dbconfig-mysql_2.0.24_all.deb ...
403s Unpacking dbconfig-mysql (2.0.24) ...
403s Selecting previously unselected package bacula-director-mysql.
403s Preparing to unpack .../09-bacula-director-mysql_13.0.4-4build1_all.deb ...
403s Unpacking bacula-director-mysql (13.0.4-4build1) ...
403s Selecting previously unselected package postfix.
403s Preparing to unpack .../10-postfix_3.9.1-10ubuntu1_s390x.deb ...
403s Unpacking postfix (3.9.1-10ubuntu1) ...
403s Selecting previously unselected package liblockfile-bin.
403s Preparing to unpack .../11-liblockfile-bin_1.17-2_s390x.deb ...
403s Unpacking liblockfile-bin (1.17-2) ...
403s Selecting previously unselected package liblockfile1:s390x.
403s Preparing to unpack .../12-liblockfile1_1.17-2_s390x.deb ...
403s Unpacking liblockfile1:s390x (1.17-2) ...
403s Selecting previously unselected package bsd-mailx.
403s Preparing to unpack .../13-bsd-mailx_8.1.2-0.20220412cvs-1build1_s390x.deb ...
403s Unpacking bsd-mailx (8.1.2-0.20220412cvs-1build1) ...
403s Selecting previously unselected package bacula-director.
403s Preparing to unpack .../14-bacula-director_13.0.4-4build1_s390x.deb ...
403s Unpacking bacula-director (13.0.4-4build1) ...
403s Selecting previously unselected package bacula-fd.
403s Preparing to unpack .../15-bacula-fd_13.0.4-4build1_s390x.deb ...
403s Unpacking bacula-fd (13.0.4-4build1) ...
403s Selecting previously unselected package mtx.
403s Preparing to unpack .../16-mtx_1.3.12-18_s390x.deb ...
403s Unpacking mtx (1.3.12-18) ...
403s Selecting previously unselected package bacula-sd.
403s Preparing to unpack .../17-bacula-sd_13.0.4-4build1_s390x.deb ...
403s Unpacking bacula-sd (13.0.4-4build1) ...
403s Selecting previously unselected package libmecab2:s390x.
403s Preparing to unpack .../18-libmecab2_0.996-15.1build2_s390x.deb ...
403s Unpacking libmecab2:s390x (0.996-15.1build2) ...
403s Selecting previously unselected package libprotobuf-lite32t64:s390x.
403s Preparing to unpack .../19-libprotobuf-lite32t64_3.21.12-10build2_s390x.deb ...
403s Unpacking libprotobuf-lite32t64:s390x (3.21.12-10build2) ...
403s Selecting previously unselected package mysql-server-core.
403s Preparing to unpack .../20-mysql-server-core_8.4.4-0ubuntu2_s390x.deb ...
403s Unpacking mysql-server-core (8.4.4-0ubuntu2) ...
403s Setting up mysql-common (5.8+1.1.1ubuntu1) ...
403s update-alternatives: using /etc/mysql/my.cnf.fallback to provide /etc/mysql/my.cnf (my.cnf) in auto mode
403s Selecting previously unselected package mysql-server.
403s (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 ... 82430 files and directories currently installed.)
403s Preparing to unpack .../00-mysql-server_8.4.4-0ubuntu2_s390x.deb ...
404s Unpacking mysql-server (8.4.4-0ubuntu2) ...
404s Selecting previously unselected package bacula-console.
404s Preparing to unpack .../01-bacula-console_13.0.4-4build1_s390x.deb ...
404s Unpacking bacula-console (13.0.4-4build1) ...
404s Selecting previously unselected package bacula-client.
404s Preparing to unpack .../02-bacula-client_13.0.4-4build1_all.deb ...
404s Unpacking bacula-client (13.0.4-4build1) ...
404s Selecting previously unselected package bacula-bscan.
404s Preparing to unpack .../03-bacula-bscan_13.0.4-4build1_s390x.deb ...
404s Unpacking bacula-bscan (13.0.4-4build1) ...
404s Selecting previously unselected package bacula-server.
404s Preparing to unpack .../04-bacula-server_13.0.4-4build1_all.deb ...
404s Unpacking bacula-server (13.0.4-4build1) ...
404s Selecting previously unselected package bacula.
404s Preparing to unpack .../05-bacula_13.0.4-4build1_all.deb ...
404s Unpacking bacula (13.0.4-4build1) ...
404s Selecting previously unselected package libpq5:s390x.
404s Preparing to unpack .../06-libpq5_17.4-1_s390x.deb ...
404s Unpacking libpq5:s390x (17.4-1) ...
404s Selecting previously unselected package postgresql-client-common.
404s Preparing to unpack .../07-postgresql-client-common_274_all.deb ...
404s Unpacking postgresql-client-common (274) ...
404s Selecting previously unselected package postgresql-client-17.
404s Preparing to unpack .../08-postgresql-client-17_17.4-1_s390x.deb ...
404s Unpacking postgresql-client-17 (17.4-1) ...
404s Selecting previously unselected package postgresql-client.
404s Preparing to unpack .../09-postgresql-client_17+274_all.deb ...
404s Unpacking postgresql-client (17+274) ...
404s Selecting previously unselected package dbconfig-pgsql.
404s Preparing to unpack .../10-dbconfig-pgsql_2.0.24_all.deb ...
404s Unpacking dbconfig-pgsql (2.0.24) ...
404s Selecting previously unselected package default-mysql-server.
404s Preparing to unpack .../11-default-mysql-server_1.1.1ubuntu1_all.deb ...
404s Unpacking default-mysql-server (1.1.1ubuntu1) ...
404s Setting up libprotobuf-lite32t64:s390x (3.21.12-10build2) ...
404s Setting up postgresql-client-common (274) ...
404s Setting up libmecab2:s390x (0.996-15.1build2) ...
404s Setting up liblockfile-bin (1.17-2) ...
404s Setting up libpq5:s390x (17.4-1) ...
404s Setting up mtx (1.3.12-18) ...
404s Setting up dbconfig-common (2.0.24) ...
404s Creating config file /etc/dbconfig-common/config with new version
404s Setting up libmysqlclient24:s390x (8.4.4-0ubuntu2) ...
404s Setting up bacula-common (13.0.4-4build1) ...
404s Setting up bacula-sd (13.0.4-4build1) ...
404s Creating config file /etc/default/bacula-sd with new version
404s Creating config file /etc/bacula/bacula-sd.conf with new version
405s Created symlink '/etc/systemd/system/multi-user.target.wants/bacula-sd.service' → '/usr/lib/systemd/system/bacula-sd.service'.

405s Setting up mysql-server-core (8.4.4-0ubuntu2) ...
405s Setting up bacula-console (13.0.4-4build1) ...
405s Creating config file /etc/bacula/bconsole.conf with new version
405s Setting up postfix (3.9.1-10ubuntu1) ...
405s Created symlink '/etc/systemd/system/multi-user.target.wants/postfix.service' → '/usr/lib/systemd/system/postfix.service'.

405s info: Selecting UID from range 100 to 999 ...
405s 
405s info: Selecting GID from range 100 to 999 ...
405s info: Adding system user `postfix' (UID 109) ...
405s info: Adding new group `postfix' (GID 114) ...
405s info: Adding new user `postfix' (UID 109) with group `postfix' ...
405s info: Not creating home directory `/var/spool/postfix'.
405s info: Selecting GID from range 100 to 999 ...
405s info: Adding group `postdrop' (GID 115) ...
405s Creating /etc/postfix/dynamicmaps.cf
405s setting myhostname: autopkgtest.local
405s setting alias maps
405s setting alias database
405s changing /etc/mailname to autopkgtest.local
405s setting myorigin
405s setting destinations: $myhostname, autopkgtest.local, localhost.local, , localhost
405s setting relayhost: 
405s setting mynetworks: 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128
405s clearing mailbox_command
405s setting mailbox_size_limit: 0
405s setting recipient_delimiter: +
407s setting inet_interfaces: all
409s setting inet_protocols: all
409s /etc/aliases does not exist, creating it.
409s WARNING: /etc/aliases exists, but does not have a root alias.
409s 
409s Postfix (main.cf) is now set up with a default configuration.  If you need to 
409s make changes, edit /etc/postfix/main.cf (and others) as needed.  To view 
409s Postfix configuration values, see postconf(1).
409s 
409s After modifying main.cf, be sure to run 'systemctl reload postfix'.
409s 
411s Setting up mysql-client-core (8.4.4-0ubuntu2) ...
411s Setting up liblockfile1:s390x (1.17-2) ...
411s Setting up bacula-fd (13.0.4-4build1) ...
411s Creating config file /etc/default/bacula-fd with new version
411s Creating config file /etc/bacula/bacula-fd.conf with new version
412s Created symlink '/etc/systemd/system/multi-user.target.wants/bacula-fd.service' → '/usr/lib/systemd/system/bacula-fd.service'.

412s Setting up mysql-client (8.4.4-0ubuntu2) ...
412s Setting up bacula-client (13.0.4-4build1) ...
412s Setting up bacula-common-mysql (13.0.4-4build1) ...
412s Setting up postgresql-client-17 (17.4-1) ...
412s 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
412s Setting up dbconfig-pgsql (2.0.24) ...
412s Setting up dbconfig-mysql (2.0.24) ...
412s Setting up bsd-mailx (8.1.2-0.20220412cvs-1build1) ...
412s update-alternatives: using /usr/bin/bsd-mailx to provide /usr/bin/mailx (mailx) in auto mode
412s Setting up bacula-director-mysql (13.0.4-4build1) ...
412s dbconfig-common: writing config to /etc/dbconfig-common/bacula-director-mysql.conf
412s Creating config file /etc/dbconfig-common/bacula-director-mysql.conf with new version
412s ERROR 2002 (HY000): Can't connect to local MySQL server through socket '/var/run/mysqld/mysqld.sock' (2).
412s unable to connect to mysql server.
412s error encountered creating user:
412s ERROR 2002 (HY000): Can't connect to local MySQL server through socket '/var/run/mysqld/mysqld.sock' (2)
412s dbconfig-common: bacula-director-mysql configure: noninteractive fail.
412s dbconfig-common: bacula-director-mysql configure: ignoring errors from here forwards
412s populating database via sql...  done.
412s dbconfig-common: flushing administrative password
412s Setting up bacula-director (13.0.4-4build1) ...
412s Creating config file /etc/default/bacula-dir with new version
412s Creating config file /etc/bacula/bacula-dir.conf with new version
413s Creating config file /etc/bacula/scripts/delete_catalog_backup with new version
413s Creating config file /etc/bacula/scripts/make_catalog_backup with new version
413s Created symlink '/etc/systemd/system/bacula-dir.service' → '/usr/lib/systemd/system/bacula-director.service'.

413s Created symlink '/etc/systemd/system/multi-user.target.wants/bacula-director.service' → '/usr/lib/systemd/system/bacula-director.service'.

443s Could not execute systemctl:  at /usr/bin/deb-systemd-invoke line 148.
443s Setting up bacula-bscan (13.0.4-4build1) ...
443s Setting up bacula-server (13.0.4-4build1) ...
443s Setting up default-mysql-client (1.1.1ubuntu1) ...
443s Setting up mysql-server (8.4.4-0ubuntu2) ...
444s update-alternatives: using /etc/mysql/mysql.cnf to provide /etc/mysql/my.cnf (my.cnf) in auto mode
444s Renaming removed key_buffer and myisam-recover options (if present)
449s Created symlink '/etc/systemd/system/multi-user.target.wants/mysql.service' → '/usr/lib/systemd/system/mysql.service'.

450s Setting up postgresql-client (17+274) ...
450s Setting up bacula (13.0.4-4build1) ...
450s Setting up default-mysql-server (1.1.1ubuntu1) ...
450s Processing triggers for libc-bin (2.41-6ubuntu1) ...
450s Processing triggers for rsyslog (8.2412.0-2ubuntu2) ...
450s Processing triggers for ufw (0.36.2-9) ...
450s Processing triggers for man-db (2.13.0-1) ...
451s Processing triggers for postfix (3.9.1-10ubuntu1) ...
451s Restarting postfix
456s autopkgtest [08:43:46]: test backup-test-mysql: [-----------------------
456s + apt-get -y install debconf-utils
456s Reading package lists...
457s Building dependency tree...
457s Reading state information...
457s Solving dependencies...
457s The following NEW packages will be installed:
457s   debconf-utils
457s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded.
457s Need to get 49.5 kB of archives.
457s After this operation, 99.3 kB of additional disk space will be used.
457s Get:1 http://ftpmaster.internal/ubuntu questing/universe s390x debconf-utils all 1.5.87ubuntu1 [49.5 kB]
457s Fetched 49.5 kB in 0s (175 kB/s)
457s Selecting previously unselected package debconf-utils.
457s (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 ... 82798 files and directories currently installed.)
457s Preparing to unpack .../debconf-utils_1.5.87ubuntu1_all.deb ...
457s Unpacking debconf-utils (1.5.87ubuntu1) ...
457s Setting up debconf-utils (1.5.87ubuntu1) ...
457s Processing triggers for man-db (2.13.0-1) ...
458s + debconf-get-selections
458s + awk '$3=="password"{print}'
458s + debconf-set-selections
458s + for pkg in bacula-director-mysql bacula-director-pgsql
458s ++ dpkg-query --showformat '${db:Status-Status}' -W bacula-director-mysql
458s + pkg_status=installed
458s + '[' installed = installed ']'
458s + echo 'bacula-director-mysql bacula-director-mysql/dbconfig-reinstall boolean true'
458s + debconf-set-selections
458s + DEBIAN_FRONTEND=noninteractive
458s + dpkg-reconfigure bacula-director-mysql
458s Determining localhost credentials from /etc/mysql/debian.cnf: succeeded.
458s Determining localhost credentials from /etc/mysql/debian.cnf: succeeded.
458s dbconfig-common: writing config to /etc/dbconfig-common/bacula-director-mysql.conf
458s Replacing config file /etc/dbconfig-common/bacula-director-mysql.conf with new version
458s checking privileges on database bacula for bacula@localhost: user creation needed.
458s granting access to database bacula for bacula@localhost: success.
458s verifying access for bacula@localhost: success.
458s dbconfig-common: dumping mysql database bacula to /var/tmp/bacula-director-mysql.bacula.2025-05-02-08.43.mysql.ZJ5x96.
458s database does not exist.
458s dbconfig-common: dropping old mysql database bacula.
458s dropping database bacula: database does not exist.
458s creating database bacula: success.
459s verifying database bacula exists: success.
459s populating database via sql...  done.
459s dbconfig-common: flushing administrative password
459s + for pkg in bacula-director-mysql bacula-director-pgsql
459s ++ dpkg-query --showformat '${db:Status-Status}' -W bacula-director-pgsql
459s + pkg_status=not-installed
459s + '[' not-installed = installed ']'
459s + echo 'start testing ... '
459s start testing ... 
459s + echo 'USER: root'
459s USER: root
459s + DBTYPE=mysql
459s + echo 'DBTYPE: mysql'
459s DBTYPE: mysql
459s + echo '--------- configuring Bacula daemons -----------'
459s --------- configuring Bacula daemons -----------
459s + FILECHGRDIR=/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr
459s + RESTOREDIR=/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-restores
459s + mkdir -p /tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr
459s + chown -R bacula:tape /tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr
459s + sed -i s%/nonexistent/path/to/file/archive/dir%/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr% /etc/bacula/bacula-sd.conf
459s + sed -i 's%Where = /nonexistent/path/to/file/archive/dir/bacula-restores%Where = /tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-restores%' /etc/bacula/bacula-dir.conf
459s + sed -i 's/signature = MD5/signature = SHA1/' /etc/bacula/bacula-dir.conf
459s + sed -i 's/signature = MD5/signature = SHA1\naclsupport = yes/' /etc/bacula/bacula-dir.conf
459s + echo '--------- restarting services ----------- '
459s --------- restarting services ----------- 
459s + service bacula-director restart
459s + service bacula-sd restart
459s + service bacula-fd restart
459s + sleep 10
469s + echo '--------- checking services ----------- '
469s --------- checking services ----------- 
469s + service bacula-director status
470s ● bacula-director.service - Bacula Director Daemon service
470s      Loaded: loaded (/usr/lib/systemd/system/bacula-director.service; enabled; preset: enabled)
470s      Active: active (running) since Fri 2025-05-02 08:43:49 UTC; 10s ago
470s  Invocation: 530f13f8b6f74e29a0040c43487dfe58
470s        Docs: man:bacula-dir(8)
470s     Process: 5562 ExecStartPre=/usr/sbin/bacula-dir -t -c $CONFIG (code=exited, status=0/SUCCESS)
470s    Main PID: 5565 (bacula-dir)
470s       Tasks: 5 (limit: 4767)
470s      Memory: 2.3M (peak: 2.7M)
470s         CPU: 20ms
470s      CGroup: /system.slice/bacula-director.service
470s              └─5565 /usr/sbin/bacula-dir -fP -c /etc/bacula/bacula-dir.conf
470s 
470s May 02 08:43:49 autopkgtest systemd[1]: Starting bacula-director.service - Bacula Director Daemon service...
470s May 02 08:43:49 autopkgtest bacula-dir[5562]: WARNING: MYSQL_OPT_RECONNECT is deprecated and will be removed in a future version.
470s May 02 08:43:49 autopkgtest systemd[1]: Started bacula-director.service - Bacula Director Daemon service.
470s May 02 08:43:49 autopkgtest bacula-dir[5565]: WARNING: MYSQL_OPT_RECONNECT is deprecated and will be removed in a future version.
470s May 02 08:43:49 autopkgtest bacula-dir[5565]: WARNING: MYSQL_OPT_RECONNECT is deprecated and will be removed in a future version.
470s + service bacula-sd status
470s ● bacula-sd.service - Bacula Storage Daemon service
470s      Loaded: loaded (/usr/lib/systemd/system/bacula-sd.service; enabled; preset: enabled)
470s      Active: active (running) since Fri 2025-05-02 08:43:49 UTC; 10s ago
470s  Invocation: 99f536337a7b49ca8da807c65e150ba6
470s        Docs: man:bacula-sd(8)
470s     Process: 5575 ExecStartPre=/usr/sbin/bacula-sd -t -c $CONFIG (code=exited, status=0/SUCCESS)
470s    Main PID: 5577 (bacula-sd)
470s       Tasks: 3 (limit: 4767)
470s      Memory: 1.9M (peak: 2.2M)
470s         CPU: 16ms
470s      CGroup: /system.slice/bacula-sd.service
470s              └─5577 /usr/sbin/bacula-sd -fP -c /etc/bacula/bacula-sd.conf
470s 
470s May 02 08:43:49 autopkgtest systemd[1]: Starting bacula-sd.service - Bacula Storage Daemon service...
470s May 02 08:43:49 autopkgtest systemd[1]: Started bacula-sd.service - Bacula Storage Daemon service.
470s + service bacula-fd status
470s ● bacula-fd.service - Bacula File Daemon service
470s      Loaded: loaded (/usr/lib/systemd/system/bacula-fd.service; enabled; preset: enabled)
470s      Active: active (running) since Fri 2025-05-02 08:43:49 UTC; 10s ago
470s  Invocation: 63f1f1a9c5424ea18495d9820eb0a827
470s        Docs: man:bacula-fd(8)
470s     Process: 5585 ExecStartPre=/usr/sbin/bacula-fd -t -c $CONFIG (code=exited, status=0/SUCCESS)
470s    Main PID: 5586 (bacula-fd)
470s       Tasks: 3 (limit: 4767)
470s      Memory: 1.6M (peak: 2.1M)
470s         CPU: 13ms
470s      CGroup: /system.slice/bacula-fd.service
470s              └─5586 /usr/sbin/bacula-fd -fP -c /etc/bacula/bacula-fd.conf
470s 
470s May 02 08:43:49 autopkgtest systemd[1]: Starting bacula-fd.service - Bacula File Daemon service...
470s May 02 08:43:49 autopkgtest systemd[1]: Started bacula-fd.service - Bacula File Daemon service.
470s + ps auwwwx
470s + grep '[b]acula'
470s bacula      5565  0.0  0.3 321220 12788 ?        Ssl  08:43   0:00 /usr/sbin/bacula-dir -fP -c /etc/bacula/bacula-dir.conf
470s bacula      5577  0.0  0.2 239820 10668 ?        Ssl  08:43   0:00 /usr/sbin/bacula-sd -fP -c /etc/bacula/bacula-sd.conf
470s root        5586  0.0  0.2 165972 10000 ?        Ssl  08:43   0:00 /usr/sbin/bacula-fd -fP -c /etc/bacula/bacula-fd.conf
470s + echo '----- create some file to test backup / restore ----'
470s ----- create some file to test backup / restore ----
470s + BACKUP_TEST_FILE=/usr/sbin/bacula-backup.test
470s + echo 'bacula restore test'
470s + chown nobody:shadow /usr/sbin/bacula-backup.test
470s + chmod 2755 /usr/sbin/bacula-backup.test
470s + echo '---- status of all daemons ----'
470s ---- status of all daemons ----
470s + echo -e 'status all'
470s + bconsole
470s Connecting to Director localhost:9101
470s 1000 OK: 10002 autopkgtest-dir Version: 13.0.4 (12 February 2024)
470s Enter a period to cancel a command.
470s status all
470s autopkgtest-dir Version: 13.0.4 (12 February 2024) s390x-ibm-linux-gnu ubuntu 25.04
470s Daemon started 02-May-25 08:43, conf reloaded 02-May-2025 08:43:49
470s  Jobs: run=0, running=0 mode=0,0
470s  Crypto: fips=N/A crypto=OpenSSL 3.4.0 22 Oct 2024
470s  Heap: heap=942,080 smbytes=335,465 max_bytes=335,465 bufs=395 max_bufs=395
470s  Res: njobs=3 nclients=1 nstores=2 npools=3 ncats=1 nfsets=2 nscheds=2
470s 
470s Scheduled Jobs:
470s Level          Type     Pri  Scheduled          Job Name           Volume
470s ===================================================================================
470s Incremental    Backup    10  02-May-25 23:05    BackupClient1      *unknown*
470s Full           Backup    11  02-May-25 23:10    BackupCatalog      *unknown*
470s ====
470s 
470s Running Jobs:
470s Console connected using TLS at 02-May-25 08:43
470s No Jobs running.
470s ====
470s No Terminated Jobs.
470s ====
470s Connecting to Storage daemon File1 at localhost:9103
470s 
470s autopkgtest-sd Version: 13.0.4 (12 February 2024) s390x-ibm-linux-gnu ubuntu 25.04
470s Daemon started 02-May-25 08:43. Jobs: run=0, running=0.
470s  Ulimits: nofile=1024 memlock=unlimited status=nofile
470s  Heap: heap=643,072 smbytes=228,774 max_bytes=350,074 bufs=267 max_bufs=268
470s  Sizes: boffset_t=8 size_t=8 int32_t=4 int64_t=8 mode=0,0 newbsr=0
470s  Crypto: fips=N/A crypto=OpenSSL 3.4.0 22 Oct 2024
470s  Res: ndevices=4 nautochgr=2
470s 
470s Running Jobs:
470s Director connected using TLS at: 02-May-25 08:44
470s No Jobs running.
470s ====
470s 
470s Jobs waiting to reserve a drive:
470s ====
470s 
470s Terminated Jobs:
470s ====
470s 
470s Device status:
470s Autochanger "FileChgr1" with devices:
470s    "FileChgr1-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
470s    "FileChgr1-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
470s Autochanger "FileChgr2" with devices:
470s    "FileChgr2-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
470s    "FileChgr2-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
470s 
470s Device File: "FileChgr1-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
470s    Drive 0 is not loaded.
470s    Available Space=18.10 GB
470s ==
470s 
470s Device File: "FileChgr1-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
470s    Drive 0 is not loaded.
470s    Available Space=18.10 GB
470s ==
470s 
470s Device File: "FileChgr2-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
470s    Drive 0 is not loaded.
470s    Available Space=18.10 GB
470s ==
470s 
470s Device File: "FileChgr2-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
470s    Drive 0 is not loaded.
470s    Available Space=18.10 GB
470s ==
470s ====
470s 
470s Used Volume status:
470s ====
470s 
470s ====
470s 
470s Connecting to Client autopkgtest-fd at localhost:9102
470s 
470s autopkgtest-fd Version: 13.0.4 (12 February 2024)  s390x-ibm-linux-gnu ubuntu 25.04
470s Daemon started 02-May-25 08:43. Jobs: run=0 running=0.
470s  Heap: heap=536,576 smbytes=197,902 max_bytes=197,919 bufs=101 max_bufs=101
470s  Sizes: boffset_t=8 size_t=8 debug=0 trace=0 mode=0,0 bwlimit=0kB/s
470s  Crypto: fips=N/A crypto=OpenSSL 3.4.0 22 Oct 2024
470s  Plugin: bpipe-fd.so(2) 
470s 
470s Running Jobs:
470s Director connected using TLS at: 02-May-25 08:44
470s No Jobs running.
470s ====
470s 
470s Terminated Jobs:
470s ====
470s + echo
470s 
470s + echo '---- label a volume ----'
470s ---- label a volume ----
470s + echo -e 'label volume=testvol pool=File storage=File1 drive=0 slot=0'
470s + bconsole
470s Connecting to Director localhost:9101
470s 1000 OK: 10002 autopkgtest-dir Version: 13.0.4 (12 February 2024)
470s Enter a period to cancel a command.
470s label volume=testvol pool=File storage=File1 drive=0 slot=0
470s Automatically selected Catalog: MyCatalog
470s Using Catalog "MyCatalog"
470s Connecting to Storage daemon File1 at localhost:9103 ...
470s Sending label command for Volume "testvol" Slot 0 ...
470s 3000 OK label. VolBytes=226 VolABytes=0 VolType=1 Volume="testvol" Device="FileChgr1-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
470s Catalog record for Volume "testvol", Slot 0  successfully created.
470s Requesting to mount FileChgr1 ...
470s 3906 File device ""FileChgr1-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)" is always mounted.
470s + echo
470s 
470s + echo '----- create some file to test backup / restore ----'
470s ----- create some file to test backup / restore ----
470s + echo 'bacula restore test'
470s + echo
470s 
470s + echo '------ trigger backup job -----'
470s ------ trigger backup job -----
470s + echo -e 'run job=BackupClient1 yes\rwait'
470s + bconsole
470s + grep 'Job queued. JobId='
474s Job queued. JobId=1
474s + echo 'status all'
474s + bconsole
474s Connecting to Director localhost:9101
474s 1000 OK: 10002 autopkgtest-dir Version: 13.0.4 (12 February 2024)
474s Enter a period to cancel a command.
474s status all
474s autopkgtest-dir Version: 13.0.4 (12 February 2024) s390x-ibm-linux-gnu ubuntu 25.04
474s Daemon started 02-May-25 08:43, conf reloaded 02-May-2025 08:43:49
474s  Jobs: run=1, running=0 mode=0,0
474s  Crypto: fips=N/A crypto=OpenSSL 3.4.0 22 Oct 2024
474s  Heap: heap=942,080 smbytes=468,202 max_bytes=492,511 bufs=457 max_bufs=506
474s  Res: njobs=3 nclients=1 nstores=2 npools=3 ncats=1 nfsets=2 nscheds=2
474s 
474s Scheduled Jobs:
474s Level          Type     Pri  Scheduled          Job Name           Volume
474s ===================================================================================
474s Incremental    Backup    10  02-May-25 23:05    BackupClient1      testvol
474s Full           Backup    11  02-May-25 23:10    BackupCatalog      testvol
474s ====
474s 
474s Running Jobs:
474s Console connected using TLS at 02-May-25 08:44
474s No Jobs running.
474s ====
474s 
474s Terminated Jobs:
474s  JobId  Level     Files      Bytes   Status   Finished        Name 
474s ====================================================================
474s      1  Full         591    93.02 M  OK       02-May-25 08:44 BackupClient1
474s 
474s ====
474s Connecting to Storage daemon File1 at localhost:9103
474s 
474s autopkgtest-sd Version: 13.0.4 (12 February 2024) s390x-ibm-linux-gnu ubuntu 25.04
474s Daemon started 02-May-25 08:43. Jobs: run=1, running=0.
474s  Ulimits: nofile=1024 memlock=unlimited status=nofile
474s  Heap: heap=643,072 smbytes=669,304 max_bytes=1,061,001 bufs=283 max_bufs=305
474s  Sizes: boffset_t=8 size_t=8 int32_t=4 int64_t=8 mode=0,0 newbsr=0
474s  Crypto: fips=N/A crypto=OpenSSL 3.4.0 22 Oct 2024
474s  Res: ndevices=4 nautochgr=2
474s 
474s Running Jobs:
474s Director connected using TLS at: 02-May-25 08:44
474s No Jobs running.
474s ====
474s 
474s Jobs waiting to reserve a drive:
474s ====
474s 
474s Terminated Jobs:
474s  JobId  Level    Files      Bytes   Status   Finished        Name 
474s ===================================================================
474s      1  Full        591    93.08 M  OK       02-May-25 08:44 BackupClient1
474s ====
474s 
474s Device status:
474s Autochanger "FileChgr1" with devices:
474s    "FileChgr1-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
474s    "FileChgr1-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
474s Autochanger "FileChgr2" with devices:
474s    "FileChgr2-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
474s    "FileChgr2-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
474s 
474s Device File: "FileChgr1-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
474s    Drive 0 is not loaded.
474s    Available Space=18.01 GB
474s ==
474s 
474s Device File: "FileChgr1-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
474s    Drive 0 is not loaded.
474s    Available Space=18.01 GB
474s ==
474s 
474s Device File: "FileChgr2-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
474s    Drive 0 is not loaded.
474s    Available Space=18.01 GB
474s ==
474s 
474s Device File: "FileChgr2-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
474s    Drive 0 is not loaded.
474s    Available Space=18.01 GB
474s ==
474s ====
474s 
474s Used Volume status:
474s ====
474s 
474s Attr spooling: 0 active jobs, 122,764 bytes; 1 total jobs, 122,764 max bytes.
474s ====
474s 
474s Connecting to Client autopkgtest-fd at localhost:9102
475s 
475s autopkgtest-fd Version: 13.0.4 (12 February 2024)  s390x-ibm-linux-gnu ubuntu 25.04
475s Daemon started 02-May-25 08:43. Jobs: run=1 running=0.
475s  Heap: heap=536,576 smbytes=400,466 max_bytes=662,269 bufs=116 max_bufs=150
475s  Sizes: boffset_t=8 size_t=8 debug=0 trace=0 mode=0,0 bwlimit=0kB/s
475s  Crypto: fips=N/A crypto=OpenSSL 3.4.0 22 Oct 2024
475s  Plugin: bpipe-fd.so(2) 
475s 
475s Running Jobs:
475s Director connected using TLS at: 02-May-25 08:44
475s No Jobs running.
475s ====
475s 
475s Terminated Jobs:
475s  JobId  Level    Files      Bytes   Status   Finished        Name 
475s ===================================================================
475s      1  Full        591    93.02 M  OK       02-May-25 08:44 BackupClient1
475s ====
475s You have messages.
475s + echo
475s 
475s + echo '------ trigger restore job -----'
475s ------ trigger restore job -----
475s + echo -e 'restore select current\rls\rmark usr\rdone\ryes\rwait'
475s + bconsole
475s Connecting to Director localhost:9101
475s 1000 OK: 10002 autopkgtest-dir Version: 13.0.4 (12 February 2024)
475s Enter a period to cancel a command.
475s restore select current
475s Automatically selected Catalog: MyCatalog
475s Using Catalog "MyCatalog"
475s Automatically selected Client: autopkgtest-fd
475s Automatically selected FileSet: Full Set
475s +-------+-------+----------+------------+---------------------+------------+
475s | JobId | Level | JobFiles | JobBytes   | StartTime           | VolumeName |
475s +-------+-------+----------+------------+---------------------+------------+
475s |     1 | F     |      591 | 93,025,848 | 2025-05-02 08:44:02 | testvol    |
475s +-------+-------+----------+------------+---------------------+------------+
475s You have selected the following JobId: 1
475s 
475s Building directory tree for JobId(s) 1 ...  +++++++++++++++++++++++++++++++++++++++++++++++++
475s 590 files inserted into the tree.
475s 
475s You are now entering file selection mode where you add (mark) and
475s remove (unmark) files to be restored. No files are initially added, unless
475s you used the "all" keyword on the command line.
475s Enter "done" to leave this mode.
475s 
475s cwd is: /
475s $ ls
475s usr/
475s $ mark usr
475s 591 files marked.
475s $ done
475s Bootstrap records written to /var/lib/bacula/autopkgtest-dir.restore.1.bsr
475s 
475s The Job will require the following (*=>InChanger):
475s    Volume(s)                 Storage(s)                SD Device(s)
475s ===========================================================================
475s    
475s     testvol                   File1                     FileChgr1                
475s 
475s Volumes marked with "*" are in the Autochanger.
475s 
475s 
475s 591 files selected to be restored.
475s 
475s Using Catalog "MyCatalog"
475s Run Restore job
475s JobName:         RestoreFiles
475s Bootstrap:       /var/lib/bacula/autopkgtest-dir.restore.1.bsr
475s Where:           /tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-restores
475s Replace:         Always
475s FileSet:         Full Set
475s Backup Client:   autopkgtest-fd
475s Restore Client:  autopkgtest-fd
475s Storage:         File1
475s When:            2025-05-02 08:44:05
475s Catalog:         MyCatalog
475s Priority:        10
475s Plugin Options:  *None*
475s OK to run? (yes/mod/no): yes
475s Job queued. JobId=2
475s You have messages.
475s wait
478s + echo 'status all'
478s + bconsole
478s Connecting to Director localhost:9101
478s 1000 OK: 10002 autopkgtest-dir Version: 13.0.4 (12 February 2024)
478s Enter a period to cancel a command.
478s status all
478s autopkgtest-dir Version: 13.0.4 (12 February 2024) s390x-ibm-linux-gnu ubuntu 25.04
478s Daemon started 02-May-25 08:43, conf reloaded 02-May-2025 08:43:49
478s  Jobs: run=2, running=0 mode=0,0
478s  Crypto: fips=N/A crypto=OpenSSL 3.4.0 22 Oct 2024
478s  Heap: heap=835,584 smbytes=464,536 max_bytes=1,676,755 bufs=459 max_bufs=521
478s  Res: njobs=3 nclients=1 nstores=2 npools=3 ncats=1 nfsets=2 nscheds=2
478s 
478s Scheduled Jobs:
478s Level          Type     Pri  Scheduled          Job Name           Volume
478s ===================================================================================
478s Incremental    Backup    10  02-May-25 23:05    BackupClient1      testvol
478s Full           Backup    11  02-May-25 23:10    BackupCatalog      testvol
478s ====
478s 
478s Running Jobs:
478s Console connected using TLS at 02-May-25 08:44
478s No Jobs running.
478s ====
478s 
478s Terminated Jobs:
478s  JobId  Level     Files      Bytes   Status   Finished        Name 
478s ====================================================================
478s      1  Full         591    93.02 M  OK       02-May-25 08:44 BackupClient1
478s      2  Restore      591    93.02 M  OK       02-May-25 08:44 RestoreFiles
478s 
478s ====
478s Connecting to Storage daemon File1 at localhost:9103
478s 
478s autopkgtest-sd Version: 13.0.4 (12 February 2024) s390x-ibm-linux-gnu ubuntu 25.04
478s Daemon started 02-May-25 08:43. Jobs: run=2, running=0.
478s  Ulimits: nofile=1024 memlock=unlimited status=nofile
478s  Heap: heap=536,576 smbytes=642,362 max_bytes=1,061,001 bufs=277 max_bufs=315
478s  Sizes: boffset_t=8 size_t=8 int32_t=4 int64_t=8 mode=0,0 newbsr=0
478s  Crypto: fips=N/A crypto=OpenSSL 3.4.0 22 Oct 2024
478s  Res: ndevices=4 nautochgr=2
478s 
478s Running Jobs:
478s Director connected using TLS at: 02-May-25 08:44
478s No Jobs running.
478s ====
478s 
478s Jobs waiting to reserve a drive:
478s ====
478s 
478s Terminated Jobs:
478s  JobId  Level    Files      Bytes   Status   Finished        Name 
478s ===================================================================
478s      1  Full        591    93.08 M  OK       02-May-25 08:44 BackupClient1
478s      2  Rest        591    93.08 M  OK       02-May-25 08:44 RestoreFiles
478s ====
478s 
478s Device status:
478s Autochanger "FileChgr1" with devices:
478s    "FileChgr1-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
478s    "FileChgr1-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
478s Autochanger "FileChgr2" with devices:
478s    "FileChgr2-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
478s    "FileChgr2-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
478s 
478s Device File: "FileChgr1-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
478s    Drive 0 is not loaded.
478s    Available Space=17.91 GB
478s ==
478s 
478s Device File: "FileChgr1-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
478s    Drive 0 is not loaded.
478s    Available Space=17.91 GB
478s ==
478s 
478s Device File: "FileChgr2-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
478s    Drive 0 is not loaded.
478s    Available Space=17.91 GB
478s ==
478s 
478s Device File: "FileChgr2-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
478s    Drive 0 is not loaded.
478s    Available Space=17.91 GB
478s ==
478s ====
478s 
478s Used Volume status:
478s ====
478s 
478s Attr spooling: 0 active jobs, 122,764 bytes; 1 total jobs, 122,764 max bytes.
478s ====
478s 
478s Connecting to Client autopkgtest-fd at localhost:9102
478s 
478s autopkgtest-fd Version: 13.0.4 (12 February 2024)  s390x-ibm-linux-gnu ubuntu 25.04
478s Daemon started 02-May-25 08:43. Jobs: run=2 running=0.
478s  Heap: heap=528,384 smbytes=239,997 max_bytes=1,173,011 bufs=102 max_bufs=150
478s  Sizes: boffset_t=8 size_t=8 debug=0 trace=0 mode=0,0 bwlimit=0kB/s
478s  Crypto: fips=N/A crypto=OpenSSL 3.4.0 22 Oct 2024
478s  Plugin: bpipe-fd.so(2) 
478s 
478s Running Jobs:
478s Director connected using TLS at: 02-May-25 08:44
478s No Jobs running.
478s ====
478s 
478s Terminated Jobs:
478s  JobId  Level    Files      Bytes   Status   Finished        Name 
478s ===================================================================
478s      1  Full        591    93.02 M  OK       02-May-25 08:44 BackupClient1
478s      2  Rest        591    93.02 M  OK       02-May-25 08:44 RestoreFiles
478s ====
478s You have messages.
478s + grep 'bacula restore test' /tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-restores//usr/sbin/bacula-backup.test
478s bacula restore test
478s + echo
478s 
478s + echo '------ compare original and restore ------'
478s ------ compare original and restore ------
478s + debian/tests/scripts/diff.pl -s /usr/sbin -d /tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-restores/usr/sbin --acl --attr
480s + echo
480s 
480s + echo '------ backup-test end ------'
480s ------ backup-test end ------
480s autopkgtest [08:44:10]: test backup-test-mysql: -----------------------]
481s backup-test-mysql    PASS
481s autopkgtest [08:44:11]: test backup-test-mysql:  - - - - - - - - - - results - - - - - - - - - -
481s autopkgtest [08:44:11]: test program-test-mysql: preparing testbed
606s autopkgtest [08:46:16]: testbed dpkg architecture: s390x
607s autopkgtest [08:46:16]: testbed apt version: 3.0.0
607s autopkgtest [08:46:17]: @@@@@@@@@@@@@@@@@@@@ test bed setup
607s autopkgtest [08:46:17]: testbed release detected to be: questing
608s autopkgtest [08:46:18]: updating testbed package index (apt update)
608s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [110 kB]
608s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease
608s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease
608s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease
608s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [44.4 kB]
608s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [2076 kB]
609s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [175 kB]
609s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main s390x Packages [208 kB]
609s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/universe s390x Packages [1079 kB]
609s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/multiverse s390x Packages [9148 B]
609s Fetched 3701 kB in 1s (2978 kB/s)
610s Reading package lists...
610s autopkgtest [08:46:20]: upgrading testbed (apt dist-upgrade and autopurge)
610s Reading package lists...
611s Building dependency tree...
611s Reading state information...
611s Calculating upgrade...Starting pkgProblemResolver with broken count: 0
611s Starting 2 pkgProblemResolver with broken count: 0
611s Done
611s Entering ResolveByKeep
611s 
611s Calculating upgrade...
611s The following packages will be upgraded:
611s   htop nano ucf
611s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
611s Need to get 532 kB of archives.
611s After this operation, 4096 B of additional disk space will be used.
611s Get:1 http://ftpmaster.internal/ubuntu questing-proposed/main s390x ucf all 3.0051 [43.6 kB]
612s Get:2 http://ftpmaster.internal/ubuntu questing/main s390x nano s390x 8.4-1 [299 kB]
612s Get:3 http://ftpmaster.internal/ubuntu questing/main s390x htop s390x 3.4.1-4 [189 kB]
612s Preconfiguring packages ...
612s Fetched 532 kB in 1s (982 kB/s)
612s (Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 81472 files and directories currently installed.)
612s Preparing to unpack .../archives/ucf_3.0051_all.deb ...
612s Unpacking ucf (3.0051) over (3.0050) ...
612s Preparing to unpack .../archives/nano_8.4-1_s390x.deb ...
612s Unpacking nano (8.4-1) over (8.3-1) ...
612s Preparing to unpack .../htop_3.4.1-4_s390x.deb ...
612s Unpacking htop (3.4.1-4) over (3.4.0-2) ...
612s Setting up htop (3.4.1-4) ...
612s Setting up ucf (3.0051) ...
612s Setting up nano (8.4-1) ...
612s Installing new version of config file /etc/nanorc ...
612s Processing triggers for man-db (2.13.0-1) ...
613s Processing triggers for install-info (7.1.1-1) ...
613s Reading package lists...
613s Building dependency tree...
613s Reading state information...
613s Starting pkgProblemResolver with broken count: 0
613s Starting 2 pkgProblemResolver with broken count: 0
613s Done
614s Solving dependencies...
614s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
616s Reading package lists...
616s Building dependency tree...
616s Reading state information...
616s Starting pkgProblemResolver with broken count: 0
616s Starting 2 pkgProblemResolver with broken count: 0
616s Done
617s The following NEW packages will be installed:
617s   bacula bacula-bscan bacula-client bacula-common bacula-common-mysql
617s   bacula-console bacula-director bacula-director-mysql bacula-fd bacula-sd
617s   bacula-server bsd-mailx dbconfig-common dbconfig-mysql dbconfig-pgsql
617s   default-mysql-client default-mysql-server liblockfile-bin liblockfile1
617s   libmecab2 libmysqlclient24 libpq5 libprotobuf-lite32t64 mtx mysql-client
617s   mysql-client-core mysql-common mysql-server mysql-server-core postfix
617s   postgresql-client postgresql-client-17 postgresql-client-common
617s 0 upgraded, 33 newly installed, 0 to remove and 0 not upgraded.
617s Need to get 30.8 MB of archives.
617s After this operation, 205 MB of additional disk space will be used.
617s Get:1 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-common s390x 13.0.4-4build1 [854 kB]
617s Get:2 http://ftpmaster.internal/ubuntu questing/main s390x mysql-common all 5.8+1.1.1ubuntu1 [6922 B]
617s Get:3 http://ftpmaster.internal/ubuntu questing/main s390x libmysqlclient24 s390x 8.4.4-0ubuntu2 [1295 kB]
617s Get:4 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-common-mysql s390x 13.0.4-4build1 [12.2 kB]
617s Get:5 http://ftpmaster.internal/ubuntu questing/universe s390x dbconfig-common all 2.0.24 [596 kB]
617s Get:6 http://ftpmaster.internal/ubuntu questing/main s390x mysql-client-core s390x 8.4.4-0ubuntu2 [2222 kB]
617s Get:7 http://ftpmaster.internal/ubuntu questing/main s390x mysql-client s390x 8.4.4-0ubuntu2 [9122 B]
617s Get:8 http://ftpmaster.internal/ubuntu questing/universe s390x default-mysql-client all 1.1.1ubuntu1 [3072 B]
617s Get:9 http://ftpmaster.internal/ubuntu questing/universe s390x dbconfig-mysql all 2.0.24 [938 B]
617s Get:10 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-director-mysql all 13.0.4-4build1 [32.3 kB]
617s Get:11 http://ftpmaster.internal/ubuntu questing/main s390x postfix s390x 3.9.1-10ubuntu1 [1305 kB]
617s Get:12 http://ftpmaster.internal/ubuntu questing/main s390x liblockfile-bin s390x 1.17-2 [11.5 kB]
617s Get:13 http://ftpmaster.internal/ubuntu questing/main s390x liblockfile1 s390x 1.17-2 [6970 B]
617s Get:14 http://ftpmaster.internal/ubuntu questing/main s390x bsd-mailx s390x 8.1.2-0.20220412cvs-1build1 [69.7 kB]
617s Get:15 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-director s390x 13.0.4-4build1 [379 kB]
617s Get:16 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-fd s390x 13.0.4-4build1 [144 kB]
617s Get:17 http://ftpmaster.internal/ubuntu questing/main s390x mtx s390x 1.3.12-18 [43.2 kB]
617s Get:18 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-sd s390x 13.0.4-4build1 [151 kB]
617s Get:19 http://ftpmaster.internal/ubuntu questing/main s390x libmecab2 s390x 0.996-15.1build2 [214 kB]
617s Get:20 http://ftpmaster.internal/ubuntu questing/main s390x libprotobuf-lite32t64 s390x 3.21.12-10build2 [238 kB]
618s Get:21 http://ftpmaster.internal/ubuntu questing/main s390x mysql-server-core s390x 8.4.4-0ubuntu2 [20.1 MB]
618s Get:22 http://ftpmaster.internal/ubuntu questing/main s390x mysql-server s390x 8.4.4-0ubuntu2 [1369 kB]
618s Get:23 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-console s390x 13.0.4-4build1 [28.6 kB]
618s Get:24 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-client all 13.0.4-4build1 [23.5 kB]
618s Get:25 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-bscan s390x 13.0.4-4build1 [24.7 kB]
618s Get:26 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-server all 13.0.4-4build1 [23.4 kB]
618s Get:27 http://ftpmaster.internal/ubuntu questing/universe s390x bacula all 13.0.4-4build1 [1036 B]
618s Get:28 http://ftpmaster.internal/ubuntu questing/main s390x libpq5 s390x 17.4-1 [147 kB]
618s Get:29 http://ftpmaster.internal/ubuntu questing/main s390x postgresql-client-common all 274 [47.6 kB]
618s Get:30 http://ftpmaster.internal/ubuntu questing/main s390x postgresql-client-17 s390x 17.4-1 [1367 kB]
618s Get:31 http://ftpmaster.internal/ubuntu questing/main s390x postgresql-client all 17+274 [13.3 kB]
618s Get:32 http://ftpmaster.internal/ubuntu questing/universe s390x dbconfig-pgsql all 2.0.24 [914 B]
618s Get:33 http://ftpmaster.internal/ubuntu questing/universe s390x default-mysql-server all 1.1.1ubuntu1 [3088 B]
618s Preconfiguring packages ...
619s Fetched 30.8 MB in 2s (19.3 MB/s)
619s Selecting previously unselected package bacula-common.
619s (Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 81472 files and directories currently installed.)
619s Preparing to unpack .../00-bacula-common_13.0.4-4build1_s390x.deb ...
619s Adding user 'bacula'... Ok.
619s Unpacking bacula-common (13.0.4-4build1) ...
619s Selecting previously unselected package mysql-common.
619s Preparing to unpack .../01-mysql-common_5.8+1.1.1ubuntu1_all.deb ...
619s Unpacking mysql-common (5.8+1.1.1ubuntu1) ...
619s Selecting previously unselected package libmysqlclient24:s390x.
619s Preparing to unpack .../02-libmysqlclient24_8.4.4-0ubuntu2_s390x.deb ...
619s Unpacking libmysqlclient24:s390x (8.4.4-0ubuntu2) ...
619s Selecting previously unselected package bacula-common-mysql.
619s Preparing to unpack .../03-bacula-common-mysql_13.0.4-4build1_s390x.deb ...
619s Unpacking bacula-common-mysql (13.0.4-4build1) ...
619s Selecting previously unselected package dbconfig-common.
619s Preparing to unpack .../04-dbconfig-common_2.0.24_all.deb ...
619s Unpacking dbconfig-common (2.0.24) ...
619s Selecting previously unselected package mysql-client-core.
619s Preparing to unpack .../05-mysql-client-core_8.4.4-0ubuntu2_s390x.deb ...
619s Unpacking mysql-client-core (8.4.4-0ubuntu2) ...
619s Selecting previously unselected package mysql-client.
619s Preparing to unpack .../06-mysql-client_8.4.4-0ubuntu2_s390x.deb ...
619s Unpacking mysql-client (8.4.4-0ubuntu2) ...
619s Selecting previously unselected package default-mysql-client.
619s Preparing to unpack .../07-default-mysql-client_1.1.1ubuntu1_all.deb ...
619s Unpacking default-mysql-client (1.1.1ubuntu1) ...
619s Selecting previously unselected package dbconfig-mysql.
619s Preparing to unpack .../08-dbconfig-mysql_2.0.24_all.deb ...
619s Unpacking dbconfig-mysql (2.0.24) ...
619s Selecting previously unselected package bacula-director-mysql.
619s Preparing to unpack .../09-bacula-director-mysql_13.0.4-4build1_all.deb ...
619s Unpacking bacula-director-mysql (13.0.4-4build1) ...
619s Selecting previously unselected package postfix.
619s Preparing to unpack .../10-postfix_3.9.1-10ubuntu1_s390x.deb ...
619s Unpacking postfix (3.9.1-10ubuntu1) ...
619s Selecting previously unselected package liblockfile-bin.
619s Preparing to unpack .../11-liblockfile-bin_1.17-2_s390x.deb ...
619s Unpacking liblockfile-bin (1.17-2) ...
619s Selecting previously unselected package liblockfile1:s390x.
619s Preparing to unpack .../12-liblockfile1_1.17-2_s390x.deb ...
619s Unpacking liblockfile1:s390x (1.17-2) ...
619s Selecting previously unselected package bsd-mailx.
619s Preparing to unpack .../13-bsd-mailx_8.1.2-0.20220412cvs-1build1_s390x.deb ...
619s Unpacking bsd-mailx (8.1.2-0.20220412cvs-1build1) ...
619s Selecting previously unselected package bacula-director.
619s Preparing to unpack .../14-bacula-director_13.0.4-4build1_s390x.deb ...
619s Unpacking bacula-director (13.0.4-4build1) ...
619s Selecting previously unselected package bacula-fd.
619s Preparing to unpack .../15-bacula-fd_13.0.4-4build1_s390x.deb ...
619s Unpacking bacula-fd (13.0.4-4build1) ...
619s Selecting previously unselected package mtx.
619s Preparing to unpack .../16-mtx_1.3.12-18_s390x.deb ...
619s Unpacking mtx (1.3.12-18) ...
619s Selecting previously unselected package bacula-sd.
619s Preparing to unpack .../17-bacula-sd_13.0.4-4build1_s390x.deb ...
619s Unpacking bacula-sd (13.0.4-4build1) ...
619s Selecting previously unselected package libmecab2:s390x.
619s Preparing to unpack .../18-libmecab2_0.996-15.1build2_s390x.deb ...
619s Unpacking libmecab2:s390x (0.996-15.1build2) ...
619s Selecting previously unselected package libprotobuf-lite32t64:s390x.
619s Preparing to unpack .../19-libprotobuf-lite32t64_3.21.12-10build2_s390x.deb ...
619s Unpacking libprotobuf-lite32t64:s390x (3.21.12-10build2) ...
619s Selecting previously unselected package mysql-server-core.
619s Preparing to unpack .../20-mysql-server-core_8.4.4-0ubuntu2_s390x.deb ...
619s Unpacking mysql-server-core (8.4.4-0ubuntu2) ...
620s Setting up mysql-common (5.8+1.1.1ubuntu1) ...
620s update-alternatives: using /etc/mysql/my.cnf.fallback to provide /etc/mysql/my.cnf (my.cnf) in auto mode
620s Selecting previously unselected package mysql-server.
620s (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 ... 82430 files and directories currently installed.)
620s Preparing to unpack .../00-mysql-server_8.4.4-0ubuntu2_s390x.deb ...
620s Unpacking mysql-server (8.4.4-0ubuntu2) ...
620s Selecting previously unselected package bacula-console.
620s Preparing to unpack .../01-bacula-console_13.0.4-4build1_s390x.deb ...
620s Unpacking bacula-console (13.0.4-4build1) ...
620s Selecting previously unselected package bacula-client.
620s Preparing to unpack .../02-bacula-client_13.0.4-4build1_all.deb ...
620s Unpacking bacula-client (13.0.4-4build1) ...
620s Selecting previously unselected package bacula-bscan.
620s Preparing to unpack .../03-bacula-bscan_13.0.4-4build1_s390x.deb ...
620s Unpacking bacula-bscan (13.0.4-4build1) ...
620s Selecting previously unselected package bacula-server.
620s Preparing to unpack .../04-bacula-server_13.0.4-4build1_all.deb ...
620s Unpacking bacula-server (13.0.4-4build1) ...
620s Selecting previously unselected package bacula.
620s Preparing to unpack .../05-bacula_13.0.4-4build1_all.deb ...
620s Unpacking bacula (13.0.4-4build1) ...
620s Selecting previously unselected package libpq5:s390x.
620s Preparing to unpack .../06-libpq5_17.4-1_s390x.deb ...
620s Unpacking libpq5:s390x (17.4-1) ...
620s Selecting previously unselected package postgresql-client-common.
620s Preparing to unpack .../07-postgresql-client-common_274_all.deb ...
620s Unpacking postgresql-client-common (274) ...
620s Selecting previously unselected package postgresql-client-17.
620s Preparing to unpack .../08-postgresql-client-17_17.4-1_s390x.deb ...
620s Unpacking postgresql-client-17 (17.4-1) ...
620s Selecting previously unselected package postgresql-client.
620s Preparing to unpack .../09-postgresql-client_17+274_all.deb ...
620s Unpacking postgresql-client (17+274) ...
620s Selecting previously unselected package dbconfig-pgsql.
620s Preparing to unpack .../10-dbconfig-pgsql_2.0.24_all.deb ...
620s Unpacking dbconfig-pgsql (2.0.24) ...
620s Selecting previously unselected package default-mysql-server.
620s Preparing to unpack .../11-default-mysql-server_1.1.1ubuntu1_all.deb ...
620s Unpacking default-mysql-server (1.1.1ubuntu1) ...
620s Setting up libprotobuf-lite32t64:s390x (3.21.12-10build2) ...
620s Setting up postgresql-client-common (274) ...
620s Setting up libmecab2:s390x (0.996-15.1build2) ...
620s Setting up liblockfile-bin (1.17-2) ...
620s Setting up libpq5:s390x (17.4-1) ...
620s Setting up mtx (1.3.12-18) ...
620s Setting up dbconfig-common (2.0.24) ...
620s Creating config file /etc/dbconfig-common/config with new version
620s Setting up libmysqlclient24:s390x (8.4.4-0ubuntu2) ...
620s Setting up bacula-common (13.0.4-4build1) ...
620s Setting up bacula-sd (13.0.4-4build1) ...
620s Creating config file /etc/default/bacula-sd with new version
621s Creating config file /etc/bacula/bacula-sd.conf with new version
621s Created symlink '/etc/systemd/system/multi-user.target.wants/bacula-sd.service' → '/usr/lib/systemd/system/bacula-sd.service'.

621s Setting up mysql-server-core (8.4.4-0ubuntu2) ...
621s Setting up bacula-console (13.0.4-4build1) ...
621s Creating config file /etc/bacula/bconsole.conf with new version
621s Setting up postfix (3.9.1-10ubuntu1) ...
621s Created symlink '/etc/systemd/system/multi-user.target.wants/postfix.service' → '/usr/lib/systemd/system/postfix.service'.

622s info: Selecting UID from range 100 to 999 ...
622s 
622s info: Selecting GID from range 100 to 999 ...
622s info: Adding system user `postfix' (UID 109) ...
622s info: Adding new group `postfix' (GID 114) ...
622s info: Adding new user `postfix' (UID 109) with group `postfix' ...
622s info: Not creating home directory `/var/spool/postfix'.
622s info: Selecting GID from range 100 to 999 ...
622s info: Adding group `postdrop' (GID 115) ...
622s Creating /etc/postfix/dynamicmaps.cf
622s setting myhostname: autopkgtest.local
622s setting alias maps
622s setting alias database
622s changing /etc/mailname to autopkgtest.local
622s setting myorigin
622s setting destinations: $myhostname, autopkgtest.local, localhost.local, , localhost
622s setting relayhost: 
622s setting mynetworks: 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128
622s clearing mailbox_command
622s setting mailbox_size_limit: 0
622s setting recipient_delimiter: +
624s setting inet_interfaces: all
626s setting inet_protocols: all
626s /etc/aliases does not exist, creating it.
626s WARNING: /etc/aliases exists, but does not have a root alias.
626s 
626s Postfix (main.cf) is now set up with a default configuration.  If you need to 
626s make changes, edit /etc/postfix/main.cf (and others) as needed.  To view 
626s Postfix configuration values, see postconf(1).
626s 
626s After modifying main.cf, be sure to run 'systemctl reload postfix'.
626s 
628s Setting up mysql-client-core (8.4.4-0ubuntu2) ...
628s Setting up liblockfile1:s390x (1.17-2) ...
628s Setting up bacula-fd (13.0.4-4build1) ...
628s Creating config file /etc/default/bacula-fd with new version
628s Creating config file /etc/bacula/bacula-fd.conf with new version
628s Created symlink '/etc/systemd/system/multi-user.target.wants/bacula-fd.service' → '/usr/lib/systemd/system/bacula-fd.service'.

629s Setting up mysql-client (8.4.4-0ubuntu2) ...
629s Setting up bacula-client (13.0.4-4build1) ...
629s Setting up bacula-common-mysql (13.0.4-4build1) ...
629s Setting up postgresql-client-17 (17.4-1) ...
629s 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
629s Setting up dbconfig-pgsql (2.0.24) ...
629s Setting up dbconfig-mysql (2.0.24) ...
629s Setting up bsd-mailx (8.1.2-0.20220412cvs-1build1) ...
629s update-alternatives: using /usr/bin/bsd-mailx to provide /usr/bin/mailx (mailx) in auto mode
629s Setting up bacula-director-mysql (13.0.4-4build1) ...
629s dbconfig-common: writing config to /etc/dbconfig-common/bacula-director-mysql.conf
629s Creating config file /etc/dbconfig-common/bacula-director-mysql.conf with new version
629s ERROR 2002 (HY000): Can't connect to local MySQL server through socket '/var/run/mysqld/mysqld.sock' (2).
629s unable to connect to mysql server.
629s error encountered creating user:
629s ERROR 2002 (HY000): Can't connect to local MySQL server through socket '/var/run/mysqld/mysqld.sock' (2)
629s dbconfig-common: bacula-director-mysql configure: noninteractive fail.
629s dbconfig-common: bacula-director-mysql configure: ignoring errors from here forwards
629s populating database via sql...  done.
629s dbconfig-common: flushing administrative password
629s Setting up bacula-director (13.0.4-4build1) ...
629s Creating config file /etc/default/bacula-dir with new version
629s Creating config file /etc/bacula/bacula-dir.conf with new version
630s Creating config file /etc/bacula/scripts/delete_catalog_backup with new version
630s Creating config file /etc/bacula/scripts/make_catalog_backup with new version
630s Created symlink '/etc/systemd/system/bacula-dir.service' → '/usr/lib/systemd/system/bacula-director.service'.

630s Created symlink '/etc/systemd/system/multi-user.target.wants/bacula-director.service' → '/usr/lib/systemd/system/bacula-director.service'.

660s Could not execute systemctl:  at /usr/bin/deb-systemd-invoke line 148.
660s Setting up bacula-bscan (13.0.4-4build1) ...
660s Setting up bacula-server (13.0.4-4build1) ...
660s Setting up default-mysql-client (1.1.1ubuntu1) ...
660s Setting up mysql-server (8.4.4-0ubuntu2) ...
660s update-alternatives: using /etc/mysql/mysql.cnf to provide /etc/mysql/my.cnf (my.cnf) in auto mode
660s Renaming removed key_buffer and myisam-recover options (if present)
665s Created symlink '/etc/systemd/system/multi-user.target.wants/mysql.service' → '/usr/lib/systemd/system/mysql.service'.

667s Setting up postgresql-client (17+274) ...
667s Setting up bacula (13.0.4-4build1) ...
667s Setting up default-mysql-server (1.1.1ubuntu1) ...
667s Processing triggers for libc-bin (2.41-6ubuntu1) ...
667s Processing triggers for rsyslog (8.2412.0-2ubuntu2) ...
667s Processing triggers for ufw (0.36.2-9) ...
667s Processing triggers for man-db (2.13.0-1) ...
668s Processing triggers for postfix (3.9.1-10ubuntu1) ...
668s Restarting postfix
672s autopkgtest [08:47:22]: test program-test-mysql: [-----------------------
672s + echo '----- start testing -----'
672s ----- start testing -----
672s + echo 'USER: root'
672s USER: root
672s + DBTYPE=mysql
672s + echo '---- Preparing test files ----'
672s ---- Preparing test files ----
672s + DATAFILE=/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/datafile
672s + cat
672s + echo
672s 
672s + echo '---- Testing /usr/sbin/bregex ----'
672s ---- Testing /usr/sbin/bregex ----
672s + echo -en 'line . of the message\r'
672s + /usr/sbin/bregex -f /tmp/autopkgtest.qRgwYF/autopkgtest_tmp/datafile
672s Enter regex pattern:     2: This is line 1 of the message.
672s     3: This is line 2 of the message.
672s     4: This is line 3 of the message.
672s     5: This is line 4 of the message.
672s Enter regex pattern: + echo
672s 
672s + echo '---- Testing /usr/sbin/bwild ----'
672s ---- Testing /usr/sbin/bwild ----
672s + echo -en '*line ? of the message.\r'
672s + /usr/sbin/bwild -f /tmp/autopkgtest.qRgwYF/autopkgtest_tmp/datafile
672s Enter a wild-card:     2: This is line 1 of the message.
672s     3: This is line 2 of the message.
672s     4: This is line 3 of the message.
672s     5: This is line 4 of the message.
672s Enter a wild-card: + echo
672s 
672s + echo '---- Testing /usr/sbin/bbconsjson ----'
672s ---- Testing /usr/sbin/bbconsjson ----
672s + /usr/sbin/bbconsjson
672s [
672s {
672s   "Director": {
672s     "Name": "autopkgtest-dir",
672s     "DirPort": 9101,
672s     "Address": "localhost",
672s     "Password": "9fzAzUYXvRX59FKSAz4p-c_bQIcpO28Gf"
672s    }
672s }
672s ]
672s + echo
672s 
672s + echo '---- Testing /usr/sbin/bdirjson ----'
672s ---- Testing /usr/sbin/bdirjson ----
672s + /usr/sbin/bdirjson
672s [
672s {
672s   "Director": {
672s     "Name": "autopkgtest-dir",
672s     "Messages": "Daemon",
672s     "DirAddress": "127.0.0.1",
672s     "QueryFile": "/etc/bacula/scripts/query.sql",
672s     "WorkingDirectory": "/var/lib/bacula",
672s     "PidDirectory": "/run/bacula",
672s     "MaximumConcurrentJobs": 20,
672s     "Password": "9fzAzUYXvRX59FKSAz4p-c_bQIcpO28Gf"
672s   }
672s },
672s {
672s   "Client": {
672s     "Name": "autopkgtest-fd",
672s     "Address": "localhost",
672s     "FdPort": 9102,
672s     "Password": "QKOh-yXlJWNjuxo8yxgGRmF-6EyXVEMvq",
672s     "Catalog": "MyCatalog",
672s     "FileRetention": 5184000,
672s     "JobRetention": 15552000,
672s     "AutoPrune": true
672s   }
672s },
672s {
672s   "Job": {
672s     "Name": "BackupCatalog",
672s     "Type": "Backup",
672s     "Level": "Full",
672s     "Messages": "Standard",
672s     "Storage": ["File1"],
672s     "Pool": "File",
672s     "Client": "autopkgtest-fd",
672s     "Fileset": "Catalog",
672s     "Schedule": "WeeklyCycleAfterBackup",
672s     "JobDefs": "DefaultJob",
672s     "WriteBootstrap": "/var/lib/bacula/%n.bsr",
672s     "SpoolAttributes": true,
672s     "Runscript": [
672s       {
672s         "RunsWhen": "Before",
672s         "RunsOnClient": false,
672s         "Command": "/etc/bacula/scripts/make_catalog_backup.pl MyCatalog"
672s       },
672s       {
672s         "RunsWhen": "After",
672s         "RunsOnClient": false,
672s         "Command": "/etc/bacula/scripts/delete_catalog_backup"
672s       }
672s     ]
672s ,
672s     "Priority": 11
672s   }
672s },
672s {
672s   "Job": {
672s     "Name": "BackupClient1",
672s     "Type": "Backup",
672s     "Level": "Incremental",
672s     "Messages": "Standard",
672s     "Storage": ["File1"],
672s     "Pool": "File",
672s     "Client": "autopkgtest-fd",
672s     "Fileset": "Full Set",
672s     "Schedule": "WeeklyCycle",
672s     "JobDefs": "DefaultJob",
672s     "WriteBootstrap": "/var/lib/bacula/%c.bsr",
672s     "SpoolAttributes": true,
672s     "Priority": 10
672s   }
672s },
672s {
672s   "Job": {
672s     "Name": "RestoreFiles",
672s     "Type": "Restore",
672s     "Messages": "Standard",
672s     "Storage": ["File1"],
672s     "Pool": "File",
672s     "Client": "autopkgtest-fd",
672s     "Fileset": "Full Set",
672s     "Where": "/nonexistent/path/to/file/archive/dir/bacula-restores"
672s   }
672s },
672s {
672s   "Storage": {
672s     "Name": "File1",
672s     "SdPort": 9103,
672s     "Address": "localhost",
672s     "Password": "s2ds5mdUmZ4M6HVIBKMsuc69wuYjnsSLC",
672s     "Device": ["FileChgr1"],
672s     "MediaType": "File1",
672s     "Autochanger": "File1",
672s     "MaximumConcurrentJobs": 10
672s   }
672s },
672s {
672s   "Storage": {
672s     "Name": "File2",
672s     "SdPort": 9103,
672s     "Address": "localhost",
672s     "Password": "s2ds5mdUmZ4M6HVIBKMsuc69wuYjnsSLC",
672s     "Device": ["FileChgr2"],
672s     "MediaType": "File2",
672s     "Autochanger": "File2",
672s     "MaximumConcurrentJobs": 10
672s   }
672s },
672s {
672s   "Catalog": {
672s     "Name": "MyCatalog",
672s     "Address": "localhost",
672s     "DbPort": 3306,
672s     "Password": "boCFnOjIDrvj",
672s     "User": "bacula",
672s     "DbName": "bacula"
672s   }
672s },
672s {
672s   "Schedule": {
672s     "Name": "WeeklyCycle",
672s     "Run": [
672s      {
672s       "Level": "Full",
672s       "Level": "Full",
672s       "Level": "Full",
672s       "Hour": [23],
672s       "Minute": 5,
672s       "Day": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30],
672s       "Month": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11],
672s       "DayOfWeek": [0],
672s       "WeekOfMonth": [0],
672s       "WeekOfYear": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31, 32, 33, 34, 35, 36, 37, 38, 39, 40, 41, 42, 43, 44, 45, 46, 47, 48, 49, 50, 51, 52, 53]
672s      },
672s      {
672s       "Level": "Differential",
672s       "Level": "Differential",
672s       "Level": "Differential",
672s       "Hour": [23],
672s       "Minute": 5,
672s       "Day": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30],
672s       "Month": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11],
672s       "DayOfWeek": [0],
672s       "WeekOfMonth": [1, 2, 3, 4],
672s       "WeekOfYear": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31, 32, 33, 34, 35, 36, 37, 38, 39, 40, 41, 42, 43, 44, 45, 46, 47, 48, 49, 50, 51, 52, 53]
672s      },
672s      {
672s       "Level": "Incremental",
672s       "Level": "Incremental",
672s       "Level": "Incremental",
672s       "Hour": [23],
672s       "Minute": 5,
672s       "Day": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30],
672s       "Month": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11],
672s       "DayOfWeek": [1, 2, 3, 4, 5, 6],
672s       "WeekOfMonth": [0, 1, 2, 3, 4, 5],
672s       "WeekOfYear": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31, 32, 33, 34, 35, 36, 37, 38, 39, 40, 41, 42, 43, 44, 45, 46, 47, 48, 49, 50, 51, 52, 53]
672s      }
672s     ]
672s   }
672s },
672s {
672s   "Schedule": {
672s     "Name": "WeeklyCycleAfterBackup",
672s     "Run": [
672s      {
672s       "Level": "Full",
672s       "Level": "Full",
672s       "Level": "Full",
672s       "Hour": [23],
672s       "Minute": 10,
672s       "Day": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30],
672s       "Month": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11],
672s       "DayOfWeek": [0, 1, 2, 3, 4, 5, 6],
672s       "WeekOfMonth": [0, 1, 2, 3, 4, 5],
672s       "WeekOfYear": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31, 32, 33, 34, 35, 36, 37, 38, 39, 40, 41, 42, 43, 44, 45, 46, 47, 48, 49, 50, 51, 52, 53]
672s      }
672s     ]
672s   }
672s },
672s {
672s   "Fileset": {
672s     "Name": "Catalog",
672s     "Include": [{
672s       "File": ["/var/lib/bacula/bacula.sql"],
672s       "Options": [ 
672s        {
672s          "Signature": "Md5"
672s        }
672s       ]
672s     }]
672s   }
672s },
672s {
672s   "Fileset": {
672s     "Name": "Full Set",
672s     "Include": [{
672s       "File": ["/usr/sbin"],
672s       "Options": [ 
672s        {
672s          "Signature": "Md5"
672s        }
672s       ]
672s     }],
672s     "Exclude": {
672s       "File":  ["/var/lib/bacula", "/nonexistent/path/to/file/archive/dir", "/proc", "/tmp", "/sys", "/.journal", "/.fsck"]
672s     }
672s   }
672s },
672s {
672s   "Pool": {
672s     "Name": "Default",
672s     "PoolType": "Backup",
672s     "MaximumVolumes": 100,
672s     "MaximumVolumeBytes": 53687091200,
672s     "VolumeRetention": 31536000,
672s     "AutoPrune": true,
672s     "Recycle": true
672s   }
672s },
672s {
672s   "Pool": {
672s     "Name": "File",
672s     "PoolType": "Backup",
672s     "LabelFormat": "Vol-",
672s     "MaximumVolumes": 100,
672s     "MaximumVolumeBytes": 53687091200,
672s     "VolumeRetention": 31536000,
672s     "AutoPrune": true,
672s     "Recycle": true
672s   }
672s },
672s {
672s   "Pool": {
672s     "Name": "Scratch",
672s     "PoolType": "Backup"
672s   }
672s },
672s {
672s   "Messages": {
672s     "Name": "Daemon",
672s     "MailCommand": "/usr/sbin/bsmtp -h localhost -f \"(Bacula) <%r>\" -s \"Bacula daemon message\" %r",
672s     "Destinations": [
672s       {
672s         "Type": "Mail",
672s         "MsgTypes": ["All","!Skipped"],
672s         "Where": ["root"],
672s         "Command": "/usr/sbin/bsmtp -h localhost -f \"(Bacula) <%r>\" -s \"Bacula daemon message\" %r"
672s       },
672s       {
672s         "Type": "Append",
672s         "MsgTypes": ["All","!Skipped"],
672s         "Where": ["/var/log/bacula/bacula.log"]
672s       },
672s       {
672s         "Type": "Console",
672s         "MsgTypes": ["All","!Skipped"]
672s       }
672s     ]
672s   }
672s },
672s {
672s   "Messages": {
672s     "Name": "Standard",
672s     "MailCommand": "/usr/sbin/bsmtp -h localhost -f \"(Bacula) <%r>\" -s \"Bacula: %t %e of %c %l\" %r",
672s     "OperatorCommand": "/usr/sbin/bsmtp -h localhost -f \"(Bacula) <%r>\" -s \"Bacula: Intervention needed for %j\" %r",
672s     "Destinations": [
672s       {
672s         "Type": "Mail",
672s         "MsgTypes": ["All","!Skipped"],
672s         "Where": ["root"],
672s         "Command": "/usr/sbin/bsmtp -h localhost -f \"(Bacula) <%r>\" -s \"Bacula: %t %e of %c %l\" %r"
672s       },
672s       {
672s         "Type": "Append",
672s         "MsgTypes": ["All","!Skipped"],
672s         "Where": ["/var/log/bacula/bacula.log"]
672s       },
672s       {
672s         "Type": "Console",
672s         "MsgTypes": ["All","!Skipped"]
672s       },
672s       {
672s         "Type": "Operator",
672s         "MsgTypes": ["Mount"],
672s         "Where": ["root"],
672s         "Command": "/usr/sbin/bsmtp -h localhost -f \"(Bacula) <%r>\" -s \"Bacula: Intervention needed for %j\" %r"
672s       },
672s       {
672s         "Type": "Catalog",
672s         "MsgTypes": ["All"]
672s       }
672s     ]
672s   }
672s },
672s {
672s   "Console": {
672s     "Name": "autopkgtest-mon",
672s     "Password": "V9k_k7AtLSmjFubaAwCL8-VgREwmD93JU",
672s     "CommandAcl": ["status", ".status"]
672s   }
672s },
672s {
672s   "JobDefs": {
672s     "Name": "DefaultJob",
672s     "Type": "Backup",
672s     "Level": "Incremental",
672s     "Messages": "Standard",
672s     "Storage": ["File1"],
672s     "Pool": "File",
672s     "Client": "autopkgtest-fd",
672s     "Fileset": "Full Set",
672s     "Schedule": "WeeklyCycle",
672s     "WriteBootstrap": "/var/lib/bacula/%c.bsr",
672s     "SpoolAttributes": true,
672s     "Priority": 10
672s   }
672s }
672s ]
672s + echo
672s 
672s + echo '---- Testing /usr/sbin/bfdjson ----'
672s ---- Testing /usr/sbin/bfdjson ----
672s + /usr/sbin/bfdjson
672s [{
672s   "Director": {
672s     "Name": "autopkgtest-dir",
672s     "Password": "QKOh-yXlJWNjuxo8yxgGRmF-6EyXVEMvq"
672s   }
672s },
672s {
672s   "Director": {
672s     "Name": "autopkgtest-mon",
672s     "Password": "w3ajvGV1HYM8Z0ftrawTDA0rs7QpHyLy7",
672s     "Monitor": true
672s   }
672s },
672s {
672s   "FileDaemon": {
672s     "Name": "autopkgtest-fd",
672s     "FdAddress": "127.0.0.1",
672s     "WorkingDirectory": "/var/lib/bacula",
672s     "PidDirectory": "/run/bacula",
672s     "PluginDirectory": "/usr/lib/bacula",
672s     "MaximumConcurrentJobs": 20
672s   }
672s },
672s {
672s   "Messages": {
672s     "Name": "Standard",
672s     "Destinations": [
672s       {
672s         "Type": "Director",
672s         "MsgTypes": ["All","!Skipped","!Restored","!Verified"],
672s         "Where": ["autopkgtest-dir"]
672s       }
672s     ]
672s   }
672s }
672s ]
672s + echo
672s 
672s + echo '---- Testing /usr/sbin/bsdjson ----'
672s ---- Testing /usr/sbin/bsdjson ----
672s + /usr/sbin/bsdjson
672s [
672s {
672s   "Director": {
672s     "Name": "autopkgtest-dir",
672s     "Password": "s2ds5mdUmZ4M6HVIBKMsuc69wuYjnsSLC"
672s   }
672s },
672s {
672s   "Director": {
672s     "Name": "autopkgtest-mon",
672s     "Password": "aeL7pdgfLixNkN1TmJDbrCpK0TQEuYQq-",
672s     "Monitor": true
672s   }
672s },
672s {
672s   "Storage": {
672s     "Name": "autopkgtest-sd",
672s     "SdAddress": "127.0.0.1",
672s     "WorkingDirectory": "/var/lib/bacula",
672s     "PidDirectory": "/run/bacula",
672s     "PluginDirectory": "/usr/lib/bacula",
672s     "MaximumConcurrentJobs": 20
672s   }
672s },
672s {
672s   "Device": {
672s     "Name": "FileChgr1-Dev1",
672s     "MediaType": "File1",
672s     "ArchiveDevice": "/nonexistent/path/to/file/archive/dir",
672s     "RemovableMedia": false,
672s     "RandomAccess": true,
672s     "AutomaticMount": true,
672s     "LabelMedia": true,
672s     "AlwaysOpen": false,
672s     "MaximumConcurrentJobs": 5
672s   }
672s },
672s {
672s   "Device": {
672s     "Name": "FileChgr1-Dev2",
672s     "MediaType": "File1",
672s     "ArchiveDevice": "/nonexistent/path/to/file/archive/dir",
672s     "RemovableMedia": false,
672s     "RandomAccess": true,
672s     "AutomaticMount": true,
672s     "LabelMedia": true,
672s     "AlwaysOpen": false,
672s     "MaximumConcurrentJobs": 5
672s   }
672s },
672s {
672s   "Device": {
672s     "Name": "FileChgr2-Dev1",
672s     "MediaType": "File2",
672s     "ArchiveDevice": "/nonexistent/path/to/file/archive/dir",
672s     "RemovableMedia": false,
672s     "RandomAccess": true,
672s     "AutomaticMount": true,
672s     "LabelMedia": true,
672s     "AlwaysOpen": false,
672s     "MaximumConcurrentJobs": 5
672s   }
672s },
672s {
672s   "Device": {
672s     "Name": "FileChgr2-Dev2",
672s     "MediaType": "File2",
672s     "ArchiveDevice": "/nonexistent/path/to/file/archive/dir",
672s     "RemovableMedia": false,
672s     "RandomAccess": true,
672s     "AutomaticMount": true,
672s     "LabelMedia": true,
672s     "AlwaysOpen": false,
672s     "MaximumConcurrentJobs": 5
672s   }
672s },
672s {
672s   "Messages": {
672s     "Name": "Standard",
672s     "Destinations": [
672s       {
672s         "Type": "Director",
672s         "MsgTypes": ["All"],
672s         "Where": ["autopkgtest-dir"]
672s       }
672s     ]
672s   }
672s },
672s {
672s   "Autochanger": {
672s     "Name": "FileChgr1",
672s     "Device": ["FileChgr1-Dev1", "FileChgr1-Dev2"],
672s     "ChangerDevice": "/dev/null",
672s     "ChangerCommand": ""
672s   }
672s },
672s {
672s   "Autochanger": {
672s     "Name": "FileChgr2",
672s     "Device": ["FileChgr2-Dev1", "FileChgr2-Dev2"],
672s     "ChangerDevice": "/dev/null",
672s     "ChangerCommand": ""
672s   }
672s }
672s ]
672s autopkgtest [08:47:22]: test program-test-mysql: -----------------------]
673s autopkgtest [08:47:23]: test program-test-mysql:  - - - - - - - - - - results - - - - - - - - - -
673s program-test-mysql   PASS
673s autopkgtest [08:47:23]: test backup-test-sqlite3: preparing testbed
806s autopkgtest [08:49:36]: testbed dpkg architecture: s390x
806s autopkgtest [08:49:36]: testbed apt version: 3.0.0
806s autopkgtest [08:49:36]: @@@@@@@@@@@@@@@@@@@@ test bed setup
806s autopkgtest [08:49:36]: testbed release detected to be: questing
807s autopkgtest [08:49:37]: updating testbed package index (apt update)
807s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [110 kB]
807s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease
808s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease
808s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease
808s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [44.4 kB]
808s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [2076 kB]
808s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [175 kB]
808s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main s390x Packages [208 kB]
808s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/universe s390x Packages [1079 kB]
808s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/multiverse s390x Packages [9148 B]
808s Fetched 3701 kB in 1s (2685 kB/s)
809s Reading package lists...
810s autopkgtest [08:49:40]: upgrading testbed (apt dist-upgrade and autopurge)
810s Reading package lists...
810s Building dependency tree...
810s Reading state information...
810s Calculating upgrade...Starting pkgProblemResolver with broken count: 0
810s Starting 2 pkgProblemResolver with broken count: 0
810s Done
811s Entering ResolveByKeep
811s 
811s Calculating upgrade...
811s The following packages will be upgraded:
811s   htop nano ucf
811s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
811s Need to get 532 kB of archives.
811s After this operation, 4096 B of additional disk space will be used.
811s Get:1 http://ftpmaster.internal/ubuntu questing-proposed/main s390x ucf all 3.0051 [43.6 kB]
811s Get:2 http://ftpmaster.internal/ubuntu questing/main s390x nano s390x 8.4-1 [299 kB]
812s Get:3 http://ftpmaster.internal/ubuntu questing/main s390x htop s390x 3.4.1-4 [189 kB]
812s Preconfiguring packages ...
812s Fetched 532 kB in 1s (772 kB/s)
812s (Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 81472 files and directories currently installed.)
812s Preparing to unpack .../archives/ucf_3.0051_all.deb ...
812s Unpacking ucf (3.0051) over (3.0050) ...
812s Preparing to unpack .../archives/nano_8.4-1_s390x.deb ...
812s Unpacking nano (8.4-1) over (8.3-1) ...
812s Preparing to unpack .../htop_3.4.1-4_s390x.deb ...
812s Unpacking htop (3.4.1-4) over (3.4.0-2) ...
812s Setting up htop (3.4.1-4) ...
812s Setting up ucf (3.0051) ...
812s Setting up nano (8.4-1) ...
812s Installing new version of config file /etc/nanorc ...
812s Processing triggers for man-db (2.13.0-1) ...
813s Processing triggers for install-info (7.1.1-1) ...
813s Reading package lists...
813s Building dependency tree...
813s Reading state information...
814s Starting pkgProblemResolver with broken count: 0
814s Starting 2 pkgProblemResolver with broken count: 0
814s Done
814s Solving dependencies...
814s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
817s Reading package lists...
817s Building dependency tree...
817s Reading state information...
817s Starting pkgProblemResolver with broken count: 0
817s Starting 2 pkgProblemResolver with broken count: 0
817s Done
817s The following NEW packages will be installed:
817s   bacula bacula-bscan bacula-client bacula-common bacula-common-sqlite3
817s   bacula-console bacula-director bacula-director-sqlite3 bacula-fd bacula-sd
817s   bacula-server bsd-mailx dbconfig-common dbconfig-pgsql dbconfig-sqlite3
817s   liblockfile-bin liblockfile1 libpq5 mtx postfix postgresql-client
817s   postgresql-client-17 postgresql-client-common sqlite3
817s 0 upgraded, 24 newly installed, 0 to remove and 0 not upgraded.
817s Need to get 5438 kB of archives.
817s After this operation, 17.1 MB of additional disk space will be used.
817s Get:1 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-common s390x 13.0.4-4build1 [854 kB]
818s Get:2 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-common-sqlite3 s390x 13.0.4-4build1 [10.8 kB]
818s Get:3 http://ftpmaster.internal/ubuntu questing/universe s390x dbconfig-common all 2.0.24 [596 kB]
818s Get:4 http://ftpmaster.internal/ubuntu questing/main s390x sqlite3 s390x 3.46.1-3 [157 kB]
818s Get:5 http://ftpmaster.internal/ubuntu questing/universe s390x dbconfig-sqlite3 all 2.0.24 [892 B]
818s Get:6 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-director-sqlite3 all 13.0.4-4build1 [31.6 kB]
818s Get:7 http://ftpmaster.internal/ubuntu questing/main s390x postfix s390x 3.9.1-10ubuntu1 [1305 kB]
818s Get:8 http://ftpmaster.internal/ubuntu questing/main s390x liblockfile-bin s390x 1.17-2 [11.5 kB]
818s Get:9 http://ftpmaster.internal/ubuntu questing/main s390x liblockfile1 s390x 1.17-2 [6970 B]
818s Get:10 http://ftpmaster.internal/ubuntu questing/main s390x bsd-mailx s390x 8.1.2-0.20220412cvs-1build1 [69.7 kB]
818s Get:11 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-director s390x 13.0.4-4build1 [379 kB]
818s Get:12 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-fd s390x 13.0.4-4build1 [144 kB]
818s Get:13 http://ftpmaster.internal/ubuntu questing/main s390x mtx s390x 1.3.12-18 [43.2 kB]
818s Get:14 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-sd s390x 13.0.4-4build1 [151 kB]
818s Get:15 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-console s390x 13.0.4-4build1 [28.6 kB]
819s Get:16 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-client all 13.0.4-4build1 [23.5 kB]
819s Get:17 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-bscan s390x 13.0.4-4build1 [24.7 kB]
819s Get:18 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-server all 13.0.4-4build1 [23.4 kB]
819s Get:19 http://ftpmaster.internal/ubuntu questing/universe s390x bacula all 13.0.4-4build1 [1036 B]
819s Get:20 http://ftpmaster.internal/ubuntu questing/main s390x libpq5 s390x 17.4-1 [147 kB]
819s Get:21 http://ftpmaster.internal/ubuntu questing/main s390x postgresql-client-common all 274 [47.6 kB]
819s Get:22 http://ftpmaster.internal/ubuntu questing/main s390x postgresql-client-17 s390x 17.4-1 [1367 kB]
819s Get:23 http://ftpmaster.internal/ubuntu questing/main s390x postgresql-client all 17+274 [13.3 kB]
819s Get:24 http://ftpmaster.internal/ubuntu questing/universe s390x dbconfig-pgsql all 2.0.24 [914 B]
819s Preconfiguring packages ...
819s Fetched 5438 kB in 2s (3084 kB/s)
819s Selecting previously unselected package bacula-common.
819s (Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 81472 files and directories currently installed.)
819s Preparing to unpack .../00-bacula-common_13.0.4-4build1_s390x.deb ...
819s Adding user 'bacula'... Ok.
819s Unpacking bacula-common (13.0.4-4build1) ...
819s Selecting previously unselected package bacula-common-sqlite3.
819s Preparing to unpack .../01-bacula-common-sqlite3_13.0.4-4build1_s390x.deb ...
819s Unpacking bacula-common-sqlite3 (13.0.4-4build1) ...
819s Selecting previously unselected package dbconfig-common.
819s Preparing to unpack .../02-dbconfig-common_2.0.24_all.deb ...
819s Unpacking dbconfig-common (2.0.24) ...
819s Selecting previously unselected package sqlite3.
819s Preparing to unpack .../03-sqlite3_3.46.1-3_s390x.deb ...
819s Unpacking sqlite3 (3.46.1-3) ...
819s Selecting previously unselected package dbconfig-sqlite3.
819s Preparing to unpack .../04-dbconfig-sqlite3_2.0.24_all.deb ...
819s Unpacking dbconfig-sqlite3 (2.0.24) ...
819s Selecting previously unselected package bacula-director-sqlite3.
819s Preparing to unpack .../05-bacula-director-sqlite3_13.0.4-4build1_all.deb ...
819s Unpacking bacula-director-sqlite3 (13.0.4-4build1) ...
819s Selecting previously unselected package postfix.
819s Preparing to unpack .../06-postfix_3.9.1-10ubuntu1_s390x.deb ...
819s Unpacking postfix (3.9.1-10ubuntu1) ...
819s Selecting previously unselected package liblockfile-bin.
819s Preparing to unpack .../07-liblockfile-bin_1.17-2_s390x.deb ...
819s Unpacking liblockfile-bin (1.17-2) ...
819s Selecting previously unselected package liblockfile1:s390x.
819s Preparing to unpack .../08-liblockfile1_1.17-2_s390x.deb ...
819s Unpacking liblockfile1:s390x (1.17-2) ...
819s Selecting previously unselected package bsd-mailx.
819s Preparing to unpack .../09-bsd-mailx_8.1.2-0.20220412cvs-1build1_s390x.deb ...
819s Unpacking bsd-mailx (8.1.2-0.20220412cvs-1build1) ...
819s Selecting previously unselected package bacula-director.
819s Preparing to unpack .../10-bacula-director_13.0.4-4build1_s390x.deb ...
819s Unpacking bacula-director (13.0.4-4build1) ...
819s Selecting previously unselected package bacula-fd.
820s Preparing to unpack .../11-bacula-fd_13.0.4-4build1_s390x.deb ...
820s Unpacking bacula-fd (13.0.4-4build1) ...
820s Selecting previously unselected package mtx.
820s Preparing to unpack .../12-mtx_1.3.12-18_s390x.deb ...
820s Unpacking mtx (1.3.12-18) ...
820s Selecting previously unselected package bacula-sd.
820s Preparing to unpack .../13-bacula-sd_13.0.4-4build1_s390x.deb ...
820s Unpacking bacula-sd (13.0.4-4build1) ...
820s Selecting previously unselected package bacula-console.
820s Preparing to unpack .../14-bacula-console_13.0.4-4build1_s390x.deb ...
820s Unpacking bacula-console (13.0.4-4build1) ...
820s Selecting previously unselected package bacula-client.
820s Preparing to unpack .../15-bacula-client_13.0.4-4build1_all.deb ...
820s Unpacking bacula-client (13.0.4-4build1) ...
820s Selecting previously unselected package bacula-bscan.
820s Preparing to unpack .../16-bacula-bscan_13.0.4-4build1_s390x.deb ...
820s Unpacking bacula-bscan (13.0.4-4build1) ...
820s Selecting previously unselected package bacula-server.
820s Preparing to unpack .../17-bacula-server_13.0.4-4build1_all.deb ...
820s Unpacking bacula-server (13.0.4-4build1) ...
820s Selecting previously unselected package bacula.
820s Preparing to unpack .../18-bacula_13.0.4-4build1_all.deb ...
820s Unpacking bacula (13.0.4-4build1) ...
820s Selecting previously unselected package libpq5:s390x.
820s Preparing to unpack .../19-libpq5_17.4-1_s390x.deb ...
820s Unpacking libpq5:s390x (17.4-1) ...
820s Selecting previously unselected package postgresql-client-common.
820s Preparing to unpack .../20-postgresql-client-common_274_all.deb ...
820s Unpacking postgresql-client-common (274) ...
820s Selecting previously unselected package postgresql-client-17.
820s Preparing to unpack .../21-postgresql-client-17_17.4-1_s390x.deb ...
820s Unpacking postgresql-client-17 (17.4-1) ...
820s Selecting previously unselected package postgresql-client.
820s Preparing to unpack .../22-postgresql-client_17+274_all.deb ...
820s Unpacking postgresql-client (17+274) ...
820s Selecting previously unselected package dbconfig-pgsql.
820s Preparing to unpack .../23-dbconfig-pgsql_2.0.24_all.deb ...
820s Unpacking dbconfig-pgsql (2.0.24) ...
820s Setting up postgresql-client-common (274) ...
820s Setting up liblockfile-bin (1.17-2) ...
820s Setting up libpq5:s390x (17.4-1) ...
820s Setting up mtx (1.3.12-18) ...
820s Setting up dbconfig-common (2.0.24) ...
820s Creating config file /etc/dbconfig-common/config with new version
820s Setting up bacula-common (13.0.4-4build1) ...
820s Setting up bacula-sd (13.0.4-4build1) ...
820s Creating config file /etc/default/bacula-sd with new version
820s Creating config file /etc/bacula/bacula-sd.conf with new version
821s Created symlink '/etc/systemd/system/multi-user.target.wants/bacula-sd.service' → '/usr/lib/systemd/system/bacula-sd.service'.

821s Setting up bacula-console (13.0.4-4build1) ...
821s Creating config file /etc/bacula/bconsole.conf with new version
821s Setting up postfix (3.9.1-10ubuntu1) ...
821s Created symlink '/etc/systemd/system/multi-user.target.wants/postfix.service' → '/usr/lib/systemd/system/postfix.service'.

821s info: Selecting UID from range 100 to 999 ...
821s 
821s info: Selecting GID from range 100 to 999 ...
821s info: Adding system user `postfix' (UID 108) ...
821s info: Adding new group `postfix' (GID 113) ...
821s info: Adding new user `postfix' (UID 108) with group `postfix' ...
821s info: Not creating home directory `/var/spool/postfix'.
821s info: Selecting GID from range 100 to 999 ...
821s info: Adding group `postdrop' (GID 114) ...
821s Creating /etc/postfix/dynamicmaps.cf
821s setting myhostname: autopkgtest.local
821s setting alias maps
821s setting alias database
821s changing /etc/mailname to autopkgtest.local
821s setting myorigin
821s setting destinations: $myhostname, autopkgtest.local, localhost.local, , localhost
821s setting relayhost: 
821s setting mynetworks: 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128
821s clearing mailbox_command
821s setting mailbox_size_limit: 0
822s setting recipient_delimiter: +
823s setting inet_interfaces: all
825s setting inet_protocols: all
825s /etc/aliases does not exist, creating it.
825s WARNING: /etc/aliases exists, but does not have a root alias.
825s 
825s Postfix (main.cf) is now set up with a default configuration.  If you need to 
825s make changes, edit /etc/postfix/main.cf (and others) as needed.  To view 
825s Postfix configuration values, see postconf(1).
825s 
825s After modifying main.cf, be sure to run 'systemctl reload postfix'.
825s 
827s Setting up bacula-common-sqlite3 (13.0.4-4build1) ...
827s Setting up liblockfile1:s390x (1.17-2) ...
827s Setting up bacula-bscan (13.0.4-4build1) ...
827s Setting up sqlite3 (3.46.1-3) ...
827s Setting up bacula-fd (13.0.4-4build1) ...
827s Creating config file /etc/default/bacula-fd with new version
827s Creating config file /etc/bacula/bacula-fd.conf with new version
828s Created symlink '/etc/systemd/system/multi-user.target.wants/bacula-fd.service' → '/usr/lib/systemd/system/bacula-fd.service'.

828s Setting up bacula-client (13.0.4-4build1) ...
828s Setting up postgresql-client-17 (17.4-1) ...
828s 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
828s Setting up dbconfig-pgsql (2.0.24) ...
828s Setting up bsd-mailx (8.1.2-0.20220412cvs-1build1) ...
828s update-alternatives: using /usr/bin/bsd-mailx to provide /usr/bin/mailx (mailx) in auto mode
828s Setting up dbconfig-sqlite3 (2.0.24) ...
828s Setting up postgresql-client (17+274) ...
828s Setting up bacula-director-sqlite3 (13.0.4-4build1) ...
828s dbconfig-common: writing config to /etc/dbconfig-common/bacula-director-sqlite3.conf
828s Creating config file /etc/dbconfig-common/bacula-director-sqlite3.conf with new version
828s creating database bacula.db: success.
828s verifying database bacula.db exists: success.
828s populating database via sql...  done.
828s Setting up bacula-director (13.0.4-4build1) ...
828s Creating config file /etc/default/bacula-dir with new version
829s Creating config file /etc/bacula/bacula-dir.conf with new version
829s Creating config file /etc/bacula/scripts/delete_catalog_backup with new version
829s Creating config file /etc/bacula/scripts/make_catalog_backup with new version
829s Created symlink '/etc/systemd/system/bacula-dir.service' → '/usr/lib/systemd/system/bacula-director.service'.

829s Created symlink '/etc/systemd/system/multi-user.target.wants/bacula-director.service' → '/usr/lib/systemd/system/bacula-director.service'.

829s Setting up bacula-server (13.0.4-4build1) ...
829s Setting up bacula (13.0.4-4build1) ...
829s Processing triggers for rsyslog (8.2412.0-2ubuntu2) ...
830s Processing triggers for ufw (0.36.2-9) ...
830s Processing triggers for man-db (2.13.0-1) ...
830s Processing triggers for libc-bin (2.41-6ubuntu1) ...
831s Processing triggers for postfix (3.9.1-10ubuntu1) ...
831s Restarting postfix
836s autopkgtest [08:50:06]: test backup-test-sqlite3: [-----------------------
836s + apt-get -y install debconf-utils
836s Reading package lists...
836s Building dependency tree...
836s Reading state information...
837s Solving dependencies...
837s The following NEW packages will be installed:
837s   debconf-utils
837s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded.
837s Need to get 49.5 kB of archives.
837s After this operation, 99.3 kB of additional disk space will be used.
837s Get:1 http://ftpmaster.internal/ubuntu questing/universe s390x debconf-utils all 1.5.87ubuntu1 [49.5 kB]
837s Fetched 49.5 kB in 0s (163 kB/s)
837s Selecting previously unselected package debconf-utils.
837s (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 ... 82561 files and directories currently installed.)
837s Preparing to unpack .../debconf-utils_1.5.87ubuntu1_all.deb ...
837s Unpacking debconf-utils (1.5.87ubuntu1) ...
837s Setting up debconf-utils (1.5.87ubuntu1) ...
837s Processing triggers for man-db (2.13.0-1) ...
838s + debconf-get-selections
838s + debconf-set-selections
838s + awk '$3=="password"{print}'
838s + for pkg in bacula-director-mysql bacula-director-pgsql
838s ++ dpkg-query --showformat '${db:Status-Status}' -W bacula-director-mysql
838s + pkg_status=not-installed
838s + '[' not-installed = installed ']'
838s + for pkg in bacula-director-mysql bacula-director-pgsql
838s ++ dpkg-query --showformat '${db:Status-Status}' -W bacula-director-pgsql
838s + pkg_status=not-installed
838s + '[' not-installed = installed ']'
838s + echo 'start testing ... '
838s start testing ... 
838s + echo 'USER: root'
838s USER: root
838s + DBTYPE=sqlite3
838s + echo 'DBTYPE: sqlite3'
838s DBTYPE: sqlite3
838s + echo '--------- configuring Bacula daemons -----------'
838s --------- configuring Bacula daemons -----------
838s + FILECHGRDIR=/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr
838s + RESTOREDIR=/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-restores
838s + mkdir -p /tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr
838s + chown -R bacula:tape /tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr
838s + sed -i s%/nonexistent/path/to/file/archive/dir%/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr% /etc/bacula/bacula-sd.conf
838s + sed -i 's%Where = /nonexistent/path/to/file/archive/dir/bacula-restores%Where = /tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-restores%' /etc/bacula/bacula-dir.conf
838s + sed -i 's/signature = MD5/signature = SHA1/' /etc/bacula/bacula-dir.conf
838s + sed -i 's/signature = MD5/signature = SHA1\naclsupport = yes/' /etc/bacula/bacula-dir.conf
838s + echo '--------- restarting services ----------- '
838s --------- restarting services ----------- 
838s + service bacula-director restart
838s + service bacula-sd restart
839s + service bacula-fd restart
839s + sleep 10
849s + echo '--------- checking services ----------- '
849s --------- checking services ----------- 
849s + service bacula-director status
849s ● bacula-director.service - Bacula Director Daemon service
849s      Loaded: loaded (/usr/lib/systemd/system/bacula-director.service; enabled; preset: enabled)
849s      Active: active (running) since Fri 2025-05-02 08:50:08 UTC; 10s ago
849s  Invocation: 3dac7d01c6d94a6487e8e1cd238e58c7
849s        Docs: man:bacula-dir(8)
849s     Process: 4698 ExecStartPre=/usr/sbin/bacula-dir -t -c $CONFIG (code=exited, status=0/SUCCESS)
849s    Main PID: 4701 (bacula-dir)
849s       Tasks: 5 (limit: 4767)
849s      Memory: 2.2M (peak: 2.5M)
849s         CPU: 19ms
849s      CGroup: /system.slice/bacula-director.service
849s              └─4701 /usr/sbin/bacula-dir -fP -c /etc/bacula/bacula-dir.conf
849s 
849s May 02 08:50:08 autopkgtest systemd[1]: Starting bacula-director.service - Bacula Director Daemon service...
849s May 02 08:50:08 autopkgtest systemd[1]: Started bacula-director.service - Bacula Director Daemon service.
849s + service bacula-sd status
849s ● bacula-sd.service - Bacula Storage Daemon service
849s      Loaded: loaded (/usr/lib/systemd/system/bacula-sd.service; enabled; preset: enabled)
849s      Active: active (running) since Fri 2025-05-02 08:50:09 UTC; 10s ago
849s  Invocation: 914d1bfdb0c346c5a21e5add1b33e47f
849s        Docs: man:bacula-sd(8)
849s     Process: 4710 ExecStartPre=/usr/sbin/bacula-sd -t -c $CONFIG (code=exited, status=0/SUCCESS)
849s    Main PID: 4712 (bacula-sd)
849s       Tasks: 3 (limit: 4767)
849s      Memory: 1.8M (peak: 2M)
849s         CPU: 18ms
849s      CGroup: /system.slice/bacula-sd.service
849s              └─4712 /usr/sbin/bacula-sd -fP -c /etc/bacula/bacula-sd.conf
849s 
849s May 02 08:50:09 autopkgtest systemd[1]: Starting bacula-sd.service - Bacula Storage Daemon service...
849s May 02 08:50:09 autopkgtest systemd[1]: Started bacula-sd.service - Bacula Storage Daemon service.
849s + service bacula-fd status
849s ● bacula-fd.service - Bacula File Daemon service
849s      Loaded: loaded (/usr/lib/systemd/system/bacula-fd.service; enabled; preset: enabled)
849s      Active: active (running) since Fri 2025-05-02 08:50:09 UTC; 10s ago
849s  Invocation: b41710c66d2a4d83918d99b95a08bd11
849s        Docs: man:bacula-fd(8)
849s     Process: 4720 ExecStartPre=/usr/sbin/bacula-fd -t -c $CONFIG (code=exited, status=0/SUCCESS)
849s    Main PID: 4721 (bacula-fd)
849s       Tasks: 3 (limit: 4767)
849s      Memory: 1.6M (peak: 2M)
849s         CPU: 14ms
849s      CGroup: /system.slice/bacula-fd.service
849s              └─4721 /usr/sbin/bacula-fd -fP -c /etc/bacula/bacula-fd.conf
849s 
849s May 02 08:50:09 autopkgtest systemd[1]: Starting bacula-fd.service - Bacula File Daemon service...
849s May 02 08:50:09 autopkgtest systemd[1]: Started bacula-fd.service - Bacula File Daemon service.
849s + ps auwwwx
849s + grep '[b]acula'
849s bacula      4701  0.0  0.3 316044 12480 ?        Ssl  08:50   0:00 /usr/sbin/bacula-dir -fP -c /etc/bacula/bacula-dir.conf
849s bacula      4712  0.0  0.2 166088 10540 ?        Ssl  08:50   0:00 /usr/sbin/bacula-sd -fP -c /etc/bacula/bacula-sd.conf
849s root        4721  0.0  0.2 165972 10000 ?        Ssl  08:50   0:00 /usr/sbin/bacula-fd -fP -c /etc/bacula/bacula-fd.conf
849s + echo '----- create some file to test backup / restore ----'
849s ----- create some file to test backup / restore ----
849s + BACKUP_TEST_FILE=/usr/sbin/bacula-backup.test
849s + echo 'bacula restore test'
849s + chown nobody:shadow /usr/sbin/bacula-backup.test
849s + chmod 2755 /usr/sbin/bacula-backup.test
849s + echo '---- status of all daemons ----'
849s ---- status of all daemons ----
849s + echo -e 'status all'
849s + bconsole
849s Connecting to Director localhost:9101
849s 1000 OK: 10002 autopkgtest-dir Version: 13.0.4 (12 February 2024)
849s Enter a period to cancel a command.
849s status all
849s autopkgtest-dir Version: 13.0.4 (12 February 2024) s390x-ibm-linux-gnu ubuntu 25.04
849s Daemon started 02-May-25 08:50, conf reloaded 02-May-2025 08:50:08
849s  Jobs: run=0, running=0 mode=0,0
849s  Crypto: fips=N/A crypto=OpenSSL 3.4.0 22 Oct 2024
849s  Heap: heap=958,464 smbytes=335,398 max_bytes=335,398 bufs=394 max_bufs=394
849s  Res: njobs=3 nclients=1 nstores=2 npools=3 ncats=1 nfsets=2 nscheds=2
849s 
849s Scheduled Jobs:
849s Level          Type     Pri  Scheduled          Job Name           Volume
849s ===================================================================================
849s Incremental    Backup    10  02-May-25 23:05    BackupClient1      *unknown*
849s Full           Backup    11  02-May-25 23:10    BackupCatalog      *unknown*
849s ====
849s 
849s Running Jobs:
849s Console connected using TLS at 02-May-25 08:50
849s No Jobs running.
849s ====
849s No Terminated Jobs.
849s ====
849s Connecting to Storage daemon File1 at localhost:9103
849s 
849s autopkgtest-sd Version: 13.0.4 (12 February 2024) s390x-ibm-linux-gnu ubuntu 25.04
849s Daemon started 02-May-25 08:50. Jobs: run=0, running=0.
849s  Ulimits: nofile=1024 memlock=unlimited status=nofile
849s  Heap: heap=643,072 smbytes=228,774 max_bytes=306,926 bufs=267 max_bufs=268
849s  Sizes: boffset_t=8 size_t=8 int32_t=4 int64_t=8 mode=0,0 newbsr=0
849s  Crypto: fips=N/A crypto=OpenSSL 3.4.0 22 Oct 2024
849s  Res: ndevices=4 nautochgr=2
849s 
849s Running Jobs:
849s Director connected using TLS at: 02-May-25 08:50
849s No Jobs running.
849s ====
849s 
849s Jobs waiting to reserve a drive:
849s ====
849s 
849s Terminated Jobs:
849s ====
849s 
849s Device status:
849s Autochanger "FileChgr1" with devices:
849s    "FileChgr1-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
849s    "FileChgr1-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
849s Autochanger "FileChgr2" with devices:
849s    "FileChgr2-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
849s    "FileChgr2-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
849s 
849s Device File: "FileChgr1-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
849s    Drive 0 is not loaded.
849s    Available Space=18.53 GB
849s ==
849s 
849s Device File: "FileChgr1-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
849s    Drive 0 is not loaded.
849s    Available Space=18.53 GB
849s ==
849s 
849s Device File: "FileChgr2-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
849s    Drive 0 is not loaded.
849s    Available Space=18.53 GB
849s ==
849s 
849s Device File: "FileChgr2-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
849s    Drive 0 is not loaded.
849s    Available Space=18.53 GB
849s ==
849s ====
849s 
849s Used Volume status:
849s ====
849s 
849s ====
849s 
849s Connecting to Client autopkgtest-fd at localhost:9102
849s 
849s autopkgtest-fd Version: 13.0.4 (12 February 2024)  s390x-ibm-linux-gnu ubuntu 25.04
849s Daemon started 02-May-25 08:50. Jobs: run=0 running=0.
849s  Heap: heap=536,576 smbytes=197,902 max_bytes=197,919 bufs=101 max_bufs=101
849s  Sizes: boffset_t=8 size_t=8 debug=0 trace=0 mode=0,0 bwlimit=0kB/s
849s  Crypto: fips=N/A crypto=OpenSSL 3.4.0 22 Oct 2024
849s  Plugin: bpipe-fd.so(2) 
849s 
849s Running Jobs:
849s Director connected using TLS at: 02-May-25 08:50
849s No Jobs running.
849s ====
849s 
849s Terminated Jobs:
849s ====
849s + echo
849s 
849s + echo '---- label a volume ----'
849s ---- label a volume ----
849s + echo -e 'label volume=testvol pool=File storage=File1 drive=0 slot=0'
849s + bconsole
849s Connecting to Director localhost:9101
849s 1000 OK: 10002 autopkgtest-dir Version: 13.0.4 (12 February 2024)
849s Enter a period to cancel a command.
849s label volume=testvol pool=File storage=File1 drive=0 slot=0
849s Automatically selected Catalog: MyCatalog
849s Using Catalog "MyCatalog"
849s Connecting to Storage daemon File1 at localhost:9103 ...
849s Sending label command for Volume "testvol" Slot 0 ...
849s 3000 OK label. VolBytes=226 VolABytes=0 VolType=1 Volume="testvol" Device="FileChgr1-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
849s Catalog record for Volume "testvol", Slot 0  successfully created.
849s Requesting to mount FileChgr1 ...
849s 3906 File device ""FileChgr1-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)" is always mounted.
849s + echo
849s 
849s + echo '----- create some file to test backup / restore ----'
849s ----- create some file to test backup / restore ----
849s + echo 'bacula restore test'
849s + echo
849s 
849s + echo '------ trigger backup job -----'
849s ------ trigger backup job -----
849s + echo -e 'run job=BackupClient1 yes\rwait'
849s + bconsole
849s + grep 'Job queued. JobId='
853s Job queued. JobId=1
853s + bconsole
853s + echo 'status all'
853s Connecting to Director localhost:9101
853s 1000 OK: 10002 autopkgtest-dir Version: 13.0.4 (12 February 2024)
853s Enter a period to cancel a command.
853s status all
853s autopkgtest-dir Version: 13.0.4 (12 February 2024) s390x-ibm-linux-gnu ubuntu 25.04
853s Daemon started 02-May-25 08:50, conf reloaded 02-May-2025 08:50:08
853s  Jobs: run=1, running=0 mode=0,0
853s  Crypto: fips=N/A crypto=OpenSSL 3.4.0 22 Oct 2024
853s  Heap: heap=958,464 smbytes=465,104 max_bytes=491,114 bufs=456 max_bufs=497
853s  Res: njobs=3 nclients=1 nstores=2 npools=3 ncats=1 nfsets=2 nscheds=2
853s 
853s Scheduled Jobs:
853s Level          Type     Pri  Scheduled          Job Name           Volume
853s ===================================================================================
853s Incremental    Backup    10  02-May-25 23:05    BackupClient1      testvol
853s Full           Backup    11  02-May-25 23:10    BackupCatalog      testvol
853s ====
853s 
853s Running Jobs:
853s Console connected using TLS at 02-May-25 08:50
853s No Jobs running.
853s ====
853s 
853s Terminated Jobs:
853s  JobId  Level     Files      Bytes   Status   Finished        Name 
853s ====================================================================
853s      1  Full         590    29.51 M  OK       02-May-25 08:50 BackupClient1
853s 
853s ====
853s Connecting to Storage daemon File1 at localhost:9103
853s 
853s autopkgtest-sd Version: 13.0.4 (12 February 2024) s390x-ibm-linux-gnu ubuntu 25.04
853s Daemon started 02-May-25 08:50. Jobs: run=1, running=0.
853s  Ulimits: nofile=1024 memlock=unlimited status=nofile
853s  Heap: heap=643,072 smbytes=666,508 max_bytes=1,002,145 bufs=283 max_bufs=305
853s  Sizes: boffset_t=8 size_t=8 int32_t=4 int64_t=8 mode=0,0 newbsr=0
853s  Crypto: fips=N/A crypto=OpenSSL 3.4.0 22 Oct 2024
853s  Res: ndevices=4 nautochgr=2
853s 
853s Running Jobs:
853s Director connected using TLS at: 02-May-25 08:50
853s No Jobs running.
853s ====
853s 
853s Jobs waiting to reserve a drive:
853s ====
853s 
853s Terminated Jobs:
853s  JobId  Level    Files      Bytes   Status   Finished        Name 
853s ===================================================================
853s      1  Full        590    29.57 M  OK       02-May-25 08:50 BackupClient1
853s ====
853s 
853s Device status:
853s Autochanger "FileChgr1" with devices:
853s    "FileChgr1-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
853s    "FileChgr1-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
853s Autochanger "FileChgr2" with devices:
853s    "FileChgr2-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
853s    "FileChgr2-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
853s 
853s Device File: "FileChgr1-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
853s    Drive 0 is not loaded.
853s    Available Space=18.51 GB
853s ==
853s 
853s Device File: "FileChgr1-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
853s    Drive 0 is not loaded.
853s    Available Space=18.51 GB
853s ==
853s 
853s Device File: "FileChgr2-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
853s    Drive 0 is not loaded.
853s    Available Space=18.51 GB
853s ==
853s 
853s Device File: "FileChgr2-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
853s    Drive 0 is not loaded.
853s    Available Space=18.51 GB
853s ==
853s ====
853s 
853s Used Volume status:
853s ====
853s 
853s Attr spooling: 0 active jobs, 122,552 bytes; 1 total jobs, 122,552 max bytes.
853s ====
853s 
853s Connecting to Client autopkgtest-fd at localhost:9102
853s 
853s autopkgtest-fd Version: 13.0.4 (12 February 2024)  s390x-ibm-linux-gnu ubuntu 25.04
853s Daemon started 02-May-25 08:50. Jobs: run=1 running=0.
853s  Heap: heap=536,576 smbytes=400,466 max_bytes=662,269 bufs=116 max_bufs=150
853s  Sizes: boffset_t=8 size_t=8 debug=0 trace=0 mode=0,0 bwlimit=0kB/s
853s  Crypto: fips=N/A crypto=OpenSSL 3.4.0 22 Oct 2024
853s  Plugin: bpipe-fd.so(2) 
853s 
853s Running Jobs:
853s Director connected using TLS at: 02-May-25 08:50
853s No Jobs running.
853s ====
853s 
853s Terminated Jobs:
853s  JobId  Level    Files      Bytes   Status   Finished        Name 
853s ===================================================================
853s      1  Full        590    29.51 M  OK       02-May-25 08:50 BackupClient1
853s ====
853s You have messages.
853s + echo
853s 
853s + echo '------ trigger restore job -----'
853s ------ trigger restore job -----
853s + echo -e 'restore select current\rls\rmark usr\rdone\ryes\rwait'
853s + bconsole
853s Connecting to Director localhost:9101
853s 1000 OK: 10002 autopkgtest-dir Version: 13.0.4 (12 February 2024)
853s Enter a period to cancel a command.
853s restore select current
853s Automatically selected Catalog: MyCatalog
853s Using Catalog "MyCatalog"
853s Automatically selected Client: autopkgtest-fd
853s Automatically selected FileSet: Full Set
853s +-------+-------+----------+----------+---------------------+------------+
853s | JobId | Level | JobFiles | JobBytes | StartTime           | VolumeName |
853s +-------+-------+----------+----------+---------------------+------------+
853s | 1     | F     | 590      | 29513240 | 2025-05-02 08:50:22 | testvol    |
853s +-------+-------+----------+----------+---------------------+------------+
853s You have selected the following JobId: 1
853s 
853s Building directory tree for JobId(s) 1 ...  +++++++++++++++++++++++++++++++++++++++++++++++++
853s 589 files inserted into the tree.
853s 
853s You are now entering file selection mode where you add (mark) and
853s remove (unmark) files to be restored. No files are initially added, unless
853s you used the "all" keyword on the command line.
853s Enter "done" to leave this mode.
853s 
853s cwd is: /
853s $ ls
853s usr/
853s $ mark usr
853s 590 files marked.
853s $ done
853s Bootstrap records written to /var/lib/bacula/autopkgtest-dir.restore.1.bsr
853s 
853s The Job will require the following (*=>InChanger):
853s    Volume(s)                 Storage(s)                SD Device(s)
853s ===========================================================================
853s    
853s     testvol                   File1                     FileChgr1                
853s 
853s Volumes marked with "*" are in the Autochanger.
853s 
853s 
853s 590 files selected to be restored.
853s 
853s Using Catalog "MyCatalog"
853s Run Restore job
853s JobName:         RestoreFiles
853s Bootstrap:       /var/lib/bacula/autopkgtest-dir.restore.1.bsr
853s Where:           /tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-restores
853s Replace:         Always
853s FileSet:         Full Set
853s Backup Client:   autopkgtest-fd
853s Restore Client:  autopkgtest-fd
853s Storage:         File1
853s When:            2025-05-02 08:50:23
853s Catalog:         MyCatalog
853s Priority:        10
853s Plugin Options:  *None*
853s OK to run? (yes/mod/no): yes
853s Job queued. JobId=2
853s You have messages.
853s wait
856s + bconsole
856s + echo 'status all'
856s Connecting to Director localhost:9101
856s 1000 OK: 10002 autopkgtest-dir Version: 13.0.4 (12 February 2024)
856s Enter a period to cancel a command.
856s status all
856s autopkgtest-dir Version: 13.0.4 (12 February 2024) s390x-ibm-linux-gnu ubuntu 25.04
856s Daemon started 02-May-25 08:50, conf reloaded 02-May-2025 08:50:08
856s  Jobs: run=2, running=0 mode=0,0
856s  Crypto: fips=N/A crypto=OpenSSL 3.4.0 22 Oct 2024
856s  Heap: heap=860,160 smbytes=464,469 max_bytes=1,672,327 bufs=458 max_bufs=511
856s  Res: njobs=3 nclients=1 nstores=2 npools=3 ncats=1 nfsets=2 nscheds=2
856s 
856s Scheduled Jobs:
856s Level          Type     Pri  Scheduled          Job Name           Volume
856s ===================================================================================
856s Incremental    Backup    10  02-May-25 23:05    BackupClient1      testvol
856s Full           Backup    11  02-May-25 23:10    BackupCatalog      testvol
856s ====
856s 
856s Running Jobs:
856s Console connected using TLS at 02-May-25 08:50
856s No Jobs running.
856s ====
856s 
856s Terminated Jobs:
856s  JobId  Level     Files      Bytes   Status   Finished        Name 
856s ====================================================================
856s      1  Full         590    29.51 M  OK       02-May-25 08:50 BackupClient1
856s      2  Restore      590    29.51 M  OK       02-May-25 08:50 RestoreFiles
856s 
856s ====
856s Connecting to Storage daemon File1 at localhost:9103
856s 
856s autopkgtest-sd Version: 13.0.4 (12 February 2024) s390x-ibm-linux-gnu ubuntu 25.04
856s Daemon started 02-May-25 08:50. Jobs: run=2, running=0.
856s  Ulimits: nofile=1024 memlock=unlimited status=nofile
856s  Heap: heap=536,576 smbytes=639,566 max_bytes=1,002,145 bufs=277 max_bufs=315
856s  Sizes: boffset_t=8 size_t=8 int32_t=4 int64_t=8 mode=0,0 newbsr=0
856s  Crypto: fips=N/A crypto=OpenSSL 3.4.0 22 Oct 2024
856s  Res: ndevices=4 nautochgr=2
856s 
856s Running Jobs:
856s Director connected using TLS at: 02-May-25 08:50
856s No Jobs running.
856s ====
856s 
856s Jobs waiting to reserve a drive:
856s ====
856s 
856s Terminated Jobs:
856s  JobId  Level    Files      Bytes   Status   Finished        Name 
856s ===================================================================
856s      1  Full        590    29.57 M  OK       02-May-25 08:50 BackupClient1
856s      2  Rest        590    29.57 M  OK       02-May-25 08:50 RestoreFiles
856s ====
856s 
856s Device status:
856s Autochanger "FileChgr1" with devices:
856s    "FileChgr1-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
856s    "FileChgr1-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
856s Autochanger "FileChgr2" with devices:
856s    "FileChgr2-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
856s    "FileChgr2-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr)
856s 
856s Device File: "FileChgr1-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
856s    Drive 0 is not loaded.
856s    Available Space=18.47 GB
856s ==
856s 
856s Device File: "FileChgr1-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
856s    Drive 0 is not loaded.
856s    Available Space=18.47 GB
856s ==
856s 
856s Device File: "FileChgr2-Dev1" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
856s    Drive 0 is not loaded.
856s    Available Space=18.47 GB
856s ==
856s 
856s Device File: "FileChgr2-Dev2" (/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-sd/filechgr) is not open.
856s    Drive 0 is not loaded.
856s    Available Space=18.47 GB
856s ==
856s ====
856s 
856s Used Volume status:
856s ====
856s 
856s Attr spooling: 0 active jobs, 122,552 bytes; 1 total jobs, 122,552 max bytes.
856s ====
856s 
856s Connecting to Client autopkgtest-fd at localhost:9102
856s 
857s autopkgtest-fd Version: 13.0.4 (12 February 2024)  s390x-ibm-linux-gnu ubuntu 25.04
857s Daemon started 02-May-25 08:50. Jobs: run=2 running=0.
857s  Heap: heap=528,384 smbytes=239,997 max_bytes=1,114,034 bufs=102 max_bufs=150
857s  Sizes: boffset_t=8 size_t=8 debug=0 trace=0 mode=0,0 bwlimit=0kB/s
857s  Crypto: fips=N/A crypto=OpenSSL 3.4.0 22 Oct 2024
857s  Plugin: bpipe-fd.so(2) 
857s 
857s Running Jobs:
857s Director connected using TLS at: 02-May-25 08:50
857s No Jobs running.
857s ====
857s 
857s Terminated Jobs:
857s  JobId  Level    Files      Bytes   Status   Finished        Name 
857s ===================================================================
857s      1  Full        590    29.51 M  OK       02-May-25 08:50 BackupClient1
857s      2  Rest        590    29.51 M  OK       02-May-25 08:50 RestoreFiles
857s ====
857s You have messages.
857s + grep 'bacula restore test' /tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-restores//usr/sbin/bacula-backup.test
857s bacula restore test
857s + echo
857s 
857s + echo '------ compare original and restore ------'
857s ------ compare original and restore ------
857s + debian/tests/scripts/diff.pl -s /usr/sbin -d /tmp/autopkgtest.qRgwYF/autopkgtest_tmp/bacula-restores/usr/sbin --acl --attr
859s + echo
859s 
859s + echo '------ backup-test end ------'
859s ------ backup-test end ------
859s autopkgtest [08:50:29]: test backup-test-sqlite3: -----------------------]
859s autopkgtest [08:50:29]: test backup-test-sqlite3:  - - - - - - - - - - results - - - - - - - - - -
859s backup-test-sqlite3  PASS
860s autopkgtest [08:50:30]: test program-test-sqlite3: preparing testbed
944s autopkgtest [08:51:54]: testbed dpkg architecture: s390x
944s autopkgtest [08:51:54]: testbed apt version: 3.0.0
944s autopkgtest [08:51:54]: @@@@@@@@@@@@@@@@@@@@ test bed setup
944s autopkgtest [08:51:54]: testbed release detected to be: questing
945s autopkgtest [08:51:55]: updating testbed package index (apt update)
945s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [110 kB]
946s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease
946s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease
946s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease
946s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [44.4 kB]
946s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [2076 kB]
946s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [175 kB]
946s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main s390x Packages [208 kB]
946s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/universe s390x Packages [1079 kB]
946s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/multiverse s390x Packages [9148 B]
947s Fetched 3701 kB in 1s (2884 kB/s)
947s Reading package lists...
948s autopkgtest [08:51:58]: upgrading testbed (apt dist-upgrade and autopurge)
948s Reading package lists...
948s Building dependency tree...
948s Reading state information...
948s Calculating upgrade...Starting pkgProblemResolver with broken count: 0
948s Starting 2 pkgProblemResolver with broken count: 0
948s Done
948s Entering ResolveByKeep
948s 
948s Calculating upgrade...
949s The following packages will be upgraded:
949s   htop nano ucf
949s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
949s Need to get 532 kB of archives.
949s After this operation, 4096 B of additional disk space will be used.
949s Get:1 http://ftpmaster.internal/ubuntu questing-proposed/main s390x ucf all 3.0051 [43.6 kB]
949s Get:2 http://ftpmaster.internal/ubuntu questing/main s390x nano s390x 8.4-1 [299 kB]
949s Get:3 http://ftpmaster.internal/ubuntu questing/main s390x htop s390x 3.4.1-4 [189 kB]
949s Preconfiguring packages ...
949s Fetched 532 kB in 1s (850 kB/s)
950s (Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 81472 files and directories currently installed.)
950s Preparing to unpack .../archives/ucf_3.0051_all.deb ...
950s Unpacking ucf (3.0051) over (3.0050) ...
950s Preparing to unpack .../archives/nano_8.4-1_s390x.deb ...
950s Unpacking nano (8.4-1) over (8.3-1) ...
950s Preparing to unpack .../htop_3.4.1-4_s390x.deb ...
950s Unpacking htop (3.4.1-4) over (3.4.0-2) ...
950s Setting up htop (3.4.1-4) ...
950s Setting up ucf (3.0051) ...
950s Setting up nano (8.4-1) ...
950s Installing new version of config file /etc/nanorc ...
950s Processing triggers for man-db (2.13.0-1) ...
950s Processing triggers for install-info (7.1.1-1) ...
951s Reading package lists...
951s Building dependency tree...
951s Reading state information...
951s Starting pkgProblemResolver with broken count: 0
951s Starting 2 pkgProblemResolver with broken count: 0
951s Done
951s Solving dependencies...
951s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
954s Reading package lists...
954s Building dependency tree...
954s Reading state information...
954s Starting pkgProblemResolver with broken count: 0
954s Starting 2 pkgProblemResolver with broken count: 0
954s Done
954s The following NEW packages will be installed:
954s   bacula bacula-bscan bacula-client bacula-common bacula-common-sqlite3
954s   bacula-console bacula-director bacula-director-sqlite3 bacula-fd bacula-sd
954s   bacula-server bsd-mailx dbconfig-common dbconfig-pgsql dbconfig-sqlite3
954s   liblockfile-bin liblockfile1 libpq5 mtx postfix postgresql-client
954s   postgresql-client-17 postgresql-client-common sqlite3
954s 0 upgraded, 24 newly installed, 0 to remove and 0 not upgraded.
954s Need to get 5438 kB of archives.
954s After this operation, 17.1 MB of additional disk space will be used.
954s Get:1 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-common s390x 13.0.4-4build1 [854 kB]
955s Get:2 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-common-sqlite3 s390x 13.0.4-4build1 [10.8 kB]
955s Get:3 http://ftpmaster.internal/ubuntu questing/universe s390x dbconfig-common all 2.0.24 [596 kB]
955s Get:4 http://ftpmaster.internal/ubuntu questing/main s390x sqlite3 s390x 3.46.1-3 [157 kB]
955s Get:5 http://ftpmaster.internal/ubuntu questing/universe s390x dbconfig-sqlite3 all 2.0.24 [892 B]
955s Get:6 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-director-sqlite3 all 13.0.4-4build1 [31.6 kB]
955s Get:7 http://ftpmaster.internal/ubuntu questing/main s390x postfix s390x 3.9.1-10ubuntu1 [1305 kB]
955s Get:8 http://ftpmaster.internal/ubuntu questing/main s390x liblockfile-bin s390x 1.17-2 [11.5 kB]
955s Get:9 http://ftpmaster.internal/ubuntu questing/main s390x liblockfile1 s390x 1.17-2 [6970 B]
955s Get:10 http://ftpmaster.internal/ubuntu questing/main s390x bsd-mailx s390x 8.1.2-0.20220412cvs-1build1 [69.7 kB]
955s Get:11 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-director s390x 13.0.4-4build1 [379 kB]
955s Get:12 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-fd s390x 13.0.4-4build1 [144 kB]
955s Get:13 http://ftpmaster.internal/ubuntu questing/main s390x mtx s390x 1.3.12-18 [43.2 kB]
955s Get:14 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-sd s390x 13.0.4-4build1 [151 kB]
955s Get:15 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-console s390x 13.0.4-4build1 [28.6 kB]
955s Get:16 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-client all 13.0.4-4build1 [23.5 kB]
955s Get:17 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-bscan s390x 13.0.4-4build1 [24.7 kB]
956s Get:18 http://ftpmaster.internal/ubuntu questing/universe s390x bacula-server all 13.0.4-4build1 [23.4 kB]
956s Get:19 http://ftpmaster.internal/ubuntu questing/universe s390x bacula all 13.0.4-4build1 [1036 B]
956s Get:20 http://ftpmaster.internal/ubuntu questing/main s390x libpq5 s390x 17.4-1 [147 kB]
956s Get:21 http://ftpmaster.internal/ubuntu questing/main s390x postgresql-client-common all 274 [47.6 kB]
956s Get:22 http://ftpmaster.internal/ubuntu questing/main s390x postgresql-client-17 s390x 17.4-1 [1367 kB]
956s Get:23 http://ftpmaster.internal/ubuntu questing/main s390x postgresql-client all 17+274 [13.3 kB]
956s Get:24 http://ftpmaster.internal/ubuntu questing/universe s390x dbconfig-pgsql all 2.0.24 [914 B]
956s Preconfiguring packages ...
956s Fetched 5438 kB in 2s (2787 kB/s)
956s Selecting previously unselected package bacula-common.
956s (Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 81472 files and directories currently installed.)
956s Preparing to unpack .../00-bacula-common_13.0.4-4build1_s390x.deb ...
956s Adding user 'bacula'... Ok.
956s Unpacking bacula-common (13.0.4-4build1) ...
956s Selecting previously unselected package bacula-common-sqlite3.
956s Preparing to unpack .../01-bacula-common-sqlite3_13.0.4-4build1_s390x.deb ...
956s Unpacking bacula-common-sqlite3 (13.0.4-4build1) ...
956s Selecting previously unselected package dbconfig-common.
956s Preparing to unpack .../02-dbconfig-common_2.0.24_all.deb ...
956s Unpacking dbconfig-common (2.0.24) ...
956s Selecting previously unselected package sqlite3.
956s Preparing to unpack .../03-sqlite3_3.46.1-3_s390x.deb ...
956s Unpacking sqlite3 (3.46.1-3) ...
956s Selecting previously unselected package dbconfig-sqlite3.
956s Preparing to unpack .../04-dbconfig-sqlite3_2.0.24_all.deb ...
956s Unpacking dbconfig-sqlite3 (2.0.24) ...
957s Selecting previously unselected package bacula-director-sqlite3.
957s Preparing to unpack .../05-bacula-director-sqlite3_13.0.4-4build1_all.deb ...
957s Unpacking bacula-director-sqlite3 (13.0.4-4build1) ...
957s Selecting previously unselected package postfix.
957s Preparing to unpack .../06-postfix_3.9.1-10ubuntu1_s390x.deb ...
957s Unpacking postfix (3.9.1-10ubuntu1) ...
957s Selecting previously unselected package liblockfile-bin.
957s Preparing to unpack .../07-liblockfile-bin_1.17-2_s390x.deb ...
957s Unpacking liblockfile-bin (1.17-2) ...
957s Selecting previously unselected package liblockfile1:s390x.
957s Preparing to unpack .../08-liblockfile1_1.17-2_s390x.deb ...
957s Unpacking liblockfile1:s390x (1.17-2) ...
957s Selecting previously unselected package bsd-mailx.
957s Preparing to unpack .../09-bsd-mailx_8.1.2-0.20220412cvs-1build1_s390x.deb ...
957s Unpacking bsd-mailx (8.1.2-0.20220412cvs-1build1) ...
957s Selecting previously unselected package bacula-director.
957s Preparing to unpack .../10-bacula-director_13.0.4-4build1_s390x.deb ...
957s Unpacking bacula-director (13.0.4-4build1) ...
957s Selecting previously unselected package bacula-fd.
957s Preparing to unpack .../11-bacula-fd_13.0.4-4build1_s390x.deb ...
957s Unpacking bacula-fd (13.0.4-4build1) ...
957s Selecting previously unselected package mtx.
957s Preparing to unpack .../12-mtx_1.3.12-18_s390x.deb ...
957s Unpacking mtx (1.3.12-18) ...
957s Selecting previously unselected package bacula-sd.
957s Preparing to unpack .../13-bacula-sd_13.0.4-4build1_s390x.deb ...
957s Unpacking bacula-sd (13.0.4-4build1) ...
957s Selecting previously unselected package bacula-console.
957s Preparing to unpack .../14-bacula-console_13.0.4-4build1_s390x.deb ...
957s Unpacking bacula-console (13.0.4-4build1) ...
957s Selecting previously unselected package bacula-client.
957s Preparing to unpack .../15-bacula-client_13.0.4-4build1_all.deb ...
957s Unpacking bacula-client (13.0.4-4build1) ...
957s Selecting previously unselected package bacula-bscan.
957s Preparing to unpack .../16-bacula-bscan_13.0.4-4build1_s390x.deb ...
957s Unpacking bacula-bscan (13.0.4-4build1) ...
957s Selecting previously unselected package bacula-server.
957s Preparing to unpack .../17-bacula-server_13.0.4-4build1_all.deb ...
957s Unpacking bacula-server (13.0.4-4build1) ...
957s Selecting previously unselected package bacula.
957s Preparing to unpack .../18-bacula_13.0.4-4build1_all.deb ...
957s Unpacking bacula (13.0.4-4build1) ...
957s Selecting previously unselected package libpq5:s390x.
957s Preparing to unpack .../19-libpq5_17.4-1_s390x.deb ...
957s Unpacking libpq5:s390x (17.4-1) ...
957s Selecting previously unselected package postgresql-client-common.
957s Preparing to unpack .../20-postgresql-client-common_274_all.deb ...
957s Unpacking postgresql-client-common (274) ...
957s Selecting previously unselected package postgresql-client-17.
957s Preparing to unpack .../21-postgresql-client-17_17.4-1_s390x.deb ...
957s Unpacking postgresql-client-17 (17.4-1) ...
957s Selecting previously unselected package postgresql-client.
957s Preparing to unpack .../22-postgresql-client_17+274_all.deb ...
957s Unpacking postgresql-client (17+274) ...
957s Selecting previously unselected package dbconfig-pgsql.
957s Preparing to unpack .../23-dbconfig-pgsql_2.0.24_all.deb ...
957s Unpacking dbconfig-pgsql (2.0.24) ...
957s Setting up postgresql-client-common (274) ...
957s Setting up liblockfile-bin (1.17-2) ...
957s Setting up libpq5:s390x (17.4-1) ...
957s Setting up mtx (1.3.12-18) ...
957s Setting up dbconfig-common (2.0.24) ...
957s Creating config file /etc/dbconfig-common/config with new version
957s Setting up bacula-common (13.0.4-4build1) ...
957s Setting up bacula-sd (13.0.4-4build1) ...
957s Creating config file /etc/default/bacula-sd with new version
957s Creating config file /etc/bacula/bacula-sd.conf with new version
958s Created symlink '/etc/systemd/system/multi-user.target.wants/bacula-sd.service' → '/usr/lib/systemd/system/bacula-sd.service'.

958s Setting up bacula-console (13.0.4-4build1) ...
958s Creating config file /etc/bacula/bconsole.conf with new version
958s Setting up postfix (3.9.1-10ubuntu1) ...
958s Created symlink '/etc/systemd/system/multi-user.target.wants/postfix.service' → '/usr/lib/systemd/system/postfix.service'.

958s info: Selecting UID from range 100 to 999 ...
958s 
958s info: Selecting GID from range 100 to 999 ...
958s info: Adding system user `postfix' (UID 108) ...
958s info: Adding new group `postfix' (GID 113) ...
958s info: Adding new user `postfix' (UID 108) with group `postfix' ...
958s info: Not creating home directory `/var/spool/postfix'.
958s info: Selecting GID from range 100 to 999 ...
958s info: Adding group `postdrop' (GID 114) ...
958s Creating /etc/postfix/dynamicmaps.cf
959s setting myhostname: autopkgtest.local
959s setting alias maps
959s setting alias database
959s changing /etc/mailname to autopkgtest.local
959s setting myorigin
959s setting destinations: $myhostname, autopkgtest.local, localhost.local, , localhost
959s setting relayhost: 
959s setting mynetworks: 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128
959s clearing mailbox_command
959s setting mailbox_size_limit: 0
959s setting recipient_delimiter: +
960s setting inet_interfaces: all
962s setting inet_protocols: all
962s /etc/aliases does not exist, creating it.
962s WARNING: /etc/aliases exists, but does not have a root alias.
962s 
962s Postfix (main.cf) is now set up with a default configuration.  If you need to 
962s make changes, edit /etc/postfix/main.cf (and others) as needed.  To view 
962s Postfix configuration values, see postconf(1).
962s 
962s After modifying main.cf, be sure to run 'systemctl reload postfix'.
962s 
964s Setting up bacula-common-sqlite3 (13.0.4-4build1) ...
964s Setting up liblockfile1:s390x (1.17-2) ...
964s Setting up bacula-bscan (13.0.4-4build1) ...
964s Setting up sqlite3 (3.46.1-3) ...
964s Setting up bacula-fd (13.0.4-4build1) ...
964s Creating config file /etc/default/bacula-fd with new version
964s Creating config file /etc/bacula/bacula-fd.conf with new version
965s Created symlink '/etc/systemd/system/multi-user.target.wants/bacula-fd.service' → '/usr/lib/systemd/system/bacula-fd.service'.

965s Setting up bacula-client (13.0.4-4build1) ...
965s Setting up postgresql-client-17 (17.4-1) ...
965s 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
965s Setting up dbconfig-pgsql (2.0.24) ...
965s Setting up bsd-mailx (8.1.2-0.20220412cvs-1build1) ...
965s update-alternatives: using /usr/bin/bsd-mailx to provide /usr/bin/mailx (mailx) in auto mode
965s Setting up dbconfig-sqlite3 (2.0.24) ...
965s Setting up postgresql-client (17+274) ...
965s Setting up bacula-director-sqlite3 (13.0.4-4build1) ...
965s dbconfig-common: writing config to /etc/dbconfig-common/bacula-director-sqlite3.conf
965s Creating config file /etc/dbconfig-common/bacula-director-sqlite3.conf with new version
965s creating database bacula.db: success.
965s verifying database bacula.db exists: success.
965s populating database via sql...  done.
965s Setting up bacula-director (13.0.4-4build1) ...
965s Creating config file /etc/default/bacula-dir with new version
965s Creating config file /etc/bacula/bacula-dir.conf with new version
966s Creating config file /etc/bacula/scripts/delete_catalog_backup with new version
966s Creating config file /etc/bacula/scripts/make_catalog_backup with new version
966s Created symlink '/etc/systemd/system/bacula-dir.service' → '/usr/lib/systemd/system/bacula-director.service'.

966s Created symlink '/etc/systemd/system/multi-user.target.wants/bacula-director.service' → '/usr/lib/systemd/system/bacula-director.service'.

966s Setting up bacula-server (13.0.4-4build1) ...
966s Setting up bacula (13.0.4-4build1) ...
966s Processing triggers for rsyslog (8.2412.0-2ubuntu2) ...
966s Processing triggers for ufw (0.36.2-9) ...
967s Processing triggers for man-db (2.13.0-1) ...
967s Processing triggers for libc-bin (2.41-6ubuntu1) ...
967s Processing triggers for postfix (3.9.1-10ubuntu1) ...
967s Restarting postfix
973s autopkgtest [08:52:23]: test program-test-sqlite3: [-----------------------
973s + echo '----- start testing -----'
973s ----- start testing -----
973s + echo 'USER: root'
973s USER: root
973s + DBTYPE=sqlite3
973s + echo '---- Preparing test files ----'
973s ---- Preparing test files ----
973s + DATAFILE=/tmp/autopkgtest.qRgwYF/autopkgtest_tmp/datafile
973s + cat
973s + echo
973s 
973s + echo '---- Testing /usr/sbin/bregex ----'
973s ---- Testing /usr/sbin/bregex ----
973s + echo -en 'line . of the message\r'
973s + /usr/sbin/bregex -f /tmp/autopkgtest.qRgwYF/autopkgtest_tmp/datafile
973s Enter regex pattern:     2: This is line 1 of the message.
973s     3: This is line 2 of the message.
973s     4: This is line 3 of the message.
973s     5: This is line 4 of the message.
973s Enter regex pattern: + echo
973s 
973s + echo '---- Testing /usr/sbin/bwild ----'
973s ---- Testing /usr/sbin/bwild ----
973s + echo -en '*line ? of the message.\r'
973s + /usr/sbin/bwild -f /tmp/autopkgtest.qRgwYF/autopkgtest_tmp/datafile
973s Enter a wild-card:     2: This is line 1 of the message.
973s     3: This is line 2 of the message.
973s     4: This is line 3 of the message.
973s     5: This is line 4 of the message.
973s Enter a wild-card: + echo
973s 
973s + echo '---- Testing /usr/sbin/bbconsjson ----'
973s ---- Testing /usr/sbin/bbconsjson ----
973s + /usr/sbin/bbconsjson
973s [
973s {
973s   "Director": {
973s     "Name": "autopkgtest-dir",
973s     "DirPort": 9101,
973s     "Address": "localhost",
973s     "Password": "n1ezlvAnIse8KiAp5MAMqDuIU572vp24m"
973s    }
973s }
973s ]
973s + echo
973s 
973s + echo '---- Testing /usr/sbin/bdirjson ----'
973s ---- Testing /usr/sbin/bdirjson ----
973s + /usr/sbin/bdirjson
973s [
973s {
973s   "Director": {
973s     "Name": "autopkgtest-dir",
973s     "Messages": "Daemon",
973s     "DirAddress": "127.0.0.1",
973s     "QueryFile": "/etc/bacula/scripts/query.sql",
973s     "WorkingDirectory": "/var/lib/bacula",
973s     "PidDirectory": "/run/bacula",
973s     "MaximumConcurrentJobs": 20,
973s     "Password": "n1ezlvAnIse8KiAp5MAMqDuIU572vp24m"
973s   }
973s },
973s {
973s   "Client": {
973s     "Name": "autopkgtest-fd",
973s     "Address": "localhost",
973s     "FdPort": 9102,
973s     "Password": "bocqacgcHPhT5ePiRJZZ7kJn9Hrdqnb0I",
973s     "Catalog": "MyCatalog",
973s     "FileRetention": 5184000,
973s     "JobRetention": 15552000,
973s     "AutoPrune": true
973s   }
973s },
973s {
973s   "Job": {
973s     "Name": "BackupCatalog",
973s     "Type": "Backup",
973s     "Level": "Full",
973s     "Messages": "Standard",
973s     "Storage": ["File1"],
973s     "Pool": "File",
973s     "Client": "autopkgtest-fd",
973s     "Fileset": "Catalog",
973s     "Schedule": "WeeklyCycleAfterBackup",
973s     "JobDefs": "DefaultJob",
973s     "WriteBootstrap": "/var/lib/bacula/%n.bsr",
973s     "SpoolAttributes": true,
973s     "Runscript": [
973s       {
973s         "RunsWhen": "Before",
973s         "RunsOnClient": false,
973s         "Command": "/etc/bacula/scripts/make_catalog_backup.pl MyCatalog"
973s       },
973s       {
973s         "RunsWhen": "After",
973s         "RunsOnClient": false,
973s         "Command": "/etc/bacula/scripts/delete_catalog_backup"
973s       }
973s     ]
973s ,
973s     "Priority": 11
973s   }
973s },
973s {
973s   "Job": {
973s     "Name": "BackupClient1",
973s     "Type": "Backup",
973s     "Level": "Incremental",
973s     "Messages": "Standard",
973s     "Storage": ["File1"],
973s     "Pool": "File",
973s     "Client": "autopkgtest-fd",
973s     "Fileset": "Full Set",
973s     "Schedule": "WeeklyCycle",
973s     "JobDefs": "DefaultJob",
973s     "WriteBootstrap": "/var/lib/bacula/%c.bsr",
973s     "SpoolAttributes": true,
973s     "Priority": 10
973s   }
973s },
973s {
973s   "Job": {
973s     "Name": "RestoreFiles",
973s     "Type": "Restore",
973s     "Messages": "Standard",
973s     "Storage": ["File1"],
973s     "Pool": "File",
973s     "Client": "autopkgtest-fd",
973s     "Fileset": "Full Set",
973s     "Where": "/nonexistent/path/to/file/archive/dir/bacula-restores"
973s   }
973s },
973s {
973s   "Storage": {
973s     "Name": "File1",
973s     "SdPort": 9103,
973s     "Address": "localhost",
973s     "Password": "gTMPD_u45H0dH1GcgQRg3RscPkGMrp82k",
973s     "Device": ["FileChgr1"],
973s     "MediaType": "File1",
973s     "Autochanger": "File1",
973s     "MaximumConcurrentJobs": 10
973s   }
973s },
973s {
973s   "Storage": {
973s     "Name": "File2",
973s     "SdPort": 9103,
973s     "Address": "localhost",
973s     "Password": "gTMPD_u45H0dH1GcgQRg3RscPkGMrp82k",
973s     "Device": ["FileChgr2"],
973s     "MediaType": "File2",
973s     "Autochanger": "File2",
973s     "MaximumConcurrentJobs": 10
973s   }
973s },
973s {
973s   "Catalog": {
973s     "Name": "MyCatalog",
973s     "Password": "",
973s     "User": "",
973s     "DbName": "bacula"
973s   }
973s },
973s {
973s   "Schedule": {
973s     "Name": "WeeklyCycle",
973s     "Run": [
973s      {
973s       "Level": "Full",
973s       "Level": "Full",
973s       "Level": "Full",
973s       "Hour": [23],
973s       "Minute": 5,
973s       "Day": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30],
973s       "Month": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11],
973s       "DayOfWeek": [0],
973s       "WeekOfMonth": [0],
973s       "WeekOfYear": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31, 32, 33, 34, 35, 36, 37, 38, 39, 40, 41, 42, 43, 44, 45, 46, 47, 48, 49, 50, 51, 52, 53]
973s      },
973s      {
973s       "Level": "Differential",
973s       "Level": "Differential",
973s       "Level": "Differential",
973s       "Hour": [23],
973s       "Minute": 5,
973s       "Day": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30],
973s       "Month": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11],
973s       "DayOfWeek": [0],
973s       "WeekOfMonth": [1, 2, 3, 4],
973s       "WeekOfYear": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31, 32, 33, 34, 35, 36, 37, 38, 39, 40, 41, 42, 43, 44, 45, 46, 47, 48, 49, 50, 51, 52, 53]
973s      },
973s      {
973s       "Level": "Incremental",
973s       "Level": "Incremental",
973s       "Level": "Incremental",
973s       "Hour": [23],
973s       "Minute": 5,
973s       "Day": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30],
973s       "Month": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11],
973s       "DayOfWeek": [1, 2, 3, 4, 5, 6],
973s       "WeekOfMonth": [0, 1, 2, 3, 4, 5],
973s       "WeekOfYear": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31, 32, 33, 34, 35, 36, 37, 38, 39, 40, 41, 42, 43, 44, 45, 46, 47, 48, 49, 50, 51, 52, 53]
973s      }
973s     ]
973s   }
973s },
973s {
973s   "Schedule": {
973s     "Name": "WeeklyCycleAfterBackup",
973s     "Run": [
973s      {
973s       "Level": "Full",
973s       "Level": "Full",
973s       "Level": "Full",
973s       "Hour": [23],
973s       "Minute": 10,
973s       "Day": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30],
973s       "Month": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11],
973s       "DayOfWeek": [0, 1, 2, 3, 4, 5, 6],
973s       "WeekOfMonth": [0, 1, 2, 3, 4, 5],
973s       "WeekOfYear": [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31, 32, 33, 34, 35, 36, 37, 38, 39, 40, 41, 42, 43, 44, 45, 46, 47, 48, 49, 50, 51, 52, 53]
973s      }
973s     ]
973s   }
973s },
973s {
973s   "Fileset": {
973s     "Name": "Catalog",
973s     "Include": [{
973s       "File": ["/var/lib/bacula/bacula.sql"],
973s       "Options": [ 
973s        {
973s          "Signature": "Md5"
973s        }
973s       ]
973s     }]
973s   }
973s },
973s {
973s   "Fileset": {
973s     "Name": "Full Set",
973s     "Include": [{
973s       "File": ["/usr/sbin"],
973s       "Options": [ 
973s        {
973s          "Signature": "Md5"
973s        }
973s       ]
973s     }],
973s     "Exclude": {
973s       "File":  ["/var/lib/bacula", "/nonexistent/path/to/file/archive/dir", "/proc", "/tmp", "/sys", "/.journal", "/.fsck"]
973s     }
973s   }
973s },
973s {
973s   "Pool": {
973s     "Name": "Default",
973s     "PoolType": "Backup",
973s     "MaximumVolumes": 100,
973s     "MaximumVolumeBytes": 53687091200,
973s     "VolumeRetention": 31536000,
973s     "AutoPrune": true,
973s     "Recycle": true
973s   }
973s },
973s {
973s   "Pool": {
973s     "Name": "File",
973s     "PoolType": "Backup",
973s     "LabelFormat": "Vol-",
973s     "MaximumVolumes": 100,
973s     "MaximumVolumeBytes": 53687091200,
973s     "VolumeRetention": 31536000,
973s     "AutoPrune": true,
973s     "Recycle": true
973s   }
973s },
973s {
973s   "Pool": {
973s     "Name": "Scratch",
973s     "PoolType": "Backup"
973s   }
973s },
973s {
973s   "Messages": {
973s     "Name": "Daemon",
973s     "MailCommand": "/usr/sbin/bsmtp -h localhost -f \"(Bacula) <%r>\" -s \"Bacula daemon message\" %r",
973s     "Destinations": [
973s       {
973s         "Type": "Mail",
973s         "MsgTypes": ["All","!Skipped"],
973s         "Where": ["root"],
973s         "Command": "/usr/sbin/bsmtp -h localhost -f \"(Bacula) <%r>\" -s \"Bacula daemon message\" %r"
973s       },
973s       {
973s         "Type": "Append",
973s         "MsgTypes": ["All","!Skipped"],
973s         "Where": ["/var/log/bacula/bacula.log"]
973s       },
973s       {
973s         "Type": "Console",
973s         "MsgTypes": ["All","!Skipped"]
973s       }
973s     ]
973s   }
973s },
973s {
973s   "Messages": {
973s     "Name": "Standard",
973s     "MailCommand": "/usr/sbin/bsmtp -h localhost -f \"(Bacula) <%r>\" -s \"Bacula: %t %e of %c %l\" %r",
973s     "OperatorCommand": "/usr/sbin/bsmtp -h localhost -f \"(Bacula) <%r>\" -s \"Bacula: Intervention needed for %j\" %r",
973s     "Destinations": [
973s       {
973s         "Type": "Mail",
973s         "MsgTypes": ["All","!Skipped"],
973s         "Where": ["root"],
973s         "Command": "/usr/sbin/bsmtp -h localhost -f \"(Bacula) <%r>\" -s \"Bacula: %t %e of %c %l\" %r"
973s       },
973s       {
973s         "Type": "Append",
973s         "MsgTypes": ["All","!Skipped"],
973s         "Where": ["/var/log/bacula/bacula.log"]
973s       },
973s       {
973s         "Type": "Console",
973s         "MsgTypes": ["All","!Skipped"]
973s       },
973s       {
973s         "Type": "Operator",
973s         "MsgTypes": ["Mount"],
973s         "Where": ["root"],
973s         "Command": "/usr/sbin/bsmtp -h localhost -f \"(Bacula) <%r>\" -s \"Bacula: Intervention needed for %j\" %r"
973s       },
973s       {
973s         "Type": "Catalog",
973s         "MsgTypes": ["All"]
973s       }
973s     ]
973s   }
973s },
973s {
973s   "Console": {
973s     "Name": "autopkgtest-mon",
973s     "Password": "g2eYUpdXRuZCy5mEodLg4STnYTB-hkWK8",
973s     "CommandAcl": ["status", ".status"]
973s   }
973s },
973s {
973s   "JobDefs": {
973s     "Name": "DefaultJob",
973s     "Type": "Backup",
973s     "Level": "Incremental",
973s     "Messages": "Standard",
973s     "Storage": ["File1"],
973s     "Pool": "File",
973s     "Client": "autopkgtest-fd",
973s     "Fileset": "Full Set",
973s     "Schedule": "WeeklyCycle",
973s     "WriteBootstrap": "/var/lib/bacula/%c.bsr",
973s     "SpoolAttributes": true,
973s     "Priority": 10
973s   }
973s }
973s ]
973s + echo
973s 
973s + echo '---- Testing /usr/sbin/bfdjson ----'
973s ---- Testing /usr/sbin/bfdjson ----
973s + /usr/sbin/bfdjson
973s [{
973s   "Director": {
973s     "Name": "autopkgtest-dir",
973s     "Password": "bocqacgcHPhT5ePiRJZZ7kJn9Hrdqnb0I"
973s   }
973s },
973s {
973s   "Director": {
973s     "Name": "autopkgtest-mon",
973s     "Password": "FXfBoKyJNMB1YVqlgz8tO-lvlWbgd9iC1",
973s     "Monitor": true
973s   }
973s },
973s {
973s   "FileDaemon": {
973s     "Name": "autopkgtest-fd",
973s     "FdAddress": "127.0.0.1",
973s     "WorkingDirectory": "/var/lib/bacula",
973s     "PidDirectory": "/run/bacula",
973s     "PluginDirectory": "/usr/lib/bacula",
973s     "MaximumConcurrentJobs": 20
973s   }
973s },
973s {
973s   "Messages": {
973s     "Name": "Standard",
973s     "Destinations": [
973s       {
973s         "Type": "Director",
973s         "MsgTypes": ["All","!Skipped","!Restored","!Verified"],
973s         "Where": ["autopkgtest-dir"]
973s       }
973s     ]
973s   }
973s }
973s ]
973s + echo
973s 
973s + echo '---- Testing /usr/sbin/bsdjson ----'
973s ---- Testing /usr/sbin/bsdjson ----
973s + /usr/sbin/bsdjson
973s [
973s {
973s   "Director": {
973s     "Name": "autopkgtest-dir",
973s     "Password": "gTMPD_u45H0dH1GcgQRg3RscPkGMrp82k"
973s   }
973s },
973s {
973s   "Director": {
973s     "Name": "autopkgtest-mon",
973s     "Password": "blq8sTrM5s9CW4wTlOfmuOnKkh8s6HJZ9",
973s     "Monitor": true
973s   }
973s },
973s {
973s   "Storage": {
973s     "Name": "autopkgtest-sd",
973s     "SdAddress": "127.0.0.1",
973s     "WorkingDirectory": "/var/lib/bacula",
973s     "PidDirectory": "/run/bacula",
973s     "PluginDirectory": "/usr/lib/bacula",
973s     "MaximumConcurrentJobs": 20
973s   }
973s },
973s {
973s   "Device": {
973s     "Name": "FileChgr1-Dev1",
973s     "MediaType": "File1",
973s     "ArchiveDevice": "/nonexistent/path/to/file/archive/dir",
973s     "RemovableMedia": false,
973s     "RandomAccess": true,
973s     "AutomaticMount": true,
973s     "LabelMedia": true,
973s     "AlwaysOpen": false,
973s     "MaximumConcurrentJobs": 5
973s   }
973s },
973s {
973s   "Device": {
973s     "Name": "FileChgr1-Dev2",
973s     "MediaType": "File1",
973s     "ArchiveDevice": "/nonexistent/path/to/file/archive/dir",
973s     "RemovableMedia": false,
973s     "RandomAccess": true,
973s     "AutomaticMount": true,
973s     "LabelMedia": true,
973s     "AlwaysOpen": false,
973s     "MaximumConcurrentJobs": 5
973s   }
973s },
973s {
973s   "Device": {
973s     "Name": "FileChgr2-Dev1",
973s     "MediaType": "File2",
973s     "ArchiveDevice": "/nonexistent/path/to/file/archive/dir",
973s     "RemovableMedia": false,
973s     "RandomAccess": true,
973s     "AutomaticMount": true,
973s     "LabelMedia": true,
973s     "AlwaysOpen": false,
973s     "MaximumConcurrentJobs": 5
973s   }
973s },
973s {
973s   "Device": {
973s     "Name": "FileChgr2-Dev2",
973s     "MediaType": "File2",
973s     "ArchiveDevice": "/nonexistent/path/to/file/archive/dir",
973s     "RemovableMedia": false,
973s     "RandomAccess": true,
973s     "AutomaticMount": true,
973s     "LabelMedia": true,
973s     "AlwaysOpen": false,
973s     "MaximumConcurrentJobs": 5
973s   }
973s },
973s {
973s   "Messages": {
973s     "Name": "Standard",
973s     "Destinations": [
973s       {
973s         "Type": "Director",
973s         "MsgTypes": ["All"],
973s         "Where": ["autopkgtest-dir"]
973s       }
973s     ]
973s   }
973s },
973s {
973s   "Autochanger": {
973s     "Name": "FileChgr1",
973s     "Device": ["FileChgr1-Dev1", "FileChgr1-Dev2"],
973s     "ChangerDevice": "/dev/null",
973s     "ChangerCommand": ""
973s   }
973s },
973s {
973s   "Autochanger": {
973s     "Name": "FileChgr2",
973s     "Device": ["FileChgr2-Dev1", "FileChgr2-Dev2"],
973s     "ChangerDevice": "/dev/null",
973s     "ChangerCommand": ""
973s   }
973s }
973s ]
973s autopkgtest [08:52:23]: test program-test-sqlite3: -----------------------]
974s program-test-sqlite3 PASS
974s autopkgtest [08:52:24]: test program-test-sqlite3:  - - - - - - - - - - results - - - - - - - - - -
974s autopkgtest [08:52:24]: @@@@@@@@@@@@@@@@@@@@ summary
974s backup-test-pgsql    PASS
974s program-test-pgsql   PASS
974s backup-test-mysql    PASS
974s program-test-mysql   PASS
974s backup-test-sqlite3  PASS
974s program-test-sqlite3 PASS
992s nova [W] Using flock in prodstack6-s390x
992s Creating nova instance adt-questing-s390x-bacula-20250502-083610-juju-7f2275-prod-proposed-migration-environment-21-1b0e9945-158c-4107-af0d-ed7dd5534a87 from image adt/ubuntu-questing-s390x-server-20250502.img (UUID 632ecfca-a19d-4f3a-af48-b7883fa0ccf2)...
992s nova [W] Timed out waiting for e90f6fae-d1de-43b2-916c-07454fee9f4b to get deleted.
992s nova [W] Using flock in prodstack6-s390x
992s Creating nova instance adt-questing-s390x-bacula-20250502-083610-juju-7f2275-prod-proposed-migration-environment-21-1b0e9945-158c-4107-af0d-ed7dd5534a87 from image adt/ubuntu-questing-s390x-server-20250502.img (UUID 632ecfca-a19d-4f3a-af48-b7883fa0ccf2)...
992s nova [W] Timed out waiting for 6702a0fe-ea49-4fdb-9427-3eb128aeb649 to get deleted.
992s nova [W] Using flock in prodstack6-s390x
992s Creating nova instance adt-questing-s390x-bacula-20250502-083610-juju-7f2275-prod-proposed-migration-environment-21-1b0e9945-158c-4107-af0d-ed7dd5534a87 from image adt/ubuntu-questing-s390x-server-20250502.img (UUID 632ecfca-a19d-4f3a-af48-b7883fa0ccf2)...
992s nova [W] Timed out waiting for df300519-1731-440b-8cdc-d422b3f0db3b to get deleted.
992s nova [W] Using flock in prodstack6-s390x
992s Creating nova instance adt-questing-s390x-bacula-20250502-083610-juju-7f2275-prod-proposed-migration-environment-21-1b0e9945-158c-4107-af0d-ed7dd5534a87 from image adt/ubuntu-questing-s390x-server-20250502.img (UUID 632ecfca-a19d-4f3a-af48-b7883fa0ccf2)...
992s nova [W] Timed out waiting for 78e6e8ea-4392-42e0-b631-0eb0732424f9 to get deleted.
992s nova [W] Using flock in prodstack6-s390x
992s Creating nova instance adt-questing-s390x-bacula-20250502-083610-juju-7f2275-prod-proposed-migration-environment-21-1b0e9945-158c-4107-af0d-ed7dd5534a87 from image adt/ubuntu-questing-s390x-server-20250502.img (UUID 632ecfca-a19d-4f3a-af48-b7883fa0ccf2)...
992s nova [W] Timed out waiting for f5fcc245-75cf-441f-be05-a622c6b944ac to get deleted.
992s nova [W] Using flock in prodstack6-s390x
992s Creating nova instance adt-questing-s390x-bacula-20250502-083610-juju-7f2275-prod-proposed-migration-environment-21-1b0e9945-158c-4107-af0d-ed7dd5534a87 from image adt/ubuntu-questing-s390x-server-20250502.img (UUID 632ecfca-a19d-4f3a-af48-b7883fa0ccf2)...
992s nova [W] Timed out waiting for 07336b99-dc55-4d3a-9418-341b2dbf757a to get deleted.