Dec 06 03:58:51.016 INFO testing chklauser/rust-nvm against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 06 03:58:51.016 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-3/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 06 03:58:51.420 INFO [stdout] 685c84205f0bfb0c81de707765565fdbec4c5bf64b031aa9f3a250b720399041
Dec 06 03:58:51.426 INFO running `"docker" "start" "-a" "685c84205f0bfb0c81de707765565fdbec4c5bf64b031aa9f3a250b720399041"`
Dec 06 03:58:52.564 INFO [stderr] usermod: no changes
Dec 06 03:58:52.756 INFO [stderr]    Compiling libc v0.2.14
Dec 06 03:58:52.756 INFO [stderr]    Compiling regex-syntax v0.3.4
Dec 06 03:58:52.772 INFO [stderr]    Compiling combine v2.0.0
Dec 06 03:58:54.600 INFO [stderr]    Compiling thread-id v2.0.0
Dec 06 03:58:54.600 INFO [stderr]    Compiling memchr v0.1.11
Dec 06 03:58:54.600 INFO [stderr]    Compiling term_size v0.2.1
Dec 06 03:58:55.360 INFO [stderr]    Compiling thread_local v0.2.6
Dec 06 03:58:55.776 INFO [stderr]    Compiling clap v2.19.1
Dec 06 03:58:56.324 INFO [stderr]    Compiling aho-corasick v0.5.2
Dec 06 03:59:01.554 INFO [stderr]    Compiling combine-language v2.0.0
Dec 06 03:59:01.696 INFO [stderr]    Compiling regex v0.1.73
Dec 06 03:59:13.814 INFO [stderr]    Compiling env_logger v0.3.4
Dec 06 03:59:20.696 INFO [stderr]    Compiling nvm v0.1.0 (/source)
Dec 06 03:59:21.708 INFO [stderr] warning: unused macro definition
Dec 06 03:59:21.708 INFO [stderr]    --> src/vm/machine.rs:109:1
Dec 06 03:59:21.708 INFO [stderr]     |
Dec 06 03:59:21.708 INFO [stderr] 109 | / macro_rules! try_check{
Dec 06 03:59:21.708 INFO [stderr] 110 | |   ($e:expr) => (e)
Dec 06 03:59:21.708 INFO [stderr] 111 | | }
Dec 06 03:59:21.708 INFO [stderr]     | |_^
Dec 06 03:59:21.708 INFO [stderr]     |
Dec 06 03:59:21.708 INFO [stderr]     = note: #[warn(unused_macros)] on by default
Dec 06 03:59:21.708 INFO [stderr] 
Dec 06 03:59:28.807 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 36.22s
Dec 06 03:59:28.813 INFO [stderr] su: No module specific data is present
Dec 06 03:59:30.051 INFO running `"docker" "inspect" "685c84205f0bfb0c81de707765565fdbec4c5bf64b031aa9f3a250b720399041"`
Dec 06 03:59:30.374 INFO running `"docker" "rm" "-f" "685c84205f0bfb0c81de707765565fdbec4c5bf64b031aa9f3a250b720399041"`
Dec 06 03:59:30.780 INFO [stdout] 685c84205f0bfb0c81de707765565fdbec4c5bf64b031aa9f3a250b720399041
Dec 06 03:59:30.786 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-3/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 06 03:59:31.295 INFO [stdout] e934b7e278527d7eb3bf7b140e51e1f71f60722712926a18a90d0c3cc07aaa89
Dec 06 03:59:31.297 INFO running `"docker" "start" "-a" "e934b7e278527d7eb3bf7b140e51e1f71f60722712926a18a90d0c3cc07aaa89"`
Dec 06 03:59:32.936 INFO [stderr] usermod: no changes
Dec 06 03:59:33.044 INFO [stderr]    Compiling nvm v0.1.0 (/source)
Dec 06 03:59:34.163 INFO [stderr] warning: unused `#[macro_use]` import
Dec 06 03:59:34.163 INFO [stderr]  --> src/main.rs:8:1
Dec 06 03:59:34.163 INFO [stderr]   |
Dec 06 03:59:34.163 INFO [stderr] 8 | #[macro_use]
Dec 06 03:59:34.164 INFO [stderr]   | ^^^^^^^^^^^^
Dec 06 03:59:34.164 INFO [stderr]   |
Dec 06 03:59:34.164 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Dec 06 03:59:34.164 INFO [stderr] 
Dec 06 03:59:34.164 INFO [stderr] warning: unused macro definition
Dec 06 03:59:34.164 INFO [stderr]    --> src/vm/machine.rs:109:1
Dec 06 03:59:34.164 INFO [stderr]     |
Dec 06 03:59:34.164 INFO [stderr] 109 | / macro_rules! try_check{
Dec 06 03:59:34.164 INFO [stderr] 110 | |   ($e:expr) => (e)
Dec 06 03:59:34.164 INFO [stderr] 111 | | }
Dec 06 03:59:34.164 INFO [stderr]     | |_^
Dec 06 03:59:34.164 INFO [stderr]     |
Dec 06 03:59:34.164 INFO [stderr]     = note: #[warn(unused_macros)] on by default
Dec 06 03:59:34.164 INFO [stderr] 
Dec 06 03:59:40.573 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 7.61s
Dec 06 03:59:40.579 INFO [stderr] su: No module specific data is present
Dec 06 03:59:41.346 INFO running `"docker" "inspect" "e934b7e278527d7eb3bf7b140e51e1f71f60722712926a18a90d0c3cc07aaa89"`
Dec 06 03:59:41.588 INFO running `"docker" "rm" "-f" "e934b7e278527d7eb3bf7b140e51e1f71f60722712926a18a90d0c3cc07aaa89"`
Dec 06 03:59:41.872 INFO [stdout] e934b7e278527d7eb3bf7b140e51e1f71f60722712926a18a90d0c3cc07aaa89
Dec 06 03:59:41.875 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-3/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 06 03:59:42.386 INFO [stdout] 7b4fef3b868b4e811b96ca92fac9d65619fc32a3e32b8d1e42352661ff1d8581
Dec 06 03:59:42.392 INFO running `"docker" "start" "-a" "7b4fef3b868b4e811b96ca92fac9d65619fc32a3e32b8d1e42352661ff1d8581"`
Dec 06 03:59:43.639 INFO [stderr] usermod: no changes
Dec 06 03:59:43.744 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.07s
Dec 06 03:59:43.744 INFO [stderr]      Running /target/debug/deps/nvm-145956bff9a782ed
Dec 06 03:59:43.744 INFO [stdout] 
Dec 06 03:59:43.744 INFO [stdout] running 18 tests
Dec 06 03:59:43.745 INFO [stdout] test tests::if_test ... ok
Dec 06 03:59:43.747 INFO [stdout] test tests::miniprogram ... ok
Dec 06 03:59:43.750 INFO [stdout] test tests::if_else_if ... ok
Dec 06 03:59:43.750 INFO [stdout] test tests::if_else_test ... ok
Dec 06 03:59:43.754 INFO [stdout] test tests::compile_fib_iter ... ok
Dec 06 03:59:43.757 INFO [stdout] test tests::maxfn ... ok
Dec 06 03:59:43.758 INFO [stdout] test tests::allow_interpreter_line ... ok
Dec 06 03:59:43.759 INFO [stdout] test tests::add ... ok
Dec 06 03:59:43.760 INFO [stdout] test tests::run_gen_fib4 ... ok
Dec 06 03:59:43.772 INFO [stdout] test tests::run_fib_iter8 ... ok
Dec 06 03:59:43.774 INFO [stdout] test tests::simple_call_v ... ok
Dec 06 03:59:43.774 INFO [stdout] test tests::ref_in_function ... ok
Dec 06 03:59:43.777 INFO [stdout] test tests::readme_example ... ok
Dec 06 03:59:43.779 INFO [stdout] test tests::simple_function_call ... ok
Dec 06 03:59:43.784 INFO [stdout] test tests::ref_of_params_function ... ok
Dec 06 03:59:43.789 INFO [stdout] test tests::sample ... ok
Dec 06 03:59:43.790 INFO [stdout] test tests::run_gen_fib8 ... ok
Dec 06 03:59:43.791 INFO [stdout] test tests::simple_call ... ok
Dec 06 03:59:43.791 INFO [stdout] 
Dec 06 03:59:43.791 INFO [stdout] test result: ok. 18 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 03:59:43.791 INFO [stdout] 
Dec 06 03:59:43.793 INFO [stderr] su: No module specific data is present
Dec 06 03:59:44.705 INFO running `"docker" "inspect" "7b4fef3b868b4e811b96ca92fac9d65619fc32a3e32b8d1e42352661ff1d8581"`
Dec 06 03:59:44.990 INFO running `"docker" "rm" "-f" "7b4fef3b868b4e811b96ca92fac9d65619fc32a3e32b8d1e42352661ff1d8581"`
Dec 06 03:59:45.260 INFO [stdout] 7b4fef3b868b4e811b96ca92fac9d65619fc32a3e32b8d1e42352661ff1d8581