[INFO] cloning repository https://github.com/Twaha-Rahman/microgrep [INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/Twaha-Rahman/microgrep" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FTwaha-Rahman%2Fmicrogrep", kill_on_drop: false }` [INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FTwaha-Rahman%2Fmicrogrep'... [INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }` [INFO] [stdout] 8177df957e4bae8ee31103265f41f26fbf1b4b6e [INFO] testing Twaha-Rahman/microgrep against 1.84.0 for beta-1.85-1 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FTwaha-Rahman%2Fmicrogrep" "/workspace/builds/worker-5-tc1/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-5-tc1/source'... [INFO] [stderr] done. [INFO] validating manifest of git repo https://github.com/Twaha-Rahman/microgrep on toolchain 1.84.0 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.84.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking git repo https://github.com/Twaha-Rahman/microgrep [INFO] finished tweaking git repo https://github.com/Twaha-Rahman/microgrep [INFO] tweaked toml for git repo https://github.com/Twaha-Rahman/microgrep written to /workspace/builds/worker-5-tc1/source/Cargo.toml [INFO] crate git repo https://github.com/Twaha-Rahman/microgrep 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" "+1.84.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:86ea7c7af713d31e8cfdb68a6d0db50b5cf7cbeecde3d112f9f257f747318d36" "/opt/rustwide/cargo-home/bin/cargo" "+1.84.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] b137f8a3308a5143af410b53ca1e6b8b9e243a1008bd40134381021ea2b89e09 [INFO] running `Command { std: "docker" "start" "-a" "b137f8a3308a5143af410b53ca1e6b8b9e243a1008bd40134381021ea2b89e09", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "b137f8a3308a5143af410b53ca1e6b8b9e243a1008bd40134381021ea2b89e09", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "b137f8a3308a5143af410b53ca1e6b8b9e243a1008bd40134381021ea2b89e09", kill_on_drop: false }` [INFO] [stdout] b137f8a3308a5143af410b53ca1e6b8b9e243a1008bd40134381021ea2b89e09 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-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:86ea7c7af713d31e8cfdb68a6d0db50b5cf7cbeecde3d112f9f257f747318d36" "/opt/rustwide/cargo-home/bin/cargo" "+1.84.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 775c4fe968e4a3d421c2bf4a4ad98e82298855454b47e7e9f82ef94361734c24 [INFO] running `Command { std: "docker" "start" "-a" "775c4fe968e4a3d421c2bf4a4ad98e82298855454b47e7e9f82ef94361734c24", kill_on_drop: false }` [INFO] [stderr] Compiling libc v0.2.78 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling memchr v2.3.3 [INFO] [stderr] Compiling regex-syntax v0.6.20 [INFO] [stderr] Compiling basic_threadpool v0.1.0 (/opt/rustwide/workdir/basic_threadpool) [INFO] [stderr] Compiling thread_local v1.0.1 [INFO] [stderr] Compiling aho-corasick v0.7.14 [INFO] [stderr] Compiling atty v0.2.14 [INFO] [stderr] Compiling colored v2.0.0 [INFO] [stderr] Compiling argument_parser v0.1.0 (/opt/rustwide/workdir/argument_parser) [INFO] [stderr] Compiling regex v1.4.1 [INFO] [stderr] Compiling recursive_file_check v0.1.0 (/opt/rustwide/workdir/recursive_file_check) [INFO] [stderr] Compiling microgrep v0.1.0 (/opt/rustwide/workdir/microgrep) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 11.64s [INFO] running `Command { std: "docker" "inspect" "775c4fe968e4a3d421c2bf4a4ad98e82298855454b47e7e9f82ef94361734c24", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "775c4fe968e4a3d421c2bf4a4ad98e82298855454b47e7e9f82ef94361734c24", kill_on_drop: false }` [INFO] [stdout] 775c4fe968e4a3d421c2bf4a4ad98e82298855454b47e7e9f82ef94361734c24 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-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:86ea7c7af713d31e8cfdb68a6d0db50b5cf7cbeecde3d112f9f257f747318d36" "/opt/rustwide/cargo-home/bin/cargo" "+1.84.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] e96b42ac4f736ecb028adc3d78cbc379bbb93bb36060731d0fb039b41d3e8bb3 [INFO] running `Command { std: "docker" "start" "-a" "e96b42ac4f736ecb028adc3d78cbc379bbb93bb36060731d0fb039b41d3e8bb3", kill_on_drop: false }` [INFO] [stderr] Compiling microgrep v0.1.0 (/opt/rustwide/workdir/microgrep) [INFO] [stderr] Compiling recursive_file_check v0.1.0 (/opt/rustwide/workdir/recursive_file_check) [INFO] [stderr] Compiling argument_parser v0.1.0 (/opt/rustwide/workdir/argument_parser) [INFO] [stderr] Compiling basic_threadpool v0.1.0 (/opt/rustwide/workdir/basic_threadpool) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 1.88s [INFO] running `Command { std: "docker" "inspect" "e96b42ac4f736ecb028adc3d78cbc379bbb93bb36060731d0fb039b41d3e8bb3", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "e96b42ac4f736ecb028adc3d78cbc379bbb93bb36060731d0fb039b41d3e8bb3", kill_on_drop: false }` [INFO] [stdout] e96b42ac4f736ecb028adc3d78cbc379bbb93bb36060731d0fb039b41d3e8bb3 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-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:86ea7c7af713d31e8cfdb68a6d0db50b5cf7cbeecde3d112f9f257f747318d36" "/opt/rustwide/cargo-home/bin/cargo" "+1.84.0" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 3dbb67240d4d25f93b2306edfa29613e3f896de9acae784759551673e577a898 [INFO] running `Command { std: "docker" "start" "-a" "3dbb67240d4d25f93b2306edfa29613e3f896de9acae784759551673e577a898", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.03s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/argument_parser-6bab2e37a5c9014b) [INFO] [stdout] [INFO] [stdout] running 4 tests [INFO] [stdout] test collect_flags::tests::filter_out_unknown_flags ... ok [INFO] [stdout] test collect_flags::tests::no_flags_passed ... ok [INFO] [stdout] test collect_flags::tests::collects_multiple_flags ... ok [INFO] [stdout] test collect_flags::tests::collects_single_flag ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s [INFO] [stdout] [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/basic_threadpool-ce4ef886e12de805) [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stdout] test tests::it_works ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/microgrep-2aae935db6413940) [INFO] [stdout] [INFO] [stdout] running 4 tests [INFO] [stdout] test time_taken::tests::takes_less_than_one_ms ... ok [INFO] [stdout] test time_taken::tests::takes_one_ms ... ok [INFO] [stdout] test time_taken::tests::takes_more_than_one_ms ... FAILED [INFO] [stdout] test time_taken::tests::takes_more_than_one_sec ... FAILED [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- time_taken::tests::takes_more_than_one_ms stdout ---- [INFO] [stdout] thread 'time_taken::tests::takes_more_than_one_ms' panicked at microgrep/src/time_taken.rs:48:9: [INFO] [stdout] assertion failed: returned_msg.contains("Took 50ms to search.") [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x622851c131da - std::backtrace_rs::backtrace::libunwind::trace::hfe0e1def394da018 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5 [INFO] [stdout] 1: 0x622851c131da - std::backtrace_rs::backtrace::trace_unsynchronized::h96fbb6d117554616 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x622851c131da - std::sys::backtrace::_print_fmt::he1169c6f8956325b [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/sys/backtrace.rs:66:9 [INFO] [stdout] 3: 0x622851c131da - ::fmt::ha4a311b32f6b4ad8 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/sys/backtrace.rs:39:26 [INFO] [stdout] 4: 0x622851c39223 - core::fmt::rt::Argument::fmt::h8ccd2627d2418ed3 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/core/src/fmt/rt.rs:177:76 [INFO] [stdout] 5: 0x622851c39223 - core::fmt::write::h1866771663f62b81 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/core/src/fmt/mod.rs:1189:21 [INFO] [stdout] 6: 0x622851c10373 - std::io::Write::write_fmt::h2df399c9fb8c6039 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/io/mod.rs:1884:15 [INFO] [stdout] 7: 0x622851c13022 - std::sys::backtrace::BacktraceLock::print::hddd3a9918ce29aa7 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/sys/backtrace.rs:42:9 [INFO] [stdout] 8: 0x622851c1465d - std::panicking::default_hook::{{closure}}::h791f75256b902d7d [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/panicking.rs:268:22 [INFO] [stdout] 9: 0x622851c14467 - std::panicking::default_hook::h82cc572fcb0d8cd7 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/panicking.rs:292:9 [INFO] [stdout] 10: 0x622851bd0137 - as core::ops::function::Fn>::call::h47f4385e5c05a6bc [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/alloc/src/boxed.rs:1986:9 [INFO] [stdout] 11: 0x622851bd0137 - test::test_main::{{closure}}::h592b6187ee9bbe51 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/test/src/lib.rs:134:21 [INFO] [stdout] 12: 0x622851c14d08 - as core::ops::function::Fn>::call::h80408f032954f187 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/alloc/src/boxed.rs:1986:9 [INFO] [stdout] 13: 0x622851c14d08 - std::panicking::rust_panic_with_hook::he21644cc2707f2c4 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/panicking.rs:809:13 [INFO] [stdout] 14: 0x622851c14a96 - std::panicking::begin_panic_handler::{{closure}}::h42f7c414fed3cad9 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/panicking.rs:667:13 [INFO] [stdout] 15: 0x622851c136b9 - std::sys::backtrace::__rust_end_short_backtrace::ha26cf5766b4e8c65 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/sys/backtrace.rs:170:18 [INFO] [stdout] 16: 0x622851c1475c - rust_begin_unwind [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/panicking.rs:665:5 [INFO] [stdout] 17: 0x622851b93aa0 - core::panicking::panic_fmt::h74866b78e934b1c0 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/core/src/panicking.rs:76:14 [INFO] [stdout] 18: 0x622851b93b2c - core::panicking::panic::h95d8269cf8bd4f7a [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/core/src/panicking.rs:148:5 [INFO] [stdout] 19: 0x622851b9672c - microgrep::time_taken::tests::takes_more_than_one_ms::ha95063fe164c05fe [INFO] [stdout] at /opt/rustwide/workdir/microgrep/src/time_taken.rs:48:9 [INFO] [stdout] 20: 0x622851b96647 - microgrep::time_taken::tests::takes_more_than_one_ms::{{closure}}::h1de6ecc50e1c032c [INFO] [stdout] at /opt/rustwide/workdir/microgrep/src/time_taken.rs:41:32 [INFO] [stdout] 21: 0x622851b943c6 - core::ops::function::FnOnce::call_once::h48301375bc8b50e0 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 22: 0x622851bd4ceb - core::ops::function::FnOnce::call_once::h2f54be8ccda9ff77 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 23: 0x622851bd4ceb - test::__rust_begin_short_backtrace::h505f4667df5bf10c [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/test/src/lib.rs:632:18 [INFO] [stdout] 24: 0x622851bd4648 - test::run_test_in_process::{{closure}}::h5ed3028e6069c117 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/test/src/lib.rs:655:60 [INFO] [stdout] 25: 0x622851bd4648 - as core::ops::function::FnOnce<()>>::call_once::hbf705be6aea7c287 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 26: 0x622851bd4648 - std::panicking::try::do_call::h555223a41631f02b [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/panicking.rs:557:40 [INFO] [stdout] 27: 0x622851bd4648 - std::panicking::try::he81e496d432108c4 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/panicking.rs:520:19 [INFO] [stdout] 28: 0x622851bd4648 - std::panic::catch_unwind::hb2ff356e76867b52 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/panic.rs:358:14 [INFO] [stdout] 29: 0x622851bd4648 - test::run_test_in_process::h665bcd2e01d69f5b [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/test/src/lib.rs:655:27 [INFO] [stdout] 30: 0x622851bd4648 - test::run_test::{{closure}}::ha58fbc9c79c6786d [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/test/src/lib.rs:576:43 [INFO] [stdout] 31: 0x622851b980ea - test::run_test::{{closure}}::h958602d5fcb1d647 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/test/src/lib.rs:606:41 [INFO] [stdout] 32: 0x622851b980ea - std::sys::backtrace::__rust_begin_short_backtrace::h7ca2fb16f64faa0f [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/sys/backtrace.rs:154:18 [INFO] [stdout] 33: 0x622851b9b9a4 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hebe77fbe87ddae61 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/thread/mod.rs:561:17 [INFO] [stdout] 34: 0x622851b9b9a4 - as core::ops::function::FnOnce<()>>::call_once::h5e26d6a69f85d1d6 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 35: 0x622851b9b9a4 - std::panicking::try::do_call::h9787fac579f00884 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/panicking.rs:557:40 [INFO] [stdout] 36: 0x622851b9b9a4 - std::panicking::try::h788012b555fbd7c5 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/panicking.rs:520:19 [INFO] [stdout] 37: 0x622851b9b9a4 - std::panic::catch_unwind::hd194f26f99a98fb5 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/panic.rs:358:14 [INFO] [stdout] 38: 0x622851b9b9a4 - std::thread::Builder::spawn_unchecked_::{{closure}}::h31c0dcba34ed449c [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/thread/mod.rs:559:30 [INFO] [stdout] 39: 0x622851b9b9a4 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h60302d9c688101a6 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 40: 0x622851c18c4b - as core::ops::function::FnOnce>::call_once::h9578f6ea1d4e1c4b [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/alloc/src/boxed.rs:1972:9 [INFO] [stdout] 41: 0x622851c18c4b - as core::ops::function::FnOnce>::call_once::hf4a2f438d8019348 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/alloc/src/boxed.rs:1972:9 [INFO] [stdout] 42: 0x622851c18c4b - std::sys::pal::unix::thread::Thread::new::thread_start::h14f1eb868ff90fc9 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/sys/pal/unix/thread.rs:105:17 [INFO] [stdout] 43: 0x75eff4736ac3 - [INFO] [stdout] 44: 0x75eff47c7a04 - clone [INFO] [stdout] 45: 0x0 - [INFO] [stdout] [INFO] [stdout] ---- time_taken::tests::takes_more_than_one_sec stdout ---- [INFO] [stdout] thread 'time_taken::tests::takes_more_than_one_sec' panicked at microgrep/src/time_taken.rs:59:9: [INFO] [stdout] assertion failed: returned_msg.contains("Took 1000ms to search.") [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x622851c131da - std::backtrace_rs::backtrace::libunwind::trace::hfe0e1def394da018 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5 [INFO] [stdout] 1: 0x622851c131da - std::backtrace_rs::backtrace::trace_unsynchronized::h96fbb6d117554616 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x622851c131da - std::sys::backtrace::_print_fmt::he1169c6f8956325b [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/sys/backtrace.rs:66:9 [INFO] [stdout] 3: 0x622851c131da - ::fmt::ha4a311b32f6b4ad8 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/sys/backtrace.rs:39:26 [INFO] [stdout] 4: 0x622851c39223 - core::fmt::rt::Argument::fmt::h8ccd2627d2418ed3 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/core/src/fmt/rt.rs:177:76 [INFO] [stdout] 5: 0x622851c39223 - core::fmt::write::h1866771663f62b81 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/core/src/fmt/mod.rs:1189:21 [INFO] [stdout] 6: 0x622851c10373 - std::io::Write::write_fmt::h2df399c9fb8c6039 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/io/mod.rs:1884:15 [INFO] [stdout] 7: 0x622851c13022 - std::sys::backtrace::BacktraceLock::print::hddd3a9918ce29aa7 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/sys/backtrace.rs:42:9 [INFO] [stdout] 8: 0x622851c1465d - std::panicking::default_hook::{{closure}}::h791f75256b902d7d [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/panicking.rs:268:22 [INFO] [stdout] 9: 0x622851c14467 - std::panicking::default_hook::h82cc572fcb0d8cd7 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/panicking.rs:292:9 [INFO] [stdout] 10: 0x622851bd0137 - as core::ops::function::Fn>::call::h47f4385e5c05a6bc [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/alloc/src/boxed.rs:1986:9 [INFO] [stdout] 11: 0x622851bd0137 - test::test_main::{{closure}}::h592b6187ee9bbe51 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/test/src/lib.rs:134:21 [INFO] [stdout] 12: 0x622851c14d08 - as core::ops::function::Fn>::call::h80408f032954f187 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/alloc/src/boxed.rs:1986:9 [INFO] [stdout] 13: 0x622851c14d08 - std::panicking::rust_panic_with_hook::he21644cc2707f2c4 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/panicking.rs:809:13 [INFO] [stdout] 14: 0x622851c14a96 - std::panicking::begin_panic_handler::{{closure}}::h42f7c414fed3cad9 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/panicking.rs:667:13 [INFO] [stdout] 15: 0x622851c136b9 - std::sys::backtrace::__rust_end_short_backtrace::ha26cf5766b4e8c65 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/sys/backtrace.rs:170:18 [INFO] [stdout] 16: 0x622851c1475c - rust_begin_unwind [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/panicking.rs:665:5 [INFO] [stdout] 17: 0x622851b93aa0 - core::panicking::panic_fmt::h74866b78e934b1c0 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/core/src/panicking.rs:76:14 [INFO] [stdout] 18: 0x622851b93b2c - core::panicking::panic::h95d8269cf8bd4f7a [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/core/src/panicking.rs:148:5 [INFO] [stdout] 19: 0x622851b9685c - microgrep::time_taken::tests::takes_more_than_one_sec::ha9f43f8bab8232bf [INFO] [stdout] at /opt/rustwide/workdir/microgrep/src/time_taken.rs:59:9 [INFO] [stdout] 20: 0x622851b96777 - microgrep::time_taken::tests::takes_more_than_one_sec::{{closure}}::h52931ae4c67f04a3 [INFO] [stdout] at /opt/rustwide/workdir/microgrep/src/time_taken.rs:52:33 [INFO] [stdout] 21: 0x622851b94456 - core::ops::function::FnOnce::call_once::hba9953b73d1c45ca [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 22: 0x622851bd4ceb - core::ops::function::FnOnce::call_once::h2f54be8ccda9ff77 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 23: 0x622851bd4ceb - test::__rust_begin_short_backtrace::h505f4667df5bf10c [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/test/src/lib.rs:632:18 [INFO] [stdout] 24: 0x622851bd4648 - test::run_test_in_process::{{closure}}::h5ed3028e6069c117 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/test/src/lib.rs:655:60 [INFO] [stdout] 25: 0x622851bd4648 - as core::ops::function::FnOnce<()>>::call_once::hbf705be6aea7c287 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 26: 0x622851bd4648 - std::panicking::try::do_call::h555223a41631f02b [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/panicking.rs:557:40 [INFO] [stdout] 27: 0x622851bd4648 - std::panicking::try::he81e496d432108c4 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/panicking.rs:520:19 [INFO] [stdout] 28: 0x622851bd4648 - std::panic::catch_unwind::hb2ff356e76867b52 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/panic.rs:358:14 [INFO] [stdout] 29: 0x622851bd4648 - test::run_test_in_process::h665bcd2e01d69f5b [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/test/src/lib.rs:655:27 [INFO] [stdout] 30: 0x622851bd4648 - test::run_test::{{closure}}::ha58fbc9c79c6786d [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/test/src/lib.rs:576:43 [INFO] [stdout] 31: 0x622851b980ea - test::run_test::{{closure}}::h958602d5fcb1d647 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/test/src/lib.rs:606:41 [INFO] [stdout] 32: 0x622851b980ea - std::sys::backtrace::__rust_begin_short_backtrace::h7ca2fb16f64faa0f [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/sys/backtrace.rs:154:18 [INFO] [stdout] 33: 0x622851b9b9a4 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hebe77fbe87ddae61 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/thread/mod.rs:561:17 [INFO] [stdout] 34: 0x622851b9b9a4 - as core::ops::function::FnOnce<()>>::call_once::h5e26d6a69f85d1d6 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 35: 0x622851b9b9a4 - std::panicking::try::do_call::h9787fac579f00884 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/panicking.rs:557:40 [INFO] [stdout] 36: 0x622851b9b9a4 - std::panicking::try::h788012b555fbd7c5 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/panicking.rs:520:19 [INFO] [stdout] 37: 0x622851b9b9a4 - std::panic::catch_unwind::hd194f26f99a98fb5 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/panic.rs:358:14 [INFO] [stdout] 38: 0x622851b9b9a4 - std::thread::Builder::spawn_unchecked_::{{closure}}::h31c0dcba34ed449c [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/thread/mod.rs:559:30 [INFO] [stdout] 39: 0x622851b9b9a4 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h60302d9c688101a6 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 40: 0x622851c18c4b - as core::ops::function::FnOnce>::call_once::h9578f6ea1d4e1c4b [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/alloc/src/boxed.rs:1972:9 [INFO] [stdout] 41: 0x622851c18c4b - as core::ops::function::FnOnce>::call_once::hf4a2f438d8019348 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/alloc/src/boxed.rs:1972:9 [INFO] [stdout] 42: 0x622851c18c4b - std::sys::pal::unix::thread::Thread::new::thread_start::h14f1eb868ff90fc9 [INFO] [stdout] at /rustc/9fc6b43126469e3858e2fe86cafb4f0fd5068869/library/std/src/sys/pal/unix/thread.rs:105:17 [INFO] [stdout] 43: 0x75eff4736ac3 - [INFO] [stdout] 44: 0x75eff47c7a04 - clone [INFO] [stdout] 45: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] time_taken::tests::takes_more_than_one_ms [INFO] [stdout] time_taken::tests::takes_more_than_one_sec [INFO] [stdout] [INFO] [stdout] test result: FAILED. 2 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.01s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass `-p microgrep --lib` [INFO] running `Command { std: "docker" "inspect" "3dbb67240d4d25f93b2306edfa29613e3f896de9acae784759551673e577a898", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "3dbb67240d4d25f93b2306edfa29613e3f896de9acae784759551673e577a898", kill_on_drop: false }` [INFO] [stdout] 3dbb67240d4d25f93b2306edfa29613e3f896de9acae784759551673e577a898