Radicle repository id rad:z3248z9KmBQ6Tf4mwXih1zKPtuSw5
[2025-09-17T13:32:57Z 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 2.9M 1 disk
vdc 254:32 0 580K 1 disk
vdd 254:48 0 9.3G 0 disk
vde 254:64 0 46.6G 0 disk
vdf 254:80 0 318.9M 1 disk
INFO: Extracting tar archive from /dev/vdb
drwxr-xr-x _rad/_rad 0 2025-09-17 13:32 ./
-rw-r--r-- _rad/_rad 861 2025-09-17 13:32 ./plan.yaml
-rwxr-xr-x _rad/_rad 3007128 2025-09-17 13:32 ./run-ci
INFO: Extracted files:
4587530 4 drwxr-xr-x 2 1001 1001 4096 Sep 17 13:32 .
4587531 4 -rw-r--r-- 1 1001 1001 861 Sep 17 13:32 ./plan.yaml
4587532 2940 -rwxr-xr-x 1 1001 1001 3007128 Sep 17 13:32 ./run-ci
INFO: Running run-ci from /dev/vdb
================================ BEGIN ================================
[2025-09-17T13:32:40Z TRACE ambient_execute_plan] ambient-execute-plan starts
[2025-09-17T13:32:40Z DEBUG ambient_execute_plan] ambient-execute-plan starts
[2025-09-17T13:32:40Z INFO ambient_execute_plan] ambient-execute-plan starts
[2025-09-17T13:32:40Z WARN ambient_execute_plan] ambient-execute-plan starts
[2025-09-17T13:32:40Z ERROR ambient_execute_plan] ambient-execute-plan starts
RunnablePlan::from_file: filename=plan.yaml
steps:
- action: mkdir
pathname: /workspace
- action: mkdir
pathname: /workspace/artifacts
- action: tar_extract
archive: /dev/vdc
directory: /workspace/src
- action: tar_extract
archive: /dev/vdf
directory: /workspace/deps
- action: tar_extract
archive: /dev/vde
directory: /workspace/cache
- action: spawn
argv:
- find
- /workspace
- '-maxdepth'
- '2'
- '-ls'
- action: cargo_clippy
- action: cargo_build
- action: cargo_test
- action: tar_create
archive: /dev/vde
directory: /workspace/cache
- action: tar_create
archive: /dev/vdd
directory: /workspace/artifacts
executor_drive: /dev/vdb
source_drive: /dev/vdc
artifact_drive: /dev/vdd
cache_drive: /dev/vde
deps_drive: /dev/vdf
workspace_dir: /workspace
source_dir: /workspace/src
deps_dir: /workspace/deps
cache_dir: /workspace/cache
artifacts_dir: /workspace/artifacts
RUN: Action Mkdir {
pathname: "/workspace",
}
[2025-09-17T13:32:40Z DEBUG ambient_ci::action] Plan::execute: Mkdir {
pathname: "/workspace",
}
RUN: Action finished OK
RUN: Action Mkdir {
pathname: "/workspace/artifacts",
}
[2025-09-17T13:32:40Z DEBUG ambient_ci::action] Plan::execute: Mkdir {
pathname: "/workspace/artifacts",
}
RUN: Action finished OK
RUN: Action TarExtract {
archive: "/dev/vdc",
directory: "/workspace/src",
}
[2025-09-17T13:32:40Z DEBUG ambient_ci::action] Plan::execute: TarExtract {
archive: "/dev/vdc",
directory: "/workspace/src",
}
[2025-09-17T13:32:40Z TRACE ambient_ci::vdrive] extracting /dev/vdc to /workspace/src
[2025-09-17T13:32:40Z TRACE ambient_ci::vdrive] extraction OK
RUN: Action finished OK
RUN: Action TarExtract {
archive: "/dev/vdf",
directory: "/workspace/deps",
}
[2025-09-17T13:32:40Z DEBUG ambient_ci::action] Plan::execute: TarExtract {
archive: "/dev/vdf",
directory: "/workspace/deps",
}
[2025-09-17T13:32:40Z TRACE ambient_ci::vdrive] extracting /dev/vdf to /workspace/deps
[2025-09-17T13:32:41Z TRACE ambient_ci::vdrive] extraction OK
RUN: Action finished OK
RUN: Action TarExtract {
archive: "/dev/vde",
directory: "/workspace/cache",
}
[2025-09-17T13:32:41Z DEBUG ambient_ci::action] Plan::execute: TarExtract {
archive: "/dev/vde",
directory: "/workspace/cache",
}
[2025-09-17T13:32:41Z TRACE ambient_ci::vdrive] extracting /dev/vde to /workspace/cache
[2025-09-17T13:32:41Z TRACE ambient_ci::vdrive] extraction OK
RUN: Action finished OK
RUN: Action Spawn {
argv: [
"find",
"/workspace",
"-maxdepth",
"2",
"-ls",
],
}
[2025-09-17T13:32:41Z DEBUG ambient_ci::action] Plan::execute: Spawn {
argv: [
"find",
"/workspace",
"-maxdepth",
"2",
"-ls",
],
}
SPAWN: argv=["find", "/workspace", "-maxdepth", "2", "-ls"]
cwd=/workspace/src (exists? true)
extra_env=[]
2621441 4 drwxr-xr-x 6 root root 4096 Sep 17 13:32 /workspace
2621611 4 drwxr-xr-x 3 root root 4096 Sep 17 13:32 /workspace/deps
2621612 0 -rw-r--r-- 1 root root 0 Sep 17 13:32 /workspace/deps/.package-cache-mutate
2621615 4 drwxr-xr-x 5 root root 4096 Sep 17 13:32 /workspace/deps/registry
2621613 56 -rw-r--r-- 1 root root 57344 Sep 17 13:32 /workspace/deps/.global-cache
2621614 0 -rw-r--r-- 1 root root 0 Sep 17 13:32 /workspace/deps/.package-cache
2621443 4 drwxr-xr-x 7 root root 4096 Sep 17 13:32 /workspace/src
2621456 4 -rw-r--r-- 1 root root 470 Sep 17 13:32 /workspace/src/Cargo.toml
2621453 4 -rw-r--r-- 1 root root 1172 Sep 17 13:32 /workspace/src/NEWS.md
2621461 4 drwxr-xr-x 8 root root 4096 Sep 17 13:32 /workspace/src/.git
2621446 4 drwxr-xr-x 2 root root 4096 Sep 17 13:32 /workspace/src/src
2621454 4 -rw-r--r-- 1 root root 1484 Sep 17 13:32 /workspace/src/README.md
2621444 4 drwxr-xr-x 2 root root 4096 Sep 17 13:32 /workspace/src/.radicle
2621610 16 -rw-r--r-- 1 root root 15728 Sep 17 13:32 /workspace/src/Cargo.lock
2621455 4 -rw-r--r-- 1 root root 8 Sep 17 13:32 /workspace/src/.gitignore
2621457 4 drwxr-xr-x 2 root root 4096 Sep 17 13:32 /workspace/src/examples
2621609 4 -rw-r--r-- 1 root root 198 Sep 17 13:32 /workspace/src/Makefile
2621451 4 drwxr-xr-x 2 root root 4096 Sep 17 13:32 /workspace/src/.cargo
2621442 4 drwxr-xr-x 2 root root 4096 Sep 17 13:32 /workspace/artifacts
2629172 4 drwxr-xr-x 2 root root 4096 Sep 17 13:32 /workspace/cache
RUN: Action finished OK
RUN: Action CargoClippy
[2025-09-17T13:32:41Z DEBUG ambient_ci::action] Plan::execute: CargoClippy
SPAWN: argv=["cargo", "clippy", "--offline", "--locked", "--workspace", "--all-targets", "--no-deps", "--", "--deny", "warnings"]
cwd=/workspace/src (exists? true)
extra_env=[("CARGO_TARGET_DIR", "/workspace/cache"), ("CARGO_HOME", "/workspace/deps"), ("PATH", "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin")]
Compiling proc-macro2 v1.0.95
Compiling unicode-ident v1.0.18
Compiling serde v1.0.219
Compiling libc v0.2.174
Checking cfg-if v1.0.1
Compiling getrandom v0.3.3
Compiling rustix v1.0.8
Compiling thiserror v2.0.12
Checking winnow v0.7.12
Checking ryu v1.0.20
Checking hashbrown v0.15.4
Compiling quote v1.0.40
Checking itoa v1.0.15
Checking bitflags v2.9.1
Compiling syn v2.0.104
Checking equivalent v1.0.2
Compiling serde_json v1.0.141
Checking linux-raw-sys v0.9.4
Checking indexmap v2.10.0
Checking toml_parser v1.0.1
Checking dirs-sys-next v0.1.2
Checking toml_writer v1.0.2
Checking memchr v2.7.5
Checking unsafe-libyaml-norway v0.2.15
Checking once_cell v1.21.3
Checking fastrand v2.3.0
Checking directories-next v2.0.0
Checking tempfile v3.20.0
Compiling serde_derive v1.0.219
Compiling thiserror-impl v2.0.12
Checking toml_datetime v0.7.0
Checking serde_spanned v1.0.0
Checking serde_norway v0.9.42
Checking toml v0.9.2
Checking clingwrap v0.4.0 (/workspace/src)
Finished `dev` profile [unoptimized + debuginfo] target(s) in 7.40s
RUN: Action finished OK
RUN: Action CargoBuild
[2025-09-17T13:32:49Z DEBUG ambient_ci::action] Plan::execute: CargoBuild
SPAWN: argv=["cargo", "build", "--offline", "--locked", "--workspace", "--all-targets"]
cwd=/workspace/src (exists? true)
extra_env=[("CARGO_TARGET_DIR", "/workspace/cache"), ("CARGO_HOME", "/workspace/deps"), ("PATH", "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin")]
Compiling serde v1.0.219
Compiling cfg-if v1.0.1
Compiling libc v0.2.174
Compiling linux-raw-sys v0.9.4
Compiling hashbrown v0.15.4
Compiling bitflags v2.9.1
Compiling ryu v1.0.20
Compiling itoa v1.0.15
Compiling equivalent v1.0.2
Compiling winnow v0.7.12
Compiling indexmap v2.10.0
Compiling dirs-sys-next v0.1.2
Compiling getrandom v0.3.3
Compiling rustix v1.0.8
Compiling toml_writer v1.0.2
Compiling once_cell v1.21.3
Compiling unsafe-libyaml-norway v0.2.15
Compiling toml_parser v1.0.1
Compiling memchr v2.7.5
Compiling serde_spanned v1.0.0
Compiling toml_datetime v0.7.0
Compiling fastrand v2.3.0
Compiling toml v0.9.2
Compiling tempfile v3.20.0
Compiling serde_json v1.0.141
Compiling serde_norway v0.9.42
Compiling thiserror v2.0.12
Compiling directories-next v2.0.0
Compiling clingwrap v0.4.0 (/workspace/src)
Finished `dev` profile [unoptimized + debuginfo] target(s) in 4.64s
RUN: Action finished OK
RUN: Action CargoTest
[2025-09-17T13:32:53Z DEBUG ambient_ci::action] Plan::execute: CargoTest
SPAWN: argv=["cargo", "test", "--offline", "--locked", "--workspace"]
cwd=/workspace/src (exists? true)
extra_env=[("CARGO_TARGET_DIR", "/workspace/cache"), ("CARGO_HOME", "/workspace/deps"), ("PATH", "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin")]
Finished `test` profile [unoptimized + debuginfo] target(s) in 0.02s
Running unittests src/lib.rs (/workspace/cache/debug/deps/clingwrap-0974b031ea215f84)
running 18 tests
test config::test::filenames ... ok
test config::test::builtin_defaults ... ok
test config::test::load_configs ... ok
test config::test::merge_simple ... ok
test config::test::parse_json ... ok
test config::test::parse_toml ... ok
test config::test::parse_yaml ... ok
test tildepathbuf::test::as_ref ... ok
test tildepathbuf::test::deref ... ok
test tildepathbuf::test::deser ... ok
test tildepathbuf::test::eq ... ok
test tildepathbuf::test::just_tilde ... ok
test tildepathbuf::test::no_tilde ... ok
test tildepathbuf::test::tilde_slash ... ok
test tildepathbuf::test::tilde_slash_with_home_from_var ... ok
test tildepathbuf::test::tilde_username ... ok
test tildepathbuf::test::to_path_buf ... ok
test config::test::overrides ... ok
test result: ok. 18 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
Doc-tests clingwrap
running 3 tests
test src/config.rs - config (line 75) ... ok
test src/tildepathbuf.rs - tildepathbuf (line 9) ... ok
test src/runner.rs - runner (line 8) ... ok
test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
RUN: Action finished OK
RUN: Action TarCreate {
archive: "/dev/vde",
directory: "/workspace/cache",
}
[2025-09-17T13:32:54Z DEBUG ambient_ci::action] Plan::execute: TarCreate {
archive: "/dev/vde",
directory: "/workspace/cache",
}
[2025-09-17T13:32:54Z TRACE ambient_ci::vdrive] creating virtual drive (tar archive): VirtualDriveBuilder {
filename: Some(
"/dev/vde",
),
root: Some(
"/workspace/cache",
),
size: None,
}
[2025-09-17T13:32:54Z TRACE ambient_ci::vdrive] tar archive to be created: /dev/vde; exists? true
[2025-09-17T13:32:54Z TRACE ambient_ci::vdrive] create archive file /dev/vde
[2025-09-17T13:32:54Z TRACE ambient_ci::vdrive] directory /workspace/cache exists? true
[2025-09-17T13:32:54Z TRACE ambient_ci::vdrive] add contents of /workspace/cache as .
[2025-09-17T13:32:54Z TRACE ambient_ci::vdrive] created virtual drive /dev/vde
RUN: Action finished OK
RUN: Action TarCreate {
archive: "/dev/vdd",
directory: "/workspace/artifacts",
}
[2025-09-17T13:32:54Z DEBUG ambient_ci::action] Plan::execute: TarCreate {
archive: "/dev/vdd",
directory: "/workspace/artifacts",
}
[2025-09-17T13:32:54Z TRACE ambient_ci::vdrive] creating virtual drive (tar archive): VirtualDriveBuilder {
filename: Some(
"/dev/vdd",
),
root: Some(
"/workspace/artifacts",
),
size: None,
}
[2025-09-17T13:32:54Z TRACE ambient_ci::vdrive] tar archive to be created: /dev/vdd; exists? true
[2025-09-17T13:32:54Z TRACE ambient_ci::vdrive] create archive file /dev/vdd
[2025-09-17T13:32:54Z TRACE ambient_ci::vdrive] directory /workspace/artifacts exists? true
[2025-09-17T13:32:54Z TRACE ambient_ci::vdrive] add contents of /workspace/artifacts as .
[2025-09-17T13:32:54Z TRACE ambient_ci::vdrive] created virtual drive /dev/vdd
RUN: Action finished OK
ambient-execute-plan ends
EXIT CODE: 0
[2025-09-17T13:32:57Z INFO ambient] ambient ends successfully
{
"request": "trigger",
"version": 1,
"event_type": "patch",
"repository": {
"id": "rad:z3248z9KmBQ6Tf4mwXih1zKPtuSw5",
"name": "clingwrap",
"description": "Utilities for making command line apps in Rust",
"private": false,
"default_branch": "main",
"delegates": [
"did:key:z6MkgEMYod7Hxfy9qCvDv5hYHkZ4ciWmLFgfvm3Wn1b2w2FV"
]
},
"action": "Created",
"patch": {
"id": "943e52e6671c770fe7ce79cc8a2abbdfa5cf4bd1",
"author": {
"id": "did:key:z6MkgEMYod7Hxfy9qCvDv5hYHkZ4ciWmLFgfvm3Wn1b2w2FV",
"alias": "liw"
},
"title": "fix: switch to serde_norway as a YAML implementation",
"state": {
"status": "open",
"conflicts": []
},
"before": "8af9309adef1626ae2b6f82195c0d6518b332732",
"after": "61725e88bdc22d953cf6155485c1420eb458e7ab",
"commits": [
"61725e88bdc22d953cf6155485c1420eb458e7ab"
],
"target": "8af9309adef1626ae2b6f82195c0d6518b332732",
"labels": [],
"assignees": [],
"revisions": [
{
"id": "943e52e6671c770fe7ce79cc8a2abbdfa5cf4bd1",
"author": {
"id": "did:key:z6MkgEMYod7Hxfy9qCvDv5hYHkZ4ciWmLFgfvm3Wn1b2w2FV",
"alias": "liw"
},
"description": "",
"base": "8af9309adef1626ae2b6f82195c0d6518b332732",
"oid": "61725e88bdc22d953cf6155485c1420eb458e7ab",
"timestamp": 1758115948
}
]
}
}[2025-09-17T13:32:32Z INFO ambient] ambient starts
[2025-09-17T13:32:32Z DEBUG ambient] load default configuration file /home/_rad/.config/ambient/config.yaml if it exists
[2025-09-17T13:32:32Z 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-17T13:32:32Z 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-17T13:32:32Z DEBUG ambient_ci::project] load project state from /srv/ambient-state/rad:z3248z9KmBQ6Tf4mwXih1zKPtuSw5/meta.yaml
[2025-09-17T13:32:32Z DEBUG ambient_ci::run] no latest commit stored
[2025-09-17T13:32:32Z DEBUG ambient_ci::run] is a git repository
[2025-09-17T13:32:32Z DEBUG ambient_ci::run] git repository is clean
[2025-09-17T13:32:32Z DEBUG ambient_ci::run] current (HEAD) commit: 61725e88bdc22d953cf6155485c1420eb458e7ab
[2025-09-17T13:32:32Z DEBUG ambient_ci::run] no dry run requested
[2025-09-17T13:32:32Z DEBUG ambient_ci::run] forced run requested
[2025-09-17T13:32:32Z DEBUG ambient_ci::run] run? true
[2025-09-17T13:32:32Z INFO ambient_ci::run] project rad:z3248z9KmBQ6Tf4mwXih1zKPtuSw5: running CI
[2025-09-17T13:32:32Z DEBUG ambient_ci::run] Executing pre-plan steps
[2025-09-17T13:32:32Z DEBUG ambient_ci::action] Plan::execute: CargoFetch {
sourcedir: "/tmp/.tmpyuR0Zz/src",
dependenciesdir: "/srv/ambient-state/rad:z3248z9KmBQ6Tf4mwXih1zKPtuSw5/dependencies",
}
SPAWN: argv=["env", "CARGO_HOME=/srv/ambient-state/rad:z3248z9KmBQ6Tf4mwXih1zKPtuSw5/dependencies", "cargo", "fetch", "--locked"]
cwd=/tmp/.tmpyuR0Zz/src (exists? true)
extra_env=[]
Updating crates.io index
Downloading crates ...
Downloaded toml_datetime v0.7.0
Downloaded windows-targets v0.52.6
Downloaded toml_parser v1.0.1
Downloaded toml v0.9.2
Downloaded tempfile v3.20.0
Downloaded redox_users v0.4.6
Downloaded proc-macro2 v1.0.95
Downloaded thiserror-impl v1.0.69
Downloaded thiserror v1.0.69
Downloaded cfg-if v1.0.1
Downloaded libredox v0.1.6
Downloaded directories-next v2.0.0
Downloaded wit-bindgen-rt v0.39.0
Downloaded wasi v0.11.1+wasi-snapshot-preview1
Downloaded windows_i686_gnullvm v0.52.6
Downloaded itoa v1.0.15
Downloaded getrandom v0.2.16
Downloaded unsafe-libyaml-norway v0.2.15
Downloaded serde_norway v0.9.42
Downloaded memchr v2.7.5
Downloaded ryu v1.0.20
Downloaded getrandom v0.3.3
Downloaded once_cell v1.21.3
Downloaded r-efi v5.3.0
Downloaded quote v1.0.40
Downloaded thiserror-impl v2.0.12
Downloaded wasi v0.14.2+wasi-0.2.4
Downloaded serde_json v1.0.141
Downloaded hashbrown v0.15.4
Downloaded indexmap v2.10.0
Downloaded thiserror v2.0.12
Downloaded dirs-sys-next v0.1.2
Downloaded errno v0.3.13
Downloaded equivalent v1.0.2
Downloaded serde_spanned v1.0.0
Downloaded bitflags v2.9.1
Downloaded fastrand v2.3.0
Downloaded syn v2.0.104
Downloaded windows-targets v0.53.2
Downloaded serde v1.0.219
Downloaded winnow v0.7.12
Downloaded unicode-ident v1.0.18
Downloaded serde_derive v1.0.219
Downloaded rustix v1.0.8
Downloaded windows_x86_64_gnullvm v0.52.6
Downloaded toml_writer v1.0.2
Downloaded windows_aarch64_gnullvm v0.52.6
Downloaded windows_x86_64_gnullvm v0.53.0
Downloaded libc v0.2.174
Downloaded windows_aarch64_gnullvm v0.53.0
Downloaded windows_x86_64_msvc v0.53.0
Downloaded windows_aarch64_msvc v0.53.0
Downloaded windows_i686_gnu v0.53.0
Downloaded windows_aarch64_msvc v0.52.6
Downloaded windows_i686_msvc v0.53.0
Downloaded windows_x86_64_gnu v0.53.0
Downloaded windows_i686_msvc v0.52.6
Downloaded windows_x86_64_gnu v0.52.6
Downloaded windows_x86_64_msvc v0.52.6
Downloaded windows_i686_gnu v0.52.6
Downloaded windows_i686_gnullvm v0.53.0
Downloaded winapi v0.3.9
Downloaded windows-sys v0.60.2
Downloaded windows-sys v0.59.0
Downloaded linux-raw-sys v0.9.4
Downloaded winapi-i686-pc-windows-gnu v0.4.0
Downloaded winapi-x86_64-pc-windows-gnu v0.4.0
[2025-09-17T13:32:33Z DEBUG ambient_ci::run] create virtual drive /srv/tmp/.tmpOfqyg3/src.tar
[2025-09-17T13:32:33Z DEBUG ambient_ci::run] create virtual drive /srv/tmp/.tmpOfqyg3/deps.tar
[2025-09-17T13:32:33Z DEBUG ambient_ci::run] create_executor_vdrive: executor="/usr/bin/ambient-execute-plan"
[2025-09-17T13:32:33Z 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,
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-17T13:32:33Z DEBUG ambient_ci::run] executor bin /usr/bin/ambient-execute-plan
[2025-09-17T13:32:33Z DEBUG ambient_ci::run] copying /usr/bin/ambient-execute-plan to /srv/tmp/.tmpOfqyg3/ambient-execute-plan/run-ci
[2025-09-17T13:32:33Z DEBUG ambient_ci::run] copy OK: true
[2025-09-17T13:32:33Z DEBUG ambient_ci::run] create virtual drive /srv/tmp/.tmpOfqyg3/executor.tar
[2025-09-17T13:32:33Z DEBUG ambient_ci::project] removing run log file /srv/ambient-state/rad:z3248z9KmBQ6Tf4mwXih1zKPtuSw5/run.log
[2025-09-17T13:32:33Z DEBUG ambient_ci::project] statedir is /srv/ambient-state/rad:z3248z9KmBQ6Tf4mwXih1zKPtuSw5, exists? true
[2025-09-17T13:32:33Z DEBUG ambient_ci::project] creating run log file /srv/ambient-state/rad:z3248z9KmBQ6Tf4mwXih1zKPtuSw5/run.log
[2025-09-17T13:32:33Z DEBUG ambient_ci::project] created run log file /srv/ambient-state/rad:z3248z9KmBQ6Tf4mwXih1zKPtuSw5/run.log OK
[2025-09-17T13:32:33Z DEBUG ambient_ci::cloud_init] with_hostname called: "ambient"
[2025-09-17T13:32:33Z DEBUG ambient_ci::cloud_init] with_runcmd called: "echo xyzzy > /dev/ttyS1"
[2025-09-17T13:32:33Z 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-17T13:32:33Z DEBUG ambient_ci::cloud_init] with_runcmd called: "poweroff"
[2025-09-17T13:32:33Z 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-17T13:32:33Z DEBUG ambient_ci::qemu] run QEMU
[2025-09-17T13:32:33Z DEBUG ambient_ci::qemu] create copy-on-write image and UEFI vars file
[2025-09-17T13:32:33Z DEBUG ambient_ci::qemu_utils] qemu-img create /srv/tmp/.tmpem6D6c/.tmpL8aw9a/vm.qcow2 backing on /home/_rad/ambient.qcow2
[2025-09-17T13:32:33Z DEBUG ambient_ci::qemu] create cloud-init ISO file
[2025-09-17T13:32:33Z 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-17T13:32:33Z DEBUG ambient_ci::cloud_init] write /tmp/.tmphW2nqz/meta-data
[2025-09-17T13:32:33Z DEBUG ambient_ci::cloud_init] write /tmp/.tmphW2nqz/user-data
[2025-09-17T13:32:33Z DEBUG ambient_ci::qemu] set console log file to /srv/tmp/.tmpem6D6c/.tmpL8aw9a/console.log
[2025-09-17T13:32:33Z DEBUG ambient_ci::util] create file /srv/tmp/.tmpem6D6c/.tmpL8aw9a/console.log
[2025-09-17T13:32:33Z DEBUG ambient_ci::qemu] set run file to /srv/ambient-state/rad:z3248z9KmBQ6Tf4mwXih1zKPtuSw5/run.log
[2025-09-17T13:32:33Z DEBUG ambient_ci::util] create file /srv/ambient-state/rad:z3248z9KmBQ6Tf4mwXih1zKPtuSw5/run.log
[2025-09-17T13:32:33Z 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/.tmpem6D6c/.tmpL8aw9a/console.log",
"-serial",
"file:/srv/ambient-state/rad:z3248z9KmBQ6Tf4mwXih1zKPtuSw5/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/.tmpem6D6c/.tmpL8aw9a/vars.fd",
"-drive",
"format=qcow2,if=virtio,file=/srv/tmp/.tmpem6D6c/.tmpL8aw9a/vm.qcow2",
"-drive",
"format=raw,if=virtio,file=/srv/tmp/.tmpOfqyg3/executor.tar,readonly=on",
"-cdrom",
"/srv/tmp/.tmpem6D6c/.tmpL8aw9a/cloud_init.iso",
"-drive",
"format=raw,if=virtio,file=/srv/tmp/.tmpOfqyg3/src.tar,readonly=on",
"-drive",
"format=raw,if=virtio,file=/srv/tmp/.tmpOfqyg3/artifacts.tar",
"-drive",
"format=raw,if=virtio,file=/srv/tmp/.tmpOfqyg3/cache.tar",
"-drive",
"format=raw,if=virtio,file=/srv/tmp/.tmpOfqyg3/deps.tar,readonly=on",
"-nodefaults",
"-no-user-config",
],
}
[2025-09-17T13:32:56Z DEBUG ambient_ci::qemu] QEMU finished OK
[2025-09-17T13:32:56Z DEBUG ambient_ci::qemu] run log:
--------------------==========
[2025-09-17T13:32:40Z TRACE ambient_execute_plan] ambient-execute-plan starts
[2025-09-17T13:32:40Z DEBUG ambient_execute_plan] ambient-execute-plan starts
[2025-09-17T13:32:40Z INFO ambient_execute_plan] ambient-execute-plan starts
[2025-09-17T13:32:40Z WARN ambient_execute_plan] ambient-execute-plan starts
[2025-09-17T13:32:40Z ERROR ambient_execute_plan] ambient-execute-plan starts
RunnablePlan::from_file: filename=plan.yaml
steps:
- action: mkdir
pathname: /workspace
- action: mkdir
pathname: /workspace/artifacts
- action: tar_extract
archive: /dev/vdc
directory: /workspace/src
- action: tar_extract
archive: /dev/vdf
directory: /workspace/deps
- action: tar_extract
archive: /dev/vde
directory: /workspace/cache
- action: spawn
argv:
- find
- /workspace
- '-maxdepth'
- '2'
- '-ls'
- action: cargo_clippy
- action: cargo_build
- action: cargo_test
- action: tar_create
archive: /dev/vde
directory: /workspace/cache
- action: tar_create
archive: /dev/vdd
directory: /workspace/artifacts
executor_drive: /dev/vdb
source_drive: /dev/vdc
artifact_drive: /dev/vdd
cache_drive: /dev/vde
deps_drive: /dev/vdf
workspace_dir: /workspace
source_dir: /workspace/src
deps_dir: /workspace/deps
cache_dir: /workspace/cache
artifacts_dir: /workspace/artifacts
RUN: Action Mkdir {
pathname: "/workspace",
}
[2025-09-17T13:32:40Z DEBUG ambient_ci::action] Plan::execute: Mkdir {
pathname: "/workspace",
}
RUN: Action finished OK
RUN: Action Mkdir {
pathname: "/workspace/artifacts",
}
[2025-09-17T13:32:40Z DEBUG ambient_ci::action] Plan::execute: Mkdir {
pathname: "/workspace/artifacts",
}
RUN: Action finished OK
RUN: Action TarExtract {
archive: "/dev/vdc",
directory: "/workspace/src",
}
[2025-09-17T13:32:40Z DEBUG ambient_ci::action] Plan::execute: TarExtract {
archive: "/dev/vdc",
directory: "/workspace/src",
}
[2025-09-17T13:32:40Z TRACE ambient_ci::vdrive] extracting /dev/vdc to /workspace/src
[2025-09-17T13:32:40Z TRACE ambient_ci::vdrive] extraction OK
RUN: Action finished OK
RUN: Action TarExtract {
archive: "/dev/vdf",
directory: "/workspace/deps",
}
[2025-09-17T13:32:40Z DEBUG ambient_ci::action] Plan::execute: TarExtract {
archive: "/dev/vdf",
directory: "/workspace/deps",
}
[2025-09-17T13:32:40Z TRACE ambient_ci::vdrive] extracting /dev/vdf to /workspace/deps
[2025-09-17T13:32:41Z TRACE ambient_ci::vdrive] extraction OK
RUN: Action finished OK
RUN: Action TarExtract {
archive: "/dev/vde",
directory: "/workspace/cache",
}
[2025-09-17T13:32:41Z DEBUG ambient_ci::action] Plan::execute: TarExtract {
archive: "/dev/vde",
directory: "/workspace/cache",
}
[2025-09-17T13:32:41Z TRACE ambient_ci::vdrive] extracting /dev/vde to /workspace/cache
[2025-09-17T13:32:41Z TRACE ambient_ci::vdrive] extraction OK
RUN: Action finished OK
RUN: Action Spawn {
argv: [
"find",
"/workspace",
"-maxdepth",
"2",
"-ls",
],
}
[2025-09-17T13:32:41Z DEBUG ambient_ci::action] Plan::execute: Spawn {
argv: [
"find",
"/workspace",
"-maxdepth",
"2",
"-ls",
],
}
SPAWN: argv=["find", "/workspace", "-maxdepth", "2", "-ls"]
cwd=/workspace/src (exists? true)
extra_env=[]
2621441 4 drwxr-xr-x 6 root root 4096 Sep 17 13:32 /workspace
2621611 4 drwxr-xr-x 3 root root 4096 Sep 17 13:32 /workspace/deps
2621612 0 -rw-r--r-- 1 root root 0 Sep 17 13:32 /workspace/deps/.package-cache-mutate
2621615 4 drwxr-xr-x 5 root root 4096 Sep 17 13:32 /workspace/deps/registry
2621613 56 -rw-r--r-- 1 root root 57344 Sep 17 13:32 /workspace/deps/.global-cache
2621614 0 -rw-r--r-- 1 root root 0 Sep 17 13:32 /workspace/deps/.package-cache
2621443 4 drwxr-xr-x 7 root root 4096 Sep 17 13:32 /workspace/src
2621456 4 -rw-r--r-- 1 root root 470 Sep 17 13:32 /workspace/src/Cargo.toml
2621453 4 -rw-r--r-- 1 root root 1172 Sep 17 13:32 /workspace/src/NEWS.md
2621461 4 drwxr-xr-x 8 root root 4096 Sep 17 13:32 /workspace/src/.git
2621446 4 drwxr-xr-x 2 root root 4096 Sep 17 13:32 /workspace/src/src
2621454 4 -rw-r--r-- 1 root root 1484 Sep 17 13:32 /workspace/src/README.md
2621444 4 drwxr-xr-x 2 root root 4096 Sep 17 13:32 /workspace/src/.radicle
2621610 16 -rw-r--r-- 1 root root 15728 Sep 17 13:32 /workspace/src/Cargo.lock
2621455 4 -rw-r--r-- 1 root root 8 Sep 17 13:32 /workspace/src/.gitignore
2621457 4 drwxr-xr-x 2 root root 4096 Sep 17 13:32 /workspace/src/examples
2621609 4 -rw-r--r-- 1 root root 198 Sep 17 13:32 /workspace/src/Makefile
2621451 4 drwxr-xr-x 2 root root 4096 Sep 17 13:32 /workspace/src/.cargo
2621442 4 drwxr-xr-x 2 root root 4096 Sep 17 13:32 /workspace/artifacts
2629172 4 drwxr-xr-x 2 root root 4096 Sep 17 13:32 /workspace/cache
RUN: Action finished OK
RUN: Action CargoClippy
[2025-09-17T13:32:41Z DEBUG ambient_ci::action] Plan::execute: CargoClippy
SPAWN: argv=["cargo", "clippy", "--offline", "--locked", "--workspace", "--all-targets", "--no-deps", "--", "--deny", "warnings"]
cwd=/workspace/src (exists? true)
extra_env=[("CARGO_TARGET_DIR", "/workspace/cache"), ("CARGO_HOME", "/workspace/deps"), ("PATH", "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin")]
Compiling proc-macro2 v1.0.95
Compiling unicode-ident v1.0.18
Compiling serde v1.0.219
Compiling libc v0.2.174
Checking cfg-if v1.0.1
Compiling getrandom v0.3.3
Compiling rustix v1.0.8
Compiling thiserror v2.0.12
Checking winnow v0.7.12
Checking ryu v1.0.20
Checking hashbrown v0.15.4
Compiling quote v1.0.40
Checking itoa v1.0.15
Checking bitflags v2.9.1
Compiling syn v2.0.104
Checking equivalent v1.0.2
Compiling serde_json v1.0.141
Checking linux-raw-sys v0.9.4
Checking indexmap v2.10.0
Checking toml_parser v1.0.1
Checking dirs-sys-next v0.1.2
Checking toml_writer v1.0.2
Checking memchr v2.7.5
Checking unsafe-libyaml-norway v0.2.15
Checking once_cell v1.21.3
Checking fastrand v2.3.0
Checking directories-next v2.0.0
Checking tempfile v3.20.0
Compiling serde_derive v1.0.219
Compiling thiserror-impl v2.0.12
Checking toml_datetime v0.7.0
Checking serde_spanned v1.0.0
Checking serde_norway v0.9.42
Checking toml v0.9.2
Checking clingwrap v0.4.0 (/workspace/src)
Finished `dev` profile [unoptimized + debuginfo] target(s) in 7.40s
RUN: Action finished OK
RUN: Action CargoBuild
[2025-09-17T13:32:49Z DEBUG ambient_ci::action] Plan::execute: CargoBuild
SPAWN: argv=["cargo", "build", "--offline", "--locked", "--workspace", "--all-targets"]
cwd=/workspace/src (exists? true)
extra_env=[("CARGO_TARGET_DIR", "/workspace/cache"), ("CARGO_HOME", "/workspace/deps"), ("PATH", "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin")]
Compiling serde v1.0.219
Compiling cfg-if v1.0.1
Compiling libc v0.2.174
Compiling linux-raw-sys v0.9.4
Compiling hashbrown v0.15.4
Compiling bitflags v2.9.1
Compiling ryu v1.0.20
Compiling itoa v1.0.15
Compiling equivalent v1.0.2
Compiling winnow v0.7.12
Compiling indexmap v2.10.0
Compiling dirs-sys-next v0.1.2
Compiling getrandom v0.3.3
Compiling rustix v1.0.8
Compiling toml_writer v1.0.2
Compiling once_cell v1.21.3
Compiling unsafe-libyaml-norway v0.2.15
Compiling toml_parser v1.0.1
Compiling memchr v2.7.5
Compiling serde_spanned v1.0.0
Compiling toml_datetime v0.7.0
Compiling fastrand v2.3.0
Compiling toml v0.9.2
Compiling tempfile v3.20.0
Compiling serde_json v1.0.141
Compiling serde_norway v0.9.42
Compiling thiserror v2.0.12
Compiling directories-next v2.0.0
Compiling clingwrap v0.4.0 (/workspace/src)
Finished `dev` profile [unoptimized + debuginfo] target(s) in 4.64s
RUN: Action finished OK
RUN: Action CargoTest
[2025-09-17T13:32:53Z DEBUG ambient_ci::action] Plan::execute: CargoTest
SPAWN: argv=["cargo", "test", "--offline", "--locked", "--workspace"]
cwd=/workspace/src (exists? true)
extra_env=[("CARGO_TARGET_DIR", "/workspace/cache"), ("CARGO_HOME", "/workspace/deps"), ("PATH", "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin")]
Finished `test` profile [unoptimized + debuginfo] target(s) in 0.02s
Running unittests src/lib.rs (/workspace/cache/debug/deps/clingwrap-0974b031ea215f84)
running 18 tests
test config::test::filenames ... ok
test config::test::builtin_defaults ... ok
test config::test::load_configs ... ok
test config::test::merge_simple ... ok
test config::test::parse_json ... ok
test config::test::parse_toml ... ok
test config::test::parse_yaml ... ok
test tildepathbuf::test::as_ref ... ok
test tildepathbuf::test::deref ... ok
test tildepathbuf::test::deser ... ok
test tildepathbuf::test::eq ... ok
test tildepathbuf::test::just_tilde ... ok
test tildepathbuf::test::no_tilde ... ok
test tildepathbuf::test::tilde_slash ... ok
test tildepathbuf::test::tilde_slash_with_home_from_var ... ok
test tildepathbuf::test::tilde_username ... ok
test tildepathbuf::test::to_path_buf ... ok
test config::test::overrides ... ok
test result: ok. 18 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
Doc-tests clingwrap
running 3 tests
test src/config.rs - config (line 75) ... ok
test src/tildepathbuf.rs - tildepathbuf (line 9) ... ok
test src/runner.rs - runner (line 8) ... ok
test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
RUN: Action finished OK
RUN: Action TarCreate {
archive: "/dev/vde",
directory: "/workspace/cache",
}
[2025-09-17T13:32:54Z DEBUG ambient_ci::action] Plan::execute: TarCreate {
archive: "/dev/vde",
directory: "/workspace/cache",
}
[2025-09-17T13:32:54Z TRACE ambient_ci::vdrive] creating virtual drive (tar archive): VirtualDriveBuilder {
filename: Some(
"/dev/vde",
),
root: Some(
"/workspace/cache",
),
size: None,
}
[2025-09-17T13:32:54Z TRACE ambient_ci::vdrive] tar archive to be created: /dev/vde; exists? true
[2025-09-17T13:32:54Z TRACE ambient_ci::vdrive] create archive file /dev/vde
[2025-09-17T13:32:54Z TRACE ambient_ci::vdrive] directory /workspace/cache exists? true
[2025-09-17T13:32:54Z TRACE ambient_ci::vdrive] add contents of /workspace/cache as .
[2025-09-17T13:32:54Z TRACE ambient_ci::vdrive] created virtual drive /dev/vde
RUN: Action finished OK
RUN: Action TarCreate {
archive: "/dev/vdd",
directory: "/workspace/artifacts",
}
[2025-09-17T13:32:54Z DEBUG ambient_ci::action] Plan::execute: TarCreate {
archive: "/dev/vdd",
directory: "/workspace/artifacts",
}
[2025-09-17T13:32:54Z TRACE ambient_ci::vdrive] creating virtual drive (tar archive): VirtualDriveBuilder {
filename: Some(
"/dev/vdd",
),
root: Some(
"/workspace/artifacts",
),
size: None,
}
[2025-09-17T13:32:54Z TRACE ambient_ci::vdrive] tar archive to be created: /dev/vdd; exists? true
[2025-09-17T13:32:54Z TRACE ambient_ci::vdrive] create archive file /dev/vdd
[2025-09-17T13:32:54Z TRACE ambient_ci::vdrive] directory /workspace/artifacts exists? true
[2025-09-17T13:32:54Z TRACE ambient_ci::vdrive] add contents of /workspace/artifacts as .
[2025-09-17T13:32:54Z TRACE ambient_ci::vdrive] created virtual drive /dev/vdd
RUN: Action finished OK
ambient-execute-plan ends
EXIT CODE: 0
====================
[2025-09-17T13:32:56Z DEBUG ambient_ci::qemu] QEMU exit code 0
[2025-09-17T13:32:56Z DEBUG ambient_ci::run] remove old cache
[2025-09-17T13:32:56Z DEBUG ambient_ci::run] extract cache
[2025-09-17T13:32:57Z DEBUG ambient_ci::run] Executing post-plan steps
[2025-09-17T13:32:57Z DEBUG ambient_ci::project] write project state to /srv/ambient-state/rad:z3248z9KmBQ6Tf4mwXih1zKPtuSw5/meta.yaml
[2025-09-17T13:32:57Z INFO ambient] ambient ends successfully
<empty log>