CI run for vmdb2

Radicle repository id rad:z2kxCtBwDQMPcaf9vGTNH5nYkp9qk

Table of Contents

Run log

[2025-08-09T04:27:39Z 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-09 04:27 ./
-rw-r--r-- _rad/_rad      1396 2025-08-09 04:27 ./plan.yaml
-rwxr-xr-x _rad/_rad   2998936 2025-08-09 04:27 ./run-ci
INFO: Extracted files:
  1477881      4 drwxr-xr-x   2 1001     1001         4096 Aug  9 04:27 .
  1477809      4 -rw-r--r--   1 1001     1001         1396 Aug  9 04:27 ./plan.yaml
  1477810   2932 -rwxr-xr-x   1 1001     1001      2998936 Aug  9 04:27 ./run-ci
INFO: Running run-ci from /dev/vdb
================================ BEGIN ================================
[2025-08-09T04:27:18Z TRACE ambient_execute_plan] ambient-execute-plan starts
[2025-08-09T04:27:18Z DEBUG ambient_execute_plan] ambient-execute-plan starts
[2025-08-09T04:27:18Z INFO  ambient_execute_plan] ambient-execute-plan starts
[2025-08-09T04:27:18Z WARN  ambient_execute_plan] ambient-execute-plan starts
[2025-08-09T04:27:18Z 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-09T04:27:18Z DEBUG ambient_ci::action] Plan::execute: Mkdir {
        pathname: "/workspace",
    }
RUN: Action finished OK
RUN: Action Mkdir {
    pathname: "/workspace/artifacts",
}
[2025-08-09T04:27:18Z 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-09T04:27:18Z DEBUG ambient_ci::action] Plan::execute: TarExtract {
        archive: "/dev/vdc",
        directory: "/workspace/src",
    }
[2025-08-09T04:27:18Z TRACE ambient_ci::vdrive] extracting /dev/vdc to /workspace/src
[2025-08-09T04:27:18Z TRACE ambient_ci::vdrive] extraction OK
RUN: Action finished OK
RUN: Action TarExtract {
    archive: "/dev/vdf",
    directory: "/workspace/deps",
}
[2025-08-09T04:27:18Z DEBUG ambient_ci::action] Plan::execute: TarExtract {
        archive: "/dev/vdf",
        directory: "/workspace/deps",
    }
[2025-08-09T04:27:18Z TRACE ambient_ci::vdrive] extracting /dev/vdf to /workspace/deps
[2025-08-09T04:27:18Z TRACE ambient_ci::vdrive] extraction OK
RUN: Action finished OK
RUN: Action TarExtract {
    archive: "/dev/vde",
    directory: "/workspace/cache",
}
[2025-08-09T04:27:18Z DEBUG ambient_ci::action] Plan::execute: TarExtract {
        archive: "/dev/vde",
        directory: "/workspace/cache",
    }
[2025-08-09T04:27:18Z TRACE ambient_ci::vdrive] extracting /dev/vde to /workspace/cache
[2025-08-09T04:27:18Z TRACE ambient_ci::vdrive] extraction OK
RUN: Action finished OK
RUN: Action Spawn {
    argv: [
        "find",
        "/workspace",
        "-maxdepth",
        "2",
        "-ls",
    ],
}
[2025-08-09T04:27:18Z 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  9 04:27 /workspace
  3932162      4 drwxr-xr-x   2 root     root         4096 Aug  9 04:27 /workspace/artifacts
  3932693      4 drwxr-xr-x   2 root     root         4096 Jun  7 11:19 /workspace/deps
  3932163      4 drwxr-xr-x   7 root     root         4096 Aug  9 04:27 /workspace/src
  3932692      4 -rw-r--r--   1 root     root         1264 Aug  9 04:27 /workspace/src/smoke-ppc64el.vmdb
  3932165      4 drwxr-xr-x   2 root     root         4096 Aug  9 04:27 /workspace/src/.radicle
  3932181      4 -rw-r--r--   1 root     root         1976 Aug  9 04:27 /workspace/src/smoke-ppc64el.yarn
  3932685      4 -rw-r--r--   1 root     root            8 Aug  9 04:27 /workspace/src/lvm2.lukskey
  3932186      4 -rwxr-xr-x   1 root     root          101 Aug  9 04:27 /workspace/src/smoke-ppc64el.sh
  3932686      4 -rw-r--r--   1 root     root          211 Aug  9 04:27 /workspace/src/vmdb2.yaml
  3932168      8 -rwxr-xr-x   1 root     root         5713 Aug  9 04:27 /workspace/src/check-one
  3932164      4 -rwxr-xr-x   1 root     root           76 Aug  9 04:27 /workspace/src/vmdb2
  3932182      4 -rwxr-xr-x   1 root     root          516 Aug  9 04:27 /workspace/src/check-external
  3932178      4 -rw-r--r--   1 root     root         1153 Aug  9 04:27 /workspace/src/base.vmdb
  3932687      4 -rwxr-xr-x   1 root     root          304 Aug  9 04:27 /workspace/src/format.sh
  3932183      4 -rwxr-xr-x   1 root     root          308 Aug  9 04:27 /workspace/src/check-all
  3932200      4 -rw-r--r--   1 root     root           12 Aug  9 04:27 /workspace/src/.gitignore
  3932167      4 -rw-r--r--   1 root     root          985 Aug  9 04:27 /workspace/src/ppc64el.vmdb
  3932688      4 -rw-r--r--   1 root     root          504 Aug  9 04:27 /workspace/src/vmdb2.css
  3932612     12 -rw-r--r--   1 root     root        10708 Aug  9 04:27 /workspace/src/vmdb2.md
  3932684      4 -rw-r--r--   1 root     root          143 Aug  9 04:27 /workspace/src/ansible.yml
  3932202      4 drwxr-xr-x   8 root     root         4096 Aug  9 04:27 /workspace/src/.git
  3932690      4 -rwxr-xr-x   1 root     root         1083 Aug  9 04:27 /workspace/src/check-images
  3932187      4 drwxr-xr-x   3 root     root         4096 Aug  9 04:27 /workspace/src/debian
  3932201      4 -rw-r--r--   1 root     root         1057 Aug  9 04:27 /workspace/src/without-tests
  3932177      4 -rw-r--r--   1 root     root          162 Aug  9 04:27 /workspace/src/vmdb2.py
  3932199      8 -rw-r--r--   1 root     root         7962 Aug  9 04:27 /workspace/src/README.md
  3932689      4 -rw-r--r--   1 root     root         2055 Aug  9 04:27 /workspace/src/vmdb2.1
  3932180     24 -rw-r--r--   1 root     root        23398 Aug  9 04:27 /workspace/src/NEWS
  3932179      4 -rwxr-xr-x   1 root     root         1174 Aug  9 04:27 /workspace/src/setup.py
  3932185      4 -rw-r--r--   1 root     root         1271 Aug  9 04:27 /workspace/src/lvm2.vmdb
  3932184      4 -rw-r--r--   1 root     root          235 Aug  9 04:27 /workspace/src/vmdb2.subplot
  3932691      4 -rw-r--r--   1 root     root         3218 Aug  9 04:27 /workspace/src/code-of-conduct.md
  3932613      4 drwxr-xr-x   3 root     root         4096 Aug  9 04:27 /workspace/src/vmdb
  3932176      4 -rwxr-xr-x   1 root     root         1393 Aug  9 04:27 /workspace/src/check
  3932169      4 drwxr-xr-x   4 root     root         4096 Aug  9 04:27 /workspace/src/roles
  3932694      4 drwxr-xr-x   2 root     root         4096 Jun  7 11:19 /workspace/cache
RUN: Action finished OK
RUN: Action Shell {
    shell: "./format.sh\ncp vmdb2.html /workspace/artifacts/index.html\n",
}
[2025-08-09T04:27:18Z 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-09T04:27:19Z 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.5 s

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

Running Subplot ============================================
 INFO Starting Subplot
 INFO Subplot finished successfully
srcdir /workspace/src
datadir /tmp/tmpi8df3w7x
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: 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: 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: 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 ========================================
+ 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=20250809T042721
+ version=0.41.ci20250809T042721-1
+ dch -v 0.41.ci20250809T042721-1 'CI build under Ambient.'
+ dch -r ''
RUN: Action finished OK
RUN: Action Deb
[2025-08-09T04:27:21Z 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=284
LANG=C.UTF-8
CARGO_HOME=/workspace/deps
DEBEMAIL=liw@liw.fi
INVOCATION_ID=b68e73e2f6a442769f88959ac5f0244e
SHLVL=2
JOURNAL_STREAM=8:13434
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.ci20250809T042721-1
++ echo 0.41.ci20250809T042721-1
++ sed 's/-[^-]*$//'
+ uv=0.41.ci20250809T042721
++ dpkg --print-architecture
+ arch=amd64
+ orig=../vmdb2_0.41.ci20250809T042721.orig.tar.xz
+ deb=../vmdb2_0.41.ci20250809T042721-1_amd64.deb
+ changes=../vmdb2_0.41.ci20250809T042721-1_amd64.changes
+ git archive HEAD
+ xz
+ dpkg-buildpackage -us -uc
dpkg-buildpackage: info: source package vmdb2
dpkg-buildpackage: info: source version 0.41.ci20250809T042721-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.ci20250809T042721.orig.tar.xz
dpkg-source: info: building vmdb2 in vmdb2_0.41.ci20250809T042721-1.debian.tar.xz
dpkg-source: info: building vmdb2 in vmdb2_0.41.ci20250809T042721-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.3 s

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

Running Subplot ============================================
 INFO Starting Subplot
 INFO Subplot finished successfully
srcdir /workspace/src
datadir /tmp/tmpr19x14jt
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: 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: 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.ci20250809T042721-1_all.deb'.
 dpkg-genbuildinfo -O../vmdb2_0.41.ci20250809T042721-1_amd64.buildinfo
 dpkg-genchanges -O../vmdb2_0.41.ci20250809T042721-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  9 04:27 artifacts
drwxr-xr-x 2 root root  4096 Jun  7 11:19 cache
drwxr-xr-x 2 root root  4096 Jun  7 11:19 deps
drwxr-xr-x 9 root root  4096 Aug  9 04:27 src
-rw-r--r-- 1 root root 23684 Aug  9 04:27 vmdb2_0.41.ci20250809T042721-1.debian.tar.xz
-rw-r--r-- 1 root root   977 Aug  9 04:27 vmdb2_0.41.ci20250809T042721-1.dsc
-rw-r--r-- 1 root root 26864 Aug  9 04:27 vmdb2_0.41.ci20250809T042721-1_all.deb
-rw-r--r-- 1 root root  6108 Aug  9 04:27 vmdb2_0.41.ci20250809T042721-1_amd64.buildinfo
-rw-r--r-- 1 root root  1956 Aug  9 04:27 vmdb2_0.41.ci20250809T042721-1_amd64.changes
-rw-r--r-- 1 root root 64380 Aug  9 04:27 vmdb2_0.41.ci20250809T042721.orig.tar.xz
+ for x in ../*.deb
+ dpkg -c ../vmdb2_0.41.ci20250809T042721-1_all.deb
drwxr-xr-x root/root         0 2025-08-09 04:27 ./
drwxr-xr-x root/root         0 2025-08-09 04:27 ./usr/
drwxr-xr-x root/root         0 2025-08-09 04:27 ./usr/bin/
-rwxr-xr-x root/root        76 2025-08-09 04:27 ./usr/bin/vmdb2
drwxr-xr-x root/root         0 2025-08-09 04:27 ./usr/lib/
drwxr-xr-x root/root         0 2025-08-09 04:27 ./usr/lib/python3/
drwxr-xr-x root/root         0 2025-08-09 04:27 ./usr/lib/python3/dist-packages/
drwxr-xr-x root/root         0 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/
-rw-r--r-- root/root      1488 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/__init__.py
-rw-r--r-- root/root      8321 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/app.py
-rw-r--r-- root/root      1687 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugin.py
-rw-r--r-- root/root      1922 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugin_tests.py
drwxr-xr-x root/root         0 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/
-rw-r--r-- root/root      3286 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/ansible_plugin.py
-rw-r--r-- root/root      2578 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/apt_plugin.py
-rw-r--r-- root/root      2419 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/cache_rootfs_plugin.py
-rw-r--r-- root/root      1186 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/chroot_plugin.py
-rw-r--r-- root/root      3984 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/copy_dir_plugin.py
-rw-r--r-- root/root      1795 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/copy_file_plugin.py
-rw-r--r-- root/root      1463 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/create_dir_plugin.py
-rw-r--r-- root/root      1612 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/create_file_plugin.py
-rw-r--r-- root/root      4805 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/cryptsetup_plugin.py
-rw-r--r-- root/root      4942 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/debootstrap_plugin.py
-rw-r--r-- root/root      1256 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/echo_plugin.py
-rw-r--r-- root/root      1438 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/error_plugin.py
-rw-r--r-- root/root      2920 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/fstab_plugin.py
-rw-r--r-- root/root     15713 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/grub_plugin.py
-rw-r--r-- root/root      3513 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/kpartx_plugin.py
-rw-r--r-- root/root      1520 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/lvcreate_plugin.py
-rw-r--r-- root/root      2336 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/lvscan_plugin.py
-rw-r--r-- root/root      3108 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/mkfs_plugin.py
-rw-r--r-- root/root      1395 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/mkimg_plugin.py
-rw-r--r-- root/root      1139 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/mklabel_plugin.py
-rw-r--r-- root/root      4654 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/mkpart_plugin.py
-rw-r--r-- root/root      4046 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/mount_plugin.py
-rw-r--r-- root/root      3295 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/resize_plugin.py
-rw-r--r-- root/root      1915 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/set_part_flag_plugin.py
-rw-r--r-- root/root      1210 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/shell_plugin.py
-rw-r--r-- root/root      1582 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/unpack_rootfs_plugin.py
-rw-r--r-- root/root      1539 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/vgcreate_plugin.py
-rw-r--r-- root/root      2546 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/virtualfs_plugin.py
-rw-r--r-- root/root      3201 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/runcmd.py
-rw-r--r-- root/root      1488 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/spec.py
-rw-r--r-- root/root      2687 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/spec_tests.py
-rw-r--r-- root/root       973 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/state.py
-rw-r--r-- root/root      4277 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/step_list.py
-rw-r--r-- root/root      3642 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/step_list_tests.py
-rw-r--r-- root/root      5356 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/tags.py
-rw-r--r-- root/root      6873 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/tags_tests.py
-rw-r--r-- root/root      2444 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/unmount.py
-rw-r--r-- root/root      2109 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/unmount_tests.py
-rw-r--r-- root/root        48 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/version.py
-rw-r--r-- root/root       241 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb2-0.41.egg-info
drwxr-xr-x root/root         0 2025-08-09 04:27 ./usr/share/
drwxr-xr-x root/root         0 2025-08-09 04:27 ./usr/share/doc/
drwxr-xr-x root/root         0 2025-08-09 04:27 ./usr/share/doc/vmdb2/
-rw-r--r-- root/root       685 2025-08-09 04:27 ./usr/share/doc/vmdb2/changelog.Debian.gz
-rw-r--r-- root/root       979 2025-08-09 04:27 ./usr/share/doc/vmdb2/copyright
drwxr-xr-x root/root         0 2025-08-09 04:27 ./usr/share/man/
drwxr-xr-x root/root         0 2025-08-09 04:27 ./usr/share/man/man1/
-rw-r--r-- root/root      1047 2025-08-09 04:27 ./usr/share/man/man1/vmdb2.1.gz
+ mv ../vmdb2_0.41.ci20250809T042721-1.debian.tar.xz ../vmdb2_0.41.ci20250809T042721-1.dsc ../vmdb2_0.41.ci20250809T042721-1_all.deb ../vmdb2_0.41.ci20250809T042721-1_amd64.buildinfo ../vmdb2_0.41.ci20250809T042721-1_amd64.changes ../vmdb2_0.41.ci20250809T042721.orig.tar.xz /workspace/artifacts
RUN: Action finished OK
RUN: Action TarCreate {
    archive: "/dev/vde",
    directory: "/workspace/cache",
}
[2025-08-09T04:27:33Z DEBUG ambient_ci::action] Plan::execute: TarCreate {
        archive: "/dev/vde",
        directory: "/workspace/cache",
    }
[2025-08-09T04:27:33Z TRACE ambient_ci::vdrive] creating virtual drive (tar archive): VirtualDriveBuilder {
        filename: Some(
            "/dev/vde",
        ),
        root: Some(
            "/workspace/cache",
        ),
        size: None,
    }
[2025-08-09T04:27:33Z TRACE ambient_ci::vdrive] tar archive to be created: /dev/vde; exists? true
[2025-08-09T04:27:33Z TRACE ambient_ci::vdrive] create archive file /dev/vde
[2025-08-09T04:27:33Z TRACE ambient_ci::vdrive] directory /workspace/cache exists? true
[2025-08-09T04:27:33Z TRACE ambient_ci::vdrive] add contents of /workspace/cache as .
[2025-08-09T04:27:33Z TRACE ambient_ci::vdrive] created virtual drive /dev/vde
RUN: Action finished OK
RUN: Action TarCreate {
    archive: "/dev/vdd",
    directory: "/workspace/artifacts",
}
[2025-08-09T04:27:33Z DEBUG ambient_ci::action] Plan::execute: TarCreate {
        archive: "/dev/vdd",
        directory: "/workspace/artifacts",
    }
[2025-08-09T04:27:33Z TRACE ambient_ci::vdrive] creating virtual drive (tar archive): VirtualDriveBuilder {
        filename: Some(
            "/dev/vdd",
        ),
        root: Some(
            "/workspace/artifacts",
        ),
        size: None,
    }
[2025-08-09T04:27:33Z TRACE ambient_ci::vdrive] tar archive to be created: /dev/vdd; exists? true
[2025-08-09T04:27:33Z TRACE ambient_ci::vdrive] create archive file /dev/vdd
[2025-08-09T04:27:33Z TRACE ambient_ci::vdrive] directory /workspace/artifacts exists? true
[2025-08-09T04:27:33Z TRACE ambient_ci::vdrive] add contents of /workspace/artifacts as .
[2025-08-09T04:27:33Z TRACE ambient_ci::vdrive] created virtual drive /dev/vdd
RUN: Action finished OK
ambient-execute-plan ends
EXIT CODE: 0
[2025-08-09T04:27:39Z 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-09T04:27:10Z INFO  ambient] ambient starts
[2025-08-09T04:27:10Z DEBUG ambient] load default configuration file /home/_rad/.config/ambient/config.yaml if it exists
[2025-08-09T04:27:10Z DEBUG ambient] load files named with --config: /tmp/.tmplorhl5/ambient_extra_values.yaml
[2025-08-09T04:27:10Z 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-09T04:27:10Z 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-09T04:27:10Z DEBUG ambient_ci::project] load project state from /srv/ambient-state/vmdb2/meta.yaml
[2025-08-09T04:27:10Z DEBUG ambient_ci::run] latest commit: "af6685a991008df668d5c7eb1c7df7a9efcabcec"
[2025-08-09T04:27:10Z DEBUG ambient_ci::run] is a git repository
[2025-08-09T04:27:10Z DEBUG ambient_ci::run] git repository is clean
[2025-08-09T04:27:10Z DEBUG ambient_ci::run] current (HEAD) commit: af6685a991008df668d5c7eb1c7df7a9efcabcec
[2025-08-09T04:27:10Z DEBUG ambient_ci::run] no dry run requested
[2025-08-09T04:27:10Z DEBUG ambient_ci::run] forced run requested
[2025-08-09T04:27:10Z DEBUG ambient_ci::run] run? true
[2025-08-09T04:27:10Z INFO  ambient_ci::run] project vmdb2: running CI
[2025-08-09T04:27:10Z DEBUG ambient_ci::run] Executing pre-plan steps
[2025-08-09T04:27:10Z DEBUG ambient_ci::run] create virtual drive /srv/tmp/.tmpNmdV6t/src.tar
[2025-08-09T04:27:10Z DEBUG ambient_ci::run] create virtual drive /srv/tmp/.tmpNmdV6t/deps.tar
[2025-08-09T04:27:10Z DEBUG ambient_ci::run] create_executor_vdrive: executor="/usr/bin/ambient-execute-plan"
[2025-08-09T04:27:10Z 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-09T04:27:10Z DEBUG ambient_ci::run] executor bin /usr/bin/ambient-execute-plan
[2025-08-09T04:27:10Z DEBUG ambient_ci::run] copying /usr/bin/ambient-execute-plan to /srv/tmp/.tmpNmdV6t/ambient-execute-plan/run-ci
[2025-08-09T04:27:10Z DEBUG ambient_ci::run] copy OK: true
[2025-08-09T04:27:10Z DEBUG ambient_ci::run] create virtual drive /srv/tmp/.tmpNmdV6t/executor.tar
[2025-08-09T04:27:10Z DEBUG ambient_ci::project] removing run log file /srv/ambient-state/vmdb2/run.log
[2025-08-09T04:27:10Z DEBUG ambient_ci::project] statedir is /srv/ambient-state/vmdb2, exists? true
[2025-08-09T04:27:10Z DEBUG ambient_ci::project] creating run log file /srv/ambient-state/vmdb2/run.log
[2025-08-09T04:27:10Z DEBUG ambient_ci::project] created run log file /srv/ambient-state/vmdb2/run.log OK
[2025-08-09T04:27:10Z DEBUG ambient_ci::cloud_init] with_hostname called: "ambient"
[2025-08-09T04:27:10Z DEBUG ambient_ci::cloud_init] with_runcmd called: "echo xyzzy > /dev/ttyS1"
[2025-08-09T04:27:10Z 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-09T04:27:10Z DEBUG ambient_ci::cloud_init] with_runcmd called: "poweroff"
[2025-08-09T04:27:10Z 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-09T04:27:10Z DEBUG ambient_ci::qemu] run QEMU
[2025-08-09T04:27:10Z DEBUG ambient_ci::qemu] create copy-on-write image and UEFI vars file
[2025-08-09T04:27:10Z DEBUG ambient_ci::qemu_utils] qemu-img create /srv/tmp/.tmpZhJHbF/.tmpF6on9R/vm.qcow2 backing on /home/_rad/ambient.qcow2
[2025-08-09T04:27:10Z DEBUG ambient_ci::qemu] create cloud-init ISO file
[2025-08-09T04:27:10Z 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-09T04:27:10Z DEBUG ambient_ci::cloud_init] write /tmp/.tmp6O4sba/meta-data
[2025-08-09T04:27:10Z DEBUG ambient_ci::cloud_init] write /tmp/.tmp6O4sba/user-data
[2025-08-09T04:27:10Z DEBUG ambient_ci::qemu] set console log file to /srv/tmp/.tmpZhJHbF/.tmpF6on9R/console.log
[2025-08-09T04:27:10Z DEBUG ambient_ci::util] create file /srv/tmp/.tmpZhJHbF/.tmpF6on9R/console.log
[2025-08-09T04:27:10Z DEBUG ambient_ci::qemu] set run file to /srv/ambient-state/vmdb2/run.log
[2025-08-09T04:27:10Z DEBUG ambient_ci::util] create file /srv/ambient-state/vmdb2/run.log
[2025-08-09T04:27:10Z 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/.tmpZhJHbF/.tmpF6on9R/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/.tmpZhJHbF/.tmpF6on9R/vars.fd",
            "-drive",
            "format=qcow2,if=virtio,file=/srv/tmp/.tmpZhJHbF/.tmpF6on9R/vm.qcow2",
            "-drive",
            "format=raw,if=virtio,file=/srv/tmp/.tmpNmdV6t/executor.tar,readonly=on",
            "-cdrom",
            "/srv/tmp/.tmpZhJHbF/.tmpF6on9R/cloud_init.iso",
            "-drive",
            "format=raw,if=virtio,file=/srv/tmp/.tmpNmdV6t/src.tar,readonly=on",
            "-drive",
            "format=raw,if=virtio,file=/srv/tmp/.tmpNmdV6t/artifacts.tar",
            "-drive",
            "format=raw,if=virtio,file=/srv/tmp/.tmpNmdV6t/cache.tar",
            "-drive",
            "format=raw,if=virtio,file=/srv/tmp/.tmpNmdV6t/deps.tar,readonly=on",
            "-nodefaults",
            "-no-user-config",
        ],
    }
[2025-08-09T04:27:37Z DEBUG ambient_ci::qemu] QEMU finished OK
[2025-08-09T04:27:37Z DEBUG ambient_ci::qemu] run log:
    --------------------==========
    [2025-08-09T04:27:18Z TRACE ambient_execute_plan] ambient-execute-plan starts
    [2025-08-09T04:27:18Z DEBUG ambient_execute_plan] ambient-execute-plan starts
    [2025-08-09T04:27:18Z INFO  ambient_execute_plan] ambient-execute-plan starts
    [2025-08-09T04:27:18Z WARN  ambient_execute_plan] ambient-execute-plan starts
    [2025-08-09T04:27:18Z 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-09T04:27:18Z DEBUG ambient_ci::action] Plan::execute: Mkdir {
            pathname: "/workspace",
        }
    RUN: Action finished OK
    RUN: Action Mkdir {
        pathname: "/workspace/artifacts",
    }
    [2025-08-09T04:27:18Z 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-09T04:27:18Z DEBUG ambient_ci::action] Plan::execute: TarExtract {
            archive: "/dev/vdc",
            directory: "/workspace/src",
        }
    [2025-08-09T04:27:18Z TRACE ambient_ci::vdrive] extracting /dev/vdc to /workspace/src
    [2025-08-09T04:27:18Z TRACE ambient_ci::vdrive] extraction OK
    RUN: Action finished OK
    RUN: Action TarExtract {
        archive: "/dev/vdf",
        directory: "/workspace/deps",
    }
    [2025-08-09T04:27:18Z DEBUG ambient_ci::action] Plan::execute: TarExtract {
            archive: "/dev/vdf",
            directory: "/workspace/deps",
        }
    [2025-08-09T04:27:18Z TRACE ambient_ci::vdrive] extracting /dev/vdf to /workspace/deps
    [2025-08-09T04:27:18Z TRACE ambient_ci::vdrive] extraction OK
    RUN: Action finished OK
    RUN: Action TarExtract {
        archive: "/dev/vde",
        directory: "/workspace/cache",
    }
    [2025-08-09T04:27:18Z DEBUG ambient_ci::action] Plan::execute: TarExtract {
            archive: "/dev/vde",
            directory: "/workspace/cache",
        }
    [2025-08-09T04:27:18Z TRACE ambient_ci::vdrive] extracting /dev/vde to /workspace/cache
    [2025-08-09T04:27:18Z TRACE ambient_ci::vdrive] extraction OK
    RUN: Action finished OK
    RUN: Action Spawn {
        argv: [
            "find",
            "/workspace",
            "-maxdepth",
            "2",
            "-ls",
        ],
    }
    [2025-08-09T04:27:18Z 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  9 04:27 /workspace
      3932162      4 drwxr-xr-x   2 root     root         4096 Aug  9 04:27 /workspace/artifacts
      3932693      4 drwxr-xr-x   2 root     root         4096 Jun  7 11:19 /workspace/deps
      3932163      4 drwxr-xr-x   7 root     root         4096 Aug  9 04:27 /workspace/src
      3932692      4 -rw-r--r--   1 root     root         1264 Aug  9 04:27 /workspace/src/smoke-ppc64el.vmdb
      3932165      4 drwxr-xr-x   2 root     root         4096 Aug  9 04:27 /workspace/src/.radicle
      3932181      4 -rw-r--r--   1 root     root         1976 Aug  9 04:27 /workspace/src/smoke-ppc64el.yarn
      3932685      4 -rw-r--r--   1 root     root            8 Aug  9 04:27 /workspace/src/lvm2.lukskey
      3932186      4 -rwxr-xr-x   1 root     root          101 Aug  9 04:27 /workspace/src/smoke-ppc64el.sh
      3932686      4 -rw-r--r--   1 root     root          211 Aug  9 04:27 /workspace/src/vmdb2.yaml
      3932168      8 -rwxr-xr-x   1 root     root         5713 Aug  9 04:27 /workspace/src/check-one
      3932164      4 -rwxr-xr-x   1 root     root           76 Aug  9 04:27 /workspace/src/vmdb2
      3932182      4 -rwxr-xr-x   1 root     root          516 Aug  9 04:27 /workspace/src/check-external
      3932178      4 -rw-r--r--   1 root     root         1153 Aug  9 04:27 /workspace/src/base.vmdb
      3932687      4 -rwxr-xr-x   1 root     root          304 Aug  9 04:27 /workspace/src/format.sh
      3932183      4 -rwxr-xr-x   1 root     root          308 Aug  9 04:27 /workspace/src/check-all
      3932200      4 -rw-r--r--   1 root     root           12 Aug  9 04:27 /workspace/src/.gitignore
      3932167      4 -rw-r--r--   1 root     root          985 Aug  9 04:27 /workspace/src/ppc64el.vmdb
      3932688      4 -rw-r--r--   1 root     root          504 Aug  9 04:27 /workspace/src/vmdb2.css
      3932612     12 -rw-r--r--   1 root     root        10708 Aug  9 04:27 /workspace/src/vmdb2.md
      3932684      4 -rw-r--r--   1 root     root          143 Aug  9 04:27 /workspace/src/ansible.yml
      3932202      4 drwxr-xr-x   8 root     root         4096 Aug  9 04:27 /workspace/src/.git
      3932690      4 -rwxr-xr-x   1 root     root         1083 Aug  9 04:27 /workspace/src/check-images
      3932187      4 drwxr-xr-x   3 root     root         4096 Aug  9 04:27 /workspace/src/debian
      3932201      4 -rw-r--r--   1 root     root         1057 Aug  9 04:27 /workspace/src/without-tests
      3932177      4 -rw-r--r--   1 root     root          162 Aug  9 04:27 /workspace/src/vmdb2.py
      3932199      8 -rw-r--r--   1 root     root         7962 Aug  9 04:27 /workspace/src/README.md
      3932689      4 -rw-r--r--   1 root     root         2055 Aug  9 04:27 /workspace/src/vmdb2.1
      3932180     24 -rw-r--r--   1 root     root        23398 Aug  9 04:27 /workspace/src/NEWS
      3932179      4 -rwxr-xr-x   1 root     root         1174 Aug  9 04:27 /workspace/src/setup.py
      3932185      4 -rw-r--r--   1 root     root         1271 Aug  9 04:27 /workspace/src/lvm2.vmdb
      3932184      4 -rw-r--r--   1 root     root          235 Aug  9 04:27 /workspace/src/vmdb2.subplot
      3932691      4 -rw-r--r--   1 root     root         3218 Aug  9 04:27 /workspace/src/code-of-conduct.md
      3932613      4 drwxr-xr-x   3 root     root         4096 Aug  9 04:27 /workspace/src/vmdb
      3932176      4 -rwxr-xr-x   1 root     root         1393 Aug  9 04:27 /workspace/src/check
      3932169      4 drwxr-xr-x   4 root     root         4096 Aug  9 04:27 /workspace/src/roles
      3932694      4 drwxr-xr-x   2 root     root         4096 Jun  7 11:19 /workspace/cache
    RUN: Action finished OK
    RUN: Action Shell {
        shell: "./format.sh\ncp vmdb2.html /workspace/artifacts/index.html\n",
    }
    [2025-08-09T04:27:18Z 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-09T04:27:19Z 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.5 s
    
    Checking every plugin looks OK ============================================
    
    Running Subplot ============================================
     INFO Starting Subplot
     INFO Subplot finished successfully
    srcdir /workspace/src
    datadir /tmp/tmpi8df3w7x
    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: 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: 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: 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 ========================================
    + 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=20250809T042721
    + version=0.41.ci20250809T042721-1
    + dch -v 0.41.ci20250809T042721-1 'CI build under Ambient.'
    + dch -r ''
    RUN: Action finished OK
    RUN: Action Deb
    [2025-08-09T04:27:21Z 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=284
    LANG=C.UTF-8
    CARGO_HOME=/workspace/deps
    DEBEMAIL=liw@liw.fi
    INVOCATION_ID=b68e73e2f6a442769f88959ac5f0244e
    SHLVL=2
    JOURNAL_STREAM=8:13434
    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.ci20250809T042721-1
    ++ echo 0.41.ci20250809T042721-1
    ++ sed 's/-[^-]*$//'
    + uv=0.41.ci20250809T042721
    ++ dpkg --print-architecture
    + arch=amd64
    + orig=../vmdb2_0.41.ci20250809T042721.orig.tar.xz
    + deb=../vmdb2_0.41.ci20250809T042721-1_amd64.deb
    + changes=../vmdb2_0.41.ci20250809T042721-1_amd64.changes
    + git archive HEAD
    + xz
    + dpkg-buildpackage -us -uc
    dpkg-buildpackage: info: source package vmdb2
    dpkg-buildpackage: info: source version 0.41.ci20250809T042721-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.ci20250809T042721.orig.tar.xz
    dpkg-source: info: building vmdb2 in vmdb2_0.41.ci20250809T042721-1.debian.tar.xz
    dpkg-source: info: building vmdb2 in vmdb2_0.41.ci20250809T042721-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.3 s
    
    Checking every plugin looks OK ============================================
    
    Running Subplot ============================================
     INFO Starting Subplot
     INFO Subplot finished successfully
    srcdir /workspace/src
    datadir /tmp/tmpr19x14jt
    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: 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: 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.ci20250809T042721-1_all.deb'.
     dpkg-genbuildinfo -O../vmdb2_0.41.ci20250809T042721-1_amd64.buildinfo
     dpkg-genchanges -O../vmdb2_0.41.ci20250809T042721-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  9 04:27 artifacts
    drwxr-xr-x 2 root root  4096 Jun  7 11:19 cache
    drwxr-xr-x 2 root root  4096 Jun  7 11:19 deps
    drwxr-xr-x 9 root root  4096 Aug  9 04:27 src
    -rw-r--r-- 1 root root 23684 Aug  9 04:27 vmdb2_0.41.ci20250809T042721-1.debian.tar.xz
    -rw-r--r-- 1 root root   977 Aug  9 04:27 vmdb2_0.41.ci20250809T042721-1.dsc
    -rw-r--r-- 1 root root 26864 Aug  9 04:27 vmdb2_0.41.ci20250809T042721-1_all.deb
    -rw-r--r-- 1 root root  6108 Aug  9 04:27 vmdb2_0.41.ci20250809T042721-1_amd64.buildinfo
    -rw-r--r-- 1 root root  1956 Aug  9 04:27 vmdb2_0.41.ci20250809T042721-1_amd64.changes
    -rw-r--r-- 1 root root 64380 Aug  9 04:27 vmdb2_0.41.ci20250809T042721.orig.tar.xz
    + for x in ../*.deb
    + dpkg -c ../vmdb2_0.41.ci20250809T042721-1_all.deb
    drwxr-xr-x root/root         0 2025-08-09 04:27 ./
    drwxr-xr-x root/root         0 2025-08-09 04:27 ./usr/
    drwxr-xr-x root/root         0 2025-08-09 04:27 ./usr/bin/
    -rwxr-xr-x root/root        76 2025-08-09 04:27 ./usr/bin/vmdb2
    drwxr-xr-x root/root         0 2025-08-09 04:27 ./usr/lib/
    drwxr-xr-x root/root         0 2025-08-09 04:27 ./usr/lib/python3/
    drwxr-xr-x root/root         0 2025-08-09 04:27 ./usr/lib/python3/dist-packages/
    drwxr-xr-x root/root         0 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/
    -rw-r--r-- root/root      1488 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/__init__.py
    -rw-r--r-- root/root      8321 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/app.py
    -rw-r--r-- root/root      1687 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugin.py
    -rw-r--r-- root/root      1922 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugin_tests.py
    drwxr-xr-x root/root         0 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/
    -rw-r--r-- root/root      3286 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/ansible_plugin.py
    -rw-r--r-- root/root      2578 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/apt_plugin.py
    -rw-r--r-- root/root      2419 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/cache_rootfs_plugin.py
    -rw-r--r-- root/root      1186 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/chroot_plugin.py
    -rw-r--r-- root/root      3984 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/copy_dir_plugin.py
    -rw-r--r-- root/root      1795 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/copy_file_plugin.py
    -rw-r--r-- root/root      1463 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/create_dir_plugin.py
    -rw-r--r-- root/root      1612 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/create_file_plugin.py
    -rw-r--r-- root/root      4805 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/cryptsetup_plugin.py
    -rw-r--r-- root/root      4942 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/debootstrap_plugin.py
    -rw-r--r-- root/root      1256 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/echo_plugin.py
    -rw-r--r-- root/root      1438 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/error_plugin.py
    -rw-r--r-- root/root      2920 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/fstab_plugin.py
    -rw-r--r-- root/root     15713 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/grub_plugin.py
    -rw-r--r-- root/root      3513 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/kpartx_plugin.py
    -rw-r--r-- root/root      1520 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/lvcreate_plugin.py
    -rw-r--r-- root/root      2336 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/lvscan_plugin.py
    -rw-r--r-- root/root      3108 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/mkfs_plugin.py
    -rw-r--r-- root/root      1395 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/mkimg_plugin.py
    -rw-r--r-- root/root      1139 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/mklabel_plugin.py
    -rw-r--r-- root/root      4654 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/mkpart_plugin.py
    -rw-r--r-- root/root      4046 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/mount_plugin.py
    -rw-r--r-- root/root      3295 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/resize_plugin.py
    -rw-r--r-- root/root      1915 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/set_part_flag_plugin.py
    -rw-r--r-- root/root      1210 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/shell_plugin.py
    -rw-r--r-- root/root      1582 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/unpack_rootfs_plugin.py
    -rw-r--r-- root/root      1539 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/vgcreate_plugin.py
    -rw-r--r-- root/root      2546 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/plugins/virtualfs_plugin.py
    -rw-r--r-- root/root      3201 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/runcmd.py
    -rw-r--r-- root/root      1488 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/spec.py
    -rw-r--r-- root/root      2687 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/spec_tests.py
    -rw-r--r-- root/root       973 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/state.py
    -rw-r--r-- root/root      4277 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/step_list.py
    -rw-r--r-- root/root      3642 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/step_list_tests.py
    -rw-r--r-- root/root      5356 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/tags.py
    -rw-r--r-- root/root      6873 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/tags_tests.py
    -rw-r--r-- root/root      2444 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/unmount.py
    -rw-r--r-- root/root      2109 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/unmount_tests.py
    -rw-r--r-- root/root        48 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb/version.py
    -rw-r--r-- root/root       241 2025-08-09 04:27 ./usr/lib/python3/dist-packages/vmdb2-0.41.egg-info
    drwxr-xr-x root/root         0 2025-08-09 04:27 ./usr/share/
    drwxr-xr-x root/root         0 2025-08-09 04:27 ./usr/share/doc/
    drwxr-xr-x root/root         0 2025-08-09 04:27 ./usr/share/doc/vmdb2/
    -rw-r--r-- root/root       685 2025-08-09 04:27 ./usr/share/doc/vmdb2/changelog.Debian.gz
    -rw-r--r-- root/root       979 2025-08-09 04:27 ./usr/share/doc/vmdb2/copyright
    drwxr-xr-x root/root         0 2025-08-09 04:27 ./usr/share/man/
    drwxr-xr-x root/root         0 2025-08-09 04:27 ./usr/share/man/man1/
    -rw-r--r-- root/root      1047 2025-08-09 04:27 ./usr/share/man/man1/vmdb2.1.gz
    + mv ../vmdb2_0.41.ci20250809T042721-1.debian.tar.xz ../vmdb2_0.41.ci20250809T042721-1.dsc ../vmdb2_0.41.ci20250809T042721-1_all.deb ../vmdb2_0.41.ci20250809T042721-1_amd64.buildinfo ../vmdb2_0.41.ci20250809T042721-1_amd64.changes ../vmdb2_0.41.ci20250809T042721.orig.tar.xz /workspace/artifacts
    RUN: Action finished OK
    RUN: Action TarCreate {
        archive: "/dev/vde",
        directory: "/workspace/cache",
    }
    [2025-08-09T04:27:33Z DEBUG ambient_ci::action] Plan::execute: TarCreate {
            archive: "/dev/vde",
            directory: "/workspace/cache",
        }
    [2025-08-09T04:27:33Z TRACE ambient_ci::vdrive] creating virtual drive (tar archive): VirtualDriveBuilder {
            filename: Some(
                "/dev/vde",
            ),
            root: Some(
                "/workspace/cache",
            ),
            size: None,
        }
    [2025-08-09T04:27:33Z TRACE ambient_ci::vdrive] tar archive to be created: /dev/vde; exists? true
    [2025-08-09T04:27:33Z TRACE ambient_ci::vdrive] create archive file /dev/vde
    [2025-08-09T04:27:33Z TRACE ambient_ci::vdrive] directory /workspace/cache exists? true
    [2025-08-09T04:27:33Z TRACE ambient_ci::vdrive] add contents of /workspace/cache as .
    [2025-08-09T04:27:33Z TRACE ambient_ci::vdrive] created virtual drive /dev/vde
    RUN: Action finished OK
    RUN: Action TarCreate {
        archive: "/dev/vdd",
        directory: "/workspace/artifacts",
    }
    [2025-08-09T04:27:33Z DEBUG ambient_ci::action] Plan::execute: TarCreate {
            archive: "/dev/vdd",
            directory: "/workspace/artifacts",
        }
    [2025-08-09T04:27:33Z TRACE ambient_ci::vdrive] creating virtual drive (tar archive): VirtualDriveBuilder {
            filename: Some(
                "/dev/vdd",
            ),
            root: Some(
                "/workspace/artifacts",
            ),
            size: None,
        }
    [2025-08-09T04:27:33Z TRACE ambient_ci::vdrive] tar archive to be created: /dev/vdd; exists? true
    [2025-08-09T04:27:33Z TRACE ambient_ci::vdrive] create archive file /dev/vdd
    [2025-08-09T04:27:33Z TRACE ambient_ci::vdrive] directory /workspace/artifacts exists? true
    [2025-08-09T04:27:33Z TRACE ambient_ci::vdrive] add contents of /workspace/artifacts as .
    [2025-08-09T04:27:33Z TRACE ambient_ci::vdrive] created virtual drive /dev/vdd
    RUN: Action finished OK
    ambient-execute-plan ends
    EXIT CODE: 0
    
    ====================
[2025-08-09T04:27:37Z DEBUG ambient_ci::qemu] QEMU exit code 0
[2025-08-09T04:27:37Z DEBUG ambient_ci::run] remove old cache
[2025-08-09T04:27:37Z DEBUG ambient_ci::run] extract cache
[2025-08-09T04:27:37Z DEBUG ambient_ci::run] Executing post-plan steps
[2025-08-09T04:27:37Z DEBUG ambient_ci::action] Plan::execute: Dput {
        artifactsdir: "/srv/ambient-state/vmdb2/artifacts",
        dput_target: Some(
            "apt.liw.fi",
        ),
    }
[2025-08-09T04:27:37Z DEBUG ambient_ci::util] found /srv/ambient-state/vmdb2/artifacts
[2025-08-09T04:27:37Z DEBUG ambient_ci::util] found /srv/ambient-state/vmdb2/artifacts/vmdb2_0.41.ci20250809T042721-1_all.deb
[2025-08-09T04:27:37Z DEBUG ambient_ci::util] found /srv/ambient-state/vmdb2/artifacts/vmdb2_0.41.ci20250809T042721.orig.tar.xz
[2025-08-09T04:27:37Z DEBUG ambient_ci::util] found /srv/ambient-state/vmdb2/artifacts/vmdb2_0.41.ci20250809T042721-1.debian.tar.xz
[2025-08-09T04:27:37Z DEBUG ambient_ci::util] found /srv/ambient-state/vmdb2/artifacts/index.html
[2025-08-09T04:27:37Z DEBUG ambient_ci::util] found /srv/ambient-state/vmdb2/artifacts/vmdb2_0.41.ci20250809T042721-1.dsc
[2025-08-09T04:27:37Z DEBUG ambient_ci::util] found /srv/ambient-state/vmdb2/artifacts/vmdb2_0.41.ci20250809T042721-1_amd64.buildinfo
[2025-08-09T04:27:37Z DEBUG ambient_ci::util] found /srv/ambient-state/vmdb2/artifacts/vmdb2_0.41.ci20250809T042721-1_amd64.changes
[2025-08-09T04:27:37Z INFO  ambient_ci::util] dput apt.liw.fi /srv/ambient-state/vmdb2/artifacts/vmdb2_0.41.ci20250809T042721-1_amd64.changes
[2025-08-09T04:27:38Z 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-09T04:27:38Z INFO  ambient_ci::util] rsync /srv/ambient-state/vmdb2/artifacts/. -> ci@http.liw.fi:/srv/http/vmdb2-manual.liw.fi/.
[2025-08-09T04:27:39Z DEBUG ambient_ci::project] write project state to /srv/ambient-state/vmdb2/meta.yaml
[2025-08-09T04:27:39Z INFO  ambient] ambient ends successfully

Ambient stderr

<empty log>