[INFO] fetching crate ulogger 0.1.0...
[INFO] testing ulogger-0.1.0 against 1.100.0-beta.1+cargoflags=--release for beta-release-1.100-2
[INFO] extracting crate ulogger 0.1.0 into /workspace/builds/worker-0-tc2/source
[INFO] started tweaking crates.io crate ulogger 0.1.0
[INFO] removed 0 missing examples
[INFO] finished tweaking crates.io crate ulogger 0.1.0
[INFO] tweaked toml for crates.io crate ulogger 0.1.0 written to /workspace/builds/worker-0-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate ulogger 0.1.0 on toolchain 1.100.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate ulogger 0.1.0 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr] warning: `package.homepage` is redundant with `package.repository`
[INFO] [stderr]   --> Cargo.toml:30:12
[INFO] [stderr]    |
[INFO] [stderr] 30 | homepage = "https://github.com/userx007/uRustLogger"
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 35 | repository = "https://github.com/userx007/uRustLogger"
[INFO] [stderr]    |              -----------------------------------------
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::redundant_homepage` is set to `warn` by default
[INFO] [stderr] help: consider removing `package.homepage`
[INFO] [stderr] warning: `ulogger` (manifest) generated 1 warning
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:77db811e55d90add9212f6832c23229e3de5f1c1f9905e8cb07319ea15df73ac" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 50c1ebe71b0097ce7cd912bcee9a476d8208d1fb0c4fef05ded04cb4d6ee9d40
[INFO] running `Command { std: "docker" "start" "50c1ebe71b0097ce7cd912bcee9a476d8208d1fb0c4fef05ded04cb4d6ee9d40", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "50c1ebe71b0097ce7cd912bcee9a476d8208d1fb0c4fef05ded04cb4d6ee9d40", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-w" "/opt/rustwide/workdir" "--user" "0:0" "50c1ebe71b0097ce7cd912bcee9a476d8208d1fb0c4fef05ded04cb4d6ee9d40" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "50c1ebe71b0097ce7cd912bcee9a476d8208d1fb0c4fef05ded04cb4d6ee9d40", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "50c1ebe71b0097ce7cd912bcee9a476d8208d1fb0c4fef05ded04cb4d6ee9d40" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr] warning: `package.homepage` is redundant with `package.repository`
[INFO] [stderr]   --> Cargo.toml:30:12
[INFO] [stderr]    |
[INFO] [stderr] 30 | homepage = "https://github.com/userx007/uRustLogger"
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 35 | repository = "https://github.com/userx007/uRustLogger"
[INFO] [stderr]    |              -----------------------------------------
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::redundant_homepage` is set to `warn` by default
[INFO] [stderr] help: consider removing `package.homepage`
[INFO] [stderr] warning: `ulogger` (manifest) generated 1 warning
[INFO] [stderr]    Compiling autocfg v1.5.0
[INFO] [stderr]    Compiling iana-time-zone v0.1.64
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling chrono v0.4.42
[INFO] [stderr]    Compiling ulogger v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 4.52s
[INFO] running `Command { std: "docker" "inspect" "50c1ebe71b0097ce7cd912bcee9a476d8208d1fb0c4fef05ded04cb4d6ee9d40", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "50c1ebe71b0097ce7cd912bcee9a476d8208d1fb0c4fef05ded04cb4d6ee9d40" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr] warning: `package.homepage` is redundant with `package.repository`
[INFO] [stderr]   --> Cargo.toml:30:12
[INFO] [stderr]    |
[INFO] [stderr] 30 | homepage = "https://github.com/userx007/uRustLogger"
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 35 | repository = "https://github.com/userx007/uRustLogger"
[INFO] [stderr]    |              -----------------------------------------
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::redundant_homepage` is set to `warn` by default
[INFO] [stderr] help: consider removing `package.homepage`
[INFO] [stderr] warning: `ulogger` (manifest) generated 1 warning
[INFO] [stderr]    Compiling ulogger v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 0.92s
[INFO] running `Command { std: "docker" "inspect" "50c1ebe71b0097ce7cd912bcee9a476d8208d1fb0c4fef05ded04cb4d6ee9d40", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "50c1ebe71b0097ce7cd912bcee9a476d8208d1fb0c4fef05ded04cb4d6ee9d40" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--release", kill_on_drop: false }`
[INFO] [stderr] warning: `package.homepage` is redundant with `package.repository`
[INFO] [stderr]   --> Cargo.toml:30:12
[INFO] [stderr]    |
[INFO] [stderr] 30 | homepage = "https://github.com/userx007/uRustLogger"
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 35 | repository = "https://github.com/userx007/uRustLogger"
[INFO] [stderr]    |              -----------------------------------------
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::redundant_homepage` is set to `warn` by default
[INFO] [stderr] help: consider removing `package.homepage`
[INFO] [stderr] warning: `ulogger` (manifest) generated 1 warning
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 0.04s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/build/ulogger/d6bb6a0386fe4a32/out/ulogger-d6bb6a0386fe4a32)
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test tests::test_hex_logging ... ok
[INFO] [stdout] test tests::test_file_logging_with_icons ... FAILED
[INFO] [stdout] test tests::test_log_levels ... FAILED
[INFO] [stdout] test tests::test_module_name_in_file_output ... FAILED
[INFO] [stdout] test tests::test_module_empty_when_not_set ... FAILED
[INFO] [stdout] test tests::test_module_name_in_output_console ... FAILED
[INFO] [stdout] test tests::test_basic_logging ... FAILED
[INFO] [stdout] test tests::test_file_logging_creates_file ... FAILED
[INFO] [stdout] test tests::test_pointer_logging ... FAILED
[INFO] [stdout] test tests::test_logging_all_types ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- tests::test_file_logging_with_icons stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'tests::test_file_logging_with_icons' (283) panicked at src/lib.rs:200:22:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5e9133c96461 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5e9133caa62a - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    2:     0x5e9133c9a67c - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5e9133c71d86 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5e9133c8e189 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]    5:     0x5e9133c20180 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]    6:     0x5e9133c8e342 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5e9133c71e32 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5e9133c6a909 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5e9133c72a3d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]   10:     0x5e9133caad8c - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5e9133caab62 - core[a373ad73a504971]::result::unwrap_failed
[INFO] [stdout]   12:     0x5e9133c12b2b - <ulogger[13b891b64d28583c]::Logger>::enable_file_logging
[INFO] [stdout]   13:     0x5e9133c0bd06 - <ulogger[13b891b64d28583c]::tests::test_file_logging_with_icons::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x5e9133c135cb - test[aada8e7e76ba119b]::__rust_begin_short_backtrace::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]   15:     0x5e9133c207a5 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]   16:     0x5e9133c1a094 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]   17:     0x5e9133c23832 - <std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   18:     0x5e9133c9564f - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   19:     0x73af8904adfa - <unknown>
[INFO] [stdout]   20:     0x73af890de3d4 - clone
[INFO] [stdout]   21:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- tests::test_log_levels stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'tests::test_log_levels' (285) panicked at src/lib.rs:445:40:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: PoisonError { .. }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5e9133c96461 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5e9133caa62a - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    2:     0x5e9133c9a67c - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5e9133c71d86 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5e9133c8e189 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]    5:     0x5e9133c20180 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]    6:     0x5e9133c8e342 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5e9133c71e32 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5e9133c6a909 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5e9133c72a3d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]   10:     0x5e9133caad8c - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5e9133caab62 - core[a373ad73a504971]::result::unwrap_failed
[INFO] [stdout]   12:     0x5e9133c09ce2 - ulogger[13b891b64d28583c]::tests::reset_logger
[INFO] [stdout]   13:     0x5e9133c0a5d6 - <ulogger[13b891b64d28583c]::tests::test_log_levels::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x5e9133c135cb - test[aada8e7e76ba119b]::__rust_begin_short_backtrace::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]   15:     0x5e9133c207a5 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]   16:     0x5e9133c1a094 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]   17:     0x5e9133c23832 - <std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   18:     0x5e9133c9564f - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   19:     0x73af8904adfa - <unknown>
[INFO] [stdout]   20:     0x73af890de3d4 - clone
[INFO] [stdout]   21:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- tests::test_module_name_in_file_output stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'tests::test_module_name_in_file_output' (288) panicked at src/lib.rs:445:40:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: PoisonError { .. }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5e9133c96461 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5e9133caa62a - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    2:     0x5e9133c9a67c - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5e9133c71d86 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5e9133c8e189 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]    5:     0x5e9133c20180 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]    6:     0x5e9133c8e342 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5e9133c71e32 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5e9133c6a909 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5e9133c72a3d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]   10:     0x5e9133caad8c - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5e9133caab62 - core[a373ad73a504971]::result::unwrap_failed
[INFO] [stdout]   12:     0x5e9133c09ce2 - ulogger[13b891b64d28583c]::tests::reset_logger
[INFO] [stdout]   13:     0x5e9133c0cf26 - <ulogger[13b891b64d28583c]::tests::test_module_name_in_file_output::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x5e9133c135cb - test[aada8e7e76ba119b]::__rust_begin_short_backtrace::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]   15:     0x5e9133c207a5 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]   16:     0x5e9133c1a094 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]   17:     0x5e9133c23832 - <std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   18:     0x5e9133c9564f - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   19:     0x73af8904adfa - <unknown>
[INFO] [stdout]   20:     0x73af890de3d4 - clone
[INFO] [stdout]   21:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- tests::test_module_empty_when_not_set stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'tests::test_module_empty_when_not_set' (287) panicked at src/lib.rs:445:40:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: PoisonError { .. }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5e9133c96461 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5e9133caa62a - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    2:     0x5e9133c9a67c - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5e9133c71d86 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5e9133c8e189 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]    5:     0x5e9133c20180 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]    6:     0x5e9133c8e342 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5e9133c71e32 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5e9133c6a909 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5e9133c72a3d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]   10:     0x5e9133caad8c - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5e9133caab62 - core[a373ad73a504971]::result::unwrap_failed
[INFO] [stdout]   12:     0x5e9133c09ce2 - ulogger[13b891b64d28583c]::tests::reset_logger
[INFO] [stdout]   13:     0x5e9133c0c846 - <ulogger[13b891b64d28583c]::tests::test_module_empty_when_not_set::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x5e9133c135cb - test[aada8e7e76ba119b]::__rust_begin_short_backtrace::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]   15:     0x5e9133c207a5 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]   16:     0x5e9133c1a094 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]   17:     0x5e9133c23832 - <std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   18:     0x5e9133c9564f - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   19:     0x73af8904adfa - <unknown>
[INFO] [stdout]   20:     0x73af890de3d4 - clone
[INFO] [stdout]   21:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- tests::test_module_name_in_output_console stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'tests::test_module_name_in_output_console' (289) panicked at src/lib.rs:445:40:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: PoisonError { .. }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5e9133c96461 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5e9133caa62a - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    2:     0x5e9133c9a67c - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5e9133c71d86 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5e9133c8e189 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]    5:     0x5e9133c20180 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]    6:     0x5e9133c8e342 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5e9133c71e32 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5e9133c6a909 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5e9133c72a3d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]   10:     0x5e9133caad8c - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5e9133caab62 - core[a373ad73a504971]::result::unwrap_failed
[INFO] [stdout]   12:     0x5e9133c09ce2 - ulogger[13b891b64d28583c]::tests::reset_logger
[INFO] [stdout]   13:     0x5e9133c0d656 - <ulogger[13b891b64d28583c]::tests::test_module_name_in_output_console::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x5e9133c135cb - test[aada8e7e76ba119b]::__rust_begin_short_backtrace::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]   15:     0x5e9133c207a5 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]   16:     0x5e9133c1a094 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]   17:     0x5e9133c23832 - <std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   18:     0x5e9133c9564f - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   19:     0x73af8904adfa - <unknown>
[INFO] [stdout]   20:     0x73af890de3d4 - clone
[INFO] [stdout]   21:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- tests::test_basic_logging stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'tests::test_basic_logging' (281) panicked at src/lib.rs:445:40:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: PoisonError { .. }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5e9133c96461 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5e9133caa62a - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    2:     0x5e9133c9a67c - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5e9133c71d86 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5e9133c8e189 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]    5:     0x5e9133c20180 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]    6:     0x5e9133c8e342 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5e9133c71e32 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5e9133c6a909 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5e9133c72a3d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]   10:     0x5e9133caad8c - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5e9133caab62 - core[a373ad73a504971]::result::unwrap_failed
[INFO] [stdout]   12:     0x5e9133c09ce2 - ulogger[13b891b64d28583c]::tests::reset_logger
[INFO] [stdout]   13:     0x5e9133c0afd6 - <ulogger[13b891b64d28583c]::tests::test_basic_logging::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x5e9133c135cb - test[aada8e7e76ba119b]::__rust_begin_short_backtrace::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]   15:     0x5e9133c207a5 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]   16:     0x5e9133c1a094 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]   17:     0x5e9133c23832 - <std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   18:     0x5e9133c9564f - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   19:     0x73af8904adfa - <unknown>
[INFO] [stdout]   20:     0x73af890de3d4 - clone
[INFO] [stdout]   21:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- tests::test_file_logging_creates_file stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'tests::test_file_logging_creates_file' (282) panicked at src/lib.rs:445:40:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: PoisonError { .. }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5e9133c96461 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5e9133caa62a - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    2:     0x5e9133c9a67c - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5e9133c71d86 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5e9133c8e189 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]    5:     0x5e9133c20180 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]    6:     0x5e9133c8e342 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5e9133c71e32 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5e9133c6a909 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5e9133c72a3d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]   10:     0x5e9133caad8c - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5e9133caab62 - core[a373ad73a504971]::result::unwrap_failed
[INFO] [stdout]   12:     0x5e9133c09ce2 - ulogger[13b891b64d28583c]::tests::reset_logger
[INFO] [stdout]   13:     0x5e9133c0c259 - <ulogger[13b891b64d28583c]::tests::test_file_logging_creates_file::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x5e9133c135cb - test[aada8e7e76ba119b]::__rust_begin_short_backtrace::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]   15:     0x5e9133c207a5 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]   16:     0x5e9133c1a094 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]   17:     0x5e9133c23832 - <std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   18:     0x5e9133c9564f - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   19:     0x73af8904adfa - <unknown>
[INFO] [stdout]   20:     0x73af890de3d4 - clone
[INFO] [stdout]   21:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- tests::test_pointer_logging stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'tests::test_pointer_logging' (290) panicked at src/lib.rs:445:40:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: PoisonError { .. }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5e9133c96461 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5e9133caa62a - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    2:     0x5e9133c9a67c - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5e9133c71d86 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5e9133c8e189 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]    5:     0x5e9133c20180 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]    6:     0x5e9133c8e342 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5e9133c71e32 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5e9133c6a909 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5e9133c72a3d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]   10:     0x5e9133caad8c - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5e9133caab62 - core[a373ad73a504971]::result::unwrap_failed
[INFO] [stdout]   12:     0x5e9133c09ce2 - ulogger[13b891b64d28583c]::tests::reset_logger
[INFO] [stdout]   13:     0x5e9133c0b3b6 - <ulogger[13b891b64d28583c]::tests::test_pointer_logging::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x5e9133c135cb - test[aada8e7e76ba119b]::__rust_begin_short_backtrace::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]   15:     0x5e9133c207a5 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]   16:     0x5e9133c1a094 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]   17:     0x5e9133c23832 - <std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   18:     0x5e9133c9564f - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   19:     0x73af8904adfa - <unknown>
[INFO] [stdout]   20:     0x73af890de3d4 - clone
[INFO] [stdout]   21:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- tests::test_logging_all_types stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'tests::test_logging_all_types' (286) panicked at src/lib.rs:445:40:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: PoisonError { .. }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5e9133c96461 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5e9133caa62a - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    2:     0x5e9133c9a67c - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5e9133c71d86 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5e9133c8e189 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]    5:     0x5e9133c20180 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]    6:     0x5e9133c8e342 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5e9133c71e32 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5e9133c6a909 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5e9133c72a3d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]   10:     0x5e9133caad8c - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5e9133caab62 - core[a373ad73a504971]::result::unwrap_failed
[INFO] [stdout]   12:     0x5e9133c09ce2 - ulogger[13b891b64d28583c]::tests::reset_logger
[INFO] [stdout]   13:     0x5e9133c0b786 - <ulogger[13b891b64d28583c]::tests::test_logging_all_types::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x5e9133c135cb - test[aada8e7e76ba119b]::__rust_begin_short_backtrace::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]   15:     0x5e9133c207a5 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]   16:     0x5e9133c1a094 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]   17:     0x5e9133c23832 - <std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   18:     0x5e9133c9564f - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   19:     0x73af8904adfa - <unknown>
[INFO] [stdout]   20:     0x73af890de3d4 - clone
[INFO] [stdout]   21:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     tests::test_basic_logging
[INFO] [stdout]     tests::test_file_logging_creates_file
[INFO] [stdout]     tests::test_file_logging_with_icons
[INFO] [stdout]     tests::test_log_levels
[INFO] [stdout]     tests::test_logging_all_types
[INFO] [stdout]     tests::test_module_empty_when_not_set
[INFO] [stdout]     tests::test_module_name_in_file_output
[INFO] [stdout]     tests::test_module_name_in_output_console
[INFO] [stdout]     tests::test_pointer_logging
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 1 passed; 9 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "50c1ebe71b0097ce7cd912bcee9a476d8208d1fb0c4fef05ded04cb4d6ee9d40", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "50c1ebe71b0097ce7cd912bcee9a476d8208d1fb0c4fef05ded04cb4d6ee9d40", kill_on_drop: false }`
[INFO] [stdout] 50c1ebe71b0097ce7cd912bcee9a476d8208d1fb0c4fef05ded04cb4d6ee9d40
