[INFO] cloning repository https://github.com/honvex-cool/cratemover
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/honvex-cool/cratemover" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fhonvex-cool%2Fcratemover", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fhonvex-cool%2Fcratemover'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 4ba1b18ea9ad629462ddbd79e3205348a3784c16
[INFO] testing honvex-cool/cratemover against beta-2022-04-10 for beta-1.61-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fhonvex-cool%2Fcratemover" "/workspace/builds/worker-4/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-4/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/honvex-cool/cratemover on toolchain beta-2022-04-10
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/honvex-cool/cratemover
[INFO] finished tweaking git repo https://github.com/honvex-cool/cratemover
[INFO] tweaked toml for git repo https://github.com/honvex-cool/cratemover written to /workspace/builds/worker-4/source/Cargo.toml
[INFO] crate git repo https://github.com/honvex-cool/cratemover already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] b9da1cc5a0b23dc70defe9cf555058aad66ebdaa8758386bff7f85e8e992e78c
[INFO] running `Command { std: "docker" "start" "-a" "b9da1cc5a0b23dc70defe9cf555058aad66ebdaa8758386bff7f85e8e992e78c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "b9da1cc5a0b23dc70defe9cf555058aad66ebdaa8758386bff7f85e8e992e78c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b9da1cc5a0b23dc70defe9cf555058aad66ebdaa8758386bff7f85e8e992e78c", kill_on_drop: false }`
[INFO] [stdout] b9da1cc5a0b23dc70defe9cf555058aad66ebdaa8758386bff7f85e8e992e78c
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 995506dd7f31cc903e03cced245fe6247caf722d98fd71d505aecba1d3477073
[INFO] running `Command { std: "docker" "start" "-a" "995506dd7f31cc903e03cced245fe6247caf722d98fd71d505aecba1d3477073", kill_on_drop: false }`
[INFO] [stderr]    Compiling sfml-build v0.4.0
[INFO] [stderr]    Compiling widestring v0.4.3
[INFO] [stderr]    Compiling csfml-system-sys v0.6.0
[INFO] [stderr]    Compiling csfml-window-sys v0.6.0
[INFO] [stderr]    Compiling csfml-audio-sys v0.6.0
[INFO] [stderr]    Compiling csfml-graphics-sys v0.6.0
[INFO] [stderr]    Compiling sfml v0.16.0
[INFO] [stderr]    Compiling cratemover v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.58s
[INFO] running `Command { std: "docker" "inspect" "995506dd7f31cc903e03cced245fe6247caf722d98fd71d505aecba1d3477073", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "995506dd7f31cc903e03cced245fe6247caf722d98fd71d505aecba1d3477073", kill_on_drop: false }`
[INFO] [stdout] 995506dd7f31cc903e03cced245fe6247caf722d98fd71d505aecba1d3477073
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] a40fed79701315d866336ef260cd06af20e6975e94b16f96e3bf569ae7187928
[INFO] running `Command { std: "docker" "start" "-a" "a40fed79701315d866336ef260cd06af20e6975e94b16f96e3bf569ae7187928", kill_on_drop: false }`
[INFO] [stderr]    Compiling cratemover v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 1.05s
[INFO] [stderr]   Executable unittests src/main.rs (/opt/rustwide/target/debug/deps/cratemover-ad808aecd8c21148)
[INFO] running `Command { std: "docker" "inspect" "a40fed79701315d866336ef260cd06af20e6975e94b16f96e3bf569ae7187928", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a40fed79701315d866336ef260cd06af20e6975e94b16f96e3bf569ae7187928", kill_on_drop: false }`
[INFO] [stdout] a40fed79701315d866336ef260cd06af20e6975e94b16f96e3bf569ae7187928
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] eb8c6ea43ed0344d157b95419d94e1d2d38218926c62928960237b08c882891f
[INFO] running `Command { std: "docker" "start" "-a" "eb8c6ea43ed0344d157b95419d94e1d2d38218926c62928960237b08c882891f", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 2m 44s
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/cratemover-ad808aecd8c21148)
[INFO] [stdout] 
[INFO] [stdout] running 28 tests
[INFO] [stdout] test sokoban::board::tests::board_parsing_fails_because_of_empty_grid ... ok
[INFO] [stdout] test sokoban::board::tests::board_can_be_loaded_from_file ... ok
[INFO] [stdout] test sokoban::board::tests::board_parsing_fails_because_of_unknown_chars ... ok
[INFO] [stdout] test sokoban::board::tests::board_parsing_fails_if_there_are_more_chests_than_destinations ... ok
[INFO] [stdout] test sokoban::board::tests::board_parsing_fails_if_there_are_more_destinations_than_chests ... ok
[INFO] [stdout] test sokoban::board::tests::board_parsing_fails_when_multiple_starting_positions_are_given ... ok
[INFO] [stdout] test sokoban::board::tests::board_parsing_fails_when_no_starting_position_is_given ... ok
[INFO] [stdout] test sokoban::board::tests::known_chars_are_correctly_parsed ... ok
[INFO] [stdout] test sokoban::board::tests::board_parsing_succeeds_with_valid_board_representations ... ok
[INFO] [stdout] test sokoban::board::tests::parsing_unknown_chars_returns_appropriate_err_variants ... ok
[INFO] [stdout] test sokoban::board::tests::parsing_rows_that_contain_unknown_chars_returns_err_of_the_first_unknown_char ... ok
[INFO] [stdout] test sokoban::board::tests::loading_from_a_nonexistent_file_fails ... ok
[INFO] [stdout] test sokoban::board::tests::rows_of_known_chars_are_correctly_parsed ... ok
[INFO] [stdout] test sokoban::board::tests::short_rows_can_be_padded_with_empty_squares ... ok
[INFO] [stdout] test sokoban::board::tests::starting_positions_are_correctly_discovered ... ok
[INFO] [stdout] test utils::tests::dimensions_of_rectangular_grids_are_correctly_determined ... ok
[INFO] [stdout] test utils::tests::grid_can_be_indexed_by_valid_positions ... ok
[INFO] [stdout] test utils::tests::grid_entries_at_positions_yielded_by_iterator_can_be_set_to_a_value ... ok
[INFO] [stdout] test utils::tests::grid_positions_of_elements_are_correctly_discovered ... ok
[INFO] [stdout] test utils::tests::grid_rows_can_be_padded_with_default_values ... ok
[INFO] [stdout] test utils::tests::indirect_access_to_an_invalid_position_returns_none ... ok
[INFO] [stdout] test utils::tests::position_can_be_shifted_down ... ok
[INFO] [stdout] test utils::tests::position_can_be_shifted_left ... ok
[INFO] [stdout] test utils::tests::position_can_be_shifted_right ... ok
[INFO] [stdout] test utils::tests::position_can_be_shifted_up ... ok
[INFO] [stdout] test utils::tests::querying_an_empty_grid_for_dimensions_returns_none ... ok
[INFO] [stdout] test utils::tests::querying_non_rectangular_grids_for_dimensions_returns_none ... ok
[INFO] [stdout] test utils::tests::direct_access_to_an_invalid_position_panics - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 28 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "eb8c6ea43ed0344d157b95419d94e1d2d38218926c62928960237b08c882891f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "eb8c6ea43ed0344d157b95419d94e1d2d38218926c62928960237b08c882891f", kill_on_drop: false }`
[INFO] [stdout] eb8c6ea43ed0344d157b95419d94e1d2d38218926c62928960237b08c882891f