Nov 17 00:02:50.917 INFO testing jasonhansel/kineticvm against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 17 00:02:50.917 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 17 00:02:51.356 INFO [stdout] d7d14aabd06063490f39a20f18f85595538d371c643c93b5bdd6dd82f72694f0
Nov 17 00:02:51.359 INFO running `"docker" "start" "-a" "d7d14aabd06063490f39a20f18f85595538d371c643c93b5bdd6dd82f72694f0"`
Nov 17 00:02:52.834 INFO [stderr] usermod: no changes
Nov 17 00:02:52.911 INFO [stderr]    Compiling kineticvm v0.0.1 (/source)
Nov 17 00:02:56.731 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.87s
Nov 17 00:02:56.734 INFO [stderr] su: No module specific data is present
Nov 17 00:02:57.635 INFO running `"docker" "inspect" "d7d14aabd06063490f39a20f18f85595538d371c643c93b5bdd6dd82f72694f0"`
Nov 17 00:02:57.953 INFO running `"docker" "rm" "-f" "d7d14aabd06063490f39a20f18f85595538d371c643c93b5bdd6dd82f72694f0"`
Nov 17 00:02:58.191 INFO [stdout] d7d14aabd06063490f39a20f18f85595538d371c643c93b5bdd6dd82f72694f0
Nov 17 00:02:58.193 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 17 00:02:58.643 INFO [stdout] 004017b4c831242c304883a0431ea8b0b2810befa493aeb1e1625538d325869e
Nov 17 00:02:58.651 INFO running `"docker" "start" "-a" "004017b4c831242c304883a0431ea8b0b2810befa493aeb1e1625538d325869e"`
Nov 17 00:02:59.734 INFO [stderr] usermod: no changes
Nov 17 00:02:59.783 INFO [stderr]    Compiling kineticvm v0.0.1 (/source)
Nov 17 00:03:00.192 INFO [stderr] warning: unused import: `Read`
Nov 17 00:03:00.192 INFO [stderr]  --> src/test.rs:7:22
Nov 17 00:03:00.193 INFO [stderr]   |
Nov 17 00:03:00.193 INFO [stderr] 7 | use std::io::{Cursor,Read};
Nov 17 00:03:00.193 INFO [stderr]   |                      ^^^^
Nov 17 00:03:00.194 INFO [stderr]   |
Nov 17 00:03:00.194 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Nov 17 00:03:00.194 INFO [stderr] 
Nov 17 00:03:00.194 INFO [stderr] warning: unused macro definition
Nov 17 00:03:00.195 INFO [stderr]   --> src/test.rs:42:1
Nov 17 00:03:00.195 INFO [stderr]    |
Nov 17 00:03:00.195 INFO [stderr] 42 | / macro_rules! bench_program {
Nov 17 00:03:00.196 INFO [stderr] 43 | |     ( $x:ident ) => {
Nov 17 00:03:00.196 INFO [stderr] 44 | |         
Nov 17 00:03:00.196 INFO [stderr] 45 | |
Nov 17 00:03:00.197 INFO [stderr] ...  |
Nov 17 00:03:00.197 INFO [stderr] 62 | |     }
Nov 17 00:03:00.197 INFO [stderr] 63 | | }
Nov 17 00:03:00.198 INFO [stderr]    | |_^
Nov 17 00:03:00.198 INFO [stderr]    |
Nov 17 00:03:00.198 INFO [stderr]    = note: #[warn(unused_macros)] on by default
Nov 17 00:03:00.206 INFO [stderr] 
Nov 17 00:03:02.319 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.57s
Nov 17 00:03:02.322 INFO [stderr] su: No module specific data is present
Nov 17 00:03:02.939 INFO running `"docker" "inspect" "004017b4c831242c304883a0431ea8b0b2810befa493aeb1e1625538d325869e"`
Nov 17 00:03:03.235 INFO running `"docker" "rm" "-f" "004017b4c831242c304883a0431ea8b0b2810befa493aeb1e1625538d325869e"`
Nov 17 00:03:03.535 INFO [stdout] 004017b4c831242c304883a0431ea8b0b2810befa493aeb1e1625538d325869e
Nov 17 00:03:03.546 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 17 00:03:04.051 INFO [stdout] 0cd7338fe7c8cd207fc8c408d8a2b826166da652db8bd29bf3b5573f9ce5838f
Nov 17 00:03:04.053 INFO running `"docker" "start" "-a" "0cd7338fe7c8cd207fc8c408d8a2b826166da652db8bd29bf3b5573f9ce5838f"`
Nov 17 00:03:04.989 INFO [stderr] usermod: no changes
Nov 17 00:03:05.021 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.01s
Nov 17 00:03:05.021 INFO [stderr]      Running /target/debug/deps/kineticvm-958d8029661f0795
Nov 17 00:03:05.025 INFO [stdout] 
Nov 17 00:03:05.025 INFO [stdout] running 11 tests
Nov 17 00:03:05.036 INFO [stdout] test test::bitwise ... ok
Nov 17 00:03:05.036 INFO [stdout] test test::arithmetic ... ok
Nov 17 00:03:05.036 INFO [stdout] test test::addition ... ok
Nov 17 00:03:05.040 INFO [stdout] test test::label_addr ... ok
Nov 17 00:03:05.040 INFO [stdout] test test::equality ... ok
Nov 17 00:03:05.040 INFO [stdout] test test::calls ... ok
Nov 17 00:03:05.040 INFO [stdout] test test::io_char ... ok
Nov 17 00:03:05.041 INFO [stdout] test test::memory ... ok
Nov 17 00:03:05.041 INFO [stdout] test test::factorial ... ok
Nov 17 00:03:05.042 INFO [stdout] test test::loops ... ok
Nov 17 00:03:05.048 INFO [stdout] test test::memory_types ... ok
Nov 17 00:03:05.048 INFO [stdout] 
Nov 17 00:03:05.048 INFO [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 00:03:05.048 INFO [stdout] 
Nov 17 00:03:05.051 INFO [stderr] su: No module specific data is present
Nov 17 00:03:05.530 INFO running `"docker" "inspect" "0cd7338fe7c8cd207fc8c408d8a2b826166da652db8bd29bf3b5573f9ce5838f"`
Nov 17 00:03:05.677 INFO running `"docker" "rm" "-f" "0cd7338fe7c8cd207fc8c408d8a2b826166da652db8bd29bf3b5573f9ce5838f"`
Nov 17 00:03:05.809 INFO [stdout] 0cd7338fe7c8cd207fc8c408d8a2b826166da652db8bd29bf3b5573f9ce5838f