CI run for rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5

Radicle repository id rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5

Table of Contents

Run log

[2025-08-13T09:41:50Z INFO  ambient] ambient starts
[=3h[=3hBdsDxe: failed to load Boot0001 "UEFI QEMU DVD-ROM QM00005 " from PciRoot(0x0)/Pci(0x1F,0x2)/Sata(0x2,0xFFFF,0x0): Not Found
BdsDxe: loading Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x2,0x0)
BdsDxe: starting Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x2,0x0)
Welcome to GRUB!


INFO: Block devices
NAME   MAJ:MIN RM   SIZE RO TYPE MOUNTPOINTS
vda    254:0    0   100G  0 disk 
├─vda1 254:1    0   953M  0 part 
└─vda2 254:2    0  99.1G  0 part /
vdb    254:16   0   2.9M  1 disk 
vdc    254:32   0  22.5M  1 disk 
vdd    254:48   0   9.3G  0 disk 
vde    254:64   0  46.6G  0 disk 
vdf    254:80   0 696.7M  1 disk 
INFO: Extracting tar archive from /dev/vdb
drwxr-xr-x _rad/_rad         0 2025-08-13 09:36 ./
-rw-r--r-- _rad/_rad      2416 2025-08-13 09:36 ./plan.yaml
-rwxr-xr-x _rad/_rad   3003032 2025-08-13 09:36 ./run-ci
INFO: Extracted files:
  1477809      4 drwxr-xr-x   2 1001     1001         4096 Aug 13 09:36 .
  1477810      4 -rw-r--r--   1 1001     1001         2416 Aug 13 09:36 ./plan.yaml
  1477881   2936 -rwxr-xr-x   1 1001     1001      3003032 Aug 13 09:36 ./run-ci
INFO: Running run-ci from /dev/vdb
================================ BEGIN ================================
[2025-08-13T09:37:44Z TRACE ambient_execute_plan] ambient-execute-plan starts
[2025-08-13T09:37:44Z DEBUG ambient_execute_plan] ambient-execute-plan starts
[2025-08-13T09:37:44Z INFO  ambient_execute_plan] ambient-execute-plan starts
[2025-08-13T09:37:44Z WARN  ambient_execute_plan] ambient-execute-plan starts
[2025-08-13T09:37:44Z ERROR ambient_execute_plan] ambient-execute-plan starts
RunnablePlan::from_file: filename=plan.yaml
steps:
- action: mkdir
  pathname: /workspace
- action: mkdir
  pathname: /workspace/artifacts
- action: tar_extract
  archive: /dev/vdc
  directory: /workspace/src
- action: tar_extract
  archive: /dev/vdf
  directory: /workspace/deps
- action: tar_extract
  archive: /dev/vde
  directory: /workspace/cache
- action: spawn
  argv:
  - find
  - /workspace
  - '-maxdepth'
  - '2'
  - '-ls'
- action: cargo_fmt
- action: cargo_clippy
- action: cargo_build
- action: cargo_test
- action: shell
  shell: |
    # Because of a (temporary) limitation in Ambient, we need to set
    # these variables manually. Once Ambient manages environment
    # variables better, these can be deleted.
    export CARGO_TARGET_DIR=/workspace/cache
    export CARGO_HOME=/workspace/deps
    export HOME=/root
    export PATH="/root/.cargo/bin:$PATH"

    cargo doc --workspace --no-deps
- action: shell
  shell: |
    # Because of a (temporary) limitation in Ambient, we need to set
    # these variables manually. Once Ambient manages environment
    # variables better, these can be deleted.
    export CARGO_TARGET_DIR=/workspace/cache
    export CARGO_HOME=/workspace/deps
    export HOME=/root
    export PATH="/root/.cargo/bin:$PATH"

    # These are based on debian/control.
    export DEBEMAIL=liw@liw.fi
    export DEBFULLNAME="Lars Wirzenius"

    # Clean up after tests and documentation building. The Debian
    # package building tools do not want changes outside the
    # `debian` directory, compared to what is committed to Git, from
    # which the "upstream tarball" is created.
    git reset --hard
    git clean -fdx
    git status --ignored

    # Update debian/changelog with a new version so that every run
    # creates a newer version. This avoids us having to update the
    # file manually for every CI run.
    V="$(dpkg-parsechangelog -SVersion | sed 's/-[^-]*$//')"
    T="$(date -u "+%Y%m%dT%H%M%S")"
    version="$V.ci$T-1"
    dch -v "$version" "CI build under Ambient."
    dch -r ''
- action: deb
- action: tar_create
  archive: /dev/vde
  directory: /workspace/cache
- action: tar_create
  archive: /dev/vdd
  directory: /workspace/artifacts
executor_drive: /dev/vdb
source_drive: /dev/vdc
artifact_drive: /dev/vdd
cache_drive: /dev/vde
deps_drive: /dev/vdf
workspace_dir: /workspace
source_dir: /workspace/src
deps_dir: /workspace/deps
cache_dir: /workspace/cache
artifacts_dir: /workspace/artifacts


RUN: Action Mkdir {
    pathname: "/workspace",
}
[2025-08-13T09:37:44Z DEBUG ambient_ci::action] Plan::execute: Mkdir {
        pathname: "/workspace",
    }
RUN: Action finished OK
RUN: Action Mkdir {
    pathname: "/workspace/artifacts",
}
[2025-08-13T09:37:44Z DEBUG ambient_ci::action] Plan::execute: Mkdir {
        pathname: "/workspace/artifacts",
    }
RUN: Action finished OK
RUN: Action TarExtract {
    archive: "/dev/vdc",
    directory: "/workspace/src",
}
[2025-08-13T09:37:44Z DEBUG ambient_ci::action] Plan::execute: TarExtract {
        archive: "/dev/vdc",
        directory: "/workspace/src",
    }
[2025-08-13T09:37:44Z TRACE ambient_ci::vdrive] extracting /dev/vdc to /workspace/src
[2025-08-13T09:37:45Z TRACE ambient_ci::vdrive] extraction OK
RUN: Action finished OK
RUN: Action TarExtract {
    archive: "/dev/vdf",
    directory: "/workspace/deps",
}
[2025-08-13T09:37:45Z DEBUG ambient_ci::action] Plan::execute: TarExtract {
        archive: "/dev/vdf",
        directory: "/workspace/deps",
    }
[2025-08-13T09:37:45Z TRACE ambient_ci::vdrive] extracting /dev/vdf to /workspace/deps
[2025-08-13T09:37:46Z TRACE ambient_ci::vdrive] extraction OK
RUN: Action finished OK
RUN: Action TarExtract {
    archive: "/dev/vde",
    directory: "/workspace/cache",
}
[2025-08-13T09:37:46Z DEBUG ambient_ci::action] Plan::execute: TarExtract {
        archive: "/dev/vde",
        directory: "/workspace/cache",
    }
[2025-08-13T09:37:46Z TRACE ambient_ci::vdrive] extracting /dev/vde to /workspace/cache
[2025-08-13T09:38:55Z TRACE ambient_ci::vdrive] extraction OK
RUN: Action finished OK
RUN: Action Spawn {
    argv: [
        "find",
        "/workspace",
        "-maxdepth",
        "2",
        "-ls",
    ],
}
[2025-08-13T09:38:55Z DEBUG ambient_ci::action] Plan::execute: Spawn {
        argv: [
            "find",
            "/workspace",
            "-maxdepth",
            "2",
            "-ls",
        ],
    }
SPAWN: argv=["find", "/workspace", "-maxdepth", "2", "-ls"]
       cwd=/workspace/src (exists? true)
       extra_env=[]
  3932161      4 drwxr-xr-x   6 root     root         4096 Aug 13 09:37 /workspace
  3932162      4 drwxr-xr-x   2 root     root         4096 Aug 13 09:37 /workspace/artifacts
  3933071      4 drwxr-xr-x   3 root     root         4096 Aug 13 09:36 /workspace/deps
  3933073    120 -rw-r--r--   1 root     root       122880 Aug 13 09:36 /workspace/deps/.global-cache
  3933072      0 -rw-r--r--   1 root     root            0 Aug 13 07:06 /workspace/deps/.package-cache-mutate
  3933074      0 -rw-r--r--   1 root     root            0 Aug 13 07:05 /workspace/deps/.package-cache
  3933075      4 drwxr-xr-x   5 root     root         4096 Aug 13 07:06 /workspace/deps/registry
  3932163      4 drwxr-xr-x  12 root     root         4096 Aug 13 09:36 /workspace/src
  3932164      4 drwxr-xr-x   2 root     root         4096 Aug 13 09:36 /workspace/src/.radicle
  3932179      8 -rw-r--r--   1 root     root         7645 Aug 13 09:36 /workspace/src/HACKING.md
  3932180      4 -rw-r--r--   1 root     root           30 Aug 13 09:36 /workspace/src/.dockerignore
  3932189      4 -rw-r--r--   1 root     root          571 Aug 13 09:36 /workspace/src/git-remote-rad.1.adoc
  3933064      8 -rw-r--r--   1 root     root         7144 Aug 13 09:36 /workspace/src/rad-id.1.adoc
  3933070    108 -rw-r--r--   1 root     root       107585 Aug 13 09:36 /workspace/src/Cargo.lock
  3932220      4 -rw-r--r--   1 root     root         2613 Aug 13 09:36 /workspace/src/Cargo.toml
  3933069      4 -rw-r--r--   1 root     root         1083 Aug 13 09:36 /workspace/src/.gitsigners
  3932224      8 -rw-r--r--   1 root     root         5432 Aug 13 09:36 /workspace/src/deny.toml
  3932218      8 -rw-r--r--   1 root     root         8144 Aug 13 09:36 /workspace/src/flake.nix
  3933066      8 -rw-r--r--   1 root     root         5102 Aug 13 09:36 /workspace/src/flake.lock
  3932181      4 -rw-r--r--   1 root     root         2163 Aug 13 09:36 /workspace/src/VERSIONING.md
  3933065      4 -rw-r--r--   1 root     root         1203 Aug 13 09:36 /workspace/src/DCO
  3932499     12 -rw-r--r--   1 root     root         9723 Aug 13 09:36 /workspace/src/LICENSE-APACHE
  3932219      4 -rw-r--r--   1 root     root          101 Aug 13 09:36 /workspace/src/.gitignore
  3932168      4 drwxr-xr-x   2 root     root         4096 Aug 13 09:36 /workspace/src/scripts
  3932501      4 drwxr-xr-x   5 root     root         4096 Aug 13 09:36 /workspace/src/systemd
  3932185      4 -rw-r--r--   1 root     root           77 Aug 13 09:36 /workspace/src/rust-toolchain.toml
  3932167      4 -rw-r--r--   1 root     root         1079 Aug 13 09:36 /workspace/src/LICENSE-MIT
  3933067     12 -rw-r--r--   1 root     root         8740 Aug 13 09:36 /workspace/src/CONTRIBUTING.md
  3932223      4 -rw-r--r--   1 root     root          426 Aug 13 09:36 /workspace/src/radicle-node.1.adoc
  3932225      4 drwxr-xr-x   8 root     root         4096 Aug 13 09:36 /workspace/src/.git
  3932500     12 -rw-r--r--   1 root     root        10770 Aug 13 09:36 /workspace/src/rad-patch.1.adoc
  3932186      4 -rw-r--r--   1 root     root           42 Aug 13 09:36 /workspace/src/.envrc
  3932203      4 drwxr-xr-x   3 root     root         4096 Aug 13 09:36 /workspace/src/debian
  3932188      8 -rw-r--r--   1 root     root         7345 Aug 13 09:36 /workspace/src/CHANGELOG.md
  3932216      4 -rw-r--r--   1 root     root         3133 Aug 13 09:36 /workspace/src/README.md
  3932190      4 drwxr-xr-x   2 root     root         4096 Aug 13 09:36 /workspace/src/build
  3932508      4 drwxr-xr-x  17 root     root         4096 Aug 13 09:36 /workspace/src/crates
  3932184      8 -rw-r--r--   1 root     root         8022 Aug 13 09:36 /workspace/src/rad.1.adoc
  3933062      4 drwxr-xr-x   2 root     root         4096 Aug 13 09:36 /workspace/src/.github
  3932221      4 drwxr-xr-x   2 root     root         4096 Aug 13 09:36 /workspace/src/.config
  3933068      4 -rw-r--r--   1 root     root           79 Aug 13 09:36 /workspace/src/ARCHITECTURE.md
  3932217      4 -rw-r--r--   1 root     root         1623 Aug 13 09:36 /workspace/src/build.rs
  3932182      4 drwxr-xr-x   2 root     root         4096 Aug 13 09:36 /workspace/src/.cargo
  3932187      4 -rw-r--r--   1 root     root           61 Aug 13 09:36 /workspace/src/.env.seed
  3957754      4 drwxr-xr-x   6 root     root         4096 Aug 13 08:29 /workspace/cache
  3973816      4 drwxr-xr-x   7 root     root         4096 Aug 13 08:33 /workspace/cache/release
  3978401      4 drwxr-xr-x  24 root     root         4096 Aug 13 08:29 /workspace/cache/doc
  3957756      4 drwxr-xr-x   7 root     root         4096 Aug 13 08:27 /workspace/cache/debug
  3957755      4 drwxr-xr-x   2 root     root         4096 Aug 13 08:23 /workspace/cache/tmp
  3973815      4 -rw-r--r--   1 root     root          218 Aug 13 08:29 /workspace/cache/.rustdoc_fingerprint.json
  3978400      4 -rw-r--r--   1 root     root         1032 Aug 13 08:26 /workspace/cache/.rustc_info.json
RUN: Action finished OK
RUN: Action CargoFmt
[2025-08-13T09:38:55Z DEBUG ambient_ci::action] Plan::execute: CargoFmt
SPAWN: argv=["cargo", "fmt", "--check"]
       cwd=/workspace/src (exists? true)
       extra_env=[("CARGO_TARGET_DIR", "/workspace/cache"), ("CARGO_HOME", "/workspace/deps"), ("PATH", "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin")]
RUN: Action finished OK
RUN: Action CargoClippy
[2025-08-13T09:38:57Z DEBUG ambient_ci::action] Plan::execute: CargoClippy
SPAWN: argv=["cargo", "clippy", "--offline", "--locked", "--workspace", "--all-targets", "--no-deps", "--", "--deny", "warnings"]
       cwd=/workspace/src (exists? true)
       extra_env=[("CARGO_TARGET_DIR", "/workspace/cache"), ("CARGO_HOME", "/workspace/deps"), ("PATH", "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin")]
    Checking radicle-ssh v0.10.0 (/workspace/src/crates/radicle-ssh)
    Checking radicle-dag v0.10.0 (/workspace/src/crates/radicle-dag)
    Checking radicle-signals v0.11.0 (/workspace/src/crates/radicle-signals)
   Compiling radicle-cli v0.15.0 (/workspace/src/crates/radicle-cli)
    Checking radicle-term v0.14.0 (/workspace/src/crates/radicle-term)
   Compiling radicle-node v0.14.0 (/workspace/src/crates/radicle-node)
    Checking radicle-crypto v0.13.0 (/workspace/src/crates/radicle-crypto)
    Checking radicle-systemd v0.10.0 (/workspace/src/crates/radicle-systemd)
    Checking radicle-cob v0.15.0 (/workspace/src/crates/radicle-cob)
   Compiling radicle-remote-helper v0.12.0 (/workspace/src/crates/radicle-remote-helper)
    Checking radicle v0.18.0 (/workspace/src/crates/radicle)
    Checking radicle-fetch v0.14.0 (/workspace/src/crates/radicle-fetch)
    Checking radicle-cli-test v0.12.0 (/workspace/src/crates/radicle-cli-test)
    Checking radicle-protocol v0.2.0 (/workspace/src/crates/radicle-protocol)
    Checking radicle-schemars v0.4.0 (/workspace/src/crates/radicle-schemars)
    Finished `dev` profile [unoptimized + debuginfo] target(s) in 22.59s
