CI run log: rad:z3Cs5AnQ7J7GPCK11RESEqWBHREFV

Radicle info

Trigger message
{
  "request": "trigger",
  "version": 1,
  "event_type": "push",
  "repository": {
    "id": "rad:z3Cs5AnQ7J7GPCK11RESEqWBHREFV",
    "name": "explain-wait-status",
    "description": "Explain status from the wait(2) system call",
    "private": false,
    "default_branch": "main",
    "delegates": [
      "did:key:z6MkgEMYod7Hxfy9qCvDv5hYHkZ4ciWmLFgfvm3Wn1b2w2FV"
    ]
  },
  "pusher": {
    "id": "did:key:z6Mki2ago1X2A5UWgKpoSxyCRLLhyZMwpam4T3EKvRmFTyuy",
    "alias": "callisto.liw.fi"
  },
  "before": "c980a21c3474017e94cce1bfc5d600353a5883a9",
  "after": "c980a21c3474017e94cce1bfc5d600353a5883a9",
  "branch": "main",
  "commits": [
    "c980a21c3474017e94cce1bfc5d600353a5883a9"
  ]
}
Ambient stdout
executor from config: /usr/bin/ambient-execute-plan
executor from PATH: /usr/bin/ambient-execute-plan
run CI for rad:z3Cs5AnQ7J7GPCK11RESEqWBHREFV
CONSTRUCT: Config {
    tmpdir: "/home/_rad/tmp",
    image_store: "/home/_rad/ambient-images",
    projects: "/dev/null",
    state: "/home/_rad/ambient-state",
    rsync_target: None,
    rsync_target_base: None,
    rsync_target_map: None,
    dput_target: None,
    executor: Some(
        "/usr/bin/ambient-execute-plan",
    ),
    artifacts_max_size: Byte(
        1000000000,
    ),
    cache_max_size: Byte(
        30000000000,
    ),
    qemu: QemuConfig {
        cpus: 2,
        memory: Byte(
            12000000000,
        ),
        kvm_binary: "/usr/bin/kvm",
        ovmf_vars_file: "/usr/share/ovmf/OVMF.fd",
        ovmf_code_file: "/usr/share/ovmf/OVMF.fd",
    },
    uefi: false,
    lint: false,
    secrets: None,
} Project {
    source: TildePathBuf {
        path: "src",
    },
    expanded_source: "/tmp/.tmpZqzOcO/src",
    image: TildePathBuf {
        path: "/home/_rad/ambient.qcow2",
    },
    expanded_image: "/home/_rad/ambient.qcow2",
    pre_plan: Some(
        [
            CargoFetch,
        ],
    ),
    plan: Some(
        [
            CargoFmt,
            CargoClippy,
            CargoTest,
            CargoDoc,
            Custom(
                Custom {
                    name: "dch",
                    args: {
                        "debemail": String("liw@liw.fi"),
                        "debfullname": String("Lars Wirzenius"),
                    },
                },
            ),
            Deb,
        ],
    ),
    post_plan: Some(
        [],
    ),
    artifact_max_size: None,
    cache_max_size: None,
    dependencies_max_size: None,
}
SECRETS: copy OK
SECRETS: copy OK
Ambient stderr
<empty log>

Pre-plan VM

Structured log: all OK
  1. 0 ms: Executor starts
    • Name: ambient-execute-plan
    • Version: 0.16.0@da3268d
  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_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. 0 ms: Execute action: mkdir: /ci
    - action: mkdir
  pathname: /ci
  4. 0 ms: Action succeeded: mkdir: /ci
    - action: mkdir
  pathname: /ci
  5. 0 ms: Execute action: mkdir: /ci/artifacts
    - action: mkdir
  pathname: /ci/artifacts
  6. 0 ms: Action succeeded: mkdir: /ci/artifacts
    - action: mkdir
  pathname: /ci/artifacts
  7. 0 ms: Execute action: mkdir: /ci/artifacts/debian
    - action: mkdir
  pathname: /ci/artifacts/debian
  8. 0 ms: Action succeeded: mkdir: /ci/artifacts/debian
    - action: mkdir
  pathname: /ci/artifacts/debian
  9. 0 ms: Execute action: mkdir: /ci/artifacts/rsync
    - action: mkdir
  pathname: /ci/artifacts/rsync
  10. 0 ms: Action succeeded: mkdir: /ci/artifacts/rsync
    - action: mkdir
  pathname: /ci/artifacts/rsync
  11. 0 ms: Execute action: mkdir: /ci/secrets
    - action: mkdir
  pathname: /ci/secrets
  12. 0 ms: Action succeeded: mkdir: /ci/secrets
    - action: mkdir
  pathname: /ci/secrets
  13. 0 ms: Execute action: mkdir: /ci/deps
    - action: mkdir
  pathname: /ci/deps
  14. 0 ms: Action succeeded: mkdir: /ci/deps
    - action: mkdir
  pathname: /ci/deps
  15. 0 ms: Execute action: tar_extract
    - action: tar_extract
  archive: /dev/vdc
  directory: /ci/src
  16. 184 ms: Action succeeded: tar_extract
    - action: tar_extract
  archive: /dev/vdc
  directory: /ci/src
  17. 190 ms: Execute action: tar_extract
    - action: tar_extract
  archive: /dev/vdf
  directory: /ci/deps
  18. 228 ms: Action succeeded: tar_extract
    - action: tar_extract
  archive: /dev/vdf
  directory: /ci/deps
  19. 235 ms: Execute action: tar_extract
    - action: tar_extract
  archive: /dev/vde
  directory: /ci/cache
  20. 248 ms: Action succeeded: tar_extract
    - action: tar_extract
  archive: /dev/vde
  directory: /ci/cache
  21. 252 ms: Execute action: tar_extract
    - action: tar_extract
  archive: /dev/vdd
  directory: /ci/artifacts
  22. 262 ms: Action succeeded: tar_extract
    - action: tar_extract
  archive: /dev/vdd
  directory: /ci/artifacts
  23. 271 ms: Execute action: tar_extract
    - action: tar_extract
  archive: /dev/vdg
  directory: /ci/secrets
  24. 307 ms: Action succeeded: tar_extract
    - action: tar_extract
  archive: /dev/vdg
  directory: /ci/secrets
  25. 327 ms: Execute action: shell: ln -sf /ci /workspace
    - action: shell
  shell: ln -sf /ci /workspace
  26. 339 ms: Start program: bash
    • bash
    • -c
    • set -xeuo pipefail ln -sf /ci /workspace
  27. 359 ms: Program succeeded
    • Exit code: 0
    • Stdout
    • Stderr
      + ln -sf /ci /workspace

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

  29. 366 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. 384 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. 398 ms: Execute action: cargo_fetch
    - action: cargo_fetch

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

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

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

    • Stderr
  38. 714 ms: Start program: cargo
    • cargo
    • fetch
    • --locked
  39. 7848 ms: Program succeeded
    • Exit code: 0
    • Stdout
    • Stderr
          Updating crates.io index
 Downloading crates ...
  Downloaded colorchoice v1.0.4
  Downloaded anstyle-query v1.1.3
  Downloaded anstyle-parse v0.2.7
  Downloaded quote v1.0.40
  Downloaded unicode-ident v1.0.18
  Downloaded ryu v1.0.20
  Downloaded memchr v2.7.5
  Downloaded proc-macro2 v1.0.95
  Downloaded serde_derive v1.0.219
  Downloaded serde_json v1.0.141
  Downloaded once_cell_polyfill v1.70.1
  Downloaded anstream v0.6.19
  Downloaded anstyle v1.0.11
  Downloaded clap_builder v4.5.41
  Downloaded bitflags v2.9.1
  Downloaded heck v0.5.0
  Downloaded clap v4.5.41
  Downloaded anstyle-wincon v3.0.9
  Downloaded is_terminal_polyfill v1.70.1
  Downloaded utf8parse v0.2.2
  Downloaded clap_lex v0.7.5
  Downloaded strsim v0.11.1
  Downloaded errno v0.3.13
  Downloaded windows-targets v0.53.2
  Downloaded terminal_size v0.4.2
  Downloaded clap_derive v4.5.41
  Downloaded itoa v1.0.15
  Downloaded windows-targets v0.52.6
  Downloaded serde v1.0.219
  Downloaded syn v2.0.104
  Downloaded windows_aarch64_gnullvm v0.52.6
  Downloaded rustix v1.0.8
  Downloaded windows_x86_64_gnullvm v0.52.6
  Downloaded windows_i686_gnullvm v0.52.6
  Downloaded windows_x86_64_gnullvm v0.53.0
  Downloaded windows_aarch64_gnullvm v0.53.0
  Downloaded windows_x86_64_msvc v0.53.0
  Downloaded windows_aarch64_msvc v0.53.0
  Downloaded windows_x86_64_msvc v0.52.6
  Downloaded windows_x86_64_gnu v0.53.0
  Downloaded windows_i686_gnullvm v0.53.0
  Downloaded windows_i686_msvc v0.52.6
  Downloaded windows_i686_gnu v0.53.0
  Downloaded windows_i686_gnu v0.52.6
  Downloaded windows_i686_msvc v0.53.0
  Downloaded windows_x86_64_gnu v0.52.6
  Downloaded windows_aarch64_msvc v0.52.6
  Downloaded libc v0.2.174
  Downloaded linux-raw-sys v0.9.4
  Downloaded windows-sys v0.59.0
  Downloaded windows-sys v0.60.2

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

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

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

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

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

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

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

  47. 10076 ms: Plan succededThere was much rejoicing!
  48. 10079 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-random-seed.service - Load/Save OS Random Seed.
[  OK  ] Finished systemd-tmpfiles-setup-de…ic Device Nodes in /dev gracefully.
         Starting systemd-sysusers.service - Create System Users...
[  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  ] 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-resolved.service - Network Name Resolution.
[  OK  ] Started systemd-udevd.service - Ru…anager for Device Events and Files.
[  OK  ] Reached target nss-lookup.target - Host and Network Name Lookups.
         Starting systemd-networkd.service - Network Configuration...
[  OK  ] Finished systemd-journal-catalog-u….service - Rebuild Journal Catalog.
[  OK  ] Found device dev-ttyS0.device - /dev/ttyS0.
         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  ] Finished ldconfig.service - Rebuild Dynamic Linker Cache.
         Starting systemd-update-done.service - Update is Completed...
