0s autopkgtest [00:02:27]: starting date: 2024-03-19 0s autopkgtest [00:02:27]: git checkout: d9c0295b adt_testbed.py: supress warnings from apt using a shell pipeline 0s autopkgtest [00:02:27]: host juju-7f2275-prod-proposed-migration-environment-4; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.hk58i1f9/out --timeout-copy=6000 --setup-commands 'sed -i "s/ports.ubuntu.com/ftpmaster.internal/; s/ubuntu-ports/ubuntu/" /etc/apt/sources.list `ls /etc/apt/sources.list.d/*.list 2>/dev/null || true`; 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,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:sudo,src:openssl --apt-upgrade backuppc --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=sudo/1.9.15p5-3ubuntu3 openssl/3.0.13-0ubuntu2' -- lxd -r lxd-armhf-10.44.124.246 lxd-armhf-10.44.124.246:autopkgtest/ubuntu/noble/armhf 43s autopkgtest [00:03:10]: @@@@@@@@@@@@@@@@@@@@ test bed setup 45s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [117 kB] 46s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [485 kB] 46s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [3736 kB] 48s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [52.0 kB] 48s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [6540 B] 48s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main armhf Packages [585 kB] 48s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main armhf c-n-f Metadata [2492 B] 48s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted armhf Packages [1372 B] 48s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted armhf c-n-f Metadata [116 B] 48s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe armhf Packages [3609 kB] 49s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/universe armhf c-n-f Metadata [7776 B] 49s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/multiverse armhf Packages [35.6 kB] 49s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/multiverse armhf c-n-f Metadata [116 B] 56s Fetched 8639 kB in 4s (2004 kB/s) 57s Reading package lists... 72s tee: /proc/self/fd/2: Permission denied 101s Hit:1 http://ftpmaster.internal/ubuntu noble InRelease 101s Hit:2 http://ports.ubuntu.com/ubuntu-ports noble InRelease 101s Hit:3 http://ports.ubuntu.com/ubuntu-ports noble-updates InRelease 101s Hit:4 http://ftpmaster.internal/ubuntu noble-updates InRelease 101s Hit:5 http://ports.ubuntu.com/ubuntu-ports noble-backports InRelease 101s Hit:6 http://ftpmaster.internal/ubuntu noble-security InRelease 101s Hit:7 http://ports.ubuntu.com/ubuntu-ports noble-security InRelease 101s Hit:8 http://ftpmaster.internal/ubuntu noble-proposed InRelease 106s Reading package lists... 106s Reading package lists... 107s Building dependency tree... 107s Reading state information... 108s Calculating upgrade... 109s The following packages have been kept back: 109s openssl sudo 109s 0 upgraded, 0 newly installed, 0 to remove and 2 not upgraded. 110s Reading package lists... 110s Building dependency tree... 110s Reading state information... 112s 0 upgraded, 0 newly installed, 0 to remove and 2 not upgraded. 114s autopkgtest [00:04:21]: rebooting testbed after setup commands that affected boot 143s autopkgtest [00:04:50]: testbed running kernel: Linux 5.4.0-170-generic #188-Ubuntu SMP Wed Jan 10 09:51:10 UTC 2024 148s autopkgtest [00:04:55]: testbed dpkg architecture: armhf 162s autopkgtest [00:05:09]: @@@@@@@@@@@@@@@@@@@@ apt-source backuppc 169s Get:1 http://ftpmaster.internal/ubuntu noble/main backuppc 4.4.0-8 (dsc) [2157 B] 169s Get:2 http://ftpmaster.internal/ubuntu noble/main backuppc 4.4.0-8 (tar) [657 kB] 169s Get:3 http://ftpmaster.internal/ubuntu noble/main backuppc 4.4.0-8 (diff) [61.0 kB] 169s gpgv: Signature made Sun Jan 15 11:50:10 2023 UTC 169s gpgv: using RSA key 468C89793B429819E9D761266BE663C75A35C975 169s gpgv: Can't check signature: No public key 169s dpkg-source: warning: cannot verify inline signature for ./backuppc_4.4.0-8.dsc: no acceptable signature found 170s autopkgtest [00:05:17]: testing package backuppc version 4.4.0-8 170s autopkgtest [00:05:17]: build not needed 177s autopkgtest [00:05:24]: test smb-backup: preparing testbed 190s Reading package lists... 191s Building dependency tree... 191s Reading state information... 192s Correcting dependencies...Starting pkgProblemResolver with broken count: 0 192s Starting 2 pkgProblemResolver with broken count: 0 192s Done 193s Done 194s Starting pkgProblemResolver with broken count: 0 194s Starting 2 pkgProblemResolver with broken count: 0 194s Done 196s The following additional packages will be installed: 196s apache2 apache2-bin apache2-data apache2-utils backuppc backuppc-rsync 196s libapr1 libaprutil1 libaprutil1-dbd-sqlite3 libaprutil1-ldap 196s libarchive-zip-perl libavahi-client3 libavahi-common-data libavahi-common3 196s libbackuppc-xs-perl libcgi-pm-perl libcups2 libfile-listing-perl 196s libhtml-parser-perl libhtml-tagset-perl libhttp-date-perl libldb2 196s liblua5.4-0 libpython3.12 libsmbclient libtalloc2 libtdb1 libtevent0 196s libtime-parsedate-perl libtimedate-perl liburi-perl libwbclient0 postfix 196s python3-dnspython python3-ldb python3-markdown python3-samba python3-talloc 196s python3-tdb samba samba-common samba-common-bin samba-libs smbclient 196s ssl-cert tdb-tools 196s Suggested packages: 196s apache2-doc apache2-suexec-pristine | apache2-suexec-custom www-browser 196s certbot | acme-tiny | acmetool | dehydrated | lacme | lecm | lego 196s libscgi-perl par2 w3m | www-browser cups-common libdata-dump-perl 196s libbusiness-isbn-perl libregexp-ipv6-perl libwww-perl procmail postfix-mysql 196s postfix-pgsql postfix-ldap postfix-pcre postfix-lmdb postfix-sqlite 196s sasl2-bin | dovecot-common postfix-cdb mail-reader postfix-mta-sts-resolver 196s postfix-doc python3-trio python3-aioquic python3-h2 python3-httpx 196s python3-httpcore python-markdown-doc bind9 bind9utils ctdb ldb-tools ntp 196s | chrony winbind heimdal-clients cifs-utils 196s Recommended packages: 196s libio-dirent-perl rrdtool libcgi-fast-perl libhttp-message-perl 196s python3-requests-toolbelt python3-gpg attr samba-dsdb-modules 196s samba-vfs-modules samba-ad-provision 196s The following NEW packages will be installed: 196s apache2 apache2-bin apache2-data apache2-utils backuppc backuppc-rsync 196s libapr1 libaprutil1 libaprutil1-dbd-sqlite3 libaprutil1-ldap 196s libarchive-zip-perl libavahi-client3 libavahi-common-data libavahi-common3 196s libbackuppc-xs-perl libcgi-pm-perl libcups2 libfile-listing-perl 196s libhtml-parser-perl libhtml-tagset-perl libhttp-date-perl libldb2 196s liblua5.4-0 libpython3.12 libsmbclient libtalloc2 libtdb1 libtevent0 196s libtime-parsedate-perl libtimedate-perl liburi-perl libwbclient0 postfix 196s python3-dnspython python3-ldb python3-markdown python3-samba python3-talloc 196s python3-tdb samba samba-common samba-common-bin samba-libs smbclient 196s ssl-cert tdb-tools 196s 0 upgraded, 46 newly installed, 0 to remove and 2 not upgraded. 196s 1 not fully installed or removed. 196s Need to get 18.9 MB of archives. 196s After this operation, 67.8 MB of additional disk space will be used. 196s Get:1 http://ftpmaster.internal/ubuntu noble/main armhf libapr1 armhf 1.7.2-3 [86.2 kB] 196s Get:2 http://ftpmaster.internal/ubuntu noble/main armhf libaprutil1 armhf 1.6.3-1ubuntu1 [81.3 kB] 197s Get:3 http://ftpmaster.internal/ubuntu noble/main armhf libaprutil1-dbd-sqlite3 armhf 1.6.3-1ubuntu1 [9574 B] 197s Get:4 http://ftpmaster.internal/ubuntu noble/main armhf libaprutil1-ldap armhf 1.6.3-1ubuntu1 [8482 B] 197s Get:5 http://ftpmaster.internal/ubuntu noble/main armhf liblua5.4-0 armhf 5.4.6-3 [133 kB] 197s Get:6 http://ftpmaster.internal/ubuntu noble/main armhf apache2-bin armhf 2.4.58-1ubuntu2 [1201 kB] 198s Get:7 http://ftpmaster.internal/ubuntu noble/main armhf apache2-data all 2.4.58-1ubuntu2 [163 kB] 198s Get:8 http://ftpmaster.internal/ubuntu noble/main armhf apache2-utils armhf 2.4.58-1ubuntu2 [96.7 kB] 198s Get:9 http://ftpmaster.internal/ubuntu noble/main armhf apache2 armhf 2.4.58-1ubuntu2 [90.2 kB] 198s Get:10 http://ftpmaster.internal/ubuntu noble/main armhf backuppc-rsync armhf 3.1.3.0-3build1 [235 kB] 199s Get:11 http://ftpmaster.internal/ubuntu noble/main armhf ssl-cert all 1.1.2ubuntu1 [17.8 kB] 199s Get:12 http://ftpmaster.internal/ubuntu noble/main armhf postfix armhf 3.8.5-1 [1190 kB] 199s Get:13 http://ftpmaster.internal/ubuntu noble/main armhf libarchive-zip-perl all 1.68-1 [90.2 kB] 199s Get:14 http://ftpmaster.internal/ubuntu noble/main armhf libbackuppc-xs-perl armhf 0.62-2build3 [59.6 kB] 199s Get:15 http://ftpmaster.internal/ubuntu noble/main armhf libhtml-tagset-perl all 3.20-6 [11.3 kB] 199s Get:16 http://ftpmaster.internal/ubuntu noble/main armhf liburi-perl all 5.27-1 [88.0 kB] 200s Get:17 http://ftpmaster.internal/ubuntu noble/main armhf libhtml-parser-perl armhf 3.81-1build1 [82.5 kB] 200s Get:18 http://ftpmaster.internal/ubuntu noble/main armhf libcgi-pm-perl all 4.62-1 [185 kB] 200s Get:19 http://ftpmaster.internal/ubuntu noble/main armhf libtimedate-perl all 2.3300-2 [34.0 kB] 200s Get:20 http://ftpmaster.internal/ubuntu noble/main armhf libhttp-date-perl all 6.06-1 [10.2 kB] 200s Get:21 http://ftpmaster.internal/ubuntu noble/main armhf libfile-listing-perl all 6.16-1 [11.3 kB] 200s Get:22 http://ftpmaster.internal/ubuntu noble/main armhf libtime-parsedate-perl all 2015.103-4 [28.6 kB] 200s Get:23 http://ftpmaster.internal/ubuntu noble/main armhf backuppc armhf 4.4.0-8 [542 kB] 200s Get:24 http://ftpmaster.internal/ubuntu noble/main armhf python3-dnspython all 2.4.2-1ubuntu1 [157 kB] 200s Get:25 http://ftpmaster.internal/ubuntu noble/main armhf libtalloc2 armhf 2.4.2-1 [25.8 kB] 200s Get:26 http://ftpmaster.internal/ubuntu noble/main armhf libtdb1 armhf 1.4.10-1 [43.0 kB] 200s Get:27 http://ftpmaster.internal/ubuntu noble/main armhf libtevent0 armhf 0.16.1-1 [37.1 kB] 200s Get:28 http://ftpmaster.internal/ubuntu noble/main armhf libldb2 armhf 2:2.8.0+samba4.19.5+dfsg-1ubuntu1 [161 kB] 200s Get:29 http://ftpmaster.internal/ubuntu noble/main armhf libpython3.12 armhf 3.12.2-1 [2092 kB] 202s Get:30 http://ftpmaster.internal/ubuntu noble/main armhf python3-ldb armhf 2:2.8.0+samba4.19.5+dfsg-1ubuntu1 [38.5 kB] 202s Get:31 http://ftpmaster.internal/ubuntu noble/main armhf python3-tdb armhf 1.4.10-1 [14.2 kB] 202s Get:32 http://ftpmaster.internal/ubuntu noble/main armhf python3-markdown all 3.5.2-1 [72.0 kB] 202s Get:33 http://ftpmaster.internal/ubuntu noble/main armhf libavahi-common-data armhf 0.8-13ubuntu2 [29.5 kB] 202s Get:34 http://ftpmaster.internal/ubuntu noble/main armhf libavahi-common3 armhf 0.8-13ubuntu2 [20.3 kB] 202s Get:35 http://ftpmaster.internal/ubuntu noble/main armhf libavahi-client3 armhf 0.8-13ubuntu2 [24.4 kB] 202s Get:36 http://ftpmaster.internal/ubuntu noble/main armhf libwbclient0 armhf 2:4.19.5+dfsg-1ubuntu1 [66.6 kB] 202s Get:37 http://ftpmaster.internal/ubuntu noble/main armhf samba-libs armhf 2:4.19.5+dfsg-1ubuntu1 [5683 kB] 205s Get:38 http://ftpmaster.internal/ubuntu noble/main armhf python3-talloc armhf 2.4.2-1 [11.9 kB] 205s Get:39 http://ftpmaster.internal/ubuntu noble/main armhf python3-samba armhf 2:4.19.5+dfsg-1ubuntu1 [2930 kB] 207s Get:40 http://ftpmaster.internal/ubuntu noble/main armhf samba-common all 2:4.19.5+dfsg-1ubuntu1 [63.4 kB] 207s Get:41 http://ftpmaster.internal/ubuntu noble/main armhf libcups2 armhf 2.4.6-0ubuntu3 [236 kB] 207s Get:42 http://ftpmaster.internal/ubuntu noble/main armhf samba-common-bin armhf 2:4.19.5+dfsg-1ubuntu1 [1211 kB] 208s Get:43 http://ftpmaster.internal/ubuntu noble/main armhf tdb-tools armhf 1.4.10-1 [24.5 kB] 208s Get:44 http://ftpmaster.internal/ubuntu noble/main armhf samba armhf 2:4.19.5+dfsg-1ubuntu1 [952 kB] 208s Get:45 http://ftpmaster.internal/ubuntu noble/main armhf libsmbclient armhf 2:4.19.5+dfsg-1ubuntu1 [57.3 kB] 208s Get:46 http://ftpmaster.internal/ubuntu noble/main armhf smbclient armhf 2:4.19.5+dfsg-1ubuntu1 [446 kB] 210s Preconfiguring packages ... 210s Fetched 18.9 MB in 12s (1522 kB/s) 210s Selecting previously unselected package libapr1:armhf. 210s (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 ... 58620 files and directories currently installed.) 210s Preparing to unpack .../00-libapr1_1.7.2-3_armhf.deb ... 210s Unpacking libapr1:armhf (1.7.2-3) ... 210s Selecting previously unselected package libaprutil1:armhf. 210s Preparing to unpack .../01-libaprutil1_1.6.3-1ubuntu1_armhf.deb ... 210s Unpacking libaprutil1:armhf (1.6.3-1ubuntu1) ... 211s Selecting previously unselected package libaprutil1-dbd-sqlite3:armhf. 211s Preparing to unpack .../02-libaprutil1-dbd-sqlite3_1.6.3-1ubuntu1_armhf.deb ... 211s Unpacking libaprutil1-dbd-sqlite3:armhf (1.6.3-1ubuntu1) ... 211s Selecting previously unselected package libaprutil1-ldap:armhf. 211s Preparing to unpack .../03-libaprutil1-ldap_1.6.3-1ubuntu1_armhf.deb ... 211s Unpacking libaprutil1-ldap:armhf (1.6.3-1ubuntu1) ... 211s Selecting previously unselected package liblua5.4-0:armhf. 211s Preparing to unpack .../04-liblua5.4-0_5.4.6-3_armhf.deb ... 211s Unpacking liblua5.4-0:armhf (5.4.6-3) ... 211s Selecting previously unselected package apache2-bin. 211s Preparing to unpack .../05-apache2-bin_2.4.58-1ubuntu2_armhf.deb ... 211s Unpacking apache2-bin (2.4.58-1ubuntu2) ... 211s Selecting previously unselected package apache2-data. 211s Preparing to unpack .../06-apache2-data_2.4.58-1ubuntu2_all.deb ... 211s Unpacking apache2-data (2.4.58-1ubuntu2) ... 211s Selecting previously unselected package apache2-utils. 211s Preparing to unpack .../07-apache2-utils_2.4.58-1ubuntu2_armhf.deb ... 211s Unpacking apache2-utils (2.4.58-1ubuntu2) ... 211s Selecting previously unselected package apache2. 211s Preparing to unpack .../08-apache2_2.4.58-1ubuntu2_armhf.deb ... 211s Unpacking apache2 (2.4.58-1ubuntu2) ... 212s Selecting previously unselected package backuppc-rsync. 212s Preparing to unpack .../09-backuppc-rsync_3.1.3.0-3build1_armhf.deb ... 212s Unpacking backuppc-rsync (3.1.3.0-3build1) ... 212s Selecting previously unselected package ssl-cert. 212s Preparing to unpack .../10-ssl-cert_1.1.2ubuntu1_all.deb ... 212s Unpacking ssl-cert (1.1.2ubuntu1) ... 212s Selecting previously unselected package postfix. 212s Preparing to unpack .../11-postfix_3.8.5-1_armhf.deb ... 212s Unpacking postfix (3.8.5-1) ... 213s Selecting previously unselected package libarchive-zip-perl. 213s Preparing to unpack .../12-libarchive-zip-perl_1.68-1_all.deb ... 213s Unpacking libarchive-zip-perl (1.68-1) ... 213s Selecting previously unselected package libbackuppc-xs-perl:armhf. 213s Preparing to unpack .../13-libbackuppc-xs-perl_0.62-2build3_armhf.deb ... 213s Unpacking libbackuppc-xs-perl:armhf (0.62-2build3) ... 213s Selecting previously unselected package libhtml-tagset-perl. 213s Preparing to unpack .../14-libhtml-tagset-perl_3.20-6_all.deb ... 213s Unpacking libhtml-tagset-perl (3.20-6) ... 213s Selecting previously unselected package liburi-perl. 213s Preparing to unpack .../15-liburi-perl_5.27-1_all.deb ... 213s Unpacking liburi-perl (5.27-1) ... 213s Selecting previously unselected package libhtml-parser-perl:armhf. 213s Preparing to unpack .../16-libhtml-parser-perl_3.81-1build1_armhf.deb ... 213s Unpacking libhtml-parser-perl:armhf (3.81-1build1) ... 213s Selecting previously unselected package libcgi-pm-perl. 213s Preparing to unpack .../17-libcgi-pm-perl_4.62-1_all.deb ... 213s Unpacking libcgi-pm-perl (4.62-1) ... 213s Selecting previously unselected package libtimedate-perl. 213s Preparing to unpack .../18-libtimedate-perl_2.3300-2_all.deb ... 213s Unpacking libtimedate-perl (2.3300-2) ... 213s Selecting previously unselected package libhttp-date-perl. 214s Preparing to unpack .../19-libhttp-date-perl_6.06-1_all.deb ... 214s Unpacking libhttp-date-perl (6.06-1) ... 214s Selecting previously unselected package libfile-listing-perl. 214s Preparing to unpack .../20-libfile-listing-perl_6.16-1_all.deb ... 214s Unpacking libfile-listing-perl (6.16-1) ... 214s Selecting previously unselected package libtime-parsedate-perl. 214s Preparing to unpack .../21-libtime-parsedate-perl_2015.103-4_all.deb ... 214s Unpacking libtime-parsedate-perl (2015.103-4) ... 214s Selecting previously unselected package backuppc. 214s Preparing to unpack .../22-backuppc_4.4.0-8_armhf.deb ... 214s Unpacking backuppc (4.4.0-8) ... 214s Selecting previously unselected package python3-dnspython. 214s Preparing to unpack .../23-python3-dnspython_2.4.2-1ubuntu1_all.deb ... 214s Unpacking python3-dnspython (2.4.2-1ubuntu1) ... 215s Selecting previously unselected package libtalloc2:armhf. 215s Preparing to unpack .../24-libtalloc2_2.4.2-1_armhf.deb ... 215s Unpacking libtalloc2:armhf (2.4.2-1) ... 215s Selecting previously unselected package libtdb1:armhf. 215s Preparing to unpack .../25-libtdb1_1.4.10-1_armhf.deb ... 215s Unpacking libtdb1:armhf (1.4.10-1) ... 215s Selecting previously unselected package libtevent0:armhf. 215s Preparing to unpack .../26-libtevent0_0.16.1-1_armhf.deb ... 215s Unpacking libtevent0:armhf (0.16.1-1) ... 215s Selecting previously unselected package libldb2:armhf. 215s Preparing to unpack .../27-libldb2_2%3a2.8.0+samba4.19.5+dfsg-1ubuntu1_armhf.deb ... 215s Unpacking libldb2:armhf (2:2.8.0+samba4.19.5+dfsg-1ubuntu1) ... 215s Selecting previously unselected package libpython3.12:armhf. 215s Preparing to unpack .../28-libpython3.12_3.12.2-1_armhf.deb ... 215s Unpacking libpython3.12:armhf (3.12.2-1) ... 215s Selecting previously unselected package python3-ldb. 215s Preparing to unpack .../29-python3-ldb_2%3a2.8.0+samba4.19.5+dfsg-1ubuntu1_armhf.deb ... 215s Unpacking python3-ldb (2:2.8.0+samba4.19.5+dfsg-1ubuntu1) ... 215s Selecting previously unselected package python3-tdb. 215s Preparing to unpack .../30-python3-tdb_1.4.10-1_armhf.deb ... 215s Unpacking python3-tdb (1.4.10-1) ... 215s Selecting previously unselected package python3-markdown. 215s Preparing to unpack .../31-python3-markdown_3.5.2-1_all.deb ... 215s Unpacking python3-markdown (3.5.2-1) ... 215s Selecting previously unselected package libavahi-common-data:armhf. 215s Preparing to unpack .../32-libavahi-common-data_0.8-13ubuntu2_armhf.deb ... 215s Unpacking libavahi-common-data:armhf (0.8-13ubuntu2) ... 215s Selecting previously unselected package libavahi-common3:armhf. 215s Preparing to unpack .../33-libavahi-common3_0.8-13ubuntu2_armhf.deb ... 215s Unpacking libavahi-common3:armhf (0.8-13ubuntu2) ... 215s Selecting previously unselected package libavahi-client3:armhf. 215s Preparing to unpack .../34-libavahi-client3_0.8-13ubuntu2_armhf.deb ... 215s Unpacking libavahi-client3:armhf (0.8-13ubuntu2) ... 216s Selecting previously unselected package libwbclient0:armhf. 216s Preparing to unpack .../35-libwbclient0_2%3a4.19.5+dfsg-1ubuntu1_armhf.deb ... 216s Unpacking libwbclient0:armhf (2:4.19.5+dfsg-1ubuntu1) ... 216s Selecting previously unselected package samba-libs:armhf. 216s Preparing to unpack .../36-samba-libs_2%3a4.19.5+dfsg-1ubuntu1_armhf.deb ... 216s Unpacking samba-libs:armhf (2:4.19.5+dfsg-1ubuntu1) ... 216s Selecting previously unselected package python3-talloc:armhf. 216s Preparing to unpack .../37-python3-talloc_2.4.2-1_armhf.deb ... 216s Unpacking python3-talloc:armhf (2.4.2-1) ... 216s Selecting previously unselected package python3-samba. 216s Preparing to unpack .../38-python3-samba_2%3a4.19.5+dfsg-1ubuntu1_armhf.deb ... 216s Unpacking python3-samba (2:4.19.5+dfsg-1ubuntu1) ... 217s Selecting previously unselected package samba-common. 217s Preparing to unpack .../39-samba-common_2%3a4.19.5+dfsg-1ubuntu1_all.deb ... 217s Unpacking samba-common (2:4.19.5+dfsg-1ubuntu1) ... 217s Selecting previously unselected package libcups2:armhf. 217s Preparing to unpack .../40-libcups2_2.4.6-0ubuntu3_armhf.deb ... 217s Unpacking libcups2:armhf (2.4.6-0ubuntu3) ... 217s Selecting previously unselected package samba-common-bin. 217s Preparing to unpack .../41-samba-common-bin_2%3a4.19.5+dfsg-1ubuntu1_armhf.deb ... 217s Unpacking samba-common-bin (2:4.19.5+dfsg-1ubuntu1) ... 217s Selecting previously unselected package tdb-tools. 217s Preparing to unpack .../42-tdb-tools_1.4.10-1_armhf.deb ... 217s Unpacking tdb-tools (1.4.10-1) ... 217s Selecting previously unselected package samba. 217s Preparing to unpack .../43-samba_2%3a4.19.5+dfsg-1ubuntu1_armhf.deb ... 217s Unpacking samba (2:4.19.5+dfsg-1ubuntu1) ... 217s Selecting previously unselected package libsmbclient:armhf. 218s Preparing to unpack .../44-libsmbclient_2%3a4.19.5+dfsg-1ubuntu1_armhf.deb ... 218s Unpacking libsmbclient:armhf (2:4.19.5+dfsg-1ubuntu1) ... 218s Selecting previously unselected package smbclient. 218s Preparing to unpack .../45-smbclient_2%3a4.19.5+dfsg-1ubuntu1_armhf.deb ... 218s Unpacking smbclient (2:4.19.5+dfsg-1ubuntu1) ... 218s Setting up libarchive-zip-perl (1.68-1) ... 218s Setting up libtdb1:armhf (1.4.10-1) ... 218s Setting up libhtml-tagset-perl (3.20-6) ... 218s Setting up libapr1:armhf (1.7.2-3) ... 218s Setting up samba-common (2:4.19.5+dfsg-1ubuntu1) ... 218s 218s Creating config file /etc/samba/smb.conf with new version 218s Setting up libwbclient0:armhf (2:4.19.5+dfsg-1ubuntu1) ... 218s Setting up libtalloc2:armhf (2.4.2-1) ... 218s Setting up backuppc-rsync (3.1.3.0-3build1) ... 219s Setting up python3-tdb (1.4.10-1) ... 219s Setting up libtevent0:armhf (0.16.1-1) ... 219s Setting up ssl-cert (1.1.2ubuntu1) ... 221s Created symlink /etc/systemd/system/multi-user.target.wants/ssl-cert.service → /usr/lib/systemd/system/ssl-cert.service. 223s Setting up libavahi-common-data:armhf (0.8-13ubuntu2) ... 223s Setting up tdb-tools (1.4.10-1) ... 223s update-alternatives: using /usr/bin/tdbbackup.tdbtools to provide /usr/bin/tdbbackup (tdbbackup) in auto mode 223s Setting up python3-markdown (3.5.2-1) ... 224s Setting up libtimedate-perl (2.3300-2) ... 224s Setting up postfix (3.8.5-1) ... 225s info: Selecting GID from range 100 to 999 ... 225s info: Adding group `postfix' (GID 111) ... 225s info: Selecting UID from range 100 to 999 ... 225s 225s info: Adding system user `postfix' (UID 107) ... 225s info: Adding new user `postfix' (UID 107) with group `postfix' ... 225s info: Not creating home directory `/var/spool/postfix'. 225s Creating /etc/postfix/dynamicmaps.cf 226s info: Selecting GID from range 100 to 999 ... 226s info: Adding group `postdrop' (GID 112) ... 226s setting myhostname: autopkgtest-lxd-bnmtnr.lxd 226s setting alias maps 226s setting alias database 226s mailname is not a fully qualified domain name. Not changing /etc/mailname. 226s setting destinations: $myhostname, autopkgtest-lxd-bnmtnr, localhost.localdomain, , localhost 226s setting relayhost: 226s setting mynetworks: 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128 226s setting mailbox_size_limit: 0 226s setting recipient_delimiter: + 228s setting inet_interfaces: all 230s setting inet_protocols: all 230s /etc/aliases does not exist, creating it. 230s WARNING: /etc/aliases exists, but does not have a root alias. 230s 230s Postfix (main.cf) is now set up with a default configuration. If you need to 230s make changes, edit /etc/postfix/main.cf (and others) as needed. To view 230s Postfix configuration values, see postconf(1). 230s 230s After modifying main.cf, be sure to run 'systemctl reload postfix'. 230s 232s Running newaliases 234s Created symlink /etc/systemd/system/multi-user.target.wants/postfix.service → /usr/lib/systemd/system/postfix.service. 239s Setting up libtime-parsedate-perl (2015.103-4) ... 239s Setting up python3-dnspython (2.4.2-1ubuntu1) ... 241s Setting up liblua5.4-0:armhf (5.4.6-3) ... 241s Setting up apache2-data (2.4.58-1ubuntu2) ... 241s Setting up libldb2:armhf (2:2.8.0+samba4.19.5+dfsg-1ubuntu1) ... 241s Setting up libbackuppc-xs-perl:armhf (0.62-2build3) ... 241s Setting up libpython3.12:armhf (3.12.2-1) ... 241s Setting up liburi-perl (5.27-1) ... 241s Setting up libaprutil1:armhf (1.6.3-1ubuntu1) ... 241s Setting up libhttp-date-perl (6.06-1) ... 241s Setting up libfile-listing-perl (6.16-1) ... 241s Setting up python3-talloc:armhf (2.4.2-1) ... 241s Setting up libavahi-common3:armhf (0.8-13ubuntu2) ... 241s Setting up libaprutil1-ldap:armhf (1.6.3-1ubuntu1) ... 241s Setting up libaprutil1-dbd-sqlite3:armhf (1.6.3-1ubuntu1) ... 241s Setting up python3-ldb (2:2.8.0+samba4.19.5+dfsg-1ubuntu1) ... 241s Setting up libhtml-parser-perl:armhf (3.81-1build1) ... 241s Setting up libavahi-client3:armhf (0.8-13ubuntu2) ... 241s Setting up apache2-utils (2.4.58-1ubuntu2) ... 241s Setting up libcgi-pm-perl (4.62-1) ... 241s Setting up samba-libs:armhf (2:4.19.5+dfsg-1ubuntu1) ... 241s Setting up apache2-bin (2.4.58-1ubuntu2) ... 241s Setting up libsmbclient:armhf (2:4.19.5+dfsg-1ubuntu1) ... 241s Setting up smbclient (2:4.19.5+dfsg-1ubuntu1) ... 241s Setting up libcups2:armhf (2.4.6-0ubuntu3) ... 241s Setting up python3-samba (2:4.19.5+dfsg-1ubuntu1) ... 244s /usr/lib/python3/dist-packages/samba/tests/dns_forwarder_helpers/server.py:80: SyntaxWarning: invalid escape sequence '\s' 244s m = re.match(b'^timeout\s+([\d.]+)$', data.strip()) 246s /usr/lib/python3/dist-packages/samba/tests/samba_tool/join_member.py:43: SyntaxWarning: invalid escape sequence '\s' 246s existing_records = re.findall('A:\s+(\d+\.\d+\.\d+\.\d+)\s', out) 246s /usr/lib/python3/dist-packages/samba/tests/samba_tool/ntacl.py:93: SyntaxWarning: invalid escape sequence '\s' 246s self.assertNotRegex(err, '^\s*File [^,]+, line \d+, in', 246s /usr/lib/python3/dist-packages/samba/tests/samba_tool/user_virtualCryptSHA.py:42: SyntaxWarning: invalid escape sequence '\s' 246s p = re.compile("^" + name + ":\s+(\S+)") 246s /usr/lib/python3/dist-packages/samba/tests/samba_tool/user_virtualCryptSHA_base.py:42: SyntaxWarning: invalid escape sequence '\s' 246s p = re.compile("^" + name + ":\s+(\S+)") 246s Setting up apache2 (2.4.58-1ubuntu2) ... 247s Enabling module mpm_event. 247s Enabling module authz_core. 247s Enabling module authz_host. 247s Enabling module authn_core. 247s Enabling module auth_basic. 247s Enabling module access_compat. 247s Enabling module authn_file. 248s Enabling module authz_user. 248s Enabling module alias. 248s Enabling module dir. 248s Enabling module autoindex. 248s Enabling module env. 248s Enabling module mime. 248s Enabling module negotiation. 249s Enabling module setenvif. 249s Enabling module filter. 249s Enabling module deflate. 249s Enabling module status. 249s Enabling module reqtimeout. 250s Enabling conf charset. 250s Enabling conf localized-error-pages. 250s Enabling conf other-vhosts-access-log. 250s Enabling conf security. 250s Enabling conf serve-cgi-bin. 251s Enabling site 000-default. 254s Created symlink /etc/systemd/system/multi-user.target.wants/apache2.service → /usr/lib/systemd/system/apache2.service. 256s Created symlink /etc/systemd/system/multi-user.target.wants/apache-htcacheclean.service → /usr/lib/systemd/system/apache-htcacheclean.service. 261s Setting up backuppc (4.4.0-8) ... 261s 262s apache2_invoke: Enable configuration backuppc.conf 264s warn: The home directory `/var/lib/backuppc' already exists. Not touching this directory. 264s warn: Warning: The home directory `/var/lib/backuppc' does not belong to the user you are currently creating. 264s Adding password for user backuppc 264s Considering dependency authn_core for auth_basic: 264s Module authn_core already enabled 264s Module auth_basic already enabled 265s Considering dependency authz_core for authz_groupfile: 265s Module authz_core already enabled 265s Enabling module authz_groupfile. 265s To activate the new configuration, you need to run: 265s systemctl restart apache2 265s Module authn_file already enabled 265s Considering dependency authz_core for authz_user: 265s Module authz_core already enabled 265s Module authz_user already enabled 265s Your MPM seems to be threaded. Selecting cgid instead of cgi. 265s Enabling module cgid. 265s To activate the new configuration, you need to run: 265s systemctl restart apache2 266s 266s Creating config file /etc/backuppc/config.pl with new version 268s Created symlink /etc/systemd/system/multi-user.target.wants/backuppc.service → /usr/lib/systemd/system/backuppc.service. 269s Setting up samba-common-bin (2:4.19.5+dfsg-1ubuntu1) ... 269s Setting up samba (2:4.19.5+dfsg-1ubuntu1) ... 273s Created symlink /etc/systemd/system/smb.service → /usr/lib/systemd/system/smbd.service. 273s Created symlink /etc/systemd/system/multi-user.target.wants/smbd.service → /usr/lib/systemd/system/smbd.service. 278s Created symlink /etc/systemd/system/nmb.service → /usr/lib/systemd/system/nmbd.service. 278s Created symlink /etc/systemd/system/multi-user.target.wants/nmbd.service → /usr/lib/systemd/system/nmbd.service. 280s Created symlink /etc/systemd/system/samba.service → /usr/lib/systemd/system/samba-ad-dc.service. 280s Created symlink /etc/systemd/system/multi-user.target.wants/samba-ad-dc.service → /usr/lib/systemd/system/samba-ad-dc.service. 281s Setting up autopkgtest-satdep (0) ... 281s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ... 282s Processing triggers for ufw (0.36.2-5) ... 282s Processing triggers for man-db (2.12.0-3) ... 287s Processing triggers for libc-bin (2.39-0ubuntu2) ... 314s (Reading database ... 61246 files and directories currently installed.) 314s Removing autopkgtest-satdep (0) ... 325s autopkgtest [00:07:52]: test smb-backup: [----------------------- 328s Populating share path 329s Adding samba share 329s Adding [public] share 329s Configuring backuppc 329s Performing a full backup 329s Backup type: type = full, needs_full = 1, needs_incr = 1, lastFullTime = 0, opts{f} = 1, opts{i} = , opts{F} = 329s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 329s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 329s CheckHostAlive: ran '/bin/ping -c 1 localhost'; returning 0.046 329s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.0.z created 2024-03-19 00:07:56 329s Backup prep: type = full, case = 1, inPlace = 1, doDuplicate = 0, newBkupNum = 0, newBkupIdx = 0, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = ) 329s __bpc_progress_state__ backup share "public" 329s Running: /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -Tc - 329s full backup started for share public 329s started full dump, share=public 329s Xfer PIDs are now 3337,3336 329s xferPids 3337,3336 329s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -Tc - 329s tarmode is now full, system, hidden, noreset, noverbose 329s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 1 329s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 329s __bpc_progress_fileCnt__ 0 330s new 644 0/0 480434 tmp.IaqcPh 330s new 644 0/0 480434 tmp.Y5j9Zo 330s new 644 0/0 480434 tmp.qX4zYw 330s new 644 0/0 480434 tmp.WuGAEv 330s new 644 0/0 480434 tmp.h0HK0i 330s new 644 0/0 480434 tmp.mJn3fF 330s new 644 0/0 480434 tmp.5q7zbf 330s new 644 0/0 480434 tmp.SoDBlk 330s new 644 0/0 480434 tmp.dUwsPg 330s tar: dumped 10 files and 0 directories 330s Total bytes written: 4804340 (9.7 MiB/s) 330s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 330s new 644 0/0 480434 tmp.1eFhSM 330s __bpc_progress_fileCnt__ 10 330s tarExtract: Done: 0 errors, 0 filesExist, 0 sizeExist, 0 sizeExistComp, 10 filesTotal, 4804340 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377752 sizeNewComp, 13 inodeLast 330s Xfer PIDs are now 330s xferPids 330s full backup 0 complete, 10 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 330s BackupExpire: cntFull = 1, cntIncr = 0, firstFull = 0, firstIncr = , oldestIncr = 0, oldestFull = 1.15740740740741e-05 330s __bpc_progress_state__ fsck 330s Running BackupPC_refCountUpdate -h localhost on localhost 330s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 330s Xfer PIDs are now 3343 330s xferPids 3343 330s BackupPC_refCountUpdate: doing fsck on localhost #0 (full) since $ConfRefCntFsck == 1 330s __bpc_progress_state__ refCnt #0 330s __bpc_progress_state__ cntUpdate #0 330s __bpc_progress_state__ rename #0 330s __bpc_progress_state__ sumUpdate 330s __bpc_progress_fileCnt__ 0/128 330s __bpc_progress_fileCnt__ 8/128 330s __bpc_progress_fileCnt__ 16/128 330s __bpc_progress_fileCnt__ 24/128 330s __bpc_progress_fileCnt__ 32/128 330s __bpc_progress_fileCnt__ 40/128 330s __bpc_progress_fileCnt__ 48/128 330s __bpc_progress_fileCnt__ 56/128 330s __bpc_progress_fileCnt__ 64/128 330s __bpc_progress_fileCnt__ 72/128 330s __bpc_progress_fileCnt__ 80/128 330s __bpc_progress_fileCnt__ 88/128 330s __bpc_progress_fileCnt__ 96/128 330s __bpc_progress_fileCnt__ 104/128 330s __bpc_progress_fileCnt__ 112/128 330s __bpc_progress_fileCnt__ 120/128 330s __bpc_progress_state__ rename total 330s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 330s Xfer PIDs are now 330s xferPids 330s Finished BackupPC_refCountUpdate (running time: 0 sec) 330s Xfer PIDs are now 330s xferPids 330s full backup complete 330s OK: Full backup succeeded 330s Changing share content and performing an incremental backup 331s Backup type: type = incr, needs_full = , needs_incr = , lastFullTime = 1710806876, opts{f} = , opts{i} = 1, opts{F} = 331s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 331s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 331s CheckHostAlive: ran '/bin/ping -c 1 localhost'; returning 0.045 331s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.1.z created 2024-03-19 00:07:58 331s Backup prep: type = incr, case = 3, inPlace = 1, doDuplicate = 1, newBkupNum = 1, newBkupIdx = 1, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = ) 331s Executing /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 331s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 332s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDuplicate line 89. 332s (Did you mean "$Host\'s" instead?) 332s Xfer PIDs are now 3413 332s xferPids 3413 332s __bpc_progress_state__ copy #0 -> #1 332s Copying backup #0 to #1 332s __bpc_progress_fileCnt__ 3 dirs 332s Xfer PIDs are now 3413,3416 332s xferPids 3413,3416 332s __bpc_progress_state__ sumUpdate 332s __bpc_progress_fileCnt__ 0/128 332s __bpc_progress_fileCnt__ 8/128 332s __bpc_progress_fileCnt__ 16/128 332s __bpc_progress_fileCnt__ 24/128 332s __bpc_progress_fileCnt__ 32/128 332s __bpc_progress_fileCnt__ 40/128 332s __bpc_progress_fileCnt__ 48/128 332s __bpc_progress_fileCnt__ 56/128 332s __bpc_progress_fileCnt__ 64/128 332s __bpc_progress_fileCnt__ 72/128 332s __bpc_progress_fileCnt__ 80/128 332s __bpc_progress_fileCnt__ 88/128 332s __bpc_progress_fileCnt__ 96/128 332s __bpc_progress_fileCnt__ 104/128 332s __bpc_progress_fileCnt__ 112/128 332s __bpc_progress_fileCnt__ 120/128 332s __bpc_progress_state__ rename total 332s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 332s Xfer PIDs are now 3413 332s xferPids 3413 332s BackupPC_backupDuplicate: got 0 errors and 0 file open errors 332s Finished BackupPC_backupDuplicate (running time: 1 sec) 332s __bpc_progress_state__ backup share "public" 332s Running: /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 332s incr backup started back to 2024-03-18 23:07:56 (backup #0) for share public 332s started incr dump, share=public 332s Xfer PIDs are now 3420,3419 332s xferPids 3420,3419 332s 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 - 332s tar:1298 Getting files newer than Mon Mar 18 23:07:56 2024 332s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 332s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 332s tarmode is now full, system, hidden, noreset, noverbose 332s __bpc_progress_fileCnt__ 0 332s same 644 0/0 480434 tmp.IaqcPh 332s same 644 0/0 480434 tmp.Y5j9Zo 332s same 644 0/0 480434 tmp.qX4zYw 332s same 644 0/0 480434 tmp.WuGAEv 332s same 644 0/0 480434 tmp.h0HK0i 332s same 644 0/0 480434 tmp.mJn3fF 332s same 644 0/0 480434 tmp.5q7zbf 332s same 644 0/0 480434 tmp.SoDBlk 332s same 644 0/0 480434 tmp.dUwsPg 332s same 644 0/0 480434 tmp.1eFhSM 332s new 644 0/0 480434 tmp.GNiZRq 333s new 644 0/0 480434 tmp.TLlCkX 333s new 644 0/0 480434 tmp.0wtvC8 333s new 644 0/0 480434 tmp.nJni2O 333s new 644 0/0 480434 tmp.lODePy 333s new 644 0/0 480434 tmp.QrDC4q 333s new 644 0/0 480434 tmp.O80QI7 333s new 644 0/0 480434 tmp.J4SdHN 333s new 644 0/0 480434 tmp.a7HM9p 333s tar: dumped 20 files and 0 directories 333s Total bytes written: 9608680 (12.1 MiB/s) 333s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 333s new 644 0/0 480434 tmp.sXV9Pp 333s __bpc_progress_fileCnt__ 20 333s tarExtract: Done: 0 errors, 10 filesExist, 4804340 sizeExist, 1377752 sizeExistComp, 20 filesTotal, 9608680 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377743 sizeNewComp, 24 inodeLast 333s Xfer PIDs are now 333s xferPids 333s incr backup 1 complete, 20 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 333s BackupExpire: cntFull = 2, cntIncr = 0, firstFull = 0, firstIncr = , oldestIncr = 0, oldestFull = 4.62962962962963e-05 333s __bpc_progress_state__ fsck 333s Running BackupPC_refCountUpdate -h localhost on localhost 333s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 333s Xfer PIDs are now 3426 333s xferPids 3426 333s __bpc_progress_state__ cntUpdate #1 333s __bpc_progress_state__ rename #1 333s __bpc_progress_state__ sumUpdate 333s __bpc_progress_fileCnt__ 0/128 333s __bpc_progress_fileCnt__ 8/128 333s __bpc_progress_fileCnt__ 16/128 333s __bpc_progress_fileCnt__ 24/128 333s __bpc_progress_fileCnt__ 32/128 333s __bpc_progress_fileCnt__ 40/128 333s __bpc_progress_fileCnt__ 48/128 333s __bpc_progress_fileCnt__ 56/128 333s __bpc_progress_fileCnt__ 64/128 333s __bpc_progress_fileCnt__ 72/128 333s __bpc_progress_fileCnt__ 80/128 333s __bpc_progress_fileCnt__ 88/128 333s __bpc_progress_fileCnt__ 96/128 333s __bpc_progress_fileCnt__ 104/128 333s __bpc_progress_fileCnt__ 112/128 333s __bpc_progress_fileCnt__ 120/128 333s __bpc_progress_state__ rename total 333s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 333s Xfer PIDs are now 333s xferPids 333s Finished BackupPC_refCountUpdate (running time: 0 sec) 333s Xfer PIDs are now 333s xferPids 333s incr backup complete 333s OK: Incremental backup succeeded 333s Done. 334s autopkgtest [00:08:01]: test smb-backup: -----------------------] 338s smb-backup PASS 338s autopkgtest [00:08:05]: test smb-backup: - - - - - - - - - - results - - - - - - - - - - 342s autopkgtest [00:08:09]: test authenticated-smb-backup: preparing testbed 358s Reading package lists... 359s Building dependency tree... 359s Reading state information... 360s Starting pkgProblemResolver with broken count: 0 360s Starting 2 pkgProblemResolver with broken count: 0 360s Done 363s 0 upgraded, 0 newly installed, 0 to remove and 2 not upgraded. 363s 1 not fully installed or removed. 363s After this operation, 0 B of additional disk space will be used. 363s Setting up autopkgtest-satdep (0) ... 379s (Reading database ... 61246 files and directories currently installed.) 379s Removing autopkgtest-satdep (0) ... 390s autopkgtest [00:08:57]: test authenticated-smb-backup: [----------------------- 393s Populating share path 393s Adding samba share 393s Adding [private] share 394s Creating user 394s Creating a local and samba user called smbtest3721 394s Setting samba password for the smbtest3721 user 394s Added user smbtest3721. 394s Configuring backuppc 394s Performing a full backup 395s Backup type: type = full, needs_full = , needs_incr = , lastFullTime = 1710806876, opts{f} = 1, opts{i} = , opts{F} = 395s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 395s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 395s CheckHostAlive: ran '/bin/ping -c 1 localhost'; returning 3.650 395s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.2.z created 2024-03-19 00:09:02 395s Backup prep: type = full, case = 4, inPlace = 0, doDuplicate = 0, newBkupNum = 2, newBkupIdx = 2, lastBkupNum = 1, lastBkupIdx = 1 (FillCycle = 0, noFillCnt = 0) 395s __bpc_progress_state__ backup share "private" 395s Running: /usr/bin/smbclient \\\\localhost\\private -U smbtest3721 -E -d 1 -c tarmode\ full -mSMB3 -Tc - 395s full backup started for share private 395s started full dump, share=private 395s Xfer PIDs are now 3817,3816 395s xferPids 3817,3816 395s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\private -U smbtest3721 -E -d 1 -c tarmode\ full -mSMB3 -Tc - 395s tarmode is now full, system, hidden, noreset, noverbose 395s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 1 395s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 395s __bpc_progress_fileCnt__ 0 395s new 644 0/0 480434 tmp.4X4moj 395s new 644 0/0 480434 tmp.Im5adn 395s new 644 0/0 480434 tmp.hoQdbH 395s new 644 0/0 480434 tmp.czzu2K 395s new 644 0/0 480434 tmp.H4glpq 395s new 644 0/0 480434 tmp.TFLkBG 396s new 644 0/0 480434 tmp.lglyvb 396s new 644 0/0 480434 tmp.b1jD1v 396s new 644 0/0 480434 tmp.L9rxRb 396s tar: dumped 10 files and 0 directories 396s Total bytes written: 4804340 (5.7 MiB/s) 396s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 396s new 644 0/0 480434 tmp.aoE4f6 396s __bpc_progress_fileCnt__ 10 396s tarExtract: Done: 0 errors, 0 filesExist, 0 sizeExist, 0 sizeExistComp, 10 filesTotal, 4804340 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377737 sizeNewComp, 36 inodeLast 396s Xfer PIDs are now 396s xferPids 396s OrphanShareNameClean: removing orphan share public from /var/lib/backuppc/pc/localhost/2 396s __bpc_progress_state__ delete share #2/public 396s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDelete -h localhost -n 2 -l -m -s public / 396s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDelete line 102. 396s (Did you mean "$Host\'s" instead?) 396s Xfer PIDs are now 3823 396s xferPids 3823 396s BackupPC_backupDelete: removing #2/public/ 396s __bpc_progress_state__ merge #2/public/ -> #1/public/ 396s BackupPC_backupDelete: Merge into backup 1/public/ 396s mergeDir: attr write to /var/lib/backuppc/pc/localhost/1/fpublic//attrib failed (digest was ) 396s bpc_attrib_dirWrite: can't open/create raw /var/lib/backuppc/pc/localhost/1/fpublic for writing 397s Xfer PIDs are now 3823,3826 397s xferPids 3823,3826 397s __bpc_progress_state__ refCnt #1 397s __bpc_progress_state__ cntUpdate #1 397s __bpc_progress_state__ rename #1 397s __bpc_progress_state__ refCnt #2 397s BackupPC_refCountUpdate: localhost #2 inodeLast set to 37 (was 24) 397s __bpc_progress_state__ cntUpdate #2 397s __bpc_progress_state__ rename #2 397s __bpc_progress_state__ sumUpdate 397s __bpc_progress_fileCnt__ 0/128 397s __bpc_progress_fileCnt__ 8/128 397s __bpc_progress_fileCnt__ 16/128 397s __bpc_progress_fileCnt__ 24/128 397s __bpc_progress_fileCnt__ 32/128 397s __bpc_progress_fileCnt__ 40/128 397s __bpc_progress_fileCnt__ 48/128 397s __bpc_progress_fileCnt__ 56/128 397s __bpc_progress_fileCnt__ 64/128 397s __bpc_progress_fileCnt__ 72/128 397s __bpc_progress_fileCnt__ 80/128 397s __bpc_progress_fileCnt__ 88/128 397s __bpc_progress_fileCnt__ 96/128 397s __bpc_progress_fileCnt__ 104/128 397s __bpc_progress_fileCnt__ 112/128 397s __bpc_progress_fileCnt__ 120/128 397s __bpc_progress_state__ rename total 397s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 397s Xfer PIDs are now 3823 397s xferPids 3823 397s Xfer PIDs are now 397s xferPids 397s Finished BackupPC_backupDelete, status = 0 (running time: 1 sec) 397s Xfer PIDs are now 397s xferPids 397s full backup 2 complete, 10 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 397s BackupExpire: cntFull = 2, cntIncr = 1, firstFull = 0, firstIncr = 1, oldestIncr = 0.000752314814814815, oldestFull = 0.000787037037037037 397s __bpc_progress_state__ fsck 397s Running BackupPC_refCountUpdate -h localhost on localhost 397s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 397s Xfer PIDs are now 3829 397s xferPids 3829 397s BackupPC_refCountUpdate: doing fsck on localhost #2 (full) since $ConfRefCntFsck == 1 397s __bpc_progress_state__ refCnt #2 397s __bpc_progress_state__ cntUpdate #2 398s __bpc_progress_state__ rename #2 398s __bpc_progress_state__ sumUpdate 398s __bpc_progress_fileCnt__ 0/128 398s __bpc_progress_fileCnt__ 8/128 398s __bpc_progress_fileCnt__ 16/128 398s __bpc_progress_fileCnt__ 24/128 398s __bpc_progress_fileCnt__ 32/128 398s __bpc_progress_fileCnt__ 40/128 398s __bpc_progress_fileCnt__ 48/128 398s __bpc_progress_fileCnt__ 56/128 398s __bpc_progress_fileCnt__ 64/128 398s __bpc_progress_fileCnt__ 72/128 398s __bpc_progress_fileCnt__ 80/128 398s __bpc_progress_fileCnt__ 88/128 398s __bpc_progress_fileCnt__ 96/128 398s __bpc_progress_fileCnt__ 104/128 398s __bpc_progress_fileCnt__ 112/128 398s __bpc_progress_fileCnt__ 120/128 398s __bpc_progress_state__ rename total 398s BackupPC_refCountUpdate: host localhost got 0 errors (took 1 secs) 398s Xfer PIDs are now 398s xferPids 398s Finished BackupPC_refCountUpdate (running time: 1 sec) 398s Xfer PIDs are now 398s xferPids 398s full backup complete 398s OK: Full backup succeeded 398s Changing share content and performing an incremental backup 399s Backup type: type = incr, needs_full = , needs_incr = , lastFullTime = 1710806942, opts{f} = , opts{i} = 1, opts{F} = 399s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 399s cmdSystemOrEval: about to system /bin/ping -c 1 localhost 399s CheckHostAlive: ran '/bin/ping -c 1 localhost'; returning 0.057 399s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.3.z created 2024-03-19 00:09:06 399s Backup prep: type = incr, case = 3, inPlace = 1, doDuplicate = 1, newBkupNum = 3, newBkupIdx = 3, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = 1) 399s Executing /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 399s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 399s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDuplicate line 89. 399s (Did you mean "$Host\'s" instead?) 399s Xfer PIDs are now 3899 399s xferPids 3899 399s __bpc_progress_state__ copy #2 -> #3 399s Copying backup #2 to #3 399s __bpc_progress_fileCnt__ 3 dirs 401s Xfer PIDs are now 3902,3899 401s xferPids 3902,3899 401s __bpc_progress_state__ sumUpdate 401s __bpc_progress_fileCnt__ 0/128 401s __bpc_progress_fileCnt__ 8/128 401s __bpc_progress_fileCnt__ 16/128 401s __bpc_progress_fileCnt__ 24/128 401s __bpc_progress_fileCnt__ 32/128 401s __bpc_progress_fileCnt__ 40/128 401s __bpc_progress_fileCnt__ 48/128 401s __bpc_progress_fileCnt__ 56/128 401s __bpc_progress_fileCnt__ 64/128 401s __bpc_progress_fileCnt__ 72/128 401s __bpc_progress_fileCnt__ 80/128 401s __bpc_progress_fileCnt__ 88/128 401s __bpc_progress_fileCnt__ 96/128 401s __bpc_progress_fileCnt__ 104/128 401s __bpc_progress_fileCnt__ 112/128 401s __bpc_progress_fileCnt__ 120/128 401s __bpc_progress_state__ rename total 401s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 401s Xfer PIDs are now 3899 401s xferPids 3899 401s BackupPC_backupDuplicate: got 0 errors and 0 file open errors 401s Finished BackupPC_backupDuplicate (running time: 1 sec) 401s __bpc_progress_state__ backup share "private" 401s Running: /usr/bin/smbclient \\\\localhost\\private -U smbtest3721 -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 401s incr backup started back to 2024-03-18 23:09:02 (backup #2) for share private 401s started incr dump, share=private 401s Xfer PIDs are now 3906,3905 401s xferPids 3906,3905 401s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\private -U smbtest3721 -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 401s tar:1298 Getting files newer than Mon Mar 18 23:09:02 2024 401s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 401s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 401s tarmode is now full, system, hidden, noreset, noverbose 401s __bpc_progress_fileCnt__ 0 401s same 644 0/0 480434 tmp.4X4moj 401s same 644 0/0 480434 tmp.Im5adn 401s same 644 0/0 480434 tmp.hoQdbH 401s same 644 0/0 480434 tmp.czzu2K 401s same 644 0/0 480434 tmp.H4glpq 401s same 644 0/0 480434 tmp.TFLkBG 401s same 644 0/0 480434 tmp.lglyvb 401s same 644 0/0 480434 tmp.b1jD1v 401s same 644 0/0 480434 tmp.L9rxRb 401s same 644 0/0 480434 tmp.aoE4f6 401s new 644 0/0 480434 tmp.6wNYkN 401s new 644 0/0 480434 tmp.CsQEeT 401s new 644 0/0 480434 tmp.Wk5oyj 401s new 644 0/0 480434 tmp.fSbnlf 401s new 644 0/0 480434 tmp.K2hxCm 401s new 644 0/0 480434 tmp.hr2lx1 401s new 644 0/0 480434 tmp.mYVMXo 401s new 644 0/0 480434 tmp.S6X3I2 401s new 644 0/0 480434 tmp.0VNKy3 401s tar: dumped 20 files and 0 directories 401s Total bytes written: 9608680 (8.6 MiB/s) 401s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 401s new 644 0/0 480434 tmp.y3T3vv 401s __bpc_progress_fileCnt__ 20 401s tarExtract: Done: 0 errors, 10 filesExist, 4804340 sizeExist, 1377737 sizeExistComp, 20 filesTotal, 9608680 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377737 sizeNewComp, 47 inodeLast 401s Xfer PIDs are now 401s xferPids 401s incr backup 3 complete, 20 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 401s BackupExpire: cntFull = 3, cntIncr = 1, firstFull = 0, firstIncr = 1, oldestIncr = 0.000798611111111111, oldestFull = 0.000833333333333333 401s __bpc_progress_state__ fsck 401s Running BackupPC_refCountUpdate -h localhost on localhost 401s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 402s Xfer PIDs are now 3913 402s xferPids 3913 402s __bpc_progress_state__ cntUpdate #3 402s __bpc_progress_state__ rename #3 402s __bpc_progress_state__ sumUpdate 402s __bpc_progress_fileCnt__ 0/128 402s __bpc_progress_fileCnt__ 8/128 402s __bpc_progress_fileCnt__ 16/128 402s __bpc_progress_fileCnt__ 24/128 402s __bpc_progress_fileCnt__ 32/128 402s __bpc_progress_fileCnt__ 40/128 402s __bpc_progress_fileCnt__ 48/128 402s __bpc_progress_fileCnt__ 56/128 402s __bpc_progress_fileCnt__ 64/128 402s __bpc_progress_fileCnt__ 72/128 402s __bpc_progress_fileCnt__ 80/128 402s __bpc_progress_fileCnt__ 88/128 402s __bpc_progress_fileCnt__ 96/128 402s __bpc_progress_fileCnt__ 104/128 402s __bpc_progress_fileCnt__ 112/128 402s __bpc_progress_fileCnt__ 120/128 402s __bpc_progress_state__ rename total 402s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 402s Xfer PIDs are now 402s xferPids 402s Finished BackupPC_refCountUpdate (running time: 1 sec) 402s Xfer PIDs are now 402s xferPids 402s incr backup complete 402s OK: Incremental backup succeeded 402s Done. 402s Deleted user smbtest3721. 403s userdel: smbtest3721 mail spool (/var/mail/smbtest3721) not found 403s autopkgtest [00:09:10]: test authenticated-smb-backup: -----------------------] 408s authenticated-smb-backup PASS 408s autopkgtest [00:09:15]: test authenticated-smb-backup: - - - - - - - - - - results - - - - - - - - - - 413s autopkgtest [00:09:20]: @@@@@@@@@@@@@@@@@@@@ summary 413s smb-backup PASS 413s authenticated-smb-backup PASS