Oct 16 16:54:45.625 INFO testing bip_utracker-0.4.0 against master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513 for rustdoc-test-static-cling-1
Oct 16 16:54:45.627 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-3/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-3/rustdoc-test-static-cling-1/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/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 +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-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"`
Oct 16 16:54:46.076 INFO blam! 932bef72bf0a704a7a1f72282007e84e796da8610bb510d8a9ad53d0cdc49a5d
Oct 16 16:54:46.078 INFO running `"docker" "start" "-a" "932bef72bf0a704a7a1f72282007e84e796da8610bb510d8a9ad53d0cdc49a5d"`
Oct 16 16:54:47.619 INFO kablam! usermod: no changes
Oct 16 16:54:47.895 INFO kablam!    Compiling miow v0.1.5
Oct 16 16:54:47.903 INFO kablam!    Compiling chrono v0.2.25
Oct 16 16:54:48.691 INFO kablam!    Compiling mio v0.5.1
Oct 16 16:54:51.931 INFO kablam!    Compiling umio v0.3.0
Oct 16 16:54:52.609 INFO kablam!    Compiling bip_util v0.5.0
Oct 16 16:54:55.545 INFO kablam!    Compiling bip_handshake v0.7.1
Oct 16 16:55:02.045 INFO kablam!    Compiling bip_utracker v0.4.0 (/source)
Oct 16 16:55:09.360 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 21.71s
Oct 16 16:55:09.368 INFO kablam! su: No module specific data is present
Oct 16 16:55:10.143 INFO running `"docker" "rm" "-f" "932bef72bf0a704a7a1f72282007e84e796da8610bb510d8a9ad53d0cdc49a5d"`
Oct 16 16:55:10.462 INFO blam! 932bef72bf0a704a7a1f72282007e84e796da8610bb510d8a9ad53d0cdc49a5d
Oct 16 16:55:10.467 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-3/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-3/rustdoc-test-static-cling-1/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/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 +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-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"`
Oct 16 16:55:10.891 INFO blam! 1b99068582ef4e613b31e29e985bb8a7bf567594212e4b0f2ab41417d6bc2b5e
Oct 16 16:55:10.894 INFO running `"docker" "start" "-a" "1b99068582ef4e613b31e29e985bb8a7bf567594212e4b0f2ab41417d6bc2b5e"`
Oct 16 16:55:12.239 INFO kablam! usermod: no changes
Oct 16 16:55:12.527 INFO kablam!    Compiling bip_utracker v0.4.0 (/source)
Oct 16 16:55:28.551 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 16.28s
Oct 16 16:55:28.556 INFO kablam! su: No module specific data is present
Oct 16 16:55:29.112 INFO running `"docker" "rm" "-f" "1b99068582ef4e613b31e29e985bb8a7bf567594212e4b0f2ab41417d6bc2b5e"`
Oct 16 16:55:29.299 INFO blam! 1b99068582ef4e613b31e29e985bb8a7bf567594212e4b0f2ab41417d6bc2b5e
Oct 16 16:55:29.304 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-3/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-3/rustdoc-test-static-cling-1/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/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 +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-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"`
Oct 16 16:55:29.732 INFO blam! a902981261855b50fb2c6a2927beb4431bbfa94773f6eb6928a54efe03b0215a
Oct 16 16:55:29.735 INFO running `"docker" "start" "-a" "a902981261855b50fb2c6a2927beb4431bbfa94773f6eb6928a54efe03b0215a"`
Oct 16 16:55:31.071 INFO kablam! usermod: no changes
Oct 16 16:55:31.307 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.19s
Oct 16 16:55:31.313 INFO kablam!      Running /target/debug/deps/bip_utracker-8f87a194b4e9e4ea
Oct 16 16:55:31.328 INFO blam! 
Oct 16 16:55:31.328 INFO blam! running 76 tests
Oct 16 16:55:31.330 INFO blam! test announce::tests::negative_parse_incomplete_v4_source ... ok
Oct 16 16:55:31.330 INFO blam! test announce::tests::negative_parse_empty_v6_source ... ok
Oct 16 16:55:31.331 INFO blam! test announce::tests::negative_parse_incomplete_state ... ok
Oct 16 16:55:31.331 INFO blam! test announce::tests::negative_parse_no_event ... ok
Oct 16 16:55:31.332 INFO blam! test announce::tests::negative_parse_incomplete_v6_source ... ok
Oct 16 16:55:31.333 INFO blam! test announce::tests::positive_parse_desired_peers_specified ... ok
Oct 16 16:55:31.333 INFO blam! test announce::tests::negative_parse_request_missing_key ... ok
Oct 16 16:55:31.334 INFO blam! test announce::tests::positive_parse_completed_event ... ok
Oct 16 16:55:31.334 INFO blam! test announce::tests::positive_parse_explicit_v4_source ... ok
Oct 16 16:55:31.334 INFO blam! test announce::tests::positive_parse_explicit_v6_source ... ok
Oct 16 16:55:31.334 INFO blam! test announce::tests::positive_parse_implied_v6_source ... ok
Oct 16 16:55:31.334 INFO blam! test announce::tests::positive_parse_none_event ... ok
Oct 16 16:55:31.335 INFO blam! test announce::tests::positive_parse_request_empty_options ... ok
Oct 16 16:55:31.335 INFO blam! test announce::tests::positive_parse_implied_v4_source ... ok
Oct 16 16:55:31.335 INFO blam! test announce::tests::positive_parse_response_many_peers ... ok
Oct 16 16:55:31.335 INFO blam! test announce::tests::positive_parse_response_empty_peers ... ok
Oct 16 16:55:31.335 INFO blam! test announce::tests::positive_parse_started_event ... ok
Oct 16 16:55:31.335 INFO blam! test announce::tests::positive_parse_state ... ok
Oct 16 16:55:31.335 INFO blam! test announce::tests::positive_parse_stopped_event ... ok
Oct 16 16:55:31.335 INFO blam! test announce::tests::positive_write_completed_event ... ok
Oct 16 16:55:31.336 INFO blam! test announce::tests::positive_write_desired_peers_specified ... ok
Oct 16 16:55:31.336 INFO blam! test announce::tests::positive_write_none_event ... ok
Oct 16 16:55:31.336 INFO blam! test announce::tests::positive_write_response ... ok
Oct 16 16:55:31.336 INFO blam! test announce::tests::positive_write_request ... ok
Oct 16 16:55:31.336 INFO blam! test announce::tests::positive_write_source_ipv4_explicit ... ok
Oct 16 16:55:31.336 INFO blam! test announce::tests::positive_write_source_ipv4_implied ... ok
Oct 16 16:55:31.336 INFO blam! test announce::tests::positive_write_desired_peers_default ... ok
Oct 16 16:55:31.336 INFO blam! test announce::tests::positive_write_stopped_event ... ok
Oct 16 16:55:31.336 INFO blam! test contact::tests::positive_iterate_v4 ... ok
Oct 16 16:55:31.336 INFO blam! test contact::tests::positive_parse_empty_v4 ... ok
Oct 16 16:55:31.336 INFO blam! test contact::tests::positive_parse_empty_v6 ... ok
Oct 16 16:55:31.337 INFO blam! test announce::tests::positive_write_source_ipv6_implied ... ok
Oct 16 16:55:31.337 INFO blam! test announce::tests::positive_write_started_event ... ok
Oct 16 16:55:31.337 INFO blam! test announce::tests::positive_write_source_ipv6_explicit ... ok
Oct 16 16:55:31.337 INFO blam! test announce::tests::positive_write_state ... ok
Oct 16 16:55:31.337 INFO blam! test contact::tests::positive_write_empty_v4 ... ok
Oct 16 16:55:31.337 INFO blam! test contact::tests::positive_iterate_v6 ... ok
Oct 16 16:55:31.337 INFO blam! test contact::tests::positive_write_empty_v6 ... ok
Oct 16 16:55:31.337 INFO blam! test contact::tests::positive_write_peer_v4 ... ok
Oct 16 16:55:31.337 INFO blam! test contact::tests::positive_parse_peers_v6 ... ok
Oct 16 16:55:31.337 INFO blam! test contact::tests::positive_write_peers_v4 ... ok
Oct 16 16:55:31.337 INFO blam! test contact::tests::positive_parse_peers_v4 ... ok
Oct 16 16:55:31.338 INFO blam! test option::tests::negative_parse_url_data_incomplete ... ok
Oct 16 16:55:31.347 INFO blam! test option::tests::negative_parse_url_data_unterminated ... ok
Oct 16 16:55:31.347 INFO blam! test option::tests::positive_parse_empty_option ... ok
Oct 16 16:55:31.347 INFO blam! test option::tests::positive_parse_end_option ... ok
Oct 16 16:55:31.347 INFO blam! test option::tests::positive_parse_noop_option ... ok
Oct 16 16:55:31.347 INFO blam! test option::tests::positive_parse_url_data_end_of_options ... ok
Oct 16 16:55:31.347 INFO blam! test option::tests::positive_parse_url_data_noop_end_of_options ... ok
Oct 16 16:55:31.347 INFO blam! test contact::tests::positive_parse_peer_v4 ... ok
Oct 16 16:55:31.347 INFO blam! test contact::tests::positive_write_peer_v6 ... ok
Oct 16 16:55:31.363 INFO blam! test option::tests::positive_parse_url_data_noop_eof ... ok
Oct 16 16:55:31.363 INFO blam! test option::tests::positive_parse_url_data_single_chunk ... ok
Oct 16 16:55:31.363 INFO blam! test announce::tests::positive_parse_desired_peers_default ... ok
Oct 16 16:55:31.363 INFO blam! test announce::tests::negative_parse_empty_v4_source ... ok
Oct 16 16:55:31.363 INFO blam! test contact::tests::positive_parse_peer_v6 ... ok
Oct 16 16:55:31.363 INFO blam! test contact::tests::positive_write_peers_v6 ... ok
Oct 16 16:55:31.363 INFO blam! test option::tests::positive_parse_url_data_undivisible_chunks ... ok
Oct 16 16:55:31.363 INFO blam! test option::tests::positive_parse_url_data_two_chunks ... ok
Oct 16 16:55:31.363 INFO blam! test option::tests::positive_write_chunked_option ... ok
Oct 16 16:55:31.371 INFO blam! test option::tests::positive_write_empty_option ... ok
Oct 16 16:55:31.371 INFO blam! test option::tests::positive_write_eof_option ... ok
Oct 16 16:55:31.371 INFO blam! test scrape::tests::positive_parse_request_empty ... ok
Oct 16 16:55:31.371 INFO blam! test option::tests::positive_write_single_option ... ok
Oct 16 16:55:31.371 INFO blam! test scrape::tests::positive_parse_request_multiple_hashes ... ok
Oct 16 16:55:31.371 INFO blam! test scrape::tests::positive_parse_request_single_hash ... ok
Oct 16 16:55:31.379 INFO blam! test option::tests::positive_pasre_url_data_eof ... ok
Oct 16 16:55:31.379 INFO blam! test scrape::tests::positive_parse_response_single_stat ... ok
Oct 16 16:55:31.379 INFO blam! test scrape::tests::positive_write_request_many_hashes ... ok
Oct 16 16:55:31.379 INFO blam! test scrape::tests::positive_write_request_empty ... ok
Oct 16 16:55:31.379 INFO blam! test scrape::tests::positive_parse_response_many_stats ... ok
Oct 16 16:55:31.379 INFO blam! test scrape::tests::positive_write_request_single_hash ... ok
Oct 16 16:55:31.379 INFO blam! test scrape::tests::positive_write_response_many_stats ... ok
Oct 16 16:55:31.379 INFO blam! test scrape::tests::positive_write_response_single_stat ... ok
Oct 16 16:55:31.381 INFO blam! test scrape::tests::positive_write_response_empty ... ok
Oct 16 16:55:31.381 INFO blam! test scrape::tests::positive_parse_response_empty ... ok
Oct 16 16:55:31.381 INFO blam! 
Oct 16 16:55:31.381 INFO blam! test result: ok. 76 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 16 16:55:31.381 INFO blam! 
Oct 16 16:55:31.382 INFO kablam!      Running /target/debug/deps/test-a6d76545ff6e684e
Oct 16 16:55:31.399 INFO blam! 
Oct 16 16:55:31.399 INFO blam! running 8 tests
Oct 16 16:55:31.411 INFO blam! test test_client_full::positive_client_request_dropped ... ok
Oct 16 16:55:31.443 INFO blam! test test_client_drop::positive_client_request_failed ... ok
Oct 16 16:55:31.506 INFO blam! test test_announce_start::positive_announce_started ... ok
Oct 16 16:55:31.523 INFO blam! test test_scrape::positive_scrape ... ok
Oct 16 16:55:31.529 INFO blam! test test_connect_cache::positive_connection_id_cache ... ok
Oct 16 16:55:31.535 INFO blam! test test_announce_stop::positive_announce_stopped ... ok
Oct 16 16:55:31.535 INFO blam! test test_connect::positive_receive_connect_id ... ok
Oct 16 16:55:31.595 INFO blam! test test_server_drop::positive_server_dropped ... ok
Oct 16 16:55:31.595 INFO blam! 
Oct 16 16:55:31.595 INFO blam! test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 16 16:55:31.595 INFO blam! 
Oct 16 16:55:31.596 INFO kablam!    Doc-tests bip_utracker
Oct 16 16:55:41.419 INFO blam! 
Oct 16 16:55:41.419 INFO blam! running 0 tests
Oct 16 16:55:41.421 INFO blam! 
Oct 16 16:55:41.421 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 16 16:55:41.421 INFO blam! 
Oct 16 16:55:41.435 INFO kablam! su: No module specific data is present
Oct 16 16:55:41.721 INFO running `"docker" "rm" "-f" "a902981261855b50fb2c6a2927beb4431bbfa94773f6eb6928a54efe03b0215a"`
Oct 16 16:55:41.857 INFO blam! a902981261855b50fb2c6a2927beb4431bbfa94773f6eb6928a54efe03b0215a