RUN: Action finished OK
RUN: Action CargoBuild
[2025-08-13T09:39:19Z DEBUG ambient_ci::action] Plan::execute: CargoBuild
SPAWN: argv=["cargo", "build", "--offline", "--locked", "--workspace", "--all-targets"]
       cwd=/workspace/src (exists? true)
       extra_env=[("CARGO_TARGET_DIR", "/workspace/cache"), ("CARGO_HOME", "/workspace/deps"), ("PATH", "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin")]
   Compiling radicle-ssh v0.10.0 (/workspace/src/crates/radicle-ssh)
   Compiling radicle-dag v0.10.0 (/workspace/src/crates/radicle-dag)
   Compiling radicle-signals v0.11.0 (/workspace/src/crates/radicle-signals)
   Compiling radicle-cli v0.15.0 (/workspace/src/crates/radicle-cli)
   Compiling radicle-crypto v0.13.0 (/workspace/src/crates/radicle-crypto)
   Compiling radicle-term v0.14.0 (/workspace/src/crates/radicle-term)
   Compiling radicle-node v0.14.0 (/workspace/src/crates/radicle-node)
   Compiling radicle-cob v0.15.0 (/workspace/src/crates/radicle-cob)
   Compiling radicle-systemd v0.10.0 (/workspace/src/crates/radicle-systemd)
   Compiling radicle-remote-helper v0.12.0 (/workspace/src/crates/radicle-remote-helper)
   Compiling radicle v0.18.0 (/workspace/src/crates/radicle)
   Compiling radicle-fetch v0.14.0 (/workspace/src/crates/radicle-fetch)
   Compiling radicle-protocol v0.2.0 (/workspace/src/crates/radicle-protocol)
   Compiling radicle-cli-test v0.12.0 (/workspace/src/crates/radicle-cli-test)
   Compiling radicle-schemars v0.4.0 (/workspace/src/crates/radicle-schemars)
    Finished `dev` profile [unoptimized + debuginfo] target(s) in 44.39s
RUN: Action finished OK
RUN: Action CargoTest
[2025-08-13T09:40:08Z DEBUG ambient_ci::action] Plan::execute: CargoTest
SPAWN: argv=["cargo", "test", "--offline", "--locked", "--workspace"]
       cwd=/workspace/src (exists? true)
       extra_env=[("CARGO_TARGET_DIR", "/workspace/cache"), ("CARGO_HOME", "/workspace/deps"), ("PATH", "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin")]
    Finished `test` profile [unoptimized + debuginfo] target(s) in 1.46s
     Running unittests src/lib.rs (/workspace/cache/debug/deps/radicle-470b5d57ddeae839)

running 223 tests
test canonical::formatter::test::securesystemslib_asserts ... ok
test canonical::formatter::test::ordered_nested_object ... ok
test cob::cache::tests::test_check_version ... ok
test cob::cache::migrations::_2::tests::test_patch_json_deserialization ... ok
test cob::cache::tests::test_migrate_to ... ok
test cob::common::test::test_color ... ok
test cob::common::test::test_emojis ... ok
test canonical::formatter::test::ascii_control_characters ... ok
test cob::cache::migrations::_2::tests::test_migration_2 ... ok
test cob::identity::test::prop_json_eq_str ... ok
test cob::identity::test::test_identity_redact_revision ... ok
test cob::identity::test::test_identity_reject_concurrent ... ok
test cob::identity::test::test_identity_update_rejected ... ok
test cob::identity::test::test_identity_remove_delegate_concurrent ... ok
test cob::identity::test::test_identity_updates ... ok
test cob::issue::cache::tests::test_counts ... ok
test cob::issue::cache::tests::test_get ... ok
test cob::issue::cache::tests::test_is_empty ... ok
test cob::issue::cache::tests::test_list ... ok
test cob::issue::cache::tests::test_list_by_status ... ok
test cob::issue::cache::tests::test_remove ... ok
test cob::identity::test::test_valid_identity ... ok
test cob::identity::test::test_identity_updates_concurrent ... ok
test cob::issue::test::test_embeds ... ok
test cob::issue::test::test_embeds_edit ... ok
test cob::identity::test::test_identity_updates_concurrent_outdated ... ok
test cob::issue::test::test_invalid_actions ... ok
test cob::issue::test::test_invalid_tx_reference ... ok
test cob::issue::test::test_invalid_tx ... ok
test cob::issue::test::test_invalid_cob ... ok
test cob::issue::test::test_concurrency ... ok
test cob::issue::test::test_issue_all ... ok
test cob::issue::test::test_issue_comment ... ok
test cob::issue::test::test_issue_create_and_assign ... ok
test cob::issue::test::test_issue_comment_redact ... ok
test cob::issue::test::test_issue_create_and_get ... ok
test cob::issue::test::test_issue_create_and_change_state ... ok
test cob::issue::test::test_issue_create_and_unassign ... ok
test cob::issue::test::test_issue_create_and_reassign ... ok
test cob::issue::test::test_issue_edit ... ok
test cob::issue::test::test_issue_edit_description ... ok
test cob::issue::test::test_issue_multilines ... ok
test cob::issue::test::test_issue_state_serde ... ok
test cob::issue::test::test_ordering ... ok
test cob::patch::actions::test::test_review_edit ... ok
test cob::issue::test::test_issue_label ... ok
test cob::issue::test::test_issue_react ... ok
test cob::issue::test::test_issue_reply ... ok
test cob::patch::cache::tests::test_is_empty ... ok
test cob::patch::cache::tests::test_get ... ok
test cob::patch::cache::tests::test_list ... ok
test cob::patch::cache::tests::test_remove ... ok
test cob::patch::encoding::review::test::test_review_deserialize_summary_migration_null_summary ... ok
test cob::patch::encoding::review::test::test_review_deserialize_summary_migration_with_summary ... ok
test cob::patch::encoding::review::test::test_review_deserialize_summary_migration_without_summary ... ok
test cob::patch::encoding::review::test::test_review_deserialize_summary_v2 ... ok
test cob::patch::encoding::review::test::test_review_summary ... ok
test cob::patch::test::test_json ... ok
test cob::patch::test::test_json_serialization ... ok
test cob::patch::cache::tests::test_list_by_status ... ok
test cob::patch::test::test_patch_create_and_get ... ok
test cob::patch::test::test_patch_discussion ... ok
test cob::patch::cache::tests::test_counts ... ok
test cob::patch::test::test_patch_merge ... ok
test cob::patch::test::test_patch_redact ... ok
test cob::patch::test::test_patch_review ... ok
test cob::patch::test::test_patch_review_comment ... ok
test cob::patch::test::test_patch_review_duplicate ... ok
test cob::patch::test::test_patch_review_edit ... ok
test cob::patch::test::test_patch_review_remove_summary ... ok
test cob::patch::test::test_patch_review_edit_comment ... ok
test cob::patch::test::test_reactions_json_serialization ... ok
test cob::patch::test::test_revision_edit_redact ... ok
test cob::patch::test::test_revision_reaction ... ok
test cob::patch::test::test_revision_review_merge_redacted ... ok
test cob::patch::test::test_patch_review_revision_redact ... ok
test cob::thread::tests::test_comment_edit_missing ... ok
test cob::thread::tests::test_comment_edit_redacted ... ok
test cob::thread::tests::test_comment_redact_missing ... ok
test cob::thread::tests::test_duplicate_comments ... ok
test cob::thread::tests::test_edit_comment ... ok
test cob::thread::tests::test_redact_comment ... ok
test cob::thread::tests::test_timeline ... ok
test git::canonical::rules::tests::test_canonical ... ok
test git::canonical::rules::tests::test_deserialization ... ok
test git::canonical::rules::tests::test_deserialize_extensions ... ok
test git::canonical::rules::tests::test_order ... ok
test git::canonical::rules::tests::test_roundtrip ... ok
test cob::patch::test::test_patch_update ... ok
test git::canonical::rules::tests::test_rule_validate_success ... ok
test git::canonical::rules::tests::test_special_branches ... ok
test git::canonical::rules::tests::test_rule_validate_failures ... ok
test git::canonical::tests::test_quorum_groups ... ok
test git::canonical::tests::test_quorum_merges ... ok
test git::canonical::tests::test_quorum ... ok
test git::canonical::tests::test_quorum_tag ... ok
test git::test::test_version_from_str ... ok
test git::test::test_version_ord ... ok
test identity::did::test::test_did_encode_decode ... ok
test identity::did::test::test_did_vectors ... ok
test identity::doc::id::test::prop_from_str ... ok
test git::canonical::tests::test_quorum_properties ... ok
test identity::doc::test::test_canonical_doc ... ok
test identity::doc::test::test_canonical_example ... ok
test identity::doc::test::test_duplicate_dids ... ok
test identity::doc::test::test_future_version_error ... ok
test identity::doc::test::test_is_valid_version ... ok
test cob::thread::tests::prop_ordering ... ok
test identity::doc::test::test_not_found ... ok
test cob::patch::cache::tests::test_find_by_revision ... ok
test identity::doc::test::test_parse_version ... ok
test identity::doc::test::test_visibility_json ... ok
test identity::doc::update::test::test_can_update_crefs ... ok
test identity::doc::update::test::test_cannot_include_default_branch_rule ... ok
test identity::doc::update::test::test_default_branch_rule_exists_after_verification ... ok
test identity::project::test::test_project_name ... ok
test node::address::store::test::test_alias ... ok
test node::address::store::test::test_disconnected ... ok
test node::address::store::test::test_disconnected_ban ... ok
test node::address::store::test::test_entries ... ok
test node::address::store::test::test_get_none ... ok
test node::address::store::test::test_insert_and_get ... ok
test node::address::store::test::test_insert_and_remove ... ok
test node::address::store::test::test_insert_and_update ... ok
test node::address::store::test::test_insert_duplicate ... ok
test node::address::store::test::test_node_aliases ... ok
test node::address::store::test::test_remove_nothing ... ok
test node::db::test::test_version ... ok
test node::features::test::test_operations ... ok
test node::notifications::store::test::test_branch_notifications ... ok
test identity::doc::test::test_max_delegates ... ok
test node::notifications::store::test::test_clear ... ok
test node::notifications::store::test::test_cob_notifications ... ok
test node::notifications::store::test::test_counts_by_repo ... ok
test node::notifications::store::test::test_duplicate_notifications ... ok
test node::notifications::store::test::test_notification_status ... ok
test node::policy::store::test::test_follow_and_unfollow_node ... ok
test node::policy::store::test::test_node_aliases ... ok
test node::policy::store::test::test_node_policy ... ok
test node::policy::store::test::test_node_policies ... ok
test node::policy::store::test::test_repo_policies ... ok
test node::policy::store::test::test_seed_and_unseed_repo ... ok
test node::policy::store::test::test_update_alias ... ok
test node::policy::store::test::test_update_scope ... ok
test node::refs::store::test::test_count ... ok
test node::refs::store::test::test_set_and_delete ... ok
test node::policy::store::test::test_repo_policy ... ok
test node::refs::store::test::test_set_and_get ... ok
test node::routing::test::test_count ... ok
test node::routing::test::test_entries ... ok
test node::routing::test::test_insert_and_get_resources ... ok
test node::address::store::test::test_empty ... ok
test node::routing::test::test_insert_duplicate ... ok
test node::routing::test::test_insert_and_get ... ok
test node::routing::test::test_insert_existing_updated_time ... ok
test node::routing::test::test_insert_and_remove ... ok
test node::routing::test::test_len ... ok
test node::routing::test::test_remove_many ... ok
test node::routing::test::test_remove_redundant ... ok
test node::routing::test::test_update_existing_multi ... ok
test node::sync::announce::test::all_synced_nodes_are_preferred_seeds ... ok
test node::sync::announce::test::announcer_adapts_target_to_reach ... ok
test node::sync::announce::test::announcer_preferred_seeds_or_replica_factor ... ok
test node::routing::test::test_prune ... ok
test node::sync::announce::test::announcer_reached_max_replication_target ... ok
test node::sync::announce::test::announcer_reached_min_replication_target ... ok
test node::sync::announce::test::announcer_reached_preferred_seeds ... ok
test node::sync::announce::test::announcer_synced_with_unknown_node ... ok
test node::sync::announce::test::announcer_with_replication_factor_zero_and_preferred_seeds ... ok
test node::sync::announce::test::announcer_timed_out ... ok
test node::sync::announce::test::construct_node_appears_in_multiple_input_sets ... ok
test node::sync::announce::test::construct_only_preferred_seeds_provided ... ok
test node::sync::announce::test::invariant_progress_should_match_state ... ok
test node::sync::announce::test::local_node_in_multiple_sets ... ok
test node::sync::announce::test::cannot_construct_announcer ... ok
test node::sync::announce::test::local_node_in_preferred_seeds ... ok
test node::sync::announce::test::local_node_in_synced_set ... ok
test node::sync::announce::test::local_node_only_in_all_sets_results_in_no_seeds_error ... ok
test node::sync::announce::test::local_node_in_unsynced_set ... ok
test node::sync::announce::test::preferred_seeds_already_synced ... ok
test node::sync::announce::test::synced_with_local_node_is_ignored ... ok
test node::sync::announce::test::timed_out_after_reaching_success ... ok
test node::sync::announce::test::synced_with_same_node_multiple_times ... ok
test node::sync::fetch::test::all_nodes_are_candidates ... ok
test node::sync::fetch::test::ignores_duplicates_and_local_node ... ok
test node::sync::fetch::test::all_nodes_are_fetchable ... ok
test node::sync::fetch::test::preferred_seeds_target_returned_over_replicas ... ok
test node::sync::fetch::test::could_not_reach_target ... ok
test node::sync::fetch::test::reaches_target_of_preferred_seeds ... ok
test node::sync::test::ensure_replicas_construction ... ok
test node::sync::test::replicas_constrain_to ... ok
test node::test::test_alias ... ok
test node::test::test_command_result ... ok
test node::test::test_user_agent ... ok
test node::timestamp::tests::test_timestamp_max ... ok
test node::sync::fetch::test::reaches_target_of_replicas ... ok
test profile::test::canonicalize_home ... ok
test profile::test::test_config ... ok
test node::sync::fetch::test::reaches_target_of_max_replicas ... ok
test rad::tests::test_checkout ... ok
test rad::tests::test_fork ... ok
test serde_ext::test::test_localtime ... ok
test serde_ext::test::test_localtime_ext ... ok
test storage::git::tests::test_references_of ... ok
test rad::tests::test_init ... ok
test storage::git::tests::test_sign_refs ... ok
test storage::git::transport::local::url::test::test_url_parse ... ok
test storage::git::transport::local::url::test::test_url_to_string ... ok
test storage::git::transport::remote::url::test::test_url_parse ... ok
test storage::refs::tests::prop_canonical_roundtrip ... ok
test storage::git::tests::test_remote_refs ... ok
test storage::tests::test_storage ... ok
test test::assert::test::assert_with_message ... ok
test test::assert::test::test_assert_no_move ... ok
test test::assert::test::test_assert_panic_0 - should panic ... ok
test test::assert::test::test_assert_panic_1 - should panic ... ok
test test::assert::test::test_assert_panic_2 - should panic ... ok
test test::assert::test::test_assert_succeed ... ok
test test::assert::test::test_panic_message ... ok
test version::test::test_version ... ok
test profile::config::test::schema ... ok
test storage::refs::tests::test_rid_verification ... ok
test identity::doc::test::prop_encode_decode ... ok

