[INFO] fetching crate mt_logger 3.0.2... [INFO] testing mt_logger-3.0.2 against try#b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b for pr-145330-1 [INFO] extracting crate mt_logger 3.0.2 into /workspace/builds/worker-1-tc2/source [INFO] started tweaking crates.io crate mt_logger 3.0.2 [INFO] finished tweaking crates.io crate mt_logger 3.0.2 [INFO] tweaked toml for crates.io crate mt_logger 3.0.2 written to /workspace/builds/worker-1-tc2/source/Cargo.toml [INFO] validating manifest of crates.io crate mt_logger 3.0.2 on toolchain b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Updating crates.io index [INFO] [stderr] Locking 38 packages to latest compatible versions [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] fce7754835981cb536fed7ce9c02b4fe25d1c0d66dcd05bfe9f04c73f61b11b9 [INFO] running `Command { std: "docker" "start" "-a" "fce7754835981cb536fed7ce9c02b4fe25d1c0d66dcd05bfe9f04c73f61b11b9", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "fce7754835981cb536fed7ce9c02b4fe25d1c0d66dcd05bfe9f04c73f61b11b9", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "fce7754835981cb536fed7ce9c02b4fe25d1c0d66dcd05bfe9f04c73f61b11b9", kill_on_drop: false }` [INFO] [stdout] fce7754835981cb536fed7ce9c02b4fe25d1c0d66dcd05bfe9f04c73f61b11b9 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 3ec407be376b7a1efd41621ba7955327264754f32497a78b93675f74c35726f1 [INFO] running `Command { std: "docker" "start" "-a" "3ec407be376b7a1efd41621ba7955327264754f32497a78b93675f74c35726f1", kill_on_drop: false }` [INFO] [stderr] Compiling num-traits v0.2.19 [INFO] [stderr] Compiling chrono v0.4.42 [INFO] [stderr] Compiling mt_logger v3.0.2 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 3.83s [INFO] running `Command { std: "docker" "inspect" "3ec407be376b7a1efd41621ba7955327264754f32497a78b93675f74c35726f1", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "3ec407be376b7a1efd41621ba7955327264754f32497a78b93675f74c35726f1", kill_on_drop: false }` [INFO] [stdout] 3ec407be376b7a1efd41621ba7955327264754f32497a78b93675f74c35726f1 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 07abf3dced2b6d7308476dbdbb5a101b8105b5c67dd0395f908dfe85fddb822c [INFO] running `Command { std: "docker" "start" "-a" "07abf3dced2b6d7308476dbdbb5a101b8105b5c67dd0395f908dfe85fddb822c", kill_on_drop: false }` [INFO] [stderr] Compiling aho-corasick v1.1.3 [INFO] [stderr] Compiling regex-automata v0.4.11 [INFO] [stderr] Compiling regex v1.11.3 [INFO] [stderr] Compiling mt_logger v3.0.2 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 9.71s [INFO] running `Command { std: "docker" "inspect" "07abf3dced2b6d7308476dbdbb5a101b8105b5c67dd0395f908dfe85fddb822c", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "07abf3dced2b6d7308476dbdbb5a101b8105b5c67dd0395f908dfe85fddb822c", kill_on_drop: false }` [INFO] [stdout] 07abf3dced2b6d7308476dbdbb5a101b8105b5c67dd0395f908dfe85fddb822c [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 46e5bde6f9ce77ecf7c5e9800a8ca08a8ff827a382e98ec7e03d7d60828e12e0 [INFO] running `Command { std: "docker" "start" "-a" "46e5bde6f9ce77ecf7c5e9800a8ca08a8ff827a382e98ec7e03d7d60828e12e0", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.04s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/mt_logger-663bcc960a932a43) [INFO] [stdout] [INFO] [stdout] running 3 tests [INFO] [stdout] test tests::outputstream_verification ... FAILED [INFO] [stdout] test tests::flush_test ... FAILED [INFO] [stdout] test tests::format_verification ... FAILED [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- tests::outputstream_verification stdout ---- [INFO] [stdout] 2025-10-02T03:21:30.144152604: Entered LogReceiver thread. [INFO] [stdout] Flushing all messages to their output... [INFO] [stdout] [INFO] [stdout] thread 'log_receiver' (20) panicked at src/receiver.rs:122:27: [INFO] [stdout] Failed to create logs directory. Error: Read-only file system (os error 30) [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x649708582422 - std::backtrace_rs::backtrace::libunwind::trace::hc4a5f428cfb78751 [INFO] [stdout] at /rustc/b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stdout] 1: 0x649708582422 - std::backtrace_rs::backtrace::trace_unsynchronized::h20e1095684b4c296 [INFO] [stdout] at /rustc/b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stdout] 2: 0x649708582422 - std::sys::backtrace::_print_fmt::h461f2e3a8f6b29e2 [INFO] [stdout] at /rustc/b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b/library/std/src/sys/backtrace.rs:66:9 [INFO] [stdout] 3: 0x649708582422 - ::fmt::h4ee3a75aa71a2c45 [INFO] [stdout] at /rustc/b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b/library/std/src/sys/backtrace.rs:39:26 [INFO] [stdout] 4: 0x6497085a659f - core::fmt::rt::Argument::fmt::h6f1564705cd089af [INFO] [stdout] at /rustc/b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b/library/core/src/fmt/rt.rs:173:76 [INFO] [stdout] 5: 0x6497085a659f - core::fmt::write::h21ca93b65a7c281a [INFO] [stdout] at /rustc/b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b/library/core/src/fmt/mod.rs:1468:25 [INFO] [stdout] 6: 0x64970856efe3 - std::io::default_write_fmt::h6f3360f4711e9130 [INFO] [stdout] at /rustc/b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b/library/std/src/io/mod.rs:639:11 [INFO] [stdout] 7: 0x64970856efe3 - std::io::Write::write_fmt::hf4539125c0e0bc30 [INFO] [stdout] at /rustc/b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b/library/std/src/io/mod.rs:1954:13 [INFO] [stdout] 8: 0x649708582a32 - std::sys::backtrace::BacktraceLock::print::h58d5d73f9e953cf1 [INFO] [stdout] at /rustc/b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b/library/std/src/sys/backtrace.rs:42:9 [INFO] [stdout] 9: 0x64970856d5fc - std::panicking::default_hook::{{closure}}::h1457fbe47c9457d1 [INFO] [stdout] at /rustc/b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b/library/std/src/panicking.rs:301:27 [INFO] [stdout] 10: 0x64970856d474 - std::panicking::default_hook::hccb5e73b206c0830 [INFO] [stdout] at /rustc/b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b/library/std/src/panicking.rs:325:9 [INFO] [stdout] 11: 0x6497082650be - as core::ops::function::Fn>::call::h04940a86aa899793 [INFO] [stdout] at /rustc/b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b/library/alloc/src/boxed.rs:1985:9 [INFO] [stdout] 12: 0x6497082650be - test::test_main_with_exit_callback::{{closure}}::hca6cc295403b83e8 [INFO] [stdout] at /rustc/b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b/library/test/src/lib.rs:145:21 [INFO] [stdout] 13: 0x64970856e253 - as core::ops::function::Fn>::call::h9d85285925beb538 [INFO] [stdout] at /rustc/b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b/library/alloc/src/boxed.rs:1985:9 [INFO] [stdout] 14: 0x64970856e253 - std::panicking::panic_with_hook::h3190ecc6229cdd29 [INFO] [stdout] at /rustc/b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b/library/std/src/panicking.rs:842:13 [INFO] [stdout] 15: 0x64970858283a - std::panicking::panic_handler::{{closure}}::ha1f1b769bc2bb40c [INFO] [stdout] at /rustc/b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b/library/std/src/panicking.rs:707:13 [INFO] [stdout] 16: 0x649708582799 - std::sys::backtrace::__rust_end_short_backtrace::h5f9cf66f19c2a172 [INFO] [stdout] at /rustc/b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b/library/std/src/sys/backtrace.rs:174:18 [INFO] [stdout] 17: 0x64970856defd - __rustc[a93bd50104b99ad4]::rust_begin_unwind [INFO] [stdout] at /rustc/b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b/library/std/src/panicking.rs:698:5 [INFO] [stdout] 18: 0x6497085adf80 - core::panicking::panic_fmt::hc70c3c83f13c1375 [INFO] [stdout] at /rustc/b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b/library/core/src/panicking.rs:75:14 [INFO] [stdout] 19: 0x64970822fc9c - mt_logger::receiver::Receiver::main::hcd972bec73f01fdf [INFO] [stdout] at /opt/rustwide/workdir/src/receiver.rs:122:27 [INFO] [stdout] 20: 0x64970823e8bd - mt_logger::MtLogger::new::{{closure}}::hb296e1416f7a2c8c [INFO] [stdout] at /opt/rustwide/workdir/src/lib.rs:167:41 [INFO] [stdout] 21: 0x649708236246 - std::sys::backtrace::__rust_begin_short_backtrace::had81af9d7980ba69 [INFO] [stdout] at /rustc/b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b/library/std/src/sys/backtrace.rs:158:18 [INFO] [stdout] 22: 0x64970823fcb3 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::ha17546a1047c4107 [INFO] [stdout] at /rustc/b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b/library/std/src/thread/mod.rs:559:17 [INFO] [stdout] 23: 0x64970823a4d0 - as core::ops::function::FnOnce<()>>::call_once::hcf39fc6d4f1af4a7 [INFO] [stdout] at /rustc/b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 24: 0x64970823a32f - std::panicking::catch_unwind::do_call::h9c0f68e9c23925d3 [INFO] [stdout] at /rustc/b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b/library/std/src/panicking.rs:590:40 [INFO] [stdout] 25: 0x64970824264b - __rust_try [INFO] [stdout] 26: 0x64970824142a - std::panicking::catch_unwind::ha6d8de44a9aeab20 [INFO] [stdout] at /rustc/b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b/library/std/src/panicking.rs:553:19 [INFO] [stdout] 27: 0x64970824142a - std::panic::catch_unwind::hfe3a91a1372ae377 [INFO] [stdout] at /rustc/b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b/library/std/src/panic.rs:359:14 [INFO] [stdout] 28: 0x64970824142a - std::thread::Builder::spawn_unchecked_::{{closure}}::h13dae1ec4d6cad02 [INFO] [stdout] at /rustc/b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b/library/std/src/thread/mod.rs:557:30 [INFO] [stdout] 29: 0x649708229b9e - core::ops::function::FnOnce::call_once{{vtable.shim}}::h7c8c073b5e77a164 [INFO] [stdout] at /rustc/b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b/library/core/src/ops/function.rs:253:5 [INFO] [stdout] 30: 0x649708557a8f - as core::ops::function::FnOnce>::call_once::h1b9c6fea2cbefc68 [INFO] [stdout] at /rustc/b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b/library/alloc/src/boxed.rs:1971:9 [INFO] [stdout] 31: 0x649708557a8f - std::sys::pal::unix::thread::Thread::new::thread_start::h92caa992bc760789 [INFO] [stdout] at /rustc/b6ae10aa7319b7ebb6c7b3331dd71a9d6c9c5b4b/library/std/src/sys/pal/unix/thread.rs:107:17 [INFO] [stdout] 32: 0x763bd566aaa4 - [INFO] [stdout] 33: 0x763bd56f7a34 - clone [INFO] [stdout] 34: 0x0 - [INFO] [stdout] Error: RecvError(RecvError) [INFO] [stdout] [INFO] [stdout] ---- tests::flush_test stdout ---- [INFO] [stdout] Initial message count: 0 [INFO] [stdout] Sending messages... [INFO] [stdout] Error: SendError(SendError { .. }) [INFO] [stdout] [INFO] [stdout] ---- tests::format_verification stdout ---- [INFO] [stdout] Flushing all messages to their output... [INFO] [stdout] Error: SendError(SendError { .. }) [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] tests::flush_test [INFO] [stdout] tests::format_verification [INFO] [stdout] tests::outputstream_verification [INFO] [stdout] [INFO] [stdout] test result: FAILED. 0 passed; 3 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.10s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass `--lib` [INFO] running `Command { std: "docker" "inspect" "46e5bde6f9ce77ecf7c5e9800a8ca08a8ff827a382e98ec7e03d7d60828e12e0", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "46e5bde6f9ce77ecf7c5e9800a8ca08a8ff827a382e98ec7e03d7d60828e12e0", kill_on_drop: false }` [INFO] [stdout] 46e5bde6f9ce77ecf7c5e9800a8ca08a8ff827a382e98ec7e03d7d60828e12e0