CI run for vmdb2

Radicle repository id rad:z2kxCtBwDQMPcaf9vGTNH5nYkp9qk

Table of Contents

Run log

[2025-08-18T11:05:35Z INFO  ambient] ambient starts
[=3h[=3hBdsDxe: failed to load Boot0001 "UEFI QEMU DVD-ROM QM00005 " from PciRoot(0x0)/Pci(0x1F,0x2)/Sata(0x2,0xFFFF,0x0): Not Found
BdsDxe: loading Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x2,0x0)
BdsDxe: starting Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x2,0x0)
Welcome to GRUB!


INFO: Block devices
NAME   MAJ:MIN RM  SIZE RO TYPE MOUNTPOINTS
vda    254:0    0  100G  0 disk 
├─vda1 254:1    0  953M  0 part 
└─vda2 254:2    0 99.1G  0 part /
vdb    254:16   0  2.9M  1 disk 
vdc    254:32   0  1.6M  1 disk 
vdd    254:48   0  9.3G  0 disk 
vde    254:64   0 46.6G  0 disk 
vdf    254:80   0   10K  1 disk 
INFO: Extracting tar archive from /dev/vdb
drwxr-xr-x _rad/_rad         0 2025-08-18 11:05 ./
-rw-r--r-- _rad/_rad      1396 2025-08-18 11:05 ./plan.yaml
-rwxr-xr-x _rad/_rad   3003032 2025-08-18 11:05 ./run-ci
INFO: Extracted files:
  1477809      4 drwxr-xr-x   2 1001     1001         4096 Aug 18 11:05 .
  1477810      4 -rw-r--r--   1 1001     1001         1396 Aug 18 11:05 ./plan.yaml
  1477881   2936 -rwxr-xr-x   1 1001     1001      3003032 Aug 18 11:05 ./run-ci
INFO: Running run-ci from /dev/vdb
================================ BEGIN ================================
[2025-08-18T11:05:20Z TRACE ambient_execute_plan] ambient-execute-plan starts
[2025-08-18T11:05:20Z DEBUG ambient_execute_plan] ambient-execute-plan starts
[2025-08-18T11:05:20Z INFO  ambient_execute_plan] ambient-execute-plan starts
[2025-08-18T11:05:20Z WARN  ambient_execute_plan] ambient-execute-plan starts
[2025-08-18T11:05:20Z ERROR ambient_execute_plan] ambient-execute-plan starts
RunnablePlan::from_file: filename=plan.yaml
steps:
- action: mkdir
  pathname: /workspace
- action: mkdir
  pathname: /workspace/artifacts
- action: tar_extract
  archive: /dev/vdc
  directory: /workspace/src
- action: tar_extract
  archive: /dev/vdf
  directory: /workspace/deps
- action: tar_extract
  archive: /dev/vde
  directory: /workspace/cache
- action: spawn
  argv:
  - find
  - /workspace
  - '-maxdepth'
  - '2'
  - '-ls'
- action: shell
  shell: |
    ./format.sh
    cp vmdb2.html /workspace/artifacts/index.html
- action: shell
  shell: |
    export DEBEMAIL=liw@liw.fi
    export DEBFULLNAME="Lars Wirzenius"
    export HOME=/root
    export PATH="/root/.cargo/bin:/bin:/sbin"
    export SOPASS_LOG=trace
    export CARGO_TARGET_DIR=/workspace/cache
    export CARGO_HOME=/workspace/deps

    ./check

    git clean -fdx

    V="$(dpkg-parsechangelog -SVersion | sed 's/-[^-]*$//')"
    T="$(date -u "+%Y%m%dT%H%M%S")"
    version="$V.ci$T-1"
    dch -v "$version" "CI build under Ambient."
    dch -r ''
- action: deb
- action: tar_create
  archive: /dev/vde
  directory: /workspace/cache
- action: tar_create
  archive: /dev/vdd
  directory: /workspace/artifacts
executor_drive: /dev/vdb
source_drive: /dev/vdc
artifact_drive: /dev/vdd
cache_drive: /dev/vde
deps_drive: /dev/vdf
workspace_dir: /workspace
source_dir: /workspace/src
deps_dir: /workspace/deps
cache_dir: /workspace/cache
artifacts_dir: /workspace/artifacts


RUN: Action Mkdir {
    pathname: "/workspace",
}
[2025-08-18T11:05:20Z DEBUG ambient_ci::action] Plan::execute: Mkdir {
        pathname: "/workspace",
    }
RUN: Action finished OK
RUN: Action Mkdir {
    pathname: "/workspace/artifacts",
}
[2025-08-18T11:05:20Z DEBUG ambient_ci::action] Plan::execute: Mkdir {
        pathname: "/workspace/artifacts",
    }
RUN: Action finished OK
RUN: Action TarExtract {
    archive: "/dev/vdc",
    directory: "/workspace/src",
}
[2025-08-18T11:05:20Z DEBUG ambient_ci::action] Plan::execute: TarExtract {
        archive: "/dev/vdc",
        directory: "/workspace/src",
    }
[2025-08-18T11:05:20Z TRACE ambient_ci::vdrive] extracting /dev/vdc to /workspace/src
[2025-08-18T11:05:20Z TRACE ambient_ci::vdrive] extraction OK
RUN: Action finished OK
RUN: Action TarExtract {
    archive: "/dev/vdf",
    directory: "/workspace/deps",
}
[2025-08-18T11:05:20Z DEBUG ambient_ci::action] Plan::execute: TarExtract {
        archive: "/dev/vdf",
        directory: "/workspace/deps",
    }
[2025-08-18T11:05:20Z TRACE ambient_ci::vdrive] extracting /dev/vdf to /workspace/deps
[2025-08-18T11:05:21Z TRACE ambient_ci::vdrive] extraction OK
RUN: Action finished OK
RUN: Action TarExtract {
    archive: "/dev/vde",
    directory: "/workspace/cache",
}
[2025-08-18T11:05:21Z DEBUG ambient_ci::action] Plan::execute: TarExtract {
        archive: "/dev/vde",
        directory: "/workspace/cache",
    }
[2025-08-18T11:05:21Z TRACE ambient_ci::vdrive] extracting /dev/vde to /workspace/cache
[2025-08-18T11:05:21Z TRACE ambient_ci::vdrive] extraction OK
RUN: Action finished OK
RUN: Action Spawn {
    argv: [
        "find",
        "/workspace",
        "-maxdepth",
        "2",
        "-ls",
    ],
}
[2025-08-18T11:05:21Z DEBUG ambient_ci::action] Plan::execute: Spawn {
        argv: [
            "find",
            "/workspace",
            "-maxdepth",
            "2",
            "-ls",
        ],
    }
SPAWN: argv=["find", "/workspace", "-maxdepth", "2", "-ls"]
       cwd=/workspace/src (exists? true)
       extra_env=[]
  3932161      4 drwxr-xr-x   6 root     root         4096 Aug 18 11:05 /workspace
  3932162      4 drwxr-xr-x   2 root     root         4096 Aug 18 11:05 /workspace/artifacts
  3932734      4 drwxr-xr-x   2 root     root         4096 Aug 16 05:30 /workspace/deps
  3932163      4 drwxr-xr-x   7 root     root         4096 Aug 18 11:05 /workspace/src
  3932733      4 -rw-r--r--   1 root     root         1264 Aug 18 11:05 /workspace/src/smoke-ppc64el.vmdb
  3932165      4 drwxr-xr-x   2 root     root         4096 Aug 18 11:05 /workspace/src/.radicle
  3932181      4 -rw-r--r--   1 root     root         1976 Aug 18 11:05 /workspace/src/smoke-ppc64el.yarn
  3932726      4 -rw-r--r--   1 root     root            8 Aug 18 11:05 /workspace/src/lvm2.lukskey
  3932186      4 -rwxr-xr-x   1 root     root          101 Aug 18 11:05 /workspace/src/smoke-ppc64el.sh
  3932727      4 -rw-r--r--   1 root     root          211 Aug 18 11:05 /workspace/src/vmdb2.yaml
  3932168      8 -rwxr-xr-x   1 root     root         5713 Aug 18 11:05 /workspace/src/check-one
  3932164      4 -rwxr-xr-x   1 root     root           76 Aug 18 11:05 /workspace/src/vmdb2
  3932182      4 -rwxr-xr-x   1 root     root          516 Aug 18 11:05 /workspace/src/check-external
  3932178      4 -rw-r--r--   1 root     root         1153 Aug 18 11:05 /workspace/src/base.vmdb
  3932728      4 -rwxr-xr-x   1 root     root          304 Aug 18 11:05 /workspace/src/format.sh
  3932183      4 -rwxr-xr-x   1 root     root          308 Aug 18 11:05 /workspace/src/check-all
  3932200      4 -rw-r--r--   1 root     root           12 Aug 18 11:05 /workspace/src/.gitignore
  3932167      4 -rw-r--r--   1 root     root          985 Aug 18 11:05 /workspace/src/ppc64el.vmdb
  3932729      4 -rw-r--r--   1 root     root          504 Aug 18 11:05 /workspace/src/vmdb2.css
  3932653     12 -rw-r--r--   1 root     root        10708 Aug 18 11:05 /workspace/src/vmdb2.md
  3932725      4 -rw-r--r--   1 root     root          143 Aug 18 11:05 /workspace/src/ansible.yml
  3932202      4 drwxr-xr-x   8 root     root         4096 Aug 18 11:05 /workspace/src/.git
  3932731      4 -rwxr-xr-x   1 root     root         1083 Aug 18 11:05 /workspace/src/check-images
  3932187      4 drwxr-xr-x   3 root     root         4096 Aug 18 11:05 /workspace/src/debian
  3932201      4 -rw-r--r--   1 root     root         1057 Aug 18 11:05 /workspace/src/without-tests
  3932177      4 -rw-r--r--   1 root     root          162 Aug 18 11:05 /workspace/src/vmdb2.py
  3932199      8 -rw-r--r--   1 root     root         7962 Aug 18 11:05 /workspace/src/README.md
  3932730      4 -rw-r--r--   1 root     root         2055 Aug 18 11:05 /workspace/src/vmdb2.1
  3932180     24 -rw-r--r--   1 root     root        23398 Aug 18 11:05 /workspace/src/NEWS
  3932179      4 -rwxr-xr-x   1 root     root         1174 Aug 18 11:05 /workspace/src/setup.py
  3932185      4 -rw-r--r--   1 root     root         1271 Aug 18 11:05 /workspace/src/lvm2.vmdb
  3932184      4 -rw-r--r--   1 root     root          235 Aug 18 11:05 /workspace/src/vmdb2.subplot
  3932732      4 -rw-r--r--   1 root     root         3218 Aug 18 11:05 /workspace/src/code-of-conduct.md
  3932654      4 drwxr-xr-x   3 root     root         4096 Aug 18 11:05 /workspace/src/vmdb
  3932176      4 -rwxr-xr-x   1 root     root         1393 Aug 18 11:05 /workspace/src/check
  3932169      4 drwxr-xr-x   4 root     root         4096 Aug 18 11:05 /workspace/src/roles
  3932735      4 drwxr-xr-x   2 root     root         4096 Aug 16 05:30 /workspace/cache
RUN: Action finished OK
RUN: Action Shell {
    shell: "./format.sh\ncp vmdb2.html /workspace/artifacts/index.html\n",
}
[2025-08-18T11:05:21Z DEBUG ambient_ci::action] Plan::execute: Shell {
        shell: "./format.sh\ncp vmdb2.html /workspace/artifacts/index.html\n",
    }
SPAWN: argv=["/bin/bash", "-c", "set -xeuo pipefail\n./format.sh\ncp vmdb2.html /workspace/artifacts/index.html\n\n"]
       cwd=/workspace/src (exists? true)
       extra_env=[]
+ ./format.sh
+ cp vmdb2.html /workspace/artifacts/index.html
RUN: Action finished OK
RUN: Action Shell {
    shell: "export DEBEMAIL=liw@liw.fi\nexport DEBFULLNAME=\"Lars Wirzenius\"\nexport HOME=/root\nexport PATH=\"/root/.cargo/bin:/bin:/sbin\"\nexport SOPASS_LOG=trace\nexport CARGO_TARGET_DIR=/workspace/cache\nexport CARGO_HOME=/workspace/deps\n\n./check\n\ngit clean -fdx\n\nV=\"$(dpkg-parsechangelog -SVersion | sed 's/-[^-]*$//')\"\nT=\"$(date -u \"+%Y%m%dT%H%M%S\")\"\nversion=\"$V.ci$T-1\"\ndch -v \"$version\" \"CI build under Ambient.\"\ndch -r ''\n",
}
[2025-08-18T11:05:22Z DEBUG ambient_ci::action] Plan::execute: Shell {
        shell: "export DEBEMAIL=liw@liw.fi\nexport DEBFULLNAME=\"Lars Wirzenius\"\nexport HOME=/root\nexport PATH=\"/root/.cargo/bin:/bin:/sbin\"\nexport SOPASS_LOG=trace\nexport CARGO_TARGET_DIR=/workspace/cache\nexport CARGO_HOME=/workspace/deps\n\n./check\n\ngit clean -fdx\n\nV=\"$(dpkg-parsechangelog -SVersion | sed 's/-[^-]*$//')\"\nT=\"$(date -u \"+%Y%m%dT%H%M%S\")\"\nversion=\"$V.ci$T-1\"\ndch -v \"$version\" \"CI build under Ambient.\"\ndch -r ''\n",
    }
SPAWN: argv=["/bin/bash", "-c", "set -xeuo pipefail\nexport DEBEMAIL=liw@liw.fi\nexport DEBFULLNAME=\"Lars Wirzenius\"\nexport HOME=/root\nexport PATH=\"/root/.cargo/bin:/bin:/sbin\"\nexport SOPASS_LOG=trace\nexport CARGO_TARGET_DIR=/workspace/cache\nexport CARGO_HOME=/workspace/deps\n\n./check\n\ngit clean -fdx\n\nV=\"$(dpkg-parsechangelog -SVersion | sed 's/-[^-]*$//')\"\nT=\"$(date -u \"+%Y%m%dT%H%M%S\")\"\nversion=\"$V.ci$T-1\"\ndch -v \"$version\" \"CI build under Ambient.\"\ndch -r ''\n\n"]
       cwd=/workspace/src (exists? true)
       extra_env=[]
+ export DEBEMAIL=liw@liw.fi
+ DEBEMAIL=liw@liw.fi
+ export 'DEBFULLNAME=Lars Wirzenius'
+ DEBFULLNAME='Lars Wirzenius'
+ export HOME=/root
+ HOME=/root
+ export PATH=/root/.cargo/bin:/bin:/sbin
+ PATH=/root/.cargo/bin:/bin:/sbin
+ export SOPASS_LOG=trace
+ SOPASS_LOG=trace
+ export CARGO_TARGET_DIR=/workspace/cache
+ CARGO_TARGET_DIR=/workspace/cache
+ export CARGO_HOME=/workspace/deps
+ CARGO_HOME=/workspace/deps
+ ./check
Running unit tests ============================================
/usr/lib/python3/dist-packages/CoverageTestRunner.py:22: DeprecationWarning: the imp module is deprecated in favour of importlib and slated for removal in Python 3.12; see the module's documentation for alternative uses
  import imp
