[INFO] fetching crate solverforge-console 0.13.0...
[INFO] testing solverforge-console-0.13.0 against master#ec6f9a5b4413f74386267ef8efc93712c2ce6db6 for pr-155739-1
[INFO] extracting crate solverforge-console 0.13.0 into /workspace/builds/worker-3-tc1/source
[INFO] started tweaking crates.io crate solverforge-console 0.13.0
[INFO] finished tweaking crates.io crate solverforge-console 0.13.0
[INFO] tweaked toml for crates.io crate solverforge-console 0.13.0 written to /workspace/builds/worker-3-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate solverforge-console 0.13.0 on toolchain ec6f9a5b4413f74386267ef8efc93712c2ce6db6
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate solverforge-console 0.13.0 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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] b9d6785ef00bd287ca26fbe15e75d85b02722b6f650e6a6c9c4da8d5a09359d1
[INFO] running `Command { std: "docker" "start" "-a" "b9d6785ef00bd287ca26fbe15e75d85b02722b6f650e6a6c9c4da8d5a09359d1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "b9d6785ef00bd287ca26fbe15e75d85b02722b6f650e6a6c9c4da8d5a09359d1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b9d6785ef00bd287ca26fbe15e75d85b02722b6f650e6a6c9c4da8d5a09359d1", kill_on_drop: false }`
[INFO] [stdout] b9d6785ef00bd287ca26fbe15e75d85b02722b6f650e6a6c9c4da8d5a09359d1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d9d97a70eb4d74415fe5fbc0ff4f6a7ffda88dd07e1e1aa68e2c0ca186373661
[INFO] running `Command { std: "docker" "start" "-a" "d9d97a70eb4d74415fe5fbc0ff4f6a7ffda88dd07e1e1aa68e2c0ca186373661", kill_on_drop: false }`
[INFO] [stderr]    Compiling regex-syntax v0.8.10
[INFO] [stderr]    Compiling owo-colors v4.3.0
[INFO] [stderr]    Compiling arrayvec v0.7.6
[INFO] [stderr]    Compiling tracing-log v0.2.0
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling num-format v0.4.4
[INFO] [stderr]    Compiling regex-automata v0.4.14
[INFO] [stderr]    Compiling matchers v0.2.0
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling tracing-subscriber v0.3.23
[INFO] [stderr]    Compiling solverforge-console v0.13.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 13.31s
[INFO] running `Command { std: "docker" "inspect" "d9d97a70eb4d74415fe5fbc0ff4f6a7ffda88dd07e1e1aa68e2c0ca186373661", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d9d97a70eb4d74415fe5fbc0ff4f6a7ffda88dd07e1e1aa68e2c0ca186373661", kill_on_drop: false }`
[INFO] [stdout] d9d97a70eb4d74415fe5fbc0ff4f6a7ffda88dd07e1e1aa68e2c0ca186373661
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 261c5b9f670932375a1a5adfbd121327fd56a7504e710069089713b8da11d3ed
[INFO] running `Command { std: "docker" "start" "-a" "261c5b9f670932375a1a5adfbd121327fd56a7504e710069089713b8da11d3ed", kill_on_drop: false }`
[INFO] [stderr]    Compiling solverforge-console v0.13.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.98s
[INFO] running `Command { std: "docker" "inspect" "261c5b9f670932375a1a5adfbd121327fd56a7504e710069089713b8da11d3ed", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "261c5b9f670932375a1a5adfbd121327fd56a7504e710069089713b8da11d3ed", kill_on_drop: false }`
[INFO] [stdout] 261c5b9f670932375a1a5adfbd121327fd56a7504e710069089713b8da11d3ed
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 5929b4e2d5af606a6d0e12b267bada6be9e56ef0acba8fdc4dedac28be5bde0a
[INFO] running `Command { std: "docker" "start" "-a" "5929b4e2d5af606a6d0e12b267bada6be9e56ef0acba8fdc4dedac28be5bde0a", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.08s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/solverforge_console-8bd36af9d5cb1675)
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test format::tests::format_event_renders_phase_end_with_exact_duration_string ... ok
[INFO] [stderr]    Doc-tests solverforge_console
[INFO] [stdout] test format::tests::calculate_problem_scale_handles_zero_and_nonzero_inputs ... ok
[INFO] [stdout] test format::tests::format_event_renders_solve_start_and_end_summaries ... ok
[INFO] [stdout] test format::tests::format_event_renders_phase_start_score_when_present ... ok
[INFO] [stdout] test format::tests::format_event_renders_progress_and_trace_steps ... ok
[INFO] [stdout] test format::tests::format_elapsed_duration_uses_exact_integer_units ... ok
[INFO] [stdout] test format::tests::format_score_handles_hard_soft_and_simple_scores ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[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] running `Command { std: "docker" "inspect" "5929b4e2d5af606a6d0e12b267bada6be9e56ef0acba8fdc4dedac28be5bde0a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5929b4e2d5af606a6d0e12b267bada6be9e56ef0acba8fdc4dedac28be5bde0a", kill_on_drop: false }`
[INFO] [stdout] 5929b4e2d5af606a6d0e12b267bada6be9e56ef0acba8fdc4dedac28be5bde0a
