Radicle repository id rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x
[2025-09-21T05:41:11Z 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 1.1M 1 disk
vdd 254:48 0 9.3G 0 disk
vde 254:64 0 46.6G 0 disk
vdf 254:80 0 454.6M 1 disk
INFO: Extracting tar archive from /dev/vdb
drwxr-xr-x _rad/_rad 0 2025-09-21 05:40 ./
-rw-r--r-- _rad/_rad 990 2025-09-21 05:40 ./plan.yaml
-rwxr-xr-x _rad/_rad 6410400 2025-09-21 05:40 ./run-ci
INFO: Extracted files:
4587526 4 drwxr-xr-x 2 1001 1001 4096 Sep 21 05:40 .
4587527 4 -rw-r--r-- 1 1001 1001 990 Sep 21 05:40 ./plan.yaml
4587530 6264 -rwxr-xr-x 1 1001 1001 6410400 Sep 21 05:40 ./run-ci
INFO: Running run-ci from /dev/vdb
================================ BEGIN ================================
[2025-09-21T05:40:39Z TRACE ambient_execute_plan] ambient-execute-plan version 0.6.0@6a70056 starts
[2025-09-21T05:40:39Z DEBUG ambient_execute_plan] ambient-execute-plan version 0.6.0@6a70056 starts
[2025-09-21T05:40:39Z INFO ambient_execute_plan] ambient-execute-plan version 0.6.0@6a70056 starts
[2025-09-21T05:40:39Z WARN ambient_execute_plan] ambient-execute-plan version 0.6.0@6a70056 starts
[2025-09-21T05:40:39Z ERROR ambient_execute_plan] ambient-execute-plan version 0.6.0@6a70056 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_clippy
- action: cargo_build
- action: cargo_test
- action: shell
shell: |
export PATH=/root/.cargo/bin:/bin:/sbin
export CARGO_TARGET_DIR=/workspace/cache
make subplot
- 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-21T05:40:39Z DEBUG ambient_ci::plan] RUN: Action Mkdir {
pathname: "/workspace",
}
[2025-09-21T05:40:39Z DEBUG ambient_ci::action] Plan::execute: plan=Mkdir {
pathname: "/workspace",
}
[2025-09-21T05:40:39Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
[2025-09-21T05:40:39Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-21T05:40:39Z DEBUG ambient_ci::plan] RUN: Action Mkdir {
pathname: "/workspace/artifacts",
}
[2025-09-21T05:40:39Z DEBUG ambient_ci::action] Plan::execute: plan=Mkdir {
pathname: "/workspace/artifacts",
}
[2025-09-21T05:40:39Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
[2025-09-21T05:40:39Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-21T05:40:39Z DEBUG ambient_ci::plan] RUN: Action TarExtract {
archive: "/dev/vdc",
directory: "/workspace/src",
}
[2025-09-21T05:40:39Z DEBUG ambient_ci::action] Plan::execute: plan=TarExtract {
archive: "/dev/vdc",
directory: "/workspace/src",
}
[2025-09-21T05:40:39Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
[2025-09-21T05:40:39Z TRACE ambient_ci::vdrive] extracting /dev/vdc to /workspace/src
[2025-09-21T05:40:39Z TRACE ambient_ci::vdrive] extraction OK
[2025-09-21T05:40:39Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-21T05:40:39Z DEBUG ambient_ci::plan] RUN: Action TarExtract {
archive: "/dev/vdf",
directory: "/workspace/deps",
}
[2025-09-21T05:40:39Z DEBUG ambient_ci::action] Plan::execute: plan=TarExtract {
archive: "/dev/vdf",
directory: "/workspace/deps",
}
[2025-09-21T05:40:39Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
[2025-09-21T05:40:39Z TRACE ambient_ci::vdrive] extracting /dev/vdf to /workspace/deps
[2025-09-21T05:40:41Z TRACE ambient_ci::vdrive] extraction OK
[2025-09-21T05:40:41Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-21T05:40:41Z DEBUG ambient_ci::plan] RUN: Action TarExtract {
archive: "/dev/vde",
directory: "/workspace/cache",
}
[2025-09-21T05:40:41Z DEBUG ambient_ci::action] Plan::execute: plan=TarExtract {
archive: "/dev/vde",
directory: "/workspace/cache",
}
[2025-09-21T05:40:41Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
[2025-09-21T05:40:41Z TRACE ambient_ci::vdrive] extracting /dev/vde to /workspace/cache
[2025-09-21T05:40:41Z TRACE ambient_ci::vdrive] extraction OK
[2025-09-21T05:40:41Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-21T05:40:41Z DEBUG ambient_ci::plan] RUN: Action Spawn {
argv: [
"find",
"/workspace",
"-maxdepth",
"2",
"-ls",
],
}
[2025-09-21T05:40:41Z DEBUG ambient_ci::action] Plan::execute: plan=Spawn {
argv: [
"find",
"/workspace",
"-maxdepth",
"2",
"-ls",
],
}
[2025-09-21T05:40:41Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
SPAWN: argv=["find", "/workspace", "-maxdepth", "2", "-ls"]
cwd=/workspace/src (exists? true)
2621441 4 drwxr-xr-x 6 root root 4096 Sep 21 05:40 /workspace
2621668 4 drwxr-xr-x 3 root root 4096 Sep 21 05:40 /workspace/deps
2621669 0 -rw-r--r-- 1 root root 0 Sep 21 03:59 /workspace/deps/.package-cache-mutate
2621672 4 drwxr-xr-x 5 root root 4096 Sep 21 03:59 /workspace/deps/registry
2621670 88 -rw-r--r-- 1 root root 90112 Sep 21 05:40 /workspace/deps/.global-cache
2621671 0 -rw-r--r-- 1 root root 0 Sep 21 03:59 /workspace/deps/.package-cache
2621443 4 drwxr-xr-x 6 root root 4096 Sep 21 05:40 /workspace/src
2621470 4 -rw-r--r-- 1 root root 490 Sep 21 05:40 /workspace/src/Cargo.toml
2621472 4 drwxr-xr-x 8 root root 4096 Sep 21 05:40 /workspace/src/.git
2621659 20 -rw-r--r-- 1 root root 20373 Sep 21 05:40 /workspace/src/obnam.md
2621662 4 drwxr-xr-x 2 root root 4096 Sep 21 05:40 /workspace/src/doc
2621446 4 drwxr-xr-x 3 root root 4096 Sep 21 05:40 /workspace/src/src
2621468 4 -rw-r--r-- 1 root root 3457 Sep 21 05:40 /workspace/src/README.md
2621444 4 drwxr-xr-x 2 root root 4096 Sep 21 05:40 /workspace/src/.radicle
2621467 4 -rw-r--r-- 1 root root 767 Sep 21 05:40 /workspace/src/roadmap.yaml
2621661 32 -rw-r--r-- 1 root root 31712 Sep 21 05:40 /workspace/src/Cargo.lock
2621469 4 -rw-r--r-- 1 root root 26 Sep 21 05:40 /workspace/src/.gitignore
2621667 4 -rw-r--r-- 1 root root 224 Sep 21 05:40 /workspace/src/obnam.subplot
2621660 4 -rw-r--r-- 1 root root 283 Sep 21 05:40 /workspace/src/obnam.yaml
2621658 4 -rw-r--r-- 1 root root 458 Sep 21 05:40 /workspace/src/Makefile
2621471 4 -rw-r--r-- 1 root root 1010 Sep 21 05:40 /workspace/src/obnam.py
2621442 4 drwxr-xr-x 2 root root 4096 Sep 21 05:40 /workspace/artifacts
2636211 4 drwxr-xr-x 3 root root 4096 Sep 21 03:59 /workspace/cache
2636212 4 drwxr-xr-x 7 root root 4096 Sep 21 05:35 /workspace/cache/debug
2638399 4 -rw-r--r-- 1 root root 1038 Sep 21 05:40 /workspace/cache/.rustc_info.json
[2025-09-21T05:40:44Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-21T05:40:44Z DEBUG ambient_ci::plan] RUN: Action CargoClippy
[2025-09-21T05:40:44Z DEBUG ambient_ci::action] Plan::execute: plan=CargoClippy
[2025-09-21T05:40:44Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
SPAWN: argv=["cargo", "--version"]
cwd=/workspace/src (exists? true)
cargo 1.88.0 (873a06493 2025-05-10)
SPAWN: argv=["cargo", "clippy", "--version"]
cwd=/workspace/src (exists? true)
clippy 0.1.88 (6b00bc3880 2025-06-23)
SPAWN: argv=["rustc", "--version"]
cwd=/workspace/src (exists? true)
rustc 1.88.0 (6b00bc388 2025-06-23)
SPAWN: argv=["cargo", "clippy", "--offline", "--locked", "--workspace", "--all-targets", "--no-deps", "--", "--deny", "warnings"]
cwd=/workspace/src (exists? true)
Compiling libc v0.2.175
Checking cfg-if v1.0.3
Compiling proc-macro2 v1.0.101
Compiling unicode-ident v1.0.19
Compiling serde_core v1.0.226
Checking bitflags v2.9.4
Compiling rustix v1.1.2
Compiling serde v1.0.226
Checking linux-raw-sys v0.11.0
Compiling quote v1.0.40
Checking getrandom v0.2.16
Checking rand_core v0.6.4
Compiling autocfg v1.5.0
Compiling syn v2.0.106
Checking crypto-common v0.1.6
Compiling lock_api v0.4.13
Compiling semver v1.0.27
Compiling getrandom v0.3.3
Compiling thiserror v2.0.16
Compiling rustc_version v0.4.1
Compiling libsqlite3-sys v0.35.0
Compiling heapless v0.7.17
Checking anstyle-parse v0.2.7
Checking cipher v0.4.4
Checking anstyle v1.0.11
Checking anstyle-query v1.1.4
Checking colorchoice v1.0.4
Compiling serde_json v1.0.145
Compiling crc32fast v1.5.0
Checking hashbrown v0.16.0
Checking toml_parser v1.0.3
Checking universal-hash v0.5.1
Checking anstream v0.6.20
Checking hashbrown v0.15.5
Checking terminal_size v0.4.3
Checking indexmap v2.11.4
Checking spin v0.9.8
Checking serde_spanned v1.0.2
Checking toml_datetime v0.7.2
Checking dirs-sys-next v0.1.2
Checking once_cell v1.21.3
Checking clap_lex v0.7.5
Checking adler2 v2.0.1
Checking unsafe-libyaml-norway v0.2.15
Checking toml_writer v1.0.3
Checking memchr v2.7.5
Checking toml v0.9.7
Compiling serde_derive v1.0.226
Compiling thiserror-impl v2.0.16
Compiling clap_derive v4.5.47
Checking clap_builder v4.5.48
Checking cobs v0.3.0
Checking tempfile v3.22.0
Checking miniz_oxide v0.8.9
Checking directories-next v2.0.0
Checking polyval v0.6.2
Checking hashlink v0.10.0
Checking aes v0.8.4
Checking ctr v0.9.2
Checking aead v0.5.2
Checking smallvec v1.15.1
Checking flate2 v1.1.2
Checking rusqlite v0.37.0
Checking clap v4.5.48
Checking aes-gcm-siv v0.11.1
Checking uuid v1.18.1
Checking serde_norway v0.9.42
Checking postcard v1.1.3
Checking clingwrap v0.4.0
Checking obnam v0.1.0 (/workspace/src)
Finished `dev` profile [unoptimized + debuginfo] target(s) in 9.20s
[2025-09-21T05:40:54Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-21T05:40:54Z DEBUG ambient_ci::plan] RUN: Action CargoBuild
[2025-09-21T05:40:54Z DEBUG ambient_ci::action] Plan::execute: plan=CargoBuild
[2025-09-21T05:40:54Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
SPAWN: argv=["cargo", "--version"]
cwd=/workspace/src (exists? true)
cargo 1.88.0 (873a06493 2025-05-10)
SPAWN: argv=["cargo", "clippy", "--version"]
cwd=/workspace/src (exists? true)
clippy 0.1.88 (6b00bc3880 2025-06-23)
SPAWN: argv=["rustc", "--version"]
cwd=/workspace/src (exists? true)
rustc 1.88.0 (6b00bc388 2025-06-23)
SPAWN: argv=["cargo", "build", "--offline", "--locked", "--workspace", "--all-targets"]
cwd=/workspace/src (exists? true)
Compiling cfg-if v1.0.3
Compiling libc v0.2.175
Compiling serde_core v1.0.226
Compiling bitflags v2.9.4
Compiling linux-raw-sys v0.11.0
Compiling lock_api v0.4.13
Compiling anstyle-parse v0.2.7
Compiling rustix v1.1.2
Compiling thiserror v2.0.16
Compiling hashbrown v0.16.0
Compiling getrandom v0.2.16
Compiling rand_core v0.6.4
Compiling crypto-common v0.1.6
Compiling cipher v0.4.4
Compiling getrandom v0.3.3
Compiling colorchoice v1.0.4
Compiling anstyle-query v1.1.4
Compiling anstyle v1.0.11
Compiling universal-hash v0.5.1
Compiling indexmap v2.11.4
Compiling anstream v0.6.20
Compiling dirs-sys-next v0.1.2
Compiling toml_parser v1.0.3
Compiling serde v1.0.226
Compiling serde_spanned v1.0.2
Compiling toml_datetime v0.7.2
Compiling terminal_size v0.4.3
Compiling hashbrown v0.15.5
Compiling spin v0.9.8
Compiling toml_writer v1.0.3
Compiling once_cell v1.21.3
Compiling clap_lex v0.7.5
Compiling memchr v2.7.5
Compiling adler2 v2.0.1
Compiling unsafe-libyaml-norway v0.2.15
Compiling tempfile v3.22.0
Compiling hashlink v0.10.0
Compiling serde_json v1.0.145
Compiling miniz_oxide v0.8.9
Compiling serde_norway v0.9.42
Compiling clap_builder v4.5.48
Compiling toml v0.9.7
Compiling heapless v0.7.17
Compiling polyval v0.6.2
Compiling libsqlite3-sys v0.35.0
Compiling directories-next v2.0.0
Compiling crc32fast v1.5.0
Compiling aes v0.8.4
Compiling ctr v0.9.2
Compiling aead v0.5.2
Compiling cobs v0.3.0
Compiling smallvec v1.15.1
Compiling postcard v1.1.3
Compiling rusqlite v0.37.0
Compiling aes-gcm-siv v0.11.1
Compiling clap v4.5.48
Compiling flate2 v1.1.2
Compiling clingwrap v0.4.0
Compiling uuid v1.18.1
Compiling obnam v0.1.0 (/workspace/src)
Finished `dev` profile [unoptimized + debuginfo] target(s) in 8.44s
[2025-09-21T05:41:02Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-21T05:41:02Z DEBUG ambient_ci::plan] RUN: Action CargoTest
[2025-09-21T05:41:02Z DEBUG ambient_ci::action] Plan::execute: plan=CargoTest
[2025-09-21T05:41:02Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
SPAWN: argv=["cargo", "--version"]
cwd=/workspace/src (exists? true)
cargo 1.88.0 (873a06493 2025-05-10)
SPAWN: argv=["cargo", "clippy", "--version"]
cwd=/workspace/src (exists? true)
clippy 0.1.88 (6b00bc3880 2025-06-23)
SPAWN: argv=["rustc", "--version"]
cwd=/workspace/src (exists? true)
rustc 1.88.0 (6b00bc388 2025-06-23)
SPAWN: argv=["cargo", "test", "--offline", "--locked", "--workspace"]
cwd=/workspace/src (exists? true)
Finished `test` profile [unoptimized + debuginfo] target(s) in 0.05s
Running unittests src/lib.rs (/workspace/cache/debug/deps/obnam-4f71915e86cfaf65)
running 33 tests
test chunk::test::id_is_comparable_with_itself ... ok
test chunk::test::id ... ok
test chunk::test::label_round_trip ... ok
test chunk::test::metadata ... ok
test chunk::test::ciphertext_does_not_contain_plaintext ... ok
test chunk::test::metadata_round_trip ... ok
test chunk::test::two_new_chunk_ids_differ ... ok
test cipher::test::aead_round_trip ... ok
test cipher::test::key ... ok
test cipher::test::key_from_string ... ok
test client::test::generates_key ... ok
test client::test::gets_correct_key ... ok
test client::test::has_name ... ok
test client::test::has_no_keys_initially ... ok
test client::test::serialiazion_round_trip ... ok
test client::test::sets_old_versions ... ok
test plaintext::test::compressed ... ok
test plaintext::test::compression_round_trip ... ok
test plaintext::test::uncompressed ... ok
test chunk::test::chunk_round_trip ... ok
test store::test::cant_init_nonexistent_dir ... ok
test store::test::empty_dir_is_not_init ... ok
test credential::test::roundtrip_sop_credential ... ok
test credential::test::roundtrip_sop_method ... ok
test store::test::adds_chunk ... ok
test store::test::finds_no_chunk_in_empty_store ... ok
test store::test::has_no_chunks_initially ... ok
test store::test::nonexistent_dir_is_not_init ... ok
test store::test::finds_no_chunk_when_none_match_label ... ok
test store::test::root_dir_is_not_init ... ok
test store::test::inits_empty_dir ... ok
test store::test::finds_chunk_when_labels_match ... ok
test store::test::removes_chunk ... ok
test result: ok. 33 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.20s
Running unittests src/bin/obnam.rs (/workspace/cache/debug/deps/obnam-6274f7325498b9bb)
running 0 tests
test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
Doc-tests obnam
running 1 test
test src/runner.rs - runner (line 8) ... ok
test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[2025-09-21T05:41:04Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-21T05:41:04Z DEBUG ambient_ci::plan] RUN: Action Shell {
shell: "export PATH=/root/.cargo/bin:/bin:/sbin\nexport CARGO_TARGET_DIR=/workspace/cache\nmake subplot\n",
}
[2025-09-21T05:41:04Z DEBUG ambient_ci::action] Plan::execute: plan=Shell {
shell: "export PATH=/root/.cargo/bin:/bin:/sbin\nexport CARGO_TARGET_DIR=/workspace/cache\nmake subplot\n",
}
[2025-09-21T05:41:04Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
SPAWN: argv=["/bin/bash", "-c", "set -xeuo pipefail\nexport PATH=/root/.cargo/bin:/bin:/sbin\nexport CARGO_TARGET_DIR=/workspace/cache\nmake subplot\n\n"]
cwd=/workspace/src (exists? true)
+ export PATH=/root/.cargo/bin:/bin:/sbin
+ PATH=/root/.cargo/bin:/bin:/sbin
+ export CARGO_TARGET_DIR=/workspace/cache
+ CARGO_TARGET_DIR=/workspace/cache
+ make subplot
subplot docgen obnam.subplot --output obnam.html
[32m INFO[0m Starting Subplot
[32m INFO[0m Subplot finished successfully
subplot codegen obnam.subplot --output test.py
[32m INFO[0m Starting Subplot
[32m INFO[0m Subplot finished successfully
rm -f test.log
python3 test.py --log test.log
srcdir /workspace/src
datadir /tmp/tmpre82_ojx
scenario: Extracting a certificate from a key
step: given an installed obnam
step: given file alice.key
step: when I run obnam sop extract-cert rsop alice.key
step: then stdout isn't exactly ""
scenario: Avoid client chunks with the same name
step: given an installed obnam
step: given file .config/obnam/config.yaml from config.yaml
step: when I create directory mychunks
step: when I run obnam store init
step: when I run obnam --client-key my.secret client init my.host
step: then command is successful
step: when I try to run obnam --client-key my.secret client init my.host
step: then command fails
scenario: Chunk encrypt/decrypt round trip via file
step: given an installed obnam
step: given file greeting.txt
step: when I run obnam chunk encrypt --key secret --label sticky.tape greeting.txt --output chunk.file
step: when I run obnam chunk decrypt --key secret chunk.file
step: then stdout is exactly "Hello, world.\n"
scenario: Encryption round trip
step: given an installed obnam
step: given file alice.key
step: given file hello.txt
step: when I run obnam sop encrypt rsop alice.key hello.txt -o encrypted
step: when I run ls -l encrypted
step: when I run cat encrypted
step: when I run obnam sop decrypt rsop alice.key encrypted
step: then stdout is exactly "hello, world\n"
scenario: List clients
step: given an installed obnam
step: given file .config/obnam/config.yaml from config.yaml
step: when I create directory mychunks
step: when I run obnam store init
step: when I run obnam --client-key my.secret client init my.host
step: when I run obnam --client-key my.secret client list
step: then stdout is exactly "my.host\n"
scenario: Initialize a store
step: given an installed obnam
step: given file .config/obnam/config.yaml from config.yaml
step: then directory mychunks does not exist
step: when I try to run obnam store is
step: then command fails
step: when I create directory mychunks
step: when I try to run obnam store is
step: then command fails
step: when I run obnam store init
step: when I run obnam store is
step: then exit code is 0
scenario: Round trip chunk encryption using key from client chunk
step: given an installed obnam
step: given file .config/obnam/config.yaml from config.yaml
step: given file greeting.txt
step: when I create directory mychunks
step: when I run obnam store init
step: when I run obnam --client-key my.secret client init my.host
step: when I run obnam --client-key my.secret client generate my.host my.key
step: when I run obnam --client-key my.secret chunk encrypt --client-name my.host --key-name my.key --label sticky.tape greeting.txt --output chunk.file
step: when I run obnam --client-key my.secret chunk decrypt --client-name my.host --key-name my.key chunk.file
step: then stdout is exactly "Hello, world.\n"
scenario: Generate new key
step: given an installed obnam
step: given file .config/obnam/config.yaml from config.yaml
step: when I create directory mychunks
step: when I run obnam store init
step: when I run obnam --client-key my.secret client init my.host
step: when I run obnam --client-key my.secret client generate my.host my.key
step: when I run obnam --client-key my.secret client show my.host
step: then stdout contains "my.key"
scenario: Initialize a client chunk
step: given an installed obnam
step: given file .config/obnam/config.yaml from config-with-credential.yaml
step: when I create directory mychunks
step: when I run obnam store init
step: when I run obnam client init my.host --credential softy
step: then command is successful
step: when I run obnam credential list --all
step: then stdout isn't exactly ""
scenario: Find chunks using labels
step: given an installed obnam
step: given file .config/obnam/config.yaml from config.yaml
step: given file chunk.blob
step: given a directory mychunks
step: when I run obnam store init
step: when I run obnam store add xyzzy data-chunk chunk.blob
step: when I run obnam store add plugh data-chunk chunk.blob
step: when I run obnam store add advent client-chunk chunk.blob
step: when I run obnam store find missing
step: then stdout is exactly ""
step: when I run obnam store find data-chunk
step: then stdout contains "xyzzy"
step: then stdout contains "plugh"
step: then stdout doesn't contain "advent"
step: when I run obnam store find client-chunk
step: then stdout doesn't contain "xyzzy"
step: then stdout doesn't contain "plugh"
step: then stdout contains "advent"
scenario: Chunk encrypt/decrypt round trip via repository
step: given an installed obnam
step: given file .config/obnam/config.yaml from config.yaml
step: given file greeting.txt
step: when I create directory mychunks
step: when I try to run obnam store init
step: when I run obnam chunk encrypt --key secret --label sticky.tape greeting.txt --id=chunk0
step: when I run obnam store list
step: when I run obnam chunk decrypt --key secret --id chunk0
step: then stdout is exactly "Hello, world.\n"
scenario: Inspect an encrypted chunk using key from client chunk
step: given an installed obnam
step: given file .config/obnam/config.yaml from config.yaml
step: given file greeting.txt
step: when I create directory mychunks
step: when I run obnam store init
step: when I run obnam --client-key my.secret client init my.host
step: when I run obnam --client-key my.secret client generate my.host my.key
step: when I run obnam --client-key my.secret chunk encrypt --client-name my.host --key-name my.key --label sticky.tape greeting.txt --output chunk.file
step: when I run obnam --client-key my.secret chunk inspect --filename chunk.file --client-name my.host --key-name my.key
step: then stdout is valid JSON
step: then stdout contains ""id":"
step: then stdout contains ""label":"
step: then stdout contains ""data": ""
scenario: Add a chunk to the store.
step: given an installed obnam
step: given file .config/obnam/config.yaml from config.yaml
step: given file chunk.blob
step: given a directory mychunks
step: when I run obnam store init
step: when I run obnam store add xyzzy data-chunk chunk.blob
step: when I run obnam store list
step: then stdout is exactly "xyzzy\n"
scenario: Inspect an encoded chunk in repository
step: given an installed obnam
step: given file .config/obnam/config.yaml from config.yaml
step: given file greeting.txt
step: when I create directory mychunks
step: when I try to run obnam store init
step: when I run obnam chunk encrypt --label sticky.tape --key secret greeting.txt --id=chunk0
step: when I run obnam chunk inspect --id chunk0
step: then stdout is valid JSON
step: then stdout contains ""id":"
step: then stdout contains ""label":"
step: then stdout contains ""data": null"
step: when I run obnam chunk inspect --key secret --id chunk0
step: then stdout is valid JSON
step: then stdout contains ""id":"
step: then stdout contains ""label":"
step: then stdout contains ""data": ""
scenario: Remove a chunk from store
step: given an installed obnam
step: given file .config/obnam/config.yaml from config.yaml
step: given file chunk.blob
step: given a directory mychunks
step: when I run obnam store init
step: when I run obnam store add xyzzy data-chunk chunk.blob
step: when I run obnam store remove xyzzy
step: when I run obnam store list
step: then stdout doesn't contain "xyzzy"
scenario: Get path to chunk in store
step: given an installed obnam
step: given file .config/obnam/config.yaml from config.yaml
step: given file chunk.blob
step: given a directory mychunks
step: when I run obnam store init
step: when I run obnam store add xyzzy data-chunk chunk.blob
step: when I run obnam store path xyzzy -o chunk.filename
step: then a file exists whose name is in chunk.filename
scenario: Chunk encrypt/decrypt with compression round trip via file
step: given an installed obnam
step: given file greeting.txt
step: when I run obnam chunk encrypt --compress --key secret --label sticky.tape greeting.txt --output chunk.file
step: when I run obnam chunk decrypt --key secret chunk.file
step: then stdout is exactly "Hello, world.\n"
scenario: Chunk encrypt/decrypt with compression round trip via repository
step: given an installed obnam
step: given file .config/obnam/config.yaml from config.yaml
step: given file greeting.txt
step: when I create directory mychunks
step: when I try to run obnam store init
step: when I run obnam chunk encrypt --compress --key secret --label sticky.tape greeting.txt --id=chunk0
step: when I run obnam store list
step: when I run obnam chunk decrypt --key secret --id chunk0
step: then stdout is exactly "Hello, world.\n"
scenario: Create an OpenPGP software key credential
step: given an installed obnam
step: given file .config/obnam/config.yaml from config.yaml
step: given file sop-generate
step: when I run bash sop-generate alice.tsk
step: when I create directory mychunks
step: when I run obnam store init
step: when I run obnam credential list
step: then stdout is exactly ""
step: when I run obnam --client-key my.secret credential openpgp-soft alice.tsk
step: when I run obnam credential list --all
step: then stdout isn't exactly ""
scenario: Conveniently encrypt and decrypt chunk in a store
step: given an installed obnam
step: given file .config/obnam/config.yaml from comfy.yaml
step: given file message.txt
step: when I create directory chunk.store
step: when I run obnam store init --credential softy --client testy
step: when I run obnam chunk encrypt --label data --client-name testy --key-name default --id test.chunk message.txt
step: when I run obnam chunk decrypt --client-name testy --key-name default --id test.chunk --output out.dat
step: then files message.txt and out.dat match
scenario: Show client
step: given an installed obnam
step: given file .config/obnam/config.yaml from config.yaml
step: when I create directory mychunks
step: when I run obnam store init
step: when I run obnam --client-key my.secret client init my.host
step: when I run obnam --client-key my.secret client show my.host
step: then stdout is valid JSON
scenario: Inspect an encoded chunk in file
step: given an installed obnam
step: given file greeting.txt
step: when I run obnam chunk encrypt --label sticky.tape --key secret greeting.txt --output chunk.file
step: when I run obnam chunk inspect --filename chunk.file
step: then stdout is valid JSON
step: then stdout contains ""id":"
step: then stdout contains ""label":"
step: then stdout contains ""data": null"
step: when I run obnam chunk inspect --filename chunk.file --key secret
step: then stdout is valid JSON
step: then stdout contains ""id":"
step: then stdout contains ""label":"
step: then stdout contains ""data": ""
scenario: Conveniently initialize a store with OpenPGP software key credential
step: given an installed obnam
step: given file .config/obnam/config.yaml from comfy.yaml
step: when I create directory chunk.store
step: when I run obnam store init --credential softy
step: when I run obnam store list
step: then stdout is exactly ""
OK, all scenarios finished successfully
[2025-09-21T05:41:05Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-21T05:41:05Z DEBUG ambient_ci::plan] RUN: Action TarCreate {
archive: "/dev/vde",
directory: "/workspace/cache",
}
[2025-09-21T05:41:05Z DEBUG ambient_ci::action] Plan::execute: plan=TarCreate {
archive: "/dev/vde",
directory: "/workspace/cache",
}
[2025-09-21T05:41:05Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
[2025-09-21T05:41:05Z TRACE ambient_ci::vdrive] creating virtual drive (tar archive): VirtualDriveBuilder {
filename: Some(
"/dev/vde",
),
root: Some(
"/workspace/cache",
),
size: None,
}
[2025-09-21T05:41:05Z TRACE ambient_ci::vdrive] tar archive to be created: /dev/vde; exists? true
[2025-09-21T05:41:05Z TRACE ambient_ci::vdrive] create archive file /dev/vde
[2025-09-21T05:41:05Z TRACE ambient_ci::vdrive] directory /workspace/cache exists? true
[2025-09-21T05:41:05Z TRACE ambient_ci::vdrive] add contents of /workspace/cache as .
[2025-09-21T05:41:05Z TRACE ambient_ci::vdrive] calling tar_create
[2025-09-21T05:41:06Z TRACE ambient_ci::vdrive] created virtual drive /dev/vde
[2025-09-21T05:41:06Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-21T05:41:06Z DEBUG ambient_ci::plan] RUN: Action TarCreate {
archive: "/dev/vdd",
directory: "/workspace/artifacts",
}
[2025-09-21T05:41:06Z DEBUG ambient_ci::action] Plan::execute: plan=TarCreate {
archive: "/dev/vdd",
directory: "/workspace/artifacts",
}
[2025-09-21T05:41:06Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
[2025-09-21T05:41:06Z TRACE ambient_ci::vdrive] creating virtual drive (tar archive): VirtualDriveBuilder {
filename: Some(
"/dev/vdd",
),
root: Some(
"/workspace/artifacts",
),
size: None,
}
[2025-09-21T05:41:06Z TRACE ambient_ci::vdrive] tar archive to be created: /dev/vdd; exists? true
[2025-09-21T05:41:06Z TRACE ambient_ci::vdrive] create archive file /dev/vdd
[2025-09-21T05:41:06Z TRACE ambient_ci::vdrive] directory /workspace/artifacts exists? true
[2025-09-21T05:41:06Z TRACE ambient_ci::vdrive] add contents of /workspace/artifacts as .
[2025-09-21T05:41:06Z TRACE ambient_ci::vdrive] calling tar_create
[2025-09-21T05:41:06Z TRACE ambient_ci::vdrive] created virtual drive /dev/vdd
[2025-09-21T05:41:06Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-21T05:41:06Z DEBUG ambient_ci::plan] All actions were performed successfully
ambient-execute-plan ends
EXIT CODE: 0
[2025-09-21T05:41:11Z INFO ambient] ambient ends successfully
{
"request": "trigger",
"version": 1,
"event_type": "patch",
"repository": {
"id": "rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x",
"name": "obnam",
"description": "Explore implementation of backup fundamentals",
"private": false,
"default_branch": "main",
"delegates": [
"did:key:z6MkgEMYod7Hxfy9qCvDv5hYHkZ4ciWmLFgfvm3Wn1b2w2FV"
]
},
"action": "Created",
"patch": {
"id": "dc54b1268a223750b58eb1b89bbe1335f7c0d13c",
"author": {
"id": "did:key:z6MkgEMYod7Hxfy9qCvDv5hYHkZ4ciWmLFgfvm3Wn1b2w2FV",
"alias": "liw"
},
"title": "update dependencies",
"state": {
"status": "open",
"conflicts": []
},
"before": "021794ea8d28a25dac18bb7962304c5a9185c8fe",
"after": "f1854d7b6111d545e2f6361f7b7ae568bb45b40b",
"commits": [
"f1854d7b6111d545e2f6361f7b7ae568bb45b40b",
"49c42d6bb6dd2edcbc4558384e07422b8a2f247a"
],
"target": "021794ea8d28a25dac18bb7962304c5a9185c8fe",
"labels": [],
"assignees": [],
"revisions": [
{
"id": "dc54b1268a223750b58eb1b89bbe1335f7c0d13c",
"author": {
"id": "did:key:z6MkgEMYod7Hxfy9qCvDv5hYHkZ4ciWmLFgfvm3Wn1b2w2FV",
"alias": "liw"
},
"description": "",
"base": "021794ea8d28a25dac18bb7962304c5a9185c8fe",
"oid": "f1854d7b6111d545e2f6361f7b7ae568bb45b40b",
"timestamp": 1758433228
}
]
}
}[2025-09-21T05:40:29Z INFO ambient] ambient starts
[2025-09-21T05:40:29Z DEBUG ambient] load default configuration file /home/_rad/.config/ambient/config.yaml if it exists
[2025-09-21T05:40:29Z 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-21T05:40:29Z 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-21T05:40:29Z DEBUG ambient_ci::project] load project state from /srv/ambient-state/rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x/meta.yaml
[2025-09-21T05:40:29Z DEBUG ambient_ci::run] latest commit: "021794ea8d28a25dac18bb7962304c5a9185c8fe"
[2025-09-21T05:40:29Z DEBUG ambient_ci::run] is a git repository
[2025-09-21T05:40:29Z DEBUG ambient_ci::run] git repository is clean
[2025-09-21T05:40:29Z DEBUG ambient_ci::run] current (HEAD) commit: f1854d7b6111d545e2f6361f7b7ae568bb45b40b
[2025-09-21T05:40:29Z DEBUG ambient_ci::run] no dry run requested
[2025-09-21T05:40:29Z DEBUG ambient_ci::run] forced run requested
[2025-09-21T05:40:29Z DEBUG ambient_ci::run] run? true
[2025-09-21T05:40:29Z INFO ambient_ci::run] project rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x: running CI
[2025-09-21T05:40:29Z DEBUG ambient_ci::run] Executing pre-plan steps
[2025-09-21T05:40:29Z DEBUG ambient_ci::plan] RUN: Action CargoFetch {
sourcedir: "/tmp/.tmpa87VTS/src",
}
[2025-09-21T05:40:29Z DEBUG ambient_ci::action] Plan::execute: plan=CargoFetch {
sourcedir: "/tmp/.tmpa87VTS/src",
}
[2025-09-21T05:40:29Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"CARGO_TARGET_DIR": "/srv/ambient-state/rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x/cache",
"CARGO_HOME": "/srv/ambient-state/rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x/dependencies",
"PATH": "/root/.cargo/bin:/bin:/home/_rad/.radicle/bin:/home/_rad/.cargo/bin",
},
source_dir: "/tmp/.tmpa87VTS/src",
}
SPAWN: argv=["cargo", "--version"]
cwd=/tmp/.tmpa87VTS/src (exists? true)
cargo 1.90.0 (840b83a10 2025-07-30)
SPAWN: argv=["cargo", "clippy", "--version"]
cwd=/tmp/.tmpa87VTS/src (exists? true)
clippy 0.1.90 (1159e78c47 2025-09-14)
SPAWN: argv=["rustc", "--version"]
cwd=/tmp/.tmpa87VTS/src (exists? true)
rustc 1.90.0 (1159e78c4 2025-09-14)
SPAWN: argv=["cargo", "fetch"]
cwd=/tmp/.tmpa87VTS/src (exists? true)
Updating crates.io index
Downloading crates ...
Downloaded wasm-bindgen-macro v0.2.103
Downloaded proc-macro2 v1.0.101
Downloaded wasm-bindgen v0.2.103
Downloaded windows-link v0.2.0
Downloaded wasm-bindgen-shared v0.2.103
Downloaded wasi v0.14.7+wasi-0.2.4
Downloaded errno v0.3.14
Downloaded adler2 v2.0.1
Downloaded thiserror v2.0.16
Downloaded anstyle-parse v0.2.7
Downloaded tempfile v3.22.0
Downloaded colorchoice v1.0.4
Downloaded once_cell_polyfill v1.70.1
Downloaded serde_core v1.0.226
Downloaded anstyle-query v1.1.4
Downloaded anstyle v1.0.11
Downloaded anstream v0.6.20
Downloaded toml v0.9.7
Downloaded smallvec v1.15.1
Downloaded clap_derive v4.5.47
Downloaded clap v4.5.48
Downloaded memchr v2.7.5
Downloaded indexmap v2.11.4
Downloaded serde_json v1.0.145
Downloaded miniz_oxide v0.8.9
Downloaded serde_derive v1.0.226
Downloaded unsafe-libyaml-norway v0.2.15
Downloaded serde_norway v0.9.42
Downloaded toml_parser v1.0.3
Downloaded wasip2 v1.0.1+wasi-0.2.4
Downloaded rusqlite v0.37.0
Downloaded bumpalo v3.19.0
Downloaded clap_builder v4.5.48
Downloaded hashbrown v0.16.0
Downloaded syn v2.0.106
Downloaded hashbrown v0.15.5
Downloaded serde v1.0.226
Downloaded wasi v0.11.1+wasi-snapshot-preview1
Downloaded crc32fast v1.5.0
Downloaded lock_api v0.4.13
Downloaded semver v1.0.27
Downloaded terminal_size v0.4.3
Downloaded toml_datetime v0.7.2
Downloaded toml_writer v1.0.3
Downloaded rustix v1.1.2
Downloaded wit-bindgen v0.46.0
Downloaded getrandom v0.3.3
Downloaded anstyle-wincon v3.0.10
Downloaded clap_lex v0.7.5
Downloaded clingwrap v0.4.0
Downloaded cobs v0.3.0
Downloaded autocfg v1.5.0
Downloaded r-efi v5.3.0
Downloaded windows-targets v0.53.3
Downloaded postcard v1.1.3
Downloaded uuid v1.18.1
Downloaded js-sys v0.3.80
Downloaded log v0.4.28
Downloaded windows-link v0.1.3
Downloaded serde_spanned v1.0.2
Downloaded libc v0.2.175
Downloaded libredox v0.1.10
Downloaded bitflags v2.9.4
Downloaded windows_aarch64_gnullvm v0.53.0
Downloaded windows_i686_gnullvm v0.53.0
Downloaded windows_x86_64_gnullvm v0.53.0
Downloaded wasm-bindgen-macro-support v0.2.103
Downloaded windows_x86_64_msvc v0.53.0
Downloaded windows_aarch64_msvc v0.53.0
Downloaded windows_i686_msvc v0.53.0
Downloaded windows_x86_64_gnu v0.53.0
Downloaded unicode-ident v1.0.19
Downloaded thiserror-impl v2.0.16
Downloaded windows_i686_gnu v0.53.0
Downloaded once_cell v1.21.3
Downloaded wasm-bindgen-backend v0.2.103
Downloaded cfg-if v1.0.3
Downloaded rustversion v1.0.22
Downloaded windows-sys v0.61.0
Downloaded windows-sys v0.60.2
Downloaded linux-raw-sys v0.11.0
Downloaded libsqlite3-sys v0.35.0
[2025-09-21T05:40:30Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-21T05:40:30Z DEBUG ambient_ci::plan] All actions were performed successfully
[2025-09-21T05:40:30Z DEBUG ambient_ci::run] create virtual drive /srv/tmp/.tmpOmzZVZ/src.tar
[2025-09-21T05:40:30Z DEBUG ambient_ci::run] create virtual drive /srv/tmp/.tmpOmzZVZ/deps.tar
[2025-09-21T05:40:31Z DEBUG ambient_ci::run] create_executor_vdrive: executor="/usr/bin/ambient-execute-plan"
[2025-09-21T05:40:31Z 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",
],
},
CargoClippy,
CargoBuild,
CargoTest,
Shell {
shell: "export PATH=/root/.cargo/bin:/bin:/sbin\nexport CARGO_TARGET_DIR=/workspace/cache\nmake subplot\n",
},
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-21T05:40:31Z DEBUG ambient_ci::run] executor bin /usr/bin/ambient-execute-plan
[2025-09-21T05:40:31Z DEBUG ambient_ci::run] copying /usr/bin/ambient-execute-plan to /srv/tmp/.tmpOmzZVZ/ambient-execute-plan/run-ci
[2025-09-21T05:40:31Z DEBUG ambient_ci::run] copy OK: true
[2025-09-21T05:40:31Z DEBUG ambient_ci::run] create virtual drive /srv/tmp/.tmpOmzZVZ/executor.tar
[2025-09-21T05:40:32Z DEBUG ambient_ci::project] removing run log file /srv/ambient-state/rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x/run.log
[2025-09-21T05:40:32Z DEBUG ambient_ci::project] statedir is /srv/ambient-state/rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x, exists? true
[2025-09-21T05:40:32Z DEBUG ambient_ci::project] creating run log file /srv/ambient-state/rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x/run.log
[2025-09-21T05:40:32Z DEBUG ambient_ci::project] created run log file /srv/ambient-state/rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x/run.log OK
[2025-09-21T05:40:32Z DEBUG ambient_ci::cloud_init] with_hostname called: "ambient"
[2025-09-21T05:40:32Z DEBUG ambient_ci::cloud_init] with_runcmd called: "echo xyzzy > /dev/ttyS1"
[2025-09-21T05:40:32Z 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-21T05:40:32Z DEBUG ambient_ci::cloud_init] with_runcmd called: "poweroff"
[2025-09-21T05:40:32Z 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-21T05:40:32Z DEBUG ambient_ci::qemu] run QEMU
[2025-09-21T05:40:32Z DEBUG ambient_ci::qemu] create copy-on-write image and UEFI vars file
[2025-09-21T05:40:32Z DEBUG ambient_ci::qemu_utils] qemu-img create /srv/tmp/.tmpc32DVM/.tmpoOioX8/vm.qcow2 backing on /home/_rad/ambient.qcow2
[2025-09-21T05:40:32Z DEBUG ambient_ci::qemu] create cloud-init ISO file
[2025-09-21T05:40:32Z 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-21T05:40:32Z DEBUG ambient_ci::cloud_init] write /tmp/.tmpQUWZzq/meta-data
[2025-09-21T05:40:32Z DEBUG ambient_ci::cloud_init] write /tmp/.tmpQUWZzq/user-data
[2025-09-21T05:40:32Z DEBUG ambient_ci::qemu] set console log file to /srv/tmp/.tmpc32DVM/.tmpoOioX8/console.log
[2025-09-21T05:40:32Z DEBUG ambient_ci::util] create file /srv/tmp/.tmpc32DVM/.tmpoOioX8/console.log
[2025-09-21T05:40:32Z DEBUG ambient_ci::qemu] set run file to /srv/ambient-state/rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x/run.log
[2025-09-21T05:40:32Z DEBUG ambient_ci::util] create file /srv/ambient-state/rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x/run.log
[2025-09-21T05:40:32Z 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/.tmpc32DVM/.tmpoOioX8/console.log",
"-serial",
"file:/srv/ambient-state/rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x/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/.tmpc32DVM/.tmpoOioX8/vars.fd",
"-drive",
"format=qcow2,if=virtio,file=/srv/tmp/.tmpc32DVM/.tmpoOioX8/vm.qcow2",
"-drive",
"format=raw,if=virtio,file=/srv/tmp/.tmpOmzZVZ/executor.tar,readonly=on",
"-cdrom",
"/srv/tmp/.tmpc32DVM/.tmpoOioX8/cloud_init.iso",
"-drive",
"format=raw,if=virtio,file=/srv/tmp/.tmpOmzZVZ/src.tar,readonly=on",
"-drive",
"format=raw,if=virtio,file=/srv/tmp/.tmpOmzZVZ/artifacts.tar",
"-drive",
"format=raw,if=virtio,file=/srv/tmp/.tmpOmzZVZ/cache.tar",
"-drive",
"format=raw,if=virtio,file=/srv/tmp/.tmpOmzZVZ/deps.tar,readonly=on",
"-nodefaults",
"-no-user-config",
],
}
[2025-09-21T05:41:10Z DEBUG ambient_ci::qemu] QEMU finished OK
[2025-09-21T05:41:10Z DEBUG ambient_ci::qemu] run log:
--------------------==========
[2025-09-21T05:40:39Z TRACE ambient_execute_plan] ambient-execute-plan version 0.6.0@6a70056 starts
[2025-09-21T05:40:39Z DEBUG ambient_execute_plan] ambient-execute-plan version 0.6.0@6a70056 starts
[2025-09-21T05:40:39Z INFO ambient_execute_plan] ambient-execute-plan version 0.6.0@6a70056 starts
[2025-09-21T05:40:39Z WARN ambient_execute_plan] ambient-execute-plan version 0.6.0@6a70056 starts
[2025-09-21T05:40:39Z ERROR ambient_execute_plan] ambient-execute-plan version 0.6.0@6a70056 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_clippy
- action: cargo_build
- action: cargo_test
- action: shell
shell: |
export PATH=/root/.cargo/bin:/bin:/sbin
export CARGO_TARGET_DIR=/workspace/cache
make subplot
- 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-21T05:40:39Z DEBUG ambient_ci::plan] RUN: Action Mkdir {
pathname: "/workspace",
}
[2025-09-21T05:40:39Z DEBUG ambient_ci::action] Plan::execute: plan=Mkdir {
pathname: "/workspace",
}
[2025-09-21T05:40:39Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
[2025-09-21T05:40:39Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-21T05:40:39Z DEBUG ambient_ci::plan] RUN: Action Mkdir {
pathname: "/workspace/artifacts",
}
[2025-09-21T05:40:39Z DEBUG ambient_ci::action] Plan::execute: plan=Mkdir {
pathname: "/workspace/artifacts",
}
[2025-09-21T05:40:39Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
[2025-09-21T05:40:39Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-21T05:40:39Z DEBUG ambient_ci::plan] RUN: Action TarExtract {
archive: "/dev/vdc",
directory: "/workspace/src",
}
[2025-09-21T05:40:39Z DEBUG ambient_ci::action] Plan::execute: plan=TarExtract {
archive: "/dev/vdc",
directory: "/workspace/src",
}
[2025-09-21T05:40:39Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
[2025-09-21T05:40:39Z TRACE ambient_ci::vdrive] extracting /dev/vdc to /workspace/src
[2025-09-21T05:40:39Z TRACE ambient_ci::vdrive] extraction OK
[2025-09-21T05:40:39Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-21T05:40:39Z DEBUG ambient_ci::plan] RUN: Action TarExtract {
archive: "/dev/vdf",
directory: "/workspace/deps",
}
[2025-09-21T05:40:39Z DEBUG ambient_ci::action] Plan::execute: plan=TarExtract {
archive: "/dev/vdf",
directory: "/workspace/deps",
}
[2025-09-21T05:40:39Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
[2025-09-21T05:40:39Z TRACE ambient_ci::vdrive] extracting /dev/vdf to /workspace/deps
[2025-09-21T05:40:41Z TRACE ambient_ci::vdrive] extraction OK
[2025-09-21T05:40:41Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-21T05:40:41Z DEBUG ambient_ci::plan] RUN: Action TarExtract {
archive: "/dev/vde",
directory: "/workspace/cache",
}
[2025-09-21T05:40:41Z DEBUG ambient_ci::action] Plan::execute: plan=TarExtract {
archive: "/dev/vde",
directory: "/workspace/cache",
}
[2025-09-21T05:40:41Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
[2025-09-21T05:40:41Z TRACE ambient_ci::vdrive] extracting /dev/vde to /workspace/cache
[2025-09-21T05:40:41Z TRACE ambient_ci::vdrive] extraction OK
[2025-09-21T05:40:41Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-21T05:40:41Z DEBUG ambient_ci::plan] RUN: Action Spawn {
argv: [
"find",
"/workspace",
"-maxdepth",
"2",
"-ls",
],
}
[2025-09-21T05:40:41Z DEBUG ambient_ci::action] Plan::execute: plan=Spawn {
argv: [
"find",
"/workspace",
"-maxdepth",
"2",
"-ls",
],
}
[2025-09-21T05:40:41Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
SPAWN: argv=["find", "/workspace", "-maxdepth", "2", "-ls"]
cwd=/workspace/src (exists? true)
2621441 4 drwxr-xr-x 6 root root 4096 Sep 21 05:40 /workspace
2621668 4 drwxr-xr-x 3 root root 4096 Sep 21 05:40 /workspace/deps
2621669 0 -rw-r--r-- 1 root root 0 Sep 21 03:59 /workspace/deps/.package-cache-mutate
2621672 4 drwxr-xr-x 5 root root 4096 Sep 21 03:59 /workspace/deps/registry
2621670 88 -rw-r--r-- 1 root root 90112 Sep 21 05:40 /workspace/deps/.global-cache
2621671 0 -rw-r--r-- 1 root root 0 Sep 21 03:59 /workspace/deps/.package-cache
2621443 4 drwxr-xr-x 6 root root 4096 Sep 21 05:40 /workspace/src
2621470 4 -rw-r--r-- 1 root root 490 Sep 21 05:40 /workspace/src/Cargo.toml
2621472 4 drwxr-xr-x 8 root root 4096 Sep 21 05:40 /workspace/src/.git
2621659 20 -rw-r--r-- 1 root root 20373 Sep 21 05:40 /workspace/src/obnam.md
2621662 4 drwxr-xr-x 2 root root 4096 Sep 21 05:40 /workspace/src/doc
2621446 4 drwxr-xr-x 3 root root 4096 Sep 21 05:40 /workspace/src/src
2621468 4 -rw-r--r-- 1 root root 3457 Sep 21 05:40 /workspace/src/README.md
2621444 4 drwxr-xr-x 2 root root 4096 Sep 21 05:40 /workspace/src/.radicle
2621467 4 -rw-r--r-- 1 root root 767 Sep 21 05:40 /workspace/src/roadmap.yaml
2621661 32 -rw-r--r-- 1 root root 31712 Sep 21 05:40 /workspace/src/Cargo.lock
2621469 4 -rw-r--r-- 1 root root 26 Sep 21 05:40 /workspace/src/.gitignore
2621667 4 -rw-r--r-- 1 root root 224 Sep 21 05:40 /workspace/src/obnam.subplot
2621660 4 -rw-r--r-- 1 root root 283 Sep 21 05:40 /workspace/src/obnam.yaml
2621658 4 -rw-r--r-- 1 root root 458 Sep 21 05:40 /workspace/src/Makefile
2621471 4 -rw-r--r-- 1 root root 1010 Sep 21 05:40 /workspace/src/obnam.py
2621442 4 drwxr-xr-x 2 root root 4096 Sep 21 05:40 /workspace/artifacts
2636211 4 drwxr-xr-x 3 root root 4096 Sep 21 03:59 /workspace/cache
2636212 4 drwxr-xr-x 7 root root 4096 Sep 21 05:35 /workspace/cache/debug
2638399 4 -rw-r--r-- 1 root root 1038 Sep 21 05:40 /workspace/cache/.rustc_info.json
[2025-09-21T05:40:44Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-21T05:40:44Z DEBUG ambient_ci::plan] RUN: Action CargoClippy
[2025-09-21T05:40:44Z DEBUG ambient_ci::action] Plan::execute: plan=CargoClippy
[2025-09-21T05:40:44Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
SPAWN: argv=["cargo", "--version"]
cwd=/workspace/src (exists? true)
cargo 1.88.0 (873a06493 2025-05-10)
SPAWN: argv=["cargo", "clippy", "--version"]
cwd=/workspace/src (exists? true)
clippy 0.1.88 (6b00bc3880 2025-06-23)
SPAWN: argv=["rustc", "--version"]
cwd=/workspace/src (exists? true)
rustc 1.88.0 (6b00bc388 2025-06-23)
SPAWN: argv=["cargo", "clippy", "--offline", "--locked", "--workspace", "--all-targets", "--no-deps", "--", "--deny", "warnings"]
cwd=/workspace/src (exists? true)
Compiling libc v0.2.175
Checking cfg-if v1.0.3
Compiling proc-macro2 v1.0.101
Compiling unicode-ident v1.0.19
Compiling serde_core v1.0.226
Checking bitflags v2.9.4
Compiling rustix v1.1.2
Compiling serde v1.0.226
Checking linux-raw-sys v0.11.0
Compiling quote v1.0.40
Checking getrandom v0.2.16
Checking rand_core v0.6.4
Compiling autocfg v1.5.0
Compiling syn v2.0.106
Checking crypto-common v0.1.6
Compiling lock_api v0.4.13
Compiling semver v1.0.27
Compiling getrandom v0.3.3
Compiling thiserror v2.0.16
Compiling rustc_version v0.4.1
Compiling libsqlite3-sys v0.35.0
Compiling heapless v0.7.17
Checking anstyle-parse v0.2.7
Checking cipher v0.4.4
Checking anstyle v1.0.11
Checking anstyle-query v1.1.4
Checking colorchoice v1.0.4
Compiling serde_json v1.0.145
Compiling crc32fast v1.5.0
Checking hashbrown v0.16.0
Checking toml_parser v1.0.3
Checking universal-hash v0.5.1
Checking anstream v0.6.20
Checking hashbrown v0.15.5
Checking terminal_size v0.4.3
Checking indexmap v2.11.4
Checking spin v0.9.8
Checking serde_spanned v1.0.2
Checking toml_datetime v0.7.2
Checking dirs-sys-next v0.1.2
Checking once_cell v1.21.3
Checking clap_lex v0.7.5
Checking adler2 v2.0.1
Checking unsafe-libyaml-norway v0.2.15
Checking toml_writer v1.0.3
Checking memchr v2.7.5
Checking toml v0.9.7
Compiling serde_derive v1.0.226
Compiling thiserror-impl v2.0.16
Compiling clap_derive v4.5.47
Checking clap_builder v4.5.48
Checking cobs v0.3.0
Checking tempfile v3.22.0
Checking miniz_oxide v0.8.9
Checking directories-next v2.0.0
Checking polyval v0.6.2
Checking hashlink v0.10.0
Checking aes v0.8.4
Checking ctr v0.9.2
Checking aead v0.5.2
Checking smallvec v1.15.1
Checking flate2 v1.1.2
Checking rusqlite v0.37.0
Checking clap v4.5.48
Checking aes-gcm-siv v0.11.1
Checking uuid v1.18.1
Checking serde_norway v0.9.42
Checking postcard v1.1.3
Checking clingwrap v0.4.0
Checking obnam v0.1.0 (/workspace/src)
Finished `dev` profile [unoptimized + debuginfo] target(s) in 9.20s
[2025-09-21T05:40:54Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-21T05:40:54Z DEBUG ambient_ci::plan] RUN: Action CargoBuild
[2025-09-21T05:40:54Z DEBUG ambient_ci::action] Plan::execute: plan=CargoBuild
[2025-09-21T05:40:54Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
SPAWN: argv=["cargo", "--version"]
cwd=/workspace/src (exists? true)
cargo 1.88.0 (873a06493 2025-05-10)
SPAWN: argv=["cargo", "clippy", "--version"]
cwd=/workspace/src (exists? true)
clippy 0.1.88 (6b00bc3880 2025-06-23)
SPAWN: argv=["rustc", "--version"]
cwd=/workspace/src (exists? true)
rustc 1.88.0 (6b00bc388 2025-06-23)
SPAWN: argv=["cargo", "build", "--offline", "--locked", "--workspace", "--all-targets"]
cwd=/workspace/src (exists? true)
Compiling cfg-if v1.0.3
Compiling libc v0.2.175
Compiling serde_core v1.0.226
Compiling bitflags v2.9.4
Compiling linux-raw-sys v0.11.0
Compiling lock_api v0.4.13
Compiling anstyle-parse v0.2.7
Compiling rustix v1.1.2
Compiling thiserror v2.0.16
Compiling hashbrown v0.16.0
Compiling getrandom v0.2.16
Compiling rand_core v0.6.4
Compiling crypto-common v0.1.6
Compiling cipher v0.4.4
Compiling getrandom v0.3.3
Compiling colorchoice v1.0.4
Compiling anstyle-query v1.1.4
Compiling anstyle v1.0.11
Compiling universal-hash v0.5.1
Compiling indexmap v2.11.4
Compiling anstream v0.6.20
Compiling dirs-sys-next v0.1.2
Compiling toml_parser v1.0.3
Compiling serde v1.0.226
Compiling serde_spanned v1.0.2
Compiling toml_datetime v0.7.2
Compiling terminal_size v0.4.3
Compiling hashbrown v0.15.5
Compiling spin v0.9.8
Compiling toml_writer v1.0.3
Compiling once_cell v1.21.3
Compiling clap_lex v0.7.5
Compiling memchr v2.7.5
Compiling adler2 v2.0.1
Compiling unsafe-libyaml-norway v0.2.15
Compiling tempfile v3.22.0
Compiling hashlink v0.10.0
Compiling serde_json v1.0.145
Compiling miniz_oxide v0.8.9
Compiling serde_norway v0.9.42
Compiling clap_builder v4.5.48
Compiling toml v0.9.7
Compiling heapless v0.7.17
Compiling polyval v0.6.2
Compiling libsqlite3-sys v0.35.0
Compiling directories-next v2.0.0
Compiling crc32fast v1.5.0
Compiling aes v0.8.4
Compiling ctr v0.9.2
Compiling aead v0.5.2
Compiling cobs v0.3.0
Compiling smallvec v1.15.1
Compiling postcard v1.1.3
Compiling rusqlite v0.37.0
Compiling aes-gcm-siv v0.11.1
Compiling clap v4.5.48
Compiling flate2 v1.1.2
Compiling clingwrap v0.4.0
Compiling uuid v1.18.1
Compiling obnam v0.1.0 (/workspace/src)
Finished `dev` profile [unoptimized + debuginfo] target(s) in 8.44s
[2025-09-21T05:41:02Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-21T05:41:02Z DEBUG ambient_ci::plan] RUN: Action CargoTest
[2025-09-21T05:41:02Z DEBUG ambient_ci::action] Plan::execute: plan=CargoTest
[2025-09-21T05:41:02Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
SPAWN: argv=["cargo", "--version"]
cwd=/workspace/src (exists? true)
cargo 1.88.0 (873a06493 2025-05-10)
SPAWN: argv=["cargo", "clippy", "--version"]
cwd=/workspace/src (exists? true)
clippy 0.1.88 (6b00bc3880 2025-06-23)
SPAWN: argv=["rustc", "--version"]
cwd=/workspace/src (exists? true)
rustc 1.88.0 (6b00bc388 2025-06-23)
SPAWN: argv=["cargo", "test", "--offline", "--locked", "--workspace"]
cwd=/workspace/src (exists? true)
Finished `test` profile [unoptimized + debuginfo] target(s) in 0.05s
Running unittests src/lib.rs (/workspace/cache/debug/deps/obnam-4f71915e86cfaf65)
running 33 tests
test chunk::test::id_is_comparable_with_itself ... ok
test chunk::test::id ... ok
test chunk::test::label_round_trip ... ok
test chunk::test::metadata ... ok
test chunk::test::ciphertext_does_not_contain_plaintext ... ok
test chunk::test::metadata_round_trip ... ok
test chunk::test::two_new_chunk_ids_differ ... ok
test cipher::test::aead_round_trip ... ok
test cipher::test::key ... ok
test cipher::test::key_from_string ... ok
test client::test::generates_key ... ok
test client::test::gets_correct_key ... ok
test client::test::has_name ... ok
test client::test::has_no_keys_initially ... ok
test client::test::serialiazion_round_trip ... ok
test client::test::sets_old_versions ... ok
test plaintext::test::compressed ... ok
test plaintext::test::compression_round_trip ... ok
test plaintext::test::uncompressed ... ok
test chunk::test::chunk_round_trip ... ok
test store::test::cant_init_nonexistent_dir ... ok
test store::test::empty_dir_is_not_init ... ok
test credential::test::roundtrip_sop_credential ... ok
test credential::test::roundtrip_sop_method ... ok
test store::test::adds_chunk ... ok
test store::test::finds_no_chunk_in_empty_store ... ok
test store::test::has_no_chunks_initially ... ok
test store::test::nonexistent_dir_is_not_init ... ok
test store::test::finds_no_chunk_when_none_match_label ... ok
test store::test::root_dir_is_not_init ... ok
test store::test::inits_empty_dir ... ok
test store::test::finds_chunk_when_labels_match ... ok
test store::test::removes_chunk ... ok
test result: ok. 33 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.20s
Running unittests src/bin/obnam.rs (/workspace/cache/debug/deps/obnam-6274f7325498b9bb)
running 0 tests
test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
Doc-tests obnam
running 1 test
test src/runner.rs - runner (line 8) ... ok
test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[2025-09-21T05:41:04Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-21T05:41:04Z DEBUG ambient_ci::plan] RUN: Action Shell {
shell: "export PATH=/root/.cargo/bin:/bin:/sbin\nexport CARGO_TARGET_DIR=/workspace/cache\nmake subplot\n",
}
[2025-09-21T05:41:04Z DEBUG ambient_ci::action] Plan::execute: plan=Shell {
shell: "export PATH=/root/.cargo/bin:/bin:/sbin\nexport CARGO_TARGET_DIR=/workspace/cache\nmake subplot\n",
}
[2025-09-21T05:41:04Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
SPAWN: argv=["/bin/bash", "-c", "set -xeuo pipefail\nexport PATH=/root/.cargo/bin:/bin:/sbin\nexport CARGO_TARGET_DIR=/workspace/cache\nmake subplot\n\n"]
cwd=/workspace/src (exists? true)
+ export PATH=/root/.cargo/bin:/bin:/sbin
+ PATH=/root/.cargo/bin:/bin:/sbin
+ export CARGO_TARGET_DIR=/workspace/cache
+ CARGO_TARGET_DIR=/workspace/cache
+ make subplot
subplot docgen obnam.subplot --output obnam.html
INFO Starting Subplot
INFO Subplot finished successfully
subplot codegen obnam.subplot --output test.py
INFO Starting Subplot
INFO Subplot finished successfully
rm -f test.log
python3 test.py --log test.log
srcdir /workspace/src
datadir /tmp/tmpre82_ojx
scenario: Extracting a certificate from a key
step: given an installed obnam
step: given file alice.key
step: when I run obnam sop extract-cert rsop alice.key
step: then stdout isn't exactly ""
scenario: Avoid client chunks with the same name
step: given an installed obnam
step: given file .config/obnam/config.yaml from config.yaml
step: when I create directory mychunks
step: when I run obnam store init
step: when I run obnam --client-key my.secret client init my.host
step: then command is successful
step: when I try to run obnam --client-key my.secret client init my.host
step: then command fails
scenario: Chunk encrypt/decrypt round trip via file
step: given an installed obnam
step: given file greeting.txt
step: when I run obnam chunk encrypt --key secret --label sticky.tape greeting.txt --output chunk.file
step: when I run obnam chunk decrypt --key secret chunk.file
step: then stdout is exactly "Hello, world.\n"
scenario: Encryption round trip
step: given an installed obnam
step: given file alice.key
step: given file hello.txt
step: when I run obnam sop encrypt rsop alice.key hello.txt -o encrypted
step: when I run ls -l encrypted
step: when I run cat encrypted
step: when I run obnam sop decrypt rsop alice.key encrypted
step: then stdout is exactly "hello, world\n"
scenario: List clients
step: given an installed obnam
step: given file .config/obnam/config.yaml from config.yaml
step: when I create directory mychunks
step: when I run obnam store init
step: when I run obnam --client-key my.secret client init my.host
step: when I run obnam --client-key my.secret client list
step: then stdout is exactly "my.host\n"
scenario: Initialize a store
step: given an installed obnam
step: given file .config/obnam/config.yaml from config.yaml
step: then directory mychunks does not exist
step: when I try to run obnam store is
step: then command fails
step: when I create directory mychunks
step: when I try to run obnam store is
step: then command fails
step: when I run obnam store init
step: when I run obnam store is
step: then exit code is 0
scenario: Round trip chunk encryption using key from client chunk
step: given an installed obnam
step: given file .config/obnam/config.yaml from config.yaml
step: given file greeting.txt
step: when I create directory mychunks
step: when I run obnam store init
step: when I run obnam --client-key my.secret client init my.host
step: when I run obnam --client-key my.secret client generate my.host my.key
step: when I run obnam --client-key my.secret chunk encrypt --client-name my.host --key-name my.key --label sticky.tape greeting.txt --output chunk.file
step: when I run obnam --client-key my.secret chunk decrypt --client-name my.host --key-name my.key chunk.file
step: then stdout is exactly "Hello, world.\n"
scenario: Generate new key
step: given an installed obnam
step: given file .config/obnam/config.yaml from config.yaml
step: when I create directory mychunks
step: when I run obnam store init
step: when I run obnam --client-key my.secret client init my.host
step: when I run obnam --client-key my.secret client generate my.host my.key
step: when I run obnam --client-key my.secret client show my.host
step: then stdout contains "my.key"
scenario: Initialize a client chunk
step: given an installed obnam
step: given file .config/obnam/config.yaml from config-with-credential.yaml
step: when I create directory mychunks
step: when I run obnam store init
step: when I run obnam client init my.host --credential softy
step: then command is successful
step: when I run obnam credential list --all
step: then stdout isn't exactly ""
scenario: Find chunks using labels
step: given an installed obnam
step: given file .config/obnam/config.yaml from config.yaml
step: given file chunk.blob
step: given a directory mychunks
step: when I run obnam store init
step: when I run obnam store add xyzzy data-chunk chunk.blob
step: when I run obnam store add plugh data-chunk chunk.blob
step: when I run obnam store add advent client-chunk chunk.blob
step: when I run obnam store find missing
step: then stdout is exactly ""
step: when I run obnam store find data-chunk
step: then stdout contains "xyzzy"
step: then stdout contains "plugh"
step: then stdout doesn't contain "advent"
step: when I run obnam store find client-chunk
step: then stdout doesn't contain "xyzzy"
step: then stdout doesn't contain "plugh"
step: then stdout contains "advent"
scenario: Chunk encrypt/decrypt round trip via repository
step: given an installed obnam
step: given file .config/obnam/config.yaml from config.yaml
step: given file greeting.txt
step: when I create directory mychunks
step: when I try to run obnam store init
step: when I run obnam chunk encrypt --key secret --label sticky.tape greeting.txt --id=chunk0
step: when I run obnam store list
step: when I run obnam chunk decrypt --key secret --id chunk0
step: then stdout is exactly "Hello, world.\n"
scenario: Inspect an encrypted chunk using key from client chunk
step: given an installed obnam
step: given file .config/obnam/config.yaml from config.yaml
step: given file greeting.txt
step: when I create directory mychunks
step: when I run obnam store init
step: when I run obnam --client-key my.secret client init my.host
step: when I run obnam --client-key my.secret client generate my.host my.key
step: when I run obnam --client-key my.secret chunk encrypt --client-name my.host --key-name my.key --label sticky.tape greeting.txt --output chunk.file
step: when I run obnam --client-key my.secret chunk inspect --filename chunk.file --client-name my.host --key-name my.key
step: then stdout is valid JSON
step: then stdout contains ""id":"
step: then stdout contains ""label":"
step: then stdout contains ""data": ""
scenario: Add a chunk to the store.
step: given an installed obnam
step: given file .config/obnam/config.yaml from config.yaml
step: given file chunk.blob
step: given a directory mychunks
step: when I run obnam store init
step: when I run obnam store add xyzzy data-chunk chunk.blob
step: when I run obnam store list
step: then stdout is exactly "xyzzy\n"
scenario: Inspect an encoded chunk in repository
step: given an installed obnam
step: given file .config/obnam/config.yaml from config.yaml
step: given file greeting.txt
step: when I create directory mychunks
step: when I try to run obnam store init
step: when I run obnam chunk encrypt --label sticky.tape --key secret greeting.txt --id=chunk0
step: when I run obnam chunk inspect --id chunk0
step: then stdout is valid JSON
step: then stdout contains ""id":"
step: then stdout contains ""label":"
step: then stdout contains ""data": null"
step: when I run obnam chunk inspect --key secret --id chunk0
step: then stdout is valid JSON
step: then stdout contains ""id":"
step: then stdout contains ""label":"
step: then stdout contains ""data": ""
scenario: Remove a chunk from store
step: given an installed obnam
step: given file .config/obnam/config.yaml from config.yaml
step: given file chunk.blob
step: given a directory mychunks
step: when I run obnam store init
step: when I run obnam store add xyzzy data-chunk chunk.blob
step: when I run obnam store remove xyzzy
step: when I run obnam store list
step: then stdout doesn't contain "xyzzy"
scenario: Get path to chunk in store
step: given an installed obnam
step: given file .config/obnam/config.yaml from config.yaml
step: given file chunk.blob
step: given a directory mychunks
step: when I run obnam store init
step: when I run obnam store add xyzzy data-chunk chunk.blob
step: when I run obnam store path xyzzy -o chunk.filename
step: then a file exists whose name is in chunk.filename
scenario: Chunk encrypt/decrypt with compression round trip via file
step: given an installed obnam
step: given file greeting.txt
step: when I run obnam chunk encrypt --compress --key secret --label sticky.tape greeting.txt --output chunk.file
step: when I run obnam chunk decrypt --key secret chunk.file
step: then stdout is exactly "Hello, world.\n"
scenario: Chunk encrypt/decrypt with compression round trip via repository
step: given an installed obnam
step: given file .config/obnam/config.yaml from config.yaml
step: given file greeting.txt
step: when I create directory mychunks
step: when I try to run obnam store init
step: when I run obnam chunk encrypt --compress --key secret --label sticky.tape greeting.txt --id=chunk0
step: when I run obnam store list
step: when I run obnam chunk decrypt --key secret --id chunk0
step: then stdout is exactly "Hello, world.\n"
scenario: Create an OpenPGP software key credential
step: given an installed obnam
step: given file .config/obnam/config.yaml from config.yaml
step: given file sop-generate
step: when I run bash sop-generate alice.tsk
step: when I create directory mychunks
step: when I run obnam store init
step: when I run obnam credential list
step: then stdout is exactly ""
step: when I run obnam --client-key my.secret credential openpgp-soft alice.tsk
step: when I run obnam credential list --all
step: then stdout isn't exactly ""
scenario: Conveniently encrypt and decrypt chunk in a store
step: given an installed obnam
step: given file .config/obnam/config.yaml from comfy.yaml
step: given file message.txt
step: when I create directory chunk.store
step: when I run obnam store init --credential softy --client testy
step: when I run obnam chunk encrypt --label data --client-name testy --key-name default --id test.chunk message.txt
step: when I run obnam chunk decrypt --client-name testy --key-name default --id test.chunk --output out.dat
step: then files message.txt and out.dat match
scenario: Show client
step: given an installed obnam
step: given file .config/obnam/config.yaml from config.yaml
step: when I create directory mychunks
step: when I run obnam store init
step: when I run obnam --client-key my.secret client init my.host
step: when I run obnam --client-key my.secret client show my.host
step: then stdout is valid JSON
scenario: Inspect an encoded chunk in file
step: given an installed obnam
step: given file greeting.txt
step: when I run obnam chunk encrypt --label sticky.tape --key secret greeting.txt --output chunk.file
step: when I run obnam chunk inspect --filename chunk.file
step: then stdout is valid JSON
step: then stdout contains ""id":"
step: then stdout contains ""label":"
step: then stdout contains ""data": null"
step: when I run obnam chunk inspect --filename chunk.file --key secret
step: then stdout is valid JSON
step: then stdout contains ""id":"
step: then stdout contains ""label":"
step: then stdout contains ""data": ""
scenario: Conveniently initialize a store with OpenPGP software key credential
step: given an installed obnam
step: given file .config/obnam/config.yaml from comfy.yaml
step: when I create directory chunk.store
step: when I run obnam store init --credential softy
step: when I run obnam store list
step: then stdout is exactly ""
OK, all scenarios finished successfully
[2025-09-21T05:41:05Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-21T05:41:05Z DEBUG ambient_ci::plan] RUN: Action TarCreate {
archive: "/dev/vde",
directory: "/workspace/cache",
}
[2025-09-21T05:41:05Z DEBUG ambient_ci::action] Plan::execute: plan=TarCreate {
archive: "/dev/vde",
directory: "/workspace/cache",
}
[2025-09-21T05:41:05Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
[2025-09-21T05:41:05Z TRACE ambient_ci::vdrive] creating virtual drive (tar archive): VirtualDriveBuilder {
filename: Some(
"/dev/vde",
),
root: Some(
"/workspace/cache",
),
size: None,
}
[2025-09-21T05:41:05Z TRACE ambient_ci::vdrive] tar archive to be created: /dev/vde; exists? true
[2025-09-21T05:41:05Z TRACE ambient_ci::vdrive] create archive file /dev/vde
[2025-09-21T05:41:05Z TRACE ambient_ci::vdrive] directory /workspace/cache exists? true
[2025-09-21T05:41:05Z TRACE ambient_ci::vdrive] add contents of /workspace/cache as .
[2025-09-21T05:41:05Z TRACE ambient_ci::vdrive] calling tar_create
[2025-09-21T05:41:06Z TRACE ambient_ci::vdrive] created virtual drive /dev/vde
[2025-09-21T05:41:06Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-21T05:41:06Z DEBUG ambient_ci::plan] RUN: Action TarCreate {
archive: "/dev/vdd",
directory: "/workspace/artifacts",
}
[2025-09-21T05:41:06Z DEBUG ambient_ci::action] Plan::execute: plan=TarCreate {
archive: "/dev/vdd",
directory: "/workspace/artifacts",
}
[2025-09-21T05:41:06Z DEBUG ambient_ci::action] Plan::execute: context=Context {
envs: {
"PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
"CARGO_HOME": "/workspace/deps",
"CARGO_TARGET_DIR": "/workspace/cache",
},
source_dir: "/workspace/src",
}
[2025-09-21T05:41:06Z TRACE ambient_ci::vdrive] creating virtual drive (tar archive): VirtualDriveBuilder {
filename: Some(
"/dev/vdd",
),
root: Some(
"/workspace/artifacts",
),
size: None,
}
[2025-09-21T05:41:06Z TRACE ambient_ci::vdrive] tar archive to be created: /dev/vdd; exists? true
[2025-09-21T05:41:06Z TRACE ambient_ci::vdrive] create archive file /dev/vdd
[2025-09-21T05:41:06Z TRACE ambient_ci::vdrive] directory /workspace/artifacts exists? true
[2025-09-21T05:41:06Z TRACE ambient_ci::vdrive] add contents of /workspace/artifacts as .
[2025-09-21T05:41:06Z TRACE ambient_ci::vdrive] calling tar_create
[2025-09-21T05:41:06Z TRACE ambient_ci::vdrive] created virtual drive /dev/vdd
[2025-09-21T05:41:06Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-21T05:41:06Z DEBUG ambient_ci::plan] All actions were performed successfully
ambient-execute-plan ends
EXIT CODE: 0
====================
[2025-09-21T05:41:11Z DEBUG ambient_ci::run] remove old cache
[2025-09-21T05:41:11Z DEBUG ambient_ci::run] extract cache
[2025-09-21T05:41:11Z DEBUG ambient_ci::run] Executing post-plan steps
[2025-09-21T05:41:11Z DEBUG ambient_ci::plan] All actions were performed successfully
[2025-09-21T05:41:11Z DEBUG ambient_ci::project] write project state to /srv/ambient-state/rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x/meta.yaml
[2025-09-21T05:41:11Z INFO ambient] ambient ends successfully
<empty log>