Dec 03 18:11:58.464 INFO testing bip_utracker-0.4.0 against 1.30.1 for beta-1.31-5
Dec 03 18:11:58.464 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-7/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/beta-1.31-5/1.30.1:/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 +1.30.1 build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 03 18:11:58.727 INFO [stdout] 2c9ae3e84c4e9ffdd21b6c2f06818847b28501e366ae92b65222d4c0df2d23d7
Dec 03 18:11:58.729 INFO running `"docker" "start" "-a" "2c9ae3e84c4e9ffdd21b6c2f06818847b28501e366ae92b65222d4c0df2d23d7"`
Dec 03 18:12:00.198 INFO [stderr] usermod: no changes
Dec 03 18:12:00.483 INFO [stderr]    Compiling miow v0.1.5
Dec 03 18:12:00.491 INFO [stderr]    Compiling chrono v0.2.25
Dec 03 18:12:01.871 INFO [stderr]    Compiling mio v0.5.1
Dec 03 18:12:06.295 INFO [stderr]    Compiling umio v0.3.0
Dec 03 18:12:06.492 INFO [stderr]    Compiling bip_util v0.5.0
Dec 03 18:12:10.382 INFO [stderr]    Compiling bip_handshake v0.7.1
Dec 03 18:12:17.415 INFO [stderr]    Compiling bip_utracker v0.4.0 (/source)
Dec 03 18:12:26.604 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 26.37s
Dec 03 18:12:26.614 INFO [stderr] su: No module specific data is present
Dec 03 18:12:27.673 INFO running `"docker" "inspect" "2c9ae3e84c4e9ffdd21b6c2f06818847b28501e366ae92b65222d4c0df2d23d7"`
Dec 03 18:12:27.955 INFO running `"docker" "rm" "-f" "2c9ae3e84c4e9ffdd21b6c2f06818847b28501e366ae92b65222d4c0df2d23d7"`
Dec 03 18:12:28.295 INFO [stdout] 2c9ae3e84c4e9ffdd21b6c2f06818847b28501e366ae92b65222d4c0df2d23d7
Dec 03 18:12:28.307 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-7/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/beta-1.31-5/1.30.1:/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 +1.30.1 test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 03 18:12:28.823 INFO [stdout] e7a651b9a3bcbe0bd0f273d5aacdc76afdfc21fff1fd3de45bfdf6c8f3e0f125
Dec 03 18:12:28.825 INFO running `"docker" "start" "-a" "e7a651b9a3bcbe0bd0f273d5aacdc76afdfc21fff1fd3de45bfdf6c8f3e0f125"`
Dec 03 18:12:30.099 INFO [stderr] usermod: no changes
Dec 03 18:12:30.270 INFO [stderr]    Compiling bip_utracker v0.4.0 (/source)
Dec 03 18:12:48.659 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 18.51s
Dec 03 18:12:48.667 INFO [stderr] su: No module specific data is present
Dec 03 18:12:49.703 INFO running `"docker" "inspect" "e7a651b9a3bcbe0bd0f273d5aacdc76afdfc21fff1fd3de45bfdf6c8f3e0f125"`
Dec 03 18:12:50.091 INFO running `"docker" "rm" "-f" "e7a651b9a3bcbe0bd0f273d5aacdc76afdfc21fff1fd3de45bfdf6c8f3e0f125"`
Dec 03 18:12:50.407 INFO [stdout] e7a651b9a3bcbe0bd0f273d5aacdc76afdfc21fff1fd3de45bfdf6c8f3e0f125
Dec 03 18:12:50.415 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-7/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/beta-1.31-5/1.30.1:/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 +1.30.1 test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 03 18:12:50.863 INFO [stdout] e1160b89ca8ad19d4225b761f84508f7fe0dc1dcbca367d9601368ba706c3f76
Dec 03 18:12:50.865 INFO running `"docker" "start" "-a" "e1160b89ca8ad19d4225b761f84508f7fe0dc1dcbca367d9601368ba706c3f76"`
Dec 03 18:12:52.362 INFO [stderr] usermod: no changes
Dec 03 18:12:52.643 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.25s
Dec 03 18:12:52.659 INFO [stderr]      Running /target/debug/deps/bip_utracker-2c783ca66bf50003
Dec 03 18:12:52.667 INFO [stdout] 
Dec 03 18:12:52.667 INFO [stdout] running 76 tests
Dec 03 18:12:52.707 INFO [stdout] test announce::tests::negative_parse_empty_v6_source ... ok
Dec 03 18:12:52.707 INFO [stdout] test announce::tests::negative_parse_empty_v4_source ... ok
Dec 03 18:12:52.708 INFO [stdout] test announce::tests::negative_parse_incomplete_v4_source ... ok
Dec 03 18:12:52.708 INFO [stdout] test announce::tests::negative_parse_incomplete_state ... ok
Dec 03 18:12:52.708 INFO [stdout] test announce::tests::negative_parse_incomplete_v6_source ... ok
Dec 03 18:12:52.709 INFO [stdout] test announce::tests::negative_parse_no_event ... ok
Dec 03 18:12:52.709 INFO [stdout] test announce::tests::positive_parse_explicit_v4_source ... ok
Dec 03 18:12:52.710 INFO [stdout] test announce::tests::positive_parse_explicit_v6_source ... ok
Dec 03 18:12:52.710 INFO [stdout] test announce::tests::positive_parse_implied_v6_source ... ok
Dec 03 18:12:52.710 INFO [stdout] test announce::tests::positive_parse_implied_v4_source ... ok
Dec 03 18:12:52.711 INFO [stdout] test announce::tests::positive_parse_none_event ... ok
Dec 03 18:12:52.711 INFO [stdout] test announce::tests::positive_parse_response_empty_peers ... ok
Dec 03 18:12:52.712 INFO [stdout] test announce::tests::positive_parse_request_empty_options ... ok
Dec 03 18:12:52.712 INFO [stdout] test announce::tests::positive_parse_desired_peers_default ... ok
Dec 03 18:12:52.712 INFO [stdout] test announce::tests::negative_parse_request_missing_key ... ok
Dec 03 18:12:52.713 INFO [stdout] test announce::tests::positive_parse_desired_peers_specified ... ok
Dec 03 18:12:52.713 INFO [stdout] test announce::tests::positive_parse_completed_event ... ok
Dec 03 18:12:52.714 INFO [stdout] test announce::tests::positive_parse_response_many_peers ... ok
Dec 03 18:12:52.714 INFO [stdout] test announce::tests::positive_parse_started_event ... ok
Dec 03 18:12:52.714 INFO [stdout] test announce::tests::positive_parse_state ... ok
Dec 03 18:12:52.715 INFO [stdout] test announce::tests::positive_parse_stopped_event ... ok
Dec 03 18:12:52.715 INFO [stdout] test announce::tests::positive_write_completed_event ... ok
Dec 03 18:12:52.716 INFO [stdout] test announce::tests::positive_write_desired_peers_default ... ok
Dec 03 18:12:52.716 INFO [stdout] test announce::tests::positive_write_desired_peers_specified ... ok
Dec 03 18:12:52.716 INFO [stdout] test announce::tests::positive_write_none_event ... ok
Dec 03 18:12:52.717 INFO [stdout] test announce::tests::positive_write_request ... ok
Dec 03 18:12:52.717 INFO [stdout] test announce::tests::positive_write_response ... ok
Dec 03 18:12:52.718 INFO [stdout] test announce::tests::positive_write_source_ipv4_explicit ... ok
Dec 03 18:12:52.718 INFO [stdout] test announce::tests::positive_write_source_ipv4_implied ... ok
Dec 03 18:12:52.718 INFO [stdout] test announce::tests::positive_write_source_ipv6_explicit ... ok
Dec 03 18:12:52.719 INFO [stdout] test announce::tests::positive_write_source_ipv6_implied ... ok
Dec 03 18:12:52.719 INFO [stdout] test announce::tests::positive_write_started_event ... ok
Dec 03 18:12:52.720 INFO [stdout] test announce::tests::positive_write_state ... ok
Dec 03 18:12:52.720 INFO [stdout] test announce::tests::positive_write_stopped_event ... ok
Dec 03 18:12:52.720 INFO [stdout] test contact::tests::positive_iterate_v4 ... ok
Dec 03 18:12:52.721 INFO [stdout] test contact::tests::positive_iterate_v6 ... ok
Dec 03 18:12:52.721 INFO [stdout] test contact::tests::positive_parse_empty_v4 ... ok
Dec 03 18:12:52.722 INFO [stdout] test contact::tests::positive_parse_peer_v4 ... ok
Dec 03 18:12:52.722 INFO [stdout] test contact::tests::positive_parse_peer_v6 ... ok
Dec 03 18:12:52.722 INFO [stdout] test contact::tests::positive_parse_peers_v4 ... ok
Dec 03 18:12:52.723 INFO [stdout] test contact::tests::positive_parse_peers_v6 ... ok
Dec 03 18:12:52.723 INFO [stdout] test contact::tests::positive_write_empty_v4 ... ok
Dec 03 18:12:52.724 INFO [stdout] test contact::tests::positive_write_empty_v6 ... ok
Dec 03 18:12:52.724 INFO [stdout] test contact::tests::positive_write_peer_v4 ... ok
Dec 03 18:12:52.724 INFO [stdout] test contact::tests::positive_write_peer_v6 ... ok
Dec 03 18:12:52.725 INFO [stdout] test contact::tests::positive_parse_empty_v6 ... ok
Dec 03 18:12:52.725 INFO [stdout] test contact::tests::positive_write_peers_v4 ... ok
Dec 03 18:12:52.725 INFO [stdout] test contact::tests::positive_write_peers_v6 ... ok
Dec 03 18:12:52.726 INFO [stdout] test option::tests::negative_parse_url_data_incomplete ... ok
Dec 03 18:12:52.726 INFO [stdout] test option::tests::negative_parse_url_data_unterminated ... ok
Dec 03 18:12:52.727 INFO [stdout] test option::tests::positive_parse_empty_option ... ok
Dec 03 18:12:52.727 INFO [stdout] test option::tests::positive_parse_end_option ... ok
Dec 03 18:12:52.728 INFO [stdout] test option::tests::positive_parse_noop_option ... ok
Dec 03 18:12:52.728 INFO [stdout] test option::tests::positive_parse_url_data_end_of_options ... ok
Dec 03 18:12:52.728 INFO [stdout] test option::tests::positive_parse_url_data_noop_end_of_options ... ok
Dec 03 18:12:52.729 INFO [stdout] test option::tests::positive_parse_url_data_noop_eof ... ok
Dec 03 18:12:52.729 INFO [stdout] test option::tests::positive_parse_url_data_single_chunk ... ok
Dec 03 18:12:52.730 INFO [stdout] test option::tests::positive_parse_url_data_two_chunks ... ok
Dec 03 18:12:52.730 INFO [stdout] test option::tests::positive_parse_url_data_undivisible_chunks ... ok
Dec 03 18:12:52.730 INFO [stdout] test option::tests::positive_pasre_url_data_eof ... ok
Dec 03 18:12:52.731 INFO [stdout] test option::tests::positive_write_chunked_option ... ok
Dec 03 18:12:52.731 INFO [stdout] test option::tests::positive_write_empty_option ... ok
Dec 03 18:12:52.732 INFO [stdout] test option::tests::positive_write_eof_option ... ok
Dec 03 18:12:52.732 INFO [stdout] test option::tests::positive_write_single_option ... ok
Dec 03 18:12:52.732 INFO [stdout] test scrape::tests::positive_parse_request_empty ... ok
Dec 03 18:12:52.733 INFO [stdout] test scrape::tests::positive_parse_request_multiple_hashes ... ok
Dec 03 18:12:52.733 INFO [stdout] test scrape::tests::positive_parse_response_empty ... ok
Dec 03 18:12:52.734 INFO [stdout] test scrape::tests::positive_parse_request_single_hash ... ok
Dec 03 18:12:52.734 INFO [stdout] test scrape::tests::positive_parse_response_many_stats ... ok
Dec 03 18:12:52.734 INFO [stdout] test scrape::tests::positive_parse_response_single_stat ... ok
Dec 03 18:12:52.735 INFO [stdout] test scrape::tests::positive_write_request_empty ... ok
Dec 03 18:12:52.735 INFO [stdout] test scrape::tests::positive_write_request_many_hashes ... ok
Dec 03 18:12:52.735 INFO [stdout] test scrape::tests::positive_write_request_single_hash ... ok
Dec 03 18:12:52.736 INFO [stdout] test scrape::tests::positive_write_response_empty ... ok
Dec 03 18:12:52.736 INFO [stdout] test scrape::tests::positive_write_response_many_stats ... ok
Dec 03 18:12:52.736 INFO [stdout] test scrape::tests::positive_write_response_single_stat ... ok
Dec 03 18:12:52.736 INFO [stdout] 
Dec 03 18:12:52.737 INFO [stdout] test result: ok. 76 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 03 18:12:52.737 INFO [stdout] 
Dec 03 18:12:52.738 INFO [stderr]      Running /target/debug/deps/test-8d513d10f5b7ac46
Dec 03 18:12:52.744 INFO [stdout] 
Dec 03 18:12:52.744 INFO [stdout] running 8 tests
Dec 03 18:12:52.755 INFO [stdout] test test_client_full::positive_client_request_dropped ... ok
Dec 03 18:12:52.756 INFO [stdout] test test_client_drop::positive_client_request_failed ... ok
Dec 03 18:12:52.900 INFO [stdout] test test_connect::positive_receive_connect_id ... ok
Dec 03 18:12:52.900 INFO [stdout] test test_scrape::positive_scrape ... ok
Dec 03 18:12:52.907 INFO [stdout] test test_announce_stop::positive_announce_stopped ... ok
Dec 03 18:12:52.908 INFO [stdout] test test_connect_cache::positive_connection_id_cache ... ok
Dec 03 18:12:52.923 INFO [stdout] test test_announce_start::positive_announce_started ... ok
Dec 03 18:12:52.971 INFO [stdout] test test_server_drop::positive_server_dropped ... ok
Dec 03 18:12:52.971 INFO [stdout] 
Dec 03 18:12:52.971 INFO [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 03 18:12:52.971 INFO [stdout] 
Dec 03 18:12:52.972 INFO [stderr]    Doc-tests bip_utracker
Dec 03 18:13:06.015 INFO [stdout] 
Dec 03 18:13:06.015 INFO [stdout] running 0 tests
Dec 03 18:13:06.015 INFO [stdout] 
Dec 03 18:13:06.015 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 03 18:13:06.015 INFO [stdout] 
Dec 03 18:13:06.027 INFO [stderr] su: No module specific data is present
Dec 03 18:13:06.605 INFO running `"docker" "inspect" "e1160b89ca8ad19d4225b761f84508f7fe0dc1dcbca367d9601368ba706c3f76"`
Dec 03 18:13:06.831 INFO running `"docker" "rm" "-f" "e1160b89ca8ad19d4225b761f84508f7fe0dc1dcbca367d9601368ba706c3f76"`
Dec 03 18:13:07.179 INFO [stdout] e1160b89ca8ad19d4225b761f84508f7fe0dc1dcbca367d9601368ba706c3f76
