CI run log: rad:z2R1kHGj9718qAjN3U6upyzJgjeCm

Radicle info

Trigger message
{
  "request": "trigger",
  "version": 1,
  "event_type": "push",
  "repository": {
    "id": "rad:z2R1kHGj9718qAjN3U6upyzJgjeCm",
    "name": "sop-run",
    "description": "Convenience library in Rust to run a Stateless OpenPGP implemenation",
    "private": false,
    "default_branch": "main",
    "delegates": [
      "did:key:z6MkgEMYod7Hxfy9qCvDv5hYHkZ4ciWmLFgfvm3Wn1b2w2FV"
    ]
  },
  "pusher": {
    "id": "did:key:z6MkgEMYod7Hxfy9qCvDv5hYHkZ4ciWmLFgfvm3Wn1b2w2FV",
    "alias": "liw"
  },
  "before": "876d88f355acfd91e85be3284b8a1507607c7729",
  "after": "876d88f355acfd91e85be3284b8a1507607c7729",
  "branch": "main",
  "commits": [
    "876d88f355acfd91e85be3284b8a1507607c7729"
  ]
}
Ambient stdout
executor from config: /usr/bin/ambient-execute-plan
executor from PATH: /usr/bin/ambient-execute-plan
run CI for rad:z2R1kHGj9718qAjN3U6upyzJgjeCm
Ambient stderr
<empty log>

Pre-plan VM

Structured log: all OK
  1. 0 ms: Executor starts
    • Name: ambient-execute-plan
    • Version: 0.15.0@eeab732
  2. 2 ms: Runnable plan
    steps:
- action: mkdir
  pathname: /ci
- action: mkdir
  pathname: /ci/artifacts
- action: mkdir
  pathname: /ci/artifacts/debian
- action: mkdir
  pathname: /ci/artifacts/rsync
- action: mkdir
  pathname: /ci/secrets
- action: mkdir
  pathname: /ci/deps
- action: tar_extract
  archive: /dev/vdc
  directory: /ci/src
- action: tar_extract
  archive: /dev/vdf
  directory: /ci/deps
- action: tar_extract
  archive: /dev/vde
  directory: /ci/cache
- action: tar_extract
  archive: /dev/vdd
  directory: /ci/artifacts
- action: tar_extract
  archive: /dev/vdg
  directory: /ci/secrets
- action: shell
  shell: ln -sf /ci /workspace
- action: create_file
  filename: /root/.ssh/config
  content: "Host *\nStrictHostKeyChecking accept-new\nIdentityFile /ci/secrets/ssh_key\n                "
  overwrite: true
- action: cargo_fetch
- action: tar_create
  archive: /dev/vde
  directory: /ci/cache
- action: tar_create
  archive: /dev/vdd
  directory: /ci/artifacts
- action: tar_create
  archive: /dev/vdf
  directory: /ci/deps
executor_drive: /dev/vdb
source_drive: /dev/vdc
artifact_drive: /dev/vdd
cache_drive: /dev/vde
deps_drive: /dev/vdf
secrets_drive: null
workspace_dir: /ci
source_dir: /ci/src
deps_dir: /ci/deps
cache_dir: /ci/cache
artifacts_dir: /ci/artifacts
secrets_dir: null
envs: {}
  3. 34 ms: Execute action: mkdir: /ci
    - action: mkdir
  pathname: /ci
  4. 37 ms: Action succeeded: mkdir: /ci
    - action: mkdir
  pathname: /ci
  5. 38 ms: Execute action: mkdir: /ci/artifacts
    - action: mkdir
  pathname: /ci/artifacts
  6. 38 ms: Action succeeded: mkdir: /ci/artifacts
    - action: mkdir
  pathname: /ci/artifacts
  7. 39 ms: Execute action: mkdir: /ci/artifacts/debian
    - action: mkdir
  pathname: /ci/artifacts/debian
  8. 39 ms: Action succeeded: mkdir: /ci/artifacts/debian
    - action: mkdir
  pathname: /ci/artifacts/debian
  9. 39 ms: Execute action: mkdir: /ci/artifacts/rsync
    - action: mkdir
  pathname: /ci/artifacts/rsync
  10. 39 ms: Action succeeded: mkdir: /ci/artifacts/rsync
    - action: mkdir
  pathname: /ci/artifacts/rsync
  11. 39 ms: Execute action: mkdir: /ci/secrets
    - action: mkdir
  pathname: /ci/secrets
  12. 39 ms: Action succeeded: mkdir: /ci/secrets
    - action: mkdir
  pathname: /ci/secrets
  13. 39 ms: Execute action: mkdir: /ci/deps
    - action: mkdir
  pathname: /ci/deps
  14. 39 ms: Action succeeded: mkdir: /ci/deps
    - action: mkdir
  pathname: /ci/deps
  15. 39 ms: Execute action: tar_extract
    - action: tar_extract
  archive: /dev/vdc
  directory: /ci/src
  16. 65 ms: Action succeeded: tar_extract
    - action: tar_extract
  archive: /dev/vdc
  directory: /ci/src
  17. 65 ms: Execute action: tar_extract
    - action: tar_extract
  archive: /dev/vdf
  directory: /ci/deps
  18. 71 ms: Action succeeded: tar_extract
    - action: tar_extract
  archive: /dev/vdf
  directory: /ci/deps
  19. 71 ms: Execute action: tar_extract
    - action: tar_extract
  archive: /dev/vde
  directory: /ci/cache
  20. 347 ms: Action succeeded: tar_extract
    - action: tar_extract
  archive: /dev/vde
  directory: /ci/cache
  21. 350 ms: Execute action: tar_extract
    - action: tar_extract
  archive: /dev/vdd
  directory: /ci/artifacts
  22. 354 ms: Action succeeded: tar_extract
    - action: tar_extract
  archive: /dev/vdd
  directory: /ci/artifacts
  23. 357 ms: Execute action: tar_extract
    - action: tar_extract
  archive: /dev/vdg
  directory: /ci/secrets
  24. 361 ms: Action succeeded: tar_extract
    - action: tar_extract
  archive: /dev/vdg
  directory: /ci/secrets
  25. 364 ms: Execute action: shell: ln -sf /ci /workspace
    - action: shell
  shell: ln -sf /ci /workspace
  26. 366 ms: Start program: bash
    • bash
    • -c
    • set -xeuo pipefail ln -sf /ci /workspace
  27. 373 ms: Program succeeded
    • Exit code: 0
    • Stdout
    • Stderr
      + ln -sf /ci /workspace

  28. 376 ms: Action succeeded: shell: ln -sf /ci /workspace
    - action: shell
  shell: ln -sf /ci /workspace

  29. 378 ms: Execute action: create_file
    - action: create_file
  filename: /root/.ssh/config
  content: "Host *\nStrictHostKeyChecking accept-new\nIdentityFile /ci/secrets/ssh_key\n                "
  overwrite: true

  30. 383 ms: Action succeeded: create_file
    - action: create_file
  filename: /root/.ssh/config
  content: "Host *\nStrictHostKeyChecking accept-new\nIdentityFile /ci/secrets/ssh_key\n                "
  overwrite: true

  31. 387 ms: Execute action: cargo_fetch
    - action: cargo_fetch

  32. 389 ms: Start program: cargo
    • cargo
    • --version
  33. 418 ms: Program succeeded
    • Exit code: 0
    • Stdout
      cargo 1.96.1 (356927216 2026-06-26)

    • Stderr
  34. 420 ms: Start program: cargo
    • cargo
    • clippy
    • --version
  35. 476 ms: Program succeeded
    • Exit code: 0
    • Stdout
      clippy 0.1.96 (31fca3adb2 2026-06-26)

    • Stderr
  36. 476 ms: Start program: rustc
    • rustc
    • --version
  37. 495 ms: Program succeeded
    • Exit code: 0
    • Stdout
      rustc 1.96.1 (31fca3adb 2026-06-26)

    • Stderr
  38. 500 ms: Start program: cargo
    • cargo
    • fetch
    • --locked
  39. 2675 ms: Program succeeded
    • Exit code: 0
    • Stdout
    • Stderr
          Updating crates.io index
 Downloading crates ...
  Downloaded itoa v1.0.17
  Downloaded cfg-if v1.0.4
  Downloaded windows-link v0.2.1
  Downloaded errno v0.3.14
  Downloaded redox_users v0.4.6
  Downloaded libredox v0.1.12
  Downloaded fastrand v2.3.0
  Downloaded unicode-xid v0.2.6
  Downloaded thiserror v2.0.18
  Downloaded toml_writer v1.0.6+spec-1.1.0
  Downloaded foldhash v0.1.5
  Downloaded wit-bindgen-rust-macro v0.51.0
  Downloaded serde_spanned v1.0.4
  Downloaded equivalent v1.0.2
  Downloaded mutants v0.0.3
  Downloaded directories-next v2.0.0
  Downloaded id-arena v2.3.0
  Downloaded toml_datetime v0.7.5+spec-1.1.0
  Downloaded dirs-sys-next v0.1.2
  Downloaded heck v0.5.0
  Downloaded leb128fmt v0.1.0
  Downloaded zmij v1.0.20
  Downloaded wit-bindgen-rust v0.51.0
  Downloaded thiserror-impl v1.0.69
  Downloaded thiserror-impl v2.0.18
  Downloaded quote v1.0.44
  Downloaded semver v1.0.27
  Downloaded wasi v0.11.1+wasi-snapshot-preview1
  Downloaded clingwrap v0.6.1
  Downloaded bitflags v2.10.0
  Downloaded wasm-metadata v0.244.0
  Downloaded once_cell v1.21.3
  Downloaded unicode-ident v1.0.23
  Downloaded getrandom v0.2.17
  Downloaded toml_parser v1.0.6+spec-1.1.0
  Downloaded serde_derive v1.0.228
  Downloaded thiserror v1.0.69
  Downloaded ryu v1.0.23
  Downloaded proc-macro2 v1.0.106
  Downloaded anyhow v1.0.101
  Downloaded toml v0.9.11+spec-1.1.0
  Downloaded serde_norway v0.9.42
  Downloaded unsafe-libyaml-norway v0.2.15
  Downloaded prettyplease v0.2.37
  Downloaded memchr v2.8.0
  Downloaded wasip2 v1.0.2+wasi-0.2.9
  Downloaded wasip3 v0.4.0+wasi-0.3.0-rc-2026-01-06
  Downloaded syn v2.0.114
  Downloaded hashbrown v0.16.1
  Downloaded serde_json v1.0.149
  Downloaded winnow v0.7.14
  Downloaded hashbrown v0.15.5
  Downloaded wit-parser v0.244.0
  Downloaded indexmap v2.13.0
  Downloaded wasmparser v0.244.0
  Downloaded wit-component v0.244.0
  Downloaded r-efi v5.3.0
  Downloaded wasm-encoder v0.244.0
  Downloaded serde v1.0.228
  Downloaded serde_core v1.0.228
  Downloaded wit-bindgen v0.51.0
  Downloaded log v0.4.29
  Downloaded rustix v1.1.4
  Downloaded getrandom v0.4.1
  Downloaded wit-bindgen-core v0.51.0
  Downloaded tempfile v3.26.0
  Downloaded libc v0.2.182
  Downloaded winapi v0.3.9
  Downloaded windows-sys v0.61.2
  Downloaded winapi-i686-pc-windows-gnu v0.4.0
  Downloaded winapi-x86_64-pc-windows-gnu v0.4.0
  Downloaded linux-raw-sys v0.12.1

  40. 2711 ms: Action succeeded: cargo_fetch
    - action: cargo_fetch

  41. 2713 ms: Execute action: tar_create
    - action: tar_create
  archive: /dev/vde
  directory: /ci/cache

  42. 3026 ms: Action succeeded: tar_create
    - action: tar_create
  archive: /dev/vde
  directory: /ci/cache

  43. 3030 ms: Execute action: tar_create
    - action: tar_create
  archive: /dev/vdd
  directory: /ci/artifacts

  44. 3035 ms: Action succeeded: tar_create
    - action: tar_create
  archive: /dev/vdd
  directory: /ci/artifacts

  45. 3038 ms: Execute action: tar_create
    - action: tar_create
  archive: /dev/vdf
  directory: /ci/deps

  46. 4014 ms: Action succeeded: tar_create
    - action: tar_create
  archive: /dev/vdf
  directory: /ci/deps

  47. 4015 ms: Plan succededThere was much rejoicing!
  48. 4015 ms: Executor ends successfullyPhew, nothing seems to have gone wrong.
