[INFO] fetching crate dlang 0.1.3...
[INFO] testing dlang-0.1.3 against try#8de4c7234dd9b97c9d76b58671343fdbbc9a433e+target=x86_64-unknown-linux-musl for musl_upgrade_1_2_5_with_libc_patch_0
[INFO] extracting crate dlang 0.1.3 into /workspace/builds/worker-5-tc1/source
[INFO] started tweaking crates.io crate dlang 0.1.3
[INFO] finished tweaking crates.io crate dlang 0.1.3
[INFO] tweaked toml for crates.io crate dlang 0.1.3 written to /workspace/builds/worker-5-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate dlang 0.1.3 on toolchain 8de4c7234dd9b97c9d76b58671343fdbbc9a433e
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate dlang 0.1.3 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" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/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:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 2dfd0abbd940440bf1f1c50d45be63bae7183c0f548ad22c9a4ee2840196846f
[INFO] running `Command { std: "docker" "start" "-a" "2dfd0abbd940440bf1f1c50d45be63bae7183c0f548ad22c9a4ee2840196846f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "2dfd0abbd940440bf1f1c50d45be63bae7183c0f548ad22c9a4ee2840196846f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2dfd0abbd940440bf1f1c50d45be63bae7183c0f548ad22c9a4ee2840196846f", kill_on_drop: false }`
[INFO] [stdout] 2dfd0abbd940440bf1f1c50d45be63bae7183c0f548ad22c9a4ee2840196846f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/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:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "build" "--frozen" "--message-format=json" "--target" "x86_64-unknown-linux-musl", kill_on_drop: false }`
[INFO] [stdout] 54c46204737a177c22872b0f5dd0331df73dfaacb31de858d3f6d129de586d4c
[INFO] running `Command { std: "docker" "start" "-a" "54c46204737a177c22872b0f5dd0331df73dfaacb31de858d3f6d129de586d4c", kill_on_drop: false }`
[INFO] [stderr]    Compiling dlang v0.1.3 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 2.47s
[INFO] running `Command { std: "docker" "inspect" "54c46204737a177c22872b0f5dd0331df73dfaacb31de858d3f6d129de586d4c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "54c46204737a177c22872b0f5dd0331df73dfaacb31de858d3f6d129de586d4c", kill_on_drop: false }`
[INFO] [stdout] 54c46204737a177c22872b0f5dd0331df73dfaacb31de858d3f6d129de586d4c
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/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:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "test" "--frozen" "--no-run" "--message-format=json" "--target" "x86_64-unknown-linux-musl", kill_on_drop: false }`
[INFO] [stdout] 169e9aca37430ee4290dc720878cbfc14f82fdaaf1e37b6c5686bd472949d5cb
[INFO] running `Command { std: "docker" "start" "-a" "169e9aca37430ee4290dc720878cbfc14f82fdaaf1e37b6c5686bd472949d5cb", kill_on_drop: false }`
[INFO] [stderr]    Compiling dlang v0.1.3 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unused variable: `idx`
[INFO] [stdout]    --> tests/parser.rs:113:10
[INFO] [stdout]     |
[INFO] [stdout] 113 |     for (idx, (input, expect)) in tests.iter().enumerate() {
[INFO] [stdout]     |          ^^^ help: if this is intentional, prefix it with an underscore: `_idx`
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(unused_variables)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 3.16s
[INFO] running `Command { std: "docker" "inspect" "169e9aca37430ee4290dc720878cbfc14f82fdaaf1e37b6c5686bd472949d5cb", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "169e9aca37430ee4290dc720878cbfc14f82fdaaf1e37b6c5686bd472949d5cb", kill_on_drop: false }`
[INFO] [stdout] 169e9aca37430ee4290dc720878cbfc14f82fdaaf1e37b6c5686bd472949d5cb
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/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:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "test" "--frozen" "--target" "x86_64-unknown-linux-musl", kill_on_drop: false }`
[INFO] [stdout] c18bcb062f41b1ba5ad08db49cbca3537ee11fc562023feb06b09a0d6e104f37
[INFO] running `Command { std: "docker" "start" "-a" "c18bcb062f41b1ba5ad08db49cbca3537ee11fc562023feb06b09a0d6e104f37", kill_on_drop: false }`
[INFO] [stderr] warning: unused variable: `idx`
[INFO] [stderr]    --> tests/parser.rs:113:10
[INFO] [stderr]     |
[INFO] [stderr] 113 |     for (idx, (input, expect)) in tests.iter().enumerate() {
[INFO] [stderr]     |          ^^^ help: if this is intentional, prefix it with an underscore: `_idx`
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(unused_variables)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `dlang` (test "parser") generated 1 warning
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/dlang-2a90b4ace7c99e54)
[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/main.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/dlang-7252853e7f590660)
[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/eval.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/eval-cc0d9b58d041538d)
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test test_eval_function ... ok
[INFO] [stdout] test test_eval_errors ... ok
[INFO] [stdout] test test_eval_if_expression ... ok
[INFO] [stdout] test test_eval_string_expression ... ok
[INFO] [stdout] test test_let_expression ... ok
[INFO] [stdout] test test_eval_integer_expression ... ok
[INFO] [stdout] test test_eval_bool_expression ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/immix.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/immix-e074f70f4cc90792)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test test_block_list ... ok
[INFO] [stdout] test test_bumpblock ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/lexer.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/lexer-9c91f0c5e9085a82)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]      Running tests/parser.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/parser-18e1e1c0f7f5e479)
[INFO] [stdout] test test_lexer ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test test_call_expression ... ok
[INFO] [stderr]      Running tests/vm.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/vm-b43c54716eec2c4b)
[INFO] [stdout] test test_bool_literal ... ok
[INFO] [stdout] test test_array_literal ... ok
[INFO] [stdout] test test_infix ... ok
[INFO] [stdout] test test_let_statement ... ok
[INFO] [stdout] test test_parentheses ... ok
[INFO] [stdout] test test_return_statement ... ok
[INFO] [stdout] test test_prefix_expression ... ok
[INFO] [stdout] test test_function_literal ... ok
[INFO] [stdout] test test_if_expression ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test test_vm_array_creation ... ok
[INFO] [stdout] test test_vm_array_index ... ok
[INFO] [stdout] test test_vm_bool_operation ... ok
[INFO] [stdout] test test_vm_let_stm_operation ... ok
[INFO] [stdout] test test_vm_integer_operation ... ok
[INFO] [stdout] test test_vm_jump_operation ... ok
[INFO] [stdout] test test_vm_function_recursive ... ok
[INFO] [stdout] test test_vm_function_not_closure ... ok
[INFO] [stdout] test test_vm_function_closure ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "c18bcb062f41b1ba5ad08db49cbca3537ee11fc562023feb06b09a0d6e104f37", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c18bcb062f41b1ba5ad08db49cbca3537ee11fc562023feb06b09a0d6e104f37", kill_on_drop: false }`
[INFO] [stdout] c18bcb062f41b1ba5ad08db49cbca3537ee11fc562023feb06b09a0d6e104f37