[INFO] fetching crate ds-common-logger-rs-lib 0.1.1...
[INFO] testing ds-common-logger-rs-lib-0.1.1 against 1.99.0-beta.8+cargoflags=--release for beta-release-1.100-2
[INFO] extracting crate ds-common-logger-rs-lib 0.1.1 into /workspace/builds/worker-4-tc1/source
[INFO] started tweaking crates.io crate ds-common-logger-rs-lib 0.1.1
[INFO] removed 0 missing examples
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate ds-common-logger-rs-lib 0.1.1
[INFO] tweaked toml for crates.io crate ds-common-logger-rs-lib 0.1.1 written to /workspace/builds/worker-4-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate ds-common-logger-rs-lib 0.1.1 on toolchain 1.99.0-beta.8
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate ds-common-logger-rs-lib 0.1.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" "+1.99.0-beta.8" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/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:77db811e55d90add9212f6832c23229e3de5f1c1f9905e8cb07319ea15df73ac" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 5f9504b42408c3840b788ad0143bade1e0c66d19e734e79d75005743a188d1c5
[INFO] running `Command { std: "docker" "start" "5f9504b42408c3840b788ad0143bade1e0c66d19e734e79d75005743a188d1c5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "5f9504b42408c3840b788ad0143bade1e0c66d19e734e79d75005743a188d1c5", 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" "5f9504b42408c3840b788ad0143bade1e0c66d19e734e79d75005743a188d1c5" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "5f9504b42408c3840b788ad0143bade1e0c66d19e734e79d75005743a188d1c5", 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" "5f9504b42408c3840b788ad0143bade1e0c66d19e734e79d75005743a188d1c5" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling quote v1.0.41
[INFO] [stderr]    Compiling regex-syntax v0.8.6
[INFO] [stderr]    Compiling log v0.4.28
[INFO] [stderr]    Compiling tracing-core v0.1.34
[INFO] [stderr]    Compiling thread_local v1.1.9
[INFO] [stderr]    Compiling nu-ansi-term v0.50.1
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling serde_json v1.0.145
[INFO] [stderr]    Compiling tracing-log v0.2.0
[INFO] [stderr]    Compiling syn v2.0.106
[INFO] [stderr]    Compiling tracing-serde v0.2.0
[INFO] [stderr]    Compiling regex-automata v0.4.11
[INFO] [stderr]    Compiling matchers v0.2.0
[INFO] [stderr]    Compiling tracing-attributes v0.1.30
[INFO] [stderr]    Compiling tracing v0.1.41
[INFO] [stderr]    Compiling tracing-subscriber v0.3.20
[INFO] [stderr]    Compiling tracing-error v0.2.1
[INFO] [stderr]    Compiling ds-common-logger-rs-lib v0.1.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 22.05s
[INFO] running `Command { std: "docker" "inspect" "5f9504b42408c3840b788ad0143bade1e0c66d19e734e79d75005743a188d1c5", 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" "5f9504b42408c3840b788ad0143bade1e0c66d19e734e79d75005743a188d1c5" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--no-run" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.176
[INFO] [stderr]    Compiling syn v2.0.106
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling mio v1.0.4
[INFO] [stderr]    Compiling signal-hook-registry v1.4.6
[INFO] [stderr]    Compiling socket2 v0.6.0
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling tracing-attributes v0.1.30
[INFO] [stderr]    Compiling tokio-macros v2.5.0
[INFO] [stderr]    Compiling tokio v1.47.1
[INFO] [stderr]    Compiling tracing v0.1.41
[INFO] [stderr]    Compiling tracing-subscriber v0.3.20
[INFO] [stderr]    Compiling tracing-error v0.2.1
[INFO] [stderr]    Compiling ds-common-logger-rs-lib v0.1.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 24.27s
[INFO] running `Command { std: "docker" "inspect" "5f9504b42408c3840b788ad0143bade1e0c66d19e734e79d75005743a188d1c5", 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" "5f9504b42408c3840b788ad0143bade1e0c66d19e734e79d75005743a188d1c5" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--release", kill_on_drop: false }`
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 0.06s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/deps/ds_common_logger_rs_lib-52a3acc08935e77e)
[INFO] [stderr]      Running tests/integration_tests.rs (/opt/rustwide/target/release/deps/integration_tests-5b650a696b1e92a9)
[INFO] [stderr]      Running tests/panic_handling.rs (/opt/rustwide/target/release/deps/panic_handling-b151b3c9b3f5f109)
[INFO] [stderr]      Running tests/thread_safety.rs (/opt/rustwide/target/release/deps/thread_safety-928842d16c28bd90)
[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 4 tests
[INFO] [stdout] [2m2026-10-18T07:51:07.428836Z[0m [32m INFO[0m test_log_levels ThreadId(02) [2mds_common_logger_rs_lib[0m[2m:[0m Tracing initialized [3mformat[0m[2m=[0mcompact
[INFO] [stdout] [2m2026-10-18T07:51:07.428868Z[0m [32m INFO[0m test_log_levels ThreadId(02) [2mintegration_tests[0m[2m:[0m Info message
[INFO] [stdout] [2m2026-10-18T07:51:07.428873Z[0m [33m WARN[0m test_log_levels ThreadId(02) [2mintegration_tests[0m[2m:[0m Warning message
[INFO] [stdout] [2m2026-10-18T07:51:07.428877Z[0m [31mERROR[0m test_log_levels ThreadId(02) [2mintegration_tests[0m[2m:[0m Error message
[INFO] [stdout] test test_log_levels ... ok
[INFO] [stdout] [2m2026-10-18T07:51:07.429644Z[0m [32m INFO[0m test_multiple_initialization_calls ThreadId(03) [2mintegration_tests[0m[2m:[0m Multiple initialization test passed
[INFO] [stdout] [2m2026-10-18T07:51:07.430649Z[0m [32m INFO[0m        test_tracing_initialization ThreadId(05) [2mintegration_tests[0m[2m:[0m Test info message
[INFO] [stdout] test test_multiple_initialization_calls ... [2m2026-10-18T07:51:07.431622Z[0m [33m WARN[0m        test_tracing_initialization ThreadId(05) [2mintegration_tests[0m[2m:[0m Test warning message
[INFO] [stdout] ok
[INFO] [stdout] [2m2026-10-18T07:51:07.431635Z[0m [31mERROR[0m        test_tracing_initialization ThreadId(05) [2mintegration_tests[0m[2m:[0m Test error message
[INFO] [stdout] test test_tracing_initialization ... ok
[INFO] [stdout] [2m2026-10-18T07:51:07.434716Z[0m [32m INFO[0m            test_structured_logging ThreadId(04) [1mtest_operation[0m: [2mintegration_tests[0m[2m:[0m Operation started [2moperation_id="test-123" user_id=42[0m
[INFO] [stdout] [2m2026-10-18T07:51:07.434747Z[0m [32m INFO[0m            test_structured_logging ThreadId(04) [1mtest_operation[0m: [2mintegration_tests[0m[2m:[0m Operation completed [2moperation_id="test-123" user_id=42[0m
[INFO] [stdout] [2m2026-10-18T07:51:07.434755Z[0m [32m INFO[0m            test_structured_logging ThreadId(04) [1mtest_operation[0m: [2mintegration_tests[0m[2m:[0m close [3mtime.busy[0m[2m=[0m41.3µs [3mtime.idle[0m[2m=[0m2.76µs [2moperation_id="test-123" user_id=42[0m
[INFO] [stdout] test test_structured_logging ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] [2m2026-10-18T07:51:07.438911Z[0m [32m INFO[0m test_panic_with_context ThreadId(03) [2mds_common_logger_rs_lib[0m[2m:[0m Tracing initialized [3mformat[0m[2m=[0mcompact
[INFO] [stdout] [2m2026-10-18T07:51:07.438990Z[0m [32m INFO[0m test_panic_with_context ThreadId(03) [1mpanic_test_operation[0m: [2mpanic_handling[0m[2m:[0m About to panic [2mtest_id="panic-test-456"[0m
[INFO] [stdout] [2m2026-10-18T07:51:07.439025Z[0m [31mERROR[0m test_panic_with_context ThreadId(03) [1mpanic_test_operation[0m: [2mds_common_logger_rs_lib[0m[2m:[0m Application panicked [3mlocation[0m[2m=[0mtests/panic_handling.rs:30 [3mpayload[0m[2m=[0mpanicked at tests/panic_handling.rs:30:9:
[INFO] [stdout] Panic with span context [2mtest_id="panic-test-456"[0m
[INFO] [stdout] [2m2026-10-18T07:51:07.439153Z[0m [32m INFO[0m test_panic_with_context ThreadId(03) [1mpanic_test_operation[0m: [2mpanic_handling[0m[2m:[0m Panic with context test completed [2mtest_id="panic-test-456"[0m
[INFO] [stdout] [2m2026-10-18T07:51:07.439277Z[0m [32m INFO[0m test_panic_with_context ThreadId(03) [1mpanic_test_operation[0m: [2mpanic_handling[0m[2m:[0m close [3mtime.busy[0m[2m=[0m286µs [3mtime.idle[0m[2m=[0m2.81µs [2mtest_id="panic-test-456"[0m
[INFO] [stdout] [2m2026-10-18T07:51:07.439659Z[0m [31mERROR[0m      test_panic_logging ThreadId(02) [2mds_common_logger_rs_lib[0m[2m:[0m Application panicked [3mlocation[0m[2m=[0mtests/panic_handling.rs:10 [3mpayload[0m[2m=[0mpanicked at tests/panic_handling.rs:10:9:
[INFO] [stdout] Test panic for logging
[INFO] [stdout] [2m2026-10-18T07:51:07.439712Z[0m [32m INFO[0m      test_panic_logging ThreadId(02) [2mpanic_handling[0m[2m:[0m Panic handling test completed
[INFO] [stdout] test test_panic_with_context ... ok
[INFO] [stdout] test test_panic_logging ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 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] [2m2026-10-18T07:51:07.444861Z[0m [32m INFO[0m test_concurrent_logging ThreadId(03) [2mds_common_logger_rs_lib[0m[2m:[0m Tracing initialized [3mformat[0m[2m=[0mcompact
[INFO] [stdout] [2m2026-10-18T07:51:07.445185Z[0m [32m INFO[0m ThreadId(13) [2mthread_safety[0m[2m:[0m Thread 7 initialized
[INFO] [stdout] [2m2026-10-18T07:51:07.445832Z[0m [32m INFO[0m ThreadId(14) [2mthread_safety[0m[2m:[0m Thread 8 initialized
[INFO] [stdout] [2m2026-10-18T07:51:07.446700Z[0m [32m INFO[0m ThreadId(20) [2mthread_safety[0m[2m:[0m Thread 1 processing shared_data
[INFO] [stdout] [2m2026-10-18T07:51:07.446701Z[0m [32m INFO[0m ThreadId(08) [2mthread_safety[0m[2m:[0m Thread 3 initialized
[INFO] [stdout] [2m2026-10-18T07:51:07.446876Z[0m [32m INFO[0m ThreadId(07) [2mthread_safety[0m[2m:[0m Thread 2 initialized
[INFO] [stdout] [2m2026-10-18T07:51:07.446913Z[0m [32m INFO[0m ThreadId(15) [2mthread_safety[0m[2m:[0m Thread 9 initialized
[INFO] [stdout] [2m2026-10-18T07:51:07.446979Z[0m [32m INFO[0m ThreadId(10) [2mthread_safety[0m[2m:[0m Thread 4 initialized
[INFO] [stdout] [2m2026-10-18T07:51:07.446744Z[0m [32m INFO[0m ThreadId(05) [2mthread_safety[0m[2m:[0m Thread 0 initialized
[INFO] [stdout] [2m2026-10-18T07:51:07.447096Z[0m [32m INFO[0m ThreadId(22) [2mthread_safety[0m[2m:[0m Thread 4 message 0
[INFO] [stdout] [2m2026-10-18T07:51:07.447641Z[0m [32m INFO[0m ThreadId(16) [2mthread_safety[0m[2m:[0m Thread 1 message 0
[INFO] [stdout] [2m2026-10-18T07:51:07.447694Z[0m [32m INFO[0m ThreadId(17) [2mthread_safety[0m[2m:[0m Thread 0 processing shared_data
[INFO] [stdout] [2m2026-10-18T07:51:07.447851Z[0m [32m INFO[0m ThreadId(21) [2mthread_safety[0m[2m:[0m Thread 2 processing shared_data
[INFO] [stdout] [2m2026-10-18T07:51:07.447921Z[0m [32m INFO[0m ThreadId(18) [2mthread_safety[0m[2m:[0m Thread 2 message 0
[INFO] [stdout] [2m2026-10-18T07:51:07.447954Z[0m [32m INFO[0m ThreadId(09) [2mthread_safety[0m[2m:[0m Thread 0 message 0
[INFO] [stdout] [2m2026-10-18T07:51:07.447983Z[0m [32m INFO[0m ThreadId(11) [2mthread_safety[0m[2m:[0m Thread 5 initialized
[INFO] [stdout] [2m2026-10-18T07:51:07.448181Z[0m [32m INFO[0m ThreadId(22) [2mthread_safety[0m[2m:[0m Thread 4 message 1
[INFO] [stdout] [2m2026-10-18T07:51:07.448654Z[0m [32m INFO[0m ThreadId(12) [2mthread_safety[0m[2m:[0m Thread 6 initialized
[INFO] [stdout] [2m2026-10-18T07:51:07.448766Z[0m [32m INFO[0m ThreadId(06) [2mthread_safety[0m[2m:[0m Thread 1 initialized
[INFO] [stdout] [2m2026-10-18T07:51:07.448655Z[0m [32m INFO[0m ThreadId(19) [2mthread_safety[0m[2m:[0m Thread 3 message 0
[INFO] [stdout] [2m2026-10-18T07:51:07.448830Z[0m [32m INFO[0m ThreadId(16) [2mthread_safety[0m[2m:[0m Thread 1 message 1
[INFO] [stdout] [2m2026-10-18T07:51:07.449005Z[0m [32m INFO[0m ThreadId(09) [2mthread_safety[0m[2m:[0m Thread 0 message 1
[INFO] [stdout] [2m2026-10-18T07:51:07.449055Z[0m [32m INFO[0m ThreadId(18) [2mthread_safety[0m[2m:[0m Thread 2 message 1
[INFO] [stdout] [2m2026-10-18T07:51:07.449263Z[0m [32m INFO[0m test_shared_logger_across_threads ThreadId(04) [2mthread_safety[0m[2m:[0m Shared logger test completed
[INFO] [stdout] [2m2026-10-18T07:51:07.449269Z[0m [32m INFO[0m ThreadId(22) [2mthread_safety[0m[2m:[0m Thread 4 message 2
[INFO] [stdout] [2m2026-10-18T07:51:07.449619Z[0m [32m INFO[0m    test_concurrent_initialization ThreadId(02) [2mthread_safety[0m[2m:[0m Concurrent initialization test completed
[INFO] [stdout] test test_shared_logger_across_threads ... ok
[INFO] [stdout] [2m2026-10-18T07:51:07.449911Z[0m [32m INFO[0m ThreadId(16) [2mthread_safety[0m[2m:[0m Thread 1 message 2
[INFO] [stdout] [2m2026-10-18T07:51:07.449928Z[0m [32m INFO[0m ThreadId(19) [2mthread_safety[0m[2m:[0m Thread 3 message 1
[INFO] [stdout] test test_concurrent_initialization ... ok
[INFO] [stdout] [2m2026-10-18T07:51:07.450211Z[0m [32m INFO[0m ThreadId(09) [2mthread_safety[0m[2m:[0m Thread 0 message 2
[INFO] [stdout] [2m2026-10-18T07:51:07.450226Z[0m [32m INFO[0m ThreadId(18) [2mthread_safety[0m[2m:[0m Thread 2 message 2
[INFO] [stdout] [2m2026-10-18T07:51:07.450704Z[0m [32m INFO[0m ThreadId(22) [2mthread_safety[0m[2m:[0m Thread 4 message 3
[INFO] [stdout] [2m2026-10-18T07:51:07.451005Z[0m [32m INFO[0m ThreadId(16) [2mthread_safety[0m[2m:[0m Thread 1 message 3
[INFO] [stdout] [2m2026-10-18T07:51:07.451021Z[0m [32m INFO[0m ThreadId(19) [2mthread_safety[0m[2m:[0m Thread 3 message 2
[INFO] [stdout] [2m2026-10-18T07:51:07.451288Z[0m [32m INFO[0m ThreadId(18) [2mthread_safety[0m[2m:[0m Thread 2 message 3
[INFO] [stdout] [2m2026-10-18T07:51:07.451306Z[0m [32m INFO[0m ThreadId(09) [2mthread_safety[0m[2m:[0m Thread 0 message 3
[INFO] [stdout] [2m2026-10-18T07:51:07.451833Z[0m [32m INFO[0m ThreadId(22) [2mthread_safety[0m[2m:[0m Thread 4 message 4
[INFO] [stdout] [2m2026-10-18T07:51:07.452093Z[0m [32m INFO[0m ThreadId(19) [2mthread_safety[0m[2m:[0m Thread 3 message 3
[INFO] [stdout] [2m2026-10-18T07:51:07.452111Z[0m [32m INFO[0m ThreadId(16) [2mthread_safety[0m[2m:[0m Thread 1 message 4
[INFO] [stdout] [2m2026-10-18T07:51:07.452392Z[0m [32m INFO[0m ThreadId(18) [2mthread_safety[0m[2m:[0m Thread 2 message 4
[INFO] [stdout] [2m2026-10-18T07:51:07.452410Z[0m [32m INFO[0m ThreadId(09) [2mthread_safety[0m[2m:[0m Thread 0 message 4
[INFO] [stdout] [2m2026-10-18T07:51:07.452961Z[0m [32m INFO[0m ThreadId(22) [2mthread_safety[0m[2m:[0m Thread 4 message 5
[INFO] [stdout] [2m2026-10-18T07:51:07.453183Z[0m [32m INFO[0m ThreadId(16) [2mthread_safety[0m[2m:[0m Thread 1 message 5
[INFO] [stdout] [2m2026-10-18T07:51:07.453200Z[0m [32m INFO[0m ThreadId(19) [2mthread_safety[0m[2m:[0m Thread 3 message 4
[INFO] [stdout] [2m2026-10-18T07:51:07.453495Z[0m [32m INFO[0m ThreadId(09) [2mthread_safety[0m[2m:[0m Thread 0 message 5
[INFO] [stdout] [2m2026-10-18T07:51:07.453540Z[0m [32m INFO[0m ThreadId(18) [2mthread_safety[0m[2m:[0m Thread 2 message 5
[INFO] [stdout] [2m2026-10-18T07:51:07.454093Z[0m [32m INFO[0m ThreadId(22) [2mthread_safety[0m[2m:[0m Thread 4 message 6
[INFO] [stdout] [2m2026-10-18T07:51:07.454270Z[0m [32m INFO[0m ThreadId(19) [2mthread_safety[0m[2m:[0m Thread 3 message 5
[INFO] [stdout] [2m2026-10-18T07:51:07.454284Z[0m [32m INFO[0m ThreadId(16) [2mthread_safety[0m[2m:[0m Thread 1 message 6
[INFO] [stdout] [2m2026-10-18T07:51:07.454701Z[0m [32m INFO[0m ThreadId(09) [2mthread_safety[0m[2m:[0m Thread 0 message 6
[INFO] [stdout] [2m2026-10-18T07:51:07.454715Z[0m [32m INFO[0m ThreadId(18) [2mthread_safety[0m[2m:[0m Thread 2 message 6
[INFO] [stdout] [2m2026-10-18T07:51:07.455183Z[0m [32m INFO[0m ThreadId(22) [2mthread_safety[0m[2m:[0m Thread 4 message 7
[INFO] [stdout] [2m2026-10-18T07:51:07.455358Z[0m [32m INFO[0m ThreadId(19) [2mthread_safety[0m[2m:[0m Thread 3 message 6
[INFO] [stdout] [2m2026-10-18T07:51:07.455371Z[0m [32m INFO[0m ThreadId(16) [2mthread_safety[0m[2m:[0m Thread 1 message 7
[INFO] [stdout] [2m2026-10-18T07:51:07.455746Z[0m [32m INFO[0m ThreadId(09) [2mthread_safety[0m[2m:[0m Thread 0 message 7
[INFO] [stdout] [2m2026-10-18T07:51:07.455809Z[0m [32m INFO[0m ThreadId(18) [2mthread_safety[0m[2m:[0m Thread 2 message 7
[INFO] [stdout] [2m2026-10-18T07:51:07.456270Z[0m [32m INFO[0m ThreadId(22) [2mthread_safety[0m[2m:[0m Thread 4 message 8
[INFO] [stdout] [2m2026-10-18T07:51:07.456441Z[0m [32m INFO[0m ThreadId(16) [2mthread_safety[0m[2m:[0m Thread 1 message 8
[INFO] [stdout] [2m2026-10-18T07:51:07.456454Z[0m [32m INFO[0m ThreadId(19) [2mthread_safety[0m[2m:[0m Thread 3 message 7
[INFO] [stdout] [2m2026-10-18T07:51:07.456827Z[0m [32m INFO[0m ThreadId(09) [2mthread_safety[0m[2m:[0m Thread 0 message 8
[INFO] [stdout] [2m2026-10-18T07:51:07.456893Z[0m [32m INFO[0m ThreadId(18) [2mthread_safety[0m[2m:[0m Thread 2 message 8
[INFO] [stdout] [2m2026-10-18T07:51:07.457355Z[0m [32m INFO[0m ThreadId(22) [2mthread_safety[0m[2m:[0m Thread 4 message 9
[INFO] [stdout] [2m2026-10-18T07:51:07.457529Z[0m [32m INFO[0m ThreadId(19) [2mthread_safety[0m[2m:[0m Thread 3 message 8
[INFO] [stdout] [2m2026-10-18T07:51:07.457543Z[0m [32m INFO[0m ThreadId(16) [2mthread_safety[0m[2m:[0m Thread 1 message 9
[INFO] [stdout] [2m2026-10-18T07:51:07.457965Z[0m [32m INFO[0m ThreadId(09) [2mthread_safety[0m[2m:[0m Thread 0 message 9
[INFO] [stdout] [2m2026-10-18T07:51:07.457981Z[0m [32m INFO[0m ThreadId(18) [2mthread_safety[0m[2m:[0m Thread 2 message 9
[INFO] [stdout] [2m2026-10-18T07:51:07.458704Z[0m [32m INFO[0m ThreadId(19) [2mthread_safety[0m[2m:[0m Thread 3 message 9
[INFO] [stderr]    Doc-tests ds_common_logger_rs_lib
[INFO] [stdout] [2m2026-10-18T07:51:07.460638Z[0m [32m INFO[0m           test_concurrent_logging ThreadId(03) [2mthread_safety[0m[2m:[0m Concurrent logging test completed
[INFO] [stdout] test test_concurrent_logging ... 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] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test src/lib.rs - init_tracing (line 125) ... ok
[INFO] [stdout] test src/lib.rs - (line 24) ... ok
[INFO] [stdout] test src/lib.rs - init_tracing (line 140) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.26s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "5f9504b42408c3840b788ad0143bade1e0c66d19e734e79d75005743a188d1c5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5f9504b42408c3840b788ad0143bade1e0c66d19e734e79d75005743a188d1c5", kill_on_drop: false }`
[INFO] [stdout] 5f9504b42408c3840b788ad0143bade1e0c66d19e734e79d75005743a188d1c5