Console log
BdsDxe: 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(0x3,0x0)
BdsDxe: starting Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x3,0x0)
  Booting `Debian GNU/Linux'

Loading Linux 6.12.86+deb13-amd64 ...
Loading initial ramdisk ...
EFI stub: Loaded initrd from LINUX_EFI_INITRD_MEDIA_GUID device path
Loading, please wait...
Starting systemd-udevd version 257.13-1~deb13u1
Begin: Loading essential drivers ... done.
Begin: Running /scripts/init-premount ... done.
Begin: Mounting root file system ... Begin: Running /scripts/local-top ... done.
Begin: Running /scripts/local-premount ... done.
Begin: Will now check root file system ... fsck from util-linux 2.41
fsck: error 2 (No such file or directory) while executing fsck.ext4 for /dev/vda2
fsck exited with status code 8
done.
Warning: File system check failed but did not detect errors
done.
Begin: Running /scripts/local-bottom ... done.
Begin: Running /scripts/init-bottom ... done.

Welcome to Debian GNU/Linux 13 (trixie)!

[  OK  ] Created slice system-getty.slice - Slice /system/getty.
[  OK  ] Created slice system-modprobe.slice - Slice /system/modprobe.
[  OK  ] Created slice system-serial\x2dget…slice - Slice /system/serial-getty.
[  OK  ] Created slice user.slice - User and Session Slice.
[  OK  ] Started systemd-ask-password-conso…equests to Console Directory Watch.
[  OK  ] Started systemd-ask-password-wall.…d Requests to Wall Directory Watch.
[  OK  ] Set up automount proc-sys-fs-binfm…ormats File System Automount Point.
         Expecting device dev-ttyS0.device - /dev/ttyS0...
[  OK  ] Reached target paths.target - Path Units.
[  OK  ] Reached target remote-fs.target - Remote File Systems.
[  OK  ] Reached target slices.target - Slice Units.
[  OK  ] Reached target swap.target - Swaps.
[  OK  ] Listening on systemd-creds.socket - Credential Encryption/Decryption.
[  OK  ] Listening on systemd-initctl.socke…- initctl Compatibility Named Pipe.
[  OK  ] Listening on systemd-journald-dev-…socket - Journal Socket (/dev/log).
[  OK  ] Listening on systemd-journald.socket - Journal Sockets.
[  OK  ] Listening on systemd-networkd.socket - Network Service Netlink Socket.
[  OK  ] Listening on systemd-udevd-control.socket - udev Control Socket.
[  OK  ] Listening on systemd-udevd-kernel.socket - udev Kernel Socket.
         Mounting dev-hugepages.mount - Huge Pages File System...
         Mounting dev-mqueue.mount - POSIX Message Queue File System...
         Mounting run-lock.mount - Legacy Locks Directory /run/lock...
         Mounting sys-kernel-debug.mount - Kernel Debug File System...
         Mounting sys-kernel-tracing.mount - Kernel Trace File System...
         Mounting tmp.mount - Temporary Directory /tmp...
         Starting kmod-static-nodes.service…eate List of Static Device Nodes...
         Starting modprobe@configfs.service - Load Kernel Module configfs...
         Starting modprobe@drm.service - Load Kernel Module drm...
         Starting modprobe@efi_pstore.servi… - Load Kernel Module efi_pstore...
         Starting modprobe@fuse.service - Load Kernel Module fuse...
         Starting systemd-journald.service - Journal Service...
         Starting systemd-modules-load.service - Load Kernel Modules...
         Starting systemd-network-generator…k Units from Kernel Command Line...
         Starting systemd-remount-fs.servic…unt Root and Kernel File Systems...
         Starting systemd-udev-load-credent…Load udev Rules from Credentials...
         Starting systemd-udev-trigger.service - Coldplug All udev Devices...
[  OK  ] Mounted dev-hugepages.mount - Huge Pages File System.
[  OK  ] Started systemd-journald.service - Journal Service.
[  OK  ] Mounted dev-mqueue.mount - POSIX Message Queue File System.
[  OK  ] Mounted run-lock.mount - Legacy Locks Directory /run/lock.
[  OK  ] Mounted sys-kernel-debug.mount - Kernel Debug File System.
[  OK  ] Mounted sys-kernel-tracing.mount - Kernel Trace File System.
[  OK  ] Mounted tmp.mount - Temporary Directory /tmp.
[  OK  ] Finished kmod-static-nodes.service…Create List of Static Device Nodes.
[  OK  ] Finished modprobe@configfs.service - Load Kernel Module configfs.
[  OK  ] Finished modprobe@drm.service - Load Kernel Module drm.
[  OK  ] Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
[  OK  ] Finished modprobe@fuse.service - Load Kernel Module fuse.
[  OK  ] Finished systemd-modules-load.service - Load Kernel Modules.
[  OK  ] Finished systemd-network-generator…ork Units from Kernel Command Line.
[  OK  ] Finished systemd-remount-fs.servic…mount Root and Kernel File Systems.
[  OK  ] Finished systemd-udev-load-credent…- Load udev Rules from Credentials.
[  OK  ] Reached target network-pre.target - Preparation for Network.
         Mounting sys-fs-fuse-connections.mount - FUSE Control File System...
         Mounting sys-kernel-config.mount - Kernel Configuration File System...
         Starting systemd-journal-flush.ser…sh Journal to Persistent Storage...
         Starting systemd-random-seed.service - Load/Save OS Random Seed...
         Starting systemd-sysctl.service - Apply Kernel Variables...
         Starting systemd-tmpfiles-setup-de… Device Nodes in /dev gracefully...
[  OK  ] Mounted sys-fs-fuse-connections.mount - FUSE Control File System.
[  OK  ] Mounted sys-kernel-config.mount - Kernel Configuration File System.
[  OK  ] Finished systemd-udev-trigger.service - Coldplug All udev Devices.
[  OK  ] Finished systemd-sysctl.service - Apply Kernel Variables.
[  OK  ] Finished systemd-tmpfiles-setup-de…ic Device Nodes in /dev gracefully.
         Starting systemd-sysusers.service - Create System Users...
[  OK  ] Finished systemd-random-seed.service - Load/Save OS Random Seed.
[  OK  ] Finished systemd-journal-flush.ser…lush Journal to Persistent Storage.
[  OK  ] Finished systemd-sysusers.service - Create System Users.
         Starting systemd-resolved.service - Network Name Resolution...
         Starting systemd-tmpfiles-setup-de…eate Static Device Nodes in /dev...
[  OK  ] Finished systemd-tmpfiles-setup-de…Create Static Device Nodes in /dev.
[  OK  ] Reached target local-fs-pre.target…Preparation for Local File Systems.
[  OK  ] Set up automount efi.automount - EFI System Partition Automount.
[  OK  ] Reached target local-fs.target - Local File Systems.
[  OK  ] Listening on systemd-sysext.socket… System Extension Image Management.
         Starting systemd-binfmt.service - Set Up Additional Binary Formats...
         Starting systemd-tmpfiles-setup.se…ate System Files and Directories...
         Starting systemd-udevd.service - R…ager for Device Events and Files...
[  OK  ] Started systemd-resolved.service - Network Name Resolution.
[  OK  ] Reached target nss-lookup.target - Host and Network Name Lookups.
[  OK  ] Finished systemd-tmpfiles-setup.se…reate System Files and Directories.
         Starting ldconfig.service - Rebuild Dynamic Linker Cache...
         Starting systemd-journal-catalog-u…ervice - Rebuild Journal Catalog...
[  OK  ] Started systemd-udevd.service - Ru…anager for Device Events and Files.
         Starting systemd-networkd.service - Network Configuration...
[  OK  ] Finished systemd-journal-catalog-u….service - Rebuild Journal Catalog.
[  OK  ] Found device dev-ttyS0.device - /dev/ttyS0.
[  OK  ] Finished ldconfig.service - Rebuild Dynamic Linker Cache.
         Starting systemd-update-done.service - Update is Completed...
[  OK  ] Finished systemd-update-done.service - Update is Completed.
         Mounting proc-sys-fs-binfmt_misc.m…cutable File Formats File System...
[  OK  ] Mounted proc-sys-fs-binfmt_misc.mo…xecutable File Formats File System.
[  OK  ] Finished systemd-binfmt.service - Set Up Additional Binary Formats.
[  OK  ] Reached target sysinit.target - System Initialization.
[  OK  ] Started apt-daily.timer - Daily apt download activities.
[  OK  ] Started apt-daily-upgrade.timer - …y apt upgrade and clean activities.
[  OK  ] Started dpkg-db-backup.timer - Daily dpkg database backup timer.
[  OK  ] Started fstrim.timer - Discard unused filesystem blocks once a week.
[  OK  ] Started man-db.timer - Daily man-db regeneration.
[  OK  ] Started systemd-tmpfiles-clean.tim…y Cleanup of Temporary Directories.
[  OK  ] Reached target timers.target - Timer Units.
[  OK  ] Listening on dbus.socket - D-Bus System Message Bus Socket.
[  OK  ] Listening on sshd-unix-local.socke…temd-ssh-generator, AF_UNIX Local).
[  OK  ] Listening on systemd-hostnamed.socket - Hostname Service Socket.
[  OK  ] Reached target sockets.target - Socket Units.
[  OK  ] Reached target basic.target - Basic System.
         Starting ambient.service - Run build job for Ambient CI...
         Starting dbus.service - D-Bus System Message Bus...
         Starting grub-common.service - Record successful boot for GRUB...
         Starting systemd-logind.service - User Login Management...
[  OK  ] Started dbus.service - D-Bus System Message Bus.
[  OK  ] Listening on systemd-rfkill.socket…ll Switch Status /dev/rfkill Watch.
[  OK  ] Finished grub-common.service - Record successful boot for GRUB.
[  OK  ] Started systemd-logind.service - User Login Management.
[  OK  ] Started systemd-networkd.service - Network Configuration.
[  OK  ] Reached target network.target - Network.
         Starting ssh.service - OpenBSD Secure Shell server...
         Starting systemd-networkd-persiste…tent Storage in systemd-networkd...
         Starting systemd-user-sessions.service - Permit User Sessions...
[  OK  ] Finished systemd-networkd-persiste…istent Storage in systemd-networkd.
[  OK  ] Finished systemd-user-sessions.service - Permit User Sessions.
[  OK  ] Started getty@tty1.service - Getty on tty1.
[  OK  ] Started serial-getty@ttyS0.service - Serial Getty on ttyS0.
[  OK  ] Reached target getty.target - Login Prompts.
[  OK  ] Started ssh.service - OpenBSD Secure Shell server.
[  OK  ] Removed slice system-modprobe.slice - Slice /system/modprobe.
[  OK  ] Stopped target getty.target - Login Prompts.
[  OK  ] Stopped target nss-lookup.target - Host and Network Name Lookups.
[  OK  ] Stopped target timers.target - Timer Units.
[  OK  ] Stopped apt-daily-upgrade.timer - …y apt upgrade and clean activities.
[  OK  ] Stopped apt-daily.timer - Daily apt download activities.
[  OK  ] Stopped dpkg-db-backup.timer - Daily dpkg database backup timer.
[  OK  ] Stopped fstrim.timer - Discard unused filesystem blocks once a week.
[  OK  ] Stopped man-db.timer - Daily man-db regeneration.
[  OK  ] Stopped systemd-tmpfiles-clean.tim…y Cleanup of Temporary Directories.
[  OK  ] Closed systemd-rfkill.socket - Loa…ll Switch Status /dev/rfkill Watch.
         Stopping dbus.service - D-Bus System Message Bus...
         Stopping getty@tty1.service - Getty on tty1...
         Stopping serial-getty@ttyS0.service - Serial Getty on ttyS0...
         Stopping ssh.service - OpenBSD Secure Shell server...
         Stopping systemd-logind.service - User Login Management...
         Stopping systemd-networkd-persiste…tent Storage in systemd-networkd...
         Stopping systemd-random-seed.service - Load/Save OS Random Seed...
[  OK  ] Stopped systemd-udev-load-credenti…- Load udev Rules from Credentials.
[  OK  ] Stopped dbus.service - D-Bus System Message Bus.
[  OK  ] Stopped ssh.service - OpenBSD Secure Shell server.
[  OK  ] Stopped getty@tty1.service - Getty on tty1.
[  OK  ] Stopped serial-getty@ttyS0.service - Serial Getty on ttyS0.
[  OK  ] Stopped ambient.service - Run build job for Ambient CI.
[  OK  ] Stopped systemd-networkd-persisten…istent Storage in systemd-networkd.
[  OK  ] Stopped systemd-random-seed.service - Load/Save OS Random Seed.
[  OK  ] Stopped systemd-logind.service - User Login Management.
[  OK  ] Removed slice system-getty.slice - Slice /system/getty.
[  OK  ] Removed slice system-serial\x2dget…slice - Slice /system/serial-getty.
         Stopping systemd-user-sessions.service - Permit User Sessions...
[  OK  ] Stopped systemd-user-sessions.service - Permit User Sessions.
[  OK  ] Stopped target basic.target - Basic System.
[  OK  ] Stopped target network.target - Network.
[  OK  ] Stopped target paths.target - Path Units.
[  OK  ] Stopped systemd-ask-password-conso…equests to Console Directory Watch.
[  OK  ] Stopped systemd-ask-password-wall.…d Requests to Wall Directory Watch.
[  OK  ] Stopped target remote-fs.target - Remote File Systems.
[  OK  ] Stopped target slices.target - Slice Units.
[  OK  ] Removed slice user.slice - User and Session Slice.
[  OK  ] Stopped target sockets.target - Socket Units.
[  OK  ] Closed dbus.socket - D-Bus System Message Bus Socket.
[  OK  ] Closed sshd-unix-local.socket - Op…temd-ssh-generator, AF_UNIX Local).
[  OK  ] Closed systemd-hostnamed.socket - Hostname Service Socket.
[  OK  ] Stopped target sysinit.target - System Initialization.
         Stopping systemd-binfmt.service - Set Up Additional Binary Formats...
         Stopping systemd-networkd.service - Network Configuration...
         Stopping systemd-resolved.service - Network Name Resolution...
[  OK  ] Stopped systemd-update-done.service - Update is Completed.
[  OK  ] Stopped ldconfig.service - Rebuild Dynamic Linker Cache.
[  OK  ] Stopped systemd-journal-catalog-up….service - Rebuild Journal Catalog.
[  OK  ] Stopped systemd-tmpfiles-setup.ser…reate System Files and Directories.
[  OK  ] Stopped systemd-binfmt.service - Set Up Additional Binary Formats.
[  OK  ] Unset automount proc-sys-fs-binfmt…ormats File System Automount Point.
[  OK  ] Stopped target local-fs.target - Local File Systems.
[  OK  ] Unset automount efi.automount - EFI System Partition Automount.
[  OK  ] Stopped target local-fs-pre.target…Preparation for Local File Systems.
         Unmounting run-lock.mount - Legacy Locks Directory /run/lock...
         Unmounting tmp.mount - Temporary Directory /tmp...
[  OK  ] Stopped systemd-tmpfiles-setup-dev…Create Static Device Nodes in /dev.
[  OK  ] Stopped systemd-resolved.service - Network Name Resolution.
[  OK  ] Stopped systemd-networkd.service - Network Configuration.
[  OK  ] Unmounted run-lock.mount - Legacy Locks Directory /run/lock.
[  OK  ] Unmounted tmp.mount - Temporary Directory /tmp.
[  OK  ] Stopped target network-pre.target - Preparation for Network.
[  OK  ] Stopped target swap.target - Swaps.
[  OK  ] Reached target umount.target - Unmount All Filesystems.
[  OK  ] Closed systemd-networkd.socket - Network Service Netlink Socket.
[  OK  ] Stopped systemd-network-generator.…ork Units from Kernel Command Line.
[  OK  ] Stopped systemd-sysctl.service - Apply Kernel Variables.
[  OK  ] Stopped systemd-modules-load.service - Load Kernel Modules.
[  OK  ] Stopped systemd-sysusers.service - Create System Users.
[  OK  ] Stopped systemd-remount-fs.service…mount Root and Kernel File Systems.
[  OK  ] Stopped systemd-tmpfiles-setup-dev…ic Device Nodes in /dev gracefully.
[  OK  ] Reached target shutdown.target - System Shutdown.
[  OK  ] Reached target final.target - Late Shutdown Services.
[  OK  ] Finished systemd-poweroff.service - System Power Off.
[  OK  ] Reached target poweroff.target - System Power Off.
[   12.727978] reboot: Power down

Raw run log
BdsDxe: 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(0x3,0x0)
BdsDxe: starting Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x3,0x0)
EFI stub: Loaded initrd from LINUX_EFI_INITRD_MEDIA_GUID device path
INFO: Block devices
NAME   MAJ:MIN RM   SIZE RO TYPE MOUNTPOINTS
sr0     11:0    1   372K  0 rom  
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   5.3M  1 disk 
vdc    254:32   0   490K  1 disk 
vdd    254:48   0 953.7M  0 disk 
vde    254:64   0  27.9G  0 disk 
vdf    254:80   0   100G  0 disk 
vdg    254:96   0    10K  1 disk 
INFO: Extracting tar archive from /dev/vdb
drwxr-xr-x _rad/_rad         0 2026-07-05 13:21 ./
-rw-r--r-- _rad/_rad      1294 2026-07-05 13:21 ./plan.yaml
-rwxr-xr-x _rad/_rad   5517632 2026-07-05 13:21 ./run-ci
INFO: Extracted files:
        6      0 drwxr-xr-x   2 1000     1000           80 Jul  5 13:21 .
       10   5392 -rwxr-xr-x   1 1000     1000      5517632 Jul  5 13:21 ./run-ci
        9      4 -rw-r--r--   1 1000     1000         1294 Jul  5 13:21 ./plan.yaml
INFO: Running run-ci from /dev/vdb
================================ BEGIN ================================
{"type":"executor_starts","name":"ambient-execute-plan","version":"0.15.0@eeab732","timestamp":{"secs_since_epoch":1783257674,"nanos_since_epoch":794232723},"log_source":"Plan"}
{"type":"runnable_plan","steps":[{"action":"mkdir","pathname":"/ci"},{"action":"mkdir","pathname":"/ci/artifacts"},{"action":"mkdir","pathname":"/ci/artifacts/debian"},{"action":"mkdir","pathname":"/ci/artifacts/rsync"},{"action":"mkdir","pathname":"/ci/secrets"},{"action":"mkdir","pathname":"/ci/deps"},{"action":"tar_extract","archive":"/dev/vdc","directory":"/ci/src"},{"action":"tar_extract","archive":"/dev/vdf","directory":"/ci/deps"},{"action":"tar_extract","archive":"/dev/vde","directory":"/ci/cache"},{"action":"tar_extract","archive":"/dev/vdd","directory":"/ci/artifacts"},{"action":"tar_extract","archive":"/dev/vdg","directory":"/ci/secrets"},{"action":"shell","shell":"ln -sf /ci /workspace"},{"action":"create_file","filename":"/root/.ssh/config","content":"Host *\nStrictHostKeyChecking accept-new\nIdentityFile /ci/secrets/ssh_key\n                ","overwrite":true},{"action":"cargo_fetch"},{"action":"tar_create","archive":"/dev/vde","directory":"/ci/cache"},{"action":"tar_create","archive":"/dev/vdd","directory":"/ci/artifacts"},{"action":"tar_create","archive":"/dev/vdf","directory":"/ci/deps"}],"executor_drive":"/dev/vdb","source_drive":"/dev/vdc","artifact_drive":"/dev/vdd","cache_drive":"/dev/vde","deps_drive":"/dev/vdf","secrets_drive":null,"workspace_dir":"/ci","source_dir":"/ci/src","deps_dir":"/ci/deps","cache_dir":"/ci/cache","artifacts_dir":"/ci/artifacts","secrets_dir":null,"envs":{},"timestamp":{"secs_since_epoch":1783257674,"nanos_since_epoch":796961471},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci","timestamp":{"secs_since_epoch":1783257674,"nanos_since_epoch":828484549},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci","timestamp":{"secs_since_epoch":1783257674,"nanos_since_epoch":832169562},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/artifacts","timestamp":{"secs_since_epoch":1783257674,"nanos_since_epoch":832874173},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/artifacts","timestamp":{"secs_since_epoch":1783257674,"nanos_since_epoch":833117113},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/artifacts/debian","timestamp":{"secs_since_epoch":1783257674,"nanos_since_epoch":833298290},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/artifacts/debian","timestamp":{"secs_since_epoch":1783257674,"nanos_since_epoch":833326332},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/artifacts/rsync","timestamp":{"secs_since_epoch":1783257674,"nanos_since_epoch":833510290},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/artifacts/rsync","timestamp":{"secs_since_epoch":1783257674,"nanos_since_epoch":833535681},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/secrets","timestamp":{"secs_since_epoch":1783257674,"nanos_since_epoch":833785719},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/secrets","timestamp":{"secs_since_epoch":1783257674,"nanos_since_epoch":833814882},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/deps","timestamp":{"secs_since_epoch":1783257674,"nanos_since_epoch":833997035},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/deps","timestamp":{"secs_since_epoch":1783257674,"nanos_since_epoch":834021294},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdc","directory":"/ci/src","timestamp":{"secs_since_epoch":1783257674,"nanos_since_epoch":834209824},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdc","directory":"/ci/src","timestamp":{"secs_since_epoch":1783257674,"nanos_since_epoch":859716750},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdf","directory":"/ci/deps","timestamp":{"secs_since_epoch":1783257674,"nanos_since_epoch":860142924},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdf","directory":"/ci/deps","timestamp":{"secs_since_epoch":1783257674,"nanos_since_epoch":865330551},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783257674,"nanos_since_epoch":865778671},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783257675,"nanos_since_epoch":142224040},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783257675,"nanos_since_epoch":144885948},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783257675,"nanos_since_epoch":149228761},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdg","directory":"/ci/secrets","timestamp":{"secs_since_epoch":1783257675,"nanos_since_epoch":151943651},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdg","directory":"/ci/secrets","timestamp":{"secs_since_epoch":1783257675,"nanos_since_epoch":155761272},"log_source":"Plan"}
{"type":"execute_action","action":"shell","shell":"ln -sf /ci /workspace","timestamp":{"secs_since_epoch":1783257675,"nanos_since_epoch":158436755},"log_source":"Plan"}
{"type":"start_program","argv":[{"Unix":[98,97,115,104]},{"Unix":[45,99]},{"Unix":[115,101,116,32,45,120,101,117,111,32,112,105,112,101,102,97,105,108,10,108,110,32,45,115,102,32,47,99,105,32,47,119,111,114,107,115,112,97,99,101,10]}],"timestamp":{"secs_since_epoch":1783257675,"nanos_since_epoch":160790792},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"","stderr":"+ ln -sf /ci /workspace\n","timestamp":{"secs_since_epoch":1783257675,"nanos_since_epoch":167943828},"log_source":"Plan"}
{"type":"action_succeeded","action":"shell","shell":"ln -sf /ci /workspace","timestamp":{"secs_since_epoch":1783257675,"nanos_since_epoch":170597222},"log_source":"Plan"}
{"type":"execute_action","action":"create_file","filename":"/root/.ssh/config","content":"Host *\nStrictHostKeyChecking accept-new\nIdentityFile /ci/secrets/ssh_key\n                ","overwrite":true,"timestamp":{"secs_since_epoch":1783257675,"nanos_since_epoch":172966297},"log_source":"Plan"}
{"type":"action_succeeded","action":"create_file","filename":"/root/.ssh/config","content":"Host *\nStrictHostKeyChecking accept-new\nIdentityFile /ci/secrets/ssh_key\n                ","overwrite":true,"timestamp":{"secs_since_epoch":1783257675,"nanos_since_epoch":177376313},"log_source":"Plan"}
{"type":"execute_action","action":"cargo_fetch","timestamp":{"secs_since_epoch":1783257675,"nanos_since_epoch":181494089},"log_source":"Plan"}
{"type":"start_program","argv":[{"Unix":[99,97,114,103,111]},{"Unix":[45,45,118,101,114,115,105,111,110]}],"timestamp":{"secs_since_epoch":1783257675,"nanos_since_epoch":183516301},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"cargo 1.96.1 (356927216 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783257675,"nanos_since_epoch":212443152},"log_source":"Plan"}
{"type":"start_program","argv":[{"Unix":[99,97,114,103,111]},{"Unix":[99,108,105,112,112,121]},{"Unix":[45,45,118,101,114,115,105,111,110]}],"timestamp":{"secs_since_epoch":1783257675,"nanos_since_epoch":215223940},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"clippy 0.1.96 (31fca3adb2 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783257675,"nanos_since_epoch":270263783},"log_source":"Plan"}
{"type":"start_program","argv":[{"Unix":[114,117,115,116,99]},{"Unix":[45,45,118,101,114,115,105,111,110]}],"timestamp":{"secs_since_epoch":1783257675,"nanos_since_epoch":270720341},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"rustc 1.96.1 (31fca3adb 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783257675,"nanos_since_epoch":290028179},"log_source":"Plan"}
copying relevant files to /tmp/.tmpdvlQNa
{"type":"start_program","argv":[{"Unix":[99,97,114,103,111]},{"Unix":[102,101,116,99,104]},{"Unix":[45,45,108,111,99,107,101,100]}],"timestamp":{"secs_since_epoch":1783257675,"nanos_since_epoch":295055725},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"","stderr":"    Updating crates.io index\n Downloading crates ...\n  Downloaded itoa v1.0.17\n  Downloaded cfg-if v1.0.4\n  Downloaded windows-link v0.2.1\n  Downloaded errno v0.3.14\n  Downloaded redox_users v0.4.6\n  Downloaded libredox v0.1.12\n  Downloaded fastrand v2.3.0\n  Downloaded unicode-xid v0.2.6\n  Downloaded thiserror v2.0.18\n  Downloaded toml_writer v1.0.6+spec-1.1.0\n  Downloaded foldhash v0.1.5\n  Downloaded wit-bindgen-rust-macro v0.51.0\n  Downloaded serde_spanned v1.0.4\n  Downloaded equivalent v1.0.2\n  Downloaded mutants v0.0.3\n  Downloaded directories-next v2.0.0\n  Downloaded id-arena v2.3.0\n  Downloaded toml_datetime v0.7.5+spec-1.1.0\n  Downloaded dirs-sys-next v0.1.2\n  Downloaded heck v0.5.0\n  Downloaded leb128fmt v0.1.0\n  Downloaded zmij v1.0.20\n  Downloaded wit-bindgen-rust v0.51.0\n  Downloaded thiserror-impl v1.0.69\n  Downloaded thiserror-impl v2.0.18\n  Downloaded quote v1.0.44\n  Downloaded semver v1.0.27\n  Downloaded wasi v0.11.1+wasi-snapshot-preview1\n  Downloaded clingwrap v0.6.1\n  Downloaded bitflags v2.10.0\n  Downloaded wasm-metadata v0.244.0\n  Downloaded once_cell v1.21.3\n  Downloaded unicode-ident v1.0.23\n  Downloaded getrandom v0.2.17\n  Downloaded toml_parser v1.0.6+spec-1.1.0\n  Downloaded serde_derive v1.0.228\n  Downloaded thiserror v1.0.69\n  Downloaded ryu v1.0.23\n  Downloaded proc-macro2 v1.0.106\n  Downloaded anyhow v1.0.101\n  Downloaded toml v0.9.11+spec-1.1.0\n  Downloaded serde_norway v0.9.42\n  Downloaded unsafe-libyaml-norway v0.2.15\n  Downloaded prettyplease v0.2.37\n  Downloaded memchr v2.8.0\n  Downloaded wasip2 v1.0.2+wasi-0.2.9\n  Downloaded wasip3 v0.4.0+wasi-0.3.0-rc-2026-01-06\n  Downloaded syn v2.0.114\n  Downloaded hashbrown v0.16.1\n  Downloaded serde_json v1.0.149\n  Downloaded winnow v0.7.14\n  Downloaded hashbrown v0.15.5\n  Downloaded wit-parser v0.244.0\n  Downloaded indexmap v2.13.0\n  Downloaded wasmparser v0.244.0\n  Downloaded wit-component v0.244.0\n  Downloaded r-efi v5.3.0\n  Downloaded wasm-encoder v0.244.0\n  Downloaded serde v1.0.228\n  Downloaded serde_core v1.0.228\n  Downloaded wit-bindgen v0.51.0\n  Downloaded log v0.4.29\n  Downloaded rustix v1.1.4\n  Downloaded getrandom v0.4.1\n  Downloaded wit-bindgen-core v0.51.0\n  Downloaded tempfile v3.26.0\n  Downloaded libc v0.2.182\n  Downloaded winapi v0.3.9\n  Downloaded windows-sys v0.61.2\n  Downloaded winapi-i686-pc-windows-gnu v0.4.0\n  Downloaded winapi-x86_64-pc-windows-gnu v0.4.0\n  Downloaded linux-raw-sys v0.12.1\n","timestamp":{"secs_since_epoch":1783257677,"nanos_since_epoch":469818082},"log_source":"Plan"}
{"type":"action_succeeded","action":"cargo_fetch","timestamp":{"secs_since_epoch":1783257677,"nanos_since_epoch":506048910},"log_source":"Plan"}
{"type":"execute_action","action":"tar_create","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783257677,"nanos_since_epoch":508017857},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_create","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783257677,"nanos_since_epoch":821147821},"log_source":"Plan"}
{"type":"execute_action","action":"tar_create","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783257677,"nanos_since_epoch":824397719},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_create","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783257677,"nanos_since_epoch":829481354},"log_source":"Plan"}
{"type":"execute_action","action":"tar_create","archive":"/dev/vdf","directory":"/ci/deps","timestamp":{"secs_since_epoch":1783257677,"nanos_since_epoch":833011753},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_create","archive":"/dev/vdf","directory":"/ci/deps","timestamp":{"secs_since_epoch":1783257678,"nanos_since_epoch":808820867},"log_source":"Plan"}
{"type":"plan_succeeded","timestamp":{"secs_since_epoch":1783257678,"nanos_since_epoch":809276808},"log_source":"Plan"}
{"type":"executor_ends_successfully","timestamp":{"secs_since_epoch":1783257678,"nanos_since_epoch":809489260},"log_source":"Plan"}
EXIT CODE: 0

Plan VM
Structured log: all OK
  1. 0 ms: Executor starts
    • Name: ambient-execute-plan
    • Version: 0.15.0@eeab732
  2. 0 ms: Runnable plan
    steps:
- action: mkdir
  pathname: /ci
- action: mkdir
  pathname: /ci/artifacts
- action: mkdir
  pathname: /ci/artifacts/debian
- action: mkdir
  pathname: /ci/artifacts/rsync
- action: mkdir
  pathname: /ci/secrets
- action: mkdir
  pathname: /ci/deps
- action: tar_extract
  archive: /dev/vdc
  directory: /ci/src
- action: tar_extract
  archive: /dev/vdf
  directory: /ci/deps
- action: tar_extract
  archive: /dev/vde
  directory: /ci/cache
- action: tar_extract
  archive: /dev/vdd
  directory: /ci/artifacts
- action: tar_extract
  archive: /dev/vdg
  directory: /ci/secrets
- action: shell
  shell: ln -sf /ci /workspace
- action: create_file
  filename: /root/.ssh/config
  content: "Host *\nStrictHostKeyChecking accept-new\nIdentityFile /ci/secrets/ssh_key\n                "
  overwrite: true
- action: cargo_fmt
- action: cargo_clippy
- action: cargo_build
- action: cargo_test
- action: tar_create
  archive: /dev/vde
  directory: /ci/cache
- action: tar_create
  archive: /dev/vdd
  directory: /ci/artifacts
executor_drive: /dev/vdb
source_drive: /dev/vdc
artifact_drive: /dev/vdd
cache_drive: /dev/vde
deps_drive: /dev/vdf
secrets_drive: null
workspace_dir: /ci
source_dir: /ci/src
deps_dir: /ci/deps
cache_dir: /ci/cache
artifacts_dir: /ci/artifacts
secrets_dir: null
envs: {}

  3. 0 ms: Execute action: mkdir: /ci
    - action: mkdir
  pathname: /ci

  4. 1 ms: Action succeeded: mkdir: /ci
    - action: mkdir
  pathname: /ci

  5. 2 ms: Execute action: mkdir: /ci/artifacts
    - action: mkdir
  pathname: /ci/artifacts

  6. 2 ms: Action succeeded: mkdir: /ci/artifacts
    - action: mkdir
  pathname: /ci/artifacts

  7. 3 ms: Execute action: mkdir: /ci/artifacts/debian
    - action: mkdir
  pathname: /ci/artifacts/debian

  8. 3 ms: Action succeeded: mkdir: /ci/artifacts/debian
    - action: mkdir
  pathname: /ci/artifacts/debian

  9. 3 ms: Execute action: mkdir: /ci/artifacts/rsync
    - action: mkdir
  pathname: /ci/artifacts/rsync

  10. 3 ms: Action succeeded: mkdir: /ci/artifacts/rsync
    - action: mkdir
  pathname: /ci/artifacts/rsync

  11. 4 ms: Execute action: mkdir: /ci/secrets
    - action: mkdir
  pathname: /ci/secrets

  12. 5 ms: Action succeeded: mkdir: /ci/secrets
    - action: mkdir
  pathname: /ci/secrets

  13. 7 ms: Execute action: mkdir: /ci/deps
    - action: mkdir
  pathname: /ci/deps

  14. 7 ms: Action succeeded: mkdir: /ci/deps
    - action: mkdir
  pathname: /ci/deps

  15. 7 ms: Execute action: tar_extract
    - action: tar_extract
  archive: /dev/vdc
  directory: /ci/src

  16. 20 ms: Action succeeded: tar_extract
    - action: tar_extract
  archive: /dev/vdc
  directory: /ci/src

  17. 20 ms: Execute action: tar_extract
    - action: tar_extract
  archive: /dev/vdf
  directory: /ci/deps

  18. 618 ms: Action succeeded: tar_extract
    - action: tar_extract
  archive: /dev/vdf
  directory: /ci/deps

  19. 621 ms: Execute action: tar_extract
    - action: tar_extract
  archive: /dev/vde
  directory: /ci/cache

  20. 864 ms: Action succeeded: tar_extract
    - action: tar_extract
  archive: /dev/vde
  directory: /ci/cache

  21. 866 ms: Execute action: tar_extract
    - action: tar_extract
  archive: /dev/vdd
  directory: /ci/artifacts

  22. 871 ms: Action succeeded: tar_extract
    - action: tar_extract
  archive: /dev/vdd
  directory: /ci/artifacts

  23. 873 ms: Execute action: tar_extract
    - action: tar_extract
  archive: /dev/vdg
  directory: /ci/secrets

  24. 877 ms: Action succeeded: tar_extract
    - action: tar_extract
  archive: /dev/vdg
  directory: /ci/secrets

  25. 880 ms: Execute action: shell: ln -sf /ci /workspace
    - action: shell
  shell: ln -sf /ci /workspace

  26. 882 ms: Start program: bash
    • bash
    • -c
    • set -xeuo pipefail
ln -sf /ci /workspace

  27. 890 ms: Program succeeded
    • Exit code: 0
    • Stdout
    • Stderr
      + ln -sf /ci /workspace

  28. 892 ms: Action succeeded: shell: ln -sf /ci /workspace
    - action: shell
  shell: ln -sf /ci /workspace

  29. 895 ms: Execute action: create_file
    - action: create_file
  filename: /root/.ssh/config
  content: "Host *\nStrictHostKeyChecking accept-new\nIdentityFile /ci/secrets/ssh_key\n                "
  overwrite: true

  30. 899 ms: Action succeeded: create_file
    - action: create_file
  filename: /root/.ssh/config
  content: "Host *\nStrictHostKeyChecking accept-new\nIdentityFile /ci/secrets/ssh_key\n                "
  overwrite: true

  31. 903 ms: Execute action: cargo_fmt
    - action: cargo_fmt

  32. 905 ms: Start program: cargo
    • cargo
    • --version
  33. 934 ms: Program succeeded
    • Exit code: 0
    • Stdout
      cargo 1.96.1 (356927216 2026-06-26)

    • Stderr
  34. 934 ms: Start program: cargo
    • cargo
    • clippy
    • --version
  35. 990 ms: Program succeeded
    • Exit code: 0
    • Stdout
      clippy 0.1.96 (31fca3adb2 2026-06-26)

    • Stderr
  36. 993 ms: Start program: rustc
    • rustc
    • --version
  37. 1011 ms: Program succeeded
    • Exit code: 0
    • Stdout
      rustc 1.96.1 (31fca3adb 2026-06-26)

    • Stderr
  38. 1014 ms: Start program: cargo
    • cargo
    • fmt
    • --check
  39. 1084 ms: Program succeeded
    • Exit code: 0
    • Stdout
    • Stderr
  40. 1084 ms: Action succeeded: cargo_fmt
    - action: cargo_fmt

  41. 1084 ms: Execute action: cargo_clippy
    - action: cargo_clippy

  42. 1084 ms: Start program: cargo
    • cargo
    • --version
  43. 1102 ms: Program succeeded
    • Exit code: 0
    • Stdout
      cargo 1.96.1 (356927216 2026-06-26)

    • Stderr
  44. 1104 ms: Start program: cargo
    • cargo
    • clippy
    • --version
  45. 1134 ms: Program succeeded
    • Exit code: 0
    • Stdout
      clippy 0.1.96 (31fca3adb2 2026-06-26)

    • Stderr
  46. 1137 ms: Start program: rustc
    • rustc
    • --version
  47. 1152 ms: Program succeeded
    • Exit code: 0
    • Stdout
      rustc 1.96.1 (31fca3adb 2026-06-26)

    • Stderr
  48. 1152 ms: Start program: cargo
    • cargo
    • clippy
    • --offline
    • --locked
    • --workspace
    • --all-targets
    • --no-deps
    • --
    • --deny
    • warnings
  49. 1508 ms: Program succeeded
    • Exit code: 0
    • Stdout
    • Stderr
          Checking sop-run v0.1.0 (/ci/src)
    Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.31s

  50. 1511 ms: Action succeeded: cargo_clippy
    - action: cargo_clippy

  51. 1514 ms: Execute action: cargo_build
    - action: cargo_build

  52. 1516 ms: Start program: cargo
    • cargo
    • --version
  53. 1527 ms: Program succeeded
    • Exit code: 0
    • Stdout
      cargo 1.96.1 (356927216 2026-06-26)

    • Stderr
  54. 1530 ms: Start program: cargo
    • cargo
    • clippy
    • --version
  55. 1559 ms: Program succeeded
    • Exit code: 0
    • Stdout
      clippy 0.1.96 (31fca3adb2 2026-06-26)

    • Stderr
  56. 1559 ms: Start program: rustc
    • rustc
    • --version
  57. 1576 ms: Program succeeded
    • Exit code: 0
    • Stdout
      rustc 1.96.1 (31fca3adb 2026-06-26)

    • Stderr
  58. 1579 ms: Start program: cargo
    • cargo
    • build
    • --offline
    • --locked
    • --workspace
    • --all-targets
  59. 1898 ms: Program succeeded
    • Exit code: 0
    • Stdout
    • Stderr
         Compiling sop-run v0.1.0 (/ci/src)
    Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.30s

  60. 1898 ms: Action succeeded: cargo_build
    - action: cargo_build

  61. 1898 ms: Execute action: cargo_test
    - action: cargo_test

  62. 1898 ms: Start program: cargo
    • cargo
    • --version
  63. 1916 ms: Program succeeded
    • Exit code: 0
    • Stdout
      cargo 1.96.1 (356927216 2026-06-26)

    • Stderr
  64. 1916 ms: Start program: cargo
    • cargo
    • clippy
    • --version
  65. 1948 ms: Program succeeded
    • Exit code: 0
    • Stdout
      clippy 0.1.96 (31fca3adb2 2026-06-26)

    • Stderr
  66. 1948 ms: Start program: rustc
    • rustc
    • --version
  67. 1963 ms: Program succeeded
    • Exit code: 0
    • Stdout
      rustc 1.96.1 (31fca3adb 2026-06-26)

    • Stderr
  68. 1964 ms: Start program: cargo
    • cargo
    • test
    • --offline
    • --locked
    • --workspace
  69. 2090 ms: Program succeeded
    • Exit code: 0
    • Stdout
      running 14 tests
test cmd::armor::test::armor ... ok
test cmd::dearmor::test::armor ... ok
test cmd::extract_cert::test::extract_cert ... ok
test cmd::generate_key::test::generate_armored_key ... ok
test cmd::generate_key::test::generate_binary_key ... ok
test cmd::encrypt::test::round_trip ... ok
test cmd::version::test::backend ... ok
test cmd::version::test::extended ... ok
test cmd::version::test::sop_spec ... ok
test cmd::version::test::sopv ... ok
test cmd::sign::test::roundtrip ... ok
test cmd::version::test::version ... ok
test engine::test::cat ... ok
test engine::test::echo ... ok

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


running 0 tests

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


    • Stderr
          Finished `test` profile [unoptimized + debuginfo] target(s) in 0.03s
     Running unittests src/lib.rs (/ci/cache/cargo-target/debug/deps/sop_run-57c21bd16d918b8a)
   Doc-tests sop_run

  70. 2106 ms: Action succeeded: cargo_test
    - action: cargo_test

  71. 2108 ms: Execute action: tar_create
    - action: tar_create
  archive: /dev/vde
  directory: /ci/cache

  72. 2443 ms: Action succeeded: tar_create
    - action: tar_create
  archive: /dev/vde
  directory: /ci/cache

  73. 2444 ms: Execute action: tar_create
    - action: tar_create
  archive: /dev/vdd
  directory: /ci/artifacts

  74. 2445 ms: Action succeeded: tar_create
    - action: tar_create
  archive: /dev/vdd
  directory: /ci/artifacts

  75. 2445 ms: Plan succededThere was much rejoicing!
  76. 2445 ms: Executor ends successfullyPhew, nothing seems to have gone wrong.
Console log
BdsDxe: 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)
  Booting `Debian GNU/Linux'

