[INFO] fetching crate retrogress 1.1.0...
[INFO] testing retrogress-1.1.0 against master#cdb45c87e2cd43495379f7e867e3cc15dcee9f93 for pr-145838-1
[INFO] extracting crate retrogress 1.1.0 into /workspace/builds/worker-7-tc1/source
[INFO] started tweaking crates.io crate retrogress 1.1.0
[INFO] removed 0 missing examples
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate retrogress 1.1.0
[INFO] tweaked toml for crates.io crate retrogress 1.1.0 written to /workspace/builds/worker-7-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate retrogress 1.1.0 on toolchain cdb45c87e2cd43495379f7e867e3cc15dcee9f93
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate retrogress 1.1.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" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "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-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] c2938f8d0d0cca8821610355a578e92c7021f99ff6d5aeb6dd3659c1c1df9c85
[INFO] running `Command { std: "docker" "start" "-a" "c2938f8d0d0cca8821610355a578e92c7021f99ff6d5aeb6dd3659c1c1df9c85", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "c2938f8d0d0cca8821610355a578e92c7021f99ff6d5aeb6dd3659c1c1df9c85", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c2938f8d0d0cca8821610355a578e92c7021f99ff6d5aeb6dd3659c1c1df9c85", kill_on_drop: false }`
[INFO] [stdout] c2938f8d0d0cca8821610355a578e92c7021f99ff6d5aeb6dd3659c1c1df9c85
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 46391de67f78930182af3a04bfea8bc2e4ef5f172402b3f22c3305c7b127776c
[INFO] running `Command { std: "docker" "start" "-a" "46391de67f78930182af3a04bfea8bc2e4ef5f172402b3f22c3305c7b127776c", kill_on_drop: false }`
[INFO] [stderr]    Compiling unicode-width v0.2.1
[INFO] [stderr]    Compiling console v0.16.0
[INFO] [stderr]    Compiling retrogress v1.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 1.62s
[INFO] running `Command { std: "docker" "inspect" "46391de67f78930182af3a04bfea8bc2e4ef5f172402b3f22c3305c7b127776c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "46391de67f78930182af3a04bfea8bc2e4ef5f172402b3f22c3305c7b127776c", kill_on_drop: false }`
[INFO] [stdout] 46391de67f78930182af3a04bfea8bc2e4ef5f172402b3f22c3305c7b127776c
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 431eadff2a3de478b9705ba33310eb9674a7fead9300cca2b2e12324fe8941c0
[INFO] running `Command { std: "docker" "start" "-a" "431eadff2a3de478b9705ba33310eb9674a7fead9300cca2b2e12324fe8941c0", kill_on_drop: false }`
[INFO] [stderr]    Compiling getrandom v0.3.3
[INFO] [stderr]    Compiling cfg-if v1.0.1
[INFO] [stderr]    Compiling rand_core v0.9.3
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling rand v0.9.2
[INFO] [stderr]    Compiling retrogress v1.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 3.53s
[INFO] running `Command { std: "docker" "inspect" "431eadff2a3de478b9705ba33310eb9674a7fead9300cca2b2e12324fe8941c0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "431eadff2a3de478b9705ba33310eb9674a7fead9300cca2b2e12324fe8941c0", kill_on_drop: false }`
[INFO] [stdout] 431eadff2a3de478b9705ba33310eb9674a7fead9300cca2b2e12324fe8941c0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] cbbd9544fba0443a35d0374297d853f8d01f316c267fe689c9c4291868ff4a15
[INFO] running `Command { std: "docker" "start" "-a" "cbbd9544fba0443a35d0374297d853f8d01f316c267fe689c9c4291868ff4a15", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.03s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/retrogress-77ee6a6ebe3e4f0f)
[INFO] [stdout] 
[INFO] [stdout] running 61 tests
[INFO] [stdout] [?25ltest parallel::tests::channel_disconnection_after_worker_panic ... ok
[INFO] [stdout] test parallel::tests::parallel_drop_shuts_down_worker_thread ... ok
[INFO] [stdout] test parallel::tests::operations_after_channel_failure ... ok
[INFO] [stdout] test parallel::tests::parallel_append_returns_unique_refs ... ok
[INFO] [stdout] test parallel::tests::parallel_concurrent_access ... ok
[INFO] [stdout] [?25ltest parallel::tests::parallel_implements_progress_trait ... ok
[INFO] [stdout] test parallel::tests::parallel_default_creates_worker_thread ... ok
[INFO] [stdout] test parallel::tests::parallel_failed_operation ... ok
[INFO] [stdout] test parallel::tests::parallel_boxed_returns_boxed_instance ... ok
[INFO] [stdout] [?25l[?25l[?25ltest parallel::tests::parallel_multiple_operations_sequence ... ok
[INFO] [stdout] [?25ltest parallel::tests::parallel_operations_do_not_panic ... ok
[INFO] [stdout] [?25ltest parallel::tests::graceful_handling_of_channel_errors ... ok
[INFO] [stdout] test parallel::tests::parallel_message_sender_channel_works ... ok
[INFO] [stdout] test parallel::tests::progress_message_debug_trait ... ok
[INFO] [stdout] test parallel::tests::progress_bar_state_buffer ... ok
[INFO] [stdout] test parallel::tests::parallel_new_creates_worker_thread ... ok
[INFO] [stdout] test parallel::tests::parallel_worker_thread_processes_shutdown ... ok
[INFO] [stdout] [?25ltest progress::tests::ref_is_copy_and_clone ... ok
[INFO] [stdout] [?25l[?25ltest progress::tests::ref_new_generates_unique_ids ... ok
[INFO] [stdout] test progress::tests::progress_bar_is_send_and_sync ... ok
[INFO] [stdout] test progress::tests::ref_default_creates_new_ref ... ok
[INFO] [stdout] test render::tests::progress_bar_clone ... ok
[INFO] [stdout] test render::tests::progress_bar_hide ... ok
[INFO] [stdout] [?25ltest render::tests::progress_bar_finish ... ok
[INFO] [stdout] test render::tests::progress_bar_finished_stops_spinner_updates ... ok
[INFO] [stdout] test render::tests::progress_bar_new_creates_with_message ... ok
[INFO] [stdout] test render::tests::progress_bar_println_when_hidden ... ok
[INFO] [stdout] test render::tests::progress_bar_println_when_visible ... ok
[INFO] [stdout] test render::tests::progress_bar_set_message ... ok
[INFO] [stdout] test render::tests::progress_bar_set_prefix ... ok
[INFO] [stdout] test render::tests::progress_bar_tick_updates_spinner ... ok
[INFO] [stdout] test render::tests::spinner_chars_constant ... ok
[INFO] [stdout] test render::tests::progress_bar_show ... ok
[INFO] [stdout] test sync::tests::sync_append_returns_different_refs_for_different_messages ... ok
[INFO] [stdout] test sync::tests::sync_append_creates_and_stores_progress_bar ... ok
[INFO] [stdout] test sync::tests::sync_boxed_returns_boxed_instance ... ok
[INFO] [stdout] test sync::tests::sync_default_creates_empty_progress_tracker ... ok
[INFO] [stdout] test sync::tests::sync_failed_operation_with_valid_reference ... ok
[INFO] [stdout] test sync::tests::sync_implements_progress_trait ... ok
[INFO] [stdout] test sync::tests::sync_multiple_append_and_operations ... ok
[INFO] [stdout] test sync::tests::sync_new_creates_empty_progress_tracker ... ok
[INFO] [stdout] test sync::tests::sync_operations_with_valid_reference ... ok
[INFO] [stdout] test sync::tests::sync_hide_panics_with_invalid_reference - should panic ... ok
[INFO] [stdout] test sync::tests::sync_failed_panics_with_invalid_reference - should panic ... ok
[INFO] [stdout] test sync::tests::sync_set_message_panics_with_invalid_reference - should panic ... ok
[INFO] [stdout] test sync::tests::sync_println_panics_with_invalid_reference - should panic ... ok
[INFO] [stdout] test sync::tests::sync_show_panics_with_invalid_reference - should panic ... ok
[INFO] [stdout] test sync::tests::sync_succeeded_panics_with_invalid_reference - should panic ... ok
[INFO] [stdout] [?25h[?25htest parallel::tests::stress_high_frequency_concurrent_operations ... ok
[INFO] [stdout] [?25h[?25htest progress::tests::progress_bar_append_delegates_to_implementation ... ok
[INFO] [stdout] test parallel::tests::performance_under_high_load ... ok
[INFO] [stdout] [?25htest progress::tests::progress_bar_clone ... ok
[INFO] [stdout] test parallel::tests::many_concurrent_threads_same_progress_bar ... ok
[INFO] [stdout] [?25htest progress::tests::progress_bar_hide_delegates_to_implementation ... ok
[INFO] [stdout] [?25htest progress::tests::progress_bar_set_message_delegates_to_implementation ... ok
[INFO] [stdout] [?25htest progress::tests::progress_bar_show_delegates_to_implementation ... ok
[INFO] [stdout] [?25htest progress::tests::progress_bar_failed_delegates_to_implementation ... ok
[INFO] [stdout] [?25htest progress::tests::progress_bar_succeeded_delegates_to_implementation ... ok
[INFO] [stdout] [?25htest progress::tests::progress_bar_println_delegates_to_implementation ... ok
[INFO] [stdout] test parallel::tests::parallel_render_sends_tick_message ... ok
[INFO] [stdout] test parallel::tests::parallel_render_with_multiple_progress_bars ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 61 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.16s
[INFO] [stdout] 
[INFO] [stderr] [?25l
[?25l
[?25l[?25l[?25l[?25l[?25l[?25l[?25l[?25l
[?25l
















































































































































[?25h[?25h[?25h[?25h[?25h[?25h[?25h[?25h[?25h[?25h[?25h     Running tests/integration_tests.rs (/opt/rustwide/target/debug/deps/integration_tests-cdffb1e3db63f7d7)
[INFO] [stdout] 
[INFO] [stdout] running 13 tests
[INFO] [stdout] [?25l[?25l[?25l[?25l[?25l[?25l[?25l[?25l[?25l[?25l[?25l[?25l[?25l[?25htest interleaved_operations ... ok
[INFO] [stdout] [?25htest empty_messages ... ok
[INFO] [stdout] [?25htest many_progress_bars ... ok
[INFO] [stdout] [?25h[?25htest progress_bar_hide_and_show ... ok
[INFO] [stdout] [?25h[?25h[?25h[?25h[?25htest parallel_progress_bar_multiple_threads ... ok
[INFO] [stdout] test rapid_operations ... ok
[INFO] [stdout] test parallel_progress_bar_basic_usage ... ok
[INFO] [stdout] test sync_progress_bar_basic_usage ... ok
[INFO] [stdout] [?25ltest parallel_many_progress_bars ... ok
[INFO] [stdout] [?25htest unicode_messages ... ok
[INFO] [stdout] [?25h[?25htest progress_bar_clone_and_move ... ok
[INFO] [stdout] test very_long_messages ... ok
[INFO] [stdout] [?25htest channel_disconnection_handling ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.18s
[INFO] [stdout] 
[INFO] [stderr] [?25l[?25l[?25l



[?25l
[?25l[?25l[?25l
















[?25l






























































































[?25l[?25l
[?25l



[?25l




[?25l







[?25h[?25h[?25h[?25h[?25h[?25h[?25h[?25h[?25h[?25h[?25l[?25h[?25h[?25h[?25h   Doc-tests retrogress
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test src/parallel/mod.rs - parallel::Parallel (line 58) ... ok
[INFO] [stdout] test src/lib.rs - (line 8) ... ok
[INFO] [stdout] test src/sync/mod.rs - sync::Sync (line 11) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.28s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "cbbd9544fba0443a35d0374297d853f8d01f316c267fe689c9c4291868ff4a15", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "cbbd9544fba0443a35d0374297d853f8d01f316c267fe689c9c4291868ff4a15", kill_on_drop: false }`
[INFO] [stdout] cbbd9544fba0443a35d0374297d853f8d01f316c267fe689c9c4291868ff4a15