[INFO] fetching crate poptrie 0.2.0...
[INFO] testing poptrie-0.2.0 against try#dec9417b8611e34e787a3e4c37686b5131f9e5c5 for pr-154210-2
[INFO] extracting crate poptrie 0.2.0 into /workspace/builds/worker-4-tc2/source
[INFO] started tweaking crates.io crate poptrie 0.2.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate poptrie 0.2.0
[INFO] tweaked toml for crates.io crate poptrie 0.2.0 written to /workspace/builds/worker-4-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate poptrie 0.2.0 on toolchain dec9417b8611e34e787a3e4c37686b5131f9e5c5
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate poptrie 0.2.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" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "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-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/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" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 51f6cebbe00180ff22e4688802fb3b71a93dd64d857d1af3cdf45ecec2c9c1f9
[INFO] running `Command { std: "docker" "start" "-a" "51f6cebbe00180ff22e4688802fb3b71a93dd64d857d1af3cdf45ecec2c9c1f9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "51f6cebbe00180ff22e4688802fb3b71a93dd64d857d1af3cdf45ecec2c9c1f9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "51f6cebbe00180ff22e4688802fb3b71a93dd64d857d1af3cdf45ecec2c9c1f9", kill_on_drop: false }`
[INFO] [stdout] 51f6cebbe00180ff22e4688802fb3b71a93dd64d857d1af3cdf45ecec2c9c1f9
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/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" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 54fbdaefce8fcd1fdf82fd5c447cbe1ad0d9a5a26582262b2d0411084252e581
[INFO] running `Command { std: "docker" "start" "-a" "54fbdaefce8fcd1fdf82fd5c447cbe1ad0d9a5a26582262b2d0411084252e581", kill_on_drop: false }`
[INFO] [stderr]    Compiling poptrie v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.39s
[INFO] running `Command { std: "docker" "inspect" "54fbdaefce8fcd1fdf82fd5c447cbe1ad0d9a5a26582262b2d0411084252e581", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "54fbdaefce8fcd1fdf82fd5c447cbe1ad0d9a5a26582262b2d0411084252e581", kill_on_drop: false }`
[INFO] [stdout] 54fbdaefce8fcd1fdf82fd5c447cbe1ad0d9a5a26582262b2d0411084252e581
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/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" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 4ce1ad57d1bd8a82254e503bf76b9cc23e281a895a0b386d8854020024c455f5
[INFO] running `Command { std: "docker" "start" "-a" "4ce1ad57d1bd8a82254e503bf76b9cc23e281a895a0b386d8854020024c455f5", kill_on_drop: false }`
[INFO] [stderr]    Compiling unicode-ident v1.0.23
[INFO] [stderr]    Compiling zerocopy v0.8.39
[INFO] [stderr]    Compiling rand_core v0.10.0
[INFO] [stderr]    Compiling getrandom v0.4.1
[INFO] [stderr]    Compiling rustix v1.1.3
[INFO] [stderr]    Compiling cc v1.2.56
[INFO] [stderr]    Compiling regex-syntax v0.8.9
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling once_cell v1.21.3
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling clap_builder v4.5.60
[INFO] [stderr]    Compiling wait-timeout v0.2.1
[INFO] [stderr]    Compiling cpufeatures v0.3.0
[INFO] [stderr]    Compiling criterion-plot v0.8.2
[INFO] [stderr]    Compiling page_size v0.6.0
[INFO] [stderr]    Compiling rand_core v0.9.5
[INFO] [stderr]    Compiling proc-macro2 v1.0.106
[INFO] [stderr]    Compiling rand_xorshift v0.4.0
[INFO] [stderr]    Compiling rand v0.9.2
[INFO] [stderr]    Compiling chacha20 v0.10.0
[INFO] [stderr]    Compiling rand v0.10.0
[INFO] [stderr]    Compiling quote v1.0.44
[INFO] [stderr]    Compiling syn v2.0.115
[INFO] [stderr]    Compiling tempfile v3.25.0
[INFO] [stderr]    Compiling alloca v0.4.0
[INFO] [stderr]    Compiling rusty-fork v0.3.1
[INFO] [stderr]    Compiling clap v4.5.60
[INFO] [stderr]    Compiling regex-automata v0.4.14
[INFO] [stderr]    Compiling regex v1.12.3
[INFO] [stderr]    Compiling zerocopy-derive v0.8.39
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling generic-tests v0.1.3
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling tinytemplate v1.2.1
[INFO] [stderr]    Compiling half v2.7.1
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling ciborium-ll v0.2.2
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling rand_chacha v0.10.0
[INFO] [stderr]    Compiling ciborium v0.2.2
[INFO] [stderr]    Compiling proptest v1.10.0
[INFO] [stderr]    Compiling criterion v0.8.2
[INFO] [stderr]    Compiling poptrie v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 34.64s
[INFO] running `Command { std: "docker" "inspect" "4ce1ad57d1bd8a82254e503bf76b9cc23e281a895a0b386d8854020024c455f5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4ce1ad57d1bd8a82254e503bf76b9cc23e281a895a0b386d8854020024c455f5", kill_on_drop: false }`
[INFO] [stdout] 4ce1ad57d1bd8a82254e503bf76b9cc23e281a895a0b386d8854020024c455f5
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/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" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 3fa8041ace6895c99d4bc11c485b9156346a1d1c4fc74f0e2b57aa4bf2899e4a
[INFO] running `Command { std: "docker" "start" "-a" "3fa8041ace6895c99d4bc11c485b9156346a1d1c4fc74f0e2b57aa4bf2899e4a", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.17s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/poptrie-623690f66c58807a)
[INFO] [stdout] 
[INFO] [stdout] running 16 tests
[INFO] [stdout] test address::tests::test_saturated_extraction ... ok
[INFO] [stdout] test address::tests::test_msb_alignement ... ok
[INFO] [stdout] test bitmap::tests::bitmap_id_prefix_test ... ok
[INFO] [stdout] test iter::tests::from_iter_round_trips_with_into_iter ... ok
[INFO] [stdout] test bitmap::tests::bitmap_index_test ... ok
[INFO] [stdout] test bitmap::tests::test_prefix_to_stride ... ok
[INFO] [stdout] test iter::tests::into_iter_empty_trie ... ok
[INFO] [stdout] test iter::tests::into_iter_consumes_all_entries ... ok
[INFO] [stdout] test iter::tests::iter_after_remove ... ok
[INFO] [stdout] test iter::tests::iter_empty_trie ... ok
[INFO] [stdout] test iter::tests::iter_contains_key_consistent ... ok
[INFO] [stdout] test iter::tests::iter_is_sorted ... ok
[INFO] [stdout] test iter::tests::iter_mut_modifies_values ... ok
[INFO] [stdout] test iter::tests::iter_yields_all_entries ... ok
[INFO] [stdout] test address::tests::test_extraction ... ok
[INFO] [stdout] test bitmap::tests::test_find_lpm ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/tests.rs (/opt/rustwide/target/debug/deps/tests-a76d224246c279bb)
[INFO] [stdout] 
[INFO] [stdout] running 29 tests
[INFO] [stdout] test api::contains::contains_key_false_for_different_prefix_length ... ok
[INFO] [stdout] test api::contains::contains_key_true_for_inserted_prefix ... ok
[INFO] [stdout] test api::default::default_route_matches_everything ... ok
[INFO] [stdout] test api::default::default_at_first_level_propagates_into_second_level ... ok
[INFO] [stdout] test api::default::default_at_second_level_propagates_into_third_level ... ok
[INFO] [stdout] test api::default::default_route_overwrite_propagates_to_children ... ok
[INFO] [stdout] test api::contains::contains_key_false_on_empty_trie ... ok
[INFO] [stdout] test api::default::non_full_length_default_does_not_cover_sibling_subtree ... ok
[INFO] [stdout] test api::default::specific_prefix_overrides_default_route ... ok
[INFO] [stdout] test api::insert::insert_order_does_not_affect_lpm ... ok
[INFO] [stdout] test api::insert::insert_returns_old_value ... ok
[INFO] [stdout] test api::lookup::lpm_child_prefix_inserted_before_parent ... ok
[INFO] [stdout] test api::lookup::empty_trie_returns_none ... ok
[INFO] [stdout] test api::lookup::lpm_sibling_strides_do_not_bleed ... ok
[INFO] [stdout] test api::lookup::lpm_selects_longest_matching_prefix ... ok
[INFO] [stdout] test api::lookup::prefix_at_second_stride_boundary ... ok
[INFO] [stdout] test api::lookup::prefix_spanning_two_stride_levels ... ok
[INFO] [stdout] test api::lookup::prefix_at_first_stride_boundary ... ok
[INFO] [stdout] test api::remove::remove_and_reinsert_gives_new_value ... ok
[INFO] [stdout] test common::tests::u32_macro_full_stride ... ok
[INFO] [stdout] test common::tests::u32_macro_simple ... ok
[INFO] [stdout] test common::tests::u32_macro_steps ... ok
[INFO] [stdout] test common::tests::u32_macro_encoding ... ok
[INFO] [stdout] test api::remove::remove_returns_value_and_clears_lookup ... ok
[INFO] [stdout] test api::lookup::two_prefixes_one_stride_apart_with_shared_parent ... ok
[INFO] [stdout] test api::remove::remove_specific_falls_back_to_less_specific ... ok
[INFO] [stdout] test api::remove::removed_child_with_same_stride_doesnt_find_missing_key ... ok
[INFO] [stdout] test proptests::insert::bulk_insertion_matches_manual_insertion ... ok
[INFO] [stdout] test proptests::lookup::matches_reference_model ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 29 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.80s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests poptrie
[INFO] [stdout] 
[INFO] [stdout] running 21 tests
[INFO] [stdout] test src/iter.rs - iter::Poptrie<P,V>::iter (line 223) ... ok
[INFO] [stdout] test src/iter.rs - iter::Poptrie<P,V>::into_iter (line 167) ... ok
[INFO] [stdout] test src/lib.rs - Poptrie (line 57) ... ok
[INFO] [stdout] test src/lib.rs - Poptrie<P,V>::is_empty (line 340) ... ok
[INFO] [stdout] test src/lib.rs - Poptrie<P,V>::insert (line 130) ... ok
[INFO] [stdout] test src/lib.rs - Poptrie<P,V>::remove (line 497) ... ok
[INFO] [stdout] test src/iter.rs - iter::Poptrie<P,V>::from_iter (line 14) ... ok
[INFO] [stdout] test src/lib.rs - Poptrie<P,V>::get (line 358) ... ok
[INFO] [stdout] test src/lib.rs - Poptrie<P,V>::get_mut (line 379) ... ok
[INFO] [stdout] test src/lib.rs - Poptrie<P,V>::values (line 425) ... ok
[INFO] [stdout] test src/lib.rs - Poptrie<P,V>::retain (line 463) ... ok
[INFO] [stdout] test src/iter.rs - iter::Poptrie<P,V>::iter_mut (line 277) ... ok
[INFO] [stdout] test src/lib.rs - Poptrie<P,V>::contains_key (line 303) ... ok
[INFO] [stdout] test src/lib.rs - Poptrie<P,V>::len (line 323) ... ok
[INFO] [stdout] test src/lib.rs - Poptrie<P,V>::lookup (line 248) ... ok
[INFO] [stdout] test src/address.rs - address::Address (line 19) ... ok
[INFO] [stdout] test src/lib.rs - Poptrie<P,V>::keys (line 403) ... ok
[INFO] [stdout] test src/lib.rs - Poptrie<P,V>::new (line 99) ... ok
[INFO] [stdout] test src/prefix.rs - prefix::Prefix (line 20) ... ok
[INFO] [stdout] test src/prefix.rs - prefix::Prefix (line 11) ... ok
[INFO] [stdout] test src/lib.rs - Poptrie<P,V>::values_mut (line 443) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 21 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 1.17s; merged doctests compilation took 1.13s
[INFO] running `Command { std: "docker" "inspect" "3fa8041ace6895c99d4bc11c485b9156346a1d1c4fc74f0e2b57aa4bf2899e4a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3fa8041ace6895c99d4bc11c485b9156346a1d1c4fc74f0e2b57aa4bf2899e4a", kill_on_drop: false }`
[INFO] [stdout] 3fa8041ace6895c99d4bc11c485b9156346a1d1c4fc74f0e2b57aa4bf2899e4a