[INFO] cloning repository https://github.com/tinyironlabs/tractors
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/tinyironlabs/tractors" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Ftinyironlabs%2Ftractors", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Ftinyironlabs%2Ftractors'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 3b2784b35ff64fc860e4dc25e31674257dfc7aa0
[INFO] testing tinyironlabs/tractors against try#8da20828b6ea601dfd8e2448cb50ace88876bd78 for pr-150933
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Ftinyironlabs%2Ftractors" "/workspace/builds/worker-3-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-3-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/tinyironlabs/tractors
[INFO] finished tweaking git repo https://github.com/tinyironlabs/tractors
[INFO] tweaked toml for git repo https://github.com/tinyironlabs/tractors written to /workspace/builds/worker-3-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/tinyironlabs/tractors on toolchain 8da20828b6ea601dfd8e2448cb50ace88876bd78
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+8da20828b6ea601dfd8e2448cb50ace88876bd78" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/tinyironlabs/tractors 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" "+8da20828b6ea601dfd8e2448cb50ace88876bd78" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded time-core v0.1.7
[INFO] [stderr]   Downloaded time v0.3.45
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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:cfa559dde23f44738f9990739aaa3487d8df3af37eb5df0572f7cf76004a604a" "/opt/rustwide/cargo-home/bin/cargo" "+8da20828b6ea601dfd8e2448cb50ace88876bd78" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 9b1a5db53a6f5cb01a8878efe4bf8cfb4f222fb7fcb1a2a9e6c8024c26fdafad
[INFO] running `Command { std: "docker" "start" "-a" "9b1a5db53a6f5cb01a8878efe4bf8cfb4f222fb7fcb1a2a9e6c8024c26fdafad", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "9b1a5db53a6f5cb01a8878efe4bf8cfb4f222fb7fcb1a2a9e6c8024c26fdafad", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9b1a5db53a6f5cb01a8878efe4bf8cfb4f222fb7fcb1a2a9e6c8024c26fdafad", kill_on_drop: false }`
[INFO] [stdout] 9b1a5db53a6f5cb01a8878efe4bf8cfb4f222fb7fcb1a2a9e6c8024c26fdafad
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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:cfa559dde23f44738f9990739aaa3487d8df3af37eb5df0572f7cf76004a604a" "/opt/rustwide/cargo-home/bin/cargo" "+8da20828b6ea601dfd8e2448cb50ace88876bd78" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] a4b339f99bfcbaa8c0134efeb351ab1bbec1050029f05756736bf079103a16fa
[INFO] running `Command { std: "docker" "start" "-a" "a4b339f99bfcbaa8c0134efeb351ab1bbec1050029f05756736bf079103a16fa", kill_on_drop: false }`
[INFO] [stderr]    Compiling deranged v0.5.5
[INFO] [stderr]    Compiling time-core v0.1.7
[INFO] [stderr]    Compiling num_threads v0.1.7
[INFO] [stderr]    Compiling time v0.3.45
[INFO] [stderr]    Compiling tractors v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 2.75s
[INFO] running `Command { std: "docker" "inspect" "a4b339f99bfcbaa8c0134efeb351ab1bbec1050029f05756736bf079103a16fa", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a4b339f99bfcbaa8c0134efeb351ab1bbec1050029f05756736bf079103a16fa", kill_on_drop: false }`
[INFO] [stdout] a4b339f99bfcbaa8c0134efeb351ab1bbec1050029f05756736bf079103a16fa
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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:cfa559dde23f44738f9990739aaa3487d8df3af37eb5df0572f7cf76004a604a" "/opt/rustwide/cargo-home/bin/cargo" "+8da20828b6ea601dfd8e2448cb50ace88876bd78" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 90695bdc18249655e88ead7f1ab645166dc10f4d23f2a1bf380d1ce50ef9bf35
[INFO] running `Command { std: "docker" "start" "-a" "90695bdc18249655e88ead7f1ab645166dc10f4d23f2a1bf380d1ce50ef9bf35", kill_on_drop: false }`
[INFO] [stderr]    Compiling tractors v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.07s
[INFO] running `Command { std: "docker" "inspect" "90695bdc18249655e88ead7f1ab645166dc10f4d23f2a1bf380d1ce50ef9bf35", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "90695bdc18249655e88ead7f1ab645166dc10f4d23f2a1bf380d1ce50ef9bf35", kill_on_drop: false }`
[INFO] [stdout] 90695bdc18249655e88ead7f1ab645166dc10f4d23f2a1bf380d1ce50ef9bf35
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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:cfa559dde23f44738f9990739aaa3487d8df3af37eb5df0572f7cf76004a604a" "/opt/rustwide/cargo-home/bin/cargo" "+8da20828b6ea601dfd8e2448cb50ace88876bd78" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 6e8947679d63a07bb11a6d397fb50c4834ec36a7903bdf20f031a07f6cb3c6b1
[INFO] running `Command { std: "docker" "start" "-a" "6e8947679d63a07bb11a6d397fb50c4834ec36a7903bdf20f031a07f6cb3c6b1", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.01s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/tractors-60f9ea12c11c6661)
[INFO] [stdout] 
[INFO] [stdout] running 61 tests
[INFO] [stdout] test cli::errors::tests::idle_exit_code_is_one ... ok
[INFO] [stdout] test cli::parse::tests::parse_start_accepts_date_time ... ok
[INFO] [stdout] test cli::parse::tests::parse_start_rejects_missing_at_value ... ok
[INFO] [stdout] test cli::parse::tests::parse_start_accepts_at_with_flags ... ok
[INFO] [stdout] test cli::parse::tests::parse_switch_accepts_project_task_note ... ok
[INFO] [stdout] test cli::tests::compute_stop_ms_for_date_uses_local_date_offset ... ok
[INFO] [stdout] test cli::tests::format_bar_combinations ... ok
[INFO] [stdout] test cli::tests::format_bar_hours_use_hhmm ... ok
[INFO] [stdout] test cli::tests::parse_at_accepts_time_and_date_time ... ok
[INFO] [stdout] test cli::tests::parse_at_rejects_bad_values ... ok
[INFO] [stdout] test cli::tests::parse_hhmm_accepts_valid_and_rejects_invalid ... ok
[INFO] [stdout] test cli::tests::split_stop_events_across_midnight ... ok
[INFO] [stdout] test cli::tests::start_at_rejects_future ... ok
[INFO] [stdout] test cli::tests::stop_at_midnight_split_still_applies ... ok
[INFO] [stdout] test cli::tests::stop_at_validation_accepts_past_date_time ... ok
[INFO] [stdout] test cli::tests::stop_at_validation_rejects_future_and_before_start ... ok
[INFO] [stdout] test config::core::tests::durability_parsing_defaults_to_flush ... ok
[INFO] [stdout] test config::core::tests::filter_logic_matches_parent_and_child_paths ... ok
[INFO] [stdout] test config::core::tests::longest_prefix_match_prefers_most_specific_parent ... ok
[INFO] [stdout] test config::core::tests::parse_config_with_multiple_dirs ... ok
[INFO] [stdout] test config::core::tests::update_dir_entry_merges_keys ... ok
[INFO] [stdout] test events::rotate::tests::event_log_path_uses_local_date ... ok
[INFO] [stdout] test events::rotate::tests::split_session_across_midnight ... ok
[INFO] [stdout] test events::core::tests::event_roundtrip_with_metadata ... ok
[INFO] [stdout] test report::core::tests::active_session_without_stop_counts_up_to_now ... ok
[INFO] [stdout] test config::core::tests::render_is_stable ... ok
[INFO] [stdout] test report::core::tests::csv_escape_handles_quotes_commas_and_newlines ... ok
[INFO] [stdout] test report::core::tests::export_csv_sessions_includes_running_session ... ok
[INFO] [stdout] test report::core::tests::export_csv_split_columns_outputs_empty_fields ... ok
[INFO] [stdout] test report::core::tests::groups_and_sorts_breakdown ... ok
[INFO] [stdout] test cli::tests::start_at_writes_to_correct_day_log ... ok
[INFO] [stdout] test report::core::tests::export_csv_split_columns_escapes_values ... ok
[INFO] [stdout] test report::core::tests::malformed_lines_are_ignored ... ok
[INFO] [stdout] test report::core::tests::export_csv_sessions_outputs_header_when_empty ... ok
[INFO] [stdout] test report::core::tests::export_csv_range_outputs_header_when_empty ... ok
[INFO] [stdout] test report::core::tests::month_bounds_rollover ... ok
[INFO] [stdout] test report::core::tests::export_csv_accumulates_across_days ... ok
[INFO] [stdout] test report::core::tests::parse_date_range_accepts_valid_and_rejects_invalid ... ok
[INFO] [stdout] test report::core::tests::parses_year_month ... ok
[INFO] [stdout] test report::core::tests::export_csv_range_includes_session_starting_before_range ... ok
[INFO] [stdout] test report::core::tests::running_session_included_up_to_now ... ok
[INFO] [stdout] test report::core::tests::start_before_today_stop_today_is_clamped ... ok
[INFO] [stdout] test report::core::tests::totals_for_complete_sessions ... ok
[INFO] [stdout] test report::core::tests::week_bounds_from_now_uses_iso_week_start ... ok
[INFO] [stdout] test report::core::tests::export_csv_sessions_clamps_spanning_midnight ... ok
[INFO] [stdout] test state::core::tests::state_roundtrip ... ok
[INFO] [stdout] test cli::tests::doctor_reports_stale_state ... ok
[INFO] [stdout] test report::core::tests::range_accumulates_across_days ... ok
[INFO] [stdout] test report::core::tests::running_session_is_clamped_to_range_end ... ok
[INFO] [stdout] test state::core::tests::corrupt_state_falls_back_to_logs ... ok
[INFO] [stdout] test state::core::tests::reconstructs_active_from_fake_logs ... ok
[INFO] [stdout] test report::core::tests::export_csv_includes_running_session_clamped_to_range ... ok
[INFO] [stdout] test report::core::tests::report_week_accumulates_across_days ... ok
[INFO] [stdout] test report::core::tests::report_today_ignores_stale_state_for_running ... ok
[INFO] [stdout] test state::core::tests::validate_sid_active_checks_start_stop_order ... ok
[INFO] [stdout] test state::core::tests::stale_state_is_cleared_when_stop_exists ... ok
[INFO] [stdout] test state::core::tests::valid_running_state_is_kept ... ok
[INFO] [stdout] test cli::tests::start_rejects_when_already_running ... ok
[INFO] [stdout] test cli::tests::switch_when_idle_starts_session ... ok
[INFO] [stdout] test cli::tests::switch_when_running_stops_and_starts ... ok
[INFO] [stdout] test cli::tests::where_output_includes_resolved_paths ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 61 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/tractors-68ba93c1b8609d2b)
[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] [stderr]    Doc-tests tractors
[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" "6e8947679d63a07bb11a6d397fb50c4834ec36a7903bdf20f031a07f6cb3c6b1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6e8947679d63a07bb11a6d397fb50c4834ec36a7903bdf20f031a07f6cb3c6b1", kill_on_drop: false }`
[INFO] [stdout] 6e8947679d63a07bb11a6d397fb50c4834ec36a7903bdf20f031a07f6cb3c6b1