[INFO] cloning repository https://github.com/feba66/spacetraders-relay-rs
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/feba66/spacetraders-relay-rs" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Ffeba66%2Fspacetraders-relay-rs", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Ffeba66%2Fspacetraders-relay-rs'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 41e1e2df61fa28c9ff791934fd137fa066c4867e
[INFO] testing feba66/spacetraders-relay-rs against master#61223975d46f794466efa832bc7562b9707ecc46+rustflags=-Copt-level=3 for pr-121282
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Ffeba66%2Fspacetraders-relay-rs" "/workspace/builds/worker-7-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-7-tc1/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/feba66/spacetraders-relay-rs on toolchain 61223975d46f794466efa832bc7562b9707ecc46
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+61223975d46f794466efa832bc7562b9707ecc46" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/feba66/spacetraders-relay-rs
[INFO] finished tweaking git repo https://github.com/feba66/spacetraders-relay-rs
[INFO] tweaked toml for git repo https://github.com/feba66/spacetraders-relay-rs written to /workspace/builds/worker-7-tc1/source/Cargo.toml
[INFO] crate git repo https://github.com/feba66/spacetraders-relay-rs 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" "+61223975d46f794466efa832bc7562b9707ecc46" "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 feba66/spacetraders-relay-rs against try#d073071d77ce0f93b4fd8cc567a1e2b9e1b22126+rustflags=-Copt-level=3 for pr-121282
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Ffeba66%2Fspacetraders-relay-rs" "/workspace/builds/worker-7-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-7-tc2/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/feba66/spacetraders-relay-rs on toolchain d073071d77ce0f93b4fd8cc567a1e2b9e1b22126
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+d073071d77ce0f93b4fd8cc567a1e2b9e1b22126" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/feba66/spacetraders-relay-rs
[INFO] finished tweaking git repo https://github.com/feba66/spacetraders-relay-rs
[INFO] tweaked toml for git repo https://github.com/feba66/spacetraders-relay-rs written to /workspace/builds/worker-7-tc2/source/Cargo.toml
[INFO] crate git repo https://github.com/feba66/spacetraders-relay-rs 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" "+d073071d77ce0f93b4fd8cc567a1e2b9e1b22126" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]     Blocking waiting for file lock on package cache
[ERROR] error running command: no output for 300 seconds
[INFO] testing feba66/spacetraders-relay-rs against try#d073071d77ce0f93b4fd8cc567a1e2b9e1b22126+rustflags=-Copt-level=3 for pr-121282
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Ffeba66%2Fspacetraders-relay-rs" "/workspace/builds/worker-7-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-7-tc2/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/feba66/spacetraders-relay-rs on toolchain d073071d77ce0f93b4fd8cc567a1e2b9e1b22126
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+d073071d77ce0f93b4fd8cc567a1e2b9e1b22126" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/feba66/spacetraders-relay-rs
[INFO] finished tweaking git repo https://github.com/feba66/spacetraders-relay-rs
[INFO] tweaked toml for git repo https://github.com/feba66/spacetraders-relay-rs written to /workspace/builds/worker-7-tc2/source/Cargo.toml
[INFO] crate git repo https://github.com/feba66/spacetraders-relay-rs 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" "+d073071d77ce0f93b4fd8cc567a1e2b9e1b22126" "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] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded clocksource v0.6.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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" "+d073071d77ce0f93b4fd8cc567a1e2b9e1b22126" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 68bedfc97625a9af479a21e8a4fcf970db6de08c0ec206531c305f7e17508eb0
[INFO] running `Command { std: "docker" "start" "-a" "68bedfc97625a9af479a21e8a4fcf970db6de08c0ec206531c305f7e17508eb0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "68bedfc97625a9af479a21e8a4fcf970db6de08c0ec206531c305f7e17508eb0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "68bedfc97625a9af479a21e8a4fcf970db6de08c0ec206531c305f7e17508eb0", kill_on_drop: false }`
[INFO] [stdout] 68bedfc97625a9af479a21e8a4fcf970db6de08c0ec206531c305f7e17508eb0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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 -Copt-level=3" "-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" "+d073071d77ce0f93b4fd8cc567a1e2b9e1b22126" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 176ce9bc9769133a43be7f93418b3cc348e926c804c1b8b6c4f2508b02d9d1b8
[INFO] running `Command { std: "docker" "start" "-a" "176ce9bc9769133a43be7f93418b3cc348e926c804c1b8b6c4f2508b02d9d1b8", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.146
[INFO] [stderr]    Compiling autocfg v1.1.0
[INFO] [stderr]    Compiling proc-macro2 v1.0.60
[INFO] [stderr]    Compiling quote v1.0.28
[INFO] [stderr]    Compiling unicode-ident v1.0.9
[INFO] [stderr]    Compiling cfg-if v1.0.0
[INFO] [stderr]    Compiling once_cell v1.18.0
[INFO] [stderr]    Compiling pkg-config v0.3.27
[INFO] [stderr]    Compiling cc v1.0.79
[INFO] [stderr]    Compiling parking_lot_core v0.9.8
[INFO] [stderr]    Compiling pin-project-lite v0.2.9
[INFO] [stderr]    Compiling bytes v1.4.0
[INFO] [stderr]    Compiling futures-core v0.3.28
[INFO] [stderr]    Compiling smallvec v1.10.0
[INFO] [stderr]    Compiling scopeguard v1.1.0
[INFO] [stderr]    Compiling itoa v1.0.6
[INFO] [stderr]    Compiling futures-task v0.3.28
[INFO] [stderr]    Compiling tracing-core v0.1.31
[INFO] [stderr]    Compiling lock_api v0.4.10
[INFO] [stderr]    Compiling tokio v1.28.2
[INFO] [stderr]    Compiling syn v2.0.18
[INFO] [stderr]    Compiling signal-hook-registry v1.4.1
[INFO] [stderr]    Compiling mio v0.8.8
[INFO] [stderr]    Compiling parking_lot v0.12.1
[INFO] [stderr]    Compiling socket2 v0.4.9
[INFO] [stderr]    Compiling num_cpus v1.15.0
[INFO] [stderr]    Compiling slab v0.4.8
[INFO] [stderr]    Compiling indexmap v1.9.3
[INFO] [stderr]    Compiling openssl v0.10.54
[INFO] [stderr]    Compiling futures-util v0.3.28
[INFO] [stderr]    Compiling foreign-types-shared v0.1.1
[INFO] [stderr]    Compiling fnv v1.0.7
[INFO] [stderr]    Compiling foreign-types v0.3.2
[INFO] [stderr]    Compiling http v0.2.9
[INFO] [stderr]    Compiling tracing v0.1.37
[INFO] [stderr]    Compiling native-tls v0.2.11
[INFO] [stderr]    Compiling httparse v1.8.0
[INFO] [stderr]    Compiling futures-sink v0.3.28
[INFO] [stderr]    Compiling pin-utils v0.1.0
[INFO] [stderr]    Compiling hashbrown v0.12.3
[INFO] [stderr]    Compiling futures-channel v0.3.28
[INFO] [stderr]    Compiling bitflags v1.3.2
[INFO] [stderr]    Compiling try-lock v0.2.4
[INFO] [stderr]    Compiling openssl-probe v0.1.5
[INFO] [stderr]    Compiling log v0.4.19
[INFO] [stderr]    Compiling http-body v0.4.5
[INFO] [stderr]    Compiling want v0.3.1
[INFO] [stderr]    Compiling tower-service v0.3.2
[INFO] [stderr]    Compiling time-core v0.1.1
[INFO] [stderr]    Compiling httpdate v1.0.2
[INFO] [stderr]    Compiling thiserror v1.0.40
[INFO] [stderr]    Compiling openssl-sys v0.9.88
[INFO] [stderr]    Compiling time v0.3.22
[INFO] [stderr]    Compiling clocksource v0.6.0
[INFO] [stderr]    Compiling tokio-macros v2.1.0
[INFO] [stderr]    Compiling openssl-macros v0.1.1
[INFO] [stderr]    Compiling thiserror-impl v1.0.40
[INFO] [stderr]    Compiling tokio-util v0.7.8
[INFO] [stderr]    Compiling tokio-native-tls v0.3.1
[INFO] [stderr]    Compiling h2 v0.3.19
[INFO] [stderr]    Compiling hyper v0.14.26
[INFO] [stderr]    Compiling hyper-tls v0.5.0
[INFO] [stderr]    Compiling relay v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 47.64s
[INFO] running `Command { std: "docker" "inspect" "176ce9bc9769133a43be7f93418b3cc348e926c804c1b8b6c4f2508b02d9d1b8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "176ce9bc9769133a43be7f93418b3cc348e926c804c1b8b6c4f2508b02d9d1b8", kill_on_drop: false }`
[INFO] [stdout] 176ce9bc9769133a43be7f93418b3cc348e926c804c1b8b6c4f2508b02d9d1b8
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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 -Copt-level=3" "-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" "+d073071d77ce0f93b4fd8cc567a1e2b9e1b22126" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] e9ea124091184d5c6aa1ddeacdab8c4dd46461c7557f17cfde9b98e61e5a0469
[INFO] running `Command { std: "docker" "start" "-a" "e9ea124091184d5c6aa1ddeacdab8c4dd46461c7557f17cfde9b98e61e5a0469", kill_on_drop: false }`
[INFO] [stderr]    Compiling relay v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: the item `Duration` is imported redundantly
[INFO] [stdout]    --> src/ratelimit.rs:307:21
[INFO] [stdout]     |
[INFO] [stdout] 306 |     use crate::*;
[INFO] [stdout]     |         -------- the item `Duration` is already imported here
[INFO] [stdout] 307 |     use std::time::{Duration, Instant};
[INFO] [stdout]     |                     ^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(unused_imports)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 1 warning emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.42s
[INFO] running `Command { std: "docker" "inspect" "e9ea124091184d5c6aa1ddeacdab8c4dd46461c7557f17cfde9b98e61e5a0469", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e9ea124091184d5c6aa1ddeacdab8c4dd46461c7557f17cfde9b98e61e5a0469", kill_on_drop: false }`
[INFO] [stdout] e9ea124091184d5c6aa1ddeacdab8c4dd46461c7557f17cfde9b98e61e5a0469
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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 -Copt-level=3" "-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" "+d073071d77ce0f93b4fd8cc567a1e2b9e1b22126" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] cf651b1a761a341b145d1fb9daa5c31adb2b9e7ab3186e25f7e28bd64ac02959
[INFO] running `Command { std: "docker" "start" "-a" "cf651b1a761a341b145d1fb9daa5c31adb2b9e7ab3186e25f7e28bd64ac02959", kill_on_drop: false }`
[INFO] [stderr] warning: the item `Duration` is imported redundantly
[INFO] [stderr]    --> src/ratelimit.rs:307:21
[INFO] [stderr]     |
[INFO] [stderr] 306 |     use crate::*;
[INFO] [stderr]     |         -------- the item `Duration` is already imported here
[INFO] [stderr] 307 |     use std::time::{Duration, Instant};
[INFO] [stderr]     |                     ^^^^^^^^
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(unused_imports)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `relay` (bin "relay" test) generated 1 warning
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/relay-ee8dbc5bbe8309da)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test ratelimit::tests::rate ... ok
[INFO] [stdout] test ratelimit::tests::wait ... ok
[INFO] [stdout] test ratelimit::tests::idle ... ok
[INFO] [stdout] test ratelimit::tests::capacity ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.10s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "cf651b1a761a341b145d1fb9daa5c31adb2b9e7ab3186e25f7e28bd64ac02959", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "cf651b1a761a341b145d1fb9daa5c31adb2b9e7ab3186e25f7e28bd64ac02959", kill_on_drop: false }`
[INFO] [stdout] cf651b1a761a341b145d1fb9daa5c31adb2b9e7ab3186e25f7e28bd64ac02959