0s autopkgtest [23:15:36]: starting date and time: 2024-11-20 23:15:36+0000 0s autopkgtest [23:15:36]: git checkout: 0acbae0a WIP show VirtSubproc stderr in real-time 0s autopkgtest [23:15:36]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.krxxfewx/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:iputils --apt-upgrade backuppc --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=iputils/3:20240905-1 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-s390x-1.secgroup --name adt-plucky-s390x-backuppc-20241120-231536-juju-7f2275-prod-proposed-migration-environment-2-06323453-8cfa-40b6-9492-711be0ae35ad --image adt/ubuntu-plucky-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration-s390x -e TERM=linux -e ''"'"'http_proxy=http://squid.internal:3128'"'"'' -e ''"'"'https_proxy=http://squid.internal:3128'"'"'' -e ''"'"'no_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 98s autopkgtest [23:17:14]: testbed dpkg architecture: s390x 99s autopkgtest [23:17:15]: testbed apt version: 2.9.8 99s autopkgtest [23:17:15]: @@@@@@@@@@@@@@@@@@@@ test bed setup 99s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 100s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [12.8 kB] 100s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [9704 B] 100s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [847 kB] 100s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [55.0 kB] 100s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [68.6 kB] 100s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/restricted s390x Packages [756 B] 100s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [649 kB] 100s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [3772 B] 100s Fetched 1721 kB in 1s (2154 kB/s) 100s Reading package lists... 102s Reading package lists... 102s Building dependency tree... 102s Reading state information... 102s Calculating upgrade... 103s The following NEW packages will be installed: 103s linux-sysctl-defaults 103s The following packages will be upgraded: 103s bpftrace curl distro-info gir1.2-girepository-2.0 gir1.2-glib-2.0 103s iputils-ping iputils-tracepath libaudit-common libaudit1 libcurl3t64-gnutls 103s libcurl4t64 libgirepository-1.0-1 libglib2.0-0t64 libglib2.0-data 103s libselinux1 libsemanage-common libsemanage2 linux-base openssh-client 103s openssh-server openssh-sftp-server python3-yaml 103s 22 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 103s Need to get 6741 kB of archives. 103s After this operation, 601 kB of additional disk space will be used. 103s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x libselinux1 s390x 3.7-3ubuntu1 [85.2 kB] 103s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x openssh-sftp-server s390x 1:9.9p1-3ubuntu1 [38.2 kB] 103s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x openssh-server s390x 1:9.9p1-3ubuntu1 [552 kB] 103s Get:4 http://ftpmaster.internal/ubuntu plucky/main s390x openssh-client s390x 1:9.9p1-3ubuntu1 [955 kB] 103s Get:5 http://ftpmaster.internal/ubuntu plucky/main s390x libaudit-common all 1:4.0.2-2ubuntu1 [6578 B] 103s Get:6 http://ftpmaster.internal/ubuntu plucky/main s390x libaudit1 s390x 1:4.0.2-2ubuntu1 [52.5 kB] 103s Get:7 http://ftpmaster.internal/ubuntu plucky/main s390x libsemanage-common all 3.7-2build1 [7186 B] 103s Get:8 http://ftpmaster.internal/ubuntu plucky/main s390x libsemanage2 s390x 3.7-2build1 [97.1 kB] 103s Get:9 http://ftpmaster.internal/ubuntu plucky/main s390x distro-info s390x 1.12 [20.0 kB] 103s Get:10 http://ftpmaster.internal/ubuntu plucky/main s390x gir1.2-girepository-2.0 s390x 1.82.0-2 [25.0 kB] 103s Get:11 http://ftpmaster.internal/ubuntu plucky/main s390x gir1.2-glib-2.0 s390x 2.82.2-3 [180 kB] 103s Get:12 http://ftpmaster.internal/ubuntu plucky/main s390x libglib2.0-0t64 s390x 2.82.2-3 [1575 kB] 103s Get:13 http://ftpmaster.internal/ubuntu plucky/main s390x libgirepository-1.0-1 s390x 1.82.0-2 [84.9 kB] 103s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x iputils-ping s390x 3:20240905-1 [46.6 kB] 103s Get:15 http://ftpmaster.internal/ubuntu plucky/main s390x libglib2.0-data all 2.82.2-3 [51.7 kB] 103s Get:16 http://ftpmaster.internal/ubuntu plucky/main s390x python3-yaml s390x 6.0.2-1build1 [188 kB] 103s Get:17 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x iputils-tracepath s390x 3:20240905-1 [13.6 kB] 103s Get:18 http://ftpmaster.internal/ubuntu plucky/main s390x bpftrace s390x 0.21.2-2ubuntu3 [1718 kB] 103s Get:19 http://ftpmaster.internal/ubuntu plucky/main s390x curl s390x 8.9.1-2ubuntu3 [241 kB] 103s Get:20 http://ftpmaster.internal/ubuntu plucky/main s390x libcurl4t64 s390x 8.9.1-2ubuntu3 [386 kB] 103s Get:21 http://ftpmaster.internal/ubuntu plucky/main s390x libcurl3t64-gnutls s390x 8.9.1-2ubuntu3 [379 kB] 103s Get:22 http://ftpmaster.internal/ubuntu plucky/main s390x linux-base all 4.10.1ubuntu1 [34.8 kB] 103s Get:23 http://ftpmaster.internal/ubuntu plucky/main s390x linux-sysctl-defaults all 4.10.1ubuntu1 [5432 B] 104s Preconfiguring packages ... 104s Fetched 6741 kB in 1s (8570 kB/s) 104s (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 ... 55541 files and directories currently installed.) 104s Preparing to unpack .../libselinux1_3.7-3ubuntu1_s390x.deb ... 104s Unpacking libselinux1:s390x (3.7-3ubuntu1) over (3.5-2ubuntu5) ... 104s Setting up libselinux1:s390x (3.7-3ubuntu1) ... 104s (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 ... 55541 files and directories currently installed.) 104s Preparing to unpack .../openssh-sftp-server_1%3a9.9p1-3ubuntu1_s390x.deb ... 104s Unpacking openssh-sftp-server (1:9.9p1-3ubuntu1) over (1:9.7p1-7ubuntu5) ... 104s Preparing to unpack .../openssh-server_1%3a9.9p1-3ubuntu1_s390x.deb ... 104s Unpacking openssh-server (1:9.9p1-3ubuntu1) over (1:9.7p1-7ubuntu5) ... 104s Preparing to unpack .../openssh-client_1%3a9.9p1-3ubuntu1_s390x.deb ... 104s Unpacking openssh-client (1:9.9p1-3ubuntu1) over (1:9.7p1-7ubuntu5) ... 104s Preparing to unpack .../libaudit-common_1%3a4.0.2-2ubuntu1_all.deb ... 104s Unpacking libaudit-common (1:4.0.2-2ubuntu1) over (1:4.0.1-1ubuntu2) ... 104s Setting up libaudit-common (1:4.0.2-2ubuntu1) ... 104s (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 ... 55543 files and directories currently installed.) 104s Preparing to unpack .../libaudit1_1%3a4.0.2-2ubuntu1_s390x.deb ... 104s Unpacking libaudit1:s390x (1:4.0.2-2ubuntu1) over (1:4.0.1-1ubuntu2) ... 104s Setting up libaudit1:s390x (1:4.0.2-2ubuntu1) ... 104s (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 ... 55543 files and directories currently installed.) 104s Preparing to unpack .../libsemanage-common_3.7-2build1_all.deb ... 104s Unpacking libsemanage-common (3.7-2build1) over (3.5-1build6) ... 104s Setting up libsemanage-common (3.7-2build1) ... 104s (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 ... 55542 files and directories currently installed.) 104s Preparing to unpack .../libsemanage2_3.7-2build1_s390x.deb ... 104s Unpacking libsemanage2:s390x (3.7-2build1) over (3.5-1build6) ... 104s Setting up libsemanage2:s390x (3.7-2build1) ... 104s (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 ... 55542 files and directories currently installed.) 104s Preparing to unpack .../00-distro-info_1.12_s390x.deb ... 104s Unpacking distro-info (1.12) over (1.9) ... 104s Preparing to unpack .../01-gir1.2-girepository-2.0_1.82.0-2_s390x.deb ... 104s Unpacking gir1.2-girepository-2.0:s390x (1.82.0-2) over (1.80.1-4) ... 104s Preparing to unpack .../02-gir1.2-glib-2.0_2.82.2-3_s390x.deb ... 104s Unpacking gir1.2-glib-2.0:s390x (2.82.2-3) over (2.82.1-0ubuntu1) ... 104s Preparing to unpack .../03-libglib2.0-0t64_2.82.2-3_s390x.deb ... 104s Unpacking libglib2.0-0t64:s390x (2.82.2-3) over (2.82.1-0ubuntu1) ... 104s Preparing to unpack .../04-libgirepository-1.0-1_1.82.0-2_s390x.deb ... 104s Unpacking libgirepository-1.0-1:s390x (1.82.0-2) over (1.80.1-4) ... 104s Preparing to unpack .../05-iputils-ping_3%3a20240905-1_s390x.deb ... 104s Unpacking iputils-ping (3:20240905-1) over (3:20240117-1build1) ... 104s Preparing to unpack .../06-libglib2.0-data_2.82.2-3_all.deb ... 104s Unpacking libglib2.0-data (2.82.2-3) over (2.82.1-0ubuntu1) ... 104s Preparing to unpack .../07-python3-yaml_6.0.2-1build1_s390x.deb ... 104s Unpacking python3-yaml (6.0.2-1build1) over (6.0.2-1) ... 104s Preparing to unpack .../08-iputils-tracepath_3%3a20240905-1_s390x.deb ... 104s Unpacking iputils-tracepath (3:20240905-1) over (3:20240117-1build1) ... 104s Preparing to unpack .../09-bpftrace_0.21.2-2ubuntu3_s390x.deb ... 104s Unpacking bpftrace (0.21.2-2ubuntu3) over (0.21.2-2ubuntu2) ... 104s Preparing to unpack .../10-curl_8.9.1-2ubuntu3_s390x.deb ... 104s Unpacking curl (8.9.1-2ubuntu3) over (8.9.1-2ubuntu2) ... 104s Preparing to unpack .../11-libcurl4t64_8.9.1-2ubuntu3_s390x.deb ... 104s Unpacking libcurl4t64:s390x (8.9.1-2ubuntu3) over (8.9.1-2ubuntu2) ... 104s Preparing to unpack .../12-libcurl3t64-gnutls_8.9.1-2ubuntu3_s390x.deb ... 104s Unpacking libcurl3t64-gnutls:s390x (8.9.1-2ubuntu3) over (8.9.1-2ubuntu2) ... 104s Preparing to unpack .../13-linux-base_4.10.1ubuntu1_all.deb ... 104s Unpacking linux-base (4.10.1ubuntu1) over (4.5ubuntu9) ... 104s Selecting previously unselected package linux-sysctl-defaults. 104s Preparing to unpack .../14-linux-sysctl-defaults_4.10.1ubuntu1_all.deb ... 104s Unpacking linux-sysctl-defaults (4.10.1ubuntu1) ... 104s Setting up distro-info (1.12) ... 104s Setting up linux-base (4.10.1ubuntu1) ... 105s Setting up libcurl4t64:s390x (8.9.1-2ubuntu3) ... 105s Setting up bpftrace (0.21.2-2ubuntu3) ... 105s Setting up openssh-client (1:9.9p1-3ubuntu1) ... 105s Setting up libcurl3t64-gnutls:s390x (8.9.1-2ubuntu3) ... 105s Setting up python3-yaml (6.0.2-1build1) ... 105s Setting up libglib2.0-0t64:s390x (2.82.2-3) ... 105s No schema files found: doing nothing. 105s Setting up libglib2.0-data (2.82.2-3) ... 105s Setting up linux-sysctl-defaults (4.10.1ubuntu1) ... 105s Setting up gir1.2-glib-2.0:s390x (2.82.2-3) ... 105s Setting up libgirepository-1.0-1:s390x (1.82.0-2) ... 105s Setting up curl (8.9.1-2ubuntu3) ... 105s Setting up iputils-ping (3:20240905-1) ... 105s Setting up iputils-tracepath (3:20240905-1) ... 105s Setting up openssh-sftp-server (1:9.9p1-3ubuntu1) ... 105s Setting up openssh-server (1:9.9p1-3ubuntu1) ... 105s Installing new version of config file /etc/ssh/moduli ... 105s Setting up gir1.2-girepository-2.0:s390x (1.82.0-2) ... 105s Processing triggers for ufw (0.36.2-8) ... 106s Processing triggers for man-db (2.13.0-1) ... 106s Processing triggers for libc-bin (2.40-1ubuntu3) ... 107s Reading package lists... 107s Building dependency tree... 107s Reading state information... 107s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 107s Hit:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease 107s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 107s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 108s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 108s Reading package lists... 108s Reading package lists... 108s Building dependency tree... 108s Reading state information... 108s Calculating upgrade... 109s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 109s Reading package lists... 109s Building dependency tree... 109s Reading state information... 109s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 109s autopkgtest [23:17:25]: rebooting testbed after setup commands that affected boot 113s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 130s autopkgtest [23:17:46]: testbed running kernel: Linux 6.11.0-8-generic #8-Ubuntu SMP Mon Sep 16 12:49:35 UTC 2024 132s autopkgtest [23:17:48]: @@@@@@@@@@@@@@@@@@@@ apt-source backuppc 134s Get:1 http://ftpmaster.internal/ubuntu plucky/main backuppc 4.4.0-10 (dsc) [2161 B] 134s Get:2 http://ftpmaster.internal/ubuntu plucky/main backuppc 4.4.0-10 (tar) [657 kB] 134s Get:3 http://ftpmaster.internal/ubuntu plucky/main backuppc 4.4.0-10 (diff) [37.5 kB] 134s gpgv: Signature made Sat Jul 27 01:39:43 2024 UTC 134s gpgv: using RSA key FDDD0CFF3864277630A2186C9164FA1D17BD5D36 134s gpgv: Can't check signature: No public key 134s dpkg-source: warning: cannot verify inline signature for ./backuppc_4.4.0-10.dsc: no acceptable signature found 134s autopkgtest [23:17:50]: testing package backuppc version 4.4.0-10 134s autopkgtest [23:17:50]: build not needed 135s autopkgtest [23:17:51]: test smb-backup: preparing testbed 136s Reading package lists... 136s Building dependency tree... 136s Reading state information... 136s Starting pkgProblemResolver with broken count: 0 136s Starting 2 pkgProblemResolver with broken count: 0 136s Done 136s The following additional packages will be installed: 136s apache2 apache2-bin apache2-data apache2-utils backuppc backuppc-rsync 136s libapr1t64 libaprutil1-dbd-sqlite3 libaprutil1-ldap libaprutil1t64 136s libarchive-zip-perl libavahi-client3 libavahi-common-data libavahi-common3 136s libbackuppc-xs-perl libcgi-pm-perl libcups2t64 libfile-listing-perl 136s libhtml-parser-perl libhtml-tagset-perl libhttp-date-perl libldb2 136s liblua5.4-0 libsmbclient0 libtalloc2 libtdb1 libtevent0t64 136s libtime-parsedate-perl libtimedate-perl liburi-perl liburing2 libwbclient0 136s postfix samba samba-common samba-common-bin samba-libs smbclient ssl-cert 136s Suggested packages: 136s apache2-doc apache2-suexec-pristine | apache2-suexec-custom www-browser 136s certbot | acme-tiny | acmetool | dehydrated | lacme | lecm | lego 136s libscgi-perl par2 w3m | www-browser cups-common libdata-dump-perl 136s libbusiness-isbn-perl libmime-base32-perl libregexp-ipv6-perl libwww-perl 136s mail-reader postfix-cdb postfix-doc postfix-ldap postfix-lmdb 136s postfix-mta-sts-resolver postfix-mongodb postfix-mysql postfix-pcre 136s postfix-pgsql postfix-sqlite procmail sasl2-bin | dovecot-common ctdb 136s winbind samba-vfs-ceph samba-vfs-glusterfs heimdal-clients cifs-utils 136s Recommended packages: 136s libio-dirent-perl rrdtool libcgi-fast-perl libhttp-message-perl attr 136s python3-samba 136s The following NEW packages will be installed: 136s apache2 apache2-bin apache2-data apache2-utils autopkgtest-satdep backuppc 136s backuppc-rsync libapr1t64 libaprutil1-dbd-sqlite3 libaprutil1-ldap 136s libaprutil1t64 libarchive-zip-perl libavahi-client3 libavahi-common-data 136s libavahi-common3 libbackuppc-xs-perl libcgi-pm-perl libcups2t64 136s libfile-listing-perl libhtml-parser-perl libhtml-tagset-perl 136s libhttp-date-perl libldb2 liblua5.4-0 libsmbclient0 libtalloc2 libtdb1 136s libtevent0t64 libtime-parsedate-perl libtimedate-perl liburi-perl liburing2 136s libwbclient0 postfix samba samba-common samba-common-bin samba-libs 136s smbclient ssl-cert 136s 0 upgraded, 40 newly installed, 0 to remove and 0 not upgraded. 136s Need to get 15.4 MB/15.4 MB of archives. 136s After this operation, 59.1 MB of additional disk space will be used. 136s Get:1 /tmp/autopkgtest.tTjHWp/1-autopkgtest-satdep.deb autopkgtest-satdep s390x 0 [724 B] 137s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x libapr1t64 s390x 1.7.2-3.2ubuntu1 [114 kB] 137s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x libaprutil1t64 s390x 1.6.3-3ubuntu1 [98.3 kB] 137s Get:4 http://ftpmaster.internal/ubuntu plucky/main s390x libaprutil1-dbd-sqlite3 s390x 1.6.3-3ubuntu1 [11.7 kB] 137s Get:5 http://ftpmaster.internal/ubuntu plucky/main s390x libaprutil1-ldap s390x 1.6.3-3ubuntu1 [9052 B] 137s Get:6 http://ftpmaster.internal/ubuntu plucky/main s390x liblua5.4-0 s390x 5.4.6-3build2 [179 kB] 137s Get:7 http://ftpmaster.internal/ubuntu plucky/main s390x apache2-bin s390x 2.4.62-1ubuntu1 [1408 kB] 137s Get:8 http://ftpmaster.internal/ubuntu plucky/main s390x apache2-data all 2.4.62-1ubuntu1 [163 kB] 137s Get:9 http://ftpmaster.internal/ubuntu plucky/main s390x apache2-utils s390x 2.4.62-1ubuntu1 [101 kB] 137s Get:10 http://ftpmaster.internal/ubuntu plucky/main s390x apache2 s390x 2.4.62-1ubuntu1 [90.4 kB] 137s Get:11 http://ftpmaster.internal/ubuntu plucky/main s390x backuppc-rsync s390x 3.1.3.0-4 [273 kB] 138s Get:12 http://ftpmaster.internal/ubuntu plucky/main s390x ssl-cert all 1.1.2ubuntu2 [18.0 kB] 138s Get:13 http://ftpmaster.internal/ubuntu plucky/main s390x postfix s390x 3.9.0-3 [1283 kB] 138s Get:14 http://ftpmaster.internal/ubuntu plucky/main s390x libarchive-zip-perl all 1.68-1 [90.2 kB] 138s Get:15 http://ftpmaster.internal/ubuntu plucky/main s390x libbackuppc-xs-perl s390x 0.62-2build6 [70.6 kB] 138s Get:16 http://ftpmaster.internal/ubuntu plucky/main s390x libhtml-tagset-perl all 3.24-1 [14.1 kB] 138s Get:17 http://ftpmaster.internal/ubuntu plucky/main s390x liburi-perl all 5.30-1 [94.4 kB] 138s Get:18 http://ftpmaster.internal/ubuntu plucky/main s390x libhtml-parser-perl s390x 3.83-1build1 [87.8 kB] 138s Get:19 http://ftpmaster.internal/ubuntu plucky/main s390x libcgi-pm-perl all 4.66-1 [185 kB] 138s Get:20 http://ftpmaster.internal/ubuntu plucky/main s390x libtimedate-perl all 2.3300-2 [34.0 kB] 138s Get:21 http://ftpmaster.internal/ubuntu plucky/main s390x libhttp-date-perl all 6.06-1 [10.2 kB] 138s Get:22 http://ftpmaster.internal/ubuntu plucky/main s390x libfile-listing-perl all 6.16-1 [11.3 kB] 138s Get:23 http://ftpmaster.internal/ubuntu plucky/main s390x libtime-parsedate-perl all 2015.103-5 [27.9 kB] 138s Get:24 http://ftpmaster.internal/ubuntu plucky/main s390x backuppc s390x 4.4.0-10 [517 kB] 138s Get:25 http://ftpmaster.internal/ubuntu plucky/main s390x samba-common all 2:4.20.4+dfsg-1ubuntu1 [68.0 kB] 138s Get:26 http://ftpmaster.internal/ubuntu plucky/main s390x libavahi-common-data s390x 0.8-13ubuntu6 [29.7 kB] 138s Get:27 http://ftpmaster.internal/ubuntu plucky/main s390x libavahi-common3 s390x 0.8-13ubuntu6 [24.1 kB] 138s Get:28 http://ftpmaster.internal/ubuntu plucky/main s390x libavahi-client3 s390x 0.8-13ubuntu6 [27.2 kB] 138s Get:29 http://ftpmaster.internal/ubuntu plucky/main s390x libcups2t64 s390x 2.4.10-1ubuntu2 [281 kB] 138s Get:30 http://ftpmaster.internal/ubuntu plucky/main s390x libtalloc2 s390x 2.4.2-1build2 [28.4 kB] 138s Get:31 http://ftpmaster.internal/ubuntu plucky/main s390x libtdb1 s390x 1.4.12-1 [49.4 kB] 138s Get:32 http://ftpmaster.internal/ubuntu plucky/main s390x libtevent0t64 s390x 0.16.1-3 [42.6 kB] 138s Get:33 http://ftpmaster.internal/ubuntu plucky/main s390x libldb2 s390x 2:2.9.1+samba4.20.4+dfsg-1ubuntu1 [194 kB] 138s Get:34 http://ftpmaster.internal/ubuntu plucky/main s390x libwbclient0 s390x 2:4.20.4+dfsg-1ubuntu1 [75.3 kB] 138s Get:35 http://ftpmaster.internal/ubuntu plucky/main s390x samba-libs s390x 2:4.20.4+dfsg-1ubuntu1 [6348 kB] 139s Get:36 http://ftpmaster.internal/ubuntu plucky/main s390x samba-common-bin s390x 2:4.20.4+dfsg-1ubuntu1 [1337 kB] 139s Get:37 http://ftpmaster.internal/ubuntu plucky/main s390x liburing2 s390x 2.8-1 [25.5 kB] 139s Get:38 http://ftpmaster.internal/ubuntu plucky/main s390x samba s390x 2:4.20.4+dfsg-1ubuntu1 [1385 kB] 139s Get:39 http://ftpmaster.internal/ubuntu plucky/main s390x libsmbclient0 s390x 2:4.20.4+dfsg-1ubuntu1 [64.9 kB] 139s Get:40 http://ftpmaster.internal/ubuntu plucky/main s390x smbclient s390x 2:4.20.4+dfsg-1ubuntu1 [495 kB] 139s Preconfiguring packages ... 139s Fetched 15.4 MB in 3s (5808 kB/s) 139s Selecting previously unselected package libapr1t64:s390x. 140s (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 ... 55575 files and directories currently installed.) 140s Preparing to unpack .../00-libapr1t64_1.7.2-3.2ubuntu1_s390x.deb ... 140s Unpacking libapr1t64:s390x (1.7.2-3.2ubuntu1) ... 140s Selecting previously unselected package libaprutil1t64:s390x. 140s Preparing to unpack .../01-libaprutil1t64_1.6.3-3ubuntu1_s390x.deb ... 140s Unpacking libaprutil1t64:s390x (1.6.3-3ubuntu1) ... 140s Selecting previously unselected package libaprutil1-dbd-sqlite3:s390x. 140s Preparing to unpack .../02-libaprutil1-dbd-sqlite3_1.6.3-3ubuntu1_s390x.deb ... 140s Unpacking libaprutil1-dbd-sqlite3:s390x (1.6.3-3ubuntu1) ... 140s Selecting previously unselected package libaprutil1-ldap:s390x. 140s Preparing to unpack .../03-libaprutil1-ldap_1.6.3-3ubuntu1_s390x.deb ... 140s Unpacking libaprutil1-ldap:s390x (1.6.3-3ubuntu1) ... 140s Selecting previously unselected package liblua5.4-0:s390x. 140s Preparing to unpack .../04-liblua5.4-0_5.4.6-3build2_s390x.deb ... 140s Unpacking liblua5.4-0:s390x (5.4.6-3build2) ... 140s Selecting previously unselected package apache2-bin. 140s Preparing to unpack .../05-apache2-bin_2.4.62-1ubuntu1_s390x.deb ... 140s Unpacking apache2-bin (2.4.62-1ubuntu1) ... 140s Selecting previously unselected package apache2-data. 140s Preparing to unpack .../06-apache2-data_2.4.62-1ubuntu1_all.deb ... 140s Unpacking apache2-data (2.4.62-1ubuntu1) ... 140s Selecting previously unselected package apache2-utils. 140s Preparing to unpack .../07-apache2-utils_2.4.62-1ubuntu1_s390x.deb ... 140s Unpacking apache2-utils (2.4.62-1ubuntu1) ... 140s Selecting previously unselected package apache2. 140s Preparing to unpack .../08-apache2_2.4.62-1ubuntu1_s390x.deb ... 140s Unpacking apache2 (2.4.62-1ubuntu1) ... 140s Selecting previously unselected package backuppc-rsync. 140s Preparing to unpack .../09-backuppc-rsync_3.1.3.0-4_s390x.deb ... 140s Unpacking backuppc-rsync (3.1.3.0-4) ... 140s Selecting previously unselected package ssl-cert. 140s Preparing to unpack .../10-ssl-cert_1.1.2ubuntu2_all.deb ... 140s Unpacking ssl-cert (1.1.2ubuntu2) ... 140s Selecting previously unselected package postfix. 140s Preparing to unpack .../11-postfix_3.9.0-3_s390x.deb ... 140s Unpacking postfix (3.9.0-3) ... 140s Selecting previously unselected package libarchive-zip-perl. 140s Preparing to unpack .../12-libarchive-zip-perl_1.68-1_all.deb ... 140s Unpacking libarchive-zip-perl (1.68-1) ... 140s Selecting previously unselected package libbackuppc-xs-perl:s390x. 140s Preparing to unpack .../13-libbackuppc-xs-perl_0.62-2build6_s390x.deb ... 140s Unpacking libbackuppc-xs-perl:s390x (0.62-2build6) ... 140s Selecting previously unselected package libhtml-tagset-perl. 140s Preparing to unpack .../14-libhtml-tagset-perl_3.24-1_all.deb ... 140s Unpacking libhtml-tagset-perl (3.24-1) ... 140s Selecting previously unselected package liburi-perl. 140s Preparing to unpack .../15-liburi-perl_5.30-1_all.deb ... 140s Unpacking liburi-perl (5.30-1) ... 140s Selecting previously unselected package libhtml-parser-perl:s390x. 140s Preparing to unpack .../16-libhtml-parser-perl_3.83-1build1_s390x.deb ... 140s Unpacking libhtml-parser-perl:s390x (3.83-1build1) ... 140s Selecting previously unselected package libcgi-pm-perl. 140s Preparing to unpack .../17-libcgi-pm-perl_4.66-1_all.deb ... 140s Unpacking libcgi-pm-perl (4.66-1) ... 140s Selecting previously unselected package libtimedate-perl. 140s Preparing to unpack .../18-libtimedate-perl_2.3300-2_all.deb ... 140s Unpacking libtimedate-perl (2.3300-2) ... 140s Selecting previously unselected package libhttp-date-perl. 140s Preparing to unpack .../19-libhttp-date-perl_6.06-1_all.deb ... 140s Unpacking libhttp-date-perl (6.06-1) ... 140s Selecting previously unselected package libfile-listing-perl. 140s Preparing to unpack .../20-libfile-listing-perl_6.16-1_all.deb ... 140s Unpacking libfile-listing-perl (6.16-1) ... 140s Selecting previously unselected package libtime-parsedate-perl. 140s Preparing to unpack .../21-libtime-parsedate-perl_2015.103-5_all.deb ... 140s Unpacking libtime-parsedate-perl (2015.103-5) ... 140s Selecting previously unselected package backuppc. 140s Preparing to unpack .../22-backuppc_4.4.0-10_s390x.deb ... 140s Unpacking backuppc (4.4.0-10) ... 140s Selecting previously unselected package samba-common. 140s Preparing to unpack .../23-samba-common_2%3a4.20.4+dfsg-1ubuntu1_all.deb ... 140s Unpacking samba-common (2:4.20.4+dfsg-1ubuntu1) ... 140s Selecting previously unselected package libavahi-common-data:s390x. 140s Preparing to unpack .../24-libavahi-common-data_0.8-13ubuntu6_s390x.deb ... 140s Unpacking libavahi-common-data:s390x (0.8-13ubuntu6) ... 140s Selecting previously unselected package libavahi-common3:s390x. 140s Preparing to unpack .../25-libavahi-common3_0.8-13ubuntu6_s390x.deb ... 140s Unpacking libavahi-common3:s390x (0.8-13ubuntu6) ... 140s Selecting previously unselected package libavahi-client3:s390x. 140s Preparing to unpack .../26-libavahi-client3_0.8-13ubuntu6_s390x.deb ... 140s Unpacking libavahi-client3:s390x (0.8-13ubuntu6) ... 140s Selecting previously unselected package libcups2t64:s390x. 140s Preparing to unpack .../27-libcups2t64_2.4.10-1ubuntu2_s390x.deb ... 140s Unpacking libcups2t64:s390x (2.4.10-1ubuntu2) ... 140s Selecting previously unselected package libtalloc2:s390x. 140s Preparing to unpack .../28-libtalloc2_2.4.2-1build2_s390x.deb ... 140s Unpacking libtalloc2:s390x (2.4.2-1build2) ... 140s Selecting previously unselected package libtdb1:s390x. 140s Preparing to unpack .../29-libtdb1_1.4.12-1_s390x.deb ... 140s Unpacking libtdb1:s390x (1.4.12-1) ... 140s Selecting previously unselected package libtevent0t64:s390x. 140s Preparing to unpack .../30-libtevent0t64_0.16.1-3_s390x.deb ... 140s Unpacking libtevent0t64:s390x (0.16.1-3) ... 140s Selecting previously unselected package libldb2:s390x. 140s Preparing to unpack .../31-libldb2_2%3a2.9.1+samba4.20.4+dfsg-1ubuntu1_s390x.deb ... 140s Unpacking libldb2:s390x (2:2.9.1+samba4.20.4+dfsg-1ubuntu1) ... 140s Selecting previously unselected package libwbclient0:s390x. 140s Preparing to unpack .../32-libwbclient0_2%3a4.20.4+dfsg-1ubuntu1_s390x.deb ... 140s Unpacking libwbclient0:s390x (2:4.20.4+dfsg-1ubuntu1) ... 140s Selecting previously unselected package samba-libs:s390x. 140s Preparing to unpack .../33-samba-libs_2%3a4.20.4+dfsg-1ubuntu1_s390x.deb ... 140s Unpacking samba-libs:s390x (2:4.20.4+dfsg-1ubuntu1) ... 140s Selecting previously unselected package samba-common-bin. 140s Preparing to unpack .../34-samba-common-bin_2%3a4.20.4+dfsg-1ubuntu1_s390x.deb ... 140s Unpacking samba-common-bin (2:4.20.4+dfsg-1ubuntu1) ... 140s Selecting previously unselected package liburing2:s390x. 140s Preparing to unpack .../35-liburing2_2.8-1_s390x.deb ... 140s Unpacking liburing2:s390x (2.8-1) ... 140s Selecting previously unselected package samba. 140s Preparing to unpack .../36-samba_2%3a4.20.4+dfsg-1ubuntu1_s390x.deb ... 140s Unpacking samba (2:4.20.4+dfsg-1ubuntu1) ... 140s Selecting previously unselected package libsmbclient0:s390x. 140s Preparing to unpack .../37-libsmbclient0_2%3a4.20.4+dfsg-1ubuntu1_s390x.deb ... 140s Unpacking libsmbclient0:s390x (2:4.20.4+dfsg-1ubuntu1) ... 140s Selecting previously unselected package smbclient. 140s Preparing to unpack .../38-smbclient_2%3a4.20.4+dfsg-1ubuntu1_s390x.deb ... 140s Unpacking smbclient (2:4.20.4+dfsg-1ubuntu1) ... 140s Selecting previously unselected package autopkgtest-satdep. 140s Preparing to unpack .../39-1-autopkgtest-satdep.deb ... 140s Unpacking autopkgtest-satdep (0) ... 140s Setting up libarchive-zip-perl (1.68-1) ... 140s Setting up libtdb1:s390x (1.4.12-1) ... 140s Setting up libhtml-tagset-perl (3.24-1) ... 140s Setting up samba-common (2:4.20.4+dfsg-1ubuntu1) ... 141s 141s Creating config file /etc/samba/smb.conf with new version 141s Setting up libwbclient0:s390x (2:4.20.4+dfsg-1ubuntu1) ... 141s Setting up libtalloc2:s390x (2.4.2-1build2) ... 141s Setting up backuppc-rsync (3.1.3.0-4) ... 141s Setting up ssl-cert (1.1.2ubuntu2) ... 141s Created symlink '/etc/systemd/system/multi-user.target.wants/ssl-cert.service' → '/usr/lib/systemd/system/ssl-cert.service'. 142s Setting up libavahi-common-data:s390x (0.8-13ubuntu6) ... 142s Setting up libtimedate-perl (2.3300-2) ... 142s Setting up postfix (3.9.0-3) ... 143s info: Selecting GID from range 100 to 999 ... 143s info: Adding group `postfix' (GID 111) ... 143s info: Selecting UID from range 100 to 999 ... 143s 143s info: Adding system user `postfix' (UID 107) ... 143s info: Adding new user `postfix' (UID 107) with group `postfix' ... 143s info: Not creating home directory `/var/spool/postfix'. 143s Creating /etc/postfix/dynamicmaps.cf 143s info: Selecting GID from range 100 to 999 ... 143s info: Adding group `postdrop' (GID 112) ... 143s setting myhostname: autopkgtest.local 143s setting alias maps 143s setting alias database 143s changing /etc/mailname to autopkgtest.local 143s setting myorigin 143s setting destinations: $myhostname, autopkgtest.local, localhost.local, , localhost 143s setting relayhost: 143s setting mynetworks: 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128 143s setting mailbox_size_limit: 0 143s setting recipient_delimiter: + 145s setting inet_interfaces: all 147s setting inet_protocols: all 147s /etc/aliases does not exist, creating it. 147s WARNING: /etc/aliases exists, but does not have a root alias. 147s 147s Postfix (main.cf) is now set up with a default configuration. If you need to 147s make changes, edit /etc/postfix/main.cf (and others) as needed. To view 147s Postfix configuration values, see postconf(1). 147s 147s After modifying main.cf, be sure to run 'systemctl reload postfix'. 147s 149s Running newaliases 149s Created symlink '/etc/systemd/system/multi-user.target.wants/postfix.service' → '/usr/lib/systemd/system/postfix.service'. 150s Setting up libtime-parsedate-perl (2015.103-5) ... 150s Setting up libapr1t64:s390x (1.7.2-3.2ubuntu1) ... 150s Setting up liblua5.4-0:s390x (5.4.6-3build2) ... 150s Setting up apache2-data (2.4.62-1ubuntu1) ... 150s Setting up liburing2:s390x (2.8-1) ... 150s Setting up libbackuppc-xs-perl:s390x (0.62-2build6) ... 150s Setting up liburi-perl (5.30-1) ... 150s Setting up libtevent0t64:s390x (0.16.1-3) ... 150s Setting up libaprutil1t64:s390x (1.6.3-3ubuntu1) ... 150s Setting up libhttp-date-perl (6.06-1) ... 150s Setting up libfile-listing-perl (6.16-1) ... 150s Setting up libavahi-common3:s390x (0.8-13ubuntu6) ... 150s Setting up libaprutil1-ldap:s390x (1.6.3-3ubuntu1) ... 150s Setting up libaprutil1-dbd-sqlite3:s390x (1.6.3-3ubuntu1) ... 150s Setting up libhtml-parser-perl:s390x (3.83-1build1) ... 150s Setting up libldb2:s390x (2:2.9.1+samba4.20.4+dfsg-1ubuntu1) ... 150s Setting up libavahi-client3:s390x (0.8-13ubuntu6) ... 150s Setting up apache2-utils (2.4.62-1ubuntu1) ... 150s Setting up libcgi-pm-perl (4.66-1) ... 150s Setting up samba-libs:s390x (2:4.20.4+dfsg-1ubuntu1) ... 150s Setting up apache2-bin (2.4.62-1ubuntu1) ... 150s Setting up libsmbclient0:s390x (2:4.20.4+dfsg-1ubuntu1) ... 150s Setting up libcups2t64:s390x (2.4.10-1ubuntu2) ... 150s Setting up apache2 (2.4.62-1ubuntu1) ... 150s Enabling module mpm_event. 150s Enabling module authz_core. 150s Enabling module authz_host. 150s Enabling module authn_core. 150s Enabling module auth_basic. 150s Enabling module access_compat. 150s Enabling module authn_file. 150s Enabling module authz_user. 150s Enabling module alias. 150s Enabling module dir. 150s Enabling module autoindex. 150s Enabling module env. 150s Enabling module mime. 150s Enabling module negotiation. 150s Enabling module setenvif. 150s Enabling module filter. 150s Enabling module deflate. 150s Enabling module status. 150s Enabling module reqtimeout. 150s Enabling conf charset. 150s Enabling conf localized-error-pages. 150s Enabling conf other-vhosts-access-log. 150s Enabling conf security. 150s Enabling conf serve-cgi-bin. 150s Enabling site 000-default. 151s Created symlink '/etc/systemd/system/multi-user.target.wants/apache2.service' → '/usr/lib/systemd/system/apache2.service'. 151s Created symlink '/etc/systemd/system/multi-user.target.wants/apache-htcacheclean.service' → '/usr/lib/systemd/system/apache-htcacheclean.service'. 152s Setting up backuppc (4.4.0-10) ... 152s 152s apache2_invoke: Enable configuration backuppc.conf 152s warn: The home directory `/var/lib/backuppc' already exists. Not touching this directory. 152s warn: Warning: The home directory `/var/lib/backuppc' does not belong to the user you are currently creating. 152s Adding password for user backuppc 152s Considering dependency authn_core for auth_basic: 152s Module authn_core already enabled 152s Module auth_basic already enabled 152s Considering dependency authz_core for authz_groupfile: 152s Module authz_core already enabled 152s Enabling module authz_groupfile. 152s To activate the new configuration, you need to run: 152s systemctl restart apache2 152s Module authn_file already enabled 152s Considering dependency authz_core for authz_user: 152s Module authz_core already enabled 152s Module authz_user already enabled 153s Your MPM seems to be threaded. Selecting cgid instead of cgi. 153s Enabling module cgid. 153s To activate the new configuration, you need to run: 153s systemctl restart apache2 153s 153s Creating config file /etc/backuppc/config.pl with new version 153s Created symlink '/etc/systemd/system/multi-user.target.wants/backuppc.service' → '/usr/lib/systemd/system/backuppc.service'. 153s Setting up smbclient (2:4.20.4+dfsg-1ubuntu1) ... 153s Setting up samba-common-bin (2:4.20.4+dfsg-1ubuntu1) ... 153s Setting up samba (2:4.20.4+dfsg-1ubuntu1) ... 154s Created symlink '/etc/systemd/system/smb.service' → '/usr/lib/systemd/system/smbd.service'. 154s Created symlink '/etc/systemd/system/multi-user.target.wants/smbd.service' → '/usr/lib/systemd/system/smbd.service'. 154s Created symlink '/etc/systemd/system/nmb.service' → '/usr/lib/systemd/system/nmbd.service'. 154s Created symlink '/etc/systemd/system/multi-user.target.wants/nmbd.service' → '/usr/lib/systemd/system/nmbd.service'. 155s Setting up autopkgtest-satdep (0) ... 155s Processing triggers for rsyslog (8.2406.0-1ubuntu2) ... 155s Processing triggers for ufw (0.36.2-8) ... 155s Processing triggers for man-db (2.13.0-1) ... 156s Processing triggers for libc-bin (2.40-1ubuntu3) ... 158s (Reading database ... 57512 files and directories currently installed.) 158s Removing autopkgtest-satdep (0) ... 159s autopkgtest [23:18:15]: test smb-backup: [----------------------- 159s Populating share path 159s Adding samba share 159s Adding [public] share 159s Configuring backuppc 159s Performing a full backup 159s Backup type: type = full, needs_full = 1, needs_incr = 1, lastFullTime = 0, opts{f} = 1, opts{i} = , opts{F} = 159s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 159s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 159s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.003 159s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.0.z created 2024-11-20 23:18:15 159s Backup prep: type = full, case = 1, inPlace = 1, doDuplicate = 0, newBkupNum = 0, newBkupIdx = 0, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = ) 159s __bpc_progress_state__ backup share "public" 159s Running: /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -Tc - 159s full backup started for share public 159s started full dump, share=public 159s Xfer PIDs are now 3891,3890 159s xferPids 3891,3890 159s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -Tc - 159s tarmode is now full, system, hidden, noreset, noverbose 159s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 1 159s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 159s __bpc_progress_fileCnt__ 0 159s new 644 0/0 480434 tmp.86vvkK 159s new 644 0/0 480434 tmp.feQRDR 159s new 644 0/0 480434 tmp.g4hTWQ 159s new 644 0/0 480434 tmp.kxp6oQ 159s new 644 0/0 480434 tmp.j9BOG6 159s new 644 0/0 480434 tmp.vlAVWC 159s new 644 0/0 480434 tmp.YCP9ei 159s new 644 0/0 480434 tmp.y2xuOo 159s new 644 0/0 480434 tmp.oe0BAZ 159s tar: dumped 10 files and 0 directories 159s Total bytes written: 4804340 (36.9 MiB/s) 159s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 159s new 644 0/0 480434 tmp.3zP5RI 159s __bpc_progress_fileCnt__ 10 159s tarExtract: Done: 0 errors, 0 filesExist, 0 sizeExist, 0 sizeExistComp, 10 filesTotal, 4804340 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377832 sizeNewComp, 13 inodeLast 159s Xfer PIDs are now 159s xferPids 159s full backup 0 complete, 10 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 159s BackupExpire: cntFull = 1, cntIncr = 0, firstFull = 0, firstIncr = , oldestIncr = 0, oldestFull = 0 159s __bpc_progress_state__ fsck 159s Running BackupPC_refCountUpdate -h localhost on localhost 159s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 159s Xfer PIDs are now 3897 159s xferPids 3897 159s BackupPC_refCountUpdate: doing fsck on localhost #0 (full) since $ConfRefCntFsck == 1 159s __bpc_progress_state__ refCnt #0 159s __bpc_progress_state__ cntUpdate #0 159s __bpc_progress_state__ rename #0 159s __bpc_progress_state__ sumUpdate 159s __bpc_progress_fileCnt__ 0/128 159s __bpc_progress_fileCnt__ 8/128 159s __bpc_progress_fileCnt__ 16/128 159s __bpc_progress_fileCnt__ 24/128 159s __bpc_progress_fileCnt__ 32/128 159s __bpc_progress_fileCnt__ 40/128 159s __bpc_progress_fileCnt__ 48/128 159s __bpc_progress_fileCnt__ 56/128 159s __bpc_progress_fileCnt__ 64/128 159s __bpc_progress_fileCnt__ 72/128 159s __bpc_progress_fileCnt__ 80/128 159s __bpc_progress_fileCnt__ 88/128 159s __bpc_progress_fileCnt__ 96/128 159s __bpc_progress_fileCnt__ 104/128 159s __bpc_progress_fileCnt__ 112/128 159s __bpc_progress_fileCnt__ 120/128 159s __bpc_progress_state__ rename total 159s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 159s Xfer PIDs are now 159s xferPids 159s Finished BackupPC_refCountUpdate (running time: 0 sec) 159s Xfer PIDs are now 159s xferPids 159s full backup complete 159s OK: Full backup succeeded 159s Changing share content and performing an incremental backup 159s Backup type: type = incr, needs_full = , needs_incr = , lastFullTime = 1732144695, opts{f} = , opts{i} = 1, opts{F} = 159s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 159s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 159s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.003 159s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.1.z created 2024-11-20 23:18:15 159s Backup prep: type = incr, case = 3, inPlace = 1, doDuplicate = 1, newBkupNum = 1, newBkupIdx = 1, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = ) 159s Executing /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 159s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 159s Xfer PIDs are now 3967 159s xferPids 3967 159s __bpc_progress_state__ copy #0 -> #1 159s Copying backup #0 to #1 159s __bpc_progress_fileCnt__ 3 dirs 159s Xfer PIDs are now 3967,3970 159s xferPids 3967,3970 159s __bpc_progress_state__ sumUpdate 159s __bpc_progress_fileCnt__ 0/128 159s __bpc_progress_fileCnt__ 8/128 159s __bpc_progress_fileCnt__ 16/128 159s __bpc_progress_fileCnt__ 24/128 159s __bpc_progress_fileCnt__ 32/128 159s __bpc_progress_fileCnt__ 40/128 159s __bpc_progress_fileCnt__ 48/128 159s __bpc_progress_fileCnt__ 56/128 159s __bpc_progress_fileCnt__ 64/128 159s __bpc_progress_fileCnt__ 72/128 159s __bpc_progress_fileCnt__ 80/128 159s __bpc_progress_fileCnt__ 88/128 159s __bpc_progress_fileCnt__ 96/128 159s __bpc_progress_fileCnt__ 104/128 159s __bpc_progress_fileCnt__ 112/128 159s __bpc_progress_fileCnt__ 120/128 159s __bpc_progress_state__ rename total 159s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 159s Xfer PIDs are now 3967 159s xferPids 3967 159s BackupPC_backupDuplicate: got 0 errors and 0 file open errors 159s Finished BackupPC_backupDuplicate (running time: 0 sec) 159s __bpc_progress_state__ backup share "public" 160s Running: /usr/bin/smbclient \\\\localhost\\public -U guest -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 160s incr backup started back to 2024-11-20 22:18:15 (backup #0) for share public 160s started incr dump, share=public 160s Xfer PIDs are now 3974,3973 160s xferPids 3974,3973 160s 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 - 160s tar:1298 Getting files newer than Wed Nov 20 22:18:15 2024 160s tarmode is now full, system, hidden, noreset, noverbose 160s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 160s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 160s __bpc_progress_fileCnt__ 0 160s same 644 0/0 480434 tmp.86vvkK 160s same 644 0/0 480434 tmp.feQRDR 160s same 644 0/0 480434 tmp.g4hTWQ 160s same 644 0/0 480434 tmp.kxp6oQ 160s new 644 0/0 480434 tmp.pw11X0 160s new 644 0/0 480434 tmp.VR2OrK 160s new 644 0/0 480434 tmp.8RcRrz 160s new 644 0/0 480434 tmp.GylkaB 160s same 644 0/0 480434 tmp.j9BOG6 160s new 644 0/0 480434 tmp.4GLPq9 160s same 644 0/0 480434 tmp.vlAVWC 160s new 644 0/0 480434 tmp.rwE55q 160s new 644 0/0 480434 tmp.eKv7If 160s same 644 0/0 480434 tmp.YCP9ei 160s same 644 0/0 480434 tmp.y2xuOo 160s same 644 0/0 480434 tmp.oe0BAZ 160s same 644 0/0 480434 tmp.3zP5RI 160s new 644 0/0 480434 tmp.qlr2al 160s new 644 0/0 480434 tmp.XdKwHn 160s tar: dumped 20 files and 0 directories 160s Total bytes written: 9608680 (59.4 MiB/s) 160s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 160s new 644 0/0 480434 tmp.GwWk8e 160s __bpc_progress_fileCnt__ 20 160s tarExtract: Done: 0 errors, 10 filesExist, 4804340 sizeExist, 1377832 sizeExistComp, 20 filesTotal, 9608680 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377844 sizeNewComp, 24 inodeLast 160s Xfer PIDs are now 160s xferPids 160s incr backup 1 complete, 20 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 160s BackupExpire: cntFull = 2, cntIncr = 0, firstFull = 0, firstIncr = , oldestIncr = 0, oldestFull = 1.15740740740741e-05 160s __bpc_progress_state__ fsck 160s Running BackupPC_refCountUpdate -h localhost on localhost 160s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 160s Xfer PIDs are now 3981 160s xferPids 3981 160s __bpc_progress_state__ cntUpdate #1 160s __bpc_progress_state__ rename #1 160s __bpc_progress_state__ sumUpdate 160s __bpc_progress_fileCnt__ 0/128 160s __bpc_progress_fileCnt__ 8/128 160s __bpc_progress_fileCnt__ 16/128 160s __bpc_progress_fileCnt__ 24/128 160s __bpc_progress_fileCnt__ 32/128 160s __bpc_progress_fileCnt__ 40/128 160s __bpc_progress_fileCnt__ 48/128 160s __bpc_progress_fileCnt__ 56/128 160s __bpc_progress_fileCnt__ 64/128 160s __bpc_progress_fileCnt__ 72/128 160s __bpc_progress_fileCnt__ 80/128 160s __bpc_progress_fileCnt__ 88/128 160s __bpc_progress_fileCnt__ 96/128 160s __bpc_progress_fileCnt__ 104/128 160s __bpc_progress_fileCnt__ 112/128 160s __bpc_progress_fileCnt__ 120/128 160s __bpc_progress_state__ rename total 160s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 160s Xfer PIDs are now 160s xferPids 160s Finished BackupPC_refCountUpdate (running time: 0 sec) 160s Xfer PIDs are now 160s xferPids 160s incr backup complete 160s OK: Incremental backup succeeded 160s Done. 160s autopkgtest [23:18:16]: test smb-backup: -----------------------] 161s autopkgtest [23:18:17]: test smb-backup: - - - - - - - - - - results - - - - - - - - - - 161s smb-backup PASS 161s autopkgtest [23:18:17]: test authenticated-smb-backup: preparing testbed 162s Reading package lists... 162s Building dependency tree... 162s Reading state information... 162s Starting pkgProblemResolver with broken count: 0 162s Starting 2 pkgProblemResolver with broken count: 0 162s Done 163s The following NEW packages will be installed: 163s autopkgtest-satdep 163s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 163s Need to get 0 B/728 B of archives. 163s After this operation, 0 B of additional disk space will be used. 163s Get:1 /tmp/autopkgtest.tTjHWp/2-autopkgtest-satdep.deb autopkgtest-satdep s390x 0 [728 B] 163s Selecting previously unselected package autopkgtest-satdep. 163s (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 ... 57513 files and directories currently installed.) 163s Preparing to unpack .../2-autopkgtest-satdep.deb ... 163s Unpacking autopkgtest-satdep (0) ... 163s Setting up autopkgtest-satdep (0) ... 164s (Reading database ... 57512 files and directories currently installed.) 164s Removing autopkgtest-satdep (0) ... 165s autopkgtest [23:18:21]: test authenticated-smb-backup: [----------------------- 165s Populating share path 165s Adding samba share 165s Adding [private] share 165s Creating user 165s Creating a local and samba user called smbtest4233 165s Setting samba password for the smbtest4233 user 165s Added user smbtest4233. 165s Configuring backuppc 165s Performing a full backup 165s Backup type: type = full, needs_full = , needs_incr = , lastFullTime = 1732144695, opts{f} = 1, opts{i} = , opts{F} = 165s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 165s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 165s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.003 165s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.2.z created 2024-11-20 23:18:21 165s Backup prep: type = full, case = 4, inPlace = 0, doDuplicate = 0, newBkupNum = 2, newBkupIdx = 2, lastBkupNum = 1, lastBkupIdx = 1 (FillCycle = 0, noFillCnt = 0) 165s __bpc_progress_state__ backup share "private" 165s Running: /usr/bin/smbclient \\\\localhost\\private -U smbtest4233 -E -d 1 -c tarmode\ full -mSMB3 -Tc - 165s full backup started for share private 165s started full dump, share=private 165s Xfer PIDs are now 4325,4324 165s xferPids 4325,4324 165s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\private -U smbtest4233 -E -d 1 -c tarmode\ full -mSMB3 -Tc - 165s tarmode is now full, system, hidden, noreset, noverbose 165s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 1 165s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 165s __bpc_progress_fileCnt__ 0 165s new 644 0/0 480434 tmp.5N7TkQ 165s new 644 0/0 480434 tmp.hUnHWI 165s new 644 0/0 480434 tmp.g21pwq 165s new 644 0/0 480434 tmp.6GyTmw 165s new 644 0/0 480434 tmp.Vpmq2P 165s new 644 0/0 480434 tmp.vhuK4V 165s new 644 0/0 480434 tmp.bPuwHQ 165s new 644 0/0 480434 tmp.GxPcfU 165s new 644 0/0 480434 tmp.9Jxqpm 165s tar: dumped 10 files and 0 directories 165s Total bytes written: 4804340 (36.1 MiB/s) 165s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 165s new 644 0/0 480434 tmp.AgAMbD 165s __bpc_progress_fileCnt__ 10 165s tarExtract: Done: 0 errors, 0 filesExist, 0 sizeExist, 0 sizeExistComp, 10 filesTotal, 4804340 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377756 sizeNewComp, 36 inodeLast 165s Xfer PIDs are now 165s xferPids 165s OrphanShareNameClean: removing orphan share public from /var/lib/backuppc/pc/localhost/2 165s __bpc_progress_state__ delete share #2/public 165s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDelete -h localhost -n 2 -l -m -s public / 166s Xfer PIDs are now 4331 166s xferPids 4331 166s BackupPC_backupDelete: removing #2/public/ 166s __bpc_progress_state__ merge #2/public/ -> #1/public/ 166s BackupPC_backupDelete: Merge into backup 1/public/ 166s mergeDir: attr write to /var/lib/backuppc/pc/localhost/1/fpublic//attrib failed (digest was ) 166s bpc_attrib_dirWrite: can't open/create raw /var/lib/backuppc/pc/localhost/1/fpublic for writing 166s Xfer PIDs are now 4331,4334 166s xferPids 4331,4334 166s __bpc_progress_state__ refCnt #1 166s __bpc_progress_state__ cntUpdate #1 166s __bpc_progress_state__ rename #1 166s __bpc_progress_state__ refCnt #2 166s BackupPC_refCountUpdate: localhost #2 inodeLast set to 37 (was 24) 166s __bpc_progress_state__ cntUpdate #2 166s __bpc_progress_state__ rename #2 166s __bpc_progress_state__ sumUpdate 166s __bpc_progress_fileCnt__ 0/128 166s __bpc_progress_fileCnt__ 8/128 166s __bpc_progress_fileCnt__ 16/128 166s __bpc_progress_fileCnt__ 24/128 166s __bpc_progress_fileCnt__ 32/128 166s __bpc_progress_fileCnt__ 40/128 166s __bpc_progress_fileCnt__ 48/128 166s __bpc_progress_fileCnt__ 56/128 166s __bpc_progress_fileCnt__ 64/128 166s __bpc_progress_fileCnt__ 72/128 166s __bpc_progress_fileCnt__ 80/128 166s __bpc_progress_fileCnt__ 88/128 166s __bpc_progress_fileCnt__ 96/128 166s __bpc_progress_fileCnt__ 104/128 166s __bpc_progress_fileCnt__ 112/128 166s __bpc_progress_fileCnt__ 120/128 166s __bpc_progress_state__ rename total 166s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 166s Xfer PIDs are now 4331 166s xferPids 4331 166s Xfer PIDs are now 166s xferPids 166s Finished BackupPC_backupDelete, status = 0 (running time: 1 sec) 166s Xfer PIDs are now 166s xferPids 166s full backup 2 complete, 10 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 166s BackupExpire: cntFull = 2, cntIncr = 1, firstFull = 0, firstIncr = 1, oldestIncr = 8.10185185185185e-05, oldestFull = 8.10185185185185e-05 166s __bpc_progress_state__ fsck 166s Running BackupPC_refCountUpdate -h localhost on localhost 166s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 166s Xfer PIDs are now 4337 166s xferPids 4337 166s BackupPC_refCountUpdate: doing fsck on localhost #2 (full) since $ConfRefCntFsck == 1 166s __bpc_progress_state__ refCnt #2 166s __bpc_progress_state__ cntUpdate #2 166s __bpc_progress_state__ rename #2 166s __bpc_progress_state__ sumUpdate 166s __bpc_progress_fileCnt__ 0/128 166s __bpc_progress_fileCnt__ 8/128 166s __bpc_progress_fileCnt__ 16/128 166s __bpc_progress_fileCnt__ 24/128 166s __bpc_progress_fileCnt__ 32/128 166s __bpc_progress_fileCnt__ 40/128 166s __bpc_progress_fileCnt__ 48/128 166s __bpc_progress_fileCnt__ 56/128 166s __bpc_progress_fileCnt__ 64/128 166s __bpc_progress_fileCnt__ 72/128 166s __bpc_progress_fileCnt__ 80/128 166s __bpc_progress_fileCnt__ 88/128 166s __bpc_progress_fileCnt__ 96/128 166s __bpc_progress_fileCnt__ 104/128 166s __bpc_progress_fileCnt__ 112/128 166s __bpc_progress_fileCnt__ 120/128 166s __bpc_progress_state__ rename total 166s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 166s Xfer PIDs are now 166s xferPids 166s Finished BackupPC_refCountUpdate (running time: 0 sec) 166s Xfer PIDs are now 166s xferPids 166s full backup complete 166s OK: Full backup succeeded 166s Changing share content and performing an incremental backup 166s Backup type: type = incr, needs_full = , needs_incr = , lastFullTime = 1732144701, opts{f} = , opts{i} = 1, opts{F} = 166s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 166s cmdSystemOrEval: about to system /bin/ping6 -c 1 localhost 166s CheckHostAlive: ran '/bin/ping6 -c 1 localhost'; returning 0.006 166s XferLOG file /var/lib/backuppc/pc/localhost/XferLOG.3.z created 2024-11-20 23:18:22 166s Backup prep: type = incr, case = 3, inPlace = 1, doDuplicate = 1, newBkupNum = 3, newBkupIdx = 3, lastBkupNum = , lastBkupIdx = (FillCycle = 0, noFillCnt = 1) 166s Executing /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 166s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_backupDuplicate -m -h localhost 166s Xfer PIDs are now 4407 166s xferPids 4407 166s __bpc_progress_state__ copy #2 -> #3 166s Copying backup #2 to #3 166s __bpc_progress_fileCnt__ 3 dirs 166s Xfer PIDs are now 4410,4407 166s xferPids 4410,4407 166s __bpc_progress_state__ sumUpdate 166s __bpc_progress_fileCnt__ 0/128 166s __bpc_progress_fileCnt__ 8/128 166s __bpc_progress_fileCnt__ 16/128 166s __bpc_progress_fileCnt__ 24/128 166s __bpc_progress_fileCnt__ 32/128 166s __bpc_progress_fileCnt__ 40/128 166s __bpc_progress_fileCnt__ 48/128 166s __bpc_progress_fileCnt__ 56/128 166s __bpc_progress_fileCnt__ 64/128 166s __bpc_progress_fileCnt__ 72/128 166s __bpc_progress_fileCnt__ 80/128 166s __bpc_progress_fileCnt__ 88/128 166s __bpc_progress_fileCnt__ 96/128 166s __bpc_progress_fileCnt__ 104/128 166s __bpc_progress_fileCnt__ 112/128 166s __bpc_progress_fileCnt__ 120/128 166s __bpc_progress_state__ rename total 166s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 166s Xfer PIDs are now 4407 166s xferPids 4407 166s BackupPC_backupDuplicate: got 0 errors and 0 file open errors 166s Finished BackupPC_backupDuplicate (running time: 0 sec) 166s __bpc_progress_state__ backup share "private" 166s Running: /usr/bin/smbclient \\\\localhost\\private -U smbtest4233 -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 166s incr backup started back to 2024-11-20 22:18:21 (backup #2) for share private 166s started incr dump, share=private 166s Xfer PIDs are now 4414,4413 166s xferPids 4414,4413 166s XferErr cmdExecOrEval: about to exec /usr/bin/smbclient \\\\localhost\\private -U smbtest4233 -E -d 1 -c tarmode\ full -mSMB3 -TcN /var/lib/backuppc/pc/localhost/timeStamp.level0 - 166s tar:1298 Getting files newer than Wed Nov 20 22:18:21 2024 166s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract: got Full = 166s tarmode is now full, system, hidden, noreset, noverbose 166s tarExtract: /usr/share/backuppc/bin/BackupPC_tarExtract starting... (XferLogLevel = 1) 166s __bpc_progress_fileCnt__ 0 166s same 644 0/0 480434 tmp.5N7TkQ 166s new 644 0/0 480434 tmp.MZ0Wqe 166s new 644 0/0 480434 tmp.ES1k1B 166s new 644 0/0 480434 tmp.HgDAdV 166s same 644 0/0 480434 tmp.hUnHWI 166s new 644 0/0 480434 tmp.Mrt9hx 166s same 644 0/0 480434 tmp.g21pwq 166s same 644 0/0 480434 tmp.6GyTmw 166s new 644 0/0 480434 tmp.o7JWED 166s same 644 0/0 480434 tmp.Vpmq2P 166s same 644 0/0 480434 tmp.vhuK4V 166s same 644 0/0 480434 tmp.bPuwHQ 166s new 644 0/0 480434 tmp.Kek96N 166s new 644 0/0 480434 tmp.sOqBaG 166s new 644 0/0 480434 tmp.zizyDd 166s new 644 0/0 480434 tmp.v6nzaC 166s same 644 0/0 480434 tmp.GxPcfU 166s same 644 0/0 480434 tmp.9Jxqpm 166s new 644 0/0 480434 tmp.LafA7B 166s tar: dumped 20 files and 0 directories 166s Total bytes written: 9608680 (58.3 MiB/s) 166s same 644 0/0 480434 tmp.AgAMbD 166s readOutput: sysread returns 0 and got EOF (exit ok = 1, ) 166s __bpc_progress_fileCnt__ 20 166s tarExtract: Done: 0 errors, 10 filesExist, 4804340 sizeExist, 1377756 sizeExistComp, 20 filesTotal, 9608680 sizeTotal, 10 filesNew, 4804340 sizeNew, 1377728 sizeNewComp, 47 inodeLast 166s Xfer PIDs are now 166s xferPids 166s incr backup 3 complete, 20 files, 0 bytes, 1 xferErrs (0 bad files, 0 bad shares, 1 other) 166s BackupExpire: cntFull = 3, cntIncr = 1, firstFull = 0, firstIncr = 1, oldestIncr = 8.10185185185185e-05, oldestFull = 8.10185185185185e-05 166s __bpc_progress_state__ fsck 166s Running BackupPC_refCountUpdate -h localhost on localhost 166s cmdSystemOrEval: about to system /usr/share/backuppc/bin/BackupPC_refCountUpdate -h localhost 166s Xfer PIDs are now 4420 166s xferPids 4420 166s __bpc_progress_state__ cntUpdate #3 166s __bpc_progress_state__ rename #3 166s __bpc_progress_state__ sumUpdate 166s __bpc_progress_fileCnt__ 0/128 166s __bpc_progress_fileCnt__ 8/128 166s __bpc_progress_fileCnt__ 16/128 166s __bpc_progress_fileCnt__ 24/128 166s __bpc_progress_fileCnt__ 32/128 166s __bpc_progress_fileCnt__ 40/128 166s __bpc_progress_fileCnt__ 48/128 166s __bpc_progress_fileCnt__ 56/128 166s __bpc_progress_fileCnt__ 64/128 166s __bpc_progress_fileCnt__ 72/128 166s __bpc_progress_fileCnt__ 80/128 166s __bpc_progress_fileCnt__ 88/128 166s __bpc_progress_fileCnt__ 96/128 166s __bpc_progress_fileCnt__ 104/128 166s __bpc_progress_fileCnt__ 112/128 166s __bpc_progress_fileCnt__ 120/128 166s __bpc_progress_state__ rename total 166s BackupPC_refCountUpdate: host localhost got 0 errors (took 0 secs) 166s Xfer PIDs are now 166s xferPids 166s Finished BackupPC_refCountUpdate (running time: 0 sec) 166s Xfer PIDs are now 166s xferPids 166s incr backup complete 166s OK: Incremental backup succeeded 166s Done. 166s Deleted user smbtest4233. 166s userdel: smbtest4233 mail spool (/var/mail/smbtest4233) not found 167s autopkgtest [23:18:23]: test authenticated-smb-backup: -----------------------] 167s authenticated-smb-backup PASS 167s autopkgtest [23:18:23]: test authenticated-smb-backup: - - - - - - - - - - results - - - - - - - - - - 167s autopkgtest [23:18:23]: @@@@@@@@@@@@@@@@@@@@ summary 167s smb-backup PASS 167s authenticated-smb-backup PASS 179s virt: nova [W] Using flock in prodstack6-s390x 179s virt: flock: timeout while waiting to get lock 179s virt: Creating nova instance adt-plucky-s390x-backuppc-20241120-231536-juju-7f2275-prod-proposed-migration-environment-2-06323453-8cfa-40b6-9492-711be0ae35ad from image adt/ubuntu-plucky-s390x-server-20241119.img (UUID 0efe7a44-24e0-44d8-af6e-8997f14b87bd)...