CI run for rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x

Radicle repository id rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x

Table of Contents

Run log

[=3h[=3hBdsDxe: failed to load Boot0001 "UEFI QEMU DVD-ROM QM00005 " from PciRoot(0x0)/Pci(0x1F,0x2)/Sata(0x2,0xFFFF,0x0): Not Found
BdsDxe: loading Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x2,0x0)
BdsDxe: starting Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x2,0x0)
Welcome to GRUB!


INFO: Block devices
NAME   MAJ:MIN RM   SIZE RO TYPE MOUNTPOINTS
vda    254:0    0   100G  0 disk 
├─vda1 254:1    0   953M  0 part 
└─vda2 254:2    0  99.1G  0 part /
vdb    254:16   0     6M  1 disk 
vdc    254:32   0   1.9M  1 disk 
vdd    254:48   0 953.7M  0 disk 
vde    254:64   0  27.9G  0 disk 
vdf    254:80   0 342.3M  1 disk 
INFO: Extracting tar archive from /dev/vdb
drwxr-xr-x _rad/_rad         0 2026-01-15 06:12 ./
-rw-r--r-- _rad/_rad      1212 2026-01-15 06:12 ./plan.yaml
-rwxr-xr-x _rad/_rad   6275392 2026-01-15 06:12 ./run-ci
INFO: Extracted files:
  5636108      4 drwxr-xr-x   2 1000     1000         4096 Jan 15 06:12 .
  5636110   6132 -rwxr-xr-x   1 1000     1000      6275392 Jan 15 06:12 ./run-ci
  5636109      4 -rw-r--r--   1 1000     1000         1212 Jan 15 06:12 ./plan.yaml
