[INFO] fetching crate timberjack 0.1.0-beta.1... [INFO] testing timberjack-0.1.0-beta.1 against try#b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b for pr-145330-1 [INFO] extracting crate timberjack 0.1.0-beta.1 into /workspace/builds/worker-6-tc2/source [INFO] started tweaking crates.io crate timberjack 0.1.0-beta.1 [INFO] removed 0 missing tests [INFO] finished tweaking crates.io crate timberjack 0.1.0-beta.1 [INFO] tweaked toml for crates.io crate timberjack 0.1.0-beta.1 written to /workspace/builds/worker-6-tc2/source/Cargo.toml [INFO] validating manifest of crates.io crate timberjack 0.1.0-beta.1 on toolchain b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] crate crates.io crate timberjack 0.1.0-beta.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" "+b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 2b27ad4e0ea7acbc14bb1ac70f98f84be0dcae890f7565137e6f4ed08cda510e [INFO] running `Command { std: "docker" "start" "-a" "2b27ad4e0ea7acbc14bb1ac70f98f84be0dcae890f7565137e6f4ed08cda510e", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "2b27ad4e0ea7acbc14bb1ac70f98f84be0dcae890f7565137e6f4ed08cda510e", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "2b27ad4e0ea7acbc14bb1ac70f98f84be0dcae890f7565137e6f4ed08cda510e", kill_on_drop: false }` [INFO] [stdout] 2b27ad4e0ea7acbc14bb1ac70f98f84be0dcae890f7565137e6f4ed08cda510e [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 1dac7f61df41428026961439e50a50bee4ed0daf1807068169dc222d4fadc913 [INFO] running `Command { std: "docker" "start" "-a" "1dac7f61df41428026961439e50a50bee4ed0daf1807068169dc222d4fadc913", kill_on_drop: false }` [INFO] [stderr] Compiling libc v0.2.171 [INFO] [stderr] Compiling syn v2.0.100 [INFO] [stderr] Compiling clap_builder v4.5.34 [INFO] [stderr] Compiling rayon v1.10.0 [INFO] [stderr] Compiling memmap2 v0.9.5 [INFO] [stderr] Compiling serde_derive v1.0.219 [INFO] [stderr] Compiling clap_derive v4.5.32 [INFO] [stderr] Compiling clap v4.5.34 [INFO] [stderr] Compiling serde v1.0.219 [INFO] [stderr] Compiling serde_json v1.0.140 [INFO] [stderr] Compiling timberjack v0.1.0-beta.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 14.08s [INFO] running `Command { std: "docker" "inspect" "1dac7f61df41428026961439e50a50bee4ed0daf1807068169dc222d4fadc913", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "1dac7f61df41428026961439e50a50bee4ed0daf1807068169dc222d4fadc913", kill_on_drop: false }` [INFO] [stdout] 1dac7f61df41428026961439e50a50bee4ed0daf1807068169dc222d4fadc913 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] de793eedd462937fc02cb2bb913512c049b6f79b8322fe60d43d3e55f7a35494 [INFO] running `Command { std: "docker" "start" "-a" "de793eedd462937fc02cb2bb913512c049b6f79b8322fe60d43d3e55f7a35494", kill_on_drop: false }` [INFO] [stderr] Compiling either v1.15.0 [INFO] [stderr] Compiling regex-automata v0.4.9 [INFO] [stderr] Compiling half v2.5.0 [INFO] [stderr] Compiling doc-comment v0.3.3 [INFO] [stderr] Compiling getrandom v0.3.2 [INFO] [stderr] Compiling predicates-core v1.0.9 [INFO] [stderr] Compiling ciborium-io v0.2.2 [INFO] [stderr] Compiling rustix v1.0.3 [INFO] [stderr] Compiling plotters-backend v0.3.7 [INFO] [stderr] Compiling difflib v0.4.0 [INFO] [stderr] Compiling assert_cmd v2.0.16 [INFO] [stderr] Compiling float-cmp v0.10.0 [INFO] [stderr] Compiling serde v1.0.219 [INFO] [stderr] Compiling termtree v0.5.1 [INFO] [stderr] Compiling linux-raw-sys v0.9.3 [INFO] [stderr] Compiling normalize-line-endings v0.3.0 [INFO] [stderr] Compiling ciborium-ll v0.2.2 [INFO] [stderr] Compiling cast v0.3.0 [INFO] [stderr] Compiling is-terminal v0.4.16 [INFO] [stderr] Compiling wait-timeout v0.2.1 [INFO] [stderr] Compiling anes v0.1.6 [INFO] [stderr] Compiling oorandom v11.1.5 [INFO] [stderr] Compiling plotters-svg v0.3.7 [INFO] [stderr] Compiling rayon v1.10.0 [INFO] [stderr] Compiling itertools v0.10.5 [INFO] [stderr] Compiling predicates-tree v1.0.12 [INFO] [stderr] Compiling plotters v0.3.7 [INFO] [stderr] Compiling criterion-plot v0.5.0 [INFO] [stderr] Compiling tempfile v3.19.1 [INFO] [stderr] Compiling regex v1.11.1 [INFO] [stderr] Compiling bstr v1.11.3 [INFO] [stderr] Compiling serde_json v1.0.140 [INFO] [stderr] Compiling ciborium v0.2.2 [INFO] [stderr] Compiling predicates v3.1.3 [INFO] [stderr] Compiling tinytemplate v1.2.1 [INFO] [stderr] Compiling timberjack v0.1.0-beta.1 (/opt/rustwide/workdir) [INFO] [stderr] Compiling criterion v0.5.1 [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 23.66s [INFO] running `Command { std: "docker" "inspect" "de793eedd462937fc02cb2bb913512c049b6f79b8322fe60d43d3e55f7a35494", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "de793eedd462937fc02cb2bb913512c049b6f79b8322fe60d43d3e55f7a35494", kill_on_drop: false }` [INFO] [stdout] de793eedd462937fc02cb2bb913512c049b6f79b8322fe60d43d3e55f7a35494 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 146a5ba7d37a74afa7a3eadd953df903c75fdabba4a979912712cb8d85b8dcf9 [INFO] running `Command { std: "docker" "start" "-a" "146a5ba7d37a74afa7a3eadd953df903c75fdabba4a979912712cb8d85b8dcf9", 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/timberjack-ee2afe52e3a9984f) [INFO] [stdout] [INFO] [stdout] running 6 tests [INFO] [stdout] test accelerated::tests::test_line_processing ... ok [INFO] [stdout] test accelerated::tests::test_simd_literal_matcher_basic ... ok [INFO] [stdout] test parser::json::tests::test_nested_json ... ok [INFO] [stdout] test parser::json::tests::test_json_detection ... ok [INFO] [stdout] test parser::json::tests::test_json_parsing ... ok [INFO] [stdout] test accelerated::tests::test_factory_creates_appropriate_matchers ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stderr] Running unittests src/bin/create_benchmark_logs.rs (/opt/rustwide/target/debug/deps/create_benchmark_logs-93fbcd862d59728d) [INFO] [stderr] Running unittests src/main.rs (/opt/rustwide/target/debug/deps/timber-0c8cf457a28785d9) [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] [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] Running tests/analyzer_tests.rs (/opt/rustwide/target/debug/deps/analyzer_tests-1e35c4974b15bc78) [INFO] [stdout] [INFO] [stdout] running 9 tests [INFO] [stdout] test test_extract_error_type ... ok [INFO] [stdout] test test_analyze_line_with_pattern ... ok [INFO] [stdout] test test_analyze_mmap_with_level_filter ... ok [INFO] [stdout] test test_combined_filters ... ok [INFO] [stdout] test test_empty_results ... ok [INFO] [stdout] test test_analyze_line_with_level_filter ... ok [INFO] [stdout] test test_analyze_mmap_with_pattern ... ok [INFO] [stdout] test test_stats_collection ... ok [INFO] [stdout] test test_time_trends ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s [INFO] [stdout] [INFO] [stderr] Running tests/cli_tests.rs (/opt/rustwide/target/debug/deps/cli_tests-cb6273e4a37086c6) [INFO] [stdout] [INFO] [stdout] running 10 tests [INFO] [stdout] test test_count_empty_file ... ok [INFO] [stdout] test test_count_total_lines ... ok [INFO] [stdout] test test_level_filtering ... ok [INFO] [stdout] test test_count_with_pattern_and_level ... ok [INFO] [stdout] test test_stats_option ... ok [INFO] [stdout] test test_count_with_level_filter ... ok [INFO] [stdout] test test_trend_option ... ok [INFO] [stdout] test test_combined_options ... ok [INFO] [stdout] test test_count_with_pattern ... ok [INFO] [stdout] test test_basic_chop ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.12s [INFO] [stdout] [INFO] [stderr] Running tests/edge_cases.rs (/opt/rustwide/target/debug/deps/edge_cases-c431535314c9c5b2) [INFO] [stdout] [INFO] [stdout] running 8 tests [INFO] [stdout] test test_non_ascii_characters ... ok [INFO] [stdout] test test_very_large_values ... ok [INFO] [stdout] test test_mixed_log_formats ... ok [INFO] [stdout] test test_empty_file ... ok [INFO] [stdout] test test_very_long_lines ... ok [INFO] [stdout] test test_complex_regex_patterns ... ok [INFO] [stdout] test test_multiple_matches_same_line ... ok [INFO] [stdout] test test_malformed_logs ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.24s [INFO] [stdout] [INFO] [stderr] Running tests/error_tests.rs (/opt/rustwide/target/debug/deps/error_tests-1a2e89c8c0f5a030) [INFO] [stdout] [INFO] [stdout] running 3 tests [INFO] [stdout] test test_empty_file ... ok [INFO] [stdout] test test_nonexistent_file ... ok [INFO] [stdout] test test_malformed_log ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.06s [INFO] [stdout] [INFO] [stderr] Running tests/field_filter_tests.rs (/opt/rustwide/target/debug/deps/field_filter_tests-cfb4b0de9d5e3cd8) [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stdout] test test_json_field_filtering ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.09s [INFO] [stdout] [INFO] [stderr] Running tests/formatter_tests.rs (/opt/rustwide/target/debug/deps/formatter_tests-5c63cadad0e8a223) [INFO] [stdout] [INFO] [stdout] running 6 tests [INFO] [stdout] test test_empty_results ... ok [INFO] [stdout] test test_print_basic_results ... ok [INFO] [stdout] test test_print_trend_results ... ok [INFO] [stdout] test test_print_stats_results ... ok [INFO] [stdout] test test_show_unique_messages ... ok [INFO] [stdout] test test_top_errors_limit ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Running tests/json_cli_tests.rs (/opt/rustwide/target/debug/deps/json_cli_tests-5900317e2c5efe45) [INFO] [stdout] [INFO] [stdout] running 4 tests [INFO] [stdout] test test_cli_json_with_new_options ... ok [INFO] [stdout] test test_cli_json_output ... ok [INFO] [stdout] test test_cli_show_unique_option ... ok [INFO] [stdout] test test_cli_top_errors_option ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.14s [INFO] [stdout] [INFO] [stderr] Running tests/json_output_tests.rs (/opt/rustwide/target/debug/deps/json_output_tests-843dd564d55aed88) [INFO] [stdout] [INFO] [stdout] running 4 tests [INFO] [stdout] test test_json_output_basic ... ok [INFO] [stdout] test test_json_structure ... ok [INFO] [stdout] test test_json_top_errors_limit ... ok [INFO] [stdout] test test_json_unique_messages ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.29s [INFO] [stdout] [INFO] [stderr] Running tests/json_parser_tests.rs (/opt/rustwide/target/debug/deps/json_parser_tests-3fbf39c4a83e2d8e) [INFO] [stdout] [INFO] [stdout] running 3 tests [INFO] [stdout] test tests::test_json_detection ... ok [INFO] [stdout] test tests::test_malformed_json ... ok [INFO] [stdout] test tests::test_json_parsing ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Running tests/parser_tests.rs (/opt/rustwide/target/debug/deps/parser_tests-c02579d575371b37) [INFO] [stdout] [INFO] [stdout] running 2 tests [INFO] [stdout] test tests::test_format_detection ... ok [INFO] [stdout] test tests::test_generic_parser ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s [INFO] [stdout] [INFO] [stderr] Running tests/sample_logs_tests.rs (/opt/rustwide/target/debug/deps/sample_logs_tests-e5b6b3dc8ecd492b) [INFO] [stdout] [INFO] [stdout] running 6 tests [INFO] [stdout] test test_combined_features ... ok [INFO] [stdout] test test_medium_log_level_filtering ... ok [INFO] [stdout] test test_small_log_pattern_search ... ok [INFO] [stdout] test test_small_log_stats ... ok [INFO] [stdout] test test_large_log_error_spike_detection ... ok [INFO] [stdout] test test_large_log_trend_analysis ... ok [INFO] [stderr] Running tests/stdin_tests.rs (/opt/rustwide/target/debug/deps/stdin_tests-f371860d74efd618) [INFO] [stdout] [INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.14s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 9 tests [INFO] [stdout] test test_stdin_empty ... ok [INFO] [stdout] test test_stdin_with_trends ... ok [INFO] [stdout] test test_stdin_combined_options ... ok [INFO] [stdout] test test_stdin_with_count ... ok [INFO] [stdout] test test_stdin_with_stats ... ok [INFO] [stdout] test test_stdin_json_output ... ok [INFO] [stdout] test test_stdin_with_pattern ... ok [INFO] [stdout] test test_stdin_with_level ... ok [INFO] [stdout] test test_stdin_basic ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.17s [INFO] [stdout] [INFO] [stderr] Doc-tests timberjack [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" "146a5ba7d37a74afa7a3eadd953df903c75fdabba4a979912712cb8d85b8dcf9", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "146a5ba7d37a74afa7a3eadd953df903c75fdabba4a979912712cb8d85b8dcf9", kill_on_drop: false }` [INFO] [stdout] 146a5ba7d37a74afa7a3eadd953df903c75fdabba4a979912712cb8d85b8dcf9