Loading Linux 6.12.86+deb13-amd64 ...
Loading initial ramdisk ...
EFI stub: Loaded initrd from LINUX_EFI_INITRD_MEDIA_GUID device path
Loading, please wait...
Starting systemd-udevd version 257.13-1~deb13u1
Begin: Loading essential drivers ... done.
Begin: Running /scripts/init-premount ... done.
Begin: Mounting root file system ... Begin: Running /scripts/local-top ... done.
Begin: Running /scripts/local-premount ... done.
Begin: Will now check root file system ... fsck from util-linux 2.41
fsck: error 2 (No such file or directory) while executing fsck.ext4 for /dev/vda2
fsck exited with status code 8
done.
Warning: File system check failed but did not detect errors
done.
Begin: Running /scripts/local-bottom ... done.
Begin: Running /scripts/init-bottom ... done.

Welcome to Debian GNU/Linux 13 (trixie)!

[  OK  ] Created slice system-getty.slice - Slice /system/getty.
[  OK  ] Created slice system-modprobe.slice - Slice /system/modprobe.
[  OK  ] Created slice system-serial\x2dget…slice - Slice /system/serial-getty.
[  OK  ] Created slice user.slice - User and Session Slice.
[  OK  ] Started systemd-ask-password-conso…equests to Console Directory Watch.
[  OK  ] Started systemd-ask-password-wall.…d Requests to Wall Directory Watch.
[  OK  ] Set up automount proc-sys-fs-binfm…ormats File System Automount Point.
         Expecting device dev-ttyS0.device - /dev/ttyS0...
