CI run log: rad:z4ExzU1jYHivznhtDPvuTL9z5Ebit

Radicle info

Trigger message
{
  "request": "trigger",
  "version": 1,
  "event_type": "push",
  "repository": {
    "id": "rad:z4ExzU1jYHivznhtDPvuTL9z5Ebit",
    "name": "sopass",
    "description": "A command line password manager using SOP",
    "private": false,
    "default_branch": "main",
    "delegates": [
      "did:key:z6MkgEMYod7Hxfy9qCvDv5hYHkZ4ciWmLFgfvm3Wn1b2w2FV"
    ]
  },
  "pusher": {
    "id": "did:key:z6Mki2ago1X2A5UWgKpoSxyCRLLhyZMwpam4T3EKvRmFTyuy",
    "alias": "callisto.liw.fi"
  },
  "before": "5eef0cf51177d59030bf2f166b3b42d2c4bb21d0",
  "after": "5eef0cf51177d59030bf2f166b3b42d2c4bb21d0",
  "branch": "main",
  "commits": [
    "5eef0cf51177d59030bf2f166b3b42d2c4bb21d0"
  ]
}
Ambient stdout
executor from config: /usr/bin/ambient-execute-plan
executor from PATH: /usr/bin/ambient-execute-plan
run CI for rad:z4ExzU1jYHivznhtDPvuTL9z5Ebit
Ambient stderr
<empty log>

Pre-plan VM

Structured log: all OK
  1. 0 ms: Executor starts
    • Name: ambient-execute-plan
    • Version: 0.15.0@eeab732
  2. 5 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. 65 ms: Execute action: mkdir: /ci
    - action: mkdir
      pathname: /ci
    
  4. 69 ms: Action succeeded: mkdir: /ci
    - action: mkdir
      pathname: /ci
    
  5. 72 ms: Execute action: mkdir: /ci/artifacts
    - action: mkdir
      pathname: /ci/artifacts
    
  6. 78 ms: Action succeeded: mkdir: /ci/artifacts
    - action: mkdir
      pathname: /ci/artifacts
    
  7. 81 ms: Execute action: mkdir: /ci/artifacts/debian
    - action: mkdir
      pathname: /ci/artifacts/debian
    
  8. 89 ms: Action succeeded: mkdir: /ci/artifacts/debian
    - action: mkdir
      pathname: /ci/artifacts/debian
    
  9. 93 ms: Execute action: mkdir: /ci/artifacts/rsync
    - action: mkdir
      pathname: /ci/artifacts/rsync
    
  10. 96 ms: Action succeeded: mkdir: /ci/artifacts/rsync
    - action: mkdir
      pathname: /ci/artifacts/rsync
    
  11. 100 ms: Execute action: mkdir: /ci/secrets
    - action: mkdir
      pathname: /ci/secrets
    
  12. 111 ms: Action succeeded: mkdir: /ci/secrets
    - action: mkdir
      pathname: /ci/secrets
    
  13. 119 ms: Execute action: mkdir: /ci/deps
    - action: mkdir
      pathname: /ci/deps
    
  14. 127 ms: Action succeeded: mkdir: /ci/deps
    - action: mkdir
      pathname: /ci/deps
    
  15. 134 ms: Execute action: tar_extract
    - action: tar_extract
      archive: /dev/vdc
      directory: /ci/src
    
  16. 207 ms: Action succeeded: tar_extract
    - action: tar_extract
      archive: /dev/vdc
      directory: /ci/src
    
  17. 216 ms: Execute action: tar_extract
    - action: tar_extract
      archive: /dev/vdf
      directory: /ci/deps
    
  18. 229 ms: Action succeeded: tar_extract
    - action: tar_extract
      archive: /dev/vdf
      directory: /ci/deps
    
  19. 238 ms: Execute action: tar_extract
    - action: tar_extract
      archive: /dev/vde
      directory: /ci/cache
    
  20. 251 ms: Action succeeded: tar_extract
    - action: tar_extract
      archive: /dev/vde
      directory: /ci/cache
    
  21. 259 ms: Execute action: tar_extract
    - action: tar_extract
      archive: /dev/vdd
      directory: /ci/artifacts
    
  22. 288 ms: Action succeeded: tar_extract
    - action: tar_extract
      archive: /dev/vdd
      directory: /ci/artifacts
    
  23. 288 ms: Execute action: tar_extract
    - action: tar_extract
      archive: /dev/vdg
      directory: /ci/secrets
    
  24. 308 ms: Action succeeded: tar_extract
    - action: tar_extract
      archive: /dev/vdg
      directory: /ci/secrets
    
  25. 308 ms: Execute action: shell: ln -sf /ci /workspace
    - action: shell
      shell: ln -sf /ci /workspace
    
  26. 309 ms: Start program: bash
    • bash
    • -c
    • set -xeuo pipefail ln -sf /ci /workspace
  27. 330 ms: Program succeeded
    • Exit code: 0
    • Stdout
    • Stderr
      + ln -sf /ci /workspace
      
  28. 330 ms: Action succeeded: shell: ln -sf /ci /workspace
    - action: shell
      shell: ln -sf /ci /workspace
    
  29. 333 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. 334 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. 334 ms: Execute action: cargo_fetch
    - action: cargo_fetch
    
  32. 335 ms: Start program: cargo
    • cargo
    • --version
  33. 451 ms: Program succeeded
    • Exit code: 0
    • Stdout
      cargo 1.96.1 (356927216 2026-06-26)
      
    • Stderr
  34. 454 ms: Start program: cargo
    • cargo
    • clippy
    • --version
  35. 622 ms: Program succeeded
    • Exit code: 0
    • Stdout
      clippy 0.1.96 (31fca3adb2 2026-06-26)
      
    • Stderr
  36. 622 ms: Start program: rustc
    • rustc
    • --version
  37. 672 ms: Program succeeded
    • Exit code: 0
    • Stdout
      rustc 1.96.1 (31fca3adb 2026-06-26)
      
    • Stderr
  38. 690 ms: Start program: cargo
    • cargo
    • fetch
    • --locked
  39. 7039 ms: Program succeeded
    • Exit code: 0
    • Stdout
    • Stderr
          Updating crates.io index
       Downloading crates ...
        Downloaded colorchoice v1.0.4
        Downloaded dirs-sys-next v0.1.2
        Downloaded once_cell v1.21.3
        Downloaded windows-link v0.2.1
        Downloaded thiserror-impl v2.0.17
        Downloaded serde_spanned v1.0.3
        Downloaded ryu v1.0.20
        Downloaded anstyle-wincon v3.0.10
        Downloaded ppv-lite86 v0.2.21
        Downloaded directories-next v2.0.0
        Downloaded cfg-if v1.0.4
        Downloaded rand_chacha v0.3.1
        Downloaded itoa v1.0.15
        Downloaded strsim v0.11.1
        Downloaded random-number-macro-impl v0.1.8
        Downloaded fastrand v2.3.0
        Downloaded terminal_size v0.4.3
        Downloaded heck v0.5.0
        Downloaded libredox v0.1.10
        Downloaded windows-targets v0.53.5
        Downloaded rand_core v0.6.4
        Downloaded equivalent v1.0.2
        Downloaded toml_datetime v0.7.3
        Downloaded toml_writer v1.0.4
        Downloaded clap_lex v0.7.6
        Downloaded clingwrap v0.5.0
        Downloaded anstream v0.6.21
        Downloaded thiserror-impl v1.0.69
        Downloaded env_logger v0.11.8
        Downloaded anstyle-parse v0.2.7
        Downloaded getrandom v0.2.16
        Downloaded clap_derive v4.5.49
        Downloaded toml_parser v1.0.4
        Downloaded serde_json v1.0.145
        Downloaded r-efi v5.3.0
        Downloaded clap v4.5.51
        Downloaded log v0.4.28
        Downloaded indexmap v2.12.0
        Downloaded rand v0.8.5
        Downloaded wasip2 v1.0.1+wasi-0.2.4
        Downloaded clap_builder v4.5.51
        Downloaded aho-corasick v1.1.4
        Downloaded portable-atomic v1.11.1
        Downloaded hashbrown v0.16.0
        Downloaded winnow v0.7.13
        Downloaded regex v1.12.2
        Downloaded zerocopy v0.8.27
        Downloaded memchr v2.7.6
        Downloaded zerocopy-derive v0.8.27
        Downloaded serde v1.0.228
        Downloaded serde_core v1.0.228
        Downloaded syn v2.0.108
        Downloaded serde_norway v0.9.42
        Downloaded toml v0.9.8
        Downloaded regex-syntax v0.8.8
        Downloaded jiff-static v0.2.15
        Downloaded portable-atomic-util v0.2.4
        Downloaded tempfile v3.23.0
        Downloaded wit-bindgen v0.46.0
        Downloaded getrandom v0.3.4
        Downloaded proc-macro2 v1.0.103
        Downloaded random-number v0.1.9
        Downloaded unicode-ident v1.0.22
        Downloaded rustix v1.1.2
        Downloaded unsafe-libyaml-norway v0.2.15
        Downloaded serde_derive v1.0.228
        Downloaded bitflags v2.10.0
        Downloaded wasi v0.11.1+wasi-snapshot-preview1
        Downloaded anstyle v1.0.13
        Downloaded thiserror v1.0.69
        Downloaded redox_users v0.4.6
        Downloaded anstyle-query v1.1.4
        Downloaded is_terminal_polyfill v1.70.2
        Downloaded once_cell_polyfill v1.70.2
        Downloaded regex-automata v0.4.13
        Downloaded utf8parse v0.2.2
        Downloaded jiff v0.2.15
        Downloaded env_filter v0.1.4
        Downloaded proc-macro-hack v0.5.20+deprecated
        Downloaded random-pick v1.2.16
        Downloaded errno v0.3.14
        Downloaded quote v1.0.41
        Downloaded thiserror v2.0.17
        Downloaded windows_aarch64_gnullvm v0.53.1
        Downloaded windows_x86_64_gnullvm v0.53.1
        Downloaded libc v0.2.177
        Downloaded windows_i686_gnullvm v0.53.1
        Downloaded windows_x86_64_msvc v0.53.1
        Downloaded windows_aarch64_msvc v0.53.1
        Downloaded windows_i686_msvc v0.53.1
        Downloaded windows_i686_gnu v0.53.1
        Downloaded windows_x86_64_gnu v0.53.1
        Downloaded passwords v3.1.16
        Downloaded winapi v0.3.9
        Downloaded windows-sys v0.60.2
        Downloaded windows-sys v0.61.2
        Downloaded linux-raw-sys v0.11.0
        Downloaded winapi-i686-pc-windows-gnu v0.4.0
        Downloaded winapi-x86_64-pc-windows-gnu v0.4.0
      
  40. 7040 ms: Action succeeded: cargo_fetch
    - action: cargo_fetch
    
  41. 7040 ms: Execute action: tar_create
    - action: tar_create
      archive: /dev/vde
      directory: /ci/cache
    
  42. 7170 ms: Action succeeded: tar_create
    - action: tar_create
      archive: /dev/vde
      directory: /ci/cache
    
  43. 7170 ms: Execute action: tar_create
    - action: tar_create
      archive: /dev/vdd
      directory: /ci/artifacts
    
  44. 7177 ms: Action succeeded: tar_create
    - action: tar_create
      archive: /dev/vdd
      directory: /ci/artifacts
    
  45. 7183 ms: Execute action: tar_create
    - action: tar_create
      archive: /dev/vdf
      directory: /ci/deps
    
  46. 10431 ms: Action succeeded: tar_create
    - action: tar_create
      archive: /dev/vdf
      directory: /ci/deps
    
  47. 10438 ms: Plan succededThere was much rejoicing!
  48. 10442 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.
         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  ] 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  ] 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  ] 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 systemd-journal-catalog-u….service - Rebuild Journal Catalog.
[  OK  ] Finished modprobe@fuse.service - Load Kernel Module fuse.
[  OK  ] Finished modprobe@configfs.service - Load Kernel Module configfs.
[  OK  ] Found device dev-ttyS0.device - /dev/ttyS0.
         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 sys-fs-fuse-connections.mount - FUSE Control File System.
[  OK  ] Mounted 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  ] 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  ] 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  ] Started dbus.service - D-Bus System Message Bus.
[  OK  ] Finished systemd-user-sessions.service - Permit User Sessions.
[  OK  ] Started getty@tty1.service - Getty on tty1.
[  OK  ] Started serial-getty@ttyS0.service - Serial Getty on ttyS0.
[  OK  ] Reached target getty.target - Login Prompts.
[  OK  ] Finished systemd-networkd-persiste…istent Storage in systemd-networkd.
[  OK  ] Finished grub-common.service - Record successful boot for GRUB.
[  OK  ] Started systemd-logind.service - User Login Management.
[  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 - 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 systemd-logind.service - User Login Management.
[  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  ] Removed slice system-getty.slice - Slice /system/getty.
[  OK  ] Removed slice system-serial\x2dget…slice - Slice /system/serial-getty.
         Stopping systemd-user-sessions.service - Permit User Sessions...
[  OK  ] Stopped systemd-user-sessions.service - Permit User Sessions.
[  OK  ] Stopped target basic.target - Basic System.
[  OK  ] Stopped target network.target - Network.
[  OK  ] Stopped target paths.target - Path Units.
[  OK  ] Stopped systemd-ask-password-conso…equests to Console Directory Watch.
[  OK  ] Stopped systemd-ask-password-wall.…d Requests to Wall Directory Watch.
[  OK  ] Stopped target remote-fs.target - Remote File Systems.
[  OK  ] Stopped target slices.target - Slice Units.
[  OK  ] Removed slice user.slice - User and Session Slice.
[  OK  ] Stopped target sockets.target - Socket Units.
[  OK  ] Closed dbus.socket - D-Bus System Message Bus Socket.
[  OK  ] Closed sshd-unix-local.socket - Op…temd-ssh-generator, AF_UNIX Local).
[  OK  ] Closed systemd-hostnamed.socket - Hostname Service Socket.
[  OK  ] Stopped target sysinit.target - System Initialization.
         Stopping systemd-binfmt.service - Set Up Additional Binary Formats...
         Stopping systemd-networkd.service - Network Configuration...
         Stopping systemd-resolved.service - Network Name Resolution...
[  OK  ] Stopped systemd-update-done.service - Update is Completed.
[  OK  ] Stopped ldconfig.service - Rebuild Dynamic Linker Cache.
[  OK  ] Stopped systemd-journal-catalog-up….service - Rebuild Journal Catalog.
[  OK  ] Stopped systemd-tmpfiles-setup.ser…reate System Files and Directories.
[  OK  ] Stopped systemd-binfmt.service - Set Up Additional Binary Formats.
[  OK  ] Unset automount proc-sys-fs-binfmt…ormats File System Automount Point.
[  OK  ] Stopped target local-fs.target - Local File Systems.
[  OK  ] Unset automount efi.automount - EFI System Partition Automount.
[  OK  ] Stopped target local-fs-pre.target…Preparation for Local File Systems.
         Unmounting run-lock.mount - Legacy Locks Directory /run/lock...
         Unmounting tmp.mount - Temporary Directory /tmp...
