[INFO] cloning repository https://github.com/dwayne/xsos
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/dwayne/xsos" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdwayne%2Fxsos", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdwayne%2Fxsos'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] c6244b25f72b7ba335daeda8100bc6fdaf6ef0e3
[INFO] testing dwayne/xsos against 1.55.0 for beta-1.56-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdwayne%2Fxsos" "/workspace/builds/worker-64/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-64/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/dwayne/xsos on toolchain 1.55.0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.55.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/dwayne/xsos
[INFO] finished tweaking git repo https://github.com/dwayne/xsos
[INFO] tweaked toml for git repo https://github.com/dwayne/xsos written to /workspace/builds/worker-64/source/Cargo.toml
[INFO] crate git repo https://github.com/dwayne/xsos already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.55.0" "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-64/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-64/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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+1.55.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] c68c6420b66f74d3e1f9c3a2c40da6c6d86db29f517d883725e62350f075936c
[INFO] running `Command { std: "docker" "start" "-a" "c68c6420b66f74d3e1f9c3a2c40da6c6d86db29f517d883725e62350f075936c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "c68c6420b66f74d3e1f9c3a2c40da6c6d86db29f517d883725e62350f075936c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c68c6420b66f74d3e1f9c3a2c40da6c6d86db29f517d883725e62350f075936c", kill_on_drop: false }`
[INFO] [stdout] c68c6420b66f74d3e1f9c3a2c40da6c6d86db29f517d883725e62350f075936c
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-64/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-64/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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+1.55.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] ab9d8c3d5cbbb4d44001f5eb445d04ac66d7dc06dbffea96b8c66be03ff953c3
[INFO] running `Command { std: "docker" "start" "-a" "ab9d8c3d5cbbb4d44001f5eb445d04ac66d7dc06dbffea96b8c66be03ff953c3", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling libc v0.2.77
[INFO] [stderr]    Compiling proc-macro2 v1.0.21
[INFO] [stderr]    Compiling version_check v0.9.2
[INFO] [stderr]    Compiling unicode-xid v0.2.1
[INFO] [stderr]    Compiling syn v1.0.41
[INFO] [stderr]    Compiling heck v0.3.1
[INFO] [stderr]    Compiling proc-macro-error-attr v1.0.4
[INFO] [stderr]    Compiling proc-macro-error v1.0.4
[INFO] [stderr]    Compiling getrandom v0.1.15
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling quote v1.0.7
[INFO] [stderr]    Compiling clap v2.33.3
[INFO] [stderr]    Compiling rand_core v0.5.1
[INFO] [stderr]    Compiling rand_chacha v0.2.2
[INFO] [stderr]    Compiling rand v0.7.3
[INFO] [stderr]    Compiling structopt-derive v0.4.10
[INFO] [stderr]    Compiling structopt v0.3.17
[INFO] [stderr]    Compiling xsos v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 59s
[INFO] running `Command { std: "docker" "inspect" "ab9d8c3d5cbbb4d44001f5eb445d04ac66d7dc06dbffea96b8c66be03ff953c3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ab9d8c3d5cbbb4d44001f5eb445d04ac66d7dc06dbffea96b8c66be03ff953c3", kill_on_drop: false }`
[INFO] [stdout] ab9d8c3d5cbbb4d44001f5eb445d04ac66d7dc06dbffea96b8c66be03ff953c3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-64/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-64/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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+1.55.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 4f214a33815b56fb7c85651443d2df71d1504c5a8ed7097e5186824dc41aca14
[INFO] running `Command { std: "docker" "start" "-a" "4f214a33815b56fb7c85651443d2df71d1504c5a8ed7097e5186824dc41aca14", kill_on_drop: false }`
[INFO] [stderr]    Compiling xsos v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 2.04s
[INFO] running `Command { std: "docker" "inspect" "4f214a33815b56fb7c85651443d2df71d1504c5a8ed7097e5186824dc41aca14", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4f214a33815b56fb7c85651443d2df71d1504c5a8ed7097e5186824dc41aca14", kill_on_drop: false }`
[INFO] [stdout] 4f214a33815b56fb7c85651443d2df71d1504c5a8ed7097e5186824dc41aca14
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-64/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-64/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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+1.55.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 6bbce190e25629d4717ec3390b1fbaf5688a4a71a6df92bf6f65f49a268cb21f
[INFO] running `Command { std: "docker" "start" "-a" "6bbce190e25629d4717ec3390b1fbaf5688a4a71a6df92bf6f65f49a268cb21f", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 3.10s
[INFO] [stdout] running 20 tests
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/xsos-a0697c776f924649)
[INFO] [stdout] test ai::tests::it_favors_winning_over_blocking ... ok
[INFO] [stdout] test ai::tests::it_finds_the_blocking_move_to_avoid_losing ... ok
[INFO] [stdout] test cli::tests::let_computer_play_with_x_and_human_play_with_o ... ok
[INFO] [stdout] test grid::tests::usage ... ok
[INFO] [stdout] test referee::tests::evaluate_detects_a_draw ... ok
[INFO] [stdout] test game::tests::when_o_squashes ... ok
[INFO] [stdout] test referee::tests::evaluate_detects_a_win ... ok
[INFO] [stdout] test game::tests::clone ... ok
[INFO] [stdout] test game::tests::after_3_plays ... ok
[INFO] [stdout] test referee::tests::evaluate_on_an_empty_grid_returns_none ... ok
[INFO] [stdout] test cli::tests::let_o_play_first ... ok
[INFO] [stdout] test cli::tests::computer_vs_computer_for_50_rounds ... ok
[INFO] [stdout] test cli::tests::defaults ... ok
[INFO] [stdout] test ai::tests::it_finds_the_winning_moves ... ok
[INFO] [stdout] test cli::tests::computer_vs_computer ... ok
[INFO] [stdout] test game::tests::when_position_is_out_of_bounds ... ok
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/xsos-7510d05fa4d9c439)
[INFO] [stderr]    Doc-tests xsos
[INFO] [stdout] test grid::tests::clone ... ok
[INFO] [stdout] test game::tests::when_x_wins ... ok
[INFO] [stdout] test ai::tests::it_has_no_good_moves_since_every_position_is_losing ... ok
[INFO] [stdout] test game::tests::when_position_is_unavailable ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test src/grid.rs - grid::Cell (line 26) ... ok
[INFO] [stdout] test src/mark.rs - mark::Mark::swap (line 15) ... ok
[INFO] [stdout] test src/game.rs - game::Game::play (line 166) ... ok
[INFO] [stdout] test src/grid.rs - grid::Grid::cells (line 170) ... ok
[INFO] [stdout] test src/grid.rs - grid::Position (line 12) ... ok
[INFO] [stdout] test src/grid.rs - grid::Grid::unmarked_positions (line 141) ... ok
[INFO] [stdout] test src/grid.rs - grid::Grid::mark (line 83) ... ok
[INFO] [stdout] test src/game.rs - game::Game (line 22) ... ok
[INFO] [stdout] test src/grid.rs - grid::Grid::in_bounds (line 66) ... ok
[INFO] [stdout] test src/game.rs - game::Game::start (line 129) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 5.57s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "6bbce190e25629d4717ec3390b1fbaf5688a4a71a6df92bf6f65f49a268cb21f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6bbce190e25629d4717ec3390b1fbaf5688a4a71a6df92bf6f65f49a268cb21f", kill_on_drop: false }`
[INFO] [stdout] 6bbce190e25629d4717ec3390b1fbaf5688a4a71a6df92bf6f65f49a268cb21f