[INFO] updating cached repository bankent1/rv-cpu
[INFO] running `"git" "fetch" "--all"`
[INFO] [stdout] Fetching origin
[INFO] [stderr] From git://github.com/bankent1/rv-cpu
[INFO] [stderr]  * branch            HEAD       -> FETCH_HEAD
[INFO] running `"git" "clone" "work/cache/sources/gh/bankent1/rv-cpu" "work/ex/beta-1.38-1/sources/1.37.0/gh/bankent1/rv-cpu"`
[INFO] [stderr] Cloning into 'work/ex/beta-1.38-1/sources/1.37.0/gh/bankent1/rv-cpu'...
[INFO] [stderr] done.
[INFO] running `"git" "clone" "work/cache/sources/gh/bankent1/rv-cpu" "work/ex/beta-1.38-1/sources/beta-2019-08-13/gh/bankent1/rv-cpu"`
[INFO] [stderr] Cloning into 'work/ex/beta-1.38-1/sources/beta-2019-08-13/gh/bankent1/rv-cpu'...
[INFO] [stderr] done.
[INFO] running `"git" "rev-parse" "HEAD"`
[INFO] [stdout] ed5697bbe145269f0e8cc62cd764fb7ad6e626ea
[INFO] sha for GitHub repo bankent1/rv-cpu: ed5697bbe145269f0e8cc62cd764fb7ad6e626ea
[INFO] validating manifest of bankent1/rv-cpu on toolchain 1.37.0
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+1.37.0" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] validating manifest of bankent1/rv-cpu on toolchain beta-2019-08-13
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+beta-2019-08-13" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] started frobbing bankent1/rv-cpu
[INFO] finished frobbing bankent1/rv-cpu
[INFO] frobbed toml for bankent1/rv-cpu written to work/ex/beta-1.38-1/sources/1.37.0/gh/bankent1/rv-cpu/Cargo.toml
[INFO] started frobbing bankent1/rv-cpu
[INFO] finished frobbing bankent1/rv-cpu
[INFO] frobbed toml for bankent1/rv-cpu written to work/ex/beta-1.38-1/sources/beta-2019-08-13/gh/bankent1/rv-cpu/Cargo.toml
[INFO] crate bankent1/rv-cpu already has a lockfile, it will not be regenerated
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+1.37.0" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+beta-2019-08-13" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] testing bankent1/rv-cpu against beta-2019-08-13 for beta-1.38-1
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.38-1/worker-2/beta-2019-08-13:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.38-1/sources/beta-2019-08-13/gh/bankent1/rv-cpu:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+beta-2019-08-13" "build" "--frozen"`
[INFO] [stdout] 31671cc5cc1c555f4219adc1a73c39aecd567a1f2fad1a1c79d30cc5bd1bbf42
[INFO] running `"docker" "start" "-a" "31671cc5cc1c555f4219adc1a73c39aecd567a1f2fad1a1c79d30cc5bd1bbf42"`
[INFO] [stderr]    Compiling rvp v0.1.0 (/opt/crater/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.00s
[INFO] running `"docker" "inspect" "31671cc5cc1c555f4219adc1a73c39aecd567a1f2fad1a1c79d30cc5bd1bbf42"`
[INFO] running `"docker" "rm" "-f" "31671cc5cc1c555f4219adc1a73c39aecd567a1f2fad1a1c79d30cc5bd1bbf42"`
[INFO] [stdout] 31671cc5cc1c555f4219adc1a73c39aecd567a1f2fad1a1c79d30cc5bd1bbf42
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.38-1/worker-2/beta-2019-08-13:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.38-1/sources/beta-2019-08-13/gh/bankent1/rv-cpu:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+beta-2019-08-13" "test" "--frozen" "--no-run"`
[INFO] [stdout] 59c12a469518de43fbe5ed2867e4280445110203e79929f99fca88f8f7d663f7
[INFO] running `"docker" "start" "-a" "59c12a469518de43fbe5ed2867e4280445110203e79929f99fca88f8f7d663f7"`
[INFO] [stderr]    Compiling rvp v0.1.0 (/opt/crater/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.53s
[INFO] running `"docker" "inspect" "59c12a469518de43fbe5ed2867e4280445110203e79929f99fca88f8f7d663f7"`
[INFO] running `"docker" "rm" "-f" "59c12a469518de43fbe5ed2867e4280445110203e79929f99fca88f8f7d663f7"`
[INFO] [stdout] 59c12a469518de43fbe5ed2867e4280445110203e79929f99fca88f8f7d663f7
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.38-1/worker-2/beta-2019-08-13:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.38-1/sources/beta-2019-08-13/gh/bankent1/rv-cpu:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+beta-2019-08-13" "test" "--frozen"`
[INFO] [stdout] 3c2f55effe0bc5f13e67e6d780fa388b813d9a42935ee42bfa350dd7891bb81f
[INFO] running `"docker" "start" "-a" "3c2f55effe0bc5f13e67e6d780fa388b813d9a42935ee42bfa350dd7891bb81f"`
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.01s
[INFO] [stderr]      Running /opt/crater/target/debug/deps/rvp-0673a0d63949b327
[INFO] [stdout] 
[INFO] [stdout] running 42 tests
[INFO] [stdout] test demos::assembler::instr_macros::tests::test_ADDIU ... ok
[INFO] [stdout] test demos::assembler::instr_macros::tests::test_ANDI ... ok
[INFO] [stdout] test demos::assembler::instr_macros::tests::test_ADD ... ok
[INFO] [stdout] test demos::assembler::instr_macros::tests::test_ADDU ... ok
[INFO] [stdout] test demos::assembler::instr_macros::tests::test_AND ... ok
[INFO] [stdout] test demos::assembler::instr_macros::tests::test_BEQ ... ok
[INFO] [stdout] test demos::assembler::instr_macros::tests::test_NOR ... ok
[INFO] [stdout] test demos::assembler::instr_macros::tests::test_OR ... ok
[INFO] [stdout] test demos::assembler::instr_macros::tests::test_LW ... ok
[INFO] [stdout] test demos::assembler::instr_macros::tests::test_LUI ... ok
[INFO] [stdout] test demos::assembler::instr_macros::tests::test_LB ... ok
[INFO] [stdout] test demos::assembler::instr_macros::tests::test_J ... ok
[INFO] [stdout] test demos::assembler::instr_macros::tests::test_ORI ... ok
[INFO] [stdout] test demos::assembler::instr_macros::tests::test_SB ... ok
[INFO] [stdout] test demos::assembler::instr_macros::tests::test_SLT ... ok
[INFO] [stdout] test demos::assembler::instr_macros::tests::test_BNE ... ok
[INFO] [stdout] test demos::assembler::instr_macros::tests::test_SLTI ... ok
[INFO] [stdout] test demos::assembler::instr_macros::tests::test_SLTIU ... ok
[INFO] [stdout] test demos::assembler::instr_macros::tests::test_SLTU ... ok
[INFO] [stdout] test demos::assembler::instr_macros::tests::test_SUB ... ok
[INFO] [stdout] test demos::assembler::instr_macros::tests::test_SUBU ... ok
[INFO] [stdout] test demos::assembler::instr_macros::tests::test_SW ... ok
[INFO] [stdout] test demos::assembler::instr_macros::tests::test_XOR ... ok
[INFO] [stdout] test hardware::alu::tests::test_add ... ok
[INFO] [stdout] test hardware::alu::tests::test_and ... ok
[INFO] [stdout] test hardware::alu::tests::test_less ... ok
[INFO] [stdout] test hardware::alu::tests::test_or ... ok
[INFO] [stdout] test hardware::alu::tests::test_xor ... ok
[INFO] [stdout] test hardware::data_mem::tests::test_get_size ... ok
[INFO] [stdout] test demos::assembler::instr_macros::tests::test_ADDI ... ok
[INFO] [stdout] test hardware::data_mem::tests::test_read_write ... ok
[INFO] [stdout] test hardware::instr_mem::tests::test_get_size ... ok
[INFO] [stdout] test hardware::instr_mem::tests::test_read_write ... ok
[INFO] [stdout] test phases::tests::test_execute_alu ... ok
[INFO] [stdout] test phases::tests::test_instr_decode ... ok
[INFO] [stdout] test hardware::reg_file::tests::test_write_and_load ... ok
[INFO] [stdout] test phases::tests::test_mem_phase ... ok
[INFO] [stdout] test phases::tests::test_write_back ... ok
[INFO] [stdout] test hardware::data_mem::tests::test_write_panic ... ok
[INFO] [stdout] test hardware::instr_mem::tests::test_read_panic ... ok
[INFO] [stdout] test hardware::instr_mem::tests::test_write_panic ... ok
[INFO] [stdout] test hardware::data_mem::tests::test_read_panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 42 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] running `"docker" "inspect" "3c2f55effe0bc5f13e67e6d780fa388b813d9a42935ee42bfa350dd7891bb81f"`
[INFO] running `"docker" "rm" "-f" "3c2f55effe0bc5f13e67e6d780fa388b813d9a42935ee42bfa350dd7891bb81f"`
[INFO] [stdout] 3c2f55effe0bc5f13e67e6d780fa388b813d9a42935ee42bfa350dd7891bb81f