CI run for cachedir

Radicle repository id rad:zhmWact4xuWp1XSwPER79oPUGW9S

Table of Contents

Run log

[2025-09-27T07:49:19Z INFO  ambient] ambient starts
[=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   6.1M  1 disk 
vdc    254:32   0   400K  1 disk 
vdd    254:48   0   9.3G  0 disk 
vde    254:64   0  46.6G  0 disk 
vdf    254:80   0 619.1M  1 disk 
INFO: Extracting tar archive from /dev/vdb
drwxr-xr-x _rad/_rad         0 2025-09-27 07:47 ./
-rw-r--r-- _rad/_rad      1086 2025-09-27 07:47 ./plan.yaml
-rwxr-xr-x _rad/_rad   6410400 2025-09-27 07:47 ./run-ci
INFO: Extracted files:
  4587528      4 drwxr-xr-x   2 1001     1001         4096 Sep 27 07:47 .
  4587531      4 -rw-r--r--   1 1001     1001         1086 Sep 27 07:47 ./plan.yaml
  4587532   6264 -rwxr-xr-x   1 1001     1001      6410400 Sep 27 07:47 ./run-ci
INFO: Running run-ci from /dev/vdb
================================ BEGIN ================================
[2025-09-27T07:47:33Z TRACE ambient_execute_plan] ambient-execute-plan version 0.7.0@2e86bbe starts
[2025-09-27T07:47:33Z DEBUG ambient_execute_plan] ambient-execute-plan version 0.7.0@2e86bbe starts
[2025-09-27T07:47:33Z INFO  ambient_execute_plan] ambient-execute-plan version 0.7.0@2e86bbe starts
[2025-09-27T07:47:33Z WARN  ambient_execute_plan] ambient-execute-plan version 0.7.0@2e86bbe starts
[2025-09-27T07:47:33Z ERROR ambient_execute_plan] ambient-execute-plan version 0.7.0@2e86bbe starts
RunnablePlan::from_file: filename=plan.yaml
steps:
- action: mkdir
  pathname: /workspace
- action: mkdir
  pathname: /workspace/artifacts
- action: tar_extract
  archive: /dev/vdc
  directory: /workspace/src
- action: tar_extract
  archive: /dev/vdf
  directory: /workspace/deps
- action: tar_extract
  archive: /dev/vde
  directory: /workspace/cache
- action: spawn
  argv:
  - find
  - /workspace
  - -maxdepth
  - '2'
  - -ls
- action: cargo_fmt
- action: cargo_clippy
- action: cargo_build
- action: cargo_test
- action: shell
  shell: |
    subplot docgen cachedir.subplot -o /workspace/artifacts/cachedir.html
- action: custom
  name: dch
  args:
    debemail: liw@liw.fi
    debfullname: Lars Wirzenius
- action: deb
- action: tar_create
  archive: /dev/vde
  directory: /workspace/cache
- action: tar_create
  archive: /dev/vdd
  directory: /workspace/artifacts
executor_drive: /dev/vdb
source_drive: /dev/vdc
artifact_drive: /dev/vdd
cache_drive: /dev/vde
deps_drive: /dev/vdf
workspace_dir: /workspace
source_dir: /workspace/src
deps_dir: /workspace/deps
cache_dir: /workspace/cache
artifacts_dir: /workspace/artifacts


[2025-09-27T07:47:33Z DEBUG ambient_ci::plan] RUN: Action Mkdir {
        pathname: "/workspace",
    }
[2025-09-27T07:47:33Z DEBUG ambient_ci::action] Plan::execute: plan=Mkdir {
        pathname: "/workspace",
    }
[2025-09-27T07:47:33Z DEBUG ambient_ci::action] Plan::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/workspace/cache",
            "CARGO_HOME": "/workspace/deps",
            "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
        },
        source_dir: "/workspace/src",
    }
[2025-09-27T07:47:33Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-27T07:47:33Z DEBUG ambient_ci::plan] RUN: Action Mkdir {
        pathname: "/workspace/artifacts",
    }
[2025-09-27T07:47:33Z DEBUG ambient_ci::action] Plan::execute: plan=Mkdir {
        pathname: "/workspace/artifacts",
    }
[2025-09-27T07:47:33Z DEBUG ambient_ci::action] Plan::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/workspace/cache",
            "CARGO_HOME": "/workspace/deps",
            "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
        },
        source_dir: "/workspace/src",
    }
[2025-09-27T07:47:33Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-27T07:47:33Z DEBUG ambient_ci::plan] RUN: Action TarExtract {
        archive: "/dev/vdc",
        directory: "/workspace/src",
    }
[2025-09-27T07:47:33Z DEBUG ambient_ci::action] Plan::execute: plan=TarExtract {
        archive: "/dev/vdc",
        directory: "/workspace/src",
    }
[2025-09-27T07:47:33Z DEBUG ambient_ci::action] Plan::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/workspace/cache",
            "CARGO_HOME": "/workspace/deps",
            "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
        },
        source_dir: "/workspace/src",
    }
[2025-09-27T07:47:33Z TRACE ambient_ci::vdrive] extracting /dev/vdc to /workspace/src
[2025-09-27T07:47:33Z TRACE ambient_ci::vdrive] extraction OK
[2025-09-27T07:47:33Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-27T07:47:33Z DEBUG ambient_ci::plan] RUN: Action TarExtract {
        archive: "/dev/vdf",
        directory: "/workspace/deps",
    }
[2025-09-27T07:47:33Z DEBUG ambient_ci::action] Plan::execute: plan=TarExtract {
        archive: "/dev/vdf",
        directory: "/workspace/deps",
    }
[2025-09-27T07:47:33Z DEBUG ambient_ci::action] Plan::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/workspace/cache",
            "CARGO_HOME": "/workspace/deps",
            "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
        },
        source_dir: "/workspace/src",
    }
[2025-09-27T07:47:33Z TRACE ambient_ci::vdrive] extracting /dev/vdf to /workspace/deps
[2025-09-27T07:47:35Z TRACE ambient_ci::vdrive] extraction OK
[2025-09-27T07:47:35Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-27T07:47:35Z DEBUG ambient_ci::plan] RUN: Action TarExtract {
        archive: "/dev/vde",
        directory: "/workspace/cache",
    }
[2025-09-27T07:47:35Z DEBUG ambient_ci::action] Plan::execute: plan=TarExtract {
        archive: "/dev/vde",
        directory: "/workspace/cache",
    }
[2025-09-27T07:47:35Z DEBUG ambient_ci::action] Plan::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/workspace/cache",
            "CARGO_HOME": "/workspace/deps",
            "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
        },
        source_dir: "/workspace/src",
    }
[2025-09-27T07:47:35Z TRACE ambient_ci::vdrive] extracting /dev/vde to /workspace/cache
[2025-09-27T07:47:35Z TRACE ambient_ci::vdrive] extraction OK
[2025-09-27T07:47:35Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-27T07:47:35Z DEBUG ambient_ci::plan] RUN: Action Spawn {
        argv: [
            "find",
            "/workspace",
            "-maxdepth",
            "2",
            "-ls",
        ],
    }
[2025-09-27T07:47:35Z DEBUG ambient_ci::action] Plan::execute: plan=Spawn {
        argv: [
            "find",
            "/workspace",
            "-maxdepth",
            "2",
            "-ls",
        ],
    }
[2025-09-27T07:47:35Z DEBUG ambient_ci::action] Plan::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/workspace/cache",
            "CARGO_HOME": "/workspace/deps",
            "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
        },
        source_dir: "/workspace/src",
    }
SPAWN: argv=["find", "/workspace", "-maxdepth", "2", "-ls"]
       cwd=/workspace/src (exists? true)
  2621441      4 drwxr-xr-x   6 root     root         4096 Sep 27 07:47 /workspace
  2621617      4 drwxr-xr-x   3 root     root         4096 Sep 27 07:47 /workspace/deps
  2621618      0 -rw-r--r--   1 root     root            0 Sep 27 07:47 /workspace/deps/.package-cache-mutate
  2621621      4 drwxr-xr-x   5 root     root         4096 Sep 27 07:47 /workspace/deps/registry
  2621619     88 -rw-r--r--   1 root     root        90112 Sep 27 07:47 /workspace/deps/.global-cache
  2621620      0 -rw-r--r--   1 root     root            0 Sep 27 07:47 /workspace/deps/.package-cache
  2621443      4 drwxr-xr-x   8 root     root         4096 Sep 27 07:47 /workspace/src
  2621469      4 -rw-r--r--   1 root     root          373 Sep 27 07:47 /workspace/src/Cargo.toml
  2621449      4 -rwxr-xr-x   1 root     root          590 Sep 27 07:47 /workspace/src/check
  2621446      4 -rw-r--r--   1 root     root         1015 Sep 27 07:47 /workspace/src/subplot.rs
  2621467      4 -rw-r--r--   1 root     root          200 Sep 27 07:47 /workspace/src/build.rs
  2621472      4 drwxr-xr-x   8 root     root         4096 Sep 27 07:47 /workspace/src/.git
  2621454      4 -rw-r--r--   1 root     root           84 Sep 27 07:47 /workspace/src/subplot.yaml
  2621450      4 drwxr-xr-x   3 root     root         4096 Sep 27 07:47 /workspace/src/src
  2621466      4 -rw-r--r--   1 root     root         1025 Sep 27 07:47 /workspace/src/README.md
  2621447      4 drwxr-xr-x   2 root     root         4096 Sep 27 07:47 /workspace/src/.ambient
  2621444      4 drwxr-xr-x   2 root     root         4096 Sep 27 07:47 /workspace/src/.radicle
  2621456      4 drwxr-xr-x   3 root     root         4096 Sep 27 07:47 /workspace/src/debian
  2621616     48 -rw-r--r--   1 root     root        48002 Sep 27 07:47 /workspace/src/Cargo.lock
  2621468      4 -rw-r--r--   1 root     root           21 Sep 27 07:47 /workspace/src/.gitignore
  2621470      4 drwxr-xr-x   2 root     root         4096 Sep 27 07:47 /workspace/src/tests
  2621615      4 -rw-r--r--   1 root     root          211 Sep 27 07:47 /workspace/src/cachedir.subplot
  2621455      4 -rw-r--r--   1 root     root         2275 Sep 27 07:47 /workspace/src/cachedir.md
  2621442      4 drwxr-xr-x   2 root     root         4096 Sep 27 07:47 /workspace/artifacts
  2636405      4 drwxr-xr-x   2 root     root         4096 Sep 27 07:47 /workspace/cache
  2636406      4 -rw-r--r--   1 root     root         1038 Sep 27 07:47 /workspace/cache/.rustc_info.json
[2025-09-27T07:47:36Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-27T07:47:36Z DEBUG ambient_ci::plan] RUN: Action CargoFmt
[2025-09-27T07:47:36Z DEBUG ambient_ci::action] Plan::execute: plan=CargoFmt
[2025-09-27T07:47:36Z DEBUG ambient_ci::action] Plan::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/workspace/cache",
            "CARGO_HOME": "/workspace/deps",
            "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
        },
        source_dir: "/workspace/src",
    }
SPAWN: argv=["cargo", "--version"]
       cwd=/workspace/src (exists? true)
cargo 1.88.0 (873a06493 2025-05-10)
SPAWN: argv=["cargo", "clippy", "--version"]
       cwd=/workspace/src (exists? true)
clippy 0.1.88 (6b00bc3880 2025-06-23)
SPAWN: argv=["rustc", "--version"]
       cwd=/workspace/src (exists? true)
rustc 1.88.0 (6b00bc388 2025-06-23)
SPAWN: argv=["cargo", "fmt", "--check"]
       cwd=/workspace/src (exists? true)
[2025-09-27T07:47:36Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-27T07:47:36Z DEBUG ambient_ci::plan] RUN: Action CargoClippy
[2025-09-27T07:47:36Z DEBUG ambient_ci::action] Plan::execute: plan=CargoClippy
[2025-09-27T07:47:36Z DEBUG ambient_ci::action] Plan::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/workspace/cache",
            "CARGO_HOME": "/workspace/deps",
            "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
        },
        source_dir: "/workspace/src",
    }
SPAWN: argv=["cargo", "--version"]
       cwd=/workspace/src (exists? true)
cargo 1.88.0 (873a06493 2025-05-10)
SPAWN: argv=["cargo", "clippy", "--version"]
       cwd=/workspace/src (exists? true)
clippy 0.1.88 (6b00bc3880 2025-06-23)
SPAWN: argv=["rustc", "--version"]
       cwd=/workspace/src (exists? true)