[  OK  ] Reached target paths.target - Path Units.
[  OK  ] Reached target remote-fs.target - Remote File Systems.
[  OK  ] Reached target slices.target - Slice Units.
[  OK  ] Reached target swap.target - Swaps.
[  OK  ] Listening on systemd-creds.socket - Credential Encryption/Decryption.
[  OK  ] Listening on systemd-initctl.socke…- initctl Compatibility Named Pipe.
[  OK  ] Listening on systemd-journald-dev-…socket - Journal Socket (/dev/log).
[  OK  ] Listening on systemd-journald.socket - Journal Sockets.
[  OK  ] Listening on systemd-networkd.socket - Network Service Netlink Socket.
[  OK  ] Listening on systemd-udevd-control.socket - udev Control Socket.
[  OK  ] Listening on systemd-udevd-kernel.socket - udev Kernel Socket.
         Mounting dev-hugepages.mount - Huge Pages File System...
         Mounting dev-mqueue.mount - POSIX Message Queue File System...
         Mounting run-lock.mount - Legacy Locks Directory /run/lock...
         Mounting sys-kernel-debug.mount - Kernel Debug File System...
         Mounting sys-kernel-tracing.mount - Kernel Trace File System...
         Mounting tmp.mount - Temporary Directory /tmp...
         Starting kmod-static-nodes.service…eate List of Static Device Nodes...
         Starting modprobe@configfs.service - Load Kernel Module configfs...
         Starting modprobe@drm.service - Load Kernel Module drm...
         Starting modprobe@efi_pstore.servi… - Load Kernel Module efi_pstore...
         Starting modprobe@fuse.service - Load Kernel Module fuse...
         Starting systemd-journald.service - Journal Service...
         Starting systemd-modules-load.service - Load Kernel Modules...
         Starting systemd-network-generator…k Units from Kernel Command Line...
         Starting systemd-remount-fs.servic…unt Root and Kernel File Systems...
         Starting systemd-udev-load-credent…Load udev Rules from Credentials...
         Starting systemd-udev-trigger.service - Coldplug All udev Devices...
[  OK  ] Mounted dev-hugepages.mount - Huge Pages File System.
[  OK  ] Mounted dev-mqueue.mount - POSIX Message Queue File System.
[  OK  ] Mounted run-lock.mount - Legacy Locks Directory /run/lock.
[  OK  ] Mounted sys-kernel-debug.mount - Kernel Debug File System.
[  OK  ] Mounted sys-kernel-tracing.mount - Kernel Trace File System.
[  OK  ] Mounted tmp.mount - Temporary Directory /tmp.
[  OK  ] Finished kmod-static-nodes.service…Create List of Static Device Nodes.
[  OK  ] Finished modprobe@configfs.service - Load Kernel Module configfs.
[  OK  ] Finished modprobe@drm.service - Load Kernel Module drm.
[  OK  ] Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
[  OK  ] Finished modprobe@fuse.service - Load Kernel Module fuse.
[  OK  ] Started systemd-journald.service - Journal Service.
[  OK  ] Finished systemd-modules-load.service - Load Kernel Modules.
[  OK  ] Finished systemd-network-generator…ork Units from Kernel Command Line.
[  OK  ] Finished systemd-remount-fs.servic…mount Root and Kernel File Systems.
[  OK  ] Finished systemd-udev-load-credent…- Load udev Rules from Credentials.
[  OK  ] Reached target network-pre.target - Preparation for Network.
         Mounting sys-fs-fuse-connections.mount - FUSE Control File System...
         Mounting sys-kernel-config.mount - Kernel Configuration File System...
         Starting systemd-journal-flush.ser…sh Journal to Persistent Storage...
         Starting systemd-random-seed.service - Load/Save OS Random Seed...
         Starting systemd-sysctl.service - Apply Kernel Variables...
         Starting systemd-tmpfiles-setup-de… Device Nodes in /dev gracefully...
