Dec 07 22:41:20.027 INFO testing bip_dht-0.6.0 against try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468 for pr-56514
Dec 07 22:41:20.027 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-alt build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 07 22:41:20.272 INFO [stdout] 411ca8ce821901d4131c53d218a603c6e2fc1965bef4a8d484a4ec50bcdbf2a2
Dec 07 22:41:20.280 INFO running `"docker" "start" "-a" "411ca8ce821901d4131c53d218a603c6e2fc1965bef4a8d484a4ec50bcdbf2a2"`
Dec 07 22:41:21.124 INFO [stderr] usermod: no changes
Dec 07 22:41:21.238 INFO [stderr]    Compiling slab v0.2.0
Dec 07 22:41:21.240 INFO [stderr]    Compiling net2 v0.2.33
Dec 07 22:41:21.240 INFO [stderr]    Compiling bip_bencode v0.2.0
Dec 07 22:41:21.240 INFO [stderr]    Compiling bip_util v0.5.0
Dec 07 22:41:23.658 INFO [stderr]    Compiling miow v0.1.5
Dec 07 22:41:24.751 INFO [stderr]    Compiling mio v0.5.1
Dec 07 22:41:27.173 INFO [stderr]    Compiling bip_handshake v0.4.1
Dec 07 22:41:30.308 INFO [stderr]    Compiling bip_dht v0.6.0 (/source)
Dec 07 22:41:37.978 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 16.83s
Dec 07 22:41:37.985 INFO [stderr] su: No module specific data is present
Dec 07 22:41:38.648 INFO running `"docker" "inspect" "411ca8ce821901d4131c53d218a603c6e2fc1965bef4a8d484a4ec50bcdbf2a2"`
Dec 07 22:41:39.000 INFO running `"docker" "rm" "-f" "411ca8ce821901d4131c53d218a603c6e2fc1965bef4a8d484a4ec50bcdbf2a2"`
Dec 07 22:41:39.236 INFO [stdout] 411ca8ce821901d4131c53d218a603c6e2fc1965bef4a8d484a4ec50bcdbf2a2
Dec 07 22:41:39.242 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-alt test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 07 22:41:39.662 INFO [stdout] 4da9e4f832a8b4471fd547c9459ab602704421fddb4a018dd893e341b1873d91
Dec 07 22:41:39.664 INFO running `"docker" "start" "-a" "4da9e4f832a8b4471fd547c9459ab602704421fddb4a018dd893e341b1873d91"`
Dec 07 22:41:41.376 INFO [stderr] usermod: no changes
Dec 07 22:41:41.536 INFO [stderr]    Compiling bip_dht v0.6.0 (/source)
Dec 07 22:41:53.917 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 12.52s
Dec 07 22:41:53.923 INFO [stderr] su: No module specific data is present
Dec 07 22:41:54.298 INFO running `"docker" "inspect" "4da9e4f832a8b4471fd547c9459ab602704421fddb4a018dd893e341b1873d91"`
Dec 07 22:41:54.432 INFO running `"docker" "rm" "-f" "4da9e4f832a8b4471fd547c9459ab602704421fddb4a018dd893e341b1873d91"`
Dec 07 22:41:54.577 INFO [stdout] 4da9e4f832a8b4471fd547c9459ab602704421fddb4a018dd893e341b1873d91
Dec 07 22:41:54.580 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-alt test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 07 22:41:54.820 INFO [stdout] 618a09556faacf59fddaff97804e012ab6badcbf0354b98534e35fbe20c353f9
Dec 07 22:41:54.826 INFO running `"docker" "start" "-a" "618a09556faacf59fddaff97804e012ab6badcbf0354b98534e35fbe20c353f9"`
Dec 07 22:41:55.532 INFO [stderr] usermod: no changes
Dec 07 22:41:55.620 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.07s
Dec 07 22:41:55.623 INFO [stderr]      Running /target/debug/deps/bip_dht-7646b0716c4dd4dc
Dec 07 22:41:55.626 INFO [stdout] 
Dec 07 22:41:55.626 INFO [stdout] running 57 tests
Dec 07 22:41:55.626 INFO [stdout] test routing::bucket::tests::positive_all_questionable_nodes ... ok
Dec 07 22:41:55.626 INFO [stdout] test message::compact_info::tests::positive_compact_values_many ... ok
Dec 07 22:41:55.626 INFO [stdout] test message::compact_info::tests::positive_compact_values_empty ... ok
Dec 07 22:41:55.626 INFO [stdout] test message::compact_info::tests::positive_compact_nodes_one ... ok
Dec 07 22:41:55.626 INFO [stdout] test message::compact_info::tests::positive_compact_nodes_many ... ok
Dec 07 22:41:55.626 INFO [stdout] test message::compact_info::tests::positive_compact_nodes_empty ... ok
Dec 07 22:41:55.627 INFO [stdout] test routing::bucket::tests::positive_resist_questionable_node_churn ... ok
Dec 07 22:41:55.627 INFO [stdout] test routing::bucket::tests::positive_resist_good_node_churn ... ok
Dec 07 22:41:55.627 INFO [stdout] test routing::node::tests::positive_as_good ... ok
Dec 07 22:41:55.627 INFO [stdout] test routing::node::tests::positive_encode_node ... ok
Dec 07 22:41:55.627 INFO [stdout] test routing::node::tests::positive_good_status_ordering ... ok
Dec 07 22:41:55.627 INFO [stdout] test routing::node::tests::positive_as_bad ... ok
Dec 07 22:41:55.627 INFO [stdout] test routing::bucket::tests::positive_replace_questionable_node ... ok
Dec 07 22:41:55.627 INFO [stdout] test routing::node::tests::positive_node_idle_reqeusts ... ok
Dec 07 22:41:55.628 INFO [stdout] test routing::node::tests::positive_request_renewal ... ok
Dec 07 22:41:55.628 INFO [stdout] test routing::node::tests::positive_response_renewal ... ok
Dec 07 22:41:55.628 INFO [stdout] test routing::node::tests::positive_questionable_status_ordering ... ok
Dec 07 22:41:55.628 INFO [stdout] test routing::node::tests::positive_bad_status_ordering ... ok
Dec 07 22:41:55.628 INFO [stdout] test routing::bucket::tests::positive_initial_no_nodes ... ok
Dec 07 22:41:55.632 INFO [stdout] test routing::node::tests::positive_as_questionable ... ok
Dec 07 22:41:55.632 INFO [stdout] test message::compact_info::tests::positive_compact_values_one ... ok
Dec 07 22:41:55.636 INFO [stdout] test routing::node::tests::positive_node_idle ... ok
Dec 07 22:41:55.636 INFO [stdout] test routing::table::tests::negative_node_id_equal_table_id ... ok
Dec 07 22:41:55.636 INFO [stdout] test routing::bucket::tests::positive_all_good_nodes ... ok
Dec 07 22:41:55.636 INFO [stdout] test routing::table::tests::positive_first_bucket_sorted ... ok
Dec 07 22:41:55.644 INFO [stdout] test routing::table::tests::positive_initial_empty_buckets ... ok
Dec 07 22:41:55.644 INFO [stdout] test security::tests::positive_generate_compliant_ipv4_test_four ... ok
Dec 07 22:41:55.644 INFO [stdout] test security::tests::positive_generate_compliant_ipv4_test_two ... ok
Dec 07 22:41:55.644 INFO [stdout] test security::tests::positive_generate_compliant_ipv4_test_one ... ok
Dec 07 22:41:55.644 INFO [stdout] test security::tests::positive_generate_compliant_ipv4_test_three ... ok
Dec 07 22:41:55.644 INFO [stdout] test security::tests::positive_generate_compliant_ipv4_test_five ... ok
Dec 07 22:41:55.644 INFO [stdout] test security::tests::positive_is_compliant_ipv4_test_three ... ok
Dec 07 22:41:55.644 INFO [stdout] test security::tests::positive_is_compliant_ipv4_test_one ... ok
Dec 07 22:41:55.672 INFO [stdout] test security::tests::positive_is_compliant_ipv4_test_two ... ok
Dec 07 22:41:55.673 INFO [stdout] test storage::tests::positive_add_and_retrieve_contact ... ok
Dec 07 22:41:55.673 INFO [stdout] test security::tests::positive_is_compliant_ipv4_test_five ... ok
Dec 07 22:41:55.673 INFO [stdout] test security::tests::positive_is_compliant_ipv4_test_four ... ok
Dec 07 22:41:55.674 INFO [stdout] test routing::table::tests::positive_last_bucket_sorted ... ok
Dec 07 22:41:55.689 INFO [stdout] test storage::tests::positive_full_storage_expire_two_infohash ... ok
Dec 07 22:41:55.694 INFO [stdout] test routing::table::tests::positive_add_node_max_recursion ... ok
Dec 07 22:41:55.700 INFO [stdout] test token::tests::positive_accept_v4_token_from_second_secret ... ok
Dec 07 22:41:55.701 INFO [stdout] test token::tests::positive_accept_v6_token_from_second_secret ... ok
Dec 07 22:41:55.701 INFO [stdout] test token::tests::positive_accept_valid_v6_token ... ok
Dec 07 22:41:55.704 INFO [stdout] test token::tests::positive_accept_valid_v4_token ... ok
Dec 07 22:41:55.705 INFO [stdout] test routing::table::tests::positive_all_sorted_buckets ... ok
Dec 07 22:41:55.708 INFO [stdout] test transaction::tests::positive_overflow_tid_generate ... ok
Dec 07 22:41:55.709 INFO [stdout] test transaction::tests::positive_tid_from_bytes ... ok
Dec 07 22:41:55.710 INFO [stdout] test transaction::tests::positive_unique_aid_blocks ... ok
Dec 07 22:41:55.712 INFO [stdout] test transaction::tests::positive_unique_mid_blocks ... ok
Dec 07 22:41:55.714 INFO [stdout] test transaction::tests::positive_unique_tid_blocks ... ok
Dec 07 22:41:55.717 INFO [stdout] test transaction::tests::positive_overflow_aid_generate ... ok
Dec 07 22:41:55.718 INFO [stdout] test storage::tests::positive_add_and_retrieve_contacts ... ok
Dec 07 22:41:55.719 INFO [stdout] test transaction::tests::positive_overflow_mid_generate ... ok
Dec 07 22:41:55.760 INFO [stdout] test token::tests::negative_reject_expired_v6_token ... ok
Dec 07 22:41:55.760 INFO [stdout] test token::tests::negative_reject_expired_v4_token ... ok
Dec 07 22:41:55.767 INFO [stdout] test storage::tests::positive_full_storage_expire_one_infohash ... ok
Dec 07 22:41:55.783 INFO [stdout] test storage::tests::positive_renew_contacts ... ok
Dec 07 22:41:55.783 INFO [stdout] 
Dec 07 22:41:55.784 INFO [stdout] test result: ok. 57 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 22:41:55.784 INFO [stdout] 
Dec 07 22:41:55.786 INFO [stderr]    Doc-tests bip_dht
Dec 07 22:42:01.185 INFO [stdout] 
Dec 07 22:42:01.185 INFO [stdout] running 0 tests
Dec 07 22:42:01.185 INFO [stdout] 
Dec 07 22:42:01.185 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 22:42:01.185 INFO [stdout] 
Dec 07 22:42:01.199 INFO [stderr] su: No module specific data is present
Dec 07 22:42:01.757 INFO running `"docker" "inspect" "618a09556faacf59fddaff97804e012ab6badcbf0354b98534e35fbe20c353f9"`
Dec 07 22:42:01.873 INFO running `"docker" "rm" "-f" "618a09556faacf59fddaff97804e012ab6badcbf0354b98534e35fbe20c353f9"`
Dec 07 22:42:01.966 INFO [stdout] 618a09556faacf59fddaff97804e012ab6badcbf0354b98534e35fbe20c353f9