0s autopkgtest [00:48:21]: starting date and time: 2024-06-10 00:48:21+0000 0s autopkgtest [00:48:21]: git checkout: 433ed4c Merge branch 'skia/nova_flock' into 'ubuntu/5.34+prod' 0s autopkgtest [00:48:21]: host juju-7f2275-prod-proposed-migration-environment-9; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.ae4yw769/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.65-1 -- lxd -r lxd-armhf-10.145.243.252 lxd-armhf-10.145.243.252:autopkgtest/ubuntu/oracular/armhf 26s autopkgtest [00:48:47]: testbed dpkg architecture: armhf 28s autopkgtest [00:48:49]: testbed apt version: 2.9.3 28s autopkgtest [00:48:49]: @@@@@@@@@@@@@@@@@@@@ test bed setup 36s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [110 kB] 36s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [7972 B] 36s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [360 kB] 36s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [2364 B] 36s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [45.8 kB] 36s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main armhf Packages [35.1 kB] 36s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/restricted armhf Packages [1860 B] 36s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/universe armhf Packages [285 kB] 36s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse armhf Packages [2088 B] 36s Fetched 850 kB in 1s (1105 kB/s) 36s Reading package lists... 53s tee: /proc/self/fd/2: Permission denied 74s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 74s Hit:2 http://ftpmaster.internal/ubuntu oracular InRelease 74s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease 74s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease 75s Reading package lists... 75s Reading package lists... 76s Building dependency tree... 76s Reading state information... 76s Calculating upgrade... 76s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 77s Reading package lists... 77s Building dependency tree... 77s Reading state information... 78s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 80s autopkgtest [00:49:41]: rebooting testbed after setup commands that affected boot 120s autopkgtest [00:50:21]: 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 148s autopkgtest [00:50:49]: @@@@@@@@@@@@@@@@@@@@ apt-source backuppc 158s Get:1 http://ftpmaster.internal/ubuntu oracular/main backuppc 4.4.0-8build1 (dsc) [2289 B] 158s Get:2 http://ftpmaster.internal/ubuntu oracular/main backuppc 4.4.0-8build1 (tar) [657 kB] 158s Get:3 http://ftpmaster.internal/ubuntu oracular/main backuppc 4.4.0-8build1 (diff) [61.1 kB] 158s gpgv: Signature made Mon Apr 8 15:54:41 2024 UTC 158s gpgv: using RSA key 4FB588A84C2DDE79A74C77876FA458DD1DB03F71 158s gpgv: issuer "juliank@ubuntu.com" 158s gpgv: Can't check signature: No public key 158s dpkg-source: warning: cannot verify inline signature for ./backuppc_4.4.0-8build1.dsc: no acceptable signature found 158s autopkgtest [00:50:59]: testing package backuppc version 4.4.0-8build1 161s autopkgtest [00:51:02]: build not needed 164s autopkgtest [00:51:05]: test smb-backup: preparing testbed 175s Reading package lists... 175s Building dependency tree... 175s Reading state information... 176s Starting pkgProblemResolver with broken count: 0 176s Starting 2 pkgProblemResolver with broken count: 0 176s Done 177s The following additional packages will be installed: 177s apache2 apache2-bin apache2-data apache2-utils backuppc backuppc-rsync 177s libapr1t64 libaprutil1-dbd-sqlite3 libaprutil1-ldap libaprutil1t64 177s libarchive-zip-perl libavahi-client3 libavahi-common-data libavahi-common3 177s libbackuppc-xs-perl libcgi-pm-perl libcups2t64 libfile-listing-perl 177s libhtml-parser-perl libhtml-tagset-perl libhttp-date-perl libldb2 177s liblua5.4-0 libnsl2 libpython3.12t64 libsmbclient0 libtalloc2 libtdb1 177s libtevent0t64 libtime-parsedate-perl libtimedate-perl liburi-perl 177s libwbclient0 postfix python3-dnspython python3-ldb python3-markdown 177s python3-samba python3-talloc python3-tdb samba samba-common samba-common-bin 177s samba-libs smbclient ssl-cert tdb-tools 177s Suggested packages: 177s apache2-doc apache2-suexec-pristine | apache2-suexec-custom www-browser 177s certbot | acme-tiny | acmetool | dehydrated | lacme | lecm | lego 177s libscgi-perl par2 w3m | www-browser cups-common libdata-dump-perl 177s libbusiness-isbn-perl libregexp-ipv6-perl libwww-perl mail-reader 177s postfix-cdb postfix-doc postfix-ldap postfix-lmdb postfix-mta-sts-resolver 177s postfix-mongodb postfix-mysql postfix-pcre postfix-pgsql postfix-sqlite 177s procmail sasl2-bin | dovecot-common python3-trio python3-aioquic python3-h2 177s python3-httpx python3-httpcore python-markdown-doc bind9 bind9utils ctdb 177s ldb-tools ntp | chrony winbind heimdal-clients cifs-utils 177s Recommended packages: 177s libio-dirent-perl rrdtool libcgi-fast-perl libhttp-message-perl python3-gpg 177s attr samba-dsdb-modules samba-vfs-modules samba-ad-provision 177s The following NEW packages will be installed: 177s apache2 apache2-bin apache2-data apache2-utils autopkgtest-satdep backuppc 177s backuppc-rsync libapr1t64 libaprutil1-dbd-sqlite3 libaprutil1-ldap 177s libaprutil1t64 libarchive-zip-perl libavahi-client3 libavahi-common-data 177s libavahi-common3 libbackuppc-xs-perl libcgi-pm-perl libcups2t64 177s libfile-listing-perl libhtml-parser-perl libhtml-tagset-perl 177s libhttp-date-perl libldb2 liblua5.4-0 libnsl2 libpython3.12t64 libsmbclient0 177s libtalloc2 libtdb1 libtevent0t64 libtime-parsedate-perl libtimedate-perl 177s liburi-perl libwbclient0 postfix python3-dnspython python3-ldb 177s python3-markdown python3-samba python3-talloc python3-tdb samba samba-common 177s samba-common-bin samba-libs smbclient ssl-cert tdb-tools 177s 0 upgraded, 48 newly installed, 0 to remove and 0 not upgraded. 177s Need to get 18.5 MB/18.5 MB of archives. 177s After this operation, 62.7 MB of additional disk space will be used. 177s Get:1 /tmp/autopkgtest.H0Dqg7/1-autopkgtest-satdep.deb autopkgtest-satdep armhf 0 [724 B] 177s Get:2 http://ftpmaster.internal/ubuntu oracular/main armhf libapr1t64 armhf 1.7.2-3.2 [86.0 kB] 177s Get:3 http://ftpmaster.internal/ubuntu oracular/main armhf libaprutil1t64 armhf 1.6.3-2ubuntu1 [82.5 kB] 177s Get:4 http://ftpmaster.internal/ubuntu oracular/main armhf libaprutil1-dbd-sqlite3 armhf 1.6.3-2ubuntu1 [9584 B] 177s Get:5 http://ftpmaster.internal/ubuntu oracular/main armhf libaprutil1-ldap armhf 1.6.3-2ubuntu1 [8490 B] 177s Get:6 http://ftpmaster.internal/ubuntu oracular/main armhf liblua5.4-0 armhf 5.4.6-3build2 [133 kB] 177s Get:7 http://ftpmaster.internal/ubuntu oracular/main armhf apache2-bin armhf 2.4.58-1ubuntu8.1 [1203 kB] 177s Get:8 http://ftpmaster.internal/ubuntu oracular/main armhf apache2-data all 2.4.58-1ubuntu8.1 [163 kB] 177s Get:9 http://ftpmaster.internal/ubuntu oracular/main armhf apache2-utils armhf 2.4.58-1ubuntu8.1 [97.3 kB] 177s Get:10 http://ftpmaster.internal/ubuntu oracular/main armhf apache2 armhf 2.4.58-1ubuntu8.1 [90.2 kB] 177s Get:11 http://ftpmaster.internal/ubuntu oracular/main armhf backuppc-rsync armhf 3.1.3.0-3ubuntu1 [233 kB] 177s Get:12 http://ftpmaster.internal/ubuntu oracular/main armhf ssl-cert all 1.1.2ubuntu1 [17.8 kB] 177s Get:13 http://ftpmaster.internal/ubuntu oracular/main armhf libnsl2 armhf 1.3.0-3build3 [36.5 kB] 177s Get:14 http://ftpmaster.internal/ubuntu oracular/main armhf postfix armhf 3.9.0-2 [1203 kB] 177s Get:15 http://ftpmaster.internal/ubuntu oracular/main armhf libarchive-zip-perl all 1.68-1 [90.2 kB] 177s Get:16 http://ftpmaster.internal/ubuntu oracular/main armhf libbackuppc-xs-perl armhf 0.62-2build5 [59.7 kB] 177s Get:17 http://ftpmaster.internal/ubuntu oracular/main armhf libhtml-tagset-perl all 3.24-1 [14.1 kB] 177s Get:18 http://ftpmaster.internal/ubuntu oracular/main armhf liburi-perl all 5.28-1 [88.1 kB] 177s Get:19 http://ftpmaster.internal/ubuntu oracular/main armhf libhtml-parser-perl armhf 3.82-1 [82.4 kB] 177s Get:20 http://ftpmaster.internal/ubuntu oracular-proposed/main armhf libcgi-pm-perl all 4.65-1 [185 kB] 177s Get:21 http://ftpmaster.internal/ubuntu oracular/main armhf libtimedate-perl all 2.3300-2 [34.0 kB] 177s Get:22 http://ftpmaster.internal/ubuntu oracular/main armhf libhttp-date-perl all 6.06-1 [10.2 kB] 177s Get:23 http://ftpmaster.internal/ubuntu oracular/main armhf libfile-listing-perl all 6.16-1 [11.3 kB] 177s Get:24 http://ftpmaster.internal/ubuntu oracular/main armhf libtime-parsedate-perl all 2015.103-4 [28.6 kB] 177s Get:25 http://ftpmaster.internal/ubuntu oracular/main armhf backuppc armhf 4.4.0-8build1 [540 kB] 177s Get:26 http://ftpmaster.internal/ubuntu oracular/main armhf python3-dnspython all 2.6.1-1ubuntu1 [163 kB] 177s Get:27 http://ftpmaster.internal/ubuntu oracular/main armhf libtalloc2 armhf 2.4.2-1build2 [25.9 kB] 177s Get:28 http://ftpmaster.internal/ubuntu oracular/main armhf libtdb1 armhf 1.4.10-1build1 [43.1 kB] 177s Get:29 http://ftpmaster.internal/ubuntu oracular/main armhf libtevent0t64 armhf 0.16.1-2build1 [38.1 kB] 177s Get:30 http://ftpmaster.internal/ubuntu oracular/main armhf libldb2 armhf 2:2.8.0+samba4.19.5+dfsg-4ubuntu9 [163 kB] 177s Get:31 http://ftpmaster.internal/ubuntu oracular/main armhf libpython3.12t64 armhf 3.12.3-1 [2058 kB] 177s Get:32 http://ftpmaster.internal/ubuntu oracular/main armhf python3-ldb armhf 2:2.8.0+samba4.19.5+dfsg-4ubuntu9 [38.5 kB] 177s Get:33 http://ftpmaster.internal/ubuntu oracular/main armhf python3-tdb armhf 1.4.10-1build1 [14.2 kB] 178s Get:34 http://ftpmaster.internal/ubuntu oracular/main armhf python3-markdown all 3.6-1 [73.4 kB] 178s Get:35 http://ftpmaster.internal/ubuntu oracular/main armhf libavahi-common-data armhf 0.8-13ubuntu6 [29.7 kB] 178s Get:36 http://ftpmaster.internal/ubuntu oracular/main armhf libavahi-common3 armhf 0.8-13ubuntu6 [20.2 kB] 178s Get:37 http://ftpmaster.internal/ubuntu oracular/main armhf libavahi-client3 armhf 0.8-13ubuntu6 [24.2 kB] 178s Get:38 http://ftpmaster.internal/ubuntu oracular/main armhf libwbclient0 armhf 2:4.19.5+dfsg-4ubuntu9 [67.5 kB] 178s Get:39 http://ftpmaster.internal/ubuntu oracular/main armhf samba-libs armhf 2:4.19.5+dfsg-4ubuntu9 [5693 kB] 178s Get:40 http://ftpmaster.internal/ubuntu oracular/main armhf python3-talloc armhf 2.4.2-1build2 [11.9 kB] 178s Get:41 http://ftpmaster.internal/ubuntu oracular/main armhf python3-samba armhf 2:4.19.5+dfsg-4ubuntu9 [2488 kB] 178s Get:42 http://ftpmaster.internal/ubuntu oracular/main armhf samba-common all 2:4.19.5+dfsg-4ubuntu9 [64.1 kB] 178s Get:43 http://ftpmaster.internal/ubuntu oracular/main armhf libcups2t64 armhf 2.4.7-1.2ubuntu7 [240 kB] 178s Get:44 http://ftpmaster.internal/ubuntu oracular/main armhf samba-common-bin armhf 2:4.19.5+dfsg-4ubuntu9 [1213 kB] 178s Get:45 http://ftpmaster.internal/ubuntu oracular/main armhf tdb-tools armhf 1.4.10-1build1 [25.3 kB] 178s Get:46 http://ftpmaster.internal/ubuntu oracular/main armhf samba armhf 2:4.19.5+dfsg-4ubuntu9 [957 kB] 178s Get:47 http://ftpmaster.internal/ubuntu oracular/main armhf libsmbclient0 armhf 2:4.19.5+dfsg-4ubuntu9 [57.4 kB] 178s Get:48 http://ftpmaster.internal/ubuntu oracular/main armhf smbclient armhf 2:4.19.5+dfsg-4ubuntu9 [446 kB] 178s Preconfiguring packages ... 178s Fetched 18.5 MB in 1s (14.7 MB/s) 179s Selecting previously unselected package libapr1t64:armhf. 179s (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 ... 58401 files and directories currently installed.) 179s Preparing to unpack .../00-libapr1t64_1.7.2-3.2_armhf.deb ... 179s Unpacking libapr1t64:armhf (1.7.2-3.2) ... 179s Selecting previously unselected package libaprutil1t64:armhf. 179s Preparing to unpack .../01-libaprutil1t64_1.6.3-2ubuntu1_armhf.deb ... 179s Unpacking libaprutil1t64:armhf (1.6.3-2ubuntu1) ... 179s Selecting previously unselected package libaprutil1-dbd-sqlite3:armhf. 179s Preparing to unpack .../02-libaprutil1-dbd-sqlite3_1.6.3-2ubuntu1_armhf.deb ... 179s Unpacking libaprutil1-dbd-sqlite3:armhf (1.6.3-2ubuntu1) ... 179s Selecting previously unselected package libaprutil1-ldap:armhf. 179s Preparing to unpack .../03-libaprutil1-ldap_1.6.3-2ubuntu1_armhf.deb ... 179s Unpacking libaprutil1-ldap:armhf (1.6.3-2ubuntu1) ... 179s Selecting previously unselected package liblua5.4-0:armhf. 179s Preparing to unpack .../04-liblua5.4-0_5.4.6-3build2_armhf.deb ... 179s Unpacking liblua5.4-0:armhf (5.4.6-3build2) ... 179s Selecting previously unselected package apache2-bin. 179s Preparing to unpack .../05-apache2-bin_2.4.58-1ubuntu8.1_armhf.deb ... 179s Unpacking apache2-bin (2.4.58-1ubuntu8.1) ... 179s Selecting previously unselected package apache2-data. 179s Preparing to unpack .../06-apache2-data_2.4.58-1ubuntu8.1_all.deb ... 179s Unpacking apache2-data (2.4.58-1ubuntu8.1) ... 179s Selecting previously unselected package apache2-utils. 179s Preparing to unpack .../07-apache2-utils_2.4.58-1ubuntu8.1_armhf.deb ... 179s Unpacking apache2-utils (2.4.58-1ubuntu8.1) ... 179s Selecting previously unselected package apache2. 179s Preparing to unpack .../08-apache2_2.4.58-1ubuntu8.1_armhf.deb ... 179s Unpacking apache2 (2.4.58-1ubuntu8.1) ... 179s Selecting previously unselected package backuppc-rsync. 179s Preparing to unpack .../09-backuppc-rsync_3.1.3.0-3ubuntu1_armhf.deb ... 179s Unpacking backuppc-rsync (3.1.3.0-3ubuntu1) ... 179s Selecting previously unselected package ssl-cert. 179s Preparing to unpack .../10-ssl-cert_1.1.2ubuntu1_all.deb ... 179s Unpacking ssl-cert (1.1.2ubuntu1) ... 179s Selecting previously unselected package libnsl2:armhf. 179s Preparing to unpack .../11-libnsl2_1.3.0-3build3_armhf.deb ... 179s Unpacking libnsl2:armhf (1.3.0-3build3) ... 179s Selecting previously unselected package postfix. 179s Preparing to unpack .../12-postfix_3.9.0-2_armhf.deb ... 179s Unpacking postfix (3.9.0-2) ... 179s Selecting previously unselected package libarchive-zip-perl. 180s Preparing to unpack .../13-libarchive-zip-perl_1.68-1_all.deb ... 180s Unpacking libarchive-zip-perl (1.68-1) ... 180s Selecting previously unselected package libbackuppc-xs-perl:armhf. 180s Preparing to unpack .../14-libbackuppc-xs-perl_0.62-2build5_armhf.deb ... 180s Unpacking libbackuppc-xs-perl:armhf (0.62-2build5) ... 180s Selecting previously unselected package libhtml-tagset-perl. 180s Preparing to unpack .../15-libhtml-tagset-perl_3.24-1_all.deb ... 180s Unpacking libhtml-tagset-perl (3.24-1) ... 180s Selecting previously unselected package liburi-perl. 180s Preparing to unpack .../16-liburi-perl_5.28-1_all.deb ... 180s Unpacking liburi-perl (5.28-1) ... 180s Selecting previously unselected package libhtml-parser-perl:armhf. 180s Preparing to unpack .../17-libhtml-parser-perl_3.82-1_armhf.deb ... 180s Unpacking libhtml-parser-perl:armhf (3.82-1) ... 180s Selecting previously unselected package libcgi-pm-perl. 180s Preparing to unpack .../18-libcgi-pm-perl_4.65-1_all.deb ... 180s Unpacking libcgi-pm-perl (4.65-1) ... 180s Selecting previously unselected package libtimedate-perl. 180s Preparing to unpack .../19-libtimedate-perl_2.3300-2_all.deb ... 180s Unpacking libtimedate-perl (2.3300-2) ... 180s Selecting previously unselected package libhttp-date-perl. 180s Preparing to unpack .../20-libhttp-date-perl_6.06-1_all.deb ... 180s Unpacking libhttp-date-perl (6.06-1) ... 180s Selecting previously unselected package libfile-listing-perl. 180s Preparing to unpack .../21-libfile-listing-perl_6.16-1_all.deb ... 180s Unpacking libfile-listing-perl (6.16-1) ... 180s Selecting previously unselected package libtime-parsedate-perl. 180s Preparing to unpack .../22-libtime-parsedate-perl_2015.103-4_all.deb ... 180s Unpacking libtime-parsedate-perl (2015.103-4) ... 180s Selecting previously unselected package backuppc. 180s Preparing to unpack .../23-backuppc_4.4.0-8build1_armhf.deb ... 180s Unpacking backuppc (4.4.0-8build1) ... 180s Selecting previously unselected package python3-dnspython. 180s Preparing to unpack .../24-python3-dnspython_2.6.1-1ubuntu1_all.deb ... 180s Unpacking python3-dnspython (2.6.1-1ubuntu1) ... 180s Selecting previously unselected package libtalloc2:armhf. 180s Preparing to unpack .../25-libtalloc2_2.4.2-1build2_armhf.deb ... 180s Unpacking libtalloc2:armhf (2.4.2-1build2) ... 180s Selecting previously unselected package libtdb1:armhf. 180s Preparing to unpack .../26-libtdb1_1.4.10-1build1_armhf.deb ... 180s Unpacking libtdb1:armhf (1.4.10-1build1) ... 180s Selecting previously unselected package libtevent0t64:armhf. 180s Preparing to unpack .../27-libtevent0t64_0.16.1-2build1_armhf.deb ... 180s Unpacking libtevent0t64:armhf (0.16.1-2build1) ... 180s Selecting previously unselected package libldb2:armhf. 180s Preparing to unpack .../28-libldb2_2%3a2.8.0+samba4.19.5+dfsg-4ubuntu9_armhf.deb ... 180s Unpacking libldb2:armhf (2:2.8.0+samba4.19.5+dfsg-4ubuntu9) ... 180s Selecting previously unselected package libpython3.12t64:armhf. 180s Preparing to unpack .../29-libpython3.12t64_3.12.3-1_armhf.deb ... 180s Unpacking libpython3.12t64:armhf (3.12.3-1) ... 180s Selecting previously unselected package python3-ldb. 180s Preparing to unpack .../30-python3-ldb_2%3a2.8.0+samba4.19.5+dfsg-4ubuntu9_armhf.deb ... 180s Unpacking python3-ldb (2:2.8.0+samba4.19.5+dfsg-4ubuntu9) ... 180s Selecting previously unselected package python3-tdb. 180s Preparing to unpack .../31-python3-tdb_1.4.10-1build1_armhf.deb ... 180s Unpacking python3-tdb (1.4.10-1build1) ... 180s Selecting previously unselected package python3-markdown. 180s Preparing to unpack .../32-python3-markdown_3.6-1_all.deb ... 180s Unpacking python3-markdown (3.6-1) ... 180s Selecting previously unselected package libavahi-common-data:armhf. 180s Preparing to unpack .../33-libavahi-common-data_0.8-13ubuntu6_armhf.deb ... 180s Unpacking libavahi-common-data:armhf (0.8-13ubuntu6) ... 180s Selecting previously unselected package libavahi-common3:armhf. 180s Preparing to unpack .../34-libavahi-common3_0.8-13ubuntu6_armhf.deb ... 180s Unpacking libavahi-common3:armhf (0.8-13ubuntu6) ... 180s Selecting previously unselected package libavahi-client3:armhf. 180s Preparing to unpack .../35-libavahi-client3_0.8-13ubuntu6_armhf.deb ... 180s Unpacking libavahi-client3:armhf (0.8-13ubuntu6) ... 180s Selecting previously unselected package libwbclient0:armhf. 180s Preparing to unpack .../36-libwbclient0_2%3a4.19.5+dfsg-4ubuntu9_armhf.deb ... 180s Unpacking libwbclient0:armhf (2:4.19.5+dfsg-4ubuntu9) ... 180s Selecting previously unselected package samba-libs:armhf. 180s Preparing to unpack .../37-samba-libs_2%3a4.19.5+dfsg-4ubuntu9_armhf.deb ... 180s Unpacking samba-libs:armhf (2:4.19.5+dfsg-4ubuntu9) ... 181s Selecting previously unselected package python3-talloc:armhf. 181s Preparing to unpack .../38-python3-talloc_2.4.2-1build2_armhf.deb ... 181s Unpacking python3-talloc:armhf (2.4.2-1build2) ... 181s Selecting previously unselected package python3-samba. 181s Preparing to unpack .../39-python3-samba_2%3a4.19.5+dfsg-4ubuntu9_armhf.deb ... 181s Unpacking python3-samba (2:4.19.5+dfsg-4ubuntu9) ... 181s Selecting previously unselected package samba-common. 181s Preparing to unpack .../40-samba-common_2%3a4.19.5+dfsg-4ubuntu9_all.deb ... 181s Unpacking samba-common (2:4.19.5+dfsg-4ubuntu9) ... 181s Selecting previously unselected package libcups2t64:armhf. 181s Preparing to unpack .../41-libcups2t64_2.4.7-1.2ubuntu7_armhf.deb ... 181s Unpacking libcups2t64:armhf (2.4.7-1.2ubuntu7) ... 181s Selecting previously unselected package samba-common-bin. 181s Preparing to unpack .../42-samba-common-bin_2%3a4.19.5+dfsg-4ubuntu9_armhf.deb ... 181s Unpacking samba-common-bin (2:4.19.5+dfsg-4ubuntu9) ... 181s Selecting previously unselected package tdb-tools. 181s Preparing to unpack .../43-tdb-tools_1.4.10-1build1_armhf.deb ... 181s Unpacking tdb-tools (1.4.10-1build1) ... 181s Selecting previously unselected package samba. 181s Preparing to unpack .../44-samba_2%3a4.19.5+dfsg-4ubuntu9_armhf.deb ... 181s Unpacking samba (2:4.19.5+dfsg-4ubuntu9) ... 181s Selecting previously unselected package libsmbclient0:armhf. 181s Preparing to unpack .../45-libsmbclient0_2%3a4.19.5+dfsg-4ubuntu9_armhf.deb ... 181s Unpacking libsmbclient0:armhf (2:4.19.5+dfsg-4ubuntu9) ... 181s Selecting previously unselected package smbclient. 181s Preparing to unpack .../46-smbclient_2%3a4.19.5+dfsg-4ubuntu9_armhf.deb ... 181s Unpacking smbclient (2:4.19.5+dfsg-4ubuntu9) ... 181s Selecting previously unselected package autopkgtest-satdep. 181s Preparing to unpack .../47-1-autopkgtest-satdep.deb ... 181s Unpacking autopkgtest-satdep (0) ... 181s Setting up libarchive-zip-perl (1.68-1) ... 181s Setting up libtdb1:armhf (1.4.10-1build1) ... 181s Setting up libhtml-tagset-perl (3.24-1) ... 181s Setting up samba-common (2:4.19.5+dfsg-4ubuntu9) ... 183s 183s Creating config file /etc/samba/smb.conf with new version 183s Setting up libwbclient0:armhf (2:4.19.5+dfsg-4ubuntu9) ... 183s Setting up libtalloc2:armhf (2.4.2-1build2) ... 183s Setting up libpython3.12t64:armhf (3.12.3-1) ... 183s Setting up backuppc-rsync (3.1.3.0-3ubuntu1) ... 183s Setting up python3-tdb (1.4.10-1build1) ... 183s Setting up ssl-cert (1.1.2ubuntu1) ... 184s Created symlink /etc/systemd/system/multi-user.target.wants/ssl-cert.service → /usr/lib/systemd/system/ssl-cert.service. 186s Setting up libavahi-common-data:armhf (0.8-13ubuntu6) ... 186s Setting up tdb-tools (1.4.10-1build1) ... 186s update-alternatives: using /usr/bin/tdbbackup.tdbtools to provide /usr/bin/tdbbackup (tdbbackup) in auto mode 186s Setting up python3-markdown (3.6-1) ... 186s Setting up libtimedate-perl (2.3300-2) ... 186s Setting up libtime-parsedate-perl (2015.103-4) ... 186s Setting up python3-dnspython (2.6.1-1ubuntu1) ... 186s Setting up libapr1t64:armhf (1.7.2-3.2) ... 186s Setting up libnsl2:armhf (1.3.0-3build3) ... 186s Setting up liblua5.4-0:armhf (5.4.6-3build2) ... 186s Setting up apache2-data (2.4.58-1ubuntu8.1) ... 186s Setting up libbackuppc-xs-perl:armhf (0.62-2build5) ... 186s Setting up liburi-perl (5.28-1) ... 186s Setting up libtevent0t64:armhf (0.16.1-2build1) ... 186s Setting up libaprutil1t64:armhf (1.6.3-2ubuntu1) ... 186s Setting up libhttp-date-perl (6.06-1) ... 186s Setting up libfile-listing-perl (6.16-1) ... 186s Setting up python3-talloc:armhf (2.4.2-1build2) ... 186s Setting up libavahi-common3:armhf (0.8-13ubuntu6) ... 186s Setting up libaprutil1-ldap:armhf (1.6.3-2ubuntu1) ... 186s Setting up libaprutil1-dbd-sqlite3:armhf (1.6.3-2ubuntu1) ... 186s Setting up postfix (3.9.0-2) ... 187s info: Selecting GID from range 100 to 999 ... 187s info: Adding group `postfix' (GID 111) ... 187s info: Selecting UID from range 100 to 999 ... 187s 187s info: Adding system user `postfix' (UID 107) ... 187s info: Adding new user `postfix' (UID 107) with group `postfix' ... 187s info: Not creating home directory `/var/spool/postfix'. 187s Creating /etc/postfix/dynamicmaps.cf 187s info: Selecting GID from range 100 to 999 ... 187s info: Adding group `postdrop' (GID 112) ... 187s setting myhostname: autopkgtest-lxd-pvmcbi.lxd 187s setting alias maps 187s setting alias database 187s changing /etc/mailname to autopkgtest-lxd-pvmcbi.lxd 187s setting myorigin 187s setting destinations: $myhostname, autopkgtest-lxd-pvmcbi.lxd, localhost.lxd, , localhost 187s setting relayhost: 187s setting mynetworks: 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128 187s setting mailbox_size_limit: 0 187s setting recipient_delimiter: + 189s setting inet_interfaces: all 191s setting inet_protocols: all 191s /etc/aliases does not exist, creating it. 191s WARNING: /etc/aliases exists, but does not have a root alias. 191s 191s Postfix (main.cf) is now set up with a default configuration. If you need to 191s make changes, edit /etc/postfix/main.cf (and others) as needed. To view 191s Postfix configuration values, see postconf(1). 191s 191s After modifying main.cf, be sure to run 'systemctl reload postfix'. 191s 193s Running newaliases 194s Created symlink /etc/systemd/system/multi-user.target.wants/postfix.service → /usr/lib/systemd/system/postfix.service. 195s Setting up libhtml-parser-perl:armhf (3.82-1) ... 195s Setting up libldb2:armhf (2:2.8.0+samba4.19.5+dfsg-4ubuntu9) ... 195s Setting up libavahi-client3:armhf (0.8-13ubuntu6) ... 195s Setting up apache2-utils (2.4.58-1ubuntu8.1) ... 195s Setting up libcgi-pm-perl (4.65-1) ... 195s Setting up samba-libs:armhf (2:4.19.5+dfsg-4ubuntu9) ... 195s Setting up apache2-bin (2.4.58-1ubuntu8.1) ... 195s Setting up python3-ldb (2:2.8.0+samba4.19.5+dfsg-4ubuntu9) ... 195s Setting up libsmbclient0:armhf (2:4.19.5+dfsg-4ubuntu9) ... 195s Setting up libcups2t64:armhf (2.4.7-1.2ubuntu7) ... 195s Setting up python3-samba (2:4.19.5+dfsg-4ubuntu9) ... 196s Setting up apache2 (2.4.58-1ubuntu8.1) ... 196s Enabling module mpm_event. 196s Enabling module authz_core. 196s Enabling module authz_host. 196s Enabling module authn_core. 196s Enabling module auth_basic. 196s Enabling module access_compat. 196s Enabling module authn_file. 196s Enabling module authz_user. 196s Enabling module alias. 196s Enabling module dir. 196s Enabling module autoindex. 196s Enabling module env. 197s Enabling module mime. 197s Enabling module negotiation. 197s Enabling module setenvif. 197s Enabling module filter. 197s Enabling module deflate. 197s Enabling module status. 197s Enabling module reqtimeout. 197s Enabling conf charset. 197s Enabling conf localized-error-pages. 197s Enabling conf other-vhosts-access-log. 197s Enabling conf security. 197s Enabling conf serve-cgi-bin. 197s Enabling site 000-default. 198s Created symlink /etc/systemd/system/multi-user.target.wants/apache2.service → /usr/lib/systemd/system/apache2.service. 199s Created symlink /etc/systemd/system/multi-user.target.wants/apache-htcacheclean.service → /usr/lib/systemd/system/apache-htcacheclean.service. 200s Setting up backuppc (4.4.0-8build1) ... 200s 200s apache2_invoke: Enable configuration backuppc.conf 200s warn: The home directory `/var/lib/backuppc' already exists. Not touching this directory. 201s warn: Warning: The home directory `/var/lib/backuppc' does not belong to the user you are currently creating. 201s Adding password for user backuppc 201s Considering dependency authn_core for auth_basic: 201s Module authn_core already enabled 201s Module auth_basic already enabled 201s Considering dependency authz_core for authz_groupfile: 201s Module authz_core already enabled 201s Enabling module authz_groupfile. 201s To activate the new configuration, you need to run: 201s systemctl restart apache2 201s Module authn_file already enabled 201s Considering dependency authz_core for authz_user: 201s Module authz_core already enabled 201s Module authz_user already enabled 201s Your MPM seems to be threaded. Selecting cgid instead of cgi. 201s Enabling module cgid. 201s To activate the new configuration, you need to run: 201s systemctl restart apache2 201s 201s Creating config file /etc/backuppc/config.pl with new version 202s Created symlink /etc/systemd/system/multi-user.target.wants/backuppc.service → /usr/lib/systemd/system/backuppc.service. 202s Setting up smbclient (2:4.19.5+dfsg-4ubuntu9) ... 202s Setting up samba-common-bin (2:4.19.5+dfsg-4ubuntu9) ... 202s Setting up samba (2:4.19.5+dfsg-4ubuntu9) ... 204s Created symlink /etc/systemd/system/smb.service → /usr/lib/systemd/system/smbd.service. 204s Created symlink /etc/systemd/system/multi-user.target.wants/smbd.service → /usr/lib/systemd/system/smbd.service. 205s Created symlink /etc/systemd/system/nmb.service → /usr/lib/systemd/system/nmbd.service. 205s Created symlink /etc/systemd/system/multi-user.target.wants/nmbd.service → /usr/lib/systemd/system/nmbd.service. 205s Created symlink /etc/systemd/system/samba.service → /usr/lib/systemd/system/samba-ad-dc.service. 205s Created symlink /etc/systemd/system/multi-user.target.wants/samba-ad-dc.service → /usr/lib/systemd/system/samba-ad-dc.service. 206s Setting up autopkgtest-satdep (0) ... 206s Processing triggers for rsyslog (8.2312.0-3ubuntu9) ... 206s Processing triggers for ufw (0.36.2-6) ... 206s Processing triggers for man-db (2.12.1-2) ... 207s Processing triggers for libc-bin (2.39-0ubuntu8.1) ... 224s (Reading database ... 60773 files and directories currently installed.) 224s Removing autopkgtest-satdep (0) ... 230s autopkgtest [00:52:11]: test smb-backup: [----------------------- 232s Populating share path 232s Adding samba share 232s Adding [public] share 232s Configuring backuppc 232s Performing a full backup 232s Backup type: type = full, needs_full = 1, needs_incr = 1, lastFullTime = 0, opts{f} = 1, opts{i} = , opts{F} = 232s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 232s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 232s CheckHostAlive: ran '/bin/ping -c 1 localhost'; returning 0.014 232s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.0.z created 2024-06-10 00:52:13 232s Backup prep: type = full, case = 1, inPlace = 1, doDuplicate = 0, newBkupNum = 0, newBkupIdx = 0, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = ) 232s __bpc_progress_state__ backup share "public" 232s Running: /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -Tc - 232s full backup started for share public 232s started full dump, share=public 232s Xfer PIDs are now 3460,3459 232s xferPids 3460,3459 232s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -Tc - 232s tarmode is now full, system, hidden, noreset, noverbose 232s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 1 232s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 232s __bpc_progress_fileCnt__ 0 232s new 644 0/0 480434 tmp.dIkDw0 232s new 644 0/0 480434 tmp.4j9a2o 232s new 644 0/0 480434 tmp.fhjpRB 232s new 644 0/0 480434 tmp.Wi8EFZ 232s new 644 0/0 480434 tmp.0yRK9Z 232s new 644 0/0 480434 tmp.2fcSGQ 232s new 644 0/0 480434 tmp.zWdj9G 232s new 644 0/0 480434 tmp.YDqCRW 232s new 644 0/0 480434 tmp.N9dABT 232s tar: dumped 10 files and 0 directories 232s Total bytes written: 4804340 (30.6 MiB/s) 232s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 232s new 644 0/0 480434 tmp.QgmLYz 232s __bpc_progress_fileCnt__ 10 232s tarExtract: Done: 0 errors, 0 filesExist, 0 sizeExist, 0 sizeExistComp, 10 filesTotal, 4804340 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377785 sizeNewComp, 13 inodeLast 232s Xfer PIDs are now 232s xferPids 232s full backup 0 complete, 10 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 232s BackupExpire: cntFull = 1, cntIncr = 0, firstFull = 0, firstIncr = , oldestIncr = 0, oldestFull = 0 232s __bpc_progress_state__ fsck 232s Running BackupPC_refCountUpdate -h localhost on localhost 232s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 232s Xfer PIDs are now 3466 232s xferPids 3466 232s BackupPC_refCountUpdate: doing fsck on localhost #0 (full) since $ConfRefCntFsck == 1 232s __bpc_progress_state__ refCnt #0 232s __bpc_progress_state__ cntUpdate #0 232s __bpc_progress_state__ rename #0 232s __bpc_progress_state__ sumUpdate 232s __bpc_progress_fileCnt__ 0/128 232s __bpc_progress_fileCnt__ 8/128 232s __bpc_progress_fileCnt__ 16/128 232s __bpc_progress_fileCnt__ 24/128 232s __bpc_progress_fileCnt__ 32/128 232s __bpc_progress_fileCnt__ 40/128 232s __bpc_progress_fileCnt__ 48/128 232s __bpc_progress_fileCnt__ 56/128 232s __bpc_progress_fileCnt__ 64/128 232s __bpc_progress_fileCnt__ 72/128 232s __bpc_progress_fileCnt__ 80/128 232s __bpc_progress_fileCnt__ 88/128 232s __bpc_progress_fileCnt__ 96/128 232s __bpc_progress_fileCnt__ 104/128 232s __bpc_progress_fileCnt__ 112/128 232s __bpc_progress_fileCnt__ 120/128 232s __bpc_progress_state__ rename total 232s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 232s Xfer PIDs are now 232s xferPids 232s Finished BackupPC_refCountUpdate (running time: 0 sec) 232s Xfer PIDs are now 232s xferPids 232s full backup complete 233s OK: Full backup succeeded 233s Changing share content and performing an incremental backup 233s Backup type: type = incr, needs_full = , needs_incr = , lastFullTime = 1717980733, opts{f} = , opts{i} = 1, opts{F} = 233s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 233s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 233s CheckHostAlive: ran '/bin/ping -c 1 localhost'; returning 0.018 233s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.1.z created 2024-06-10 00:52:14 233s Backup prep: type = incr, case = 3, inPlace = 1, doDuplicate = 1, newBkupNum = 1, newBkupIdx = 1, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = ) 233s Executing /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 233s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 233s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDuplicate line 89. 233s (Did you mean "$Host\'s" instead?) 233s Xfer PIDs are now 3536 233s xferPids 3536 233s __bpc_progress_state__ copy #0 -> #1 233s Copying backup #0 to #1 233s __bpc_progress_fileCnt__ 3 dirs 233s Xfer PIDs are now 3536,3539 233s xferPids 3536,3539 233s __bpc_progress_state__ sumUpdate 233s __bpc_progress_fileCnt__ 0/128 233s __bpc_progress_fileCnt__ 8/128 233s __bpc_progress_fileCnt__ 16/128 233s __bpc_progress_fileCnt__ 24/128 233s __bpc_progress_fileCnt__ 32/128 233s __bpc_progress_fileCnt__ 40/128 233s __bpc_progress_fileCnt__ 48/128 233s __bpc_progress_fileCnt__ 56/128 233s __bpc_progress_fileCnt__ 64/128 233s __bpc_progress_fileCnt__ 72/128 233s __bpc_progress_fileCnt__ 80/128 233s __bpc_progress_fileCnt__ 88/128 233s __bpc_progress_fileCnt__ 96/128 233s __bpc_progress_fileCnt__ 104/128 233s __bpc_progress_fileCnt__ 112/128 233s __bpc_progress_fileCnt__ 120/128 233s __bpc_progress_state__ rename total 233s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 233s Xfer PIDs are now 3536 233s xferPids 3536 233s BackupPC_backupDuplicate: got 0 errors and 0 file open errors 233s Finished BackupPC_backupDuplicate (running time: 0 sec) 233s __bpc_progress_state__ backup share "public" 233s Running: /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 233s incr backup started back to 2024-06-09 23:52:13 (backup #0) for share public 233s started incr dump, share=public 233s Xfer PIDs are now 3543,3542 233s xferPids 3543,3542 233s 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 - 233s tar:1298 Getting files newer than Sun Jun 9 23:52:13 2024 233s tarmode is now full, system, hidden, noreset, noverbose 233s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 233s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 233s __bpc_progress_fileCnt__ 0 233s same 644 0/0 480434 tmp.dIkDw0 233s same 644 0/0 480434 tmp.4j9a2o 233s same 644 0/0 480434 tmp.fhjpRB 233s same 644 0/0 480434 tmp.Wi8EFZ 233s same 644 0/0 480434 tmp.0yRK9Z 233s same 644 0/0 480434 tmp.2fcSGQ 233s same 644 0/0 480434 tmp.zWdj9G 233s same 644 0/0 480434 tmp.YDqCRW 233s same 644 0/0 480434 tmp.N9dABT 233s same 644 0/0 480434 tmp.QgmLYz 233s new 644 0/0 480434 tmp.jcCYtZ 233s new 644 0/0 480434 tmp.sTzygW 233s new 644 0/0 480434 tmp.csRRSc 233s new 644 0/0 480434 tmp.WxNdoh 233s new 644 0/0 480434 tmp.Pea7tJ 233s new 644 0/0 480434 tmp.UeVh05 233s new 644 0/0 480434 tmp.vsQxLL 233s new 644 0/0 480434 tmp.jPcgis 233s new 644 0/0 480434 tmp.YPIdsI 233s tar: dumped 20 files and 0 directories 233s Total bytes written: 9608680 (44.2 MiB/s) 233s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 233s new 644 0/0 480434 tmp.eROHZF 233s __bpc_progress_fileCnt__ 20 233s tarExtract: Done: 0 errors, 10 filesExist, 4804340 sizeExist, 1377785 sizeExistComp, 20 filesTotal, 9608680 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377774 sizeNewComp, 24 inodeLast 233s Xfer PIDs are now 233s xferPids 233s incr backup 1 complete, 20 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 233s BackupExpire: cntFull = 2, cntIncr = 0, firstFull = 0, firstIncr = , oldestIncr = 0, oldestFull = 1.15740740740741e-05 233s __bpc_progress_state__ fsck 233s Running BackupPC_refCountUpdate -h localhost on localhost 233s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 233s Xfer PIDs are now 3549 233s xferPids 3549 233s __bpc_progress_state__ cntUpdate #1 233s __bpc_progress_state__ rename #1 233s __bpc_progress_state__ sumUpdate 233s __bpc_progress_fileCnt__ 0/128 233s __bpc_progress_fileCnt__ 8/128 233s __bpc_progress_fileCnt__ 16/128 233s __bpc_progress_fileCnt__ 24/128 233s __bpc_progress_fileCnt__ 32/128 233s __bpc_progress_fileCnt__ 40/128 233s __bpc_progress_fileCnt__ 48/128 233s __bpc_progress_fileCnt__ 56/128 233s __bpc_progress_fileCnt__ 64/128 233s __bpc_progress_fileCnt__ 72/128 233s __bpc_progress_fileCnt__ 80/128 233s __bpc_progress_fileCnt__ 88/128 233s __bpc_progress_fileCnt__ 96/128 233s __bpc_progress_fileCnt__ 104/128 233s __bpc_progress_fileCnt__ 112/128 233s __bpc_progress_fileCnt__ 120/128 233s __bpc_progress_state__ rename total 233s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 233s Xfer PIDs are now 233s xferPids 233s Finished BackupPC_refCountUpdate (running time: 0 sec) 233s Xfer PIDs are now 233s xferPids 233s incr backup complete 233s OK: Incremental backup succeeded 233s Done. 234s autopkgtest [00:52:15]: test smb-backup: -----------------------] 238s smb-backup PASS 238s autopkgtest [00:52:19]: test smb-backup: - - - - - - - - - - results - - - - - - - - - - 241s autopkgtest [00:52:22]: test authenticated-smb-backup: preparing testbed 251s Reading package lists... 251s Building dependency tree... 251s Reading state information... 252s Starting pkgProblemResolver with broken count: 0 252s Starting 2 pkgProblemResolver with broken count: 0 252s Done 253s The following NEW packages will be installed: 253s autopkgtest-satdep 253s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 253s Need to get 0 B/720 B of archives. 253s After this operation, 0 B of additional disk space will be used. 253s Get:1 /tmp/autopkgtest.H0Dqg7/2-autopkgtest-satdep.deb autopkgtest-satdep armhf 0 [720 B] 253s Selecting previously unselected package autopkgtest-satdep. 253s (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 ... 60774 files and directories currently installed.) 253s Preparing to unpack .../2-autopkgtest-satdep.deb ... 253s Unpacking autopkgtest-satdep (0) ... 253s Setting up autopkgtest-satdep (0) ... 262s (Reading database ... 60773 files and directories currently installed.) 262s Removing autopkgtest-satdep (0) ... 268s autopkgtest [00:52:49]: test authenticated-smb-backup: [----------------------- 270s Populating share path 270s Adding samba share 270s Adding [private] share 270s Creating user 270s Creating a local and samba user called smbtest3864 270s Setting samba password for the smbtest3864 user 270s Added user smbtest3864. 270s Configuring backuppc 270s Performing a full backup 270s Backup type: type = full, needs_full = , needs_incr = , lastFullTime = 1717980733, opts{f} = 1, opts{i} = , opts{F} = 270s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 270s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 270s CheckHostAlive: ran '/bin/ping -c 1 localhost'; returning 0.014 271s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.2.z created 2024-06-10 00:52:51 271s Backup prep: type = full, case = 4, inPlace = 0, doDuplicate = 0, newBkupNum = 2, newBkupIdx = 2, lastBkupNum = 1, lastBkupIdx = 1 (FillCycle = 0, noFillCnt = 0) 271s __bpc_progress_state__ backup share "private" 271s Running: /usr/bin/smbclient \\\\localhost\\private -U smbtest3864 -E -d 1 -c tarmode\ full -mSMB3 -Tc - 271s full backup started for share private 271s started full dump, share=private 271s Xfer PIDs are now 3958,3957 271s xferPids 3958,3957 271s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\private -U smbtest3864 -E -d 1 -c tarmode\ full -mSMB3 -Tc - 271s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 1 271s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 271s tarmode is now full, system, hidden, noreset, noverbose 271s __bpc_progress_fileCnt__ 0 271s new 644 0/0 480434 tmp.Y81tZt 271s new 644 0/0 480434 tmp.Yrz3Nr 271s new 644 0/0 480434 tmp.YRO0aC 271s new 644 0/0 480434 tmp.xlSi9W 271s new 644 0/0 480434 tmp.ArJmdL 271s new 644 0/0 480434 tmp.rZ3oOw 271s new 644 0/0 480434 tmp.xMZURw 271s new 644 0/0 480434 tmp.e2pIvC 271s new 644 0/0 480434 tmp.m9k09R 271s tar: dumped 10 files and 0 directories 271s Total bytes written: 4804340 (30.5 MiB/s) 271s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 271s new 644 0/0 480434 tmp.T7CKia 271s __bpc_progress_fileCnt__ 10 271s tarExtract: Done: 0 errors, 0 filesExist, 0 sizeExist, 0 sizeExistComp, 10 filesTotal, 4804340 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377724 sizeNewComp, 36 inodeLast 271s Xfer PIDs are now 271s xferPids 271s OrphanShareNameClean: removing orphan share public from /var/lib/backuppc/pc/localhost/2 271s __bpc_progress_state__ delete share #2/public 271s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDelete -h localhost -n 2 -l -m -s public / 271s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDelete line 102. 271s (Did you mean "$Host\'s" instead?) 271s Xfer PIDs are now 3964 271s xferPids 3964 271s BackupPC_backupDelete: removing #2/public/ 271s __bpc_progress_state__ merge #2/public/ -> #1/public/ 271s BackupPC_backupDelete: Merge into backup 1/public/ 271s mergeDir: attr write to /var/lib/backuppc/pc/localhost/1/fpublic//attrib failed (digest was ) 271s bpc_attrib_dirWrite: can't open/create raw /var/lib/backuppc/pc/localhost/1/fpublic for writing 271s Xfer PIDs are now 3964,3967 271s xferPids 3964,3967 271s __bpc_progress_state__ refCnt #1 271s __bpc_progress_state__ cntUpdate #1 271s __bpc_progress_state__ rename #1 271s __bpc_progress_state__ refCnt #2 271s BackupPC_refCountUpdate: localhost #2 inodeLast set to 37 (was 24) 271s __bpc_progress_state__ cntUpdate #2 271s __bpc_progress_state__ rename #2 271s __bpc_progress_state__ sumUpdate 271s __bpc_progress_fileCnt__ 0/128 271s __bpc_progress_fileCnt__ 8/128 271s __bpc_progress_fileCnt__ 16/128 271s __bpc_progress_fileCnt__ 24/128 271s __bpc_progress_fileCnt__ 32/128 271s __bpc_progress_fileCnt__ 40/128 271s __bpc_progress_fileCnt__ 48/128 271s __bpc_progress_fileCnt__ 56/128 271s __bpc_progress_fileCnt__ 64/128 271s __bpc_progress_fileCnt__ 72/128 271s __bpc_progress_fileCnt__ 80/128 271s __bpc_progress_fileCnt__ 88/128 271s __bpc_progress_fileCnt__ 96/128 271s __bpc_progress_fileCnt__ 104/128 271s __bpc_progress_fileCnt__ 112/128 271s __bpc_progress_fileCnt__ 120/128 271s __bpc_progress_state__ rename total 271s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 271s Xfer PIDs are now 3964 271s xferPids 3964 271s Xfer PIDs are now 271s xferPids 271s Finished BackupPC_backupDelete, status = 0 (running time: 0 sec) 271s Xfer PIDs are now 271s xferPids 271s full backup 2 complete, 10 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 271s BackupExpire: cntFull = 2, cntIncr = 1, firstFull = 0, firstIncr = 1, oldestIncr = 0.000439814814814815, oldestFull = 0.000451388888888889 271s __bpc_progress_state__ fsck 271s Running BackupPC_refCountUpdate -h localhost on localhost 271s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 271s Xfer PIDs are now 3970 271s xferPids 3970 271s BackupPC_refCountUpdate: doing fsck on localhost #2 (full) since $ConfRefCntFsck == 1 271s __bpc_progress_state__ refCnt #2 271s __bpc_progress_state__ cntUpdate #2 271s __bpc_progress_state__ rename #2 271s __bpc_progress_state__ sumUpdate 271s __bpc_progress_fileCnt__ 0/128 271s __bpc_progress_fileCnt__ 8/128 271s __bpc_progress_fileCnt__ 16/128 271s __bpc_progress_fileCnt__ 24/128 271s __bpc_progress_fileCnt__ 32/128 271s __bpc_progress_fileCnt__ 40/128 271s __bpc_progress_fileCnt__ 48/128 271s __bpc_progress_fileCnt__ 56/128 271s __bpc_progress_fileCnt__ 64/128 271s __bpc_progress_fileCnt__ 72/128 271s __bpc_progress_fileCnt__ 80/128 271s __bpc_progress_fileCnt__ 88/128 271s __bpc_progress_fileCnt__ 96/128 271s __bpc_progress_fileCnt__ 104/128 271s __bpc_progress_fileCnt__ 112/128 271s __bpc_progress_fileCnt__ 120/128 271s __bpc_progress_state__ rename total 271s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 271s Xfer PIDs are now 271s xferPids 271s Finished BackupPC_refCountUpdate (running time: 0 sec) 271s Xfer PIDs are now 271s xferPids 271s full backup complete 271s OK: Full backup succeeded 271s Changing share content and performing an incremental backup 271s Backup type: type = incr, needs_full = , needs_incr = , lastFullTime = 1717980771, opts{f} = , opts{i} = 1, opts{F} = 271s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 271s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 271s CheckHostAlive: ran '/bin/ping -c 1 localhost'; returning 0.016 271s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.3.z created 2024-06-10 00:52:52 271s Backup prep: type = incr, case = 3, inPlace = 1, doDuplicate = 1, newBkupNum = 3, newBkupIdx = 3, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = 1) 271s Executing /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 271s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 271s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDuplicate line 89. 271s (Did you mean "$Host\'s" instead?) 271s Xfer PIDs are now 4040 271s xferPids 4040 271s __bpc_progress_state__ copy #2 -> #3 271s Copying backup #2 to #3 271s __bpc_progress_fileCnt__ 3 dirs 272s Xfer PIDs are now 4040,4043 272s xferPids 4040,4043 272s __bpc_progress_state__ sumUpdate 272s __bpc_progress_fileCnt__ 0/128 272s __bpc_progress_fileCnt__ 8/128 272s __bpc_progress_fileCnt__ 16/128 272s __bpc_progress_fileCnt__ 24/128 272s __bpc_progress_fileCnt__ 32/128 272s __bpc_progress_fileCnt__ 40/128 272s __bpc_progress_fileCnt__ 48/128 272s __bpc_progress_fileCnt__ 56/128 272s __bpc_progress_fileCnt__ 64/128 272s __bpc_progress_fileCnt__ 72/128 272s __bpc_progress_fileCnt__ 80/128 272s __bpc_progress_fileCnt__ 88/128 272s __bpc_progress_fileCnt__ 96/128 272s __bpc_progress_fileCnt__ 104/128 272s __bpc_progress_fileCnt__ 112/128 272s __bpc_progress_fileCnt__ 120/128 272s __bpc_progress_state__ rename total 272s BackupPC_refCountUpdate: host localhost got 0 errors (took 1 secs) 272s Xfer PIDs are now 4040 272s xferPids 4040 272s BackupPC_backupDuplicate: got 0 errors and 0 file open errors 272s Finished BackupPC_backupDuplicate (running time: 1 sec) 272s __bpc_progress_state__ backup share "private" 272s Running: /usr/bin/smbclient \\\\localhost\\private -U smbtest3864 -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 272s incr backup started back to 2024-06-09 23:52:51 (backup #2) for share private 272s started incr dump, share=private 272s Xfer PIDs are now 4047,4046 272s xferPids 4047,4046 272s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\private -U smbtest3864 -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 272s tar:1298 Getting files newer than Sun Jun 9 23:52:51 2024 272s tarmode is now full, system, hidden, noreset, noverbose 272s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 272s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 272s __bpc_progress_fileCnt__ 0 272s same 644 0/0 480434 tmp.Y81tZt 272s same 644 0/0 480434 tmp.Yrz3Nr 272s same 644 0/0 480434 tmp.YRO0aC 272s same 644 0/0 480434 tmp.xlSi9W 272s same 644 0/0 480434 tmp.ArJmdL 272s same 644 0/0 480434 tmp.rZ3oOw 272s same 644 0/0 480434 tmp.xMZURw 272s same 644 0/0 480434 tmp.e2pIvC 272s same 644 0/0 480434 tmp.m9k09R 272s same 644 0/0 480434 tmp.T7CKia 272s new 644 0/0 480434 tmp.dfuSFd 272s new 644 0/0 480434 tmp.5U1mwE 272s new 644 0/0 480434 tmp.H4MjT8 272s new 644 0/0 480434 tmp.ybk5L1 272s new 644 0/0 480434 tmp.Hrc6ND 272s new 644 0/0 480434 tmp.MDkrBN 272s new 644 0/0 480434 tmp.C4n1io 272s new 644 0/0 480434 tmp.Q6cs7b 272s new 644 0/0 480434 tmp.FvDeRj 272s tar: dumped 20 files and 0 directories 272s Total bytes written: 9608680 (44.2 MiB/s) 272s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 272s new 644 0/0 480434 tmp.6Tt7z0 272s __bpc_progress_fileCnt__ 20 272s tarExtract: Done: 0 errors, 10 filesExist, 4804340 sizeExist, 1377724 sizeExistComp, 20 filesTotal, 9608680 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377792 sizeNewComp, 47 inodeLast 272s Xfer PIDs are now 272s xferPids 272s incr backup 3 complete, 20 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 272s BackupExpire: cntFull = 3, cntIncr = 1, firstFull = 0, firstIncr = 1, oldestIncr = 0.000451388888888889, oldestFull = 0.000462962962962963 272s __bpc_progress_state__ fsck 272s Running BackupPC_refCountUpdate -h localhost on localhost 272s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 272s Xfer PIDs are now 4053 272s xferPids 4053 272s __bpc_progress_state__ cntUpdate #3 272s __bpc_progress_state__ rename #3 272s __bpc_progress_state__ sumUpdate 272s __bpc_progress_fileCnt__ 0/128 272s __bpc_progress_fileCnt__ 8/128 272s __bpc_progress_fileCnt__ 16/128 272s __bpc_progress_fileCnt__ 24/128 272s __bpc_progress_fileCnt__ 32/128 272s __bpc_progress_fileCnt__ 40/128 272s __bpc_progress_fileCnt__ 48/128 272s __bpc_progress_fileCnt__ 56/128 272s __bpc_progress_fileCnt__ 64/128 272s __bpc_progress_fileCnt__ 72/128 272s __bpc_progress_fileCnt__ 80/128 272s __bpc_progress_fileCnt__ 88/128 272s __bpc_progress_fileCnt__ 96/128 272s __bpc_progress_fileCnt__ 104/128 272s __bpc_progress_fileCnt__ 112/128 272s __bpc_progress_fileCnt__ 120/128 272s __bpc_progress_state__ rename total 272s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 272s Xfer PIDs are now 272s xferPids 272s Finished BackupPC_refCountUpdate (running time: 0 sec) 272s Xfer PIDs are now 272s xferPids 272s incr backup complete 272s OK: Incremental backup succeeded 272s Done. 272s Deleted user smbtest3864. 272s userdel: smbtest3864 mail spool (/var/mail/smbtest3864) not found 273s autopkgtest [00:52:54]: test authenticated-smb-backup: -----------------------] 276s autopkgtest [00:52:57]: test authenticated-smb-backup: - - - - - - - - - - results - - - - - - - - - - 276s authenticated-smb-backup PASS 280s autopkgtest [00:53:01]: @@@@@@@@@@@@@@@@@@@@ summary 280s smb-backup PASS 280s authenticated-smb-backup PASS