0s autopkgtest [07:36:27]: starting date and time: 2024-06-17 07:36:27+0000 0s autopkgtest [07:36:27]: git checkout: 433ed4c Merge branch 'skia/nova_flock' into 'ubuntu/5.34+prod' 0s autopkgtest [07:36:27]: host juju-7f2275-prod-proposed-migration-environment-9; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.vcp02kv5/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:sendmail --apt-upgrade backuppc --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=sendmail/8.18.1-4 -- lxd -r lxd-armhf-10.145.243.171 lxd-armhf-10.145.243.171:autopkgtest/ubuntu/oracular/armhf 30s autopkgtest [07:36:57]: testbed dpkg architecture: armhf 31s autopkgtest [07:36:58]: testbed apt version: 2.9.5 31s autopkgtest [07:36:58]: @@@@@@@@@@@@@@@@@@@@ test bed setup 40s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [110 kB] 40s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [7052 B] 40s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [412 kB] 40s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [2576 B] 40s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [37.3 kB] 40s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main armhf Packages [35.8 kB] 40s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/restricted armhf Packages [1860 B] 40s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/universe armhf Packages [298 kB] 40s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse armhf Packages [2528 B] 41s Fetched 907 kB in 1s (796 kB/s) 41s Reading package lists... 58s tee: /proc/self/fd/2: Permission denied 83s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 83s Hit:2 http://ftpmaster.internal/ubuntu oracular InRelease 83s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease 83s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease 85s Reading package lists... 85s Reading package lists... 86s Building dependency tree... 86s Reading state information... 87s Calculating upgrade... 88s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 88s Reading package lists... 88s Building dependency tree... 88s Reading state information... 89s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 91s autopkgtest [07:37:58]: rebooting testbed after setup commands that affected boot 132s autopkgtest [07:38:39]: testbed running kernel: Linux 6.5.0-35-generic #35~22.04.1-Ubuntu SMP PREEMPT_DYNAMIC Tue May 7 11:19:33 UTC 2 167s autopkgtest [07:39:14]: @@@@@@@@@@@@@@@@@@@@ apt-source backuppc 182s Get:1 http://ftpmaster.internal/ubuntu oracular/main backuppc 4.4.0-8build1 (dsc) [2289 B] 182s Get:2 http://ftpmaster.internal/ubuntu oracular/main backuppc 4.4.0-8build1 (tar) [657 kB] 182s Get:3 http://ftpmaster.internal/ubuntu oracular/main backuppc 4.4.0-8build1 (diff) [61.1 kB] 183s gpgv: Signature made Mon Apr 8 15:54:41 2024 UTC 183s gpgv: using RSA key 4FB588A84C2DDE79A74C77876FA458DD1DB03F71 183s gpgv: issuer "juliank@ubuntu.com" 183s gpgv: Can't check signature: No public key 183s dpkg-source: warning: cannot verify inline signature for ./backuppc_4.4.0-8build1.dsc: no acceptable signature found 183s autopkgtest [07:39:30]: testing package backuppc version 4.4.0-8build1 186s autopkgtest [07:39:33]: build not needed 188s autopkgtest [07:39:35]: test smb-backup: preparing testbed 200s Reading package lists... 201s Building dependency tree... 201s Reading state information... 202s Starting pkgProblemResolver with broken count: 0 202s Starting 2 pkgProblemResolver with broken count: 0 202s Done 203s The following additional packages will be installed: 203s apache2 apache2-bin apache2-data apache2-utils backuppc backuppc-rsync 203s libapr1t64 libaprutil1-dbd-sqlite3 libaprutil1-ldap libaprutil1t64 203s libarchive-zip-perl libavahi-client3 libavahi-common-data libavahi-common3 203s libbackuppc-xs-perl libcgi-pm-perl libcups2t64 libfile-listing-perl 203s libhtml-parser-perl libhtml-tagset-perl libhttp-date-perl libldb2 203s liblua5.4-0 libnsl2 libpython3.12t64 libsmbclient0 libtalloc2 libtdb1 203s libtevent0t64 libtime-parsedate-perl libtimedate-perl liburi-perl 203s libwbclient0 postfix python3-dnspython python3-ldb python3-markdown 203s python3-samba python3-talloc python3-tdb samba samba-common samba-common-bin 203s samba-libs smbclient ssl-cert tdb-tools 203s Suggested packages: 203s apache2-doc apache2-suexec-pristine | apache2-suexec-custom www-browser 203s certbot | acme-tiny | acmetool | dehydrated | lacme | lecm | lego 203s libscgi-perl par2 w3m | www-browser cups-common libdata-dump-perl 203s libbusiness-isbn-perl libregexp-ipv6-perl libwww-perl mail-reader 203s postfix-cdb postfix-doc postfix-ldap postfix-lmdb postfix-mta-sts-resolver 203s postfix-mongodb postfix-mysql postfix-pcre postfix-pgsql postfix-sqlite 203s procmail sasl2-bin | dovecot-common python3-trio python3-aioquic python3-h2 203s python3-httpx python3-httpcore python-markdown-doc bind9 bind9utils ctdb 203s ldb-tools ntp | chrony winbind heimdal-clients cifs-utils 203s Recommended packages: 203s libio-dirent-perl rrdtool libcgi-fast-perl libhttp-message-perl python3-gpg 203s attr samba-dsdb-modules samba-vfs-modules samba-ad-provision 204s The following NEW packages will be installed: 204s apache2 apache2-bin apache2-data apache2-utils autopkgtest-satdep backuppc 204s backuppc-rsync libapr1t64 libaprutil1-dbd-sqlite3 libaprutil1-ldap 204s libaprutil1t64 libarchive-zip-perl libavahi-client3 libavahi-common-data 204s libavahi-common3 libbackuppc-xs-perl libcgi-pm-perl libcups2t64 204s libfile-listing-perl libhtml-parser-perl libhtml-tagset-perl 204s libhttp-date-perl libldb2 liblua5.4-0 libnsl2 libpython3.12t64 libsmbclient0 204s libtalloc2 libtdb1 libtevent0t64 libtime-parsedate-perl libtimedate-perl 204s liburi-perl libwbclient0 postfix python3-dnspython python3-ldb 204s python3-markdown python3-samba python3-talloc python3-tdb samba samba-common 204s samba-common-bin samba-libs smbclient ssl-cert tdb-tools 204s 0 upgraded, 48 newly installed, 0 to remove and 0 not upgraded. 204s Need to get 18.5 MB/18.5 MB of archives. 204s After this operation, 62.7 MB of additional disk space will be used. 204s Get:1 /tmp/autopkgtest.TbuxqK/1-autopkgtest-satdep.deb autopkgtest-satdep armhf 0 [724 B] 204s Get:2 http://ftpmaster.internal/ubuntu oracular/main armhf libapr1t64 armhf 1.7.2-3.2 [86.0 kB] 204s Get:3 http://ftpmaster.internal/ubuntu oracular/main armhf libaprutil1t64 armhf 1.6.3-2ubuntu1 [82.5 kB] 204s Get:4 http://ftpmaster.internal/ubuntu oracular/main armhf libaprutil1-dbd-sqlite3 armhf 1.6.3-2ubuntu1 [9584 B] 204s Get:5 http://ftpmaster.internal/ubuntu oracular/main armhf libaprutil1-ldap armhf 1.6.3-2ubuntu1 [8490 B] 204s Get:6 http://ftpmaster.internal/ubuntu oracular/main armhf liblua5.4-0 armhf 5.4.6-3build2 [133 kB] 204s Get:7 http://ftpmaster.internal/ubuntu oracular/main armhf apache2-bin armhf 2.4.59-2ubuntu2 [1206 kB] 205s Get:8 http://ftpmaster.internal/ubuntu oracular/main armhf apache2-data all 2.4.59-2ubuntu2 [163 kB] 205s Get:9 http://ftpmaster.internal/ubuntu oracular/main armhf apache2-utils armhf 2.4.59-2ubuntu2 [98.0 kB] 205s Get:10 http://ftpmaster.internal/ubuntu oracular/main armhf apache2 armhf 2.4.59-2ubuntu2 [90.3 kB] 205s Get:11 http://ftpmaster.internal/ubuntu oracular/main armhf backuppc-rsync armhf 3.1.3.0-3ubuntu1 [233 kB] 205s Get:12 http://ftpmaster.internal/ubuntu oracular/main armhf ssl-cert all 1.1.2ubuntu1 [17.8 kB] 205s Get:13 http://ftpmaster.internal/ubuntu oracular/main armhf libnsl2 armhf 1.3.0-3build3 [36.5 kB] 205s Get:14 http://ftpmaster.internal/ubuntu oracular/main armhf postfix armhf 3.9.0-2 [1203 kB] 205s Get:15 http://ftpmaster.internal/ubuntu oracular/main armhf libarchive-zip-perl all 1.68-1 [90.2 kB] 205s Get:16 http://ftpmaster.internal/ubuntu oracular/main armhf libbackuppc-xs-perl armhf 0.62-2build5 [59.7 kB] 205s Get:17 http://ftpmaster.internal/ubuntu oracular/main armhf libhtml-tagset-perl all 3.24-1 [14.1 kB] 205s Get:18 http://ftpmaster.internal/ubuntu oracular/main armhf liburi-perl all 5.28-1 [88.1 kB] 205s Get:19 http://ftpmaster.internal/ubuntu oracular/main armhf libhtml-parser-perl armhf 3.82-1 [82.4 kB] 205s Get:20 http://ftpmaster.internal/ubuntu oracular/main armhf libcgi-pm-perl all 4.65-1 [185 kB] 205s Get:21 http://ftpmaster.internal/ubuntu oracular/main armhf libtimedate-perl all 2.3300-2 [34.0 kB] 205s Get:22 http://ftpmaster.internal/ubuntu oracular/main armhf libhttp-date-perl all 6.06-1 [10.2 kB] 205s Get:23 http://ftpmaster.internal/ubuntu oracular/main armhf libfile-listing-perl all 6.16-1 [11.3 kB] 205s Get:24 http://ftpmaster.internal/ubuntu oracular/main armhf libtime-parsedate-perl all 2015.103-4 [28.6 kB] 205s Get:25 http://ftpmaster.internal/ubuntu oracular/main armhf backuppc armhf 4.4.0-8build1 [540 kB] 205s Get:26 http://ftpmaster.internal/ubuntu oracular/main armhf python3-dnspython all 2.6.1-1ubuntu1 [163 kB] 205s Get:27 http://ftpmaster.internal/ubuntu oracular/main armhf libtalloc2 armhf 2.4.2-1build2 [25.9 kB] 205s Get:28 http://ftpmaster.internal/ubuntu oracular/main armhf libtdb1 armhf 1.4.10-1build1 [43.1 kB] 205s Get:29 http://ftpmaster.internal/ubuntu oracular/main armhf libtevent0t64 armhf 0.16.1-2build1 [38.1 kB] 205s Get:30 http://ftpmaster.internal/ubuntu oracular/main armhf libldb2 armhf 2:2.8.0+samba4.19.5+dfsg-4ubuntu9 [163 kB] 205s Get:31 http://ftpmaster.internal/ubuntu oracular/main armhf libpython3.12t64 armhf 3.12.4-1 [2059 kB] 205s Get:32 http://ftpmaster.internal/ubuntu oracular/main armhf python3-ldb armhf 2:2.8.0+samba4.19.5+dfsg-4ubuntu9 [38.5 kB] 205s Get:33 http://ftpmaster.internal/ubuntu oracular/main armhf python3-tdb armhf 1.4.10-1build1 [14.2 kB] 205s Get:34 http://ftpmaster.internal/ubuntu oracular/main armhf python3-markdown all 3.6-1 [73.4 kB] 205s Get:35 http://ftpmaster.internal/ubuntu oracular/main armhf libavahi-common-data armhf 0.8-13ubuntu6 [29.7 kB] 205s Get:36 http://ftpmaster.internal/ubuntu oracular/main armhf libavahi-common3 armhf 0.8-13ubuntu6 [20.2 kB] 205s Get:37 http://ftpmaster.internal/ubuntu oracular/main armhf libavahi-client3 armhf 0.8-13ubuntu6 [24.2 kB] 205s Get:38 http://ftpmaster.internal/ubuntu oracular/main armhf libwbclient0 armhf 2:4.19.5+dfsg-4ubuntu9 [67.5 kB] 205s Get:39 http://ftpmaster.internal/ubuntu oracular/main armhf samba-libs armhf 2:4.19.5+dfsg-4ubuntu9 [5693 kB] 205s Get:40 http://ftpmaster.internal/ubuntu oracular/main armhf python3-talloc armhf 2.4.2-1build2 [11.9 kB] 205s Get:41 http://ftpmaster.internal/ubuntu oracular/main armhf python3-samba armhf 2:4.19.5+dfsg-4ubuntu9 [2488 kB] 205s Get:42 http://ftpmaster.internal/ubuntu oracular/main armhf samba-common all 2:4.19.5+dfsg-4ubuntu9 [64.1 kB] 205s Get:43 http://ftpmaster.internal/ubuntu oracular/main armhf libcups2t64 armhf 2.4.7-1.2ubuntu7 [240 kB] 205s Get:44 http://ftpmaster.internal/ubuntu oracular/main armhf samba-common-bin armhf 2:4.19.5+dfsg-4ubuntu9 [1213 kB] 205s Get:45 http://ftpmaster.internal/ubuntu oracular/main armhf tdb-tools armhf 1.4.10-1build1 [25.3 kB] 205s Get:46 http://ftpmaster.internal/ubuntu oracular/main armhf samba armhf 2:4.19.5+dfsg-4ubuntu9 [957 kB] 206s Get:47 http://ftpmaster.internal/ubuntu oracular/main armhf libsmbclient0 armhf 2:4.19.5+dfsg-4ubuntu9 [57.4 kB] 206s Get:48 http://ftpmaster.internal/ubuntu oracular/main armhf smbclient armhf 2:4.19.5+dfsg-4ubuntu9 [446 kB] 207s Preconfiguring packages ... 208s Fetched 18.5 MB in 2s (10.7 MB/s) 208s Selecting previously unselected package libapr1t64:armhf. 208s (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 ... 58342 files and directories currently installed.) 208s Preparing to unpack .../00-libapr1t64_1.7.2-3.2_armhf.deb ... 208s Unpacking libapr1t64:armhf (1.7.2-3.2) ... 208s Selecting previously unselected package libaprutil1t64:armhf. 208s Preparing to unpack .../01-libaprutil1t64_1.6.3-2ubuntu1_armhf.deb ... 208s Unpacking libaprutil1t64:armhf (1.6.3-2ubuntu1) ... 208s Selecting previously unselected package libaprutil1-dbd-sqlite3:armhf. 208s Preparing to unpack .../02-libaprutil1-dbd-sqlite3_1.6.3-2ubuntu1_armhf.deb ... 208s Unpacking libaprutil1-dbd-sqlite3:armhf (1.6.3-2ubuntu1) ... 208s Selecting previously unselected package libaprutil1-ldap:armhf. 208s Preparing to unpack .../03-libaprutil1-ldap_1.6.3-2ubuntu1_armhf.deb ... 208s Unpacking libaprutil1-ldap:armhf (1.6.3-2ubuntu1) ... 208s Selecting previously unselected package liblua5.4-0:armhf. 208s Preparing to unpack .../04-liblua5.4-0_5.4.6-3build2_armhf.deb ... 208s Unpacking liblua5.4-0:armhf (5.4.6-3build2) ... 208s Selecting previously unselected package apache2-bin. 209s Preparing to unpack .../05-apache2-bin_2.4.59-2ubuntu2_armhf.deb ... 209s Unpacking apache2-bin (2.4.59-2ubuntu2) ... 209s Selecting previously unselected package apache2-data. 209s Preparing to unpack .../06-apache2-data_2.4.59-2ubuntu2_all.deb ... 209s Unpacking apache2-data (2.4.59-2ubuntu2) ... 209s Selecting previously unselected package apache2-utils. 209s Preparing to unpack .../07-apache2-utils_2.4.59-2ubuntu2_armhf.deb ... 209s Unpacking apache2-utils (2.4.59-2ubuntu2) ... 209s Selecting previously unselected package apache2. 210s Preparing to unpack .../08-apache2_2.4.59-2ubuntu2_armhf.deb ... 210s Unpacking apache2 (2.4.59-2ubuntu2) ... 210s Selecting previously unselected package backuppc-rsync. 210s Preparing to unpack .../09-backuppc-rsync_3.1.3.0-3ubuntu1_armhf.deb ... 210s Unpacking backuppc-rsync (3.1.3.0-3ubuntu1) ... 210s Selecting previously unselected package ssl-cert. 210s Preparing to unpack .../10-ssl-cert_1.1.2ubuntu1_all.deb ... 210s Unpacking ssl-cert (1.1.2ubuntu1) ... 210s Selecting previously unselected package libnsl2:armhf. 210s Preparing to unpack .../11-libnsl2_1.3.0-3build3_armhf.deb ... 210s Unpacking libnsl2:armhf (1.3.0-3build3) ... 211s Selecting previously unselected package postfix. 211s Preparing to unpack .../12-postfix_3.9.0-2_armhf.deb ... 211s Unpacking postfix (3.9.0-2) ... 212s Selecting previously unselected package libarchive-zip-perl. 212s Preparing to unpack .../13-libarchive-zip-perl_1.68-1_all.deb ... 212s Unpacking libarchive-zip-perl (1.68-1) ... 212s Selecting previously unselected package libbackuppc-xs-perl:armhf. 212s Preparing to unpack .../14-libbackuppc-xs-perl_0.62-2build5_armhf.deb ... 212s Unpacking libbackuppc-xs-perl:armhf (0.62-2build5) ... 212s Selecting previously unselected package libhtml-tagset-perl. 212s Preparing to unpack .../15-libhtml-tagset-perl_3.24-1_all.deb ... 212s Unpacking libhtml-tagset-perl (3.24-1) ... 212s Selecting previously unselected package liburi-perl. 212s Preparing to unpack .../16-liburi-perl_5.28-1_all.deb ... 212s Unpacking liburi-perl (5.28-1) ... 212s Selecting previously unselected package libhtml-parser-perl:armhf. 212s Preparing to unpack .../17-libhtml-parser-perl_3.82-1_armhf.deb ... 212s Unpacking libhtml-parser-perl:armhf (3.82-1) ... 212s Selecting previously unselected package libcgi-pm-perl. 212s Preparing to unpack .../18-libcgi-pm-perl_4.65-1_all.deb ... 212s Unpacking libcgi-pm-perl (4.65-1) ... 212s Selecting previously unselected package libtimedate-perl. 212s Preparing to unpack .../19-libtimedate-perl_2.3300-2_all.deb ... 212s Unpacking libtimedate-perl (2.3300-2) ... 213s Selecting previously unselected package libhttp-date-perl. 213s Preparing to unpack .../20-libhttp-date-perl_6.06-1_all.deb ... 213s Unpacking libhttp-date-perl (6.06-1) ... 213s Selecting previously unselected package libfile-listing-perl. 213s Preparing to unpack .../21-libfile-listing-perl_6.16-1_all.deb ... 213s Unpacking libfile-listing-perl (6.16-1) ... 213s Selecting previously unselected package libtime-parsedate-perl. 213s Preparing to unpack .../22-libtime-parsedate-perl_2015.103-4_all.deb ... 213s Unpacking libtime-parsedate-perl (2015.103-4) ... 213s Selecting previously unselected package backuppc. 213s Preparing to unpack .../23-backuppc_4.4.0-8build1_armhf.deb ... 213s Unpacking backuppc (4.4.0-8build1) ... 213s Selecting previously unselected package python3-dnspython. 213s Preparing to unpack .../24-python3-dnspython_2.6.1-1ubuntu1_all.deb ... 213s Unpacking python3-dnspython (2.6.1-1ubuntu1) ... 213s Selecting previously unselected package libtalloc2:armhf. 213s Preparing to unpack .../25-libtalloc2_2.4.2-1build2_armhf.deb ... 213s Unpacking libtalloc2:armhf (2.4.2-1build2) ... 213s Selecting previously unselected package libtdb1:armhf. 213s Preparing to unpack .../26-libtdb1_1.4.10-1build1_armhf.deb ... 213s Unpacking libtdb1:armhf (1.4.10-1build1) ... 213s Selecting previously unselected package libtevent0t64:armhf. 213s Preparing to unpack .../27-libtevent0t64_0.16.1-2build1_armhf.deb ... 213s Unpacking libtevent0t64:armhf (0.16.1-2build1) ... 213s Selecting previously unselected package libldb2:armhf. 214s Preparing to unpack .../28-libldb2_2%3a2.8.0+samba4.19.5+dfsg-4ubuntu9_armhf.deb ... 214s Unpacking libldb2:armhf (2:2.8.0+samba4.19.5+dfsg-4ubuntu9) ... 214s Selecting previously unselected package libpython3.12t64:armhf. 214s Preparing to unpack .../29-libpython3.12t64_3.12.4-1_armhf.deb ... 214s Unpacking libpython3.12t64:armhf (3.12.4-1) ... 214s Selecting previously unselected package python3-ldb. 214s Preparing to unpack .../30-python3-ldb_2%3a2.8.0+samba4.19.5+dfsg-4ubuntu9_armhf.deb ... 214s Unpacking python3-ldb (2:2.8.0+samba4.19.5+dfsg-4ubuntu9) ... 214s Selecting previously unselected package python3-tdb. 214s Preparing to unpack .../31-python3-tdb_1.4.10-1build1_armhf.deb ... 214s Unpacking python3-tdb (1.4.10-1build1) ... 214s Selecting previously unselected package python3-markdown. 214s Preparing to unpack .../32-python3-markdown_3.6-1_all.deb ... 214s Unpacking python3-markdown (3.6-1) ... 214s Selecting previously unselected package libavahi-common-data:armhf. 214s Preparing to unpack .../33-libavahi-common-data_0.8-13ubuntu6_armhf.deb ... 214s Unpacking libavahi-common-data:armhf (0.8-13ubuntu6) ... 214s Selecting previously unselected package libavahi-common3:armhf. 214s Preparing to unpack .../34-libavahi-common3_0.8-13ubuntu6_armhf.deb ... 214s Unpacking libavahi-common3:armhf (0.8-13ubuntu6) ... 214s Selecting previously unselected package libavahi-client3:armhf. 215s Preparing to unpack .../35-libavahi-client3_0.8-13ubuntu6_armhf.deb ... 215s Unpacking libavahi-client3:armhf (0.8-13ubuntu6) ... 215s Selecting previously unselected package libwbclient0:armhf. 215s Preparing to unpack .../36-libwbclient0_2%3a4.19.5+dfsg-4ubuntu9_armhf.deb ... 215s Unpacking libwbclient0:armhf (2:4.19.5+dfsg-4ubuntu9) ... 215s Selecting previously unselected package samba-libs:armhf. 215s Preparing to unpack .../37-samba-libs_2%3a4.19.5+dfsg-4ubuntu9_armhf.deb ... 215s Unpacking samba-libs:armhf (2:4.19.5+dfsg-4ubuntu9) ... 215s Selecting previously unselected package python3-talloc:armhf. 215s Preparing to unpack .../38-python3-talloc_2.4.2-1build2_armhf.deb ... 215s Unpacking python3-talloc:armhf (2.4.2-1build2) ... 216s Selecting previously unselected package python3-samba. 216s Preparing to unpack .../39-python3-samba_2%3a4.19.5+dfsg-4ubuntu9_armhf.deb ... 216s Unpacking python3-samba (2:4.19.5+dfsg-4ubuntu9) ... 216s Selecting previously unselected package samba-common. 216s Preparing to unpack .../40-samba-common_2%3a4.19.5+dfsg-4ubuntu9_all.deb ... 216s Unpacking samba-common (2:4.19.5+dfsg-4ubuntu9) ... 216s Selecting previously unselected package libcups2t64:armhf. 216s Preparing to unpack .../41-libcups2t64_2.4.7-1.2ubuntu7_armhf.deb ... 216s Unpacking libcups2t64:armhf (2.4.7-1.2ubuntu7) ... 216s Selecting previously unselected package samba-common-bin. 217s Preparing to unpack .../42-samba-common-bin_2%3a4.19.5+dfsg-4ubuntu9_armhf.deb ... 217s Unpacking samba-common-bin (2:4.19.5+dfsg-4ubuntu9) ... 217s Selecting previously unselected package tdb-tools. 217s Preparing to unpack .../43-tdb-tools_1.4.10-1build1_armhf.deb ... 217s Unpacking tdb-tools (1.4.10-1build1) ... 217s Selecting previously unselected package samba. 217s Preparing to unpack .../44-samba_2%3a4.19.5+dfsg-4ubuntu9_armhf.deb ... 217s Unpacking samba (2:4.19.5+dfsg-4ubuntu9) ... 217s Selecting previously unselected package libsmbclient0:armhf. 217s Preparing to unpack .../45-libsmbclient0_2%3a4.19.5+dfsg-4ubuntu9_armhf.deb ... 217s Unpacking libsmbclient0:armhf (2:4.19.5+dfsg-4ubuntu9) ... 217s Selecting previously unselected package smbclient. 217s Preparing to unpack .../46-smbclient_2%3a4.19.5+dfsg-4ubuntu9_armhf.deb ... 217s Unpacking smbclient (2:4.19.5+dfsg-4ubuntu9) ... 217s Selecting previously unselected package autopkgtest-satdep. 217s Preparing to unpack .../47-1-autopkgtest-satdep.deb ... 217s Unpacking autopkgtest-satdep (0) ... 217s Setting up libarchive-zip-perl (1.68-1) ... 217s Setting up libtdb1:armhf (1.4.10-1build1) ... 217s Setting up libhtml-tagset-perl (3.24-1) ... 217s Setting up samba-common (2:4.19.5+dfsg-4ubuntu9) ... 218s 218s Creating config file /etc/samba/smb.conf with new version 219s Setting up libwbclient0:armhf (2:4.19.5+dfsg-4ubuntu9) ... 219s Setting up libtalloc2:armhf (2.4.2-1build2) ... 219s Setting up libpython3.12t64:armhf (3.12.4-1) ... 219s Setting up backuppc-rsync (3.1.3.0-3ubuntu1) ... 219s Setting up python3-tdb (1.4.10-1build1) ... 220s Setting up ssl-cert (1.1.2ubuntu1) ... 223s Created symlink /etc/systemd/system/multi-user.target.wants/ssl-cert.service → /usr/lib/systemd/system/ssl-cert.service. 225s Setting up libavahi-common-data:armhf (0.8-13ubuntu6) ... 225s Setting up tdb-tools (1.4.10-1build1) ... 225s update-alternatives: using /usr/bin/tdbbackup.tdbtools to provide /usr/bin/tdbbackup (tdbbackup) in auto mode 225s Setting up python3-markdown (3.6-1) ... 225s Setting up libtimedate-perl (2.3300-2) ... 225s Setting up libtime-parsedate-perl (2015.103-4) ... 225s Setting up python3-dnspython (2.6.1-1ubuntu1) ... 226s Setting up libapr1t64:armhf (1.7.2-3.2) ... 226s Setting up libnsl2:armhf (1.3.0-3build3) ... 226s Setting up liblua5.4-0:armhf (5.4.6-3build2) ... 226s Setting up apache2-data (2.4.59-2ubuntu2) ... 226s Setting up libbackuppc-xs-perl:armhf (0.62-2build5) ... 226s Setting up liburi-perl (5.28-1) ... 226s Setting up libtevent0t64:armhf (0.16.1-2build1) ... 226s Setting up libaprutil1t64:armhf (1.6.3-2ubuntu1) ... 226s Setting up libhttp-date-perl (6.06-1) ... 226s Setting up libfile-listing-perl (6.16-1) ... 226s Setting up python3-talloc:armhf (2.4.2-1build2) ... 226s Setting up libavahi-common3:armhf (0.8-13ubuntu6) ... 226s Setting up libaprutil1-ldap:armhf (1.6.3-2ubuntu1) ... 226s Setting up libaprutil1-dbd-sqlite3:armhf (1.6.3-2ubuntu1) ... 226s Setting up postfix (3.9.0-2) ... 226s info: Selecting GID from range 100 to 999 ... 226s info: Adding group `postfix' (GID 111) ... 226s info: Selecting UID from range 100 to 999 ... 226s 227s info: Adding system user `postfix' (UID 107) ... 227s info: Adding new user `postfix' (UID 107) with group `postfix' ... 227s info: Not creating home directory `/var/spool/postfix'. 227s Creating /etc/postfix/dynamicmaps.cf 227s info: Selecting GID from range 100 to 999 ... 227s info: Adding group `postdrop' (GID 112) ... 227s setting myhostname: autopkgtest-lxd-tkxufm.lxd 227s setting alias maps 227s setting alias database 227s changing /etc/mailname to autopkgtest-lxd-tkxufm.lxd 227s setting myorigin 227s setting destinations: $myhostname, autopkgtest-lxd-tkxufm.lxd, localhost.lxd, , localhost 227s setting relayhost: 227s setting mynetworks: 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128 227s setting mailbox_size_limit: 0 227s setting recipient_delimiter: + 229s setting inet_interfaces: all 231s setting inet_protocols: all 231s /etc/aliases does not exist, creating it. 231s WARNING: /etc/aliases exists, but does not have a root alias. 231s 231s Postfix (main.cf) is now set up with a default configuration. If you need to 231s make changes, edit /etc/postfix/main.cf (and others) as needed. To view 231s Postfix configuration values, see postconf(1). 231s 231s After modifying main.cf, be sure to run 'systemctl reload postfix'. 231s 233s Running newaliases 234s Created symlink /etc/systemd/system/multi-user.target.wants/postfix.service → /usr/lib/systemd/system/postfix.service. 236s Setting up libhtml-parser-perl:armhf (3.82-1) ... 236s Setting up libldb2:armhf (2:2.8.0+samba4.19.5+dfsg-4ubuntu9) ... 236s Setting up libavahi-client3:armhf (0.8-13ubuntu6) ... 236s Setting up apache2-utils (2.4.59-2ubuntu2) ... 236s Setting up libcgi-pm-perl (4.65-1) ... 236s Setting up samba-libs:armhf (2:4.19.5+dfsg-4ubuntu9) ... 236s Setting up apache2-bin (2.4.59-2ubuntu2) ... 236s Setting up python3-ldb (2:2.8.0+samba4.19.5+dfsg-4ubuntu9) ... 236s Setting up libsmbclient0:armhf (2:4.19.5+dfsg-4ubuntu9) ... 236s Setting up libcups2t64:armhf (2.4.7-1.2ubuntu7) ... 236s Setting up python3-samba (2:4.19.5+dfsg-4ubuntu9) ... 237s Setting up apache2 (2.4.59-2ubuntu2) ... 237s Enabling module mpm_event. 237s Enabling module authz_core. 238s Enabling module authz_host. 238s Enabling module authn_core. 238s Enabling module auth_basic. 238s Enabling module access_compat. 238s Enabling module authn_file. 238s Enabling module authz_user. 238s Enabling module alias. 238s Enabling module dir. 238s Enabling module autoindex. 238s Enabling module env. 238s Enabling module mime. 238s Enabling module negotiation. 238s Enabling module setenvif. 238s Enabling module filter. 238s Enabling module deflate. 238s Enabling module status. 238s Enabling module reqtimeout. 239s Enabling conf charset. 239s Enabling conf localized-error-pages. 239s Enabling conf other-vhosts-access-log. 239s Enabling conf security. 239s Enabling conf serve-cgi-bin. 239s Enabling site 000-default. 240s Created symlink /etc/systemd/system/multi-user.target.wants/apache2.service → /usr/lib/systemd/system/apache2.service. 241s Created symlink /etc/systemd/system/multi-user.target.wants/apache-htcacheclean.service → /usr/lib/systemd/system/apache-htcacheclean.service. 243s Setting up backuppc (4.4.0-8build1) ... 243s 244s apache2_invoke: Enable configuration backuppc.conf 245s warn: The home directory `/var/lib/backuppc' already exists. Not touching this directory. 245s warn: Warning: The home directory `/var/lib/backuppc' does not belong to the user you are currently creating. 245s Adding password for user backuppc 245s Considering dependency authn_core for auth_basic: 245s Module authn_core already enabled 245s Module auth_basic already enabled 245s Considering dependency authz_core for authz_groupfile: 245s Module authz_core already enabled 245s Enabling module authz_groupfile. 245s To activate the new configuration, you need to run: 245s systemctl restart apache2 245s Module authn_file already enabled 245s Considering dependency authz_core for authz_user: 245s Module authz_core already enabled 245s Module authz_user already enabled 245s Your MPM seems to be threaded. Selecting cgid instead of cgi. 245s Enabling module cgid. 245s To activate the new configuration, you need to run: 245s systemctl restart apache2 246s 246s Creating config file /etc/backuppc/config.pl with new version 246s Created symlink /etc/systemd/system/multi-user.target.wants/backuppc.service → /usr/lib/systemd/system/backuppc.service. 247s Setting up smbclient (2:4.19.5+dfsg-4ubuntu9) ... 247s Setting up samba-common-bin (2:4.19.5+dfsg-4ubuntu9) ... 247s Setting up samba (2:4.19.5+dfsg-4ubuntu9) ... 249s Created symlink /etc/systemd/system/smb.service → /usr/lib/systemd/system/smbd.service. 249s Created symlink /etc/systemd/system/multi-user.target.wants/smbd.service → /usr/lib/systemd/system/smbd.service. 251s Created symlink /etc/systemd/system/nmb.service → /usr/lib/systemd/system/nmbd.service. 251s Created symlink /etc/systemd/system/multi-user.target.wants/nmbd.service → /usr/lib/systemd/system/nmbd.service. 253s Created symlink /etc/systemd/system/samba.service → /usr/lib/systemd/system/samba-ad-dc.service. 253s Created symlink /etc/systemd/system/multi-user.target.wants/samba-ad-dc.service → /usr/lib/systemd/system/samba-ad-dc.service. 253s Setting up autopkgtest-satdep (0) ... 253s Processing triggers for rsyslog (8.2312.0-3ubuntu9) ... 254s Processing triggers for ufw (0.36.2-6) ... 254s Processing triggers for man-db (2.12.1-2) ... 256s Processing triggers for libc-bin (2.39-0ubuntu9) ... 276s (Reading database ... 60715 files and directories currently installed.) 276s Removing autopkgtest-satdep (0) ... 282s autopkgtest [07:41:09]: test smb-backup: [----------------------- 286s Populating share path 286s Adding samba share 286s Adding [public] share 286s Configuring backuppc 286s 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.053 287s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.0.z created 2024-06-17 07:41:14 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 3455,3454 287s xferPids 3455,3454 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.q6uFaC 287s new 644 0/0 480434 tmp.hIvGng 287s new 644 0/0 480434 tmp.tCXjqj 287s new 644 0/0 480434 tmp.eHewjl 287s new 644 0/0 480434 tmp.YhWMMz 287s new 644 0/0 480434 tmp.yISCxF 287s new 644 0/0 480434 tmp.vUSqBe 287s new 644 0/0 480434 tmp.OQgLdO 288s new 644 0/0 480434 tmp.MC1JFl 288s tar: dumped 10 files and 0 directories 288s Total bytes written: 4804340 (11.4 MiB/s) 288s new 644 0/0 480434 tmp.xzDSxp 288s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 288s __bpc_progress_fileCnt__ 10 288s tarExtract: Done: 0 errors, 0 filesExist, 0 sizeExist, 0 sizeExistComp, 10 filesTotal, 4804340 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377762 sizeNewComp, 13 inodeLast 288s Xfer PIDs are now 288s xferPids 288s full backup 0 complete, 10 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 288s BackupExpire: cntFull = 1, 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 3461 288s xferPids 3461 288s BackupPC_refCountUpdate: doing fsck on localhost #0 (full) since $ConfRefCntFsck == 1 288s __bpc_progress_state__ refCnt #0 288s __bpc_progress_state__ cntUpdate #0 288s __bpc_progress_state__ rename #0 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 full backup complete 288s OK: Full backup succeeded 288s Changing share content and performing an incremental backup 289s Backup type: type = incr, needs_full = , needs_incr = , lastFullTime = 1718610074, opts{f} = , opts{i} = 1, opts{F} = 289s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 289s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 289s CheckHostAlive: ran '/bin/ping -c 1 localhost'; returning 0.131 289s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.1.z created 2024-06-17 07:41:16 289s Backup prep: type = incr, case = 3, inPlace = 1, doDuplicate = 1, newBkupNum = 1, newBkupIdx = 1, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = ) 289s Executing /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 289s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 289s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDuplicate line 89. 289s (Did you mean "$Host\'s" instead?) 289s Xfer PIDs are now 3531 289s xferPids 3531 289s __bpc_progress_state__ copy #0 -> #1 289s Copying backup #0 to #1 289s __bpc_progress_fileCnt__ 3 dirs 289s Xfer PIDs are now 3531,3534 289s xferPids 3531,3534 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 3531 289s xferPids 3531 289s BackupPC_backupDuplicate: got 0 errors and 0 file open errors 289s Finished BackupPC_backupDuplicate (running time: 0 sec) 289s __bpc_progress_state__ backup share "public" 289s Running: /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 289s incr backup started back to 2024-06-17 06:41:14 (backup #0) for share public 289s started incr dump, share=public 289s Xfer PIDs are now 3538,3537 289s xferPids 3538,3537 289s 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 - 289s tar:1298 Getting files newer than Mon Jun 17 06:41:14 2024 289s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 290s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 290s tarmode is now full, system, hidden, noreset, noverbose 290s __bpc_progress_fileCnt__ 0 290s same 644 0/0 480434 tmp.q6uFaC 290s same 644 0/0 480434 tmp.hIvGng 290s same 644 0/0 480434 tmp.tCXjqj 290s same 644 0/0 480434 tmp.eHewjl 290s same 644 0/0 480434 tmp.YhWMMz 290s same 644 0/0 480434 tmp.yISCxF 290s same 644 0/0 480434 tmp.vUSqBe 290s same 644 0/0 480434 tmp.OQgLdO 290s same 644 0/0 480434 tmp.MC1JFl 290s same 644 0/0 480434 tmp.xzDSxp 290s new 644 0/0 480434 tmp.nAUDTg 290s new 644 0/0 480434 tmp.ah4xYM 290s new 644 0/0 480434 tmp.00l0WX 290s new 644 0/0 480434 tmp.H4kBEC 290s new 644 0/0 480434 tmp.64cfss 290s new 644 0/0 480434 tmp.gneFuI 290s new 644 0/0 480434 tmp.Q0qLs9 290s new 644 0/0 480434 tmp.Cbz4zY 290s new 644 0/0 480434 tmp.HUOIgx 290s tar: dumped 20 files and 0 directories 290s Total bytes written: 9608680 (15.8 MiB/s) 290s new 644 0/0 480434 tmp.ceHstz 290s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 290s __bpc_progress_fileCnt__ 20 290s tarExtract: Done: 0 errors, 10 filesExist, 4804340 sizeExist, 1377762 sizeExistComp, 20 filesTotal, 9608680 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377762 sizeNewComp, 24 inodeLast 290s Xfer PIDs are now 290s xferPids 290s incr backup 1 complete, 20 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 290s BackupExpire: cntFull = 2, cntIncr = 0, firstFull = 0, firstIncr = , oldestIncr = 0, oldestFull = 3.47222222222222e-05 290s __bpc_progress_state__ fsck 290s Running BackupPC_refCountUpdate -h localhost on localhost 290s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 290s Xfer PIDs are now 3544 290s xferPids 3544 290s __bpc_progress_state__ cntUpdate #1 290s __bpc_progress_state__ rename #1 290s __bpc_progress_state__ sumUpdate 290s __bpc_progress_fileCnt__ 0/128 290s __bpc_progress_fileCnt__ 8/128 290s __bpc_progress_fileCnt__ 16/128 290s __bpc_progress_fileCnt__ 24/128 290s __bpc_progress_fileCnt__ 32/128 290s __bpc_progress_fileCnt__ 40/128 290s __bpc_progress_fileCnt__ 48/128 290s __bpc_progress_fileCnt__ 56/128 290s __bpc_progress_fileCnt__ 64/128 290s __bpc_progress_fileCnt__ 72/128 290s __bpc_progress_fileCnt__ 80/128 290s __bpc_progress_fileCnt__ 88/128 290s __bpc_progress_fileCnt__ 96/128 290s __bpc_progress_fileCnt__ 104/128 290s __bpc_progress_fileCnt__ 112/128 291s __bpc_progress_fileCnt__ 120/128 291s __bpc_progress_state__ rename total 291s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 291s Xfer PIDs are now 291s xferPids 291s Finished BackupPC_refCountUpdate (running time: 0 sec) 291s Xfer PIDs are now 291s xferPids 291s incr backup complete 291s OK: Incremental backup succeeded 291s Done. 291s autopkgtest [07:41:18]: test smb-backup: -----------------------] 296s autopkgtest [07:41:23]: test smb-backup: - - - - - - - - - - results - - - - - - - - - - 296s smb-backup PASS 300s autopkgtest [07:41:27]: test authenticated-smb-backup: preparing testbed 311s Reading package lists... 311s Building dependency tree... 311s Reading state information... 312s Starting pkgProblemResolver with broken count: 0 312s Starting 2 pkgProblemResolver with broken count: 0 312s Done 313s The following NEW packages will be installed: 313s autopkgtest-satdep 313s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 313s Need to get 0 B/724 B of archives. 313s After this operation, 0 B of additional disk space will be used. 313s Get:1 /tmp/autopkgtest.TbuxqK/2-autopkgtest-satdep.deb autopkgtest-satdep armhf 0 [724 B] 314s Selecting previously unselected package autopkgtest-satdep. 315s (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 ... 60716 files and directories currently installed.) 315s Preparing to unpack .../2-autopkgtest-satdep.deb ... 315s Unpacking autopkgtest-satdep (0) ... 315s Setting up autopkgtest-satdep (0) ... 326s (Reading database ... 60715 files and directories currently installed.) 326s Removing autopkgtest-satdep (0) ... 333s autopkgtest [07:42:00]: test authenticated-smb-backup: [----------------------- 336s Populating share path 336s Adding samba share 336s Adding [private] share 337s Creating user 337s Creating a local and samba user called smbtest3833 337s Setting samba password for the smbtest3833 user 337s Added user smbtest3833. 337s Configuring backuppc 337s Performing a full backup 338s Backup type: type = full, needs_full = , needs_incr = , lastFullTime = 1718610074, opts{f} = 1, opts{i} = , opts{F} = 338s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 338s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 338s CheckHostAlive: ran '/bin/ping -c 1 localhost'; returning 0.063 338s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.2.z created 2024-06-17 07:42:05 338s Backup prep: type = full, case = 4, inPlace = 0, doDuplicate = 0, newBkupNum = 2, newBkupIdx = 2, lastBkupNum = 1, lastBkupIdx = 1 (FillCycle = 0, noFillCnt = 0) 338s __bpc_progress_state__ backup share "private" 338s Running: /usr/bin/smbclient \\\\localhost\\private -U smbtest3833 -E -d 1 -c tarmode\ full -mSMB3 -Tc - 338s full backup started for share private 338s started full dump, share=private 338s Xfer PIDs are now 3927,3926 338s xferPids 3927,3926 338s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\private -U smbtest3833 -E -d 1 -c tarmode\ full -mSMB3 -Tc - 338s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 1 338s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 338s tarmode is now full, system, hidden, noreset, noverbose 338s __bpc_progress_fileCnt__ 0 338s new 644 0/0 480434 tmp.f1cQd5 338s new 644 0/0 480434 tmp.75NrqZ 338s new 644 0/0 480434 tmp.qxh0Fk 338s new 644 0/0 480434 tmp.atqXfX 338s new 644 0/0 480434 tmp.if9yB5 338s new 644 0/0 480434 tmp.0JzDCE 338s new 644 0/0 480434 tmp.uNwYeT 338s new 644 0/0 480434 tmp.IZyYi8 338s new 644 0/0 480434 tmp.jYLSml 338s tar: dumped 10 files and 0 directories 338s Total bytes written: 4804340 (21.8 MiB/s) 338s new 644 0/0 480434 tmp.6L9Hly 338s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 339s __bpc_progress_fileCnt__ 10 339s tarExtract: Done: 0 errors, 0 filesExist, 0 sizeExist, 0 sizeExistComp, 10 filesTotal, 4804340 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377760 sizeNewComp, 36 inodeLast 339s Xfer PIDs are now 339s xferPids 339s OrphanShareNameClean: removing orphan share public from /var/lib/backuppc/pc/localhost/2 339s __bpc_progress_state__ delete share #2/public 339s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDelete -h localhost -n 2 -l -m -s public / 339s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDelete line 102. 339s (Did you mean "$Host\'s" instead?) 339s Xfer PIDs are now 3933 339s xferPids 3933 339s BackupPC_backupDelete: removing #2/public/ 339s __bpc_progress_state__ merge #2/public/ -> #1/public/ 339s BackupPC_backupDelete: Merge into backup 1/public/ 339s mergeDir: attr write to /var/lib/backuppc/pc/localhost/1/fpublic//attrib failed (digest was ) 339s bpc_attrib_dirWrite: can't open/create raw /var/lib/backuppc/pc/localhost/1/fpublic for writing 339s Xfer PIDs are now 3933,3936 339s xferPids 3933,3936 339s __bpc_progress_state__ refCnt #1 339s __bpc_progress_state__ cntUpdate #1 339s __bpc_progress_state__ rename #1 339s __bpc_progress_state__ refCnt #2 339s BackupPC_refCountUpdate: localhost #2 inodeLast set to 37 (was 24) 339s __bpc_progress_state__ cntUpdate #2 339s __bpc_progress_state__ rename #2 339s __bpc_progress_state__ sumUpdate 339s __bpc_progress_fileCnt__ 0/128 339s __bpc_progress_fileCnt__ 8/128 339s __bpc_progress_fileCnt__ 16/128 339s __bpc_progress_fileCnt__ 24/128 339s __bpc_progress_fileCnt__ 32/128 339s __bpc_progress_fileCnt__ 40/128 339s __bpc_progress_fileCnt__ 48/128 339s __bpc_progress_fileCnt__ 56/128 339s __bpc_progress_fileCnt__ 64/128 339s __bpc_progress_fileCnt__ 72/128 339s __bpc_progress_fileCnt__ 80/128 339s __bpc_progress_fileCnt__ 88/128 339s __bpc_progress_fileCnt__ 96/128 339s __bpc_progress_fileCnt__ 104/128 339s __bpc_progress_fileCnt__ 112/128 339s __bpc_progress_fileCnt__ 120/128 339s __bpc_progress_state__ rename total 339s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 339s Xfer PIDs are now 3933 339s xferPids 3933 339s Xfer PIDs are now 339s xferPids 339s Finished BackupPC_backupDelete, status = 0 (running time: 1 sec) 339s Xfer PIDs are now 339s xferPids 339s full backup 2 complete, 10 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 339s BackupExpire: cntFull = 2, cntIncr = 1, firstFull = 0, firstIncr = 1, oldestIncr = 0.000578703703703704, oldestFull = 0.000601851851851852 339s __bpc_progress_state__ fsck 339s Running BackupPC_refCountUpdate -h localhost on localhost 339s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 339s Xfer PIDs are now 3939 339s xferPids 3939 339s BackupPC_refCountUpdate: doing fsck on localhost #2 (full) since $ConfRefCntFsck == 1 339s __bpc_progress_state__ refCnt #2 339s __bpc_progress_state__ cntUpdate #2 339s __bpc_progress_state__ rename #2 339s __bpc_progress_state__ sumUpdate 339s __bpc_progress_fileCnt__ 0/128 339s __bpc_progress_fileCnt__ 8/128 339s __bpc_progress_fileCnt__ 16/128 339s __bpc_progress_fileCnt__ 24/128 339s __bpc_progress_fileCnt__ 32/128 339s __bpc_progress_fileCnt__ 40/128 339s __bpc_progress_fileCnt__ 48/128 339s __bpc_progress_fileCnt__ 56/128 339s __bpc_progress_fileCnt__ 64/128 339s __bpc_progress_fileCnt__ 72/128 339s __bpc_progress_fileCnt__ 80/128 339s __bpc_progress_fileCnt__ 88/128 339s __bpc_progress_fileCnt__ 96/128 339s __bpc_progress_fileCnt__ 104/128 339s __bpc_progress_fileCnt__ 112/128 339s __bpc_progress_fileCnt__ 120/128 339s __bpc_progress_state__ rename total 339s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 339s Xfer PIDs are now 339s xferPids 339s Finished BackupPC_refCountUpdate (running time: 0 sec) 339s Xfer PIDs are now 339s xferPids 339s full backup complete 339s OK: Full backup succeeded 339s Changing share content and performing an incremental backup 340s Backup type: type = incr, needs_full = , needs_incr = , lastFullTime = 1718610125, opts{f} = , opts{i} = 1, opts{F} = 340s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 340s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 340s CheckHostAlive: ran '/bin/ping -c 1 localhost'; returning 0.064 340s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.3.z created 2024-06-17 07:42:07 340s Backup prep: type = incr, case = 3, inPlace = 1, doDuplicate = 1, newBkupNum = 3, newBkupIdx = 3, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = 1) 340s Executing /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 340s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 340s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDuplicate line 89. 340s (Did you mean "$Host\'s" instead?) 340s Xfer PIDs are now 4009 340s xferPids 4009 340s __bpc_progress_state__ copy #2 -> #3 340s Copying backup #2 to #3 340s __bpc_progress_fileCnt__ 3 dirs 340s Xfer PIDs are now 4009,4012 340s xferPids 4009,4012 340s __bpc_progress_state__ sumUpdate 340s __bpc_progress_fileCnt__ 0/128 340s __bpc_progress_fileCnt__ 8/128 341s __bpc_progress_fileCnt__ 16/128 341s __bpc_progress_fileCnt__ 24/128 341s __bpc_progress_fileCnt__ 32/128 341s __bpc_progress_fileCnt__ 40/128 341s __bpc_progress_fileCnt__ 48/128 341s __bpc_progress_fileCnt__ 56/128 341s __bpc_progress_fileCnt__ 64/128 341s __bpc_progress_fileCnt__ 72/128 341s __bpc_progress_fileCnt__ 80/128 341s __bpc_progress_fileCnt__ 88/128 341s __bpc_progress_fileCnt__ 96/128 341s __bpc_progress_fileCnt__ 104/128 341s __bpc_progress_fileCnt__ 112/128 341s __bpc_progress_fileCnt__ 120/128 341s __bpc_progress_state__ rename total 341s BackupPC_refCountUpdate: host localhost got 0 errors (took 1 secs) 341s Xfer PIDs are now 4009 341s xferPids 4009 341s BackupPC_backupDuplicate: got 0 errors and 0 file open errors 341s Finished BackupPC_backupDuplicate (running time: 1 sec) 341s __bpc_progress_state__ backup share "private" 341s Running: /usr/bin/smbclient \\\\localhost\\private -U smbtest3833 -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 341s incr backup started back to 2024-06-17 06:42:05 (backup #2) for share private 341s started incr dump, share=private 341s Xfer PIDs are now 4016,4015 341s xferPids 4016,4015 341s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\private -U smbtest3833 -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 341s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 341s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 341s tar:1298 Getting files newer than Mon Jun 17 06:42:05 2024 341s tarmode is now full, system, hidden, noreset, noverbose 341s __bpc_progress_fileCnt__ 0 341s same 644 0/0 480434 tmp.f1cQd5 341s same 644 0/0 480434 tmp.75NrqZ 341s same 644 0/0 480434 tmp.qxh0Fk 341s same 644 0/0 480434 tmp.atqXfX 341s same 644 0/0 480434 tmp.if9yB5 341s same 644 0/0 480434 tmp.0JzDCE 341s same 644 0/0 480434 tmp.uNwYeT 341s same 644 0/0 480434 tmp.IZyYi8 341s same 644 0/0 480434 tmp.jYLSml 341s same 644 0/0 480434 tmp.6L9Hly 341s new 644 0/0 480434 tmp.muBst4 341s new 644 0/0 480434 tmp.7A6Fcr 341s new 644 0/0 480434 tmp.qNv1gm 341s new 644 0/0 480434 tmp.9Mj6aa 341s new 644 0/0 480434 tmp.x3JMGh 341s new 644 0/0 480434 tmp.EN4chz 341s new 644 0/0 480434 tmp.6dYm4t 341s new 644 0/0 480434 tmp.uDCjpL 341s new 644 0/0 480434 tmp.TGs2IP 341s tar: dumped 20 files and 0 directories 341s Total bytes written: 9608680 (29.8 MiB/s) 341s new 644 0/0 480434 tmp.Us0JMi 341s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 341s __bpc_progress_fileCnt__ 20 341s tarExtract: Done: 0 errors, 10 filesExist, 4804340 sizeExist, 1377760 sizeExistComp, 20 filesTotal, 9608680 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377746 sizeNewComp, 47 inodeLast 341s Xfer PIDs are now 341s xferPids 341s incr backup 3 complete, 20 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 341s BackupExpire: cntFull = 3, cntIncr = 1, firstFull = 0, firstIncr = 1, oldestIncr = 0.000601851851851852, oldestFull = 0.000625 341s __bpc_progress_state__ fsck 341s Running BackupPC_refCountUpdate -h localhost on localhost 341s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 341s Xfer PIDs are now 4022 341s xferPids 4022 341s __bpc_progress_state__ cntUpdate #3 341s __bpc_progress_state__ rename #3 341s __bpc_progress_state__ sumUpdate 341s __bpc_progress_fileCnt__ 0/128 342s __bpc_progress_fileCnt__ 8/128 342s __bpc_progress_fileCnt__ 16/128 342s __bpc_progress_fileCnt__ 24/128 342s __bpc_progress_fileCnt__ 32/128 342s __bpc_progress_fileCnt__ 40/128 342s __bpc_progress_fileCnt__ 48/128 342s __bpc_progress_fileCnt__ 56/128 342s __bpc_progress_fileCnt__ 64/128 342s __bpc_progress_fileCnt__ 72/128 342s __bpc_progress_fileCnt__ 80/128 342s __bpc_progress_fileCnt__ 88/128 342s __bpc_progress_fileCnt__ 96/128 342s __bpc_progress_fileCnt__ 104/128 342s __bpc_progress_fileCnt__ 112/128 342s __bpc_progress_fileCnt__ 120/128 342s __bpc_progress_state__ rename total 342s BackupPC_refCountUpdate: host localhost got 0 errors (took 1 secs) 342s Xfer PIDs are now 342s xferPids 342s Finished BackupPC_refCountUpdate (running time: 1 sec) 342s Xfer PIDs are now 342s xferPids 342s incr backup complete 342s OK: Incremental backup succeeded 342s Done. 342s Deleted user smbtest3833. 342s userdel: smbtest3833 mail spool (/var/mail/smbtest3833) not found 342s autopkgtest [07:42:09]: test authenticated-smb-backup: -----------------------] 347s autopkgtest [07:42:14]: test authenticated-smb-backup: - - - - - - - - - - results - - - - - - - - - - 347s authenticated-smb-backup PASS 351s autopkgtest [07:42:18]: @@@@@@@@@@@@@@@@@@@@ summary 351s smb-backup PASS 351s authenticated-smb-backup PASS