[INFO] cloning repository https://github.com/MaxBondABE/attempt [INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/MaxBondABE/attempt" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FMaxBondABE%2Fattempt", kill_on_drop: false }` [INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FMaxBondABE%2Fattempt'... [INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }` [INFO] [stdout] 91296fd8e0ef9940a9f9c10abdbfd689822c0ef2 [INFO] testing MaxBondABE/attempt against try#bd7d74411512a3dd3b35d2f699c51dd2557c7e7e+cargoflags=-Zbuild-dir-new-layout for pr-149852-1 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FMaxBondABE%2Fattempt" "/workspace/builds/worker-3-tc2/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-3-tc2/source'... [INFO] [stderr] done. [INFO] started tweaking git repo https://github.com/MaxBondABE/attempt [INFO] finished tweaking git repo https://github.com/MaxBondABE/attempt [INFO] tweaked toml for git repo https://github.com/MaxBondABE/attempt written to /workspace/builds/worker-3-tc2/source/Cargo.toml [INFO] validating manifest of git repo https://github.com/MaxBondABE/attempt on toolchain bd7d74411512a3dd3b35d2f699c51dd2557c7e7e [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+bd7d74411512a3dd3b35d2f699c51dd2557c7e7e" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] crate git repo https://github.com/MaxBondABE/attempt 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" "+bd7d74411512a3dd3b35d2f699c51dd2557c7e7e" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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:aa71247004a7fa38d13ec170f48f06cdedf5bc50b2a8645e56ed7e992e6fa513" "/opt/rustwide/cargo-home/bin/cargo" "+bd7d74411512a3dd3b35d2f699c51dd2557c7e7e" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 1dbdd6f8043574d98f4d687bb4533ff614c02f77febb32d481ad05ed51e22338 [INFO] running `Command { std: "docker" "start" "-a" "1dbdd6f8043574d98f4d687bb4533ff614c02f77febb32d481ad05ed51e22338", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "1dbdd6f8043574d98f4d687bb4533ff614c02f77febb32d481ad05ed51e22338", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "1dbdd6f8043574d98f4d687bb4533ff614c02f77febb32d481ad05ed51e22338", kill_on_drop: false }` [INFO] [stdout] 1dbdd6f8043574d98f4d687bb4533ff614c02f77febb32d481ad05ed51e22338 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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:aa71247004a7fa38d13ec170f48f06cdedf5bc50b2a8645e56ed7e992e6fa513" "/opt/rustwide/cargo-home/bin/cargo" "+bd7d74411512a3dd3b35d2f699c51dd2557c7e7e" "build" "--frozen" "--message-format=json" "-Zbuild-dir-new-layout", kill_on_drop: false }` [INFO] [stdout] cbc2cbcadd16f153aef36cf07e47762f78fed02b68010b7f3654c61e7618ea2d [INFO] running `Command { std: "docker" "start" "-a" "cbc2cbcadd16f153aef36cf07e47762f78fed02b68010b7f3654c61e7618ea2d", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.101 [INFO] [stderr] Compiling libc v0.2.175 [INFO] [stderr] Compiling unicode-ident v1.0.18 [INFO] [stderr] Compiling zerocopy v0.8.27 [INFO] [stderr] Compiling cfg-if v1.0.3 [INFO] [stderr] Compiling libm v0.2.15 [INFO] [stderr] Compiling autocfg v1.5.0 [INFO] [stderr] Compiling utf8parse v0.2.2 [INFO] [stderr] Compiling anstyle v1.0.11 [INFO] [stderr] Compiling is_terminal_polyfill v1.70.1 [INFO] [stderr] Compiling memchr v2.7.5 [INFO] [stderr] Compiling anstyle-query v1.1.4 [INFO] [stderr] Compiling colorchoice v1.0.4 [INFO] [stderr] Compiling heck v0.5.0 [INFO] [stderr] Compiling thiserror v1.0.69 [INFO] [stderr] Compiling clap_lex v0.7.5 [INFO] [stderr] Compiling regex-syntax v0.8.6 [INFO] [stderr] Compiling strsim v0.11.1 [INFO] [stderr] Compiling anstyle-parse v0.2.7 [INFO] [stderr] Compiling anyhow v1.0.99 [INFO] [stderr] Compiling log v0.4.28 [INFO] [stderr] Compiling anstream v0.6.20 [INFO] [stderr] Compiling num-traits v0.2.19 [INFO] [stderr] Compiling clap_builder v4.5.47 [INFO] [stderr] Compiling quote v1.0.40 [INFO] [stderr] Compiling aho-corasick v1.1.3 [INFO] [stderr] Compiling syn v2.0.106 [INFO] [stderr] Compiling getrandom v0.2.16 [INFO] [stderr] Compiling rand_core v0.6.4 [INFO] [stderr] Compiling ppv-lite86 v0.2.21 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling regex-automata v0.4.10 [INFO] [stderr] Compiling rand v0.8.5 [INFO] [stderr] Compiling rand_distr v0.4.3 [INFO] [stderr] Compiling clap_derive v4.5.47 [INFO] [stderr] Compiling thiserror-impl v1.0.69 [INFO] [stderr] Compiling regex v1.11.2 [INFO] [stderr] Compiling clap v4.5.47 [INFO] [stderr] Compiling attempt-cli v1.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 23.17s [INFO] running `Command { std: "docker" "inspect" "cbc2cbcadd16f153aef36cf07e47762f78fed02b68010b7f3654c61e7618ea2d", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "cbc2cbcadd16f153aef36cf07e47762f78fed02b68010b7f3654c61e7618ea2d", kill_on_drop: false }` [INFO] [stdout] cbc2cbcadd16f153aef36cf07e47762f78fed02b68010b7f3654c61e7618ea2d [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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:aa71247004a7fa38d13ec170f48f06cdedf5bc50b2a8645e56ed7e992e6fa513" "/opt/rustwide/cargo-home/bin/cargo" "+bd7d74411512a3dd3b35d2f699c51dd2557c7e7e" "test" "--frozen" "--no-run" "--message-format=json" "-Zbuild-dir-new-layout", kill_on_drop: false }` [INFO] [stdout] 10c510b6d5301abf957463a52b63f413b3e137f965fe019160bd8c68c9865779 [INFO] running `Command { std: "docker" "start" "-a" "10c510b6d5301abf957463a52b63f413b3e137f965fe019160bd8c68c9865779", kill_on_drop: false }` [INFO] [stderr] Compiling libc v0.2.175 [INFO] [stderr] Compiling predicates-core v1.0.9 [INFO] [stderr] Compiling doc-comment v0.3.3 [INFO] [stderr] Compiling assert_cmd v2.0.17 [INFO] [stderr] Compiling difflib v0.4.0 [INFO] [stderr] Compiling regex-automata v0.4.10 [INFO] [stderr] Compiling normalize-line-endings v0.3.0 [INFO] [stderr] Compiling termtree v0.5.1 [INFO] [stderr] Compiling once_cell v1.21.3 [INFO] [stderr] Compiling float-cmp v0.10.0 [INFO] [stderr] Compiling predicates-tree v1.0.12 [INFO] [stderr] Compiling getrandom v0.2.16 [INFO] [stderr] Compiling wait-timeout v0.2.1 [INFO] [stderr] Compiling rand_core v0.6.4 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling rand v0.8.5 [INFO] [stderr] Compiling rand_distr v0.4.3 [INFO] [stderr] Compiling regex v1.11.2 [INFO] [stderr] Compiling bstr v1.12.0 [INFO] [stderr] Compiling predicates v3.1.3 [INFO] [stderr] Compiling attempt-cli v1.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 9.67s [INFO] running `Command { std: "docker" "inspect" "10c510b6d5301abf957463a52b63f413b3e137f965fe019160bd8c68c9865779", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "10c510b6d5301abf957463a52b63f413b3e137f965fe019160bd8c68c9865779", kill_on_drop: false }` [INFO] [stdout] 10c510b6d5301abf957463a52b63f413b3e137f965fe019160bd8c68c9865779 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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:aa71247004a7fa38d13ec170f48f06cdedf5bc50b2a8645e56ed7e992e6fa513" "/opt/rustwide/cargo-home/bin/cargo" "+bd7d74411512a3dd3b35d2f699c51dd2557c7e7e" "test" "--frozen" "-Zbuild-dir-new-layout", kill_on_drop: false }` [INFO] [stdout] f8461b56cc3efd1950742f5bd342bc9a97f6193c86e9ba9ac091677774d46c44 [INFO] running `Command { std: "docker" "start" "-a" "f8461b56cc3efd1950742f5bd342bc9a97f6193c86e9ba9ac091677774d46c44", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.12s [INFO] [stderr] Running unittests src/main.rs (/opt/rustwide/target/debug/build/attempt-cli/f6c98c47793f1dfe/deps/attempt-f6c98c47793f1dfe) [INFO] [stdout] [INFO] [stdout] running 60 tests [INFO] [stdout] test arguments::test::jitter ... ok [INFO] [stdout] test arguments::test::fixed ... ok [INFO] [stdout] test arguments::test::exponential_with_jitter ... ok [INFO] [stdout] test arguments::test::max_wait_is_respected ... ok [INFO] [stdout] test arguments::test::fixed_with_jitter ... ok [INFO] [stdout] test arguments::test::exponential ... ok [INFO] [stdout] test arguments::test::min_and_max_do_not_erase_jitter ... ok [INFO] [stdout] test arguments::test::linear ... ok [INFO] [stdout] test arguments::test::fixed_is_default ... ok [INFO] [stdout] test arguments::test::stagger ... ok [INFO] [stdout] test arguments::test::min_wait_is_respected ... ok [INFO] [stdout] test policy::test::retry_if_killed ... ok [INFO] [stdout] test policy::test::retry_always_and_forever ... ok [INFO] [stdout] test policy::test::stop_if_killed ... ok [INFO] [stdout] test arguments::test::forever_and_unlimited_override_attempts ... ok [INFO] [stdout] test policy::test::signal_pattern_matching ... ok [INFO] [stdout] test policy::test::stop_if_timeout ... ok [INFO] [stdout] test policy::test::stop_if_contains ... ok [INFO] [stdout] test policy::test::stop_if_status ... ok [INFO] [stdout] test policy::test::retry_if_status ... ok [INFO] [stdout] test policy::test::retry_if_contains ... ok [INFO] [stdout] test util::pattern::test::backwards_ranges_are_fixed ... ok [INFO] [stdout] test util::pattern::test::parsing_fails_on_empty ... ok [INFO] [stdout] test util::pattern::test::parsing_several_status_codes ... ok [INFO] [stdout] test util::pattern::test::parsing_single_status_code ... ok [INFO] [stdout] test util::pattern::test::parsing_complex_status_code ... ok [INFO] [stdout] test util::pattern::test::parsing_status_code_range ... ok [INFO] [stdout] test policy::test::retry_if_matches ... ok [INFO] [stdout] test policy::test::retry_if_timeout ... ok [INFO] [stdout] test test::happy_path_smoke_test_exp ... ok [INFO] [stdout] test util::pattern::test::parsing_status_codes_ignores_gratuitous_commas ... ok [INFO] [stdout] test util::pattern::test::parsing_status_codes_catches_invalid_whitespace ... ok [INFO] [stdout] test policy::test::stop_if_signal ... ok [INFO] [stdout] test util::pattern::test::parsing_status_codes_fails_on_invalid_chars ... ok [INFO] [stdout] test test::happy_path_smoke_test_linear ... ok [INFO] [stdout] test test::happy_path_smoke_test_fixed ... ok [INFO] [stdout] test util::poll::test::expected_runtime_not_multiple_of_1m ... ok [INFO] [stdout] test policy::test::retry_if_signal ... ok [INFO] [stdout] test util::poll::test::poll_returns_immediately_if_result_is_ready ... ok [INFO] [stdout] test util::pattern::test::valid_whitespace_is_ignored ... ok [INFO] [stdout] test util::pattern::test::parsing_status_codes_fails_on_invalid_status_codes ... ok [INFO] [stdout] test util::poll::test::poll_runs_at_the_very_end ... ok [INFO] [stdout] test util::poll::test::poll_runs_until_timeout ... ok [INFO] [stdout] test util::poll::test::expected_runtime_less_than_1m ... ok [INFO] [stdout] test util::value_parsing::tests::empty_strings ... ok [INFO] [stdout] test util::value_parsing::tests::time_units ... ok [INFO] [stdout] test util::poll::test::timeout_overrides_expected_runtime ... ok [INFO] [stdout] test util::value_parsing::tests::invalid_numbers ... ok [INFO] [stdout] test util::value_parsing::tests::components_with_fractional_parts ... ok [INFO] [stdout] test util::value_parsing::tests::multiple_components ... ok [INFO] [stdout] test util::value_parsing::tests::multiple_components_require_units ... ok [INFO] [stdout] test test::sad_path_smoke_test_linear ... ok [INFO] [stdout] test policy::test::retry_failing_status ... ok [INFO] [stdout] test util::poll::test::expected_runtime_greater_than_1m ... ok [INFO] [stdout] test util::pattern::test::parsing_status_codes_fails_on_bad_ranges ... ok [INFO] [stdout] test util::value_parsing::tests::unknown_units ... ok [INFO] [stdout] test test::sad_path_smoke_test_fixed ... ok [INFO] [stdout] test policy::test::stop_if_matches ... ok [INFO] [stdout] test util::poll::test::exponential_wait_time_saturates_at_max_delay ... ok [INFO] [stderr] Running tests/e2e.rs (/opt/rustwide/target/debug/build/attempt-cli/3eb3469a1c0f4be5/deps/e2e-3eb3469a1c0f4be5) [INFO] [stdout] test test::sad_path_smoke_test_exp ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 60 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.09s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 13 tests [INFO] [stdout] test happy_path_smoke_test_linear ... ok [INFO] [stdout] test command_not_found ... ok [INFO] [stdout] test happy_path_smoke_test_exp ... ok [INFO] [stdout] test happy_path_smoke_test_fixed ... ok [INFO] [stdout] test command_failed ... ok [INFO] [stdout] test version ... ok [INFO] [stdout] test stop_on_signal ... ok [INFO] [stdout] test retry_on_signal ... ok [INFO] [stdout] test sad_path_smoke_test_fixed ... ok [INFO] [stdout] test sad_path_smoke_test_exp ... ok [INFO] [stdout] test sad_path_smoke_test_linear ... ok [INFO] [stdout] test timeouts_are_respected ... FAILED [INFO] [stdout] test staggering ... ok [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- timeouts_are_respected stdout ---- [INFO] [stdout] [INFO] [stdout] thread 'timeouts_are_respected' (134) panicked at tests/e2e.rs:326:9: [INFO] [stdout] Error is too high (measured 26.028692% threshold 10%) [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5fc024daa6b2 - std[840933623431fd06]::backtrace_rs::backtrace::libunwind::trace [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stdout] 1: 0x5fc024daa6b2 - std[840933623431fd06]::backtrace_rs::backtrace::trace_unsynchronized:: [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stdout] 2: 0x5fc024daa6b2 - std[840933623431fd06]::sys::backtrace::_print_fmt [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/std/src/sys/backtrace.rs:74:9 [INFO] [stdout] 3: 0x5fc024daa6b2 - <::print::DisplayBacktrace as core[8f93d80df273fe75]::fmt::Display>::fmt [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/std/src/sys/backtrace.rs:44:26 [INFO] [stdout] 4: 0x5fc024dc1dea - ::fmt [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/core/src/fmt/rt.rs:152:76 [INFO] [stdout] 5: 0x5fc024dc1dea - core[8f93d80df273fe75]::fmt::write [INFO] [stdout] 6: 0x5fc024db0956 - std[840933623431fd06]::io::default_write_fmt::> [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/std/src/io/mod.rs:639:11 [INFO] [stdout] 7: 0x5fc024db0956 - as std[840933623431fd06]::io::Write>::write_fmt [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/std/src/io/mod.rs:1994:13 [INFO] [stdout] 8: 0x5fc024d8818f - ::print [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/std/src/sys/backtrace.rs:47:9 [INFO] [stdout] 9: 0x5fc024d8818f - std[840933623431fd06]::panicking::default_hook::{closure#0} [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/std/src/panicking.rs:292:27 [INFO] [stdout] 10: 0x5fc024da27d9 - std[840933623431fd06]::panicking::default_hook [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/std/src/panicking.rs:316:9 [INFO] [stdout] 11: 0x5fc024cfcace - core[8f93d80df273fe75]::ops::function::Fn<(&'a std[840933623431fd06]::panic::PanicHookInfo<'b>,), Output = ()> + core[8f93d80df273fe75]::marker::Sync + core[8f93d80df273fe75]::marker::Send> as core[8f93d80df273fe75]::ops::function::Fn<(&std[840933623431fd06]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/alloc/src/boxed.rs:2220:9 [INFO] [stdout] 12: 0x5fc024cfcace - test[2f1252070343a163]::test_main_with_exit_callback::::{closure#0} [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/test/src/lib.rs:145:21 [INFO] [stdout] 13: 0x5fc024da2a42 - core[8f93d80df273fe75]::ops::function::Fn<(&'a std[840933623431fd06]::panic::PanicHookInfo<'b>,), Output = ()> + core[8f93d80df273fe75]::marker::Sync + core[8f93d80df273fe75]::marker::Send> as core[8f93d80df273fe75]::ops::function::Fn<(&std[840933623431fd06]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/alloc/src/boxed.rs:2220:9 [INFO] [stdout] 14: 0x5fc024da2a42 - std[840933623431fd06]::panicking::panic_with_hook [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/std/src/panicking.rs:833:13 [INFO] [stdout] 15: 0x5fc024d88248 - std[840933623431fd06]::panicking::panic_handler::{closure#0} [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/std/src/panicking.rs:698:13 [INFO] [stdout] 16: 0x5fc024d7fc19 - std[840933623431fd06]::sys::backtrace::__rust_end_short_backtrace:: [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/std/src/sys/backtrace.rs:182:18 [INFO] [stdout] 17: 0x5fc024d8909d - __rustc[5b4a0c6d8cc4a177]::rust_begin_unwind [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/std/src/panicking.rs:689:5 [INFO] [stdout] 18: 0x5fc024dc257c - core[8f93d80df273fe75]::panicking::panic_fmt [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/core/src/panicking.rs:80:14 [INFO] [stdout] 19: 0x5fc024cee842 - e2e[5738f4f14be8e756]::assert_percent_error [INFO] [stdout] at /opt/rustwide/workdir/tests/e2e.rs:326:9 [INFO] [stdout] 20: 0x5fc024cea76a - e2e[5738f4f14be8e756]::assert_average_percent_error:: [INFO] [stdout] at /opt/rustwide/workdir/tests/e2e.rs:354:5 [INFO] [stdout] 21: 0x5fc024cef481 - e2e[5738f4f14be8e756]::timeouts_are_respected [INFO] [stdout] at /opt/rustwide/workdir/tests/e2e.rs:149:5 [INFO] [stdout] 22: 0x5fc024ced5d7 - e2e[5738f4f14be8e756]::timeouts_are_respected::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/tests/e2e.rs:144:28 [INFO] [stdout] 23: 0x5fc024ce9da6 - >::call_once [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 24: 0x5fc024cf0e7b - core[8f93d80df273fe75]::result::Result<(), alloc[40b2bae28975ac47]::string::String> as core[8f93d80df273fe75]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 25: 0x5fc024cf0e7b - test[2f1252070343a163]::__rust_begin_short_backtrace::, fn() -> core[8f93d80df273fe75]::result::Result<(), alloc[40b2bae28975ac47]::string::String>> [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/test/src/lib.rs:663:18 [INFO] [stdout] 26: 0x5fc024cfd6da - test[2f1252070343a163]::run_test_in_process::{closure#0} [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/test/src/lib.rs:686:74 [INFO] [stdout] 27: 0x5fc024cfd6da - as core[8f93d80df273fe75]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/core/src/panic/unwind_safe.rs:274:9 [INFO] [stdout] 28: 0x5fc024cfd6da - std[840933623431fd06]::panicking::catch_unwind::do_call::, core[8f93d80df273fe75]::result::Result<(), alloc[40b2bae28975ac47]::string::String>> [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/std/src/panicking.rs:581:40 [INFO] [stdout] 29: 0x5fc024cfd6da - std[840933623431fd06]::panicking::catch_unwind::, core[8f93d80df273fe75]::panic::unwind_safe::AssertUnwindSafe> [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/std/src/panicking.rs:544:19 [INFO] [stdout] 30: 0x5fc024cfd6da - std[840933623431fd06]::panic::catch_unwind::, core[8f93d80df273fe75]::result::Result<(), alloc[40b2bae28975ac47]::string::String>> [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/std/src/panic.rs:359:14 [INFO] [stdout] 31: 0x5fc024cfd6da - test[2f1252070343a163]::run_test_in_process [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/test/src/lib.rs:686:27 [INFO] [stdout] 32: 0x5fc024cfd6da - test[2f1252070343a163]::run_test::{closure#0} [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/test/src/lib.rs:607:43 [INFO] [stdout] 33: 0x5fc024cf7ba4 - test[2f1252070343a163]::run_test::{closure#1} [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/test/src/lib.rs:637:41 [INFO] [stdout] 34: 0x5fc024cf7ba4 - std[840933623431fd06]::sys::backtrace::__rust_begin_short_backtrace:: [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/std/src/sys/backtrace.rs:166:18 [INFO] [stdout] 35: 0x5fc024d001d2 - std[840933623431fd06]::thread::lifecycle::spawn_unchecked::::{closure#1}::{closure#0} [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/std/src/thread/lifecycle.rs:91:13 [INFO] [stdout] 36: 0x5fc024d001d2 - ::{closure#1}::{closure#0}> as core[8f93d80df273fe75]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/core/src/panic/unwind_safe.rs:274:9 [INFO] [stdout] 37: 0x5fc024d001d2 - std[840933623431fd06]::panicking::catch_unwind::do_call::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/std/src/panicking.rs:581:40 [INFO] [stdout] 38: 0x5fc024d001d2 - std[840933623431fd06]::panicking::catch_unwind::<(), core[8f93d80df273fe75]::panic::unwind_safe::AssertUnwindSafe::{closure#1}::{closure#0}>> [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/std/src/panicking.rs:544:19 [INFO] [stdout] 39: 0x5fc024d001d2 - std[840933623431fd06]::panic::catch_unwind::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/std/src/panic.rs:359:14 [INFO] [stdout] 40: 0x5fc024d001d2 - std[840933623431fd06]::thread::lifecycle::spawn_unchecked::::{closure#1} [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/std/src/thread/lifecycle.rs:89:26 [INFO] [stdout] 41: 0x5fc024d001d2 - ::{closure#1} as core[8f93d80df273fe75]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0} [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 42: 0x5fc024da9ecf - + core[8f93d80df273fe75]::marker::Send> as core[8f93d80df273fe75]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/alloc/src/boxed.rs:2206:9 [INFO] [stdout] 43: 0x5fc024da9ecf - ::new::thread_start [INFO] [stdout] at /rustc/bd7d74411512a3dd3b35d2f699c51dd2557c7e7e/library/std/src/sys/thread/unix.rs:119:17 [INFO] [stdout] 44: 0x7d1b0873daa4 - [INFO] [stdout] 45: 0x7d1b087caa64 - clone [INFO] [stdout] 46: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] timeouts_are_respected [INFO] [stdout] [INFO] [stdout] test result: FAILED. 12 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 4.99s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass `--test e2e` [INFO] running `Command { std: "docker" "inspect" "f8461b56cc3efd1950742f5bd342bc9a97f6193c86e9ba9ac091677774d46c44", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "f8461b56cc3efd1950742f5bd342bc9a97f6193c86e9ba9ac091677774d46c44", kill_on_drop: false }` [INFO] [stdout] f8461b56cc3efd1950742f5bd342bc9a97f6193c86e9ba9ac091677774d46c44