[INFO] cloning repository https://github.com/sanevillain/server-from-scratch
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/sanevillain/server-from-scratch" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fsanevillain%2Fserver-from-scratch", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fsanevillain%2Fserver-from-scratch'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] daa5e990d4f825086fcf41a78f1832333aca6b2b
[INFO] testing sanevillain/server-from-scratch against try#ce59db7a1b1b012fb2793c4641c1bdecad7a128b for pr-85530
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fsanevillain%2Fserver-from-scratch" "/workspace/builds/worker-8/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-8/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/sanevillain/server-from-scratch on toolchain ce59db7a1b1b012fb2793c4641c1bdecad7a128b
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+ce59db7a1b1b012fb2793c4641c1bdecad7a128b" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/sanevillain/server-from-scratch
[INFO] finished tweaking git repo https://github.com/sanevillain/server-from-scratch
[INFO] tweaked toml for git repo https://github.com/sanevillain/server-from-scratch written to /workspace/builds/worker-8/source/Cargo.toml
[INFO] crate git repo https://github.com/sanevillain/server-from-scratch already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+ce59db7a1b1b012fb2793c4641c1bdecad7a128b" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/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:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+ce59db7a1b1b012fb2793c4641c1bdecad7a128b" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 82a1020a51145ca753c550aaa9983152ba93a749b0e15c45a696a4d778d983b3
[INFO] running `Command { std: "docker" "start" "-a" "82a1020a51145ca753c550aaa9983152ba93a749b0e15c45a696a4d778d983b3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "82a1020a51145ca753c550aaa9983152ba93a749b0e15c45a696a4d778d983b3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "82a1020a51145ca753c550aaa9983152ba93a749b0e15c45a696a4d778d983b3", kill_on_drop: false }`
[INFO] [stdout] 82a1020a51145ca753c550aaa9983152ba93a749b0e15c45a696a4d778d983b3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/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" "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:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+ce59db7a1b1b012fb2793c4641c1bdecad7a128b" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 79669926175e34aba5e0d5c94fd142a7fb65a7e04322edc90318a2adf2ff1542
[INFO] running `Command { std: "docker" "start" "-a" "79669926175e34aba5e0d5c94fd142a7fb65a7e04322edc90318a2adf2ff1542", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling libc v0.2.77
[INFO] [stderr]    Compiling nix v0.17.0
[INFO] [stderr]    Compiling nix v0.18.0
[INFO] [stderr]    Compiling void v1.0.2
[INFO] [stderr]    Compiling num-traits v0.2.12
[INFO] [stderr]    Compiling num-integer v0.1.43
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling time v0.1.44
[INFO] [stderr]    Compiling env_logger v0.6.2
[INFO] [stderr]    Compiling chrono v0.4.19
[INFO] [stderr]    Compiling pretty_env_logger v0.3.1
[INFO] [stderr]    Compiling ctrlc v3.1.6
[INFO] [stderr]    Compiling server-from-scratch v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 12.22s
[INFO] running `Command { std: "docker" "inspect" "79669926175e34aba5e0d5c94fd142a7fb65a7e04322edc90318a2adf2ff1542", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "79669926175e34aba5e0d5c94fd142a7fb65a7e04322edc90318a2adf2ff1542", kill_on_drop: false }`
[INFO] [stdout] 79669926175e34aba5e0d5c94fd142a7fb65a7e04322edc90318a2adf2ff1542
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/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" "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:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+ce59db7a1b1b012fb2793c4641c1bdecad7a128b" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 139d61523a1b906563cde8e7e21b64730e0d8d477027134aba4695d64ebc56c8
[INFO] running `Command { std: "docker" "start" "-a" "139d61523a1b906563cde8e7e21b64730e0d8d477027134aba4695d64ebc56c8", kill_on_drop: false }`
[INFO] [stderr]    Compiling server-from-scratch v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 1.47s
[INFO] running `Command { std: "docker" "inspect" "139d61523a1b906563cde8e7e21b64730e0d8d477027134aba4695d64ebc56c8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "139d61523a1b906563cde8e7e21b64730e0d8d477027134aba4695d64ebc56c8", kill_on_drop: false }`
[INFO] [stdout] 139d61523a1b906563cde8e7e21b64730e0d8d477027134aba4695d64ebc56c8
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/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" "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:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+ce59db7a1b1b012fb2793c4641c1bdecad7a128b" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 9bded43f07635973263a5d311394229f17a6f5829f83e27bddb1e560ed28bf08
[INFO] running `Command { std: "docker" "start" "-a" "9bded43f07635973263a5d311394229f17a6f5829f83e27bddb1e560ed28bf08", 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]     Finished test [unoptimized + debuginfo] target(s) in 3.99s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/server_from_scratch-a678253f60593a6e)
[INFO] [stdout] 
[INFO] [stdout] running 17 tests
[INFO] [stdout] test http::header::test_from_str::test_from_str_should_return_io_error_on_invalid_method ... ok
[INFO] [stdout] test http::header::test_from_str::test_from_str_should_return_io_error_on_invalid_input ... ok
[INFO] [stdout] test http::header::test_method_add_and_get::test_get_non_existing_key_should_return_none ... ok
[INFO] [stdout] test http::header::test_from_str::test_from_str_should_split_add_all_header_values ... ok
[INFO] [stdout] test http::header::test_from_str::test_from_str_should_store_header_key_value ... ok
[INFO] [stdout] test http::header::test_method_del::test_del_key_should_delete_asociated_value ... ok
[INFO] [stdout] test http::header::test_from_str::test_from_str_should_return_io_error_on_invalid_url ... ok
[INFO] [stdout] test http::header::test_to_string::test_to_string_with_multiple_values ... ok
[INFO] [stdout] test http::header::test_from_str::test_from_str_should_skip_first_line ... ok
[INFO] [stdout] test http::header::test_method_del::test_del_key_should_delete_all_asociated_values ... ok
[INFO] [stdout] test http::header::test_method_add_and_get::test_get_with_multiple_values_should_return_first ... ok
[INFO] [stdout] test http::header::test_from_str::test_from_str_should_return_io_error_on_unsupported_http_version ... ok
[INFO] [stdout] test http::header::test_method_add_and_get::test_add_should_only_add_alphanumeric_keys ... ok
[INFO] [stdout] test http::header::test_to_string::test_to_string_should_return_io_error_on_invalid_line ... ok
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/server_from_scratch-cbbd59b45e59ab6d)
[INFO] [stdout] test http::header::test_method_values::test_values_for_existing_key_should_return_vec_for_multiple_values ... ok
[INFO] [stderr]    Doc-tests server-from-scratch
[INFO] [stdout] test http::header::test_method_values::test_values_for_non_existing_entry_should_return_none ... ok
[INFO] [stdout] test http::header::test_method_values::test_values_for_existing_key_should_return_vec_with_single_value ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 17 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] [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" "9bded43f07635973263a5d311394229f17a6f5829f83e27bddb1e560ed28bf08", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9bded43f07635973263a5d311394229f17a6f5829f83e27bddb1e560ed28bf08", kill_on_drop: false }`
[INFO] [stdout] 9bded43f07635973263a5d311394229f17a6f5829f83e27bddb1e560ed28bf08