test result: ok. 223 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 3.99s

     Running unittests src/lib.rs (/workspace/cache/debug/deps/radicle_cli-3beb2acfdc1661c1)

running 14 tests
test commands::rad_patch::review::builder::tests::test_review_comments_multiline ... ok
test commands::rad_inspect::test::test_tree ... ok
test commands::rad_patch::review::builder::tests::test_review_comments_basic ... ok
test commands::rad_patch::review::builder::tests::test_review_comments_split_hunk ... ok
test git::ddiff::tests::diff_encode_decode_ddiff_hunk ... ok
test git::pretty_diff::test::test_pretty ... ignored
test git::unified_diff::test::test_diff_content_encode_decode_content ... ok
test git::unified_diff::test::test_diff_encode_decode_diff ... ok
test terminal::format::test::test_bytes ... ok
test terminal::format::test::test_strip_comments ... ok
test terminal::patch::test::test_edit_display_message ... ok
test terminal::patch::test::test_create_display_message ... ok
test terminal::patch::test::test_update_display_message ... ok
test commands::rad_patch::review::builder::tests::test_review_comments_before ... ok

test result: ok. 13 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out; finished in 0.03s

     Running unittests src/main.rs (/workspace/cache/debug/deps/rad-a688f6b88a0ae1aa)

running 0 tests

test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s

     Running tests/commands.rs (/workspace/cache/debug/deps/commands-7e751aa8c63b07e8)

running 101 tests
test framework_home ... ok
test git_push_and_fetch ... ok
test git_push_amend ... ok
test git_push_canonical_annotated_tags ... ok
test git_push_canonical_lightweight_tags ... ok
test git_push_diverge ... ok
test git_tag ... FAILED
test rad_auth_errors ... ok
test rad_auth ... ok
test git_push_rollback ... ok
test rad_block ... ok
test rad_checkout ... ok
test git_push_converge ... ok
test rad_clone ... ok
test rad_clean ... ok
test rad_clone_all ... ok
test rad_clone_directory ... ok
test rad_clone_connect ... ok
test rad_clone_unknown ... ok
test rad_cob_log ... ok
test rad_cob_migrate ... ok
test rad_cob_multiset ... ok
test rad_cob_show ... ok
test rad_cob_update_identity ... ok
test rad_cob_update ... ok
test rad_diff ... ok
test rad_clone_partial_fail ... ok
test rad_config ... ok
test rad_id_collaboration ... ignored, slow
test rad_id ... ok
test rad_id_conflict ... ok
test rad_id_missing_commits ... ok
test rad_fetch ... ok
test rad_fork ... ok
test rad_id_private ... ok
test rad_id_multi_delegate ... ok
test rad_id_unknown_field ... ok
test rad_id_update_delete_field ... ok
test rad_init ... ignored, part of many other tests
test rad_init_detached_head ... ok
test rad_id_threshold_soft_fork ... ok
test rad_init_existing ... ok
test rad_init_no_git ... ok
test rad_init_no_seed ... ok
test rad_init_private ... ok
test rad_id_threshold ... ok
test rad_init_private_no_seed ... ok
test rad_inbox ... ok
test rad_init_private_clone_seed ... ok
test rad_init_private_clone ... ok
test rad_init_sync_not_connected ... ok
test rad_init_private_seed ... ok
test rad_init_with_existing_remote ... ok
test rad_init_sync_preferred ... ok
test rad_inspect ... ok
test rad_issue ... ok
test rad_merge_after_update ... ok
test rad_merge_no_ff ... ok
test rad_merge_via_push ... ok
test rad_node_connect ... ok
test rad_node ... ok
test rad_init_sync_and_clone ... ok
test rad_node_connect_without_address ... ok
test rad_init_sync_timeout ... ok
test rad_patch_ahead_behind ... ok
test rad_patch_change_base ... ok
test rad_patch ... ok
test rad_patch_checkout ... ok
test rad_patch_checkout_revision ... ok
test rad_patch_detached_head ... ok
test rad_patch_diff ... ok
test rad_patch_draft ... ok
test rad_patch_checkout_force ... ok
test rad_patch_edit ... ok
test rad_patch_fetch_2 ... ok
test rad_patch_merge_draft ... ok
test rad_patch_fetch_1 ... ok
test rad_patch_revert_merge ... ok
test rad_patch_update ... ok
test rad_patch_open_explore ... ok
test rad_patch_delete ... ok
test rad_publish ... ok
test rad_patch_via_push ... ok
test rad_review_by_hunk ... ok
test rad_seed_and_follow ... ok
test rad_patch_pull_update ... ok
test rad_remote ... ok
test rad_push_and_pull_patches ... ok
test rad_seed_many ... ok
test rad_self ... ok
test rad_unseed ... ok
test rad_unseed_many ... ok
test rad_warn_old_nodes ... ok
test rad_sync_without_node ... ok
test test_clone_without_seeds ... ok
test rad_watch ... ok
test rad_sync ... ok
test test_cob_deletion ... ok
test test_cob_replication ... ok
test rad_workflow ... ok
test test_replication_via_seed ... ok

failures:

---- git_tag stdout ----
1755078042 test: Using PATH ["/workspace/cache/debug", "/workspace/deps/bin", "/root/.cargo/bin", "/usr/local/sbin", "/usr/local/bin", "/usr/sbin", "/usr/bin", "/sbin", "/bin", "/tmp/radicle-wk5SL6/work/alice"]
1755078042 test: rad-init.md: Running `/workspace/cache/debug/rad` with ["init", "--name", "heartwood", "--description", "Radicle Heartwood Protocol & Stack", "--no-confirm", "--public", "-v"] in `/tmp/radicle-wk5SL6/work/alice`..
1755078042 test: rad-init.md: Running `/workspace/cache/debug/rad` with ["init"] in `/tmp/radicle-wk5SL6/work/alice`..
1755078042 test: rad-init.md: Running `/workspace/cache/debug/rad` with ["ls"] in `/tmp/radicle-wk5SL6/work/alice`..
1755078042 test: rad-init.md: Running `/workspace/cache/debug/rad` with ["node", "inventory"] in `/tmp/radicle-wk5SL6/work/alice`..
1755078042 git_tag               node: Opening policy database..
1755078042 git_tag               node: Default seeding policy set to 'block (all)'
1755078042 git_tag               node: Initializing service (Test)..
1755078042 git_tag               node: Opening node database..
1755078042 git_tag               node: Address book is empty. Adding bootstrap nodes..
1755078042 git_tag               node: 0 nodes added to address book
1755078042 git_tag            service: Init @1755078042510
1755078042 git_tag            service: Empty refs database, populating from storage..
1755078042 git_tag            service: Saved local sync status for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji..
1755078042 git_tag            service: Adding refs announcement for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji to historical gossip messages..
1755078042 git_tag            service: Not enough available peers to connect to (available=0, wanted=8)
1755078042 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>           node: Listening on 0.0.0.0:36179..
1755078042 git_tag               node: Binding control socket /tmp/radicle-wk5SL6/home/alice/.radicle/node/control.sock..
1755078042 git_tag               node: Opening policy database..
1755078042 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <runtime>           node: Running node z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi in /tmp/radicle-wk5SL6/home/alice/.radicle..
1755078042 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <control>        control: Control thread listening on socket..
1755078042 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <signals>           node: Signal notifications channel error: receiving on an empty and disconnected channel
1755078042 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>        service: Received command QueryState(..)
1755078042 git_tag               node: Default seeding policy set to 'block (all)'
1755078042 git_tag               node: Initializing service (Test)..
1755078042 git_tag               node: Opening node database..
1755078043 git_tag               node: Address book is empty. Adding bootstrap nodes..
1755078043 git_tag               node: 0 nodes added to address book
1755078043 git_tag            service: Init @1755078042791
1755078043 git_tag            service: Empty refs database, populating from storage..
1755078043 git_tag            service: Not enough available peers to connect to (available=0, wanted=8)
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>           node: Listening on 0.0.0.0:34227..
1755078043 git_tag               node: Binding control socket /tmp/radicle-wk5SL6/home/bob/.radicle/node/control.sock..
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <runtime>           node: Running node z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk in /tmp/radicle-wk5SL6/home/bob/.radicle..
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control>        control: Control thread listening on socket..
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <signals>           node: Signal notifications channel error: receiving on an empty and disconnected channel
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Received command QueryState(..)
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Received command QueryState(..)
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Received command Connect(z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi, 0.0.0.0:36179, ConnectOptions { persistent: false, timeout: 30s })
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Connecting to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (0.0.0.0:36179)..
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Attempted connection to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (0.0.0.0:36179)
1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>           wire: Inbound connection from 127.0.0.1:37338 (fd=213)..
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>           wire: Registering outbound transport for z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (fd=212)..
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>           wire: Outbound peer resource registered for z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi with id=2 (fd=212)
1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>           wire: Accepted inbound connection from 127.0.0.1:37338 (fd=213)..
1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>           wire: Inbound peer resource registered with id=2 (fd=213)
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>           wire: Session established with z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (id=2) (fd=212) (outbound)
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Connected to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (0.0.0.0:36179) (Outbound)
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Subscribing to messages since timestamp 1754991643018..
1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>           wire: Session established with z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk (id=2) (fd=213) (inbound)
1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>        service: Connected to z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk (127.0.0.1:37338) (Inbound)
1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>        service: Subscribing to messages since timestamp 1754991643018..
1755078043 test: Node z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi has converged
1755078043 test: Node has missing routes: [(RepoId(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji), PublicKey(z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi))]
1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>        service: Received node announcement of z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk with 0 address(es) from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk (t=1755078042791)
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Received node announcement of z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi with 0 address(es) from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (t=1755078042510)
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Stored announcement from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi to be broadcast in 0 millisecond(s) (t=1755078042510)
1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>        service: Stored announcement from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk to be broadcast in 0 millisecond(s) (t=1755078042791)
1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>        service: Address store entry for node z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk updated at 1755078042791
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Address store entry for node z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi updated at 1755078042510
1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>        service: Received inventory announcement of z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk with 0 item(s) from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk (t=1755078042792)
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Received inventory announcement of z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi with 1 item(s) from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (t=1755078042512)
1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>        service: Stored announcement from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk to be broadcast in 0 millisecond(s) (t=1755078042792)
1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>        service: Received subscription filter from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Stored announcement from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi to be broadcast in 0 millisecond(s) (t=1755078042512)
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Routing table updated for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji with seed z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Received subscription filter from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
1755078043 test: Node z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk has converged
1755078043 test: Using PATH ["/workspace/cache/debug", "/workspace/deps/bin", "/root/.cargo/bin", "/usr/local/sbin", "/usr/local/bin", "/usr/sbin", "/usr/bin", "/sbin", "/bin", "/tmp/radicle-wk5SL6/work/bob"]
1755078043 test: rad-clone.md: Running `/workspace/cache/debug/rad` with ["clone", "rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji", "--scope", "followed"] in `/tmp/radicle-wk5SL6/work/bob`..
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control>        control: Received `{"command":"status"}` on control socket
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control>        control: Received `{"command":"seed","rid":"rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji","scope":"followed"}` on control socket
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Received command Seed(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji, followed)
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Sending subscription filter to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>        service: Received subscription filter from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control>        control: Received `{"command":"seeds","rid":"rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji"}` on control socket
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Received command Seeds(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji)
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Found 1 connected seed(s) and 0 disconnected seed(s) for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control>        control: Received `{"command":"session","nid":"z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi"}` on control socket
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Received command QueryState(..)
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control>        control: Received `{"command":"fetch","rid":"rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji","nid":"z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi","timeout":{"secs":9,"nanos":0}}` on control socket
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Received command Fetch(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji, z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi)
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Fetch initiated for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji with z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi [outbound connected] (all remotes)..
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>           wire: Opened new stream with id 12 for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji and remote z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0>        worker: Worker processing outgoing fetch for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>           wire: Received `open` command for stream 12 from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk
1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <worker#0>        worker: Worker processing incoming fetch for z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk on stream 12..
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0>        worker: z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk cloning from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <worker#0>        worker: Spawning upload-pack process for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji on stream 12..
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0>         fetch: Fetched rad/id (12ms)
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0>         fetch: Fetched data for 1 remote(s) (33ms)
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0>         fetch: Fetched data refs for 1 remotes (41ms)
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0>         fetch: Sent done signal to remote z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>           wire: Received `end-of-file` on stream 12 from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk
1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <upload-pack>     worker: Exiting upload-pack reader thread for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <worker#0>        worker: Upload pack finished (48ms)
1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <worker#0>        worker: Upload process on stream 12 exited with result Ok(())
1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>           wire: Received fetch result from worker for stream 12, remote z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk: Responder { rid: Some(RepoId(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji)), result: Ok(()) }
1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>           wire: Stream 12 of z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk closing with 0 byte(s) sent and 0 byte(s) received
1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>           wire: Peer z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk fetched rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji from us successfully
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0>         fetch: Validated 1 remote(s) (42ms)
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>           wire: Received `close` command for stream 12 from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>           wire: Stream 12 of z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi closed with 0 byte(s) sent and 0 byte(s) received
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0>         fetch: Applied updates (43ms)
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0>         fetch: Finished clone of rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (50ms)
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0>           cob: Loading object of type xyz.radicle.id at 0656c217f917c3e06234771e9ecae53aba5e173e
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0>       storage: Setting ref: refs/rad/id -> 0656c217f917c3e06234771e9ecae53aba5e173e
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0>       storage: Setting ref: refs/heads/master -> f2de534b5e81d7c6e2dcaf58c3dd91573c0a0354
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0>       storage: Setting ref: HEAD -> refs/heads/master
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0>           cob: Loading object of type xyz.radicle.id at 0656c217f917c3e06234771e9ecae53aba5e173e
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>           wire: Received fetch result from worker for stream 12, remote z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi: Initiator { rid: RepoId(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji), result: Ok(FetchResult { updated: [Created { name: RefString("refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/rad/id"), oid: Oid(0656c217f917c3e06234771e9ecae53aba5e173e) }, Created { name: RefString("refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/rad/sigrefs"), oid: Oid(99c549702e2bcfe02b0e68d4a2224fb7a1524529) }, Created { name: RefString("refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/cobs/xyz.radicle.id/0656c217f917c3e06234771e9ecae53aba5e173e"), oid: Oid(0656c217f917c3e06234771e9ecae53aba5e173e) }, Created { name: RefString("refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/heads/master"), oid: Oid(f2de534b5e81d7c6e2dcaf58c3dd91573c0a0354) }, Skipped { name: RefString("refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/rad/id"), oid: Oid(0656c217f917c3e06234771e9ecae53aba5e173e) }, Created { name: RefString("refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/rad/root"), oid: Oid(0656c217f917c3e06234771e9ecae53aba5e173e) }], namespaces: {PublicKey(z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi)}, clone: true, doc: DocAt { commit: Oid(0656c217f917c3e06234771e9ecae53aba5e173e), blob: Oid(d96f425412c9f8ad5d9a9a05c9831d0728e2338d), doc: Doc { version: Version(1), payload: {PayloadId(TypeName("xyz.radicle.project")): Payload { value: Object {"defaultBranch": String("master"), "description": String("Radicle Heartwood Protocol & Stack"), "name": String("heartwood")} }}, delegates: Delegates(NonEmpty { head: Did("did:key:z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi"), tail: [] }), threshold: Threshold(1), visibility: Public } } }) }
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Found existing fetch request from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi, sending result..
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Sent fetch result for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi..
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Fetched rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi successfully
1755078043 test: rad-clone.md: Running `cd /tmp/radicle-wk5SL6/work/bob/heartwood`..
1755078043 test: rad-clone.md: Running `ls` with [] in `/tmp/radicle-wk5SL6/work/bob/heartwood`..
1755078043 test: rad-clone.md: Running `cat` with ["README"] in `/tmp/radicle-wk5SL6/work/bob/heartwood`..
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Ref updated: * 0000000..0656c21 refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/rad/id for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Ref updated: * 0000000..99c5497 refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/rad/sigrefs for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Ref updated: * 0000000..0656c21 refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/cobs/xyz.radicle.id/0656c217f917c3e06234771e9ecae53aba5e173e for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Ref updated: * 0000000..f2de534 refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/heads/master for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Ref updated: * 0000000..0656c21 refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/rad/root for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Updating and announcing inventory for cloned repository rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji..
1755078043 test: rad-clone.md: Running `git` with ["status"] in `/tmp/radicle-wk5SL6/work/bob/heartwood`..
1755078043 test: rad-clone.md: Running `git` with ["branch", "--remotes"] in `/tmp/radicle-wk5SL6/work/bob/heartwood`..
1755078043 test: rad-clone.md: Running `git` with ["remote", "-v"] in `/tmp/radicle-wk5SL6/work/bob/heartwood`..
1755078043 test: rad-clone.md: Running `git` with ["log", "-n", "1"] in `/tmp/radicle-wk5SL6/work/bob/heartwood`..
1755078043 test: rad-clone.md: Running `/workspace/cache/debug/rad` with ["ls", "--seeded"] in `/tmp/radicle-wk5SL6/work/bob/heartwood`..
1755078043 test: Using PATH ["/workspace/cache/debug", "/workspace/deps/bin", "/root/.cargo/bin", "/usr/local/sbin", "/usr/local/bin", "/usr/sbin", "/usr/bin", "/sbin", "/bin", "/tmp/radicle-wk5SL6"]
1755078043 test: git-tag.md: Running `touch` with ["LICENSE"] in `/tmp/radicle-wk5SL6/work/alice`..
1755078043 test: git-tag.md: Running `git` with ["add", "LICENSE"] in `/tmp/radicle-wk5SL6/work/alice`..
1755078043 test: git-tag.md: Running `git` with ["commit", "-am", "Add LICENSE"] in `/tmp/radicle-wk5SL6/work/alice`..
1755078043 test: git-tag.md: Running `git` with ["tag", "v1.0", "-a", "-m", "Release v1.0"] in `/tmp/radicle-wk5SL6/work/alice`..
1755078043 test: git-tag.md: Running `git` with ["push", "rad", "v1.0"] in `/tmp/radicle-wk5SL6/work/alice`..
1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <control>        control: Received `{"command":"status"}` on control socket
1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <control>        control: Received `{"command":"seeds","rid":"rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji"}` on control socket
1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>        service: Received command Seeds(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji)
1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>        service: Found 0 connected seed(s) and 1 disconnected seed(s) for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji

