0s autopkgtest [11:47:58]: starting date and time: 2024-03-25 11:47:58+0000
  0s autopkgtest [11:47:58]: git checkout: 4a1cd702 l/adt_testbed: don't blame the testbed for unsolvable build deps
  0s autopkgtest [11:47:58]: host juju-7f2275-prod-proposed-migration-environment-3; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.tj4197ax/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --setup-commands /home/ubuntu/autopkgtest/setup-commands/setup-testbed --apt-pocket=proposed --apt-upgrade backuppc --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=courier/1.0.16-3.2build4 cups/2.4.7-1.2ubuntu1 db5.3/5.3.28+dfsg2-6 gdbm/1.23-5.1 gnutls28/3.8.3-1.1ubuntu2 gpgme1.0/1.18.0-4.1ubuntu3 libarchive/3.7.2-1.1ubuntu2 libtirpc/1.3.4+ds-1.1 mmdebstrap/1.4.3-6 nettle/3.9.1-2.2 openssl/3.0.13-0ubuntu2 perl/5.38.2-3.2 python3.12/3.12.2-4build3 readline/8.2-4 samba/2:4.19.5+dfsg-4ubuntu7 sssd/2.9.4-1.1ubuntu3 tevent/0.16.1-2' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-3@lcy02-40.secgroup --name adt-noble-amd64-backuppc-20240325-114756-juju-7f2275-prod-proposed-migration-environment-3 --image adt/ubuntu-noble-amd64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-3 --net-id=net_prod-proposed-migration -e TERM=linux -e ''"'"'http_proxy=http://squid.internal:3128'"'"'' -e ''"'"'https_proxy=http://squid.internal:3128'"'"'' -e ''"'"'no_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'"'"'' --mirror=http://ftpmaster.internal/ubuntu/