rustc 1.88.0 (6b00bc388 2025-06-23)
SPAWN: argv=["cargo", "clippy", "--offline", "--locked", "--workspace", "--all-targets", "--no-deps", "--", "--deny", "warnings"]
       cwd=/workspace/src (exists? true)
   Compiling proc-macro2 v1.0.83
   Compiling unicode-ident v1.0.12
   Compiling libc v0.2.155
   Compiling memchr v2.7.2
   Compiling thiserror v1.0.61
   Compiling serde v1.0.202
   Compiling aho-corasick v1.1.3
   Compiling itoa v1.0.11
   Compiling crossbeam-utils v0.8.20
   Compiling quote v1.0.36
   Compiling syn v2.0.65
   Compiling regex-syntax v0.8.3
   Compiling log v0.4.21
   Compiling cfg-if v1.0.0
   Compiling once_cell v1.19.0
   Compiling same-file v1.0.6
   Compiling rustix v0.38.34
   Compiling ryu v1.0.18
   Compiling walkdir v2.5.0
   Compiling regex-automata v0.4.6
   Compiling getrandom v0.2.15
   Compiling ucd-trie v0.1.6
   Compiling time-core v0.1.2
   Compiling autocfg v1.3.0
   Compiling anyhow v1.0.86
   Compiling num-conv v0.1.0
   Compiling indexmap v1.9.3
   Compiling crossbeam-epoch v0.9.18
   Compiling time-macros v0.2.18
   Compiling rand_core v0.6.4
   Compiling bstr v1.9.1
   Compiling thiserror-impl v1.0.61
   Compiling serde_derive v1.0.202
   Compiling serde_json v1.0.117
   Compiling libm v0.2.8
   Compiling version_check v0.9.4
   Compiling unic-common v0.9.0
   Compiling ppv-lite86 v0.2.17
   Compiling unicode-width v0.1.12
   Compiling utf8parse v0.2.1
   Compiling bitflags v2.5.0
   Compiling powerfmt v0.2.0
   Compiling unic-char-range v0.9.0
   Compiling pest v2.7.10
   Compiling unic-char-property v0.9.0
   Compiling deranged v0.3.11
   Compiling rand_chacha v0.3.1
   Compiling anstyle-parse v0.2.4
   Compiling unic-ucd-version v0.9.0
   Compiling unicase v2.7.0
   Compiling globset v0.4.14
   Compiling crossbeam-deque v0.8.5
   Compiling pest_meta v2.7.10
   Compiling colorchoice v1.0.1
   Compiling hashbrown v0.12.3
   Compiling linux-raw-sys v0.4.14
   Compiling heck v0.5.0
   Compiling anstyle-query v1.0.3
   Compiling is_terminal_polyfill v1.70.0
   Compiling cc v1.0.98
   Compiling linked-hash-map v0.5.6
   Compiling anstyle v1.0.7
   Compiling anstream v0.6.14
   Compiling yaml-rust v0.4.5
   Compiling pest_generator v2.7.10
   Compiling pikchr v0.1.3
   Compiling clap_derive v4.5.4
   Compiling ignore v0.4.22
   Compiling time v0.3.36
   Compiling unic-ucd-segment v0.9.0
   Compiling rand v0.8.5
   Compiling regex v1.10.4
   Compiling bitflags v1.3.2
   Compiling unicode-linebreak v0.1.5
   Compiling smawk v0.3.2
   Compiling hashbrown v0.14.5
   Compiling pulldown-cmark v0.9.6
   Compiling fastrand v2.1.0
   Compiling equivalent v1.0.1
   Compiling deunicode v1.6.0
   Compiling strsim v0.11.1
   Compiling clap_lex v0.7.0
   Compiling slug v0.1.5
   Compiling indexmap v2.2.6
   Compiling clap_builder v4.5.2
   Compiling git-testament-derive v0.2.0
   Compiling tempfile v3.10.1
   Compiling textwrap v0.15.2
   Compiling globwalk v0.8.1
   Compiling unic-segment v0.9.0
   Compiling humansize v2.1.3
   Compiling serde_yaml v0.8.26
   Compiling pest_derive v2.7.10
   Compiling subplot v0.9.0
   Compiling getopts v0.2.21
   Compiling is-terminal v0.4.12
   Compiling humantime v2.1.0
   Compiling unsafe-libyaml v0.2.11
   Compiling lazy_static v1.4.0
   Compiling percent-encoding v2.3.1
   Compiling utf8-width v0.1.7
   Compiling termcolor v1.4.1
   Compiling tera v1.19.1
   Compiling env_logger v0.10.2
   Compiling serde_yaml v0.9.34+deprecated
   Compiling clap v4.5.4
   Compiling html-escape v0.2.13
   Compiling roadmap v0.5.0
   Compiling git-testament v0.2.5
   Compiling tempfile-fast v0.3.4
   Compiling serde-aux v4.5.0
   Compiling tracing-attributes v0.1.27
   Compiling tracing-core v0.1.32
   Compiling line-col v0.2.1
   Compiling file_diff v1.0.0
   Compiling pin-project-lite v0.2.14
   Compiling base64 v0.21.7
   Compiling syn v1.0.109
   Compiling tracing v0.1.40
   Compiling subplot-build v0.9.0
    Checking nix v0.26.4
   Compiling cachedir v9.1.0 (/workspace/src)
    Checking cvt v0.1.2
   Compiling glob v0.3.1
   Compiling subplotlib v0.9.0
   Compiling fehler-macros v1.0.0
    Checking fs_at v0.1.10
    Checking normpath v1.2.0
   Compiling fehler v1.0.0
   Compiling subplotlib-derive v0.9.0
    Checking remove_dir_all v0.8.2
    Checking fs2 v0.4.3
    Checking filetime v0.2.23
    Checking state v0.5.3
    Checking shell-words v1.1.0
    Checking unescape v0.1.0
    Finished `dev` profile [unoptimized + debuginfo] target(s) in 38.39s
[2025-09-27T07:48:15Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-27T07:48:15Z DEBUG ambient_ci::plan] RUN: Action CargoBuild
[2025-09-27T07:48:15Z DEBUG ambient_ci::action] Plan::execute: plan=CargoBuild
[2025-09-27T07:48:15Z DEBUG ambient_ci::action] Plan::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/workspace/cache",
            "CARGO_HOME": "/workspace/deps",
            "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
        },
        source_dir: "/workspace/src",
    }
SPAWN: argv=["cargo", "--version"]
       cwd=/workspace/src (exists? true)
cargo 1.88.0 (873a06493 2025-05-10)
SPAWN: argv=["cargo", "clippy", "--version"]
       cwd=/workspace/src (exists? true)
clippy 0.1.88 (6b00bc3880 2025-06-23)
SPAWN: argv=["rustc", "--version"]
       cwd=/workspace/src (exists? true)
rustc 1.88.0 (6b00bc388 2025-06-23)
SPAWN: argv=["cargo", "build", "--offline", "--locked", "--workspace", "--all-targets"]
       cwd=/workspace/src (exists? true)
   Compiling libc v0.2.155
   Compiling memchr v2.7.2
   Compiling cfg-if v1.0.0
   Compiling itoa v1.0.11
   Compiling regex-syntax v0.8.3
   Compiling thiserror v1.0.61
   Compiling same-file v1.0.6
   Compiling walkdir v2.5.0
   Compiling aho-corasick v1.1.3
   Compiling bitflags v1.3.2
   Compiling pest v2.7.10
   Compiling getrandom v0.2.15
   Compiling rand_core v0.6.4
   Compiling bstr v1.9.1
   Compiling regex-automata v0.4.6
   Compiling num-conv v0.1.0
   Compiling bitflags v2.5.0
   Compiling powerfmt v0.2.0
   Compiling time-core v0.1.2
   Compiling utf8parse v0.2.1
   Compiling time-macros v0.2.18
   Compiling anstyle-parse v0.2.4
   Compiling deranged v0.3.11
   Compiling rand_chacha v0.3.1
   Compiling pest_meta v2.7.10
   Compiling anstyle v1.0.7
   Compiling anstyle-query v1.0.3
   Compiling colorchoice v1.0.1
   Compiling linux-raw-sys v0.4.14
   Compiling globset v0.4.14
   Compiling is_terminal_polyfill v1.70.0
   Compiling anstream v0.6.14
   Compiling ignore v0.4.22
   Compiling rustix v0.38.34
   Compiling time v0.3.36
   Compiling pest_generator v2.7.10
   Compiling regex v1.10.4
   Compiling rand v0.8.5
   Compiling serde_json v1.0.117
   Compiling fastrand v2.1.0
   Compiling lazy_static v1.4.0
   Compiling clap_lex v0.7.0
   Compiling strsim v0.11.1
   Compiling git-testament-derive v0.2.0
   Compiling clap_builder v4.5.2
   Compiling tempfile v3.10.1
   Compiling pest_derive v2.7.10
   Compiling globwalk v0.8.1
   Compiling subplot v0.9.0
   Compiling is-terminal v0.4.12
   Compiling env_logger v0.10.2
   Compiling git-testament v0.2.5
   Compiling serde_yaml v0.9.34+deprecated
   Compiling tera v1.19.1
   Compiling pulldown-cmark v0.9.6
   Compiling clap v4.5.4
   Compiling tempfile-fast v0.3.4
   Compiling pikchr v0.1.3
   Compiling roadmap v0.5.0
   Compiling serde-aux v4.5.0
   Compiling base64 v0.21.7
   Compiling nix v0.26.4
   Compiling cvt v0.1.2
   Compiling fs_at v0.1.10
   Compiling fehler v1.0.0
   Compiling normpath v1.2.0
   Compiling remove_dir_all v0.8.2
   Compiling subplotlib-derive v0.9.0
   Compiling subplot-build v0.9.0
   Compiling filetime v0.2.23
   Compiling fs2 v0.4.3
   Compiling unescape v0.1.0
   Compiling shell-words v1.1.0
   Compiling state v0.5.3
   Compiling cachedir v9.1.0 (/workspace/src)
   Compiling subplotlib v0.9.0
    Finished `dev` profile [unoptimized + debuginfo] target(s) in 14.92s
[2025-09-27T07:48:30Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-27T07:48:30Z DEBUG ambient_ci::plan] RUN: Action CargoTest
[2025-09-27T07:48:30Z DEBUG ambient_ci::action] Plan::execute: plan=CargoTest
[2025-09-27T07:48:30Z DEBUG ambient_ci::action] Plan::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/workspace/cache",
            "CARGO_HOME": "/workspace/deps",
            "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
        },
        source_dir: "/workspace/src",
    }
SPAWN: argv=["cargo", "--version"]
       cwd=/workspace/src (exists? true)
cargo 1.88.0 (873a06493 2025-05-10)
SPAWN: argv=["cargo", "clippy", "--version"]
       cwd=/workspace/src (exists? true)
clippy 0.1.88 (6b00bc3880 2025-06-23)
SPAWN: argv=["rustc", "--version"]
       cwd=/workspace/src (exists? true)
rustc 1.88.0 (6b00bc388 2025-06-23)
SPAWN: argv=["cargo", "test", "--offline", "--locked", "--workspace"]
       cwd=/workspace/src (exists? true)
    Finished `test` profile [unoptimized + debuginfo] target(s) in 0.07s
     Running unittests src/lib.rs (/workspace/cache/debug/deps/cachedir-3bc7e529cb05a405)

running 0 tests

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

     Running unittests src/bin/cachedir.rs (/workspace/cache/debug/deps/cachedir-7282b54efa332aaf)

running 0 tests

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

     Running tests/subplot.rs (/workspace/cache/debug/deps/subplot-5a4b17446178ddc1)

running 1 test
test managing_cache_directories ... ok

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

   Doc-tests cachedir

running 0 tests

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

[2025-09-27T07:48:30Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-27T07:48:30Z DEBUG ambient_ci::plan] RUN: Action Shell {
        shell: "subplot docgen cachedir.subplot -o /workspace/artifacts/cachedir.html\n",
    }
[2025-09-27T07:48:30Z DEBUG ambient_ci::action] Plan::execute: plan=Shell {
        shell: "subplot docgen cachedir.subplot -o /workspace/artifacts/cachedir.html\n",
    }
[2025-09-27T07:48:30Z DEBUG ambient_ci::action] Plan::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/workspace/cache",
            "CARGO_HOME": "/workspace/deps",
            "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
        },
        source_dir: "/workspace/src",
    }
SPAWN: argv=["/bin/bash", "-c", "set -xeuo pipefail\nsubplot docgen cachedir.subplot -o /workspace/artifacts/cachedir.html\n\n"]
       cwd=/workspace/src (exists? true)
+ subplot docgen cachedir.subplot -o /workspace/artifacts/cachedir.html
 INFO Starting Subplot
 INFO Subplot finished successfully
[2025-09-27T07:48:30Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-27T07:48:30Z DEBUG ambient_ci::plan] RUN: Action Custom(
        Custom {
            name: "dch",
            args: {
                "debemail": String("liw@liw.fi"),
                "debfullname": String("Lars Wirzenius"),
            },
        },
    )
[2025-09-27T07:48:30Z DEBUG ambient_ci::action] Plan::execute: plan=Custom(
        Custom {
            name: "dch",
            args: {
                "debemail": String("liw@liw.fi"),
                "debfullname": String("Lars Wirzenius"),
            },
        },
    )
[2025-09-27T07:48:30Z DEBUG ambient_ci::action] Plan::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/workspace/cache",
            "CARGO_HOME": "/workspace/deps",
            "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
        },
        source_dir: "/workspace/src",
    }
custom: source=/workspace/src
custom: exe=".ambient/dch" exists=false
HEAD is now at aae0231 ci: use custom dch action under Ambient
custom action "dch" exit code Some(0)
[2025-09-27T07:48:31Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-27T07:48:31Z DEBUG ambient_ci::plan] RUN: Action Deb
[2025-09-27T07:48:31Z DEBUG ambient_ci::action] Plan::execute: plan=Deb
[2025-09-27T07:48:31Z DEBUG ambient_ci::action] Plan::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/workspace/cache",
            "CARGO_HOME": "/workspace/deps",
            "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
        },
        source_dir: "/workspace/src",
    }
SPAWN: argv=["/bin/bash", "-c", "#!/bin/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 ../*_* /workspace/artifacts\n        "]
       cwd=/workspace/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=/workspace/cache
PWD=/workspace/src
SYSTEMD_EXEC_PID=278
LANG=C.UTF-8
CARGO_HOME=/workspace/deps
DEBEMAIL=liw@liw.fi
INVOCATION_ID=c813ce5f535746c7811ae462addf436f
SHLVL=2
JOURNAL_STREAM=8:13086
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.88.0 (873a06493 2025-05-10)
+ rustc --version
rustc 1.88.0 (6b00bc388 2025-06-23)
++ dpkg-parsechangelog -SSource
+ name=cachedir
++ dpkg-parsechangelog -SVersion
+ version=9.1.0.ci20250927T074831-1
++ echo 9.1.0.ci20250927T074831-1
++ sed 's/-[^-]*$//'
+ uv=9.1.0.ci20250927T074831
++ dpkg --print-architecture
+ arch=amd64
+ orig=../cachedir_9.1.0.ci20250927T074831.orig.tar.xz
+ deb=../cachedir_9.1.0.ci20250927T074831-1_amd64.deb
+ changes=../cachedir_9.1.0.ci20250927T074831-1_amd64.changes
+ git archive HEAD
+ xz
+ dpkg-buildpackage -us -uc
dpkg-buildpackage: info: source package cachedir
dpkg-buildpackage: info: source version 9.1.0.ci20250927T074831-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_clean
 dpkg-source -b .
dpkg-source: info: using source format '3.0 (quilt)'
dpkg-source: info: building cachedir using existing ./cachedir_9.1.0.ci20250927T074831.orig.tar.xz
dpkg-source: info: building cachedir in cachedir_9.1.0.ci20250927T074831-1.debian.tar.xz
dpkg-source: info: building cachedir in cachedir_9.1.0.ci20250927T074831-1.dsc
 debian/rules build
dh build
   dh_update_autotools_config
   dh_autoreconf
   debian/rules override_dh_auto_build
make[1]: Entering directory '/workspace/src'
true
make[1]: Leaving directory '/workspace/src'
   debian/rules override_dh_auto_test
