[INFO] fetching crate servlin 0.1.1... [INFO] testing servlin-0.1.1 against try#61cd42370816fd135c0f3b9debf2f5dfcf194594 for pr-98839 [INFO] extracting crate servlin 0.1.1 into /workspace/builds/worker-3/source [INFO] validating manifest of crates.io crate servlin 0.1.1 on toolchain 61cd42370816fd135c0f3b9debf2f5dfcf194594 [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+61cd42370816fd135c0f3b9debf2f5dfcf194594" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate servlin 0.1.1 [INFO] removed 0 missing examples [INFO] finished tweaking crates.io crate servlin 0.1.1 [INFO] tweaked toml for crates.io crate servlin 0.1.1 written to /workspace/builds/worker-3/source/Cargo.toml [INFO] crate crates.io crate servlin 0.1.1 already has a lockfile, it will not be regenerated [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+61cd42370816fd135c0f3b9debf2f5dfcf194594" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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:5873ed620acfc3295992aedd9294443d62a478a48ba243bc5e6c4f5abaffa05f" "/opt/rustwide/cargo-home/bin/cargo" "+61cd42370816fd135c0f3b9debf2f5dfcf194594" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 609af6deb3287ce593939d7ce9cb7545b98abada0264b4f59328fa70a35c85bd [INFO] running `Command { std: "docker" "start" "-a" "609af6deb3287ce593939d7ce9cb7545b98abada0264b4f59328fa70a35c85bd", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "609af6deb3287ce593939d7ce9cb7545b98abada0264b4f59328fa70a35c85bd", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "609af6deb3287ce593939d7ce9cb7545b98abada0264b4f59328fa70a35c85bd", kill_on_drop: false }` [INFO] [stdout] 609af6deb3287ce593939d7ce9cb7545b98abada0264b4f59328fa70a35c85bd [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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:5873ed620acfc3295992aedd9294443d62a478a48ba243bc5e6c4f5abaffa05f" "/opt/rustwide/cargo-home/bin/cargo" "+61cd42370816fd135c0f3b9debf2f5dfcf194594" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] cee79e09cec021bd276dbfbc27b516a371e337d18e31fda88f9ecdd2e10a189c [INFO] running `Command { std: "docker" "start" "-a" "cee79e09cec021bd276dbfbc27b516a371e337d18e31fda88f9ecdd2e10a189c", kill_on_drop: false }` [INFO] [stderr] Compiling futures-core v0.3.21 [INFO] [stderr] Compiling memchr v2.5.0 [INFO] [stderr] Compiling libc v0.2.126 [INFO] [stderr] Compiling cache-padded v1.2.0 [INFO] [stderr] Compiling futures-io v0.3.21 [INFO] [stderr] Compiling safe-proc-macro2 v1.0.36 [INFO] [stderr] Compiling waker-fn v1.1.0 [INFO] [stderr] Compiling fastrand v1.7.0 [INFO] [stderr] Compiling pin-project-lite v0.2.9 [INFO] [stderr] Compiling once_cell v1.12.0 [INFO] [stderr] Compiling parking v2.0.0 [INFO] [stderr] Compiling unicode-xid v0.2.3 [INFO] [stderr] Compiling event-listener v2.5.2 [INFO] [stderr] Compiling log v0.4.17 [INFO] [stderr] Compiling tinyvec_macros v0.1.0 [INFO] [stderr] Compiling cfg-if v1.0.0 [INFO] [stderr] Compiling atomic-waker v1.0.0 [INFO] [stderr] Compiling matches v0.1.9 [INFO] [stderr] Compiling async-task v4.2.0 [INFO] [stderr] Compiling unicode-bidi v0.3.8 [INFO] [stderr] Compiling percent-encoding v2.1.0 [INFO] [stderr] Compiling slab v0.4.6 [INFO] [stderr] Compiling safina-sync v0.2.4 [INFO] [stderr] Compiling safina-threadpool v0.2.4 [INFO] [stderr] Compiling temp-dir v0.1.11 [INFO] [stderr] Compiling permit v0.1.4 [INFO] [stderr] Compiling temp-file v0.1.7 [INFO] [stderr] Compiling concurrent-queue v1.2.2 [INFO] [stderr] Compiling tinyvec v1.6.0 [INFO] [stderr] Compiling fixed-buffer v0.5.0 [INFO] [stderr] Compiling async-lock v2.5.0 [INFO] [stderr] Compiling safina-timer v0.1.11 [INFO] [stderr] Compiling form_urlencoded v1.0.1 [INFO] [stderr] Compiling safina-executor v0.3.3 [INFO] [stderr] Compiling async-channel v1.6.1 [INFO] [stderr] Compiling futures-lite v1.12.0 [INFO] [stderr] Compiling safe-quote v1.0.15 [INFO] [stderr] Compiling safe-regex-compiler v0.2.5 [INFO] [stderr] Compiling polling v2.2.0 [INFO] [stderr] Compiling socket2 v0.4.4 [INFO] [stderr] Compiling unicode-normalization v0.1.20 [INFO] [stderr] Compiling blocking v1.2.0 [INFO] [stderr] Compiling safe-regex-macro v0.2.5 [INFO] [stderr] Compiling async-fs v1.5.0 [INFO] [stderr] Compiling async-io v1.7.0 [INFO] [stderr] Compiling idna v0.2.3 [INFO] [stderr] Compiling async-net v1.6.1 [INFO] [stderr] Compiling safe-regex v0.2.5 [INFO] [stderr] Compiling url v2.2.2 [INFO] [stderr] Compiling servlin v0.1.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 6.35s [INFO] running `Command { std: "docker" "inspect" "cee79e09cec021bd276dbfbc27b516a371e337d18e31fda88f9ecdd2e10a189c", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "cee79e09cec021bd276dbfbc27b516a371e337d18e31fda88f9ecdd2e10a189c", kill_on_drop: false }` [INFO] [stdout] cee79e09cec021bd276dbfbc27b516a371e337d18e31fda88f9ecdd2e10a189c [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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:5873ed620acfc3295992aedd9294443d62a478a48ba243bc5e6c4f5abaffa05f" "/opt/rustwide/cargo-home/bin/cargo" "+61cd42370816fd135c0f3b9debf2f5dfcf194594" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] bd63ccc00094664cb947642916f0601c236db2f694c3219a769b3dc3bcc9d5e4 [INFO] running `Command { std: "docker" "start" "-a" "bd63ccc00094664cb947642916f0601c236db2f694c3219a769b3dc3bcc9d5e4", kill_on_drop: false }` [INFO] [stderr] Compiling servlin v0.1.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 36.24s [INFO] running `Command { std: "docker" "inspect" "bd63ccc00094664cb947642916f0601c236db2f694c3219a769b3dc3bcc9d5e4", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "bd63ccc00094664cb947642916f0601c236db2f694c3219a769b3dc3bcc9d5e4", kill_on_drop: false }` [INFO] [stdout] bd63ccc00094664cb947642916f0601c236db2f694c3219a769b3dc3bcc9d5e4 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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:5873ed620acfc3295992aedd9294443d62a478a48ba243bc5e6c4f5abaffa05f" "/opt/rustwide/cargo-home/bin/cargo" "+61cd42370816fd135c0f3b9debf2f5dfcf194594" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 0e5191afe0c0aed57af79f407ad8e1b34b70c04e8027208a7f15846b4788a349 [INFO] running `Command { std: "docker" "start" "-a" "0e5191afe0c0aed57af79f407ad8e1b34b70c04e8027208a7f15846b4788a349", kill_on_drop: false }` [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.20s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/servlin-d859ea79a4f126eb) [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/cookie.rs (/opt/rustwide/target/debug/deps/cookie-53d4bb9a48990e13) [INFO] [stdout] [INFO] [stdout] running 10 tests [INFO] [stdout] test new ... ok [INFO] [stdout] test empty_value ... ok [INFO] [stdout] test with_domain ... ok [INFO] [stdout] test with_expires ... ok [INFO] [stdout] test with_max_age ... ok [INFO] [stdout] test with_http_only_true ... ok [INFO] [stdout] test with_path ... ok [INFO] [stdout] test with_same_site ... ok [INFO] [stdout] test with_secure ... ok [INFO] [stdout] test empty_name_should_panic - should panic ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.70s [INFO] [stdout] [INFO] [stderr] Running tests/event.rs (/opt/rustwide/target/debug/deps/event-ca243ae4d6c25a15) [INFO] [stdout] [INFO] [stdout] running 4 tests [INFO] [stdout] test single_message ... ok [INFO] [stdout] test already_closed ... ok [INFO] [stdout] test empty ... ok [INFO] [stderr] Running tests/handler.rs (/opt/rustwide/target/debug/deps/handler-df3d194cf2a2fb61) [INFO] [stdout] test multiple_messages ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.45s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 29 tests [INFO] [stdout] test empty ... ok [INFO] [stdout] test body_not_pending ... ok [INFO] [stdout] test chunked_not_last ... ok [INFO] [stdout] test content_length_zero ... ok [INFO] [stdout] test fast_reply ... ok [INFO] [stdout] test chunked_not_supported ... ok [INFO] [stdout] test duplicate_content_length_header ... ok [INFO] [stdout] test return_drop ... ok [INFO] [stdout] test text ... ok [INFO] [stdout] test error_writing_body_file ... ok [INFO] [stdout] test method_not_allowed_405 ... ok [INFO] [stdout] test already_got_body ... ok [INFO] [stdout] test with_status ... ok [INFO] [stdout] test with_duplicate_header ... ok [INFO] [stdout] test with_body ... ok [INFO] [stdout] test duplicate_content_type_header ... ok [INFO] [stdout] test with_duplicate_header_different_case ... ok [INFO] [stdout] test with_type_and_body ... ok [INFO] [stdout] test with_type ... ok [INFO] [stdout] test unsupported_transfer_encoding ... ok [INFO] [stdout] test with_header ... ok [INFO] [stdout] test unknown_code ... ok [INFO] [stdout] test error_reading_body_file ... FAILED [INFO] [stdout] test panics ... ok [INFO] [stdout] test slow_reply ... FAILED [INFO] [stdout] test client_incomplete_read ... ok [INFO] [stdout] test get_body_then_drop ... ok [INFO] [stdout] test expect_100_continue ... ok [INFO] [stdout] test get_body ... ok [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- error_reading_body_file stdout ---- [INFO] [stdout] thread 'error_reading_body_file' panicked at 'assertion failed: `(left == right)` [INFO] [stdout] left: `"HTTP/1.1 500 Internal Server Error\r\ncontent-type: text/plain; charset=UTF-8\r\ncontent-length: 21\r\n\r\nInternal server error"`, [INFO] [stdout] right: `"HTTP/1.1 500 Internal Server Error\r\ncontent-type: text/plain; charset=UTF-8\r\ncontent-length: 12\r\n\r\nServer error"`', tests/handler.rs:287:5 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x55ad1502fe60 - std::backtrace_rs::backtrace::libunwind::trace::h385ffbf574363e81 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 1: 0x55ad1502fe60 - std::backtrace_rs::backtrace::trace_unsynchronized::h1d1dbabbc7babee7 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x55ad1502fe60 - std::sys_common::backtrace::_print_fmt::h3fd7a321b650d311 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/sys_common/backtrace.rs:66:5 [INFO] [stdout] 3: 0x55ad1502fe60 - ::fmt::h9c5fc513eb6f6c7a [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/sys_common/backtrace.rs:45:22 [INFO] [stdout] 4: 0x55ad1505393c - core::fmt::write::h149259a69b3e2f89 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/core/src/fmt/mod.rs:1198:17 [INFO] [stdout] 5: 0x55ad1502b945 - std::io::Write::write_fmt::h6d11f4b16fd2c9e6 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/io/mod.rs:1672:15 [INFO] [stdout] 6: 0x55ad150318d1 - std::sys_common::backtrace::_print::h350a49f9ba10dc38 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/sys_common/backtrace.rs:48:5 [INFO] [stdout] 7: 0x55ad150318d1 - std::sys_common::backtrace::print::hc9483bcde74add9a [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/sys_common/backtrace.rs:35:9 [INFO] [stdout] 8: 0x55ad150318d1 - std::panicking::default_hook::{{closure}}::h033c319db21062da [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/panicking.rs:295:22 [INFO] [stdout] 9: 0x55ad15031526 - std::panicking::default_hook::h082702b84ddf9cba [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/panicking.rs:311:9 [INFO] [stdout] 10: 0x55ad15031f73 - std::panicking::rust_panic_with_hook::hb5031567964b2362 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/panicking.rs:698:17 [INFO] [stdout] 11: 0x55ad15031e67 - std::panicking::begin_panic_handler::{{closure}}::h040f81592aed215a [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/panicking.rs:588:13 [INFO] [stdout] 12: 0x55ad15030334 - std::sys_common::backtrace::__rust_end_short_backtrace::hb55752442d66befe [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/sys_common/backtrace.rs:138:18 [INFO] [stdout] 13: 0x55ad15031b92 - rust_begin_unwind [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/panicking.rs:584:5 [INFO] [stdout] 14: 0x55ad14ceeec3 - core::panicking::panic_fmt::hab8e33512c332233 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/core/src/panicking.rs:142:14 [INFO] [stdout] 15: 0x55ad15052468 - core::panicking::assert_failed_inner::haa5b9f0d3dbc28b3 [INFO] [stdout] 16: 0x55ad14d792be - core::panicking::assert_failed::h56a671ad17189190 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/core/src/panicking.rs:181:5 [INFO] [stdout] 17: 0x55ad14d74343 - handler::error_reading_body_file::hddfc20316e2227a9 [INFO] [stdout] at /opt/rustwide/workdir/tests/handler.rs:287:5 [INFO] [stdout] 18: 0x55ad14d7410a - handler::error_reading_body_file::{{closure}}::h8a2fdf041ee563c7 [INFO] [stdout] at /opt/rustwide/workdir/tests/handler.rs:273:1 [INFO] [stdout] 19: 0x55ad14da206e - core::ops::function::FnOnce::call_once::h5c4d325416776c16 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/core/src/ops/function.rs:248:5 [INFO] [stdout] 20: 0x55ad14ea9463 - core::ops::function::FnOnce::call_once::ha7afe1ddf9a8665b [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/core/src/ops/function.rs:248:5 [INFO] [stdout] 21: 0x55ad14ea9463 - test::__rust_begin_short_backtrace::h02df713062fe0d09 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/test/src/lib.rs:572:5 [INFO] [stdout] 22: 0x55ad14ea825c - as core::ops::function::FnOnce>::call_once::h4f2b36c78ff85792 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/alloc/src/boxed.rs:1934:9 [INFO] [stdout] 23: 0x55ad14ea825c - as core::ops::function::FnOnce<()>>::call_once::h8624c6094a076c25 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/core/src/panic/unwind_safe.rs:271:9 [INFO] [stdout] 24: 0x55ad14ea825c - std::panicking::try::do_call::h0c501a0f7fa5bee0 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/panicking.rs:492:40 [INFO] [stdout] 25: 0x55ad14ea825c - std::panicking::try::h60ab49b272d3e4f0 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/panicking.rs:456:19 [INFO] [stdout] 26: 0x55ad14ea825c - std::panic::catch_unwind::h5f34d55961997ae8 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/panic.rs:137:14 [INFO] [stdout] 27: 0x55ad14ea825c - test::run_test_in_process::hcf99044408a39ffa [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/test/src/lib.rs:595:18 [INFO] [stdout] 28: 0x55ad14ea825c - test::run_test::run_test_inner::{{closure}}::h5f747e7c34969277 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/test/src/lib.rs:489:39 [INFO] [stdout] 29: 0x55ad14e741cc - test::run_test::run_test_inner::{{closure}}::hfbc9b7f814e7611c [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/test/src/lib.rs:516:37 [INFO] [stdout] 30: 0x55ad14e741cc - std::sys_common::backtrace::__rust_begin_short_backtrace::hc864e8be9763567e [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/sys_common/backtrace.rs:122:18 [INFO] [stdout] 31: 0x55ad14e7a0df - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::h635fae7f98a9851a [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/thread/mod.rs:505:17 [INFO] [stdout] 32: 0x55ad14e7a0df - as core::ops::function::FnOnce<()>>::call_once::hb0e77e0fbf0b74e7 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/core/src/panic/unwind_safe.rs:271:9 [INFO] [stdout] 33: 0x55ad14e7a0df - std::panicking::try::do_call::h843a2c7f433b6950 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/panicking.rs:492:40 [INFO] [stdout] 34: 0x55ad14e7a0df - std::panicking::try::h64dfa5d8b1ef556f [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/panicking.rs:456:19 [INFO] [stdout] 35: 0x55ad14e7a0df - std::panic::catch_unwind::h3af2f5bf220b9738 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/panic.rs:137:14 [INFO] [stdout] 36: 0x55ad14e7a0df - std::thread::Builder::spawn_unchecked_::{{closure}}::h8fd0a07746213f59 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/thread/mod.rs:504:30 [INFO] [stdout] 37: 0x55ad14e7a0df - core::ops::function::FnOnce::call_once{{vtable.shim}}::h589aaf080555aafb [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/core/src/ops/function.rs:248:5 [INFO] [stdout] 38: 0x55ad15036de3 - as core::ops::function::FnOnce>::call_once::h4a4c573311170bd5 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/alloc/src/boxed.rs:1934:9 [INFO] [stdout] 39: 0x55ad15036de3 - as core::ops::function::FnOnce>::call_once::h4c3a154b8915668e [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/alloc/src/boxed.rs:1934:9 [INFO] [stdout] 40: 0x55ad15036de3 - std::sys::unix::thread::Thread::new::thread_start::h9d4e5992c5fda7ce [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/sys/unix/thread.rs:108:17 [INFO] [stdout] 41: 0x7f6a8859f609 - start_thread [INFO] [stdout] 42: 0x7f6a8836f133 - clone [INFO] [stdout] 43: 0x0 - [INFO] [stdout] [INFO] [stdout] ---- slow_reply stdout ---- [INFO] [stdout] thread 'slow_reply' panicked at 'called `Result::unwrap()` on an `Err` value: "377.09495ms elapsed, out of range 100ms..200ms"', tests/handler.rs:311:37 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x55ad1502fe60 - std::backtrace_rs::backtrace::libunwind::trace::h385ffbf574363e81 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 1: 0x55ad1502fe60 - std::backtrace_rs::backtrace::trace_unsynchronized::h1d1dbabbc7babee7 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x55ad1502fe60 - std::sys_common::backtrace::_print_fmt::h3fd7a321b650d311 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/sys_common/backtrace.rs:66:5 [INFO] [stdout] 3: 0x55ad1502fe60 - ::fmt::h9c5fc513eb6f6c7a [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/sys_common/backtrace.rs:45:22 [INFO] [stdout] 4: 0x55ad1505393c - core::fmt::write::h149259a69b3e2f89 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/core/src/fmt/mod.rs:1198:17 [INFO] [stdout] 5: 0x55ad1502b945 - std::io::Write::write_fmt::h6d11f4b16fd2c9e6 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/io/mod.rs:1672:15 [INFO] [stdout] 6: 0x55ad150318d1 - std::sys_common::backtrace::_print::h350a49f9ba10dc38 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/sys_common/backtrace.rs:48:5 [INFO] [stdout] 7: 0x55ad150318d1 - std::sys_common::backtrace::print::hc9483bcde74add9a [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/sys_common/backtrace.rs:35:9 [INFO] [stdout] 8: 0x55ad150318d1 - std::panicking::default_hook::{{closure}}::h033c319db21062da [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/panicking.rs:295:22 [INFO] [stdout] 9: 0x55ad15031526 - std::panicking::default_hook::h082702b84ddf9cba [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/panicking.rs:311:9 [INFO] [stdout] 10: 0x55ad15031f73 - std::panicking::rust_panic_with_hook::hb5031567964b2362 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/panicking.rs:698:17 [INFO] [stdout] 11: 0x55ad15031e67 - std::panicking::begin_panic_handler::{{closure}}::h040f81592aed215a [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/panicking.rs:588:13 [INFO] [stdout] 12: 0x55ad15030334 - std::sys_common::backtrace::__rust_end_short_backtrace::hb55752442d66befe [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/sys_common/backtrace.rs:138:18 [INFO] [stdout] 13: 0x55ad15031b92 - rust_begin_unwind [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/panicking.rs:584:5 [INFO] [stdout] 14: 0x55ad14ceeec3 - core::panicking::panic_fmt::hab8e33512c332233 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/core/src/panicking.rs:142:14 [INFO] [stdout] 15: 0x55ad14ceefb3 - core::result::unwrap_failed::ha596fafa7ca6c65c [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/core/src/result.rs:1805:5 [INFO] [stdout] 16: 0x55ad14d96521 - core::result::Result::unwrap::hbe368b852835dcfa [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/core/src/result.rs:1098:23 [INFO] [stdout] 17: 0x55ad14d74900 - handler::slow_reply::hfb9be6f4e3ae3f5b [INFO] [stdout] at /opt/rustwide/workdir/tests/handler.rs:311:5 [INFO] [stdout] 18: 0x55ad14d7479a - handler::slow_reply::{{closure}}::h592bfa71563ba2e0 [INFO] [stdout] at /opt/rustwide/workdir/tests/handler.rs:303:1 [INFO] [stdout] 19: 0x55ad14da244e - core::ops::function::FnOnce::call_once::hbc3f7542ee5d7f27 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/core/src/ops/function.rs:248:5 [INFO] [stdout] 20: 0x55ad14ea9463 - core::ops::function::FnOnce::call_once::ha7afe1ddf9a8665b [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/core/src/ops/function.rs:248:5 [INFO] [stdout] 21: 0x55ad14ea9463 - test::__rust_begin_short_backtrace::h02df713062fe0d09 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/test/src/lib.rs:572:5 [INFO] [stdout] 22: 0x55ad14ea825c - as core::ops::function::FnOnce>::call_once::h4f2b36c78ff85792 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/alloc/src/boxed.rs:1934:9 [INFO] [stdout] 23: 0x55ad14ea825c - as core::ops::function::FnOnce<()>>::call_once::h8624c6094a076c25 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/core/src/panic/unwind_safe.rs:271:9 [INFO] [stdout] 24: 0x55ad14ea825c - std::panicking::try::do_call::h0c501a0f7fa5bee0 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/panicking.rs:492:40 [INFO] [stdout] 25: 0x55ad14ea825c - std::panicking::try::h60ab49b272d3e4f0 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/panicking.rs:456:19 [INFO] [stdout] 26: 0x55ad14ea825c - std::panic::catch_unwind::h5f34d55961997ae8 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/panic.rs:137:14 [INFO] [stdout] 27: 0x55ad14ea825c - test::run_test_in_process::hcf99044408a39ffa [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/test/src/lib.rs:595:18 [INFO] [stdout] 28: 0x55ad14ea825c - test::run_test::run_test_inner::{{closure}}::h5f747e7c34969277 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/test/src/lib.rs:489:39 [INFO] [stdout] 29: 0x55ad14e741cc - test::run_test::run_test_inner::{{closure}}::hfbc9b7f814e7611c [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/test/src/lib.rs:516:37 [INFO] [stdout] 30: 0x55ad14e741cc - std::sys_common::backtrace::__rust_begin_short_backtrace::hc864e8be9763567e [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/sys_common/backtrace.rs:122:18 [INFO] [stdout] 31: 0x55ad14e7a0df - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::h635fae7f98a9851a [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/thread/mod.rs:505:17 [INFO] [stdout] 32: 0x55ad14e7a0df - as core::ops::function::FnOnce<()>>::call_once::hb0e77e0fbf0b74e7 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/core/src/panic/unwind_safe.rs:271:9 [INFO] [stdout] 33: 0x55ad14e7a0df - std::panicking::try::do_call::h843a2c7f433b6950 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/panicking.rs:492:40 [INFO] [stdout] 34: 0x55ad14e7a0df - std::panicking::try::h64dfa5d8b1ef556f [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/panicking.rs:456:19 [INFO] [stdout] 35: 0x55ad14e7a0df - std::panic::catch_unwind::h3af2f5bf220b9738 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/panic.rs:137:14 [INFO] [stdout] 36: 0x55ad14e7a0df - std::thread::Builder::spawn_unchecked_::{{closure}}::h8fd0a07746213f59 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/thread/mod.rs:504:30 [INFO] [stdout] 37: 0x55ad14e7a0df - core::ops::function::FnOnce::call_once{{vtable.shim}}::h589aaf080555aafb [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/core/src/ops/function.rs:248:5 [INFO] [stdout] 38: 0x55ad15036de3 - as core::ops::function::FnOnce>::call_once::h4a4c573311170bd5 [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/alloc/src/boxed.rs:1934:9 [INFO] [stdout] 39: 0x55ad15036de3 - as core::ops::function::FnOnce>::call_once::h4c3a154b8915668e [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/alloc/src/boxed.rs:1934:9 [INFO] [stdout] 40: 0x55ad15036de3 - std::sys::unix::thread::Thread::new::thread_start::h9d4e5992c5fda7ce [INFO] [stdout] at /rustc/61cd42370816fd135c0f3b9debf2f5dfcf194594/library/std/src/sys/unix/thread.rs:108:17 [INFO] [stdout] 41: 0x7f6a8859f609 - start_thread [INFO] [stdout] 42: 0x7f6a8836f133 - clone [INFO] [stdout] 43: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] error_reading_body_file [INFO] [stdout] slow_reply [INFO] [stdout] [INFO] [stdout] test result: FAILED. 27 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.07s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass '--test handler' [INFO] running `Command { std: "docker" "inspect" "0e5191afe0c0aed57af79f407ad8e1b34b70c04e8027208a7f15846b4788a349", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "0e5191afe0c0aed57af79f407ad8e1b34b70c04e8027208a7f15846b4788a349", kill_on_drop: false }` [INFO] [stdout] 0e5191afe0c0aed57af79f407ad8e1b34b70c04e8027208a7f15846b4788a349