[INFO] fetching crate tfmt 0.4.0...
[INFO] testing tfmt-0.4.0 against try#2440211fe03bc45c89b6dc1a3df18382ce91e32b for pr-146098-1
[INFO] extracting crate tfmt 0.4.0 into /workspace/builds/worker-1-tc2/source
[INFO] started tweaking crates.io crate tfmt 0.4.0
[INFO] finished tweaking crates.io crate tfmt 0.4.0
[INFO] tweaked toml for crates.io crate tfmt 0.4.0 written to /workspace/builds/worker-1-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate tfmt 0.4.0 on toolchain 2440211fe03bc45c89b6dc1a3df18382ce91e32b
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+2440211fe03bc45c89b6dc1a3df18382ce91e32b" "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" "+2440211fe03bc45c89b6dc1a3df18382ce91e32b" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]      Locking 9 packages to latest compatible versions
[INFO] [stderr]       Adding heapless v0.8.0 (available: v0.9.1)
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+2440211fe03bc45c89b6dc1a3df18382ce91e32b" "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" "+2440211fe03bc45c89b6dc1a3df18382ce91e32b" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] e9082fc383eca7c05a60c4f17ce538e89cb77d6ef612a832235b17719151b1c0
[INFO] running `Command { std: "docker" "start" "-a" "e9082fc383eca7c05a60c4f17ce538e89cb77d6ef612a832235b17719151b1c0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "e9082fc383eca7c05a60c4f17ce538e89cb77d6ef612a832235b17719151b1c0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e9082fc383eca7c05a60c4f17ce538e89cb77d6ef612a832235b17719151b1c0", kill_on_drop: false }`
[INFO] [stdout] e9082fc383eca7c05a60c4f17ce538e89cb77d6ef612a832235b17719151b1c0
[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" "+2440211fe03bc45c89b6dc1a3df18382ce91e32b" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] ea50c2b42b24192a192def60c655b04b425db9742a9e0ca5f5a705d1f6c5173c
[INFO] running `Command { std: "docker" "start" "-a" "ea50c2b42b24192a192def60c655b04b425db9742a9e0ca5f5a705d1f6c5173c", kill_on_drop: false }`
[INFO] [stderr]    Compiling syn v1.0.109
[INFO] [stderr]    Compiling heapless v0.8.0
[INFO] [stderr]    Compiling stable_deref_trait v1.2.0
[INFO] [stderr]    Compiling hash32 v0.3.1
[INFO] [stderr]    Compiling tfmt-macros v0.4.0
[INFO] [stderr]    Compiling tfmt v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 6.02s
[INFO] running `Command { std: "docker" "inspect" "ea50c2b42b24192a192def60c655b04b425db9742a9e0ca5f5a705d1f6c5173c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ea50c2b42b24192a192def60c655b04b425db9742a9e0ca5f5a705d1f6c5173c", kill_on_drop: false }`
[INFO] [stdout] ea50c2b42b24192a192def60c655b04b425db9742a9e0ca5f5a705d1f6c5173c
[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" "+2440211fe03bc45c89b6dc1a3df18382ce91e32b" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 7af02f222ded7699712619618fac07ff588d51c1ab1736139cc8558e938dd1b2
[INFO] running `Command { std: "docker" "start" "-a" "7af02f222ded7699712619618fac07ff588d51c1ab1736139cc8558e938dd1b2", kill_on_drop: false }`
[INFO] [stderr]    Compiling tfmt v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 2.12s
[INFO] running `Command { std: "docker" "inspect" "7af02f222ded7699712619618fac07ff588d51c1ab1736139cc8558e938dd1b2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7af02f222ded7699712619618fac07ff588d51c1ab1736139cc8558e938dd1b2", kill_on_drop: false }`
[INFO] [stdout] 7af02f222ded7699712619618fac07ff588d51c1ab1736139cc8558e938dd1b2
[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" "+2440211fe03bc45c89b6dc1a3df18382ce91e32b" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 7a5d219bb73a28e3d1259e43c1b73303e25d87374cae2aa0638368b6b0a53264
[INFO] running `Command { std: "docker" "start" "-a" "7a5d219bb73a28e3d1259e43c1b73303e25d87374cae2aa0638368b6b0a53264", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.06s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/tfmt-aed63c7d2e29acbf)
[INFO] [stdout] running 0 tests
[INFO] [stderr]      Running tests/core.rs (/opt/rustwide/target/debug/deps/core-3ffb8d68a317f1b1)
[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] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stderr]      Running tests/debug.rs (/opt/rustwide/target/debug/deps/debug-90b9467b6ba0fd58)
[INFO] [stdout] test aligned ... ok
[INFO] [stdout] test fmt ... ok
[INFO] [stdout] test result ... ok
[INFO] [stdout] test option ... ok
[INFO] [stdout] test uwriteln ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test slice ... ok
[INFO] [stdout] test generic ... ok
[INFO] [stdout] test enum_ ... ok
[INFO] [stdout] test formatter_uwrite ... ok
[INFO] [stdout] test struct_ ... ok
[INFO] [stdout] test tuples ... ok
[INFO] [stdout] 
[INFO] [stderr]      Running tests/float.rs (/opt/rustwide/target/debug/deps/float-bc81f3cb1482c1ca)
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stderr]      Running tests/int.rs (/opt/rustwide/target/debug/deps/int-a05e840848e04e33)
[INFO] [stdout] test f64 ... ok
[INFO] [stdout] test f32 ... 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 7 tests
[INFO] [stderr]    Doc-tests tfmt
[INFO] [stdout] test ixx_min_max ... ok
[INFO] [stdout] test uxx_aligned ... ok
[INFO] [stdout] test ptr ... ok
[INFO] [stdout] test ixx_aligned ... ok
[INFO] [stdout] test ixx_hex ... ok
[INFO] [stdout] test uxx_min_max ... ok
[INFO] [stdout] test uxx_hex ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 14 tests
[INFO] [stdout] test src/impls/float.rs - impls::float::Convert<CAP>::f32_pad (line 118) ... ok
[INFO] [stdout] test src/impls/int.rs - impls::int::Convert<CAP>::i32_pad (line 362) ... ok
[INFO] [stdout] test src/impls/float.rs - impls::float::Convert<CAP>::from_f32 (line 79) ... ok
[INFO] [stdout] test src/impls/float.rs - impls::float::Convert<CAP>::f64_pad (line 140) ... ok
[INFO] [stdout] test src/impls/int.rs - impls::int::Convert<CAP>::from_i32 (line 347) ... ok
[INFO] [stdout] test src/impls/int.rs - impls::int::Convert<CAP>::from_u32 (line 300) ... ok
[INFO] [stdout] test src/impls/float.rs - impls::float::Convert<CAP>::from_f64 (line 97) ... ok
[INFO] [stdout] test src/impls/int.rs - impls::int::Convert<CAP>::u32_pad (line 315) ... ok
[INFO] [stdout] test src/lib.rs - uDisplayFormatted (line 347) ... ok
[INFO] [stdout] test src/lib.rs - (line 76) ... ok
[INFO] [stdout] test src/lib.rs - (line 122) ... ok
[INFO] [stdout] test src/lib.rs - uformat (line 56) ... ok
[INFO] [stdout] test src/lib.rs - (line 40) ... ok
[INFO] [stdout] test src/lib.rs - uDisplayPadded (line 299) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 14 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.68s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "7a5d219bb73a28e3d1259e43c1b73303e25d87374cae2aa0638368b6b0a53264", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7a5d219bb73a28e3d1259e43c1b73303e25d87374cae2aa0638368b6b0a53264", kill_on_drop: false }`
[INFO] [stdout] 7a5d219bb73a28e3d1259e43c1b73303e25d87374cae2aa0638368b6b0a53264