1026s autopkgtest [12:05:04]: testbed dpkg architecture: amd64
1026s autopkgtest [12:05:04]: testbed apt version: 2.7.12
1026s autopkgtest [12:05:04]: @@@@@@@@@@@@@@@@@@@@ test bed setup
1027s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [117 kB]
1027s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [7608 B]
1027s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [498 kB]
1027s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [56.8 kB]
1027s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [3992 kB]
1027s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main i386 Packages [489 kB]
1027s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 Packages [730 kB]
1027s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 c-n-f Metadata [3508 B]
1027s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted amd64 Packages [35.1 kB]
1027s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/restricted i386 Packages [6700 B]
1027s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/restricted amd64 c-n-f Metadata [116 B]
1027s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/universe amd64 Packages [4423 kB]
1027s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/universe i386 Packages [1298 kB]
1027s Get:14 http://ftpmaster.internal/ubuntu noble-proposed/universe amd64 c-n-f Metadata [9396 B]
1027s Get:15 http://ftpmaster.internal/ubuntu noble-proposed/multiverse amd64 Packages [97.5 kB]
1027s Get:16 http://ftpmaster.internal/ubuntu noble-proposed/multiverse i386 Packages [29.6 kB]
1027s Get:17 http://ftpmaster.internal/ubuntu noble-proposed/multiverse amd64 c-n-f Metadata [196 B]
1030s Fetched 11.8 MB in 1s (8064 kB/s)
1030s Reading package lists...
1032s Reading package lists...
1032s Building dependency tree...
1032s Reading state information...
1032s Calculating upgrade...
1032s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
1032s Reading package lists...
1033s Building dependency tree...
1033s Reading state information...
1033s 0 upgraded, 0 newly installed, 0 to remove and 248 not upgraded.
1033s sh: Attempting to set up Debian/Ubuntu apt sources automatically
1033s sh: Distribution appears to be Ubuntu
1034s Reading package lists...
1034s Building dependency tree...
1034s Reading state information...
1035s eatmydata is already the newest version (131-1).
1035s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
1035s Reading package lists...
1035s Building dependency tree...
1035s Reading state information...
1035s dbus is already the newest version (1.14.10-4ubuntu1).
1035s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
1035s Reading package lists...
1035s Building dependency tree...
1035s Reading state information...
1036s rng-tools-debian is already the newest version (2.4).
1036s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
1036s Reading package lists...
1036s Building dependency tree...
1036s Reading state information...
1036s The following packages will be REMOVED:
1036s   cloud-init* python3-configobj* python3-debconf*
1036s 0 upgraded, 0 newly installed, 3 to remove and 0 not upgraded.
1036s After this operation, 3256 kB disk space will be freed.
1037s (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 ... 71864 files and directories currently installed.)
1037s Removing cloud-init (24.1.2-0ubuntu1) ...
1037s Removing python3-configobj (5.0.8-3) ...
1037s Removing python3-debconf (1.5.86) ...
1037s Processing triggers for man-db (2.12.0-3) ...
1038s (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 ... 71475 files and directories currently installed.)
1038s Purging configuration files for cloud-init (24.1.2-0ubuntu1) ...
1038s dpkg: warning: while removing cloud-init, directory '/etc/cloud/cloud.cfg.d' not empty so not removed
1038s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ...
1038s invoke-rc.d: policy-rc.d denied execution of try-restart.
1039s Reading package lists...
1039s Building dependency tree...
1039s Reading state information...
1039s linux-generic is already the newest version (6.8.0-11.11+1).
1039s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
1039s Hit:1 http://ftpmaster.internal/ubuntu noble InRelease
1039s Hit:2 http://ftpmaster.internal/ubuntu noble-updates InRelease
1039s Hit:3 http://ftpmaster.internal/ubuntu noble-security InRelease
1041s Reading package lists...
1041s Reading package lists...
1041s Building dependency tree...
1041s Reading state information...
1042s Calculating upgrade...
1042s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
1042s Reading package lists...
1042s Building dependency tree...
1042s Reading state information...
1042s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
1043s autopkgtest [12:05:21]: rebooting testbed after setup commands that affected boot
1066s autopkgtest [12:05:44]: testbed running kernel: Linux 6.8.0-11-generic #11-Ubuntu SMP PREEMPT_DYNAMIC Wed Feb 14 00:29:05 UTC 2024
1068s autopkgtest [12:05:46]: @@@@@@@@@@@@@@@@@@@@ apt-source backuppc
1068s Get:1 http://ftpmaster.internal/ubuntu noble/main backuppc 4.4.0-8 (dsc) [2157 B]
1068s Get:2 http://ftpmaster.internal/ubuntu noble/main backuppc 4.4.0-8 (tar) [657 kB]
1068s Get:3 http://ftpmaster.internal/ubuntu noble/main backuppc 4.4.0-8 (diff) [61.0 kB]
1069s gpgv: Signature made Sun Jan 15 11:50:10 2023 UTC
1069s gpgv:                using RSA key 468C89793B429819E9D761266BE663C75A35C975
1069s gpgv: Can't check signature: No public key
1069s dpkg-source: warning: cannot verify inline signature for ./backuppc_4.4.0-8.dsc: no acceptable signature found
1069s autopkgtest [12:05:47]: testing package backuppc version 4.4.0-8
1069s autopkgtest [12:05:47]: build not needed
1069s autopkgtest [12:05:47]: test smb-backup: preparing testbed
1073s Reading package lists...
1074s Building dependency tree...
1074s Reading state information...
1074s Starting pkgProblemResolver with broken count: 0
1074s Starting 2 pkgProblemResolver with broken count: 0
1074s Done
1074s The following additional packages will be installed:
1074s   apache2 apache2-bin apache2-data apache2-utils backuppc backuppc-rsync
1074s   libapr1 libaprutil1 libaprutil1-dbd-sqlite3 libaprutil1-ldap
1074s   libarchive-zip-perl libavahi-client3 libavahi-common-data libavahi-common3
1074s   libbackuppc-xs-perl libcgi-pm-perl libcups2 libfile-listing-perl
1074s   libhtml-parser-perl libhtml-tagset-perl libhttp-date-perl libldb2
1074s   liblua5.4-0 libpython3.12 libsmbclient libtalloc2 libtdb1 libtevent0
1074s   libtime-parsedate-perl libtimedate-perl liburi-perl libwbclient0 postfix
1074s   python3-dnspython python3-ldb python3-markdown python3-samba python3-talloc
1074s   python3-tdb samba samba-common samba-common-bin samba-libs smbclient
1074s   ssl-cert tdb-tools
1074s Suggested packages:
1074s   apache2-doc apache2-suexec-pristine | apache2-suexec-custom www-browser
1074s   certbot | acme-tiny | acmetool | dehydrated | lacme | lecm | lego
1074s   libscgi-perl par2 w3m | www-browser cups-common libdata-dump-perl
1074s   libbusiness-isbn-perl libregexp-ipv6-perl libwww-perl procmail postfix-mysql
1074s   postfix-pgsql postfix-ldap postfix-pcre postfix-lmdb postfix-sqlite
1074s   sasl2-bin | dovecot-common postfix-cdb mail-reader postfix-mta-sts-resolver
1074s   postfix-doc python3-trio python3-aioquic python3-h2 python3-httpx
1074s   python3-httpcore python-markdown-doc bind9 bind9utils ctdb ldb-tools ntp
1074s   | chrony winbind heimdal-clients cifs-utils
1074s Recommended packages:
1074s   libio-dirent-perl rrdtool libcgi-fast-perl libhttp-message-perl python3-gpg
1074s   attr samba-dsdb-modules samba-vfs-modules samba-ad-provision
1074s The following NEW packages will be installed:
1074s   apache2 apache2-bin apache2-data apache2-utils autopkgtest-satdep backuppc
1074s   backuppc-rsync libapr1 libaprutil1 libaprutil1-dbd-sqlite3 libaprutil1-ldap
1074s   libarchive-zip-perl libavahi-client3 libavahi-common-data libavahi-common3
1074s   libbackuppc-xs-perl libcgi-pm-perl libcups2 libfile-listing-perl
1074s   libhtml-parser-perl libhtml-tagset-perl libhttp-date-perl libldb2
1074s   liblua5.4-0 libpython3.12 libsmbclient libtalloc2 libtdb1 libtevent0
1074s   libtime-parsedate-perl libtimedate-perl liburi-perl libwbclient0 postfix
1074s   python3-dnspython python3-ldb python3-markdown python3-samba python3-talloc
1074s   python3-tdb samba samba-common samba-common-bin samba-libs smbclient
1074s   ssl-cert tdb-tools
1074s 0 upgraded, 47 newly installed, 0 to remove and 0 not upgraded.
1074s Need to get 20.4 MB/20.4 MB of archives.
1074s After this operation, 90.4 MB of additional disk space will be used.
1074s Get:1 /tmp/autopkgtest.zAxVns/1-autopkgtest-satdep.deb autopkgtest-satdep amd64 0 [724 B]
1074s Get:2 http://ftpmaster.internal/ubuntu noble/main amd64 libapr1 amd64 1.7.2-3 [107 kB]
1074s Get:3 http://ftpmaster.internal/ubuntu noble/main amd64 libaprutil1 amd64 1.6.3-1ubuntu1 [91.6 kB]
1074s Get:4 http://ftpmaster.internal/ubuntu noble/main amd64 libaprutil1-dbd-sqlite3 amd64 1.6.3-1ubuntu1 [11.3 kB]
1074s Get:5 http://ftpmaster.internal/ubuntu noble/main amd64 libaprutil1-ldap amd64 1.6.3-1ubuntu1 [9172 B]
1074s Get:6 http://ftpmaster.internal/ubuntu noble/main amd64 liblua5.4-0 amd64 5.4.6-3 [166 kB]
1074s Get:7 http://ftpmaster.internal/ubuntu noble/main amd64 apache2-bin amd64 2.4.58-1ubuntu2 [1328 kB]
1074s Get:8 http://ftpmaster.internal/ubuntu noble/main amd64 apache2-data all 2.4.58-1ubuntu2 [163 kB]
1074s Get:9 http://ftpmaster.internal/ubuntu noble/main amd64 apache2-utils amd64 2.4.58-1ubuntu2 [95.7 kB]
1074s Get:10 http://ftpmaster.internal/ubuntu noble/main amd64 apache2 amd64 2.4.58-1ubuntu2 [90.2 kB]
1074s Get:11 http://ftpmaster.internal/ubuntu noble/main amd64 backuppc-rsync amd64 3.1.3.0-3build1 [257 kB]
1074s Get:12 http://ftpmaster.internal/ubuntu noble/main amd64 ssl-cert all 1.1.2ubuntu1 [17.8 kB]
1074s Get:13 http://ftpmaster.internal/ubuntu noble/main amd64 postfix amd64 3.8.5-1 [1252 kB]
1074s Get:14 http://ftpmaster.internal/ubuntu noble/main amd64 libarchive-zip-perl all 1.68-1 [90.2 kB]
1074s Get:15 http://ftpmaster.internal/ubuntu noble/main amd64 libbackuppc-xs-perl amd64 0.62-2build3 [65.2 kB]
1074s Get:16 http://ftpmaster.internal/ubuntu noble/main amd64 libhtml-tagset-perl all 3.20-6 [11.3 kB]
1074s Get:17 http://ftpmaster.internal/ubuntu noble/main amd64 liburi-perl all 5.27-1 [88.0 kB]
1074s Get:18 http://ftpmaster.internal/ubuntu noble/main amd64 libhtml-parser-perl amd64 3.81-1build1 [85.7 kB]
1074s Get:19 http://ftpmaster.internal/ubuntu noble/main amd64 libcgi-pm-perl all 4.62-1 [185 kB]
1074s Get:20 http://ftpmaster.internal/ubuntu noble/main amd64 libtimedate-perl all 2.3300-2 [34.0 kB]
1074s Get:21 http://ftpmaster.internal/ubuntu noble/main amd64 libhttp-date-perl all 6.06-1 [10.2 kB]
1074s Get:22 http://ftpmaster.internal/ubuntu noble/main amd64 libfile-listing-perl all 6.16-1 [11.3 kB]
1074s Get:23 http://ftpmaster.internal/ubuntu noble/main amd64 libtime-parsedate-perl all 2015.103-4 [28.6 kB]
1074s Get:24 http://ftpmaster.internal/ubuntu noble/main amd64 backuppc amd64 4.4.0-8 [542 kB]
1074s Get:25 http://ftpmaster.internal/ubuntu noble/main amd64 python3-dnspython all 2.6.1-1ubuntu1 [163 kB]
1074s Get:26 http://ftpmaster.internal/ubuntu noble/main amd64 libtalloc2 amd64 2.4.2-1 [27.2 kB]
1074s Get:27 http://ftpmaster.internal/ubuntu noble/main amd64 libtdb1 amd64 1.4.10-1 [46.7 kB]
1074s Get:28 http://ftpmaster.internal/ubuntu noble/main amd64 libtevent0 amd64 0.16.1-1 [42.1 kB]
1074s Get:29 http://ftpmaster.internal/ubuntu noble/main amd64 libldb2 amd64 2:2.8.0+samba4.19.5+dfsg-1ubuntu1 [186 kB]
1074s Get:30 http://ftpmaster.internal/ubuntu noble/main amd64 libpython3.12 amd64 3.12.2-1 [2359 kB]
1074s Get:31 http://ftpmaster.internal/ubuntu noble/main amd64 python3-ldb amd64 2:2.8.0+samba4.19.5+dfsg-1ubuntu1 [41.8 kB]
1074s Get:32 http://ftpmaster.internal/ubuntu noble/main amd64 python3-tdb amd64 1.4.10-1 [15.3 kB]
1074s Get:33 http://ftpmaster.internal/ubuntu noble/main amd64 python3-markdown all 3.5.2-1 [72.0 kB]
1074s Get:34 http://ftpmaster.internal/ubuntu noble/main amd64 libavahi-common-data amd64 0.8-13ubuntu2 [29.5 kB]
1074s Get:35 http://ftpmaster.internal/ubuntu noble/main amd64 libavahi-common3 amd64 0.8-13ubuntu2 [23.5 kB]
1074s Get:36 http://ftpmaster.internal/ubuntu noble/main amd64 libavahi-client3 amd64 0.8-13ubuntu2 [27.4 kB]
1074s Get:37 http://ftpmaster.internal/ubuntu noble/main amd64 libwbclient0 amd64 2:4.19.5+dfsg-1ubuntu1 [69.8 kB]
1074s Get:38 http://ftpmaster.internal/ubuntu noble/main amd64 samba-libs amd64 2:4.19.5+dfsg-1ubuntu1 [6017 kB]
1074s Get:39 http://ftpmaster.internal/ubuntu noble/main amd64 python3-talloc amd64 2.4.2-1 [12.9 kB]
1074s Get:40 http://ftpmaster.internal/ubuntu noble/main amd64 python3-samba amd64 2:4.19.5+dfsg-1ubuntu1 [3339 kB]
1075s Get:41 http://ftpmaster.internal/ubuntu noble/main amd64 samba-common all 2:4.19.5+dfsg-1ubuntu1 [63.4 kB]
1075s Get:42 http://ftpmaster.internal/ubuntu noble/main amd64 libcups2 amd64 2.4.6-0ubuntu3 [269 kB]
1075s Get:43 http://ftpmaster.internal/ubuntu noble/main amd64 samba-common-bin amd64 2:4.19.5+dfsg-1ubuntu1 [1279 kB]
1075s Get:44 http://ftpmaster.internal/ubuntu noble/main amd64 tdb-tools amd64 1.4.10-1 [25.8 kB]
1075s Get:45 http://ftpmaster.internal/ubuntu noble/main amd64 samba amd64 2:4.19.5+dfsg-1ubuntu1 [1003 kB]
1075s Get:46 http://ftpmaster.internal/ubuntu noble/main amd64 libsmbclient amd64 2:4.19.5+dfsg-1ubuntu1 [62.6 kB]
1075s Get:47 http://ftpmaster.internal/ubuntu noble/main amd64 smbclient amd64 2:4.19.5+dfsg-1ubuntu1 [470 kB]
1076s Preconfiguring packages ...
1076s Fetched 20.4 MB in 0s (63.6 MB/s)
1076s Selecting previously unselected package libapr1:amd64.
1076s (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 ... 71420 files and directories currently installed.)
1076s Preparing to unpack .../00-libapr1_1.7.2-3_amd64.deb ...
1076s Unpacking libapr1:amd64 (1.7.2-3) ...
1076s Selecting previously unselected package libaprutil1:amd64.
1076s Preparing to unpack .../01-libaprutil1_1.6.3-1ubuntu1_amd64.deb ...
1076s Unpacking libaprutil1:amd64 (1.6.3-1ubuntu1) ...
1076s Selecting previously unselected package libaprutil1-dbd-sqlite3:amd64.
1076s Preparing to unpack .../02-libaprutil1-dbd-sqlite3_1.6.3-1ubuntu1_amd64.deb ...
1076s Unpacking libaprutil1-dbd-sqlite3:amd64 (1.6.3-1ubuntu1) ...
1076s Selecting previously unselected package libaprutil1-ldap:amd64.
1076s Preparing to unpack .../03-libaprutil1-ldap_1.6.3-1ubuntu1_amd64.deb ...
1076s Unpacking libaprutil1-ldap:amd64 (1.6.3-1ubuntu1) ...
1076s Selecting previously unselected package liblua5.4-0:amd64.
1076s Preparing to unpack .../04-liblua5.4-0_5.4.6-3_amd64.deb ...
1076s Unpacking liblua5.4-0:amd64 (5.4.6-3) ...
1076s Selecting previously unselected package apache2-bin.
1076s Preparing to unpack .../05-apache2-bin_2.4.58-1ubuntu2_amd64.deb ...
1076s Unpacking apache2-bin (2.4.58-1ubuntu2) ...
1076s Selecting previously unselected package apache2-data.
1076s Preparing to unpack .../06-apache2-data_2.4.58-1ubuntu2_all.deb ...
1076s Unpacking apache2-data (2.4.58-1ubuntu2) ...
1076s Selecting previously unselected package apache2-utils.
1076s Preparing to unpack .../07-apache2-utils_2.4.58-1ubuntu2_amd64.deb ...
1076s Unpacking apache2-utils (2.4.58-1ubuntu2) ...
1076s Selecting previously unselected package apache2.
1076s Preparing to unpack .../08-apache2_2.4.58-1ubuntu2_amd64.deb ...
1076s Unpacking apache2 (2.4.58-1ubuntu2) ...
1076s Selecting previously unselected package backuppc-rsync.
1076s Preparing to unpack .../09-backuppc-rsync_3.1.3.0-3build1_amd64.deb ...
1076s Unpacking backuppc-rsync (3.1.3.0-3build1) ...
1076s Selecting previously unselected package ssl-cert.
1076s Preparing to unpack .../10-ssl-cert_1.1.2ubuntu1_all.deb ...
1076s Unpacking ssl-cert (1.1.2ubuntu1) ...
1076s Selecting previously unselected package postfix.
1076s Preparing to unpack .../11-postfix_3.8.5-1_amd64.deb ...
1076s Unpacking postfix (3.8.5-1) ...
1076s Selecting previously unselected package libarchive-zip-perl.
1076s Preparing to unpack .../12-libarchive-zip-perl_1.68-1_all.deb ...
1076s Unpacking libarchive-zip-perl (1.68-1) ...
1076s Selecting previously unselected package libbackuppc-xs-perl:amd64.
1076s Preparing to unpack .../13-libbackuppc-xs-perl_0.62-2build3_amd64.deb ...
1076s Unpacking libbackuppc-xs-perl:amd64 (0.62-2build3) ...
1076s Selecting previously unselected package libhtml-tagset-perl.
1076s Preparing to unpack .../14-libhtml-tagset-perl_3.20-6_all.deb ...
1076s Unpacking libhtml-tagset-perl (3.20-6) ...
1076s Selecting previously unselected package liburi-perl.
1076s Preparing to unpack .../15-liburi-perl_5.27-1_all.deb ...
1076s Unpacking liburi-perl (5.27-1) ...
1076s Selecting previously unselected package libhtml-parser-perl:amd64.
1076s Preparing to unpack .../16-libhtml-parser-perl_3.81-1build1_amd64.deb ...
1076s Unpacking libhtml-parser-perl:amd64 (3.81-1build1) ...
1076s Selecting previously unselected package libcgi-pm-perl.
1076s Preparing to unpack .../17-libcgi-pm-perl_4.62-1_all.deb ...
1076s Unpacking libcgi-pm-perl (4.62-1) ...
1076s Selecting previously unselected package libtimedate-perl.
1076s Preparing to unpack .../18-libtimedate-perl_2.3300-2_all.deb ...
1076s Unpacking libtimedate-perl (2.3300-2) ...
1076s Selecting previously unselected package libhttp-date-perl.
1076s Preparing to unpack .../19-libhttp-date-perl_6.06-1_all.deb ...
1076s Unpacking libhttp-date-perl (6.06-1) ...
1076s Selecting previously unselected package libfile-listing-perl.
1076s Preparing to unpack .../20-libfile-listing-perl_6.16-1_all.deb ...
1076s Unpacking libfile-listing-perl (6.16-1) ...
1076s Selecting previously unselected package libtime-parsedate-perl.
1076s Preparing to unpack .../21-libtime-parsedate-perl_2015.103-4_all.deb ...
1076s Unpacking libtime-parsedate-perl (2015.103-4) ...
1076s Selecting previously unselected package backuppc.
1076s Preparing to unpack .../22-backuppc_4.4.0-8_amd64.deb ...
1076s Unpacking backuppc (4.4.0-8) ...
1076s Selecting previously unselected package python3-dnspython.
1076s Preparing to unpack .../23-python3-dnspython_2.6.1-1ubuntu1_all.deb ...
1076s Unpacking python3-dnspython (2.6.1-1ubuntu1) ...
1076s Selecting previously unselected package libtalloc2:amd64.
1076s Preparing to unpack .../24-libtalloc2_2.4.2-1_amd64.deb ...
1076s Unpacking libtalloc2:amd64 (2.4.2-1) ...
1076s Selecting previously unselected package libtdb1:amd64.
1076s Preparing to unpack .../25-libtdb1_1.4.10-1_amd64.deb ...
1076s Unpacking libtdb1:amd64 (1.4.10-1) ...
1076s Selecting previously unselected package libtevent0:amd64.
1076s Preparing to unpack .../26-libtevent0_0.16.1-1_amd64.deb ...
1076s Unpacking libtevent0:amd64 (0.16.1-1) ...
1076s Selecting previously unselected package libldb2:amd64.
1076s Preparing to unpack .../27-libldb2_2%3a2.8.0+samba4.19.5+dfsg-1ubuntu1_amd64.deb ...
1076s Unpacking libldb2:amd64 (2:2.8.0+samba4.19.5+dfsg-1ubuntu1) ...
1076s Selecting previously unselected package libpython3.12:amd64.
1076s Preparing to unpack .../28-libpython3.12_3.12.2-1_amd64.deb ...
1076s Unpacking libpython3.12:amd64 (3.12.2-1) ...
1076s Selecting previously unselected package python3-ldb.
1076s Preparing to unpack .../29-python3-ldb_2%3a2.8.0+samba4.19.5+dfsg-1ubuntu1_amd64.deb ...
1076s Unpacking python3-ldb (2:2.8.0+samba4.19.5+dfsg-1ubuntu1) ...
1076s Selecting previously unselected package python3-tdb.
1076s Preparing to unpack .../30-python3-tdb_1.4.10-1_amd64.deb ...
1076s Unpacking python3-tdb (1.4.10-1) ...
1076s Selecting previously unselected package python3-markdown.
1076s Preparing to unpack .../31-python3-markdown_3.5.2-1_all.deb ...
1076s Unpacking python3-markdown (3.5.2-1) ...
1076s Selecting previously unselected package libavahi-common-data:amd64.
1076s Preparing to unpack .../32-libavahi-common-data_0.8-13ubuntu2_amd64.deb ...
1076s Unpacking libavahi-common-data:amd64 (0.8-13ubuntu2) ...
1076s Selecting previously unselected package libavahi-common3:amd64.
1076s Preparing to unpack .../33-libavahi-common3_0.8-13ubuntu2_amd64.deb ...
1076s Unpacking libavahi-common3:amd64 (0.8-13ubuntu2) ...
1076s Selecting previously unselected package libavahi-client3:amd64.
1076s Preparing to unpack .../34-libavahi-client3_0.8-13ubuntu2_amd64.deb ...
1076s Unpacking libavahi-client3:amd64 (0.8-13ubuntu2) ...
1076s Selecting previously unselected package libwbclient0:amd64.
1076s Preparing to unpack .../35-libwbclient0_2%3a4.19.5+dfsg-1ubuntu1_amd64.deb ...
1076s Unpacking libwbclient0:amd64 (2:4.19.5+dfsg-1ubuntu1) ...
1076s Selecting previously unselected package samba-libs:amd64.
1076s Preparing to unpack .../36-samba-libs_2%3a4.19.5+dfsg-1ubuntu1_amd64.deb ...
1077s Unpacking samba-libs:amd64 (2:4.19.5+dfsg-1ubuntu1) ...
1077s Selecting previously unselected package python3-talloc:amd64.
1077s Preparing to unpack .../37-python3-talloc_2.4.2-1_amd64.deb ...
1077s Unpacking python3-talloc:amd64 (2.4.2-1) ...
1077s Selecting previously unselected package python3-samba.
1077s Preparing to unpack .../38-python3-samba_2%3a4.19.5+dfsg-1ubuntu1_amd64.deb ...
1077s Unpacking python3-samba (2:4.19.5+dfsg-1ubuntu1) ...
1077s Selecting previously unselected package samba-common.
1077s Preparing to unpack .../39-samba-common_2%3a4.19.5+dfsg-1ubuntu1_all.deb ...
1077s Unpacking samba-common (2:4.19.5+dfsg-1ubuntu1) ...
1077s Selecting previously unselected package libcups2:amd64.
1077s Preparing to unpack .../40-libcups2_2.4.6-0ubuntu3_amd64.deb ...
1077s Unpacking libcups2:amd64 (2.4.6-0ubuntu3) ...
1077s Selecting previously unselected package samba-common-bin.
1077s Preparing to unpack .../41-samba-common-bin_2%3a4.19.5+dfsg-1ubuntu1_amd64.deb ...
1077s Unpacking samba-common-bin (2:4.19.5+dfsg-1ubuntu1) ...
1077s Selecting previously unselected package tdb-tools.
1077s Preparing to unpack .../42-tdb-tools_1.4.10-1_amd64.deb ...
1077s Unpacking tdb-tools (1.4.10-1) ...
1077s Selecting previously unselected package samba.
1077s Preparing to unpack .../43-samba_2%3a4.19.5+dfsg-1ubuntu1_amd64.deb ...
1077s Unpacking samba (2:4.19.5+dfsg-1ubuntu1) ...
1077s Selecting previously unselected package libsmbclient:amd64.
1077s Preparing to unpack .../44-libsmbclient_2%3a4.19.5+dfsg-1ubuntu1_amd64.deb ...
1077s Unpacking libsmbclient:amd64 (2:4.19.5+dfsg-1ubuntu1) ...
1077s Selecting previously unselected package smbclient.
1077s Preparing to unpack .../45-smbclient_2%3a4.19.5+dfsg-1ubuntu1_amd64.deb ...
1077s Unpacking smbclient (2:4.19.5+dfsg-1ubuntu1) ...
1077s Selecting previously unselected package autopkgtest-satdep.
1077s Preparing to unpack .../46-1-autopkgtest-satdep.deb ...
1077s Unpacking autopkgtest-satdep (0) ...
1077s Setting up libarchive-zip-perl (1.68-1) ...
1077s Setting up libtdb1:amd64 (1.4.10-1) ...
1077s Setting up libhtml-tagset-perl (3.20-6) ...
1077s Setting up libapr1:amd64 (1.7.2-3) ...
1077s Setting up samba-common (2:4.19.5+dfsg-1ubuntu1) ...
1077s 
1077s Creating config file /etc/samba/smb.conf with new version
1077s Setting up libwbclient0:amd64 (2:4.19.5+dfsg-1ubuntu1) ...
1077s Setting up libtalloc2:amd64 (2.4.2-1) ...
1077s Setting up backuppc-rsync (3.1.3.0-3build1) ...
1077s Setting up python3-tdb (1.4.10-1) ...
1077s Setting up libtevent0:amd64 (0.16.1-1) ...
1077s Setting up ssl-cert (1.1.2ubuntu1) ...
1078s Created symlink /etc/systemd/system/multi-user.target.wants/ssl-cert.service → /usr/lib/systemd/system/ssl-cert.service.