thread 'git_tag' panicked at crates/radicle-cli-test/src/lib.rs:489:36:

--- Expected
++++ actual:   stderr
   1      - ✓ Synced with 1 seed(s)
        1 + No seeds found for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji.
   2    2 | To rad://z42hL2jL4XNk6K8oHQaSWfMgCL7ji/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
   3    3 |  * [new tag]         v1.0 -> v1.0

Exit status: 0

note: run with `RUST_BACKTRACE=1` environment variable to display a backtrace
1755078043 test: Node z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk shutting down..
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control>        control: Received `{"command":"shutdown"}` on control socket
1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control>        control: Shutdown requested..
1755078044 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Sending inventory announcement of z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk with 1 item(s) to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (t=1755078043452)
1755078044 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Sending refs announcement of z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji with 1 remote(s) to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (t=1755078043453)
1755078044 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>           wire: Disconnecting peer with id=2: connection reset
1755078044 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>           wire: Transport handover for disconnecting peer with id=2 (fd=213)
1755078044 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>        service: Disconnected from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk (connection reset)
1755078044 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>        service: Dropping peer z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk..
1755078044 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <runtime>           pool: Worker pool shutting down..
1755078044 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <runtime>           node: Node shutdown completed for z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk
1755078044 test: Node z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi shutting down..
1755078044 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <control>        control: Received `{"command":"shutdown"}` on control socket
1755078044 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <control>        control: Shutdown requested..
1755078044 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <runtime>           pool: Worker pool shutting down..
1755078044 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <runtime>           node: Node shutdown completed for z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi


failures:
    git_tag

test result: FAILED. 98 passed; 1 failed; 2 ignored; 0 measured; 0 filtered out; finished in 94.01s

error: test failed, to rerun pass `-p radicle-cli --test commands`
ERROR: Action failed: command failed: ["cargo", "test", "--offline", "--locked", "--workspace"]
ERROR: command failed: ["cargo", "test", "--offline", "--locked", "--workspace"]
EXIT CODE: 1
[2025-08-13T09:41:50Z INFO  ambient] ambient ends successfully

Trigger message

{
  "request": "trigger",
  "version": 1,
  "event_type": "patch",
  "repository": {
    "id": "rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5",
    "name": "heartwood",
    "description": "Radicle Heartwood Protocol & Stack",
    "private": false,
    "default_branch": "master",
    "delegates": [
      "did:key:z6MksFqXN3Yhqk8pTJdUGLwATkRfQvwZXPqR2qMEhbS9wzpT",
      "did:key:z6MktaNvN1KVFMkSRAiN4qK5yvX1zuEEaseeX5sffhzPZRZW",
      "did:key:z6MkireRatUThvd3qzfKht1S44wpm4FEWSSa4PRMTSQZ3voM",
      "did:key:z6MkgFq6z5fkF2hioLLSNu1zP2qEL1aHXHZzGH1FLFGAnBGz",
      "did:key:z6MkkPvBfjP4bQmco5Dm7UGsX2ruDBieEHi8n9DVJWX5sTEz"
    ]
  },
  "action": "Created",
  "patch": {
    "id": "ce861ef2f573f991c8d26ead7ce0ce30338f3c16",
    "author": {
      "id": "did:key:z6MkireRatUThvd3qzfKht1S44wpm4FEWSSa4PRMTSQZ3voM",
      "alias": "fintohaps"
    },
    "title": "node: Remove useless caching of node announcement",
    "state": {
      "status": "open",
      "conflicts": []
    },
    "before": "efa7efacc401243e309cef37d90e8cd023381c2e",
    "after": "1cd3ad078453b316dc7f1d4aeb637fc2f6af35e0",
    "commits": [
      "1cd3ad078453b316dc7f1d4aeb637fc2f6af35e0"
    ],
    "target": "efa7efacc401243e309cef37d90e8cd023381c2e",
    "labels": [],
    "assignees": [],
    "revisions": [
      {
        "id": "ce861ef2f573f991c8d26ead7ce0ce30338f3c16",
        "author": {
          "id": "did:key:z6MkireRatUThvd3qzfKht1S44wpm4FEWSSa4PRMTSQZ3voM",
          "alias": "fintohaps"
        },
        "description": "When initializing the `radicle-node` process, see\n`radicle-node/src/runtime.rs`, an attempt is made to read from a node\nannouncement file.\n\nThis file is never written, therefore all of these reads fail.\n\nEven though this caching mechanism might make sense or might have made\nsense at some point, it is dead code now, and therefore removed.\n\nAlso, the fact that the file name was defined in the `radicle` crate is\nugly.",
        "base": "a8dac56ca645fdd98955766f07abe7cdd8980e56",
        "oid": "b69e4c478babc6b2fe938e763ce6271111ca37ae",
        "timestamp": 1754923204
      },
      {
        "id": "adc98452224a569df83832a5fda2fe50b30193f2",
        "author": {
          "id": "did:key:z6MkireRatUThvd3qzfKht1S44wpm4FEWSSa4PRMTSQZ3voM",
          "alias": "fintohaps"
        },
        "description": "Rebased",
        "base": "efa7efacc401243e309cef37d90e8cd023381c2e",
        "oid": "1cd3ad078453b316dc7f1d4aeb637fc2f6af35e0",
        "timestamp": 1755077794
      }
    ]
  }
}

Ambient stdout

[2025-08-13T09:36:46Z INFO  ambient] ambient starts
[2025-08-13T09:36:46Z DEBUG ambient] load default configuration file /home/_rad/.config/ambient/config.yaml if it exists
[2025-08-13T09:36:46Z DEBUG ambient] complete configuration: Config {
        tmpdir: "/srv/tmp",
        image_store: "/home/_rad/.local/state/ambient-ci/images",
        projects: "/home/_rad/ambient-projects.yaml",
        state: "/srv/ambient-state",
        rsync_target: None,
        rsync_target_base: None,
        rsync_target_map: None,
        dput_target: None,
        executor: Some(
            "/usr/bin/ambient-execute-plan",
        ),
        artifacts_max_size: Byte(
            10000000000,
        ),
        cache_max_size: Byte(
            50000000000,
        ),
        qemu: QemuConfig {
            cpus: 4,
            memory: Byte(
                8000000000,
            ),
            kvm_binary: "/usr/bin/kvm",
            ovmf_vars_file: "/usr/share/ovmf/OVMF.fd",
            ovmf_code_file: "/usr/share/ovmf/OVMF.fd",
        },
    }
[2025-08-13T09:36:46Z DEBUG ambient] configuration: Config {
        tmpdir: "/srv/tmp",
        image_store: "/home/_rad/.local/state/ambient-ci/images",
        projects: "/home/_rad/ambient-projects.yaml",
        state: "/srv/ambient-state",
        rsync_target: None,
        rsync_target_base: None,
        rsync_target_map: None,
        dput_target: None,
        executor: Some(
            "/usr/bin/ambient-execute-plan",
        ),
        artifacts_max_size: Byte(
            10000000000,
        ),
        cache_max_size: Byte(
            50000000000,
        ),
        qemu: QemuConfig {
            cpus: 4,
            memory: Byte(
                8000000000,
            ),
            kvm_binary: "/usr/bin/kvm",
            ovmf_vars_file: "/usr/share/ovmf/OVMF.fd",
            ovmf_code_file: "/usr/share/ovmf/OVMF.fd",
        },
    }
[2025-08-13T09:36:46Z DEBUG ambient_ci::project] load project state from /srv/ambient-state/rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5/meta.yaml
[2025-08-13T09:36:46Z DEBUG ambient_ci::run] latest commit: "d147094812207130b05dcf66ef79bd113caadce2"
[2025-08-13T09:36:46Z DEBUG ambient_ci::run] is a git repository
[2025-08-13T09:36:46Z DEBUG ambient_ci::run] git repository is clean
[2025-08-13T09:36:46Z DEBUG ambient_ci::run] current (HEAD) commit: 1cd3ad078453b316dc7f1d4aeb637fc2f6af35e0
[2025-08-13T09:36:46Z DEBUG ambient_ci::run] no dry run requested
[2025-08-13T09:36:46Z DEBUG ambient_ci::run] forced run requested
[2025-08-13T09:36:46Z DEBUG ambient_ci::run] run? true
[2025-08-13T09:36:46Z INFO  ambient_ci::run] project rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5: running CI
[2025-08-13T09:36:46Z DEBUG ambient_ci::run] Executing pre-plan steps
[2025-08-13T09:36:46Z DEBUG ambient_ci::action] Plan::execute: CargoFetch {
        sourcedir: "/tmp/.tmpZwA9up/src",
        dependenciesdir: "/srv/ambient-state/rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5/dependencies",
    }
SPAWN: argv=["env", "CARGO_HOME=/srv/ambient-state/rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5/dependencies", "cargo", "fetch", "--locked"]
       cwd=/tmp/.tmpZwA9up/src (exists? true)
       extra_env=[]
[2025-08-13T09:36:48Z DEBUG ambient_ci::run] create virtual drive /srv/tmp/.tmpbiNLvl/src.tar
[2025-08-13T09:36:48Z DEBUG ambient_ci::run] create virtual drive /srv/tmp/.tmpbiNLvl/deps.tar
[2025-08-13T09:36:56Z DEBUG ambient_ci::run] create_executor_vdrive: executor="/usr/bin/ambient-execute-plan"
[2025-08-13T09:36:56Z DEBUG ambient_ci::run] create_executor_vdrive: plan=RunnablePlan {
        steps: [
            Mkdir {
                pathname: "/workspace",
            },
            Mkdir {
                pathname: "/workspace/artifacts",
            },
            TarExtract {
                archive: "/dev/vdc",
                directory: "/workspace/src",
            },
            TarExtract {
                archive: "/dev/vdf",
                directory: "/workspace/deps",
            },
            TarExtract {
                archive: "/dev/vde",
                directory: "/workspace/cache",
            },
            Spawn {
                argv: [
                    "find",
                    "/workspace",
                    "-maxdepth",
                    "2",
                    "-ls",
                ],
            },
            CargoFmt,
            CargoClippy,
            CargoBuild,
            CargoTest,
            Shell {
                shell: "# Because of a (temporary) limitation in Ambient, we need to set\n# these variables manually. Once Ambient manages environment\n# variables better, these can be deleted.\nexport CARGO_TARGET_DIR=/workspace/cache\nexport CARGO_HOME=/workspace/deps\nexport HOME=/root\nexport PATH=\"/root/.cargo/bin:$PATH\"\n\ncargo doc --workspace --no-deps\n",
            },
            Shell {
                shell: "# Because of a (temporary) limitation in Ambient, we need to set\n# these variables manually. Once Ambient manages environment\n# variables better, these can be deleted.\nexport CARGO_TARGET_DIR=/workspace/cache\nexport CARGO_HOME=/workspace/deps\nexport HOME=/root\nexport PATH=\"/root/.cargo/bin:$PATH\"\n\n# These are based on debian/control.\nexport DEBEMAIL=liw@liw.fi\nexport DEBFULLNAME=\"Lars Wirzenius\"\n\n# Clean up after tests and documentation building. The Debian\n# package building tools do not want changes outside the\n# `debian` directory, compared to what is committed to Git, from\n# which the \"upstream tarball\" is created.\ngit reset --hard\ngit clean -fdx\ngit status --ignored\n\n# Update debian/changelog with a new version so that every run\n# creates a newer version. This avoids us having to update the\n# file manually for every CI run.\nV=\"$(dpkg-parsechangelog -SVersion | sed 's/-[^-]*$//')\"\nT=\"$(date -u \"+%Y%m%dT%H%M%S\")\"\nversion=\"$V.ci$T-1\"\ndch -v \"$version\" \"CI build under Ambient.\"\ndch -r ''\n",
            },
            Deb,
            TarCreate {
                archive: "/dev/vde",
                directory: "/workspace/cache",
            },
            TarCreate {
                archive: "/dev/vdd",
                directory: "/workspace/artifacts",
            },
        ],
        executor_drive: Some(
            "/dev/vdb",
        ),
        source_drive: Some(
            "/dev/vdc",
        ),
        artifact_drive: Some(
            "/dev/vdd",
        ),
        cache_drive: Some(
            "/dev/vde",
        ),
        deps_drive: Some(
            "/dev/vdf",
        ),
        workspace_dir: Some(
            "/workspace",
        ),
        source_dir: Some(
            "/workspace/src",
        ),
        deps_dir: Some(
            "/workspace/deps",
        ),
        cache_dir: Some(
            "/workspace/cache",
        ),
        artifacts_dir: Some(
            "/workspace/artifacts",
        ),
    }
