[INFO] fetching crate ecs-logger 1.1.0... [INFO] testing ecs-logger-1.1.0 against master#1ddedbaa5919b7b3e70d984660e21e844c615c97 for pr-128400-1 [INFO] extracting crate ecs-logger 1.1.0 into /workspace/builds/worker-6-tc1/source [INFO] validating manifest of crates.io crate ecs-logger 1.1.0 on toolchain 1ddedbaa5919b7b3e70d984660e21e844c615c97 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1ddedbaa5919b7b3e70d984660e21e844c615c97" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate ecs-logger 1.1.0 [INFO] finished tweaking crates.io crate ecs-logger 1.1.0 [INFO] tweaked toml for crates.io crate ecs-logger 1.1.0 written to /workspace/builds/worker-6-tc1/source/Cargo.toml [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1ddedbaa5919b7b3e70d984660e21e844c615c97" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Updating crates.io index [INFO] [stderr] Locking 51 packages to latest compatible versions [INFO] [stderr] Adding env_logger v0.10.2 (latest: v0.11.5) [INFO] [stderr] Adding windows-core v0.52.0 (latest: v0.58.0) [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1ddedbaa5919b7b3e70d984660e21e844c615c97" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded ryu v1.0.18 [INFO] [stderr] Downloaded equivalent v1.0.1 [INFO] [stderr] Downloaded indexmap v2.3.0 [INFO] [stderr] Downloaded itoa v1.0.11 [INFO] [stderr] Downloaded thiserror-impl v1.0.63 [INFO] [stderr] Downloaded thiserror v1.0.63 [INFO] [stderr] Downloaded env_logger v0.10.2 [INFO] [stderr] Downloaded hashbrown v0.14.5 [INFO] [stderr] Downloaded serde_json v1.0.122 [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:923055f121b5182466d55868a8b05e67af8ba4a3a3f6bad814e953ca3cd3ac2a" "/opt/rustwide/cargo-home/bin/cargo" "+1ddedbaa5919b7b3e70d984660e21e844c615c97" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] fafb0114ff0b0688f5e106bd8afbfdbccb368f56567484fba0cc90f901c91a63 [INFO] running `Command { std: "docker" "start" "-a" "fafb0114ff0b0688f5e106bd8afbfdbccb368f56567484fba0cc90f901c91a63", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "fafb0114ff0b0688f5e106bd8afbfdbccb368f56567484fba0cc90f901c91a63", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "fafb0114ff0b0688f5e106bd8afbfdbccb368f56567484fba0cc90f901c91a63", kill_on_drop: false }` [INFO] [stdout] fafb0114ff0b0688f5e106bd8afbfdbccb368f56567484fba0cc90f901c91a63 [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:923055f121b5182466d55868a8b05e67af8ba4a3a3f6bad814e953ca3cd3ac2a" "/opt/rustwide/cargo-home/bin/cargo" "+1ddedbaa5919b7b3e70d984660e21e844c615c97" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 6189ee44b9293e6c4255bddcce871cb167c8ddea1ff368b34e1e132f5fdd64bf [INFO] running `Command { std: "docker" "start" "-a" "6189ee44b9293e6c4255bddcce871cb167c8ddea1ff368b34e1e132f5fdd64bf", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.86 [INFO] [stderr] Compiling unicode-ident v1.0.12 [INFO] [stderr] Compiling serde v1.0.205 [INFO] [stderr] Compiling autocfg v1.3.0 [INFO] [stderr] Compiling serde_json v1.0.122 [INFO] [stderr] Compiling hashbrown v0.14.5 [INFO] [stderr] Compiling equivalent v1.0.1 [INFO] [stderr] Compiling thiserror v1.0.63 [INFO] [stderr] Compiling memchr v2.7.4 [INFO] [stderr] Compiling ryu v1.0.18 [INFO] [stderr] Compiling iana-time-zone v0.1.60 [INFO] [stderr] Compiling log v0.4.22 [INFO] [stderr] Compiling itoa v1.0.11 [INFO] [stderr] Compiling num-traits v0.2.19 [INFO] [stderr] Compiling indexmap v2.3.0 [INFO] [stderr] Compiling env_logger v0.10.2 [INFO] [stderr] Compiling quote v1.0.36 [INFO] [stderr] Compiling syn v2.0.72 [INFO] [stderr] Compiling serde_derive v1.0.205 [INFO] [stderr] Compiling thiserror-impl v1.0.63 [INFO] [stderr] Compiling chrono v0.4.38 [INFO] [stderr] Compiling ecs-logger v1.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 17.03s [INFO] running `Command { std: "docker" "inspect" "6189ee44b9293e6c4255bddcce871cb167c8ddea1ff368b34e1e132f5fdd64bf", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "6189ee44b9293e6c4255bddcce871cb167c8ddea1ff368b34e1e132f5fdd64bf", kill_on_drop: false }` [INFO] [stdout] 6189ee44b9293e6c4255bddcce871cb167c8ddea1ff368b34e1e132f5fdd64bf [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:923055f121b5182466d55868a8b05e67af8ba4a3a3f6bad814e953ca3cd3ac2a" "/opt/rustwide/cargo-home/bin/cargo" "+1ddedbaa5919b7b3e70d984660e21e844c615c97" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 5128a4fe0ab52cf17024955e534ce9698831953c245b78b6db4fa79f1595750c [INFO] running `Command { std: "docker" "start" "-a" "5128a4fe0ab52cf17024955e534ce9698831953c245b78b6db4fa79f1595750c", kill_on_drop: false }` [INFO] [stderr] Compiling aho-corasick v1.1.3 [INFO] [stderr] Compiling regex-syntax v0.8.4 [INFO] [stderr] Compiling once_cell v1.19.0 [INFO] [stderr] Compiling regex-automata v0.4.7 [INFO] [stderr] Compiling regex v1.10.6 [INFO] [stderr] Compiling ecs-logger v1.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 15.67s [INFO] running `Command { std: "docker" "inspect" "5128a4fe0ab52cf17024955e534ce9698831953c245b78b6db4fa79f1595750c", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "5128a4fe0ab52cf17024955e534ce9698831953c245b78b6db4fa79f1595750c", kill_on_drop: false }` [INFO] [stdout] 5128a4fe0ab52cf17024955e534ce9698831953c245b78b6db4fa79f1595750c [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:923055f121b5182466d55868a8b05e67af8ba4a3a3f6bad814e953ca3cd3ac2a" "/opt/rustwide/cargo-home/bin/cargo" "+1ddedbaa5919b7b3e70d984660e21e844c615c97" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 142955ac393fbcb5098f77096ffda9991d57baef720b3d83eb077aebab6bd342 [INFO] running `Command { std: "docker" "start" "-a" "142955ac393fbcb5098f77096ffda9991d57baef720b3d83eb077aebab6bd342", kill_on_drop: false }` [INFO] [stdout] [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.06s [INFO] [stdout] running 12 tests [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/ecs_logger-b606fd83552020d4) [INFO] [stdout] test extra_fields::tests::test_clear_extra_fields ... ok [INFO] [stdout] test ecs::tests::test_from_log_record ... ok [INFO] [stdout] test ecs::tests::test_serialize_with_none ... ok [INFO] [stdout] test ecs::tests::test_serialize ... ok [INFO] [stdout] test extra_fields::tests::test_extend_json_map ... ok [INFO] [stdout] test tests::test_format ... ok [INFO] [stdout] test extra_fields::tests::test_set_extra_fields_ok ... ok [INFO] [stdout] test tests::test_init ... ok [INFO] [stdout] test timestamp::tests::test_get_timestamp ... ok [INFO] [stdout] test tests::test_format_with_extra_fields ... ok [INFO] [stdout] test extra_fields::tests::test_merge_extra_fields ... ok [INFO] [stdout] test extra_fields::tests::test_set_extra_fields_err ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s [INFO] [stdout] [INFO] [stderr] Running tests/example.rs (/opt/rustwide/target/debug/deps/example-0af107f6fb58c9e3) [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stderr] {"@timestamp":"2024-08-09T09:36:27.491659183Z","log.level":"ERROR","message":"this is printed by default","ecs.version":"1.12.1","log.origin":{"file":{"line":36,"name":"example.rs"},"rust":{"target":"example::tests","module_path":"example::tests","file_path":"tests/example.rs"}},"organization.name":"Example Company","service":{"name":"example-service","version":"1.2.3"}} [INFO] [stdout] test tests::main ... ok [INFO] [stderr] Running tests/log.rs (/opt/rustwide/target/debug/deps/log-a5821f96d2e37aab) [INFO] [stdout] [INFO] [stdout] test result: ok. 1 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_extra_fields ... ok [INFO] [stdout] test tests::test_logs ... ok [INFO] [stdout] test tests::test_target ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.13s [INFO] [stdout] [INFO] [stderr] Doc-tests ecs_logger [INFO] [stdout] [INFO] [stdout] running 13 tests [INFO] [stdout] test src/lib.rs - (line 103) ... ok [INFO] [stdout] test src/lib.rs - (line 26) ... ok [INFO] [stdout] test src/extra_fields.rs - extra_fields::set_extra_fields (line 76) ... ok [INFO] [stdout] test src/extra_fields.rs - extra_fields (line 7) ... ok [INFO] [stdout] test src/extra_fields.rs - extra_fields::clear_extra_fields (line 108) ... ok [INFO] [stdout] test src/extra_fields.rs - extra_fields::SetExtraFieldsError::InvalidJson (line 41) ... ok [INFO] [stdout] test src/extra_fields.rs - extra_fields::SetExtraFieldsError::NotObject (line 57) ... ok [INFO] [stdout] test src/lib.rs - format (line 200) ... ok [INFO] [stdout] test src/lib.rs - init (line 155) ... ok [INFO] [stdout] test src/lib.rs - (line 89) ... ok [INFO] [stdout] test src/lib.rs - try_init (line 178) ... ok [INFO] [stdout] test src/ecs.rs - ecs (line 7) ... ok [INFO] [stdout] test src/lib.rs - (line 55) ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.64s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "142955ac393fbcb5098f77096ffda9991d57baef720b3d83eb077aebab6bd342", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "142955ac393fbcb5098f77096ffda9991d57baef720b3d83eb077aebab6bd342", kill_on_drop: false }` [INFO] [stdout] 142955ac393fbcb5098f77096ffda9991d57baef720b3d83eb077aebab6bd342 [INFO] testing ecs-logger-1.1.0 against try#33f1d8bb92813a1bfc23c093c9f443ab09290307 for pr-128400-1 [INFO] extracting crate ecs-logger 1.1.0 into /workspace/builds/worker-6-tc2/source [INFO] validating manifest of crates.io crate ecs-logger 1.1.0 on toolchain 33f1d8bb92813a1bfc23c093c9f443ab09290307 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+33f1d8bb92813a1bfc23c093c9f443ab09290307" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate ecs-logger 1.1.0 [INFO] finished tweaking crates.io crate ecs-logger 1.1.0 [INFO] tweaked toml for crates.io crate ecs-logger 1.1.0 written to /workspace/builds/worker-6-tc2/source/Cargo.toml [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+33f1d8bb92813a1bfc23c093c9f443ab09290307" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Updating crates.io index [INFO] [stderr] Locking 51 packages to latest compatible versions [INFO] [stderr] Adding env_logger v0.10.2 (latest: v0.11.5) [INFO] [stderr] Adding windows-core v0.52.0 (latest: v0.58.0) [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+33f1d8bb92813a1bfc23c093c9f443ab09290307" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [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:923055f121b5182466d55868a8b05e67af8ba4a3a3f6bad814e953ca3cd3ac2a" "/opt/rustwide/cargo-home/bin/cargo" "+33f1d8bb92813a1bfc23c093c9f443ab09290307" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] fb9a329ad0cf83388155080a8bfb77e68a805ad9809f8c278cf1cd0941ecdecb [INFO] running `Command { std: "docker" "start" "-a" "fb9a329ad0cf83388155080a8bfb77e68a805ad9809f8c278cf1cd0941ecdecb", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "fb9a329ad0cf83388155080a8bfb77e68a805ad9809f8c278cf1cd0941ecdecb", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "fb9a329ad0cf83388155080a8bfb77e68a805ad9809f8c278cf1cd0941ecdecb", kill_on_drop: false }` [INFO] [stdout] fb9a329ad0cf83388155080a8bfb77e68a805ad9809f8c278cf1cd0941ecdecb [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:923055f121b5182466d55868a8b05e67af8ba4a3a3f6bad814e953ca3cd3ac2a" "/opt/rustwide/cargo-home/bin/cargo" "+33f1d8bb92813a1bfc23c093c9f443ab09290307" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 2e063dfac434c6f0988ce654f9c8cb161ac51bf238ae6926634c32fe5b8f4dd0 [INFO] running `Command { std: "docker" "start" "-a" "2e063dfac434c6f0988ce654f9c8cb161ac51bf238ae6926634c32fe5b8f4dd0", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.86 [INFO] [stderr] Compiling unicode-ident v1.0.12 [INFO] [stderr] Compiling serde v1.0.205 [INFO] [stderr] Compiling autocfg v1.3.0 [INFO] [stderr] Compiling equivalent v1.0.1 [INFO] [stderr] Compiling serde_json v1.0.122 [INFO] [stderr] Compiling thiserror v1.0.63 [INFO] [stderr] Compiling hashbrown v0.14.5 [INFO] [stderr] Compiling iana-time-zone v0.1.60 [INFO] [stderr] Compiling ryu v1.0.18 [INFO] [stderr] Compiling itoa v1.0.11 [INFO] [stderr] Compiling log v0.4.22 [INFO] [stderr] Compiling memchr v2.7.4 [INFO] [stderr] Compiling num-traits v0.2.19 [INFO] [stderr] Compiling env_logger v0.10.2 [INFO] [stderr] Compiling quote v1.0.36 [INFO] [stderr] Compiling indexmap v2.3.0 [INFO] [stderr] Compiling syn v2.0.72 [INFO] [stderr] Compiling serde_derive v1.0.205 [INFO] [stderr] Compiling thiserror-impl v1.0.63 [INFO] [stderr] Compiling chrono v0.4.38 [INFO] [stderr] Compiling ecs-logger v1.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 22.75s [INFO] running `Command { std: "docker" "inspect" "2e063dfac434c6f0988ce654f9c8cb161ac51bf238ae6926634c32fe5b8f4dd0", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "2e063dfac434c6f0988ce654f9c8cb161ac51bf238ae6926634c32fe5b8f4dd0", kill_on_drop: false }` [INFO] [stdout] 2e063dfac434c6f0988ce654f9c8cb161ac51bf238ae6926634c32fe5b8f4dd0 [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:923055f121b5182466d55868a8b05e67af8ba4a3a3f6bad814e953ca3cd3ac2a" "/opt/rustwide/cargo-home/bin/cargo" "+33f1d8bb92813a1bfc23c093c9f443ab09290307" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 9506df3dfb91c1ae576923583bea1cf0bfb5d5265da38208485e6a75a54abc8c [INFO] running `Command { std: "docker" "start" "-a" "9506df3dfb91c1ae576923583bea1cf0bfb5d5265da38208485e6a75a54abc8c", kill_on_drop: false }` [INFO] [stderr] Compiling aho-corasick v1.1.3 [INFO] [stderr] Compiling regex-syntax v0.8.4 [INFO] [stderr] Compiling once_cell v1.19.0 [INFO] [stderr] Compiling regex-automata v0.4.7 [INFO] [stderr] Compiling regex v1.10.6 [INFO] [stderr] Compiling ecs-logger v1.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 14.88s [INFO] running `Command { std: "docker" "inspect" "9506df3dfb91c1ae576923583bea1cf0bfb5d5265da38208485e6a75a54abc8c", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "9506df3dfb91c1ae576923583bea1cf0bfb5d5265da38208485e6a75a54abc8c", kill_on_drop: false }` [INFO] [stdout] 9506df3dfb91c1ae576923583bea1cf0bfb5d5265da38208485e6a75a54abc8c [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:923055f121b5182466d55868a8b05e67af8ba4a3a3f6bad814e953ca3cd3ac2a" "/opt/rustwide/cargo-home/bin/cargo" "+33f1d8bb92813a1bfc23c093c9f443ab09290307" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 948e7c45b35f9d97ae2e238a891798a55d8bb2374f9dec1486b0e45f5a739912 [INFO] running `Command { std: "docker" "start" "-a" "948e7c45b35f9d97ae2e238a891798a55d8bb2374f9dec1486b0e45f5a739912", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.05s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/ecs_logger-b606fd83552020d4) [INFO] [stdout] [INFO] [stdout] running 12 tests [INFO] [stdout] test ecs::tests::test_serialize ... ok [INFO] [stdout] test ecs::tests::test_from_log_record ... ok [INFO] [stdout] test extra_fields::tests::test_extend_json_map ... ok [INFO] [stdout] test extra_fields::tests::test_clear_extra_fields ... ok [INFO] [stdout] test tests::test_format ... ok [INFO] [stdout] test extra_fields::tests::test_set_extra_fields_ok ... ok [INFO] [stdout] test tests::test_init ... ok [INFO] [stdout] test timestamp::tests::test_get_timestamp ... ok [INFO] [stdout] test extra_fields::tests::test_set_extra_fields_err ... ok [INFO] [stdout] test extra_fields::tests::test_merge_extra_fields ... ok [INFO] [stdout] test ecs::tests::test_serialize_with_none ... ok [INFO] [stdout] test tests::test_format_with_extra_fields ... FAILED [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- tests::test_format_with_extra_fields stdout ---- [INFO] [stdout] thread 'tests::test_format_with_extra_fields' panicked at src/lib.rs:289:9: [INFO] [stdout] assertion `left == right` failed [INFO] [stdout] left: "{\"@timestamp\":\"2000-01-23T01:23:45.678901200Z\",\"log.level\":\"ERROR\",\"message\":\"hello world\",\"ecs.version\":\"1.12.1\",\"log.origin\":{\"file\":{\"line\":13,\"name\":\"example.rs\"},\"rust\":{\"target\":\"example\",\"module_path\":\"example::tests\",\"file_path\":\"tests/example.rs\"}},\"b\":{\"d\":3},\"e\":4}\n" [INFO] [stdout] right: "{\"@timestamp\":\"2000-01-23T01:23:45.678901200Z\",\"log.level\":\"ERROR\",\"message\":\"hello world\",\"ecs.version\":\"1.12.1\",\"log.origin\":{\"file\":{\"line\":13,\"name\":\"example.rs\"},\"rust\":{\"target\":\"example\",\"module_path\":\"example::tests\",\"file_path\":\"tests/example.rs\"}},\"a\":1,\"b\":{\"c\":2}}\n" [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x556e057d03d5 - std::backtrace_rs::backtrace::libunwind::trace::h644651cb29d88bb0 [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5 [INFO] [stdout] 1: 0x556e057d03d5 - std::backtrace_rs::backtrace::trace_unsynchronized::h4f227a4714c93f22 [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x556e057d03d5 - std::sys::backtrace::_print_fmt::hfe88767e38ff4b4e [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/std/src/sys/backtrace.rs:66:9 [INFO] [stdout] 3: 0x556e057d03d5 - ::fmt::h0e27af9f1d310e0a [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/std/src/sys/backtrace.rs:39:26 [INFO] [stdout] 4: 0x556e057f71eb - core::fmt::rt::Argument::fmt::h900f10175a69b72e [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/core/src/fmt/rt.rs:173:76 [INFO] [stdout] 5: 0x556e057f71eb - core::fmt::write::h3a97e76bd9b733fa [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/core/src/fmt/mod.rs:1178:21 [INFO] [stdout] 6: 0x556e057cd7ef - std::io::Write::write_fmt::he4611995baa28da3 [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/std/src/io/mod.rs:1823:15 [INFO] [stdout] 7: 0x556e057d1bf1 - std::sys::backtrace::BacktraceLock::print::h52f15558f43bfe2f [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/std/src/sys/backtrace.rs:42:9 [INFO] [stdout] 8: 0x556e057d1bf1 - std::panicking::default_hook::{{closure}}::h77edc81607b06015 [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/std/src/panicking.rs:266:22 [INFO] [stdout] 9: 0x556e057d1798 - std::panicking::default_hook::h4a889c281e863e6e [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/std/src/panicking.rs:290:9 [INFO] [stdout] 10: 0x556e0576e81a - as core::ops::function::Fn>::call::h87ae598a6618f03f [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/alloc/src/boxed.rs:2162:9 [INFO] [stdout] 11: 0x556e0576e81a - test::test_main::{{closure}}::haa35c2695dfcc048 [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/test/src/lib.rs:132:21 [INFO] [stdout] 12: 0x556e057d24ff - as core::ops::function::Fn>::call::h0934a01d4a1cdb06 [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/alloc/src/boxed.rs:2162:9 [INFO] [stdout] 13: 0x556e057d24ff - std::panicking::rust_panic_with_hook::h74d8fff54c965152 [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/std/src/panicking.rs:805:13 [INFO] [stdout] 14: 0x556e057d2127 - std::panicking::begin_panic_handler::{{closure}}::h82b61517a14ab3ae [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/std/src/panicking.rs:671:13 [INFO] [stdout] 15: 0x556e057d0899 - std::sys::backtrace::__rust_end_short_backtrace::h7f24a51d7748d3e4 [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/std/src/sys/backtrace.rs:170:18 [INFO] [stdout] 16: 0x556e057d1db4 - rust_begin_unwind [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/std/src/panicking.rs:662:5 [INFO] [stdout] 17: 0x556e057f5b23 - core::panicking::panic_fmt::h7de3a20d92caa6a2 [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/core/src/panicking.rs:74:14 [INFO] [stdout] 18: 0x556e057f5eee - core::panicking::assert_failed_inner::hb4e1d95e5f1c8b95 [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/core/src/panicking.rs:412:17 [INFO] [stdout] 19: 0x556e056f8f8e - core::panicking::assert_failed::h27eaa7e611b0cf6d [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/core/src/panicking.rs:367:5 [INFO] [stdout] 20: 0x556e0570fd52 - ecs_logger::tests::test_format_with_extra_fields::hae4e08cd778d9393 [INFO] [stdout] at /opt/rustwide/workdir/src/lib.rs:289:9 [INFO] [stdout] 21: 0x556e0570daa7 - ecs_logger::tests::test_format_with_extra_fields::{{closure}}::ha90f439c1eeab0ad [INFO] [stdout] at /opt/rustwide/workdir/src/lib.rs:275:39 [INFO] [stdout] 22: 0x556e056ffc96 - core::ops::function::FnOnce::call_once::h7d8eab43a95fe66f [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 23: 0x556e0577339b - core::ops::function::FnOnce::call_once::h24a6f01be65f4680 [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 24: 0x556e0577339b - test::__rust_begin_short_backtrace::h7c53016b80d5a608 [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/test/src/lib.rs:620:18 [INFO] [stdout] 25: 0x556e05772bb5 - test::run_test_in_process::{{closure}}::hde6a274ce897aaad [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/test/src/lib.rs:643:60 [INFO] [stdout] 26: 0x556e05772bb5 - as core::ops::function::FnOnce<()>>::call_once::hd431ac2f54963786 [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 27: 0x556e05772bb5 - std::panicking::try::do_call::h10362e01a063baa0 [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/std/src/panicking.rs:554:40 [INFO] [stdout] 28: 0x556e05772bb5 - std::panicking::try::h30318180e4290dce [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/std/src/panicking.rs:518:19 [INFO] [stdout] 29: 0x556e05772bb5 - std::panic::catch_unwind::h97d52b1b1f400ecc [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/std/src/panic.rs:345:14 [INFO] [stdout] 30: 0x556e05772bb5 - test::run_test_in_process::haec7bb1f728b765d [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/test/src/lib.rs:643:27 [INFO] [stdout] 31: 0x556e05772bb5 - test::run_test::{{closure}}::ha988a53ee25f80e1 [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/test/src/lib.rs:564:43 [INFO] [stdout] 32: 0x556e05738484 - test::run_test::{{closure}}::hddc4d91f14475af0 [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/test/src/lib.rs:594:41 [INFO] [stdout] 33: 0x556e05738484 - std::sys::backtrace::__rust_begin_short_backtrace::h550bd80387fd32b0 [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/std/src/sys/backtrace.rs:154:18 [INFO] [stdout] 34: 0x556e0573bbb2 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::h0907e6530d89c432 [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/std/src/thread/mod.rs:524:17 [INFO] [stdout] 35: 0x556e0573bbb2 - as core::ops::function::FnOnce<()>>::call_once::h1426168782d20988 [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 36: 0x556e0573bbb2 - std::panicking::try::do_call::h9e10c7df8de701e0 [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/std/src/panicking.rs:554:40 [INFO] [stdout] 37: 0x556e0573bbb2 - std::panicking::try::hc0169bb633716dc9 [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/std/src/panicking.rs:518:19 [INFO] [stdout] 38: 0x556e0573bbb2 - std::panic::catch_unwind::h2d365a7fbba378ff [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/std/src/panic.rs:345:14 [INFO] [stdout] 39: 0x556e0573bbb2 - std::thread::Builder::spawn_unchecked_::{{closure}}::h99b3d5b0eb8d8349 [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/std/src/thread/mod.rs:523:30 [INFO] [stdout] 40: 0x556e0573bbb2 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h785f99837c772588 [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 41: 0x556e057d665b - as core::ops::function::FnOnce>::call_once::h9d8f2204f4fcbe73 [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/alloc/src/boxed.rs:2148:9 [INFO] [stdout] 42: 0x556e057d665b - as core::ops::function::FnOnce>::call_once::h817ffd7b41f007e2 [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/alloc/src/boxed.rs:2148:9 [INFO] [stdout] 43: 0x556e057d665b - std::sys::pal::unix::thread::Thread::new::thread_start::hfffda88b0cd3e69f [INFO] [stdout] at /rustc/33f1d8bb92813a1bfc23c093c9f443ab09290307/library/std/src/sys/pal/unix/thread.rs:105:17 [INFO] [stdout] 44: 0x7fbd3669eac3 - [INFO] [stdout] 45: 0x7fbd3672fa04 - clone [INFO] [stdout] 46: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] tests::test_format_with_extra_fields [INFO] [stdout] [INFO] [stdout] test result: FAILED. 11 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.09s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass `--lib` [INFO] running `Command { std: "docker" "inspect" "948e7c45b35f9d97ae2e238a891798a55d8bb2374f9dec1486b0e45f5a739912", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "948e7c45b35f9d97ae2e238a891798a55d8bb2374f9dec1486b0e45f5a739912", kill_on_drop: false }` [INFO] [stdout] 948e7c45b35f9d97ae2e238a891798a55d8bb2374f9dec1486b0e45f5a739912