0s autopkgtest [04:45:17]: starting date and time: 2024-03-23 04:45:17+0000 0s autopkgtest [04:45:17]: git checkout: 4a1cd702 l/adt_testbed: don't blame the testbed for unsolvable build deps 0s autopkgtest [04:45:17]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.up616x2m/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --setup-commands /home/ubuntu/autopkgtest/setup-commands/setup-testbed --apt-pocket=proposed=src:ssmtp,src:gnutls28,src:nettle --apt-upgrade backuppc --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=ssmtp/2.64-11build1 gnutls28/3.8.3-1.1ubuntu2 nettle/3.9.1-2.2' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos02-s390x-20.secgroup --name adt-noble-s390x-backuppc-20240323-044516-juju-7f2275-prod-proposed-migration-environment-2 --image adt/ubuntu-noble-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration -e TERM=linux -e ''"'"'http_proxy=http://squid.internal:3128'"'"'' -e ''"'"'https_proxy=http://squid.internal:3128'"'"'' -e ''"'"'no_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 77s autopkgtest [04:46:34]: testbed dpkg architecture: s390x 77s autopkgtest [04:46:34]: testbed apt version: 2.7.12 77s autopkgtest [04:46:34]: @@@@@@@@@@@@@@@@@@@@ test bed setup 80s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [117 kB] 80s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [57.7 kB] 80s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [4011 kB] 80s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [494 kB] 80s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [6540 B] 80s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main s390x Packages [651 kB] 80s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main s390x c-n-f Metadata [3032 B] 80s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted s390x Packages [1372 B] 80s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted s390x c-n-f Metadata [116 B] 80s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe s390x Packages [4149 kB] 80s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/universe s390x c-n-f Metadata [7292 B] 80s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/multiverse s390x Packages [47.5 kB] 80s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/multiverse s390x c-n-f Metadata [116 B] 81s Fetched 9545 kB in 3s (3768 kB/s) 82s Reading package lists... 85s Reading package lists... 86s Building dependency tree... 86s Reading state information... 86s Calculating upgrade... 86s The following packages will be upgraded: 86s libbsd0 88s 1 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 88s Need to get 46.7 kB of archives. 88s After this operation, 0 B of additional disk space will be used. 88s Get:1 http://ftpmaster.internal/ubuntu noble/main s390x libbsd0 s390x 0.12.1-1 [46.7 kB] 88s Unknown architecture, assuming PC-style ttyS0 88s Fetched 46.7 kB in 0s (171 kB/s) 88s (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 ... 52170 files and directories currently installed.) 88s Preparing to unpack .../libbsd0_0.12.1-1_s390x.deb ... 88s Unpacking libbsd0:s390x (0.12.1-1) over (0.11.8-1) ... 88s Setting up libbsd0:s390x (0.12.1-1) ... 88s Processing triggers for libc-bin (2.39-0ubuntu2) ... 88s Reading package lists... 88s Building dependency tree... 88s Reading state information... 88s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 88s Reading package lists...sh: Attempting to set up Debian/Ubuntu apt sources automatically 88s sh: Distribution appears to be Ubuntu 89s 89s Building dependency tree... 89s Reading state information... 89s eatmydata is already the newest version (131-1). 89s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 89s Reading package lists... 89s Building dependency tree... 89s Reading state information... 89s dbus is already the newest version (1.14.10-4ubuntu1). 89s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 89s Reading package lists... 90s Building dependency tree... 90s Reading state information... 90s rng-tools-debian is already the newest version (2.4). 90s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 90s Reading package lists... 90s Building dependency tree... 90s Reading state information... 90s The following packages will be REMOVED: 90s cloud-init* python3-configobj* python3-debconf* 91s 0 upgraded, 0 newly installed, 3 to remove and 0 not upgraded. 91s After this operation, 3256 kB disk space will be freed. 91s (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 ... 52170 files and directories currently installed.) 91s Removing cloud-init (24.1.2-0ubuntu1) ... 91s Removing python3-configobj (5.0.8-3) ... 91s Removing python3-debconf (1.5.86) ... 91s Processing triggers for man-db (2.12.0-3) ... 92s (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 ... 51781 files and directories currently installed.) 92s Purging configuration files for cloud-init (24.1.2-0ubuntu1) ... 92s dpkg: warning: while removing cloud-init, directory '/etc/cloud/cloud.cfg.d' not empty so not removed 92s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ... 92s invoke-rc.d: policy-rc.d denied execution of try-restart. 92s Reading package lists... 92s Building dependency tree... 92s Reading state information... 93s linux-generic is already the newest version (6.8.0-11.11+1). 93s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 93s Hit:1 http://ftpmaster.internal/ubuntu noble InRelease 93s Hit:2 http://ftpmaster.internal/ubuntu noble-updates InRelease 93s Hit:3 http://ftpmaster.internal/ubuntu noble-security InRelease 95s Reading package lists... 95s Reading package lists... 95s Building dependency tree... 95s Reading state information... 95s Calculating upgrade... 96s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 96s Reading package lists... 96s Building dependency tree... 96s Reading state information... 96s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 96s autopkgtest [04:46:53]: rebooting testbed after setup commands that affected boot 111s autopkgtest [04:47:08]: testbed running kernel: Linux 6.8.0-11-generic #11-Ubuntu SMP Tue Feb 13 23:45:46 UTC 2024 113s autopkgtest [04:47:10]: @@@@@@@@@@@@@@@@@@@@ apt-source backuppc 115s Get:1 http://ftpmaster.internal/ubuntu noble/main backuppc 4.4.0-8 (dsc) [2157 B] 115s Get:2 http://ftpmaster.internal/ubuntu noble/main backuppc 4.4.0-8 (tar) [657 kB] 115s Get:3 http://ftpmaster.internal/ubuntu noble/main backuppc 4.4.0-8 (diff) [61.0 kB] 115s gpgv: Signature made Sun Jan 15 11:50:10 2023 UTC 115s gpgv: using RSA key 468C89793B429819E9D761266BE663C75A35C975 115s gpgv: Can't check signature: No public key 115s dpkg-source: warning: cannot verify inline signature for ./backuppc_4.4.0-8.dsc: no acceptable signature found 115s autopkgtest [04:47:12]: testing package backuppc version 4.4.0-8 116s autopkgtest [04:47:13]: build not needed 116s autopkgtest [04:47:13]: test smb-backup: preparing testbed 120s Reading package lists... 120s Building dependency tree... 120s Reading state information... 120s Starting pkgProblemResolver with broken count: 0 120s Starting 2 pkgProblemResolver with broken count: 0 120s Done 120s The following additional packages will be installed: 120s apache2 apache2-bin apache2-data apache2-utils backuppc backuppc-rsync 120s libapr1 libaprutil1 libaprutil1-dbd-sqlite3 libaprutil1-ldap 120s libarchive-zip-perl libavahi-client3 libavahi-common-data libavahi-common3 120s libbackuppc-xs-perl libcgi-pm-perl libcups2 libfile-listing-perl 120s libhtml-parser-perl libhtml-tagset-perl libhttp-date-perl libldb2 120s liblua5.4-0 libpython3.12 libsmbclient libtalloc2 libtdb1 libtevent0 120s libtime-parsedate-perl libtimedate-perl liburi-perl libwbclient0 postfix 120s python3-dnspython python3-ldb python3-markdown python3-samba python3-talloc 120s python3-tdb samba samba-common samba-common-bin samba-libs smbclient 120s ssl-cert tdb-tools 120s Suggested packages: 120s apache2-doc apache2-suexec-pristine | apache2-suexec-custom www-browser 120s certbot | acme-tiny | acmetool | dehydrated | lacme | lecm | lego 120s libscgi-perl par2 w3m | www-browser cups-common libdata-dump-perl 120s libbusiness-isbn-perl libregexp-ipv6-perl libwww-perl procmail postfix-mysql 120s postfix-pgsql postfix-ldap postfix-pcre postfix-lmdb postfix-sqlite 120s sasl2-bin | dovecot-common postfix-cdb mail-reader postfix-mta-sts-resolver 120s postfix-doc python3-trio python3-aioquic python3-h2 python3-httpx 120s python3-httpcore python-markdown-doc bind9 bind9utils ctdb ldb-tools ntp 120s | chrony winbind heimdal-clients cifs-utils 120s Recommended packages: 120s libio-dirent-perl rrdtool libcgi-fast-perl libhttp-message-perl python3-gpg 120s attr samba-dsdb-modules samba-vfs-modules samba-ad-provision 120s The following NEW packages will be installed: 120s apache2 apache2-bin apache2-data apache2-utils autopkgtest-satdep backuppc 120s backuppc-rsync libapr1 libaprutil1 libaprutil1-dbd-sqlite3 libaprutil1-ldap 120s libarchive-zip-perl libavahi-client3 libavahi-common-data libavahi-common3 120s libbackuppc-xs-perl libcgi-pm-perl libcups2 libfile-listing-perl 120s libhtml-parser-perl libhtml-tagset-perl libhttp-date-perl libldb2 120s liblua5.4-0 libpython3.12 libsmbclient libtalloc2 libtdb1 libtevent0 120s libtime-parsedate-perl libtimedate-perl liburi-perl libwbclient0 postfix 120s python3-dnspython python3-ldb python3-markdown python3-samba python3-talloc 120s python3-tdb samba samba-common samba-common-bin samba-libs smbclient 120s ssl-cert tdb-tools 120s 0 upgraded, 47 newly installed, 0 to remove and 0 not upgraded. 120s Need to get 21.1 MB/21.1 MB of archives. 120s After this operation, 93.6 MB of additional disk space will be used. 120s Get:1 /tmp/autopkgtest.HaodLW/1-autopkgtest-satdep.deb autopkgtest-satdep s390x 0 [724 B] 120s Get:2 http://ftpmaster.internal/ubuntu noble/main s390x libapr1 s390x 1.7.2-3 [105 kB] 121s Get:3 http://ftpmaster.internal/ubuntu noble/main s390x libaprutil1 s390x 1.6.3-1ubuntu1 [91.9 kB] 121s Get:4 http://ftpmaster.internal/ubuntu noble/main s390x libaprutil1-dbd-sqlite3 s390x 1.6.3-1ubuntu1 [11.2 kB] 121s Get:5 http://ftpmaster.internal/ubuntu noble/main s390x libaprutil1-ldap s390x 1.6.3-1ubuntu1 [8914 B] 121s Get:6 http://ftpmaster.internal/ubuntu noble/main s390x liblua5.4-0 s390x 5.4.6-3 [179 kB] 121s Get:7 http://ftpmaster.internal/ubuntu noble/main s390x apache2-bin s390x 2.4.58-1ubuntu2 [1412 kB] 121s Get:8 http://ftpmaster.internal/ubuntu noble/main s390x apache2-data all 2.4.58-1ubuntu2 [163 kB] 121s Get:9 http://ftpmaster.internal/ubuntu noble/main s390x apache2-utils s390x 2.4.58-1ubuntu2 [99.6 kB] 121s Get:10 http://ftpmaster.internal/ubuntu noble/main s390x apache2 s390x 2.4.58-1ubuntu2 [90.2 kB] 121s Get:11 http://ftpmaster.internal/ubuntu noble/main s390x backuppc-rsync s390x 3.1.3.0-3build1 [250 kB] 121s Get:12 http://ftpmaster.internal/ubuntu noble/main s390x ssl-cert all 1.1.2ubuntu1 [17.8 kB] 121s Get:13 http://ftpmaster.internal/ubuntu noble/main s390x postfix s390x 3.8.5-1 [1279 kB] 121s Get:14 http://ftpmaster.internal/ubuntu noble/main s390x libarchive-zip-perl all 1.68-1 [90.2 kB] 121s Get:15 http://ftpmaster.internal/ubuntu noble/main s390x libbackuppc-xs-perl s390x 0.62-2build3 [72.0 kB] 121s Get:16 http://ftpmaster.internal/ubuntu noble/main s390x libhtml-tagset-perl all 3.20-6 [11.3 kB] 121s Get:17 http://ftpmaster.internal/ubuntu noble/main s390x liburi-perl all 5.27-1 [88.0 kB] 121s Get:18 http://ftpmaster.internal/ubuntu noble/main s390x libhtml-parser-perl s390x 3.81-1build1 [87.8 kB] 121s Get:19 http://ftpmaster.internal/ubuntu noble/main s390x libcgi-pm-perl all 4.62-1 [185 kB] 121s Get:20 http://ftpmaster.internal/ubuntu noble/main s390x libtimedate-perl all 2.3300-2 [34.0 kB] 121s Get:21 http://ftpmaster.internal/ubuntu noble/main s390x libhttp-date-perl all 6.06-1 [10.2 kB] 121s Get:22 http://ftpmaster.internal/ubuntu noble/main s390x libfile-listing-perl all 6.16-1 [11.3 kB] 121s Get:23 http://ftpmaster.internal/ubuntu noble/main s390x libtime-parsedate-perl all 2015.103-4 [28.6 kB] 121s Get:24 http://ftpmaster.internal/ubuntu noble/main s390x backuppc s390x 4.4.0-8 [542 kB] 121s Get:25 http://ftpmaster.internal/ubuntu noble/main s390x python3-dnspython all 2.6.1-1ubuntu1 [163 kB] 121s Get:26 http://ftpmaster.internal/ubuntu noble/main s390x libtalloc2 s390x 2.4.2-1 [28.3 kB] 121s Get:27 http://ftpmaster.internal/ubuntu noble/main s390x libtdb1 s390x 1.4.10-1 [49.9 kB] 121s Get:28 http://ftpmaster.internal/ubuntu noble/main s390x libtevent0 s390x 0.16.1-1 [43.1 kB] 121s Get:29 http://ftpmaster.internal/ubuntu noble/main s390x libldb2 s390x 2:2.8.0+samba4.19.5+dfsg-1ubuntu1 [191 kB] 121s Get:30 http://ftpmaster.internal/ubuntu noble/main s390x libpython3.12 s390x 3.12.2-1 [2561 kB] 121s Get:31 http://ftpmaster.internal/ubuntu noble/main s390x python3-ldb s390x 2:2.8.0+samba4.19.5+dfsg-1ubuntu1 [42.3 kB] 121s Get:32 http://ftpmaster.internal/ubuntu noble/main s390x python3-tdb s390x 1.4.10-1 [15.9 kB] 121s Get:33 http://ftpmaster.internal/ubuntu noble/main s390x python3-markdown all 3.5.2-1 [72.0 kB] 121s Get:34 http://ftpmaster.internal/ubuntu noble/main s390x libavahi-common-data s390x 0.8-13ubuntu2 [29.5 kB] 121s Get:35 http://ftpmaster.internal/ubuntu noble/main s390x libavahi-common3 s390x 0.8-13ubuntu2 [23.8 kB] 121s Get:36 http://ftpmaster.internal/ubuntu noble/main s390x libavahi-client3 s390x 0.8-13ubuntu2 [26.7 kB] 121s Get:37 http://ftpmaster.internal/ubuntu noble/main s390x libwbclient0 s390x 2:4.19.5+dfsg-1ubuntu1 [70.3 kB] 121s Get:38 http://ftpmaster.internal/ubuntu noble/main s390x samba-libs s390x 2:4.19.5+dfsg-1ubuntu1 [6231 kB] 122s Get:39 http://ftpmaster.internal/ubuntu noble/main s390x python3-talloc s390x 2.4.2-1 [12.9 kB] 122s Get:40 http://ftpmaster.internal/ubuntu noble/main s390x python3-samba s390x 2:4.19.5+dfsg-1ubuntu1 [3398 kB] 122s Get:41 http://ftpmaster.internal/ubuntu noble/main s390x samba-common all 2:4.19.5+dfsg-1ubuntu1 [63.4 kB] 122s Get:42 http://ftpmaster.internal/ubuntu noble/main s390x libcups2 s390x 2.4.6-0ubuntu3 [277 kB] 122s Get:43 http://ftpmaster.internal/ubuntu noble/main s390x samba-common-bin s390x 2:4.19.5+dfsg-1ubuntu1 [1302 kB] 122s Get:44 http://ftpmaster.internal/ubuntu noble/main s390x tdb-tools s390x 1.4.10-1 [26.5 kB] 122s Get:45 http://ftpmaster.internal/ubuntu noble/main s390x samba s390x 2:4.19.5+dfsg-1ubuntu1 [1015 kB] 122s Get:46 http://ftpmaster.internal/ubuntu noble/main s390x libsmbclient s390x 2:4.19.5+dfsg-1ubuntu1 [65.1 kB] 122s Get:47 http://ftpmaster.internal/ubuntu noble/main s390x smbclient s390x 2:4.19.5+dfsg-1ubuntu1 [494 kB] 122s Preconfiguring packages ... 122s Fetched 21.1 MB in 2s (13.3 MB/s) 122s Selecting previously unselected package libapr1:s390x. 122s (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 ... 51726 files and directories currently installed.) 122s Preparing to unpack .../00-libapr1_1.7.2-3_s390x.deb ... 122s Unpacking libapr1:s390x (1.7.2-3) ... 122s Selecting previously unselected package libaprutil1:s390x. 122s Preparing to unpack .../01-libaprutil1_1.6.3-1ubuntu1_s390x.deb ... 122s Unpacking libaprutil1:s390x (1.6.3-1ubuntu1) ... 122s Selecting previously unselected package libaprutil1-dbd-sqlite3:s390x. 122s Preparing to unpack .../02-libaprutil1-dbd-sqlite3_1.6.3-1ubuntu1_s390x.deb ... 122s Unpacking libaprutil1-dbd-sqlite3:s390x (1.6.3-1ubuntu1) ... 122s Selecting previously unselected package libaprutil1-ldap:s390x. 122s Preparing to unpack .../03-libaprutil1-ldap_1.6.3-1ubuntu1_s390x.deb ... 122s Unpacking libaprutil1-ldap:s390x (1.6.3-1ubuntu1) ... 122s Selecting previously unselected package liblua5.4-0:s390x. 122s Preparing to unpack .../04-liblua5.4-0_5.4.6-3_s390x.deb ... 122s Unpacking liblua5.4-0:s390x (5.4.6-3) ... 122s Selecting previously unselected package apache2-bin. 122s Preparing to unpack .../05-apache2-bin_2.4.58-1ubuntu2_s390x.deb ... 122s Unpacking apache2-bin (2.4.58-1ubuntu2) ... 122s Selecting previously unselected package apache2-data. 122s Preparing to unpack .../06-apache2-data_2.4.58-1ubuntu2_all.deb ... 122s Unpacking apache2-data (2.4.58-1ubuntu2) ... 122s Selecting previously unselected package apache2-utils. 122s Preparing to unpack .../07-apache2-utils_2.4.58-1ubuntu2_s390x.deb ... 122s Unpacking apache2-utils (2.4.58-1ubuntu2) ... 122s Selecting previously unselected package apache2. 122s Preparing to unpack .../08-apache2_2.4.58-1ubuntu2_s390x.deb ... 122s Unpacking apache2 (2.4.58-1ubuntu2) ... 122s Selecting previously unselected package backuppc-rsync. 122s Preparing to unpack .../09-backuppc-rsync_3.1.3.0-3build1_s390x.deb ... 122s Unpacking backuppc-rsync (3.1.3.0-3build1) ... 123s Selecting previously unselected package ssl-cert. 123s Preparing to unpack .../10-ssl-cert_1.1.2ubuntu1_all.deb ... 123s Unpacking ssl-cert (1.1.2ubuntu1) ... 123s Selecting previously unselected package postfix. 123s Preparing to unpack .../11-postfix_3.8.5-1_s390x.deb ... 123s Unpacking postfix (3.8.5-1) ... 123s Selecting previously unselected package libarchive-zip-perl. 123s Preparing to unpack .../12-libarchive-zip-perl_1.68-1_all.deb ... 123s Unpacking libarchive-zip-perl (1.68-1) ... 123s Selecting previously unselected package libbackuppc-xs-perl:s390x. 123s Preparing to unpack .../13-libbackuppc-xs-perl_0.62-2build3_s390x.deb ... 123s Unpacking libbackuppc-xs-perl:s390x (0.62-2build3) ... 123s Selecting previously unselected package libhtml-tagset-perl. 123s Preparing to unpack .../14-libhtml-tagset-perl_3.20-6_all.deb ... 123s Unpacking libhtml-tagset-perl (3.20-6) ... 123s Selecting previously unselected package liburi-perl. 123s Preparing to unpack .../15-liburi-perl_5.27-1_all.deb ... 123s Unpacking liburi-perl (5.27-1) ... 123s Selecting previously unselected package libhtml-parser-perl:s390x. 123s Preparing to unpack .../16-libhtml-parser-perl_3.81-1build1_s390x.deb ... 123s Unpacking libhtml-parser-perl:s390x (3.81-1build1) ... 123s Selecting previously unselected package libcgi-pm-perl. 123s Preparing to unpack .../17-libcgi-pm-perl_4.62-1_all.deb ... 123s Unpacking libcgi-pm-perl (4.62-1) ... 123s Selecting previously unselected package libtimedate-perl. 123s Preparing to unpack .../18-libtimedate-perl_2.3300-2_all.deb ... 123s Unpacking libtimedate-perl (2.3300-2) ... 123s Selecting previously unselected package libhttp-date-perl. 123s Preparing to unpack .../19-libhttp-date-perl_6.06-1_all.deb ... 123s Unpacking libhttp-date-perl (6.06-1) ... 123s Selecting previously unselected package libfile-listing-perl. 123s Preparing to unpack .../20-libfile-listing-perl_6.16-1_all.deb ... 123s Unpacking libfile-listing-perl (6.16-1) ... 123s Selecting previously unselected package libtime-parsedate-perl. 123s Preparing to unpack .../21-libtime-parsedate-perl_2015.103-4_all.deb ... 123s Unpacking libtime-parsedate-perl (2015.103-4) ... 123s Selecting previously unselected package backuppc. 123s Preparing to unpack .../22-backuppc_4.4.0-8_s390x.deb ... 123s Unpacking backuppc (4.4.0-8) ... 123s Selecting previously unselected package python3-dnspython. 123s Preparing to unpack .../23-python3-dnspython_2.6.1-1ubuntu1_all.deb ... 123s Unpacking python3-dnspython (2.6.1-1ubuntu1) ... 123s Selecting previously unselected package libtalloc2:s390x. 123s Preparing to unpack .../24-libtalloc2_2.4.2-1_s390x.deb ... 123s Unpacking libtalloc2:s390x (2.4.2-1) ... 123s Selecting previously unselected package libtdb1:s390x. 123s Preparing to unpack .../25-libtdb1_1.4.10-1_s390x.deb ... 123s Unpacking libtdb1:s390x (1.4.10-1) ... 123s Selecting previously unselected package libtevent0:s390x. 123s Preparing to unpack .../26-libtevent0_0.16.1-1_s390x.deb ... 123s Unpacking libtevent0:s390x (0.16.1-1) ... 123s Selecting previously unselected package libldb2:s390x. 123s Preparing to unpack .../27-libldb2_2%3a2.8.0+samba4.19.5+dfsg-1ubuntu1_s390x.deb ... 123s Unpacking libldb2:s390x (2:2.8.0+samba4.19.5+dfsg-1ubuntu1) ... 123s Selecting previously unselected package libpython3.12:s390x. 123s Preparing to unpack .../28-libpython3.12_3.12.2-1_s390x.deb ... 123s Unpacking libpython3.12:s390x (3.12.2-1) ... 123s Selecting previously unselected package python3-ldb. 123s Preparing to unpack .../29-python3-ldb_2%3a2.8.0+samba4.19.5+dfsg-1ubuntu1_s390x.deb ... 123s Unpacking python3-ldb (2:2.8.0+samba4.19.5+dfsg-1ubuntu1) ... 123s Selecting previously unselected package python3-tdb. 123s Preparing to unpack .../30-python3-tdb_1.4.10-1_s390x.deb ... 123s Unpacking python3-tdb (1.4.10-1) ... 123s Selecting previously unselected package python3-markdown. 123s Preparing to unpack .../31-python3-markdown_3.5.2-1_all.deb ... 123s Unpacking python3-markdown (3.5.2-1) ... 123s Selecting previously unselected package libavahi-common-data:s390x. 123s Preparing to unpack .../32-libavahi-common-data_0.8-13ubuntu2_s390x.deb ... 123s Unpacking libavahi-common-data:s390x (0.8-13ubuntu2) ... 123s Selecting previously unselected package libavahi-common3:s390x. 123s Preparing to unpack .../33-libavahi-common3_0.8-13ubuntu2_s390x.deb ... 123s Unpacking libavahi-common3:s390x (0.8-13ubuntu2) ... 123s Selecting previously unselected package libavahi-client3:s390x. 123s Preparing to unpack .../34-libavahi-client3_0.8-13ubuntu2_s390x.deb ... 123s Unpacking libavahi-client3:s390x (0.8-13ubuntu2) ... 123s Selecting previously unselected package libwbclient0:s390x. 123s Preparing to unpack .../35-libwbclient0_2%3a4.19.5+dfsg-1ubuntu1_s390x.deb ... 123s Unpacking libwbclient0:s390x (2:4.19.5+dfsg-1ubuntu1) ... 123s Selecting previously unselected package samba-libs:s390x. 123s Preparing to unpack .../36-samba-libs_2%3a4.19.5+dfsg-1ubuntu1_s390x.deb ... 123s Unpacking samba-libs:s390x (2:4.19.5+dfsg-1ubuntu1) ... 123s Selecting previously unselected package python3-talloc:s390x. 123s Preparing to unpack .../37-python3-talloc_2.4.2-1_s390x.deb ... 123s Unpacking python3-talloc:s390x (2.4.2-1) ... 123s Selecting previously unselected package python3-samba. 123s Preparing to unpack .../38-python3-samba_2%3a4.19.5+dfsg-1ubuntu1_s390x.deb ... 123s Unpacking python3-samba (2:4.19.5+dfsg-1ubuntu1) ... 124s Selecting previously unselected package samba-common. 124s Preparing to unpack .../39-samba-common_2%3a4.19.5+dfsg-1ubuntu1_all.deb ... 124s Unpacking samba-common (2:4.19.5+dfsg-1ubuntu1) ... 124s Selecting previously unselected package libcups2:s390x. 124s Preparing to unpack .../40-libcups2_2.4.6-0ubuntu3_s390x.deb ... 124s Unpacking libcups2:s390x (2.4.6-0ubuntu3) ... 124s Selecting previously unselected package samba-common-bin. 124s Preparing to unpack .../41-samba-common-bin_2%3a4.19.5+dfsg-1ubuntu1_s390x.deb ... 124s Unpacking samba-common-bin (2:4.19.5+dfsg-1ubuntu1) ... 124s Selecting previously unselected package tdb-tools. 124s Preparing to unpack .../42-tdb-tools_1.4.10-1_s390x.deb ... 124s Unpacking tdb-tools (1.4.10-1) ... 124s Selecting previously unselected package samba. 124s Preparing to unpack .../43-samba_2%3a4.19.5+dfsg-1ubuntu1_s390x.deb ... 124s Unpacking samba (2:4.19.5+dfsg-1ubuntu1) ... 124s Selecting previously unselected package libsmbclient:s390x. 124s Preparing to unpack .../44-libsmbclient_2%3a4.19.5+dfsg-1ubuntu1_s390x.deb ... 124s Unpacking libsmbclient:s390x (2:4.19.5+dfsg-1ubuntu1) ... 124s Selecting previously unselected package smbclient. 124s Preparing to unpack .../45-smbclient_2%3a4.19.5+dfsg-1ubuntu1_s390x.deb ... 124s Unpacking smbclient (2:4.19.5+dfsg-1ubuntu1) ... 124s Selecting previously unselected package autopkgtest-satdep. 124s Preparing to unpack .../46-1-autopkgtest-satdep.deb ... 124s Unpacking autopkgtest-satdep (0) ... 124s Setting up libarchive-zip-perl (1.68-1) ... 124s Setting up libtdb1:s390x (1.4.10-1) ... 124s Setting up libhtml-tagset-perl (3.20-6) ... 124s Setting up libapr1:s390x (1.7.2-3) ... 124s Setting up samba-common (2:4.19.5+dfsg-1ubuntu1) ... 124s 124s Creating config file /etc/samba/smb.conf with new version 124s Setting up libwbclient0:s390x (2:4.19.5+dfsg-1ubuntu1) ... 124s Setting up libtalloc2:s390x (2.4.2-1) ... 124s Setting up backuppc-rsync (3.1.3.0-3build1) ... 124s Setting up python3-tdb (1.4.10-1) ... 124s Setting up libtevent0:s390x (0.16.1-1) ... 124s Setting up ssl-cert (1.1.2ubuntu1) ... 125s Created symlink /etc/systemd/system/multi-user.target.wants/ssl-cert.service → /usr/lib/systemd/system/ssl-cert.service. 126s Setting up libavahi-common-data:s390x (0.8-13ubuntu2) ... 126s Setting up tdb-tools (1.4.10-1) ... 127s update-alternatives: using /usr/bin/tdbbackup.tdbtools to provide /usr/bin/tdbbackup (tdbbackup) in auto mode 127s Setting up python3-markdown (3.5.2-1) ... 127s Setting up libtimedate-perl (2.3300-2) ... 127s Setting up postfix (3.8.5-1) ... 127s info: Selecting GID from range 100 to 999 ... 127s info: Adding group `postfix' (GID 113) ... 127s info: Selecting UID from range 100 to 999 ... 127s 127s info: Adding system user `postfix' (UID 107) ... 127s info: Adding new user `postfix' (UID 107) with group `postfix' ... 127s info: Not creating home directory `/var/spool/postfix'. 127s Creating /etc/postfix/dynamicmaps.cf 127s info: Selecting GID from range 100 to 999 ... 127s info: Adding group `postdrop' (GID 114) ... 127s setting myhostname: adt-noble-s390x-backuppc-20240323-044516-juju-7f2275-prod-propo.novalocal 127s setting alias maps 127s setting alias database 127s changing /etc/mailname to adt-noble-s390x-backuppc-20240323-044516-juju-7f2275-prod-propo.novalocal 127s setting myorigin 127s setting destinations: $myhostname, adt-noble-s390x-backuppc-20240323-044516-juju-7f2275-prod-propo.novalocal, localhost.novalocal, , localhost 127s setting relayhost: 127s setting mynetworks: 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128 127s setting mailbox_size_limit: 0 127s setting recipient_delimiter: + 128s setting inet_interfaces: all 131s setting inet_protocols: all 131s /etc/aliases does not exist, creating it. 131s WARNING: /etc/aliases exists, but does not have a root alias. 131s 131s Postfix (main.cf) is now set up with a default configuration. If you need to 131s make changes, edit /etc/postfix/main.cf (and others) as needed. To view 131s Postfix configuration values, see postconf(1). 131s 131s After modifying main.cf, be sure to run 'systemctl reload postfix'. 131s 133s Running newaliases 133s Created symlink /etc/systemd/system/multi-user.target.wants/postfix.service → /usr/lib/systemd/system/postfix.service. 134s Setting up libtime-parsedate-perl (2015.103-4) ... 134s Setting up python3-dnspython (2.6.1-1ubuntu1) ... 134s Setting up liblua5.4-0:s390x (5.4.6-3) ... 134s Setting up apache2-data (2.4.58-1ubuntu2) ... 134s Setting up libldb2:s390x (2:2.8.0+samba4.19.5+dfsg-1ubuntu1) ... 134s Setting up libbackuppc-xs-perl:s390x (0.62-2build3) ... 134s Setting up libpython3.12:s390x (3.12.2-1) ... 134s Setting up liburi-perl (5.27-1) ... 134s Setting up libaprutil1:s390x (1.6.3-1ubuntu1) ... 134s Setting up libhttp-date-perl (6.06-1) ... 134s Setting up libfile-listing-perl (6.16-1) ... 134s Setting up python3-talloc:s390x (2.4.2-1) ... 134s Setting up libavahi-common3:s390x (0.8-13ubuntu2) ... 134s Setting up libaprutil1-ldap:s390x (1.6.3-1ubuntu1) ... 134s Setting up libaprutil1-dbd-sqlite3:s390x (1.6.3-1ubuntu1) ... 134s Setting up python3-ldb (2:2.8.0+samba4.19.5+dfsg-1ubuntu1) ... 134s Setting up libhtml-parser-perl:s390x (3.81-1build1) ... 134s Setting up libavahi-client3:s390x (0.8-13ubuntu2) ... 134s Setting up apache2-utils (2.4.58-1ubuntu2) ... 134s Setting up libcgi-pm-perl (4.62-1) ... 134s Setting up samba-libs:s390x (2:4.19.5+dfsg-1ubuntu1) ... 134s Setting up apache2-bin (2.4.58-1ubuntu2) ... 134s Setting up libsmbclient:s390x (2:4.19.5+dfsg-1ubuntu1) ... 134s Setting up smbclient (2:4.19.5+dfsg-1ubuntu1) ... 134s Setting up libcups2:s390x (2.4.6-0ubuntu3) ... 134s Setting up python3-samba (2:4.19.5+dfsg-1ubuntu1) ... 135s /usr/lib/python3/dist-packages/samba/tests/dns_forwarder_helpers/server.py:80: SyntaxWarning: invalid escape sequence '\s' 135s m = re.match(b'^timeout\s+([\d.]+)$', data.strip()) 136s /usr/lib/python3/dist-packages/samba/tests/samba_tool/join_member.py:43: SyntaxWarning: invalid escape sequence '\s' 136s existing_records = re.findall('A:\s+(\d+\.\d+\.\d+\.\d+)\s', out) 136s /usr/lib/python3/dist-packages/samba/tests/samba_tool/ntacl.py:93: SyntaxWarning: invalid escape sequence '\s' 136s self.assertNotRegex(err, '^\s*File [^,]+, line \d+, in', 136s /usr/lib/python3/dist-packages/samba/tests/samba_tool/user_virtualCryptSHA.py:42: SyntaxWarning: invalid escape sequence '\s' 136s p = re.compile("^" + name + ":\s+(\S+)") 136s /usr/lib/python3/dist-packages/samba/tests/samba_tool/user_virtualCryptSHA_base.py:42: SyntaxWarning: invalid escape sequence '\s' 136s p = re.compile("^" + name + ":\s+(\S+)") 136s Setting up apache2 (2.4.58-1ubuntu2) ... 136s Enabling module mpm_event. 136s Enabling module authz_core. 136s Enabling module authz_host. 136s Enabling module authn_core. 136s Enabling module auth_basic. 136s Enabling module access_compat. 136s Enabling module authn_file. 136s Enabling module authz_user. 136s Enabling module alias. 136s Enabling module dir. 136s Enabling module autoindex. 136s Enabling module env. 136s Enabling module mime. 136s Enabling module negotiation. 136s Enabling module setenvif. 136s Enabling module filter. 136s Enabling module deflate. 136s Enabling module status. 136s Enabling module reqtimeout. 136s Enabling conf charset. 136s Enabling conf localized-error-pages. 136s Enabling conf other-vhosts-access-log. 136s Enabling conf security. 136s Enabling conf serve-cgi-bin. 136s Enabling site 000-default. 137s Created symlink /etc/systemd/system/multi-user.target.wants/apache2.service → /usr/lib/systemd/system/apache2.service. 138s Created symlink /etc/systemd/system/multi-user.target.wants/apache-htcacheclean.service → /usr/lib/systemd/system/apache-htcacheclean.service. 139s Setting up backuppc (4.4.0-8) ... 139s 139s apache2_invoke: Enable configuration backuppc.conf 139s warn: The home directory `/var/lib/backuppc' already exists. Not touching this directory. 139s warn: Warning: The home directory `/var/lib/backuppc' does not belong to the user you are currently creating. 139s Adding password for user backuppc 139s Considering dependency authn_core for auth_basic: 139s Module authn_core already enabled 139s Module auth_basic already enabled 139s Considering dependency authz_core for authz_groupfile: 139s Module authz_core already enabled 139s Enabling module authz_groupfile. 139s To activate the new configuration, you need to run: 139s systemctl restart apache2 139s Module authn_file already enabled 139s Considering dependency authz_core for authz_user: 139s Module authz_core already enabled 139s Module authz_user already enabled 139s Your MPM seems to be threaded. Selecting cgid instead of cgi. 139s Enabling module cgid. 139s To activate the new configuration, you need to run: 139s systemctl restart apache2 139s 139s Creating config file /etc/backuppc/config.pl with new version 140s Created symlink /etc/systemd/system/multi-user.target.wants/backuppc.service → /usr/lib/systemd/system/backuppc.service. 140s Setting up samba-common-bin (2:4.19.5+dfsg-1ubuntu1) ... 140s Setting up samba (2:4.19.5+dfsg-1ubuntu1) ... 141s Created symlink /etc/systemd/system/smb.service → /usr/lib/systemd/system/smbd.service. 141s Created symlink /etc/systemd/system/multi-user.target.wants/smbd.service → /usr/lib/systemd/system/smbd.service. 142s Created symlink /etc/systemd/system/nmb.service → /usr/lib/systemd/system/nmbd.service. 142s Created symlink /etc/systemd/system/multi-user.target.wants/nmbd.service → /usr/lib/systemd/system/nmbd.service. 142s Created symlink /etc/systemd/system/samba.service → /usr/lib/systemd/system/samba-ad-dc.service. 142s Created symlink /etc/systemd/system/multi-user.target.wants/samba-ad-dc.service → /usr/lib/systemd/system/samba-ad-dc.service. 142s Setting up autopkgtest-satdep (0) ... 142s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ... 143s Processing triggers for ufw (0.36.2-5) ... 143s Processing triggers for man-db (2.12.0-3) ... 143s Processing triggers for libc-bin (2.39-0ubuntu2) ... 146s (Reading database ... 54357 files and directories currently installed.) 146s Removing autopkgtest-satdep (0) ... 147s autopkgtest [04:47:44]: test smb-backup: [----------------------- 147s Populating share path 147s Adding samba share 147s Adding [public] share 147s Configuring backuppc 147s Performing a full backup 147s Backup type: type = full, needs_full = 1, needs_incr = 1, lastFullTime = 0, opts{f} = 1, opts{i} = , opts{F} = 147s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 147s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 147s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.020 147s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.0.z created 2024-03-23 04:47:44 147s Backup prep: type = full, case = 1, inPlace = 1, doDuplicate = 0, newBkupNum = 0, newBkupIdx = 0, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = ) 147s __bpc_progress_state__ backup share "public" 147s Running: /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -Tc - 147s full backup started for share public 147s started full dump, share=public 147s Xfer PIDs are now 3760,3759 147s xferPids 3760,3759 147s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -Tc - 147s tarmode is now full, system, hidden, noreset, noverbose 147s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 1 147s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 147s __bpc_progress_fileCnt__ 0 147s new 644 0/0 480434 tmp.Y5Us5w 147s new 644 0/0 480434 tmp.QNr9Ha 147s new 644 0/0 480434 tmp.67ZfN2 147s new 644 0/0 480434 tmp.nAG9t7 147s new 644 0/0 480434 tmp.isiFRg 147s new 644 0/0 480434 tmp.1nS7YY 148s new 644 0/0 480434 tmp.JQhh4Y 148s new 644 0/0 480434 tmp.CMSw38 148s new 644 0/0 480434 tmp.SMby5N 148s tar: dumped 10 files and 0 directories 148s Total bytes written: 4804340 (29.3 MiB/s) 148s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 148s new 644 0/0 480434 tmp.LTmInn 148s __bpc_progress_fileCnt__ 10 148s tarExtract: Done: 0 errors, 0 filesExist, 0 sizeExist, 0 sizeExistComp, 10 filesTotal, 4804340 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377800 sizeNewComp, 13 inodeLast 148s Xfer PIDs are now 148s xferPids 148s full backup 0 complete, 10 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 148s BackupExpire: cntFull = 1, cntIncr = 0, firstFull = 0, firstIncr = , oldestIncr = 0, oldestFull = 1.15740740740741e-05 148s __bpc_progress_state__ fsck 148s Running BackupPC_refCountUpdate -h localhost on localhost 148s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 148s Xfer PIDs are now 3766 148s xferPids 3766 148s BackupPC_refCountUpdate: doing fsck on localhost #0 (full) since $ConfRefCntFsck == 1 148s __bpc_progress_state__ refCnt #0 148s __bpc_progress_state__ cntUpdate #0 148s __bpc_progress_state__ rename #0 148s __bpc_progress_state__ sumUpdate 148s __bpc_progress_fileCnt__ 0/128 148s __bpc_progress_fileCnt__ 8/128 148s __bpc_progress_fileCnt__ 16/128 148s __bpc_progress_fileCnt__ 24/128 148s __bpc_progress_fileCnt__ 32/128 148s __bpc_progress_fileCnt__ 40/128 148s __bpc_progress_fileCnt__ 48/128 148s __bpc_progress_fileCnt__ 56/128 148s __bpc_progress_fileCnt__ 64/128 148s __bpc_progress_fileCnt__ 72/128 148s __bpc_progress_fileCnt__ 80/128 148s __bpc_progress_fileCnt__ 88/128 148s __bpc_progress_fileCnt__ 96/128 148s __bpc_progress_fileCnt__ 104/128 148s __bpc_progress_fileCnt__ 112/128 148s __bpc_progress_fileCnt__ 120/128 148s __bpc_progress_state__ rename total 148s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 148s Xfer PIDs are now 148s xferPids 148s Finished BackupPC_refCountUpdate (running time: 0 sec) 148s Xfer PIDs are now 148s xferPids 148s full backup complete 148s OK: Full backup succeeded 148s Changing share content and performing an incremental backup 148s Backup type: type = incr, needs_full = , needs_incr = , lastFullTime = 1711169264, opts{f} = , opts{i} = 1, opts{F} = 148s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 148s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 148s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.006 148s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.1.z created 2024-03-23 04:47:45 148s Backup prep: type = incr, case = 3, inPlace = 1, doDuplicate = 1, newBkupNum = 1, newBkupIdx = 1, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = ) 148s Executing /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 148s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 148s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDuplicate line 89. 148s (Did you mean "$Host\'s" instead?) 148s Xfer PIDs are now 3836 148s xferPids 3836 148s __bpc_progress_state__ copy #0 -> #1 148s Copying backup #0 to #1 148s __bpc_progress_fileCnt__ 3 dirs 148s Xfer PIDs are now 3839,3836 148s xferPids 3839,3836 148s __bpc_progress_state__ sumUpdate 148s __bpc_progress_fileCnt__ 0/128 148s __bpc_progress_fileCnt__ 8/128 148s __bpc_progress_fileCnt__ 16/128 148s __bpc_progress_fileCnt__ 24/128 148s __bpc_progress_fileCnt__ 32/128 148s __bpc_progress_fileCnt__ 40/128 148s __bpc_progress_fileCnt__ 48/128 148s __bpc_progress_fileCnt__ 56/128 148s __bpc_progress_fileCnt__ 64/128 148s __bpc_progress_fileCnt__ 72/128 148s __bpc_progress_fileCnt__ 80/128 148s __bpc_progress_fileCnt__ 88/128 148s __bpc_progress_fileCnt__ 96/128 148s __bpc_progress_fileCnt__ 104/128 148s __bpc_progress_fileCnt__ 112/128 148s __bpc_progress_fileCnt__ 120/128 148s __bpc_progress_state__ rename total 148s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 148s Xfer PIDs are now 3836 148s xferPids 3836 148s BackupPC_backupDuplicate: got 0 errors and 0 file open errors 148s Finished BackupPC_backupDuplicate (running time: 0 sec) 148s __bpc_progress_state__ backup share "public" 148s Running: /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 148s incr backup started back to 2024-03-23 03:47:44 (backup #0) for share public 148s started incr dump, share=public 148s Xfer PIDs are now 3843,3842 148s xferPids 3843,3842 148s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 148s tar:1298 Getting files newer than Sat Mar 23 03:47:44 2024 148s 148s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 148s tarmode is now full, system, hidden, noreset, noverbose 148s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 148s __bpc_progress_fileCnt__ 0 148s new 644 0/0 480434 tmp.kYdmlN 148s new 644 0/0 480434 tmp.U7IKcl 148s new 644 0/0 480434 tmp.C7mOwv 148s same 644 0/0 480434 tmp.Y5Us5w 148s same 644 0/0 480434 tmp.QNr9Ha 148s new 644 0/0 480434 tmp.XoiYJX 148s new 644 0/0 480434 tmp.sOlZEz 148s same 644 0/0 480434 tmp.67ZfN2 148s same 644 0/0 480434 tmp.nAG9t7 148s same 644 0/0 480434 tmp.isiFRg 148s new 644 0/0 480434 tmp.7w0KhO 148s same 644 0/0 480434 tmp.1nS7YY 148s new 644 0/0 480434 tmp.JL5sHT 148s new 644 0/0 480434 tmp.9fK3Jv 148s same 644 0/0 480434 tmp.JQhh4Y 148s same 644 0/0 480434 tmp.CMSw38 148s same 644 0/0 480434 tmp.SMby5N 148s same 644 0/0 480434 tmp.LTmInn 148s new 644 0/0 480434 tmp.zcDJ4w 148s tar: dumped 20 files and 0 directories 148s Total bytes written: 9608680 (46.5 MiB/s) 148s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 148s new 644 0/0 480434 tmp.NlnJyq 148s __bpc_progress_fileCnt__ 20 148s tarExtract: Done: 0 errors, 10 filesExist, 4804340 sizeExist, 1377800 sizeExistComp, 20 filesTotal, 9608680 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377826 sizeNewComp, 24 inodeLast 148s Xfer PIDs are now 148s xferPids 148s incr backup 1 complete, 20 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 148s BackupExpire: cntFull = 2, cntIncr = 0, firstFull = 0, firstIncr = , oldestIncr = 0, oldestFull = 1.15740740740741e-05 148s __bpc_progress_state__ fsck 148s Running BackupPC_refCountUpdate -h localhost on localhost 148s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 148s Xfer PIDs are now 3849 148s xferPids 3849 148s __bpc_progress_state__ cntUpdate #1 148s __bpc_progress_state__ rename #1 148s __bpc_progress_state__ sumUpdate 148s __bpc_progress_fileCnt__ 0/128 148s __bpc_progress_fileCnt__ 8/128 148s __bpc_progress_fileCnt__ 16/128 148s __bpc_progress_fileCnt__ 24/128 148s __bpc_progress_fileCnt__ 32/128 148s __bpc_progress_fileCnt__ 40/128 148s __bpc_progress_fileCnt__ 48/128 148s __bpc_progress_fileCnt__ 56/128 148s __bpc_progress_fileCnt__ 64/128 148s __bpc_progress_fileCnt__ 72/128 148s __bpc_progress_fileCnt__ 80/128 148s __bpc_progress_fileCnt__ 88/128 148s __bpc_progress_fileCnt__ 96/128 148s __bpc_progress_fileCnt__ 104/128 148s __bpc_progress_fileCnt__ 112/128 148s __bpc_progress_fileCnt__ 120/128 148s __bpc_progress_state__ rename total 148s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 148s Xfer PIDs are now 148s xferPids 148s Finished BackupPC_refCountUpdate (running time: 0 sec) 148s Xfer PIDs are now 148s xferPids 148s incr backup complete 148s OK: Incremental backup succeeded 148s Done. 149s autopkgtest [04:47:46]: test smb-backup: -----------------------] 149s smb-backup PASS 149s autopkgtest [04:47:46]: test smb-backup: - - - - - - - - - - results - - - - - - - - - - 150s autopkgtest [04:47:47]: test authenticated-smb-backup: preparing testbed 153s Reading package lists... 153s Building dependency tree... 153s Reading state information... 154s Starting pkgProblemResolver with broken count: 0 154s Starting 2 pkgProblemResolver with broken count: 0 154s Done 154s The following NEW packages will be installed: 154s autopkgtest-satdep 154s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 154s Need to get 0 B/720 B of archives. 154s After this operation, 0 B of additional disk space will be used. 154s Get:1 /tmp/autopkgtest.HaodLW/2-autopkgtest-satdep.deb autopkgtest-satdep s390x 0 [720 B] 154s Selecting previously unselected package autopkgtest-satdep. 154s (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 ... 54358 files and directories currently installed.) 154s Preparing to unpack .../2-autopkgtest-satdep.deb ... 154s Unpacking autopkgtest-satdep (0) ... 154s Setting up autopkgtest-satdep (0) ... 156s (Reading database ... 54357 files and directories currently installed.) 156s Removing autopkgtest-satdep (0) ... 157s autopkgtest [04:47:54]: test authenticated-smb-backup: [----------------------- 157s Populating share path 157s Adding samba share 157s Adding [private] share 157s Creating user 157s Creating a local and samba user called smbtest4098 157s Setting samba password for the smbtest4098 user 157s Added user smbtest4098. 157s Configuring backuppc 157s Performing a full backup 157s Backup type: type = full, needs_full = , needs_incr = , lastFullTime = 1711169264, opts{f} = 1, opts{i} = , opts{F} = 157s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 157s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 157s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.006 157s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.2.z created 2024-03-23 04:47:54 157s Backup prep: type = full, case = 4, inPlace = 0, doDuplicate = 0, newBkupNum = 2, newBkupIdx = 2, lastBkupNum = 1, lastBkupIdx = 1 (FillCycle = 0, noFillCnt = 0) 157s __bpc_progress_state__ backup share "private" 157s Running: /usr/bin/smbclient \\\\localhost\\private -U smbtest4098 -E -d 1 -c tarmode\ full -mSMB3 -Tc - 157s full backup started for share private 157s started full dump, share=private 157s Xfer PIDs are now 4192,4191 157s xferPids 4192,4191 157s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\private -U smbtest4098 -E -d 1 -c tarmode\ full -mSMB3 -Tc - 158s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 1 158s tarmode is now full, system, hidden, noreset, noverbose 158s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 158s __bpc_progress_fileCnt__ 0 158s new 644 0/0 480434 tmp.LIyLLv 158s new 644 0/0 480434 tmp.AHFWbG 158s new 644 0/0 480434 tmp.tB7GES 158s new 644 0/0 480434 tmp.i4fer5 158s new 644 0/0 480434 tmp.O5T4mW 158s new 644 0/0 480434 tmp.hdf9Zu 158s new 644 0/0 480434 tmp.6c8pYC 158s new 644 0/0 480434 tmp.4BDbXD 158s new 644 0/0 480434 tmp.BC9XUP 158s tar: dumped 10 files and 0 directories 158s Total bytes written: 4804340 (26.7 MiB/s) 158s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 158s new 644 0/0 480434 tmp.sfwBJm 158s __bpc_progress_fileCnt__ 10 158s tarExtract: Done: 0 errors, 0 filesExist, 0 sizeExist, 0 sizeExistComp, 10 filesTotal, 4804340 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377810 sizeNewComp, 36 inodeLast 158s Xfer PIDs are now 158s xferPids 158s OrphanShareNameClean: removing orphan share public from /var/lib/backuppc/pc/localhost/2 158s __bpc_progress_state__ delete share #2/public 158s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDelete -h localhost -n 2 -l -m -s public / 158s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDelete line 102. 158s (Did you mean "$Host\'s" instead?) 158s Xfer PIDs are now 4198 158s xferPids 4198 158s BackupPC_backupDelete: removing #2/public/ 158s __bpc_progress_state__ merge #2/public/ -> #1/public/ 158s BackupPC_backupDelete: Merge into backup 1/public/ 158s mergeDir: attr write to /var/lib/backuppc/pc/localhost/1/fpublic//attrib failed (digest was ) 158s bpc_attrib_dirWrite: can't open/create raw /var/lib/backuppc/pc/localhost/1/fpublic for writing 158s Xfer PIDs are now 4198,4201 158s xferPids 4198,4201 158s __bpc_progress_state__ refCnt #1 158s __bpc_progress_state__ cntUpdate #1 158s __bpc_progress_state__ rename #1 158s __bpc_progress_state__ refCnt #2 158s BackupPC_refCountUpdate: localhost #2 inodeLast set to 37 (was 24) 158s __bpc_progress_state__ cntUpdate #2 158s __bpc_progress_state__ rename #2 158s __bpc_progress_state__ sumUpdate 158s __bpc_progress_fileCnt__ 0/128 158s __bpc_progress_fileCnt__ 8/128 158s __bpc_progress_fileCnt__ 16/128 158s __bpc_progress_fileCnt__ 24/128 158s __bpc_progress_fileCnt__ 32/128 158s __bpc_progress_fileCnt__ 40/128 158s __bpc_progress_fileCnt__ 48/128 158s __bpc_progress_fileCnt__ 56/128 158s __bpc_progress_fileCnt__ 64/128 158s __bpc_progress_fileCnt__ 72/128 158s __bpc_progress_fileCnt__ 80/128 158s __bpc_progress_fileCnt__ 88/128 158s __bpc_progress_fileCnt__ 96/128 158s __bpc_progress_fileCnt__ 104/128 158s __bpc_progress_fileCnt__ 112/128 158s __bpc_progress_fileCnt__ 120/128 158s __bpc_progress_state__ rename total 158s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 158s Xfer PIDs are now 4198 158s xferPids 4198 158s Xfer PIDs are now 158s xferPids 158s Finished BackupPC_backupDelete, status = 0 (running time: 0 sec) 158s Xfer PIDs are now 158s xferPids 158s full backup 2 complete, 10 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 158s BackupExpire: cntFull = 2, cntIncr = 1, firstFull = 0, firstIncr = 1, oldestIncr = 0.000115740740740741, oldestFull = 0.000127314814814815 158s __bpc_progress_state__ fsck 158s Running BackupPC_refCountUpdate -h localhost on localhost 158s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 158s Xfer PIDs are now 4204 158s xferPids 4204 158s BackupPC_refCountUpdate: doing fsck on localhost #2 (full) since $ConfRefCntFsck == 1 158s __bpc_progress_state__ refCnt #2 158s __bpc_progress_state__ cntUpdate #2 158s __bpc_progress_state__ rename #2 158s __bpc_progress_state__ sumUpdate 158s __bpc_progress_fileCnt__ 0/128 158s __bpc_progress_fileCnt__ 8/128 158s __bpc_progress_fileCnt__ 16/128 158s __bpc_progress_fileCnt__ 24/128 158s __bpc_progress_fileCnt__ 32/128 158s __bpc_progress_fileCnt__ 40/128 158s __bpc_progress_fileCnt__ 48/128 158s __bpc_progress_fileCnt__ 56/128 158s __bpc_progress_fileCnt__ 64/128 158s __bpc_progress_fileCnt__ 72/128 158s __bpc_progress_fileCnt__ 80/128 158s __bpc_progress_fileCnt__ 88/128 158s __bpc_progress_fileCnt__ 96/128 158s __bpc_progress_fileCnt__ 104/128 158s __bpc_progress_fileCnt__ 112/128 158s __bpc_progress_fileCnt__ 120/128 158s __bpc_progress_state__ rename total 158s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 158s Xfer PIDs are now 158s xferPids 158s Finished BackupPC_refCountUpdate (running time: 0 sec) 158s Xfer PIDs are now 158s xferPids 158s full backup complete 158s OK: Full backup succeeded 158s Changing share content and performing an incremental backup 158s Backup type: type = incr, needs_full = , needs_incr = , lastFullTime = 1711169274, opts{f} = , opts{i} = 1, opts{F} = 158s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 158s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 158s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.005 158s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.3.z created 2024-03-23 04:47:55 158s Backup prep: type = incr, case = 3, inPlace = 1, doDuplicate = 1, newBkupNum = 3, newBkupIdx = 3, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = 1) 158s Executing /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 158s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 158s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDuplicate line 89. 158s (Did you mean "$Host\'s" instead?) 158s Xfer PIDs are now 4274 158s xferPids 4274 158s __bpc_progress_state__ copy #2 -> #3 158s Copying backup #2 to #3 158s __bpc_progress_fileCnt__ 3 dirs 158s Xfer PIDs are now 4277,4274 158s xferPids 4277,4274 158s __bpc_progress_state__ sumUpdate 158s __bpc_progress_fileCnt__ 0/128 158s __bpc_progress_fileCnt__ 8/128 158s __bpc_progress_fileCnt__ 16/128 158s __bpc_progress_fileCnt__ 24/128 158s __bpc_progress_fileCnt__ 32/128 158s __bpc_progress_fileCnt__ 40/128 158s __bpc_progress_fileCnt__ 48/128 158s __bpc_progress_fileCnt__ 56/128 158s __bpc_progress_fileCnt__ 64/128 158s __bpc_progress_fileCnt__ 72/128 158s __bpc_progress_fileCnt__ 80/128 158s __bpc_progress_fileCnt__ 88/128 158s __bpc_progress_fileCnt__ 96/128 158s __bpc_progress_fileCnt__ 104/128 158s __bpc_progress_fileCnt__ 112/128 158s __bpc_progress_fileCnt__ 120/128 158s __bpc_progress_state__ rename total 158s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 158s Xfer PIDs are now 4274 158s xferPids 4274 158s BackupPC_backupDuplicate: got 0 errors and 0 file open errors 158s Finished BackupPC_backupDuplicate (running time: 0 sec) 158s __bpc_progress_state__ backup share "private" 158s Running: /usr/bin/smbclient \\\\localhost\\private -U smbtest4098 -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 158s incr backup started back to 2024-03-23 03:47:54 (backup #2) for share private 158s started incr dump, share=private 158s Xfer PIDs are now 4281,4280 158s xferPids 4281,4280 158s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\private -U smbtest4098 -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 158s tar:1298 Getting files newer than Sat Mar 23 03:47:54 2024 158s 159s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 159s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 159s tarmode is now full, system, hidden, noreset, noverbose 159s __bpc_progress_fileCnt__ 0 159s new 644 0/0 480434 tmp.H7saIO 159s same 644 0/0 480434 tmp.LIyLLv 159s same 644 0/0 480434 tmp.AHFWbG 159s new 644 0/0 480434 tmp.9J4Esl 159s new 644 0/0 480434 tmp.TJekcp 159s same 644 0/0 480434 tmp.tB7GES 159s same 644 0/0 480434 tmp.i4fer5 159s new 644 0/0 480434 tmp.Xezqax 159s same 644 0/0 480434 tmp.O5T4mW 159s same 644 0/0 480434 tmp.hdf9Zu 159s new 644 0/0 480434 tmp.TiESAN 159s new 644 0/0 480434 tmp.e1bXk4 159s same 644 0/0 480434 tmp.6c8pYC 159s new 644 0/0 480434 tmp.3WGPK7 159s same 644 0/0 480434 tmp.4BDbXD 159s new 644 0/0 480434 tmp.lMmpca 159s new 644 0/0 480434 tmp.g3k5AN 159s same 644 0/0 480434 tmp.BC9XUP 159s same 644 0/0 480434 tmp.sfwBJm 159s tar: dumped 20 files and 0 directories 159s Total bytes written: 9608680 (48.8 MiB/s) 159s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 159s new 644 0/0 480434 tmp.SErArG 159s __bpc_progress_fileCnt__ 20 159s tarExtract: Done: 0 errors, 10 filesExist, 4804340 sizeExist, 1377810 sizeExistComp, 20 filesTotal, 9608680 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377808 sizeNewComp, 47 inodeLast 159s Xfer PIDs are now 159s xferPids 159s incr backup 3 complete, 20 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 159s BackupExpire: cntFull = 3, cntIncr = 1, firstFull = 0, firstIncr = 1, oldestIncr = 0.000127314814814815, oldestFull = 0.000138888888888889 159s __bpc_progress_state__ fsck 159s Running BackupPC_refCountUpdate -h localhost on localhost 159s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 159s Xfer PIDs are now 4287 159s xferPids 4287 159s __bpc_progress_state__ cntUpdate #3 159s __bpc_progress_state__ rename #3 159s __bpc_progress_state__ sumUpdate 159s __bpc_progress_fileCnt__ 0/128 159s __bpc_progress_fileCnt__ 8/128 159s __bpc_progress_fileCnt__ 16/128 159s __bpc_progress_fileCnt__ 24/128 159s __bpc_progress_fileCnt__ 32/128 159s __bpc_progress_fileCnt__ 40/128 159s __bpc_progress_fileCnt__ 48/128 159s __bpc_progress_fileCnt__ 56/128 159s __bpc_progress_fileCnt__ 64/128 159s __bpc_progress_fileCnt__ 72/128 159s __bpc_progress_fileCnt__ 80/128 159s __bpc_progress_fileCnt__ 88/128 159s __bpc_progress_fileCnt__ 96/128 159s __bpc_progress_fileCnt__ 104/128 159s __bpc_progress_fileCnt__ 112/128 159s __bpc_progress_fileCnt__ 120/128 159s __bpc_progress_state__ rename total 159s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 159s Xfer PIDs are now 159s xferPids 159s Finished BackupPC_refCountUpdate (running time: 0 sec) 159s Xfer PIDs are now 159s xferPids 159s incr backup complete 159s OK: Incremental backup succeeded 159s Done. 159s Deleted user smbtest4098. 159s userdel: smbtest4098 mail spool (/var/mail/smbtest4098) not found 159s autopkgtest [04:47:56]: test authenticated-smb-backup: -----------------------] 160s autopkgtest [04:47:57]: test authenticated-smb-backup: - - - - - - - - - - results - - - - - - - - - - 160s authenticated-smb-backup PASS 160s autopkgtest [04:47:57]: @@@@@@@@@@@@@@@@@@@@ summary 160s smb-backup PASS 160s authenticated-smb-backup PASS 172s Creating nova instance adt-noble-s390x-backuppc-20240323-044516-juju-7f2275-prod-proposed-migration-environment-2 from image adt/ubuntu-noble-s390x-server-20240322.img (UUID c8671f9a-0e89-48e3-af4f-3c79b89294e8)...