[2025-08-13T09:36:56Z DEBUG ambient_ci::run] executor bin /usr/bin/ambient-execute-plan
[2025-08-13T09:36:56Z DEBUG ambient_ci::run] copying /usr/bin/ambient-execute-plan to /srv/tmp/.tmpbiNLvl/ambient-execute-plan/run-ci
[2025-08-13T09:36:56Z DEBUG ambient_ci::run] copy OK: true
[2025-08-13T09:36:56Z DEBUG ambient_ci::run] create virtual drive /srv/tmp/.tmpbiNLvl/executor.tar
[2025-08-13T09:37:37Z DEBUG ambient_ci::project] removing run log file /srv/ambient-state/rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5/run.log
[2025-08-13T09:37:37Z DEBUG ambient_ci::project] statedir is /srv/ambient-state/rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5, exists? true
[2025-08-13T09:37:37Z DEBUG ambient_ci::project] creating run log file /srv/ambient-state/rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5/run.log
[2025-08-13T09:37:37Z DEBUG ambient_ci::project] created run log file /srv/ambient-state/rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5/run.log OK
[2025-08-13T09:37:37Z DEBUG ambient_ci::cloud_init] with_hostname called: "ambient"
[2025-08-13T09:37:37Z DEBUG ambient_ci::cloud_init] with_runcmd called: "echo xyzzy > /dev/ttyS1"
[2025-08-13T09:37:37Z DEBUG ambient_ci::cloud_init] with_runcmd called: "\n(set -xeu\nenv\ndir=\"$(mktemp -d)\"\ncd \"$dir\"\ntar -xvf /dev/vdb\nfind -ls || true\nldd ./run-ci || true\necho ================================ BEGIN ================================\nexport RUST_BACKTRACE=1\nif ./run-ci; then\n        echo \"EXIT CODE: 0\"\nelse\n        echo \"EXIT CODE: $?\"\nfi) > /dev/ttyS1 2>&1\n"
[2025-08-13T09:37:37Z DEBUG ambient_ci::cloud_init] with_runcmd called: "poweroff"
[2025-08-13T09:37:37Z DEBUG ambient_ci::cloud_init] LocalDataStoreBuilder: LocalDataStoreBuilder {
        hostname: Some(
            "ambient",
        ),
        network: false,
        bootcmd: [],
        runcmd: [
            "echo xyzzy > /dev/ttyS1",
            "\n(set -xeu\nenv\ndir=\"$(mktemp -d)\"\ncd \"$dir\"\ntar -xvf /dev/vdb\nfind -ls || true\nldd ./run-ci || true\necho ================================ BEGIN ================================\nexport RUST_BACKTRACE=1\nif ./run-ci; then\n        echo \"EXIT CODE: 0\"\nelse\n        echo \"EXIT CODE: $?\"\nfi) > /dev/ttyS1 2>&1\n",
            "poweroff",
        ],
    }
[2025-08-13T09:37:37Z DEBUG ambient_ci::qemu] run QEMU
[2025-08-13T09:37:37Z DEBUG ambient_ci::qemu] create copy-on-write image and UEFI vars file
[2025-08-13T09:37:37Z DEBUG ambient_ci::qemu_utils] qemu-img create /srv/tmp/.tmpz6s2yy/.tmp6exK9z/vm.qcow2 backing on /home/_rad/ambient.qcow2
[2025-08-13T09:37:37Z DEBUG ambient_ci::qemu] create cloud-init ISO file
[2025-08-13T09:37:37Z DEBUG ambient_ci::cloud_init] LocalDataStore: LocalDataStore {
        hostname: "ambient",
        network: false,
        bootcmd: [],
        runcmd: [
            "echo xyzzy > /dev/ttyS1",
            "\n(set -xeu\nenv\ndir=\"$(mktemp -d)\"\ncd \"$dir\"\ntar -xvf /dev/vdb\nfind -ls || true\nldd ./run-ci || true\necho ================================ BEGIN ================================\nexport RUST_BACKTRACE=1\nif ./run-ci; then\n        echo \"EXIT CODE: 0\"\nelse\n        echo \"EXIT CODE: $?\"\nfi) > /dev/ttyS1 2>&1\n",
            "poweroff",
        ],
    }
[2025-08-13T09:37:37Z DEBUG ambient_ci::cloud_init] write /tmp/.tmpiI6NxD/meta-data
[2025-08-13T09:37:37Z DEBUG ambient_ci::cloud_init] write /tmp/.tmpiI6NxD/user-data
[2025-08-13T09:37:37Z DEBUG ambient_ci::qemu] set console log file to /srv/tmp/.tmpz6s2yy/.tmp6exK9z/console.log
[2025-08-13T09:37:37Z DEBUG ambient_ci::util] create file /srv/tmp/.tmpz6s2yy/.tmp6exK9z/console.log
[2025-08-13T09:37:37Z DEBUG ambient_ci::qemu] set run file to /srv/ambient-state/rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5/run.log
[2025-08-13T09:37:37Z DEBUG ambient_ci::util] create file /srv/ambient-state/rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5/run.log
[2025-08-13T09:37:37Z DEBUG ambient_ci::qemu] run QEMU: QemuArgs {
        args: [
            "-m",
            "7629",
            "-smp",
            "cpus=4",
            "-cpu",
            "kvm64",
            "-machine",
            "type=q35,accel=kvm,usb=off",
            "-uuid",
            "a85c9de7-edc0-4e54-bead-112e5733582c",
            "-boot",
            "strict=on",
            "-name",
            "ambient-ci-vm",
            "-rtc",
            "base=utc,driftfix=slew",
            "-display",
            "none",
            "-device",
            "virtio-rng-pci",
            "-serial",
            "file:/srv/tmp/.tmpz6s2yy/.tmp6exK9z/console.log",
            "-serial",
            "file:/srv/ambient-state/rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5/run.log",
            "-drive",
            "if=pflash,format=raw,unit=0,file=/usr/share/ovmf/OVMF.fd,readonly=on",
            "-drive",
            "if=pflash,format=raw,unit=1,file=/srv/tmp/.tmpz6s2yy/.tmp6exK9z/vars.fd",
            "-drive",
            "format=qcow2,if=virtio,file=/srv/tmp/.tmpz6s2yy/.tmp6exK9z/vm.qcow2",
            "-drive",
            "format=raw,if=virtio,file=/srv/tmp/.tmpbiNLvl/executor.tar,readonly=on",
            "-cdrom",
            "/srv/tmp/.tmpz6s2yy/.tmp6exK9z/cloud_init.iso",
            "-drive",
            "format=raw,if=virtio,file=/srv/tmp/.tmpbiNLvl/src.tar,readonly=on",
            "-drive",
            "format=raw,if=virtio,file=/srv/tmp/.tmpbiNLvl/artifacts.tar",
            "-drive",
            "format=raw,if=virtio,file=/srv/tmp/.tmpbiNLvl/cache.tar",
            "-drive",
            "format=raw,if=virtio,file=/srv/tmp/.tmpbiNLvl/deps.tar,readonly=on",
            "-nodefaults",
            "-no-user-config",
        ],
    }
