0s autopkgtest [20:44:18]: starting date and time: 2024-05-15 20:44:18+0000 0s autopkgtest [20:44:18]: git checkout: 699e7f9f ssh-setup/nova: explicitely set 'fqdn' in cloud-init 0s autopkgtest [20:44:18]: host juju-7f2275-prod-proposed-migration-environment-3; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.4jihbac2/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:sendmail --apt-upgrade backuppc --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=sendmail/8.18.1-3 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-3@bos02-ppc64el-23.secgroup --name adt-oracular-ppc64el-backuppc-20240515-204417-juju-7f2275-prod-proposed-migration-environment-3-45d9e364-ee9c-44cb-92d5-b7d3bc7080fc --image adt/ubuntu-oracular-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-3 --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,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/ 90s autopkgtest [20:45:48]: testbed dpkg architecture: ppc64el 90s autopkgtest [20:45:48]: testbed apt version: 2.7.14build2 90s autopkgtest [20:45:48]: @@@@@@@@@@@@@@@@@@@@ test bed setup 91s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [73.9 kB] 91s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [1964 B] 91s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [1842 kB] 91s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [9628 B] 91s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [137 kB] 91s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el Packages [209 kB] 91s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/universe ppc64el Packages [1266 kB] 92s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse ppc64el Packages [18.4 kB] 92s Fetched 3558 kB in 1s (2492 kB/s) 92s Reading package lists... 94s Reading package lists... 94s Building dependency tree... 94s Reading state information... 95s Calculating upgrade... 95s The following packages will be upgraded: 95s pastebinit 95s 1 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 95s Need to get 14.9 kB of archives. 95s After this operation, 8192 B of additional disk space will be used. 95s Get:1 http://ftpmaster.internal/ubuntu oracular/main ppc64el pastebinit all 1.7.0-1 [14.9 kB] 95s Fetched 14.9 kB in 0s (71.3 kB/s) 95s (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 ... 72144 files and directories currently installed.) 95s Preparing to unpack .../pastebinit_1.7.0-1_all.deb ... 95s Unpacking pastebinit (1.7.0-1) over (1.6.2-1) ... 95s Setting up pastebinit (1.7.0-1) ... 95s Processing triggers for man-db (2.12.0-4build2) ... 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. 97s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 97s Hit:2 http://ftpmaster.internal/ubuntu oracular InRelease 97s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease 97s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease 98s Reading package lists... 98s Reading package lists... 98s Building dependency tree... 98s Reading state information... 98s Calculating upgrade... 98s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 98s Reading package lists... 98s Building dependency tree... 98s Reading state information... 99s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 101s autopkgtest [20:45:59]: testbed running kernel: Linux 6.8.0-31-generic #31-Ubuntu SMP Sat Apr 20 00:05:55 UTC 2024 101s autopkgtest [20:45:59]: @@@@@@@@@@@@@@@@@@@@ apt-source backuppc 103s Get:1 http://ftpmaster.internal/ubuntu oracular/main backuppc 4.4.0-8build1 (dsc) [2289 B] 103s Get:2 http://ftpmaster.internal/ubuntu oracular/main backuppc 4.4.0-8build1 (tar) [657 kB] 103s Get:3 http://ftpmaster.internal/ubuntu oracular/main backuppc 4.4.0-8build1 (diff) [61.1 kB] 103s gpgv: Signature made Mon Apr 8 15:54:41 2024 UTC 103s gpgv: using RSA key 4FB588A84C2DDE79A74C77876FA458DD1DB03F71 103s gpgv: issuer "juliank@ubuntu.com" 103s gpgv: Can't check signature: No public key 103s dpkg-source: warning: cannot verify inline signature for ./backuppc_4.4.0-8build1.dsc: no acceptable signature found 104s autopkgtest [20:46:02]: testing package backuppc version 4.4.0-8build1 104s autopkgtest [20:46:02]: build not needed 105s autopkgtest [20:46:03]: test smb-backup: preparing testbed 106s Reading package lists... 106s Building dependency tree... 106s Reading state information... 106s Starting pkgProblemResolver with broken count: 0 106s Starting 2 pkgProblemResolver with broken count: 0 106s Done 106s The following additional packages will be installed: 106s apache2 apache2-bin apache2-data apache2-utils backuppc backuppc-rsync 106s libapr1t64 libaprutil1-dbd-sqlite3 libaprutil1-ldap libaprutil1t64 106s libarchive-zip-perl libavahi-client3 libavahi-common-data libavahi-common3 106s libbackuppc-xs-perl libcgi-pm-perl libcups2t64 libfile-listing-perl 106s libhtml-parser-perl libhtml-tagset-perl libhttp-date-perl libldb2 106s liblua5.4-0 libnsl2 libpython3.12t64 libsmbclient0 libtalloc2 libtdb1 106s libtevent0t64 libtime-parsedate-perl libtimedate-perl liburi-perl 106s libwbclient0 postfix python3-dnspython python3-ldb python3-markdown 106s python3-samba python3-talloc python3-tdb samba samba-common samba-common-bin 106s samba-libs smbclient ssl-cert tdb-tools 106s Suggested packages: 106s apache2-doc apache2-suexec-pristine | apache2-suexec-custom www-browser 106s certbot | acme-tiny | acmetool | dehydrated | lacme | lecm | lego 106s libscgi-perl par2 w3m | www-browser cups-common libdata-dump-perl 106s libbusiness-isbn-perl libregexp-ipv6-perl libwww-perl mail-reader 106s postfix-cdb postfix-doc postfix-ldap postfix-lmdb postfix-mta-sts-resolver 106s postfix-mysql postfix-pcre postfix-pgsql postfix-sqlite procmail sasl2-bin 106s | dovecot-common python3-trio python3-aioquic python3-h2 python3-httpx 106s python3-httpcore python-markdown-doc bind9 bind9utils ctdb ldb-tools ntp 106s | chrony winbind heimdal-clients cifs-utils 106s Recommended packages: 106s libio-dirent-perl rrdtool libcgi-fast-perl libhttp-message-perl python3-gpg 106s attr samba-dsdb-modules samba-vfs-modules samba-ad-provision 106s The following NEW packages will be installed: 106s apache2 apache2-bin apache2-data apache2-utils autopkgtest-satdep backuppc 106s backuppc-rsync libapr1t64 libaprutil1-dbd-sqlite3 libaprutil1-ldap 106s libaprutil1t64 libarchive-zip-perl libavahi-client3 libavahi-common-data 106s libavahi-common3 libbackuppc-xs-perl libcgi-pm-perl libcups2t64 106s libfile-listing-perl libhtml-parser-perl libhtml-tagset-perl 106s libhttp-date-perl libldb2 liblua5.4-0 libnsl2 libpython3.12t64 libsmbclient0 106s libtalloc2 libtdb1 libtevent0t64 libtime-parsedate-perl libtimedate-perl 106s liburi-perl libwbclient0 postfix python3-dnspython python3-ldb 106s python3-markdown python3-samba python3-talloc python3-tdb samba samba-common 106s samba-common-bin samba-libs smbclient ssl-cert tdb-tools 106s 0 upgraded, 48 newly installed, 0 to remove and 0 not upgraded. 106s Need to get 21.9 MB/21.9 MB of archives. 106s After this operation, 121 MB of additional disk space will be used. 106s Get:1 /tmp/autopkgtest.S9UxdP/1-autopkgtest-satdep.deb autopkgtest-satdep ppc64el 0 [728 B] 107s Get:2 http://ftpmaster.internal/ubuntu oracular/main ppc64el libapr1t64 ppc64el 1.7.2-3.1build2 [135 kB] 107s Get:3 http://ftpmaster.internal/ubuntu oracular/main ppc64el libaprutil1t64 ppc64el 1.6.3-1.1ubuntu7 [113 kB] 107s Get:4 http://ftpmaster.internal/ubuntu oracular/main ppc64el libaprutil1-dbd-sqlite3 ppc64el 1.6.3-1.1ubuntu7 [12.5 kB] 107s Get:5 http://ftpmaster.internal/ubuntu oracular/main ppc64el libaprutil1-ldap ppc64el 1.6.3-1.1ubuntu7 [9298 B] 107s Get:6 http://ftpmaster.internal/ubuntu oracular/main ppc64el liblua5.4-0 ppc64el 5.4.6-3build2 [216 kB] 107s Get:7 http://ftpmaster.internal/ubuntu oracular/main ppc64el apache2-bin ppc64el 2.4.58-1ubuntu8 [1563 kB] 107s Get:8 http://ftpmaster.internal/ubuntu oracular/main ppc64el apache2-data all 2.4.58-1ubuntu8 [163 kB] 107s Get:9 http://ftpmaster.internal/ubuntu oracular/main ppc64el apache2-utils ppc64el 2.4.58-1ubuntu8 [102 kB] 107s Get:10 http://ftpmaster.internal/ubuntu oracular/main ppc64el apache2 ppc64el 2.4.58-1ubuntu8 [90.2 kB] 107s Get:11 http://ftpmaster.internal/ubuntu oracular/main ppc64el backuppc-rsync ppc64el 3.1.3.0-3ubuntu1 [318 kB] 107s Get:12 http://ftpmaster.internal/ubuntu oracular/main ppc64el ssl-cert all 1.1.2ubuntu1 [17.8 kB] 107s Get:13 http://ftpmaster.internal/ubuntu oracular/main ppc64el libnsl2 ppc64el 1.3.0-3build3 [48.9 kB] 107s Get:14 http://ftpmaster.internal/ubuntu oracular/main ppc64el postfix ppc64el 3.8.6-1build2 [1366 kB] 108s Get:15 http://ftpmaster.internal/ubuntu oracular/main ppc64el libarchive-zip-perl all 1.68-1 [90.2 kB] 108s Get:16 http://ftpmaster.internal/ubuntu oracular/main ppc64el libbackuppc-xs-perl ppc64el 0.62-2build5 [74.9 kB] 108s Get:17 http://ftpmaster.internal/ubuntu oracular/main ppc64el libhtml-tagset-perl all 3.24-1 [14.1 kB] 108s Get:18 http://ftpmaster.internal/ubuntu oracular/main ppc64el liburi-perl all 5.27-1 [88.0 kB] 108s Get:19 http://ftpmaster.internal/ubuntu oracular/main ppc64el libhtml-parser-perl ppc64el 3.81-1build3 [91.6 kB] 108s Get:20 http://ftpmaster.internal/ubuntu oracular/main ppc64el libcgi-pm-perl all 4.63-1 [185 kB] 108s Get:21 http://ftpmaster.internal/ubuntu oracular/main ppc64el libtimedate-perl all 2.3300-2 [34.0 kB] 108s Get:22 http://ftpmaster.internal/ubuntu oracular/main ppc64el libhttp-date-perl all 6.06-1 [10.2 kB] 108s Get:23 http://ftpmaster.internal/ubuntu oracular/main ppc64el libfile-listing-perl all 6.16-1 [11.3 kB] 108s Get:24 http://ftpmaster.internal/ubuntu oracular/main ppc64el libtime-parsedate-perl all 2015.103-4 [28.6 kB] 108s Get:25 http://ftpmaster.internal/ubuntu oracular/main ppc64el backuppc ppc64el 4.4.0-8build1 [541 kB] 108s Get:26 http://ftpmaster.internal/ubuntu oracular/main ppc64el python3-dnspython all 2.6.1-1ubuntu1 [163 kB] 108s Get:27 http://ftpmaster.internal/ubuntu oracular/main ppc64el libtalloc2 ppc64el 2.4.2-1build2 [36.7 kB] 108s Get:28 http://ftpmaster.internal/ubuntu oracular/main ppc64el libtdb1 ppc64el 1.4.10-1build1 [62.8 kB] 108s Get:29 http://ftpmaster.internal/ubuntu oracular/main ppc64el libtevent0t64 ppc64el 0.16.1-2build1 [51.2 kB] 108s Get:30 http://ftpmaster.internal/ubuntu oracular/main ppc64el libldb2 ppc64el 2:2.8.0+samba4.19.5+dfsg-4ubuntu9 [220 kB] 108s Get:31 http://ftpmaster.internal/ubuntu oracular/main ppc64el libpython3.12t64 ppc64el 3.12.3-1 [2553 kB] 108s Get:32 http://ftpmaster.internal/ubuntu oracular/main ppc64el python3-ldb ppc64el 2:2.8.0+samba4.19.5+dfsg-4ubuntu9 [48.0 kB] 108s Get:33 http://ftpmaster.internal/ubuntu oracular/main ppc64el python3-tdb ppc64el 1.4.10-1build1 [15.8 kB] 108s Get:34 http://ftpmaster.internal/ubuntu oracular/main ppc64el python3-markdown all 3.5.2-1 [72.0 kB] 108s Get:35 http://ftpmaster.internal/ubuntu oracular/main ppc64el libavahi-common-data ppc64el 0.8-13ubuntu6 [29.7 kB] 108s Get:36 http://ftpmaster.internal/ubuntu oracular/main ppc64el libavahi-common3 ppc64el 0.8-13ubuntu6 [26.3 kB] 108s Get:37 http://ftpmaster.internal/ubuntu oracular/main ppc64el libavahi-client3 ppc64el 0.8-13ubuntu6 [30.8 kB] 108s Get:38 http://ftpmaster.internal/ubuntu oracular/main ppc64el libwbclient0 ppc64el 2:4.19.5+dfsg-4ubuntu9 [77.3 kB] 108s Get:39 http://ftpmaster.internal/ubuntu oracular/main ppc64el samba-libs ppc64el 2:4.19.5+dfsg-4ubuntu9 [6674 kB] 109s Get:40 http://ftpmaster.internal/ubuntu oracular/main ppc64el python3-talloc ppc64el 2.4.2-1build2 [13.4 kB] 109s Get:41 http://ftpmaster.internal/ubuntu oracular/main ppc64el python3-samba ppc64el 2:4.19.5+dfsg-4ubuntu9 [2930 kB] 109s Get:42 http://ftpmaster.internal/ubuntu oracular/main ppc64el samba-common all 2:4.19.5+dfsg-4ubuntu9 [64.1 kB] 109s Get:43 http://ftpmaster.internal/ubuntu oracular/main ppc64el libcups2t64 ppc64el 2.4.7-1.2ubuntu7 [347 kB] 109s Get:44 http://ftpmaster.internal/ubuntu oracular/main ppc64el samba-common-bin ppc64el 2:4.19.5+dfsg-4ubuntu9 [1417 kB] 109s Get:45 http://ftpmaster.internal/ubuntu oracular/main ppc64el tdb-tools ppc64el 1.4.10-1build1 [27.2 kB] 109s Get:46 http://ftpmaster.internal/ubuntu oracular/main ppc64el samba ppc64el 2:4.19.5+dfsg-4ubuntu9 [1113 kB] 109s Get:47 http://ftpmaster.internal/ubuntu oracular/main ppc64el libsmbclient0 ppc64el 2:4.19.5+dfsg-4ubuntu9 [70.3 kB] 109s Get:48 http://ftpmaster.internal/ubuntu oracular/main ppc64el smbclient ppc64el 2:4.19.5+dfsg-4ubuntu9 [526 kB] 110s Preconfiguring packages ... 110s Fetched 21.9 MB in 3s (7767 kB/s) 110s Selecting previously unselected package libapr1t64:ppc64el. 110s (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 ... 72146 files and directories currently installed.) 110s Preparing to unpack .../00-libapr1t64_1.7.2-3.1build2_ppc64el.deb ... 110s Unpacking libapr1t64:ppc64el (1.7.2-3.1build2) ... 110s Selecting previously unselected package libaprutil1t64:ppc64el. 110s Preparing to unpack .../01-libaprutil1t64_1.6.3-1.1ubuntu7_ppc64el.deb ... 110s Unpacking libaprutil1t64:ppc64el (1.6.3-1.1ubuntu7) ... 110s Selecting previously unselected package libaprutil1-dbd-sqlite3:ppc64el. 110s Preparing to unpack .../02-libaprutil1-dbd-sqlite3_1.6.3-1.1ubuntu7_ppc64el.deb ... 110s Unpacking libaprutil1-dbd-sqlite3:ppc64el (1.6.3-1.1ubuntu7) ... 110s Selecting previously unselected package libaprutil1-ldap:ppc64el. 110s Preparing to unpack .../03-libaprutil1-ldap_1.6.3-1.1ubuntu7_ppc64el.deb ... 110s Unpacking libaprutil1-ldap:ppc64el (1.6.3-1.1ubuntu7) ... 110s Selecting previously unselected package liblua5.4-0:ppc64el. 110s Preparing to unpack .../04-liblua5.4-0_5.4.6-3build2_ppc64el.deb ... 110s Unpacking liblua5.4-0:ppc64el (5.4.6-3build2) ... 110s Selecting previously unselected package apache2-bin. 110s Preparing to unpack .../05-apache2-bin_2.4.58-1ubuntu8_ppc64el.deb ... 110s Unpacking apache2-bin (2.4.58-1ubuntu8) ... 110s Selecting previously unselected package apache2-data. 110s Preparing to unpack .../06-apache2-data_2.4.58-1ubuntu8_all.deb ... 110s Unpacking apache2-data (2.4.58-1ubuntu8) ... 110s Selecting previously unselected package apache2-utils. 110s Preparing to unpack .../07-apache2-utils_2.4.58-1ubuntu8_ppc64el.deb ... 110s Unpacking apache2-utils (2.4.58-1ubuntu8) ... 110s Selecting previously unselected package apache2. 110s Preparing to unpack .../08-apache2_2.4.58-1ubuntu8_ppc64el.deb ... 110s Unpacking apache2 (2.4.58-1ubuntu8) ... 110s Selecting previously unselected package backuppc-rsync. 110s Preparing to unpack .../09-backuppc-rsync_3.1.3.0-3ubuntu1_ppc64el.deb ... 110s Unpacking backuppc-rsync (3.1.3.0-3ubuntu1) ... 110s Selecting previously unselected package ssl-cert. 110s Preparing to unpack .../10-ssl-cert_1.1.2ubuntu1_all.deb ... 110s Unpacking ssl-cert (1.1.2ubuntu1) ... 110s Selecting previously unselected package libnsl2:ppc64el. 110s Preparing to unpack .../11-libnsl2_1.3.0-3build3_ppc64el.deb ... 110s Unpacking libnsl2:ppc64el (1.3.0-3build3) ... 110s Selecting previously unselected package postfix. 110s Preparing to unpack .../12-postfix_3.8.6-1build2_ppc64el.deb ... 110s Unpacking postfix (3.8.6-1build2) ... 110s Selecting previously unselected package libarchive-zip-perl. 110s Preparing to unpack .../13-libarchive-zip-perl_1.68-1_all.deb ... 110s Unpacking libarchive-zip-perl (1.68-1) ... 110s Selecting previously unselected package libbackuppc-xs-perl:ppc64el. 110s Preparing to unpack .../14-libbackuppc-xs-perl_0.62-2build5_ppc64el.deb ... 110s Unpacking libbackuppc-xs-perl:ppc64el (0.62-2build5) ... 110s Selecting previously unselected package libhtml-tagset-perl. 110s Preparing to unpack .../15-libhtml-tagset-perl_3.24-1_all.deb ... 110s Unpacking libhtml-tagset-perl (3.24-1) ... 110s Selecting previously unselected package liburi-perl. 110s Preparing to unpack .../16-liburi-perl_5.27-1_all.deb ... 110s Unpacking liburi-perl (5.27-1) ... 110s Selecting previously unselected package libhtml-parser-perl:ppc64el. 110s Preparing to unpack .../17-libhtml-parser-perl_3.81-1build3_ppc64el.deb ... 110s Unpacking libhtml-parser-perl:ppc64el (3.81-1build3) ... 110s Selecting previously unselected package libcgi-pm-perl. 110s Preparing to unpack .../18-libcgi-pm-perl_4.63-1_all.deb ... 110s Unpacking libcgi-pm-perl (4.63-1) ... 110s Selecting previously unselected package libtimedate-perl. 110s Preparing to unpack .../19-libtimedate-perl_2.3300-2_all.deb ... 110s Unpacking libtimedate-perl (2.3300-2) ... 110s Selecting previously unselected package libhttp-date-perl. 110s Preparing to unpack .../20-libhttp-date-perl_6.06-1_all.deb ... 110s Unpacking libhttp-date-perl (6.06-1) ... 111s Selecting previously unselected package libfile-listing-perl. 111s Preparing to unpack .../21-libfile-listing-perl_6.16-1_all.deb ... 111s Unpacking libfile-listing-perl (6.16-1) ... 111s Selecting previously unselected package libtime-parsedate-perl. 111s Preparing to unpack .../22-libtime-parsedate-perl_2015.103-4_all.deb ... 111s Unpacking libtime-parsedate-perl (2015.103-4) ... 111s Selecting previously unselected package backuppc. 111s Preparing to unpack .../23-backuppc_4.4.0-8build1_ppc64el.deb ... 111s Unpacking backuppc (4.4.0-8build1) ... 111s Selecting previously unselected package python3-dnspython. 111s Preparing to unpack .../24-python3-dnspython_2.6.1-1ubuntu1_all.deb ... 111s Unpacking python3-dnspython (2.6.1-1ubuntu1) ... 111s Selecting previously unselected package libtalloc2:ppc64el. 111s Preparing to unpack .../25-libtalloc2_2.4.2-1build2_ppc64el.deb ... 111s Unpacking libtalloc2:ppc64el (2.4.2-1build2) ... 111s Selecting previously unselected package libtdb1:ppc64el. 111s Preparing to unpack .../26-libtdb1_1.4.10-1build1_ppc64el.deb ... 111s Unpacking libtdb1:ppc64el (1.4.10-1build1) ... 111s Selecting previously unselected package libtevent0t64:ppc64el. 111s Preparing to unpack .../27-libtevent0t64_0.16.1-2build1_ppc64el.deb ... 111s Unpacking libtevent0t64:ppc64el (0.16.1-2build1) ... 111s Selecting previously unselected package libldb2:ppc64el. 111s Preparing to unpack .../28-libldb2_2%3a2.8.0+samba4.19.5+dfsg-4ubuntu9_ppc64el.deb ... 111s Unpacking libldb2:ppc64el (2:2.8.0+samba4.19.5+dfsg-4ubuntu9) ... 111s Selecting previously unselected package libpython3.12t64:ppc64el. 111s Preparing to unpack .../29-libpython3.12t64_3.12.3-1_ppc64el.deb ... 111s Unpacking libpython3.12t64:ppc64el (3.12.3-1) ... 111s Selecting previously unselected package python3-ldb. 111s Preparing to unpack .../30-python3-ldb_2%3a2.8.0+samba4.19.5+dfsg-4ubuntu9_ppc64el.deb ... 111s Unpacking python3-ldb (2:2.8.0+samba4.19.5+dfsg-4ubuntu9) ... 111s Selecting previously unselected package python3-tdb. 111s Preparing to unpack .../31-python3-tdb_1.4.10-1build1_ppc64el.deb ... 111s Unpacking python3-tdb (1.4.10-1build1) ... 111s Selecting previously unselected package python3-markdown. 111s Preparing to unpack .../32-python3-markdown_3.5.2-1_all.deb ... 111s Unpacking python3-markdown (3.5.2-1) ... 111s Selecting previously unselected package libavahi-common-data:ppc64el. 111s Preparing to unpack .../33-libavahi-common-data_0.8-13ubuntu6_ppc64el.deb ... 111s Unpacking libavahi-common-data:ppc64el (0.8-13ubuntu6) ... 111s Selecting previously unselected package libavahi-common3:ppc64el. 111s Preparing to unpack .../34-libavahi-common3_0.8-13ubuntu6_ppc64el.deb ... 111s Unpacking libavahi-common3:ppc64el (0.8-13ubuntu6) ... 111s Selecting previously unselected package libavahi-client3:ppc64el. 111s Preparing to unpack .../35-libavahi-client3_0.8-13ubuntu6_ppc64el.deb ... 111s Unpacking libavahi-client3:ppc64el (0.8-13ubuntu6) ... 111s Selecting previously unselected package libwbclient0:ppc64el. 111s Preparing to unpack .../36-libwbclient0_2%3a4.19.5+dfsg-4ubuntu9_ppc64el.deb ... 111s Unpacking libwbclient0:ppc64el (2:4.19.5+dfsg-4ubuntu9) ... 111s Selecting previously unselected package samba-libs:ppc64el. 111s Preparing to unpack .../37-samba-libs_2%3a4.19.5+dfsg-4ubuntu9_ppc64el.deb ... 111s Unpacking samba-libs:ppc64el (2:4.19.5+dfsg-4ubuntu9) ... 111s Selecting previously unselected package python3-talloc:ppc64el. 111s Preparing to unpack .../38-python3-talloc_2.4.2-1build2_ppc64el.deb ... 111s Unpacking python3-talloc:ppc64el (2.4.2-1build2) ... 111s Selecting previously unselected package python3-samba. 111s Preparing to unpack .../39-python3-samba_2%3a4.19.5+dfsg-4ubuntu9_ppc64el.deb ... 111s Unpacking python3-samba (2:4.19.5+dfsg-4ubuntu9) ... 111s Selecting previously unselected package samba-common. 111s Preparing to unpack .../40-samba-common_2%3a4.19.5+dfsg-4ubuntu9_all.deb ... 111s Unpacking samba-common (2:4.19.5+dfsg-4ubuntu9) ... 111s Selecting previously unselected package libcups2t64:ppc64el. 111s Preparing to unpack .../41-libcups2t64_2.4.7-1.2ubuntu7_ppc64el.deb ... 111s Unpacking libcups2t64:ppc64el (2.4.7-1.2ubuntu7) ... 111s Selecting previously unselected package samba-common-bin. 111s Preparing to unpack .../42-samba-common-bin_2%3a4.19.5+dfsg-4ubuntu9_ppc64el.deb ... 111s Unpacking samba-common-bin (2:4.19.5+dfsg-4ubuntu9) ... 111s Selecting previously unselected package tdb-tools. 111s Preparing to unpack .../43-tdb-tools_1.4.10-1build1_ppc64el.deb ... 111s Unpacking tdb-tools (1.4.10-1build1) ... 111s Selecting previously unselected package samba. 111s Preparing to unpack .../44-samba_2%3a4.19.5+dfsg-4ubuntu9_ppc64el.deb ... 111s Unpacking samba (2:4.19.5+dfsg-4ubuntu9) ... 112s Selecting previously unselected package libsmbclient0:ppc64el. 112s Preparing to unpack .../45-libsmbclient0_2%3a4.19.5+dfsg-4ubuntu9_ppc64el.deb ... 112s Unpacking libsmbclient0:ppc64el (2:4.19.5+dfsg-4ubuntu9) ... 112s Selecting previously unselected package smbclient. 112s Preparing to unpack .../46-smbclient_2%3a4.19.5+dfsg-4ubuntu9_ppc64el.deb ... 112s Unpacking smbclient (2:4.19.5+dfsg-4ubuntu9) ... 112s Selecting previously unselected package autopkgtest-satdep. 112s Preparing to unpack .../47-1-autopkgtest-satdep.deb ... 112s Unpacking autopkgtest-satdep (0) ... 112s Setting up libarchive-zip-perl (1.68-1) ... 112s Setting up libtdb1:ppc64el (1.4.10-1build1) ... 112s Setting up libhtml-tagset-perl (3.24-1) ... 112s Setting up samba-common (2:4.19.5+dfsg-4ubuntu9) ... 112s 112s Creating config file /etc/samba/smb.conf with new version 112s Setting up libwbclient0:ppc64el (2:4.19.5+dfsg-4ubuntu9) ... 112s Setting up libtalloc2:ppc64el (2.4.2-1build2) ... 112s Setting up libpython3.12t64:ppc64el (3.12.3-1) ... 112s Setting up backuppc-rsync (3.1.3.0-3ubuntu1) ... 112s Setting up python3-tdb (1.4.10-1build1) ... 112s Setting up ssl-cert (1.1.2ubuntu1) ... 113s Created symlink /etc/systemd/system/multi-user.target.wants/ssl-cert.service → /usr/lib/systemd/system/ssl-cert.service. 114s Setting up libavahi-common-data:ppc64el (0.8-13ubuntu6) ... 114s Setting up tdb-tools (1.4.10-1build1) ... 114s update-alternatives: using /usr/bin/tdbbackup.tdbtools to provide /usr/bin/tdbbackup (tdbbackup) in auto mode 114s Setting up python3-markdown (3.5.2-1) ... 114s Setting up libtimedate-perl (2.3300-2) ... 114s Setting up libtime-parsedate-perl (2015.103-4) ... 114s Setting up python3-dnspython (2.6.1-1ubuntu1) ... 115s Setting up libapr1t64:ppc64el (1.7.2-3.1build2) ... 115s Setting up libnsl2:ppc64el (1.3.0-3build3) ... 115s Setting up liblua5.4-0:ppc64el (5.4.6-3build2) ... 115s Setting up apache2-data (2.4.58-1ubuntu8) ... 115s Setting up libbackuppc-xs-perl:ppc64el (0.62-2build5) ... 115s Setting up liburi-perl (5.27-1) ... 115s Setting up libtevent0t64:ppc64el (0.16.1-2build1) ... 115s Setting up libaprutil1t64:ppc64el (1.6.3-1.1ubuntu7) ... 115s Setting up libhttp-date-perl (6.06-1) ... 115s Setting up libfile-listing-perl (6.16-1) ... 115s Setting up python3-talloc:ppc64el (2.4.2-1build2) ... 115s Setting up libavahi-common3:ppc64el (0.8-13ubuntu6) ... 115s Setting up libaprutil1-ldap:ppc64el (1.6.3-1.1ubuntu7) ... 115s Setting up libaprutil1-dbd-sqlite3:ppc64el (1.6.3-1.1ubuntu7) ... 115s Setting up postfix (3.8.6-1build2) ... 115s info: Selecting GID from range 100 to 999 ... 115s info: Adding group `postfix' (GID 111) ... 115s info: Selecting UID from range 100 to 999 ... 115s 115s info: Adding system user `postfix' (UID 107) ... 115s info: Adding new user `postfix' (UID 107) with group `postfix' ... 115s info: Not creating home directory `/var/spool/postfix'. 115s Creating /etc/postfix/dynamicmaps.cf 115s info: Selecting GID from range 100 to 999 ... 115s info: Adding group `postdrop' (GID 112) ... 115s setting myhostname: autopkgtest.local 115s setting alias maps 115s setting alias database 115s changing /etc/mailname to autopkgtest.local 115s setting myorigin 115s setting destinations: $myhostname, autopkgtest.local, localhost.local, , localhost 115s setting relayhost: 115s setting mynetworks: 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128 115s setting mailbox_size_limit: 0 115s setting recipient_delimiter: + 117s setting inet_interfaces: all 119s setting inet_protocols: all 119s /etc/aliases does not exist, creating it. 119s WARNING: /etc/aliases exists, but does not have a root alias. 119s 119s Postfix (main.cf) is now set up with a default configuration. If you need to 119s make changes, edit /etc/postfix/main.cf (and others) as needed. To view 119s Postfix configuration values, see postconf(1). 119s 119s After modifying main.cf, be sure to run 'systemctl reload postfix'. 119s 121s Running newaliases 122s Created symlink /etc/systemd/system/multi-user.target.wants/postfix.service → /usr/lib/systemd/system/postfix.service. 123s Setting up libhtml-parser-perl:ppc64el (3.81-1build3) ... 123s Setting up libldb2:ppc64el (2:2.8.0+samba4.19.5+dfsg-4ubuntu9) ... 123s Setting up libavahi-client3:ppc64el (0.8-13ubuntu6) ... 123s Setting up apache2-utils (2.4.58-1ubuntu8) ... 123s Setting up libcgi-pm-perl (4.63-1) ... 123s Setting up samba-libs:ppc64el (2:4.19.5+dfsg-4ubuntu9) ... 123s Setting up apache2-bin (2.4.58-1ubuntu8) ... 123s Setting up python3-ldb (2:2.8.0+samba4.19.5+dfsg-4ubuntu9) ... 123s Setting up libsmbclient0:ppc64el (2:4.19.5+dfsg-4ubuntu9) ... 123s Setting up libcups2t64:ppc64el (2.4.7-1.2ubuntu7) ... 123s Setting up python3-samba (2:4.19.5+dfsg-4ubuntu9) ... 123s Setting up apache2 (2.4.58-1ubuntu8) ... 123s Enabling module mpm_event. 123s Enabling module authz_core. 123s Enabling module authz_host. 123s Enabling module authn_core. 123s Enabling module auth_basic. 124s Enabling module access_compat. 124s Enabling module authn_file. 124s Enabling module authz_user. 124s Enabling module alias. 124s Enabling module dir. 124s Enabling module autoindex. 124s Enabling module env. 124s Enabling module mime. 124s Enabling module negotiation. 124s Enabling module setenvif. 124s Enabling module filter. 124s Enabling module deflate. 124s Enabling module status. 124s Enabling module reqtimeout. 124s Enabling conf charset. 124s Enabling conf localized-error-pages. 124s Enabling conf other-vhosts-access-log. 124s Enabling conf security. 124s Enabling conf serve-cgi-bin. 124s Enabling site 000-default. 125s Created symlink /etc/systemd/system/multi-user.target.wants/apache2.service → /usr/lib/systemd/system/apache2.service. 125s Created symlink /etc/systemd/system/multi-user.target.wants/apache-htcacheclean.service → /usr/lib/systemd/system/apache-htcacheclean.service. 127s Setting up backuppc (4.4.0-8build1) ... 127s 127s apache2_invoke: Enable configuration backuppc.conf 127s warn: The home directory `/var/lib/backuppc' already exists. Not touching this directory. 127s warn: Warning: The home directory `/var/lib/backuppc' does not belong to the user you are currently creating. 127s Adding password for user backuppc 127s Considering dependency authn_core for auth_basic: 127s Module authn_core already enabled 127s Module auth_basic already enabled 127s Considering dependency authz_core for authz_groupfile: 127s Module authz_core already enabled 127s Enabling module authz_groupfile. 127s To activate the new configuration, you need to run: 127s systemctl restart apache2 127s Module authn_file already enabled 127s Considering dependency authz_core for authz_user: 127s Module authz_core already enabled 127s Module authz_user already enabled 127s Your MPM seems to be threaded. Selecting cgid instead of cgi. 127s Enabling module cgid. 127s To activate the new configuration, you need to run: 127s systemctl restart apache2 127s 127s Creating config file /etc/backuppc/config.pl with new version 128s Created symlink /etc/systemd/system/multi-user.target.wants/backuppc.service → /usr/lib/systemd/system/backuppc.service. 128s Setting up smbclient (2:4.19.5+dfsg-4ubuntu9) ... 128s Setting up samba-common-bin (2:4.19.5+dfsg-4ubuntu9) ... 128s Setting up samba (2:4.19.5+dfsg-4ubuntu9) ... 130s Created symlink /etc/systemd/system/smb.service → /usr/lib/systemd/system/smbd.service. 130s Created symlink /etc/systemd/system/multi-user.target.wants/smbd.service → /usr/lib/systemd/system/smbd.service. 130s Created symlink /etc/systemd/system/nmb.service → /usr/lib/systemd/system/nmbd.service. 130s Created symlink /etc/systemd/system/multi-user.target.wants/nmbd.service → /usr/lib/systemd/system/nmbd.service. 131s Created symlink /etc/systemd/system/samba.service → /usr/lib/systemd/system/samba-ad-dc.service. 131s Created symlink /etc/systemd/system/multi-user.target.wants/samba-ad-dc.service → /usr/lib/systemd/system/samba-ad-dc.service. 131s Setting up autopkgtest-satdep (0) ... 131s Processing triggers for rsyslog (8.2312.0-3ubuntu9) ... 131s Processing triggers for ufw (0.36.2-6) ... 132s Processing triggers for man-db (2.12.0-4build2) ... 133s Processing triggers for libc-bin (2.39-0ubuntu8) ... 135s (Reading database ... 74520 files and directories currently installed.) 135s Removing autopkgtest-satdep (0) ... 136s autopkgtest [20:46:34]: test smb-backup: [----------------------- 136s Populating share path 136s Adding samba share 136s Adding [public] share 136s Configuring backuppc 136s Performing a full backup 136s Backup type: type = full, needs_full = 1, needs_incr = 1, lastFullTime = 0, opts{f} = 1, opts{i} = , opts{F} = 136s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 136s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 136s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.011 136s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.0.z created 2024-05-15 20:46:34 136s Backup prep: type = full, case = 1, inPlace = 1, doDuplicate = 0, newBkupNum = 0, newBkupIdx = 0, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = ) 136s __bpc_progress_state__ backup share "public" 136s Running: /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -Tc - 136s full backup started for share public 136s started full dump, share=public 136s Xfer PIDs are now 4791,4790 136s xferPids 4791,4790 136s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -Tc - 137s tarmode is now full, system, hidden, noreset, noverbose 137s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 1 137s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 137s __bpc_progress_fileCnt__ 0 137s new 644 0/0 480434 tmp.lMrIQD 137s new 644 0/0 480434 tmp.neHcGE 137s new 644 0/0 480434 tmp.ROq4kd 137s new 644 0/0 480434 tmp.bfHFMo 137s new 644 0/0 480434 tmp.SEz5q0 137s new 644 0/0 480434 tmp.yg5urc 137s new 644 0/0 480434 tmp.qcnOSu 137s new 644 0/0 480434 tmp.QsaZLS 137s new 644 0/0 480434 tmp.IhFqa9 137s tar: dumped 10 files and 0 directories 137s Total bytes written: 4804340 (25.7 MiB/s) 137s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 137s new 644 0/0 480434 tmp.S4NREv 137s __bpc_progress_fileCnt__ 10 137s tarExtract: Done: 0 errors, 0 filesExist, 0 sizeExist, 0 sizeExistComp, 10 filesTotal, 4804340 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377791 sizeNewComp, 13 inodeLast 137s Xfer PIDs are now 137s xferPids 137s full backup 0 complete, 10 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 137s BackupExpire: cntFull = 1, cntIncr = 0, firstFull = 0, firstIncr = , oldestIncr = 0, oldestFull = 1.15740740740741e-05 137s __bpc_progress_state__ fsck 137s Running BackupPC_refCountUpdate -h localhost on localhost 137s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 137s Xfer PIDs are now 4797 137s xferPids 4797 137s BackupPC_refCountUpdate: doing fsck on localhost #0 (full) since $ConfRefCntFsck == 1 137s __bpc_progress_state__ refCnt #0 137s __bpc_progress_state__ cntUpdate #0 137s __bpc_progress_state__ rename #0 137s __bpc_progress_state__ sumUpdate 137s __bpc_progress_fileCnt__ 0/128 137s __bpc_progress_fileCnt__ 8/128 137s __bpc_progress_fileCnt__ 16/128 137s __bpc_progress_fileCnt__ 24/128 137s __bpc_progress_fileCnt__ 32/128 137s __bpc_progress_fileCnt__ 40/128 137s __bpc_progress_fileCnt__ 48/128 137s __bpc_progress_fileCnt__ 56/128 137s __bpc_progress_fileCnt__ 64/128 137s __bpc_progress_fileCnt__ 72/128 137s __bpc_progress_fileCnt__ 80/128 137s __bpc_progress_fileCnt__ 88/128 137s __bpc_progress_fileCnt__ 96/128 137s __bpc_progress_fileCnt__ 104/128 137s __bpc_progress_fileCnt__ 112/128 137s __bpc_progress_fileCnt__ 120/128 137s __bpc_progress_state__ rename total 137s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 137s Xfer PIDs are now 137s xferPids 137s Finished BackupPC_refCountUpdate (running time: 0 sec) 137s Xfer PIDs are now 137s xferPids 137s full backup complete 137s OK: Full backup succeeded 137s Changing share content and performing an incremental backup 137s Backup type: type = incr, needs_full = , needs_incr = , lastFullTime = 1715805994, opts{f} = , opts{i} = 1, opts{F} = 137s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 137s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 137s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.023 137s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.1.z created 2024-05-15 20:46:35 137s Backup prep: type = incr, case = 3, inPlace = 1, doDuplicate = 1, newBkupNum = 1, newBkupIdx = 1, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = ) 137s Executing /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 137s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 137s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDuplicate line 89. 137s (Did you mean "$Host\'s" instead?) 137s Xfer PIDs are now 4867 137s xferPids 4867 137s __bpc_progress_state__ copy #0 -> #1 137s Copying backup #0 to #1 137s __bpc_progress_fileCnt__ 3 dirs 137s Xfer PIDs are now 4870,4867 137s xferPids 4870,4867 137s __bpc_progress_state__ sumUpdate 137s __bpc_progress_fileCnt__ 0/128 137s __bpc_progress_fileCnt__ 8/128 137s __bpc_progress_fileCnt__ 16/128 137s __bpc_progress_fileCnt__ 24/128 137s __bpc_progress_fileCnt__ 32/128 137s __bpc_progress_fileCnt__ 40/128 137s __bpc_progress_fileCnt__ 48/128 137s __bpc_progress_fileCnt__ 56/128 137s __bpc_progress_fileCnt__ 64/128 137s __bpc_progress_fileCnt__ 72/128 137s __bpc_progress_fileCnt__ 80/128 137s __bpc_progress_fileCnt__ 88/128 137s __bpc_progress_fileCnt__ 96/128 137s __bpc_progress_fileCnt__ 104/128 137s __bpc_progress_fileCnt__ 112/128 137s __bpc_progress_fileCnt__ 120/128 137s __bpc_progress_state__ rename total 137s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 137s Xfer PIDs are now 4867 137s xferPids 4867 137s BackupPC_backupDuplicate: got 0 errors and 0 file open errors 137s Finished BackupPC_backupDuplicate (running time: 0 sec) 137s __bpc_progress_state__ backup share "public" 137s Running: /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 137s incr backup started back to 2024-05-15 19:46:34 (backup #0) for share public 137s started incr dump, share=public 137s Xfer PIDs are now 4874,4873 137s xferPids 4874,4873 137s 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 - 137s tar:1298 Getting files newer than Wed May 15 19:46:34 2024 137s 137s tarmode is now full, system, hidden, noreset, noverbose 137s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 137s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 137s __bpc_progress_fileCnt__ 0 137s new 644 0/0 480434 tmp.CGjFo5 137s new 644 0/0 480434 tmp.neCNe1 137s same 644 0/0 480434 tmp.lMrIQD 137s same 644 0/0 480434 tmp.neHcGE 137s new 644 0/0 480434 tmp.hYydBy 137s same 644 0/0 480434 tmp.ROq4kd 137s new 644 0/0 480434 tmp.S7yCPj 137s same 644 0/0 480434 tmp.bfHFMo 137s new 644 0/0 480434 tmp.SbPSWR 137s same 644 0/0 480434 tmp.SEz5q0 137s same 644 0/0 480434 tmp.yg5urc 137s new 644 0/0 480434 tmp.y43mV4 137s same 644 0/0 480434 tmp.qcnOSu 137s same 644 0/0 480434 tmp.QsaZLS 137s new 644 0/0 480434 tmp.xQ3zXe 137s new 644 0/0 480434 tmp.g9kqao 138s new 644 0/0 480434 tmp.aCvS4n 138s new 644 0/0 480434 tmp.AsC7Vy 138s same 644 0/0 480434 tmp.IhFqa9 138s tar: dumped 20 files and 0 directories 138s Total bytes written: 9608680 (38.4 MiB/s) 138s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 138s same 644 0/0 480434 tmp.S4NREv 138s __bpc_progress_fileCnt__ 20 138s tarExtract: Done: 0 errors, 10 filesExist, 4804340 sizeExist, 1377791 sizeExistComp, 20 filesTotal, 9608680 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377799 sizeNewComp, 24 inodeLast 138s Xfer PIDs are now 138s xferPids 138s incr backup 1 complete, 20 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 138s BackupExpire: cntFull = 2, cntIncr = 0, firstFull = 0, firstIncr = , oldestIncr = 0, oldestFull = 2.31481481481481e-05 138s __bpc_progress_state__ fsck 138s Running BackupPC_refCountUpdate -h localhost on localhost 138s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 138s Xfer PIDs are now 4880 138s xferPids 4880 138s __bpc_progress_state__ cntUpdate #1 138s __bpc_progress_state__ rename #1 138s __bpc_progress_state__ sumUpdate 138s __bpc_progress_fileCnt__ 0/128 138s __bpc_progress_fileCnt__ 8/128 138s __bpc_progress_fileCnt__ 16/128 138s __bpc_progress_fileCnt__ 24/128 138s __bpc_progress_fileCnt__ 32/128 138s __bpc_progress_fileCnt__ 40/128 138s __bpc_progress_fileCnt__ 48/128 138s __bpc_progress_fileCnt__ 56/128 138s __bpc_progress_fileCnt__ 64/128 138s __bpc_progress_fileCnt__ 72/128 138s __bpc_progress_fileCnt__ 80/128 138s __bpc_progress_fileCnt__ 88/128 138s __bpc_progress_fileCnt__ 96/128 138s __bpc_progress_fileCnt__ 104/128 138s __bpc_progress_fileCnt__ 112/128 138s __bpc_progress_fileCnt__ 120/128 138s __bpc_progress_state__ rename total 138s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 138s Xfer PIDs are now 138s xferPids 138s Finished BackupPC_refCountUpdate (running time: 0 sec) 138s Xfer PIDs are now 138s xferPids 138s incr backup complete 138s OK: Incremental backup succeeded 138s Done. 138s autopkgtest [20:46:36]: test smb-backup: -----------------------] 138s smb-backup PASS 138s autopkgtest [20:46:36]: test smb-backup: - - - - - - - - - - results - - - - - - - - - - 139s autopkgtest [20:46:37]: test authenticated-smb-backup: preparing testbed 140s Reading package lists... 140s Building dependency tree... 140s Reading state information... 140s Starting pkgProblemResolver with broken count: 0 140s Starting 2 pkgProblemResolver with broken count: 0 140s Done 141s The following NEW packages will be installed: 141s autopkgtest-satdep 141s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 141s Need to get 0 B/720 B of archives. 141s After this operation, 0 B of additional disk space will be used. 141s Get:1 /tmp/autopkgtest.S9UxdP/2-autopkgtest-satdep.deb autopkgtest-satdep ppc64el 0 [720 B] 141s Selecting previously unselected package autopkgtest-satdep. 141s (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 ... 74521 files and directories currently installed.) 141s Preparing to unpack .../2-autopkgtest-satdep.deb ... 141s Unpacking autopkgtest-satdep (0) ... 141s Setting up autopkgtest-satdep (0) ... 142s (Reading database ... 74520 files and directories currently installed.) 142s Removing autopkgtest-satdep (0) ... 143s autopkgtest [20:46:41]: test authenticated-smb-backup: [----------------------- 143s Populating share path 143s Adding samba share 143s Adding [private] share 143s Creating user 143s Creating a local and samba user called smbtest5131 143s Setting samba password for the smbtest5131 user 143s Added user smbtest5131. 143s Configuring backuppc 143s Performing a full backup 143s Backup type: type = full, needs_full = , needs_incr = , lastFullTime = 1715805994, opts{f} = 1, opts{i} = , opts{F} = 143s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 143s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 143s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.011 143s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.2.z created 2024-05-15 20:46:41 143s Backup prep: type = full, case = 4, inPlace = 0, doDuplicate = 0, newBkupNum = 2, newBkupIdx = 2, lastBkupNum = 1, lastBkupIdx = 1 (FillCycle = 0, noFillCnt = 0) 143s __bpc_progress_state__ backup share "private" 144s Running: /usr/bin/smbclient \\\\localhost\\private -U smbtest5131 -E -d 1 -c tarmode\ full -mSMB3 -Tc - 144s full backup started for share private 144s started full dump, share=private 144s Xfer PIDs are now 5225,5224 144s xferPids 5225,5224 144s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\private -U smbtest5131 -E -d 1 -c tarmode\ full -mSMB3 -Tc - 144s tarmode is now full, system, hidden, noreset, noverbose 144s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 1 144s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 144s __bpc_progress_fileCnt__ 0 144s new 644 0/0 480434 tmp.gvef3l 144s new 644 0/0 480434 tmp.Q3OjwR 144s new 644 0/0 480434 tmp.t6bD9K 144s new 644 0/0 480434 tmp.IVPrZM 144s new 644 0/0 480434 tmp.3M3jm9 144s new 644 0/0 480434 tmp.z3XCGh 144s new 644 0/0 480434 tmp.Qjzn8h 144s new 644 0/0 480434 tmp.x88jo6 144s new 644 0/0 480434 tmp.wHOalN 144s tar: dumped 10 files and 0 directories 144s Total bytes written: 4804340 (27.3 MiB/s) 144s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 144s new 644 0/0 480434 tmp.CV3nHf 144s __bpc_progress_fileCnt__ 10 144s tarExtract: Done: 0 errors, 0 filesExist, 0 sizeExist, 0 sizeExistComp, 10 filesTotal, 4804340 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377715 sizeNewComp, 36 inodeLast 144s Xfer PIDs are now 144s xferPids 144s OrphanShareNameClean: removing orphan share public from /var/lib/backuppc/pc/localhost/2 144s __bpc_progress_state__ delete share #2/public 144s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDelete -h localhost -n 2 -l -m -s public / 144s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDelete line 102. 144s (Did you mean "$Host\'s" instead?) 144s Xfer PIDs are now 5231 144s xferPids 5231 144s BackupPC_backupDelete: removing #2/public/ 144s __bpc_progress_state__ merge #2/public/ -> #1/public/ 144s BackupPC_backupDelete: Merge into backup 1/public/ 144s mergeDir: attr write to /var/lib/backuppc/pc/localhost/1/fpublic//attrib failed (digest was ) 144s bpc_attrib_dirWrite: can't open/create raw /var/lib/backuppc/pc/localhost/1/fpublic for writing 144s Xfer PIDs are now 5234,5231 144s xferPids 5234,5231 144s __bpc_progress_state__ refCnt #1 144s __bpc_progress_state__ cntUpdate #1 144s __bpc_progress_state__ rename #1 144s __bpc_progress_state__ refCnt #2 144s BackupPC_refCountUpdate: localhost #2 inodeLast set to 37 (was 24) 144s __bpc_progress_state__ cntUpdate #2 144s __bpc_progress_state__ rename #2 144s __bpc_progress_state__ sumUpdate 144s __bpc_progress_fileCnt__ 0/128 144s __bpc_progress_fileCnt__ 8/128 144s __bpc_progress_fileCnt__ 16/128 144s __bpc_progress_fileCnt__ 24/128 144s __bpc_progress_fileCnt__ 32/128 144s __bpc_progress_fileCnt__ 40/128 144s __bpc_progress_fileCnt__ 48/128 144s __bpc_progress_fileCnt__ 56/128 144s __bpc_progress_fileCnt__ 64/128 144s __bpc_progress_fileCnt__ 72/128 144s __bpc_progress_fileCnt__ 80/128 144s __bpc_progress_fileCnt__ 88/128 144s __bpc_progress_fileCnt__ 96/128 144s __bpc_progress_fileCnt__ 104/128 144s __bpc_progress_fileCnt__ 112/128 144s __bpc_progress_fileCnt__ 120/128 144s __bpc_progress_state__ rename total 144s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 144s Xfer PIDs are now 5231 144s xferPids 5231 144s Xfer PIDs are now 144s xferPids 144s Finished BackupPC_backupDelete, status = 0 (running time: 0 sec) 144s Xfer PIDs are now 144s xferPids 144s full backup 2 complete, 10 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 144s BackupExpire: cntFull = 2, cntIncr = 1, firstFull = 0, firstIncr = 1, oldestIncr = 8.10185185185185e-05, oldestFull = 9.25925925925926e-05 144s __bpc_progress_state__ fsck 144s Running BackupPC_refCountUpdate -h localhost on localhost 144s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 144s Xfer PIDs are now 5237 144s xferPids 5237 144s BackupPC_refCountUpdate: doing fsck on localhost #2 (full) since $ConfRefCntFsck == 1 144s __bpc_progress_state__ refCnt #2 144s __bpc_progress_state__ cntUpdate #2 144s __bpc_progress_state__ rename #2 144s __bpc_progress_state__ sumUpdate 144s __bpc_progress_fileCnt__ 0/128 144s __bpc_progress_fileCnt__ 8/128 144s __bpc_progress_fileCnt__ 16/128 144s __bpc_progress_fileCnt__ 24/128 144s __bpc_progress_fileCnt__ 32/128 144s __bpc_progress_fileCnt__ 40/128 144s __bpc_progress_fileCnt__ 48/128 144s __bpc_progress_fileCnt__ 56/128 144s __bpc_progress_fileCnt__ 64/128 144s __bpc_progress_fileCnt__ 72/128 144s __bpc_progress_fileCnt__ 80/128 144s __bpc_progress_fileCnt__ 88/128 144s __bpc_progress_fileCnt__ 96/128 144s __bpc_progress_fileCnt__ 104/128 144s __bpc_progress_fileCnt__ 112/128 144s __bpc_progress_fileCnt__ 120/128 144s __bpc_progress_state__ rename total 144s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 144s Xfer PIDs are now 144s xferPids 144s Finished BackupPC_refCountUpdate (running time: 0 sec) 144s Xfer PIDs are now 144s xferPids 144s full backup complete 144s OK: Full backup succeeded 144s Changing share content and performing an incremental backup 144s Backup type: type = incr, needs_full = , needs_incr = , lastFullTime = 1715806001, opts{f} = , opts{i} = 1, opts{F} = 144s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 144s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 144s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.010 144s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.3.z created 2024-05-15 20:46:42 144s Backup prep: type = incr, case = 3, inPlace = 1, doDuplicate = 1, newBkupNum = 3, newBkupIdx = 3, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = 1) 144s Executing /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 144s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 144s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDuplicate line 89. 144s (Did you mean "$Host\'s" instead?) 144s Xfer PIDs are now 5307 144s xferPids 5307 144s __bpc_progress_state__ copy #2 -> #3 144s Copying backup #2 to #3 144s __bpc_progress_fileCnt__ 3 dirs 144s Xfer PIDs are now 5310,5307 144s xferPids 5310,5307 144s __bpc_progress_state__ sumUpdate 144s __bpc_progress_fileCnt__ 0/128 144s __bpc_progress_fileCnt__ 8/128 144s __bpc_progress_fileCnt__ 16/128 144s __bpc_progress_fileCnt__ 24/128 144s __bpc_progress_fileCnt__ 32/128 144s __bpc_progress_fileCnt__ 40/128 144s __bpc_progress_fileCnt__ 48/128 144s __bpc_progress_fileCnt__ 56/128 144s __bpc_progress_fileCnt__ 64/128 144s __bpc_progress_fileCnt__ 72/128 144s __bpc_progress_fileCnt__ 80/128 144s __bpc_progress_fileCnt__ 88/128 144s __bpc_progress_fileCnt__ 96/128 144s __bpc_progress_fileCnt__ 104/128 144s __bpc_progress_fileCnt__ 112/128 144s __bpc_progress_fileCnt__ 120/128 145s __bpc_progress_state__ rename total 145s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 145s Xfer PIDs are now 5307 145s xferPids 5307 145s BackupPC_backupDuplicate: got 0 errors and 0 file open errors 145s Finished BackupPC_backupDuplicate (running time: 0 sec) 145s __bpc_progress_state__ backup share "private" 145s Running: /usr/bin/smbclient \\\\localhost\\private -U smbtest5131 -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 145s incr backup started back to 2024-05-15 19:46:41 (backup #2) for share private 145s started incr dump, share=private 145s Xfer PIDs are now 5314,5313 145s xferPids 5314,5313 145s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\private -U smbtest5131 -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 145s tar:1298 Getting files newer than Wed May 15 19:46:41 2024 145s 145s tarmode is now full, system, hidden, noreset, noverbose 145s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 145s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 145s __bpc_progress_fileCnt__ 0 145s new 644 0/0 480434 tmp.WGUeGk 145s new 644 0/0 480434 tmp.N7EOeW 145s new 644 0/0 480434 tmp.spvoqE 145s same 644 0/0 480434 tmp.gvef3l 145s new 644 0/0 480434 tmp.ZM3StJ 145s same 644 0/0 480434 tmp.Q3OjwR 145s same 644 0/0 480434 tmp.t6bD9K 145s new 644 0/0 480434 tmp.WviHnT 145s same 644 0/0 480434 tmp.IVPrZM 145s same 644 0/0 480434 tmp.3M3jm9 145s new 644 0/0 480434 tmp.t9d6Zc 145s same 644 0/0 480434 tmp.z3XCGh 145s new 644 0/0 480434 tmp.4yttWT 145s same 644 0/0 480434 tmp.Qjzn8h 145s same 644 0/0 480434 tmp.x88jo6 145s same 644 0/0 480434 tmp.wHOalN 145s new 644 0/0 480434 tmp.zigTIK 145s new 644 0/0 480434 tmp.PwV1xA 145s new 644 0/0 480434 tmp.8j6JyL 145s tar: dumped 20 files and 0 directories 145s Total bytes written: 9608680 (39.2 MiB/s) 145s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 145s same 644 0/0 480434 tmp.CV3nHf 145s __bpc_progress_fileCnt__ 20 145s tarExtract: Done: 0 errors, 10 filesExist, 4804340 sizeExist, 1377715 sizeExistComp, 20 filesTotal, 9608680 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377702 sizeNewComp, 47 inodeLast 145s Xfer PIDs are now 145s xferPids 145s incr backup 3 complete, 20 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 145s BackupExpire: cntFull = 3, cntIncr = 1, firstFull = 0, firstIncr = 1, oldestIncr = 9.25925925925926e-05, oldestFull = 0.000104166666666667 145s __bpc_progress_state__ fsck 145s Running BackupPC_refCountUpdate -h localhost on localhost 145s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 145s Xfer PIDs are now 5320 145s xferPids 5320 145s __bpc_progress_state__ cntUpdate #3 145s __bpc_progress_state__ rename #3 145s __bpc_progress_state__ sumUpdate 145s __bpc_progress_fileCnt__ 0/128 145s __bpc_progress_fileCnt__ 8/128 145s __bpc_progress_fileCnt__ 16/128 145s __bpc_progress_fileCnt__ 24/128 145s __bpc_progress_fileCnt__ 32/128 145s __bpc_progress_fileCnt__ 40/128 145s __bpc_progress_fileCnt__ 48/128 145s __bpc_progress_fileCnt__ 56/128 145s __bpc_progress_fileCnt__ 64/128 145s __bpc_progress_fileCnt__ 72/128 145s __bpc_progress_fileCnt__ 80/128 145s __bpc_progress_fileCnt__ 88/128 145s __bpc_progress_fileCnt__ 96/128 145s __bpc_progress_fileCnt__ 104/128 145s __bpc_progress_fileCnt__ 112/128 145s __bpc_progress_fileCnt__ 120/128 145s __bpc_progress_state__ rename total 145s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 145s Xfer PIDs are now 145s xferPids 145s Finished BackupPC_refCountUpdate (running time: 0 sec) 145s Xfer PIDs are now 145s xferPids 145s incr backup complete 145s OK: Incremental backup succeeded 145s Done. 145s Deleted user smbtest5131. 145s userdel: smbtest5131 mail spool (/var/mail/smbtest5131) not found 145s autopkgtest [20:46:43]: test authenticated-smb-backup: -----------------------] 146s authenticated-smb-backup PASS 146s autopkgtest [20:46:44]: test authenticated-smb-backup: - - - - - - - - - - results - - - - - - - - - - 146s autopkgtest [20:46:44]: @@@@@@@@@@@@@@@@@@@@ summary 146s smb-backup PASS 146s authenticated-smb-backup PASS 157s Creating nova instance adt-oracular-ppc64el-backuppc-20240515-204417-juju-7f2275-prod-proposed-migration-environment-3-45d9e364-ee9c-44cb-92d5-b7d3bc7080fc from image adt/ubuntu-oracular-ppc64el-server-20240509.img (UUID 1c85ce1c-4944-4b4e-a1c6-2159ec573517)...