0s autopkgtest [02:05:40]: starting date and time: 2024-05-04 02:05:40+0000 0s autopkgtest [02:05:40]: git checkout: 699e7f9f ssh-setup/nova: explicitely set 'fqdn' in cloud-init 0s autopkgtest [02:05:40]: host juju-7f2275-prod-proposed-migration-environment-3; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.j93wjp5_/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:mini-httpd --apt-upgrade backuppc --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=mini-httpd/1.30-10 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-3@bos02-arm64-9.secgroup --name adt-oracular-arm64-backuppc-20240504-020540-juju-7f2275-prod-proposed-migration-environment-3-ca84d5d3-ca13-4a74-b78a-bff81e4f0695 --image adt/ubuntu-oracular-arm64-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/ 112s autopkgtest [02:07:32]: testbed dpkg architecture: arm64 113s autopkgtest [02:07:33]: testbed apt version: 2.7.14build2 113s autopkgtest [02:07:33]: @@@@@@@@@@@@@@@@@@@@ test bed setup 114s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [64.7 kB] 115s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [2042 kB] 115s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [2800 B] 115s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [159 kB] 115s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [36.2 kB] 115s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 Packages [227 kB] 115s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/restricted arm64 Packages [13.1 kB] 115s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/universe arm64 Packages [1459 kB] 115s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse arm64 Packages [28.3 kB] 116s Fetched 4032 kB in 2s (1741 kB/s) 117s Reading package lists... 123s Reading package lists... 124s Building dependency tree... 124s Reading state information... 126s Calculating upgrade... 127s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 127s Reading package lists... 128s Building dependency tree... 128s Reading state information... 130s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 131s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 131s Hit:2 http://ftpmaster.internal/ubuntu oracular InRelease 131s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease 131s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease 135s Reading package lists... 135s Reading package lists... 136s Building dependency tree... 136s Reading state information... 137s Calculating upgrade... 138s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 139s Reading package lists... 139s Building dependency tree... 139s Reading state information... 142s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 146s autopkgtest [02:08:06]: testbed running kernel: Linux 6.8.0-31-generic #31-Ubuntu SMP PREEMPT_DYNAMIC Sat Apr 20 02:32:42 UTC 2024 147s autopkgtest [02:08:07]: @@@@@@@@@@@@@@@@@@@@ apt-source backuppc 150s Get:1 http://ftpmaster.internal/ubuntu oracular/main backuppc 4.4.0-8build1 (dsc) [2289 B] 150s Get:2 http://ftpmaster.internal/ubuntu oracular/main backuppc 4.4.0-8build1 (tar) [657 kB] 150s Get:3 http://ftpmaster.internal/ubuntu oracular/main backuppc 4.4.0-8build1 (diff) [61.1 kB] 150s gpgv: Signature made Mon Apr 8 15:54:41 2024 UTC 150s gpgv: using RSA key 4FB588A84C2DDE79A74C77876FA458DD1DB03F71 150s gpgv: issuer "juliank@ubuntu.com" 150s gpgv: Can't check signature: No public key 150s dpkg-source: warning: cannot verify inline signature for ./backuppc_4.4.0-8build1.dsc: no acceptable signature found 151s autopkgtest [02:08:11]: testing package backuppc version 4.4.0-8build1 151s autopkgtest [02:08:11]: build not needed 152s autopkgtest [02:08:12]: test smb-backup: preparing testbed 154s Reading package lists... 155s Building dependency tree... 155s Reading state information... 156s Starting pkgProblemResolver with broken count: 0 156s Starting 2 pkgProblemResolver with broken count: 0 156s Done 158s The following additional packages will be installed: 158s apache2 apache2-bin apache2-data apache2-utils backuppc backuppc-rsync 158s libapr1t64 libaprutil1-dbd-sqlite3 libaprutil1-ldap libaprutil1t64 158s libarchive-zip-perl libavahi-client3 libavahi-common-data libavahi-common3 158s libbackuppc-xs-perl libcgi-pm-perl libcups2t64 libfile-listing-perl 158s libhtml-parser-perl libhtml-tagset-perl libhttp-date-perl libldb2 158s liblua5.4-0 libnsl2 libpython3.12t64 libsmbclient0 libtalloc2 libtdb1 158s libtevent0t64 libtime-parsedate-perl libtimedate-perl liburi-perl 158s libwbclient0 postfix python3-dnspython python3-ldb python3-markdown 158s python3-samba python3-talloc python3-tdb samba samba-common samba-common-bin 158s samba-libs smbclient ssl-cert tdb-tools 158s Suggested packages: 158s apache2-doc apache2-suexec-pristine | apache2-suexec-custom www-browser 158s certbot | acme-tiny | acmetool | dehydrated | lacme | lecm | lego 158s libscgi-perl par2 w3m | www-browser cups-common libdata-dump-perl 158s libbusiness-isbn-perl libregexp-ipv6-perl libwww-perl mail-reader 158s postfix-cdb postfix-doc postfix-ldap postfix-lmdb postfix-mta-sts-resolver 158s postfix-mysql postfix-pcre postfix-pgsql postfix-sqlite procmail sasl2-bin 158s | dovecot-common python3-trio python3-aioquic python3-h2 python3-httpx 158s python3-httpcore python-markdown-doc bind9 bind9utils ctdb ldb-tools ntp 158s | chrony winbind heimdal-clients cifs-utils 158s Recommended packages: 158s libio-dirent-perl rrdtool libcgi-fast-perl libhttp-message-perl python3-gpg 158s attr samba-dsdb-modules samba-vfs-modules samba-ad-provision 158s The following NEW packages will be installed: 158s apache2 apache2-bin apache2-data apache2-utils autopkgtest-satdep backuppc 158s backuppc-rsync libapr1t64 libaprutil1-dbd-sqlite3 libaprutil1-ldap 158s libaprutil1t64 libarchive-zip-perl libavahi-client3 libavahi-common-data 158s libavahi-common3 libbackuppc-xs-perl libcgi-pm-perl libcups2t64 158s libfile-listing-perl libhtml-parser-perl libhtml-tagset-perl 158s libhttp-date-perl libldb2 liblua5.4-0 libnsl2 libpython3.12t64 libsmbclient0 158s libtalloc2 libtdb1 libtevent0t64 libtime-parsedate-perl libtimedate-perl 158s liburi-perl libwbclient0 postfix python3-dnspython python3-ldb 158s python3-markdown python3-samba python3-talloc python3-tdb samba samba-common 158s samba-common-bin samba-libs smbclient ssl-cert tdb-tools 159s 0 upgraded, 48 newly installed, 0 to remove and 0 not upgraded. 159s Need to get 19.8 MB/19.8 MB of archives. 159s After this operation, 106 MB of additional disk space will be used. 159s Get:1 /tmp/autopkgtest.ZPZp0F/1-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [724 B] 159s Get:2 http://ftpmaster.internal/ubuntu oracular/main arm64 libapr1t64 arm64 1.7.2-3.1build2 [105 kB] 159s Get:3 http://ftpmaster.internal/ubuntu oracular/main arm64 libaprutil1t64 arm64 1.6.3-1.1ubuntu7 [93.9 kB] 159s Get:4 http://ftpmaster.internal/ubuntu oracular/main arm64 libaprutil1-dbd-sqlite3 arm64 1.6.3-1.1ubuntu7 [11.2 kB] 159s Get:5 http://ftpmaster.internal/ubuntu oracular/main arm64 libaprutil1-ldap arm64 1.6.3-1.1ubuntu7 [9046 B] 159s Get:6 http://ftpmaster.internal/ubuntu oracular/main arm64 liblua5.4-0 arm64 5.4.6-3build2 [158 kB] 159s Get:7 http://ftpmaster.internal/ubuntu oracular/main arm64 apache2-bin arm64 2.4.58-1ubuntu8 [1316 kB] 159s Get:8 http://ftpmaster.internal/ubuntu oracular/main arm64 apache2-data all 2.4.58-1ubuntu8 [163 kB] 159s Get:9 http://ftpmaster.internal/ubuntu oracular/main arm64 apache2-utils arm64 2.4.58-1ubuntu8 [95.2 kB] 159s Get:10 http://ftpmaster.internal/ubuntu oracular/main arm64 apache2 arm64 2.4.58-1ubuntu8 [90.2 kB] 159s Get:11 http://ftpmaster.internal/ubuntu oracular/main arm64 backuppc-rsync arm64 3.1.3.0-3ubuntu1 [248 kB] 159s Get:12 http://ftpmaster.internal/ubuntu oracular/main arm64 ssl-cert all 1.1.2ubuntu1 [17.8 kB] 159s Get:13 http://ftpmaster.internal/ubuntu oracular/main arm64 libnsl2 arm64 1.3.0-3build3 [41.6 kB] 159s Get:14 http://ftpmaster.internal/ubuntu oracular/main arm64 postfix arm64 3.8.6-1build2 [1251 kB] 159s Get:15 http://ftpmaster.internal/ubuntu oracular/main arm64 libarchive-zip-perl all 1.68-1 [90.2 kB] 160s Get:16 http://ftpmaster.internal/ubuntu oracular/main arm64 libbackuppc-xs-perl arm64 0.62-2build5 [65.1 kB] 160s Get:17 http://ftpmaster.internal/ubuntu oracular/main arm64 libhtml-tagset-perl all 3.20-6 [11.3 kB] 160s Get:18 http://ftpmaster.internal/ubuntu oracular/main arm64 liburi-perl all 5.27-1 [88.0 kB] 160s Get:19 http://ftpmaster.internal/ubuntu oracular/main arm64 libhtml-parser-perl arm64 3.81-1build3 [85.0 kB] 160s Get:20 http://ftpmaster.internal/ubuntu oracular/main arm64 libcgi-pm-perl all 4.63-1 [185 kB] 160s Get:21 http://ftpmaster.internal/ubuntu oracular/main arm64 libtimedate-perl all 2.3300-2 [34.0 kB] 160s Get:22 http://ftpmaster.internal/ubuntu oracular/main arm64 libhttp-date-perl all 6.06-1 [10.2 kB] 160s Get:23 http://ftpmaster.internal/ubuntu oracular/main arm64 libfile-listing-perl all 6.16-1 [11.3 kB] 160s Get:24 http://ftpmaster.internal/ubuntu oracular/main arm64 libtime-parsedate-perl all 2015.103-4 [28.6 kB] 160s Get:25 http://ftpmaster.internal/ubuntu oracular/main arm64 backuppc arm64 4.4.0-8build1 [541 kB] 160s Get:26 http://ftpmaster.internal/ubuntu oracular/main arm64 python3-dnspython all 2.6.1-1ubuntu1 [163 kB] 160s Get:27 http://ftpmaster.internal/ubuntu oracular/main arm64 libtalloc2 arm64 2.4.2-1build2 [26.7 kB] 160s Get:28 http://ftpmaster.internal/ubuntu oracular/main arm64 libtdb1 arm64 1.4.10-1build1 [48.5 kB] 160s Get:29 http://ftpmaster.internal/ubuntu oracular/main arm64 libtevent0t64 arm64 0.16.1-2build1 [42.3 kB] 160s Get:30 http://ftpmaster.internal/ubuntu oracular/main arm64 libldb2 arm64 2:2.8.0+samba4.19.5+dfsg-4ubuntu9 [188 kB] 160s Get:31 http://ftpmaster.internal/ubuntu oracular/main arm64 libpython3.12t64 arm64 3.12.3-1 [2278 kB] 160s Get:32 http://ftpmaster.internal/ubuntu oracular/main arm64 python3-ldb arm64 2:2.8.0+samba4.19.5+dfsg-4ubuntu9 [42.4 kB] 160s Get:33 http://ftpmaster.internal/ubuntu oracular/main arm64 python3-tdb arm64 1.4.10-1build1 [15.1 kB] 160s Get:34 http://ftpmaster.internal/ubuntu oracular/main arm64 python3-markdown all 3.5.2-1 [72.0 kB] 160s Get:35 http://ftpmaster.internal/ubuntu oracular/main arm64 libavahi-common-data arm64 0.8-13ubuntu6 [29.6 kB] 160s Get:36 http://ftpmaster.internal/ubuntu oracular/main arm64 libavahi-common3 arm64 0.8-13ubuntu6 [23.3 kB] 160s Get:37 http://ftpmaster.internal/ubuntu oracular/main arm64 libavahi-client3 arm64 0.8-13ubuntu6 [27.2 kB] 160s Get:38 http://ftpmaster.internal/ubuntu oracular/main arm64 libwbclient0 arm64 2:4.19.5+dfsg-4ubuntu9 [71.4 kB] 160s Get:39 http://ftpmaster.internal/ubuntu oracular/main arm64 samba-libs arm64 2:4.19.5+dfsg-4ubuntu9 [6061 kB] 160s Get:40 http://ftpmaster.internal/ubuntu oracular/main arm64 python3-talloc arm64 2.4.2-1build2 [12.9 kB] 160s Get:41 http://ftpmaster.internal/ubuntu oracular/main arm64 python3-samba arm64 2:4.19.5+dfsg-4ubuntu9 [2804 kB] 160s Get:42 http://ftpmaster.internal/ubuntu oracular/main arm64 samba-common all 2:4.19.5+dfsg-4ubuntu9 [64.1 kB] 160s Get:43 http://ftpmaster.internal/ubuntu oracular/main arm64 libcups2t64 arm64 2.4.7-1.2ubuntu7 [273 kB] 160s Get:44 http://ftpmaster.internal/ubuntu oracular/main arm64 samba-common-bin arm64 2:4.19.5+dfsg-4ubuntu9 [1269 kB] 160s Get:45 http://ftpmaster.internal/ubuntu oracular/main arm64 tdb-tools arm64 1.4.10-1build1 [25.9 kB] 161s Get:46 http://ftpmaster.internal/ubuntu oracular/main arm64 samba arm64 2:4.19.5+dfsg-4ubuntu9 [1000 kB] 161s Get:47 http://ftpmaster.internal/ubuntu oracular/main arm64 libsmbclient0 arm64 2:4.19.5+dfsg-4ubuntu9 [62.1 kB] 161s Get:48 http://ftpmaster.internal/ubuntu oracular/main arm64 smbclient arm64 2:4.19.5+dfsg-4ubuntu9 [488 kB] 162s Preconfiguring packages ... 163s Fetched 19.8 MB in 2s (9777 kB/s) 163s Selecting previously unselected package libapr1t64:arm64. 163s (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 ... 77894 files and directories currently installed.) 163s Preparing to unpack .../00-libapr1t64_1.7.2-3.1build2_arm64.deb ... 163s Unpacking libapr1t64:arm64 (1.7.2-3.1build2) ... 163s Selecting previously unselected package libaprutil1t64:arm64. 163s Preparing to unpack .../01-libaprutil1t64_1.6.3-1.1ubuntu7_arm64.deb ... 163s Unpacking libaprutil1t64:arm64 (1.6.3-1.1ubuntu7) ... 163s Selecting previously unselected package libaprutil1-dbd-sqlite3:arm64. 163s Preparing to unpack .../02-libaprutil1-dbd-sqlite3_1.6.3-1.1ubuntu7_arm64.deb ... 163s Unpacking libaprutil1-dbd-sqlite3:arm64 (1.6.3-1.1ubuntu7) ... 163s Selecting previously unselected package libaprutil1-ldap:arm64. 163s Preparing to unpack .../03-libaprutil1-ldap_1.6.3-1.1ubuntu7_arm64.deb ... 163s Unpacking libaprutil1-ldap:arm64 (1.6.3-1.1ubuntu7) ... 164s Selecting previously unselected package liblua5.4-0:arm64. 164s Preparing to unpack .../04-liblua5.4-0_5.4.6-3build2_arm64.deb ... 164s Unpacking liblua5.4-0:arm64 (5.4.6-3build2) ... 164s Selecting previously unselected package apache2-bin. 164s Preparing to unpack .../05-apache2-bin_2.4.58-1ubuntu8_arm64.deb ... 164s Unpacking apache2-bin (2.4.58-1ubuntu8) ... 164s Selecting previously unselected package apache2-data. 164s Preparing to unpack .../06-apache2-data_2.4.58-1ubuntu8_all.deb ... 164s Unpacking apache2-data (2.4.58-1ubuntu8) ... 164s Selecting previously unselected package apache2-utils. 164s Preparing to unpack .../07-apache2-utils_2.4.58-1ubuntu8_arm64.deb ... 164s Unpacking apache2-utils (2.4.58-1ubuntu8) ... 164s Selecting previously unselected package apache2. 164s Preparing to unpack .../08-apache2_2.4.58-1ubuntu8_arm64.deb ... 164s Unpacking apache2 (2.4.58-1ubuntu8) ... 164s Selecting previously unselected package backuppc-rsync. 164s Preparing to unpack .../09-backuppc-rsync_3.1.3.0-3ubuntu1_arm64.deb ... 164s Unpacking backuppc-rsync (3.1.3.0-3ubuntu1) ... 165s Selecting previously unselected package ssl-cert. 165s Preparing to unpack .../10-ssl-cert_1.1.2ubuntu1_all.deb ... 165s Unpacking ssl-cert (1.1.2ubuntu1) ... 165s Selecting previously unselected package libnsl2:arm64. 165s Preparing to unpack .../11-libnsl2_1.3.0-3build3_arm64.deb ... 165s Unpacking libnsl2:arm64 (1.3.0-3build3) ... 165s Selecting previously unselected package postfix. 165s Preparing to unpack .../12-postfix_3.8.6-1build2_arm64.deb ... 165s Unpacking postfix (3.8.6-1build2) ... 166s Selecting previously unselected package libarchive-zip-perl. 166s Preparing to unpack .../13-libarchive-zip-perl_1.68-1_all.deb ... 166s Unpacking libarchive-zip-perl (1.68-1) ... 166s Selecting previously unselected package libbackuppc-xs-perl:arm64. 166s Preparing to unpack .../14-libbackuppc-xs-perl_0.62-2build5_arm64.deb ... 166s Unpacking libbackuppc-xs-perl:arm64 (0.62-2build5) ... 166s Selecting previously unselected package libhtml-tagset-perl. 166s Preparing to unpack .../15-libhtml-tagset-perl_3.20-6_all.deb ... 166s Unpacking libhtml-tagset-perl (3.20-6) ... 166s Selecting previously unselected package liburi-perl. 166s Preparing to unpack .../16-liburi-perl_5.27-1_all.deb ... 166s Unpacking liburi-perl (5.27-1) ... 166s Selecting previously unselected package libhtml-parser-perl:arm64. 166s Preparing to unpack .../17-libhtml-parser-perl_3.81-1build3_arm64.deb ... 166s Unpacking libhtml-parser-perl:arm64 (3.81-1build3) ... 167s Selecting previously unselected package libcgi-pm-perl. 167s Preparing to unpack .../18-libcgi-pm-perl_4.63-1_all.deb ... 167s Unpacking libcgi-pm-perl (4.63-1) ... 167s Selecting previously unselected package libtimedate-perl. 167s Preparing to unpack .../19-libtimedate-perl_2.3300-2_all.deb ... 167s Unpacking libtimedate-perl (2.3300-2) ... 167s Selecting previously unselected package libhttp-date-perl. 167s Preparing to unpack .../20-libhttp-date-perl_6.06-1_all.deb ... 167s Unpacking libhttp-date-perl (6.06-1) ... 167s Selecting previously unselected package libfile-listing-perl. 167s Preparing to unpack .../21-libfile-listing-perl_6.16-1_all.deb ... 167s Unpacking libfile-listing-perl (6.16-1) ... 167s Selecting previously unselected package libtime-parsedate-perl. 167s Preparing to unpack .../22-libtime-parsedate-perl_2015.103-4_all.deb ... 167s Unpacking libtime-parsedate-perl (2015.103-4) ... 167s Selecting previously unselected package backuppc. 167s Preparing to unpack .../23-backuppc_4.4.0-8build1_arm64.deb ... 167s Unpacking backuppc (4.4.0-8build1) ... 168s Selecting previously unselected package python3-dnspython. 168s Preparing to unpack .../24-python3-dnspython_2.6.1-1ubuntu1_all.deb ... 168s Unpacking python3-dnspython (2.6.1-1ubuntu1) ... 168s Selecting previously unselected package libtalloc2:arm64. 168s Preparing to unpack .../25-libtalloc2_2.4.2-1build2_arm64.deb ... 168s Unpacking libtalloc2:arm64 (2.4.2-1build2) ... 168s Selecting previously unselected package libtdb1:arm64. 168s Preparing to unpack .../26-libtdb1_1.4.10-1build1_arm64.deb ... 168s Unpacking libtdb1:arm64 (1.4.10-1build1) ... 168s Selecting previously unselected package libtevent0t64:arm64. 168s Preparing to unpack .../27-libtevent0t64_0.16.1-2build1_arm64.deb ... 168s Unpacking libtevent0t64:arm64 (0.16.1-2build1) ... 168s Selecting previously unselected package libldb2:arm64. 168s Preparing to unpack .../28-libldb2_2%3a2.8.0+samba4.19.5+dfsg-4ubuntu9_arm64.deb ... 168s Unpacking libldb2:arm64 (2:2.8.0+samba4.19.5+dfsg-4ubuntu9) ... 168s Selecting previously unselected package libpython3.12t64:arm64. 168s Preparing to unpack .../29-libpython3.12t64_3.12.3-1_arm64.deb ... 168s Unpacking libpython3.12t64:arm64 (3.12.3-1) ... 169s Selecting previously unselected package python3-ldb. 169s Preparing to unpack .../30-python3-ldb_2%3a2.8.0+samba4.19.5+dfsg-4ubuntu9_arm64.deb ... 169s Unpacking python3-ldb (2:2.8.0+samba4.19.5+dfsg-4ubuntu9) ... 169s Selecting previously unselected package python3-tdb. 169s Preparing to unpack .../31-python3-tdb_1.4.10-1build1_arm64.deb ... 169s Unpacking python3-tdb (1.4.10-1build1) ... 169s Selecting previously unselected package python3-markdown. 169s Preparing to unpack .../32-python3-markdown_3.5.2-1_all.deb ... 169s Unpacking python3-markdown (3.5.2-1) ... 169s Selecting previously unselected package libavahi-common-data:arm64. 169s Preparing to unpack .../33-libavahi-common-data_0.8-13ubuntu6_arm64.deb ... 169s Unpacking libavahi-common-data:arm64 (0.8-13ubuntu6) ... 169s Selecting previously unselected package libavahi-common3:arm64. 169s Preparing to unpack .../34-libavahi-common3_0.8-13ubuntu6_arm64.deb ... 169s Unpacking libavahi-common3:arm64 (0.8-13ubuntu6) ... 169s Selecting previously unselected package libavahi-client3:arm64. 169s Preparing to unpack .../35-libavahi-client3_0.8-13ubuntu6_arm64.deb ... 169s Unpacking libavahi-client3:arm64 (0.8-13ubuntu6) ... 170s Selecting previously unselected package libwbclient0:arm64. 170s Preparing to unpack .../36-libwbclient0_2%3a4.19.5+dfsg-4ubuntu9_arm64.deb ... 170s Unpacking libwbclient0:arm64 (2:4.19.5+dfsg-4ubuntu9) ... 170s Selecting previously unselected package samba-libs:arm64. 170s Preparing to unpack .../37-samba-libs_2%3a4.19.5+dfsg-4ubuntu9_arm64.deb ... 170s Unpacking samba-libs:arm64 (2:4.19.5+dfsg-4ubuntu9) ... 170s Selecting previously unselected package python3-talloc:arm64. 170s Preparing to unpack .../38-python3-talloc_2.4.2-1build2_arm64.deb ... 170s Unpacking python3-talloc:arm64 (2.4.2-1build2) ... 170s Selecting previously unselected package python3-samba. 170s Preparing to unpack .../39-python3-samba_2%3a4.19.5+dfsg-4ubuntu9_arm64.deb ... 170s Unpacking python3-samba (2:4.19.5+dfsg-4ubuntu9) ... 171s Selecting previously unselected package samba-common. 171s Preparing to unpack .../40-samba-common_2%3a4.19.5+dfsg-4ubuntu9_all.deb ... 171s Unpacking samba-common (2:4.19.5+dfsg-4ubuntu9) ... 171s Selecting previously unselected package libcups2t64:arm64. 171s Preparing to unpack .../41-libcups2t64_2.4.7-1.2ubuntu7_arm64.deb ... 171s Unpacking libcups2t64:arm64 (2.4.7-1.2ubuntu7) ... 171s Selecting previously unselected package samba-common-bin. 171s Preparing to unpack .../42-samba-common-bin_2%3a4.19.5+dfsg-4ubuntu9_arm64.deb ... 171s Unpacking samba-common-bin (2:4.19.5+dfsg-4ubuntu9) ... 171s Selecting previously unselected package tdb-tools. 171s Preparing to unpack .../43-tdb-tools_1.4.10-1build1_arm64.deb ... 171s Unpacking tdb-tools (1.4.10-1build1) ... 171s Selecting previously unselected package samba. 172s Preparing to unpack .../44-samba_2%3a4.19.5+dfsg-4ubuntu9_arm64.deb ... 172s Unpacking samba (2:4.19.5+dfsg-4ubuntu9) ... 172s Selecting previously unselected package libsmbclient0:arm64. 172s Preparing to unpack .../45-libsmbclient0_2%3a4.19.5+dfsg-4ubuntu9_arm64.deb ... 172s Unpacking libsmbclient0:arm64 (2:4.19.5+dfsg-4ubuntu9) ... 172s Selecting previously unselected package smbclient. 172s Preparing to unpack .../46-smbclient_2%3a4.19.5+dfsg-4ubuntu9_arm64.deb ... 172s Unpacking smbclient (2:4.19.5+dfsg-4ubuntu9) ... 172s Selecting previously unselected package autopkgtest-satdep. 172s Preparing to unpack .../47-1-autopkgtest-satdep.deb ... 172s Unpacking autopkgtest-satdep (0) ... 172s Setting up libarchive-zip-perl (1.68-1) ... 172s Setting up libtdb1:arm64 (1.4.10-1build1) ... 172s Setting up libhtml-tagset-perl (3.20-6) ... 172s Setting up samba-common (2:4.19.5+dfsg-4ubuntu9) ... 173s 173s Creating config file /etc/samba/smb.conf with new version 173s Setting up libwbclient0:arm64 (2:4.19.5+dfsg-4ubuntu9) ... 173s Setting up libtalloc2:arm64 (2.4.2-1build2) ... 173s Setting up libpython3.12t64:arm64 (3.12.3-1) ... 173s Setting up backuppc-rsync (3.1.3.0-3ubuntu1) ... 173s Setting up python3-tdb (1.4.10-1build1) ... 174s Setting up ssl-cert (1.1.2ubuntu1) ... 176s Created symlink /etc/systemd/system/multi-user.target.wants/ssl-cert.service → /usr/lib/systemd/system/ssl-cert.service. 178s Setting up libavahi-common-data:arm64 (0.8-13ubuntu6) ... 179s Setting up tdb-tools (1.4.10-1build1) ... 179s update-alternatives: using /usr/bin/tdbbackup.tdbtools to provide /usr/bin/tdbbackup (tdbbackup) in auto mode 179s Setting up python3-markdown (3.5.2-1) ... 179s Setting up libtimedate-perl (2.3300-2) ... 179s Setting up libtime-parsedate-perl (2015.103-4) ... 179s Setting up python3-dnspython (2.6.1-1ubuntu1) ... 181s Setting up libapr1t64:arm64 (1.7.2-3.1build2) ... 181s Setting up libnsl2:arm64 (1.3.0-3build3) ... 181s Setting up liblua5.4-0:arm64 (5.4.6-3build2) ... 181s Setting up apache2-data (2.4.58-1ubuntu8) ... 181s Setting up libbackuppc-xs-perl:arm64 (0.62-2build5) ... 181s Setting up liburi-perl (5.27-1) ... 181s Setting up libtevent0t64:arm64 (0.16.1-2build1) ... 181s Setting up libaprutil1t64:arm64 (1.6.3-1.1ubuntu7) ... 181s Setting up libhttp-date-perl (6.06-1) ... 181s Setting up libfile-listing-perl (6.16-1) ... 181s Setting up python3-talloc:arm64 (2.4.2-1build2) ... 181s Setting up libavahi-common3:arm64 (0.8-13ubuntu6) ... 181s Setting up libaprutil1-ldap:arm64 (1.6.3-1.1ubuntu7) ... 181s Setting up libaprutil1-dbd-sqlite3:arm64 (1.6.3-1.1ubuntu7) ... 181s Setting up postfix (3.8.6-1build2) ... 181s info: Selecting GID from range 100 to 999 ... 181s info: Adding group `postfix' (GID 111) ... 182s info: Selecting UID from range 100 to 999 ... 182s 182s info: Adding system user `postfix' (UID 107) ... 182s info: Adding new user `postfix' (UID 107) with group `postfix' ... 182s info: Not creating home directory `/var/spool/postfix'. 182s Creating /etc/postfix/dynamicmaps.cf 182s info: Selecting GID from range 100 to 999 ... 182s info: Adding group `postdrop' (GID 112) ... 182s setting myhostname: autopkgtest.local 182s setting alias maps 182s setting alias database 182s changing /etc/mailname to autopkgtest.local 182s setting myorigin 182s setting destinations: $myhostname, autopkgtest.local, localhost.local, , localhost 182s setting relayhost: 182s setting mynetworks: 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128 182s setting mailbox_size_limit: 0 183s setting recipient_delimiter: + 184s setting inet_interfaces: all 186s setting inet_protocols: all 186s /etc/aliases does not exist, creating it. 186s WARNING: /etc/aliases exists, but does not have a root alias. 186s 186s Postfix (main.cf) is now set up with a default configuration. If you need to 186s make changes, edit /etc/postfix/main.cf (and others) as needed. To view 186s Postfix configuration values, see postconf(1). 186s 186s After modifying main.cf, be sure to run 'systemctl reload postfix'. 186s 188s Running newaliases 191s Created symlink /etc/systemd/system/multi-user.target.wants/postfix.service → /usr/lib/systemd/system/postfix.service. 195s Setting up libhtml-parser-perl:arm64 (3.81-1build3) ... 195s Setting up libldb2:arm64 (2:2.8.0+samba4.19.5+dfsg-4ubuntu9) ... 195s Setting up libavahi-client3:arm64 (0.8-13ubuntu6) ... 195s Setting up apache2-utils (2.4.58-1ubuntu8) ... 195s Setting up libcgi-pm-perl (4.63-1) ... 195s Setting up samba-libs:arm64 (2:4.19.5+dfsg-4ubuntu9) ... 195s Setting up apache2-bin (2.4.58-1ubuntu8) ... 195s Setting up python3-ldb (2:2.8.0+samba4.19.5+dfsg-4ubuntu9) ... 196s Setting up libsmbclient0:arm64 (2:4.19.5+dfsg-4ubuntu9) ... 196s Setting up libcups2t64:arm64 (2.4.7-1.2ubuntu7) ... 196s Setting up python3-samba (2:4.19.5+dfsg-4ubuntu9) ... 199s Setting up apache2 (2.4.58-1ubuntu8) ... 199s Enabling module mpm_event. 199s Enabling module authz_core. 199s Enabling module authz_host. 200s Enabling module authn_core. 200s Enabling module auth_basic. 200s Enabling module access_compat. 200s Enabling module authn_file. 200s Enabling module authz_user. 200s Enabling module alias. 200s Enabling module dir. 200s Enabling module autoindex. 201s Enabling module env. 201s Enabling module mime. 201s Enabling module negotiation. 201s Enabling module setenvif. 201s Enabling module filter. 201s Enabling module deflate. 201s Enabling module status. 202s Enabling module reqtimeout. 202s Enabling conf charset. 202s Enabling conf localized-error-pages. 202s Enabling conf other-vhosts-access-log. 202s Enabling conf security. 203s Enabling conf serve-cgi-bin. 203s Enabling site 000-default. 206s Created symlink /etc/systemd/system/multi-user.target.wants/apache2.service → /usr/lib/systemd/system/apache2.service. 209s Created symlink /etc/systemd/system/multi-user.target.wants/apache-htcacheclean.service → /usr/lib/systemd/system/apache-htcacheclean.service. 214s Setting up backuppc (4.4.0-8build1) ... 215s 215s apache2_invoke: Enable configuration backuppc.conf 216s warn: The home directory `/var/lib/backuppc' already exists. Not touching this directory. 216s warn: Warning: The home directory `/var/lib/backuppc' does not belong to the user you are currently creating. 217s Adding password for user backuppc 217s Considering dependency authn_core for auth_basic: 217s Module authn_core already enabled 217s Module auth_basic already enabled 217s Considering dependency authz_core for authz_groupfile: 217s Module authz_core already enabled 217s Enabling module authz_groupfile. 217s To activate the new configuration, you need to run: 217s systemctl restart apache2 217s Module authn_file already enabled 217s Considering dependency authz_core for authz_user: 217s Module authz_core already enabled 217s Module authz_user already enabled 218s Your MPM seems to be threaded. Selecting cgid instead of cgi. 218s Enabling module cgid. 218s To activate the new configuration, you need to run: 218s systemctl restart apache2 218s 218s Creating config file /etc/backuppc/config.pl with new version 220s Created symlink /etc/systemd/system/multi-user.target.wants/backuppc.service → /usr/lib/systemd/system/backuppc.service. 222s Setting up smbclient (2:4.19.5+dfsg-4ubuntu9) ... 222s Setting up samba-common-bin (2:4.19.5+dfsg-4ubuntu9) ... 222s Setting up samba (2:4.19.5+dfsg-4ubuntu9) ... 227s Created symlink /etc/systemd/system/smb.service → /usr/lib/systemd/system/smbd.service. 227s Created symlink /etc/systemd/system/multi-user.target.wants/smbd.service → /usr/lib/systemd/system/smbd.service. 229s Created symlink /etc/systemd/system/nmb.service → /usr/lib/systemd/system/nmbd.service. 229s Created symlink /etc/systemd/system/multi-user.target.wants/nmbd.service → /usr/lib/systemd/system/nmbd.service. 232s Created symlink /etc/systemd/system/samba.service → /usr/lib/systemd/system/samba-ad-dc.service. 232s Created symlink /etc/systemd/system/multi-user.target.wants/samba-ad-dc.service → /usr/lib/systemd/system/samba-ad-dc.service. 234s Setting up autopkgtest-satdep (0) ... 234s Processing triggers for rsyslog (8.2312.0-3ubuntu9) ... 234s Processing triggers for ufw (0.36.2-6) ... 235s Processing triggers for man-db (2.12.0-4build2) ... 240s Processing triggers for libc-bin (2.39-0ubuntu8) ... 252s (Reading database ... 80268 files and directories currently installed.) 252s Removing autopkgtest-satdep (0) ... 253s autopkgtest [02:09:53]: test smb-backup: [----------------------- 254s Populating share path 254s Adding samba share 254s Adding [public] share 255s Configuring backuppc 255s Performing a full backup 255s Backup type: type = full, needs_full = 1, needs_incr = 1, lastFullTime = 0, opts{f} = 1, opts{i} = , opts{F} = 255s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 255s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 255s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.063 255s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.0.z created 2024-05-04 02:09:55 255s Backup prep: type = full, case = 1, inPlace = 1, doDuplicate = 0, newBkupNum = 0, newBkupIdx = 0, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = ) 255s __bpc_progress_state__ backup share "public" 255s Running: /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -Tc - 255s full backup started for share public 255s started full dump, share=public 255s Xfer PIDs are now 4640,4639 255s xferPids 4640,4639 255s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -Tc - 256s tarmode is now full, system, hidden, noreset, noverbose 256s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 1 256s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 256s __bpc_progress_fileCnt__ 0 256s new 644 0/0 480434 tmp.n9HtCJ 256s new 644 0/0 480434 tmp.4c2VDd 257s new 644 0/0 480434 tmp.MfuyBd 257s new 644 0/0 480434 tmp.wMN2gU 257s new 644 0/0 480434 tmp.TaryJG 257s new 644 0/0 480434 tmp.Dr6zUS 257s new 644 0/0 480434 tmp.I0dExv 257s new 644 0/0 480434 tmp.5nAw7O 257s new 644 0/0 480434 tmp.TtgHWD 257s tar: dumped 10 files and 0 directories 257s Total bytes written: 4804340 (4.7 MiB/s) 257s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 257s new 644 0/0 480434 tmp.1Y8xji 257s __bpc_progress_fileCnt__ 10 257s tarExtract: Done: 0 errors, 0 filesExist, 0 sizeExist, 0 sizeExistComp, 10 filesTotal, 4804340 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377822 sizeNewComp, 13 inodeLast 257s Xfer PIDs are now 257s xferPids 257s full backup 0 complete, 10 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 257s BackupExpire: cntFull = 1, cntIncr = 0, firstFull = 0, firstIncr = , oldestIncr = 0, oldestFull = 2.31481481481481e-05 257s __bpc_progress_state__ fsck 257s Running BackupPC_refCountUpdate -h localhost on localhost 257s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 258s Xfer PIDs are now 4646 258s xferPids 4646 258s BackupPC_refCountUpdate: doing fsck on localhost #0 (full) since $ConfRefCntFsck == 1 258s __bpc_progress_state__ refCnt #0 258s __bpc_progress_state__ cntUpdate #0 258s __bpc_progress_state__ rename #0 258s __bpc_progress_state__ sumUpdate 258s __bpc_progress_fileCnt__ 0/128 258s __bpc_progress_fileCnt__ 8/128 258s __bpc_progress_fileCnt__ 16/128 258s __bpc_progress_fileCnt__ 24/128 258s __bpc_progress_fileCnt__ 32/128 258s __bpc_progress_fileCnt__ 40/128 258s __bpc_progress_fileCnt__ 48/128 258s __bpc_progress_fileCnt__ 56/128 258s __bpc_progress_fileCnt__ 64/128 258s __bpc_progress_fileCnt__ 72/128 258s __bpc_progress_fileCnt__ 80/128 258s __bpc_progress_fileCnt__ 88/128 258s __bpc_progress_fileCnt__ 96/128 258s __bpc_progress_fileCnt__ 104/128 258s __bpc_progress_fileCnt__ 112/128 258s __bpc_progress_fileCnt__ 120/128 258s __bpc_progress_state__ rename total 258s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 258s Xfer PIDs are now 258s xferPids 258s Finished BackupPC_refCountUpdate (running time: 1 sec) 258s Xfer PIDs are now 258s xferPids 258s full backup complete 258s OK: Full backup succeeded 258s Changing share content and performing an incremental backup 259s Backup type: type = incr, needs_full = , needs_incr = , lastFullTime = 1714788595, opts{f} = , opts{i} = 1, opts{F} = 259s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 260s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 260s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.061 260s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.1.z created 2024-05-04 02:09:59 260s Backup prep: type = incr, case = 3, inPlace = 1, doDuplicate = 1, newBkupNum = 1, newBkupIdx = 1, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = ) 260s Executing /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 260s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 260s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDuplicate line 89. 260s (Did you mean "$Host\'s" instead?) 260s Xfer PIDs are now 4716 260s xferPids 4716 260s __bpc_progress_state__ copy #0 -> #1 260s Copying backup #0 to #1 260s __bpc_progress_fileCnt__ 3 dirs 260s Xfer PIDs are now 4716,4719 260s xferPids 4716,4719 260s __bpc_progress_state__ sumUpdate 260s __bpc_progress_fileCnt__ 0/128 260s __bpc_progress_fileCnt__ 8/128 260s __bpc_progress_fileCnt__ 16/128 260s __bpc_progress_fileCnt__ 24/128 260s __bpc_progress_fileCnt__ 32/128 260s __bpc_progress_fileCnt__ 40/128 260s __bpc_progress_fileCnt__ 48/128 260s __bpc_progress_fileCnt__ 56/128 260s __bpc_progress_fileCnt__ 64/128 260s __bpc_progress_fileCnt__ 72/128 260s __bpc_progress_fileCnt__ 80/128 260s __bpc_progress_fileCnt__ 88/128 260s __bpc_progress_fileCnt__ 96/128 260s __bpc_progress_fileCnt__ 104/128 260s __bpc_progress_fileCnt__ 112/128 260s __bpc_progress_fileCnt__ 120/128 260s __bpc_progress_state__ rename total 260s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 260s Xfer PIDs are now 4716 260s xferPids 4716 260s BackupPC_backupDuplicate: got 0 errors and 0 file open errors 260s Finished BackupPC_backupDuplicate (running time: 1 sec) 260s __bpc_progress_state__ backup share "public" 260s Running: /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 260s incr backup started back to 2024-05-04 01:09:55 (backup #0) for share public 260s started incr dump, share=public 260s Xfer PIDs are now 4723,4722 260s xferPids 4723,4722 260s 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 - 260s tar:1298 Getting files newer than Sat May 4 01:09:55 2024 261s tarmode is now full, system, hidden, noreset, noverbose 261s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 261s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 261s __bpc_progress_fileCnt__ 0 261s same 644 0/0 480434 tmp.n9HtCJ 261s new 644 0/0 480434 tmp.kzW4Rn 261s same 644 0/0 480434 tmp.4c2VDd 261s same 644 0/0 480434 tmp.MfuyBd 261s new 644 0/0 480434 tmp.5nL9rF 261s new 644 0/0 480434 tmp.b4EBPb 261s new 644 0/0 480434 tmp.Q7RseV 261s new 644 0/0 480434 tmp.DJTsqU 261s same 644 0/0 480434 tmp.wMN2gU 261s same 644 0/0 480434 tmp.TaryJG 261s new 644 0/0 480434 tmp.v2SPSL 261s same 644 0/0 480434 tmp.Dr6zUS 261s same 644 0/0 480434 tmp.I0dExv 261s same 644 0/0 480434 tmp.5nAw7O 261s new 644 0/0 480434 tmp.ixwSVR 261s new 644 0/0 480434 tmp.oROoez 261s same 644 0/0 480434 tmp.TtgHWD 261s same 644 0/0 480434 tmp.1Y8xji 261s new 644 0/0 480434 tmp.2v6mmT 261s tar: dumped 20 files and 0 directories 261s Total bytes written: 9608680 (12.3 MiB/s) 261s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 261s new 644 0/0 480434 tmp.onYOmz 261s __bpc_progress_fileCnt__ 20 261s tarExtract: Done: 0 errors, 10 filesExist, 4804340 sizeExist, 1377822 sizeExistComp, 20 filesTotal, 9608680 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377811 sizeNewComp, 24 inodeLast 261s Xfer PIDs are now 261s xferPids 261s incr backup 1 complete, 20 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 261s BackupExpire: cntFull = 2, cntIncr = 0, firstFull = 0, firstIncr = , oldestIncr = 0, oldestFull = 6.94444444444444e-05 261s __bpc_progress_state__ fsck 261s Running BackupPC_refCountUpdate -h localhost on localhost 261s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 262s Xfer PIDs are now 4729 262s xferPids 4729 262s __bpc_progress_state__ cntUpdate #1 262s __bpc_progress_state__ rename #1 262s __bpc_progress_state__ sumUpdate 262s __bpc_progress_fileCnt__ 0/128 262s __bpc_progress_fileCnt__ 8/128 262s __bpc_progress_fileCnt__ 16/128 262s __bpc_progress_fileCnt__ 24/128 262s __bpc_progress_fileCnt__ 32/128 262s __bpc_progress_fileCnt__ 40/128 262s __bpc_progress_fileCnt__ 48/128 262s __bpc_progress_fileCnt__ 56/128 262s __bpc_progress_fileCnt__ 64/128 262s __bpc_progress_fileCnt__ 72/128 262s __bpc_progress_fileCnt__ 80/128 262s __bpc_progress_fileCnt__ 88/128 262s __bpc_progress_fileCnt__ 96/128 262s __bpc_progress_fileCnt__ 104/128 262s __bpc_progress_fileCnt__ 112/128 262s __bpc_progress_fileCnt__ 120/128 262s __bpc_progress_state__ rename total 262s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 262s Xfer PIDs are now 262s xferPids 262s Finished BackupPC_refCountUpdate (running time: 1 sec) 262s Xfer PIDs are now 262s xferPids 262s incr backup complete 262s OK: Incremental backup succeeded 262s Done. 263s autopkgtest [02:10:03]: test smb-backup: -----------------------] 263s smb-backup PASS 263s autopkgtest [02:10:03]: test smb-backup: - - - - - - - - - - results - - - - - - - - - - 264s autopkgtest [02:10:04]: test authenticated-smb-backup: preparing testbed 266s Reading package lists... 267s Building dependency tree... 267s Reading state information... 268s Starting pkgProblemResolver with broken count: 0 268s Starting 2 pkgProblemResolver with broken count: 0 269s Done 271s The following NEW packages will be installed: 271s autopkgtest-satdep 271s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 271s Need to get 0 B/724 B of archives. 271s After this operation, 0 B of additional disk space will be used. 271s Get:1 /tmp/autopkgtest.ZPZp0F/2-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [724 B] 272s Selecting previously unselected package autopkgtest-satdep. 272s (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 ... 80269 files and directories currently installed.) 272s Preparing to unpack .../2-autopkgtest-satdep.deb ... 272s Unpacking autopkgtest-satdep (0) ... 272s Setting up autopkgtest-satdep (0) ... 279s (Reading database ... 80268 files and directories currently installed.) 279s Removing autopkgtest-satdep (0) ... 280s autopkgtest [02:10:20]: test authenticated-smb-backup: [----------------------- 280s Populating share path 281s Adding samba share 281s Adding [private] share 281s Creating user 281s Creating a local and samba user called smbtest4982 281s Setting samba password for the smbtest4982 user 282s Added user smbtest4982. 282s Configuring backuppc 282s Performing a full backup 282s Backup type: type = full, needs_full = , needs_incr = , lastFullTime = 1714788595, opts{f} = 1, opts{i} = , opts{F} = 282s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 282s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 282s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.062 282s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.2.z created 2024-05-04 02:10:22 282s Backup prep: type = full, case = 4, inPlace = 0, doDuplicate = 0, newBkupNum = 2, newBkupIdx = 2, lastBkupNum = 1, lastBkupIdx = 1 (FillCycle = 0, noFillCnt = 0) 282s __bpc_progress_state__ backup share "private" 282s Running: /usr/bin/smbclient \\\\localhost\\private -U smbtest4982 -E -d 1 -c tarmode\ full -mSMB3 -Tc - 282s full backup started for share private 282s started full dump, share=private 282s Xfer PIDs are now 5076,5075 282s xferPids 5076,5075 282s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\private -U smbtest4982 -E -d 1 -c tarmode\ full -mSMB3 -Tc - 283s tarmode is now full, system, hidden, noreset, noverbose 283s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 1 283s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 283s __bpc_progress_fileCnt__ 0 283s new 644 0/0 480434 tmp.uKBRS7 283s new 644 0/0 480434 tmp.71d1Pm 283s new 644 0/0 480434 tmp.REZ6cK 283s new 644 0/0 480434 tmp.ETAyHx 283s new 644 0/0 480434 tmp.iJyiCQ 283s new 644 0/0 480434 tmp.T9RuiS 283s new 644 0/0 480434 tmp.TdBVIe 283s new 644 0/0 480434 tmp.OVEyxm 283s new 644 0/0 480434 tmp.FDwEg1 283s tar: dumped 10 files and 0 directories 283s Total bytes written: 4804340 (7.7 MiB/s) 283s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 283s new 644 0/0 480434 tmp.egWJsi 283s __bpc_progress_fileCnt__ 10 283s tarExtract: Done: 0 errors, 0 filesExist, 0 sizeExist, 0 sizeExistComp, 10 filesTotal, 4804340 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377775 sizeNewComp, 36 inodeLast 283s Xfer PIDs are now 283s xferPids 283s OrphanShareNameClean: removing orphan share public from /var/lib/backuppc/pc/localhost/2 283s __bpc_progress_state__ delete share #2/public 283s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDelete -h localhost -n 2 -l -m -s public / 284s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDelete line 102. 284s (Did you mean "$Host\'s" instead?) 284s Xfer PIDs are now 5082 284s xferPids 5082 284s BackupPC_backupDelete: removing #2/public/ 284s __bpc_progress_state__ merge #2/public/ -> #1/public/ 284s BackupPC_backupDelete: Merge into backup 1/public/ 284s mergeDir: attr write to /var/lib/backuppc/pc/localhost/1/fpublic//attrib failed (digest was ) 284s bpc_attrib_dirWrite: can't open/create raw /var/lib/backuppc/pc/localhost/1/fpublic for writing 284s Xfer PIDs are now 5085,5082 284s xferPids 5085,5082 284s __bpc_progress_state__ refCnt #1 284s __bpc_progress_state__ cntUpdate #1 284s __bpc_progress_state__ rename #1 284s __bpc_progress_state__ refCnt #2 284s BackupPC_refCountUpdate: localhost #2 inodeLast set to 37 (was 24) 284s __bpc_progress_state__ cntUpdate #2 284s __bpc_progress_state__ rename #2 285s __bpc_progress_state__ sumUpdate 285s __bpc_progress_fileCnt__ 0/128 285s __bpc_progress_fileCnt__ 8/128 285s __bpc_progress_fileCnt__ 16/128 285s __bpc_progress_fileCnt__ 24/128 285s __bpc_progress_fileCnt__ 32/128 285s __bpc_progress_fileCnt__ 40/128 285s __bpc_progress_fileCnt__ 48/128 285s __bpc_progress_fileCnt__ 56/128 285s __bpc_progress_fileCnt__ 64/128 285s __bpc_progress_fileCnt__ 72/128 285s __bpc_progress_fileCnt__ 80/128 285s __bpc_progress_fileCnt__ 88/128 285s __bpc_progress_fileCnt__ 96/128 285s __bpc_progress_fileCnt__ 104/128 285s __bpc_progress_fileCnt__ 112/128 285s __bpc_progress_fileCnt__ 120/128 285s __bpc_progress_state__ rename total 285s BackupPC_refCountUpdate: host localhost got 0 errors (took 1 secs) 285s Xfer PIDs are now 5082 285s xferPids 5082 285s Xfer PIDs are now 285s xferPids 285s Finished BackupPC_backupDelete, status = 0 (running time: 2 sec) 285s Xfer PIDs are now 285s xferPids 285s full backup 2 complete, 10 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 285s BackupExpire: cntFull = 2, cntIncr = 1, firstFull = 0, firstIncr = 1, oldestIncr = 0.000289351851851852, oldestFull = 0.000347222222222222 285s __bpc_progress_state__ fsck 285s Running BackupPC_refCountUpdate -h localhost on localhost 285s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 285s Xfer PIDs are now 5088 285s xferPids 5088 285s BackupPC_refCountUpdate: doing fsck on localhost #2 (full) since $ConfRefCntFsck == 1 285s __bpc_progress_state__ refCnt #2 285s __bpc_progress_state__ cntUpdate #2 285s __bpc_progress_state__ rename #2 285s __bpc_progress_state__ sumUpdate 285s __bpc_progress_fileCnt__ 0/128 285s __bpc_progress_fileCnt__ 8/128 285s __bpc_progress_fileCnt__ 16/128 285s __bpc_progress_fileCnt__ 24/128 285s __bpc_progress_fileCnt__ 32/128 285s __bpc_progress_fileCnt__ 40/128 285s __bpc_progress_fileCnt__ 48/128 285s __bpc_progress_fileCnt__ 56/128 285s __bpc_progress_fileCnt__ 64/128 285s __bpc_progress_fileCnt__ 72/128 285s __bpc_progress_fileCnt__ 80/128 285s __bpc_progress_fileCnt__ 88/128 285s __bpc_progress_fileCnt__ 96/128 285s __bpc_progress_fileCnt__ 104/128 285s __bpc_progress_fileCnt__ 112/128 285s __bpc_progress_fileCnt__ 120/128 285s __bpc_progress_state__ rename total 285s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 285s Xfer PIDs are now 285s xferPids 285s Finished BackupPC_refCountUpdate (running time: 0 sec) 285s Xfer PIDs are now 285s xferPids 285s full backup complete 285s OK: Full backup succeeded 285s Changing share content and performing an incremental backup 286s Backup type: type = incr, needs_full = , needs_incr = , lastFullTime = 1714788622, opts{f} = , opts{i} = 1, opts{F} = 286s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 286s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 286s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.061 286s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.3.z created 2024-05-04 02:10:26 286s Backup prep: type = incr, case = 3, inPlace = 1, doDuplicate = 1, newBkupNum = 3, newBkupIdx = 3, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = 1) 286s Executing /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 286s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 287s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDuplicate line 89. 287s (Did you mean "$Host\'s" instead?) 287s Xfer PIDs are now 5158 287s xferPids 5158 287s __bpc_progress_state__ copy #2 -> #3 287s Copying backup #2 to #3 287s __bpc_progress_fileCnt__ 3 dirs 287s Xfer PIDs are now 5161,5158 287s xferPids 5161,5158 287s __bpc_progress_state__ sumUpdate 287s __bpc_progress_fileCnt__ 0/128 287s __bpc_progress_fileCnt__ 8/128 287s __bpc_progress_fileCnt__ 16/128 287s __bpc_progress_fileCnt__ 24/128 287s __bpc_progress_fileCnt__ 32/128 287s __bpc_progress_fileCnt__ 40/128 287s __bpc_progress_fileCnt__ 48/128 287s __bpc_progress_fileCnt__ 56/128 287s __bpc_progress_fileCnt__ 64/128 287s __bpc_progress_fileCnt__ 72/128 287s __bpc_progress_fileCnt__ 80/128 287s __bpc_progress_fileCnt__ 88/128 287s __bpc_progress_fileCnt__ 96/128 287s __bpc_progress_fileCnt__ 104/128 287s __bpc_progress_fileCnt__ 112/128 287s __bpc_progress_fileCnt__ 120/128 287s __bpc_progress_state__ rename total 287s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 287s Xfer PIDs are now 5158 287s xferPids 5158 287s BackupPC_backupDuplicate: got 0 errors and 0 file open errors 287s Finished BackupPC_backupDuplicate (running time: 1 sec) 287s __bpc_progress_state__ backup share "private" 287s Running: /usr/bin/smbclient \\\\localhost\\private -U smbtest4982 -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 287s incr backup started back to 2024-05-04 01:10:22 (backup #2) for share private 287s started incr dump, share=private 287s Xfer PIDs are now 5165,5164 287s xferPids 5165,5164 287s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\private -U smbtest4982 -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 287s tar:1298 Getting files newer than Sat May 4 01:10:22 2024 287s tarmode is now full, system, hidden, noreset, noverbose 288s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 288s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 288s __bpc_progress_fileCnt__ 0 288s new 644 0/0 480434 tmp.zoitmE 288s same 644 0/0 480434 tmp.uKBRS7 288s same 644 0/0 480434 tmp.71d1Pm 288s new 644 0/0 480434 tmp.limXnh 288s same 644 0/0 480434 tmp.REZ6cK 288s new 644 0/0 480434 tmp.6g6WPo 288s new 644 0/0 480434 tmp.O8czOw 288s new 644 0/0 480434 tmp.iouS8Q 288s new 644 0/0 480434 tmp.HCwrcF 288s same 644 0/0 480434 tmp.ETAyHx 288s same 644 0/0 480434 tmp.iJyiCQ 288s same 644 0/0 480434 tmp.T9RuiS 288s new 644 0/0 480434 tmp.VwG5ad 288s same 644 0/0 480434 tmp.TdBVIe 288s same 644 0/0 480434 tmp.OVEyxm 288s new 644 0/0 480434 tmp.NrXHql 288s new 644 0/0 480434 tmp.kmhBCX 288s same 644 0/0 480434 tmp.FDwEg1 288s same 644 0/0 480434 tmp.egWJsi 288s tar: dumped 20 files and 0 directories 288s Total bytes written: 9608680 (13.7 MiB/s) 288s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 288s new 644 0/0 480434 tmp.m9lX5p 288s __bpc_progress_fileCnt__ 20 288s tarExtract: Done: 0 errors, 10 filesExist, 4804340 sizeExist, 1377775 sizeExistComp, 20 filesTotal, 9608680 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377804 sizeNewComp, 47 inodeLast 288s Xfer PIDs are now 288s xferPids 288s incr backup 3 complete, 20 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 288s BackupExpire: cntFull = 3, cntIncr = 1, firstFull = 0, firstIncr = 1, oldestIncr = 0.000324074074074074, oldestFull = 0.000381944444444444 288s __bpc_progress_state__ fsck 288s Running BackupPC_refCountUpdate -h localhost on localhost 288s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 289s Xfer PIDs are now 5171 289s xferPids 5171 289s __bpc_progress_state__ cntUpdate #3 289s __bpc_progress_state__ rename #3 289s __bpc_progress_state__ sumUpdate 289s __bpc_progress_fileCnt__ 0/128 289s __bpc_progress_fileCnt__ 8/128 289s __bpc_progress_fileCnt__ 16/128 289s __bpc_progress_fileCnt__ 24/128 289s __bpc_progress_fileCnt__ 32/128 289s __bpc_progress_fileCnt__ 40/128 289s __bpc_progress_fileCnt__ 48/128 289s __bpc_progress_fileCnt__ 56/128 289s __bpc_progress_fileCnt__ 64/128 289s __bpc_progress_fileCnt__ 72/128 289s __bpc_progress_fileCnt__ 80/128 289s __bpc_progress_fileCnt__ 88/128 289s __bpc_progress_fileCnt__ 96/128 289s __bpc_progress_fileCnt__ 104/128 289s __bpc_progress_fileCnt__ 112/128 289s __bpc_progress_fileCnt__ 120/128 289s __bpc_progress_state__ rename total 289s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 289s Xfer PIDs are now 289s xferPids 289s Finished BackupPC_refCountUpdate (running time: 1 sec) 289s Xfer PIDs are now 289s xferPids 289s incr backup complete 289s OK: Incremental backup succeeded 289s Done. 289s Deleted user smbtest4982. 289s userdel: smbtest4982 mail spool (/var/mail/smbtest4982) not found 290s autopkgtest [02:10:30]: test authenticated-smb-backup: -----------------------] 291s authenticated-smb-backup PASS 291s autopkgtest [02:10:31]: test authenticated-smb-backup: - - - - - - - - - - results - - - - - - - - - - 291s autopkgtest [02:10:31]: @@@@@@@@@@@@@@@@@@@@ summary 291s smb-backup PASS 291s authenticated-smb-backup PASS 303s Creating nova instance adt-oracular-arm64-backuppc-20240504-020540-juju-7f2275-prod-proposed-migration-environment-3-ca84d5d3-ca13-4a74-b78a-bff81e4f0695 from image adt/ubuntu-oracular-arm64-server-20240503.img (UUID 1cc2317f-29dd-4d69-b15e-2e03b50e20ac)...