Dec 13 23:48:48.284 INFO testing chklauser/rust-nvm against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 13 23:48:48.285 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-3/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +aa49d8ef14939ddec0e34b346b60174a5673d48f-alt build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 13 23:48:48.884 INFO [stdout] f62b52eccfdb07998f156b939b8553cfa69107388a23a0072289d480e917b7c2
Dec 13 23:48:48.886 INFO running `"docker" "start" "-a" "f62b52eccfdb07998f156b939b8553cfa69107388a23a0072289d480e917b7c2"`
Dec 13 23:48:50.686 INFO [stderr] usermod: no changes
Dec 13 23:48:50.927 INFO [stderr]    Compiling regex-syntax v0.3.4
Dec 13 23:48:50.935 INFO [stderr]    Compiling memchr v0.1.11
Dec 13 23:48:50.947 INFO [stderr]    Compiling term_size v0.2.1
Dec 13 23:48:50.947 INFO [stderr]    Compiling combine v2.0.0
Dec 13 23:48:50.947 INFO [stderr]    Compiling thread-id v2.0.0
Dec 13 23:48:52.403 INFO [stderr]    Compiling clap v2.19.1
Dec 13 23:48:52.428 INFO [stderr]    Compiling thread_local v0.2.6
Dec 13 23:48:53.071 INFO [stderr]    Compiling aho-corasick v0.5.2
Dec 13 23:49:01.723 INFO [stderr]    Compiling regex v0.1.73
Dec 13 23:49:02.467 INFO [stderr]    Compiling combine-language v2.0.0
Dec 13 23:49:17.243 INFO [stderr]    Compiling env_logger v0.3.4
Dec 13 23:49:26.595 INFO [stderr]    Compiling nvm v0.1.0 (/source)
Dec 13 23:49:27.711 INFO [stderr] warning: unused macro definition
Dec 13 23:49:27.711 INFO [stderr]    --> src/vm/machine.rs:109:1
Dec 13 23:49:27.711 INFO [stderr]     |
Dec 13 23:49:27.711 INFO [stderr] 109 | / macro_rules! try_check{
Dec 13 23:49:27.711 INFO [stderr] 110 | |   ($e:expr) => (e)
Dec 13 23:49:27.711 INFO [stderr] 111 | | }
Dec 13 23:49:27.711 INFO [stderr]     | |_^
Dec 13 23:49:27.711 INFO [stderr]     |
Dec 13 23:49:27.711 INFO [stderr]     = note: #[warn(unused_macros)] on by default
Dec 13 23:49:27.711 INFO [stderr] 
Dec 13 23:49:34.796 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 44.07s
Dec 13 23:49:34.823 INFO [stderr] su: No module specific data is present
Dec 13 23:49:36.127 INFO running `"docker" "inspect" "f62b52eccfdb07998f156b939b8553cfa69107388a23a0072289d480e917b7c2"`
Dec 13 23:49:36.441 INFO running `"docker" "rm" "-f" "f62b52eccfdb07998f156b939b8553cfa69107388a23a0072289d480e917b7c2"`
Dec 13 23:49:36.771 INFO [stdout] f62b52eccfdb07998f156b939b8553cfa69107388a23a0072289d480e917b7c2
Dec 13 23:49:36.777 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-3/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +aa49d8ef14939ddec0e34b346b60174a5673d48f-alt test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 13 23:49:37.251 INFO [stdout] 2cd5c20376d1ed127252d576a636141b94a2fca9064559d121f97767d26c4c2e
Dec 13 23:49:37.257 INFO running `"docker" "start" "-a" "2cd5c20376d1ed127252d576a636141b94a2fca9064559d121f97767d26c4c2e"`
Dec 13 23:49:38.802 INFO [stderr] usermod: no changes
Dec 13 23:49:38.927 INFO [stderr]    Compiling nvm v0.1.0 (/source)
Dec 13 23:49:40.055 INFO [stderr] warning: unused `#[macro_use]` import
Dec 13 23:49:40.056 INFO [stderr]  --> src/main.rs:8:1
Dec 13 23:49:40.056 INFO [stderr]   |
Dec 13 23:49:40.056 INFO [stderr] 8 | #[macro_use]
Dec 13 23:49:40.056 INFO [stderr]   | ^^^^^^^^^^^^
Dec 13 23:49:40.058 INFO [stderr]   |
Dec 13 23:49:40.058 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Dec 13 23:49:40.058 INFO [stderr] 
Dec 13 23:49:40.058 INFO [stderr] warning: unused macro definition
Dec 13 23:49:40.058 INFO [stderr]    --> src/vm/machine.rs:109:1
Dec 13 23:49:40.059 INFO [stderr]     |
Dec 13 23:49:40.059 INFO [stderr] 109 | / macro_rules! try_check{
Dec 13 23:49:40.059 INFO [stderr] 110 | |   ($e:expr) => (e)
Dec 13 23:49:40.059 INFO [stderr] 111 | | }
Dec 13 23:49:40.059 INFO [stderr]     | |_^
Dec 13 23:49:40.059 INFO [stderr]     |
Dec 13 23:49:40.059 INFO [stderr]     = note: #[warn(unused_macros)] on by default
Dec 13 23:49:40.059 INFO [stderr] 
Dec 13 23:49:47.923 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 9.08s
Dec 13 23:49:47.927 INFO [stderr] su: No module specific data is present
Dec 13 23:49:49.113 INFO running `"docker" "inspect" "2cd5c20376d1ed127252d576a636141b94a2fca9064559d121f97767d26c4c2e"`
Dec 13 23:49:49.503 INFO running `"docker" "rm" "-f" "2cd5c20376d1ed127252d576a636141b94a2fca9064559d121f97767d26c4c2e"`
Dec 13 23:49:49.803 INFO [stdout] 2cd5c20376d1ed127252d576a636141b94a2fca9064559d121f97767d26c4c2e
Dec 13 23:49:49.811 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-3/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +aa49d8ef14939ddec0e34b346b60174a5673d48f-alt test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 13 23:49:50.393 INFO [stdout] e0bdeefd67fbdb3c7f60594153e8b7c6ebf4c35a86ebb592ffc6be68ba6d5ca0
Dec 13 23:49:50.395 INFO running `"docker" "start" "-a" "e0bdeefd67fbdb3c7f60594153e8b7c6ebf4c35a86ebb592ffc6be68ba6d5ca0"`
Dec 13 23:49:52.178 INFO [stderr] usermod: no changes
Dec 13 23:49:52.327 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.12s
Dec 13 23:49:52.327 INFO [stderr]      Running /target/debug/deps/nvm-c356dba42409622f
Dec 13 23:49:52.339 INFO [stdout] 
Dec 13 23:49:52.339 INFO [stdout] running 18 tests
Dec 13 23:49:52.339 INFO [stdout] test tests::allow_interpreter_line ... ok
Dec 13 23:49:52.339 INFO [stdout] test tests::add ... ok
Dec 13 23:49:52.351 INFO [stdout] test tests::miniprogram ... ok
Dec 13 23:49:52.351 INFO [stdout] test tests::if_else_if ... ok
Dec 13 23:49:52.351 INFO [stdout] test tests::if_else_test ... ok
Dec 13 23:49:52.351 INFO [stdout] test tests::run_gen_fib4 ... ok
Dec 13 23:49:52.359 INFO [stdout] test tests::compile_fib_iter ... ok
Dec 13 23:49:52.359 INFO [stdout] test tests::ref_in_function ... ok
Dec 13 23:49:52.363 INFO [stdout] test tests::readme_example ... ok
Dec 13 23:49:52.363 INFO [stdout] test tests::if_test ... ok
Dec 13 23:49:52.379 INFO [stdout] test tests::ref_of_params_function ... ok
Dec 13 23:49:52.379 INFO [stdout] test tests::run_fib_iter8 ... ok
Dec 13 23:49:52.379 INFO [stdout] test tests::maxfn ... ok
Dec 13 23:49:52.379 INFO [stdout] test tests::simple_call ... ok
Dec 13 23:49:52.379 INFO [stdout] test tests::sample ... ok
Dec 13 23:49:52.379 INFO [stdout] test tests::run_gen_fib8 ... ok
Dec 13 23:49:52.383 INFO [stdout] test tests::simple_function_call ... ok
Dec 13 23:49:52.383 INFO [stdout] test tests::simple_call_v ... ok
Dec 13 23:49:52.383 INFO [stdout] 
Dec 13 23:49:52.383 INFO [stdout] test result: ok. 18 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 23:49:52.383 INFO [stdout] 
Dec 13 23:49:52.393 INFO [stderr] su: No module specific data is present
Dec 13 23:49:53.651 INFO running `"docker" "inspect" "e0bdeefd67fbdb3c7f60594153e8b7c6ebf4c35a86ebb592ffc6be68ba6d5ca0"`
Dec 13 23:49:54.027 INFO running `"docker" "rm" "-f" "e0bdeefd67fbdb3c7f60594153e8b7c6ebf4c35a86ebb592ffc6be68ba6d5ca0"`
Dec 13 23:49:54.307 INFO [stdout] e0bdeefd67fbdb3c7f60594153e8b7c6ebf4c35a86ebb592ffc6be68ba6d5ca0