0s autopkgtest [11:21:46]: starting date and time: 2025-03-13 11:21:46+0000 0s autopkgtest [11:21:46]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [11:21:46]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.uzkkeyjv/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:rdiff-backup --apt-upgrade rdiff-backup --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=rdiff-backup/2.2.6-3build1 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-ppc64el --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-ppc64el-19.secgroup --name adt-plucky-ppc64el-rdiff-backup-20250313-110003-juju-7f2275-prod-proposed-migration-environment-2-2f01902d-9959-4a1e-a48c-8f3cb9411ad4 --image adt/ubuntu-plucky-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration-ppc64el -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,radosgw.ps5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 62s autopkgtest [11:22:48]: testbed dpkg architecture: ppc64el 62s autopkgtest [11:22:48]: testbed apt version: 2.9.32ubuntu1 63s autopkgtest [11:22:49]: @@@@@@@@@@@@@@@@@@@@ test bed setup 63s autopkgtest [11:22:49]: testbed release detected to be: None 64s autopkgtest [11:22:50]: updating testbed package index (apt update) 64s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [110 kB] 64s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 64s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 64s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 64s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [396 kB] 65s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [43.9 kB] 65s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [11.5 kB] 65s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el Packages [56.8 kB] 65s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/universe ppc64el Packages [328 kB] 65s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse ppc64el Packages [3020 B] 65s Fetched 950 kB in 1s (1102 kB/s) 66s Reading package lists... 66s Reading package lists... 67s Building dependency tree... 67s Reading state information... 67s Calculating upgrade... 67s Calculating upgrade... 67s The following NEW packages will be installed: 67s pnp.ids 67s The following packages will be upgraded: 67s gir1.2-glib-2.0 htop hwdata libglib2.0-0t64 libglib2.0-data 67s 5 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 67s Need to get 2297 kB of archives. 67s After this operation, 11.3 kB of additional disk space will be used. 67s Get:1 http://ftpmaster.internal/ubuntu plucky/main ppc64el gir1.2-glib-2.0 ppc64el 2.84.0-1 [184 kB] 67s Get:2 http://ftpmaster.internal/ubuntu plucky/main ppc64el libglib2.0-0t64 ppc64el 2.84.0-1 [1802 kB] 68s Get:3 http://ftpmaster.internal/ubuntu plucky/main ppc64el libglib2.0-data all 2.84.0-1 [53.0 kB] 68s Get:4 http://ftpmaster.internal/ubuntu plucky/main ppc64el htop ppc64el 3.4.0-2 [227 kB] 68s Get:5 http://ftpmaster.internal/ubuntu plucky/main ppc64el hwdata all 0.393-3 [1562 B] 68s Get:6 http://ftpmaster.internal/ubuntu plucky/main ppc64el pnp.ids all 0.393-3 [29.5 kB] 68s Fetched 2297 kB in 1s (3530 kB/s) 69s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 107190 files and directories currently installed.) 69s Preparing to unpack .../0-gir1.2-glib-2.0_2.84.0-1_ppc64el.deb ... 69s Unpacking gir1.2-glib-2.0:ppc64el (2.84.0-1) over (2.83.5-1) ... 69s Preparing to unpack .../1-libglib2.0-0t64_2.84.0-1_ppc64el.deb ... 69s Unpacking libglib2.0-0t64:ppc64el (2.84.0-1) over (2.83.5-1) ... 69s Preparing to unpack .../2-libglib2.0-data_2.84.0-1_all.deb ... 69s Unpacking libglib2.0-data (2.84.0-1) over (2.83.5-1) ... 69s Preparing to unpack .../3-htop_3.4.0-2_ppc64el.deb ... 69s Unpacking htop (3.4.0-2) over (3.4.0-1) ... 69s Preparing to unpack .../4-hwdata_0.393-3_all.deb ... 69s Unpacking hwdata (0.393-3) over (0.393-1) ... 69s Selecting previously unselected package pnp.ids. 69s Preparing to unpack .../5-pnp.ids_0.393-3_all.deb ... 69s Unpacking pnp.ids (0.393-3) ... 69s Setting up htop (3.4.0-2) ... 69s Setting up libglib2.0-0t64:ppc64el (2.84.0-1) ... 69s No schema files found: doing nothing. 69s Setting up libglib2.0-data (2.84.0-1) ... 69s Setting up gir1.2-glib-2.0:ppc64el (2.84.0-1) ... 69s Setting up pnp.ids (0.393-3) ... 69s Setting up hwdata (0.393-3) ... 69s Processing triggers for man-db (2.13.0-1) ... 70s Processing triggers for libc-bin (2.41-1ubuntu1) ... 70s Reading package lists... 70s Building dependency tree... 70s Reading state information... 70s Solving dependencies... 70s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 70s autopkgtest [11:22:56]: upgrading testbed (apt dist-upgrade and autopurge) 71s Reading package lists... 71s Building dependency tree... 71s Reading state information... 71s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 71s Starting 2 pkgProblemResolver with broken count: 0 71s Done 71s Entering ResolveByKeep 71s 72s Calculating upgrade... 72s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 72s Reading package lists... 72s Building dependency tree... 72s Reading state information... 72s Starting pkgProblemResolver with broken count: 0 72s Starting 2 pkgProblemResolver with broken count: 0 72s Done 72s Solving dependencies... 73s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 75s autopkgtest [11:23:01]: testbed running kernel: Linux 6.14.0-7-generic #7-Ubuntu SMP Fri Feb 28 12:06:33 UTC 2025 76s autopkgtest [11:23:02]: @@@@@@@@@@@@@@@@@@@@ apt-source rdiff-backup 77s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/universe rdiff-backup 2.2.6-3build1 (dsc) [2298 B] 77s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/universe rdiff-backup 2.2.6-3build1 (tar) [899 kB] 77s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/universe rdiff-backup 2.2.6-3build1 (diff) [14.4 kB] 78s gpgv: Signature made Tue Mar 4 19:35:22 2025 UTC 78s gpgv: using RSA key 25E3FF2D7F469DBE7D0D4E50AFCFEC8E669CE1C2 78s gpgv: Can't check signature: No public key 78s dpkg-source: warning: cannot verify inline signature for ./rdiff-backup_2.2.6-3build1.dsc: no acceptable signature found 78s autopkgtest [11:23:04]: testing package rdiff-backup version 2.2.6-3build1 78s autopkgtest [11:23:04]: build not needed 79s autopkgtest [11:23:05]: test smoke: preparing testbed 80s Reading package lists... 80s Building dependency tree... 80s Reading state information... 80s Starting pkgProblemResolver with broken count: 0 80s Starting 2 pkgProblemResolver with broken count: 0 80s Done 80s The following NEW packages will be installed: 80s librsync2t64 rdiff-backup 80s 0 upgraded, 2 newly installed, 0 to remove and 0 not upgraded. 80s Need to get 302 kB of archives. 80s After this operation, 1478 kB of additional disk space will be used. 80s Get:1 http://ftpmaster.internal/ubuntu plucky/main ppc64el librsync2t64 ppc64el 2.3.4-1.1ubuntu2 [47.5 kB] 81s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/universe ppc64el rdiff-backup ppc64el 2.2.6-3build1 [254 kB] 81s Fetched 302 kB in 0s (616 kB/s) 81s Selecting previously unselected package librsync2t64:ppc64el. 81s (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 ... 107193 files and directories currently installed.) 81s Preparing to unpack .../librsync2t64_2.3.4-1.1ubuntu2_ppc64el.deb ... 81s Unpacking librsync2t64:ppc64el (2.3.4-1.1ubuntu2) ... 81s Selecting previously unselected package rdiff-backup. 81s Preparing to unpack .../rdiff-backup_2.2.6-3build1_ppc64el.deb ... 81s Unpacking rdiff-backup (2.2.6-3build1) ... 81s Setting up librsync2t64:ppc64el (2.3.4-1.1ubuntu2) ... 81s Setting up rdiff-backup (2.2.6-3build1) ... 81s Processing triggers for man-db (2.13.0-1) ... 82s Processing triggers for libc-bin (2.41-1ubuntu1) ... 83s autopkgtest [11:23:09]: test smoke: [----------------------- 83s + rdiff-backup --print-statistics 83s + grep -qF rdiff-backup: error: Action backup requires 2 location(s) instead of []. 83s + Basic smoke test passed 83s echo Basic smoke test passed 83s autopkgtest [11:23:09]: test smoke: -----------------------] 84s autopkgtest [11:23:10]: test smoke: - - - - - - - - - - results - - - - - - - - - - 84s smoke PASS (superficial) 84s autopkgtest [11:23:10]: test version: preparing testbed 84s Reading package lists... 85s Building dependency tree... 85s Reading state information... 85s Starting pkgProblemResolver with broken count: 0 85s Starting 2 pkgProblemResolver with broken count: 0 85s Done 85s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 86s autopkgtest [11:23:12]: test version: [----------------------- 86s + rdiff-backup --version 86s + grep -q DEV 87s Version test passed 87s + echo Version test passed 87s autopkgtest [11:23:13]: test version: -----------------------] 87s version PASS 87s autopkgtest [11:23:13]: test version: - - - - - - - - - - results - - - - - - - - - - 88s autopkgtest [11:23:14]: test unit: preparing testbed 88s Reading package lists... 88s Building dependency tree... 88s Reading state information... 89s Starting pkgProblemResolver with broken count: 0 89s Starting 2 pkgProblemResolver with broken count: 0 89s Done 89s The following NEW packages will be installed: 89s python3-iniconfig python3-packaging python3-pluggy python3-pytest rdiff 89s 0 upgraded, 5 newly installed, 0 to remove and 0 not upgraded. 89s Need to get 339 kB of archives. 89s After this operation, 1738 kB of additional disk space will be used. 89s Get:1 http://ftpmaster.internal/ubuntu plucky/universe ppc64el python3-iniconfig all 1.1.1-2 [6024 B] 89s Get:2 http://ftpmaster.internal/ubuntu plucky/main ppc64el python3-packaging all 24.2-1 [51.5 kB] 89s Get:3 http://ftpmaster.internal/ubuntu plucky/universe ppc64el python3-pluggy all 1.5.0-1 [21.0 kB] 89s Get:4 http://ftpmaster.internal/ubuntu plucky/universe ppc64el python3-pytest all 8.3.4-1 [252 kB] 89s Get:5 http://ftpmaster.internal/ubuntu plucky/universe ppc64el rdiff ppc64el 2.3.4-1.1ubuntu2 [8374 B] 90s Fetched 339 kB in 0s (709 kB/s) 90s Selecting previously unselected package python3-iniconfig. 90s (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 ... 107314 files and directories currently installed.) 90s Preparing to unpack .../python3-iniconfig_1.1.1-2_all.deb ... 90s Unpacking python3-iniconfig (1.1.1-2) ... 90s Selecting previously unselected package python3-packaging. 90s Preparing to unpack .../python3-packaging_24.2-1_all.deb ... 90s Unpacking python3-packaging (24.2-1) ... 90s Selecting previously unselected package python3-pluggy. 90s Preparing to unpack .../python3-pluggy_1.5.0-1_all.deb ... 90s Unpacking python3-pluggy (1.5.0-1) ... 90s Selecting previously unselected package python3-pytest. 90s Preparing to unpack .../python3-pytest_8.3.4-1_all.deb ... 90s Unpacking python3-pytest (8.3.4-1) ... 90s Selecting previously unselected package rdiff. 90s Preparing to unpack .../rdiff_2.3.4-1.1ubuntu2_ppc64el.deb ... 90s Unpacking rdiff (2.3.4-1.1ubuntu2) ... 90s Setting up python3-iniconfig (1.1.1-2) ... 90s Setting up rdiff (2.3.4-1.1ubuntu2) ... 90s Setting up python3-packaging (24.2-1) ... 90s Setting up python3-pluggy (1.5.0-1) ... 90s Setting up python3-pytest (8.3.4-1) ... 91s Processing triggers for man-db (2.13.0-1) ... 92s autopkgtest [11:23:18]: test unit: [----------------------- 92s + python3 testing/commontest.py 92s + python3 -m pytest testing/action_backuprestore_test.py testing/action_calculate_test.py testing/action_compare_test.py testing/action_complete_test.py testing/action_list_test.py testing/action_regress_test.py testing/action_remove_test.py testing/action_test_test.py testing/action_verify_test.py testing/api_test.py testing/location_lock_test.py testing/location_map_filenames_test.py testing/location_map_hardlinks_test.py testing/readonly_actions_test.py testing/utils_simpleps_test.py testing/ctest.py testing/errorsrecovertest.py testing/iterfiletest.py testing/librsynctest.py testing/rorpitertest.py testing/rdb_arguments.py testing/setconnectionstest.py testing/timetest.py testing/user_grouptest.py 93s ============================= test session starts ============================== 93s platform linux -- Python 3.13.2, pytest-8.3.4, pluggy-1.5.0 93s rootdir: /tmp/autopkgtest.iT6Poc/build.lJl/src 93s plugins: typeguard-4.4.2 93s collected 77 items 93s 101s testing/action_backuprestore_test.py ...... [ 7%] 103s testing/action_calculate_test.py . [ 9%] 106s testing/action_compare_test.py . [ 10%] 108s testing/action_complete_test.py . [ 11%] 111s testing/action_list_test.py ... [ 15%] 115s testing/action_regress_test.py .. [ 18%] 119s testing/action_remove_test.py . [ 19%] 120s testing/action_test_test.py . [ 20%] 121s testing/action_verify_test.py . [ 22%] 122s testing/api_test.py .... [ 27%] 122s testing/location_lock_test.py .. [ 29%] 125s testing/location_map_filenames_test.py ... [ 33%] 125s testing/location_map_hardlinks_test.py . [ 35%] 127s testing/readonly_actions_test.py s.. [ 38%] 127s testing/utils_simpleps_test.py . [ 40%] 128s testing/ctest.py .... [ 45%] 131s testing/errorsrecovertest.py . [ 46%] 131s testing/iterfiletest.py ....... [ 55%] 132s testing/librsynctest.py ..... [ 62%] 132s testing/rorpitertest.py ........ [ 72%] 132s testing/rdb_arguments.py ... [ 76%] 132s testing/setconnectionstest.py . [ 77%] 134s testing/timetest.py ............ [ 93%] 134s testing/user_grouptest.py .+ python3 testing/hashtest.py 134s .... [100%] 134s 134s ======================== 76 passed, 1 skipped in 41.98s ======================== 135s ..s 135s ---------------------------------------------------------------------- 135s Ran 3 tests in 0.121s 135s 135s OK (skipped=1) 135s autopkgtest [11:24:01]: test unit: -----------------------] 136s autopkgtest [11:24:02]: test unit: - - - - - - - - - - results - - - - - - - - - - 136s unit PASS 136s autopkgtest [11:24:02]: test files: preparing testbed 226s autopkgtest [11:25:32]: testbed dpkg architecture: ppc64el 227s autopkgtest [11:25:33]: testbed apt version: 2.9.32ubuntu1 227s autopkgtest [11:25:33]: @@@@@@@@@@@@@@@@@@@@ test bed setup 227s autopkgtest [11:25:33]: testbed release detected to be: plucky 228s autopkgtest [11:25:34]: updating testbed package index (apt update) 228s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [110 kB] 229s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 229s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 229s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 229s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [11.5 kB] 229s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [396 kB] 229s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [43.9 kB] 229s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el Packages [56.8 kB] 229s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/universe ppc64el Packages [328 kB] 229s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse ppc64el Packages [3020 B] 229s Fetched 950 kB in 1s (1095 kB/s) 230s Reading package lists... 230s Reading package lists... 231s Building dependency tree... 231s Reading state information... 231s Calculating upgrade... 231s Calculating upgrade... 231s The following NEW packages will be installed: 231s pnp.ids 231s The following packages will be upgraded: 231s gir1.2-glib-2.0 htop hwdata libglib2.0-0t64 libglib2.0-data 231s 5 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 231s Need to get 2297 kB of archives. 231s After this operation, 11.3 kB of additional disk space will be used. 231s Get:1 http://ftpmaster.internal/ubuntu plucky/main ppc64el gir1.2-glib-2.0 ppc64el 2.84.0-1 [184 kB] 231s Get:2 http://ftpmaster.internal/ubuntu plucky/main ppc64el libglib2.0-0t64 ppc64el 2.84.0-1 [1802 kB] 232s Get:3 http://ftpmaster.internal/ubuntu plucky/main ppc64el libglib2.0-data all 2.84.0-1 [53.0 kB] 232s Get:4 http://ftpmaster.internal/ubuntu plucky/main ppc64el htop ppc64el 3.4.0-2 [227 kB] 232s Get:5 http://ftpmaster.internal/ubuntu plucky/main ppc64el hwdata all 0.393-3 [1562 B] 232s Get:6 http://ftpmaster.internal/ubuntu plucky/main ppc64el pnp.ids all 0.393-3 [29.5 kB] 232s Fetched 2297 kB in 1s (3758 kB/s) 232s (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 ... 107190 files and directories currently installed.) 232s Preparing to unpack .../0-gir1.2-glib-2.0_2.84.0-1_ppc64el.deb ... 232s Unpacking gir1.2-glib-2.0:ppc64el (2.84.0-1) over (2.83.5-1) ... 232s Preparing to unpack .../1-libglib2.0-0t64_2.84.0-1_ppc64el.deb ... 232s Unpacking libglib2.0-0t64:ppc64el (2.84.0-1) over (2.83.5-1) ... 232s Preparing to unpack .../2-libglib2.0-data_2.84.0-1_all.deb ... 232s Unpacking libglib2.0-data (2.84.0-1) over (2.83.5-1) ... 232s Preparing to unpack .../3-htop_3.4.0-2_ppc64el.deb ... 232s Unpacking htop (3.4.0-2) over (3.4.0-1) ... 232s Preparing to unpack .../4-hwdata_0.393-3_all.deb ... 232s Unpacking hwdata (0.393-3) over (0.393-1) ... 232s Selecting previously unselected package pnp.ids. 232s Preparing to unpack .../5-pnp.ids_0.393-3_all.deb ... 232s Unpacking pnp.ids (0.393-3) ... 232s Setting up htop (3.4.0-2) ... 232s Setting up libglib2.0-0t64:ppc64el (2.84.0-1) ... 232s No schema files found: doing nothing. 232s Setting up libglib2.0-data (2.84.0-1) ... 232s Setting up gir1.2-glib-2.0:ppc64el (2.84.0-1) ... 232s Setting up pnp.ids (0.393-3) ... 232s Setting up hwdata (0.393-3) ... 232s Processing triggers for man-db (2.13.0-1) ... 233s Processing triggers for libc-bin (2.41-1ubuntu1) ... 233s Reading package lists... 233s Building dependency tree... 233s Reading state information... 234s Solving dependencies... 234s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 234s autopkgtest [11:25:40]: upgrading testbed (apt dist-upgrade and autopurge) 234s Reading package lists... 234s Building dependency tree... 234s Reading state information... 234s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 234s Starting 2 pkgProblemResolver with broken count: 0 234s Done 235s Entering ResolveByKeep 235s 235s Calculating upgrade... 235s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 235s Reading package lists... 235s Building dependency tree... 235s Reading state information... 236s Starting pkgProblemResolver with broken count: 0 236s Starting 2 pkgProblemResolver with broken count: 0 236s Done 236s Solving dependencies... 236s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 239s Reading package lists... 239s Building dependency tree... 239s Reading state information... 239s Starting pkgProblemResolver with broken count: 0 239s Starting 2 pkgProblemResolver with broken count: 0 239s Done 239s The following NEW packages will be installed: 239s librsync2t64 rdiff-backup 240s 0 upgraded, 2 newly installed, 0 to remove and 0 not upgraded. 240s Need to get 302 kB of archives. 240s After this operation, 1478 kB of additional disk space will be used. 240s Get:1 http://ftpmaster.internal/ubuntu plucky/main ppc64el librsync2t64 ppc64el 2.3.4-1.1ubuntu2 [47.5 kB] 240s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/universe ppc64el rdiff-backup ppc64el 2.2.6-3build1 [254 kB] 240s Fetched 302 kB in 0s (644 kB/s) 240s Selecting previously unselected package librsync2t64:ppc64el. 240s (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 ... 107193 files and directories currently installed.) 240s Preparing to unpack .../librsync2t64_2.3.4-1.1ubuntu2_ppc64el.deb ... 240s Unpacking librsync2t64:ppc64el (2.3.4-1.1ubuntu2) ... 240s Selecting previously unselected package rdiff-backup. 240s Preparing to unpack .../rdiff-backup_2.2.6-3build1_ppc64el.deb ... 240s Unpacking rdiff-backup (2.2.6-3build1) ... 240s Setting up librsync2t64:ppc64el (2.3.4-1.1ubuntu2) ... 240s Setting up rdiff-backup (2.2.6-3build1) ... 241s Processing triggers for man-db (2.13.0-1) ... 241s Processing triggers for libc-bin (2.41-1ubuntu1) ... 244s autopkgtest [11:25:50]: test files: [----------------------- 244s uid=1000(ubuntu) gid=1000(ubuntu) groups=1000(ubuntu),4(adm),24(cdrom),27(sudo),30(dip),103(lxd) 244s id: ‘/dev/null’: no such user 244s + AUTOPKGTEST_TMP=/tmp/autopkgtest.iT6Poc/autopkgtest_tmp 244s + export RDIFF_TEST_UID=1000 244s + id 1000 /dev/null 244s + user=test 244s + group=test 244s + useradd --uid 1000 --user-group test 244s useradd: UID 1000 is not unique 244s autopkgtest [11:25:50]: test files: -----------------------] 245s files FAIL non-zero exit status 4 245s autopkgtest [11:25:51]: test files: - - - - - - - - - - results - - - - - - - - - - 245s autopkgtest [11:25:51]: test fs: preparing testbed 343s autopkgtest [11:27:29]: testbed dpkg architecture: ppc64el 343s autopkgtest [11:27:29]: testbed apt version: 2.9.32ubuntu1 343s autopkgtest [11:27:29]: @@@@@@@@@@@@@@@@@@@@ test bed setup 343s autopkgtest [11:27:29]: testbed release detected to be: plucky 344s autopkgtest [11:27:30]: updating testbed package index (apt update) 344s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [110 kB] 345s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 345s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 345s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 345s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [11.5 kB] 345s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [43.9 kB] 345s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [396 kB] 345s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el Packages [56.8 kB] 345s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/universe ppc64el Packages [328 kB] 345s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse ppc64el Packages [3020 B] 345s Fetched 950 kB in 1s (1115 kB/s) 346s Reading package lists... 347s Reading package lists... 347s Building dependency tree... 347s Reading state information... 347s Calculating upgrade... 347s Calculating upgrade... 348s The following NEW packages will be installed: 348s pnp.ids 348s The following packages will be upgraded: 348s gir1.2-glib-2.0 htop hwdata libglib2.0-0t64 libglib2.0-data 348s 5 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 348s Need to get 2297 kB of archives. 348s After this operation, 11.3 kB of additional disk space will be used. 348s Get:1 http://ftpmaster.internal/ubuntu plucky/main ppc64el gir1.2-glib-2.0 ppc64el 2.84.0-1 [184 kB] 348s Get:2 http://ftpmaster.internal/ubuntu plucky/main ppc64el libglib2.0-0t64 ppc64el 2.84.0-1 [1802 kB] 348s Get:3 http://ftpmaster.internal/ubuntu plucky/main ppc64el libglib2.0-data all 2.84.0-1 [53.0 kB] 348s Get:4 http://ftpmaster.internal/ubuntu plucky/main ppc64el htop ppc64el 3.4.0-2 [227 kB] 348s Get:5 http://ftpmaster.internal/ubuntu plucky/main ppc64el hwdata all 0.393-3 [1562 B] 348s Get:6 http://ftpmaster.internal/ubuntu plucky/main ppc64el pnp.ids all 0.393-3 [29.5 kB] 349s Fetched 2297 kB in 1s (3705 kB/s) 349s (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 ... 107190 files and directories currently installed.) 349s Preparing to unpack .../0-gir1.2-glib-2.0_2.84.0-1_ppc64el.deb ... 349s Unpacking gir1.2-glib-2.0:ppc64el (2.84.0-1) over (2.83.5-1) ... 349s Preparing to unpack .../1-libglib2.0-0t64_2.84.0-1_ppc64el.deb ... 349s Unpacking libglib2.0-0t64:ppc64el (2.84.0-1) over (2.83.5-1) ... 349s Preparing to unpack .../2-libglib2.0-data_2.84.0-1_all.deb ... 349s Unpacking libglib2.0-data (2.84.0-1) over (2.83.5-1) ... 349s Preparing to unpack .../3-htop_3.4.0-2_ppc64el.deb ... 349s Unpacking htop (3.4.0-2) over (3.4.0-1) ... 349s Preparing to unpack .../4-hwdata_0.393-3_all.deb ... 349s Unpacking hwdata (0.393-3) over (0.393-1) ... 349s Selecting previously unselected package pnp.ids. 349s Preparing to unpack .../5-pnp.ids_0.393-3_all.deb ... 349s Unpacking pnp.ids (0.393-3) ... 349s Setting up htop (3.4.0-2) ... 349s Setting up libglib2.0-0t64:ppc64el (2.84.0-1) ... 349s No schema files found: doing nothing. 349s Setting up libglib2.0-data (2.84.0-1) ... 349s Setting up gir1.2-glib-2.0:ppc64el (2.84.0-1) ... 349s Setting up pnp.ids (0.393-3) ... 349s Setting up hwdata (0.393-3) ... 349s Processing triggers for man-db (2.13.0-1) ... 349s Processing triggers for libc-bin (2.41-1ubuntu1) ... 350s Reading package lists... 350s Building dependency tree... 350s Reading state information... 350s Solving dependencies... 350s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 350s autopkgtest [11:27:36]: upgrading testbed (apt dist-upgrade and autopurge) 350s Reading package lists... 351s Building dependency tree... 351s Reading state information... 351s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 351s Starting 2 pkgProblemResolver with broken count: 0 351s Done 351s Entering ResolveByKeep 352s 352s Calculating upgrade... 352s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 352s Reading package lists... 352s Building dependency tree... 352s Reading state information... 353s Starting pkgProblemResolver with broken count: 0 353s Starting 2 pkgProblemResolver with broken count: 0 353s Done 353s Solving dependencies... 353s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 356s Reading package lists... 356s Building dependency tree... 356s Reading state information... 356s Starting pkgProblemResolver with broken count: 0 356s Starting 2 pkgProblemResolver with broken count: 0 356s Done 356s The following NEW packages will be installed: 356s librsync2t64 python3-pylibacl python3-pyxattr rdiff-backup 357s 0 upgraded, 4 newly installed, 0 to remove and 0 not upgraded. 357s Need to get 338 kB of archives. 357s After this operation, 1700 kB of additional disk space will be used. 357s Get:1 http://ftpmaster.internal/ubuntu plucky/main ppc64el librsync2t64 ppc64el 2.3.4-1.1ubuntu2 [47.5 kB] 357s Get:2 http://ftpmaster.internal/ubuntu plucky/main ppc64el python3-pylibacl ppc64el 0.7.2-1 [20.0 kB] 357s Get:3 http://ftpmaster.internal/ubuntu plucky/main ppc64el python3-pyxattr ppc64el 0.8.1-1build4 [15.9 kB] 357s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/universe ppc64el rdiff-backup ppc64el 2.2.6-3build1 [254 kB] 357s Fetched 338 kB in 0s (721 kB/s) 357s Selecting previously unselected package librsync2t64:ppc64el. 357s (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 ... 107193 files and directories currently installed.) 357s Preparing to unpack .../librsync2t64_2.3.4-1.1ubuntu2_ppc64el.deb ... 357s Unpacking librsync2t64:ppc64el (2.3.4-1.1ubuntu2) ... 357s Selecting previously unselected package python3-pylibacl:ppc64el. 357s Preparing to unpack .../python3-pylibacl_0.7.2-1_ppc64el.deb ... 357s Unpacking python3-pylibacl:ppc64el (0.7.2-1) ... 357s Selecting previously unselected package python3-pyxattr:ppc64el. 357s Preparing to unpack .../python3-pyxattr_0.8.1-1build4_ppc64el.deb ... 357s Unpacking python3-pyxattr:ppc64el (0.8.1-1build4) ... 357s Selecting previously unselected package rdiff-backup. 357s Preparing to unpack .../rdiff-backup_2.2.6-3build1_ppc64el.deb ... 357s Unpacking rdiff-backup (2.2.6-3build1) ... 357s Setting up python3-pylibacl:ppc64el (0.7.2-1) ... 357s Setting up librsync2t64:ppc64el (2.3.4-1.1ubuntu2) ... 357s Setting up rdiff-backup (2.2.6-3build1) ... 358s Setting up python3-pyxattr:ppc64el (0.8.1-1build4) ... 358s Processing triggers for man-db (2.13.0-1) ... 358s Processing triggers for libc-bin (2.41-1ubuntu1) ... 360s autopkgtest [11:27:46]: test fs: [----------------------- 361s + python3 testing/commontest.py 361s + python3 testing/fs_abilitiestest.py 361s .----------------------------------------------------------------- 361s Detected abilities for read-only (read only) file system: 361s Access control lists On 361s Extended attributes On 361s Windows access control lists Off 361s Case sensitivity On 361s Escape DOS devices Off 361s Escape trailing spaces Off 361s Mac OS X style resource forks Off 361s Mac OS X Finder information Off 361s ----------------------------------------------------------------- 361s Time elapsed = 0.006754398345947266 361s ----------------------------------------------------------------- 361s Detected abilities for read/write (read/write) file system: 361s Ownership changing Off 361s Hard linking On 361s fsync() directories On 361s Directory inc permissions On 361s High-bit permissions On 361s Symlink permissions Off 361s Extended filenames On 361s Windows reserved filenames Off 361s Access control lists On 361s Extended attributes On 361s Windows access control lists Off 361s Case sensitivity On 361s Escape DOS devices Off 361s Escape trailing spaces Off 361s Mac OS X style resource forks Off 361s Mac OS X Finder information Off 361s ----------------------------------------------------------------- 361s .s 361s ---------------------------------------------------------------------- 361s Ran 3 tests in 0.008s 361s 361s OK (skipped=1) 361s + python3 testing/eas_aclstest.py 361s .....WARNING: Server will be called with deprecated command line interface to guarantee compatibility. It might lead to a deprecation warning from newer rdiff-backup versions. Use '--api-version 201' (or higher) to avoid it. 361s WARNING: Server will be called with deprecated command line interface to guarantee compatibility. It might lead to a deprecation warning from newer rdiff-backup versions. Use '--api-version 201' (or higher) to avoid it. 361s WARNING: Server will be called with deprecated command line interface to guarantee compatibility. It might lead to a deprecation warning from newer rdiff-backup versions. Use '--api-version 201' (or higher) to avoid it. 361s WARNING: Server will be called with deprecated command line interface to guarantee compatibility. It might lead to a deprecation warning from newer rdiff-backup versions. Use '--api-version 201' (or higher) to avoid it. 361s WARNING: Server will be called with deprecated command line interface to guarantee compatibility. It might lead to a deprecation warning from newer rdiff-backup versions. Use '--api-version 201' (or higher) to avoid it. 361s WARNING: Server will be called with deprecated command line interface to guarantee compatibility. It might lead to a deprecation warning from newer rdiff-backup versions. Use '--api-version 201' (or higher) to avoid it. 361s WARNING: Server will be called with deprecated command line interface to guarantee compatibility. It might lead to a deprecation warning from newer rdiff-backup versions. Use '--api-version 201' (or higher) to avoid it. 362s .NOTE: Could not determine case sensitivity of source directory /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_empty because we can't find any files with letters in them. It will be treated as case sensitive: unnecessary but harmless quoting of capital letters might happen if the target repository is case insensitive 364s .WARNING: ACL name aoensutheu not found on system, dropping entry. Further ACL entries dropped with this name will not trigger further warnings 364s WARNING: ACL name aeuai not found on system, dropping entry. Further ACL entries dropped with this name will not trigger further warnings 364s WARNING: ACL name enutohnh not found on system, dropping entry. Further ACL entries dropped with this name will not trigger further warnings 364s Fatal Error: --never-drop-acls specified but cannot map ACL name aoensutheu 364s .WARNING: this command line interface is deprecated and will disappear, start using the new one as described with '--new --help'. 364s WARNING: Server will be called with deprecated command line interface to guarantee compatibility. It might lead to a deprecation warning from newer rdiff-backup versions. Use '--api-version 201' (or higher) to avoid it. 364s NOTE: Starting mirror from source path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_map_test to destination path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 364s .WARNING: this command line interface is deprecated and will disappear, start using the new one as described with '--new --help'. 364s WARNING: Server will be called with deprecated command line interface to guarantee compatibility. It might lead to a deprecation warning from newer rdiff-backup versions. Use '--api-version 201' (or higher) to avoid it. 364s NOTE: Starting mirror from source path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_test1 to destination path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 364s WARNING: this command line interface is deprecated and will disappear, start using the new one as described with '--new --help'. 364s WARNING: Server will be called with deprecated command line interface to guarantee compatibility. It might lead to a deprecation warning from newer rdiff-backup versions. Use '--api-version 201' (or higher) to avoid it. 364s NOTE: Starting increment operation from source path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_test2 to destination path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 364s WARNING: this command line interface is deprecated and will disappear, start using the new one as described with '--new --help'. 364s WARNING: Server will be called with deprecated command line interface to guarantee compatibility. It might lead to a deprecation warning from newer rdiff-backup versions. Use '--api-version 201' (or higher) to avoid it. 365s WARNING: this command line interface is deprecated and will disappear, start using the new one as described with '--new --help'. 365s WARNING: Server will be called with deprecated command line interface to guarantee compatibility. It might lead to a deprecation warning from newer rdiff-backup versions. Use '--api-version 201' (or higher) to avoid it. 365s .WARNING: this command line interface is deprecated and will disappear, start using the new one as described with '--new --help'. 365s WARNING: Server will be called with deprecated command line interface to guarantee compatibility. It might lead to a deprecation warning from newer rdiff-backup versions. Use '--api-version 201' (or higher) to avoid it. 365s NOTE: Starting mirror from source path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_test1 to destination path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 365s WARNING: this command line interface is deprecated and will disappear, start using the new one as described with '--new --help'. 365s WARNING: Server will be called with deprecated command line interface to guarantee compatibility. It might lead to a deprecation warning from newer rdiff-backup versions. Use '--api-version 201' (or higher) to avoid it. 365s NOTE: Starting increment operation from source path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_test1 to destination path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 365s .WARNING: Server will be called with deprecated command line interface to guarantee compatibility. It might lead to a deprecation warning from newer rdiff-backup versions. Use '--api-version 201' (or higher) to avoid it. 365s WARNING: Server will be called with deprecated command line interface to guarantee compatibility. It might lead to a deprecation warning from newer rdiff-backup versions. Use '--api-version 201' (or higher) to avoid it. 365s WARNING: Server will be called with deprecated command line interface to guarantee compatibility. It might lead to a deprecation warning from newer rdiff-backup versions. Use '--api-version 201' (or higher) to avoid it. 365s WARNING: Server will be called with deprecated command line interface to guarantee compatibility. It might lead to a deprecation warning from newer rdiff-backup versions. Use '--api-version 201' (or higher) to avoid it. 365s NOTE: Starting mirror from source path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_test1 to destination path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 365s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_test1 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output, hardlinks 1, eas 0, acls 1 365s NOTE: Could not determine case sensitivity of source directory /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_empty because we can't find any files with letters in them. It will be treated as case sensitive: unnecessary but harmless quoting of capital letters might happen if the target repository is case insensitive 365s NOTE: Starting increment operation from source path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_empty to destination path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 365s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_empty and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output, hardlinks 1, eas 0, acls 1 365s NOTE: Starting increment operation from source path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_test2 to destination path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 365s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_test2 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output, hardlinks 1, eas 0, acls 1 365s NOTE: Starting increment operation from source path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_test1 to destination path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 365s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_test1 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output, hardlinks 1, eas 0, acls 1 365s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_test1 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/restore, hardlinks True, eas 0, acls 1 365s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_empty and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/restore, hardlinks True, eas 0, acls 1 365s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_test2 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/restore, hardlinks True, eas 0, acls 1 365s NOTE: Starting mirror from source path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_test1 to destination path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 365s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_test1 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output, hardlinks 1, eas 0, acls 1 365s NOTE: Starting increment operation from source path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_test2 to destination path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 365s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_test2 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output, hardlinks 1, eas 0, acls 1 365s NOTE: Starting increment operation from source path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_empty to destination path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 365s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_empty and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output, hardlinks 1, eas 0, acls 1 365s NOTE: Starting increment operation from source path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_test1 to destination path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 365s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_test1 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output, hardlinks 1, eas 0, acls 1 365s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_test1 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/restore, hardlinks True, eas 0, acls 1 365s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_test2 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/restore, hardlinks True, eas 0, acls 1 365s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_empty and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/restore, hardlinks True, eas 0, acls 1 365s Executing: /usr/bin/rdiff-backup '--user-mapping-file /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_map_test/users_map_file --group-mapping-file /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_map_test/groups_map_file' /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_map_test /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 365s Executing: /usr/bin/rdiff-backup '' '--current-time 10000' /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_test1 /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 365s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_test1 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output, hardlinks True, eas False, acls 1 365s Executing: /usr/bin/rdiff-backup '' '--current-time 20000' /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_test2 /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 365s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_test2 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output, hardlinks True, eas False, acls 1 365s Executing: /usr/bin/rdiff-backup '-r 10000' /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/restore 365s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_test1 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/restore, hardlinks True, eas False, acls 1 365s Executing: /usr/bin/rdiff-backup '-r now' /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/restore 365s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_test2 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/restore, hardlinks True, eas False, acls 1 365s Executing: /usr/bin/rdiff-backup '' '--current-time 10000' /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_test1 /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 365s Executing: /usr/bin/rdiff-backup '' '--current-time 20000' /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/acl_test1 /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 365s NOTE: Starting mirror from source path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_acl_test1 to destination path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 365s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_acl_test1 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output, hardlinks 1, eas 1, acls 1 365s NOTE: Starting increment operation from source path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_acl_test2 to destination path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 365s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_acl_test2 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output, hardlinks 1, eas 1, acls 1 365s NOTE: Could not determine case sensitivity of source directory /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_acl_empty because we can't find any files with letters in them. It will be treated as case sensitive: unnecessary but harmless quoting of capital letters might happen if the target repository is case insensitive 365s NOTE: Starting increment operation from source path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_acl_empty to destination path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 365s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_acl_empty and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output, hardlinks 1, eas 1, acls 1 365s NOTE: Starting increment operation from source path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_acl_test1 to destination path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 365s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_acl_test1 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output, hardlinks 1, eas 1, acls 1 365s WARNING: Server will be called with deprecated command line interface to guarantee compatibility. It might lead to a deprecation warning from newer rdiff-backup versions. Use '--api-version 201' (or higher) to avoid it. 365s WARNING: Server will be called with deprecated command line interface to guarantee compatibility. It might lead to a deprecation warning from newer rdiff-backup versions. Use '--api-version 201' (or higher) to avoid it. 365s WARNING: Server will be called with deprecated command line interface to guarantee compatibility. It might lead to a deprecation warning from newer rdiff-backup versions. Use '--api-version 201' (or higher) to avoid it. 366s .NOTE: Could not determine case sensitivity of source directory /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_acl_empty because we can't find any files with letters in them. It will be treated as case sensitive: unnecessary but harmless quoting of capital letters might happen if the target repository is case insensitive 368s .....WARNING: Server will be called with deprecated command line interface to guarantee compatibility. It might lead to a deprecation warning from newer rdiff-backup versions. Use '--api-version 201' (or higher) to avoid it. 368s WARNING: Server will be called with deprecated command line interface to guarantee compatibility. It might lead to a deprecation warning from newer rdiff-backup versions. Use '--api-version 201' (or higher) to avoid it. 368s WARNING: Server will be called with deprecated command line interface to guarantee compatibility. It might lead to a deprecation warning from newer rdiff-backup versions. Use '--api-version 201' (or higher) to avoid it. 368s WARNING: Server will be called with deprecated command line interface to guarantee compatibility. It might lead to a deprecation warning from newer rdiff-backup versions. Use '--api-version 201' (or higher) to avoid it. 368s WARNING: Server will be called with deprecated command line interface to guarantee compatibility. It might lead to a deprecation warning from newer rdiff-backup versions. Use '--api-version 201' (or higher) to avoid it. 368s WARNING: Server will be called with deprecated command line interface to guarantee compatibility. It might lead to a deprecation warning from newer rdiff-backup versions. Use '--api-version 201' (or higher) to avoid it. 368s WARNING: Server will be called with deprecated command line interface to guarantee compatibility. It might lead to a deprecation warning from newer rdiff-backup versions. Use '--api-version 201' (or higher) to avoid it. 369s .NOTE: Could not determine case sensitivity of source directory /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_empty because we can't find any files with letters in them. It will be treated as case sensitive: unnecessary but harmless quoting of capital letters might happen if the target repository is case insensitive 371s .WARNING: this command line interface is deprecated and will disappear, start using the new one as described with '--new --help'. 371s WARNING: Server will be called with deprecated command line interface to guarantee compatibility. It might lead to a deprecation warning from newer rdiff-backup versions. Use '--api-version 201' (or higher) to avoid it. 371s NOTE: Starting mirror from source path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_test1 to destination path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 372s WARNING: this command line interface is deprecated and will disappear, start using the new one as described with '--new --help'. 372s WARNING: Server will be called with deprecated command line interface to guarantee compatibility. It might lead to a deprecation warning from newer rdiff-backup versions. Use '--api-version 201' (or higher) to avoid it. 372s NOTE: Starting increment operation from source path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_test2 to destination path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 372s WARNING: this command line interface is deprecated and will disappear, start using the new one as described with '--new --help'. 372s WARNING: Server will be called with deprecated command line interface to guarantee compatibility. It might lead to a deprecation warning from newer rdiff-backup versions. Use '--api-version 201' (or higher) to avoid it. 372s . 372s ---------------------------------------------------------------------- 372s Ran 20 tests in 10.874s 372s 372s OK 372s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_acl_test1 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/restore, hardlinks True, eas 1, acls 1 372s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_acl_test2 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/restore, hardlinks True, eas 1, acls 1 372s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_acl_empty and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/restore, hardlinks True, eas 1, acls 1 372s NOTE: Starting mirror from source path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_acl_test1 to destination path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 372s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_acl_test1 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output, hardlinks 1, eas 1, acls 1 372s NOTE: Starting increment operation from source path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_acl_empty to destination path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 372s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_acl_empty and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output, hardlinks 1, eas 1, acls 1 372s NOTE: Starting increment operation from source path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_acl_test2 to destination path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 372s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_acl_test2 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output, hardlinks 1, eas 1, acls 1 372s NOTE: Starting increment operation from source path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_acl_test1 to destination path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 372s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_acl_test1 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output, hardlinks 1, eas 1, acls 1 372s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_acl_test1 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/restore, hardlinks True, eas 1, acls 1 372s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_acl_empty and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/restore, hardlinks True, eas 1, acls 1 372s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_acl_test2 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/restore, hardlinks True, eas 1, acls 1 372s NOTE: Starting mirror from source path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_test1 to destination path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 372s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_test1 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output, hardlinks 1, eas 1, acls 0 372s NOTE: Could not determine case sensitivity of source directory /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_empty because we can't find any files with letters in them. It will be treated as case sensitive: unnecessary but harmless quoting of capital letters might happen if the target repository is case insensitive 372s NOTE: Starting increment operation from source path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_empty to destination path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 372s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_empty and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output, hardlinks 1, eas 1, acls 0 372s NOTE: Starting increment operation from source path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_test2 to destination path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 372s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_test2 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output, hardlinks 1, eas 1, acls 0 372s NOTE: Starting increment operation from source path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_test1 to destination path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 372s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_test1 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output, hardlinks 1, eas 1, acls 0 372s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_test1 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/restore, hardlinks True, eas 1, acls 0 372s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_empty and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/restore, hardlinks True, eas 1, acls 0 372s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_test2 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/restore, hardlinks True, eas 1, acls 0 372s NOTE: Starting mirror from source path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_test1 to destination path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 372s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_test1 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output, hardlinks 1, eas 1, acls 0 372s NOTE: Starting increment operation from source path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_test2 to destination path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 372s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_test2 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output, hardlinks 1, eas 1, acls 0 372s NOTE: Starting increment operation from source path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_empty to destination path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 372s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_empty and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output, hardlinks 1, eas 1, acls 0 372s NOTE: Starting increment operation from source path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_test1 to destination path /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 372s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_test1 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output, hardlinks 1, eas 1, acls 0 372s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_test1 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/restore, hardlinks True, eas 1, acls 0 372s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_test2 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/restore, hardlinks True, eas 1, acls 0 372s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_empty and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/restore, hardlinks True, eas 1, acls 0 372s Executing: /usr/bin/rdiff-backup '' '--current-time 10000' /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_test1 /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 372s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_test1 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output, hardlinks True, eas 1, acls False 372s Executing: /usr/bin/rdiff-backup '' '--current-time 20000' /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_test2 /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output 372s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_test2 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output, hardlinks True, eas 1, acls False 372s Executing: /usr/bin/rdiff-backup '-r 10000' /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/output /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/restore 372s NOTE: Comparing /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/ea_test1 and /tmp/autopkgtest.iT6Poc/build.lJl/src/build/testfiles/restore, hardlinks True, eas 1, acls False 372s autopkgtest [11:27:58]: test fs: -----------------------] 373s autopkgtest [11:27:59]: test fs: - - - - - - - - - - results - - - - - - - - - - 373s fs PASS 373s autopkgtest [11:27:59]: @@@@@@@@@@@@@@@@@@@@ summary 373s smoke PASS (superficial) 373s version PASS 373s unit PASS 373s files FAIL non-zero exit status 4 373s fs PASS 378s nova [W] Using flock in prodstack6-ppc64el 378s Creating nova instance adt-plucky-ppc64el-rdiff-backup-20250313-110003-juju-7f2275-prod-proposed-migration-environment-2-2f01902d-9959-4a1e-a48c-8f3cb9411ad4 from image adt/ubuntu-plucky-ppc64el-server-20250313.img (UUID 039b69e3-5f2d-4af8-9d4f-d440c2e5edc9)... 378s nova [W] Timed out waiting for 8b63f1b1-eac0-4829-9499-7b6abf2fe30c to get deleted. 378s nova [W] Using flock in prodstack6-ppc64el 378s Creating nova instance adt-plucky-ppc64el-rdiff-backup-20250313-110003-juju-7f2275-prod-proposed-migration-environment-2-2f01902d-9959-4a1e-a48c-8f3cb9411ad4 from image adt/ubuntu-plucky-ppc64el-server-20250313.img (UUID 039b69e3-5f2d-4af8-9d4f-d440c2e5edc9)... 378s nova [W] Timed out waiting for c3c1eaa3-651f-4f84-a59d-c46a5ae1e1b1 to get deleted. 378s nova [W] Using flock in prodstack6-ppc64el 378s Creating nova instance adt-plucky-ppc64el-rdiff-backup-20250313-110003-juju-7f2275-prod-proposed-migration-environment-2-2f01902d-9959-4a1e-a48c-8f3cb9411ad4 from image adt/ubuntu-plucky-ppc64el-server-20250313.img (UUID 039b69e3-5f2d-4af8-9d4f-d440c2e5edc9)... 378s nova [W] Timed out waiting for 95c1bdd1-5af6-459e-a69f-872026436165 to get deleted.