1079s Setting up libavahi-common-data:amd64 (0.8-13ubuntu2) ...
1079s Setting up tdb-tools (1.4.10-1) ...
1079s update-alternatives: using /usr/bin/tdbbackup.tdbtools to provide /usr/bin/tdbbackup (tdbbackup) in auto mode
1079s Setting up python3-markdown (3.5.2-1) ...
1079s Setting up libtimedate-perl (2.3300-2) ...
1079s Setting up postfix (3.8.5-1) ...
1080s info: Selecting GID from range 100 to 999 ...
1080s info: Adding group `postfix' (GID 112) ...
1080s info: Selecting UID from range 100 to 999 ...
1080s 
1080s info: Adding system user `postfix' (UID 108) ...
1080s info: Adding new user `postfix' (UID 108) with group `postfix' ...
1080s info: Not creating home directory `/var/spool/postfix'.
1080s Creating /etc/postfix/dynamicmaps.cf
1080s info: Selecting GID from range 100 to 999 ...
1080s info: Adding group `postdrop' (GID 113) ...
1080s setting myhostname: adt-noble-amd64-backuppc-20240325-114756-juju-7f2275-prod-propo.openstack.prodstack5.lan
1080s setting alias maps
1080s setting alias database
1080s changing /etc/mailname to adt-noble-amd64-backuppc-20240325-114756-juju-7f2275-prod-propo.openstack.prodstack5.lan
1080s setting myorigin
1080s setting destinations: $myhostname, adt-noble-amd64-backuppc-20240325-114756-juju-7f2275-prod-propo.openstack.prodstack5.lan, localhost.openstack.prodstack5.lan, , localhost
1080s setting relayhost: 
1080s setting mynetworks: 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128
1080s setting mailbox_size_limit: 0
1080s setting recipient_delimiter: +
1082s setting inet_interfaces: all
1084s setting inet_protocols: all
1084s /etc/aliases does not exist, creating it.
1084s WARNING: /etc/aliases exists, but does not have a root alias.
1084s 
1084s Postfix (main.cf) is now set up with a default configuration.  If you need to 
1084s make changes, edit /etc/postfix/main.cf (and others) as needed.  To view 
1084s Postfix configuration values, see postconf(1).
1084s 
1084s After modifying main.cf, be sure to run 'systemctl reload postfix'.
1084s 
1086s Running newaliases
1087s Created symlink /etc/systemd/system/multi-user.target.wants/postfix.service → /usr/lib/systemd/system/postfix.service.

