[INFO] fetching crate castwright 0.0.6... [INFO] testing castwright-0.0.6 against master#552a959051cebf8f88a8f558399baf733bec9ce0 for pr-136932 [INFO] extracting crate castwright 0.0.6 into /workspace/builds/worker-2-tc1/source [INFO] validating manifest of crates.io crate castwright 0.0.6 on toolchain 552a959051cebf8f88a8f558399baf733bec9ce0 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+552a959051cebf8f88a8f558399baf733bec9ce0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate castwright 0.0.6 [INFO] finished tweaking crates.io crate castwright 0.0.6 [INFO] tweaked toml for crates.io crate castwright 0.0.6 written to /workspace/builds/worker-2-tc1/source/Cargo.toml [INFO] crate crates.io crate castwright 0.0.6 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" "+552a959051cebf8f88a8f558399baf733bec9ce0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Updating crates.io index [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded duct v0.13.7 [INFO] [stderr] Downloaded shared_child v1.0.1 [INFO] [stderr] Downloaded os_pipe v1.2.1 [INFO] [stderr] Downloaded terminal_size v0.4.1 [INFO] [stderr] Downloaded argh_shared v0.1.13 [INFO] [stderr] Downloaded disperror v0.1.2 [INFO] [stderr] Downloaded optfield v0.4.0 [INFO] [stderr] Downloaded argh_derive v0.1.13 [INFO] [stderr] Downloaded argh v0.1.13 [INFO] [stderr] Downloaded rust-fuzzy-search v0.1.1 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/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:3959728d45483eb673ba100a951a6b9f5012970368db2a9e08e0ac9b67c8a5ad" "/opt/rustwide/cargo-home/bin/cargo" "+552a959051cebf8f88a8f558399baf733bec9ce0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] b84d6a83c60e9dfe2e615ce805e0b8101fed6f8700ca0972340c50c76c7a40cf [INFO] running `Command { std: "docker" "start" "-a" "b84d6a83c60e9dfe2e615ce805e0b8101fed6f8700ca0972340c50c76c7a40cf", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "b84d6a83c60e9dfe2e615ce805e0b8101fed6f8700ca0972340c50c76c7a40cf", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "b84d6a83c60e9dfe2e615ce805e0b8101fed6f8700ca0972340c50c76c7a40cf", kill_on_drop: false }` [INFO] [stdout] b84d6a83c60e9dfe2e615ce805e0b8101fed6f8700ca0972340c50c76c7a40cf [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/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:3959728d45483eb673ba100a951a6b9f5012970368db2a9e08e0ac9b67c8a5ad" "/opt/rustwide/cargo-home/bin/cargo" "+552a959051cebf8f88a8f558399baf733bec9ce0" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 0bd33003b6142375aaf88a20004fc7f8c9c5d22f73b24bbd46e8a9e580fcd9e6 [INFO] running `Command { std: "docker" "start" "-a" "0bd33003b6142375aaf88a20004fc7f8c9c5d22f73b24bbd46e8a9e580fcd9e6", kill_on_drop: false }` [INFO] [stderr] Compiling syn v2.0.98 [INFO] [stderr] Compiling rustix v0.38.44 [INFO] [stderr] Compiling bitflags v2.8.0 [INFO] [stderr] Compiling thiserror v2.0.11 [INFO] [stderr] Compiling argh_shared v0.1.13 [INFO] [stderr] Compiling linux-raw-sys v0.4.15 [INFO] [stderr] Compiling serde_json v1.0.138 [INFO] [stderr] Compiling memchr v2.7.4 [INFO] [stderr] Compiling rust-fuzzy-search v0.1.1 [INFO] [stderr] Compiling disperror v0.1.2 [INFO] [stderr] Compiling shared_child v1.0.1 [INFO] [stderr] Compiling os_pipe v1.2.1 [INFO] [stderr] Compiling duct v0.13.7 [INFO] [stderr] Compiling terminal_size v0.4.1 [INFO] [stderr] Compiling serde_derive v1.0.217 [INFO] [stderr] Compiling argh_derive v0.1.13 [INFO] [stderr] Compiling thiserror-impl v2.0.11 [INFO] [stderr] Compiling optfield v0.4.0 [INFO] [stderr] Compiling serde v1.0.217 [INFO] [stderr] Compiling argh v0.1.13 [INFO] [stderr] Compiling castwright v0.0.6 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 20.63s [INFO] running `Command { std: "docker" "inspect" "0bd33003b6142375aaf88a20004fc7f8c9c5d22f73b24bbd46e8a9e580fcd9e6", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "0bd33003b6142375aaf88a20004fc7f8c9c5d22f73b24bbd46e8a9e580fcd9e6", kill_on_drop: false }` [INFO] [stdout] 0bd33003b6142375aaf88a20004fc7f8c9c5d22f73b24bbd46e8a9e580fcd9e6 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/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:3959728d45483eb673ba100a951a6b9f5012970368db2a9e08e0ac9b67c8a5ad" "/opt/rustwide/cargo-home/bin/cargo" "+552a959051cebf8f88a8f558399baf733bec9ce0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] f8fcc14395f48a22527d083980b7c734462cfa9320c5d24c72302b080b4c5d85 [INFO] running `Command { std: "docker" "start" "-a" "f8fcc14395f48a22527d083980b7c734462cfa9320c5d24c72302b080b4c5d85", kill_on_drop: false }` [INFO] [stderr] Compiling castwright v0.0.6 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 1.90s [INFO] running `Command { std: "docker" "inspect" "f8fcc14395f48a22527d083980b7c734462cfa9320c5d24c72302b080b4c5d85", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "f8fcc14395f48a22527d083980b7c734462cfa9320c5d24c72302b080b4c5d85", kill_on_drop: false }` [INFO] [stdout] f8fcc14395f48a22527d083980b7c734462cfa9320c5d24c72302b080b4c5d85 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/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:3959728d45483eb673ba100a951a6b9f5012970368db2a9e08e0ac9b67c8a5ad" "/opt/rustwide/cargo-home/bin/cargo" "+552a959051cebf8f88a8f558399baf733bec9ce0" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 5f35dddfc3ead0ee78709979a7bdbfcf20079f1f1c2f4f2fc2c3d857564ac066 [INFO] running `Command { std: "docker" "start" "-a" "5f35dddfc3ead0ee78709979a7bdbfcf20079f1f1c2f4f2fc2c3d857564ac066", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.05s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/castwright-642ab896c242ec74) [INFO] [stdout] [INFO] [stdout] running 47 tests [INFO] [stdout] test asciicast::tests::explicit_write_header ... ok [INFO] [stdout] test asciicast::tests::implicit_write_header ... ok [INFO] [stdout] test instruction::command::tests::command_instruction ... ok [INFO] [stdout] test asciicast::event::tests::event_serialize ... ok [INFO] [stdout] test asciicast::tests::implicit_header_already_written ... ok [INFO] [stdout] test instruction::command::tests::error_handling ... ok [INFO] [stdout] test instruction::config::tests::execute_config_instruction ... ok [INFO] [stdout] test asciicast::header::tests::header_serialize ... ok [INFO] [stdout] test instruction::config::tests::config_instruction_persistent ... ok [INFO] [stdout] test instruction::config::tests::config_instruction_type ... ok [INFO] [stdout] test asciicast::tests::explicit_header_already_written ... ok [INFO] [stdout] test instruction::config::tests::malformed_config_instruction ... ok [INFO] [stdout] test instruction::config::tests::unknown_config_instruction ... ok [INFO] [stdout] test instruction::empty::tests::empty_instruction ... ok [INFO] [stdout] test instruction::frontmatter::tests::expected_key_value_pair ... ok [INFO] [stdout] test instruction::frontmatter::tests::front_matter_instruction ... ok [INFO] [stdout] test instruction::frontmatter::tests::json_error ... ok [INFO] [stdout] test instruction::frontmatter::tests::malformed_front_matter_instruction ... ok [INFO] [stdout] test instruction::frontmatter::tests::test_parse_positive_u16 ... ok [INFO] [stdout] test instruction::marker::tests::marker_instruction ... ok [INFO] [stdout] test instruction::tests::invalid_instruction ... ok [INFO] [stdout] test instruction::tests::instruction_with_space ... ok [INFO] [stdout] test instruction::print::tests::print_instruction ... ok [INFO] [stdout] test instruction::tests::instruction_without_space ... ok [INFO] [stdout] test shell::cd::tests::cd_absolute ... ok [INFO] [stdout] test instruction::frontmatter::tests::empty_front_matter ... ok [INFO] [stdout] test shell::cd::tests::cd_relative ... ok [INFO] [stdout] test instruction::frontmatter::tests::unknown_front_matter_instruction ... ok [INFO] [stdout] test tests::execution_context_consume_temporary ... ok [INFO] [stdout] test instruction::tests::empty_instruction ... ok [INFO] [stdout] test tests::expected_closing_delimiter ... ok [INFO] [stdout] test tests::expected_key_value_pair ... ok [INFO] [stdout] test instruction::wait::tests::wait_instruction ... ok [INFO] [stdout] test tests::script_expected_continuation_1 ... ok [INFO] [stdout] test shell::tests::replaced_newline ... ok [INFO] [stdout] test tests::script_unexpected_continuation ... ok [INFO] [stdout] test tests::version_correct ... ok [INFO] [stdout] test util::tests::loose_string_error ... ok [INFO] [stdout] test util::tests::duration ... ok [INFO] [stdout] test util::tests::loose_string ... ok [INFO] [stdout] test tests::script_expected_continuation_2 ... ok [INFO] [stdout] test shell::tests::echo_both ... ok [INFO] [stdout] test shell::tests::echo_stderr ... ok [INFO] [stdout] test tests::front_matter_exists ... ok [INFO] [stdout] test tests::script_unknown_instruction ... ok [INFO] [stdout] test shell::tests::echo_stdout ... ok [INFO] [stdout] test shell::tests::echo_with_delay ... FAILED [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- shell::tests::echo_with_delay stdout ---- [INFO] [stdout] [INFO] [stdout] thread 'shell::tests::echo_with_delay' panicked at src/shell/mod.rs:199:9: [INFO] [stdout] Duration: 999.49455ms [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5b37e863e6e0 - std::backtrace_rs::backtrace::libunwind::trace::hff7ffeb2055d56f7 [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5 [INFO] [stdout] 1: 0x5b37e863e6e0 - std::backtrace_rs::backtrace::trace_unsynchronized::he7b3446d48853094 [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x5b37e863e6e0 - std::sys::backtrace::_print_fmt::hc2f9f78a9d81f67e [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/std/src/sys/backtrace.rs:66:9 [INFO] [stdout] 3: 0x5b37e863e6e0 - ::fmt::h222ded249a1f0b37 [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/std/src/sys/backtrace.rs:39:26 [INFO] [stdout] 4: 0x5b37e86670e3 - core::fmt::rt::Argument::fmt::hf87ad28cd961f7a3 [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/core/src/fmt/rt.rs:177:76 [INFO] [stdout] 5: 0x5b37e86670e3 - core::fmt::write::h9275005cf35b8a10 [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/core/src/fmt/mod.rs:1449:21 [INFO] [stdout] 6: 0x5b37e863ab63 - std::io::Write::write_fmt::h9c45a7064b117632 [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/std/src/io/mod.rs:1890:15 [INFO] [stdout] 7: 0x5b37e863e532 - std::sys::backtrace::BacktraceLock::print::hd225c6688b44ae93 [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/std/src/sys/backtrace.rs:42:9 [INFO] [stdout] 8: 0x5b37e863fb0f - std::panicking::default_hook::{{closure}}::h2b0bdfbf5b027ac9 [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/std/src/panicking.rs:298:22 [INFO] [stdout] 9: 0x5b37e863f928 - std::panicking::default_hook::ha8790851fc656c1a [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/std/src/panicking.rs:322:9 [INFO] [stdout] 10: 0x5b37e85abec5 - as core::ops::function::Fn>::call::hdad4d0506655a157 [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/alloc/src/boxed.rs:2030:9 [INFO] [stdout] 11: 0x5b37e85abec5 - test::test_main::{{closure}}::hdf61abd52acd3de0 [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/test/src/lib.rs:135:21 [INFO] [stdout] 12: 0x5b37e8640603 - as core::ops::function::Fn>::call::h52c5bf698b1366e5 [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/alloc/src/boxed.rs:2030:9 [INFO] [stdout] 13: 0x5b37e8640603 - std::panicking::rust_panic_with_hook::ha306bc05bdb5b696 [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/std/src/panicking.rs:839:13 [INFO] [stdout] 14: 0x5b37e86402ba - std::panicking::begin_panic_handler::{{closure}}::h2c0d6e717a62810c [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/std/src/panicking.rs:704:13 [INFO] [stdout] 15: 0x5b37e863ebe9 - std::sys::backtrace::__rust_end_short_backtrace::h1e7465e8c528d13d [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/std/src/sys/backtrace.rs:168:18 [INFO] [stdout] 16: 0x5b37e863ff4d - rust_begin_unwind [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/std/src/panicking.rs:695:5 [INFO] [stdout] 17: 0x5b37e8665550 - core::panicking::panic_fmt::h0c17c793f18e9c3f [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/core/src/panicking.rs:75:14 [INFO] [stdout] 18: 0x5b37e8561d71 - castwright::shell::tests::echo_with_delay::hd53355027696bb71 [INFO] [stdout] at /opt/rustwide/workdir/src/shell/mod.rs:199:9 [INFO] [stdout] 19: 0x5b37e85615c7 - castwright::shell::tests::echo_with_delay::{{closure}}::he7bfe2ada1b1a1dd [INFO] [stdout] at /opt/rustwide/workdir/src/shell/mod.rs:176:25 [INFO] [stdout] 20: 0x5b37e8534df6 - core::ops::function::FnOnce::call_once::h4625ec1a7f1b99b1 [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 21: 0x5b37e85b16bb - core::ops::function::FnOnce::call_once::ha8d13c24f305262f [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 22: 0x5b37e85b16bb - test::__rust_begin_short_backtrace::hda7ed5913d26b4c3 [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/test/src/lib.rs:637:18 [INFO] [stdout] 23: 0x5b37e85b0538 - test::run_test_in_process::{{closure}}::h98799ac8ad05dc17 [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/test/src/lib.rs:660:60 [INFO] [stdout] 24: 0x5b37e85b0538 - as core::ops::function::FnOnce<()>>::call_once::h9915be725ed5cec7 [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 25: 0x5b37e85b0538 - std::panicking::try::do_call::hdae5166dc0f6479b [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/std/src/panicking.rs:587:40 [INFO] [stdout] 26: 0x5b37e85b0538 - std::panicking::try::h8fa0f35111734e43 [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/std/src/panicking.rs:550:19 [INFO] [stdout] 27: 0x5b37e85b0538 - std::panic::catch_unwind::h2c5c178909d676e7 [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/std/src/panic.rs:358:14 [INFO] [stdout] 28: 0x5b37e85b0538 - test::run_test_in_process::h2157e57f25733f22 [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/test/src/lib.rs:660:27 [INFO] [stdout] 29: 0x5b37e85b0538 - test::run_test::{{closure}}::h22055a3e9dc56ab9 [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/test/src/lib.rs:581:43 [INFO] [stdout] 30: 0x5b37e85734f5 - test::run_test::{{closure}}::h0de666e52c64b314 [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/test/src/lib.rs:611:41 [INFO] [stdout] 31: 0x5b37e85734f5 - std::sys::backtrace::__rust_begin_short_backtrace::hc24dfc6dbc7f5867 [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/std/src/sys/backtrace.rs:152:18 [INFO] [stdout] 32: 0x5b37e8576e7a - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::h036a075b14c8a889 [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/std/src/thread/mod.rs:559:17 [INFO] [stdout] 33: 0x5b37e8576e7a - as core::ops::function::FnOnce<()>>::call_once::h77e5e1e1c11b3182 [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 34: 0x5b37e8576e7a - std::panicking::try::do_call::h64009ce4a7d5024a [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/std/src/panicking.rs:587:40 [INFO] [stdout] 35: 0x5b37e8576e7a - std::panicking::try::h9f253851f45b6cf2 [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/std/src/panicking.rs:550:19 [INFO] [stdout] 36: 0x5b37e8576e7a - std::panic::catch_unwind::hbcdf318df191e0d2 [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/std/src/panic.rs:358:14 [INFO] [stdout] 37: 0x5b37e8576e7a - std::thread::Builder::spawn_unchecked_::{{closure}}::h1b0514eb1722a9bb [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/std/src/thread/mod.rs:557:30 [INFO] [stdout] 38: 0x5b37e8576e7a - core::ops::function::FnOnce::call_once{{vtable.shim}}::h49ed8239622cf2ed [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 39: 0x5b37e864475b - as core::ops::function::FnOnce>::call_once::h5d46408001e51da6 [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/alloc/src/boxed.rs:2016:9 [INFO] [stdout] 40: 0x5b37e864475b - as core::ops::function::FnOnce>::call_once::hfb44b07af29285a8 [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/alloc/src/boxed.rs:2016:9 [INFO] [stdout] 41: 0x5b37e864475b - std::sys::pal::unix::thread::Thread::new::thread_start::h3fe202b40d9df201 [INFO] [stdout] at /rustc/552a959051cebf8f88a8f558399baf733bec9ce0/library/std/src/sys/pal/unix/thread.rs:106:17 [INFO] [stdout] 42: 0x76f04e974ac3 - [INFO] [stdout] 43: 0x76f04ea05a04 - clone [INFO] [stdout] 44: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] shell::tests::echo_with_delay [INFO] [stdout] [INFO] [stdout] test result: FAILED. 46 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.04s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass `--lib` [INFO] running `Command { std: "docker" "inspect" "5f35dddfc3ead0ee78709979a7bdbfcf20079f1f1c2f4f2fc2c3d857564ac066", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "5f35dddfc3ead0ee78709979a7bdbfcf20079f1f1c2f4f2fc2c3d857564ac066", kill_on_drop: false }` [INFO] [stdout] 5f35dddfc3ead0ee78709979a7bdbfcf20079f1f1c2f4f2fc2c3d857564ac066