[INFO] fetching crate flashlog 0.2.3...
[INFO] testing flashlog-0.2.3 against nightly-2024-10-28+rustflags=-Zrandomize-layout for randomize-layout
[INFO] extracting crate flashlog 0.2.3 into /workspace/builds/worker-4-tc2/source
[INFO] validating manifest of crates.io crate flashlog 0.2.3 on toolchain nightly-2024-10-28
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+nightly-2024-10-28" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate flashlog 0.2.3
[INFO] finished tweaking crates.io crate flashlog 0.2.3
[INFO] tweaked toml for crates.io crate flashlog 0.2.3 written to /workspace/builds/worker-4-tc2/source/Cargo.toml
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+nightly-2024-10-28" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]      Locking 108 packages to latest compatible versions
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+nightly-2024-10-28" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:4a844ea9eb2546a2d2c7022eacef16ef2e8229c7fbb2c7d4d55a9ceca922f72d" "/opt/rustwide/cargo-home/bin/cargo" "+nightly-2024-10-28" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] d753370a328d20934e292ff0633a50a24550e21a451abdc58ef8072d9a585332
[INFO] running `Command { std: "docker" "start" "-a" "d753370a328d20934e292ff0633a50a24550e21a451abdc58ef8072d9a585332", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "d753370a328d20934e292ff0633a50a24550e21a451abdc58ef8072d9a585332", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d753370a328d20934e292ff0633a50a24550e21a451abdc58ef8072d9a585332", kill_on_drop: false }`
[INFO] [stdout] d753370a328d20934e292ff0633a50a24550e21a451abdc58ef8072d9a585332
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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 -Zrandomize-layout" "-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:4a844ea9eb2546a2d2c7022eacef16ef2e8229c7fbb2c7d4d55a9ceca922f72d" "/opt/rustwide/cargo-home/bin/cargo" "+nightly-2024-10-28" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] b9cec07ef9efe0c289071db12ee107ca4479b8a4c7c94da46f76b6f767a0c89b
[INFO] running `Command { std: "docker" "start" "-a" "b9cec07ef9efe0c289071db12ee107ca4479b8a4c7c94da46f76b6f767a0c89b", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.89
[INFO] [stderr]    Compiling serde v1.0.214
[INFO] [stderr]    Compiling siphasher v0.3.11
[INFO] [stderr]    Compiling regex-syntax v0.8.5
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling crossbeam-utils v0.8.20
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling rayon-core v1.12.1
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling phf_shared v0.11.2
[INFO] [stderr]    Compiling either v1.13.0
[INFO] [stderr]    Compiling serde_json v1.0.132
[INFO] [stderr]    Compiling itoa v1.0.11
[INFO] [stderr]    Compiling half v2.4.1
[INFO] [stderr]    Compiling memchr v2.7.4
[INFO] [stderr]    Compiling crossbeam-epoch v0.9.18
[INFO] [stderr]    Compiling phf_generator v0.11.2
[INFO] [stderr]    Compiling crossbeam-deque v0.8.5
[INFO] [stderr]    Compiling phf_codegen v0.11.2
[INFO] [stderr]    Compiling anstyle v1.0.9
[INFO] [stderr]    Compiling quote v1.0.37
[INFO] [stderr]    Compiling ryu v1.0.18
[INFO] [stderr]    Compiling ciborium-io v0.2.2
[INFO] [stderr]    Compiling syn v2.0.86
[INFO] [stderr]    Compiling clap_lex v0.7.2
[INFO] [stderr]    Compiling plotters-backend v0.3.7
[INFO] [stderr]    Compiling regex-automata v0.4.8
[INFO] [stderr]    Compiling clap_builder v4.5.20
[INFO] [stderr]    Compiling ciborium-ll v0.2.2
[INFO] [stderr]    Compiling plotters-svg v0.3.7
[INFO] [stderr]    Compiling itertools v0.10.5
[INFO] [stderr]    Compiling bitflags v2.6.0
[INFO] [stderr]    Compiling iana-time-zone v0.1.61
[INFO] [stderr]    Compiling powerfmt v0.2.0
[INFO] [stderr]    Compiling cast v0.3.0
[INFO] [stderr]    Compiling num-conv v0.1.0
[INFO] [stderr]    Compiling same-file v1.0.6
[INFO] [stderr]    Compiling time-core v0.1.2
[INFO] [stderr]    Compiling anyhow v1.0.92
[INFO] [stderr]    Compiling time-macros v0.2.18
[INFO] [stderr]    Compiling walkdir v2.5.0
[INFO] [stderr]    Compiling regex v1.11.1
[INFO] [stderr]    Compiling criterion-plot v0.5.0
[INFO] [stderr]    Compiling parse-zoneinfo v0.3.1
[INFO] [stderr]    Compiling clap v4.5.20
[INFO] [stderr]    Compiling chrono-tz-build v0.4.0
[INFO] [stderr]    Compiling rayon v1.10.0
[INFO] [stderr]    Compiling raw-cpuid v11.2.0
[INFO] [stderr]    Compiling phf v0.11.2
[INFO] [stderr]    Compiling plotters v0.3.7
[INFO] [stderr]    Compiling chrono-tz v0.10.0
[INFO] [stderr]    Compiling serde_derive v1.0.214
[INFO] [stderr]    Compiling is-terminal v0.4.13
[INFO] [stderr]    Compiling oorandom v11.1.4
[INFO] [stderr]    Compiling anes v0.1.6
[INFO] [stderr]    Compiling num_threads v0.1.7
[INFO] [stderr]    Compiling core_affinity v0.8.1
[INFO] [stderr]    Compiling crossbeam-channel v0.5.13
[INFO] [stderr]    Compiling quanta v0.12.3
[INFO] [stderr]    Compiling ciborium v0.2.2
[INFO] [stderr]    Compiling deranged v0.3.11
[INFO] [stderr]    Compiling chrono v0.4.38
[INFO] [stderr]    Compiling tinytemplate v1.2.1
[INFO] [stderr]    Compiling time v0.3.36
[INFO] [stderr]    Compiling criterion v0.5.1
[INFO] [stderr]    Compiling flashlog v0.2.3 (/opt/rustwide/workdir)
[INFO] [stdout] warning: use of deprecated macro `log_trace`: Use flashlog::flash_trace! instead
[INFO] [stdout]    --> src/logger.rs:519:9
[INFO] [stdout]     |
[INFO] [stdout] 519 |         log_trace!("logger", message = "LoggerGuard is dropped");
[INFO] [stdout]     |         ^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(deprecated)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated struct `lazy_string::LazyString`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stdout]   --> src/lazy_string.rs:11:6
[INFO] [stdout]    |
[INFO] [stdout] 11 | impl LazyString {
[INFO] [stdout]    |      ^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated struct `lazy_string::LazyString`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stdout]   --> src/lazy_string.rs:23:16
[INFO] [stdout]    |
[INFO] [stdout] 23 | impl Deref for LazyString {
[INFO] [stdout]    |                ^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated struct `lazy_string::LazyString`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stdout]   --> src/lazy_string.rs:31:20
[INFO] [stdout]    |
[INFO] [stdout] 31 | impl Serialize for LazyString {
[INFO] [stdout]    |                    ^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated struct `lazy_string::LazyString`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stdout]   --> src/lazy_string.rs:41:32
[INFO] [stdout]    |
[INFO] [stdout] 41 | impl<'de> Deserialize<'de> for LazyString {
[INFO] [stdout]    |                                ^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated struct `lazy_string::LazyString`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stdout]   --> src/lazy_string.rs:16:9
[INFO] [stdout]    |
[INFO] [stdout] 16 |         LazyString {
[INFO] [stdout]    |         ^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated struct `lazy_string::LazyString`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stdout]   --> src/lazy_string.rs:47:12
[INFO] [stdout]    |
[INFO] [stdout] 47 |         Ok(LazyString::new(move || s.clone()))
[INFO] [stdout]    |            ^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated field `lazy_string::LazyString::cell`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stdout]   --> src/lazy_string.rs:17:13
[INFO] [stdout]    |
[INFO] [stdout] 17 |             cell: OnceCell::new(),
[INFO] [stdout]    |             ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated field `lazy_string::LazyString::initializer`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stdout]   --> src/lazy_string.rs:18:13
[INFO] [stdout]    |
[INFO] [stdout] 18 |             initializer: Box::new(f),
[INFO] [stdout]    |             ^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated field `lazy_string::LazyString::cell`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stdout]   --> src/lazy_string.rs:27:9
[INFO] [stdout]    |
[INFO] [stdout] 27 |         self.cell.get_or_init(|| (self.initializer)())
[INFO] [stdout]    |         ^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated field `lazy_string::LazyString::initializer`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stdout]   --> src/lazy_string.rs:27:34
[INFO] [stdout]    |
[INFO] [stdout] 27 |         self.cell.get_or_init(|| (self.initializer)())
[INFO] [stdout]    |                                  ^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 21.85s
[INFO] running `Command { std: "docker" "inspect" "b9cec07ef9efe0c289071db12ee107ca4479b8a4c7c94da46f76b6f767a0c89b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b9cec07ef9efe0c289071db12ee107ca4479b8a4c7c94da46f76b6f767a0c89b", kill_on_drop: false }`
[INFO] [stdout] b9cec07ef9efe0c289071db12ee107ca4479b8a4c7c94da46f76b6f767a0c89b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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 -Zrandomize-layout" "-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:4a844ea9eb2546a2d2c7022eacef16ef2e8229c7fbb2c7d4d55a9ceca922f72d" "/opt/rustwide/cargo-home/bin/cargo" "+nightly-2024-10-28" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 561ad346501d6142aefbabb6fa47fd5aa0c115ca70bd221f7a22221efa9b4183
[INFO] running `Command { std: "docker" "start" "-a" "561ad346501d6142aefbabb6fa47fd5aa0c115ca70bd221f7a22221efa9b4183", kill_on_drop: false }`
[INFO] [stdout] warning: use of deprecated macro `log_trace`: Use flashlog::flash_trace! instead
[INFO] [stdout]    --> src/logger.rs:519:9
[INFO] [stdout]     |
[INFO] [stdout] 519 |         log_trace!("logger", message = "LoggerGuard is dropped");
[INFO] [stdout]     |         ^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(deprecated)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated struct `lazy_string::LazyString`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stdout]   --> src/lazy_string.rs:11:6
[INFO] [stdout]    |
[INFO] [stdout] 11 | impl LazyString {
[INFO] [stdout]    |      ^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated struct `lazy_string::LazyString`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stdout]   --> src/lazy_string.rs:23:16
[INFO] [stdout]    |
[INFO] [stdout] 23 | impl Deref for LazyString {
[INFO] [stdout]    |                ^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated struct `lazy_string::LazyString`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stdout]   --> src/lazy_string.rs:31:20
[INFO] [stdout]    |
[INFO] [stdout] 31 | impl Serialize for LazyString {
[INFO] [stdout]    |                    ^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated struct `lazy_string::LazyString`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stdout]   --> src/lazy_string.rs:41:32
[INFO] [stdout]    |
[INFO] [stdout] 41 | impl<'de> Deserialize<'de> for LazyString {
[INFO] [stdout]    |                                ^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated struct `lazy_string::LazyString`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stdout]   --> src/lazy_string.rs:16:9
[INFO] [stdout]    |
[INFO] [stdout] 16 |         LazyString {
[INFO] [stdout]    |         ^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated struct `lazy_string::LazyString`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stdout]   --> src/lazy_string.rs:47:12
[INFO] [stdout]    |
[INFO] [stdout] 47 |         Ok(LazyString::new(move || s.clone()))
[INFO] [stdout]    |            ^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated field `lazy_string::LazyString::cell`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stdout]   --> src/lazy_string.rs:17:13
[INFO] [stdout]    |
[INFO] [stdout] 17 |             cell: OnceCell::new(),
[INFO] [stdout]    |             ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated field `lazy_string::LazyString::initializer`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stdout]   --> src/lazy_string.rs:18:13
[INFO] [stdout]    |
[INFO] [stdout] 18 |             initializer: Box::new(f),
[INFO] [stdout]    |             ^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated field `lazy_string::LazyString::cell`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stdout]   --> src/lazy_string.rs:27:9
[INFO] [stdout]    |
[INFO] [stdout] 27 |         self.cell.get_or_init(|| (self.initializer)())
[INFO] [stdout]    |         ^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated field `lazy_string::LazyString::initializer`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stdout]   --> src/lazy_string.rs:27:34
[INFO] [stdout]    |
[INFO] [stdout] 27 |         self.cell.get_or_init(|| (self.initializer)())
[INFO] [stdout]    |                                  ^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]    Compiling flashlog v0.2.3 (/opt/rustwide/workdir)
[INFO] [stdout] warning: use of deprecated macro `log_trace`: Use flashlog::flash_trace! instead
[INFO] [stdout]    --> src/logger.rs:519:9
[INFO] [stdout]     |
[INFO] [stdout] 519 |         log_trace!("logger", message = "LoggerGuard is dropped");
[INFO] [stdout]     |         ^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(deprecated)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated macro `info`: Use flashlog::flash_info! instead
[INFO] [stdout]    --> src/logger.rs:637:9
[INFO] [stdout]     |
[INFO] [stdout] 637 |         info!("warm up");
[INFO] [stdout]     |         ^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated macro `info`: Use flashlog::flash_info! instead
[INFO] [stdout]    --> src/logger.rs:638:9
[INFO] [stdout]     |
[INFO] [stdout] 638 |         info!("warm up");
[INFO] [stdout]     |         ^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated macro `info`: Use flashlog::flash_info! instead
[INFO] [stdout]    --> src/logger.rs:639:9
[INFO] [stdout]     |
[INFO] [stdout] 639 |         info!("warm up");
[INFO] [stdout]     |         ^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated macro `flushing_log_info`: Use flashlog::flush! instead
[INFO] [stdout]    --> src/logger.rs:661:9
[INFO] [stdout]     |
[INFO] [stdout] 661 |         flushing_log_info!(
[INFO] [stdout]     |         ^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated macro `info`: Use flashlog::flash_info! instead
[INFO] [stdout]    --> src/logger.rs:647:13
[INFO] [stdout]     |
[INFO] [stdout] 647 |             info!("test");
[INFO] [stdout]     |             ^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated struct `lazy_string::LazyString`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stdout]   --> src/lazy_string.rs:11:6
[INFO] [stdout]    |
[INFO] [stdout] 11 | impl LazyString {
[INFO] [stdout]    |      ^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated struct `lazy_string::LazyString`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stdout]   --> src/lazy_string.rs:23:16
[INFO] [stdout]    |
[INFO] [stdout] 23 | impl Deref for LazyString {
[INFO] [stdout]    |                ^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated struct `lazy_string::LazyString`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stdout]   --> src/lazy_string.rs:31:20
[INFO] [stdout]    |
[INFO] [stdout] 31 | impl Serialize for LazyString {
[INFO] [stdout]    |                    ^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated struct `lazy_string::LazyString`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stdout]   --> src/lazy_string.rs:41:32
[INFO] [stdout]    |
[INFO] [stdout] 41 | impl<'de> Deserialize<'de> for LazyString {
[INFO] [stdout]    |                                ^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated struct `lazy_string::LazyString`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stdout]   --> src/lazy_string.rs:16:9
[INFO] [stdout]    |
[INFO] [stdout] 16 |         LazyString {
[INFO] [stdout]    |         ^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated struct `lazy_string::LazyString`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stdout]   --> src/lazy_string.rs:47:12
[INFO] [stdout]    |
[INFO] [stdout] 47 |         Ok(LazyString::new(move || s.clone()))
[INFO] [stdout]    |            ^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated struct `lazy_string::LazyString`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stdout]   --> src/lazy_string.rs:57:27
[INFO] [stdout]    |
[INFO] [stdout] 57 |         let lazy_string = LazyString::new(|| format!("{} {} {}", 1, 2, 3));
[INFO] [stdout]    |                           ^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated field `lazy_string::LazyString::cell`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stdout]   --> src/lazy_string.rs:17:13
[INFO] [stdout]    |
[INFO] [stdout] 17 |             cell: OnceCell::new(),
[INFO] [stdout]    |             ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated field `lazy_string::LazyString::initializer`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stdout]   --> src/lazy_string.rs:18:13
[INFO] [stdout]    |
[INFO] [stdout] 18 |             initializer: Box::new(f),
[INFO] [stdout]    |             ^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated field `lazy_string::LazyString::cell`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stdout]   --> src/lazy_string.rs:27:9
[INFO] [stdout]    |
[INFO] [stdout] 27 |         self.cell.get_or_init(|| (self.initializer)())
[INFO] [stdout]    |         ^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated field `lazy_string::LazyString::initializer`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stdout]   --> src/lazy_string.rs:27:34
[INFO] [stdout]    |
[INFO] [stdout] 27 |         self.cell.get_or_init(|| (self.initializer)())
[INFO] [stdout]    |                                  ^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.27s
[INFO] running `Command { std: "docker" "inspect" "561ad346501d6142aefbabb6fa47fd5aa0c115ca70bd221f7a22221efa9b4183", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "561ad346501d6142aefbabb6fa47fd5aa0c115ca70bd221f7a22221efa9b4183", kill_on_drop: false }`
[INFO] [stdout] 561ad346501d6142aefbabb6fa47fd5aa0c115ca70bd221f7a22221efa9b4183
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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 -Zrandomize-layout" "-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:4a844ea9eb2546a2d2c7022eacef16ef2e8229c7fbb2c7d4d55a9ceca922f72d" "/opt/rustwide/cargo-home/bin/cargo" "+nightly-2024-10-28" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] f119a36707513bb2889cee0f782cfa7e2385a580c5c10e1f0c29a460a0ed6ef4
[INFO] running `Command { std: "docker" "start" "-a" "f119a36707513bb2889cee0f782cfa7e2385a580c5c10e1f0c29a460a0ed6ef4", kill_on_drop: false }`
[INFO] [stderr] warning: use of deprecated macro `log_trace`: Use flashlog::flash_trace! instead
[INFO] [stderr]    --> src/logger.rs:519:9
[INFO] [stderr]     |
[INFO] [stderr] 519 |         log_trace!("logger", message = "LoggerGuard is dropped");
[INFO] [stderr]     |         ^^^^^^^^^
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(deprecated)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated struct `lazy_string::LazyString`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stderr]   --> src/lazy_string.rs:11:6
[INFO] [stderr]    |
[INFO] [stderr] 11 | impl LazyString {
[INFO] [stderr]    |      ^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated struct `lazy_string::LazyString`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stderr]   --> src/lazy_string.rs:23:16
[INFO] [stderr]    |
[INFO] [stderr] 23 | impl Deref for LazyString {
[INFO] [stderr]    |                ^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated struct `lazy_string::LazyString`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stderr]   --> src/lazy_string.rs:31:20
[INFO] [stderr]    |
[INFO] [stderr] 31 | impl Serialize for LazyString {
[INFO] [stderr]    |                    ^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated struct `lazy_string::LazyString`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stderr]   --> src/lazy_string.rs:41:32
[INFO] [stderr]    |
[INFO] [stderr] 41 | impl<'de> Deserialize<'de> for LazyString {
[INFO] [stderr]    |                                ^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated struct `lazy_string::LazyString`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stderr]   --> src/lazy_string.rs:16:9
[INFO] [stderr]    |
[INFO] [stderr] 16 |         LazyString {
[INFO] [stderr]    |         ^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated struct `lazy_string::LazyString`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stderr]   --> src/lazy_string.rs:47:12
[INFO] [stderr]    |
[INFO] [stderr] 47 |         Ok(LazyString::new(move || s.clone()))
[INFO] [stderr]    |            ^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated field `lazy_string::LazyString::cell`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stderr]   --> src/lazy_string.rs:17:13
[INFO] [stderr]    |
[INFO] [stderr] 17 |             cell: OnceCell::new(),
[INFO] [stderr]    |             ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated field `lazy_string::LazyString::initializer`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stderr]   --> src/lazy_string.rs:18:13
[INFO] [stderr]    |
[INFO] [stderr] 18 |             initializer: Box::new(f),
[INFO] [stderr]    |             ^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated field `lazy_string::LazyString::cell`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stderr]   --> src/lazy_string.rs:27:9
[INFO] [stderr]    |
[INFO] [stderr] 27 |         self.cell.get_or_init(|| (self.initializer)())
[INFO] [stderr]    |         ^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated field `lazy_string::LazyString::initializer`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stderr]   --> src/lazy_string.rs:27:34
[INFO] [stderr]    |
[INFO] [stderr] 27 |         self.cell.get_or_init(|| (self.initializer)())
[INFO] [stderr]    |                                  ^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated macro `info`: Use flashlog::flash_info! instead
[INFO] [stderr]    --> src/logger.rs:637:9
[INFO] [stderr]     |
[INFO] [stderr] 637 |         info!("warm up");
[INFO] [stderr]     |         ^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated macro `info`: Use flashlog::flash_info! instead
[INFO] [stderr]    --> src/logger.rs:638:9
[INFO] [stderr]     |
[INFO] [stderr] 638 |         info!("warm up");
[INFO] [stderr]     |         ^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated macro `info`: Use flashlog::flash_info! instead
[INFO] [stderr]    --> src/logger.rs:639:9
[INFO] [stderr]     |
[INFO] [stderr] 639 |         info!("warm up");
[INFO] [stderr]     |         ^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated macro `flushing_log_info`: Use flashlog::flush! instead
[INFO] [stderr]    --> src/logger.rs:661:9
[INFO] [stderr]     |
[INFO] [stderr] 661 |         flushing_log_info!(
[INFO] [stderr]     |         ^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated macro `info`: Use flashlog::flash_info! instead
[INFO] [stderr]    --> src/logger.rs:647:13
[INFO] [stderr]     |
[INFO] [stderr] 647 |             info!("test");
[INFO] [stderr]     |             ^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated struct `lazy_string::LazyString`: now the string interpolation in flash_xxx! macros is inherently lazy
[INFO] [stderr]   --> src/lazy_string.rs:57:27
[INFO] [stderr]    |
[INFO] [stderr] 57 |         let lazy_string = LazyString::new(|| format!("{} {} {}", 1, 2, 3));
[INFO] [stderr]    |                           ^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: `flashlog` (lib) generated 11 warnings
[INFO] [stderr] warning: `flashlog` (lib test) generated 17 warnings (11 duplicates)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.09s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/flashlog-dacb9bc4a19fce98)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test lazy_string::tests::test_lazy_string ... ok
[INFO] [stdout] test logger_v2::tests::test_logger ... ok
[INFO] [stdout] test timer::tests::test_get_unix_nano ... ok
[INFO] [stdout] test timer::tests::test_time_components_from_unix_nano ... ok
[INFO] [stdout] test logger::tests::test_logger ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- logger::tests::test_logger stdout ----
[INFO] [stdout] thread 'logger::tests::test_logger' panicked at src/logger.rs:637:9:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: "Disconnected(..)"
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5706a3776b5a - std::backtrace_rs::backtrace::libunwind::trace::h207520d6e9873551
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5
[INFO] [stdout]    1:     0x5706a3776b5a - std::backtrace_rs::backtrace::trace_unsynchronized::h2ed7433f370e3eca
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x5706a3776b5a - std::sys::backtrace::_print_fmt::h916fac51166b18d7
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/std/src/sys/backtrace.rs:66:9
[INFO] [stdout]    3:     0x5706a3776b5a - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::ha0a4c9b8ce3802e6
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/std/src/sys/backtrace.rs:39:26
[INFO] [stdout]    4:     0x5706a379d573 - core::fmt::rt::Argument::fmt::h4cfc8587d52b3eb5
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/core/src/fmt/rt.rs:177:76
[INFO] [stdout]    5:     0x5706a379d573 - core::fmt::write::h522cc39e5b36ae9f
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/core/src/fmt/mod.rs:1190:21
[INFO] [stdout]    6:     0x5706a3773353 - std::io::Write::write_fmt::h7d3c26752da97734
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/std/src/io/mod.rs:1839:15
[INFO] [stdout]    7:     0x5706a37769a2 - std::sys::backtrace::BacktraceLock::print::h4b9e00b29e9c0942
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/std/src/sys/backtrace.rs:42:9
[INFO] [stdout]    8:     0x5706a3777fea - std::panicking::default_hook::{{closure}}::hb59b88280d0324d9
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/std/src/panicking.rs:268:22
[INFO] [stdout]    9:     0x5706a3777df4 - std::panicking::default_hook::he1dd496665be4a29
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/std/src/panicking.rs:292:9
[INFO] [stdout]   10:     0x5706a36dca19 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h4ff71de18744e1dc
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/alloc/src/boxed.rs:2468:9
[INFO] [stdout]   11:     0x5706a36dca19 - test::test_main::{{closure}}::hcf7c055ce117aa81
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/test/src/lib.rs:133:21
[INFO] [stdout]   12:     0x5706a37786e8 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h1d66c6bbd60c9692
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/alloc/src/boxed.rs:2468:9
[INFO] [stdout]   13:     0x5706a37786e8 - std::panicking::rust_panic_with_hook::h2ff17fe8f26dfcf8
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/std/src/panicking.rs:809:13
[INFO] [stdout]   14:     0x5706a37784aa - std::panicking::begin_panic_handler::{{closure}}::h4fad77951c07e101
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/std/src/panicking.rs:674:13
[INFO] [stdout]   15:     0x5706a3777039 - std::sys::backtrace::__rust_end_short_backtrace::hb1a25b3da5d0ea08
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/std/src/sys/backtrace.rs:170:18
[INFO] [stdout]   16:     0x5706a377813c - rust_begin_unwind
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/std/src/panicking.rs:665:5
[INFO] [stdout]   17:     0x5706a379bf70 - core::panicking::panic_fmt::ha9db07b529f9b256
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/core/src/panicking.rs:75:14
[INFO] [stdout]   18:     0x5706a379c3b6 - core::result::unwrap_failed::h5e8218e4d4338b8a
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/core/src/result.rs:1698:5
[INFO] [stdout]   19:     0x5706a36800d8 - core::result::Result<T,E>::unwrap::h153e8bd301b72d8d
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/core/src/result.rs:1103:23
[INFO] [stdout]   20:     0x5706a36800d8 - flashlog::logger::tests::test_logger::h15aa72d34f21e540
[INFO] [stdout]                                at /opt/rustwide/workdir/src/logger.rs:378:13
[INFO] [stdout]   21:     0x5706a367fc07 - flashlog::logger::tests::test_logger::{{closure}}::ha827d6c48d44ddac
[INFO] [stdout]                                at /opt/rustwide/workdir/src/logger.rs:629:25
[INFO] [stdout]   22:     0x5706a3690ae6 - core::ops::function::FnOnce::call_once::h56bd1263021976c1
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   23:     0x5706a36e12eb - core::ops::function::FnOnce::call_once::h22c3ba5715e93f05
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x5706a36e12eb - test::__rust_begin_short_backtrace::h8e82d8113d0da17f
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/test/src/lib.rs:621:18
[INFO] [stdout]   25:     0x5706a36e0c67 - test::run_test_in_process::{{closure}}::h33235f4f20b7b7c7
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/test/src/lib.rs:644:60
[INFO] [stdout]   26:     0x5706a36e0c67 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hb5043206310c586f
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   27:     0x5706a36e0c67 - std::panicking::try::do_call::h9ad4731a60ab23e2
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/std/src/panicking.rs:557:40
[INFO] [stdout]   28:     0x5706a36e0c67 - std::panicking::try::h3824d23db772a716
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/std/src/panicking.rs:520:19
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] [stdout]   29:     0x5706a36e0c67 - std::panic::catch_unwind::h5afd514605fde46b
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/std/src/panic.rs:358:14
[INFO] [stdout]   30:     0x5706a36e0c67 - test::run_test_in_process::h0d5cbfa7067d1720
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/test/src/lib.rs:644:27
[INFO] [stdout]   31:     0x5706a36e0c67 - test::run_test::{{closure}}::h708eb8872708115d
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/test/src/lib.rs:565:43
[INFO] [stdout]   32:     0x5706a36a4384 - test::run_test::{{closure}}::h392c51cee94713ab
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/test/src/lib.rs:595:41
[INFO] [stdout]   33:     0x5706a36a4384 - std::sys::backtrace::__rust_begin_short_backtrace::h2f40290710935a8b
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/std/src/sys/backtrace.rs:154:18
[INFO] [stdout]   34:     0x5706a36a7b2e - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::h3fd968d89053a903
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/std/src/thread/mod.rs:541:17
[INFO] [stdout]   35:     0x5706a36a7b2e - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h743f637ba4229880
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   36:     0x5706a36a7b2e - std::panicking::try::do_call::h07440897322525a6
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/std/src/panicking.rs:557:40
[INFO] [stdout]   37:     0x5706a36a7b2e - std::panicking::try::he5a2e00188156637
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/std/src/panicking.rs:520:19
[INFO] [stdout]   38:     0x5706a36a7b2e - std::panic::catch_unwind::hbaf3cae49b3c6433
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/std/src/panic.rs:358:14
[INFO] [stdout]   39:     0x5706a36a7b2e - std::thread::Builder::spawn_unchecked_::{{closure}}::h8e141ea224820bce
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/std/src/thread/mod.rs:540:30
[INFO] [stdout]   40:     0x5706a36a7b2e - core::ops::function::FnOnce::call_once{{vtable.shim}}::h90d312fedd7b8ea8
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x5706a377c7bb - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h69aa08ddb6adb8b6
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/alloc/src/boxed.rs:2454:9
[INFO] [stdout]   42:     0x5706a377c7bb - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h5aa36efdb79c806f
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/alloc/src/boxed.rs:2454:9
[INFO] [stdout]   43:     0x5706a377c7bb - std::sys::pal::unix::thread::Thread::new::thread_start::h6cd80a1b4be5158d
[INFO] [stdout]                                at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/std/src/sys/pal/unix/thread.rs:105:17
[INFO] [stdout]   44:     0x71716ba0aac3 - <unknown>
[INFO] [stdout]   45:     0x71716ba9ba04 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     logger::tests::test_logger
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 4 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "f119a36707513bb2889cee0f782cfa7e2385a580c5c10e1f0c29a460a0ed6ef4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f119a36707513bb2889cee0f782cfa7e2385a580c5c10e1f0c29a460a0ed6ef4", kill_on_drop: false }`
[INFO] [stdout] f119a36707513bb2889cee0f782cfa7e2385a580c5c10e1f0c29a460a0ed6ef4
