[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] checking ailisp/test-flatdata against master#db1fb85cff63ad5fffe435e17128f99f9e1d970c for pr-89056
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Failisp%2Ftest-flatdata" "/workspace/builds/worker-13/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-13/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/ailisp/test-flatdata on toolchain db1fb85cff63ad5fffe435e17128f99f9e1d970c
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+db1fb85cff63ad5fffe435e17128f99f9e1d970c" "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-13/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" "+db1fb85cff63ad5fffe435e17128f99f9e1d970c" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-13/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-13/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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+db1fb85cff63ad5fffe435e17128f99f9e1d970c" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 944f99c7e5d7d6efacc87d182d69c60e253f36ff6ad09ac61ebf3856ed3df32f
[INFO] running `Command { std: "docker" "start" "-a" "944f99c7e5d7d6efacc87d182d69c60e253f36ff6ad09ac61ebf3856ed3df32f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "944f99c7e5d7d6efacc87d182d69c60e253f36ff6ad09ac61ebf3856ed3df32f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "944f99c7e5d7d6efacc87d182d69c60e253f36ff6ad09ac61ebf3856ed3df32f", kill_on_drop: false }`
[INFO] [stdout] 944f99c7e5d7d6efacc87d182d69c60e253f36ff6ad09ac61ebf3856ed3df32f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-13/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-13/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=forbid" "-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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+db1fb85cff63ad5fffe435e17128f99f9e1d970c" "check" "--frozen" "--all" "--all-targets" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 7c7f3452a3ae88df9c2672da20e7d16ad206694c2d9929867a0f51fc99b498bc
[INFO] running `Command { std: "docker" "start" "-a" "7c7f3452a3ae88df9c2672da20e7d16ad206694c2d9929867a0f51fc99b498bc", kill_on_drop: false }`
[INFO] [stderr]    Compiling same-file v1.0.6
[INFO] [stderr]    Compiling diff v0.1.12
[INFO] [stderr]    Compiling libc v0.2.88
[INFO] [stderr]     Checking memmap v0.7.0
[INFO] [stderr]    Compiling walkdir v2.3.1
[INFO] [stderr]     Checking 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-88b8edce328c9211/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-8a5d1724712fc581/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:     0x556046406e7c - std::backtrace_rs::backtrace::libunwind::trace::h2ab374bc2a3b7023
[INFO] [stderr]                                  at /rustc/db1fb85cff63ad5fffe435e17128f99f9e1d970c/library/std/src/../../backtrace/src/backtrace/libunwind.rs:90:5
[INFO] [stderr]      1:     0x556046406e7c - std::backtrace_rs::backtrace::trace_unsynchronized::h128cb5178b04dc46
[INFO] [stderr]                                  at /rustc/db1fb85cff63ad5fffe435e17128f99f9e1d970c/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stderr]      2:     0x556046406e7c - std::sys_common::backtrace::_print_fmt::h5344f9eefca2041f
[INFO] [stderr]                                  at /rustc/db1fb85cff63ad5fffe435e17128f99f9e1d970c/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stderr]      3:     0x556046406e7c - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h213003bc5c7acf04
[INFO] [stderr]                                  at /rustc/db1fb85cff63ad5fffe435e17128f99f9e1d970c/library/std/src/sys_common/backtrace.rs:46:22
[INFO] [stderr]      4:     0x5560464256ec - core::fmt::write::h78bf85fc3e93663f
[INFO] [stderr]                                  at /rustc/db1fb85cff63ad5fffe435e17128f99f9e1d970c/library/core/src/fmt/mod.rs:1126:17
[INFO] [stderr]      5:     0x5560464043c5 - std::io::Write::write_fmt::he619515c888f21a5
[INFO] [stderr]                                  at /rustc/db1fb85cff63ad5fffe435e17128f99f9e1d970c/library/std/src/io/mod.rs:1667:15
[INFO] [stderr]      6:     0x556046408570 - std::sys_common::backtrace::_print::hf706674f77848203
[INFO] [stderr]                                  at /rustc/db1fb85cff63ad5fffe435e17128f99f9e1d970c/library/std/src/sys_common/backtrace.rs:49:5
[INFO] [stderr]      7:     0x556046408570 - std::sys_common::backtrace::print::hf0b6c7a88804ec56
[INFO] [stderr]                                  at /rustc/db1fb85cff63ad5fffe435e17128f99f9e1d970c/library/std/src/sys_common/backtrace.rs:36:9
[INFO] [stderr]      8:     0x556046408570 - std::panicking::default_hook::{{closure}}::h2dde766cd83a333a
[INFO] [stderr]                                  at /rustc/db1fb85cff63ad5fffe435e17128f99f9e1d970c/library/std/src/panicking.rs:210:50
[INFO] [stderr]      9:     0x556046408127 - std::panicking::default_hook::h501e3b2e134eb149
[INFO] [stderr]                                  at /rustc/db1fb85cff63ad5fffe435e17128f99f9e1d970c/library/std/src/panicking.rs:227:9
[INFO] [stderr]     10:     0x556046408c24 - std::panicking::rust_panic_with_hook::hc09e869c4cf00885
[INFO] [stderr]                                  at /rustc/db1fb85cff63ad5fffe435e17128f99f9e1d970c/library/std/src/panicking.rs:624:17
[INFO] [stderr]     11:     0x556046408700 - std::panicking::begin_panic_handler::{{closure}}::hc2c6d70142458fc8
[INFO] [stderr]                                  at /rustc/db1fb85cff63ad5fffe435e17128f99f9e1d970c/library/std/src/panicking.rs:521:13
[INFO] [stderr]     12:     0x556046407324 - std::sys_common::backtrace::__rust_end_short_backtrace::had58f7c459a1cd6e
[INFO] [stderr]                                  at /rustc/db1fb85cff63ad5fffe435e17128f99f9e1d970c/library/std/src/sys_common/backtrace.rs:141:18
[INFO] [stderr]     13:     0x556046408669 - rust_begin_unwind
[INFO] [stderr]                                  at /rustc/db1fb85cff63ad5fffe435e17128f99f9e1d970c/library/std/src/panicking.rs:517:5
[INFO] [stderr]     14:     0x5560463c8211 - core::panicking::panic_fmt::hf443e5eeb6cc9eab
[INFO] [stderr]                                  at /rustc/db1fb85cff63ad5fffe435e17128f99f9e1d970c/library/core/src/panicking.rs:103:14
[INFO] [stderr]     15:     0x5560463c82a3 - core::result::unwrap_failed::h885d3f7beb571353
[INFO] [stderr]                                  at /rustc/db1fb85cff63ad5fffe435e17128f99f9e1d970c/library/core/src/result.rs:1617:5
[INFO] [stderr]     16:     0x5560463d02e8 - core::result::Result<T,E>::expect::h1b7fc815b03374e1
[INFO] [stderr]                                  at /rustc/db1fb85cff63ad5fffe435e17128f99f9e1d970c/library/core/src/result.rs:1259:23
[INFO] [stderr]     17:     0x5560463cc15d - build_script_build::main::hc4ac0e6aebacebd8
[INFO] [stderr]                                  at /opt/rustwide/workdir/build.rs:2:5
[INFO] [stderr]     18:     0x5560463ce2bb - core::ops::function::FnOnce::call_once::ha2515622a779dd99
[INFO] [stderr]                                  at /rustc/db1fb85cff63ad5fffe435e17128f99f9e1d970c/library/core/src/ops/function.rs:227:5
[INFO] [stderr]     19:     0x5560463d09de - std::sys_common::backtrace::__rust_begin_short_backtrace::h66c9058100d61d7b
[INFO] [stderr]                                  at /rustc/db1fb85cff63ad5fffe435e17128f99f9e1d970c/library/std/src/sys_common/backtrace.rs:125:18
[INFO] [stderr]     20:     0x5560463d0a71 - std::rt::lang_start::{{closure}}::h097771ce74eae343
[INFO] [stderr]                                  at /rustc/db1fb85cff63ad5fffe435e17128f99f9e1d970c/library/std/src/rt.rs:64:18
[INFO] [stderr]     21:     0x55604640912a - core::ops::function::impls::<impl core::ops::function::FnOnce<A> for &F>::call_once::hab43eb8ec758341e
[INFO] [stderr]                                  at /rustc/db1fb85cff63ad5fffe435e17128f99f9e1d970c/library/core/src/ops/function.rs:259:13
[INFO] [stderr]     22:     0x55604640912a - std::panicking::try::do_call::hb667fefd650e964d
[INFO] [stderr]                                  at /rustc/db1fb85cff63ad5fffe435e17128f99f9e1d970c/library/std/src/panicking.rs:403:40
[INFO] [stderr]     23:     0x55604640912a - std::panicking::try::hc279775c9409768d
[INFO] [stderr]                                  at /rustc/db1fb85cff63ad5fffe435e17128f99f9e1d970c/library/std/src/panicking.rs:367:19
[INFO] [stderr]     24:     0x55604640912a - std::panic::catch_unwind::hbe8b6ecc84f73073
[INFO] [stderr]                                  at /rustc/db1fb85cff63ad5fffe435e17128f99f9e1d970c/library/std/src/panic.rs:133:14
[INFO] [stderr]     25:     0x55604640912a - std::rt::lang_start_internal::{{closure}}::hb04fdaef496a162b
[INFO] [stderr]                                  at /rustc/db1fb85cff63ad5fffe435e17128f99f9e1d970c/library/std/src/rt.rs:46:48
[INFO] [stderr]     26:     0x55604640912a - std::panicking::try::do_call::habca359de051411d
[INFO] [stderr]                                  at /rustc/db1fb85cff63ad5fffe435e17128f99f9e1d970c/library/std/src/panicking.rs:403:40
[INFO] [stderr]     27:     0x55604640912a - std::panicking::try::h24c556a6948e0937
[INFO] [stderr]                                  at /rustc/db1fb85cff63ad5fffe435e17128f99f9e1d970c/library/std/src/panicking.rs:367:19
[INFO] [stderr]     28:     0x55604640912a - std::panic::catch_unwind::h58075d47f5a308d8
[INFO] [stderr]                                  at /rustc/db1fb85cff63ad5fffe435e17128f99f9e1d970c/library/std/src/panic.rs:133:14
[INFO] [stderr]     29:     0x55604640912a - std::rt::lang_start_internal::h3d20dc1537d76758
[INFO] [stderr]                                  at /rustc/db1fb85cff63ad5fffe435e17128f99f9e1d970c/library/std/src/rt.rs:46:20
[INFO] [stderr]     30:     0x5560463d0a40 - std::rt::lang_start::h0979dfd38815d197
[INFO] [stderr]                                  at /rustc/db1fb85cff63ad5fffe435e17128f99f9e1d970c/library/std/src/rt.rs:63:17
[INFO] [stderr]     31:     0x5560463cc1cc - main
[INFO] [stderr]     32:     0x7f7468b700b3 - __libc_start_main
[INFO] [stderr]     33:     0x5560463c896e - _start
[INFO] [stderr]     34:                0x0 - <unknown>
[INFO] running `Command { std: "docker" "inspect" "7c7f3452a3ae88df9c2672da20e7d16ad206694c2d9929867a0f51fc99b498bc", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7c7f3452a3ae88df9c2672da20e7d16ad206694c2d9929867a0f51fc99b498bc", kill_on_drop: false }`
[INFO] [stdout] 7c7f3452a3ae88df9c2672da20e7d16ad206694c2d9929867a0f51fc99b498bc