[INFO] updating cached repository https://github.com/wasmatic/vm-translator [INFO] running `"git" "-c" "credential.helper=" "-c" "credential.helper=/big/crater/work/cargo-home/bin/git-credential-null" "-c" "remote.origin.fetch=refs/heads/*:refs/heads/*" "fetch" "origin" "--force" "--prune"` [INFO] running `"git" "rev-parse" "HEAD"` [INFO] [stdout] 5a273e93146ea693e99206a772875a8b93c98770 [INFO] testing wasmatic/vm-translator against 1.38.0 for beta-1.39-1 [INFO] running `"git" "clone" "work/cache/git-repos/https%3A%2F%2Fgithub.com%2Fwasmatic%2Fvm-translator" "work/builds/worker-1/source"` [INFO] [stderr] Cloning into 'work/builds/worker-1/source'... [INFO] [stderr] done. [INFO] validating manifest of git repo https://github.com/wasmatic/vm-translator on toolchain 1.38.0 [INFO] running `"/big/crater/work/cargo-home/bin/cargo" "+1.38.0" "read-manifest" "--manifest-path" "Cargo.toml"` [INFO] started tweaking git repo https://github.com/wasmatic/vm-translator [INFO] finished tweaking git repo https://github.com/wasmatic/vm-translator [INFO] tweaked toml for git repo https://github.com/wasmatic/vm-translator written to work/builds/worker-1/source/Cargo.toml [INFO] crate git repo https://github.com/wasmatic/vm-translator already has a lockfile, it will not be regenerated [INFO] running `"/big/crater/work/cargo-home/bin/cargo" "+1.38.0" "fetch" "--locked" "--manifest-path" "Cargo.toml"` [INFO] running `"docker" "create" "-v" "/big/crater/work/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/big/crater/work/builds/worker-1/source:/opt/rustwide/workdir:ro,Z" "-v" "/big/crater/work/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/big/crater/work/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "MAP_USER_ID=1000" "-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" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+1.38.0" "build" "--frozen"` [INFO] [stdout] a0d5486cb72825ad172bd4c3030f19980e21d6b704bb2513bacf30452e867a2c [INFO] running `"docker" "start" "-a" "a0d5486cb72825ad172bd4c3030f19980e21d6b704bb2513bacf30452e867a2c"` [INFO] [stderr] Compiling glob v0.3.0 [INFO] [stderr] Compiling vm_translator v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 2.36s [INFO] running `"docker" "inspect" "a0d5486cb72825ad172bd4c3030f19980e21d6b704bb2513bacf30452e867a2c"` [INFO] running `"docker" "rm" "-f" "a0d5486cb72825ad172bd4c3030f19980e21d6b704bb2513bacf30452e867a2c"` [INFO] [stdout] a0d5486cb72825ad172bd4c3030f19980e21d6b704bb2513bacf30452e867a2c [INFO] running `"docker" "create" "-v" "/big/crater/work/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/big/crater/work/builds/worker-1/source:/opt/rustwide/workdir:ro,Z" "-v" "/big/crater/work/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/big/crater/work/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "MAP_USER_ID=1000" "-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" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+1.38.0" "test" "--frozen" "--no-run"` [INFO] [stdout] 9339e8a985855cf6414e575f4f14b7f306cdb03d0b0a1613f6c90446aeaf3f66 [INFO] running `"docker" "start" "-a" "9339e8a985855cf6414e575f4f14b7f306cdb03d0b0a1613f6c90446aeaf3f66"` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Compiling vm_translator v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 1.76s [INFO] running `"docker" "inspect" "9339e8a985855cf6414e575f4f14b7f306cdb03d0b0a1613f6c90446aeaf3f66"` [INFO] running `"docker" "rm" "-f" "9339e8a985855cf6414e575f4f14b7f306cdb03d0b0a1613f6c90446aeaf3f66"` [INFO] [stdout] 9339e8a985855cf6414e575f4f14b7f306cdb03d0b0a1613f6c90446aeaf3f66 [INFO] running `"docker" "create" "-v" "/big/crater/work/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/big/crater/work/builds/worker-1/source:/opt/rustwide/workdir:ro,Z" "-v" "/big/crater/work/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/big/crater/work/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "MAP_USER_ID=1000" "-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" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+1.38.0" "test" "--frozen"` [INFO] [stdout] 38341339fbe8be81e2ee900f70d409ddc22b4cd44574f8231cd59119a9f4b9db [INFO] running `"docker" "start" "-a" "38341339fbe8be81e2ee900f70d409ddc22b4cd44574f8231cd59119a9f4b9db"` [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.00s [INFO] [stderr] Running /opt/rustwide/target/debug/deps/vm_translator-74db0a8cb569ee53 [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 [INFO] [stdout] [INFO] [stderr] Running /opt/rustwide/target/debug/deps/vm_translator-726988a064dac59f [INFO] [stdout] [INFO] [stdout] running 3 tests [INFO] [stdout] test test_split ... ok [INFO] [stdout] test test_trim ... ok [INFO] [stdout] test test_add_vm_files ... FAILED [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- test_add_vm_files stdout ---- [INFO] [stdout] thread 'test_add_vm_files' panicked at 'assertion failed: `(left == right)` [INFO] [stdout] left: `[]`, [INFO] [stdout] right: `["/home/user/nand2tetris/projects/08/FunctionCalls/FibonacciElement/Main.vm", "/home/user/nand2tetris/projects/08/FunctionCalls/FibonacciElement/Sys.vm"]`', src/main.rs:163:5 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5584dc5beafb - backtrace::backtrace::libunwind::trace::h89fcc71e59e3bc5b [INFO] [stdout] at /cargo/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.34/src/backtrace/libunwind.rs:88 [INFO] [stdout] 1: 0x5584dc5beafb - backtrace::backtrace::trace_unsynchronized::h0bad9be1379e729a [INFO] [stdout] at /cargo/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.34/src/backtrace/mod.rs:66 [INFO] [stdout] 2: 0x5584dc5beafb - std::sys_common::backtrace::_print::hd3382a1f33c473da [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:47 [INFO] [stdout] 3: 0x5584dc5beafb - std::sys_common::backtrace::print::h0ec6f03cfb8e76a6 [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:36 [INFO] [stdout] 4: 0x5584dc5beafb - std::panicking::default_hook::{{closure}}::h96cbf7b454e3f557 [INFO] [stdout] at src/libstd/panicking.rs:200 [INFO] [stdout] 5: 0x5584dc5be76c - std::panicking::default_hook::h95a8f00337383d83 [INFO] [stdout] at src/libstd/panicking.rs:211 [INFO] [stdout] 6: 0x5584dc5bf26d - std::panicking::rust_panic_with_hook::h92f98b46e22f14ed [INFO] [stdout] at src/libstd/panicking.rs:477 [INFO] [stdout] 7: 0x5584dc5bedf2 - std::panicking::continue_panic_fmt::h25abfbb4e5b7043a [INFO] [stdout] at src/libstd/panicking.rs:384 [INFO] [stdout] 8: 0x5584dc5bed3f - std::panicking::begin_panic_fmt::hc33ce01c7f7cd52d [INFO] [stdout] at src/libstd/panicking.rs:339 [INFO] [stdout] 9: 0x5584dc53e912 - vm_translator::test_add_vm_files::h6fa68223c8d4e7a9 [INFO] [stdout] at src/main.rs:163 [INFO] [stdout] 10: 0x5584dc53e63a - vm_translator::test_add_vm_files::{{closure}}::h9b99e8e3943b1d03 [INFO] [stdout] at src/main.rs:152 [INFO] [stdout] 11: 0x5584dc539b5e - core::ops::function::FnOnce::call_once::hebc79edf119e466e [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libcore/ops/function.rs:235 [INFO] [stdout] 12: 0x5584dc55224f - as core::ops::function::FnOnce>::call_once::hac0fbe2754f8bd24 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/liballoc/boxed.rs:787 [INFO] [stdout] 13: 0x5584dc5c1d6a - __rust_maybe_catch_panic [INFO] [stdout] at src/libpanic_unwind/lib.rs:80 [INFO] [stdout] 14: 0x5584dc56c83e - std::panicking::try::h9d6938917cc05e3f [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/panicking.rs:275 [INFO] [stdout] 15: 0x5584dc56c83e - std::panic::catch_unwind::h5be70fd1d69515b0 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/panic.rs:394 [INFO] [stdout] 16: 0x5584dc56c83e - test::run_test::run_test_inner::{{closure}}::h056f206eafd8ff6e [INFO] [stdout] at src/libtest/lib.rs:1408 [INFO] [stdout] 17: 0x5584dc547c75 - std::sys_common::backtrace::__rust_begin_short_backtrace::h859abbc742a34b19 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/sys_common/backtrace.rs:77 [INFO] [stdout] 18: 0x5584dc54bdb5 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::hf8192ec938c43694 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/thread/mod.rs:470 [INFO] [stdout] 19: 0x5584dc54bdb5 - as core::ops::function::FnOnce<()>>::call_once::hae7b2431555cb4db [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/panic.rs:315 [INFO] [stdout] 20: 0x5584dc54bdb5 - std::panicking::try::do_call::h6da7ecd0783259d7 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/panicking.rs:296 [INFO] [stdout] 21: 0x5584dc5c1d6a - __rust_maybe_catch_panic [INFO] [stdout] at src/libpanic_unwind/lib.rs:80 [INFO] [stdout] 22: 0x5584dc54c392 - std::panicking::try::h3c1c35414c2c78f1 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/panicking.rs:275 [INFO] [stdout] 23: 0x5584dc54c392 - std::panic::catch_unwind::ha5cfb2018fda983e [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/panic.rs:394 [INFO] [stdout] 24: 0x5584dc54c392 - std::thread::Builder::spawn_unchecked::{{closure}}::hc7620e41f0938c09 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/thread/mod.rs:469 [INFO] [stdout] 25: 0x5584dc54c392 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h1b3b20eeb6ea6ddd [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libcore/ops/function.rs:235 [INFO] [stdout] 26: 0x5584dc5b41af - as core::ops::function::FnOnce>::call_once::h2877b2aefb0fd627 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/liballoc/boxed.rs:787 [INFO] [stdout] 27: 0x5584dc5c14a0 - as core::ops::function::FnOnce>::call_once::h13f473dbcdaa0fef [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/liballoc/boxed.rs:787 [INFO] [stdout] 28: 0x5584dc5c14a0 - std::sys_common::thread::start_thread::h562a7c4953cb1d31 [INFO] [stdout] at src/libstd/sys_common/thread.rs:13 [INFO] [stdout] 29: 0x5584dc5c14a0 - std::sys::unix::thread::Thread::new::thread_start::h382c6ae14181d163 [INFO] [stdout] at src/libstd/sys/unix/thread.rs:79 [INFO] [stdout] 30: 0x7f8110e316db - start_thread [INFO] [stdout] 31: 0x7f811094288f - __clone [INFO] [stdout] 32: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] test_add_vm_files [INFO] [stdout] [INFO] [stdout] test result: FAILED. 2 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass '--bin vm_translator' [INFO] running `"docker" "inspect" "38341339fbe8be81e2ee900f70d409ddc22b4cd44574f8231cd59119a9f4b9db"` [INFO] running `"docker" "rm" "-f" "38341339fbe8be81e2ee900f70d409ddc22b4cd44574f8231cd59119a9f4b9db"` [INFO] [stdout] 38341339fbe8be81e2ee900f70d409ddc22b4cd44574f8231cd59119a9f4b9db