[  OK  ] Finished systemd-update-done.service - Update is Completed.
[  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 systemd-networkd.service - Network Configuration.
[  OK  ] Started dbus.service - D-Bus System Message Bus.
[  OK  ] Reached target network.target - Network.
[  OK  ] Listening on systemd-rfkill.socket…ll Switch Status /dev/rfkill Watch.
         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 systemd-logind.service - User Login Management.
[  OK  ] Started ssh.service - OpenBSD Secure Shell server.
[  OK  ] Finished grub-common.service - Record successful boot for GRUB.

Debian GNU/Linux 13 ambient-dev ttyS0

ambient-dev login: [  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.
[topping 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-networkd.service - Network Configuration.
[  OK  ] Stopped systemd-resolved.service - Network Name Resolution.
[  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.
[  OK  ] Stopped target network-pre.target - Preparation for Network.
[  OK  ] Closed systemd-networkd.socket - Network Service Netlink Socket.
         Unmounting run-lock.mount - Legacy Locks Directory /run/lock...
         Unmounting tmp.mount - Temporary Directory /tmp...
[  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-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.
[   21.691197] 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
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   910K  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-09 16:18 ./
-rw-r--r-- _rad/_rad      1294 2026-07-09 16:18 ./plan.yaml
-rwxr-xr-x _rad/_rad   5525824 2026-07-09 16:18 ./run-ci
INFO: Extracted files:
        6      0 drwxr-xr-x   2 1000     1000           80 Jul  9 16:18 .
       10   5400 -rwxr-xr-x   1 1000     1000      5525824 Jul  9 16:18 ./run-ci
        9      4 -rw-r--r--   1 1000     1000         1294 Jul  9 16:18 ./plan.yaml
INFO: Running run-ci from /dev/vdb
================================ BEGIN ================================
{"type":"executor_starts","name":"ambient-execute-plan","version":"0.16.0@da3268d","timestamp":{"secs_since_epoch":1783613942,"nanos_since_epoch":907419500},"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":1783613942,"nanos_since_epoch":907876588},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci","timestamp":{"secs_since_epoch":1783613942,"nanos_since_epoch":907976179},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci","timestamp":{"secs_since_epoch":1783613942,"nanos_since_epoch":908108021},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/artifacts","timestamp":{"secs_since_epoch":1783613942,"nanos_since_epoch":908117993},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/artifacts","timestamp":{"secs_since_epoch":1783613942,"nanos_since_epoch":908167501},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/artifacts/debian","timestamp":{"secs_since_epoch":1783613942,"nanos_since_epoch":908176303},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/artifacts/debian","timestamp":{"secs_since_epoch":1783613942,"nanos_since_epoch":908223782},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/artifacts/rsync","timestamp":{"secs_since_epoch":1783613942,"nanos_since_epoch":908232108},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/artifacts/rsync","timestamp":{"secs_since_epoch":1783613942,"nanos_since_epoch":908276108},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/secrets","timestamp":{"secs_since_epoch":1783613942,"nanos_since_epoch":908284191},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/secrets","timestamp":{"secs_since_epoch":1783613942,"nanos_since_epoch":908330498},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/deps","timestamp":{"secs_since_epoch":1783613942,"nanos_since_epoch":908338777},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/deps","timestamp":{"secs_since_epoch":1783613942,"nanos_since_epoch":908382317},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdc","directory":"/ci/src","timestamp":{"secs_since_epoch":1783613942,"nanos_since_epoch":908390951},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdc","directory":"/ci/src","timestamp":{"secs_since_epoch":1783613943,"nanos_since_epoch":91969574},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdf","directory":"/ci/deps","timestamp":{"secs_since_epoch":1783613943,"nanos_since_epoch":97704215},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdf","directory":"/ci/deps","timestamp":{"secs_since_epoch":1783613943,"nanos_since_epoch":136091637},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783613943,"nanos_since_epoch":143276309},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783613943,"nanos_since_epoch":156040920},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783613943,"nanos_since_epoch":159808788},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783613943,"nanos_since_epoch":169523093},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdg","directory":"/ci/secrets","timestamp":{"secs_since_epoch":1783613943,"nanos_since_epoch":179095529},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdg","directory":"/ci/secrets","timestamp":{"secs_since_epoch":1783613943,"nanos_since_epoch":215205532},"log_source":"Plan"}
{"type":"execute_action","action":"shell","shell":"ln -sf /ci /workspace","timestamp":{"secs_since_epoch":1783613943,"nanos_since_epoch":234649476},"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":1783613943,"nanos_since_epoch":246964576},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"","stderr":"+ ln -sf /ci /workspace\n","timestamp":{"secs_since_epoch":1783613943,"nanos_since_epoch":266707045},"log_source":"Plan"}
{"type":"action_succeeded","action":"shell","shell":"ln -sf /ci /workspace","timestamp":{"secs_since_epoch":1783613943,"nanos_since_epoch":270559058},"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":1783613943,"nanos_since_epoch":274014170},"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":1783613943,"nanos_since_epoch":291936219},"log_source":"Plan"}
{"type":"execute_action","action":"cargo_fetch","timestamp":{"secs_since_epoch":1783613943,"nanos_since_epoch":306110009},"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":1783613943,"nanos_since_epoch":315349411},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"cargo 1.96.1 (356927216 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783613943,"nanos_since_epoch":415234257},"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":1783613943,"nanos_since_epoch":419690722},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"clippy 0.1.96 (31fca3adb2 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783613943,"nanos_since_epoch":551067894},"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":1783613943,"nanos_since_epoch":557032678},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"rustc 1.96.1 (31fca3adb 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783613943,"nanos_since_epoch":607443494},"log_source":"Plan"}
copying relevant files to /tmp/.tmpKVHQHK
{"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":1783613943,"nanos_since_epoch":621927266},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"","stderr":"    Updating crates.io index\n Downloading crates ...\n  Downloaded colorchoice v1.0.4\n  Downloaded anstyle-query v1.1.3\n  Downloaded anstyle-parse v0.2.7\n  Downloaded quote v1.0.40\n  Downloaded unicode-ident v1.0.18\n  Downloaded ryu v1.0.20\n  Downloaded memchr v2.7.5\n  Downloaded proc-macro2 v1.0.95\n  Downloaded serde_derive v1.0.219\n  Downloaded serde_json v1.0.141\n  Downloaded once_cell_polyfill v1.70.1\n  Downloaded anstream v0.6.19\n  Downloaded anstyle v1.0.11\n  Downloaded clap_builder v4.5.41\n  Downloaded bitflags v2.9.1\n  Downloaded heck v0.5.0\n  Downloaded clap v4.5.41\n  Downloaded anstyle-wincon v3.0.9\n  Downloaded is_terminal_polyfill v1.70.1\n  Downloaded utf8parse v0.2.2\n  Downloaded clap_lex v0.7.5\n  Downloaded strsim v0.11.1\n  Downloaded errno v0.3.13\n  Downloaded windows-targets v0.53.2\n  Downloaded terminal_size v0.4.2\n  Downloaded clap_derive v4.5.41\n  Downloaded itoa v1.0.15\n  Downloaded windows-targets v0.52.6\n  Downloaded serde v1.0.219\n  Downloaded syn v2.0.104\n  Downloaded windows_aarch64_gnullvm v0.52.6\n  Downloaded rustix v1.0.8\n  Downloaded windows_x86_64_gnullvm v0.52.6\n  Downloaded windows_i686_gnullvm v0.52.6\n  Downloaded windows_x86_64_gnullvm v0.53.0\n  Downloaded windows_aarch64_gnullvm v0.53.0\n  Downloaded windows_x86_64_msvc v0.53.0\n  Downloaded windows_aarch64_msvc v0.53.0\n  Downloaded windows_x86_64_msvc v0.52.6\n  Downloaded windows_x86_64_gnu v0.53.0\n  Downloaded windows_i686_gnullvm v0.53.0\n  Downloaded windows_i686_msvc v0.52.6\n  Downloaded windows_i686_gnu v0.53.0\n  Downloaded windows_i686_gnu v0.52.6\n  Downloaded windows_i686_msvc v0.53.0\n  Downloaded windows_x86_64_gnu v0.52.6\n  Downloaded windows_aarch64_msvc v0.52.6\n  Downloaded libc v0.2.174\n  Downloaded linux-raw-sys v0.9.4\n  Downloaded windows-sys v0.59.0\n  Downloaded windows-sys v0.60.2\n","timestamp":{"secs_since_epoch":1783613950,"nanos_since_epoch":755809458},"log_source":"Plan"}
{"type":"action_succeeded","action":"cargo_fetch","timestamp":{"secs_since_epoch":1783613950,"nanos_since_epoch":756416374},"log_source":"Plan"}
{"type":"execute_action","action":"tar_create","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783613950,"nanos_since_epoch":756427605},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_create","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783613950,"nanos_since_epoch":832225658},"log_source":"Plan"}
{"type":"execute_action","action":"tar_create","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783613950,"nanos_since_epoch":832816701},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_create","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783613950,"nanos_since_epoch":837182156},"log_source":"Plan"}
{"type":"execute_action","action":"tar_create","archive":"/dev/vdf","directory":"/ci/deps","timestamp":{"secs_since_epoch":1783613950,"nanos_since_epoch":837215525},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_create","archive":"/dev/vdf","directory":"/ci/deps","timestamp":{"secs_since_epoch":1783613952,"nanos_since_epoch":979508180},"log_source":"Plan"}
{"type":"plan_succeeded","timestamp":{"secs_since_epoch":1783613952,"nanos_since_epoch":984105751},"log_source":"Plan"}
{"type":"executor_ends_successfully","timestamp":{"secs_since_epoch":1783613952,"nanos_since_epoch":987049522},"log_source":"Plan"}
EXIT CODE: 0

Plan VM
Structured log: all OK
  1. 0 ms: Executor starts
    • Name: ambient-execute-plan
    • Version: 0.16.0@da3268d
  2. 1 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_test
- action: cargo_doc
- action: custom
  name: dch
  args:
    debfullname: Lars Wirzenius
    debemail: liw@liw.fi
- action: deb
  packages: .
- action: tar_create
  archive: /dev/vde
  directory: /ci/cache
- action: tar_create
  archive: /dev/vdd
  directory: /ci/artifacts
executor_drive: /dev/vdb
source_drive: /dev/vdc
artifact_drive: /dev/vdd
cache_drive: /dev/vde
deps_drive: /dev/vdf
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. 2 ms: Execute action: mkdir: /ci
    - action: mkdir
  pathname: /ci

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

  29. 1007 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. 1009 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. 1009 ms: Execute action: cargo_fmt
    - action: cargo_fmt

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

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

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

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

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

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

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

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

    • Stderr
  48. 1419 ms: Start program: cargo
    • cargo
    • clippy
    • --offline
    • --locked
    • --workspace
    • --all-targets
    • --no-deps
    • --
    • --deny
    • warnings
  49. 16980 ms: Program succeeded
    • Exit code: 0
    • Stdout
    • Stderr
         Compiling proc-macro2 v1.0.95
   Compiling unicode-ident v1.0.18
   Compiling rustix v1.0.8
    Checking bitflags v2.9.1
    Checking linux-raw-sys v0.9.4
   Compiling quote v1.0.40
   Compiling syn v2.0.104
    Checking utf8parse v0.2.2
    Checking anstyle-parse v0.2.7
    Checking anstyle-query v1.1.3
    Checking anstyle v1.0.11
    Checking is_terminal_polyfill v1.70.1
   Compiling serde v1.0.219
    Checking colorchoice v1.0.4
    Checking anstream v0.6.19
    Checking terminal_size v0.4.2
    Checking strsim v0.11.1
   Compiling serde_json v1.0.141
   Compiling heck v0.5.0
    Checking clap_lex v0.7.5
   Compiling libc v0.2.174
    Checking clap_builder v4.5.41
    Checking ryu v1.0.20
    Checking memchr v2.7.5
   Compiling serde_derive v1.0.219
   Compiling clap_derive v4.5.41
    Checking itoa v1.0.15
    Checking clap v4.5.41
    Checking explain-wait-status v0.1.0 (/ci/src)
    Finished `dev` profile [unoptimized + debuginfo] target(s) in 15.48s

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

  51. 16981 ms: Execute action: cargo_test
    - action: cargo_test

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

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

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

    • Stderr
  58. 17136 ms: Start program: cargo
    • cargo
    • test
    • --offline
    • --locked
    • --workspace
  59. 27461 ms: Program succeeded
    • Exit code: 0
    • Stdout
      running 1 test
test test::normal_exits ... ok

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


running 0 tests

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


running 0 tests

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


    • Stderr
         Compiling bitflags v2.9.1
   Compiling utf8parse v0.2.2
   Compiling linux-raw-sys v0.9.4
   Compiling anstyle-parse v0.2.7
   Compiling anstyle v1.0.11
   Compiling rustix v1.0.8
   Compiling colorchoice v1.0.4
   Compiling anstyle-query v1.1.3
   Compiling is_terminal_polyfill v1.70.1
   Compiling anstream v0.6.19
   Compiling clap_lex v0.7.5
   Compiling terminal_size v0.4.2
   Compiling strsim v0.11.1
   Compiling serde v1.0.219
   Compiling clap_builder v4.5.41
   Compiling itoa v1.0.15
   Compiling memchr v2.7.5
   Compiling ryu v1.0.20
   Compiling serde_json v1.0.141
   Compiling clap v4.5.41
   Compiling libc v0.2.174
   Compiling explain-wait-status v0.1.0 (/ci/src)
    Finished `test` profile [unoptimized + debuginfo] target(s) in 10.22s
     Running unittests src/lib.rs (/ci/cache/cargo-target/debug/deps/explain_wait_status-0c5809f5e4f77e5d)
     Running unittests src/main.rs (/ci/cache/cargo-target/debug/deps/explain_wait_status-cbbe738206f82c37)
   Doc-tests explain_wait_status

  60. 27496 ms: Action succeeded: cargo_test
    - action: cargo_test

  61. 27500 ms: Execute action: cargo_doc
    - action: cargo_doc

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

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

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

    • Stderr
  68. 27633 ms: Start program: env
    • env
    • RUSTDOCFLAGS=-D warnings
    • cargo
    • doc
    • --workspace
  69. 49420 ms: Program succeeded
    • Exit code: 0
    • Stdout
    • Stderr
          Checking unicode-ident v1.0.18
 Documenting unicode-ident v1.0.18
    Checking proc-macro2 v1.0.95
 Documenting proc-macro2 v1.0.95
    Checking quote v1.0.40
    Checking syn v2.0.104
 Documenting quote v1.0.40
 Documenting syn v2.0.104
 Documenting utf8parse v0.2.2
 Documenting linux-raw-sys v0.9.4
 Documenting bitflags v2.9.1
 Documenting rustix v1.0.8
 Documenting anstyle-parse v0.2.7
 Documenting anstyle v1.0.11
 Documenting colorchoice v1.0.4
 Documenting is_terminal_polyfill v1.70.1
 Documenting anstyle-query v1.1.3
 Documenting terminal_size v0.4.2
 Documenting anstream v0.6.19
 Documenting serde_derive v1.0.219
 Documenting strsim v0.11.1
    Checking heck v0.5.0
 Documenting clap_lex v0.7.5
 Documenting heck v0.5.0
 Documenting clap_builder v4.5.41
 Documenting clap_derive v4.5.41
 Documenting serde v1.0.219
 Documenting ryu v1.0.20
 Documenting memchr v2.7.5
 Documenting itoa v1.0.15
 Documenting clap v4.5.41
 Documenting serde_json v1.0.141
 Documenting libc v0.2.174
 Documenting explain-wait-status v0.1.0 (/ci/src)
    Finished `dev` profile [unoptimized + debuginfo] target(s) in 21.75s
   Generated /ci/cache/cargo-target/doc/explain_wait_status/index.html

  70. 49420 ms: Action succeeded: cargo_doc
    - action: cargo_doc

  71. 49421 ms: Execute action: custom: dch
    - action: custom
  name: dch
  args:
    debfullname: Lars Wirzenius
    debemail: liw@liw.fi

  72. 49421 ms: Custom action starts: dch
    • Source: /ci/src
    • - name: dch
  args:
    debfullname: Lars Wirzenius
    debemail: liw@liw.fi

    • Executable: .ambient/dch
    • Executable exists? false
  73. 50115 ms: Custom action output
    • Stdout
      HEAD is now at c980a21 chore: update .ambient/dch

    • Stderr
      + export 'DEBEMAIL="liw@liw.fi"'
+ DEBEMAIL='"liw@liw.fi"'
+ export 'DEBFULLNAME="Lars Wirzenius"'
+ DEBFULLNAME='"Lars Wirzenius"'
+ export CARGO_TARGET_DIR=/workspace/cache
+ CARGO_TARGET_DIR=/workspace/cache
+ export CARGO_HOME=/workspace/deps
+ CARGO_HOME=/workspace/deps
+ export HOME=/root
+ HOME=/root
+ export PATH=/root/.cargo/bin:/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin
+ PATH=/root/.cargo/bin:/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin
+ git reset --hard
+ git clean -fdx
++ dpkg-parsechangelog -SVersion
++ sed 's/-[^-]*$//'
+ V=0.1.0
++ date -u +%Y%m%dT%H%M%S
+ T=20260709T162014
+ version=0.1.0.ci20260709T162014-1
+ dch -v 0.1.0.ci20260709T162014-1 'CI build under Ambient.'
+ dch -r ''

  74. 50116 ms: Action succeeded: custom: dch
    - action: custom
  name: dch
  args:
    debfullname: Lars Wirzenius
    debemail: liw@liw.fi

  75. 50116 ms: Execute action: deb
    - action: deb
  packages: .

  76. 50116 ms: Start program: /bin/bash
    • /bin/bash
    • -c
    • #!/usr/bin/env bash
set -xeuo pipefail

echo "PATH at start: $PATH"
export PATH="/root/.cargo/bin:$PATH"
export CARGO_HOME=/ci/deps
export DEBEMAIL=liw@liw.fi
export DEBFULLNAME="Lars Wirzenius"
/bin/env

command -v cargo
command -v rustc

cargo --version
rustc --version

# Get name and version of source package.
name="$(dpkg-parsechangelog -SSource)"
version="$(dpkg-parsechangelog -SVersion)"

# Get upstream version: everything before the last dash.
uv="$(echo "$version" | sed 's/-[^-]*$//')"

# Files that will be created.
arch="$(dpkg --print-architecture)"
orig="../${name}_${uv}.orig.tar.xz"
deb="../${name}_${version}_${arch}.deb"
changes="../${name}_${version}_${arch}.changes"

# Create "upstream tarball".
git archive HEAD | xz >"$orig"

# Build package.
dpkg-buildpackage -us -uc

# Dump some information to make it easier to visually verify
# everything looks OK. Also, test the package with the lintian tool.

ls -l ..
for x in ../*.deb; do dpkg -c "$x"; done
# FIXME: disabled while this prevents radicle-native-ci deb from being built.
# lintian -i --allow-root --fail-on warning ../*.changes

# Move files to artifacts directory.
mv ../*_* /ci/artifacts/.
        
  77. 86212 ms: Program succeeded
    • Exit code: 0
    • Stdout
      PATH at start: /root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin
MEMORY_PRESSURE_WRITE=c29tZSAyMDAwMDAgMjAwMDAwMAA=
DEBFULLNAME=Lars Wirzenius
CARGO_TARGET_DIR=/ci/cache/cargo-target
PWD=/ci/src
SYSTEMD_EXEC_PID=355
HOME=/root
LANG=C.UTF-8
CARGO_HOME=/ci/deps
MEMORY_PRESSURE_WATCH=/sys/fs/cgroup/system.slice/ambient.service/memory.pressure
DEBEMAIL=liw@liw.fi
INVOCATION_ID=0bc5a7a21bad453ea9bb17d32f63ad6c
USER=root
SHLVL=2
JOURNAL_STREAM=9:2590
PATH=/root/.cargo/bin:/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin
OLDPWD=/
_=/bin/env
/root/.cargo/bin/cargo
/root/.cargo/bin/rustc
cargo 1.96.1 (356927216 2026-06-26)
rustc 1.96.1 (31fca3adb 2026-06-26)
dpkg-buildpackage: info: source package explain-wait-status
dpkg-buildpackage: info: source version 0.1.0.ci20260709T162014-1
dpkg-buildpackage: info: source distribution unstable
dpkg-buildpackage: info: source changed by "Lars Wirzenius" <"liw@liw.fi">
dpkg-buildpackage: info: host architecture amd64
dh clean
   dh_clean
dpkg-source: info: using source format '3.0 (quilt)'
dpkg-source: info: building explain-wait-status using existing ./explain-wait-status_0.1.0.ci20260709T162014.orig.tar.xz
dpkg-source: info: building explain-wait-status in explain-wait-status_0.1.0.ci20260709T162014-1.debian.tar.xz
dpkg-source: info: building explain-wait-status in explain-wait-status_0.1.0.ci20260709T162014-1.dsc
dh binary
   dh_update_autotools_config
   dh_autoreconf
   debian/rules override_dh_auto_build
make[1]: Entering directory '/ci/src'
true
make[1]: Leaving directory '/ci/src'
   create-stamp debian/debhelper-build-stamp
   dh_prep
   debian/rules override_dh_auto_install
make[1]: Entering directory '/ci/src'
cargo install --offline --locked --path=. --root=debian/explain-wait-status/usr
find debian/*/ -name ".crates*" -delete
make[1]: Leaving directory '/ci/src'
   dh_installdocs
   dh_installchangelogs
   dh_lintian
   dh_perl
   dh_link
   dh_strip_nondeterminism
   dh_compress
   dh_fixperms
   dh_missing
   dh_strip
   dh_makeshlibs
   dh_shlibdeps
   dh_installdeb
   dh_gencontrol
   dh_md5sums
   dh_builddeb
dpkg-deb: building package 'explain-wait-status-dbgsym' in '../explain-wait-status-dbgsym_0.1.0.ci20260709T162014-1_amd64.deb'.
dpkg-deb: building package 'explain-wait-status' in '../explain-wait-status_0.1.0.ci20260709T162014-1_amd64.deb'.
dpkg-genchanges: info: including full source code in upload
dpkg-buildpackage: info: full upload (original source is included)
total 380
drwxr-xr-x 4 root root   4096 Jul  9 16:18 artifacts
drwxr-xr-x 3 root root   4096 Jul  9 16:19 cache
drwxr-xr-x 3 root root   4096 Jul  9 16:19 deps
-rw-r--r-- 1 root root  38276 Jul  9 16:20 explain-wait-status-dbgsym_0.1.0.ci20260709T162014-1_amd64.deb
-rw-r--r-- 1 root root   2168 Jul  9 16:20 explain-wait-status_0.1.0.ci20260709T162014-1.debian.tar.xz
-rw-r--r-- 1 root root    992 Jul  9 16:20 explain-wait-status_0.1.0.ci20260709T162014-1.dsc
-rw-r--r-- 1 root root   5351 Jul  9 16:20 explain-wait-status_0.1.0.ci20260709T162014-1_amd64.buildinfo
-rw-r--r-- 1 root root   2601 Jul  9 16:20 explain-wait-status_0.1.0.ci20260709T162014-1_amd64.changes
-rw-r--r-- 1 root root 298528 Jul  9 16:20 explain-wait-status_0.1.0.ci20260709T162014-1_amd64.deb
-rw-r--r-- 1 root root   6508 Jul  9 16:20 explain-wait-status_0.1.0.ci20260709T162014.orig.tar.xz
drwxr-xr-x 2 root root   4096 Jul  9 16:19 secrets
drwxr-xr-x 7 root root   4096 Jul  9 16:20 src
drwxr-xr-x root/root         0 2026-07-09 16:20 ./
drwxr-xr-x root/root         0 2026-07-09 16:20 ./usr/
drwxr-xr-x root/root         0 2026-07-09 16:20 ./usr/lib/
drwxr-xr-x root/root         0 2026-07-09 16:20 ./usr/lib/debug/
drwxr-xr-x root/root         0 2026-07-09 16:20 ./usr/lib/debug/.build-id/
drwxr-xr-x root/root         0 2026-07-09 16:20 ./usr/lib/debug/.build-id/4a/
-rw-r--r-- root/root    216096 2026-07-09 16:20 ./usr/lib/debug/.build-id/4a/e3fa8ef53ccca151722f6d0215169659ad0dac.debug
drwxr-xr-x root/root         0 2026-07-09 16:20 ./usr/share/
drwxr-xr-x root/root         0 2026-07-09 16:20 ./usr/share/doc/
lrwxrwxrwx root/root         0 2026-07-09 16:20 ./usr/share/doc/explain-wait-status-dbgsym -> explain-wait-status
drwxr-xr-x root/root         0 2026-07-09 16:20 ./
drwxr-xr-x root/root         0 2026-07-09 16:20 ./usr/
drwxr-xr-x root/root         0 2026-07-09 16:20 ./usr/bin/
-rwxr-xr-x root/root    836384 2026-07-09 16:20 ./usr/bin/explain-wait-status
drwxr-xr-x root/root         0 2026-07-09 16:20 ./usr/share/
drwxr-xr-x root/root         0 2026-07-09 16:20 ./usr/share/doc/
drwxr-xr-x root/root         0 2026-07-09 16:20 ./usr/share/doc/explain-wait-status/
-rw-r--r-- root/root       223 2026-07-09 16:20 ./usr/share/doc/explain-wait-status/changelog.Debian.gz
-rw-r--r-- root/root      1093 2026-07-09 16:20 ./usr/share/doc/explain-wait-status/copyright
drwxr-xr-x root/root         0 2026-07-09 16:20 ./usr/share/lintian/
drwxr-xr-x root/root         0 2026-07-09 16:20 ./usr/share/lintian/overrides/
-rw-r--r-- root/root       101 2026-07-09 16:20 ./usr/share/lintian/overrides/explain-wait-status

    • Stderr
      + echo 'PATH at start: /root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin'
+ export PATH=/root/.cargo/bin:/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin
+ PATH=/root/.cargo/bin:/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin
+ export CARGO_HOME=/ci/deps
+ CARGO_HOME=/ci/deps
+ export DEBEMAIL=liw@liw.fi
+ DEBEMAIL=liw@liw.fi
+ export 'DEBFULLNAME=Lars Wirzenius'
+ DEBFULLNAME='Lars Wirzenius'
+ /bin/env
+ command -v cargo
+ command -v rustc
+ cargo --version
+ rustc --version
++ dpkg-parsechangelog -SSource
+ name=explain-wait-status
++ dpkg-parsechangelog -SVersion
+ version=0.1.0.ci20260709T162014-1
++ echo 0.1.0.ci20260709T162014-1
++ sed 's/-[^-]*$//'
+ uv=0.1.0.ci20260709T162014
++ dpkg --print-architecture
+ arch=amd64
+ orig=../explain-wait-status_0.1.0.ci20260709T162014.orig.tar.xz
+ deb=../explain-wait-status_0.1.0.ci20260709T162014-1_amd64.deb
+ changes=../explain-wait-status_0.1.0.ci20260709T162014-1_amd64.changes
+ git archive HEAD
+ xz
+ dpkg-buildpackage -us -uc
 dpkg-source --before-build .
 debian/rules clean
 dpkg-source -b .
 debian/rules binary
  Installing explain-wait-status v0.1.0 (/ci/src)
   Compiling proc-macro2 v1.0.95
   Compiling unicode-ident v1.0.18
   Compiling rustix v1.0.8
   Compiling bitflags v2.9.1
   Compiling quote v1.0.40
   Compiling linux-raw-sys v0.9.4
   Compiling syn v2.0.104
   Compiling utf8parse v0.2.2
   Compiling anstyle-parse v0.2.7
   Compiling serde v1.0.219
   Compiling anstyle v1.0.11
   Compiling is_terminal_polyfill v1.70.1
   Compiling colorchoice v1.0.4
   Compiling anstyle-query v1.1.3
   Compiling anstream v0.6.19
   Compiling terminal_size v0.4.2
   Compiling libc v0.2.174
   Compiling clap_lex v0.7.5
   Compiling strsim v0.11.1
   Compiling serde_derive v1.0.219
   Compiling serde_json v1.0.141
   Compiling heck v0.5.0
   Compiling clap_derive v4.5.41
   Compiling clap_builder v4.5.41
   Compiling itoa v1.0.15
   Compiling ryu v1.0.20
   Compiling memchr v2.7.5
   Compiling clap v4.5.41
   Compiling explain-wait-status v0.1.0 (/ci/src)
    Finished `release` profile [optimized] target(s) in 29.90s
  Installing /ci/src/debian/explain-wait-status/usr/bin/explain-wait-status
   Installed package `explain-wait-status v0.1.0 (/ci/src)` (executable `explain-wait-status`)
warning: be sure to add `/ci/src/debian/explain-wait-status/usr/bin` to your PATH to be able to run the installed binaries
dpkg-shlibdeps: warning: diversions involved - output may be incorrect
 diversion by libc6 from: /lib64/ld-linux-x86-64.so.2
dpkg-shlibdeps: warning: diversions involved - output may be incorrect
 diversion by libc6 to: /lib64/ld-linux-x86-64.so.2.usr-is-merged
 dpkg-genbuildinfo -O../explain-wait-status_0.1.0.ci20260709T162014-1_amd64.buildinfo
 dpkg-genchanges -O../explain-wait-status_0.1.0.ci20260709T162014-1_amd64.changes
 dpkg-source --after-build .
+ ls -l ..
+ for x in ../*.deb
+ dpkg -c ../explain-wait-status-dbgsym_0.1.0.ci20260709T162014-1_amd64.deb
+ for x in ../*.deb
+ dpkg -c ../explain-wait-status_0.1.0.ci20260709T162014-1_amd64.deb
+ mv ../explain-wait-status-dbgsym_0.1.0.ci20260709T162014-1_amd64.deb ../explain-wait-status_0.1.0.ci20260709T162014-1.debian.tar.xz ../explain-wait-status_0.1.0.ci20260709T162014-1.dsc ../explain-wait-status_0.1.0.ci20260709T162014-1_amd64.buildinfo ../explain-wait-status_0.1.0.ci20260709T162014-1_amd64.changes ../explain-wait-status_0.1.0.ci20260709T162014-1_amd64.deb ../explain-wait-status_0.1.0.ci20260709T162014.orig.tar.xz /ci/artifacts/.

  78. 86403 ms: Action succeeded: deb
    - action: deb
  packages: .

  79. 86406 ms: Execute action: tar_create
    - action: tar_create
  archive: /dev/vde
  directory: /ci/cache

  80. 87889 ms: Action succeeded: tar_create
    - action: tar_create
  archive: /dev/vde
  directory: /ci/cache

  81. 87889 ms: Execute action: tar_create
    - action: tar_create
  archive: /dev/vdd
  directory: /ci/artifacts

  82. 87903 ms: Action succeeded: tar_create
    - action: tar_create
  archive: /dev/vdd
  directory: /ci/artifacts

  83. 87903 ms: Plan succededThere was much rejoicing!
  84. 87903 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@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 modprobe@drm.service - Load Kernel Module drm.
[  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.
[  OK  ] Finished systemd-udev-trigger.service - Coldplug All udev Devices.
         Starting systemd-journal-flush.ser…sh Journal to Persistent Storage...
[  OK  ] Finished systemd-sysctl.service - Apply Kernel Variables.
[  OK  ] Finished systemd-random-seed.service - Load/Save OS Random Seed.
[  OK  ] Finished systemd-tmpfiles-setup-de…ic Device Nodes in /dev gracefully.
         Starting systemd-sysusers.service - Create System Users...
[  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.
         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  ] Finished ldconfig.service - Rebuild Dynamic Linker Cache.
         Starting systemd-update-done.service - Update is Completed...
[  OK  ] Finished systemd-update-done.service - Update is Completed.
[  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-user-sessions.service - Permit User Sessions.
[  OK  ] Finished systemd-networkd-persiste…istent Storage in systemd-networkd.
[  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.

Debian GNU/Linux 13 ambient-dev ttyS0

ambient-dev login: [  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 - Dail         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 systemd-logind.service - User Login Management.
[  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  ] 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-networkd.service - Network Configuration.
[  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.
[  OK  ] Stopped target network-pre.target - Preparation for Network.
[  OK  ] Closed systemd-networkd.socket - Network Service Netlink Socket.
         Unmounting run-lock.mount - Legacy Locks Directory /run/lock...
         Unmounting tmp.mount - Temporary Directory /tmp...
[  OK  ] Stopped systemd-network-generator.…ork Units from Kernel Command Line.
[  OK  ] Stopped systemd-tmpfiles-setup-dev…Create Static Device Nodes in /dev.
[  OK  ] Stopped systemd-resolved.service - Network Name Resolution.
[  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.
[   98.315374] 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
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   910K  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-09 16:18 ./
-rw-r--r-- _rad/_rad      1415 2026-07-09 16:19 ./plan.yaml
-rwxr-xr-x _rad/_rad   5525824 2026-07-09 16:19 ./run-ci
INFO: Extracted files:
        8      0 drwxr-xr-x   2 1000     1000           80 Jul  9 16:18 .
       10   5400 -rwxr-xr-x   1 1000     1000      5525824 Jul  9 16:19 ./run-ci
        9      4 -rw-r--r--   1 1000     1000         1415 Jul  9 16:19 ./plan.yaml
INFO: Running run-ci from /dev/vdb
================================ BEGIN ================================
{"type":"executor_starts","name":"ambient-execute-plan","version":"0.16.0@da3268d","timestamp":{"secs_since_epoch":1783613964,"nanos_since_epoch":881375243},"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_test"},{"action":"cargo_doc"},{"action":"custom","name":"dch","args":{"debfullname":"Lars Wirzenius","debemail":"liw@liw.fi"}},{"action":"deb","packages":"."},{"action":"tar_create","archive":"/dev/vde","directory":"/ci/cache"},{"action":"tar_create","archive":"/dev/vdd","directory":"/ci/artifacts"}],"executor_drive":"/dev/vdb","source_drive":"/dev/vdc","artifact_drive":"/dev/vdd","cache_drive":"/dev/vde","deps_drive":"/dev/vdf","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":1783613964,"nanos_since_epoch":882994155},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci","timestamp":{"secs_since_epoch":1783613964,"nanos_since_epoch":883554921},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci","timestamp":{"secs_since_epoch":1783613964,"nanos_since_epoch":883977098},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/artifacts","timestamp":{"secs_since_epoch":1783613964,"nanos_since_epoch":884128749},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/artifacts","timestamp":{"secs_since_epoch":1783613964,"nanos_since_epoch":888891397},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/artifacts/debian","timestamp":{"secs_since_epoch":1783613964,"nanos_since_epoch":889057843},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/artifacts/debian","timestamp":{"secs_since_epoch":1783613964,"nanos_since_epoch":889462683},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/artifacts/rsync","timestamp":{"secs_since_epoch":1783613964,"nanos_since_epoch":889666015},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/artifacts/rsync","timestamp":{"secs_since_epoch":1783613964,"nanos_since_epoch":890068000},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/secrets","timestamp":{"secs_since_epoch":1783613964,"nanos_since_epoch":890250710},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/secrets","timestamp":{"secs_since_epoch":1783613964,"nanos_since_epoch":890655909},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/deps","timestamp":{"secs_since_epoch":1783613964,"nanos_since_epoch":890836893},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/deps","timestamp":{"secs_since_epoch":1783613964,"nanos_since_epoch":891166096},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdc","directory":"/ci/src","timestamp":{"secs_since_epoch":1783613964,"nanos_since_epoch":891424804},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdc","directory":"/ci/src","timestamp":{"secs_since_epoch":1783613964,"nanos_since_epoch":968728594},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdf","directory":"/ci/deps","timestamp":{"secs_since_epoch":1783613964,"nanos_since_epoch":968983072},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdf","directory":"/ci/deps","timestamp":{"secs_since_epoch":1783613965,"nanos_since_epoch":839937986},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783613965,"nanos_since_epoch":840841838},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783613965,"nanos_since_epoch":848860916},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783613965,"nanos_since_epoch":849480026},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783613965,"nanos_since_epoch":857692253},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdg","directory":"/ci/secrets","timestamp":{"secs_since_epoch":1783613965,"nanos_since_epoch":858290974},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdg","directory":"/ci/secrets","timestamp":{"secs_since_epoch":1783613965,"nanos_since_epoch":867425840},"log_source":"Plan"}
{"type":"execute_action","action":"shell","shell":"ln -sf /ci /workspace","timestamp":{"secs_since_epoch":1783613965,"nanos_since_epoch":868112656},"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":1783613965,"nanos_since_epoch":868470270},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"","stderr":"+ ln -sf /ci /workspace\n","timestamp":{"secs_since_epoch":1783613965,"nanos_since_epoch":887256992},"log_source":"Plan"}
{"type":"action_succeeded","action":"shell","shell":"ln -sf /ci /workspace","timestamp":{"secs_since_epoch":1783613965,"nanos_since_epoch":889033208},"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":1783613965,"nanos_since_epoch":889355267},"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":1783613965,"nanos_since_epoch":890468978},"log_source":"Plan"}
{"type":"execute_action","action":"cargo_fmt","timestamp":{"secs_since_epoch":1783613965,"nanos_since_epoch":890569157},"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":1783613965,"nanos_since_epoch":890916716},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"cargo 1.96.1 (356927216 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783613965,"nanos_since_epoch":957153553},"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":1783613965,"nanos_since_epoch":960818169},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"clippy 0.1.96 (31fca3adb2 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783613966,"nanos_since_epoch":77376255},"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":1783613966,"nanos_since_epoch":78008474},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"rustc 1.96.1 (31fca3adb 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783613966,"nanos_since_epoch":107741064},"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":1783613966,"nanos_since_epoch":108378174},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"","stderr":"","timestamp":{"secs_since_epoch":1783613966,"nanos_since_epoch":198251484},"log_source":"Plan"}
{"type":"action_succeeded","action":"cargo_fmt","timestamp":{"secs_since_epoch":1783613966,"nanos_since_epoch":198909668},"log_source":"Plan"}
{"type":"execute_action","action":"cargo_clippy","timestamp":{"secs_since_epoch":1783613966,"nanos_since_epoch":199209948},"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":1783613966,"nanos_since_epoch":199221625},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"cargo 1.96.1 (356927216 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783613966,"nanos_since_epoch":228170397},"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":1783613966,"nanos_since_epoch":228854259},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"clippy 0.1.96 (31fca3adb2 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783613966,"nanos_since_epoch":268996225},"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":1783613966,"nanos_since_epoch":273156696},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"rustc 1.96.1 (31fca3adb 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783613966,"nanos_since_epoch":300603937},"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":1783613966,"nanos_since_epoch":301373887},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"","stderr":"   Compiling proc-macro2 v1.0.95\n   Compiling unicode-ident v1.0.18\n   Compiling rustix v1.0.8\n    Checking bitflags v2.9.1\n    Checking linux-raw-sys v0.9.4\n   Compiling quote v1.0.40\n   Compiling syn v2.0.104\n    Checking utf8parse v0.2.2\n    Checking anstyle-parse v0.2.7\n    Checking anstyle-query v1.1.3\n    Checking anstyle v1.0.11\n    Checking is_terminal_polyfill v1.70.1\n   Compiling serde v1.0.219\n    Checking colorchoice v1.0.4\n    Checking anstream v0.6.19\n    Checking terminal_size v0.4.2\n    Checking strsim v0.11.1\n   Compiling serde_json v1.0.141\n   Compiling heck v0.5.0\n    Checking clap_lex v0.7.5\n   Compiling libc v0.2.174\n    Checking clap_builder v4.5.41\n    Checking ryu v1.0.20\n    Checking memchr v2.7.5\n   Compiling serde_derive v1.0.219\n   Compiling clap_derive v4.5.41\n    Checking itoa v1.0.15\n    Checking clap v4.5.41\n    Checking explain-wait-status v0.1.0 (/ci/src)\n    Finished `dev` profile [unoptimized + debuginfo] target(s) in 15.48s\n","timestamp":{"secs_since_epoch":1783613981,"nanos_since_epoch":862115697},"log_source":"Plan"}
{"type":"action_succeeded","action":"cargo_clippy","timestamp":{"secs_since_epoch":1783613981,"nanos_since_epoch":862902700},"log_source":"Plan"}
{"type":"execute_action","action":"cargo_test","timestamp":{"secs_since_epoch":1783613981,"nanos_since_epoch":863188943},"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":1783613981,"nanos_since_epoch":863514653},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"cargo 1.96.1 (356927216 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783613981,"nanos_since_epoch":914220282},"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":1783613981,"nanos_since_epoch":914849293},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"clippy 0.1.96 (31fca3adb2 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783613981,"nanos_since_epoch":974634683},"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":1783613981,"nanos_since_epoch":974937614},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"rustc 1.96.1 (31fca3adb 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783613982,"nanos_since_epoch":9129580},"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":1783613982,"nanos_since_epoch":17739001},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"\nrunning 1 test\ntest test::normal_exits ... ok\n\ntest result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s\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\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":"   Compiling bitflags v2.9.1\n   Compiling utf8parse v0.2.2\n   Compiling linux-raw-sys v0.9.4\n   Compiling anstyle-parse v0.2.7\n   Compiling anstyle v1.0.11\n   Compiling rustix v1.0.8\n   Compiling colorchoice v1.0.4\n   Compiling anstyle-query v1.1.3\n   Compiling is_terminal_polyfill v1.70.1\n   Compiling anstream v0.6.19\n   Compiling clap_lex v0.7.5\n   Compiling terminal_size v0.4.2\n   Compiling strsim v0.11.1\n   Compiling serde v1.0.219\n   Compiling clap_builder v4.5.41\n   Compiling itoa v1.0.15\n   Compiling memchr v2.7.5\n   Compiling ryu v1.0.20\n   Compiling serde_json v1.0.141\n   Compiling clap v4.5.41\n   Compiling libc v0.2.174\n   Compiling explain-wait-status v0.1.0 (/ci/src)\n    Finished `test` profile [unoptimized + debuginfo] target(s) in 10.22s\n     Running unittests src/lib.rs (/ci/cache/cargo-target/debug/deps/explain_wait_status-0c5809f5e4f77e5d)\n     Running unittests src/main.rs (/ci/cache/cargo-target/debug/deps/explain_wait_status-cbbe738206f82c37)\n   Doc-tests explain_wait_status\n","timestamp":{"secs_since_epoch":1783613992,"nanos_since_epoch":342927599},"log_source":"Plan"}
{"type":"action_succeeded","action":"cargo_test","timestamp":{"secs_since_epoch":1783613992,"nanos_since_epoch":378080053},"log_source":"Plan"}
{"type":"execute_action","action":"cargo_doc","timestamp":{"secs_since_epoch":1783613992,"nanos_since_epoch":381431707},"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":1783613992,"nanos_since_epoch":384334754},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"cargo 1.96.1 (356927216 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783613992,"nanos_since_epoch":404513495},"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":1783613992,"nanos_since_epoch":408851044},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"clippy 0.1.96 (31fca3adb2 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783613992,"nanos_since_epoch":475623327},"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":1783613992,"nanos_since_epoch":476346687},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"rustc 1.96.1 (31fca3adb 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783613992,"nanos_since_epoch":510576591},"log_source":"Plan"}
{"type":"start_program","argv":[{"Unix":[101,110,118]},{"Unix":[82,85,83,84,68,79,67,70,76,65,71,83,61,45,68,32,119,97,114,110,105,110,103,115]},{"Unix":[99,97,114,103,111]},{"Unix":[100,111,99]},{"Unix":[45,45,119,111,114,107,115,112,97,99,101]}],"timestamp":{"secs_since_epoch":1783613992,"nanos_since_epoch":514886655},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"","stderr":"    Checking unicode-ident v1.0.18\n Documenting unicode-ident v1.0.18\n    Checking proc-macro2 v1.0.95\n Documenting proc-macro2 v1.0.95\n    Checking quote v1.0.40\n    Checking syn v2.0.104\n Documenting quote v1.0.40\n Documenting syn v2.0.104\n Documenting utf8parse v0.2.2\n Documenting linux-raw-sys v0.9.4\n Documenting bitflags v2.9.1\n Documenting rustix v1.0.8\n Documenting anstyle-parse v0.2.7\n Documenting anstyle v1.0.11\n Documenting colorchoice v1.0.4\n Documenting is_terminal_polyfill v1.70.1\n Documenting anstyle-query v1.1.3\n Documenting terminal_size v0.4.2\n Documenting anstream v0.6.19\n Documenting serde_derive v1.0.219\n Documenting strsim v0.11.1\n    Checking heck v0.5.0\n Documenting clap_lex v0.7.5\n Documenting heck v0.5.0\n Documenting clap_builder v4.5.41\n Documenting clap_derive v4.5.41\n Documenting serde v1.0.219\n Documenting ryu v1.0.20\n Documenting memchr v2.7.5\n Documenting itoa v1.0.15\n Documenting clap v4.5.41\n Documenting serde_json v1.0.141\n Documenting libc v0.2.174\n Documenting explain-wait-status v0.1.0 (/ci/src)\n    Finished `dev` profile [unoptimized + debuginfo] target(s) in 21.75s\n   Generated /ci/cache/cargo-target/doc/explain_wait_status/index.html\n","timestamp":{"secs_since_epoch":1783614014,"nanos_since_epoch":301413410},"log_source":"Plan"}
{"type":"action_succeeded","action":"cargo_doc","timestamp":{"secs_since_epoch":1783614014,"nanos_since_epoch":302237531},"log_source":"Plan"}
{"type":"execute_action","action":"custom","name":"dch","args":{"debfullname":"Lars Wirzenius","debemail":"liw@liw.fi"},"timestamp":{"secs_since_epoch":1783614014,"nanos_since_epoch":302527266},"log_source":"Plan"}
{"type":"custom_action_starts","source":"/ci/src","custom":{"name":"dch","args":{"debfullname":"Lars Wirzenius","debemail":"liw@liw.fi"}},"exe":".ambient/dch","exe_exists":false,"timestamp":{"secs_since_epoch":1783614014,"nanos_since_epoch":302858340},"log_source":"Plan"}
"HEAD is now at c980a21 chore: update .ambient/dch\n"
{"type":"custom_action_output","stdout":[72,69,65,68,32,105,115,32,110,111,119,32,97,116,32,99,57,56,48,97,50,49,32,99,104,111,114,101,58,32,117,112,100,97,116,101,32,46,97,109,98,105,101,110,116,47,100,99,104,10],"stderr":[43,32,101,120,112,111,114,116,32,39,68,69,66,69,77,65,73,76,61,34,108,105,119,64,108,105,119,46,102,105,34,39,10,43,32,68,69,66,69,77,65,73,76,61,39,34,108,105,119,64,108,105,119,46,102,105,34,39,10,43,32,101,120,112,111,114,116,32,39,68,69,66,70,85,76,76,78,65,77,69,61,34,76,97,114,115,32,87,105,114,122,101,110,105,117,115,34,39,10,43,32,68,69,66,70,85,76,76,78,65,77,69,61,39,34,76,97,114,115,32,87,105,114,122,101,110,105,117,115,34,39,10,43,32,101,120,112,111,114,116,32,67,65,82,71,79,95,84,65,82,71,69,84,95,68,73,82,61,47,119,111,114,107,115,112,97,99,101,47,99,97,99,104,101,10,43,32,67,65,82,71,79,95,84,65,82,71,69,84,95,68,73,82,61,47,119,111,114,107,115,112,97,99,101,47,99,97,99,104,101,10,43,32,101,120,112,111,114,116,32,67,65,82,71,79,95,72,79,77,69,61,47,119,111,114,107,115,112,97,99,101,47,100,101,112,115,10,43,32,67,65,82,71,79,95,72,79,77,69,61,47,119,111,114,107,115,112,97,99,101,47,100,101,112,115,10,43,32,101,120,112,111,114,116,32,72,79,77,69,61,47,114,111,111,116,10,43,32,72,79,77,69,61,47,114,111,111,116,10,43,32,101,120,112,111,114,116,32,80,65,84,72,61,47,114,111,111,116,47,46,99,97,114,103,111,47,98,105,110,58,47,114,111,111,116,47,46,99,97,114,103,111,47,98,105,110,58,47,117,115,114,47,108,111,99,97,108,47,115,98,105,110,58,47,117,115,114,47,108,111,99,97,108,47,98,105,110,58,47,117,115,114,47,115,98,105,110,58,47,117,115,114,47,98,105,110,10,43,32,80,65,84,72,61,47,114,111,111,116,47,46,99,97,114,103,111,47,98,105,110,58,47,114,111,111,116,47,46,99,97,114,103,111,47,98,105,110,58,47,117,115,114,47,108,111,99,97,108,47,115,98,105,110,58,47,117,115,114,47,108,111,99,97,108,47,98,105,110,58,47,117,115,114,47,115,98,105,110,58,47,117,115,114,47,98,105,110,10,43,32,103,105,116,32,114,101,115,101,116,32,45,45,104,97,114,100,10,43,32,103,105,116,32,99,108,101,97,110,32,45,102,100,120,10,43,43,32,100,112,107,103,45,112,97,114,115,101,99,104,97,110,103,101,108,111,103,32,45,83,86,101,114,115,105,111,110,10,43,43,32,115,101,100,32,39,115,47,45,91,94,45,93,42,36,47,47,39,10,43,32,86,61,48,46,49,46,48,10,43,43,32,100,97,116,101,32,45,117,32,43,37,89,37,109,37,100,84,37,72,37,77,37,83,10,43,32,84,61,50,48,50,54,48,55,48,57,84,49,54,50,48,49,52,10,43,32,118,101,114,115,105,111,110,61,48,46,49,46,48,46,99,105,50,48,50,54,48,55,48,57,84,49,54,50,48,49,52,45,49,10,43,32,100,99,104,32,45,118,32,48,46,49,46,48,46,99,105,50,48,50,54,48,55,48,57,84,49,54,50,48,49,52,45,49,32,39,67,73,32,98,117,105,108,100,32,117,110,100,101,114,32,65,109,98,105,101,110,116,46,39,10,43,32,100,99,104,32,45,114,32,39,39,10],"timestamp":{"secs_since_epoch":1783614014,"nanos_since_epoch":997240379},"log_source":"Plan"}
{"type":"action_succeeded","action":"custom","name":"dch","args":{"debfullname":"Lars Wirzenius","debemail":"liw@liw.fi"},"timestamp":{"secs_since_epoch":1783614014,"nanos_since_epoch":997405886},"log_source":"Plan"}
{"type":"execute_action","action":"deb","packages":".","timestamp":{"secs_since_epoch":1783614014,"nanos_since_epoch":997418193},"log_source":"Plan"}
{"type":"start_program","argv":[{"Unix":[47,98,105,110,47,98,97,115,104]},{"Unix":[45,99]},{"Unix":[35,33,47,117,115,114,47,98,105,110,47,101,110,118,32,98,97,115,104,10,115,101,116,32,45,120,101,117,111,32,112,105,112,101,102,97,105,108,10,10,101,99,104,111,32,34,80,65,84,72,32,97,116,32,115,116,97,114,116,58,32,36,80,65,84,72,34,10,101,120,112,111,114,116,32,80,65,84,72,61,34,47,114,111,111,116,47,46,99,97,114,103,111,47,98,105,110,58,36,80,65,84,72,34,10,101,120,112,111,114,116,32,67,65,82,71,79,95,72,79,77,69,61,47,99,105,47,100,101,112,115,10,101,120,112,111,114,116,32,68,69,66,69,77,65,73,76,61,108,105,119,64,108,105,119,46,102,105,10,101,120,112,111,114,116,32,68,69,66,70,85,76,76,78,65,77,69,61,34,76,97,114,115,32,87,105,114,122,101,110,105,117,115,34,10,47,98,105,110,47,101,110,118,10,10,99,111,109,109,97,110,100,32,45,118,32,99,97,114,103,111,10,99,111,109,109,97,110,100,32,45,118,32,114,117,115,116,99,10,10,99,97,114,103,111,32,45,45,118,101,114,115,105,111,110,10,114,117,115,116,99,32,45,45,118,101,114,115,105,111,110,10,10,35,32,71,101,116,32,110,97,109,101,32,97,110,100,32,118,101,114,115,105,111,110,32,111,102,32,115,111,117,114,99,101,32,112,97,99,107,97,103,101,46,10,110,97,109,101,61,34,36,40,100,112,107,103,45,112,97,114,115,101,99,104,97,110,103,101,108,111,103,32,45,83,83,111,117,114,99,101,41,34,10,118,101,114,115,105,111,110,61,34,36,40,100,112,107,103,45,112,97,114,115,101,99,104,97,110,103,101,108,111,103,32,45,83,86,101,114,115,105,111,110,41,34,10,10,35,32,71,101,116,32,117,112,115,116,114,101,97,109,32,118,101,114,115,105,111,110,58,32,101,118,101,114,121,116,104,105,110,103,32,98,101,102,111,114,101,32,116,104,101,32,108,97,115,116,32,100,97,115,104,46,10,117,118,61,34,36,40,101,99,104,111,32,34,36,118,101,114,115,105,111,110,34,32,124,32,115,101,100,32,39,115,47,45,91,94,45,93,42,36,47,47,39,41,34,10,10,35,32,70,105,108,101,115,32,116,104,97,116,32,119,105,108,108,32,98,101,32,99,114,101,97,116,101,100,46,10,97,114,99,104,61,34,36,40,100,112,107,103,32,45,45,112,114,105,110,116,45,97,114,99,104,105,116,101,99,116,117,114,101,41,34,10,111,114,105,103,61,34,46,46,47,36,123,110,97,109,101,125,95,36,123,117,118,125,46,111,114,105,103,46,116,97,114,46,120,122,34,10,100,101,98,61,34,46,46,47,36,123,110,97,109,101,125,95,36,123,118,101,114,115,105,111,110,125,95,36,123,97,114,99,104,125,46,100,101,98,34,10,99,104,97,110,103,101,115,61,34,46,46,47,36,123,110,97,109,101,125,95,36,123,118,101,114,115,105,111,110,125,95,36,123,97,114,99,104,125,46,99,104,97,110,103,101,115,34,10,10,35,32,67,114,101,97,116,101,32,34,117,112,115,116,114,101,97,109,32,116,97,114,98,97,108,108,34,46,10,103,105,116,32,97,114,99,104,105,118,101,32,72,69,65,68,32,124,32,120,122,32,62,34,36,111,114,105,103,34,10,10,35,32,66,117,105,108,100,32,112,97,99,107,97,103,101,46,10,100,112,107,103,45,98,117,105,108,100,112,97,99,107,97,103,101,32,45,117,115,32,45,117,99,10,10,35,32,68,117,109,112,32,115,111,109,101,32,105,110,102,111,114,109,97,116,105,111,110,32,116,111,32,109,97,107,101,32,105,116,32,101,97,115,105,101,114,32,116,111,32,118,105,115,117,97,108,108,121,32,118,101,114,105,102,121,10,35,32,101,118,101,114,121,116,104,105,110,103,32,108,111,111,107,115,32,79,75,46,32,65,108,115,111,44,32,116,101,115,116,32,116,104,101,32,112,97,99,107,97,103,101,32,119,105,116,104,32,116,104,101,32,108,105,110,116,105,97,110,32,116,111,111,108,46,10,10,108,115,32,45,108,32,46,46,10,102,111,114,32,120,32,105,110,32,46,46,47,42,46,100,101,98,59,32,100,111,32,100,112,107,103,32,45,99,32,34,36,120,34,59,32,100,111,110,101,10,35,32,70,73,88,77,69,58,32,100,105,115,97,98,108,101,100,32,119,104,105,108,101,32,116,104,105,115,32,112,114,101,118,101,110,116,115,32,114,97,100,105,99,108,101,45,110,97,116,105,118,101,45,99,105,32,100,101,98,32,102,114,111,109,32,98,101,105,110,103,32,98,117,105,108,116,46,10,35,32,108,105,110,116,105,97,110,32,45,105,32,45,45,97,108,108,111,119,45,114,111,111,116,32,45,45,102,97,105,108,45,111,110,32,119,97,114,110,105,110,103,32,46,46,47,42,46,99,104,97,110,103,101,115,10,10,35,32,77,111,118,101,32,102,105,108,101,115,32,116,111,32,97,114,116,105,102,97,99,116,115,32,100,105,114,101,99,116,111,114,121,46,10,109,118,32,46,46,47,42,95,42,32,47,99,105,47,97,114,116,105,102,97,99,116,115,47,46,10,32,32,32,32,32,32,32,32]}],"timestamp":{"secs_since_epoch":1783614014,"nanos_since_epoch":997653950},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"PATH at start: /root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin\nMEMORY_PRESSURE_WRITE=c29tZSAyMDAwMDAgMjAwMDAwMAA=\nDEBFULLNAME=Lars Wirzenius\nCARGO_TARGET_DIR=/ci/cache/cargo-target\nPWD=/ci/src\nSYSTEMD_EXEC_PID=355\nHOME=/root\nLANG=C.UTF-8\nCARGO_HOME=/ci/deps\nMEMORY_PRESSURE_WATCH=/sys/fs/cgroup/system.slice/ambient.service/memory.pressure\nDEBEMAIL=liw@liw.fi\nINVOCATION_ID=0bc5a7a21bad453ea9bb17d32f63ad6c\nUSER=root\nSHLVL=2\nJOURNAL_STREAM=9:2590\nPATH=/root/.cargo/bin:/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin\nOLDPWD=/\n_=/bin/env\n/root/.cargo/bin/cargo\n/root/.cargo/bin/rustc\ncargo 1.96.1 (356927216 2026-06-26)\nrustc 1.96.1 (31fca3adb 2026-06-26)\ndpkg-buildpackage: info: source package explain-wait-status\ndpkg-buildpackage: info: source version 0.1.0.ci20260709T162014-1\ndpkg-buildpackage: info: source distribution unstable\ndpkg-buildpackage: info: source changed by \"Lars Wirzenius\" <\"liw@liw.fi\">\ndpkg-buildpackage: info: host architecture amd64\ndh clean\n   dh_clean\ndpkg-source: info: using source format '3.0 (quilt)'\ndpkg-source: info: building explain-wait-status using existing ./explain-wait-status_0.1.0.ci20260709T162014.orig.tar.xz\ndpkg-source: info: building explain-wait-status in explain-wait-status_0.1.0.ci20260709T162014-1.debian.tar.xz\ndpkg-source: info: building explain-wait-status in explain-wait-status_0.1.0.ci20260709T162014-1.dsc\ndh binary\n   dh_update_autotools_config\n   dh_autoreconf\n   debian/rules override_dh_auto_build\nmake[1]: Entering directory '/ci/src'\ntrue\nmake[1]: Leaving directory '/ci/src'\n   create-stamp debian/debhelper-build-stamp\n   dh_prep\n   debian/rules override_dh_auto_install\nmake[1]: Entering directory '/ci/src'\ncargo install --offline --locked --path=. --root=debian/explain-wait-status/usr\nfind debian/*/ -name \".crates*\" -delete\nmake[1]: Leaving directory '/ci/src'\n   dh_installdocs\n   dh_installchangelogs\n   dh_lintian\n   dh_perl\n   dh_link\n   dh_strip_nondeterminism\n   dh_compress\n   dh_fixperms\n   dh_missing\n   dh_strip\n   dh_makeshlibs\n   dh_shlibdeps\n   dh_installdeb\n   dh_gencontrol\n   dh_md5sums\n   dh_builddeb\ndpkg-deb: building package 'explain-wait-status-dbgsym' in '../explain-wait-status-dbgsym_0.1.0.ci20260709T162014-1_amd64.deb'.\ndpkg-deb: building package 'explain-wait-status' in '../explain-wait-status_0.1.0.ci20260709T162014-1_amd64.deb'.\ndpkg-genchanges: info: including full source code in upload\ndpkg-buildpackage: info: full upload (original source is included)\ntotal 380\ndrwxr-xr-x 4 root root   4096 Jul  9 16:18 artifacts\ndrwxr-xr-x 3 root root   4096 Jul  9 16:19 cache\ndrwxr-xr-x 3 root root   4096 Jul  9 16:19 deps\n-rw-r--r-- 1 root root  38276 Jul  9 16:20 explain-wait-status-dbgsym_0.1.0.ci20260709T162014-1_amd64.deb\n-rw-r--r-- 1 root root   2168 Jul  9 16:20 explain-wait-status_0.1.0.ci20260709T162014-1.debian.tar.xz\n-rw-r--r-- 1 root root    992 Jul  9 16:20 explain-wait-status_0.1.0.ci20260709T162014-1.dsc\n-rw-r--r-- 1 root root   5351 Jul  9 16:20 explain-wait-status_0.1.0.ci20260709T162014-1_amd64.buildinfo\n-rw-r--r-- 1 root root   2601 Jul  9 16:20 explain-wait-status_0.1.0.ci20260709T162014-1_amd64.changes\n-rw-r--r-- 1 root root 298528 Jul  9 16:20 explain-wait-status_0.1.0.ci20260709T162014-1_amd64.deb\n-rw-r--r-- 1 root root   6508 Jul  9 16:20 explain-wait-status_0.1.0.ci20260709T162014.orig.tar.xz\ndrwxr-xr-x 2 root root   4096 Jul  9 16:19 secrets\ndrwxr-xr-x 7 root root   4096 Jul  9 16:20 src\ndrwxr-xr-x root/root         0 2026-07-09 16:20 ./\ndrwxr-xr-x root/root         0 2026-07-09 16:20 ./usr/\ndrwxr-xr-x root/root         0 2026-07-09 16:20 ./usr/lib/\ndrwxr-xr-x root/root         0 2026-07-09 16:20 ./usr/lib/debug/\ndrwxr-xr-x root/root         0 2026-07-09 16:20 ./usr/lib/debug/.build-id/\ndrwxr-xr-x root/root         0 2026-07-09 16:20 ./usr/lib/debug/.build-id/4a/\n-rw-r--r-- root/root    216096 2026-07-09 16:20 ./usr/lib/debug/.build-id/4a/e3fa8ef53ccca151722f6d0215169659ad0dac.debug\ndrwxr-xr-x root/root         0 2026-07-09 16:20 ./usr/share/\ndrwxr-xr-x root/root         0 2026-07-09 16:20 ./usr/share/doc/\nlrwxrwxrwx root/root         0 2026-07-09 16:20 ./usr/share/doc/explain-wait-status-dbgsym -> explain-wait-status\ndrwxr-xr-x root/root         0 2026-07-09 16:20 ./\ndrwxr-xr-x root/root         0 2026-07-09 16:20 ./usr/\ndrwxr-xr-x root/root         0 2026-07-09 16:20 ./usr/bin/\n-rwxr-xr-x root/root    836384 2026-07-09 16:20 ./usr/bin/explain-wait-status\ndrwxr-xr-x root/root         0 2026-07-09 16:20 ./usr/share/\ndrwxr-xr-x root/root         0 2026-07-09 16:20 ./usr/share/doc/\ndrwxr-xr-x root/root         0 2026-07-09 16:20 ./usr/share/doc/explain-wait-status/\n-rw-r--r-- root/root       223 2026-07-09 16:20 ./usr/share/doc/explain-wait-status/changelog.Debian.gz\n-rw-r--r-- root/root      1093 2026-07-09 16:20 ./usr/share/doc/explain-wait-status/copyright\ndrwxr-xr-x root/root         0 2026-07-09 16:20 ./usr/share/lintian/\ndrwxr-xr-x root/root         0 2026-07-09 16:20 ./usr/share/lintian/overrides/\n-rw-r--r-- root/root       101 2026-07-09 16:20 ./usr/share/lintian/overrides/explain-wait-status\n","stderr":"+ echo 'PATH at start: /root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin'\n+ export PATH=/root/.cargo/bin:/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin\n+ PATH=/root/.cargo/bin:/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin\n+ export CARGO_HOME=/ci/deps\n+ CARGO_HOME=/ci/deps\n+ export DEBEMAIL=liw@liw.fi\n+ DEBEMAIL=liw@liw.fi\n+ export 'DEBFULLNAME=Lars Wirzenius'\n+ DEBFULLNAME='Lars Wirzenius'\n+ /bin/env\n+ command -v cargo\n+ command -v rustc\n+ cargo --version\n+ rustc --version\n++ dpkg-parsechangelog -SSource\n+ name=explain-wait-status\n++ dpkg-parsechangelog -SVersion\n+ version=0.1.0.ci20260709T162014-1\n++ echo 0.1.0.ci20260709T162014-1\n++ sed 's/-[^-]*$//'\n+ uv=0.1.0.ci20260709T162014\n++ dpkg --print-architecture\n+ arch=amd64\n+ orig=../explain-wait-status_0.1.0.ci20260709T162014.orig.tar.xz\n+ deb=../explain-wait-status_0.1.0.ci20260709T162014-1_amd64.deb\n+ changes=../explain-wait-status_0.1.0.ci20260709T162014-1_amd64.changes\n+ git archive HEAD\n+ xz\n+ dpkg-buildpackage -us -uc\n dpkg-source --before-build .\n debian/rules clean\n dpkg-source -b .\n debian/rules binary\n  Installing explain-wait-status v0.1.0 (/ci/src)\n   Compiling proc-macro2 v1.0.95\n   Compiling unicode-ident v1.0.18\n   Compiling rustix v1.0.8\n   Compiling bitflags v2.9.1\n   Compiling quote v1.0.40\n   Compiling linux-raw-sys v0.9.4\n   Compiling syn v2.0.104\n   Compiling utf8parse v0.2.2\n   Compiling anstyle-parse v0.2.7\n   Compiling serde v1.0.219\n   Compiling anstyle v1.0.11\n   Compiling is_terminal_polyfill v1.70.1\n   Compiling colorchoice v1.0.4\n   Compiling anstyle-query v1.1.3\n   Compiling anstream v0.6.19\n   Compiling terminal_size v0.4.2\n   Compiling libc v0.2.174\n   Compiling clap_lex v0.7.5\n   Compiling strsim v0.11.1\n   Compiling serde_derive v1.0.219\n   Compiling serde_json v1.0.141\n   Compiling heck v0.5.0\n   Compiling clap_derive v4.5.41\n   Compiling clap_builder v4.5.41\n   Compiling itoa v1.0.15\n   Compiling ryu v1.0.20\n   Compiling memchr v2.7.5\n   Compiling clap v4.5.41\n   Compiling explain-wait-status v0.1.0 (/ci/src)\n    Finished `release` profile [optimized] target(s) in 29.90s\n  Installing /ci/src/debian/explain-wait-status/usr/bin/explain-wait-status\n   Installed package `explain-wait-status v0.1.0 (/ci/src)` (executable `explain-wait-status`)\nwarning: be sure to add `/ci/src/debian/explain-wait-status/usr/bin` to your PATH to be able to run the installed binaries\ndpkg-shlibdeps: warning: diversions involved - output may be incorrect\n diversion by libc6 from: /lib64/ld-linux-x86-64.so.2\ndpkg-shlibdeps: warning: diversions involved - output may be incorrect\n diversion by libc6 to: /lib64/ld-linux-x86-64.so.2.usr-is-merged\n dpkg-genbuildinfo -O../explain-wait-status_0.1.0.ci20260709T162014-1_amd64.buildinfo\n dpkg-genchanges -O../explain-wait-status_0.1.0.ci20260709T162014-1_amd64.changes\n dpkg-source --after-build .\n+ ls -l ..\n+ for x in ../*.deb\n+ dpkg -c ../explain-wait-status-dbgsym_0.1.0.ci20260709T162014-1_amd64.deb\n+ for x in ../*.deb\n+ dpkg -c ../explain-wait-status_0.1.0.ci20260709T162014-1_amd64.deb\n+ mv ../explain-wait-status-dbgsym_0.1.0.ci20260709T162014-1_amd64.deb ../explain-wait-status_0.1.0.ci20260709T162014-1.debian.tar.xz ../explain-wait-status_0.1.0.ci20260709T162014-1.dsc ../explain-wait-status_0.1.0.ci20260709T162014-1_amd64.buildinfo ../explain-wait-status_0.1.0.ci20260709T162014-1_amd64.changes ../explain-wait-status_0.1.0.ci20260709T162014-1_amd64.deb ../explain-wait-status_0.1.0.ci20260709T162014.orig.tar.xz /ci/artifacts/.\n","timestamp":{"secs_since_epoch":1783614051,"nanos_since_epoch":93730196},"log_source":"Plan"}
{"type":"action_succeeded","action":"deb","packages":".","timestamp":{"secs_since_epoch":1783614051,"nanos_since_epoch":285002907},"log_source":"Plan"}
{"type":"execute_action","action":"tar_create","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783614051,"nanos_since_epoch":287776304},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_create","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783614052,"nanos_since_epoch":770751285},"log_source":"Plan"}
{"type":"execute_action","action":"tar_create","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783614052,"nanos_since_epoch":771105932},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_create","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783614052,"nanos_since_epoch":784677663},"log_source":"Plan"}
{"type":"plan_succeeded","timestamp":{"secs_since_epoch":1783614052,"nanos_since_epoch":785079647},"log_source":"Plan"}
{"type":"executor_ends_successfully","timestamp":{"secs_since_epoch":1783614052,"nanos_since_epoch":785091809},"log_source":"Plan"}
EXIT CODE: 0

Post-plan VM
Structured log: all OK
  1. 0 ms: Executor starts
    • Name: ambient-execute-plan
    • Version: 0.16.0@da3268d
  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: 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. 1 ms: Execute action: mkdir: /ci/artifacts
    - action: mkdir
  pathname: /ci/artifacts

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

  29. 2883 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. 2890 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. 2897 ms: Execute action: tar_create
    - action: tar_create
  archive: /dev/vde
  directory: /ci/cache

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

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

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

  35. 4207 ms: Plan succededThere was much rejoicing!
  36. 4208 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  ] Started systemd-journald.service - Journal Service.
[  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-udev-load-credent…- Load udev Rules from Credentials.
[  OK  ] Finished systemd-remount-fs.servic…mount Root and Kernel File Systems.
[  OK  ] Reached target network-pre.target - Preparation for Network.
         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  ] Finished systemd-udev-trigger.service - Coldplug All udev Devices.
[  OK  ] Finished systemd-sysctl.service - Apply Kernel Variables.
[  OK  ] Finished systemd-random-seed.service - Load/Save OS Random Seed.
[  OK  ] Finished systemd-tmpfiles-setup-de…ic Device Nodes in /dev gracefully.
[  OK  ] Finished systemd-journal-flush.ser…lush Journal to Persistent Storage.
         Starting systemd-sysusers.service - Create System Users...
[  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  ] 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-resolved.service - Network Name Resolution.
[  OK  ] Reached target nss-lookup.target - Host and Network Name Lookups.
[  OK  ] Finished systemd-journal-catalog-u….service - Rebuild Journal Catalog.
[  OK  ] Started systemd-udevd.service - Ru…anager for Device Events and Files.
         Starting systemd-networkd.service - Network Configuration...
         Starting modprobe@configfs.service - Load Kernel Module configfs...
         Starting modprobe@fuse.service - Load Kernel Module fuse...
[  OK  ] Finished modprobe@configfs.service - Load Kernel Module configfs.
[  OK  ] Finished modprobe@fuse.service - Load Kernel Module fuse.
[  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...
         Mounting sys-fs-fuse-connections.mount - FUSE Control File System...
         Mounting sys-kernel-config.mount - Kernel Configuration 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  ] Mounted sys-fs-fuse-connections.mount - FUSE Control File System.
[  OK  ] Mounted sys-kernel-config.mount - Kernel Configuration File System.
[  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  ] Listening on systemd-rfkill.socket…ll Switch Status /dev/rfkill Watch.
[  OK  ] Started dbus.service - D-Bus System Message Bus.
[  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 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-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 tmp.mount - Temporary Directory /tmp.
[  OK  ] Unmounted run-lock.mount - Legacy Locks Directory /run/lock.
[  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.
[   15.012398] 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
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   910K  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-09 16:18 ./
-rw-r--r-- _rad/_rad      1209 2026-07-09 16:20 ./plan.yaml
-rwxr-xr-x _rad/_rad   5525824 2026-07-09 16:20 ./run-ci
INFO: Extracted files:
        8      0 drwxr-xr-x   2 1000     1000           80 Jul  9 16:18 .
       10   5400 -rwxr-xr-x   1 1000     1000      5525824 Jul  9 16:20 ./run-ci
        9      4 -rw-r--r--   1 1000     1000         1209 Jul  9 16:20 ./plan.yaml
INFO: Running run-ci from /dev/vdb
================================ BEGIN ================================
{"type":"executor_starts","name":"ambient-execute-plan","version":"0.16.0@da3268d","timestamp":{"secs_since_epoch":1783614066,"nanos_since_epoch":91465},"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":1783614066,"nanos_since_epoch":481082},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci","timestamp":{"secs_since_epoch":1783614066,"nanos_since_epoch":540503},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci","timestamp":{"secs_since_epoch":1783614066,"nanos_since_epoch":1328470},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/artifacts","timestamp":{"secs_since_epoch":1783614066,"nanos_since_epoch":1412819},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/artifacts","timestamp":{"secs_since_epoch":1783614066,"nanos_since_epoch":1819938},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/artifacts/debian","timestamp":{"secs_since_epoch":1783614066,"nanos_since_epoch":2114386},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/artifacts/debian","timestamp":{"secs_since_epoch":1783614066,"nanos_since_epoch":2274318},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/artifacts/rsync","timestamp":{"secs_since_epoch":1783614066,"nanos_since_epoch":2476933},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/artifacts/rsync","timestamp":{"secs_since_epoch":1783614066,"nanos_since_epoch":2877662},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/secrets","timestamp":{"secs_since_epoch":1783614066,"nanos_since_epoch":3185737},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/secrets","timestamp":{"secs_since_epoch":1783614066,"nanos_since_epoch":3255017},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/deps","timestamp":{"secs_since_epoch":1783614066,"nanos_since_epoch":3611369},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/deps","timestamp":{"secs_since_epoch":1783614066,"nanos_since_epoch":3660846},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdc","directory":"/ci/src","timestamp":{"secs_since_epoch":1783614066,"nanos_since_epoch":3963635},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdc","directory":"/ci/src","timestamp":{"secs_since_epoch":1783614066,"nanos_since_epoch":80873664},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdf","directory":"/ci/deps","timestamp":{"secs_since_epoch":1783614066,"nanos_since_epoch":85135007},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdf","directory":"/ci/deps","timestamp":{"secs_since_epoch":1783614066,"nanos_since_epoch":820911461},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783614066,"nanos_since_epoch":820963573},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783614068,"nanos_since_epoch":833980447},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783614068,"nanos_since_epoch":835059485},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783614068,"nanos_since_epoch":843907692},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdg","directory":"/ci/secrets","timestamp":{"secs_since_epoch":1783614068,"nanos_since_epoch":848350131},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdg","directory":"/ci/secrets","timestamp":{"secs_since_epoch":1783614068,"nanos_since_epoch":855096770},"log_source":"Plan"}
{"type":"execute_action","action":"shell","shell":"ln -sf /ci /workspace","timestamp":{"secs_since_epoch":1783614068,"nanos_since_epoch":859524986},"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":1783614068,"nanos_since_epoch":863238891},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"","stderr":"+ ln -sf /ci /workspace\n","timestamp":{"secs_since_epoch":1783614068,"nanos_since_epoch":875332417},"log_source":"Plan"}
{"type":"action_succeeded","action":"shell","shell":"ln -sf /ci /workspace","timestamp":{"secs_since_epoch":1783614068,"nanos_since_epoch":879853817},"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":1783614068,"nanos_since_epoch":883655692},"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":1783614068,"nanos_since_epoch":890567962},"log_source":"Plan"}
{"type":"execute_action","action":"tar_create","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783614068,"nanos_since_epoch":897102524},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_create","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783614070,"nanos_since_epoch":194770354},"log_source":"Plan"}
{"type":"execute_action","action":"tar_create","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783614070,"nanos_since_epoch":199455526},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_create","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783614070,"nanos_since_epoch":207974042},"log_source":"Plan"}
{"type":"plan_succeeded","timestamp":{"secs_since_epoch":1783614070,"nanos_since_epoch":208051049},"log_source":"Plan"}
{"type":"executor_ends_successfully","timestamp":{"secs_since_epoch":1783614070,"nanos_since_epoch":208373253},"log_source":"Plan"}
EXIT CODE: 0