[INFO] fetching crate trie 0.3.0...
[INFO] testing trie-0.3.0 against try#dec9417b8611e34e787a3e4c37686b5131f9e5c5 for pr-154210-1
[INFO] extracting crate trie 0.3.0 into /workspace/builds/worker-4-tc2/source
[INFO] started tweaking crates.io crate trie 0.3.0
[INFO] finished tweaking crates.io crate trie 0.3.0
[INFO] tweaked toml for crates.io crate trie 0.3.0 written to /workspace/builds/worker-4-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate trie 0.3.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 trie 0.3.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] 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] 6e685323b6c3d337bd59fe715d5ba6a4f4f67fa2ed5d431b24e3c160b7114864
[INFO] running `Command { std: "docker" "start" "-a" "6e685323b6c3d337bd59fe715d5ba6a4f4f67fa2ed5d431b24e3c160b7114864", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "6e685323b6c3d337bd59fe715d5ba6a4f4f67fa2ed5d431b24e3c160b7114864", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6e685323b6c3d337bd59fe715d5ba6a4f4f67fa2ed5d431b24e3c160b7114864", kill_on_drop: false }`
[INFO] [stdout] 6e685323b6c3d337bd59fe715d5ba6a4f4f67fa2ed5d431b24e3c160b7114864
[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] 7634979d6d7a8162dc7291c96c408e681aafa77a05d0f24aa0eb2e71fd4fac60
[INFO] running `Command { std: "docker" "start" "-a" "7634979d6d7a8162dc7291c96c408e681aafa77a05d0f24aa0eb2e71fd4fac60", kill_on_drop: false }`
[INFO] [stderr]    Compiling trie v0.3.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.37s
[INFO] running `Command { std: "docker" "inspect" "7634979d6d7a8162dc7291c96c408e681aafa77a05d0f24aa0eb2e71fd4fac60", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7634979d6d7a8162dc7291c96c408e681aafa77a05d0f24aa0eb2e71fd4fac60", kill_on_drop: false }`
[INFO] [stdout] 7634979d6d7a8162dc7291c96c408e681aafa77a05d0f24aa0eb2e71fd4fac60
[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] dd1c4cef52763374bb825d8f92246dd7fba7d5cda4f8b2c213ce419054c296bb
[INFO] running `Command { std: "docker" "start" "-a" "dd1c4cef52763374bb825d8f92246dd7fba7d5cda4f8b2c213ce419054c296bb", kill_on_drop: false }`
[INFO] [stderr]    Compiling getrandom v0.4.1
[INFO] [stderr]    Compiling rand v0.10.0
[INFO] [stderr]    Compiling trie v0.3.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.84s
[INFO] running `Command { std: "docker" "inspect" "dd1c4cef52763374bb825d8f92246dd7fba7d5cda4f8b2c213ce419054c296bb", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "dd1c4cef52763374bb825d8f92246dd7fba7d5cda4f8b2c213ce419054c296bb", kill_on_drop: false }`
[INFO] [stdout] dd1c4cef52763374bb825d8f92246dd7fba7d5cda4f8b2c213ce419054c296bb
[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] 49203802f89d3783df643f6cb5c5c3736a9206de464292deecd3d17199c19cf6
[INFO] running `Command { std: "docker" "start" "-a" "49203802f89d3783df643f6cb5c5c3736a9206de464292deecd3d17199c19cf6", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.04s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/trie-643b679977f97aad)
[INFO] [stdout] 
[INFO] [stdout] running 39 tests
[INFO] [stdout] test map::test::test_clone ... ok
[INFO] [stdout] test map::test::test_debug ... ok
[INFO] [stdout] test map::test::test_entry_get ... ok
[INFO] [stdout] test map::test::test_entry_get_mut ... ok
[INFO] [stdout] test map::test::test_bound ... ok
[INFO] [stdout] test map::test::test_entry_take ... ok
[INFO] [stdout] test map::test::test_each_reverse ... ok
[INFO] [stdout] test map::test::test_entry_into_mut ... ok
[INFO] [stdout] test map::test::test_eq ... ok
[INFO] [stdout] test map::test::test_find_mut_missing ... ok
[INFO] [stdout] test map::test::test_find_mut ... ok
[INFO] [stdout] test map::test::test_hash ... ok
[INFO] [stdout] test map::test::test_index ... ok
[INFO] [stdout] test map::test::test_from_iter ... ok
[INFO] [stdout] test map::test::test_insert ... ok
[INFO] [stdout] test map::test::test_keys ... ok
[INFO] [stdout] test map::test::test_ord ... ok
[INFO] [stdout] test map::test::test_remove ... ok
[INFO] [stdout] test map::test::test_each_reverse_break ... ok
[INFO] [stdout] test map::test::test_vacant_entry_set ... ok
[INFO] [stdout] test map::test::test_mut_bound ... ok
[INFO] [stdout] test map::test::test_values ... ok
[INFO] [stdout] test map::test::test_occupied_entry_set ... ok
[INFO] [stdout] test map::test::test_single_key ... ok
[INFO] [stdout] test map::test::test_lt ... ok
[INFO] [stdout] test set::test::test_bit_xor ... ok
[INFO] [stdout] test set::test::test_bit_or ... ok
[INFO] [stdout] test set::test::test_lt ... ok
[INFO] [stdout] test set::test::test_bit_and ... ok
[INFO] [stdout] test set::test::test_clone ... ok
[INFO] [stdout] test set::test::test_from_iter ... ok
[INFO] [stdout] test set::test::test_sane_chunk ... ok
[INFO] [stdout] test set::test::test_sub ... ok
[INFO] [stdout] test set::test::test_debug ... ok
[INFO] [stdout] test map::test::test_iteration ... ok
[INFO] [stdout] test set::test::test_ord ... ok
[INFO] [stdout] test map::test::test_mut_iter ... ok
[INFO] [stdout] test map::test::test_step ... ok
[INFO] [stdout] test map::test::test_index_nonexistent - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 39 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests trie
[INFO] [stdout] 
[INFO] [stdout] running 40 tests
[INFO] [stdout] test src/map.rs - map::Map (line 59) ... ok
[INFO] [stdout] test src/map.rs - map::Map<T>::each_reverse (line 172) ... ok
[INFO] [stdout] test src/map.rs - map::Map<T>::get (line 299) ... ok
[INFO] [stdout] test src/map.rs - map::Map<T>::clear (line 283) ... ok
[INFO] [stdout] test src/map.rs - map::Map<T>::insert (line 363) ... ok
[INFO] [stdout] test src/map.rs - map::Map<T>::get_mut (line 344) ... ok
[INFO] [stdout] test src/map.rs - map::Map<T>::iter (line 208) ... ok
[INFO] [stdout] test src/map.rs - map::Map<T>::len (line 253) ... ok
[INFO] [stdout] test src/map.rs - map::Map<T>::lower_bound (line 496) ... ok
[INFO] [stdout] test src/map.rs - map::Map<T>::iter_mut (line 229) ... ok
[INFO] [stdout] test src/map.rs - map::Map<T>::new (line 156) ... ok
[INFO] [stdout] test src/map.rs - map::Map<T>::is_empty (line 268) ... ok
[INFO] [stdout] test src/map.rs - map::Map<T>::contains_key (line 329) ... ok
[INFO] [stdout] test src/map.rs - map::Map<T>::remove (line 391) ... ok
[INFO] [stdout] test src/set.rs - set::Set::intersection (line 215) ... ok
[INFO] [stdout] test src/set.rs - set::Set::difference (line 161) ... ok
[INFO] [stdout] test src/set.rs - set::Set::contains (line 305) ... ok
[INFO] [stdout] test src/set.rs - set::Set::each_reverse (line 80) ... ok
[INFO] [stdout] test src/map.rs - map::Map<T>::lower_bound_mut (line 536) ... ok
[INFO] [stdout] test src/set.rs - set::Set::iter (line 104) ... ok
[INFO] [stdout] test src/set.rs - set::Set::insert (line 381) ... ok
[INFO] [stdout] test src/set.rs - set::&'_Set::bitor (line 434) ... ok
[INFO] [stdout] test src/set.rs - set::Set::is_superset (line 358) ... ok
[INFO] [stdout] test src/map.rs - map::Map<T>::upper_bound_mut (line 560) ... ok
[INFO] [stdout] test src/set.rs - set::&'_Set::bitand (line 454) ... ok
[INFO] [stdout] test src/set.rs - set::Set (line 28) ... ok
[INFO] [stdout] test src/set.rs - set::&'_Set::sub (line 494) ... ok
[INFO] [stdout] test src/map.rs - map::Map<T>::upper_bound (line 512) ... ok
[INFO] [stdout] test src/set.rs - set::Set::len (line 261) ... ok
[INFO] [stdout] test src/set.rs - set::Set::lower_bound (line 128) ... ok
[INFO] [stdout] test src/set.rs - set::Set::clear (line 290) ... ok
[INFO] [stdout] test src/set.rs - set::Set::union (line 238) ... ok
[INFO] [stdout] test src/set.rs - set::Set::new (line 67) ... ok
[INFO] [stdout] test src/set.rs - set::Set::remove (line 398) ... ok
[INFO] [stdout] test src/set.rs - set::Set::upper_bound (line 145) ... ok
[INFO] [stdout] test src/set.rs - set::Set::symmetric_difference (line 189) ... ok
[INFO] [stdout] test src/set.rs - set::Set::is_empty (line 276) ... ok
[INFO] [stdout] test src/set.rs - set::Set::is_disjoint (line 320) ... ok
[INFO] [stdout] test src/set.rs - set::Set::is_subset (line 339) ... ok
[INFO] [stdout] test src/set.rs - set::&'_Set::bitxor (line 474) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 40 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 0.80s; merged doctests compilation took 0.75s
[INFO] running `Command { std: "docker" "inspect" "49203802f89d3783df643f6cb5c5c3736a9206de464292deecd3d17199c19cf6", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "49203802f89d3783df643f6cb5c5c3736a9206de464292deecd3d17199c19cf6", kill_on_drop: false }`
[INFO] [stdout] 49203802f89d3783df643f6cb5c5c3736a9206de464292deecd3d17199c19cf6