[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] 04e2bcb1cf986814f939fc19105b6c2a0443e3f5 [INFO] testing danielparks/cron-wrapper against master#ebf0cf75d368c035f4c7e7246d203bd469ee4a51 for pr-137940-2 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdanielparks%2Fcron-wrapper" "/workspace/builds/worker-1-tc1/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-1-tc1/source'... [INFO] [stderr] done. [INFO] validating manifest of git repo https://github.com/danielparks/cron-wrapper on toolchain ebf0cf75d368c035f4c7e7246d203bd469ee4a51 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+ebf0cf75d368c035f4c7e7246d203bd469ee4a51" "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-1-tc1/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" "+ebf0cf75d368c035f4c7e7246d203bd469ee4a51" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Updating crates.io index [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded quote v1.0.35 [INFO] [stderr] Downloaded thiserror v1.0.57 [INFO] [stderr] Downloaded num_threads v0.1.7 [INFO] [stderr] Downloaded itoa v1.0.10 [INFO] [stderr] Downloaded is-terminal v0.4.12 [INFO] [stderr] Downloaded colorchoice v1.0.0 [INFO] [stderr] Downloaded doc-comment v0.3.3 [INFO] [stderr] Downloaded windows-targets v0.52.4 [INFO] [stderr] Downloaded termtree v0.4.1 [INFO] [stderr] Downloaded assert2-macros v0.3.14 [INFO] [stderr] Downloaded utf8parse v0.2.1 [INFO] [stderr] Downloaded strsim v0.11.0 [INFO] [stderr] Downloaded predicates-core v1.0.6 [INFO] [stderr] Downloaded predicates v3.1.0 [INFO] [stderr] Downloaded winapi-util v0.1.6 [INFO] [stderr] Downloaded yansi v0.5.1 [INFO] [stderr] Downloaded semver v1.0.22 [INFO] [stderr] Downloaded anyhow v1.0.80 [INFO] [stderr] Downloaded diff v0.1.13 [INFO] [stderr] Downloaded memchr v2.7.1 [INFO] [stderr] Downloaded cc v1.0.90 [INFO] [stderr] Downloaded clap v4.5.2 [INFO] [stderr] Downloaded rust_decimal v1.34.3 [INFO] [stderr] Downloaded clap_builder v4.5.2 [INFO] [stderr] Downloaded blake3 v1.5.0 [INFO] [stderr] Downloaded aho-corasick v1.1.2 [INFO] [stderr] Downloaded bitflags v2.4.2 [INFO] [stderr] Downloaded syn v2.0.52 [INFO] [stderr] Downloaded syn v1.0.109 [INFO] [stderr] Downloaded nix v0.26.4 [INFO] [stderr] Downloaded regex v1.10.3 [INFO] [stderr] Downloaded serde v1.0.197 [INFO] [stderr] Downloaded num-traits v0.2.18 [INFO] [stderr] Downloaded regex-syntax v0.8.2 [INFO] [stderr] Downloaded log v0.4.21 [INFO] [stderr] Downloaded bstr v1.9.1 [INFO] [stderr] Downloaded rustix v0.38.31 [INFO] [stderr] Downloaded serde_derive v1.0.197 [INFO] [stderr] Downloaded windows_aarch64_gnullvm v0.52.4 [INFO] [stderr] Downloaded windows_x86_64_gnullvm v0.52.4 [INFO] [stderr] Downloaded assert2 v0.3.14 [INFO] [stderr] Downloaded difflib v0.4.0 [INFO] [stderr] Downloaded assert_cmd v2.0.14 [INFO] [stderr] Downloaded constant_time_eq v0.3.0 [INFO] [stderr] Downloaded anstyle-parse v0.2.3 [INFO] [stderr] Downloaded anstream v0.6.13 [INFO] [stderr] Downloaded clap_derive v4.5.0 [INFO] [stderr] Downloaded regex-automata v0.4.6 [INFO] [stderr] Downloaded arrayvec v0.7.4 [INFO] [stderr] Downloaded libc v0.2.153 [INFO] [stderr] Downloaded predicates-tree v1.0.9 [INFO] [stderr] Downloaded anstyle-query v1.0.2 [INFO] [stderr] Downloaded fd-lock v4.0.2 [INFO] [stderr] Downloaded hermit-abi v0.3.9 [INFO] [stderr] Downloaded os_pipe v1.1.5 [INFO] [stderr] Downloaded popol v3.0.0 [INFO] [stderr] Downloaded wait-timeout v0.2.0 [INFO] [stderr] Downloaded arrayref v0.3.7 [INFO] [stderr] Downloaded anstyle-wincon v3.0.2 [INFO] [stderr] Downloaded anstyle v1.0.6 [INFO] [stderr] Downloaded windows_x86_64_msvc v0.52.4 [INFO] [stderr] Downloaded windows_aarch64_msvc v0.52.4 [INFO] [stderr] Downloaded windows_i686_msvc v0.52.4 [INFO] [stderr] Downloaded windows_i686_gnu v0.52.4 [INFO] [stderr] Downloaded windows_x86_64_gnu v0.52.4 [INFO] [stderr] Downloaded roundable v0.1.0 [INFO] [stderr] Downloaded thiserror-impl v1.0.57 [INFO] [stderr] Downloaded autocfg v1.1.0 [INFO] [stderr] Downloaded duration-str v0.5.1 [INFO] [stderr] Downloaded fastrand v2.0.1 [INFO] [stderr] Downloaded simplelog v0.12.2 [INFO] [stderr] Downloaded proc-macro2 v1.0.78 [INFO] [stderr] Downloaded heck v0.4.1 [INFO] [stderr] Downloaded clap_lex v0.7.0 [INFO] [stderr] Downloaded termcolor v1.4.1 [INFO] [stderr] Downloaded errno v0.3.8 [INFO] [stderr] Downloaded linux-raw-sys v0.4.13 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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:1680c8fbd8dfb46fcd6d22e546df16ab0e007457dc29fcd9e987cdd5077fd1af" "/opt/rustwide/cargo-home/bin/cargo" "+ebf0cf75d368c035f4c7e7246d203bd469ee4a51" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 339e3bece91aad34c27f1ba9fbf42d6eb08b0aa0741c7abc16727a767dcc50fb [INFO] running `Command { std: "docker" "start" "-a" "339e3bece91aad34c27f1ba9fbf42d6eb08b0aa0741c7abc16727a767dcc50fb", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "339e3bece91aad34c27f1ba9fbf42d6eb08b0aa0741c7abc16727a767dcc50fb", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "339e3bece91aad34c27f1ba9fbf42d6eb08b0aa0741c7abc16727a767dcc50fb", kill_on_drop: false }` [INFO] [stdout] 339e3bece91aad34c27f1ba9fbf42d6eb08b0aa0741c7abc16727a767dcc50fb [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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:1680c8fbd8dfb46fcd6d22e546df16ab0e007457dc29fcd9e987cdd5077fd1af" "/opt/rustwide/cargo-home/bin/cargo" "+ebf0cf75d368c035f4c7e7246d203bd469ee4a51" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] b3caf161e0ca87fc3cef34ae401319620630fd92c9f41ffdca8acebbd5e38ad0 [INFO] running `Command { std: "docker" "start" "-a" "b3caf161e0ca87fc3cef34ae401319620630fd92c9f41ffdca8acebbd5e38ad0", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.78 [INFO] [stderr] Compiling autocfg v1.1.0 [INFO] [stderr] Compiling utf8parse v0.2.1 [INFO] [stderr] Compiling anstyle v1.0.6 [INFO] [stderr] Compiling cc v1.0.90 [INFO] [stderr] Compiling rustix v0.38.31 [INFO] [stderr] Compiling powerfmt v0.2.0 [INFO] [stderr] Compiling thiserror v1.0.57 [INFO] [stderr] Compiling anstyle-parse v0.2.3 [INFO] [stderr] Compiling rust_decimal v1.34.3 [INFO] [stderr] Compiling num-conv v0.1.0 [INFO] [stderr] Compiling colorchoice v1.0.0 [INFO] [stderr] Compiling time-core v0.1.2 [INFO] [stderr] Compiling num-traits v0.2.18 [INFO] [stderr] Compiling anstyle-query v1.0.2 [INFO] [stderr] Compiling arrayvec v0.7.4 [INFO] [stderr] Compiling memchr v2.7.1 [INFO] [stderr] Compiling anstream v0.6.13 [INFO] [stderr] Compiling time-macros v0.2.18 [INFO] [stderr] Compiling deranged v0.3.11 [INFO] [stderr] Compiling heck v0.4.1 [INFO] [stderr] Compiling clap_lex v0.7.0 [INFO] [stderr] Compiling quote v1.0.35 [INFO] [stderr] Compiling num_threads v0.1.7 [INFO] [stderr] Compiling syn v2.0.52 [INFO] [stderr] Compiling minimal-lexical v0.2.1 [INFO] [stderr] Compiling bitflags v2.4.2 [INFO] [stderr] Compiling strsim v0.11.0 [INFO] [stderr] Compiling anyhow v1.0.80 [INFO] [stderr] Compiling linux-raw-sys v0.4.13 [INFO] [stderr] Compiling blake3 v1.5.0 [INFO] [stderr] Compiling itoa v1.0.10 [INFO] [stderr] Compiling clap_builder v4.5.2 [INFO] [stderr] Compiling nom v7.1.3 [INFO] [stderr] Compiling log v0.4.21 [INFO] [stderr] Compiling constant_time_eq v0.3.0 [INFO] [stderr] Compiling nix v0.26.4 [INFO] [stderr] Compiling time v0.3.36 [INFO] [stderr] Compiling bstr v1.9.1 [INFO] [stderr] Compiling popol v3.0.0 [INFO] [stderr] Compiling os_pipe v1.1.5 [INFO] [stderr] Compiling is-terminal v0.4.12 [INFO] [stderr] Compiling roundable v0.1.0 [INFO] [stderr] Compiling home v0.5.9 [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] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 23.80s [INFO] running `Command { std: "docker" "inspect" "b3caf161e0ca87fc3cef34ae401319620630fd92c9f41ffdca8acebbd5e38ad0", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "b3caf161e0ca87fc3cef34ae401319620630fd92c9f41ffdca8acebbd5e38ad0", kill_on_drop: false }` [INFO] [stdout] b3caf161e0ca87fc3cef34ae401319620630fd92c9f41ffdca8acebbd5e38ad0 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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:1680c8fbd8dfb46fcd6d22e546df16ab0e007457dc29fcd9e987cdd5077fd1af" "/opt/rustwide/cargo-home/bin/cargo" "+ebf0cf75d368c035f4c7e7246d203bd469ee4a51" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 0b9f5ae64216b1c87f8b4b3bd6feb838c93335d2db3e41bc3128840c0f778612 [INFO] running `Command { std: "docker" "start" "-a" "0b9f5ae64216b1c87f8b4b3bd6feb838c93335d2db3e41bc3128840c0f778612", 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 predicates-core v1.0.6 [INFO] [stderr] Compiling difflib v0.4.0 [INFO] [stderr] Compiling termtree v0.4.1 [INFO] [stderr] Compiling assert_cmd v2.0.14 [INFO] [stderr] Compiling wait-timeout v0.2.0 [INFO] [stderr] Compiling predicates-tree v1.0.9 [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 cron-wrapper v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Compiling assert2 v0.3.14 [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 19.71s [INFO] running `Command { std: "docker" "inspect" "0b9f5ae64216b1c87f8b4b3bd6feb838c93335d2db3e41bc3128840c0f778612", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "0b9f5ae64216b1c87f8b4b3bd6feb838c93335d2db3e41bc3128840c0f778612", kill_on_drop: false }` [INFO] [stdout] 0b9f5ae64216b1c87f8b4b3bd6feb838c93335d2db3e41bc3128840c0f778612 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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:1680c8fbd8dfb46fcd6d22e546df16ab0e007457dc29fcd9e987cdd5077fd1af" "/opt/rustwide/cargo-home/bin/cargo" "+ebf0cf75d368c035f4c7e7246d203bd469ee4a51" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 5e647541ba4442263891b2095f34621929ee2c9462fc3c17e9d1bba8fa9e811b [INFO] running `Command { std: "docker" "start" "-a" "5e647541ba4442263891b2095f34621929ee2c9462fc3c17e9d1bba8fa9e811b", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.15s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/cron_wrapper-ab4e209535e0a75f) [INFO] [stdout] [INFO] [stdout] running 55 tests [INFO] [stdout] test job_logger::logger::tests::directory_and_stream_loggers ... ok [INFO] [stdout] test command::tests::echo_ok ... ok [INFO] [stdout] test job_logger::logger::tests::directory_logger_no_metadata ... ok [INFO] [stdout] test command::tests::killed ... 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 job_logger::logger::tests::escape_value_newline_explicit ... ok [INFO] [stdout] test job_logger::logger::tests::escape_value_newline_implicit ... ok [INFO] [stdout] test command::tests::wait_idle_timeout ... ok [INFO] [stdout] test command::tests::wait_run_timeout ... ok [INFO] [stdout] test job_logger::logger::tests::stream_logger_continuation ... 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::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::parser::tests::bstr_to_duration_nanoseconds ... ok [INFO] [stdout] test job_logger::logger::tests::none_logger ... ok [INFO] [stdout] test job_logger::logger::tests::stream_logger ... 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_empty ... ok [INFO] [stdout] test job_logger::logger::tests::directory_logger_with_child ... 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_metadata ... ok [INFO] [stdout] test job_logger::parser::tests::bstr_to_duration_zero ... 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::bstr_to_u64_extremes ... ok [INFO] [stdout] test job_logger::parser::tests::metadata_line_parser_ok_multiline ... ok [INFO] [stdout] test job_logger::parser::tests::log_parser_simple ... ok [INFO] [stdout] test job_logger::parser::tests::log_parser_no_blank_no_records ... 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::unescape_invalid_utf8 ... ok [INFO] [stdout] test command::tests::wait_no_timeout ... FAILED [INFO] [stdout] test job_logger::parser::tests::unescape ... ok [INFO] [stdout] test job_logger::parser::tests::unescape_line_ending_output ... ok [INFO] [stdout] test timeout::tests::check_expired_timeout_expired ... ok [INFO] [stdout] test job_logger::parser::tests::unescape_line_ending_non_output ... ok [INFO] [stdout] test timeout::tests::check_expired_timeout_future ... ok [INFO] [stdout] test lock::tests::lock_standard_basic ... ok [INFO] [stdout] test timeout::tests::check_expired_timeout_pending ... ok [INFO] [stdout] test timeout::tests::check_expired_timeout_never ... ok [INFO] [stdout] test job_logger::parser::tests::record_parser_ok_multiline ... 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 lock::tests::lock_basic ... ok [INFO] [stdout] test job_logger::logger::tests::directory_logger_conflicting_file_name ... ok [INFO] [stdout] test command::tests::run_timeout ... ok [INFO] [stderr] error: test failed, to rerun pass `--lib` [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.754168ms < 19ms [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] thread 'command::tests::wait_no_timeout' panicked at src/command.rs:1248:9: [INFO] [stdout] check failed [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x64f732450d32 - std::backtrace_rs::backtrace::libunwind::trace::hf010e1dbae51cb72 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stdout] 1: 0x64f732450d32 - std::backtrace_rs::backtrace::trace_unsynchronized::hfea1b1ce70c8ef04 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stdout] 2: 0x64f732450d32 - std::sys::backtrace::_print_fmt::h2997a50d2484a6a6 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/sys/backtrace.rs:66:9 [INFO] [stdout] 3: 0x64f732450d32 - ::fmt::h7fb80f6afbe41a33 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/sys/backtrace.rs:39:26 [INFO] [stdout] 4: 0x64f732479e43 - core::fmt::rt::Argument::fmt::hd3a68c3e7e846625 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/core/src/fmt/rt.rs:185:76 [INFO] [stdout] 5: 0x64f732479e43 - core::fmt::write::h000527be0eea6fe8 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/core/src/fmt/mod.rs:1449:21 [INFO] [stdout] 6: 0x64f73244d333 - std::io::Write::write_fmt::h5402e677befea770 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/io/mod.rs:1890:15 [INFO] [stdout] 7: 0x64f732450b82 - std::sys::backtrace::BacktraceLock::print::hffad87dde00cbe3e [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/sys/backtrace.rs:42:9 [INFO] [stdout] 8: 0x64f7324521da - std::panicking::default_hook::{{closure}}::ha46397973bec1239 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/panicking.rs:298:22 [INFO] [stdout] 9: 0x64f732451fc9 - std::panicking::default_hook::h706de72a1550eed4 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/panicking.rs:322:9 [INFO] [stdout] 10: 0x64f7322d47c7 - as core::ops::function::Fn>::call::hde091e5c6e92bb68 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/alloc/src/boxed.rs:1984:9 [INFO] [stdout] 11: 0x64f7322d47c7 - test::test_main::{{closure}}::h769424ff54c41197 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/test/src/lib.rs:136:21 [INFO] [stdout] 12: 0x64f732452cc3 - as core::ops::function::Fn>::call::hbd7480c9dddf3315 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/alloc/src/boxed.rs:1984:9 [INFO] [stdout] 13: 0x64f732452cc3 - std::panicking::rust_panic_with_hook::h6666776865bd21f5 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/panicking.rs:839:13 [INFO] [stdout] 14: 0x64f732452946 - std::panicking::begin_panic_handler::{{closure}}::hb8595612365d24db [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/panicking.rs:697:13 [INFO] [stdout] 15: 0x64f732451229 - std::sys::backtrace::__rust_end_short_backtrace::h7037f177c7ae4ed3 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/sys/backtrace.rs:168:18 [INFO] [stdout] 16: 0x64f73245260d - rust_begin_unwind [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/panicking.rs:695:5 [INFO] [stdout] 17: 0x64f732477fe0 - core::panicking::panic_fmt::hd26142fa9828e2a3 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/core/src/panicking.rs:75:14 [INFO] [stdout] 18: 0x64f732253349 - cron_wrapper::command::tests::wait_no_timeout::{{closure}}::h5c18b61bf2ffdd28 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/assert2-0.3.14/src/lib.rs:247:47 [INFO] [stdout] 19: 0x64f732274141 - as core::ops::drop::Drop>::drop::h5bb33706c7941089 [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] 20: 0x64f73223bafa - core::ptr::drop_in_place>::h42d0c276148eb3e7 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/core/src/ptr/mod.rs:523:1 [INFO] [stdout] 21: 0x64f73223ccce - core::ptr::drop_in_place>>::h39e1b2e4ad0459a7 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/core/src/ptr/mod.rs:523:1 [INFO] [stdout] 22: 0x64f732252f49 - cron_wrapper::command::tests::wait_no_timeout::hac5d7a78f7d8abb6 [INFO] [stdout] at /opt/rustwide/workdir/src/command.rs:1249:5 [INFO] [stdout] 23: 0x64f7322527f7 - cron_wrapper::command::tests::wait_no_timeout::{{closure}}::hc9de05caeb25447e [INFO] [stdout] at /opt/rustwide/workdir/src/command.rs:1238:25 [INFO] [stdout] 24: 0x64f73223a9f6 - core::ops::function::FnOnce::call_once::h220f4999010d9cb6 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 25: 0x64f7322da0cb - core::ops::function::FnOnce::call_once::h537cb3ba0681a85d [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 26: 0x64f7322da0cb - test::__rust_begin_short_backtrace::ha34590b284b8a909 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/test/src/lib.rs:638:18 [INFO] [stdout] 27: 0x64f7322d9165 - test::run_test_in_process::{{closure}}::h7e5cb0195a5ea6a6 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/test/src/lib.rs:661:60 [INFO] [stdout] 28: 0x64f7322d9165 - as core::ops::function::FnOnce<()>>::call_once::h4fd7826f39023efe [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 29: 0x64f7322d9165 - std::panicking::try::do_call::h840562177f324507 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/panicking.rs:587:40 [INFO] [stdout] 30: 0x64f7322d9165 - std::panicking::try::h2360ed2f8f8e7bd8 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/panicking.rs:550:19 [INFO] [stdout] 31: 0x64f7322d9165 - std::panic::catch_unwind::h98cd8da2f8eb8f7b [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/panic.rs:359:14 [INFO] [stdout] 32: 0x64f7322d9165 - test::run_test_in_process::hcd6b1143eaf140ef [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/test/src/lib.rs:661:27 [INFO] [stdout] 33: 0x64f7322d9165 - test::run_test::{{closure}}::h12da0337272887dc [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/test/src/lib.rs:582:43 [INFO] [stdout] 34: 0x64f73229c154 - test::run_test::{{closure}}::h11d537cad5364bdc [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/test/src/lib.rs:612:41 [INFO] [stdout] 35: 0x64f73229c154 - std::sys::backtrace::__rust_begin_short_backtrace::h5f533949825eb644 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/sys/backtrace.rs:152:18 [INFO] [stdout] 36: 0x64f73229fbba - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hf8cffede9b676267 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/thread/mod.rs:559:17 [INFO] [stdout] 37: 0x64f73229fbba - as core::ops::function::FnOnce<()>>::call_once::h3160424131f9b05b [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 38: 0x64f73229fbba - std::panicking::try::do_call::h4821f856f783960c [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/panicking.rs:587:40 [INFO] [stdout] 39: 0x64f73229fbba - std::panicking::try::hd6726363e8162e27 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/panicking.rs:550:19 [INFO] [stdout] 40: 0x64f73229fbba - std::panic::catch_unwind::hb75a27d7bd2912cb [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/panic.rs:359:14 [INFO] [stdout] 41: 0x64f73229fbba - std::thread::Builder::spawn_unchecked_::{{closure}}::h36d5666a81748b85 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/thread/mod.rs:557:30 [INFO] [stdout] 42: 0x64f73229fbba - core::ops::function::FnOnce::call_once{{vtable.shim}}::ha3d6556f1deabcaf [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 43: 0x64f7324565fb - as core::ops::function::FnOnce>::call_once::h454485597884df01 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/alloc/src/boxed.rs:1970:9 [INFO] [stdout] 44: 0x64f7324565fb - as core::ops::function::FnOnce>::call_once::h421b8b5dc09cf3b4 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/alloc/src/boxed.rs:1970:9 [INFO] [stdout] 45: 0x64f7324565fb - std::sys::pal::unix::thread::Thread::new::thread_start::ha1530b93ff336c49 [INFO] [stdout] at /rustc/ebf0cf75d368c035f4c7e7246d203bd469ee4a51/library/std/src/sys/pal/unix/thread.rs:109:17 [INFO] [stdout] 46: 0x766865609ac3 - [INFO] [stdout] 47: 0x76686569aa04 - 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.02s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "5e647541ba4442263891b2095f34621929ee2c9462fc3c17e9d1bba8fa9e811b", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "5e647541ba4442263891b2095f34621929ee2c9462fc3c17e9d1bba8fa9e811b", kill_on_drop: false }` [INFO] [stdout] 5e647541ba4442263891b2095f34621929ee2c9462fc3c17e9d1bba8fa9e811b