0s autopkgtest [02:21:37]: starting date and time: 2026-01-31 02:21:37+0000 0s autopkgtest [02:21:37]: git checkout: 4b346b80 nova: make wait_reboot return success even when a no-op 0s autopkgtest [02:21:37]: host juju-7f2275-prod-proposed-migration-environment-20; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.hddvumoq/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-amd64 --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-20@sto01-10.secgroup --name adt-resolute-amd64-backuppc-20260131-022137-juju-7f2275-prod-proposed-migration-environment-20-406d665b-f57b-4227-87e4-361a572172b4 --image adt/ubuntu-resolute-amd64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-20 --net-id=net_prod-autopkgtest-workers-amd64 -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 4s Creating nova instance adt-resolute-amd64-backuppc-20260131-022137-juju-7f2275-prod-proposed-migration-environment-20-406d665b-f57b-4227-87e4-361a572172b4 from image adt/ubuntu-resolute-amd64-server-20260130.img (UUID afba56f8-6ab4-44eb-9e07-036bcbd7054f)... 72s autopkgtest [02:22:49]: testbed dpkg architecture: amd64 73s autopkgtest [02:22:50]: testbed apt version: 3.1.14 73s autopkgtest [02:22:50]: @@@@@@@@@@@@@@@@@@@@ test bed setup 73s autopkgtest [02:22:50]: testbed release detected to be: None 74s autopkgtest [02:22:51]: updating testbed package index (apt update) 74s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease [124 kB] 74s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 74s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 74s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 74s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse Sources [28.0 kB] 74s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/restricted Sources [4676 B] 74s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/universe Sources [1193 kB] 75s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/main Sources [106 kB] 75s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main i386 Packages [101 kB] 75s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 Packages [118 kB] 75s Get:11 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 c-n-f Metadata [4164 B] 75s Get:12 http://ftpmaster.internal/ubuntu resolute-proposed/restricted i386 Packages [6164 B] 75s Get:13 http://ftpmaster.internal/ubuntu resolute-proposed/restricted amd64 Packages [20.9 kB] 75s Get:14 http://ftpmaster.internal/ubuntu resolute-proposed/restricted amd64 c-n-f Metadata [388 B] 75s Get:15 http://ftpmaster.internal/ubuntu resolute-proposed/universe amd64 Packages [973 kB] 76s Get:16 http://ftpmaster.internal/ubuntu resolute-proposed/universe i386 Packages [395 kB] 76s Get:17 http://ftpmaster.internal/ubuntu resolute-proposed/universe amd64 c-n-f Metadata [25.3 kB] 76s Get:18 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse amd64 Packages [24.6 kB] 76s Get:19 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse i386 Packages [4200 B] 76s Get:20 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse amd64 c-n-f Metadata [1060 B] 76s Fetched 3130 kB in 2s (1991 kB/s) 76s Reading package lists... 77s Hit:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease 77s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 77s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 77s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 78s Reading package lists... 78s Reading package lists... 78s Building dependency tree... 78s Reading state information... 78s Calculating upgrade... 78s The following packages will be upgraded: 78s 3cpio bzip2 inetutils-telnet libbz2-1.0 libsqlite3-0 rng-tools-debian telnet 78s 7 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 78s Need to get 1234 kB of archives. 78s After this operation, 18.4 kB disk space will be freed. 78s Get:1 http://ftpmaster.internal/ubuntu resolute/universe amd64 rng-tools-debian amd64 2.6build1 [46.1 kB] 78s Get:2 http://ftpmaster.internal/ubuntu resolute/main amd64 bzip2 amd64 1.0.8-6build2 [34.3 kB] 78s Get:3 http://ftpmaster.internal/ubuntu resolute/main amd64 libbz2-1.0 amd64 1.0.8-6build2 [37.0 kB] 78s Get:4 http://ftpmaster.internal/ubuntu resolute/main amd64 libsqlite3-0 amd64 3.46.1-9 [722 kB] 78s Get:5 http://ftpmaster.internal/ubuntu resolute/main amd64 inetutils-telnet amd64 2:2.7-2ubuntu1 [107 kB] 78s Get:6 http://ftpmaster.internal/ubuntu resolute/main amd64 telnet all 0.17+2.7-2ubuntu1 [3636 B] 78s Get:7 http://ftpmaster.internal/ubuntu resolute/main amd64 3cpio amd64 0.13.1-1ubuntu1 [284 kB] 78s dpkg-preconfigure: unable to re-open stdin: No such file or directory 78s Fetched 1234 kB in 0s (5347 kB/s) 79s (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 ... 124211 files and directories currently installed.) 79s Preparing to unpack .../rng-tools-debian_2.6build1_amd64.deb ... 79s Unpacking rng-tools-debian (2.6build1) over (2.6) ... 79s Preparing to unpack .../bzip2_1.0.8-6build2_amd64.deb ... 79s Unpacking bzip2 (1.0.8-6build2) over (1.0.8-6build1) ... 79s Preparing to unpack .../libbz2-1.0_1.0.8-6build2_amd64.deb ... 79s Unpacking libbz2-1.0:amd64 (1.0.8-6build2) over (1.0.8-6build1) ... 79s Setting up libbz2-1.0:amd64 (1.0.8-6build2) ... 79s (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 ... 124211 files and directories currently installed.) 79s Preparing to unpack .../libsqlite3-0_3.46.1-9_amd64.deb ... 79s Unpacking libsqlite3-0:amd64 (3.46.1-9) over (3.46.1-8) ... 79s Preparing to unpack .../inetutils-telnet_2%3a2.7-2ubuntu1_amd64.deb ... 79s Unpacking inetutils-telnet (2:2.7-2ubuntu1) over (2:2.6-4ubuntu1) ... 79s Preparing to unpack .../telnet_0.17+2.7-2ubuntu1_all.deb ... 79s Unpacking telnet (0.17+2.7-2ubuntu1) over (0.17+2.6-4ubuntu1) ... 79s Preparing to unpack .../3cpio_0.13.1-1ubuntu1_amd64.deb ... 79s Unpacking 3cpio (0.13.1-1ubuntu1) over (0.12.0-1ubuntu1) ... 79s Setting up 3cpio (0.13.1-1ubuntu1) ... 79s Setting up libsqlite3-0:amd64 (3.46.1-9) ... 79s Setting up inetutils-telnet (2:2.7-2ubuntu1) ... 79s Setting up bzip2 (1.0.8-6build2) ... 79s Setting up rng-tools-debian (2.6build1) ... 80s Setting up telnet (0.17+2.7-2ubuntu1) ... 80s Processing triggers for man-db (2.13.1-1) ... 80s Processing triggers for libc-bin (2.42-2ubuntu4) ... 80s autopkgtest [02:22:57]: upgrading testbed (apt dist-upgrade and autopurge) 80s Reading package lists... 81s Building dependency tree... 81s Reading state information... 81s Calculating upgrade... 81s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 81s Reading package lists... 81s Building dependency tree... 81s Reading state information... 81s Solving dependencies... 81s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 81s autopkgtest [02:22:58]: rebooting testbed after setup commands that affected boot 110s autopkgtest [02:23:27]: testbed running kernel: Linux 6.18.0-9-generic #9-Ubuntu SMP PREEMPT_DYNAMIC Mon Jan 12 16:49:02 UTC 2026 112s autopkgtest [02:23:29]: @@@@@@@@@@@@@@@@@@@@ apt-source backuppc 113s Get:1 http://ftpmaster.internal/ubuntu resolute/main backuppc 4.4.0-11 (dsc) [2169 B] 113s Get:2 http://ftpmaster.internal/ubuntu resolute/main backuppc 4.4.0-11 (tar) [657 kB] 113s Get:3 http://ftpmaster.internal/ubuntu resolute/main backuppc 4.4.0-11 (diff) [37.9 kB] 113s gpgv: Signature made Sun Mar 30 09:20:11 2025 UTC 113s gpgv: using RSA key FDDD0CFF3864277630A2186C9164FA1D17BD5D36 113s gpgv: Can't check signature: No public key 113s dpkg-source: warning: cannot verify inline signature for ./backuppc_4.4.0-11.dsc: no acceptable signature found 113s autopkgtest [02:23:30]: testing package backuppc version 4.4.0-11 113s autopkgtest [02:23:30]: build not needed 114s autopkgtest [02:23:31]: test smb-backup: preparing testbed 115s Reading package lists... 115s Building dependency tree... 115s Reading state information... 115s Solving dependencies... 115s The following NEW packages will be installed: 115s apache2 apache2-bin apache2-data apache2-utils backuppc backuppc-rsync 115s libapr1t64 libaprutil1-dbd-sqlite3 libaprutil1-ldap libaprutil1t64 115s libarchive-zip-perl libavahi-client3 libavahi-common-data libavahi-common3 115s libbackuppc-xs-perl libcgi-pm-perl libcups2t64 libfile-listing-perl 115s libhtml-parser-perl libhtml-tagset-perl libhttp-date-perl libldb2 115s liblua5.4-0 libnsl2 libsmbclient0 libtalloc2 libtdb1 libtevent0t64 115s libtime-parsedate-perl libtimedate-perl liburi-perl liburing2 libwbclient0 115s postfix samba samba-common samba-common-bin samba-libs smbclient 115s 0 upgraded, 39 newly installed, 0 to remove and 0 not upgraded. 115s Need to get 15.6 MB of archives. 115s After this operation, 60.2 MB of additional disk space will be used. 115s Get:1 http://ftpmaster.internal/ubuntu resolute/main amd64 libapr1t64 amd64 1.7.6-3 [109 kB] 115s Get:2 http://ftpmaster.internal/ubuntu resolute/main amd64 libaprutil1t64 amd64 1.6.3-3ubuntu3 [93.8 kB] 115s Get:3 http://ftpmaster.internal/ubuntu resolute/main amd64 libaprutil1-dbd-sqlite3 amd64 1.6.3-3ubuntu3 [11.4 kB] 115s Get:4 http://ftpmaster.internal/ubuntu resolute/main amd64 libaprutil1-ldap amd64 1.6.3-3ubuntu3 [9226 B] 115s Get:5 http://ftpmaster.internal/ubuntu resolute/main amd64 liblua5.4-0 amd64 5.4.8-1 [174 kB] 115s Get:6 http://ftpmaster.internal/ubuntu resolute/main amd64 apache2-bin amd64 2.4.65-3ubuntu1 [1353 kB] 115s Get:7 http://ftpmaster.internal/ubuntu resolute/main amd64 apache2-data all 2.4.65-3ubuntu1 [163 kB] 115s Get:8 http://ftpmaster.internal/ubuntu resolute/main amd64 apache2-utils amd64 2.4.65-3ubuntu1 [100 kB] 115s Get:9 http://ftpmaster.internal/ubuntu resolute/main amd64 apache2 amd64 2.4.65-3ubuntu1 [93.4 kB] 115s Get:10 http://ftpmaster.internal/ubuntu resolute/main amd64 backuppc-rsync amd64 3.1.3.0-5 [258 kB] 115s Get:11 http://ftpmaster.internal/ubuntu resolute/main amd64 libnsl2 amd64 1.3.0-3build4 [41.8 kB] 115s Get:12 http://ftpmaster.internal/ubuntu resolute/main amd64 postfix amd64 3.10.6-4ubuntu1 [1306 kB] 115s Get:13 http://ftpmaster.internal/ubuntu resolute/main amd64 libarchive-zip-perl all 1.68-1 [90.2 kB] 115s Get:14 http://ftpmaster.internal/ubuntu resolute/main amd64 libbackuppc-xs-perl amd64 0.62-2build6 [65.5 kB] 115s Get:15 http://ftpmaster.internal/ubuntu resolute/main amd64 libhtml-tagset-perl all 3.24-1 [14.1 kB] 115s Get:16 http://ftpmaster.internal/ubuntu resolute/main amd64 liburi-perl all 5.34-2build1 [100 kB] 115s Get:17 http://ftpmaster.internal/ubuntu resolute/main amd64 libhtml-parser-perl amd64 3.83-1build1 [86.2 kB] 115s Get:18 http://ftpmaster.internal/ubuntu resolute/main amd64 libcgi-pm-perl all 4.71-1build1 [185 kB] 115s Get:19 http://ftpmaster.internal/ubuntu resolute/main amd64 libtimedate-perl all 2.3300-2 [34.0 kB] 115s Get:20 http://ftpmaster.internal/ubuntu resolute/main amd64 libhttp-date-perl all 6.06-1 [10.2 kB] 115s Get:21 http://ftpmaster.internal/ubuntu resolute/main amd64 libfile-listing-perl all 6.16-1 [11.3 kB] 115s Get:22 http://ftpmaster.internal/ubuntu resolute/main amd64 libtime-parsedate-perl all 2015.103-5 [27.9 kB] 115s Get:23 http://ftpmaster.internal/ubuntu resolute/main amd64 backuppc amd64 4.4.0-11 [518 kB] 115s Get:24 http://ftpmaster.internal/ubuntu resolute/main amd64 samba-common all 2:4.23.4+dfsg-1ubuntu1 [74.4 kB] 115s Get:25 http://ftpmaster.internal/ubuntu resolute/main amd64 libavahi-common-data amd64 0.8-17ubuntu2 [31.5 kB] 115s Get:26 http://ftpmaster.internal/ubuntu resolute/main amd64 libavahi-common3 amd64 0.8-17ubuntu2 [23.7 kB] 115s Get:27 http://ftpmaster.internal/ubuntu resolute/main amd64 libavahi-client3 amd64 0.8-17ubuntu2 [27.3 kB] 115s Get:28 http://ftpmaster.internal/ubuntu resolute/main amd64 libcups2t64 amd64 2.4.16-1ubuntu1 [273 kB] 115s Get:29 http://ftpmaster.internal/ubuntu resolute/main amd64 libtalloc2 amd64 2:2.4.3+samba4.23.4+dfsg-1ubuntu1 [77.8 kB] 115s Get:30 http://ftpmaster.internal/ubuntu resolute/main amd64 libtdb1 amd64 2:1.4.14+samba4.23.4+dfsg-1ubuntu1 [97.2 kB] 115s Get:31 http://ftpmaster.internal/ubuntu resolute/main amd64 libtevent0t64 amd64 2:0.17.1+samba4.23.4+dfsg-1ubuntu1 [42.1 kB] 115s Get:32 http://ftpmaster.internal/ubuntu resolute/main amd64 libldb2 amd64 2:2.11.0+samba4.23.4+dfsg-1ubuntu1 [150 kB] 115s Get:33 http://ftpmaster.internal/ubuntu resolute/main amd64 libwbclient0 amd64 2:4.23.4+dfsg-1ubuntu1 [84.8 kB] 116s Get:34 http://ftpmaster.internal/ubuntu resolute/main amd64 samba-libs amd64 2:4.23.4+dfsg-1ubuntu1 [6648 kB] 116s Get:35 http://ftpmaster.internal/ubuntu resolute/main amd64 samba-common-bin amd64 2:4.23.4+dfsg-1ubuntu1 [1409 kB] 116s Get:36 http://ftpmaster.internal/ubuntu resolute/main amd64 liburing2 amd64 2.11-1 [24.7 kB] 116s Get:37 http://ftpmaster.internal/ubuntu resolute/main amd64 samba amd64 2:4.23.4+dfsg-1ubuntu1 [1237 kB] 116s Get:38 http://ftpmaster.internal/ubuntu resolute/main amd64 libsmbclient0 amd64 2:4.23.4+dfsg-1ubuntu1 [63.6 kB] 116s Get:39 http://ftpmaster.internal/ubuntu resolute/main amd64 smbclient amd64 2:4.23.4+dfsg-1ubuntu1 [480 kB] 116s Preconfiguring packages ... 116s Fetched 15.6 MB in 1s (13.5 MB/s) 116s Selecting previously unselected package libapr1t64:amd64. 116s (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 ... 124211 files and directories currently installed.) 116s Preparing to unpack .../00-libapr1t64_1.7.6-3_amd64.deb ... 116s Unpacking libapr1t64:amd64 (1.7.6-3) ... 116s Selecting previously unselected package libaprutil1t64:amd64. 116s Preparing to unpack .../01-libaprutil1t64_1.6.3-3ubuntu3_amd64.deb ... 116s Unpacking libaprutil1t64:amd64 (1.6.3-3ubuntu3) ... 116s Selecting previously unselected package libaprutil1-dbd-sqlite3:amd64. 116s Preparing to unpack .../02-libaprutil1-dbd-sqlite3_1.6.3-3ubuntu3_amd64.deb ... 116s Unpacking libaprutil1-dbd-sqlite3:amd64 (1.6.3-3ubuntu3) ... 116s Selecting previously unselected package libaprutil1-ldap:amd64. 116s Preparing to unpack .../03-libaprutil1-ldap_1.6.3-3ubuntu3_amd64.deb ... 116s Unpacking libaprutil1-ldap:amd64 (1.6.3-3ubuntu3) ... 116s Selecting previously unselected package liblua5.4-0:amd64. 117s Preparing to unpack .../04-liblua5.4-0_5.4.8-1_amd64.deb ... 117s Unpacking liblua5.4-0:amd64 (5.4.8-1) ... 117s Selecting previously unselected package apache2-bin. 117s Preparing to unpack .../05-apache2-bin_2.4.65-3ubuntu1_amd64.deb ... 117s Unpacking apache2-bin (2.4.65-3ubuntu1) ... 117s Selecting previously unselected package apache2-data. 117s Preparing to unpack .../06-apache2-data_2.4.65-3ubuntu1_all.deb ... 117s Unpacking apache2-data (2.4.65-3ubuntu1) ... 117s Selecting previously unselected package apache2-utils. 117s Preparing to unpack .../07-apache2-utils_2.4.65-3ubuntu1_amd64.deb ... 117s Unpacking apache2-utils (2.4.65-3ubuntu1) ... 117s Selecting previously unselected package apache2. 117s Preparing to unpack .../08-apache2_2.4.65-3ubuntu1_amd64.deb ... 117s Unpacking apache2 (2.4.65-3ubuntu1) ... 117s Selecting previously unselected package backuppc-rsync. 117s Preparing to unpack .../09-backuppc-rsync_3.1.3.0-5_amd64.deb ... 117s Unpacking backuppc-rsync (3.1.3.0-5) ... 117s Selecting previously unselected package libnsl2:amd64. 117s Preparing to unpack .../10-libnsl2_1.3.0-3build4_amd64.deb ... 117s Unpacking libnsl2:amd64 (1.3.0-3build4) ... 117s Selecting previously unselected package postfix. 117s Preparing to unpack .../11-postfix_3.10.6-4ubuntu1_amd64.deb ... 117s Unpacking postfix (3.10.6-4ubuntu1) ... 117s Selecting previously unselected package libarchive-zip-perl. 117s Preparing to unpack .../12-libarchive-zip-perl_1.68-1_all.deb ... 117s Unpacking libarchive-zip-perl (1.68-1) ... 117s Selecting previously unselected package libbackuppc-xs-perl:amd64. 117s Preparing to unpack .../13-libbackuppc-xs-perl_0.62-2build6_amd64.deb ... 117s Unpacking libbackuppc-xs-perl:amd64 (0.62-2build6) ... 117s Selecting previously unselected package libhtml-tagset-perl. 117s Preparing to unpack .../14-libhtml-tagset-perl_3.24-1_all.deb ... 117s Unpacking libhtml-tagset-perl (3.24-1) ... 117s Selecting previously unselected package liburi-perl. 117s Preparing to unpack .../15-liburi-perl_5.34-2build1_all.deb ... 117s Unpacking liburi-perl (5.34-2build1) ... 117s Selecting previously unselected package libhtml-parser-perl:amd64. 117s Preparing to unpack .../16-libhtml-parser-perl_3.83-1build1_amd64.deb ... 117s Unpacking libhtml-parser-perl:amd64 (3.83-1build1) ... 117s Selecting previously unselected package libcgi-pm-perl. 117s Preparing to unpack .../17-libcgi-pm-perl_4.71-1build1_all.deb ... 117s Unpacking libcgi-pm-perl (4.71-1build1) ... 117s Selecting previously unselected package libtimedate-perl. 117s Preparing to unpack .../18-libtimedate-perl_2.3300-2_all.deb ... 117s Unpacking libtimedate-perl (2.3300-2) ... 117s Selecting previously unselected package libhttp-date-perl. 117s Preparing to unpack .../19-libhttp-date-perl_6.06-1_all.deb ... 117s Unpacking libhttp-date-perl (6.06-1) ... 117s Selecting previously unselected package libfile-listing-perl. 117s Preparing to unpack .../20-libfile-listing-perl_6.16-1_all.deb ... 117s Unpacking libfile-listing-perl (6.16-1) ... 117s Selecting previously unselected package libtime-parsedate-perl. 117s Preparing to unpack .../21-libtime-parsedate-perl_2015.103-5_all.deb ... 117s Unpacking libtime-parsedate-perl (2015.103-5) ... 117s Selecting previously unselected package backuppc. 117s Preparing to unpack .../22-backuppc_4.4.0-11_amd64.deb ... 117s Unpacking backuppc (4.4.0-11) ... 117s Selecting previously unselected package samba-common. 117s Preparing to unpack .../23-samba-common_2%3a4.23.4+dfsg-1ubuntu1_all.deb ... 117s Unpacking samba-common (2:4.23.4+dfsg-1ubuntu1) ... 117s Selecting previously unselected package libavahi-common-data:amd64. 117s Preparing to unpack .../24-libavahi-common-data_0.8-17ubuntu2_amd64.deb ... 117s Unpacking libavahi-common-data:amd64 (0.8-17ubuntu2) ... 117s Selecting previously unselected package libavahi-common3:amd64. 117s Preparing to unpack .../25-libavahi-common3_0.8-17ubuntu2_amd64.deb ... 117s Unpacking libavahi-common3:amd64 (0.8-17ubuntu2) ... 117s Selecting previously unselected package libavahi-client3:amd64. 117s Preparing to unpack .../26-libavahi-client3_0.8-17ubuntu2_amd64.deb ... 117s Unpacking libavahi-client3:amd64 (0.8-17ubuntu2) ... 117s Selecting previously unselected package libcups2t64:amd64. 117s Preparing to unpack .../27-libcups2t64_2.4.16-1ubuntu1_amd64.deb ... 117s Unpacking libcups2t64:amd64 (2.4.16-1ubuntu1) ... 117s Selecting previously unselected package libtalloc2:amd64. 117s Preparing to unpack .../28-libtalloc2_2%3a2.4.3+samba4.23.4+dfsg-1ubuntu1_amd64.deb ... 117s Unpacking libtalloc2:amd64 (2:2.4.3+samba4.23.4+dfsg-1ubuntu1) ... 117s Selecting previously unselected package libtdb1:amd64. 117s Preparing to unpack .../29-libtdb1_2%3a1.4.14+samba4.23.4+dfsg-1ubuntu1_amd64.deb ... 117s Unpacking libtdb1:amd64 (2:1.4.14+samba4.23.4+dfsg-1ubuntu1) ... 117s Selecting previously unselected package libtevent0t64:amd64. 117s Preparing to unpack .../30-libtevent0t64_2%3a0.17.1+samba4.23.4+dfsg-1ubuntu1_amd64.deb ... 117s Unpacking libtevent0t64:amd64 (2:0.17.1+samba4.23.4+dfsg-1ubuntu1) ... 117s Selecting previously unselected package libldb2:amd64. 117s Preparing to unpack .../31-libldb2_2%3a2.11.0+samba4.23.4+dfsg-1ubuntu1_amd64.deb ... 117s Unpacking libldb2:amd64 (2:2.11.0+samba4.23.4+dfsg-1ubuntu1) ... 117s Selecting previously unselected package libwbclient0:amd64. 117s Preparing to unpack .../32-libwbclient0_2%3a4.23.4+dfsg-1ubuntu1_amd64.deb ... 117s Unpacking libwbclient0:amd64 (2:4.23.4+dfsg-1ubuntu1) ... 117s Selecting previously unselected package samba-libs:amd64. 117s Preparing to unpack .../33-samba-libs_2%3a4.23.4+dfsg-1ubuntu1_amd64.deb ... 117s Unpacking samba-libs:amd64 (2:4.23.4+dfsg-1ubuntu1) ... 117s Selecting previously unselected package samba-common-bin. 117s Preparing to unpack .../34-samba-common-bin_2%3a4.23.4+dfsg-1ubuntu1_amd64.deb ... 117s Unpacking samba-common-bin (2:4.23.4+dfsg-1ubuntu1) ... 117s Selecting previously unselected package liburing2:amd64. 117s Preparing to unpack .../35-liburing2_2.11-1_amd64.deb ... 117s Unpacking liburing2:amd64 (2.11-1) ... 117s Selecting previously unselected package samba. 117s Preparing to unpack .../36-samba_2%3a4.23.4+dfsg-1ubuntu1_amd64.deb ... 117s Unpacking samba (2:4.23.4+dfsg-1ubuntu1) ... 117s Selecting previously unselected package libsmbclient0:amd64. 117s Preparing to unpack .../37-libsmbclient0_2%3a4.23.4+dfsg-1ubuntu1_amd64.deb ... 117s Unpacking libsmbclient0:amd64 (2:4.23.4+dfsg-1ubuntu1) ... 117s Selecting previously unselected package smbclient. 117s Preparing to unpack .../38-smbclient_2%3a4.23.4+dfsg-1ubuntu1_amd64.deb ... 117s Unpacking smbclient (2:4.23.4+dfsg-1ubuntu1) ... 117s Setting up libarchive-zip-perl (1.68-1) ... 117s Setting up libtdb1:amd64 (2:1.4.14+samba4.23.4+dfsg-1ubuntu1) ... 117s Setting up libhtml-tagset-perl (3.24-1) ... 117s Setting up samba-common (2:4.23.4+dfsg-1ubuntu1) ... 117s Creating config file /etc/samba/smb.conf with new version 117s Setting up libwbclient0:amd64 (2:4.23.4+dfsg-1ubuntu1) ... 117s Setting up libtalloc2:amd64 (2:2.4.3+samba4.23.4+dfsg-1ubuntu1) ... 117s Setting up backuppc-rsync (3.1.3.0-5) ... 117s Setting up libavahi-common-data:amd64 (0.8-17ubuntu2) ... 117s Setting up libtimedate-perl (2.3300-2) ... 117s Setting up libtime-parsedate-perl (2015.103-5) ... 117s Setting up libapr1t64:amd64 (1.7.6-3) ... 117s Setting up libnsl2:amd64 (1.3.0-3build4) ... 117s Setting up liblua5.4-0:amd64 (5.4.8-1) ... 117s Setting up apache2-data (2.4.65-3ubuntu1) ... 117s Setting up liburing2:amd64 (2.11-1) ... 117s Setting up libbackuppc-xs-perl:amd64 (0.62-2build6) ... 117s Setting up liburi-perl (5.34-2build1) ... 117s Setting up libtevent0t64:amd64 (2:0.17.1+samba4.23.4+dfsg-1ubuntu1) ... 117s Setting up libaprutil1t64:amd64 (1.6.3-3ubuntu3) ... 117s Setting up libhttp-date-perl (6.06-1) ... 117s Setting up libfile-listing-perl (6.16-1) ... 117s Setting up libavahi-common3:amd64 (0.8-17ubuntu2) ... 117s Setting up libaprutil1-ldap:amd64 (1.6.3-3ubuntu3) ... 117s Setting up libaprutil1-dbd-sqlite3:amd64 (1.6.3-3ubuntu3) ... 117s Setting up postfix (3.10.6-4ubuntu1) ... 118s Created symlink '/etc/systemd/system/multi-user.target.wants/postfix.service' → '/usr/lib/systemd/system/postfix.service'. 118s Creating /etc/postfix/dynamicmaps.cf 118s setting myhostname: autopkgtest.local 118s setting alias maps 118s setting alias database 118s changing /etc/mailname to autopkgtest.local 118s setting myorigin 118s setting destinations: $myhostname, autopkgtest.local, localhost.local, , localhost 118s setting relayhost: 118s setting mynetworks: 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128 118s clearing mailbox_command 118s setting mailbox_size_limit: 0 118s setting recipient_delimiter: + 119s setting inet_interfaces: all 121s setting inet_protocols: all 121s /etc/aliases does not exist, creating it. 121s WARNING: /etc/aliases exists, but does not have a root alias. 121s 121s Postfix (main.cf) is now set up with a default configuration. If you need to 121s make changes, edit /etc/postfix/main.cf (and others) as needed. To view 121s Postfix configuration values, see postconf(1). 121s 121s After modifying main.cf, be sure to run 'systemctl reload postfix'. 121s 123s Setting up libhtml-parser-perl:amd64 (3.83-1build1) ... 123s Setting up libldb2:amd64 (2:2.11.0+samba4.23.4+dfsg-1ubuntu1) ... 123s Setting up libavahi-client3:amd64 (0.8-17ubuntu2) ... 123s Setting up apache2-utils (2.4.65-3ubuntu1) ... 123s Setting up libcgi-pm-perl (4.71-1build1) ... 123s Setting up samba-libs:amd64 (2:4.23.4+dfsg-1ubuntu1) ... 123s Setting up apache2-bin (2.4.65-3ubuntu1) ... 123s Setting up libsmbclient0:amd64 (2:4.23.4+dfsg-1ubuntu1) ... 123s Setting up libcups2t64:amd64 (2.4.16-1ubuntu1) ... 123s Setting up apache2 (2.4.65-3ubuntu1) ... 123s Enabling module mpm_event. 123s Enabling module authz_core. 123s Enabling module authz_host. 123s Enabling module authn_core. 123s Enabling module auth_basic. 123s Enabling module access_compat. 123s Enabling module authn_file. 123s Enabling module authz_user. 123s Enabling module alias. 124s Enabling module dir. 124s Enabling module autoindex. 124s Enabling module env. 124s Enabling module mime. 124s Enabling module negotiation. 124s Enabling module setenvif. 124s Enabling module filter. 124s Enabling module deflate. 124s Enabling module status. 124s Enabling module reqtimeout. 124s Enabling conf charset. 124s Enabling conf localized-error-pages. 124s Enabling conf other-vhosts-access-log. 124s Enabling conf security. 124s Enabling conf serve-cgi-bin. 124s Enabling site 000-default. 124s Created symlink '/etc/systemd/system/multi-user.target.wants/apache2.service' → '/usr/lib/systemd/system/apache2.service'. 125s Created symlink '/etc/systemd/system/multi-user.target.wants/apache-htcacheclean.service' → '/usr/lib/systemd/system/apache-htcacheclean.service'. 125s Setting up backuppc (4.4.0-11) ... 125s 125s apache2_invoke: Enable configuration backuppc.conf 126s Adding password for user backuppc 126s Considering dependency authn_core for auth_basic: 126s Module authn_core already enabled 126s Module auth_basic already enabled 126s Considering dependency authz_core for authz_groupfile: 126s Module authz_core already enabled 126s Enabling module authz_groupfile. 126s To activate the new configuration, you need to run: 126s systemctl restart apache2 126s Module authn_file already enabled 126s Considering dependency authz_core for authz_user: 126s Module authz_core already enabled 126s Module authz_user already enabled 126s Your MPM seems to be threaded. Selecting cgid instead of cgi. 126s Enabling module cgid. 126s To activate the new configuration, you need to run: 126s systemctl restart apache2 126s Creating config file /etc/backuppc/config.pl with new version 126s Created symlink '/etc/systemd/system/multi-user.target.wants/backuppc.service' → '/usr/lib/systemd/system/backuppc.service'. 126s Setting up smbclient (2:4.23.4+dfsg-1ubuntu1) ... 126s Setting up samba-common-bin (2:4.23.4+dfsg-1ubuntu1) ... 126s Setting up samba (2:4.23.4+dfsg-1ubuntu1) ... 127s Created symlink '/etc/systemd/system/smb.service' → '/usr/lib/systemd/system/smbd.service'. 127s Created symlink '/etc/systemd/system/multi-user.target.wants/smbd.service' → '/usr/lib/systemd/system/smbd.service'. 127s Created symlink '/etc/systemd/system/nmb.service' → '/usr/lib/systemd/system/nmbd.service'. 127s Created symlink '/etc/systemd/system/multi-user.target.wants/nmbd.service' → '/usr/lib/systemd/system/nmbd.service'. 127s Processing triggers for rsyslog (8.2512.0-1ubuntu2) ... 127s Processing triggers for ufw (0.36.2-9build1) ... 128s Processing triggers for man-db (2.13.1-1) ... 128s Processing triggers for libc-bin (2.42-2ubuntu4) ... 128s Processing triggers for postfix (3.10.6-4ubuntu1) ... 128s Restarting postfix 129s autopkgtest [02:23:46]: test smb-backup: [----------------------- 129s net.ipv4.ping_group_range = 0 1000 129s Populating share path 130s Adding samba share 130s Adding [public] share 130s Configuring backuppc 130s Performing a full backup 130s Backup type: type = full, needs_full = 1, needs_incr = 1, lastFullTime = 0, opts{f} = 1, opts{i} = , opts{F} = 130s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 130s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 130s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.007 130s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.0.z created 2026-01-31 02:23:46 130s Backup prep: type = full, case = 1, inPlace = 1, doDuplicate = 0, newBkupNum = 0, newBkupIdx = 0, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = ) 130s __bpc_progress_state__ backup share "public" 130s Running: /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -Tc - 130s full backup started for share public 130s started full dump, share=public 130s Xfer PIDs are now 3630,3629 130s xferPids 3630,3629 130s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -Tc - 130s tarmode is now full, system, hidden, noreset, noverbose 130s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 1 130s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 130s __bpc_progress_fileCnt__ 0 130s new 644 0/0 480434 tmp.xpLhgy 130s new 644 0/0 480434 tmp.xEgPhg 130s new 644 0/0 480434 tmp.ilwace 130s new 644 0/0 480434 tmp.nOxUcH 130s new 644 0/0 480434 tmp.mowJRN 130s new 644 0/0 480434 tmp.xc7tLo 130s new 644 0/0 480434 tmp.nNGZHV 130s new 644 0/0 480434 tmp.ZDuQxZ 130s new 644 0/0 480434 tmp.gEkvjQ 130s tar: dumped 10 files and 0 directories 130s Total bytes written: 4804340 (52.2 MiB/s) 130s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 130s new 644 0/0 480434 tmp.LxL1co 130s __bpc_progress_fileCnt__ 10 130s tarExtract: Done: 0 errors, 0 filesExist, 0 sizeExist, 0 sizeExistComp, 10 filesTotal, 4804340 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377842 sizeNewComp, 13 inodeLast 130s Xfer PIDs are now 130s xferPids 130s full backup 0 complete, 10 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 130s BackupExpire: cntFull = 1, cntIncr = 0, firstFull = 0, firstIncr = , oldestIncr = 0, oldestFull = 0 130s __bpc_progress_state__ fsck 130s Running BackupPC_refCountUpdate -h localhost on localhost 130s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 130s Xfer PIDs are now 3637 130s xferPids 3637 130s BackupPC_refCountUpdate: doing fsck on localhost #0 (full) since $ConfRefCntFsck == 1 130s __bpc_progress_state__ refCnt #0 130s __bpc_progress_state__ cntUpdate #0 130s __bpc_progress_state__ rename #0 130s __bpc_progress_state__ sumUpdate 130s __bpc_progress_fileCnt__ 0/128 130s __bpc_progress_fileCnt__ 8/128 130s __bpc_progress_fileCnt__ 16/128 130s __bpc_progress_fileCnt__ 24/128 130s __bpc_progress_fileCnt__ 32/128 130s __bpc_progress_fileCnt__ 40/128 130s __bpc_progress_fileCnt__ 48/128 130s __bpc_progress_fileCnt__ 56/128 130s __bpc_progress_fileCnt__ 64/128 130s __bpc_progress_fileCnt__ 72/128 130s __bpc_progress_fileCnt__ 80/128 130s __bpc_progress_fileCnt__ 88/128 130s __bpc_progress_fileCnt__ 96/128 130s __bpc_progress_fileCnt__ 104/128 130s __bpc_progress_fileCnt__ 112/128 130s __bpc_progress_fileCnt__ 120/128 130s __bpc_progress_state__ rename total 130s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 130s Xfer PIDs are now 130s xferPids 130s Finished BackupPC_refCountUpdate (running time: 0 sec) 130s Xfer PIDs are now 130s xferPids 130s full backup complete 130s OK: Full backup succeeded 130s Changing share content and performing an incremental backup 130s Backup type: type = incr, needs_full = , needs_incr = , lastFullTime = 1769826226, opts{f} = , opts{i} = 1, opts{F} = 130s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 130s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 130s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.007 130s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.1.z created 2026-01-31 02:23:47 130s Backup prep: type = incr, case = 3, inPlace = 1, doDuplicate = 1, newBkupNum = 1, newBkupIdx = 1, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = ) 130s Executing /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 130s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 130s Xfer PIDs are now 3708 130s xferPids 3708 130s __bpc_progress_state__ copy #0 -> #1 130s Copying backup #0 to #1 130s __bpc_progress_fileCnt__ 3 dirs 130s Xfer PIDs are now 3711,3708 130s xferPids 3711,3708 130s __bpc_progress_state__ sumUpdate 130s __bpc_progress_fileCnt__ 0/128 130s __bpc_progress_fileCnt__ 8/128 130s __bpc_progress_fileCnt__ 16/128 130s __bpc_progress_fileCnt__ 24/128 130s __bpc_progress_fileCnt__ 32/128 130s __bpc_progress_fileCnt__ 40/128 130s __bpc_progress_fileCnt__ 48/128 130s __bpc_progress_fileCnt__ 56/128 130s __bpc_progress_fileCnt__ 64/128 130s __bpc_progress_fileCnt__ 72/128 130s __bpc_progress_fileCnt__ 80/128 130s __bpc_progress_fileCnt__ 88/128 130s __bpc_progress_fileCnt__ 96/128 130s __bpc_progress_fileCnt__ 104/128 130s __bpc_progress_fileCnt__ 112/128 130s __bpc_progress_fileCnt__ 120/128 130s __bpc_progress_state__ rename total 130s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 130s Xfer PIDs are now 3708 130s xferPids 3708 130s BackupPC_backupDuplicate: got 0 errors and 0 file open errors 130s Finished BackupPC_backupDuplicate (running time: 0 sec) 130s __bpc_progress_state__ backup share "public" 130s Running: /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 130s incr backup started back to 2026-01-31 01:23:46 (backup #0) for share public 130s started incr dump, share=public 130s Xfer PIDs are now 3715,3714 130s xferPids 3715,3714 130s 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 - 130s tar:1306 Getting files newer than Sat Jan 31 01:23:46 2026 130s tarmode is now full, system, hidden, noreset, noverbose 130s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 130s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 130s __bpc_progress_fileCnt__ 0 130s new 644 0/0 480434 tmp.X7tj56 130s new 644 0/0 480434 tmp.FkLN6P 130s same 644 0/0 480434 tmp.xpLhgy 130s new 644 0/0 480434 tmp.T3Ys6c 130s same 644 0/0 480434 tmp.xEgPhg 130s new 644 0/0 480434 tmp.nC3Ulg 130s same 644 0/0 480434 tmp.ilwace 130s same 644 0/0 480434 tmp.nOxUcH 130s new 644 0/0 480434 tmp.FOYW2v 130s new 644 0/0 480434 tmp.NWcuHX 130s same 644 0/0 480434 tmp.mowJRN 130s new 644 0/0 480434 tmp.mB21N1 130s same 644 0/0 480434 tmp.xc7tLo 130s new 644 0/0 480434 tmp.nMJy5B 130s same 644 0/0 480434 tmp.nNGZHV 130s same 644 0/0 480434 tmp.ZDuQxZ 130s new 644 0/0 480434 tmp.4bdGB8 130s same 644 0/0 480434 tmp.gEkvjQ 130s new 644 0/0 480434 tmp.GYmj6q 130s tar: dumped 20 files and 0 directories 130s Total bytes written: 9608680 (77.9 MiB/s) 130s same 644 0/0 480434 tmp.LxL1co 130s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 130s __bpc_progress_fileCnt__ 20 130s tarExtract: Done: 0 errors, 10 filesExist, 4804340 sizeExist, 1377842 sizeExistComp, 20 filesTotal, 9608680 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377837 sizeNewComp, 24 inodeLast 130s Xfer PIDs are now 130s xferPids 130s incr backup 1 complete, 20 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 130s BackupExpire: cntFull = 2, cntIncr = 0, firstFull = 0, firstIncr = , oldestIncr = 0, oldestFull = 1.15740740740741e-05 130s __bpc_progress_state__ fsck 130s Running BackupPC_refCountUpdate -h localhost on localhost 130s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 130s Xfer PIDs are now 3721 130s xferPids 3721 130s __bpc_progress_state__ cntUpdate #1 130s __bpc_progress_state__ rename #1 130s __bpc_progress_state__ sumUpdate 130s __bpc_progress_fileCnt__ 0/128 130s __bpc_progress_fileCnt__ 8/128 130s __bpc_progress_fileCnt__ 16/128 130s __bpc_progress_fileCnt__ 24/128 130s __bpc_progress_fileCnt__ 32/128 130s __bpc_progress_fileCnt__ 40/128 130s __bpc_progress_fileCnt__ 48/128 130s __bpc_progress_fileCnt__ 56/128 130s __bpc_progress_fileCnt__ 64/128 130s __bpc_progress_fileCnt__ 72/128 130s __bpc_progress_fileCnt__ 80/128 130s __bpc_progress_fileCnt__ 88/128 130s __bpc_progress_fileCnt__ 96/128 130s __bpc_progress_fileCnt__ 104/128 130s __bpc_progress_fileCnt__ 112/128 130s __bpc_progress_fileCnt__ 120/128 130s __bpc_progress_state__ rename total 130s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 130s Xfer PIDs are now 130s xferPids 130s Finished BackupPC_refCountUpdate (running time: 0 sec) 130s Xfer PIDs are now 130s xferPids 130s incr backup complete 130s OK: Incremental backup succeeded 130s Done. 131s autopkgtest [02:23:48]: test smb-backup: -----------------------] 131s smb-backup PASS 131s autopkgtest [02:23:48]: test smb-backup: - - - - - - - - - - results - - - - - - - - - - 131s autopkgtest [02:23:48]: test authenticated-smb-backup: preparing testbed 131s Reading package lists... 132s Building dependency tree... 132s Reading state information... 132s Solving dependencies... 132s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 132s autopkgtest [02:23:49]: test authenticated-smb-backup: [----------------------- 133s Populating share path 133s Adding samba share 133s Adding [private] share 133s Creating user 133s Creating a local and samba user called smbtest3902 133s Setting samba password for the smbtest3902 user 133s Added user smbtest3902. 133s Configuring backuppc 133s Performing a full backup 133s Backup type: type = full, needs_full = , needs_incr = , lastFullTime = 1769826226, opts{f} = 1, opts{i} = , opts{F} = 133s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 133s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 133s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.007 133s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.2.z created 2026-01-31 02:23:49 133s Backup prep: type = full, case = 4, inPlace = 0, doDuplicate = 0, newBkupNum = 2, newBkupIdx = 2, lastBkupNum = 1, lastBkupIdx = 1 (FillCycle = 0, noFillCnt = 0) 133s __bpc_progress_state__ backup share "private" 133s Running: /usr/bin/smbclient \\\\localhost\\private -U smbtest3902 -E -d 1 -c tarmode\ full -mSMB3 -Tc - 133s full backup started for share private 133s started full dump, share=private 133s Xfer PIDs are now 3995,3994 133s xferPids 3995,3994 133s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\private -U smbtest3902 -E -d 1 -c tarmode\ full -mSMB3 -Tc - 133s tarmode is now full, system, hidden, noreset, noverbose 133s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 1 133s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 133s __bpc_progress_fileCnt__ 0 133s new 644 0/0 480434 tmp.AgP3lJ 133s new 644 0/0 480434 tmp.lutALx 133s new 644 0/0 480434 tmp.hXEPjN 133s new 644 0/0 480434 tmp.8WUQog 133s new 644 0/0 480434 tmp.bhXZ6B 133s new 644 0/0 480434 tmp.KaidcQ 133s new 644 0/0 480434 tmp.h4Db9t 133s new 644 0/0 480434 tmp.ASrVXY 133s new 644 0/0 480434 tmp.y5o3u3 133s tar: dumped 10 files and 0 directories 133s Total bytes written: 4804340 (54.7 MiB/s) 133s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 133s new 644 0/0 480434 tmp.fMACd9 133s __bpc_progress_fileCnt__ 10 133s tarExtract: Done: 0 errors, 0 filesExist, 0 sizeExist, 0 sizeExistComp, 10 filesTotal, 4804340 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377841 sizeNewComp, 36 inodeLast 133s Xfer PIDs are now 133s xferPids 133s OrphanShareNameClean: removing orphan share public from /var/lib/backuppc/pc/localhost/2 133s __bpc_progress_state__ delete share #2/public 133s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDelete -h localhost -n 2 -l -m -s public / 133s Xfer PIDs are now 4002 133s xferPids 4002 133s BackupPC_backupDelete: removing #2/public/ 133s __bpc_progress_state__ merge #2/public/ -> #1/public/ 133s BackupPC_backupDelete: Merge into backup 1/public/ 133s mergeDir: attr write to /var/lib/backuppc/pc/localhost/1/fpublic//attrib failed (digest was ) 133s bpc_attrib_dirWrite: can't open/create raw /var/lib/backuppc/pc/localhost/1/fpublic for writing 133s Xfer PIDs are now 4002,4005 133s xferPids 4002,4005 133s __bpc_progress_state__ refCnt #1 133s __bpc_progress_state__ cntUpdate #1 133s __bpc_progress_state__ rename #1 133s __bpc_progress_state__ refCnt #2 133s BackupPC_refCountUpdate: localhost #2 inodeLast set to 37 (was 24) 133s __bpc_progress_state__ cntUpdate #2 133s __bpc_progress_state__ rename #2 133s __bpc_progress_state__ sumUpdate 133s __bpc_progress_fileCnt__ 0/128 133s __bpc_progress_fileCnt__ 8/128 133s __bpc_progress_fileCnt__ 16/128 133s __bpc_progress_fileCnt__ 24/128 133s __bpc_progress_fileCnt__ 32/128 133s __bpc_progress_fileCnt__ 40/128 133s __bpc_progress_fileCnt__ 48/128 133s __bpc_progress_fileCnt__ 56/128 133s __bpc_progress_fileCnt__ 64/128 133s __bpc_progress_fileCnt__ 72/128 133s __bpc_progress_fileCnt__ 80/128 133s __bpc_progress_fileCnt__ 88/128 133s __bpc_progress_fileCnt__ 96/128 133s __bpc_progress_fileCnt__ 104/128 133s __bpc_progress_fileCnt__ 112/128 133s __bpc_progress_fileCnt__ 120/128 133s __bpc_progress_state__ rename total 133s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 133s Xfer PIDs are now 4002 133s xferPids 4002 133s Xfer PIDs are now 133s xferPids 133s Finished BackupPC_backupDelete, status = 0 (running time: 1 sec) 133s Xfer PIDs are now 133s xferPids 133s full backup 2 complete, 10 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 133s BackupExpire: cntFull = 2, cntIncr = 1, firstFull = 0, firstIncr = 1, oldestIncr = 3.47222222222222e-05, oldestFull = 4.62962962962963e-05 133s __bpc_progress_state__ fsck 133s Running BackupPC_refCountUpdate -h localhost on localhost 133s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 133s Xfer PIDs are now 4008 133s xferPids 4008 133s BackupPC_refCountUpdate: doing fsck on localhost #2 (full) since $ConfRefCntFsck == 1 133s __bpc_progress_state__ refCnt #2 133s __bpc_progress_state__ cntUpdate #2 133s __bpc_progress_state__ rename #2 133s __bpc_progress_state__ sumUpdate 133s __bpc_progress_fileCnt__ 0/128 133s __bpc_progress_fileCnt__ 8/128 133s __bpc_progress_fileCnt__ 16/128 133s __bpc_progress_fileCnt__ 24/128 133s __bpc_progress_fileCnt__ 32/128 133s __bpc_progress_fileCnt__ 40/128 133s __bpc_progress_fileCnt__ 48/128 133s __bpc_progress_fileCnt__ 56/128 133s __bpc_progress_fileCnt__ 64/128 133s __bpc_progress_fileCnt__ 72/128 133s __bpc_progress_fileCnt__ 80/128 133s __bpc_progress_fileCnt__ 88/128 133s __bpc_progress_fileCnt__ 96/128 133s __bpc_progress_fileCnt__ 104/128 133s __bpc_progress_fileCnt__ 112/128 133s __bpc_progress_fileCnt__ 120/128 133s __bpc_progress_state__ rename total 133s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 133s Xfer PIDs are now 133s xferPids 133s Finished BackupPC_refCountUpdate (running time: 0 sec) 133s Xfer PIDs are now 133s xferPids 133s full backup complete 133s OK: Full backup succeeded 133s Changing share content and performing an incremental backup 133s Backup type: type = incr, needs_full = , needs_incr = , lastFullTime = 1769826229, opts{f} = , opts{i} = 1, opts{F} = 133s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 133s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 133s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.007 133s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.3.z created 2026-01-31 02:23:50 133s Backup prep: type = incr, case = 3, inPlace = 1, doDuplicate = 1, newBkupNum = 3, newBkupIdx = 3, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = 1) 133s Executing /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 133s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 133s Xfer PIDs are now 4079 133s xferPids 4079 133s __bpc_progress_state__ copy #2 -> #3 133s Copying backup #2 to #3 133s __bpc_progress_fileCnt__ 3 dirs 133s Xfer PIDs are now 4082,4079 133s xferPids 4082,4079 133s __bpc_progress_state__ sumUpdate 133s __bpc_progress_fileCnt__ 0/128 133s __bpc_progress_fileCnt__ 8/128 133s __bpc_progress_fileCnt__ 16/128 133s __bpc_progress_fileCnt__ 24/128 133s __bpc_progress_fileCnt__ 32/128 133s __bpc_progress_fileCnt__ 40/128 133s __bpc_progress_fileCnt__ 48/128 133s __bpc_progress_fileCnt__ 56/128 133s __bpc_progress_fileCnt__ 64/128 133s __bpc_progress_fileCnt__ 72/128 133s __bpc_progress_fileCnt__ 80/128 133s __bpc_progress_fileCnt__ 88/128 133s __bpc_progress_fileCnt__ 96/128 133s __bpc_progress_fileCnt__ 104/128 133s __bpc_progress_fileCnt__ 112/128 133s __bpc_progress_fileCnt__ 120/128 133s __bpc_progress_state__ rename total 133s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 133s Xfer PIDs are now 4079 133s xferPids 4079 133s BackupPC_backupDuplicate: got 0 errors and 0 file open errors 133s Finished BackupPC_backupDuplicate (running time: 0 sec) 133s __bpc_progress_state__ backup share "private" 133s Running: /usr/bin/smbclient \\\\localhost\\private -U smbtest3902 -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 133s incr backup started back to 2026-01-31 01:23:49 (backup #2) for share private 133s started incr dump, share=private 133s Xfer PIDs are now 4086,4085 133s xferPids 4086,4085 133s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\private -U smbtest3902 -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 133s tar:1306 Getting files newer than Sat Jan 31 01:23:49 2026 133s tarmode is now full, system, hidden, noreset, noverbose 133s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 133s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 133s __bpc_progress_fileCnt__ 0 133s new 644 0/0 480434 tmp.2pf6kD 133s new 644 0/0 480434 tmp.hjFQYQ 133s new 644 0/0 480434 tmp.tRfFJG 133s same 644 0/0 480434 tmp.AgP3lJ 133s same 644 0/0 480434 tmp.lutALx 133s same 644 0/0 480434 tmp.hXEPjN 133s new 644 0/0 480434 tmp.JGjQ30 133s same 644 0/0 480434 tmp.8WUQog 133s new 644 0/0 480434 tmp.CDKErq 133s new 644 0/0 480434 tmp.IlQb0R 133s same 644 0/0 480434 tmp.bhXZ6B 134s new 644 0/0 480434 tmp.XR4c4h 134s same 644 0/0 480434 tmp.KaidcQ 134s same 644 0/0 480434 tmp.h4Db9t 134s same 644 0/0 480434 tmp.ASrVXY 134s new 644 0/0 480434 tmp.cTXKMl 134s new 644 0/0 480434 tmp.6lZflI 134s new 644 0/0 480434 tmp.jQ5qfr 134s tar: dumped 20 files and 0 directories 134s Total bytes written: 9608680 (79.2 MiB/s) 134s same 644 0/0 480434 tmp.y5o3u3 134s same 644 0/0 480434 tmp.fMACd9 134s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 134s __bpc_progress_fileCnt__ 20 134s tarExtract: Done: 0 errors, 10 filesExist, 4804340 sizeExist, 1377841 sizeExistComp, 20 filesTotal, 9608680 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377803 sizeNewComp, 47 inodeLast 134s Xfer PIDs are now 134s xferPids 134s incr backup 3 complete, 20 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 134s BackupExpire: cntFull = 3, cntIncr = 1, firstFull = 0, firstIncr = 1, oldestIncr = 3.47222222222222e-05, oldestFull = 4.62962962962963e-05 134s __bpc_progress_state__ fsck 134s Running BackupPC_refCountUpdate -h localhost on localhost 134s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 134s Xfer PIDs are now 4095 134s xferPids 4095 134s __bpc_progress_state__ cntUpdate #3 134s __bpc_progress_state__ rename #3 134s __bpc_progress_state__ sumUpdate 134s __bpc_progress_fileCnt__ 0/128 134s __bpc_progress_fileCnt__ 8/128 134s __bpc_progress_fileCnt__ 16/128 134s __bpc_progress_fileCnt__ 24/128 134s __bpc_progress_fileCnt__ 32/128 134s __bpc_progress_fileCnt__ 40/128 134s __bpc_progress_fileCnt__ 48/128 134s __bpc_progress_fileCnt__ 56/128 134s __bpc_progress_fileCnt__ 64/128 134s __bpc_progress_fileCnt__ 72/128 134s __bpc_progress_fileCnt__ 80/128 134s __bpc_progress_fileCnt__ 88/128 134s __bpc_progress_fileCnt__ 96/128 134s __bpc_progress_fileCnt__ 104/128 134s __bpc_progress_fileCnt__ 112/128 134s __bpc_progress_fileCnt__ 120/128 134s __bpc_progress_state__ rename total 134s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 134s Xfer PIDs are now 134s xferPids 134s Finished BackupPC_refCountUpdate (running time: 0 sec) 134s Xfer PIDs are now 134s xferPids 134s incr backup complete 134s OK: Incremental backup succeeded 134s Done. 134s Deleted user smbtest3902. 134s userdel: smbtest3902 mail spool (/var/mail/smbtest3902) not found 134s autopkgtest [02:23:51]: test authenticated-smb-backup: -----------------------] 134s autopkgtest [02:23:51]: test authenticated-smb-backup: - - - - - - - - - - results - - - - - - - - - - 134s authenticated-smb-backup PASS 135s autopkgtest [02:23:52]: @@@@@@@@@@@@@@@@@@@@ summary 135s smb-backup PASS 135s authenticated-smb-backup PASS