make[1]: Entering directory '/workspace/src'
echo "disabled: cargo test"
disabled: cargo test
make[1]: Leaving directory '/workspace/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 '/workspace/src'
cargo install --path=. --root=debian/cachedir --offline --locked
  Installing cachedir v9.1.0 (/workspace/src)
   Compiling proc-macro2 v1.0.83
   Compiling unicode-ident v1.0.12
   Compiling memchr v2.7.2
   Compiling libc v0.2.155
   Compiling thiserror v1.0.61
   Compiling serde v1.0.202
   Compiling aho-corasick v1.1.3
   Compiling quote v1.0.36
   Compiling syn v2.0.65
   Compiling crossbeam-utils v0.8.20
   Compiling regex-syntax v0.8.3
   Compiling cfg-if v1.0.0
   Compiling log v0.4.21
   Compiling itoa v1.0.11
   Compiling once_cell v1.19.0
   Compiling same-file v1.0.6
   Compiling ryu v1.0.18
   Compiling walkdir v2.5.0
   Compiling getrandom v0.2.15
   Compiling autocfg v1.3.0
   Compiling ucd-trie v0.1.6
   Compiling anyhow v1.0.86
   Compiling regex-automata v0.4.6
   Compiling indexmap v1.9.3
   Compiling rand_core v0.6.4
   Compiling crossbeam-epoch v0.9.18
   Compiling bstr v1.9.1
   Compiling ppv-lite86 v0.2.17
   Compiling serde_json v1.0.117
   Compiling rustix v0.38.34
   Compiling num-conv v0.1.0
   Compiling version_check v0.9.4
   Compiling utf8parse v0.2.1
   Compiling unic-char-range v0.9.0
   Compiling unic-common v0.9.0
   Compiling unicode-width v0.1.12
   Compiling time-core v0.1.2
   Compiling bitflags v2.5.0
   Compiling libm v0.2.8
   Compiling powerfmt v0.2.0
   Compiling time-macros v0.2.18
   Compiling deranged v0.3.11
   Compiling globset v0.4.14
   Compiling thiserror-impl v1.0.61
   Compiling serde_derive v1.0.202
   Compiling unicase v2.7.0
   Compiling unic-ucd-version v0.9.0
   Compiling unic-char-property v0.9.0
   Compiling anstyle-parse v0.2.4
   Compiling rand_chacha v0.3.1
   Compiling crossbeam-deque v0.8.5
   Compiling colorchoice v1.0.1
   Compiling hashbrown v0.12.3
   Compiling linux-raw-sys v0.4.14
   Compiling pest v2.7.10
   Compiling anstyle-query v1.0.3
   Compiling heck v0.5.0
   Compiling anstyle v1.0.7
   Compiling is_terminal_polyfill v1.70.0
   Compiling cc v1.0.98
   Compiling linked-hash-map v0.5.6
   Compiling yaml-rust v0.4.5
   Compiling pest_meta v2.7.10
   Compiling anstream v0.6.14
   Compiling pikchr v0.1.3
   Compiling clap_derive v4.5.4
   Compiling pest_generator v2.7.10
   Compiling ignore v0.4.22
   Compiling rand v0.8.5
   Compiling unic-ucd-segment v0.9.0
   Compiling time v0.3.36
   Compiling regex v1.10.4
   Compiling deunicode v1.6.0
   Compiling bitflags v1.3.2
   Compiling equivalent v1.0.1
   Compiling unicode-linebreak v0.1.5
   Compiling fastrand v2.1.0
   Compiling clap_lex v0.7.0
   Compiling strsim v0.11.1
   Compiling hashbrown v0.14.5
   Compiling smawk v0.3.2
   Compiling pulldown-cmark v0.9.6
   Compiling textwrap v0.15.2
   Compiling git-testament-derive v0.2.0
   Compiling indexmap v2.2.6
   Compiling clap_builder v4.5.2
   Compiling tempfile v3.10.1
   Compiling globwalk v0.8.1
   Compiling humansize v2.1.3
   Compiling slug v0.1.5
   Compiling serde_yaml v0.8.26
   Compiling unic-segment v0.9.0
   Compiling pest_derive v2.7.10
   Compiling subplot v0.9.0
   Compiling getopts v0.2.21
   Compiling is-terminal v0.4.12
   Compiling unsafe-libyaml v0.2.11
   Compiling humantime v2.1.0
   Compiling lazy_static v1.4.0
   Compiling utf8-width v0.1.7
   Compiling termcolor v1.4.1
   Compiling percent-encoding v2.3.1
   Compiling tera v1.19.1
   Compiling serde_yaml v0.9.34+deprecated
   Compiling env_logger v0.10.2
   Compiling html-escape v0.2.13
   Compiling clap v4.5.4
   Compiling roadmap v0.5.0
   Compiling git-testament v0.2.5
   Compiling tempfile-fast v0.3.4
   Compiling serde-aux v4.5.0
   Compiling tracing-attributes v0.1.27
   Compiling tracing-core v0.1.32
   Compiling line-col v0.2.1
   Compiling base64 v0.21.7
   Compiling file_diff v1.0.0
   Compiling pin-project-lite v0.2.14
   Compiling tracing v0.1.40
   Compiling subplot-build v0.9.0
   Compiling cachedir v9.1.0 (/workspace/src)
    Finished `release` profile [optimized] target(s) in 27.55s
  Installing debian/cachedir/bin/cachedir
   Installed package `cachedir v9.1.0 (/workspace/src)` (executable `cachedir`)
warning: be sure to add `debian/cachedir/bin` to your PATH to be able to run the installed binaries
find debian/cachedir -name '.crates*' -delete
make[1]: Leaving directory '/workspace/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
dpkg-gencontrol: warning: Built-Using field of package cachedir: substitution variable ${cargo:Built-Using} used, but is not defined
dpkg-gencontrol: warning: Built-Using field of package cachedir: substitution variable ${cargo:Built-Using} used, but is not defined
   dh_md5sums
   dh_builddeb
dpkg-deb: building package 'cachedir-dbgsym' in '../cachedir-dbgsym_9.1.0.ci20250927T074831-1_amd64.deb'.
dpkg-deb: building package 'cachedir' in '../cachedir_9.1.0.ci20250927T074831-1_amd64.deb'.
 dpkg-genbuildinfo -O../cachedir_9.1.0.ci20250927T074831-1_amd64.buildinfo
 dpkg-genchanges -O../cachedir_9.1.0.ci20250927T074831-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 428
