[INFO] cloning repository https://github.com/dandelion-blanc/practice09_progressbar
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/dandelion-blanc/practice09_progressbar" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdandelion-blanc%2Fpractice09_progressbar", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdandelion-blanc%2Fpractice09_progressbar'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] c04280ce0f62c75590430aa56396e2318259387c
[INFO] testing dandelion-blanc/practice09_progressbar against try#c3758fdc4730d7700b25a13cccff296a08f42c00 for pr-91743
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdandelion-blanc%2Fpractice09_progressbar" "/workspace/builds/worker-46/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-46/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/dandelion-blanc/practice09_progressbar on toolchain c3758fdc4730d7700b25a13cccff296a08f42c00
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+c3758fdc4730d7700b25a13cccff296a08f42c00" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/dandelion-blanc/practice09_progressbar
[INFO] finished tweaking git repo https://github.com/dandelion-blanc/practice09_progressbar
[INFO] tweaked toml for git repo https://github.com/dandelion-blanc/practice09_progressbar written to /workspace/builds/worker-46/source/Cargo.toml
[INFO] crate git repo https://github.com/dandelion-blanc/practice09_progressbar already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+c3758fdc4730d7700b25a13cccff296a08f42c00" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-46/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-46/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:d190cb871061d98bc6d0581d85cb2ecb09a0f8a142ba5463de30be9999fc3251" "/opt/rustwide/cargo-home/bin/cargo" "+c3758fdc4730d7700b25a13cccff296a08f42c00" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 9007ead6194d24413aed6aa8928f4b8cdc353517e237d2230fa2c4d5093c8538
[INFO] running `Command { std: "docker" "start" "-a" "9007ead6194d24413aed6aa8928f4b8cdc353517e237d2230fa2c4d5093c8538", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "9007ead6194d24413aed6aa8928f4b8cdc353517e237d2230fa2c4d5093c8538", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9007ead6194d24413aed6aa8928f4b8cdc353517e237d2230fa2c4d5093c8538", kill_on_drop: false }`
[INFO] [stdout] 9007ead6194d24413aed6aa8928f4b8cdc353517e237d2230fa2c4d5093c8538
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-46/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-46/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:d190cb871061d98bc6d0581d85cb2ecb09a0f8a142ba5463de30be9999fc3251" "/opt/rustwide/cargo-home/bin/cargo" "+c3758fdc4730d7700b25a13cccff296a08f42c00" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] a64d756978f8dd45b7300f5dfca7721c71de4ebe02f00050e34a38d85d6be27b
[INFO] running `Command { std: "docker" "start" "-a" "a64d756978f8dd45b7300f5dfca7721c71de4ebe02f00050e34a38d85d6be27b", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling libc v0.2.76
[INFO] [stderr]    Compiling regex-syntax v0.6.18
[INFO] [stderr]    Compiling unicode-width v0.1.8
[INFO] [stderr]    Compiling lazy_static v1.4.0
[INFO] [stderr]    Compiling number_prefix v0.3.0
[INFO] [stderr]    Compiling terminal_size v0.1.13
[INFO] [stderr]    Compiling termios v0.3.2
[INFO] [stderr]    Compiling regex v1.3.9
[INFO] [stderr]    Compiling console v0.12.0
[INFO] [stderr]    Compiling indicatif v0.15.0 (https://github.com/mitsuhiko/indicatif.git?branch=main#b28cd22b)
[INFO] [stderr]    Compiling practice09_progressbar v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 29.84s
[INFO] running `Command { std: "docker" "inspect" "a64d756978f8dd45b7300f5dfca7721c71de4ebe02f00050e34a38d85d6be27b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a64d756978f8dd45b7300f5dfca7721c71de4ebe02f00050e34a38d85d6be27b", kill_on_drop: false }`
[INFO] [stdout] a64d756978f8dd45b7300f5dfca7721c71de4ebe02f00050e34a38d85d6be27b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-46/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-46/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:d190cb871061d98bc6d0581d85cb2ecb09a0f8a142ba5463de30be9999fc3251" "/opt/rustwide/cargo-home/bin/cargo" "+c3758fdc4730d7700b25a13cccff296a08f42c00" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] be4cec616eda46084bad73c7620e9e891667ad6a6ac45b47f54a819dfe3565d6
[INFO] running `Command { std: "docker" "start" "-a" "be4cec616eda46084bad73c7620e9e891667ad6a6ac45b47f54a819dfe3565d6", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling practice09_progressbar v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 1m 12s
[INFO] [stderr]   Executable unittests src/main.rs (/opt/rustwide/target/debug/deps/practice09_progressbar-5991d2a37bd73034)
[INFO] running `Command { std: "docker" "inspect" "be4cec616eda46084bad73c7620e9e891667ad6a6ac45b47f54a819dfe3565d6", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "be4cec616eda46084bad73c7620e9e891667ad6a6ac45b47f54a819dfe3565d6", kill_on_drop: false }`
[INFO] [stdout] be4cec616eda46084bad73c7620e9e891667ad6a6ac45b47f54a819dfe3565d6
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-46/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-46/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:d190cb871061d98bc6d0581d85cb2ecb09a0f8a142ba5463de30be9999fc3251" "/opt/rustwide/cargo-home/bin/cargo" "+c3758fdc4730d7700b25a13cccff296a08f42c00" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 337f2ea836357fbaab360223eeef7b6d089c319216461b4e11bdf38f4e4db167
[INFO] running `Command { std: "docker" "start" "-a" "337f2ea836357fbaab360223eeef7b6d089c319216461b4e11bdf38f4e4db167", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[ERROR] error running command: no output for 300 seconds
[INFO] running `Command { std: "docker" "inspect" "337f2ea836357fbaab360223eeef7b6d089c319216461b4e11bdf38f4e4db167", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "337f2ea836357fbaab360223eeef7b6d089c319216461b4e11bdf38f4e4db167", kill_on_drop: false }`
[INFO] [stdout] 337f2ea836357fbaab360223eeef7b6d089c319216461b4e11bdf38f4e4db167