Radicle repository id rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5
[2025-09-25T16:13:01Z INFO ambient] ambient starts
[2J[01;01H[=3h[2J[01;01H[2J[01;01H[=3h[2J[01;01HBdsDxe: 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)
[0m[30m[47mWelcome to GRUB!
[0m[37m[40m[0m[30m[40m[2J[01;01H[0m[37m[40mINFO: 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 6.1M 1 disk
vdc 254:32 0 29.1M 1 disk
vdd 254:48 0 9.3G 0 disk
vde 254:64 0 46.6G 0 disk
vdf 254:80 0 809.1M 1 disk
INFO: Extracting tar archive from /dev/vdb
drwxr-xr-x _rad/_rad 0 2025-09-25 16:06 ./
-rw-r--r-- _rad/_rad 2450 2025-09-25 16:06 ./plan.yaml
-rwxr-xr-x _rad/_rad 6410400 2025-09-25 16:06 ./run-ci
INFO: Extracted files:
4587530 4 drwxr-xr-x 2 1001 1001 4096 Sep 25 16:06 .
4587526 4 -rw-r--r-- 1 1001 1001 2450 Sep 25 16:06 ./plan.yaml
4587527 6264 -rwxr-xr-x 1 1001 1001 6410400 Sep 25 16:06 ./run-ci
INFO: Running run-ci from /dev/vdb
================================ BEGIN ================================
[2025-09-25T16:07:21Z TRACE ambient_execute_plan] ambient-execute-plan version 0.7.0@2e86bbe starts
[2025-09-25T16:07:21Z DEBUG ambient_execute_plan] ambient-execute-plan version 0.7.0@2e86bbe starts
[2025-09-25T16:07:21Z INFO ambient_execute_plan] ambient-execute-plan version 0.7.0@2e86bbe starts
[2025-09-25T16:07:21Z WARN ambient_execute_plan] ambient-execute-plan version 0.7.0@2e86bbe starts
[2025-09-25T16:07:21Z ERROR ambient_execute_plan] ambient-execute-plan version 0.7.0@2e86bbe 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"
export RUSTDOCFLAGS='-D warnings'
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
[2025-09-25T16:07:21Z DEBUG ambient_ci::plan] RUN: Action Mkdir {
pathname: "/workspace",
}
[2025-09-25T16:07:21Z DEBUG ambient_ci::action] Plan::execute: plan=Mkdir {
pathname: "/workspace",
}
[2025-09-25T16:07:21Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_HOME": "/workspace/deps",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
[2025-09-25T16:07:21Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-25T16:07:21Z DEBUG ambient_ci::plan] RUN: Action Mkdir {
pathname: "/workspace/artifacts",
}
[2025-09-25T16:07:21Z DEBUG ambient_ci::action] Plan::execute: plan=Mkdir {
pathname: "/workspace/artifacts",
}
[2025-09-25T16:07:21Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_HOME": "/workspace/deps",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
[2025-09-25T16:07:22Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-25T16:07:22Z DEBUG ambient_ci::plan] RUN: Action TarExtract {
archive: "/dev/vdc",
directory: "/workspace/src",
}
[2025-09-25T16:07:22Z DEBUG ambient_ci::action] Plan::execute: plan=TarExtract {
archive: "/dev/vdc",
directory: "/workspace/src",
}
[2025-09-25T16:07:22Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_HOME": "/workspace/deps",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
[2025-09-25T16:07:22Z TRACE ambient_ci::vdrive] extracting /dev/vdc to /workspace/src
[2025-09-25T16:07:22Z TRACE ambient_ci::vdrive] extraction OK
[2025-09-25T16:07:22Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-25T16:07:22Z DEBUG ambient_ci::plan] RUN: Action TarExtract {
archive: "/dev/vdf",
directory: "/workspace/deps",
}
[2025-09-25T16:07:22Z DEBUG ambient_ci::action] Plan::execute: plan=TarExtract {
archive: "/dev/vdf",
directory: "/workspace/deps",
}
[2025-09-25T16:07:22Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_HOME": "/workspace/deps",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
[2025-09-25T16:07:22Z TRACE ambient_ci::vdrive] extracting /dev/vdf to /workspace/deps
[2025-09-25T16:07:45Z TRACE ambient_ci::vdrive] extraction OK
[2025-09-25T16:07:45Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-25T16:07:45Z DEBUG ambient_ci::plan] RUN: Action TarExtract {
archive: "/dev/vde",
directory: "/workspace/cache",
}
[2025-09-25T16:07:45Z DEBUG ambient_ci::action] Plan::execute: plan=TarExtract {
archive: "/dev/vde",
directory: "/workspace/cache",
}
[2025-09-25T16:07:45Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_HOME": "/workspace/deps",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
[2025-09-25T16:07:45Z TRACE ambient_ci::vdrive] extracting /dev/vde to /workspace/cache
[2025-09-25T16:09:16Z TRACE ambient_ci::vdrive] extraction OK
[2025-09-25T16:09:16Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-25T16:09:16Z DEBUG ambient_ci::plan] RUN: Action Spawn {
argv: [
"find",
"/workspace",
"-maxdepth",
"2",
"-ls",
],
}
[2025-09-25T16:09:16Z DEBUG ambient_ci::action] Plan::execute: plan=Spawn {
argv: [
"find",
"/workspace",
"-maxdepth",
"2",
"-ls",
],
}
[2025-09-25T16:09:16Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_HOME": "/workspace/deps",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
SPAWN: argv=["find", "/workspace", "-maxdepth", "2", "-ls"]
cwd=/workspace/src (exists? true)
2621441 4 drwxr-xr-x 6 root root 4096 Sep 25 16:07 /workspace
2622488 4 drwxr-xr-x 3 root root 4096 Sep 25 16:06 /workspace/deps
2622489 0 -rw-r--r-- 1 root root 0 Sep 22 16:46 /workspace/deps/.package-cache-mutate
2622492 4 drwxr-xr-x 5 root root 4096 Sep 22 16:46 /workspace/deps/registry
2622490 128 -rw-r--r-- 1 root root 131072 Sep 25 16:06 /workspace/deps/.global-cache
2622491 0 -rw-r--r-- 1 root root 0 Sep 22 16:46 /workspace/deps/.package-cache
2621443 4 drwxr-xr-x 12 root root 4096 Sep 25 16:06 /workspace/src
2621499 4 -rw-r--r-- 1 root root 2653 Sep 25 16:06 /workspace/src/Cargo.toml
2622484 12 -rw-r--r-- 1 root root 9636 Sep 25 16:06 /workspace/src/CONTRIBUTING.md
2621500 4 drwxr-xr-x 2 root root 4096 Sep 25 16:06 /workspace/src/.config
2621496 4 -rw-r--r-- 1 root root 1623 Sep 25 16:06 /workspace/src/build.rs
2621502 4 -rw-r--r-- 1 root root 426 Sep 25 16:06 /workspace/src/radicle-node.1.adoc
2621504 4 drwxr-xr-x 8 root root 4096 Sep 25 16:06 /workspace/src/.git
2622481 8 -rw-r--r-- 1 root root 7144 Sep 25 16:06 /workspace/src/rad-id.1.adoc
2621460 4 -rw-r--r-- 1 root root 2163 Sep 25 16:06 /workspace/src/VERSIONING.md
2621495 4 -rw-r--r-- 1 root root 3133 Sep 25 16:06 /workspace/src/README.md
2621903 12 -rw-r--r-- 1 root root 10975 Sep 25 16:06 /workspace/src/rad-patch.1.adoc
2622485 4 -rw-r--r-- 1 root root 79 Sep 25 16:06 /workspace/src/ARCHITECTURE.md
2621911 4 drwxr-xr-x 17 root root 4096 Sep 25 16:06 /workspace/src/crates
2621448 4 drwxr-xr-x 2 root root 4096 Sep 25 16:06 /workspace/src/scripts
2621444 4 drwxr-xr-x 2 root root 4096 Sep 25 16:06 /workspace/src/.radicle
2621467 12 -rw-r--r-- 1 root root 9422 Sep 25 16:06 /workspace/src/CHANGELOG.md
2621482 4 drwxr-xr-x 3 root root 4096 Sep 25 16:06 /workspace/src/debian
2621465 4 -rw-r--r-- 1 root root 42 Sep 25 16:06 /workspace/src/.envrc
2622482 4 -rw-r--r-- 1 root root 1203 Sep 25 16:06 /workspace/src/DCO
2622477 4 drwxr-xr-x 3 root root 4096 Sep 25 16:06 /workspace/src/.github
2622487 120 -rw-r--r-- 1 root root 121633 Sep 25 16:06 /workspace/src/Cargo.lock
2621904 4 drwxr-xr-x 5 root root 4096 Sep 25 16:06 /workspace/src/systemd
2621902 12 -rw-r--r-- 1 root root 9723 Sep 25 16:06 /workspace/src/LICENSE-APACHE
2621498 4 -rw-r--r-- 1 root root 101 Sep 25 16:06 /workspace/src/.gitignore
2622483 8 -rw-r--r-- 1 root root 5102 Sep 25 16:06 /workspace/src/flake.lock
2621464 4 -rw-r--r-- 1 root root 77 Sep 25 16:06 /workspace/src/rust-toolchain.toml
2621497 12 -rw-r--r-- 1 root root 10500 Sep 25 16:06 /workspace/src/flake.nix
2621468 4 -rw-r--r-- 1 root root 571 Sep 25 16:06 /workspace/src/git-remote-rad.1.adoc
2621466 4 -rw-r--r-- 1 root root 61 Sep 25 16:06 /workspace/src/.env.seed
2621503 8 -rw-r--r-- 1 root root 5432 Sep 25 16:06 /workspace/src/deny.toml
2621458 8 -rw-r--r-- 1 root root 7645 Sep 25 16:06 /workspace/src/HACKING.md
2621447 4 -rw-r--r-- 1 root root 1079 Sep 25 16:06 /workspace/src/LICENSE-MIT
2621463 8 -rw-r--r-- 1 root root 8023 Sep 25 16:06 /workspace/src/rad.1.adoc
2621469 4 drwxr-xr-x 2 root root 4096 Sep 25 16:06 /workspace/src/build
2622486 4 -rw-r--r-- 1 root root 1083 Sep 25 16:06 /workspace/src/.gitsigners
2621459 4 -rw-r--r-- 1 root root 30 Sep 25 16:06 /workspace/src/.dockerignore
2621461 4 drwxr-xr-x 2 root root 4096 Sep 25 16:06 /workspace/src/.cargo
2621442 4 drwxr-xr-x 2 root root 4096 Sep 25 16:07 /workspace/artifacts
2650536 4 drwxr-xr-x 6 root root 4096 Sep 22 23:09 /workspace/cache
2669231 4 -rw-r--r-- 1 root root 218 Sep 22 23:08 /workspace/cache/.rustdoc_fingerprint.json
2757416 4 drwxr-xr-x 24 root root 4096 Sep 24 10:45 /workspace/cache/doc
2650538 4 drwxr-xr-x 7 root root 4096 Sep 24 10:43 /workspace/cache/debug
2650537 4 drwxr-xr-x 2 root root 4096 Sep 22 23:02 /workspace/cache/tmp
2669232 4 -rw-r--r-- 1 root root 1036 Sep 24 12:56 /workspace/cache/.rustc_info.json
2752513 4 drwxr-xr-x 7 root root 4096 Sep 24 10:47 /workspace/cache/release
[2025-09-25T16:09:17Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-25T16:09:17Z DEBUG ambient_ci::plan] RUN: Action CargoFmt
[2025-09-25T16:09:17Z DEBUG ambient_ci::action] Plan::execute: plan=CargoFmt
[2025-09-25T16:09:17Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_HOME": "/workspace/deps",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
SPAWN: argv=["cargo", "--version"]
cwd=/workspace/src (exists? true)
cargo 1.88.0 (873a06493 2025-05-10)
SPAWN: argv=["cargo", "clippy", "--version"]
cwd=/workspace/src (exists? true)
clippy 0.1.88 (6b00bc3880 2025-06-23)
SPAWN: argv=["rustc", "--version"]
cwd=/workspace/src (exists? true)
rustc 1.88.0 (6b00bc388 2025-06-23)
SPAWN: argv=["cargo", "fmt", "--check"]
cwd=/workspace/src (exists? true)
[2025-09-25T16:09:18Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-25T16:09:18Z DEBUG ambient_ci::plan] RUN: Action CargoClippy
[2025-09-25T16:09:18Z DEBUG ambient_ci::action] Plan::execute: plan=CargoClippy
[2025-09-25T16:09:18Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_HOME": "/workspace/deps",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
SPAWN: argv=["cargo", "--version"]
cwd=/workspace/src (exists? true)
cargo 1.88.0 (873a06493 2025-05-10)
SPAWN: argv=["cargo", "clippy", "--version"]
cwd=/workspace/src (exists? true)
clippy 0.1.88 (6b00bc3880 2025-06-23)
SPAWN: argv=["rustc", "--version"]
cwd=/workspace/src (exists? true)
rustc 1.88.0 (6b00bc388 2025-06-23)
SPAWN: argv=["cargo", "clippy", "--offline", "--locked", "--workspace", "--all-targets", "--no-deps", "--", "--deny", "warnings"]
cwd=/workspace/src (exists? true)
Checking erased-serde v0.4.6
Checking serde_fmt v1.0.3
Checking radicle-ssh v0.10.0 (/workspace/src/crates/radicle-ssh)
Checking radicle-dag v0.10.0 (/workspace/src/crates/radicle-dag)
Checking anstyle v1.0.6
Checking radicle-signals v0.11.0 (/workspace/src/crates/radicle-signals)
Compiling portable-atomic v1.11.0
Checking anstream v0.6.13
Checking unicode-width v0.2.1
Checking value-bag-serde1 v1.11.1
Checking value-bag v1.11.1
Checking serde-untagged v0.1.7
Checking console v0.16.0
Checking snapbox-macros v0.3.8
Checking log v0.4.27
Checking unit-prefix v0.5.1
Checking snapbox v0.4.17
Checking pin-project-lite v0.2.16
Checking tokio v1.47.1
Checking prodash v29.0.2
Checking git2 v0.19.0
Checking mio v0.8.11
Checking gix-features v0.39.1
Checking mio v1.0.4
Checking gix-object v0.46.1
Checking gix-commitgraph v0.25.1
Checking gix-fs v0.12.1
Checking gix-tempfile v15.0.0
Checking gix-lock v15.0.1
Checking gix-url v0.28.2
Checking gix-revwalk v0.17.0
Checking gix-traverse v0.43.1
Checking gix-revision v0.31.1
Checking gix-diff v0.49.0
Checking gix-refspec v0.27.0
Checking gix-pack v0.56.0
Checking gix-transport v0.44.0
Checking radicle-git-ext v0.8.1
Checking gix-credentials v0.26.0
Checking gix-negotiate v0.17.0
Checking radicle-crypto v0.13.0 (/workspace/src/crates/radicle-crypto)
Checking gix-ref v0.49.1
Checking gix-shallow v0.1.0
Checking signal-hook-mio v0.2.4
Checking radicle-cob v0.16.0 (/workspace/src/crates/radicle-cob)
Checking gix-odb v0.66.0
Checking crossterm v0.25.0
Checking gix-protocol v0.47.0
Checking inquire v0.7.5
Checking indicatif v0.18.0
Checking radicle v0.19.0 (/workspace/src/crates/radicle)
Checking crossterm v0.29.0
Checking systemd-journal-logger v2.2.2
Checking os_info v3.12.0
Compiling radicle-node v0.15.0 (/workspace/src/crates/radicle-node)
Compiling radicle-cli v0.16.0 (/workspace/src/crates/radicle-cli)
Checking radicle-surf v0.22.0
Checking radicle-term v0.15.0 (/workspace/src/crates/radicle-term)
Checking human-panic v2.0.3
Checking radicle-systemd v0.10.0 (/workspace/src/crates/radicle-systemd)
Checking structured-logger v1.0.4
Checking escargot v0.5.10
Checking env_filter v0.1.3
Checking env_logger v0.11.8
Compiling radicle-remote-helper v0.13.0 (/workspace/src/crates/radicle-remote-helper)
Checking test-log v0.2.18
Checking radicle-fetch v0.15.0 (/workspace/src/crates/radicle-fetch)
Checking radicle-cli-test v0.13.0 (/workspace/src/crates/radicle-cli-test)
Checking radicle-protocol v0.3.0 (/workspace/src/crates/radicle-protocol)
Checking radicle-schemars v0.5.0 (/workspace/src/crates/radicle-schemars)
Finished `dev` profile [unoptimized + debuginfo] target(s) in 24.36s
[2025-09-25T16:09:43Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-25T16:09:43Z DEBUG ambient_ci::plan] RUN: Action CargoBuild
[2025-09-25T16:09:43Z DEBUG ambient_ci::action] Plan::execute: plan=CargoBuild
[2025-09-25T16:09:43Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_HOME": "/workspace/deps",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
SPAWN: argv=["cargo", "--version"]
cwd=/workspace/src (exists? true)
cargo 1.88.0 (873a06493 2025-05-10)
SPAWN: argv=["cargo", "clippy", "--version"]
cwd=/workspace/src (exists? true)
clippy 0.1.88 (6b00bc3880 2025-06-23)
SPAWN: argv=["rustc", "--version"]
cwd=/workspace/src (exists? true)
rustc 1.88.0 (6b00bc388 2025-06-23)
SPAWN: argv=["cargo", "build", "--offline", "--locked", "--workspace", "--all-targets"]
cwd=/workspace/src (exists? true)
Compiling erased-serde v0.4.6
Compiling serde_fmt v1.0.3
Compiling radicle-ssh v0.10.0 (/workspace/src/crates/radicle-ssh)
Compiling radicle-dag v0.10.0 (/workspace/src/crates/radicle-dag)
Compiling anstyle v1.0.6
Compiling radicle-signals v0.11.0 (/workspace/src/crates/radicle-signals)
Compiling unicode-width v0.2.1
Compiling anstream v0.6.13
Compiling portable-atomic v1.11.0
Compiling value-bag-serde1 v1.11.1
Compiling value-bag v1.11.1
Compiling serde-untagged v0.1.7
Compiling snapbox-macros v0.3.8
Compiling console v0.16.0
Compiling unit-prefix v0.5.1
Compiling snapbox v0.4.17
Compiling log v0.4.27
Compiling indicatif v0.18.0
Compiling pin-project-lite v0.2.16
Compiling prodash v29.0.2
Compiling git2 v0.19.0
Compiling gix-features v0.39.1
Compiling mio v1.0.4
Compiling mio v0.8.11
Compiling gix-object v0.46.1
Compiling gix-commitgraph v0.25.1
Compiling gix-fs v0.12.1
Compiling gix-tempfile v15.0.0
Compiling gix-url v0.28.2
Compiling gix-lock v15.0.1
Compiling gix-revwalk v0.17.0
Compiling gix-diff v0.49.0
Compiling gix-revision v0.31.1
Compiling gix-traverse v0.43.1
Compiling radicle-git-ext v0.8.1
Compiling gix-pack v0.56.0
Compiling radicle-crypto v0.13.0 (/workspace/src/crates/radicle-crypto)
Compiling gix-refspec v0.27.0
Compiling radicle-cob v0.16.0 (/workspace/src/crates/radicle-cob)
Compiling gix-negotiate v0.17.0
Compiling gix-ref v0.49.1
Compiling gix-shallow v0.1.0
Compiling radicle v0.19.0 (/workspace/src/crates/radicle)
Compiling gix-credentials v0.26.0
Compiling gix-transport v0.44.0
Compiling signal-hook-mio v0.2.4
Compiling gix-odb v0.66.0
Compiling crossterm v0.25.0
Compiling gix-protocol v0.47.0
Compiling inquire v0.7.5
Compiling crossterm v0.29.0
Compiling systemd-journal-logger v2.2.2
Compiling tokio v1.47.1
Compiling os_info v3.12.0
Compiling radicle-cli v0.16.0 (/workspace/src/crates/radicle-cli)
Compiling radicle-node v0.15.0 (/workspace/src/crates/radicle-node)
Compiling radicle-surf v0.22.0
Compiling radicle-term v0.15.0 (/workspace/src/crates/radicle-term)
Compiling structured-logger v1.0.4
Compiling human-panic v2.0.3
Compiling radicle-systemd v0.10.0 (/workspace/src/crates/radicle-systemd)
Compiling escargot v0.5.10
Compiling env_filter v0.1.3
Compiling env_logger v0.11.8
Compiling radicle-remote-helper v0.13.0 (/workspace/src/crates/radicle-remote-helper)
Compiling test-log v0.2.18
Compiling radicle-fetch v0.15.0 (/workspace/src/crates/radicle-fetch)
Compiling radicle-protocol v0.3.0 (/workspace/src/crates/radicle-protocol)
Compiling radicle-cli-test v0.13.0 (/workspace/src/crates/radicle-cli-test)
Compiling radicle-schemars v0.5.0 (/workspace/src/crates/radicle-schemars)
Finished `dev` profile [unoptimized + debuginfo] target(s) in 1m 06s
[2025-09-25T16:10:50Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-25T16:10:50Z DEBUG ambient_ci::plan] RUN: Action CargoTest
[2025-09-25T16:10:50Z DEBUG ambient_ci::action] Plan::execute: plan=CargoTest
[2025-09-25T16:10:50Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_HOME": "/workspace/deps",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
SPAWN: argv=["cargo", "--version"]
cwd=/workspace/src (exists? true)
cargo 1.88.0 (873a06493 2025-05-10)
SPAWN: argv=["cargo", "clippy", "--version"]
cwd=/workspace/src (exists? true)
clippy 0.1.88 (6b00bc3880 2025-06-23)
SPAWN: argv=["rustc", "--version"]
cwd=/workspace/src (exists? true)
rustc 1.88.0 (6b00bc388 2025-06-23)
SPAWN: argv=["cargo", "test", "--offline", "--locked", "--workspace"]
cwd=/workspace/src (exists? true)
Finished `test` profile [unoptimized + debuginfo] target(s) in 0.39s
Running unittests src/lib.rs (/workspace/cache/debug/deps/radicle-f412a4d7b87c45b5)
running 238 tests
test canonical::formatter::test::securesystemslib_asserts ... ok
test canonical::formatter::test::ascii_control_characters ... ok
test canonical::formatter::test::ordered_nested_object ... ok
test cob::cache::migrations::_2::tests::test_patch_json_deserialization ... ok
test cob::cache::tests::test_check_version ... ok
test cob::cache::migrations::_2::tests::test_migration_2 ... ok
test cob::cache::tests::test_migrate_to ... ok
test cob::common::test::test_color ... ok
test cob::common::test::test_emojis ... ok
test cob::common::test::test_title ... 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_remove_delegate_concurrent ... ok
test cob::identity::test::test_identity_updates ... ok
test cob::identity::test::test_identity_update_rejected ... 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_cob ... ok
test cob::issue::test::test_concurrency ... ok
test cob::issue::test::test_invalid_tx_reference ... ok
test cob::issue::test::test_invalid_tx ... ok
test cob::issue::test::test_issue_all ... ok
test cob::issue::test::test_issue_create_and_assign ... ok
test cob::issue::test::test_issue_comment ... 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::patch::cache::tests::test_get ... ok
test cob::patch::cache::tests::test_is_empty ... ok
test cob::issue::test::test_issue_reply ... ok
test cob::patch::cache::tests::test_list_by_status ... ok
test cob::patch::cache::tests::test_list ... 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::test::test_patch_create_and_get ... ok
test cob::patch::test::test_patch_discussion ... ok
test cob::patch::cache::tests::test_remove ... 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_edit_comment ... ok
test cob::patch::test::test_patch_review_remove_summary ... 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::stream::tests::test_all_from ... ok
test cob::patch::test::test_patch_review_revision_redact ... ok
test cob::stream::tests::test_all_from_until ... ok
test cob::stream::tests::test_all_until ... ok
test cob::stream::tests::test_regression_from_until ... ok
test cob::stream::tests::test_from_until ... 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::quorum::test::merge_base_commutative ... ok
test git::canonical::quorum::test::test_merge_bases ... ok
test cob::patch::test::test_patch_update ... 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 git::canonical::rules::tests::test_canonical ... ok
test git::canonical::rules::tests::test_rule_validate_success ... ok
test git::canonical::rules::tests::test_special_branches ... ok
test git::canonical::tests::test_commit_quorum_fork_of_a_fork ... ok
test git::canonical::tests::test_commit_quorum_forked_merge_commits ... ok
test git::canonical::tests::test_commit_quorum_groups ... ok
test git::canonical::tests::test_commit_quorum_linear ... ok
test git::canonical::tests::test_commit_quorum_merges ... ok
test git::canonical::tests::test_commit_quorum_single ... ok
test git::canonical::tests::test_commit_quorum_three_way_fork ... ok
test git::canonical::tests::test_commit_quorum_two_way_fork ... ok
test git::canonical::tests::test_quorum_different_types ... ok
test cob::patch::cache::tests::test_find_by_revision ... ok
test git::canonical::tests::test_tag_quorum ... 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::rules::tests::test_rule_validate_failures ... 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 identity::doc::test::test_max_delegates ... ok
test identity::doc::test::test_not_found ... 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 git::canonical::tests::test_quorum_properties ... 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::config::test::partial ... 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 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::address::store::test::test_empty ... ok
test node::policy::store::test::test_node_aliases ... ok
test node::policy::store::test::test_node_policies ... ok
test node::policy::store::test::test_node_policy ... ok
test node::policy::store::test::test_repo_policies ... ok
test node::policy::store::test::test_repo_policy ... ok
test node::policy::store::test::test_seed_and_unseed_repo ... ok
test node::policy::store::test::test_update_scope ... ok
test node::policy::store::test::test_update_alias ... ok
test node::refs::store::test::test_count ... ok
test node::refs::store::test::test_set_and_get ... ok
test node::refs::store::test::test_set_and_delete ... ok
test node::routing::test::test_count ... ok
test node::routing::test::test_entries ... ok
test node::routing::test::test_insert_and_get ... ok
test node::routing::test::test_insert_and_remove ... ok
test node::routing::test::test_insert_and_get_resources ... ok
test node::routing::test::test_insert_duplicate ... ok
test node::routing::test::test_insert_existing_updated_time ... 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::cannot_construct_announcer ... 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::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::synced_with_same_node_multiple_times ... ok
test node::sync::announce::test::timed_out_after_reaching_success ... ok
test node::sync::fetch::test::all_nodes_are_candidates ... ok
test node::sync::fetch::test::all_nodes_are_fetchable ... ok
test node::sync::fetch::test::could_not_reach_target ... ok
test node::sync::fetch::test::ignores_duplicates_and_local_node ... ok
test node::sync::fetch::test::preferred_seeds_target_returned_over_replicas ... ok
test node::sync::fetch::test::reaches_target_of_max_replicas ... 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::sync::fetch::test::reaches_target_of_replicas ... ok
test node::test::test_user_agent ... ok
test node::timestamp::tests::test_timestamp_max ... ok
test profile::test::canonicalize_home ... ok
test profile::test::test_config ... ok
test cob::thread::tests::prop_ordering ... ok
test rad::tests::test_checkout ... ok
test rad::tests::test_fork ... ok
test rad::tests::test_init ... 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 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. 238 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 4.25s
Running unittests src/lib.rs (/workspace/cache/debug/deps/radicle_cli-1940553710e3dbe5)
running 14 tests
test commands::patch::review::builder::tests::test_review_comments_multiline ... ok
test commands::patch::review::builder::tests::test_review_comments_basic ... ok
test commands::inspect::test::test_tree ... ok
test commands::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 commands::patch::review::builder::tests::test_review_comments_before ... ok
test terminal::patch::test::test_create_display_message ... ok
test terminal::patch::test::test_update_display_message ... ok
test result: ok. 13 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out; finished in 0.02s
Running unittests src/main.rs (/workspace/cache/debug/deps/rad-f4b8d3d317a00168)
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-2b1390b62c18490c)
running 104 tests
test framework_home ... ok
test git_push_and_fetch ... ok
test git_push_canonical_lightweight_tags ... FAILED
test git_push_amend ... ok
test git_push_canonical_annotated_tags ... ok
test git_push_diverge ... ok
test git_push_rollback ... ok
test rad_auth_errors ... ok
test git_tag ... ok
test rad_block ... ok
test rad_auth ... ok
test rad_checkout ... ok
test rad_clone ... ok
test git_push_converge ... ok
test rad_clean ... ok
test rad_clone_all ... ok
test rad_clone_bare ... ok
test rad_clone_unknown ... ok
test rad_clone_connect ... ok
test rad_clone_directory ... ok
test rad_cob_log ... ok
test rad_cob_migrate ... ok
test rad_cob_multiset ... ok
test rad_cob_operations ... ok
test rad_clone_partial_fail ... ok
test rad_cob_show ... ok
test rad_cob_update ... ok
test rad_cob_update_identity ... ok
test rad_config ... ok
test rad_diff ... ok
test rad_id_collaboration ... ignored, slow
test rad_id ... ok
test rad_id_conflict ... ok
test rad_id_private ... ok
test rad_fork ... ok
test rad_fetch ... ok
test rad_id_multi_delegate ... ok
test rad_id_threshold ... ok
test rad_id_unknown_field ... ok
test rad_init ... ignored, part of many other tests
test rad_id_update_delete_field ... ok
test rad_init_detached_head ... ok
test rad_init_bare ... ok
test rad_id_threshold_soft_fork ... ok
test rad_init_existing ... ok
test rad_init_existing_bare ... ok
test rad_init_no_git ... ok
test rad_init_no_seed ... ok
test rad_init_private ... ok
test rad_init_private_no_seed ... ok
test rad_init_private_clone ... ok
test rad_inbox ... ok
test rad_init_private_clone_seed ... ok
test rad_init_private_seed ... ok
test rad_init_sync_not_connected ... 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_init_sync_timeout ... ok
test rad_node_connect_without_address ... ok
test rad_patch_ahead_behind ... ok
test rad_patch ... ok
test rad_patch_change_base ... ok
test rad_patch_checkout ... ok
test rad_patch_detached_head ... ok
test rad_patch_checkout_revision ... 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 ... FAILED
test rad_patch_merge_draft ... ok
test rad_patch_fetch_1 ... ok
test rad_patch_revert_merge ... ok
test rad_patch_delete ... ok
test rad_patch_update ... ok
test rad_patch_via_push ... FAILED
test rad_patch_open_explore ... ok
test rad_publish ... 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_seed_many ... ok
test rad_self ... ok
test rad_push_and_pull_patches ... ok
test rad_unseed ... ok
test rad_unseed_many ... ok
test rad_sync_without_node ... ok
test rad_warn_old_nodes ... 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_push_canonical_lightweight_tags stdout ----
1758816700 [36mtest:[0m [36mUsing PATH ["/workspace/cache/debug", "/workspace/deps/bin", "/root/.cargo/bin", "/usr/local/sbin", "/usr/local/bin", "/usr/sbin", "/usr/bin", "/sbin", "/bin", "/tmp/radicle-hg2Xri/work/alice"][0m
1758816700 [36mtest:[0m [36mrad-init.md: Running `/workspace/cache/debug/rad` with ["init", "--name", "heartwood", "--description", "Radicle Heartwood Protocol & Stack", "--no-confirm", "--public", "-v"] in `/tmp/radicle-hg2Xri/work/alice`..[0m
1758816701 [36mtest:[0m [36mrad-init.md: Running `/workspace/cache/debug/rad` with ["init"] in `/tmp/radicle-hg2Xri/work/alice`..[0m
1758816701 [36mtest:[0m [36mrad-init.md: Running `/workspace/cache/debug/rad` with ["ls"] in `/tmp/radicle-hg2Xri/work/alice`..[0m
1758816701 [36mtest:[0m [36mrad-init.md: Running `/workspace/cache/debug/rad` with ["node", "inventory"] in `/tmp/radicle-hg2Xri/work/alice`..[0m
[2m1758816701 git_push_canonical_lightweight_tags node: Opening policy database..[0m
[2m1758816701 git_push_canonical_lightweight_tags node: Default seeding policy set to 'block (all)'[0m
[2m1758816701 git_push_canonical_lightweight_tags node: Initializing service (Test)..[0m
[2m1758816701 git_push_canonical_lightweight_tags node: Opening node database..[0m
[2m1758816701 git_push_canonical_lightweight_tags node: Address book is empty. Adding bootstrap nodes..[0m
[2m1758816701 git_push_canonical_lightweight_tags node: 0 nodes added to address book[0m
[2m1758816701 git_push_canonical_lightweight_tags service: Init @1758816701231[0m
[2m1758816701 git_push_canonical_lightweight_tags service: Empty refs database, populating from storage..[0m
[2m1758816701 git_push_canonical_lightweight_tags service: Saved local sync status for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji..[0m
[2m1758816701 git_push_canonical_lightweight_tags service: Adding refs announcement for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji to historical gossip messages..[0m
[2m1758816701 git_push_canonical_lightweight_tags service: Not enough available peers to connect to (available=0, wanted=8)[0m
[2m1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> node: Listening on 0.0.0.0:38471..[0m
[2m1758816701 git_push_canonical_lightweight_tags node: Binding control socket /tmp/radicle-hg2Xri/home/alice/.radicle/node/control.sock..[0m
[2m1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <runtime> node: Running node z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi in /tmp/radicle-hg2Xri/home/alice/.radicle..[0m
[2m1758816701 git_push_canonical_lightweight_tags node: Opening policy database..[0m
[2m1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <control> control: Control thread listening on socket..[0m
[33m1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <signals> node: Signal notifications channel error: receiving on an empty and disconnected channel[0m
[2m1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Received command QueryState(..)[0m
[2m1758816701 git_push_canonical_lightweight_tags node: Default seeding policy set to 'block (all)'[0m
[2m1758816701 git_push_canonical_lightweight_tags node: Initializing service (Test)..[0m
[2m1758816701 git_push_canonical_lightweight_tags node: Opening node database..[0m
[2m1758816701 git_push_canonical_lightweight_tags node: Address book is empty. Adding bootstrap nodes..[0m
[2m1758816701 git_push_canonical_lightweight_tags node: 0 nodes added to address book[0m
[2m1758816701 git_push_canonical_lightweight_tags service: Init @1758816701484[0m
[2m1758816701 git_push_canonical_lightweight_tags service: Empty refs database, populating from storage..[0m
[2m1758816701 git_push_canonical_lightweight_tags service: Not enough available peers to connect to (available=0, wanted=8)[0m
[2m1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> node: Listening on 0.0.0.0:36157..[0m
[2m1758816701 git_push_canonical_lightweight_tags node: Binding control socket /tmp/radicle-hg2Xri/home/bob/.radicle/node/control.sock..[0m
[2m1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <runtime> node: Running node z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk in /tmp/radicle-hg2Xri/home/bob/.radicle..[0m
[2m1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control> control: Control thread listening on socket..[0m
[2m1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received command QueryState(..)[0m
[33m1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <signals> node: Signal notifications channel error: receiving on an empty and disconnected channel[0m
[2m1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received command QueryState(..)[0m
[2m1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received command Connect(z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi, 0.0.0.0:38471, ConnectOptions { persistent: false, timeout: 30s })[0m
[2m1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Connecting to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (0.0.0.0:38471)..[0m
[2m1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Attempted connection to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (0.0.0.0:38471)[0m
[2m1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Inbound connection from 127.0.0.1:53428 (fd=183)..[0m
[2m1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> wire: Registering outbound transport for z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (fd=182)..[0m
[2m1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> wire: Outbound peer resource registered for z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi with id=2 (fd=182)[0m
[2m1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Accepted inbound connection from 127.0.0.1:53428 (fd=183)..[0m
[2m1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Inbound peer resource registered with id=2 (fd=183)[0m
[2m1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> wire: Session established with z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (id=2) (fd=182) (outbound)[0m
[2m1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Connected to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (0.0.0.0:38471) (Outbound)[0m
[2m1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Subscribing to messages since timestamp 1758730301685..[0m
[2m1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Session established with z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk (id=2) (fd=183) (inbound)[0m
[2m1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Connected to z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk (127.0.0.1:53428) (Inbound)[0m
[2m1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Subscribing to messages since timestamp 1758730301685..[0m
1758816701 [36mtest:[0m [36mNode z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi has converged[0m
1758816701 [36mtest:[0m [36mNode has missing routes: [(RepoId(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji), PublicKey(z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi))][0m
[2m1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received node announcement of z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi with 0 address(es) from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (t=1758816701231)[0m
[2m1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Received node announcement of z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk with 0 address(es) from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk (t=1758816701484)[0m
[2m1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Stored announcement from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk to be broadcast in 0 millisecond(s) (t=1758816701484)[0m
[2m1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Stored announcement from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi to be broadcast in 0 millisecond(s) (t=1758816701231)[0m
[2m1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Address store entry for node z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk updated at 1758816701484[0m
[2m1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Address store entry for node z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi updated at 1758816701231[0m
[2m1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Received inventory announcement of z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk with 0 item(s) from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk (t=1758816701485)[0m
[2m1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received inventory announcement of z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi with 1 item(s) from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (t=1758816701233)[0m
[2m1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Stored announcement from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi to be broadcast in 0 millisecond(s) (t=1758816701233)[0m
[2m1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Stored announcement from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk to be broadcast in 0 millisecond(s) (t=1758816701485)[0m
[2m1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Received subscription filter from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk[0m
[2m1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Routing table updated for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji with seed z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi[0m
[2m1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received subscription filter from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi[0m
1758816701 [36mtest:[0m [36mNode z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk has converged[0m
1758816701 [36mtest:[0m [36mRunning `rad clone ["rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji"]` in /tmp/radicle-hg2Xri/work/bob..[0m
[2m1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control> control: Received `{"command":"status"}` on control socket[0m
[2m1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control> control: Received `{"command":"seed","rid":"rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji","scope":"all"}` on control socket[0m
[2m1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received command Seed(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji, all)[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Sending subscription filter to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi[0m
[2m1758816702 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Received subscription filter from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control> control: Received `{"command":"seeds","rid":"rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji"}` on control socket[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received command Seeds(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji)[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Found 1 connected seed(s) and 0 disconnected seed(s) for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control> control: Received `{"command":"session","nid":"z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi"}` on control socket[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received command QueryState(..)[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control> control: Received `{"command":"fetch","rid":"rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji","nid":"z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi","timeout":{"secs":9,"nanos":0}}` on control socket[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received command Fetch(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji, z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi)[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Fetch initiated for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji with z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi [outbound connected] (all remotes)..[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> wire: Opened new stream with id 12 for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji and remote z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> worker: Worker processing outgoing fetch for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji[0m
[2m1758816702 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Received `open` command for stream 12 from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk[0m
[2m1758816702 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <worker#0> worker: Worker processing incoming fetch for z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk on stream 12..[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> worker: z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk cloning from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi[0m
[2m1758816702 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <worker#0> worker: Spawning upload-pack process for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji on stream 12..[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> fetch: Fetched rad/id (17ms)[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> fetch: Fetched data for 1 remote(s) (38ms)[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> fetch: Fetched data refs for 1 remotes (51ms)[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> fetch: Sent done signal to remote z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi[0m
[2m1758816702 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Received `end-of-file` on stream 12 from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk[0m
[2m1758816702 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <upload-pack> worker: Exiting upload-pack reader thread for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji[0m
[2m1758816702 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <worker#0> worker: Upload pack finished (60ms)[0m
[2m1758816702 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <worker#0> worker: Upload process on stream 12 exited with result Ok(())[0m
[2m1758816702 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Received fetch result from worker for stream 12, remote z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk: Responder { rid: Some(RepoId(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji)), result: Ok(()) }[0m
[2m1758816702 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Stream 12 of z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk closing with 0 byte(s) sent and 0 byte(s) received[0m
[2m1758816702 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Peer z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk fetched rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji from us successfully[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> wire: Received `close` command for stream 12 from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> fetch: Validated 1 remote(s) (53ms)[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> wire: Stream 12 of z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi closed with 0 byte(s) sent and 0 byte(s) received[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> fetch: Applied updates (55ms)[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> fetch: Finished clone of rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (64ms)[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> cob: Loading object of type xyz.radicle.id at 0656c217f917c3e06234771e9ecae53aba5e173e[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> storage: Setting ref: refs/rad/id -> 0656c217f917c3e06234771e9ecae53aba5e173e[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> storage: Setting ref: refs/heads/master -> f2de534b5e81d7c6e2dcaf58c3dd91573c0a0354[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> storage: Setting ref: HEAD -> refs/heads/master[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> cob: Loading object of type xyz.radicle.id at 0656c217f917c3e06234771e9ecae53aba5e173e[0m
[2m1758816702 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) }], canonical: UpdatedCanonicalRefs { inner: {Qualified(RefString("refs/heads/master")): Oid(f2de534b5e81d7c6e2dcaf58c3dd91573c0a0354)} }, 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 } } }) }[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Found existing fetch request from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi, sending result..[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Sent fetch result for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi..[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Fetched rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi successfully[0m
1758816702 [36mtest:[0m [36mrad clone: ✓ Seeding policy updated for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji with scope 'all'[0m
1758816702 [36mtest:[0m [36mrad clone: Fetching rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji from the network, found 1 potential seed(s).[0m
1758816702 [36mtest:[0m [36mrad clone: ✓ Target met: 1 seed(s)[0m
1758816702 [36mtest:[0m [36mrad clone: ✓ Creating checkout in ./heartwood..[0m
1758816702 [36mtest:[0m [36mrad clone: ✓ Remote alice@z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi added[0m
1758816702 [36mtest:[0m [36mrad clone: ✓ Remote-tracking branch alice@z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/master created for z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi[0m
1758816702 [36mtest:[0m [36mrad clone: ✓ Repository successfully cloned under /tmp/radicle-hg2Xri/work/bob/heartwood/[0m
1758816702 [36mtest:[0m [36mrad clone: ╭────────────────────────────────────╮[0m
1758816702 [36mtest:[0m [36mrad clone: │ heartwood │[0m
1758816702 [36mtest:[0m [36mrad clone: │ Radicle Heartwood Protocol & Stack │[0m
1758816702 [36mtest:[0m [36mrad clone: │ 0 issues · 0 patches │[0m
1758816702 [36mtest:[0m [36mrad clone: ╰────────────────────────────────────╯[0m
1758816702 [36mtest:[0m [36mrad clone: Run `cd ./heartwood` to go to the repository directory.[0m
1758816702 [36mtest:[0m [36mRan command `rad clone` (status=0)[0m
1758816702 [36mtest:[0m [36mUsing PATH ["/workspace/cache/debug", "/workspace/deps/bin", "/root/.cargo/bin", "/usr/local/sbin", "/usr/local/bin", "/usr/sbin", "/usr/bin", "/sbin", "/bin", "/tmp/radicle-hg2Xri"][0m
1758816702 [36mtest:[0m [36mgit-push-canonical-lightweight-tags.md: Running `/workspace/cache/debug/rad` with ["id", "update", "--title", "Add canonical reference rules", "--payload", "xyz.radicle.crefs", "rules", "{ \"refs/tags/*\": { \"threshold\": 1, \"allow\": \"delegates\" }, \"refs/tags/qa/*\": { \"threshold\": 1, \"allow\": \"delegates\" }}"] in `/tmp/radicle-hg2Xri/work/alice`..[0m
1758816702 [36mtest:[0m [36mgit-push-canonical-lightweight-tags.md: Running `git` with ["tag", "v1.0-hotfix"] in `/tmp/radicle-hg2Xri/work/alice`..[0m
1758816702 [36mtest:[0m [36mgit-push-canonical-lightweight-tags.md: Running `git` with ["push", "rad", "--tags"] in `/tmp/radicle-hg2Xri/work/alice`..[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Ref updated: * 0000000..0656c21 refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/rad/id for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Ref updated: * 0000000..99c5497 refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/rad/sigrefs for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Ref updated: * 0000000..0656c21 refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/cobs/xyz.radicle.id/0656c217f917c3e06234771e9ecae53aba5e173e for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Ref updated: * 0000000..f2de534 refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/heads/master for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Ref updated: * 0000000..0656c21 refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/rad/root for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Updating and announcing inventory for cloned repository rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji..[0m
[2m1758816702 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <control> control: Received `{"command":"status"}` on control socket[0m
[2m1758816702 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <control> control: Received `{"command":"seeds","rid":"rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji"}` on control socket[0m
[2m1758816702 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Received command Seeds(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji)[0m
[2m1758816702 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Found 0 connected seed(s) and 1 disconnected seed(s) for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji[0m
thread 'git_push_canonical_lightweight_tags' panicked at crates/radicle-cli-test/src/lib.rs:489:36:
--- Expected
++++ actual: stderr
1 1 | ✓ Canonical reference refs/tags/v1.0-hotfix updated to target commit f2de534b5e81d7c6e2dcaf58c3dd91573c0a0354
2 - ✓ Synced with 1 seed(s)
2 + No seeds found for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji.
3 3 | To rad://z42hL2jL4XNk6K8oHQaSWfMgCL7ji/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
4 4 | * [new tag] v1.0-hotfix -> v1.0-hotfix
Exit status: 0
note: run with `RUST_BACKTRACE=1` environment variable to display a backtrace
1758816702 [36mtest:[0m [36mNode z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk shutting down..[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control> control: Received `{"command":"shutdown"}` on control socket[0m
[2m1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control> control: Shutdown requested..[0m
[2m1758816703 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Sending inventory announcement of z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk with 1 item(s) to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (t=1758816702454)[0m
[2m1758816703 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Sending refs announcement of z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji with 1 remote(s) to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (t=1758816702455)[0m
[2m1758816703 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Disconnecting peer with id=2: connection reset[0m
[2m1758816703 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Transport handover for disconnecting peer with id=2 (fd=183)[0m
[2m1758816703 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Disconnected from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk (connection reset)[0m
[2m1758816703 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Dropping peer z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk..[0m
[2m1758816703 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <runtime> pool: Worker pool shutting down..[0m
[2m1758816703 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <runtime> node: Node shutdown completed for z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk[0m
1758816703 [36mtest:[0m [36mNode z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi shutting down..[0m
[2m1758816703 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <control> control: Received `{"command":"shutdown"}` on control socket[0m
[2m1758816703 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <control> control: Shutdown requested..[0m
[2m1758816703 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <runtime> pool: Worker pool shutting down..[0m
[2m1758816703 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <runtime> node: Node shutdown completed for z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi[0m
---- rad_patch_fetch_2 stdout ----
1758816751 [36mtest:[0m [36mUsing PATH ["/workspace/cache/debug", "/workspace/deps/bin", "/root/.cargo/bin", "/usr/local/sbin", "/usr/local/bin", "/usr/sbin", "/usr/bin", "/sbin", "/bin", "/tmp/radicle-pKhn1U/work/alice"][0m
1758816751 [36mtest:[0m [36mrad-init.md: Running `/workspace/cache/debug/rad` with ["init", "--name", "heartwood", "--description", "Radicle Heartwood Protocol & Stack", "--no-confirm", "--public", "-v"] in `/tmp/radicle-pKhn1U/work/alice`..[0m
1758816751 [36mtest:[0m [36mrad-init.md: Running `/workspace/cache/debug/rad` with ["init"] in `/tmp/radicle-pKhn1U/work/alice`..[0m
1758816751 [36mtest:[0m [36mrad-init.md: Running `/workspace/cache/debug/rad` with ["ls"] in `/tmp/radicle-pKhn1U/work/alice`..[0m
1758816751 [36mtest:[0m [36mrad-init.md: Running `/workspace/cache/debug/rad` with ["node", "inventory"] in `/tmp/radicle-pKhn1U/work/alice`..[0m
1758816751 [36mtest:[0m [36mUsing PATH ["/workspace/cache/debug", "/workspace/deps/bin", "/root/.cargo/bin", "/usr/local/sbin", "/usr/local/bin", "/usr/sbin", "/usr/bin", "/sbin", "/bin", "/tmp/radicle-pKhn1U/work/alice"][0m
1758816751 [36mtest:[0m [36mrad-patch-fetch-2.md: Running `git` with ["checkout", "-b", "alice/1", "-q"] in `/tmp/radicle-pKhn1U/work/alice`..[0m
1758816751 [36mtest:[0m [36mrad-patch-fetch-2.md: Running `git` with ["commit", "--allow-empty", "-m", "Changes #1", "-q"] in `/tmp/radicle-pKhn1U/work/alice`..[0m
1758816751 [36mtest:[0m [36mrad-patch-fetch-2.md: Running `git` with ["push", "rad", "-o", "patch.message=Changes", "HEAD:refs/patches"] in `/tmp/radicle-pKhn1U/work/alice`..[0m
1758816752 [36mtest:[0m [36mrad-patch-fetch-2.md: Running `git` with ["checkout", "master", "-q"] in `/tmp/radicle-pKhn1U/work/alice`..[0m
1758816752 [36mtest:[0m [36mrad-patch-fetch-2.md: Running `git` with ["branch", "-D", "alice/1", "-q"] in `/tmp/radicle-pKhn1U/work/alice`..[0m
1758816752 [36mtest:[0m [36mrad-patch-fetch-2.md: Running `git` with ["update-ref", "-d", "refs/remotes/rad/alice/1"] in `/tmp/radicle-pKhn1U/work/alice`..[0m
1758816752 [36mtest:[0m [36mrad-patch-fetch-2.md: Running `git` with ["update-ref", "-d", "refs/remotes/rad/patches/5e2dedcc5d515fcbc1cca483d3376609fe889bfb"] in `/tmp/radicle-pKhn1U/work/alice`..[0m
1758816752 [36mtest:[0m [36mrad-patch-fetch-2.md: Running `git` with ["gc", "--prune=now"] in `/tmp/radicle-pKhn1U/work/alice`..[0m
1758816752 [36mtest:[0m [36mrad-patch-fetch-2.md: Running `git` with ["branch", "-r"] in `/tmp/radicle-pKhn1U/work/alice`..[0m
1758816752 [36mtest:[0m [36mrad-patch-fetch-2.md: Running `git` with ["pull"] in `/tmp/radicle-pKhn1U/work/alice`..[0m
1758816752 [36mtest:[0m [36mrad-patch-fetch-2.md: Running `git` with ["branch", "-r"] in `/tmp/radicle-pKhn1U/work/alice`..[0m
thread 'rad_patch_fetch_2' panicked at crates/radicle-cli-test/src/lib.rs:491:36:
--- Expected
++++ actual: stdout
1 - rad/HEAD -> rad/master
2 1 | rad/master
3 2 | rad/patches/5e2dedcc5d515fcbc1cca483d3376609fe889bfb
Exit status: 0
---- rad_patch_via_push stdout ----
1758816755 [36mtest:[0m [36mUsing PATH ["/workspace/cache/debug", "/workspace/deps/bin", "/root/.cargo/bin", "/usr/local/sbin", "/usr/local/bin", "/usr/sbin", "/usr/bin", "/sbin", "/bin", "/tmp/radicle-Tr8UKL/work/alice"][0m
1758816755 [36mtest:[0m [36mrad-init.md: Running `/workspace/cache/debug/rad` with ["init", "--name", "heartwood", "--description", "Radicle Heartwood Protocol & Stack", "--no-confirm", "--public", "-v"] in `/tmp/radicle-Tr8UKL/work/alice`..[0m
1758816756 [36mtest:[0m [36mrad-init.md: Running `/workspace/cache/debug/rad` with ["init"] in `/tmp/radicle-Tr8UKL/work/alice`..[0m
1758816756 [36mtest:[0m [36mrad-init.md: Running `/workspace/cache/debug/rad` with ["ls"] in `/tmp/radicle-Tr8UKL/work/alice`..[0m
1758816756 [36mtest:[0m [36mrad-init.md: Running `/workspace/cache/debug/rad` with ["node", "inventory"] in `/tmp/radicle-Tr8UKL/work/alice`..[0m
1758816756 [36mtest:[0m [36mUsing PATH ["/workspace/cache/debug", "/workspace/deps/bin", "/root/.cargo/bin", "/usr/local/sbin", "/usr/local/bin", "/usr/sbin", "/usr/bin", "/sbin", "/bin", "/tmp/radicle-Tr8UKL/work/alice"][0m
1758816756 [36mtest:[0m [36mrad-patch-via-push.md: Running `git` with ["checkout", "-b", "feature/1"] in `/tmp/radicle-Tr8UKL/work/alice`..[0m
1758816756 [36mtest:[0m [36mrad-patch-via-push.md: Running `git` with ["commit", "-a", "-m", "Add things", "-q", "--allow-empty"] in `/tmp/radicle-Tr8UKL/work/alice`..[0m
1758816756 [36mtest:[0m [36mrad-patch-via-push.md: Running `git` with ["push", "-o", "patch.message=Add things #1", "-o", "patch.message=See commits for details.", "rad", "HEAD:refs/patches"] in `/tmp/radicle-Tr8UKL/work/alice`..[0m
1758816756 [36mtest:[0m [36mrad-patch-via-push.md: Running `/workspace/cache/debug/rad` with ["patch", "show", "6035d2f582afbe01ff23ea87528ae523d76875b6"] in `/tmp/radicle-Tr8UKL/work/alice`..[0m
1758816756 [36mtest:[0m [36mrad-patch-via-push.md: Running `git` with ["branch", "-vv"] in `/tmp/radicle-Tr8UKL/work/alice`..[0m
1758816756 [36mtest:[0m [36mrad-patch-via-push.md: Running `git` with ["status", "--short", "--branch"] in `/tmp/radicle-Tr8UKL/work/alice`..[0m
1758816756 [36mtest:[0m [36mrad-patch-via-push.md: Running `git` with ["fetch"] in `/tmp/radicle-Tr8UKL/work/alice`..[0m
1758816756 [36mtest:[0m [36mrad-patch-via-push.md: Running `git` with ["push"] in `/tmp/radicle-Tr8UKL/work/alice`..[0m
1758816756 [36mtest:[0m [36mrad-patch-via-push.md: Running `git` with ["show-ref"] in `/tmp/radicle-Tr8UKL/work/alice`..[0m
thread 'rad_patch_via_push' panicked at crates/radicle-cli-test/src/lib.rs:491:36:
--- Expected
++++ actual: stdout
1 1 | 42d894a83c9c356552a57af09ccdbd5587a99045 refs/heads/feature/1
2 2 | f2de534b5e81d7c6e2dcaf58c3dd91573c0a0354 refs/heads/master
3 - f2de534b5e81d7c6e2dcaf58c3dd91573c0a0354 refs/remotes/rad/HEAD
4 3 | f2de534b5e81d7c6e2dcaf58c3dd91573c0a0354 refs/remotes/rad/master
5 4 | 42d894a83c9c356552a57af09ccdbd5587a99045 refs/remotes/rad/patches/6035d2f582afbe01ff23ea87528ae523d76875b6
Exit status: 0
failures:
git_push_canonical_lightweight_tags
rad_patch_fetch_2
rad_patch_via_push
test result: FAILED. 99 passed; 3 failed; 2 ignored; 0 measured; 0 filtered out; finished in 121.40s
error: test failed, to rerun pass `-p radicle-cli --test commands`
[2025-09-25T16:12:57Z ERROR ambient_ci::plan] ERROR: Action failed: failed to execute cargo
[2025-09-25T16:12:57Z ERROR ambient_ci::plan] caused by: command failed: "cargo": exit code 101
ERROR: failed to execute cargo
caused by: command failed: "cargo": exit code 101
EXIT CODE: 1
[2025-09-25T16:13:01Z INFO ambient] ambient ends successfully
{
"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": "Updated",
"patch": {
"id": "ed450c98018617be362fcb51c50a2a0f4c66ef69",
"author": {
"id": "did:key:z6MkkPvBfjP4bQmco5Dm7UGsX2ruDBieEHi8n9DVJWX5sTEz",
"alias": "lorenz"
},
"title": "node: Make location of secret key configurable",
"state": {
"status": "open",
"conflicts": []
},
"before": "ed8b086045ee5d7bd1327f579de7861a1cf49e3b",
"after": "cca3454defb46f697ab409093e4273074fcd6364",
"commits": [
"cca3454defb46f697ab409093e4273074fcd6364",
"75841c4dfecdfbc1cab67275fec4132d7182fe5d"
],
"target": "ed8b086045ee5d7bd1327f579de7861a1cf49e3b",
"labels": [],
"assignees": [],
"revisions": [
{
"id": "ed450c98018617be362fcb51c50a2a0f4c66ef69",
"author": {
"id": "did:key:z6MkkPvBfjP4bQmco5Dm7UGsX2ruDBieEHi8n9DVJWX5sTEz",
"alias": "lorenz"
},
"description": "With this change, the location of the secret SSH key can be configured\nthrough `${RAD_HOME}/config.json` so that the node key does not have to\nbe placed under `${RAD_HOME}/keys` anymore.\n\nFurther, there is now an option to override `config.json` directly when\nexecuting `radicle-node` via the command line argument\n`--secret`.\n\nThe primary motivation is more flexible deployments, for example\nleveraging external secret management solutions, like\n<https://systemd.io/CREDENTIALS/>.\n\nIn order to get this implemented, I had to make modifications\nto the keystore in `radicle-ssh`.",
"base": "6ab3bfcba0577fabdcb84498441c6605391290f4",
"oid": "2b5a0199a4c2f856dda67e6b377209d41da08023",
"timestamp": 1715128217
},
{
"id": "ee94b9696218880e63eae64c5dff06f875633630",
"author": {
"id": "did:key:z6MkkPvBfjP4bQmco5Dm7UGsX2ruDBieEHi8n9DVJWX5sTEz",
"alias": "lorenz"
},
"description": "Updates after initial review by Fintan:\n - Don't implement `Default` for `Keys`.\n - Bring back `keys()`.\n - Add `Home::default_keys()`.\n - Introduce constant string for `\".radicle\"`.\n - Fix `radicle-httpd` tests.",
"base": "25c6660a59c621de1ec406e4f9b2ccfbd21e1b90",
"oid": "f8864608b9bc255bf1c5f04598445b361bf9dfdf",
"timestamp": 1715641705
},
{
"id": "de5f30a3448521fc761bee2a5ddc2ba72bf6e00e",
"author": {
"id": "did:key:z6MkkPvBfjP4bQmco5Dm7UGsX2ruDBieEHi8n9DVJWX5sTEz",
"alias": "lorenz"
},
"description": "Minor changes to previous revision.",
"base": "25c6660a59c621de1ec406e4f9b2ccfbd21e1b90",
"oid": "bf969780502e2883b56dfca3929ba94000492d91",
"timestamp": 1715643263
},
{
"id": "7ed460f7dd1a8130076aca13f1c3965cbf299ee6",
"author": {
"id": "did:key:z6MkkPvBfjP4bQmco5Dm7UGsX2ruDBieEHi8n9DVJWX5sTEz",
"alias": "lorenz"
},
"description": "More rusty fingerprint check.",
"base": "25c6660a59c621de1ec406e4f9b2ccfbd21e1b90",
"oid": "b594a38ebc72ff6253a24d196c6f718771c578da",
"timestamp": 1715711933
},
{
"id": "c0d0e7b633692b66c6aba6866ff7bfb78f66b4a1",
"author": {
"id": "did:key:z6MkkPvBfjP4bQmco5Dm7UGsX2ruDBieEHi8n9DVJWX5sTEz",
"alias": "lorenz"
},
"description": "Another round of review by Fintan.",
"base": "25c6660a59c621de1ec406e4f9b2ccfbd21e1b90",
"oid": "cadb70c3d91ef3faece5bfc2628aed59596023dd",
"timestamp": 1715773899
},
{
"id": "624a626ca52ccf4d3cc5b38d040b3439c8465241",
"author": {
"id": "did:key:z6MkkPvBfjP4bQmco5Dm7UGsX2ruDBieEHi8n9DVJWX5sTEz",
"alias": "lorenz"
},
"description": "Forgot to work in some review comments…",
"base": "25c6660a59c621de1ec406e4f9b2ccfbd21e1b90",
"oid": "bcb7bf320630a503f3e8961908554978f798d390",
"timestamp": 1715775736
},
{
"id": "7439eebf7e76fb180feded75b92205d5b58b60d4",
"author": {
"id": "did:key:z6MkkPvBfjP4bQmco5Dm7UGsX2ruDBieEHi8n9DVJWX5sTEz",
"alias": "lorenz"
},
"description": "Trivial rebase.",
"base": "5727359319f2b8ba6311f066391b7ab0004e5558",
"oid": "7a637fd85244922ea110da0b38dee69f15a49f94",
"timestamp": 1715775992
},
{
"id": "986c4c2593461142dcf3296c28f266ce912f3730",
"author": {
"id": "did:key:z6MkkPvBfjP4bQmco5Dm7UGsX2ruDBieEHi8n9DVJWX5sTEz",
"alias": "lorenz"
},
"description": "Rebase",
"base": "ca7db1620c6f8d4e9caed0902b191c5e6def8bc3",
"oid": "ad252b693e81f06781acb016b11411d7662b9844",
"timestamp": 1715865841
},
{
"id": "821cdf971face4efa942018eb327ebd17fac0b3e",
"author": {
"id": "did:key:z6MkkPvBfjP4bQmco5Dm7UGsX2ruDBieEHi8n9DVJWX5sTEz",
"alias": "lorenz"
},
"description": "Another round of review. Rebase.",
"base": "064ece32ac0a0bd0efe4f459dcb0462bafc236e6",
"oid": "1431768b064d0681ca003658882a9018a3dfcda5",
"timestamp": 1716196287
},
{
"id": "f160f2c3a7bd4e8f661c3685079705ad372c1665",
"author": {
"id": "did:key:z6MkkPvBfjP4bQmco5Dm7UGsX2ruDBieEHi8n9DVJWX5sTEz",
"alias": "lorenz"
},
"description": "Fixes after review. Tests are broken.",
"base": "6dcd56275e606396ec82f4e95fab1d736e8152a4",
"oid": "25a9072138098ba056a18ad4d3787a45183d80b0",
"timestamp": 1745510251
},
{
"id": "312144c8fb8baf2e3610e18a5e4894bdb0578b66",
"author": {
"id": "did:key:z6MkkPvBfjP4bQmco5Dm7UGsX2ruDBieEHi8n9DVJWX5sTEz",
"alias": "lorenz"
},
"description": "Pulled out the changes to CLI testing. They are now in `rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5/patch/12bc8517149547b24ccdc10def80ee34ec9368cc`.",
"base": "f13afe491d169004159a033c4ad7548a7ba76271",
"oid": "d2f7b8988f3cb65212fc0c2236aac523f8f46622",
"timestamp": 1745589182
},
{
"id": "f4e2ffc215916ee397d7fc5f67a60590a8bbf794",
"author": {
"id": "did:key:z6MkkPvBfjP4bQmco5Dm7UGsX2ruDBieEHi8n9DVJWX5sTEz",
"alias": "lorenz"
},
"description": "Rewrite the whole thing. It's *much* cleaner now.",
"base": "bc4a13902ca80b1c496ab65670c0526141663e9e",
"oid": "dec836e7ad4697f0c8eea848a18b2da75913ba03",
"timestamp": 1756255247
},
{
"id": "dedcf2e12117c5ba15487fc718abdec0e5201077",
"author": {
"id": "did:key:z6MkkPvBfjP4bQmco5Dm7UGsX2ruDBieEHi8n9DVJWX5sTEz",
"alias": "lorenz"
},
"description": "REVIEW: see commits",
"base": "bc4a13902ca80b1c496ab65670c0526141663e9e",
"oid": "9b1627faee800898a4a28c22dc276902809de745",
"timestamp": 1757416285
},
{
"id": "4991e458f020e5f2870b15b38464cd13e279953e",
"author": {
"id": "did:key:z6MkkPvBfjP4bQmco5Dm7UGsX2ruDBieEHi8n9DVJWX5sTEz",
"alias": "lorenz"
},
"description": "- Apply most of Fintan's suggested changes.\n- Improve documentation, hopefully answering Fintan's questions.",
"base": "bc4a13902ca80b1c496ab65670c0526141663e9e",
"oid": "46a0998ab96d4b2e960dd0d81cabe8a0b0bdcfcf",
"timestamp": 1757536685
},
{
"id": "21c7dbc3bf02fd8a2284e122ab2e30ec8de053ef",
"author": {
"id": "did:key:z6MkkPvBfjP4bQmco5Dm7UGsX2ruDBieEHi8n9DVJWX5sTEz",
"alias": "lorenz"
},
"description": "Rebase",
"base": "ed8b086045ee5d7bd1327f579de7861a1cf49e3b",
"oid": "5ce5010cb45523867b3cc420b9167bb7e2d3383b",
"timestamp": 1758733474
},
{
"id": "265a584346dda25e7fdf4a1d29c5ab23f58b0ab7",
"author": {
"id": "did:key:z6MkkPvBfjP4bQmco5Dm7UGsX2ruDBieEHi8n9DVJWX5sTEz",
"alias": "lorenz"
},
"description": "Rewrite",
"base": "ed8b086045ee5d7bd1327f579de7861a1cf49e3b",
"oid": "9f3c14034fcae9c7a0d4b95a5acc84e932f0623a",
"timestamp": 1758814755
},
{
"id": "152c9e8e82ec30250b00b37f015778ebf90ee2c6",
"author": {
"id": "did:key:z6MkkPvBfjP4bQmco5Dm7UGsX2ruDBieEHi8n9DVJWX5sTEz",
"alias": "lorenz"
},
"description": "Rewrite",
"base": "ed8b086045ee5d7bd1327f579de7861a1cf49e3b",
"oid": "cca3454defb46f697ab409093e4273074fcd6364",
"timestamp": 1758816361
}
]
}
}[2025-09-25T16:06:08Z INFO ambient] ambient starts
[2025-09-25T16:06:08Z DEBUG ambient] load default configuration file /home/_rad/.config/ambient/config.yaml if it exists
[2025-09-25T16:06:08Z 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-09-25T16:06:08Z 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-09-25T16:06:08Z DEBUG ambient_ci::project] load project state from /srv/ambient-state/rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5/meta.yaml
[2025-09-25T16:06:08Z DEBUG ambient_ci::run] latest commit: "9f3c14034fcae9c7a0d4b95a5acc84e932f0623a"
[2025-09-25T16:06:08Z DEBUG ambient_ci::run] is a git repository
[2025-09-25T16:06:08Z DEBUG ambient_ci::run] git repository is clean
[2025-09-25T16:06:08Z DEBUG ambient_ci::run] current (HEAD) commit: cca3454defb46f697ab409093e4273074fcd6364
[2025-09-25T16:06:08Z DEBUG ambient_ci::run] no dry run requested
[2025-09-25T16:06:08Z DEBUG ambient_ci::run] forced run requested
[2025-09-25T16:06:08Z DEBUG ambient_ci::run] run? true
[2025-09-25T16:06:08Z INFO ambient_ci::run] project rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5: running CI
[2025-09-25T16:06:08Z DEBUG ambient_ci::run] Executing pre-plan steps
[2025-09-25T16:06:08Z DEBUG ambient_ci::plan] RUN: Action CargoFetch {
sourcedir: "/tmp/.tmpX68W3q/src",
}
[2025-09-25T16:06:08Z DEBUG ambient_ci::action] Plan::execute: plan=CargoFetch {
sourcedir: "/tmp/.tmpX68W3q/src",
}
[2025-09-25T16:06:08Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"PATH": "/root/.cargo/bin:/bin:/home/_rad/.radicle/bin:/home/_rad/.cargo/bin",
"CARGO_TARGET_DIR": "/srv/ambient-state/rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5/cache",
"CARGO_HOME": "/srv/ambient-state/rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5/dependencies",
},
source_dir: "/tmp/.tmpX68W3q/src",
}
SPAWN: argv=["cargo", "--version"]
cwd=/tmp/.tmpX68W3q/src (exists? true)
cargo 1.88.0 (873a06493 2025-05-10)
SPAWN: argv=["cargo", "clippy", "--version"]
cwd=/tmp/.tmpX68W3q/src (exists? true)
clippy 0.1.88 (6b00bc3880 2025-06-23)
SPAWN: argv=["rustc", "--version"]
cwd=/tmp/.tmpX68W3q/src (exists? true)
rustc 1.88.0 (6b00bc388 2025-06-23)
SPAWN: argv=["cargo", "fetch"]
cwd=/tmp/.tmpX68W3q/src (exists? true)
[2025-09-25T16:06:09Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-25T16:06:09Z DEBUG ambient_ci::plan] All actions were performed successfully
[2025-09-25T16:06:09Z DEBUG ambient_ci::run] create virtual drive /srv/tmp/.tmpJW1QRk/src.tar
[2025-09-25T16:06:09Z DEBUG ambient_ci::run] create virtual drive /srv/tmp/.tmpJW1QRk/deps.tar
[2025-09-25T16:06:17Z DEBUG ambient_ci::run] create_executor_vdrive: executor="/usr/bin/ambient-execute-plan"
[2025-09-25T16:06:17Z 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\"\nexport RUSTDOCFLAGS='-D warnings'\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-09-25T16:06:17Z DEBUG ambient_ci::run] executor bin /usr/bin/ambient-execute-plan
[2025-09-25T16:06:17Z DEBUG ambient_ci::run] copying /usr/bin/ambient-execute-plan to /srv/tmp/.tmpJW1QRk/ambient-execute-plan/run-ci
[2025-09-25T16:06:17Z DEBUG ambient_ci::run] copy OK: true
[2025-09-25T16:06:17Z DEBUG ambient_ci::run] create virtual drive /srv/tmp/.tmpJW1QRk/executor.tar
[2025-09-25T16:07:10Z DEBUG ambient_ci::project] removing run log file /srv/ambient-state/rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5/run.log
[2025-09-25T16:07:10Z DEBUG ambient_ci::project] statedir is /srv/ambient-state/rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5, exists? true
[2025-09-25T16:07:10Z DEBUG ambient_ci::project] creating run log file /srv/ambient-state/rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5/run.log
[2025-09-25T16:07:10Z DEBUG ambient_ci::project] created run log file /srv/ambient-state/rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5/run.log OK
[2025-09-25T16:07:10Z DEBUG ambient_ci::cloud_init] with_hostname called: "ambient"
[2025-09-25T16:07:10Z DEBUG ambient_ci::cloud_init] with_runcmd called: "echo xyzzy > /dev/ttyS1"
[2025-09-25T16:07:10Z 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-09-25T16:07:10Z DEBUG ambient_ci::cloud_init] with_runcmd called: "poweroff"
[2025-09-25T16:07:10Z 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-09-25T16:07:10Z DEBUG ambient_ci::qemu] run QEMU
[2025-09-25T16:07:10Z DEBUG ambient_ci::qemu] create copy-on-write image and UEFI vars file
[2025-09-25T16:07:10Z DEBUG ambient_ci::qemu_utils] qemu-img create /srv/tmp/.tmpUpcoWX/.tmpPKaekn/vm.qcow2 backing on /home/_rad/ambient.qcow2
[2025-09-25T16:07:10Z DEBUG ambient_ci::qemu] create cloud-init ISO file
[2025-09-25T16:07:10Z 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-09-25T16:07:10Z DEBUG ambient_ci::cloud_init] write /tmp/.tmpomzGB8/meta-data
[2025-09-25T16:07:10Z DEBUG ambient_ci::cloud_init] write /tmp/.tmpomzGB8/user-data
[2025-09-25T16:07:10Z DEBUG ambient_ci::qemu] set console log file to /srv/tmp/.tmpUpcoWX/.tmpPKaekn/console.log
[2025-09-25T16:07:10Z DEBUG ambient_ci::util] create file /srv/tmp/.tmpUpcoWX/.tmpPKaekn/console.log
[2025-09-25T16:07:10Z DEBUG ambient_ci::qemu] set run file to /srv/ambient-state/rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5/run.log
[2025-09-25T16:07:10Z DEBUG ambient_ci::util] create file /srv/ambient-state/rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5/run.log
[2025-09-25T16:07:10Z 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/.tmpUpcoWX/.tmpPKaekn/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/.tmpUpcoWX/.tmpPKaekn/vars.fd",
"-drive",
"format=qcow2,if=virtio,file=/srv/tmp/.tmpUpcoWX/.tmpPKaekn/vm.qcow2",
"-drive",
"format=raw,if=virtio,file=/srv/tmp/.tmpJW1QRk/executor.tar,readonly=on",
"-cdrom",
"/srv/tmp/.tmpUpcoWX/.tmpPKaekn/cloud_init.iso",
"-drive",
"format=raw,if=virtio,file=/srv/tmp/.tmpJW1QRk/src.tar,readonly=on",
"-drive",
"format=raw,if=virtio,file=/srv/tmp/.tmpJW1QRk/artifacts.tar",
"-drive",
"format=raw,if=virtio,file=/srv/tmp/.tmpJW1QRk/cache.tar",
"-drive",
"format=raw,if=virtio,file=/srv/tmp/.tmpJW1QRk/deps.tar,readonly=on",
"-nodefaults",
"-no-user-config",
],
}
[2025-09-25T16:12:59Z DEBUG ambient_ci::qemu] QEMU finished OK
[2025-09-25T16:12:59Z DEBUG ambient_ci::qemu] run log:
--------------------==========
[2025-09-25T16:07:21Z TRACE ambient_execute_plan] ambient-execute-plan version 0.7.0@2e86bbe starts
[2025-09-25T16:07:21Z DEBUG ambient_execute_plan] ambient-execute-plan version 0.7.0@2e86bbe starts
[2025-09-25T16:07:21Z INFO ambient_execute_plan] ambient-execute-plan version 0.7.0@2e86bbe starts
[2025-09-25T16:07:21Z WARN ambient_execute_plan] ambient-execute-plan version 0.7.0@2e86bbe starts
[2025-09-25T16:07:21Z ERROR ambient_execute_plan] ambient-execute-plan version 0.7.0@2e86bbe 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"
export RUSTDOCFLAGS='-D warnings'
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
[2025-09-25T16:07:21Z DEBUG ambient_ci::plan] RUN: Action Mkdir {
pathname: "/workspace",
}
[2025-09-25T16:07:21Z DEBUG ambient_ci::action] Plan::execute: plan=Mkdir {
pathname: "/workspace",
}
[2025-09-25T16:07:21Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_HOME": "/workspace/deps",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
[2025-09-25T16:07:21Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-25T16:07:21Z DEBUG ambient_ci::plan] RUN: Action Mkdir {
pathname: "/workspace/artifacts",
}
[2025-09-25T16:07:21Z DEBUG ambient_ci::action] Plan::execute: plan=Mkdir {
pathname: "/workspace/artifacts",
}
[2025-09-25T16:07:21Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_HOME": "/workspace/deps",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
[2025-09-25T16:07:22Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-25T16:07:22Z DEBUG ambient_ci::plan] RUN: Action TarExtract {
archive: "/dev/vdc",
directory: "/workspace/src",
}
[2025-09-25T16:07:22Z DEBUG ambient_ci::action] Plan::execute: plan=TarExtract {
archive: "/dev/vdc",
directory: "/workspace/src",
}
[2025-09-25T16:07:22Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_HOME": "/workspace/deps",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
[2025-09-25T16:07:22Z TRACE ambient_ci::vdrive] extracting /dev/vdc to /workspace/src
[2025-09-25T16:07:22Z TRACE ambient_ci::vdrive] extraction OK
[2025-09-25T16:07:22Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-25T16:07:22Z DEBUG ambient_ci::plan] RUN: Action TarExtract {
archive: "/dev/vdf",
directory: "/workspace/deps",
}
[2025-09-25T16:07:22Z DEBUG ambient_ci::action] Plan::execute: plan=TarExtract {
archive: "/dev/vdf",
directory: "/workspace/deps",
}
[2025-09-25T16:07:22Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_HOME": "/workspace/deps",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
[2025-09-25T16:07:22Z TRACE ambient_ci::vdrive] extracting /dev/vdf to /workspace/deps
[2025-09-25T16:07:45Z TRACE ambient_ci::vdrive] extraction OK
[2025-09-25T16:07:45Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-25T16:07:45Z DEBUG ambient_ci::plan] RUN: Action TarExtract {
archive: "/dev/vde",
directory: "/workspace/cache",
}
[2025-09-25T16:07:45Z DEBUG ambient_ci::action] Plan::execute: plan=TarExtract {
archive: "/dev/vde",
directory: "/workspace/cache",
}
[2025-09-25T16:07:45Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_HOME": "/workspace/deps",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
[2025-09-25T16:07:45Z TRACE ambient_ci::vdrive] extracting /dev/vde to /workspace/cache
[2025-09-25T16:09:16Z TRACE ambient_ci::vdrive] extraction OK
[2025-09-25T16:09:16Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-25T16:09:16Z DEBUG ambient_ci::plan] RUN: Action Spawn {
argv: [
"find",
"/workspace",
"-maxdepth",
"2",
"-ls",
],
}
[2025-09-25T16:09:16Z DEBUG ambient_ci::action] Plan::execute: plan=Spawn {
argv: [
"find",
"/workspace",
"-maxdepth",
"2",
"-ls",
],
}
[2025-09-25T16:09:16Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_HOME": "/workspace/deps",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
SPAWN: argv=["find", "/workspace", "-maxdepth", "2", "-ls"]
cwd=/workspace/src (exists? true)
2621441 4 drwxr-xr-x 6 root root 4096 Sep 25 16:07 /workspace
2622488 4 drwxr-xr-x 3 root root 4096 Sep 25 16:06 /workspace/deps
2622489 0 -rw-r--r-- 1 root root 0 Sep 22 16:46 /workspace/deps/.package-cache-mutate
2622492 4 drwxr-xr-x 5 root root 4096 Sep 22 16:46 /workspace/deps/registry
2622490 128 -rw-r--r-- 1 root root 131072 Sep 25 16:06 /workspace/deps/.global-cache
2622491 0 -rw-r--r-- 1 root root 0 Sep 22 16:46 /workspace/deps/.package-cache
2621443 4 drwxr-xr-x 12 root root 4096 Sep 25 16:06 /workspace/src
2621499 4 -rw-r--r-- 1 root root 2653 Sep 25 16:06 /workspace/src/Cargo.toml
2622484 12 -rw-r--r-- 1 root root 9636 Sep 25 16:06 /workspace/src/CONTRIBUTING.md
2621500 4 drwxr-xr-x 2 root root 4096 Sep 25 16:06 /workspace/src/.config
2621496 4 -rw-r--r-- 1 root root 1623 Sep 25 16:06 /workspace/src/build.rs
2621502 4 -rw-r--r-- 1 root root 426 Sep 25 16:06 /workspace/src/radicle-node.1.adoc
2621504 4 drwxr-xr-x 8 root root 4096 Sep 25 16:06 /workspace/src/.git
2622481 8 -rw-r--r-- 1 root root 7144 Sep 25 16:06 /workspace/src/rad-id.1.adoc
2621460 4 -rw-r--r-- 1 root root 2163 Sep 25 16:06 /workspace/src/VERSIONING.md
2621495 4 -rw-r--r-- 1 root root 3133 Sep 25 16:06 /workspace/src/README.md
2621903 12 -rw-r--r-- 1 root root 10975 Sep 25 16:06 /workspace/src/rad-patch.1.adoc
2622485 4 -rw-r--r-- 1 root root 79 Sep 25 16:06 /workspace/src/ARCHITECTURE.md
2621911 4 drwxr-xr-x 17 root root 4096 Sep 25 16:06 /workspace/src/crates
2621448 4 drwxr-xr-x 2 root root 4096 Sep 25 16:06 /workspace/src/scripts
2621444 4 drwxr-xr-x 2 root root 4096 Sep 25 16:06 /workspace/src/.radicle
2621467 12 -rw-r--r-- 1 root root 9422 Sep 25 16:06 /workspace/src/CHANGELOG.md
2621482 4 drwxr-xr-x 3 root root 4096 Sep 25 16:06 /workspace/src/debian
2621465 4 -rw-r--r-- 1 root root 42 Sep 25 16:06 /workspace/src/.envrc
2622482 4 -rw-r--r-- 1 root root 1203 Sep 25 16:06 /workspace/src/DCO
2622477 4 drwxr-xr-x 3 root root 4096 Sep 25 16:06 /workspace/src/.github
2622487 120 -rw-r--r-- 1 root root 121633 Sep 25 16:06 /workspace/src/Cargo.lock
2621904 4 drwxr-xr-x 5 root root 4096 Sep 25 16:06 /workspace/src/systemd
2621902 12 -rw-r--r-- 1 root root 9723 Sep 25 16:06 /workspace/src/LICENSE-APACHE
2621498 4 -rw-r--r-- 1 root root 101 Sep 25 16:06 /workspace/src/.gitignore
2622483 8 -rw-r--r-- 1 root root 5102 Sep 25 16:06 /workspace/src/flake.lock
2621464 4 -rw-r--r-- 1 root root 77 Sep 25 16:06 /workspace/src/rust-toolchain.toml
2621497 12 -rw-r--r-- 1 root root 10500 Sep 25 16:06 /workspace/src/flake.nix
2621468 4 -rw-r--r-- 1 root root 571 Sep 25 16:06 /workspace/src/git-remote-rad.1.adoc
2621466 4 -rw-r--r-- 1 root root 61 Sep 25 16:06 /workspace/src/.env.seed
2621503 8 -rw-r--r-- 1 root root 5432 Sep 25 16:06 /workspace/src/deny.toml
2621458 8 -rw-r--r-- 1 root root 7645 Sep 25 16:06 /workspace/src/HACKING.md
2621447 4 -rw-r--r-- 1 root root 1079 Sep 25 16:06 /workspace/src/LICENSE-MIT
2621463 8 -rw-r--r-- 1 root root 8023 Sep 25 16:06 /workspace/src/rad.1.adoc
2621469 4 drwxr-xr-x 2 root root 4096 Sep 25 16:06 /workspace/src/build
2622486 4 -rw-r--r-- 1 root root 1083 Sep 25 16:06 /workspace/src/.gitsigners
2621459 4 -rw-r--r-- 1 root root 30 Sep 25 16:06 /workspace/src/.dockerignore
2621461 4 drwxr-xr-x 2 root root 4096 Sep 25 16:06 /workspace/src/.cargo
2621442 4 drwxr-xr-x 2 root root 4096 Sep 25 16:07 /workspace/artifacts
2650536 4 drwxr-xr-x 6 root root 4096 Sep 22 23:09 /workspace/cache
2669231 4 -rw-r--r-- 1 root root 218 Sep 22 23:08 /workspace/cache/.rustdoc_fingerprint.json
2757416 4 drwxr-xr-x 24 root root 4096 Sep 24 10:45 /workspace/cache/doc
2650538 4 drwxr-xr-x 7 root root 4096 Sep 24 10:43 /workspace/cache/debug
2650537 4 drwxr-xr-x 2 root root 4096 Sep 22 23:02 /workspace/cache/tmp
2669232 4 -rw-r--r-- 1 root root 1036 Sep 24 12:56 /workspace/cache/.rustc_info.json
2752513 4 drwxr-xr-x 7 root root 4096 Sep 24 10:47 /workspace/cache/release
[2025-09-25T16:09:17Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-25T16:09:17Z DEBUG ambient_ci::plan] RUN: Action CargoFmt
[2025-09-25T16:09:17Z DEBUG ambient_ci::action] Plan::execute: plan=CargoFmt
[2025-09-25T16:09:17Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_HOME": "/workspace/deps",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
SPAWN: argv=["cargo", "--version"]
cwd=/workspace/src (exists? true)
cargo 1.88.0 (873a06493 2025-05-10)
SPAWN: argv=["cargo", "clippy", "--version"]
cwd=/workspace/src (exists? true)
clippy 0.1.88 (6b00bc3880 2025-06-23)
SPAWN: argv=["rustc", "--version"]
cwd=/workspace/src (exists? true)
rustc 1.88.0 (6b00bc388 2025-06-23)
SPAWN: argv=["cargo", "fmt", "--check"]
cwd=/workspace/src (exists? true)
[2025-09-25T16:09:18Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-25T16:09:18Z DEBUG ambient_ci::plan] RUN: Action CargoClippy
[2025-09-25T16:09:18Z DEBUG ambient_ci::action] Plan::execute: plan=CargoClippy
[2025-09-25T16:09:18Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_HOME": "/workspace/deps",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
SPAWN: argv=["cargo", "--version"]
cwd=/workspace/src (exists? true)
cargo 1.88.0 (873a06493 2025-05-10)
SPAWN: argv=["cargo", "clippy", "--version"]
cwd=/workspace/src (exists? true)
clippy 0.1.88 (6b00bc3880 2025-06-23)
SPAWN: argv=["rustc", "--version"]
cwd=/workspace/src (exists? true)
rustc 1.88.0 (6b00bc388 2025-06-23)
SPAWN: argv=["cargo", "clippy", "--offline", "--locked", "--workspace", "--all-targets", "--no-deps", "--", "--deny", "warnings"]
cwd=/workspace/src (exists? true)
Checking erased-serde v0.4.6
Checking serde_fmt v1.0.3
Checking radicle-ssh v0.10.0 (/workspace/src/crates/radicle-ssh)
Checking radicle-dag v0.10.0 (/workspace/src/crates/radicle-dag)
Checking anstyle v1.0.6
Checking radicle-signals v0.11.0 (/workspace/src/crates/radicle-signals)
Compiling portable-atomic v1.11.0
Checking anstream v0.6.13
Checking unicode-width v0.2.1
Checking value-bag-serde1 v1.11.1
Checking value-bag v1.11.1
Checking serde-untagged v0.1.7
Checking console v0.16.0
Checking snapbox-macros v0.3.8
Checking log v0.4.27
Checking unit-prefix v0.5.1
Checking snapbox v0.4.17
Checking pin-project-lite v0.2.16
Checking tokio v1.47.1
Checking prodash v29.0.2
Checking git2 v0.19.0
Checking mio v0.8.11
Checking gix-features v0.39.1
Checking mio v1.0.4
Checking gix-object v0.46.1
Checking gix-commitgraph v0.25.1
Checking gix-fs v0.12.1
Checking gix-tempfile v15.0.0
Checking gix-lock v15.0.1
Checking gix-url v0.28.2
Checking gix-revwalk v0.17.0
Checking gix-traverse v0.43.1
Checking gix-revision v0.31.1
Checking gix-diff v0.49.0
Checking gix-refspec v0.27.0
Checking gix-pack v0.56.0
Checking gix-transport v0.44.0
Checking radicle-git-ext v0.8.1
Checking gix-credentials v0.26.0
Checking gix-negotiate v0.17.0
Checking radicle-crypto v0.13.0 (/workspace/src/crates/radicle-crypto)
Checking gix-ref v0.49.1
Checking gix-shallow v0.1.0
Checking signal-hook-mio v0.2.4
Checking radicle-cob v0.16.0 (/workspace/src/crates/radicle-cob)
Checking gix-odb v0.66.0
Checking crossterm v0.25.0
Checking gix-protocol v0.47.0
Checking inquire v0.7.5
Checking indicatif v0.18.0
Checking radicle v0.19.0 (/workspace/src/crates/radicle)
Checking crossterm v0.29.0
Checking systemd-journal-logger v2.2.2
Checking os_info v3.12.0
Compiling radicle-node v0.15.0 (/workspace/src/crates/radicle-node)
Compiling radicle-cli v0.16.0 (/workspace/src/crates/radicle-cli)
Checking radicle-surf v0.22.0
Checking radicle-term v0.15.0 (/workspace/src/crates/radicle-term)
Checking human-panic v2.0.3
Checking radicle-systemd v0.10.0 (/workspace/src/crates/radicle-systemd)
Checking structured-logger v1.0.4
Checking escargot v0.5.10
Checking env_filter v0.1.3
Checking env_logger v0.11.8
Compiling radicle-remote-helper v0.13.0 (/workspace/src/crates/radicle-remote-helper)
Checking test-log v0.2.18
Checking radicle-fetch v0.15.0 (/workspace/src/crates/radicle-fetch)
Checking radicle-cli-test v0.13.0 (/workspace/src/crates/radicle-cli-test)
Checking radicle-protocol v0.3.0 (/workspace/src/crates/radicle-protocol)
Checking radicle-schemars v0.5.0 (/workspace/src/crates/radicle-schemars)
Finished `dev` profile [unoptimized + debuginfo] target(s) in 24.36s
[2025-09-25T16:09:43Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-25T16:09:43Z DEBUG ambient_ci::plan] RUN: Action CargoBuild
[2025-09-25T16:09:43Z DEBUG ambient_ci::action] Plan::execute: plan=CargoBuild
[2025-09-25T16:09:43Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_HOME": "/workspace/deps",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
SPAWN: argv=["cargo", "--version"]
cwd=/workspace/src (exists? true)
cargo 1.88.0 (873a06493 2025-05-10)
SPAWN: argv=["cargo", "clippy", "--version"]
cwd=/workspace/src (exists? true)
clippy 0.1.88 (6b00bc3880 2025-06-23)
SPAWN: argv=["rustc", "--version"]
cwd=/workspace/src (exists? true)
rustc 1.88.0 (6b00bc388 2025-06-23)
SPAWN: argv=["cargo", "build", "--offline", "--locked", "--workspace", "--all-targets"]
cwd=/workspace/src (exists? true)
Compiling erased-serde v0.4.6
Compiling serde_fmt v1.0.3
Compiling radicle-ssh v0.10.0 (/workspace/src/crates/radicle-ssh)
Compiling radicle-dag v0.10.0 (/workspace/src/crates/radicle-dag)
Compiling anstyle v1.0.6
Compiling radicle-signals v0.11.0 (/workspace/src/crates/radicle-signals)
Compiling unicode-width v0.2.1
Compiling anstream v0.6.13
Compiling portable-atomic v1.11.0
Compiling value-bag-serde1 v1.11.1
Compiling value-bag v1.11.1
Compiling serde-untagged v0.1.7
Compiling snapbox-macros v0.3.8
Compiling console v0.16.0
Compiling unit-prefix v0.5.1
Compiling snapbox v0.4.17
Compiling log v0.4.27
Compiling indicatif v0.18.0
Compiling pin-project-lite v0.2.16
Compiling prodash v29.0.2
Compiling git2 v0.19.0
Compiling gix-features v0.39.1
Compiling mio v1.0.4
Compiling mio v0.8.11
Compiling gix-object v0.46.1
Compiling gix-commitgraph v0.25.1
Compiling gix-fs v0.12.1
Compiling gix-tempfile v15.0.0
Compiling gix-url v0.28.2
Compiling gix-lock v15.0.1
Compiling gix-revwalk v0.17.0
Compiling gix-diff v0.49.0
Compiling gix-revision v0.31.1
Compiling gix-traverse v0.43.1
Compiling radicle-git-ext v0.8.1
Compiling gix-pack v0.56.0
Compiling radicle-crypto v0.13.0 (/workspace/src/crates/radicle-crypto)
Compiling gix-refspec v0.27.0
Compiling radicle-cob v0.16.0 (/workspace/src/crates/radicle-cob)
Compiling gix-negotiate v0.17.0
Compiling gix-ref v0.49.1
Compiling gix-shallow v0.1.0
Compiling radicle v0.19.0 (/workspace/src/crates/radicle)
Compiling gix-credentials v0.26.0
Compiling gix-transport v0.44.0
Compiling signal-hook-mio v0.2.4
Compiling gix-odb v0.66.0
Compiling crossterm v0.25.0
Compiling gix-protocol v0.47.0
Compiling inquire v0.7.5
Compiling crossterm v0.29.0
Compiling systemd-journal-logger v2.2.2
Compiling tokio v1.47.1
Compiling os_info v3.12.0
Compiling radicle-cli v0.16.0 (/workspace/src/crates/radicle-cli)
Compiling radicle-node v0.15.0 (/workspace/src/crates/radicle-node)
Compiling radicle-surf v0.22.0
Compiling radicle-term v0.15.0 (/workspace/src/crates/radicle-term)
Compiling structured-logger v1.0.4
Compiling human-panic v2.0.3
Compiling radicle-systemd v0.10.0 (/workspace/src/crates/radicle-systemd)
Compiling escargot v0.5.10
Compiling env_filter v0.1.3
Compiling env_logger v0.11.8
Compiling radicle-remote-helper v0.13.0 (/workspace/src/crates/radicle-remote-helper)
Compiling test-log v0.2.18
Compiling radicle-fetch v0.15.0 (/workspace/src/crates/radicle-fetch)
Compiling radicle-protocol v0.3.0 (/workspace/src/crates/radicle-protocol)
Compiling radicle-cli-test v0.13.0 (/workspace/src/crates/radicle-cli-test)
Compiling radicle-schemars v0.5.0 (/workspace/src/crates/radicle-schemars)
Finished `dev` profile [unoptimized + debuginfo] target(s) in 1m 06s
[2025-09-25T16:10:50Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-25T16:10:50Z DEBUG ambient_ci::plan] RUN: Action CargoTest
[2025-09-25T16:10:50Z DEBUG ambient_ci::action] Plan::execute: plan=CargoTest
[2025-09-25T16:10:50Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_HOME": "/workspace/deps",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
SPAWN: argv=["cargo", "--version"]
cwd=/workspace/src (exists? true)
cargo 1.88.0 (873a06493 2025-05-10)
SPAWN: argv=["cargo", "clippy", "--version"]
cwd=/workspace/src (exists? true)
clippy 0.1.88 (6b00bc3880 2025-06-23)
SPAWN: argv=["rustc", "--version"]
cwd=/workspace/src (exists? true)
rustc 1.88.0 (6b00bc388 2025-06-23)
SPAWN: argv=["cargo", "test", "--offline", "--locked", "--workspace"]
cwd=/workspace/src (exists? true)
Finished `test` profile [unoptimized + debuginfo] target(s) in 0.39s
Running unittests src/lib.rs (/workspace/cache/debug/deps/radicle-f412a4d7b87c45b5)
running 238 tests
test canonical::formatter::test::securesystemslib_asserts ... ok
test canonical::formatter::test::ascii_control_characters ... ok
test canonical::formatter::test::ordered_nested_object ... ok
test cob::cache::migrations::_2::tests::test_patch_json_deserialization ... ok
test cob::cache::tests::test_check_version ... ok
test cob::cache::migrations::_2::tests::test_migration_2 ... ok
test cob::cache::tests::test_migrate_to ... ok
test cob::common::test::test_color ... ok
test cob::common::test::test_emojis ... ok
test cob::common::test::test_title ... 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_remove_delegate_concurrent ... ok
test cob::identity::test::test_identity_updates ... ok
test cob::identity::test::test_identity_update_rejected ... 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_cob ... ok
test cob::issue::test::test_concurrency ... ok
test cob::issue::test::test_invalid_tx_reference ... ok
test cob::issue::test::test_invalid_tx ... ok
test cob::issue::test::test_issue_all ... ok
test cob::issue::test::test_issue_create_and_assign ... ok
test cob::issue::test::test_issue_comment ... 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::patch::cache::tests::test_get ... ok
test cob::patch::cache::tests::test_is_empty ... ok
test cob::issue::test::test_issue_reply ... ok
test cob::patch::cache::tests::test_list_by_status ... ok
test cob::patch::cache::tests::test_list ... 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::test::test_patch_create_and_get ... ok
test cob::patch::test::test_patch_discussion ... ok
test cob::patch::cache::tests::test_remove ... 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_edit_comment ... ok
test cob::patch::test::test_patch_review_remove_summary ... 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::stream::tests::test_all_from ... ok
test cob::patch::test::test_patch_review_revision_redact ... ok
test cob::stream::tests::test_all_from_until ... ok
test cob::stream::tests::test_all_until ... ok
test cob::stream::tests::test_regression_from_until ... ok
test cob::stream::tests::test_from_until ... 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::quorum::test::merge_base_commutative ... ok
test git::canonical::quorum::test::test_merge_bases ... ok
test cob::patch::test::test_patch_update ... 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 git::canonical::rules::tests::test_canonical ... ok
test git::canonical::rules::tests::test_rule_validate_success ... ok
test git::canonical::rules::tests::test_special_branches ... ok
test git::canonical::tests::test_commit_quorum_fork_of_a_fork ... ok
test git::canonical::tests::test_commit_quorum_forked_merge_commits ... ok
test git::canonical::tests::test_commit_quorum_groups ... ok
test git::canonical::tests::test_commit_quorum_linear ... ok
test git::canonical::tests::test_commit_quorum_merges ... ok
test git::canonical::tests::test_commit_quorum_single ... ok
test git::canonical::tests::test_commit_quorum_three_way_fork ... ok
test git::canonical::tests::test_commit_quorum_two_way_fork ... ok
test git::canonical::tests::test_quorum_different_types ... ok
test cob::patch::cache::tests::test_find_by_revision ... ok
test git::canonical::tests::test_tag_quorum ... 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::rules::tests::test_rule_validate_failures ... 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 identity::doc::test::test_max_delegates ... ok
test identity::doc::test::test_not_found ... 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 git::canonical::tests::test_quorum_properties ... 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::config::test::partial ... 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 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::address::store::test::test_empty ... ok
test node::policy::store::test::test_node_aliases ... ok
test node::policy::store::test::test_node_policies ... ok
test node::policy::store::test::test_node_policy ... ok
test node::policy::store::test::test_repo_policies ... ok
test node::policy::store::test::test_repo_policy ... ok
test node::policy::store::test::test_seed_and_unseed_repo ... ok
test node::policy::store::test::test_update_scope ... ok
test node::policy::store::test::test_update_alias ... ok
test node::refs::store::test::test_count ... ok
test node::refs::store::test::test_set_and_get ... ok
test node::refs::store::test::test_set_and_delete ... ok
test node::routing::test::test_count ... ok
test node::routing::test::test_entries ... ok
test node::routing::test::test_insert_and_get ... ok
test node::routing::test::test_insert_and_remove ... ok
test node::routing::test::test_insert_and_get_resources ... ok
test node::routing::test::test_insert_duplicate ... ok
test node::routing::test::test_insert_existing_updated_time ... 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::cannot_construct_announcer ... 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::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::synced_with_same_node_multiple_times ... ok
test node::sync::announce::test::timed_out_after_reaching_success ... ok
test node::sync::fetch::test::all_nodes_are_candidates ... ok
test node::sync::fetch::test::all_nodes_are_fetchable ... ok
test node::sync::fetch::test::could_not_reach_target ... ok
test node::sync::fetch::test::ignores_duplicates_and_local_node ... ok
test node::sync::fetch::test::preferred_seeds_target_returned_over_replicas ... ok
test node::sync::fetch::test::reaches_target_of_max_replicas ... 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::sync::fetch::test::reaches_target_of_replicas ... ok
test node::test::test_user_agent ... ok
test node::timestamp::tests::test_timestamp_max ... ok
test profile::test::canonicalize_home ... ok
test profile::test::test_config ... ok
test cob::thread::tests::prop_ordering ... ok
test rad::tests::test_checkout ... ok
test rad::tests::test_fork ... ok
test rad::tests::test_init ... 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 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. 238 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 4.25s
Running unittests src/lib.rs (/workspace/cache/debug/deps/radicle_cli-1940553710e3dbe5)
running 14 tests
test commands::patch::review::builder::tests::test_review_comments_multiline ... ok
test commands::patch::review::builder::tests::test_review_comments_basic ... ok
test commands::inspect::test::test_tree ... ok
test commands::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 commands::patch::review::builder::tests::test_review_comments_before ... ok
test terminal::patch::test::test_create_display_message ... ok
test terminal::patch::test::test_update_display_message ... ok
test result: ok. 13 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out; finished in 0.02s
Running unittests src/main.rs (/workspace/cache/debug/deps/rad-f4b8d3d317a00168)
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-2b1390b62c18490c)
running 104 tests
test framework_home ... ok
test git_push_and_fetch ... ok
test git_push_canonical_lightweight_tags ... FAILED
test git_push_amend ... ok
test git_push_canonical_annotated_tags ... ok
test git_push_diverge ... ok
test git_push_rollback ... ok
test rad_auth_errors ... ok
test git_tag ... ok
test rad_block ... ok
test rad_auth ... ok
test rad_checkout ... ok
test rad_clone ... ok
test git_push_converge ... ok
test rad_clean ... ok
test rad_clone_all ... ok
test rad_clone_bare ... ok
test rad_clone_unknown ... ok
test rad_clone_connect ... ok
test rad_clone_directory ... ok
test rad_cob_log ... ok
test rad_cob_migrate ... ok
test rad_cob_multiset ... ok
test rad_cob_operations ... ok
test rad_clone_partial_fail ... ok
test rad_cob_show ... ok
test rad_cob_update ... ok
test rad_cob_update_identity ... ok
test rad_config ... ok
test rad_diff ... ok
test rad_id_collaboration ... ignored, slow
test rad_id ... ok
test rad_id_conflict ... ok
test rad_id_private ... ok
test rad_fork ... ok
test rad_fetch ... ok
test rad_id_multi_delegate ... ok
test rad_id_threshold ... ok
test rad_id_unknown_field ... ok
test rad_init ... ignored, part of many other tests
test rad_id_update_delete_field ... ok
test rad_init_detached_head ... ok
test rad_init_bare ... ok
test rad_id_threshold_soft_fork ... ok
test rad_init_existing ... ok
test rad_init_existing_bare ... ok
test rad_init_no_git ... ok
test rad_init_no_seed ... ok
test rad_init_private ... ok
test rad_init_private_no_seed ... ok
test rad_init_private_clone ... ok
test rad_inbox ... ok
test rad_init_private_clone_seed ... ok
test rad_init_private_seed ... ok
test rad_init_sync_not_connected ... 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_init_sync_timeout ... ok
test rad_node_connect_without_address ... ok
test rad_patch_ahead_behind ... ok
test rad_patch ... ok
test rad_patch_change_base ... ok
test rad_patch_checkout ... ok
test rad_patch_detached_head ... ok
test rad_patch_checkout_revision ... 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 ... FAILED
test rad_patch_merge_draft ... ok
test rad_patch_fetch_1 ... ok
test rad_patch_revert_merge ... ok
test rad_patch_delete ... ok
test rad_patch_update ... ok
test rad_patch_via_push ... FAILED
test rad_patch_open_explore ... ok
test rad_publish ... 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_seed_many ... ok
test rad_self ... ok
test rad_push_and_pull_patches ... ok
test rad_unseed ... ok
test rad_unseed_many ... ok
test rad_sync_without_node ... ok
test rad_warn_old_nodes ... 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_push_canonical_lightweight_tags stdout ----
1758816700 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-hg2Xri/work/alice"]
1758816700 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-hg2Xri/work/alice`..
1758816701 test: rad-init.md: Running `/workspace/cache/debug/rad` with ["init"] in `/tmp/radicle-hg2Xri/work/alice`..
1758816701 test: rad-init.md: Running `/workspace/cache/debug/rad` with ["ls"] in `/tmp/radicle-hg2Xri/work/alice`..
1758816701 test: rad-init.md: Running `/workspace/cache/debug/rad` with ["node", "inventory"] in `/tmp/radicle-hg2Xri/work/alice`..
1758816701 git_push_canonical_lightweight_tags node: Opening policy database..
1758816701 git_push_canonical_lightweight_tags node: Default seeding policy set to 'block (all)'
1758816701 git_push_canonical_lightweight_tags node: Initializing service (Test)..
1758816701 git_push_canonical_lightweight_tags node: Opening node database..
1758816701 git_push_canonical_lightweight_tags node: Address book is empty. Adding bootstrap nodes..
1758816701 git_push_canonical_lightweight_tags node: 0 nodes added to address book
1758816701 git_push_canonical_lightweight_tags service: Init @1758816701231
1758816701 git_push_canonical_lightweight_tags service: Empty refs database, populating from storage..
1758816701 git_push_canonical_lightweight_tags service: Saved local sync status for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji..
1758816701 git_push_canonical_lightweight_tags service: Adding refs announcement for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji to historical gossip messages..
1758816701 git_push_canonical_lightweight_tags service: Not enough available peers to connect to (available=0, wanted=8)
1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> node: Listening on 0.0.0.0:38471..
1758816701 git_push_canonical_lightweight_tags node: Binding control socket /tmp/radicle-hg2Xri/home/alice/.radicle/node/control.sock..
1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <runtime> node: Running node z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi in /tmp/radicle-hg2Xri/home/alice/.radicle..
1758816701 git_push_canonical_lightweight_tags node: Opening policy database..
1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <control> control: Control thread listening on socket..
1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <signals> node: Signal notifications channel error: receiving on an empty and disconnected channel
1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Received command QueryState(..)
1758816701 git_push_canonical_lightweight_tags node: Default seeding policy set to 'block (all)'
1758816701 git_push_canonical_lightweight_tags node: Initializing service (Test)..
1758816701 git_push_canonical_lightweight_tags node: Opening node database..
1758816701 git_push_canonical_lightweight_tags node: Address book is empty. Adding bootstrap nodes..
1758816701 git_push_canonical_lightweight_tags node: 0 nodes added to address book
1758816701 git_push_canonical_lightweight_tags service: Init @1758816701484
1758816701 git_push_canonical_lightweight_tags service: Empty refs database, populating from storage..
1758816701 git_push_canonical_lightweight_tags service: Not enough available peers to connect to (available=0, wanted=8)
1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> node: Listening on 0.0.0.0:36157..
1758816701 git_push_canonical_lightweight_tags node: Binding control socket /tmp/radicle-hg2Xri/home/bob/.radicle/node/control.sock..
1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <runtime> node: Running node z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk in /tmp/radicle-hg2Xri/home/bob/.radicle..
1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control> control: Control thread listening on socket..
1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received command QueryState(..)
1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <signals> node: Signal notifications channel error: receiving on an empty and disconnected channel
1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received command QueryState(..)
1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received command Connect(z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi, 0.0.0.0:38471, ConnectOptions { persistent: false, timeout: 30s })
1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Connecting to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (0.0.0.0:38471)..
1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Attempted connection to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (0.0.0.0:38471)
1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Inbound connection from 127.0.0.1:53428 (fd=183)..
1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> wire: Registering outbound transport for z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (fd=182)..
1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> wire: Outbound peer resource registered for z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi with id=2 (fd=182)
1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Accepted inbound connection from 127.0.0.1:53428 (fd=183)..
1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Inbound peer resource registered with id=2 (fd=183)
1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> wire: Session established with z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (id=2) (fd=182) (outbound)
1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Connected to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (0.0.0.0:38471) (Outbound)
1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Subscribing to messages since timestamp 1758730301685..
1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Session established with z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk (id=2) (fd=183) (inbound)
1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Connected to z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk (127.0.0.1:53428) (Inbound)
1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Subscribing to messages since timestamp 1758730301685..
1758816701 test: Node z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi has converged
1758816701 test: Node has missing routes: [(RepoId(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji), PublicKey(z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi))]
1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received node announcement of z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi with 0 address(es) from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (t=1758816701231)
1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Received node announcement of z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk with 0 address(es) from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk (t=1758816701484)
1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Stored announcement from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk to be broadcast in 0 millisecond(s) (t=1758816701484)
1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Stored announcement from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi to be broadcast in 0 millisecond(s) (t=1758816701231)
1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Address store entry for node z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk updated at 1758816701484
1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Address store entry for node z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi updated at 1758816701231
1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Received inventory announcement of z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk with 0 item(s) from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk (t=1758816701485)
1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received inventory announcement of z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi with 1 item(s) from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (t=1758816701233)
1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Stored announcement from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi to be broadcast in 0 millisecond(s) (t=1758816701233)
1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Stored announcement from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk to be broadcast in 0 millisecond(s) (t=1758816701485)
1758816701 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Received subscription filter from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk
1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Routing table updated for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji with seed z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received subscription filter from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
1758816701 test: Node z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk has converged
1758816701 test: Running `rad clone ["rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji"]` in /tmp/radicle-hg2Xri/work/bob..
1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control> control: Received `{"command":"status"}` on control socket
1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control> control: Received `{"command":"seed","rid":"rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji","scope":"all"}` on control socket
1758816701 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received command Seed(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji, all)
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Sending subscription filter to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
1758816702 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Received subscription filter from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control> control: Received `{"command":"seeds","rid":"rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji"}` on control socket
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received command Seeds(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji)
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Found 1 connected seed(s) and 0 disconnected seed(s) for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control> control: Received `{"command":"session","nid":"z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi"}` on control socket
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received command QueryState(..)
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control> control: Received `{"command":"fetch","rid":"rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji","nid":"z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi","timeout":{"secs":9,"nanos":0}}` on control socket
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received command Fetch(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji, z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi)
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Fetch initiated for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji with z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi [outbound connected] (all remotes)..
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> wire: Opened new stream with id 12 for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji and remote z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> worker: Worker processing outgoing fetch for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
1758816702 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Received `open` command for stream 12 from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk
1758816702 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <worker#0> worker: Worker processing incoming fetch for z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk on stream 12..
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> worker: z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk cloning from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
1758816702 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <worker#0> worker: Spawning upload-pack process for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji on stream 12..
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> fetch: Fetched rad/id (17ms)
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> fetch: Fetched data for 1 remote(s) (38ms)
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> fetch: Fetched data refs for 1 remotes (51ms)
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> fetch: Sent done signal to remote z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
1758816702 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Received `end-of-file` on stream 12 from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk
1758816702 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <upload-pack> worker: Exiting upload-pack reader thread for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
1758816702 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <worker#0> worker: Upload pack finished (60ms)
1758816702 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <worker#0> worker: Upload process on stream 12 exited with result Ok(())
1758816702 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Received fetch result from worker for stream 12, remote z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk: Responder { rid: Some(RepoId(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji)), result: Ok(()) }
1758816702 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Stream 12 of z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk closing with 0 byte(s) sent and 0 byte(s) received
1758816702 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Peer z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk fetched rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji from us successfully
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> wire: Received `close` command for stream 12 from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> fetch: Validated 1 remote(s) (53ms)
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> wire: Stream 12 of z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi closed with 0 byte(s) sent and 0 byte(s) received
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> fetch: Applied updates (55ms)
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> fetch: Finished clone of rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (64ms)
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> cob: Loading object of type xyz.radicle.id at 0656c217f917c3e06234771e9ecae53aba5e173e
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> storage: Setting ref: refs/rad/id -> 0656c217f917c3e06234771e9ecae53aba5e173e
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> storage: Setting ref: refs/heads/master -> f2de534b5e81d7c6e2dcaf58c3dd91573c0a0354
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> storage: Setting ref: HEAD -> refs/heads/master
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> cob: Loading object of type xyz.radicle.id at 0656c217f917c3e06234771e9ecae53aba5e173e
1758816702 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) }], canonical: UpdatedCanonicalRefs { inner: {Qualified(RefString("refs/heads/master")): Oid(f2de534b5e81d7c6e2dcaf58c3dd91573c0a0354)} }, 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 } } }) }
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Found existing fetch request from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi, sending result..
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Sent fetch result for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi..
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Fetched rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi successfully
1758816702 test: rad clone: ✓ Seeding policy updated for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji with scope 'all'
1758816702 test: rad clone: Fetching rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji from the network, found 1 potential seed(s).
1758816702 test: rad clone: ✓ Target met: 1 seed(s)
1758816702 test: rad clone: ✓ Creating checkout in ./heartwood..
1758816702 test: rad clone: ✓ Remote alice@z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi added
1758816702 test: rad clone: ✓ Remote-tracking branch alice@z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/master created for z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
1758816702 test: rad clone: ✓ Repository successfully cloned under /tmp/radicle-hg2Xri/work/bob/heartwood/
1758816702 test: rad clone: ╭────────────────────────────────────╮
1758816702 test: rad clone: │ heartwood │
1758816702 test: rad clone: │ Radicle Heartwood Protocol & Stack │
1758816702 test: rad clone: │ 0 issues · 0 patches │
1758816702 test: rad clone: ╰────────────────────────────────────╯
1758816702 test: rad clone: Run `cd ./heartwood` to go to the repository directory.
1758816702 test: Ran command `rad clone` (status=0)
1758816702 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-hg2Xri"]
1758816702 test: git-push-canonical-lightweight-tags.md: Running `/workspace/cache/debug/rad` with ["id", "update", "--title", "Add canonical reference rules", "--payload", "xyz.radicle.crefs", "rules", "{ \"refs/tags/*\": { \"threshold\": 1, \"allow\": \"delegates\" }, \"refs/tags/qa/*\": { \"threshold\": 1, \"allow\": \"delegates\" }}"] in `/tmp/radicle-hg2Xri/work/alice`..
1758816702 test: git-push-canonical-lightweight-tags.md: Running `git` with ["tag", "v1.0-hotfix"] in `/tmp/radicle-hg2Xri/work/alice`..
1758816702 test: git-push-canonical-lightweight-tags.md: Running `git` with ["push", "rad", "--tags"] in `/tmp/radicle-hg2Xri/work/alice`..
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Ref updated: * 0000000..0656c21 refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/rad/id for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Ref updated: * 0000000..99c5497 refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/rad/sigrefs for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Ref updated: * 0000000..0656c21 refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/cobs/xyz.radicle.id/0656c217f917c3e06234771e9ecae53aba5e173e for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Ref updated: * 0000000..f2de534 refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/heads/master for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Ref updated: * 0000000..0656c21 refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/rad/root for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Updating and announcing inventory for cloned repository rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji..
1758816702 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <control> control: Received `{"command":"status"}` on control socket
1758816702 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <control> control: Received `{"command":"seeds","rid":"rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji"}` on control socket
1758816702 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Received command Seeds(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji)
1758816702 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Found 0 connected seed(s) and 1 disconnected seed(s) for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
thread 'git_push_canonical_lightweight_tags' panicked at crates/radicle-cli-test/src/lib.rs:489:36:
--- Expected
++++ actual: stderr
1 1 | ✓ Canonical reference refs/tags/v1.0-hotfix updated to target commit f2de534b5e81d7c6e2dcaf58c3dd91573c0a0354
2 - ✓ Synced with 1 seed(s)
2 + No seeds found for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji.
3 3 | To rad://z42hL2jL4XNk6K8oHQaSWfMgCL7ji/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
4 4 | * [new tag] v1.0-hotfix -> v1.0-hotfix
Exit status: 0
note: run with `RUST_BACKTRACE=1` environment variable to display a backtrace
1758816702 test: Node z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk shutting down..
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control> control: Received `{"command":"shutdown"}` on control socket
1758816702 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control> control: Shutdown requested..
1758816703 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Sending inventory announcement of z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk with 1 item(s) to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (t=1758816702454)
1758816703 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Sending refs announcement of z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji with 1 remote(s) to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (t=1758816702455)
1758816703 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Disconnecting peer with id=2: connection reset
1758816703 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Transport handover for disconnecting peer with id=2 (fd=183)
1758816703 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Disconnected from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk (connection reset)
1758816703 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Dropping peer z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk..
1758816703 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <runtime> pool: Worker pool shutting down..
1758816703 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <runtime> node: Node shutdown completed for z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk
1758816703 test: Node z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi shutting down..
1758816703 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <control> control: Received `{"command":"shutdown"}` on control socket
1758816703 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <control> control: Shutdown requested..
1758816703 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <runtime> pool: Worker pool shutting down..
1758816703 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <runtime> node: Node shutdown completed for z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
---- rad_patch_fetch_2 stdout ----
1758816751 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-pKhn1U/work/alice"]
1758816751 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-pKhn1U/work/alice`..
1758816751 test: rad-init.md: Running `/workspace/cache/debug/rad` with ["init"] in `/tmp/radicle-pKhn1U/work/alice`..
1758816751 test: rad-init.md: Running `/workspace/cache/debug/rad` with ["ls"] in `/tmp/radicle-pKhn1U/work/alice`..
1758816751 test: rad-init.md: Running `/workspace/cache/debug/rad` with ["node", "inventory"] in `/tmp/radicle-pKhn1U/work/alice`..
1758816751 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-pKhn1U/work/alice"]
1758816751 test: rad-patch-fetch-2.md: Running `git` with ["checkout", "-b", "alice/1", "-q"] in `/tmp/radicle-pKhn1U/work/alice`..
1758816751 test: rad-patch-fetch-2.md: Running `git` with ["commit", "--allow-empty", "-m", "Changes #1", "-q"] in `/tmp/radicle-pKhn1U/work/alice`..
1758816751 test: rad-patch-fetch-2.md: Running `git` with ["push", "rad", "-o", "patch.message=Changes", "HEAD:refs/patches"] in `/tmp/radicle-pKhn1U/work/alice`..
1758816752 test: rad-patch-fetch-2.md: Running `git` with ["checkout", "master", "-q"] in `/tmp/radicle-pKhn1U/work/alice`..
1758816752 test: rad-patch-fetch-2.md: Running `git` with ["branch", "-D", "alice/1", "-q"] in `/tmp/radicle-pKhn1U/work/alice`..
1758816752 test: rad-patch-fetch-2.md: Running `git` with ["update-ref", "-d", "refs/remotes/rad/alice/1"] in `/tmp/radicle-pKhn1U/work/alice`..
1758816752 test: rad-patch-fetch-2.md: Running `git` with ["update-ref", "-d", "refs/remotes/rad/patches/5e2dedcc5d515fcbc1cca483d3376609fe889bfb"] in `/tmp/radicle-pKhn1U/work/alice`..
1758816752 test: rad-patch-fetch-2.md: Running `git` with ["gc", "--prune=now"] in `/tmp/radicle-pKhn1U/work/alice`..
1758816752 test: rad-patch-fetch-2.md: Running `git` with ["branch", "-r"] in `/tmp/radicle-pKhn1U/work/alice`..
1758816752 test: rad-patch-fetch-2.md: Running `git` with ["pull"] in `/tmp/radicle-pKhn1U/work/alice`..
1758816752 test: rad-patch-fetch-2.md: Running `git` with ["branch", "-r"] in `/tmp/radicle-pKhn1U/work/alice`..
thread 'rad_patch_fetch_2' panicked at crates/radicle-cli-test/src/lib.rs:491:36:
--- Expected
++++ actual: stdout
1 - rad/HEAD -> rad/master
2 1 | rad/master
3 2 | rad/patches/5e2dedcc5d515fcbc1cca483d3376609fe889bfb
Exit status: 0
---- rad_patch_via_push stdout ----
1758816755 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-Tr8UKL/work/alice"]
1758816755 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-Tr8UKL/work/alice`..
1758816756 test: rad-init.md: Running `/workspace/cache/debug/rad` with ["init"] in `/tmp/radicle-Tr8UKL/work/alice`..
1758816756 test: rad-init.md: Running `/workspace/cache/debug/rad` with ["ls"] in `/tmp/radicle-Tr8UKL/work/alice`..
1758816756 test: rad-init.md: Running `/workspace/cache/debug/rad` with ["node", "inventory"] in `/tmp/radicle-Tr8UKL/work/alice`..
1758816756 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-Tr8UKL/work/alice"]
1758816756 test: rad-patch-via-push.md: Running `git` with ["checkout", "-b", "feature/1"] in `/tmp/radicle-Tr8UKL/work/alice`..
1758816756 test: rad-patch-via-push.md: Running `git` with ["commit", "-a", "-m", "Add things", "-q", "--allow-empty"] in `/tmp/radicle-Tr8UKL/work/alice`..
1758816756 test: rad-patch-via-push.md: Running `git` with ["push", "-o", "patch.message=Add things #1", "-o", "patch.message=See commits for details.", "rad", "HEAD:refs/patches"] in `/tmp/radicle-Tr8UKL/work/alice`..
1758816756 test: rad-patch-via-push.md: Running `/workspace/cache/debug/rad` with ["patch", "show", "6035d2f582afbe01ff23ea87528ae523d76875b6"] in `/tmp/radicle-Tr8UKL/work/alice`..
1758816756 test: rad-patch-via-push.md: Running `git` with ["branch", "-vv"] in `/tmp/radicle-Tr8UKL/work/alice`..
1758816756 test: rad-patch-via-push.md: Running `git` with ["status", "--short", "--branch"] in `/tmp/radicle-Tr8UKL/work/alice`..
1758816756 test: rad-patch-via-push.md: Running `git` with ["fetch"] in `/tmp/radicle-Tr8UKL/work/alice`..
1758816756 test: rad-patch-via-push.md: Running `git` with ["push"] in `/tmp/radicle-Tr8UKL/work/alice`..
1758816756 test: rad-patch-via-push.md: Running `git` with ["show-ref"] in `/tmp/radicle-Tr8UKL/work/alice`..
thread 'rad_patch_via_push' panicked at crates/radicle-cli-test/src/lib.rs:491:36:
--- Expected
++++ actual: stdout
1 1 | 42d894a83c9c356552a57af09ccdbd5587a99045 refs/heads/feature/1
2 2 | f2de534b5e81d7c6e2dcaf58c3dd91573c0a0354 refs/heads/master
3 - f2de534b5e81d7c6e2dcaf58c3dd91573c0a0354 refs/remotes/rad/HEAD
4 3 | f2de534b5e81d7c6e2dcaf58c3dd91573c0a0354 refs/remotes/rad/master
5 4 | 42d894a83c9c356552a57af09ccdbd5587a99045 refs/remotes/rad/patches/6035d2f582afbe01ff23ea87528ae523d76875b6
Exit status: 0
failures:
git_push_canonical_lightweight_tags
rad_patch_fetch_2
rad_patch_via_push
test result: FAILED. 99 passed; 3 failed; 2 ignored; 0 measured; 0 filtered out; finished in 121.40s
error: test failed, to rerun pass `-p radicle-cli --test commands`
[2025-09-25T16:12:57Z ERROR ambient_ci::plan] ERROR: Action failed: failed to execute cargo
[2025-09-25T16:12:57Z ERROR ambient_ci::plan] caused by: command failed: "cargo": exit code 101
ERROR: failed to execute cargo
caused by: command failed: "cargo": exit code 101
EXIT CODE: 1
====================
[2025-09-25T16:12:59Z DEBUG ambient_ci::qemu] QEMU: CI run under exit code 1
[2025-09-25T16:13:00Z DEBUG ambient_ci::run] CI run exit code from QEMU: 1
[2025-09-25T16:13:00Z DEBUG ambient_ci::project] write project state to /srv/ambient-state/rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5/meta.yaml
ERROR: CI run failed inside QEMU
<empty log>