[INFO] fetching crate snazy 0.58.1...
[INFO] testing snazy-0.58.1 against master#2fd6efc32704647e64d3d646d21c4c68eae100e4 for pr-149852-1
[INFO] extracting crate snazy 0.58.1 into /workspace/builds/worker-3-tc1/source
[INFO] started tweaking crates.io crate snazy 0.58.1
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate snazy 0.58.1
[INFO] tweaked toml for crates.io crate snazy 0.58.1 written to /workspace/builds/worker-3-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate snazy 0.58.1 on toolchain 2fd6efc32704647e64d3d646d21c4c68eae100e4
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+2fd6efc32704647e64d3d646d21c4c68eae100e4" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate snazy 0.58.1 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" "+2fd6efc32704647e64d3d646d21c4c68eae100e4" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded color-print v0.3.7
[INFO] [stderr]   Downloaded clap_complete v4.5.55
[INFO] [stderr]   Downloaded color-print-proc-macro v0.3.7
[INFO] [stderr]   Downloaded clap v4.5.42
[INFO] [stderr]   Downloaded clap_builder v4.5.42
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+2fd6efc32704647e64d3d646d21c4c68eae100e4" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] a3eefa851ac6bf9d440db3537fa7fd66e5c1f773d0d105062b349bf19c612178
[INFO] running `Command { std: "docker" "start" "-a" "a3eefa851ac6bf9d440db3537fa7fd66e5c1f773d0d105062b349bf19c612178", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "a3eefa851ac6bf9d440db3537fa7fd66e5c1f773d0d105062b349bf19c612178", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a3eefa851ac6bf9d440db3537fa7fd66e5c1f773d0d105062b349bf19c612178", kill_on_drop: false }`
[INFO] [stdout] a3eefa851ac6bf9d440db3537fa7fd66e5c1f773d0d105062b349bf19c612178
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+2fd6efc32704647e64d3d646d21c4c68eae100e4" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 70ed0e77db45b98dd1effe970142ebc247ef1ac6f5a790b9ca19d0caca832768
[INFO] running `Command { std: "docker" "start" "-a" "70ed0e77db45b98dd1effe970142ebc247ef1ac6f5a790b9ca19d0caca832768", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde v1.0.219
[INFO] [stderr]    Compiling getrandom v0.3.3
[INFO] [stderr]    Compiling nom v7.1.3
[INFO] [stderr]    Compiling phf_shared v0.12.1
[INFO] [stderr]    Compiling aho-corasick v1.1.3
[INFO] [stderr]    Compiling serde_json v1.0.142
[INFO] [stderr]    Compiling chrono-tz v0.10.4
[INFO] [stderr]    Compiling clap_builder v4.5.42
[INFO] [stderr]    Compiling is-terminal v0.4.16
[INFO] [stderr]    Compiling serde_derive v1.0.219
[INFO] [stderr]    Compiling clap_derive v4.5.41
[INFO] [stderr]    Compiling chrono v0.4.41
[INFO] [stderr]    Compiling phf v0.12.1
[INFO] [stderr]    Compiling tempfile v3.20.0
[INFO] [stderr]    Compiling regex-automata v0.4.9
[INFO] [stderr]    Compiling color-print-proc-macro v0.3.7
[INFO] [stderr]    Compiling clap v4.5.42
[INFO] [stderr]    Compiling clap_complete v4.5.55
[INFO] [stderr]    Compiling color-print v0.3.7
[INFO] [stderr]    Compiling regex v1.11.1
[INFO] [stderr]    Compiling snazy v0.58.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 21.14s
[INFO] running `Command { std: "docker" "inspect" "70ed0e77db45b98dd1effe970142ebc247ef1ac6f5a790b9ca19d0caca832768", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "70ed0e77db45b98dd1effe970142ebc247ef1ac6f5a790b9ca19d0caca832768", kill_on_drop: false }`
[INFO] [stdout] 70ed0e77db45b98dd1effe970142ebc247ef1ac6f5a790b9ca19d0caca832768
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+2fd6efc32704647e64d3d646d21c4c68eae100e4" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 9cbbfef8492e3f5d146ec546946bb0da682ecdedfa34636d0aa1441252677713
[INFO] running `Command { std: "docker" "start" "-a" "9cbbfef8492e3f5d146ec546946bb0da682ecdedfa34636d0aa1441252677713", kill_on_drop: false }`
[INFO] [stderr]    Compiling snazy v0.58.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.66s
[INFO] running `Command { std: "docker" "inspect" "9cbbfef8492e3f5d146ec546946bb0da682ecdedfa34636d0aa1441252677713", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9cbbfef8492e3f5d146ec546946bb0da682ecdedfa34636d0aa1441252677713", kill_on_drop: false }`
[INFO] [stdout] 9cbbfef8492e3f5d146ec546946bb0da682ecdedfa34636d0aa1441252677713
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+2fd6efc32704647e64d3d646d21c4c68eae100e4" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 4ee58d6a248391bee7702f96a3dc280df76298cf2d5406ab0549f9a21ebfba55
[INFO] running `Command { std: "docker" "start" "-a" "4ee58d6a248391bee7702f96a3dc280df76298cf2d5406ab0549f9a21ebfba55", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.11s
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/snazy-5f14f44397d4de00)
[INFO] [stdout] 
[INFO] [stdout] running 29 tests
[INFO] [stdout] test parse::tests::test_format_stack_line_coloring_toggle ... ok
[INFO] [stdout] test parse::tests::test_kubectl_events_object_type_coloring ... ok
[INFO] [stdout] test parse::tests::test_kubectl_events_parsing_and_formatting ... ok
[INFO] [stdout] test parse_test::tests::test_apply_regexps ... ok
[INFO] [stdout] test parse_test::tests::test_get_line ... ok
[INFO] [stdout] test parse_test::tests::test_custom_json_match ... ok
[INFO] [stdout] test parse::tests::test_extract_info_knative ... ok
[INFO] [stdout] test parse::tests::test_extract_info_pac ... ok
[INFO] [stdout] test parse_test::tests::test_config_json_keys ... ok
[INFO] [stdout] test parse_test::tests::test_read_from_empty_file ... 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 parse::tests::test_kail_prefix_coloring_toggle ... ok
[INFO] [stdout] test utils::tests::test_level_symbols ... ok
[INFO] [stdout] test utils::tests::test_providers ... ok
[INFO] [stdout] test parse_test::tests::test_read_from_missing_file ... ok
[INFO] [stdout] test parse::tests::test_do_line_level_symbols ... ok
[INFO] [stdout] test parse_test::tests::test_hide_stacktrace ... ok
[INFO] [stdout] test parse_test::tests::test_skip_lines ... ok
[INFO] [stdout] test parse_test::tests::test_config_json_timestamp_float ... ok
[INFO] [stdout] test utils::tests::test_convert_ts_float_or_str_non_float ... ok
[INFO] [stdout] test parse_test::tests::test_read_from_malformed_json ... ok
[INFO] [stdout] test utils::tests::test_convert_ts_float_or_str ... ok
[INFO] [stdout] test parse_test::tests::test_action_on_regexp ... ok
[INFO] [stdout] test parse_test::tests::test_kail_newline ... ok
[INFO] [stdout] test parse_test::tests::test_kail_prefix ... ok
[INFO] [stdout] test parse_test::tests::test_read_from_file ... ok
[INFO] [stdout] test parse_test::tests::test_pac_provider_icon ... ok
[INFO] [stdout] test parse_test::tests::test_kail_no_prefix ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 29 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.06s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/tests.rs (/opt/rustwide/target/debug/deps/tests-bea818fefa9bb310)
[INFO] [stdout] 
[INFO] [stdout] running 35 tests
[INFO] [stdout] test custom_level_debug ... ok
[INFO] [stdout] test filter_level_info ... ok
[INFO] [stdout] test include_fields_subset ... ok
[INFO] [stdout] test include_fields_kail_basic ... ok
[INFO] [stdout] test multiple_regexp_raw_json ... ok
[INFO] [stdout] test filter_level_warning ... ok
[INFO] [stdout] test kail_log_and_regexp ... ok
[INFO] [stdout] test include_fields_kail_nested_fields ... ok
[INFO] [stdout] test include_fields_kail_no_prefix ... ok
[INFO] [stdout] test include_fields_kail_all_fields ... ok
[INFO] [stdout] test extra_fields_all ... ok
[INFO] [stdout] test custom_level_info ... ok
[INFO] [stdout] test include_fields_kail_with_colors ... ok
[INFO] [stdout] test floated_date ... ok
[INFO] [stdout] test include_fields_kail_missing_fields ... ok
[INFO] [stdout] test kail_custom_format ... ok
[INFO] [stdout] test pac_output_bitbucket_server ... ok
[INFO] [stdout] test regexp_raw_json ... ok
[INFO] [stdout] test regexp_color_fg_bg ... ok
[INFO] [stdout] test level_symbols ... ok
[INFO] [stdout] test pac_output_gitlab ... ok
[INFO] [stdout] test pac_output_bitbucket_cloud ... ok
[INFO] [stdout] test pac_output_github ... ok
[INFO] [stdout] test simple_date ... ok
[INFO] [stdout] test all_json_keys_need_tobe_specified - should panic ... ok
[INFO] [stdout] test show_help ... ok
[INFO] [stdout] test stacktrace_hidden ... ok
[INFO] [stdout] test regexp_rgb_colored ... ok
[INFO] [stdout] test stacktrace_default_display ... ok
[INFO] [stdout] test timezone_parsing ... ok
[INFO] [stdout] test skip_lines ... ok
[INFO] [stdout] test kail_no_prefix ... ok
[INFO] [stdout] test raw_non_json ... ok
[INFO] [stdout] test simple_parsing ... ok
[INFO] [stdout] test pac_output_fallback_ts ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 35 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.20s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "4ee58d6a248391bee7702f96a3dc280df76298cf2d5406ab0549f9a21ebfba55", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4ee58d6a248391bee7702f96a3dc280df76298cf2d5406ab0549f9a21ebfba55", kill_on_drop: false }`
[INFO] [stdout] 4ee58d6a248391bee7702f96a3dc280df76298cf2d5406ab0549f9a21ebfba55