Running test 1/52: tests_finds_no_plugin_when_file_has_none (plugin_t                                                                     Running test 2/52: tests_finds_no_plugins_in_empty_directory (plugin_                                                                     Running test 3/52: tests_finds_no_plugins_when_there_are_other_files                                                                      Running test 4/52: tests_finds_plugin_when_there_is_one (plugin_tests                                                                     Running test 5/52: test_sets_app (plugin_tests.PluginTests.test_sets_                                                                     Running test 6/52: test_raises_error_for_missing_mandatory_key (step_                                                                     Running test 7/52: test_raises_error_for_wrong_type_of_value_for_mand                                                                     Running test 8/52: test_raises_error_for_wrong_type_of_value_for_opti                                                                     Running test 9/52: test_returns_actual_value_for_optional_key (step_l                                                                     Running test 10/52: test_returns_default_value_for_missing_optional_ke                                                                      Running test 11/52: test_returns_values_from_step_for_mandatory_keys (                                                                      Running test 12/52: test_adds_a_runner (step_list_tests.StepRunnerList                                                                      Running test 13/52: test_finds_correct_runner (step_list_tests.StepRun                                                                      Running test 14/52: test_is_empty_initially (step_list_tests.StepRunne                                                                      Running test 15/52: test_raises_error_if_runner_not_found (step_list_t                                                                      Running test 16/52: test_raises_error_if_wrong_step_key_values (step_l                                                                      Running test 17/52: test_raises_error_if_not_mounted (unmount_tests.Un                                                                      Running test 18/52: test_unmounts_mounted_dir (unmount_tests.UnmountTe                                                                      Running test 19/52: test_unmounts_mounted_dir_with_submounts (unmount_                                                                      Running test 20/52: test_expands_dict_of_templates (spec_tests.ExpandT                                                                      Running test 21/52: test_expands_list_of_templates (spec_tests.ExpandT                                                                      Running test 22/52: test_expands_simple_string_template (spec_tests.Ex                                                                      Running test 23/52: test_raises_assert_if_given_incomprehensible_value                                                                      Running test 24/52: test_returns_same_given_string_without_template (s                                                                      Running test 25/52: test_expands_templates (spec_tests.SpecTests.test_                                                                      Running test 26/52: test_loads_spec (spec_tests.SpecTests.test_loads_s                                                                      Running test 27/52: test_adds_builder_mount_point (tags_tests.TagsTest                                                                      Running test 28/52: test_builder_mount_point_can_be_made_cached (tags_                                                                      Running test 29/52: test_builder_mount_point_is_uncached_by_default (t                                                                      Running test 30/52: test_get_dev_raises_error_for_unknown_tag (tags_te                                                                      Running test 31/52: test_getting_builder_mount_point_raises_error_for_                                                                      Running test 32/52: test_lists_no_tags_initially (tags_tests.TagsTests                                                                      Running test 33/52: test_raises_error_for_reused_tag (tags_tests.TagsT                                                                      Running test 34/52: test_raises_error_if_both_mount_points_not_set (ta                                                                      Running test 35/52: test_remembers_order (tags_tests.TagsTests.test_re                                                                      Running test 36/52: test_returns_builder_when_given_target_mount_point                                                                      Running test 37/52: test_set_builder_mount_point_raises_error_for_doub                                                                      Running test 38/52: test_set_builder_mount_point_raises_error_for_unkn                                                                      Running test 39/52: test_set_dev_raises_error_for_double_dev (tags_tes                                                                      Running test 40/52: test_set_dev_raises_error_for_unknown_tag (tags_te                                                                      Running test 41/52: test_set_dm (tags_tests.TagsTests.test_set_dm)                                                                  Running test 42/52: test_set_dm_raises_error_for_double_fstype (tags_t                                                                      Running test 43/52: test_set_fstype (tags_tests.TagsTests.test_set_fst                                                                      Running test 44/52: test_set_fstype_raises_error_for_double_fstype (ta                                                                      Running test 45/52: test_set_fsuuid (tags_tests.TagsTests.test_set_fsu                                                                      Running test 46/52: test_set_fsuuid_raises_error_for_double_fstype (ta                                                                      Running test 47/52: test_set_luksuuid (tags_tests.TagsTests.test_set_l                                                                      Running test 48/52: test_set_luksuuid_raises_error_for_double_fstype (                                                                      Running test 49/52: test_set_target_mount_point (tags_tests.TagsTests.                                                                      Running test 50/52: test_set_target_mount_point_raises_error_for_doubl                                                                      Running test 51/52: test_sets_dev (tags_tests.TagsTests.test_sets_dev)                                                                      Running test 52/52: test_tells_if_tag_exists (tags_tests.TagsTests.tes

OK
54 excluded statements
33 excluded modules
Time: 0.3 s

Checking every plugin looks OK ============================================

Running Subplot ============================================
 INFO Starting Subplot
 INFO Subplot finished successfully
srcdir /workspace/src
datadir /tmp/tmph7v777cd
scenario: A happy path
  step: given an installed vmdb2
  step: given file happy.vmdb
  step: when I run vmdb2 -v happy.vmdb --output=happy.img
  step: then exit code is 0
  step: then stdout contains "foo\nbar\nbar_teardown\n"
scenario: Checking the version
  step: given an installed vmdb2
  step: when I run vmdb2 --version
  step: then exit code is 0
  step: then stdout matches regex ^\\d+\\.\\d+$
scenario: Error handling
  step: given an installed vmdb2
  step: given file unhappy.vmdb
  step: when I try to run vmdb2 -v unhappy.vmdb --output=unhappy.img
  step: then exit code is 1
  step: then stdout contains "foo\nyikes\n"
  step: then stdout contains "WAT?!\n"
  step: then stdout contains "foo_teardown\n"
  step: then stdout doesn't contain "bar_step"
  step: then stdout contains "bar_teardown"
scenario: Jinja2 templating in specification file values
  step: given an installed vmdb2
  step: given file j2.vmdb
  step: when I run vmdb2 -v j2.vmdb --output=foo.img
  step: then exit code is 0
  step: then stdout contains "image is foo.img\nbar"
OK, all scenarios finished successfully

Formatting docs ========================================
+ git clean -fdx
Removing .coverage
Removing test.log
Removing test.py
Removing vmdb/__pycache__/
Removing vmdb/plugins/__pycache__/
Removing vmdb2.html
++ dpkg-parsechangelog -SVersion
++ sed 's/-[^-]*$//'
+ V=0.41
++ date -u +%Y%m%dT%H%M%S
+ T=20250818T110524
+ version=0.41.ci20250818T110524-1
+ dch -v 0.41.ci20250818T110524-1 'CI build under Ambient.'
+ dch -r ''
RUN: Action finished OK
RUN: Action Deb
[2025-08-18T11:05:24Z DEBUG ambient_ci::action] Plan::execute: Deb
SPAWN: argv=["/bin/bash", "-c", "#!/bin/bash\nset -xeuo pipefail\n\necho \"PATH at start: $PATH\"\nexport PATH=\"/root/.cargo/bin:$PATH\"\nexport CARGO_HOME=/workspace/deps\nexport DEBEMAIL=liw@liw.fi\nexport DEBFULLNAME=\"Lars Wirzenius\"\n/bin/env\n\ncommand -v cargo\ncommand -v rustc\n\ncargo --version\nrustc --version\n\n# Get name and version of source package.\nname=\"$(dpkg-parsechangelog -SSource)\"\nversion=\"$(dpkg-parsechangelog -SVersion)\"\n\n# Get upstream version: everything before the last dash.\nuv=\"$(echo \"$version\" | sed 's/-[^-]*$//')\"\n\n# Files that will be created.\narch=\"$(dpkg --print-architecture)\"\norig=\"../${name}_${uv}.orig.tar.xz\"\ndeb=\"../${name}_${version}_${arch}.deb\"\nchanges=\"../${name}_${version}_${arch}.changes\"\n\n# Create \"upstream tarball\".\ngit archive HEAD | xz >\"$orig\"\n\n# Build package.\ndpkg-buildpackage -us -uc\n\n# Dump some information to make it easier to visually verify\n# everything looks OK. Also, test the package with the lintian tool.\n\nls -l ..\nfor x in ../*.deb; do dpkg -c \"$x\"; done\n# FIXME: disabled while this prevents radicle-native-ci deb from being built.\n# lintian -i --allow-root --fail-on warning ../*.changes\n\n# Move files to artifacts directory.\nmv ../*_* /workspace/artifacts\n        "]
       cwd=/workspace/src (exists? true)
       extra_env=[("CARGO_TARGET_DIR", "/workspace/cache"), ("CARGO_HOME", "/workspace/deps"), ("PATH", "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin")]
+ echo 'PATH at start: /root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin'
PATH at start: /root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
+ export PATH=/root/.cargo/bin:/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
+ PATH=/root/.cargo/bin:/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
+ export CARGO_HOME=/workspace/deps
+ CARGO_HOME=/workspace/deps
+ export DEBEMAIL=liw@liw.fi
+ DEBEMAIL=liw@liw.fi
+ export 'DEBFULLNAME=Lars Wirzenius'
+ DEBFULLNAME='Lars Wirzenius'
+ /bin/env
DEBFULLNAME=Lars Wirzenius
CARGO_TARGET_DIR=/workspace/cache
PWD=/workspace/src
SYSTEMD_EXEC_PID=275
LANG=C.UTF-8
CARGO_HOME=/workspace/deps
DEBEMAIL=liw@liw.fi
INVOCATION_ID=fa2e3f8a8b0a4e8b9fadeaefc59587b6
SHLVL=2
JOURNAL_STREAM=8:14648
PATH=/root/.cargo/bin:/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
OLDPWD=/
_=/bin/env
+ command -v cargo
/root/.cargo/bin/cargo
+ command -v rustc
/root/.cargo/bin/rustc
+ cargo --version
cargo 1.89.0 (c24e10642 2025-06-23)
+ rustc --version
rustc 1.89.0 (29483883e 2025-08-04)
++ dpkg-parsechangelog -SSource
+ name=vmdb2
++ dpkg-parsechangelog -SVersion
+ version=0.41.ci20250818T110524-1
++ echo 0.41.ci20250818T110524-1
++ sed 's/-[^-]*$//'
+ uv=0.41.ci20250818T110524
++ dpkg --print-architecture
+ arch=amd64
+ orig=../vmdb2_0.41.ci20250818T110524.orig.tar.xz
+ deb=../vmdb2_0.41.ci20250818T110524-1_amd64.deb
+ changes=../vmdb2_0.41.ci20250818T110524-1_amd64.changes
+ xz
+ git archive HEAD
+ dpkg-buildpackage -us -uc
dpkg-buildpackage: info: source package vmdb2
dpkg-buildpackage: info: source version 0.41.ci20250818T110524-1
dpkg-buildpackage: info: source distribution unstable
dpkg-buildpackage: info: source changed by Lars Wirzenius <liw@liw.fi>
dpkg-buildpackage: info: host architecture amd64
 dpkg-source --before-build .
 debian/rules clean
dh clean --with=python3 --buildsystem=pybuild
   dh_auto_clean -O--buildsystem=pybuild
I: pybuild base:240: python3.11 setup.py clean 
/workspace/src/setup.py:18: DeprecationWarning: The distutils package is deprecated and slated for removal in Python 3.12. Use setuptools or check PEP 632 for potential alternatives
  from distutils.core import setup
running clean
removing '/workspace/src/.pybuild/cpython3_3.11_vmdb2/build' (and everything under it)
'build/bdist.linux-x86_64' does not exist -- can't clean it
'build/scripts-3.11' does not exist -- can't clean it
   dh_autoreconf_clean -O--buildsystem=pybuild
   dh_clean -O--buildsystem=pybuild
 dpkg-source -b .
dpkg-source: info: using source format '3.0 (quilt)'
dpkg-source: info: building vmdb2 using existing ./vmdb2_0.41.ci20250818T110524.orig.tar.xz
dpkg-source: info: building vmdb2 in vmdb2_0.41.ci20250818T110524-1.debian.tar.xz
dpkg-source: info: building vmdb2 in vmdb2_0.41.ci20250818T110524-1.dsc
 debian/rules build
dh build --with=python3 --buildsystem=pybuild
   dh_update_autotools_config -O--buildsystem=pybuild
   dh_autoreconf -O--buildsystem=pybuild
   dh_auto_configure -O--buildsystem=pybuild
I: pybuild base:240: python3.11 setup.py config 
/workspace/src/setup.py:18: DeprecationWarning: The distutils package is deprecated and slated for removal in Python 3.12. Use setuptools or check PEP 632 for potential alternatives
  from distutils.core import setup
running config
   dh_auto_build -O--buildsystem=pybuild
I: pybuild base:240: /usr/bin/python3 setup.py build 
/workspace/src/setup.py:18: DeprecationWarning: The distutils package is deprecated and slated for removal in Python 3.12. Use setuptools or check PEP 632 for potential alternatives
  from distutils.core import setup
running build
running build_py
creating /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb
copying vmdb/spec.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb
copying vmdb/runcmd.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb
copying vmdb/step_list.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb
copying vmdb/app.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb
copying vmdb/__init__.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb
copying vmdb/plugin_tests.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb
copying vmdb/step_list_tests.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb
copying vmdb/unmount_tests.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb
copying vmdb/tags.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb
copying vmdb/plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb
copying vmdb/spec_tests.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb
copying vmdb/version.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb
copying vmdb/state.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb
copying vmdb/tags_tests.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb
copying vmdb/unmount.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb
package init file 'vmdb/plugins/__init__.py' not found (or not a regular file)
creating /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
copying vmdb/plugins/debootstrap_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
copying vmdb/plugins/fstab_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
copying vmdb/plugins/cryptsetup_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
copying vmdb/plugins/mount_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
copying vmdb/plugins/echo_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
copying vmdb/plugins/vgcreate_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
copying vmdb/plugins/shell_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
copying vmdb/plugins/set_part_flag_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
copying vmdb/plugins/mkfs_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
copying vmdb/plugins/virtualfs_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
copying vmdb/plugins/lvcreate_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
copying vmdb/plugins/cache_rootfs_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
copying vmdb/plugins/mkimg_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
copying vmdb/plugins/kpartx_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
copying vmdb/plugins/mkpart_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
copying vmdb/plugins/chroot_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
copying vmdb/plugins/error_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
copying vmdb/plugins/apt_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
copying vmdb/plugins/resize_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
copying vmdb/plugins/copy_dir_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
copying vmdb/plugins/grub_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
copying vmdb/plugins/create_dir_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
copying vmdb/plugins/create_file_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
copying vmdb/plugins/lvscan_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
copying vmdb/plugins/copy_file_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
copying vmdb/plugins/mklabel_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
copying vmdb/plugins/ansible_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
copying vmdb/plugins/unpack_rootfs_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
package init file 'vmdb/plugins/__init__.py' not found (or not a regular file)
running build_scripts
creating build
creating build/scripts-3.11
copying and adjusting vmdb2 -> build/scripts-3.11
changing mode of build/scripts-3.11/vmdb2 from 644 to 755
   debian/rules override_dh_auto_test
make[1]: Entering directory '/workspace/src'
./check
Running unit tests ============================================
/usr/lib/python3/dist-packages/CoverageTestRunner.py:22: DeprecationWarning: the imp module is deprecated in favour of importlib and slated for removal in Python 3.12; see the module's documentation for alternative uses
  import imp
Running test 1/52: tests_finds_no_plugin_when_file_has_none (plugin_t                                                                     Running test 2/52: tests_finds_no_plugins_in_empty_directory (plugin_                                                                     Running test 3/52: tests_finds_no_plugins_when_there_are_other_files                                                                      Running test 4/52: tests_finds_plugin_when_there_is_one (plugin_tests                                                                     Running test 5/52: test_sets_app (plugin_tests.PluginTests.test_sets_                                                                     Running test 6/52: test_raises_error_for_missing_mandatory_key (step_                                                                     Running test 7/52: test_raises_error_for_wrong_type_of_value_for_mand                                                                     Running test 8/52: test_raises_error_for_wrong_type_of_value_for_opti                                                                     Running test 9/52: test_returns_actual_value_for_optional_key (step_l                                                                     Running test 10/52: test_returns_default_value_for_missing_optional_ke                                                                      Running test 11/52: test_returns_values_from_step_for_mandatory_keys (                                                                      Running test 12/52: test_adds_a_runner (step_list_tests.StepRunnerList                                                                      Running test 13/52: test_finds_correct_runner (step_list_tests.StepRun                                                                      Running test 14/52: test_is_empty_initially (step_list_tests.StepRunne                                                                      Running test 15/52: test_raises_error_if_runner_not_found (step_list_t                                                                      Running test 16/52: test_raises_error_if_wrong_step_key_values (step_l                                                                      Running test 17/52: test_raises_error_if_not_mounted (unmount_tests.Un                                                                      Running test 18/52: test_unmounts_mounted_dir (unmount_tests.UnmountTe                                                                      Running test 19/52: test_unmounts_mounted_dir_with_submounts (unmount_                                                                      Running test 20/52: test_expands_dict_of_templates (spec_tests.ExpandT                                                                      Running test 21/52: test_expands_list_of_templates (spec_tests.ExpandT                                                                      Running test 22/52: test_expands_simple_string_template (spec_tests.Ex                                                                      Running test 23/52: test_raises_assert_if_given_incomprehensible_value                                                                      Running test 24/52: test_returns_same_given_string_without_template (s                                                                      Running test 25/52: test_expands_templates (spec_tests.SpecTests.test_                                                                      Running test 26/52: test_loads_spec (spec_tests.SpecTests.test_loads_s                                                                      Running test 27/52: test_adds_builder_mount_point (tags_tests.TagsTest                                                                      Running test 28/52: test_builder_mount_point_can_be_made_cached (tags_                                                                      Running test 29/52: test_builder_mount_point_is_uncached_by_default (t                                                                      Running test 30/52: test_get_dev_raises_error_for_unknown_tag (tags_te                                                                      Running test 31/52: test_getting_builder_mount_point_raises_error_for_                                                                      Running test 32/52: test_lists_no_tags_initially (tags_tests.TagsTests                                                                      Running test 33/52: test_raises_error_for_reused_tag (tags_tests.TagsT                                                                      Running test 34/52: test_raises_error_if_both_mount_points_not_set (ta                                                                      Running test 35/52: test_remembers_order (tags_tests.TagsTests.test_re                                                                      Running test 36/52: test_returns_builder_when_given_target_mount_point                                                                      Running test 37/52: test_set_builder_mount_point_raises_error_for_doub                                                                      Running test 38/52: test_set_builder_mount_point_raises_error_for_unkn                                                                      Running test 39/52: test_set_dev_raises_error_for_double_dev (tags_tes                                                                      Running test 40/52: test_set_dev_raises_error_for_unknown_tag (tags_te                                                                      Running test 41/52: test_set_dm (tags_tests.TagsTests.test_set_dm)                                                                  Running test 42/52: test_set_dm_raises_error_for_double_fstype (tags_t                                                                      Running test 43/52: test_set_fstype (tags_tests.TagsTests.test_set_fst                                                                      Running test 44/52: test_set_fstype_raises_error_for_double_fstype (ta                                                                      Running test 45/52: test_set_fsuuid (tags_tests.TagsTests.test_set_fsu                                                                      Running test 46/52: test_set_fsuuid_raises_error_for_double_fstype (ta                                                                      Running test 47/52: test_set_luksuuid (tags_tests.TagsTests.test_set_l                                                                      Running test 48/52: test_set_luksuuid_raises_error_for_double_fstype (                                                                      Running test 49/52: test_set_target_mount_point (tags_tests.TagsTests.                                                                      Running test 50/52: test_set_target_mount_point_raises_error_for_doubl                                                                      Running test 51/52: test_sets_dev (tags_tests.TagsTests.test_sets_dev)                                                                      Running test 52/52: test_tells_if_tag_exists (tags_tests.TagsTests.tes

OK
54 excluded statements
33 excluded modules
Time: 0.4 s

Checking every plugin looks OK ============================================

Running Subplot ============================================
 INFO Starting Subplot
 INFO Subplot finished successfully
srcdir /workspace/src
datadir /tmp/tmpfwvs137w
scenario: Checking the version
  step: given an installed vmdb2
  step: when I run vmdb2 --version
  step: then exit code is 0
  step: then stdout matches regex ^\\d+\\.\\d+$
scenario: Error handling
  step: given an installed vmdb2
  step: given file unhappy.vmdb
  step: when I try to run vmdb2 -v unhappy.vmdb --output=unhappy.img
  step: then exit code is 1
  step: then stdout contains "foo\nyikes\n"
  step: then stdout contains "WAT?!\n"
  step: then stdout contains "foo_teardown\n"
  step: then stdout doesn't contain "bar_step"
  step: then stdout contains "bar_teardown"
scenario: Jinja2 templating in specification file values
  step: given an installed vmdb2
  step: given file j2.vmdb
  step: when I run vmdb2 -v j2.vmdb --output=foo.img
  step: then exit code is 0
  step: then stdout contains "image is foo.img\nbar"
scenario: A happy path
  step: given an installed vmdb2
  step: given file happy.vmdb
  step: when I run vmdb2 -v happy.vmdb --output=happy.img
  step: then exit code is 0
  step: then stdout contains "foo\nbar\nbar_teardown\n"
OK, all scenarios finished successfully

Formatting docs ========================================
make[1]: Leaving directory '/workspace/src'
   create-stamp debian/debhelper-build-stamp
 debian/rules binary
dh binary --with=python3 --buildsystem=pybuild
   dh_testroot -O--buildsystem=pybuild
   dh_prep -O--buildsystem=pybuild
   dh_auto_install --destdir=debian/vmdb2/ -O--buildsystem=pybuild
I: pybuild base:240: /usr/bin/python3 setup.py install --root /workspace/src/debian/vmdb2 
/workspace/src/setup.py:18: DeprecationWarning: The distutils package is deprecated and slated for removal in Python 3.12. Use setuptools or check PEP 632 for potential alternatives
  from distutils.core import setup
running install
running build
running build_py
package init file 'vmdb/plugins/__init__.py' not found (or not a regular file)
package init file 'vmdb/plugins/__init__.py' not found (or not a regular file)
running build_scripts
running install_lib
creating /workspace/src/debian/vmdb2/usr
creating /workspace/src/debian/vmdb2/usr/lib
creating /workspace/src/debian/vmdb2/usr/lib/python3.11
creating /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages
creating /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/spec.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/runcmd.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/step_list.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/app.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/__init__.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugin_tests.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/step_list_tests.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/unmount_tests.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/tags.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/spec_tests.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/version.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/state.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/tags_tests.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/unmount.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb
creating /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/debootstrap_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/fstab_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/cryptsetup_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/mount_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/echo_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/vgcreate_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/shell_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/set_part_flag_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/mkfs_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/virtualfs_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/lvcreate_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/cache_rootfs_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/mkimg_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/kpartx_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/mkpart_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/chroot_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/error_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/apt_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/resize_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/copy_dir_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/grub_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/create_dir_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/create_file_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/lvscan_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/copy_file_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/mklabel_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/ansible_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/unpack_rootfs_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/spec.py to spec.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/runcmd.py to runcmd.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/step_list.py to step_list.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/app.py to app.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/__init__.py to __init__.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugin_tests.py to plugin_tests.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/step_list_tests.py to step_list_tests.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/unmount_tests.py to unmount_tests.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/tags.py to tags.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugin.py to plugin.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/spec_tests.py to spec_tests.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/version.py to version.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/state.py to state.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/tags_tests.py to tags_tests.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/unmount.py to unmount.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/debootstrap_plugin.py to debootstrap_plugin.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/fstab_plugin.py to fstab_plugin.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/cryptsetup_plugin.py to cryptsetup_plugin.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/mount_plugin.py to mount_plugin.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/echo_plugin.py to echo_plugin.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/vgcreate_plugin.py to vgcreate_plugin.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/shell_plugin.py to shell_plugin.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/set_part_flag_plugin.py to set_part_flag_plugin.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/mkfs_plugin.py to mkfs_plugin.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/virtualfs_plugin.py to virtualfs_plugin.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/lvcreate_plugin.py to lvcreate_plugin.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/cache_rootfs_plugin.py to cache_rootfs_plugin.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/mkimg_plugin.py to mkimg_plugin.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/kpartx_plugin.py to kpartx_plugin.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/mkpart_plugin.py to mkpart_plugin.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/chroot_plugin.py to chroot_plugin.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/error_plugin.py to error_plugin.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/apt_plugin.py to apt_plugin.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/resize_plugin.py to resize_plugin.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/copy_dir_plugin.py to copy_dir_plugin.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/grub_plugin.py to grub_plugin.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/create_dir_plugin.py to create_dir_plugin.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/create_file_plugin.py to create_file_plugin.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/lvscan_plugin.py to lvscan_plugin.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/copy_file_plugin.py to copy_file_plugin.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/mklabel_plugin.py to mklabel_plugin.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/ansible_plugin.py to ansible_plugin.cpython-311.pyc
byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/unpack_rootfs_plugin.py to unpack_rootfs_plugin.cpython-311.pyc
running install_scripts
creating /workspace/src/debian/vmdb2/usr/bin
copying build/scripts-3.11/vmdb2 -> /workspace/src/debian/vmdb2/usr/bin
changing mode of /workspace/src/debian/vmdb2/usr/bin/vmdb2 to 755
running install_data
creating /workspace/src/debian/vmdb2/usr/share
creating /workspace/src/debian/vmdb2/usr/share/man
creating /workspace/src/debian/vmdb2/usr/share/man/man1
copying vmdb2.1 -> /workspace/src/debian/vmdb2/usr/share/man/man1
running install_egg_info
Writing /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb2-0.41.egg-info
   dh_installdocs -O--buildsystem=pybuild
   dh_installchangelogs -O--buildsystem=pybuild
   dh_installman -O--buildsystem=pybuild
   dh_systemd_enable -O--buildsystem=pybuild
   dh_python3 -O--buildsystem=pybuild
   dh_installinit -O--buildsystem=pybuild
   dh_systemd_start -O--buildsystem=pybuild
   dh_perl -O--buildsystem=pybuild
   dh_link -O--buildsystem=pybuild
   dh_strip_nondeterminism -O--buildsystem=pybuild
   dh_compress -O--buildsystem=pybuild
   dh_fixperms -O--buildsystem=pybuild
   dh_missing -O--buildsystem=pybuild
   dh_installdeb -O--buildsystem=pybuild
   dh_gencontrol -O--buildsystem=pybuild
   dh_md5sums -O--buildsystem=pybuild
   dh_builddeb -O--buildsystem=pybuild
dpkg-deb: building package 'vmdb2' in '../vmdb2_0.41.ci20250818T110524-1_all.deb'.
 dpkg-genbuildinfo -O../vmdb2_0.41.ci20250818T110524-1_amd64.buildinfo
 dpkg-genchanges -O../vmdb2_0.41.ci20250818T110524-1_amd64.changes
dpkg-genchanges: info: including full source code in upload
 dpkg-source --after-build .
dpkg-buildpackage: info: full upload (original source is included)
+ ls -l ..
total 148
drwxr-xr-x 2 root root  4096 Aug 18 11:05 artifacts
drwxr-xr-x 2 root root  4096 Aug 16 05:30 cache
drwxr-xr-x 2 root root  4096 Aug 16 05:30 deps
drwxr-xr-x 9 root root  4096 Aug 18 11:05 src
-rw-r--r-- 1 root root 23696 Aug 18 11:05 vmdb2_0.41.ci20250818T110524-1.debian.tar.xz
-rw-r--r-- 1 root root   977 Aug 18 11:05 vmdb2_0.41.ci20250818T110524-1.dsc
-rw-r--r-- 1 root root 26868 Aug 18 11:05 vmdb2_0.41.ci20250818T110524-1_all.deb
-rw-r--r-- 1 root root  6108 Aug 18 11:05 vmdb2_0.41.ci20250818T110524-1_amd64.buildinfo
-rw-r--r-- 1 root root  1956 Aug 18 11:05 vmdb2_0.41.ci20250818T110524-1_amd64.changes
-rw-r--r-- 1 root root 64380 Aug 18 11:05 vmdb2_0.41.ci20250818T110524.orig.tar.xz
+ for x in ../*.deb
+ dpkg -c ../vmdb2_0.41.ci20250818T110524-1_all.deb
drwxr-xr-x root/root         0 2025-08-18 11:05 ./
drwxr-xr-x root/root         0 2025-08-18 11:05 ./usr/
drwxr-xr-x root/root         0 2025-08-18 11:05 ./usr/bin/
-rwxr-xr-x root/root        76 2025-08-18 11:05 ./usr/bin/vmdb2
drwxr-xr-x root/root         0 2025-08-18 11:05 ./usr/lib/
drwxr-xr-x root/root         0 2025-08-18 11:05 ./usr/lib/python3/
drwxr-xr-x root/root         0 2025-08-18 11:05 ./usr/lib/python3/dist-packages/
drwxr-xr-x root/root         0 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/
-rw-r--r-- root/root      1488 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/__init__.py
-rw-r--r-- root/root      8321 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/app.py
-rw-r--r-- root/root      1687 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugin.py
-rw-r--r-- root/root      1922 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugin_tests.py
drwxr-xr-x root/root         0 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/
-rw-r--r-- root/root      3286 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/ansible_plugin.py
-rw-r--r-- root/root      2578 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/apt_plugin.py
-rw-r--r-- root/root      2419 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/cache_rootfs_plugin.py
-rw-r--r-- root/root      1186 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/chroot_plugin.py
-rw-r--r-- root/root      3984 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/copy_dir_plugin.py
-rw-r--r-- root/root      1795 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/copy_file_plugin.py
-rw-r--r-- root/root      1463 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/create_dir_plugin.py
-rw-r--r-- root/root      1612 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/create_file_plugin.py
-rw-r--r-- root/root      4805 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/cryptsetup_plugin.py
-rw-r--r-- root/root      4942 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/debootstrap_plugin.py
-rw-r--r-- root/root      1256 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/echo_plugin.py
-rw-r--r-- root/root      1438 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/error_plugin.py
-rw-r--r-- root/root      2920 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/fstab_plugin.py
-rw-r--r-- root/root     15713 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/grub_plugin.py
-rw-r--r-- root/root      3513 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/kpartx_plugin.py
-rw-r--r-- root/root      1520 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/lvcreate_plugin.py
-rw-r--r-- root/root      2336 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/lvscan_plugin.py
-rw-r--r-- root/root      3108 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/mkfs_plugin.py
-rw-r--r-- root/root      1395 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/mkimg_plugin.py
-rw-r--r-- root/root      1139 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/mklabel_plugin.py
-rw-r--r-- root/root      4654 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/mkpart_plugin.py
-rw-r--r-- root/root      4046 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/mount_plugin.py
-rw-r--r-- root/root      3295 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/resize_plugin.py
-rw-r--r-- root/root      1915 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/set_part_flag_plugin.py
-rw-r--r-- root/root      1210 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/shell_plugin.py
-rw-r--r-- root/root      1582 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/unpack_rootfs_plugin.py
-rw-r--r-- root/root      1539 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/vgcreate_plugin.py
-rw-r--r-- root/root      2546 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/virtualfs_plugin.py
-rw-r--r-- root/root      3201 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/runcmd.py
-rw-r--r-- root/root      1488 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/spec.py
-rw-r--r-- root/root      2687 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/spec_tests.py
-rw-r--r-- root/root       973 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/state.py
-rw-r--r-- root/root      4277 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/step_list.py
-rw-r--r-- root/root      3642 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/step_list_tests.py
-rw-r--r-- root/root      5356 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/tags.py
-rw-r--r-- root/root      6873 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/tags_tests.py
-rw-r--r-- root/root      2444 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/unmount.py
-rw-r--r-- root/root      2109 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/unmount_tests.py
-rw-r--r-- root/root        48 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/version.py
-rw-r--r-- root/root       241 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb2-0.41.egg-info
drwxr-xr-x root/root         0 2025-08-18 11:05 ./usr/share/
drwxr-xr-x root/root         0 2025-08-18 11:05 ./usr/share/doc/
drwxr-xr-x root/root         0 2025-08-18 11:05 ./usr/share/doc/vmdb2/
-rw-r--r-- root/root       685 2025-08-18 11:05 ./usr/share/doc/vmdb2/changelog.Debian.gz
-rw-r--r-- root/root       979 2025-08-18 11:05 ./usr/share/doc/vmdb2/copyright
drwxr-xr-x root/root         0 2025-08-18 11:05 ./usr/share/man/
drwxr-xr-x root/root         0 2025-08-18 11:05 ./usr/share/man/man1/
-rw-r--r-- root/root      1047 2025-08-18 11:05 ./usr/share/man/man1/vmdb2.1.gz
+ mv ../vmdb2_0.41.ci20250818T110524-1.debian.tar.xz ../vmdb2_0.41.ci20250818T110524-1.dsc ../vmdb2_0.41.ci20250818T110524-1_all.deb ../vmdb2_0.41.ci20250818T110524-1_amd64.buildinfo ../vmdb2_0.41.ci20250818T110524-1_amd64.changes ../vmdb2_0.41.ci20250818T110524.orig.tar.xz /workspace/artifacts
RUN: Action finished OK
RUN: Action TarCreate {
    archive: "/dev/vde",
    directory: "/workspace/cache",
}
[2025-08-18T11:05:31Z DEBUG ambient_ci::action] Plan::execute: TarCreate {
        archive: "/dev/vde",
        directory: "/workspace/cache",
    }
[2025-08-18T11:05:31Z TRACE ambient_ci::vdrive] creating virtual drive (tar archive): VirtualDriveBuilder {
        filename: Some(
            "/dev/vde",
        ),
        root: Some(
            "/workspace/cache",
        ),
        size: None,
    }
[2025-08-18T11:05:31Z TRACE ambient_ci::vdrive] tar archive to be created: /dev/vde; exists? true
[2025-08-18T11:05:31Z TRACE ambient_ci::vdrive] create archive file /dev/vde
[2025-08-18T11:05:31Z TRACE ambient_ci::vdrive] directory /workspace/cache exists? true
[2025-08-18T11:05:31Z TRACE ambient_ci::vdrive] add contents of /workspace/cache as .
[2025-08-18T11:05:31Z TRACE ambient_ci::vdrive] created virtual drive /dev/vde
RUN: Action finished OK
RUN: Action TarCreate {
    archive: "/dev/vdd",
    directory: "/workspace/artifacts",
}
[2025-08-18T11:05:31Z DEBUG ambient_ci::action] Plan::execute: TarCreate {
        archive: "/dev/vdd",
        directory: "/workspace/artifacts",
    }
[2025-08-18T11:05:31Z TRACE ambient_ci::vdrive] creating virtual drive (tar archive): VirtualDriveBuilder {
        filename: Some(
            "/dev/vdd",
        ),
        root: Some(
            "/workspace/artifacts",
        ),
        size: None,
    }
[2025-08-18T11:05:31Z TRACE ambient_ci::vdrive] tar archive to be created: /dev/vdd; exists? true
[2025-08-18T11:05:31Z TRACE ambient_ci::vdrive] create archive file /dev/vdd
[2025-08-18T11:05:31Z TRACE ambient_ci::vdrive] directory /workspace/artifacts exists? true
[2025-08-18T11:05:31Z TRACE ambient_ci::vdrive] add contents of /workspace/artifacts as .
[2025-08-18T11:05:31Z TRACE ambient_ci::vdrive] created virtual drive /dev/vdd
RUN: Action finished OK
ambient-execute-plan ends
EXIT CODE: 0
[2025-08-18T11:05:35Z INFO  ambient] ambient ends successfully

Trigger message

{
  "request": "trigger",
  "version": 1,
  "event_type": "push",
  "repository": {
    "id": "rad:z2kxCtBwDQMPcaf9vGTNH5nYkp9qk",
    "name": "vmdb2",
    "description": "Debian virtual machine image builder",
    "private": false,
    "default_branch": "main",
    "delegates": [
      "did:key:z6MkgEMYod7Hxfy9qCvDv5hYHkZ4ciWmLFgfvm3Wn1b2w2FV"
    ]
  },
  "pusher": {
    "id": "did:key:z6MkkYez6QAFWvmdudjrfMXySu1NTpSrraJotCJFwGgkmgx8",
    "alias": "ci0"
  },
  "before": "af6685a991008df668d5c7eb1c7df7a9efcabcec",
  "after": "af6685a991008df668d5c7eb1c7df7a9efcabcec",
  "branch": "main",
  "commits": [
    "af6685a991008df668d5c7eb1c7df7a9efcabcec"
  ]
}

Ambient stdout

[2025-08-18T11:05:12Z INFO  ambient] ambient starts
[2025-08-18T11:05:12Z DEBUG ambient] load default configuration file /home/_rad/.config/ambient/config.yaml if it exists
[2025-08-18T11:05:12Z DEBUG ambient] load files named with --config: /tmp/.tmp7SIm0D/ambient_extra_values.yaml
[2025-08-18T11:05:12Z DEBUG ambient] complete configuration: Config {
        tmpdir: "/srv/tmp",
        image_store: "/home/_rad/.local/state/ambient-ci/images",
        projects: "/home/_rad/ambient-projects.yaml",
        state: "/srv/ambient-state",
        rsync_target: Some(
            "ci@http.liw.fi:/srv/http/vmdb2-manual.liw.fi",
        ),
        rsync_target_base: None,
        rsync_target_map: None,
        dput_target: Some(
            "apt.liw.fi",
        ),
        executor: Some(
            "/usr/bin/ambient-execute-plan",
        ),
        artifacts_max_size: Byte(
            10000000000,
        ),
        cache_max_size: Byte(
            50000000000,
        ),
        qemu: QemuConfig {
            cpus: 4,
            memory: Byte(
                8000000000,
            ),
            kvm_binary: "/usr/bin/kvm",
            ovmf_vars_file: "/usr/share/ovmf/OVMF.fd",
            ovmf_code_file: "/usr/share/ovmf/OVMF.fd",
        },
    }
[2025-08-18T11:05:12Z DEBUG ambient] configuration: Config {
        tmpdir: "/srv/tmp",
        image_store: "/home/_rad/.local/state/ambient-ci/images",
        projects: "/home/_rad/ambient-projects.yaml",
        state: "/srv/ambient-state",
        rsync_target: Some(
            "ci@http.liw.fi:/srv/http/vmdb2-manual.liw.fi",
        ),
        rsync_target_base: None,
        rsync_target_map: None,
        dput_target: Some(
            "apt.liw.fi",
        ),
        executor: Some(
            "/usr/bin/ambient-execute-plan",
        ),
        artifacts_max_size: Byte(
            10000000000,
        ),
        cache_max_size: Byte(
            50000000000,
        ),
        qemu: QemuConfig {
            cpus: 4,
            memory: Byte(
                8000000000,
            ),
            kvm_binary: "/usr/bin/kvm",
            ovmf_vars_file: "/usr/share/ovmf/OVMF.fd",
            ovmf_code_file: "/usr/share/ovmf/OVMF.fd",
        },
    }
[2025-08-18T11:05:12Z DEBUG ambient_ci::project] load project state from /srv/ambient-state/vmdb2/meta.yaml
[2025-08-18T11:05:12Z DEBUG ambient_ci::run] latest commit: "af6685a991008df668d5c7eb1c7df7a9efcabcec"
[2025-08-18T11:05:12Z DEBUG ambient_ci::run] is a git repository
[2025-08-18T11:05:12Z DEBUG ambient_ci::run] git repository is clean
[2025-08-18T11:05:12Z DEBUG ambient_ci::run] current (HEAD) commit: af6685a991008df668d5c7eb1c7df7a9efcabcec
[2025-08-18T11:05:12Z DEBUG ambient_ci::run] no dry run requested
[2025-08-18T11:05:12Z DEBUG ambient_ci::run] forced run requested
[2025-08-18T11:05:12Z DEBUG ambient_ci::run] run? true
[2025-08-18T11:05:12Z INFO  ambient_ci::run] project vmdb2: running CI
[2025-08-18T11:05:12Z DEBUG ambient_ci::run] Executing pre-plan steps
[2025-08-18T11:05:12Z DEBUG ambient_ci::run] create virtual drive /srv/tmp/.tmpVwXJeB/src.tar
[2025-08-18T11:05:12Z DEBUG ambient_ci::run] create virtual drive /srv/tmp/.tmpVwXJeB/deps.tar
[2025-08-18T11:05:12Z DEBUG ambient_ci::run] create_executor_vdrive: executor="/usr/bin/ambient-execute-plan"
[2025-08-18T11:05:12Z DEBUG ambient_ci::run] create_executor_vdrive: plan=RunnablePlan {
        steps: [
            Mkdir {
                pathname: "/workspace",
            },
            Mkdir {
                pathname: "/workspace/artifacts",
            },
            TarExtract {
                archive: "/dev/vdc",
                directory: "/workspace/src",
            },
            TarExtract {
                archive: "/dev/vdf",
                directory: "/workspace/deps",
            },
            TarExtract {
                archive: "/dev/vde",
                directory: "/workspace/cache",
            },
            Spawn {
                argv: [
                    "find",
                    "/workspace",
                    "-maxdepth",
                    "2",
                    "-ls",
                ],
            },
            Shell {
                shell: "./format.sh\ncp vmdb2.html /workspace/artifacts/index.html\n",
            },
            Shell {
                shell: "export DEBEMAIL=liw@liw.fi\nexport DEBFULLNAME=\"Lars Wirzenius\"\nexport HOME=/root\nexport PATH=\"/root/.cargo/bin:/bin:/sbin\"\nexport SOPASS_LOG=trace\nexport CARGO_TARGET_DIR=/workspace/cache\nexport CARGO_HOME=/workspace/deps\n\n./check\n\ngit clean -fdx\n\nV=\"$(dpkg-parsechangelog -SVersion | sed 's/-[^-]*$//')\"\nT=\"$(date -u \"+%Y%m%dT%H%M%S\")\"\nversion=\"$V.ci$T-1\"\ndch -v \"$version\" \"CI build under Ambient.\"\ndch -r ''\n",
            },
            Deb,
            TarCreate {
                archive: "/dev/vde",
                directory: "/workspace/cache",
            },
            TarCreate {
                archive: "/dev/vdd",
                directory: "/workspace/artifacts",
            },
        ],
        executor_drive: Some(
            "/dev/vdb",
        ),
        source_drive: Some(
            "/dev/vdc",
        ),
        artifact_drive: Some(
            "/dev/vdd",
        ),
        cache_drive: Some(
            "/dev/vde",
        ),
        deps_drive: Some(
            "/dev/vdf",
        ),
        workspace_dir: Some(
            "/workspace",
        ),
        source_dir: Some(
            "/workspace/src",
        ),
        deps_dir: Some(
            "/workspace/deps",
        ),
        cache_dir: Some(
            "/workspace/cache",
        ),
        artifacts_dir: Some(
            "/workspace/artifacts",
        ),
    }
[2025-08-18T11:05:12Z DEBUG ambient_ci::run] executor bin /usr/bin/ambient-execute-plan
[2025-08-18T11:05:12Z DEBUG ambient_ci::run] copying /usr/bin/ambient-execute-plan to /srv/tmp/.tmpVwXJeB/ambient-execute-plan/run-ci
[2025-08-18T11:05:12Z DEBUG ambient_ci::run] copy OK: true
[2025-08-18T11:05:12Z DEBUG ambient_ci::run] create virtual drive /srv/tmp/.tmpVwXJeB/executor.tar
[2025-08-18T11:05:12Z DEBUG ambient_ci::project] removing run log file /srv/ambient-state/vmdb2/run.log
[2025-08-18T11:05:12Z DEBUG ambient_ci::project] statedir is /srv/ambient-state/vmdb2, exists? true
[2025-08-18T11:05:12Z DEBUG ambient_ci::project] creating run log file /srv/ambient-state/vmdb2/run.log
[2025-08-18T11:05:12Z DEBUG ambient_ci::project] created run log file /srv/ambient-state/vmdb2/run.log OK
[2025-08-18T11:05:12Z DEBUG ambient_ci::cloud_init] with_hostname called: "ambient"
[2025-08-18T11:05:12Z DEBUG ambient_ci::cloud_init] with_runcmd called: "echo xyzzy > /dev/ttyS1"
[2025-08-18T11:05:12Z DEBUG ambient_ci::cloud_init] with_runcmd called: "\n(set -xeu\nenv\ndir=\"$(mktemp -d)\"\ncd \"$dir\"\ntar -xvf /dev/vdb\nfind -ls || true\nldd ./run-ci || true\necho ================================ BEGIN ================================\nexport RUST_BACKTRACE=1\nif ./run-ci; then\n        echo \"EXIT CODE: 0\"\nelse\n        echo \"EXIT CODE: $?\"\nfi) > /dev/ttyS1 2>&1\n"
[2025-08-18T11:05:12Z DEBUG ambient_ci::cloud_init] with_runcmd called: "poweroff"
[2025-08-18T11:05:12Z DEBUG ambient_ci::cloud_init] LocalDataStoreBuilder: LocalDataStoreBuilder {
        hostname: Some(
            "ambient",
        ),
        network: false,
        bootcmd: [],
        runcmd: [
            "echo xyzzy > /dev/ttyS1",
            "\n(set -xeu\nenv\ndir=\"$(mktemp -d)\"\ncd \"$dir\"\ntar -xvf /dev/vdb\nfind -ls || true\nldd ./run-ci || true\necho ================================ BEGIN ================================\nexport RUST_BACKTRACE=1\nif ./run-ci; then\n        echo \"EXIT CODE: 0\"\nelse\n        echo \"EXIT CODE: $?\"\nfi) > /dev/ttyS1 2>&1\n",
            "poweroff",
        ],
    }
[2025-08-18T11:05:12Z DEBUG ambient_ci::qemu] run QEMU
[2025-08-18T11:05:12Z DEBUG ambient_ci::qemu] create copy-on-write image and UEFI vars file
[2025-08-18T11:05:12Z DEBUG ambient_ci::qemu_utils] qemu-img create /srv/tmp/.tmpYwSwrD/.tmpxijxFx/vm.qcow2 backing on /home/_rad/ambient.qcow2
[2025-08-18T11:05:12Z DEBUG ambient_ci::qemu] create cloud-init ISO file
[2025-08-18T11:05:12Z DEBUG ambient_ci::cloud_init] LocalDataStore: LocalDataStore {
        hostname: "ambient",
        network: false,
        bootcmd: [],
        runcmd: [
            "echo xyzzy > /dev/ttyS1",
            "\n(set -xeu\nenv\ndir=\"$(mktemp -d)\"\ncd \"$dir\"\ntar -xvf /dev/vdb\nfind -ls || true\nldd ./run-ci || true\necho ================================ BEGIN ================================\nexport RUST_BACKTRACE=1\nif ./run-ci; then\n        echo \"EXIT CODE: 0\"\nelse\n        echo \"EXIT CODE: $?\"\nfi) > /dev/ttyS1 2>&1\n",
            "poweroff",
        ],
    }
[2025-08-18T11:05:12Z DEBUG ambient_ci::cloud_init] write /tmp/.tmpfDht8h/meta-data
[2025-08-18T11:05:12Z DEBUG ambient_ci::cloud_init] write /tmp/.tmpfDht8h/user-data
[2025-08-18T11:05:12Z DEBUG ambient_ci::qemu] set console log file to /srv/tmp/.tmpYwSwrD/.tmpxijxFx/console.log
[2025-08-18T11:05:12Z DEBUG ambient_ci::util] create file /srv/tmp/.tmpYwSwrD/.tmpxijxFx/console.log
[2025-08-18T11:05:12Z DEBUG ambient_ci::qemu] set run file to /srv/ambient-state/vmdb2/run.log
[2025-08-18T11:05:12Z DEBUG ambient_ci::util] create file /srv/ambient-state/vmdb2/run.log
[2025-08-18T11:05:12Z DEBUG ambient_ci::qemu] run QEMU: QemuArgs {
        args: [
            "-m",
            "7629",
            "-smp",
            "cpus=4",
            "-cpu",
            "kvm64",
            "-machine",
            "type=q35,accel=kvm,usb=off",
            "-uuid",
            "a85c9de7-edc0-4e54-bead-112e5733582c",
            "-boot",
            "strict=on",
            "-name",
            "ambient-ci-vm",
            "-rtc",
            "base=utc,driftfix=slew",
            "-display",
            "none",
            "-device",
            "virtio-rng-pci",
            "-serial",
            "file:/srv/tmp/.tmpYwSwrD/.tmpxijxFx/console.log",
            "-serial",
            "file:/srv/ambient-state/vmdb2/run.log",
            "-drive",
            "if=pflash,format=raw,unit=0,file=/usr/share/ovmf/OVMF.fd,readonly=on",
            "-drive",
            "if=pflash,format=raw,unit=1,file=/srv/tmp/.tmpYwSwrD/.tmpxijxFx/vars.fd",
            "-drive",
            "format=qcow2,if=virtio,file=/srv/tmp/.tmpYwSwrD/.tmpxijxFx/vm.qcow2",
            "-drive",
            "format=raw,if=virtio,file=/srv/tmp/.tmpVwXJeB/executor.tar,readonly=on",
            "-cdrom",
            "/srv/tmp/.tmpYwSwrD/.tmpxijxFx/cloud_init.iso",
            "-drive",
            "format=raw,if=virtio,file=/srv/tmp/.tmpVwXJeB/src.tar,readonly=on",
            "-drive",
            "format=raw,if=virtio,file=/srv/tmp/.tmpVwXJeB/artifacts.tar",
            "-drive",
            "format=raw,if=virtio,file=/srv/tmp/.tmpVwXJeB/cache.tar",
            "-drive",
            "format=raw,if=virtio,file=/srv/tmp/.tmpVwXJeB/deps.tar,readonly=on",
            "-nodefaults",
            "-no-user-config",
        ],
    }
[2025-08-18T11:05:33Z DEBUG ambient_ci::qemu] QEMU finished OK
[2025-08-18T11:05:33Z DEBUG ambient_ci::qemu] run log:
    --------------------==========
    [2025-08-18T11:05:20Z TRACE ambient_execute_plan] ambient-execute-plan starts
    [2025-08-18T11:05:20Z DEBUG ambient_execute_plan] ambient-execute-plan starts
    [2025-08-18T11:05:20Z INFO  ambient_execute_plan] ambient-execute-plan starts
    [2025-08-18T11:05:20Z WARN  ambient_execute_plan] ambient-execute-plan starts
    [2025-08-18T11:05:20Z ERROR ambient_execute_plan] ambient-execute-plan starts
    RunnablePlan::from_file: filename=plan.yaml
    steps:
    - action: mkdir
      pathname: /workspace
    - action: mkdir
      pathname: /workspace/artifacts
    - action: tar_extract
      archive: /dev/vdc
      directory: /workspace/src
    - action: tar_extract
      archive: /dev/vdf
      directory: /workspace/deps
    - action: tar_extract
      archive: /dev/vde
      directory: /workspace/cache
    - action: spawn
      argv:
      - find
      - /workspace
      - '-maxdepth'
      - '2'
      - '-ls'
    - action: shell
      shell: |
        ./format.sh
        cp vmdb2.html /workspace/artifacts/index.html
    - action: shell
      shell: |
        export DEBEMAIL=liw@liw.fi
        export DEBFULLNAME="Lars Wirzenius"
        export HOME=/root
        export PATH="/root/.cargo/bin:/bin:/sbin"
        export SOPASS_LOG=trace
        export CARGO_TARGET_DIR=/workspace/cache
        export CARGO_HOME=/workspace/deps
    
        ./check
    
        git clean -fdx
    
        V="$(dpkg-parsechangelog -SVersion | sed 's/-[^-]*$//')"
        T="$(date -u "+%Y%m%dT%H%M%S")"
        version="$V.ci$T-1"
        dch -v "$version" "CI build under Ambient."
        dch -r ''
    - action: deb
    - action: tar_create
      archive: /dev/vde
      directory: /workspace/cache
    - action: tar_create
      archive: /dev/vdd
      directory: /workspace/artifacts
    executor_drive: /dev/vdb
    source_drive: /dev/vdc
    artifact_drive: /dev/vdd
    cache_drive: /dev/vde
    deps_drive: /dev/vdf
    workspace_dir: /workspace
    source_dir: /workspace/src
    deps_dir: /workspace/deps
    cache_dir: /workspace/cache
    artifacts_dir: /workspace/artifacts
    
    
    RUN: Action Mkdir {
        pathname: "/workspace",
    }
    [2025-08-18T11:05:20Z DEBUG ambient_ci::action] Plan::execute: Mkdir {
            pathname: "/workspace",
        }
    RUN: Action finished OK
    RUN: Action Mkdir {
        pathname: "/workspace/artifacts",
    }
    [2025-08-18T11:05:20Z DEBUG ambient_ci::action] Plan::execute: Mkdir {
            pathname: "/workspace/artifacts",
        }
    RUN: Action finished OK
    RUN: Action TarExtract {
        archive: "/dev/vdc",
        directory: "/workspace/src",
    }
    [2025-08-18T11:05:20Z DEBUG ambient_ci::action] Plan::execute: TarExtract {
            archive: "/dev/vdc",
            directory: "/workspace/src",
        }
    [2025-08-18T11:05:20Z TRACE ambient_ci::vdrive] extracting /dev/vdc to /workspace/src
    [2025-08-18T11:05:20Z TRACE ambient_ci::vdrive] extraction OK
    RUN: Action finished OK
    RUN: Action TarExtract {
        archive: "/dev/vdf",
        directory: "/workspace/deps",
    }
    [2025-08-18T11:05:20Z DEBUG ambient_ci::action] Plan::execute: TarExtract {
            archive: "/dev/vdf",
            directory: "/workspace/deps",
        }
    [2025-08-18T11:05:20Z TRACE ambient_ci::vdrive] extracting /dev/vdf to /workspace/deps
    [2025-08-18T11:05:21Z TRACE ambient_ci::vdrive] extraction OK
    RUN: Action finished OK
    RUN: Action TarExtract {
        archive: "/dev/vde",
        directory: "/workspace/cache",
    }
    [2025-08-18T11:05:21Z DEBUG ambient_ci::action] Plan::execute: TarExtract {
            archive: "/dev/vde",
            directory: "/workspace/cache",
        }
    [2025-08-18T11:05:21Z TRACE ambient_ci::vdrive] extracting /dev/vde to /workspace/cache
    [2025-08-18T11:05:21Z TRACE ambient_ci::vdrive] extraction OK
    RUN: Action finished OK
    RUN: Action Spawn {
        argv: [
            "find",
            "/workspace",
            "-maxdepth",
            "2",
            "-ls",
        ],
    }
    [2025-08-18T11:05:21Z DEBUG ambient_ci::action] Plan::execute: Spawn {
            argv: [
                "find",
                "/workspace",
                "-maxdepth",
                "2",
                "-ls",
            ],
        }
    SPAWN: argv=["find", "/workspace", "-maxdepth", "2", "-ls"]
           cwd=/workspace/src (exists? true)
           extra_env=[]
      3932161      4 drwxr-xr-x   6 root     root         4096 Aug 18 11:05 /workspace
      3932162      4 drwxr-xr-x   2 root     root         4096 Aug 18 11:05 /workspace/artifacts
      3932734      4 drwxr-xr-x   2 root     root         4096 Aug 16 05:30 /workspace/deps
      3932163      4 drwxr-xr-x   7 root     root         4096 Aug 18 11:05 /workspace/src
      3932733      4 -rw-r--r--   1 root     root         1264 Aug 18 11:05 /workspace/src/smoke-ppc64el.vmdb
      3932165      4 drwxr-xr-x   2 root     root         4096 Aug 18 11:05 /workspace/src/.radicle
      3932181      4 -rw-r--r--   1 root     root         1976 Aug 18 11:05 /workspace/src/smoke-ppc64el.yarn
      3932726      4 -rw-r--r--   1 root     root            8 Aug 18 11:05 /workspace/src/lvm2.lukskey
      3932186      4 -rwxr-xr-x   1 root     root          101 Aug 18 11:05 /workspace/src/smoke-ppc64el.sh
      3932727      4 -rw-r--r--   1 root     root          211 Aug 18 11:05 /workspace/src/vmdb2.yaml
      3932168      8 -rwxr-xr-x   1 root     root         5713 Aug 18 11:05 /workspace/src/check-one
      3932164      4 -rwxr-xr-x   1 root     root           76 Aug 18 11:05 /workspace/src/vmdb2
      3932182      4 -rwxr-xr-x   1 root     root          516 Aug 18 11:05 /workspace/src/check-external
      3932178      4 -rw-r--r--   1 root     root         1153 Aug 18 11:05 /workspace/src/base.vmdb
      3932728      4 -rwxr-xr-x   1 root     root          304 Aug 18 11:05 /workspace/src/format.sh
      3932183      4 -rwxr-xr-x   1 root     root          308 Aug 18 11:05 /workspace/src/check-all
      3932200      4 -rw-r--r--   1 root     root           12 Aug 18 11:05 /workspace/src/.gitignore
      3932167      4 -rw-r--r--   1 root     root          985 Aug 18 11:05 /workspace/src/ppc64el.vmdb
      3932729      4 -rw-r--r--   1 root     root          504 Aug 18 11:05 /workspace/src/vmdb2.css
      3932653     12 -rw-r--r--   1 root     root        10708 Aug 18 11:05 /workspace/src/vmdb2.md
      3932725      4 -rw-r--r--   1 root     root          143 Aug 18 11:05 /workspace/src/ansible.yml
      3932202      4 drwxr-xr-x   8 root     root         4096 Aug 18 11:05 /workspace/src/.git
      3932731      4 -rwxr-xr-x   1 root     root         1083 Aug 18 11:05 /workspace/src/check-images
      3932187      4 drwxr-xr-x   3 root     root         4096 Aug 18 11:05 /workspace/src/debian
      3932201      4 -rw-r--r--   1 root     root         1057 Aug 18 11:05 /workspace/src/without-tests
      3932177      4 -rw-r--r--   1 root     root          162 Aug 18 11:05 /workspace/src/vmdb2.py
      3932199      8 -rw-r--r--   1 root     root         7962 Aug 18 11:05 /workspace/src/README.md
      3932730      4 -rw-r--r--   1 root     root         2055 Aug 18 11:05 /workspace/src/vmdb2.1
      3932180     24 -rw-r--r--   1 root     root        23398 Aug 18 11:05 /workspace/src/NEWS
      3932179      4 -rwxr-xr-x   1 root     root         1174 Aug 18 11:05 /workspace/src/setup.py
      3932185      4 -rw-r--r--   1 root     root         1271 Aug 18 11:05 /workspace/src/lvm2.vmdb
      3932184      4 -rw-r--r--   1 root     root          235 Aug 18 11:05 /workspace/src/vmdb2.subplot
      3932732      4 -rw-r--r--   1 root     root         3218 Aug 18 11:05 /workspace/src/code-of-conduct.md
      3932654      4 drwxr-xr-x   3 root     root         4096 Aug 18 11:05 /workspace/src/vmdb
      3932176      4 -rwxr-xr-x   1 root     root         1393 Aug 18 11:05 /workspace/src/check
      3932169      4 drwxr-xr-x   4 root     root         4096 Aug 18 11:05 /workspace/src/roles
      3932735      4 drwxr-xr-x   2 root     root         4096 Aug 16 05:30 /workspace/cache
    RUN: Action finished OK
    RUN: Action Shell {
        shell: "./format.sh\ncp vmdb2.html /workspace/artifacts/index.html\n",
    }
    [2025-08-18T11:05:21Z DEBUG ambient_ci::action] Plan::execute: Shell {
            shell: "./format.sh\ncp vmdb2.html /workspace/artifacts/index.html\n",
        }
    SPAWN: argv=["/bin/bash", "-c", "set -xeuo pipefail\n./format.sh\ncp vmdb2.html /workspace/artifacts/index.html\n\n"]
           cwd=/workspace/src (exists? true)
           extra_env=[]
    + ./format.sh
    + cp vmdb2.html /workspace/artifacts/index.html
    RUN: Action finished OK
    RUN: Action Shell {
        shell: "export DEBEMAIL=liw@liw.fi\nexport DEBFULLNAME=\"Lars Wirzenius\"\nexport HOME=/root\nexport PATH=\"/root/.cargo/bin:/bin:/sbin\"\nexport SOPASS_LOG=trace\nexport CARGO_TARGET_DIR=/workspace/cache\nexport CARGO_HOME=/workspace/deps\n\n./check\n\ngit clean -fdx\n\nV=\"$(dpkg-parsechangelog -SVersion | sed 's/-[^-]*$//')\"\nT=\"$(date -u \"+%Y%m%dT%H%M%S\")\"\nversion=\"$V.ci$T-1\"\ndch -v \"$version\" \"CI build under Ambient.\"\ndch -r ''\n",
    }
    [2025-08-18T11:05:22Z DEBUG ambient_ci::action] Plan::execute: Shell {
            shell: "export DEBEMAIL=liw@liw.fi\nexport DEBFULLNAME=\"Lars Wirzenius\"\nexport HOME=/root\nexport PATH=\"/root/.cargo/bin:/bin:/sbin\"\nexport SOPASS_LOG=trace\nexport CARGO_TARGET_DIR=/workspace/cache\nexport CARGO_HOME=/workspace/deps\n\n./check\n\ngit clean -fdx\n\nV=\"$(dpkg-parsechangelog -SVersion | sed 's/-[^-]*$//')\"\nT=\"$(date -u \"+%Y%m%dT%H%M%S\")\"\nversion=\"$V.ci$T-1\"\ndch -v \"$version\" \"CI build under Ambient.\"\ndch -r ''\n",
        }
    SPAWN: argv=["/bin/bash", "-c", "set -xeuo pipefail\nexport DEBEMAIL=liw@liw.fi\nexport DEBFULLNAME=\"Lars Wirzenius\"\nexport HOME=/root\nexport PATH=\"/root/.cargo/bin:/bin:/sbin\"\nexport SOPASS_LOG=trace\nexport CARGO_TARGET_DIR=/workspace/cache\nexport CARGO_HOME=/workspace/deps\n\n./check\n\ngit clean -fdx\n\nV=\"$(dpkg-parsechangelog -SVersion | sed 's/-[^-]*$//')\"\nT=\"$(date -u \"+%Y%m%dT%H%M%S\")\"\nversion=\"$V.ci$T-1\"\ndch -v \"$version\" \"CI build under Ambient.\"\ndch -r ''\n\n"]
           cwd=/workspace/src (exists? true)
           extra_env=[]
    + export DEBEMAIL=liw@liw.fi
    + DEBEMAIL=liw@liw.fi
    + export 'DEBFULLNAME=Lars Wirzenius'
    + DEBFULLNAME='Lars Wirzenius'
    + export HOME=/root
    + HOME=/root
    + export PATH=/root/.cargo/bin:/bin:/sbin
    + PATH=/root/.cargo/bin:/bin:/sbin
    + export SOPASS_LOG=trace
    + SOPASS_LOG=trace
    + export CARGO_TARGET_DIR=/workspace/cache
    + CARGO_TARGET_DIR=/workspace/cache
    + export CARGO_HOME=/workspace/deps
    + CARGO_HOME=/workspace/deps
    + ./check
    Running unit tests ============================================
    /usr/lib/python3/dist-packages/CoverageTestRunner.py:22: DeprecationWarning: the imp module is deprecated in favour of importlib and slated for removal in Python 3.12; see the module's documentation for alternative uses
      import imp
    Running test 1/52: tests_finds_no_plugin_when_file_has_none (plugin_t                                                                     Running test 2/52: tests_finds_no_plugins_in_empty_directory (plugin_                                                                     Running test 3/52: tests_finds_no_plugins_when_there_are_other_files                                                                      Running test 4/52: tests_finds_plugin_when_there_is_one (plugin_tests                                                                     Running test 5/52: test_sets_app (plugin_tests.PluginTests.test_sets_                                                                     Running test 6/52: test_raises_error_for_missing_mandatory_key (step_                                                                     Running test 7/52: test_raises_error_for_wrong_type_of_value_for_mand                                                                     Running test 8/52: test_raises_error_for_wrong_type_of_value_for_opti                                                                     Running test 9/52: test_returns_actual_value_for_optional_key (step_l                                                                     Running test 10/52: test_returns_default_value_for_missing_optional_ke                                                                      Running test 11/52: test_returns_values_from_step_for_mandatory_keys (                                                                      Running test 12/52: test_adds_a_runner (step_list_tests.StepRunnerList                                                                      Running test 13/52: test_finds_correct_runner (step_list_tests.StepRun                                                                      Running test 14/52: test_is_empty_initially (step_list_tests.StepRunne                                                                      Running test 15/52: test_raises_error_if_runner_not_found (step_list_t                                                                      Running test 16/52: test_raises_error_if_wrong_step_key_values (step_l                                                                      Running test 17/52: test_raises_error_if_not_mounted (unmount_tests.Un                                                                      Running test 18/52: test_unmounts_mounted_dir (unmount_tests.UnmountTe                                                                      Running test 19/52: test_unmounts_mounted_dir_with_submounts (unmount_                                                                      Running test 20/52: test_expands_dict_of_templates (spec_tests.ExpandT                                                                      Running test 21/52: test_expands_list_of_templates (spec_tests.ExpandT                                                                      Running test 22/52: test_expands_simple_string_template (spec_tests.Ex                                                                      Running test 23/52: test_raises_assert_if_given_incomprehensible_value                                                                      Running test 24/52: test_returns_same_given_string_without_template (s                                                                      Running test 25/52: test_expands_templates (spec_tests.SpecTests.test_                                                                      Running test 26/52: test_loads_spec (spec_tests.SpecTests.test_loads_s                                                                      Running test 27/52: test_adds_builder_mount_point (tags_tests.TagsTest                                                                      Running test 28/52: test_builder_mount_point_can_be_made_cached (tags_                                                                      Running test 29/52: test_builder_mount_point_is_uncached_by_default (t                                                                      Running test 30/52: test_get_dev_raises_error_for_unknown_tag (tags_te                                                                      Running test 31/52: test_getting_builder_mount_point_raises_error_for_                                                                      Running test 32/52: test_lists_no_tags_initially (tags_tests.TagsTests                                                                      Running test 33/52: test_raises_error_for_reused_tag (tags_tests.TagsT                                                                      Running test 34/52: test_raises_error_if_both_mount_points_not_set (ta                                                                      Running test 35/52: test_remembers_order (tags_tests.TagsTests.test_re                                                                      Running test 36/52: test_returns_builder_when_given_target_mount_point                                                                      Running test 37/52: test_set_builder_mount_point_raises_error_for_doub                                                                      Running test 38/52: test_set_builder_mount_point_raises_error_for_unkn                                                                      Running test 39/52: test_set_dev_raises_error_for_double_dev (tags_tes                                                                      Running test 40/52: test_set_dev_raises_error_for_unknown_tag (tags_te                                                                      Running test 41/52: test_set_dm (tags_tests.TagsTests.test_set_dm)                                                                  Running test 42/52: test_set_dm_raises_error_for_double_fstype (tags_t                                                                      Running test 43/52: test_set_fstype (tags_tests.TagsTests.test_set_fst                                                                      Running test 44/52: test_set_fstype_raises_error_for_double_fstype (ta                                                                      Running test 45/52: test_set_fsuuid (tags_tests.TagsTests.test_set_fsu                                                                      Running test 46/52: test_set_fsuuid_raises_error_for_double_fstype (ta                                                                      Running test 47/52: test_set_luksuuid (tags_tests.TagsTests.test_set_l                                                                      Running test 48/52: test_set_luksuuid_raises_error_for_double_fstype (                                                                      Running test 49/52: test_set_target_mount_point (tags_tests.TagsTests.                                                                      Running test 50/52: test_set_target_mount_point_raises_error_for_doubl                                                                      Running test 51/52: test_sets_dev (tags_tests.TagsTests.test_sets_dev)                                                                      Running test 52/52: test_tells_if_tag_exists (tags_tests.TagsTests.tes
    
    OK
    54 excluded statements
    33 excluded modules
    Time: 0.3 s
    
    Checking every plugin looks OK ============================================
    
    Running Subplot ============================================
     INFO Starting Subplot
     INFO Subplot finished successfully
    srcdir /workspace/src
    datadir /tmp/tmph7v777cd
    scenario: A happy path
      step: given an installed vmdb2
      step: given file happy.vmdb
      step: when I run vmdb2 -v happy.vmdb --output=happy.img
      step: then exit code is 0
      step: then stdout contains "foo\nbar\nbar_teardown\n"
    scenario: Checking the version
      step: given an installed vmdb2
      step: when I run vmdb2 --version
      step: then exit code is 0
      step: then stdout matches regex ^\\d+\\.\\d+$
    scenario: Error handling
      step: given an installed vmdb2
      step: given file unhappy.vmdb
      step: when I try to run vmdb2 -v unhappy.vmdb --output=unhappy.img
      step: then exit code is 1
      step: then stdout contains "foo\nyikes\n"
      step: then stdout contains "WAT?!\n"
      step: then stdout contains "foo_teardown\n"
      step: then stdout doesn't contain "bar_step"
      step: then stdout contains "bar_teardown"
    scenario: Jinja2 templating in specification file values
      step: given an installed vmdb2
      step: given file j2.vmdb
      step: when I run vmdb2 -v j2.vmdb --output=foo.img
      step: then exit code is 0
      step: then stdout contains "image is foo.img\nbar"
    OK, all scenarios finished successfully
    
    Formatting docs ========================================
    + git clean -fdx
    Removing .coverage
    Removing test.log
    Removing test.py
    Removing vmdb/__pycache__/
    Removing vmdb/plugins/__pycache__/
    Removing vmdb2.html
    ++ dpkg-parsechangelog -SVersion
    ++ sed 's/-[^-]*$//'
    + V=0.41
    ++ date -u +%Y%m%dT%H%M%S
    + T=20250818T110524
    + version=0.41.ci20250818T110524-1
    + dch -v 0.41.ci20250818T110524-1 'CI build under Ambient.'
    + dch -r ''
    RUN: Action finished OK
    RUN: Action Deb
    [2025-08-18T11:05:24Z DEBUG ambient_ci::action] Plan::execute: Deb
    SPAWN: argv=["/bin/bash", "-c", "#!/bin/bash\nset -xeuo pipefail\n\necho \"PATH at start: $PATH\"\nexport PATH=\"/root/.cargo/bin:$PATH\"\nexport CARGO_HOME=/workspace/deps\nexport DEBEMAIL=liw@liw.fi\nexport DEBFULLNAME=\"Lars Wirzenius\"\n/bin/env\n\ncommand -v cargo\ncommand -v rustc\n\ncargo --version\nrustc --version\n\n# Get name and version of source package.\nname=\"$(dpkg-parsechangelog -SSource)\"\nversion=\"$(dpkg-parsechangelog -SVersion)\"\n\n# Get upstream version: everything before the last dash.\nuv=\"$(echo \"$version\" | sed 's/-[^-]*$//')\"\n\n# Files that will be created.\narch=\"$(dpkg --print-architecture)\"\norig=\"../${name}_${uv}.orig.tar.xz\"\ndeb=\"../${name}_${version}_${arch}.deb\"\nchanges=\"../${name}_${version}_${arch}.changes\"\n\n# Create \"upstream tarball\".\ngit archive HEAD | xz >\"$orig\"\n\n# Build package.\ndpkg-buildpackage -us -uc\n\n# Dump some information to make it easier to visually verify\n# everything looks OK. Also, test the package with the lintian tool.\n\nls -l ..\nfor x in ../*.deb; do dpkg -c \"$x\"; done\n# FIXME: disabled while this prevents radicle-native-ci deb from being built.\n# lintian -i --allow-root --fail-on warning ../*.changes\n\n# Move files to artifacts directory.\nmv ../*_* /workspace/artifacts\n        "]
           cwd=/workspace/src (exists? true)
           extra_env=[("CARGO_TARGET_DIR", "/workspace/cache"), ("CARGO_HOME", "/workspace/deps"), ("PATH", "/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin")]
    + echo 'PATH at start: /root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin'
    PATH at start: /root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
    + export PATH=/root/.cargo/bin:/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
    + PATH=/root/.cargo/bin:/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
    + export CARGO_HOME=/workspace/deps
    + CARGO_HOME=/workspace/deps
    + export DEBEMAIL=liw@liw.fi
    + DEBEMAIL=liw@liw.fi
    + export 'DEBFULLNAME=Lars Wirzenius'
    + DEBFULLNAME='Lars Wirzenius'
    + /bin/env
    DEBFULLNAME=Lars Wirzenius
    CARGO_TARGET_DIR=/workspace/cache
    PWD=/workspace/src
    SYSTEMD_EXEC_PID=275
    LANG=C.UTF-8
    CARGO_HOME=/workspace/deps
    DEBEMAIL=liw@liw.fi
    INVOCATION_ID=fa2e3f8a8b0a4e8b9fadeaefc59587b6
    SHLVL=2
    JOURNAL_STREAM=8:14648
    PATH=/root/.cargo/bin:/root/.cargo/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
    OLDPWD=/
    _=/bin/env
    + command -v cargo
    /root/.cargo/bin/cargo
    + command -v rustc
    /root/.cargo/bin/rustc
    + cargo --version
    cargo 1.89.0 (c24e10642 2025-06-23)
    + rustc --version
    rustc 1.89.0 (29483883e 2025-08-04)
    ++ dpkg-parsechangelog -SSource
    + name=vmdb2
    ++ dpkg-parsechangelog -SVersion
    + version=0.41.ci20250818T110524-1
    ++ echo 0.41.ci20250818T110524-1
    ++ sed 's/-[^-]*$//'
    + uv=0.41.ci20250818T110524
    ++ dpkg --print-architecture
    + arch=amd64
    + orig=../vmdb2_0.41.ci20250818T110524.orig.tar.xz
    + deb=../vmdb2_0.41.ci20250818T110524-1_amd64.deb
    + changes=../vmdb2_0.41.ci20250818T110524-1_amd64.changes
    + xz
    + git archive HEAD
    + dpkg-buildpackage -us -uc
    dpkg-buildpackage: info: source package vmdb2
    dpkg-buildpackage: info: source version 0.41.ci20250818T110524-1
    dpkg-buildpackage: info: source distribution unstable
    dpkg-buildpackage: info: source changed by Lars Wirzenius <liw@liw.fi>
    dpkg-buildpackage: info: host architecture amd64
     dpkg-source --before-build .
     debian/rules clean
    dh clean --with=python3 --buildsystem=pybuild
       dh_auto_clean -O--buildsystem=pybuild
    I: pybuild base:240: python3.11 setup.py clean 
    /workspace/src/setup.py:18: DeprecationWarning: The distutils package is deprecated and slated for removal in Python 3.12. Use setuptools or check PEP 632 for potential alternatives
      from distutils.core import setup
    running clean
    removing '/workspace/src/.pybuild/cpython3_3.11_vmdb2/build' (and everything under it)
    'build/bdist.linux-x86_64' does not exist -- can't clean it
    'build/scripts-3.11' does not exist -- can't clean it
       dh_autoreconf_clean -O--buildsystem=pybuild
       dh_clean -O--buildsystem=pybuild
     dpkg-source -b .
    dpkg-source: info: using source format '3.0 (quilt)'
    dpkg-source: info: building vmdb2 using existing ./vmdb2_0.41.ci20250818T110524.orig.tar.xz
    dpkg-source: info: building vmdb2 in vmdb2_0.41.ci20250818T110524-1.debian.tar.xz
    dpkg-source: info: building vmdb2 in vmdb2_0.41.ci20250818T110524-1.dsc
     debian/rules build
    dh build --with=python3 --buildsystem=pybuild
       dh_update_autotools_config -O--buildsystem=pybuild
       dh_autoreconf -O--buildsystem=pybuild
       dh_auto_configure -O--buildsystem=pybuild
    I: pybuild base:240: python3.11 setup.py config 
    /workspace/src/setup.py:18: DeprecationWarning: The distutils package is deprecated and slated for removal in Python 3.12. Use setuptools or check PEP 632 for potential alternatives
      from distutils.core import setup
    running config
       dh_auto_build -O--buildsystem=pybuild
    I: pybuild base:240: /usr/bin/python3 setup.py build 
    /workspace/src/setup.py:18: DeprecationWarning: The distutils package is deprecated and slated for removal in Python 3.12. Use setuptools or check PEP 632 for potential alternatives
      from distutils.core import setup
    running build
    running build_py
    creating /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb
    copying vmdb/spec.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb
    copying vmdb/runcmd.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb
    copying vmdb/step_list.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb
    copying vmdb/app.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb
    copying vmdb/__init__.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb
    copying vmdb/plugin_tests.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb
    copying vmdb/step_list_tests.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb
    copying vmdb/unmount_tests.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb
    copying vmdb/tags.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb
    copying vmdb/plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb
    copying vmdb/spec_tests.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb
    copying vmdb/version.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb
    copying vmdb/state.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb
    copying vmdb/tags_tests.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb
    copying vmdb/unmount.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb
    package init file 'vmdb/plugins/__init__.py' not found (or not a regular file)
    creating /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
    copying vmdb/plugins/debootstrap_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
    copying vmdb/plugins/fstab_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
    copying vmdb/plugins/cryptsetup_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
    copying vmdb/plugins/mount_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
    copying vmdb/plugins/echo_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
    copying vmdb/plugins/vgcreate_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
    copying vmdb/plugins/shell_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
    copying vmdb/plugins/set_part_flag_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
    copying vmdb/plugins/mkfs_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
    copying vmdb/plugins/virtualfs_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
    copying vmdb/plugins/lvcreate_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
    copying vmdb/plugins/cache_rootfs_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
    copying vmdb/plugins/mkimg_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
    copying vmdb/plugins/kpartx_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
    copying vmdb/plugins/mkpart_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
    copying vmdb/plugins/chroot_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
    copying vmdb/plugins/error_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
    copying vmdb/plugins/apt_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
    copying vmdb/plugins/resize_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
    copying vmdb/plugins/copy_dir_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
    copying vmdb/plugins/grub_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
    copying vmdb/plugins/create_dir_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
    copying vmdb/plugins/create_file_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
    copying vmdb/plugins/lvscan_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
    copying vmdb/plugins/copy_file_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
    copying vmdb/plugins/mklabel_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
    copying vmdb/plugins/ansible_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
    copying vmdb/plugins/unpack_rootfs_plugin.py -> /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins
    package init file 'vmdb/plugins/__init__.py' not found (or not a regular file)
    running build_scripts
    creating build
    creating build/scripts-3.11
    copying and adjusting vmdb2 -> build/scripts-3.11
    changing mode of build/scripts-3.11/vmdb2 from 644 to 755
       debian/rules override_dh_auto_test
    make[1]: Entering directory '/workspace/src'
    ./check
    Running unit tests ============================================
    /usr/lib/python3/dist-packages/CoverageTestRunner.py:22: DeprecationWarning: the imp module is deprecated in favour of importlib and slated for removal in Python 3.12; see the module's documentation for alternative uses
      import imp
    Running test 1/52: tests_finds_no_plugin_when_file_has_none (plugin_t                                                                     Running test 2/52: tests_finds_no_plugins_in_empty_directory (plugin_                                                                     Running test 3/52: tests_finds_no_plugins_when_there_are_other_files                                                                      Running test 4/52: tests_finds_plugin_when_there_is_one (plugin_tests                                                                     Running test 5/52: test_sets_app (plugin_tests.PluginTests.test_sets_                                                                     Running test 6/52: test_raises_error_for_missing_mandatory_key (step_                                                                     Running test 7/52: test_raises_error_for_wrong_type_of_value_for_mand                                                                     Running test 8/52: test_raises_error_for_wrong_type_of_value_for_opti                                                                     Running test 9/52: test_returns_actual_value_for_optional_key (step_l                                                                     Running test 10/52: test_returns_default_value_for_missing_optional_ke                                                                      Running test 11/52: test_returns_values_from_step_for_mandatory_keys (                                                                      Running test 12/52: test_adds_a_runner (step_list_tests.StepRunnerList                                                                      Running test 13/52: test_finds_correct_runner (step_list_tests.StepRun                                                                      Running test 14/52: test_is_empty_initially (step_list_tests.StepRunne                                                                      Running test 15/52: test_raises_error_if_runner_not_found (step_list_t                                                                      Running test 16/52: test_raises_error_if_wrong_step_key_values (step_l                                                                      Running test 17/52: test_raises_error_if_not_mounted (unmount_tests.Un                                                                      Running test 18/52: test_unmounts_mounted_dir (unmount_tests.UnmountTe                                                                      Running test 19/52: test_unmounts_mounted_dir_with_submounts (unmount_                                                                      Running test 20/52: test_expands_dict_of_templates (spec_tests.ExpandT                                                                      Running test 21/52: test_expands_list_of_templates (spec_tests.ExpandT                                                                      Running test 22/52: test_expands_simple_string_template (spec_tests.Ex                                                                      Running test 23/52: test_raises_assert_if_given_incomprehensible_value                                                                      Running test 24/52: test_returns_same_given_string_without_template (s                                                                      Running test 25/52: test_expands_templates (spec_tests.SpecTests.test_                                                                      Running test 26/52: test_loads_spec (spec_tests.SpecTests.test_loads_s                                                                      Running test 27/52: test_adds_builder_mount_point (tags_tests.TagsTest                                                                      Running test 28/52: test_builder_mount_point_can_be_made_cached (tags_                                                                      Running test 29/52: test_builder_mount_point_is_uncached_by_default (t                                                                      Running test 30/52: test_get_dev_raises_error_for_unknown_tag (tags_te                                                                      Running test 31/52: test_getting_builder_mount_point_raises_error_for_                                                                      Running test 32/52: test_lists_no_tags_initially (tags_tests.TagsTests                                                                      Running test 33/52: test_raises_error_for_reused_tag (tags_tests.TagsT                                                                      Running test 34/52: test_raises_error_if_both_mount_points_not_set (ta                                                                      Running test 35/52: test_remembers_order (tags_tests.TagsTests.test_re                                                                      Running test 36/52: test_returns_builder_when_given_target_mount_point                                                                      Running test 37/52: test_set_builder_mount_point_raises_error_for_doub                                                                      Running test 38/52: test_set_builder_mount_point_raises_error_for_unkn                                                                      Running test 39/52: test_set_dev_raises_error_for_double_dev (tags_tes                                                                      Running test 40/52: test_set_dev_raises_error_for_unknown_tag (tags_te                                                                      Running test 41/52: test_set_dm (tags_tests.TagsTests.test_set_dm)                                                                  Running test 42/52: test_set_dm_raises_error_for_double_fstype (tags_t                                                                      Running test 43/52: test_set_fstype (tags_tests.TagsTests.test_set_fst                                                                      Running test 44/52: test_set_fstype_raises_error_for_double_fstype (ta                                                                      Running test 45/52: test_set_fsuuid (tags_tests.TagsTests.test_set_fsu                                                                      Running test 46/52: test_set_fsuuid_raises_error_for_double_fstype (ta                                                                      Running test 47/52: test_set_luksuuid (tags_tests.TagsTests.test_set_l                                                                      Running test 48/52: test_set_luksuuid_raises_error_for_double_fstype (                                                                      Running test 49/52: test_set_target_mount_point (tags_tests.TagsTests.                                                                      Running test 50/52: test_set_target_mount_point_raises_error_for_doubl                                                                      Running test 51/52: test_sets_dev (tags_tests.TagsTests.test_sets_dev)                                                                      Running test 52/52: test_tells_if_tag_exists (tags_tests.TagsTests.tes
    
    OK
    54 excluded statements
    33 excluded modules
    Time: 0.4 s
    
    Checking every plugin looks OK ============================================
    
    Running Subplot ============================================
     INFO Starting Subplot
     INFO Subplot finished successfully
    srcdir /workspace/src
    datadir /tmp/tmpfwvs137w
    scenario: Checking the version
      step: given an installed vmdb2
      step: when I run vmdb2 --version
      step: then exit code is 0
      step: then stdout matches regex ^\\d+\\.\\d+$
    scenario: Error handling
      step: given an installed vmdb2
      step: given file unhappy.vmdb
      step: when I try to run vmdb2 -v unhappy.vmdb --output=unhappy.img
      step: then exit code is 1
      step: then stdout contains "foo\nyikes\n"
      step: then stdout contains "WAT?!\n"
      step: then stdout contains "foo_teardown\n"
      step: then stdout doesn't contain "bar_step"
      step: then stdout contains "bar_teardown"
    scenario: Jinja2 templating in specification file values
      step: given an installed vmdb2
      step: given file j2.vmdb
      step: when I run vmdb2 -v j2.vmdb --output=foo.img
      step: then exit code is 0
      step: then stdout contains "image is foo.img\nbar"
    scenario: A happy path
      step: given an installed vmdb2
      step: given file happy.vmdb
      step: when I run vmdb2 -v happy.vmdb --output=happy.img
      step: then exit code is 0
      step: then stdout contains "foo\nbar\nbar_teardown\n"
    OK, all scenarios finished successfully
    
    Formatting docs ========================================
    make[1]: Leaving directory '/workspace/src'
       create-stamp debian/debhelper-build-stamp
     debian/rules binary
    dh binary --with=python3 --buildsystem=pybuild
       dh_testroot -O--buildsystem=pybuild
       dh_prep -O--buildsystem=pybuild
       dh_auto_install --destdir=debian/vmdb2/ -O--buildsystem=pybuild
    I: pybuild base:240: /usr/bin/python3 setup.py install --root /workspace/src/debian/vmdb2 
    /workspace/src/setup.py:18: DeprecationWarning: The distutils package is deprecated and slated for removal in Python 3.12. Use setuptools or check PEP 632 for potential alternatives
      from distutils.core import setup
    running install
    running build
    running build_py
    package init file 'vmdb/plugins/__init__.py' not found (or not a regular file)
    package init file 'vmdb/plugins/__init__.py' not found (or not a regular file)
    running build_scripts
    running install_lib
    creating /workspace/src/debian/vmdb2/usr
    creating /workspace/src/debian/vmdb2/usr/lib
    creating /workspace/src/debian/vmdb2/usr/lib/python3.11
    creating /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages
    creating /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/spec.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/runcmd.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/step_list.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/app.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/__init__.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugin_tests.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/step_list_tests.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/unmount_tests.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/tags.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/spec_tests.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/version.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/state.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/tags_tests.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/unmount.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb
    creating /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/debootstrap_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/fstab_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/cryptsetup_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/mount_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/echo_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/vgcreate_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/shell_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/set_part_flag_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/mkfs_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/virtualfs_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/lvcreate_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/cache_rootfs_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/mkimg_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/kpartx_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/mkpart_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/chroot_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/error_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/apt_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/resize_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/copy_dir_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/grub_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/create_dir_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/create_file_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/lvscan_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/copy_file_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/mklabel_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/ansible_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
    copying /workspace/src/.pybuild/cpython3_3.11_vmdb2/build/vmdb/plugins/unpack_rootfs_plugin.py -> /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/spec.py to spec.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/runcmd.py to runcmd.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/step_list.py to step_list.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/app.py to app.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/__init__.py to __init__.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugin_tests.py to plugin_tests.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/step_list_tests.py to step_list_tests.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/unmount_tests.py to unmount_tests.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/tags.py to tags.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugin.py to plugin.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/spec_tests.py to spec_tests.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/version.py to version.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/state.py to state.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/tags_tests.py to tags_tests.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/unmount.py to unmount.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/debootstrap_plugin.py to debootstrap_plugin.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/fstab_plugin.py to fstab_plugin.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/cryptsetup_plugin.py to cryptsetup_plugin.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/mount_plugin.py to mount_plugin.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/echo_plugin.py to echo_plugin.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/vgcreate_plugin.py to vgcreate_plugin.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/shell_plugin.py to shell_plugin.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/set_part_flag_plugin.py to set_part_flag_plugin.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/mkfs_plugin.py to mkfs_plugin.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/virtualfs_plugin.py to virtualfs_plugin.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/lvcreate_plugin.py to lvcreate_plugin.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/cache_rootfs_plugin.py to cache_rootfs_plugin.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/mkimg_plugin.py to mkimg_plugin.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/kpartx_plugin.py to kpartx_plugin.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/mkpart_plugin.py to mkpart_plugin.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/chroot_plugin.py to chroot_plugin.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/error_plugin.py to error_plugin.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/apt_plugin.py to apt_plugin.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/resize_plugin.py to resize_plugin.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/copy_dir_plugin.py to copy_dir_plugin.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/grub_plugin.py to grub_plugin.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/create_dir_plugin.py to create_dir_plugin.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/create_file_plugin.py to create_file_plugin.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/lvscan_plugin.py to lvscan_plugin.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/copy_file_plugin.py to copy_file_plugin.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/mklabel_plugin.py to mklabel_plugin.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/ansible_plugin.py to ansible_plugin.cpython-311.pyc
    byte-compiling /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb/plugins/unpack_rootfs_plugin.py to unpack_rootfs_plugin.cpython-311.pyc
    running install_scripts
    creating /workspace/src/debian/vmdb2/usr/bin
    copying build/scripts-3.11/vmdb2 -> /workspace/src/debian/vmdb2/usr/bin
    changing mode of /workspace/src/debian/vmdb2/usr/bin/vmdb2 to 755
    running install_data
    creating /workspace/src/debian/vmdb2/usr/share
    creating /workspace/src/debian/vmdb2/usr/share/man
    creating /workspace/src/debian/vmdb2/usr/share/man/man1
    copying vmdb2.1 -> /workspace/src/debian/vmdb2/usr/share/man/man1
    running install_egg_info
    Writing /workspace/src/debian/vmdb2/usr/lib/python3.11/dist-packages/vmdb2-0.41.egg-info
       dh_installdocs -O--buildsystem=pybuild
       dh_installchangelogs -O--buildsystem=pybuild
       dh_installman -O--buildsystem=pybuild
       dh_systemd_enable -O--buildsystem=pybuild
       dh_python3 -O--buildsystem=pybuild
       dh_installinit -O--buildsystem=pybuild
       dh_systemd_start -O--buildsystem=pybuild
       dh_perl -O--buildsystem=pybuild
       dh_link -O--buildsystem=pybuild
       dh_strip_nondeterminism -O--buildsystem=pybuild
       dh_compress -O--buildsystem=pybuild
       dh_fixperms -O--buildsystem=pybuild
       dh_missing -O--buildsystem=pybuild
       dh_installdeb -O--buildsystem=pybuild
       dh_gencontrol -O--buildsystem=pybuild
       dh_md5sums -O--buildsystem=pybuild
       dh_builddeb -O--buildsystem=pybuild
    dpkg-deb: building package 'vmdb2' in '../vmdb2_0.41.ci20250818T110524-1_all.deb'.
     dpkg-genbuildinfo -O../vmdb2_0.41.ci20250818T110524-1_amd64.buildinfo
     dpkg-genchanges -O../vmdb2_0.41.ci20250818T110524-1_amd64.changes
    dpkg-genchanges: info: including full source code in upload
     dpkg-source --after-build .
    dpkg-buildpackage: info: full upload (original source is included)
    + ls -l ..
    total 148
    drwxr-xr-x 2 root root  4096 Aug 18 11:05 artifacts
    drwxr-xr-x 2 root root  4096 Aug 16 05:30 cache
    drwxr-xr-x 2 root root  4096 Aug 16 05:30 deps
    drwxr-xr-x 9 root root  4096 Aug 18 11:05 src
    -rw-r--r-- 1 root root 23696 Aug 18 11:05 vmdb2_0.41.ci20250818T110524-1.debian.tar.xz
    -rw-r--r-- 1 root root   977 Aug 18 11:05 vmdb2_0.41.ci20250818T110524-1.dsc
    -rw-r--r-- 1 root root 26868 Aug 18 11:05 vmdb2_0.41.ci20250818T110524-1_all.deb
    -rw-r--r-- 1 root root  6108 Aug 18 11:05 vmdb2_0.41.ci20250818T110524-1_amd64.buildinfo
    -rw-r--r-- 1 root root  1956 Aug 18 11:05 vmdb2_0.41.ci20250818T110524-1_amd64.changes
    -rw-r--r-- 1 root root 64380 Aug 18 11:05 vmdb2_0.41.ci20250818T110524.orig.tar.xz
    + for x in ../*.deb
    + dpkg -c ../vmdb2_0.41.ci20250818T110524-1_all.deb
    drwxr-xr-x root/root         0 2025-08-18 11:05 ./
    drwxr-xr-x root/root         0 2025-08-18 11:05 ./usr/
    drwxr-xr-x root/root         0 2025-08-18 11:05 ./usr/bin/
    -rwxr-xr-x root/root        76 2025-08-18 11:05 ./usr/bin/vmdb2
    drwxr-xr-x root/root         0 2025-08-18 11:05 ./usr/lib/
    drwxr-xr-x root/root         0 2025-08-18 11:05 ./usr/lib/python3/
    drwxr-xr-x root/root         0 2025-08-18 11:05 ./usr/lib/python3/dist-packages/
    drwxr-xr-x root/root         0 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/
    -rw-r--r-- root/root      1488 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/__init__.py
    -rw-r--r-- root/root      8321 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/app.py
    -rw-r--r-- root/root      1687 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugin.py
    -rw-r--r-- root/root      1922 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugin_tests.py
    drwxr-xr-x root/root         0 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/
    -rw-r--r-- root/root      3286 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/ansible_plugin.py
    -rw-r--r-- root/root      2578 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/apt_plugin.py
    -rw-r--r-- root/root      2419 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/cache_rootfs_plugin.py
    -rw-r--r-- root/root      1186 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/chroot_plugin.py
    -rw-r--r-- root/root      3984 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/copy_dir_plugin.py
    -rw-r--r-- root/root      1795 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/copy_file_plugin.py
    -rw-r--r-- root/root      1463 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/create_dir_plugin.py
    -rw-r--r-- root/root      1612 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/create_file_plugin.py
    -rw-r--r-- root/root      4805 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/cryptsetup_plugin.py
    -rw-r--r-- root/root      4942 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/debootstrap_plugin.py
    -rw-r--r-- root/root      1256 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/echo_plugin.py
    -rw-r--r-- root/root      1438 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/error_plugin.py
    -rw-r--r-- root/root      2920 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/fstab_plugin.py
    -rw-r--r-- root/root     15713 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/grub_plugin.py
    -rw-r--r-- root/root      3513 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/kpartx_plugin.py
    -rw-r--r-- root/root      1520 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/lvcreate_plugin.py
    -rw-r--r-- root/root      2336 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/lvscan_plugin.py
    -rw-r--r-- root/root      3108 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/mkfs_plugin.py
    -rw-r--r-- root/root      1395 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/mkimg_plugin.py
    -rw-r--r-- root/root      1139 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/mklabel_plugin.py
    -rw-r--r-- root/root      4654 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/mkpart_plugin.py
    -rw-r--r-- root/root      4046 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/mount_plugin.py
    -rw-r--r-- root/root      3295 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/resize_plugin.py
    -rw-r--r-- root/root      1915 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/set_part_flag_plugin.py
    -rw-r--r-- root/root      1210 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/shell_plugin.py
    -rw-r--r-- root/root      1582 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/unpack_rootfs_plugin.py
    -rw-r--r-- root/root      1539 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/vgcreate_plugin.py
    -rw-r--r-- root/root      2546 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/plugins/virtualfs_plugin.py
    -rw-r--r-- root/root      3201 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/runcmd.py
    -rw-r--r-- root/root      1488 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/spec.py
    -rw-r--r-- root/root      2687 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/spec_tests.py
    -rw-r--r-- root/root       973 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/state.py
    -rw-r--r-- root/root      4277 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/step_list.py
    -rw-r--r-- root/root      3642 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/step_list_tests.py
    -rw-r--r-- root/root      5356 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/tags.py
    -rw-r--r-- root/root      6873 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/tags_tests.py
    -rw-r--r-- root/root      2444 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/unmount.py
    -rw-r--r-- root/root      2109 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/unmount_tests.py
    -rw-r--r-- root/root        48 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb/version.py
    -rw-r--r-- root/root       241 2025-08-18 11:05 ./usr/lib/python3/dist-packages/vmdb2-0.41.egg-info
    drwxr-xr-x root/root         0 2025-08-18 11:05 ./usr/share/
    drwxr-xr-x root/root         0 2025-08-18 11:05 ./usr/share/doc/
    drwxr-xr-x root/root         0 2025-08-18 11:05 ./usr/share/doc/vmdb2/
    -rw-r--r-- root/root       685 2025-08-18 11:05 ./usr/share/doc/vmdb2/changelog.Debian.gz
    -rw-r--r-- root/root       979 2025-08-18 11:05 ./usr/share/doc/vmdb2/copyright
    drwxr-xr-x root/root         0 2025-08-18 11:05 ./usr/share/man/
    drwxr-xr-x root/root         0 2025-08-18 11:05 ./usr/share/man/man1/
    -rw-r--r-- root/root      1047 2025-08-18 11:05 ./usr/share/man/man1/vmdb2.1.gz
    + mv ../vmdb2_0.41.ci20250818T110524-1.debian.tar.xz ../vmdb2_0.41.ci20250818T110524-1.dsc ../vmdb2_0.41.ci20250818T110524-1_all.deb ../vmdb2_0.41.ci20250818T110524-1_amd64.buildinfo ../vmdb2_0.41.ci20250818T110524-1_amd64.changes ../vmdb2_0.41.ci20250818T110524.orig.tar.xz /workspace/artifacts
    RUN: Action finished OK
    RUN: Action TarCreate {
        archive: "/dev/vde",
        directory: "/workspace/cache",
    }
    [2025-08-18T11:05:31Z DEBUG ambient_ci::action] Plan::execute: TarCreate {
            archive: "/dev/vde",
            directory: "/workspace/cache",
        }
    [2025-08-18T11:05:31Z TRACE ambient_ci::vdrive] creating virtual drive (tar archive): VirtualDriveBuilder {
            filename: Some(
                "/dev/vde",
            ),
            root: Some(
                "/workspace/cache",
            ),
            size: None,
        }
    [2025-08-18T11:05:31Z TRACE ambient_ci::vdrive] tar archive to be created: /dev/vde; exists? true
    [2025-08-18T11:05:31Z TRACE ambient_ci::vdrive] create archive file /dev/vde
    [2025-08-18T11:05:31Z TRACE ambient_ci::vdrive] directory /workspace/cache exists? true
    [2025-08-18T11:05:31Z TRACE ambient_ci::vdrive] add contents of /workspace/cache as .
    [2025-08-18T11:05:31Z TRACE ambient_ci::vdrive] created virtual drive /dev/vde
    RUN: Action finished OK
    RUN: Action TarCreate {
        archive: "/dev/vdd",
        directory: "/workspace/artifacts",
    }
    [2025-08-18T11:05:31Z DEBUG ambient_ci::action] Plan::execute: TarCreate {
            archive: "/dev/vdd",
            directory: "/workspace/artifacts",
        }
    [2025-08-18T11:05:31Z TRACE ambient_ci::vdrive] creating virtual drive (tar archive): VirtualDriveBuilder {
            filename: Some(
                "/dev/vdd",
            ),
            root: Some(
                "/workspace/artifacts",
            ),
            size: None,
        }
    [2025-08-18T11:05:31Z TRACE ambient_ci::vdrive] tar archive to be created: /dev/vdd; exists? true
    [2025-08-18T11:05:31Z TRACE ambient_ci::vdrive] create archive file /dev/vdd
    [2025-08-18T11:05:31Z TRACE ambient_ci::vdrive] directory /workspace/artifacts exists? true
    [2025-08-18T11:05:31Z TRACE ambient_ci::vdrive] add contents of /workspace/artifacts as .
    [2025-08-18T11:05:31Z TRACE ambient_ci::vdrive] created virtual drive /dev/vdd
    RUN: Action finished OK
    ambient-execute-plan ends
    EXIT CODE: 0
    
    ====================
[2025-08-18T11:05:33Z DEBUG ambient_ci::qemu] QEMU exit code 0
[2025-08-18T11:05:33Z DEBUG ambient_ci::run] remove old cache
[2025-08-18T11:05:33Z DEBUG ambient_ci::run] extract cache
[2025-08-18T11:05:33Z DEBUG ambient_ci::run] Executing post-plan steps
[2025-08-18T11:05:33Z DEBUG ambient_ci::action] Plan::execute: Dput {
        artifactsdir: "/srv/ambient-state/vmdb2/artifacts",
        dput_target: Some(
            "apt.liw.fi",
        ),
    }
[2025-08-18T11:05:33Z DEBUG ambient_ci::util] found /srv/ambient-state/vmdb2/artifacts
[2025-08-18T11:05:33Z DEBUG ambient_ci::util] found /srv/ambient-state/vmdb2/artifacts/vmdb2_0.41.ci20250818T110524-1_amd64.buildinfo
[2025-08-18T11:05:33Z DEBUG ambient_ci::util] found /srv/ambient-state/vmdb2/artifacts/vmdb2_0.41.ci20250818T110524-1_all.deb
[2025-08-18T11:05:33Z DEBUG ambient_ci::util] found /srv/ambient-state/vmdb2/artifacts/vmdb2_0.41.ci20250818T110524-1.dsc
[2025-08-18T11:05:33Z DEBUG ambient_ci::util] found /srv/ambient-state/vmdb2/artifacts/index.html
[2025-08-18T11:05:33Z DEBUG ambient_ci::util] found /srv/ambient-state/vmdb2/artifacts/vmdb2_0.41.ci20250818T110524-1_amd64.changes
[2025-08-18T11:05:33Z DEBUG ambient_ci::util] found /srv/ambient-state/vmdb2/artifacts/vmdb2_0.41.ci20250818T110524-1.debian.tar.xz
[2025-08-18T11:05:33Z DEBUG ambient_ci::util] found /srv/ambient-state/vmdb2/artifacts/vmdb2_0.41.ci20250818T110524.orig.tar.xz
[2025-08-18T11:05:33Z INFO  ambient_ci::util] dput apt.liw.fi /srv/ambient-state/vmdb2/artifacts/vmdb2_0.41.ci20250818T110524-1_amd64.changes
[2025-08-18T11:05:34Z DEBUG ambient_ci::action] Plan::execute: Rsync {
        artifactsdir: "/srv/ambient-state/vmdb2/artifacts",
        rsync_target: Some(
            "ci@http.liw.fi:/srv/http/vmdb2-manual.liw.fi",
        ),
    }
[2025-08-18T11:05:34Z INFO  ambient_ci::util] rsync /srv/ambient-state/vmdb2/artifacts/. -> ci@http.liw.fi:/srv/http/vmdb2-manual.liw.fi/.
[2025-08-18T11:05:35Z DEBUG ambient_ci::project] write project state to /srv/ambient-state/vmdb2/meta.yaml
[2025-08-18T11:05:35Z INFO  ambient] ambient ends successfully

Ambient stderr

<empty log>