[INFO] fetching crate fern 0.7.1... [INFO] testing fern-0.7.1 against try#8de4c7234dd9b97c9d76b58671343fdbbc9a433e+target=x86_64-unknown-linux-musl for musl_upgrade_1_2_5_with_libc_patch_0 [INFO] extracting crate fern 0.7.1 into /workspace/builds/worker-5-tc1/source [INFO] started tweaking crates.io crate fern 0.7.1 [INFO] removed 0 missing examples [INFO] removed 0 missing tests [INFO] finished tweaking crates.io crate fern 0.7.1 [INFO] tweaked toml for crates.io crate fern 0.7.1 written to /workspace/builds/worker-5-tc1/source/Cargo.toml [INFO] validating manifest of crates.io crate fern 0.7.1 on toolchain 8de4c7234dd9b97c9d76b58671343fdbbc9a433e [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] crate crates.io crate fern 0.7.1 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" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Updating crates.io index [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded syslog v3.3.0 [INFO] [stderr] Downloaded syslog v4.0.1 [INFO] [stderr] Downloaded syslog v7.0.0 [INFO] [stderr] Downloaded reopen v0.3.0 [INFO] [stderr] Downloaded reopen v1.0.3 [INFO] [stderr] Downloaded syslog v6.1.1 [INFO] [stderr] Downloaded cc v1.1.1 [INFO] [stderr] Downloaded time v0.3.15 [INFO] [stderr] Downloaded rustix v0.38.9 [INFO] [stderr] Downloaded syn v2.0.82 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] e1514cc97a334e36000fc2da6b6d4ece131c8507d9496469f9c613d3bcc5a871 [INFO] running `Command { std: "docker" "start" "-a" "e1514cc97a334e36000fc2da6b6d4ece131c8507d9496469f9c613d3bcc5a871", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "e1514cc97a334e36000fc2da6b6d4ece131c8507d9496469f9c613d3bcc5a871", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "e1514cc97a334e36000fc2da6b6d4ece131c8507d9496469f9c613d3bcc5a871", kill_on_drop: false }` [INFO] [stdout] e1514cc97a334e36000fc2da6b6d4ece131c8507d9496469f9c613d3bcc5a871 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "build" "--frozen" "--message-format=json" "--target" "x86_64-unknown-linux-musl", kill_on_drop: false }` [INFO] [stdout] 5003d56eeb29be497b2e4809aa520a2409777a79e36f65c721fdc37b4c4e30fa [INFO] running `Command { std: "docker" "start" "-a" "5003d56eeb29be497b2e4809aa520a2409777a79e36f65c721fdc37b4c4e30fa", kill_on_drop: false }` [INFO] [stderr] Compiling log v0.4.22 [INFO] [stderr] Compiling fern v0.7.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.98s [INFO] running `Command { std: "docker" "inspect" "5003d56eeb29be497b2e4809aa520a2409777a79e36f65c721fdc37b4c4e30fa", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "5003d56eeb29be497b2e4809aa520a2409777a79e36f65c721fdc37b4c4e30fa", kill_on_drop: false }` [INFO] [stdout] 5003d56eeb29be497b2e4809aa520a2409777a79e36f65c721fdc37b4c4e30fa [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "test" "--frozen" "--no-run" "--message-format=json" "--target" "x86_64-unknown-linux-musl", kill_on_drop: false }` [INFO] [stdout] baa6700f208bd0d05479e1d9218e27cbe0753c2396a64d66929dfef7ca3bd60b [INFO] running `Command { std: "docker" "start" "-a" "baa6700f208bd0d05479e1d9218e27cbe0753c2396a64d66929dfef7ca3bd60b", kill_on_drop: false }` [INFO] [stderr] Compiling libc v0.2.161 [INFO] [stderr] Compiling rustix v0.38.9 [INFO] [stderr] Compiling linux-raw-sys v0.4.14 [INFO] [stderr] Compiling bitflags v2.6.0 [INFO] [stderr] Compiling unicode-width v0.1.14 [INFO] [stderr] Compiling strsim v0.8.0 [INFO] [stderr] Compiling vec_map v0.8.2 [INFO] [stderr] Compiling fastrand v2.1.1 [INFO] [stderr] Compiling ansi_term v0.12.1 [INFO] [stderr] Compiling humantime v2.1.0 [INFO] [stderr] Compiling textwrap v0.11.0 [INFO] [stderr] Compiling atty v0.2.14 [INFO] [stderr] Compiling clap v2.34.0 [INFO] [stderr] Compiling tempfile v3.8.0 [INFO] [stderr] Compiling fern v0.7.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 12.24s [INFO] running `Command { std: "docker" "inspect" "baa6700f208bd0d05479e1d9218e27cbe0753c2396a64d66929dfef7ca3bd60b", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "baa6700f208bd0d05479e1d9218e27cbe0753c2396a64d66929dfef7ca3bd60b", kill_on_drop: false }` [INFO] [stdout] baa6700f208bd0d05479e1d9218e27cbe0753c2396a64d66929dfef7ca3bd60b [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "test" "--frozen" "--target" "x86_64-unknown-linux-musl", kill_on_drop: false }` [INFO] [stdout] e8d97bb694a57194080e4e0404672b90dd34019f85a5046f783f2f74e0eeee0f [INFO] running `Command { std: "docker" "start" "-a" "e8d97bb694a57194080e4e0404672b90dd34019f85a5046f783f2f74e0eeee0f", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.08s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/fern-20bdb55d47daf567) [INFO] [stdout] [INFO] [stdout] running 7 tests [INFO] [stdout] test log_impl::test::test_level_config_find_exact_minimal ... ok [INFO] [stdout] test log_impl::test::test_level_config_find_exact_many ... ok [INFO] [stdout] test log_impl::test::test_level_config_hierarchy_correct ... ok [INFO] [stdout] test log_impl::test::test_level_config_similar_names_are_not_same ... ok [INFO] [stdout] test log_impl::test::test_level_config_simple_hierarchy ... ok [INFO] [stdout] test log_impl::test::test_level_config_single_colon_is_not_double_colon ... ok [INFO] [stdout] test log_impl::test::test_level_config_all_chars ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Running tests/channel_logging.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/channel_logging-e19b1b19e83733ef) [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stdout] test test_channel_logging ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Running tests/enabled_is_deep_check.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/enabled_is_deep_check-810fb817319cc760) [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stdout] test ensure_enabled_is_a_deep_check ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Running tests/file_logging.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/file_logging-6254271e9ef3e6b4) [INFO] [stdout] running 2 tests [INFO] [stdout] test test_custom_line_separators ... ok [INFO] [stderr] Running tests/global_logging.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/global_logging-9d5e0f11e2b93e9d) [INFO] [stdout] [INFO] Test information message [INFO] [stdout] [WARN] Test warning message [INFO] [stdout] [ERROR] Test error message [INFO] [stdout] test test_basic_logging_file_logging ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stdout] test test_global_logger ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Running tests/meta_logging.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/meta_logging-8f157c218c9be86e) [INFO] [stdout] [INFO] [stdout] running 0 tests [INFO] [stdout] [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Running tests/panic_logging.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/panic_logging-a68b5ef8d3a64d8c) [INFO] [stdout] [INFO] [stdout] running 3 tests [INFO] [stdout] this should not panic [INFO] [stdout] test double_chained_with_panics_no_info_panic ... ok [INFO] [stdout] test double_chained_with_panics_yes_error_panic - should panic ... ok [INFO] [stdout] test test_panic_panics - should panic ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s [INFO] [stdout] [INFO] [stderr] Running tests/reopen_logging.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/reopen_logging-f879d8a29ce175fe) [INFO] [stdout] [INFO] [stdout] running 0 tests [INFO] [stdout] [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Running tests/support.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/support-99f4b979a468e464) [INFO] [stdout] [INFO] [stdout] running 0 tests [INFO] [stdout] [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Running tests/write_logging.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/write_logging-43afb191047f7820) [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stdout] [INFO] Test information message [INFO] [stdout] test test_raw_write_logging ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "e8d97bb694a57194080e4e0404672b90dd34019f85a5046f783f2f74e0eeee0f", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "e8d97bb694a57194080e4e0404672b90dd34019f85a5046f783f2f74e0eeee0f", kill_on_drop: false }` [INFO] [stdout] e8d97bb694a57194080e4e0404672b90dd34019f85a5046f783f2f74e0eeee0f