[INFO] fetching crate indicatif 0.17.0-beta.1...
[INFO] testing indicatif-0.17.0-beta.1 against master#a77da2d454e6caa227a85b16410b95f93495e7e0 for pr-91031
[INFO] extracting crate indicatif 0.17.0-beta.1 into /workspace/builds/worker-64/source
[INFO] validating manifest of crates.io crate indicatif 0.17.0-beta.1 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 indicatif 0.17.0-beta.1
[INFO] finished tweaking crates.io crate indicatif 0.17.0-beta.1
[INFO] tweaked toml for crates.io crate indicatif 0.17.0-beta.1 written to /workspace/builds/worker-64/source/Cargo.toml
[INFO] crate crates.io crate indicatif 0.17.0-beta.1 already has a lockfile, it will not be regenerated
[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-64/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-64/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] 2c998669c102fc397b4c26bd426f07a0de6fe9515c6425e723b1702a50b263f0
[INFO] running `Command { std: "docker" "start" "-a" "2c998669c102fc397b4c26bd426f07a0de6fe9515c6425e723b1702a50b263f0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "2c998669c102fc397b4c26bd426f07a0de6fe9515c6425e723b1702a50b263f0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2c998669c102fc397b4c26bd426f07a0de6fe9515c6425e723b1702a50b263f0", kill_on_drop: false }`
[INFO] [stdout] 2c998669c102fc397b4c26bd426f07a0de6fe9515c6425e723b1702a50b263f0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-64/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-64/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] 91ea9fc6b06a910b5fedab7429176b481376ce7f869ed1a82642f50fa2892212
[INFO] running `Command { std: "docker" "start" "-a" "91ea9fc6b06a910b5fedab7429176b481376ce7f869ed1a82642f50fa2892212", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.98
[INFO] [stderr]    Compiling lazy_static v1.4.0
[INFO] [stderr]    Compiling regex-syntax v0.6.25
[INFO] [stderr]    Compiling number_prefix v0.4.0
[INFO] [stderr]    Compiling terminal_size v0.1.17
[INFO] [stderr]    Compiling console v0.14.1
[INFO] [stderr]    Compiling regex v1.5.4
[INFO] [stderr]    Compiling indicatif v0.17.0-beta.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.71s
[INFO] running `Command { std: "docker" "inspect" "91ea9fc6b06a910b5fedab7429176b481376ce7f869ed1a82642f50fa2892212", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "91ea9fc6b06a910b5fedab7429176b481376ce7f869ed1a82642f50fa2892212", kill_on_drop: false }`
[INFO] [stdout] 91ea9fc6b06a910b5fedab7429176b481376ce7f869ed1a82642f50fa2892212
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-64/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-64/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] cbffaa696eb0c20993a5045c50015e51ba986a44144d6b18824de1a905ce04a5
[INFO] running `Command { std: "docker" "start" "-a" "cbffaa696eb0c20993a5045c50015e51ba986a44144d6b18824de1a905ce04a5", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.28
[INFO] [stderr]    Compiling version_check v0.9.3
[INFO] [stderr]    Compiling unicode-xid v0.2.2
[INFO] [stderr]    Compiling syn v1.0.74
[INFO] [stderr]    Compiling bitflags v1.2.1
[INFO] [stderr]    Compiling cfg-if v1.0.0
[INFO] [stderr]    Compiling autocfg v1.0.1
[INFO] [stderr]    Compiling unicode-width v0.1.8
[INFO] [stderr]    Compiling unicode-segmentation v1.8.0
[INFO] [stderr]    Compiling ppv-lite86 v0.2.10
[INFO] [stderr]    Compiling vec_map v0.8.2
[INFO] [stderr]    Compiling strsim v0.8.0
[INFO] [stderr]    Compiling ansi_term v0.11.0
[INFO] [stderr]    Compiling pin-project-lite v0.2.7
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling getrandom v0.2.3
[INFO] [stderr]    Compiling textwrap v0.11.0
[INFO] [stderr]    Compiling rand_core v0.6.3
[INFO] [stderr]    Compiling tokio v1.9.0
[INFO] [stderr]    Compiling proc-macro-error-attr v1.0.4
[INFO] [stderr]    Compiling proc-macro-error v1.0.4
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling heck v0.3.3
[INFO] [stderr]    Compiling clap v2.33.3
[INFO] [stderr]    Compiling rand v0.8.4
[INFO] [stderr]    Compiling quote v1.0.9
[INFO] [stderr]    Compiling structopt-derive v0.4.15
[INFO] [stderr]    Compiling structopt v0.3.22
[INFO] [stderr]    Compiling indicatif v0.17.0-beta.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 19.44s
[INFO] running `Command { std: "docker" "inspect" "cbffaa696eb0c20993a5045c50015e51ba986a44144d6b18824de1a905ce04a5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "cbffaa696eb0c20993a5045c50015e51ba986a44144d6b18824de1a905ce04a5", kill_on_drop: false }`
[INFO] [stdout] cbffaa696eb0c20993a5045c50015e51ba986a44144d6b18824de1a905ce04a5
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-64/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-64/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] 2c50f14424fc7bba17556856e13c3a390fdee60867cf3a499161651e0834f6cf
[INFO] running `Command { std: "docker" "start" "-a" "2c50f14424fc7bba17556856e13c3a390fdee60867cf3a499161651e0834f6cf", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.58s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/indicatif-719a23a8c2497c0d)
[INFO] [stdout] 
[INFO] [stdout] running 29 tests
[INFO] [stdout] test format::tests::human_duration_alternate ... ok
[INFO] [stdout] test format::tests::human_duration_less_than_one_second ... ok
[INFO] [stdout] test format::tests::human_duration_less_than_two_seconds ... ok
[INFO] [stdout] test format::tests::human_duration_one_and_a_half_unit ... ok
[INFO] [stdout] test format::tests::human_duration_one_unit ... ok
[INFO] [stdout] test format::tests::human_duration_two_and_a_half_units ... ok
[INFO] [stdout] test iter::test::it_can_wrap_an_iterator ... ok
[INFO] [stdout] test format::tests::human_duration_two_units ... ok
[INFO] [stdout] test format::tests::human_duration_three_units ... ok
[INFO] [stdout] test format::tests::human_duration_less_than_two_and_a_half_units ... ok
[INFO] [stdout] test progress_bar::tests::test_get_position ... ok
[INFO] [stdout] test progress_bar::tests::it_can_wrap_a_reader ... ok
[INFO] [stdout] test progress_bar::tests::late_pb_drop ... ok
[INFO] [stdout] test progress_bar::tests::multi_progress_multiple_remove ... ok
[INFO] [stdout] test progress_bar::tests::progress_bar_sync_send ... ok
[INFO] [stdout] test progress_bar::tests::test_draw_delta_deadlock ... ok
[INFO] [stdout] test progress_bar::tests::test_pbar_overflow ... ok
[INFO] [stdout] test format::tests::human_duration_less_than_one_and_a_half_unit ... ok
[INFO] [stdout] test progress_bar::tests::test_pbar_maxu64 ... ok
[INFO] [stdout] test progress_bar::tests::test_weak_pb ... ok
[INFO] [stdout] test progress_bar::tests::multi_progress_modifications ... ok
[INFO] [stdout] test progress_bar::tests::it_can_wrap_a_writer ... ok
[INFO] [stdout] test progress_bar::tests::test_abandon_deadlock ... ok
[INFO] [stdout] test style::tests::test_expand_template ... ok
[INFO] [stdout] test state::tests::test_time_per_step ... ok
[INFO] [stdout] test progress_bar::tests::multi_progress_hidden ... ok
[INFO] [stdout] test style::tests::test_expand_template_flags ... ok
[INFO] [stdout] test progress_bar::tests::test_pbar_zero ... ok
[INFO] [stdout] test state::tests::test_duration_stuff ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 29 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/multi-autodrop.rs (/opt/rustwide/target/debug/deps/multi_autodrop-5f0d4b4d776241a5)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test main ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.51s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests indicatif
[INFO] [stdout] 
[INFO] [stdout] running 14 tests
[INFO] [stdout] test src/draw_target.rs - draw_target::MultiProgressAlignment (line 413) ... ignored
[INFO] [stdout] test src/draw_target.rs - draw_target::MultiProgressAlignment (line 420) ... ignored
[INFO] [stdout] test src/lib.rs - (line 108) ... ignored
[INFO] [stdout] test src/lib.rs - (line 96) ... ignored
[INFO] [stdout] test src/progress_bar.rs - progress_bar::ProgressBar::wrap_iter (line 406) - compile ... ok
[INFO] [stdout] test src/progress_bar.rs - progress_bar::ProgressBar::set_draw_rate (line 179) - compile ... ok
[INFO] [stdout] test src/progress_bar.rs - progress_bar::ProgressBar::set_draw_target (line 389) - compile ... ok
[INFO] [stdout] test src/progress_bar.rs - progress_bar::ProgressBar::wrap_read (line 420) - compile ... ok
[INFO] [stdout] test src/progress_bar.rs - progress_bar::ProgressBar::wrap_write (line 441) - compile ... ok
[INFO] [stdout] test src/progress_bar.rs - progress_bar::ProgressBar::set_draw_delta (line 158) - compile ... ok
[INFO] [stdout] test src/lib.rs - (line 193) ... ok
[INFO] [stdout] test src/lib.rs - (line 150) ... ok
[INFO] [stdout] test src/lib.rs - (line 46) ... ok
[INFO] [stdout] test src/lib.rs - (line 75) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 4 ignored; 0 measured; 0 filtered out; finished in 0.64s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "2c50f14424fc7bba17556856e13c3a390fdee60867cf3a499161651e0834f6cf", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2c50f14424fc7bba17556856e13c3a390fdee60867cf3a499161651e0834f6cf", kill_on_drop: false }`
[INFO] [stdout] 2c50f14424fc7bba17556856e13c3a390fdee60867cf3a499161651e0834f6cf