Dec 13 15:38:09.290 INFO testing jfredett/synacor against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 13 15:38:09.290 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 13 15:38:09.495 INFO [stdout] 18910d1ee7ba9c0dc333817d756ed1dd4533d2480b94c1841aa5a7b764293b5c
Dec 13 15:38:09.497 INFO running `"docker" "start" "-a" "18910d1ee7ba9c0dc333817d756ed1dd4533d2480b94c1841aa5a7b764293b5c"`
Dec 13 15:38:10.108 INFO [stderr] usermod: no changes
Dec 13 15:38:10.219 INFO [stderr]    Compiling synacor v0.1.0 (/source)
Dec 13 15:38:10.947 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 13 15:38:10.947 INFO [stderr]    --> src/vm.rs:186:9
Dec 13 15:38:10.947 INFO [stderr]     |
Dec 13 15:38:10.947 INFO [stderr] 186 |         stdin.read_exact(&mut buf);
Dec 13 15:38:10.947 INFO [stderr]     |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 15:38:10.947 INFO [stderr]     |
Dec 13 15:38:10.947 INFO [stderr]     = note: #[warn(unused_must_use)] on by default
Dec 13 15:38:10.947 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Dec 13 15:38:10.947 INFO [stderr] 
Dec 13 15:38:13.972 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.84s
Dec 13 15:38:13.982 INFO [stderr] su: No module specific data is present
Dec 13 15:38:14.579 INFO running `"docker" "inspect" "18910d1ee7ba9c0dc333817d756ed1dd4533d2480b94c1841aa5a7b764293b5c"`
Dec 13 15:38:14.791 INFO running `"docker" "rm" "-f" "18910d1ee7ba9c0dc333817d756ed1dd4533d2480b94c1841aa5a7b764293b5c"`
Dec 13 15:38:14.951 INFO [stdout] 18910d1ee7ba9c0dc333817d756ed1dd4533d2480b94c1841aa5a7b764293b5c
Dec 13 15:38:14.956 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 13 15:38:15.231 INFO [stdout] baf41d1c7721be855641ee051ea7a412bab965900540d94759384dc7405a7277
Dec 13 15:38:15.233 INFO running `"docker" "start" "-a" "baf41d1c7721be855641ee051ea7a412bab965900540d94759384dc7405a7277"`
Dec 13 15:38:15.789 INFO [stderr] usermod: no changes
Dec 13 15:38:15.850 INFO [stderr]    Compiling synacor v0.1.0 (/source)
Dec 13 15:38:18.675 INFO [stderr] warning: unused arithmetic operation that must be used
Dec 13 15:38:18.675 INFO [stderr]    --> src/u15.rs:163:30
Dec 13 15:38:18.675 INFO [stderr]     |
Dec 13 15:38:18.675 INFO [stderr] 163 |         fn sub_underflow() { u15(0) - u15(2); }
Dec 13 15:38:18.675 INFO [stderr]     |                              ^^^^^^^^^^^^^^^
Dec 13 15:38:18.675 INFO [stderr]     |
Dec 13 15:38:18.675 INFO [stderr]     = note: #[warn(unused_must_use)] on by default
Dec 13 15:38:18.675 INFO [stderr] 
Dec 13 15:38:18.675 INFO [stderr] warning: unused arithmetic operation that must be used
Dec 13 15:38:18.675 INFO [stderr]    --> src/u15.rs:167:28
Dec 13 15:38:18.675 INFO [stderr]     |
Dec 13 15:38:18.675 INFO [stderr] 167 |         fn div_by_zero() { u15(1) / u15(0); }
Dec 13 15:38:18.675 INFO [stderr]     |                            ^^^^^^^^^^^^^^^
Dec 13 15:38:18.675 INFO [stderr] 
Dec 13 15:38:18.675 INFO [stderr] warning: unused arithmetic operation that must be used
Dec 13 15:38:18.675 INFO [stderr]    --> src/u15.rs:223:26
Dec 13 15:38:18.675 INFO [stderr]     |
Dec 13 15:38:18.675 INFO [stderr] 223 |         fn sub_panic() { u15(16) - u15(17); }
Dec 13 15:38:18.675 INFO [stderr]     |                          ^^^^^^^^^^^^^^^^^
Dec 13 15:38:18.675 INFO [stderr] 
Dec 13 15:38:18.735 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 13 15:38:18.735 INFO [stderr]    --> src/vm.rs:186:9
Dec 13 15:38:18.735 INFO [stderr]     |
Dec 13 15:38:18.735 INFO [stderr] 186 |         stdin.read_exact(&mut buf);
Dec 13 15:38:18.735 INFO [stderr]     |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 15:38:18.735 INFO [stderr]     |
Dec 13 15:38:18.735 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Dec 13 15:38:18.735 INFO [stderr] 
Dec 13 15:38:20.879 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 5.07s
Dec 13 15:38:20.891 INFO [stderr] su: No module specific data is present
Dec 13 15:38:21.685 INFO running `"docker" "inspect" "baf41d1c7721be855641ee051ea7a412bab965900540d94759384dc7405a7277"`
Dec 13 15:38:21.983 INFO running `"docker" "rm" "-f" "baf41d1c7721be855641ee051ea7a412bab965900540d94759384dc7405a7277"`
Dec 13 15:38:22.295 INFO [stdout] baf41d1c7721be855641ee051ea7a412bab965900540d94759384dc7405a7277
Dec 13 15:38:22.303 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 13 15:38:22.740 INFO [stdout] c013e32eaca75deeb6cc4c2eacdcdde3c74225f4b644868e219c88b6298529b1
Dec 13 15:38:22.749 INFO running `"docker" "start" "-a" "c013e32eaca75deeb6cc4c2eacdcdde3c74225f4b644868e219c88b6298529b1"`
Dec 13 15:38:23.699 INFO [stderr] usermod: no changes
Dec 13 15:38:23.742 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.03s
Dec 13 15:38:23.743 INFO [stderr]      Running /target/debug/deps/synacor-67dcc0bd5e8fd2e5
Dec 13 15:38:23.745 INFO [stdout] 
Dec 13 15:38:23.745 INFO [stdout] running 312 tests
Dec 13 15:38:23.745 INFO [stdout] test address::tests::invalid ... ok
Dec 13 15:38:23.745 INFO [stdout] test address::tests::next ... ok
Dec 13 15:38:23.745 INFO [stdout] test address::tests::register_none ... ok
Dec 13 15:38:23.745 INFO [stdout] test address::tests::register_some ... ok
Dec 13 15:38:23.745 INFO [stdout] test address::tests::valid ... ok
Dec 13 15:38:23.745 INFO [stdout] test argument::tests::new_lit ... ok
Dec 13 15:38:23.745 INFO [stdout] test argument::tests::new_reg ... ok
Dec 13 15:38:23.745 INFO [stdout] test instruction::tests::display::add::lit_lit ... ok
Dec 13 15:38:23.746 INFO [stdout] test instruction::tests::display::add::lit_reg ... ok
Dec 13 15:38:23.746 INFO [stdout] test instruction::tests::display::and::lit_lit ... ok
Dec 13 15:38:23.746 INFO [stdout] test instruction::tests::display::and::reg_lit ... ok
Dec 13 15:38:23.746 INFO [stdout] test instruction::tests::display::add::reg_lit ... ok
Dec 13 15:38:23.746 INFO [stdout] test instruction::tests::display::add::reg_reg ... ok
Dec 13 15:38:23.746 INFO [stdout] test instruction::tests::display::and::reg_reg ... ok
Dec 13 15:38:23.747 INFO [stdout] test instruction::tests::display::and::lit_reg ... ok
Dec 13 15:38:23.747 INFO [stdout] test instruction::tests::display::call::lit ... ok
Dec 13 15:38:23.747 INFO [stdout] test instruction::tests::display::eq::reg_lit ... ok
Dec 13 15:38:23.747 INFO [stdout] test instruction::tests::display::eq::lit_lit ... ok
Dec 13 15:38:23.747 INFO [stdout] test instruction::tests::display::call::reg ... ok
Dec 13 15:38:23.748 INFO [stdout] test instruction::tests::display::gt::reg_lit ... ok
Dec 13 15:38:23.748 INFO [stdout] test instruction::tests::display::gt::reg_reg ... ok
Dec 13 15:38:23.748 INFO [stdout] test instruction::tests::display::gt::lit_lit ... ok
Dec 13 15:38:23.748 INFO [stdout] test instruction::tests::display::eq::reg_reg ... ok
Dec 13 15:38:23.748 INFO [stdout] test instruction::tests::display::in_val::lit ... ok
Dec 13 15:38:23.748 INFO [stdout] test instruction::tests::display::jf::lit_lit ... ok
Dec 13 15:38:23.748 INFO [stdout] test instruction::tests::display::jf::lit_reg ... ok
Dec 13 15:38:23.748 INFO [stdout] test instruction::tests::display::jf::reg_reg ... ok
Dec 13 15:38:23.748 INFO [stdout] test instruction::tests::display::jmp::lit ... ok
Dec 13 15:38:23.748 INFO [stdout] test instruction::tests::display::jmp::reg ... ok
Dec 13 15:38:23.748 INFO [stdout] test instruction::tests::display::jt::lit_lit ... ok
Dec 13 15:38:23.748 INFO [stdout] test instruction::tests::display::jt::lit_reg ... ok
Dec 13 15:38:23.748 INFO [stdout] test instruction::tests::display::jt::reg_reg ... ok
Dec 13 15:38:23.748 INFO [stdout] test instruction::tests::display::modulo::lit_lit ... ok
Dec 13 15:38:23.748 INFO [stdout] test instruction::tests::display::in_val::reg ... ok
Dec 13 15:38:23.748 INFO [stdout] test instruction::tests::display::jt::reg_lit ... ok
Dec 13 15:38:23.748 INFO [stdout] test instruction::tests::display::halt::test ... ok
Dec 13 15:38:23.748 INFO [stdout] test instruction::tests::display::modulo::lit_reg ... ok
Dec 13 15:38:23.748 INFO [stdout] test instruction::tests::display::modulo::reg_reg ... ok
Dec 13 15:38:23.748 INFO [stdout] test instruction::tests::display::mult::lit_lit ... ok
Dec 13 15:38:23.748 INFO [stdout] test instruction::tests::display::mult::lit_reg ... ok
Dec 13 15:38:23.748 INFO [stdout] test instruction::tests::display::modulo::reg_lit ... ok
Dec 13 15:38:23.749 INFO [stdout] test instruction::tests::display::not::lit ... ok
Dec 13 15:38:23.749 INFO [stdout] test instruction::tests::display::mult::reg_reg ... ok
Dec 13 15:38:23.749 INFO [stdout] test instruction::tests::display::noop::test ... ok
Dec 13 15:38:23.749 INFO [stdout] test instruction::tests::display::not::reg ... ok
Dec 13 15:38:23.749 INFO [stdout] test instruction::tests::display::mult::reg_lit ... ok
Dec 13 15:38:23.749 INFO [stdout] test instruction::tests::display::or::lit_lit ... ok
Dec 13 15:38:23.749 INFO [stdout] test instruction::tests::display::or::lit_reg ... ok
Dec 13 15:38:23.749 INFO [stdout] test instruction::tests::display::out::reg ... ok
Dec 13 15:38:23.749 INFO [stdout] test instruction::tests::display::out::lit ... ok
Dec 13 15:38:23.751 INFO [stdout] test instruction::tests::display::or::reg_reg ... ok
Dec 13 15:38:23.751 INFO [stdout] test instruction::tests::display::or::reg_lit ... ok
Dec 13 15:38:23.751 INFO [stdout] test instruction::tests::display::pop::reg ... ok
Dec 13 15:38:23.751 INFO [stdout] test instruction::tests::display::ret::test ... ok
Dec 13 15:38:23.751 INFO [stdout] test instruction::tests::display::push::reg ... ok
Dec 13 15:38:23.751 INFO [stdout] test instruction::tests::display::rmem::lit ... ok
Dec 13 15:38:23.751 INFO [stdout] test instruction::tests::display::set::reg ... ok
Dec 13 15:38:23.751 INFO [stdout] test instruction::tests::display::set::lit ... ok
Dec 13 15:38:23.751 INFO [stdout] test instruction::tests::display::rmem::reg ... ok
Dec 13 15:38:23.751 INFO [stdout] test instruction::tests::display::wmem::lit_reg ... ok
Dec 13 15:38:23.751 INFO [stdout] test instruction::tests::display::wmem::reg_lit ... ok
Dec 13 15:38:23.752 INFO [stdout] test instruction::tests::display::wmem::lit_lit ... ok
Dec 13 15:38:23.752 INFO [stdout] test instruction::tests::display::wmem::reg_reg ... ok
Dec 13 15:38:23.752 INFO [stdout] test instruction::tests::from_u16_sequence::add::lit_reg ... ok
Dec 13 15:38:23.752 INFO [stdout] test instruction::tests::from_u16_sequence::add::lit_lit ... ok
Dec 13 15:38:23.752 INFO [stdout] test instruction::tests::from_u16_sequence::add::reg_lit ... ok
Dec 13 15:38:23.752 INFO [stdout] test instruction::tests::from_u16_sequence::add::reg_reg ... ok
Dec 13 15:38:23.752 INFO [stdout] test instruction::tests::from_u16_sequence::and::reg_lit ... ok
Dec 13 15:38:23.752 INFO [stdout] test instruction::tests::from_u16_sequence::and::lit_reg ... ok
Dec 13 15:38:23.752 INFO [stdout] test instruction::tests::from_u16_sequence::call::lit ... ok
Dec 13 15:38:23.752 INFO [stdout] test instruction::tests::from_u16_sequence::and::reg_reg ... ok
Dec 13 15:38:23.752 INFO [stdout] test instruction::tests::from_u16_sequence::and::lit_lit ... ok
Dec 13 15:38:23.752 INFO [stdout] test instruction::tests::from_u16_sequence::call::reg ... ok
Dec 13 15:38:23.752 INFO [stdout] test instruction::tests::from_u16_sequence::eq::lit_reg ... ok
Dec 13 15:38:23.753 INFO [stdout] test instruction::tests::from_u16_sequence::eq::reg_reg ... ok
Dec 13 15:38:23.753 INFO [stdout] test instruction::tests::from_u16_sequence::gt::lit_lit ... ok
Dec 13 15:38:23.754 INFO [stdout] test instruction::tests::from_u16_sequence::gt::lit_reg ... ok
Dec 13 15:38:23.756 INFO [stdout] test instruction::tests::display::push::lit ... ok
Dec 13 15:38:23.756 INFO [stdout] test instruction::tests::from_u16_sequence::eq::reg_lit ... ok
Dec 13 15:38:23.756 INFO [stdout] test instruction::tests::display::jf::reg_lit ... ok
Dec 13 15:38:23.756 INFO [stdout] test instruction::tests::from_u16_sequence::eq::lit_lit ... ok
Dec 13 15:38:23.756 INFO [stdout] test instruction::tests::display::eq::lit_reg ... ok
Dec 13 15:38:23.756 INFO [stdout] test instruction::tests::from_u16_sequence::gt::reg_reg ... ok
Dec 13 15:38:23.756 INFO [stdout] test instruction::tests::from_u16_sequence::halt::halt ... ok
Dec 13 15:38:23.756 INFO [stdout] test instruction::tests::from_u16_sequence::in_val::lit ... ok
Dec 13 15:38:23.756 INFO [stdout] test instruction::tests::from_u16_sequence::gt::reg_lit ... ok
Dec 13 15:38:23.756 INFO [stdout] test instruction::tests::from_u16_sequence::in_val::reg ... ok
Dec 13 15:38:23.756 INFO [stdout] test instruction::tests::from_u16_sequence::jf::reg_lit ... ok
Dec 13 15:38:23.756 INFO [stdout] test instruction::tests::from_u16_sequence::jf::reg_reg ... ok
Dec 13 15:38:23.756 INFO [stdout] test instruction::tests::from_u16_sequence::jt::lit_reg ... ok
Dec 13 15:38:23.756 INFO [stdout] test instruction::tests::from_u16_sequence::jt::lit_lit ... ok
Dec 13 15:38:23.756 INFO [stdout] test instruction::tests::from_u16_sequence::jmp::reg ... ok
Dec 13 15:38:23.756 INFO [stdout] test instruction::tests::from_u16_sequence::jmp::lit ... ok
Dec 13 15:38:23.756 INFO [stdout] test instruction::tests::from_u16_sequence::jf::lit_lit ... ok
Dec 13 15:38:23.756 INFO [stdout] test instruction::tests::from_u16_sequence::jf::lit_reg ... ok
Dec 13 15:38:23.756 INFO [stdout] test instruction::tests::from_u16_sequence::jt::reg_lit ... ok
Dec 13 15:38:23.756 INFO [stdout] test instruction::tests::from_u16_sequence::modulo::reg_lit ... ok
Dec 13 15:38:23.756 INFO [stdout] test instruction::tests::from_u16_sequence::modulo::reg_reg ... ok
Dec 13 15:38:23.756 INFO [stdout] test instruction::tests::from_u16_sequence::mult::reg_lit ... ok
Dec 13 15:38:23.757 INFO [stdout] test instruction::tests::from_u16_sequence::modulo::lit_lit ... ok
Dec 13 15:38:23.757 INFO [stdout] test instruction::tests::from_u16_sequence::jt::reg_reg ... ok
Dec 13 15:38:23.757 INFO [stdout] test instruction::tests::from_u16_sequence::mult::lit_reg ... ok
Dec 13 15:38:23.757 INFO [stdout] test instruction::tests::from_u16_sequence::modulo::lit_reg ... ok
Dec 13 15:38:23.757 INFO [stdout] test instruction::tests::from_u16_sequence::mult::reg_reg ... ok
Dec 13 15:38:23.757 INFO [stdout] test instruction::tests::from_u16_sequence::noop::noop ... ok
Dec 13 15:38:23.757 INFO [stdout] test instruction::tests::from_u16_sequence::not::lit ... ok
Dec 13 15:38:23.757 INFO [stdout] test instruction::tests::from_u16_sequence::not::reg ... ok
Dec 13 15:38:23.757 INFO [stdout] test instruction::tests::from_u16_sequence::mult::lit_lit ... ok
Dec 13 15:38:23.757 INFO [stdout] test instruction::tests::from_u16_sequence::or::lit_lit ... ok
Dec 13 15:38:23.757 INFO [stdout] test instruction::tests::from_u16_sequence::or::reg_reg ... ok
Dec 13 15:38:23.757 INFO [stdout] test instruction::tests::from_u16_sequence::or::lit_reg ... ok
Dec 13 15:38:23.757 INFO [stdout] test instruction::tests::from_u16_sequence::pop::reg ... ok
Dec 13 15:38:23.757 INFO [stdout] test instruction::tests::from_u16_sequence::or::reg_lit ... ok
Dec 13 15:38:23.757 INFO [stdout] test instruction::tests::from_u16_sequence::push::reg ... ok
Dec 13 15:38:23.759 INFO [stdout] test instruction::tests::from_u16_sequence::out::lit ... ok
Dec 13 15:38:23.759 INFO [stdout] test instruction::tests::from_u16_sequence::out::reg ... ok
Dec 13 15:38:23.759 INFO [stdout] test instruction::tests::from_u16_sequence::ret::ret ... ok
Dec 13 15:38:23.759 INFO [stdout] test instruction::tests::from_u16_sequence::rmem::lit ... ok
Dec 13 15:38:23.759 INFO [stdout] test instruction::tests::from_u16_sequence::push::lit ... ok
Dec 13 15:38:23.759 INFO [stdout] test instruction::tests::display::gt::lit_reg ... ok
Dec 13 15:38:23.761 INFO [stdout] test instruction::tests::from_u16_sequence::set::reg ... ok
Dec 13 15:38:23.761 INFO [stdout] test instruction::tests::from_u16_sequence::wmem::lit_reg ... ok
Dec 13 15:38:23.761 INFO [stdout] test instruction::tests::from_u16_sequence::wmem::reg_reg ... ok
Dec 13 15:38:23.761 INFO [stdout] test instruction::tests::from_u16_sequence::wmem::reg_lit ... ok
Dec 13 15:38:23.761 INFO [stdout] test instruction::tests::to_u16_sequence::add::lit_lit ... ok
Dec 13 15:38:23.761 INFO [stdout] test instruction::tests::from_u16_sequence::wmem::lit_lit ... ok
Dec 13 15:38:23.761 INFO [stdout] test instruction::tests::to_u16_sequence::add::lit_reg ... ok
Dec 13 15:38:23.761 INFO [stdout] test instruction::tests::to_u16_sequence::add::reg_reg ... ok
Dec 13 15:38:23.761 INFO [stdout] test instruction::tests::to_u16_sequence::add::reg_lit ... ok
Dec 13 15:38:23.761 INFO [stdout] test instruction::tests::from_u16_sequence::set::lit ... ok
Dec 13 15:38:23.762 INFO [stdout] test instruction::tests::to_u16_sequence::and::lit_lit ... ok
Dec 13 15:38:23.762 INFO [stdout] test instruction::tests::to_u16_sequence::and::reg_lit ... ok
Dec 13 15:38:23.762 INFO [stdout] test instruction::tests::to_u16_sequence::and::reg_reg ... ok
Dec 13 15:38:23.762 INFO [stdout] test instruction::tests::to_u16_sequence::call::lit ... ok
Dec 13 15:38:23.762 INFO [stdout] test instruction::tests::to_u16_sequence::call::reg ... ok
Dec 13 15:38:23.765 INFO [stdout] test instruction::tests::to_u16_sequence::eq::lit_lit ... ok
Dec 13 15:38:23.765 INFO [stdout] test instruction::tests::to_u16_sequence::eq::lit_reg ... ok
Dec 13 15:38:23.765 INFO [stdout] test instruction::tests::to_u16_sequence::gt::reg_lit ... ok
Dec 13 15:38:23.765 INFO [stdout] test instruction::tests::to_u16_sequence::gt::lit_reg ... ok
Dec 13 15:38:23.765 INFO [stdout] test instruction::tests::to_u16_sequence::gt::reg_reg ... ok
Dec 13 15:38:23.765 INFO [stdout] test instruction::tests::to_u16_sequence::halt::halt ... ok
Dec 13 15:38:23.765 INFO [stdout] test instruction::tests::to_u16_sequence::in_val::lit ... ok
Dec 13 15:38:23.765 INFO [stdout] test instruction::tests::to_u16_sequence::in_val::reg ... ok
Dec 13 15:38:23.765 INFO [stdout] test instruction::tests::to_u16_sequence::jf::lit_lit ... ok
Dec 13 15:38:23.765 INFO [stdout] test instruction::tests::to_u16_sequence::jf::lit_reg ... ok
Dec 13 15:38:23.765 INFO [stdout] test instruction::tests::to_u16_sequence::jf::reg_lit ... ok
Dec 13 15:38:23.765 INFO [stdout] test instruction::tests::to_u16_sequence::jf::reg_reg ... ok
Dec 13 15:38:23.812 INFO [stdout] test instruction::tests::to_u16_sequence::jmp::lit ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::jmp::reg ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::jt::lit_reg ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::jt::reg_lit ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::jt::lit_lit ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::jt::reg_reg ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::modulo::lit_lit ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::modulo::lit_reg ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::modulo::reg_lit ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::modulo::reg_reg ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::mult::lit_lit ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::mult::lit_reg ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::mult::reg_lit ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::mult::reg_reg ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::noop::noop ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::not::lit ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::not::reg ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::or::lit_lit ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::or::lit_reg ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::or::reg_lit ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::or::reg_reg ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::out::lit ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::out::reg ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::pop::reg ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::push::lit ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::push::reg ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::ret::ret ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::rmem::reg ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::and::lit_reg ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::set::reg ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::wmem::lit_lit ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::wmem::lit_reg ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::wmem::reg_lit ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::wmem::reg_reg ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::from_u16_sequence::rmem::reg ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::set::lit ... ok
Dec 13 15:38:23.813 INFO [stdout] test register::tests::new ... ok
Dec 13 15:38:23.813 INFO [stdout] test u15::tests::basics::add ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::eq::reg_lit ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::eq::reg_reg ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::gt::lit_lit ... ok
Dec 13 15:38:23.813 INFO [stdout] test u15::tests::basics::bitand_assign ... ok
Dec 13 15:38:23.813 INFO [stdout] test u15::tests::basics::bitor ... ok
Dec 13 15:38:23.813 INFO [stdout] test u15::tests::basics::bitor_assign ... ok
Dec 13 15:38:23.813 INFO [stdout] test u15::tests::basics::bitxor ... ok
Dec 13 15:38:23.813 INFO [stdout] test u15::tests::basics::bitxor_assign ... ok
Dec 13 15:38:23.813 INFO [stdout] test u15::tests::basics::bitand ... ok
Dec 13 15:38:23.813 INFO [stdout] test instruction::tests::to_u16_sequence::rmem::lit ... ok
Dec 13 15:38:23.813 INFO [stdout] test u15::tests::basics::add_assign ... ok
Dec 13 15:38:23.813 INFO [stdout] test u15::tests::basics::div_non_even ... ok
Dec 13 15:38:23.813 INFO [stdout] test u15::tests::basics::mul ... ok
Dec 13 15:38:23.813 INFO [stdout] test u15::tests::basics::not ... ok
Dec 13 15:38:23.813 INFO [stdout] test u15::tests::basics::div_non_even_assign ... ok
Dec 13 15:38:23.813 INFO [stdout] test u15::tests::basics::div_assign ... ok
Dec 13 15:38:23.813 INFO [stdout] test u15::tests::basics::mul_assign ... ok
Dec 13 15:38:23.813 INFO [stdout] test u15::tests::basics::div ... ok
Dec 13 15:38:23.813 INFO [stdout] test u15::tests::basics::rem ... ok
Dec 13 15:38:23.814 INFO [stdout] test u15::tests::basics::rem_assign ... ok
Dec 13 15:38:23.814 INFO [stdout] test u15::tests::basics::rem_assign_nonzero_remainder ... ok
Dec 13 15:38:23.814 INFO [stdout] test u15::tests::basics::rem_non_even ... ok
Dec 13 15:38:23.814 INFO [stdout] test u15::tests::basics::shl ... ok
Dec 13 15:38:23.814 INFO [stdout] test u15::tests::basics::shl_i16 ... ok
Dec 13 15:38:23.814 INFO [stdout] test u15::tests::basics::shl_i32 ... ok
Dec 13 15:38:23.814 INFO [stdout] test u15::tests::basics::shl_i64 ... ok
Dec 13 15:38:23.814 INFO [stdout] test u15::tests::basics::shl_i8 ... ok
Dec 13 15:38:23.814 INFO [stdout] test u15::tests::basics::shl_u16 ... ok
Dec 13 15:38:23.814 INFO [stdout] test u15::tests::basics::shl_u64 ... ok
Dec 13 15:38:23.814 INFO [stdout] test u15::tests::basics::shl_u32 ... ok
Dec 13 15:38:23.814 INFO [stdout] test u15::tests::basics::shr ... ok
Dec 13 15:38:23.814 INFO [stdout] test u15::tests::basics::shr_i16 ... ok
Dec 13 15:38:23.814 INFO [stdout] test u15::tests::basics::shr_i32 ... ok
Dec 13 15:38:23.814 INFO [stdout] test u15::tests::basics::shr_i64 ... ok
Dec 13 15:38:23.814 INFO [stdout] test u15::tests::basics::shr_i8 ... ok
Dec 13 15:38:23.814 INFO [stdout] test u15::tests::basics::shr_u16 ... ok
Dec 13 15:38:23.814 INFO [stdout] test u15::tests::basics::shr_u32 ... ok
Dec 13 15:38:23.814 INFO [stdout] test u15::tests::basics::shr_u64 ... ok
Dec 13 15:38:23.814 INFO [stdout] test u15::tests::basics::shr_u8 ... ok
Dec 13 15:38:23.814 INFO [stdout] test u15::tests::basics::sub_assign ... ok
Dec 13 15:38:23.814 INFO [stdout] test u15::tests::basics::sub ... ok
Dec 13 15:38:23.814 INFO [stdout] test u15::tests::basics::shl_u8 ... ok
Dec 13 15:38:23.814 INFO [stdout] test u15::tests::modular_arithmetic::max_val ... ok
Dec 13 15:38:23.814 INFO [stdout] test u15::tests::modular_arithmetic::add_overflow ... ok
Dec 13 15:38:23.814 INFO [stdout] test u15::tests::modular_arithmetic::mul_overflow ... ok
Dec 13 15:38:23.814 INFO [stdout] test u15::tests::modular_arithmetic::min_val ... ok
Dec 13 15:38:23.814 INFO [stdout] test u15::tests::modular_arithmetic::not_is_15b ... ok
Dec 13 15:38:23.814 INFO [stdout] test vm::tests::instructions::add::lit_lit_nowrap ... ok
Dec 13 15:38:23.814 INFO [stdout] test vm::tests::instructions::add::lit_lit_wrap ... ok
Dec 13 15:38:23.814 INFO [stdout] test vm::tests::instructions::add::lit_reg_nowrap ... ok
Dec 13 15:38:23.814 INFO [stdout] test vm::tests::instructions::add::lit_reg_wrap ... ok
Dec 13 15:38:23.814 INFO [stdout] test argument::tests::new_panic_on_out_of_range ... ok
Dec 13 15:38:23.814 INFO [stdout] test vm::tests::instructions::add::reg_lit_wrap ... ok
Dec 13 15:38:23.814 INFO [stdout] test vm::tests::instructions::add::reg_lit_nowrap ... ok
Dec 13 15:38:23.814 INFO [stdout] test vm::tests::instructions::add::reg_reg_wrap ... ok
Dec 13 15:38:23.814 INFO [stdout] test vm::tests::instructions::add::reg_reg_nowrap ... ok
Dec 13 15:38:23.814 INFO [stdout] test vm::tests::instructions::and::lit_lit ... ok
Dec 13 15:38:23.814 INFO [stdout] test vm::tests::instructions::and::lit_reg ... ok
Dec 13 15:38:23.814 INFO [stdout] test vm::tests::instructions::and::reg_lit ... ok
Dec 13 15:38:23.814 INFO [stdout] test vm::tests::instructions::and::reg_reg ... ok
Dec 13 15:38:23.814 INFO [stdout] test vm::tests::instructions::call::reg ... ok
Dec 13 15:38:23.814 INFO [stdout] test vm::tests::instructions::call::lit ... ok
Dec 13 15:38:23.814 INFO [stdout] test vm::tests::instructions::eq::lit_lit ... ok
Dec 13 15:38:23.814 INFO [stdout] test vm::tests::instructions::eq::reg_lit ... ok
Dec 13 15:38:23.814 INFO [stdout] test vm::tests::instructions::eq::reg_reg ... ok
Dec 13 15:38:23.814 INFO [stdout] test vm::tests::instructions::gt::lit_lit_false ... ok
Dec 13 15:38:23.814 INFO [stdout] test vm::tests::instructions::gt::lit_lit_true ... ok
Dec 13 15:38:23.814 INFO [stdout] test vm::tests::instructions::gt::lit_reg ... ok
Dec 13 15:38:23.814 INFO [stdout] test vm::tests::instructions::gt::reg_lit ... ok
Dec 13 15:38:23.814 INFO [stdout] test vm::tests::instructions::gt::reg_reg ... ok
Dec 13 15:38:23.814 INFO [stdout] test vm::tests::instructions::jf::lit_lit ... ok
Dec 13 15:38:23.814 INFO [stdout] test vm::tests::instructions::jf::lit_reg ... ok
Dec 13 15:38:23.814 INFO [stdout] test vm::tests::instructions::jf::reg_lit ... ok
Dec 13 15:38:23.814 INFO [stdout] test vm::tests::instructions::jf::reg_reg ... ok
Dec 13 15:38:23.814 INFO [stdout] test vm::tests::instructions::jt::lit_lit ... ok
Dec 13 15:38:23.814 INFO [stdout] test vm::tests::instructions::jt::lit_reg ... ok
Dec 13 15:38:23.814 INFO [stdout] test vm::tests::instructions::jt::reg_lit ... ok
Dec 13 15:38:23.814 INFO [stdout] test vm::tests::instructions::eq::lit_reg ... ok
Dec 13 15:38:23.814 INFO [stdout] test vm::tests::instructions::jt::reg_reg ... ok
Dec 13 15:38:23.814 INFO [stdout] test register::tests::new_panics_with_lit_value ... ok
Dec 13 15:38:23.815 INFO [stdout] test vm::tests::instructions::jump::lit ... ok
Dec 13 15:38:23.815 INFO [stdout] test register::tests::new_panics_with_invalid_value ... ok
Dec 13 15:38:23.815 INFO [stdout] test vm::tests::instructions::modulo::lit_reg ... ok
Dec 13 15:38:23.816 INFO [stdout] test vm::tests::instructions::modulo::reg_lit ... ok
Dec 13 15:38:23.817 INFO [stdout] test u15::tests::basics::sub_panic ... ok
Dec 13 15:38:23.817 INFO [stdout] test vm::tests::instructions::modulo::reg_reg ... ok
Dec 13 15:38:23.817 INFO [stdout] test u15::tests::basics::sub_panic_assign ... ok
Dec 13 15:38:23.817 INFO [stdout] test u15::tests::modular_arithmetic::sub_underflow ... ok
Dec 13 15:38:23.817 INFO [stdout] test vm::tests::instructions::mult::lit_reg_nowrap ... ok
Dec 13 15:38:23.817 INFO [stdout] test u15::tests::modular_arithmetic::div_by_zero ... ok
Dec 13 15:38:23.818 INFO [stdout] test vm::tests::instructions::mult::lit_lit_nowrap ... ok
Dec 13 15:38:23.818 INFO [stdout] test vm::tests::instructions::mult::lit_lit_wrap ... ok
Dec 13 15:38:23.818 INFO [stdout] test vm::tests::instructions::mult::reg_reg_wrap ... ok
Dec 13 15:38:23.819 INFO [stdout] test vm::tests::instructions::not::reg ... ok
Dec 13 15:38:23.819 INFO [stdout] test vm::tests::instructions::mult::reg_lit_wrap ... ok
Dec 13 15:38:23.822 INFO [stdout] test vm::tests::instructions::mult::lit_reg_wrap ... ok
Dec 13 15:38:23.822 INFO [stdout] test vm::tests::instructions::or::lit_reg ... ok
Dec 13 15:38:23.822 INFO [stdout] test vm::tests::instructions::or::lit_lit ... ok
Dec 13 15:38:23.822 INFO [stdout] test vm::tests::instructions::mult::reg_lit_nowrap ... ok
Dec 13 15:38:23.822 INFO [stdout] test vm::tests::instructions::mult::reg_reg_nowrap ... ok
Dec 13 15:38:23.822 INFO [stdout] test vm::tests::instructions::modulo::lit_lit ... ok
Dec 13 15:38:23.822 INFO [stdout] test vm::tests::instructions::pop::happy ... ok
Dec 13 15:38:23.824 INFO [stdout] test vm::tests::instructions::push::lit ... ok
Dec 13 15:38:23.824 INFO [stdout] test vm::tests::instructions::or::reg_reg ... ok
Dec 13 15:38:23.827 INFO [stdout] test vm::tests::instructions::or::reg_lit ... ok
Dec 13 15:38:23.827 INFO [stdout] test vm::tests::instructions::jump::reg ... ok
Dec 13 15:38:23.827 INFO [stdout] test vm::tests::instructions::not::lit ... ok
Dec 13 15:38:23.827 INFO [stdout] test vm::tests::instructions::pop::stack_underflow_error ... ok
Dec 13 15:38:23.828 INFO [stdout] test vm::tests::instructions::ret::lit ... ok
Dec 13 15:38:23.828 INFO [stdout] test vm::tests::instructions::pop::nonempty_remaining_stack ... ok
Dec 13 15:38:23.828 INFO [stdout] test vm::tests::instructions::set::reg ... ok
Dec 13 15:38:23.830 INFO [stdout] test vm::tests::instructions::push::reg ... ok
Dec 13 15:38:23.830 INFO [stdout] test vm::tests::instructions::ret::reg ... ok
Dec 13 15:38:23.831 INFO [stdout] test vm::tests::instructions::wmem::reg_reg ... ok
Dec 13 15:38:23.831 INFO [stdout] test vm::tests::instructions::set::lit ... ok
Dec 13 15:38:23.831 INFO [stdout] test vm::tests::instructions::rmem::lit ... ok
Dec 13 15:38:23.831 INFO [stdout] test vm::tests::instructions::wmem::lit_lit ... ok
Dec 13 15:38:23.832 INFO [stdout] test vm::tests::load_program::valid_program_load ... ok
Dec 13 15:38:23.832 INFO [stdout] test vm::tests::instructions::rmem::reg ... ok
Dec 13 15:38:23.832 INFO [stdout] test vm::tests::instructions::wmem::lit_reg ... ok
Dec 13 15:38:23.832 INFO [stdout] test vm::tests::step::step ... ok
Dec 13 15:38:23.833 INFO [stdout] test vm::tests::step::advance ... ok
Dec 13 15:38:23.834 INFO [stdout] test vm::tests::step::read_memory_invalid ... ok
Dec 13 15:38:23.834 INFO [stdout] test vm::tests::step::current_instruction_bad_opcode ... ok
Dec 13 15:38:23.834 INFO [stdout] test vm::tests::step::read_memory_happy ... ok
Dec 13 15:38:23.834 INFO [stdout] test vm::tests::step::current_instruction_malformed ... ok
Dec 13 15:38:23.835 INFO [stdout] test vm::tests::step::current_instruction_happy ... ok
Dec 13 15:38:23.835 INFO [stdout] 
Dec 13 15:38:23.835 INFO [stdout] test result: ok. 312 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 15:38:23.835 INFO [stdout] 
Dec 13 15:38:23.837 INFO [stderr]      Running /target/debug/deps/syn_asm-d49103b8e9351c9c
Dec 13 15:38:23.841 INFO [stdout] 
Dec 13 15:38:23.841 INFO [stdout] running 0 tests
Dec 13 15:38:23.841 INFO [stdout] 
Dec 13 15:38:23.841 INFO [stderr]      Running /target/debug/deps/syn_dis-83f83e93a0c310ef
Dec 13 15:38:23.841 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 15:38:23.841 INFO [stdout] 
Dec 13 15:38:23.844 INFO [stdout] 
Dec 13 15:38:23.844 INFO [stdout] running 0 tests
Dec 13 15:38:23.844 INFO [stdout] 
Dec 13 15:38:23.844 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 15:38:23.844 INFO [stdout] 
Dec 13 15:38:23.845 INFO [stderr]      Running /target/debug/deps/syn_vm-e24c5903698149cb
Dec 13 15:38:23.850 INFO [stdout] 
Dec 13 15:38:23.850 INFO [stdout] running 0 tests
Dec 13 15:38:23.850 INFO [stdout] 
Dec 13 15:38:23.850 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 15:38:23.850 INFO [stdout] 
Dec 13 15:38:23.850 INFO [stderr]    Doc-tests synacor
Dec 13 15:38:24.308 INFO [stdout] 
Dec 13 15:38:24.308 INFO [stdout] running 0 tests
Dec 13 15:38:24.308 INFO [stdout] 
Dec 13 15:38:24.308 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 15:38:24.308 INFO [stdout] 
Dec 13 15:38:24.310 INFO [stderr] su: No module specific data is present
Dec 13 15:38:24.714 INFO running `"docker" "inspect" "c013e32eaca75deeb6cc4c2eacdcdde3c74225f4b644868e219c88b6298529b1"`
Dec 13 15:38:25.070 INFO running `"docker" "rm" "-f" "c013e32eaca75deeb6cc4c2eacdcdde3c74225f4b644868e219c88b6298529b1"`
Dec 13 15:38:25.246 INFO [stdout] c013e32eaca75deeb6cc4c2eacdcdde3c74225f4b644868e219c88b6298529b1