[INFO] cloning repository https://github.com/danielparks/cron-wrapper
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/danielparks/cron-wrapper" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdanielparks%2Fcron-wrapper", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdanielparks%2Fcron-wrapper'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 6b019280b367cd95a2345aa683fefd36fe82df75
[INFO] testing danielparks/cron-wrapper against beta-2024-12-08 for beta-1.84.0-4-retry
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdanielparks%2Fcron-wrapper" "/workspace/builds/worker-2-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-2-tc2/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/danielparks/cron-wrapper on toolchain beta-2024-12-08
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+beta-2024-12-08" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/danielparks/cron-wrapper
[INFO] finished tweaking git repo https://github.com/danielparks/cron-wrapper
[INFO] tweaked toml for git repo https://github.com/danielparks/cron-wrapper written to /workspace/builds/worker-2-tc2/source/Cargo.toml
[INFO] crate git repo https://github.com/danielparks/cron-wrapper 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" "+beta-2024-12-08" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2024-12-08" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] a9064abb10ef945518b7dd0c2f1185e00f40cc89b4fb09686337fb12ff748cbf
[INFO] running `Command { std: "docker" "start" "-a" "a9064abb10ef945518b7dd0c2f1185e00f40cc89b4fb09686337fb12ff748cbf", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "a9064abb10ef945518b7dd0c2f1185e00f40cc89b4fb09686337fb12ff748cbf", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a9064abb10ef945518b7dd0c2f1185e00f40cc89b4fb09686337fb12ff748cbf", kill_on_drop: false }`
[INFO] [stdout] a9064abb10ef945518b7dd0c2f1185e00f40cc89b4fb09686337fb12ff748cbf
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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=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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2024-12-08" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 9e198dcf46b5a0d6c28ea8f044011d369614ee2b499583c062c2710d0513383a
[INFO] running `Command { std: "docker" "start" "-a" "9e198dcf46b5a0d6c28ea8f044011d369614ee2b499583c062c2710d0513383a", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.78
[INFO] [stderr]    Compiling libc v0.2.153
[INFO] [stderr]    Compiling unicode-ident v1.0.12
[INFO] [stderr]    Compiling utf8parse v0.2.1
[INFO] [stderr]    Compiling colorchoice v1.0.0
[INFO] [stderr]    Compiling thiserror v1.0.57
[INFO] [stderr]    Compiling num-traits v0.2.18
[INFO] [stderr]    Compiling anstyle-query v1.0.2
[INFO] [stderr]    Compiling anstyle-parse v0.2.3
[INFO] [stderr]    Compiling arrayvec v0.7.4
[INFO] [stderr]    Compiling time-core v0.1.2
[INFO] [stderr]    Compiling num-conv v0.1.0
[INFO] [stderr]    Compiling anstyle v1.0.6
[INFO] [stderr]    Compiling cc v1.0.90
[INFO] [stderr]    Compiling memchr v2.7.1
[INFO] [stderr]    Compiling rust_decimal v1.34.3
[INFO] [stderr]    Compiling rustix v0.38.31
[INFO] [stderr]    Compiling powerfmt v0.2.0
[INFO] [stderr]    Compiling deranged v0.3.11
[INFO] [stderr]    Compiling anstream v0.6.13
[INFO] [stderr]    Compiling time-macros v0.2.18
[INFO] [stderr]    Compiling quote v1.0.35
[INFO] [stderr]    Compiling clap_lex v0.7.0
[INFO] [stderr]    Compiling syn v2.0.52
[INFO] [stderr]    Compiling heck v0.4.1
[INFO] [stderr]    Compiling itoa v1.0.10
[INFO] [stderr]    Compiling num_threads v0.1.7
[INFO] [stderr]    Compiling minimal-lexical v0.2.1
[INFO] [stderr]    Compiling strsim v0.11.0
[INFO] [stderr]    Compiling anyhow v1.0.80
[INFO] [stderr]    Compiling blake3 v1.5.0
[INFO] [stderr]    Compiling bitflags v2.4.2
[INFO] [stderr]    Compiling linux-raw-sys v0.4.13
[INFO] [stderr]    Compiling clap_builder v4.5.2
[INFO] [stderr]    Compiling nom v7.1.3
[INFO] [stderr]    Compiling bitflags v1.3.2
[INFO] [stderr]    Compiling termcolor v1.4.1
[INFO] [stderr]    Compiling log v0.4.21
[INFO] [stderr]    Compiling constant_time_eq v0.3.0
[INFO] [stderr]    Compiling arrayref v0.3.7
[INFO] [stderr]    Compiling time v0.3.36
[INFO] [stderr]    Compiling nix v0.26.4
[INFO] [stderr]    Compiling popol v3.0.0
[INFO] [stderr]    Compiling is-terminal v0.4.12
[INFO] [stderr]    Compiling os_pipe v1.1.5
[INFO] [stderr]    Compiling bstr v1.9.1
[INFO] [stderr]    Compiling home v0.5.9
[INFO] [stderr]    Compiling roundable v0.1.0
[INFO] [stderr]    Compiling shlex v1.3.0
[INFO] [stderr]    Compiling simplelog v0.12.2
[INFO] [stderr]    Compiling fd-lock v4.0.2
[INFO] [stderr]    Compiling thiserror-impl v1.0.57
[INFO] [stderr]    Compiling clap_derive v4.5.0
[INFO] [stderr]    Compiling duration-str v0.5.1
[INFO] [stderr]    Compiling clap v4.5.2
[INFO] [stderr]    Compiling cron-wrapper v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: elided lifetime has a name
[INFO] [stdout]   --> src/job_logger/parser.rs:98:49
[INFO] [stdout]    |
[INFO] [stdout] 97 | pub fn metadata_line_parser<'a, E>(
[INFO] [stdout]    |                             -- lifetime `'a` declared here
[INFO] [stdout] 98 | ) -> impl FnMut(&'a [u8]) -> IResult<&'a [u8], (&[u8], Vec<u8>), E>
[INFO] [stdout]    |                                                 ^ this elided lifetime gets resolved as `'a`
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(elided_named_lifetimes)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 35.43s
[INFO] running `Command { std: "docker" "inspect" "9e198dcf46b5a0d6c28ea8f044011d369614ee2b499583c062c2710d0513383a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9e198dcf46b5a0d6c28ea8f044011d369614ee2b499583c062c2710d0513383a", kill_on_drop: false }`
[INFO] [stdout] 9e198dcf46b5a0d6c28ea8f044011d369614ee2b499583c062c2710d0513383a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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=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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2024-12-08" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 27735febd9061cc7370ae029edb17db7d96ed6bf642bd6ed5c1023b7e15cf43f
[INFO] running `Command { std: "docker" "start" "-a" "27735febd9061cc7370ae029edb17db7d96ed6bf642bd6ed5c1023b7e15cf43f", kill_on_drop: false }`
[INFO] [stderr]    Compiling semver v1.0.22
[INFO] [stderr]    Compiling regex-syntax v0.8.2
[INFO] [stderr]    Compiling syn v1.0.109
[INFO] [stderr]    Compiling doc-comment v0.3.3
[INFO] [stderr]    Compiling predicates-core v1.0.6
[INFO] [stderr]    Compiling termtree v0.4.1
[INFO] [stderr]    Compiling assert_cmd v2.0.14
[INFO] [stderr]    Compiling difflib v0.4.0
[INFO] [stderr]    Compiling predicates-tree v1.0.9
[INFO] [stderr]    Compiling wait-timeout v0.2.0
[INFO] [stderr]    Compiling fastrand v2.0.1
[INFO] [stderr]    Compiling predicates v3.1.0
[INFO] [stderr]    Compiling yansi v0.5.1
[INFO] [stderr]    Compiling diff v0.1.13
[INFO] [stderr]    Compiling tempfile v3.10.1
[INFO] [stderr]    Compiling rustc_version v0.4.0
[INFO] [stderr]    Compiling assert2-macros v0.3.14
[INFO] [stderr]    Compiling regex-automata v0.4.6
[INFO] [stderr]    Compiling bstr v1.9.1
[INFO] [stderr]    Compiling regex v1.10.3
[INFO] [stderr]    Compiling assert2 v0.3.14
[INFO] [stderr]    Compiling cron-wrapper v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: elided lifetime has a name
[INFO] [stdout]   --> src/job_logger/parser.rs:98:49
[INFO] [stdout]    |
[INFO] [stdout] 97 | pub fn metadata_line_parser<'a, E>(
[INFO] [stdout]    |                             -- lifetime `'a` declared here
[INFO] [stdout] 98 | ) -> impl FnMut(&'a [u8]) -> IResult<&'a [u8], (&[u8], Vec<u8>), E>
[INFO] [stdout]    |                                                 ^ this elided lifetime gets resolved as `'a`
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(elided_named_lifetimes)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: elided lifetime has a name
[INFO] [stdout]   --> src/job_logger/parser.rs:98:49
[INFO] [stdout]    |
[INFO] [stdout] 97 | pub fn metadata_line_parser<'a, E>(
[INFO] [stdout]    |                             -- lifetime `'a` declared here
[INFO] [stdout] 98 | ) -> impl FnMut(&'a [u8]) -> IResult<&'a [u8], (&[u8], Vec<u8>), E>
[INFO] [stdout]    |                                                 ^ this elided lifetime gets resolved as `'a`
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(elided_named_lifetimes)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: missing documentation for the crate
[INFO] [stdout]   --> tests/lock.rs:1:1
[INFO] [stdout]    |
[INFO] [stdout] 1  | / use assert2::check;
[INFO] [stdout] 2  | | use bstr::ByteSlice;
[INFO] [stdout] 3  | | use std::thread;
[INFO] [stdout] 4  | | use std::time::{Duration, Instant};
[INFO] [stdout] ...  |
[INFO] [stdout] 78 | |     check!(start.elapsed() > Duration::from_secs(1));
[INFO] [stdout] 79 | | }
[INFO] [stdout]    | |_^
[INFO] [stdout]    |
[INFO] [stdout]    = note: requested on the command line with `-W missing-docs`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: missing documentation for the crate
[INFO] [stdout]   --> tests/timeout.rs:1:1
[INFO] [stdout]    |
[INFO] [stdout] 1  | / use assert2::check;
[INFO] [stdout] 2  | | use bstr::ByteSlice;
[INFO] [stdout] 3  | | use std::ffi::OsStr;
[INFO] [stdout] 4  | | use std::path::PathBuf;
[INFO] [stdout] ...  |
[INFO] [stdout] 90 | |     );
[INFO] [stdout] 91 | | }
[INFO] [stdout]    | |_^
[INFO] [stdout]    |
[INFO] [stdout]    = note: requested on the command line with `-W missing-docs`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: missing documentation for the crate
[INFO] [stdout]    --> tests/general.rs:1:1
[INFO] [stdout]     |
[INFO] [stdout] 1   | / use assert2::check;
[INFO] [stdout] 2   | | use bstr::{ByteSlice, B};
[INFO] [stdout] 3   | |
[INFO] [stdout] 4   | | mod helpers;
[INFO] [stdout] ...   |
[INFO] [stdout] 172 | |     check!(output.stderr.as_bstr() == "");
[INFO] [stdout] 173 | | }
[INFO] [stdout]     | |_^
[INFO] [stdout]     |
[INFO] [stdout]     = note: requested on the command line with `-W missing-docs`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 36.11s
[INFO] running `Command { std: "docker" "inspect" "27735febd9061cc7370ae029edb17db7d96ed6bf642bd6ed5c1023b7e15cf43f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "27735febd9061cc7370ae029edb17db7d96ed6bf642bd6ed5c1023b7e15cf43f", kill_on_drop: false }`
[INFO] [stdout] 27735febd9061cc7370ae029edb17db7d96ed6bf642bd6ed5c1023b7e15cf43f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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=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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2024-12-08" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 8b5943efc7154558c3a6a533a1a32c1f3c0102823ae3bc60aeb96688d891a034
[INFO] running `Command { std: "docker" "start" "-a" "8b5943efc7154558c3a6a533a1a32c1f3c0102823ae3bc60aeb96688d891a034", kill_on_drop: false }`
[INFO] [stderr] warning: elided lifetime has a name
[INFO] [stderr]   --> src/job_logger/parser.rs:98:49
[INFO] [stderr]    |
[INFO] [stderr] 97 | pub fn metadata_line_parser<'a, E>(
[INFO] [stderr]    |                             -- lifetime `'a` declared here
[INFO] [stderr] 98 | ) -> impl FnMut(&'a [u8]) -> IResult<&'a [u8], (&[u8], Vec<u8>), E>
[INFO] [stderr]    |                                                 ^ this elided lifetime gets resolved as `'a`
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(elided_named_lifetimes)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `cron-wrapper` (lib) generated 1 warning
[INFO] [stderr] warning: missing documentation for the crate
[INFO] [stderr]   --> tests/lock.rs:1:1
[INFO] [stderr]    |
[INFO] [stderr] 1  | / use assert2::check;
[INFO] [stderr] 2  | | use bstr::ByteSlice;
[INFO] [stderr] 3  | | use std::thread;
[INFO] [stderr] 4  | | use std::time::{Duration, Instant};
[INFO] [stderr] ...  |
[INFO] [stderr] 78 | |     check!(start.elapsed() > Duration::from_secs(1));
[INFO] [stderr] 79 | | }
[INFO] [stderr]    | |_^
[INFO] [stderr]    |
[INFO] [stderr]    = note: requested on the command line with `-W missing-docs`
[INFO] [stderr] 
[INFO] [stderr] warning: missing documentation for the crate
[INFO] [stderr]   --> tests/timeout.rs:1:1
[INFO] [stderr]    |
[INFO] [stderr] 1  | / use assert2::check;
[INFO] [stderr] 2  | | use bstr::ByteSlice;
[INFO] [stderr] 3  | | use std::ffi::OsStr;
[INFO] [stderr] 4  | | use std::path::PathBuf;
[INFO] [stderr] ...  |
[INFO] [stderr] 90 | |     );
[INFO] [stderr] 91 | | }
[INFO] [stderr]    | |_^
[INFO] [stderr]    |
[INFO] [stderr]    = note: requested on the command line with `-W missing-docs`
[INFO] [stderr] 
[INFO] [stderr] warning: missing documentation for the crate
[INFO] [stderr]    --> tests/general.rs:1:1
[INFO] [stderr]     |
[INFO] [stderr] 1   | / use assert2::check;
[INFO] [stderr] 2   | | use bstr::{ByteSlice, B};
[INFO] [stderr] 3   | |
[INFO] [stderr] 4   | | mod helpers;
[INFO] [stderr] ...   |
[INFO] [stderr] 172 | |     check!(output.stderr.as_bstr() == "");
[INFO] [stderr] 173 | | }
[INFO] [stderr]     | |_^
[INFO] [stderr]     |
[INFO] [stderr]     = note: requested on the command line with `-W missing-docs`
[INFO] [stderr] 
[INFO] [stderr] warning: `cron-wrapper` (test "lock") generated 1 warning
[INFO] [stderr] warning: `cron-wrapper` (lib test) generated 1 warning (1 duplicate)
[INFO] [stderr] warning: `cron-wrapper` (test "timeout") generated 1 warning
[INFO] [stderr] warning: `cron-wrapper` (test "general") generated 1 warning
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.19s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/cron_wrapper-c0f6796007906e0e)
[INFO] [stdout] 
[INFO] [stdout] running 55 tests
[INFO] [stdout] test job_logger::logger::tests::directory_and_stream_loggers ... ok
[INFO] [stdout] test command::tests::wait_run_timeout ... ok
[INFO] [stdout] test job_logger::logger::tests::directory_logger_no_metadata ... ok
[INFO] [stdout] test command::tests::echo_ok ... ok
[INFO] [stdout] test job_logger::logger::tests::directory_logger_with_command ... ok
[INFO] [stdout] test job_logger::logger::tests::escape_value_escapes ... ok
[INFO] [stdout] test command::tests::killed ... ok
[INFO] [stdout] test job_logger::logger::tests::escape_value_newline_implicit ... ok
[INFO] [stdout] test job_logger::logger::tests::escape_value_newline_explicit ... ok
[INFO] [stdout] test command::tests::wait_no_timeout ... FAILED
[INFO] [stdout] test job_logger::logger::tests::directory_logger_with_child ... ok
[INFO] [stdout] test job_logger::logger::tests::none_logger ... ok
[INFO] [stdout] test command::tests::wait_idle_timeout ... FAILED
[INFO] [stdout] test job_logger::logger::tests::stream_logger ... ok
[INFO] [stdout] test job_logger::parser::tests::bstr_to_duration_max ... ok
[INFO] [stdout] test job_logger::logger::tests::stream_logger_escapes ... ok
[INFO] [stdout] test job_logger::logger::tests::stream_logger_continuation_recoverable_error ... ok
[INFO] [stdout] test job_logger::parser::tests::bstr_to_duration_milliseconds ... ok
[INFO] [stdout] test job_logger::parser::tests::bstr_to_duration_nanoseconds ... ok
[INFO] [stdout] test job_logger::parser::tests::bstr_to_duration_zero ... ok
[INFO] [stdout] test job_logger::parser::tests::bstr_to_u64_extremes ... ok
[INFO] [stdout] test job_logger::parser::tests::log_parser_blank_no_records ... ok
[INFO] [stdout] test job_logger::parser::tests::log_parser_empty ... ok
[INFO] [stdout] test job_logger::parser::tests::log_parser_just_blank ... ok
[INFO] [stdout] test job_logger::parser::tests::log_parser_no_blank_no_records ... ok
[INFO] [stdout] test job_logger::logger::tests::stream_logger_recoverable_error ... ok
[INFO] [stdout] test job_logger::parser::tests::log_parser_blank_no_metadata ... ok
[INFO] [stdout] test job_logger::logger::tests::stream_logger_continuation ... ok
[INFO] [stdout] test job_logger::parser::tests::log_parser_simple ... ok
[INFO] [stdout] test job_logger::parser::tests::log_parser_no_blank_no_metadata ... ok
[INFO] [stdout] test job_logger::parser::tests::metadata_line_parser_err ... ok
[INFO] [stdout] test job_logger::parser::tests::metadata_line_parser_ok ... ok
[INFO] [stdout] test job_logger::parser::tests::metadata_line_parser_ok_multiline ... ok
[INFO] [stdout] test job_logger::parser::tests::record_parser_err ... ok
[INFO] [stdout] test job_logger::parser::tests::record_parser_ok ... ok
[INFO] [stdout] test job_logger::parser::tests::record_parser_ok_multiline ... ok
[INFO] [stdout] test job_logger::parser::tests::unescape ... ok
[INFO] [stdout] test job_logger::parser::tests::unescape_invalid_utf8 ... ok
[INFO] [stdout] test job_logger::parser::tests::unescape_line_ending_non_output ... ok
[INFO] [stdout] test lock::tests::lock_basic ... ok
[INFO] [stdout] test timeout::tests::check_expired_timeout_never ... ok
[INFO] [stdout] test timeout::tests::check_expired_timeout_pending ... ok
[INFO] [stdout] test lock::tests::lock_standard_basic ... ok
[INFO] [stdout] test timeout::tests::check_expired_timeout_future ... ok
[INFO] [stdout] test timeout::tests::check_expired_within_timeout_pending ... ok
[INFO] [stdout] test timeout::tests::compare_timeout_expired ... ok
[INFO] [stdout] test timeout::tests::compare_timeout_future ... ok
[INFO] [stdout] test timeout::tests::compare_timeout_never ... ok
[INFO] [stdout] test timeout::tests::compare_timeout_pending ... ok
[INFO] [stdout] test timeout::tests::compare_timeout_pending_overtime ... ok
[INFO] [stdout] test timeout::tests::check_expired_timeout_expired ... ok
[INFO] [stdout] test job_logger::parser::tests::unescape_line_ending_output ... ok
[INFO] [stdout] test job_logger::logger::tests::directory_logger_conflicting_file_name ... ok
[INFO] [stdout] test command::tests::run_timeout ... ok
[INFO] [stdout] test command::tests::idle_timeout ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- command::tests::wait_no_timeout stdout ----
[INFO] [stdout] Assertion failed at src/command.rs:1249:9:
[INFO] [stdout]   check!( start.elapsed() < Duration :: from_millis(19) )
[INFO] [stdout] with expansion:
[INFO] [stdout]   45.289566ms < 19ms
[INFO] [stdout] 
[INFO] [stdout] thread 'command::tests::wait_no_timeout' panicked at src/command.rs:1249:9:
[INFO] [stdout] check failed
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5dea15409e0a - std::backtrace_rs::backtrace::libunwind::trace::h8810477743020387
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5
[INFO] [stdout]    1:     0x5dea15409e0a - std::backtrace_rs::backtrace::trace_unsynchronized::h3aa55355dd6c54a6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x5dea15409e0a - std::sys::backtrace::_print_fmt::h8588b0f62410823f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:66:9
[INFO] [stdout]    3:     0x5dea15409e0a - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::h98c26ac25ffe89bb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:39:26
[INFO] [stdout]    4:     0x5dea154311c3 - core::fmt::rt::Argument::fmt::hf95377f4aebd453b
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/rt.rs:177:76
[INFO] [stdout]    5:     0x5dea154311c3 - core::fmt::write::h0dd5f6e2238c7982
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/mod.rs:1189:21
[INFO] [stdout]    6:     0x5dea154068d3 - std::io::Write::write_fmt::h03bb0ca26e6faf8c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/io/mod.rs:1884:15
[INFO] [stdout]    7:     0x5dea15409c52 - std::sys::backtrace::BacktraceLock::print::h5c19c1c038ee186d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:42:9
[INFO] [stdout]    8:     0x5dea1540b28d - std::panicking::default_hook::{{closure}}::h77172f079a1fcb13
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:268:22
[INFO] [stdout]    9:     0x5dea1540b097 - std::panicking::default_hook::he5f8e3b203ccddba
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:292:9
[INFO] [stdout]   10:     0x5dea15283e47 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h7a3c7b4a1ae77f2f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   11:     0x5dea15283e47 - test::test_main::{{closure}}::hf0d3b69ae9b353d1
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:134:21
[INFO] [stdout]   12:     0x5dea1540b938 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h6332e82e7b189abd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   13:     0x5dea1540b938 - std::panicking::rust_panic_with_hook::h53863d4e9018df39
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:809:13
[INFO] [stdout]   14:     0x5dea1540b6c6 - std::panicking::begin_panic_handler::{{closure}}::h67280e6fa0757873
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:667:13
[INFO] [stdout]   15:     0x5dea1540a2e9 - std::sys::backtrace::__rust_end_short_backtrace::h1dac3f54d6fbbeb2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:170:18
[INFO] [stdout]   16:     0x5dea1540b38c - rust_begin_unwind
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:665:5
[INFO] [stdout]   17:     0x5dea15189290 - core::panicking::panic_fmt::h6792bd1b2bf01041
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panicking.rs:76:14
[INFO] [stdout]   18:     0x5dea1521d5d8 - cron_wrapper::command::tests::wait_no_timeout::{{closure}}::hea430b94c14b65bd
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/assert2-0.3.14/src/lib.rs:247:47
[INFO] [stdout]   19:     0x5dea15212131 - <assert2::__assert2_impl::FailGuard<T> as core::ops::drop::Drop>::drop::h69841226b71a81c3
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/assert2-0.3.14/src/__assert2_impl/mod.rs:16:4
[INFO] [stdout]   20:     0x5dea152412ba - core::ptr::drop_in_place<assert2::__assert2_impl::FailGuard<cron_wrapper::command::tests::wait_no_timeout::{{closure}}>>::hcbfa6e3583617550
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ptr/mod.rs:521:1
[INFO] [stdout]   21:     0x5dea1524248e - core::ptr::drop_in_place<core::option::Option<assert2::__assert2_impl::FailGuard<cron_wrapper::command::tests::wait_no_timeout::{{closure}}>>>::h371bd1801d9dc6ee
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ptr/mod.rs:521:1
[INFO] [stdout]   22:     0x5dea1521d1a0 - cron_wrapper::command::tests::wait_no_timeout::h620ce8b3c9c040be
[INFO] [stdout]                                at /opt/rustwide/workdir/src/command.rs:1250:5
[INFO] [stdout]   23:     0x5dea1521ca57 - cron_wrapper::command::tests::wait_no_timeout::{{closure}}::h60fb5a2805807be4
[INFO] [stdout]                                at /opt/rustwide/workdir/src/command.rs:1239:25
[INFO] [stdout]   24:     0x5dea15240246 - core::ops::function::FnOnce::call_once::h3fc8c97bb036b8e1
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5dea1528896b - core::ops::function::FnOnce::call_once::h871bf86719ec9aa4
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5dea1528896b - test::__rust_begin_short_backtrace::h2167df1e2b7d76fd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:632:18
[INFO] [stdout]   27:     0x5dea15288358 - test::run_test_in_process::{{closure}}::h15d92f75a3adfb79
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:60
[INFO] [stdout]   28:     0x5dea15288358 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hb6c8955835a8dbbb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   29:     0x5dea15288358 - std::panicking::try::do_call::hc79d0fc888a0bd30
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   30:     0x5dea15288358 - std::panicking::try::hb8a7878e3a8589d6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   31:     0x5dea15288358 - std::panic::catch_unwind::hb8e4600ff0ff5cfa
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   32:     0x5dea15288358 - test::run_test_in_process::hc2900b0b18688dd6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:27
[INFO] [stdout]   33:     0x5dea15288358 - test::run_test::{{closure}}::hac2a9cb07be3d48d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:576:43
[INFO] [stdout]   34:     0x5dea1524bdfa - test::run_test::{{closure}}::h4a5b729e66a38cd8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:606:41
[INFO] [stdout]   35:     0x5dea1524bdfa - std::sys::backtrace::__rust_begin_short_backtrace::h0496fb742492f573
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:154:18
[INFO] [stdout]   36:     0x5dea1524f774 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hbb6d257c550a54bd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:561:17
[INFO] [stdout]   37:     0x5dea1524f774 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h46696fe4a6832328
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   38:     0x5dea1524f774 - std::panicking::try::do_call::h2625a51b667bfb64
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   39:     0x5dea1524f774 - std::panicking::try::hb956a59a1973aa4c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   40:     0x5dea1524f774 - std::panic::catch_unwind::h64f3b9d1067ef6a0
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   41:     0x5dea1524f774 - std::thread::Builder::spawn_unchecked_::{{closure}}::h42b2841295b6c0b2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:559:30
[INFO] [stdout]   42:     0x5dea1524f774 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h6127de71b8124639
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x5dea1541056b - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h42f0ba71002a1b2c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   44:     0x5dea1541056b - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::had9e47d7a3dcecb8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   45:     0x5dea1541056b - std::sys::pal::unix::thread::Thread::new::thread_start::h48cf765408f6f5f2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/pal/unix/thread.rs:105:17
[INFO] [stdout]   46:     0x7d8b85e22ac3 - <unknown>
[INFO] [stdout]   47:     0x7d8b85eb3a04 - clone
[INFO] [stdout]   48:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- command::tests::wait_idle_timeout stdout ----
[INFO] [stdout] [1;31mAssertion failed[0m at [1;49;39msrc/command.rs[0m:1261:9:
[INFO] [stdout]   [35mcheck[0m[35m!([0m [36mstart.elapsed()[0m [1;34m<[0m [33mDuration :: from_millis(20)[0m [35m)[0m
[INFO] [stdout] with expansion:
[INFO] [stdout]   39.003215ms < 20ms
[INFO] [stdout] 
[INFO] [stdout] thread 'command::tests::wait_idle_timeout' panicked at src/command.rs:1261:9:
[INFO] [stdout] check failed
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5dea15409e0a - std::backtrace_rs::backtrace::libunwind::trace::h8810477743020387
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5
[INFO] [stdout]    1:     0x5dea15409e0a - std::backtrace_rs::backtrace::trace_unsynchronized::h3aa55355dd6c54a6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x5dea15409e0a - std::sys::backtrace::_print_fmt::h8588b0f62410823f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:66:9
[INFO] [stdout]    3:     0x5dea15409e0a - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::h98c26ac25ffe89bb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:39:26
[INFO] [stdout]    4:     0x5dea154311c3 - core::fmt::rt::Argument::fmt::hf95377f4aebd453b
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/rt.rs:177:76
[INFO] [stdout]    5:     0x5dea154311c3 - core::fmt::write::h0dd5f6e2238c7982
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/mod.rs:1189:21
[INFO] [stdout]    6:     0x5dea154068d3 - std::io::Write::write_fmt::h03bb0ca26e6faf8c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/io/mod.rs:1884:15
[INFO] [stdout]    7:     0x5dea15409c52 - std::sys::backtrace::BacktraceLock::print::h5c19c1c038ee186d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:42:9
[INFO] [stdout]    8:     0x5dea1540b28d - std::panicking::default_hook::{{closure}}::h77172f079a1fcb13
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:268:22
[INFO] [stdout]    9:     0x5dea1540b097 - std::panicking::default_hook::he5f8e3b203ccddba
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:292:9
[INFO] [stdout]   10:     0x5dea15283e47 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h7a3c7b4a1ae77f2f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   11:     0x5dea15283e47 - test::test_main::{{closure}}::hf0d3b69ae9b353d1
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:134:21
[INFO] [stdout]   12:     0x5dea1540b938 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h6332e82e7b189abd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   13:     0x5dea1540b938 - std::panicking::rust_panic_with_hook::h53863d4e9018df39
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:809:13
[INFO] [stdout]   14:     0x5dea1540b6c6 - std::panicking::begin_panic_handler::{{closure}}::h67280e6fa0757873
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:667:13
[INFO] [stdout]   15:     0x5dea1540a2e9 - std::sys::backtrace::__rust_end_short_backtrace::h1dac3f54d6fbbeb2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:170:18
[INFO] [stdout]   16:     0x5dea1540b38c - rust_begin_unwind
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:665:5
[INFO] [stdout]   17:     0x5dea15189290 - core::panicking::panic_fmt::h6792bd1b2bf01041
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panicking.rs:76:14
[INFO] [stdout]   18:     0x5dea1521e0b8 - cron_wrapper::command::tests::wait_idle_timeout::{{closure}}::h0111156a93abc967
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/assert2-0.3.14/src/lib.rs:247:47
[INFO] [stdout]   19:     0x5dea15210f91 - <assert2::__assert2_impl::FailGuard<T> as core::ops::drop::Drop>::drop::h088e65356130c616
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/assert2-0.3.14/src/__assert2_impl/mod.rs:16:4
[INFO] [stdout]   20:     0x5dea1524130a - core::ptr::drop_in_place<assert2::__assert2_impl::FailGuard<cron_wrapper::command::tests::wait_idle_timeout::{{closure}}>>::h39b61bf5f3bb3ed5
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ptr/mod.rs:521:1
[INFO] [stdout]   21:     0x5dea152425fe - core::ptr::drop_in_place<core::option::Option<assert2::__assert2_impl::FailGuard<cron_wrapper::command::tests::wait_idle_timeout::{{closure}}>>>::h77beaa1dcc2ff122
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ptr/mod.rs:521:1
[INFO] [stdout]   22:     0x5dea1521dd37 - cron_wrapper::command::tests::wait_idle_timeout::h29aaa9477bc771c6
[INFO] [stdout]                                at /opt/rustwide/workdir/src/command.rs:1266:5
[INFO] [stdout]   23:     0x5dea1521d5f7 - cron_wrapper::command::tests::wait_idle_timeout::{{closure}}::h148d809154e26f0a
[INFO] [stdout]                                at /opt/rustwide/workdir/src/command.rs:1253:27
[INFO] [stdout]   24:     0x5dea15240cf6 - core::ops::function::FnOnce::call_once::he9c2aa9869defb99
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5dea1528896b - core::ops::function::FnOnce::call_once::h871bf86719ec9aa4
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5dea1528896b - test::__rust_begin_short_backtrace::h2167df1e2b7d76fd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:632:18
[INFO] [stdout]   27:     0x5dea15288358 - test::run_test_in_process::{{closure}}::h15d92f75a3adfb79
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:60
[INFO] [stdout]   28:     0x5dea15288358 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hb6c8955835a8dbbb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   29:     0x5dea15288358 - std::panicking::try::do_call::hc79d0fc888a0bd30
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   30:     0x5dea15288358 - std::panicking::try::hb8a7878e3a8589d6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   31:     0x5dea15288358 - std::panic::catch_unwind::hb8e4600ff0ff5cfa
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   32:     0x5dea15288358 - test::run_test_in_process::hc2900b0b18688dd6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:27
[INFO] [stdout]   33:     0x5dea15288358 - test::run_test::{{closure}}::hac2a9cb07be3d48d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:576:43
[INFO] [stdout]   34:     0x5dea1524bdfa - test::run_test::{{closure}}::h4a5b729e66a38cd8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:606:41
[INFO] [stdout]   35:     0x5dea1524bdfa - std::sys::backtrace::__rust_begin_short_backtrace::h0496fb742492f573
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:154:18
[INFO] [stdout]   36:     0x5dea1524f774 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hbb6d257c550a54bd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:561:17
[INFO] [stdout]   37:     0x5dea1524f774 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h46696fe4a6832328
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   38:     0x5dea1524f774 - std::panicking::try::do_call::h2625a51b667bfb64
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   39:     0x5dea1524f774 - std::panicking::try::hb956a59a1973aa4c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   40:     0x5dea1524f774 - std::panic::catch_unwind::h64f3b9d1067ef6a0
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   41:     0x5dea1524f774 - std::thread::Builder::spawn_unchecked_::{{closure}}::h42b2841295b6c0b2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:559:30
[INFO] [stdout]   42:     0x5dea1524f774 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h6127de71b8124639
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x5dea1541056b - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h42f0ba71002a1b2c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   44:     0x5dea1541056b - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::had9e47d7a3dcecb8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   45:     0x5dea1541056b - std::sys::pal::unix::thread::Thread::new::thread_start::h48cf765408f6f5f2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/pal/unix/thread.rs:105:17
[INFO] [stdout]   46:     0x7d8b85e22ac3 - <unknown>
[INFO] [stdout]   47:     0x7d8b85eb3a04 - clone
[INFO] [stdout]   48:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     command::tests::wait_idle_timeout
[INFO] [stdout]     command::tests::wait_no_timeout
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 53 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.03s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "8b5943efc7154558c3a6a533a1a32c1f3c0102823ae3bc60aeb96688d891a034", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8b5943efc7154558c3a6a533a1a32c1f3c0102823ae3bc60aeb96688d891a034", kill_on_drop: false }`
[INFO] [stdout] 8b5943efc7154558c3a6a533a1a32c1f3c0102823ae3bc60aeb96688d891a034
