[INFO] fetching crate snazy 0.59.0...
[INFO] testing snazy-0.59.0 against 1.100.0-beta.1 for beta-1.100-2
[INFO] extracting crate snazy 0.59.0 into /workspace/builds/worker-4-tc2/source
[INFO] started tweaking crates.io crate snazy 0.59.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate snazy 0.59.0
[INFO] tweaked toml for crates.io crate snazy 0.59.0 written to /workspace/builds/worker-4-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate snazy 0.59.0 on toolchain 1.100.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate snazy 0.59.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" "+1.100.0-beta.1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,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" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:3111399a4047eeb3a02b7a90e478d715f38a8c6669b5c4b49d30a17385265909" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 62815b1b9fd39113fa780264854751694b3c875769d3033a135626d848535fce
[INFO] running `Command { std: "docker" "start" "62815b1b9fd39113fa780264854751694b3c875769d3033a135626d848535fce", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "62815b1b9fd39113fa780264854751694b3c875769d3033a135626d848535fce", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-w" "/opt/rustwide/workdir" "--user" "0:0" "62815b1b9fd39113fa780264854751694b3c875769d3033a135626d848535fce" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "62815b1b9fd39113fa780264854751694b3c875769d3033a135626d848535fce", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-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" "-w" "/opt/rustwide/workdir" "--user" "0:0" "62815b1b9fd39113fa780264854751694b3c875769d3033a135626d848535fce" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.184
[INFO] [stderr]    Compiling minimal-lexical v0.2.1
[INFO] [stderr]    Compiling siphasher v1.0.2
[INFO] [stderr]    Compiling clap_builder v4.6.0
[INFO] [stderr]    Compiling clap_derive v4.6.0
[INFO] [stderr]    Compiling chrono-tz v0.10.4
[INFO] [stderr]    Compiling bitflags v2.11.0
[INFO] [stderr]    Compiling chrono v0.4.44
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling phf_shared v0.12.1
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling nom v7.1.3
[INFO] [stderr]    Compiling phf v0.12.1
[INFO] [stderr]    Compiling yansi v1.0.1
[INFO] [stderr]    Compiling getrandom v0.4.2
[INFO] [stderr]    Compiling is-terminal v0.4.17
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling color-print-proc-macro v0.3.7
[INFO] [stderr]    Compiling clap v4.6.0
[INFO] [stderr]    Compiling clap_complete v4.6.0
[INFO] [stderr]    Compiling color-print v0.3.7
[INFO] [stderr]    Compiling snazy v0.59.0 (/opt/rustwide/workdir)
[INFO] [stderr] warning: unused dependency `is-terminal`
[INFO] [stderr]   --> Cargo.toml:26:15
[INFO] [stderr]    |
[INFO] [stderr] 26 | [dependencies.is-terminal]
[INFO] [stderr]    |               ^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::unused_dependencies` is set to `warn` by default
[INFO] [stderr] help: consider removing the dependency on `is-terminal`
[INFO] [stderr] warning: unused dependency `tempfile`
[INFO] [stderr]   --> Cargo.toml:39:15
[INFO] [stderr]    |
[INFO] [stderr] 39 | [dependencies.tempfile]
[INFO] [stderr]    |               ^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr] help: consider removing the dependency on `tempfile`
[INFO] [stderr] warning: `snazy` (manifest) generated 2 warnings
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 27.05s
[INFO] running `Command { std: "docker" "inspect" "62815b1b9fd39113fa780264854751694b3c875769d3033a135626d848535fce", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-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" "-w" "/opt/rustwide/workdir" "--user" "0:0" "62815b1b9fd39113fa780264854751694b3c875769d3033a135626d848535fce" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling snazy v0.59.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 2.65s
[INFO] running `Command { std: "docker" "inspect" "62815b1b9fd39113fa780264854751694b3c875769d3033a135626d848535fce", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-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" "-w" "/opt/rustwide/workdir" "--user" "0:0" "62815b1b9fd39113fa780264854751694b3c875769d3033a135626d848535fce" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.12s
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/build/snazy/fe52a9a2c587a969/out/snazy-fe52a9a2c587a969)
[INFO] [stdout] 
[INFO] [stdout] running 40 tests
[INFO] [stdout] test input::tests::duplicate_collapser_flushes_before_non_collapsible_output ... ok
[INFO] [stdout] test input::tests::duplicate_collapser_summarizes_duplicates_within_window ... ok
[INFO] [stdout] test input::tests::duplicate_collapser_flushes_single_lines_unchanged ... ok
[INFO] [stdout] test input::tests::duplicate_collapser_starts_new_burst_after_window_expires ... ok
[INFO] [stdout] test input::tests::read_a_file_handles_missing_and_empty_files ... ok
[INFO] [stdout] test parser::tests::kubectl_events_are_detected ... ok
[INFO] [stdout] test parser::tests::applies_kail_prefix_template ... ok
[INFO] [stdout] test parser::tests::normalizes_cloud_logging_critical_to_error ... ok
[INFO] [stdout] test parser::tests::does_not_treat_generic_request_logs_as_caddy ... ok
[INFO] [stdout] test parser::tests::parses_caddy_access_logs ... ok
[INFO] [stdout] test parser::tests::parses_custom_json_keys ... ok
[INFO] [stdout] test input::tests::process_reader_flushes_each_rendered_line_for_stdin ... ok
[INFO] [stdout] test parser::tests::parses_cloud_logging_logs ... ok
[INFO] [stdout] test input::tests::read_a_file_formats_logs ... ok
[INFO] [stdout] test input::tests::stacktrace_output_can_be_hidden ... ok
[INFO] [stdout] test parser::tests::parses_pac_logs ... ok
[INFO] [stdout] test parser::tests::parses_custom_json_float_timestamp ... ok
[INFO] [stdout] test parser::tests::parses_ecs_logs ... ok
[INFO] [stdout] test parser::tests::parses_logrus_logs ... ok
[INFO] [stdout] test parser::tests::parses_zerolog_logs ... ok
[INFO] [stdout] test parser::tests::parses_knative_logs ... ok
[INFO] [stdout] test pipeline::tests::include_fields_support_nested_paths ... ok
[INFO] [stdout] test render::tests::colorize_object_type_assigns_color_codes ... ok
[INFO] [stdout] test render::tests::format_stack_line_respects_coloring_toggle ... ok
[INFO] [stdout] test parser::tests::skips_missing_custom_json_keys ... ok
[INFO] [stdout] test render::tests::render_structured_log_appends_extra_fields ... ok
[INFO] [stdout] test render::tests::render_parsed_line_resets_time_delta_after_unparsable_timestamp ... ok
[INFO] [stdout] test utils::tests::test_apply_regexps ... ok
[INFO] [stdout] test pipeline::tests::extra_fields_skip_consumed_top_level_fields ... ok
[INFO] [stdout] test utils::tests::test_apply_regexps_invalid_regex ... ok
[INFO] [stdout] test utils::tests::test_convert_ts_float_or_str_with_timezone ... ok
[INFO] [stdout] test utils::tests::test_convert_ts_float_or_str ... ok
[INFO] [stdout] test utils::tests::test_convert_ts_float_or_str_keeps_subseconds ... ok
[INFO] [stdout] test pipeline::tests::extra_fields_skip_consumed_nested_objects ... ok
[INFO] [stdout] test utils::tests::test_format_time_delta_compact_units ... ok
[INFO] [stdout] test utils::tests::test_level_symbols ... ok
[INFO] [stdout] test utils::tests::test_providers ... ok
[INFO] [stdout] test utils::tests::test_convert_ts_float_or_str_non_float ... ok
[INFO] [stdout] test render::tests::render_structured_log_renders_delta_slot ... ok
[INFO] [stdout] test pipeline::tests::action_command_is_triggered ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 40 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.08s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/tests.rs (/opt/rustwide/target/debug/build/snazy/824f84e7d4d200fe/out/tests-824f84e7d4d200fe)
[INFO] [stdout] 
[INFO] [stdout] running 53 tests
[INFO] [stdout] test custom_level_debug ... ok
[INFO] [stdout] test cloud_logging_critical_matches_error_filter ... ok
[INFO] [stdout] test caddy_access_log_post ... ok
[INFO] [stdout] test cloud_logging_autodetect ... ok
[INFO] [stdout] test custom_level_info ... ok
[INFO] [stdout] test caddy_general_log ... ok
[INFO] [stdout] test caddy_does_not_override_generic_request_logs ... ok
[INFO] [stdout] test duplicate_raw_logs_collapse_into_summary ... ok
[INFO] [stdout] test duplicate_collapse_keeps_time_delta_based_on_hidden_duplicates ... ok
[INFO] [stdout] test floated_date ... ok
[INFO] [stdout] test filter_level_warning ... ok
[INFO] [stdout] test all_json_keys_need_tobe_specified - should panic ... ok
[INFO] [stdout] test include_fields_kail_all_fields ... ok
[INFO] [stdout] test include_fields_kail_missing_fields ... ok
[INFO] [stdout] test include_fields_kail_basic ... ok
[INFO] [stdout] test extra_fields_all ... ok
[INFO] [stdout] test duplicate_structured_logs_collapse_into_summary ... ok
[INFO] [stdout] test include_fields_kail_nested_fields ... ok
[INFO] [stdout] test filter_level_info ... ok
[INFO] [stdout] test include_fields_kail_no_prefix ... ok
[INFO] [stdout] test kail_custom_format ... ok
[INFO] [stdout] test kail_log_and_regexp ... ok
[INFO] [stdout] test include_fields_subset ... ok
[INFO] [stdout] test include_fields_kail_with_colors ... ok
[INFO] [stdout] test logrus_autodetect ... ok
[INFO] [stdout] test level_symbols ... ok
[INFO] [stdout] test kail_no_prefix ... ok
[INFO] [stdout] test pac_output_bitbucket_server ... ok
[INFO] [stdout] test pac_output_bitbucket_cloud ... ok
[INFO] [stdout] test pac_output_fallback_ts ... ok
[INFO] [stdout] test pac_output_gitlab ... ok
[INFO] [stdout] test pac_output_github ... ok
[INFO] [stdout] test regexp_raw_json ... ok
[INFO] [stdout] test regexp_rgb_colored ... ok
[INFO] [stdout] test multiple_regexp_raw_json ... ok
[INFO] [stdout] test show_help ... ok
[INFO] [stdout] test caddy_access_log_basic ... ok
[INFO] [stdout] test logrus_extra_fields_skip_consumed_time ... ok
[INFO] [stdout] test simple_date ... ok
[INFO] [stdout] test simple_parsing ... ok
[INFO] [stdout] test skip_lines ... ok
[INFO] [stdout] test stacktrace_hidden ... ok
[INFO] [stdout] test ecs_autodetect ... ok
[INFO] [stdout] test raw_non_json ... ok
[INFO] [stdout] test regexp_color_fg_bg ... ok
[INFO] [stdout] test time_delta_between_timestamped_logs ... ok
[INFO] [stdout] test time_delta_ignores_raw_and_missing_timestamps ... ok
[INFO] [stdout] test time_delta_resets_after_unparsable_timestamp ... ok
[INFO] [stdout] test zerolog_autodetect ... ok
[INFO] [stdout] test timezone_parsing ... ok
[INFO] [stdout] test zerolog_extra_fields_skip_consumed_stack ... ok
[INFO] [stdout] test stacktrace_default_display ... ok
[INFO] [stdout] test time_delta_disabled_keeps_existing_output ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 53 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.35s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "62815b1b9fd39113fa780264854751694b3c875769d3033a135626d848535fce", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "62815b1b9fd39113fa780264854751694b3c875769d3033a135626d848535fce", kill_on_drop: false }`
[INFO] [stdout] 62815b1b9fd39113fa780264854751694b3c875769d3033a135626d848535fce
