Nov 17 00:02:50.161 INFO testing jasonhansel/kineticvm against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 17 00:02:50.161 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-3/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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:50.646 INFO [stdout] 44e2c724772878fcb33fc98106255b7c508c0de4bde6c74917c961bda1e63dd5
Nov 17 00:02:50.653 INFO running `"docker" "start" "-a" "44e2c724772878fcb33fc98106255b7c508c0de4bde6c74917c961bda1e63dd5"`
Nov 17 00:02:51.627 INFO [stderr] usermod: no changes
Nov 17 00:02:51.687 INFO [stderr]    Compiling kineticvm v0.0.1 (/source)
Nov 17 00:02:55.363 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.71s
Nov 17 00:02:55.366 INFO [stderr] su: No module specific data is present
Nov 17 00:02:56.647 INFO running `"docker" "inspect" "44e2c724772878fcb33fc98106255b7c508c0de4bde6c74917c961bda1e63dd5"`
Nov 17 00:02:56.967 INFO running `"docker" "rm" "-f" "44e2c724772878fcb33fc98106255b7c508c0de4bde6c74917c961bda1e63dd5"`
Nov 17 00:02:57.223 INFO [stdout] 44e2c724772878fcb33fc98106255b7c508c0de4bde6c74917c961bda1e63dd5
Nov 17 00:02:57.230 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-3/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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:57.695 INFO [stdout] f098fbc023c478879efe00f6924b66b742b91304f843e656cab8e8b839ad8c05
Nov 17 00:02:57.701 INFO running `"docker" "start" "-a" "f098fbc023c478879efe00f6924b66b742b91304f843e656cab8e8b839ad8c05"`
Nov 17 00:02:58.903 INFO [stderr] usermod: no changes
Nov 17 00:02:58.951 INFO [stderr]    Compiling kineticvm v0.0.1 (/source)
Nov 17 00:02:59.363 INFO [stderr] warning: unused import: `Read`
Nov 17 00:02:59.363 INFO [stderr]  --> src/test.rs:7:22
Nov 17 00:02:59.363 INFO [stderr]   |
Nov 17 00:02:59.363 INFO [stderr] 7 | use std::io::{Cursor,Read};
Nov 17 00:02:59.363 INFO [stderr]   |                      ^^^^
Nov 17 00:02:59.363 INFO [stderr]   |
Nov 17 00:02:59.363 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Nov 17 00:02:59.363 INFO [stderr] 
Nov 17 00:02:59.363 INFO [stderr] warning: unused macro definition
Nov 17 00:02:59.363 INFO [stderr]   --> src/test.rs:42:1
Nov 17 00:02:59.363 INFO [stderr]    |
Nov 17 00:02:59.363 INFO [stderr] 42 | / macro_rules! bench_program {
Nov 17 00:02:59.363 INFO [stderr] 43 | |     ( $x:ident ) => {
Nov 17 00:02:59.363 INFO [stderr] 44 | |         
Nov 17 00:02:59.363 INFO [stderr] 45 | |
Nov 17 00:02:59.363 INFO [stderr] ...  |
Nov 17 00:02:59.363 INFO [stderr] 62 | |     }
Nov 17 00:02:59.363 INFO [stderr] 63 | | }
Nov 17 00:02:59.363 INFO [stderr]    | |_^
Nov 17 00:02:59.363 INFO [stderr]    |
Nov 17 00:02:59.363 INFO [stderr]    = note: #[warn(unused_macros)] on by default
Nov 17 00:02:59.363 INFO [stderr] 
Nov 17 00:03:01.515 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.58s
Nov 17 00:03:01.515 INFO [stderr] su: No module specific data is present
Nov 17 00:03:02.227 INFO running `"docker" "inspect" "f098fbc023c478879efe00f6924b66b742b91304f843e656cab8e8b839ad8c05"`
Nov 17 00:03:02.461 INFO running `"docker" "rm" "-f" "f098fbc023c478879efe00f6924b66b742b91304f843e656cab8e8b839ad8c05"`
Nov 17 00:03:02.879 INFO [stdout] f098fbc023c478879efe00f6924b66b742b91304f843e656cab8e8b839ad8c05
Nov 17 00:03:02.884 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-3/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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:03.319 INFO [stdout] e68245c65f4fd33143586bfc092e90a4dd26a5ebd2e0342f7f2784c7c12aad0f
Nov 17 00:03:03.323 INFO running `"docker" "start" "-a" "e68245c65f4fd33143586bfc092e90a4dd26a5ebd2e0342f7f2784c7c12aad0f"`
Nov 17 00:03:04.730 INFO [stderr] usermod: no changes
Nov 17 00:03:04.785 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.02s
Nov 17 00:03:04.786 INFO [stderr]      Running /target/debug/deps/kineticvm-a6e6251f705a7452
Nov 17 00:03:04.788 INFO [stdout] 
Nov 17 00:03:04.788 INFO [stdout] running 11 tests
Nov 17 00:03:04.791 INFO [stdout] test test::addition ... ok
Nov 17 00:03:04.791 INFO [stdout] test test::arithmetic ... ok
Nov 17 00:03:04.792 INFO [stdout] test test::io_char ... ok
Nov 17 00:03:04.802 INFO [stdout] test test::bitwise ... ok
Nov 17 00:03:04.802 INFO [stdout] test test::loops ... ok
Nov 17 00:03:04.802 INFO [stdout] test test::label_addr ... ok
Nov 17 00:03:04.802 INFO [stdout] test test::equality ... ok
Nov 17 00:03:04.802 INFO [stdout] test test::memory ... ok
Nov 17 00:03:04.802 INFO [stdout] test test::factorial ... ok
Nov 17 00:03:04.805 INFO [stdout] test test::calls ... ok
Nov 17 00:03:04.809 INFO [stdout] test test::memory_types ... ok
Nov 17 00:03:04.809 INFO [stdout] 
Nov 17 00:03:04.809 INFO [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 00:03:04.809 INFO [stdout] 
Nov 17 00:03:04.811 INFO [stderr] su: No module specific data is present
Nov 17 00:03:05.173 INFO running `"docker" "inspect" "e68245c65f4fd33143586bfc092e90a4dd26a5ebd2e0342f7f2784c7c12aad0f"`
Nov 17 00:03:05.327 INFO running `"docker" "rm" "-f" "e68245c65f4fd33143586bfc092e90a4dd26a5ebd2e0342f7f2784c7c12aad0f"`
Nov 17 00:03:05.532 INFO [stdout] e68245c65f4fd33143586bfc092e90a4dd26a5ebd2e0342f7f2784c7c12aad0f