Dec 05 03:00:22.499 INFO testing vakabus/rumipsem against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 05 03:00:22.499 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 05 03:00:23.022 INFO [stdout] 9847f46ab69513e87068f6c0d7614e051104d8f7a33a3956f61cc3dbcd2566d6
Dec 05 03:00:23.024 INFO running `"docker" "start" "-a" "9847f46ab69513e87068f6c0d7614e051104d8f7a33a3956f61cc3dbcd2566d6"`
Dec 05 03:00:24.704 INFO [stderr] usermod: no changes
Dec 05 03:00:24.920 INFO [stderr]    Compiling num-integer v0.1.38
Dec 05 03:00:24.920 INFO [stderr]    Compiling plain v0.2.3
Dec 05 03:00:24.920 INFO [stderr]    Compiling scroll v0.7.0
Dec 05 03:00:24.972 INFO [stderr]    Compiling miniz-sys v0.1.10
Dec 05 03:00:24.972 INFO [stderr]    Compiling time v0.1.39
Dec 05 03:00:24.972 INFO [stderr]    Compiling term v0.5.1
Dec 05 03:00:24.972 INFO [stderr]    Compiling nix v0.11.0
Dec 05 03:00:24.972 INFO [stderr]    Compiling scroll_derive v0.7.0
Dec 05 03:00:25.685 INFO [stderr]    Compiling serde_json v1.0.19
Dec 05 03:00:30.305 INFO [stderr]    Compiling goblin v0.0.11
Dec 05 03:00:31.292 INFO [stderr]    Compiling chrono v0.4.3
Dec 05 03:00:31.792 INFO [stderr]    Compiling flate2 v0.2.20
Dec 05 03:00:34.934 INFO [stderr]    Compiling simplelog v0.5.2
Dec 05 03:00:44.104 INFO [stderr]    Compiling rumipsem v0.1.0 (/source)
Dec 05 03:00:46.405 INFO [stderr] warning: variant is never constructed: `FlowChangeImmediate`
Dec 05 03:00:46.405 INFO [stderr]   --> src/cpu/event.rs:10:5
Dec 05 03:00:46.405 INFO [stderr]    |
Dec 05 03:00:46.406 INFO [stderr] 10 |     FlowChangeImmediate(u32), // this is here to support compact branch
Dec 05 03:00:46.406 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^
Dec 05 03:00:46.406 INFO [stderr]    |
Dec 05 03:00:46.406 INFO [stderr]    = note: #[warn(dead_code)] on by default
Dec 05 03:00:46.406 INFO [stderr] 
Dec 05 03:00:46.406 INFO [stderr] warning: constant item is never used: `RETURN_ADDRESS`
Dec 05 03:00:46.406 INFO [stderr]   --> src/cpu/registers.rs:10:1
Dec 05 03:00:46.406 INFO [stderr]    |
Dec 05 03:00:46.406 INFO [stderr] 10 | pub const RETURN_ADDRESS: u32 = 31;
Dec 05 03:00:46.406 INFO [stderr]    | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 05 03:00:46.406 INFO [stderr] 
Dec 05 03:00:46.406 INFO [stderr] warning: method is never used: `get_instruction_number`
Dec 05 03:00:46.406 INFO [stderr]   --> src/cpu/watchdog.rs:43:5
Dec 05 03:00:46.406 INFO [stderr]    |
Dec 05 03:00:46.406 INFO [stderr] 43 |     pub fn get_instruction_number(&self) -> usize {
Dec 05 03:00:46.406 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 05 03:00:46.406 INFO [stderr] 
Dec 05 03:00:46.408 INFO [stderr] warning: method is never used: `disable_trace_checking`
Dec 05 03:00:46.408 INFO [stderr]    --> src/cpu/watchdog.rs:102:5
Dec 05 03:00:46.408 INFO [stderr]     |
Dec 05 03:00:46.408 INFO [stderr] 102 |     pub fn disable_trace_checking(&mut self) {
Dec 05 03:00:46.408 INFO [stderr]     |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 05 03:00:46.408 INFO [stderr] 
Dec 05 03:00:49.040 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 24.31s
Dec 05 03:00:49.051 INFO [stderr] su: No module specific data is present
Dec 05 03:00:49.400 INFO running `"docker" "inspect" "9847f46ab69513e87068f6c0d7614e051104d8f7a33a3956f61cc3dbcd2566d6"`
Dec 05 03:00:49.606 INFO running `"docker" "rm" "-f" "9847f46ab69513e87068f6c0d7614e051104d8f7a33a3956f61cc3dbcd2566d6"`
Dec 05 03:00:49.742 INFO [stdout] 9847f46ab69513e87068f6c0d7614e051104d8f7a33a3956f61cc3dbcd2566d6
Dec 05 03:00:49.746 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 05 03:00:50.004 INFO [stdout] 403397c456dcbceea64b70dba330783b17ea536d7cc38724db768b672ea737f9
Dec 05 03:00:50.005 INFO running `"docker" "start" "-a" "403397c456dcbceea64b70dba330783b17ea536d7cc38724db768b672ea737f9"`
Dec 05 03:00:50.563 INFO [stderr] usermod: no changes
Dec 05 03:00:50.624 INFO [stderr]    Compiling rumipsem v0.1.0 (/source)
Dec 05 03:00:52.800 INFO [stderr] warning: variant is never constructed: `FlowChangeImmediate`
Dec 05 03:00:52.800 INFO [stderr]   --> src/cpu/event.rs:10:5
Dec 05 03:00:52.800 INFO [stderr]    |
Dec 05 03:00:52.800 INFO [stderr] 10 |     FlowChangeImmediate(u32), // this is here to support compact branch
Dec 05 03:00:52.800 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^
Dec 05 03:00:52.800 INFO [stderr]    |
Dec 05 03:00:52.800 INFO [stderr]    = note: #[warn(dead_code)] on by default
Dec 05 03:00:52.800 INFO [stderr] 
Dec 05 03:00:52.800 INFO [stderr] warning: constant item is never used: `RETURN_ADDRESS`
Dec 05 03:00:52.800 INFO [stderr]   --> src/cpu/registers.rs:10:1
Dec 05 03:00:52.800 INFO [stderr]    |
Dec 05 03:00:52.800 INFO [stderr] 10 | pub const RETURN_ADDRESS: u32 = 31;
Dec 05 03:00:52.800 INFO [stderr]    | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 05 03:00:52.800 INFO [stderr] 
Dec 05 03:00:52.800 INFO [stderr] warning: method is never used: `get_instruction_number`
Dec 05 03:00:52.800 INFO [stderr]   --> src/cpu/watchdog.rs:43:5
Dec 05 03:00:52.800 INFO [stderr]    |
Dec 05 03:00:52.800 INFO [stderr] 43 |     pub fn get_instruction_number(&self) -> usize {
Dec 05 03:00:52.800 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 05 03:00:52.800 INFO [stderr] 
Dec 05 03:00:52.800 INFO [stderr] warning: method is never used: `disable_trace_checking`
Dec 05 03:00:52.800 INFO [stderr]    --> src/cpu/watchdog.rs:102:5
Dec 05 03:00:52.800 INFO [stderr]     |
Dec 05 03:00:52.800 INFO [stderr] 102 |     pub fn disable_trace_checking(&mut self) {
Dec 05 03:00:52.800 INFO [stderr]     |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 05 03:00:52.800 INFO [stderr] 
Dec 05 03:00:53.356 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.78s
Dec 05 03:00:53.363 INFO [stderr] su: No module specific data is present
Dec 05 03:00:53.631 INFO running `"docker" "inspect" "403397c456dcbceea64b70dba330783b17ea536d7cc38724db768b672ea737f9"`
Dec 05 03:00:53.718 INFO running `"docker" "rm" "-f" "403397c456dcbceea64b70dba330783b17ea536d7cc38724db768b672ea737f9"`
Dec 05 03:00:53.810 INFO [stdout] 403397c456dcbceea64b70dba330783b17ea536d7cc38724db768b672ea737f9
Dec 05 03:00:53.813 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 05 03:00:54.003 INFO [stdout] d62ee6769a71032af15d282416dd62816341b17472780a8f1598058bbdeb1756
Dec 05 03:00:54.005 INFO running `"docker" "start" "-a" "d62ee6769a71032af15d282416dd62816341b17472780a8f1598058bbdeb1756"`
Dec 05 03:00:54.405 INFO [stderr] usermod: no changes
Dec 05 03:00:54.495 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.06s
Dec 05 03:00:54.512 INFO [stderr]      Running /target/debug/deps/rumipsem-1472c1e10183790f
Dec 05 03:00:54.516 INFO [stdout] 
Dec 05 03:00:54.516 INFO [stdout] running 3 tests
Dec 05 03:00:54.518 INFO [stdout] test cpu::bitutils::test_add_to_upper_bits ... ok
Dec 05 03:00:54.518 INFO [stdout] test cpu::bitutils::test_sign_extend ... ok
Dec 05 03:00:54.519 INFO [stdout] test cpu::bitutils::test_apply_offset ... ok
Dec 05 03:00:54.519 INFO [stdout] 
Dec 05 03:00:54.519 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 03:00:54.519 INFO [stdout] 
Dec 05 03:00:54.521 INFO [stderr] su: No module specific data is present
Dec 05 03:00:54.798 INFO running `"docker" "inspect" "d62ee6769a71032af15d282416dd62816341b17472780a8f1598058bbdeb1756"`
Dec 05 03:00:54.873 INFO running `"docker" "rm" "-f" "d62ee6769a71032af15d282416dd62816341b17472780a8f1598058bbdeb1756"`
Dec 05 03:00:54.943 INFO [stdout] d62ee6769a71032af15d282416dd62816341b17472780a8f1598058bbdeb1756