0s autopkgtest [05:55:36]: starting date and time: 2026-01-30 05:55:36+0000 0s autopkgtest [05:55:36]: git checkout: 4b346b80 nova: make wait_reboot return success even when a no-op 0s autopkgtest [05:55:36]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.osa3s8u7/out --timeout-copy=6000 --needs-internet=try --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:tntnet --apt-upgrade backuppc --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=tntnet/3.0-4build1 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-cpu2-ram4-disk20-arm64 --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@sto01-arm64-3.secgroup --name adt-resolute-arm64-backuppc-20260130-055536-juju-7f2275-prod-proposed-migration-environment-2-1dc4b9fe-ea1d-4268-abb5-b03a09bc735a --image adt/ubuntu-resolute-arm64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-autopkgtest-workers-arm64 -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 4s Creating nova instance adt-resolute-arm64-backuppc-20260130-055536-juju-7f2275-prod-proposed-migration-environment-2-1dc4b9fe-ea1d-4268-abb5-b03a09bc735a from image adt/ubuntu-resolute-arm64-server-20260130.img (UUID d80a3628-95a8-4c17-a25a-26b02882b363)... 58s autopkgtest [05:56:34]: testbed dpkg architecture: arm64 58s autopkgtest [05:56:34]: testbed apt version: 3.1.14 58s autopkgtest [05:56:34]: @@@@@@@@@@@@@@@@@@@@ test bed setup 58s autopkgtest [05:56:34]: testbed release detected to be: None 59s autopkgtest [05:56:35]: updating testbed package index (apt update) 59s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease [124 kB] 59s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 59s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 60s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 60s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/restricted Sources [2820 B] 60s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/universe Sources [1600 kB] 60s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/main Sources [103 kB] 60s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse Sources [33.0 kB] 60s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main arm64 Packages [120 kB] 60s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/main arm64 c-n-f Metadata [4364 B] 60s Get:11 http://ftpmaster.internal/ubuntu resolute-proposed/restricted arm64 Packages [12.3 kB] 60s Get:12 http://ftpmaster.internal/ubuntu resolute-proposed/restricted arm64 c-n-f Metadata [328 B] 60s Get:13 http://ftpmaster.internal/ubuntu resolute-proposed/universe arm64 Packages [1166 kB] 60s Get:14 http://ftpmaster.internal/ubuntu resolute-proposed/universe arm64 c-n-f Metadata [21.9 kB] 60s Get:15 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse arm64 Packages [25.4 kB] 60s Get:16 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse arm64 c-n-f Metadata [720 B] 63s Fetched 3215 kB in 1s (2712 kB/s) 64s Reading package lists... 65s Hit:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease 65s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 65s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 65s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 66s Reading package lists... 66s Reading package lists... 66s Building dependency tree... 66s Reading state information... 67s Calculating upgrade... 67s The following packages will be upgraded: 67s bzip2 inetutils-telnet libbz2-1.0 libsqlite3-0 telnet 68s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 68s Need to get 888 kB of archives. 68s After this operation, 2048 B of additional disk space will be used. 68s Get:1 http://ftpmaster.internal/ubuntu resolute/main arm64 bzip2 arm64 1.0.8-6build2 [34.0 kB] 68s Get:2 http://ftpmaster.internal/ubuntu resolute/main arm64 libbz2-1.0 arm64 1.0.8-6build2 [34.9 kB] 68s Get:3 http://ftpmaster.internal/ubuntu resolute/main arm64 libsqlite3-0 arm64 3.46.1-9 [711 kB] 68s Get:4 http://ftpmaster.internal/ubuntu resolute/main arm64 inetutils-telnet arm64 2:2.7-2ubuntu1 [104 kB] 68s Get:5 http://ftpmaster.internal/ubuntu resolute/main arm64 telnet all 0.17+2.7-2ubuntu1 [3636 B] 68s dpkg-preconfigure: unable to re-open stdin: No such file or directory 68s Fetched 888 kB in 1s (927 kB/s) 69s (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 ... 135255 files and directories currently installed.) 69s Preparing to unpack .../bzip2_1.0.8-6build2_arm64.deb ... 69s Unpacking bzip2 (1.0.8-6build2) over (1.0.8-6build1) ... 69s Preparing to unpack .../libbz2-1.0_1.0.8-6build2_arm64.deb ... 69s Unpacking libbz2-1.0:arm64 (1.0.8-6build2) over (1.0.8-6build1) ... 69s Setting up libbz2-1.0:arm64 (1.0.8-6build2) ... 69s (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 ... 135255 files and directories currently installed.) 69s Preparing to unpack .../libsqlite3-0_3.46.1-9_arm64.deb ... 69s Unpacking libsqlite3-0:arm64 (3.46.1-9) over (3.46.1-8) ... 69s Preparing to unpack .../inetutils-telnet_2%3a2.7-2ubuntu1_arm64.deb ... 69s Unpacking inetutils-telnet (2:2.7-2ubuntu1) over (2:2.6-4ubuntu1) ... 69s Preparing to unpack .../telnet_0.17+2.7-2ubuntu1_all.deb ... 69s Unpacking telnet (0.17+2.7-2ubuntu1) over (0.17+2.6-4ubuntu1) ... 69s Setting up libsqlite3-0:arm64 (3.46.1-9) ... 69s Setting up inetutils-telnet (2:2.7-2ubuntu1) ... 69s Setting up bzip2 (1.0.8-6build2) ... 69s Setting up telnet (0.17+2.7-2ubuntu1) ... 69s Processing triggers for man-db (2.13.1-1) ... 70s Processing triggers for libc-bin (2.42-2ubuntu4) ... 70s autopkgtest [05:56:46]: upgrading testbed (apt dist-upgrade and autopurge) 70s Reading package lists... 70s Building dependency tree... 70s Reading state information... 71s Calculating upgrade... 71s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 71s Reading package lists... 71s Building dependency tree... 71s Reading state information... 72s Solving dependencies... 72s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 74s autopkgtest [05:56:50]: testbed running kernel: Linux 6.18.0-9-generic #9-Ubuntu SMP PREEMPT_DYNAMIC Mon Jan 12 16:41:39 UTC 2026 75s autopkgtest [05:56:51]: @@@@@@@@@@@@@@@@@@@@ apt-source backuppc 76s Get:1 http://ftpmaster.internal/ubuntu resolute/main backuppc 4.4.0-11 (dsc) [2169 B] 76s Get:2 http://ftpmaster.internal/ubuntu resolute/main backuppc 4.4.0-11 (tar) [657 kB] 76s Get:3 http://ftpmaster.internal/ubuntu resolute/main backuppc 4.4.0-11 (diff) [37.9 kB] 76s gpgv: Signature made Sun Mar 30 09:20:11 2025 UTC 76s gpgv: using RSA key FDDD0CFF3864277630A2186C9164FA1D17BD5D36 76s gpgv: Can't check signature: No public key 76s dpkg-source: warning: cannot verify inline signature for ./backuppc_4.4.0-11.dsc: no acceptable signature found 76s autopkgtest [05:56:52]: testing package backuppc version 4.4.0-11 77s autopkgtest [05:56:53]: build not needed 78s autopkgtest [05:56:54]: test smb-backup: preparing testbed 78s Reading package lists... 78s Building dependency tree... 78s Reading state information... 78s Solving dependencies... 79s The following NEW packages will be installed: 79s apache2 apache2-bin apache2-data apache2-utils backuppc backuppc-rsync 79s libapr1t64 libaprutil1-dbd-sqlite3 libaprutil1-ldap libaprutil1t64 79s libarchive-zip-perl libavahi-client3 libavahi-common-data libavahi-common3 79s libbackuppc-xs-perl libcgi-pm-perl libcups2t64 libfile-listing-perl 79s libhtml-parser-perl libhtml-tagset-perl libhttp-date-perl libldb2 79s liblua5.4-0 libnsl2 libsmbclient0 libtalloc2 libtdb1 libtevent0t64 79s libtime-parsedate-perl libtimedate-perl liburi-perl liburing2 libwbclient0 79s postfix samba samba-common samba-common-bin samba-libs smbclient 79s 0 upgraded, 39 newly installed, 0 to remove and 0 not upgraded. 79s Need to get 15.4 MB of archives. 79s After this operation, 77.9 MB of additional disk space will be used. 79s Get:1 http://ftpmaster.internal/ubuntu resolute/main arm64 libapr1t64 arm64 1.7.6-3 [107 kB] 79s Get:2 http://ftpmaster.internal/ubuntu resolute/main arm64 libaprutil1t64 arm64 1.6.3-3ubuntu3 [92.9 kB] 79s Get:3 http://ftpmaster.internal/ubuntu resolute/main arm64 libaprutil1-dbd-sqlite3 arm64 1.6.3-3ubuntu3 [11.4 kB] 79s Get:4 http://ftpmaster.internal/ubuntu resolute/main arm64 libaprutil1-ldap arm64 1.6.3-3ubuntu3 [9066 B] 79s Get:5 http://ftpmaster.internal/ubuntu resolute/main arm64 liblua5.4-0 arm64 5.4.8-1 [171 kB] 79s Get:6 http://ftpmaster.internal/ubuntu resolute/main arm64 apache2-bin arm64 2.4.65-3ubuntu1 [1322 kB] 79s Get:7 http://ftpmaster.internal/ubuntu resolute/main arm64 apache2-data all 2.4.65-3ubuntu1 [163 kB] 79s Get:8 http://ftpmaster.internal/ubuntu resolute/main arm64 apache2-utils arm64 2.4.65-3ubuntu1 [98.8 kB] 79s Get:9 http://ftpmaster.internal/ubuntu resolute/main arm64 apache2 arm64 2.4.65-3ubuntu1 [93.4 kB] 79s Get:10 http://ftpmaster.internal/ubuntu resolute/main arm64 backuppc-rsync arm64 3.1.3.0-5 [255 kB] 79s Get:11 http://ftpmaster.internal/ubuntu resolute/main arm64 libnsl2 arm64 1.3.0-3build4 [41.7 kB] 79s Get:12 http://ftpmaster.internal/ubuntu resolute/main arm64 postfix arm64 3.10.6-1ubuntu1 [1291 kB] 79s Get:13 http://ftpmaster.internal/ubuntu resolute/main arm64 libarchive-zip-perl all 1.68-1 [90.2 kB] 79s Get:14 http://ftpmaster.internal/ubuntu resolute/main arm64 libbackuppc-xs-perl arm64 0.62-2build6 [64.6 kB] 79s Get:15 http://ftpmaster.internal/ubuntu resolute/main arm64 libhtml-tagset-perl all 3.24-1 [14.1 kB] 79s Get:16 http://ftpmaster.internal/ubuntu resolute/main arm64 liburi-perl all 5.34-2build1 [100 kB] 79s Get:17 http://ftpmaster.internal/ubuntu resolute/main arm64 libhtml-parser-perl arm64 3.83-1build1 [85.3 kB] 79s Get:18 http://ftpmaster.internal/ubuntu resolute/main arm64 libcgi-pm-perl all 4.71-1build1 [185 kB] 79s Get:19 http://ftpmaster.internal/ubuntu resolute/main arm64 libtimedate-perl all 2.3300-2 [34.0 kB] 79s Get:20 http://ftpmaster.internal/ubuntu resolute/main arm64 libhttp-date-perl all 6.06-1 [10.2 kB] 79s Get:21 http://ftpmaster.internal/ubuntu resolute/main arm64 libfile-listing-perl all 6.16-1 [11.3 kB] 79s Get:22 http://ftpmaster.internal/ubuntu resolute/main arm64 libtime-parsedate-perl all 2015.103-5 [27.9 kB] 79s Get:23 http://ftpmaster.internal/ubuntu resolute/main arm64 backuppc arm64 4.4.0-11 [518 kB] 79s Get:24 http://ftpmaster.internal/ubuntu resolute/main arm64 samba-common all 2:4.23.4+dfsg-1ubuntu1 [74.4 kB] 79s Get:25 http://ftpmaster.internal/ubuntu resolute/main arm64 libavahi-common-data arm64 0.8-17ubuntu2 [31.5 kB] 79s Get:26 http://ftpmaster.internal/ubuntu resolute/main arm64 libavahi-common3 arm64 0.8-17ubuntu2 [22.6 kB] 79s Get:27 http://ftpmaster.internal/ubuntu resolute/main arm64 libavahi-client3 arm64 0.8-17ubuntu2 [26.7 kB] 79s Get:28 http://ftpmaster.internal/ubuntu resolute/main arm64 libcups2t64 arm64 2.4.16-1ubuntu1 [271 kB] 79s Get:29 http://ftpmaster.internal/ubuntu resolute/main arm64 libtalloc2 arm64 2:2.4.3+samba4.23.4+dfsg-1ubuntu1 [76.8 kB] 79s Get:30 http://ftpmaster.internal/ubuntu resolute/main arm64 libtdb1 arm64 2:1.4.14+samba4.23.4+dfsg-1ubuntu1 [98.4 kB] 79s Get:31 http://ftpmaster.internal/ubuntu resolute/main arm64 libtevent0t64 arm64 2:0.17.1+samba4.23.4+dfsg-1ubuntu1 [41.1 kB] 79s Get:32 http://ftpmaster.internal/ubuntu resolute/main arm64 libldb2 arm64 2:2.11.0+samba4.23.4+dfsg-1ubuntu1 [151 kB] 79s Get:33 http://ftpmaster.internal/ubuntu resolute/main arm64 libwbclient0 arm64 2:4.23.4+dfsg-1ubuntu1 [85.8 kB] 79s Get:34 http://ftpmaster.internal/ubuntu resolute/main arm64 samba-libs arm64 2:4.23.4+dfsg-1ubuntu1 [6591 kB] 79s Get:35 http://ftpmaster.internal/ubuntu resolute/main arm64 samba-common-bin arm64 2:4.23.4+dfsg-1ubuntu1 [1385 kB] 79s Get:36 http://ftpmaster.internal/ubuntu resolute/main arm64 liburing2 arm64 2.11-1 [25.1 kB] 79s Get:37 http://ftpmaster.internal/ubuntu resolute/main arm64 samba arm64 2:4.23.4+dfsg-1ubuntu1 [1218 kB] 79s Get:38 http://ftpmaster.internal/ubuntu resolute/main arm64 libsmbclient0 arm64 2:4.23.4+dfsg-1ubuntu1 [62.9 kB] 79s Get:39 http://ftpmaster.internal/ubuntu resolute/main arm64 smbclient arm64 2:4.23.4+dfsg-1ubuntu1 [493 kB] 80s Preconfiguring packages ... 80s Fetched 15.4 MB in 1s (21.2 MB/s) 80s Selecting previously unselected package libapr1t64:arm64. 80s (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 ... 135255 files and directories currently installed.) 80s Preparing to unpack .../00-libapr1t64_1.7.6-3_arm64.deb ... 80s Unpacking libapr1t64:arm64 (1.7.6-3) ... 80s Selecting previously unselected package libaprutil1t64:arm64. 80s Preparing to unpack .../01-libaprutil1t64_1.6.3-3ubuntu3_arm64.deb ... 80s Unpacking libaprutil1t64:arm64 (1.6.3-3ubuntu3) ... 80s Selecting previously unselected package libaprutil1-dbd-sqlite3:arm64. 80s Preparing to unpack .../02-libaprutil1-dbd-sqlite3_1.6.3-3ubuntu3_arm64.deb ... 80s Unpacking libaprutil1-dbd-sqlite3:arm64 (1.6.3-3ubuntu3) ... 80s Selecting previously unselected package libaprutil1-ldap:arm64. 80s Preparing to unpack .../03-libaprutil1-ldap_1.6.3-3ubuntu3_arm64.deb ... 80s Unpacking libaprutil1-ldap:arm64 (1.6.3-3ubuntu3) ... 80s Selecting previously unselected package liblua5.4-0:arm64. 80s Preparing to unpack .../04-liblua5.4-0_5.4.8-1_arm64.deb ... 80s Unpacking liblua5.4-0:arm64 (5.4.8-1) ... 80s Selecting previously unselected package apache2-bin. 80s Preparing to unpack .../05-apache2-bin_2.4.65-3ubuntu1_arm64.deb ... 80s Unpacking apache2-bin (2.4.65-3ubuntu1) ... 80s Selecting previously unselected package apache2-data. 80s Preparing to unpack .../06-apache2-data_2.4.65-3ubuntu1_all.deb ... 80s Unpacking apache2-data (2.4.65-3ubuntu1) ... 80s Selecting previously unselected package apache2-utils. 80s Preparing to unpack .../07-apache2-utils_2.4.65-3ubuntu1_arm64.deb ... 80s Unpacking apache2-utils (2.4.65-3ubuntu1) ... 80s Selecting previously unselected package apache2. 80s Preparing to unpack .../08-apache2_2.4.65-3ubuntu1_arm64.deb ... 80s Unpacking apache2 (2.4.65-3ubuntu1) ... 80s Selecting previously unselected package backuppc-rsync. 80s Preparing to unpack .../09-backuppc-rsync_3.1.3.0-5_arm64.deb ... 80s Unpacking backuppc-rsync (3.1.3.0-5) ... 80s Selecting previously unselected package libnsl2:arm64. 80s Preparing to unpack .../10-libnsl2_1.3.0-3build4_arm64.deb ... 80s Unpacking libnsl2:arm64 (1.3.0-3build4) ... 80s Selecting previously unselected package postfix. 80s Preparing to unpack .../11-postfix_3.10.6-1ubuntu1_arm64.deb ... 80s Unpacking postfix (3.10.6-1ubuntu1) ... 80s Selecting previously unselected package libarchive-zip-perl. 81s Preparing to unpack .../12-libarchive-zip-perl_1.68-1_all.deb ... 81s Unpacking libarchive-zip-perl (1.68-1) ... 81s Selecting previously unselected package libbackuppc-xs-perl:arm64. 81s Preparing to unpack .../13-libbackuppc-xs-perl_0.62-2build6_arm64.deb ... 81s Unpacking libbackuppc-xs-perl:arm64 (0.62-2build6) ... 81s Selecting previously unselected package libhtml-tagset-perl. 81s Preparing to unpack .../14-libhtml-tagset-perl_3.24-1_all.deb ... 81s Unpacking libhtml-tagset-perl (3.24-1) ... 81s Selecting previously unselected package liburi-perl. 81s Preparing to unpack .../15-liburi-perl_5.34-2build1_all.deb ... 81s Unpacking liburi-perl (5.34-2build1) ... 81s Selecting previously unselected package libhtml-parser-perl:arm64. 81s Preparing to unpack .../16-libhtml-parser-perl_3.83-1build1_arm64.deb ... 81s Unpacking libhtml-parser-perl:arm64 (3.83-1build1) ... 81s Selecting previously unselected package libcgi-pm-perl. 81s Preparing to unpack .../17-libcgi-pm-perl_4.71-1build1_all.deb ... 81s Unpacking libcgi-pm-perl (4.71-1build1) ... 81s Selecting previously unselected package libtimedate-perl. 81s Preparing to unpack .../18-libtimedate-perl_2.3300-2_all.deb ... 81s Unpacking libtimedate-perl (2.3300-2) ... 81s Selecting previously unselected package libhttp-date-perl. 81s Preparing to unpack .../19-libhttp-date-perl_6.06-1_all.deb ... 81s Unpacking libhttp-date-perl (6.06-1) ... 81s Selecting previously unselected package libfile-listing-perl. 81s Preparing to unpack .../20-libfile-listing-perl_6.16-1_all.deb ... 81s Unpacking libfile-listing-perl (6.16-1) ... 81s Selecting previously unselected package libtime-parsedate-perl. 81s Preparing to unpack .../21-libtime-parsedate-perl_2015.103-5_all.deb ... 81s Unpacking libtime-parsedate-perl (2015.103-5) ... 81s Selecting previously unselected package backuppc. 81s Preparing to unpack .../22-backuppc_4.4.0-11_arm64.deb ... 81s Unpacking backuppc (4.4.0-11) ... 81s Selecting previously unselected package samba-common. 81s Preparing to unpack .../23-samba-common_2%3a4.23.4+dfsg-1ubuntu1_all.deb ... 81s Unpacking samba-common (2:4.23.4+dfsg-1ubuntu1) ... 81s Selecting previously unselected package libavahi-common-data:arm64. 81s Preparing to unpack .../24-libavahi-common-data_0.8-17ubuntu2_arm64.deb ... 81s Unpacking libavahi-common-data:arm64 (0.8-17ubuntu2) ... 81s Selecting previously unselected package libavahi-common3:arm64. 81s Preparing to unpack .../25-libavahi-common3_0.8-17ubuntu2_arm64.deb ... 81s Unpacking libavahi-common3:arm64 (0.8-17ubuntu2) ... 81s Selecting previously unselected package libavahi-client3:arm64. 81s Preparing to unpack .../26-libavahi-client3_0.8-17ubuntu2_arm64.deb ... 81s Unpacking libavahi-client3:arm64 (0.8-17ubuntu2) ... 81s Selecting previously unselected package libcups2t64:arm64. 81s Preparing to unpack .../27-libcups2t64_2.4.16-1ubuntu1_arm64.deb ... 81s Unpacking libcups2t64:arm64 (2.4.16-1ubuntu1) ... 81s Selecting previously unselected package libtalloc2:arm64. 81s Preparing to unpack .../28-libtalloc2_2%3a2.4.3+samba4.23.4+dfsg-1ubuntu1_arm64.deb ... 81s Unpacking libtalloc2:arm64 (2:2.4.3+samba4.23.4+dfsg-1ubuntu1) ... 81s Selecting previously unselected package libtdb1:arm64. 81s Preparing to unpack .../29-libtdb1_2%3a1.4.14+samba4.23.4+dfsg-1ubuntu1_arm64.deb ... 81s Unpacking libtdb1:arm64 (2:1.4.14+samba4.23.4+dfsg-1ubuntu1) ... 81s Selecting previously unselected package libtevent0t64:arm64. 81s Preparing to unpack .../30-libtevent0t64_2%3a0.17.1+samba4.23.4+dfsg-1ubuntu1_arm64.deb ... 81s Unpacking libtevent0t64:arm64 (2:0.17.1+samba4.23.4+dfsg-1ubuntu1) ... 81s Selecting previously unselected package libldb2:arm64. 81s Preparing to unpack .../31-libldb2_2%3a2.11.0+samba4.23.4+dfsg-1ubuntu1_arm64.deb ... 81s Unpacking libldb2:arm64 (2:2.11.0+samba4.23.4+dfsg-1ubuntu1) ... 81s Selecting previously unselected package libwbclient0:arm64. 81s Preparing to unpack .../32-libwbclient0_2%3a4.23.4+dfsg-1ubuntu1_arm64.deb ... 81s Unpacking libwbclient0:arm64 (2:4.23.4+dfsg-1ubuntu1) ... 81s Selecting previously unselected package samba-libs:arm64. 81s Preparing to unpack .../33-samba-libs_2%3a4.23.4+dfsg-1ubuntu1_arm64.deb ... 81s Unpacking samba-libs:arm64 (2:4.23.4+dfsg-1ubuntu1) ... 82s Selecting previously unselected package samba-common-bin. 82s Preparing to unpack .../34-samba-common-bin_2%3a4.23.4+dfsg-1ubuntu1_arm64.deb ... 82s Unpacking samba-common-bin (2:4.23.4+dfsg-1ubuntu1) ... 82s Selecting previously unselected package liburing2:arm64. 82s Preparing to unpack .../35-liburing2_2.11-1_arm64.deb ... 82s Unpacking liburing2:arm64 (2.11-1) ... 82s Selecting previously unselected package samba. 82s Preparing to unpack .../36-samba_2%3a4.23.4+dfsg-1ubuntu1_arm64.deb ... 82s Unpacking samba (2:4.23.4+dfsg-1ubuntu1) ... 82s Selecting previously unselected package libsmbclient0:arm64. 82s Preparing to unpack .../37-libsmbclient0_2%3a4.23.4+dfsg-1ubuntu1_arm64.deb ... 82s Unpacking libsmbclient0:arm64 (2:4.23.4+dfsg-1ubuntu1) ... 82s Selecting previously unselected package smbclient. 82s Preparing to unpack .../38-smbclient_2%3a4.23.4+dfsg-1ubuntu1_arm64.deb ... 82s Unpacking smbclient (2:4.23.4+dfsg-1ubuntu1) ... 82s Setting up libarchive-zip-perl (1.68-1) ... 82s Setting up libtdb1:arm64 (2:1.4.14+samba4.23.4+dfsg-1ubuntu1) ... 82s Setting up libhtml-tagset-perl (3.24-1) ... 82s Setting up samba-common (2:4.23.4+dfsg-1ubuntu1) ... 82s Creating config file /etc/samba/smb.conf with new version 82s Setting up libwbclient0:arm64 (2:4.23.4+dfsg-1ubuntu1) ... 82s Setting up libtalloc2:arm64 (2:2.4.3+samba4.23.4+dfsg-1ubuntu1) ... 82s Setting up backuppc-rsync (3.1.3.0-5) ... 82s Setting up libavahi-common-data:arm64 (0.8-17ubuntu2) ... 82s Setting up libtimedate-perl (2.3300-2) ... 82s Setting up libtime-parsedate-perl (2015.103-5) ... 82s Setting up libapr1t64:arm64 (1.7.6-3) ... 82s Setting up libnsl2:arm64 (1.3.0-3build4) ... 82s Setting up liblua5.4-0:arm64 (5.4.8-1) ... 82s Setting up apache2-data (2.4.65-3ubuntu1) ... 82s Setting up liburing2:arm64 (2.11-1) ... 82s Setting up libbackuppc-xs-perl:arm64 (0.62-2build6) ... 82s Setting up liburi-perl (5.34-2build1) ... 82s Setting up libtevent0t64:arm64 (2:0.17.1+samba4.23.4+dfsg-1ubuntu1) ... 82s Setting up libaprutil1t64:arm64 (1.6.3-3ubuntu3) ... 82s Setting up libhttp-date-perl (6.06-1) ... 82s Setting up libfile-listing-perl (6.16-1) ... 82s Setting up libavahi-common3:arm64 (0.8-17ubuntu2) ... 82s Setting up libaprutil1-ldap:arm64 (1.6.3-3ubuntu3) ... 82s Setting up libaprutil1-dbd-sqlite3:arm64 (1.6.3-3ubuntu3) ... 82s Setting up postfix (3.10.6-1ubuntu1) ... 83s Created symlink '/etc/systemd/system/multi-user.target.wants/postfix.service' → '/usr/lib/systemd/system/postfix.service'. 83s Creating /etc/postfix/dynamicmaps.cf 83s setting myhostname: autopkgtest.local 83s setting alias maps 83s setting alias database 83s changing /etc/mailname to autopkgtest.local 83s setting myorigin 83s setting destinations: $myhostname, autopkgtest.local, localhost.local, , localhost 83s setting relayhost: 83s setting mynetworks: 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128 83s clearing mailbox_command 83s setting mailbox_size_limit: 0 83s setting recipient_delimiter: + 86s setting inet_interfaces: all 87s setting inet_protocols: all 87s /etc/aliases does not exist, creating it. 87s WARNING: /etc/aliases exists, but does not have a root alias. 87s 87s Postfix (main.cf) is now set up with a default configuration. If you need to 87s make changes, edit /etc/postfix/main.cf (and others) as needed. To view 87s Postfix configuration values, see postconf(1). 87s 87s After modifying main.cf, be sure to run 'systemctl reload postfix'. 87s 90s Setting up libhtml-parser-perl:arm64 (3.83-1build1) ... 90s Setting up libldb2:arm64 (2:2.11.0+samba4.23.4+dfsg-1ubuntu1) ... 90s Setting up libavahi-client3:arm64 (0.8-17ubuntu2) ... 90s Setting up apache2-utils (2.4.65-3ubuntu1) ... 90s Setting up libcgi-pm-perl (4.71-1build1) ... 90s Setting up samba-libs:arm64 (2:4.23.4+dfsg-1ubuntu1) ... 90s Setting up apache2-bin (2.4.65-3ubuntu1) ... 90s Setting up libsmbclient0:arm64 (2:4.23.4+dfsg-1ubuntu1) ... 90s Setting up libcups2t64:arm64 (2.4.16-1ubuntu1) ... 90s Setting up apache2 (2.4.65-3ubuntu1) ... 90s Enabling module mpm_event. 90s Enabling module authz_core. 90s Enabling module authz_host. 90s Enabling module authn_core. 90s Enabling module auth_basic. 90s Enabling module access_compat. 90s Enabling module authn_file. 90s Enabling module authz_user. 90s Enabling module alias. 90s Enabling module dir. 90s Enabling module autoindex. 90s Enabling module env. 90s Enabling module mime. 90s Enabling module negotiation. 90s Enabling module setenvif. 90s Enabling module filter. 90s Enabling module deflate. 90s Enabling module status. 90s Enabling module reqtimeout. 90s Enabling conf charset. 90s Enabling conf localized-error-pages. 91s Enabling conf other-vhosts-access-log. 91s Enabling conf security. 91s Enabling conf serve-cgi-bin. 91s Enabling site 000-default. 91s Created symlink '/etc/systemd/system/multi-user.target.wants/apache2.service' → '/usr/lib/systemd/system/apache2.service'. 92s Created symlink '/etc/systemd/system/multi-user.target.wants/apache-htcacheclean.service' → '/usr/lib/systemd/system/apache-htcacheclean.service'. 93s Setting up backuppc (4.4.0-11) ... 93s 93s apache2_invoke: Enable configuration backuppc.conf 93s Adding password for user backuppc 93s Considering dependency authn_core for auth_basic: 93s Module authn_core already enabled 93s Module auth_basic already enabled 93s Considering dependency authz_core for authz_groupfile: 93s Module authz_core already enabled 93s Enabling module authz_groupfile. 93s To activate the new configuration, you need to run: 93s systemctl restart apache2 93s Module authn_file already enabled 93s Considering dependency authz_core for authz_user: 93s Module authz_core already enabled 93s Module authz_user already enabled 93s Your MPM seems to be threaded. Selecting cgid instead of cgi. 93s Enabling module cgid. 93s To activate the new configuration, you need to run: 93s systemctl restart apache2 94s Creating config file /etc/backuppc/config.pl with new version 94s Created symlink '/etc/systemd/system/multi-user.target.wants/backuppc.service' → '/usr/lib/systemd/system/backuppc.service'. 94s Setting up smbclient (2:4.23.4+dfsg-1ubuntu1) ... 94s Setting up samba-common-bin (2:4.23.4+dfsg-1ubuntu1) ... 94s Setting up samba (2:4.23.4+dfsg-1ubuntu1) ... 95s Created symlink '/etc/systemd/system/smb.service' → '/usr/lib/systemd/system/smbd.service'. 95s Created symlink '/etc/systemd/system/multi-user.target.wants/smbd.service' → '/usr/lib/systemd/system/smbd.service'. 96s Created symlink '/etc/systemd/system/nmb.service' → '/usr/lib/systemd/system/nmbd.service'. 96s Created symlink '/etc/systemd/system/multi-user.target.wants/nmbd.service' → '/usr/lib/systemd/system/nmbd.service'. 96s Processing triggers for rsyslog (8.2512.0-1ubuntu2) ... 96s Processing triggers for ufw (0.36.2-9build1) ... 96s Processing triggers for man-db (2.13.1-1) ... 97s Processing triggers for libc-bin (2.42-2ubuntu4) ... 97s Processing triggers for postfix (3.10.6-1ubuntu1) ... 97s Restarting postfix 99s autopkgtest [05:57:15]: test smb-backup: [----------------------- 99s net.ipv4.ping_group_range = 0 1000 99s Populating share path 99s Adding samba share 99s Adding [public] share 99s Configuring backuppc 99s Performing a full backup 99s Backup type: type = full, needs_full = 1, needs_incr = 1, lastFullTime = 0, opts{f} = 1, opts{i} = , opts{F} = 99s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 99s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 99s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.020 99s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.0.z created 2026-01-30 05:57:16 99s Backup prep: type = full, case = 1, inPlace = 1, doDuplicate = 0, newBkupNum = 0, newBkupIdx = 0, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = ) 99s __bpc_progress_state__ backup share "public" 99s Running: /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -Tc - 99s full backup started for share public 99s started full dump, share=public 99s Xfer PIDs are now 4086,4085 99s xferPids 4086,4085 99s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -Tc - 99s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 1 99s tarmode is now full, system, hidden, noreset, noverbose 99s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 99s __bpc_progress_fileCnt__ 0 99s new 644 0/0 480434 tmp.UUEOCa 99s new 644 0/0 480434 tmp.rJAEax 99s new 644 0/0 480434 tmp.1W3jrI 99s new 644 0/0 480434 tmp.OSNUpG 99s new 644 0/0 480434 tmp.7Z3rHp 99s new 644 0/0 480434 tmp.kNDjQE 99s new 644 0/0 480434 tmp.1Z9DtQ 99s new 644 0/0 480434 tmp.StmuJH 99s new 644 0/0 480434 tmp.JirJoF 99s tar: dumped 10 files and 0 directories 99s Total bytes written: 4804340 (34.3 MiB/s) 99s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 99s new 644 0/0 480434 tmp.IRpZ20 100s __bpc_progress_fileCnt__ 10 100s tarExtract: Done: 0 errors, 0 filesExist, 0 sizeExist, 0 sizeExistComp, 10 filesTotal, 4804340 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377835 sizeNewComp, 13 inodeLast 100s Xfer PIDs are now 100s xferPids 100s full backup 0 complete, 10 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 100s BackupExpire: cntFull = 1, cntIncr = 0, firstFull = 0, firstIncr = , oldestIncr = 0, oldestFull = 0 100s __bpc_progress_state__ fsck 100s Running BackupPC_refCountUpdate -h localhost on localhost 100s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 100s Xfer PIDs are now 4092 100s xferPids 4092 100s BackupPC_refCountUpdate: doing fsck on localhost #0 (full) since $ConfRefCntFsck == 1 100s __bpc_progress_state__ refCnt #0 100s __bpc_progress_state__ cntUpdate #0 100s __bpc_progress_state__ rename #0 100s __bpc_progress_state__ sumUpdate 100s __bpc_progress_fileCnt__ 0/128 100s __bpc_progress_fileCnt__ 8/128 100s __bpc_progress_fileCnt__ 16/128 100s __bpc_progress_fileCnt__ 24/128 100s __bpc_progress_fileCnt__ 32/128 100s __bpc_progress_fileCnt__ 40/128 100s __bpc_progress_fileCnt__ 48/128 100s __bpc_progress_fileCnt__ 56/128 100s __bpc_progress_fileCnt__ 64/128 100s __bpc_progress_fileCnt__ 72/128 100s __bpc_progress_fileCnt__ 80/128 100s __bpc_progress_fileCnt__ 88/128 100s __bpc_progress_fileCnt__ 96/128 100s __bpc_progress_fileCnt__ 104/128 100s __bpc_progress_fileCnt__ 112/128 100s __bpc_progress_fileCnt__ 120/128 100s __bpc_progress_state__ rename total 100s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 100s Xfer PIDs are now 100s xferPids 100s Finished BackupPC_refCountUpdate (running time: 0 sec) 100s Xfer PIDs are now 100s xferPids 100s full backup complete 100s OK: Full backup succeeded 100s Changing share content and performing an incremental backup 100s Backup type: type = incr, needs_full = , needs_incr = , lastFullTime = 1769752636, opts{f} = , opts{i} = 1, opts{F} = 100s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 100s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 100s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.019 100s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.1.z created 2026-01-30 05:57:16 100s Backup prep: type = incr, case = 3, inPlace = 1, doDuplicate = 1, newBkupNum = 1, newBkupIdx = 1, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = ) 100s Executing /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 100s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 100s Xfer PIDs are now 4163 100s xferPids 4163 100s __bpc_progress_state__ copy #0 -> #1 100s Copying backup #0 to #1 100s __bpc_progress_fileCnt__ 3 dirs 100s Xfer PIDs are now 4163,4166 100s xferPids 4163,4166 100s __bpc_progress_state__ sumUpdate 100s __bpc_progress_fileCnt__ 0/128 100s __bpc_progress_fileCnt__ 8/128 100s __bpc_progress_fileCnt__ 16/128 100s __bpc_progress_fileCnt__ 24/128 100s __bpc_progress_fileCnt__ 32/128 100s __bpc_progress_fileCnt__ 40/128 100s __bpc_progress_fileCnt__ 48/128 100s __bpc_progress_fileCnt__ 56/128 100s __bpc_progress_fileCnt__ 64/128 100s __bpc_progress_fileCnt__ 72/128 100s __bpc_progress_fileCnt__ 80/128 100s __bpc_progress_fileCnt__ 88/128 100s __bpc_progress_fileCnt__ 96/128 100s __bpc_progress_fileCnt__ 104/128 100s __bpc_progress_fileCnt__ 112/128 100s __bpc_progress_fileCnt__ 120/128 100s __bpc_progress_state__ rename total 100s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 100s Xfer PIDs are now 4163 100s xferPids 4163 100s BackupPC_backupDuplicate: got 0 errors and 0 file open errors 100s Finished BackupPC_backupDuplicate (running time: 0 sec) 100s __bpc_progress_state__ backup share "public" 100s Running: /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 100s incr backup started back to 2026-01-30 04:57:16 (backup #0) for share public 100s started incr dump, share=public 100s Xfer PIDs are now 4170,4169 100s xferPids 4170,4169 100s 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 - 100s tar:1306 Getting files newer than Fri Jan 30 04:57:16 2026 100s tarmode is now full, system, hidden, noreset, noverbose 100s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 100s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 100s __bpc_progress_fileCnt__ 0 100s new 644 0/0 480434 tmp.3LqYcL 100s new 644 0/0 480434 tmp.cJScIz 100s same 644 0/0 480434 tmp.UUEOCa 100s same 644 0/0 480434 tmp.rJAEax 100s same 644 0/0 480434 tmp.1W3jrI 100s new 644 0/0 480434 tmp.4wG590 100s same 644 0/0 480434 tmp.OSNUpG 100s new 644 0/0 480434 tmp.I7CSUi 100s same 644 0/0 480434 tmp.7Z3rHp 100s new 644 0/0 480434 tmp.b9Vcas 100s new 644 0/0 480434 tmp.xpIOoJ 100s new 644 0/0 480434 tmp.hEQsxd 100s same 644 0/0 480434 tmp.kNDjQE 100s new 644 0/0 480434 tmp.pm8t99 100s new 644 0/0 480434 tmp.qXbFaA 100s same 644 0/0 480434 tmp.1Z9DtQ 100s same 644 0/0 480434 tmp.StmuJH 100s new 644 0/0 480434 tmp.E7b60J 100s same 644 0/0 480434 tmp.JirJoF 100s tar: dumped 20 files and 0 directories 100s Total bytes written: 9608680 (51.2 MiB/s) 100s same 644 0/0 480434 tmp.IRpZ20 100s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 100s __bpc_progress_fileCnt__ 20 100s tarExtract: Done: 0 errors, 10 filesExist, 4804340 sizeExist, 1377835 sizeExistComp, 20 filesTotal, 9608680 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377861 sizeNewComp, 24 inodeLast 100s Xfer PIDs are now 100s xferPids 100s incr backup 1 complete, 20 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 100s BackupExpire: cntFull = 2, cntIncr = 0, firstFull = 0, firstIncr = , oldestIncr = 0, oldestFull = 1.15740740740741e-05 100s __bpc_progress_state__ fsck 100s Running BackupPC_refCountUpdate -h localhost on localhost 100s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 100s Xfer PIDs are now 4176 100s xferPids 4176 100s __bpc_progress_state__ cntUpdate #1 100s __bpc_progress_state__ rename #1 100s __bpc_progress_state__ sumUpdate 100s __bpc_progress_fileCnt__ 0/128 100s __bpc_progress_fileCnt__ 8/128 100s __bpc_progress_fileCnt__ 16/128 100s __bpc_progress_fileCnt__ 24/128 100s __bpc_progress_fileCnt__ 32/128 100s __bpc_progress_fileCnt__ 40/128 100s __bpc_progress_fileCnt__ 48/128 100s __bpc_progress_fileCnt__ 56/128 100s __bpc_progress_fileCnt__ 64/128 100s __bpc_progress_fileCnt__ 72/128 100s __bpc_progress_fileCnt__ 80/128 100s __bpc_progress_fileCnt__ 88/128 100s __bpc_progress_fileCnt__ 96/128 100s __bpc_progress_fileCnt__ 104/128 100s __bpc_progress_fileCnt__ 112/128 100s __bpc_progress_fileCnt__ 120/128 100s __bpc_progress_state__ rename total 100s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 100s Xfer PIDs are now 100s xferPids 100s Finished BackupPC_refCountUpdate (running time: 0 sec) 100s Xfer PIDs are now 100s xferPids 100s incr backup complete 100s OK: Incremental backup succeeded 100s Done. 101s autopkgtest [05:57:17]: test smb-backup: -----------------------] 101s smb-backup PASS 101s autopkgtest [05:57:17]: test smb-backup: - - - - - - - - - - results - - - - - - - - - - 102s autopkgtest [05:57:18]: test authenticated-smb-backup: preparing testbed 102s Reading package lists... 102s Building dependency tree... 102s Reading state information... 102s Solving dependencies... 103s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 103s autopkgtest [05:57:19]: test authenticated-smb-backup: [----------------------- 104s Populating share path 104s Adding samba share 104s Adding [private] share 104s Creating user 104s Creating a local and samba user called smbtest4358 104s Setting samba password for the smbtest4358 user 104s Added user smbtest4358. 104s Configuring backuppc 104s Performing a full backup 104s Backup type: type = full, needs_full = , needs_incr = , lastFullTime = 1769752636, opts{f} = 1, opts{i} = , opts{F} = 104s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 104s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 104s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.020 104s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.2.z created 2026-01-30 05:57:20 104s Backup prep: type = full, case = 4, inPlace = 0, doDuplicate = 0, newBkupNum = 2, newBkupIdx = 2, lastBkupNum = 1, lastBkupIdx = 1 (FillCycle = 0, noFillCnt = 0) 104s __bpc_progress_state__ backup share "private" 104s Running: /usr/bin/smbclient \\\\localhost\\private -U smbtest4358 -E -d 1 -c tarmode\ full -mSMB3 -Tc - 104s full backup started for share private 104s started full dump, share=private 104s Xfer PIDs are now 4450,4449 104s xferPids 4450,4449 104s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\private -U smbtest4358 -E -d 1 -c tarmode\ full -mSMB3 -Tc - 104s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 1 104s tarmode is now full, system, hidden, noreset, noverbose 104s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 104s __bpc_progress_fileCnt__ 0 104s new 644 0/0 480434 tmp.cgXDNw 104s new 644 0/0 480434 tmp.W9cdmN 104s new 644 0/0 480434 tmp.FcpzHc 104s new 644 0/0 480434 tmp.MOoda4 104s new 644 0/0 480434 tmp.4GBaPU 104s new 644 0/0 480434 tmp.5MGg3s 104s new 644 0/0 480434 tmp.6zP3CU 104s new 644 0/0 480434 tmp.Rd9Wd8 104s new 644 0/0 480434 tmp.kKAKKB 104s tar: dumped 10 files and 0 directories 104s Total bytes written: 4804340 (36.6 MiB/s) 104s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 104s new 644 0/0 480434 tmp.1v5PjI 104s __bpc_progress_fileCnt__ 10 104s tarExtract: Done: 0 errors, 0 filesExist, 0 sizeExist, 0 sizeExistComp, 10 filesTotal, 4804340 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377839 sizeNewComp, 36 inodeLast 104s Xfer PIDs are now 104s xferPids 104s OrphanShareNameClean: removing orphan share public from /var/lib/backuppc/pc/localhost/2 104s __bpc_progress_state__ delete share #2/public 104s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDelete -h localhost -n 2 -l -m -s public / 104s Xfer PIDs are now 4457 104s xferPids 4457 104s BackupPC_backupDelete: removing #2/public/ 104s __bpc_progress_state__ merge #2/public/ -> #1/public/ 104s BackupPC_backupDelete: Merge into backup 1/public/ 104s mergeDir: attr write to /var/lib/backuppc/pc/localhost/1/fpublic//attrib failed (digest was ) 104s bpc_attrib_dirWrite: can't open/create raw /var/lib/backuppc/pc/localhost/1/fpublic for writing 104s Xfer PIDs are now 4457,4460 104s xferPids 4457,4460 104s __bpc_progress_state__ refCnt #1 104s __bpc_progress_state__ cntUpdate #1 104s __bpc_progress_state__ rename #1 104s __bpc_progress_state__ refCnt #2 104s BackupPC_refCountUpdate: localhost #2 inodeLast set to 37 (was 24) 104s __bpc_progress_state__ cntUpdate #2 104s __bpc_progress_state__ rename #2 104s __bpc_progress_state__ sumUpdate 104s __bpc_progress_fileCnt__ 0/128 104s __bpc_progress_fileCnt__ 8/128 104s __bpc_progress_fileCnt__ 16/128 104s __bpc_progress_fileCnt__ 24/128 104s __bpc_progress_fileCnt__ 32/128 104s __bpc_progress_fileCnt__ 40/128 104s __bpc_progress_fileCnt__ 48/128 104s __bpc_progress_fileCnt__ 56/128 104s __bpc_progress_fileCnt__ 64/128 104s __bpc_progress_fileCnt__ 72/128 104s __bpc_progress_fileCnt__ 80/128 104s __bpc_progress_fileCnt__ 88/128 104s __bpc_progress_fileCnt__ 96/128 104s __bpc_progress_fileCnt__ 104/128 104s __bpc_progress_fileCnt__ 112/128 104s __bpc_progress_fileCnt__ 120/128 104s __bpc_progress_state__ rename total 104s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 104s Xfer PIDs are now 4457 104s xferPids 4457 104s Xfer PIDs are now 104s xferPids 104s Finished BackupPC_backupDelete, status = 0 (running time: 0 sec) 104s Xfer PIDs are now 104s xferPids 104s full backup 2 complete, 10 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 104s BackupExpire: cntFull = 2, cntIncr = 1, firstFull = 0, firstIncr = 1, oldestIncr = 5.78703703703704e-05, oldestFull = 5.78703703703704e-05 104s __bpc_progress_state__ fsck 104s Running BackupPC_refCountUpdate -h localhost on localhost 104s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 105s Xfer PIDs are now 4463 105s xferPids 4463 105s BackupPC_refCountUpdate: doing fsck on localhost #2 (full) since $ConfRefCntFsck == 1 105s __bpc_progress_state__ refCnt #2 105s __bpc_progress_state__ cntUpdate #2 105s __bpc_progress_state__ rename #2 105s __bpc_progress_state__ sumUpdate 105s __bpc_progress_fileCnt__ 0/128 105s __bpc_progress_fileCnt__ 8/128 105s __bpc_progress_fileCnt__ 16/128 105s __bpc_progress_fileCnt__ 24/128 105s __bpc_progress_fileCnt__ 32/128 105s __bpc_progress_fileCnt__ 40/128 105s __bpc_progress_fileCnt__ 48/128 105s __bpc_progress_fileCnt__ 56/128 105s __bpc_progress_fileCnt__ 64/128 105s __bpc_progress_fileCnt__ 72/128 105s __bpc_progress_fileCnt__ 80/128 105s __bpc_progress_fileCnt__ 88/128 105s __bpc_progress_fileCnt__ 96/128 105s __bpc_progress_fileCnt__ 104/128 105s __bpc_progress_fileCnt__ 112/128 105s __bpc_progress_fileCnt__ 120/128 105s __bpc_progress_state__ rename total 105s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 105s Xfer PIDs are now 105s xferPids 105s Finished BackupPC_refCountUpdate (running time: 0 sec) 105s Xfer PIDs are now 105s xferPids 105s full backup complete 105s OK: Full backup succeeded 105s Changing share content and performing an incremental backup 105s Backup type: type = incr, needs_full = , needs_incr = , lastFullTime = 1769752640, opts{f} = , opts{i} = 1, opts{F} = 105s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 105s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 105s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.016 105s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.3.z created 2026-01-30 05:57:21 105s Backup prep: type = incr, case = 3, inPlace = 1, doDuplicate = 1, newBkupNum = 3, newBkupIdx = 3, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = 1) 105s Executing /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 105s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 105s Xfer PIDs are now 4535 105s xferPids 4535 105s __bpc_progress_state__ copy #2 -> #3 105s Copying backup #2 to #3 105s __bpc_progress_fileCnt__ 3 dirs 105s Xfer PIDs are now 4538,4535 105s xferPids 4538,4535 105s __bpc_progress_state__ sumUpdate 105s __bpc_progress_fileCnt__ 0/128 105s __bpc_progress_fileCnt__ 8/128 105s __bpc_progress_fileCnt__ 16/128 105s __bpc_progress_fileCnt__ 24/128 105s __bpc_progress_fileCnt__ 32/128 105s __bpc_progress_fileCnt__ 40/128 105s __bpc_progress_fileCnt__ 48/128 105s __bpc_progress_fileCnt__ 56/128 105s __bpc_progress_fileCnt__ 64/128 105s __bpc_progress_fileCnt__ 72/128 105s __bpc_progress_fileCnt__ 80/128 105s __bpc_progress_fileCnt__ 88/128 105s __bpc_progress_fileCnt__ 96/128 105s __bpc_progress_fileCnt__ 104/128 105s __bpc_progress_fileCnt__ 112/128 105s __bpc_progress_fileCnt__ 120/128 105s __bpc_progress_state__ rename total 105s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 105s Xfer PIDs are now 4535 105s xferPids 4535 105s BackupPC_backupDuplicate: got 0 errors and 0 file open errors 105s Finished BackupPC_backupDuplicate (running time: 0 sec) 105s __bpc_progress_state__ backup share "private" 105s Running: /usr/bin/smbclient \\\\localhost\\private -U smbtest4358 -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 105s incr backup started back to 2026-01-30 04:57:20 (backup #2) for share private 105s started incr dump, share=private 105s Xfer PIDs are now 4542,4541 105s xferPids 4542,4541 105s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\private -U smbtest4358 -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 105s tar:1306 Getting files newer than Fri Jan 30 04:57:20 2026 105s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 105s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 105s tarmode is now full, system, hidden, noreset, noverbose 105s __bpc_progress_fileCnt__ 0 105s new 644 0/0 480434 tmp.xPaxcP 105s new 644 0/0 480434 tmp.BmlwLM 105s same 644 0/0 480434 tmp.cgXDNw 105s new 644 0/0 480434 tmp.WGVOyS 105s same 644 0/0 480434 tmp.W9cdmN 105s same 644 0/0 480434 tmp.FcpzHc 105s new 644 0/0 480434 tmp.aJJJU8 105s new 644 0/0 480434 tmp.XBhovl 105s same 644 0/0 480434 tmp.MOoda4 105s same 644 0/0 480434 tmp.4GBaPU 105s same 644 0/0 480434 tmp.5MGg3s 105s new 644 0/0 480434 tmp.g13H2I 105s same 644 0/0 480434 tmp.6zP3CU 105s new 644 0/0 480434 tmp.vLGNll 105s new 644 0/0 480434 tmp.t9RmME 105s same 644 0/0 480434 tmp.Rd9Wd8 105s same 644 0/0 480434 tmp.kKAKKB 105s new 644 0/0 480434 tmp.RjcW03 105s new 644 0/0 480434 tmp.Vw0Pir 105s tar: dumped 20 files and 0 directories 105s Total bytes written: 9608680 (55.2 MiB/s) 105s same 644 0/0 480434 tmp.1v5PjI 105s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 105s __bpc_progress_fileCnt__ 20 105s tarExtract: Done: 0 errors, 10 filesExist, 4804340 sizeExist, 1377839 sizeExistComp, 20 filesTotal, 9608680 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377844 sizeNewComp, 47 inodeLast 105s Xfer PIDs are now 105s xferPids 105s incr backup 3 complete, 20 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 105s BackupExpire: cntFull = 3, cntIncr = 1, firstFull = 0, firstIncr = 1, oldestIncr = 6.94444444444444e-05, oldestFull = 6.94444444444444e-05 105s __bpc_progress_state__ fsck 105s Running BackupPC_refCountUpdate -h localhost on localhost 105s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 105s Xfer PIDs are now 4549 105s xferPids 4549 105s __bpc_progress_state__ cntUpdate #3 105s __bpc_progress_state__ rename #3 105s __bpc_progress_state__ sumUpdate 105s __bpc_progress_fileCnt__ 0/128 105s __bpc_progress_fileCnt__ 8/128 105s __bpc_progress_fileCnt__ 16/128 105s __bpc_progress_fileCnt__ 24/128 105s __bpc_progress_fileCnt__ 32/128 105s __bpc_progress_fileCnt__ 40/128 105s __bpc_progress_fileCnt__ 48/128 105s __bpc_progress_fileCnt__ 56/128 105s __bpc_progress_fileCnt__ 64/128 105s __bpc_progress_fileCnt__ 72/128 105s __bpc_progress_fileCnt__ 80/128 105s __bpc_progress_fileCnt__ 88/128 105s __bpc_progress_fileCnt__ 96/128 105s __bpc_progress_fileCnt__ 104/128 105s __bpc_progress_fileCnt__ 112/128 105s __bpc_progress_fileCnt__ 120/128 105s __bpc_progress_state__ rename total 105s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 105s Xfer PIDs are now 105s xferPids 105s Finished BackupPC_refCountUpdate (running time: 0 sec) 105s Xfer PIDs are now 105s xferPids 105s incr backup complete 105s OK: Incremental backup succeeded 105s Done. 105s Deleted user smbtest4358. 105s userdel: smbtest4358 mail spool (/var/mail/smbtest4358) not found 106s autopkgtest [05:57:22]: test authenticated-smb-backup: -----------------------] 106s authenticated-smb-backup PASS 106s autopkgtest [05:57:22]: test authenticated-smb-backup: - - - - - - - - - - results - - - - - - - - - - 107s autopkgtest [05:57:23]: @@@@@@@@@@@@@@@@@@@@ summary 107s smb-backup PASS 107s authenticated-smb-backup PASS