[INFO] fetching crate context-logger 0.1.3... [INFO] testing context-logger-0.1.3 against 1.90.0 for beta-1.91-3 [INFO] extracting crate context-logger 0.1.3 into /workspace/builds/worker-1-tc1/source [INFO] started tweaking crates.io crate context-logger 0.1.3 [INFO] removed 0 missing examples [INFO] finished tweaking crates.io crate context-logger 0.1.3 [INFO] tweaked toml for crates.io crate context-logger 0.1.3 written to /workspace/builds/worker-1-tc1/source/Cargo.toml [INFO] validating manifest of crates.io crate context-logger 0.1.3 on toolchain 1.90.0 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.90.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] crate crates.io crate context-logger 0.1.3 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.90.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Updating crates.io index [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded value-bag-sval2 v1.11.1 [INFO] [stderr] Downloaded structured-logger v1.0.4 [INFO] [stderr] Downloaded sval_fmt v2.14.1 [INFO] [stderr] Downloaded sval_json v2.14.1 [INFO] [stderr] Downloaded include-utils-macro v0.2.4 [INFO] [stderr] Downloaded sval_buffer v2.14.1 [INFO] [stderr] Downloaded value-bag-serde1 v1.11.1 [INFO] [stderr] Downloaded sval_nested v2.14.1 [INFO] [stderr] Downloaded manyhow-macros v0.11.4 [INFO] [stderr] Downloaded proc-macro-utils v0.10.0 [INFO] [stderr] Downloaded sval v2.14.1 [INFO] [stderr] Downloaded manyhow v0.11.4 [INFO] [stderr] Downloaded include-utils v0.2.4 [INFO] [stderr] Downloaded serde_fmt v1.0.3 [INFO] [stderr] Downloaded sval_dynamic v2.14.1 [INFO] [stderr] Downloaded sval_serde v2.14.1 [INFO] [stderr] Downloaded sval_ref v2.14.1 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+1.90.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] cb7816eea851632106a8d5183d63b43a77d84d93ffe09a9c3a7415ac67f714e4 [INFO] running `Command { std: "docker" "start" "-a" "cb7816eea851632106a8d5183d63b43a77d84d93ffe09a9c3a7415ac67f714e4", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "cb7816eea851632106a8d5183d63b43a77d84d93ffe09a9c3a7415ac67f714e4", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "cb7816eea851632106a8d5183d63b43a77d84d93ffe09a9c3a7415ac67f714e4", kill_on_drop: false }` [INFO] [stdout] cb7816eea851632106a8d5183d63b43a77d84d93ffe09a9c3a7415ac67f714e4 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-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" "+1.90.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 381dfe45bc8c1b85237f46f8a022a039a0a469fc614eea9d0125f8db9bf8c678 [INFO] running `Command { std: "docker" "start" "-a" "381dfe45bc8c1b85237f46f8a022a039a0a469fc614eea9d0125f8db9bf8c678", kill_on_drop: false }` [INFO] [stderr] Compiling serde v1.0.219 [INFO] [stderr] Compiling syn v2.0.106 [INFO] [stderr] Compiling smallvec v1.15.1 [INFO] [stderr] Compiling itertools v0.13.0 [INFO] [stderr] Compiling proc-macro-utils v0.10.0 [INFO] [stderr] Compiling manyhow-macros v0.11.4 [INFO] [stderr] Compiling manyhow v0.11.4 [INFO] [stderr] Compiling include-utils-macro v0.2.4 [INFO] [stderr] Compiling pin-project-internal v1.1.10 [INFO] [stderr] Compiling erased-serde v0.4.6 [INFO] [stderr] Compiling serde_fmt v1.0.3 [INFO] [stderr] Compiling value-bag-serde1 v1.11.1 [INFO] [stderr] Compiling value-bag v1.11.1 [INFO] [stderr] Compiling include-utils v0.2.4 [INFO] [stderr] Compiling pin-project v1.1.10 [INFO] [stderr] Compiling log v0.4.27 [INFO] [stderr] Compiling context-logger v0.1.3 (/opt/rustwide/workdir) [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/stack.rs:57:16 [INFO] [stdout] | [INFO] [stdout] 57 | pub fn top(&self) -> Option> { [INFO] [stdout] | ^^^^^ ------------------- the same lifetime is hidden here [INFO] [stdout] | | [INFO] [stdout] | the lifetime is elided here [INFO] [stdout] | [INFO] [stdout] = help: the same lifetime is referred to in inconsistent ways, making the signature confusing [INFO] [stdout] = note: `#[warn(mismatched_lifetime_syntaxes)]` on by default [INFO] [stdout] help: use `'_` for type paths [INFO] [stdout] | [INFO] [stdout] 57 | pub fn top(&self) -> Option> { [INFO] [stdout] | +++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/stack.rs:71:20 [INFO] [stdout] | [INFO] [stdout] 71 | pub fn top_mut(&self) -> Option> { [INFO] [stdout] | ^^^^^ ---------------------- the same lifetime is hidden here [INFO] [stdout] | | [INFO] [stdout] | the lifetime is elided here [INFO] [stdout] | [INFO] [stdout] = help: the same lifetime is referred to in inconsistent ways, making the signature confusing [INFO] [stdout] help: use `'_` for type paths [INFO] [stdout] | [INFO] [stdout] 71 | pub fn top_mut(&self) -> Option> { [INFO] [stdout] | +++ [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 8.47s [INFO] running `Command { std: "docker" "inspect" "381dfe45bc8c1b85237f46f8a022a039a0a469fc614eea9d0125f8db9bf8c678", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "381dfe45bc8c1b85237f46f8a022a039a0a469fc614eea9d0125f8db9bf8c678", kill_on_drop: false }` [INFO] [stdout] 381dfe45bc8c1b85237f46f8a022a039a0a469fc614eea9d0125f8db9bf8c678 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-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" "+1.90.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] f42825ec1716192cb564982c46ca7108308ffea3a750983d1644808b636331c1 [INFO] running `Command { std: "docker" "start" "-a" "f42825ec1716192cb564982c46ca7108308ffea3a750983d1644808b636331c1", kill_on_drop: false }` [INFO] [stderr] Compiling serde_derive v1.0.219 [INFO] [stderr] Compiling tokio-macros v2.5.0 [INFO] [stderr] Compiling regex-automata v0.4.10 [INFO] [stderr] Compiling futures-macro v0.3.31 [INFO] [stderr] Compiling diff v0.1.13 [INFO] [stderr] Compiling yansi v1.0.1 [INFO] [stderr] Compiling jiff v0.2.15 [INFO] [stderr] Compiling parking_lot_core v0.9.11 [INFO] [stderr] Compiling anstream v0.6.20 [INFO] [stderr] Compiling futures-core v0.3.31 [INFO] [stderr] Compiling parking_lot v0.12.4 [INFO] [stderr] Compiling pretty_assertions v1.4.1 [INFO] [stderr] Compiling futures-util v0.3.31 [INFO] [stderr] Compiling tokio v1.47.1 [INFO] [stderr] Compiling regex v1.11.2 [INFO] [stderr] Compiling serde v1.0.219 [INFO] [stderr] Compiling erased-serde v0.4.6 [INFO] [stderr] Compiling serde_fmt v1.0.3 [INFO] [stderr] Compiling serde_json v1.0.143 [INFO] [stderr] Compiling value-bag-serde1 v1.11.1 [INFO] [stderr] Compiling value-bag v1.11.1 [INFO] [stderr] Compiling log v0.4.27 [INFO] [stderr] Compiling env_filter v0.1.3 [INFO] [stderr] Compiling structured-logger v1.0.4 [INFO] [stderr] Compiling context-logger v0.1.3 (/opt/rustwide/workdir) [INFO] [stderr] Compiling env_logger v0.11.8 [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/stack.rs:57:16 [INFO] [stdout] | [INFO] [stdout] 57 | pub fn top(&self) -> Option> { [INFO] [stdout] | ^^^^^ ------------------- the same lifetime is hidden here [INFO] [stdout] | | [INFO] [stdout] | the lifetime is elided here [INFO] [stdout] | [INFO] [stdout] = help: the same lifetime is referred to in inconsistent ways, making the signature confusing [INFO] [stdout] = note: `#[warn(mismatched_lifetime_syntaxes)]` on by default [INFO] [stdout] help: use `'_` for type paths [INFO] [stdout] | [INFO] [stdout] 57 | pub fn top(&self) -> Option> { [INFO] [stdout] | +++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/stack.rs:71:20 [INFO] [stdout] | [INFO] [stdout] 71 | pub fn top_mut(&self) -> Option> { [INFO] [stdout] | ^^^^^ ---------------------- the same lifetime is hidden here [INFO] [stdout] | | [INFO] [stdout] | the lifetime is elided here [INFO] [stdout] | [INFO] [stdout] = help: the same lifetime is referred to in inconsistent ways, making the signature confusing [INFO] [stdout] help: use `'_` for type paths [INFO] [stdout] | [INFO] [stdout] 71 | pub fn top_mut(&self) -> Option> { [INFO] [stdout] | +++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/stack.rs:57:16 [INFO] [stdout] | [INFO] [stdout] 57 | pub fn top(&self) -> Option> { [INFO] [stdout] | ^^^^^ ------------------- the same lifetime is hidden here [INFO] [stdout] | | [INFO] [stdout] | the lifetime is elided here [INFO] [stdout] | [INFO] [stdout] = help: the same lifetime is referred to in inconsistent ways, making the signature confusing [INFO] [stdout] = note: `#[warn(mismatched_lifetime_syntaxes)]` on by default [INFO] [stdout] help: use `'_` for type paths [INFO] [stdout] | [INFO] [stdout] 57 | pub fn top(&self) -> Option> { [INFO] [stdout] | +++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/stack.rs:71:20 [INFO] [stdout] | [INFO] [stdout] 71 | pub fn top_mut(&self) -> Option> { [INFO] [stdout] | ^^^^^ ---------------------- the same lifetime is hidden here [INFO] [stdout] | | [INFO] [stdout] | the lifetime is elided here [INFO] [stdout] | [INFO] [stdout] = help: the same lifetime is referred to in inconsistent ways, making the signature confusing [INFO] [stdout] help: use `'_` for type paths [INFO] [stdout] | [INFO] [stdout] 71 | pub fn top_mut(&self) -> Option> { [INFO] [stdout] | +++ [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 20.66s [INFO] running `Command { std: "docker" "inspect" "f42825ec1716192cb564982c46ca7108308ffea3a750983d1644808b636331c1", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "f42825ec1716192cb564982c46ca7108308ffea3a750983d1644808b636331c1", kill_on_drop: false }` [INFO] [stdout] f42825ec1716192cb564982c46ca7108308ffea3a750983d1644808b636331c1 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-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" "+1.90.0" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 24a71b1f60870b19cf1f113bc031310b3eca07506d33565b263ebcee53eb616f [INFO] running `Command { std: "docker" "start" "-a" "24a71b1f60870b19cf1f113bc031310b3eca07506d33565b263ebcee53eb616f", kill_on_drop: false }` [INFO] [stderr] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stderr] --> src/stack.rs:57:16 [INFO] [stderr] | [INFO] [stderr] 57 | pub fn top(&self) -> Option> { [INFO] [stderr] | ^^^^^ ------------------- the same lifetime is hidden here [INFO] [stderr] | | [INFO] [stderr] | the lifetime is elided here [INFO] [stderr] | [INFO] [stderr] = help: the same lifetime is referred to in inconsistent ways, making the signature confusing [INFO] [stderr] = note: `#[warn(mismatched_lifetime_syntaxes)]` on by default [INFO] [stderr] help: use `'_` for type paths [INFO] [stderr] | [INFO] [stderr] 57 | pub fn top(&self) -> Option> { [INFO] [stderr] | +++ [INFO] [stderr] [INFO] [stderr] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stderr] --> src/stack.rs:71:20 [INFO] [stderr] | [INFO] [stderr] 71 | pub fn top_mut(&self) -> Option> { [INFO] [stderr] | ^^^^^ ---------------------- the same lifetime is hidden here [INFO] [stderr] | | [INFO] [stderr] | the lifetime is elided here [INFO] [stderr] | [INFO] [stderr] = help: the same lifetime is referred to in inconsistent ways, making the signature confusing [INFO] [stderr] help: use `'_` for type paths [INFO] [stderr] | [INFO] [stderr] 71 | pub fn top_mut(&self) -> Option> { [INFO] [stderr] | +++ [INFO] [stderr] [INFO] [stderr] warning: `context-logger` (lib) generated 2 warnings [INFO] [stderr] warning: `context-logger` (lib test) generated 2 warnings (2 duplicates) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.12s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/context_logger-6f1e34c68d858012) [INFO] [stdout] [INFO] [stdout] running 9 tests [INFO] [stdout] test future::tests::test_future_with_context ... ok [INFO] [stdout] test future::tests::test_nested_future_with_common_context ... ok [INFO] [stdout] test guard::tests::test_log_context_guard_enter ... ok [INFO] [stdout] test future::tests::test_nested_future_with_different_contexts ... ok [INFO] [stdout] test guard::tests::test_log_context_nested_guards ... ok [INFO] [stdout] test guard::tests::test_log_context_multithread ... ok [INFO] [stdout] test future::tests::test_join_multiple_tasks_single_thread ... ok [INFO] [stderr] Doc-tests context_logger [INFO] [stdout] test future::tests::test_panicked_future ... ok [INFO] [stdout] test future::tests::test_join_multiple_tasks_multi_thread ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.08s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 10 tests [INFO] [stdout] test src/context.rs - context::LogContext::add_record (line 53) ... ok [INFO] [stdout] test src/context.rs - context::LogContext::record (line 27) ... ok [INFO] [stdout] test src/context.rs - context::LogContext::enter (line 86) ... ok [INFO] [stdout] test src/guard.rs - guard::LogContextGuard (line 17) ... ok [INFO] [stdout] test src/lib.rs - (line 58) ... ok [INFO] [stdout] test src/value.rs - value::ContextValue (line 15) ... ok [INFO] [stdout] test src/lib.rs - ContextLogger::default_record (line 135) ... ok [INFO] [stdout] test src/lib.rs - ContextLogger (line 53) ... ok [INFO] [stdout] test src/future.rs - future::FutureExt::in_log_context (line 22) ... ok [INFO] [stdout] test src/lib.rs - (line 25) ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "24a71b1f60870b19cf1f113bc031310b3eca07506d33565b263ebcee53eb616f", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "24a71b1f60870b19cf1f113bc031310b3eca07506d33565b263ebcee53eb616f", kill_on_drop: false }` [INFO] [stdout] 24a71b1f60870b19cf1f113bc031310b3eca07506d33565b263ebcee53eb616f