[2025-08-13T09:41:49Z DEBUG ambient_ci::qemu] QEMU finished OK
[2025-08-13T09:41:49Z DEBUG ambient_ci::qemu] run log:
    --------------------==========
    [2025-08-13T09:37:44Z TRACE ambient_execute_plan] ambient-execute-plan starts
    [2025-08-13T09:37:44Z DEBUG ambient_execute_plan] ambient-execute-plan starts
    [2025-08-13T09:37:44Z INFO  ambient_execute_plan] ambient-execute-plan starts
    [2025-08-13T09:37:44Z WARN  ambient_execute_plan] ambient-execute-plan starts
    [2025-08-13T09:37:44Z ERROR ambient_execute_plan] ambient-execute-plan starts
    RunnablePlan::from_file: filename=plan.yaml
    steps:
    - action: mkdir
      pathname: /workspace
    - action: mkdir
      pathname: /workspace/artifacts
    - action: tar_extract
      archive: /dev/vdc
      directory: /workspace/src
    - action: tar_extract
      archive: /dev/vdf
      directory: /workspace/deps
    - action: tar_extract
      archive: /dev/vde
      directory: /workspace/cache
    - action: spawn
      argv:
      - find
      - /workspace
      - '-maxdepth'
      - '2'
      - '-ls'
    - action: cargo_fmt
    - action: cargo_clippy
    - action: cargo_build
    - action: cargo_test
    - action: shell
      shell: |
        # Because of a (temporary) limitation in Ambient, we need to set
        # these variables manually. Once Ambient manages environment
        # variables better, these can be deleted.
        export CARGO_TARGET_DIR=/workspace/cache
        export CARGO_HOME=/workspace/deps
        export HOME=/root
        export PATH="/root/.cargo/bin:$PATH"
    
        cargo doc --workspace --no-deps
    - action: shell
      shell: |
        # Because of a (temporary) limitation in Ambient, we need to set
        # these variables manually. Once Ambient manages environment
        # variables better, these can be deleted.
        export CARGO_TARGET_DIR=/workspace/cache
        export CARGO_HOME=/workspace/deps
        export HOME=/root
        export PATH="/root/.cargo/bin:$PATH"
    
        # These are based on debian/control.
        export DEBEMAIL=liw@liw.fi
        export DEBFULLNAME="Lars Wirzenius"
    
        # Clean up after tests and documentation building. The Debian
        # package building tools do not want changes outside the
        # `debian` directory, compared to what is committed to Git, from
        # which the "upstream tarball" is created.
        git reset --hard
        git clean -fdx
        git status --ignored
    
        # Update debian/changelog with a new version so that every run
        # creates a newer version. This avoids us having to update the
        # file manually for every CI run.
        V="$(dpkg-parsechangelog -SVersion | sed 's/-[^-]*$//')"
        T="$(date -u "+%Y%m%dT%H%M%S")"
        version="$V.ci$T-1"
        dch -v "$version" "CI build under Ambient."
        dch -r ''
    - action: deb
    - action: tar_create
      archive: /dev/vde
      directory: /workspace/cache
    - action: tar_create
      archive: /dev/vdd
      directory: /workspace/artifacts
    executor_drive: /dev/vdb
    source_drive: /dev/vdc
    artifact_drive: /dev/vdd
    cache_drive: /dev/vde
    deps_drive: /dev/vdf
    workspace_dir: /workspace
    source_dir: /workspace/src
    deps_dir: /workspace/deps
    cache_dir: /workspace/cache
    artifacts_dir: /workspace/artifacts
    
    
    RUN: Action Mkdir {
        pathname: "/workspace",
    }
    [2025-08-13T09:37:44Z DEBUG ambient_ci::action] Plan::execute: Mkdir {
            pathname: "/workspace",
        }
    RUN: Action finished OK
    RUN: Action Mkdir {
        pathname: "/workspace/artifacts",
    }
    [2025-08-13T09:37:44Z DEBUG ambient_ci::action] Plan::execute: Mkdir {
            pathname: "/workspace/artifacts",
        }
    RUN: Action finished OK
    RUN: Action TarExtract {
        archive: "/dev/vdc",
        directory: "/workspace/src",
    }
    [2025-08-13T09:37:44Z DEBUG ambient_ci::action] Plan::execute: TarExtract {
            archive: "/dev/vdc",
            directory: "/workspace/src",
        }
    [2025-08-13T09:37:44Z TRACE ambient_ci::vdrive] extracting /dev/vdc to /workspace/src
    [2025-08-13T09:37:45Z TRACE ambient_ci::vdrive] extraction OK
    RUN: Action finished OK
    RUN: Action TarExtract {
        archive: "/dev/vdf",
        directory: "/workspace/deps",
    }
    [2025-08-13T09:37:45Z DEBUG ambient_ci::action] Plan::execute: TarExtract {
            archive: "/dev/vdf",
            directory: "/workspace/deps",
        }
    [2025-08-13T09:37:45Z TRACE ambient_ci::vdrive] extracting /dev/vdf to /workspace/deps
    [2025-08-13T09:37:46Z TRACE ambient_ci::vdrive] extraction OK
    RUN: Action finished OK
    RUN: Action TarExtract {
        archive: "/dev/vde",
        directory: "/workspace/cache",
    }
    [2025-08-13T09:37:46Z DEBUG ambient_ci::action] Plan::execute: TarExtract {
            archive: "/dev/vde",
            directory: "/workspace/cache",
        }
    [2025-08-13T09:37:46Z TRACE ambient_ci::vdrive] extracting /dev/vde to /workspace/cache
    [2025-08-13T09:38:55Z TRACE ambient_ci::vdrive] extraction OK
    RUN: Action finished OK
    RUN: Action Spawn {
        argv: [
            "find",
            "/workspace",
            "-maxdepth",
            "2",
            "-ls",
        ],
    }
    [2025-08-13T09:38:55Z DEBUG ambient_ci::action] Plan::execute: Spawn {
            argv: [
                "find",
                "/workspace",
                "-maxdepth",
                "2",
                "-ls",
            ],
        }
    SPAWN: argv=["find", "/workspace", "-maxdepth", "2", "-ls"]
           cwd=/workspace/src (exists? true)
           extra_env=[]
      3932161      4 drwxr-xr-x   6 root     root         4096 Aug 13 09:37 /workspace
      3932162      4 drwxr-xr-x   2 root     root         4096 Aug 13 09:37 /workspace/artifacts
      3933071      4 drwxr-xr-x   3 root     root         4096 Aug 13 09:36 /workspace/deps
      3933073    120 -rw-r--r--   1 root     root       122880 Aug 13 09:36 /workspace/deps/.global-cache
      3933072      0 -rw-r--r--   1 root     root            0 Aug 13 07:06 /workspace/deps/.package-cache-mutate
      3933074      0 -rw-r--r--   1 root     root            0 Aug 13 07:05 /workspace/deps/.package-cache
      3933075      4 drwxr-xr-x   5 root     root         4096 Aug 13 07:06 /workspace/deps/registry
      3932163      4 drwxr-xr-x  12 root     root         4096 Aug 13 09:36 /workspace/src
      3932164      4 drwxr-xr-x   2 root     root         4096 Aug 13 09:36 /workspace/src/.radicle
      3932179      8 -rw-r--r--   1 root     root         7645 Aug 13 09:36 /workspace/src/HACKING.md
      3932180      4 -rw-r--r--   1 root     root           30 Aug 13 09:36 /workspace/src/.dockerignore
      3932189      4 -rw-r--r--   1 root     root          571 Aug 13 09:36 /workspace/src/git-remote-rad.1.adoc
      3933064      8 -rw-r--r--   1 root     root         7144 Aug 13 09:36 /workspace/src/rad-id.1.adoc
      3933070    108 -rw-r--r--   1 root     root       107585 Aug 13 09:36 /workspace/src/Cargo.lock
      3932220      4 -rw-r--r--   1 root     root         2613 Aug 13 09:36 /workspace/src/Cargo.toml
      3933069      4 -rw-r--r--   1 root     root         1083 Aug 13 09:36 /workspace/src/.gitsigners
      3932224      8 -rw-r--r--   1 root     root         5432 Aug 13 09:36 /workspace/src/deny.toml
      3932218      8 -rw-r--r--   1 root     root         8144 Aug 13 09:36 /workspace/src/flake.nix
      3933066      8 -rw-r--r--   1 root     root         5102 Aug 13 09:36 /workspace/src/flake.lock
      3932181      4 -rw-r--r--   1 root     root         2163 Aug 13 09:36 /workspace/src/VERSIONING.md
      3933065      4 -rw-r--r--   1 root     root         1203 Aug 13 09:36 /workspace/src/DCO
      3932499     12 -rw-r--r--   1 root     root         9723 Aug 13 09:36 /workspace/src/LICENSE-APACHE
      3932219      4 -rw-r--r--   1 root     root          101 Aug 13 09:36 /workspace/src/.gitignore
      3932168      4 drwxr-xr-x   2 root     root         4096 Aug 13 09:36 /workspace/src/scripts
      3932501      4 drwxr-xr-x   5 root     root         4096 Aug 13 09:36 /workspace/src/systemd
      3932185      4 -rw-r--r--   1 root     root           77 Aug 13 09:36 /workspace/src/rust-toolchain.toml
      3932167      4 -rw-r--r--   1 root     root         1079 Aug 13 09:36 /workspace/src/LICENSE-MIT
      3933067     12 -rw-r--r--   1 root     root         8740 Aug 13 09:36 /workspace/src/CONTRIBUTING.md
      3932223      4 -rw-r--r--   1 root     root          426 Aug 13 09:36 /workspace/src/radicle-node.1.adoc
      3932225      4 drwxr-xr-x   8 root     root         4096 Aug 13 09:36 /workspace/src/.git
      3932500     12 -rw-r--r--   1 root     root        10770 Aug 13 09:36 /workspace/src/rad-patch.1.adoc
      3932186      4 -rw-r--r--   1 root     root           42 Aug 13 09:36 /workspace/src/.envrc
      3932203      4 drwxr-xr-x   3 root     root         4096 Aug 13 09:36 /workspace/src/debian
      3932188      8 -rw-r--r--   1 root     root         7345 Aug 13 09:36 /workspace/src/CHANGELOG.md
      3932216      4 -rw-r--r--   1 root     root         3133 Aug 13 09:36 /workspace/src/README.md
      3932190      4 drwxr-xr-x   2 root     root         4096 Aug 13 09:36 /workspace/src/build
      3932508      4 drwxr-xr-x  17 root     root         4096 Aug 13 09:36 /workspace/src/crates
      3932184      8 -rw-r--r--   1 root     root         8022 Aug 13 09:36 /workspace/src/rad.1.adoc
      3933062      4 drwxr-xr-x   2 root     root         4096 Aug 13 09:36 /workspace/src/.github
      3932221      4 drwxr-xr-x   2 root     root         4096 Aug 13 09:36 /workspace/src/.config
      3933068      4 -rw-r--r--   1 root     root           79 Aug 13 09:36 /workspace/src/ARCHITECTURE.md
      3932217      4 -rw-r--r--   1 root     root         1623 Aug 13 09:36 /workspace/src/build.rs
      3932182      4 drwxr-xr-x   2 root     root         4096 Aug 13 09:36 /workspace/src/.cargo
      3932187      4 -rw-r--r--   1 root     root           61 Aug 13 09:36 /workspace/src/.env.seed
      3957754      4 drwxr-xr-x   6 root     root         4096 Aug 13 08:29 /workspace/cache
      3973816      4 drwxr-xr-x   7 root     root         4096 Aug 13 08:33 /workspace/cache/release
      3978401      4 drwxr-xr-x  24 root     root         4096 Aug 13 08:29 /workspace/cache/doc
      3957756      4 drwxr-xr-x   7 root     root         4096 Aug 13 08:27 /workspace/cache/debug
      3957755      4 drwxr-xr-x   2 root     root         4096 Aug 13 08:23 /workspace/cache/tmp
      3973815      4 -rw-r--r--   1 root     root          218 Aug 13 08:29 /workspace/cache/.rustdoc_fingerprint.json
      3978400      4 -rw-r--r--   1 root     root         1032 Aug 13 08:26 /workspace/cache/.rustc_info.json
    RUN: Action finished OK
    RUN: Action CargoFmt
    [2025-08-13T09:38:55Z DEBUG ambient_ci::action] Plan::execute: CargoFmt
    SPAWN: argv=["cargo", "fmt", "--check"]
           cwd=/workspace/src (exists? true)
           extra_env=[("CARGO_TARGET_DIR", "/workspace/cache"), ("CARGO_HOME", "/workspace/deps"), ("PATH", "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin")]
    RUN: Action finished OK
    RUN: Action CargoClippy
    [2025-08-13T09:38:57Z DEBUG ambient_ci::action] Plan::execute: CargoClippy
    SPAWN: argv=["cargo", "clippy", "--offline", "--locked", "--workspace", "--all-targets", "--no-deps", "--", "--deny", "warnings"]
           cwd=/workspace/src (exists? true)
           extra_env=[("CARGO_TARGET_DIR", "/workspace/cache"), ("CARGO_HOME", "/workspace/deps"), ("PATH", "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin")]
        Checking radicle-ssh v0.10.0 (/workspace/src/crates/radicle-ssh)
        Checking radicle-dag v0.10.0 (/workspace/src/crates/radicle-dag)
        Checking radicle-signals v0.11.0 (/workspace/src/crates/radicle-signals)
       Compiling radicle-cli v0.15.0 (/workspace/src/crates/radicle-cli)
        Checking radicle-term v0.14.0 (/workspace/src/crates/radicle-term)
       Compiling radicle-node v0.14.0 (/workspace/src/crates/radicle-node)
        Checking radicle-crypto v0.13.0 (/workspace/src/crates/radicle-crypto)
        Checking radicle-systemd v0.10.0 (/workspace/src/crates/radicle-systemd)
        Checking radicle-cob v0.15.0 (/workspace/src/crates/radicle-cob)
       Compiling radicle-remote-helper v0.12.0 (/workspace/src/crates/radicle-remote-helper)
        Checking radicle v0.18.0 (/workspace/src/crates/radicle)
        Checking radicle-fetch v0.14.0 (/workspace/src/crates/radicle-fetch)
        Checking radicle-cli-test v0.12.0 (/workspace/src/crates/radicle-cli-test)
        Checking radicle-protocol v0.2.0 (/workspace/src/crates/radicle-protocol)
        Checking radicle-schemars v0.4.0 (/workspace/src/crates/radicle-schemars)
        Finished `dev` profile [unoptimized + debuginfo] target(s) in 22.59s
    RUN: Action finished OK
    RUN: Action CargoBuild
    [2025-08-13T09:39:19Z DEBUG ambient_ci::action] Plan::execute: CargoBuild
    SPAWN: argv=["cargo", "build", "--offline", "--locked", "--workspace", "--all-targets"]
           cwd=/workspace/src (exists? true)
           extra_env=[("CARGO_TARGET_DIR", "/workspace/cache"), ("CARGO_HOME", "/workspace/deps"), ("PATH", "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin")]
       Compiling radicle-ssh v0.10.0 (/workspace/src/crates/radicle-ssh)
       Compiling radicle-dag v0.10.0 (/workspace/src/crates/radicle-dag)
       Compiling radicle-signals v0.11.0 (/workspace/src/crates/radicle-signals)
       Compiling radicle-cli v0.15.0 (/workspace/src/crates/radicle-cli)
       Compiling radicle-crypto v0.13.0 (/workspace/src/crates/radicle-crypto)
       Compiling radicle-term v0.14.0 (/workspace/src/crates/radicle-term)
       Compiling radicle-node v0.14.0 (/workspace/src/crates/radicle-node)
       Compiling radicle-cob v0.15.0 (/workspace/src/crates/radicle-cob)
       Compiling radicle-systemd v0.10.0 (/workspace/src/crates/radicle-systemd)
       Compiling radicle-remote-helper v0.12.0 (/workspace/src/crates/radicle-remote-helper)
       Compiling radicle v0.18.0 (/workspace/src/crates/radicle)
       Compiling radicle-fetch v0.14.0 (/workspace/src/crates/radicle-fetch)
       Compiling radicle-protocol v0.2.0 (/workspace/src/crates/radicle-protocol)
       Compiling radicle-cli-test v0.12.0 (/workspace/src/crates/radicle-cli-test)
       Compiling radicle-schemars v0.4.0 (/workspace/src/crates/radicle-schemars)
        Finished `dev` profile [unoptimized + debuginfo] target(s) in 44.39s
    RUN: Action finished OK
    RUN: Action CargoTest
    [2025-08-13T09:40:08Z DEBUG ambient_ci::action] Plan::execute: CargoTest
    SPAWN: argv=["cargo", "test", "--offline", "--locked", "--workspace"]
           cwd=/workspace/src (exists? true)
           extra_env=[("CARGO_TARGET_DIR", "/workspace/cache"), ("CARGO_HOME", "/workspace/deps"), ("PATH", "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin")]
        Finished `test` profile [unoptimized + debuginfo] target(s) in 1.46s
         Running unittests src/lib.rs (/workspace/cache/debug/deps/radicle-470b5d57ddeae839)
    
    running 223 tests
    test canonical::formatter::test::securesystemslib_asserts ... ok
    test canonical::formatter::test::ordered_nested_object ... ok
    test cob::cache::tests::test_check_version ... ok
    test cob::cache::migrations::_2::tests::test_patch_json_deserialization ... ok
    test cob::cache::tests::test_migrate_to ... ok
    test cob::common::test::test_color ... ok
    test cob::common::test::test_emojis ... ok
    test canonical::formatter::test::ascii_control_characters ... ok
    test cob::cache::migrations::_2::tests::test_migration_2 ... ok
    test cob::identity::test::prop_json_eq_str ... ok
    test cob::identity::test::test_identity_redact_revision ... ok
    test cob::identity::test::test_identity_reject_concurrent ... ok
    test cob::identity::test::test_identity_update_rejected ... ok
    test cob::identity::test::test_identity_remove_delegate_concurrent ... ok
    test cob::identity::test::test_identity_updates ... ok
    test cob::issue::cache::tests::test_counts ... ok
    test cob::issue::cache::tests::test_get ... ok
    test cob::issue::cache::tests::test_is_empty ... ok
    test cob::issue::cache::tests::test_list ... ok
    test cob::issue::cache::tests::test_list_by_status ... ok
    test cob::issue::cache::tests::test_remove ... ok
    test cob::identity::test::test_valid_identity ... ok
    test cob::identity::test::test_identity_updates_concurrent ... ok
    test cob::issue::test::test_embeds ... ok
    test cob::issue::test::test_embeds_edit ... ok
    test cob::identity::test::test_identity_updates_concurrent_outdated ... ok
    test cob::issue::test::test_invalid_actions ... ok
    test cob::issue::test::test_invalid_tx_reference ... ok
    test cob::issue::test::test_invalid_tx ... ok
    test cob::issue::test::test_invalid_cob ... ok
    test cob::issue::test::test_concurrency ... ok
    test cob::issue::test::test_issue_all ... ok
    test cob::issue::test::test_issue_comment ... ok
    test cob::issue::test::test_issue_create_and_assign ... ok
    test cob::issue::test::test_issue_comment_redact ... ok
    test cob::issue::test::test_issue_create_and_get ... ok
    test cob::issue::test::test_issue_create_and_change_state ... ok
    test cob::issue::test::test_issue_create_and_unassign ... ok
    test cob::issue::test::test_issue_create_and_reassign ... ok
    test cob::issue::test::test_issue_edit ... ok
    test cob::issue::test::test_issue_edit_description ... ok
    test cob::issue::test::test_issue_multilines ... ok
    test cob::issue::test::test_issue_state_serde ... ok
    test cob::issue::test::test_ordering ... ok
    test cob::patch::actions::test::test_review_edit ... ok
    test cob::issue::test::test_issue_label ... ok
    test cob::issue::test::test_issue_react ... ok
    test cob::issue::test::test_issue_reply ... ok
    test cob::patch::cache::tests::test_is_empty ... ok
    test cob::patch::cache::tests::test_get ... ok
    test cob::patch::cache::tests::test_list ... ok
    test cob::patch::cache::tests::test_remove ... ok
    test cob::patch::encoding::review::test::test_review_deserialize_summary_migration_null_summary ... ok
    test cob::patch::encoding::review::test::test_review_deserialize_summary_migration_with_summary ... ok
    test cob::patch::encoding::review::test::test_review_deserialize_summary_migration_without_summary ... ok
    test cob::patch::encoding::review::test::test_review_deserialize_summary_v2 ... ok
    test cob::patch::encoding::review::test::test_review_summary ... ok
    test cob::patch::test::test_json ... ok
    test cob::patch::test::test_json_serialization ... ok
    test cob::patch::cache::tests::test_list_by_status ... ok
    test cob::patch::test::test_patch_create_and_get ... ok
    test cob::patch::test::test_patch_discussion ... ok
    test cob::patch::cache::tests::test_counts ... ok
    test cob::patch::test::test_patch_merge ... ok
    test cob::patch::test::test_patch_redact ... ok
    test cob::patch::test::test_patch_review ... ok
    test cob::patch::test::test_patch_review_comment ... ok
    test cob::patch::test::test_patch_review_duplicate ... ok
    test cob::patch::test::test_patch_review_edit ... ok
    test cob::patch::test::test_patch_review_remove_summary ... ok
    test cob::patch::test::test_patch_review_edit_comment ... ok
    test cob::patch::test::test_reactions_json_serialization ... ok
    test cob::patch::test::test_revision_edit_redact ... ok
    test cob::patch::test::test_revision_reaction ... ok
    test cob::patch::test::test_revision_review_merge_redacted ... ok
    test cob::patch::test::test_patch_review_revision_redact ... ok
    test cob::thread::tests::test_comment_edit_missing ... ok
    test cob::thread::tests::test_comment_edit_redacted ... ok
    test cob::thread::tests::test_comment_redact_missing ... ok
    test cob::thread::tests::test_duplicate_comments ... ok
    test cob::thread::tests::test_edit_comment ... ok
    test cob::thread::tests::test_redact_comment ... ok
    test cob::thread::tests::test_timeline ... ok
    test git::canonical::rules::tests::test_canonical ... ok
    test git::canonical::rules::tests::test_deserialization ... ok
    test git::canonical::rules::tests::test_deserialize_extensions ... ok
    test git::canonical::rules::tests::test_order ... ok
    test git::canonical::rules::tests::test_roundtrip ... ok
    test cob::patch::test::test_patch_update ... ok
    test git::canonical::rules::tests::test_rule_validate_success ... ok
    test git::canonical::rules::tests::test_special_branches ... ok
    test git::canonical::rules::tests::test_rule_validate_failures ... ok
    test git::canonical::tests::test_quorum_groups ... ok
    test git::canonical::tests::test_quorum_merges ... ok
    test git::canonical::tests::test_quorum ... ok
    test git::canonical::tests::test_quorum_tag ... ok
    test git::test::test_version_from_str ... ok
    test git::test::test_version_ord ... ok
    test identity::did::test::test_did_encode_decode ... ok
    test identity::did::test::test_did_vectors ... ok
    test identity::doc::id::test::prop_from_str ... ok
    test git::canonical::tests::test_quorum_properties ... ok
    test identity::doc::test::test_canonical_doc ... ok
    test identity::doc::test::test_canonical_example ... ok
    test identity::doc::test::test_duplicate_dids ... ok
    test identity::doc::test::test_future_version_error ... ok
    test identity::doc::test::test_is_valid_version ... ok
    test cob::thread::tests::prop_ordering ... ok
    test identity::doc::test::test_not_found ... ok
    test cob::patch::cache::tests::test_find_by_revision ... ok
    test identity::doc::test::test_parse_version ... ok
    test identity::doc::test::test_visibility_json ... ok
    test identity::doc::update::test::test_can_update_crefs ... ok
    test identity::doc::update::test::test_cannot_include_default_branch_rule ... ok
    test identity::doc::update::test::test_default_branch_rule_exists_after_verification ... ok
    test identity::project::test::test_project_name ... ok
    test node::address::store::test::test_alias ... ok
    test node::address::store::test::test_disconnected ... ok
    test node::address::store::test::test_disconnected_ban ... ok
    test node::address::store::test::test_entries ... ok
    test node::address::store::test::test_get_none ... ok
    test node::address::store::test::test_insert_and_get ... ok
    test node::address::store::test::test_insert_and_remove ... ok
    test node::address::store::test::test_insert_and_update ... ok
    test node::address::store::test::test_insert_duplicate ... ok
    test node::address::store::test::test_node_aliases ... ok
    test node::address::store::test::test_remove_nothing ... ok
    test node::db::test::test_version ... ok
    test node::features::test::test_operations ... ok
    test node::notifications::store::test::test_branch_notifications ... ok
    test identity::doc::test::test_max_delegates ... ok
    test node::notifications::store::test::test_clear ... ok
    test node::notifications::store::test::test_cob_notifications ... ok
    test node::notifications::store::test::test_counts_by_repo ... ok
    test node::notifications::store::test::test_duplicate_notifications ... ok
    test node::notifications::store::test::test_notification_status ... ok
    test node::policy::store::test::test_follow_and_unfollow_node ... ok
    test node::policy::store::test::test_node_aliases ... ok
    test node::policy::store::test::test_node_policy ... ok
    test node::policy::store::test::test_node_policies ... ok
    test node::policy::store::test::test_repo_policies ... ok
    test node::policy::store::test::test_seed_and_unseed_repo ... ok
    test node::policy::store::test::test_update_alias ... ok
    test node::policy::store::test::test_update_scope ... ok
    test node::refs::store::test::test_count ... ok
    test node::refs::store::test::test_set_and_delete ... ok
    test node::policy::store::test::test_repo_policy ... ok
    test node::refs::store::test::test_set_and_get ... ok
    test node::routing::test::test_count ... ok
    test node::routing::test::test_entries ... ok
    test node::routing::test::test_insert_and_get_resources ... ok
    test node::address::store::test::test_empty ... ok
    test node::routing::test::test_insert_duplicate ... ok
    test node::routing::test::test_insert_and_get ... ok
    test node::routing::test::test_insert_existing_updated_time ... ok
    test node::routing::test::test_insert_and_remove ... ok
    test node::routing::test::test_len ... ok
    test node::routing::test::test_remove_many ... ok
    test node::routing::test::test_remove_redundant ... ok
    test node::routing::test::test_update_existing_multi ... ok
    test node::sync::announce::test::all_synced_nodes_are_preferred_seeds ... ok
    test node::sync::announce::test::announcer_adapts_target_to_reach ... ok
    test node::sync::announce::test::announcer_preferred_seeds_or_replica_factor ... ok
    test node::routing::test::test_prune ... ok
    test node::sync::announce::test::announcer_reached_max_replication_target ... ok
    test node::sync::announce::test::announcer_reached_min_replication_target ... ok
    test node::sync::announce::test::announcer_reached_preferred_seeds ... ok
    test node::sync::announce::test::announcer_synced_with_unknown_node ... ok
    test node::sync::announce::test::announcer_with_replication_factor_zero_and_preferred_seeds ... ok
    test node::sync::announce::test::announcer_timed_out ... ok
    test node::sync::announce::test::construct_node_appears_in_multiple_input_sets ... ok
    test node::sync::announce::test::construct_only_preferred_seeds_provided ... ok
    test node::sync::announce::test::invariant_progress_should_match_state ... ok
    test node::sync::announce::test::local_node_in_multiple_sets ... ok
    test node::sync::announce::test::cannot_construct_announcer ... ok
    test node::sync::announce::test::local_node_in_preferred_seeds ... ok
    test node::sync::announce::test::local_node_in_synced_set ... ok
    test node::sync::announce::test::local_node_only_in_all_sets_results_in_no_seeds_error ... ok
    test node::sync::announce::test::local_node_in_unsynced_set ... ok
    test node::sync::announce::test::preferred_seeds_already_synced ... ok
    test node::sync::announce::test::synced_with_local_node_is_ignored ... ok
    test node::sync::announce::test::timed_out_after_reaching_success ... ok
    test node::sync::announce::test::synced_with_same_node_multiple_times ... ok
    test node::sync::fetch::test::all_nodes_are_candidates ... ok
    test node::sync::fetch::test::ignores_duplicates_and_local_node ... ok
    test node::sync::fetch::test::all_nodes_are_fetchable ... ok
    test node::sync::fetch::test::preferred_seeds_target_returned_over_replicas ... ok
    test node::sync::fetch::test::could_not_reach_target ... ok
    test node::sync::fetch::test::reaches_target_of_preferred_seeds ... ok
    test node::sync::test::ensure_replicas_construction ... ok
    test node::sync::test::replicas_constrain_to ... ok
    test node::test::test_alias ... ok
    test node::test::test_command_result ... ok
    test node::test::test_user_agent ... ok
    test node::timestamp::tests::test_timestamp_max ... ok
    test node::sync::fetch::test::reaches_target_of_replicas ... ok
    test profile::test::canonicalize_home ... ok
    test profile::test::test_config ... ok
    test node::sync::fetch::test::reaches_target_of_max_replicas ... ok
    test rad::tests::test_checkout ... ok
    test rad::tests::test_fork ... ok
    test serde_ext::test::test_localtime ... ok
    test serde_ext::test::test_localtime_ext ... ok
    test storage::git::tests::test_references_of ... ok
    test rad::tests::test_init ... ok
    test storage::git::tests::test_sign_refs ... ok
    test storage::git::transport::local::url::test::test_url_parse ... ok
    test storage::git::transport::local::url::test::test_url_to_string ... ok
    test storage::git::transport::remote::url::test::test_url_parse ... ok
    test storage::refs::tests::prop_canonical_roundtrip ... ok
    test storage::git::tests::test_remote_refs ... ok
    test storage::tests::test_storage ... ok
    test test::assert::test::assert_with_message ... ok
    test test::assert::test::test_assert_no_move ... ok
    test test::assert::test::test_assert_panic_0 - should panic ... ok
    test test::assert::test::test_assert_panic_1 - should panic ... ok
    test test::assert::test::test_assert_panic_2 - should panic ... ok
    test test::assert::test::test_assert_succeed ... ok
    test test::assert::test::test_panic_message ... ok
    test version::test::test_version ... ok
    test profile::config::test::schema ... ok
    test storage::refs::tests::test_rid_verification ... ok
    test identity::doc::test::prop_encode_decode ... ok
    
    test result: ok. 223 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 3.99s
    
         Running unittests src/lib.rs (/workspace/cache/debug/deps/radicle_cli-3beb2acfdc1661c1)
    
    running 14 tests
    test commands::rad_patch::review::builder::tests::test_review_comments_multiline ... ok
    test commands::rad_inspect::test::test_tree ... ok
    test commands::rad_patch::review::builder::tests::test_review_comments_basic ... ok
    test commands::rad_patch::review::builder::tests::test_review_comments_split_hunk ... ok
    test git::ddiff::tests::diff_encode_decode_ddiff_hunk ... ok
    test git::pretty_diff::test::test_pretty ... ignored
    test git::unified_diff::test::test_diff_content_encode_decode_content ... ok
    test git::unified_diff::test::test_diff_encode_decode_diff ... ok
    test terminal::format::test::test_bytes ... ok
    test terminal::format::test::test_strip_comments ... ok
    test terminal::patch::test::test_edit_display_message ... ok
    test terminal::patch::test::test_create_display_message ... ok
    test terminal::patch::test::test_update_display_message ... ok
    test commands::rad_patch::review::builder::tests::test_review_comments_before ... ok
    
    test result: ok. 13 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out; finished in 0.03s
    
         Running unittests src/main.rs (/workspace/cache/debug/deps/rad-a688f6b88a0ae1aa)
    
    running 0 tests
    
    test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
    
         Running tests/commands.rs (/workspace/cache/debug/deps/commands-7e751aa8c63b07e8)
    
    running 101 tests
    test framework_home ... ok
    test git_push_and_fetch ... ok
    test git_push_amend ... ok
    test git_push_canonical_annotated_tags ... ok
    test git_push_canonical_lightweight_tags ... ok
    test git_push_diverge ... ok
    test git_tag ... FAILED
    test rad_auth_errors ... ok
    test rad_auth ... ok
    test git_push_rollback ... ok
    test rad_block ... ok
    test rad_checkout ... ok
    test git_push_converge ... ok
    test rad_clone ... ok
    test rad_clean ... ok
    test rad_clone_all ... ok
    test rad_clone_directory ... ok
    test rad_clone_connect ... ok
    test rad_clone_unknown ... ok
    test rad_cob_log ... ok
    test rad_cob_migrate ... ok
    test rad_cob_multiset ... ok
    test rad_cob_show ... ok
    test rad_cob_update_identity ... ok
    test rad_cob_update ... ok
    test rad_diff ... ok
    test rad_clone_partial_fail ... ok
    test rad_config ... ok
    test rad_id_collaboration ... ignored, slow
    test rad_id ... ok
    test rad_id_conflict ... ok
    test rad_id_missing_commits ... ok
    test rad_fetch ... ok
    test rad_fork ... ok
    test rad_id_private ... ok
    test rad_id_multi_delegate ... ok
    test rad_id_unknown_field ... ok
    test rad_id_update_delete_field ... ok
    test rad_init ... ignored, part of many other tests
    test rad_init_detached_head ... ok
    test rad_id_threshold_soft_fork ... ok
    test rad_init_existing ... ok
    test rad_init_no_git ... ok
    test rad_init_no_seed ... ok
    test rad_init_private ... ok
    test rad_id_threshold ... ok
    test rad_init_private_no_seed ... ok
    test rad_inbox ... ok
    test rad_init_private_clone_seed ... ok
    test rad_init_private_clone ... ok
    test rad_init_sync_not_connected ... ok
    test rad_init_private_seed ... ok
    test rad_init_with_existing_remote ... ok
    test rad_init_sync_preferred ... ok
    test rad_inspect ... ok
    test rad_issue ... ok
    test rad_merge_after_update ... ok
    test rad_merge_no_ff ... ok
    test rad_merge_via_push ... ok
    test rad_node_connect ... ok
    test rad_node ... ok
    test rad_init_sync_and_clone ... ok
    test rad_node_connect_without_address ... ok
    test rad_init_sync_timeout ... ok
    test rad_patch_ahead_behind ... ok
    test rad_patch_change_base ... ok
    test rad_patch ... ok
    test rad_patch_checkout ... ok
    test rad_patch_checkout_revision ... ok
    test rad_patch_detached_head ... ok
    test rad_patch_diff ... ok
    test rad_patch_draft ... ok
    test rad_patch_checkout_force ... ok
    test rad_patch_edit ... ok
    test rad_patch_fetch_2 ... ok
    test rad_patch_merge_draft ... ok
    test rad_patch_fetch_1 ... ok
    test rad_patch_revert_merge ... ok
    test rad_patch_update ... ok
    test rad_patch_open_explore ... ok
    test rad_patch_delete ... ok
    test rad_publish ... ok
    test rad_patch_via_push ... ok
    test rad_review_by_hunk ... ok
    test rad_seed_and_follow ... ok
    test rad_patch_pull_update ... ok
    test rad_remote ... ok
    test rad_push_and_pull_patches ... ok
    test rad_seed_many ... ok
    test rad_self ... ok
    test rad_unseed ... ok
    test rad_unseed_many ... ok
    test rad_warn_old_nodes ... ok
    test rad_sync_without_node ... ok
    test test_clone_without_seeds ... ok
    test rad_watch ... ok
    test rad_sync ... ok
    test test_cob_deletion ... ok
    test test_cob_replication ... ok
    test rad_workflow ... ok
    test test_replication_via_seed ... ok
    
    failures:
    
    ---- git_tag stdout ----
    1755078042 test: Using PATH ["/workspace/cache/debug", "/workspace/deps/bin", "/root/.cargo/bin", "/usr/local/sbin", "/usr/local/bin", "/usr/sbin", "/usr/bin", "/sbin", "/bin", "/tmp/radicle-wk5SL6/work/alice"]
    1755078042 test: rad-init.md: Running `/workspace/cache/debug/rad` with ["init", "--name", "heartwood", "--description", "Radicle Heartwood Protocol & Stack", "--no-confirm", "--public", "-v"] in `/tmp/radicle-wk5SL6/work/alice`..
    1755078042 test: rad-init.md: Running `/workspace/cache/debug/rad` with ["init"] in `/tmp/radicle-wk5SL6/work/alice`..
    1755078042 test: rad-init.md: Running `/workspace/cache/debug/rad` with ["ls"] in `/tmp/radicle-wk5SL6/work/alice`..
    1755078042 test: rad-init.md: Running `/workspace/cache/debug/rad` with ["node", "inventory"] in `/tmp/radicle-wk5SL6/work/alice`..
    1755078042 git_tag               node: Opening policy database..
    1755078042 git_tag               node: Default seeding policy set to 'block (all)'
    1755078042 git_tag               node: Initializing service (Test)..
    1755078042 git_tag               node: Opening node database..
    1755078042 git_tag               node: Address book is empty. Adding bootstrap nodes..
    1755078042 git_tag               node: 0 nodes added to address book
    1755078042 git_tag            service: Init @1755078042510
    1755078042 git_tag            service: Empty refs database, populating from storage..
    1755078042 git_tag            service: Saved local sync status for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji..
    1755078042 git_tag            service: Adding refs announcement for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji to historical gossip messages..
    1755078042 git_tag            service: Not enough available peers to connect to (available=0, wanted=8)
    1755078042 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>           node: Listening on 0.0.0.0:36179..
    1755078042 git_tag               node: Binding control socket /tmp/radicle-wk5SL6/home/alice/.radicle/node/control.sock..
    1755078042 git_tag               node: Opening policy database..
    1755078042 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <runtime>           node: Running node z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi in /tmp/radicle-wk5SL6/home/alice/.radicle..
    1755078042 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <control>        control: Control thread listening on socket..
    1755078042 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <signals>           node: Signal notifications channel error: receiving on an empty and disconnected channel
    1755078042 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>        service: Received command QueryState(..)
    1755078042 git_tag               node: Default seeding policy set to 'block (all)'
    1755078042 git_tag               node: Initializing service (Test)..
    1755078042 git_tag               node: Opening node database..
    1755078043 git_tag               node: Address book is empty. Adding bootstrap nodes..
    1755078043 git_tag               node: 0 nodes added to address book
    1755078043 git_tag            service: Init @1755078042791
    1755078043 git_tag            service: Empty refs database, populating from storage..
    1755078043 git_tag            service: Not enough available peers to connect to (available=0, wanted=8)
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>           node: Listening on 0.0.0.0:34227..
    1755078043 git_tag               node: Binding control socket /tmp/radicle-wk5SL6/home/bob/.radicle/node/control.sock..
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <runtime>           node: Running node z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk in /tmp/radicle-wk5SL6/home/bob/.radicle..
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control>        control: Control thread listening on socket..
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <signals>           node: Signal notifications channel error: receiving on an empty and disconnected channel
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Received command QueryState(..)
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Received command QueryState(..)
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Received command Connect(z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi, 0.0.0.0:36179, ConnectOptions { persistent: false, timeout: 30s })
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Connecting to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (0.0.0.0:36179)..
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Attempted connection to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (0.0.0.0:36179)
    1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>           wire: Inbound connection from 127.0.0.1:37338 (fd=213)..
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>           wire: Registering outbound transport for z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (fd=212)..
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>           wire: Outbound peer resource registered for z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi with id=2 (fd=212)
    1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>           wire: Accepted inbound connection from 127.0.0.1:37338 (fd=213)..
    1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>           wire: Inbound peer resource registered with id=2 (fd=213)
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>           wire: Session established with z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (id=2) (fd=212) (outbound)
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Connected to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (0.0.0.0:36179) (Outbound)
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Subscribing to messages since timestamp 1754991643018..
    1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>           wire: Session established with z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk (id=2) (fd=213) (inbound)
    1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>        service: Connected to z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk (127.0.0.1:37338) (Inbound)
    1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>        service: Subscribing to messages since timestamp 1754991643018..
    1755078043 test: Node z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi has converged
    1755078043 test: Node has missing routes: [(RepoId(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji), PublicKey(z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi))]
    1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>        service: Received node announcement of z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk with 0 address(es) from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk (t=1755078042791)
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Received node announcement of z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi with 0 address(es) from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (t=1755078042510)
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Stored announcement from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi to be broadcast in 0 millisecond(s) (t=1755078042510)
    1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>        service: Stored announcement from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk to be broadcast in 0 millisecond(s) (t=1755078042791)
    1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>        service: Address store entry for node z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk updated at 1755078042791
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Address store entry for node z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi updated at 1755078042510
    1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>        service: Received inventory announcement of z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk with 0 item(s) from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk (t=1755078042792)
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Received inventory announcement of z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi with 1 item(s) from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (t=1755078042512)
    1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>        service: Stored announcement from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk to be broadcast in 0 millisecond(s) (t=1755078042792)
    1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>        service: Received subscription filter from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Stored announcement from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi to be broadcast in 0 millisecond(s) (t=1755078042512)
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Routing table updated for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji with seed z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Received subscription filter from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
    1755078043 test: Node z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk has converged
    1755078043 test: Using PATH ["/workspace/cache/debug", "/workspace/deps/bin", "/root/.cargo/bin", "/usr/local/sbin", "/usr/local/bin", "/usr/sbin", "/usr/bin", "/sbin", "/bin", "/tmp/radicle-wk5SL6/work/bob"]
    1755078043 test: rad-clone.md: Running `/workspace/cache/debug/rad` with ["clone", "rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji", "--scope", "followed"] in `/tmp/radicle-wk5SL6/work/bob`..
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control>        control: Received `{"command":"status"}` on control socket
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control>        control: Received `{"command":"seed","rid":"rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji","scope":"followed"}` on control socket
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Received command Seed(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji, followed)
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Sending subscription filter to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
    1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>        service: Received subscription filter from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control>        control: Received `{"command":"seeds","rid":"rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji"}` on control socket
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Received command Seeds(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji)
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Found 1 connected seed(s) and 0 disconnected seed(s) for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control>        control: Received `{"command":"session","nid":"z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi"}` on control socket
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Received command QueryState(..)
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control>        control: Received `{"command":"fetch","rid":"rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji","nid":"z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi","timeout":{"secs":9,"nanos":0}}` on control socket
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Received command Fetch(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji, z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi)
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Fetch initiated for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji with z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi [outbound connected] (all remotes)..
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>           wire: Opened new stream with id 12 for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji and remote z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0>        worker: Worker processing outgoing fetch for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
    1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>           wire: Received `open` command for stream 12 from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk
    1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <worker#0>        worker: Worker processing incoming fetch for z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk on stream 12..
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0>        worker: z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk cloning from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
    1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <worker#0>        worker: Spawning upload-pack process for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji on stream 12..
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0>         fetch: Fetched rad/id (12ms)
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0>         fetch: Fetched data for 1 remote(s) (33ms)
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0>         fetch: Fetched data refs for 1 remotes (41ms)
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0>         fetch: Sent done signal to remote z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
    1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>           wire: Received `end-of-file` on stream 12 from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk
    1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <upload-pack>     worker: Exiting upload-pack reader thread for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
    1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <worker#0>        worker: Upload pack finished (48ms)
    1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <worker#0>        worker: Upload process on stream 12 exited with result Ok(())
    1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>           wire: Received fetch result from worker for stream 12, remote z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk: Responder { rid: Some(RepoId(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji)), result: Ok(()) }
    1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>           wire: Stream 12 of z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk closing with 0 byte(s) sent and 0 byte(s) received
    1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>           wire: Peer z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk fetched rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji from us successfully
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0>         fetch: Validated 1 remote(s) (42ms)
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>           wire: Received `close` command for stream 12 from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>           wire: Stream 12 of z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi closed with 0 byte(s) sent and 0 byte(s) received
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0>         fetch: Applied updates (43ms)
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0>         fetch: Finished clone of rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (50ms)
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0>           cob: Loading object of type xyz.radicle.id at 0656c217f917c3e06234771e9ecae53aba5e173e
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0>       storage: Setting ref: refs/rad/id -> 0656c217f917c3e06234771e9ecae53aba5e173e
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0>       storage: Setting ref: refs/heads/master -> f2de534b5e81d7c6e2dcaf58c3dd91573c0a0354
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0>       storage: Setting ref: HEAD -> refs/heads/master
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0>           cob: Loading object of type xyz.radicle.id at 0656c217f917c3e06234771e9ecae53aba5e173e
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>           wire: Received fetch result from worker for stream 12, remote z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi: Initiator { rid: RepoId(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji), result: Ok(FetchResult { updated: [Created { name: RefString("refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/rad/id"), oid: Oid(0656c217f917c3e06234771e9ecae53aba5e173e) }, Created { name: RefString("refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/rad/sigrefs"), oid: Oid(99c549702e2bcfe02b0e68d4a2224fb7a1524529) }, Created { name: RefString("refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/cobs/xyz.radicle.id/0656c217f917c3e06234771e9ecae53aba5e173e"), oid: Oid(0656c217f917c3e06234771e9ecae53aba5e173e) }, Created { name: RefString("refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/heads/master"), oid: Oid(f2de534b5e81d7c6e2dcaf58c3dd91573c0a0354) }, Skipped { name: RefString("refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/rad/id"), oid: Oid(0656c217f917c3e06234771e9ecae53aba5e173e) }, Created { name: RefString("refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/rad/root"), oid: Oid(0656c217f917c3e06234771e9ecae53aba5e173e) }], namespaces: {PublicKey(z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi)}, clone: true, doc: DocAt { commit: Oid(0656c217f917c3e06234771e9ecae53aba5e173e), blob: Oid(d96f425412c9f8ad5d9a9a05c9831d0728e2338d), doc: Doc { version: Version(1), payload: {PayloadId(TypeName("xyz.radicle.project")): Payload { value: Object {"defaultBranch": String("master"), "description": String("Radicle Heartwood Protocol & Stack"), "name": String("heartwood")} }}, delegates: Delegates(NonEmpty { head: Did("did:key:z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi"), tail: [] }), threshold: Threshold(1), visibility: Public } } }) }
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Found existing fetch request from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi, sending result..
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Sent fetch result for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi..
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Fetched rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi successfully
    1755078043 test: rad-clone.md: Running `cd /tmp/radicle-wk5SL6/work/bob/heartwood`..
    1755078043 test: rad-clone.md: Running `ls` with [] in `/tmp/radicle-wk5SL6/work/bob/heartwood`..
    1755078043 test: rad-clone.md: Running `cat` with ["README"] in `/tmp/radicle-wk5SL6/work/bob/heartwood`..
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Ref updated: * 0000000..0656c21 refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/rad/id for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Ref updated: * 0000000..99c5497 refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/rad/sigrefs for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Ref updated: * 0000000..0656c21 refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/cobs/xyz.radicle.id/0656c217f917c3e06234771e9ecae53aba5e173e for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Ref updated: * 0000000..f2de534 refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/heads/master for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Ref updated: * 0000000..0656c21 refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/rad/root for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Updating and announcing inventory for cloned repository rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji..
    1755078043 test: rad-clone.md: Running `git` with ["status"] in `/tmp/radicle-wk5SL6/work/bob/heartwood`..
    1755078043 test: rad-clone.md: Running `git` with ["branch", "--remotes"] in `/tmp/radicle-wk5SL6/work/bob/heartwood`..
    1755078043 test: rad-clone.md: Running `git` with ["remote", "-v"] in `/tmp/radicle-wk5SL6/work/bob/heartwood`..
    1755078043 test: rad-clone.md: Running `git` with ["log", "-n", "1"] in `/tmp/radicle-wk5SL6/work/bob/heartwood`..
    1755078043 test: rad-clone.md: Running `/workspace/cache/debug/rad` with ["ls", "--seeded"] in `/tmp/radicle-wk5SL6/work/bob/heartwood`..
    1755078043 test: Using PATH ["/workspace/cache/debug", "/workspace/deps/bin", "/root/.cargo/bin", "/usr/local/sbin", "/usr/local/bin", "/usr/sbin", "/usr/bin", "/sbin", "/bin", "/tmp/radicle-wk5SL6"]
    1755078043 test: git-tag.md: Running `touch` with ["LICENSE"] in `/tmp/radicle-wk5SL6/work/alice`..
    1755078043 test: git-tag.md: Running `git` with ["add", "LICENSE"] in `/tmp/radicle-wk5SL6/work/alice`..
    1755078043 test: git-tag.md: Running `git` with ["commit", "-am", "Add LICENSE"] in `/tmp/radicle-wk5SL6/work/alice`..
    1755078043 test: git-tag.md: Running `git` with ["tag", "v1.0", "-a", "-m", "Release v1.0"] in `/tmp/radicle-wk5SL6/work/alice`..
    1755078043 test: git-tag.md: Running `git` with ["push", "rad", "v1.0"] in `/tmp/radicle-wk5SL6/work/alice`..
    1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <control>        control: Received `{"command":"status"}` on control socket
    1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <control>        control: Received `{"command":"seeds","rid":"rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji"}` on control socket
    1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>        service: Received command Seeds(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji)
    1755078043 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>        service: Found 0 connected seed(s) and 1 disconnected seed(s) for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
    
    thread 'git_tag' panicked at crates/radicle-cli-test/src/lib.rs:489:36:
    
    --- Expected
    ++++ actual:   stderr
       1      - ✓ Synced with 1 seed(s)
            1 + No seeds found for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji.
       2    2 | To rad://z42hL2jL4XNk6K8oHQaSWfMgCL7ji/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
       3    3 |  * [new tag]         v1.0 -> v1.0
    
    Exit status: 0
    
    note: run with `RUST_BACKTRACE=1` environment variable to display a backtrace
    1755078043 test: Node z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk shutting down..
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control>        control: Received `{"command":"shutdown"}` on control socket
    1755078043 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control>        control: Shutdown requested..
    1755078044 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Sending inventory announcement of z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk with 1 item(s) to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (t=1755078043452)
    1755078044 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service>        service: Sending refs announcement of z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji with 1 remote(s) to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (t=1755078043453)
    1755078044 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>           wire: Disconnecting peer with id=2: connection reset
    1755078044 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>           wire: Transport handover for disconnecting peer with id=2 (fd=213)
    1755078044 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>        service: Disconnected from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk (connection reset)
    1755078044 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service>        service: Dropping peer z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk..
    1755078044 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <runtime>           pool: Worker pool shutting down..
    1755078044 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <runtime>           node: Node shutdown completed for z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk
    1755078044 test: Node z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi shutting down..
    1755078044 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <control>        control: Received `{"command":"shutdown"}` on control socket
    1755078044 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <control>        control: Shutdown requested..
    1755078044 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <runtime>           pool: Worker pool shutting down..
    1755078044 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <runtime>           node: Node shutdown completed for z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
    
    
    failures:
        git_tag
    
    test result: FAILED. 98 passed; 1 failed; 2 ignored; 0 measured; 0 filtered out; finished in 94.01s
    
    error: test failed, to rerun pass `-p radicle-cli --test commands`
    ERROR: Action failed: command failed: ["cargo", "test", "--offline", "--locked", "--workspace"]
    ERROR: command failed: ["cargo", "test", "--offline", "--locked", "--workspace"]
    EXIT CODE: 1
    
    ====================
[2025-08-13T09:41:50Z DEBUG ambient_ci::qemu] QEMU exit code 1
ERROR: failed to run actions in QEMU

Ambient stderr

<empty log>