Radicle repository id rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5
[2025-09-30T18:34:37Z 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 30M 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-30 18:25 ./
-rw-r--r-- _rad/_rad 2450 2025-09-30 18:25 ./plan.yaml
-rwxr-xr-x _rad/_rad 6410400 2025-09-30 18:25 ./run-ci
INFO: Extracted files:
4587530 4 drwxr-xr-x 2 1001 1001 4096 Sep 30 18:25 .
4587526 4 -rw-r--r-- 1 1001 1001 2450 Sep 30 18:25 ./plan.yaml
4587527 6264 -rwxr-xr-x 1 1001 1001 6410400 Sep 30 18:25 ./run-ci
INFO: Running run-ci from /dev/vdb
================================ BEGIN ================================
[2025-09-30T18:27:22Z TRACE ambient_execute_plan] ambient-execute-plan version 0.7.0@14cdd4c starts
[2025-09-30T18:27:22Z DEBUG ambient_execute_plan] ambient-execute-plan version 0.7.0@14cdd4c starts
[2025-09-30T18:27:22Z INFO ambient_execute_plan] ambient-execute-plan version 0.7.0@14cdd4c starts
[2025-09-30T18:27:22Z WARN ambient_execute_plan] ambient-execute-plan version 0.7.0@14cdd4c starts
[2025-09-30T18:27:22Z ERROR ambient_execute_plan] ambient-execute-plan version 0.7.0@14cdd4c 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-30T18:27:22Z DEBUG ambient_ci::plan] RUN: Action Mkdir {
pathname: "/workspace",
}
[2025-09-30T18:27:22Z DEBUG ambient_ci::action] Plan::execute: plan=Mkdir {
pathname: "/workspace",
}
[2025-09-30T18:27:22Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_TARGET_DIR": "/workspace/cache",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
},
source_dir: "/workspace/src",
}
[2025-09-30T18:27:22Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-30T18:27:22Z DEBUG ambient_ci::plan] RUN: Action Mkdir {
pathname: "/workspace/artifacts",
}
[2025-09-30T18:27:22Z DEBUG ambient_ci::action] Plan::execute: plan=Mkdir {
pathname: "/workspace/artifacts",
}
[2025-09-30T18:27:22Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_TARGET_DIR": "/workspace/cache",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
},
source_dir: "/workspace/src",
}
[2025-09-30T18:27:22Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-30T18:27:22Z DEBUG ambient_ci::plan] RUN: Action TarExtract {
archive: "/dev/vdc",
directory: "/workspace/src",
}
[2025-09-30T18:27:22Z DEBUG ambient_ci::action] Plan::execute: plan=TarExtract {
archive: "/dev/vdc",
directory: "/workspace/src",
}
[2025-09-30T18:27:22Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_TARGET_DIR": "/workspace/cache",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
},
source_dir: "/workspace/src",
}
[2025-09-30T18:27:22Z TRACE ambient_ci::vdrive] extracting /dev/vdc to /workspace/src
[2025-09-30T18:27:23Z TRACE ambient_ci::vdrive] extraction OK
[2025-09-30T18:27:23Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-30T18:27:23Z DEBUG ambient_ci::plan] RUN: Action TarExtract {
archive: "/dev/vdf",
directory: "/workspace/deps",
}
[2025-09-30T18:27:23Z DEBUG ambient_ci::action] Plan::execute: plan=TarExtract {
archive: "/dev/vdf",
directory: "/workspace/deps",
}
[2025-09-30T18:27:23Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_TARGET_DIR": "/workspace/cache",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
},
source_dir: "/workspace/src",
}
[2025-09-30T18:27:23Z TRACE ambient_ci::vdrive] extracting /dev/vdf to /workspace/deps
[2025-09-30T18:27:51Z TRACE ambient_ci::vdrive] extraction OK
[2025-09-30T18:27:51Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-30T18:27:51Z DEBUG ambient_ci::plan] RUN: Action TarExtract {
archive: "/dev/vde",
directory: "/workspace/cache",
}
[2025-09-30T18:27:51Z DEBUG ambient_ci::action] Plan::execute: plan=TarExtract {
archive: "/dev/vde",
directory: "/workspace/cache",
}
[2025-09-30T18:27:51Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_TARGET_DIR": "/workspace/cache",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
},
source_dir: "/workspace/src",
}
[2025-09-30T18:27:51Z TRACE ambient_ci::vdrive] extracting /dev/vde to /workspace/cache
[2025-09-30T18:30:43Z TRACE ambient_ci::vdrive] extraction OK
[2025-09-30T18:30:43Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-30T18:30:43Z DEBUG ambient_ci::plan] RUN: Action Spawn {
argv: [
"find",
"/workspace",
"-maxdepth",
"2",
"-ls",
],
}
[2025-09-30T18:30:43Z DEBUG ambient_ci::action] Plan::execute: plan=Spawn {
argv: [
"find",
"/workspace",
"-maxdepth",
"2",
"-ls",
],
}
[2025-09-30T18:30:43Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_TARGET_DIR": "/workspace/cache",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
},
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 30 18:27 /workspace
2622401 4 drwxr-xr-x 3 root root 4096 Sep 30 18:25 /workspace/deps
2622402 0 -rw-r--r-- 1 root root 0 Sep 22 16:46 /workspace/deps/.package-cache-mutate
2622405 4 drwxr-xr-x 5 root root 4096 Sep 22 16:46 /workspace/deps/registry
2622403 128 -rw-r--r-- 1 root root 131072 Sep 30 18:25 /workspace/deps/.global-cache
2622404 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 30 18:25 /workspace/src
2621499 4 -rw-r--r-- 1 root root 2653 Sep 30 18:25 /workspace/src/Cargo.toml
2622397 12 -rw-r--r-- 1 root root 9636 Sep 30 18:25 /workspace/src/CONTRIBUTING.md
2621500 4 drwxr-xr-x 2 root root 4096 Sep 30 18:25 /workspace/src/.config
2621496 4 -rw-r--r-- 1 root root 1623 Sep 30 18:25 /workspace/src/build.rs
2621502 4 -rw-r--r-- 1 root root 426 Sep 30 18:25 /workspace/src/radicle-node.1.adoc
2621504 4 drwxr-xr-x 8 root root 4096 Sep 30 18:25 /workspace/src/.git
2622394 8 -rw-r--r-- 1 root root 7144 Sep 30 18:25 /workspace/src/rad-id.1.adoc
2621460 4 -rw-r--r-- 1 root root 2163 Sep 30 18:25 /workspace/src/VERSIONING.md
2621495 4 -rw-r--r-- 1 root root 3133 Sep 30 18:25 /workspace/src/README.md
2621802 12 -rw-r--r-- 1 root root 10975 Sep 30 18:25 /workspace/src/rad-patch.1.adoc
2622398 4 -rw-r--r-- 1 root root 79 Sep 30 18:25 /workspace/src/ARCHITECTURE.md
2621810 4 drwxr-xr-x 17 root root 4096 Sep 30 18:25 /workspace/src/crates
2621448 4 drwxr-xr-x 2 root root 4096 Sep 30 18:25 /workspace/src/scripts
2621444 4 drwxr-xr-x 2 root root 4096 Sep 30 18:25 /workspace/src/.radicle
2621467 16 -rw-r--r-- 1 root root 14022 Sep 30 18:25 /workspace/src/CHANGELOG.md
2621482 4 drwxr-xr-x 3 root root 4096 Sep 30 18:25 /workspace/src/debian
2621465 4 -rw-r--r-- 1 root root 42 Sep 30 18:25 /workspace/src/.envrc
2622395 4 -rw-r--r-- 1 root root 1203 Sep 30 18:25 /workspace/src/DCO
2622390 4 drwxr-xr-x 3 root root 4096 Sep 30 18:25 /workspace/src/.github
2622400 124 -rw-r--r-- 1 root root 122985 Sep 30 18:25 /workspace/src/Cargo.lock
2621803 4 drwxr-xr-x 5 root root 4096 Sep 30 18:25 /workspace/src/systemd
2621801 12 -rw-r--r-- 1 root root 9723 Sep 30 18:25 /workspace/src/LICENSE-APACHE
2621498 4 -rw-r--r-- 1 root root 101 Sep 30 18:25 /workspace/src/.gitignore
2622396 8 -rw-r--r-- 1 root root 5102 Sep 30 18:25 /workspace/src/flake.lock
2621464 4 -rw-r--r-- 1 root root 77 Sep 30 18:25 /workspace/src/rust-toolchain.toml
2621497 12 -rw-r--r-- 1 root root 10520 Sep 30 18:25 /workspace/src/flake.nix
2621468 4 -rw-r--r-- 1 root root 571 Sep 30 18:25 /workspace/src/git-remote-rad.1.adoc
2621466 4 -rw-r--r-- 1 root root 61 Sep 30 18:25 /workspace/src/.env.seed
2621503 8 -rw-r--r-- 1 root root 5432 Sep 30 18:25 /workspace/src/deny.toml
2621458 8 -rw-r--r-- 1 root root 7645 Sep 30 18:25 /workspace/src/HACKING.md
2621447 4 -rw-r--r-- 1 root root 1079 Sep 30 18:25 /workspace/src/LICENSE-MIT
2621463 8 -rw-r--r-- 1 root root 8023 Sep 30 18:25 /workspace/src/rad.1.adoc
2621469 4 drwxr-xr-x 2 root root 4096 Sep 30 18:25 /workspace/src/build
2622399 4 -rw-r--r-- 1 root root 1083 Sep 30 18:25 /workspace/src/.gitsigners
2621459 4 -rw-r--r-- 1 root root 30 Sep 30 18:25 /workspace/src/.dockerignore
2621461 4 drwxr-xr-x 2 root root 4096 Sep 30 18:25 /workspace/src/.cargo
2621442 4 drwxr-xr-x 2 root root 4096 Sep 30 18:27 /workspace/artifacts
2650449 4 drwxr-xr-x 6 root root 4096 Sep 22 23:09 /workspace/cache
2669144 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
2650451 4 drwxr-xr-x 7 root root 4096 Sep 24 10:43 /workspace/cache/debug
2650450 4 drwxr-xr-x 2 root root 4096 Sep 22 23:02 /workspace/cache/tmp
2669145 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-30T18:30:44Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-30T18:30:44Z DEBUG ambient_ci::plan] RUN: Action CargoFmt
[2025-09-30T18:30:44Z DEBUG ambient_ci::action] Plan::execute: plan=CargoFmt
[2025-09-30T18:30:44Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_TARGET_DIR": "/workspace/cache",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
},
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-30T18:30:46Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-30T18:30:46Z DEBUG ambient_ci::plan] RUN: Action CargoClippy
[2025-09-30T18:30:46Z DEBUG ambient_ci::action] Plan::execute: plan=CargoClippy
[2025-09-30T18:30:46Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_TARGET_DIR": "/workspace/cache",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
},
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 radicle-signals v0.11.0 (/workspace/src/crates/radicle-signals)
Compiling portable-atomic v1.11.0
Checking unicode-width v0.2.1
Checking unit-prefix v0.5.1
Checking pin-project-lite v0.2.16
Checking value-bag-serde1 v1.11.1
Checking serde-untagged v0.1.7
Checking value-bag v1.11.1
Checking console v0.16.0
Checking tokio v1.47.1
Checking log v0.4.27
Compiling radicle-node v0.15.0 (/workspace/src/crates/radicle-node)
Checking prodash v29.0.2
Checking git2 v0.19.0
Checking mio v1.0.4
Checking gix-features v0.39.1
Checking mio v0.8.11
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-revwalk v0.17.0
Checking gix-url v0.28.2
Checking gix-revision v0.31.1
Checking gix-traverse v0.43.1
Checking gix-diff v0.49.0
Checking gix-refspec v0.27.0
Checking gix-pack v0.56.0
Checking radicle-git-ext v0.8.1
Checking gix-transport v0.44.0
Checking gix-credentials v0.26.0
Checking radicle-crypto v0.13.0 (/workspace/src/crates/radicle-crypto)
Checking gix-negotiate v0.17.0
Checking gix-shallow v0.1.0
Checking gix-ref v0.49.1
Checking signal-hook-mio v0.2.4
Checking crossterm v0.25.0
Checking radicle-cob v0.16.0 (/workspace/src/crates/radicle-cob)
Checking gix-odb v0.66.0
Checking gix-protocol v0.47.0
Checking radicle v0.19.0 (/workspace/src/crates/radicle)
Checking indicatif v0.18.0
Checking inquire v0.7.5
Checking crossterm v0.29.0
Checking systemd-journal-logger v2.2.2
Checking os_info v3.12.0
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-schemars v0.5.0 (/workspace/src/crates/radicle-schemars)
Checking radicle-protocol v0.3.0 (/workspace/src/crates/radicle-protocol)
Finished `dev` profile [unoptimized + debuginfo] target(s) in 28.58s
[2025-09-30T18:31:15Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-30T18:31:15Z DEBUG ambient_ci::plan] RUN: Action CargoBuild
[2025-09-30T18:31:15Z DEBUG ambient_ci::action] Plan::execute: plan=CargoBuild
[2025-09-30T18:31:15Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_TARGET_DIR": "/workspace/cache",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
},
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 radicle-signals v0.11.0 (/workspace/src/crates/radicle-signals)
Compiling unicode-width v0.2.1
Compiling portable-atomic v1.11.0
Compiling console v0.16.0
Compiling unit-prefix v0.5.1
Compiling value-bag-serde1 v1.11.1
Compiling serde-untagged v0.1.7
Compiling value-bag v1.11.1
Compiling pin-project-lite v0.2.16
Compiling indicatif v0.18.0
Compiling tokio v1.47.1
Compiling log v0.4.27
Compiling radicle-cli v0.16.0 (/workspace/src/crates/radicle-cli)
Compiling radicle-node v0.15.0 (/workspace/src/crates/radicle-node)
Compiling prodash v29.0.2
Compiling git2 v0.19.0
Compiling gix-features v0.39.1
Compiling mio v1.0.4
Compiling gix-object v0.46.1
Compiling gix-commitgraph v0.25.1
Compiling gix-fs v0.12.1
Compiling gix-revwalk v0.17.0
Compiling gix-tempfile v15.0.0
Compiling gix-lock v15.0.1
Compiling gix-url v0.28.2
Compiling radicle-git-ext v0.8.1
Compiling gix-revision v0.31.1
Compiling radicle-crypto v0.13.0 (/workspace/src/crates/radicle-crypto)
Compiling gix-traverse v0.43.1
Compiling gix-diff v0.49.0
Compiling mio v0.8.11
Compiling gix-pack v0.56.0
Compiling radicle-cob v0.16.0 (/workspace/src/crates/radicle-cob)
Compiling signal-hook-mio v0.2.4
Compiling gix-refspec v0.27.0
Compiling gix-transport v0.44.0
Compiling radicle v0.19.0 (/workspace/src/crates/radicle)
Compiling gix-credentials v0.26.0
Compiling gix-shallow v0.1.0
Compiling gix-ref v0.49.1
Compiling gix-negotiate v0.17.0
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 os_info v3.12.0
Compiling radicle-surf v0.22.0
Compiling human-panic v2.0.3
Compiling radicle-term v0.15.0 (/workspace/src/crates/radicle-term)
Compiling radicle-systemd v0.10.0 (/workspace/src/crates/radicle-systemd)
Compiling structured-logger v1.0.4
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 22s
[2025-09-30T18:32:39Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-30T18:32:39Z DEBUG ambient_ci::plan] RUN: Action CargoTest
[2025-09-30T18:32:39Z DEBUG ambient_ci::action] Plan::execute: plan=CargoTest
[2025-09-30T18:32:39Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_TARGET_DIR": "/workspace/cache",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
},
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.89s
Running unittests src/lib.rs (/workspace/cache/debug/deps/radicle-f412a4d7b87c45b5)
running 238 tests
test canonical::formatter::test::ascii_control_characters ... ok
test canonical::formatter::test::securesystemslib_asserts ... ok
test canonical::formatter::test::ordered_nested_object ... ok
test cob::cache::migrations::_2::tests::test_migration_2 ... ok
test cob::cache::migrations::_2::tests::test_patch_json_deserialization ... ok
test cob::cache::tests::test_check_version ... 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_remove_delegate_concurrent ... ok
test cob::identity::test::test_identity_update_rejected ... ok
test cob::identity::test::test_identity_reject_concurrent ... ok
test cob::identity::test::test_identity_updates ... ok
test cob::issue::cache::tests::test_counts ... ok
test cob::issue::cache::tests::test_get ... ok
test cob::issue::cache::tests::test_is_empty ... ok
test cob::issue::cache::tests::test_list ... ok
test cob::issue::cache::tests::test_list_by_status ... ok
test cob::issue::cache::tests::test_remove ... ok
test cob::identity::test::test_identity_updates_concurrent ... ok
test cob::identity::test::test_valid_identity ... ok
test cob::issue::test::test_embeds ... ok
test cob::identity::test::test_identity_updates_concurrent_outdated ... ok
test cob::issue::test::test_embeds_edit ... ok
test cob::issue::test::test_invalid_actions ... ok
test cob::issue::test::test_invalid_tx ... ok
test cob::issue::test::test_invalid_cob ... ok
test cob::issue::test::test_invalid_tx_reference ... ok
test cob::issue::test::test_issue_all ... ok
test cob::issue::test::test_concurrency ... ok
test cob::issue::test::test_issue_comment ... ok
test cob::issue::test::test_issue_create_and_assign ... ok
test cob::issue::test::test_issue_comment_redact ... ok
test cob::issue::test::test_issue_create_and_get ... ok
test cob::issue::test::test_issue_create_and_change_state ... ok
test cob::issue::test::test_issue_create_and_reassign ... ok
test cob::issue::test::test_issue_create_and_unassign ... 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::patch::cache::tests::test_list ... ok
test cob::patch::cache::tests::test_list_by_status ... ok
test cob::issue::test::test_issue_reply ... 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::cache::tests::test_remove ... 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::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::cache::tests::test_counts ... 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_from_until ... ok
test cob::stream::tests::test_all_until ... ok
test cob::stream::tests::test_regression_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::cache::tests::test_find_by_revision ... 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_rule_validate_failures ... 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::rules::tests::test_canonical ... ok
test git::canonical::tests::test_quorum_different_types ... 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 cob::patch::test::test_patch_update ... 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 cob::thread::tests::prop_ordering ... 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::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_alias ... ok
test node::policy::store::test::test_update_scope ... ok
test node::refs::store::test::test_count ... ok
test node::refs::store::test::test_set_and_delete ... ok
test node::address::store::test::test_empty ... ok
test node::refs::store::test::test_set_and_get ... ok
test node::routing::test::test_count ... ok
test node::routing::test::test_insert_and_get ... ok
test node::routing::test::test_entries ... 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_and_remove ... 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::routing::test::test_prune ... ok
test node::sync::announce::test::announcer_preferred_seeds_or_replica_factor ... 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_synced_with_unknown_node ... ok
test node::sync::announce::test::announcer_reached_preferred_seeds ... 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::could_not_reach_target ... ok
test node::sync::fetch::test::ignores_duplicates_and_local_node ... ok
test node::sync::fetch::test::all_nodes_are_fetchable ... ok
test node::sync::fetch::test::preferred_seeds_target_returned_over_replicas ... ok
test node::sync::fetch::test::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 rad::tests::test_checkout ... ok
test git::canonical::tests::test_quorum_properties ... ok
test rad::tests::test_fork ... ok
test serde_ext::test::test_localtime ... ok
test serde_ext::test::test_localtime_ext ... ok
test rad::tests::test_init ... 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.66s
Running unittests src/lib.rs (/workspace/cache/debug/deps/radicle_cli-90e0b7158ea35ad9)
running 14 tests
test commands::patch::review::builder::tests::test_review_comments_multiline ... ok
test commands::patch::review::builder::tests::test_review_comments_before ... 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::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 git::ddiff::tests::diff_encode_decode_ddiff_hunk ... 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.04s
Running unittests src/main.rs (/workspace/cache/debug/deps/rad-7a737c56230fb7bd)
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-bba39495eb4efa81)
running 109 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 rad_block ... ok
test git_tag ... ok
test rad_auth ... ok
test rad_checkout ... ok
test git_push_converge ... ok
test rad_clone ... ok
test rad_clean ... ok
test rad_clone_bare ... ok
test rad_clone_all ... ok
test rad_clone_unknown ... ok
test rad_clone_directory ... ok
test rad_clone_connect ... 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_help ... ok
test rad_id_collaboration ... ignored, slow
test rad_id ... ok
test rad_id_conflict ... ok
test rad_id_private ... ok
test rad_fetch ... ok
test rad_fork ... ok
test rad_id_multi_delegate ... ok
test rad_id_unknown_field ... ok
test rad_id_update_delete_field ... ok
test rad_init ... ignored, part of many other tests
test rad_id_threshold_soft_fork ... ok
test rad_init_bare ... ok
test rad_id_threshold ... ok
test rad_init_detached_head ... ok
test rad_init_existing ... ok
test rad_init_no_git ... ok
test rad_init_existing_bare ... ok
test rad_init_no_seed ... ok
test rad_init_private ... ok
test rad_init_private_no_seed ... ok
test rad_inbox ... ok
test rad_init_private_clone ... ok
test rad_init_private_clone_seed ... ok
test rad_init_sync_not_connected ... ok
test rad_init_private_seed ... ok
test rad_init_with_existing_remote ... ok
test rad_init_sync_preferred ... ok
test rad_inspect ... ok
test rad_issue ... ok
test rad_jj_bare ... ok
test rad_jj_colocated_patch ... ok
test rad_issue_list ... ok
test rad_key_mismatch ... ok
test rad_merge_no_ff ... ok
test rad_merge_after_update ... ok
test rad_merge_via_push ... ok
test rad_init_sync_and_clone ... ok
test rad_node ... ok
test rad_init_sync_timeout ... ok
test rad_node_connect ... ok
test rad_node_connect_without_address ... ok
test rad_patch_ahead_behind ... ok
test rad_patch_change_base ... ok
test rad_patch ... ok
test rad_patch_checkout ... ok
test rad_patch_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_publish ... ok
test rad_patch_open_explore ... ok
test rad_review_by_hunk ... ok
test rad_seed_and_follow ... ok
test rad_patch_pull_update ... ok
test rad_self ... ok
test rad_push_and_pull_patches ... ok
test rad_remote ... ok
test rad_seed_many ... 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_sync ... ok
test rad_watch ... 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 ----
1759257197 [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-OFY61L/work/alice"][0m
1759257197 [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-OFY61L/work/alice`..[0m
1759257198 [36mtest:[0m [36mrad-init.md: Running `/workspace/cache/debug/rad` with ["init"] in `/tmp/radicle-OFY61L/work/alice`..[0m
1759257198 [36mtest:[0m [36mrad-init.md: Running `/workspace/cache/debug/rad` with ["ls"] in `/tmp/radicle-OFY61L/work/alice`..[0m
1759257198 [36mtest:[0m [36mrad-init.md: Running `/workspace/cache/debug/rad` with ["node", "inventory"] in `/tmp/radicle-OFY61L/work/alice`..[0m
[2m1759257198 git_push_canonical_lightweight_tags node: Opening policy database..[0m
[2m1759257198 git_push_canonical_lightweight_tags node: Default seeding policy set to 'block (all)'[0m
[2m1759257198 git_push_canonical_lightweight_tags node: Initializing service (Test)..[0m
[2m1759257198 git_push_canonical_lightweight_tags node: Opening node database..[0m
[2m1759257198 git_push_canonical_lightweight_tags node: Address book is empty. Adding bootstrap nodes..[0m
[2m1759257198 git_push_canonical_lightweight_tags node: 0 nodes added to address book[0m
[2m1759257198 git_push_canonical_lightweight_tags service: Init @1759257198161[0m
[2m1759257198 git_push_canonical_lightweight_tags service: Empty refs database, populating from storage..[0m
[2m1759257198 git_push_canonical_lightweight_tags service: Saved local sync status for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji..[0m
[2m1759257198 git_push_canonical_lightweight_tags service: Adding refs announcement for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji to historical gossip messages..[0m
[2m1759257198 git_push_canonical_lightweight_tags service: Not enough available peers to connect to (available=0, wanted=8)[0m
[2m1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> node: Listening on 0.0.0.0:34091..[0m
[2m1759257198 git_push_canonical_lightweight_tags node: Binding control socket /tmp/radicle-OFY61L/home/alice/.radicle/node/control.sock..[0m
[2m1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <runtime> node: Running node z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi in /tmp/radicle-OFY61L/home/alice/.radicle..[0m
[2m1759257198 git_push_canonical_lightweight_tags node: Opening policy database..[0m
[2m1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <control> control: Control thread listening on socket..[0m
[33m1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <signals> node: Signal notifications channel error: receiving on an empty and disconnected channel[0m
[2m1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Received command QueryState(..)[0m
[2m1759257198 git_push_canonical_lightweight_tags node: Default seeding policy set to 'block (all)'[0m
[2m1759257198 git_push_canonical_lightweight_tags node: Initializing service (Test)..[0m
[2m1759257198 git_push_canonical_lightweight_tags node: Opening node database..[0m
[2m1759257198 git_push_canonical_lightweight_tags node: Address book is empty. Adding bootstrap nodes..[0m
[2m1759257198 git_push_canonical_lightweight_tags node: 0 nodes added to address book[0m
[2m1759257198 git_push_canonical_lightweight_tags service: Init @1759257198433[0m
[2m1759257198 git_push_canonical_lightweight_tags service: Empty refs database, populating from storage..[0m
[2m1759257198 git_push_canonical_lightweight_tags service: Not enough available peers to connect to (available=0, wanted=8)[0m
[2m1759257198 git_push_canonical_lightweight_tags node: Binding control socket /tmp/radicle-OFY61L/home/bob/.radicle/node/control.sock..[0m
[2m1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <runtime> node: Running node z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk in /tmp/radicle-OFY61L/home/bob/.radicle..[0m
[2m1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received command QueryState(..)[0m
[2m1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control> control: Control thread listening on socket..[0m
[2m1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> node: Listening on 0.0.0.0:41711..[0m
[33m1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <signals> node: Signal notifications channel error: receiving on an empty and disconnected channel[0m
[2m1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received command QueryState(..)[0m
[2m1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received command Connect(z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi, 0.0.0.0:34091, ConnectOptions { persistent: false, timeout: 30s })[0m
[2m1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Connecting to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (0.0.0.0:34091)..[0m
[2m1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Attempted connection to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (0.0.0.0:34091)[0m
[2m1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> wire: Registering outbound transport for z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (fd=7)..[0m
[2m1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> wire: Outbound peer resource registered for z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi with id=2 (fd=7)[0m
[2m1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Inbound connection from 127.0.0.1:56038 (fd=177)..[0m
[2m1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Accepted inbound connection from 127.0.0.1:56038 (fd=177)..[0m
[2m1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Inbound peer resource registered with id=2 (fd=177)[0m
[2m1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> wire: Session established with z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (id=2) (fd=7) (outbound)[0m
[2m1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Connected to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (0.0.0.0:34091) (Outbound)[0m
[2m1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Subscribing to messages since timestamp 1759170798596..[0m
[2m1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Session established with z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk (id=2) (fd=177) (inbound)[0m
[2m1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Connected to z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk (127.0.0.1:56038) (Inbound)[0m
[2m1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Subscribing to messages since timestamp 1759170798596..[0m
1759257198 [36mtest:[0m [36mNode z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi has converged[0m
1759257198 [36mtest:[0m [36mNode has missing routes: [(RepoId(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji), PublicKey(z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi))][0m
[2m1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Received node announcement of z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk with 0 address(es) from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk (t=1759257198433)[0m
[2m1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received node announcement of z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi with 0 address(es) from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (t=1759257198161)[0m
[2m1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Stored announcement from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi to be broadcast in 0 millisecond(s) (t=1759257198161)[0m
[2m1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Stored announcement from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk to be broadcast in 0 millisecond(s) (t=1759257198433)[0m
[2m1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Address store entry for node z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk updated at 1759257198433[0m
[2m1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Received inventory announcement of z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk with 0 item(s) from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk (t=1759257198434)[0m
[2m1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Address store entry for node z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi updated at 1759257198161[0m
[2m1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received inventory announcement of z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi with 1 item(s) from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (t=1759257198163)[0m
[2m1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Stored announcement from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk to be broadcast in 0 millisecond(s) (t=1759257198434)[0m
[2m1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Received subscription filter from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk[0m
[2m1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Stored announcement from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi to be broadcast in 0 millisecond(s) (t=1759257198163)[0m
1759257198 [36mtest:[0m [36mNode has missing routes: [(RepoId(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji), PublicKey(z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi))][0m
[2m1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Routing table updated for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji with seed z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi[0m
[2m1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received subscription filter from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi[0m
1759257198 [36mtest:[0m [36mNode z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk has converged[0m
1759257198 [36mtest:[0m [36mRunning `rad clone ["rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji"]` in /tmp/radicle-OFY61L/work/bob..[0m
[2m1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control> control: Received `{"command":"status"}` on control socket[0m
[2m1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control> control: Received `{"command":"seed","rid":"rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji","scope":"all"}` on control socket[0m
[2m1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received command Seed(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji, all)[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Sending subscription filter to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi[0m
[2m1759257199 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Received subscription filter from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control> control: Received `{"command":"seeds","rid":"rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji"}` on control socket[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received command Seeds(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji)[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Found 1 connected seed(s) and 0 disconnected seed(s) for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control> control: Received `{"command":"session","nid":"z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi"}` on control socket[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received command QueryState(..)[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control> control: Received `{"command":"fetch","rid":"rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji","nid":"z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi","timeout":{"secs":9,"nanos":0}}` on control socket[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received command Fetch(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji, z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi)[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Fetch initiated for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji with z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi [outbound connected] (all remotes)..[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> wire: Opened new stream with id 12 for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji and remote z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> worker: Worker processing outgoing fetch for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji[0m
[2m1759257199 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Received `open` command for stream 12 from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk[0m
[2m1759257199 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <worker#0> worker: Worker processing incoming fetch for z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk on stream 12..[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> worker: z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk cloning from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi[0m
[2m1759257199 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <worker#0> worker: Spawning upload-pack process for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji on stream 12..[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> fetch: Fetched rad/id (18ms)[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> fetch: Fetched data for 1 remote(s) (39ms)[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> fetch: Fetched data refs for 1 remotes (52ms)[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> fetch: Sent done signal to remote z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi[0m
[2m1759257199 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Received `end-of-file` on stream 12 from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk[0m
[2m1759257199 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <upload-pack> worker: Exiting upload-pack reader thread for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji[0m
[2m1759257199 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <worker#0> worker: Upload pack finished (62ms)[0m
[2m1759257199 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <worker#0> worker: Upload process on stream 12 exited with result Ok(())[0m
[2m1759257199 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Received fetch result from worker for stream 12, remote z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk: Responder { rid: Some(RepoId(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji)), result: Ok(()) }[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> fetch: Validated 1 remote(s) (53ms)[0m
[2m1759257199 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Stream 12 of z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk closing with 0 byte(s) sent and 0 byte(s) received[0m
[2m1759257199 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Peer z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk fetched rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji from us successfully[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> wire: Received `close` command for stream 12 from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> wire: Stream 12 of z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi closed with 0 byte(s) sent and 0 byte(s) received[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> fetch: Applied updates (56ms)[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> fetch: Finished clone of rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (67ms)[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> cob: Loading object of type xyz.radicle.id at 0656c217f917c3e06234771e9ecae53aba5e173e[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> storage: Setting ref: refs/rad/id -> 0656c217f917c3e06234771e9ecae53aba5e173e[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> storage: Setting ref: refs/heads/master -> f2de534b5e81d7c6e2dcaf58c3dd91573c0a0354[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> storage: Setting ref: HEAD -> refs/heads/master[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> cob: Loading object of type xyz.radicle.id at 0656c217f917c3e06234771e9ecae53aba5e173e[0m
[2m1759257199 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
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Found existing fetch request from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi, sending result..[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Sent fetch result for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi..[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Fetched rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi successfully[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Ref updated: * 0000000..0656c21 refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/rad/id for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Ref updated: * 0000000..99c5497 refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/rad/sigrefs for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Ref updated: * 0000000..0656c21 refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/cobs/xyz.radicle.id/0656c217f917c3e06234771e9ecae53aba5e173e for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Ref updated: * 0000000..f2de534 refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/heads/master for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Ref updated: * 0000000..0656c21 refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/rad/root for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Updating and announcing inventory for cloned repository rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji..[0m
1759257199 [36mtest:[0m [36mrad clone: ✓ Seeding policy updated for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji with scope 'all'[0m
1759257199 [36mtest:[0m [36mrad clone: Fetching rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji from the network, found 1 potential seed(s).[0m
1759257199 [36mtest:[0m [36mrad clone: ✓ Target met: 1 seed(s)[0m
1759257199 [36mtest:[0m [36mrad clone: ✓ Creating checkout in ./heartwood..[0m
1759257199 [36mtest:[0m [36mrad clone: ✓ Remote alice@z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi added[0m
1759257199 [36mtest:[0m [36mrad clone: ✓ Remote-tracking branch alice@z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/master created for z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi[0m
1759257199 [36mtest:[0m [36mrad clone: ✓ Repository successfully cloned under /tmp/radicle-OFY61L/work/bob/heartwood/[0m
1759257199 [36mtest:[0m [36mrad clone: ╭────────────────────────────────────╮[0m
1759257199 [36mtest:[0m [36mrad clone: │ heartwood │[0m
1759257199 [36mtest:[0m [36mrad clone: │ Radicle Heartwood Protocol & Stack │[0m
1759257199 [36mtest:[0m [36mrad clone: │ 0 issues · 0 patches │[0m
1759257199 [36mtest:[0m [36mrad clone: ╰────────────────────────────────────╯[0m
1759257199 [36mtest:[0m [36mrad clone: Run `cd ./heartwood` to go to the repository directory.[0m
1759257199 [36mtest:[0m [36mRan command `rad clone` (status=0)[0m
1759257199 [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-OFY61L"][0m
1759257199 [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-OFY61L/work/alice`..[0m
1759257199 [36mtest:[0m [36mgit-push-canonical-lightweight-tags.md: Running `git` with ["tag", "v1.0-hotfix"] in `/tmp/radicle-OFY61L/work/alice`..[0m
1759257199 [36mtest:[0m [36mgit-push-canonical-lightweight-tags.md: Running `git` with ["push", "rad", "--tags"] in `/tmp/radicle-OFY61L/work/alice`..[0m
[2m1759257199 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <control> control: Received `{"command":"status"}` on control socket[0m
[2m1759257199 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <control> control: Received `{"command":"seeds","rid":"rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji","ns":"z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi"}` on control socket[0m
[2m1759257199 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Received command Seeds(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji)[0m
[2m1759257199 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:501: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
1759257199 [36mtest:[0m [36mNode z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk shutting down..[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control> control: Received `{"command":"shutdown"}` on control socket[0m
[2m1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control> control: Shutdown requested..[0m
[2m1759257200 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Sending inventory announcement of z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk with 1 item(s) to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (t=1759257199526)[0m
[2m1759257200 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Sending refs announcement of z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji with 1 remote(s) to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (t=1759257199527)[0m
[2m1759257200 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Disconnecting peer with id=2: connection reset[0m
[2m1759257200 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Transport handover for disconnecting peer with id=2 (fd=177)[0m
[2m1759257200 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Disconnected from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk (connection reset)[0m
[2m1759257200 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Dropping peer z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk..[0m
[2m1759257200 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <runtime> pool: Worker pool shutting down..[0m
[2m1759257200 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <runtime> node: Node shutdown completed for z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk[0m
1759257200 [36mtest:[0m [36mNode z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi shutting down..[0m
[2m1759257200 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <control> control: Received `{"command":"shutdown"}` on control socket[0m
[2m1759257200 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <control> control: Shutdown requested..[0m
[2m1759257200 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <runtime> pool: Worker pool shutting down..[0m
[2m1759257200 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <runtime> node: Node shutdown completed for z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi[0m
---- rad_patch_fetch_2 stdout ----
1759257250 [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-j3sgut/work/alice"][0m
1759257250 [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-j3sgut/work/alice`..[0m
1759257251 [36mtest:[0m [36mrad-init.md: Running `/workspace/cache/debug/rad` with ["init"] in `/tmp/radicle-j3sgut/work/alice`..[0m
1759257251 [36mtest:[0m [36mrad-init.md: Running `/workspace/cache/debug/rad` with ["ls"] in `/tmp/radicle-j3sgut/work/alice`..[0m
1759257251 [36mtest:[0m [36mrad-init.md: Running `/workspace/cache/debug/rad` with ["node", "inventory"] in `/tmp/radicle-j3sgut/work/alice`..[0m
1759257251 [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-j3sgut/work/alice"][0m
1759257251 [36mtest:[0m [36mrad-patch-fetch-2.md: Running `git` with ["checkout", "-b", "alice/1", "-q"] in `/tmp/radicle-j3sgut/work/alice`..[0m
1759257251 [36mtest:[0m [36mrad-patch-fetch-2.md: Running `git` with ["commit", "--allow-empty", "-m", "Changes #1", "-q"] in `/tmp/radicle-j3sgut/work/alice`..[0m
1759257251 [36mtest:[0m [36mrad-patch-fetch-2.md: Running `git` with ["push", "rad", "-o", "patch.message=Changes", "HEAD:refs/patches"] in `/tmp/radicle-j3sgut/work/alice`..[0m
1759257251 [36mtest:[0m [36mrad-patch-fetch-2.md: Running `git` with ["checkout", "master", "-q"] in `/tmp/radicle-j3sgut/work/alice`..[0m
1759257251 [36mtest:[0m [36mrad-patch-fetch-2.md: Running `git` with ["branch", "-D", "alice/1", "-q"] in `/tmp/radicle-j3sgut/work/alice`..[0m
1759257251 [36mtest:[0m [36mrad-patch-fetch-2.md: Running `git` with ["update-ref", "-d", "refs/remotes/rad/alice/1"] in `/tmp/radicle-j3sgut/work/alice`..[0m
1759257251 [36mtest:[0m [36mrad-patch-fetch-2.md: Running `git` with ["update-ref", "-d", "refs/remotes/rad/patches/5e2dedcc5d515fcbc1cca483d3376609fe889bfb"] in `/tmp/radicle-j3sgut/work/alice`..[0m
1759257251 [36mtest:[0m [36mrad-patch-fetch-2.md: Running `git` with ["gc", "--prune=now"] in `/tmp/radicle-j3sgut/work/alice`..[0m
1759257251 [36mtest:[0m [36mrad-patch-fetch-2.md: Running `git` with ["branch", "-r"] in `/tmp/radicle-j3sgut/work/alice`..[0m
1759257251 [36mtest:[0m [36mrad-patch-fetch-2.md: Running `git` with ["pull"] in `/tmp/radicle-j3sgut/work/alice`..[0m
1759257251 [36mtest:[0m [36mrad-patch-fetch-2.md: Running `git` with ["branch", "-r"] in `/tmp/radicle-j3sgut/work/alice`..[0m
thread 'rad_patch_fetch_2' panicked at crates/radicle-cli-test/src/lib.rs:503: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 ----
1759257254 [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-RffxsS/work/alice"][0m
1759257254 [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-RffxsS/work/alice`..[0m
1759257254 [36mtest:[0m [36mrad-init.md: Running `/workspace/cache/debug/rad` with ["init"] in `/tmp/radicle-RffxsS/work/alice`..[0m
1759257254 [36mtest:[0m [36mrad-init.md: Running `/workspace/cache/debug/rad` with ["ls"] in `/tmp/radicle-RffxsS/work/alice`..[0m
1759257254 [36mtest:[0m [36mrad-init.md: Running `/workspace/cache/debug/rad` with ["node", "inventory"] in `/tmp/radicle-RffxsS/work/alice`..[0m
1759257254 [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-RffxsS/work/alice"][0m
1759257254 [36mtest:[0m [36mrad-patch-via-push.md: Running `git` with ["checkout", "-b", "feature/1"] in `/tmp/radicle-RffxsS/work/alice`..[0m
1759257254 [36mtest:[0m [36mrad-patch-via-push.md: Running `git` with ["commit", "-a", "-m", "Add things", "-q", "--allow-empty"] in `/tmp/radicle-RffxsS/work/alice`..[0m
1759257254 [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-RffxsS/work/alice`..[0m
1759257254 [36mtest:[0m [36mrad-patch-via-push.md: Running `/workspace/cache/debug/rad` with ["patch", "show", "6035d2f582afbe01ff23ea87528ae523d76875b6"] in `/tmp/radicle-RffxsS/work/alice`..[0m
1759257254 [36mtest:[0m [36mrad-patch-via-push.md: Running `git` with ["branch", "-vv"] in `/tmp/radicle-RffxsS/work/alice`..[0m
1759257254 [36mtest:[0m [36mrad-patch-via-push.md: Running `git` with ["status", "--short", "--branch"] in `/tmp/radicle-RffxsS/work/alice`..[0m
1759257254 [36mtest:[0m [36mrad-patch-via-push.md: Running `git` with ["fetch"] in `/tmp/radicle-RffxsS/work/alice`..[0m
1759257254 [36mtest:[0m [36mrad-patch-via-push.md: Running `git` with ["push"] in `/tmp/radicle-RffxsS/work/alice`..[0m
1759257254 [36mtest:[0m [36mrad-patch-via-push.md: Running `git` with ["show-ref"] in `/tmp/radicle-RffxsS/work/alice`..[0m
thread 'rad_patch_via_push' panicked at crates/radicle-cli-test/src/lib.rs:503: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. 104 passed; 3 failed; 2 ignored; 0 measured; 0 filtered out; finished in 109.46s
error: test failed, to rerun pass `-p radicle-cli --test commands`
[2025-09-30T18:34:35Z ERROR ambient_ci::plan] ERROR: Action failed: failed to execute cargo
[2025-09-30T18:34:35Z 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-30T18:34:37Z 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": "05db4d7284c69875986a30b8161238b607155f5e",
"author": {
"id": "did:key:z6MkkPvBfjP4bQmco5Dm7UGsX2ruDBieEHi8n9DVJWX5sTEz",
"alias": "lorenz"
},
"title": "node: Generalize commands announce/seeds to take public key",
"state": {
"status": "open",
"conflicts": []
},
"before": "4787b53b1e85d8052744fc77e4160e4d90e46d0f",
"after": "77816c3d5814cf381d60be6318c4b9ff43869089",
"commits": [
"77816c3d5814cf381d60be6318c4b9ff43869089",
"f42826ceaffbb78730ba0cf61b120036a0ae8f16"
],
"target": "4787b53b1e85d8052744fc77e4160e4d90e46d0f",
"labels": [],
"assignees": [],
"revisions": [
{
"id": "05db4d7284c69875986a30b8161238b607155f5e",
"author": {
"id": "did:key:z6MkkPvBfjP4bQmco5Dm7UGsX2ruDBieEHi8n9DVJWX5sTEz",
"alias": "lorenz"
},
"description": "The commands \"announce references\" and \"seeds\" only take a repository ID,\nand carry the implicit assumption that the namespace with the same public\nkey as the Node ID of the receiving `radicle-node` process is relevant,\nbut no other namespace.\n\nIn the spirit of separating user and node identity, relax this, so that\nthese command also carry the public key for which the announcement\nshould be made or sync status should be reported.\n\nThis feature is not exposed via CLI, but used to pass through the user\nidentity of the active profile.\n\nFor sync status, this patch still is not fully satisfactory, because\nthe node does not store sync updates for all namespaces, but only for\nits own. Storing sync updates for namespaces that were announced from\nthe node could be implemented in the future.",
"base": "f1c7c9860716e5db88f657c61d39d6081fb5645f",
"oid": "b4aa1c43a68995611cdb112eb2caa226d5caec22",
"timestamp": 1759161610
},
{
"id": "101ab959c9494b6891c892bb4724723f0b65df86",
"author": {
"id": "did:key:z6MkkPvBfjP4bQmco5Dm7UGsX2ruDBieEHi8n9DVJWX5sTEz",
"alias": "lorenz"
},
"description": "Minor improvements.",
"base": "f1c7c9860716e5db88f657c61d39d6081fb5645f",
"oid": "93a1ac799bdb934a8f57352922cf4a09cd48b06b",
"timestamp": 1759167857
},
{
"id": "5271370a953736e9507ee5fd56bfc20c529aa96e",
"author": {
"id": "did:key:z6MkkPvBfjP4bQmco5Dm7UGsX2ruDBieEHi8n9DVJWX5sTEz",
"alias": "lorenz"
},
"description": "Also cover `rad sync status`.",
"base": "f1c7c9860716e5db88f657c61d39d6081fb5645f",
"oid": "1ac5c1f5ef7a533eeacdf3c40d8b3df4af52dff9",
"timestamp": 1759171522
},
{
"id": "48e82a78b3362981627578c13214a3ace3790b52",
"author": {
"id": "did:key:z6MkkPvBfjP4bQmco5Dm7UGsX2ruDBieEHi8n9DVJWX5sTEz",
"alias": "lorenz"
},
"description": "Rebase",
"base": "4787b53b1e85d8052744fc77e4160e4d90e46d0f",
"oid": "77816c3d5814cf381d60be6318c4b9ff43869089",
"timestamp": 1759255468
}
]
}
}[2025-09-30T18:25:44Z INFO ambient] ambient starts
[2025-09-30T18:25:44Z DEBUG ambient] load default configuration file /home/_rad/.config/ambient/config.yaml if it exists
[2025-09-30T18:25:44Z 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-30T18:25:44Z 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-30T18:25:44Z DEBUG ambient_ci::project] load project state from /srv/ambient-state/rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5/meta.yaml
[2025-09-30T18:25:44Z DEBUG ambient_ci::run] latest commit: "d02c4c127a1ff0a8a2d56c8dcad3d815b6cd9427"
[2025-09-30T18:25:44Z DEBUG ambient_ci::run] is a git repository
[2025-09-30T18:25:44Z DEBUG ambient_ci::run] git repository is clean
[2025-09-30T18:25:44Z DEBUG ambient_ci::run] current (HEAD) commit: 77816c3d5814cf381d60be6318c4b9ff43869089
[2025-09-30T18:25:44Z DEBUG ambient_ci::run] no dry run requested
[2025-09-30T18:25:44Z DEBUG ambient_ci::run] forced run requested
[2025-09-30T18:25:44Z DEBUG ambient_ci::run] run? true
[2025-09-30T18:25:44Z INFO ambient_ci::run] project rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5: running CI
[2025-09-30T18:25:44Z DEBUG ambient_ci::run] Executing pre-plan steps
[2025-09-30T18:25:44Z DEBUG ambient_ci::plan] RUN: Action CargoFetch {
sourcedir: "/tmp/.tmpLD1LAb/src",
}
[2025-09-30T18:25:44Z DEBUG ambient_ci::action] Plan::execute: plan=CargoFetch {
sourcedir: "/tmp/.tmpLD1LAb/src",
}
[2025-09-30T18:25:44Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_HOME": "/srv/ambient-state/rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5/dependencies",
"PATH": "/root/.cargo/bin:/bin:/home/_rad/.radicle/bin:/home/_rad/.cargo/bin",
"CARGO_TARGET_DIR": "/srv/ambient-state/rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5/cache",
},
source_dir: "/tmp/.tmpLD1LAb/src",
}
SPAWN: argv=["cargo", "--version"]
cwd=/tmp/.tmpLD1LAb/src (exists? true)
cargo 1.88.0 (873a06493 2025-05-10)
SPAWN: argv=["cargo", "clippy", "--version"]
cwd=/tmp/.tmpLD1LAb/src (exists? true)
clippy 0.1.88 (6b00bc3880 2025-06-23)
SPAWN: argv=["rustc", "--version"]
cwd=/tmp/.tmpLD1LAb/src (exists? true)
rustc 1.88.0 (6b00bc388 2025-06-23)
SPAWN: argv=["cargo", "fetch"]
cwd=/tmp/.tmpLD1LAb/src (exists? true)
[2025-09-30T18:25:45Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-30T18:25:45Z DEBUG ambient_ci::plan] All actions were performed successfully
[2025-09-30T18:25:45Z DEBUG ambient_ci::run] create virtual drive /srv/tmp/.tmpFuJnQa/src.tar
[2025-09-30T18:25:45Z DEBUG ambient_ci::run] create virtual drive /srv/tmp/.tmpFuJnQa/deps.tar
[2025-09-30T18:25:57Z DEBUG ambient_ci::run] create_executor_vdrive: executor="/usr/bin/ambient-execute-plan"
[2025-09-30T18:25:57Z 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-30T18:25:57Z DEBUG ambient_ci::run] executor bin /usr/bin/ambient-execute-plan
[2025-09-30T18:25:57Z DEBUG ambient_ci::run] copying /usr/bin/ambient-execute-plan to /srv/tmp/.tmpFuJnQa/ambient-execute-plan/run-ci
[2025-09-30T18:25:57Z DEBUG ambient_ci::run] copy OK: true
[2025-09-30T18:25:57Z DEBUG ambient_ci::run] create virtual drive /srv/tmp/.tmpFuJnQa/executor.tar
[2025-09-30T18:27:05Z DEBUG ambient_ci::project] removing run log file /srv/ambient-state/rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5/run.log
[2025-09-30T18:27:05Z DEBUG ambient_ci::project] statedir is /srv/ambient-state/rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5, exists? true
[2025-09-30T18:27:05Z DEBUG ambient_ci::project] creating run log file /srv/ambient-state/rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5/run.log
[2025-09-30T18:27:05Z DEBUG ambient_ci::project] created run log file /srv/ambient-state/rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5/run.log OK
[2025-09-30T18:27:05Z DEBUG ambient_ci::cloud_init] with_hostname called: "ambient"
[2025-09-30T18:27:05Z DEBUG ambient_ci::cloud_init] with_runcmd called: "echo xyzzy > /dev/ttyS1"
[2025-09-30T18:27:05Z 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-30T18:27:05Z DEBUG ambient_ci::cloud_init] with_runcmd called: "poweroff"
[2025-09-30T18:27:05Z 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-30T18:27:05Z DEBUG ambient_ci::qemu] run QEMU
[2025-09-30T18:27:05Z DEBUG ambient_ci::qemu] create copy-on-write image and UEFI vars file
[2025-09-30T18:27:05Z DEBUG ambient_ci::qemu_utils] qemu-img create /srv/tmp/.tmpXmXaFk/.tmpsD69vj/vm.qcow2 backing on /home/_rad/ambient.qcow2
[2025-09-30T18:27:05Z DEBUG ambient_ci::qemu] create cloud-init ISO file
[2025-09-30T18:27:05Z 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-30T18:27:05Z DEBUG ambient_ci::cloud_init] write /tmp/.tmpDMXVpQ/meta-data
[2025-09-30T18:27:05Z DEBUG ambient_ci::cloud_init] write /tmp/.tmpDMXVpQ/user-data
[2025-09-30T18:27:06Z DEBUG ambient_ci::qemu] set console log file to /srv/tmp/.tmpXmXaFk/.tmpsD69vj/console.log
[2025-09-30T18:27:06Z DEBUG ambient_ci::util] create file /srv/tmp/.tmpXmXaFk/.tmpsD69vj/console.log
[2025-09-30T18:27:06Z DEBUG ambient_ci::qemu] set run file to /srv/ambient-state/rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5/run.log
[2025-09-30T18:27:06Z DEBUG ambient_ci::util] create file /srv/ambient-state/rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5/run.log
[2025-09-30T18:27:06Z 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/.tmpXmXaFk/.tmpsD69vj/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/.tmpXmXaFk/.tmpsD69vj/vars.fd",
"-drive",
"format=qcow2,if=virtio,file=/srv/tmp/.tmpXmXaFk/.tmpsD69vj/vm.qcow2",
"-drive",
"format=raw,if=virtio,file=/srv/tmp/.tmpFuJnQa/executor.tar,readonly=on",
"-cdrom",
"/srv/tmp/.tmpXmXaFk/.tmpsD69vj/cloud_init.iso",
"-drive",
"format=raw,if=virtio,file=/srv/tmp/.tmpFuJnQa/src.tar,readonly=on",
"-drive",
"format=raw,if=virtio,file=/srv/tmp/.tmpFuJnQa/artifacts.tar",
"-drive",
"format=raw,if=virtio,file=/srv/tmp/.tmpFuJnQa/cache.tar",
"-drive",
"format=raw,if=virtio,file=/srv/tmp/.tmpFuJnQa/deps.tar,readonly=on",
"-nodefaults",
"-no-user-config",
],
}
[2025-09-30T18:34:36Z DEBUG ambient_ci::qemu] QEMU finished OK
[2025-09-30T18:34:36Z DEBUG ambient_ci::qemu] run log:
--------------------==========
[2025-09-30T18:27:22Z TRACE ambient_execute_plan] ambient-execute-plan version 0.7.0@14cdd4c starts
[2025-09-30T18:27:22Z DEBUG ambient_execute_plan] ambient-execute-plan version 0.7.0@14cdd4c starts
[2025-09-30T18:27:22Z INFO ambient_execute_plan] ambient-execute-plan version 0.7.0@14cdd4c starts
[2025-09-30T18:27:22Z WARN ambient_execute_plan] ambient-execute-plan version 0.7.0@14cdd4c starts
[2025-09-30T18:27:22Z ERROR ambient_execute_plan] ambient-execute-plan version 0.7.0@14cdd4c 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-30T18:27:22Z DEBUG ambient_ci::plan] RUN: Action Mkdir {
pathname: "/workspace",
}
[2025-09-30T18:27:22Z DEBUG ambient_ci::action] Plan::execute: plan=Mkdir {
pathname: "/workspace",
}
[2025-09-30T18:27:22Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_TARGET_DIR": "/workspace/cache",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
},
source_dir: "/workspace/src",
}
[2025-09-30T18:27:22Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-30T18:27:22Z DEBUG ambient_ci::plan] RUN: Action Mkdir {
pathname: "/workspace/artifacts",
}
[2025-09-30T18:27:22Z DEBUG ambient_ci::action] Plan::execute: plan=Mkdir {
pathname: "/workspace/artifacts",
}
[2025-09-30T18:27:22Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_TARGET_DIR": "/workspace/cache",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
},
source_dir: "/workspace/src",
}
[2025-09-30T18:27:22Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-30T18:27:22Z DEBUG ambient_ci::plan] RUN: Action TarExtract {
archive: "/dev/vdc",
directory: "/workspace/src",
}
[2025-09-30T18:27:22Z DEBUG ambient_ci::action] Plan::execute: plan=TarExtract {
archive: "/dev/vdc",
directory: "/workspace/src",
}
[2025-09-30T18:27:22Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_TARGET_DIR": "/workspace/cache",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
},
source_dir: "/workspace/src",
}
[2025-09-30T18:27:22Z TRACE ambient_ci::vdrive] extracting /dev/vdc to /workspace/src
[2025-09-30T18:27:23Z TRACE ambient_ci::vdrive] extraction OK
[2025-09-30T18:27:23Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-30T18:27:23Z DEBUG ambient_ci::plan] RUN: Action TarExtract {
archive: "/dev/vdf",
directory: "/workspace/deps",
}
[2025-09-30T18:27:23Z DEBUG ambient_ci::action] Plan::execute: plan=TarExtract {
archive: "/dev/vdf",
directory: "/workspace/deps",
}
[2025-09-30T18:27:23Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_TARGET_DIR": "/workspace/cache",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
},
source_dir: "/workspace/src",
}
[2025-09-30T18:27:23Z TRACE ambient_ci::vdrive] extracting /dev/vdf to /workspace/deps
[2025-09-30T18:27:51Z TRACE ambient_ci::vdrive] extraction OK
[2025-09-30T18:27:51Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-30T18:27:51Z DEBUG ambient_ci::plan] RUN: Action TarExtract {
archive: "/dev/vde",
directory: "/workspace/cache",
}
[2025-09-30T18:27:51Z DEBUG ambient_ci::action] Plan::execute: plan=TarExtract {
archive: "/dev/vde",
directory: "/workspace/cache",
}
[2025-09-30T18:27:51Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_TARGET_DIR": "/workspace/cache",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
},
source_dir: "/workspace/src",
}
[2025-09-30T18:27:51Z TRACE ambient_ci::vdrive] extracting /dev/vde to /workspace/cache
[2025-09-30T18:30:43Z TRACE ambient_ci::vdrive] extraction OK
[2025-09-30T18:30:43Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-30T18:30:43Z DEBUG ambient_ci::plan] RUN: Action Spawn {
argv: [
"find",
"/workspace",
"-maxdepth",
"2",
"-ls",
],
}
[2025-09-30T18:30:43Z DEBUG ambient_ci::action] Plan::execute: plan=Spawn {
argv: [
"find",
"/workspace",
"-maxdepth",
"2",
"-ls",
],
}
[2025-09-30T18:30:43Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_TARGET_DIR": "/workspace/cache",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
},
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 30 18:27 /workspace
2622401 4 drwxr-xr-x 3 root root 4096 Sep 30 18:25 /workspace/deps
2622402 0 -rw-r--r-- 1 root root 0 Sep 22 16:46 /workspace/deps/.package-cache-mutate
2622405 4 drwxr-xr-x 5 root root 4096 Sep 22 16:46 /workspace/deps/registry
2622403 128 -rw-r--r-- 1 root root 131072 Sep 30 18:25 /workspace/deps/.global-cache
2622404 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 30 18:25 /workspace/src
2621499 4 -rw-r--r-- 1 root root 2653 Sep 30 18:25 /workspace/src/Cargo.toml
2622397 12 -rw-r--r-- 1 root root 9636 Sep 30 18:25 /workspace/src/CONTRIBUTING.md
2621500 4 drwxr-xr-x 2 root root 4096 Sep 30 18:25 /workspace/src/.config
2621496 4 -rw-r--r-- 1 root root 1623 Sep 30 18:25 /workspace/src/build.rs
2621502 4 -rw-r--r-- 1 root root 426 Sep 30 18:25 /workspace/src/radicle-node.1.adoc
2621504 4 drwxr-xr-x 8 root root 4096 Sep 30 18:25 /workspace/src/.git
2622394 8 -rw-r--r-- 1 root root 7144 Sep 30 18:25 /workspace/src/rad-id.1.adoc
2621460 4 -rw-r--r-- 1 root root 2163 Sep 30 18:25 /workspace/src/VERSIONING.md
2621495 4 -rw-r--r-- 1 root root 3133 Sep 30 18:25 /workspace/src/README.md
2621802 12 -rw-r--r-- 1 root root 10975 Sep 30 18:25 /workspace/src/rad-patch.1.adoc
2622398 4 -rw-r--r-- 1 root root 79 Sep 30 18:25 /workspace/src/ARCHITECTURE.md
2621810 4 drwxr-xr-x 17 root root 4096 Sep 30 18:25 /workspace/src/crates
2621448 4 drwxr-xr-x 2 root root 4096 Sep 30 18:25 /workspace/src/scripts
2621444 4 drwxr-xr-x 2 root root 4096 Sep 30 18:25 /workspace/src/.radicle
2621467 16 -rw-r--r-- 1 root root 14022 Sep 30 18:25 /workspace/src/CHANGELOG.md
2621482 4 drwxr-xr-x 3 root root 4096 Sep 30 18:25 /workspace/src/debian
2621465 4 -rw-r--r-- 1 root root 42 Sep 30 18:25 /workspace/src/.envrc
2622395 4 -rw-r--r-- 1 root root 1203 Sep 30 18:25 /workspace/src/DCO
2622390 4 drwxr-xr-x 3 root root 4096 Sep 30 18:25 /workspace/src/.github
2622400 124 -rw-r--r-- 1 root root 122985 Sep 30 18:25 /workspace/src/Cargo.lock
2621803 4 drwxr-xr-x 5 root root 4096 Sep 30 18:25 /workspace/src/systemd
2621801 12 -rw-r--r-- 1 root root 9723 Sep 30 18:25 /workspace/src/LICENSE-APACHE
2621498 4 -rw-r--r-- 1 root root 101 Sep 30 18:25 /workspace/src/.gitignore
2622396 8 -rw-r--r-- 1 root root 5102 Sep 30 18:25 /workspace/src/flake.lock
2621464 4 -rw-r--r-- 1 root root 77 Sep 30 18:25 /workspace/src/rust-toolchain.toml
2621497 12 -rw-r--r-- 1 root root 10520 Sep 30 18:25 /workspace/src/flake.nix
2621468 4 -rw-r--r-- 1 root root 571 Sep 30 18:25 /workspace/src/git-remote-rad.1.adoc
2621466 4 -rw-r--r-- 1 root root 61 Sep 30 18:25 /workspace/src/.env.seed
2621503 8 -rw-r--r-- 1 root root 5432 Sep 30 18:25 /workspace/src/deny.toml
2621458 8 -rw-r--r-- 1 root root 7645 Sep 30 18:25 /workspace/src/HACKING.md
2621447 4 -rw-r--r-- 1 root root 1079 Sep 30 18:25 /workspace/src/LICENSE-MIT
2621463 8 -rw-r--r-- 1 root root 8023 Sep 30 18:25 /workspace/src/rad.1.adoc
2621469 4 drwxr-xr-x 2 root root 4096 Sep 30 18:25 /workspace/src/build
2622399 4 -rw-r--r-- 1 root root 1083 Sep 30 18:25 /workspace/src/.gitsigners
2621459 4 -rw-r--r-- 1 root root 30 Sep 30 18:25 /workspace/src/.dockerignore
2621461 4 drwxr-xr-x 2 root root 4096 Sep 30 18:25 /workspace/src/.cargo
2621442 4 drwxr-xr-x 2 root root 4096 Sep 30 18:27 /workspace/artifacts
2650449 4 drwxr-xr-x 6 root root 4096 Sep 22 23:09 /workspace/cache
2669144 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
2650451 4 drwxr-xr-x 7 root root 4096 Sep 24 10:43 /workspace/cache/debug
2650450 4 drwxr-xr-x 2 root root 4096 Sep 22 23:02 /workspace/cache/tmp
2669145 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-30T18:30:44Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-30T18:30:44Z DEBUG ambient_ci::plan] RUN: Action CargoFmt
[2025-09-30T18:30:44Z DEBUG ambient_ci::action] Plan::execute: plan=CargoFmt
[2025-09-30T18:30:44Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_TARGET_DIR": "/workspace/cache",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
},
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-30T18:30:46Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-30T18:30:46Z DEBUG ambient_ci::plan] RUN: Action CargoClippy
[2025-09-30T18:30:46Z DEBUG ambient_ci::action] Plan::execute: plan=CargoClippy
[2025-09-30T18:30:46Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_TARGET_DIR": "/workspace/cache",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
},
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 radicle-signals v0.11.0 (/workspace/src/crates/radicle-signals)
Compiling portable-atomic v1.11.0
Checking unicode-width v0.2.1
Checking unit-prefix v0.5.1
Checking pin-project-lite v0.2.16
Checking value-bag-serde1 v1.11.1
Checking serde-untagged v0.1.7
Checking value-bag v1.11.1
Checking console v0.16.0
Checking tokio v1.47.1
Checking log v0.4.27
Compiling radicle-node v0.15.0 (/workspace/src/crates/radicle-node)
Checking prodash v29.0.2
Checking git2 v0.19.0
Checking mio v1.0.4
Checking gix-features v0.39.1
Checking mio v0.8.11
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-revwalk v0.17.0
Checking gix-url v0.28.2
Checking gix-revision v0.31.1
Checking gix-traverse v0.43.1
Checking gix-diff v0.49.0
Checking gix-refspec v0.27.0
Checking gix-pack v0.56.0
Checking radicle-git-ext v0.8.1
Checking gix-transport v0.44.0
Checking gix-credentials v0.26.0
Checking radicle-crypto v0.13.0 (/workspace/src/crates/radicle-crypto)
Checking gix-negotiate v0.17.0
Checking gix-shallow v0.1.0
Checking gix-ref v0.49.1
Checking signal-hook-mio v0.2.4
Checking crossterm v0.25.0
Checking radicle-cob v0.16.0 (/workspace/src/crates/radicle-cob)
Checking gix-odb v0.66.0
Checking gix-protocol v0.47.0
Checking radicle v0.19.0 (/workspace/src/crates/radicle)
Checking indicatif v0.18.0
Checking inquire v0.7.5
Checking crossterm v0.29.0
Checking systemd-journal-logger v2.2.2
Checking os_info v3.12.0
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-schemars v0.5.0 (/workspace/src/crates/radicle-schemars)
Checking radicle-protocol v0.3.0 (/workspace/src/crates/radicle-protocol)
Finished `dev` profile [unoptimized + debuginfo] target(s) in 28.58s
[2025-09-30T18:31:15Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-30T18:31:15Z DEBUG ambient_ci::plan] RUN: Action CargoBuild
[2025-09-30T18:31:15Z DEBUG ambient_ci::action] Plan::execute: plan=CargoBuild
[2025-09-30T18:31:15Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_TARGET_DIR": "/workspace/cache",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
},
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 radicle-signals v0.11.0 (/workspace/src/crates/radicle-signals)
Compiling unicode-width v0.2.1
Compiling portable-atomic v1.11.0
Compiling console v0.16.0
Compiling unit-prefix v0.5.1
Compiling value-bag-serde1 v1.11.1
Compiling serde-untagged v0.1.7
Compiling value-bag v1.11.1
Compiling pin-project-lite v0.2.16
Compiling indicatif v0.18.0
Compiling tokio v1.47.1
Compiling log v0.4.27
Compiling radicle-cli v0.16.0 (/workspace/src/crates/radicle-cli)
Compiling radicle-node v0.15.0 (/workspace/src/crates/radicle-node)
Compiling prodash v29.0.2
Compiling git2 v0.19.0
Compiling gix-features v0.39.1
Compiling mio v1.0.4
Compiling gix-object v0.46.1
Compiling gix-commitgraph v0.25.1
Compiling gix-fs v0.12.1
Compiling gix-revwalk v0.17.0
Compiling gix-tempfile v15.0.0
Compiling gix-lock v15.0.1
Compiling gix-url v0.28.2
Compiling radicle-git-ext v0.8.1
Compiling gix-revision v0.31.1
Compiling radicle-crypto v0.13.0 (/workspace/src/crates/radicle-crypto)
Compiling gix-traverse v0.43.1
Compiling gix-diff v0.49.0
Compiling mio v0.8.11
Compiling gix-pack v0.56.0
Compiling radicle-cob v0.16.0 (/workspace/src/crates/radicle-cob)
Compiling signal-hook-mio v0.2.4
Compiling gix-refspec v0.27.0
Compiling gix-transport v0.44.0
Compiling radicle v0.19.0 (/workspace/src/crates/radicle)
Compiling gix-credentials v0.26.0
Compiling gix-shallow v0.1.0
Compiling gix-ref v0.49.1
Compiling gix-negotiate v0.17.0
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 os_info v3.12.0
Compiling radicle-surf v0.22.0
Compiling human-panic v2.0.3
Compiling radicle-term v0.15.0 (/workspace/src/crates/radicle-term)
Compiling radicle-systemd v0.10.0 (/workspace/src/crates/radicle-systemd)
Compiling structured-logger v1.0.4
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 22s
[2025-09-30T18:32:39Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-30T18:32:39Z DEBUG ambient_ci::plan] RUN: Action CargoTest
[2025-09-30T18:32:39Z DEBUG ambient_ci::action] Plan::execute: plan=CargoTest
[2025-09-30T18:32:39Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_TARGET_DIR": "/workspace/cache",
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
},
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.89s
Running unittests src/lib.rs (/workspace/cache/debug/deps/radicle-f412a4d7b87c45b5)
running 238 tests
test canonical::formatter::test::ascii_control_characters ... ok
test canonical::formatter::test::securesystemslib_asserts ... ok
test canonical::formatter::test::ordered_nested_object ... ok
test cob::cache::migrations::_2::tests::test_migration_2 ... ok
test cob::cache::migrations::_2::tests::test_patch_json_deserialization ... ok
test cob::cache::tests::test_check_version ... 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_remove_delegate_concurrent ... ok
test cob::identity::test::test_identity_update_rejected ... ok
test cob::identity::test::test_identity_reject_concurrent ... ok
test cob::identity::test::test_identity_updates ... ok
test cob::issue::cache::tests::test_counts ... ok
test cob::issue::cache::tests::test_get ... ok
test cob::issue::cache::tests::test_is_empty ... ok
test cob::issue::cache::tests::test_list ... ok
test cob::issue::cache::tests::test_list_by_status ... ok
test cob::issue::cache::tests::test_remove ... ok
test cob::identity::test::test_identity_updates_concurrent ... ok
test cob::identity::test::test_valid_identity ... ok
test cob::issue::test::test_embeds ... ok
test cob::identity::test::test_identity_updates_concurrent_outdated ... ok
test cob::issue::test::test_embeds_edit ... ok
test cob::issue::test::test_invalid_actions ... ok
test cob::issue::test::test_invalid_tx ... ok
test cob::issue::test::test_invalid_cob ... ok
test cob::issue::test::test_invalid_tx_reference ... ok
test cob::issue::test::test_issue_all ... ok
test cob::issue::test::test_concurrency ... ok
test cob::issue::test::test_issue_comment ... ok
test cob::issue::test::test_issue_create_and_assign ... ok
test cob::issue::test::test_issue_comment_redact ... ok
test cob::issue::test::test_issue_create_and_get ... ok
test cob::issue::test::test_issue_create_and_change_state ... ok
test cob::issue::test::test_issue_create_and_reassign ... ok
test cob::issue::test::test_issue_create_and_unassign ... 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::patch::cache::tests::test_list ... ok
test cob::patch::cache::tests::test_list_by_status ... ok
test cob::issue::test::test_issue_reply ... 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::cache::tests::test_remove ... 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::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::cache::tests::test_counts ... 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_from_until ... ok
test cob::stream::tests::test_all_until ... ok
test cob::stream::tests::test_regression_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::cache::tests::test_find_by_revision ... 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_rule_validate_failures ... 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::rules::tests::test_canonical ... ok
test git::canonical::tests::test_quorum_different_types ... 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 cob::patch::test::test_patch_update ... 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 cob::thread::tests::prop_ordering ... 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::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_alias ... ok
test node::policy::store::test::test_update_scope ... ok
test node::refs::store::test::test_count ... ok
test node::refs::store::test::test_set_and_delete ... ok
test node::address::store::test::test_empty ... ok
test node::refs::store::test::test_set_and_get ... ok
test node::routing::test::test_count ... ok
test node::routing::test::test_insert_and_get ... ok
test node::routing::test::test_entries ... 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_and_remove ... 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::routing::test::test_prune ... ok
test node::sync::announce::test::announcer_preferred_seeds_or_replica_factor ... 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_synced_with_unknown_node ... ok
test node::sync::announce::test::announcer_reached_preferred_seeds ... 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::could_not_reach_target ... ok
test node::sync::fetch::test::ignores_duplicates_and_local_node ... ok
test node::sync::fetch::test::all_nodes_are_fetchable ... ok
test node::sync::fetch::test::preferred_seeds_target_returned_over_replicas ... ok
test node::sync::fetch::test::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 rad::tests::test_checkout ... ok
test git::canonical::tests::test_quorum_properties ... ok
test rad::tests::test_fork ... ok
test serde_ext::test::test_localtime ... ok
test serde_ext::test::test_localtime_ext ... ok
test rad::tests::test_init ... 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.66s
Running unittests src/lib.rs (/workspace/cache/debug/deps/radicle_cli-90e0b7158ea35ad9)
running 14 tests
test commands::patch::review::builder::tests::test_review_comments_multiline ... ok
test commands::patch::review::builder::tests::test_review_comments_before ... 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::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 git::ddiff::tests::diff_encode_decode_ddiff_hunk ... 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.04s
Running unittests src/main.rs (/workspace/cache/debug/deps/rad-7a737c56230fb7bd)
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-bba39495eb4efa81)
running 109 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 rad_block ... ok
test git_tag ... ok
test rad_auth ... ok
test rad_checkout ... ok
test git_push_converge ... ok
test rad_clone ... ok
test rad_clean ... ok
test rad_clone_bare ... ok
test rad_clone_all ... ok
test rad_clone_unknown ... ok
test rad_clone_directory ... ok
test rad_clone_connect ... 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_help ... ok
test rad_id_collaboration ... ignored, slow
test rad_id ... ok
test rad_id_conflict ... ok
test rad_id_private ... ok
test rad_fetch ... ok
test rad_fork ... ok
test rad_id_multi_delegate ... ok
test rad_id_unknown_field ... ok
test rad_id_update_delete_field ... ok
test rad_init ... ignored, part of many other tests
test rad_id_threshold_soft_fork ... ok
test rad_init_bare ... ok
test rad_id_threshold ... ok
test rad_init_detached_head ... ok
test rad_init_existing ... ok
test rad_init_no_git ... ok
test rad_init_existing_bare ... ok
test rad_init_no_seed ... ok
test rad_init_private ... ok
test rad_init_private_no_seed ... ok
test rad_inbox ... ok
test rad_init_private_clone ... ok
test rad_init_private_clone_seed ... ok
test rad_init_sync_not_connected ... ok
test rad_init_private_seed ... ok
test rad_init_with_existing_remote ... ok
test rad_init_sync_preferred ... ok
test rad_inspect ... ok
test rad_issue ... ok
test rad_jj_bare ... ok
test rad_jj_colocated_patch ... ok
test rad_issue_list ... ok
test rad_key_mismatch ... ok
test rad_merge_no_ff ... ok
test rad_merge_after_update ... ok
test rad_merge_via_push ... ok
test rad_init_sync_and_clone ... ok
test rad_node ... ok
test rad_init_sync_timeout ... ok
test rad_node_connect ... ok
test rad_node_connect_without_address ... ok
test rad_patch_ahead_behind ... ok
test rad_patch_change_base ... ok
test rad_patch ... ok
test rad_patch_checkout ... ok
test rad_patch_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_publish ... ok
test rad_patch_open_explore ... ok
test rad_review_by_hunk ... ok
test rad_seed_and_follow ... ok
test rad_patch_pull_update ... ok
test rad_self ... ok
test rad_push_and_pull_patches ... ok
test rad_remote ... ok
test rad_seed_many ... 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_sync ... ok
test rad_watch ... 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 ----
1759257197 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-OFY61L/work/alice"]
1759257197 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-OFY61L/work/alice`..
1759257198 test: rad-init.md: Running `/workspace/cache/debug/rad` with ["init"] in `/tmp/radicle-OFY61L/work/alice`..
1759257198 test: rad-init.md: Running `/workspace/cache/debug/rad` with ["ls"] in `/tmp/radicle-OFY61L/work/alice`..
1759257198 test: rad-init.md: Running `/workspace/cache/debug/rad` with ["node", "inventory"] in `/tmp/radicle-OFY61L/work/alice`..
1759257198 git_push_canonical_lightweight_tags node: Opening policy database..
1759257198 git_push_canonical_lightweight_tags node: Default seeding policy set to 'block (all)'
1759257198 git_push_canonical_lightweight_tags node: Initializing service (Test)..
1759257198 git_push_canonical_lightweight_tags node: Opening node database..
1759257198 git_push_canonical_lightweight_tags node: Address book is empty. Adding bootstrap nodes..
1759257198 git_push_canonical_lightweight_tags node: 0 nodes added to address book
1759257198 git_push_canonical_lightweight_tags service: Init @1759257198161
1759257198 git_push_canonical_lightweight_tags service: Empty refs database, populating from storage..
1759257198 git_push_canonical_lightweight_tags service: Saved local sync status for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji..
1759257198 git_push_canonical_lightweight_tags service: Adding refs announcement for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji to historical gossip messages..
1759257198 git_push_canonical_lightweight_tags service: Not enough available peers to connect to (available=0, wanted=8)
1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> node: Listening on 0.0.0.0:34091..
1759257198 git_push_canonical_lightweight_tags node: Binding control socket /tmp/radicle-OFY61L/home/alice/.radicle/node/control.sock..
1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <runtime> node: Running node z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi in /tmp/radicle-OFY61L/home/alice/.radicle..
1759257198 git_push_canonical_lightweight_tags node: Opening policy database..
1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <control> control: Control thread listening on socket..
1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <signals> node: Signal notifications channel error: receiving on an empty and disconnected channel
1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Received command QueryState(..)
1759257198 git_push_canonical_lightweight_tags node: Default seeding policy set to 'block (all)'
1759257198 git_push_canonical_lightweight_tags node: Initializing service (Test)..
1759257198 git_push_canonical_lightweight_tags node: Opening node database..
1759257198 git_push_canonical_lightweight_tags node: Address book is empty. Adding bootstrap nodes..
1759257198 git_push_canonical_lightweight_tags node: 0 nodes added to address book
1759257198 git_push_canonical_lightweight_tags service: Init @1759257198433
1759257198 git_push_canonical_lightweight_tags service: Empty refs database, populating from storage..
1759257198 git_push_canonical_lightweight_tags service: Not enough available peers to connect to (available=0, wanted=8)
1759257198 git_push_canonical_lightweight_tags node: Binding control socket /tmp/radicle-OFY61L/home/bob/.radicle/node/control.sock..
1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <runtime> node: Running node z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk in /tmp/radicle-OFY61L/home/bob/.radicle..
1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received command QueryState(..)
1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control> control: Control thread listening on socket..
1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> node: Listening on 0.0.0.0:41711..
1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <signals> node: Signal notifications channel error: receiving on an empty and disconnected channel
1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received command QueryState(..)
1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received command Connect(z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi, 0.0.0.0:34091, ConnectOptions { persistent: false, timeout: 30s })
1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Connecting to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (0.0.0.0:34091)..
1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Attempted connection to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (0.0.0.0:34091)
1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> wire: Registering outbound transport for z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (fd=7)..
1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> wire: Outbound peer resource registered for z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi with id=2 (fd=7)
1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Inbound connection from 127.0.0.1:56038 (fd=177)..
1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Accepted inbound connection from 127.0.0.1:56038 (fd=177)..
1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Inbound peer resource registered with id=2 (fd=177)
1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> wire: Session established with z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (id=2) (fd=7) (outbound)
1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Connected to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (0.0.0.0:34091) (Outbound)
1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Subscribing to messages since timestamp 1759170798596..
1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Session established with z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk (id=2) (fd=177) (inbound)
1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Connected to z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk (127.0.0.1:56038) (Inbound)
1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Subscribing to messages since timestamp 1759170798596..
1759257198 test: Node z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi has converged
1759257198 test: Node has missing routes: [(RepoId(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji), PublicKey(z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi))]
1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Received node announcement of z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk with 0 address(es) from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk (t=1759257198433)
1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received node announcement of z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi with 0 address(es) from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (t=1759257198161)
1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Stored announcement from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi to be broadcast in 0 millisecond(s) (t=1759257198161)
1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Stored announcement from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk to be broadcast in 0 millisecond(s) (t=1759257198433)
1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Address store entry for node z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk updated at 1759257198433
1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Received inventory announcement of z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk with 0 item(s) from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk (t=1759257198434)
1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Address store entry for node z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi updated at 1759257198161
1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received inventory announcement of z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi with 1 item(s) from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (t=1759257198163)
1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Stored announcement from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk to be broadcast in 0 millisecond(s) (t=1759257198434)
1759257198 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Received subscription filter from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk
1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Stored announcement from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi to be broadcast in 0 millisecond(s) (t=1759257198163)
1759257198 test: Node has missing routes: [(RepoId(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji), PublicKey(z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi))]
1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Routing table updated for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji with seed z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received subscription filter from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
1759257198 test: Node z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk has converged
1759257198 test: Running `rad clone ["rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji"]` in /tmp/radicle-OFY61L/work/bob..
1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control> control: Received `{"command":"status"}` on control socket
1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control> control: Received `{"command":"seed","rid":"rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji","scope":"all"}` on control socket
1759257198 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received command Seed(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji, all)
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Sending subscription filter to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
1759257199 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Received subscription filter from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control> control: Received `{"command":"seeds","rid":"rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji"}` on control socket
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received command Seeds(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji)
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Found 1 connected seed(s) and 0 disconnected seed(s) for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control> control: Received `{"command":"session","nid":"z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi"}` on control socket
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received command QueryState(..)
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control> control: Received `{"command":"fetch","rid":"rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji","nid":"z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi","timeout":{"secs":9,"nanos":0}}` on control socket
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Received command Fetch(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji, z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi)
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Fetch initiated for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji with z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi [outbound connected] (all remotes)..
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> wire: Opened new stream with id 12 for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji and remote z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> worker: Worker processing outgoing fetch for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
1759257199 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Received `open` command for stream 12 from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk
1759257199 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <worker#0> worker: Worker processing incoming fetch for z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk on stream 12..
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> worker: z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk cloning from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
1759257199 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <worker#0> worker: Spawning upload-pack process for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji on stream 12..
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> fetch: Fetched rad/id (18ms)
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> fetch: Fetched data for 1 remote(s) (39ms)
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> fetch: Fetched data refs for 1 remotes (52ms)
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> fetch: Sent done signal to remote z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
1759257199 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Received `end-of-file` on stream 12 from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk
1759257199 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <upload-pack> worker: Exiting upload-pack reader thread for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
1759257199 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <worker#0> worker: Upload pack finished (62ms)
1759257199 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <worker#0> worker: Upload process on stream 12 exited with result Ok(())
1759257199 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Received fetch result from worker for stream 12, remote z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk: Responder { rid: Some(RepoId(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji)), result: Ok(()) }
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> fetch: Validated 1 remote(s) (53ms)
1759257199 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Stream 12 of z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk closing with 0 byte(s) sent and 0 byte(s) received
1759257199 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Peer z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk fetched rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji from us successfully
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> wire: Received `close` command for stream 12 from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> wire: Stream 12 of z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi closed with 0 byte(s) sent and 0 byte(s) received
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> fetch: Applied updates (56ms)
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> fetch: Finished clone of rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (67ms)
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> cob: Loading object of type xyz.radicle.id at 0656c217f917c3e06234771e9ecae53aba5e173e
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> storage: Setting ref: refs/rad/id -> 0656c217f917c3e06234771e9ecae53aba5e173e
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> storage: Setting ref: refs/heads/master -> f2de534b5e81d7c6e2dcaf58c3dd91573c0a0354
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> storage: Setting ref: HEAD -> refs/heads/master
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <worker#0> cob: Loading object of type xyz.radicle.id at 0656c217f917c3e06234771e9ecae53aba5e173e
1759257199 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 } } }) }
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Found existing fetch request from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi, sending result..
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Sent fetch result for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi..
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Fetched rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji from z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi successfully
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Ref updated: * 0000000..0656c21 refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/rad/id for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Ref updated: * 0000000..99c5497 refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/rad/sigrefs for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Ref updated: * 0000000..0656c21 refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/cobs/xyz.radicle.id/0656c217f917c3e06234771e9ecae53aba5e173e for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Ref updated: * 0000000..f2de534 refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/heads/master for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Ref updated: * 0000000..0656c21 refs/namespaces/z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/refs/rad/root for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Updating and announcing inventory for cloned repository rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji..
1759257199 test: rad clone: ✓ Seeding policy updated for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji with scope 'all'
1759257199 test: rad clone: Fetching rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji from the network, found 1 potential seed(s).
1759257199 test: rad clone: ✓ Target met: 1 seed(s)
1759257199 test: rad clone: ✓ Creating checkout in ./heartwood..
1759257199 test: rad clone: ✓ Remote alice@z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi added
1759257199 test: rad clone: ✓ Remote-tracking branch alice@z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi/master created for z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
1759257199 test: rad clone: ✓ Repository successfully cloned under /tmp/radicle-OFY61L/work/bob/heartwood/
1759257199 test: rad clone: ╭────────────────────────────────────╮
1759257199 test: rad clone: │ heartwood │
1759257199 test: rad clone: │ Radicle Heartwood Protocol & Stack │
1759257199 test: rad clone: │ 0 issues · 0 patches │
1759257199 test: rad clone: ╰────────────────────────────────────╯
1759257199 test: rad clone: Run `cd ./heartwood` to go to the repository directory.
1759257199 test: Ran command `rad clone` (status=0)
1759257199 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-OFY61L"]
1759257199 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-OFY61L/work/alice`..
1759257199 test: git-push-canonical-lightweight-tags.md: Running `git` with ["tag", "v1.0-hotfix"] in `/tmp/radicle-OFY61L/work/alice`..
1759257199 test: git-push-canonical-lightweight-tags.md: Running `git` with ["push", "rad", "--tags"] in `/tmp/radicle-OFY61L/work/alice`..
1759257199 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <control> control: Received `{"command":"status"}` on control socket
1759257199 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <control> control: Received `{"command":"seeds","rid":"rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji","ns":"z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi"}` on control socket
1759257199 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Received command Seeds(rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji)
1759257199 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:501: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
1759257199 test: Node z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk shutting down..
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control> control: Received `{"command":"shutdown"}` on control socket
1759257199 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <control> control: Shutdown requested..
1759257200 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Sending inventory announcement of z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk with 1 item(s) to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (t=1759257199526)
1759257200 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <service> service: Sending refs announcement of z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk for rad:z42hL2jL4XNk6K8oHQaSWfMgCL7ji with 1 remote(s) to z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi (t=1759257199527)
1759257200 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Disconnecting peer with id=2: connection reset
1759257200 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> wire: Transport handover for disconnecting peer with id=2 (fd=177)
1759257200 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Disconnected from z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk (connection reset)
1759257200 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <service> service: Dropping peer z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk..
1759257200 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <runtime> pool: Worker pool shutting down..
1759257200 z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk <runtime> node: Node shutdown completed for z6Mkt67GdsW7715MEfRuP4pSZxJRJh6kj6Y48WRqVv4N1tRk
1759257200 test: Node z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi shutting down..
1759257200 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <control> control: Received `{"command":"shutdown"}` on control socket
1759257200 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <control> control: Shutdown requested..
1759257200 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <runtime> pool: Worker pool shutting down..
1759257200 z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi <runtime> node: Node shutdown completed for z6MknSLrJoTcukLrE435hVNQT4JUhbvWLX4kUzqkEStBU8Vi
---- rad_patch_fetch_2 stdout ----
1759257250 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-j3sgut/work/alice"]
1759257250 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-j3sgut/work/alice`..
1759257251 test: rad-init.md: Running `/workspace/cache/debug/rad` with ["init"] in `/tmp/radicle-j3sgut/work/alice`..
1759257251 test: rad-init.md: Running `/workspace/cache/debug/rad` with ["ls"] in `/tmp/radicle-j3sgut/work/alice`..
1759257251 test: rad-init.md: Running `/workspace/cache/debug/rad` with ["node", "inventory"] in `/tmp/radicle-j3sgut/work/alice`..
1759257251 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-j3sgut/work/alice"]
1759257251 test: rad-patch-fetch-2.md: Running `git` with ["checkout", "-b", "alice/1", "-q"] in `/tmp/radicle-j3sgut/work/alice`..
1759257251 test: rad-patch-fetch-2.md: Running `git` with ["commit", "--allow-empty", "-m", "Changes #1", "-q"] in `/tmp/radicle-j3sgut/work/alice`..
1759257251 test: rad-patch-fetch-2.md: Running `git` with ["push", "rad", "-o", "patch.message=Changes", "HEAD:refs/patches"] in `/tmp/radicle-j3sgut/work/alice`..
1759257251 test: rad-patch-fetch-2.md: Running `git` with ["checkout", "master", "-q"] in `/tmp/radicle-j3sgut/work/alice`..
1759257251 test: rad-patch-fetch-2.md: Running `git` with ["branch", "-D", "alice/1", "-q"] in `/tmp/radicle-j3sgut/work/alice`..
1759257251 test: rad-patch-fetch-2.md: Running `git` with ["update-ref", "-d", "refs/remotes/rad/alice/1"] in `/tmp/radicle-j3sgut/work/alice`..
1759257251 test: rad-patch-fetch-2.md: Running `git` with ["update-ref", "-d", "refs/remotes/rad/patches/5e2dedcc5d515fcbc1cca483d3376609fe889bfb"] in `/tmp/radicle-j3sgut/work/alice`..
1759257251 test: rad-patch-fetch-2.md: Running `git` with ["gc", "--prune=now"] in `/tmp/radicle-j3sgut/work/alice`..
1759257251 test: rad-patch-fetch-2.md: Running `git` with ["branch", "-r"] in `/tmp/radicle-j3sgut/work/alice`..
1759257251 test: rad-patch-fetch-2.md: Running `git` with ["pull"] in `/tmp/radicle-j3sgut/work/alice`..
1759257251 test: rad-patch-fetch-2.md: Running `git` with ["branch", "-r"] in `/tmp/radicle-j3sgut/work/alice`..
thread 'rad_patch_fetch_2' panicked at crates/radicle-cli-test/src/lib.rs:503: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 ----
1759257254 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-RffxsS/work/alice"]
1759257254 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-RffxsS/work/alice`..
1759257254 test: rad-init.md: Running `/workspace/cache/debug/rad` with ["init"] in `/tmp/radicle-RffxsS/work/alice`..
1759257254 test: rad-init.md: Running `/workspace/cache/debug/rad` with ["ls"] in `/tmp/radicle-RffxsS/work/alice`..
1759257254 test: rad-init.md: Running `/workspace/cache/debug/rad` with ["node", "inventory"] in `/tmp/radicle-RffxsS/work/alice`..
1759257254 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-RffxsS/work/alice"]
1759257254 test: rad-patch-via-push.md: Running `git` with ["checkout", "-b", "feature/1"] in `/tmp/radicle-RffxsS/work/alice`..
1759257254 test: rad-patch-via-push.md: Running `git` with ["commit", "-a", "-m", "Add things", "-q", "--allow-empty"] in `/tmp/radicle-RffxsS/work/alice`..
1759257254 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-RffxsS/work/alice`..
1759257254 test: rad-patch-via-push.md: Running `/workspace/cache/debug/rad` with ["patch", "show", "6035d2f582afbe01ff23ea87528ae523d76875b6"] in `/tmp/radicle-RffxsS/work/alice`..
1759257254 test: rad-patch-via-push.md: Running `git` with ["branch", "-vv"] in `/tmp/radicle-RffxsS/work/alice`..
1759257254 test: rad-patch-via-push.md: Running `git` with ["status", "--short", "--branch"] in `/tmp/radicle-RffxsS/work/alice`..
1759257254 test: rad-patch-via-push.md: Running `git` with ["fetch"] in `/tmp/radicle-RffxsS/work/alice`..
1759257254 test: rad-patch-via-push.md: Running `git` with ["push"] in `/tmp/radicle-RffxsS/work/alice`..
1759257254 test: rad-patch-via-push.md: Running `git` with ["show-ref"] in `/tmp/radicle-RffxsS/work/alice`..
thread 'rad_patch_via_push' panicked at crates/radicle-cli-test/src/lib.rs:503: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. 104 passed; 3 failed; 2 ignored; 0 measured; 0 filtered out; finished in 109.46s
error: test failed, to rerun pass `-p radicle-cli --test commands`
[2025-09-30T18:34:35Z ERROR ambient_ci::plan] ERROR: Action failed: failed to execute cargo
[2025-09-30T18:34:35Z 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-30T18:34:36Z DEBUG ambient_ci::qemu] QEMU: CI run under exit code 1
[2025-09-30T18:34:37Z DEBUG ambient_ci::run] CI run exit code from QEMU: 1
[2025-09-30T18:34:37Z DEBUG ambient_ci::project] write project state to /srv/ambient-state/rad:z3gqcJUoA1n9HaHKufZs5FCSGazv5/meta.yaml
ERROR: CI run failed inside QEMU
<empty log>