[INFO] fetching crate wfu 0.0.3...
[INFO] testing wfu-0.0.3 against try#dec9417b8611e34e787a3e4c37686b5131f9e5c5 for pr-154210-2
[INFO] extracting crate wfu 0.0.3 into /workspace/builds/worker-2-tc2/source
[INFO] started tweaking crates.io crate wfu 0.0.3
[INFO] finished tweaking crates.io crate wfu 0.0.3
[INFO] tweaked toml for crates.io crate wfu 0.0.3 written to /workspace/builds/worker-2-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate wfu 0.0.3 on toolchain dec9417b8611e34e787a3e4c37686b5131f9e5c5
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate wfu 0.0.3 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 876a929b1151eadc5115688c3dea0e5634b283a854c4640f5da8ad170de70aab
[INFO] running `Command { std: "docker" "start" "-a" "876a929b1151eadc5115688c3dea0e5634b283a854c4640f5da8ad170de70aab", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "876a929b1151eadc5115688c3dea0e5634b283a854c4640f5da8ad170de70aab", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "876a929b1151eadc5115688c3dea0e5634b283a854c4640f5da8ad170de70aab", kill_on_drop: false }`
[INFO] [stdout] 876a929b1151eadc5115688c3dea0e5634b283a854c4640f5da8ad170de70aab
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 2ca450c5d9d162a881b9afae1649643d22b110a691ea2410a0f6d96a83d1b026
[INFO] running `Command { std: "docker" "start" "-a" "2ca450c5d9d162a881b9afae1649643d22b110a691ea2410a0f6d96a83d1b026", kill_on_drop: false }`
[INFO] [stderr]    Compiling wfu v0.0.3 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.37s
[INFO] running `Command { std: "docker" "inspect" "2ca450c5d9d162a881b9afae1649643d22b110a691ea2410a0f6d96a83d1b026", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2ca450c5d9d162a881b9afae1649643d22b110a691ea2410a0f6d96a83d1b026", kill_on_drop: false }`
[INFO] [stdout] 2ca450c5d9d162a881b9afae1649643d22b110a691ea2410a0f6d96a83d1b026
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 1e3e17290ab03ff933072f61fde4579912b0c702b840c15ec7a05b578009d0da
[INFO] running `Command { std: "docker" "start" "-a" "1e3e17290ab03ff933072f61fde4579912b0c702b840c15ec7a05b578009d0da", kill_on_drop: false }`
[INFO] [stderr]    Compiling wfu v0.0.3 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.06s
[INFO] running `Command { std: "docker" "inspect" "1e3e17290ab03ff933072f61fde4579912b0c702b840c15ec7a05b578009d0da", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1e3e17290ab03ff933072f61fde4579912b0c702b840c15ec7a05b578009d0da", kill_on_drop: false }`
[INFO] [stdout] 1e3e17290ab03ff933072f61fde4579912b0c702b840c15ec7a05b578009d0da
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 0d472380db401d7e626cd549de53769c701d0a1c20d0fe4df8ec1317496600f8
[INFO] running `Command { std: "docker" "start" "-a" "0d472380db401d7e626cd549de53769c701d0a1c20d0fe4df8ec1317496600f8", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.03s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/wfu-f9bbbe18ff0f6682)
[INFO] [stdout] 
[INFO] [stdout] running 29 tests
[INFO] [stdout] test fmt_as::tests::test_basic_proxy ... ok
[INFO] [stdout] test fmt_as::tests::test_fmt_as_inner_type ... ok
[INFO] [stdout] test fmt_as::tests::test_edge_cases ... ok
[INFO] [stdout] test fmt_as::tests::test_proxy_in_functions ... ok
[INFO] [stdout] test fmt_as::tests::test_reference_types ... ok
[INFO] [stdout] test fmt_as::tests::test_lifetime_handling ... ok
[INFO] [stdout] test fmt_as::tests::test_multiple_formatting_traits ... ok
[INFO] [stdout] test fmt_by_holder::tests::test_chain_composition ... ok
[INFO] [stdout] test fmt_as::tests::test_unicode_characters ... ok
[INFO] [stdout] test fmt_with::tests::test_closure_lifetimes ... ok
[INFO] [stdout] test fmt_by::tests::test_custom_extra ... ok
[INFO] [stdout] test tests::test_performance_patterns ... ok
[INFO] [stdout] test utils::debug_map::tests::test_custom_debug_map ... ok
[INFO] [stdout] test tests::test_formatting_trait_consistency ... ok
[INFO] [stdout] test tests::test_no_std_compatibility ... ok
[INFO] [stdout] test tests::test_combined_usage ... ok
[INFO] [stdout] test fmt_with::tests::test_fmt_with ... ok
[INFO] [stdout] test utils::debug_map::tests::test_debug_map ... ok
[INFO] [stdout] test utils::debug_map::tests::test_ref_item_debug_map ... ok
[INFO] [stdout] test utils::fmt_fn::tests::test_format_with_basic ... ok
[INFO] [stdout] test utils::joined::tests::test_joined_proxy ... ok
[INFO] [stdout] test utils::fmt_fn::tests::test_format_with_multiple_traits ... ok
[INFO] [stdout] test utils::proxy::tests::test_format_with_basic ... ok
[INFO] [stdout] test utils::joined::tests::test_joined_with_different_containers ... ok
[INFO] [stdout] test utils::joined::tests::test_joined_proxy_ref ... ok
[INFO] [stdout] test utils::proxy::tests::test_format_with_multiple_traits ... ok
[INFO] [stdout] test utils::debug_map::tests::test_clone_iter_debug_map ... ok
[INFO] [stdout] test utils::repeat::tests::test_repeat_proxy ... ok
[INFO] [stdout] test utils::proxy::tests::test_macro_defined_proxies ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 29 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests wfu
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test src/../README.md - (line 56) ... ok
[INFO] [stdout] test src/../README.md - (line 12) ... ok
[INFO] [stdout] test src/utils/joined.rs - utils::joined::CloneIterJoined (line 68) ... ok
[INFO] [stdout] test src/utils/joined.rs - utils::joined::Joined (line 33) ... ok
[INFO] [stdout] test src/../README.md - (line 75) ... ok
[INFO] [stdout] test src/utils/debug_map.rs - utils::debug_map::DebugMap (line 35) ... ok
[INFO] [stdout] test src/utils/fmt_fn.rs - utils::fmt_fn::FmtFn (line 33) ... ok
[INFO] [stdout] test src/utils/debug_map.rs - utils::debug_map::CloneIterDebugMap (line 118) ... ok
[INFO] [stdout] test src/utils/debug_map.rs - utils::debug_map::RefItemDebugMap (line 78) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 0.88s; merged doctests compilation took 0.85s
[INFO] running `Command { std: "docker" "inspect" "0d472380db401d7e626cd549de53769c701d0a1c20d0fe4df8ec1317496600f8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "0d472380db401d7e626cd549de53769c701d0a1c20d0fe4df8ec1317496600f8", kill_on_drop: false }`
[INFO] [stdout] 0d472380db401d7e626cd549de53769c701d0a1c20d0fe4df8ec1317496600f8