Dec 01 21:45:11.228 INFO testing chklauser/rust-nvm against 1.30.1 for beta-1.31-5
Dec 01 21:45:11.228 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-2/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/beta-1.31-5/1.30.1:/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 +1.30.1 build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 01 21:45:11.555 INFO [stdout] 6c8cb345c50946ee46651ff66dcce804f790191916b10d42484052e55ae82c2f
Dec 01 21:45:11.559 INFO running `"docker" "start" "-a" "6c8cb345c50946ee46651ff66dcce804f790191916b10d42484052e55ae82c2f"`
Dec 01 21:45:12.995 INFO [stderr] usermod: no changes
Dec 01 21:45:13.123 INFO [stderr]    Compiling libc v0.2.14
Dec 01 21:45:13.123 INFO [stderr]    Compiling regex-syntax v0.3.4
Dec 01 21:45:13.126 INFO [stderr]    Compiling combine v2.0.0
Dec 01 21:45:15.102 INFO [stderr]    Compiling thread-id v2.0.0
Dec 01 21:45:15.102 INFO [stderr]    Compiling memchr v0.1.11
Dec 01 21:45:15.102 INFO [stderr]    Compiling term_size v0.2.1
Dec 01 21:45:16.953 INFO [stderr]    Compiling aho-corasick v0.5.2
Dec 01 21:45:17.128 INFO [stderr]    Compiling thread_local v0.2.6
Dec 01 21:45:17.312 INFO [stderr]    Compiling clap v2.19.1
Dec 01 21:45:23.467 INFO [stderr]    Compiling combine-language v2.0.0
Dec 01 21:45:26.023 INFO [stderr]    Compiling regex v0.1.73
Dec 01 21:45:42.815 INFO [stderr]    Compiling env_logger v0.3.4
Dec 01 21:45:47.851 INFO [stderr]    Compiling nvm v0.1.0 (/source)
Dec 01 21:45:49.071 INFO [stderr] warning: unused macro definition
Dec 01 21:45:49.071 INFO [stderr]    --> src/vm/machine.rs:109:1
Dec 01 21:45:49.072 INFO [stderr]     |
Dec 01 21:45:49.072 INFO [stderr] 109 | / macro_rules! try_check{
Dec 01 21:45:49.072 INFO [stderr] 110 | |   ($e:expr) => (e)
Dec 01 21:45:49.072 INFO [stderr] 111 | | }
Dec 01 21:45:49.073 INFO [stderr]     | |_^
Dec 01 21:45:49.073 INFO [stderr]     |
Dec 01 21:45:49.073 INFO [stderr]     = note: #[warn(unused_macros)] on by default
Dec 01 21:45:49.073 INFO [stderr] 
Dec 01 21:45:56.833 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 43.80s
Dec 01 21:45:56.834 INFO [stderr] su: No module specific data is present
Dec 01 21:45:57.655 INFO running `"docker" "inspect" "6c8cb345c50946ee46651ff66dcce804f790191916b10d42484052e55ae82c2f"`
Dec 01 21:45:57.971 INFO running `"docker" "rm" "-f" "6c8cb345c50946ee46651ff66dcce804f790191916b10d42484052e55ae82c2f"`
Dec 01 21:45:58.263 INFO [stdout] 6c8cb345c50946ee46651ff66dcce804f790191916b10d42484052e55ae82c2f
Dec 01 21:45:58.263 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-2/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/beta-1.31-5/1.30.1:/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 +1.30.1 test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 01 21:45:58.768 INFO [stdout] 1858f3679c83aed732b248277c8cfa3facfa1d1da0395113c8419bdb654b365e
Dec 01 21:45:58.770 INFO running `"docker" "start" "-a" "1858f3679c83aed732b248277c8cfa3facfa1d1da0395113c8419bdb654b365e"`
Dec 01 21:46:00.465 INFO [stderr] usermod: no changes
Dec 01 21:46:00.632 INFO [stderr]    Compiling nvm v0.1.0 (/source)
Dec 01 21:46:01.893 INFO [stderr] warning: unused `#[macro_use]` import
Dec 01 21:46:01.893 INFO [stderr]  --> src/main.rs:8:1
Dec 01 21:46:01.893 INFO [stderr]   |
Dec 01 21:46:01.893 INFO [stderr] 8 | #[macro_use]
Dec 01 21:46:01.893 INFO [stderr]   | ^^^^^^^^^^^^
Dec 01 21:46:01.893 INFO [stderr]   |
Dec 01 21:46:01.893 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Dec 01 21:46:01.893 INFO [stderr] 
Dec 01 21:46:01.894 INFO [stderr] warning: unused macro definition
Dec 01 21:46:01.894 INFO [stderr]    --> src/vm/machine.rs:109:1
Dec 01 21:46:01.894 INFO [stderr]     |
Dec 01 21:46:01.894 INFO [stderr] 109 | / macro_rules! try_check{
Dec 01 21:46:01.894 INFO [stderr] 110 | |   ($e:expr) => (e)
Dec 01 21:46:01.894 INFO [stderr] 111 | | }
Dec 01 21:46:01.894 INFO [stderr]     | |_^
Dec 01 21:46:01.894 INFO [stderr]     |
Dec 01 21:46:01.894 INFO [stderr]     = note: #[warn(unused_macros)] on by default
Dec 01 21:46:01.894 INFO [stderr] 
Dec 01 21:46:09.419 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 8.92s
Dec 01 21:46:09.420 INFO [stderr] su: No module specific data is present
Dec 01 21:46:10.415 INFO running `"docker" "inspect" "1858f3679c83aed732b248277c8cfa3facfa1d1da0395113c8419bdb654b365e"`
Dec 01 21:46:10.687 INFO running `"docker" "rm" "-f" "1858f3679c83aed732b248277c8cfa3facfa1d1da0395113c8419bdb654b365e"`
Dec 01 21:46:11.091 INFO [stdout] 1858f3679c83aed732b248277c8cfa3facfa1d1da0395113c8419bdb654b365e
Dec 01 21:46:11.099 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-2/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/beta-1.31-5/1.30.1:/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 +1.30.1 test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 01 21:46:11.647 INFO [stdout] e0e27b955bb2fecb1f04745a981142f1ecd8798612d45486f4a542b46d02c418
Dec 01 21:46:11.650 INFO running `"docker" "start" "-a" "e0e27b955bb2fecb1f04745a981142f1ecd8798612d45486f4a542b46d02c418"`
Dec 01 21:46:13.191 INFO [stderr] usermod: no changes
Dec 01 21:46:13.303 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.09s
Dec 01 21:46:13.315 INFO [stderr]      Running /target/debug/deps/nvm-ec0040a42d7b9b94
Dec 01 21:46:13.315 INFO [stdout] 
Dec 01 21:46:13.315 INFO [stdout] running 18 tests
Dec 01 21:46:13.318 INFO [stdout] test tests::miniprogram ... ok
Dec 01 21:46:13.318 INFO [stdout] test tests::if_test ... ok
Dec 01 21:46:13.323 INFO [stdout] test tests::if_else_test ... ok
Dec 01 21:46:13.335 INFO [stdout] test tests::maxfn ... ok
Dec 01 21:46:13.335 INFO [stdout] test tests::allow_interpreter_line ... ok
Dec 01 21:46:13.335 INFO [stdout] test tests::add ... ok
Dec 01 21:46:13.335 INFO [stdout] test tests::if_else_if ... ok
Dec 01 21:46:13.355 INFO [stdout] test tests::ref_in_function ... ok
Dec 01 21:46:13.355 INFO [stdout] test tests::compile_fib_iter ... ok
Dec 01 21:46:13.367 INFO [stdout] test tests::ref_of_params_function ... ok
Dec 01 21:46:13.367 INFO [stdout] test tests::run_gen_fib8 ... ok
Dec 01 21:46:13.367 INFO [stdout] test tests::sample ... ok
Dec 01 21:46:13.374 INFO [stdout] test tests::simple_call ... ok
Dec 01 21:46:13.374 INFO [stdout] test tests::run_gen_fib4 ... ok
Dec 01 21:46:13.374 INFO [stdout] test tests::readme_example ... ok
Dec 01 21:46:13.374 INFO [stdout] test tests::run_fib_iter8 ... ok
Dec 01 21:46:13.391 INFO [stdout] test tests::simple_call_v ... ok
Dec 01 21:46:13.391 INFO [stdout] test tests::simple_function_call ... ok
Dec 01 21:46:13.391 INFO [stdout] 
Dec 01 21:46:13.391 INFO [stdout] test result: ok. 18 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 01 21:46:13.391 INFO [stdout] 
Dec 01 21:46:13.407 INFO [stderr] su: No module specific data is present
Dec 01 21:46:14.652 INFO running `"docker" "inspect" "e0e27b955bb2fecb1f04745a981142f1ecd8798612d45486f4a542b46d02c418"`
Dec 01 21:46:15.005 INFO running `"docker" "rm" "-f" "e0e27b955bb2fecb1f04745a981142f1ecd8798612d45486f4a542b46d02c418"`
Dec 01 21:46:15.399 INFO [stdout] e0e27b955bb2fecb1f04745a981142f1ecd8798612d45486f4a542b46d02c418
