[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] 310dcb05d72b665be5ccace61b39e1f7c01f1443 [INFO] testing danielparks/cron-wrapper against master#1ef7943ee607160a564655b6596f83670ef95df5 for pr-146098-6 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdanielparks%2Fcron-wrapper" "/workspace/builds/worker-7-tc1/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-7-tc1/source'... [INFO] [stderr] done. [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-7-tc1/source/Cargo.toml [INFO] validating manifest of git repo https://github.com/danielparks/cron-wrapper on toolchain 1ef7943ee607160a564655b6596f83670ef95df5 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1ef7943ee607160a564655b6596f83670ef95df5" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [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" "+1ef7943ee607160a564655b6596f83670ef95df5" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Updating crates.io index [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded fd-lock v4.0.2 [INFO] [stderr] Downloaded simplelog v0.12.2 [INFO] [stderr] Downloaded num-traits v0.2.18 [INFO] [stderr] Downloaded assert2-macros v0.3.14 [INFO] [stderr] Downloaded popol v3.0.0 [INFO] [stderr] Downloaded clap_derive v4.5.0 [INFO] [stderr] Downloaded assert_cmd v2.0.14 [INFO] [stderr] Downloaded duration-str v0.5.1 [INFO] [stderr] Downloaded clap v4.5.2 [INFO] [stderr] Downloaded rust_decimal v1.34.3 [INFO] [stderr] Downloaded assert2 v0.3.14 [INFO] [stderr] Downloaded roundable v0.1.0 [INFO] [stderr] Downloaded bstr v1.9.1 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:4848fb76d95f26979359cc7e45710b1dbc8f3acb7aeedee7c460d7702230f228" "/opt/rustwide/cargo-home/bin/cargo" "+1ef7943ee607160a564655b6596f83670ef95df5" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] daedcc4c7b0ea889208cdbc6bb56e6feb53c1289cc37faf28e401b5c0ea67c5a [INFO] running `Command { std: "docker" "start" "-a" "daedcc4c7b0ea889208cdbc6bb56e6feb53c1289cc37faf28e401b5c0ea67c5a", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "daedcc4c7b0ea889208cdbc6bb56e6feb53c1289cc37faf28e401b5c0ea67c5a", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "daedcc4c7b0ea889208cdbc6bb56e6feb53c1289cc37faf28e401b5c0ea67c5a", kill_on_drop: false }` [INFO] [stdout] daedcc4c7b0ea889208cdbc6bb56e6feb53c1289cc37faf28e401b5c0ea67c5a [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:4848fb76d95f26979359cc7e45710b1dbc8f3acb7aeedee7c460d7702230f228" "/opt/rustwide/cargo-home/bin/cargo" "+1ef7943ee607160a564655b6596f83670ef95df5" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] bdafa30a180bf37e7049663e8256b5b949c6cb4b1cde116bafffbad1ad7dd6c6 [INFO] running `Command { std: "docker" "start" "-a" "bdafa30a180bf37e7049663e8256b5b949c6cb4b1cde116bafffbad1ad7dd6c6", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.78 [INFO] [stderr] Compiling libc v0.2.153 [INFO] [stderr] Compiling utf8parse v0.2.1 [INFO] [stderr] Compiling colorchoice v1.0.0 [INFO] [stderr] Compiling anstyle v1.0.6 [INFO] [stderr] Compiling rustix v0.38.31 [INFO] [stderr] Compiling time-core v0.1.2 [INFO] [stderr] Compiling arrayvec v0.7.4 [INFO] [stderr] Compiling rust_decimal v1.34.3 [INFO] [stderr] Compiling anstyle-query v1.0.2 [INFO] [stderr] Compiling thiserror v1.0.57 [INFO] [stderr] Compiling num-traits v0.2.18 [INFO] [stderr] Compiling cc v1.0.90 [INFO] [stderr] Compiling memchr v2.7.1 [INFO] [stderr] Compiling linux-raw-sys v0.4.13 [INFO] [stderr] Compiling anyhow v1.0.80 [INFO] [stderr] Compiling anstyle-parse v0.2.3 [INFO] [stderr] Compiling strsim v0.11.0 [INFO] [stderr] Compiling bitflags v2.4.2 [INFO] [stderr] Compiling time-macros v0.2.18 [INFO] [stderr] Compiling itoa v1.0.10 [INFO] [stderr] Compiling num_threads v0.1.7 [INFO] [stderr] Compiling anstream v0.6.13 [INFO] [stderr] Compiling clap_lex v0.7.0 [INFO] [stderr] Compiling arrayref v0.3.7 [INFO] [stderr] Compiling log v0.4.21 [INFO] [stderr] Compiling constant_time_eq v0.3.0 [INFO] [stderr] Compiling shlex v1.3.0 [INFO] [stderr] Compiling roundable v0.1.0 [INFO] [stderr] Compiling home v0.5.9 [INFO] [stderr] Compiling nom v7.1.3 [INFO] [stderr] Compiling bstr v1.9.1 [INFO] [stderr] Compiling clap_builder v4.5.2 [INFO] [stderr] Compiling blake3 v1.5.0 [INFO] [stderr] Compiling quote v1.0.35 [INFO] [stderr] Compiling syn v2.0.52 [INFO] [stderr] Compiling fd-lock v4.0.2 [INFO] [stderr] Compiling time v0.3.36 [INFO] [stderr] Compiling os_pipe v1.1.5 [INFO] [stderr] Compiling nix v0.26.4 [INFO] [stderr] Compiling is-terminal v0.4.12 [INFO] [stderr] Compiling popol v3.0.0 [INFO] [stderr] Compiling simplelog v0.12.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: unused import: `error` [INFO] [stdout] --> src/command.rs:16:18 [INFO] [stdout] | [INFO] [stdout] 16 | use log::{debug, error, info, trace}; [INFO] [stdout] | ^^^^^ [INFO] [stdout] | [INFO] [stdout] = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: value assigned to `attempts` is never read [INFO] [stdout] --> src/job_logger/logger.rs:86:9 [INFO] [stdout] | [INFO] [stdout] 86 | attempts: usize, [INFO] [stdout] | ^^^^^^^^ [INFO] [stdout] | [INFO] [stdout] = help: maybe it is overwritten before being read? [INFO] [stdout] = note: `#[warn(unused_assignments)]` (part of `#[warn(unused)]`) on by default [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 22.26s [INFO] running `Command { std: "docker" "inspect" "bdafa30a180bf37e7049663e8256b5b949c6cb4b1cde116bafffbad1ad7dd6c6", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "bdafa30a180bf37e7049663e8256b5b949c6cb4b1cde116bafffbad1ad7dd6c6", kill_on_drop: false }` [INFO] [stdout] bdafa30a180bf37e7049663e8256b5b949c6cb4b1cde116bafffbad1ad7dd6c6 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:4848fb76d95f26979359cc7e45710b1dbc8f3acb7aeedee7c460d7702230f228" "/opt/rustwide/cargo-home/bin/cargo" "+1ef7943ee607160a564655b6596f83670ef95df5" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 0c723a08e101c76ce67f810c7ddc1882a76ade2debec582972bd319a5b044d2a [INFO] running `Command { std: "docker" "start" "-a" "0c723a08e101c76ce67f810c7ddc1882a76ade2debec582972bd319a5b044d2a", 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 difflib v0.4.0 [INFO] [stderr] Compiling assert_cmd v2.0.14 [INFO] [stderr] Compiling wait-timeout v0.2.0 [INFO] [stderr] Compiling fastrand v2.0.1 [INFO] [stderr] Compiling yansi v0.5.1 [INFO] [stderr] Compiling predicates v3.1.0 [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: unused import: `error` [INFO] [stdout] --> src/command.rs:16:18 [INFO] [stdout] | [INFO] [stdout] 16 | use log::{debug, error, info, trace}; [INFO] [stdout] | ^^^^^ [INFO] [stdout] | [INFO] [stdout] = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: value assigned to `attempts` is never read [INFO] [stdout] --> src/job_logger/logger.rs:86:9 [INFO] [stdout] | [INFO] [stdout] 86 | attempts: usize, [INFO] [stdout] | ^^^^^^^^ [INFO] [stdout] | [INFO] [stdout] = help: maybe it is overwritten before being read? [INFO] [stdout] = note: `#[warn(unused_assignments)]` (part of `#[warn(unused)]`) on by default [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: unused import: `error` [INFO] [stdout] --> src/command.rs:16:18 [INFO] [stdout] | [INFO] [stdout] 16 | use log::{debug, error, info, trace}; [INFO] [stdout] | ^^^^^ [INFO] [stdout] | [INFO] [stdout] = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: value assigned to `attempts` is never read [INFO] [stdout] --> src/job_logger/logger.rs:86:9 [INFO] [stdout] | [INFO] [stdout] 86 | attempts: usize, [INFO] [stdout] | ^^^^^^^^ [INFO] [stdout] | [INFO] [stdout] = help: maybe it is overwritten before being read? [INFO] [stdout] = note: `#[warn(unused_assignments)]` (part of `#[warn(unused)]`) on by default [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 16.89s [INFO] running `Command { std: "docker" "inspect" "0c723a08e101c76ce67f810c7ddc1882a76ade2debec582972bd319a5b044d2a", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "0c723a08e101c76ce67f810c7ddc1882a76ade2debec582972bd319a5b044d2a", kill_on_drop: false }` [INFO] [stdout] 0c723a08e101c76ce67f810c7ddc1882a76ade2debec582972bd319a5b044d2a [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:4848fb76d95f26979359cc7e45710b1dbc8f3acb7aeedee7c460d7702230f228" "/opt/rustwide/cargo-home/bin/cargo" "+1ef7943ee607160a564655b6596f83670ef95df5" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] ece4ba756e4f0b7d1e739362c3263dd94356d1e3e6b1d3910a278dbf382af0c8 [INFO] running `Command { std: "docker" "start" "-a" "ece4ba756e4f0b7d1e739362c3263dd94356d1e3e6b1d3910a278dbf382af0c8", kill_on_drop: false }` [INFO] [stderr] warning: unused import: `error` [INFO] [stderr] --> src/command.rs:16:18 [INFO] [stderr] | [INFO] [stderr] 16 | use log::{debug, error, info, trace}; [INFO] [stderr] | ^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default [INFO] [stderr] [INFO] [stderr] warning: value assigned to `attempts` is never read [INFO] [stderr] --> src/job_logger/logger.rs:86:9 [INFO] [stderr] | [INFO] [stderr] 86 | attempts: usize, [INFO] [stderr] | ^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = help: maybe it is overwritten before being read? [INFO] [stderr] = note: `#[warn(unused_assignments)]` (part of `#[warn(unused)]`) on by default [INFO] [stderr] [INFO] [stderr] warning: `cron-wrapper` (lib) generated 2 warnings (run `cargo fix --lib -p cron-wrapper` to apply 1 suggestion) [INFO] [stderr] warning: `cron-wrapper` (lib test) generated 2 warnings (2 duplicates) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.20s [INFO] [stdout] [INFO] [stdout] running 55 tests [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/cron_wrapper-42e3cdf398938176) [INFO] [stdout] test job_logger::logger::tests::escape_value_escapes ... ok [INFO] [stdout] test job_logger::logger::tests::escape_value_newline_implicit ... ok [INFO] [stdout] test job_logger::logger::tests::none_logger ... ok [INFO] [stdout] test job_logger::logger::tests::stream_logger_continuation_recoverable_error ... ok [INFO] [stdout] test job_logger::logger::tests::stream_logger_escapes ... ok [INFO] [stdout] test job_logger::logger::tests::directory_logger_with_command ... ok [INFO] [stdout] test job_logger::logger::tests::stream_logger_recoverable_error ... ok [INFO] [stdout] test job_logger::parser::tests::bstr_to_duration_max ... ok [INFO] [stdout] test job_logger::parser::tests::bstr_to_duration_milliseconds ... ok [INFO] [stdout] test job_logger::logger::tests::escape_value_newline_explicit ... ok [INFO] [stdout] test job_logger::logger::tests::stream_logger ... ok [INFO] [stdout] test job_logger::logger::tests::stream_logger_continuation ... ok [INFO] [stdout] test job_logger::parser::tests::bstr_to_duration_nanoseconds ... ok [INFO] [stdout] test job_logger::parser::tests::bstr_to_u64_extremes ... ok [INFO] [stdout] test job_logger::logger::tests::directory_and_stream_loggers ... ok [INFO] [stdout] test command::tests::killed ... ok [INFO] [stdout] test job_logger::logger::tests::directory_logger_no_metadata ... ok [INFO] [stdout] test job_logger::parser::tests::log_parser_blank_no_metadata ... ok [INFO] [stdout] test job_logger::parser::tests::log_parser_blank_no_records ... ok [INFO] [stdout] test job_logger::parser::tests::log_parser_just_blank ... ok [INFO] [stdout] test command::tests::echo_ok ... ok [INFO] [stdout] test job_logger::parser::tests::log_parser_no_blank_no_metadata ... ok [INFO] [stdout] test job_logger::parser::tests::log_parser_no_blank_no_records ... ok [INFO] [stdout] test job_logger::parser::tests::log_parser_simple ... 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::bstr_to_duration_zero ... ok [INFO] [stdout] test job_logger::parser::tests::log_parser_empty ... 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_line_ending_output ... ok [INFO] [stdout] test job_logger::parser::tests::unescape ... ok [INFO] [stdout] test timeout::tests::check_expired_timeout_never ... ok [INFO] [stdout] test timeout::tests::check_expired_timeout_pending ... ok [INFO] [stdout] test timeout::tests::compare_timeout_future ... ok [INFO] [stdout] test job_logger::parser::tests::unescape_line_ending_non_output ... ok [INFO] [stdout] test timeout::tests::compare_timeout_never ... ok [INFO] [stdout] test timeout::tests::compare_timeout_pending ... 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 job_logger::parser::tests::unescape_invalid_utf8 ... ok [INFO] [stdout] test lock::tests::lock_basic ... ok [INFO] [stdout] test lock::tests::lock_standard_basic ... ok [INFO] [stdout] test timeout::tests::check_expired_timeout_expired ... ok [INFO] [stdout] test timeout::tests::compare_timeout_expired ... ok [INFO] [stdout] test timeout::tests::compare_timeout_pending_overtime ... ok [INFO] [stdout] test command::tests::wait_idle_timeout ... ok [INFO] [stdout] test command::tests::wait_run_timeout ... 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::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:1248:9: [INFO] [stdout] check!( start.elapsed() < Duration::from_millis(19) ) [INFO] [stdout] with expansion: [INFO] [stdout] 22.572779ms < 19ms [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] thread 'command::tests::wait_no_timeout' (30) panicked at src/command.rs:1248:9: [INFO] [stdout] check failed [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x63965e6a7522 - std::backtrace_rs::backtrace::libunwind::trace::h786de35fecf3582f [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stdout] 1: 0x63965e6a7522 - std::backtrace_rs::backtrace::trace_unsynchronized::h4a7da1a2a64387f1 [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stdout] 2: 0x63965e6a7522 - std::sys::backtrace::_print_fmt::h6bd7d500070c788c [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/std/src/sys/backtrace.rs:66:9 [INFO] [stdout] 3: 0x63965e6a7522 - ::fmt::h6d82c1afff976903 [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/std/src/sys/backtrace.rs:39:26 [INFO] [stdout] 4: 0x63965e6b853f - core::fmt::rt::Argument::fmt::hc4ce6d643d397690 [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/core/src/fmt/rt.rs:173:76 [INFO] [stdout] 5: 0x63965e6b853f - core::fmt::write::hb1e7ca88b6a3936e [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/core/src/fmt/mod.rs:1469:25 [INFO] [stdout] 6: 0x63965e6727e3 - std::io::default_write_fmt::haffd49d96f1984a8 [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/std/src/io/mod.rs:639:11 [INFO] [stdout] 7: 0x63965e6727e3 - std::io::Write::write_fmt::h027871c57cf57c01 [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/std/src/io/mod.rs:1954:13 [INFO] [stdout] 8: 0x63965e67f122 - std::sys::backtrace::BacktraceLock::print::ha2430613ee79d059 [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/std/src/sys/backtrace.rs:42:9 [INFO] [stdout] 9: 0x63965e684b7f - std::panicking::default_hook::{{closure}}::hdbd2db9e5c303cf6 [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/std/src/panicking.rs:301:27 [INFO] [stdout] 10: 0x63965e684a11 - std::panicking::default_hook::hed93c70cba5fdcf0 [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/std/src/panicking.rs:325:9 [INFO] [stdout] 11: 0x63965e4ff46e - as core::ops::function::Fn>::call::hd0ee8b569efc6a07 [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/alloc/src/boxed.rs:2099:9 [INFO] [stdout] 12: 0x63965e4ff46e - test::test_main_with_exit_callback::{{closure}}::hf10864b576ecd15d [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/test/src/lib.rs:145:21 [INFO] [stdout] 13: 0x63965e68518f - as core::ops::function::Fn>::call::h3a55ca34534c0d00 [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/alloc/src/boxed.rs:2099:9 [INFO] [stdout] 14: 0x63965e68518f - std::panicking::panic_with_hook::h3862d766c2cec19b [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/std/src/panicking.rs:842:13 [INFO] [stdout] 15: 0x63965e684fb6 - std::panicking::panic_handler::{{closure}}::hb95eb402b5e28ee1 [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/std/src/panicking.rs:700:13 [INFO] [stdout] 16: 0x63965e67f259 - std::sys::backtrace::__rust_end_short_backtrace::hf73a26dc1835d85a [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/std/src/sys/backtrace.rs:174:18 [INFO] [stdout] 17: 0x63965e66602d - __rustc[6ed5915ee467787]::rust_begin_unwind [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/std/src/panicking.rs:698:5 [INFO] [stdout] 18: 0x63965e6c0e40 - core::panicking::panic_fmt::h3454303eb8e6f7cd [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/core/src/panicking.rs:80:14 [INFO] [stdout] 19: 0x63965e4ccc19 - cron_wrapper::command::tests::wait_no_timeout::{{closure}}::h0c08c89b4f8dd333 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/assert2-0.3.14/src/lib.rs:247:47 [INFO] [stdout] 20: 0x63965e48e411 - as core::ops::drop::Drop>::drop::h9164ac3d9929e43d [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/assert2-0.3.14/src/__assert2_impl/mod.rs:16:4 [INFO] [stdout] 21: 0x63965e490d7a - core::ptr::drop_in_place>::h7d8c1ac6e4955a2d [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/core/src/ptr/mod.rs:805:1 [INFO] [stdout] 22: 0x63965e491f9e - core::ptr::drop_in_place>>::hdad60edc531b7132 [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/core/src/ptr/mod.rs:805:1 [INFO] [stdout] 23: 0x63965e4cc879 - cron_wrapper::command::tests::wait_no_timeout::h75b1dec2b4c8f363 [INFO] [stdout] at /opt/rustwide/workdir/src/command.rs:1249:5 [INFO] [stdout] 24: 0x63965e4ccc67 - cron_wrapper::command::tests::wait_no_timeout::{{closure}}::h6d458ba9e6180756 [INFO] [stdout] at /opt/rustwide/workdir/src/command.rs:1238:25 [INFO] [stdout] 25: 0x63965e4906f6 - core::ops::function::FnOnce::call_once::hc8e8d4bc2c5fe19f [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 26: 0x63965e4ff24b - core::ops::function::FnOnce::call_once::ha729ee35d2fab541 [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 27: 0x63965e4ff24b - test::__rust_begin_short_backtrace::ha40f4db8207e1111 [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/test/src/lib.rs:663:18 [INFO] [stdout] 28: 0x63965e5132cd - test::run_test_in_process::{{closure}}::hc1b77cda5d44f0f3 [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/test/src/lib.rs:686:74 [INFO] [stdout] 29: 0x63965e5132cd - as core::ops::function::FnOnce<()>>::call_once::h1dbea1de64785521 [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/core/src/panic/unwind_safe.rs:274:9 [INFO] [stdout] 30: 0x63965e5132cd - std::panicking::catch_unwind::do_call::hd5febe9affd5a1b3 [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/std/src/panicking.rs:590:40 [INFO] [stdout] 31: 0x63965e5132cd - std::panicking::catch_unwind::h51ea89627559b6f4 [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/std/src/panicking.rs:553:19 [INFO] [stdout] 32: 0x63965e5132cd - std::panic::catch_unwind::hb8b8c2367cae3d66 [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/std/src/panic.rs:359:14 [INFO] [stdout] 33: 0x63965e5132cd - test::run_test_in_process::ha5b55801407ea100 [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/test/src/lib.rs:686:27 [INFO] [stdout] 34: 0x63965e5132cd - test::run_test::{{closure}}::h0b9d4072b527abf5 [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/test/src/lib.rs:607:43 [INFO] [stdout] 35: 0x63965e4ec7e4 - test::run_test::{{closure}}::hb1056b5731205822 [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/test/src/lib.rs:637:41 [INFO] [stdout] 36: 0x63965e4ec7e4 - std::sys::backtrace::__rust_begin_short_backtrace::hb61ff5a34023c7ef [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/std/src/sys/backtrace.rs:158:18 [INFO] [stdout] 37: 0x63965e4f011a - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hb0a83c0e8b353cff [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/std/src/thread/mod.rs:562:17 [INFO] [stdout] 38: 0x63965e4f011a - as core::ops::function::FnOnce<()>>::call_once::hb4f32cb008535298 [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/core/src/panic/unwind_safe.rs:274:9 [INFO] [stdout] 39: 0x63965e4f011a - std::panicking::catch_unwind::do_call::h16d110e4fc35789a [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/std/src/panicking.rs:590:40 [INFO] [stdout] 40: 0x63965e4f011a - std::panicking::catch_unwind::hea9118f355699c4b [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/std/src/panicking.rs:553:19 [INFO] [stdout] 41: 0x63965e4f011a - std::panic::catch_unwind::hf4b3c2a06d3f42f5 [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/std/src/panic.rs:359:14 [INFO] [stdout] 42: 0x63965e4f011a - std::thread::Builder::spawn_unchecked_::{{closure}}::h3f4cb733a52d53d5 [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/std/src/thread/mod.rs:560:30 [INFO] [stdout] 43: 0x63965e4f011a - core::ops::function::FnOnce::call_once{{vtable.shim}}::h4052f0967b37caeb [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 44: 0x63965e67a57f - as core::ops::function::FnOnce>::call_once::h7ec433abd3f148b4 [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/alloc/src/boxed.rs:2085:9 [INFO] [stdout] 45: 0x63965e67a57f - std::sys::thread::unix::Thread::new::thread_start::he514622d3d7ba65c [INFO] [stdout] at /rustc/1ef7943ee607160a564655b6596f83670ef95df5/library/std/src/sys/thread/unix.rs:124:17 [INFO] [stdout] 46: 0x784a07807aa4 - [INFO] [stdout] 47: 0x784a07894a64 - clone [INFO] [stdout] 48: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] command::tests::wait_no_timeout [INFO] [stdout] [INFO] [stdout] test result: FAILED. 54 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.01s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass `--lib` [INFO] running `Command { std: "docker" "inspect" "ece4ba756e4f0b7d1e739362c3263dd94356d1e3e6b1d3910a278dbf382af0c8", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "ece4ba756e4f0b7d1e739362c3263dd94356d1e3e6b1d3910a278dbf382af0c8", kill_on_drop: false }` [INFO] [stdout] ece4ba756e4f0b7d1e739362c3263dd94356d1e3e6b1d3910a278dbf382af0c8