[  OK  ] Stopped systemd-tmpfiles-setup-dev…Create Static Device Nodes in /dev.
[  OK  ] Stopped systemd-resolved.service - Network Name Resolution.
[  OK  ] Stopped systemd-networkd.service - Network Configuration.
[  OK  ] Stopped target network-pre.target - Preparation for Network.
[  OK  ] Closed systemd-networkd.socket - Network Service Netlink Socket.
[  OK  ] Stopped systemd-network-generator.…ork Units from Kernel Command Line.
[  OK  ] Stopped systemd-sysctl.service - Apply Kernel Variables.
[  OK  ] Stopped systemd-modules-load.service - Load Kernel Modules.
[  OK  ] Stopped systemd-sysusers.service - Create System Users.
[  OK  ] Stopped systemd-remount-fs.service…mount Root and Kernel File Systems.
[  OK  ] Stopped systemd-tmpfiles-setup-dev…ic Device Nodes in /dev gracefully.
[  OK  ] Unmounted run-lock.mount - Legacy Locks Directory /run/lock.
[  OK  ] Unmounted tmp.mount - Temporary Directory /tmp.
[  OK  ] Stopped target swap.target - Swaps.
[  OK  ] Reached target shutdown.target - System Shutdown.
[  OK  ] Reached target umount.target - Unmount All Filesystems.
[  OK  ] Reached target final.target - Late Shutdown Services.
[  OK  ] Finished systemd-poweroff.service - System Power Off.
[  OK  ] Reached target poweroff.target - System Power Off.
[   22.252482] 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   1.5M  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-03 13:09 ./
-rw-r--r-- _rad/_rad      1294 2026-07-03 13:09 ./plan.yaml
-rwxr-xr-x _rad/_rad   5517632 2026-07-03 13:09 ./run-ci
INFO: Extracted files:
        6      0 drwxr-xr-x   2 1000     1000           80 Jul  3 13:09 .
       10   5392 -rwxr-xr-x   1 1000     1000      5517632 Jul  3 13:09 ./run-ci
        9      4 -rw-r--r--   1 1000     1000         1294 Jul  3 13:09 ./plan.yaml