drwxr-xr-x 2 root root   4096 Sep 27 07:48 artifacts
drwxr-xr-x 5 root root   4096 Sep 27 07:48 cache
-rw-r--r-- 1 root root  46052 Sep 27 07:49 cachedir-dbgsym_9.1.0.ci20250927T074831-1_amd64.deb
-rw-r--r-- 1 root root   1384 Sep 27 07:48 cachedir_9.1.0.ci20250927T074831-1.debian.tar.xz
-rw-r--r-- 1 root root    956 Sep 27 07:48 cachedir_9.1.0.ci20250927T074831-1.dsc
-rw-r--r-- 1 root root   6332 Sep 27 07:49 cachedir_9.1.0.ci20250927T074831-1_amd64.buildinfo
-rw-r--r-- 1 root root   2369 Sep 27 07:49 cachedir_9.1.0.ci20250927T074831-1_amd64.changes
-rw-r--r-- 1 root root 331924 Sep 27 07:49 cachedir_9.1.0.ci20250927T074831-1_amd64.deb
-rw-r--r-- 1 root root  16244 Sep 27 07:48 cachedir_9.1.0.ci20250927T074831.orig.tar.xz
drwxr-xr-x 3 root root   4096 Sep 27 07:47 deps
drwxr-xr-x 8 root root   4096 Sep 27 07:48 src
+ for x in ../*.deb
+ dpkg -c ../cachedir-dbgsym_9.1.0.ci20250927T074831-1_amd64.deb
drwxr-xr-x root/root         0 2025-09-27 07:48 ./
drwxr-xr-x root/root         0 2025-09-27 07:48 ./usr/
drwxr-xr-x root/root         0 2025-09-27 07:48 ./usr/lib/
drwxr-xr-x root/root         0 2025-09-27 07:48 ./usr/lib/debug/
drwxr-xr-x root/root         0 2025-09-27 07:48 ./usr/lib/debug/.build-id/
drwxr-xr-x root/root         0 2025-09-27 07:48 ./usr/lib/debug/.build-id/74/
-rw-r--r-- root/root    218952 2025-09-27 07:48 ./usr/lib/debug/.build-id/74/dc05ec892b8dfc4a10a1a7504f9f80b74ae6b2.debug
drwxr-xr-x root/root         0 2025-09-27 07:48 ./usr/share/
drwxr-xr-x root/root         0 2025-09-27 07:48 ./usr/share/doc/
lrwxrwxrwx root/root         0 2025-09-27 07:48 ./usr/share/doc/cachedir-dbgsym -> cachedir
+ for x in ../*.deb
+ dpkg -c ../cachedir_9.1.0.ci20250927T074831-1_amd64.deb
drwxr-xr-x root/root         0 2025-09-27 07:48 ./
drwxr-xr-x root/root         0 2025-09-27 07:48 ./bin/
-rwxr-xr-x root/root   1008352 2025-09-27 07:48 ./bin/cachedir
drwxr-xr-x root/root         0 2025-09-27 07:48 ./usr/
drwxr-xr-x root/root         0 2025-09-27 07:48 ./usr/share/
drwxr-xr-x root/root         0 2025-09-27 07:48 ./usr/share/doc/
drwxr-xr-x root/root         0 2025-09-27 07:48 ./usr/share/doc/cachedir/
-rw-r--r-- root/root       384 2025-09-27 07:48 ./usr/share/doc/cachedir/changelog.Debian.gz
-rw-r--r-- root/root       299 2025-09-27 07:48 ./usr/share/doc/cachedir/copyright
drwxr-xr-x root/root         0 2025-09-27 07:48 ./usr/share/lintian/
drwxr-xr-x root/root         0 2025-09-27 07:48 ./usr/share/lintian/overrides/
-rw-r--r-- root/root        32 2025-09-27 07:48 ./usr/share/lintian/overrides/cachedir
+ mv ../cachedir-dbgsym_9.1.0.ci20250927T074831-1_amd64.deb ../cachedir_9.1.0.ci20250927T074831-1.debian.tar.xz ../cachedir_9.1.0.ci20250927T074831-1.dsc ../cachedir_9.1.0.ci20250927T074831-1_amd64.buildinfo ../cachedir_9.1.0.ci20250927T074831-1_amd64.changes ../cachedir_9.1.0.ci20250927T074831-1_amd64.deb ../cachedir_9.1.0.ci20250927T074831.orig.tar.xz /workspace/artifacts
[2025-09-27T07:49:02Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-27T07:49:02Z DEBUG ambient_ci::plan] RUN: Action TarCreate {
        archive: "/dev/vde",
        directory: "/workspace/cache",
    }
[2025-09-27T07:49:02Z DEBUG ambient_ci::action] Plan::execute: plan=TarCreate {
        archive: "/dev/vde",
        directory: "/workspace/cache",
    }
[2025-09-27T07:49:02Z DEBUG ambient_ci::action] Plan::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/workspace/cache",
            "CARGO_HOME": "/workspace/deps",
            "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
        },
        source_dir: "/workspace/src",
    }
[2025-09-27T07:49:02Z TRACE ambient_ci::vdrive] creating virtual drive (tar archive): VirtualDriveBuilder {
        filename: Some(
            "/dev/vde",
        ),
        root: Some(
            "/workspace/cache",
        ),
        size: None,
    }
[2025-09-27T07:49:02Z TRACE ambient_ci::vdrive] tar archive to be created: /dev/vde; exists? true
[2025-09-27T07:49:02Z TRACE ambient_ci::vdrive] create archive file /dev/vde
[2025-09-27T07:49:02Z TRACE ambient_ci::vdrive] directory /workspace/cache exists? true
[2025-09-27T07:49:02Z TRACE ambient_ci::vdrive] add contents of /workspace/cache as .
[2025-09-27T07:49:02Z TRACE ambient_ci::vdrive] calling tar_create
[2025-09-27T07:49:07Z TRACE ambient_ci::vdrive] created virtual drive /dev/vde
[2025-09-27T07:49:07Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-27T07:49:07Z DEBUG ambient_ci::plan] RUN: Action TarCreate {
        archive: "/dev/vdd",
        directory: "/workspace/artifacts",
    }
[2025-09-27T07:49:07Z DEBUG ambient_ci::action] Plan::execute: plan=TarCreate {
        archive: "/dev/vdd",
        directory: "/workspace/artifacts",
    }
[2025-09-27T07:49:07Z DEBUG ambient_ci::action] Plan::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/workspace/cache",
            "CARGO_HOME": "/workspace/deps",
            "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
        },
        source_dir: "/workspace/src",
    }
[2025-09-27T07:49:07Z TRACE ambient_ci::vdrive] creating virtual drive (tar archive): VirtualDriveBuilder {
        filename: Some(
            "/dev/vdd",
        ),
        root: Some(
            "/workspace/artifacts",
        ),
        size: None,
    }
[2025-09-27T07:49:07Z TRACE ambient_ci::vdrive] tar archive to be created: /dev/vdd; exists? true
[2025-09-27T07:49:07Z TRACE ambient_ci::vdrive] create archive file /dev/vdd
[2025-09-27T07:49:07Z TRACE ambient_ci::vdrive] directory /workspace/artifacts exists? true
[2025-09-27T07:49:07Z TRACE ambient_ci::vdrive] add contents of /workspace/artifacts as .
[2025-09-27T07:49:07Z TRACE ambient_ci::vdrive] calling tar_create
[2025-09-27T07:49:07Z TRACE ambient_ci::vdrive] created virtual drive /dev/vdd
[2025-09-27T07:49:07Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-27T07:49:07Z DEBUG ambient_ci::plan] All actions were performed successfully
ambient-execute-plan ends
EXIT CODE: 0
[2025-09-27T07:49:19Z INFO  ambient] ambient ends successfully

Trigger message

{
  "request": "trigger",
  "version": 1,
  "event_type": "push",
  "repository": {
    "id": "rad:zhmWact4xuWp1XSwPER79oPUGW9S",
    "name": "cachedir",
    "description": "Manage CACHEDIR.TAG files on the file system",
    "private": false,
    "default_branch": "main",
    "delegates": [
      "did:key:z6MkgEMYod7Hxfy9qCvDv5hYHkZ4ciWmLFgfvm3Wn1b2w2FV"
    ]
  },
  "pusher": {
    "id": "did:key:z6MkkYez6QAFWvmdudjrfMXySu1NTpSrraJotCJFwGgkmgx8",
    "alias": "ci0"
  },
  "before": "aae02312d81f5181002ffdd7552afdf578e97ec8",
  "after": "aae02312d81f5181002ffdd7552afdf578e97ec8",
  "branch": "main",
  "commits": [
    "aae02312d81f5181002ffdd7552afdf578e97ec8"
  ]
}

Ambient stdout

[2025-09-27T07:47:02Z INFO  ambient] ambient starts
[2025-09-27T07:47:02Z DEBUG ambient] load default configuration file /home/_rad/.config/ambient/config.yaml if it exists
[2025-09-27T07:47:02Z DEBUG ambient] load files named with --config: /tmp/.tmpkNvpmE/ambient_extra_values.yaml
[2025-09-27T07:47:02Z DEBUG ambient] complete configuration: Config {
        tmpdir: "/srv/tmp",
        image_store: "/home/_rad/.local/state/ambient-ci/images",
        projects: "/home/_rad/ambient-projects.yaml",
        state: "/srv/ambient-state",
        rsync_target: None,
        rsync_target_base: Some(
            "ci@http.liw.fi:/srv/http/doc.liw.fi",
        ),
        rsync_target_map: None,
        dput_target: Some(
            "apt.liw.fi",
        ),
        executor: Some(
            "/usr/bin/ambient-execute-plan",
        ),
        artifacts_max_size: Byte(
            10000000000,
        ),
        cache_max_size: Byte(
            50000000000,
        ),
        qemu: QemuConfig {
            cpus: 4,
            memory: Byte(
                8000000000,
            ),
            kvm_binary: "/usr/bin/kvm",
            ovmf_vars_file: "/usr/share/ovmf/OVMF.fd",
            ovmf_code_file: "/usr/share/ovmf/OVMF.fd",
        },
    }
[2025-09-27T07:47:02Z DEBUG ambient] configuration: Config {
        tmpdir: "/srv/tmp",
        image_store: "/home/_rad/.local/state/ambient-ci/images",
        projects: "/home/_rad/ambient-projects.yaml",
        state: "/srv/ambient-state",
        rsync_target: None,
        rsync_target_base: Some(
            "ci@http.liw.fi:/srv/http/doc.liw.fi",
        ),
        rsync_target_map: None,
        dput_target: Some(
            "apt.liw.fi",
        ),
        executor: Some(
            "/usr/bin/ambient-execute-plan",
        ),
        artifacts_max_size: Byte(
            10000000000,
        ),
        cache_max_size: Byte(
            50000000000,
        ),
        qemu: QemuConfig {
            cpus: 4,
            memory: Byte(
                8000000000,
            ),
            kvm_binary: "/usr/bin/kvm",
            ovmf_vars_file: "/usr/share/ovmf/OVMF.fd",
            ovmf_code_file: "/usr/share/ovmf/OVMF.fd",
        },
    }
[2025-09-27T07:47:02Z DEBUG ambient_ci::project] load project state from /srv/ambient-state/cachedir/meta.yaml
[2025-09-27T07:47:02Z DEBUG ambient_ci::run] no latest commit stored
[2025-09-27T07:47:02Z DEBUG ambient_ci::run] is a git repository
[2025-09-27T07:47:02Z DEBUG ambient_ci::run] git repository is clean
[2025-09-27T07:47:02Z DEBUG ambient_ci::run] current (HEAD) commit: aae02312d81f5181002ffdd7552afdf578e97ec8
[2025-09-27T07:47:02Z DEBUG ambient_ci::run] no dry run requested
[2025-09-27T07:47:02Z DEBUG ambient_ci::run] forced run requested
[2025-09-27T07:47:02Z DEBUG ambient_ci::run] run? true
[2025-09-27T07:47:02Z INFO  ambient_ci::run] project cachedir: running CI
[2025-09-27T07:47:02Z DEBUG ambient_ci::run] Executing pre-plan steps
[2025-09-27T07:47:02Z DEBUG ambient_ci::plan] RUN: Action CargoFetch {
        sourcedir: "/tmp/.tmpIx6m2k/src",
    }
[2025-09-27T07:47:02Z DEBUG ambient_ci::action] Plan::execute: plan=CargoFetch {
        sourcedir: "/tmp/.tmpIx6m2k/src",
    }
[2025-09-27T07:47:02Z DEBUG ambient_ci::action] Plan::execute: context=Context {
        envs: {
            "CARGO_TARGET_DIR": "/srv/ambient-state/cachedir/cache",
            "CARGO_HOME": "/srv/ambient-state/cachedir/dependencies",
            "PATH": "/root/.cargo/bin:/bin:/home/_rad/.radicle/bin:/home/_rad/.cargo/bin",
        },
        source_dir: "/tmp/.tmpIx6m2k/src",
    }
SPAWN: argv=["cargo", "--version"]
       cwd=/tmp/.tmpIx6m2k/src (exists? true)
cargo 1.90.0 (840b83a10 2025-07-30)
SPAWN: argv=["cargo", "clippy", "--version"]
       cwd=/tmp/.tmpIx6m2k/src (exists? true)
clippy 0.1.90 (1159e78c47 2025-09-14)
SPAWN: argv=["rustc", "--version"]
       cwd=/tmp/.tmpIx6m2k/src (exists? true)
rustc 1.90.0 (1159e78c4 2025-09-14)
SPAWN: argv=["cargo", "fetch"]
       cwd=/tmp/.tmpIx6m2k/src (exists? true)
    Updating crates.io index
 Downloading crates ...
  Downloaded windows-targets v0.52.5
  Downloaded winapi-util v0.1.8
  Downloaded walkdir v2.5.0
  Downloaded thiserror v1.0.61
  Downloaded same-file v1.0.6
  Downloaded thiserror-impl v1.0.61
  Downloaded crossbeam-epoch v0.9.18
  Downloaded crossbeam-deque v0.8.5
  Downloaded time-core v0.1.2
  Downloaded equivalent v1.0.1
  Downloaded num-conv v0.1.0
  Downloaded cfg-if v1.0.0
  Downloaded bitflags v1.3.2
  Downloaded lazy_static v1.4.0
  Downloaded generic-array v0.14.7
  Downloaded percent-encoding v2.3.1
  Downloaded block-buffer v0.10.4
  Downloaded fs2 v0.4.3
  Downloaded globwalk v0.8.1
  Downloaded pin-project-lite v0.2.14
  Downloaded line-col v0.2.1
  Downloaded rand_core v0.6.4
  Downloaded digest v0.10.7
  Downloaded autocfg v1.3.0
  Downloaded filetime v0.2.23
  Downloaded sha2 v0.10.8
  Downloaded typenum v1.17.0
  Downloaded redox_syscall v0.4.1
  Downloaded crossbeam-utils v0.8.20
  Downloaded ignore v0.4.22
  Downloaded tracing-core v0.1.32
  Downloaded getopts v0.2.21
  Downloaded serde v1.0.202
  Downloaded utf8-width v0.1.7
  Downloaded hashbrown v0.14.5
  Downloaded html-escape v0.2.13
  Downloaded smawk v0.3.2
  Downloaded serde-aux v4.5.0
  Downloaded pest v2.7.10
  Downloaded time v0.3.36
  Downloaded libm v0.2.8
  Downloaded memchr v2.7.2
  Downloaded tera v1.19.1
  Downloaded unicase v2.7.0
  Downloaded rand v0.8.5
  Downloaded syn v2.0.65
  Downloaded glob v0.3.1
  Downloaded anstyle-parse v0.2.4
  Downloaded aligned v0.4.2
  Downloaded scoped-tls v1.0.1
  Downloaded anstream v0.6.14
  Downloaded windows-targets v0.42.2
  Downloaded rustix v0.38.34
  Downloaded as-slice v0.2.1
  Downloaded windows_aarch64_gnullvm v0.52.5
  Downloaded nu-ansi-term v0.46.0
  Downloaded stable_deref_trait v1.2.0
  Downloaded shell-words v1.1.0
  Downloaded generator v0.7.5
  Downloaded regex-automata v0.4.6
  Downloaded state v0.5.3
  Downloaded libc v0.2.155
  Downloaded tracing-log v0.2.0
  Downloaded windows_aarch64_msvc v0.52.5
  Downloaded windows_i686_gnu v0.52.5
  Downloaded clap v4.5.4
  Downloaded hashbrown v0.12.3
  Downloaded windows_i686_msvc v0.52.5
  Downloaded windows_x86_64_gnu v0.52.5
  Downloaded loom v0.5.6
  Downloaded base64 v0.21.7
  Downloaded linux-raw-sys v0.4.14
  Downloaded pulldown-cmark v0.9.6
  Downloaded regex-automata v0.1.10
  Downloaded windows-sys v0.52.0
  Downloaded windows_x86_64_msvc v0.52.5
  Downloaded cc v1.0.98
  Downloaded clap_derive v4.5.4
  Downloaded env_logger v0.10.2
  Downloaded pikchr v0.1.3
  Downloaded colorchoice v1.0.1
  Downloaded utf8parse v0.2.1
  Downloaded strsim v0.11.1
  Downloaded humantime v2.1.0
  Downloaded hermit-abi v0.3.9
  Downloaded is-terminal v0.4.12
  Downloaded smallvec v1.13.2
  Downloaded anstyle-query v1.0.3
  Downloaded anstyle-wincon v3.0.3
  Downloaded windows_i686_gnullvm v0.52.5
  Downloaded normpath v1.2.0
  Downloaded rustversion v1.0.17
  Downloaded thread_local v1.1.8
  Downloaded clap_lex v0.7.0
  Downloaded heck v0.5.0
  Downloaded windows_x86_64_gnullvm v0.52.5
  Downloaded clap_builder v4.5.2
  Downloaded termcolor v1.4.1
  Downloaded regex v1.10.4
  Downloaded syn v1.0.109
  Downloaded anyhow v1.0.86
  Downloaded indexmap v1.9.3
  Downloaded linked-hash-map v0.5.6
  Downloaded unicode-linebreak v0.1.5
  Downloaded unicode-width v0.1.12
  Downloaded textwrap v0.15.2
  Downloaded aho-corasick v1.1.3
  Downloaded cvt v0.1.2
  Downloaded windows-targets v0.48.5
  Downloaded tracing-subscriber v0.3.18
  Downloaded matchers v0.1.0
  Downloaded overload v0.1.1
  Downloaded sharded-slab v0.1.7
  Downloaded is_terminal_polyfill v1.70.0
  Downloaded anstyle v1.0.7
  Downloaded serde_yaml v0.8.26
  Downloaded deunicode v1.6.0
  Downloaded wasm-bindgen v0.2.92
  Downloaded bumpalo v3.16.0
  Downloaded log v0.4.21
  Downloaded tracing v0.1.40
  Downloaded bitflags v2.5.0
  Downloaded globset v0.4.14
  Downloaded pest_meta v2.7.10
  Downloaded wasm-bindgen-backend v0.2.92
  Downloaded yaml-rust v0.4.5
  Downloaded indexmap v2.2.6
  Downloaded ucd-trie v0.1.6
  Downloaded getrandom v0.2.15
  Downloaded valuable v0.1.0
  Downloaded proc-macro2 v1.0.83
  Downloaded unicode-ident v1.0.12
  Downloaded ryu v1.0.18
  Downloaded unic-ucd-segment v0.9.0
  Downloaded unic-segment v0.9.0
  Downloaded tempfile v3.10.1
  Downloaded time-macros v0.2.18
  Downloaded quote v1.0.36
  Downloaded nix v0.26.4
  Downloaded unsafe-libyaml v0.2.11
  Downloaded serde_yaml v0.9.34+deprecated
  Downloaded pest_derive v2.7.10
  Downloaded wasi v0.11.0+wasi-snapshot-preview1
  Downloaded version_check v0.9.4
  Downloaded rand_chacha v0.3.1
  Downloaded powerfmt v0.2.0
  Downloaded ppv-lite86 v0.2.17
  Downloaded tracing-attributes v0.1.27
  Downloaded once_cell v1.19.0
  Downloaded deranged v0.3.11
  Downloaded humansize v2.1.3
  Downloaded cpufeatures v0.2.12
  Downloaded pest_generator v2.7.10
  Downloaded regex-syntax v0.6.29
  Downloaded unic-common v0.9.0
  Downloaded unic-ucd-version v0.9.0
  Downloaded wasm-bindgen-macro-support v0.2.92
  Downloaded fastrand v2.1.0
  Downloaded itoa v1.0.11
  Downloaded wasm-bindgen-shared v0.2.92
  Downloaded unic-char-property v0.9.0
  Downloaded unic-char-range v0.9.0
  Downloaded errno v0.3.9
  Downloaded wasm-bindgen-macro v0.2.92
  Downloaded crypto-common v0.1.6
  Downloaded windows_x86_64_gnullvm v0.42.2
  Downloaded windows_aarch64_gnullvm v0.42.2
  Downloaded unescape v0.1.0
  Downloaded windows_aarch64_gnullvm v0.48.5
  Downloaded windows_x86_64_gnullvm v0.48.5
  Downloaded fehler-macros v1.0.0
  Downloaded fehler v1.0.0
  Downloaded slug v0.1.5
  Downloaded subplotlib-derive v0.9.0
  Downloaded subplot-build v0.9.0
  Downloaded tempfile-fast v0.3.4
  Downloaded git-testament-derive v0.2.0
  Downloaded git-testament v0.2.5
  Downloaded windows_aarch64_msvc v0.42.2
  Downloaded roadmap v0.5.0
  Downloaded windows_x86_64_msvc v0.42.2
  Downloaded windows_x86_64_gnu v0.42.2
  Downloaded subplotlib v0.9.0
  Downloaded windows_i686_msvc v0.42.2
  Downloaded windows_i686_gnu v0.42.2
  Downloaded serde_derive v1.0.202
  Downloaded windows_x86_64_msvc v0.48.5
  Downloaded windows_aarch64_msvc v0.48.5
  Downloaded windows_x86_64_gnu v0.48.5
  Downloaded windows_i686_gnu v0.48.5
  Downloaded windows_i686_msvc v0.48.5
  Downloaded file_diff v1.0.0
  Downloaded fs_at v0.1.10
  Downloaded remove_dir_all v0.8.2
  Downloaded serde_json v1.0.117
  Downloaded winapi v0.3.9
  Downloaded subplot v0.9.0
  Downloaded windows-sys v0.48.0
  Downloaded windows-sys v0.45.0
  Downloaded bstr v1.9.1
  Downloaded regex-syntax v0.8.3
  Downloaded winapi-i686-pc-windows-gnu v0.4.0
  Downloaded winapi-x86_64-pc-windows-gnu v0.4.0
  Downloaded windows v0.48.0
[2025-09-27T07:47:07Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-27T07:47:07Z DEBUG ambient_ci::plan] All actions were performed successfully
[2025-09-27T07:47:07Z DEBUG ambient_ci::run] create virtual drive /srv/tmp/.tmpg4DqPY/src.tar
[2025-09-27T07:47:07Z DEBUG ambient_ci::run] create virtual drive /srv/tmp/.tmpg4DqPY/deps.tar
[2025-09-27T07:47:14Z DEBUG ambient_ci::run] create_executor_vdrive: executor="/usr/bin/ambient-execute-plan"
[2025-09-27T07:47:14Z DEBUG ambient_ci::run] create_executor_vdrive: plan=RunnablePlan {
        steps: [
            Mkdir {
                pathname: "/workspace",
            },
            Mkdir {
                pathname: "/workspace/artifacts",
            },
            TarExtract {
                archive: "/dev/vdc",
                directory: "/workspace/src",
            },
            TarExtract {
                archive: "/dev/vdf",
                directory: "/workspace/deps",
            },
            TarExtract {
                archive: "/dev/vde",
                directory: "/workspace/cache",
            },
            Spawn {
                argv: [
                    "find",
                    "/workspace",
                    "-maxdepth",
                    "2",
                    "-ls",
                ],
            },
            CargoFmt,
            CargoClippy,
            CargoBuild,
            CargoTest,
            Shell {
                shell: "subplot docgen cachedir.subplot -o /workspace/artifacts/cachedir.html\n",
            },
            Custom(
                Custom {
                    name: "dch",
                    args: {
                        "debemail": String("liw@liw.fi"),
                        "debfullname": String("Lars Wirzenius"),
                    },
                },
            ),
            Deb,
            TarCreate {
                archive: "/dev/vde",
                directory: "/workspace/cache",
            },
            TarCreate {
                archive: "/dev/vdd",
                directory: "/workspace/artifacts",
            },
        ],
        executor_drive: Some(
            "/dev/vdb",
        ),
        source_drive: Some(
            "/dev/vdc",
        ),
        artifact_drive: Some(
            "/dev/vdd",
        ),
        cache_drive: Some(
            "/dev/vde",
        ),
        deps_drive: Some(
            "/dev/vdf",
        ),
        workspace_dir: Some(
            "/workspace",
        ),
        source_dir: Some(
            "/workspace/src",
        ),
        deps_dir: Some(
            "/workspace/deps",
        ),
        cache_dir: Some(
            "/workspace/cache",
        ),
        artifacts_dir: Some(
            "/workspace/artifacts",
        ),
    }
[2025-09-27T07:47:14Z DEBUG ambient_ci::run] executor bin /usr/bin/ambient-execute-plan
[2025-09-27T07:47:14Z DEBUG ambient_ci::run] copying /usr/bin/ambient-execute-plan to /srv/tmp/.tmpg4DqPY/ambient-execute-plan/run-ci
[2025-09-27T07:47:14Z DEBUG ambient_ci::run] copy OK: true
[2025-09-27T07:47:14Z DEBUG ambient_ci::run] create virtual drive /srv/tmp/.tmpg4DqPY/executor.tar
[2025-09-27T07:47:14Z DEBUG ambient_ci::project] removing run log file /srv/ambient-state/cachedir/run.log
[2025-09-27T07:47:14Z DEBUG ambient_ci::project] statedir is /srv/ambient-state/cachedir, exists? true
[2025-09-27T07:47:14Z DEBUG ambient_ci::project] creating run log file /srv/ambient-state/cachedir/run.log
[2025-09-27T07:47:14Z DEBUG ambient_ci::project] created run log file /srv/ambient-state/cachedir/run.log OK
[2025-09-27T07:47:14Z DEBUG ambient_ci::cloud_init] with_hostname called: "ambient"
[2025-09-27T07:47:14Z DEBUG ambient_ci::cloud_init] with_runcmd called: "echo xyzzy > /dev/ttyS1"
[2025-09-27T07:47:14Z DEBUG ambient_ci::cloud_init] with_runcmd called: "\n(set -xeu\nenv\ndir=\"$(mktemp -d)\"\ncd \"$dir\"\ntar -xvf /dev/vdb\nfind -ls || true\nldd ./run-ci || true\necho ================================ BEGIN ================================\nexport RUST_BACKTRACE=1\nif ./run-ci; then\n        echo \"EXIT CODE: 0\"\nelse\n        echo \"EXIT CODE: $?\"\nfi) > /dev/ttyS1 2>&1\n"
[2025-09-27T07:47:14Z DEBUG ambient_ci::cloud_init] with_runcmd called: "poweroff"
[2025-09-27T07:47:14Z DEBUG ambient_ci::cloud_init] LocalDataStoreBuilder: LocalDataStoreBuilder {
        hostname: Some(
            "ambient",
        ),
        network: false,
        bootcmd: [],
        runcmd: [
            "echo xyzzy > /dev/ttyS1",
            "\n(set -xeu\nenv\ndir=\"$(mktemp -d)\"\ncd \"$dir\"\ntar -xvf /dev/vdb\nfind -ls || true\nldd ./run-ci || true\necho ================================ BEGIN ================================\nexport RUST_BACKTRACE=1\nif ./run-ci; then\n        echo \"EXIT CODE: 0\"\nelse\n        echo \"EXIT CODE: $?\"\nfi) > /dev/ttyS1 2>&1\n",
            "poweroff",
        ],
    }
[2025-09-27T07:47:14Z DEBUG ambient_ci::qemu] run QEMU
[2025-09-27T07:47:14Z DEBUG ambient_ci::qemu] create copy-on-write image and UEFI vars file
[2025-09-27T07:47:14Z DEBUG ambient_ci::qemu_utils] qemu-img create /srv/tmp/.tmpsDFuEC/.tmp7AkpMG/vm.qcow2 backing on /home/_rad/ambient.qcow2
[2025-09-27T07:47:14Z DEBUG ambient_ci::qemu] create cloud-init ISO file
[2025-09-27T07:47:14Z DEBUG ambient_ci::cloud_init] LocalDataStore: LocalDataStore {
        hostname: "ambient",
        network: false,
        bootcmd: [],
        runcmd: [
            "echo xyzzy > /dev/ttyS1",
            "\n(set -xeu\nenv\ndir=\"$(mktemp -d)\"\ncd \"$dir\"\ntar -xvf /dev/vdb\nfind -ls || true\nldd ./run-ci || true\necho ================================ BEGIN ================================\nexport RUST_BACKTRACE=1\nif ./run-ci; then\n        echo \"EXIT CODE: 0\"\nelse\n        echo \"EXIT CODE: $?\"\nfi) > /dev/ttyS1 2>&1\n",
            "poweroff",
        ],
    }
[2025-09-27T07:47:14Z DEBUG ambient_ci::cloud_init] write /tmp/.tmpXexYhE/meta-data
[2025-09-27T07:47:14Z DEBUG ambient_ci::cloud_init] write /tmp/.tmpXexYhE/user-data
[2025-09-27T07:47:14Z DEBUG ambient_ci::qemu] set console log file to /srv/tmp/.tmpsDFuEC/.tmp7AkpMG/console.log
[2025-09-27T07:47:14Z DEBUG ambient_ci::util] create file /srv/tmp/.tmpsDFuEC/.tmp7AkpMG/console.log
[2025-09-27T07:47:14Z DEBUG ambient_ci::qemu] set run file to /srv/ambient-state/cachedir/run.log
[2025-09-27T07:47:14Z DEBUG ambient_ci::util] create file /srv/ambient-state/cachedir/run.log
[2025-09-27T07:47:14Z DEBUG ambient_ci::qemu] run QEMU: QemuArgs {
        args: [
            "-m",
            "7629",
            "-smp",
            "cpus=4",
            "-cpu",
            "kvm64",
            "-machine",
            "type=q35,accel=kvm,usb=off",
            "-uuid",
            "a85c9de7-edc0-4e54-bead-112e5733582c",
            "-boot",
            "strict=on",
            "-name",
            "ambient-ci-vm",
            "-rtc",
            "base=utc,driftfix=slew",
            "-display",
            "none",
            "-device",
            "virtio-rng-pci",
            "-serial",
            "file:/srv/tmp/.tmpsDFuEC/.tmp7AkpMG/console.log",
            "-serial",
            "file:/srv/ambient-state/cachedir/run.log",
            "-drive",
            "if=pflash,format=raw,unit=0,file=/usr/share/ovmf/OVMF.fd,readonly=on",
            "-drive",
            "if=pflash,format=raw,unit=1,file=/srv/tmp/.tmpsDFuEC/.tmp7AkpMG/vars.fd",
            "-drive",
            "format=qcow2,if=virtio,file=/srv/tmp/.tmpsDFuEC/.tmp7AkpMG/vm.qcow2",
            "-drive",
            "format=raw,if=virtio,file=/srv/tmp/.tmpg4DqPY/executor.tar,readonly=on",
            "-cdrom",
            "/srv/tmp/.tmpsDFuEC/.tmp7AkpMG/cloud_init.iso",
            "-drive",
            "format=raw,if=virtio,file=/srv/tmp/.tmpg4DqPY/src.tar,readonly=on",
            "-drive",
            "format=raw,if=virtio,file=/srv/tmp/.tmpg4DqPY/artifacts.tar",
            "-drive",
            "format=raw,if=virtio,file=/srv/tmp/.tmpg4DqPY/cache.tar",
            "-drive",
            "format=raw,if=virtio,file=/srv/tmp/.tmpg4DqPY/deps.tar,readonly=on",
            "-nodefaults",
            "-no-user-config",
        ],
    }
[2025-09-27T07:49:16Z DEBUG ambient_ci::qemu] QEMU finished OK
[2025-09-27T07:49:16Z DEBUG ambient_ci::qemu] run log:
    --------------------==========
    [2025-09-27T07:47:33Z TRACE ambient_execute_plan] ambient-execute-plan version 0.7.0@2e86bbe starts
    [2025-09-27T07:47:33Z DEBUG ambient_execute_plan] ambient-execute-plan version 0.7.0@2e86bbe starts
    [2025-09-27T07:47:33Z INFO  ambient_execute_plan] ambient-execute-plan version 0.7.0@2e86bbe starts
    [2025-09-27T07:47:33Z WARN  ambient_execute_plan] ambient-execute-plan version 0.7.0@2e86bbe starts
    [2025-09-27T07:47:33Z ERROR ambient_execute_plan] ambient-execute-plan version 0.7.0@2e86bbe starts
    RunnablePlan::from_file: filename=plan.yaml
    steps:
    - action: mkdir
      pathname: /workspace
    - action: mkdir
      pathname: /workspace/artifacts
    - action: tar_extract
      archive: /dev/vdc
      directory: /workspace/src
    - action: tar_extract
      archive: /dev/vdf
      directory: /workspace/deps
    - action: tar_extract
      archive: /dev/vde
      directory: /workspace/cache
    - action: spawn
      argv:
      - find
      - /workspace
      - -maxdepth
      - '2'
      - -ls
    - action: cargo_fmt
    - action: cargo_clippy
    - action: cargo_build
    - action: cargo_test
    - action: shell
      shell: |
        subplot docgen cachedir.subplot -o /workspace/artifacts/cachedir.html
    - action: custom
      name: dch
      args:
        debemail: liw@liw.fi
        debfullname: Lars Wirzenius
    - action: deb
    - action: tar_create
      archive: /dev/vde
      directory: /workspace/cache
    - action: tar_create
      archive: /dev/vdd
      directory: /workspace/artifacts
    executor_drive: /dev/vdb
    source_drive: /dev/vdc
    artifact_drive: /dev/vdd
    cache_drive: /dev/vde
    deps_drive: /dev/vdf
    workspace_dir: /workspace
    source_dir: /workspace/src
    deps_dir: /workspace/deps
    cache_dir: /workspace/cache
    artifacts_dir: /workspace/artifacts
    
    
    [2025-09-27T07:47:33Z DEBUG ambient_ci::plan] RUN: Action Mkdir {
            pathname: "/workspace",
        }
    [2025-09-27T07:47:33Z DEBUG ambient_ci::action] Plan::execute: plan=Mkdir {
            pathname: "/workspace",
        }
    [2025-09-27T07:47:33Z DEBUG ambient_ci::action] Plan::execute: context=Context {
            envs: {
                "CARGO_TARGET_DIR": "/workspace/cache",
                "CARGO_HOME": "/workspace/deps",
                "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
            },
            source_dir: "/workspace/src",
        }
    [2025-09-27T07:47:33Z DEBUG ambient_ci::plan] RUN: Action finished OK
    [2025-09-27T07:47:33Z DEBUG ambient_ci::plan] RUN: Action Mkdir {
            pathname: "/workspace/artifacts",
        }
    [2025-09-27T07:47:33Z DEBUG ambient_ci::action] Plan::execute: plan=Mkdir {
            pathname: "/workspace/artifacts",
        }
    [2025-09-27T07:47:33Z DEBUG ambient_ci::action] Plan::execute: context=Context {
            envs: {
                "CARGO_TARGET_DIR": "/workspace/cache",
                "CARGO_HOME": "/workspace/deps",
                "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
            },
            source_dir: "/workspace/src",
        }
    [2025-09-27T07:47:33Z DEBUG ambient_ci::plan] RUN: Action finished OK
    [2025-09-27T07:47:33Z DEBUG ambient_ci::plan] RUN: Action TarExtract {
            archive: "/dev/vdc",
            directory: "/workspace/src",
        }
    [2025-09-27T07:47:33Z DEBUG ambient_ci::action] Plan::execute: plan=TarExtract {
            archive: "/dev/vdc",
            directory: "/workspace/src",
        }
    [2025-09-27T07:47:33Z DEBUG ambient_ci::action] Plan::execute: context=Context {
            envs: {
                "CARGO_TARGET_DIR": "/workspace/cache",
                "CARGO_HOME": "/workspace/deps",
                "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
            },
            source_dir: "/workspace/src",
        }
    [2025-09-27T07:47:33Z TRACE ambient_ci::vdrive] extracting /dev/vdc to /workspace/src
    [2025-09-27T07:47:33Z TRACE ambient_ci::vdrive] extraction OK
    [2025-09-27T07:47:33Z DEBUG ambient_ci::plan] RUN: Action finished OK
    [2025-09-27T07:47:33Z DEBUG ambient_ci::plan] RUN: Action TarExtract {
            archive: "/dev/vdf",
            directory: "/workspace/deps",
        }
    [2025-09-27T07:47:33Z DEBUG ambient_ci::action] Plan::execute: plan=TarExtract {
            archive: "/dev/vdf",
            directory: "/workspace/deps",
        }
    [2025-09-27T07:47:33Z DEBUG ambient_ci::action] Plan::execute: context=Context {
            envs: {
                "CARGO_TARGET_DIR": "/workspace/cache",
                "CARGO_HOME": "/workspace/deps",
                "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
            },
            source_dir: "/workspace/src",
        }
    [2025-09-27T07:47:33Z TRACE ambient_ci::vdrive] extracting /dev/vdf to /workspace/deps
    [2025-09-27T07:47:35Z TRACE ambient_ci::vdrive] extraction OK
    [2025-09-27T07:47:35Z DEBUG ambient_ci::plan] RUN: Action finished OK
    [2025-09-27T07:47:35Z DEBUG ambient_ci::plan] RUN: Action TarExtract {
            archive: "/dev/vde",
            directory: "/workspace/cache",
        }
    [2025-09-27T07:47:35Z DEBUG ambient_ci::action] Plan::execute: plan=TarExtract {
            archive: "/dev/vde",
            directory: "/workspace/cache",
        }
    [2025-09-27T07:47:35Z DEBUG ambient_ci::action] Plan::execute: context=Context {
            envs: {
                "CARGO_TARGET_DIR": "/workspace/cache",
                "CARGO_HOME": "/workspace/deps",
                "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
            },
            source_dir: "/workspace/src",
        }
    [2025-09-27T07:47:35Z TRACE ambient_ci::vdrive] extracting /dev/vde to /workspace/cache
    [2025-09-27T07:47:35Z TRACE ambient_ci::vdrive] extraction OK
    [2025-09-27T07:47:35Z DEBUG ambient_ci::plan] RUN: Action finished OK
    [2025-09-27T07:47:35Z DEBUG ambient_ci::plan] RUN: Action Spawn {
            argv: [
                "find",
                "/workspace",
                "-maxdepth",
                "2",
                "-ls",
            ],
        }
    [2025-09-27T07:47:35Z DEBUG ambient_ci::action] Plan::execute: plan=Spawn {
            argv: [
                "find",
                "/workspace",
                "-maxdepth",
                "2",
                "-ls",
            ],
        }
    [2025-09-27T07:47:35Z DEBUG ambient_ci::action] Plan::execute: context=Context {
            envs: {
                "CARGO_TARGET_DIR": "/workspace/cache",
                "CARGO_HOME": "/workspace/deps",
                "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
            },
            source_dir: "/workspace/src",
        }
    SPAWN: argv=["find", "/workspace", "-maxdepth", "2", "-ls"]
           cwd=/workspace/src (exists? true)
      2621441      4 drwxr-xr-x   6 root     root         4096 Sep 27 07:47 /workspace
      2621617      4 drwxr-xr-x   3 root     root         4096 Sep 27 07:47 /workspace/deps
      2621618      0 -rw-r--r--   1 root     root            0 Sep 27 07:47 /workspace/deps/.package-cache-mutate
      2621621      4 drwxr-xr-x   5 root     root         4096 Sep 27 07:47 /workspace/deps/registry
      2621619     88 -rw-r--r--   1 root     root        90112 Sep 27 07:47 /workspace/deps/.global-cache
      2621620      0 -rw-r--r--   1 root     root            0 Sep 27 07:47 /workspace/deps/.package-cache
      2621443      4 drwxr-xr-x   8 root     root         4096 Sep 27 07:47 /workspace/src
      2621469      4 -rw-r--r--   1 root     root          373 Sep 27 07:47 /workspace/src/Cargo.toml
      2621449      4 -rwxr-xr-x   1 root     root          590 Sep 27 07:47 /workspace/src/check
      2621446      4 -rw-r--r--   1 root     root         1015 Sep 27 07:47 /workspace/src/subplot.rs
      2621467      4 -rw-r--r--   1 root     root          200 Sep 27 07:47 /workspace/src/build.rs
      2621472      4 drwxr-xr-x   8 root     root         4096 Sep 27 07:47 /workspace/src/.git
      2621454      4 -rw-r--r--   1 root     root           84 Sep 27 07:47 /workspace/src/subplot.yaml
      2621450      4 drwxr-xr-x   3 root     root         4096 Sep 27 07:47 /workspace/src/src
      2621466      4 -rw-r--r--   1 root     root         1025 Sep 27 07:47 /workspace/src/README.md
      2621447      4 drwxr-xr-x   2 root     root         4096 Sep 27 07:47 /workspace/src/.ambient
      2621444      4 drwxr-xr-x   2 root     root         4096 Sep 27 07:47 /workspace/src/.radicle
      2621456      4 drwxr-xr-x   3 root     root         4096 Sep 27 07:47 /workspace/src/debian
      2621616     48 -rw-r--r--   1 root     root        48002 Sep 27 07:47 /workspace/src/Cargo.lock
      2621468      4 -rw-r--r--   1 root     root           21 Sep 27 07:47 /workspace/src/.gitignore
      2621470      4 drwxr-xr-x   2 root     root         4096 Sep 27 07:47 /workspace/src/tests
      2621615      4 -rw-r--r--   1 root     root          211 Sep 27 07:47 /workspace/src/cachedir.subplot
      2621455      4 -rw-r--r--   1 root     root         2275 Sep 27 07:47 /workspace/src/cachedir.md
      2621442      4 drwxr-xr-x   2 root     root         4096 Sep 27 07:47 /workspace/artifacts
      2636405      4 drwxr-xr-x   2 root     root         4096 Sep 27 07:47 /workspace/cache
      2636406      4 -rw-r--r--   1 root     root         1038 Sep 27 07:47 /workspace/cache/.rustc_info.json
    [2025-09-27T07:47:36Z DEBUG ambient_ci::plan] RUN: Action finished OK
    [2025-09-27T07:47:36Z DEBUG ambient_ci::plan] RUN: Action CargoFmt
    [2025-09-27T07:47:36Z DEBUG ambient_ci::action] Plan::execute: plan=CargoFmt
    [2025-09-27T07:47:36Z DEBUG ambient_ci::action] Plan::execute: context=Context {
            envs: {
                "CARGO_TARGET_DIR": "/workspace/cache",
                "CARGO_HOME": "/workspace/deps",
                "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
            },
            source_dir: "/workspace/src",
        }
    SPAWN: argv=["cargo", "--version"]
           cwd=/workspace/src (exists? true)
    cargo 1.88.0 (873a06493 2025-05-10)
    SPAWN: argv=["cargo", "clippy", "--version"]
           cwd=/workspace/src (exists? true)
    clippy 0.1.88 (6b00bc3880 2025-06-23)
    SPAWN: argv=["rustc", "--version"]
           cwd=/workspace/src (exists? true)
    rustc 1.88.0 (6b00bc388 2025-06-23)
    SPAWN: argv=["cargo", "fmt", "--check"]
           cwd=/workspace/src (exists? true)
    [2025-09-27T07:47:36Z DEBUG ambient_ci::plan] RUN: Action finished OK
    [2025-09-27T07:47:36Z DEBUG ambient_ci::plan] RUN: Action CargoClippy
    [2025-09-27T07:47:36Z DEBUG ambient_ci::action] Plan::execute: plan=CargoClippy
    [2025-09-27T07:47:36Z DEBUG ambient_ci::action] Plan::execute: context=Context {
            envs: {
                "CARGO_TARGET_DIR": "/workspace/cache",
                "CARGO_HOME": "/workspace/deps",
                "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
            },
            source_dir: "/workspace/src",
        }
    SPAWN: argv=["cargo", "--version"]
           cwd=/workspace/src (exists? true)
    cargo 1.88.0 (873a06493 2025-05-10)
    SPAWN: argv=["cargo", "clippy", "--version"]
           cwd=/workspace/src (exists? true)
    clippy 0.1.88 (6b00bc3880 2025-06-23)
    SPAWN: argv=["rustc", "--version"]
           cwd=/workspace/src (exists? true)
    rustc 1.88.0 (6b00bc388 2025-06-23)
    SPAWN: argv=["cargo", "clippy", "--offline", "--locked", "--workspace", "--all-targets", "--no-deps", "--", "--deny", "warnings"]
           cwd=/workspace/src (exists? true)
       Compiling proc-macro2 v1.0.83
       Compiling unicode-ident v1.0.12
       Compiling libc v0.2.155
       Compiling memchr v2.7.2
       Compiling thiserror v1.0.61
       Compiling serde v1.0.202
       Compiling aho-corasick v1.1.3
       Compiling itoa v1.0.11
       Compiling crossbeam-utils v0.8.20
       Compiling quote v1.0.36
       Compiling syn v2.0.65
       Compiling regex-syntax v0.8.3
       Compiling log v0.4.21
       Compiling cfg-if v1.0.0
       Compiling once_cell v1.19.0
       Compiling same-file v1.0.6
       Compiling rustix v0.38.34
       Compiling ryu v1.0.18
       Compiling walkdir v2.5.0
       Compiling regex-automata v0.4.6
       Compiling getrandom v0.2.15
       Compiling ucd-trie v0.1.6
       Compiling time-core v0.1.2
       Compiling autocfg v1.3.0
       Compiling anyhow v1.0.86
       Compiling num-conv v0.1.0
       Compiling indexmap v1.9.3
       Compiling crossbeam-epoch v0.9.18
       Compiling time-macros v0.2.18
       Compiling rand_core v0.6.4
       Compiling bstr v1.9.1
       Compiling thiserror-impl v1.0.61
       Compiling serde_derive v1.0.202
       Compiling serde_json v1.0.117
       Compiling libm v0.2.8
       Compiling version_check v0.9.4
       Compiling unic-common v0.9.0
       Compiling ppv-lite86 v0.2.17
       Compiling unicode-width v0.1.12
       Compiling utf8parse v0.2.1
       Compiling bitflags v2.5.0
       Compiling powerfmt v0.2.0
       Compiling unic-char-range v0.9.0
       Compiling pest v2.7.10
       Compiling unic-char-property v0.9.0
       Compiling deranged v0.3.11
       Compiling rand_chacha v0.3.1
       Compiling anstyle-parse v0.2.4
       Compiling unic-ucd-version v0.9.0
       Compiling unicase v2.7.0
       Compiling globset v0.4.14
       Compiling crossbeam-deque v0.8.5
       Compiling pest_meta v2.7.10
       Compiling colorchoice v1.0.1
       Compiling hashbrown v0.12.3
       Compiling linux-raw-sys v0.4.14
       Compiling heck v0.5.0
       Compiling anstyle-query v1.0.3
       Compiling is_terminal_polyfill v1.70.0
       Compiling cc v1.0.98
       Compiling linked-hash-map v0.5.6
       Compiling anstyle v1.0.7
       Compiling anstream v0.6.14
       Compiling yaml-rust v0.4.5
       Compiling pest_generator v2.7.10
       Compiling pikchr v0.1.3
       Compiling clap_derive v4.5.4
       Compiling ignore v0.4.22
       Compiling time v0.3.36
       Compiling unic-ucd-segment v0.9.0
       Compiling rand v0.8.5
       Compiling regex v1.10.4
       Compiling bitflags v1.3.2
       Compiling unicode-linebreak v0.1.5
       Compiling smawk v0.3.2
       Compiling hashbrown v0.14.5
       Compiling pulldown-cmark v0.9.6
       Compiling fastrand v2.1.0
       Compiling equivalent v1.0.1
       Compiling deunicode v1.6.0
       Compiling strsim v0.11.1
       Compiling clap_lex v0.7.0
       Compiling slug v0.1.5
       Compiling indexmap v2.2.6
       Compiling clap_builder v4.5.2
       Compiling git-testament-derive v0.2.0
       Compiling tempfile v3.10.1
       Compiling textwrap v0.15.2
       Compiling globwalk v0.8.1
       Compiling unic-segment v0.9.0
       Compiling humansize v2.1.3
       Compiling serde_yaml v0.8.26
       Compiling pest_derive v2.7.10
       Compiling subplot v0.9.0
       Compiling getopts v0.2.21
       Compiling is-terminal v0.4.12
       Compiling humantime v2.1.0
       Compiling unsafe-libyaml v0.2.11
       Compiling lazy_static v1.4.0
       Compiling percent-encoding v2.3.1
       Compiling utf8-width v0.1.7
       Compiling termcolor v1.4.1
       Compiling tera v1.19.1
       Compiling env_logger v0.10.2
       Compiling serde_yaml v0.9.34+deprecated
       Compiling clap v4.5.4
       Compiling html-escape v0.2.13
       Compiling roadmap v0.5.0
       Compiling git-testament v0.2.5
       Compiling tempfile-fast v0.3.4
       Compiling serde-aux v4.5.0
       Compiling tracing-attributes v0.1.27
       Compiling tracing-core v0.1.32
       Compiling line-col v0.2.1
       Compiling file_diff v1.0.0
       Compiling pin-project-lite v0.2.14
       Compiling base64 v0.21.7
       Compiling syn v1.0.109
       Compiling tracing v0.1.40
       Compiling subplot-build v0.9.0
        Checking nix v0.26.4
       Compiling cachedir v9.1.0 (/workspace/src)
        Checking cvt v0.1.2
       Compiling glob v0.3.1
       Compiling subplotlib v0.9.0
       Compiling fehler-macros v1.0.0
        Checking fs_at v0.1.10
        Checking normpath v1.2.0
       Compiling fehler v1.0.0
       Compiling subplotlib-derive v0.9.0
        Checking remove_dir_all v0.8.2
        Checking fs2 v0.4.3
        Checking filetime v0.2.23
        Checking state v0.5.3
        Checking shell-words v1.1.0
        Checking unescape v0.1.0
        Finished `dev` profile [unoptimized + debuginfo] target(s) in 38.39s
    [2025-09-27T07:48:15Z DEBUG ambient_ci::plan] RUN: Action finished OK
    [2025-09-27T07:48:15Z DEBUG ambient_ci::plan] RUN: Action CargoBuild
    [2025-09-27T07:48:15Z DEBUG ambient_ci::action] Plan::execute: plan=CargoBuild
    [2025-09-27T07:48:15Z DEBUG ambient_ci::action] Plan::execute: context=Context {
            envs: {
                "CARGO_TARGET_DIR": "/workspace/cache",
                "CARGO_HOME": "/workspace/deps",
                "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
            },
            source_dir: "/workspace/src",
        }
    SPAWN: argv=["cargo", "--version"]
           cwd=/workspace/src (exists? true)
    cargo 1.88.0 (873a06493 2025-05-10)
    SPAWN: argv=["cargo", "clippy", "--version"]
           cwd=/workspace/src (exists? true)
    clippy 0.1.88 (6b00bc3880 2025-06-23)
    SPAWN: argv=["rustc", "--version"]
           cwd=/workspace/src (exists? true)
    rustc 1.88.0 (6b00bc388 2025-06-23)
    SPAWN: argv=["cargo", "build", "--offline", "--locked", "--workspace", "--all-targets"]
           cwd=/workspace/src (exists? true)
       Compiling libc v0.2.155
       Compiling memchr v2.7.2
       Compiling cfg-if v1.0.0
       Compiling itoa v1.0.11
       Compiling regex-syntax v0.8.3
       Compiling thiserror v1.0.61
       Compiling same-file v1.0.6
       Compiling walkdir v2.5.0
       Compiling aho-corasick v1.1.3
       Compiling bitflags v1.3.2
       Compiling pest v2.7.10
       Compiling getrandom v0.2.15
       Compiling rand_core v0.6.4
       Compiling bstr v1.9.1
       Compiling regex-automata v0.4.6
       Compiling num-conv v0.1.0
       Compiling bitflags v2.5.0
       Compiling powerfmt v0.2.0
       Compiling time-core v0.1.2
       Compiling utf8parse v0.2.1
       Compiling time-macros v0.2.18
       Compiling anstyle-parse v0.2.4
       Compiling deranged v0.3.11
       Compiling rand_chacha v0.3.1
       Compiling pest_meta v2.7.10
       Compiling anstyle v1.0.7
       Compiling anstyle-query v1.0.3
       Compiling colorchoice v1.0.1
       Compiling linux-raw-sys v0.4.14
       Compiling globset v0.4.14
       Compiling is_terminal_polyfill v1.70.0
       Compiling anstream v0.6.14
       Compiling ignore v0.4.22
       Compiling rustix v0.38.34
       Compiling time v0.3.36
       Compiling pest_generator v2.7.10
       Compiling regex v1.10.4
       Compiling rand v0.8.5
       Compiling serde_json v1.0.117
       Compiling fastrand v2.1.0
       Compiling lazy_static v1.4.0
       Compiling clap_lex v0.7.0
       Compiling strsim v0.11.1
       Compiling git-testament-derive v0.2.0
       Compiling clap_builder v4.5.2
       Compiling tempfile v3.10.1
       Compiling pest_derive v2.7.10
       Compiling globwalk v0.8.1
       Compiling subplot v0.9.0
       Compiling is-terminal v0.4.12
       Compiling env_logger v0.10.2
       Compiling git-testament v0.2.5
       Compiling serde_yaml v0.9.34+deprecated
       Compiling tera v1.19.1
       Compiling pulldown-cmark v0.9.6
       Compiling clap v4.5.4
       Compiling tempfile-fast v0.3.4
       Compiling pikchr v0.1.3
       Compiling roadmap v0.5.0
       Compiling serde-aux v4.5.0
       Compiling base64 v0.21.7
       Compiling nix v0.26.4
       Compiling cvt v0.1.2
       Compiling fs_at v0.1.10
       Compiling fehler v1.0.0
       Compiling normpath v1.2.0
       Compiling remove_dir_all v0.8.2
       Compiling subplotlib-derive v0.9.0
       Compiling subplot-build v0.9.0
       Compiling filetime v0.2.23
       Compiling fs2 v0.4.3
       Compiling unescape v0.1.0
       Compiling shell-words v1.1.0
       Compiling state v0.5.3
       Compiling cachedir v9.1.0 (/workspace/src)
       Compiling subplotlib v0.9.0
        Finished `dev` profile [unoptimized + debuginfo] target(s) in 14.92s
    [2025-09-27T07:48:30Z DEBUG ambient_ci::plan] RUN: Action finished OK
    [2025-09-27T07:48:30Z DEBUG ambient_ci::plan] RUN: Action CargoTest
    [2025-09-27T07:48:30Z DEBUG ambient_ci::action] Plan::execute: plan=CargoTest
    [2025-09-27T07:48:30Z DEBUG ambient_ci::action] Plan::execute: context=Context {
            envs: {
                "CARGO_TARGET_DIR": "/workspace/cache",
                "CARGO_HOME": "/workspace/deps",
                "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
            },
            source_dir: "/workspace/src",
        }
    SPAWN: argv=["cargo", "--version"]
           cwd=/workspace/src (exists? true)
    cargo 1.88.0 (873a06493 2025-05-10)
    SPAWN: argv=["cargo", "clippy", "--version"]
           cwd=/workspace/src (exists? true)
    clippy 0.1.88 (6b00bc3880 2025-06-23)
    SPAWN: argv=["rustc", "--version"]
           cwd=/workspace/src (exists? true)
    rustc 1.88.0 (6b00bc388 2025-06-23)
    SPAWN: argv=["cargo", "test", "--offline", "--locked", "--workspace"]
           cwd=/workspace/src (exists? true)
        Finished `test` profile [unoptimized + debuginfo] target(s) in 0.07s
         Running unittests src/lib.rs (/workspace/cache/debug/deps/cachedir-3bc7e529cb05a405)
    
    running 0 tests
    
    test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
    
         Running unittests src/bin/cachedir.rs (/workspace/cache/debug/deps/cachedir-7282b54efa332aaf)
    
    running 0 tests
    
    test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
    
         Running tests/subplot.rs (/workspace/cache/debug/deps/subplot-5a4b17446178ddc1)
    
    running 1 test
    test managing_cache_directories ... ok
    
    test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
    
       Doc-tests cachedir
    
    running 0 tests
    
    test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
    
    [2025-09-27T07:48:30Z DEBUG ambient_ci::plan] RUN: Action finished OK
    [2025-09-27T07:48:30Z DEBUG ambient_ci::plan] RUN: Action Shell {
            shell: "subplot docgen cachedir.subplot -o /workspace/artifacts/cachedir.html\n",
        }
    [2025-09-27T07:48:30Z DEBUG ambient_ci::action] Plan::execute: plan=Shell {
            shell: "subplot docgen cachedir.subplot -o /workspace/artifacts/cachedir.html\n",
        }
    [2025-09-27T07:48:30Z DEBUG ambient_ci::action] Plan::execute: context=Context {
            envs: {
                "CARGO_TARGET_DIR": "/workspace/cache",
                "CARGO_HOME": "/workspace/deps",
                "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
            },
            source_dir: "/workspace/src",
        }
    SPAWN: argv=["/bin/bash", "-c", "set -xeuo pipefail\nsubplot docgen cachedir.subplot -o /workspace/artifacts/cachedir.html\n\n"]
           cwd=/workspace/src (exists? true)
    + subplot docgen cachedir.subplot -o /workspace/artifacts/cachedir.html
     INFO Starting Subplot
     INFO Subplot finished successfully
    [2025-09-27T07:48:30Z DEBUG ambient_ci::plan] RUN: Action finished OK
    [2025-09-27T07:48:30Z DEBUG ambient_ci::plan] RUN: Action Custom(
            Custom {
                name: "dch",
                args: {
                    "debemail": String("liw@liw.fi"),
                    "debfullname": String("Lars Wirzenius"),
                },
            },
        )
    [2025-09-27T07:48:30Z DEBUG ambient_ci::action] Plan::execute: plan=Custom(
            Custom {
                name: "dch",
                args: {
                    "debemail": String("liw@liw.fi"),
                    "debfullname": String("Lars Wirzenius"),
                },
            },
        )
    [2025-09-27T07:48:30Z DEBUG ambient_ci::action] Plan::execute: context=Context {
            envs: {
                "CARGO_TARGET_DIR": "/workspace/cache",
                "CARGO_HOME": "/workspace/deps",
                "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
            },
            source_dir: "/workspace/src",
        }
    custom: source=/workspace/src
    custom: exe=".ambient/dch" exists=false
    HEAD is now at aae0231 ci: use custom dch action under Ambient
    custom action "dch" exit code Some(0)
    [2025-09-27T07:48:31Z DEBUG ambient_ci::plan] RUN: Action finished OK
    [2025-09-27T07:48:31Z DEBUG ambient_ci::plan] RUN: Action Deb
    [2025-09-27T07:48:31Z DEBUG ambient_ci::action] Plan::execute: plan=Deb
    [2025-09-27T07:48:31Z DEBUG ambient_ci::action] Plan::execute: context=Context {
            envs: {
                "CARGO_TARGET_DIR": "/workspace/cache",
                "CARGO_HOME": "/workspace/deps",
                "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
            },
            source_dir: "/workspace/src",
        }
    SPAWN: argv=["/bin/bash", "-c", "#!/bin/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 ../*_* /workspace/artifacts\n        "]
           cwd=/workspace/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=/workspace/cache
    PWD=/workspace/src
    SYSTEMD_EXEC_PID=278
    LANG=C.UTF-8
    CARGO_HOME=/workspace/deps
    DEBEMAIL=liw@liw.fi
    INVOCATION_ID=c813ce5f535746c7811ae462addf436f
    SHLVL=2
    JOURNAL_STREAM=8:13086
    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.88.0 (873a06493 2025-05-10)
    + rustc --version
    rustc 1.88.0 (6b00bc388 2025-06-23)
    ++ dpkg-parsechangelog -SSource
    + name=cachedir
    ++ dpkg-parsechangelog -SVersion
    + version=9.1.0.ci20250927T074831-1
    ++ echo 9.1.0.ci20250927T074831-1
    ++ sed 's/-[^-]*$//'
    + uv=9.1.0.ci20250927T074831
    ++ dpkg --print-architecture
    + arch=amd64
    + orig=../cachedir_9.1.0.ci20250927T074831.orig.tar.xz
    + deb=../cachedir_9.1.0.ci20250927T074831-1_amd64.deb
    + changes=../cachedir_9.1.0.ci20250927T074831-1_amd64.changes
    + git archive HEAD
    + xz
    + dpkg-buildpackage -us -uc
    dpkg-buildpackage: info: source package cachedir
    dpkg-buildpackage: info: source version 9.1.0.ci20250927T074831-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_clean
     dpkg-source -b .
    dpkg-source: info: using source format '3.0 (quilt)'
    dpkg-source: info: building cachedir using existing ./cachedir_9.1.0.ci20250927T074831.orig.tar.xz
    dpkg-source: info: building cachedir in cachedir_9.1.0.ci20250927T074831-1.debian.tar.xz
    dpkg-source: info: building cachedir in cachedir_9.1.0.ci20250927T074831-1.dsc
     debian/rules build
    dh build
       dh_update_autotools_config
       dh_autoreconf
       debian/rules override_dh_auto_build
    make[1]: Entering directory '/workspace/src'
    true
    make[1]: Leaving directory '/workspace/src'
       debian/rules override_dh_auto_test
    make[1]: Entering directory '/workspace/src'
    echo "disabled: cargo test"
    disabled: cargo test
    make[1]: Leaving directory '/workspace/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 '/workspace/src'
    cargo install --path=. --root=debian/cachedir --offline --locked
      Installing cachedir v9.1.0 (/workspace/src)
       Compiling proc-macro2 v1.0.83
       Compiling unicode-ident v1.0.12
       Compiling memchr v2.7.2
       Compiling libc v0.2.155
       Compiling thiserror v1.0.61
       Compiling serde v1.0.202
       Compiling aho-corasick v1.1.3
       Compiling quote v1.0.36
       Compiling syn v2.0.65
       Compiling crossbeam-utils v0.8.20
       Compiling regex-syntax v0.8.3
       Compiling cfg-if v1.0.0
       Compiling log v0.4.21
       Compiling itoa v1.0.11
       Compiling once_cell v1.19.0
       Compiling same-file v1.0.6
       Compiling ryu v1.0.18
       Compiling walkdir v2.5.0
       Compiling getrandom v0.2.15
       Compiling autocfg v1.3.0
       Compiling ucd-trie v0.1.6
       Compiling anyhow v1.0.86
       Compiling regex-automata v0.4.6
       Compiling indexmap v1.9.3
       Compiling rand_core v0.6.4
       Compiling crossbeam-epoch v0.9.18
       Compiling bstr v1.9.1
       Compiling ppv-lite86 v0.2.17
       Compiling serde_json v1.0.117
       Compiling rustix v0.38.34
       Compiling num-conv v0.1.0
       Compiling version_check v0.9.4
       Compiling utf8parse v0.2.1
       Compiling unic-char-range v0.9.0
       Compiling unic-common v0.9.0
       Compiling unicode-width v0.1.12
       Compiling time-core v0.1.2
       Compiling bitflags v2.5.0
       Compiling libm v0.2.8
       Compiling powerfmt v0.2.0
       Compiling time-macros v0.2.18
       Compiling deranged v0.3.11
       Compiling globset v0.4.14
       Compiling thiserror-impl v1.0.61
       Compiling serde_derive v1.0.202
       Compiling unicase v2.7.0
       Compiling unic-ucd-version v0.9.0
       Compiling unic-char-property v0.9.0
       Compiling anstyle-parse v0.2.4
       Compiling rand_chacha v0.3.1
       Compiling crossbeam-deque v0.8.5
       Compiling colorchoice v1.0.1
       Compiling hashbrown v0.12.3
       Compiling linux-raw-sys v0.4.14
       Compiling pest v2.7.10
       Compiling anstyle-query v1.0.3
       Compiling heck v0.5.0
       Compiling anstyle v1.0.7
       Compiling is_terminal_polyfill v1.70.0
       Compiling cc v1.0.98
       Compiling linked-hash-map v0.5.6
       Compiling yaml-rust v0.4.5
       Compiling pest_meta v2.7.10
       Compiling anstream v0.6.14
       Compiling pikchr v0.1.3
       Compiling clap_derive v4.5.4
       Compiling pest_generator v2.7.10
       Compiling ignore v0.4.22
       Compiling rand v0.8.5
       Compiling unic-ucd-segment v0.9.0
       Compiling time v0.3.36
       Compiling regex v1.10.4
       Compiling deunicode v1.6.0
       Compiling bitflags v1.3.2
       Compiling equivalent v1.0.1
       Compiling unicode-linebreak v0.1.5
       Compiling fastrand v2.1.0
       Compiling clap_lex v0.7.0
       Compiling strsim v0.11.1
       Compiling hashbrown v0.14.5
       Compiling smawk v0.3.2
       Compiling pulldown-cmark v0.9.6
       Compiling textwrap v0.15.2
       Compiling git-testament-derive v0.2.0
       Compiling indexmap v2.2.6
       Compiling clap_builder v4.5.2
       Compiling tempfile v3.10.1
       Compiling globwalk v0.8.1
       Compiling humansize v2.1.3
       Compiling slug v0.1.5
       Compiling serde_yaml v0.8.26
       Compiling unic-segment v0.9.0
       Compiling pest_derive v2.7.10
       Compiling subplot v0.9.0
       Compiling getopts v0.2.21
       Compiling is-terminal v0.4.12
       Compiling unsafe-libyaml v0.2.11
       Compiling humantime v2.1.0
       Compiling lazy_static v1.4.0
       Compiling utf8-width v0.1.7
       Compiling termcolor v1.4.1
       Compiling percent-encoding v2.3.1
       Compiling tera v1.19.1
       Compiling serde_yaml v0.9.34+deprecated
       Compiling env_logger v0.10.2
       Compiling html-escape v0.2.13
       Compiling clap v4.5.4
       Compiling roadmap v0.5.0
       Compiling git-testament v0.2.5
       Compiling tempfile-fast v0.3.4
       Compiling serde-aux v4.5.0
       Compiling tracing-attributes v0.1.27
       Compiling tracing-core v0.1.32
       Compiling line-col v0.2.1
       Compiling base64 v0.21.7
       Compiling file_diff v1.0.0
       Compiling pin-project-lite v0.2.14
       Compiling tracing v0.1.40
       Compiling subplot-build v0.9.0
       Compiling cachedir v9.1.0 (/workspace/src)
        Finished `release` profile [optimized] target(s) in 27.55s
      Installing debian/cachedir/bin/cachedir
       Installed package `cachedir v9.1.0 (/workspace/src)` (executable `cachedir`)
    warning: be sure to add `debian/cachedir/bin` to your PATH to be able to run the installed binaries
    find debian/cachedir -name '.crates*' -delete
    make[1]: Leaving directory '/workspace/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
    dpkg-gencontrol: warning: Built-Using field of package cachedir: substitution variable ${cargo:Built-Using} used, but is not defined
    dpkg-gencontrol: warning: Built-Using field of package cachedir: substitution variable ${cargo:Built-Using} used, but is not defined
       dh_md5sums
       dh_builddeb
    dpkg-deb: building package 'cachedir-dbgsym' in '../cachedir-dbgsym_9.1.0.ci20250927T074831-1_amd64.deb'.
    dpkg-deb: building package 'cachedir' in '../cachedir_9.1.0.ci20250927T074831-1_amd64.deb'.
     dpkg-genbuildinfo -O../cachedir_9.1.0.ci20250927T074831-1_amd64.buildinfo
     dpkg-genchanges -O../cachedir_9.1.0.ci20250927T074831-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 428
    drwxr-xr-x 2 root root   4096 Sep 27 07:48 artifacts
    drwxr-xr-x 5 root root   4096 Sep 27 07:48 cache
    -rw-r--r-- 1 root root  46052 Sep 27 07:49 cachedir-dbgsym_9.1.0.ci20250927T074831-1_amd64.deb
    -rw-r--r-- 1 root root   1384 Sep 27 07:48 cachedir_9.1.0.ci20250927T074831-1.debian.tar.xz
    -rw-r--r-- 1 root root    956 Sep 27 07:48 cachedir_9.1.0.ci20250927T074831-1.dsc
    -rw-r--r-- 1 root root   6332 Sep 27 07:49 cachedir_9.1.0.ci20250927T074831-1_amd64.buildinfo
    -rw-r--r-- 1 root root   2369 Sep 27 07:49 cachedir_9.1.0.ci20250927T074831-1_amd64.changes
    -rw-r--r-- 1 root root 331924 Sep 27 07:49 cachedir_9.1.0.ci20250927T074831-1_amd64.deb
    -rw-r--r-- 1 root root  16244 Sep 27 07:48 cachedir_9.1.0.ci20250927T074831.orig.tar.xz
    drwxr-xr-x 3 root root   4096 Sep 27 07:47 deps
    drwxr-xr-x 8 root root   4096 Sep 27 07:48 src
    + for x in ../*.deb
    + dpkg -c ../cachedir-dbgsym_9.1.0.ci20250927T074831-1_amd64.deb
    drwxr-xr-x root/root         0 2025-09-27 07:48 ./
    drwxr-xr-x root/root         0 2025-09-27 07:48 ./usr/
    drwxr-xr-x root/root         0 2025-09-27 07:48 ./usr/lib/
    drwxr-xr-x root/root         0 2025-09-27 07:48 ./usr/lib/debug/
    drwxr-xr-x root/root         0 2025-09-27 07:48 ./usr/lib/debug/.build-id/
    drwxr-xr-x root/root         0 2025-09-27 07:48 ./usr/lib/debug/.build-id/74/
    -rw-r--r-- root/root    218952 2025-09-27 07:48 ./usr/lib/debug/.build-id/74/dc05ec892b8dfc4a10a1a7504f9f80b74ae6b2.debug
    drwxr-xr-x root/root         0 2025-09-27 07:48 ./usr/share/
    drwxr-xr-x root/root         0 2025-09-27 07:48 ./usr/share/doc/
    lrwxrwxrwx root/root         0 2025-09-27 07:48 ./usr/share/doc/cachedir-dbgsym -> cachedir
    + for x in ../*.deb
    + dpkg -c ../cachedir_9.1.0.ci20250927T074831-1_amd64.deb
    drwxr-xr-x root/root         0 2025-09-27 07:48 ./
    drwxr-xr-x root/root         0 2025-09-27 07:48 ./bin/
    -rwxr-xr-x root/root   1008352 2025-09-27 07:48 ./bin/cachedir
    drwxr-xr-x root/root         0 2025-09-27 07:48 ./usr/
    drwxr-xr-x root/root         0 2025-09-27 07:48 ./usr/share/
    drwxr-xr-x root/root         0 2025-09-27 07:48 ./usr/share/doc/
    drwxr-xr-x root/root         0 2025-09-27 07:48 ./usr/share/doc/cachedir/
    -rw-r--r-- root/root       384 2025-09-27 07:48 ./usr/share/doc/cachedir/changelog.Debian.gz
    -rw-r--r-- root/root       299 2025-09-27 07:48 ./usr/share/doc/cachedir/copyright
    drwxr-xr-x root/root         0 2025-09-27 07:48 ./usr/share/lintian/
    drwxr-xr-x root/root         0 2025-09-27 07:48 ./usr/share/lintian/overrides/
    -rw-r--r-- root/root        32 2025-09-27 07:48 ./usr/share/lintian/overrides/cachedir
    + mv ../cachedir-dbgsym_9.1.0.ci20250927T074831-1_amd64.deb ../cachedir_9.1.0.ci20250927T074831-1.debian.tar.xz ../cachedir_9.1.0.ci20250927T074831-1.dsc ../cachedir_9.1.0.ci20250927T074831-1_amd64.buildinfo ../cachedir_9.1.0.ci20250927T074831-1_amd64.changes ../cachedir_9.1.0.ci20250927T074831-1_amd64.deb ../cachedir_9.1.0.ci20250927T074831.orig.tar.xz /workspace/artifacts
    [2025-09-27T07:49:02Z DEBUG ambient_ci::plan] RUN: Action finished OK
    [2025-09-27T07:49:02Z DEBUG ambient_ci::plan] RUN: Action TarCreate {
            archive: "/dev/vde",
            directory: "/workspace/cache",
        }
    [2025-09-27T07:49:02Z DEBUG ambient_ci::action] Plan::execute: plan=TarCreate {
            archive: "/dev/vde",
            directory: "/workspace/cache",
        }
    [2025-09-27T07:49:02Z DEBUG ambient_ci::action] Plan::execute: context=Context {
            envs: {
                "CARGO_TARGET_DIR": "/workspace/cache",
                "CARGO_HOME": "/workspace/deps",
                "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
            },
            source_dir: "/workspace/src",
        }
    [2025-09-27T07:49:02Z TRACE ambient_ci::vdrive] creating virtual drive (tar archive): VirtualDriveBuilder {
            filename: Some(
                "/dev/vde",
            ),
            root: Some(
                "/workspace/cache",
            ),
            size: None,
        }
    [2025-09-27T07:49:02Z TRACE ambient_ci::vdrive] tar archive to be created: /dev/vde; exists? true
    [2025-09-27T07:49:02Z TRACE ambient_ci::vdrive] create archive file /dev/vde
    [2025-09-27T07:49:02Z TRACE ambient_ci::vdrive] directory /workspace/cache exists? true
    [2025-09-27T07:49:02Z TRACE ambient_ci::vdrive] add contents of /workspace/cache as .
    [2025-09-27T07:49:02Z TRACE ambient_ci::vdrive] calling tar_create
    [2025-09-27T07:49:07Z TRACE ambient_ci::vdrive] created virtual drive /dev/vde
    [2025-09-27T07:49:07Z DEBUG ambient_ci::plan] RUN: Action finished OK
    [2025-09-27T07:49:07Z DEBUG ambient_ci::plan] RUN: Action TarCreate {
            archive: "/dev/vdd",
            directory: "/workspace/artifacts",
        }
    [2025-09-27T07:49:07Z DEBUG ambient_ci::action] Plan::execute: plan=TarCreate {
            archive: "/dev/vdd",
            directory: "/workspace/artifacts",
        }
    [2025-09-27T07:49:07Z DEBUG ambient_ci::action] Plan::execute: context=Context {
            envs: {
                "CARGO_TARGET_DIR": "/workspace/cache",
                "CARGO_HOME": "/workspace/deps",
                "PATH": "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin",
            },
            source_dir: "/workspace/src",
        }
    [2025-09-27T07:49:07Z TRACE ambient_ci::vdrive] creating virtual drive (tar archive): VirtualDriveBuilder {
            filename: Some(
                "/dev/vdd",
            ),
            root: Some(
                "/workspace/artifacts",
            ),
            size: None,
        }
    [2025-09-27T07:49:07Z TRACE ambient_ci::vdrive] tar archive to be created: /dev/vdd; exists? true
    [2025-09-27T07:49:07Z TRACE ambient_ci::vdrive] create archive file /dev/vdd
    [2025-09-27T07:49:07Z TRACE ambient_ci::vdrive] directory /workspace/artifacts exists? true
    [2025-09-27T07:49:07Z TRACE ambient_ci::vdrive] add contents of /workspace/artifacts as .
    [2025-09-27T07:49:07Z TRACE ambient_ci::vdrive] calling tar_create
    [2025-09-27T07:49:07Z TRACE ambient_ci::vdrive] created virtual drive /dev/vdd
    [2025-09-27T07:49:07Z DEBUG ambient_ci::plan] RUN: Action finished OK
    [2025-09-27T07:49:07Z DEBUG ambient_ci::plan] All actions were performed successfully
    ambient-execute-plan ends
    EXIT CODE: 0
    
    ====================
[2025-09-27T07:49:16Z DEBUG ambient_ci::qemu] QEMU: CI run under exit code 0
[2025-09-27T07:49:16Z DEBUG ambient_ci::run] CI run exit code from QEMU: 0
[2025-09-27T07:49:16Z DEBUG ambient_ci::run] remove old cache
[2025-09-27T07:49:16Z DEBUG ambient_ci::run] extract cache
[2025-09-27T07:49:17Z DEBUG ambient_ci::run] Executing post-plan steps
[2025-09-27T07:49:17Z DEBUG ambient_ci::plan] RUN: Action Dput {
        artifactsdir: "/srv/ambient-state/cachedir/artifacts",
        dput_target: Some(
            "apt.liw.fi",
        ),
    }
[2025-09-27T07:49:17Z DEBUG ambient_ci::action] Plan::execute: plan=Dput {
        artifactsdir: "/srv/ambient-state/cachedir/artifacts",
        dput_target: Some(
            "apt.liw.fi",
        ),
    }
[2025-09-27T07:49:17Z DEBUG ambient_ci::action] Plan::execute: context=Context {
        envs: {
            "PATH": "/root/.cargo/bin:/bin:/home/_rad/.radicle/bin:/home/_rad/.cargo/bin",
            "CARGO_TARGET_DIR": "/srv/ambient-state/cachedir/cache",
            "CARGO_HOME": "/srv/ambient-state/cachedir/dependencies",
        },
        source_dir: "/tmp/.tmpIx6m2k/src",
    }
[2025-09-27T07:49:17Z DEBUG ambient_ci::util] found /srv/ambient-state/cachedir/artifacts
[2025-09-27T07:49:17Z DEBUG ambient_ci::util] found /srv/ambient-state/cachedir/artifacts/cachedir_9.1.0.ci20250927T074831-1_amd64.buildinfo
[2025-09-27T07:49:17Z DEBUG ambient_ci::util] found /srv/ambient-state/cachedir/artifacts/cachedir_9.1.0.ci20250927T074831-1_amd64.deb
[2025-09-27T07:49:17Z DEBUG ambient_ci::util] found /srv/ambient-state/cachedir/artifacts/cachedir.html
[2025-09-27T07:49:17Z DEBUG ambient_ci::util] found /srv/ambient-state/cachedir/artifacts/cachedir_9.1.0.ci20250927T074831-1_amd64.changes
[2025-09-27T07:49:17Z DEBUG ambient_ci::util] found /srv/ambient-state/cachedir/artifacts/cachedir-dbgsym_9.1.0.ci20250927T074831-1_amd64.deb
[2025-09-27T07:49:17Z DEBUG ambient_ci::util] found /srv/ambient-state/cachedir/artifacts/cachedir_9.1.0.ci20250927T074831-1.dsc
[2025-09-27T07:49:17Z DEBUG ambient_ci::util] found /srv/ambient-state/cachedir/artifacts/cachedir_9.1.0.ci20250927T074831.orig.tar.xz
[2025-09-27T07:49:17Z DEBUG ambient_ci::util] found /srv/ambient-state/cachedir/artifacts/cachedir_9.1.0.ci20250927T074831-1.debian.tar.xz
[2025-09-27T07:49:17Z INFO  ambient_ci::util] dput apt.liw.fi /srv/ambient-state/cachedir/artifacts/cachedir_9.1.0.ci20250927T074831-1_amd64.changes
[2025-09-27T07:49:18Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-27T07:49:18Z DEBUG ambient_ci::plan] RUN: Action Rsync {
        artifactsdir: "/srv/ambient-state/cachedir/artifacts",
        rsync_target: Some(
            "ci@http.liw.fi:/srv/http/doc.liw.fi/cachedir",
        ),
    }
[2025-09-27T07:49:18Z DEBUG ambient_ci::action] Plan::execute: plan=Rsync {
        artifactsdir: "/srv/ambient-state/cachedir/artifacts",
        rsync_target: Some(
            "ci@http.liw.fi:/srv/http/doc.liw.fi/cachedir",
        ),
    }
[2025-09-27T07:49:18Z DEBUG ambient_ci::action] Plan::execute: context=Context {
        envs: {
            "PATH": "/root/.cargo/bin:/bin:/home/_rad/.radicle/bin:/home/_rad/.cargo/bin",
            "CARGO_TARGET_DIR": "/srv/ambient-state/cachedir/cache",
            "CARGO_HOME": "/srv/ambient-state/cachedir/dependencies",
        },
        source_dir: "/tmp/.tmpIx6m2k/src",
    }
[2025-09-27T07:49:18Z INFO  ambient_ci::util] rsync /srv/ambient-state/cachedir/artifacts/. -> ci@http.liw.fi:/srv/http/doc.liw.fi/cachedir/.
[2025-09-27T07:49:19Z DEBUG ambient_ci::plan] RUN: Action finished OK
[2025-09-27T07:49:19Z DEBUG ambient_ci::plan] All actions were performed successfully
[2025-09-27T07:49:19Z DEBUG ambient_ci::project] write project state to /srv/ambient-state/cachedir/meta.yaml
[2025-09-27T07:49:19Z INFO  ambient] ambient ends successfully

Ambient stderr

<empty log>