[INFO] cloning repository https://github.com/ailisp/test-flatdata
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/ailisp/test-flatdata" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Failisp%2Ftest-flatdata", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Failisp%2Ftest-flatdata'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] fc6764c520b14b873691e25ccfd83996d64f0cd8
[INFO] testing ailisp/test-flatdata against 1.54.0 for beta-1.55-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Failisp%2Ftest-flatdata" "/workspace/builds/worker-3/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-3/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/ailisp/test-flatdata on toolchain 1.54.0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.54.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/ailisp/test-flatdata
[INFO] finished tweaking git repo https://github.com/ailisp/test-flatdata
[INFO] tweaked toml for git repo https://github.com/ailisp/test-flatdata written to /workspace/builds/worker-3/source/Cargo.toml
[INFO] crate git repo https://github.com/ailisp/test-flatdata already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.54.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+1.54.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] d3ea460f379f8967bd2358f577402d61b378fc7193c445106d093b5fd3d748f7
[INFO] running `Command { std: "docker" "start" "-a" "d3ea460f379f8967bd2358f577402d61b378fc7193c445106d093b5fd3d748f7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "d3ea460f379f8967bd2358f577402d61b378fc7193c445106d093b5fd3d748f7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d3ea460f379f8967bd2358f577402d61b378fc7193c445106d093b5fd3d748f7", kill_on_drop: false }`
[INFO] [stdout] d3ea460f379f8967bd2358f577402d61b378fc7193c445106d093b5fd3d748f7
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+1.54.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] bc464772aca479478ca41bfd1297a5f41bd2a96f3ad00d7f9036ce4d496520cc
[INFO] running `Command { std: "docker" "start" "-a" "bc464772aca479478ca41bfd1297a5f41bd2a96f3ad00d7f9036ce4d496520cc", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling libc v0.2.88
[INFO] [stderr]    Compiling diff v0.1.12
[INFO] [stderr]    Compiling memmap v0.7.0
[INFO] [stderr]    Compiling flatdata v0.5.1
[INFO] [stderr]    Compiling test-flatdata v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr] error: failed to run custom build command for `test-flatdata v0.1.0 (/opt/rustwide/workdir)`
[INFO] [stderr] 
[INFO] [stderr] Caused by:
[INFO] [stderr]   process didn't exit successfully: `/opt/rustwide/target/debug/build/test-flatdata-f322e1f96840d31b/build-script-build` (exit status: 101)
[INFO] [stderr]   --- stdout
[INFO] [stderr]   The virtual environment was not created successfully because ensurepip is not
[INFO] [stderr]   available.  On Debian/Ubuntu systems, you need to install the python3-venv
[INFO] [stderr]   package using the following command.
[INFO] [stderr] 
[INFO] [stderr]       apt install python3.8-venv
[INFO] [stderr] 
[INFO] [stderr]   You may need to use sudo with that command.  After installing the python3-venv
[INFO] [stderr]   package, recreate your virtual environment.
[INFO] [stderr] 
[INFO] [stderr]   Failing command: ['/opt/rustwide/target/debug/build/test-flatdata-1657e99c769b2b31/out/bin/python3', '-Im', 'ensurepip', '--upgrade', '--default-pip']
[INFO] [stderr] 
[INFO] [stderr] 
[INFO] [stderr]   --- stderr
[INFO] [stderr]   creating python virtualenv
[INFO] [stderr]   installing flatdata-generator from PyPI
[INFO] [stderr]   thread 'main' panicked at 'generator failed: PythonError(Os { code: 2, kind: NotFound, message: "No such file or directory" })', build.rs:6:6
[INFO] [stderr]   stack backtrace:
[INFO] [stderr]      0:     0x55e50a31ab70 - std::backtrace_rs::backtrace::libunwind::trace::h34055254b57d8e79
[INFO] [stderr]                                  at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/../../backtrace/src/backtrace/libunwind.rs:90:5
[INFO] [stderr]      1:     0x55e50a31ab70 - std::backtrace_rs::backtrace::trace_unsynchronized::h8f1e3fbd9afff6ec
[INFO] [stderr]                                  at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stderr]      2:     0x55e50a31ab70 - std::sys_common::backtrace::_print_fmt::h3a99a796b770c360
[INFO] [stderr]                                  at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stderr]      3:     0x55e50a31ab70 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h32d1f94a80615d18
[INFO] [stderr]                                  at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sys_common/backtrace.rs:46:22
[INFO] [stderr]      4:     0x55e50a33880c - core::fmt::write::h306731c068f7162c
[INFO] [stderr]                                  at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/fmt/mod.rs:1110:17
[INFO] [stderr]      5:     0x55e50a318535 - std::io::Write::write_fmt::hd2fa90334eee2a21
[INFO] [stderr]                                  at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/io/mod.rs:1588:15
[INFO] [stderr]      6:     0x55e50a31c82b - std::sys_common::backtrace::_print::h5abaa2601a852287
[INFO] [stderr]                                  at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sys_common/backtrace.rs:49:5
[INFO] [stderr]      7:     0x55e50a31c82b - std::sys_common::backtrace::print::h8d81445442bb638f
[INFO] [stderr]                                  at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sys_common/backtrace.rs:36:9
[INFO] [stderr]      8:     0x55e50a31c82b - std::panicking::default_hook::{{closure}}::hcfe804496a9fa747
[INFO] [stderr]                                  at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:208:50
[INFO] [stderr]      9:     0x55e50a31c301 - std::panicking::default_hook::hbea8e3ccf2ba8901
[INFO] [stderr]                                  at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:225:9
[INFO] [stderr]     10:     0x55e50a31cef4 - std::panicking::rust_panic_with_hook::h7ee9e1a2d0f8975a
[INFO] [stderr]                                  at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:622:17
[INFO] [stderr]     11:     0x55e50a31c9d7 - std::panicking::begin_panic_handler::{{closure}}::h8ab3b4491718b2c7
[INFO] [stderr]                                  at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:519:13
[INFO] [stderr]     12:     0x55e50a31b06c - std::sys_common::backtrace::__rust_end_short_backtrace::hd489062ffa586a9f
[INFO] [stderr]                                  at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sys_common/backtrace.rs:141:18
[INFO] [stderr]     13:     0x55e50a31c939 - rust_begin_unwind
[INFO] [stderr]                                  at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:515:5
[INFO] [stderr]     14:     0x55e50a2e22b1 - core::panicking::panic_fmt::hca6330e3e14086b4
[INFO] [stderr]                                  at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/panicking.rs:92:14
[INFO] [stderr]     15:     0x55e50a2e2343 - core::result::unwrap_failed::h6160d2b4bfbb0e87
[INFO] [stderr]                                  at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/result.rs:1355:5
[INFO] [stderr]     16:     0x55e50a2e8089 - core::result::Result<T,E>::expect::hdf22b554c79aa6fa
[INFO] [stderr]                                  at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/result.rs:997:23
[INFO] [stderr]     17:     0x55e50a2ea67d - build_script_build::main::hc8b0a5ee2d910da2
[INFO] [stderr]                                  at /opt/rustwide/workdir/build.rs:2:5
[INFO] [stderr]     18:     0x55e50a2e8fbb - core::ops::function::FnOnce::call_once::hcbb9cf7307cc7371
[INFO] [stderr]                                  at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/ops/function.rs:227:5
[INFO] [stderr]     19:     0x55e50a2e8dae - std::sys_common::backtrace::__rust_begin_short_backtrace::h3f5bc6b2bd0d9654
[INFO] [stderr]                                  at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sys_common/backtrace.rs:125:18
[INFO] [stderr]     20:     0x55e50a2e8e31 - std::rt::lang_start::{{closure}}::h24effcf01b1f92e7
[INFO] [stderr]                                  at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/rt.rs:49:18
[INFO] [stderr]     21:     0x55e50a31d3f9 - core::ops::function::impls::<impl core::ops::function::FnOnce<A> for &F>::call_once::h2aabc384aab89b7b
[INFO] [stderr]                                  at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/ops/function.rs:259:13
[INFO] [stderr]     22:     0x55e50a31d3f9 - std::panicking::try::do_call::hc5fcacb7a85fc7b1
[INFO] [stderr]                                  at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:401:40
[INFO] [stderr]     23:     0x55e50a31d3f9 - std::panicking::try::hb5d9603af3abbe3a
[INFO] [stderr]                                  at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:365:19
[INFO] [stderr]     24:     0x55e50a31d3f9 - std::panic::catch_unwind::h98fe6ac3925e64b4
[INFO] [stderr]                                  at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panic.rs:434:14
[INFO] [stderr]     25:     0x55e50a31d3f9 - std::rt::lang_start_internal::h22ac7383c516f93e
[INFO] [stderr]                                  at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/rt.rs:34:21
[INFO] [stderr]     26:     0x55e50a2e8e10 - std::rt::lang_start::h69c54df8ff6a1d5c
[INFO] [stderr]                                  at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/rt.rs:48:5
[INFO] [stderr]     27:     0x55e50a2ea6ec - main
[INFO] [stderr]     28:     0x7f5dd80fe0b3 - __libc_start_main
[INFO] [stderr]     29:     0x55e50a2e2a0e - _start
[INFO] [stderr]     30:                0x0 - <unknown>
[INFO] running `Command { std: "docker" "inspect" "bc464772aca479478ca41bfd1297a5f41bd2a96f3ad00d7f9036ce4d496520cc", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "bc464772aca479478ca41bfd1297a5f41bd2a96f3ad00d7f9036ce4d496520cc", kill_on_drop: false }`
[INFO] [stdout] bc464772aca479478ca41bfd1297a5f41bd2a96f3ad00d7f9036ce4d496520cc
