0s autopkgtest [03:01:47]: starting date and time: 2024-06-22 03:01:47+0000 0s autopkgtest [03:01:47]: git checkout: 433ed4cb Merge branch 'skia/nova_flock' into 'ubuntu/5.34+prod' 0s autopkgtest [03:01:47]: host juju-7f2275-prod-proposed-migration-environment-3; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.26us0hk_/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:nullmailer --apt-upgrade backuppc --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=nullmailer/1:2.2+10~g7ed88a0-6' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-3@bos02-ppc64el-9.secgroup --name adt-oracular-ppc64el-backuppc-20240622-030147-juju-7f2275-prod-proposed-migration-environment-3-e265c729-c96e-40ac-9cc9-7a4bde6d1a8e --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/ 138s autopkgtest [03:04:05]: testbed dpkg architecture: ppc64el 138s autopkgtest [03:04:05]: testbed apt version: 2.9.5 138s autopkgtest [03:04:05]: @@@@@@@@@@@@@@@@@@@@ test bed setup 139s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [110 kB] 140s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [3884 B] 140s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [7052 B] 140s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [430 kB] 140s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [56.2 kB] 140s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el Packages [76.1 kB] 140s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/restricted ppc64el Packages [1860 B] 140s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/universe ppc64el Packages [377 kB] 140s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse ppc64el Packages [2532 B] 140s Fetched 1065 kB in 1s (1244 kB/s) 140s Reading package lists... 142s Reading package lists... 142s Building dependency tree... 142s Reading state information... 143s Calculating upgrade... 143s The following packages will be upgraded: 143s pollinate 143s 1 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 143s Need to get 22.8 kB of archives. 143s After this operation, 1024 B disk space will be freed. 143s Get:1 http://ftpmaster.internal/ubuntu oracular/main ppc64el pollinate all 4.33-4ubuntu1 [22.8 kB] 143s Fetched 22.8 kB in 0s (106 kB/s) 143s (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 ... 72687 files and directories currently installed.) 143s Preparing to unpack .../pollinate_4.33-4ubuntu1_all.deb ... 143s Unpacking pollinate (4.33-4ubuntu1) over (4.33-3.1ubuntu1) ... 143s Setting up pollinate (4.33-4ubuntu1) ... 144s Processing triggers for man-db (2.12.1-2) ... 144s Reading package lists... 145s Building dependency tree... 145s Reading state information... 145s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 145s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 146s Hit:2 http://ftpmaster.internal/ubuntu oracular InRelease 146s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease 146s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease 147s Reading package lists... 147s Reading package lists... 147s Building dependency tree... 147s Reading state information... 148s Calculating upgrade... 148s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 148s Reading package lists... 148s Building dependency tree... 148s Reading state information... 148s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 148s autopkgtest [03:04:15]: rebooting testbed after setup commands that affected boot 152s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 185s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 189s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 196s autopkgtest [03:05:03]: testbed running kernel: Linux 6.8.0-31-generic #31-Ubuntu SMP Sat Apr 20 00:05:55 UTC 2024 198s autopkgtest [03:05:05]: @@@@@@@@@@@@@@@@@@@@ apt-source backuppc 200s Get:1 http://ftpmaster.internal/ubuntu oracular/main backuppc 4.4.0-8build1 (dsc) [2289 B] 200s Get:2 http://ftpmaster.internal/ubuntu oracular/main backuppc 4.4.0-8build1 (tar) [657 kB] 200s Get:3 http://ftpmaster.internal/ubuntu oracular/main backuppc 4.4.0-8build1 (diff) [61.1 kB] 200s gpgv: Signature made Mon Apr 8 15:54:41 2024 UTC 200s gpgv: using RSA key 4FB588A84C2DDE79A74C77876FA458DD1DB03F71 200s gpgv: issuer "juliank@ubuntu.com" 200s gpgv: Can't check signature: No public key 200s dpkg-source: warning: cannot verify inline signature for ./backuppc_4.4.0-8build1.dsc: no acceptable signature found 200s autopkgtest [03:05:07]: testing package backuppc version 4.4.0-8build1 201s autopkgtest [03:05:08]: build not needed 201s autopkgtest [03:05:08]: test smb-backup: preparing testbed 202s Reading package lists... 202s Building dependency tree... 202s Reading state information... 202s Starting pkgProblemResolver with broken count: 0 202s Starting 2 pkgProblemResolver with broken count: 0 202s Done 203s The following additional packages will be installed: 203s apache2 apache2-bin apache2-data apache2-utils backuppc backuppc-rsync 203s libapr1t64 libaprutil1-dbd-sqlite3 libaprutil1-ldap libaprutil1t64 203s libarchive-zip-perl libavahi-client3 libavahi-common-data libavahi-common3 203s libbackuppc-xs-perl libcgi-pm-perl libcups2t64 libfile-listing-perl 203s libhtml-parser-perl libhtml-tagset-perl libhttp-date-perl libldb2 203s liblua5.4-0 libnsl2 libpython3.12t64 libsmbclient0 libtalloc2 libtdb1 203s libtevent0t64 libtime-parsedate-perl libtimedate-perl liburi-perl 203s libwbclient0 postfix python3-dnspython python3-ldb python3-markdown 203s python3-samba python3-talloc python3-tdb samba samba-common samba-common-bin 203s samba-libs smbclient ssl-cert tdb-tools 203s Suggested packages: 203s apache2-doc apache2-suexec-pristine | apache2-suexec-custom www-browser 203s certbot | acme-tiny | acmetool | dehydrated | lacme | lecm | lego 203s libscgi-perl par2 w3m | www-browser cups-common libdata-dump-perl 203s libbusiness-isbn-perl libregexp-ipv6-perl libwww-perl mail-reader 203s postfix-cdb postfix-doc postfix-ldap postfix-lmdb postfix-mta-sts-resolver 203s postfix-mongodb postfix-mysql postfix-pcre postfix-pgsql postfix-sqlite 203s procmail sasl2-bin | dovecot-common python3-trio python3-aioquic python3-h2 203s python3-httpx python3-httpcore python-markdown-doc bind9 bind9utils ctdb 203s ldb-tools ntp | chrony winbind heimdal-clients cifs-utils 203s Recommended packages: 203s libio-dirent-perl rrdtool libcgi-fast-perl libhttp-message-perl python3-gpg 203s attr samba-dsdb-modules samba-vfs-modules samba-ad-provision 203s The following NEW packages will be installed: 203s apache2 apache2-bin apache2-data apache2-utils autopkgtest-satdep backuppc 203s backuppc-rsync libapr1t64 libaprutil1-dbd-sqlite3 libaprutil1-ldap 203s libaprutil1t64 libarchive-zip-perl libavahi-client3 libavahi-common-data 203s libavahi-common3 libbackuppc-xs-perl libcgi-pm-perl libcups2t64 203s libfile-listing-perl libhtml-parser-perl libhtml-tagset-perl 203s libhttp-date-perl libldb2 liblua5.4-0 libnsl2 libpython3.12t64 libsmbclient0 203s libtalloc2 libtdb1 libtevent0t64 libtime-parsedate-perl libtimedate-perl 203s liburi-perl libwbclient0 postfix python3-dnspython python3-ldb 203s python3-markdown python3-samba python3-talloc python3-tdb samba samba-common 203s samba-common-bin samba-libs smbclient ssl-cert tdb-tools 203s 0 upgraded, 48 newly installed, 0 to remove and 0 not upgraded. 203s Need to get 21.9 MB/21.9 MB of archives. 203s After this operation, 121 MB of additional disk space will be used. 203s Get:1 /tmp/autopkgtest.k8m5Ts/1-autopkgtest-satdep.deb autopkgtest-satdep ppc64el 0 [728 B] 203s Get:2 http://ftpmaster.internal/ubuntu oracular/main ppc64el libapr1t64 ppc64el 1.7.2-3.2 [133 kB] 203s Get:3 http://ftpmaster.internal/ubuntu oracular/main ppc64el libaprutil1t64 ppc64el 1.6.3-2ubuntu1 [112 kB] 203s Get:4 http://ftpmaster.internal/ubuntu oracular/main ppc64el libaprutil1-dbd-sqlite3 ppc64el 1.6.3-2ubuntu1 [12.2 kB] 203s Get:5 http://ftpmaster.internal/ubuntu oracular/main ppc64el libaprutil1-ldap ppc64el 1.6.3-2ubuntu1 [9230 B] 203s Get:6 http://ftpmaster.internal/ubuntu oracular/main ppc64el liblua5.4-0 ppc64el 5.4.6-3build2 [216 kB] 203s Get:7 http://ftpmaster.internal/ubuntu oracular/main ppc64el apache2-bin ppc64el 2.4.59-2ubuntu2 [1558 kB] 203s Get:8 http://ftpmaster.internal/ubuntu oracular/main ppc64el apache2-data all 2.4.59-2ubuntu2 [163 kB] 203s Get:9 http://ftpmaster.internal/ubuntu oracular/main ppc64el apache2-utils ppc64el 2.4.59-2ubuntu2 [102 kB] 203s Get:10 http://ftpmaster.internal/ubuntu oracular/main ppc64el apache2 ppc64el 2.4.59-2ubuntu2 [90.3 kB] 203s Get:11 http://ftpmaster.internal/ubuntu oracular/main ppc64el backuppc-rsync ppc64el 3.1.3.0-3ubuntu1 [318 kB] 203s Get:12 http://ftpmaster.internal/ubuntu oracular/main ppc64el ssl-cert all 1.1.2ubuntu1 [17.8 kB] 203s Get:13 http://ftpmaster.internal/ubuntu oracular/main ppc64el libnsl2 ppc64el 1.3.0-3build3 [48.9 kB] 203s Get:14 http://ftpmaster.internal/ubuntu oracular/main ppc64el postfix ppc64el 3.9.0-2 [1371 kB] 203s Get:15 http://ftpmaster.internal/ubuntu oracular/main ppc64el libarchive-zip-perl all 1.68-1 [90.2 kB] 203s Get:16 http://ftpmaster.internal/ubuntu oracular/main ppc64el libbackuppc-xs-perl ppc64el 0.62-2build5 [74.9 kB] 203s Get:17 http://ftpmaster.internal/ubuntu oracular/main ppc64el libhtml-tagset-perl all 3.24-1 [14.1 kB] 203s Get:18 http://ftpmaster.internal/ubuntu oracular/main ppc64el liburi-perl all 5.28-1 [88.1 kB] 204s Get:19 http://ftpmaster.internal/ubuntu oracular/main ppc64el libhtml-parser-perl ppc64el 3.82-1 [91.2 kB] 204s Get:20 http://ftpmaster.internal/ubuntu oracular/main ppc64el libcgi-pm-perl all 4.65-1 [185 kB] 204s Get:21 http://ftpmaster.internal/ubuntu oracular/main ppc64el libtimedate-perl all 2.3300-2 [34.0 kB] 204s Get:22 http://ftpmaster.internal/ubuntu oracular/main ppc64el libhttp-date-perl all 6.06-1 [10.2 kB] 204s Get:23 http://ftpmaster.internal/ubuntu oracular/main ppc64el libfile-listing-perl all 6.16-1 [11.3 kB] 204s Get:24 http://ftpmaster.internal/ubuntu oracular/main ppc64el libtime-parsedate-perl all 2015.103-4 [28.6 kB] 204s Get:25 http://ftpmaster.internal/ubuntu oracular/main ppc64el backuppc ppc64el 4.4.0-8build1 [541 kB] 204s Get:26 http://ftpmaster.internal/ubuntu oracular/main ppc64el python3-dnspython all 2.6.1-1ubuntu1 [163 kB] 204s Get:27 http://ftpmaster.internal/ubuntu oracular/main ppc64el libtalloc2 ppc64el 2.4.2-1build2 [36.7 kB] 204s Get:28 http://ftpmaster.internal/ubuntu oracular/main ppc64el libtdb1 ppc64el 1.4.10-1build1 [62.8 kB] 204s Get:29 http://ftpmaster.internal/ubuntu oracular/main ppc64el libtevent0t64 ppc64el 0.16.1-2build1 [51.2 kB] 204s Get:30 http://ftpmaster.internal/ubuntu oracular/main ppc64el libldb2 ppc64el 2:2.8.0+samba4.19.5+dfsg-4ubuntu9 [220 kB] 204s Get:31 http://ftpmaster.internal/ubuntu oracular/main ppc64el libpython3.12t64 ppc64el 3.12.4-1 [2542 kB] 204s Get:32 http://ftpmaster.internal/ubuntu oracular/main ppc64el python3-ldb ppc64el 2:2.8.0+samba4.19.5+dfsg-4ubuntu9 [48.0 kB] 204s Get:33 http://ftpmaster.internal/ubuntu oracular/main ppc64el python3-tdb ppc64el 1.4.10-1build1 [15.8 kB] 204s Get:34 http://ftpmaster.internal/ubuntu oracular/main ppc64el python3-markdown all 3.6-1 [73.4 kB] 204s Get:35 http://ftpmaster.internal/ubuntu oracular/main ppc64el libavahi-common-data ppc64el 0.8-13ubuntu6 [29.7 kB] 204s Get:36 http://ftpmaster.internal/ubuntu oracular/main ppc64el libavahi-common3 ppc64el 0.8-13ubuntu6 [26.3 kB] 204s Get:37 http://ftpmaster.internal/ubuntu oracular/main ppc64el libavahi-client3 ppc64el 0.8-13ubuntu6 [30.8 kB] 204s Get:38 http://ftpmaster.internal/ubuntu oracular/main ppc64el libwbclient0 ppc64el 2:4.19.5+dfsg-4ubuntu9 [77.3 kB] 204s Get:39 http://ftpmaster.internal/ubuntu oracular/main ppc64el samba-libs ppc64el 2:4.19.5+dfsg-4ubuntu9 [6674 kB] 204s Get:40 http://ftpmaster.internal/ubuntu oracular/main ppc64el python3-talloc ppc64el 2.4.2-1build2 [13.4 kB] 204s Get:41 http://ftpmaster.internal/ubuntu oracular/main ppc64el python3-samba ppc64el 2:4.19.5+dfsg-4ubuntu9 [2930 kB] 204s Get:42 http://ftpmaster.internal/ubuntu oracular/main ppc64el samba-common all 2:4.19.5+dfsg-4ubuntu9 [64.1 kB] 204s Get:43 http://ftpmaster.internal/ubuntu oracular/main ppc64el libcups2t64 ppc64el 2.4.7-1.2ubuntu7 [347 kB] 204s Get:44 http://ftpmaster.internal/ubuntu oracular/main ppc64el samba-common-bin ppc64el 2:4.19.5+dfsg-4ubuntu9 [1417 kB] 204s Get:45 http://ftpmaster.internal/ubuntu oracular/main ppc64el tdb-tools ppc64el 1.4.10-1build1 [27.2 kB] 204s Get:46 http://ftpmaster.internal/ubuntu oracular/main ppc64el samba ppc64el 2:4.19.5+dfsg-4ubuntu9 [1113 kB] 204s Get:47 http://ftpmaster.internal/ubuntu oracular/main ppc64el libsmbclient0 ppc64el 2:4.19.5+dfsg-4ubuntu9 [70.3 kB] 204s Get:48 http://ftpmaster.internal/ubuntu oracular/main ppc64el smbclient ppc64el 2:4.19.5+dfsg-4ubuntu9 [526 kB] 205s Preconfiguring packages ... 205s Fetched 21.9 MB in 2s (14.0 MB/s) 205s Selecting previously unselected package libapr1t64:ppc64el. 205s (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 ... 72687 files and directories currently installed.) 205s Preparing to unpack .../00-libapr1t64_1.7.2-3.2_ppc64el.deb ... 205s Unpacking libapr1t64:ppc64el (1.7.2-3.2) ... 205s Selecting previously unselected package libaprutil1t64:ppc64el. 205s Preparing to unpack .../01-libaprutil1t64_1.6.3-2ubuntu1_ppc64el.deb ... 205s Unpacking libaprutil1t64:ppc64el (1.6.3-2ubuntu1) ... 205s Selecting previously unselected package libaprutil1-dbd-sqlite3:ppc64el. 205s Preparing to unpack .../02-libaprutil1-dbd-sqlite3_1.6.3-2ubuntu1_ppc64el.deb ... 205s Unpacking libaprutil1-dbd-sqlite3:ppc64el (1.6.3-2ubuntu1) ... 205s Selecting previously unselected package libaprutil1-ldap:ppc64el. 205s Preparing to unpack .../03-libaprutil1-ldap_1.6.3-2ubuntu1_ppc64el.deb ... 205s Unpacking libaprutil1-ldap:ppc64el (1.6.3-2ubuntu1) ... 205s Selecting previously unselected package liblua5.4-0:ppc64el. 205s Preparing to unpack .../04-liblua5.4-0_5.4.6-3build2_ppc64el.deb ... 205s Unpacking liblua5.4-0:ppc64el (5.4.6-3build2) ... 205s Selecting previously unselected package apache2-bin. 205s Preparing to unpack .../05-apache2-bin_2.4.59-2ubuntu2_ppc64el.deb ... 205s Unpacking apache2-bin (2.4.59-2ubuntu2) ... 205s Selecting previously unselected package apache2-data. 205s Preparing to unpack .../06-apache2-data_2.4.59-2ubuntu2_all.deb ... 205s Unpacking apache2-data (2.4.59-2ubuntu2) ... 205s Selecting previously unselected package apache2-utils. 205s Preparing to unpack .../07-apache2-utils_2.4.59-2ubuntu2_ppc64el.deb ... 205s Unpacking apache2-utils (2.4.59-2ubuntu2) ... 205s Selecting previously unselected package apache2. 205s Preparing to unpack .../08-apache2_2.4.59-2ubuntu2_ppc64el.deb ... 205s Unpacking apache2 (2.4.59-2ubuntu2) ... 205s Selecting previously unselected package backuppc-rsync. 205s Preparing to unpack .../09-backuppc-rsync_3.1.3.0-3ubuntu1_ppc64el.deb ... 205s Unpacking backuppc-rsync (3.1.3.0-3ubuntu1) ... 205s Selecting previously unselected package ssl-cert. 205s Preparing to unpack .../10-ssl-cert_1.1.2ubuntu1_all.deb ... 205s Unpacking ssl-cert (1.1.2ubuntu1) ... 205s Selecting previously unselected package libnsl2:ppc64el. 205s Preparing to unpack .../11-libnsl2_1.3.0-3build3_ppc64el.deb ... 205s Unpacking libnsl2:ppc64el (1.3.0-3build3) ... 205s Selecting previously unselected package postfix. 205s Preparing to unpack .../12-postfix_3.9.0-2_ppc64el.deb ... 205s Unpacking postfix (3.9.0-2) ... 205s Selecting previously unselected package libarchive-zip-perl. 205s Preparing to unpack .../13-libarchive-zip-perl_1.68-1_all.deb ... 205s Unpacking libarchive-zip-perl (1.68-1) ... 205s Selecting previously unselected package libbackuppc-xs-perl:ppc64el. 205s Preparing to unpack .../14-libbackuppc-xs-perl_0.62-2build5_ppc64el.deb ... 205s Unpacking libbackuppc-xs-perl:ppc64el (0.62-2build5) ... 205s Selecting previously unselected package libhtml-tagset-perl. 205s Preparing to unpack .../15-libhtml-tagset-perl_3.24-1_all.deb ... 205s Unpacking libhtml-tagset-perl (3.24-1) ... 206s Selecting previously unselected package liburi-perl. 206s Preparing to unpack .../16-liburi-perl_5.28-1_all.deb ... 206s Unpacking liburi-perl (5.28-1) ... 206s Selecting previously unselected package libhtml-parser-perl:ppc64el. 206s Preparing to unpack .../17-libhtml-parser-perl_3.82-1_ppc64el.deb ... 206s Unpacking libhtml-parser-perl:ppc64el (3.82-1) ... 206s Selecting previously unselected package libcgi-pm-perl. 206s Preparing to unpack .../18-libcgi-pm-perl_4.65-1_all.deb ... 206s Unpacking libcgi-pm-perl (4.65-1) ... 206s Selecting previously unselected package libtimedate-perl. 206s Preparing to unpack .../19-libtimedate-perl_2.3300-2_all.deb ... 206s Unpacking libtimedate-perl (2.3300-2) ... 206s Selecting previously unselected package libhttp-date-perl. 206s Preparing to unpack .../20-libhttp-date-perl_6.06-1_all.deb ... 206s Unpacking libhttp-date-perl (6.06-1) ... 206s Selecting previously unselected package libfile-listing-perl. 206s Preparing to unpack .../21-libfile-listing-perl_6.16-1_all.deb ... 206s Unpacking libfile-listing-perl (6.16-1) ... 206s Selecting previously unselected package libtime-parsedate-perl. 206s Preparing to unpack .../22-libtime-parsedate-perl_2015.103-4_all.deb ... 206s Unpacking libtime-parsedate-perl (2015.103-4) ... 206s Selecting previously unselected package backuppc. 206s Preparing to unpack .../23-backuppc_4.4.0-8build1_ppc64el.deb ... 206s Unpacking backuppc (4.4.0-8build1) ... 206s Selecting previously unselected package python3-dnspython. 206s Preparing to unpack .../24-python3-dnspython_2.6.1-1ubuntu1_all.deb ... 206s Unpacking python3-dnspython (2.6.1-1ubuntu1) ... 206s Selecting previously unselected package libtalloc2:ppc64el. 206s Preparing to unpack .../25-libtalloc2_2.4.2-1build2_ppc64el.deb ... 206s Unpacking libtalloc2:ppc64el (2.4.2-1build2) ... 206s Selecting previously unselected package libtdb1:ppc64el. 206s Preparing to unpack .../26-libtdb1_1.4.10-1build1_ppc64el.deb ... 206s Unpacking libtdb1:ppc64el (1.4.10-1build1) ... 206s Selecting previously unselected package libtevent0t64:ppc64el. 206s Preparing to unpack .../27-libtevent0t64_0.16.1-2build1_ppc64el.deb ... 206s Unpacking libtevent0t64:ppc64el (0.16.1-2build1) ... 206s Selecting previously unselected package libldb2:ppc64el. 206s Preparing to unpack .../28-libldb2_2%3a2.8.0+samba4.19.5+dfsg-4ubuntu9_ppc64el.deb ... 206s Unpacking libldb2:ppc64el (2:2.8.0+samba4.19.5+dfsg-4ubuntu9) ... 206s Selecting previously unselected package libpython3.12t64:ppc64el. 206s Preparing to unpack .../29-libpython3.12t64_3.12.4-1_ppc64el.deb ... 206s Unpacking libpython3.12t64:ppc64el (3.12.4-1) ... 206s Selecting previously unselected package python3-ldb. 206s Preparing to unpack .../30-python3-ldb_2%3a2.8.0+samba4.19.5+dfsg-4ubuntu9_ppc64el.deb ... 206s Unpacking python3-ldb (2:2.8.0+samba4.19.5+dfsg-4ubuntu9) ... 206s Selecting previously unselected package python3-tdb. 206s Preparing to unpack .../31-python3-tdb_1.4.10-1build1_ppc64el.deb ... 206s Unpacking python3-tdb (1.4.10-1build1) ... 206s Selecting previously unselected package python3-markdown. 206s Preparing to unpack .../32-python3-markdown_3.6-1_all.deb ... 206s Unpacking python3-markdown (3.6-1) ... 206s Selecting previously unselected package libavahi-common-data:ppc64el. 206s Preparing to unpack .../33-libavahi-common-data_0.8-13ubuntu6_ppc64el.deb ... 206s Unpacking libavahi-common-data:ppc64el (0.8-13ubuntu6) ... 206s Selecting previously unselected package libavahi-common3:ppc64el. 206s Preparing to unpack .../34-libavahi-common3_0.8-13ubuntu6_ppc64el.deb ... 206s Unpacking libavahi-common3:ppc64el (0.8-13ubuntu6) ... 206s Selecting previously unselected package libavahi-client3:ppc64el. 206s Preparing to unpack .../35-libavahi-client3_0.8-13ubuntu6_ppc64el.deb ... 206s Unpacking libavahi-client3:ppc64el (0.8-13ubuntu6) ... 206s Selecting previously unselected package libwbclient0:ppc64el. 206s Preparing to unpack .../36-libwbclient0_2%3a4.19.5+dfsg-4ubuntu9_ppc64el.deb ... 206s Unpacking libwbclient0:ppc64el (2:4.19.5+dfsg-4ubuntu9) ... 206s Selecting previously unselected package samba-libs:ppc64el. 206s Preparing to unpack .../37-samba-libs_2%3a4.19.5+dfsg-4ubuntu9_ppc64el.deb ... 206s Unpacking samba-libs:ppc64el (2:4.19.5+dfsg-4ubuntu9) ... 206s Selecting previously unselected package python3-talloc:ppc64el. 206s Preparing to unpack .../38-python3-talloc_2.4.2-1build2_ppc64el.deb ... 206s Unpacking python3-talloc:ppc64el (2.4.2-1build2) ... 206s Selecting previously unselected package python3-samba. 206s Preparing to unpack .../39-python3-samba_2%3a4.19.5+dfsg-4ubuntu9_ppc64el.deb ... 206s Unpacking python3-samba (2:4.19.5+dfsg-4ubuntu9) ... 207s Selecting previously unselected package samba-common. 207s Preparing to unpack .../40-samba-common_2%3a4.19.5+dfsg-4ubuntu9_all.deb ... 207s Unpacking samba-common (2:4.19.5+dfsg-4ubuntu9) ... 207s Selecting previously unselected package libcups2t64:ppc64el. 207s Preparing to unpack .../41-libcups2t64_2.4.7-1.2ubuntu7_ppc64el.deb ... 207s Unpacking libcups2t64:ppc64el (2.4.7-1.2ubuntu7) ... 207s Selecting previously unselected package samba-common-bin. 207s Preparing to unpack .../42-samba-common-bin_2%3a4.19.5+dfsg-4ubuntu9_ppc64el.deb ... 207s Unpacking samba-common-bin (2:4.19.5+dfsg-4ubuntu9) ... 207s Selecting previously unselected package tdb-tools. 207s Preparing to unpack .../43-tdb-tools_1.4.10-1build1_ppc64el.deb ... 207s Unpacking tdb-tools (1.4.10-1build1) ... 207s Selecting previously unselected package samba. 207s Preparing to unpack .../44-samba_2%3a4.19.5+dfsg-4ubuntu9_ppc64el.deb ... 207s Unpacking samba (2:4.19.5+dfsg-4ubuntu9) ... 207s Selecting previously unselected package libsmbclient0:ppc64el. 207s Preparing to unpack .../45-libsmbclient0_2%3a4.19.5+dfsg-4ubuntu9_ppc64el.deb ... 207s Unpacking libsmbclient0:ppc64el (2:4.19.5+dfsg-4ubuntu9) ... 207s Selecting previously unselected package smbclient. 207s Preparing to unpack .../46-smbclient_2%3a4.19.5+dfsg-4ubuntu9_ppc64el.deb ... 207s Unpacking smbclient (2:4.19.5+dfsg-4ubuntu9) ... 207s Selecting previously unselected package autopkgtest-satdep. 207s Preparing to unpack .../47-1-autopkgtest-satdep.deb ... 207s Unpacking autopkgtest-satdep (0) ... 207s Setting up libarchive-zip-perl (1.68-1) ... 207s Setting up libtdb1:ppc64el (1.4.10-1build1) ... 207s Setting up libhtml-tagset-perl (3.24-1) ... 207s Setting up samba-common (2:4.19.5+dfsg-4ubuntu9) ... 207s 207s Creating config file /etc/samba/smb.conf with new version 207s Setting up libwbclient0:ppc64el (2:4.19.5+dfsg-4ubuntu9) ... 207s Setting up libtalloc2:ppc64el (2.4.2-1build2) ... 207s Setting up libpython3.12t64:ppc64el (3.12.4-1) ... 207s Setting up backuppc-rsync (3.1.3.0-3ubuntu1) ... 207s Setting up python3-tdb (1.4.10-1build1) ... 207s Setting up ssl-cert (1.1.2ubuntu1) ... 208s Created symlink /etc/systemd/system/multi-user.target.wants/ssl-cert.service → /usr/lib/systemd/system/ssl-cert.service. 209s Setting up libavahi-common-data:ppc64el (0.8-13ubuntu6) ... 209s Setting up tdb-tools (1.4.10-1build1) ... 209s update-alternatives: using /usr/bin/tdbbackup.tdbtools to provide /usr/bin/tdbbackup (tdbbackup) in auto mode 209s Setting up python3-markdown (3.6-1) ... 209s Setting up libtimedate-perl (2.3300-2) ... 209s Setting up libtime-parsedate-perl (2015.103-4) ... 209s Setting up python3-dnspython (2.6.1-1ubuntu1) ... 210s Setting up libapr1t64:ppc64el (1.7.2-3.2) ... 210s Setting up libnsl2:ppc64el (1.3.0-3build3) ... 210s Setting up liblua5.4-0:ppc64el (5.4.6-3build2) ... 210s Setting up apache2-data (2.4.59-2ubuntu2) ... 210s Setting up libbackuppc-xs-perl:ppc64el (0.62-2build5) ... 210s Setting up liburi-perl (5.28-1) ... 210s Setting up libtevent0t64:ppc64el (0.16.1-2build1) ... 210s Setting up libaprutil1t64:ppc64el (1.6.3-2ubuntu1) ... 210s Setting up libhttp-date-perl (6.06-1) ... 210s Setting up libfile-listing-perl (6.16-1) ... 210s Setting up python3-talloc:ppc64el (2.4.2-1build2) ... 210s Setting up libavahi-common3:ppc64el (0.8-13ubuntu6) ... 210s Setting up libaprutil1-ldap:ppc64el (1.6.3-2ubuntu1) ... 210s Setting up libaprutil1-dbd-sqlite3:ppc64el (1.6.3-2ubuntu1) ... 210s Setting up postfix (3.9.0-2) ... 210s info: Selecting GID from range 100 to 999 ... 210s info: Adding group `postfix' (GID 111) ... 210s info: Selecting UID from range 100 to 999 ... 210s 210s info: Adding system user `postfix' (UID 107) ... 210s info: Adding new user `postfix' (UID 107) with group `postfix' ... 210s info: Not creating home directory `/var/spool/postfix'. 210s Creating /etc/postfix/dynamicmaps.cf 210s info: Selecting GID from range 100 to 999 ... 210s info: Adding group `postdrop' (GID 112) ... 210s setting myhostname: autopkgtest.local 210s setting alias maps 210s setting alias database 210s changing /etc/mailname to autopkgtest.local 210s setting myorigin 210s setting destinations: $myhostname, autopkgtest.local, localhost.local, , localhost 210s setting relayhost: 210s setting mynetworks: 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128 210s setting mailbox_size_limit: 0 210s setting recipient_delimiter: + 212s setting inet_interfaces: all 214s setting inet_protocols: all 214s /etc/aliases does not exist, creating it. 214s WARNING: /etc/aliases exists, but does not have a root alias. 214s 214s Postfix (main.cf) is now set up with a default configuration. If you need to 214s make changes, edit /etc/postfix/main.cf (and others) as needed. To view 214s Postfix configuration values, see postconf(1). 214s 214s After modifying main.cf, be sure to run 'systemctl reload postfix'. 214s 216s Running newaliases 217s Created symlink /etc/systemd/system/multi-user.target.wants/postfix.service → /usr/lib/systemd/system/postfix.service. 217s Setting up libhtml-parser-perl:ppc64el (3.82-1) ... 217s Setting up libldb2:ppc64el (2:2.8.0+samba4.19.5+dfsg-4ubuntu9) ... 218s Setting up libavahi-client3:ppc64el (0.8-13ubuntu6) ... 218s Setting up apache2-utils (2.4.59-2ubuntu2) ... 218s Setting up libcgi-pm-perl (4.65-1) ... 218s Setting up samba-libs:ppc64el (2:4.19.5+dfsg-4ubuntu9) ... 218s Setting up apache2-bin (2.4.59-2ubuntu2) ... 218s Setting up python3-ldb (2:2.8.0+samba4.19.5+dfsg-4ubuntu9) ... 218s Setting up libsmbclient0:ppc64el (2:4.19.5+dfsg-4ubuntu9) ... 218s Setting up libcups2t64:ppc64el (2.4.7-1.2ubuntu7) ... 218s Setting up python3-samba (2:4.19.5+dfsg-4ubuntu9) ... 218s Setting up apache2 (2.4.59-2ubuntu2) ... 218s Enabling module mpm_event. 218s Enabling module authz_core. 218s Enabling module authz_host. 218s Enabling module authn_core. 218s Enabling module auth_basic. 218s Enabling module access_compat. 219s Enabling module authn_file. 219s Enabling module authz_user. 219s Enabling module alias. 219s Enabling module dir. 219s Enabling module autoindex. 219s Enabling module env. 219s Enabling module mime. 219s Enabling module negotiation. 219s Enabling module setenvif. 219s Enabling module filter. 219s Enabling module deflate. 219s Enabling module status. 219s Enabling module reqtimeout. 219s Enabling conf charset. 219s Enabling conf localized-error-pages. 219s Enabling conf other-vhosts-access-log. 219s Enabling conf security. 219s Enabling conf serve-cgi-bin. 219s Enabling site 000-default. 220s Created symlink /etc/systemd/system/multi-user.target.wants/apache2.service → /usr/lib/systemd/system/apache2.service. 221s Created symlink /etc/systemd/system/multi-user.target.wants/apache-htcacheclean.service → /usr/lib/systemd/system/apache-htcacheclean.service. 222s Setting up backuppc (4.4.0-8build1) ... 222s 222s apache2_invoke: Enable configuration backuppc.conf 222s warn: The home directory `/var/lib/backuppc' already exists. Not touching this directory. 222s warn: Warning: The home directory `/var/lib/backuppc' does not belong to the user you are currently creating. 222s Adding password for user backuppc 222s Considering dependency authn_core for auth_basic: 222s Module authn_core already enabled 222s Module auth_basic already enabled 222s Considering dependency authz_core for authz_groupfile: 222s Module authz_core already enabled 222s Enabling module authz_groupfile. 222s To activate the new configuration, you need to run: 222s systemctl restart apache2 222s Module authn_file already enabled 222s Considering dependency authz_core for authz_user: 222s Module authz_core already enabled 222s Module authz_user already enabled 222s Your MPM seems to be threaded. Selecting cgid instead of cgi. 222s Enabling module cgid. 222s To activate the new configuration, you need to run: 222s systemctl restart apache2 222s 222s Creating config file /etc/backuppc/config.pl with new version 223s Created symlink /etc/systemd/system/multi-user.target.wants/backuppc.service → /usr/lib/systemd/system/backuppc.service. 223s Setting up smbclient (2:4.19.5+dfsg-4ubuntu9) ... 223s Setting up samba-common-bin (2:4.19.5+dfsg-4ubuntu9) ... 223s Setting up samba (2:4.19.5+dfsg-4ubuntu9) ... 225s Created symlink /etc/systemd/system/smb.service → /usr/lib/systemd/system/smbd.service. 225s Created symlink /etc/systemd/system/multi-user.target.wants/smbd.service → /usr/lib/systemd/system/smbd.service. 225s Created symlink /etc/systemd/system/nmb.service → /usr/lib/systemd/system/nmbd.service. 225s Created symlink /etc/systemd/system/multi-user.target.wants/nmbd.service → /usr/lib/systemd/system/nmbd.service. 226s Created symlink /etc/systemd/system/samba.service → /usr/lib/systemd/system/samba-ad-dc.service. 226s Created symlink /etc/systemd/system/multi-user.target.wants/samba-ad-dc.service → /usr/lib/systemd/system/samba-ad-dc.service. 226s Setting up autopkgtest-satdep (0) ... 226s Processing triggers for rsyslog (8.2312.0-3ubuntu9) ... 226s Processing triggers for ufw (0.36.2-6) ... 226s Processing triggers for man-db (2.12.1-2) ... 228s Processing triggers for libc-bin (2.39-0ubuntu9) ... 230s (Reading database ... 75062 files and directories currently installed.) 230s Removing autopkgtest-satdep (0) ... 231s autopkgtest [03:05:38]: test smb-backup: [----------------------- 231s Populating share path 231s Adding samba share 231s Adding [public] share 231s Configuring backuppc 231s Performing a full backup 231s Backup type: type = full, needs_full = 1, needs_incr = 1, lastFullTime = 0, opts{f} = 1, opts{i} = , opts{F} = 231s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 231s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 231s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.010 231s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.0.z created 2024-06-22 03:05:38 231s Backup prep: type = full, case = 1, inPlace = 1, doDuplicate = 0, newBkupNum = 0, newBkupIdx = 0, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = ) 231s __bpc_progress_state__ backup share "public" 231s Running: /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -Tc - 231s full backup started for share public 231s started full dump, share=public 231s Xfer PIDs are now 4097,4096 231s xferPids 4097,4096 231s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -Tc - 231s tarmode is now full, system, hidden, noreset, noverbose 231s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 1 231s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 231s __bpc_progress_fileCnt__ 0 231s new 644 0/0 480434 tmp.hbNGcQ 231s new 644 0/0 480434 tmp.LwE1yD 232s new 644 0/0 480434 tmp.tlgbKy 232s new 644 0/0 480434 tmp.PPjgDa 232s new 644 0/0 480434 tmp.jlN99m 232s new 644 0/0 480434 tmp.raZkJC 232s new 644 0/0 480434 tmp.XRMhHh 232s new 644 0/0 480434 tmp.cV9F5t 232s new 644 0/0 480434 tmp.UuGgdU 232s tar: dumped 10 files and 0 directories 232s Total bytes written: 4804340 (26.1 MiB/s) 232s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 232s new 644 0/0 480434 tmp.bBUkCM 232s __bpc_progress_fileCnt__ 10 232s tarExtract: Done: 0 errors, 0 filesExist, 0 sizeExist, 0 sizeExistComp, 10 filesTotal, 4804340 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377768 sizeNewComp, 13 inodeLast 232s Xfer PIDs are now 232s xferPids 232s full backup 0 complete, 10 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 232s BackupExpire: cntFull = 1, cntIncr = 0, firstFull = 0, firstIncr = , oldestIncr = 0, oldestFull = 1.15740740740741e-05 232s __bpc_progress_state__ fsck 232s Running BackupPC_refCountUpdate -h localhost on localhost 232s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 232s Xfer PIDs are now 4103 232s xferPids 4103 232s BackupPC_refCountUpdate: doing fsck on localhost #0 (full) since $ConfRefCntFsck == 1 232s __bpc_progress_state__ refCnt #0 232s __bpc_progress_state__ cntUpdate #0 232s __bpc_progress_state__ rename #0 232s __bpc_progress_state__ sumUpdate 232s __bpc_progress_fileCnt__ 0/128 232s __bpc_progress_fileCnt__ 8/128 232s __bpc_progress_fileCnt__ 16/128 232s __bpc_progress_fileCnt__ 24/128 232s __bpc_progress_fileCnt__ 32/128 232s __bpc_progress_fileCnt__ 40/128 232s __bpc_progress_fileCnt__ 48/128 232s __bpc_progress_fileCnt__ 56/128 232s __bpc_progress_fileCnt__ 64/128 232s __bpc_progress_fileCnt__ 72/128 232s __bpc_progress_fileCnt__ 80/128 232s __bpc_progress_fileCnt__ 88/128 232s __bpc_progress_fileCnt__ 96/128 232s __bpc_progress_fileCnt__ 104/128 232s __bpc_progress_fileCnt__ 112/128 232s __bpc_progress_fileCnt__ 120/128 232s __bpc_progress_state__ rename total 232s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 232s Xfer PIDs are now 232s xferPids 232s Finished BackupPC_refCountUpdate (running time: 0 sec) 232s Xfer PIDs are now 232s xferPids 232s full backup complete 232s OK: Full backup succeeded 232s Changing share content and performing an incremental backup 232s Backup type: type = incr, needs_full = , needs_incr = , lastFullTime = 1719025538, opts{f} = , opts{i} = 1, opts{F} = 232s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 232s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 232s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.016 232s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.1.z created 2024-06-22 03:05:39 232s Backup prep: type = incr, case = 3, inPlace = 1, doDuplicate = 1, newBkupNum = 1, newBkupIdx = 1, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = ) 232s Executing /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 232s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 232s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDuplicate line 89. 232s (Did you mean "$Host\'s" instead?) 232s Xfer PIDs are now 4173 232s xferPids 4173 232s __bpc_progress_state__ copy #0 -> #1 232s Copying backup #0 to #1 232s __bpc_progress_fileCnt__ 3 dirs 232s Xfer PIDs are now 4173,4176 232s xferPids 4173,4176 232s __bpc_progress_state__ sumUpdate 232s __bpc_progress_fileCnt__ 0/128 232s __bpc_progress_fileCnt__ 8/128 232s __bpc_progress_fileCnt__ 16/128 232s __bpc_progress_fileCnt__ 24/128 232s __bpc_progress_fileCnt__ 32/128 232s __bpc_progress_fileCnt__ 40/128 232s __bpc_progress_fileCnt__ 48/128 232s __bpc_progress_fileCnt__ 56/128 232s __bpc_progress_fileCnt__ 64/128 232s __bpc_progress_fileCnt__ 72/128 232s __bpc_progress_fileCnt__ 80/128 232s __bpc_progress_fileCnt__ 88/128 232s __bpc_progress_fileCnt__ 96/128 232s __bpc_progress_fileCnt__ 104/128 232s __bpc_progress_fileCnt__ 112/128 232s __bpc_progress_fileCnt__ 120/128 232s __bpc_progress_state__ rename total 232s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 232s Xfer PIDs are now 4173 232s xferPids 4173 232s BackupPC_backupDuplicate: got 0 errors and 0 file open errors 232s Finished BackupPC_backupDuplicate (running time: 0 sec) 232s __bpc_progress_state__ backup share "public" 232s Running: /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 232s incr backup started back to 2024-06-22 02:05:38 (backup #0) for share public 232s started incr dump, share=public 232s Xfer PIDs are now 4180,4179 232s xferPids 4180,4179 232s 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 - 232s tar:1298 Getting files newer than Sat Jun 22 02:05:38 2024 232s 232s tarmode is now full, system, hidden, noreset, noverbose 232s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 232s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 232s __bpc_progress_fileCnt__ 0 232s new 644 0/0 480434 tmp.ptU6qb 232s same 644 0/0 480434 tmp.hbNGcQ 232s new 644 0/0 480434 tmp.Rn9HpN 232s new 644 0/0 480434 tmp.FWtLWh 232s same 644 0/0 480434 tmp.LwE1yD 232s new 644 0/0 480434 tmp.HbSdGU 232s same 644 0/0 480434 tmp.tlgbKy 232s same 644 0/0 480434 tmp.PPjgDa 232s new 644 0/0 480434 tmp.x2fvED 232s new 644 0/0 480434 tmp.RBk1Ir 232s new 644 0/0 480434 tmp.sz1iGU 232s same 644 0/0 480434 tmp.jlN99m 232s same 644 0/0 480434 tmp.raZkJC 232s new 644 0/0 480434 tmp.6bPfV0 232s same 644 0/0 480434 tmp.XRMhHh 232s same 644 0/0 480434 tmp.cV9F5t 232s new 644 0/0 480434 tmp.5Vh53f 232s same 644 0/0 480434 tmp.UuGgdU 232s same 644 0/0 480434 tmp.bBUkCM 232s tar: dumped 20 files and 0 directories 232s Total bytes written: 9608680 (40.4 MiB/s) 232s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 232s new 644 0/0 480434 tmp.aEvHMG 232s __bpc_progress_fileCnt__ 20 232s tarExtract: Done: 0 errors, 10 filesExist, 4804340 sizeExist, 1377768 sizeExistComp, 20 filesTotal, 9608680 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377799 sizeNewComp, 24 inodeLast 232s Xfer PIDs are now 232s xferPids 232s incr backup 1 complete, 20 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 232s BackupExpire: cntFull = 2, cntIncr = 0, firstFull = 0, firstIncr = , oldestIncr = 0, oldestFull = 1.15740740740741e-05 232s __bpc_progress_state__ fsck 232s Running BackupPC_refCountUpdate -h localhost on localhost 232s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 233s Xfer PIDs are now 4186 233s xferPids 4186 233s __bpc_progress_state__ cntUpdate #1 233s __bpc_progress_state__ rename #1 233s __bpc_progress_state__ sumUpdate 233s __bpc_progress_fileCnt__ 0/128 233s __bpc_progress_fileCnt__ 8/128 233s __bpc_progress_fileCnt__ 16/128 233s __bpc_progress_fileCnt__ 24/128 233s __bpc_progress_fileCnt__ 32/128 233s __bpc_progress_fileCnt__ 40/128 233s __bpc_progress_fileCnt__ 48/128 233s __bpc_progress_fileCnt__ 56/128 233s __bpc_progress_fileCnt__ 64/128 233s __bpc_progress_fileCnt__ 72/128 233s __bpc_progress_fileCnt__ 80/128 233s __bpc_progress_fileCnt__ 88/128 233s __bpc_progress_fileCnt__ 96/128 233s __bpc_progress_fileCnt__ 104/128 233s __bpc_progress_fileCnt__ 112/128 233s __bpc_progress_fileCnt__ 120/128 233s __bpc_progress_state__ rename total 233s BackupPC_refCountUpdate: host localhost got 0 errors (took 1 secs) 233s Xfer PIDs are now 233s xferPids 233s Finished BackupPC_refCountUpdate (running time: 1 sec) 233s Xfer PIDs are now 233s xferPids 233s incr backup complete 233s OK: Incremental backup succeeded 233s Done. 233s autopkgtest [03:05:40]: test smb-backup: -----------------------] 233s smb-backup PASS 233s autopkgtest [03:05:40]: test smb-backup: - - - - - - - - - - results - - - - - - - - - - 234s autopkgtest [03:05:41]: test authenticated-smb-backup: preparing testbed 235s Reading package lists... 235s Building dependency tree... 235s Reading state information... 235s Starting pkgProblemResolver with broken count: 0 235s Starting 2 pkgProblemResolver with broken count: 0 235s Done 235s The following NEW packages will be installed: 235s autopkgtest-satdep 235s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 235s Need to get 0 B/724 B of archives. 235s After this operation, 0 B of additional disk space will be used. 235s Get:1 /tmp/autopkgtest.k8m5Ts/2-autopkgtest-satdep.deb autopkgtest-satdep ppc64el 0 [724 B] 236s Selecting previously unselected package autopkgtest-satdep. 236s (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 ... 75063 files and directories currently installed.) 236s Preparing to unpack .../2-autopkgtest-satdep.deb ... 236s Unpacking autopkgtest-satdep (0) ... 236s Setting up autopkgtest-satdep (0) ... 237s (Reading database ... 75062 files and directories currently installed.) 237s Removing autopkgtest-satdep (0) ... 238s autopkgtest [03:05:45]: test authenticated-smb-backup: [----------------------- 238s Populating share path 238s Adding samba share 238s Adding [private] share 238s Creating user 238s Creating a local and samba user called smbtest4437 238s Setting samba password for the smbtest4437 user 238s Added user smbtest4437. 238s Configuring backuppc 238s Performing a full backup 238s Backup type: type = full, needs_full = , needs_incr = , lastFullTime = 1719025538, opts{f} = 1, opts{i} = , opts{F} = 238s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 238s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 238s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.012 238s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.2.z created 2024-06-22 03:05:45 238s Backup prep: type = full, case = 4, inPlace = 0, doDuplicate = 0, newBkupNum = 2, newBkupIdx = 2, lastBkupNum = 1, lastBkupIdx = 1 (FillCycle = 0, noFillCnt = 0) 238s __bpc_progress_state__ backup share "private" 238s Running: /usr/bin/smbclient \\\\localhost\\private -U smbtest4437 -E -d 1 -c tarmode\ full -mSMB3 -Tc - 238s full backup started for share private 238s started full dump, share=private 238s Xfer PIDs are now 4531,4530 238s xferPids 4531,4530 238s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\private -U smbtest4437 -E -d 1 -c tarmode\ full -mSMB3 -Tc - 239s tarmode is now full, system, hidden, noreset, noverbose 239s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 1 239s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 239s __bpc_progress_fileCnt__ 0 239s new 644 0/0 480434 tmp.fxQUdp 239s new 644 0/0 480434 tmp.3DaTN4 239s new 644 0/0 480434 tmp.bZqCl7 239s new 644 0/0 480434 tmp.ZoE4jt 239s new 644 0/0 480434 tmp.uSfMD8 239s new 644 0/0 480434 tmp.VX7CNY 239s new 644 0/0 480434 tmp.UBVJN2 239s new 644 0/0 480434 tmp.sdlnKH 239s new 644 0/0 480434 tmp.ydG3Ev 239s tar: dumped 10 files and 0 directories 239s Total bytes written: 4804340 (26.7 MiB/s) 239s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 239s new 644 0/0 480434 tmp.TuHySe 239s __bpc_progress_fileCnt__ 10 239s tarExtract: Done: 0 errors, 0 filesExist, 0 sizeExist, 0 sizeExistComp, 10 filesTotal, 4804340 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377765 sizeNewComp, 36 inodeLast 239s Xfer PIDs are now 239s xferPids 239s OrphanShareNameClean: removing orphan share public from /var/lib/backuppc/pc/localhost/2 239s __bpc_progress_state__ delete share #2/public 239s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDelete -h localhost -n 2 -l -m -s public / 239s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDelete line 102. 239s (Did you mean "$Host\'s" instead?) 239s Xfer PIDs are now 4537 239s xferPids 4537 239s BackupPC_backupDelete: removing #2/public/ 239s __bpc_progress_state__ merge #2/public/ -> #1/public/ 239s BackupPC_backupDelete: Merge into backup 1/public/ 239s mergeDir: attr write to /var/lib/backuppc/pc/localhost/1/fpublic//attrib failed (digest was ) 239s bpc_attrib_dirWrite: can't open/create raw /var/lib/backuppc/pc/localhost/1/fpublic for writing 239s Xfer PIDs are now 4537,4540 239s xferPids 4537,4540 239s __bpc_progress_state__ refCnt #1 239s __bpc_progress_state__ cntUpdate #1 239s __bpc_progress_state__ rename #1 239s __bpc_progress_state__ refCnt #2 239s BackupPC_refCountUpdate: localhost #2 inodeLast set to 37 (was 24) 239s __bpc_progress_state__ cntUpdate #2 239s __bpc_progress_state__ rename #2 239s __bpc_progress_state__ sumUpdate 239s __bpc_progress_fileCnt__ 0/128 239s __bpc_progress_fileCnt__ 8/128 239s __bpc_progress_fileCnt__ 16/128 239s __bpc_progress_fileCnt__ 24/128 239s __bpc_progress_fileCnt__ 32/128 239s __bpc_progress_fileCnt__ 40/128 239s __bpc_progress_fileCnt__ 48/128 239s __bpc_progress_fileCnt__ 56/128 239s __bpc_progress_fileCnt__ 64/128 239s __bpc_progress_fileCnt__ 72/128 239s __bpc_progress_fileCnt__ 80/128 239s __bpc_progress_fileCnt__ 88/128 239s __bpc_progress_fileCnt__ 96/128 239s __bpc_progress_fileCnt__ 104/128 239s __bpc_progress_fileCnt__ 112/128 239s __bpc_progress_fileCnt__ 120/128 239s __bpc_progress_state__ rename total 239s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 239s Xfer PIDs are now 4537 239s xferPids 4537 239s Xfer PIDs are now 239s xferPids 239s Finished BackupPC_backupDelete, status = 0 (running time: 0 sec) 239s Xfer PIDs are now 239s xferPids 239s full backup 2 complete, 10 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 239s BackupExpire: cntFull = 2, cntIncr = 1, firstFull = 0, firstIncr = 1, oldestIncr = 8.10185185185185e-05, oldestFull = 9.25925925925926e-05 239s __bpc_progress_state__ fsck 239s Running BackupPC_refCountUpdate -h localhost on localhost 239s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 239s Xfer PIDs are now 4543 239s xferPids 4543 239s BackupPC_refCountUpdate: doing fsck on localhost #2 (full) since $ConfRefCntFsck == 1 239s __bpc_progress_state__ refCnt #2 239s __bpc_progress_state__ cntUpdate #2 239s __bpc_progress_state__ rename #2 239s __bpc_progress_state__ sumUpdate 239s __bpc_progress_fileCnt__ 0/128 239s __bpc_progress_fileCnt__ 8/128 239s __bpc_progress_fileCnt__ 16/128 239s __bpc_progress_fileCnt__ 24/128 239s __bpc_progress_fileCnt__ 32/128 239s __bpc_progress_fileCnt__ 40/128 239s __bpc_progress_fileCnt__ 48/128 239s __bpc_progress_fileCnt__ 56/128 239s __bpc_progress_fileCnt__ 64/128 239s __bpc_progress_fileCnt__ 72/128 239s __bpc_progress_fileCnt__ 80/128 239s __bpc_progress_fileCnt__ 88/128 239s __bpc_progress_fileCnt__ 96/128 239s __bpc_progress_fileCnt__ 104/128 239s __bpc_progress_fileCnt__ 112/128 239s __bpc_progress_fileCnt__ 120/128 239s __bpc_progress_state__ rename total 239s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 239s Xfer PIDs are now 239s xferPids 239s Finished BackupPC_refCountUpdate (running time: 0 sec) 239s Xfer PIDs are now 239s xferPids 239s full backup complete 239s OK: Full backup succeeded 239s Changing share content and performing an incremental backup 239s Backup type: type = incr, needs_full = , needs_incr = , lastFullTime = 1719025545, opts{f} = , opts{i} = 1, opts{F} = 239s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 239s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 239s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.012 239s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.3.z created 2024-06-22 03:05:46 239s Backup prep: type = incr, case = 3, inPlace = 1, doDuplicate = 1, newBkupNum = 3, newBkupIdx = 3, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = 1) 239s Executing /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 239s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 239s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDuplicate line 89. 239s (Did you mean "$Host\'s" instead?) 239s Xfer PIDs are now 4613 239s xferPids 4613 239s __bpc_progress_state__ copy #2 -> #3 239s Copying backup #2 to #3 239s __bpc_progress_fileCnt__ 3 dirs 239s Xfer PIDs are now 4613,4616 239s xferPids 4613,4616 239s __bpc_progress_state__ sumUpdate 239s __bpc_progress_fileCnt__ 0/128 239s __bpc_progress_fileCnt__ 8/128 239s __bpc_progress_fileCnt__ 16/128 239s __bpc_progress_fileCnt__ 24/128 239s __bpc_progress_fileCnt__ 32/128 239s __bpc_progress_fileCnt__ 40/128 239s __bpc_progress_fileCnt__ 48/128 239s __bpc_progress_fileCnt__ 56/128 239s __bpc_progress_fileCnt__ 64/128 239s __bpc_progress_fileCnt__ 72/128 239s __bpc_progress_fileCnt__ 80/128 239s __bpc_progress_fileCnt__ 88/128 239s __bpc_progress_fileCnt__ 96/128 239s __bpc_progress_fileCnt__ 104/128 239s __bpc_progress_fileCnt__ 112/128 239s __bpc_progress_fileCnt__ 120/128 239s __bpc_progress_state__ rename total 239s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 239s Xfer PIDs are now 4613 239s xferPids 4613 239s BackupPC_backupDuplicate: got 0 errors and 0 file open errors 239s Finished BackupPC_backupDuplicate (running time: 0 sec) 239s __bpc_progress_state__ backup share "private" 239s Running: /usr/bin/smbclient \\\\localhost\\private -U smbtest4437 -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 239s incr backup started back to 2024-06-22 02:05:45 (backup #2) for share private 239s started incr dump, share=private 239s Xfer PIDs are now 4620,4619 239s xferPids 4620,4619 239s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\private -U smbtest4437 -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 240s tar:1298 Getting files newer than Sat Jun 22 02:05:45 2024 240s 240s tarmode is now full, system, hidden, noreset, noverbose 240s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 240s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 240s __bpc_progress_fileCnt__ 0 240s new 644 0/0 480434 tmp.MbDJEO 240s same 644 0/0 480434 tmp.fxQUdp 240s same 644 0/0 480434 tmp.3DaTN4 240s new 644 0/0 480434 tmp.UGXZSA 240s same 644 0/0 480434 tmp.bZqCl7 240s new 644 0/0 480434 tmp.dB8gcZ 240s new 644 0/0 480434 tmp.e408Lu 240s new 644 0/0 480434 tmp.AcyKNG 240s same 644 0/0 480434 tmp.ZoE4jt 240s same 644 0/0 480434 tmp.uSfMD8 240s new 644 0/0 480434 tmp.g3FGaf 240s same 644 0/0 480434 tmp.VX7CNY 240s new 644 0/0 480434 tmp.vUBtCL 240s new 644 0/0 480434 tmp.FKzIc7 240s same 644 0/0 480434 tmp.UBVJN2 240s same 644 0/0 480434 tmp.sdlnKH 240s same 644 0/0 480434 tmp.ydG3Ev 240s same 644 0/0 480434 tmp.TuHySe 240s new 644 0/0 480434 tmp.juJE1R 240s tar: dumped 20 files and 0 directories 240s Total bytes written: 9608680 (40.7 MiB/s) 240s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 240s new 644 0/0 480434 tmp.e1fZ28 240s __bpc_progress_fileCnt__ 20 240s tarExtract: Done: 0 errors, 10 filesExist, 4804340 sizeExist, 1377765 sizeExistComp, 20 filesTotal, 9608680 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377747 sizeNewComp, 47 inodeLast 240s Xfer PIDs are now 240s xferPids 240s incr backup 3 complete, 20 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 240s BackupExpire: cntFull = 3, cntIncr = 1, firstFull = 0, firstIncr = 1, oldestIncr = 9.25925925925926e-05, oldestFull = 0.000104166666666667 240s __bpc_progress_state__ fsck 240s Running BackupPC_refCountUpdate -h localhost on localhost 240s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 240s Xfer PIDs are now 4626 240s xferPids 4626 240s __bpc_progress_state__ cntUpdate #3 240s __bpc_progress_state__ rename #3 240s __bpc_progress_state__ sumUpdate 240s __bpc_progress_fileCnt__ 0/128 240s __bpc_progress_fileCnt__ 8/128 240s __bpc_progress_fileCnt__ 16/128 240s __bpc_progress_fileCnt__ 24/128 240s __bpc_progress_fileCnt__ 32/128 240s __bpc_progress_fileCnt__ 40/128 240s __bpc_progress_fileCnt__ 48/128 240s __bpc_progress_fileCnt__ 56/128 240s __bpc_progress_fileCnt__ 64/128 240s __bpc_progress_fileCnt__ 72/128 240s __bpc_progress_fileCnt__ 80/128 240s __bpc_progress_fileCnt__ 88/128 240s __bpc_progress_fileCnt__ 96/128 240s __bpc_progress_fileCnt__ 104/128 240s __bpc_progress_fileCnt__ 112/128 240s __bpc_progress_fileCnt__ 120/128 240s __bpc_progress_state__ rename total 240s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 240s Xfer PIDs are now 240s xferPids 240s Finished BackupPC_refCountUpdate (running time: 0 sec) 240s Xfer PIDs are now 240s xferPids 240s incr backup complete 240s OK: Incremental backup succeeded 240s Done. 240s Deleted user smbtest4437. 240s userdel: smbtest4437 mail spool (/var/mail/smbtest4437) not found 240s autopkgtest [03:05:47]: test authenticated-smb-backup: -----------------------] 241s authenticated-smb-backup PASS 241s autopkgtest [03:05:48]: test authenticated-smb-backup: - - - - - - - - - - results - - - - - - - - - - 241s autopkgtest [03:05:48]: @@@@@@@@@@@@@@@@@@@@ summary 241s smb-backup PASS 241s authenticated-smb-backup PASS 252s nova [W] Using flock in scalingstack-bos02-ppc64el 252s Creating nova instance adt-oracular-ppc64el-backuppc-20240622-030147-juju-7f2275-prod-proposed-migration-environment-3-e265c729-c96e-40ac-9cc9-7a4bde6d1a8e from image adt/ubuntu-oracular-ppc64el-server-20240621.img (UUID 4681197e-fe3b-454f-a1a1-4444fa30a8a8)...