[INFO] fetching crate foca 0.19.0...
[INFO] testing foca-0.19.0 against try#8de4c7234dd9b97c9d76b58671343fdbbc9a433e+target=x86_64-unknown-linux-musl for musl_upgrade_1_2_5_with_libc_patch_0
[INFO] extracting crate foca 0.19.0 into /workspace/builds/worker-4-tc1/source
[INFO] started tweaking crates.io crate foca 0.19.0
[INFO] removed 0 missing examples
[INFO] finished tweaking crates.io crate foca 0.19.0
[INFO] tweaked toml for crates.io crate foca 0.19.0 written to /workspace/builds/worker-4-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate foca 0.19.0 on toolchain 8de4c7234dd9b97c9d76b58671343fdbbc9a433e
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate foca 0.19.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" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded postcard v1.0.10
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] cad1a50ec370af144b5737dc4f4fd6dfce51cba4fce38d9f51d69f8ae8df55a1
[INFO] running `Command { std: "docker" "start" "-a" "cad1a50ec370af144b5737dc4f4fd6dfce51cba4fce38d9f51d69f8ae8df55a1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "cad1a50ec370af144b5737dc4f4fd6dfce51cba4fce38d9f51d69f8ae8df55a1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "cad1a50ec370af144b5737dc4f4fd6dfce51cba4fce38d9f51d69f8ae8df55a1", kill_on_drop: false }`
[INFO] [stdout] cad1a50ec370af144b5737dc4f4fd6dfce51cba4fce38d9f51d69f8ae8df55a1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "build" "--frozen" "--message-format=json" "--target" "x86_64-unknown-linux-musl", kill_on_drop: false }`
[INFO] [stdout] 3b783c3c4a851dd3c55d924b28b5adc4753d7f60104d9ecfb9ab9f71419ed7e1
[INFO] running `Command { std: "docker" "start" "-a" "3b783c3c4a851dd3c55d924b28b5adc4753d7f60104d9ecfb9ab9f71419ed7e1", kill_on_drop: false }`
[INFO] [stderr]    Compiling zerocopy v0.8.24
[INFO] [stderr]    Compiling rand_core v0.9.3
[INFO] [stderr]    Compiling bytes v1.7.2
[INFO] [stderr]    Compiling rand v0.9.0
[INFO] [stderr]    Compiling foca v0.19.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 4.05s
[INFO] running `Command { std: "docker" "inspect" "3b783c3c4a851dd3c55d924b28b5adc4753d7f60104d9ecfb9ab9f71419ed7e1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3b783c3c4a851dd3c55d924b28b5adc4753d7f60104d9ecfb9ab9f71419ed7e1", kill_on_drop: false }`
[INFO] [stdout] 3b783c3c4a851dd3c55d924b28b5adc4753d7f60104d9ecfb9ab9f71419ed7e1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "test" "--frozen" "--no-run" "--message-format=json" "--target" "x86_64-unknown-linux-musl", kill_on_drop: false }`
[INFO] [stdout] cf1ae51687b2260d563ce620e670304f030eae8132aded82f30c9c941a7b1ab0
[INFO] running `Command { std: "docker" "start" "-a" "cf1ae51687b2260d563ce620e670304f030eae8132aded82f30c9c941a7b1ab0", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.87
[INFO] [stderr]    Compiling unicode-ident v1.0.13
[INFO] [stderr]    Compiling libc v0.2.159
[INFO] [stderr]    Compiling getrandom v0.3.2
[INFO] [stderr]    Compiling once_cell v1.20.2
[INFO] [stderr]    Compiling pin-project-lite v0.2.14
[INFO] [stderr]    Compiling regex-syntax v0.6.29
[INFO] [stderr]    Compiling regex-syntax v0.8.5
[INFO] [stderr]    Compiling serde v1.0.210
[INFO] [stderr]    Compiling log v0.4.22
[INFO] [stderr]    Compiling tracing-core v0.1.32
[INFO] [stderr]    Compiling overload v0.1.1
[INFO] [stderr]    Compiling sharded-slab v0.1.7
[INFO] [stderr]    Compiling textwrap v0.11.0
[INFO] [stderr]    Compiling nu-ansi-term v0.46.0
[INFO] [stderr]    Compiling thread_local v1.1.8
[INFO] [stderr]    Compiling quote v1.0.37
[INFO] [stderr]    Compiling syn v2.0.79
[INFO] [stderr]    Compiling tracing-log v0.2.0
[INFO] [stderr]    Compiling tracing v0.1.40
[INFO] [stderr]    Compiling getrandom v0.2.15
[INFO] [stderr]    Compiling socket2 v0.5.7
[INFO] [stderr]    Compiling mio v1.0.2
[INFO] [stderr]    Compiling smallvec v1.13.2
[INFO] [stderr]    Compiling rand_core v0.9.3
[INFO] [stderr]    Compiling clap v2.34.0
[INFO] [stderr]    Compiling regex-automata v0.4.8
[INFO] [stderr]    Compiling regex-automata v0.1.10
[INFO] [stderr]    Compiling matchers v0.1.0
[INFO] [stderr]    Compiling regex v1.11.0
[INFO] [stderr]    Compiling tracing-subscriber v0.3.18
[INFO] [stderr]    Compiling zerocopy-derive v0.7.35
[INFO] [stderr]    Compiling serde_derive v1.0.210
[INFO] [stderr]    Compiling tokio-macros v2.4.0
[INFO] [stderr]    Compiling tokio v1.40.0
[INFO] [stderr]    Compiling zerocopy v0.7.35
[INFO] [stderr]    Compiling ppv-lite86 v0.2.20
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling rand v0.9.0
[INFO] [stderr]    Compiling foca v0.19.0 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling uuid v0.8.2
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 52.76s
[INFO] running `Command { std: "docker" "inspect" "cf1ae51687b2260d563ce620e670304f030eae8132aded82f30c9c941a7b1ab0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "cf1ae51687b2260d563ce620e670304f030eae8132aded82f30c9c941a7b1ab0", kill_on_drop: false }`
[INFO] [stdout] cf1ae51687b2260d563ce620e670304f030eae8132aded82f30c9c941a7b1ab0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "test" "--frozen" "--target" "x86_64-unknown-linux-musl", kill_on_drop: false }`
[INFO] [stdout] 6607b3b96e4fc757b04aad291c39f5dba6feef7d4af0ab76d59fd2a8803c8bbf
[INFO] running `Command { std: "docker" "start" "-a" "6607b3b96e4fc757b04aad291c39f5dba6feef7d4af0ab76d59fd2a8803c8bbf", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.12s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/foca-4521007b9b7e99c2)
[INFO] [stdout] 
[INFO] [stdout] running 78 tests
[INFO] [stdout] test broadcast::tests::fill_does_nothing_if_buffer_full ... ok
[INFO] [stdout] test broadcast::tests::fill_with_len_prefix ... ok
[INFO] [stdout] test broadcast::tests::highest_max_tx_is_consumed_first ... ok
[INFO] [stdout] test broadcast::tests::piggyback_behaviour ... ok
[INFO] [stdout] test broadcast::tests::piggyback_consumes_largest_first ... ok
[INFO] [stdout] test broadcast::tests::piggyback_respects_limit ... ok
[INFO] [stdout] test member::tests::alive_transitions ... ok
[INFO] [stdout] test member::tests::apply_existing_if_behaviour ... ok
[INFO] [stdout] test member::tests::next_walks_sequentially_then_shuffles ... ok
[INFO] [stdout] test member::tests::next_yields_none_with_no_active_members ... ok
[INFO] [stdout] test member::tests::remove_if_down_works ... ok
[INFO] [stdout] test testing::tests::member_roundtrip ... ok
[INFO] [stdout] test testing::tests::message_roundtrip ... ok
[INFO] [stdout] test testing::tests::header_roundtrip ... ok
[INFO] [stdout] test tests::announce_to_wrong_id_is_accepted_if_same_prefix ... ok
[INFO] [stdout] test tests::apply_with_no_broadcast_doesnt_increase_backlog ... ok
[INFO] [stdout] test member::tests::choose_active_members_behaviour ... ok
[INFO] [stdout] test tests::can_join_with_another_client ... ok
[INFO] [stdout] test member::tests::down_never_transitions ... ok
[INFO] [stdout] test tests::auto_rejoin_behaviour ... ok
[INFO] [stdout] test member::tests::apply_summary_behaviour ... ok
[INFO] [stdout] test member::tests::sets_replaced_id_on_addr_conflict ... ok
[INFO] [stdout] test runtime::tests::timers_sort ... ok
[INFO] [stdout] test tests::cant_change_config_probe_timers ... ok
[INFO] [stdout] test tests::cannot_learn_about_own_previous_identity ... ok
[INFO] [stdout] test tests::cant_probe_when_not_connected ... ok
[INFO] [stdout] test tests::can_recover_from_incomplete_probe_cycle ... ok
[INFO] [stdout] test tests::cant_receive_data_from_same_addr ... ok
[INFO] [stdout] test tests::cant_receive_data_from_same_identity ... ok
[INFO] [stdout] test tests::change_identity_gossips_immediately ... ok
[INFO] [stdout] test tests::changing_identity_resets_timer_token ... ok
[INFO] [stdout] test tests::codec_errors_are_forwarded_correctly ... ok
[INFO] [stdout] test member::tests::suspect_transitions ... ok
[INFO] [stdout] test tests::cant_receive_announce_with_extra_data ... ok
[INFO] [stdout] test tests::cant_use_broadcasts_by_default ... ok
[INFO] [stdout] test tests::discards_known_old_identities_data ... ok
[INFO] [stdout] test tests::going_idle_clears_probe_state ... ok
[INFO] [stdout] test tests::custom_broadcast ... ok
[INFO] [stdout] test tests::debug_no_panic_when_handling_data_with_self_updates ... ok
[INFO] [stdout] test tests::does_not_mark_renewed_identity_as_down ... ok
[INFO] [stdout] test tests::feed_does_not_contain_trailing_jumk ... ok
[INFO] [stdout] test tests::feed_contains_only_active_members ... ok
[INFO] [stdout] test tests::gossips_when_being_suspected ... ok
[INFO] [stdout] test tests::declaring_a_member_as_down_notifies_them ... ok
[INFO] [stdout] test tests::feed_fits_as_many_as_it_can ... ok
[INFO] [stdout] test tests::invariants ... ok
[INFO] [stdout] test tests::leave_cluster_doesnt_gossip_to_duplicates ... ok
[INFO] [stdout] test tests::lightweight_messages ... ok
[INFO] [stdout] test tests::handles_member_addr_conflict ... ok
[INFO] [stdout] test tests::incarnation_does_not_increase_for_stale_suspicion ... ok
[INFO] [stdout] test tests::leave_cluster_gossips_about_our_death ... ok
[INFO] [stdout] test tests::message_from_aware_suspect_refutes_suspicion ... ok
[INFO] [stdout] test tests::message_from_down_member_is_replied_with_turn_undead ... ok
[INFO] [stdout] test tests::more_data_than_allowed_causes_error ... ok
[INFO] [stdout] test tests::new_down_member_triggers_remove_down_scheduling ... ok
[INFO] [stdout] test tests::no_indirect_cycle_if_probed_disappears ... ok
[INFO] [stdout] test tests::notification_triggers ... ok
[INFO] [stdout] test tests::notifies_on_conflict_resolution ... ok
[INFO] [stdout] test tests::periodic_announce_cannot_be_enabled_at_runtime ... ok
[INFO] [stdout] test tests::periodic_announce_to_down_members_behaviour ... ok
[INFO] [stdout] test tests::periodic_gossip_cannot_be_enabled_at_runtime ... ok
[INFO] [stdout] test tests::probe_cycle_requires_correct_probe_number ... ok
[INFO] [stdout] test tests::probe_ping_ack_cycle ... ok
[INFO] [stdout] test tests::probe_receiving_indirect_ack_sends_forwarded_ack ... ok
[INFO] [stdout] test tests::not_submitting_indirect_probe_timer_causes_probe_error ... ok
[INFO] [stdout] test tests::probe_receiving_indirect_ping_sends_indirect_ack ... ok
[INFO] [stdout] test tests::probe_receiving_ping_replies_with_ack ... ok
[INFO] [stdout] test tests::probe_receiving_ping_req_sends_indirect_ping ... ok
[INFO] [stdout] test tests::reacts_to_turnundead_even_if_sender_is_down ... ok
[INFO] [stdout] test tests::receiving_indirect_for_ourselves_causes_error ... ok
[INFO] [stdout] test tests::periodic_announce_behaviour ... ok
[INFO] [stdout] test tests::renew_during_probe_shouldnt_cause_errors ... ok
[INFO] [stdout] test tests::suspicion_refutal ... ok
[INFO] [stdout] test tests::trailing_data_is_error ... ok
[INFO] [stdout] test tests::periodic_announce_to_down_members_cannot_be_enabled_at_runtime ... ok
[INFO] [stdout] test tests::periodic_gossip_behaviour ... ok
[INFO] [stdout] test tests::piggyback_behaviour ... ok
[INFO] [stdout] test tests::probe_valid_indirect_ack_completes_succesfully ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 78 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "6607b3b96e4fc757b04aad291c39f5dba6feef7d4af0ab76d59fd2a8803c8bbf", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6607b3b96e4fc757b04aad291c39f5dba6feef7d4af0ab76d59fd2a8803c8bbf", kill_on_drop: false }`
[INFO] [stdout] 6607b3b96e4fc757b04aad291c39f5dba6feef7d4af0ab76d59fd2a8803c8bbf