0s autopkgtest [11:36:28]: starting date and time: 2024-07-12 11:36:28+0000 0s autopkgtest [11:36:28]: git checkout: fd3bed09 nova: allow more retries for quota issues 0s autopkgtest [11:36:28]: host juju-7f2275-prod-proposed-migration-environment-9; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.k05box7p/out --timeout-copy=6000 --setup-commands 'ln -s /dev/null /etc/systemd/system/bluetooth.service; printf "http_proxy=http://squid.internal:3128\nhttps_proxy=http://squid.internal:3128\nno_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\n" >> /etc/environment' --apt-pocket=proposed=src:inetutils --apt-upgrade backuppc --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=inetutils/2:2.5-5ubuntu1 -- lxd -r lxd-armhf-10.145.243.194 lxd-armhf-10.145.243.194:autopkgtest/ubuntu/oracular/armhf 56s autopkgtest [11:37:24]: testbed dpkg architecture: armhf 58s autopkgtest [11:37:26]: testbed apt version: 2.9.6 58s autopkgtest [11:37:26]: @@@@@@@@@@@@@@@@@@@@ test bed setup 67s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [126 kB] 67s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [2576 B] 67s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [45.4 kB] 67s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [8548 B] 67s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [344 kB] 67s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main armhf Packages [61.8 kB] 67s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main armhf c-n-f Metadata [1444 B] 67s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/restricted armhf Packages [1368 B] 67s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/restricted armhf c-n-f Metadata [120 B] 67s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/universe armhf Packages [297 kB] 67s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/universe armhf c-n-f Metadata [6176 B] 67s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse armhf Packages [1448 B] 67s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse armhf c-n-f Metadata [120 B] 69s Fetched 895 kB in 1s (1061 kB/s) 69s Reading package lists... 86s tee: /proc/self/fd/2: Permission denied 109s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 109s Hit:2 http://ftpmaster.internal/ubuntu oracular InRelease 109s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease 109s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease 111s Reading package lists... 111s Reading package lists... 111s Building dependency tree... 111s Reading state information... 112s Calculating upgrade... 112s The following packages will be upgraded: 112s inetutils-telnet libssl3t64 openssl telnet 112s 4 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 112s Need to get 2921 kB of archives. 112s After this operation, 266 kB of additional disk space will be used. 112s Get:1 http://ftpmaster.internal/ubuntu oracular/main armhf libssl3t64 armhf 3.2.2-1ubuntu1 [1729 kB] 113s Get:2 http://ftpmaster.internal/ubuntu oracular/main armhf openssl armhf 3.2.2-1ubuntu1 [1095 kB] 113s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/main armhf inetutils-telnet armhf 2:2.5-5ubuntu1 [94.4 kB] 113s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/main armhf telnet all 0.17+2.5-5ubuntu1 [3688 B] 114s Fetched 2921 kB in 1s (4156 kB/s) 114s (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 ... 58437 files and directories currently installed.) 114s Preparing to unpack .../libssl3t64_3.2.2-1ubuntu1_armhf.deb ... 114s Unpacking libssl3t64:armhf (3.2.2-1ubuntu1) over (3.2.1-3ubuntu1) ... 114s Setting up libssl3t64:armhf (3.2.2-1ubuntu1) ... 114s (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 ... 58437 files and directories currently installed.) 114s Preparing to unpack .../openssl_3.2.2-1ubuntu1_armhf.deb ... 114s Unpacking openssl (3.2.2-1ubuntu1) over (3.2.1-3ubuntu1) ... 114s Preparing to unpack .../inetutils-telnet_2%3a2.5-5ubuntu1_armhf.deb ... 114s Unpacking inetutils-telnet (2:2.5-5ubuntu1) over (2:2.5-3ubuntu4) ... 114s Preparing to unpack .../telnet_0.17+2.5-5ubuntu1_all.deb ... 114s Unpacking telnet (0.17+2.5-5ubuntu1) over (0.17+2.5-3ubuntu4) ... 114s Setting up inetutils-telnet (2:2.5-5ubuntu1) ... 114s Setting up openssl (3.2.2-1ubuntu1) ... 114s Installing new version of config file /etc/ssl/openssl.cnf ... 114s Setting up telnet (0.17+2.5-5ubuntu1) ... 114s Processing triggers for man-db (2.12.1-2) ... 115s Processing triggers for libc-bin (2.39-0ubuntu9) ... 115s Reading package lists... 116s Building dependency tree... 116s Reading state information... 116s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 119s autopkgtest [11:38:27]: rebooting testbed after setup commands that affected boot 188s autopkgtest [11:39:36]: testbed running kernel: Linux 6.5.0-41-generic #41~22.04.2-Ubuntu SMP PREEMPT_DYNAMIC Mon Jun 3 16:28:24 UTC 2 216s autopkgtest [11:40:04]: @@@@@@@@@@@@@@@@@@@@ apt-source backuppc 226s Get:1 http://ftpmaster.internal/ubuntu oracular/main backuppc 4.4.0-8build1 (dsc) [2289 B] 226s Get:2 http://ftpmaster.internal/ubuntu oracular/main backuppc 4.4.0-8build1 (tar) [657 kB] 226s Get:3 http://ftpmaster.internal/ubuntu oracular/main backuppc 4.4.0-8build1 (diff) [61.1 kB] 227s gpgv: Signature made Mon Apr 8 15:54:41 2024 UTC 227s gpgv: using RSA key 4FB588A84C2DDE79A74C77876FA458DD1DB03F71 227s gpgv: issuer "juliank@ubuntu.com" 227s gpgv: Can't check signature: No public key 227s dpkg-source: warning: cannot verify inline signature for ./backuppc_4.4.0-8build1.dsc: no acceptable signature found 227s autopkgtest [11:40:15]: testing package backuppc version 4.4.0-8build1 229s autopkgtest [11:40:17]: build not needed 231s autopkgtest [11:40:19]: test smb-backup: preparing testbed 241s Reading package lists... 241s Building dependency tree... 241s Reading state information... 242s Starting pkgProblemResolver with broken count: 0 242s Starting 2 pkgProblemResolver with broken count: 0 242s Done 243s The following additional packages will be installed: 243s apache2 apache2-bin apache2-data apache2-utils backuppc backuppc-rsync 243s libapr1t64 libaprutil1-dbd-sqlite3 libaprutil1-ldap libaprutil1t64 243s libarchive-zip-perl libavahi-client3 libavahi-common-data libavahi-common3 243s libbackuppc-xs-perl libcgi-pm-perl libcups2t64 libfile-listing-perl 243s libhtml-parser-perl libhtml-tagset-perl libhttp-date-perl libldb2 243s liblua5.4-0 libnsl2 libsmbclient0 libtalloc2 libtdb1 libtevent0t64 243s libtime-parsedate-perl libtimedate-perl liburi-perl libwbclient0 postfix 243s samba samba-common samba-common-bin samba-libs smbclient ssl-cert 243s Suggested packages: 243s apache2-doc apache2-suexec-pristine | apache2-suexec-custom www-browser 243s certbot | acme-tiny | acmetool | dehydrated | lacme | lecm | lego 243s libscgi-perl par2 w3m | www-browser cups-common libdata-dump-perl 243s libbusiness-isbn-perl libregexp-ipv6-perl libwww-perl mail-reader 243s postfix-cdb postfix-doc postfix-ldap postfix-lmdb postfix-mta-sts-resolver 243s postfix-mongodb postfix-mysql postfix-pcre postfix-pgsql postfix-sqlite 243s procmail sasl2-bin | dovecot-common ctdb winbind heimdal-clients cifs-utils 243s Recommended packages: 243s libio-dirent-perl rrdtool libcgi-fast-perl libhttp-message-perl attr 243s samba-vfs-modules python3-samba 243s The following NEW packages will be installed: 243s apache2 apache2-bin apache2-data apache2-utils autopkgtest-satdep backuppc 243s backuppc-rsync libapr1t64 libaprutil1-dbd-sqlite3 libaprutil1-ldap 243s libaprutil1t64 libarchive-zip-perl libavahi-client3 libavahi-common-data 243s libavahi-common3 libbackuppc-xs-perl libcgi-pm-perl libcups2t64 243s libfile-listing-perl libhtml-parser-perl libhtml-tagset-perl 243s libhttp-date-perl libldb2 liblua5.4-0 libnsl2 libsmbclient0 libtalloc2 243s libtdb1 libtevent0t64 libtime-parsedate-perl libtimedate-perl liburi-perl 243s libwbclient0 postfix samba samba-common samba-common-bin samba-libs 243s smbclient ssl-cert 243s 0 upgraded, 40 newly installed, 0 to remove and 0 not upgraded. 243s Need to get 13.8 MB/13.8 MB of archives. 243s After this operation, 42.3 MB of additional disk space will be used. 243s Get:1 /tmp/autopkgtest.TUDZFQ/1-autopkgtest-satdep.deb autopkgtest-satdep armhf 0 [720 B] 243s Get:2 http://ftpmaster.internal/ubuntu oracular/main armhf libapr1t64 armhf 1.7.2-3.2 [86.0 kB] 243s Get:3 http://ftpmaster.internal/ubuntu oracular/main armhf libaprutil1t64 armhf 1.6.3-2ubuntu1 [82.5 kB] 243s Get:4 http://ftpmaster.internal/ubuntu oracular/main armhf libaprutil1-dbd-sqlite3 armhf 1.6.3-2ubuntu1 [9584 B] 243s Get:5 http://ftpmaster.internal/ubuntu oracular/main armhf libaprutil1-ldap armhf 1.6.3-2ubuntu1 [8490 B] 243s Get:6 http://ftpmaster.internal/ubuntu oracular/main armhf liblua5.4-0 armhf 5.4.6-3build2 [133 kB] 243s Get:7 http://ftpmaster.internal/ubuntu oracular/main armhf apache2-bin armhf 2.4.59-2ubuntu2 [1206 kB] 243s Get:8 http://ftpmaster.internal/ubuntu oracular/main armhf apache2-data all 2.4.59-2ubuntu2 [163 kB] 243s Get:9 http://ftpmaster.internal/ubuntu oracular/main armhf apache2-utils armhf 2.4.59-2ubuntu2 [98.0 kB] 243s Get:10 http://ftpmaster.internal/ubuntu oracular/main armhf apache2 armhf 2.4.59-2ubuntu2 [90.3 kB] 243s Get:11 http://ftpmaster.internal/ubuntu oracular/main armhf backuppc-rsync armhf 3.1.3.0-3ubuntu1 [233 kB] 243s Get:12 http://ftpmaster.internal/ubuntu oracular/main armhf ssl-cert all 1.1.2ubuntu2 [18.0 kB] 243s Get:13 http://ftpmaster.internal/ubuntu oracular/main armhf libnsl2 armhf 1.3.0-3build3 [36.5 kB] 243s Get:14 http://ftpmaster.internal/ubuntu oracular/main armhf postfix armhf 3.9.0-2 [1203 kB] 244s Get:15 http://ftpmaster.internal/ubuntu oracular/main armhf libarchive-zip-perl all 1.68-1 [90.2 kB] 244s Get:16 http://ftpmaster.internal/ubuntu oracular/main armhf libbackuppc-xs-perl armhf 0.62-2build5 [59.7 kB] 244s Get:17 http://ftpmaster.internal/ubuntu oracular/main armhf libhtml-tagset-perl all 3.24-1 [14.1 kB] 244s Get:18 http://ftpmaster.internal/ubuntu oracular/main armhf liburi-perl all 5.28-1 [88.1 kB] 244s Get:19 http://ftpmaster.internal/ubuntu oracular/main armhf libhtml-parser-perl armhf 3.82-1 [82.4 kB] 244s Get:20 http://ftpmaster.internal/ubuntu oracular/main armhf libcgi-pm-perl all 4.66-1 [185 kB] 244s Get:21 http://ftpmaster.internal/ubuntu oracular/main armhf libtimedate-perl all 2.3300-2 [34.0 kB] 244s Get:22 http://ftpmaster.internal/ubuntu oracular/main armhf libhttp-date-perl all 6.06-1 [10.2 kB] 244s Get:23 http://ftpmaster.internal/ubuntu oracular/main armhf libfile-listing-perl all 6.16-1 [11.3 kB] 244s Get:24 http://ftpmaster.internal/ubuntu oracular/main armhf libtime-parsedate-perl all 2015.103-4 [28.6 kB] 244s Get:25 http://ftpmaster.internal/ubuntu oracular/main armhf backuppc armhf 4.4.0-8build1 [540 kB] 244s Get:26 http://ftpmaster.internal/ubuntu oracular/main armhf samba-common all 2:4.20.2+dfsg-2ubuntu2 [65.4 kB] 244s Get:27 http://ftpmaster.internal/ubuntu oracular/main armhf libavahi-common-data armhf 0.8-13ubuntu6 [29.7 kB] 244s Get:28 http://ftpmaster.internal/ubuntu oracular/main armhf libavahi-common3 armhf 0.8-13ubuntu6 [20.2 kB] 244s Get:29 http://ftpmaster.internal/ubuntu oracular/main armhf libavahi-client3 armhf 0.8-13ubuntu6 [24.2 kB] 244s Get:30 http://ftpmaster.internal/ubuntu oracular/main armhf libcups2t64 armhf 2.4.7-1.2ubuntu9 [236 kB] 244s Get:31 http://ftpmaster.internal/ubuntu oracular/main armhf libtalloc2 armhf 2.4.2-1build2 [25.9 kB] 244s Get:32 http://ftpmaster.internal/ubuntu oracular/main armhf libtdb1 armhf 1.4.10-1build1 [43.1 kB] 244s Get:33 http://ftpmaster.internal/ubuntu oracular/main armhf libtevent0t64 armhf 0.16.1-2build1 [38.1 kB] 244s Get:34 http://ftpmaster.internal/ubuntu oracular/main armhf libldb2 armhf 2:2.9.1+samba4.20.2+dfsg-2ubuntu2 [166 kB] 244s Get:35 http://ftpmaster.internal/ubuntu oracular/main armhf libwbclient0 armhf 2:4.20.2+dfsg-2ubuntu2 [70.6 kB] 244s Get:36 http://ftpmaster.internal/ubuntu oracular/main armhf samba-libs armhf 2:4.20.2+dfsg-2ubuntu2 [5888 kB] 244s Get:37 http://ftpmaster.internal/ubuntu oracular/main armhf samba-common-bin armhf 2:4.20.2+dfsg-2ubuntu2 [1257 kB] 244s Get:38 http://ftpmaster.internal/ubuntu oracular/main armhf samba armhf 2:4.20.2+dfsg-2ubuntu2 [957 kB] 244s Get:39 http://ftpmaster.internal/ubuntu oracular/main armhf libsmbclient0 armhf 2:4.20.2+dfsg-2ubuntu2 [57.5 kB] 244s Get:40 http://ftpmaster.internal/ubuntu oracular/main armhf smbclient armhf 2:4.20.2+dfsg-2ubuntu2 [454 kB] 245s Preconfiguring packages ... 245s Fetched 13.8 MB in 2s (9203 kB/s) 245s Selecting previously unselected package libapr1t64:armhf. 245s (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 ... 58436 files and directories currently installed.) 245s Preparing to unpack .../00-libapr1t64_1.7.2-3.2_armhf.deb ... 245s Unpacking libapr1t64:armhf (1.7.2-3.2) ... 245s Selecting previously unselected package libaprutil1t64:armhf. 245s Preparing to unpack .../01-libaprutil1t64_1.6.3-2ubuntu1_armhf.deb ... 245s Unpacking libaprutil1t64:armhf (1.6.3-2ubuntu1) ... 245s Selecting previously unselected package libaprutil1-dbd-sqlite3:armhf. 245s Preparing to unpack .../02-libaprutil1-dbd-sqlite3_1.6.3-2ubuntu1_armhf.deb ... 245s Unpacking libaprutil1-dbd-sqlite3:armhf (1.6.3-2ubuntu1) ... 245s Selecting previously unselected package libaprutil1-ldap:armhf. 245s Preparing to unpack .../03-libaprutil1-ldap_1.6.3-2ubuntu1_armhf.deb ... 245s Unpacking libaprutil1-ldap:armhf (1.6.3-2ubuntu1) ... 245s Selecting previously unselected package liblua5.4-0:armhf. 245s Preparing to unpack .../04-liblua5.4-0_5.4.6-3build2_armhf.deb ... 245s Unpacking liblua5.4-0:armhf (5.4.6-3build2) ... 245s Selecting previously unselected package apache2-bin. 245s Preparing to unpack .../05-apache2-bin_2.4.59-2ubuntu2_armhf.deb ... 245s Unpacking apache2-bin (2.4.59-2ubuntu2) ... 245s Selecting previously unselected package apache2-data. 245s Preparing to unpack .../06-apache2-data_2.4.59-2ubuntu2_all.deb ... 245s Unpacking apache2-data (2.4.59-2ubuntu2) ... 245s Selecting previously unselected package apache2-utils. 245s Preparing to unpack .../07-apache2-utils_2.4.59-2ubuntu2_armhf.deb ... 245s Unpacking apache2-utils (2.4.59-2ubuntu2) ... 245s Selecting previously unselected package apache2. 245s Preparing to unpack .../08-apache2_2.4.59-2ubuntu2_armhf.deb ... 245s Unpacking apache2 (2.4.59-2ubuntu2) ... 245s Selecting previously unselected package backuppc-rsync. 245s Preparing to unpack .../09-backuppc-rsync_3.1.3.0-3ubuntu1_armhf.deb ... 245s Unpacking backuppc-rsync (3.1.3.0-3ubuntu1) ... 245s Selecting previously unselected package ssl-cert. 245s Preparing to unpack .../10-ssl-cert_1.1.2ubuntu2_all.deb ... 245s Unpacking ssl-cert (1.1.2ubuntu2) ... 245s Selecting previously unselected package libnsl2:armhf. 245s Preparing to unpack .../11-libnsl2_1.3.0-3build3_armhf.deb ... 245s Unpacking libnsl2:armhf (1.3.0-3build3) ... 245s Selecting previously unselected package postfix. 245s Preparing to unpack .../12-postfix_3.9.0-2_armhf.deb ... 245s Unpacking postfix (3.9.0-2) ... 246s Selecting previously unselected package libarchive-zip-perl. 246s Preparing to unpack .../13-libarchive-zip-perl_1.68-1_all.deb ... 246s Unpacking libarchive-zip-perl (1.68-1) ... 246s Selecting previously unselected package libbackuppc-xs-perl:armhf. 246s Preparing to unpack .../14-libbackuppc-xs-perl_0.62-2build5_armhf.deb ... 246s Unpacking libbackuppc-xs-perl:armhf (0.62-2build5) ... 246s Selecting previously unselected package libhtml-tagset-perl. 246s Preparing to unpack .../15-libhtml-tagset-perl_3.24-1_all.deb ... 246s Unpacking libhtml-tagset-perl (3.24-1) ... 246s Selecting previously unselected package liburi-perl. 246s Preparing to unpack .../16-liburi-perl_5.28-1_all.deb ... 246s Unpacking liburi-perl (5.28-1) ... 246s Selecting previously unselected package libhtml-parser-perl:armhf. 246s Preparing to unpack .../17-libhtml-parser-perl_3.82-1_armhf.deb ... 246s Unpacking libhtml-parser-perl:armhf (3.82-1) ... 246s Selecting previously unselected package libcgi-pm-perl. 246s Preparing to unpack .../18-libcgi-pm-perl_4.66-1_all.deb ... 246s Unpacking libcgi-pm-perl (4.66-1) ... 246s Selecting previously unselected package libtimedate-perl. 246s Preparing to unpack .../19-libtimedate-perl_2.3300-2_all.deb ... 246s Unpacking libtimedate-perl (2.3300-2) ... 246s Selecting previously unselected package libhttp-date-perl. 246s Preparing to unpack .../20-libhttp-date-perl_6.06-1_all.deb ... 246s Unpacking libhttp-date-perl (6.06-1) ... 246s Selecting previously unselected package libfile-listing-perl. 246s Preparing to unpack .../21-libfile-listing-perl_6.16-1_all.deb ... 246s Unpacking libfile-listing-perl (6.16-1) ... 246s Selecting previously unselected package libtime-parsedate-perl. 246s Preparing to unpack .../22-libtime-parsedate-perl_2015.103-4_all.deb ... 246s Unpacking libtime-parsedate-perl (2015.103-4) ... 246s Selecting previously unselected package backuppc. 246s Preparing to unpack .../23-backuppc_4.4.0-8build1_armhf.deb ... 246s Unpacking backuppc (4.4.0-8build1) ... 246s Selecting previously unselected package samba-common. 246s Preparing to unpack .../24-samba-common_2%3a4.20.2+dfsg-2ubuntu2_all.deb ... 246s Unpacking samba-common (2:4.20.2+dfsg-2ubuntu2) ... 246s Selecting previously unselected package libavahi-common-data:armhf. 246s Preparing to unpack .../25-libavahi-common-data_0.8-13ubuntu6_armhf.deb ... 246s Unpacking libavahi-common-data:armhf (0.8-13ubuntu6) ... 246s Selecting previously unselected package libavahi-common3:armhf. 246s Preparing to unpack .../26-libavahi-common3_0.8-13ubuntu6_armhf.deb ... 246s Unpacking libavahi-common3:armhf (0.8-13ubuntu6) ... 246s Selecting previously unselected package libavahi-client3:armhf. 246s Preparing to unpack .../27-libavahi-client3_0.8-13ubuntu6_armhf.deb ... 246s Unpacking libavahi-client3:armhf (0.8-13ubuntu6) ... 246s Selecting previously unselected package libcups2t64:armhf. 246s Preparing to unpack .../28-libcups2t64_2.4.7-1.2ubuntu9_armhf.deb ... 246s Unpacking libcups2t64:armhf (2.4.7-1.2ubuntu9) ... 246s Selecting previously unselected package libtalloc2:armhf. 246s Preparing to unpack .../29-libtalloc2_2.4.2-1build2_armhf.deb ... 246s Unpacking libtalloc2:armhf (2.4.2-1build2) ... 246s Selecting previously unselected package libtdb1:armhf. 246s Preparing to unpack .../30-libtdb1_1.4.10-1build1_armhf.deb ... 246s Unpacking libtdb1:armhf (1.4.10-1build1) ... 246s Selecting previously unselected package libtevent0t64:armhf. 246s Preparing to unpack .../31-libtevent0t64_0.16.1-2build1_armhf.deb ... 246s Unpacking libtevent0t64:armhf (0.16.1-2build1) ... 246s Selecting previously unselected package libldb2:armhf. 246s Preparing to unpack .../32-libldb2_2%3a2.9.1+samba4.20.2+dfsg-2ubuntu2_armhf.deb ... 246s Unpacking libldb2:armhf (2:2.9.1+samba4.20.2+dfsg-2ubuntu2) ... 246s Selecting previously unselected package libwbclient0:armhf. 246s Preparing to unpack .../33-libwbclient0_2%3a4.20.2+dfsg-2ubuntu2_armhf.deb ... 246s Unpacking libwbclient0:armhf (2:4.20.2+dfsg-2ubuntu2) ... 246s Selecting previously unselected package samba-libs:armhf. 246s Preparing to unpack .../34-samba-libs_2%3a4.20.2+dfsg-2ubuntu2_armhf.deb ... 246s Unpacking samba-libs:armhf (2:4.20.2+dfsg-2ubuntu2) ... 246s Selecting previously unselected package samba-common-bin. 246s Preparing to unpack .../35-samba-common-bin_2%3a4.20.2+dfsg-2ubuntu2_armhf.deb ... 246s Unpacking samba-common-bin (2:4.20.2+dfsg-2ubuntu2) ... 247s Selecting previously unselected package samba. 247s Preparing to unpack .../36-samba_2%3a4.20.2+dfsg-2ubuntu2_armhf.deb ... 247s Unpacking samba (2:4.20.2+dfsg-2ubuntu2) ... 247s Selecting previously unselected package libsmbclient0:armhf. 247s Preparing to unpack .../37-libsmbclient0_2%3a4.20.2+dfsg-2ubuntu2_armhf.deb ... 247s Unpacking libsmbclient0:armhf (2:4.20.2+dfsg-2ubuntu2) ... 247s Selecting previously unselected package smbclient. 247s Preparing to unpack .../38-smbclient_2%3a4.20.2+dfsg-2ubuntu2_armhf.deb ... 247s Unpacking smbclient (2:4.20.2+dfsg-2ubuntu2) ... 247s Selecting previously unselected package autopkgtest-satdep. 247s Preparing to unpack .../39-1-autopkgtest-satdep.deb ... 247s Unpacking autopkgtest-satdep (0) ... 247s Setting up libarchive-zip-perl (1.68-1) ... 247s Setting up libtdb1:armhf (1.4.10-1build1) ... 247s Setting up libhtml-tagset-perl (3.24-1) ... 247s Setting up samba-common (2:4.20.2+dfsg-2ubuntu2) ... 247s 247s Creating config file /etc/samba/smb.conf with new version 247s Setting up libwbclient0:armhf (2:4.20.2+dfsg-2ubuntu2) ... 247s Setting up libtalloc2:armhf (2.4.2-1build2) ... 247s Setting up backuppc-rsync (3.1.3.0-3ubuntu1) ... 247s Setting up ssl-cert (1.1.2ubuntu2) ... 248s Created symlink '/etc/systemd/system/multi-user.target.wants/ssl-cert.service' → '/usr/lib/systemd/system/ssl-cert.service'. 249s Setting up libavahi-common-data:armhf (0.8-13ubuntu6) ... 249s Setting up libtimedate-perl (2.3300-2) ... 249s Setting up libtime-parsedate-perl (2015.103-4) ... 249s Setting up libapr1t64:armhf (1.7.2-3.2) ... 249s Setting up libnsl2:armhf (1.3.0-3build3) ... 249s Setting up liblua5.4-0:armhf (5.4.6-3build2) ... 249s Setting up apache2-data (2.4.59-2ubuntu2) ... 249s Setting up libbackuppc-xs-perl:armhf (0.62-2build5) ... 249s Setting up liburi-perl (5.28-1) ... 249s Setting up libtevent0t64:armhf (0.16.1-2build1) ... 249s Setting up libaprutil1t64:armhf (1.6.3-2ubuntu1) ... 249s Setting up libhttp-date-perl (6.06-1) ... 249s Setting up libfile-listing-perl (6.16-1) ... 249s Setting up libavahi-common3:armhf (0.8-13ubuntu6) ... 249s Setting up libaprutil1-ldap:armhf (1.6.3-2ubuntu1) ... 249s Setting up libaprutil1-dbd-sqlite3:armhf (1.6.3-2ubuntu1) ... 249s Setting up postfix (3.9.0-2) ... 249s info: Selecting GID from range 100 to 999 ... 249s info: Adding group `postfix' (GID 111) ... 249s info: Selecting UID from range 100 to 999 ... 249s 249s info: Adding system user `postfix' (UID 107) ... 249s info: Adding new user `postfix' (UID 107) with group `postfix' ... 249s info: Not creating home directory `/var/spool/postfix'. 249s Creating /etc/postfix/dynamicmaps.cf 249s info: Selecting GID from range 100 to 999 ... 249s info: Adding group `postdrop' (GID 112) ... 249s setting myhostname: autopkgtest-lxd-frmiiv 249s setting alias maps 249s setting alias database 249s mailname is not a fully qualified domain name. Not changing /etc/mailname. 249s setting destinations: $myhostname, autopkgtest-lxd-frmiiv, localhost.localdomain, , localhost 249s setting relayhost: 249s setting mynetworks: 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128 249s setting mailbox_size_limit: 0 249s setting recipient_delimiter: + 251s setting inet_interfaces: all 253s setting inet_protocols: all 253s /etc/aliases does not exist, creating it. 253s WARNING: /etc/aliases exists, but does not have a root alias. 253s 253s Postfix (main.cf) is now set up with a default configuration. If you need to 253s make changes, edit /etc/postfix/main.cf (and others) as needed. To view 253s Postfix configuration values, see postconf(1). 253s 253s After modifying main.cf, be sure to run 'systemctl reload postfix'. 253s 255s Running newaliases 256s Created symlink '/etc/systemd/system/multi-user.target.wants/postfix.service' → '/usr/lib/systemd/system/postfix.service'. 257s Setting up libhtml-parser-perl:armhf (3.82-1) ... 257s Setting up libldb2:armhf (2:2.9.1+samba4.20.2+dfsg-2ubuntu2) ... 257s Setting up libavahi-client3:armhf (0.8-13ubuntu6) ... 257s Setting up apache2-utils (2.4.59-2ubuntu2) ... 257s Setting up libcgi-pm-perl (4.66-1) ... 257s Setting up samba-libs:armhf (2:4.20.2+dfsg-2ubuntu2) ... 257s Setting up apache2-bin (2.4.59-2ubuntu2) ... 257s Setting up libsmbclient0:armhf (2:4.20.2+dfsg-2ubuntu2) ... 257s Setting up libcups2t64:armhf (2.4.7-1.2ubuntu9) ... 257s Setting up apache2 (2.4.59-2ubuntu2) ... 257s Enabling module mpm_event. 257s Enabling module authz_core. 257s Enabling module authz_host. 257s Enabling module authn_core. 257s Enabling module auth_basic. 257s Enabling module access_compat. 257s Enabling module authn_file. 257s Enabling module authz_user. 257s Enabling module alias. 257s Enabling module dir. 257s Enabling module autoindex. 257s Enabling module env. 257s Enabling module mime. 257s Enabling module negotiation. 257s Enabling module setenvif. 257s Enabling module filter. 257s Enabling module deflate. 257s Enabling module status. 257s Enabling module reqtimeout. 257s Enabling conf charset. 257s Enabling conf localized-error-pages. 257s Enabling conf other-vhosts-access-log. 257s Enabling conf security. 258s Enabling conf serve-cgi-bin. 258s Enabling site 000-default. 258s Created symlink '/etc/systemd/system/multi-user.target.wants/apache2.service' → '/usr/lib/systemd/system/apache2.service'. 259s Created symlink '/etc/systemd/system/multi-user.target.wants/apache-htcacheclean.service' → '/usr/lib/systemd/system/apache-htcacheclean.service'. 260s Setting up backuppc (4.4.0-8build1) ... 260s 260s apache2_invoke: Enable configuration backuppc.conf 260s warn: The home directory `/var/lib/backuppc' already exists. Not touching this directory. 260s warn: Warning: The home directory `/var/lib/backuppc' does not belong to the user you are currently creating. 260s Adding password for user backuppc 260s Considering dependency authn_core for auth_basic: 260s Module authn_core already enabled 260s Module auth_basic already enabled 260s Considering dependency authz_core for authz_groupfile: 260s Module authz_core already enabled 260s Enabling module authz_groupfile. 260s To activate the new configuration, you need to run: 260s systemctl restart apache2 260s Module authn_file already enabled 260s Considering dependency authz_core for authz_user: 260s Module authz_core already enabled 260s Module authz_user already enabled 260s Your MPM seems to be threaded. Selecting cgid instead of cgi. 260s Enabling module cgid. 260s To activate the new configuration, you need to run: 260s systemctl restart apache2 260s 260s Creating config file /etc/backuppc/config.pl with new version 261s Created symlink '/etc/systemd/system/multi-user.target.wants/backuppc.service' → '/usr/lib/systemd/system/backuppc.service'. 261s Setting up smbclient (2:4.20.2+dfsg-2ubuntu2) ... 261s Setting up samba-common-bin (2:4.20.2+dfsg-2ubuntu2) ... 261s Setting up samba (2:4.20.2+dfsg-2ubuntu2) ... 262s Created symlink '/etc/systemd/system/smb.service' → '/usr/lib/systemd/system/smbd.service'. 262s Created symlink '/etc/systemd/system/multi-user.target.wants/smbd.service' → '/usr/lib/systemd/system/smbd.service'. 263s Created symlink '/etc/systemd/system/nmb.service' → '/usr/lib/systemd/system/nmbd.service'. 263s Created symlink '/etc/systemd/system/multi-user.target.wants/nmbd.service' → '/usr/lib/systemd/system/nmbd.service'. 263s Setting up autopkgtest-satdep (0) ... 263s Processing triggers for rsyslog (8.2312.0-3ubuntu9) ... 263s Processing triggers for ufw (0.36.2-6) ... 263s Processing triggers for man-db (2.12.1-2) ... 264s Processing triggers for libc-bin (2.39-0ubuntu9) ... 279s (Reading database ... 60277 files and directories currently installed.) 279s Removing autopkgtest-satdep (0) ... 285s autopkgtest [11:41:13]: test smb-backup: [----------------------- 287s Populating share path 287s Adding samba share 287s Adding [public] share 287s Configuring backuppc 287s Performing a full backup 287s Backup type: type = full, needs_full = 1, needs_incr = 1, lastFullTime = 0, opts{f} = 1, opts{i} = , opts{F} = 287s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 287s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 287s CheckHostAlive: ran '/bin/ping -c 1 localhost'; returning 0.023 287s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.0.z created 2024-07-12 11:41:15 287s Backup prep: type = full, case = 1, inPlace = 1, doDuplicate = 0, newBkupNum = 0, newBkupIdx = 0, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = ) 287s __bpc_progress_state__ backup share "public" 287s Running: /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -Tc - 287s full backup started for share public 287s started full dump, share=public 287s Xfer PIDs are now 3342,3341 287s xferPids 3342,3341 287s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -Tc - 287s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 1 287s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 287s tarmode is now full, system, hidden, noreset, noverbose 287s __bpc_progress_fileCnt__ 0 287s new 644 0/0 480434 tmp.CBSWU9 287s new 644 0/0 480434 tmp.K47a3H 287s new 644 0/0 480434 tmp.oTWWOE 287s new 644 0/0 480434 tmp.zVjwY6 287s new 644 0/0 480434 tmp.UW2kuo 287s new 644 0/0 480434 tmp.eWfFLq 287s new 644 0/0 480434 tmp.AX3Az2 287s new 644 0/0 480434 tmp.vdU9mY 287s new 644 0/0 480434 tmp.KWa1ub 287s tar: dumped 10 files and 0 directories 287s Total bytes written: 4804340 (29.5 MiB/s) 287s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 287s new 644 0/0 480434 tmp.bPeyhl 287s __bpc_progress_fileCnt__ 10 287s tarExtract: Done: 0 errors, 0 filesExist, 0 sizeExist, 0 sizeExistComp, 10 filesTotal, 4804340 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377777 sizeNewComp, 13 inodeLast 287s Xfer PIDs are now 287s xferPids 287s full backup 0 complete, 10 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 287s BackupExpire: cntFull = 1, cntIncr = 0, firstFull = 0, firstIncr = , oldestIncr = 0, oldestFull = 0 287s __bpc_progress_state__ fsck 287s Running BackupPC_refCountUpdate -h localhost on localhost 287s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 287s Xfer PIDs are now 3348 287s xferPids 3348 287s BackupPC_refCountUpdate: doing fsck on localhost #0 (full) since $ConfRefCntFsck == 1 287s __bpc_progress_state__ refCnt #0 287s __bpc_progress_state__ cntUpdate #0 287s __bpc_progress_state__ rename #0 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 288s __bpc_progress_fileCnt__ 120/128 288s __bpc_progress_state__ rename total 288s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 288s Xfer PIDs are now 288s xferPids 288s Finished BackupPC_refCountUpdate (running time: 0 sec) 288s Xfer PIDs are now 288s xferPids 288s full backup complete 288s OK: Full backup succeeded 288s Changing share content and performing an incremental backup 288s Backup type: type = incr, needs_full = , needs_incr = , lastFullTime = 1720784475, opts{f} = , opts{i} = 1, opts{F} = 288s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 288s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 288s CheckHostAlive: ran '/bin/ping -c 1 localhost'; returning 0.022 288s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.1.z created 2024-07-12 11:41:16 288s Backup prep: type = incr, case = 3, inPlace = 1, doDuplicate = 1, newBkupNum = 1, newBkupIdx = 1, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = ) 288s Executing /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 288s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 288s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDuplicate line 89. 288s (Did you mean "$Host\'s" instead?) 288s Xfer PIDs are now 3418 288s xferPids 3418 288s __bpc_progress_state__ copy #0 -> #1 288s Copying backup #0 to #1 288s __bpc_progress_fileCnt__ 3 dirs 288s Xfer PIDs are now 3421,3418 288s xferPids 3421,3418 288s __bpc_progress_state__ sumUpdate 288s __bpc_progress_fileCnt__ 0/128 288s __bpc_progress_fileCnt__ 8/128 288s __bpc_progress_fileCnt__ 16/128 288s __bpc_progress_fileCnt__ 24/128 288s __bpc_progress_fileCnt__ 32/128 288s __bpc_progress_fileCnt__ 40/128 288s __bpc_progress_fileCnt__ 48/128 288s __bpc_progress_fileCnt__ 56/128 288s __bpc_progress_fileCnt__ 64/128 288s __bpc_progress_fileCnt__ 72/128 288s __bpc_progress_fileCnt__ 80/128 288s __bpc_progress_fileCnt__ 88/128 288s __bpc_progress_fileCnt__ 96/128 288s __bpc_progress_fileCnt__ 104/128 288s __bpc_progress_fileCnt__ 112/128 288s __bpc_progress_fileCnt__ 120/128 288s __bpc_progress_state__ rename total 288s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 288s Xfer PIDs are now 3418 288s xferPids 3418 288s BackupPC_backupDuplicate: got 0 errors and 0 file open errors 288s Finished BackupPC_backupDuplicate (running time: 0 sec) 288s __bpc_progress_state__ backup share "public" 288s Running: /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 288s incr backup started back to 2024-07-12 10:41:15 (backup #0) for share public 288s started incr dump, share=public 288s Xfer PIDs are now 3425,3424 288s xferPids 3425,3424 288s 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 - 288s tar:1298 Getting files newer than Fri Jul 12 10:41:15 2024 288s 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 same 644 0/0 480434 tmp.CBSWU9 288s same 644 0/0 480434 tmp.K47a3H 288s same 644 0/0 480434 tmp.oTWWOE 288s same 644 0/0 480434 tmp.zVjwY6 288s same 644 0/0 480434 tmp.UW2kuo 288s same 644 0/0 480434 tmp.eWfFLq 288s same 644 0/0 480434 tmp.AX3Az2 288s same 644 0/0 480434 tmp.vdU9mY 288s same 644 0/0 480434 tmp.KWa1ub 288s same 644 0/0 480434 tmp.bPeyhl 288s new 644 0/0 480434 tmp.DChe3H 288s new 644 0/0 480434 tmp.erau8c 288s new 644 0/0 480434 tmp.ETMFm2 288s new 644 0/0 480434 tmp.Lz6385 288s new 644 0/0 480434 tmp.Z3R7i1 288s new 644 0/0 480434 tmp.yyfMow 288s new 644 0/0 480434 tmp.oaqcsL 288s new 644 0/0 480434 tmp.QMgGlt 288s new 644 0/0 480434 tmp.yZ09aC 288s tar: dumped 20 files and 0 directories 288s Total bytes written: 9608680 (44.0 MiB/s) 288s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 288s new 644 0/0 480434 tmp.RBiOEt 288s __bpc_progress_fileCnt__ 20 288s tarExtract: Done: 0 errors, 10 filesExist, 4804340 sizeExist, 1377777 sizeExistComp, 20 filesTotal, 9608680 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377741 sizeNewComp, 24 inodeLast 288s Xfer PIDs are now 288s xferPids 288s incr backup 1 complete, 20 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 288s BackupExpire: cntFull = 2, cntIncr = 0, firstFull = 0, firstIncr = , oldestIncr = 0, oldestFull = 1.15740740740741e-05 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 288s Xfer PIDs are now 3431 288s xferPids 3431 288s __bpc_progress_state__ cntUpdate #1 288s __bpc_progress_state__ rename #1 288s __bpc_progress_state__ sumUpdate 288s __bpc_progress_fileCnt__ 0/128 288s __bpc_progress_fileCnt__ 8/128 288s __bpc_progress_fileCnt__ 16/128 288s __bpc_progress_fileCnt__ 24/128 288s __bpc_progress_fileCnt__ 32/128 288s __bpc_progress_fileCnt__ 40/128 288s __bpc_progress_fileCnt__ 48/128 288s __bpc_progress_fileCnt__ 56/128 288s __bpc_progress_fileCnt__ 64/128 288s __bpc_progress_fileCnt__ 72/128 288s __bpc_progress_fileCnt__ 80/128 288s __bpc_progress_fileCnt__ 88/128 288s __bpc_progress_fileCnt__ 96/128 288s __bpc_progress_fileCnt__ 104/128 288s __bpc_progress_fileCnt__ 112/128 288s __bpc_progress_fileCnt__ 120/128 288s __bpc_progress_state__ rename total 288s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 288s Xfer PIDs are now 288s xferPids 288s Finished BackupPC_refCountUpdate (running time: 0 sec) 288s Xfer PIDs are now 288s xferPids 288s incr backup complete 288s OK: Incremental backup succeeded 288s Done. 289s autopkgtest [11:41:17]: test smb-backup: -----------------------] 293s autopkgtest [11:41:21]: test smb-backup: - - - - - - - - - - results - - - - - - - - - - 293s smb-backup PASS 297s autopkgtest [11:41:25]: test authenticated-smb-backup: preparing testbed 307s Reading package lists... 307s Building dependency tree... 307s Reading state information... 307s Starting pkgProblemResolver with broken count: 0 307s Starting 2 pkgProblemResolver with broken count: 0 307s Done 308s The following NEW packages will be installed: 308s autopkgtest-satdep 308s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 308s Need to get 0 B/720 B of archives. 308s After this operation, 0 B of additional disk space will be used. 308s Get:1 /tmp/autopkgtest.TUDZFQ/2-autopkgtest-satdep.deb autopkgtest-satdep armhf 0 [720 B] 309s Selecting previously unselected package autopkgtest-satdep. 309s (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 ... 60278 files and directories currently installed.) 309s Preparing to unpack .../2-autopkgtest-satdep.deb ... 309s Unpacking autopkgtest-satdep (0) ... 309s Setting up autopkgtest-satdep (0) ... 318s (Reading database ... 60277 files and directories currently installed.) 318s Removing autopkgtest-satdep (0) ... 324s autopkgtest [11:41:52]: test authenticated-smb-backup: [----------------------- 326s Populating share path 326s Adding samba share 326s Adding [private] share 326s Creating user 326s Creating a local and samba user called smbtest3740 326s Setting samba password for the smbtest3740 user 326s Added user smbtest3740. 326s Configuring backuppc 326s Performing a full backup 326s Backup type: type = full, needs_full = , needs_incr = , lastFullTime = 1720784475, opts{f} = 1, opts{i} = , opts{F} = 326s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 326s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 326s CheckHostAlive: ran '/bin/ping -c 1 localhost'; returning 0.022 326s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.2.z created 2024-07-12 11:41:54 326s Backup prep: type = full, case = 4, inPlace = 0, doDuplicate = 0, newBkupNum = 2, newBkupIdx = 2, lastBkupNum = 1, lastBkupIdx = 1 (FillCycle = 0, noFillCnt = 0) 326s __bpc_progress_state__ backup share "private" 326s Running: /usr/bin/smbclient \\\\localhost\\private -U smbtest3740 -E -d 1 -c tarmode\ full -mSMB3 -Tc - 326s full backup started for share private 326s started full dump, share=private 326s Xfer PIDs are now 3834,3833 326s xferPids 3834,3833 326s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\private -U smbtest3740 -E -d 1 -c tarmode\ full -mSMB3 -Tc - 326s tarmode is now full, system, hidden, noreset, noverbose 326s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 1 326s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 326s __bpc_progress_fileCnt__ 0 326s new 644 0/0 480434 tmp.MuXM1T 326s new 644 0/0 480434 tmp.LyA1Yl 326s new 644 0/0 480434 tmp.dqzVQh 326s new 644 0/0 480434 tmp.1RfLn0 326s new 644 0/0 480434 tmp.75ldbd 326s new 644 0/0 480434 tmp.7KloIF 326s new 644 0/0 480434 tmp.oOWHmv 326s new 644 0/0 480434 tmp.JxxPAT 326s new 644 0/0 480434 tmp.ecgwZb 326s tar: dumped 10 files and 0 directories 326s Total bytes written: 4804340 (30.7 MiB/s) 326s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 326s new 644 0/0 480434 tmp.ZIkquF 326s __bpc_progress_fileCnt__ 10 326s tarExtract: Done: 0 errors, 0 filesExist, 0 sizeExist, 0 sizeExistComp, 10 filesTotal, 4804340 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377753 sizeNewComp, 36 inodeLast 326s Xfer PIDs are now 326s xferPids 326s OrphanShareNameClean: removing orphan share public from /var/lib/backuppc/pc/localhost/2 326s __bpc_progress_state__ delete share #2/public 326s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDelete -h localhost -n 2 -l -m -s public / 326s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDelete line 102. 326s (Did you mean "$Host\'s" instead?) 326s Xfer PIDs are now 3840 326s xferPids 3840 326s BackupPC_backupDelete: removing #2/public/ 326s __bpc_progress_state__ merge #2/public/ -> #1/public/ 326s BackupPC_backupDelete: Merge into backup 1/public/ 326s mergeDir: attr write to /var/lib/backuppc/pc/localhost/1/fpublic//attrib failed (digest was ) 326s bpc_attrib_dirWrite: can't open/create raw /var/lib/backuppc/pc/localhost/1/fpublic for writing 327s Xfer PIDs are now 3843,3840 327s xferPids 3843,3840 327s __bpc_progress_state__ refCnt #1 327s __bpc_progress_state__ cntUpdate #1 327s __bpc_progress_state__ rename #1 327s __bpc_progress_state__ refCnt #2 327s BackupPC_refCountUpdate: localhost #2 inodeLast set to 37 (was 24) 327s __bpc_progress_state__ cntUpdate #2 327s __bpc_progress_state__ rename #2 327s __bpc_progress_state__ sumUpdate 327s __bpc_progress_fileCnt__ 0/128 327s __bpc_progress_fileCnt__ 8/128 327s __bpc_progress_fileCnt__ 16/128 327s __bpc_progress_fileCnt__ 24/128 327s __bpc_progress_fileCnt__ 32/128 327s __bpc_progress_fileCnt__ 40/128 327s __bpc_progress_fileCnt__ 48/128 327s __bpc_progress_fileCnt__ 56/128 327s __bpc_progress_fileCnt__ 64/128 327s __bpc_progress_fileCnt__ 72/128 327s __bpc_progress_fileCnt__ 80/128 327s __bpc_progress_fileCnt__ 88/128 327s __bpc_progress_fileCnt__ 96/128 327s __bpc_progress_fileCnt__ 104/128 327s __bpc_progress_fileCnt__ 112/128 327s __bpc_progress_fileCnt__ 120/128 327s __bpc_progress_state__ rename total 327s BackupPC_refCountUpdate: host localhost got 0 errors (took 1 secs) 327s Xfer PIDs are now 3840 327s xferPids 3840 327s Xfer PIDs are now 327s xferPids 327s Finished BackupPC_backupDelete, status = 0 (running time: 1 sec) 327s Xfer PIDs are now 327s xferPids 327s full backup 2 complete, 10 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 327s BackupExpire: cntFull = 2, cntIncr = 1, firstFull = 0, firstIncr = 1, oldestIncr = 0.000451388888888889, oldestFull = 0.000462962962962963 327s __bpc_progress_state__ fsck 327s Running BackupPC_refCountUpdate -h localhost on localhost 327s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 327s Xfer PIDs are now 3846 327s xferPids 3846 327s BackupPC_refCountUpdate: doing fsck on localhost #2 (full) since $ConfRefCntFsck == 1 327s __bpc_progress_state__ refCnt #2 327s __bpc_progress_state__ cntUpdate #2 327s __bpc_progress_state__ rename #2 327s __bpc_progress_state__ sumUpdate 327s __bpc_progress_fileCnt__ 0/128 327s __bpc_progress_fileCnt__ 8/128 327s __bpc_progress_fileCnt__ 16/128 327s __bpc_progress_fileCnt__ 24/128 327s __bpc_progress_fileCnt__ 32/128 327s __bpc_progress_fileCnt__ 40/128 327s __bpc_progress_fileCnt__ 48/128 327s __bpc_progress_fileCnt__ 56/128 327s __bpc_progress_fileCnt__ 64/128 327s __bpc_progress_fileCnt__ 72/128 327s __bpc_progress_fileCnt__ 80/128 327s __bpc_progress_fileCnt__ 88/128 327s __bpc_progress_fileCnt__ 96/128 327s __bpc_progress_fileCnt__ 104/128 327s __bpc_progress_fileCnt__ 112/128 327s __bpc_progress_fileCnt__ 120/128 327s __bpc_progress_state__ rename total 327s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 327s Xfer PIDs are now 327s xferPids 327s Finished BackupPC_refCountUpdate (running time: 0 sec) 327s Xfer PIDs are now 327s xferPids 327s full backup complete 327s OK: Full backup succeeded 327s Changing share content and performing an incremental backup 327s Backup type: type = incr, needs_full = , needs_incr = , lastFullTime = 1720784514, opts{f} = , opts{i} = 1, opts{F} = 327s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 327s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 327s CheckHostAlive: ran '/bin/ping -c 1 localhost'; returning 0.021 327s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.3.z created 2024-07-12 11:41:55 327s Backup prep: type = incr, case = 3, inPlace = 1, doDuplicate = 1, newBkupNum = 3, newBkupIdx = 3, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = 1) 327s Executing /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 327s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 327s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDuplicate line 89. 327s (Did you mean "$Host\'s" instead?) 327s Xfer PIDs are now 3916 327s xferPids 3916 327s __bpc_progress_state__ copy #2 -> #3 327s Copying backup #2 to #3 327s __bpc_progress_fileCnt__ 3 dirs 327s Xfer PIDs are now 3916,3919 327s xferPids 3916,3919 327s __bpc_progress_state__ sumUpdate 327s __bpc_progress_fileCnt__ 0/128 327s __bpc_progress_fileCnt__ 8/128 327s __bpc_progress_fileCnt__ 16/128 327s __bpc_progress_fileCnt__ 24/128 327s __bpc_progress_fileCnt__ 32/128 327s __bpc_progress_fileCnt__ 40/128 327s __bpc_progress_fileCnt__ 48/128 327s __bpc_progress_fileCnt__ 56/128 327s __bpc_progress_fileCnt__ 64/128 327s __bpc_progress_fileCnt__ 72/128 327s __bpc_progress_fileCnt__ 80/128 327s __bpc_progress_fileCnt__ 88/128 327s __bpc_progress_fileCnt__ 96/128 327s __bpc_progress_fileCnt__ 104/128 327s __bpc_progress_fileCnt__ 112/128 327s __bpc_progress_fileCnt__ 120/128 327s __bpc_progress_state__ rename total 327s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 327s Xfer PIDs are now 3916 327s xferPids 3916 327s BackupPC_backupDuplicate: got 0 errors and 0 file open errors 327s Finished BackupPC_backupDuplicate (running time: 0 sec) 327s __bpc_progress_state__ backup share "private" 327s Running: /usr/bin/smbclient \\\\localhost\\private -U smbtest3740 -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 327s incr backup started back to 2024-07-12 10:41:54 (backup #2) for share private 327s started incr dump, share=private 327s Xfer PIDs are now 3923,3922 327s xferPids 3923,3922 327s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\private -U smbtest3740 -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 327s tar:1298 Getting files newer than Fri Jul 12 10:41:54 2024 327s tarmode is now full, system, hidden, noreset, noverbose 327s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 327s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 327s __bpc_progress_fileCnt__ 0 327s same 644 0/0 480434 tmp.MuXM1T 327s same 644 0/0 480434 tmp.LyA1Yl 327s same 644 0/0 480434 tmp.dqzVQh 327s same 644 0/0 480434 tmp.1RfLn0 327s same 644 0/0 480434 tmp.75ldbd 327s same 644 0/0 480434 tmp.7KloIF 327s same 644 0/0 480434 tmp.oOWHmv 327s same 644 0/0 480434 tmp.JxxPAT 327s same 644 0/0 480434 tmp.ecgwZb 327s same 644 0/0 480434 tmp.ZIkquF 327s new 644 0/0 480434 tmp.5sAojw 327s new 644 0/0 480434 tmp.9JSDsG 327s new 644 0/0 480434 tmp.1TIlXj 327s new 644 0/0 480434 tmp.9GNsDT 327s new 644 0/0 480434 tmp.XbHncJ 327s new 644 0/0 480434 tmp.MgRPhB 327s new 644 0/0 480434 tmp.IBpgqN 327s new 644 0/0 480434 tmp.x0DlLX 327s new 644 0/0 480434 tmp.qfk4kM 327s tar: dumped 20 files and 0 directories 327s Total bytes written: 9608680 (38.4 MiB/s) 327s new 644 0/0 480434 tmp.sMVon8 327s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 327s __bpc_progress_fileCnt__ 20 327s tarExtract: Done: 0 errors, 10 filesExist, 4804340 sizeExist, 1377753 sizeExistComp, 20 filesTotal, 9608680 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377779 sizeNewComp, 47 inodeLast 327s Xfer PIDs are now 327s xferPids 328s incr backup 3 complete, 20 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 328s BackupExpire: cntFull = 3, cntIncr = 1, firstFull = 0, firstIncr = 1, oldestIncr = 0.000451388888888889, oldestFull = 0.000462962962962963 328s __bpc_progress_state__ fsck 328s Running BackupPC_refCountUpdate -h localhost on localhost 328s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 328s Xfer PIDs are now 3929 328s xferPids 3929 328s __bpc_progress_state__ cntUpdate #3 328s __bpc_progress_state__ rename #3 328s __bpc_progress_state__ sumUpdate 328s __bpc_progress_fileCnt__ 0/128 328s __bpc_progress_fileCnt__ 8/128 328s __bpc_progress_fileCnt__ 16/128 328s __bpc_progress_fileCnt__ 24/128 328s __bpc_progress_fileCnt__ 32/128 328s __bpc_progress_fileCnt__ 40/128 328s __bpc_progress_fileCnt__ 48/128 328s __bpc_progress_fileCnt__ 56/128 328s __bpc_progress_fileCnt__ 64/128 328s __bpc_progress_fileCnt__ 72/128 328s __bpc_progress_fileCnt__ 80/128 328s __bpc_progress_fileCnt__ 88/128 328s __bpc_progress_fileCnt__ 96/128 328s __bpc_progress_fileCnt__ 104/128 328s __bpc_progress_fileCnt__ 112/128 328s __bpc_progress_fileCnt__ 120/128 328s __bpc_progress_state__ rename total 328s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 328s Xfer PIDs are now 328s xferPids 328s Finished BackupPC_refCountUpdate (running time: 1 sec) 328s Xfer PIDs are now 328s xferPids 328s incr backup complete 328s OK: Incremental backup succeeded 328s Done. 328s Deleted user smbtest3740. 328s userdel: smbtest3740 mail spool (/var/mail/smbtest3740) not found 330s autopkgtest [11:41:56]: test authenticated-smb-backup: -----------------------] 334s autopkgtest [11:42:02]: test authenticated-smb-backup: - - - - - - - - - - results - - - - - - - - - - 334s authenticated-smb-backup PASS 337s autopkgtest [11:42:05]: @@@@@@@@@@@@@@@@@@@@ summary 337s smb-backup PASS 337s authenticated-smb-backup PASS