Dec 15 21:12:38.624 INFO testing bip_handshake-0.7.1 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 15 21:12:38.624 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-3/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 15 21:12:38.812 INFO [stdout] 61f1872c5243669746f70f45661e3606fab25775bdfbf1cefea44bb9a6c57ada
Dec 15 21:12:38.816 INFO running `"docker" "start" "-a" "61f1872c5243669746f70f45661e3606fab25775bdfbf1cefea44bb9a6c57ada"`
Dec 15 21:12:39.349 INFO [stderr] usermod: no changes
Dec 15 21:12:39.468 INFO [stderr]    Compiling bip_handshake v0.7.1 (/source)
Dec 15 21:12:45.072 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 5.70s
Dec 15 21:12:45.083 INFO [stderr] su: No module specific data is present
Dec 15 21:12:45.755 INFO running `"docker" "inspect" "61f1872c5243669746f70f45661e3606fab25775bdfbf1cefea44bb9a6c57ada"`
Dec 15 21:12:45.950 INFO running `"docker" "rm" "-f" "61f1872c5243669746f70f45661e3606fab25775bdfbf1cefea44bb9a6c57ada"`
Dec 15 21:12:46.111 INFO [stdout] 61f1872c5243669746f70f45661e3606fab25775bdfbf1cefea44bb9a6c57ada
Dec 15 21:12:46.116 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-3/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 15 21:12:46.407 INFO [stdout] 8495998c22edeb562cd860b1177bf21560dd36a81c5f8a74a492990785fb9960
Dec 15 21:12:46.410 INFO running `"docker" "start" "-a" "8495998c22edeb562cd860b1177bf21560dd36a81c5f8a74a492990785fb9960"`
Dec 15 21:12:47.473 INFO [stderr] usermod: no changes
Dec 15 21:12:47.609 INFO [stderr]    Compiling bip_handshake v0.7.1 (/source)
Dec 15 21:13:12.172 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 24.68s
Dec 15 21:13:12.187 INFO [stderr] su: No module specific data is present
Dec 15 21:13:12.760 INFO running `"docker" "inspect" "8495998c22edeb562cd860b1177bf21560dd36a81c5f8a74a492990785fb9960"`
Dec 15 21:13:12.939 INFO running `"docker" "rm" "-f" "8495998c22edeb562cd860b1177bf21560dd36a81c5f8a74a492990785fb9960"`
Dec 15 21:13:13.183 INFO [stdout] 8495998c22edeb562cd860b1177bf21560dd36a81c5f8a74a492990785fb9960
Dec 15 21:13:13.187 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-3/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 15 21:13:13.572 INFO [stdout] 310e9c61410fdd28cde76c4256e90c10de9513a5a7713e00b4e5b67d8b95a905
Dec 15 21:13:13.575 INFO running `"docker" "start" "-a" "310e9c61410fdd28cde76c4256e90c10de9513a5a7713e00b4e5b67d8b95a905"`
Dec 15 21:13:14.855 INFO [stderr] usermod: no changes
Dec 15 21:13:15.042 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.16s
Dec 15 21:13:15.061 INFO [stderr]      Running /target/debug/deps/bip_handshake-cee7f46cfc543b77
Dec 15 21:13:15.061 INFO [stdout] 
Dec 15 21:13:15.061 INFO [stdout] running 34 tests
Dec 15 21:13:15.061 INFO [stdout] test bittorrent::framed::tests::positive_read_bytes_after_handshake ... ok
Dec 15 21:13:15.061 INFO [stdout] test bittorrent::framed::tests::positive_read_byte_after_handshake ... ok
Dec 15 21:13:15.061 INFO [stdout] test bittorrent::message::tests::positive_many_bytes_protocol ... ok
Dec 15 21:13:15.061 INFO [stdout] test bittorrent::message::tests::positive_bittorrent_protocol ... ok
Dec 15 21:13:15.061 INFO [stdout] test bittorrent::message::tests::positive_decode_zero_bytes_protocol ... ok
Dec 15 21:13:15.063 INFO [stdout] test bittorrent::framed::tests::positive_read_handshake_message ... ok
Dec 15 21:13:15.063 INFO [stdout] test bittorrent::framed::tests::positive_write_multiple_handshake_messages ... ok
Dec 15 21:13:15.063 INFO [stdout] test bittorrent::framed::tests::positive_write_handshake_message ... ok
Dec 15 21:13:15.068 INFO [stdout] test filter::filters::tests::positive_remove_filter_multiple_present ... ok
Dec 15 21:13:15.068 INFO [stdout] test filter::filters::tests::positive_remove_filter_not_present ... ok
Dec 15 21:13:15.068 INFO [stdout] test filter::filters::tests::positive_remove_filter ... ok
Dec 15 21:13:15.075 INFO [stdout] test filter::tests::positive_decision_choose_self ... ok
Dec 15 21:13:15.075 INFO [stdout] test filter::tests::positive_decision_choose_higher ... ok
Dec 15 21:13:15.084 INFO [stdout] test filter::filters::tests::positive_clear_filters_one_present ... ok
Dec 15 21:13:15.084 INFO [stdout] test filter::filters::tests::positive_add_filter ... ok
Dec 15 21:13:15.084 INFO [stdout] test filter::filters::tests::positive_add_filter_already_present ... ok
Dec 15 21:13:15.084 INFO [stdout] test filter::filters::tests::positive_clear_filters_none_present ... ok
Dec 15 21:13:15.084 INFO [stdout] test filter::filters::tests::positive_clear_filters_multiple_present ... ok
Dec 15 21:13:15.084 INFO [stdout] test filter::tests::positive_decision_keep_higher ... ok
Dec 15 21:13:15.084 INFO [stdout] test handshake::handler::handshaker::tests::positive_complete_handshake ... ok
Dec 15 21:13:15.090 INFO [stdout] test handshake::handler::initiator::tests::positive_needs_data_filter ... ok
Dec 15 21:13:15.095 INFO [stdout] test handshake::handler::initiator::tests::positive_passes_filter ... ok
Dec 15 21:13:15.095 INFO [stdout] test handshake::handler::listener::tests::positive_empty_filter ... ok
Dec 15 21:13:15.095 INFO [stdout] test handshake::handler::listener::tests::positive_fails_filter ... ok
Dec 15 21:13:15.096 INFO [stdout] test handshake::handler::listener::tests::positive_needs_data_filter ... ok
Dec 15 21:13:15.096 INFO [stdout] test message::extensions::tests::positive_add_extension_protocol ... ok
Dec 15 21:13:15.123 INFO [stdout] test handshake::handler::listener::tests::positive_passes_filter ... ok
Dec 15 21:13:15.123 INFO [stdout] test handshake::handler::initiator::tests::positive_fails_filter ... ok
Dec 15 21:13:15.123 INFO [stdout] test message::extensions::tests::positive_remove_extension_protocol ... ok
Dec 15 21:13:15.123 INFO [stdout] test handshake::handler::initiator::tests::positive_empty_filter ... ok
Dec 15 21:13:15.123 INFO [stdout] test handshake::handler::timer::tests::positive_finish_before_timeout ... ok
Dec 15 21:13:15.123 INFO [stdout] test handshake::handler::handshaker::tests::positive_initiate_handshake ... ok
Dec 15 21:13:15.215 INFO [stderr]      Running /target/debug/deps/test-b4fbc6dba00522f7
Dec 15 21:13:15.215 INFO [stdout] test handshake::handler::timer::tests::negative_finish_after_timeout ... ok
Dec 15 21:13:15.215 INFO [stdout] test bittorrent::message::tests::negative_create_overflow_protocol ... ok
Dec 15 21:13:15.215 INFO [stdout] 
Dec 15 21:13:15.215 INFO [stdout] test result: ok. 34 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 21:13:15.215 INFO [stdout] 
Dec 15 21:13:15.219 INFO [stdout] 
Dec 15 21:13:15.219 INFO [stdout] running 7 tests
Dec 15 21:13:15.369 INFO [stdout] test test_bytes_after_handshake::positive_recover_bytes ... ok
Dec 15 21:13:15.369 INFO [stdout] test test_byte_after_handshake::positive_recover_bytes ... ok
Dec 15 21:13:15.374 INFO [stdout] test test_connect::positive_connect ... ok
Dec 15 21:13:15.395 INFO [stdout] test test_filter_allow_all::test_filter_all ... ok
Dec 15 21:13:15.419 INFO [stdout] test test_filter_whitelist_same_data::test_filter_whitelist_same_data ... ok
Dec 15 21:13:15.447 INFO [stdout] test test_filter_block_all::test_filter_all ... ok
Dec 15 21:13:15.451 INFO [stdout] test test_filter_whitelist_diff_data::test_filter_whitelist_diff_data ... ok
Dec 15 21:13:15.451 INFO [stdout] 
Dec 15 21:13:15.451 INFO [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 21:13:15.451 INFO [stdout] 
Dec 15 21:13:15.456 INFO [stderr]    Doc-tests bip_handshake
Dec 15 21:13:25.103 INFO [stdout] 
Dec 15 21:13:25.103 INFO [stdout] running 0 tests
Dec 15 21:13:25.103 INFO [stdout] 
Dec 15 21:13:25.103 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 21:13:25.103 INFO [stdout] 
Dec 15 21:13:25.114 INFO [stderr] su: No module specific data is present
Dec 15 21:13:25.568 INFO running `"docker" "inspect" "310e9c61410fdd28cde76c4256e90c10de9513a5a7713e00b4e5b67d8b95a905"`
Dec 15 21:13:25.700 INFO running `"docker" "rm" "-f" "310e9c61410fdd28cde76c4256e90c10de9513a5a7713e00b4e5b67d8b95a905"`
Dec 15 21:13:25.776 INFO [stdout] 310e9c61410fdd28cde76c4256e90c10de9513a5a7713e00b4e5b67d8b95a905