[INFO] fetching crate float_fast_print 0.1.2...
[INFO] testing float_fast_print-0.1.2 against master#a77da2d454e6caa227a85b16410b95f93495e7e0 for pr-91031
[INFO] extracting crate float_fast_print 0.1.2 into /workspace/builds/worker-50/source
[INFO] validating manifest of crates.io crate float_fast_print 0.1.2 on toolchain a77da2d454e6caa227a85b16410b95f93495e7e0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate float_fast_print 0.1.2
[INFO] finished tweaking crates.io crate float_fast_print 0.1.2
[INFO] tweaked toml for crates.io crate float_fast_print 0.1.2 written to /workspace/builds/worker-50/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-50/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-50/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 74c8ecf9cc85308aead33f5de12d80cb1e91c72222d2daf1b833438d076a1145
[INFO] running `Command { std: "docker" "start" "-a" "74c8ecf9cc85308aead33f5de12d80cb1e91c72222d2daf1b833438d076a1145", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "74c8ecf9cc85308aead33f5de12d80cb1e91c72222d2daf1b833438d076a1145", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "74c8ecf9cc85308aead33f5de12d80cb1e91c72222d2daf1b833438d076a1145", kill_on_drop: false }`
[INFO] [stdout] 74c8ecf9cc85308aead33f5de12d80cb1e91c72222d2daf1b833438d076a1145
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-50/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-50/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" "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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 9166e6d5185173f0ab2cc5c67a566744e042d6ad85d426c34318d5050e9f64b5
[INFO] running `Command { std: "docker" "start" "-a" "9166e6d5185173f0ab2cc5c67a566744e042d6ad85d426c34318d5050e9f64b5", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling float_fast_print v0.1.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.33s
[INFO] running `Command { std: "docker" "inspect" "9166e6d5185173f0ab2cc5c67a566744e042d6ad85d426c34318d5050e9f64b5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9166e6d5185173f0ab2cc5c67a566744e042d6ad85d426c34318d5050e9f64b5", kill_on_drop: false }`
[INFO] [stdout] 9166e6d5185173f0ab2cc5c67a566744e042d6ad85d426c34318d5050e9f64b5
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-50/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-50/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" "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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d524559a07e87f0226b406480e8e3f50cfc3174773933ec8875af80c74035e8e
[INFO] running `Command { std: "docker" "start" "-a" "d524559a07e87f0226b406480e8e3f50cfc3174773933ec8875af80c74035e8e", kill_on_drop: false }`
[INFO] [stderr]    Compiling rand_core v0.4.2
[INFO] [stderr]    Compiling rand_core v0.3.1
[INFO] [stderr]    Compiling rand v0.5.6
[INFO] [stderr]    Compiling float_fast_print v0.1.2 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unused `Result` that must be used
[INFO] [stdout]   --> tests/benchmarks.rs:17:9
[INFO] [stdout]    |
[INFO] [stdout] 17 |         write!(&mut buffer, "{:?}", x);
[INFO] [stdout]    |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_must_use)]` on by default
[INFO] [stdout]    = note: this `Result` may be an `Err` variant, which should be handled
[INFO] [stdout]    = note: this warning originates in the macro `write` (in Nightly builds, run with -Z macro-backtrace for more info)
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused `Result` that must be used
[INFO] [stdout]   --> tests/benchmarks.rs:28:9
[INFO] [stdout]    |
[INFO] [stdout] 28 |         write!(&mut buffer, "{}", x);
[INFO] [stdout]    |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: this `Result` may be an `Err` variant, which should be handled
[INFO] [stdout]    = note: this warning originates in the macro `write` (in Nightly builds, run with -Z macro-backtrace for more info)
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused `Result` that must be used
[INFO] [stdout]   --> tests/benchmarks.rs:39:9
[INFO] [stdout]    |
[INFO] [stdout] 39 |         write!(&mut buffer, "{:?}", x);
[INFO] [stdout]    |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: this `Result` may be an `Err` variant, which should be handled
[INFO] [stdout]    = note: this warning originates in the macro `write` (in Nightly builds, run with -Z macro-backtrace for more info)
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused `Result` that must be used
[INFO] [stdout]   --> tests/benchmarks.rs:50:9
[INFO] [stdout]    |
[INFO] [stdout] 50 |         write!(&mut buffer, "{}", x);
[INFO] [stdout]    |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: this `Result` may be an `Err` variant, which should be handled
[INFO] [stdout]    = note: this warning originates in the macro `write` (in Nightly builds, run with -Z macro-backtrace for more info)
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 4 warnings emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 2.12s
[INFO] running `Command { std: "docker" "inspect" "d524559a07e87f0226b406480e8e3f50cfc3174773933ec8875af80c74035e8e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d524559a07e87f0226b406480e8e3f50cfc3174773933ec8875af80c74035e8e", kill_on_drop: false }`
[INFO] [stdout] d524559a07e87f0226b406480e8e3f50cfc3174773933ec8875af80c74035e8e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-50/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-50/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" "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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] c8b598775c2ff70d9396310848378a3a197e27dfd846ce56b378c505173f6b56
[INFO] running `Command { std: "docker" "start" "-a" "c8b598775c2ff70d9396310848378a3a197e27dfd846ce56b378c505173f6b56", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr] warning: unused `Result` that must be used
[INFO] [stderr]   --> tests/benchmarks.rs:17:9
[INFO] [stderr]    |
[INFO] [stderr] 17 |         write!(&mut buffer, "{:?}", x);
[INFO] [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(unused_must_use)]` on by default
[INFO] [stderr]    = note: this `Result` may be an `Err` variant, which should be handled
[INFO] [stderr]    = note: this warning originates in the macro `write` (in Nightly builds, run with -Z macro-backtrace for more info)
[INFO] [stderr] 
[INFO] [stderr] warning: unused `Result` that must be used
[INFO] [stderr]   --> tests/benchmarks.rs:28:9
[INFO] [stderr]    |
[INFO] [stderr] 28 |         write!(&mut buffer, "{}", x);
[INFO] [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: this `Result` may be an `Err` variant, which should be handled
[INFO] [stderr]    = note: this warning originates in the macro `write` (in Nightly builds, run with -Z macro-backtrace for more info)
[INFO] [stderr] 
[INFO] [stderr] warning: unused `Result` that must be used
[INFO] [stderr]   --> tests/benchmarks.rs:39:9
[INFO] [stderr]    |
[INFO] [stderr] 39 |         write!(&mut buffer, "{:?}", x);
[INFO] [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: this `Result` may be an `Err` variant, which should be handled
[INFO] [stderr]    = note: this warning originates in the macro `write` (in Nightly builds, run with -Z macro-backtrace for more info)
[INFO] [stderr] 
[INFO] [stderr] warning: unused `Result` that must be used
[INFO] [stderr]   --> tests/benchmarks.rs:50:9
[INFO] [stderr]    |
[INFO] [stderr] 50 |         write!(&mut buffer, "{}", x);
[INFO] [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: this `Result` may be an `Err` variant, which should be handled
[INFO] [stderr]    = note: this warning originates in the macro `write` (in Nightly builds, run with -Z macro-backtrace for more info)
[INFO] [stderr] 
[INFO] [stderr] warning: `float_fast_print` (test "benchmarks") generated 4 warnings
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.53s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/float_fast_print-5d2bf8ccee78d584)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test tests::f32_special_cases ... ok
[INFO] [stdout] test tests::f64_special_cases ... ok
[INFO] [stdout] test tests::f32_special_cases_roundtrip ... ok
[INFO] [stdout] test tests::f64_special_cases_roundtrip ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/benchmarks.rs (/opt/rustwide/target/debug/deps/benchmarks-0c55ca2c9e8c9698)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test bench_f64_format ... ok
[INFO] [stdout] test bench_f64_debug ... ok
[INFO] [stdout] test bench_f32_debug ... ok
[INFO] [stdout] test bench_write_f32_shortest ... ok
[INFO] [stderr]      Running tests/exhaustive.rs (/opt/rustwide/target/debug/deps/exhaustive-ea334b74a95b898f)
[INFO] [stdout] test bench_write_f64_shortest ... ok
[INFO] [stdout] test bench_f32_format ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test f32_test_exhaustive_roundtrip has been running for over 60 seconds
[INFO] [stdout] test f64_test_many_roundtrip has been running for over 60 seconds
[ERROR] error running command: no output for 300 seconds
[INFO] running `Command { std: "docker" "inspect" "c8b598775c2ff70d9396310848378a3a197e27dfd846ce56b378c505173f6b56", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c8b598775c2ff70d9396310848378a3a197e27dfd846ce56b378c505173f6b56", kill_on_drop: false }`
[INFO] [stdout] c8b598775c2ff70d9396310848378a3a197e27dfd846ce56b378c505173f6b56