0s autopkgtest [01:42:30]: starting date and time: 2024-07-23 01:42:30+0000 0s autopkgtest [01:42:30]: git checkout: fd3bed09 nova: allow more retries for quota issues 0s autopkgtest [01:42:30]: host juju-7f2275-prod-proposed-migration-environment-3; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.8f876h9y/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:merecat --apt-upgrade backuppc --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=merecat/2.31+git20220513+ds-5 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-ppc64el --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-3@bos03-ppc64el-1.secgroup --name adt-oracular-ppc64el-backuppc-20240723-014228-juju-7f2275-prod-proposed-migration-environment-3-c796b722-0643-4855-98a4-089c34d0de50 --image adt/ubuntu-oracular-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-3 --net-id=net_prod-proposed-migration-ppc64el -e TERM=linux -e ''"'"'http_proxy=http://squid.internal:3128'"'"'' -e ''"'"'https_proxy=http://squid.internal:3128'"'"'' -e ''"'"'no_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 152s autopkgtest [01:45:02]: testbed dpkg architecture: ppc64el 153s autopkgtest [01:45:03]: testbed apt version: 2.9.6 153s autopkgtest [01:45:03]: @@@@@@@@@@@@@@@@@@@@ test bed setup 154s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [126 kB] 155s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [407 kB] 155s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [3440 B] 155s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [58.5 kB] 155s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [8548 B] 155s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el Packages [100 kB] 155s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el c-n-f Metadata [2116 B] 155s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/restricted ppc64el Packages [1368 B] 155s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/restricted ppc64el c-n-f Metadata [120 B] 155s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/universe ppc64el Packages [472 kB] 155s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/universe ppc64el c-n-f Metadata [8952 B] 155s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse ppc64el Packages [1448 B] 155s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse ppc64el c-n-f Metadata [120 B] 157s Fetched 1191 kB in 1s (1514 kB/s) 157s Reading package lists... 161s Reading package lists... 161s Building dependency tree... 161s Reading state information... 161s Calculating upgrade... 161s The following packages will be upgraded: 161s gcc-14-base libgcc-s1 libstdc++6 systemd-hwe-hwdb 161s 4 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 161s Need to get 979 kB of archives. 161s After this operation, 1024 B of additional disk space will be used. 161s Get:1 http://ftpmaster.internal/ubuntu oracular/main ppc64el gcc-14-base ppc64el 14.1.0-5ubuntu1 [49.9 kB] 161s Get:2 http://ftpmaster.internal/ubuntu oracular/main ppc64el libstdc++6 ppc64el 14.1.0-5ubuntu1 [886 kB] 162s Get:3 http://ftpmaster.internal/ubuntu oracular/main ppc64el libgcc-s1 ppc64el 14.1.0-5ubuntu1 [39.1 kB] 162s Get:4 http://ftpmaster.internal/ubuntu oracular/main ppc64el systemd-hwe-hwdb all 256.2.1 [3210 B] 162s Fetched 979 kB in 1s (1802 kB/s) 162s (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 ... 72765 files and directories currently installed.) 162s Preparing to unpack .../gcc-14-base_14.1.0-5ubuntu1_ppc64el.deb ... 162s Unpacking gcc-14-base:ppc64el (14.1.0-5ubuntu1) over (14.1.0-4ubuntu2) ... 162s Setting up gcc-14-base:ppc64el (14.1.0-5ubuntu1) ... 162s (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 ... 72765 files and directories currently installed.) 162s Preparing to unpack .../libstdc++6_14.1.0-5ubuntu1_ppc64el.deb ... 162s Unpacking libstdc++6:ppc64el (14.1.0-5ubuntu1) over (14.1.0-4ubuntu2) ... 162s Setting up libstdc++6:ppc64el (14.1.0-5ubuntu1) ... 162s (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 ... 72765 files and directories currently installed.) 162s Preparing to unpack .../libgcc-s1_14.1.0-5ubuntu1_ppc64el.deb ... 162s Unpacking libgcc-s1:ppc64el (14.1.0-5ubuntu1) over (14.1.0-4ubuntu2) ... 162s Setting up libgcc-s1:ppc64el (14.1.0-5ubuntu1) ... 162s (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 ... 72765 files and directories currently installed.) 162s Preparing to unpack .../systemd-hwe-hwdb_256.2.1_all.deb ... 162s Unpacking systemd-hwe-hwdb (256.2.1) over (255.1.3) ... 162s Setting up systemd-hwe-hwdb (256.2.1) ... 163s Processing triggers for udev (256-1ubuntu1) ... 163s Processing triggers for libc-bin (2.39-0ubuntu9) ... 163s Reading package lists... 164s Building dependency tree... 164s Reading state information... 164s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 164s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 164s Hit:2 http://ftpmaster.internal/ubuntu oracular InRelease 164s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease 164s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease 165s Reading package lists... 165s Reading package lists... 166s Building dependency tree... 166s Reading state information... 166s Calculating upgrade... 166s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 166s Reading package lists... 166s Building dependency tree... 166s Reading state information... 166s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 172s autopkgtest [01:45:22]: testbed running kernel: Linux 6.8.0-31-generic #31-Ubuntu SMP Sat Apr 20 00:05:55 UTC 2024 172s autopkgtest [01:45:22]: @@@@@@@@@@@@@@@@@@@@ apt-source backuppc 175s Get:1 http://ftpmaster.internal/ubuntu oracular/main backuppc 4.4.0-8.1 (dsc) [2165 B] 175s Get:2 http://ftpmaster.internal/ubuntu oracular/main backuppc 4.4.0-8.1 (tar) [657 kB] 175s Get:3 http://ftpmaster.internal/ubuntu oracular/main backuppc 4.4.0-8.1 (diff) [61.1 kB] 175s gpgv: Signature made Sun Jul 7 23:09:26 2024 UTC 175s gpgv: using RSA key 7D1ACFFAD9E0806C9C4CD3925C13D6DB93052E03 175s gpgv: Can't check signature: No public key 175s dpkg-source: warning: cannot verify inline signature for ./backuppc_4.4.0-8.1.dsc: no acceptable signature found 175s autopkgtest [01:45:25]: testing package backuppc version 4.4.0-8.1 176s autopkgtest [01:45:26]: build not needed 176s autopkgtest [01:45:26]: test smb-backup: preparing testbed 179s Reading package lists... 179s Building dependency tree... 179s Reading state information... 180s Starting pkgProblemResolver with broken count: 0 180s Starting 2 pkgProblemResolver with broken count: 0 180s Done 180s The following additional packages will be installed: 180s apache2 apache2-bin apache2-data apache2-utils backuppc backuppc-rsync 180s libapr1t64 libaprutil1-dbd-sqlite3 libaprutil1-ldap libaprutil1t64 180s libarchive-zip-perl libavahi-client3 libavahi-common-data libavahi-common3 180s libbackuppc-xs-perl libcgi-pm-perl libcups2t64 libfile-listing-perl 180s libhtml-parser-perl libhtml-tagset-perl libhttp-date-perl libldb2 180s liblua5.4-0 libnsl2 libsmbclient0 libtalloc2 libtdb1 libtevent0t64 180s libtime-parsedate-perl libtimedate-perl liburi-perl libwbclient0 postfix 180s samba samba-common samba-common-bin samba-libs smbclient ssl-cert 180s Suggested packages: 180s apache2-doc apache2-suexec-pristine | apache2-suexec-custom www-browser 180s certbot | acme-tiny | acmetool | dehydrated | lacme | lecm | lego 180s libscgi-perl par2 w3m | www-browser cups-common libdata-dump-perl 180s libbusiness-isbn-perl libregexp-ipv6-perl libwww-perl mail-reader 180s postfix-cdb postfix-doc postfix-ldap postfix-lmdb postfix-mta-sts-resolver 180s postfix-mongodb postfix-mysql postfix-pcre postfix-pgsql postfix-sqlite 180s procmail sasl2-bin | dovecot-common ctdb winbind heimdal-clients cifs-utils 180s Recommended packages: 180s libio-dirent-perl rrdtool libcgi-fast-perl libhttp-message-perl attr 180s samba-vfs-modules python3-samba 180s The following NEW packages will be installed: 180s apache2 apache2-bin apache2-data apache2-utils autopkgtest-satdep backuppc 180s backuppc-rsync libapr1t64 libaprutil1-dbd-sqlite3 libaprutil1-ldap 180s libaprutil1t64 libarchive-zip-perl libavahi-client3 libavahi-common-data 180s libavahi-common3 libbackuppc-xs-perl libcgi-pm-perl libcups2t64 180s libfile-listing-perl libhtml-parser-perl libhtml-tagset-perl 180s libhttp-date-perl libldb2 liblua5.4-0 libnsl2 libsmbclient0 libtalloc2 180s libtdb1 libtevent0t64 libtime-parsedate-perl libtimedate-perl liburi-perl 180s libwbclient0 postfix samba samba-common samba-common-bin samba-libs 180s smbclient ssl-cert 180s 0 upgraded, 40 newly installed, 0 to remove and 0 not upgraded. 180s Need to get 16.3 MB/16.3 MB of archives. 180s After this operation, 83.0 MB of additional disk space will be used. 180s Get:1 /tmp/autopkgtest.E6gt7e/1-autopkgtest-satdep.deb autopkgtest-satdep ppc64el 0 [724 B] 180s Get:2 http://ftpmaster.internal/ubuntu oracular/main ppc64el libapr1t64 ppc64el 1.7.2-3.2 [133 kB] 180s Get:3 http://ftpmaster.internal/ubuntu oracular/main ppc64el libaprutil1t64 ppc64el 1.6.3-2ubuntu1 [112 kB] 180s Get:4 http://ftpmaster.internal/ubuntu oracular/main ppc64el libaprutil1-dbd-sqlite3 ppc64el 1.6.3-2ubuntu1 [12.2 kB] 180s Get:5 http://ftpmaster.internal/ubuntu oracular/main ppc64el libaprutil1-ldap ppc64el 1.6.3-2ubuntu1 [9230 B] 180s Get:6 http://ftpmaster.internal/ubuntu oracular/main ppc64el liblua5.4-0 ppc64el 5.4.6-3build2 [216 kB] 180s Get:7 http://ftpmaster.internal/ubuntu oracular/main ppc64el apache2-bin ppc64el 2.4.59-2ubuntu2 [1558 kB] 181s Get:8 http://ftpmaster.internal/ubuntu oracular/main ppc64el apache2-data all 2.4.59-2ubuntu2 [163 kB] 181s Get:9 http://ftpmaster.internal/ubuntu oracular/main ppc64el apache2-utils ppc64el 2.4.59-2ubuntu2 [102 kB] 181s Get:10 http://ftpmaster.internal/ubuntu oracular/main ppc64el apache2 ppc64el 2.4.59-2ubuntu2 [90.3 kB] 181s Get:11 http://ftpmaster.internal/ubuntu oracular/main ppc64el backuppc-rsync ppc64el 3.1.3.0-3ubuntu1 [318 kB] 181s Get:12 http://ftpmaster.internal/ubuntu oracular/main ppc64el ssl-cert all 1.1.2ubuntu2 [18.0 kB] 181s Get:13 http://ftpmaster.internal/ubuntu oracular/main ppc64el libnsl2 ppc64el 1.3.0-3build3 [48.9 kB] 181s Get:14 http://ftpmaster.internal/ubuntu oracular/main ppc64el postfix ppc64el 3.9.0-2 [1371 kB] 181s Get:15 http://ftpmaster.internal/ubuntu oracular/main ppc64el libarchive-zip-perl all 1.68-1 [90.2 kB] 181s Get:16 http://ftpmaster.internal/ubuntu oracular/main ppc64el libbackuppc-xs-perl ppc64el 0.62-2build5 [74.9 kB] 181s Get:17 http://ftpmaster.internal/ubuntu oracular/main ppc64el libhtml-tagset-perl all 3.24-1 [14.1 kB] 181s Get:18 http://ftpmaster.internal/ubuntu oracular/main ppc64el liburi-perl all 5.28-1 [88.1 kB] 181s Get:19 http://ftpmaster.internal/ubuntu oracular/main ppc64el libhtml-parser-perl ppc64el 3.82-1 [91.2 kB] 181s Get:20 http://ftpmaster.internal/ubuntu oracular/main ppc64el libcgi-pm-perl all 4.66-1 [185 kB] 181s Get:21 http://ftpmaster.internal/ubuntu oracular/main ppc64el libtimedate-perl all 2.3300-2 [34.0 kB] 181s Get:22 http://ftpmaster.internal/ubuntu oracular/main ppc64el libhttp-date-perl all 6.06-1 [10.2 kB] 181s Get:23 http://ftpmaster.internal/ubuntu oracular/main ppc64el libfile-listing-perl all 6.16-1 [11.3 kB] 181s Get:24 http://ftpmaster.internal/ubuntu oracular/main ppc64el libtime-parsedate-perl all 2015.103-4 [28.6 kB] 181s Get:25 http://ftpmaster.internal/ubuntu oracular/main ppc64el backuppc ppc64el 4.4.0-8.1 [540 kB] 181s Get:26 http://ftpmaster.internal/ubuntu oracular/main ppc64el samba-common all 2:4.20.2+dfsg-2ubuntu2 [65.4 kB] 181s Get:27 http://ftpmaster.internal/ubuntu oracular/main ppc64el libavahi-common-data ppc64el 0.8-13ubuntu6 [29.7 kB] 181s Get:28 http://ftpmaster.internal/ubuntu oracular/main ppc64el libavahi-common3 ppc64el 0.8-13ubuntu6 [26.3 kB] 181s Get:29 http://ftpmaster.internal/ubuntu oracular/main ppc64el libavahi-client3 ppc64el 0.8-13ubuntu6 [30.8 kB] 181s Get:30 http://ftpmaster.internal/ubuntu oracular/main ppc64el libcups2t64 ppc64el 2.4.7-1.2ubuntu9 [345 kB] 181s Get:31 http://ftpmaster.internal/ubuntu oracular/main ppc64el libtalloc2 ppc64el 2.4.2-1build2 [36.7 kB] 181s Get:32 http://ftpmaster.internal/ubuntu oracular/main ppc64el libtdb1 ppc64el 1.4.10-1build1 [62.8 kB] 181s Get:33 http://ftpmaster.internal/ubuntu oracular/main ppc64el libtevent0t64 ppc64el 0.16.1-2build1 [51.2 kB] 181s Get:34 http://ftpmaster.internal/ubuntu oracular/main ppc64el libldb2 ppc64el 2:2.9.1+samba4.20.2+dfsg-2ubuntu2 [221 kB] 181s Get:35 http://ftpmaster.internal/ubuntu oracular/main ppc64el libwbclient0 ppc64el 2:4.20.2+dfsg-2ubuntu2 [79.9 kB] 181s Get:36 http://ftpmaster.internal/ubuntu oracular/main ppc64el samba-libs ppc64el 2:4.20.2+dfsg-2ubuntu2 [6845 kB] 181s Get:37 http://ftpmaster.internal/ubuntu oracular/main ppc64el samba-common-bin ppc64el 2:4.20.2+dfsg-2ubuntu2 [1459 kB] 181s Get:38 http://ftpmaster.internal/ubuntu oracular/main ppc64el samba ppc64el 2:4.20.2+dfsg-2ubuntu2 [1116 kB] 181s Get:39 http://ftpmaster.internal/ubuntu oracular/main ppc64el libsmbclient0 ppc64el 2:4.20.2+dfsg-2ubuntu2 [69.8 kB] 181s Get:40 http://ftpmaster.internal/ubuntu oracular/main ppc64el smbclient ppc64el 2:4.20.2+dfsg-2ubuntu2 [529 kB] 181s Preconfiguring packages ... 182s Fetched 16.3 MB in 1s (12.9 MB/s) 182s Selecting previously unselected package libapr1t64:ppc64el. 182s (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 ... 72765 files and directories currently installed.) 182s Preparing to unpack .../00-libapr1t64_1.7.2-3.2_ppc64el.deb ... 182s Unpacking libapr1t64:ppc64el (1.7.2-3.2) ... 182s Selecting previously unselected package libaprutil1t64:ppc64el. 182s Preparing to unpack .../01-libaprutil1t64_1.6.3-2ubuntu1_ppc64el.deb ... 182s Unpacking libaprutil1t64:ppc64el (1.6.3-2ubuntu1) ... 182s Selecting previously unselected package libaprutil1-dbd-sqlite3:ppc64el. 182s Preparing to unpack .../02-libaprutil1-dbd-sqlite3_1.6.3-2ubuntu1_ppc64el.deb ... 182s Unpacking libaprutil1-dbd-sqlite3:ppc64el (1.6.3-2ubuntu1) ... 182s Selecting previously unselected package libaprutil1-ldap:ppc64el. 182s Preparing to unpack .../03-libaprutil1-ldap_1.6.3-2ubuntu1_ppc64el.deb ... 182s Unpacking libaprutil1-ldap:ppc64el (1.6.3-2ubuntu1) ... 182s Selecting previously unselected package liblua5.4-0:ppc64el. 182s Preparing to unpack .../04-liblua5.4-0_5.4.6-3build2_ppc64el.deb ... 182s Unpacking liblua5.4-0:ppc64el (5.4.6-3build2) ... 182s Selecting previously unselected package apache2-bin. 182s Preparing to unpack .../05-apache2-bin_2.4.59-2ubuntu2_ppc64el.deb ... 182s Unpacking apache2-bin (2.4.59-2ubuntu2) ... 182s Selecting previously unselected package apache2-data. 182s Preparing to unpack .../06-apache2-data_2.4.59-2ubuntu2_all.deb ... 182s Unpacking apache2-data (2.4.59-2ubuntu2) ... 182s Selecting previously unselected package apache2-utils. 182s Preparing to unpack .../07-apache2-utils_2.4.59-2ubuntu2_ppc64el.deb ... 182s Unpacking apache2-utils (2.4.59-2ubuntu2) ... 182s Selecting previously unselected package apache2. 182s Preparing to unpack .../08-apache2_2.4.59-2ubuntu2_ppc64el.deb ... 182s Unpacking apache2 (2.4.59-2ubuntu2) ... 182s Selecting previously unselected package backuppc-rsync. 182s Preparing to unpack .../09-backuppc-rsync_3.1.3.0-3ubuntu1_ppc64el.deb ... 182s Unpacking backuppc-rsync (3.1.3.0-3ubuntu1) ... 182s Selecting previously unselected package ssl-cert. 182s Preparing to unpack .../10-ssl-cert_1.1.2ubuntu2_all.deb ... 182s Unpacking ssl-cert (1.1.2ubuntu2) ... 182s Selecting previously unselected package libnsl2:ppc64el. 182s Preparing to unpack .../11-libnsl2_1.3.0-3build3_ppc64el.deb ... 182s Unpacking libnsl2:ppc64el (1.3.0-3build3) ... 182s Selecting previously unselected package postfix. 182s Preparing to unpack .../12-postfix_3.9.0-2_ppc64el.deb ... 182s Unpacking postfix (3.9.0-2) ... 182s Selecting previously unselected package libarchive-zip-perl. 182s Preparing to unpack .../13-libarchive-zip-perl_1.68-1_all.deb ... 182s Unpacking libarchive-zip-perl (1.68-1) ... 182s Selecting previously unselected package libbackuppc-xs-perl:ppc64el. 182s Preparing to unpack .../14-libbackuppc-xs-perl_0.62-2build5_ppc64el.deb ... 182s Unpacking libbackuppc-xs-perl:ppc64el (0.62-2build5) ... 182s Selecting previously unselected package libhtml-tagset-perl. 182s Preparing to unpack .../15-libhtml-tagset-perl_3.24-1_all.deb ... 182s Unpacking libhtml-tagset-perl (3.24-1) ... 182s Selecting previously unselected package liburi-perl. 182s Preparing to unpack .../16-liburi-perl_5.28-1_all.deb ... 182s Unpacking liburi-perl (5.28-1) ... 182s Selecting previously unselected package libhtml-parser-perl:ppc64el. 182s Preparing to unpack .../17-libhtml-parser-perl_3.82-1_ppc64el.deb ... 182s Unpacking libhtml-parser-perl:ppc64el (3.82-1) ... 182s Selecting previously unselected package libcgi-pm-perl. 182s Preparing to unpack .../18-libcgi-pm-perl_4.66-1_all.deb ... 182s Unpacking libcgi-pm-perl (4.66-1) ... 182s Selecting previously unselected package libtimedate-perl. 182s Preparing to unpack .../19-libtimedate-perl_2.3300-2_all.deb ... 182s Unpacking libtimedate-perl (2.3300-2) ... 182s Selecting previously unselected package libhttp-date-perl. 182s Preparing to unpack .../20-libhttp-date-perl_6.06-1_all.deb ... 182s Unpacking libhttp-date-perl (6.06-1) ... 182s Selecting previously unselected package libfile-listing-perl. 182s Preparing to unpack .../21-libfile-listing-perl_6.16-1_all.deb ... 182s Unpacking libfile-listing-perl (6.16-1) ... 182s Selecting previously unselected package libtime-parsedate-perl. 182s Preparing to unpack .../22-libtime-parsedate-perl_2015.103-4_all.deb ... 182s Unpacking libtime-parsedate-perl (2015.103-4) ... 182s Selecting previously unselected package backuppc. 182s Preparing to unpack .../23-backuppc_4.4.0-8.1_ppc64el.deb ... 182s Unpacking backuppc (4.4.0-8.1) ... 182s Selecting previously unselected package samba-common. 182s Preparing to unpack .../24-samba-common_2%3a4.20.2+dfsg-2ubuntu2_all.deb ... 182s Unpacking samba-common (2:4.20.2+dfsg-2ubuntu2) ... 182s Selecting previously unselected package libavahi-common-data:ppc64el. 182s Preparing to unpack .../25-libavahi-common-data_0.8-13ubuntu6_ppc64el.deb ... 182s Unpacking libavahi-common-data:ppc64el (0.8-13ubuntu6) ... 182s Selecting previously unselected package libavahi-common3:ppc64el. 182s Preparing to unpack .../26-libavahi-common3_0.8-13ubuntu6_ppc64el.deb ... 182s Unpacking libavahi-common3:ppc64el (0.8-13ubuntu6) ... 182s Selecting previously unselected package libavahi-client3:ppc64el. 182s Preparing to unpack .../27-libavahi-client3_0.8-13ubuntu6_ppc64el.deb ... 182s Unpacking libavahi-client3:ppc64el (0.8-13ubuntu6) ... 182s Selecting previously unselected package libcups2t64:ppc64el. 182s Preparing to unpack .../28-libcups2t64_2.4.7-1.2ubuntu9_ppc64el.deb ... 182s Unpacking libcups2t64:ppc64el (2.4.7-1.2ubuntu9) ... 182s Selecting previously unselected package libtalloc2:ppc64el. 182s Preparing to unpack .../29-libtalloc2_2.4.2-1build2_ppc64el.deb ... 182s Unpacking libtalloc2:ppc64el (2.4.2-1build2) ... 182s Selecting previously unselected package libtdb1:ppc64el. 182s Preparing to unpack .../30-libtdb1_1.4.10-1build1_ppc64el.deb ... 182s Unpacking libtdb1:ppc64el (1.4.10-1build1) ... 182s Selecting previously unselected package libtevent0t64:ppc64el. 183s Preparing to unpack .../31-libtevent0t64_0.16.1-2build1_ppc64el.deb ... 183s Unpacking libtevent0t64:ppc64el (0.16.1-2build1) ... 183s Selecting previously unselected package libldb2:ppc64el. 183s Preparing to unpack .../32-libldb2_2%3a2.9.1+samba4.20.2+dfsg-2ubuntu2_ppc64el.deb ... 183s Unpacking libldb2:ppc64el (2:2.9.1+samba4.20.2+dfsg-2ubuntu2) ... 183s Selecting previously unselected package libwbclient0:ppc64el. 183s Preparing to unpack .../33-libwbclient0_2%3a4.20.2+dfsg-2ubuntu2_ppc64el.deb ... 183s Unpacking libwbclient0:ppc64el (2:4.20.2+dfsg-2ubuntu2) ... 183s Selecting previously unselected package samba-libs:ppc64el. 183s Preparing to unpack .../34-samba-libs_2%3a4.20.2+dfsg-2ubuntu2_ppc64el.deb ... 183s Unpacking samba-libs:ppc64el (2:4.20.2+dfsg-2ubuntu2) ... 183s Selecting previously unselected package samba-common-bin. 183s Preparing to unpack .../35-samba-common-bin_2%3a4.20.2+dfsg-2ubuntu2_ppc64el.deb ... 183s Unpacking samba-common-bin (2:4.20.2+dfsg-2ubuntu2) ... 183s Selecting previously unselected package samba. 183s Preparing to unpack .../36-samba_2%3a4.20.2+dfsg-2ubuntu2_ppc64el.deb ... 183s Unpacking samba (2:4.20.2+dfsg-2ubuntu2) ... 183s Selecting previously unselected package libsmbclient0:ppc64el. 183s Preparing to unpack .../37-libsmbclient0_2%3a4.20.2+dfsg-2ubuntu2_ppc64el.deb ... 183s Unpacking libsmbclient0:ppc64el (2:4.20.2+dfsg-2ubuntu2) ... 183s Selecting previously unselected package smbclient. 183s Preparing to unpack .../38-smbclient_2%3a4.20.2+dfsg-2ubuntu2_ppc64el.deb ... 183s Unpacking smbclient (2:4.20.2+dfsg-2ubuntu2) ... 183s Selecting previously unselected package autopkgtest-satdep. 183s Preparing to unpack .../39-1-autopkgtest-satdep.deb ... 183s Unpacking autopkgtest-satdep (0) ... 183s Setting up libarchive-zip-perl (1.68-1) ... 183s Setting up libtdb1:ppc64el (1.4.10-1build1) ... 183s Setting up libhtml-tagset-perl (3.24-1) ... 183s Setting up samba-common (2:4.20.2+dfsg-2ubuntu2) ... 183s 183s Creating config file /etc/samba/smb.conf with new version 183s Setting up libwbclient0:ppc64el (2:4.20.2+dfsg-2ubuntu2) ... 183s Setting up libtalloc2:ppc64el (2.4.2-1build2) ... 183s Setting up backuppc-rsync (3.1.3.0-3ubuntu1) ... 183s Setting up ssl-cert (1.1.2ubuntu2) ... 184s Created symlink '/etc/systemd/system/multi-user.target.wants/ssl-cert.service' → '/usr/lib/systemd/system/ssl-cert.service'. 185s Setting up libavahi-common-data:ppc64el (0.8-13ubuntu6) ... 185s Setting up libtimedate-perl (2.3300-2) ... 185s Setting up libtime-parsedate-perl (2015.103-4) ... 185s Setting up libapr1t64:ppc64el (1.7.2-3.2) ... 185s Setting up libnsl2:ppc64el (1.3.0-3build3) ... 185s Setting up liblua5.4-0:ppc64el (5.4.6-3build2) ... 185s Setting up apache2-data (2.4.59-2ubuntu2) ... 185s Setting up libbackuppc-xs-perl:ppc64el (0.62-2build5) ... 185s Setting up liburi-perl (5.28-1) ... 185s Setting up libtevent0t64:ppc64el (0.16.1-2build1) ... 185s Setting up libaprutil1t64:ppc64el (1.6.3-2ubuntu1) ... 185s Setting up libhttp-date-perl (6.06-1) ... 185s Setting up libfile-listing-perl (6.16-1) ... 185s Setting up libavahi-common3:ppc64el (0.8-13ubuntu6) ... 185s Setting up libaprutil1-ldap:ppc64el (1.6.3-2ubuntu1) ... 185s Setting up libaprutil1-dbd-sqlite3:ppc64el (1.6.3-2ubuntu1) ... 185s Setting up postfix (3.9.0-2) ... 185s info: Selecting GID from range 100 to 999 ... 185s info: Adding group `postfix' (GID 111) ... 185s info: Selecting UID from range 100 to 999 ... 185s 185s info: Adding system user `postfix' (UID 107) ... 185s info: Adding new user `postfix' (UID 107) with group `postfix' ... 185s info: Not creating home directory `/var/spool/postfix'. 185s Creating /etc/postfix/dynamicmaps.cf 185s info: Selecting GID from range 100 to 999 ... 185s info: Adding group `postdrop' (GID 112) ... 185s setting myhostname: autopkgtest.local 185s setting alias maps 185s setting alias database 185s changing /etc/mailname to autopkgtest.local 185s setting myorigin 185s setting destinations: $myhostname, autopkgtest.local, localhost.local, , localhost 185s setting relayhost: 185s setting mynetworks: 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128 185s setting mailbox_size_limit: 0 185s setting recipient_delimiter: + 187s setting inet_interfaces: all 189s setting inet_protocols: all 189s /etc/aliases does not exist, creating it. 189s WARNING: /etc/aliases exists, but does not have a root alias. 189s 189s Postfix (main.cf) is now set up with a default configuration. If you need to 189s make changes, edit /etc/postfix/main.cf (and others) as needed. To view 189s Postfix configuration values, see postconf(1). 189s 189s After modifying main.cf, be sure to run 'systemctl reload postfix'. 189s 191s Running newaliases 192s Created symlink '/etc/systemd/system/multi-user.target.wants/postfix.service' → '/usr/lib/systemd/system/postfix.service'. 193s Setting up libhtml-parser-perl:ppc64el (3.82-1) ... 193s Setting up libldb2:ppc64el (2:2.9.1+samba4.20.2+dfsg-2ubuntu2) ... 193s Setting up libavahi-client3:ppc64el (0.8-13ubuntu6) ... 193s Setting up apache2-utils (2.4.59-2ubuntu2) ... 193s Setting up libcgi-pm-perl (4.66-1) ... 193s Setting up samba-libs:ppc64el (2:4.20.2+dfsg-2ubuntu2) ... 193s Setting up apache2-bin (2.4.59-2ubuntu2) ... 193s Setting up libsmbclient0:ppc64el (2:4.20.2+dfsg-2ubuntu2) ... 193s Setting up libcups2t64:ppc64el (2.4.7-1.2ubuntu9) ... 193s Setting up apache2 (2.4.59-2ubuntu2) ... 193s Enabling module mpm_event. 193s Enabling module authz_core. 193s Enabling module authz_host. 193s Enabling module authn_core. 193s Enabling module auth_basic. 193s Enabling module access_compat. 193s Enabling module authn_file. 193s Enabling module authz_user. 193s Enabling module alias. 193s Enabling module dir. 193s Enabling module autoindex. 193s Enabling module env. 193s Enabling module mime. 193s Enabling module negotiation. 193s Enabling module setenvif. 193s Enabling module filter. 193s Enabling module deflate. 193s Enabling module status. 193s Enabling module reqtimeout. 193s Enabling conf charset. 193s Enabling conf localized-error-pages. 193s Enabling conf other-vhosts-access-log. 193s Enabling conf security. 193s Enabling conf serve-cgi-bin. 193s Enabling site 000-default. 194s Created symlink '/etc/systemd/system/multi-user.target.wants/apache2.service' → '/usr/lib/systemd/system/apache2.service'. 195s Created symlink '/etc/systemd/system/multi-user.target.wants/apache-htcacheclean.service' → '/usr/lib/systemd/system/apache-htcacheclean.service'. 196s Setting up backuppc (4.4.0-8.1) ... 196s 196s apache2_invoke: Enable configuration backuppc.conf 196s warn: The home directory `/var/lib/backuppc' already exists. Not touching this directory. 196s warn: Warning: The home directory `/var/lib/backuppc' does not belong to the user you are currently creating. 196s Adding password for user backuppc 196s Considering dependency authn_core for auth_basic: 196s Module authn_core already enabled 196s Module auth_basic already enabled 196s Considering dependency authz_core for authz_groupfile: 196s Module authz_core already enabled 196s Enabling module authz_groupfile. 196s To activate the new configuration, you need to run: 196s systemctl restart apache2 196s Module authn_file already enabled 196s Considering dependency authz_core for authz_user: 196s Module authz_core already enabled 196s Module authz_user already enabled 196s Your MPM seems to be threaded. Selecting cgid instead of cgi. 196s Enabling module cgid. 196s To activate the new configuration, you need to run: 196s systemctl restart apache2 196s 196s Creating config file /etc/backuppc/config.pl with new version 197s Created symlink '/etc/systemd/system/multi-user.target.wants/backuppc.service' → '/usr/lib/systemd/system/backuppc.service'. 197s Setting up smbclient (2:4.20.2+dfsg-2ubuntu2) ... 197s Setting up samba-common-bin (2:4.20.2+dfsg-2ubuntu2) ... 197s Setting up samba (2:4.20.2+dfsg-2ubuntu2) ... 198s Created symlink '/etc/systemd/system/smb.service' → '/usr/lib/systemd/system/smbd.service'. 198s Created symlink '/etc/systemd/system/multi-user.target.wants/smbd.service' → '/usr/lib/systemd/system/smbd.service'. 199s Created symlink '/etc/systemd/system/nmb.service' → '/usr/lib/systemd/system/nmbd.service'. 199s Created symlink '/etc/systemd/system/multi-user.target.wants/nmbd.service' → '/usr/lib/systemd/system/nmbd.service'. 199s Setting up autopkgtest-satdep (0) ... 199s Processing triggers for rsyslog (8.2312.0-3ubuntu9) ... 199s Processing triggers for ufw (0.36.2-6) ... 199s Processing triggers for man-db (2.12.1-2) ... 201s Processing triggers for libc-bin (2.39-0ubuntu9) ... 205s (Reading database ... 74608 files and directories currently installed.) 205s Removing autopkgtest-satdep (0) ... 205s autopkgtest [01:45:55]: test smb-backup: [----------------------- 206s Populating share path 206s Adding samba share 206s Adding [public] share 206s Configuring backuppc 206s Performing a full backup 206s Backup type: type = full, needs_full = 1, needs_incr = 1, lastFullTime = 0, opts{f} = 1, opts{i} = , opts{F} = 206s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 206s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 206s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.016 206s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.0.z created 2024-07-23 01:45:56 206s Backup prep: type = full, case = 1, inPlace = 1, doDuplicate = 0, newBkupNum = 0, newBkupIdx = 0, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = ) 206s __bpc_progress_state__ backup share "public" 206s Running: /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -Tc - 206s full backup started for share public 206s started full dump, share=public 206s Xfer PIDs are now 4901,4900 206s xferPids 4901,4900 206s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -Tc - 206s tarmode is now full, system, hidden, noreset, noverbose 206s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 1 206s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 206s __bpc_progress_fileCnt__ 0 206s new 644 0/0 480434 tmp.t0AdVe 206s new 644 0/0 480434 tmp.XghfwO 206s new 644 0/0 480434 tmp.1o1oPv 206s new 644 0/0 480434 tmp.4NnfV7 206s new 644 0/0 480434 tmp.pomf2c 206s new 644 0/0 480434 tmp.nTXqWA 207s new 644 0/0 480434 tmp.mLJYWr 207s new 644 0/0 480434 tmp.qJoORh 207s new 644 0/0 480434 tmp.lQNQfM 207s tar: dumped 10 files and 0 directories 207s Total bytes written: 4804340 (25.0 MiB/s) 207s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 207s new 644 0/0 480434 tmp.LHdikC 207s __bpc_progress_fileCnt__ 10 207s tarExtract: Done: 0 errors, 0 filesExist, 0 sizeExist, 0 sizeExistComp, 10 filesTotal, 4804340 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377785 sizeNewComp, 13 inodeLast 207s Xfer PIDs are now 207s xferPids 207s full backup 0 complete, 10 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 207s BackupExpire: cntFull = 1, cntIncr = 0, firstFull = 0, firstIncr = , oldestIncr = 0, oldestFull = 1.15740740740741e-05 207s __bpc_progress_state__ fsck 207s Running BackupPC_refCountUpdate -h localhost on localhost 207s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 207s Xfer PIDs are now 4907 207s xferPids 4907 207s BackupPC_refCountUpdate: doing fsck on localhost #0 (full) since $ConfRefCntFsck == 1 207s __bpc_progress_state__ refCnt #0 207s __bpc_progress_state__ cntUpdate #0 207s __bpc_progress_state__ rename #0 207s __bpc_progress_state__ sumUpdate 207s __bpc_progress_fileCnt__ 0/128 207s __bpc_progress_fileCnt__ 8/128 207s __bpc_progress_fileCnt__ 16/128 207s __bpc_progress_fileCnt__ 24/128 207s __bpc_progress_fileCnt__ 32/128 207s __bpc_progress_fileCnt__ 40/128 207s __bpc_progress_fileCnt__ 48/128 207s __bpc_progress_fileCnt__ 56/128 207s __bpc_progress_fileCnt__ 64/128 207s __bpc_progress_fileCnt__ 72/128 207s __bpc_progress_fileCnt__ 80/128 207s __bpc_progress_fileCnt__ 88/128 207s __bpc_progress_fileCnt__ 96/128 207s __bpc_progress_fileCnt__ 104/128 207s __bpc_progress_fileCnt__ 112/128 207s __bpc_progress_fileCnt__ 120/128 207s __bpc_progress_state__ rename total 207s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 207s Xfer PIDs are now 207s xferPids 207s Finished BackupPC_refCountUpdate (running time: 0 sec) 207s Xfer PIDs are now 207s xferPids 207s full backup complete 207s OK: Full backup succeeded 207s Changing share content and performing an incremental backup 207s Backup type: type = incr, needs_full = , needs_incr = , lastFullTime = 1721699156, opts{f} = , opts{i} = 1, opts{F} = 207s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 207s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 207s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.013 207s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.1.z created 2024-07-23 01:45:57 207s Backup prep: type = incr, case = 3, inPlace = 1, doDuplicate = 1, newBkupNum = 1, newBkupIdx = 1, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = ) 207s Executing /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 207s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 207s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDuplicate line 89. 207s (Did you mean "$Host\'s" instead?) 207s Xfer PIDs are now 4977 207s xferPids 4977 207s __bpc_progress_state__ copy #0 -> #1 207s Copying backup #0 to #1 207s __bpc_progress_fileCnt__ 3 dirs 207s Xfer PIDs are now 4977,4980 207s xferPids 4977,4980 207s __bpc_progress_state__ sumUpdate 207s __bpc_progress_fileCnt__ 0/128 207s __bpc_progress_fileCnt__ 8/128 207s __bpc_progress_fileCnt__ 16/128 207s __bpc_progress_fileCnt__ 24/128 207s __bpc_progress_fileCnt__ 32/128 207s __bpc_progress_fileCnt__ 40/128 207s __bpc_progress_fileCnt__ 48/128 207s __bpc_progress_fileCnt__ 56/128 207s __bpc_progress_fileCnt__ 64/128 207s __bpc_progress_fileCnt__ 72/128 207s __bpc_progress_fileCnt__ 80/128 207s __bpc_progress_fileCnt__ 88/128 207s __bpc_progress_fileCnt__ 96/128 207s __bpc_progress_fileCnt__ 104/128 207s __bpc_progress_fileCnt__ 112/128 207s __bpc_progress_fileCnt__ 120/128 207s __bpc_progress_state__ rename total 207s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 207s Xfer PIDs are now 4977 207s xferPids 4977 207s BackupPC_backupDuplicate: got 0 errors and 0 file open errors 207s Finished BackupPC_backupDuplicate (running time: 0 sec) 207s __bpc_progress_state__ backup share "public" 207s Running: /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 207s incr backup started back to 2024-07-23 00:45:56 (backup #0) for share public 207s started incr dump, share=public 207s Xfer PIDs are now 4984,4983 207s xferPids 4984,4983 207s 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 - 207s tar:1298 Getting files newer than Tue Jul 23 00:45:56 2024 207s tarmode is now full, system, hidden, noreset, noverbose 207s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 207s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 207s __bpc_progress_fileCnt__ 0 207s same 644 0/0 480434 tmp.t0AdVe 207s new 644 0/0 480434 tmp.QvTeLP 207s new 644 0/0 480434 tmp.2rptzE 207s new 644 0/0 480434 tmp.li91AH 207s same 644 0/0 480434 tmp.XghfwO 207s same 644 0/0 480434 tmp.1o1oPv 207s same 644 0/0 480434 tmp.4NnfV7 207s same 644 0/0 480434 tmp.pomf2c 207s new 644 0/0 480434 tmp.jD3XeI 207s same 644 0/0 480434 tmp.nTXqWA 207s same 644 0/0 480434 tmp.mLJYWr 207s new 644 0/0 480434 tmp.EXA5UF 207s new 644 0/0 480434 tmp.4EERwd 207s same 644 0/0 480434 tmp.qJoORh 207s new 644 0/0 480434 tmp.FbUerw 207s same 644 0/0 480434 tmp.lQNQfM 207s same 644 0/0 480434 tmp.LHdikC 207s new 644 0/0 480434 tmp.Mha044 207s new 644 0/0 480434 tmp.pgD755 207s tar: dumped 20 files and 0 directories 207s Total bytes written: 9608680 (38.3 MiB/s) 207s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 207s new 644 0/0 480434 tmp.j1Fz75 207s __bpc_progress_fileCnt__ 20 207s tarExtract: Done: 0 errors, 10 filesExist, 4804340 sizeExist, 1377785 sizeExistComp, 20 filesTotal, 9608680 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377790 sizeNewComp, 24 inodeLast 207s Xfer PIDs are now 207s xferPids 207s incr backup 1 complete, 20 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 207s BackupExpire: cntFull = 2, cntIncr = 0, firstFull = 0, firstIncr = , oldestIncr = 0, oldestFull = 1.15740740740741e-05 207s __bpc_progress_state__ fsck 207s Running BackupPC_refCountUpdate -h localhost on localhost 207s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 207s Xfer PIDs are now 4990 207s xferPids 4990 207s __bpc_progress_state__ cntUpdate #1 207s __bpc_progress_state__ rename #1 207s __bpc_progress_state__ sumUpdate 207s __bpc_progress_fileCnt__ 0/128 207s __bpc_progress_fileCnt__ 8/128 207s __bpc_progress_fileCnt__ 16/128 207s __bpc_progress_fileCnt__ 24/128 207s __bpc_progress_fileCnt__ 32/128 207s __bpc_progress_fileCnt__ 40/128 207s __bpc_progress_fileCnt__ 48/128 207s __bpc_progress_fileCnt__ 56/128 207s __bpc_progress_fileCnt__ 64/128 207s __bpc_progress_fileCnt__ 72/128 207s __bpc_progress_fileCnt__ 80/128 207s __bpc_progress_fileCnt__ 88/128 207s __bpc_progress_fileCnt__ 96/128 207s __bpc_progress_fileCnt__ 104/128 207s __bpc_progress_fileCnt__ 112/128 207s __bpc_progress_fileCnt__ 120/128 207s __bpc_progress_state__ rename total 207s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 207s Xfer PIDs are now 207s xferPids 207s Finished BackupPC_refCountUpdate (running time: 0 sec) 207s Xfer PIDs are now 207s xferPids 207s incr backup complete 207s OK: Incremental backup succeeded 207s Done. 208s autopkgtest [01:45:58]: test smb-backup: -----------------------] 209s smb-backup PASS 209s autopkgtest [01:45:59]: test smb-backup: - - - - - - - - - - results - - - - - - - - - - 209s autopkgtest [01:45:59]: test authenticated-smb-backup: preparing testbed 212s Reading package lists... 213s Building dependency tree... 213s Reading state information... 213s Starting pkgProblemResolver with broken count: 0 213s Starting 2 pkgProblemResolver with broken count: 0 213s Done 213s The following NEW packages will be installed: 213s autopkgtest-satdep 213s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 213s Need to get 0 B/724 B of archives. 213s After this operation, 0 B of additional disk space will be used. 213s Get:1 /tmp/autopkgtest.E6gt7e/2-autopkgtest-satdep.deb autopkgtest-satdep ppc64el 0 [724 B] 213s Selecting previously unselected package autopkgtest-satdep. 213s (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 ... 74609 files and directories currently installed.) 213s Preparing to unpack .../2-autopkgtest-satdep.deb ... 213s Unpacking autopkgtest-satdep (0) ... 213s Setting up autopkgtest-satdep (0) ... 215s (Reading database ... 74608 files and directories currently installed.) 215s Removing autopkgtest-satdep (0) ... 217s autopkgtest [01:46:07]: test authenticated-smb-backup: [----------------------- 217s Populating share path 217s Adding samba share 217s Adding [private] share 217s Creating user 217s Creating a local and samba user called smbtest5242 217s Setting samba password for the smbtest5242 user 217s Added user smbtest5242. 217s Configuring backuppc 217s Performing a full backup 217s Backup type: type = full, needs_full = , needs_incr = , lastFullTime = 1721699156, opts{f} = 1, opts{i} = , opts{F} = 217s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 217s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 217s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.026 217s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.2.z created 2024-07-23 01:46:07 217s Backup prep: type = full, case = 4, inPlace = 0, doDuplicate = 0, newBkupNum = 2, newBkupIdx = 2, lastBkupNum = 1, lastBkupIdx = 1 (FillCycle = 0, noFillCnt = 0) 217s __bpc_progress_state__ backup share "private" 217s Running: /usr/bin/smbclient \\\\localhost\\private -U smbtest5242 -E -d 1 -c tarmode\ full -mSMB3 -Tc - 217s full backup started for share private 217s started full dump, share=private 217s Xfer PIDs are now 5336,5335 217s xferPids 5336,5335 217s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\private -U smbtest5242 -E -d 1 -c tarmode\ full -mSMB3 -Tc - 217s tarmode is now full, system, hidden, noreset, noverbose 217s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 1 217s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 217s __bpc_progress_fileCnt__ 0 217s new 644 0/0 480434 tmp.jhtAx5 217s new 644 0/0 480434 tmp.m9OeTT 217s new 644 0/0 480434 tmp.tJNCHr 217s new 644 0/0 480434 tmp.KttTIL 218s new 644 0/0 480434 tmp.O3xCHn 218s new 644 0/0 480434 tmp.yYkZnw 218s new 644 0/0 480434 tmp.0qrLep 218s new 644 0/0 480434 tmp.pCbKKF 218s new 644 0/0 480434 tmp.dW0NnV 218s tar: dumped 10 files and 0 directories 218s Total bytes written: 4804340 (23.6 MiB/s) 218s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 218s new 644 0/0 480434 tmp.A9BR9t 218s __bpc_progress_fileCnt__ 10 218s tarExtract: Done: 0 errors, 0 filesExist, 0 sizeExist, 0 sizeExistComp, 10 filesTotal, 4804340 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377836 sizeNewComp, 36 inodeLast 218s Xfer PIDs are now 218s xferPids 218s OrphanShareNameClean: removing orphan share public from /var/lib/backuppc/pc/localhost/2 218s __bpc_progress_state__ delete share #2/public 218s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDelete -h localhost -n 2 -l -m -s public / 218s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDelete line 102. 218s (Did you mean "$Host\'s" instead?) 218s Xfer PIDs are now 5342 218s xferPids 5342 218s BackupPC_backupDelete: removing #2/public/ 218s __bpc_progress_state__ merge #2/public/ -> #1/public/ 218s BackupPC_backupDelete: Merge into backup 1/public/ 218s mergeDir: attr write to /var/lib/backuppc/pc/localhost/1/fpublic//attrib failed (digest was ) 218s bpc_attrib_dirWrite: can't open/create raw /var/lib/backuppc/pc/localhost/1/fpublic for writing 218s Xfer PIDs are now 5342,5345 218s xferPids 5342,5345 218s __bpc_progress_state__ refCnt #1 218s __bpc_progress_state__ cntUpdate #1 218s __bpc_progress_state__ rename #1 218s __bpc_progress_state__ refCnt #2 218s BackupPC_refCountUpdate: localhost #2 inodeLast set to 37 (was 24) 218s __bpc_progress_state__ cntUpdate #2 218s __bpc_progress_state__ rename #2 218s __bpc_progress_state__ sumUpdate 218s __bpc_progress_fileCnt__ 0/128 218s __bpc_progress_fileCnt__ 8/128 218s __bpc_progress_fileCnt__ 16/128 218s __bpc_progress_fileCnt__ 24/128 218s __bpc_progress_fileCnt__ 32/128 218s __bpc_progress_fileCnt__ 40/128 218s __bpc_progress_fileCnt__ 48/128 218s __bpc_progress_fileCnt__ 56/128 218s __bpc_progress_fileCnt__ 64/128 218s __bpc_progress_fileCnt__ 72/128 218s __bpc_progress_fileCnt__ 80/128 218s __bpc_progress_fileCnt__ 88/128 218s __bpc_progress_fileCnt__ 96/128 218s __bpc_progress_fileCnt__ 104/128 218s __bpc_progress_fileCnt__ 112/128 218s __bpc_progress_fileCnt__ 120/128 218s __bpc_progress_state__ rename total 218s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 218s Xfer PIDs are now 5342 218s xferPids 5342 218s Xfer PIDs are now 218s xferPids 218s Finished BackupPC_backupDelete, status = 0 (running time: 0 sec) 218s Xfer PIDs are now 218s xferPids 218s full backup 2 complete, 10 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 218s BackupExpire: cntFull = 2, cntIncr = 1, firstFull = 0, firstIncr = 1, oldestIncr = 0.000127314814814815, oldestFull = 0.000138888888888889 218s __bpc_progress_state__ fsck 218s Running BackupPC_refCountUpdate -h localhost on localhost 218s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 218s Xfer PIDs are now 5348 218s xferPids 5348 218s BackupPC_refCountUpdate: doing fsck on localhost #2 (full) since $ConfRefCntFsck == 1 218s __bpc_progress_state__ refCnt #2 218s __bpc_progress_state__ cntUpdate #2 218s __bpc_progress_state__ rename #2 218s __bpc_progress_state__ sumUpdate 218s __bpc_progress_fileCnt__ 0/128 218s __bpc_progress_fileCnt__ 8/128 218s __bpc_progress_fileCnt__ 16/128 218s __bpc_progress_fileCnt__ 24/128 218s __bpc_progress_fileCnt__ 32/128 218s __bpc_progress_fileCnt__ 40/128 218s __bpc_progress_fileCnt__ 48/128 218s __bpc_progress_fileCnt__ 56/128 218s __bpc_progress_fileCnt__ 64/128 218s __bpc_progress_fileCnt__ 72/128 218s __bpc_progress_fileCnt__ 80/128 218s __bpc_progress_fileCnt__ 88/128 218s __bpc_progress_fileCnt__ 96/128 218s __bpc_progress_fileCnt__ 104/128 218s __bpc_progress_fileCnt__ 112/128 218s __bpc_progress_fileCnt__ 120/128 218s __bpc_progress_state__ rename total 218s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 218s Xfer PIDs are now 218s xferPids 218s Finished BackupPC_refCountUpdate (running time: 0 sec) 218s Xfer PIDs are now 218s xferPids 218s full backup complete 218s OK: Full backup succeeded 218s Changing share content and performing an incremental backup 218s Backup type: type = incr, needs_full = , needs_incr = , lastFullTime = 1721699167, opts{f} = , opts{i} = 1, opts{F} = 218s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 218s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 218s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.010 218s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.3.z created 2024-07-23 01:46:08 218s Backup prep: type = incr, case = 3, inPlace = 1, doDuplicate = 1, newBkupNum = 3, newBkupIdx = 3, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = 1) 218s Executing /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 218s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 218s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDuplicate line 89. 218s (Did you mean "$Host\'s" instead?) 218s Xfer PIDs are now 5418 218s xferPids 5418 218s __bpc_progress_state__ copy #2 -> #3 218s Copying backup #2 to #3 218s __bpc_progress_fileCnt__ 3 dirs 218s Xfer PIDs are now 5421,5418 218s xferPids 5421,5418 218s __bpc_progress_state__ sumUpdate 218s __bpc_progress_fileCnt__ 0/128 218s __bpc_progress_fileCnt__ 8/128 218s __bpc_progress_fileCnt__ 16/128 218s __bpc_progress_fileCnt__ 24/128 218s __bpc_progress_fileCnt__ 32/128 218s __bpc_progress_fileCnt__ 40/128 218s __bpc_progress_fileCnt__ 48/128 218s __bpc_progress_fileCnt__ 56/128 218s __bpc_progress_fileCnt__ 64/128 218s __bpc_progress_fileCnt__ 72/128 218s __bpc_progress_fileCnt__ 80/128 218s __bpc_progress_fileCnt__ 88/128 218s __bpc_progress_fileCnt__ 96/128 218s __bpc_progress_fileCnt__ 104/128 218s __bpc_progress_fileCnt__ 112/128 218s __bpc_progress_fileCnt__ 120/128 218s __bpc_progress_state__ rename total 218s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 218s Xfer PIDs are now 5418 218s xferPids 5418 218s BackupPC_backupDuplicate: got 0 errors and 0 file open errors 218s Finished BackupPC_backupDuplicate (running time: 0 sec) 218s __bpc_progress_state__ backup share "private" 218s Running: /usr/bin/smbclient \\\\localhost\\private -U smbtest5242 -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 218s incr backup started back to 2024-07-23 00:46:07 (backup #2) for share private 218s started incr dump, share=private 218s Xfer PIDs are now 5425,5424 218s xferPids 5425,5424 218s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\private -U smbtest5242 -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 218s tar:1298 Getting files newer than Tue Jul 23 00:46:07 2024 219s tarmode is now full, system, hidden, noreset, noverbose 219s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 219s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 219s __bpc_progress_fileCnt__ 0 219s new 644 0/0 480434 tmp.cfmT0t 219s new 644 0/0 480434 tmp.bDpDUc 219s same 644 0/0 480434 tmp.jhtAx5 219s same 644 0/0 480434 tmp.m9OeTT 219s same 644 0/0 480434 tmp.tJNCHr 219s same 644 0/0 480434 tmp.KttTIL 219s same 644 0/0 480434 tmp.O3xCHn 219s new 644 0/0 480434 tmp.ACSSzr 219s same 644 0/0 480434 tmp.yYkZnw 219s new 644 0/0 480434 tmp.T5JuJ7 219s same 644 0/0 480434 tmp.0qrLep 219s new 644 0/0 480434 tmp.RkBoFI 219s same 644 0/0 480434 tmp.pCbKKF 219s new 644 0/0 480434 tmp.BtmxfC 219s new 644 0/0 480434 tmp.rueQo3 219s same 644 0/0 480434 tmp.dW0NnV 219s new 644 0/0 480434 tmp.WIANiK 219s same 644 0/0 480434 tmp.A9BR9t 219s new 644 0/0 480434 tmp.P9j2If 219s tar: dumped 20 files and 0 directories 219s Total bytes written: 9608680 (43.6 MiB/s) 219s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 219s new 644 0/0 480434 tmp.1CPoX0 219s __bpc_progress_fileCnt__ 20 219s tarExtract: Done: 0 errors, 10 filesExist, 4804340 sizeExist, 1377836 sizeExistComp, 20 filesTotal, 9608680 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377821 sizeNewComp, 47 inodeLast 219s Xfer PIDs are now 219s xferPids 219s incr backup 3 complete, 20 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 219s BackupExpire: cntFull = 3, cntIncr = 1, firstFull = 0, firstIncr = 1, oldestIncr = 0.000138888888888889, oldestFull = 0.000150462962962963 219s __bpc_progress_state__ fsck 219s Running BackupPC_refCountUpdate -h localhost on localhost 219s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 219s Xfer PIDs are now 5431 219s xferPids 5431 219s __bpc_progress_state__ cntUpdate #3 219s __bpc_progress_state__ rename #3 219s __bpc_progress_state__ sumUpdate 219s __bpc_progress_fileCnt__ 0/128 219s __bpc_progress_fileCnt__ 8/128 219s __bpc_progress_fileCnt__ 16/128 219s __bpc_progress_fileCnt__ 24/128 219s __bpc_progress_fileCnt__ 32/128 219s __bpc_progress_fileCnt__ 40/128 219s __bpc_progress_fileCnt__ 48/128 219s __bpc_progress_fileCnt__ 56/128 219s __bpc_progress_fileCnt__ 64/128 219s __bpc_progress_fileCnt__ 72/128 219s __bpc_progress_fileCnt__ 80/128 219s __bpc_progress_fileCnt__ 88/128 219s __bpc_progress_fileCnt__ 96/128 219s __bpc_progress_fileCnt__ 104/128 219s __bpc_progress_fileCnt__ 112/128 219s __bpc_progress_fileCnt__ 120/128 219s __bpc_progress_state__ rename total 219s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 219s Xfer PIDs are now 219s xferPids 219s Finished BackupPC_refCountUpdate (running time: 0 sec) 219s Xfer PIDs are now 219s xferPids 219s incr backup complete 219s OK: Incremental backup succeeded 219s Done. 219s Deleted user smbtest5242. 219s userdel: smbtest5242 mail spool (/var/mail/smbtest5242) not found 219s autopkgtest [01:46:09]: test authenticated-smb-backup: -----------------------] 220s authenticated-smb-backup PASS 220s autopkgtest [01:46:10]: test authenticated-smb-backup: - - - - - - - - - - results - - - - - - - - - - 221s autopkgtest [01:46:11]: @@@@@@@@@@@@@@@@@@@@ summary 221s smb-backup PASS 221s authenticated-smb-backup PASS 240s nova [W] Using flock in prodstack6-ppc64el 240s Creating nova instance adt-oracular-ppc64el-backuppc-20240723-014228-juju-7f2275-prod-proposed-migration-environment-3-c796b722-0643-4855-98a4-089c34d0de50 from image adt/ubuntu-oracular-ppc64el-server-20240722.img (UUID b74e7691-503a-4447-b94b-2106a2e74b25)...