[  OK  ] Mounted sys-fs-fuse-connections.mount - FUSE Control File System.
[  OK  ] Mounted sys-kernel-config.mount - Kernel Configuration File System.
[  OK  ] Finished systemd-udev-trigger.service - Coldplug All udev Devices.
[  OK  ] Finished systemd-sysctl.service - Apply Kernel Variables.
[  OK  ] Finished systemd-tmpfiles-setup-de…ic Device Nodes in /dev gracefully.
         Starting systemd-sysusers.service - Create System Users...
[  OK  ] Finished systemd-random-seed.service - Load/Save OS Random Seed.
[  OK  ] Finished systemd-sysusers.service - Create System Users.
         Starting systemd-resolved.service - Network Name Resolution...
         Starting systemd-tmpfiles-setup-de…eate Static Device Nodes in /dev...
[  OK  ] Finished systemd-journal-flush.ser…lush Journal to Persistent Storage.
[  OK  ] Finished systemd-tmpfiles-setup-de…Create Static Device Nodes in /dev.
[  OK  ] Reached target local-fs-pre.target…Preparation for Local File Systems.
[  OK  ] Set up automount efi.automount - EFI System Partition Automount.
[  OK  ] Reached target local-fs.target - Local File Systems.
[  OK  ] Listening on systemd-sysext.socket… System Extension Image Management.
         Starting systemd-binfmt.service - Set Up Additional Binary Formats...
         Starting systemd-tmpfiles-setup.se…ate System Files and Directories...
         Starting systemd-udevd.service - R…ager for Device Events and Files...
[  OK  ] Started systemd-resolved.service - Network Name Resolution.
[  OK  ] Reached target nss-lookup.target - Host and Network Name Lookups.
[  OK  ] Finished systemd-tmpfiles-setup.se…reate System Files and Directories.
         Starting ldconfig.service - Rebuild Dynamic Linker Cache...
         Starting systemd-journal-catalog-u…ervice - Rebuild Journal Catalog...
[  OK  ] Started systemd-udevd.service - Ru…anager for Device Events and Files.
         Starting systemd-networkd.service - Network Configuration...
[  OK  ] Finished systemd-journal-catalog-u….service - Rebuild Journal Catalog.
[  OK  ] Found device dev-ttyS0.device - /dev/ttyS0.
[  OK  ] Finished ldconfig.service - Rebuild Dynamic Linker Cache.
         Starting systemd-update-done.service - Update is Completed...
[  OK  ] Finished systemd-update-done.service - Update is Completed.
         Mounting proc-sys-fs-binfmt_misc.m…cutable File Formats File System...
[  OK  ] Mounted proc-sys-fs-binfmt_misc.mo…xecutable File Formats File System.
[  OK  ] Finished systemd-binfmt.service - Set Up Additional Binary Formats.
[  OK  ] Reached target sysinit.target - System Initialization.
[  OK  ] Started apt-daily.timer - Daily apt download activities.
[  OK  ] Started apt-daily-upgrade.timer - …y apt upgrade and clean activities.
[  OK  ] Started dpkg-db-backup.timer - Daily dpkg database backup timer.
[  OK  ] Started fstrim.timer - Discard unused filesystem blocks once a week.
[  OK  ] Started man-db.timer - Daily man-db regeneration.
[  OK  ] Started systemd-tmpfiles-clean.tim…y Cleanup of Temporary Directories.
[  OK  ] Reached target timers.target - Timer Units.
[  OK  ] Listening on dbus.socket - D-Bus System Message Bus Socket.
[  OK  ] Listening on sshd-unix-local.socke…temd-ssh-generator, AF_UNIX Local).
[  OK  ] Listening on systemd-hostnamed.socket - Hostname Service Socket.
[  OK  ] Reached target sockets.target - Socket Units.
[  OK  ] Reached target basic.target - Basic System.
         Starting ambient.service - Run build job for Ambient CI...
         Starting dbus.service - D-Bus System Message Bus...
         Starting grub-common.service - Record successful boot for GRUB...
         Starting systemd-logind.service - User Login Management...
[  OK  ] Started dbus.service - D-Bus System Message Bus.
[  OK  ] Listening on systemd-rfkill.socket…ll Switch Status /dev/rfkill Watch.
[  OK  ] Started systemd-logind.service - User Login Management.
[  OK  ] Finished grub-common.service - Record successful boot for GRUB.
[  OK  ] Started systemd-networkd.service - Network Configuration.
[  OK  ] Reached target network.target - Network.
         Starting ssh.service - OpenBSD Secure Shell server...
         Starting systemd-networkd-persiste…tent Storage in systemd-networkd...
         Starting systemd-user-sessions.service - Permit User Sessions...
[  OK  ] Finished systemd-user-sessions.service - Permit User Sessions.
[  OK  ] Started getty@tty1.service - Getty on tty1.
[  OK  ] Started serial-getty@ttyS0.service - Serial Getty on ttyS0.
[  OK  ] Reached target getty.target - Login Prompts.
[  OK  ] Finished systemd-networkd-persiste…istent Storage in systemd-networkd.
[  OK  ] Started ssh.service - OpenBSD Secure Shell server.
[  OK  ] Stopped ambient.service - Run build job for Ambient CI.
[  OK  ] Removed slice system-modprobe.slice - Slice /system/modprobe.
[  OK  ] Stopped target getty.target - Login Prompts.
[  OK  ] Stopped target nss-lookup.target - Host and Network Name Lookups.
[  OK  ] Stopped target timers.target - Timer Units.
[  OK  ] Stopped apt-daily-upgrade.timer - …y apt upgrade and clean activities.
[  OK  ] Stopped apt-daily.timer - Daily apt download activities.
[  OK  ] Stopped dpkg-db-backup.timer - Daily dpkg database backup timer.
[  OK  ] Stopped fstrim.timer - Discard unused filesystem blocks once a week.
[  OK  ] Stopped man-db.timer - Daily man-db regeneration.
[  OK  ] Stopped systemd-tmpfiles-clean.tim…y Cleanup of Temporary Directories.
[  OK  ] Closed systemd-rfkill.socket - Loa…ll Switch Status /dev/rfkill Watch.
         Stopping dbus.service - D-Bus System Message Bus...
         Stopping getty@tty1.service - Getty on tty1...
         Stopping serial-getty@ttyS0.service - Serial Getty on ttyS0...
         Stopping ssh.service - OpenBSD Secure Shell server...
         Stopping systemd-logind.service - User Login Management...
         Stopping systemd-networkd-persiste…tent Storage in systemd-networkd...
         Stopping systemd-random-seed.service - Load/Save OS Random Seed...
[  OK  ] Stopped systemd-udev-load-credenti…- Load udev Rules from Credentials.
[  OK  ] Stopped dbus.service - D-Bus System Message Bus.
[  OK  ] Stopped getty@tty1.service - Getty on tty1.
[  OK  ] Stopped serial-getty@ttyS0.service - Serial Getty on ttyS0.
[  OK  ] Stopped ssh.service - OpenBSD Secure Shell server.
[  OK  ] Stopped systemd-networkd-persisten…istent Storage in systemd-networkd.
[  OK  ] Stopped systemd-logind.service - User Login Management.
[  OK  ] Removed slice system-getty.slice - Slice /system/getty.
[  OK  ] Removed slice system-serial\x2dget…slice - Slice /system/serial-getty.
         Stopping systemd-user-sessions.service - Permit User Sessions...
[  OK  ] Stopped systemd-random-seed.service - Load/Save OS Random Seed.
[  OK  ] Stopped systemd-user-sessions.service - Permit User Sessions.
[  OK  ] Stopped target basic.target - Basic System.
[  OK  ] Stopped target network.target - Network.
[  OK  ] Stopped target paths.target - Path Units.
[  OK  ] Stopped systemd-ask-password-conso…equests to Console Directory Watch.
[  OK  ] Stopped systemd-ask-password-wall.…d Requests to Wall Directory Watch.
[  OK  ] Stopped target remote-fs.target - Remote File Systems.
[  OK  ] Stopped target slices.target - Slice Units.
[  OK  ] Removed slice user.slice - User and Session Slice.
[  OK  ] Stopped target sockets.target - Socket Units.
[  OK  ] Closed dbus.socket - D-Bus System Message Bus Socket.
[  OK  ] Closed sshd-unix-local.socket - Op…temd-ssh-generator, AF_UNIX Local).
[  OK  ] Closed systemd-hostnamed.socket - Hostname Service Socket.
[  OK  ] Stopped target sysinit.target - System Initialization.
         Stopping systemd-binfmt.service - Set Up Additional Binary Formats...
         Stopping systemd-networkd.service - Network Configuration...
         Stopping systemd-resolved.service - Network Name Resolution...
[  OK  ] Stopped systemd-update-done.service - Update is Completed.
[  OK  ] Stopped ldconfig.service - Rebuild Dynamic Linker Cache.
[  OK  ] Stopped systemd-journal-catalog-up….service - Rebuild Journal Catalog.
[  OK  ] Stopped systemd-tmpfiles-setup.ser…reate System Files and Directories.
[  OK  ] Stopped systemd-networkd.service - Network Configuration.
[  OK  ] Stopped systemd-resolved.service - Network Name Resolution.
[  OK  ] Stopped target network-pre.target - Preparation for Network.
[  OK  ] Closed systemd-networkd.socket - Network Service Netlink Socket.
[  OK  ] Stopped systemd-network-generator.…ork Units from Kernel Command Line.
[  OK  ] Stopped systemd-sysctl.service - Apply Kernel Variables.
[  OK  ] Stopped systemd-modules-load.service - Load Kernel Modules.
[  OK  ] Stopped systemd-binfmt.service - Set Up Additional Binary Formats.
[  OK  ] Unset automount proc-sys-fs-binfmt…ormats File System Automount Point.
[  OK  ] Stopped target local-fs.target - Local File Systems.
[  OK  ] Unset automount efi.automount - EFI System Partition Automount.
[  OK  ] Stopped target local-fs-pre.target…Preparation for Local File Systems.
         Unmounting run-lock.mount - Legacy Locks Directory /run/lock...
         Unmounting tmp.mount - Temporary Directory /tmp...
[  OK  ] Stopped systemd-tmpfiles-setup-dev…Create Static Device Nodes in /dev.
[  OK  ] Stopped systemd-sysusers.service - Create System Users.
[  OK  ] Stopped systemd-remount-fs.service…mount Root and Kernel File Systems.
[  OK  ] Stopped systemd-tmpfiles-setup-dev…ic Device Nodes in /dev gracefully.
[  OK  ] Unmounted run-lock.mount - Legacy Locks Directory /run/lock.
[  OK  ] Unmounted tmp.mount - Temporary Directory /tmp.
[  OK  ] Stopped target swap.target - Swaps.
[  OK  ] Reached target shutdown.target - System Shutdown.
[  OK  ] Reached target umount.target - Unmount All Filesystems.
[  OK  ] Reached target final.target - Late Shutdown Services.
[  OK  ] Finished systemd-poweroff.service - System Power Off.
[  OK  ] Reached target poweroff.target - System Power Off.
[   11.337059] reboot: Power down

Raw run log
BdsDxe: 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)
EFI stub: Loaded initrd from LINUX_EFI_INITRD_MEDIA_GUID device path
INFO: Block devices
NAME   MAJ:MIN RM   SIZE RO TYPE MOUNTPOINTS
sr0     11:0    1   372K  0 rom  
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   5.3M  1 disk 
vdc    254:32   0   490K  1 disk 
vdd    254:48   0 953.7M  0 disk 
vde    254:64   0  27.9G  0 disk 
vdf    254:80   0   100G  1 disk 
vdg    254:96   0    10K  1 disk 
INFO: Extracting tar archive from /dev/vdb
drwxr-xr-x _rad/_rad         0 2026-07-05 13:21 ./
-rw-r--r-- _rad/_rad      1295 2026-07-05 13:21 ./plan.yaml
-rwxr-xr-x _rad/_rad   5517632 2026-07-05 13:21 ./run-ci
INFO: Extracted files:
        8      0 drwxr-xr-x   2 1000     1000           80 Jul  5 13:21 .
       10   5392 -rwxr-xr-x   1 1000     1000      5517632 Jul  5 13:21 ./run-ci
        9      4 -rw-r--r--   1 1000     1000         1295 Jul  5 13:21 ./plan.yaml