1088s Setting up libtime-parsedate-perl (2015.103-4) ...
1088s Setting up python3-dnspython (2.6.1-1ubuntu1) ...
1088s Setting up liblua5.4-0:amd64 (5.4.6-3) ...
1088s Setting up apache2-data (2.4.58-1ubuntu2) ...
1088s Setting up libldb2:amd64 (2:2.8.0+samba4.19.5+dfsg-1ubuntu1) ...
1088s Setting up libbackuppc-xs-perl:amd64 (0.62-2build3) ...
1088s Setting up libpython3.12:amd64 (3.12.2-1) ...
1088s Setting up liburi-perl (5.27-1) ...
1088s Setting up libaprutil1:amd64 (1.6.3-1ubuntu1) ...
1088s Setting up libhttp-date-perl (6.06-1) ...
1088s Setting up libfile-listing-perl (6.16-1) ...
1088s Setting up python3-talloc:amd64 (2.4.2-1) ...
1088s Setting up libavahi-common3:amd64 (0.8-13ubuntu2) ...
1088s Setting up libaprutil1-ldap:amd64 (1.6.3-1ubuntu1) ...
1088s Setting up libaprutil1-dbd-sqlite3:amd64 (1.6.3-1ubuntu1) ...
1088s Setting up python3-ldb (2:2.8.0+samba4.19.5+dfsg-1ubuntu1) ...
1088s Setting up libhtml-parser-perl:amd64 (3.81-1build1) ...
1088s Setting up libavahi-client3:amd64 (0.8-13ubuntu2) ...
1088s Setting up apache2-utils (2.4.58-1ubuntu2) ...
1088s Setting up libcgi-pm-perl (4.62-1) ...
1088s Setting up samba-libs:amd64 (2:4.19.5+dfsg-1ubuntu1) ...
1088s Setting up apache2-bin (2.4.58-1ubuntu2) ...
1088s Setting up libsmbclient:amd64 (2:4.19.5+dfsg-1ubuntu1) ...
1088s Setting up smbclient (2:4.19.5+dfsg-1ubuntu1) ...
1088s Setting up libcups2:amd64 (2.4.6-0ubuntu3) ...
1088s Setting up python3-samba (2:4.19.5+dfsg-1ubuntu1) ...
1089s /usr/lib/python3/dist-packages/samba/tests/dns_forwarder_helpers/server.py:80: SyntaxWarning: invalid escape sequence '\s'
1089s   m = re.match(b'^timeout\s+([\d.]+)$', data.strip())
1089s /usr/lib/python3/dist-packages/samba/tests/samba_tool/join_member.py:43: SyntaxWarning: invalid escape sequence '\s'
1089s   existing_records = re.findall('A:\s+(\d+\.\d+\.\d+\.\d+)\s', out)
1089s /usr/lib/python3/dist-packages/samba/tests/samba_tool/ntacl.py:93: SyntaxWarning: invalid escape sequence '\s'
1089s   self.assertNotRegex(err, '^\s*File [^,]+, line \d+, in',
1089s /usr/lib/python3/dist-packages/samba/tests/samba_tool/user_virtualCryptSHA.py:42: SyntaxWarning: invalid escape sequence '\s'
1089s   p = re.compile("^" + name + ":\s+(\S+)")
1089s /usr/lib/python3/dist-packages/samba/tests/samba_tool/user_virtualCryptSHA_base.py:42: SyntaxWarning: invalid escape sequence '\s'
1089s   p = re.compile("^" + name + ":\s+(\S+)")
1089s Setting up apache2 (2.4.58-1ubuntu2) ...
1089s Enabling module mpm_event.
1089s Enabling module authz_core.
1089s Enabling module authz_host.
1089s Enabling module authn_core.
1089s Enabling module auth_basic.
1089s Enabling module access_compat.
1089s Enabling module authn_file.
1089s Enabling module authz_user.
1089s Enabling module alias.
1089s Enabling module dir.
1089s Enabling module autoindex.
1089s Enabling module env.
1090s Enabling module mime.
1090s Enabling module negotiation.
1090s Enabling module setenvif.
1090s Enabling module filter.
1090s Enabling module deflate.
1090s Enabling module status.
1090s Enabling module reqtimeout.
1090s Enabling conf charset.
1090s Enabling conf localized-error-pages.
1090s Enabling conf other-vhosts-access-log.
1090s Enabling conf security.
1090s Enabling conf serve-cgi-bin.
1090s Enabling site 000-default.
1091s Created symlink /etc/systemd/system/multi-user.target.wants/apache2.service → /usr/lib/systemd/system/apache2.service.

1091s Created symlink /etc/systemd/system/multi-user.target.wants/apache-htcacheclean.service → /usr/lib/systemd/system/apache-htcacheclean.service.

1092s Setting up backuppc (4.4.0-8) ...
1092s 
1092s apache2_invoke: Enable configuration backuppc.conf
1093s warn: The home directory `/var/lib/backuppc' already exists.  Not touching this directory.
1093s warn: Warning: The home directory `/var/lib/backuppc' does not belong to the user you are currently creating.
1093s Adding password for user backuppc
1093s Considering dependency authn_core for auth_basic:
1093s Module authn_core already enabled
1093s Module auth_basic already enabled
1093s Considering dependency authz_core for authz_groupfile:
1093s Module authz_core already enabled
1093s Enabling module authz_groupfile.
1093s To activate the new configuration, you need to run:
1093s   systemctl restart apache2
1093s Module authn_file already enabled
1093s Considering dependency authz_core for authz_user:
1093s Module authz_core already enabled
1093s Module authz_user already enabled
1093s Your MPM seems to be threaded. Selecting cgid instead of cgi.
1093s Enabling module cgid.
1093s To activate the new configuration, you need to run:
1093s   systemctl restart apache2
1093s 
1093s Creating config file /etc/backuppc/config.pl with new version
1093s Created symlink /etc/systemd/system/multi-user.target.wants/backuppc.service → /usr/lib/systemd/system/backuppc.service.

1094s Setting up samba-common-bin (2:4.19.5+dfsg-1ubuntu1) ...
1094s Setting up samba (2:4.19.5+dfsg-1ubuntu1) ...
1095s Created symlink /etc/systemd/system/smb.service → /usr/lib/systemd/system/smbd.service.

1095s Created symlink /etc/systemd/system/multi-user.target.wants/smbd.service → /usr/lib/systemd/system/smbd.service.

1095s Created symlink /etc/systemd/system/nmb.service → /usr/lib/systemd/system/nmbd.service.

1095s Created symlink /etc/systemd/system/multi-user.target.wants/nmbd.service → /usr/lib/systemd/system/nmbd.service.

1096s Created symlink /etc/systemd/system/samba.service → /usr/lib/systemd/system/samba-ad-dc.service.

1096s Created symlink /etc/systemd/system/multi-user.target.wants/samba-ad-dc.service → /usr/lib/systemd/system/samba-ad-dc.service.

1096s Setting up autopkgtest-satdep (0) ...
1096s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ...
1096s Processing triggers for ufw (0.36.2-5) ...
1096s Processing triggers for man-db (2.12.0-3) ...
1098s Processing triggers for libc-bin (2.39-0ubuntu6) ...
1100s (Reading database ... 74051 files and directories currently installed.)
1100s Removing autopkgtest-satdep (0) ...
1100s autopkgtest [12:06:18]: test smb-backup: [-----------------------
1100s Populating share path
1101s Adding samba share
1101s Adding [public] share
1101s Configuring backuppc
1101s Performing a full backup
1101s Backup type: type = full, needs_full = 1, needs_incr = 1, lastFullTime = 0, opts{f} = 1, opts{i} = , opts{F} = 
1101s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost
1101s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost
1101s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.013
1101s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.0.z created 2024-03-25 12:06:19 
1101s Backup prep: type = full, case = 1, inPlace = 1, doDuplicate = 0, newBkupNum = 0, newBkupIdx = 0, lastBkupNum = , lastBkupIdx =  (FillCycle = 0, noFillCnt = )
1101s __bpc_progress_state__ backup share "public"
1101s Running: /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -Tc -
1101s full backup started for share public
1101s started full dump, share=public
1101s Xfer PIDs are now 3847,3846
1101s xferPids 3847,3846
1101s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -Tc -
1101s tarmode is now full, system, hidden, noreset, noverbose
1101s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 1
1101s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1)
1101s __bpc_progress_fileCnt__ 0
1101s   new      644       0/0      480434 tmp.yp98F6
1101s   new      644       0/0      480434 tmp.pNyK2B
1101s   new      644       0/0      480434 tmp.Wxla3X
1101s   new      644       0/0      480434 tmp.PJ7GHC
1101s   new      644       0/0      480434 tmp.4FonXZ
1101s   new      644       0/0      480434 tmp.vFxkvu
1101s   new      644       0/0      480434 tmp.u5xJz0
1101s   new      644       0/0      480434 tmp.c2ivaH
1101s   new      644       0/0      480434 tmp.ethMd3
1101s tar: dumped 10 files and 0 directories
1101s Total bytes written: 4804340 (32.4 MiB/s)
1101s readOutput: sysread returns 0 and got EOF (exit ok = 1, )
1101s   new      644       0/0      480434 tmp.Anty6B
1101s __bpc_progress_fileCnt__ 10
1101s tarExtract: Done: 0 errors, 0 filesExist, 0 sizeExist, 0 sizeExistComp, 10 filesTotal, 4804340 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377820 sizeNewComp, 13 inodeLast
1101s Xfer PIDs are now 
1101s xferPids 
1101s full backup 0 complete, 10 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other)
1101s BackupExpire: cntFull = 1, cntIncr = 0, firstFull = 0, firstIncr = , oldestIncr = 0, oldestFull = 0
1101s __bpc_progress_state__ fsck
1101s Running BackupPC_refCountUpdate -h localhost on localhost
1101s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost
1101s Xfer PIDs are now 3853
1101s xferPids 3853
1101s BackupPC_refCountUpdate: doing fsck on localhost #0 (full) since $ConfRefCntFsck == 1
1101s __bpc_progress_state__ refCnt #0
1101s __bpc_progress_state__ cntUpdate #0
1101s __bpc_progress_state__ rename #0
1101s __bpc_progress_state__ sumUpdate
1101s __bpc_progress_fileCnt__ 0/128
1101s __bpc_progress_fileCnt__ 8/128
1101s __bpc_progress_fileCnt__ 16/128
1101s __bpc_progress_fileCnt__ 24/128
1101s __bpc_progress_fileCnt__ 32/128
1101s __bpc_progress_fileCnt__ 40/128
1101s __bpc_progress_fileCnt__ 48/128
1101s __bpc_progress_fileCnt__ 56/128
1101s __bpc_progress_fileCnt__ 64/128
1101s __bpc_progress_fileCnt__ 72/128
1101s __bpc_progress_fileCnt__ 80/128
1101s __bpc_progress_fileCnt__ 88/128
1101s __bpc_progress_fileCnt__ 96/128
1101s __bpc_progress_fileCnt__ 104/128
1101s __bpc_progress_fileCnt__ 112/128
1101s __bpc_progress_fileCnt__ 120/128
1101s __bpc_progress_state__ rename total
1101s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs)
1101s Xfer PIDs are now 
1101s xferPids 
1101s Finished BackupPC_refCountUpdate (running time: 0 sec)
1101s Xfer PIDs are now 
1101s xferPids 
1101s full backup complete
1101s OK: Full backup succeeded
1101s Changing share content and performing an incremental backup
1101s Backup type: type = incr, needs_full = , needs_incr = , lastFullTime = 1711368379, opts{f} = , opts{i} = 1, opts{F} = 
1101s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost
1101s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost
1101s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.009
1101s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.1.z created 2024-03-25 12:06:19 
1101s Backup prep: type = incr, case = 3, inPlace = 1, doDuplicate = 1, newBkupNum = 1, newBkupIdx = 1, lastBkupNum = , lastBkupIdx =  (FillCycle = 0, noFillCnt = )
1101s Executing /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost
1101s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost
1101s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDuplicate line 89.
1101s 	(Did you mean "$Host\'s" instead?)
1101s Xfer PIDs are now 3923
1101s xferPids 3923
1101s __bpc_progress_state__ copy #0 -> #1
1101s Copying backup #0 to #1
1101s __bpc_progress_fileCnt__ 3 dirs
1101s Xfer PIDs are now 3923,3926
1101s xferPids 3923,3926
1101s __bpc_progress_state__ sumUpdate
1101s __bpc_progress_fileCnt__ 0/128
1101s __bpc_progress_fileCnt__ 8/128
1101s __bpc_progress_fileCnt__ 16/128
1101s __bpc_progress_fileCnt__ 24/128
1101s __bpc_progress_fileCnt__ 32/128
1101s __bpc_progress_fileCnt__ 40/128
1101s __bpc_progress_fileCnt__ 48/128
1101s __bpc_progress_fileCnt__ 56/128
1101s __bpc_progress_fileCnt__ 64/128
1101s __bpc_progress_fileCnt__ 72/128
1101s __bpc_progress_fileCnt__ 80/128
1101s __bpc_progress_fileCnt__ 88/128
1101s __bpc_progress_fileCnt__ 96/128
1101s __bpc_progress_fileCnt__ 104/128
1101s __bpc_progress_fileCnt__ 112/128
1101s __bpc_progress_fileCnt__ 120/128
1101s __bpc_progress_state__ rename total
1101s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs)
1101s Xfer PIDs are now 3923
1101s xferPids 3923
1101s BackupPC_backupDuplicate: got 0 errors and 0 file open errors
1101s Finished BackupPC_backupDuplicate (running time: 0 sec)
1101s __bpc_progress_state__ backup share "public"
1101s Running: /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 -
1101s incr backup started back to 2024-03-25 11:06:19  (backup #0) for share public
1101s started incr dump, share=public
1101s Xfer PIDs are now 3930,3929
1101s xferPids 3930,3929
1101s 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 -
1101s tar:1298 Getting files newer than Mon Mar 25 11:06:19 2024
1101s 
1101s tarmode is now full, system, hidden, noreset, noverbose
1101s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 
1101s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1)
1101s __bpc_progress_fileCnt__ 0
1101s   same     644       0/0      480434 tmp.yp98F6
1101s   same     644       0/0      480434 tmp.pNyK2B
1101s   new      644       0/0      480434 tmp.3O2vbl
1101s   new      644       0/0      480434 tmp.QKAubl
1101s   same     644       0/0      480434 tmp.Wxla3X
1102s   new      644       0/0      480434 tmp.jC7eRy
1102s   new      644       0/0      480434 tmp.aSW2ME
1102s   same     644       0/0      480434 tmp.PJ7GHC
1102s   same     644       0/0      480434 tmp.4FonXZ
1102s   same     644       0/0      480434 tmp.vFxkvu
1102s   same     644       0/0      480434 tmp.u5xJz0
1102s   new      644       0/0      480434 tmp.jAOnew
1102s   same     644       0/0      480434 tmp.c2ivaH
1102s   new      644       0/0      480434 tmp.wx38rc
1102s   new      644       0/0      480434 tmp.GpLALl
1102s   same     644       0/0      480434 tmp.ethMd3
1102s   new      644       0/0      480434 tmp.gNwlMh
1102s   new      644       0/0      480434 tmp.02sALi
1102s   new      644       0/0      480434 tmp.OYDFko
1102s tar: dumped 20 files and 0 directories
1102s Total bytes written: 9608680 (49.2 MiB/s)
1102s   same     644       0/0      480434 tmp.Anty6B
1102s readOutput: sysread returns 0 and got EOF (exit ok = 1, )
1102s __bpc_progress_fileCnt__ 20
1102s tarExtract: Done: 0 errors, 10 filesExist, 4804340 sizeExist, 1377820 sizeExistComp, 20 filesTotal, 9608680 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377828 sizeNewComp, 24 inodeLast
1102s Xfer PIDs are now 
1102s xferPids 
1102s incr backup 1 complete, 20 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other)
1102s BackupExpire: cntFull = 2, cntIncr = 0, firstFull = 0, firstIncr = , oldestIncr = 0, oldestFull = 1.15740740740741e-05
1102s __bpc_progress_state__ fsck
1102s Running BackupPC_refCountUpdate -h localhost on localhost
1102s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost
1102s Xfer PIDs are now 3936
1102s xferPids 3936
1102s __bpc_progress_state__ cntUpdate #1
1102s __bpc_progress_state__ rename #1
1102s __bpc_progress_state__ sumUpdate
1102s __bpc_progress_fileCnt__ 0/128
1102s __bpc_progress_fileCnt__ 8/128
1102s __bpc_progress_fileCnt__ 16/128
1102s __bpc_progress_fileCnt__ 24/128
1102s __bpc_progress_fileCnt__ 32/128
1102s __bpc_progress_fileCnt__ 40/128
1102s __bpc_progress_fileCnt__ 48/128
1102s __bpc_progress_fileCnt__ 56/128
1102s __bpc_progress_fileCnt__ 64/128
1102s __bpc_progress_fileCnt__ 72/128
1102s __bpc_progress_fileCnt__ 80/128
1102s __bpc_progress_fileCnt__ 88/128
1102s __bpc_progress_fileCnt__ 96/128
1102s __bpc_progress_fileCnt__ 104/128
1102s __bpc_progress_fileCnt__ 112/128
1102s __bpc_progress_fileCnt__ 120/128
1102s __bpc_progress_state__ rename total
1102s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs)
1102s Xfer PIDs are now 
1102s xferPids 
1102s Finished BackupPC_refCountUpdate (running time: 0 sec)
1102s Xfer PIDs are now 
1102s xferPids 
1102s incr backup complete
1102s OK: Incremental backup succeeded
1102s Done.
1102s autopkgtest [12:06:20]: test smb-backup: -----------------------]
1103s autopkgtest [12:06:21]: test smb-backup:  - - - - - - - - - - results - - - - - - - - - -
1103s smb-backup           PASS
1103s autopkgtest [12:06:21]: test authenticated-smb-backup: preparing testbed
1105s Reading package lists...
1105s Building dependency tree...
1105s Reading state information...
1105s Starting pkgProblemResolver with broken count: 0
1105s Starting 2 pkgProblemResolver with broken count: 0
1105s Done
1106s The following NEW packages will be installed:
1106s   autopkgtest-satdep
1106s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded.
1106s Need to get 0 B/724 B of archives.
1106s After this operation, 0 B of additional disk space will be used.
1106s Get:1 /tmp/autopkgtest.zAxVns/2-autopkgtest-satdep.deb autopkgtest-satdep amd64 0 [724 B]
1106s Selecting previously unselected package autopkgtest-satdep.
1106s (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 ... 74052 files and directories currently installed.)
1106s Preparing to unpack .../2-autopkgtest-satdep.deb ...
1106s Unpacking autopkgtest-satdep (0) ...
1106s Setting up autopkgtest-satdep (0) ...
1107s (Reading database ... 74051 files and directories currently installed.)
1107s Removing autopkgtest-satdep (0) ...
1108s autopkgtest [12:06:26]: test authenticated-smb-backup: [-----------------------
1108s Populating share path
1108s Adding samba share
1108s Adding [private] share
1108s Creating user
1108s Creating a local and samba user called smbtest4185
1108s Setting samba password for the smbtest4185 user
1108s Added user smbtest4185.
1108s Configuring backuppc
1108s Performing a full backup
1108s Backup type: type = full, needs_full = , needs_incr = , lastFullTime = 1711368379, opts{f} = 1, opts{i} = , opts{F} = 
1108s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost
1108s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost
1108s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.009
1108s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.2.z created 2024-03-25 12:06:26 
1108s Backup prep: type = full, case = 4, inPlace = 0, doDuplicate = 0, newBkupNum = 2, newBkupIdx = 2, lastBkupNum = 1, lastBkupIdx = 1 (FillCycle = 0, noFillCnt = 0)
1108s __bpc_progress_state__ backup share "private"
1108s Running: /usr/bin/smbclient \\\\localhost\\private -U smbtest4185 -E -d 1 -c tarmode\ full -mSMB3 -Tc -
1108s full backup started for share private
1108s started full dump, share=private
1108s Xfer PIDs are now 4279,4278
1108s xferPids 4279,4278
1108s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\private -U smbtest4185 -E -d 1 -c tarmode\ full -mSMB3 -Tc -
1108s tarmode is now full, system, hidden, noreset, noverbose
1108s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 1
1108s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1)
1108s __bpc_progress_fileCnt__ 0
1108s   new      644       0/0      480434 tmp.PGYExQ
1108s   new      644       0/0      480434 tmp.xnCVT6
1108s   new      644       0/0      480434 tmp.4JT3gR
1108s   new      644       0/0      480434 tmp.dV0i4z
1108s   new      644       0/0      480434 tmp.CHJHYX
1108s   new      644       0/0      480434 tmp.0j5eiF
1108s   new      644       0/0      480434 tmp.y7uF9G
1108s   new      644       0/0      480434 tmp.Di6Y8G
1108s   new      644       0/0      480434 tmp.dp4pHf
1108s tar: dumped 10 files and 0 directories
1108s Total bytes written: 4804340 (31.7 MiB/s)
1108s readOutput: sysread returns 0 and got EOF (exit ok = 1, )
1108s   new      644       0/0      480434 tmp.Ov1REB
1108s __bpc_progress_fileCnt__ 10
1108s tarExtract: Done: 0 errors, 0 filesExist, 0 sizeExist, 0 sizeExistComp, 10 filesTotal, 4804340 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377822 sizeNewComp, 36 inodeLast
1108s Xfer PIDs are now 
1108s xferPids 
1108s OrphanShareNameClean: removing orphan share public from /var/lib/backuppc/pc/localhost/2
1108s __bpc_progress_state__ delete share #2/public
1108s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDelete -h localhost -n 2 -l -m -s public /
1108s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDelete line 102.
1108s 	(Did you mean "$Host\'s" instead?)
1108s Xfer PIDs are now 4285
1108s xferPids 4285
1108s BackupPC_backupDelete: removing #2/public/
1108s __bpc_progress_state__ merge #2/public/ -> #1/public/
1108s BackupPC_backupDelete: Merge into backup 1/public/
1108s mergeDir: attr write to /var/lib/backuppc/pc/localhost/1/fpublic//attrib failed (digest was )
1108s bpc_attrib_dirWrite: can't open/create raw /var/lib/backuppc/pc/localhost/1/fpublic for writing
1108s Xfer PIDs are now 4285,4288
1108s xferPids 4285,4288
1108s __bpc_progress_state__ refCnt #1
1108s __bpc_progress_state__ cntUpdate #1
1108s __bpc_progress_state__ rename #1
1108s __bpc_progress_state__ refCnt #2
1108s BackupPC_refCountUpdate: localhost #2 inodeLast set to 37 (was 24)
1108s __bpc_progress_state__ cntUpdate #2
1108s __bpc_progress_state__ rename #2
1108s __bpc_progress_state__ sumUpdate
1108s __bpc_progress_fileCnt__ 0/128
1108s __bpc_progress_fileCnt__ 8/128
1108s __bpc_progress_fileCnt__ 16/128
1108s __bpc_progress_fileCnt__ 24/128
1108s __bpc_progress_fileCnt__ 32/128
1108s __bpc_progress_fileCnt__ 40/128
1109s __bpc_progress_fileCnt__ 48/128
1109s __bpc_progress_fileCnt__ 56/128
1109s __bpc_progress_fileCnt__ 64/128
1109s __bpc_progress_fileCnt__ 72/128
1109s __bpc_progress_fileCnt__ 80/128
1109s __bpc_progress_fileCnt__ 88/128
1109s __bpc_progress_fileCnt__ 96/128
1109s __bpc_progress_fileCnt__ 104/128
1109s __bpc_progress_fileCnt__ 112/128
1109s __bpc_progress_fileCnt__ 120/128
1109s __bpc_progress_state__ rename total
1109s BackupPC_refCountUpdate: host localhost got 0 errors (took 1 secs)
1109s Xfer PIDs are now 4285
1109s xferPids 4285
1109s Xfer PIDs are now 
1109s xferPids 
1109s Finished BackupPC_backupDelete, status = 0 (running time: 1 sec)
1109s Xfer PIDs are now 
1109s xferPids 
1109s full backup 2 complete, 10 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other)
1109s BackupExpire: cntFull = 2, cntIncr = 1, firstFull = 0, firstIncr = 1, oldestIncr = 9.25925925925926e-05, oldestFull = 9.25925925925926e-05
1109s __bpc_progress_state__ fsck
1109s Running BackupPC_refCountUpdate -h localhost on localhost
1109s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost
1109s Xfer PIDs are now 4291
1109s xferPids 4291
1109s BackupPC_refCountUpdate: doing fsck on localhost #2 (full) since $ConfRefCntFsck == 1
1109s __bpc_progress_state__ refCnt #2
1109s __bpc_progress_state__ cntUpdate #2
1109s __bpc_progress_state__ rename #2
1109s __bpc_progress_state__ sumUpdate
1109s __bpc_progress_fileCnt__ 0/128
1109s __bpc_progress_fileCnt__ 8/128
1109s __bpc_progress_fileCnt__ 16/128
1109s __bpc_progress_fileCnt__ 24/128
1109s __bpc_progress_fileCnt__ 32/128
1109s __bpc_progress_fileCnt__ 40/128
1109s __bpc_progress_fileCnt__ 48/128
1109s __bpc_progress_fileCnt__ 56/128
1109s __bpc_progress_fileCnt__ 64/128
1109s __bpc_progress_fileCnt__ 72/128
1109s __bpc_progress_fileCnt__ 80/128
1109s __bpc_progress_fileCnt__ 88/128
1109s __bpc_progress_fileCnt__ 96/128
1109s __bpc_progress_fileCnt__ 104/128
1109s __bpc_progress_fileCnt__ 112/128
1109s __bpc_progress_fileCnt__ 120/128
1109s __bpc_progress_state__ rename total
1109s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs)
1109s Xfer PIDs are now 
1109s xferPids 
1109s Finished BackupPC_refCountUpdate (running time: 0 sec)
1109s Xfer PIDs are now 
1109s xferPids 
1109s full backup complete
1109s OK: Full backup succeeded
1109s Changing share content and performing an incremental backup
1109s Backup type: type = incr, needs_full = , needs_incr = , lastFullTime = 1711368386, opts{f} = , opts{i} = 1, opts{F} = 
1109s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost
1109s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost
1109s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.012
1109s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.3.z created 2024-03-25 12:06:27 
1109s Backup prep: type = incr, case = 3, inPlace = 1, doDuplicate = 1, newBkupNum = 3, newBkupIdx = 3, lastBkupNum = , lastBkupIdx =  (FillCycle = 0, noFillCnt = 1)
1109s Executing /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost
1109s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost
1109s Old package separator used in string at /usr/share/backuppc/bin/BackupPC_backupDuplicate line 89.
1109s 	(Did you mean "$Host\'s" instead?)
1109s Xfer PIDs are now 4361
1109s xferPids 4361
1109s __bpc_progress_state__ copy #2 -> #3
1109s Copying backup #2 to #3
1109s __bpc_progress_fileCnt__ 3 dirs
1109s Xfer PIDs are now 4361,4364
1109s xferPids 4361,4364
1109s __bpc_progress_state__ sumUpdate
1109s __bpc_progress_fileCnt__ 0/128
1109s __bpc_progress_fileCnt__ 8/128
1109s __bpc_progress_fileCnt__ 16/128
1109s __bpc_progress_fileCnt__ 24/128
1109s __bpc_progress_fileCnt__ 32/128
1109s __bpc_progress_fileCnt__ 40/128
1109s __bpc_progress_fileCnt__ 48/128
1109s __bpc_progress_fileCnt__ 56/128
1109s __bpc_progress_fileCnt__ 64/128
1109s __bpc_progress_fileCnt__ 72/128
1109s __bpc_progress_fileCnt__ 80/128
1109s __bpc_progress_fileCnt__ 88/128
1109s __bpc_progress_fileCnt__ 96/128
1109s __bpc_progress_fileCnt__ 104/128
1109s __bpc_progress_fileCnt__ 112/128
1109s __bpc_progress_fileCnt__ 120/128
1109s __bpc_progress_state__ rename total
1109s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs)
1109s Xfer PIDs are now 4361
1109s xferPids 4361
1109s BackupPC_backupDuplicate: got 0 errors and 0 file open errors
1109s Finished BackupPC_backupDuplicate (running time: 0 sec)
1109s __bpc_progress_state__ backup share "private"
1109s Running: /usr/bin/smbclient \\\\localhost\\private -U smbtest4185 -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 -
1109s incr backup started back to 2024-03-25 11:06:26  (backup #2) for share private
1109s started incr dump, share=private
1109s Xfer PIDs are now 4368,4367
1109s xferPids 4368,4367
1109s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\private -U smbtest4185 -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 -
1109s tar:1298 Getting files newer than Mon Mar 25 11:06:26 2024
1109s 
1109s tarmode is now full, system, hidden, noreset, noverbose
1109s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 
1109s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1)
1109s __bpc_progress_fileCnt__ 0
1109s   new      644       0/0      480434 tmp.XkJPwi
1109s   same     644       0/0      480434 tmp.PGYExQ
1109s   new      644       0/0      480434 tmp.klud6B
1109s   new      644       0/0      480434 tmp.ERoZeI
1109s   same     644       0/0      480434 tmp.xnCVT6
1109s   same     644       0/0      480434 tmp.4JT3gR
1109s   same     644       0/0      480434 tmp.dV0i4z
1109s   same     644       0/0      480434 tmp.CHJHYX
1109s   new      644       0/0      480434 tmp.NniFs6
1109s   same     644       0/0      480434 tmp.0j5eiF
1109s   same     644       0/0      480434 tmp.y7uF9G
1109s   new      644       0/0      480434 tmp.IClr1t
1109s   new      644       0/0      480434 tmp.kY2CYU
1109s   same     644       0/0      480434 tmp.Di6Y8G
1109s   new      644       0/0      480434 tmp.qx7yBr
1109s   new      644       0/0      480434 tmp.AGADSe
1109s   new      644       0/0      480434 tmp.OZjFZR
1109s   same     644       0/0      480434 tmp.dp4pHf
1109s   new      644       0/0      480434 tmp.cBcmqW
1109s tar: dumped 20 files and 0 directories
1109s Total bytes written: 9608680 (52.1 MiB/s)
1109s   same     644       0/0      480434 tmp.Ov1REB
1109s readOutput: sysread returns 0 and got EOF (exit ok = 1, )
1109s __bpc_progress_fileCnt__ 20
1109s tarExtract: Done: 0 errors, 10 filesExist, 4804340 sizeExist, 1377822 sizeExistComp, 20 filesTotal, 9608680 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377798 sizeNewComp, 47 inodeLast
1109s Xfer PIDs are now 
1109s xferPids 
1109s incr backup 3 complete, 20 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other)
1109s BackupExpire: cntFull = 3, cntIncr = 1, firstFull = 0, firstIncr = 1, oldestIncr = 9.25925925925926e-05, oldestFull = 9.25925925925926e-05
1109s __bpc_progress_state__ fsck
1109s Running BackupPC_refCountUpdate -h localhost on localhost
1109s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost
1109s Xfer PIDs are now 4374
1109s xferPids 4374
1109s __bpc_progress_state__ cntUpdate #3
1109s __bpc_progress_state__ rename #3
1109s __bpc_progress_state__ sumUpdate
1109s __bpc_progress_fileCnt__ 0/128
1109s __bpc_progress_fileCnt__ 8/128
1109s __bpc_progress_fileCnt__ 16/128
1109s __bpc_progress_fileCnt__ 24/128
1109s __bpc_progress_fileCnt__ 32/128
1109s __bpc_progress_fileCnt__ 40/128
1109s __bpc_progress_fileCnt__ 48/128
1109s __bpc_progress_fileCnt__ 56/128
1109s __bpc_progress_fileCnt__ 64/128
1109s __bpc_progress_fileCnt__ 72/128
1109s __bpc_progress_fileCnt__ 80/128
1109s __bpc_progress_fileCnt__ 88/128
1109s __bpc_progress_fileCnt__ 96/128
1109s __bpc_progress_fileCnt__ 104/128
1109s __bpc_progress_fileCnt__ 112/128
1109s __bpc_progress_fileCnt__ 120/128
1109s __bpc_progress_state__ rename total
1109s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs)
1109s Xfer PIDs are now 
1109s xferPids 
1109s Finished BackupPC_refCountUpdate (running time: 0 sec)
1109s Xfer PIDs are now 
1109s xferPids 
1109s incr backup complete
1109s OK: Incremental backup succeeded
1109s Done.
1109s Deleted user smbtest4185.
1110s userdel: smbtest4185 mail spool (/var/mail/smbtest4185) not found
1110s autopkgtest [12:06:28]: test authenticated-smb-backup: -----------------------]
1110s autopkgtest [12:06:28]: test authenticated-smb-backup:  - - - - - - - - - - results - - - - - - - - - -
1110s authenticated-smb-backup PASS
1110s autopkgtest [12:06:28]: @@@@@@@@@@@@@@@@@@@@ summary
1110s smb-backup           PASS
1110s authenticated-smb-backup PASS
1121s Creating nova instance adt-noble-amd64-backuppc-20240325-114756-juju-7f2275-prod-proposed-migration-environment-3 from image adt/ubuntu-noble-amd64-server-20240325.img (UUID ba43860b-557a-4db2-b3f0-378a99bca08c)...