INFO: Running run-ci from /dev/vdb
================================ BEGIN ================================
{"type":"executor_starts","name":"ambient-execute-plan","version":"0.15.0@eeab732","timestamp":{"secs_since_epoch":1783084171,"nanos_since_epoch":98964556},"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":1783084171,"nanos_since_epoch":104924599},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci","timestamp":{"secs_since_epoch":1783084171,"nanos_since_epoch":164375851},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci","timestamp":{"secs_since_epoch":1783084171,"nanos_since_epoch":167969359},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/artifacts","timestamp":{"secs_since_epoch":1783084171,"nanos_since_epoch":171538672},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/artifacts","timestamp":{"secs_since_epoch":1783084171,"nanos_since_epoch":177100670},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/artifacts/debian","timestamp":{"secs_since_epoch":1783084171,"nanos_since_epoch":180892809},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/artifacts/debian","timestamp":{"secs_since_epoch":1783084171,"nanos_since_epoch":188394683},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/artifacts/rsync","timestamp":{"secs_since_epoch":1783084171,"nanos_since_epoch":192100832},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/artifacts/rsync","timestamp":{"secs_since_epoch":1783084171,"nanos_since_epoch":195843913},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/secrets","timestamp":{"secs_since_epoch":1783084171,"nanos_since_epoch":199675556},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/secrets","timestamp":{"secs_since_epoch":1783084171,"nanos_since_epoch":210043102},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/deps","timestamp":{"secs_since_epoch":1783084171,"nanos_since_epoch":217991528},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/deps","timestamp":{"secs_since_epoch":1783084171,"nanos_since_epoch":226207665},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdc","directory":"/ci/src","timestamp":{"secs_since_epoch":1783084171,"nanos_since_epoch":233385722},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdc","directory":"/ci/src","timestamp":{"secs_since_epoch":1783084171,"nanos_since_epoch":306769199},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdf","directory":"/ci/deps","timestamp":{"secs_since_epoch":1783084171,"nanos_since_epoch":315566664},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdf","directory":"/ci/deps","timestamp":{"secs_since_epoch":1783084171,"nanos_since_epoch":328642175},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783084171,"nanos_since_epoch":337826927},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783084171,"nanos_since_epoch":350416081},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783084171,"nanos_since_epoch":358804861},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783084171,"nanos_since_epoch":387390767},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdg","directory":"/ci/secrets","timestamp":{"secs_since_epoch":1783084171,"nanos_since_epoch":387483473},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdg","directory":"/ci/secrets","timestamp":{"secs_since_epoch":1783084171,"nanos_since_epoch":407702988},"log_source":"Plan"}
{"type":"execute_action","action":"shell","shell":"ln -sf /ci /workspace","timestamp":{"secs_since_epoch":1783084171,"nanos_since_epoch":407756644},"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":1783084171,"nanos_since_epoch":408095484},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"","stderr":"+ ln -sf /ci /workspace\n","timestamp":{"secs_since_epoch":1783084171,"nanos_since_epoch":429405217},"log_source":"Plan"}
{"type":"action_succeeded","action":"shell","shell":"ln -sf /ci /workspace","timestamp":{"secs_since_epoch":1783084171,"nanos_since_epoch":429489968},"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":1783084171,"nanos_since_epoch":432717763},"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":1783084171,"nanos_since_epoch":433532740},"log_source":"Plan"}
{"type":"execute_action","action":"cargo_fetch","timestamp":{"secs_since_epoch":1783084171,"nanos_since_epoch":433668567},"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":1783084171,"nanos_since_epoch":433995315},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"cargo 1.96.1 (356927216 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783084171,"nanos_since_epoch":550619732},"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":1783084171,"nanos_since_epoch":553725667},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"clippy 0.1.96 (31fca3adb2 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783084171,"nanos_since_epoch":721861484},"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":1783084171,"nanos_since_epoch":721941682},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"rustc 1.96.1 (31fca3adb 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783084171,"nanos_since_epoch":771925242},"log_source":"Plan"}
copying relevant files to /tmp/.tmpFSSjiW
{"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":1783084171,"nanos_since_epoch":789314156},"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 dirs-sys-next v0.1.2\n  Downloaded once_cell v1.21.3\n  Downloaded windows-link v0.2.1\n  Downloaded thiserror-impl v2.0.17\n  Downloaded serde_spanned v1.0.3\n  Downloaded ryu v1.0.20\n  Downloaded anstyle-wincon v3.0.10\n  Downloaded ppv-lite86 v0.2.21\n  Downloaded directories-next v2.0.0\n  Downloaded cfg-if v1.0.4\n  Downloaded rand_chacha v0.3.1\n  Downloaded itoa v1.0.15\n  Downloaded strsim v0.11.1\n  Downloaded random-number-macro-impl v0.1.8\n  Downloaded fastrand v2.3.0\n  Downloaded terminal_size v0.4.3\n  Downloaded heck v0.5.0\n  Downloaded libredox v0.1.10\n  Downloaded windows-targets v0.53.5\n  Downloaded rand_core v0.6.4\n  Downloaded equivalent v1.0.2\n  Downloaded toml_datetime v0.7.3\n  Downloaded toml_writer v1.0.4\n  Downloaded clap_lex v0.7.6\n  Downloaded clingwrap v0.5.0\n  Downloaded anstream v0.6.21\n  Downloaded thiserror-impl v1.0.69\n  Downloaded env_logger v0.11.8\n  Downloaded anstyle-parse v0.2.7\n  Downloaded getrandom v0.2.16\n  Downloaded clap_derive v4.5.49\n  Downloaded toml_parser v1.0.4\n  Downloaded serde_json v1.0.145\n  Downloaded r-efi v5.3.0\n  Downloaded clap v4.5.51\n  Downloaded log v0.4.28\n  Downloaded indexmap v2.12.0\n  Downloaded rand v0.8.5\n  Downloaded wasip2 v1.0.1+wasi-0.2.4\n  Downloaded clap_builder v4.5.51\n  Downloaded aho-corasick v1.1.4\n  Downloaded portable-atomic v1.11.1\n  Downloaded hashbrown v0.16.0\n  Downloaded winnow v0.7.13\n  Downloaded regex v1.12.2\n  Downloaded zerocopy v0.8.27\n  Downloaded memchr v2.7.6\n  Downloaded zerocopy-derive v0.8.27\n  Downloaded serde v1.0.228\n  Downloaded serde_core v1.0.228\n  Downloaded syn v2.0.108\n  Downloaded serde_norway v0.9.42\n  Downloaded toml v0.9.8\n  Downloaded regex-syntax v0.8.8\n  Downloaded jiff-static v0.2.15\n  Downloaded portable-atomic-util v0.2.4\n  Downloaded tempfile v3.23.0\n  Downloaded wit-bindgen v0.46.0\n  Downloaded getrandom v0.3.4\n  Downloaded proc-macro2 v1.0.103\n  Downloaded random-number v0.1.9\n  Downloaded unicode-ident v1.0.22\n  Downloaded rustix v1.1.2\n  Downloaded unsafe-libyaml-norway v0.2.15\n  Downloaded serde_derive v1.0.228\n  Downloaded bitflags v2.10.0\n  Downloaded wasi v0.11.1+wasi-snapshot-preview1\n  Downloaded anstyle v1.0.13\n  Downloaded thiserror v1.0.69\n  Downloaded redox_users v0.4.6\n  Downloaded anstyle-query v1.1.4\n  Downloaded is_terminal_polyfill v1.70.2\n  Downloaded once_cell_polyfill v1.70.2\n  Downloaded regex-automata v0.4.13\n  Downloaded utf8parse v0.2.2\n  Downloaded jiff v0.2.15\n  Downloaded env_filter v0.1.4\n  Downloaded proc-macro-hack v0.5.20+deprecated\n  Downloaded random-pick v1.2.16\n  Downloaded errno v0.3.14\n  Downloaded quote v1.0.41\n  Downloaded thiserror v2.0.17\n  Downloaded windows_aarch64_gnullvm v0.53.1\n  Downloaded windows_x86_64_gnullvm v0.53.1\n  Downloaded libc v0.2.177\n  Downloaded windows_i686_gnullvm v0.53.1\n  Downloaded windows_x86_64_msvc v0.53.1\n  Downloaded windows_aarch64_msvc v0.53.1\n  Downloaded windows_i686_msvc v0.53.1\n  Downloaded windows_i686_gnu v0.53.1\n  Downloaded windows_x86_64_gnu v0.53.1\n  Downloaded passwords v3.1.16\n  Downloaded winapi v0.3.9\n  Downloaded windows-sys v0.60.2\n  Downloaded windows-sys v0.61.2\n  Downloaded linux-raw-sys v0.11.0\n  Downloaded winapi-i686-pc-windows-gnu v0.4.0\n  Downloaded winapi-x86_64-pc-windows-gnu v0.4.0\n","timestamp":{"secs_since_epoch":1783084178,"nanos_since_epoch":138893942},"log_source":"Plan"}
{"type":"action_succeeded","action":"cargo_fetch","timestamp":{"secs_since_epoch":1783084178,"nanos_since_epoch":139289662},"log_source":"Plan"}
{"type":"execute_action","action":"tar_create","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783084178,"nanos_since_epoch":139739238},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_create","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783084178,"nanos_since_epoch":269701517},"log_source":"Plan"}
{"type":"execute_action","action":"tar_create","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783084178,"nanos_since_epoch":269759392},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_create","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783084178,"nanos_since_epoch":276775603},"log_source":"Plan"}
{"type":"execute_action","action":"tar_create","archive":"/dev/vdf","directory":"/ci/deps","timestamp":{"secs_since_epoch":1783084178,"nanos_since_epoch":282459750},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_create","archive":"/dev/vdf","directory":"/ci/deps","timestamp":{"secs_since_epoch":1783084181,"nanos_since_epoch":530294888},"log_source":"Plan"}
{"type":"plan_succeeded","timestamp":{"secs_since_epoch":1783084181,"nanos_since_epoch":537036912},"log_source":"Plan"}
{"type":"executor_ends_successfully","timestamp":{"secs_since_epoch":1783084181,"nanos_since_epoch":541032810},"log_source":"Plan"}
EXIT CODE: 0

Plan VM

Structured log: all OK
  1. 0 ms: Executor starts
    • Name: ambient-execute-plan
    • Version: 0.15.0@eeab732
  2. 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_build
    - action: shell
      shell: |
        make sopass.html userguide.html
        mkdir -p /ci/artifacts/rsync
        mv sopass.html userguide.html /ci/artifacts/rsync
    - action: shell
      shell: |
        make OFFLINE="--offline --locked"
        git clean -fdx
    - action: custom
      name: dch
      args:
        debemail: liw@liw.fi
        debfullname: Lars Wirzenius
    - action: deb
      packages: debian
    - 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. 1 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. 2 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. 2 ms: Execute action: mkdir: /ci/secrets
    - action: mkdir
      pathname: /ci/secrets
    
  12. 2 ms: Action succeeded: mkdir: /ci/secrets
    - action: mkdir
      pathname: /ci/secrets
    
  13. 2 ms: Execute action: mkdir: /ci/deps
    - action: mkdir
      pathname: /ci/deps
    
  14. 2 ms: Action succeeded: mkdir: /ci/deps
    - action: mkdir
      pathname: /ci/deps
    
  15. 2 ms: Execute action: tar_extract
    - action: tar_extract
      archive: /dev/vdc
      directory: /ci/src
    
  16. 200 ms: Action succeeded: tar_extract
    - action: tar_extract
      archive: /dev/vdc
      directory: /ci/src
    
  17. 213 ms: Execute action: tar_extract
    - action: tar_extract
      archive: /dev/vdf
      directory: /ci/deps
    
  18. 2022 ms: Action succeeded: tar_extract
    - action: tar_extract
      archive: /dev/vdf
      directory: /ci/deps
    
  19. 2025 ms: Execute action: tar_extract
    - action: tar_extract
      archive: /dev/vde
      directory: /ci/cache
    
  20. 2034 ms: Action succeeded: tar_extract
    - action: tar_extract
      archive: /dev/vde
      directory: /ci/cache
    
  21. 2038 ms: Execute action: tar_extract
    - action: tar_extract
      archive: /dev/vdd
      directory: /ci/artifacts
    
  22. 2046 ms: Action succeeded: tar_extract
    - action: tar_extract
      archive: /dev/vdd
      directory: /ci/artifacts
    
  23. 2050 ms: Execute action: tar_extract
    - action: tar_extract
      archive: /dev/vdg
      directory: /ci/secrets
    
  24. 2060 ms: Action succeeded: tar_extract
    - action: tar_extract
      archive: /dev/vdg
      directory: /ci/secrets
    
  25. 2062 ms: Execute action: shell: ln -sf /ci /workspace
    - action: shell
      shell: ln -sf /ci /workspace
    
  26. 2062 ms: Start program: bash
    • bash
    • -c
    • set -xeuo pipefail ln -sf /ci /workspace
  27. 2083 ms: Program succeeded
    • Exit code: 0
    • Stdout
    • Stderr
      + ln -sf /ci /workspace
      
  28. 2083 ms: Action succeeded: shell: ln -sf /ci /workspace
    - action: shell
      shell: ln -sf /ci /workspace
    
  29. 2084 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. 2086 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. 2086 ms: Execute action: cargo_fmt
    - action: cargo_fmt
    
  32. 2087 ms: Start program: cargo
    • cargo
    • --version
  33. 2155 ms: Program succeeded
    • Exit code: 0
    • Stdout
      cargo 1.96.1 (356927216 2026-06-26)
      
    • Stderr
  34. 2158 ms: Start program: cargo
    • cargo
    • clippy
    • --version
  35. 2265 ms: Program succeeded
    • Exit code: 0
    • Stdout
      clippy 0.1.96 (31fca3adb2 2026-06-26)
      
    • Stderr
  36. 2266 ms: Start program: rustc
    • rustc
    • --version
  37. 2314 ms: Program succeeded
    • Exit code: 0
    • Stdout
      rustc 1.96.1 (31fca3adb 2026-06-26)
      
    • Stderr
  38. 2315 ms: Start program: cargo
    • cargo
    • fmt
    • --check
  39. 2653 ms: Program succeeded
    • Exit code: 0
    • Stdout
    • Stderr
  40. 2657 ms: Action succeeded: cargo_fmt
    - action: cargo_fmt
    
  41. 2660 ms: Execute action: cargo_clippy
    - action: cargo_clippy
    
  42. 2663 ms: Start program: cargo
    • cargo
    • --version
  43. 2689 ms: Program succeeded
    • Exit code: 0
    • Stdout
      cargo 1.96.1 (356927216 2026-06-26)
      
    • Stderr
  44. 2695 ms: Start program: cargo
    • cargo
    • clippy
    • --version
  45. 2753 ms: Program succeeded
    • Exit code: 0
    • Stdout
      clippy 0.1.96 (31fca3adb2 2026-06-26)
      
    • Stderr
  46. 2754 ms: Start program: rustc
    • rustc
    • --version
  47. 2790 ms: Program succeeded
    • Exit code: 0
    • Stdout
      rustc 1.96.1 (31fca3adb 2026-06-26)
      
    • Stderr
  48. 2795 ms: Start program: cargo
    • cargo
    • clippy
    • --offline
    • --locked
    • --workspace
    • --all-targets
    • --no-deps
    • --
    • --deny
    • warnings
  49. 38529 ms: Program succeeded
    • Exit code: 0
    • Stdout
    • Stderr
         Compiling proc-macro2 v1.0.103
         Compiling unicode-ident v1.0.22
         Compiling quote v1.0.41
         Compiling libc v0.2.177
         Compiling syn v2.0.108
          Checking cfg-if v1.0.4
         Compiling serde_core v1.0.228
         Compiling zerocopy v0.8.27
          Checking memchr v2.7.6
         Compiling rustix v1.1.2
          Checking getrandom v0.2.16
          Checking linux-raw-sys v0.11.0
          Checking bitflags v2.10.0
         Compiling proc-macro-hack v0.5.20+deprecated
          Checking ppv-lite86 v0.2.21
          Checking rand_core v0.6.4
          Checking utf8parse v0.2.2
          Checking anstyle-parse v0.2.7
          Checking rand_chacha v0.3.1
          Checking aho-corasick v1.1.4
          Checking anstyle-query v1.1.4
          Checking colorchoice v1.0.4
          Checking anstyle v1.0.13
         Compiling getrandom v0.3.4
         Compiling serde v1.0.228
          Checking regex-syntax v0.8.8
          Checking is_terminal_polyfill v1.70.2
          Checking anstream v0.6.21
         Compiling random-number-macro-impl v0.1.8
          Checking rand v0.8.5
          Checking regex-automata v0.4.13
         Compiling serde_derive v1.0.228
          Checking hashbrown v0.16.0
         Compiling thiserror v2.0.17
          Checking winnow v0.7.13
         Compiling serde_json v1.0.145
          Checking itoa v1.0.15
          Checking ryu v1.0.20
          Checking equivalent v1.0.2
          Checking indexmap v2.12.0
          Checking toml_parser v1.0.4
          Checking regex v1.12.2
          Checking random-number v0.1.9
          Checking terminal_size v0.4.3
         Compiling thiserror-impl v2.0.17
          Checking serde_spanned v1.0.3
          Checking toml_datetime v0.7.3
          Checking dirs-sys-next v0.1.2
          Checking clap_lex v0.7.6
         Compiling heck v0.5.0
          Checking strsim v0.11.1
          Checking unsafe-libyaml-norway v0.2.15
          Checking log v0.4.28
          Checking once_cell v1.21.3
          Checking fastrand v2.3.0
          Checking toml_writer v1.0.4
          Checking tempfile v3.23.0
          Checking toml v0.9.8
          Checking serde_norway v0.9.42
          Checking env_filter v0.1.4
          Checking clap_builder v4.5.51
         Compiling clap_derive v4.5.49
          Checking directories-next v2.0.0
          Checking random-pick v1.2.16
          Checking jiff v0.2.15
          Checking clingwrap v0.5.0
          Checking clap v4.5.51
          Checking passwords v3.1.16
          Checking env_logger v0.11.8
          Checking sopass v0.6.0 (/ci/src)
          Finished `dev` profile [unoptimized + debuginfo] target(s) in 35.64s
      
  50. 38531 ms: Action succeeded: cargo_clippy
    - action: cargo_clippy
    
  51. 38536 ms: Execute action: cargo_build
    - action: cargo_build
    
  52. 38537 ms: Start program: cargo
    • cargo
    • --version
  53. 38623 ms: Program succeeded
    • Exit code: 0
    • Stdout
      cargo 1.96.1 (356927216 2026-06-26)
      
    • Stderr
  54. 38628 ms: Start program: cargo
    • cargo
    • clippy
    • --version
  55. 38683 ms: Program succeeded
    • Exit code: 0
    • Stdout
      clippy 0.1.96 (31fca3adb2 2026-06-26)
      
    • Stderr
  56. 38688 ms: Start program: rustc
    • rustc
    • --version
  57. 38721 ms: Program succeeded
    • Exit code: 0
    • Stdout
      rustc 1.96.1 (31fca3adb 2026-06-26)
      
    • Stderr
  58. 38722 ms: Start program: cargo
    • cargo
    • build
    • --offline
    • --locked
    • --workspace
    • --all-targets
  59. 84728 ms: Program succeeded
    • Exit code: 0
    • Stdout
    • Stderr
         Compiling libc v0.2.177
         Compiling cfg-if v1.0.4
         Compiling serde_core v1.0.228
         Compiling memchr v2.7.6
         Compiling getrandom v0.2.16
         Compiling zerocopy v0.8.27
         Compiling linux-raw-sys v0.11.0
         Compiling bitflags v2.10.0
         Compiling rustix v1.1.2
         Compiling ppv-lite86 v0.2.21
         Compiling rand_core v0.6.4
         Compiling utf8parse v0.2.2
         Compiling anstyle-parse v0.2.7
         Compiling rand_chacha v0.3.1
         Compiling aho-corasick v1.1.4
         Compiling colorchoice v1.0.4
         Compiling is_terminal_polyfill v1.70.2
         Compiling regex-syntax v0.8.8
         Compiling anstyle-query v1.1.4
         Compiling anstyle v1.0.13
         Compiling anstream v0.6.21
         Compiling regex-automata v0.4.13
         Compiling rand v0.8.5
         Compiling winnow v0.7.13
         Compiling itoa v1.0.15
         Compiling hashbrown v0.16.0
         Compiling equivalent v1.0.2
         Compiling ryu v1.0.20
         Compiling indexmap v2.12.0
         Compiling toml_parser v1.0.4
         Compiling regex v1.12.2
         Compiling serde v1.0.228
         Compiling random-number v0.1.9
         Compiling getrandom v0.3.4
         Compiling terminal_size v0.4.3
         Compiling toml_datetime v0.7.3
         Compiling serde_spanned v1.0.3
         Compiling dirs-sys-next v0.1.2
         Compiling fastrand v2.3.0
         Compiling once_cell v1.21.3
         Compiling toml_writer v1.0.4
         Compiling log v0.4.28
         Compiling unsafe-libyaml-norway v0.2.15
         Compiling strsim v0.11.1
         Compiling clap_lex v0.7.6
         Compiling clap_builder v4.5.51
         Compiling serde_norway v0.9.42
         Compiling env_filter v0.1.4
         Compiling tempfile v3.23.0
         Compiling toml v0.9.8
         Compiling directories-next v2.0.0
         Compiling thiserror v2.0.17
         Compiling random-pick v1.2.16
         Compiling serde_json v1.0.145
         Compiling jiff v0.2.15
         Compiling clingwrap v0.5.0
         Compiling passwords v3.1.16
         Compiling clap v4.5.51
         Compiling env_logger v0.11.8
         Compiling sopass v0.6.0 (/ci/src)
          Finished `dev` profile [unoptimized + debuginfo] target(s) in 45.96s
      
  60. 84729 ms: Action succeeded: cargo_build
    - action: cargo_build
    
  61. 84729 ms: Execute action: shell: make sopass.html userguide.html mkdir -p /ci/artifacts/rsync mv sopass.html userguide.html /ci/artifacts/rsync
    - action: shell
      shell: |
        make sopass.html userguide.html
        mkdir -p /ci/artifacts/rsync
        mv sopass.html userguide.html /ci/artifacts/rsync
    
  62. 84729 ms: Start program: bash
    • bash
    • -c
    • set -xeuo pipefail make sopass.html userguide.html mkdir -p /ci/artifacts/rsync mv sopass.html userguide.html /ci/artifacts/rsync
  63. 84967 ms: Program succeeded
    • Exit code: 0
    • Stdout
      subplot docgen sopass.subplot -o sopass.html
      subplot docgen doc/userguide.subplot -o userguide.html
      
    • Stderr
      + make sopass.html userguide.html
       INFO Starting Subplot
       INFO Subplot finished successfully
       INFO Starting Subplot
       INFO Subplot finished successfully
      + mkdir -p /ci/artifacts/rsync
      + mv sopass.html userguide.html /ci/artifacts/rsync
      
  64. 84987 ms: Action succeeded: shell: make sopass.html userguide.html mkdir -p /ci/artifacts/rsync mv sopass.html userguide.html /ci/artifacts/rsync
    - action: shell
      shell: |
        make sopass.html userguide.html
        mkdir -p /ci/artifacts/rsync
        mv sopass.html userguide.html /ci/artifacts/rsync
    
  65. 84997 ms: Execute action: shell: make OFFLINE="--offline --locked" git clean -fdx
    - action: shell
      shell: |
        make OFFLINE="--offline --locked"
        git clean -fdx
    
  66. 85001 ms: Start program: bash
    • bash
    • -c
    • set -xeuo pipefail make OFFLINE="--offline --locked" git clean -fdx
  67. 90196 ms: Program succeeded
    • Exit code: 0
    • Stdout
      subplot docgen sopass.subplot -o sopass.html
      subplot docgen doc/userguide.subplot -o userguide.html
      cargo clippy --offline --locked  --all-targets -- -Dwarnings
      cargo build --offline --locked  --all-targets
      cargo doc --offline --locked  --no-deps
      subplot codegen sopass.subplot -o test.py
      cargo test --offline --locked  --all-targets
      
      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
      
      cargo test --offline --locked  --doc
      
      running 0 tests
      
      test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
      
      rm -f test.log
      SOPASS_LOG=trace python3 test.py --log test.log 
      srcdir /ci/src
      datadir /tmp/tmp67kn_73o
      scenario: Manages certificates
        step 1: given an installed sopass
      bindir /ci/cache/cargo-target/debug
        step 2: given file .config/sopass/sopass.yml from config.yaml
        step 3: given file my.key
        step 4: given file other.key
        step 5: given file other.cert
        step 6: when I run sopass init --name primary --key my.key
        step 7: when I run sopass cert list
        step 8: then stdout is exactly "primary\n"
        step 9: when I run sopass cert add --name secondary --cert other.cert
        step 10: when I run sopass cert list
        step 11: then stdout contains "primary"
        step 12: then stdout contains "secondary"
        step 13: when I run mv other.key my.sopass/default.key
        step 14: when I run rm my.key
        step 15: when I run sopass cert list
        step 16: then stdout contains "primary"
        step 17: then stdout contains "secondary"
        step 18: when I run sopass cert remove primary
        step 19: when I run sopass cert list
        step 20: then stdout doesn't contain "primary"
        step 21: then stdout contains "secondary"
        step 22: when I try to run sopass cert remove secondary
        step 23: then command fails
        step 24: then stderr contains "secondary"
        step 25: when I run sopass cert list
        step 26: then stdout contains "secondary"
      scenario: Renames values
        step 1: given an installed sopass
      bindir /ci/cache/cargo-target/debug
        step 2: given file .config/sopass/sopass.yml from config.yaml
        step 3: given file my.key
        step 4: when I run sopass init --name primary --key my.key
        step 5: given file value.dat
        step 6: when I run sopass value add foo --file value.dat
        step 7: when I run sopass value add foobar --file value.dat
        step 8: when I try to run sopass value rename ghost yo
        step 9: then command fails
        step 10: then stderr contains "ghost"
        step 11: when I try to run sopass value rename foo foobar
        step 12: then command fails
        step 13: then stderr contains "foobar"
        step 14: when I run sopass value rename foo yo
        step 15: when I run sopass value list
        step 16: then stdout is exactly "foobar\nyo\n"
      scenario: Reports its version
        step 1: given an installed sopass
      bindir /ci/cache/cargo-target/debug
        step 2: given file .config/sopass/sopass.yml from config.yaml
        step 3: when I run sopass --version
        step 4: then stdout matches regex ^sopass \\d+\\.\\d+\\.\\d+$
        step 5: when I run sopass version
        step 6: then stdout matches regex ^sopass \\d+\\.\\d+\\.\\d+$
      scenario: Reports a default configuration
        step 1: given an installed sopass
      bindir /ci/cache/cargo-target/debug
        step 2: when I run sopass config
        step 3: then stdout contains ""database": "/"
        step 4: then stdout contains ""sop": ""
        step 5: then stdout contains ""key_file": ""
        step 6: then file .config/sopass/sopass.yml does not exist
      scenario: Showing value that does not exist fails
        step 1: given an installed sopass
      bindir /ci/cache/cargo-target/debug
        step 2: given file .config/sopass/sopass.yml from config.yaml
        step 3: given file my.key
        step 4: when I run sopass init --name primary --key my.key
        step 5: when I try to run sopass value show foo
        step 6: then command fails
        step 7: then stderr contains "foo"
        step 8: then stdout is exactly ""
      scenario: Imports from a file
        step 1: given an installed sopass
      bindir /ci/cache/cargo-target/debug
        step 2: given file .config/sopass/sopass.yml from config.yaml
        step 3: given file my.key
        step 4: given file value.dat
        step 5: given file yo.dat
        step 6: when I run sopass init --name primary --key my.key
        step 7: when I run sopass value add foo --file value.dat
        step 8: when I run sopass value add bar --file value.dat
        step 9: when I run sopass value add yo --file value.dat
        step 10: when I run sopass export database.json
        step 11: when I run sopass --database new init --name primary --key my.key
        step 12: when I run sopass --database new value add foo --file yo.dat
        step 13: when I run sopass --database new value add bar --file yo.dat
        step 14: when I run sopass --database new import database.json
        step 15: when I run sopass --database new value list
        step 16: then stdout contains "foo"
        step 17: then stdout contains "bar"
        step 18: then stdout contains "yo"
        step 19: when I run sopass --database new value show foo
        step 20: then stdout is exactly "bar\n"
        step 21: when I run sopass --database new value show bar
        step 22: then stdout is exactly "bar\n"
        step 23: when I run sopass --database new value show yo
        step 24: then stdout is exactly "bar\n"
      scenario: Loads specified configuration file
        step 1: given an installed sopass
      bindir /ci/cache/cargo-target/debug
        step 2: when I try to run sopass --config custom.yaml config
        step 3: then command fails
        step 4: then stderr contains "custom.yaml"
        step 5: given file custom.yaml
        step 6: when I run sopass --config custom.yaml config
        step 7: then stdout contains ""sop": "soppy""
      scenario: Loads default configuration file
        step 1: given an installed sopass
      bindir /ci/cache/cargo-target/debug
        step 2: given file .config/sopass/sopass.yml from default.yaml
        step 3: when I run env HOME=. sopass config
        step 4: then stdout contains ""database": "/over/the/rainbow""
      scenario: Initializes the password database
        step 1: given an installed sopass
      bindir /ci/cache/cargo-target/debug
        step 2: given file .config/sopass/sopass.yml from config.yaml
        step 3: given file my.key
        step 4: then directory xyzzy does not exist
        step 5: when I run sopass init --name primary --key my.key
        step 6: then file my.sopass/values.sopass exists
      scenario: Manages values
        step 1: given an installed sopass
      bindir /ci/cache/cargo-target/debug
        step 2: given file .config/sopass/sopass.yml from config.yaml
        step 3: given file my.key
        step 4: when I run sopass init --name primary --key my.key
        step 5: when I run sopass value list
        step 6: then stdout is exactly ""
        step 7: given file value.dat
        step 8: when I run sopass value add foo --file value.dat
        step 9: when I run sopass value list
        step 10: then stdout is exactly "foo\n"
        step 11: when I run sopass value show foo
        step 12: then stdout is exactly "bar\n"
        step 13: when I run sopass value remove foo
        step 14: then stdout is exactly ""
        step 15: given file add-stdin.sh
        step 16: when I run sh add-stdin.sh
        step 17: when I run sopass value list
        step 18: then stdout is exactly "foo\n"
        step 19: when I run sopass value show foo
        step 20: then stdout is exactly "bar\n"
        step 21: when I run sopass value remove foo
        step 22: then stdout is exactly ""
      scenario: Rejects unknown field in configuration file
        step 1: given an installed sopass
      bindir /ci/cache/cargo-target/debug
        step 2: given file unknown.yaml
        step 3: when I try to run sopass --config unknown.yaml config
        step 4: then command fails
        step 5: then stderr contains "unknown"
      scenario: Generates a password
        step 1: given an installed sopass
      bindir /ci/cache/cargo-target/debug
        step 2: given file .config/sopass/sopass.yml from config.yaml
        step 3: given file my.key
        step 4: when I run sopass init --name primary --key my.key
        step 5: when I run sopass value generate foo
        step 6: when I run sopass value list
        step 7: then stdout is exactly "foo\n"
        step 8: when I run sopass value show foo
        step 9: then stdout isn't exactly ""
      scenario: Exports database to file
        step 1: given an installed sopass
      bindir /ci/cache/cargo-target/debug
        step 2: given file .config/sopass/sopass.yml from config.yaml
        step 3: given file my.key
        step 4: when I run sopass init --name primary --key my.key
        step 5: given file value.dat
        step 6: when I run sopass value add foo --file value.dat
        step 7: when I run sopass export database.json
        step 8: when I run cat database.json
        step 9: then file database.json contains ""certs":"
        step 10: then file database.json contains ""primary":"
        step 11: then file database.json contains ""kv":"
        step 12: then file database.json contains ""foo":"
      OK, all scenarios finished successfully
      Removing sopass.html
      Removing test.log
      Removing test.py
      Removing userguide.html
      
    • Stderr
      + make 'OFFLINE=--offline --locked'
       INFO Starting Subplot
       INFO Subplot finished successfully
       INFO Starting Subplot
       INFO Subplot finished successfully
          Checking sopass v0.6.0 (/ci/src)
          Finished `dev` profile [unoptimized + debuginfo] target(s) in 1.29s
          Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.22s
       Documenting sopass v0.6.0 (/ci/src)
          Finished `dev` profile [unoptimized + debuginfo] target(s) in 1.45s
         Generated /ci/cache/cargo-target/doc/sopass/index.html
       INFO Starting Subplot
       INFO Subplot finished successfully
          Finished `test` profile [unoptimized + debuginfo] target(s) in 0.11s
           Running unittests src/lib.rs (/ci/cache/cargo-target/debug/deps/sopass-71e2af59a7702b52)
           Running unittests src/main.rs (/ci/cache/cargo-target/debug/deps/sopass-6626b20e3a2690a4)
          Finished `test` profile [unoptimized + debuginfo] target(s) in 0.11s
         Doc-tests sopass
      + git clean -fdx
      
  68. 90413 ms: Action succeeded: shell: make OFFLINE="--offline --locked" git clean -fdx
    - action: shell
      shell: |
        make OFFLINE="--offline --locked"
        git clean -fdx
    
  69. 90417 ms: Execute action: custom: dch
    - action: custom
      name: dch
      args:
        debemail: liw@liw.fi
        debfullname: Lars Wirzenius
    
  70. 90421 ms: Custom action starts: dch
    • Source: /ci/src
    • - name: dch
        args:
          debfullname: Lars Wirzenius
          debemail: liw@liw.fi
      
    • Executable: .ambient/dch
    • Executable exists? false
  71. 90900 ms: Custom action output
    • Stdout
      HEAD is now at 5eef0cf ci: fix for new Ambient
      
    • 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.6.0
      ++ date -u +%Y%m%dT%H%M%S
      + T=20260703T131124
      + version=0.6.0.ci20260703T131124-1
      + dch -v 0.6.0.ci20260703T131124-1 'CI build under Ambient.'
      + dch -r ''
      
  72. 90959 ms: Action succeeded: custom: dch
    - action: custom
      name: dch
      args:
        debemail: liw@liw.fi
        debfullname: Lars Wirzenius
    
  73. 90963 ms: Execute action: deb
    - action: deb
      packages: debian
    
  74. 90967 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/debian
  75. 204648 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=356
      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=596c23ec6d1847e49c6a97152d70c692
      USER=root
      SHLVL=2
      JOURNAL_STREAM=9:2446
      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 sopass
      dpkg-buildpackage: info: source version 0.6.0.ci20260703T131124-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_auto_clean
         dh_clean
      dpkg-source: info: using source format '3.0 (quilt)'
      dpkg-source: info: building sopass using existing ./sopass_0.6.0.ci20260703T131124.orig.tar.xz
      dpkg-source: info: building sopass in sopass_0.6.0.ci20260703T131124-1.debian.tar.xz
      dpkg-source: info: building sopass in sopass_0.6.0.ci20260703T131124-1.dsc
      dh binary
         dh_update_autotools_config
         dh_autoreconf
         dh_auto_configure
         debian/rules override_dh_auto_build
      make[1]: Entering directory '/ci/src'
      true
      make[1]: Leaving directory '/ci/src'
         debian/rules override_dh_auto_test
      make[1]: Entering directory '/ci/src'
      echo tests are disabled, for now
      tests are disabled, for now
      make[1]: Leaving directory '/ci/src'
         create-stamp debian/debhelper-build-stamp
         dh_prep
         debian/rules override_dh_auto_install
      make[1]: Entering directory '/ci/src'
      cargo install --offline --locked --target x86_64-unknown-linux-musl --path=. --root=debian/sopass/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 'sopass-dbgsym' in '../sopass-dbgsym_0.6.0.ci20260703T131124-1_amd64.deb'.
      dpkg-deb: building package 'sopass' in '../sopass_0.6.0.ci20260703T131124-1_amd64.deb'.
      dpkg-genchanges: info: including full source code in upload
      dpkg-buildpackage: info: full upload (original source is included)
      total 1136
      drwxr-xr-x 4 root root   4096 Jul  3 13:09 artifacts
      drwxr-xr-x 3 root root   4096 Jul  3 13:09 cache
      drwxr-xr-x 3 root root   4096 Jul  3 13:09 deps
      drwxr-xr-x 2 root root   4096 Jul  3 13:09 secrets
      -rw-r--r-- 1 root root 123984 Jul  3 13:13 sopass-dbgsym_0.6.0.ci20260703T131124-1_amd64.deb
      -rw-r--r-- 1 root root   2316 Jul  3 13:11 sopass_0.6.0.ci20260703T131124-1.debian.tar.xz
      -rw-r--r-- 1 root root    926 Jul  3 13:11 sopass_0.6.0.ci20260703T131124-1.dsc
      -rw-r--r-- 1 root root   5321 Jul  3 13:13 sopass_0.6.0.ci20260703T131124-1_amd64.buildinfo
      -rw-r--r-- 1 root root   2335 Jul  3 13:13 sopass_0.6.0.ci20260703T131124-1_amd64.changes
      -rw-r--r-- 1 root root 964480 Jul  3 13:13 sopass_0.6.0.ci20260703T131124-1_amd64.deb
      -rw-r--r-- 1 root root  28156 Jul  3 13:11 sopass_0.6.0.ci20260703T131124.orig.tar.xz
      drwxr-xr-x 8 root root   4096 Jul  3 13:11 src
      drwxr-xr-x root/root         0 2026-07-03 13:11 ./
      drwxr-xr-x root/root         0 2026-07-03 13:11 ./usr/
      drwxr-xr-x root/root         0 2026-07-03 13:11 ./usr/lib/
      drwxr-xr-x root/root         0 2026-07-03 13:11 ./usr/lib/debug/
      drwxr-xr-x root/root         0 2026-07-03 13:11 ./usr/lib/debug/.build-id/
      drwxr-xr-x root/root         0 2026-07-03 13:11 ./usr/lib/debug/.build-id/0e/
      -rw-r--r-- root/root    665968 2026-07-03 13:11 ./usr/lib/debug/.build-id/0e/09b9c34c6b7a0abd9d873098c3030c9f829db6.debug
      drwxr-xr-x root/root         0 2026-07-03 13:11 ./usr/share/
      drwxr-xr-x root/root         0 2026-07-03 13:11 ./usr/share/doc/
      lrwxrwxrwx root/root         0 2026-07-03 13:11 ./usr/share/doc/sopass-dbgsym -> sopass
      drwxr-xr-x root/root         0 2026-07-03 13:11 ./
      drwxr-xr-x root/root         0 2026-07-03 13:11 ./usr/
      drwxr-xr-x root/root         0 2026-07-03 13:11 ./usr/bin/
      -rwxr-xr-x root/root   2921304 2026-07-03 13:11 ./usr/bin/sopass
      drwxr-xr-x root/root         0 2026-07-03 13:11 ./usr/share/
      drwxr-xr-x root/root         0 2026-07-03 13:11 ./usr/share/doc/
      drwxr-xr-x root/root         0 2026-07-03 13:11 ./usr/share/doc/sopass/
      -rw-r--r-- root/root       307 2026-07-03 13:11 ./usr/share/doc/sopass/changelog.Debian.gz
      -rw-r--r-- root/root      1150 2026-07-03 13:11 ./usr/share/doc/sopass/copyright
      drwxr-xr-x root/root         0 2026-07-03 13:11 ./usr/share/lintian/
      drwxr-xr-x root/root         0 2026-07-03 13:11 ./usr/share/lintian/overrides/
      -rw-r--r-- root/root       173 2026-07-03 13:11 ./usr/share/lintian/overrides/sopass
      
    • 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=sopass
      ++ dpkg-parsechangelog -SVersion
      + version=0.6.0.ci20260703T131124-1
      ++ echo 0.6.0.ci20260703T131124-1
      ++ sed 's/-[^-]*$//'
      + uv=0.6.0.ci20260703T131124
      ++ dpkg --print-architecture
      + arch=amd64
      + orig=../sopass_0.6.0.ci20260703T131124.orig.tar.xz
      + deb=../sopass_0.6.0.ci20260703T131124-1_amd64.deb
      + changes=../sopass_0.6.0.ci20260703T131124-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 sopass v0.6.0 (/ci/src)
         Compiling proc-macro2 v1.0.103
         Compiling quote v1.0.41
         Compiling unicode-ident v1.0.22
         Compiling libc v0.2.177
         Compiling syn v2.0.108
         Compiling cfg-if v1.0.4
         Compiling serde_core v1.0.228
         Compiling zerocopy v0.8.27
         Compiling rustix v1.1.2
         Compiling memchr v2.7.6
         Compiling getrandom v0.2.16
         Compiling linux-raw-sys v0.11.0
         Compiling proc-macro-hack v0.5.20+deprecated
         Compiling bitflags v2.10.0
         Compiling ppv-lite86 v0.2.21
         Compiling rand_core v0.6.4
         Compiling utf8parse v0.2.2
         Compiling anstyle-parse v0.2.7
         Compiling rand_chacha v0.3.1
         Compiling aho-corasick v1.1.4
         Compiling regex-syntax v0.8.8
         Compiling is_terminal_polyfill v1.70.2
         Compiling colorchoice v1.0.4
         Compiling serde v1.0.228
         Compiling anstyle v1.0.13
         Compiling getrandom v0.3.4
         Compiling anstyle-query v1.1.4
         Compiling anstream v0.6.21
         Compiling regex-automata v0.4.13
         Compiling random-number-macro-impl v0.1.8
         Compiling rand v0.8.5
         Compiling serde_derive v1.0.228
         Compiling hashbrown v0.16.0
         Compiling winnow v0.7.13
         Compiling serde_json v1.0.145
         Compiling equivalent v1.0.2
         Compiling itoa v1.0.15
         Compiling thiserror v2.0.17
         Compiling ryu v1.0.20
         Compiling indexmap v2.12.0
         Compiling toml_parser v1.0.4
         Compiling regex v1.12.2
         Compiling random-number v0.1.9
         Compiling terminal_size v0.4.3
         Compiling thiserror-impl v2.0.17
         Compiling serde_spanned v1.0.3
         Compiling toml_datetime v0.7.3
         Compiling dirs-sys-next v0.1.2
         Compiling heck v0.5.0
         Compiling fastrand v2.3.0
         Compiling unsafe-libyaml-norway v0.2.15
         Compiling clap_lex v0.7.6
         Compiling log v0.4.28
         Compiling strsim v0.11.1
         Compiling toml_writer v1.0.4
         Compiling once_cell v1.21.3
         Compiling tempfile v3.23.0
         Compiling toml v0.9.8
         Compiling clap_builder v4.5.51
         Compiling serde_norway v0.9.42
         Compiling env_filter v0.1.4
         Compiling clap_derive v4.5.49
         Compiling directories-next v2.0.0
         Compiling random-pick v1.2.16
         Compiling jiff v0.2.15
         Compiling clingwrap v0.5.0
         Compiling passwords v3.1.16
         Compiling clap v4.5.51
         Compiling env_logger v0.11.8
         Compiling sopass v0.6.0 (/ci/src)
          Finished `release` profile [optimized] target(s) in 1m 46s
        Installing /ci/src/debian/sopass/usr/bin/sopass
         Installed package `sopass v0.6.0 (/ci/src)` (executable `sopass`)
      warning: be sure to add `/ci/src/debian/sopass/usr/bin` to your PATH to be able to run the installed binaries
      dpkg-shlibdeps: warning: couldn't parse dynamic symbol definition: no symbols
      dpkg-gencontrol: warning: Depends field of package sopass: substitution variable ${shlibs:Depends} used, but is not defined
      dpkg-gencontrol: warning: Depends field of package sopass: substitution variable ${shlibs:Depends} used, but is not defined
       dpkg-genbuildinfo -O../sopass_0.6.0.ci20260703T131124-1_amd64.buildinfo
       dpkg-genchanges -O../sopass_0.6.0.ci20260703T131124-1_amd64.changes
       dpkg-source --after-build .
      + ls -l ..
      + for x in ../*.deb
      + dpkg -c ../sopass-dbgsym_0.6.0.ci20260703T131124-1_amd64.deb
      + for x in ../*.deb
      + dpkg -c ../sopass_0.6.0.ci20260703T131124-1_amd64.deb
      + mv ../sopass-dbgsym_0.6.0.ci20260703T131124-1_amd64.deb ../sopass_0.6.0.ci20260703T131124-1.debian.tar.xz ../sopass_0.6.0.ci20260703T131124-1.dsc ../sopass_0.6.0.ci20260703T131124-1_amd64.buildinfo ../sopass_0.6.0.ci20260703T131124-1_amd64.changes ../sopass_0.6.0.ci20260703T131124-1_amd64.deb ../sopass_0.6.0.ci20260703T131124.orig.tar.xz /ci/artifacts/debian
      
  76. 204852 ms: Action succeeded: deb
    - action: deb
      packages: debian
    
  77. 204856 ms: Execute action: tar_create
    - action: tar_create
      archive: /dev/vde
      directory: /ci/cache
    
  78. 206946 ms: Action succeeded: tar_create
    - action: tar_create
      archive: /dev/vde
      directory: /ci/cache
    
  79. 206947 ms: Execute action: tar_create
    - action: tar_create
      archive: /dev/vdd
      directory: /ci/artifacts
    
  80. 206972 ms: Action succeeded: tar_create
    - action: tar_create
      archive: /dev/vdd
      directory: /ci/artifacts
    
  81. 206972 ms: Plan succededThere was much rejoicing!
  82. 206973 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  ] Started systemd-journald.service - Journal Service.
[  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-journal-flush.ser…sh Journal to Persistent Storage...
         Starting systemd-random-seed.service - Load/Save OS Random Seed...
         Starting systemd-sysctl.service - Apply Kernel Variables...
         Starting systemd-tmpfiles-setup-de… Device Nodes in /dev gracefully...
[  OK  ] Mounted sys-fs-fuse-connections.mount - FUSE Control File System.
[  OK  ] Mounted sys-kernel-config.mount - Kernel Configuration File System.
[  OK  ] Finished systemd-udev-trigger.service - Coldplug All udev Devices.
[  OK  ] Finished systemd-sysctl.service - Apply Kernel Variables.
[  OK  ] Finished systemd-tmpfiles-setup-de…ic Device Nodes in /dev gracefully.
[  OK  ] Finished systemd-random-seed.service - Load/Save OS Random Seed.
         Starting systemd-sysusers.service - Create System Users...
[  OK  ] Finished systemd-journal-flush.ser…lush Journal to Persistent Storage.
[  OK  ] Finished systemd-sysusers.service - Create System Users.
         Starting systemd-resolved.service - Network Name Resolution...
         Starting systemd-tmpfiles-setup-de…eate Static Device Nodes in /dev...
[  OK  ] Finished systemd-tmpfiles-setup-de…Create Static Device Nodes in /dev.
[  OK  ] Reached target local-fs-pre.target…Preparation for Local File Systems.
[  OK  ] Set up automount efi.automount - EFI System Partition Automount.
[  OK  ] Reached target local-fs.target - Local File Systems.
[  OK  ] Listening on systemd-sysext.socket… System Extension Image Management.
         Starting systemd-binfmt.service - Set Up Additional Binary Formats...
         Starting systemd-tmpfiles-setup.se…ate System Files and Directories...
         Starting systemd-udevd.service - R…ager for Device Events and Files...
[  OK  ] 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.
[  OK  ] Started systemd-resolved.service - Network Name Resolution.
[  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  ] Finished ldconfig.service - Rebuild Dynamic Linker Cache.
         Starting systemd-update-done.service - Update is Completed...
[  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 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  ] Finished grub-common.service - Record successful boot for GRUB.
[  OK  ] Listening on systemd-rfkill.socket…ll Switch Status /dev/rfkill Watch.
[  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  ] Started getty@tty1.service - Getty on tty1.
[  OK  ] Started serial-getty@ttyS0.service - Serial Getty on ttyS0.
[  OK  ] Reached target getty.target - Login Prompts.
[  OK  ] Finished systemd-networkd-persiste…istent Storage in systemd-networkd.
[  OK  ] Started ssh.service - OpenBSD Secure Shell server.

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.
[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 systemd-logind.service - User Login Management.
[  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  ] 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-resolved.service - Network Name Resolution.
[  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-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.
[  218.075971] 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   1.5M  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-03 13:09 ./
-rw-r--r-- _rad/_rad      1635 2026-07-03 13:09 ./plan.yaml
-rwxr-xr-x _rad/_rad   5517632 2026-07-03 13:09 ./run-ci
INFO: Extracted files:
        8      0 drwxr-xr-x   2 1000     1000           80 Jul  3 13:09 .
       10   5392 -rwxr-xr-x   1 1000     1000      5517632 Jul  3 13:09 ./run-ci
        9      4 -rw-r--r--   1 1000     1000         1635 Jul  3 13:09 ./plan.yaml
INFO: Running run-ci from /dev/vdb
================================ BEGIN ================================
{"type":"executor_starts","name":"ambient-execute-plan","version":"0.15.0@eeab732","timestamp":{"secs_since_epoch":1783084194,"nanos_since_epoch":318996578},"log_source":"Plan"}
{"type":"runnable_plan","steps":[{"action":"mkdir","pathname":"/ci"},{"action":"mkdir","pathname":"/ci/artifacts"},{"action":"mkdir","pathname":"/ci/artifacts/debian"},{"action":"mkdir","pathname":"/ci/artifacts/rsync"},{"action":"mkdir","pathname":"/ci/secrets"},{"action":"mkdir","pathname":"/ci/deps"},{"action":"tar_extract","archive":"/dev/vdc","directory":"/ci/src"},{"action":"tar_extract","archive":"/dev/vdf","directory":"/ci/deps"},{"action":"tar_extract","archive":"/dev/vde","directory":"/ci/cache"},{"action":"tar_extract","archive":"/dev/vdd","directory":"/ci/artifacts"},{"action":"tar_extract","archive":"/dev/vdg","directory":"/ci/secrets"},{"action":"shell","shell":"ln -sf /ci /workspace"},{"action":"create_file","filename":"/root/.ssh/config","content":"Host *\nStrictHostKeyChecking accept-new\nIdentityFile /ci/secrets/ssh_key\n                ","overwrite":true},{"action":"cargo_fmt"},{"action":"cargo_clippy"},{"action":"cargo_build"},{"action":"shell","shell":"make sopass.html userguide.html\nmkdir -p /ci/artifacts/rsync\nmv sopass.html userguide.html /ci/artifacts/rsync\n"},{"action":"shell","shell":"make OFFLINE=\"--offline --locked\"\ngit clean -fdx\n"},{"action":"custom","name":"dch","args":{"debfullname":"Lars Wirzenius","debemail":"liw@liw.fi"}},{"action":"deb","packages":"debian"},{"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":1783084194,"nanos_since_epoch":320047013},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci","timestamp":{"secs_since_epoch":1783084194,"nanos_since_epoch":320129361},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci","timestamp":{"secs_since_epoch":1783084194,"nanos_since_epoch":321346313},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/artifacts","timestamp":{"secs_since_epoch":1783084194,"nanos_since_epoch":321373244},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/artifacts","timestamp":{"secs_since_epoch":1783084194,"nanos_since_epoch":321439125},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/artifacts/debian","timestamp":{"secs_since_epoch":1783084194,"nanos_since_epoch":321448597},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/artifacts/debian","timestamp":{"secs_since_epoch":1783084194,"nanos_since_epoch":321501441},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/artifacts/rsync","timestamp":{"secs_since_epoch":1783084194,"nanos_since_epoch":321509686},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/artifacts/rsync","timestamp":{"secs_since_epoch":1783084194,"nanos_since_epoch":321556130},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/secrets","timestamp":{"secs_since_epoch":1783084194,"nanos_since_epoch":321564938},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/secrets","timestamp":{"secs_since_epoch":1783084194,"nanos_since_epoch":321613023},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/deps","timestamp":{"secs_since_epoch":1783084194,"nanos_since_epoch":321620778},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/deps","timestamp":{"secs_since_epoch":1783084194,"nanos_since_epoch":321665952},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdc","directory":"/ci/src","timestamp":{"secs_since_epoch":1783084194,"nanos_since_epoch":321674882},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdc","directory":"/ci/src","timestamp":{"secs_since_epoch":1783084194,"nanos_since_epoch":519773543},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdf","directory":"/ci/deps","timestamp":{"secs_since_epoch":1783084194,"nanos_since_epoch":532396948},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdf","directory":"/ci/deps","timestamp":{"secs_since_epoch":1783084196,"nanos_since_epoch":341205686},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783084196,"nanos_since_epoch":344969588},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783084196,"nanos_since_epoch":353216904},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783084196,"nanos_since_epoch":357836933},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783084196,"nanos_since_epoch":365245075},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdg","directory":"/ci/secrets","timestamp":{"secs_since_epoch":1783084196,"nanos_since_epoch":369063220},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdg","directory":"/ci/secrets","timestamp":{"secs_since_epoch":1783084196,"nanos_since_epoch":379354235},"log_source":"Plan"}
{"type":"execute_action","action":"shell","shell":"ln -sf /ci /workspace","timestamp":{"secs_since_epoch":1783084196,"nanos_since_epoch":381605371},"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":1783084196,"nanos_since_epoch":381915157},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"","stderr":"+ ln -sf /ci /workspace\n","timestamp":{"secs_since_epoch":1783084196,"nanos_since_epoch":402073032},"log_source":"Plan"}
{"type":"action_succeeded","action":"shell","shell":"ln -sf /ci /workspace","timestamp":{"secs_since_epoch":1783084196,"nanos_since_epoch":402791069},"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":1783084196,"nanos_since_epoch":403104023},"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":1783084196,"nanos_since_epoch":405253984},"log_source":"Plan"}
{"type":"execute_action","action":"cargo_fmt","timestamp":{"secs_since_epoch":1783084196,"nanos_since_epoch":405445131},"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":1783084196,"nanos_since_epoch":406298597},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"cargo 1.96.1 (356927216 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783084196,"nanos_since_epoch":474124214},"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":1783084196,"nanos_since_epoch":477786908},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"clippy 0.1.96 (31fca3adb2 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783084196,"nanos_since_epoch":584286525},"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":1783084196,"nanos_since_epoch":585158570},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"rustc 1.96.1 (31fca3adb 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783084196,"nanos_since_epoch":633756608},"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":1783084196,"nanos_since_epoch":634788255},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"","stderr":"","timestamp":{"secs_since_epoch":1783084196,"nanos_since_epoch":972995017},"log_source":"Plan"}
{"type":"action_succeeded","action":"cargo_fmt","timestamp":{"secs_since_epoch":1783084196,"nanos_since_epoch":976507445},"log_source":"Plan"}
{"type":"execute_action","action":"cargo_clippy","timestamp":{"secs_since_epoch":1783084196,"nanos_since_epoch":979640916},"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":1783084196,"nanos_since_epoch":982832891},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"cargo 1.96.1 (356927216 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783084197,"nanos_since_epoch":8291602},"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":1783084197,"nanos_since_epoch":14541485},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"clippy 0.1.96 (31fca3adb2 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783084197,"nanos_since_epoch":72762806},"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":1783084197,"nanos_since_epoch":73517047},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"rustc 1.96.1 (31fca3adb 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783084197,"nanos_since_epoch":109484590},"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":1783084197,"nanos_since_epoch":114228158},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"","stderr":"   Compiling proc-macro2 v1.0.103\n   Compiling unicode-ident v1.0.22\n   Compiling quote v1.0.41\n   Compiling libc v0.2.177\n   Compiling syn v2.0.108\n    Checking cfg-if v1.0.4\n   Compiling serde_core v1.0.228\n   Compiling zerocopy v0.8.27\n    Checking memchr v2.7.6\n   Compiling rustix v1.1.2\n    Checking getrandom v0.2.16\n    Checking linux-raw-sys v0.11.0\n    Checking bitflags v2.10.0\n   Compiling proc-macro-hack v0.5.20+deprecated\n    Checking ppv-lite86 v0.2.21\n    Checking rand_core v0.6.4\n    Checking utf8parse v0.2.2\n    Checking anstyle-parse v0.2.7\n    Checking rand_chacha v0.3.1\n    Checking aho-corasick v1.1.4\n    Checking anstyle-query v1.1.4\n    Checking colorchoice v1.0.4\n    Checking anstyle v1.0.13\n   Compiling getrandom v0.3.4\n   Compiling serde v1.0.228\n    Checking regex-syntax v0.8.8\n    Checking is_terminal_polyfill v1.70.2\n    Checking anstream v0.6.21\n   Compiling random-number-macro-impl v0.1.8\n    Checking rand v0.8.5\n    Checking regex-automata v0.4.13\n   Compiling serde_derive v1.0.228\n    Checking hashbrown v0.16.0\n   Compiling thiserror v2.0.17\n    Checking winnow v0.7.13\n   Compiling serde_json v1.0.145\n    Checking itoa v1.0.15\n    Checking ryu v1.0.20\n    Checking equivalent v1.0.2\n    Checking indexmap v2.12.0\n    Checking toml_parser v1.0.4\n    Checking regex v1.12.2\n    Checking random-number v0.1.9\n    Checking terminal_size v0.4.3\n   Compiling thiserror-impl v2.0.17\n    Checking serde_spanned v1.0.3\n    Checking toml_datetime v0.7.3\n    Checking dirs-sys-next v0.1.2\n    Checking clap_lex v0.7.6\n   Compiling heck v0.5.0\n    Checking strsim v0.11.1\n    Checking unsafe-libyaml-norway v0.2.15\n    Checking log v0.4.28\n    Checking once_cell v1.21.3\n    Checking fastrand v2.3.0\n    Checking toml_writer v1.0.4\n    Checking tempfile v3.23.0\n    Checking toml v0.9.8\n    Checking serde_norway v0.9.42\n    Checking env_filter v0.1.4\n    Checking clap_builder v4.5.51\n   Compiling clap_derive v4.5.49\n    Checking directories-next v2.0.0\n    Checking random-pick v1.2.16\n    Checking jiff v0.2.15\n    Checking clingwrap v0.5.0\n    Checking clap v4.5.51\n    Checking passwords v3.1.16\n    Checking env_logger v0.11.8\n    Checking sopass v0.6.0 (/ci/src)\n    Finished `dev` profile [unoptimized + debuginfo] target(s) in 35.64s\n","timestamp":{"secs_since_epoch":1783084232,"nanos_since_epoch":848963664},"log_source":"Plan"}
{"type":"action_succeeded","action":"cargo_clippy","timestamp":{"secs_since_epoch":1783084232,"nanos_since_epoch":850197522},"log_source":"Plan"}
{"type":"execute_action","action":"cargo_build","timestamp":{"secs_since_epoch":1783084232,"nanos_since_epoch":855635314},"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":1783084232,"nanos_since_epoch":856005865},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"cargo 1.96.1 (356927216 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783084232,"nanos_since_epoch":942759014},"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":1783084232,"nanos_since_epoch":947565022},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"clippy 0.1.96 (31fca3adb2 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783084233,"nanos_since_epoch":2904550},"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":1783084233,"nanos_since_epoch":7932084},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"rustc 1.96.1 (31fca3adb 2026-06-26)\n","stderr":"","timestamp":{"secs_since_epoch":1783084233,"nanos_since_epoch":40582789},"log_source":"Plan"}
{"type":"start_program","argv":[{"Unix":[99,97,114,103,111]},{"Unix":[98,117,105,108,100]},{"Unix":[45,45,111,102,102,108,105,110,101]},{"Unix":[45,45,108,111,99,107,101,100]},{"Unix":[45,45,119,111,114,107,115,112,97,99,101]},{"Unix":[45,45,97,108,108,45,116,97,114,103,101,116,115]}],"timestamp":{"secs_since_epoch":1783084233,"nanos_since_epoch":41405864},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"","stderr":"   Compiling libc v0.2.177\n   Compiling cfg-if v1.0.4\n   Compiling serde_core v1.0.228\n   Compiling memchr v2.7.6\n   Compiling getrandom v0.2.16\n   Compiling zerocopy v0.8.27\n   Compiling linux-raw-sys v0.11.0\n   Compiling bitflags v2.10.0\n   Compiling rustix v1.1.2\n   Compiling ppv-lite86 v0.2.21\n   Compiling rand_core v0.6.4\n   Compiling utf8parse v0.2.2\n   Compiling anstyle-parse v0.2.7\n   Compiling rand_chacha v0.3.1\n   Compiling aho-corasick v1.1.4\n   Compiling colorchoice v1.0.4\n   Compiling is_terminal_polyfill v1.70.2\n   Compiling regex-syntax v0.8.8\n   Compiling anstyle-query v1.1.4\n   Compiling anstyle v1.0.13\n   Compiling anstream v0.6.21\n   Compiling regex-automata v0.4.13\n   Compiling rand v0.8.5\n   Compiling winnow v0.7.13\n   Compiling itoa v1.0.15\n   Compiling hashbrown v0.16.0\n   Compiling equivalent v1.0.2\n   Compiling ryu v1.0.20\n   Compiling indexmap v2.12.0\n   Compiling toml_parser v1.0.4\n   Compiling regex v1.12.2\n   Compiling serde v1.0.228\n   Compiling random-number v0.1.9\n   Compiling getrandom v0.3.4\n   Compiling terminal_size v0.4.3\n   Compiling toml_datetime v0.7.3\n   Compiling serde_spanned v1.0.3\n   Compiling dirs-sys-next v0.1.2\n   Compiling fastrand v2.3.0\n   Compiling once_cell v1.21.3\n   Compiling toml_writer v1.0.4\n   Compiling log v0.4.28\n   Compiling unsafe-libyaml-norway v0.2.15\n   Compiling strsim v0.11.1\n   Compiling clap_lex v0.7.6\n   Compiling clap_builder v4.5.51\n   Compiling serde_norway v0.9.42\n   Compiling env_filter v0.1.4\n   Compiling tempfile v3.23.0\n   Compiling toml v0.9.8\n   Compiling directories-next v2.0.0\n   Compiling thiserror v2.0.17\n   Compiling random-pick v1.2.16\n   Compiling serde_json v1.0.145\n   Compiling jiff v0.2.15\n   Compiling clingwrap v0.5.0\n   Compiling passwords v3.1.16\n   Compiling clap v4.5.51\n   Compiling env_logger v0.11.8\n   Compiling sopass v0.6.0 (/ci/src)\n    Finished `dev` profile [unoptimized + debuginfo] target(s) in 45.96s\n","timestamp":{"secs_since_epoch":1783084279,"nanos_since_epoch":47770230},"log_source":"Plan"}
{"type":"action_succeeded","action":"cargo_build","timestamp":{"secs_since_epoch":1783084279,"nanos_since_epoch":48372109},"log_source":"Plan"}
{"type":"execute_action","action":"shell","shell":"make sopass.html userguide.html\nmkdir -p /ci/artifacts/rsync\nmv sopass.html userguide.html /ci/artifacts/rsync\n","timestamp":{"secs_since_epoch":1783084279,"nanos_since_epoch":48386107},"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,109,97,107,101,32,115,111,112,97,115,115,46,104,116,109,108,32,117,115,101,114,103,117,105,100,101,46,104,116,109,108,10,109,107,100,105,114,32,45,112,32,47,99,105,47,97,114,116,105,102,97,99,116,115,47,114,115,121,110,99,10,109,118,32,115,111,112,97,115,115,46,104,116,109,108,32,117,115,101,114,103,117,105,100,101,46,104,116,109,108,32,47,99,105,47,97,114,116,105,102,97,99,116,115,47,114,115,121,110,99,10,10]}],"timestamp":{"secs_since_epoch":1783084279,"nanos_since_epoch":48405017},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"subplot docgen sopass.subplot -o sopass.html\nsubplot docgen doc/userguide.subplot -o userguide.html\n","stderr":"+ make sopass.html userguide.html\n INFO Starting Subplot\n INFO Subplot finished successfully\n INFO Starting Subplot\n INFO Subplot finished successfully\n+ mkdir -p /ci/artifacts/rsync\n+ mv sopass.html userguide.html /ci/artifacts/rsync\n","timestamp":{"secs_since_epoch":1783084279,"nanos_since_epoch":286231095},"log_source":"Plan"}
{"type":"action_succeeded","action":"shell","shell":"make sopass.html userguide.html\nmkdir -p /ci/artifacts/rsync\nmv sopass.html userguide.html /ci/artifacts/rsync\n","timestamp":{"secs_since_epoch":1783084279,"nanos_since_epoch":306638356},"log_source":"Plan"}
{"type":"execute_action","action":"shell","shell":"make OFFLINE=\"--offline --locked\"\ngit clean -fdx\n","timestamp":{"secs_since_epoch":1783084279,"nanos_since_epoch":316200585},"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,109,97,107,101,32,79,70,70,76,73,78,69,61,34,45,45,111,102,102,108,105,110,101,32,45,45,108,111,99,107,101,100,34,10,103,105,116,32,99,108,101,97,110,32,45,102,100,120,10,10]}],"timestamp":{"secs_since_epoch":1783084279,"nanos_since_epoch":320474646},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"subplot docgen sopass.subplot -o sopass.html\nsubplot docgen doc/userguide.subplot -o userguide.html\ncargo clippy --offline --locked  --all-targets -- -Dwarnings\ncargo build --offline --locked  --all-targets\ncargo doc --offline --locked  --no-deps\nsubplot codegen sopass.subplot -o test.py\ncargo test --offline --locked  --all-targets\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\ncargo test --offline --locked  --doc\n\nrunning 0 tests\n\ntest result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s\n\nrm -f test.log\nSOPASS_LOG=trace python3 test.py --log test.log \nsrcdir /ci/src\ndatadir /tmp/tmp67kn_73o\nscenario: Manages certificates\n  step 1: given an installed sopass\nbindir /ci/cache/cargo-target/debug\n  step 2: given file .config/sopass/sopass.yml from config.yaml\n  step 3: given file my.key\n  step 4: given file other.key\n  step 5: given file other.cert\n  step 6: when I run sopass init --name primary --key my.key\n  step 7: when I run sopass cert list\n  step 8: then stdout is exactly \"primary\\n\"\n  step 9: when I run sopass cert add --name secondary --cert other.cert\n  step 10: when I run sopass cert list\n  step 11: then stdout contains \"primary\"\n  step 12: then stdout contains \"secondary\"\n  step 13: when I run mv other.key my.sopass/default.key\n  step 14: when I run rm my.key\n  step 15: when I run sopass cert list\n  step 16: then stdout contains \"primary\"\n  step 17: then stdout contains \"secondary\"\n  step 18: when I run sopass cert remove primary\n  step 19: when I run sopass cert list\n  step 20: then stdout doesn't contain \"primary\"\n  step 21: then stdout contains \"secondary\"\n  step 22: when I try to run sopass cert remove secondary\n  step 23: then command fails\n  step 24: then stderr contains \"secondary\"\n  step 25: when I run sopass cert list\n  step 26: then stdout contains \"secondary\"\nscenario: Renames values\n  step 1: given an installed sopass\nbindir /ci/cache/cargo-target/debug\n  step 2: given file .config/sopass/sopass.yml from config.yaml\n  step 3: given file my.key\n  step 4: when I run sopass init --name primary --key my.key\n  step 5: given file value.dat\n  step 6: when I run sopass value add foo --file value.dat\n  step 7: when I run sopass value add foobar --file value.dat\n  step 8: when I try to run sopass value rename ghost yo\n  step 9: then command fails\n  step 10: then stderr contains \"ghost\"\n  step 11: when I try to run sopass value rename foo foobar\n  step 12: then command fails\n  step 13: then stderr contains \"foobar\"\n  step 14: when I run sopass value rename foo yo\n  step 15: when I run sopass value list\n  step 16: then stdout is exactly \"foobar\\nyo\\n\"\nscenario: Reports its version\n  step 1: given an installed sopass\nbindir /ci/cache/cargo-target/debug\n  step 2: given file .config/sopass/sopass.yml from config.yaml\n  step 3: when I run sopass --version\n  step 4: then stdout matches regex ^sopass \\\\d+\\\\.\\\\d+\\\\.\\\\d+$\n  step 5: when I run sopass version\n  step 6: then stdout matches regex ^sopass \\\\d+\\\\.\\\\d+\\\\.\\\\d+$\nscenario: Reports a default configuration\n  step 1: given an installed sopass\nbindir /ci/cache/cargo-target/debug\n  step 2: when I run sopass config\n  step 3: then stdout contains \"\"database\": \"/\"\n  step 4: then stdout contains \"\"sop\": \"\"\n  step 5: then stdout contains \"\"key_file\": \"\"\n  step 6: then file .config/sopass/sopass.yml does not exist\nscenario: Showing value that does not exist fails\n  step 1: given an installed sopass\nbindir /ci/cache/cargo-target/debug\n  step 2: given file .config/sopass/sopass.yml from config.yaml\n  step 3: given file my.key\n  step 4: when I run sopass init --name primary --key my.key\n  step 5: when I try to run sopass value show foo\n  step 6: then command fails\n  step 7: then stderr contains \"foo\"\n  step 8: then stdout is exactly \"\"\nscenario: Imports from a file\n  step 1: given an installed sopass\nbindir /ci/cache/cargo-target/debug\n  step 2: given file .config/sopass/sopass.yml from config.yaml\n  step 3: given file my.key\n  step 4: given file value.dat\n  step 5: given file yo.dat\n  step 6: when I run sopass init --name primary --key my.key\n  step 7: when I run sopass value add foo --file value.dat\n  step 8: when I run sopass value add bar --file value.dat\n  step 9: when I run sopass value add yo --file value.dat\n  step 10: when I run sopass export database.json\n  step 11: when I run sopass --database new init --name primary --key my.key\n  step 12: when I run sopass --database new value add foo --file yo.dat\n  step 13: when I run sopass --database new value add bar --file yo.dat\n  step 14: when I run sopass --database new import database.json\n  step 15: when I run sopass --database new value list\n  step 16: then stdout contains \"foo\"\n  step 17: then stdout contains \"bar\"\n  step 18: then stdout contains \"yo\"\n  step 19: when I run sopass --database new value show foo\n  step 20: then stdout is exactly \"bar\\n\"\n  step 21: when I run sopass --database new value show bar\n  step 22: then stdout is exactly \"bar\\n\"\n  step 23: when I run sopass --database new value show yo\n  step 24: then stdout is exactly \"bar\\n\"\nscenario: Loads specified configuration file\n  step 1: given an installed sopass\nbindir /ci/cache/cargo-target/debug\n  step 2: when I try to run sopass --config custom.yaml config\n  step 3: then command fails\n  step 4: then stderr contains \"custom.yaml\"\n  step 5: given file custom.yaml\n  step 6: when I run sopass --config custom.yaml config\n  step 7: then stdout contains \"\"sop\": \"soppy\"\"\nscenario: Loads default configuration file\n  step 1: given an installed sopass\nbindir /ci/cache/cargo-target/debug\n  step 2: given file .config/sopass/sopass.yml from default.yaml\n  step 3: when I run env HOME=. sopass config\n  step 4: then stdout contains \"\"database\": \"/over/the/rainbow\"\"\nscenario: Initializes the password database\n  step 1: given an installed sopass\nbindir /ci/cache/cargo-target/debug\n  step 2: given file .config/sopass/sopass.yml from config.yaml\n  step 3: given file my.key\n  step 4: then directory xyzzy does not exist\n  step 5: when I run sopass init --name primary --key my.key\n  step 6: then file my.sopass/values.sopass exists\nscenario: Manages values\n  step 1: given an installed sopass\nbindir /ci/cache/cargo-target/debug\n  step 2: given file .config/sopass/sopass.yml from config.yaml\n  step 3: given file my.key\n  step 4: when I run sopass init --name primary --key my.key\n  step 5: when I run sopass value list\n  step 6: then stdout is exactly \"\"\n  step 7: given file value.dat\n  step 8: when I run sopass value add foo --file value.dat\n  step 9: when I run sopass value list\n  step 10: then stdout is exactly \"foo\\n\"\n  step 11: when I run sopass value show foo\n  step 12: then stdout is exactly \"bar\\n\"\n  step 13: when I run sopass value remove foo\n  step 14: then stdout is exactly \"\"\n  step 15: given file add-stdin.sh\n  step 16: when I run sh add-stdin.sh\n  step 17: when I run sopass value list\n  step 18: then stdout is exactly \"foo\\n\"\n  step 19: when I run sopass value show foo\n  step 20: then stdout is exactly \"bar\\n\"\n  step 21: when I run sopass value remove foo\n  step 22: then stdout is exactly \"\"\nscenario: Rejects unknown field in configuration file\n  step 1: given an installed sopass\nbindir /ci/cache/cargo-target/debug\n  step 2: given file unknown.yaml\n  step 3: when I try to run sopass --config unknown.yaml config\n  step 4: then command fails\n  step 5: then stderr contains \"unknown\"\nscenario: Generates a password\n  step 1: given an installed sopass\nbindir /ci/cache/cargo-target/debug\n  step 2: given file .config/sopass/sopass.yml from config.yaml\n  step 3: given file my.key\n  step 4: when I run sopass init --name primary --key my.key\n  step 5: when I run sopass value generate foo\n  step 6: when I run sopass value list\n  step 7: then stdout is exactly \"foo\\n\"\n  step 8: when I run sopass value show foo\n  step 9: then stdout isn't exactly \"\"\nscenario: Exports database to file\n  step 1: given an installed sopass\nbindir /ci/cache/cargo-target/debug\n  step 2: given file .config/sopass/sopass.yml from config.yaml\n  step 3: given file my.key\n  step 4: when I run sopass init --name primary --key my.key\n  step 5: given file value.dat\n  step 6: when I run sopass value add foo --file value.dat\n  step 7: when I run sopass export database.json\n  step 8: when I run cat database.json\n  step 9: then file database.json contains \"\"certs\":\"\n  step 10: then file database.json contains \"\"primary\":\"\n  step 11: then file database.json contains \"\"kv\":\"\n  step 12: then file database.json contains \"\"foo\":\"\nOK, all scenarios finished successfully\nRemoving sopass.html\nRemoving test.log\nRemoving test.py\nRemoving userguide.html\n","stderr":"+ make 'OFFLINE=--offline --locked'\n INFO Starting Subplot\n INFO Subplot finished successfully\n INFO Starting Subplot\n INFO Subplot finished successfully\n    Checking sopass v0.6.0 (/ci/src)\n    Finished `dev` profile [unoptimized + debuginfo] target(s) in 1.29s\n    Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.22s\n Documenting sopass v0.6.0 (/ci/src)\n    Finished `dev` profile [unoptimized + debuginfo] target(s) in 1.45s\n   Generated /ci/cache/cargo-target/doc/sopass/index.html\n INFO Starting Subplot\n INFO Subplot finished successfully\n    Finished `test` profile [unoptimized + debuginfo] target(s) in 0.11s\n     Running unittests src/lib.rs (/ci/cache/cargo-target/debug/deps/sopass-71e2af59a7702b52)\n     Running unittests src/main.rs (/ci/cache/cargo-target/debug/deps/sopass-6626b20e3a2690a4)\n    Finished `test` profile [unoptimized + debuginfo] target(s) in 0.11s\n   Doc-tests sopass\n+ git clean -fdx\n","timestamp":{"secs_since_epoch":1783084284,"nanos_since_epoch":515290454},"log_source":"Plan"}
{"type":"action_succeeded","action":"shell","shell":"make OFFLINE=\"--offline --locked\"\ngit clean -fdx\n","timestamp":{"secs_since_epoch":1783084284,"nanos_since_epoch":732883738},"log_source":"Plan"}
{"type":"execute_action","action":"custom","name":"dch","args":{"debfullname":"Lars Wirzenius","debemail":"liw@liw.fi"},"timestamp":{"secs_since_epoch":1783084284,"nanos_since_epoch":736826820},"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":1783084284,"nanos_since_epoch":740974592},"log_source":"Plan"}
"HEAD is now at 5eef0cf ci: fix for new Ambient\n"
{"type":"custom_action_output","stdout":[72,69,65,68,32,105,115,32,110,111,119,32,97,116,32,53,101,101,102,48,99,102,32,99,105,58,32,102,105,120,32,102,111,114,32,110,101,119,32,65,109,98,105,101,110,116,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,54,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,51,84,49,51,49,49,50,52,10,43,32,118,101,114,115,105,111,110,61,48,46,54,46,48,46,99,105,50,48,50,54,48,55,48,51,84,49,51,49,49,50,52,45,49,10,43,32,100,99,104,32,45,118,32,48,46,54,46,48,46,99,105,50,48,50,54,48,55,48,51,84,49,51,49,49,50,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":1783084285,"nanos_since_epoch":219835503},"log_source":"Plan"}
{"type":"action_succeeded","action":"custom","name":"dch","args":{"debfullname":"Lars Wirzenius","debemail":"liw@liw.fi"},"timestamp":{"secs_since_epoch":1783084285,"nanos_since_epoch":278303228},"log_source":"Plan"}
{"type":"execute_action","action":"deb","packages":"debian","timestamp":{"secs_since_epoch":1783084285,"nanos_since_epoch":282847684},"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,100,101,98,105,97,110,10,32,32,32,32,32,32,32,32]}],"timestamp":{"secs_since_epoch":1783084285,"nanos_since_epoch":286284476},"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=356\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=596c23ec6d1847e49c6a97152d70c692\nUSER=root\nSHLVL=2\nJOURNAL_STREAM=9:2446\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 sopass\ndpkg-buildpackage: info: source version 0.6.0.ci20260703T131124-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_auto_clean\n   dh_clean\ndpkg-source: info: using source format '3.0 (quilt)'\ndpkg-source: info: building sopass using existing ./sopass_0.6.0.ci20260703T131124.orig.tar.xz\ndpkg-source: info: building sopass in sopass_0.6.0.ci20260703T131124-1.debian.tar.xz\ndpkg-source: info: building sopass in sopass_0.6.0.ci20260703T131124-1.dsc\ndh binary\n   dh_update_autotools_config\n   dh_autoreconf\n   dh_auto_configure\n   debian/rules override_dh_auto_build\nmake[1]: Entering directory '/ci/src'\ntrue\nmake[1]: Leaving directory '/ci/src'\n   debian/rules override_dh_auto_test\nmake[1]: Entering directory '/ci/src'\necho tests are disabled, for now\ntests are disabled, for now\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 --target x86_64-unknown-linux-musl --path=. --root=debian/sopass/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 'sopass-dbgsym' in '../sopass-dbgsym_0.6.0.ci20260703T131124-1_amd64.deb'.\ndpkg-deb: building package 'sopass' in '../sopass_0.6.0.ci20260703T131124-1_amd64.deb'.\ndpkg-genchanges: info: including full source code in upload\ndpkg-buildpackage: info: full upload (original source is included)\ntotal 1136\ndrwxr-xr-x 4 root root   4096 Jul  3 13:09 artifacts\ndrwxr-xr-x 3 root root   4096 Jul  3 13:09 cache\ndrwxr-xr-x 3 root root   4096 Jul  3 13:09 deps\ndrwxr-xr-x 2 root root   4096 Jul  3 13:09 secrets\n-rw-r--r-- 1 root root 123984 Jul  3 13:13 sopass-dbgsym_0.6.0.ci20260703T131124-1_amd64.deb\n-rw-r--r-- 1 root root   2316 Jul  3 13:11 sopass_0.6.0.ci20260703T131124-1.debian.tar.xz\n-rw-r--r-- 1 root root    926 Jul  3 13:11 sopass_0.6.0.ci20260703T131124-1.dsc\n-rw-r--r-- 1 root root   5321 Jul  3 13:13 sopass_0.6.0.ci20260703T131124-1_amd64.buildinfo\n-rw-r--r-- 1 root root   2335 Jul  3 13:13 sopass_0.6.0.ci20260703T131124-1_amd64.changes\n-rw-r--r-- 1 root root 964480 Jul  3 13:13 sopass_0.6.0.ci20260703T131124-1_amd64.deb\n-rw-r--r-- 1 root root  28156 Jul  3 13:11 sopass_0.6.0.ci20260703T131124.orig.tar.xz\ndrwxr-xr-x 8 root root   4096 Jul  3 13:11 src\ndrwxr-xr-x root/root         0 2026-07-03 13:11 ./\ndrwxr-xr-x root/root         0 2026-07-03 13:11 ./usr/\ndrwxr-xr-x root/root         0 2026-07-03 13:11 ./usr/lib/\ndrwxr-xr-x root/root         0 2026-07-03 13:11 ./usr/lib/debug/\ndrwxr-xr-x root/root         0 2026-07-03 13:11 ./usr/lib/debug/.build-id/\ndrwxr-xr-x root/root         0 2026-07-03 13:11 ./usr/lib/debug/.build-id/0e/\n-rw-r--r-- root/root    665968 2026-07-03 13:11 ./usr/lib/debug/.build-id/0e/09b9c34c6b7a0abd9d873098c3030c9f829db6.debug\ndrwxr-xr-x root/root         0 2026-07-03 13:11 ./usr/share/\ndrwxr-xr-x root/root         0 2026-07-03 13:11 ./usr/share/doc/\nlrwxrwxrwx root/root         0 2026-07-03 13:11 ./usr/share/doc/sopass-dbgsym -> sopass\ndrwxr-xr-x root/root         0 2026-07-03 13:11 ./\ndrwxr-xr-x root/root         0 2026-07-03 13:11 ./usr/\ndrwxr-xr-x root/root         0 2026-07-03 13:11 ./usr/bin/\n-rwxr-xr-x root/root   2921304 2026-07-03 13:11 ./usr/bin/sopass\ndrwxr-xr-x root/root         0 2026-07-03 13:11 ./usr/share/\ndrwxr-xr-x root/root         0 2026-07-03 13:11 ./usr/share/doc/\ndrwxr-xr-x root/root         0 2026-07-03 13:11 ./usr/share/doc/sopass/\n-rw-r--r-- root/root       307 2026-07-03 13:11 ./usr/share/doc/sopass/changelog.Debian.gz\n-rw-r--r-- root/root      1150 2026-07-03 13:11 ./usr/share/doc/sopass/copyright\ndrwxr-xr-x root/root         0 2026-07-03 13:11 ./usr/share/lintian/\ndrwxr-xr-x root/root         0 2026-07-03 13:11 ./usr/share/lintian/overrides/\n-rw-r--r-- root/root       173 2026-07-03 13:11 ./usr/share/lintian/overrides/sopass\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=sopass\n++ dpkg-parsechangelog -SVersion\n+ version=0.6.0.ci20260703T131124-1\n++ echo 0.6.0.ci20260703T131124-1\n++ sed 's/-[^-]*$//'\n+ uv=0.6.0.ci20260703T131124\n++ dpkg --print-architecture\n+ arch=amd64\n+ orig=../sopass_0.6.0.ci20260703T131124.orig.tar.xz\n+ deb=../sopass_0.6.0.ci20260703T131124-1_amd64.deb\n+ changes=../sopass_0.6.0.ci20260703T131124-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 sopass v0.6.0 (/ci/src)\n   Compiling proc-macro2 v1.0.103\n   Compiling quote v1.0.41\n   Compiling unicode-ident v1.0.22\n   Compiling libc v0.2.177\n   Compiling syn v2.0.108\n   Compiling cfg-if v1.0.4\n   Compiling serde_core v1.0.228\n   Compiling zerocopy v0.8.27\n   Compiling rustix v1.1.2\n   Compiling memchr v2.7.6\n   Compiling getrandom v0.2.16\n   Compiling linux-raw-sys v0.11.0\n   Compiling proc-macro-hack v0.5.20+deprecated\n   Compiling bitflags v2.10.0\n   Compiling ppv-lite86 v0.2.21\n   Compiling rand_core v0.6.4\n   Compiling utf8parse v0.2.2\n   Compiling anstyle-parse v0.2.7\n   Compiling rand_chacha v0.3.1\n   Compiling aho-corasick v1.1.4\n   Compiling regex-syntax v0.8.8\n   Compiling is_terminal_polyfill v1.70.2\n   Compiling colorchoice v1.0.4\n   Compiling serde v1.0.228\n   Compiling anstyle v1.0.13\n   Compiling getrandom v0.3.4\n   Compiling anstyle-query v1.1.4\n   Compiling anstream v0.6.21\n   Compiling regex-automata v0.4.13\n   Compiling random-number-macro-impl v0.1.8\n   Compiling rand v0.8.5\n   Compiling serde_derive v1.0.228\n   Compiling hashbrown v0.16.0\n   Compiling winnow v0.7.13\n   Compiling serde_json v1.0.145\n   Compiling equivalent v1.0.2\n   Compiling itoa v1.0.15\n   Compiling thiserror v2.0.17\n   Compiling ryu v1.0.20\n   Compiling indexmap v2.12.0\n   Compiling toml_parser v1.0.4\n   Compiling regex v1.12.2\n   Compiling random-number v0.1.9\n   Compiling terminal_size v0.4.3\n   Compiling thiserror-impl v2.0.17\n   Compiling serde_spanned v1.0.3\n   Compiling toml_datetime v0.7.3\n   Compiling dirs-sys-next v0.1.2\n   Compiling heck v0.5.0\n   Compiling fastrand v2.3.0\n   Compiling unsafe-libyaml-norway v0.2.15\n   Compiling clap_lex v0.7.6\n   Compiling log v0.4.28\n   Compiling strsim v0.11.1\n   Compiling toml_writer v1.0.4\n   Compiling once_cell v1.21.3\n   Compiling tempfile v3.23.0\n   Compiling toml v0.9.8\n   Compiling clap_builder v4.5.51\n   Compiling serde_norway v0.9.42\n   Compiling env_filter v0.1.4\n   Compiling clap_derive v4.5.49\n   Compiling directories-next v2.0.0\n   Compiling random-pick v1.2.16\n   Compiling jiff v0.2.15\n   Compiling clingwrap v0.5.0\n   Compiling passwords v3.1.16\n   Compiling clap v4.5.51\n   Compiling env_logger v0.11.8\n   Compiling sopass v0.6.0 (/ci/src)\n    Finished `release` profile [optimized] target(s) in 1m 46s\n  Installing /ci/src/debian/sopass/usr/bin/sopass\n   Installed package `sopass v0.6.0 (/ci/src)` (executable `sopass`)\nwarning: be sure to add `/ci/src/debian/sopass/usr/bin` to your PATH to be able to run the installed binaries\ndpkg-shlibdeps: warning: couldn't parse dynamic symbol definition: no symbols\ndpkg-gencontrol: warning: Depends field of package sopass: substitution variable ${shlibs:Depends} used, but is not defined\ndpkg-gencontrol: warning: Depends field of package sopass: substitution variable ${shlibs:Depends} used, but is not defined\n dpkg-genbuildinfo -O../sopass_0.6.0.ci20260703T131124-1_amd64.buildinfo\n dpkg-genchanges -O../sopass_0.6.0.ci20260703T131124-1_amd64.changes\n dpkg-source --after-build .\n+ ls -l ..\n+ for x in ../*.deb\n+ dpkg -c ../sopass-dbgsym_0.6.0.ci20260703T131124-1_amd64.deb\n+ for x in ../*.deb\n+ dpkg -c ../sopass_0.6.0.ci20260703T131124-1_amd64.deb\n+ mv ../sopass-dbgsym_0.6.0.ci20260703T131124-1_amd64.deb ../sopass_0.6.0.ci20260703T131124-1.debian.tar.xz ../sopass_0.6.0.ci20260703T131124-1.dsc ../sopass_0.6.0.ci20260703T131124-1_amd64.buildinfo ../sopass_0.6.0.ci20260703T131124-1_amd64.changes ../sopass_0.6.0.ci20260703T131124-1_amd64.deb ../sopass_0.6.0.ci20260703T131124.orig.tar.xz /ci/artifacts/debian\n","timestamp":{"secs_since_epoch":1783084398,"nanos_since_epoch":967148281},"log_source":"Plan"}
{"type":"action_succeeded","action":"deb","packages":"debian","timestamp":{"secs_since_epoch":1783084399,"nanos_since_epoch":171990629},"log_source":"Plan"}
{"type":"execute_action","action":"tar_create","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783084399,"nanos_since_epoch":175336773},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_create","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783084401,"nanos_since_epoch":265583417},"log_source":"Plan"}
{"type":"execute_action","action":"tar_create","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783084401,"nanos_since_epoch":266330386},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_create","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783084401,"nanos_since_epoch":291053662},"log_source":"Plan"}
{"type":"plan_succeeded","timestamp":{"secs_since_epoch":1783084401,"nanos_since_epoch":291746203},"log_source":"Plan"}
{"type":"executor_ends_successfully","timestamp":{"secs_since_epoch":1783084401,"nanos_since_epoch":292049000},"log_source":"Plan"}
EXIT CODE: 0

Post-plan VM

Structured log: all OK
  1. 0 ms: Executor starts
    • Name: ambient-execute-plan
    • Version: 0.15.0@eeab732
  2. 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: 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. 6 ms: Action succeeded: mkdir: /ci
    - action: mkdir
      pathname: /ci
    
  5. 6 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. 10 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. 111 ms: Action succeeded: tar_extract
    - action: tar_extract
      archive: /dev/vdc
      directory: /ci/src
    
  17. 111 ms: Execute action: tar_extract
    - action: tar_extract
      archive: /dev/vdf
      directory: /ci/deps
    
  18. 2326 ms: Action succeeded: tar_extract
    - action: tar_extract
      archive: /dev/vdf
      directory: /ci/deps
    
  19. 2335 ms: Execute action: tar_extract
    - action: tar_extract
      archive: /dev/vde
      directory: /ci/cache
    
  20. 4970 ms: Action succeeded: tar_extract
    - action: tar_extract
      archive: /dev/vde
      directory: /ci/cache
    
  21. 4977 ms: Execute action: tar_extract
    - action: tar_extract
      archive: /dev/vdd
      directory: /ci/artifacts
    
  22. 4992 ms: Action succeeded: tar_extract
    - action: tar_extract
      archive: /dev/vdd
      directory: /ci/artifacts
    
  23. 4996 ms: Execute action: tar_extract
    - action: tar_extract
      archive: /dev/vdg
      directory: /ci/secrets
    
  24. 5005 ms: Action succeeded: tar_extract
    - action: tar_extract
      archive: /dev/vdg
      directory: /ci/secrets
    
  25. 5009 ms: Execute action: shell: ln -sf /ci /workspace
    - action: shell
      shell: ln -sf /ci /workspace
    
  26. 5009 ms: Start program: bash
    • bash
    • -c
    • set -xeuo pipefail ln -sf /ci /workspace
  27. 5035 ms: Program succeeded
    • Exit code: 0
    • Stdout
    • Stderr
      + ln -sf /ci /workspace
      
  28. 5035 ms: Action succeeded: shell: ln -sf /ci /workspace
    - action: shell
      shell: ln -sf /ci /workspace
    
  29. 5035 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. 5036 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. 5036 ms: Execute action: tar_create
    - action: tar_create
      archive: /dev/vde
      directory: /ci/cache
    
  32. 6585 ms: Action succeeded: tar_create
    - action: tar_create
      archive: /dev/vde
      directory: /ci/cache
    
  33. 6585 ms: Execute action: tar_create
    - action: tar_create
      archive: /dev/vdd
      directory: /ci/artifacts
    
  34. 6603 ms: Action succeeded: tar_create
    - action: tar_create
      archive: /dev/vdd
      directory: /ci/artifacts
    
  35. 6612 ms: Plan succededThere was much rejoicing!
  36. 6615 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  ] Started systemd-journald.service - Journal Service.
[  OK  ] Mounted tmp.mount - Temporary Directory /tmp.
[  OK  ] Finished kmod-static-nodes.service…Create List of Static Device Nodes.
[  OK  ] Finished modprobe@configfs.service - Load Kernel Module configfs.
[  OK  ] Finished modprobe@drm.service - Load Kernel Module drm.
[  OK  ] Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
[  OK  ] Finished modprobe@fuse.service - Load Kernel Module fuse.
[  OK  ] Finished systemd-modules-load.service - Load Kernel Modules.
[  OK  ] Finished systemd-network-generator…ork Units from Kernel Command Line.
[  OK  ] Finished systemd-remount-fs.servic…mount Root and Kernel File Systems.
[  OK  ] Finished systemd-udev-load-credent…- Load udev Rules from Credentials.
[  OK  ] Reached target network-pre.target - Preparation for Network.
         Mounting sys-fs-fuse-connections.mount - FUSE Control File System...
         Mounting sys-kernel-config.mount - Kernel Configuration File System...
         Starting systemd-journal-flush.ser…sh Journal to Persistent Storage...
         Starting systemd-random-seed.service - Load/Save OS Random Seed...
         Starting systemd-sysctl.service - Apply Kernel Variables...
         Starting systemd-tmpfiles-setup-de… Device Nodes in /dev gracefully...
[  OK  ] Finished systemd-udev-trigger.service - Coldplug All udev Devices.
[  OK  ] Mounted sys-fs-fuse-connections.mount - FUSE Control File System.
[  OK  ] Mounted sys-kernel-config.mount - Kernel Configuration File System.
[  OK  ] Finished systemd-sysctl.service - Apply Kernel Variables.
[  OK  ] Finished systemd-tmpfiles-setup-de…ic Device Nodes in /dev gracefully.
         Starting systemd-sysusers.service - Create System Users...
[  OK  ] Finished systemd-random-seed.service - Load/Save OS Random Seed.
[  OK  ] Finished systemd-journal-flush.ser…lush Journal to Persistent Storage.
[  OK  ] Finished systemd-sysusers.service - Create System Users.
         Starting systemd-resolved.service - Network Name Resolution...
         Starting systemd-tmpfiles-setup-de…eate Static Device Nodes in /dev...
[  OK  ] Finished systemd-tmpfiles-setup-de…Create Static Device Nodes in /dev.
[  OK  ] Reached target local-fs-pre.target…Preparation for Local File Systems.
[  OK  ] Set up automount efi.automount - EFI System Partition Automount.
[  OK  ] Reached target local-fs.target - Local File Systems.
[  OK  ] Listening on systemd-sysext.socket… System Extension Image Management.
         Starting systemd-binfmt.service - Set Up Additional Binary Formats...
         Starting systemd-tmpfiles-setup.se…ate System Files and Directories...
         Starting systemd-udevd.service - R…ager for Device Events and Files...
[  OK  ] Started systemd-resolved.service - Network Name Resolution.
[  OK  ] Finished systemd-tmpfiles-setup.se…reate System Files and Directories.
[  OK  ] Reached target nss-lookup.target - Host and Network Name Lookups.
         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-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 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 target network-pre.target - Preparation for Network.
[  OK  ] Closed systemd-networkd.socket - Network Service Netlink Socket.
[  OK  ] Stopped systemd-network-generator.…ork Units from Kernel Command Line.
[  OK  ] Stopped systemd-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.
         Unmounting run-lock.mount - Legacy Locks Directory /run/lock...
         Unmounting tmp.mount - Temporary Directory /tmp...
[  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 tmp.mount - Temporary Directory /tmp.
[  OK  ] Unmounted run-lock.mount - Legacy Locks Directory /run/lock.
[  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.
[   19.207998] 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   1.5M  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-03 13:09 ./
-rw-r--r-- _rad/_rad      1209 2026-07-03 13:13 ./plan.yaml
-rwxr-xr-x _rad/_rad   5517632 2026-07-03 13:13 ./run-ci
INFO: Extracted files:
        8      0 drwxr-xr-x   2 1000     1000           80 Jul  3 13:09 .
       10   5392 -rwxr-xr-x   1 1000     1000      5517632 Jul  3 13:13 ./run-ci
        9      4 -rw-r--r--   1 1000     1000         1209 Jul  3 13:13 ./plan.yaml
INFO: Running run-ci from /dev/vdb
================================ BEGIN ================================
{"type":"executor_starts","name":"ambient-execute-plan","version":"0.15.0@eeab732","timestamp":{"secs_since_epoch":1783084416,"nanos_since_epoch":126557332},"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":1783084416,"nanos_since_epoch":127963018},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci","timestamp":{"secs_since_epoch":1783084416,"nanos_since_epoch":128563207},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci","timestamp":{"secs_since_epoch":1783084416,"nanos_since_epoch":133164001},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/artifacts","timestamp":{"secs_since_epoch":1783084416,"nanos_since_epoch":133372307},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/artifacts","timestamp":{"secs_since_epoch":1783084416,"nanos_since_epoch":133747795},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/artifacts/debian","timestamp":{"secs_since_epoch":1783084416,"nanos_since_epoch":133928063},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/artifacts/debian","timestamp":{"secs_since_epoch":1783084416,"nanos_since_epoch":134696022},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/artifacts/rsync","timestamp":{"secs_since_epoch":1783084416,"nanos_since_epoch":134788346},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/artifacts/rsync","timestamp":{"secs_since_epoch":1783084416,"nanos_since_epoch":135124201},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/secrets","timestamp":{"secs_since_epoch":1783084416,"nanos_since_epoch":135367675},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/secrets","timestamp":{"secs_since_epoch":1783084416,"nanos_since_epoch":136120802},"log_source":"Plan"}
{"type":"execute_action","action":"mkdir","pathname":"/ci/deps","timestamp":{"secs_since_epoch":1783084416,"nanos_since_epoch":136334962},"log_source":"Plan"}
{"type":"action_succeeded","action":"mkdir","pathname":"/ci/deps","timestamp":{"secs_since_epoch":1783084416,"nanos_since_epoch":136705289},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdc","directory":"/ci/src","timestamp":{"secs_since_epoch":1783084416,"nanos_since_epoch":136878170},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdc","directory":"/ci/src","timestamp":{"secs_since_epoch":1783084416,"nanos_since_epoch":238178766},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdf","directory":"/ci/deps","timestamp":{"secs_since_epoch":1783084416,"nanos_since_epoch":238553541},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdf","directory":"/ci/deps","timestamp":{"secs_since_epoch":1783084418,"nanos_since_epoch":452800005},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783084418,"nanos_since_epoch":462413918},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783084421,"nanos_since_epoch":96654943},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783084421,"nanos_since_epoch":104169887},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783084421,"nanos_since_epoch":118594810},"log_source":"Plan"}
{"type":"execute_action","action":"tar_extract","archive":"/dev/vdg","directory":"/ci/secrets","timestamp":{"secs_since_epoch":1783084421,"nanos_since_epoch":122748258},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_extract","archive":"/dev/vdg","directory":"/ci/secrets","timestamp":{"secs_since_epoch":1783084421,"nanos_since_epoch":131699677},"log_source":"Plan"}
{"type":"execute_action","action":"shell","shell":"ln -sf /ci /workspace","timestamp":{"secs_since_epoch":1783084421,"nanos_since_epoch":135751986},"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":1783084421,"nanos_since_epoch":135784453},"log_source":"Plan"}
{"type":"program_succeeded","exit_code":0,"stdout":"","stderr":"+ ln -sf /ci /workspace\n","timestamp":{"secs_since_epoch":1783084421,"nanos_since_epoch":161737355},"log_source":"Plan"}
{"type":"action_succeeded","action":"shell","shell":"ln -sf /ci /workspace","timestamp":{"secs_since_epoch":1783084421,"nanos_since_epoch":162185214},"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":1783084421,"nanos_since_epoch":162203478},"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":1783084421,"nanos_since_epoch":162644669},"log_source":"Plan"}
{"type":"execute_action","action":"tar_create","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783084421,"nanos_since_epoch":162876256},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_create","archive":"/dev/vde","directory":"/ci/cache","timestamp":{"secs_since_epoch":1783084422,"nanos_since_epoch":711762124},"log_source":"Plan"}
{"type":"execute_action","action":"tar_create","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783084422,"nanos_since_epoch":712230550},"log_source":"Plan"}
{"type":"action_succeeded","action":"tar_create","archive":"/dev/vdd","directory":"/ci/artifacts","timestamp":{"secs_since_epoch":1783084422,"nanos_since_epoch":730368190},"log_source":"Plan"}
{"type":"plan_succeeded","timestamp":{"secs_since_epoch":1783084422,"nanos_since_epoch":739386734},"log_source":"Plan"}
{"type":"executor_ends_successfully","timestamp":{"secs_since_epoch":1783084422,"nanos_since_epoch":742036921},"log_source":"Plan"}
EXIT CODE: 0