Nov 17 09:46:27.534 INFO testing alexanderbladyko/caverna_bot against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 17 09:46:27.534 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-0/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/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 17 09:46:27.730 INFO [stdout] c1575d6aec0a127bfd7e67b0198fe2098e1363ba4c66f664a56caed16092bbd2
Nov 17 09:46:27.732 INFO running `"docker" "start" "-a" "c1575d6aec0a127bfd7e67b0198fe2098e1363ba4c66f664a56caed16092bbd2"`
Nov 17 09:46:28.211 INFO [stderr] usermod: no changes
Nov 17 09:46:28.289 INFO [stderr]    Compiling atty v0.2.3
Nov 17 09:46:28.289 INFO [stderr]    Compiling yaml-rust v0.4.0
Nov 17 09:46:28.483 INFO [stderr]    Compiling clap v2.28.0
Nov 17 09:46:30.913 INFO [stderr]    Compiling serde_yaml v0.7.3
Nov 17 09:46:53.380 INFO [stderr]    Compiling caverna_bot v0.1.0 (/source)
Nov 17 09:46:54.183 INFO [stderr] warning: unused macro definition
Nov 17 09:46:54.183 INFO [stderr]   --> src/common.rs:20:1
Nov 17 09:46:54.183 INFO [stderr]    |
Nov 17 09:46:54.183 INFO [stderr] 20 | / macro_rules! hash_set(
Nov 17 09:46:54.183 INFO [stderr] 21 | |     { $($x:expr),+ } => {
Nov 17 09:46:54.183 INFO [stderr] 22 | |         {
Nov 17 09:46:54.183 INFO [stderr] 23 | |             let mut m = HashSet::new();
Nov 17 09:46:54.183 INFO [stderr] ...  |
Nov 17 09:46:54.183 INFO [stderr] 29 | |     };
Nov 17 09:46:54.183 INFO [stderr] 30 | | );
Nov 17 09:46:54.183 INFO [stderr]    | |__^
Nov 17 09:46:54.183 INFO [stderr]    |
Nov 17 09:46:54.183 INFO [stderr]    = note: #[warn(unused_macros)] on by default
Nov 17 09:46:54.183 INFO [stderr] 
Nov 17 09:47:07.479 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 39.25s
Nov 17 09:47:07.489 INFO [stderr] su: No module specific data is present
Nov 17 09:47:08.575 INFO running `"docker" "inspect" "c1575d6aec0a127bfd7e67b0198fe2098e1363ba4c66f664a56caed16092bbd2"`
Nov 17 09:47:08.891 INFO running `"docker" "rm" "-f" "c1575d6aec0a127bfd7e67b0198fe2098e1363ba4c66f664a56caed16092bbd2"`
Nov 17 09:47:09.271 INFO [stdout] c1575d6aec0a127bfd7e67b0198fe2098e1363ba4c66f664a56caed16092bbd2
Nov 17 09:47:09.285 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-0/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/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 17 09:47:09.744 INFO [stdout] c7828c01d06580046a9f8c02a615c65426ce0f609b4d539860ff5c10e9460a5e
Nov 17 09:47:09.746 INFO running `"docker" "start" "-a" "c7828c01d06580046a9f8c02a615c65426ce0f609b4d539860ff5c10e9460a5e"`
Nov 17 09:47:12.223 INFO [stderr] usermod: no changes
Nov 17 09:47:12.403 INFO [stderr]    Compiling caverna_bot v0.1.0 (/source)
Nov 17 09:47:15.023 INFO [stderr] warning: unused variable: `actions`
Nov 17 09:47:15.024 INFO [stderr]   --> src/test/test_moves/test_core.rs:15:17
Nov 17 09:47:15.024 INFO [stderr]    |
Nov 17 09:47:15.024 INFO [stderr] 15 |             let actions = player_move.get_all_actions(game, &moves_config);
Nov 17 09:47:15.025 INFO [stderr]    |                 ^^^^^^^ help: consider using `_actions` instead
Nov 17 09:47:15.025 INFO [stderr]    |
Nov 17 09:47:15.025 INFO [stderr]    = note: #[warn(unused_variables)] on by default
Nov 17 09:47:15.025 INFO [stderr] 
Nov 17 09:47:18.920 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.66s
Nov 17 09:47:18.926 INFO [stderr] su: No module specific data is present
Nov 17 09:47:19.938 INFO running `"docker" "inspect" "c7828c01d06580046a9f8c02a615c65426ce0f609b4d539860ff5c10e9460a5e"`
Nov 17 09:47:20.249 INFO running `"docker" "rm" "-f" "c7828c01d06580046a9f8c02a615c65426ce0f609b4d539860ff5c10e9460a5e"`
Nov 17 09:47:20.510 INFO [stdout] c7828c01d06580046a9f8c02a615c65426ce0f609b4d539860ff5c10e9460a5e
Nov 17 09:47:20.512 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-0/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/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 17 09:47:21.097 INFO [stdout] e9ebabd2c0aa80cf1be445216641f69a40b72459c547c8bceca01bc354e12f05
Nov 17 09:47:21.099 INFO running `"docker" "start" "-a" "e9ebabd2c0aa80cf1be445216641f69a40b72459c547c8bceca01bc354e12f05"`
Nov 17 09:47:22.567 INFO [stderr] usermod: no changes
Nov 17 09:47:22.734 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.14s
Nov 17 09:47:22.739 INFO [stderr]      Running /target/debug/deps/caverna_bot-6d763b53303b2796
Nov 17 09:47:22.751 INFO [stdout] 
Nov 17 09:47:22.752 INFO [stdout] running 23 tests
Nov 17 09:47:22.752 INFO [stdout] test test::test_actions::test_actions::test::test_open_new_move::test_perform ... ok
Nov 17 09:47:22.752 INFO [stdout] test test::test_actions::test_actions::test::test_next_user::test_perform ... ok
Nov 17 09:47:22.753 INFO [stdout] test test::test_actions::test_actions::test::test_release_moves::test_perform ... ok
Nov 17 09:47:22.763 INFO [stdout] test test::test_actions::test_actions::test::test_increase_turn::test_perform ... ok
Nov 17 09:47:22.763 INFO [stdout] test test::test_actions::test_actions::test::test_reorder_players::test_perform ... ok
Nov 17 09:47:22.763 INFO [stdout] test test::test_actions::test_actions::test::test_build_fields::test_perform ... ok
Nov 17 09:47:22.763 INFO [stdout] test test::test_actions::test_actions::test::test_reserve_gnome::test_perform ... ok
Nov 17 09:47:22.763 INFO [stdout] test test::test_actions::test_actions::test::test_change_status::test_perform ... ok
Nov 17 09:47:22.763 INFO [stdout] test test::test_actions::test_actions::test::test_build_rooms::test_perform ... ok
Nov 17 09:47:22.763 INFO [stdout] test test::test_actions::test_actions::test::test_block_move::test_perform ... ok
Nov 17 09:47:22.765 INFO [stdout] test test::test_score::test_calculator::test::test_calculate_score::test_animals_effect_on_score ... ok
Nov 17 09:47:22.765 INFO [stdout] test test::test_score::test_calculator::test::test_calculate_score::test_gnomes_effect_on_score ... ok
Nov 17 09:47:22.765 INFO [stdout] test test::test_actions::test_actions::test::test_set_first_player::test_perform ... ok
Nov 17 09:47:22.766 INFO [stdout] test test::test_actions::test_actions::test::test_spawn_gnome::test_perform ... ok
Nov 17 09:47:22.767 INFO [stdout] test test::test_moves::test_core::test::test_get_free_slots::test_get_all_actions ... ok
Nov 17 09:47:22.767 INFO [stdout] test test::test_score::test_calculator::test::test_calculate_score::test_no_resources ... ok
Nov 17 09:47:22.767 INFO [stdout] test test::test_actions::test_actions::test::test_update_resources::test_perform ... ok
Nov 17 09:47:22.767 INFO [stdout] test test::test_actions::test_actions::test::test_set_feeding_and_breeding_status::test_perform ... ok
Nov 17 09:47:22.768 INFO [stdout] test test::test_utils::test::test_get_available_pair_slots::test_free_pair_slots ... ok
Nov 17 09:47:22.768 INFO [stdout] test test::test_utils::test::test_get_available_slots::test_long_free_slots ... ok
Nov 17 09:47:22.768 INFO [stdout] test test::test_utils::test::test_get_available_slots::test_side_free_slots ... ok
Nov 17 09:47:22.768 INFO [stdout] test test::test_utils::test::test_get_available_slots::test_free_slots ... ok
Nov 17 09:47:22.776 INFO [stdout] test test::test_utils::test::test_get_available_pair_slots::test_free_pair_slots_complex ... ok
Nov 17 09:47:22.776 INFO [stdout] 
Nov 17 09:47:22.776 INFO [stdout] test result: ok. 23 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 09:47:22.776 INFO [stdout] 
Nov 17 09:47:22.793 INFO [stderr] su: No module specific data is present
Nov 17 09:47:23.398 INFO running `"docker" "inspect" "e9ebabd2c0aa80cf1be445216641f69a40b72459c547c8bceca01bc354e12f05"`
Nov 17 09:47:23.619 INFO running `"docker" "rm" "-f" "e9ebabd2c0aa80cf1be445216641f69a40b72459c547c8bceca01bc354e12f05"`
Nov 17 09:47:24.011 INFO [stdout] e9ebabd2c0aa80cf1be445216641f69a40b72459c547c8bceca01bc354e12f05