[INFO] fetching crate logfusion 0.1.0... [INFO] testing logfusion-0.1.0 against master#cdb45c87e2cd43495379f7e867e3cc15dcee9f93 for pr-145838-1 [INFO] extracting crate logfusion 0.1.0 into /workspace/builds/worker-6-tc1/source [INFO] removed /workspace/builds/worker-6-tc1/source/rust-toolchain.toml [INFO] started tweaking crates.io crate logfusion 0.1.0 [INFO] removed 0 missing examples [INFO] removed 0 missing tests [INFO] finished tweaking crates.io crate logfusion 0.1.0 [INFO] tweaked toml for crates.io crate logfusion 0.1.0 written to /workspace/builds/worker-6-tc1/source/Cargo.toml [INFO] validating manifest of crates.io crate logfusion 0.1.0 on toolchain cdb45c87e2cd43495379f7e867e3cc15dcee9f93 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] crate crates.io crate logfusion 0.1.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" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Updating crates.io index [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded clap v4.5.43 [INFO] [stderr] Downloaded rusttoolkit v0.1.0 [INFO] [stderr] Downloaded clap_builder v4.5.43 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 5f9ae9aa3b1c41cb4f25308140a10b576a1a9afaf518740d2ee67f81270c0f6c [INFO] running `Command { std: "docker" "start" "-a" "5f9ae9aa3b1c41cb4f25308140a10b576a1a9afaf518740d2ee67f81270c0f6c", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "5f9ae9aa3b1c41cb4f25308140a10b576a1a9afaf518740d2ee67f81270c0f6c", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "5f9ae9aa3b1c41cb4f25308140a10b576a1a9afaf518740d2ee67f81270c0f6c", kill_on_drop: false }` [INFO] [stdout] 5f9ae9aa3b1c41cb4f25308140a10b576a1a9afaf518740d2ee67f81270c0f6c [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 76252666f47397b0d54827491671e0a583b12ed160ad852b98500415ca773c31 [INFO] running `Command { std: "docker" "start" "-a" "76252666f47397b0d54827491671e0a583b12ed160ad852b98500415ca773c31", kill_on_drop: false }` [INFO] [stderr] Compiling serde_json v1.0.142 [INFO] [stderr] Compiling regex-syntax v0.8.5 [INFO] [stderr] Compiling tracing-core v0.1.34 [INFO] [stderr] Compiling regex-automata v0.1.10 [INFO] [stderr] Compiling thread_local v1.1.9 [INFO] [stderr] Compiling rusttoolkit v0.1.0 [INFO] [stderr] Compiling matchers v0.1.0 [INFO] [stderr] Compiling tracing-log v0.2.0 [INFO] [stderr] Compiling tracing v0.1.41 [INFO] [stderr] Compiling tracing-serde v0.2.0 [INFO] [stderr] Compiling regex-automata v0.4.9 [INFO] [stderr] Compiling regex v1.11.1 [INFO] [stderr] Compiling tracing-subscriber v0.3.19 [INFO] [stderr] Compiling logfusion v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 9.36s [INFO] running `Command { std: "docker" "inspect" "76252666f47397b0d54827491671e0a583b12ed160ad852b98500415ca773c31", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "76252666f47397b0d54827491671e0a583b12ed160ad852b98500415ca773c31", kill_on_drop: false }` [INFO] [stdout] 76252666f47397b0d54827491671e0a583b12ed160ad852b98500415ca773c31 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 9c0163840cd86dc31c3838e0b741ef5253bd7a68b666e82d0ab0704d839824d4 [INFO] running `Command { std: "docker" "start" "-a" "9c0163840cd86dc31c3838e0b741ef5253bd7a68b666e82d0ab0704d839824d4", kill_on_drop: false }` [INFO] [stderr] Compiling aho-corasick v1.1.3 [INFO] [stderr] Compiling futures-channel v0.3.31 [INFO] [stderr] Compiling half v2.6.0 [INFO] [stderr] Compiling parking_lot_core v0.9.11 [INFO] [stderr] Compiling clap_builder v4.5.43 [INFO] [stderr] Compiling serde v1.0.219 [INFO] [stderr] Compiling anstyle-query v1.1.4 [INFO] [stderr] Compiling sdd v3.0.10 [INFO] [stderr] Compiling rayon v1.10.0 [INFO] [stderr] Compiling serial_test_derive v3.2.0 [INFO] [stderr] Compiling signal-hook-registry v1.4.6 [INFO] [stderr] Compiling socket2 v0.6.0 [INFO] [stderr] Compiling is-terminal v0.4.16 [INFO] [stderr] Compiling mio v1.0.4 [INFO] [stderr] Compiling jiff v0.2.15 [INFO] [stderr] Compiling anstream v0.6.20 [INFO] [stderr] Compiling parking_lot v0.12.4 [INFO] [stderr] Compiling futures-util v0.3.31 [INFO] [stderr] Compiling ciborium-ll v0.2.2 [INFO] [stderr] Compiling scc v2.3.4 [INFO] [stderr] Compiling regex-automata v0.4.9 [INFO] [stderr] Compiling tokio v1.47.1 [INFO] [stderr] Compiling serde_json v1.0.142 [INFO] [stderr] Compiling tracing-serde v0.2.0 [INFO] [stderr] Compiling ciborium v0.2.2 [INFO] [stderr] Compiling clap v4.5.43 [INFO] [stderr] Compiling futures-executor v0.3.31 [INFO] [stderr] Compiling regex v1.11.1 [INFO] [stderr] Compiling futures v0.3.31 [INFO] [stderr] Compiling serial_test v3.2.0 [INFO] [stderr] Compiling env_filter v0.1.3 [INFO] [stderr] Compiling tinytemplate v1.2.1 [INFO] [stderr] Compiling tracing-subscriber v0.3.19 [INFO] [stderr] Compiling criterion v0.5.1 [INFO] [stderr] Compiling env_logger v0.11.8 [INFO] [stderr] Compiling logfusion v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 29.22s [INFO] running `Command { std: "docker" "inspect" "9c0163840cd86dc31c3838e0b741ef5253bd7a68b666e82d0ab0704d839824d4", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "9c0163840cd86dc31c3838e0b741ef5253bd7a68b666e82d0ab0704d839824d4", kill_on_drop: false }` [INFO] [stdout] 9c0163840cd86dc31c3838e0b741ef5253bd7a68b666e82d0ab0704d839824d4 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 058b5be3d2a907113b1594bb1092b82a2ec442733c2e3710bbfd6b1690976b9e [INFO] running `Command { std: "docker" "start" "-a" "058b5be3d2a907113b1594bb1092b82a2ec442733c2e3710bbfd6b1690976b9e", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.20s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/logfusion-ade2199ac3ba9c42) [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/lib.rs (/opt/rustwide/target/debug/deps/lib-05126ab0057da261) [INFO] [stdout] [INFO] [stdout] running 52 tests [INFO] [stdout] test integration::define_errors_thiserror::basic_error_definition ... ok [INFO] [stdout] 2025-09-01T09:57:42.520228Z ERROR lib::integration::define_errors_logfusion: [SimpleError] A simple error [INFO] [stdout] 2025-09-01T09:57:42.520237Z  INFO lib::integration::auto_initialization: This respects RUST_LOG filter level [INFO] [stdout] 2025-09-01T09:57:42.520585Z ERROR lib::integration::define_errors_logfusion: [AnotherSimple] Another simple one [INFO] [stdout] 2025-09-01T09:57:42.520600Z ERROR lib::integration::define_errors_logfusion: [ComplexError] Complex: test [INFO] [stdout] 2025-09-01T09:57:42.520611Z ERROR lib::integration::define_errors_logfusion: [WithNumber] Number is 42 [INFO] [stdout] 2025-09-01T09:57:42.520625Z ERROR lib::integration::define_errors_logfusion: [NetworkError] Network error occurred [INFO] [stdout] 2025-09-01T09:57:42.520228Z  WARN lib::integration::define_errors_logfusion: [InvalidCard] Invalid card number [INFO] [stdout] 2025-09-01T09:57:42.520697Z ERROR lib::integration::define_errors_logfusion: [InsufficientFunds] Need $100, have $50 [INFO] [stdout] 2025-09-01T09:57:42.520719Z ERROR lib::integration::define_errors_logfusion: [NetworkError] Network error occurred [INFO] [stdout] 2025-09-01T09:57:42.520739Z ERROR lib::integration::define_errors_logfusion: [ProcessingFailed] Transaction txn_123 failed: card declined [INFO] [stdout] 2025-09-01T09:57:42.520259Z  INFO lib::integration::auto_initialization: Thread 2 logging [INFO] [stdout] 2025-09-01T09:57:42.520809Z ERROR lib::integration::auto_initialization: Thread 2 error [INFO] [stdout] test integration::auto_initialization::respects_rust_log_env_variable ... ok [INFO] [stdout] test integration::define_errors_logfusion::mixed_variants ... ok [INFO] [stdout] test integration::define_errors_logfusion::real_world_payment_example ... ok [INFO] [stdout] 2025-09-01T09:57:42.520979Z ERROR app::db: [DatabaseError] Database error [INFO] [stdout] 2025-09-01T09:57:42.520228Z ERROR lib::integration::define_errors_logfusion: [IoError] IO operation failed [INFO] [stdout] 2025-09-01T09:57:42.521042Z ERROR lib::integration::define_errors_logfusion: [MultipleFields] Operation read_file failed after 3 retries [INFO] [stdout] 2025-09-01T09:57:42.521045Z ERROR lib::integration::define_errors_thiserror: [CriticalIo] Critical IO error [INFO] [stdout] 2025-09-01T09:57:42.521042Z ERROR storage::db: [DatabaseIo] Database IO error [INFO] [stdout] 2025-09-01T09:57:42.521062Z  WARN lib::integration::define_errors_thiserror: [WarningIo] IO warning [INFO] [stdout] 2025-09-01T09:57:42.521095Z  WARN network::client: [NetworkIo] Network IO error [INFO] [stdout] test integration::define_errors_logfusion::automatic_source_detection ... ok [INFO] [stdout] 2025-09-01T09:57:42.521109Z  INFO lib::integration::define_errors_thiserror: [InfoIo] IO info [INFO] [stdout] test integration::define_errors_thiserror::source_with_custom_targets ... ok [INFO] [stdout] test integration::define_errors_thiserror::source_with_different_levels ... ok [INFO] [stdout] test integration::error_analytics_integration::test_error_analytics_pipeline ... ok [INFO] [stdout] test integration::error_info_method::test_error_info_for_metrics_and_monitoring ... ok [INFO] [stdout] 2025-09-01T09:57:42.521967Z ERROR lib::integration::define_errors_thiserror: [DefaultError] Default error [INFO] [stdout] 2025-09-01T09:57:42.522007Z ERROR custom::module: [CustomTargetOnly] Custom target only [INFO] [stdout] test integration::define_errors_thiserror::default_behavior_tests ... ok [INFO] [stdout] test integration::error_info_method::test_error_info_logfusion_format ... ok [INFO] [stdout] test integration::error_analytics_integration::test_multi_crate_error_info_consistency ... ok [INFO] [stdout] test integration::error_analytics_integration::test_error_info_serialization ... ok2025-09-01T09:57:42.520283Z  INFO lib::integration::callback_functionality: Callback test message [INFO] [stdout] [INFO] [stdout] 2025-09-01T09:57:42.520290Z ERROR app::database: [DatabaseError] Database error [INFO] [stdout] 2025-09-01T09:57:42.529590Z  WARN app::network: [NetworkError] Network error [INFO] [stdout] 2025-09-01T09:57:42.520310Z  INFO lib::integration::auto_initialization: Thread 0 logging [INFO] [stdout] 2025-09-01T09:57:42.529884Z  INFO app::auth: [AuthError] Authentication failed [INFO] [stdout] 2025-09-01T09:57:42.520307Z ERROR lib::integration::define_errors_thiserror: [ErrorLevel] Error level message [INFO] [stdout] 2025-09-01T09:57:42.529923Z ERROR lib::integration::define_errors_logfusion: [DefaultError] Default target error [INFO] [stdout] 2025-09-01T09:57:42.529954Z  WARN lib::integration::define_errors_thiserror: [WarnLevel] Warn level message [INFO] [stdout] 2025-09-01T09:57:42.529988Z  INFO lib::integration::define_errors_thiserror: [InfoLevel] Info level message [INFO] [stdout] 2025-09-01T09:57:42.520317Z  INFO lib::integration::auto_initialization: Thread 4 logging [INFO] [stdout] 2025-09-01T09:57:42.530078Z ERROR lib::integration::auto_initialization: Thread 4 error [INFO] [stdout] 2025-09-01T09:57:42.520344Z ERROR lib::integration::define_errors_thiserror: [Critical] Critical error [INFO] [stdout] 2025-09-01T09:57:42.520393Z ERROR lib::integration::define_errors_logfusion: [DatabaseConnection] Failed to connect to localhost:5432 [INFO] [stdout] 2025-09-01T09:57:42.530180Z ERROR lib::integration::auto_initialization: Thread 0 error [INFO] [stdout] 2025-09-01T09:57:42.530268Z  WARN lib::integration::define_errors_thiserror: [Warning] Warning condition [INFO] [stdout] 2025-09-01T09:57:42.530287Z  INFO lib::integration::define_errors_thiserror: [Information] Info message [INFO] [stdout] 2025-09-01T09:57:42.520460Z ERROR lib::integration::define_errors_logfusion: [NotFound] Resource not found [INFO] [stdout] 2025-09-01T09:57:42.530364Z ERROR lib::integration::define_errors_logfusion: [InvalidInput] Invalid input provided [INFO] [stdout] 2025-09-01T09:57:42.520488Z  INFO lib::integration::auto_initialization: Thread 1 logging [INFO] [stdout] 2025-09-01T09:57:42.530434Z ERROR lib::integration::auto_initialization: Thread 1 error [INFO] [stdout] 2025-09-01T09:57:42.520548Z ERROR lib::integration::define_errors_thiserror: [IoError] IO operation failed [INFO] [stdout] 2025-09-01T09:57:42.521005Z ERROR app::net: [NetworkError] Network error [INFO] [stdout] 2025-09-01T09:57:42.530626Z ERROR lib::integration::define_errors_logfusion: [ValidationFailed] Validation failed for email: invalid format [INFO] [stdout] 2025-09-01T09:57:42.520262Z  INFO lib::integration::auto_initialization: Auto-initialized info message [INFO] [stdout] 2025-09-01T09:57:42.530708Z ERROR lib::integration::auto_initialization: Auto-initialized error message [INFO] [stdout] 2025-09-01T09:57:42.530725Z  WARN lib::integration::auto_initialization: Auto-initialized warning message [INFO] [stdout] 2025-09-01T09:57:42.520259Z  WARN lib::integration::define_errors_logfusion: [BadRequest] Invalid field: email [INFO] [stdout] 2025-09-01T09:57:42.530871Z ERROR lib::integration::define_errors_logfusion: [Unauthorized] Access denied [INFO] [stdout] 2025-09-01T09:57:42.530905Z ERROR lib::integration::define_errors_logfusion: [ConnectionFailed] Failed to connect to localhost [INFO] [stdout] 2025-09-01T09:57:42.530920Z  WARN lib::integration::define_errors_logfusion: [QueryTimeout] Query timed out [INFO] [stdout] 2025-09-01T09:57:42.520287Z  INFO lib::integration::auto_initialization: Thread 3 logging [INFO] [stdout] 2025-09-01T09:57:42.530993Z ERROR lib::integration::auto_initialization: Thread 3 error [INFO] [stdout] 2025-09-01T09:57:42.529387Z ERROR lib::integration::callback_functionality: Callback error message [INFO] [stdout] test integration::error_info_method::test_error_info_thiserror_format ... 2025-09-01T09:57:42.520311Z ERROR lib::integration::define_errors_logfusion: [ErrorLevel] An error occurred [INFO] [stdout] 2025-09-01T09:57:42.531092Z  WARN lib::integration::define_errors_logfusion: [WarnLevel] A warning occurred [INFO] [stdout] 2025-09-01T09:57:42.531114Z  INFO lib::integration::define_errors_logfusion: [InfoLevel] Info message [INFO] [stdout] ok [INFO] [stdout] test integration::error_info_method::test_error_info_mixed_variants ... ok [INFO] [stdout] test integration::logfusion_structured_logging::logfusion_backwards_compatibility_with_simple_syntax ... ok [INFO] [stdout] test integration::define_errors_logfusion::with_custom_targets ... ok [INFO] [stdout] test integration::define_errors_thiserror::comprehensive_level_coverage ... ok [INFO] [stdout] test integration::define_errors_thiserror::error_with_log_levels ... ok [INFO] [stdout] test integration::define_errors_logfusion::unit_variants_only ... ok [INFO] [stdout] test integration::define_errors_thiserror::error_with_source_chain ... ok [INFO] [stdout] test integration::define_errors_thiserror::error_with_targets ... ok [INFO] [stdout] test integration::define_errors_logfusion::struct_variants_only ... ok [INFO] [stdout] 2025-09-01T09:57:42.531929Z  INFO lib::integration::logging_macros: User alice logged in [INFO] [stdout] test integration::auto_initialization::logging_works_without_explicit_initialization ... ok [INFO] [stdout] 2025-09-01T09:57:42.531966Z  WARN lib::integration::logging_macros: User alice has 42 failed attempts [INFO] [stdout] 2025-09-01T09:57:42.531962Z  INFO app::auth: Authentication successful [INFO] [stdout] 2025-09-01T09:57:42.531988Z ERROR lib::integration::logging_macros: Failed to process request for user: alice [INFO] [stdout] 2025-09-01T09:57:42.531992Z ERROR app::db: Database connection failed [INFO] [stdout] test integration::define_errors_logfusion::multiple_error_types_in_single_macro ... ok [INFO] [stdout] test integration::define_errors_logfusion::with_log_level_attributes ... ok [INFO] [stdout] test integration::logfusion_structured_logging::logfusion_structured_logging_basic ... ok [INFO] [stdout] test integration::auto_initialization::multiple_threads_auto_initialize_safely ... ok [INFO] [stdout] test integration::logfusion_structured_logging::logfusion_structured_logging_all_levels ... ok [INFO] [stdout] 2025-09-01T09:57:42.532179Z ERROR lib::integration::thiserror: [FieldInterpolation] Field interpolation: interpolated_value [INFO] [stdout] 2025-09-01T09:57:42.532314Z  INFO lib::integration::logging_macros: Info message [INFO] [stdout] 2025-09-01T09:57:42.532458Z ERROR lib::integration::tracing: Log crate error [INFO] [stdout] 2025-09-01T09:57:42.532492Z  WARN lib::integration::tracing: Log crate warning [INFO] [stdout] 2025-09-01T09:57:42.532516Z  INFO lib::integration::tracing: Log crate info [INFO] [stdout] 2025-09-01T09:57:42.532699Z  WARN lib::integration::logging_macros: Warning message [INFO] [stdout] 2025-09-01T09:57:42.532718Z ERROR lib::integration::logging_macros: Error message [INFO] [stdout] 2025-09-01T09:57:42.533033Z ERROR lib::integration::tracing: LogFusion error [INFO] [stdout] 2025-09-01T09:57:42.533057Z  WARN lib::integration::tracing: LogFusion warning [INFO] [stdout] 2025-09-01T09:57:42.533072Z  INFO lib::integration::tracing: LogFusion info [INFO] [stdout] test integration::logging_macros::logging_with_formatting ... ok [INFO] [stdout] test integration::logging_macros::logging_with_target ... ok [INFO] [stdout] test integration::thiserror::thiserror_debug_trait ... ok [INFO] [stdout] test integration::thiserror::thiserror_display_trait ... ok [INFO] [stdout] test integration::thiserror::thiserror_source_chaining_complex ... ok [INFO] [stdout] test integration::thiserror::thiserror_with_logging_integration ... ok [INFO] [stdout] test integration::logging_macros::basic_logging_macros_work ... ok [INFO] [stdout] test integration::logfusion_structured_logging::logfusion_structured_logging_with_targets ... ok [INFO] [stdout] test integration::thiserror::thiserror_error_trait ... ok [INFO] [stdout] test integration::thiserror::thiserror_field_types_comprehensive ... ok [INFO] [stdout] test integration::tracing::log_crate_bridge_compatibility ... ok [INFO] [stdout] test integration::tracing::tracing_basic_functionality ... ok [INFO] [stdout] test integration::logfusion_structured_logging::logfusion_structured_logging_mixed_types ... ok [INFO] [stdout] test integration::tracing::tracing_structured_logging ... ok [INFO] [stdout] 2025-09-01T09:57:42.534512Z ERROR Multi-layer error [INFO] [stdout] 2025-09-01T09:57:42.534550Z  INFO Multi-layer info [INFO] [stdout] test integration::tracing::tracing_spans_comprehensive ... ok [INFO] [stdout] test integration::tracing::tracing_subscriber_layers ... ok [INFO] [stdout] test integration::tracing::tracing_instrumentation ... ok [INFO] [stdout] test integration::tracing::tracing_spans_integration ... ok [INFO] [stdout] test integration::tracing::tracing_targeted_logging ... ok [INFO] [stdout] test integration::logfusion_structured_logging::logfusion_reexports_work ... ok [INFO] [stdout] test integration::tracing::tracing_filtering ... ok [INFO] [stdout] test integration::callback_functionality::callback_receives_log_messages ... ok [INFO] [stdout] test integration::logfusion_structured_logging::logfusion_json_output_configuration ... ok [INFO] [stderr] Running unittests examples/error_debugging_tools.rs (/opt/rustwide/target/debug/examples/error_debugging_tools-3e10faeb37f8599b) [INFO] [stdout] [INFO] [stderr] Running unittests examples/error_monitoring_dashboard.rs (/opt/rustwide/target/debug/examples/error_monitoring_dashboard-cd6c70c03f408619) [INFO] [stdout] test result: ok. 52 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.17s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 4 tests [INFO] [stdout] test tests::test_error_categorization ... ok [INFO] [stdout] test tests::test_error_pattern_analysis ... ok [INFO] [stdout] test tests::test_error_info_extraction ... ok [INFO] [stdout] test tests::test_target_grouping ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 3 tests [INFO] [stdout] test tests::test_error_info_extraction ... ok [INFO] [stdout] 2025-09-01T09:57:42.661259Z ERROR api::db: [DatabaseTimeout] Database query timed out: test query (2000ms) [INFO] [stdout] 2025-09-01T09:57:42.661332Z ERROR api::db: [DatabaseTimeout] Database query timed out: test query (2000ms) [INFO] [stdout] 2025-09-01T09:57:42.661347Z ERROR api::db: [DatabaseTimeout] Database query timed out: test query (2000ms) [INFO] [stdout] 2025-09-01T09:57:42.661357Z ERROR api::db: [DatabaseTimeout] Database query timed out: test query (2000ms) [INFO] [stdout] 2025-09-01T09:57:42.661368Z ERROR api::db: [DatabaseTimeout] Database query timed out: test query (2000ms) [INFO] [stdout] 2025-09-01T09:57:42.661379Z ERROR api::db: [DatabaseTimeout] Database query timed out: test query (2000ms) [INFO] [stdout] test tests::test_alert_conditions ... ok [INFO] [stdout] 2025-09-01T09:57:42.663411Z ERROR system::health: [ServiceDown] Service unavailable: database [INFO] [stdout] test tests::test_metrics_collection ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s [INFO] [stdout] [INFO] [stderr] Running unittests examples/structured_error_logging.rs (/opt/rustwide/target/debug/examples/structured_error_logging-ec92721821e5bf16) [INFO] [stdout] [INFO] [stdout] running 4 tests [INFO] [stdout] test tests::test_alert_conditions ... ok [INFO] [stdout] test tests::test_batch_error_processing ... ok [INFO] [stdout] test tests::test_structured_logging_format ... ok [INFO] [stdout] test tests::test_error_info_extraction ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Doc-tests logfusion [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" "058b5be3d2a907113b1594bb1092b82a2ec442733c2e3710bbfd6b1690976b9e", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "058b5be3d2a907113b1594bb1092b82a2ec442733c2e3710bbfd6b1690976b9e", kill_on_drop: false }` [INFO] [stdout] 058b5be3d2a907113b1594bb1092b82a2ec442733c2e3710bbfd6b1690976b9e