0s autopkgtest [06:25:58]: starting date and time: 2026-01-30 06:25:58+0000 0s autopkgtest [06:25:58]: git checkout: 4b346b80 nova: make wait_reboot return success even when a no-op 0s autopkgtest [06:25:58]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.vpvx3kno/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-ppc64el --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@sto01-ppc64el-7.secgroup --name adt-resolute-ppc64el-backuppc-20260130-062558-juju-7f2275-prod-proposed-migration-environment-2-a512709d-d29b-439f-8ea2-725663c2c560 --image adt/ubuntu-resolute-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-autopkgtest-workers-ppc64el -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 4s Creating nova instance adt-resolute-ppc64el-backuppc-20260130-062558-juju-7f2275-prod-proposed-migration-environment-2-a512709d-d29b-439f-8ea2-725663c2c560 from image adt/ubuntu-resolute-ppc64el-server-20260129.img (UUID 011be5ba-3d23-459d-9a9a-537803b22566)... 52s autopkgtest [06:26:50]: testbed dpkg architecture: ppc64el 52s autopkgtest [06:26:50]: testbed apt version: 3.1.14 52s autopkgtest [06:26:50]: @@@@@@@@@@@@@@@@@@@@ test bed setup 53s autopkgtest [06:26:51]: testbed release detected to be: None 53s autopkgtest [06:26:51]: updating testbed package index (apt update) 54s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease [124 kB] 54s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 54s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 54s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 54s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse Sources [33.0 kB] 54s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/main Sources [103 kB] 54s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/universe Sources [1600 kB] 55s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/restricted Sources [2820 B] 55s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main ppc64el Packages [119 kB] 55s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/universe ppc64el Packages [1131 kB] 55s Get:11 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse ppc64el Packages [22.2 kB] 55s Fetched 3136 kB in 2s (2052 kB/s) 56s Reading package lists... 57s Hit:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease 57s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 57s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 57s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 58s Reading package lists... 58s Reading package lists... 58s Building dependency tree... 58s Reading state information... 58s Calculating upgrade... 58s The following packages will be upgraded: 58s bzip2 gcc-15-base inetutils-telnet libatomic1 libbz2-1.0 libgcc-s1 58s libsgutils2-1.48 libsqlite3-0 libstdc++6 sg3-utils sg3-utils-udev telnet 58s 12 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 58s Need to get 3302 kB of archives. 58s After this operation, 3072 B of additional disk space will be used. 58s Get:1 http://ftpmaster.internal/ubuntu resolute/main ppc64el libatomic1 ppc64el 15.2.0-12ubuntu1 [11.0 kB] 58s Get:2 http://ftpmaster.internal/ubuntu resolute/main ppc64el libstdc++6 ppc64el 15.2.0-12ubuntu1 [922 kB] 58s Get:3 http://ftpmaster.internal/ubuntu resolute/main ppc64el gcc-15-base ppc64el 15.2.0-12ubuntu1 [59.6 kB] 58s Get:4 http://ftpmaster.internal/ubuntu resolute/main ppc64el libgcc-s1 ppc64el 15.2.0-12ubuntu1 [40.2 kB] 58s Get:5 http://ftpmaster.internal/ubuntu resolute/main ppc64el bzip2 ppc64el 1.0.8-6build2 [37.6 kB] 58s Get:6 http://ftpmaster.internal/ubuntu resolute/main ppc64el libbz2-1.0 ppc64el 1.0.8-6build2 [47.7 kB] 58s Get:7 http://ftpmaster.internal/ubuntu resolute/main ppc64el libsqlite3-0 ppc64el 3.46.1-9 [825 kB] 59s Get:8 http://ftpmaster.internal/ubuntu resolute/main ppc64el inetutils-telnet ppc64el 2:2.7-2ubuntu1 [125 kB] 59s Get:9 http://ftpmaster.internal/ubuntu resolute/main ppc64el telnet all 0.17+2.7-2ubuntu1 [3636 B] 59s Get:10 http://ftpmaster.internal/ubuntu resolute/main ppc64el libsgutils2-1.48 ppc64el 1.48-3ubuntu2 [143 kB] 59s Get:11 http://ftpmaster.internal/ubuntu resolute/main ppc64el sg3-utils ppc64el 1.48-3ubuntu2 [1080 kB] 59s Get:12 http://ftpmaster.internal/ubuntu resolute/main ppc64el sg3-utils-udev all 1.48-3ubuntu2 [6610 B] 59s dpkg-preconfigure: unable to re-open stdin: No such file or directory 59s Fetched 3302 kB in 0s (6728 kB/s) 61s (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 ... 120856 files and directories currently installed.) 61s Preparing to unpack .../libatomic1_15.2.0-12ubuntu1_ppc64el.deb ... 61s Unpacking libatomic1:ppc64el (15.2.0-12ubuntu1) over (15.2.0-11ubuntu1) ... 61s Preparing to unpack .../libstdc++6_15.2.0-12ubuntu1_ppc64el.deb ... 61s Unpacking libstdc++6:ppc64el (15.2.0-12ubuntu1) over (15.2.0-11ubuntu1) ... 61s Preparing to unpack .../gcc-15-base_15.2.0-12ubuntu1_ppc64el.deb ... 61s Unpacking gcc-15-base:ppc64el (15.2.0-12ubuntu1) over (15.2.0-11ubuntu1) ... 61s Setting up gcc-15-base:ppc64el (15.2.0-12ubuntu1) ... 61s (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 ... 120856 files and directories currently installed.) 61s Preparing to unpack .../libgcc-s1_15.2.0-12ubuntu1_ppc64el.deb ... 61s Unpacking libgcc-s1:ppc64el (15.2.0-12ubuntu1) over (15.2.0-11ubuntu1) ... 62s Setting up libgcc-s1:ppc64el (15.2.0-12ubuntu1) ... 62s (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 ... 120856 files and directories currently installed.) 62s Preparing to unpack .../bzip2_1.0.8-6build2_ppc64el.deb ... 62s Unpacking bzip2 (1.0.8-6build2) over (1.0.8-6build1) ... 62s Preparing to unpack .../libbz2-1.0_1.0.8-6build2_ppc64el.deb ... 62s Unpacking libbz2-1.0:ppc64el (1.0.8-6build2) over (1.0.8-6build1) ... 62s Setting up libbz2-1.0:ppc64el (1.0.8-6build2) ... 62s (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 ... 120856 files and directories currently installed.) 62s Preparing to unpack .../0-libsqlite3-0_3.46.1-9_ppc64el.deb ... 62s Unpacking libsqlite3-0:ppc64el (3.46.1-9) over (3.46.1-8) ... 63s Preparing to unpack .../1-inetutils-telnet_2%3a2.7-2ubuntu1_ppc64el.deb ... 63s Unpacking inetutils-telnet (2:2.7-2ubuntu1) over (2:2.6-4ubuntu1) ... 63s Preparing to unpack .../2-telnet_0.17+2.7-2ubuntu1_all.deb ... 63s Unpacking telnet (0.17+2.7-2ubuntu1) over (0.17+2.6-4ubuntu1) ... 63s Preparing to unpack .../3-libsgutils2-1.48_1.48-3ubuntu2_ppc64el.deb ... 63s Unpacking libsgutils2-1.48:ppc64el (1.48-3ubuntu2) over (1.48-3ubuntu1) ... 63s Preparing to unpack .../4-sg3-utils_1.48-3ubuntu2_ppc64el.deb ... 63s Unpacking sg3-utils (1.48-3ubuntu2) over (1.48-3ubuntu1) ... 64s Preparing to unpack .../5-sg3-utils-udev_1.48-3ubuntu2_all.deb ... 64s Unpacking sg3-utils-udev (1.48-3ubuntu2) over (1.48-3ubuntu1) ... 64s Setting up libsqlite3-0:ppc64el (3.46.1-9) ... 64s Setting up inetutils-telnet (2:2.7-2ubuntu1) ... 64s Setting up libsgutils2-1.48:ppc64el (1.48-3ubuntu2) ... 64s Setting up bzip2 (1.0.8-6build2) ... 64s Setting up libatomic1:ppc64el (15.2.0-12ubuntu1) ... 64s Setting up libstdc++6:ppc64el (15.2.0-12ubuntu1) ... 64s Setting up sg3-utils (1.48-3ubuntu2) ... 64s Setting up telnet (0.17+2.7-2ubuntu1) ... 64s Setting up sg3-utils-udev (1.48-3ubuntu2) ... 64s update-initramfs: deferring update (trigger activated) 64s Processing triggers for libc-bin (2.42-2ubuntu4) ... 64s Processing triggers for man-db (2.13.1-1) ... 67s Processing triggers for initramfs-tools (0.150ubuntu7) ... 67s update-initramfs: Generating /boot/initrd.img-6.18.0-9-generic 77s autopkgtest [06:27:15]: upgrading testbed (apt dist-upgrade and autopurge) 77s Reading package lists... 78s Building dependency tree... 78s Reading state information... 78s Calculating upgrade... 78s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 78s Reading package lists... 78s Building dependency tree... 78s Reading state information... 78s Solving dependencies... 78s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 78s autopkgtest [06:27:16]: rebooting testbed after setup commands that affected boot 121s autopkgtest [06:27:59]: testbed running kernel: Linux 6.18.0-9-generic #9-Ubuntu SMP PREEMPT_DYNAMIC Mon Jan 12 16:45:54 UTC 2026 123s autopkgtest [06:28:01]: @@@@@@@@@@@@@@@@@@@@ apt-source backuppc 125s Get:1 http://ftpmaster.internal/ubuntu resolute/main backuppc 4.4.0-11 (dsc) [2169 B] 125s Get:2 http://ftpmaster.internal/ubuntu resolute/main backuppc 4.4.0-11 (tar) [657 kB] 125s Get:3 http://ftpmaster.internal/ubuntu resolute/main backuppc 4.4.0-11 (diff) [37.9 kB] 125s gpgv: Signature made Sun Mar 30 09:20:11 2025 UTC 125s gpgv: using RSA key FDDD0CFF3864277630A2186C9164FA1D17BD5D36 125s gpgv: Can't check signature: No public key 125s dpkg-source: warning: cannot verify inline signature for ./backuppc_4.4.0-11.dsc: no acceptable signature found 125s autopkgtest [06:28:03]: testing package backuppc version 4.4.0-11 126s autopkgtest [06:28:04]: build not needed 126s autopkgtest [06:28:04]: test smb-backup: preparing testbed 126s Reading package lists... 126s Building dependency tree... 126s Reading state information... 126s Solving dependencies... 127s The following NEW packages will be installed: 127s apache2 apache2-bin apache2-data apache2-utils backuppc backuppc-rsync 127s libapr1t64 libaprutil1-dbd-sqlite3 libaprutil1-ldap libaprutil1t64 127s libarchive-zip-perl libavahi-client3 libavahi-common-data libavahi-common3 127s libbackuppc-xs-perl libcgi-pm-perl libcups2t64 libfile-listing-perl 127s libhtml-parser-perl libhtml-tagset-perl libhttp-date-perl libldb2 127s liblua5.4-0 libnsl2 libsmbclient0 libtalloc2 libtdb1 libtevent0t64 127s libtime-parsedate-perl libtimedate-perl liburi-perl liburing2 libwbclient0 127s postfix samba samba-common samba-common-bin samba-libs smbclient 127s 0 upgraded, 39 newly installed, 0 to remove and 0 not upgraded. 127s Need to get 17.4 MB of archives. 127s After this operation, 88.2 MB of additional disk space will be used. 127s Get:1 http://ftpmaster.internal/ubuntu resolute/main ppc64el libapr1t64 ppc64el 1.7.6-3 [141 kB] 127s Get:2 http://ftpmaster.internal/ubuntu resolute/main ppc64el libaprutil1t64 ppc64el 1.6.3-3ubuntu3 [113 kB] 127s Get:3 http://ftpmaster.internal/ubuntu resolute/main ppc64el libaprutil1-dbd-sqlite3 ppc64el 1.6.3-3ubuntu3 [12.3 kB] 127s Get:4 http://ftpmaster.internal/ubuntu resolute/main ppc64el libaprutil1-ldap ppc64el 1.6.3-3ubuntu3 [9336 B] 127s Get:5 http://ftpmaster.internal/ubuntu resolute/main ppc64el liblua5.4-0 ppc64el 5.4.8-1 [213 kB] 127s Get:6 http://ftpmaster.internal/ubuntu resolute/main ppc64el apache2-bin ppc64el 2.4.65-3ubuntu1 [1604 kB] 127s Get:7 http://ftpmaster.internal/ubuntu resolute/main ppc64el apache2-data all 2.4.65-3ubuntu1 [163 kB] 127s Get:8 http://ftpmaster.internal/ubuntu resolute/main ppc64el apache2-utils ppc64el 2.4.65-3ubuntu1 [105 kB] 127s Get:9 http://ftpmaster.internal/ubuntu resolute/main ppc64el apache2 ppc64el 2.4.65-3ubuntu1 [93.4 kB] 127s Get:10 http://ftpmaster.internal/ubuntu resolute/main ppc64el backuppc-rsync ppc64el 3.1.3.0-5 [331 kB] 127s Get:11 http://ftpmaster.internal/ubuntu resolute/main ppc64el libnsl2 ppc64el 1.3.0-3build4 [49.7 kB] 127s Get:12 http://ftpmaster.internal/ubuntu resolute/main ppc64el postfix ppc64el 3.10.6-1ubuntu1 [1419 kB] 127s Get:13 http://ftpmaster.internal/ubuntu resolute/main ppc64el libarchive-zip-perl all 1.68-1 [90.2 kB] 127s Get:14 http://ftpmaster.internal/ubuntu resolute/main ppc64el libbackuppc-xs-perl ppc64el 0.62-2build6 [73.7 kB] 127s Get:15 http://ftpmaster.internal/ubuntu resolute/main ppc64el libhtml-tagset-perl all 3.24-1 [14.1 kB] 127s Get:16 http://ftpmaster.internal/ubuntu resolute/main ppc64el liburi-perl all 5.34-2build1 [100 kB] 127s Get:17 http://ftpmaster.internal/ubuntu resolute/main ppc64el libhtml-parser-perl ppc64el 3.83-1build1 [91.8 kB] 127s Get:18 http://ftpmaster.internal/ubuntu resolute/main ppc64el libcgi-pm-perl all 4.71-1build1 [185 kB] 127s Get:19 http://ftpmaster.internal/ubuntu resolute/main ppc64el libtimedate-perl all 2.3300-2 [34.0 kB] 127s Get:20 http://ftpmaster.internal/ubuntu resolute/main ppc64el libhttp-date-perl all 6.06-1 [10.2 kB] 127s Get:21 http://ftpmaster.internal/ubuntu resolute/main ppc64el libfile-listing-perl all 6.16-1 [11.3 kB] 127s Get:22 http://ftpmaster.internal/ubuntu resolute/main ppc64el libtime-parsedate-perl all 2015.103-5 [27.9 kB] 127s Get:23 http://ftpmaster.internal/ubuntu resolute/main ppc64el backuppc ppc64el 4.4.0-11 [518 kB] 127s Get:24 http://ftpmaster.internal/ubuntu resolute/main ppc64el samba-common all 2:4.23.4+dfsg-1ubuntu1 [74.4 kB] 127s Get:25 http://ftpmaster.internal/ubuntu resolute/main ppc64el libavahi-common-data ppc64el 0.8-17ubuntu2 [31.5 kB] 127s Get:26 http://ftpmaster.internal/ubuntu resolute/main ppc64el libavahi-common3 ppc64el 0.8-17ubuntu2 [26.3 kB] 127s Get:27 http://ftpmaster.internal/ubuntu resolute/main ppc64el libavahi-client3 ppc64el 0.8-17ubuntu2 [31.1 kB] 127s Get:28 http://ftpmaster.internal/ubuntu resolute/main ppc64el libcups2t64 ppc64el 2.4.16-1ubuntu1 [353 kB] 127s Get:29 http://ftpmaster.internal/ubuntu resolute/main ppc64el libtalloc2 ppc64el 2:2.4.3+samba4.23.4+dfsg-1ubuntu1 [86.5 kB] 127s Get:30 http://ftpmaster.internal/ubuntu resolute/main ppc64el libtdb1 ppc64el 2:1.4.14+samba4.23.4+dfsg-1ubuntu1 [114 kB] 127s Get:31 http://ftpmaster.internal/ubuntu resolute/main ppc64el libtevent0t64 ppc64el 2:0.17.1+samba4.23.4+dfsg-1ubuntu1 [49.8 kB] 127s Get:32 http://ftpmaster.internal/ubuntu resolute/main ppc64el libldb2 ppc64el 2:2.11.0+samba4.23.4+dfsg-1ubuntu1 [185 kB] 127s Get:33 http://ftpmaster.internal/ubuntu resolute/main ppc64el libwbclient0 ppc64el 2:4.23.4+dfsg-1ubuntu1 [91.2 kB] 127s Get:34 http://ftpmaster.internal/ubuntu resolute/main ppc64el samba-libs ppc64el 2:4.23.4+dfsg-1ubuntu1 [7346 kB] 128s Get:35 http://ftpmaster.internal/ubuntu resolute/main ppc64el samba-common-bin ppc64el 2:4.23.4+dfsg-1ubuntu1 [1563 kB] 128s Get:36 http://ftpmaster.internal/ubuntu resolute/main ppc64el liburing2 ppc64el 2.11-1 [29.9 kB] 128s Get:37 http://ftpmaster.internal/ubuntu resolute/main ppc64el samba ppc64el 2:4.23.4+dfsg-1ubuntu1 [1372 kB] 128s Get:38 http://ftpmaster.internal/ubuntu resolute/main ppc64el libsmbclient0 ppc64el 2:4.23.4+dfsg-1ubuntu1 [72.0 kB] 128s Get:39 http://ftpmaster.internal/ubuntu resolute/main ppc64el smbclient ppc64el 2:4.23.4+dfsg-1ubuntu1 [535 kB] 129s Preconfiguring packages ... 129s Fetched 17.4 MB in 2s (10.5 MB/s) 129s Selecting previously unselected package libapr1t64:ppc64el. 129s (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 ... 120856 files and directories currently installed.) 129s Preparing to unpack .../00-libapr1t64_1.7.6-3_ppc64el.deb ... 129s Unpacking libapr1t64:ppc64el (1.7.6-3) ... 129s Selecting previously unselected package libaprutil1t64:ppc64el. 129s Preparing to unpack .../01-libaprutil1t64_1.6.3-3ubuntu3_ppc64el.deb ... 129s Unpacking libaprutil1t64:ppc64el (1.6.3-3ubuntu3) ... 129s Selecting previously unselected package libaprutil1-dbd-sqlite3:ppc64el. 129s Preparing to unpack .../02-libaprutil1-dbd-sqlite3_1.6.3-3ubuntu3_ppc64el.deb ... 129s Unpacking libaprutil1-dbd-sqlite3:ppc64el (1.6.3-3ubuntu3) ... 129s Selecting previously unselected package libaprutil1-ldap:ppc64el. 129s Preparing to unpack .../03-libaprutil1-ldap_1.6.3-3ubuntu3_ppc64el.deb ... 129s Unpacking libaprutil1-ldap:ppc64el (1.6.3-3ubuntu3) ... 129s Selecting previously unselected package liblua5.4-0:ppc64el. 129s Preparing to unpack .../04-liblua5.4-0_5.4.8-1_ppc64el.deb ... 129s Unpacking liblua5.4-0:ppc64el (5.4.8-1) ... 129s Selecting previously unselected package apache2-bin. 129s Preparing to unpack .../05-apache2-bin_2.4.65-3ubuntu1_ppc64el.deb ... 129s Unpacking apache2-bin (2.4.65-3ubuntu1) ... 129s Selecting previously unselected package apache2-data. 129s Preparing to unpack .../06-apache2-data_2.4.65-3ubuntu1_all.deb ... 129s Unpacking apache2-data (2.4.65-3ubuntu1) ... 130s Selecting previously unselected package apache2-utils. 130s Preparing to unpack .../07-apache2-utils_2.4.65-3ubuntu1_ppc64el.deb ... 130s Unpacking apache2-utils (2.4.65-3ubuntu1) ... 130s Selecting previously unselected package apache2. 130s Preparing to unpack .../08-apache2_2.4.65-3ubuntu1_ppc64el.deb ... 130s Unpacking apache2 (2.4.65-3ubuntu1) ... 130s Selecting previously unselected package backuppc-rsync. 130s Preparing to unpack .../09-backuppc-rsync_3.1.3.0-5_ppc64el.deb ... 130s Unpacking backuppc-rsync (3.1.3.0-5) ... 130s Selecting previously unselected package libnsl2:ppc64el. 130s Preparing to unpack .../10-libnsl2_1.3.0-3build4_ppc64el.deb ... 130s Unpacking libnsl2:ppc64el (1.3.0-3build4) ... 130s Selecting previously unselected package postfix. 130s Preparing to unpack .../11-postfix_3.10.6-1ubuntu1_ppc64el.deb ... 130s Unpacking postfix (3.10.6-1ubuntu1) ... 130s Selecting previously unselected package libarchive-zip-perl. 130s Preparing to unpack .../12-libarchive-zip-perl_1.68-1_all.deb ... 130s Unpacking libarchive-zip-perl (1.68-1) ... 130s Selecting previously unselected package libbackuppc-xs-perl:ppc64el. 130s Preparing to unpack .../13-libbackuppc-xs-perl_0.62-2build6_ppc64el.deb ... 130s Unpacking libbackuppc-xs-perl:ppc64el (0.62-2build6) ... 130s Selecting previously unselected package libhtml-tagset-perl. 130s Preparing to unpack .../14-libhtml-tagset-perl_3.24-1_all.deb ... 130s Unpacking libhtml-tagset-perl (3.24-1) ... 130s Selecting previously unselected package liburi-perl. 130s Preparing to unpack .../15-liburi-perl_5.34-2build1_all.deb ... 130s Unpacking liburi-perl (5.34-2build1) ... 130s Selecting previously unselected package libhtml-parser-perl:ppc64el. 130s Preparing to unpack .../16-libhtml-parser-perl_3.83-1build1_ppc64el.deb ... 130s Unpacking libhtml-parser-perl:ppc64el (3.83-1build1) ... 130s Selecting previously unselected package libcgi-pm-perl. 130s Preparing to unpack .../17-libcgi-pm-perl_4.71-1build1_all.deb ... 130s Unpacking libcgi-pm-perl (4.71-1build1) ... 130s Selecting previously unselected package libtimedate-perl. 130s Preparing to unpack .../18-libtimedate-perl_2.3300-2_all.deb ... 130s Unpacking libtimedate-perl (2.3300-2) ... 130s Selecting previously unselected package libhttp-date-perl. 130s Preparing to unpack .../19-libhttp-date-perl_6.06-1_all.deb ... 130s Unpacking libhttp-date-perl (6.06-1) ... 130s Selecting previously unselected package libfile-listing-perl. 130s Preparing to unpack .../20-libfile-listing-perl_6.16-1_all.deb ... 130s Unpacking libfile-listing-perl (6.16-1) ... 130s Selecting previously unselected package libtime-parsedate-perl. 130s Preparing to unpack .../21-libtime-parsedate-perl_2015.103-5_all.deb ... 130s Unpacking libtime-parsedate-perl (2015.103-5) ... 130s Selecting previously unselected package backuppc. 130s Preparing to unpack .../22-backuppc_4.4.0-11_ppc64el.deb ... 130s Unpacking backuppc (4.4.0-11) ... 130s Selecting previously unselected package samba-common. 130s Preparing to unpack .../23-samba-common_2%3a4.23.4+dfsg-1ubuntu1_all.deb ... 130s Unpacking samba-common (2:4.23.4+dfsg-1ubuntu1) ... 130s Selecting previously unselected package libavahi-common-data:ppc64el. 130s Preparing to unpack .../24-libavahi-common-data_0.8-17ubuntu2_ppc64el.deb ... 130s Unpacking libavahi-common-data:ppc64el (0.8-17ubuntu2) ... 130s Selecting previously unselected package libavahi-common3:ppc64el. 130s Preparing to unpack .../25-libavahi-common3_0.8-17ubuntu2_ppc64el.deb ... 130s Unpacking libavahi-common3:ppc64el (0.8-17ubuntu2) ... 130s Selecting previously unselected package libavahi-client3:ppc64el. 130s Preparing to unpack .../26-libavahi-client3_0.8-17ubuntu2_ppc64el.deb ... 130s Unpacking libavahi-client3:ppc64el (0.8-17ubuntu2) ... 130s Selecting previously unselected package libcups2t64:ppc64el. 130s Preparing to unpack .../27-libcups2t64_2.4.16-1ubuntu1_ppc64el.deb ... 130s Unpacking libcups2t64:ppc64el (2.4.16-1ubuntu1) ... 130s Selecting previously unselected package libtalloc2:ppc64el. 130s Preparing to unpack .../28-libtalloc2_2%3a2.4.3+samba4.23.4+dfsg-1ubuntu1_ppc64el.deb ... 130s Unpacking libtalloc2:ppc64el (2:2.4.3+samba4.23.4+dfsg-1ubuntu1) ... 130s Selecting previously unselected package libtdb1:ppc64el. 130s Preparing to unpack .../29-libtdb1_2%3a1.4.14+samba4.23.4+dfsg-1ubuntu1_ppc64el.deb ... 130s Unpacking libtdb1:ppc64el (2:1.4.14+samba4.23.4+dfsg-1ubuntu1) ... 130s Selecting previously unselected package libtevent0t64:ppc64el. 130s Preparing to unpack .../30-libtevent0t64_2%3a0.17.1+samba4.23.4+dfsg-1ubuntu1_ppc64el.deb ... 130s Unpacking libtevent0t64:ppc64el (2:0.17.1+samba4.23.4+dfsg-1ubuntu1) ... 130s Selecting previously unselected package libldb2:ppc64el. 130s Preparing to unpack .../31-libldb2_2%3a2.11.0+samba4.23.4+dfsg-1ubuntu1_ppc64el.deb ... 130s Unpacking libldb2:ppc64el (2:2.11.0+samba4.23.4+dfsg-1ubuntu1) ... 130s Selecting previously unselected package libwbclient0:ppc64el. 130s Preparing to unpack .../32-libwbclient0_2%3a4.23.4+dfsg-1ubuntu1_ppc64el.deb ... 130s Unpacking libwbclient0:ppc64el (2:4.23.4+dfsg-1ubuntu1) ... 130s Selecting previously unselected package samba-libs:ppc64el. 130s Preparing to unpack .../33-samba-libs_2%3a4.23.4+dfsg-1ubuntu1_ppc64el.deb ... 130s Unpacking samba-libs:ppc64el (2:4.23.4+dfsg-1ubuntu1) ... 130s Selecting previously unselected package samba-common-bin. 130s Preparing to unpack .../34-samba-common-bin_2%3a4.23.4+dfsg-1ubuntu1_ppc64el.deb ... 130s Unpacking samba-common-bin (2:4.23.4+dfsg-1ubuntu1) ... 130s Selecting previously unselected package liburing2:ppc64el. 130s Preparing to unpack .../35-liburing2_2.11-1_ppc64el.deb ... 130s Unpacking liburing2:ppc64el (2.11-1) ... 130s Selecting previously unselected package samba. 130s Preparing to unpack .../36-samba_2%3a4.23.4+dfsg-1ubuntu1_ppc64el.deb ... 130s Unpacking samba (2:4.23.4+dfsg-1ubuntu1) ... 130s Selecting previously unselected package libsmbclient0:ppc64el. 130s Preparing to unpack .../37-libsmbclient0_2%3a4.23.4+dfsg-1ubuntu1_ppc64el.deb ... 130s Unpacking libsmbclient0:ppc64el (2:4.23.4+dfsg-1ubuntu1) ... 130s Selecting previously unselected package smbclient. 130s Preparing to unpack .../38-smbclient_2%3a4.23.4+dfsg-1ubuntu1_ppc64el.deb ... 130s Unpacking smbclient (2:4.23.4+dfsg-1ubuntu1) ... 131s Setting up libarchive-zip-perl (1.68-1) ... 131s Setting up libtdb1:ppc64el (2:1.4.14+samba4.23.4+dfsg-1ubuntu1) ... 131s Setting up libhtml-tagset-perl (3.24-1) ... 131s Setting up samba-common (2:4.23.4+dfsg-1ubuntu1) ... 131s Creating config file /etc/samba/smb.conf with new version 131s Setting up libwbclient0:ppc64el (2:4.23.4+dfsg-1ubuntu1) ... 131s Setting up libtalloc2:ppc64el (2:2.4.3+samba4.23.4+dfsg-1ubuntu1) ... 131s Setting up backuppc-rsync (3.1.3.0-5) ... 131s Setting up libavahi-common-data:ppc64el (0.8-17ubuntu2) ... 131s Setting up libtimedate-perl (2.3300-2) ... 131s Setting up libtime-parsedate-perl (2015.103-5) ... 131s Setting up libapr1t64:ppc64el (1.7.6-3) ... 131s Setting up libnsl2:ppc64el (1.3.0-3build4) ... 131s Setting up liblua5.4-0:ppc64el (5.4.8-1) ... 131s Setting up apache2-data (2.4.65-3ubuntu1) ... 131s Setting up liburing2:ppc64el (2.11-1) ... 131s Setting up libbackuppc-xs-perl:ppc64el (0.62-2build6) ... 131s Setting up liburi-perl (5.34-2build1) ... 131s Setting up libtevent0t64:ppc64el (2:0.17.1+samba4.23.4+dfsg-1ubuntu1) ... 131s Setting up libaprutil1t64:ppc64el (1.6.3-3ubuntu3) ... 131s Setting up libhttp-date-perl (6.06-1) ... 131s Setting up libfile-listing-perl (6.16-1) ... 131s Setting up libavahi-common3:ppc64el (0.8-17ubuntu2) ... 131s Setting up libaprutil1-ldap:ppc64el (1.6.3-3ubuntu3) ... 131s Setting up libaprutil1-dbd-sqlite3:ppc64el (1.6.3-3ubuntu3) ... 131s Setting up postfix (3.10.6-1ubuntu1) ... 131s Created symlink '/etc/systemd/system/multi-user.target.wants/postfix.service' → '/usr/lib/systemd/system/postfix.service'. 132s Creating /etc/postfix/dynamicmaps.cf 132s setting myhostname: autopkgtest.local 132s setting alias maps 132s setting alias database 132s changing /etc/mailname to autopkgtest.local 132s setting myorigin 132s setting destinations: $myhostname, autopkgtest.local, localhost.local, , localhost 132s setting relayhost: 132s setting mynetworks: 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128 132s clearing mailbox_command 132s setting mailbox_size_limit: 0 132s setting recipient_delimiter: + 134s setting inet_interfaces: all 136s setting inet_protocols: all 136s /etc/aliases does not exist, creating it. 136s WARNING: /etc/aliases exists, but does not have a root alias. 136s 136s Postfix (main.cf) is now set up with a default configuration. If you need to 136s make changes, edit /etc/postfix/main.cf (and others) as needed. To view 136s Postfix configuration values, see postconf(1). 136s 136s After modifying main.cf, be sure to run 'systemctl reload postfix'. 136s 138s Setting up libhtml-parser-perl:ppc64el (3.83-1build1) ... 138s Setting up libldb2:ppc64el (2:2.11.0+samba4.23.4+dfsg-1ubuntu1) ... 138s Setting up libavahi-client3:ppc64el (0.8-17ubuntu2) ... 138s Setting up apache2-utils (2.4.65-3ubuntu1) ... 138s Setting up libcgi-pm-perl (4.71-1build1) ... 138s Setting up samba-libs:ppc64el (2:4.23.4+dfsg-1ubuntu1) ... 138s Setting up apache2-bin (2.4.65-3ubuntu1) ... 138s Setting up libsmbclient0:ppc64el (2:4.23.4+dfsg-1ubuntu1) ... 138s Setting up libcups2t64:ppc64el (2.4.16-1ubuntu1) ... 138s Setting up apache2 (2.4.65-3ubuntu1) ... 138s Enabling module mpm_event. 138s Enabling module authz_core. 138s Enabling module authz_host. 138s Enabling module authn_core. 138s Enabling module auth_basic. 138s Enabling module access_compat. 138s Enabling module authn_file. 138s Enabling module authz_user. 138s Enabling module alias. 138s Enabling module dir. 138s Enabling module autoindex. 138s Enabling module env. 138s Enabling module mime. 138s Enabling module negotiation. 138s Enabling module setenvif. 138s Enabling module filter. 138s Enabling module deflate. 138s Enabling module status. 138s Enabling module reqtimeout. 138s Enabling conf charset. 138s Enabling conf localized-error-pages. 138s Enabling conf other-vhosts-access-log. 138s Enabling conf security. 138s Enabling conf serve-cgi-bin. 138s Enabling site 000-default. 139s Created symlink '/etc/systemd/system/multi-user.target.wants/apache2.service' → '/usr/lib/systemd/system/apache2.service'. 140s Created symlink '/etc/systemd/system/multi-user.target.wants/apache-htcacheclean.service' → '/usr/lib/systemd/system/apache-htcacheclean.service'. 141s Setting up backuppc (4.4.0-11) ... 141s 141s apache2_invoke: Enable configuration backuppc.conf 141s Adding password for user backuppc 141s Considering dependency authn_core for auth_basic: 141s Module authn_core already enabled 141s Module auth_basic already enabled 141s Considering dependency authz_core for authz_groupfile: 141s Module authz_core already enabled 141s Enabling module authz_groupfile. 141s To activate the new configuration, you need to run: 141s systemctl restart apache2 141s Module authn_file already enabled 141s Considering dependency authz_core for authz_user: 141s Module authz_core already enabled 141s Module authz_user already enabled 141s Your MPM seems to be threaded. Selecting cgid instead of cgi. 141s Enabling module cgid. 141s To activate the new configuration, you need to run: 141s systemctl restart apache2 141s Creating config file /etc/backuppc/config.pl with new version 142s Created symlink '/etc/systemd/system/multi-user.target.wants/backuppc.service' → '/usr/lib/systemd/system/backuppc.service'. 142s Setting up smbclient (2:4.23.4+dfsg-1ubuntu1) ... 142s Setting up samba-common-bin (2:4.23.4+dfsg-1ubuntu1) ... 142s Setting up samba (2:4.23.4+dfsg-1ubuntu1) ... 143s Created symlink '/etc/systemd/system/smb.service' → '/usr/lib/systemd/system/smbd.service'. 143s Created symlink '/etc/systemd/system/multi-user.target.wants/smbd.service' → '/usr/lib/systemd/system/smbd.service'. 144s Created symlink '/etc/systemd/system/nmb.service' → '/usr/lib/systemd/system/nmbd.service'. 144s Created symlink '/etc/systemd/system/multi-user.target.wants/nmbd.service' → '/usr/lib/systemd/system/nmbd.service'. 144s Processing triggers for rsyslog (8.2512.0-1ubuntu2) ... 144s Processing triggers for ufw (0.36.2-9build1) ... 144s Processing triggers for man-db (2.13.1-1) ... 147s Processing triggers for libc-bin (2.42-2ubuntu4) ... 147s Processing triggers for postfix (3.10.6-1ubuntu1) ... 147s Restarting postfix 149s autopkgtest [06:28:27]: test smb-backup: [----------------------- 149s net.ipv4.ping_group_range = 0 1000 149s Populating share path 149s Adding samba share 149s Adding [public] share 149s Configuring backuppc 149s Performing a full backup 150s Backup type: type = full, needs_full = 1, needs_incr = 1, lastFullTime = 0, opts{f} = 1, opts{i} = , opts{F} = 150s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 150s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 150s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.009 150s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.0.z created 2026-01-30 06:28:28 150s Backup prep: type = full, case = 1, inPlace = 1, doDuplicate = 0, newBkupNum = 0, newBkupIdx = 0, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = ) 150s __bpc_progress_state__ backup share "public" 150s Running: /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -Tc - 150s full backup started for share public 150s started full dump, share=public 150s Xfer PIDs are now 3746,3745 150s xferPids 3746,3745 150s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -Tc - 150s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 1 150s tarmode is now full, system, hidden, noreset, noverbose 150s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 150s __bpc_progress_fileCnt__ 0 150s new 644 0/0 480434 tmp.Ml33b4 150s new 644 0/0 480434 tmp.aWxCVH 150s new 644 0/0 480434 tmp.5oQi1x 150s new 644 0/0 480434 tmp.wER7mU 150s new 644 0/0 480434 tmp.R94dMj 150s new 644 0/0 480434 tmp.mwUODM 150s new 644 0/0 480434 tmp.zy4UeD 150s new 644 0/0 480434 tmp.lCwu81 150s tar: dumped 10 files and 0 directories 150s Total bytes written: 4804340 (37.7 MiB/s) 150s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 150s new 644 0/0 480434 tmp.FbtHee 150s new 644 0/0 480434 tmp.d6v0Rn 150s __bpc_progress_fileCnt__ 10 150s tarExtract: Done: 0 errors, 0 filesExist, 0 sizeExist, 0 sizeExistComp, 10 filesTotal, 4804340 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377764 sizeNewComp, 13 inodeLast 150s Xfer PIDs are now 150s xferPids 150s full backup 0 complete, 10 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 150s BackupExpire: cntFull = 1, cntIncr = 0, firstFull = 0, firstIncr = , oldestIncr = 0, oldestFull = 0 150s __bpc_progress_state__ fsck 150s Running BackupPC_refCountUpdate -h localhost on localhost 150s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 150s Xfer PIDs are now 3752 150s xferPids 3752 150s BackupPC_refCountUpdate: doing fsck on localhost #0 (full) since $ConfRefCntFsck == 1 150s __bpc_progress_state__ refCnt #0 150s __bpc_progress_state__ cntUpdate #0 150s __bpc_progress_state__ rename #0 150s __bpc_progress_state__ sumUpdate 150s __bpc_progress_fileCnt__ 0/128 150s __bpc_progress_fileCnt__ 8/128 150s __bpc_progress_fileCnt__ 16/128 150s __bpc_progress_fileCnt__ 24/128 150s __bpc_progress_fileCnt__ 32/128 150s __bpc_progress_fileCnt__ 40/128 150s __bpc_progress_fileCnt__ 48/128 150s __bpc_progress_fileCnt__ 56/128 150s __bpc_progress_fileCnt__ 64/128 150s __bpc_progress_fileCnt__ 72/128 150s __bpc_progress_fileCnt__ 80/128 150s __bpc_progress_fileCnt__ 88/128 150s __bpc_progress_fileCnt__ 96/128 150s __bpc_progress_fileCnt__ 104/128 150s __bpc_progress_fileCnt__ 112/128 150s __bpc_progress_fileCnt__ 120/128 150s __bpc_progress_state__ rename total 150s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 150s Xfer PIDs are now 150s xferPids 150s Finished BackupPC_refCountUpdate (running time: 0 sec) 150s Xfer PIDs are now 150s xferPids 150s full backup complete 150s OK: Full backup succeeded 150s Changing share content and performing an incremental backup 150s Backup type: type = incr, needs_full = , needs_incr = , lastFullTime = 1769754508, opts{f} = , opts{i} = 1, opts{F} = 150s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 150s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 150s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.010 150s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.1.z created 2026-01-30 06:28:28 150s Backup prep: type = incr, case = 3, inPlace = 1, doDuplicate = 1, newBkupNum = 1, newBkupIdx = 1, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = ) 150s Executing /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 150s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 150s Xfer PIDs are now 3823 150s xferPids 3823 150s __bpc_progress_state__ copy #0 -> #1 150s Copying backup #0 to #1 150s __bpc_progress_fileCnt__ 3 dirs 150s Xfer PIDs are now 3826,3823 150s xferPids 3826,3823 150s __bpc_progress_state__ sumUpdate 150s __bpc_progress_fileCnt__ 0/128 150s __bpc_progress_fileCnt__ 8/128 150s __bpc_progress_fileCnt__ 16/128 150s __bpc_progress_fileCnt__ 24/128 150s __bpc_progress_fileCnt__ 32/128 150s __bpc_progress_fileCnt__ 40/128 150s __bpc_progress_fileCnt__ 48/128 150s __bpc_progress_fileCnt__ 56/128 150s __bpc_progress_fileCnt__ 64/128 150s __bpc_progress_fileCnt__ 72/128 150s __bpc_progress_fileCnt__ 80/128 150s __bpc_progress_fileCnt__ 88/128 150s __bpc_progress_fileCnt__ 96/128 150s __bpc_progress_fileCnt__ 104/128 150s __bpc_progress_fileCnt__ 112/128 150s __bpc_progress_fileCnt__ 120/128 150s __bpc_progress_state__ rename total 150s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 150s Xfer PIDs are now 3823 150s xferPids 3823 150s BackupPC_backupDuplicate: got 0 errors and 0 file open errors 150s Finished BackupPC_backupDuplicate (running time: 1 sec) 150s __bpc_progress_state__ backup share "public" 150s Running: /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 150s incr backup started back to 2026-01-30 05:28:28 (backup #0) for share public 150s started incr dump, share=public 150s Xfer PIDs are now 3830,3829 150s xferPids 3830,3829 150s 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 - 150s tar:1306 Getting files newer than Fri Jan 30 05:28:28 2026 150s tarmode is now full, system, hidden, noreset, noverbose 150s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 150s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 150s __bpc_progress_fileCnt__ 0 150s new 644 0/0 480434 tmp.ErxwP7 150s new 644 0/0 480434 tmp.uB8JKQ 150s new 644 0/0 480434 tmp.EwxGkL 150s new 644 0/0 480434 tmp.hqfbs9 150s same 644 0/0 480434 tmp.Ml33b4 150s same 644 0/0 480434 tmp.aWxCVH 150s new 644 0/0 480434 tmp.qBUdcU 150s new 644 0/0 480434 tmp.Hi4OMe 150s new 644 0/0 480434 tmp.28y7WC 150s same 644 0/0 480434 tmp.5oQi1x 150s same 644 0/0 480434 tmp.wER7mU 150s new 644 0/0 480434 tmp.bYBJnH 150s same 644 0/0 480434 tmp.R94dMj 150s same 644 0/0 480434 tmp.mwUODM 150s same 644 0/0 480434 tmp.zy4UeD 150s same 644 0/0 480434 tmp.lCwu81 150s same 644 0/0 480434 tmp.FbtHee 150s same 644 0/0 480434 tmp.d6v0Rn 151s tar: dumped 20 files and 0 directories 151s Total bytes written: 9608680 (41.4 MiB/s) 151s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 151s new 644 0/0 480434 tmp.PkLete 151s new 644 0/0 480434 tmp.H8PqUH 151s __bpc_progress_fileCnt__ 20 151s tarExtract: Done: 0 errors, 10 filesExist, 4804340 sizeExist, 1377764 sizeExistComp, 20 filesTotal, 9608680 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377753 sizeNewComp, 24 inodeLast 151s Xfer PIDs are now 151s xferPids 151s incr backup 1 complete, 20 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 151s BackupExpire: cntFull = 2, cntIncr = 0, firstFull = 0, firstIncr = , oldestIncr = 0, oldestFull = 1.15740740740741e-05 151s __bpc_progress_state__ fsck 151s Running BackupPC_refCountUpdate -h localhost on localhost 151s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 151s Xfer PIDs are now 3836 151s xferPids 3836 151s __bpc_progress_state__ cntUpdate #1 151s __bpc_progress_state__ rename #1 151s __bpc_progress_state__ sumUpdate 151s __bpc_progress_fileCnt__ 0/128 151s __bpc_progress_fileCnt__ 8/128 151s __bpc_progress_fileCnt__ 16/128 151s __bpc_progress_fileCnt__ 24/128 151s __bpc_progress_fileCnt__ 32/128 151s __bpc_progress_fileCnt__ 40/128 151s __bpc_progress_fileCnt__ 48/128 151s __bpc_progress_fileCnt__ 56/128 151s __bpc_progress_fileCnt__ 64/128 151s __bpc_progress_fileCnt__ 72/128 151s __bpc_progress_fileCnt__ 80/128 151s __bpc_progress_fileCnt__ 88/128 151s __bpc_progress_fileCnt__ 96/128 151s __bpc_progress_fileCnt__ 104/128 151s __bpc_progress_fileCnt__ 112/128 151s __bpc_progress_fileCnt__ 120/128 151s __bpc_progress_state__ rename total 151s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 151s Xfer PIDs are now 151s xferPids 151s Finished BackupPC_refCountUpdate (running time: 0 sec) 151s Xfer PIDs are now 151s xferPids 151s incr backup complete 151s OK: Incremental backup succeeded 151s Done. 151s autopkgtest [06:28:29]: test smb-backup: -----------------------] 151s autopkgtest [06:28:29]: test smb-backup: - - - - - - - - - - results - - - - - - - - - - 151s smb-backup PASS 152s autopkgtest [06:28:30]: test authenticated-smb-backup: preparing testbed 152s Reading package lists... 152s Building dependency tree... 152s Reading state information... 152s Solving dependencies... 152s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 153s autopkgtest [06:28:31]: test authenticated-smb-backup: [----------------------- 153s Populating share path 153s Adding samba share 153s Adding [private] share 153s Creating user 153s Creating a local and samba user called smbtest4017 154s Setting samba password for the smbtest4017 user 154s Added user smbtest4017. 154s Configuring backuppc 154s Performing a full backup 154s Backup type: type = full, needs_full = , needs_incr = , lastFullTime = 1769754508, opts{f} = 1, opts{i} = , opts{F} = 154s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 154s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 154s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.013 154s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.2.z created 2026-01-30 06:28:32 154s Backup prep: type = full, case = 4, inPlace = 0, doDuplicate = 0, newBkupNum = 2, newBkupIdx = 2, lastBkupNum = 1, lastBkupIdx = 1 (FillCycle = 0, noFillCnt = 0) 154s __bpc_progress_state__ backup share "private" 154s Running: /usr/bin/smbclient \\\\localhost\\private -U smbtest4017 -E -d 1 -c tarmode\ full -mSMB3 -Tc - 154s full backup started for share private 154s started full dump, share=private 154s Xfer PIDs are now 4109,4108 154s xferPids 4109,4108 154s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\private -U smbtest4017 -E -d 1 -c tarmode\ full -mSMB3 -Tc - 154s tarmode is now full, system, hidden, noreset, noverbose 154s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 1 154s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 154s __bpc_progress_fileCnt__ 0 154s new 644 0/0 480434 tmp.bv1AM4 154s new 644 0/0 480434 tmp.yy3n5I 154s new 644 0/0 480434 tmp.NHxBpK 154s new 644 0/0 480434 tmp.dDBfBT 154s new 644 0/0 480434 tmp.HGrx5n 154s new 644 0/0 480434 tmp.t3EsBB 154s new 644 0/0 480434 tmp.hTVjp5 154s new 644 0/0 480434 tmp.z5FDSD 154s new 644 0/0 480434 tmp.bTGqkx 154s tar: dumped 10 files and 0 directories 154s Total bytes written: 4804340 (33.2 MiB/s) 154s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 154s new 644 0/0 480434 tmp.UD7F6G 154s __bpc_progress_fileCnt__ 10 154s tarExtract: Done: 0 errors, 0 filesExist, 0 sizeExist, 0 sizeExistComp, 10 filesTotal, 4804340 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377790 sizeNewComp, 36 inodeLast 154s Xfer PIDs are now 154s xferPids 154s OrphanShareNameClean: removing orphan share public from /var/lib/backuppc/pc/localhost/2 154s __bpc_progress_state__ delete share #2/public 154s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDelete -h localhost -n 2 -l -m -s public / 154s Xfer PIDs are now 4116 154s xferPids 4116 154s BackupPC_backupDelete: removing #2/public/ 154s __bpc_progress_state__ merge #2/public/ -> #1/public/ 154s BackupPC_backupDelete: Merge into backup 1/public/ 154s mergeDir: attr write to /var/lib/backuppc/pc/localhost/1/fpublic//attrib failed (digest was ) 154s bpc_attrib_dirWrite: can't open/create raw /var/lib/backuppc/pc/localhost/1/fpublic for writing 154s Xfer PIDs are now 4116,4119 154s xferPids 4116,4119 154s __bpc_progress_state__ refCnt #1 154s __bpc_progress_state__ cntUpdate #1 154s __bpc_progress_state__ rename #1 154s __bpc_progress_state__ refCnt #2 154s BackupPC_refCountUpdate: localhost #2 inodeLast set to 37 (was 24) 154s __bpc_progress_state__ cntUpdate #2 154s __bpc_progress_state__ rename #2 154s __bpc_progress_state__ sumUpdate 154s __bpc_progress_fileCnt__ 0/128 154s __bpc_progress_fileCnt__ 8/128 154s __bpc_progress_fileCnt__ 16/128 154s __bpc_progress_fileCnt__ 24/128 154s __bpc_progress_fileCnt__ 32/128 154s __bpc_progress_fileCnt__ 40/128 154s __bpc_progress_fileCnt__ 48/128 154s __bpc_progress_fileCnt__ 56/128 154s __bpc_progress_fileCnt__ 64/128 154s __bpc_progress_fileCnt__ 72/128 154s __bpc_progress_fileCnt__ 80/128 154s __bpc_progress_fileCnt__ 88/128 154s __bpc_progress_fileCnt__ 96/128 154s __bpc_progress_fileCnt__ 104/128 154s __bpc_progress_fileCnt__ 112/128 154s __bpc_progress_fileCnt__ 120/128 154s __bpc_progress_state__ rename total 154s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 154s Xfer PIDs are now 4116 154s xferPids 4116 154s Xfer PIDs are now 154s xferPids 154s Finished BackupPC_backupDelete, status = 0 (running time: 0 sec) 154s Xfer PIDs are now 154s xferPids 154s full backup 2 complete, 10 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 154s BackupExpire: cntFull = 2, cntIncr = 1, firstFull = 0, firstIncr = 1, oldestIncr = 3.47222222222222e-05, oldestFull = 4.62962962962963e-05 154s __bpc_progress_state__ fsck 154s Running BackupPC_refCountUpdate -h localhost on localhost 154s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 154s Xfer PIDs are now 4122 154s xferPids 4122 154s BackupPC_refCountUpdate: doing fsck on localhost #2 (full) since $ConfRefCntFsck == 1 154s __bpc_progress_state__ refCnt #2 154s __bpc_progress_state__ cntUpdate #2 154s __bpc_progress_state__ rename #2 154s __bpc_progress_state__ sumUpdate 154s __bpc_progress_fileCnt__ 0/128 154s __bpc_progress_fileCnt__ 8/128 154s __bpc_progress_fileCnt__ 16/128 154s __bpc_progress_fileCnt__ 24/128 154s __bpc_progress_fileCnt__ 32/128 154s __bpc_progress_fileCnt__ 40/128 154s __bpc_progress_fileCnt__ 48/128 154s __bpc_progress_fileCnt__ 56/128 154s __bpc_progress_fileCnt__ 64/128 154s __bpc_progress_fileCnt__ 72/128 154s __bpc_progress_fileCnt__ 80/128 154s __bpc_progress_fileCnt__ 88/128 154s __bpc_progress_fileCnt__ 96/128 154s __bpc_progress_fileCnt__ 104/128 154s __bpc_progress_fileCnt__ 112/128 154s __bpc_progress_fileCnt__ 120/128 154s __bpc_progress_state__ rename total 154s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 154s Xfer PIDs are now 154s xferPids 154s Finished BackupPC_refCountUpdate (running time: 1 sec) 154s Xfer PIDs are now 154s xferPids 154s full backup complete 154s OK: Full backup succeeded 154s Changing share content and performing an incremental backup 154s Backup type: type = incr, needs_full = , needs_incr = , lastFullTime = 1769754512, opts{f} = , opts{i} = 1, opts{F} = 154s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 154s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 154s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.017 154s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.3.z created 2026-01-30 06:28:33 154s Backup prep: type = incr, case = 3, inPlace = 1, doDuplicate = 1, newBkupNum = 3, newBkupIdx = 3, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = 1) 154s Executing /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 154s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 155s Xfer PIDs are now 4193 155s xferPids 4193 155s __bpc_progress_state__ copy #2 -> #3 155s Copying backup #2 to #3 155s __bpc_progress_fileCnt__ 3 dirs 155s Xfer PIDs are now 4193,4196 155s xferPids 4193,4196 155s __bpc_progress_state__ sumUpdate 155s __bpc_progress_fileCnt__ 0/128 155s __bpc_progress_fileCnt__ 8/128 155s __bpc_progress_fileCnt__ 16/128 155s __bpc_progress_fileCnt__ 24/128 155s __bpc_progress_fileCnt__ 32/128 155s __bpc_progress_fileCnt__ 40/128 155s __bpc_progress_fileCnt__ 48/128 155s __bpc_progress_fileCnt__ 56/128 155s __bpc_progress_fileCnt__ 64/128 155s __bpc_progress_fileCnt__ 72/128 155s __bpc_progress_fileCnt__ 80/128 155s __bpc_progress_fileCnt__ 88/128 155s __bpc_progress_fileCnt__ 96/128 155s __bpc_progress_fileCnt__ 104/128 155s __bpc_progress_fileCnt__ 112/128 155s __bpc_progress_fileCnt__ 120/128 155s __bpc_progress_state__ rename total 155s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 155s Xfer PIDs are now 4193 155s xferPids 4193 155s BackupPC_backupDuplicate: got 0 errors and 0 file open errors 155s Finished BackupPC_backupDuplicate (running time: 0 sec) 155s __bpc_progress_state__ backup share "private" 155s Running: /usr/bin/smbclient \\\\localhost\\private -U smbtest4017 -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 155s incr backup started back to 2026-01-30 05:28:32 (backup #2) for share private 155s started incr dump, share=private 155s Xfer PIDs are now 4200,4199 155s xferPids 4200,4199 155s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\private -U smbtest4017 -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 155s tar:1306 Getting files newer than Fri Jan 30 05:28:32 2026 155s tarmode is now full, system, hidden, noreset, noverbose 155s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 155s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 155s __bpc_progress_fileCnt__ 0 155s same 644 0/0 480434 tmp.bv1AM4 155s same 644 0/0 480434 tmp.yy3n5I 155s new 644 0/0 480434 tmp.ovtz5g 155s new 644 0/0 480434 tmp.uX7xUg 155s same 644 0/0 480434 tmp.NHxBpK 155s new 644 0/0 480434 tmp.s9ycan 155s same 644 0/0 480434 tmp.dDBfBT 155s same 644 0/0 480434 tmp.HGrx5n 155s new 644 0/0 480434 tmp.3sKSNx 155s new 644 0/0 480434 tmp.PxRpWz 155s same 644 0/0 480434 tmp.t3EsBB 155s same 644 0/0 480434 tmp.hTVjp5 155s same 644 0/0 480434 tmp.z5FDSD 155s new 644 0/0 480434 tmp.rIgvBt 155s new 644 0/0 480434 tmp.4P3TZM 155s new 644 0/0 480434 tmp.K8Ovuv 155s same 644 0/0 480434 tmp.bTGqkx 155s new 644 0/0 480434 tmp.EVDg0V 155s same 644 0/0 480434 tmp.UD7F6G 155s tar: dumped 20 files and 0 directories 155s Total bytes written: 9608680 (34.4 MiB/s) 155s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 155s new 644 0/0 480434 tmp.QtLQZR 155s __bpc_progress_fileCnt__ 20 155s tarExtract: Done: 0 errors, 10 filesExist, 4804340 sizeExist, 1377790 sizeExistComp, 20 filesTotal, 9608680 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377772 sizeNewComp, 47 inodeLast 155s Xfer PIDs are now 155s xferPids 155s incr backup 3 complete, 20 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 155s BackupExpire: cntFull = 3, cntIncr = 1, firstFull = 0, firstIncr = 1, oldestIncr = 4.62962962962963e-05, oldestFull = 5.78703703703704e-05 155s __bpc_progress_state__ fsck 155s Running BackupPC_refCountUpdate -h localhost on localhost 155s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 155s Xfer PIDs are now 4207 155s xferPids 4207 155s __bpc_progress_state__ cntUpdate #3 155s __bpc_progress_state__ rename #3 155s __bpc_progress_state__ sumUpdate 155s __bpc_progress_fileCnt__ 0/128 155s __bpc_progress_fileCnt__ 8/128 155s __bpc_progress_fileCnt__ 16/128 155s __bpc_progress_fileCnt__ 24/128 155s __bpc_progress_fileCnt__ 32/128 155s __bpc_progress_fileCnt__ 40/128 155s __bpc_progress_fileCnt__ 48/128 155s __bpc_progress_fileCnt__ 56/128 155s __bpc_progress_fileCnt__ 64/128 155s __bpc_progress_fileCnt__ 72/128 155s __bpc_progress_fileCnt__ 80/128 155s __bpc_progress_fileCnt__ 88/128 155s __bpc_progress_fileCnt__ 96/128 155s __bpc_progress_fileCnt__ 104/128 155s __bpc_progress_fileCnt__ 112/128 155s __bpc_progress_fileCnt__ 120/128 155s __bpc_progress_state__ rename total 155s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 155s Xfer PIDs are now 155s xferPids 155s Finished BackupPC_refCountUpdate (running time: 0 sec) 155s Xfer PIDs are now 155s xferPids 155s incr backup complete 155s OK: Incremental backup succeeded 155s Done. 155s Deleted user smbtest4017. 155s userdel: smbtest4017 mail spool (/var/mail/smbtest4017) not found 156s autopkgtest [06:28:34]: test authenticated-smb-backup: -----------------------] 156s autopkgtest [06:28:34]: test authenticated-smb-backup: - - - - - - - - - - results - - - - - - - - - - 156s authenticated-smb-backup PASS 157s autopkgtest [06:28:35]: @@@@@@@@@@@@@@@@@@@@ summary 157s smb-backup PASS 157s authenticated-smb-backup PASS