[INFO] fetching crate messaging_thread_pool 3.1.0... [INFO] testing messaging_thread_pool-3.1.0 against 1.73.0 for beta-1.74-1 [INFO] extracting crate messaging_thread_pool 3.1.0 into /workspace/builds/worker-6-tc1/source [INFO] validating manifest of crates.io crate messaging_thread_pool 3.1.0 on toolchain 1.73.0 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.73.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate messaging_thread_pool 3.1.0 [INFO] finished tweaking crates.io crate messaging_thread_pool 3.1.0 [INFO] tweaked toml for crates.io crate messaging_thread_pool 3.1.0 written to /workspace/builds/worker-6-tc1/source/Cargo.toml [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.73.0" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Updating crates.io index [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.73.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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:4f8da3c744d2da974e54ce020a79f4ad54313e914ebeaab8fc086f07e8d8b066" "/opt/rustwide/cargo-home/bin/cargo" "+1.73.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] b07deeeab3fc15b1c4ff77db50e272251fc3bd82c4abd014fb08bacacc01301f [INFO] running `Command { std: "docker" "start" "-a" "b07deeeab3fc15b1c4ff77db50e272251fc3bd82c4abd014fb08bacacc01301f", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "b07deeeab3fc15b1c4ff77db50e272251fc3bd82c4abd014fb08bacacc01301f", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "b07deeeab3fc15b1c4ff77db50e272251fc3bd82c4abd014fb08bacacc01301f", kill_on_drop: false }` [INFO] [stdout] b07deeeab3fc15b1c4ff77db50e272251fc3bd82c4abd014fb08bacacc01301f [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-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:4f8da3c744d2da974e54ce020a79f4ad54313e914ebeaab8fc086f07e8d8b066" "/opt/rustwide/cargo-home/bin/cargo" "+1.73.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] b46f72dc20b87fcb32d065f2b202120bcd8668eaad23c359bf3ea36053c6b93a [INFO] running `Command { std: "docker" "start" "-a" "b46f72dc20b87fcb32d065f2b202120bcd8668eaad23c359bf3ea36053c6b93a", kill_on_drop: false }` [INFO] [stderr] Compiling serde v1.0.188 [INFO] [stderr] Compiling itoa v1.0.9 [INFO] [stderr] Compiling serde_json v1.0.107 [INFO] [stderr] Compiling crossbeam-utils v0.8.16 [INFO] [stderr] Compiling tracing-core v0.1.31 [INFO] [stderr] Compiling ryu v1.0.15 [INFO] [stderr] Compiling overload v0.1.1 [INFO] [stderr] Compiling log v0.4.20 [INFO] [stderr] Compiling nu-ansi-term v0.46.0 [INFO] [stderr] Compiling syn v2.0.38 [INFO] [stderr] Compiling sharded-slab v0.1.7 [INFO] [stderr] Compiling thread_local v1.1.7 [INFO] [stderr] Compiling time-core v0.1.2 [INFO] [stderr] Compiling deranged v0.3.8 [INFO] [stderr] Compiling smallvec v1.11.1 [INFO] [stderr] Compiling tracing-log v0.1.3 [INFO] [stderr] Compiling pin-project-lite v0.2.13 [INFO] [stderr] Compiling crossbeam-channel v0.5.8 [INFO] [stderr] Compiling rand_xoshiro v0.6.0 [INFO] [stderr] Compiling time v0.3.29 [INFO] [stderr] Compiling tracing-serde v0.1.3 [INFO] [stderr] Compiling tracing-subscriber v0.3.17 [INFO] [stderr] Compiling tracing-attributes v0.1.26 [INFO] [stderr] Compiling tracing-appender v0.2.2 [INFO] [stderr] Compiling tracing v0.1.37 [INFO] [stderr] Compiling messaging_thread_pool v3.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 17.29s [INFO] running `Command { std: "docker" "inspect" "b46f72dc20b87fcb32d065f2b202120bcd8668eaad23c359bf3ea36053c6b93a", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "b46f72dc20b87fcb32d065f2b202120bcd8668eaad23c359bf3ea36053c6b93a", kill_on_drop: false }` [INFO] [stdout] b46f72dc20b87fcb32d065f2b202120bcd8668eaad23c359bf3ea36053c6b93a [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-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:4f8da3c744d2da974e54ce020a79f4ad54313e914ebeaab8fc086f07e8d8b066" "/opt/rustwide/cargo-home/bin/cargo" "+1.73.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] db55def9a809e42303ec4a080e34fe05bdd9f01f3dcff68e8bb6c60c2c4ba7da [INFO] running `Command { std: "docker" "start" "-a" "db55def9a809e42303ec4a080e34fe05bdd9f01f3dcff68e8bb6c60c2c4ba7da", kill_on_drop: false }` [INFO] [stderr] Compiling crossbeam-utils v0.8.16 [INFO] [stderr] Compiling serde v1.0.188 [INFO] [stderr] Compiling memoffset v0.9.0 [INFO] [stderr] Compiling crossbeam-epoch v0.9.15 [INFO] [stderr] Compiling scopeguard v1.2.0 [INFO] [stderr] Compiling syn v2.0.38 [INFO] [stderr] Compiling num-traits v0.2.17 [INFO] [stderr] Compiling either v1.9.0 [INFO] [stderr] Compiling rayon-core v1.12.0 [INFO] [stderr] Compiling plotters-backend v0.3.5 [INFO] [stderr] Compiling ciborium-io v0.2.1 [INFO] [stderr] Compiling regex-syntax v0.7.5 [INFO] [stderr] Compiling half v1.8.2 [INFO] [stderr] Compiling itertools v0.10.5 [INFO] [stderr] Compiling same-file v1.0.6 [INFO] [stderr] Compiling plotters-svg v0.3.5 [INFO] [stderr] Compiling cast v0.3.0 [INFO] [stderr] Compiling ciborium-ll v0.2.1 [INFO] [stderr] Compiling crossbeam-channel v0.5.8 [INFO] [stderr] Compiling clap v3.2.25 [INFO] [stderr] Compiling walkdir v2.4.0 [INFO] [stderr] Compiling crossbeam-deque v0.8.3 [INFO] [stderr] Compiling plotters v0.3.5 [INFO] [stderr] Compiling atty v0.2.14 [INFO] [stderr] Compiling anes v0.1.6 [INFO] [stderr] Compiling oorandom v11.1.3 [INFO] [stderr] Compiling regex-automata v0.3.9 [INFO] [stderr] Compiling criterion-plot v0.5.0 [INFO] [stderr] Compiling rayon v1.8.0 [INFO] [stderr] Compiling regex v1.9.6 [INFO] [stderr] Compiling serde_derive v1.0.188 [INFO] [stderr] Compiling tracing-attributes v0.1.26 [INFO] [stderr] Compiling tracing v0.1.37 [INFO] [stderr] Compiling serde_json v1.0.107 [INFO] [stderr] Compiling tracing-serde v0.1.3 [INFO] [stderr] Compiling ciborium v0.2.1 [INFO] [stderr] Compiling tracing-subscriber v0.3.17 [INFO] [stderr] Compiling tinytemplate v1.2.1 [INFO] [stderr] Compiling criterion v0.4.0 [INFO] [stderr] Compiling tracing-appender v0.2.2 [INFO] [stderr] Compiling messaging_thread_pool v3.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 54.56s [INFO] running `Command { std: "docker" "inspect" "db55def9a809e42303ec4a080e34fe05bdd9f01f3dcff68e8bb6c60c2c4ba7da", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "db55def9a809e42303ec4a080e34fe05bdd9f01f3dcff68e8bb6c60c2c4ba7da", kill_on_drop: false }` [INFO] [stdout] db55def9a809e42303ec4a080e34fe05bdd9f01f3dcff68e8bb6c60c2c4ba7da [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-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:4f8da3c744d2da974e54ce020a79f4ad54313e914ebeaab8fc086f07e8d8b066" "/opt/rustwide/cargo-home/bin/cargo" "+1.73.0" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 84edfaab54a38be67deb15e4c6720b3df5c0db80f74de3785ee3ab761fea6dfb [INFO] running `Command { std: "docker" "start" "-a" "84edfaab54a38be67deb15e4c6720b3df5c0db80f74de3785ee3ab761fea6dfb", kill_on_drop: false }` [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.11s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/messaging_thread_pool-53d64c60bede60ca) [INFO] [stdout] [INFO] [stdout] running 75 tests [INFO] [stdout] test id_provider::id_provider_static::tests::get_first_id_gets_starting_id ... ignored, cannot test in test runner as it contains static variable [INFO] [stdout] test id_provider::id_provider_static::tests::getting_successive_id_providers_provides_successive_ids ... ignored, cannot test in test runner as it contains static variable [INFO] [stdout] test id_provider::id_provider_static::tests::peek_successive_id_providers_provides_successive_ids ... ignored, cannot test in test runner as it contains static variable [INFO] [stdout] test id_provider::id_provider_static::tests::visual_test ... ignored, cannot test in test runner as it contains static variable [INFO] [stdout] test id_provider::id_provider_mutex::tests::gets_ids_as_expected ... ok [INFO] [stdout] test id_provider::id_provider_mutex::tests::peek_id_as_expected ... ok [INFO] [stdout] test new::tests::new_called_with_thread_pool_size_2_two_threads_created ... ok [INFO] [stdout] test drop::tests::one_thread_drop_clean_shutdown_as_expected ... ok [INFO] [stdout] test pool_thread::message_loop::tests::id_1_receives_shutdown_message_exits_loop ... ok [INFO] [stdout] test pool_thread::message_loop::tests::id_2_receives_shutdown_message_exits_loop ... ok [INFO] [stdout] test pool_thread::message_loop::tests::init_id_101_102_thread_shutdown_clears_the_elements_returns_expected_shutdown_threads ... ok [INFO] [stdout] test pool_thread::message_loop::tests::id_1_receives_abort_message_exits_loop ... ok [INFO] [stdout] test pool_thread::message_loop::tests::echo_message_responds_as_expected ... ok [INFO] [stdout] test new::tests::new_called_with_thread_pool_size_1_one_thread_created ... ok [INFO] [stdout] test pool_thread::message_loop::tests::id_2_receives_abort_message_exits_loop ... ok [INFO] [stdout] test pool_thread::message_loop::tests::send_init_id_1_expected_element_added_to_map ... ok [INFO] [stdout] test pool_thread::message_loop::tests::init_id_1_2_thread_shutdown_clears_the_elements_returns_expected_shutdown_threads ... ok [INFO] [stdout] test pool_thread::message_loop::tests::send_init_id_2_expected_element_added_to_map_set ... ok [INFO] [stdout] test pool_thread::message_loop::tests::send_init_id_2_twice_returns_response_indicating_second_request_was_ignored ... ok [INFO] [stdout] test pool_thread::message_loop::tests::send_remove_element_with_id_12_expected_element_removed_from_map_set ... ok [INFO] [stdout] test pool_thread::shutdown_child_pool::tests::thread_pool_contains_single_element_1 ... ok [INFO] [stdout] test pool_thread::shutdown_child_pool::tests::thread_pool_contains_single_element_2 ... ok [INFO] [stdout] test pool_thread::message_loop::tests::init_id_101_send_get_state_message_to_element_retrieved_expected_response ... ok [INFO] [stdout] test pool_thread::shutdown_child_pool::tests::thread_pool_contains_no_elements_shutdown_returns_empty_vec ... ok [INFO] [stdout] test pool_thread::message_loop::tests::send_remove_element_with_id_2_expected_element_removed_from_map_set ... ok [INFO] [stdout] test receive::tests::single_init_request_on_a_single_thread_received_single_response_received ... ok [INFO] [stdout] test request_response::id_targeted::tests::request_response_contains_request_id_0_returns_0 ... ok [INFO] [stdout] test samples::randoms::randoms_api::tests::returns_expected_ids_for_all_api_variants ... ok [INFO] [stdout] test request_response::tests::request_response_contains_request_request_returns_request ... ok [INFO] [stdout] test request_response::id_targeted::tests::request_response_contains_request_id_1_returns_1 ... ok [INFO] [stdout] test send::tests::pool_with_two_threads_sends_echo_requests_echo_requests_processed_by_thread_0_and_thread_1 ... ok [INFO] [stdout] test receive::tests::three_init_requests_two_thread_received_three_responses_received ... ok [INFO] [stdout] test send_and_receive::tests::single_thread_single_init_receives_expected_response ... ok [INFO] [stdout] test sender_and_receiver::sender_and_receiver_mock::tests::check_mock_send_and_sync ... ok [INFO] [stdout] test send_and_receive::tests::two_threads_three_echoes_receives_expected_response ... ok [INFO] [stdout] test sender_and_receiver::sender_and_receiver_mock::tests::one_response_empty_requests_returns_empty_iterator ... ok [INFO] [stdout] test sender_and_receiver::sender_and_receiver_mock::tests::one_response_only_returns_expected_response ... ok [INFO] [stdout] test sender_and_receiver::sender_and_receiver_mock::tests::two_responses_only_one_returned_is_complete_returns_false ... ok [INFO] [stdout] test sender_and_receiver::sender_and_receiver_mock::tests::two_responses_returned_over_multiple_requests ... ok [INFO] [stdout] test send::tests::pool_with_single_thread_sends_echo_request_echo_request_processed_by_thread_0 ... ok [INFO] [stdout] test send::tests::pool_with_one_threads_send_two_echo_requests_both_processed_by_thread_0 ... ok [INFO] [stdout] test sender_and_receiver::sender_and_receiver_mock::tests::zero_responses_returns_empty_iterator ... ok [INFO] [stdout] test sender_and_receiver::sender_and_receiver_raw_mock::tests::empty_requests_and_responses_does_not_panic ... ok [INFO] [stdout] test sender_and_receiver::sender_and_receiver_mock::tests::empty_requests_and_responses_does_not_panic ... ok [INFO] [stdout] test sender_and_receiver::sender_and_receiver_raw_mock::tests::check_mock_send_and_sync ... ok [INFO] [stdout] test sender_and_receiver::sender_and_receiver_raw_mock::tests::one_response_empty_requests_returns_empty_iterator ... ok [INFO] [stdout] test sender_and_receiver::sender_and_receiver_raw_mock::tests::one_response_only_returns_expected_response ... ok [INFO] [stdout] test sender_and_receiver::sender_and_receiver_raw_mock::tests::two_responses_only_one_returned_is_complete_returns_false ... ok [INFO] [stdout] test sender_and_receiver::sender_and_receiver_raw_mock::tests::two_responses_returned_over_multiple_heterogeneous_requests ... ok [INFO] [stdout] test sender_and_receiver::sender_and_receiver_raw_mock::tests::two_responses_returned_over_multiple_requests ... ok [INFO] [stdout] test request_response::tests::request_response_contains_response_request_panics - should panic ... ok [INFO] [stdout] test request_response::id_targeted::tests::request_response_contains_response_request_panics - should panic ... ok [INFO] [stdout] test sender_and_receiver::sender_and_receiver_mock::tests::one_expected_request_actual_requests_2_panics - should panic ... ok [INFO] [stdout] test sender_and_receiver::sender_and_receiver_mock::tests::unmatched_requests_and_responses - should panic ... ok [INFO] [stdout] test sender_and_receiver::tests::send_and_receive_one_functions_as_expected ... ok [INFO] [stdout] test sender_and_receiver::sender_and_receiver_raw_mock::tests::zero_responses_returns_empty_iterator ... ok [INFO] [stdout] test shutdown::tests::two_threads_clean_shutdown_as_expected ... ok [INFO] [stdout] test sender_and_receiver::sender_and_receiver_mock::tests::one_expected_request_differs_from_one_actual_request - should panic ... ok [INFO] [stdout] test tests::thread_pool_size_1_thread_count_1 ... ok [INFO] [stdout] test shutdown::tests::two_threads_each_containing_a_sample_element_shutdown_simulates_child_thread_shutdown ... ok [INFO] [stdout] test shutdown::tests::single_thread_clean_shutdown_as_expected ... ok [INFO] [stdout] test sender_and_receiver::sender_and_receiver_raw_mock::tests::one_expected_request_actual_requests_2_panics - should panic ... ok [INFO] [stdout] test sender_and_receiver::sender_and_receiver_raw_mock::tests::one_expected_request_differs_from_one_actual_request - should panic ... ok [INFO] [stdout] test sender_and_receiver::sender_and_receiver_raw_mock::tests::unmatched_requests_and_responses - should panic ... ok [INFO] [stdout] test thread_request_response::thread_abort_request::tests::request_id_1_id_returns_1 ... ok [INFO] [stdout] test thread_request_response::thread_abort_request::tests::request_id_2_id_returns_2 ... ok [INFO] [stdout] test thread_request_response::thread_echo_request::tests::request_id_1_id_returns_1 ... ok [INFO] [stdout] test thread_request_response::thread_shutdown_request::tests::request_id_1_id_returns_1 ... ok [INFO] [stdout] test thread_request_response::thread_shutdown_request::tests::request_id_2_id_returns_2 ... ok [INFO] [stdout] test thread_endpoint::send::tests::pass_echo_message_through_echo_message_received_at_other_end_of_channel ... ok [INFO] [stdout] test tests::thread_pool_size_2_thread_count_2 ... ok [INFO] [stdout] test thread_request_response::remove_pool_item_request::tests::request_id_2_id_returns_2 ... ok [INFO] [stdout] test thread_request_response::thread_echo_request::tests::request_id_2_id_returns_2 ... ok [INFO] [stdout] test thread_request_response::remove_pool_item_request::tests::request_id_1_id_returns_1 ... ok [INFO] [stdout] test shutdown::tests::single_thread_errors_trying_to_send_request_shutdown_does_not_panic has been running for over 60 seconds [ERROR] error running command: no output for 300 seconds [INFO] running `Command { std: "docker" "inspect" "84edfaab54a38be67deb15e4c6720b3df5c0db80f74de3785ee3ab761fea6dfb", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "84edfaab54a38be67deb15e4c6720b3df5c0db80f74de3785ee3ab761fea6dfb", kill_on_drop: false }` [INFO] [stdout] 84edfaab54a38be67deb15e4c6720b3df5c0db80f74de3785ee3ab761fea6dfb