Diff of the two buildlogs: -- --- b1/build.log 2024-12-19 23:46:17.346057559 +0000 +++ b2/build.log 2024-12-19 23:59:18.110431633 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Thu Dec 19 11:32:20 -12 2024 -I: pbuilder-time-stamp: 1734651140 +I: Current time: Thu Jan 22 20:09:20 +14 2026 +I: pbuilder-time-stamp: 1769062160 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/trixie-reproducible-base.tgz] I: copying local configuration @@ -27,52 +27,84 @@ dpkg-source: info: applying py313-test-tree-with-broken-symlinks.patch I: Not using root during the build. I: Installing the build-deps -I: user script /srv/workspace/pbuilder/1238119/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/708698/tmp/hooks/D01_modify_environment starting +debug: Running on codethink01-arm64. +I: Changing host+domainname to test build reproducibility +I: Adding a custom variable just for the fun of it... +I: Changing /bin/sh to bash +'/bin/sh' -> '/bin/bash' +lrwxrwxrwx 1 root root 9 Jan 22 06:09 /bin/sh -> /bin/bash +I: Setting pbuilder2's login shell to /bin/bash +I: Setting pbuilder2's GECOS to second user,second room,second work-phone,second home-phone,second other +I: user script /srv/workspace/pbuilder/708698/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/708698/tmp/hooks/D02_print_environment starting I: set - BUILDDIR='/build/reproducible-path' - BUILDUSERGECOS='first user,first room,first work-phone,first home-phone,first other' - BUILDUSERNAME='pbuilder1' - BUILD_ARCH='arm64' - DEBIAN_FRONTEND='noninteractive' + BASH=/bin/sh + BASHOPTS=checkwinsize:cmdhist:complete_fullquote:extquote:force_fignore:globasciiranges:globskipdots:hostcomplete:interactive_comments:patsub_replacement:progcomp:promptvars:sourcepath + BASH_ALIASES=() + BASH_ARGC=() + BASH_ARGV=() + BASH_CMDS=() + BASH_LINENO=([0]="12" [1]="0") + BASH_LOADABLES_PATH=/usr/local/lib/bash:/usr/lib/bash:/opt/local/lib/bash:/usr/pkg/lib/bash:/opt/pkg/lib/bash:. + BASH_SOURCE=([0]="/tmp/hooks/D02_print_environment" [1]="/tmp/hooks/D02_print_environment") + BASH_VERSINFO=([0]="5" [1]="2" [2]="37" [3]="1" [4]="release" [5]="aarch64-unknown-linux-gnu") + BASH_VERSION='5.2.37(1)-release' + BUILDDIR=/build/reproducible-path + BUILDUSERGECOS='second user,second room,second work-phone,second home-phone,second other' + BUILDUSERNAME=pbuilder2 + BUILD_ARCH=arm64 + DEBIAN_FRONTEND=noninteractive DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=12 ' - DISTRIBUTION='trixie' - HOME='/root' - HOST_ARCH='arm64' + DIRSTACK=() + DISTRIBUTION=trixie + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/root + HOSTNAME=i-capture-the-hostname + HOSTTYPE=aarch64 + HOST_ARCH=arm64 IFS=' ' - INVOCATION_ID='7b8e037423da4285a7e06bb83b8e20c4' - LANG='C' - LANGUAGE='en_US:en' - LC_ALL='C' - MAIL='/var/mail/root' - OPTIND='1' - PATH='/usr/sbin:/usr/bin:/sbin:/bin:/usr/games' - PBCURRENTCOMMANDLINEOPERATION='build' - PBUILDER_OPERATION='build' - PBUILDER_PKGDATADIR='/usr/share/pbuilder' - PBUILDER_PKGLIBDIR='/usr/lib/pbuilder' - PBUILDER_SYSCONFDIR='/etc' - PPID='1238119' - PS1='# ' - PS2='> ' + INVOCATION_ID=9f8f77ce7bfe4e0e8609bdc63793b042 + LANG=C + LANGUAGE=nl_BE:nl + LC_ALL=C + MACHTYPE=aarch64-unknown-linux-gnu + MAIL=/var/mail/root + OPTERR=1 + OPTIND=1 + OSTYPE=linux-gnu + PATH=/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path + PBCURRENTCOMMANDLINEOPERATION=build + PBUILDER_OPERATION=build + PBUILDER_PKGDATADIR=/usr/share/pbuilder + PBUILDER_PKGLIBDIR=/usr/lib/pbuilder + PBUILDER_SYSCONFDIR=/etc + PIPESTATUS=([0]="0") + POSIXLY_CORRECT=y + PPID=708698 PS4='+ ' - PWD='/' - SHELL='/bin/bash' - SHLVL='2' - SUDO_COMMAND='/usr/bin/timeout -k 18.1h 18h /usr/bin/ionice -c 3 /usr/bin/nice /usr/sbin/pbuilder --build --configfile /srv/reproducible-results/rbuild-debian/r-b-build.t4CWGHc3/pbuilderrc_acmN --distribution trixie --hookdir /etc/pbuilder/first-build-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/trixie-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.t4CWGHc3/b1 --logfile b1/build.log datalad-next_1.5.0-1.dsc' - SUDO_GID='109' - SUDO_UID='104' - SUDO_USER='jenkins' - TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' - USER='root' - _='/usr/bin/systemd-run' - http_proxy='http://192.168.101.4:3128' + PWD=/ + SHELL=/bin/bash + SHELLOPTS=braceexpand:errexit:hashall:interactive-comments:posix + SHLVL=3 + SUDO_COMMAND='/usr/bin/timeout -k 24.1h 24h /usr/bin/ionice -c 3 /usr/bin/nice -n 11 /usr/bin/unshare --uts -- /usr/sbin/pbuilder --build --configfile /srv/reproducible-results/rbuild-debian/r-b-build.t4CWGHc3/pbuilderrc_HgD0 --distribution trixie --hookdir /etc/pbuilder/rebuild-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/trixie-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.t4CWGHc3/b2 --logfile b2/build.log datalad-next_1.5.0-1.dsc' + SUDO_GID=109 + SUDO_UID=104 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + _='I: set' + http_proxy=http://192.168.101.4:3128 I: uname -a - Linux codethink02-arm64 6.1.0-28-cloud-arm64 #1 SMP Debian 6.1.119-1 (2024-11-22) aarch64 GNU/Linux + Linux i-capture-the-hostname 6.1.0-28-cloud-arm64 #1 SMP Debian 6.1.119-1 (2024-11-22) aarch64 GNU/Linux I: ls -l /bin - lrwxrwxrwx 1 root root 7 Nov 22 14:40 /bin -> usr/bin -I: user script /srv/workspace/pbuilder/1238119/tmp/hooks/D02_print_environment finished + lrwxrwxrwx 1 root root 7 Nov 22 2024 /bin -> usr/bin +I: user script /srv/workspace/pbuilder/708698/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -309,7 +341,7 @@ Get: 165 http://deb.debian.org/debian trixie/main arm64 python3-sphinx-rtd-theme all 3.0.2+dfsg-1 [29.5 kB] Get: 166 http://deb.debian.org/debian trixie/main arm64 python3-webdavclient all 3.14.6-3 [19.8 kB] Get: 167 http://deb.debian.org/debian trixie/main arm64 unzip arm64 6.0-28+b1 [158 kB] -Fetched 88.4 MB in 1s (105 MB/s) +Fetched 88.4 MB in 0s (210 MB/s) debconf: delaying package configuration, since apt-utils is not installed Selecting previously unselected package fonts-lato. (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 ... 20076 files and directories currently installed.) @@ -855,8 +887,8 @@ Setting up tzdata (2024b-4) ... Current default time zone: 'Etc/UTC' -Local time is now: Thu Dec 19 23:32:45 UTC 2024. -Universal Time is now: Thu Dec 19 23:32:45 UTC 2024. +Local time is now: Thu Jan 22 06:09:49 UTC 2026. +Universal Time is now: Thu Jan 22 06:09:49 UTC 2026. Run 'dpkg-reconfigure tzdata' if you wish to change it. Setting up liberror-perl (0.17029-2) ... @@ -1018,7 +1050,11 @@ Building tag database... -> Finished parsing the build-deps I: Building the package -I: Running cd /build/reproducible-path/datalad-next-1.5.0/ && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games" HOME="/nonexistent/first-build" dpkg-buildpackage -us -uc -b && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games" HOME="/nonexistent/first-build" dpkg-genchanges -S > ../datalad-next_1.5.0-1_source.changes +I: user script /srv/workspace/pbuilder/708698/tmp/hooks/A99_set_merged_usr starting +Not re-configuring usrmerge for trixie +I: user script /srv/workspace/pbuilder/708698/tmp/hooks/A99_set_merged_usr finished +hostname: Name or service not known +I: Running cd /build/reproducible-path/datalad-next-1.5.0/ && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path" HOME="/nonexistent/second-build" dpkg-buildpackage -us -uc -b && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path" HOME="/nonexistent/second-build" dpkg-genchanges -S > ../datalad-next_1.5.0-1_source.changes dpkg-buildpackage: info: source package datalad-next dpkg-buildpackage: info: source version 1.5.0-1 dpkg-buildpackage: info: source distribution unstable @@ -1997,15 +2033,15 @@ debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/commands/tests/test_ls_file_collection.py::test_ls_file_collection_gitworktree PASSED debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/commands/tests/test_ls_file_collection.py::test_ls_file_collection_validator PASSED debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/commands/tests/test_ls_file_collection.py::test_replace_add_archive_content SKIPPED -debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/commands/tests/test_ls_file_collection.py::test_ls_renderer drwxr-xr-x - 1111:1111 4 min ago /build/reproducible-path/datalad-next-1.5.0/debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/commands/tests/__pycache__ (directory) --rw-r--r-- 31.0K 1111:1111 5 min ago /build/reproducible-path/datalad-next-1.5.0/debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/commands/tests/test_tree.py (file) --rw-r--r-- 1.8K 1111:1111 Jun 16 2024 /build/reproducible-path/datalad-next-1.5.0/debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/commands/tests/test_status.py (file) --rw-r--r-- 1.7K 1111:1111 Jun 16 2024 /build/reproducible-path/datalad-next-1.5.0/debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/commands/tests/test_results.py (file) --rw-r--r-- 8.1K 1111:1111 Jun 16 2024 /build/reproducible-path/datalad-next-1.5.0/debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/commands/tests/test_ls_file_collection.py (file) --rw-r--r-- 8.9K 1111:1111 Jun 16 2024 /build/reproducible-path/datalad-next-1.5.0/debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/commands/tests/test_download.py (file) --rw-r--r-- 6.0K 1111:1111 Jun 16 2024 /build/reproducible-path/datalad-next-1.5.0/debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/commands/tests/test_credentials.py (file) --rw-r--r-- 14.6K 1111:1111 Jun 16 2024 /build/reproducible-path/datalad-next-1.5.0/debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/commands/tests/test_create_sibling_webdav.py (file) --rw-r--r-- 0B 1111:1111 Jun 16 2024 /build/reproducible-path/datalad-next-1.5.0/debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/commands/tests/__init__.py (file) +debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/commands/tests/test_ls_file_collection.py::test_ls_renderer drwxr-xr-x - 2222:2222 3 min ago /build/reproducible-path/datalad-next-1.5.0/debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/commands/tests/__pycache__ (directory) +-rw-r--r-- 31.0K 2222:2222 4 min ago /build/reproducible-path/datalad-next-1.5.0/debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/commands/tests/test_tree.py (file) +-rw-r--r-- 1.8K 2222:2222 Jun 17 2024 /build/reproducible-path/datalad-next-1.5.0/debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/commands/tests/test_status.py (file) +-rw-r--r-- 1.7K 2222:2222 Jun 17 2024 /build/reproducible-path/datalad-next-1.5.0/debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/commands/tests/test_results.py (file) +-rw-r--r-- 8.1K 2222:2222 Jun 17 2024 /build/reproducible-path/datalad-next-1.5.0/debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/commands/tests/test_ls_file_collection.py (file) +-rw-r--r-- 8.9K 2222:2222 Jun 17 2024 /build/reproducible-path/datalad-next-1.5.0/debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/commands/tests/test_download.py (file) +-rw-r--r-- 6.0K 2222:2222 Jun 17 2024 /build/reproducible-path/datalad-next-1.5.0/debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/commands/tests/test_credentials.py (file) +-rw-r--r-- 14.6K 2222:2222 Jun 17 2024 /build/reproducible-path/datalad-next-1.5.0/debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/commands/tests/test_create_sibling_webdav.py (file) +-rw-r--r-- 0B 2222:2222 Jun 17 2024 /build/reproducible-path/datalad-next-1.5.0/debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/commands/tests/__init__.py (file) PASSED debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/commands/tests/test_ls_file_collection.py::test_ls_annexworktree_empty_dataset PASSED debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/commands/tests/test_ls_file_collection.py::test_ls_annexworktree_simple_dataset add(ok): sample.bin (file) @@ -2483,7 +2519,7 @@ PASSED debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/config/tests/test_core.py::test_includeif_breaking PASSED debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/config/tests/test_core.py::test_crazy_cfg PASSED -debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/config/tests/test_core.py::test_obtain create(ok): /tmp/datalad_temp_test_obtaing3lps6w4 (dataset) +debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/config/tests/test_core.py::test_obtain create(ok): /tmp/datalad_temp_test_obtain3f0_4jcp (dataset) PASSED debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/config/tests/test_core.py::test_from_env PASSED debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/config/tests/test_core.py::test_from_env_overrides PASSED @@ -2494,9 +2530,9 @@ PASSED debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/config/tests/test_core.py::test_no_local_write_if_no_dataset create(ok): . (dataset) PASSED -debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/config/tests/test_core.py::test_dataset_local_mode create(ok): /tmp/datalad_temp_test_dataset_local_mode3meptkp4 (dataset) +debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/config/tests/test_core.py::test_dataset_local_mode create(ok): /tmp/datalad_temp_test_dataset_local_modey7u8ayky (dataset) PASSED -debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/config/tests/test_core.py::test_dataset_systemglobal_mode create(ok): /tmp/datalad_temp_test_dataset_systemglobal_modei3j_xyqr (dataset) +debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/config/tests/test_core.py::test_dataset_systemglobal_mode create(ok): /tmp/datalad_temp_test_dataset_systemglobal_modev75lcqhu (dataset) PASSED debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/config/tests/test_core.py::test_global_config PASSED debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/config/tests/test_core.py::test_bare create(ok): . (dataset) @@ -2568,7 +2604,7 @@ debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/credman/tests/test_credman.py::test_credman_get_guess_type PASSED debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/credman/tests/test_credman.py::test_credman_obtain PASSED debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/credman/tests/test_credman.py::test_legacy_credentials PASSED -debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/gitpathspec/tests/test_gitpathspec.py::test_pathspecs Initialized empty Git repository in /tmp/pytest-of-pbuilder1/pytest-0/pathspec_match0/.git/ +debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/gitpathspec/tests/test_gitpathspec.py::test_pathspecs Initialized empty Git repository in /tmp/pytest-of-pbuilder2/pytest-0/pathspec_match0/.git/ PASSED debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/gitpathspec/tests/test_gitpathspec.py::test_yield_subdir_match_remainder_pathspecs PASSED debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/gitpathspec/tests/test_gitpathspec.py::test_GitPathSpecs PASSED @@ -2600,9 +2636,9 @@ debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/iter_collections/tests/test_itergitstatus.py::test_status_norec PASSED debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/iter_collections/tests/test_itergitstatus.py::test_status_smrec PASSED debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/iter_collections/tests/test_itergitstatus.py::test_status_monorec PASSED -debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/iter_collections/tests/test_itergitstatus.py::test_status_gitinit Initialized empty Git repository in /tmp/pytest-of-pbuilder1/pytest-0/test_status_gitinit0/.git/ +debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/iter_collections/tests/test_itergitstatus.py::test_status_gitinit Initialized empty Git repository in /tmp/pytest-of-pbuilder2/pytest-0/test_status_gitinit0/.git/ PASSED -debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/iter_collections/tests/test_itergitstatus.py::test_status_nohead_staged Initialized empty Git repository in /tmp/pytest-of-pbuilder1/pytest-0/test_status_nohead_staged0/.git/ +debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/iter_collections/tests/test_itergitstatus.py::test_status_nohead_staged Initialized empty Git repository in /tmp/pytest-of-pbuilder2/pytest-0/test_status_nohead_staged0/.git/ PASSED debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/iter_collections/tests/test_itergitstatus.py::test_status_submodule_added Adding existing repo at 'sub' to the index PASSED @@ -2673,7 +2709,7 @@ debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/itertools/tests/test_align_pattern.py::test_pattern_processor[data_chunks3-abc-expected3] PASSED debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/itertools/tests/test_align_pattern.py::test_pattern_processor[data_chunks4-abc-expected4] PASSED debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/itertools/tests/test_align_pattern.py::test_pattern_processor[data_chunks5-abc-expected5] PASSED -debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/itertools/tests/test_align_pattern.py::test_performance 0.008593053004005924 0.14928681097808294 17.372965220683284 +debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/itertools/tests/test_align_pattern.py::test_performance 0.010557000059634447 0.15648944000713527 14.823286835574192 PASSED debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/itertools/tests/test_align_pattern.py::test_newline_matches PASSED debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/itertools/tests/test_decode_bytes.py::test_split_decoding PASSED @@ -2749,7 +2785,7 @@ debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/patches/tests/test_patched_ria_ora.py::test_ria_postclone_noannex update(ok): . (dataset) update(ok): . (dataset) configure-sibling(ok): . (sibling) -create-sibling-ria(ok): /tmp/pytest-of-pbuilder1/pytest-0/dataset63 (dataset) +create-sibling-ria(ok): /tmp/pytest-of-pbuilder2/pytest-0/dataset63 (dataset) action summary: configure-sibling (ok: 1) create-sibling-ria (ok: 1) @@ -2759,7 +2795,7 @@ action summary: publish (ok: 2) configure-sibling(ok): . (sibling) -install(ok): /tmp/pytest-of-pbuilder1/pytest-0/test_ria_postclone_noannex0/cloned_ds (dataset) +install(ok): /tmp/pytest-of-pbuilder2/pytest-0/test_ria_postclone_noannex0/cloned_ds (dataset) action summary: configure-sibling (ok: 1) install (ok: 1) @@ -2793,7 +2829,7 @@ get(ok): three.txt (file) [from ora-remote...] action summary: get (ok: 4) -download_url(ok): /tmp/datalad_temp_test_read_access1queh1l4/dummy (file) +download_url(ok): /tmp/datalad_temp_test_read_accessu51hnkz8/dummy (file) add(ok): dummy (file) save(ok): . (dataset) action summary: @@ -2886,7 +2922,7 @@ Scanning the drive: 12 folders, 4 files, 32 bytes (1 KiB) -Creating archive: /tmp/pytest-of-pbuilder1/pytest-0/test_remote_layout0/ria-archive-store/974/ce2cf-e3f7-4f95-acc6-647951eb9755/archives/archive.7z +Creating archive: /tmp/pytest-of-pbuilder2/pytest-0/test_remote_layout0/ria-archive-store/529/a884b-56e5-4b6f-bab4-f78e2d30c12d/archives/archive.7z Add new data to archive: 12 folders, 4 files, 32 bytes (1 KiB) @@ -2901,13 +2937,13 @@ Scanning the drive: 6 folders, 2 files, 16 bytes (1 KiB) -Creating archive: /tmp/pytest-of-pbuilder1/pytest-0/test_remote_layout0/ria-archive-store/974/ce2cf-e3f7-4f95-acc6-647951eb9755/archives/archive2.7z +Creating archive: /tmp/pytest-of-pbuilder2/pytest-0/test_remote_layout0/ria-archive-store/529/a884b-56e5-4b6f-bab4-f78e2d30c12d/archives/archive2.7z Add new data to archive: 6 folders, 2 files, 16 bytes (1 KiB) Files read from disk: 2 -Archive size: 298 bytes (1 KiB) +Archive size: 297 bytes (1 KiB) Everything is Ok 7-Zip 24.09 (arm64) : Copyright (c) 1999-2024 Igor Pavlov : 2024-11-29 @@ -2916,13 +2952,13 @@ Scanning the drive: 6 folders, 2 files, 16 bytes (1 KiB) -Creating archive: /tmp/pytest-of-pbuilder1/pytest-0/test_remote_layout0/ria-archive-store/974/ce2cf-e3f7-4f95-acc6-647951eb9755/archives/archive3.7z +Creating archive: /tmp/pytest-of-pbuilder2/pytest-0/test_remote_layout0/ria-archive-store/529/a884b-56e5-4b6f-bab4-f78e2d30c12d/archives/archive3.7z Add new data to archive: 6 folders, 2 files, 16 bytes (1 KiB) Files read from disk: 2 -Archive size: 297 bytes (1 KiB) +Archive size: 296 bytes (1 KiB) Everything is Ok 7-Zip 24.09 (arm64) : Copyright (c) 1999-2024 Igor Pavlov : 2024-11-29 @@ -2931,13 +2967,13 @@ Scanning the drive: 6 folders, 2 files, 16 bytes (1 KiB) -Creating archive: /tmp/pytest-of-pbuilder1/pytest-0/test_remote_layout0/ria-archive-store/974/ce2cf-e3f7-4f95-acc6-647951eb9755/archives/archive4.7z +Creating archive: /tmp/pytest-of-pbuilder2/pytest-0/test_remote_layout0/ria-archive-store/529/a884b-56e5-4b6f-bab4-f78e2d30c12d/archives/archive4.7z Add new data to archive: 6 folders, 2 files, 16 bytes (1 KiB) Files read from disk: 2 -Archive size: 297 bytes (1 KiB) +Archive size: 301 bytes (1 KiB) Everything is Ok add(ok): one.txt (file) add(ok): subdir/two (file) @@ -2957,10 +2993,10 @@ copy(ok): three.txt (file) [to store...] action summary: copy (ok: 4) -export-archive-ora(ok): /tmp/pytest-of-pbuilder1/pytest-0/test_remote_layout0/ria-archive-store/974/ce2cf-e3f7-4f95-acc6-647951eb9755/archives/archive.7z (file) -export-archive-ora(ok): /tmp/pytest-of-pbuilder1/pytest-0/test_remote_layout0/ria-archive-store/974/ce2cf-e3f7-4f95-acc6-647951eb9755/archives/archive2.7z (file) -export-archive-ora(ok): /tmp/pytest-of-pbuilder1/pytest-0/test_remote_layout0/ria-archive-store/974/ce2cf-e3f7-4f95-acc6-647951eb9755/archives/archive3.7z (file) -export-archive-ora(ok): /tmp/pytest-of-pbuilder1/pytest-0/test_remote_layout0/ria-archive-store/974/ce2cf-e3f7-4f95-acc6-647951eb9755/archives/archive4.7z (file) +export-archive-ora(ok): /tmp/pytest-of-pbuilder2/pytest-0/test_remote_layout0/ria-archive-store/529/a884b-56e5-4b6f-bab4-f78e2d30c12d/archives/archive.7z (file) +export-archive-ora(ok): /tmp/pytest-of-pbuilder2/pytest-0/test_remote_layout0/ria-archive-store/529/a884b-56e5-4b6f-bab4-f78e2d30c12d/archives/archive2.7z (file) +export-archive-ora(ok): /tmp/pytest-of-pbuilder2/pytest-0/test_remote_layout0/ria-archive-store/529/a884b-56e5-4b6f-bab4-f78e2d30c12d/archives/archive3.7z (file) +export-archive-ora(ok): /tmp/pytest-of-pbuilder2/pytest-0/test_remote_layout0/ria-archive-store/529/a884b-56e5-4b6f-bab4-f78e2d30c12d/archives/archive4.7z (file) PASSED debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/patches/tests/test_patched_ria_ora.py::test_initremote_basic_sshurl SKIPPED debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/patches/tests/test_patched_ria_ora.py::test_initremote_basic_fileurl add(ok): one.txt (file) @@ -2991,140 +3027,139 @@ PASSED debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/patches/tests/test_patched_ria_ora.py::test_gitannex_ssh SKIPPED debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/patches/tests/test_patched_ria_ora.py::test_gitannex_local testremote store (generating test keys...) - Cannot run git-annex-remote-!dne! -- It is not installed in PATH (/usr/lib/git-core:/build/reproducible-path/datalad-next-1.5.0/debian/install-for-tests/usr/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games) - Cannot run git-annex-remote-!dne! -- It is not installed in PATH (/usr/lib/git-core:/build/reproducible-path/datalad-next-1.5.0/debian/install-for-tests/usr/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games) + Cannot run git-annex-remote-!dne! -- It is not installed in PATH (/usr/lib/git-core:/build/reproducible-path/datalad-next-1.5.0/debian/install-for-tests/usr/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path) + Cannot run git-annex-remote-!dne! -- It is not installed in PATH (/usr/lib/git-core:/build/reproducible-path/datalad-next-1.5.0/debian/install-for-tests/usr/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path) + Cannot run git-annex-remote-!dne! -- It is not installed in PATH (/usr/lib/git-core:/build/reproducible-path/datalad-next-1.5.0/debian/install-for-tests/usr/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path) + Cannot run git-annex-remote-!dne! -- It is not installed in PATH (/usr/lib/git-core:/build/reproducible-path/datalad-next-1.5.0/debian/install-for-tests/usr/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path) + Cannot run git-annex-remote-!dne! -- It is not installed in PATH (/usr/lib/git-core:/build/reproducible-path/datalad-next-1.5.0/debian/install-for-tests/usr/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path) Remote Tests unavailable remote removeKey: OK - storeKey: Cannot run git-annex-remote-!dne! -- It is not installed in PATH (/usr/lib/git-core:/build/reproducible-path/datalad-next-1.5.0/debian/install-for-tests/usr/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games) -OK - Cannot run git-annex-remote-!dne! -- It is not installed in PATH (/usr/lib/git-core:/build/reproducible-path/datalad-next-1.5.0/debian/install-for-tests/usr/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games) + storeKey: OK checkPresent: OK - retrieveKeyFile: Cannot run git-annex-remote-!dne! -- It is not installed in PATH (/usr/lib/git-core:/build/reproducible-path/datalad-next-1.5.0/debian/install-for-tests/usr/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games) -OK + retrieveKeyFile: OK retrieveKeyFileCheap: OK key size Just 1048576; remote chunksize=0 encryption=none removeKey when not present: OK (0.66s) - present False: OK (0.01s) - storeKey: OK (0.01s) + present False: OK + storeKey: OK present True: OK storeKey when already present: OK present True: OK - retrieveKeyFile: OK (0.03s) - fsck downloaded object: OK - retrieveKeyFile resume from 0: OK (0.02s) - fsck downloaded object: OK (0.03s) - retrieveKeyFile resume from 33%: OK (0.04s) + retrieveKeyFile: OK (0.02s) + fsck downloaded object: OK (0.02s) + retrieveKeyFile resume from 0: OK (0.04s) fsck downloaded object: OK (0.01s) - retrieveKeyFile resume from end: runHandler: couldn't find handler -OK (0.03s) + retrieveKeyFile resume from 33%: OK (0.02s) fsck downloaded object: OK + retrieveKeyFile resume from end: OK (0.02s) + fsck downloaded object: OK (0.01s) removeKey when present: OK present False: OK key size Just 1048576; remote chunksize=0 encryption=shared - removeKey when not present: OK (0.76s) - present False: OK (0.01s) - storeKey: OK (0.02s) - present True: OK (0.02s) - storeKey when already present: OK (0.02s) + removeKey when not present: OK (0.63s) + present False: OK + storeKey: OK + present True: OK + storeKey when already present: OK present True: OK retrieveKeyFile: OK (0.02s) - fsck downloaded object: OK (0.01s) - retrieveKeyFile resume from 0: OK (0.03s) + fsck downloaded object: OK (0.02s) + retrieveKeyFile resume from 0: OK (0.02s) fsck downloaded object: OK (0.01s) retrieveKeyFile resume from 33%: OK (0.02s) - fsck downloaded object: OK - retrieveKeyFile resume from end: OK (0.06s) - fsck downloaded object: OK + fsck downloaded object: OK (0.02s) + retrieveKeyFile resume from end: OK (0.02s) + fsck downloaded object: OK (0.02s) removeKey when present: OK present False: OK key size Just 1048576; remote chunksize=10485 encryption=none - removeKey when not present: OK (0.79s) + removeKey when not present: OK (0.68s) present False: OK - storeKey: OK (0.08s) - present True: OK (0.03s) - storeKey when already present: OK (0.03s) - present True: OK (0.03s) - retrieveKeyFile: OK (0.09s) - fsck downloaded object: OK - retrieveKeyFile resume from 0: OK (0.10s) - fsck downloaded object: OK - retrieveKeyFile resume from 33%: OK (0.07s) - fsck downloaded object: OK + storeKey: OK (0.15s) + present True: OK (0.05s) + storeKey when already present: OK (0.04s) + present True: OK (0.04s) + retrieveKeyFile: OK (0.13s) + fsck downloaded object: OK (0.01s) + retrieveKeyFile resume from 0: OK (0.13s) + fsck downloaded object: OK (0.01s) + retrieveKeyFile resume from 33%: OK (0.10s) + fsck downloaded object: OK (0.03s) retrieveKeyFile resume from end: OK (0.02s) - fsck downloaded object: OK - removeKey when present: OK (0.04s) + fsck downloaded object: OK (0.02s) + removeKey when present: OK (0.05s) present False: OK key size Just 1048576; remote chunksize=10485 encryption=shared - removeKey when not present: OK (0.53s) + removeKey when not present: OK (0.67s) present False: OK - storeKey: OK (0.10s) - present True: OK (0.03s) - storeKey when already present: OK (0.03s) - present True: OK (0.03s) - retrieveKeyFile: OK (0.10s) - fsck downloaded object: OK - retrieveKeyFile resume from 0: OK (0.08s) - fsck downloaded object: OK - retrieveKeyFile resume from 33%: OK (0.07s) - fsck downloaded object: OK - retrieveKeyFile resume from end: OK (0.01s) + storeKey: OK (0.16s) + present True: OK (0.05s) + storeKey when already present: OK (0.04s) + present True: OK (0.04s) + retrieveKeyFile: OK (0.12s) fsck downloaded object: OK - removeKey when present: OK (0.04s) + retrieveKeyFile resume from 0: OK (0.13s) + fsck downloaded object: OK (0.01s) + retrieveKeyFile resume from 33%: OK (0.09s) + fsck downloaded object: OK (0.01s) + retrieveKeyFile resume from end: OK (0.02s) + fsck downloaded object: OK (0.02s) + removeKey when present: OK (0.05s) present False: OK key size Just 1048576; remote chunksize=1048 encryption=none - removeKey when not present: OK (0.87s) + removeKey when not present: OK (1.02s) present False: OK - storeKey: OK (0.77s) - present True: OK (0.32s) - storeKey when already present: OK (0.30s) - present True: OK (0.43s) - retrieveKeyFile: OK (0.81s) + storeKey: OK (1.23s) + present True: OK (0.25s) + storeKey when already present: OK (0.19s) + present True: OK (0.20s) + retrieveKeyFile: OK (0.65s) fsck downloaded object: OK - retrieveKeyFile resume from 0: OK (0.82s) + retrieveKeyFile resume from 0: OK (0.54s) fsck downloaded object: OK - retrieveKeyFile resume from 33%: OK (0.64s) + retrieveKeyFile resume from 33%: OK (0.37s) fsck downloaded object: OK - retrieveKeyFile resume from end: OK (0.03s) - fsck downloaded object: OK (0.03s) - removeKey when present: OK (0.45s) + retrieveKeyFile resume from end: OK (0.01s) + fsck downloaded object: OK + removeKey when present: OK (0.26s) present False: OK key size Just 1048576; remote chunksize=1048 encryption=shared - removeKey when not present: OK (0.97s) + removeKey when not present: OK (1.00s) present False: OK - storeKey: OK (1.21s) - present True: OK (0.29s) - storeKey when already present: OK (0.23s) + storeKey: OK (0.63s) + present True: OK (0.17s) + storeKey when already present: OK (0.22s) present True: OK (0.19s) - retrieveKeyFile: OK (0.92s) - fsck downloaded object: OK (0.02s) - retrieveKeyFile resume from 0: OK (0.80s) - fsck downloaded object: OK (0.02s) - retrieveKeyFile resume from 33%: OK (0.67s) + retrieveKeyFile: OK (0.56s) fsck downloaded object: OK - retrieveKeyFile resume from end: OK (0.01s) + retrieveKeyFile resume from 0: OK (0.59s) + fsck downloaded object: OK + retrieveKeyFile resume from 33%: OK (0.35s) fsck downloaded object: OK - removeKey when present: OK (0.29s) + retrieveKeyFile resume from end: OK (0.02s) + fsck downloaded object: OK (0.02s) + removeKey when present: OK (0.24s) present False: OK key size Just 1048576; remote chunksize=1048576 encryption=none - removeKey when not present: OK (0.52s) + removeKey when not present: OK (0.64s) present False: OK storeKey: OK present True: OK storeKey when already present: OK present True: OK - retrieveKeyFile: OK (0.01s) - fsck downloaded object: OK - retrieveKeyFile resume from 0: OK - fsck downloaded object: OK - retrieveKeyFile resume from 33%: OK - fsck downloaded object: OK - retrieveKeyFile resume from end: OK - fsck downloaded object: OK + retrieveKeyFile: OK (0.02s) + fsck downloaded object: OK (0.02s) + retrieveKeyFile resume from 0: OK (0.02s) + fsck downloaded object: OK (0.02s) + retrieveKeyFile resume from 33%: OK (0.02s) + fsck downloaded object: OK (0.02s) + retrieveKeyFile resume from end: OK (0.02s) + fsck downloaded object: OK (0.02s) removeKey when present: OK present False: OK key size Just 1048576; remote chunksize=1048576 encryption=shared - removeKey when not present: OK (0.56s) + removeKey when not present: OK (0.62s) present False: OK storeKey: OK present True: OK @@ -3150,7 +3185,7 @@ retrieveKeyFile: OK (0.02s) fsck downloaded object: OK (0.02s) retrieveKeyFile resume from 0: OK (0.02s) - fsck downloaded object: OK (0.01s) + fsck downloaded object: OK (0.02s) retrieveKeyFile resume from 33%: OK (0.02s) fsck downloaded object: OK (0.02s) retrieveKeyFile resume from end: OK (0.03s) @@ -3165,82 +3200,83 @@ storeKey when already present: OK present True: OK retrieveKeyFile: OK (0.02s) - fsck downloaded object: OK (0.01s) - retrieveKeyFile resume from 0: OK (0.02s) fsck downloaded object: OK (0.02s) + retrieveKeyFile resume from 0: runHandler: couldn't find handler +OK (0.02s) + fsck downloaded object: OK (0.01s) retrieveKeyFile resume from 33%: OK (0.02s) fsck downloaded object: OK (0.02s) retrieveKeyFile resume from end: OK (0.03s) - fsck downloaded object: OK (0.01s) + fsck downloaded object: OK (0.02s) removeKey when present: OK present False: OK key size Just 1048577; remote chunksize=10485 encryption=none - removeKey when not present: OK (0.04s) + removeKey when not present: OK (0.05s) present False: OK storeKey: OK (0.14s) - present True: OK (0.04s) + present True: OK (0.05s) storeKey when already present: OK (0.04s) present True: OK (0.03s) - retrieveKeyFile: OK (0.15s) - fsck downloaded object: OK (0.02s) - retrieveKeyFile resume from 0: OK (0.13s) - fsck downloaded object: OK (0.01s) - retrieveKeyFile resume from 33%: OK (0.10s) + retrieveKeyFile: OK (0.12s) + fsck downloaded object: OK + retrieveKeyFile resume from 0: OK (0.14s) fsck downloaded object: OK (0.01s) + retrieveKeyFile resume from 33%: OK (0.11s) + fsck downloaded object: OK (0.02s) retrieveKeyFile resume from end: OK (0.02s) fsck downloaded object: OK (0.02s) - removeKey when present: OK (0.06s) + removeKey when present: OK (0.05s) present False: OK key size Just 1048577; remote chunksize=10485 encryption=shared removeKey when not present: OK (0.04s) present False: OK - storeKey: OK (0.13s) - present True: OK (0.05s) + storeKey: OK (0.16s) + present True: OK (0.04s) storeKey when already present: OK (0.04s) present True: OK (0.04s) - retrieveKeyFile: OK (0.12s) + retrieveKeyFile: OK (0.15s) fsck downloaded object: OK (0.01s) - retrieveKeyFile resume from 0: OK (0.13s) + retrieveKeyFile resume from 0: OK (0.14s) fsck downloaded object: OK (0.01s) retrieveKeyFile resume from 33%: OK (0.10s) - fsck downloaded object: OK (0.01s) - retrieveKeyFile resume from end: OK (0.03s) + fsck downloaded object: OK (0.02s) + retrieveKeyFile resume from end: OK (0.02s) fsck downloaded object: OK (0.02s) removeKey when present: OK (0.05s) present False: OK key size Just 1048577; remote chunksize=1048 encryption=none - removeKey when not present: OK (0.32s) + removeKey when not present: OK (0.25s) present False: OK - storeKey: OK (1.16s) - present True: OK (0.32s) - storeKey when already present: OK (0.24s) - present True: OK (0.29s) - retrieveKeyFile: OK (1.01s) - fsck downloaded object: OK (0.01s) - retrieveKeyFile resume from 0: OK (1.01s) + storeKey: OK (0.55s) + present True: OK (0.15s) + storeKey when already present: OK (0.15s) + present True: OK (0.23s) + retrieveKeyFile: OK (0.93s) fsck downloaded object: OK (0.01s) - retrieveKeyFile resume from 33%: OK (0.63s) + retrieveKeyFile resume from 0: OK (0.73s) + fsck downloaded object: OK + retrieveKeyFile resume from 33%: OK (0.41s) fsck downloaded object: OK retrieveKeyFile resume from end: OK (0.02s) - fsck downloaded object: OK (0.01s) - removeKey when present: OK (0.35s) + fsck downloaded object: OK + removeKey when present: OK (0.28s) present False: OK key size Just 1048577; remote chunksize=1048 encryption=shared - removeKey when not present: OK (0.38s) + removeKey when not present: OK (0.18s) present False: OK - storeKey: OK (1.24s) - present True: OK (0.32s) - storeKey when already present: OK (0.30s) - present True: OK (0.28s) - retrieveKeyFile: OK (1.03s) + storeKey: OK (0.56s) + present True: OK (0.19s) + storeKey when already present: OK (0.15s) + present True: OK (0.18s) + retrieveKeyFile: OK (0.65s) fsck downloaded object: OK - retrieveKeyFile resume from 0: OK (1.08s) - fsck downloaded object: OK (0.02s) - retrieveKeyFile resume from 33%: OK (0.68s) + retrieveKeyFile resume from 0: OK (0.66s) fsck downloaded object: OK (0.02s) + retrieveKeyFile resume from 33%: OK (0.67s) + fsck downloaded object: OK retrieveKeyFile resume from end: OK (0.02s) - fsck downloaded object: OK (0.01s) - removeKey when present: OK (0.37s) + fsck downloaded object: OK (0.02s) + removeKey when present: OK (0.28s) present False: OK key size Just 1048577; remote chunksize=1048576 encryption=none removeKey when not present: OK @@ -3249,14 +3285,14 @@ present True: OK storeKey when already present: OK present True: OK - retrieveKeyFile: OK (0.02s) - fsck downloaded object: OK (0.01s) + retrieveKeyFile: OK (0.01s) + fsck downloaded object: OK retrieveKeyFile resume from 0: OK (0.02s) - fsck downloaded object: OK (0.02s) - retrieveKeyFile resume from 33%: OK (0.02s) - fsck downloaded object: OK (0.02s) - retrieveKeyFile resume from end: OK (0.02s) fsck downloaded object: OK (0.01s) + retrieveKeyFile resume from 33%: OK (0.01s) + fsck downloaded object: OK + retrieveKeyFile resume from end: OK (0.02s) + fsck downloaded object: OK (0.02s) removeKey when present: OK present False: OK key size Just 1048577; remote chunksize=1048576 encryption=shared @@ -3267,7 +3303,7 @@ storeKey when already present: OK present True: OK retrieveKeyFile: OK (0.02s) - fsck downloaded object: OK (0.02s) + fsck downloaded object: OK (0.01s) retrieveKeyFile resume from 0: OK (0.02s) fsck downloaded object: OK (0.02s) retrieveKeyFile resume from 33%: OK (0.03s) @@ -3286,11 +3322,12 @@ retrieveKeyFile: OK (0.02s) fsck downloaded object: OK (0.02s) retrieveKeyFile resume from 0: OK (0.02s) - fsck downloaded object: OK (0.02s) + fsck downloaded object: OK (0.01s) retrieveKeyFile resume from 33%: OK (0.02s) - fsck downloaded object: OK (0.02s) - retrieveKeyFile resume from end: OK (0.02s) - fsck downloaded object: OK (0.02s) + fsck downloaded object: OK (0.01s) + retrieveKeyFile resume from end: runHandler: couldn't find handler +OK (0.02s) + fsck downloaded object: OK (0.01s) removeKey when present: OK present False: OK key size Just 1048575; remote chunksize=0 encryption=shared @@ -3303,80 +3340,80 @@ retrieveKeyFile: OK (0.02s) fsck downloaded object: OK (0.02s) retrieveKeyFile resume from 0: OK (0.02s) - fsck downloaded object: OK (0.01s) - retrieveKeyFile resume from 33%: OK (0.02s) - fsck downloaded object: OK (0.02s) - retrieveKeyFile resume from end: OK (0.03s) fsck downloaded object: OK (0.02s) + retrieveKeyFile resume from 33%: OK (0.02s) + fsck downloaded object: OK (0.01s) + retrieveKeyFile resume from end: OK (0.02s) + fsck downloaded object: OK (0.01s) removeKey when present: OK present False: OK key size Just 1048575; remote chunksize=10485 encryption=none - removeKey when not present: OK (0.05s) + removeKey when not present: OK (0.04s) present False: OK storeKey: OK (0.14s) present True: OK (0.04s) - storeKey when already present: OK (0.04s) - present True: OK (0.04s) - retrieveKeyFile: OK (0.14s) + storeKey when already present: OK (0.05s) + present True: OK (0.03s) + retrieveKeyFile: OK (0.13s) fsck downloaded object: OK (0.01s) retrieveKeyFile resume from 0: OK (0.13s) fsck downloaded object: OK (0.01s) - retrieveKeyFile resume from 33%: OK (0.10s) + retrieveKeyFile resume from 33%: OK (0.09s) fsck downloaded object: OK (0.01s) - retrieveKeyFile resume from end: OK (0.02s) + retrieveKeyFile resume from end: OK (0.03s) fsck downloaded object: OK (0.02s) - removeKey when present: OK (0.06s) + removeKey when present: OK (0.05s) present False: OK key size Just 1048575; remote chunksize=10485 encryption=shared - removeKey when not present: OK (0.05s) + removeKey when not present: OK (0.04s) present False: OK storeKey: OK (0.15s) present True: OK (0.04s) storeKey when already present: OK (0.04s) - present True: OK (0.04s) - retrieveKeyFile: OK (0.12s) + present True: OK (0.03s) + retrieveKeyFile: OK (0.11s) fsck downloaded object: OK - retrieveKeyFile resume from 0: OK (0.14s) - fsck downloaded object: OK (0.01s) - retrieveKeyFile resume from 33%: OK (0.10s) + retrieveKeyFile resume from 0: OK (0.13s) + fsck downloaded object: OK + retrieveKeyFile resume from 33%: OK (0.09s) fsck downloaded object: OK (0.01s) retrieveKeyFile resume from end: OK (0.02s) fsck downloaded object: OK (0.01s) - removeKey when present: OK (0.06s) + removeKey when present: OK (0.05s) present False: OK key size Just 1048575; remote chunksize=1048 encryption=none - removeKey when not present: OK (0.36s) + removeKey when not present: OK (0.31s) present False: OK - storeKey: OK (1.22s) - present True: OK (0.24s) - storeKey when already present: OK (0.29s) - present True: OK (0.32s) - retrieveKeyFile: OK (1.01s) - fsck downloaded object: OK (0.02s) - retrieveKeyFile resume from 0: OK (1.03s) + storeKey: OK (0.95s) + present True: OK (0.18s) + storeKey when already present: OK (0.15s) + present True: OK (0.16s) + retrieveKeyFile: OK (0.60s) + fsck downloaded object: OK + retrieveKeyFile resume from 0: OK (0.89s) + fsck downloaded object: OK + retrieveKeyFile resume from 33%: OK (0.61s) fsck downloaded object: OK - retrieveKeyFile resume from 33%: OK (0.72s) - fsck downloaded object: OK (0.01s) retrieveKeyFile resume from end: OK (0.02s) fsck downloaded object: OK (0.02s) - removeKey when present: OK (0.38s) + removeKey when present: OK (0.32s) present False: OK key size Just 1048575; remote chunksize=1048 encryption=shared - removeKey when not present: OK (0.36s) + removeKey when not present: OK (0.17s) present False: OK - storeKey: OK (1.22s) - present True: OK (0.25s) - storeKey when already present: OK (0.18s) - present True: OK (0.25s) - retrieveKeyFile: OK (0.97s) - fsck downloaded object: OK (0.01s) - retrieveKeyFile resume from 0: OK (1.08s) - fsck downloaded object: OK (0.01s) - retrieveKeyFile resume from 33%: OK (0.64s) - fsck downloaded object: OK (0.01s) - retrieveKeyFile resume from end: OK (0.02s) - fsck downloaded object: OK (0.02s) - removeKey when present: OK (0.44s) + storeKey: OK (0.52s) + present True: OK (0.15s) + storeKey when already present: OK (0.15s) + present True: OK (0.20s) + retrieveKeyFile: OK (0.49s) + fsck downloaded object: OK + retrieveKeyFile resume from 0: OK (0.48s) + fsck downloaded object: OK + retrieveKeyFile resume from 33%: OK (0.32s) + fsck downloaded object: OK + retrieveKeyFile resume from end: OK (0.01s) + fsck downloaded object: OK + removeKey when present: OK (0.21s) present False: OK key size Just 1048575; remote chunksize=1048576 encryption=none removeKey when not present: OK @@ -3385,14 +3422,14 @@ present True: OK storeKey when already present: OK present True: OK - retrieveKeyFile: OK (0.02s) - fsck downloaded object: OK (0.01s) - retrieveKeyFile resume from 0: OK (0.02s) - fsck downloaded object: OK (0.01s) - retrieveKeyFile resume from 33%: OK (0.02s) - fsck downloaded object: OK (0.02s) - retrieveKeyFile resume from end: OK (0.03s) - fsck downloaded object: OK (0.02s) + retrieveKeyFile: OK (0.01s) + fsck downloaded object: OK + retrieveKeyFile resume from 0: OK (0.01s) + fsck downloaded object: OK + retrieveKeyFile resume from 33%: OK (0.01s) + fsck downloaded object: OK + retrieveKeyFile resume from end: OK (0.02s) + fsck downloaded object: OK removeKey when present: OK present False: OK key size Just 1048575; remote chunksize=1048576 encryption=shared @@ -3421,12 +3458,12 @@ present True: OK retrieveKeyFile: OK (0.04s) fsck downloaded object: OK (0.03s) - retrieveKeyFile resume from 0: OK (0.04s) - fsck downloaded object: OK (0.03s) - retrieveKeyFile resume from 33%: OK (0.04s) - fsck downloaded object: OK (0.03s) - retrieveKeyFile resume from end: OK (0.04s) + retrieveKeyFile resume from 0: OK (0.03s) fsck downloaded object: OK (0.02s) + retrieveKeyFile resume from 33%: OK (0.02s) + fsck downloaded object: OK (0.02s) + retrieveKeyFile resume from end: OK (0.04s) + fsck downloaded object: OK (0.03s) removeKey when present: OK present False: OK key size Just 2097152; remote chunksize=0 encryption=shared @@ -3437,115 +3474,116 @@ storeKey when already present: OK present True: OK retrieveKeyFile: OK (0.03s) - fsck downloaded object: OK (0.03s) - retrieveKeyFile resume from 0: OK (0.04s) - fsck downloaded object: OK (0.03s) + fsck downloaded object: OK (0.02s) + retrieveKeyFile resume from 0: OK (0.05s) + fsck downloaded object: OK (0.02s) retrieveKeyFile resume from 33%: OK (0.04s) fsck downloaded object: OK (0.03s) - retrieveKeyFile resume from end: OK (0.04s) - fsck downloaded object: OK (0.03s) + retrieveKeyFile resume from end: runHandler: couldn't find handler +OK (0.04s) + fsck downloaded object: OK (0.02s) removeKey when present: OK present False: OK key size Just 2097152; remote chunksize=10485 encryption=none - removeKey when not present: OK (0.09s) + removeKey when not present: OK (0.08s) present False: OK - storeKey: OK (0.27s) - present True: OK (0.07s) - storeKey when already present: OK (0.07s) + storeKey: OK (0.24s) present True: OK (0.06s) - retrieveKeyFile: OK (0.26s) + storeKey when already present: OK (0.05s) + present True: OK (0.05s) + retrieveKeyFile: OK (0.21s) + fsck downloaded object: OK (0.02s) + retrieveKeyFile resume from 0: OK (0.25s) fsck downloaded object: OK (0.02s) - retrieveKeyFile resume from 0: OK (0.24s) - fsck downloaded object: OK (0.01s) retrieveKeyFile resume from 33%: OK (0.12s) fsck downloaded object: OK (0.01s) retrieveKeyFile resume from end: OK (0.04s) fsck downloaded object: OK (0.03s) - removeKey when present: OK (0.11s) + removeKey when present: OK (0.10s) present False: OK key size Just 2097152; remote chunksize=10485 encryption=shared - removeKey when not present: OK (0.09s) + removeKey when not present: OK (0.08s) present False: OK - storeKey: OK (0.29s) - present True: OK (0.07s) - storeKey when already present: OK (0.07s) + storeKey: OK (0.26s) present True: OK (0.06s) - retrieveKeyFile: OK (0.23s) - fsck downloaded object: OK (0.02s) - retrieveKeyFile resume from 0: OK (0.28s) - fsck downloaded object: OK (0.03s) - retrieveKeyFile resume from 33%: OK (0.18s) - fsck downloaded object: OK (0.02s) + storeKey when already present: OK (0.05s) + present True: OK (0.05s) + retrieveKeyFile: OK (0.19s) + fsck downloaded object: OK (0.01s) + retrieveKeyFile resume from 0: OK (0.16s) + fsck downloaded object: OK (0.01s) + retrieveKeyFile resume from 33%: OK (0.14s) + fsck downloaded object: OK (0.01s) retrieveKeyFile resume from end: OK (0.04s) fsck downloaded object: OK (0.03s) - removeKey when present: OK (0.11s) + removeKey when present: OK (0.09s) present False: OK key size Just 2097152; remote chunksize=1048 encryption=none - removeKey when not present: OK (0.61s) + removeKey when not present: OK (0.44s) present False: OK - storeKey: OK (2.24s) - present True: OK (0.49s) - storeKey when already present: OK (0.39s) - present True: OK (0.53s) - retrieveKeyFile: OK (1.64s) + storeKey: OK (1.60s) + present True: OK (0.39s) + storeKey when already present: OK (0.36s) + present True: OK (0.44s) + retrieveKeyFile: OK (1.02s) fsck downloaded object: OK (0.01s) - retrieveKeyFile resume from 0: OK (1.96s) + retrieveKeyFile resume from 0: OK (1.06s) fsck downloaded object: OK (0.01s) - retrieveKeyFile resume from 33%: OK (1.12s) + retrieveKeyFile resume from 33%: OK (0.80s) + fsck downloaded object: OK (0.01s) + retrieveKeyFile resume from end: OK (0.03s) fsck downloaded object: OK (0.02s) - retrieveKeyFile resume from end: OK (0.04s) - fsck downloaded object: OK (0.03s) - removeKey when present: OK (0.69s) + removeKey when present: OK (0.50s) present False: OK key size Just 2097152; remote chunksize=1048 encryption=shared - removeKey when not present: OK (0.58s) + removeKey when not present: OK (0.43s) present False: OK - storeKey: OK (1.87s) - present True: OK (0.40s) - storeKey when already present: OK (0.43s) - present True: OK (0.38s) - retrieveKeyFile: OK (1.38s) - fsck downloaded object: OK (0.01s) - retrieveKeyFile resume from 0: OK (1.31s) + storeKey: OK (1.53s) + present True: OK (0.37s) + storeKey when already present: OK (0.34s) + present True: OK (0.41s) + retrieveKeyFile: OK (1.79s) + fsck downloaded object: OK (0.02s) + retrieveKeyFile resume from 0: OK (1.32s) fsck downloaded object: OK (0.01s) - retrieveKeyFile resume from 33%: OK (0.87s) + retrieveKeyFile resume from 33%: OK (0.97s) fsck downloaded object: OK (0.01s) - retrieveKeyFile resume from end: OK (0.02s) - fsck downloaded object: OK (0.01s) - removeKey when present: OK (0.51s) + retrieveKeyFile resume from end: OK (0.03s) + fsck downloaded object: OK (0.02s) + removeKey when present: OK (0.67s) present False: OK key size Just 2097152; remote chunksize=1048576 encryption=none removeKey when not present: OK present False: OK - storeKey: OK + storeKey: OK (0.01s) present True: OK storeKey when already present: OK present True: OK - retrieveKeyFile: OK (0.02s) - fsck downloaded object: OK (0.01s) - retrieveKeyFile resume from 0: OK (0.02s) - fsck downloaded object: OK (0.01s) - retrieveKeyFile resume from 33%: OK (0.02s) - fsck downloaded object: OK (0.01s) - retrieveKeyFile resume from end: OK (0.02s) - fsck downloaded object: OK (0.01s) + retrieveKeyFile: OK (0.03s) + fsck downloaded object: OK (0.02s) + retrieveKeyFile resume from 0: OK (0.04s) + fsck downloaded object: OK (0.03s) + retrieveKeyFile resume from 33%: OK (0.04s) + fsck downloaded object: OK (0.03s) + retrieveKeyFile resume from end: OK (0.04s) + fsck downloaded object: OK (0.02s) removeKey when present: OK present False: OK key size Just 2097152; remote chunksize=1048576 encryption=shared removeKey when not present: OK present False: OK - storeKey: OK + storeKey: OK (0.01s) present True: OK storeKey when already present: OK present True: OK - retrieveKeyFile: OK (0.02s) - fsck downloaded object: OK (0.01s) - retrieveKeyFile resume from 0: OK (0.02s) - fsck downloaded object: OK (0.01s) - retrieveKeyFile resume from 33%: OK (0.02s) - fsck downloaded object: OK (0.01s) - retrieveKeyFile resume from end: OK (0.01s) - fsck downloaded object: OK (0.01s) + retrieveKeyFile: OK (0.04s) + fsck downloaded object: OK (0.03s) + retrieveKeyFile resume from 0: OK (0.04s) + fsck downloaded object: OK (0.03s) + retrieveKeyFile resume from 33%: OK (0.04s) + fsck downloaded object: OK (0.03s) + retrieveKeyFile resume from end: OK (0.04s) + fsck downloaded object: OK (0.02s) removeKey when present: OK present False: OK exporttree=yes; key size Just 1048576; key size Just 2097152 @@ -3609,7 +3647,7 @@ remove export directory: OK remove export directory that is already removed: OK -All 573 tests passed (64.89s) +All 573 tests passed (51.76s) ok (recording state in git...) create(ok): . (dataset) @@ -3666,7 +3704,7 @@ action summary: add (ok: 1) save (ok: 1) -publish(ok): . (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch fc1e99a..452a5c0] +publish(ok): . (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch 779eac6..e6d81a8] action summary: publish (ok: 1) publish(error): . (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch [rejected] (non-fast-forward)] @@ -3674,7 +3712,7 @@ publish (error: 1) Hints: 1: Updates were rejected because the tip of your current branch is behind its remote counterpart. If you want to integrate the remote changes, use 'git pull' before pushing again. See the 'Note about fast-forwards' in 'git push --help' for details. -publish(ok): . (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch 452a5c0...4a5d8b0 (forced update)] +publish(ok): . (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch e6d81a8...3134d35 (forced update)] action summary: publish (ok: 1) PASSED @@ -3682,7 +3720,7 @@ publish(impossible): . (dataset) [No push target given, and none could be auto-detected, please specify via --to] action summary: publish (impossible: 1) -publish(ok): . (dataset) [refs/heads/git-annex->target:refs/heads/git-annex c3c4955..088f6b9] +publish(ok): . (dataset) [refs/heads/git-annex->target:refs/heads/git-annex 20d3fa3..9b9ad69] publish(ok): . (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch [new branch]] action summary: publish (ok: 2) @@ -3699,18 +3737,18 @@ add (ok: 1) save (ok: 1) copy(ok): test_mod_annex_file (file) [to target...] -publish(ok): . (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch 5f56e06..2de7c9d] -publish(ok): . (dataset) [refs/heads/git-annex->target:refs/heads/git-annex e989288..a357760] +publish(ok): . (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch 676083f..042941a] +publish(ok): . (dataset) [refs/heads/git-annex->target:refs/heads/git-annex be29204..78adc19] action summary: copy (ok: 1) publish (ok: 2) -publish(ok): . (dataset) [refs/heads/git-annex->target:refs/heads/git-annex a357760..0b0ed08] +publish(ok): . (dataset) [refs/heads/git-annex->target:refs/heads/git-annex 78adc19..c576ac3] publish(error): . (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch [rejected] (non-fast-forward)] action summary: publish (error: 1, ok: 1) Hints: 1: Updates were rejected because the tip of your current branch is behind its remote counterpart. If you want to integrate the remote changes, use 'git pull' before pushing again. See the 'Note about fast-forwards' in 'git push --help' for details. -publish(ok): . (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch 2de7c9d...fe191ec (forced update)] +publish(ok): . (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch 042941a...bc66608 (forced update)] action summary: publish (notneeded: 1, ok: 1) PASSED @@ -3745,22 +3783,22 @@ action summary: add (ok: 2) save (ok: 1) -install(ok): /tmp/datalad_temp_test_push_recursivelekbvtok (dataset) -install(ok): /tmp/datalad_temp_test_push_recursivelekbvtok/sub m (dataset) -install(ok): /tmp/datalad_temp_test_push_recursivelekbvtok/subm noannex (dataset) -install(ok): /tmp/datalad_temp_test_push_recursivelekbvtok/sub m/subsub m (dataset) +install(ok): /tmp/datalad_temp_test_push_recursivedv1ccf75 (dataset) +install(ok): /tmp/datalad_temp_test_push_recursivedv1ccf75/sub m (dataset) +install(ok): /tmp/datalad_temp_test_push_recursivedv1ccf75/subm noannex (dataset) +install(ok): /tmp/datalad_temp_test_push_recursivedv1ccf75/sub m/subsub m (dataset) action summary: install (ok: 3) publish(error): sub m/subsub m (dataset) [Unknown target sibling 'target'.] publish(error): sub m (dataset) [Unknown target sibling 'target'.] publish(error): subm noannex (dataset) [Unknown target sibling 'target'.] -publish(ok): . (dataset) [refs/heads/git-annex->target:refs/heads/git-annex a0000fe..502cb44] +publish(ok): . (dataset) [refs/heads/git-annex->target:refs/heads/git-annex 6ea234f..20c6915] publish(ok): . (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch [new branch]] action summary: publish (error: 3, ok: 2) -publish(ok): sub m/subsub m (dataset) [refs/heads/git-annex->target:refs/heads/git-annex 39256b5..a0baa7c] +publish(ok): sub m/subsub m (dataset) [refs/heads/git-annex->target:refs/heads/git-annex 5c80ea9..8e9132a] publish(ok): sub m/subsub m (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch [new branch]] -publish(ok): sub m (dataset) [refs/heads/git-annex->target:refs/heads/git-annex 23e245f..f417e5e] +publish(ok): sub m (dataset) [refs/heads/git-annex->target:refs/heads/git-annex fdaa9f2..a5980f9] publish(ok): sub m (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch [new branch]] publish(ok): subm noannex (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch [new branch]] action summary: @@ -3779,10 +3817,10 @@ add (ok: 5) save (notneeded: 1, ok: 3) copy(ok): sub m/subsub m/test_mod_annex_file (file) [to target...] -publish(ok): sub m/subsub m (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch 522ca03..0f75890] -publish(ok): sub m/subsub m (dataset) [refs/heads/git-annex->target:refs/heads/git-annex bcebdf3..d6a9bc2] -publish(ok): sub m (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch abb0fd2..4711b35] -publish(ok): . (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch 861ceea..0149547] +publish(ok): sub m/subsub m (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch 69b3889..28ba936] +publish(ok): sub m/subsub m (dataset) [refs/heads/git-annex->target:refs/heads/git-annex 44cee21..507786c] +publish(ok): sub m (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch d3ecf91..feb8fff] +publish(ok): . (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch 08ae0f9..e0129a6] action summary: copy (ok: 1) publish (notneeded: 3, ok: 4) @@ -3806,14 +3844,14 @@ action summary: add (ok: 3) save (ok: 2) -publish(ok): subm noannex (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch dc072ba..b78c9d2] -publish(ok): . (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch 0149547..f1567d8] +publish(ok): subm noannex (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch 63b0694..a73044a] +publish(ok): . (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch e0129a6..54960ba] action summary: publish (notneeded: 1, ok: 2) -publish(ok): sub m/subsub m (dataset) [refs/heads/git-annex->target:refs/heads/git-annex d6a9bc2..fefddb6] +publish(ok): sub m/subsub m (dataset) [refs/heads/git-annex->target:refs/heads/git-annex 507786c..7e2b51e] copy(ok): sub m/test_mod_annex_file (file) [to target...] -publish(ok): sub m (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch 4711b35..547bc9f] -publish(ok): sub m (dataset) [refs/heads/git-annex->target:refs/heads/git-annex c937c25..cb6a4d7] +publish(ok): sub m (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch feb8fff..35a8660] +publish(ok): sub m (dataset) [refs/heads/git-annex->target:refs/heads/git-annex 0b46e68..265edd0] action summary: copy (ok: 1) publish (notneeded: 4, ok: 3) @@ -3822,7 +3860,7 @@ action summary: add (ok: 1) save (ok: 1) -publish(ok): . (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch b78c9d2..2c3bff9] +publish(ok): . (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch a73044a..8541b54] action summary: publish (ok: 1) PASSED @@ -3852,9 +3890,9 @@ add (ok: 3) save (notneeded: 1, ok: 2) copy(ok): sub m/subdir/test_file (file) [to target...] -publish(ok): sub m (dataset) [refs/heads/git-annex->target:refs/heads/git-annex 296f633..2e74f4c] +publish(ok): sub m (dataset) [refs/heads/git-annex->target:refs/heads/git-annex c6938aa..5571e62] publish(ok): sub m (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch [new branch]] -publish(ok): . (dataset) [refs/heads/git-annex->target:refs/heads/git-annex c9f74d9..cd79ee9] +publish(ok): . (dataset) [refs/heads/git-annex->target:refs/heads/git-annex d482031..5effe34] publish(ok): . (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch [new branch]] action summary: copy (ok: 1) @@ -3866,7 +3904,7 @@ action summary: add (ok: 1) save (ok: 1) -publish(ok): . (dataset) [refs/heads/git-annex->target:refs/heads/git-annex 23eaf9c..30970c2] +publish(ok): . (dataset) [refs/heads/git-annex->target:refs/heads/git-annex 36bf85d..54b4e0f] publish(ok): . (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch [new branch]] action summary: publish (ok: 2) @@ -3883,7 +3921,7 @@ copy (ok: 1) publish (notneeded: 2) copy(impossible): test_mod_annex_file (file) [Slated for transport, but no content present] -publish(ok): . (dataset) [refs/heads/git-annex->target:refs/heads/git-annex 8c634e9..5a26edb] +publish(ok): . (dataset) [refs/heads/git-annex->target:refs/heads/git-annex 5c54291..a802743] action summary: copy (impossible: 1) publish (notneeded: 1, ok: 1) @@ -3897,7 +3935,7 @@ update(ok): . (dataset) update(ok): . (dataset) configure-sibling(ok): . (sibling) -create-sibling-ria(ok): /tmp/datalad_temp_test_ria_pushge74x68a (dataset) +create-sibling-ria(ok): /tmp/datalad_temp_test_ria_push76tkn8qc (dataset) action summary: configure-sibling (ok: 1) create-sibling-ria (ok: 1) @@ -3910,7 +3948,7 @@ publish (ok: 2) PASSED debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/patches/tests/test_push.py::test_gh1426 create(ok): . (dataset) -publish(ok): . (dataset) [refs/heads/git-annex->target:refs/heads/git-annex ac6273f..63c7c2b] +publish(ok): . (dataset) [refs/heads/git-annex->target:refs/heads/git-annex 417b0d1..c00602b] publish(ok): . (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch [new branch]] action summary: publish (ok: 2) @@ -3922,7 +3960,7 @@ add (ok: 2) create (ok: 1) save (ok: 1) -publish(ok): . (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch e7bc94c..d939285] +publish(ok): . (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch ecef517..75a4a18] action summary: publish (notneeded: 1, ok: 1) PASSED @@ -3939,9 +3977,9 @@ save (ok: 1) drop(ok): secure.2 (file) update(ok): . (dataset) -create_sibling(ok): /tmp/datalad_temp_test_push_wantedk8cg4az3 (dataset) +create_sibling(ok): /tmp/datalad_temp_test_push_wantedzz6lcigp (dataset) copy(ok): data.0 (file) [to target...] -publish(ok): . (dataset) [refs/heads/git-annex->target:refs/heads/git-annex b11b21e..a2694df] +publish(ok): . (dataset) [refs/heads/git-annex->target:refs/heads/git-annex c24c73f..a6a0003] publish(ok): . (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch [new branch]] action summary: copy (ok: 1) @@ -3949,7 +3987,7 @@ action summary: publish (notneeded: 2) copy(ok): secure.1 (file) [to target...] -publish(ok): . (dataset) [refs/heads/git-annex->target:refs/heads/git-annex 486ba3b..0682192] +publish(ok): . (dataset) [refs/heads/git-annex->target:refs/heads/git-annex 29fa3d5..a7624f6] action summary: copy (ok: 1) publish (notneeded: 1, ok: 1) @@ -3961,8 +3999,8 @@ add (ok: 1) save (ok: 1) update(ok): . (dataset) -create_sibling(ok): /tmp/datalad_temp_test_auto_data_transfery8lzk7cc/a (dataset) -publish(ok): . (dataset) [refs/heads/git-annex->b:refs/heads/git-annex 0ea9039..b87ef7d] +create_sibling(ok): /tmp/datalad_temp_test_auto_data_transferb6x25iop/a (dataset) +publish(ok): . (dataset) [refs/heads/git-annex->b:refs/heads/git-annex 2f5382b..bac8a1d] publish(ok): . (dataset) [refs/heads/dl-test-branch->b:refs/heads/dl-test-branch [new branch]] action summary: publish (ok: 2) @@ -3983,16 +4021,16 @@ add (ok: 1) save (ok: 1) copy(ok): baz.dat (file) [to b...] -publish(ok): . (dataset) [refs/heads/dl-test-branch->b:refs/heads/dl-test-branch fc958de..2874726] -publish(ok): . (dataset) [refs/heads/git-annex->b:refs/heads/git-annex ff9c3d5..bf3c15d] +publish(ok): . (dataset) [refs/heads/dl-test-branch->b:refs/heads/dl-test-branch de7ff3a..f3b409e] +publish(ok): . (dataset) [refs/heads/git-annex->b:refs/heads/git-annex 523644d..22f0cb6] action summary: copy (ok: 1) publish (ok: 2) -publish(ok): . (dataset) [refs/heads/git-annex->b:refs/heads/git-annex bf3c15d..00633b5] +publish(ok): . (dataset) [refs/heads/git-annex->b:refs/heads/git-annex 22f0cb6..31df4df] action summary: publish (notneeded: 1, ok: 1) copy(ok): bar.dat (file) [to b...] -publish(ok): . (dataset) [refs/heads/git-annex->b:refs/heads/git-annex ac80965..69fbbce] +publish(ok): . (dataset) [refs/heads/git-annex->b:refs/heads/git-annex b0b0ce2..f6a37db] action summary: copy (ok: 1) publish (notneeded: 1, ok: 1) @@ -4032,15 +4070,15 @@ update(ok): . (dataset) update(ok): . (dataset) update(ok): . (dataset) -create_sibling(ok): /tmp/datalad_temp_test_auto_if_wanted_data_transfer_path_restriction46jfl9gi/a/sub1 (dataset) -create_sibling(ok): /tmp/datalad_temp_test_auto_if_wanted_data_transfer_path_restriction46jfl9gi/a/sub0 (dataset) -create_sibling(ok): /tmp/datalad_temp_test_auto_if_wanted_data_transfer_path_restriction46jfl9gi/a (dataset) +create_sibling(ok): /tmp/datalad_temp_test_auto_if_wanted_data_transfer_path_restrictione8_ko215/a/sub1 (dataset) +create_sibling(ok): /tmp/datalad_temp_test_auto_if_wanted_data_transfer_path_restrictione8_ko215/a/sub0 (dataset) +create_sibling(ok): /tmp/datalad_temp_test_auto_if_wanted_data_transfer_path_restrictione8_ko215/a (dataset) action summary: create_sibling (ok: 3) copy(ok): sub0/reg.dat (file) [to b...] -publish(ok): sub0 (dataset) [refs/heads/git-annex->b:refs/heads/git-annex 2325e97..daa1fbf] +publish(ok): sub0 (dataset) [refs/heads/git-annex->b:refs/heads/git-annex 2084c06..6917135] publish(ok): sub0 (dataset) [refs/heads/dl-test-branch->b:refs/heads/dl-test-branch [new branch]] -publish(ok): . (dataset) [refs/heads/git-annex->b:refs/heads/git-annex 389965d..852efbc] +publish(ok): . (dataset) [refs/heads/git-annex->b:refs/heads/git-annex c20d5ad..cc842a8] publish(ok): . (dataset) [refs/heads/dl-test-branch->b:refs/heads/dl-test-branch [new branch]] action summary: copy (ok: 1) @@ -4081,7 +4119,7 @@ copy(ok): f0 (file) [to target...] copy(ok): f3 (file) [to target...] copy(ok): f4 (file) [to target...] -publish(ok): . (dataset) [refs/heads/git-annex->target:refs/heads/git-annex d81e946..efa947d] +publish(ok): . (dataset) [refs/heads/git-annex->target:refs/heads/git-annex c96b907..b684a29] publish(ok): . (dataset) [refs/heads/dl-test-branch->target:refs/heads/dl-test-branch [new branch]] action summary: copy (notneeded: 3, ok: 3) @@ -4094,13 +4132,13 @@ add (ok: 1) save (ok: 1) copy(ok): f0 (file) [to local...] -publish(ok): . (dataset) [refs/heads/git-annex->local:refs/heads/git-annex be5bb56..0d717a5] +publish(ok): . (dataset) [refs/heads/git-annex->local:refs/heads/git-annex b64b0b9..fcfaebd] publish(ok): . (dataset) [refs/heads/dl-test-branch->local:refs/heads/dl-test-branch [new branch]] action summary: copy (ok: 1) publish (ok: 2) PASSED -debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/patches/tests/test_push.py::test_nested_pushclone_cycle_allplatforms create(ok): /tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsypep6w18/super (dataset) +debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/patches/tests/test_push.py::test_nested_pushclone_cycle_allplatforms create(ok): /tmp/datalad_temp_test_nested_pushclone_cycle_allplatformswo1nyu5c/super (dataset) add(ok): sub (dataset) add(ok): .gitmodules (file) save(ok): . (dataset) @@ -4118,23 +4156,23 @@ action summary: add (ok: 4) save (ok: 2) -[INFO] Start checking pre-existing sibling configuration Dataset(/tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsypep6w18/super) -[INFO] Finished checking pre-existing sibling configuration Dataset(/tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsypep6w18/super) -[INFO] Creating a new RIA store at /tmp/datalad_temp_test_nested_pushclone_cycle_allplatformswv4hiu92 +[INFO] Start checking pre-existing sibling configuration Dataset(/tmp/datalad_temp_test_nested_pushclone_cycle_allplatformswo1nyu5c/super) +[INFO] Finished checking pre-existing sibling configuration Dataset(/tmp/datalad_temp_test_nested_pushclone_cycle_allplatformswo1nyu5c/super) +[INFO] Creating a new RIA store at /tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsysqjd296 [INFO] create siblings 'store' and 'store-storage' ... -[INFO] Fetching updates for Dataset(/tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsypep6w18/super) +[INFO] Fetching updates for Dataset(/tmp/datalad_temp_test_nested_pushclone_cycle_allplatformswo1nyu5c/super) [INFO] Configure additional publication dependency on "store-storage" [INFO] create siblings 'store' and 'store-storage' ... -[INFO] Fetching updates for Dataset(/tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsypep6w18/super/sub) +[INFO] Fetching updates for Dataset(/tmp/datalad_temp_test_nested_pushclone_cycle_allplatformswo1nyu5c/super/sub) [INFO] Configure additional publication dependency on "store-storage" update(ok): . (dataset) update(ok): . (dataset) configure-sibling(ok): . (sibling) -create-sibling-ria(ok): /tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsypep6w18/super (dataset) +create-sibling-ria(ok): /tmp/datalad_temp_test_nested_pushclone_cycle_allplatformswo1nyu5c/super (dataset) update(ok): . (dataset) update(ok): . (dataset) configure-sibling(ok): . (sibling) -create-sibling-ria(ok): /tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsypep6w18/super/sub (dataset) +create-sibling-ria(ok): /tmp/datalad_temp_test_nested_pushclone_cycle_allplatformswo1nyu5c/super/sub (dataset) action summary: configure-sibling (ok: 2) create-sibling-ria (ok: 2) @@ -4150,8 +4188,8 @@ [INFO] Start counting objects [INFO] Start compressing objects [INFO] Start writing objects -[INFO] Finished push of Dataset(/tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsypep6w18/super/sub) -[INFO] Finished push of Dataset(/tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsypep6w18/super/sub) +[INFO] Finished push of Dataset(/tmp/datalad_temp_test_nested_pushclone_cycle_allplatformswo1nyu5c/super/sub) +[INFO] Finished push of Dataset(/tmp/datalad_temp_test_nested_pushclone_cycle_allplatformswo1nyu5c/super/sub) [INFO] Determine push target [INFO] Push refspecs [INFO] Determine push target @@ -4163,8 +4201,8 @@ [INFO] Start counting objects [INFO] Start compressing objects [INFO] Start writing objects -[INFO] Finished push of Dataset(/tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsypep6w18/super) -[INFO] Finished push of Dataset(/tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsypep6w18/super) +[INFO] Finished push of Dataset(/tmp/datalad_temp_test_nested_pushclone_cycle_allplatformswo1nyu5c/super) +[INFO] Finished push of Dataset(/tmp/datalad_temp_test_nested_pushclone_cycle_allplatformswo1nyu5c/super) copy(ok): sub/file2.txt (file) [to store-storage...] publish(ok): sub (dataset) [refs/heads/dl-test-branch->store:refs/heads/dl-test-branch [new branch]] publish(ok): sub (dataset) [refs/heads/git-annex->store:refs/heads/git-annex [new branch]] @@ -4174,22 +4212,22 @@ action summary: copy (ok: 2) publish (ok: 4) -[INFO] Attempting a clone into /tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsf8l_f7rn/super -[INFO] Attempting to clone from file:///tmp/datalad_temp_test_nested_pushclone_cycle_allplatformswv4hiu92/380/9ce72-67dd-45da-9910-e414b8f24afe to /tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsf8l_f7rn/super -[INFO] Completed clone attempts for Dataset(/tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsf8l_f7rn/super) +[INFO] Attempting a clone into /tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsdgsax_8n/super +[INFO] Attempting to clone from file:///tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsysqjd296/1cb/2360c-ab23-479e-933d-4e7da22eacc9 to /tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsdgsax_8n/super +[INFO] Completed clone attempts for Dataset(/tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsdgsax_8n/super) [INFO] Configure additional publication dependency on "store-storage" configure-sibling(ok): . (sibling) -install(ok): /tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsf8l_f7rn/super (dataset) +install(ok): /tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsdgsax_8n/super (dataset) action summary: configure-sibling (ok: 1) install (ok: 1) -[INFO] Ensuring presence of Dataset(/tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsf8l_f7rn/super) to get /tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsf8l_f7rn/super -[INFO] Attempting a clone into /tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsf8l_f7rn/super/sub -[INFO] Attempting to clone from file:///tmp/datalad_temp_test_nested_pushclone_cycle_allplatformswv4hiu92/8fc/82ce5-caa4-4f5b-b48a-0db30a8d08ab to /tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsf8l_f7rn/super/sub -[INFO] Completed clone attempts for Dataset(/tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsf8l_f7rn/super/sub) +[INFO] Ensuring presence of Dataset(/tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsdgsax_8n/super) to get /tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsdgsax_8n/super +[INFO] Attempting a clone into /tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsdgsax_8n/super/sub +[INFO] Attempting to clone from file:///tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsysqjd296/5ca/c9907-9ba4-46f9-b905-d25f6e07e810 to /tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsdgsax_8n/super/sub +[INFO] Completed clone attempts for Dataset(/tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsdgsax_8n/super/sub) [INFO] Configure additional publication dependency on "store-storage" configure-sibling(ok): . (sibling) -install(ok): /tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsf8l_f7rn/super/sub (dataset) +install(ok): /tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsdgsax_8n/super/sub (dataset) get(ok): file1.txt (file) [from store-storage...] get(ok): sub/file2.txt (file) [from store-storage...] action summary: @@ -4197,8 +4235,8 @@ get (ok: 2) install (ok: 1) subdataset(ok): sub (dataset) -.: store(-) [/tmp/datalad_temp_test_nested_pushclone_cycle_allplatformswv4hiu92/380/9ce72-67dd-45da-9910-e414b8f24afe (git)] -.: store(-) [/tmp/datalad_temp_test_nested_pushclone_cycle_allplatformswv4hiu92/8fc/82ce5-caa4-4f5b-b48a-0db30a8d08ab (git)] +.: store(-) [/tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsysqjd296/1cb/2360c-ab23-479e-933d-4e7da22eacc9 (git)] +.: store(-) [/tmp/datalad_temp_test_nested_pushclone_cycle_allplatformsysqjd296/5ca/c9907-9ba4-46f9-b905-d25f6e07e810 (git)] subdataset(ok): sub (dataset) nothing to save, working tree clean nothing to save, working tree clean @@ -4233,7 +4271,7 @@ debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/patches/tests/test_sshremoteio.py::test_sshremoteio_7z SKIPPED debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/repo_utils/tests/test_annex.py::test_has_initialized_annex PASSED debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/repo_utils/tests/test_annex.py::test_no_initialized_annex PASSED -debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/repo_utils/tests/test_head.py::test_get_worktree_head Initialized empty Git repository in /tmp/pytest-of-pbuilder1/pytest-0/test_get_worktree_head0/reponohead/.git/ +debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/repo_utils/tests/test_head.py::test_get_worktree_head Initialized empty Git repository in /tmp/pytest-of-pbuilder2/pytest-0/test_get_worktree_head0/reponohead/.git/ PASSED debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/runners/tests/test_git.py::test_call_git git version 2.45.2 git: 'notacommand' is not a git command. See 'git --help'. @@ -4307,10 +4345,10 @@ debian/install-for-tests/usr/lib/python3.12/dist-packages/datalad_next/utils/tests/test_patch.py::test_patched_env PASSEDVersions: annexremote=1.6.6 boto3=1.34.46 cmd:7z=24.09 cmd:annex=10.20241202 cmd:bundled-git=UNKNOWN cmd:git=2.45.2 cmd:ssh=9.9p1 cmd:system-git=2.45.2 cmd:system-ssh=9.9p1 datalad=1.1.4 humanize=4.11.0 iso8601=2.1.0 keyring=25.4.1 keyrings.alt=5.0.2 msgpack=1.0.3 platformdirs=4.3.6 requests=2.32.3 Obscure filename: str=b' |;&%b5{}\'"<> .datc ' repr=' |;&%b5{}\'"<> .datc ' Encodings: default='utf-8' filesystem='utf-8' locale.prefered='utf-8' -Environment: LANGUAGE='en_US:en' PATH='/build/reproducible-path/datalad-next-1.5.0/debian/install-for-tests/usr/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games' LANG='C' LC_ALL='C' PYTHONPATH='/build/reproducible-path/datalad-next-1.5.0/debian/install-for-tests/usr/lib/python3.12/dist-packages:' GIT_CONFIG_PARAMETERS="'init.defaultBranch=dl-test-branch' 'clone.defaultRemoteName=dl-test-remote'" PYTHON_KEYRING_BACKEND='keyrings.alt.file.PlaintextKeyring' GIT_CONFIG_GLOBAL='/tmp/datalad_temp_wifmnlvt/.gitconfig' GIT_ASKPASS='true' GIT_CONFIG_KEY_0='datalad.tests.nonetwork' GIT_CONFIG_VALUE_0='1' GIT_CONFIG_KEY_1='datalad.datasets.topurl' GIT_CONFIG_VALUE_1='https://datasets-tests.datalad.org/' GIT_CONFIG_KEY_2='bogusdataladtestsec.subsec' GIT_CONFIG_VALUE_2='unique' GIT_CONFIG_COUNT='3' +Environment: PATH='/build/reproducible-path/datalad-next-1.5.0/debian/install-for-tests/usr/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path' PYTHONPATH='/build/reproducible-path/datalad-next-1.5.0/debian/install-for-tests/usr/lib/python3.12/dist-packages:' LANGUAGE='nl_BE:nl' LANG='C' LC_ALL='C' GIT_CONFIG_PARAMETERS="'init.defaultBranch=dl-test-branch' 'clone.defaultRemoteName=dl-test-remote'" PYTHON_KEYRING_BACKEND='keyrings.alt.file.PlaintextKeyring' GIT_CONFIG_GLOBAL='/tmp/datalad_temp_91uadg_7/.gitconfig' GIT_ASKPASS='true' GIT_CONFIG_KEY_0='datalad.tests.nonetwork' GIT_CONFIG_VALUE_0='1' GIT_CONFIG_KEY_1='datalad.datasets.topurl' GIT_CONFIG_VALUE_1='https://datasets-tests.datalad.org/' GIT_CONFIG_KEY_2='bogusdataladtestsec.subsec' GIT_CONFIG_VALUE_2='unique' GIT_CONFIG_COUNT='3' -================= 401 passed, 67 skipped in 727.12s (0:12:07) ================== +================= 401 passed, 67 skipped in 657.62s (0:10:57) ================== make[1]: Leaving directory '/build/reproducible-path/datalad-next-1.5.0' create-stamp debian/debhelper-build-stamp dh_testroot -O--buildsystem=pybuild @@ -5462,12 +5500,14 @@ dpkg-buildpackage: info: binary-only upload (no source included) dpkg-genchanges: info: including full source code in upload I: copying local configuration +I: user script /srv/workspace/pbuilder/708698/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/708698/tmp/hooks/B01_cleanup finished I: unmounting dev/ptmx filesystem I: unmounting dev/pts filesystem I: unmounting dev/shm filesystem I: unmounting proc filesystem I: unmounting sys filesystem I: cleaning the build env -I: removing directory /srv/workspace/pbuilder/1238119 and its subdirectories -I: Current time: Thu Dec 19 11:46:16 -12 2024 -I: pbuilder-time-stamp: 1734651976 +I: removing directory /srv/workspace/pbuilder/708698 and its subdirectories +I: Current time: Thu Jan 22 20:22:16 +14 2026 +I: pbuilder-time-stamp: 1769062936