[INFO] fetching crate timecard 0.3.0...
[INFO] testing timecard-0.3.0 against try#33835004928d3bf65db4d4712e1330766263b0bd for pr-155739-1
[INFO] extracting crate timecard 0.3.0 into /workspace/builds/worker-0-tc2/source
[INFO] started tweaking crates.io crate timecard 0.3.0
[INFO] finished tweaking crates.io crate timecard 0.3.0
[INFO] tweaked toml for crates.io crate timecard 0.3.0 written to /workspace/builds/worker-0-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate timecard 0.3.0 on toolchain 33835004928d3bf65db4d4712e1330766263b0bd
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate timecard 0.3.0 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" "+33835004928d3bf65db4d4712e1330766263b0bd" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] b6beaaed0c391f114c45f05b5246ffefa0e24c065778816467d56b7fa07715f8
[INFO] running `Command { std: "docker" "start" "-a" "b6beaaed0c391f114c45f05b5246ffefa0e24c065778816467d56b7fa07715f8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "b6beaaed0c391f114c45f05b5246ffefa0e24c065778816467d56b7fa07715f8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b6beaaed0c391f114c45f05b5246ffefa0e24c065778816467d56b7fa07715f8", kill_on_drop: false }`
[INFO] [stdout] b6beaaed0c391f114c45f05b5246ffefa0e24c065778816467d56b7fa07715f8
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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=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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 583d33155fab970d69a9d5b6a9e4350a677041c486d0cae9d283557705a5d157
[INFO] running `Command { std: "docker" "start" "-a" "583d33155fab970d69a9d5b6a9e4350a677041c486d0cae9d283557705a5d157", kill_on_drop: false }`
[INFO] [stderr]    Compiling quote v1.0.44
[INFO] [stderr]    Compiling autocfg v1.5.0
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling iana-time-zone v0.1.65
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling chrono v0.4.44
[INFO] [stderr]    Compiling timecard v0.3.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 15.49s
[INFO] running `Command { std: "docker" "inspect" "583d33155fab970d69a9d5b6a9e4350a677041c486d0cae9d283557705a5d157", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "583d33155fab970d69a9d5b6a9e4350a677041c486d0cae9d283557705a5d157", kill_on_drop: false }`
[INFO] [stdout] 583d33155fab970d69a9d5b6a9e4350a677041c486d0cae9d283557705a5d157
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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=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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d11ace9bb06915f33cf58dba73138669ac87916ec65bae7f5627ef9db81f9b68
[INFO] running `Command { std: "docker" "start" "-a" "d11ace9bb06915f33cf58dba73138669ac87916ec65bae7f5627ef9db81f9b68", kill_on_drop: false }`
[INFO] [stderr]    Compiling timecard v0.3.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.14s
[INFO] running `Command { std: "docker" "inspect" "d11ace9bb06915f33cf58dba73138669ac87916ec65bae7f5627ef9db81f9b68", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d11ace9bb06915f33cf58dba73138669ac87916ec65bae7f5627ef9db81f9b68", kill_on_drop: false }`
[INFO] [stdout] d11ace9bb06915f33cf58dba73138669ac87916ec65bae7f5627ef9db81f9b68
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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=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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] da466ecd8d6990b8cdfd4131cb5e821ff8254ebe8e34f597dacfb28b4e99980a
[INFO] running `Command { std: "docker" "start" "-a" "da466ecd8d6990b8cdfd4131cb5e821ff8254ebe8e34f597dacfb28b4e99980a", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.08s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/timecard-861f9e5047bddfc0)
[INFO] [stdout] 
[INFO] [stdout] running 66 tests
[INFO] [stdout] test timecard::tests::clock_in_errors_when_time_in_future ... ok
[INFO] [stdout] test timecard::tests::clears_empty_timecard ... ok
[INFO] [stdout] test timecard::tests::clock_in_errors_when_already_clocked_in ... ok
[INFO] [stdout] test timecard::tests::clears_nonempty_timecard ... ok
[INFO] [stdout] test timecard::tests::clock_out_errors_when_not_clocked_in ... ok
[INFO] [stdout] test timecard::tests::clocks_out_when_clocked_in ... ok
[INFO] [stdout] test timecard::tests::clocks_in_when_clocked_out_with_entries ... ok
[INFO] [stdout] test timecard::tests::clocks_out_with_multiple_entries ... ok
[INFO] [stdout] test timecard::tests::creates_empty_timecard ... ok
[INFO] [stdout] test timecard::tests::clock_out_errors_with_invalid_times ... ok
[INFO] [stdout] test timecard::tests::creates_timecard_with_single_closed_entry ... ok
[INFO] [stdout] test timecard::tests::clocks_in_when_empty ... ok
[INFO] [stdout] test timecard::tests::creates_timecard_with_single_open_entry ... ok
[INFO] [stdout] test timecard::tests::creates_timecard_with_closed_and_open_entries ... ok
[INFO] [stdout] test timecard::tests::creates_timecard_with_zero_duration_entry ... ok
[INFO] [stdout] test timecard::tests::filters_by_date_range_multiple_closed_entries ... ok
[INFO] [stdout] test timecard::tests::filters_by_date_range_open_entry ... ok
[INFO] [stdout] test timecard::tests::creates_timecard_with_consecutive_entries ... ok
[INFO] [stdout] test timecard::tests::filters_by_day_empty_timecard ... ok
[INFO] [stdout] test timecard::tests::filters_by_day_entry_spanning_two_days ... ok
[INFO] [stdout] test timecard::tests::filters_by_day_multi_day_entry_with_separate_open_entry ... ok
[INFO] [stdout] test timecard::tests::filters_by_day_multiple_entries_on_different_days ... ok
[INFO] [stdout] test timecard::tests::filters_by_day_open_entry_spanning_multiple_days ... ok
[INFO] [stdout] test timecard::tests::gets_duration_on_break_current_day_with_open_entry ... ok
[INFO] [stdout] test timecard::tests::filters_by_day_single_closed_past_entry ... ok
[INFO] [stdout] test timecard::tests::gets_duration_on_break_empty_timecard ... ok
[INFO] [stdout] test timecard::tests::filters_by_day_single_open_entry ... ok
[INFO] [stdout] test timecard::tests::gets_duration_on_break_current_day_all_closed ... ok
[INFO] [stdout] test timecard::tests::gets_duration_on_break_two_closed_entries_with_break ... ok
[INFO] [stdout] test timecard::tests::gets_duration_on_break_with_open_entry ... ok
[INFO] [stdout] test timecard::tests::gets_duration_worked_current_day_all_closed ... ok
[INFO] [stdout] test timecard::tests::gets_duration_on_break_multi_day_multi_entry ... ok
[INFO] [stdout] test timecard::tests::gets_duration_worked_current_day_with_open_entry ... ok
[INFO] [stdout] test timecard::tests::gets_duration_worked_empty_timecard ... ok
[INFO] [stdout] test timecard::tests::gets_duration_worked_multi_day_with_open_entry ... ok
[INFO] [stdout] test timecard::tests::gets_duration_worked_multi_day_entry ... ok
[INFO] [stdout] test timecard::tests::gets_duration_worked_single_closed_entry ... ok
[INFO] [stdout] test timecard::tests::gets_duration_worked_two_closed_entries_with_break ... ok
[INFO] [stdout] test timecard::tests::gets_duration_on_break_multi_day_with_open_entry ... ok
[INFO] [stdout] test timecard::tests::gets_duration_worked_with_open_entry ... ok
[INFO] [stdout] test timecard::tests::gets_entries ... ok
[INFO] [stdout] test timecard::tests::gets_duration_on_break_single_closed_entry ... ok
[INFO] [stdout] test timecard::tests::gets_duration_worked_multi_day_multi_entry ... ok
[INFO] [stdout] test timecard::tests::gets_expected_end_time_current_day_all_closed ... ok
[INFO] [stdout] test timecard::tests::gets_expected_end_time_current_day_with_open_entry ... ok
[INFO] [stdout] test timecard::tests::gets_duration_on_break_multi_day_entry ... ok
[INFO] [stdout] test timecard::tests::gets_expected_end_time_single_closed_entry ... ok
[INFO] [stdout] test timecard::tests::gets_expected_end_time_two_closed_entries_with_break ... ok
[INFO] [stdout] test timecard::tests::gets_expected_end_time_with_open_entry ... ok
[INFO] [stdout] test timecard::tests::rejects_bad_entry ... ok
[INFO] [stdout] test timecard::tests::gets_expected_end_time_multi_day_entry ... ok
[INFO] [stdout] test timecard::tests::gets_expected_end_time_multi_day_multi_entry ... ok
[INFO] [stdout] test timecard::tests::gets_expected_end_time_multi_day_with_open_entry ... ok
[INFO] [stdout] test timecard::tests::rejects_bad_none_end_entry_order ... ok
[INFO] [stdout] test timecard::tests::rejects_bad_order ... ok
[INFO] [stdout] test timecard::tests::rejects_overlapping_entries_out_of_order ... ok
[INFO] [stdout] test timecard::tests::reports_clocked_in_with_closed_and_open_entries ... ok
[INFO] [stdout] test timecard::tests::reports_clocked_in_with_open_entry ... ok
[INFO] [stdout] test timecard::tests::rejects_overlapping_entries_contained ... ok
[INFO] [stdout] test timecard::tests::reports_clocked_out_when_empty ... ok
[INFO] [stdout] test timecard::tests::reports_clocked_out_with_closed_entries ... ok
[INFO] [stderr]    Doc-tests timecard
[INFO] [stdout] test timecard::tests::undo_removes_open_entry_with_prior_closed ... ok
[INFO] [stdout] test timecard::tests::undo_reopens_last_closed_entry ... ok
[INFO] [stdout] test timecard::tests::undo_errors_when_empty ... ok
[INFO] [stdout] test timecard::tests::undo_reopens_single_closed_entry ... ok
[INFO] [stdout] test timecard::tests::undo_removes_single_open_entry ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 66 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "da466ecd8d6990b8cdfd4131cb5e821ff8254ebe8e34f597dacfb28b4e99980a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "da466ecd8d6990b8cdfd4131cb5e821ff8254ebe8e34f597dacfb28b4e99980a", kill_on_drop: false }`
[INFO] [stdout] da466ecd8d6990b8cdfd4131cb5e821ff8254ebe8e34f597dacfb28b4e99980a
