Nov 16 23:46:51.662 INFO testing jfredett/synacor against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 16 23:46:51.663 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-6/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 16 23:46:52.103 INFO [stdout] 687f2494006c6045b2bff5f09d86a5c9578ae0de563981b3824dd0fbe5b12d57
Nov 16 23:46:52.106 INFO running `"docker" "start" "-a" "687f2494006c6045b2bff5f09d86a5c9578ae0de563981b3824dd0fbe5b12d57"`
Nov 16 23:46:53.024 INFO [stderr] usermod: no changes
Nov 16 23:46:53.119 INFO [stderr]    Compiling synacor v0.1.0 (/source)
Nov 16 23:46:54.021 INFO [stderr] warning: unused `std::result::Result` that must be used
Nov 16 23:46:54.021 INFO [stderr]    --> src/vm.rs:186:9
Nov 16 23:46:54.021 INFO [stderr]     |
Nov 16 23:46:54.021 INFO [stderr] 186 |         stdin.read_exact(&mut buf);
Nov 16 23:46:54.021 INFO [stderr]     |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 23:46:54.021 INFO [stderr]     |
Nov 16 23:46:54.021 INFO [stderr]     = note: #[warn(unused_must_use)] on by default
Nov 16 23:46:54.023 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Nov 16 23:46:54.023 INFO [stderr] 
Nov 16 23:46:58.033 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.99s
Nov 16 23:46:58.041 INFO [stderr] su: No module specific data is present
Nov 16 23:46:58.825 INFO running `"docker" "inspect" "687f2494006c6045b2bff5f09d86a5c9578ae0de563981b3824dd0fbe5b12d57"`
Nov 16 23:46:59.109 INFO running `"docker" "rm" "-f" "687f2494006c6045b2bff5f09d86a5c9578ae0de563981b3824dd0fbe5b12d57"`
Nov 16 23:46:59.329 INFO [stdout] 687f2494006c6045b2bff5f09d86a5c9578ae0de563981b3824dd0fbe5b12d57
Nov 16 23:46:59.334 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-6/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 16 23:46:59.611 INFO [stdout] 1bc58a8f3e592d6dc75782e49518b0513e140a173425ff87424030578c815856
Nov 16 23:46:59.613 INFO running `"docker" "start" "-a" "1bc58a8f3e592d6dc75782e49518b0513e140a173425ff87424030578c815856"`
Nov 16 23:47:00.063 INFO [stderr] usermod: no changes
Nov 16 23:47:00.117 INFO [stderr]    Compiling synacor v0.1.0 (/source)
Nov 16 23:47:02.906 INFO [stderr] warning: unused arithmetic operation that must be used
Nov 16 23:47:02.906 INFO [stderr]    --> src/u15.rs:163:30
Nov 16 23:47:02.906 INFO [stderr]     |
Nov 16 23:47:02.906 INFO [stderr] 163 |         fn sub_underflow() { u15(0) - u15(2); }
Nov 16 23:47:02.906 INFO [stderr]     |                              ^^^^^^^^^^^^^^^
Nov 16 23:47:02.906 INFO [stderr]     |
Nov 16 23:47:02.906 INFO [stderr]     = note: #[warn(unused_must_use)] on by default
Nov 16 23:47:02.906 INFO [stderr] 
Nov 16 23:47:02.906 INFO [stderr] warning: unused arithmetic operation that must be used
Nov 16 23:47:02.906 INFO [stderr]    --> src/u15.rs:167:28
Nov 16 23:47:02.906 INFO [stderr]     |
Nov 16 23:47:02.906 INFO [stderr] 167 |         fn div_by_zero() { u15(1) / u15(0); }
Nov 16 23:47:02.906 INFO [stderr]     |                            ^^^^^^^^^^^^^^^
Nov 16 23:47:02.906 INFO [stderr] 
Nov 16 23:47:02.909 INFO [stderr] warning: unused arithmetic operation that must be used
Nov 16 23:47:02.909 INFO [stderr]    --> src/u15.rs:223:26
Nov 16 23:47:02.909 INFO [stderr]     |
Nov 16 23:47:02.909 INFO [stderr] 223 |         fn sub_panic() { u15(16) - u15(17); }
Nov 16 23:47:02.909 INFO [stderr]     |                          ^^^^^^^^^^^^^^^^^
Nov 16 23:47:02.909 INFO [stderr] 
Nov 16 23:47:02.948 INFO [stderr] warning: unused `std::result::Result` that must be used
Nov 16 23:47:02.948 INFO [stderr]    --> src/vm.rs:186:9
Nov 16 23:47:02.948 INFO [stderr]     |
Nov 16 23:47:02.948 INFO [stderr] 186 |         stdin.read_exact(&mut buf);
Nov 16 23:47:02.948 INFO [stderr]     |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 23:47:02.948 INFO [stderr]     |
Nov 16 23:47:02.948 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Nov 16 23:47:02.948 INFO [stderr] 
Nov 16 23:47:04.812 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.73s
Nov 16 23:47:04.818 INFO [stderr] su: No module specific data is present
Nov 16 23:47:05.073 INFO running `"docker" "inspect" "1bc58a8f3e592d6dc75782e49518b0513e140a173425ff87424030578c815856"`
Nov 16 23:47:05.178 INFO running `"docker" "rm" "-f" "1bc58a8f3e592d6dc75782e49518b0513e140a173425ff87424030578c815856"`
Nov 16 23:47:05.260 INFO [stdout] 1bc58a8f3e592d6dc75782e49518b0513e140a173425ff87424030578c815856
Nov 16 23:47:05.264 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-6/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 16 23:47:05.438 INFO [stdout] a86bdfc0bda9177df9250ce094a454794e8bac237e0b82cf740f03c46126f710
Nov 16 23:47:05.440 INFO running `"docker" "start" "-a" "a86bdfc0bda9177df9250ce094a454794e8bac237e0b82cf740f03c46126f710"`
Nov 16 23:47:05.871 INFO [stderr] usermod: no changes
Nov 16 23:47:05.924 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.03s
Nov 16 23:47:05.937 INFO [stderr]      Running /target/debug/deps/synacor-7b70e948f0fdb012
Nov 16 23:47:05.940 INFO [stdout] 
Nov 16 23:47:05.941 INFO [stdout] running 312 tests
Nov 16 23:47:05.943 INFO [stdout] test address::tests::register_some ... ok
Nov 16 23:47:05.955 INFO [stdout] test address::tests::next ... ok
Nov 16 23:47:05.955 INFO [stdout] test address::tests::register_none ... ok
Nov 16 23:47:05.955 INFO [stdout] test address::tests::valid ... ok
Nov 16 23:47:05.955 INFO [stdout] test address::tests::invalid ... ok
Nov 16 23:47:05.955 INFO [stdout] test argument::tests::new_lit ... ok
Nov 16 23:47:05.955 INFO [stdout] test argument::tests::new_reg ... ok
Nov 16 23:47:05.958 INFO [stdout] test instruction::tests::display::add::lit_lit ... ok
Nov 16 23:47:05.958 INFO [stdout] test instruction::tests::display::add::lit_reg ... ok
Nov 16 23:47:05.960 INFO [stdout] test instruction::tests::display::add::reg_reg ... ok
Nov 16 23:47:05.960 INFO [stdout] test instruction::tests::display::and::lit_lit ... ok
Nov 16 23:47:05.962 INFO [stdout] test instruction::tests::display::and::reg_reg ... ok
Nov 16 23:47:05.969 INFO [stdout] test instruction::tests::display::add::reg_lit ... ok
Nov 16 23:47:05.969 INFO [stdout] test instruction::tests::display::call::lit ... ok
Nov 16 23:47:05.969 INFO [stdout] test instruction::tests::display::and::reg_lit ... ok
Nov 16 23:47:05.970 INFO [stdout] test instruction::tests::display::and::lit_reg ... ok
Nov 16 23:47:05.970 INFO [stdout] test instruction::tests::display::eq::lit_lit ... ok
Nov 16 23:47:05.970 INFO [stdout] test instruction::tests::display::call::reg ... ok
Nov 16 23:47:05.971 INFO [stdout] test instruction::tests::display::eq::reg_reg ... ok
Nov 16 23:47:05.971 INFO [stdout] test instruction::tests::display::gt::reg_reg ... ok
Nov 16 23:47:05.971 INFO [stdout] test instruction::tests::display::gt::lit_lit ... ok
Nov 16 23:47:05.971 INFO [stdout] test instruction::tests::display::eq::lit_reg ... ok
Nov 16 23:47:05.972 INFO [stdout] test instruction::tests::display::gt::reg_lit ... ok
Nov 16 23:47:05.972 INFO [stdout] test instruction::tests::display::gt::lit_reg ... ok
Nov 16 23:47:05.979 INFO [stdout] test instruction::tests::display::jf::lit_reg ... ok
Nov 16 23:47:05.979 INFO [stdout] test instruction::tests::display::halt::test ... ok
Nov 16 23:47:05.979 INFO [stdout] test instruction::tests::display::eq::reg_lit ... ok
Nov 16 23:47:05.979 INFO [stdout] test instruction::tests::display::in_val::lit ... ok
Nov 16 23:47:05.979 INFO [stdout] test instruction::tests::display::in_val::reg ... ok
Nov 16 23:47:05.980 INFO [stdout] test instruction::tests::display::jmp::reg ... ok
Nov 16 23:47:05.980 INFO [stdout] test instruction::tests::display::jf::lit_lit ... ok
Nov 16 23:47:05.980 INFO [stdout] test instruction::tests::display::jt::lit_lit ... ok
Nov 16 23:47:05.980 INFO [stdout] test instruction::tests::display::jt::lit_reg ... ok
Nov 16 23:47:05.980 INFO [stdout] test instruction::tests::display::jf::reg_reg ... ok
Nov 16 23:47:05.980 INFO [stdout] test instruction::tests::display::jmp::lit ... ok
Nov 16 23:47:05.991 INFO [stdout] test instruction::tests::display::jt::reg_lit ... ok
Nov 16 23:47:05.991 INFO [stdout] test instruction::tests::display::jt::reg_reg ... ok
Nov 16 23:47:05.991 INFO [stdout] test instruction::tests::display::modulo::lit_reg ... ok
Nov 16 23:47:05.992 INFO [stdout] test instruction::tests::display::jf::reg_lit ... ok
Nov 16 23:47:05.992 INFO [stdout] test instruction::tests::display::modulo::reg_lit ... ok
Nov 16 23:47:05.992 INFO [stdout] test instruction::tests::display::modulo::lit_lit ... ok
Nov 16 23:47:05.992 INFO [stdout] test instruction::tests::display::mult::reg_reg ... ok
Nov 16 23:47:05.996 INFO [stdout] test instruction::tests::display::not::reg ... ok
Nov 16 23:47:05.996 INFO [stdout] test instruction::tests::display::mult::lit_lit ... ok
Nov 16 23:47:05.996 INFO [stdout] test instruction::tests::display::mult::lit_reg ... ok
Nov 16 23:47:05.998 INFO [stdout] test instruction::tests::display::not::lit ... ok
Nov 16 23:47:05.998 INFO [stdout] test instruction::tests::display::or::lit_reg ... ok
Nov 16 23:47:05.998 INFO [stdout] test instruction::tests::display::or::reg_reg ... ok
Nov 16 23:47:05.998 INFO [stdout] test instruction::tests::display::or::reg_lit ... ok
Nov 16 23:47:05.999 INFO [stdout] test instruction::tests::display::out::lit ... ok
Nov 16 23:47:05.999 INFO [stdout] test instruction::tests::display::or::lit_lit ... ok
Nov 16 23:47:05.999 INFO [stdout] test instruction::tests::display::pop::reg ... ok
Nov 16 23:47:05.999 INFO [stdout] test instruction::tests::display::ret::test ... ok
Nov 16 23:47:05.999 INFO [stdout] test instruction::tests::display::rmem::lit ... ok
Nov 16 23:47:05.999 INFO [stdout] test instruction::tests::display::mult::reg_lit ... ok
Nov 16 23:47:05.999 INFO [stdout] test instruction::tests::display::rmem::reg ... ok
Nov 16 23:47:05.999 INFO [stdout] test instruction::tests::display::push::reg ... ok
Nov 16 23:47:05.999 INFO [stdout] test instruction::tests::display::out::reg ... ok
Nov 16 23:47:05.999 INFO [stdout] test instruction::tests::display::push::lit ... ok
Nov 16 23:47:06.002 INFO [stdout] test instruction::tests::display::set::lit ... ok
Nov 16 23:47:06.002 INFO [stdout] test instruction::tests::display::wmem::reg_reg ... ok
Nov 16 23:47:06.002 INFO [stdout] test instruction::tests::from_u16_sequence::add::lit_lit ... ok
Nov 16 23:47:06.002 INFO [stdout] test instruction::tests::from_u16_sequence::add::lit_reg ... ok
Nov 16 23:47:06.002 INFO [stdout] test instruction::tests::display::wmem::lit_lit ... ok
Nov 16 23:47:06.002 INFO [stdout] test instruction::tests::display::wmem::lit_reg ... ok
Nov 16 23:47:06.002 INFO [stdout] test instruction::tests::display::noop::test ... ok
Nov 16 23:47:06.003 INFO [stdout] test instruction::tests::display::wmem::reg_lit ... ok
Nov 16 23:47:06.003 INFO [stdout] test instruction::tests::display::modulo::reg_reg ... ok
Nov 16 23:47:06.006 INFO [stdout] test instruction::tests::display::set::reg ... ok
Nov 16 23:47:06.006 INFO [stdout] test instruction::tests::from_u16_sequence::and::reg_reg ... ok
Nov 16 23:47:06.006 INFO [stdout] test instruction::tests::from_u16_sequence::call::lit ... ok
Nov 16 23:47:06.006 INFO [stdout] test instruction::tests::from_u16_sequence::eq::lit_lit ... ok
Nov 16 23:47:06.006 INFO [stdout] test instruction::tests::from_u16_sequence::and::reg_lit ... ok
Nov 16 23:47:06.006 INFO [stdout] test instruction::tests::from_u16_sequence::add::reg_reg ... ok
Nov 16 23:47:06.006 INFO [stdout] test instruction::tests::from_u16_sequence::and::lit_lit ... ok
Nov 16 23:47:06.006 INFO [stdout] test instruction::tests::from_u16_sequence::and::lit_reg ... ok
Nov 16 23:47:06.006 INFO [stdout] test instruction::tests::from_u16_sequence::eq::reg_lit ... ok
Nov 16 23:47:06.008 INFO [stdout] test instruction::tests::from_u16_sequence::eq::lit_reg ... ok
Nov 16 23:47:06.008 INFO [stdout] test instruction::tests::from_u16_sequence::eq::reg_reg ... ok
Nov 16 23:47:06.008 INFO [stdout] test instruction::tests::from_u16_sequence::gt::lit_lit ... ok
Nov 16 23:47:06.008 INFO [stdout] test instruction::tests::from_u16_sequence::gt::lit_reg ... ok
Nov 16 23:47:06.008 INFO [stdout] test instruction::tests::from_u16_sequence::in_val::reg ... ok
Nov 16 23:47:06.008 INFO [stdout] test instruction::tests::from_u16_sequence::call::reg ... ok
Nov 16 23:47:06.008 INFO [stdout] test instruction::tests::from_u16_sequence::jf::lit_lit ... ok
Nov 16 23:47:06.008 INFO [stdout] test instruction::tests::from_u16_sequence::jf::lit_reg ... ok
Nov 16 23:47:06.011 INFO [stdout] test instruction::tests::from_u16_sequence::jf::reg_reg ... ok
Nov 16 23:47:06.011 INFO [stdout] test instruction::tests::from_u16_sequence::jf::reg_lit ... ok
Nov 16 23:47:06.011 INFO [stdout] test instruction::tests::from_u16_sequence::gt::reg_lit ... ok
Nov 16 23:47:06.011 INFO [stdout] test instruction::tests::from_u16_sequence::gt::reg_reg ... ok
Nov 16 23:47:06.011 INFO [stdout] test instruction::tests::from_u16_sequence::in_val::lit ... ok
Nov 16 23:47:06.011 INFO [stdout] test instruction::tests::from_u16_sequence::halt::halt ... ok
Nov 16 23:47:06.011 INFO [stdout] test instruction::tests::from_u16_sequence::add::reg_lit ... ok
Nov 16 23:47:06.011 INFO [stdout] test instruction::tests::from_u16_sequence::jmp::lit ... ok
Nov 16 23:47:06.016 INFO [stdout] test instruction::tests::from_u16_sequence::jmp::reg ... ok
Nov 16 23:47:06.016 INFO [stdout] test instruction::tests::from_u16_sequence::jt::lit_lit ... ok
Nov 16 23:47:06.016 INFO [stdout] test instruction::tests::from_u16_sequence::modulo::lit_lit ... ok
Nov 16 23:47:06.016 INFO [stdout] test instruction::tests::from_u16_sequence::jt::lit_reg ... ok
Nov 16 23:47:06.016 INFO [stdout] test instruction::tests::from_u16_sequence::jt::reg_lit ... ok
Nov 16 23:47:06.016 INFO [stdout] test instruction::tests::from_u16_sequence::jt::reg_reg ... ok
Nov 16 23:47:06.016 INFO [stdout] test instruction::tests::from_u16_sequence::modulo::reg_lit ... ok
Nov 16 23:47:06.016 INFO [stdout] test instruction::tests::from_u16_sequence::modulo::reg_reg ... ok
Nov 16 23:47:06.016 INFO [stdout] test instruction::tests::from_u16_sequence::mult::lit_lit ... ok
Nov 16 23:47:06.016 INFO [stdout] test instruction::tests::from_u16_sequence::mult::lit_reg ... ok
Nov 16 23:47:06.016 INFO [stdout] test instruction::tests::from_u16_sequence::modulo::lit_reg ... ok
Nov 16 23:47:06.016 INFO [stdout] test instruction::tests::from_u16_sequence::or::lit_reg ... ok
Nov 16 23:47:06.016 INFO [stdout] test instruction::tests::from_u16_sequence::or::reg_lit ... ok
Nov 16 23:47:06.016 INFO [stdout] test instruction::tests::from_u16_sequence::or::reg_reg ... ok
Nov 16 23:47:06.016 INFO [stdout] test instruction::tests::from_u16_sequence::out::lit ... ok
Nov 16 23:47:06.016 INFO [stdout] test instruction::tests::from_u16_sequence::out::reg ... ok
Nov 16 23:47:06.016 INFO [stdout] test instruction::tests::from_u16_sequence::pop::reg ... ok
Nov 16 23:47:06.016 INFO [stdout] test instruction::tests::from_u16_sequence::push::lit ... ok
Nov 16 23:47:06.016 INFO [stdout] test instruction::tests::from_u16_sequence::push::reg ... ok
Nov 16 23:47:06.016 INFO [stdout] test instruction::tests::from_u16_sequence::ret::ret ... ok
Nov 16 23:47:06.016 INFO [stdout] test instruction::tests::from_u16_sequence::rmem::lit ... ok
Nov 16 23:47:06.016 INFO [stdout] test instruction::tests::from_u16_sequence::rmem::reg ... ok
Nov 16 23:47:06.016 INFO [stdout] test instruction::tests::from_u16_sequence::set::lit ... ok
Nov 16 23:47:06.016 INFO [stdout] test instruction::tests::from_u16_sequence::set::reg ... ok
Nov 16 23:47:06.016 INFO [stdout] test instruction::tests::from_u16_sequence::wmem::lit_lit ... ok
Nov 16 23:47:06.016 INFO [stdout] test instruction::tests::from_u16_sequence::wmem::lit_reg ... ok
Nov 16 23:47:06.016 INFO [stdout] test instruction::tests::from_u16_sequence::wmem::reg_lit ... ok
Nov 16 23:47:06.016 INFO [stdout] test instruction::tests::from_u16_sequence::wmem::reg_reg ... ok
Nov 16 23:47:06.016 INFO [stdout] test instruction::tests::to_u16_sequence::add::lit_lit ... ok
Nov 16 23:47:06.016 INFO [stdout] test instruction::tests::to_u16_sequence::add::lit_reg ... ok
Nov 16 23:47:06.016 INFO [stdout] test instruction::tests::to_u16_sequence::add::reg_lit ... ok
Nov 16 23:47:06.016 INFO [stdout] test instruction::tests::to_u16_sequence::add::reg_reg ... ok
Nov 16 23:47:06.020 INFO [stdout] test instruction::tests::to_u16_sequence::and::lit_lit ... ok
Nov 16 23:47:06.023 INFO [stdout] test instruction::tests::from_u16_sequence::mult::reg_lit ... ok
Nov 16 23:47:06.023 INFO [stdout] test instruction::tests::from_u16_sequence::mult::reg_reg ... ok
Nov 16 23:47:06.023 INFO [stdout] test instruction::tests::from_u16_sequence::not::reg ... ok
Nov 16 23:47:06.023 INFO [stdout] test instruction::tests::from_u16_sequence::or::lit_lit ... ok
Nov 16 23:47:06.023 INFO [stdout] test instruction::tests::from_u16_sequence::not::lit ... ok
Nov 16 23:47:06.023 INFO [stdout] test instruction::tests::from_u16_sequence::noop::noop ... ok
Nov 16 23:47:06.023 INFO [stdout] test instruction::tests::to_u16_sequence::eq::lit_reg ... ok
Nov 16 23:47:06.023 INFO [stdout] test instruction::tests::to_u16_sequence::call::reg ... ok
Nov 16 23:47:06.023 INFO [stdout] test instruction::tests::to_u16_sequence::eq::lit_lit ... ok
Nov 16 23:47:06.023 INFO [stdout] test instruction::tests::to_u16_sequence::gt::lit_lit ... ok
Nov 16 23:47:06.023 INFO [stdout] test instruction::tests::to_u16_sequence::eq::reg_reg ... ok
Nov 16 23:47:06.023 INFO [stdout] test instruction::tests::to_u16_sequence::eq::reg_lit ... ok
Nov 16 23:47:06.027 INFO [stdout] test instruction::tests::to_u16_sequence::and::reg_lit ... ok
Nov 16 23:47:06.027 INFO [stdout] test instruction::tests::to_u16_sequence::and::reg_reg ... ok
Nov 16 23:47:06.027 INFO [stdout] test instruction::tests::to_u16_sequence::gt::lit_reg ... ok
Nov 16 23:47:06.028 INFO [stdout] test instruction::tests::to_u16_sequence::call::lit ... ok
Nov 16 23:47:06.028 INFO [stdout] test instruction::tests::to_u16_sequence::and::lit_reg ... ok
Nov 16 23:47:06.028 INFO [stdout] test instruction::tests::to_u16_sequence::gt::reg_lit ... ok
Nov 16 23:47:06.030 INFO [stdout] test instruction::tests::to_u16_sequence::halt::halt ... ok
Nov 16 23:47:06.030 INFO [stdout] test instruction::tests::to_u16_sequence::in_val::lit ... ok
Nov 16 23:47:06.031 INFO [stdout] test instruction::tests::to_u16_sequence::in_val::reg ... ok
Nov 16 23:47:06.031 INFO [stdout] test instruction::tests::to_u16_sequence::jf::lit_lit ... ok
Nov 16 23:47:06.031 INFO [stdout] test instruction::tests::to_u16_sequence::jf::lit_reg ... ok
Nov 16 23:47:06.031 INFO [stdout] test instruction::tests::to_u16_sequence::jf::reg_lit ... ok
Nov 16 23:47:06.031 INFO [stdout] test instruction::tests::to_u16_sequence::jt::reg_lit ... ok
Nov 16 23:47:06.031 INFO [stdout] test instruction::tests::to_u16_sequence::jt::reg_reg ... ok
Nov 16 23:47:06.031 INFO [stdout] test instruction::tests::to_u16_sequence::modulo::lit_lit ... ok
Nov 16 23:47:06.032 INFO [stdout] test instruction::tests::to_u16_sequence::modulo::lit_reg ... ok
Nov 16 23:47:06.032 INFO [stdout] test instruction::tests::to_u16_sequence::modulo::reg_lit ... ok
Nov 16 23:47:06.032 INFO [stdout] test instruction::tests::to_u16_sequence::modulo::reg_reg ... ok
Nov 16 23:47:06.032 INFO [stdout] test instruction::tests::to_u16_sequence::mult::lit_lit ... ok
Nov 16 23:47:06.032 INFO [stdout] test instruction::tests::to_u16_sequence::mult::lit_reg ... ok
Nov 16 23:47:06.032 INFO [stdout] test instruction::tests::to_u16_sequence::mult::reg_lit ... ok
Nov 16 23:47:06.032 INFO [stdout] test instruction::tests::to_u16_sequence::mult::reg_reg ... ok
Nov 16 23:47:06.033 INFO [stdout] test instruction::tests::to_u16_sequence::noop::noop ... ok
Nov 16 23:47:06.033 INFO [stdout] test instruction::tests::to_u16_sequence::not::lit ... ok
Nov 16 23:47:06.033 INFO [stdout] test instruction::tests::to_u16_sequence::not::reg ... ok
Nov 16 23:47:06.033 INFO [stdout] test instruction::tests::to_u16_sequence::or::lit_lit ... ok
Nov 16 23:47:06.033 INFO [stdout] test instruction::tests::to_u16_sequence::or::lit_reg ... ok
Nov 16 23:47:06.033 INFO [stdout] test instruction::tests::to_u16_sequence::or::reg_lit ... ok
Nov 16 23:47:06.034 INFO [stdout] test instruction::tests::to_u16_sequence::or::reg_reg ... ok
Nov 16 23:47:06.034 INFO [stdout] test instruction::tests::to_u16_sequence::out::lit ... ok
Nov 16 23:47:06.034 INFO [stdout] test instruction::tests::to_u16_sequence::out::reg ... ok
Nov 16 23:47:06.034 INFO [stdout] test instruction::tests::to_u16_sequence::pop::reg ... ok
Nov 16 23:47:06.034 INFO [stdout] test instruction::tests::to_u16_sequence::push::lit ... ok
Nov 16 23:47:06.034 INFO [stdout] test instruction::tests::to_u16_sequence::push::reg ... ok
Nov 16 23:47:06.034 INFO [stdout] test instruction::tests::to_u16_sequence::ret::ret ... ok
Nov 16 23:47:06.035 INFO [stdout] test instruction::tests::to_u16_sequence::rmem::lit ... ok
Nov 16 23:47:06.035 INFO [stdout] test instruction::tests::to_u16_sequence::rmem::reg ... ok
Nov 16 23:47:06.035 INFO [stdout] test instruction::tests::to_u16_sequence::set::lit ... ok
Nov 16 23:47:06.035 INFO [stdout] test instruction::tests::to_u16_sequence::set::reg ... ok
Nov 16 23:47:06.035 INFO [stdout] test instruction::tests::to_u16_sequence::wmem::lit_lit ... ok
Nov 16 23:47:06.036 INFO [stdout] test instruction::tests::to_u16_sequence::wmem::lit_reg ... ok
Nov 16 23:47:06.036 INFO [stdout] test instruction::tests::to_u16_sequence::wmem::reg_lit ... ok
Nov 16 23:47:06.036 INFO [stdout] test instruction::tests::to_u16_sequence::wmem::reg_reg ... ok
Nov 16 23:47:06.036 INFO [stdout] test register::tests::new ... ok
Nov 16 23:47:06.038 INFO [stdout] test instruction::tests::to_u16_sequence::jt::lit_reg ... ok
Nov 16 23:47:06.038 INFO [stdout] test instruction::tests::to_u16_sequence::jt::lit_lit ... ok
Nov 16 23:47:06.038 INFO [stdout] test instruction::tests::to_u16_sequence::jmp::reg ... ok
Nov 16 23:47:06.038 INFO [stdout] test instruction::tests::to_u16_sequence::jmp::lit ... ok
Nov 16 23:47:06.038 INFO [stdout] test instruction::tests::to_u16_sequence::jf::reg_reg ... ok
Nov 16 23:47:06.038 INFO [stdout] test u15::tests::basics::bitand ... ok
Nov 16 23:47:06.038 INFO [stdout] test instruction::tests::to_u16_sequence::gt::reg_reg ... ok
Nov 16 23:47:06.038 INFO [stdout] test u15::tests::basics::bitand_assign ... ok
Nov 16 23:47:06.038 INFO [stdout] test u15::tests::basics::bitor ... ok
Nov 16 23:47:06.038 INFO [stdout] test u15::tests::basics::bitxor ... ok
Nov 16 23:47:06.038 INFO [stdout] test u15::tests::basics::div ... ok
Nov 16 23:47:06.038 INFO [stdout] test u15::tests::basics::bitxor_assign ... ok
Nov 16 23:47:06.038 INFO [stdout] test u15::tests::basics::bitor_assign ... ok
Nov 16 23:47:06.040 INFO [stdout] test u15::tests::basics::add_assign ... ok
Nov 16 23:47:06.040 INFO [stdout] test u15::tests::basics::add ... ok
Nov 16 23:47:06.043 INFO [stdout] test u15::tests::basics::mul_assign ... ok
Nov 16 23:47:06.043 INFO [stdout] test u15::tests::basics::div_assign ... ok
Nov 16 23:47:06.043 INFO [stdout] test u15::tests::basics::mul ... ok
Nov 16 23:47:06.043 INFO [stdout] test u15::tests::basics::div_non_even_assign ... ok
Nov 16 23:47:06.043 INFO [stdout] test u15::tests::basics::rem_assign_nonzero_remainder ... ok
Nov 16 23:47:06.044 INFO [stdout] test u15::tests::basics::rem_assign ... ok
Nov 16 23:47:06.044 INFO [stdout] test u15::tests::basics::div_non_even ... ok
Nov 16 23:47:06.045 INFO [stdout] test u15::tests::basics::rem ... ok
Nov 16 23:47:06.045 INFO [stdout] test u15::tests::basics::not ... ok
Nov 16 23:47:06.047 INFO [stdout] test u15::tests::basics::shl_i16 ... ok
Nov 16 23:47:06.047 INFO [stdout] test u15::tests::basics::shl ... ok
Nov 16 23:47:06.049 INFO [stdout] test u15::tests::basics::shl_i32 ... ok
Nov 16 23:47:06.049 INFO [stdout] test u15::tests::basics::shl_i8 ... ok
Nov 16 23:47:06.049 INFO [stdout] test u15::tests::basics::rem_non_even ... ok
Nov 16 23:47:06.049 INFO [stdout] test u15::tests::basics::shl_i64 ... ok
Nov 16 23:47:06.050 INFO [stdout] test u15::tests::basics::shl_u64 ... ok
Nov 16 23:47:06.050 INFO [stdout] test u15::tests::basics::shl_u8 ... ok
Nov 16 23:47:06.050 INFO [stdout] test u15::tests::basics::shr ... ok
Nov 16 23:47:06.050 INFO [stdout] test u15::tests::basics::shl_u32 ... ok
Nov 16 23:47:06.050 INFO [stdout] test u15::tests::basics::shr_i64 ... ok
Nov 16 23:47:06.050 INFO [stdout] test u15::tests::basics::shr_i8 ... ok
Nov 16 23:47:06.050 INFO [stdout] test u15::tests::basics::shr_i32 ... ok
Nov 16 23:47:06.050 INFO [stdout] test u15::tests::basics::shr_i16 ... ok
Nov 16 23:47:06.051 INFO [stdout] test u15::tests::basics::shr_u16 ... ok
Nov 16 23:47:06.051 INFO [stdout] test u15::tests::basics::shl_u16 ... ok
Nov 16 23:47:06.051 INFO [stdout] test u15::tests::basics::shr_u32 ... ok
Nov 16 23:47:06.051 INFO [stdout] test u15::tests::basics::shr_u64 ... ok
Nov 16 23:47:06.055 INFO [stdout] test u15::tests::basics::shr_u8 ... ok
Nov 16 23:47:06.055 INFO [stdout] test u15::tests::basics::sub ... ok
Nov 16 23:47:06.055 INFO [stdout] test u15::tests::basics::sub_assign ... ok
Nov 16 23:47:06.058 INFO [stdout] test argument::tests::new_panic_on_out_of_range ... ok
Nov 16 23:47:06.062 INFO [stdout] test register::tests::new_panics_with_invalid_value ... ok
Nov 16 23:47:06.062 INFO [stdout] test u15::tests::modular_arithmetic::add_overflow ... ok
Nov 16 23:47:06.063 INFO [stdout] test u15::tests::modular_arithmetic::max_val ... ok
Nov 16 23:47:06.063 INFO [stdout] test u15::tests::modular_arithmetic::min_val ... ok
Nov 16 23:47:06.063 INFO [stdout] test u15::tests::modular_arithmetic::mul_overflow ... ok
Nov 16 23:47:06.063 INFO [stdout] test u15::tests::modular_arithmetic::not_is_15b ... ok
Nov 16 23:47:06.063 INFO [stdout] test vm::tests::instructions::add::lit_lit_nowrap ... ok
Nov 16 23:47:06.063 INFO [stdout] test vm::tests::instructions::add::lit_reg_nowrap ... ok
Nov 16 23:47:06.063 INFO [stdout] test vm::tests::instructions::add::lit_reg_wrap ... ok
Nov 16 23:47:06.063 INFO [stdout] test vm::tests::instructions::add::reg_lit_wrap ... ok
Nov 16 23:47:06.063 INFO [stdout] test vm::tests::instructions::add::reg_lit_nowrap ... ok
Nov 16 23:47:06.065 INFO [stdout] test vm::tests::instructions::add::lit_lit_wrap ... ok
Nov 16 23:47:06.066 INFO [stdout] test vm::tests::instructions::add::reg_reg_wrap ... ok
Nov 16 23:47:06.066 INFO [stdout] test vm::tests::instructions::add::reg_reg_nowrap ... ok
Nov 16 23:47:06.066 INFO [stdout] test vm::tests::instructions::and::reg_lit ... ok
Nov 16 23:47:06.066 INFO [stdout] test vm::tests::instructions::and::reg_reg ... ok
Nov 16 23:47:06.067 INFO [stdout] test vm::tests::instructions::call::lit ... ok
Nov 16 23:47:06.067 INFO [stdout] test vm::tests::instructions::and::lit_lit ... ok
Nov 16 23:47:06.068 INFO [stdout] test vm::tests::instructions::and::lit_reg ... ok
Nov 16 23:47:06.068 INFO [stdout] test vm::tests::instructions::call::reg ... ok
Nov 16 23:47:06.069 INFO [stdout] test vm::tests::instructions::eq::reg_lit ... ok
Nov 16 23:47:06.071 INFO [stdout] test vm::tests::instructions::eq::reg_reg ... ok
Nov 16 23:47:06.071 INFO [stdout] test vm::tests::instructions::eq::lit_reg ... ok
Nov 16 23:47:06.072 INFO [stdout] test vm::tests::instructions::eq::lit_lit ... ok
Nov 16 23:47:06.078 INFO [stdout] test vm::tests::instructions::gt::lit_lit_false ... ok
Nov 16 23:47:06.080 INFO [stdout] test vm::tests::instructions::gt::lit_lit_true ... ok
Nov 16 23:47:06.080 INFO [stdout] test vm::tests::instructions::gt::lit_reg ... ok
Nov 16 23:47:06.080 INFO [stdout] test vm::tests::instructions::gt::reg_lit ... ok
Nov 16 23:47:06.080 INFO [stdout] test vm::tests::instructions::jf::lit_reg ... ok
Nov 16 23:47:06.084 INFO [stdout] test vm::tests::instructions::jf::lit_lit ... ok
Nov 16 23:47:06.084 INFO [stdout] test vm::tests::instructions::jf::reg_lit ... ok
Nov 16 23:47:06.084 INFO [stdout] test vm::tests::instructions::gt::reg_reg ... ok
Nov 16 23:47:06.086 INFO [stdout] test register::tests::new_panics_with_lit_value ... ok
Nov 16 23:47:06.086 INFO [stdout] test vm::tests::instructions::jf::reg_reg ... ok
Nov 16 23:47:06.087 INFO [stdout] test u15::tests::basics::sub_panic_assign ... ok
Nov 16 23:47:06.087 INFO [stdout] test u15::tests::basics::sub_panic ... ok
Nov 16 23:47:06.087 INFO [stdout] test u15::tests::modular_arithmetic::sub_underflow ... ok
Nov 16 23:47:06.087 INFO [stdout] test u15::tests::modular_arithmetic::div_by_zero ... ok
Nov 16 23:47:06.088 INFO [stdout] test vm::tests::instructions::jump::reg ... ok
Nov 16 23:47:06.095 INFO [stdout] test vm::tests::instructions::jump::lit ... ok
Nov 16 23:47:06.096 INFO [stdout] test vm::tests::instructions::modulo::reg_lit ... ok
Nov 16 23:47:06.096 INFO [stdout] test vm::tests::instructions::jt::reg_reg ... ok
Nov 16 23:47:06.096 INFO [stdout] test vm::tests::instructions::jt::reg_lit ... ok
Nov 16 23:47:06.096 INFO [stdout] test vm::tests::instructions::modulo::lit_reg ... ok
Nov 16 23:47:06.096 INFO [stdout] test vm::tests::instructions::modulo::reg_reg ... ok
Nov 16 23:47:06.099 INFO [stdout] test vm::tests::instructions::mult::lit_lit_wrap ... ok
Nov 16 23:47:06.099 INFO [stdout] test vm::tests::instructions::mult::lit_reg_wrap ... ok
Nov 16 23:47:06.100 INFO [stdout] test vm::tests::instructions::mult::lit_lit_nowrap ... ok
Nov 16 23:47:06.100 INFO [stdout] test vm::tests::instructions::jt::lit_lit ... ok
Nov 16 23:47:06.100 INFO [stdout] test vm::tests::instructions::mult::reg_lit_nowrap ... ok
Nov 16 23:47:06.100 INFO [stdout] test vm::tests::instructions::modulo::lit_lit ... ok
Nov 16 23:47:06.101 INFO [stdout] test vm::tests::instructions::jt::lit_reg ... ok
Nov 16 23:47:06.101 INFO [stdout] test vm::tests::instructions::mult::lit_reg_nowrap ... ok
Nov 16 23:47:06.103 INFO [stdout] test vm::tests::instructions::or::lit_reg ... ok
Nov 16 23:47:06.103 INFO [stdout] test vm::tests::instructions::or::reg_lit ... ok
Nov 16 23:47:06.103 INFO [stdout] test vm::tests::instructions::not::reg ... ok
Nov 16 23:47:06.105 INFO [stdout] test vm::tests::instructions::not::lit ... ok
Nov 16 23:47:06.109 INFO [stdout] test vm::tests::instructions::pop::stack_underflow_error ... ok
Nov 16 23:47:06.109 INFO [stdout] test vm::tests::instructions::mult::reg_reg_wrap ... ok
Nov 16 23:47:06.109 INFO [stdout] test vm::tests::instructions::mult::reg_reg_nowrap ... ok
Nov 16 23:47:06.109 INFO [stdout] test vm::tests::instructions::or::reg_reg ... ok
Nov 16 23:47:06.109 INFO [stdout] test vm::tests::instructions::push::reg ... ok
Nov 16 23:47:06.109 INFO [stdout] test vm::tests::instructions::mult::reg_lit_wrap ... ok
Nov 16 23:47:06.109 INFO [stdout] test vm::tests::instructions::or::lit_lit ... ok
Nov 16 23:47:06.111 INFO [stdout] test vm::tests::instructions::pop::happy ... ok
Nov 16 23:47:06.111 INFO [stdout] test vm::tests::instructions::pop::nonempty_remaining_stack ... ok
Nov 16 23:47:06.111 INFO [stdout] test vm::tests::instructions::wmem::lit_lit ... ok
Nov 16 23:47:06.111 INFO [stdout] test vm::tests::instructions::ret::lit ... ok
Nov 16 23:47:06.111 INFO [stdout] test vm::tests::instructions::ret::reg ... ok
Nov 16 23:47:06.123 INFO [stdout] test vm::tests::instructions::wmem::lit_reg ... ok
Nov 16 23:47:06.123 INFO [stdout] test vm::tests::instructions::set::reg ... ok
Nov 16 23:47:06.123 INFO [stdout] test vm::tests::instructions::rmem::lit ... ok
Nov 16 23:47:06.128 INFO [stdout] test vm::tests::instructions::push::lit ... ok
Nov 16 23:47:06.128 INFO [stdout] test vm::tests::load_program::valid_program_load ... ok
Nov 16 23:47:06.128 INFO [stdout] test vm::tests::instructions::set::lit ... ok
Nov 16 23:47:06.128 INFO [stdout] test vm::tests::instructions::rmem::reg ... ok
Nov 16 23:47:06.128 INFO [stdout] test vm::tests::step::advance ... ok
Nov 16 23:47:06.128 INFO [stdout] test vm::tests::instructions::wmem::reg_reg ... ok
Nov 16 23:47:06.128 INFO [stdout] test vm::tests::step::current_instruction_happy ... ok
Nov 16 23:47:06.131 INFO [stdout] test vm::tests::step::read_memory_happy ... ok
Nov 16 23:47:06.132 INFO [stdout] test vm::tests::step::current_instruction_malformed ... ok
Nov 16 23:47:06.132 INFO [stdout] test vm::tests::step::step ... ok
Nov 16 23:47:06.132 INFO [stdout] test vm::tests::step::read_memory_invalid ... ok
Nov 16 23:47:06.139 INFO [stdout] test vm::tests::step::current_instruction_bad_opcode ... ok
Nov 16 23:47:06.139 INFO [stderr]      Running /target/debug/deps/syn_asm-b78f66ee86696502
Nov 16 23:47:06.139 INFO [stdout] 
Nov 16 23:47:06.139 INFO [stdout] test result: ok. 312 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 23:47:06.139 INFO [stdout] 
Nov 16 23:47:06.143 INFO [stdout] 
Nov 16 23:47:06.143 INFO [stderr]      Running /target/debug/deps/syn_dis-dc21dad6af271f55
Nov 16 23:47:06.143 INFO [stdout] running 0 tests
Nov 16 23:47:06.143 INFO [stderr]      Running /target/debug/deps/syn_vm-65c1bfe5dfa4854c
Nov 16 23:47:06.143 INFO [stdout] 
Nov 16 23:47:06.143 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 23:47:06.143 INFO [stdout] 
Nov 16 23:47:06.143 INFO [stdout] 
Nov 16 23:47:06.143 INFO [stdout] running 0 tests
Nov 16 23:47:06.143 INFO [stdout] 
Nov 16 23:47:06.143 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 23:47:06.143 INFO [stdout] 
Nov 16 23:47:06.145 INFO [stdout] 
Nov 16 23:47:06.145 INFO [stderr]    Doc-tests synacor
Nov 16 23:47:06.145 INFO [stdout] running 0 tests
Nov 16 23:47:06.145 INFO [stdout] 
Nov 16 23:47:06.145 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 23:47:06.145 INFO [stdout] 
Nov 16 23:47:06.533 INFO [stdout] 
Nov 16 23:47:06.533 INFO [stdout] running 0 tests
Nov 16 23:47:06.533 INFO [stdout] 
Nov 16 23:47:06.533 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 23:47:06.533 INFO [stdout] 
Nov 16 23:47:06.544 INFO [stderr] su: No module specific data is present
Nov 16 23:47:06.804 INFO running `"docker" "inspect" "a86bdfc0bda9177df9250ce094a454794e8bac237e0b82cf740f03c46126f710"`
Nov 16 23:47:06.919 INFO running `"docker" "rm" "-f" "a86bdfc0bda9177df9250ce094a454794e8bac237e0b82cf740f03c46126f710"`
Nov 16 23:47:07.046 INFO [stdout] a86bdfc0bda9177df9250ce094a454794e8bac237e0b82cf740f03c46126f710