Oct 31 17:40:18.770 INFO testing unixpickle/locky-puzzle against beta-2018-10-30 for beta-1.31-1
Oct 31 17:40:18.770 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-2/beta-2018-10-30:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/beta-1.31-1/beta-2018-10-30:/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 +beta-2018-10-30 build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Oct 31 17:40:19.243 INFO blam! 20aeaa5eb5287334e550fdabca9f41546bf53e98521fb8e2825985cc0cbde2bd
Oct 31 17:40:19.255 INFO running `"docker" "start" "-a" "20aeaa5eb5287334e550fdabca9f41546bf53e98521fb8e2825985cc0cbde2bd"`
Oct 31 17:40:20.630 INFO kablam! usermod: no changes
Oct 31 17:40:20.775 INFO kablam!    Compiling bitflags v1.0.2
Oct 31 17:40:20.783 INFO kablam!    Compiling atty v0.2.9
Oct 31 17:40:21.179 INFO kablam!    Compiling clap v2.31.2
Oct 31 17:40:35.731 INFO kablam!    Compiling locky-puzzle v0.1.0 (/source)
Oct 31 17:40:44.205 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 23.54s
Oct 31 17:40:44.210 INFO kablam! su: No module specific data is present
Oct 31 17:40:44.771 INFO running `"docker" "rm" "-f" "20aeaa5eb5287334e550fdabca9f41546bf53e98521fb8e2825985cc0cbde2bd"`
Oct 31 17:40:44.940 INFO blam! 20aeaa5eb5287334e550fdabca9f41546bf53e98521fb8e2825985cc0cbde2bd
Oct 31 17:40:44.947 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-2/beta-2018-10-30:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/beta-1.31-1/beta-2018-10-30:/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 +beta-2018-10-30 test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Oct 31 17:40:45.407 INFO blam! f15d3a7e72a49c2fa9bcfd9179732cdbf9adaac23c5887a1571f885da7ab0c50
Oct 31 17:40:45.422 INFO running `"docker" "start" "-a" "f15d3a7e72a49c2fa9bcfd9179732cdbf9adaac23c5887a1571f885da7ab0c50"`
Oct 31 17:40:46.559 INFO kablam! usermod: no changes
Oct 31 17:40:46.671 INFO kablam!    Compiling locky-puzzle v0.1.0 (/source)
Oct 31 17:40:50.507 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 3.91s
Oct 31 17:40:50.512 INFO kablam! su: No module specific data is present
Oct 31 17:40:51.067 INFO running `"docker" "rm" "-f" "f15d3a7e72a49c2fa9bcfd9179732cdbf9adaac23c5887a1571f885da7ab0c50"`
Oct 31 17:40:51.348 INFO blam! f15d3a7e72a49c2fa9bcfd9179732cdbf9adaac23c5887a1571f885da7ab0c50
Oct 31 17:40:51.355 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-2/beta-2018-10-30:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/beta-1.31-1/beta-2018-10-30:/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 +beta-2018-10-30 test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Oct 31 17:40:52.287 INFO blam! 86c940b9c912de0a874071f59f2a8f27c0fe59da95ecaf3e78676c9c67af5eac
Oct 31 17:40:52.290 INFO running `"docker" "start" "-a" "86c940b9c912de0a874071f59f2a8f27c0fe59da95ecaf3e78676c9c67af5eac"`
Oct 31 17:40:53.334 INFO kablam! usermod: no changes
Oct 31 17:40:53.407 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.03s
Oct 31 17:40:53.407 INFO kablam!      Running /target/debug/deps/locky_puzzle-03c984826de5b053
Oct 31 17:40:53.409 INFO blam! 
Oct 31 17:40:53.410 INFO blam! running 17 tests
Oct 31 17:40:53.419 INFO blam! test moves::tests::b_move ... ok
Oct 31 17:40:53.419 INFO blam! test moves::tests::long_scramble ... ok
Oct 31 17:40:53.419 INFO blam! test moves::tests::stringify_algo ... ok
Oct 31 17:40:53.419 INFO blam! test moves::tests::u_move ... ok
Oct 31 17:40:53.434 INFO blam! test moves::tests::parse_algo ... ok
Oct 31 17:40:53.439 INFO blam! test moves::tests::short_scramble_u3_r2 ... ok
Oct 31 17:40:53.440 INFO blam! test moves::tests::r_move ... ok
Oct 31 17:40:53.447 INFO blam! test moves::tests::short_scramble_d_b2 ... ok
Oct 31 17:40:53.448 INFO blam! test moves::tests::short_scramble_f2_l3 ... ok
Oct 31 17:40:53.493 INFO blam! test solve::tests::proj_simpler_solution ... ok
Oct 31 17:40:53.526 INFO blam! test solve::tests::zero_move_scramble ... ok
Oct 31 17:40:53.528 INFO blam! test state::tests::solved_display ... ok
Oct 31 17:40:53.672 INFO blam! test solve::tests::not_enough_depth ... ok
Oct 31 17:40:53.743 INFO blam! test solve::tests::one_move_scramble ... ok
Oct 31 17:40:53.743 INFO blam! test solve::tests::five_move_scramble ... ok
Oct 31 17:40:53.743 INFO blam! test solve::tests::proj_five_move_scramble ... ok
Oct 31 17:40:59.671 INFO blam! test heuristic::tests::generate_heuristic ... ok
Oct 31 17:40:59.671 INFO blam! 
Oct 31 17:40:59.671 INFO blam! test result: ok. 17 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 31 17:40:59.671 INFO blam! 
Oct 31 17:40:59.687 INFO kablam!      Running /target/debug/deps/bench_heuristic-bc330a0c978ebdcc
Oct 31 17:40:59.695 INFO blam! 
Oct 31 17:40:59.695 INFO blam! running 0 tests
Oct 31 17:40:59.695 INFO blam! 
Oct 31 17:40:59.695 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 31 17:40:59.695 INFO blam! 
Oct 31 17:40:59.696 INFO kablam!      Running /target/debug/deps/bench_solve-fd722dbc00403ad6
Oct 31 17:40:59.697 INFO blam! 
Oct 31 17:40:59.697 INFO blam! running 0 tests
Oct 31 17:40:59.697 INFO blam! 
Oct 31 17:40:59.697 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 31 17:40:59.697 INFO blam! 
Oct 31 17:40:59.703 INFO kablam!      Running /target/debug/deps/locky_scramble-71589a2a974eca95
Oct 31 17:40:59.703 INFO kablam!      Running /target/debug/deps/locky_solve-819bf7e88ffcbf06
Oct 31 17:40:59.703 INFO kablam!    Doc-tests locky_puzzle
Oct 31 17:40:59.704 INFO blam! 
Oct 31 17:40:59.704 INFO blam! running 0 tests
Oct 31 17:40:59.704 INFO blam! 
Oct 31 17:40:59.704 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 31 17:40:59.704 INFO blam! 
Oct 31 17:40:59.704 INFO blam! 
Oct 31 17:40:59.704 INFO blam! running 0 tests
Oct 31 17:40:59.704 INFO blam! 
Oct 31 17:40:59.704 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 31 17:40:59.704 INFO blam! 
Oct 31 17:40:59.919 INFO blam! 
Oct 31 17:40:59.919 INFO blam! running 0 tests
Oct 31 17:40:59.919 INFO blam! 
Oct 31 17:40:59.919 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 31 17:40:59.919 INFO blam! 
Oct 31 17:40:59.925 INFO kablam! su: No module specific data is present
Oct 31 17:41:00.755 INFO running `"docker" "rm" "-f" "86c940b9c912de0a874071f59f2a8f27c0fe59da95ecaf3e78676c9c67af5eac"`
Oct 31 17:41:00.996 INFO blam! 86c940b9c912de0a874071f59f2a8f27c0fe59da95ecaf3e78676c9c67af5eac
