[INFO] cloning repository https://github.com/qnighy/tdd-exercise-20221223
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/qnighy/tdd-exercise-20221223" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fqnighy%2Ftdd-exercise-20221223", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fqnighy%2Ftdd-exercise-20221223'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 93f814260c79fe9041f6aab3829205aa47748691
[INFO] testing qnighy/tdd-exercise-20221223 against master#ff2c56344c764af598ad33027e9c7a48881808ef for pr-118825
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fqnighy%2Ftdd-exercise-20221223" "/workspace/builds/worker-0-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-0-tc1/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/qnighy/tdd-exercise-20221223 on toolchain ff2c56344c764af598ad33027e9c7a48881808ef
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+ff2c56344c764af598ad33027e9c7a48881808ef" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/qnighy/tdd-exercise-20221223
[INFO] finished tweaking git repo https://github.com/qnighy/tdd-exercise-20221223
[INFO] tweaked toml for git repo https://github.com/qnighy/tdd-exercise-20221223 written to /workspace/builds/worker-0-tc1/source/Cargo.toml
[INFO] crate git repo https://github.com/qnighy/tdd-exercise-20221223 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+ff2c56344c764af598ad33027e9c7a48881808ef" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[ERROR] error running command: no output for 300 seconds
[ERROR] this task or one of its parent failed!
[ERROR] no output for 300 seconds
[ERROR] note: run with `RUST_BACKTRACE=1` to display a backtrace.
[INFO] testing qnighy/tdd-exercise-20221223 against try#5e4273472e1b2f223618a9b3def795f6224f241d for pr-118825
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fqnighy%2Ftdd-exercise-20221223" "/workspace/builds/worker-0-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-0-tc2/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/qnighy/tdd-exercise-20221223 on toolchain 5e4273472e1b2f223618a9b3def795f6224f241d
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+5e4273472e1b2f223618a9b3def795f6224f241d" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/qnighy/tdd-exercise-20221223
[INFO] finished tweaking git repo https://github.com/qnighy/tdd-exercise-20221223
[INFO] tweaked toml for git repo https://github.com/qnighy/tdd-exercise-20221223 written to /workspace/builds/worker-0-tc2/source/Cargo.toml
[INFO] crate git repo https://github.com/qnighy/tdd-exercise-20221223 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+5e4273472e1b2f223618a9b3def795f6224f241d" "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-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+5e4273472e1b2f223618a9b3def795f6224f241d" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 846f96b37c36f83b6b25c76abc444ebd264584c307da43574d7b6d90e3b45b94
[INFO] running `Command { std: "docker" "start" "-a" "846f96b37c36f83b6b25c76abc444ebd264584c307da43574d7b6d90e3b45b94", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "846f96b37c36f83b6b25c76abc444ebd264584c307da43574d7b6d90e3b45b94", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "846f96b37c36f83b6b25c76abc444ebd264584c307da43574d7b6d90e3b45b94", kill_on_drop: false }`
[INFO] [stdout] 846f96b37c36f83b6b25c76abc444ebd264584c307da43574d7b6d90e3b45b94
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+5e4273472e1b2f223618a9b3def795f6224f241d" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] a3be0127ea395f56ae26a848df29b0d8d0753fc11c6f0b92160f74c88745af21
[INFO] running `Command { std: "docker" "start" "-a" "a3be0127ea395f56ae26a848df29b0d8d0753fc11c6f0b92160f74c88745af21", kill_on_drop: false }`
[INFO] [stderr]    Compiling tdd-exercise-20221223 v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.29s
[INFO] running `Command { std: "docker" "inspect" "a3be0127ea395f56ae26a848df29b0d8d0753fc11c6f0b92160f74c88745af21", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a3be0127ea395f56ae26a848df29b0d8d0753fc11c6f0b92160f74c88745af21", kill_on_drop: false }`
[INFO] [stdout] a3be0127ea395f56ae26a848df29b0d8d0753fc11c6f0b92160f74c88745af21
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+5e4273472e1b2f223618a9b3def795f6224f241d" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 3d324c7549eda7b5d81cd0080a8575c3a0a3bd7528107ef73adfce357bd5ff27
[INFO] running `Command { std: "docker" "start" "-a" "3d324c7549eda7b5d81cd0080a8575c3a0a3bd7528107ef73adfce357bd5ff27", kill_on_drop: false }`
[INFO] [stderr]    Compiling tdd-exercise-20221223 v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.51s
[INFO] running `Command { std: "docker" "inspect" "3d324c7549eda7b5d81cd0080a8575c3a0a3bd7528107ef73adfce357bd5ff27", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3d324c7549eda7b5d81cd0080a8575c3a0a3bd7528107ef73adfce357bd5ff27", kill_on_drop: false }`
[INFO] [stdout] 3d324c7549eda7b5d81cd0080a8575c3a0a3bd7528107ef73adfce357bd5ff27
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+5e4273472e1b2f223618a9b3def795f6224f241d" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 8c226a2e8a06d3796c1ae8c76cb6e4af5c2315bce1a71c2846cfc52dbb284cb9
[INFO] running `Command { std: "docker" "start" "-a" "8c226a2e8a06d3796c1ae8c76cb6e4af5c2315bce1a71c2846cfc52dbb284cb9", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.01s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/tdd_exercise_20221223-dde2cee94e5dfbdf)
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/tdd_exercise_20221223-ec6a805929b8b680)
[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 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] [stderr]      Running tests/basic_tests.rs (/opt/rustwide/target/debug/deps/basic_tests-a2ce78a9845836bd)
[INFO] [stdout] 
[INFO] [stdout] running 29 tests
[INFO] [stdout] test test_neighbor_x_minus_1 ... ok
[INFO] [stdout] test test_neighbor_y_minus_1 ... ok
[INFO] [stdout] test test_point_eq ... ok
[INFO] [stdout] test test_neighbor_x_plus_1 ... ok
[INFO] [stdout] test test_not_neighbor_x_y_minus_1 ... ok
[INFO] [stdout] test test_point_set_contains_right ... ok
[INFO] [stdout] test test_point_ne_x ... ok
[INFO] [stdout] test test_point_ne_y ... ok
[INFO] [stdout] test test_point_set_connected_same ... ok
[INFO] [stdout] test test_point_set_contains_3 ... ok
[INFO] [stdout] test test_point_set_connected_right ... ok
[INFO] [stdout] test test_neighbor_y_plus_1 ... ok
[INFO] [stdout] test test_create_point ... ok
[INFO] [stdout] test test_not_neighbor_if_equal ... ok
[INFO] [stdout] test test_point_set_3_connected_straight ... ok
[INFO] [stdout] test test_point_set_3_connected_v ... ok
[INFO] [stdout] test test_point_set_new ... ok
[INFO] [stdout] test test_point_set_new_with_same_point ... ok
[INFO] [stdout] test test_point_set_3_connected_reverse_straight ... ok
[INFO] [stdout] test test_point_set_3_not_connected ... ok
[INFO] [stdout] test test_point_set_connected_up ... ok
[INFO] [stdout] test test_point_set_contains_left ... ok
[INFO] [stdout] test test_point_set_non_containment ... ok
[INFO] [stdout] test test_point_set_not_connected ... ok
[INFO] [stdout] test test_point_x ... ok
[INFO] [stdout] test test_point_to_string ... ok
[INFO] [stdout] test test_point_set_new3 ... ok
[INFO] [stdout] test test_point_y ... ok
[INFO] [stdout] test test_point_set_new3_with_same_point_12 ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 29 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests tdd-exercise-20221223
[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] running `Command { std: "docker" "inspect" "8c226a2e8a06d3796c1ae8c76cb6e4af5c2315bce1a71c2846cfc52dbb284cb9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8c226a2e8a06d3796c1ae8c76cb6e4af5c2315bce1a71c2846cfc52dbb284cb9", kill_on_drop: false }`
[INFO] [stdout] 8c226a2e8a06d3796c1ae8c76cb6e4af5c2315bce1a71c2846cfc52dbb284cb9