INFO: Running run-ci from /dev/vdb
================================ BEGIN ================================
[2026-01-15T06:12:51Z TRACE ambient_execute_plan] ambient-execute-plan version 0.11.1@d7192bd starts
[2026-01-15T06:12:51Z DEBUG ambient_execute_plan] ambient-execute-plan version 0.11.1@d7192bd starts
[2026-01-15T06:12:51Z INFO  ambient_execute_plan] ambient-execute-plan version 0.11.1@d7192bd starts
[2026-01-15T06:12:51Z WARN  ambient_execute_plan] ambient-execute-plan version 0.11.1@d7192bd starts
[2026-01-15T06:12:51Z ERROR ambient_execute_plan] ambient-execute-plan version 0.11.1@d7192bd starts
[2026-01-15T06:12:51Z TRACE ambient_ci::plan] RunnablePlan::from_file: filename=plan.yaml
    steps:
    - action: mkdir
      pathname: /ci
    - action: mkdir
      pathname: /ci/artifacts
    - action: tar_extract
      archive: /dev/vdc
      directory: /ci/src
    - action: tar_extract
      archive: /dev/vdf
      directory: /ci/deps
    - action: tar_extract
      archive: /dev/vde
      directory: /ci/cache
    - action: shell
      shell: ln -sf /ci /workspace
    - action: shell
      shell: git config --global user.name 'Ambient CI'
    - action: shell
      shell: git config --global user.email ambient@example.com
    - 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 doc
        find doc -ls
        cp obnam.html doc/*.html /workspace/artifacts
    - action: custom
      name: dch
      args:
        debemail: liw@liw.fi
        debfullname: Lars Wirzenius
    - action: deb
      packages: .
    - action: tar_create
      archive: /dev/vde
      directory: /ci/cache
    - action: tar_create
      archive: /dev/vdd
      directory: /ci/artifacts
    executor_drive: /dev/vdb
    source_drive: /dev/vdc
    artifact_drive: /dev/vdd
    cache_drive: /dev/vde
    deps_drive: /dev/vdf
    workspace_dir: /ci
    source_dir: /ci/src
    deps_dir: /ci/deps
    cache_dir: /ci/cache
    artifacts_dir: /ci/artifacts
    
    
[2026-01-15T06:12:51Z DEBUG ambient_ci::plan] RUN: Action Mkdir(
        Mkdir {
            pathname: "/ci",
        },
    )
[2026-01-15T06:12:51Z DEBUG ambient_ci::action] RunnableAction::execute: self=Mkdir(
        Mkdir {
            pathname: "/ci",
        },
    )
[2026-01-15T06:12:51Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/ci/cache/cargo-target",
            "CARGO_HOME": "/ci/deps",
            "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
            "HOME": "/root",
        },
        source_dir: "/ci/src",
        deps_dir: "/ci/deps",
        artifacts_dir: "/ci/artifacts",
    }
[2026-01-15T06:12:51Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2026-01-15T06:12:51Z DEBUG ambient_ci::plan] RUN: Action Mkdir(
        Mkdir {
            pathname: "/ci/artifacts",
        },
    )
[2026-01-15T06:12:51Z DEBUG ambient_ci::action] RunnableAction::execute: self=Mkdir(
        Mkdir {
            pathname: "/ci/artifacts",
        },
    )
[2026-01-15T06:12:51Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/ci/cache/cargo-target",
            "CARGO_HOME": "/ci/deps",
            "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
            "HOME": "/root",
        },
        source_dir: "/ci/src",
        deps_dir: "/ci/deps",
        artifacts_dir: "/ci/artifacts",
    }
[2026-01-15T06:12:51Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2026-01-15T06:12:51Z DEBUG ambient_ci::plan] RUN: Action TarExtract(
        TarExtract {
            archive: "/dev/vdc",
            directory: "/ci/src",
        },
    )
[2026-01-15T06:12:51Z DEBUG ambient_ci::action] RunnableAction::execute: self=TarExtract(
        TarExtract {
            archive: "/dev/vdc",
            directory: "/ci/src",
        },
    )
[2026-01-15T06:12:51Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/ci/cache/cargo-target",
            "CARGO_HOME": "/ci/deps",
            "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
            "HOME": "/root",
        },
        source_dir: "/ci/src",
        deps_dir: "/ci/deps",
        artifacts_dir: "/ci/artifacts",
    }
[2026-01-15T06:12:51Z TRACE ambient_ci::vdrive] extracting /dev/vdc to /ci/src
[2026-01-15T06:12:51Z TRACE ambient_ci::vdrive] extraction OK
[2026-01-15T06:12:51Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2026-01-15T06:12:51Z DEBUG ambient_ci::plan] RUN: Action TarExtract(
        TarExtract {
            archive: "/dev/vdf",
            directory: "/ci/deps",
        },
    )
[2026-01-15T06:12:51Z DEBUG ambient_ci::action] RunnableAction::execute: self=TarExtract(
        TarExtract {
            archive: "/dev/vdf",
            directory: "/ci/deps",
        },
    )
[2026-01-15T06:12:51Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/ci/cache/cargo-target",
            "CARGO_HOME": "/ci/deps",
            "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
            "HOME": "/root",
        },
        source_dir: "/ci/src",
        deps_dir: "/ci/deps",
        artifacts_dir: "/ci/artifacts",
    }
[2026-01-15T06:12:51Z TRACE ambient_ci::vdrive] extracting /dev/vdf to /ci/deps
[2026-01-15T06:12:56Z TRACE ambient_ci::vdrive] extraction OK
[2026-01-15T06:12:56Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2026-01-15T06:12:56Z DEBUG ambient_ci::plan] RUN: Action TarExtract(
        TarExtract {
            archive: "/dev/vde",
            directory: "/ci/cache",
        },
    )
[2026-01-15T06:12:56Z DEBUG ambient_ci::action] RunnableAction::execute: self=TarExtract(
        TarExtract {
            archive: "/dev/vde",
            directory: "/ci/cache",
        },
    )
[2026-01-15T06:12:56Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/ci/cache/cargo-target",
            "CARGO_HOME": "/ci/deps",
            "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
            "HOME": "/root",
        },
        source_dir: "/ci/src",
        deps_dir: "/ci/deps",
        artifacts_dir: "/ci/artifacts",
    }
[2026-01-15T06:12:56Z TRACE ambient_ci::vdrive] extracting /dev/vde to /ci/cache
[2026-01-15T06:13:59Z TRACE ambient_ci::vdrive] extraction OK
[2026-01-15T06:13:59Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2026-01-15T06:13:59Z DEBUG ambient_ci::plan] RUN: Action Shell(
        Shell {
            shell: "ln -sf /ci /workspace",
        },
    )
[2026-01-15T06:13:59Z DEBUG ambient_ci::action] RunnableAction::execute: self=Shell(
        Shell {
            shell: "ln -sf /ci /workspace",
        },
    )
[2026-01-15T06:13:59Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/ci/cache/cargo-target",
            "CARGO_HOME": "/ci/deps",
            "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
            "HOME": "/root",
        },
        source_dir: "/ci/src",
        deps_dir: "/ci/deps",
        artifacts_dir: "/ci/artifacts",
    }
SPAWN: argv=["bash", "-c", "set -xeuo pipefail\nln -sf /ci /workspace\n"]
       cwd=/ci/src (exists? true)
+ ln -sf /ci /workspace
[2026-01-15T06:13:59Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2026-01-15T06:13:59Z DEBUG ambient_ci::plan] RUN: Action Shell(
        Shell {
            shell: "git config --global user.name 'Ambient CI'",
        },
    )
[2026-01-15T06:13:59Z DEBUG ambient_ci::action] RunnableAction::execute: self=Shell(
        Shell {
            shell: "git config --global user.name 'Ambient CI'",
        },
    )
[2026-01-15T06:13:59Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/ci/cache/cargo-target",
            "CARGO_HOME": "/ci/deps",
            "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
            "HOME": "/root",
        },
        source_dir: "/ci/src",
        deps_dir: "/ci/deps",
        artifacts_dir: "/ci/artifacts",
    }
SPAWN: argv=["bash", "-c", "set -xeuo pipefail\ngit config --global user.name 'Ambient CI'\n"]
       cwd=/ci/src (exists? true)
+ git config --global user.name 'Ambient CI'
[2026-01-15T06:13:59Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2026-01-15T06:13:59Z DEBUG ambient_ci::plan] RUN: Action Shell(
        Shell {
            shell: "git config --global user.email ambient@example.com",
        },
    )
[2026-01-15T06:13:59Z DEBUG ambient_ci::action] RunnableAction::execute: self=Shell(
        Shell {
            shell: "git config --global user.email ambient@example.com",
        },
    )
[2026-01-15T06:13:59Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/ci/cache/cargo-target",
            "CARGO_HOME": "/ci/deps",
            "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
            "HOME": "/root",
        },
        source_dir: "/ci/src",
        deps_dir: "/ci/deps",
        artifacts_dir: "/ci/artifacts",
    }
SPAWN: argv=["bash", "-c", "set -xeuo pipefail\ngit config --global user.email ambient@example.com\n"]
       cwd=/ci/src (exists? true)
+ git config --global user.email ambient@example.com
[2026-01-15T06:13:59Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2026-01-15T06:13:59Z DEBUG ambient_ci::plan] RUN: Action CargoClippy(
        CargoClippy,
    )
[2026-01-15T06:13:59Z DEBUG ambient_ci::action] RunnableAction::execute: self=CargoClippy(
        CargoClippy,
    )
[2026-01-15T06:13:59Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/ci/cache/cargo-target",
            "CARGO_HOME": "/ci/deps",
            "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
            "HOME": "/root",
        },
        source_dir: "/ci/src",
        deps_dir: "/ci/deps",
        artifacts_dir: "/ci/artifacts",
    }
SPAWN: argv=["cargo", "--version"]
       cwd=/ci/src (exists? true)
cargo 1.92.0 (344c4567c 2025-10-21)
SPAWN: argv=["cargo", "clippy", "--version"]
       cwd=/ci/src (exists? true)
clippy 0.1.92 (ded5c06cf2 2025-12-08)
SPAWN: argv=["rustc", "--version"]
       cwd=/ci/src (exists? true)
rustc 1.92.0 (ded5c06cf 2025-12-08)
SPAWN: argv=["cargo", "clippy", "--offline", "--locked", "--workspace", "--all-targets", "--no-deps", "--", "--deny", "warnings"]
       cwd=/ci/src (exists? true)
   Compiling libc v0.2.177
    Checking cfg-if v1.0.4
   Compiling proc-macro2 v1.0.103
   Compiling quote v1.0.42
   Compiling unicode-ident v1.0.22
   Compiling version_check v0.9.5
   Compiling syn v2.0.110
   Compiling typenum v1.19.0
   Compiling generic-array v0.14.7
   Compiling serde_core v1.0.228
    Checking getrandom v0.2.16
    Checking rand_core v0.6.4
    Checking crypto-common v0.1.7
   Compiling rustix v1.1.2
    Checking bitflags v2.10.0
    Checking memchr v2.7.6
    Checking linux-raw-sys v0.11.0
   Compiling serde v1.0.228
   Compiling serde_derive v1.0.228
   Compiling semver v1.0.27
   Compiling getrandom v0.3.4
    Checking utf8parse v0.2.2
   Compiling thiserror v2.0.17
    Checking anstyle-parse v0.2.7
   Compiling rustc_version v0.4.1
    Checking aho-corasick v1.1.4
   Compiling thiserror-impl v2.0.17
    Checking inout v0.1.4
    Checking anstyle v1.0.13
   Compiling vcpkg v0.2.15
    Checking scopeguard v1.2.0
   Compiling num-conv v0.1.0
    Checking anstyle-query v1.1.5
    Checking colorchoice v1.0.4
   Compiling time-core v0.1.6
    Checking regex-syntax v0.8.8
   Compiling pkg-config v0.3.32
   Compiling powerfmt v0.2.0
    Checking is_terminal_polyfill v1.70.2
    Checking anstream v0.6.21
   Compiling deranged v0.5.5
    Checking regex-automata v0.4.13
   Compiling libsqlite3-sys v0.35.0
   Compiling time-macros v0.2.24
    Checking lock_api v0.4.14
    Checking cipher v0.4.4
   Compiling heapless v0.7.17
   Compiling crc32fast v1.5.0
    Checking equivalent v1.0.2
    Checking ryu v1.0.20
   Compiling serde_json v1.0.145
    Checking cpufeatures v0.2.17
    Checking foldhash v0.1.5
    Checking subtle v2.6.1
    Checking hashbrown v0.16.0
   Compiling itoa v1.0.15
    Checking winnow v0.7.13
    Checking byteorder v1.5.0
    Checking hash32 v0.2.1
    Checking indexmap v2.12.0
   Compiling time v0.3.44
    Checking toml_parser v1.0.4
    Checking universal-hash v0.5.1
    Checking hashbrown v0.15.5
    Checking spin v0.9.8
    Checking regex v1.12.2
    Checking terminal_size v0.4.3
    Checking serde_spanned v1.0.3
    Checking toml_datetime v0.7.3
    Checking dirs-sys-next v0.1.2
    Checking adler2 v2.0.1
    Checking strsim v0.11.1
    Checking fastrand v2.3.0
    Checking unsafe-libyaml-norway v0.2.15
    Checking opaque-debug v0.3.1
   Compiling heck v0.5.0
   Compiling log v0.4.28
    Checking once_cell v1.21.3
    Checking toml_writer v1.0.4
    Checking clap_lex v0.7.6
    Checking simd-adler32 v0.3.7
    Checking stable_deref_trait v1.2.1
    Checking env_filter v0.1.4
    Checking miniz_oxide v0.8.9
    Checking toml v0.9.8
    Checking clap_builder v4.5.51
    Checking serde_norway v0.9.42
    Checking tempfile v3.23.0
   Compiling git-testament-derive v0.2.1
   Compiling clap_derive v4.5.49
    Checking polyval v0.6.2
    Checking directories-next v2.0.0
    Checking hashlink v0.10.0
    Checking aes v0.8.4
    Checking ctr v0.9.2
    Checking cobs v0.3.0
    Checking aead v0.5.2
    Checking fallible-streaming-iterator v0.1.9
    Checking zeroize v1.8.2
    Checking jiff v0.2.16
    Checking smallvec v1.15.1
    Checking fallible-iterator v0.3.0
    Checking rusqlite v0.37.0
    Checking aes-gcm-siv v0.11.1
    Checking postcard v1.1.3
    Checking clap v4.5.51
    Checking clingwrap v0.5.0
    Checking flate2 v1.1.5
    Checking git-testament v0.2.6
    Checking uuid v1.18.1
    Checking hostname v0.4.1
   Compiling mutants v0.0.3
    Checking env_logger v0.11.8
    Checking obnam v0.10.0 (/ci/src)
    Finished `dev` profile [unoptimized + debuginfo] target(s) in 43.79s
[2026-01-15T06:14:44Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2026-01-15T06:14:44Z DEBUG ambient_ci::plan] RUN: Action CargoBuild(
        CargoBuild,
    )
[2026-01-15T06:14:44Z DEBUG ambient_ci::action] RunnableAction::execute: self=CargoBuild(
        CargoBuild,
    )
[2026-01-15T06:14:44Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/ci/cache/cargo-target",
            "CARGO_HOME": "/ci/deps",
            "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
            "HOME": "/root",
        },
        source_dir: "/ci/src",
        deps_dir: "/ci/deps",
        artifacts_dir: "/ci/artifacts",
    }
SPAWN: argv=["cargo", "--version"]
       cwd=/ci/src (exists? true)
cargo 1.92.0 (344c4567c 2025-10-21)
SPAWN: argv=["cargo", "clippy", "--version"]
       cwd=/ci/src (exists? true)
clippy 0.1.92 (ded5c06cf2 2025-12-08)
SPAWN: argv=["rustc", "--version"]
       cwd=/ci/src (exists? true)
rustc 1.92.0 (ded5c06cf 2025-12-08)
SPAWN: argv=["cargo", "build", "--offline", "--locked", "--workspace", "--all-targets"]
       cwd=/ci/src (exists? true)
   Compiling cfg-if v1.0.4
   Compiling libc v0.2.177
   Compiling typenum v1.19.0
   Compiling generic-array v0.14.7
   Compiling getrandom v0.2.16
   Compiling serde_core v1.0.228
   Compiling rand_core v0.6.4
   Compiling crypto-common v0.1.7
   Compiling memchr v2.7.6
   Compiling bitflags v2.10.0
   Compiling itoa v1.0.15
   Compiling linux-raw-sys v0.11.0
   Compiling rustix v1.1.2
   Compiling utf8parse v0.2.2
   Compiling anstyle-parse v0.2.7
   Compiling serde v1.0.228
   Compiling aho-corasick v1.1.4
   Compiling inout v0.1.4
   Compiling anstyle-query v1.1.5
   Compiling scopeguard v1.2.0
   Compiling anstyle v1.0.13
   Compiling regex-syntax v0.8.8
   Compiling is_terminal_polyfill v1.70.2
   Compiling colorchoice v1.0.4
   Compiling anstream v0.6.21
   Compiling regex-automata v0.4.13
   Compiling lock_api v0.4.14
   Compiling thiserror v2.0.17
   Compiling cipher v0.4.4
   Compiling getrandom v0.3.4
   Compiling foldhash v0.1.5
   Compiling subtle v2.6.1
   Compiling ryu v1.0.20
   Compiling equivalent v1.0.2
   Compiling cpufeatures v0.2.17
   Compiling hashbrown v0.16.0
   Compiling byteorder v1.5.0
   Compiling winnow v0.7.13
   Compiling toml_parser v1.0.4
   Compiling hash32 v0.2.1
   Compiling indexmap v2.12.0
   Compiling regex v1.12.2
   Compiling universal-hash v0.5.1
   Compiling hashbrown v0.15.5
   Compiling spin v0.9.8
   Compiling time v0.3.44
   Compiling terminal_size v0.4.3
   Compiling serde_spanned v1.0.3
   Compiling toml_datetime v0.7.3
   Compiling dirs-sys-next v0.1.2
   Compiling fastrand v2.3.0
   Compiling strsim v0.11.1
   Compiling once_cell v1.21.3
   Compiling simd-adler32 v0.3.7
   Compiling stable_deref_trait v1.2.1
   Compiling unsafe-libyaml-norway v0.2.15
   Compiling toml_writer v1.0.4
   Compiling clap_lex v0.7.6
   Compiling opaque-debug v0.3.1
   Compiling log v0.4.28
   Compiling adler2 v2.0.1
   Compiling miniz_oxide v0.8.9
   Compiling serde_norway v0.9.42
   Compiling env_filter v0.1.4
   Compiling polyval v0.6.2
   Compiling clap_builder v4.5.51
   Compiling toml v0.9.8
   Compiling heapless v0.7.17
   Compiling git-testament-derive v0.2.1
   Compiling tempfile v3.23.0
   Compiling directories-next v2.0.0
   Compiling libsqlite3-sys v0.35.0
   Compiling hashlink v0.10.0
   Compiling crc32fast v1.5.0
   Compiling serde_json v1.0.145
   Compiling aes v0.8.4
   Compiling ctr v0.9.2
   Compiling cobs v0.3.0
   Compiling aead v0.5.2
   Compiling zeroize v1.8.2
   Compiling fallible-iterator v0.3.0
   Compiling jiff v0.2.16
   Compiling fallible-streaming-iterator v0.1.9
   Compiling smallvec v1.15.1
   Compiling rusqlite v0.37.0
   Compiling aes-gcm-siv v0.11.1
   Compiling clingwrap v0.5.0
   Compiling postcard v1.1.3
   Compiling flate2 v1.1.5
   Compiling clap v4.5.51
   Compiling git-testament v0.2.6
   Compiling uuid v1.18.1
   Compiling hostname v0.4.1
   Compiling env_logger v0.11.8
   Compiling obnam v0.10.0 (/ci/src)
    Finished `dev` profile [unoptimized + debuginfo] target(s) in 49.56s
[2026-01-15T06:15:34Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2026-01-15T06:15:34Z DEBUG ambient_ci::plan] RUN: Action CargoTest(
        CargoTest,
    )
[2026-01-15T06:15:34Z DEBUG ambient_ci::action] RunnableAction::execute: self=CargoTest(
        CargoTest,
    )
[2026-01-15T06:15:34Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/ci/cache/cargo-target",
            "CARGO_HOME": "/ci/deps",
            "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
            "HOME": "/root",
        },
        source_dir: "/ci/src",
        deps_dir: "/ci/deps",
        artifacts_dir: "/ci/artifacts",
    }
SPAWN: argv=["cargo", "--version"]
       cwd=/ci/src (exists? true)
cargo 1.92.0 (344c4567c 2025-10-21)
SPAWN: argv=["cargo", "clippy", "--version"]
       cwd=/ci/src (exists? true)
clippy 0.1.92 (ded5c06cf2 2025-12-08)
SPAWN: argv=["rustc", "--version"]
       cwd=/ci/src (exists? true)
rustc 1.92.0 (ded5c06cf 2025-12-08)
SPAWN: argv=["cargo", "test", "--offline", "--locked", "--workspace"]
       cwd=/ci/src (exists? true)
    Finished `test` profile [unoptimized + debuginfo] target(s) in 0.16s
     Running unittests src/lib.rs (/ci/cache/cargo-target/debug/deps/obnam-60a6add4a5c21e2e)

running 42 tests
test chunk::test::ciphertext_does_not_contain_plaintext ... ok
test chunk::test::id ... ok
test chunk::test::id_is_comparable_with_itself ... ok
test chunk::test::chunk_round_trip ... ok
test chunk::test::label_round_trip ... ok
test chunk::test::metadata ... 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 config::test::merge_files ... ok
test config::test::valideted_config ... ok
test chunk::test::label_display ... ok
test credential::test::roundtrip_sop_credential ... ok
test plaintext::test::compressed ... ok
test plaintext::test::compression_round_trip ... ok
test plaintext::test::uncompressed ... ok
test sop::tests::cert_display ... ok
test credential::test::roundtrip_sop_method ... ok
test sop::tests::key_display ... ok
test store::test::cant_init_nonexistent_dir ... ok
test store::test::empty_dir_is_not_init ... ok
test store::test::adds_chunk ... ok
test store::test::finds_client_chunk ... ok
test store::test::finds_chunk_when_labels_match ... ok
test store::test::finds_no_chunk_in_empty_store ... ok
test store::test::finds_credential_chunk ... ok
test store::test::finds_no_chunk_when_none_match_label ... ok
test store::test::finds_no_clients_when_there_are_none ... ok
test store::test::has_no_chunks_initially ... ok
test store::test::nonexistent_dir_is_not_init ... ok
test store::test::inits_empty_dir ... ok
test store::test::opens_client_chunk ... ok
test store::test::root_dir_is_not_init ... ok
test store::test::removes_chunk ... ok

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

     Running unittests src/bin/obnam.rs (/ci/cache/cargo-target/debug/deps/obnam-57c9463d9f432f14)

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/lib.rs - (line 12) ... ok

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

all doctests ran in 0.51s; merged doctests compilation took 0.50s
[2026-01-15T06:15:37Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2026-01-15T06:15:37Z DEBUG ambient_ci::plan] RUN: Action Shell(
        Shell {
            shell: "export PATH=/root/.cargo/bin:/bin:/sbin\nexport CARGO_TARGET_DIR=/workspace/cache\nmake subplot doc\nfind doc -ls\ncp obnam.html doc/*.html /workspace/artifacts\n",
        },
    )
[2026-01-15T06:15:37Z DEBUG ambient_ci::action] RunnableAction::execute: self=Shell(
        Shell {
            shell: "export PATH=/root/.cargo/bin:/bin:/sbin\nexport CARGO_TARGET_DIR=/workspace/cache\nmake subplot doc\nfind doc -ls\ncp obnam.html doc/*.html /workspace/artifacts\n",
        },
    )
[2026-01-15T06:15:37Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/ci/cache/cargo-target",
            "CARGO_HOME": "/ci/deps",
            "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
            "HOME": "/root",
        },
        source_dir: "/ci/src",
        deps_dir: "/ci/deps",
        artifacts_dir: "/ci/artifacts",
    }
SPAWN: argv=["bash", "-c", "set -xeuo pipefail\nexport PATH=/root/.cargo/bin:/bin:/sbin\nexport CARGO_TARGET_DIR=/workspace/cache\nmake subplot doc\nfind doc -ls\ncp obnam.html doc/*.html /workspace/artifacts\n\n"]
       cwd=/ci/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 doc
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 /ci/src
datadir /tmp/tmparn7ea3u
scenario: Add a chunk to the store.
  step 1: given an installed obnam
  step 2: given file .config/obnam/config.yaml from config.yaml
  step 3: given file greeting.txt
  step 4: given a directory mychunks
  step 5: when I run obnam store init
  step 6: when I run obnam chunk encrypt --key secret --label data --id xyzzy greeting.txt
  step 7: when I run obnam store list
  step 8: then stdout is exactly "xyzzy\n"
scenario: Inspect an encrypted chunk using key from client chunk
  step 1: given an installed obnam
  step 2: given file .config/obnam/config.yaml from config.yaml
  step 3: given file greeting.txt
  step 4: when I create directory mychunks
  step 5: when I run obnam store init
  step 6: when I run obnam --client-key my.secret client init --client-name my.host
  step 7: when I run obnam --client-key my.secret client generate my.host my.key
  step 8: 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 9: when I run obnam --client-key my.secret chunk inspect --filename chunk.file --client-name my.host --key-name my.key
  step 10: then stdout is valid JSON
  step 11: then stdout contains ""id":"
  step 12: then stdout contains ""label":"
  step 13: then stdout contains ""data": ""
scenario: Chunk encrypt/decrypt with compression round trip via repository
  step 1: given an installed obnam
  step 2: given file .config/obnam/config.yaml from config.yaml
  step 3: given file greeting.txt
  step 4: when I create directory mychunks
  step 5: when I try to run obnam store init
  step 6: when I run obnam chunk encrypt --compress --key secret --label sticky.tape greeting.txt --id=chunk0
  step 7: when I run obnam store list
  step 8: when I run obnam chunk decrypt --key secret --id chunk0
  step 9: then stdout is exactly "Hello, world.\n"
scenario: Initialize a client chunk
  step 1: given an installed obnam
  step 2: given file .config/obnam/config.yaml from config-with-credential.yaml
  step 3: when I create directory mychunks
  step 4: when I run obnam store init
  step 5: when I run obnam client init --client-name my.host
  step 6: then command is successful
scenario: Chunk encrypt/decrypt round trip via file
  step 1: given an installed obnam
  step 2: given file greeting.txt
  step 3: when I run obnam chunk encrypt --key secret --label sticky.tape greeting.txt --output chunk.file
  step 4: when I run obnam chunk decrypt --key secret chunk.file
  step 5: then stdout is exactly "Hello, world.\n"
scenario: Logging level can be set
  step 1: given an installed obnam
  step 2: when I run obnam config
  step 3: then stderr doesn't contain "TRACE"
  step 4: then stderr doesn't contain "DEBUG"
  step 5: then stderr contains "INFO"
  step 6: then stderr contains "WARN"
  step 7: then stderr contains "ERROR"
  step 8: when I run env OBNAM_LOG=error obnam config
  step 9: then stderr doesn't contain "TRACE"
  step 10: then stderr doesn't contain "DEBUG"
  step 11: then stderr doesn't contain "INFO"
  step 12: then stderr doesn't contain "WARN"
  step 13: then stderr contains "ERROR"
  step 14: when I run obnam --log-level=error config
  step 15: then stderr doesn't contain "TRACE"
  step 16: then stderr doesn't contain "DEBUG"
  step 17: then stderr doesn't contain "INFO"
  step 18: then stderr doesn't contain "WARN"
  step 19: then stderr contains "ERROR"
  step 20: when I run env OBNAM_LOG=error obnam --log-level=trace config
  step 21: then stderr contains "TRACE"
  step 22: then stderr contains "DEBUG"
  step 23: then stderr contains "INFO"
  step 24: then stderr contains "WARN"
  step 25: then stderr contains "ERROR"
scenario: Remove a chunk from store
  step 1: given an installed obnam
  step 2: given file .config/obnam/config.yaml from config.yaml
  step 3: given file greeting.txt
  step 4: given a directory mychunks
  step 5: when I run obnam store init
  step 6: when I run obnam chunk encrypt --key secret --label data-chunk --id xyzzy greeting.txt
  step 7: when I run obnam store remove xyzzy
  step 8: when I run obnam store list
  step 9: then stdout doesn't contain "xyzzy"
scenario: Round trip chunk encryption using key from client chunk
  step 1: given an installed obnam
  step 2: given file .config/obnam/config.yaml from config.yaml
  step 3: given file greeting.txt
  step 4: when I create directory mychunks
  step 5: when I run obnam store init
  step 6: when I run obnam --client-key my.secret client init --client-name my.host
  step 7: when I run obnam --client-key my.secret client generate my.host my.key
  step 8: 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 9: when I run obnam --client-key my.secret chunk decrypt --client-name my.host --key-name my.key chunk.file
  step 10: then stdout is exactly "Hello, world.\n"
scenario: Chunk encrypt/decrypt round trip via repository
  step 1: given an installed obnam
  step 2: given file .config/obnam/config.yaml from config.yaml
  step 3: given file greeting.txt
  step 4: when I create directory mychunks
  step 5: when I try to run obnam store init
  step 6: when I run obnam chunk encrypt --key secret --label sticky.tape greeting.txt --id=chunk0
  step 7: when I run obnam store list
  step 8: when I run obnam chunk decrypt --key secret --id chunk0
  step 9: then stdout is exactly "Hello, world.\n"
scenario: Create an OpenPGP software key credential
  step 1: given an installed obnam
  step 2: given file .config/obnam/config.yaml from config.yaml
  step 3: given file sop-generate
  step 4: when I run bash sop-generate alice.tsk
  step 5: when I create directory mychunks
  step 6: when I run obnam store init
  step 7: when I run obnam credential list
  step 8: then stdout is exactly ""
  step 9: when I run obnam --client-key my.secret credential openpgp-soft alice.tsk
  step 10: when I run obnam credential list --all
  step 11: then stdout isn't exactly ""
scenario: Get path to chunk in store
  step 1: given an installed obnam
  step 2: given file .config/obnam/config.yaml from config.yaml
  step 3: given file greeting.txt
  step 4: given a directory mychunks
  step 5: when I run obnam store init
  step 6: when I run obnam chunk encrypt --key secret --label data-chunk --id xyzzy greeting.txt
  step 7: when I run obnam store path xyzzy -o chunk.filename
  step 8: then a file exists whose name is in chunk.filename
scenario: Encryption round trip
  step 1: given an installed obnam
  step 2: given file alice.key
  step 3: given file hello.txt
  step 4: when I run obnam sop encrypt rsop alice.key hello.txt -o encrypted
  step 5: when I run ls -l encrypted
  step 6: when I run cat encrypted
  step 7: when I run obnam sop decrypt rsop alice.key encrypted
  step 8: then stdout is exactly "hello, world\n"
scenario: Initialize a store
  step 1: given an installed obnam
  step 2: given file .config/obnam/config.yaml from config.yaml
  step 3: then directory mychunks does not exist
  step 4: when I try to run obnam store is
  step 5: then command fails
  step 6: when I create directory mychunks
  step 7: when I try to run obnam store is
  step 8: then command fails
  step 9: when I run obnam store init
  step 10: when I run obnam store is
  step 11: then exit code is 0
scenario: Conveniently create a client with an OpenPGP software key credential
  step 1: given an installed obnam
  step 2: given file .config/obnam/config.yaml from comfy.yaml
  step 3: when I create directory chunk.store
  step 4: when I run obnam store init
  step 5: when I run obnam client init --credential softy
  step 6: when I run obnam client list
  step 7: then stdout isn't exactly ""
scenario: Inspect an encoded chunk in file
  step 1: given an installed obnam
  step 2: given file greeting.txt
  step 3: when I run obnam chunk encrypt --label sticky.tape --key secret greeting.txt --output chunk.file
  step 4: when I run obnam chunk inspect --filename chunk.file
  step 5: then stdout is valid JSON
  step 6: then stdout contains ""id":"
  step 7: then stdout contains ""label":"
  step 8: then stdout contains ""data": null"
  step 9: when I run obnam chunk inspect --filename chunk.file --key secret
  step 10: then stdout is valid JSON
  step 11: then stdout contains ""id":"
  step 12: then stdout contains ""label":"
  step 13: then stdout contains ""data": ""
scenario: Chunk encrypt/decrypt with compression round trip via file
  step 1: given an installed obnam
  step 2: given file greeting.txt
  step 3: when I run obnam chunk encrypt --compress --key secret --label sticky.tape greeting.txt --output chunk.file
  step 4: when I run obnam chunk decrypt --key secret chunk.file
  step 5: then stdout is exactly "Hello, world.\n"
scenario: Show client
  step 1: given an installed obnam
  step 2: given file .config/obnam/config.yaml from config.yaml
  step 3: when I create directory mychunks
  step 4: when I run obnam store init
  step 5: when I run obnam --client-key my.secret client init --client-name my.host
  step 6: when I run obnam --client-key my.secret client show --client-name my.host
  step 7: then stdout is valid JSON
scenario: List clients
  step 1: given an installed obnam
  step 2: given file .config/obnam/config.yaml from config.yaml
  step 3: when I create directory mychunks
  step 4: when I run obnam store init
  step 5: when I run obnam --client-key my.secret client init --client-name my.host
  step 6: when I run obnam --client-key my.secret client list
  step 7: then stdout is exactly "my.host\n"
scenario: Conveniently encrypt and decrypt chunk in a store
  step 1: given an installed obnam
  step 2: given file .config/obnam/config.yaml from comfy.yaml
  step 3: given file message.txt
  step 4: when I create directory chunk.store
  step 5: when I run obnam store init
  step 6: when I run obnam client init --credential softy
  step 7: when I run obnam chunk encrypt --label data --key-name default --id test.chunk message.txt
  step 8: when I run obnam chunk decrypt --key-name default --id test.chunk --output out.dat
  step 9: then files message.txt and out.dat match
scenario: Avoid client chunks with the same name
  step 1: given an installed obnam
  step 2: given file .config/obnam/config.yaml from config.yaml
  step 3: when I create directory mychunks
  step 4: when I run obnam store init
  step 5: when I run obnam --client-key my.secret client init --client-name my.host
  step 6: then command is successful
  step 7: when I try to run obnam --client-key my.secret client init --client-name my.host
  step 8: then command fails
scenario: Inspect an encoded chunk in repository
  step 1: given an installed obnam
  step 2: given file .config/obnam/config.yaml from config.yaml
  step 3: given file greeting.txt
  step 4: when I create directory mychunks
  step 5: when I try to run obnam store init
  step 6: when I run obnam chunk encrypt --label sticky.tape --key secret greeting.txt --id=chunk0
  step 7: when I run obnam chunk inspect --id chunk0
  step 8: then stdout is valid JSON
  step 9: then stdout contains ""id":"
  step 10: then stdout contains ""label":"
  step 11: then stdout contains ""data": null"
  step 12: when I run obnam chunk inspect --key secret --id chunk0
  step 13: then stdout is valid JSON
  step 14: then stdout contains ""id":"
  step 15: then stdout contains ""label":"
  step 16: then stdout contains ""data": ""
scenario: Extracting a certificate from a key
  step 1: given an installed obnam
  step 2: given file alice.key
  step 3: when I run obnam sop extract-cert rsop alice.key
  step 4: then stdout isn't exactly ""
scenario: Generate new key
  step 1: given an installed obnam
  step 2: given file .config/obnam/config.yaml from config.yaml
  step 3: when I create directory mychunks
  step 4: when I run obnam store init
  step 5: when I run obnam --client-key my.secret client init --client-name my.host
  step 6: when I run obnam --client-key my.secret client generate my.host my.key
  step 7: when I run obnam --client-key my.secret client show --client-name my.host
  step 8: then stdout contains "my.key"
scenario: Find chunks using labels
  step 1: given an installed obnam
  step 2: given file .config/obnam/config.yaml from config.yaml
  step 3: given file greeting.txt
  step 4: given a directory mychunks
  step 5: when I run obnam store init
  step 6: when I run obnam chunk encrypt --key secret --label data-chunk --id xyzzy greeting.txt
  step 7: when I run obnam chunk encrypt --key secret --label data-chunk --id plugh greeting.txt
  step 8: when I run obnam chunk encrypt --key secret --label client-chunk --id advent greeting.txt
  step 9: when I run obnam store find missing
  step 10: then stdout is exactly ""
  step 11: when I run obnam store find data-chunk
  step 12: then stdout contains "xyzzy"
  step 13: then stdout contains "plugh"
  step 14: then stdout doesn't contain "advent"
  step 15: when I run obnam store find client-chunk
  step 16: then stdout doesn't contain "xyzzy"
  step 17: then stdout doesn't contain "plugh"
  step 18: then stdout contains "advent"
OK, all scenarios finished successfully
env 'RUSTDOCFLAGS=-D warnings' cargo doc --no-deps
   Compiling libc v0.2.177
    Checking cfg-if v1.0.4
   Compiling proc-macro2 v1.0.103
   Compiling unicode-ident v1.0.22
   Compiling quote v1.0.42
   Compiling version_check v0.9.5
   Compiling syn v2.0.110
   Compiling typenum v1.19.0
   Compiling generic-array v0.14.7
   Compiling serde_core v1.0.228
    Checking getrandom v0.2.16
    Checking rand_core v0.6.4
    Checking crypto-common v0.1.7
    Checking memchr v2.7.6
   Compiling rustix v1.1.2
    Checking bitflags v2.10.0
    Checking linux-raw-sys v0.11.0
   Compiling serde v1.0.228
   Compiling serde_derive v1.0.228
   Compiling getrandom v0.3.4
   Compiling semver v1.0.27
   Compiling thiserror v2.0.17
    Checking utf8parse v0.2.2
    Checking anstyle-parse v0.2.7
   Compiling rustc_version v0.4.1
    Checking aho-corasick v1.1.4
   Compiling thiserror-impl v2.0.17
    Checking inout v0.1.4
   Compiling num-conv v0.1.0
   Compiling time-core v0.1.6
   Compiling powerfmt v0.2.0
   Compiling vcpkg v0.2.15
    Checking scopeguard v1.2.0
    Checking anstyle v1.0.13
    Checking regex-syntax v0.8.8
    Checking is_terminal_polyfill v1.70.2
    Checking colorchoice v1.0.4
   Compiling pkg-config v0.3.32
    Checking anstyle-query v1.1.5
    Checking anstream v0.6.21
    Checking regex-automata v0.4.13
   Compiling libsqlite3-sys v0.35.0
    Checking lock_api v0.4.14
   Compiling deranged v0.5.5
   Compiling time-macros v0.2.24
    Checking cipher v0.4.4
   Compiling heapless v0.7.17
    Checking hashbrown v0.16.0
    Checking itoa v1.0.15
    Checking cpufeatures v0.2.17
    Checking foldhash v0.1.5
    Checking subtle v2.6.1
    Checking byteorder v1.5.0
    Checking winnow v0.7.13
    Checking equivalent v1.0.2
    Checking ryu v1.0.20
   Compiling serde_json v1.0.145
   Compiling crc32fast v1.5.0
    Checking indexmap v2.12.0
   Compiling time v0.3.44
    Checking toml_parser v1.0.4
    Checking hash32 v0.2.1
    Checking universal-hash v0.5.1
    Checking hashbrown v0.15.5
    Checking regex v1.12.2
    Checking spin v0.9.8
    Checking terminal_size v0.4.3
    Checking toml_datetime v0.7.3
    Checking serde_spanned v1.0.3
    Checking dirs-sys-next v0.1.2
    Checking fastrand v2.3.0
    Checking unsafe-libyaml-norway v0.2.15
    Checking toml_writer v1.0.4
    Checking simd-adler32 v0.3.7
    Checking opaque-debug v0.3.1
   Compiling heck v0.5.0
    Checking once_cell v1.21.3
   Compiling log v0.4.28
    Checking stable_deref_trait v1.2.1
    Checking clap_lex v0.7.6
    Checking adler2 v2.0.1
    Checking strsim v0.11.1
    Checking clap_builder v4.5.51
    Checking env_filter v0.1.4
    Checking miniz_oxide v0.8.9
   Compiling git-testament-derive v0.2.1
    Checking tempfile v3.23.0
    Checking serde_norway v0.9.42
   Compiling clap_derive v4.5.49
    Checking polyval v0.6.2
    Checking toml v0.9.8
    Checking directories-next v2.0.0
    Checking hashlink v0.10.0
    Checking aes v0.8.4
    Checking ctr v0.9.2
    Checking cobs v0.3.0
    Checking aead v0.5.2
    Checking fallible-iterator v0.3.0
    Checking jiff v0.2.16
    Checking fallible-streaming-iterator v0.1.9
    Checking smallvec v1.15.1
    Checking zeroize v1.8.2
    Checking aes-gcm-siv v0.11.1
    Checking rusqlite v0.37.0
    Checking postcard v1.1.3
    Checking clingwrap v0.5.0
    Checking flate2 v1.1.5
    Checking clap v4.5.51
    Checking git-testament v0.2.6
    Checking uuid v1.18.1
    Checking hostname v0.4.1
   Compiling mutants v0.0.3
    Checking env_logger v0.11.8
 Documenting obnam v0.10.0 (/ci/src)
    Finished `dev` profile [unoptimized + debuginfo] target(s) in 39.49s
   Generated /workspace/cache/doc/obnam/index.html
make -C doc
make[1]: Entering directory '/ci/src/doc'
pandoc -N --toc --standalone --self-contained -o "arch.html" "arch.md"
pandoc -N --toc --standalone --self-contained -o "glossary.html" "glossary.md"
[WARNING] This document format requires a nonempty <title> element.
  Defaulting to 'glossary' as the title.
  To specify a title, use 'title' in metadata or --metadata title="...".
make[1]: Leaving directory '/ci/src/doc'
+ find doc -ls
  3801117      4 drwxr-xr-x   2 root     root         4096 Jan 15 06:16 doc
  3801122      4 -rw-r--r--   1 root     root          327 Jan 15 06:12 doc/Makefile
  3801121     16 -rw-r--r--   1 root     root        13627 Jan 15 06:12 doc/arch.md
  3801118      4 -rw-r--r--   1 root     root         3885 Jan 15 06:12 doc/keys.svg
  3801120      4 -rw-r--r--   1 root     root          517 Jan 15 06:12 doc/glossary.md
  3818529     24 -rw-r--r--   1 root     root        24568 Jan 15 06:16 doc/arch.html
  3819995      8 -rw-r--r--   1 root     root         4303 Jan 15 06:16 doc/glossary.html
  3801119      4 -rw-r--r--   1 root     root          540 Jan 15 06:12 doc/keys.pik
+ cp obnam.html doc/arch.html doc/glossary.html /workspace/artifacts
[2026-01-15T06:16:22Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2026-01-15T06:16:22Z DEBUG ambient_ci::plan] RUN: Action Custom(
        Custom {
            name: "dch",
            args: {
                "debfullname": String("Lars Wirzenius"),
                "debemail": String("liw@liw.fi"),
            },
        },
    )
[2026-01-15T06:16:22Z DEBUG ambient_ci::action] RunnableAction::execute: self=Custom(
        Custom {
            name: "dch",
            args: {
                "debfullname": String("Lars Wirzenius"),
                "debemail": String("liw@liw.fi"),
            },
        },
    )
[2026-01-15T06:16:22Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/ci/cache/cargo-target",
            "CARGO_HOME": "/ci/deps",
            "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
            "HOME": "/root",
        },
        source_dir: "/ci/src",
        deps_dir: "/ci/deps",
        artifacts_dir: "/ci/artifacts",
    }
custom: source=/ci/src
custom: exe=".ambient/dch" exists=false
+ export 'DEBEMAIL="liw@liw.fi"'
+ DEBEMAIL='"liw@liw.fi"'
+ export 'DEBFULLNAME="Lars Wirzenius"'
+ DEBFULLNAME='"Lars Wirzenius"'
+ export CARGO_TARGET_DIR=/workspace/cache
+ CARGO_TARGET_DIR=/workspace/cache
+ export CARGO_HOME=/workspace/deps
+ CARGO_HOME=/workspace/deps
+ export HOME=/root
+ HOME=/root
+ export PATH=/root/.cargo/bin:/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
+ PATH=/root/.cargo/bin:/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
+ git reset --hard
HEAD is now at 34eb965 chore: update .ambient/dch
+ git clean -fdx
Removing doc/arch.html
Removing doc/glossary.html
Removing obnam.html
Removing test.log
Removing test.py
++ sed 's/-[^-]*$//'
++ dpkg-parsechangelog -SVersion
+ V=0.9.9
++ date -u +%Y%m%dT%H%M%S
+ T=20260115T061622
+ version=0.9.9.ci20260115T061622-1
+ dch -v 0.9.9.ci20260115T061622-1 'CI build under Ambient.'
+ dch -r ''
custom action "dch" exit code Some(0)
[2026-01-15T06:16:23Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2026-01-15T06:16:23Z DEBUG ambient_ci::plan] RUN: Action Deb(
        Deb {
            packages: Some(
                ".",
            ),
        },
    )
[2026-01-15T06:16:23Z DEBUG ambient_ci::action] RunnableAction::execute: self=Deb(
        Deb {
            packages: Some(
                ".",
            ),
        },
    )
[2026-01-15T06:16:23Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/ci/cache/cargo-target",
            "CARGO_HOME": "/ci/deps",
            "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
            "HOME": "/root",
        },
        source_dir: "/ci/src",
        deps_dir: "/ci/deps",
        artifacts_dir: "/ci/artifacts",
    }
SPAWN: argv=["/bin/bash", "-c", "#!/usr/bin/env bash\nset -xeuo pipefail\n\necho \"PATH at start: $PATH\"\nexport PATH=\"/root/.cargo/bin:$PATH\"\nexport CARGO_HOME=/workspace/deps\nexport DEBEMAIL=liw@liw.fi\nexport DEBFULLNAME=\"Lars Wirzenius\"\n/bin/env\n\ncommand -v cargo\ncommand -v rustc\n\ncargo --version\nrustc --version\n\n# Get name and version of source package.\nname=\"$(dpkg-parsechangelog -SSource)\"\nversion=\"$(dpkg-parsechangelog -SVersion)\"\n\n# Get upstream version: everything before the last dash.\nuv=\"$(echo \"$version\" | sed 's/-[^-]*$//')\"\n\n# Files that will be created.\narch=\"$(dpkg --print-architecture)\"\norig=\"../${name}_${uv}.orig.tar.xz\"\ndeb=\"../${name}_${version}_${arch}.deb\"\nchanges=\"../${name}_${version}_${arch}.changes\"\n\n# Create \"upstream tarball\".\ngit archive HEAD | xz >\"$orig\"\n\n# Build package.\ndpkg-buildpackage -us -uc\n\n# Dump some information to make it easier to visually verify\n# everything looks OK. Also, test the package with the lintian tool.\n\nls -l ..\nfor x in ../*.deb; do dpkg -c \"$x\"; done\n# FIXME: disabled while this prevents radicle-native-ci deb from being built.\n# lintian -i --allow-root --fail-on warning ../*.changes\n\n# Move files to artifacts directory.\nmv ../*_* /ci/artifacts/.\n        "]
       cwd=/ci/src (exists? true)
+ echo 'PATH at start: /root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin'
PATH at start: /root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
+ export PATH=/root/.cargo/bin:/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
+ PATH=/root/.cargo/bin:/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
+ export CARGO_HOME=/workspace/deps
+ CARGO_HOME=/workspace/deps
+ export DEBEMAIL=liw@liw.fi
+ DEBEMAIL=liw@liw.fi
+ export 'DEBFULLNAME=Lars Wirzenius'
+ DEBFULLNAME='Lars Wirzenius'
+ /bin/env
DEBFULLNAME=Lars Wirzenius
CARGO_TARGET_DIR=/ci/cache/cargo-target
PWD=/ci/src
SYSTEMD_EXEC_PID=293
HOME=/root
LANG=C.UTF-8
CARGO_HOME=/workspace/deps
DEBEMAIL=liw@liw.fi
INVOCATION_ID=4d9847fd11d64c059d977efe5cefa98b
SHLVL=2
JOURNAL_STREAM=8:13424
PATH=/root/.cargo/bin:/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
OLDPWD=/
_=/bin/env
+ command -v cargo
/root/.cargo/bin/cargo
+ command -v rustc
/root/.cargo/bin/rustc
+ cargo --version
cargo 1.92.0 (344c4567c 2025-10-21)
+ rustc --version
rustc 1.92.0 (ded5c06cf 2025-12-08)
++ dpkg-parsechangelog -SSource
+ name=obnam
++ dpkg-parsechangelog -SVersion
+ version=0.9.9.ci20260115T061622-1
++ sed 's/-[^-]*$//'
++ echo 0.9.9.ci20260115T061622-1
+ uv=0.9.9.ci20260115T061622
++ dpkg --print-architecture
+ arch=amd64
+ orig=../obnam_0.9.9.ci20260115T061622.orig.tar.xz
+ deb=../obnam_0.9.9.ci20260115T061622-1_amd64.deb
+ changes=../obnam_0.9.9.ci20260115T061622-1_amd64.changes
+ xz
+ git archive HEAD
+ dpkg-buildpackage -us -uc
dpkg-buildpackage: info: source package obnam
dpkg-buildpackage: info: source version 0.9.9.ci20260115T061622-1
dpkg-buildpackage: info: source distribution unstable
dpkg-buildpackage: info: source changed by "Lars Wirzenius" <"liw@liw.fi">
dpkg-buildpackage: info: host architecture amd64
 dpkg-source --before-build .
 debian/rules clean
dh clean
   dh_auto_clean
   dh_clean
 dpkg-source -b .
dpkg-source: info: using source format '3.0 (quilt)'
dpkg-source: info: building obnam using existing ./obnam_0.9.9.ci20260115T061622.orig.tar.xz
dpkg-source: info: building obnam in obnam_0.9.9.ci20260115T061622-1.debian.tar.xz
dpkg-source: info: building obnam in obnam_0.9.9.ci20260115T061622-1.dsc
 debian/rules build
dh build
   dh_update_autotools_config
   dh_autoreconf
   dh_auto_configure
   debian/rules override_dh_auto_build
make[1]: Entering directory '/ci/src'
true
make[1]: Leaving directory '/ci/src'
   debian/rules override_dh_auto_test
make[1]: Entering directory '/ci/src'
echo tests are disabled, for now
tests are disabled, for now
make[1]: Leaving directory '/ci/src'
   create-stamp debian/debhelper-build-stamp
 debian/rules binary
dh binary
   dh_testroot
   dh_prep
   debian/rules override_dh_auto_install
make[1]: Entering directory '/ci/src'
cargo install --offline --locked --path=. --root=debian/obnam/usr
  Installing obnam v0.10.0 (/ci/src)
   Compiling libc v0.2.177
   Compiling cfg-if v1.0.4
   Compiling proc-macro2 v1.0.103
   Compiling quote v1.0.42
   Compiling unicode-ident v1.0.22
   Compiling syn v2.0.110
   Compiling version_check v0.9.5
   Compiling typenum v1.19.0
   Compiling generic-array v0.14.7
   Compiling serde_core v1.0.228
   Compiling getrandom v0.2.16
   Compiling rand_core v0.6.4
   Compiling crypto-common v0.1.7
   Compiling bitflags v2.10.0
   Compiling memchr v2.7.6
   Compiling rustix v1.1.2
   Compiling serde v1.0.228
   Compiling linux-raw-sys v0.11.0
   Compiling serde_derive v1.0.228
   Compiling semver v1.0.27
   Compiling getrandom v0.3.4
   Compiling thiserror v2.0.17
   Compiling utf8parse v0.2.2
   Compiling anstyle-parse v0.2.7
   Compiling rustc_version v0.4.1
   Compiling aho-corasick v1.1.4
   Compiling thiserror-impl v2.0.17
   Compiling inout v0.1.4
   Compiling scopeguard v1.2.0
   Compiling anstyle v1.0.13
   Compiling time-core v0.1.6
   Compiling is_terminal_polyfill v1.70.2
   Compiling num-conv v0.1.0
   Compiling pkg-config v0.3.32
   Compiling vcpkg v0.2.15
   Compiling regex-syntax v0.8.8
   Compiling powerfmt v0.2.0
   Compiling anstyle-query v1.1.5
   Compiling colorchoice v1.0.4
   Compiling anstream v0.6.21
   Compiling deranged v0.5.5
   Compiling regex-automata v0.4.13
   Compiling libsqlite3-sys v0.35.0
   Compiling time-macros v0.2.24
   Compiling lock_api v0.4.14
   Compiling cipher v0.4.4
   Compiling heapless v0.7.17
   Compiling hashbrown v0.16.0
   Compiling foldhash v0.1.5
   Compiling subtle v2.6.1
   Compiling ryu v1.0.20
   Compiling crc32fast v1.5.0
   Compiling equivalent v1.0.2
   Compiling serde_json v1.0.145
   Compiling winnow v0.7.13
   Compiling cpufeatures v0.2.17
   Compiling itoa v1.0.15
   Compiling byteorder v1.5.0
   Compiling time v0.3.44
   Compiling hash32 v0.2.1
   Compiling toml_parser v1.0.4
   Compiling indexmap v2.12.0
   Compiling universal-hash v0.5.1
   Compiling hashbrown v0.15.5
   Compiling spin v0.9.8
   Compiling regex v1.12.2
   Compiling terminal_size v0.4.3
   Compiling serde_spanned v1.0.3
   Compiling toml_datetime v0.7.3
   Compiling dirs-sys-next v0.1.2
   Compiling fastrand v2.3.0
   Compiling opaque-debug v0.3.1
   Compiling clap_lex v0.7.6
   Compiling strsim v0.11.1
   Compiling simd-adler32 v0.3.7
   Compiling adler2 v2.0.1
   Compiling toml_writer v1.0.4
   Compiling once_cell v1.21.3
   Compiling stable_deref_trait v1.2.1
   Compiling heck v0.5.0
   Compiling unsafe-libyaml-norway v0.2.15
   Compiling log v0.4.28
   Compiling git-testament-derive v0.2.1
   Compiling serde_norway v0.9.42
   Compiling env_filter v0.1.4
   Compiling clap_derive v4.5.49
   Compiling toml v0.9.8
   Compiling tempfile v3.23.0
   Compiling miniz_oxide v0.8.9
   Compiling clap_builder v4.5.51
   Compiling polyval v0.6.2
   Compiling directories-next v2.0.0
   Compiling hashlink v0.10.0
   Compiling aes v0.8.4
   Compiling cobs v0.3.0
   Compiling ctr v0.9.2
   Compiling aead v0.5.2
   Compiling fallible-streaming-iterator v0.1.9
   Compiling smallvec v1.15.1
   Compiling fallible-iterator v0.3.0
   Compiling zeroize v1.8.2
   Compiling jiff v0.2.16
   Compiling aes-gcm-siv v0.11.1
   Compiling rusqlite v0.37.0
   Compiling env_logger v0.11.8
   Compiling postcard v1.1.3
   Compiling clingwrap v0.5.0
   Compiling flate2 v1.1.5
   Compiling clap v4.5.51
   Compiling git-testament v0.2.6
   Compiling uuid v1.18.1
   Compiling hostname v0.4.1
   Compiling mutants v0.0.3
   Compiling obnam v0.10.0 (/ci/src)
    Finished `release` profile [optimized] target(s) in 2m 07s
  Installing debian/obnam/usr/bin/obnam
   Installed package `obnam v0.10.0 (/ci/src)` (executable `obnam`)
warning: be sure to add `debian/obnam/usr/bin` to your PATH to be able to run the installed binaries
find debian -name '.crates*.*' -delete
make[1]: Leaving directory '/ci/src'
   dh_installdocs
   dh_installchangelogs
   dh_lintian
   dh_perl
   dh_link
   dh_strip_nondeterminism
   dh_compress
   dh_fixperms
   dh_missing
   dh_strip
   dh_makeshlibs
   dh_shlibdeps
   dh_installdeb
   dh_gencontrol
   dh_md5sums
   dh_builddeb
dpkg-deb: building package 'obnam' in '../obnam_0.9.9.ci20260115T061622-1_amd64.deb'.
dpkg-deb: building package 'obnam-dbgsym' in '../obnam-dbgsym_0.9.9.ci20260115T061622-1_amd64.deb'.
 dpkg-genbuildinfo -O../obnam_0.9.9.ci20260115T061622-1_amd64.buildinfo
 dpkg-genchanges -O../obnam_0.9.9.ci20260115T061622-1_amd64.changes
dpkg-genchanges: info: including full source code in upload
 dpkg-source --after-build .
dpkg-buildpackage: info: full upload (original source is included)
+ ls -l ..
total 1280
drwxr-xr-x 2 root root    4096 Jan 15 06:16 artifacts
drwxr-xr-x 6 root root    4096 Jan 15 06:14 cache
drwxr-xr-x 3 root root    4096 Jan 15 06:12 deps
-rw-r--r-- 1 root root  135848 Jan 15 06:18 obnam-dbgsym_0.9.9.ci20260115T061622-1_amd64.deb
-rw-r--r-- 1 root root    1716 Jan 15 06:16 obnam_0.9.9.ci20260115T061622-1.debian.tar.xz
-rw-r--r-- 1 root root     900 Jan 15 06:16 obnam_0.9.9.ci20260115T061622-1.dsc
-rw-r--r-- 1 root root    5651 Jan 15 06:18 obnam_0.9.9.ci20260115T061622-1_amd64.buildinfo
-rw-r--r-- 1 root root    2296 Jan 15 06:18 obnam_0.9.9.ci20260115T061622-1_amd64.changes
-rw-r--r-- 1 root root 1072820 Jan 15 06:18 obnam_0.9.9.ci20260115T061622-1_amd64.deb
-rw-r--r-- 1 root root   59684 Jan 15 06:16 obnam_0.9.9.ci20260115T061622.orig.tar.xz
drwxr-xr-x 8 root root    4096 Jan 15 06:16 src
+ for x in ../*.deb
+ dpkg -c ../obnam-dbgsym_0.9.9.ci20260115T061622-1_amd64.deb
drwxr-xr-x root/root         0 2026-01-15 06:16 ./
drwxr-xr-x root/root         0 2026-01-15 06:16 ./usr/
drwxr-xr-x root/root         0 2026-01-15 06:16 ./usr/lib/
drwxr-xr-x root/root         0 2026-01-15 06:16 ./usr/lib/debug/
drwxr-xr-x root/root         0 2026-01-15 06:16 ./usr/lib/debug/.build-id/
drwxr-xr-x root/root         0 2026-01-15 06:16 ./usr/lib/debug/.build-id/df/
-rw-r--r-- root/root    752472 2026-01-15 06:16 ./usr/lib/debug/.build-id/df/a95469928867f7f6e22f0422a420000c10cd6c.debug
drwxr-xr-x root/root         0 2026-01-15 06:16 ./usr/share/
drwxr-xr-x root/root         0 2026-01-15 06:16 ./usr/share/doc/
lrwxrwxrwx root/root         0 2026-01-15 06:16 ./usr/share/doc/obnam-dbgsym -> obnam
+ for x in ../*.deb
+ dpkg -c ../obnam_0.9.9.ci20260115T061622-1_amd64.deb
drwxr-xr-x root/root         0 2026-01-15 06:16 ./
drwxr-xr-x root/root         0 2026-01-15 06:16 ./usr/
drwxr-xr-x root/root         0 2026-01-15 06:16 ./usr/bin/
-rwxr-xr-x root/root   3472288 2026-01-15 06:16 ./usr/bin/obnam
drwxr-xr-x root/root         0 2026-01-15 06:16 ./usr/share/
drwxr-xr-x root/root         0 2026-01-15 06:16 ./usr/share/doc/
drwxr-xr-x root/root         0 2026-01-15 06:16 ./usr/share/doc/obnam/
-rw-r--r-- root/root       211 2026-01-15 06:16 ./usr/share/doc/obnam/changelog.Debian.gz
-rw-r--r-- root/root       371 2026-01-15 06:12 ./usr/share/doc/obnam/copyright
drwxr-xr-x root/root         0 2026-01-15 06:16 ./usr/share/lintian/
drwxr-xr-x root/root         0 2026-01-15 06:16 ./usr/share/lintian/overrides/
-rw-r--r-- root/root        48 2026-01-15 06:12 ./usr/share/lintian/overrides/obnam
+ mv ../obnam-dbgsym_0.9.9.ci20260115T061622-1_amd64.deb ../obnam_0.9.9.ci20260115T061622-1.debian.tar.xz ../obnam_0.9.9.ci20260115T061622-1.dsc ../obnam_0.9.9.ci20260115T061622-1_amd64.buildinfo ../obnam_0.9.9.ci20260115T061622-1_amd64.changes ../obnam_0.9.9.ci20260115T061622-1_amd64.deb ../obnam_0.9.9.ci20260115T061622.orig.tar.xz /ci/artifacts/.
[2026-01-15T06:18:41Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2026-01-15T06:18:41Z DEBUG ambient_ci::plan] RUN: Action TarCreate(
        TarCreate {
            archive: "/dev/vde",
            directory: "/ci/cache",
        },
    )
[2026-01-15T06:18:41Z DEBUG ambient_ci::action] RunnableAction::execute: self=TarCreate(
        TarCreate {
            archive: "/dev/vde",
            directory: "/ci/cache",
        },
    )
[2026-01-15T06:18:41Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/ci/cache/cargo-target",
            "CARGO_HOME": "/ci/deps",
            "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
            "HOME": "/root",
        },
        source_dir: "/ci/src",
        deps_dir: "/ci/deps",
        artifacts_dir: "/ci/artifacts",
    }
[2026-01-15T06:18:41Z TRACE ambient_ci::vdrive] creating virtual drive (tar archive): VirtualDriveBuilder {
        filename: Some(
            "/dev/vde",
        ),
        root: Some(
            "/ci/cache",
        ),
        size: None,
    }
[2026-01-15T06:18:41Z TRACE ambient_ci::vdrive] tar archive to be created: /dev/vde; exists? true
[2026-01-15T06:18:41Z TRACE ambient_ci::vdrive] create archive file /dev/vde
[2026-01-15T06:18:41Z TRACE ambient_ci::vdrive] directory /ci/cache exists? true
[2026-01-15T06:18:41Z TRACE ambient_ci::vdrive] add contents of /ci/cache as .
[2026-01-15T06:18:41Z TRACE ambient_ci::vdrive] calling tar_create
[2026-01-15T06:19:03Z TRACE ambient_ci::vdrive] created virtual drive /dev/vde
[2026-01-15T06:19:03Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2026-01-15T06:19:03Z DEBUG ambient_ci::plan] RUN: Action TarCreate(
        TarCreate {
            archive: "/dev/vdd",
            directory: "/ci/artifacts",
        },
    )
[2026-01-15T06:19:03Z DEBUG ambient_ci::action] RunnableAction::execute: self=TarCreate(
        TarCreate {
            archive: "/dev/vdd",
            directory: "/ci/artifacts",
        },
    )
[2026-01-15T06:19:03Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/ci/cache/cargo-target",
            "CARGO_HOME": "/ci/deps",
            "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
            "HOME": "/root",
        },
        source_dir: "/ci/src",
        deps_dir: "/ci/deps",
        artifacts_dir: "/ci/artifacts",
    }
[2026-01-15T06:19:03Z TRACE ambient_ci::vdrive] creating virtual drive (tar archive): VirtualDriveBuilder {
        filename: Some(
            "/dev/vdd",
        ),
        root: Some(
            "/ci/artifacts",
        ),
        size: None,
    }
[2026-01-15T06:19:03Z TRACE ambient_ci::vdrive] tar archive to be created: /dev/vdd; exists? true
[2026-01-15T06:19:03Z TRACE ambient_ci::vdrive] create archive file /dev/vdd
[2026-01-15T06:19:03Z TRACE ambient_ci::vdrive] directory /ci/artifacts exists? true
[2026-01-15T06:19:03Z TRACE ambient_ci::vdrive] add contents of /ci/artifacts as .
[2026-01-15T06:19:03Z TRACE ambient_ci::vdrive] calling tar_create
[2026-01-15T06:19:03Z TRACE ambient_ci::vdrive] created virtual drive /dev/vdd
[2026-01-15T06:19:03Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2026-01-15T06:19:03Z DEBUG ambient_ci::plan] All actions were performed successfully
ambient-execute-plan ends
EXIT CODE: 0

Trigger message

{
  "request": "trigger",
  "version": 1,
  "event_type": "push",
  "repository": {
    "id": "rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x",
    "name": "obnam",
    "description": "Explore implementation of backup fundamentals",
    "private": false,
    "default_branch": "main",
    "delegates": [
      "did:key:z6MkgEMYod7Hxfy9qCvDv5hYHkZ4ciWmLFgfvm3Wn1b2w2FV"
    ]
  },
  "pusher": {
    "id": "did:key:z6Mki2ago1X2A5UWgKpoSxyCRLLhyZMwpam4T3EKvRmFTyuy",
    "alias": "callisto.liw.fi"
  },
  "before": "34eb9651ccd940a0119d149a12c1aa27aa159d34",
  "after": "34eb9651ccd940a0119d149a12c1aa27aa159d34",
  "branch": "main",
  "commits": [
    "34eb9651ccd940a0119d149a12c1aa27aa159d34"
  ]
}

Ambient stdout

[2026-01-15T06:12:26Z INFO  ambient] ambient starts
[2026-01-15T06:12:26Z DEBUG ambient] load default configuration file /home/_rad/.config/ambient/config.yaml if it exists
deprecated: the `cpus` field is replaced by `qemu.cpus`
deprecated: the `memory` field is replaced by `qemu.memory`
[2026-01-15T06:12:26Z DEBUG ambient] complete configuration: Config {
        tmpdir: "/home/_rad/tmp",
        image_store: "/home/_rad/ambient-images",
        projects: "/dev/null",
        state: "/home/_rad/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(
            1000000000,
        ),
        cache_max_size: Byte(
            30000000000,
        ),
        qemu: QemuConfig {
            cpus: 2,
            memory: Byte(
                12000000000,
            ),
            kvm_binary: "/usr/bin/kvm",
            ovmf_vars_file: "/usr/share/ovmf/OVMF.fd",
            ovmf_code_file: "/usr/share/ovmf/OVMF.fd",
        },
        uefi: false,
        lint: true,
    }
[2026-01-15T06:12:26Z DEBUG ambient_ci::linter] linting project rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x with rsync_target
[2026-01-15T06:12:26Z DEBUG ambient_ci::linter] linting project rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x with http_get
[2026-01-15T06:12:26Z DEBUG ambient_ci::linter] linting project rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x with shellcheck
[2026-01-15T06:12:26Z DEBUG ambient_ci::project] load project state from /home/_rad/ambient-state/rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x/meta.yaml
[2026-01-15T06:12:26Z DEBUG ambient_ci::run] latest commit: "34eb9651ccd940a0119d149a12c1aa27aa159d34"
[2026-01-15T06:12:26Z DEBUG ambient_ci::run] is a git repository
[2026-01-15T06:12:26Z DEBUG ambient_ci::run] git repository is clean
[2026-01-15T06:12:26Z DEBUG ambient_ci::run] current (HEAD) commit: 34eb9651ccd940a0119d149a12c1aa27aa159d34
[2026-01-15T06:12:26Z DEBUG ambient_ci::run] no dry run requested
[2026-01-15T06:12:26Z DEBUG ambient_ci::run] forced run requested
[2026-01-15T06:12:26Z DEBUG ambient_ci::run] run? true
[2026-01-15T06:12:26Z INFO  ambient_ci::run] project rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x: running CI
[2026-01-15T06:12:26Z DEBUG ambient_ci::run] Construct runnable plans for pre-plan, plan, and post-plan
[2026-01-15T06:12:26Z DEBUG ambient_ci::run] Executing pre-plan steps
[2026-01-15T06:12:26Z DEBUG ambient_ci::plan] RUN: Action CargoFetch(
        CargoFetch,
    )
[2026-01-15T06:12:26Z DEBUG ambient_ci::action] RunnableAction::execute: self=CargoFetch(
        CargoFetch,
    )
[2026-01-15T06:12:26Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/home/_rad/ambient-state/rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x/cache/cargo-target",
            "CARGO_HOME": "/home/_rad/ambient-state/rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x/dependencies",
            "PATH": "/root/.cargo/bin:/bin:/home/_rad/.radicle/bin:/home/_rad/.cargo/bin",
        },
        source_dir: "/tmp/.tmpvz9Pyw/src",
        deps_dir: "/home/_rad/ambient-state/rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x/dependencies",
        artifacts_dir: "/home/_rad/ambient-state/rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x/artifacts",
    }
SPAWN: argv=["cargo", "--version"]
       cwd=/tmp/.tmpvz9Pyw/src (exists? true)
cargo 1.92.0 (344c4567c 2025-10-21)
SPAWN: argv=["cargo", "clippy", "--version"]
       cwd=/tmp/.tmpvz9Pyw/src (exists? true)
clippy 0.1.92 (ded5c06cf2 2025-12-08)
SPAWN: argv=["rustc", "--version"]
       cwd=/tmp/.tmpvz9Pyw/src (exists? true)
rustc 1.92.0 (ded5c06cf 2025-12-08)
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] copy_partial_tree: /tmp/.tmpvz9Pyw/src => /tmp/.tmpMV56ni
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/src wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/src/util.rs wanted=true
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] copy_partial_tree: copy /tmp/.tmpvz9Pyw/src/src/util.rs => /tmp/.tmpMV56ni/src/util.rs
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/src/store.rs wanted=true
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] copy_partial_tree: copy /tmp/.tmpvz9Pyw/src/src/store.rs => /tmp/.tmpMV56ni/src/store.rs
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/src/sop.rs wanted=true
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] copy_partial_tree: copy /tmp/.tmpvz9Pyw/src/src/sop.rs => /tmp/.tmpMV56ni/src/sop.rs
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/src/plaintext.rs wanted=true
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] copy_partial_tree: copy /tmp/.tmpvz9Pyw/src/src/plaintext.rs => /tmp/.tmpMV56ni/src/plaintext.rs
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/src/lib.rs wanted=true
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] copy_partial_tree: copy /tmp/.tmpvz9Pyw/src/src/lib.rs => /tmp/.tmpMV56ni/src/lib.rs
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/src/credential.rs wanted=true
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] copy_partial_tree: copy /tmp/.tmpvz9Pyw/src/src/credential.rs => /tmp/.tmpMV56ni/src/credential.rs
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/src/config.rs wanted=true
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] copy_partial_tree: copy /tmp/.tmpvz9Pyw/src/src/config.rs => /tmp/.tmpMV56ni/src/config.rs
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/src/client.rs wanted=true
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] copy_partial_tree: copy /tmp/.tmpvz9Pyw/src/src/client.rs => /tmp/.tmpMV56ni/src/client.rs
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/src/cipher.rs wanted=true
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] copy_partial_tree: copy /tmp/.tmpvz9Pyw/src/src/cipher.rs => /tmp/.tmpMV56ni/src/cipher.rs
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/src/chunk.rs wanted=true
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] copy_partial_tree: copy /tmp/.tmpvz9Pyw/src/src/chunk.rs => /tmp/.tmpMV56ni/src/chunk.rs
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/src/bin wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/src/bin/obnam.rs wanted=true
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] copy_partial_tree: copy /tmp/.tmpvz9Pyw/src/src/bin/obnam.rs => /tmp/.tmpMV56ni/src/bin/obnam.rs
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/src/bin/cmd wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/src/bin/cmd/store.rs wanted=true
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] copy_partial_tree: copy /tmp/.tmpvz9Pyw/src/src/bin/cmd/store.rs => /tmp/.tmpMV56ni/src/bin/cmd/store.rs
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/src/bin/cmd/sop.rs wanted=true
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] copy_partial_tree: copy /tmp/.tmpvz9Pyw/src/src/bin/cmd/sop.rs => /tmp/.tmpMV56ni/src/bin/cmd/sop.rs
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/src/bin/cmd/mod.rs wanted=true
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] copy_partial_tree: copy /tmp/.tmpvz9Pyw/src/src/bin/cmd/mod.rs => /tmp/.tmpMV56ni/src/bin/cmd/mod.rs
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/src/bin/cmd/credential.rs wanted=true
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] copy_partial_tree: copy /tmp/.tmpvz9Pyw/src/src/bin/cmd/credential.rs => /tmp/.tmpMV56ni/src/bin/cmd/credential.rs
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/src/bin/cmd/client.rs wanted=true
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] copy_partial_tree: copy /tmp/.tmpvz9Pyw/src/src/bin/cmd/client.rs => /tmp/.tmpMV56ni/src/bin/cmd/client.rs
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/src/bin/cmd/chunk.rs wanted=true
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] copy_partial_tree: copy /tmp/.tmpvz9Pyw/src/src/bin/cmd/chunk.rs => /tmp/.tmpMV56ni/src/bin/cmd/chunk.rs
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/obnam.yaml wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/obnam.subplot wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/obnam.py wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/obnam.md wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/obnam.1 wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/doc wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/doc/keys.svg wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/doc/keys.pik wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/doc/glossary.md wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/doc/arch.md wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/doc/Makefile wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/debian wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/debian/source wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/debian/source/format wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/debian/rules wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/debian/lintian-overrides wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/debian/copyright wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/debian/control wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/debian/compat wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/debian/changelog wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/debian/cargo-checksum.json wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/debian/build-deb wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/README.md wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/Makefile wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/LICENSE-MIT wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/LICENSE-APACHE wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/GETTING_STARTED.md wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/Cargo.toml wanted=true
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] copy_partial_tree: copy /tmp/.tmpvz9Pyw/src/Cargo.toml => /tmp/.tmpMV56ni/Cargo.toml
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/Cargo.lock wanted=true
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] copy_partial_tree: copy /tmp/.tmpvz9Pyw/src/Cargo.lock => /tmp/.tmpMV56ni/Cargo.lock
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/COPYING.md wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.radicle wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.radicle/ambient.yaml wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.gitignore wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.ambient wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.ambient/dch wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/index wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/HEAD wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/config wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/logs wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/logs/HEAD wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/logs/refs wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/logs/refs/heads wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/logs/refs/heads/main wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/logs/refs/remotes wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/logs/refs/remotes/origin wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/logs/refs/remotes/origin/HEAD wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/packed-refs wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/refs wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/refs/remotes wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/refs/remotes/origin wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/refs/remotes/origin/HEAD wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/refs/tags wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/refs/heads wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/refs/heads/main wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/13 wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/13/69cbccadb6df76d33c173a34cbf9e254aef772 wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/30 wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/30/c0ed619d6b808eff31f4649b9c9b9ac0adf65c wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/30/d79ae264d52a780a1e8d27c6cd7f41140879b9 wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/26 wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/26/bafe2e7d40721a4ec228a58517246a10a5a073 wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/b9 wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/b9/83aeea45f4d980e7fe265fc269cfb1c40fce4f wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/a3 wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/a3/6b803d185f2c7096e0e2569a49288b9620d9c9 wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/a3/83de6c2b71fa94ff7433258971ed04bccb3f96 wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/9a wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/9a/e035bed68927dd5c1b71502555ade49b2fa837 wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/5d wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/5d/f9f7dcd856e235be6cebd195ce7a6551ac4fe7 wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/29 wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/29/2db90ebb6f93abcddc9bfbcb600a9d64bf8e93 wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/dc wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/dc/0ad63d2d8037d1df544adb3bdc6b4048aaf416 wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/ec wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/ec/5561ebfb3f5d1475e15ed86caf2880c19501dc wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/6b wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/6b/68b50557f9f7e6bc389a93f8b7249b2f28f383 wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/0a wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/0a/9bd209f71f582b165fa636cc782b3222064885 wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/info wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/info/commit-graph wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/info/packs wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-855d15f15c82630483ed0631325791afcc61653e.idx wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-8e8d55215437e235318c917d600fa1c8f3e5dce4.idx wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-7d6bf350dc49aab05fa33e9b1a447bb7c448cc66.idx wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-d594bca06113e1262eade6dccd51d673d7d7869e.idx wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-166b2de879ad2d8c5b65e40514d84e28f1075c93.pack wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-c4c3ed29ffedaa02f51974942bd3061c769fc4e1.pack wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-df4a211637b8c8fa149f683c62e10f8a450cee0f.pack wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-62a83bfa52d22c96d86f5509ab65116735a4aa0d.idx wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-782821953a6a2f7e5d854b75c92215323fea3638.idx wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-dcdbb138c6b0ac62f8eafd9738d2a462e5d84e39.idx wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-df4a211637b8c8fa149f683c62e10f8a450cee0f.idx wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-eca704fb61992bd3e7feeca7a5f9a2e75541c719.idx wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-8e8d55215437e235318c917d600fa1c8f3e5dce4.bitmap wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-347fe2f8a09dded87513ed492d7342078aaefc47.pack wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-9a69350f59af2fa15216acd9021abafb059d1b8d.pack wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-347fe2f8a09dded87513ed492d7342078aaefc47.idx wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-8e8d55215437e235318c917d600fa1c8f3e5dce4.pack wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-32db34e874be9c18f54c6e5cdd7cefb35f93f1bc.idx wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-c7b598ecdab636cd6d9b4b8c02c00502d9eb2ed1.idx wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-9a69350f59af2fa15216acd9021abafb059d1b8d.idx wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-32db34e874be9c18f54c6e5cdd7cefb35f93f1bc.pack wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-c2fb0c240fd571cf9a65efaf3f6b7b13a4469660.pack wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-c4c3ed29ffedaa02f51974942bd3061c769fc4e1.idx wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-c438c4049d36898ef0014ddc6666503b41be054d.idx wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-c7b598ecdab636cd6d9b4b8c02c00502d9eb2ed1.pack wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-166b2de879ad2d8c5b65e40514d84e28f1075c93.idx wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-eca704fb61992bd3e7feeca7a5f9a2e75541c719.pack wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-dcdbb138c6b0ac62f8eafd9738d2a462e5d84e39.pack wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-855d15f15c82630483ed0631325791afcc61653e.pack wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-782821953a6a2f7e5d854b75c92215323fea3638.pack wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-c2fb0c240fd571cf9a65efaf3f6b7b13a4469660.idx wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-7d6bf350dc49aab05fa33e9b1a447bb7c448cc66.pack wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-d594bca06113e1262eade6dccd51d673d7d7869e.pack wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-62a83bfa52d22c96d86f5509ab65116735a4aa0d.pack wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-8e8d55215437e235318c917d600fa1c8f3e5dce4.rev wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/objects/pack/pack-c438c4049d36898ef0014ddc6666503b41be054d.pack wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/branches wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/hooks wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/hooks/update.sample wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/hooks/commit-msg.sample wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/hooks/applypatch-msg.sample wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/hooks/pre-merge-commit.sample wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/hooks/post-update.sample wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/hooks/pre-push.sample wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/hooks/pre-rebase.sample wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/hooks/push-to-checkout.sample wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/hooks/prepare-commit-msg.sample wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/hooks/fsmonitor-watchman.sample wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/hooks/pre-commit.sample wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/hooks/pre-receive.sample wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/hooks/sendemail-validate.sample wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/hooks/pre-applypatch.sample wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/description wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/info wanted=false
[2026-01-15T06:12:26Z DEBUG ambient_ci::action_impl::cargo] path=/tmp/.tmpvz9Pyw/src/.git/info/exclude wanted=false
SPAWN: argv=["cargo", "fetch", "--locked"]
       cwd=/tmp/.tmpMV56ni (exists? true)
[2026-01-15T06:12:27Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2026-01-15T06:12:27Z DEBUG ambient_ci::plan] All actions were performed successfully
[2026-01-15T06:12:27Z DEBUG ambient_ci::run] Executing plan steps
[2026-01-15T06:12:27Z DEBUG ambient_ci::vdrive] create virtual drive /home/_rad/tmp/.tmpojlDBZ/src.tar
[2026-01-15T06:12:27Z DEBUG ambient_ci::vdrive] create virtual drive /home/_rad/tmp/.tmpojlDBZ/deps.tar
[2026-01-15T06:12:29Z DEBUG ambient_ci::run] create_executor_vdrive: executor="/usr/bin/ambient-execute-plan"
[2026-01-15T06:12:29Z DEBUG ambient_ci::run] create_executor_vdrive: plan=RunnablePlan {
        steps: [
            Mkdir(
                Mkdir {
                    pathname: "/ci",
                },
            ),
            Mkdir(
                Mkdir {
                    pathname: "/ci/artifacts",
                },
            ),
            TarExtract(
                TarExtract {
                    archive: "/dev/vdc",
                    directory: "/ci/src",
                },
            ),
            TarExtract(
                TarExtract {
                    archive: "/dev/vdf",
                    directory: "/ci/deps",
                },
            ),
            TarExtract(
                TarExtract {
                    archive: "/dev/vde",
                    directory: "/ci/cache",
                },
            ),
            Shell(
                Shell {
                    shell: "ln -sf /ci /workspace",
                },
            ),
            Shell(
                Shell {
                    shell: "git config --global user.name 'Ambient CI'",
                },
            ),
            Shell(
                Shell {
                    shell: "git config --global user.email ambient@example.com",
                },
            ),
            CargoClippy(
                CargoClippy,
            ),
            CargoBuild(
                CargoBuild,
            ),
            CargoTest(
                CargoTest,
            ),
            Shell(
                Shell {
                    shell: "export PATH=/root/.cargo/bin:/bin:/sbin\nexport CARGO_TARGET_DIR=/workspace/cache\nmake subplot doc\nfind doc -ls\ncp obnam.html doc/*.html /workspace/artifacts\n",
                },
            ),
            Custom(
                Custom {
                    name: "dch",
                    args: {
                        "debemail": String("liw@liw.fi"),
                        "debfullname": String("Lars Wirzenius"),
                    },
                },
            ),
            Deb(
                Deb {
                    packages: Some(
                        ".",
                    ),
                },
            ),
            TarCreate(
                TarCreate {
                    archive: "/dev/vde",
                    directory: "/ci/cache",
                },
            ),
            TarCreate(
                TarCreate {
                    archive: "/dev/vdd",
                    directory: "/ci/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(
            "/ci",
        ),
        source_dir: Some(
            "/ci/src",
        ),
        deps_dir: Some(
            "/ci/deps",
        ),
        cache_dir: Some(
            "/ci/cache",
        ),
        artifacts_dir: Some(
            "/ci/artifacts",
        ),
    }
[2026-01-15T06:12:29Z DEBUG ambient_ci::run] executor bin /usr/bin/ambient-execute-plan
[2026-01-15T06:12:29Z DEBUG ambient_ci::run] copying /usr/bin/ambient-execute-plan to /home/_rad/tmp/.tmpojlDBZ/ambient-execute-plan/run-ci
[2026-01-15T06:12:29Z DEBUG ambient_ci::run] copy OK: true
[2026-01-15T06:12:29Z DEBUG ambient_ci::vdrive] create virtual drive /home/_rad/tmp/.tmpojlDBZ/executor.tar
[2026-01-15T06:12:44Z DEBUG ambient_ci::project] removing run log file /home/_rad/ambient-state/rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x/run.log
[2026-01-15T06:12:44Z DEBUG ambient_ci::project] statedir is /home/_rad/ambient-state/rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x, exists? true
[2026-01-15T06:12:44Z DEBUG ambient_ci::project] creating run log file /home/_rad/ambient-state/rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x/run.log
[2026-01-15T06:12:44Z DEBUG ambient_ci::project] created run log file /home/_rad/ambient-state/rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x/run.log OK
[2026-01-15T06:12:44Z DEBUG ambient_ci::cloud_init] with_hostname called: "ambient"
[2026-01-15T06:12:44Z DEBUG ambient_ci::cloud_init] with_runcmd called: "echo xyzzy > /dev/ttyS1"
[2026-01-15T06:12:44Z 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"
[2026-01-15T06:12:44Z DEBUG ambient_ci::cloud_init] with_runcmd called: "poweroff"
[2026-01-15T06:12:44Z DEBUG ambient_ci::cloud_init] with_network called: false
[2026-01-15T06:12:44Z 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",
        ],
    }
[2026-01-15T06:12:44Z DEBUG ambient_ci::qemu] run QEMU
[2026-01-15T06:12:44Z DEBUG ambient_ci::qemu] create copy-on-write image and UEFI vars file
[2026-01-15T06:12:44Z DEBUG ambient_ci::qemu_utils] qemu-img create /home/_rad/tmp/.tmpOJb137/.tmpeuI1Ug/vm.qcow2 backing on /home/_rad/ambient.qcow2
[2026-01-15T06:12:44Z DEBUG ambient_ci::qemu] create cloud-init ISO file
[2026-01-15T06:12:44Z 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",
        ],
    }
[2026-01-15T06:12:44Z DEBUG ambient_ci::cloud_init] write /tmp/.tmp8KxtiR/meta-data
[2026-01-15T06:12:44Z DEBUG ambient_ci::cloud_init] write /tmp/.tmp8KxtiR/user-data
[2026-01-15T06:12:44Z DEBUG ambient_ci::cloud_init] write /tmp/.tmp8KxtiR/network-config
[2026-01-15T06:12:45Z DEBUG ambient_ci::qemu] set console log file to /home/_rad/tmp/.tmpOJb137/.tmpeuI1Ug/console.log
[2026-01-15T06:12:45Z DEBUG ambient_ci::util] create file /home/_rad/tmp/.tmpOJb137/.tmpeuI1Ug/console.log
[2026-01-15T06:12:45Z DEBUG ambient_ci::qemu] set run file to /home/_rad/ambient-state/rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x/run.log
[2026-01-15T06:12:45Z DEBUG ambient_ci::util] create file /home/_rad/ambient-state/rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x/run.log
[2026-01-15T06:12:45Z DEBUG ambient_ci::qemu] run QEMU: QemuArgs {
        args: [
            "-m",
            "11444",
            "-smp",
            "cpus=2",
            "-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:/home/_rad/tmp/.tmpOJb137/.tmpeuI1Ug/console.log",
            "-serial",
            "file:/home/_rad/ambient-state/rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x/run.log",
            "-drive",
            "format=qcow2,if=virtio,file=/home/_rad/tmp/.tmpOJb137/.tmpeuI1Ug/vm.qcow2",
            "-drive",
            "format=raw,if=virtio,file=/home/_rad/tmp/.tmpojlDBZ/executor.tar,readonly=on",
            "-cdrom",
            "/home/_rad/tmp/.tmpOJb137/.tmpeuI1Ug/cloud_init.iso",
            "-drive",
            "if=pflash,format=raw,unit=0,file=/usr/share/ovmf/OVMF.fd,readonly=on",
            "-drive",
            "if=pflash,format=raw,unit=1,file=/home/_rad/tmp/.tmpOJb137/.tmpeuI1Ug/vars.fd",
            "-drive",
            "format=raw,if=virtio,file=/home/_rad/tmp/.tmpojlDBZ/src.tar,readonly=on",
            "-drive",
            "format=raw,if=virtio,file=/home/_rad/tmp/.tmpojlDBZ/artifacts.tar",
            "-drive",
            "format=raw,if=virtio,file=/home/_rad/tmp/.tmpojlDBZ/cache.tar",
            "-drive",
            "format=raw,if=virtio,file=/home/_rad/tmp/.tmpojlDBZ/deps.tar,readonly=on",
            "-nodefaults",
            "-no-user-config",
        ],
    }
[2026-01-15T06:19:07Z DEBUG ambient_ci::qemu] QEMU finished OK
[2026-01-15T06:19:07Z DEBUG ambient_ci::qemu] run log:
    --------------------==========
    [2026-01-15T06:12:51Z TRACE ambient_execute_plan] ambient-execute-plan version 0.11.1@d7192bd starts
    [2026-01-15T06:12:51Z DEBUG ambient_execute_plan] ambient-execute-plan version 0.11.1@d7192bd starts
    [2026-01-15T06:12:51Z INFO  ambient_execute_plan] ambient-execute-plan version 0.11.1@d7192bd starts
    [2026-01-15T06:12:51Z WARN  ambient_execute_plan] ambient-execute-plan version 0.11.1@d7192bd starts
    [2026-01-15T06:12:51Z ERROR ambient_execute_plan] ambient-execute-plan version 0.11.1@d7192bd starts
    [2026-01-15T06:12:51Z TRACE ambient_ci::plan] RunnablePlan::from_file: filename=plan.yaml
        steps:
        - action: mkdir
          pathname: /ci
        - action: mkdir
          pathname: /ci/artifacts
        - action: tar_extract
          archive: /dev/vdc
          directory: /ci/src
        - action: tar_extract
          archive: /dev/vdf
          directory: /ci/deps
        - action: tar_extract
          archive: /dev/vde
          directory: /ci/cache
        - action: shell
          shell: ln -sf /ci /workspace
        - action: shell
          shell: git config --global user.name 'Ambient CI'
        - action: shell
          shell: git config --global user.email ambient@example.com
        - 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 doc
            find doc -ls
            cp obnam.html doc/*.html /workspace/artifacts
        - action: custom
          name: dch
          args:
            debemail: liw@liw.fi
            debfullname: Lars Wirzenius
        - action: deb
          packages: .
        - action: tar_create
          archive: /dev/vde
          directory: /ci/cache
        - action: tar_create
          archive: /dev/vdd
          directory: /ci/artifacts
        executor_drive: /dev/vdb
        source_drive: /dev/vdc
        artifact_drive: /dev/vdd
        cache_drive: /dev/vde
        deps_drive: /dev/vdf
        workspace_dir: /ci
        source_dir: /ci/src
        deps_dir: /ci/deps
        cache_dir: /ci/cache
        artifacts_dir: /ci/artifacts
        
        
    [2026-01-15T06:12:51Z DEBUG ambient_ci::plan] RUN: Action Mkdir(
            Mkdir {
                pathname: "/ci",
            },
        )
    [2026-01-15T06:12:51Z DEBUG ambient_ci::action] RunnableAction::execute: self=Mkdir(
            Mkdir {
                pathname: "/ci",
            },
        )
    [2026-01-15T06:12:51Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
            envs: {
                "CARGO_TARGET_DIR": "/ci/cache/cargo-target",
                "CARGO_HOME": "/ci/deps",
                "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
                "HOME": "/root",
            },
            source_dir: "/ci/src",
            deps_dir: "/ci/deps",
            artifacts_dir: "/ci/artifacts",
        }
    [2026-01-15T06:12:51Z DEBUG ambient_ci::plan] RUN: Action finished OK
    [2026-01-15T06:12:51Z DEBUG ambient_ci::plan] RUN: Action Mkdir(
            Mkdir {
                pathname: "/ci/artifacts",
            },
        )
    [2026-01-15T06:12:51Z DEBUG ambient_ci::action] RunnableAction::execute: self=Mkdir(
            Mkdir {
                pathname: "/ci/artifacts",
            },
        )
    [2026-01-15T06:12:51Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
            envs: {
                "CARGO_TARGET_DIR": "/ci/cache/cargo-target",
                "CARGO_HOME": "/ci/deps",
                "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
                "HOME": "/root",
            },
            source_dir: "/ci/src",
            deps_dir: "/ci/deps",
            artifacts_dir: "/ci/artifacts",
        }
    [2026-01-15T06:12:51Z DEBUG ambient_ci::plan] RUN: Action finished OK
    [2026-01-15T06:12:51Z DEBUG ambient_ci::plan] RUN: Action TarExtract(
            TarExtract {
                archive: "/dev/vdc",
                directory: "/ci/src",
            },
        )
    [2026-01-15T06:12:51Z DEBUG ambient_ci::action] RunnableAction::execute: self=TarExtract(
            TarExtract {
                archive: "/dev/vdc",
                directory: "/ci/src",
            },
        )
    [2026-01-15T06:12:51Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
            envs: {
                "CARGO_TARGET_DIR": "/ci/cache/cargo-target",
                "CARGO_HOME": "/ci/deps",
                "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
                "HOME": "/root",
            },
            source_dir: "/ci/src",
            deps_dir: "/ci/deps",
            artifacts_dir: "/ci/artifacts",
        }
    [2026-01-15T06:12:51Z TRACE ambient_ci::vdrive] extracting /dev/vdc to /ci/src
    [2026-01-15T06:12:51Z TRACE ambient_ci::vdrive] extraction OK
    [2026-01-15T06:12:51Z DEBUG ambient_ci::plan] RUN: Action finished OK
    [2026-01-15T06:12:51Z DEBUG ambient_ci::plan] RUN: Action TarExtract(
            TarExtract {
                archive: "/dev/vdf",
                directory: "/ci/deps",
            },
        )
    [2026-01-15T06:12:51Z DEBUG ambient_ci::action] RunnableAction::execute: self=TarExtract(
            TarExtract {
                archive: "/dev/vdf",
                directory: "/ci/deps",
            },
        )
    [2026-01-15T06:12:51Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
            envs: {
                "CARGO_TARGET_DIR": "/ci/cache/cargo-target",
                "CARGO_HOME": "/ci/deps",
                "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
                "HOME": "/root",
            },
            source_dir: "/ci/src",
            deps_dir: "/ci/deps",
            artifacts_dir: "/ci/artifacts",
        }
    [2026-01-15T06:12:51Z TRACE ambient_ci::vdrive] extracting /dev/vdf to /ci/deps
    [2026-01-15T06:12:56Z TRACE ambient_ci::vdrive] extraction OK
    [2026-01-15T06:12:56Z DEBUG ambient_ci::plan] RUN: Action finished OK
    [2026-01-15T06:12:56Z DEBUG ambient_ci::plan] RUN: Action TarExtract(
            TarExtract {
                archive: "/dev/vde",
                directory: "/ci/cache",
            },
        )
    [2026-01-15T06:12:56Z DEBUG ambient_ci::action] RunnableAction::execute: self=TarExtract(
            TarExtract {
                archive: "/dev/vde",
                directory: "/ci/cache",
            },
        )
    [2026-01-15T06:12:56Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
            envs: {
                "CARGO_TARGET_DIR": "/ci/cache/cargo-target",
                "CARGO_HOME": "/ci/deps",
                "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
                "HOME": "/root",
            },
            source_dir: "/ci/src",
            deps_dir: "/ci/deps",
            artifacts_dir: "/ci/artifacts",
        }
    [2026-01-15T06:12:56Z TRACE ambient_ci::vdrive] extracting /dev/vde to /ci/cache
    [2026-01-15T06:13:59Z TRACE ambient_ci::vdrive] extraction OK
    [2026-01-15T06:13:59Z DEBUG ambient_ci::plan] RUN: Action finished OK
    [2026-01-15T06:13:59Z DEBUG ambient_ci::plan] RUN: Action Shell(
            Shell {
                shell: "ln -sf /ci /workspace",
            },
        )
    [2026-01-15T06:13:59Z DEBUG ambient_ci::action] RunnableAction::execute: self=Shell(
            Shell {
                shell: "ln -sf /ci /workspace",
            },
        )
    [2026-01-15T06:13:59Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
            envs: {
                "CARGO_TARGET_DIR": "/ci/cache/cargo-target",
                "CARGO_HOME": "/ci/deps",
                "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
                "HOME": "/root",
            },
            source_dir: "/ci/src",
            deps_dir: "/ci/deps",
            artifacts_dir: "/ci/artifacts",
        }
    SPAWN: argv=["bash", "-c", "set -xeuo pipefail\nln -sf /ci /workspace\n"]
           cwd=/ci/src (exists? true)
    + ln -sf /ci /workspace
    [2026-01-15T06:13:59Z DEBUG ambient_ci::plan] RUN: Action finished OK
    [2026-01-15T06:13:59Z DEBUG ambient_ci::plan] RUN: Action Shell(
            Shell {
                shell: "git config --global user.name 'Ambient CI'",
            },
        )
    [2026-01-15T06:13:59Z DEBUG ambient_ci::action] RunnableAction::execute: self=Shell(
            Shell {
                shell: "git config --global user.name 'Ambient CI'",
            },
        )
    [2026-01-15T06:13:59Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
            envs: {
                "CARGO_TARGET_DIR": "/ci/cache/cargo-target",
                "CARGO_HOME": "/ci/deps",
                "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
                "HOME": "/root",
            },
            source_dir: "/ci/src",
            deps_dir: "/ci/deps",
            artifacts_dir: "/ci/artifacts",
        }
    SPAWN: argv=["bash", "-c", "set -xeuo pipefail\ngit config --global user.name 'Ambient CI'\n"]
           cwd=/ci/src (exists? true)
    + git config --global user.name 'Ambient CI'
    [2026-01-15T06:13:59Z DEBUG ambient_ci::plan] RUN: Action finished OK
    [2026-01-15T06:13:59Z DEBUG ambient_ci::plan] RUN: Action Shell(
            Shell {
                shell: "git config --global user.email ambient@example.com",
            },
        )
    [2026-01-15T06:13:59Z DEBUG ambient_ci::action] RunnableAction::execute: self=Shell(
            Shell {
                shell: "git config --global user.email ambient@example.com",
            },
        )
    [2026-01-15T06:13:59Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
            envs: {
                "CARGO_TARGET_DIR": "/ci/cache/cargo-target",
                "CARGO_HOME": "/ci/deps",
                "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
                "HOME": "/root",
            },
            source_dir: "/ci/src",
            deps_dir: "/ci/deps",
            artifacts_dir: "/ci/artifacts",
        }
    SPAWN: argv=["bash", "-c", "set -xeuo pipefail\ngit config --global user.email ambient@example.com\n"]
           cwd=/ci/src (exists? true)
    + git config --global user.email ambient@example.com
    [2026-01-15T06:13:59Z DEBUG ambient_ci::plan] RUN: Action finished OK
    [2026-01-15T06:13:59Z DEBUG ambient_ci::plan] RUN: Action CargoClippy(
            CargoClippy,
        )
    [2026-01-15T06:13:59Z DEBUG ambient_ci::action] RunnableAction::execute: self=CargoClippy(
            CargoClippy,
        )
    [2026-01-15T06:13:59Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
            envs: {
                "CARGO_TARGET_DIR": "/ci/cache/cargo-target",
                "CARGO_HOME": "/ci/deps",
                "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
                "HOME": "/root",
            },
            source_dir: "/ci/src",
            deps_dir: "/ci/deps",
            artifacts_dir: "/ci/artifacts",
        }
    SPAWN: argv=["cargo", "--version"]
           cwd=/ci/src (exists? true)
    cargo 1.92.0 (344c4567c 2025-10-21)
    SPAWN: argv=["cargo", "clippy", "--version"]
           cwd=/ci/src (exists? true)
    clippy 0.1.92 (ded5c06cf2 2025-12-08)
    SPAWN: argv=["rustc", "--version"]
           cwd=/ci/src (exists? true)
    rustc 1.92.0 (ded5c06cf 2025-12-08)
    SPAWN: argv=["cargo", "clippy", "--offline", "--locked", "--workspace", "--all-targets", "--no-deps", "--", "--deny", "warnings"]
           cwd=/ci/src (exists? true)
       Compiling libc v0.2.177
        Checking cfg-if v1.0.4
       Compiling proc-macro2 v1.0.103
       Compiling quote v1.0.42
       Compiling unicode-ident v1.0.22
       Compiling version_check v0.9.5
       Compiling syn v2.0.110
       Compiling typenum v1.19.0
       Compiling generic-array v0.14.7
       Compiling serde_core v1.0.228
        Checking getrandom v0.2.16
        Checking rand_core v0.6.4
        Checking crypto-common v0.1.7
       Compiling rustix v1.1.2
        Checking bitflags v2.10.0
        Checking memchr v2.7.6
        Checking linux-raw-sys v0.11.0
       Compiling serde v1.0.228
       Compiling serde_derive v1.0.228
       Compiling semver v1.0.27
       Compiling getrandom v0.3.4
        Checking utf8parse v0.2.2
       Compiling thiserror v2.0.17
        Checking anstyle-parse v0.2.7
       Compiling rustc_version v0.4.1
        Checking aho-corasick v1.1.4
       Compiling thiserror-impl v2.0.17
        Checking inout v0.1.4
        Checking anstyle v1.0.13
       Compiling vcpkg v0.2.15
        Checking scopeguard v1.2.0
       Compiling num-conv v0.1.0
        Checking anstyle-query v1.1.5
        Checking colorchoice v1.0.4
       Compiling time-core v0.1.6
        Checking regex-syntax v0.8.8
       Compiling pkg-config v0.3.32
       Compiling powerfmt v0.2.0
        Checking is_terminal_polyfill v1.70.2
        Checking anstream v0.6.21
       Compiling deranged v0.5.5
        Checking regex-automata v0.4.13
       Compiling libsqlite3-sys v0.35.0
       Compiling time-macros v0.2.24
        Checking lock_api v0.4.14
        Checking cipher v0.4.4
       Compiling heapless v0.7.17
       Compiling crc32fast v1.5.0
        Checking equivalent v1.0.2
        Checking ryu v1.0.20
       Compiling serde_json v1.0.145
        Checking cpufeatures v0.2.17
        Checking foldhash v0.1.5
        Checking subtle v2.6.1
        Checking hashbrown v0.16.0
       Compiling itoa v1.0.15
        Checking winnow v0.7.13
        Checking byteorder v1.5.0
        Checking hash32 v0.2.1
        Checking indexmap v2.12.0
       Compiling time v0.3.44
        Checking toml_parser v1.0.4
        Checking universal-hash v0.5.1
        Checking hashbrown v0.15.5
        Checking spin v0.9.8
        Checking regex v1.12.2
        Checking terminal_size v0.4.3
        Checking serde_spanned v1.0.3
        Checking toml_datetime v0.7.3
        Checking dirs-sys-next v0.1.2
        Checking adler2 v2.0.1
        Checking strsim v0.11.1
        Checking fastrand v2.3.0
        Checking unsafe-libyaml-norway v0.2.15
        Checking opaque-debug v0.3.1
       Compiling heck v0.5.0
       Compiling log v0.4.28
        Checking once_cell v1.21.3
        Checking toml_writer v1.0.4
        Checking clap_lex v0.7.6
        Checking simd-adler32 v0.3.7
        Checking stable_deref_trait v1.2.1
        Checking env_filter v0.1.4
        Checking miniz_oxide v0.8.9
        Checking toml v0.9.8
        Checking clap_builder v4.5.51
        Checking serde_norway v0.9.42
        Checking tempfile v3.23.0
       Compiling git-testament-derive v0.2.1
       Compiling clap_derive v4.5.49
        Checking polyval v0.6.2
        Checking directories-next v2.0.0
        Checking hashlink v0.10.0
        Checking aes v0.8.4
        Checking ctr v0.9.2
        Checking cobs v0.3.0
        Checking aead v0.5.2
        Checking fallible-streaming-iterator v0.1.9
        Checking zeroize v1.8.2
        Checking jiff v0.2.16
        Checking smallvec v1.15.1
        Checking fallible-iterator v0.3.0
        Checking rusqlite v0.37.0
        Checking aes-gcm-siv v0.11.1
        Checking postcard v1.1.3
        Checking clap v4.5.51
        Checking clingwrap v0.5.0
        Checking flate2 v1.1.5
        Checking git-testament v0.2.6
        Checking uuid v1.18.1
        Checking hostname v0.4.1
       Compiling mutants v0.0.3
        Checking env_logger v0.11.8
        Checking obnam v0.10.0 (/ci/src)
        Finished `dev` profile [unoptimized + debuginfo] target(s) in 43.79s
    [2026-01-15T06:14:44Z DEBUG ambient_ci::plan] RUN: Action finished OK
    [2026-01-15T06:14:44Z DEBUG ambient_ci::plan] RUN: Action CargoBuild(
            CargoBuild,
        )
    [2026-01-15T06:14:44Z DEBUG ambient_ci::action] RunnableAction::execute: self=CargoBuild(
            CargoBuild,
        )
    [2026-01-15T06:14:44Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
            envs: {
                "CARGO_TARGET_DIR": "/ci/cache/cargo-target",
                "CARGO_HOME": "/ci/deps",
                "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
                "HOME": "/root",
            },
            source_dir: "/ci/src",
            deps_dir: "/ci/deps",
            artifacts_dir: "/ci/artifacts",
        }
    SPAWN: argv=["cargo", "--version"]
           cwd=/ci/src (exists? true)
    cargo 1.92.0 (344c4567c 2025-10-21)
    SPAWN: argv=["cargo", "clippy", "--version"]
           cwd=/ci/src (exists? true)
    clippy 0.1.92 (ded5c06cf2 2025-12-08)
    SPAWN: argv=["rustc", "--version"]
           cwd=/ci/src (exists? true)
    rustc 1.92.0 (ded5c06cf 2025-12-08)
    SPAWN: argv=["cargo", "build", "--offline", "--locked", "--workspace", "--all-targets"]
           cwd=/ci/src (exists? true)
       Compiling cfg-if v1.0.4
       Compiling libc v0.2.177
       Compiling typenum v1.19.0
       Compiling generic-array v0.14.7
       Compiling getrandom v0.2.16
       Compiling serde_core v1.0.228
       Compiling rand_core v0.6.4
       Compiling crypto-common v0.1.7
       Compiling memchr v2.7.6
       Compiling bitflags v2.10.0
       Compiling itoa v1.0.15
       Compiling linux-raw-sys v0.11.0
       Compiling rustix v1.1.2
       Compiling utf8parse v0.2.2
       Compiling anstyle-parse v0.2.7
       Compiling serde v1.0.228
       Compiling aho-corasick v1.1.4
       Compiling inout v0.1.4
       Compiling anstyle-query v1.1.5
       Compiling scopeguard v1.2.0
       Compiling anstyle v1.0.13
       Compiling regex-syntax v0.8.8
       Compiling is_terminal_polyfill v1.70.2
       Compiling colorchoice v1.0.4
       Compiling anstream v0.6.21
       Compiling regex-automata v0.4.13
       Compiling lock_api v0.4.14
       Compiling thiserror v2.0.17
       Compiling cipher v0.4.4
       Compiling getrandom v0.3.4
       Compiling foldhash v0.1.5
       Compiling subtle v2.6.1
       Compiling ryu v1.0.20
       Compiling equivalent v1.0.2
       Compiling cpufeatures v0.2.17
       Compiling hashbrown v0.16.0
       Compiling byteorder v1.5.0
       Compiling winnow v0.7.13
       Compiling toml_parser v1.0.4
       Compiling hash32 v0.2.1
       Compiling indexmap v2.12.0
       Compiling regex v1.12.2
       Compiling universal-hash v0.5.1
       Compiling hashbrown v0.15.5
       Compiling spin v0.9.8
       Compiling time v0.3.44
       Compiling terminal_size v0.4.3
       Compiling serde_spanned v1.0.3
       Compiling toml_datetime v0.7.3
       Compiling dirs-sys-next v0.1.2
       Compiling fastrand v2.3.0
       Compiling strsim v0.11.1
       Compiling once_cell v1.21.3
       Compiling simd-adler32 v0.3.7
       Compiling stable_deref_trait v1.2.1
       Compiling unsafe-libyaml-norway v0.2.15
       Compiling toml_writer v1.0.4
       Compiling clap_lex v0.7.6
       Compiling opaque-debug v0.3.1
       Compiling log v0.4.28
       Compiling adler2 v2.0.1
       Compiling miniz_oxide v0.8.9
       Compiling serde_norway v0.9.42
       Compiling env_filter v0.1.4
       Compiling polyval v0.6.2
       Compiling clap_builder v4.5.51
       Compiling toml v0.9.8
       Compiling heapless v0.7.17
       Compiling git-testament-derive v0.2.1
       Compiling tempfile v3.23.0
       Compiling directories-next v2.0.0
       Compiling libsqlite3-sys v0.35.0
       Compiling hashlink v0.10.0
       Compiling crc32fast v1.5.0
       Compiling serde_json v1.0.145
       Compiling aes v0.8.4
       Compiling ctr v0.9.2
       Compiling cobs v0.3.0
       Compiling aead v0.5.2
       Compiling zeroize v1.8.2
       Compiling fallible-iterator v0.3.0
       Compiling jiff v0.2.16
       Compiling fallible-streaming-iterator v0.1.9
       Compiling smallvec v1.15.1
       Compiling rusqlite v0.37.0
       Compiling aes-gcm-siv v0.11.1
       Compiling clingwrap v0.5.0
       Compiling postcard v1.1.3
       Compiling flate2 v1.1.5
       Compiling clap v4.5.51
       Compiling git-testament v0.2.6
       Compiling uuid v1.18.1
       Compiling hostname v0.4.1
       Compiling env_logger v0.11.8
       Compiling obnam v0.10.0 (/ci/src)
        Finished `dev` profile [unoptimized + debuginfo] target(s) in 49.56s
    [2026-01-15T06:15:34Z DEBUG ambient_ci::plan] RUN: Action finished OK
    [2026-01-15T06:15:34Z DEBUG ambient_ci::plan] RUN: Action CargoTest(
            CargoTest,
        )
    [2026-01-15T06:15:34Z DEBUG ambient_ci::action] RunnableAction::execute: self=CargoTest(
            CargoTest,
        )
    [2026-01-15T06:15:34Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
            envs: {
                "CARGO_TARGET_DIR": "/ci/cache/cargo-target",
                "CARGO_HOME": "/ci/deps",
                "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
                "HOME": "/root",
            },
            source_dir: "/ci/src",
            deps_dir: "/ci/deps",
            artifacts_dir: "/ci/artifacts",
        }
    SPAWN: argv=["cargo", "--version"]
           cwd=/ci/src (exists? true)
    cargo 1.92.0 (344c4567c 2025-10-21)
    SPAWN: argv=["cargo", "clippy", "--version"]
           cwd=/ci/src (exists? true)
    clippy 0.1.92 (ded5c06cf2 2025-12-08)
    SPAWN: argv=["rustc", "--version"]
           cwd=/ci/src (exists? true)
    rustc 1.92.0 (ded5c06cf 2025-12-08)
    SPAWN: argv=["cargo", "test", "--offline", "--locked", "--workspace"]
           cwd=/ci/src (exists? true)
        Finished `test` profile [unoptimized + debuginfo] target(s) in 0.16s
         Running unittests src/lib.rs (/ci/cache/cargo-target/debug/deps/obnam-60a6add4a5c21e2e)
    
    running 42 tests
    test chunk::test::ciphertext_does_not_contain_plaintext ... ok
    test chunk::test::id ... ok
    test chunk::test::id_is_comparable_with_itself ... ok
    test chunk::test::chunk_round_trip ... ok
    test chunk::test::label_round_trip ... ok
    test chunk::test::metadata ... 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 config::test::merge_files ... ok
    test config::test::valideted_config ... ok
    test chunk::test::label_display ... ok
    test credential::test::roundtrip_sop_credential ... ok
    test plaintext::test::compressed ... ok
    test plaintext::test::compression_round_trip ... ok
    test plaintext::test::uncompressed ... ok
    test sop::tests::cert_display ... ok
    test credential::test::roundtrip_sop_method ... ok
    test sop::tests::key_display ... ok
    test store::test::cant_init_nonexistent_dir ... ok
    test store::test::empty_dir_is_not_init ... ok
    test store::test::adds_chunk ... ok
    test store::test::finds_client_chunk ... ok
    test store::test::finds_chunk_when_labels_match ... ok
    test store::test::finds_no_chunk_in_empty_store ... ok
    test store::test::finds_credential_chunk ... ok
    test store::test::finds_no_chunk_when_none_match_label ... ok
    test store::test::finds_no_clients_when_there_are_none ... ok
    test store::test::has_no_chunks_initially ... ok
    test store::test::nonexistent_dir_is_not_init ... ok
    test store::test::inits_empty_dir ... ok
    test store::test::opens_client_chunk ... ok
    test store::test::root_dir_is_not_init ... ok
    test store::test::removes_chunk ... ok
    
    test result: ok. 42 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.83s
    
         Running unittests src/bin/obnam.rs (/ci/cache/cargo-target/debug/deps/obnam-57c9463d9f432f14)
    
    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/lib.rs - (line 12) ... ok
    
    test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
    
    all doctests ran in 0.51s; merged doctests compilation took 0.50s
    [2026-01-15T06:15:37Z DEBUG ambient_ci::plan] RUN: Action finished OK
    [2026-01-15T06:15:37Z DEBUG ambient_ci::plan] RUN: Action Shell(
            Shell {
                shell: "export PATH=/root/.cargo/bin:/bin:/sbin\nexport CARGO_TARGET_DIR=/workspace/cache\nmake subplot doc\nfind doc -ls\ncp obnam.html doc/*.html /workspace/artifacts\n",
            },
        )
    [2026-01-15T06:15:37Z DEBUG ambient_ci::action] RunnableAction::execute: self=Shell(
            Shell {
                shell: "export PATH=/root/.cargo/bin:/bin:/sbin\nexport CARGO_TARGET_DIR=/workspace/cache\nmake subplot doc\nfind doc -ls\ncp obnam.html doc/*.html /workspace/artifacts\n",
            },
        )
    [2026-01-15T06:15:37Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
            envs: {
                "CARGO_TARGET_DIR": "/ci/cache/cargo-target",
                "CARGO_HOME": "/ci/deps",
                "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
                "HOME": "/root",
            },
            source_dir: "/ci/src",
            deps_dir: "/ci/deps",
            artifacts_dir: "/ci/artifacts",
        }
    SPAWN: argv=["bash", "-c", "set -xeuo pipefail\nexport PATH=/root/.cargo/bin:/bin:/sbin\nexport CARGO_TARGET_DIR=/workspace/cache\nmake subplot doc\nfind doc -ls\ncp obnam.html doc/*.html /workspace/artifacts\n\n"]
           cwd=/ci/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 doc
    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 /ci/src
    datadir /tmp/tmparn7ea3u
    scenario: Add a chunk to the store.
      step 1: given an installed obnam
      step 2: given file .config/obnam/config.yaml from config.yaml
      step 3: given file greeting.txt
      step 4: given a directory mychunks
      step 5: when I run obnam store init
      step 6: when I run obnam chunk encrypt --key secret --label data --id xyzzy greeting.txt
      step 7: when I run obnam store list
      step 8: then stdout is exactly "xyzzy\n"
    scenario: Inspect an encrypted chunk using key from client chunk
      step 1: given an installed obnam
      step 2: given file .config/obnam/config.yaml from config.yaml
      step 3: given file greeting.txt
      step 4: when I create directory mychunks
      step 5: when I run obnam store init
      step 6: when I run obnam --client-key my.secret client init --client-name my.host
      step 7: when I run obnam --client-key my.secret client generate my.host my.key
      step 8: 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 9: when I run obnam --client-key my.secret chunk inspect --filename chunk.file --client-name my.host --key-name my.key
      step 10: then stdout is valid JSON
      step 11: then stdout contains ""id":"
      step 12: then stdout contains ""label":"
      step 13: then stdout contains ""data": ""
    scenario: Chunk encrypt/decrypt with compression round trip via repository
      step 1: given an installed obnam
      step 2: given file .config/obnam/config.yaml from config.yaml
      step 3: given file greeting.txt
      step 4: when I create directory mychunks
      step 5: when I try to run obnam store init
      step 6: when I run obnam chunk encrypt --compress --key secret --label sticky.tape greeting.txt --id=chunk0
      step 7: when I run obnam store list
      step 8: when I run obnam chunk decrypt --key secret --id chunk0
      step 9: then stdout is exactly "Hello, world.\n"
    scenario: Initialize a client chunk
      step 1: given an installed obnam
      step 2: given file .config/obnam/config.yaml from config-with-credential.yaml
      step 3: when I create directory mychunks
      step 4: when I run obnam store init
      step 5: when I run obnam client init --client-name my.host
      step 6: then command is successful
    scenario: Chunk encrypt/decrypt round trip via file
      step 1: given an installed obnam
      step 2: given file greeting.txt
      step 3: when I run obnam chunk encrypt --key secret --label sticky.tape greeting.txt --output chunk.file
      step 4: when I run obnam chunk decrypt --key secret chunk.file
      step 5: then stdout is exactly "Hello, world.\n"
    scenario: Logging level can be set
      step 1: given an installed obnam
      step 2: when I run obnam config
      step 3: then stderr doesn't contain "TRACE"
      step 4: then stderr doesn't contain "DEBUG"
      step 5: then stderr contains "INFO"
      step 6: then stderr contains "WARN"
      step 7: then stderr contains "ERROR"
      step 8: when I run env OBNAM_LOG=error obnam config
      step 9: then stderr doesn't contain "TRACE"
      step 10: then stderr doesn't contain "DEBUG"
      step 11: then stderr doesn't contain "INFO"
      step 12: then stderr doesn't contain "WARN"
      step 13: then stderr contains "ERROR"
      step 14: when I run obnam --log-level=error config
      step 15: then stderr doesn't contain "TRACE"
      step 16: then stderr doesn't contain "DEBUG"
      step 17: then stderr doesn't contain "INFO"
      step 18: then stderr doesn't contain "WARN"
      step 19: then stderr contains "ERROR"
      step 20: when I run env OBNAM_LOG=error obnam --log-level=trace config
      step 21: then stderr contains "TRACE"
      step 22: then stderr contains "DEBUG"
      step 23: then stderr contains "INFO"
      step 24: then stderr contains "WARN"
      step 25: then stderr contains "ERROR"
    scenario: Remove a chunk from store
      step 1: given an installed obnam
      step 2: given file .config/obnam/config.yaml from config.yaml
      step 3: given file greeting.txt
      step 4: given a directory mychunks
      step 5: when I run obnam store init
      step 6: when I run obnam chunk encrypt --key secret --label data-chunk --id xyzzy greeting.txt
      step 7: when I run obnam store remove xyzzy
      step 8: when I run obnam store list
      step 9: then stdout doesn't contain "xyzzy"
    scenario: Round trip chunk encryption using key from client chunk
      step 1: given an installed obnam
      step 2: given file .config/obnam/config.yaml from config.yaml
      step 3: given file greeting.txt
      step 4: when I create directory mychunks
      step 5: when I run obnam store init
      step 6: when I run obnam --client-key my.secret client init --client-name my.host
      step 7: when I run obnam --client-key my.secret client generate my.host my.key
      step 8: 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 9: when I run obnam --client-key my.secret chunk decrypt --client-name my.host --key-name my.key chunk.file
      step 10: then stdout is exactly "Hello, world.\n"
    scenario: Chunk encrypt/decrypt round trip via repository
      step 1: given an installed obnam
      step 2: given file .config/obnam/config.yaml from config.yaml
      step 3: given file greeting.txt
      step 4: when I create directory mychunks
      step 5: when I try to run obnam store init
      step 6: when I run obnam chunk encrypt --key secret --label sticky.tape greeting.txt --id=chunk0
      step 7: when I run obnam store list
      step 8: when I run obnam chunk decrypt --key secret --id chunk0
      step 9: then stdout is exactly "Hello, world.\n"
    scenario: Create an OpenPGP software key credential
      step 1: given an installed obnam
      step 2: given file .config/obnam/config.yaml from config.yaml
      step 3: given file sop-generate
      step 4: when I run bash sop-generate alice.tsk
      step 5: when I create directory mychunks
      step 6: when I run obnam store init
      step 7: when I run obnam credential list
      step 8: then stdout is exactly ""
      step 9: when I run obnam --client-key my.secret credential openpgp-soft alice.tsk
      step 10: when I run obnam credential list --all
      step 11: then stdout isn't exactly ""
    scenario: Get path to chunk in store
      step 1: given an installed obnam
      step 2: given file .config/obnam/config.yaml from config.yaml
      step 3: given file greeting.txt
      step 4: given a directory mychunks
      step 5: when I run obnam store init
      step 6: when I run obnam chunk encrypt --key secret --label data-chunk --id xyzzy greeting.txt
      step 7: when I run obnam store path xyzzy -o chunk.filename
      step 8: then a file exists whose name is in chunk.filename
    scenario: Encryption round trip
      step 1: given an installed obnam
      step 2: given file alice.key
      step 3: given file hello.txt
      step 4: when I run obnam sop encrypt rsop alice.key hello.txt -o encrypted
      step 5: when I run ls -l encrypted
      step 6: when I run cat encrypted
      step 7: when I run obnam sop decrypt rsop alice.key encrypted
      step 8: then stdout is exactly "hello, world\n"
    scenario: Initialize a store
      step 1: given an installed obnam
      step 2: given file .config/obnam/config.yaml from config.yaml
      step 3: then directory mychunks does not exist
      step 4: when I try to run obnam store is
      step 5: then command fails
      step 6: when I create directory mychunks
      step 7: when I try to run obnam store is
      step 8: then command fails
      step 9: when I run obnam store init
      step 10: when I run obnam store is
      step 11: then exit code is 0
    scenario: Conveniently create a client with an OpenPGP software key credential
      step 1: given an installed obnam
      step 2: given file .config/obnam/config.yaml from comfy.yaml
      step 3: when I create directory chunk.store
      step 4: when I run obnam store init
      step 5: when I run obnam client init --credential softy
      step 6: when I run obnam client list
      step 7: then stdout isn't exactly ""
    scenario: Inspect an encoded chunk in file
      step 1: given an installed obnam
      step 2: given file greeting.txt
      step 3: when I run obnam chunk encrypt --label sticky.tape --key secret greeting.txt --output chunk.file
      step 4: when I run obnam chunk inspect --filename chunk.file
      step 5: then stdout is valid JSON
      step 6: then stdout contains ""id":"
      step 7: then stdout contains ""label":"
      step 8: then stdout contains ""data": null"
      step 9: when I run obnam chunk inspect --filename chunk.file --key secret
      step 10: then stdout is valid JSON
      step 11: then stdout contains ""id":"
      step 12: then stdout contains ""label":"
      step 13: then stdout contains ""data": ""
    scenario: Chunk encrypt/decrypt with compression round trip via file
      step 1: given an installed obnam
      step 2: given file greeting.txt
      step 3: when I run obnam chunk encrypt --compress --key secret --label sticky.tape greeting.txt --output chunk.file
      step 4: when I run obnam chunk decrypt --key secret chunk.file
      step 5: then stdout is exactly "Hello, world.\n"
    scenario: Show client
      step 1: given an installed obnam
      step 2: given file .config/obnam/config.yaml from config.yaml
      step 3: when I create directory mychunks
      step 4: when I run obnam store init
      step 5: when I run obnam --client-key my.secret client init --client-name my.host
      step 6: when I run obnam --client-key my.secret client show --client-name my.host
      step 7: then stdout is valid JSON
    scenario: List clients
      step 1: given an installed obnam
      step 2: given file .config/obnam/config.yaml from config.yaml
      step 3: when I create directory mychunks
      step 4: when I run obnam store init
      step 5: when I run obnam --client-key my.secret client init --client-name my.host
      step 6: when I run obnam --client-key my.secret client list
      step 7: then stdout is exactly "my.host\n"
    scenario: Conveniently encrypt and decrypt chunk in a store
      step 1: given an installed obnam
      step 2: given file .config/obnam/config.yaml from comfy.yaml
      step 3: given file message.txt
      step 4: when I create directory chunk.store
      step 5: when I run obnam store init
      step 6: when I run obnam client init --credential softy
      step 7: when I run obnam chunk encrypt --label data --key-name default --id test.chunk message.txt
      step 8: when I run obnam chunk decrypt --key-name default --id test.chunk --output out.dat
      step 9: then files message.txt and out.dat match
    scenario: Avoid client chunks with the same name
      step 1: given an installed obnam
      step 2: given file .config/obnam/config.yaml from config.yaml
      step 3: when I create directory mychunks
      step 4: when I run obnam store init
      step 5: when I run obnam --client-key my.secret client init --client-name my.host
      step 6: then command is successful
      step 7: when I try to run obnam --client-key my.secret client init --client-name my.host
      step 8: then command fails
    scenario: Inspect an encoded chunk in repository
      step 1: given an installed obnam
      step 2: given file .config/obnam/config.yaml from config.yaml
      step 3: given file greeting.txt
      step 4: when I create directory mychunks
      step 5: when I try to run obnam store init
      step 6: when I run obnam chunk encrypt --label sticky.tape --key secret greeting.txt --id=chunk0
      step 7: when I run obnam chunk inspect --id chunk0
      step 8: then stdout is valid JSON
      step 9: then stdout contains ""id":"
      step 10: then stdout contains ""label":"
      step 11: then stdout contains ""data": null"
      step 12: when I run obnam chunk inspect --key secret --id chunk0
      step 13: then stdout is valid JSON
      step 14: then stdout contains ""id":"
      step 15: then stdout contains ""label":"
      step 16: then stdout contains ""data": ""
    scenario: Extracting a certificate from a key
      step 1: given an installed obnam
      step 2: given file alice.key
      step 3: when I run obnam sop extract-cert rsop alice.key
      step 4: then stdout isn't exactly ""
    scenario: Generate new key
      step 1: given an installed obnam
      step 2: given file .config/obnam/config.yaml from config.yaml
      step 3: when I create directory mychunks
      step 4: when I run obnam store init
      step 5: when I run obnam --client-key my.secret client init --client-name my.host
      step 6: when I run obnam --client-key my.secret client generate my.host my.key
      step 7: when I run obnam --client-key my.secret client show --client-name my.host
      step 8: then stdout contains "my.key"
    scenario: Find chunks using labels
      step 1: given an installed obnam
      step 2: given file .config/obnam/config.yaml from config.yaml
      step 3: given file greeting.txt
      step 4: given a directory mychunks
      step 5: when I run obnam store init
      step 6: when I run obnam chunk encrypt --key secret --label data-chunk --id xyzzy greeting.txt
      step 7: when I run obnam chunk encrypt --key secret --label data-chunk --id plugh greeting.txt
      step 8: when I run obnam chunk encrypt --key secret --label client-chunk --id advent greeting.txt
      step 9: when I run obnam store find missing
      step 10: then stdout is exactly ""
      step 11: when I run obnam store find data-chunk
      step 12: then stdout contains "xyzzy"
      step 13: then stdout contains "plugh"
      step 14: then stdout doesn't contain "advent"
      step 15: when I run obnam store find client-chunk
      step 16: then stdout doesn't contain "xyzzy"
      step 17: then stdout doesn't contain "plugh"
      step 18: then stdout contains "advent"
    OK, all scenarios finished successfully
    env 'RUSTDOCFLAGS=-D warnings' cargo doc --no-deps
       Compiling libc v0.2.177
        Checking cfg-if v1.0.4
       Compiling proc-macro2 v1.0.103
       Compiling unicode-ident v1.0.22
       Compiling quote v1.0.42
       Compiling version_check v0.9.5
       Compiling syn v2.0.110
       Compiling typenum v1.19.0
       Compiling generic-array v0.14.7
       Compiling serde_core v1.0.228
        Checking getrandom v0.2.16
        Checking rand_core v0.6.4
        Checking crypto-common v0.1.7
        Checking memchr v2.7.6
       Compiling rustix v1.1.2
        Checking bitflags v2.10.0
        Checking linux-raw-sys v0.11.0
       Compiling serde v1.0.228
       Compiling serde_derive v1.0.228
       Compiling getrandom v0.3.4
       Compiling semver v1.0.27
       Compiling thiserror v2.0.17
        Checking utf8parse v0.2.2
        Checking anstyle-parse v0.2.7
       Compiling rustc_version v0.4.1
        Checking aho-corasick v1.1.4
       Compiling thiserror-impl v2.0.17
        Checking inout v0.1.4
       Compiling num-conv v0.1.0
       Compiling time-core v0.1.6
       Compiling powerfmt v0.2.0
       Compiling vcpkg v0.2.15
        Checking scopeguard v1.2.0
        Checking anstyle v1.0.13
        Checking regex-syntax v0.8.8
        Checking is_terminal_polyfill v1.70.2
        Checking colorchoice v1.0.4
       Compiling pkg-config v0.3.32
        Checking anstyle-query v1.1.5
        Checking anstream v0.6.21
        Checking regex-automata v0.4.13
       Compiling libsqlite3-sys v0.35.0
        Checking lock_api v0.4.14
       Compiling deranged v0.5.5
       Compiling time-macros v0.2.24
        Checking cipher v0.4.4
       Compiling heapless v0.7.17
        Checking hashbrown v0.16.0
        Checking itoa v1.0.15
        Checking cpufeatures v0.2.17
        Checking foldhash v0.1.5
        Checking subtle v2.6.1
        Checking byteorder v1.5.0
        Checking winnow v0.7.13
        Checking equivalent v1.0.2
        Checking ryu v1.0.20
       Compiling serde_json v1.0.145
       Compiling crc32fast v1.5.0
        Checking indexmap v2.12.0
       Compiling time v0.3.44
        Checking toml_parser v1.0.4
        Checking hash32 v0.2.1
        Checking universal-hash v0.5.1
        Checking hashbrown v0.15.5
        Checking regex v1.12.2
        Checking spin v0.9.8
        Checking terminal_size v0.4.3
        Checking toml_datetime v0.7.3
        Checking serde_spanned v1.0.3
        Checking dirs-sys-next v0.1.2
        Checking fastrand v2.3.0
        Checking unsafe-libyaml-norway v0.2.15
        Checking toml_writer v1.0.4
        Checking simd-adler32 v0.3.7
        Checking opaque-debug v0.3.1
       Compiling heck v0.5.0
        Checking once_cell v1.21.3
       Compiling log v0.4.28
        Checking stable_deref_trait v1.2.1
        Checking clap_lex v0.7.6
        Checking adler2 v2.0.1
        Checking strsim v0.11.1
        Checking clap_builder v4.5.51
        Checking env_filter v0.1.4
        Checking miniz_oxide v0.8.9
       Compiling git-testament-derive v0.2.1
        Checking tempfile v3.23.0
        Checking serde_norway v0.9.42
       Compiling clap_derive v4.5.49
        Checking polyval v0.6.2
        Checking toml v0.9.8
        Checking directories-next v2.0.0
        Checking hashlink v0.10.0
        Checking aes v0.8.4
        Checking ctr v0.9.2
        Checking cobs v0.3.0
        Checking aead v0.5.2
        Checking fallible-iterator v0.3.0
        Checking jiff v0.2.16
        Checking fallible-streaming-iterator v0.1.9
        Checking smallvec v1.15.1
        Checking zeroize v1.8.2
        Checking aes-gcm-siv v0.11.1
        Checking rusqlite v0.37.0
        Checking postcard v1.1.3
        Checking clingwrap v0.5.0
        Checking flate2 v1.1.5
        Checking clap v4.5.51
        Checking git-testament v0.2.6
        Checking uuid v1.18.1
        Checking hostname v0.4.1
       Compiling mutants v0.0.3
        Checking env_logger v0.11.8
     Documenting obnam v0.10.0 (/ci/src)
        Finished `dev` profile [unoptimized + debuginfo] target(s) in 39.49s
       Generated /workspace/cache/doc/obnam/index.html
    make -C doc
    make[1]: Entering directory '/ci/src/doc'
    pandoc -N --toc --standalone --self-contained -o "arch.html" "arch.md"
    pandoc -N --toc --standalone --self-contained -o "glossary.html" "glossary.md"
    [WARNING] This document format requires a nonempty <title> element.
      Defaulting to 'glossary' as the title.
      To specify a title, use 'title' in metadata or --metadata title="...".
    make[1]: Leaving directory '/ci/src/doc'
    + find doc -ls
      3801117      4 drwxr-xr-x   2 root     root         4096 Jan 15 06:16 doc
      3801122      4 -rw-r--r--   1 root     root          327 Jan 15 06:12 doc/Makefile
      3801121     16 -rw-r--r--   1 root     root        13627 Jan 15 06:12 doc/arch.md
      3801118      4 -rw-r--r--   1 root     root         3885 Jan 15 06:12 doc/keys.svg
      3801120      4 -rw-r--r--   1 root     root          517 Jan 15 06:12 doc/glossary.md
      3818529     24 -rw-r--r--   1 root     root        24568 Jan 15 06:16 doc/arch.html
      3819995      8 -rw-r--r--   1 root     root         4303 Jan 15 06:16 doc/glossary.html
      3801119      4 -rw-r--r--   1 root     root          540 Jan 15 06:12 doc/keys.pik
    + cp obnam.html doc/arch.html doc/glossary.html /workspace/artifacts
    [2026-01-15T06:16:22Z DEBUG ambient_ci::plan] RUN: Action finished OK
    [2026-01-15T06:16:22Z DEBUG ambient_ci::plan] RUN: Action Custom(
            Custom {
                name: "dch",
                args: {
                    "debfullname": String("Lars Wirzenius"),
                    "debemail": String("liw@liw.fi"),
                },
            },
        )
    [2026-01-15T06:16:22Z DEBUG ambient_ci::action] RunnableAction::execute: self=Custom(
            Custom {
                name: "dch",
                args: {
                    "debfullname": String("Lars Wirzenius"),
                    "debemail": String("liw@liw.fi"),
                },
            },
        )
    [2026-01-15T06:16:22Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
            envs: {
                "CARGO_TARGET_DIR": "/ci/cache/cargo-target",
                "CARGO_HOME": "/ci/deps",
                "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
                "HOME": "/root",
            },
            source_dir: "/ci/src",
            deps_dir: "/ci/deps",
            artifacts_dir: "/ci/artifacts",
        }
    custom: source=/ci/src
    custom: exe=".ambient/dch" exists=false
    + export 'DEBEMAIL="liw@liw.fi"'
    + DEBEMAIL='"liw@liw.fi"'
    + export 'DEBFULLNAME="Lars Wirzenius"'
    + DEBFULLNAME='"Lars Wirzenius"'
    + export CARGO_TARGET_DIR=/workspace/cache
    + CARGO_TARGET_DIR=/workspace/cache
    + export CARGO_HOME=/workspace/deps
    + CARGO_HOME=/workspace/deps
    + export HOME=/root
    + HOME=/root
    + export PATH=/root/.cargo/bin:/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
    + PATH=/root/.cargo/bin:/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
    + git reset --hard
    HEAD is now at 34eb965 chore: update .ambient/dch
    + git clean -fdx
    Removing doc/arch.html
    Removing doc/glossary.html
    Removing obnam.html
    Removing test.log
    Removing test.py
    ++ sed 's/-[^-]*$//'
    ++ dpkg-parsechangelog -SVersion
    + V=0.9.9
    ++ date -u +%Y%m%dT%H%M%S
    + T=20260115T061622
    + version=0.9.9.ci20260115T061622-1
    + dch -v 0.9.9.ci20260115T061622-1 'CI build under Ambient.'
    + dch -r ''
    custom action "dch" exit code Some(0)
    [2026-01-15T06:16:23Z DEBUG ambient_ci::plan] RUN: Action finished OK
    [2026-01-15T06:16:23Z DEBUG ambient_ci::plan] RUN: Action Deb(
            Deb {
                packages: Some(
                    ".",
                ),
            },
        )
    [2026-01-15T06:16:23Z DEBUG ambient_ci::action] RunnableAction::execute: self=Deb(
            Deb {
                packages: Some(
                    ".",
                ),
            },
        )
    [2026-01-15T06:16:23Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
            envs: {
                "CARGO_TARGET_DIR": "/ci/cache/cargo-target",
                "CARGO_HOME": "/ci/deps",
                "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
                "HOME": "/root",
            },
            source_dir: "/ci/src",
            deps_dir: "/ci/deps",
            artifacts_dir: "/ci/artifacts",
        }
    SPAWN: argv=["/bin/bash", "-c", "#!/usr/bin/env bash\nset -xeuo pipefail\n\necho \"PATH at start: $PATH\"\nexport PATH=\"/root/.cargo/bin:$PATH\"\nexport CARGO_HOME=/workspace/deps\nexport DEBEMAIL=liw@liw.fi\nexport DEBFULLNAME=\"Lars Wirzenius\"\n/bin/env\n\ncommand -v cargo\ncommand -v rustc\n\ncargo --version\nrustc --version\n\n# Get name and version of source package.\nname=\"$(dpkg-parsechangelog -SSource)\"\nversion=\"$(dpkg-parsechangelog -SVersion)\"\n\n# Get upstream version: everything before the last dash.\nuv=\"$(echo \"$version\" | sed 's/-[^-]*$//')\"\n\n# Files that will be created.\narch=\"$(dpkg --print-architecture)\"\norig=\"../${name}_${uv}.orig.tar.xz\"\ndeb=\"../${name}_${version}_${arch}.deb\"\nchanges=\"../${name}_${version}_${arch}.changes\"\n\n# Create \"upstream tarball\".\ngit archive HEAD | xz >\"$orig\"\n\n# Build package.\ndpkg-buildpackage -us -uc\n\n# Dump some information to make it easier to visually verify\n# everything looks OK. Also, test the package with the lintian tool.\n\nls -l ..\nfor x in ../*.deb; do dpkg -c \"$x\"; done\n# FIXME: disabled while this prevents radicle-native-ci deb from being built.\n# lintian -i --allow-root --fail-on warning ../*.changes\n\n# Move files to artifacts directory.\nmv ../*_* /ci/artifacts/.\n        "]
           cwd=/ci/src (exists? true)
    + echo 'PATH at start: /root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin'
    PATH at start: /root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
    + export PATH=/root/.cargo/bin:/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
    + PATH=/root/.cargo/bin:/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
    + export CARGO_HOME=/workspace/deps
    + CARGO_HOME=/workspace/deps
    + export DEBEMAIL=liw@liw.fi
    + DEBEMAIL=liw@liw.fi
    + export 'DEBFULLNAME=Lars Wirzenius'
    + DEBFULLNAME='Lars Wirzenius'
    + /bin/env
    DEBFULLNAME=Lars Wirzenius
    CARGO_TARGET_DIR=/ci/cache/cargo-target
    PWD=/ci/src
    SYSTEMD_EXEC_PID=293
    HOME=/root
    LANG=C.UTF-8
    CARGO_HOME=/workspace/deps
    DEBEMAIL=liw@liw.fi
    INVOCATION_ID=4d9847fd11d64c059d977efe5cefa98b
    SHLVL=2
    JOURNAL_STREAM=8:13424
    PATH=/root/.cargo/bin:/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
    OLDPWD=/
    _=/bin/env
    + command -v cargo
    /root/.cargo/bin/cargo
    + command -v rustc
    /root/.cargo/bin/rustc
    + cargo --version
    cargo 1.92.0 (344c4567c 2025-10-21)
    + rustc --version
    rustc 1.92.0 (ded5c06cf 2025-12-08)
    ++ dpkg-parsechangelog -SSource
    + name=obnam
    ++ dpkg-parsechangelog -SVersion
    + version=0.9.9.ci20260115T061622-1
    ++ sed 's/-[^-]*$//'
    ++ echo 0.9.9.ci20260115T061622-1
    + uv=0.9.9.ci20260115T061622
    ++ dpkg --print-architecture
    + arch=amd64
    + orig=../obnam_0.9.9.ci20260115T061622.orig.tar.xz
    + deb=../obnam_0.9.9.ci20260115T061622-1_amd64.deb
    + changes=../obnam_0.9.9.ci20260115T061622-1_amd64.changes
    + xz
    + git archive HEAD
    + dpkg-buildpackage -us -uc
    dpkg-buildpackage: info: source package obnam
    dpkg-buildpackage: info: source version 0.9.9.ci20260115T061622-1
    dpkg-buildpackage: info: source distribution unstable
    dpkg-buildpackage: info: source changed by "Lars Wirzenius" <"liw@liw.fi">
    dpkg-buildpackage: info: host architecture amd64
     dpkg-source --before-build .
     debian/rules clean
    dh clean
       dh_auto_clean
       dh_clean
     dpkg-source -b .
    dpkg-source: info: using source format '3.0 (quilt)'
    dpkg-source: info: building obnam using existing ./obnam_0.9.9.ci20260115T061622.orig.tar.xz
    dpkg-source: info: building obnam in obnam_0.9.9.ci20260115T061622-1.debian.tar.xz
    dpkg-source: info: building obnam in obnam_0.9.9.ci20260115T061622-1.dsc
     debian/rules build
    dh build
       dh_update_autotools_config
       dh_autoreconf
       dh_auto_configure
       debian/rules override_dh_auto_build
    make[1]: Entering directory '/ci/src'
    true
    make[1]: Leaving directory '/ci/src'
       debian/rules override_dh_auto_test
    make[1]: Entering directory '/ci/src'
    echo tests are disabled, for now
    tests are disabled, for now
    make[1]: Leaving directory '/ci/src'
       create-stamp debian/debhelper-build-stamp
     debian/rules binary
    dh binary
       dh_testroot
       dh_prep
       debian/rules override_dh_auto_install
    make[1]: Entering directory '/ci/src'
    cargo install --offline --locked --path=. --root=debian/obnam/usr
      Installing obnam v0.10.0 (/ci/src)
       Compiling libc v0.2.177
       Compiling cfg-if v1.0.4
       Compiling proc-macro2 v1.0.103
       Compiling quote v1.0.42
       Compiling unicode-ident v1.0.22
       Compiling syn v2.0.110
       Compiling version_check v0.9.5
       Compiling typenum v1.19.0
       Compiling generic-array v0.14.7
       Compiling serde_core v1.0.228
       Compiling getrandom v0.2.16
       Compiling rand_core v0.6.4
       Compiling crypto-common v0.1.7
       Compiling bitflags v2.10.0
       Compiling memchr v2.7.6
       Compiling rustix v1.1.2
       Compiling serde v1.0.228
       Compiling linux-raw-sys v0.11.0
       Compiling serde_derive v1.0.228
       Compiling semver v1.0.27
       Compiling getrandom v0.3.4
       Compiling thiserror v2.0.17
       Compiling utf8parse v0.2.2
       Compiling anstyle-parse v0.2.7
       Compiling rustc_version v0.4.1
       Compiling aho-corasick v1.1.4
       Compiling thiserror-impl v2.0.17
       Compiling inout v0.1.4
       Compiling scopeguard v1.2.0
       Compiling anstyle v1.0.13
       Compiling time-core v0.1.6
       Compiling is_terminal_polyfill v1.70.2
       Compiling num-conv v0.1.0
       Compiling pkg-config v0.3.32
       Compiling vcpkg v0.2.15
       Compiling regex-syntax v0.8.8
       Compiling powerfmt v0.2.0
       Compiling anstyle-query v1.1.5
       Compiling colorchoice v1.0.4
       Compiling anstream v0.6.21
       Compiling deranged v0.5.5
       Compiling regex-automata v0.4.13
       Compiling libsqlite3-sys v0.35.0
       Compiling time-macros v0.2.24
       Compiling lock_api v0.4.14
       Compiling cipher v0.4.4
       Compiling heapless v0.7.17
       Compiling hashbrown v0.16.0
       Compiling foldhash v0.1.5
       Compiling subtle v2.6.1
       Compiling ryu v1.0.20
       Compiling crc32fast v1.5.0
       Compiling equivalent v1.0.2
       Compiling serde_json v1.0.145
       Compiling winnow v0.7.13
       Compiling cpufeatures v0.2.17
       Compiling itoa v1.0.15
       Compiling byteorder v1.5.0
       Compiling time v0.3.44
       Compiling hash32 v0.2.1
       Compiling toml_parser v1.0.4
       Compiling indexmap v2.12.0
       Compiling universal-hash v0.5.1
       Compiling hashbrown v0.15.5
       Compiling spin v0.9.8
       Compiling regex v1.12.2
       Compiling terminal_size v0.4.3
       Compiling serde_spanned v1.0.3
       Compiling toml_datetime v0.7.3
       Compiling dirs-sys-next v0.1.2
       Compiling fastrand v2.3.0
       Compiling opaque-debug v0.3.1
       Compiling clap_lex v0.7.6
       Compiling strsim v0.11.1
       Compiling simd-adler32 v0.3.7
       Compiling adler2 v2.0.1
       Compiling toml_writer v1.0.4
       Compiling once_cell v1.21.3
       Compiling stable_deref_trait v1.2.1
       Compiling heck v0.5.0
       Compiling unsafe-libyaml-norway v0.2.15
       Compiling log v0.4.28
       Compiling git-testament-derive v0.2.1
       Compiling serde_norway v0.9.42
       Compiling env_filter v0.1.4
       Compiling clap_derive v4.5.49
       Compiling toml v0.9.8
       Compiling tempfile v3.23.0
       Compiling miniz_oxide v0.8.9
       Compiling clap_builder v4.5.51
       Compiling polyval v0.6.2
       Compiling directories-next v2.0.0
       Compiling hashlink v0.10.0
       Compiling aes v0.8.4
       Compiling cobs v0.3.0
       Compiling ctr v0.9.2
       Compiling aead v0.5.2
       Compiling fallible-streaming-iterator v0.1.9
       Compiling smallvec v1.15.1
       Compiling fallible-iterator v0.3.0
       Compiling zeroize v1.8.2
       Compiling jiff v0.2.16
       Compiling aes-gcm-siv v0.11.1
       Compiling rusqlite v0.37.0
       Compiling env_logger v0.11.8
       Compiling postcard v1.1.3
       Compiling clingwrap v0.5.0
       Compiling flate2 v1.1.5
       Compiling clap v4.5.51
       Compiling git-testament v0.2.6
       Compiling uuid v1.18.1
       Compiling hostname v0.4.1
       Compiling mutants v0.0.3
       Compiling obnam v0.10.0 (/ci/src)
        Finished `release` profile [optimized] target(s) in 2m 07s
      Installing debian/obnam/usr/bin/obnam
       Installed package `obnam v0.10.0 (/ci/src)` (executable `obnam`)
    warning: be sure to add `debian/obnam/usr/bin` to your PATH to be able to run the installed binaries
    find debian -name '.crates*.*' -delete
    make[1]: Leaving directory '/ci/src'
       dh_installdocs
       dh_installchangelogs
       dh_lintian
       dh_perl
       dh_link
       dh_strip_nondeterminism
       dh_compress
       dh_fixperms
       dh_missing
       dh_strip
       dh_makeshlibs
       dh_shlibdeps
       dh_installdeb
       dh_gencontrol
       dh_md5sums
       dh_builddeb
    dpkg-deb: building package 'obnam' in '../obnam_0.9.9.ci20260115T061622-1_amd64.deb'.
    dpkg-deb: building package 'obnam-dbgsym' in '../obnam-dbgsym_0.9.9.ci20260115T061622-1_amd64.deb'.
     dpkg-genbuildinfo -O../obnam_0.9.9.ci20260115T061622-1_amd64.buildinfo
     dpkg-genchanges -O../obnam_0.9.9.ci20260115T061622-1_amd64.changes
    dpkg-genchanges: info: including full source code in upload
     dpkg-source --after-build .
    dpkg-buildpackage: info: full upload (original source is included)
    + ls -l ..
    total 1280
    drwxr-xr-x 2 root root    4096 Jan 15 06:16 artifacts
    drwxr-xr-x 6 root root    4096 Jan 15 06:14 cache
    drwxr-xr-x 3 root root    4096 Jan 15 06:12 deps
    -rw-r--r-- 1 root root  135848 Jan 15 06:18 obnam-dbgsym_0.9.9.ci20260115T061622-1_amd64.deb
    -rw-r--r-- 1 root root    1716 Jan 15 06:16 obnam_0.9.9.ci20260115T061622-1.debian.tar.xz
    -rw-r--r-- 1 root root     900 Jan 15 06:16 obnam_0.9.9.ci20260115T061622-1.dsc
    -rw-r--r-- 1 root root    5651 Jan 15 06:18 obnam_0.9.9.ci20260115T061622-1_amd64.buildinfo
    -rw-r--r-- 1 root root    2296 Jan 15 06:18 obnam_0.9.9.ci20260115T061622-1_amd64.changes
    -rw-r--r-- 1 root root 1072820 Jan 15 06:18 obnam_0.9.9.ci20260115T061622-1_amd64.deb
    -rw-r--r-- 1 root root   59684 Jan 15 06:16 obnam_0.9.9.ci20260115T061622.orig.tar.xz
    drwxr-xr-x 8 root root    4096 Jan 15 06:16 src
    + for x in ../*.deb
    + dpkg -c ../obnam-dbgsym_0.9.9.ci20260115T061622-1_amd64.deb
    drwxr-xr-x root/root         0 2026-01-15 06:16 ./
    drwxr-xr-x root/root         0 2026-01-15 06:16 ./usr/
    drwxr-xr-x root/root         0 2026-01-15 06:16 ./usr/lib/
    drwxr-xr-x root/root         0 2026-01-15 06:16 ./usr/lib/debug/
    drwxr-xr-x root/root         0 2026-01-15 06:16 ./usr/lib/debug/.build-id/
    drwxr-xr-x root/root         0 2026-01-15 06:16 ./usr/lib/debug/.build-id/df/
    -rw-r--r-- root/root    752472 2026-01-15 06:16 ./usr/lib/debug/.build-id/df/a95469928867f7f6e22f0422a420000c10cd6c.debug
    drwxr-xr-x root/root         0 2026-01-15 06:16 ./usr/share/
    drwxr-xr-x root/root         0 2026-01-15 06:16 ./usr/share/doc/
    lrwxrwxrwx root/root         0 2026-01-15 06:16 ./usr/share/doc/obnam-dbgsym -> obnam
    + for x in ../*.deb
    + dpkg -c ../obnam_0.9.9.ci20260115T061622-1_amd64.deb
    drwxr-xr-x root/root         0 2026-01-15 06:16 ./
    drwxr-xr-x root/root         0 2026-01-15 06:16 ./usr/
    drwxr-xr-x root/root         0 2026-01-15 06:16 ./usr/bin/
    -rwxr-xr-x root/root   3472288 2026-01-15 06:16 ./usr/bin/obnam
    drwxr-xr-x root/root         0 2026-01-15 06:16 ./usr/share/
    drwxr-xr-x root/root         0 2026-01-15 06:16 ./usr/share/doc/
    drwxr-xr-x root/root         0 2026-01-15 06:16 ./usr/share/doc/obnam/
    -rw-r--r-- root/root       211 2026-01-15 06:16 ./usr/share/doc/obnam/changelog.Debian.gz
    -rw-r--r-- root/root       371 2026-01-15 06:12 ./usr/share/doc/obnam/copyright
    drwxr-xr-x root/root         0 2026-01-15 06:16 ./usr/share/lintian/
    drwxr-xr-x root/root         0 2026-01-15 06:16 ./usr/share/lintian/overrides/
    -rw-r--r-- root/root        48 2026-01-15 06:12 ./usr/share/lintian/overrides/obnam
    + mv ../obnam-dbgsym_0.9.9.ci20260115T061622-1_amd64.deb ../obnam_0.9.9.ci20260115T061622-1.debian.tar.xz ../obnam_0.9.9.ci20260115T061622-1.dsc ../obnam_0.9.9.ci20260115T061622-1_amd64.buildinfo ../obnam_0.9.9.ci20260115T061622-1_amd64.changes ../obnam_0.9.9.ci20260115T061622-1_amd64.deb ../obnam_0.9.9.ci20260115T061622.orig.tar.xz /ci/artifacts/.
    [2026-01-15T06:18:41Z DEBUG ambient_ci::plan] RUN: Action finished OK
    [2026-01-15T06:18:41Z DEBUG ambient_ci::plan] RUN: Action TarCreate(
            TarCreate {
                archive: "/dev/vde",
                directory: "/ci/cache",
            },
        )
    [2026-01-15T06:18:41Z DEBUG ambient_ci::action] RunnableAction::execute: self=TarCreate(
            TarCreate {
                archive: "/dev/vde",
                directory: "/ci/cache",
            },
        )
    [2026-01-15T06:18:41Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
            envs: {
                "CARGO_TARGET_DIR": "/ci/cache/cargo-target",
                "CARGO_HOME": "/ci/deps",
                "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
                "HOME": "/root",
            },
            source_dir: "/ci/src",
            deps_dir: "/ci/deps",
            artifacts_dir: "/ci/artifacts",
        }
    [2026-01-15T06:18:41Z TRACE ambient_ci::vdrive] creating virtual drive (tar archive): VirtualDriveBuilder {
            filename: Some(
                "/dev/vde",
            ),
            root: Some(
                "/ci/cache",
            ),
            size: None,
        }
    [2026-01-15T06:18:41Z TRACE ambient_ci::vdrive] tar archive to be created: /dev/vde; exists? true
    [2026-01-15T06:18:41Z TRACE ambient_ci::vdrive] create archive file /dev/vde
    [2026-01-15T06:18:41Z TRACE ambient_ci::vdrive] directory /ci/cache exists? true
    [2026-01-15T06:18:41Z TRACE ambient_ci::vdrive] add contents of /ci/cache as .
    [2026-01-15T06:18:41Z TRACE ambient_ci::vdrive] calling tar_create
    [2026-01-15T06:19:03Z TRACE ambient_ci::vdrive] created virtual drive /dev/vde
    [2026-01-15T06:19:03Z DEBUG ambient_ci::plan] RUN: Action finished OK
    [2026-01-15T06:19:03Z DEBUG ambient_ci::plan] RUN: Action TarCreate(
            TarCreate {
                archive: "/dev/vdd",
                directory: "/ci/artifacts",
            },
        )
    [2026-01-15T06:19:03Z DEBUG ambient_ci::action] RunnableAction::execute: self=TarCreate(
            TarCreate {
                archive: "/dev/vdd",
                directory: "/ci/artifacts",
            },
        )
    [2026-01-15T06:19:03Z DEBUG ambient_ci::action] RunnableAction::execute: context=Context {
            envs: {
                "CARGO_TARGET_DIR": "/ci/cache/cargo-target",
                "CARGO_HOME": "/ci/deps",
                "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
                "HOME": "/root",
            },
            source_dir: "/ci/src",
            deps_dir: "/ci/deps",
            artifacts_dir: "/ci/artifacts",
        }
    [2026-01-15T06:19:03Z TRACE ambient_ci::vdrive] creating virtual drive (tar archive): VirtualDriveBuilder {
            filename: Some(
                "/dev/vdd",
            ),
            root: Some(
                "/ci/artifacts",
            ),
            size: None,
        }
    [2026-01-15T06:19:03Z TRACE ambient_ci::vdrive] tar archive to be created: /dev/vdd; exists? true
    [2026-01-15T06:19:03Z TRACE ambient_ci::vdrive] create archive file /dev/vdd
    [2026-01-15T06:19:03Z TRACE ambient_ci::vdrive] directory /ci/artifacts exists? true
    [2026-01-15T06:19:03Z TRACE ambient_ci::vdrive] add contents of /ci/artifacts as .
    [2026-01-15T06:19:03Z TRACE ambient_ci::vdrive] calling tar_create
    [2026-01-15T06:19:03Z TRACE ambient_ci::vdrive] created virtual drive /dev/vdd
    [2026-01-15T06:19:03Z DEBUG ambient_ci::plan] RUN: Action finished OK
    [2026-01-15T06:19:03Z DEBUG ambient_ci::plan] All actions were performed successfully
    ambient-execute-plan ends
    EXIT CODE: 0
    
    ====================
[2026-01-15T06:19:07Z DEBUG ambient_ci::qemu] QEMU: CI run under exit code 0
[2026-01-15T06:19:08Z DEBUG ambient_ci::run] CI run exit code from QEMU: 0
[2026-01-15T06:19:08Z DEBUG ambient_ci::run] remove old cache
[2026-01-15T06:19:10Z DEBUG ambient_ci::run] extract cache
[2026-01-15T06:19:18Z DEBUG ambient_ci::run] Executing post-plan steps
[2026-01-15T06:19:18Z DEBUG ambient_ci::plan] All actions were performed successfully
[2026-01-15T06:19:18Z DEBUG ambient_ci::project] write project state to /home/_rad/ambient-state/rad:zbWNQYkQ4QKgdSQcd1tjaemv6d6x/meta.yaml
[2026-01-15T06:19:19Z INFO  ambient] ambient ends successfully

Ambient stderr

<empty log>