0s autopkgtest [09:09:03]: starting date and time: 2024-05-12 09:09:03+0000 0s autopkgtest [09:09:03]: git checkout: 43bc6cdf gitlab-ci: do not include the salsa pipeline 0s autopkgtest [09:09:03]: host juju-7f2275-prod-proposed-migration-environment-4; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.ywd9vur6/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:libcgi-pm-perl --apt-upgrade backuppc --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=libcgi-pm-perl/4.64-1 -- lxd -r lxd-armhf-10.145.243.242 lxd-armhf-10.145.243.242:autopkgtest/ubuntu/oracular/armhf 33s autopkgtest [09:09:36]: testbed dpkg architecture: armhf 35s autopkgtest [09:09:38]: testbed apt version: 2.7.14build2 35s autopkgtest [09:09:38]: @@@@@@@@@@@@@@@@@@@@ test bed setup 43s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [73.9 kB] 44s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [1964 B] 44s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [16.8 kB] 44s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [122 kB] 44s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [1155 kB] 44s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main armhf Packages [172 kB] 44s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/universe armhf Packages [964 kB] 44s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse armhf Packages [19.2 kB] 44s Fetched 2525 kB in 1s (2086 kB/s) 45s Reading package lists... 62s tee: /proc/self/fd/2: Permission denied 86s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 86s Hit:2 http://ftpmaster.internal/ubuntu oracular InRelease 86s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease 86s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease 87s Reading package lists... 87s Reading package lists... 88s Building dependency tree... 88s Reading state information... 88s Calculating upgrade... 89s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 89s Reading package lists... 89s Building dependency tree... 89s Reading state information... 89s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 91s autopkgtest [09:10:34]: rebooting testbed after setup commands that affected boot 132s autopkgtest [09:11:15]: testbed running kernel: Linux 5.15.0-106-generic #116-Ubuntu SMP Wed Apr 17 09:19:22 UTC 2024 159s autopkgtest [09:11:42]: @@@@@@@@@@@@@@@@@@@@ apt-source backuppc 169s Get:1 http://ftpmaster.internal/ubuntu oracular/main backuppc 4.4.0-8build1 (dsc) [2289 B] 169s Get:2 http://ftpmaster.internal/ubuntu oracular/main backuppc 4.4.0-8build1 (tar) [657 kB] 169s Get:3 http://ftpmaster.internal/ubuntu oracular/main backuppc 4.4.0-8build1 (diff) [61.1 kB] 169s gpgv: Signature made Mon Apr 8 15:54:41 2024 UTC 169s gpgv: using RSA key 4FB588A84C2DDE79A74C77876FA458DD1DB03F71 169s gpgv: issuer "juliank@ubuntu.com" 169s gpgv: Can't check signature: No public key 169s dpkg-source: warning: cannot verify inline signature for ./backuppc_4.4.0-8build1.dsc: no acceptable signature found 169s autopkgtest [09:11:52]: testing package backuppc version 4.4.0-8build1 171s autopkgtest [09:11:54]: build not needed 174s autopkgtest [09:11:57]: test smb-backup: preparing testbed 183s Reading package lists... 183s Building dependency tree... 183s Reading state information... 184s Starting pkgProblemResolver with broken count: 0 184s Starting 2 pkgProblemResolver with broken count: 0 184s Done 184s The following additional packages will be installed: 184s apache2 apache2-bin apache2-data apache2-utils backuppc backuppc-rsync 184s libapr1t64 libaprutil1-dbd-sqlite3 libaprutil1-ldap libaprutil1t64 184s libarchive-zip-perl libavahi-client3 libavahi-common-data libavahi-common3 184s libbackuppc-xs-perl libcgi-pm-perl libcups2t64 libfile-listing-perl 184s libhtml-parser-perl libhtml-tagset-perl libhttp-date-perl libldb2 184s liblua5.4-0 libnsl2 libpython3.12t64 libsmbclient0 libtalloc2 libtdb1 184s libtevent0t64 libtime-parsedate-perl libtimedate-perl liburi-perl 184s libwbclient0 postfix python3-dnspython python3-ldb python3-markdown 184s python3-samba python3-talloc python3-tdb samba samba-common samba-common-bin 184s samba-libs smbclient ssl-cert tdb-tools 184s Suggested packages: 184s apache2-doc apache2-suexec-pristine | apache2-suexec-custom www-browser 184s certbot | acme-tiny | acmetool | dehydrated | lacme | lecm | lego 184s libscgi-perl par2 w3m | www-browser cups-common libdata-dump-perl 184s libbusiness-isbn-perl libregexp-ipv6-perl libwww-perl mail-reader 184s postfix-cdb postfix-doc postfix-ldap postfix-lmdb postfix-mta-sts-resolver 184s postfix-mysql postfix-pcre postfix-pgsql postfix-sqlite procmail sasl2-bin 184s | dovecot-common python3-trio python3-aioquic python3-h2 python3-httpx 184s python3-httpcore python-markdown-doc bind9 bind9utils ctdb ldb-tools ntp 184s | chrony winbind heimdal-clients cifs-utils 184s Recommended packages: 184s libio-dirent-perl rrdtool libcgi-fast-perl libhttp-message-perl python3-gpg 184s attr samba-dsdb-modules samba-vfs-modules samba-ad-provision 184s The following NEW packages will be installed: 184s apache2 apache2-bin apache2-data apache2-utils autopkgtest-satdep backuppc 184s backuppc-rsync libapr1t64 libaprutil1-dbd-sqlite3 libaprutil1-ldap 184s libaprutil1t64 libarchive-zip-perl libavahi-client3 libavahi-common-data 184s libavahi-common3 libbackuppc-xs-perl libcgi-pm-perl libcups2t64 184s libfile-listing-perl libhtml-parser-perl libhtml-tagset-perl 184s libhttp-date-perl libldb2 liblua5.4-0 libnsl2 libpython3.12t64 libsmbclient0 184s libtalloc2 libtdb1 libtevent0t64 libtime-parsedate-perl libtimedate-perl 184s liburi-perl libwbclient0 postfix python3-dnspython python3-ldb 184s python3-markdown python3-samba python3-talloc python3-tdb samba samba-common 184s samba-common-bin samba-libs smbclient ssl-cert tdb-tools 184s 0 upgraded, 48 newly installed, 0 to remove and 0 not upgraded. 184s Need to get 18.5 MB/18.5 MB of archives. 184s After this operation, 62.7 MB of additional disk space will be used. 184s Get:1 /tmp/autopkgtest.gdrmw5/1-autopkgtest-satdep.deb autopkgtest-satdep armhf 0 [720 B] 185s Get:2 http://ftpmaster.internal/ubuntu oracular/main armhf libapr1t64 armhf 1.7.2-3.1build2 [86.1 kB] 185s Get:3 http://ftpmaster.internal/ubuntu oracular/main armhf libaprutil1t64 armhf 1.6.3-1.1ubuntu7 [82.3 kB] 185s Get:4 http://ftpmaster.internal/ubuntu oracular/main armhf libaprutil1-dbd-sqlite3 armhf 1.6.3-1.1ubuntu7 [9594 B] 185s Get:5 http://ftpmaster.internal/ubuntu oracular/main armhf libaprutil1-ldap armhf 1.6.3-1.1ubuntu7 [8494 B] 185s Get:6 http://ftpmaster.internal/ubuntu oracular/main armhf liblua5.4-0 armhf 5.4.6-3build2 [133 kB] 185s Get:7 http://ftpmaster.internal/ubuntu oracular/main armhf apache2-bin armhf 2.4.58-1ubuntu8 [1202 kB] 185s Get:8 http://ftpmaster.internal/ubuntu oracular/main armhf apache2-data all 2.4.58-1ubuntu8 [163 kB] 185s Get:9 http://ftpmaster.internal/ubuntu oracular/main armhf apache2-utils armhf 2.4.58-1ubuntu8 [97.0 kB] 185s Get:10 http://ftpmaster.internal/ubuntu oracular/main armhf apache2 armhf 2.4.58-1ubuntu8 [90.2 kB] 185s Get:11 http://ftpmaster.internal/ubuntu oracular/main armhf backuppc-rsync armhf 3.1.3.0-3ubuntu1 [233 kB] 185s Get:12 http://ftpmaster.internal/ubuntu oracular/main armhf ssl-cert all 1.1.2ubuntu1 [17.8 kB] 185s Get:13 http://ftpmaster.internal/ubuntu oracular/main armhf libnsl2 armhf 1.3.0-3build3 [36.5 kB] 185s Get:14 http://ftpmaster.internal/ubuntu oracular/main armhf postfix armhf 3.8.6-1build2 [1194 kB] 185s Get:15 http://ftpmaster.internal/ubuntu oracular/main armhf libarchive-zip-perl all 1.68-1 [90.2 kB] 185s Get:16 http://ftpmaster.internal/ubuntu oracular/main armhf libbackuppc-xs-perl armhf 0.62-2build5 [59.7 kB] 185s Get:17 http://ftpmaster.internal/ubuntu oracular/main armhf libhtml-tagset-perl all 3.24-1 [14.1 kB] 185s Get:18 http://ftpmaster.internal/ubuntu oracular/main armhf liburi-perl all 5.27-1 [88.0 kB] 185s Get:19 http://ftpmaster.internal/ubuntu oracular/main armhf libhtml-parser-perl armhf 3.81-1build3 [82.5 kB] 185s Get:20 http://ftpmaster.internal/ubuntu oracular-proposed/main armhf libcgi-pm-perl all 4.64-1 [185 kB] 185s Get:21 http://ftpmaster.internal/ubuntu oracular/main armhf libtimedate-perl all 2.3300-2 [34.0 kB] 185s Get:22 http://ftpmaster.internal/ubuntu oracular/main armhf libhttp-date-perl all 6.06-1 [10.2 kB] 185s Get:23 http://ftpmaster.internal/ubuntu oracular/main armhf libfile-listing-perl all 6.16-1 [11.3 kB] 185s Get:24 http://ftpmaster.internal/ubuntu oracular/main armhf libtime-parsedate-perl all 2015.103-4 [28.6 kB] 185s Get:25 http://ftpmaster.internal/ubuntu oracular/main armhf backuppc armhf 4.4.0-8build1 [540 kB] 185s Get:26 http://ftpmaster.internal/ubuntu oracular/main armhf python3-dnspython all 2.6.1-1ubuntu1 [163 kB] 185s Get:27 http://ftpmaster.internal/ubuntu oracular/main armhf libtalloc2 armhf 2.4.2-1build2 [25.9 kB] 185s Get:28 http://ftpmaster.internal/ubuntu oracular/main armhf libtdb1 armhf 1.4.10-1build1 [43.1 kB] 185s Get:29 http://ftpmaster.internal/ubuntu oracular/main armhf libtevent0t64 armhf 0.16.1-2build1 [38.1 kB] 185s Get:30 http://ftpmaster.internal/ubuntu oracular/main armhf libldb2 armhf 2:2.8.0+samba4.19.5+dfsg-4ubuntu9 [163 kB] 185s Get:31 http://ftpmaster.internal/ubuntu oracular/main armhf libpython3.12t64 armhf 3.12.3-1 [2058 kB] 185s Get:32 http://ftpmaster.internal/ubuntu oracular/main armhf python3-ldb armhf 2:2.8.0+samba4.19.5+dfsg-4ubuntu9 [38.5 kB] 185s Get:33 http://ftpmaster.internal/ubuntu oracular/main armhf python3-tdb armhf 1.4.10-1build1 [14.2 kB] 185s Get:34 http://ftpmaster.internal/ubuntu oracular/main armhf python3-markdown all 3.5.2-1 [72.0 kB] 185s Get:35 http://ftpmaster.internal/ubuntu oracular/main armhf libavahi-common-data armhf 0.8-13ubuntu6 [29.7 kB] 185s Get:36 http://ftpmaster.internal/ubuntu oracular/main armhf libavahi-common3 armhf 0.8-13ubuntu6 [20.2 kB] 185s Get:37 http://ftpmaster.internal/ubuntu oracular/main armhf libavahi-client3 armhf 0.8-13ubuntu6 [24.2 kB] 185s Get:38 http://ftpmaster.internal/ubuntu oracular/main armhf libwbclient0 armhf 2:4.19.5+dfsg-4ubuntu9 [67.5 kB] 185s Get:39 http://ftpmaster.internal/ubuntu oracular/main armhf samba-libs armhf 2:4.19.5+dfsg-4ubuntu9 [5693 kB] 185s Get:40 http://ftpmaster.internal/ubuntu oracular/main armhf python3-talloc armhf 2.4.2-1build2 [11.9 kB] 185s Get:41 http://ftpmaster.internal/ubuntu oracular/main armhf python3-samba armhf 2:4.19.5+dfsg-4ubuntu9 [2488 kB] 186s Get:42 http://ftpmaster.internal/ubuntu oracular/main armhf samba-common all 2:4.19.5+dfsg-4ubuntu9 [64.1 kB] 186s Get:43 http://ftpmaster.internal/ubuntu oracular/main armhf libcups2t64 armhf 2.4.7-1.2ubuntu7 [240 kB] 186s Get:44 http://ftpmaster.internal/ubuntu oracular/main armhf samba-common-bin armhf 2:4.19.5+dfsg-4ubuntu9 [1213 kB] 186s Get:45 http://ftpmaster.internal/ubuntu oracular/main armhf tdb-tools armhf 1.4.10-1build1 [25.3 kB] 186s Get:46 http://ftpmaster.internal/ubuntu oracular/main armhf samba armhf 2:4.19.5+dfsg-4ubuntu9 [957 kB] 186s Get:47 http://ftpmaster.internal/ubuntu oracular/main armhf libsmbclient0 armhf 2:4.19.5+dfsg-4ubuntu9 [57.4 kB] 186s Get:48 http://ftpmaster.internal/ubuntu oracular/main armhf smbclient armhf 2:4.19.5+dfsg-4ubuntu9 [446 kB] 186s Preconfiguring packages ... 186s Fetched 18.5 MB in 1s (14.4 MB/s) 186s Selecting previously unselected package libapr1t64:armhf. 186s (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 ... 57881 files and directories currently installed.) 186s Preparing to unpack .../00-libapr1t64_1.7.2-3.1build2_armhf.deb ... 186s Unpacking libapr1t64:armhf (1.7.2-3.1build2) ... 186s Selecting previously unselected package libaprutil1t64:armhf. 186s Preparing to unpack .../01-libaprutil1t64_1.6.3-1.1ubuntu7_armhf.deb ... 186s Unpacking libaprutil1t64:armhf (1.6.3-1.1ubuntu7) ... 186s Selecting previously unselected package libaprutil1-dbd-sqlite3:armhf. 186s Preparing to unpack .../02-libaprutil1-dbd-sqlite3_1.6.3-1.1ubuntu7_armhf.deb ... 186s Unpacking libaprutil1-dbd-sqlite3:armhf (1.6.3-1.1ubuntu7) ... 186s Selecting previously unselected package libaprutil1-ldap:armhf. 186s Preparing to unpack .../03-libaprutil1-ldap_1.6.3-1.1ubuntu7_armhf.deb ... 186s Unpacking libaprutil1-ldap:armhf (1.6.3-1.1ubuntu7) ... 186s Selecting previously unselected package liblua5.4-0:armhf. 186s Preparing to unpack .../04-liblua5.4-0_5.4.6-3build2_armhf.deb ... 186s Unpacking liblua5.4-0:armhf (5.4.6-3build2) ... 186s Selecting previously unselected package apache2-bin. 186s Preparing to unpack .../05-apache2-bin_2.4.58-1ubuntu8_armhf.deb ... 186s Unpacking apache2-bin (2.4.58-1ubuntu8) ... 187s Selecting previously unselected package apache2-data. 187s Preparing to unpack .../06-apache2-data_2.4.58-1ubuntu8_all.deb ... 187s Unpacking apache2-data (2.4.58-1ubuntu8) ... 187s Selecting previously unselected package apache2-utils. 187s Preparing to unpack .../07-apache2-utils_2.4.58-1ubuntu8_armhf.deb ... 187s Unpacking apache2-utils (2.4.58-1ubuntu8) ... 187s Selecting previously unselected package apache2. 187s Preparing to unpack .../08-apache2_2.4.58-1ubuntu8_armhf.deb ... 187s Unpacking apache2 (2.4.58-1ubuntu8) ... 187s Selecting previously unselected package backuppc-rsync. 187s Preparing to unpack .../09-backuppc-rsync_3.1.3.0-3ubuntu1_armhf.deb ... 187s Unpacking backuppc-rsync (3.1.3.0-3ubuntu1) ... 187s Selecting previously unselected package ssl-cert. 187s Preparing to unpack .../10-ssl-cert_1.1.2ubuntu1_all.deb ... 187s Unpacking ssl-cert (1.1.2ubuntu1) ... 187s Selecting previously unselected package libnsl2:armhf. 187s Preparing to unpack .../11-libnsl2_1.3.0-3build3_armhf.deb ... 187s Unpacking libnsl2:armhf (1.3.0-3build3) ... 187s Selecting previously unselected package postfix. 187s Preparing to unpack .../12-postfix_3.8.6-1build2_armhf.deb ... 187s Unpacking postfix (3.8.6-1build2) ... 187s Selecting previously unselected package libarchive-zip-perl. 187s Preparing to unpack .../13-libarchive-zip-perl_1.68-1_all.deb ... 187s Unpacking libarchive-zip-perl (1.68-1) ... 187s Selecting previously unselected package libbackuppc-xs-perl:armhf. 187s Preparing to unpack .../14-libbackuppc-xs-perl_0.62-2build5_armhf.deb ... 187s Unpacking libbackuppc-xs-perl:armhf (0.62-2build5) ... 187s Selecting previously unselected package libhtml-tagset-perl. 187s Preparing to unpack .../15-libhtml-tagset-perl_3.24-1_all.deb ... 187s Unpacking libhtml-tagset-perl (3.24-1) ... 187s Selecting previously unselected package liburi-perl. 187s Preparing to unpack .../16-liburi-perl_5.27-1_all.deb ... 187s Unpacking liburi-perl (5.27-1) ... 187s Selecting previously unselected package libhtml-parser-perl:armhf. 187s Preparing to unpack .../17-libhtml-parser-perl_3.81-1build3_armhf.deb ... 187s Unpacking libhtml-parser-perl:armhf (3.81-1build3) ... 187s Selecting previously unselected package libcgi-pm-perl. 187s Preparing to unpack .../18-libcgi-pm-perl_4.64-1_all.deb ... 187s Unpacking libcgi-pm-perl (4.64-1) ... 187s Selecting previously unselected package libtimedate-perl. 187s Preparing to unpack .../19-libtimedate-perl_2.3300-2_all.deb ... 187s Unpacking libtimedate-perl (2.3300-2) ... 187s Selecting previously unselected package libhttp-date-perl. 187s Preparing to unpack .../20-libhttp-date-perl_6.06-1_all.deb ... 187s Unpacking libhttp-date-perl (6.06-1) ... 187s Selecting previously unselected package libfile-listing-perl. 187s Preparing to unpack .../21-libfile-listing-perl_6.16-1_all.deb ... 187s Unpacking libfile-listing-perl (6.16-1) ... 187s Selecting previously unselected package libtime-parsedate-perl. 187s Preparing to unpack .../22-libtime-parsedate-perl_2015.103-4_all.deb ... 187s Unpacking libtime-parsedate-perl (2015.103-4) ... 187s Selecting previously unselected package backuppc. 187s Preparing to unpack .../23-backuppc_4.4.0-8build1_armhf.deb ... 187s Unpacking backuppc (4.4.0-8build1) ... 187s Selecting previously unselected package python3-dnspython. 187s Preparing to unpack .../24-python3-dnspython_2.6.1-1ubuntu1_all.deb ... 187s Unpacking python3-dnspython (2.6.1-1ubuntu1) ... 187s Selecting previously unselected package libtalloc2:armhf. 187s Preparing to unpack .../25-libtalloc2_2.4.2-1build2_armhf.deb ... 187s Unpacking libtalloc2:armhf (2.4.2-1build2) ... 187s Selecting previously unselected package libtdb1:armhf. 187s Preparing to unpack .../26-libtdb1_1.4.10-1build1_armhf.deb ... 187s Unpacking libtdb1:armhf (1.4.10-1build1) ... 187s Selecting previously unselected package libtevent0t64:armhf. 187s Preparing to unpack .../27-libtevent0t64_0.16.1-2build1_armhf.deb ... 187s Unpacking libtevent0t64:armhf (0.16.1-2build1) ... 187s Selecting previously unselected package libldb2:armhf. 187s Preparing to unpack .../28-libldb2_2%3a2.8.0+samba4.19.5+dfsg-4ubuntu9_armhf.deb ... 187s Unpacking libldb2:armhf (2:2.8.0+samba4.19.5+dfsg-4ubuntu9) ... 188s Selecting previously unselected package libpython3.12t64:armhf. 188s Preparing to unpack .../29-libpython3.12t64_3.12.3-1_armhf.deb ... 188s Unpacking libpython3.12t64:armhf (3.12.3-1) ... 188s Selecting previously unselected package python3-ldb. 188s Preparing to unpack .../30-python3-ldb_2%3a2.8.0+samba4.19.5+dfsg-4ubuntu9_armhf.deb ... 188s Unpacking python3-ldb (2:2.8.0+samba4.19.5+dfsg-4ubuntu9) ... 188s Selecting previously unselected package python3-tdb. 188s Preparing to unpack .../31-python3-tdb_1.4.10-1build1_armhf.deb ... 188s Unpacking python3-tdb (1.4.10-1build1) ... 188s Selecting previously unselected package python3-markdown. 188s Preparing to unpack .../32-python3-markdown_3.5.2-1_all.deb ... 188s Unpacking python3-markdown (3.5.2-1) ... 188s Selecting previously unselected package libavahi-common-data:armhf. 188s Preparing to unpack .../33-libavahi-common-data_0.8-13ubuntu6_armhf.deb ... 188s Unpacking libavahi-common-data:armhf (0.8-13ubuntu6) ... 188s Selecting previously unselected package libavahi-common3:armhf. 188s Preparing to unpack .../34-libavahi-common3_0.8-13ubuntu6_armhf.deb ... 188s Unpacking libavahi-common3:armhf (0.8-13ubuntu6) ... 188s Selecting previously unselected package libavahi-client3:armhf. 188s Preparing to unpack .../35-libavahi-client3_0.8-13ubuntu6_armhf.deb ... 188s Unpacking libavahi-client3:armhf (0.8-13ubuntu6) ... 188s Selecting previously unselected package libwbclient0:armhf. 188s Preparing to unpack .../36-libwbclient0_2%3a4.19.5+dfsg-4ubuntu9_armhf.deb ... 188s Unpacking libwbclient0:armhf (2:4.19.5+dfsg-4ubuntu9) ... 188s Selecting previously unselected package samba-libs:armhf. 188s Preparing to unpack .../37-samba-libs_2%3a4.19.5+dfsg-4ubuntu9_armhf.deb ... 188s Unpacking samba-libs:armhf (2:4.19.5+dfsg-4ubuntu9) ... 188s Selecting previously unselected package python3-talloc:armhf. 188s Preparing to unpack .../38-python3-talloc_2.4.2-1build2_armhf.deb ... 188s Unpacking python3-talloc:armhf (2.4.2-1build2) ... 188s Selecting previously unselected package python3-samba. 188s Preparing to unpack .../39-python3-samba_2%3a4.19.5+dfsg-4ubuntu9_armhf.deb ... 188s Unpacking python3-samba (2:4.19.5+dfsg-4ubuntu9) ... 188s Selecting previously unselected package samba-common. 188s Preparing to unpack .../40-samba-common_2%3a4.19.5+dfsg-4ubuntu9_all.deb ... 188s Unpacking samba-common (2:4.19.5+dfsg-4ubuntu9) ... 188s Selecting previously unselected package libcups2t64:armhf. 188s Preparing to unpack .../41-libcups2t64_2.4.7-1.2ubuntu7_armhf.deb ... 188s Unpacking libcups2t64:armhf (2.4.7-1.2ubuntu7) ... 188s Selecting previously unselected package samba-common-bin. 188s Preparing to unpack .../42-samba-common-bin_2%3a4.19.5+dfsg-4ubuntu9_armhf.deb ... 188s Unpacking samba-common-bin (2:4.19.5+dfsg-4ubuntu9) ... 188s Selecting previously unselected package tdb-tools. 188s Preparing to unpack .../43-tdb-tools_1.4.10-1build1_armhf.deb ... 188s Unpacking tdb-tools (1.4.10-1build1) ... 188s Selecting previously unselected package samba. 188s Preparing to unpack .../44-samba_2%3a4.19.5+dfsg-4ubuntu9_armhf.deb ... 188s Unpacking samba (2:4.19.5+dfsg-4ubuntu9) ... 188s Selecting previously unselected package libsmbclient0:armhf. 188s Preparing to unpack .../45-libsmbclient0_2%3a4.19.5+dfsg-4ubuntu9_armhf.deb ... 188s Unpacking libsmbclient0:armhf (2:4.19.5+dfsg-4ubuntu9) ... 189s Selecting previously unselected package smbclient. 189s Preparing to unpack .../46-smbclient_2%3a4.19.5+dfsg-4ubuntu9_armhf.deb ... 189s Unpacking smbclient (2:4.19.5+dfsg-4ubuntu9) ... 189s Selecting previously unselected package autopkgtest-satdep. 189s Preparing to unpack .../47-1-autopkgtest-satdep.deb ... 189s Unpacking autopkgtest-satdep (0) ... 189s Setting up libarchive-zip-perl (1.68-1) ... 189s Setting up libtdb1:armhf (1.4.10-1build1) ... 189s Setting up libhtml-tagset-perl (3.24-1) ... 189s Setting up samba-common (2:4.19.5+dfsg-4ubuntu9) ... 189s 189s Creating config file /etc/samba/smb.conf with new version 189s Setting up libwbclient0:armhf (2:4.19.5+dfsg-4ubuntu9) ... 189s Setting up libtalloc2:armhf (2.4.2-1build2) ... 189s Setting up libpython3.12t64:armhf (3.12.3-1) ... 189s Setting up backuppc-rsync (3.1.3.0-3ubuntu1) ... 189s Setting up python3-tdb (1.4.10-1build1) ... 189s Setting up ssl-cert (1.1.2ubuntu1) ... 191s Created symlink /etc/systemd/system/multi-user.target.wants/ssl-cert.service → /usr/lib/systemd/system/ssl-cert.service. 192s Setting up libavahi-common-data:armhf (0.8-13ubuntu6) ... 192s Setting up tdb-tools (1.4.10-1build1) ... 192s update-alternatives: using /usr/bin/tdbbackup.tdbtools to provide /usr/bin/tdbbackup (tdbbackup) in auto mode 192s Setting up python3-markdown (3.5.2-1) ... 192s Setting up libtimedate-perl (2.3300-2) ... 193s Setting up libtime-parsedate-perl (2015.103-4) ... 193s Setting up python3-dnspython (2.6.1-1ubuntu1) ... 193s Setting up libapr1t64:armhf (1.7.2-3.1build2) ... 193s Setting up libnsl2:armhf (1.3.0-3build3) ... 193s Setting up liblua5.4-0:armhf (5.4.6-3build2) ... 193s Setting up apache2-data (2.4.58-1ubuntu8) ... 193s Setting up libbackuppc-xs-perl:armhf (0.62-2build5) ... 193s Setting up liburi-perl (5.27-1) ... 193s Setting up libtevent0t64:armhf (0.16.1-2build1) ... 193s Setting up libaprutil1t64:armhf (1.6.3-1.1ubuntu7) ... 193s Setting up libhttp-date-perl (6.06-1) ... 193s Setting up libfile-listing-perl (6.16-1) ... 193s Setting up python3-talloc:armhf (2.4.2-1build2) ... 193s Setting up libavahi-common3:armhf (0.8-13ubuntu6) ... 193s Setting up libaprutil1-ldap:armhf (1.6.3-1.1ubuntu7) ... 193s Setting up libaprutil1-dbd-sqlite3:armhf (1.6.3-1.1ubuntu7) ... 193s Setting up postfix (3.8.6-1build2) ... 193s info: Selecting GID from range 100 to 999 ... 193s info: Adding group `postfix' (GID 111) ... 193s info: Selecting UID from range 100 to 999 ... 193s 193s info: Adding system user `postfix' (UID 107) ... 193s info: Adding new user `postfix' (UID 107) with group `postfix' ... 193s info: Not creating home directory `/var/spool/postfix'. 193s Creating /etc/postfix/dynamicmaps.cf 194s info: Selecting GID from range 100 to 999 ... 194s info: Adding group `postdrop' (GID 112) ... 194s setting myhostname: autopkgtest-lxd-qlamic.lxd 194s setting alias maps 194s setting alias database 194s changing /etc/mailname to autopkgtest-lxd-qlamic.lxd 194s setting myorigin 194s setting destinations: $myhostname, autopkgtest-lxd-qlamic.lxd, localhost.lxd, , localhost 194s setting relayhost: 194s setting mynetworks: 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128 194s setting mailbox_size_limit: 0 194s setting recipient_delimiter: + 196s setting inet_interfaces: all 198s setting inet_protocols: all 198s /etc/aliases does not exist, creating it. 198s WARNING: /etc/aliases exists, but does not have a root alias. 198s 198s Postfix (main.cf) is now set up with a default configuration. If you need to 198s make changes, edit /etc/postfix/main.cf (and others) as needed. To view 198s Postfix configuration values, see postconf(1). 198s 198s After modifying main.cf, be sure to run 'systemctl reload postfix'. 198s 200s Running newaliases 201s Created symlink /etc/systemd/system/multi-user.target.wants/postfix.service → /usr/lib/systemd/system/postfix.service. 203s Setting up libhtml-parser-perl:armhf (3.81-1build3) ... 203s Setting up libldb2:armhf (2:2.8.0+samba4.19.5+dfsg-4ubuntu9) ... 203s Setting up libavahi-client3:armhf (0.8-13ubuntu6) ... 203s Setting up apache2-utils (2.4.58-1ubuntu8) ... 203s Setting up libcgi-pm-perl (4.64-1) ... 203s Setting up samba-libs:armhf (2:4.19.5+dfsg-4ubuntu9) ... 203s Setting up apache2-bin (2.4.58-1ubuntu8) ... 203s Setting up python3-ldb (2:2.8.0+samba4.19.5+dfsg-4ubuntu9) ... 203s Setting up libsmbclient0:armhf (2:4.19.5+dfsg-4ubuntu9) ... 203s Setting up libcups2t64:armhf (2.4.7-1.2ubuntu7) ... 203s Setting up python3-samba (2:4.19.5+dfsg-4ubuntu9) ... 204s Setting up apache2 (2.4.58-1ubuntu8) ... 204s Enabling module mpm_event. 204s Enabling module authz_core. 204s Enabling module authz_host. 204s Enabling module authn_core. 204s Enabling module auth_basic. 204s Enabling module access_compat. 204s Enabling module authn_file. 204s Enabling module authz_user. 204s Enabling module alias. 204s Enabling module dir. 204s Enabling module autoindex. 204s Enabling module env. 204s Enabling module mime. 204s Enabling module negotiation. 204s Enabling module setenvif. 204s Enabling module filter. 204s Enabling module deflate. 204s Enabling module status. 204s Enabling module reqtimeout. 204s Enabling conf charset. 204s Enabling conf localized-error-pages. 204s Enabling conf other-vhosts-access-log. 204s Enabling conf security. 204s Enabling conf serve-cgi-bin. 204s Enabling site 000-default. 205s Created symlink /etc/systemd/system/multi-user.target.wants/apache2.service → /usr/lib/systemd/system/apache2.service. 206s Created symlink /etc/systemd/system/multi-user.target.wants/apache-htcacheclean.service → /usr/lib/systemd/system/apache-htcacheclean.service. 207s Setting up backuppc (4.4.0-8build1) ... 208s 208s apache2_invoke: Enable configuration backuppc.conf 208s warn: The home directory `/var/lib/backuppc' already exists. Not touching this directory. 208s warn: Warning: The home directory `/var/lib/backuppc' does not belong to the user you are currently creating. 208s Adding password for user backuppc 208s Considering dependency authn_core for auth_basic: 208s Module authn_core already enabled 208s Module auth_basic already enabled 208s Considering dependency authz_core for authz_groupfile: 208s Module authz_core already enabled 208s Enabling module authz_groupfile. 208s To activate the new configuration, you need to run: 208s systemctl restart apache2 208s Module authn_file already enabled 208s Considering dependency authz_core for authz_user: 208s Module authz_core already enabled 208s Module authz_user already enabled 208s Your MPM seems to be threaded. Selecting cgid instead of cgi. 208s Enabling module cgid. 208s To activate the new configuration, you need to run: 208s systemctl restart apache2 208s 208s Creating config file /etc/backuppc/config.pl with new version 209s Created symlink /etc/systemd/system/multi-user.target.wants/backuppc.service → /usr/lib/systemd/system/backuppc.service. 209s Setting up smbclient (2:4.19.5+dfsg-4ubuntu9) ... 209s Setting up samba-common-bin (2:4.19.5+dfsg-4ubuntu9) ... 209s Setting up samba (2:4.19.5+dfsg-4ubuntu9) ... 210s Created symlink /etc/systemd/system/smb.service → /usr/lib/systemd/system/smbd.service. 210s Created symlink /etc/systemd/system/multi-user.target.wants/smbd.service → /usr/lib/systemd/system/smbd.service. 211s Created symlink /etc/systemd/system/nmb.service → /usr/lib/systemd/system/nmbd.service. 211s Created symlink /etc/systemd/system/multi-user.target.wants/nmbd.service → /usr/lib/systemd/system/nmbd.service. 212s Created symlink /etc/systemd/system/samba.service → /usr/lib/systemd/system/samba-ad-dc.service. 212s Created symlink /etc/systemd/system/multi-user.target.wants/samba-ad-dc.service → /usr/lib/systemd/system/samba-ad-dc.service. 212s Setting up autopkgtest-satdep (0) ... 212s Processing triggers for rsyslog (8.2312.0-3ubuntu9) ... 212s Processing triggers for ufw (0.36.2-6) ... 212s Processing triggers for man-db (2.12.0-4build2) ... 213s Processing triggers for libc-bin (2.39-0ubuntu8.1) ... 228s (Reading database ... 60253 files and directories currently installed.) 228s Removing autopkgtest-satdep (0) ... 234s autopkgtest [09:12:57]: test smb-backup: [----------------------- 236s Populating share path 236s Adding samba share 236s Adding [public] share 236s Configuring backuppc 236s Performing a full backup 236s Backup type: type = full, needs_full = 1, needs_incr = 1, lastFullTime = 0, opts{f} = 1, opts{i} = , opts{F} = 236s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 236s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 236s CheckHostAlive: ran '/bin/ping -c 1 localhost'; returning 0.013 236s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.0.z created 2024-05-12 09:12:59 236s Backup prep: type = full, case = 1, inPlace = 1, doDuplicate = 0, newBkupNum = 0, newBkupIdx = 0, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = ) 236s __bpc_progress_state__ backup share "public" 236s Running: /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -Tc - 236s full backup started for share public 236s started full dump, share=public 236s Xfer PIDs are now 3468,3467 236s xferPids 3468,3467 236s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -Tc - 236s tarmode is now full, system, hidden, noreset, noverbose 236s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 1 236s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 236s __bpc_progress_fileCnt__ 0 236s new 644 0/0 480434 tmp.04jERZ 236s new 644 0/0 480434 tmp.eT6FGt 236s new 644 0/0 480434 tmp.5TWXaz 236s new 644 0/0 480434 tmp.LfrW0u 236s new 644 0/0 480434 tmp.ae4Ffn 236s new 644 0/0 480434 tmp.SUcMv2 236s new 644 0/0 480434 tmp.K7iTzJ 236s new 644 0/0 480434 tmp.WRc4ck 236s new 644 0/0 480434 tmp.bAOrUv 236s tar: dumped 10 files and 0 directories 236s Total bytes written: 4804340 (32.3 MiB/s) 236s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 236s new 644 0/0 480434 tmp.AM8BHj 236s __bpc_progress_fileCnt__ 10 236s tarExtract: Done: 0 errors, 0 filesExist, 0 sizeExist, 0 sizeExistComp, 10 filesTotal, 4804340 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377784 sizeNewComp, 13 inodeLast 236s Xfer PIDs are now 236s xferPids 236s full backup 0 complete, 10 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 236s BackupExpire: cntFull = 1, cntIncr = 0, firstFull = 0, firstIncr = , oldestIncr = 0, oldestFull = 0 236s __bpc_progress_state__ fsck 236s Running BackupPC_refCountUpdate -h localhost on localhost 236s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 236s Xfer PIDs are now 3474 236s xferPids 3474 236s BackupPC_refCountUpdate: doing fsck on localhost #0 (full) since $ConfRefCntFsck == 1 236s __bpc_progress_state__ refCnt #0 236s __bpc_progress_state__ cntUpdate #0 236s __bpc_progress_state__ rename #0 236s __bpc_progress_state__ sumUpdate 236s __bpc_progress_fileCnt__ 0/128 236s __bpc_progress_fileCnt__ 8/128 236s __bpc_progress_fileCnt__ 16/128 236s __bpc_progress_fileCnt__ 24/128 236s __bpc_progress_fileCnt__ 32/128 236s __bpc_progress_fileCnt__ 40/128 236s __bpc_progress_fileCnt__ 48/128 236s __bpc_progress_fileCnt__ 56/128 236s __bpc_progress_fileCnt__ 64/128 236s __bpc_progress_fileCnt__ 72/128 236s __bpc_progress_fileCnt__ 80/128 236s __bpc_progress_fileCnt__ 88/128 236s __bpc_progress_fileCnt__ 96/128 236s __bpc_progress_fileCnt__ 104/128 236s __bpc_progress_fileCnt__ 112/128 236s __bpc_progress_fileCnt__ 120/128 236s __bpc_progress_state__ rename total 236s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 236s Xfer PIDs are now 236s xferPids 236s Finished BackupPC_refCountUpdate (running time: 0 sec) 236s Xfer PIDs are now 236s xferPids 236s full backup complete 236s OK: Full backup succeeded 236s Changing share content and performing an incremental backup 237s Backup type: type = incr, needs_full = , needs_incr = , lastFullTime = 1715505179, opts{f} = , opts{i} = 1, opts{F} = 237s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 237s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 237s CheckHostAlive: ran '/bin/ping -c 1 localhost'; returning 0.013 237s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.1.z created 2024-05-12 09:13:00 237s Backup prep: type = incr, case = 3, inPlace = 1, doDuplicate = 1, newBkupNum = 1, newBkupIdx = 1, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = ) 237s Executing /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 237s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 237s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDuplicate line 89. 237s (Did you mean "$Host\'s" instead?) 237s Xfer PIDs are now 3544 237s xferPids 3544 237s __bpc_progress_state__ copy #0 -> #1 237s Copying backup #0 to #1 237s __bpc_progress_fileCnt__ 3 dirs 237s Xfer PIDs are now 3544,3547 237s xferPids 3544,3547 237s __bpc_progress_state__ sumUpdate 237s __bpc_progress_fileCnt__ 0/128 237s __bpc_progress_fileCnt__ 8/128 237s __bpc_progress_fileCnt__ 16/128 237s __bpc_progress_fileCnt__ 24/128 237s __bpc_progress_fileCnt__ 32/128 237s __bpc_progress_fileCnt__ 40/128 237s __bpc_progress_fileCnt__ 48/128 237s __bpc_progress_fileCnt__ 56/128 237s __bpc_progress_fileCnt__ 64/128 237s __bpc_progress_fileCnt__ 72/128 237s __bpc_progress_fileCnt__ 80/128 237s __bpc_progress_fileCnt__ 88/128 237s __bpc_progress_fileCnt__ 96/128 237s __bpc_progress_fileCnt__ 104/128 237s __bpc_progress_fileCnt__ 112/128 237s __bpc_progress_fileCnt__ 120/128 237s __bpc_progress_state__ rename total 237s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 237s Xfer PIDs are now 3544 237s xferPids 3544 237s BackupPC_backupDuplicate: got 0 errors and 0 file open errors 237s Finished BackupPC_backupDuplicate (running time: 0 sec) 237s __bpc_progress_state__ backup share "public" 237s Running: /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 237s incr backup started back to 2024-05-12 08:12:59 (backup #0) for share public 237s started incr dump, share=public 237s Xfer PIDs are now 3551,3550 237s xferPids 3551,3550 237s 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 - 237s tar:1298 Getting files newer than Sun May 12 08:12:59 2024 237s tarmode is now full, system, hidden, noreset, noverbose 237s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 237s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 237s __bpc_progress_fileCnt__ 0 237s same 644 0/0 480434 tmp.04jERZ 237s same 644 0/0 480434 tmp.eT6FGt 237s same 644 0/0 480434 tmp.5TWXaz 237s same 644 0/0 480434 tmp.LfrW0u 237s same 644 0/0 480434 tmp.ae4Ffn 237s same 644 0/0 480434 tmp.SUcMv2 237s same 644 0/0 480434 tmp.K7iTzJ 237s same 644 0/0 480434 tmp.WRc4ck 237s same 644 0/0 480434 tmp.bAOrUv 237s same 644 0/0 480434 tmp.AM8BHj 237s new 644 0/0 480434 tmp.blZB9Z 237s new 644 0/0 480434 tmp.hV90GR 237s new 644 0/0 480434 tmp.6jvR3O 237s new 644 0/0 480434 tmp.0Qed3a 237s new 644 0/0 480434 tmp.FgYlX3 237s new 644 0/0 480434 tmp.KutGt5 237s new 644 0/0 480434 tmp.hUtyMH 237s new 644 0/0 480434 tmp.pZYAvm 237s new 644 0/0 480434 tmp.OtU0yA 237s tar: dumped 20 files and 0 directories 237s Total bytes written: 9608680 (44.5 MiB/s) 237s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 237s new 644 0/0 480434 tmp.pyFtsP 237s __bpc_progress_fileCnt__ 20 237s tarExtract: Done: 0 errors, 10 filesExist, 4804340 sizeExist, 1377784 sizeExistComp, 20 filesTotal, 9608680 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377786 sizeNewComp, 24 inodeLast 237s Xfer PIDs are now 237s xferPids 237s incr backup 1 complete, 20 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 237s BackupExpire: cntFull = 2, cntIncr = 0, firstFull = 0, firstIncr = , oldestIncr = 0, oldestFull = 1.15740740740741e-05 237s __bpc_progress_state__ fsck 237s Running BackupPC_refCountUpdate -h localhost on localhost 237s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 237s Xfer PIDs are now 3557 237s xferPids 3557 237s __bpc_progress_state__ cntUpdate #1 237s __bpc_progress_state__ rename #1 237s __bpc_progress_state__ sumUpdate 237s __bpc_progress_fileCnt__ 0/128 237s __bpc_progress_fileCnt__ 8/128 237s __bpc_progress_fileCnt__ 16/128 237s __bpc_progress_fileCnt__ 24/128 237s __bpc_progress_fileCnt__ 32/128 237s __bpc_progress_fileCnt__ 40/128 237s __bpc_progress_fileCnt__ 48/128 237s __bpc_progress_fileCnt__ 56/128 237s __bpc_progress_fileCnt__ 64/128 237s __bpc_progress_fileCnt__ 72/128 237s __bpc_progress_fileCnt__ 80/128 237s __bpc_progress_fileCnt__ 88/128 237s __bpc_progress_fileCnt__ 96/128 237s __bpc_progress_fileCnt__ 104/128 237s __bpc_progress_fileCnt__ 112/128 237s __bpc_progress_fileCnt__ 120/128 237s __bpc_progress_state__ rename total 237s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 237s Xfer PIDs are now 237s xferPids 237s Finished BackupPC_refCountUpdate (running time: 0 sec) 237s Xfer PIDs are now 237s xferPids 237s incr backup complete 237s OK: Incremental backup succeeded 237s Done. 237s autopkgtest [09:13:00]: test smb-backup: -----------------------] 241s smb-backup PASS 241s autopkgtest [09:13:04]: test smb-backup: - - - - - - - - - - results - - - - - - - - - - 245s autopkgtest [09:13:08]: test authenticated-smb-backup: preparing testbed 257s Reading package lists... 258s Building dependency tree... 258s Reading state information... 258s Starting pkgProblemResolver with broken count: 0 258s Starting 2 pkgProblemResolver with broken count: 0 258s Done 259s The following NEW packages will be installed: 259s autopkgtest-satdep 259s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 259s Need to get 0 B/720 B of archives. 259s After this operation, 0 B of additional disk space will be used. 259s Get:1 /tmp/autopkgtest.gdrmw5/2-autopkgtest-satdep.deb autopkgtest-satdep armhf 0 [720 B] 259s Selecting previously unselected package autopkgtest-satdep. 259s (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 ... 60254 files and directories currently installed.) 259s Preparing to unpack .../2-autopkgtest-satdep.deb ... 259s Unpacking autopkgtest-satdep (0) ... 259s Setting up autopkgtest-satdep (0) ... 272s (Reading database ... 60253 files and directories currently installed.) 272s Removing autopkgtest-satdep (0) ... 278s autopkgtest [09:13:41]: test authenticated-smb-backup: [----------------------- 279s Populating share path 279s Adding samba share 279s Adding [private] share 279s Creating user 279s Creating a local and samba user called smbtest3847 279s Setting samba password for the smbtest3847 user 280s Added user smbtest3847. 280s Configuring backuppc 280s Performing a full backup 280s Backup type: type = full, needs_full = , needs_incr = , lastFullTime = 1715505179, opts{f} = 1, opts{i} = , opts{F} = 280s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 280s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 280s CheckHostAlive: ran '/bin/ping -c 1 localhost'; returning 0.015 280s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.2.z created 2024-05-12 09:13:43 280s Backup prep: type = full, case = 4, inPlace = 0, doDuplicate = 0, newBkupNum = 2, newBkupIdx = 2, lastBkupNum = 1, lastBkupIdx = 1 (FillCycle = 0, noFillCnt = 0) 280s __bpc_progress_state__ backup share "private" 280s Running: /usr/bin/smbclient \\\\localhost\\private -U smbtest3847 -E -d 1 -c tarmode\ full -mSMB3 -Tc - 280s full backup started for share private 280s started full dump, share=private 280s Xfer PIDs are now 3941,3940 280s xferPids 3941,3940 280s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\private -U smbtest3847 -E -d 1 -c tarmode\ full -mSMB3 -Tc - 280s tarmode is now full, system, hidden, noreset, noverbose 280s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 1 280s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 280s __bpc_progress_fileCnt__ 0 280s new 644 0/0 480434 tmp.e1QhAn 280s new 644 0/0 480434 tmp.E3uLnk 280s new 644 0/0 480434 tmp.O0VZlf 280s new 644 0/0 480434 tmp.b4noR0 280s new 644 0/0 480434 tmp.g60XGT 280s new 644 0/0 480434 tmp.7DkUyn 280s new 644 0/0 480434 tmp.ZCl71x 280s new 644 0/0 480434 tmp.L2QEW1 280s new 644 0/0 480434 tmp.1fJ15x 280s tar: dumped 10 files and 0 directories 280s Total bytes written: 4804340 (30.2 MiB/s) 280s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 280s new 644 0/0 480434 tmp.FdCR9d 280s __bpc_progress_fileCnt__ 10 280s tarExtract: Done: 0 errors, 0 filesExist, 0 sizeExist, 0 sizeExistComp, 10 filesTotal, 4804340 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377754 sizeNewComp, 36 inodeLast 280s Xfer PIDs are now 280s xferPids 280s OrphanShareNameClean: removing orphan share public from /var/lib/backuppc/pc/localhost/2 280s __bpc_progress_state__ delete share #2/public 280s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDelete -h localhost -n 2 -l -m -s public / 280s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDelete line 102. 280s (Did you mean "$Host\'s" instead?) 280s Xfer PIDs are now 3947 280s xferPids 3947 280s BackupPC_backupDelete: removing #2/public/ 280s __bpc_progress_state__ merge #2/public/ -> #1/public/ 280s BackupPC_backupDelete: Merge into backup 1/public/ 280s mergeDir: attr write to /var/lib/backuppc/pc/localhost/1/fpublic//attrib failed (digest was ) 280s bpc_attrib_dirWrite: can't open/create raw /var/lib/backuppc/pc/localhost/1/fpublic for writing 280s Xfer PIDs are now 3947,3950 280s xferPids 3947,3950 280s __bpc_progress_state__ refCnt #1 280s __bpc_progress_state__ cntUpdate #1 280s __bpc_progress_state__ rename #1 280s __bpc_progress_state__ refCnt #2 280s BackupPC_refCountUpdate: localhost #2 inodeLast set to 37 (was 24) 280s __bpc_progress_state__ cntUpdate #2 280s __bpc_progress_state__ rename #2 280s __bpc_progress_state__ sumUpdate 280s __bpc_progress_fileCnt__ 0/128 280s __bpc_progress_fileCnt__ 8/128 280s __bpc_progress_fileCnt__ 16/128 280s __bpc_progress_fileCnt__ 24/128 280s __bpc_progress_fileCnt__ 32/128 280s __bpc_progress_fileCnt__ 40/128 280s __bpc_progress_fileCnt__ 48/128 280s __bpc_progress_fileCnt__ 56/128 280s __bpc_progress_fileCnt__ 64/128 280s __bpc_progress_fileCnt__ 72/128 280s __bpc_progress_fileCnt__ 80/128 280s __bpc_progress_fileCnt__ 88/128 280s __bpc_progress_fileCnt__ 96/128 280s __bpc_progress_fileCnt__ 104/128 280s __bpc_progress_fileCnt__ 112/128 280s __bpc_progress_fileCnt__ 120/128 280s __bpc_progress_state__ rename total 280s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 280s Xfer PIDs are now 3947 280s xferPids 3947 280s Xfer PIDs are now 280s xferPids 280s Finished BackupPC_backupDelete, status = 0 (running time: 0 sec) 280s Xfer PIDs are now 280s xferPids 280s full backup 2 complete, 10 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 280s BackupExpire: cntFull = 2, cntIncr = 1, firstFull = 0, firstIncr = 1, oldestIncr = 0.000497685185185185, oldestFull = 0.000509259259259259 280s __bpc_progress_state__ fsck 280s Running BackupPC_refCountUpdate -h localhost on localhost 280s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 280s Xfer PIDs are now 3953 280s xferPids 3953 280s BackupPC_refCountUpdate: doing fsck on localhost #2 (full) since $ConfRefCntFsck == 1 280s __bpc_progress_state__ refCnt #2 280s __bpc_progress_state__ cntUpdate #2 280s __bpc_progress_state__ rename #2 280s __bpc_progress_state__ sumUpdate 280s __bpc_progress_fileCnt__ 0/128 280s __bpc_progress_fileCnt__ 8/128 280s __bpc_progress_fileCnt__ 16/128 280s __bpc_progress_fileCnt__ 24/128 280s __bpc_progress_fileCnt__ 32/128 280s __bpc_progress_fileCnt__ 40/128 280s __bpc_progress_fileCnt__ 48/128 280s __bpc_progress_fileCnt__ 56/128 280s __bpc_progress_fileCnt__ 64/128 280s __bpc_progress_fileCnt__ 72/128 280s __bpc_progress_fileCnt__ 80/128 280s __bpc_progress_fileCnt__ 88/128 280s __bpc_progress_fileCnt__ 96/128 280s __bpc_progress_fileCnt__ 104/128 280s __bpc_progress_fileCnt__ 112/128 280s __bpc_progress_fileCnt__ 120/128 280s __bpc_progress_state__ rename total 280s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 280s Xfer PIDs are now 280s xferPids 280s Finished BackupPC_refCountUpdate (running time: 0 sec) 280s Xfer PIDs are now 280s xferPids 280s full backup complete 280s OK: Full backup succeeded 280s Changing share content and performing an incremental backup 280s Backup type: type = incr, needs_full = , needs_incr = , lastFullTime = 1715505223, opts{f} = , opts{i} = 1, opts{F} = 280s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 280s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 280s CheckHostAlive: ran '/bin/ping -c 1 localhost'; returning 0.013 280s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.3.z created 2024-05-12 09:13:43 280s Backup prep: type = incr, case = 3, inPlace = 1, doDuplicate = 1, newBkupNum = 3, newBkupIdx = 3, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = 1) 280s Executing /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 280s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 280s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDuplicate line 89. 280s (Did you mean "$Host\'s" instead?) 280s Xfer PIDs are now 4023 280s xferPids 4023 280s __bpc_progress_state__ copy #2 -> #3 280s Copying backup #2 to #3 280s __bpc_progress_fileCnt__ 3 dirs 281s Xfer PIDs are now 4023,4026 281s xferPids 4023,4026 281s __bpc_progress_state__ sumUpdate 281s __bpc_progress_fileCnt__ 0/128 281s __bpc_progress_fileCnt__ 8/128 281s __bpc_progress_fileCnt__ 16/128 281s __bpc_progress_fileCnt__ 24/128 281s __bpc_progress_fileCnt__ 32/128 281s __bpc_progress_fileCnt__ 40/128 281s __bpc_progress_fileCnt__ 48/128 281s __bpc_progress_fileCnt__ 56/128 281s __bpc_progress_fileCnt__ 64/128 281s __bpc_progress_fileCnt__ 72/128 281s __bpc_progress_fileCnt__ 80/128 281s __bpc_progress_fileCnt__ 88/128 281s __bpc_progress_fileCnt__ 96/128 281s __bpc_progress_fileCnt__ 104/128 281s __bpc_progress_fileCnt__ 112/128 281s __bpc_progress_fileCnt__ 120/128 281s __bpc_progress_state__ rename total 281s BackupPC_refCountUpdate: host localhost got 0 errors (took 1 secs) 281s Xfer PIDs are now 4023 281s xferPids 4023 281s BackupPC_backupDuplicate: got 0 errors and 0 file open errors 281s Finished BackupPC_backupDuplicate (running time: 1 sec) 281s __bpc_progress_state__ backup share "private" 281s Running: /usr/bin/smbclient \\\\localhost\\private -U smbtest3847 -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 281s incr backup started back to 2024-05-12 08:13:43 (backup #2) for share private 281s started incr dump, share=private 281s Xfer PIDs are now 4030,4029 281s xferPids 4030,4029 281s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\private -U smbtest3847 -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 281s tar:1298 Getting files newer than Sun May 12 08:13:43 2024 281s tarmode is now full, system, hidden, noreset, noverbose 281s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 281s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 281s __bpc_progress_fileCnt__ 0 281s same 644 0/0 480434 tmp.e1QhAn 281s same 644 0/0 480434 tmp.E3uLnk 281s same 644 0/0 480434 tmp.O0VZlf 281s same 644 0/0 480434 tmp.b4noR0 281s same 644 0/0 480434 tmp.g60XGT 281s same 644 0/0 480434 tmp.7DkUyn 281s same 644 0/0 480434 tmp.ZCl71x 281s same 644 0/0 480434 tmp.L2QEW1 281s same 644 0/0 480434 tmp.1fJ15x 281s same 644 0/0 480434 tmp.FdCR9d 281s new 644 0/0 480434 tmp.chHcNv 281s new 644 0/0 480434 tmp.vpPKQo 281s new 644 0/0 480434 tmp.GJ1Gjl 281s new 644 0/0 480434 tmp.sM5WuQ 281s new 644 0/0 480434 tmp.hLffd7 281s new 644 0/0 480434 tmp.Uk7aio 281s new 644 0/0 480434 tmp.r3OLFP 281s new 644 0/0 480434 tmp.6zog6t 281s new 644 0/0 480434 tmp.F5Gzz7 281s tar: dumped 20 files and 0 directories 281s Total bytes written: 9608680 (47.7 MiB/s) 281s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 281s new 644 0/0 480434 tmp.c5VV7N 281s __bpc_progress_fileCnt__ 20 281s tarExtract: Done: 0 errors, 10 filesExist, 4804340 sizeExist, 1377754 sizeExistComp, 20 filesTotal, 9608680 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377775 sizeNewComp, 47 inodeLast 281s Xfer PIDs are now 281s xferPids 281s incr backup 3 complete, 20 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 281s BackupExpire: cntFull = 3, cntIncr = 1, firstFull = 0, firstIncr = 1, oldestIncr = 0.000509259259259259, oldestFull = 0.000520833333333333 281s __bpc_progress_state__ fsck 281s Running BackupPC_refCountUpdate -h localhost on localhost 281s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 281s Xfer PIDs are now 4036 281s xferPids 4036 281s __bpc_progress_state__ cntUpdate #3 281s __bpc_progress_state__ rename #3 281s __bpc_progress_state__ sumUpdate 281s __bpc_progress_fileCnt__ 0/128 281s __bpc_progress_fileCnt__ 8/128 281s __bpc_progress_fileCnt__ 16/128 281s __bpc_progress_fileCnt__ 24/128 281s __bpc_progress_fileCnt__ 32/128 281s __bpc_progress_fileCnt__ 40/128 281s __bpc_progress_fileCnt__ 48/128 281s __bpc_progress_fileCnt__ 56/128 281s __bpc_progress_fileCnt__ 64/128 281s __bpc_progress_fileCnt__ 72/128 281s __bpc_progress_fileCnt__ 80/128 281s __bpc_progress_fileCnt__ 88/128 281s __bpc_progress_fileCnt__ 96/128 281s __bpc_progress_fileCnt__ 104/128 281s __bpc_progress_fileCnt__ 112/128 281s __bpc_progress_fileCnt__ 120/128 281s __bpc_progress_state__ rename total 281s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 281s Xfer PIDs are now 281s xferPids 281s Finished BackupPC_refCountUpdate (running time: 0 sec) 281s Xfer PIDs are now 281s xferPids 281s incr backup complete 281s OK: Incremental backup succeeded 281s Done. 281s Deleted user smbtest3847. 281s userdel: smbtest3847 mail spool (/var/mail/smbtest3847) not found 281s autopkgtest [09:13:44]: test authenticated-smb-backup: -----------------------] 285s authenticated-smb-backup PASS 285s autopkgtest [09:13:48]: test authenticated-smb-backup: - - - - - - - - - - results - - - - - - - - - - 289s autopkgtest [09:13:52]: @@@@@@@@@@@@@@@@@@@@ summary 289s smb-backup PASS 289s authenticated-smb-backup PASS