[INFO] cloning repository https://github.com/Jturnerusa/lisp
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/Jturnerusa/lisp" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FJturnerusa%2Flisp", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FJturnerusa%2Flisp'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 6a3008e584fd6908f1b1049e5e5da9e3f9eb9720
[INFO] testing Jturnerusa/lisp/6a3008e584fd6908f1b1049e5e5da9e3f9eb9720 against master#595316b4006932405a63862d8fe65f71a6356293 for pr-128254
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FJturnerusa%2Flisp" "/workspace/builds/worker-1-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-1-tc1/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/Jturnerusa/lisp on toolchain 595316b4006932405a63862d8fe65f71a6356293
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+595316b4006932405a63862d8fe65f71a6356293" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/Jturnerusa/lisp
[INFO] finished tweaking git repo https://github.com/Jturnerusa/lisp
[INFO] tweaked toml for git repo https://github.com/Jturnerusa/lisp written to /workspace/builds/worker-1-tc1/source/Cargo.toml
[INFO] crate git repo https://github.com/Jturnerusa/lisp already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+595316b4006932405a63862d8fe65f71a6356293" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[ERROR] error running command: no output for 300 seconds
[ERROR] this task or one of its parent failed!
[ERROR] no output for 300 seconds
[ERROR] note: run with `RUST_BACKTRACE=1` to display a backtrace.
[INFO] testing Jturnerusa/lisp/6a3008e584fd6908f1b1049e5e5da9e3f9eb9720 against try#5e89635d7bf1d3033c2eb20378b7b3cbe2dd1a9b for pr-128254
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FJturnerusa%2Flisp" "/workspace/builds/worker-1-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-1-tc2/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/Jturnerusa/lisp on toolchain 5e89635d7bf1d3033c2eb20378b7b3cbe2dd1a9b
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+5e89635d7bf1d3033c2eb20378b7b3cbe2dd1a9b" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/Jturnerusa/lisp
[INFO] finished tweaking git repo https://github.com/Jturnerusa/lisp
[INFO] tweaked toml for git repo https://github.com/Jturnerusa/lisp written to /workspace/builds/worker-1-tc2/source/Cargo.toml
[INFO] crate git repo https://github.com/Jturnerusa/lisp already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+5e89635d7bf1d3033c2eb20378b7b3cbe2dd1a9b" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]     Blocking waiting for file lock on package cache
[ERROR] error running command: no output for 300 seconds
[INFO] testing Jturnerusa/lisp/6a3008e584fd6908f1b1049e5e5da9e3f9eb9720 against try#5e89635d7bf1d3033c2eb20378b7b3cbe2dd1a9b for pr-128254
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FJturnerusa%2Flisp" "/workspace/builds/worker-1-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-1-tc2/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/Jturnerusa/lisp on toolchain 5e89635d7bf1d3033c2eb20378b7b3cbe2dd1a9b
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+5e89635d7bf1d3033c2eb20378b7b3cbe2dd1a9b" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/Jturnerusa/lisp
[INFO] finished tweaking git repo https://github.com/Jturnerusa/lisp
[INFO] tweaked toml for git repo https://github.com/Jturnerusa/lisp written to /workspace/builds/worker-1-tc2/source/Cargo.toml
[INFO] crate git repo https://github.com/Jturnerusa/lisp already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+5e89635d7bf1d3033c2eb20378b7b3cbe2dd1a9b" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded quasiquote-proc-macro v0.1.0
[INFO] [stderr]   Downloaded logos-codegen v0.14.0
[INFO] [stderr]   Downloaded quasiquote v0.1.1
[INFO] [stderr]   Downloaded logos-derive v0.14.0
[INFO] [stderr]   Downloaded unwrap-enum v0.1.0
[INFO] [stderr]   Downloaded unwrap-enum-proc-macro v0.1.0
[INFO] [stderr]   Downloaded logos v0.14.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/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:923055f121b5182466d55868a8b05e67af8ba4a3a3f6bad814e953ca3cd3ac2a" "/opt/rustwide/cargo-home/bin/cargo" "+5e89635d7bf1d3033c2eb20378b7b3cbe2dd1a9b" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 95cab13b85ba2e1af980825416d28f89f6fdb47d40607567c87c215d54e57743
[INFO] running `Command { std: "docker" "start" "-a" "95cab13b85ba2e1af980825416d28f89f6fdb47d40607567c87c215d54e57743", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "95cab13b85ba2e1af980825416d28f89f6fdb47d40607567c87c215d54e57743", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "95cab13b85ba2e1af980825416d28f89f6fdb47d40607567c87c215d54e57743", kill_on_drop: false }`
[INFO] [stdout] 95cab13b85ba2e1af980825416d28f89f6fdb47d40607567c87c215d54e57743
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/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" "RUSTDOCFLAGS=--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:923055f121b5182466d55868a8b05e67af8ba4a3a3f6bad814e953ca3cd3ac2a" "/opt/rustwide/cargo-home/bin/cargo" "+5e89635d7bf1d3033c2eb20378b7b3cbe2dd1a9b" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 0d6fa50d8e3f247b2fb967ea1bda3043f81c6a4b0de67df79cd3009387c1b2b1
[INFO] running `Command { std: "docker" "start" "-a" "0d6fa50d8e3f247b2fb967ea1bda3043f81c6a4b0de67df79cd3009387c1b2b1", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.79
[INFO] [stderr]    Compiling unicode-ident v1.0.12
[INFO] [stderr]    Compiling either v1.10.0
[INFO] [stderr]    Compiling thiserror v1.0.61
[INFO] [stderr]    Compiling beef v0.5.2
[INFO] [stderr]    Compiling lazy_static v1.5.0
[INFO] [stderr]    Compiling fnv v1.0.7
[INFO] [stderr]    Compiling regex-syntax v0.8.4
[INFO] [stderr]    Compiling gc v0.1.0 (/opt/rustwide/workdir/crates/gc)
[INFO] [stderr]    Compiling micro-nom v0.1.0 (/opt/rustwide/workdir/vendor/micro-nom)
[INFO] [stderr]    Compiling itertools v0.10.5
[INFO] [stderr]    Compiling quote v1.0.35
[INFO] [stderr]    Compiling syn v2.0.53
[INFO] [stderr]    Compiling quasiquote-proc-macro v0.1.0
[INFO] [stderr]    Compiling quasiquote v0.1.1
[INFO] [stderr]    Compiling logos-codegen v0.14.0
[INFO] [stderr]    Compiling unwrap-enum-proc-macro v0.1.0
[INFO] [stderr]    Compiling thiserror-impl v1.0.61
[INFO] [stderr]    Compiling unwrap-enum v0.1.0
[INFO] [stderr]    Compiling value v0.1.0 (/opt/rustwide/workdir/crates/value)
[INFO] [stderr]    Compiling logos-derive v0.14.0
[INFO] [stderr]    Compiling logos v0.14.0
[INFO] [stderr]    Compiling vm v0.1.0 (/opt/rustwide/workdir/crates/vm)
[INFO] [stderr]    Compiling reader v0.1.0 (/opt/rustwide/workdir/crates/reader)
[INFO] [stderr]    Compiling compiler v0.1.0 (/opt/rustwide/workdir/crates/compiler)
[INFO] [stderr]    Compiling native-functions v0.1.0 (/opt/rustwide/workdir/lib/native)
[INFO] [stderr]    Compiling lisp v0.0.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 11.26s
[INFO] running `Command { std: "docker" "inspect" "0d6fa50d8e3f247b2fb967ea1bda3043f81c6a4b0de67df79cd3009387c1b2b1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "0d6fa50d8e3f247b2fb967ea1bda3043f81c6a4b0de67df79cd3009387c1b2b1", kill_on_drop: false }`
[INFO] [stdout] 0d6fa50d8e3f247b2fb967ea1bda3043f81c6a4b0de67df79cd3009387c1b2b1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/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" "RUSTDOCFLAGS=--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:923055f121b5182466d55868a8b05e67af8ba4a3a3f6bad814e953ca3cd3ac2a" "/opt/rustwide/cargo-home/bin/cargo" "+5e89635d7bf1d3033c2eb20378b7b3cbe2dd1a9b" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] de91f351fa07ea0035e1b08a067a23b50ad31b1e33278243645d96c423db9e04
[INFO] running `Command { std: "docker" "start" "-a" "de91f351fa07ea0035e1b08a067a23b50ad31b1e33278243645d96c423db9e04", kill_on_drop: false }`
[INFO] [stderr]    Compiling lisp v0.0.1 (/opt/rustwide/workdir)
[INFO] [stdout] warning: function `disasm` is never used
[INFO] [stdout]   --> tests/lisp.rs:26:4
[INFO] [stdout]    |
[INFO] [stdout] 26 | fn disasm<D: fmt::Debug>(opcode_table: &OpCodeTable<D>, depth: usize) {
[INFO] [stdout]    |    ^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 1 warning emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.36s
[INFO] running `Command { std: "docker" "inspect" "de91f351fa07ea0035e1b08a067a23b50ad31b1e33278243645d96c423db9e04", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "de91f351fa07ea0035e1b08a067a23b50ad31b1e33278243645d96c423db9e04", kill_on_drop: false }`
[INFO] [stdout] de91f351fa07ea0035e1b08a067a23b50ad31b1e33278243645d96c423db9e04
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/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" "RUSTDOCFLAGS=--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:923055f121b5182466d55868a8b05e67af8ba4a3a3f6bad814e953ca3cd3ac2a" "/opt/rustwide/cargo-home/bin/cargo" "+5e89635d7bf1d3033c2eb20378b7b3cbe2dd1a9b" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] c9adadd526f7f549bf6b1043eff80e3dc5e671f3a8c5bdec74cd12051e468c1b
[INFO] running `Command { std: "docker" "start" "-a" "c9adadd526f7f549bf6b1043eff80e3dc5e671f3a8c5bdec74cd12051e468c1b", kill_on_drop: false }`
[INFO] [stderr] warning: function `disasm` is never used
[INFO] [stderr]   --> tests/lisp.rs:26:4
[INFO] [stderr]    |
[INFO] [stderr] 26 | fn disasm<D: fmt::Debug>(opcode_table: &OpCodeTable<D>, depth: usize) {
[INFO] [stderr]    |    ^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(dead_code)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `lisp` (test "lisp") generated 1 warning
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.03s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/lisp-d210e58c34cf1d53)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/bin/disasm.rs (/opt/rustwide/target/debug/deps/disasm-b2aea2c57651f755)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/bin/eval.rs (/opt/rustwide/target/debug/deps/eval-29f63788b9cc65a5)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/lisp.rs (/opt/rustwide/target/debug/deps/lisp-8bd6904b8db7db66)
[INFO] [stdout] 
[INFO] [stdout] running 46 tests
[INFO] [stdout] test test_add ... ok
[INFO] [stdout] test test_cdr ... ok
[INFO] [stdout] test test_def_global ... ok
[INFO] [stdout] test test_branch ... ok
[INFO] [stdout] test test_car ... ok
[INFO] [stdout] test test_assert ... ok
[INFO] [stdout] test test_cons ... ok
[INFO] [stdout] test test_defmacro ... ok
[INFO] [stdout] test test_eq ... ok
[INFO] [stdout] test test_eq_list ... ok
[INFO] [stdout] test test_get_upvalue ... ok
[INFO] [stdout] test test_gt ... ok
[INFO] [stdout] test test_fact ... ok
[INFO] [stdout] test test_is_type ... ok
[INFO] [stdout] test test_cond ... ok
[INFO] [stdout] test test_lambda_expr ... ok
[INFO] [stdout] test test_filter ... ok
[INFO] [stdout] test test_apply ... ok
[INFO] [stdout] test test_and ... ok
[INFO] [stdout] test test_fold ... ok
[INFO] [stdout] test test_find ... ok
[INFO] [stdout] test test_local_vars ... ok
[INFO] [stdout] test test_hashmap ... ok
[INFO] [stdout] test test_lt ... ok
[INFO] [stdout] test test_multiexpr_lambda ... ok
[INFO] [stdout] test test_last ... ok
[INFO] [stdout] test test_nested_add ... ok
[INFO] [stdout] test test_let ... ok
[INFO] [stdout] test test_not_eq ... ok
[INFO] [stdout] test test_not_gt ... ok
[INFO] [stdout] test test_not_lt ... ok
[INFO] [stdout] test test_list_sort ... ok
[INFO] [stdout] test test_list_drop ... ok
[INFO] [stdout] test test_length ... ok
[INFO] [stdout] test test_map ... ok
[INFO] [stdout] test test_named_let ... ok
[INFO] [stdout] test test_list_take ... ok
[INFO] [stdout] test test_set_global ... ok
[INFO] [stdout] test test_upvalues ... ok
[INFO] [stdout] test test_not ... ok
[INFO] [stdout] test test_nthcdr ... ok
[INFO] [stdout] test test_nth ... ok
[INFO] [stdout] test test_parallel_let ... ok
[INFO] [stdout] test test_quasiquote ... ok
[INFO] [stdout] test test_quote_eq_list ... ok
[INFO] [stdout] test test_or ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 46 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.34s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests lisp
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "c9adadd526f7f549bf6b1043eff80e3dc5e671f3a8c5bdec74cd12051e468c1b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c9adadd526f7f549bf6b1043eff80e3dc5e671f3a8c5bdec74cd12051e468c1b", kill_on_drop: false }`
[INFO] [stdout] c9adadd526f7f549bf6b1043eff80e3dc5e671f3a8c5bdec74cd12051e468c1b