INFO: Running run-ci from /dev/vdb
================================ BEGIN ================================
{"type":"executor_starts","name":"ambient-execute-plan","version":"0.15.0@eeab732","timestamp":{"secs_since_epoch":1783257689,"nanos_since_epoch":927853055},"log_source":"Plan"}
{"type":"runnable_plan","steps":[{"action":"mkdir","pathname":"/ci"},{"action":"mkdir","pathname":"/ci/artifacts"},{"action":"mkdir","pathname":"/ci/artifacts/debian"},{"action":"mkdir","pathname":"/ci/artifacts/rsync"},{"action":"mkdir","pathname":"/ci/secrets"},{"action":"mkdir","pathname":"/ci/deps"},{"action":"tar_extract","archive":"/dev/vdc","directory":"/ci/src"},{"action":"tar_extract","archive":"/dev/vdf","directory":"/ci/deps"},{"action":"tar_extract","archive":"/dev/vde","directory":"/ci/cache"},{"action":"tar_extract","archive":"/dev/vdd","directory":"/ci/artifacts"},{"action":"tar_extract","archive":"/dev/vdg","directory":"/ci/secrets"},{"action":"shell","shell":"ln -sf /ci /workspace"},{"action":"create_file","filename":"/root/.ssh/config","content":"Host *\nStrictHostKeyChecking accept-new\nIdentityFile /ci/secrets/ssh_key\n                ","overwrite":true},{"action":"cargo_fmt"},{"action":"cargo_clippy"},{"action":"cargo_build"},{"action":"cargo_test"},{"action":"tar_create","archive":"/dev/vde","directory":"/ci/cache"},{"action":"tar_create","archive":"/dev/vdd","directory":"/ci/artifacts"}],"executor_drive":"/dev/vdb","source_drive":"/dev/vdc","artifact_drive":"/dev/vdd","cache_drive":"/dev/vde","deps_drive":"/dev/vdf","secrets_drive":null,"workspace_dir":"/ci","source_dir":"/ci/src","deps_dir":"/ci/deps","cache_dir":"/ci/cache","artifacts_dir":"/ci/artifacts","secrets_dir":null,"envs":{},"timestamp":{"secs_since_epoch":1783257689,"nanos_since_epoch":928223737},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci","timestamp":{"secs_since_epoch":1783257689,"nanos_since_epoch":928466521},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci","timestamp":{"secs_since_epoch":1783257689,"nanos_since_epoch":929413248},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/artifacts","timestamp":{"secs_since_epoch":1783257689,"nanos_since_epoch":930349874},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/artifacts","timestamp":{"secs_since_epoch":1783257689,"nanos_since_epoch":930811515},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/artifacts/debian","timestamp":{"secs_since_epoch":1783257689,"nanos_since_epoch":930986103},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/artifacts/debian","timestamp":{"secs_since_epoch":1783257689,"nanos_since_epoch":931015666},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/artifacts/rsync","timestamp":{"secs_since_epoch":1783257689,"nanos_since_epoch":931197632},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/artifacts/rsync","timestamp":{"secs_since_epoch":1783257689,"nanos_since_epoch":931223123},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/secrets","timestamp":{"secs_since_epoch":1783257689,"nanos_since_epoch":932195391},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/secrets","timestamp":{"secs_since_epoch":1783257689,"nanos_since_epoch":933230102},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/deps","timestamp":{"secs_since_epoch":1783257689,"nanos_since_epoch":935367832},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/deps","timestamp":{"secs_since_epoch":1783257689,"nanos_since_epoch":935446047},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdc","directory":"/ci/src","timestamp":{"secs_since_epoch":1783257689,"nanos_since_epoch":935626749},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdc","directory":"/ci/src","timestamp":{"secs_since_epoch":1783257689,"nanos_since_epoch":948527566},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdf","directory":"/ci/deps","timestamp":{"secs_since_epoch":1783257689,"nanos_since_epoch":948571364},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdf","directory":"/ci/deps","timestamp":{"secs_since_epoch":1783257690,"nanos_since_epoch":546548615},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783257690,"nanos_since_epoch":549251150},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783257690,"nanos_since_epoch":791962071},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783257690,"nanos_since_epoch":794647391},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783257690,"nanos_since_epoch":798855936},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdg","directory":"/ci/secrets","timestamp":{"secs_since_epoch":1783257690,"nanos_since_epoch":801602237},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdg","directory":"/ci/secrets","timestamp":{"secs_since_epoch":1783257690,"nanos_since_epoch":805644957},"log_source":"Plan"}
{"type":"execute_action","action":"shell","shell":"ln -sf /ci /workspace","timestamp":{"secs_since_epoch":1783257690,"nanos_since_epoch":808389615},"log_source":"Plan"}
{"type":"start_program","argv":[{"Unix":[98,97,115,104]},{"Unix":[45,99]},{"Unix":[115,101,116,32,45,120,101,117,111,32,112,105,112,101,102,97,105,108,10,108,110,32,45,115,102,32,47,99,105,32,47,119,111,114,107,115,112,97,99,101,10]}],"timestamp":{"secs_since_epoch":1783257690,"nanos_since_epoch":810762559},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"","stderr":"+ ln -sf /ci /workspace\n","timestamp":{"secs_since_epoch":1783257690,"nanos_since_epoch":817894964},"log_source":"Plan"}
{"type":"action_succeeded","action":"shell","shell":"ln -sf /ci /workspace","timestamp":{"secs_since_epoch":1783257690,"nanos_since_epoch":820529543},"log_source":"Plan"}
{"type":"execute_action","action":"create_file","filename":"/root/.ssh/config","content":"Host *\nStrictHostKeyChecking accept-new\nIdentityFile /ci/secrets/ssh_key\n                ","overwrite":true,"timestamp":{"secs_since_epoch":1783257690,"nanos_since_epoch":822922511},"log_source":"Plan"}
{"type":"action_succeeded","action":"create_file","filename":"/root/.ssh/config","content":"Host *\nStrictHostKeyChecking accept-new\nIdentityFile /ci/secrets/ssh_key\n                ","overwrite":true,"timestamp":{"secs_since_epoch":1783257690,"nanos_since_epoch":827367374},"log_source":"Plan"}
{"type":"execute_action","action":"cargo_fmt","timestamp":{"secs_since_epoch":1783257690,"nanos_since_epoch":831474886},"log_source":"Plan"}
{"type":"start_program","argv":[{"Unix":[99,97,114,103,111]},{"Unix":[45,45,118,101,114,115,105,111,110]}],"timestamp":{"secs_since_epoch":1783257690,"nanos_since_epoch":833472126},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"cargo 1.96.1 (356927216 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783257690,"nanos_since_epoch":861928109},"log_source":"Plan"}
{"type":"start_program","argv":[{"Unix":[99,97,114,103,111]},{"Unix":[99,108,105,112,112,121]},{"Unix":[45,45,118,101,114,115,105,111,110]}],"timestamp":{"secs_since_epoch":1783257690,"nanos_since_epoch":861974095},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"clippy 0.1.96 (31fca3adb2 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783257690,"nanos_since_epoch":918543975},"log_source":"Plan"}
{"type":"start_program","argv":[{"Unix":[114,117,115,116,99]},{"Unix":[45,45,118,101,114,115,105,111,110]}],"timestamp":{"secs_since_epoch":1783257690,"nanos_since_epoch":921332988},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"rustc 1.96.1 (31fca3adb 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783257690,"nanos_since_epoch":939224601},"log_source":"Plan"}
{"type":"start_program","argv":[{"Unix":[99,97,114,103,111]},{"Unix":[102,109,116]},{"Unix":[45,45,99,104,101,99,107]}],"timestamp":{"secs_since_epoch":1783257690,"nanos_since_epoch":941994976},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"","stderr":"","timestamp":{"secs_since_epoch":1783257691,"nanos_since_epoch":12692090},"log_source":"Plan"}
{"type":"action_succeeded","action":"cargo_fmt","timestamp":{"secs_since_epoch":1783257691,"nanos_since_epoch":12737448},"log_source":"Plan"}
{"type":"execute_action","action":"cargo_clippy","timestamp":{"secs_since_epoch":1783257691,"nanos_since_epoch":12743704},"log_source":"Plan"}
{"type":"start_program","argv":[{"Unix":[99,97,114,103,111]},{"Unix":[45,45,118,101,114,115,105,111,110]}],"timestamp":{"secs_since_epoch":1783257691,"nanos_since_epoch":12752693},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"cargo 1.96.1 (356927216 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783257691,"nanos_since_epoch":29935429},"log_source":"Plan"}
{"type":"start_program","argv":[{"Unix":[99,97,114,103,111]},{"Unix":[99,108,105,112,112,121]},{"Unix":[45,45,118,101,114,115,105,111,110]}],"timestamp":{"secs_since_epoch":1783257691,"nanos_since_epoch":32795594},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"clippy 0.1.96 (31fca3adb2 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783257691,"nanos_since_epoch":62596338},"log_source":"Plan"}
{"type":"start_program","argv":[{"Unix":[114,117,115,116,99]},{"Unix":[45,45,118,101,114,115,105,111,110]}],"timestamp":{"secs_since_epoch":1783257691,"nanos_since_epoch":65420261},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"rustc 1.96.1 (31fca3adb 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783257691,"nanos_since_epoch":80281949},"log_source":"Plan"}
{"type":"start_program","argv":[{"Unix":[99,97,114,103,111]},{"Unix":[99,108,105,112,112,121]},{"Unix":[45,45,111,102,102,108,105,110,101]},{"Unix":[45,45,108,111,99,107,101,100]},{"Unix":[45,45,119,111,114,107,115,112,97,99,101]},{"Unix":[45,45,97,108,108,45,116,97,114,103,101,116,115]},{"Unix":[45,45,110,111,45,100,101,112,115]},{"Unix":[45,45]},{"Unix":[45,45,100,101,110,121]},{"Unix":[119,97,114,110,105,110,103,115]}],"timestamp":{"secs_since_epoch":1783257691,"nanos_since_epoch":80336301},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"","stderr":"    Checking sop-run v0.1.0 (/ci/src)\n    Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.31s\n","timestamp":{"secs_since_epoch":1783257691,"nanos_since_epoch":435864322},"log_source":"Plan"}
{"type":"action_succeeded","action":"cargo_clippy","timestamp":{"secs_since_epoch":1783257691,"nanos_since_epoch":439826979},"log_source":"Plan"}
{"type":"execute_action","action":"cargo_build","timestamp":{"secs_since_epoch":1783257691,"nanos_since_epoch":441979390},"log_source":"Plan"}
{"type":"start_program","argv":[{"Unix":[99,97,114,103,111]},{"Unix":[45,45,118,101,114,115,105,111,110]}],"timestamp":{"secs_since_epoch":1783257691,"nanos_since_epoch":444026178},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"cargo 1.96.1 (356927216 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783257691,"nanos_since_epoch":455053369},"log_source":"Plan"}
{"type":"start_program","argv":[{"Unix":[99,97,114,103,111]},{"Unix":[99,108,105,112,112,121]},{"Unix":[45,45,118,101,114,115,105,111,110]}],"timestamp":{"secs_since_epoch":1783257691,"nanos_since_epoch":457863868},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"clippy 0.1.96 (31fca3adb2 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783257691,"nanos_since_epoch":487186265},"log_source":"Plan"}
{"type":"start_program","argv":[{"Unix":[114,117,115,116,99]},{"Unix":[45,45,118,101,114,115,105,111,110]}],"timestamp":{"secs_since_epoch":1783257691,"nanos_since_epoch":487230471},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"rustc 1.96.1 (31fca3adb 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783257691,"nanos_since_epoch":504151559},"log_source":"Plan"}
{"type":"start_program","argv":[{"Unix":[99,97,114,103,111]},{"Unix":[98,117,105,108,100]},{"Unix":[45,45,111,102,102,108,105,110,101]},{"Unix":[45,45,108,111,99,107,101,100]},{"Unix":[45,45,119,111,114,107,115,112,97,99,101]},{"Unix":[45,45,97,108,108,45,116,97,114,103,101,116,115]}],"timestamp":{"secs_since_epoch":1783257691,"nanos_since_epoch":506919569},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"","stderr":"   Compiling sop-run v0.1.0 (/ci/src)\n    Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.30s\n","timestamp":{"secs_since_epoch":1783257691,"nanos_since_epoch":826175532},"log_source":"Plan"}
{"type":"action_succeeded","action":"cargo_build","timestamp":{"secs_since_epoch":1783257691,"nanos_since_epoch":826242299},"log_source":"Plan"}
{"type":"execute_action","action":"cargo_test","timestamp":{"secs_since_epoch":1783257691,"nanos_since_epoch":826457207},"log_source":"Plan"}
{"type":"start_program","argv":[{"Unix":[99,97,114,103,111]},{"Unix":[45,45,118,101,114,115,105,111,110]}],"timestamp":{"secs_since_epoch":1783257691,"nanos_since_epoch":826467418},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"cargo 1.96.1 (356927216 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783257691,"nanos_since_epoch":844574781},"log_source":"Plan"}
{"type":"start_program","argv":[{"Unix":[99,97,114,103,111]},{"Unix":[99,108,105,112,112,121]},{"Unix":[45,45,118,101,114,115,105,111,110]}],"timestamp":{"secs_since_epoch":1783257691,"nanos_since_epoch":844607312},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"clippy 0.1.96 (31fca3adb2 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783257691,"nanos_since_epoch":876348005},"log_source":"Plan"}
{"type":"start_program","argv":[{"Unix":[114,117,115,116,99]},{"Unix":[45,45,118,101,114,115,105,111,110]}],"timestamp":{"secs_since_epoch":1783257691,"nanos_since_epoch":876390131},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"rustc 1.96.1 (31fca3adb 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783257691,"nanos_since_epoch":891806243},"log_source":"Plan"}
{"type":"start_program","argv":[{"Unix":[99,97,114,103,111]},{"Unix":[116,101,115,116]},{"Unix":[45,45,111,102,102,108,105,110,101]},{"Unix":[45,45,108,111,99,107,101,100]},{"Unix":[45,45,119,111,114,107,115,112,97,99,101]}],"timestamp":{"secs_since_epoch":1783257691,"nanos_since_epoch":891873723},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"\nrunning 14 tests\ntest cmd::armor::test::armor ... ok\ntest cmd::dearmor::test::armor ... ok\ntest cmd::extract_cert::test::extract_cert ... ok\ntest cmd::generate_key::test::generate_armored_key ... ok\ntest cmd::generate_key::test::generate_binary_key ... ok\ntest cmd::encrypt::test::round_trip ... ok\ntest cmd::version::test::backend ... ok\ntest cmd::version::test::extended ... ok\ntest cmd::version::test::sop_spec ... ok\ntest cmd::version::test::sopv ... ok\ntest cmd::sign::test::roundtrip ... ok\ntest cmd::version::test::version ... ok\ntest engine::test::cat ... ok\ntest engine::test::echo ... ok\n\ntest result: ok. 14 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s\n\n\nrunning 0 tests\n\ntest result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s\n\n","stderr":"    Finished `test` profile [unoptimized + debuginfo] target(s) in 0.03s\n     Running unittests src/lib.rs (/ci/cache/cargo-target/debug/deps/sop_run-57c21bd16d918b8a)\n   Doc-tests sop_run\n","timestamp":{"secs_since_epoch":1783257692,"nanos_since_epoch":17917129},"log_source":"Plan"}
{"type":"action_succeeded","action":"cargo_test","timestamp":{"secs_since_epoch":1783257692,"nanos_since_epoch":34013143},"log_source":"Plan"}
{"type":"execute_action","action":"tar_create","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783257692,"nanos_since_epoch":36038349},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_create","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783257692,"nanos_since_epoch":371832213},"log_source":"Plan"}
{"type":"execute_action","action":"tar_create","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783257692,"nanos_since_epoch":371871555},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_create","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783257692,"nanos_since_epoch":373405825},"log_source":"Plan"}
{"type":"plan_succeeded","timestamp":{"secs_since_epoch":1783257692,"nanos_since_epoch":373508796},"log_source":"Plan"}
{"type":"executor_ends_successfully","timestamp":{"secs_since_epoch":1783257692,"nanos_since_epoch":373512834},"log_source":"Plan"}
EXIT CODE: 0

Post-plan VM
Structured log: all OK
  1. 0 ms: Executor starts
    • Name: ambient-execute-plan
    • Version: 0.15.0@eeab732
  2. 2 ms: Runnable plan
    steps:
- action: mkdir
  pathname: /ci
- action: mkdir
  pathname: /ci/artifacts
- action: mkdir
  pathname: /ci/artifacts/debian
- action: mkdir
  pathname: /ci/artifacts/rsync
- action: mkdir
  pathname: /ci/secrets
- action: mkdir
  pathname: /ci/deps
- action: tar_extract
  archive: /dev/vdc
  directory: /ci/src
- action: tar_extract
  archive: /dev/vdf
  directory: /ci/deps
- action: tar_extract
  archive: /dev/vde
  directory: /ci/cache
- action: tar_extract
  archive: /dev/vdd
  directory: /ci/artifacts
- action: tar_extract
  archive: /dev/vdg
  directory: /ci/secrets
- action: shell
  shell: ln -sf /ci /workspace
- action: create_file
  filename: /root/.ssh/config
  content: "Host *\nStrictHostKeyChecking accept-new\nIdentityFile /ci/secrets/ssh_key\n                "
  overwrite: true
- action: tar_create
  archive: /dev/vde
  directory: /ci/cache
- action: tar_create
  archive: /dev/vdd
  directory: /ci/artifacts
executor_drive: /dev/vdb
source_drive: /dev/vdc
artifact_drive: /dev/vdd
cache_drive: /dev/vde
deps_drive: /dev/vdf
secrets_drive: null
workspace_dir: /ci
source_dir: /ci/src
deps_dir: /ci/deps
cache_dir: /ci/cache
artifacts_dir: /ci/artifacts
secrets_dir: null
envs: {}

  3. 22 ms: Execute action: mkdir: /ci
    - action: mkdir
  pathname: /ci

  4. 24 ms: Action succeeded: mkdir: /ci
    - action: mkdir
  pathname: /ci

  5. 26 ms: Execute action: mkdir: /ci/artifacts
    - action: mkdir
  pathname: /ci/artifacts

  6. 28 ms: Action succeeded: mkdir: /ci/artifacts
    - action: mkdir
  pathname: /ci/artifacts

  7. 31 ms: Execute action: mkdir: /ci/artifacts/debian
    - action: mkdir
  pathname: /ci/artifacts/debian

  8. 33 ms: Action succeeded: mkdir: /ci/artifacts/debian
    - action: mkdir
  pathname: /ci/artifacts/debian

  9. 36 ms: Execute action: mkdir: /ci/artifacts/rsync
    - action: mkdir
  pathname: /ci/artifacts/rsync

  10. 38 ms: Action succeeded: mkdir: /ci/artifacts/rsync
    - action: mkdir
  pathname: /ci/artifacts/rsync

  11. 41 ms: Execute action: mkdir: /ci/secrets
    - action: mkdir
  pathname: /ci/secrets

  12. 43 ms: Action succeeded: mkdir: /ci/secrets
    - action: mkdir
  pathname: /ci/secrets

  13. 46 ms: Execute action: mkdir: /ci/deps
    - action: mkdir
  pathname: /ci/deps

  14. 55 ms: Action succeeded: mkdir: /ci/deps
    - action: mkdir
  pathname: /ci/deps

  15. 58 ms: Execute action: tar_extract
    - action: tar_extract
  archive: /dev/vdc
  directory: /ci/src

  16. 81 ms: Action succeeded: tar_extract
    - action: tar_extract
  archive: /dev/vdc
  directory: /ci/src

  17. 81 ms: Execute action: tar_extract
    - action: tar_extract
  archive: /dev/vdf
  directory: /ci/deps

  18. 648 ms: Action succeeded: tar_extract
    - action: tar_extract
  archive: /dev/vdf
  directory: /ci/deps

  19. 648 ms: Execute action: tar_extract
    - action: tar_extract
  archive: /dev/vde
  directory: /ci/cache

  20. 919 ms: Action succeeded: tar_extract
    - action: tar_extract
  archive: /dev/vde
  directory: /ci/cache

  21. 919 ms: Execute action: tar_extract
    - action: tar_extract
  archive: /dev/vdd
  directory: /ci/artifacts

  22. 925 ms: Action succeeded: tar_extract
    - action: tar_extract
  archive: /dev/vdd
  directory: /ci/artifacts

  23. 926 ms: Execute action: tar_extract
    - action: tar_extract
  archive: /dev/vdg
  directory: /ci/secrets

  24. 932 ms: Action succeeded: tar_extract
    - action: tar_extract
  archive: /dev/vdg
  directory: /ci/secrets

  25. 935 ms: Execute action: shell: ln -sf /ci /workspace
    - action: shell
  shell: ln -sf /ci /workspace

  26. 937 ms: Start program: bash
    • bash
    • -c
    • set -xeuo pipefail
ln -sf /ci /workspace

  27. 945 ms: Program succeeded
    • Exit code: 0
    • Stdout
    • Stderr
      + ln -sf /ci /workspace

  28. 945 ms: Action succeeded: shell: ln -sf /ci /workspace
    - action: shell
  shell: ln -sf /ci /workspace

  29. 945 ms: Execute action: create_file
    - action: create_file
  filename: /root/.ssh/config
  content: "Host *\nStrictHostKeyChecking accept-new\nIdentityFile /ci/secrets/ssh_key\n                "
  overwrite: true

  30. 945 ms: Action succeeded: create_file
    - action: create_file
  filename: /root/.ssh/config
  content: "Host *\nStrictHostKeyChecking accept-new\nIdentityFile /ci/secrets/ssh_key\n                "
  overwrite: true

  31. 945 ms: Execute action: tar_create
    - action: tar_create
  archive: /dev/vde
  directory: /ci/cache

  32. 1281 ms: Action succeeded: tar_create
    - action: tar_create
  archive: /dev/vde
  directory: /ci/cache

  33. 1281 ms: Execute action: tar_create
    - action: tar_create
  archive: /dev/vdd
  directory: /ci/artifacts

  34. 1283 ms: Action succeeded: tar_create
    - action: tar_create
  archive: /dev/vdd
  directory: /ci/artifacts

  35. 1283 ms: Plan succededThere was much rejoicing!
  36. 1283 ms: Executor ends successfullyPhew, nothing seems to have gone wrong.
Console log
BdsDxe: 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(0x3,0x0)
BdsDxe: starting Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x3,0x0)
  Booting `Debian GNU/Linux'

Loading Linux 6.12.86+deb13-amd64 ...
Loading initial ramdisk ...
EFI stub: Loaded initrd from LINUX_EFI_INITRD_MEDIA_GUID device path
Loading, please wait...
Starting systemd-udevd version 257.13-1~deb13u1
Begin: Loading essential drivers ... done.
Begin: Running /scripts/init-premount ... done.
Begin: Mounting root file system ... Begin: Running /scripts/local-top ... done.
Begin: Running /scripts/local-premount ... done.
Begin: Will now check root file system ... fsck from util-linux 2.41
fsck: error 2 (No such file or directory) while executing fsck.ext4 for /dev/vda2
fsck exited with status code 8
done.
Warning: File system check failed but did not detect errors
done.
Begin: Running /scripts/local-bottom ... done.
Begin: Running /scripts/init-bottom ... done.

Welcome to Debian GNU/Linux 13 (trixie)!

[  OK  ] Created slice system-getty.slice - Slice /system/getty.
[  OK  ] Created slice system-modprobe.slice - Slice /system/modprobe.
[  OK  ] Created slice system-serial\x2dget…slice - Slice /system/serial-getty.
[  OK  ] Created slice user.slice - User and Session Slice.
[  OK  ] Started systemd-ask-password-conso…equests to Console Directory Watch.
[  OK  ] Started systemd-ask-password-wall.…d Requests to Wall Directory Watch.
[  OK  ] Set up automount proc-sys-fs-binfm…ormats File System Automount Point.
         Expecting device dev-ttyS0.device - /dev/ttyS0...
[  OK  ] Reached target paths.target - Path Units.
[  OK  ] Reached target remote-fs.target - Remote File Systems.
[  OK  ] Reached target slices.target - Slice Units.
[  OK  ] Reached target swap.target - Swaps.
[  OK  ] Listening on systemd-creds.socket - Credential Encryption/Decryption.
[  OK  ] Listening on systemd-initctl.socke…- initctl Compatibility Named Pipe.
[  OK  ] Listening on systemd-journald-dev-…socket - Journal Socket (/dev/log).
[  OK  ] Listening on systemd-journald.socket - Journal Sockets.
[  OK  ] Listening on systemd-networkd.socket - Network Service Netlink Socket.
[  OK  ] Listening on systemd-udevd-control.socket - udev Control Socket.
[  OK  ] Listening on systemd-udevd-kernel.socket - udev Kernel Socket.
         Mounting dev-hugepages.mount - Huge Pages File System...
         Mounting dev-mqueue.mount - POSIX Message Queue File System...
         Mounting run-lock.mount - Legacy Locks Directory /run/lock...
         Mounting sys-kernel-debug.mount - Kernel Debug File System...
         Mounting sys-kernel-tracing.mount - Kernel Trace File System...
         Mounting tmp.mount - Temporary Directory /tmp...
         Starting kmod-static-nodes.service…eate List of Static Device Nodes...
         Starting modprobe@configfs.service - Load Kernel Module configfs...
         Starting modprobe@drm.service - Load Kernel Module drm...
         Starting modprobe@efi_pstore.servi… - Load Kernel Module efi_pstore...
         Starting modprobe@fuse.service - Load Kernel Module fuse...
         Starting systemd-journald.service - Journal Service...
         Starting systemd-modules-load.service - Load Kernel Modules...
         Starting systemd-network-generator…k Units from Kernel Command Line...
         Starting systemd-remount-fs.servic…unt Root and Kernel File Systems...
         Starting systemd-udev-load-credent…Load udev Rules from Credentials...
         Starting systemd-udev-trigger.service - Coldplug All udev Devices...
[  OK  ] Mounted dev-hugepages.mount - Huge Pages File System.
[  OK  ] Mounted dev-mqueue.mount - POSIX Message Queue File System.
[  OK  ] Mounted run-lock.mount - Legacy Locks Directory /run/lock.
[  OK  ] Mounted sys-kernel-debug.mount - Kernel Debug File System.
[  OK  ] Mounted sys-kernel-tracing.mount - Kernel Trace File System.
[  OK  ] Mounted tmp.mount - Temporary Directory /tmp.
[  OK  ] Finished kmod-static-nodes.service…Create List of Static Device Nodes.
[  OK  ] Finished modprobe@configfs.service - Load Kernel Module configfs.
[  OK  ] Finished modprobe@drm.service - Load Kernel Module drm.
[  OK  ] Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
[  OK  ] Finished modprobe@fuse.service - Load Kernel Module fuse.
[  OK  ] Finished systemd-modules-load.service - Load Kernel Modules.
[  OK  ] Finished systemd-network-generator…ork Units from Kernel Command Line.
[  OK  ] Finished systemd-remount-fs.servic…mount Root and Kernel File Systems.
[  OK  ] Finished systemd-udev-load-credent…- Load udev Rules from Credentials.
[  OK  ] Reached target network-pre.target - Preparation for Network.
         Mounting sys-fs-fuse-connections.mount - FUSE Control File System...
         Mounting sys-kernel-config.mount - Kernel Configuration File System...
         Starting systemd-random-seed.service - Load/Save OS Random Seed...
         Starting systemd-sysctl.service - Apply Kernel Variables...
         Starting systemd-tmpfiles-setup-de… Device Nodes in /dev gracefully...
[  OK  ] Started systemd-journald.service - Journal Service.
[  OK  ] Mounted sys-fs-fuse-connections.mount - FUSE Control File System.
[  OK  ] Mounted sys-kernel-config.mount - Kernel Configuration File System.
         Starting systemd-journal-flush.ser…sh Journal to Persistent Storage...
[  OK  ] Finished systemd-udev-trigger.service - Coldplug All udev Devices.
[  OK  ] Finished systemd-sysctl.service - Apply Kernel Variables.
[  OK  ] Finished systemd-tmpfiles-setup-de…ic Device Nodes in /dev gracefully.
         Starting systemd-sysusers.service - Create System Users...
[  OK  ] Finished systemd-random-seed.service - Load/Save OS Random Seed.
[  OK  ] Finished systemd-sysusers.service - Create System Users.
         Starting systemd-resolved.service - Network Name Resolution...
         Starting systemd-tmpfiles-setup-de…eate Static Device Nodes in /dev...
[  OK  ] Finished systemd-journal-flush.ser…lush Journal to Persistent Storage.
[  OK  ] Finished systemd-tmpfiles-setup-de…Create Static Device Nodes in /dev.
[  OK  ] Reached target local-fs-pre.target…Preparation for Local File Systems.
[  OK  ] Set up automount efi.automount - EFI System Partition Automount.
[  OK  ] Reached target local-fs.target - Local File Systems.
[  OK  ] Listening on systemd-sysext.socket… System Extension Image Management.
         Starting systemd-binfmt.service - Set Up Additional Binary Formats...
         Starting systemd-tmpfiles-setup.se…ate System Files and Directories...
         Starting systemd-udevd.service - R…ager for Device Events and Files...
[  OK  ] Started systemd-resolved.service - Network Name Resolution.
[  OK  ] Reached target nss-lookup.target - Host and Network Name Lookups.
[  OK  ] Finished systemd-tmpfiles-setup.se…reate System Files and Directories.
         Starting ldconfig.service - Rebuild Dynamic Linker Cache...
         Starting systemd-journal-catalog-u…ervice - Rebuild Journal Catalog...
[  OK  ] Started systemd-udevd.service - Ru…anager for Device Events and Files.
         Starting systemd-networkd.service - Network Configuration...
[  OK  ] Finished systemd-journal-catalog-u….service - Rebuild Journal Catalog.
[  OK  ] Found device dev-ttyS0.device - /dev/ttyS0.
[  OK  ] Finished ldconfig.service - Rebuild Dynamic Linker Cache.
         Starting systemd-update-done.service - Update is Completed...
[  OK  ] Finished systemd-update-done.service - Update is Completed.
         Mounting proc-sys-fs-binfmt_misc.m…cutable File Formats File System...
[  OK  ] Mounted proc-sys-fs-binfmt_misc.mo…xecutable File Formats File System.
[  OK  ] Finished systemd-binfmt.service - Set Up Additional Binary Formats.
[  OK  ] Reached target sysinit.target - System Initialization.
[  OK  ] Started apt-daily.timer - Daily apt download activities.
[  OK  ] Started apt-daily-upgrade.timer - …y apt upgrade and clean activities.
[  OK  ] Started dpkg-db-backup.timer - Daily dpkg database backup timer.
[  OK  ] Started fstrim.timer - Discard unused filesystem blocks once a week.
[  OK  ] Started man-db.timer - Daily man-db regeneration.
[  OK  ] Started systemd-tmpfiles-clean.tim…y Cleanup of Temporary Directories.
[  OK  ] Reached target timers.target - Timer Units.
[  OK  ] Listening on dbus.socket - D-Bus System Message Bus Socket.
[  OK  ] Listening on sshd-unix-local.socke…temd-ssh-generator, AF_UNIX Local).
[  OK  ] Listening on systemd-hostnamed.socket - Hostname Service Socket.
[  OK  ] Reached target sockets.target - Socket Units.
[  OK  ] Reached target basic.target - Basic System.
         Starting ambient.service - Run build job for Ambient CI...
         Starting dbus.service - D-Bus System Message Bus...
         Starting grub-common.service - Record successful boot for GRUB...
         Starting systemd-logind.service - User Login Management...
[  OK  ] Started dbus.service - D-Bus System Message Bus.
[  OK  ] Listening on systemd-rfkill.socket…ll Switch Status /dev/rfkill Watch.
[  OK  ] Started systemd-logind.service - User Login Management.
[  OK  ] Finished grub-common.service - Record successful boot for GRUB.
[  OK  ] Started systemd-networkd.service - Network Configuration.
[  OK  ] Reached target network.target - Network.
         Starting ssh.service - OpenBSD Secure Shell server...
         Starting systemd-networkd-persiste…tent Storage in systemd-networkd...
         Starting systemd-user-sessions.service - Permit User Sessions...
[  OK  ] Finished systemd-networkd-persiste…istent Storage in systemd-networkd.
[  OK  ] Finished systemd-user-sessions.service - Permit User Sessions.
[  OK  ] Started getty@tty1.service - Getty on tty1.
[  OK  ] Started serial-getty@ttyS0.service - Serial Getty on ttyS0.
[  OK  ] Reached target getty.target - Login Prompts.
[  OK  ] Started ssh.service - OpenBSD Secure Shell server.
[  OK  ] Stopped ambient.service - Run build job for Ambient CI.
[  OK  ] Removed slice system-modprobe.slice - Slice /system/modprobe.
[  OK  ] Stopped target getty.target - Login Prompts.
[  OK  ] Stopped target nss-lookup.target - Host and Network Name Lookups.
[  OK  ] Stopped target timers.target - Timer Units.
[  OK  ] Stopped apt-daily-upgrade.timer - …y apt upgrade and clean activities.
[  OK  ] Stopped apt-daily.timer - Daily apt download activities.
[  OK  ] Stopped dpkg-db-backup.timer - Daily dpkg database backup timer.
[  OK  ] Stopped fstrim.timer - Discard unused filesystem blocks once a week.
[  OK  ] Stopped man-db.timer - Daily man-db regeneration.
[  OK  ] Stopped systemd-tmpfiles-clean.tim…y Cleanup of Temporary Directories.
[  OK  ] Closed systemd-rfkill.socket - Loa…ll Switch Status /dev/rfkill Watch.
         Stopping dbus.service - D-Bus System Message Bus...
         Stopping getty@tty1.service - Getty on tty1...
         Stopping serial-getty@ttyS0.service - Serial Getty on ttyS0...
         Stopping ssh.service - OpenBSD Secure Shell server...
         Stopping systemd-logind.service - User Login Management...
         Stopping systemd-networkd-persiste…tent Storage in systemd-networkd...
         Stopping systemd-random-seed.service - Load/Save OS Random Seed...
[  OK  ] Stopped systemd-udev-load-credenti…- Load udev Rules from Credentials.
[  OK  ] Stopped dbus.service - D-Bus System Message Bus.
[  OK  ] Stopped ssh.service - OpenBSD Secure Shell server.
[  OK  ] Stopped getty@tty1.service - Getty on tty1.
[  OK  ] Stopped serial-getty@ttyS0.service - Serial Getty on ttyS0.
[  OK  ] Stopped systemd-networkd-persisten…istent Storage in systemd-networkd.
[  OK  ] Stopped systemd-random-seed.service - Load/Save OS Random Seed.
[  OK  ] Stopped systemd-logind.service - User Login Management.
[  OK  ] Removed slice system-getty.slice - Slice /system/getty.
[  OK  ] Removed slice system-serial\x2dget…slice - Slice /system/serial-getty.
         Stopping systemd-user-sessions.service - Permit User Sessions...
[  OK  ] Stopped systemd-user-sessions.service - Permit User Sessions.
[  OK  ] Stopped target basic.target - Basic System.
[  OK  ] Stopped target network.target - Network.
[  OK  ] Stopped target paths.target - Path Units.
[  OK  ] Stopped systemd-ask-password-conso…equests to Console Directory Watch.
[  OK  ] Stopped systemd-ask-password-wall.…d Requests to Wall Directory Watch.
[  OK  ] Stopped target remote-fs.target - Remote File Systems.
[  OK  ] Stopped target slices.target - Slice Units.
[  OK  ] Removed slice user.slice - User and Session Slice.
[  OK  ] Stopped target sockets.target - Socket Units.
[  OK  ] Closed dbus.socket - D-Bus System Message Bus Socket.
[  OK  ] Closed sshd-unix-local.socket - Op…temd-ssh-generator, AF_UNIX Local).
[  OK  ] Closed systemd-hostnamed.socket - Hostname Service Socket.
[  OK  ] Stopped target sysinit.target - System Initialization.
         Stopping systemd-binfmt.service - Set Up Additional Binary Formats...
         Stopping systemd-networkd.service - Network Configuration...
         Stopping systemd-resolved.service - Network Name Resolution...
[  OK  ] Stopped systemd-update-done.service - Update is Completed.
[  OK  ] Stopped ldconfig.service - Rebuild Dynamic Linker Cache.
[  OK  ] Stopped systemd-journal-catalog-up….service - Rebuild Journal Catalog.
[  OK  ] Stopped systemd-tmpfiles-setup.ser…reate System Files and Directories.
[  OK  ] Stopped systemd-binfmt.service - Set Up Additional Binary Formats.
[  OK  ] Unset automount proc-sys-fs-binfmt…ormats File System Automount Point.
[  OK  ] Stopped target local-fs.target - Local File Systems.
[  OK  ] Unset automount efi.automount - EFI System Partition Automount.
[  OK  ] Stopped target local-fs-pre.target…Preparation for Local File Systems.
         Unmounting run-lock.mount - Legacy Locks Directory /run/lock...
         Unmounting tmp.mount - Temporary Directory /tmp...
[  OK  ] Stopped systemd-tmpfiles-setup-dev…Create Static Device Nodes in /dev.
[  OK  ] Stopped systemd-resolved.service - Network Name Resolution.
[  OK  ] Stopped systemd-networkd.service - Network Configuration.
[  OK  ] Stopped target network-pre.target - Preparation for Network.
[  OK  ] Closed systemd-networkd.socket - Network Service Netlink Socket.
[  OK  ] Stopped systemd-network-generator.…ork Units from Kernel Command Line.
[  OK  ] Stopped systemd-sysctl.service - Apply Kernel Variables.
[  OK  ] Stopped systemd-modules-load.service - Load Kernel Modules.
[  OK  ] Stopped systemd-sysusers.service - Create System Users.
[  OK  ] Stopped systemd-remount-fs.service…mount Root and Kernel File Systems.
[  OK  ] Stopped systemd-tmpfiles-setup-dev…ic Device Nodes in /dev gracefully.
[  OK  ] Unmounted run-lock.mount - Legacy Locks Directory /run/lock.
[  OK  ] Unmounted tmp.mount - Temporary Directory /tmp.
[  OK  ] Stopped target swap.target - Swaps.
[  OK  ] Reached target shutdown.target - System Shutdown.
[  OK  ] Reached target umount.target - Unmount All Filesystems.
[  OK  ] Reached target final.target - Late Shutdown Services.
[  OK  ] Finished systemd-poweroff.service - System Power Off.
[  OK  ] Reached target poweroff.target - System Power Off.
[   10.298650] reboot: Power down

Raw run log
BdsDxe: 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(0x3,0x0)
BdsDxe: starting Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x3,0x0)
EFI stub: Loaded initrd from LINUX_EFI_INITRD_MEDIA_GUID device path
INFO: Block devices
NAME   MAJ:MIN RM   SIZE RO TYPE MOUNTPOINTS
sr0     11:0    1   372K  0 rom  
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   5.3M  1 disk 
vdc    254:32   0   490K  1 disk 
vdd    254:48   0 953.7M  0 disk 
vde    254:64   0  27.9G  0 disk 
vdf    254:80   0   100G  1 disk 
vdg    254:96   0    10K  1 disk 
INFO: Extracting tar archive from /dev/vdb
drwxr-xr-x _rad/_rad         0 2026-07-05 13:21 ./
-rw-r--r-- _rad/_rad      1209 2026-07-05 13:21 ./plan.yaml
-rwxr-xr-x _rad/_rad   5517632 2026-07-05 13:21 ./run-ci
INFO: Extracted files:
        8      0 drwxr-xr-x   2 1000     1000           80 Jul  5 13:21 .
       10   5392 -rwxr-xr-x   1 1000     1000      5517632 Jul  5 13:21 ./run-ci
        9      4 -rw-r--r--   1 1000     1000         1209 Jul  5 13:21 ./plan.yaml
INFO: Running run-ci from /dev/vdb
================================ BEGIN ================================
{"type":"executor_starts","name":"ambient-execute-plan","version":"0.15.0@eeab732","timestamp":{"secs_since_epoch":1783257701,"nanos_since_epoch":918708140},"log_source":"Plan"}
{"type":"runnable_plan","steps":[{"action":"mkdir","pathname":"/ci"},{"action":"mkdir","pathname":"/ci/artifacts"},{"action":"mkdir","pathname":"/ci/artifacts/debian"},{"action":"mkdir","pathname":"/ci/artifacts/rsync"},{"action":"mkdir","pathname":"/ci/secrets"},{"action":"mkdir","pathname":"/ci/deps"},{"action":"tar_extract","archive":"/dev/vdc","directory":"/ci/src"},{"action":"tar_extract","archive":"/dev/vdf","directory":"/ci/deps"},{"action":"tar_extract","archive":"/dev/vde","directory":"/ci/cache"},{"action":"tar_extract","archive":"/dev/vdd","directory":"/ci/artifacts"},{"action":"tar_extract","archive":"/dev/vdg","directory":"/ci/secrets"},{"action":"shell","shell":"ln -sf /ci /workspace"},{"action":"create_file","filename":"/root/.ssh/config","content":"Host *\nStrictHostKeyChecking accept-new\nIdentityFile /ci/secrets/ssh_key\n                ","overwrite":true},{"action":"tar_create","archive":"/dev/vde","directory":"/ci/cache"},{"action":"tar_create","archive":"/dev/vdd","directory":"/ci/artifacts"}],"executor_drive":"/dev/vdb","source_drive":"/dev/vdc","artifact_drive":"/dev/vdd","cache_drive":"/dev/vde","deps_drive":"/dev/vdf","secrets_drive":null,"workspace_dir":"/ci","source_dir":"/ci/src","deps_dir":"/ci/deps","cache_dir":"/ci/cache","artifacts_dir":"/ci/artifacts","secrets_dir":null,"envs":{},"timestamp":{"secs_since_epoch":1783257701,"nanos_since_epoch":921623617},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci","timestamp":{"secs_since_epoch":1783257701,"nanos_since_epoch":940945442},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci","timestamp":{"secs_since_epoch":1783257701,"nanos_since_epoch":943131922},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/artifacts","timestamp":{"secs_since_epoch":1783257701,"nanos_since_epoch":945328885},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/artifacts","timestamp":{"secs_since_epoch":1783257701,"nanos_since_epoch":947633216},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/artifacts/debian","timestamp":{"secs_since_epoch":1783257701,"nanos_since_epoch":950172985},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/artifacts/debian","timestamp":{"secs_since_epoch":1783257701,"nanos_since_epoch":952622231},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/artifacts/rsync","timestamp":{"secs_since_epoch":1783257701,"nanos_since_epoch":955060345},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/artifacts/rsync","timestamp":{"secs_since_epoch":1783257701,"nanos_since_epoch":957617891},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/secrets","timestamp":{"secs_since_epoch":1783257701,"nanos_since_epoch":960187041},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/secrets","timestamp":{"secs_since_epoch":1783257701,"nanos_since_epoch":962590675},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/deps","timestamp":{"secs_since_epoch":1783257701,"nanos_since_epoch":964913914},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/deps","timestamp":{"secs_since_epoch":1783257701,"nanos_since_epoch":974702286},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdc","directory":"/ci/src","timestamp":{"secs_since_epoch":1783257701,"nanos_since_epoch":976982157},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdc","directory":"/ci/src","timestamp":{"secs_since_epoch":1783257702,"nanos_since_epoch":533780},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdf","directory":"/ci/deps","timestamp":{"secs_since_epoch":1783257702,"nanos_since_epoch":564037},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdf","directory":"/ci/deps","timestamp":{"secs_since_epoch":1783257702,"nanos_since_epoch":567200627},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783257702,"nanos_since_epoch":567237427},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783257702,"nanos_since_epoch":838068621},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783257702,"nanos_since_epoch":838104540},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783257702,"nanos_since_epoch":844687300},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdg","directory":"/ci/secrets","timestamp":{"secs_since_epoch":1783257702,"nanos_since_epoch":844710408},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdg","directory":"/ci/secrets","timestamp":{"secs_since_epoch":1783257702,"nanos_since_epoch":851339090},"log_source":"Plan"}
{"type":"execute_action","action":"shell","shell":"ln -sf /ci /workspace","timestamp":{"secs_since_epoch":1783257702,"nanos_since_epoch":854039060},"log_source":"Plan"}
{"type":"start_program","argv":[{"Unix":[98,97,115,104]},{"Unix":[45,99]},{"Unix":[115,101,116,32,45,120,101,117,111,32,112,105,112,101,102,97,105,108,10,108,110,32,45,115,102,32,47,99,105,32,47,119,111,114,107,115,112,97,99,101,10]}],"timestamp":{"secs_since_epoch":1783257702,"nanos_since_epoch":856476332},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"","stderr":"+ ln -sf /ci /workspace\n","timestamp":{"secs_since_epoch":1783257702,"nanos_since_epoch":863754002},"log_source":"Plan"}
{"type":"action_succeeded","action":"shell","shell":"ln -sf /ci /workspace","timestamp":{"secs_since_epoch":1783257702,"nanos_since_epoch":863777840},"log_source":"Plan"}
{"type":"execute_action","action":"create_file","filename":"/root/.ssh/config","content":"Host *\nStrictHostKeyChecking accept-new\nIdentityFile /ci/secrets/ssh_key\n                ","overwrite":true,"timestamp":{"secs_since_epoch":1783257702,"nanos_since_epoch":863783548},"log_source":"Plan"}
{"type":"action_succeeded","action":"create_file","filename":"/root/.ssh/config","content":"Host *\nStrictHostKeyChecking accept-new\nIdentityFile /ci/secrets/ssh_key\n                ","overwrite":true,"timestamp":{"secs_since_epoch":1783257702,"nanos_since_epoch":864390334},"log_source":"Plan"}
{"type":"execute_action","action":"tar_create","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783257702,"nanos_since_epoch":864434229},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_create","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783257703,"nanos_since_epoch":200376118},"log_source":"Plan"}
{"type":"execute_action","action":"tar_create","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783257703,"nanos_since_epoch":200413867},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_create","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783257703,"nanos_since_epoch":201958697},"log_source":"Plan"}
{"type":"plan_succeeded","timestamp":{"secs_since_epoch":1783257703,"nanos_since_epoch":202091579},"log_source":"Plan"}
{"type":"executor_ends_successfully","timestamp":{"secs_since_epoch":1783257703,"nanos_since_epoch":202095446},"log_source":"Plan"}
EXIT CODE: 0