Nov 17 18:19:05.359 INFO testing webrtc-sctp-0.0.0 against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 17 18:19:05.359 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 17 18:19:05.807 INFO [stdout] f1629ce22c93a22f72c77e3ae676b50f4aeab4e655af877c38d443286ef07ae1
Nov 17 18:19:05.815 INFO running `"docker" "start" "-a" "f1629ce22c93a22f72c77e3ae676b50f4aeab4e655af877c38d443286ef07ae1"`
Nov 17 18:19:08.103 INFO [stderr] usermod: no changes
Nov 17 18:19:08.414 INFO [stderr]    Compiling tokio-timer v0.1.2
Nov 17 18:19:08.443 INFO [stderr]    Compiling blake2 v0.7.1
Nov 17 18:19:11.707 INFO [stderr]    Compiling webrtc-sctp v0.0.0 (/source)
Nov 17 18:19:23.375 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 15.24s
Nov 17 18:19:23.391 INFO [stderr] su: No module specific data is present
Nov 17 18:19:24.267 INFO running `"docker" "inspect" "f1629ce22c93a22f72c77e3ae676b50f4aeab4e655af877c38d443286ef07ae1"`
Nov 17 18:19:24.771 INFO running `"docker" "rm" "-f" "f1629ce22c93a22f72c77e3ae676b50f4aeab4e655af877c38d443286ef07ae1"`
Nov 17 18:19:25.103 INFO [stdout] f1629ce22c93a22f72c77e3ae676b50f4aeab4e655af877c38d443286ef07ae1
Nov 17 18:19:25.107 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 17 18:19:25.531 INFO [stdout] 001fb566ca5d8acca56417932a4507badaf9a2bf67de7ebf8259d8d3664390f9
Nov 17 18:19:25.537 INFO running `"docker" "start" "-a" "001fb566ca5d8acca56417932a4507badaf9a2bf67de7ebf8259d8d3664390f9"`
Nov 17 18:19:26.790 INFO [stderr] usermod: no changes
Nov 17 18:19:27.067 INFO [stderr]    Compiling webrtc-sctp v0.0.0 (/source)
Nov 17 18:19:50.899 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 24.08s
Nov 17 18:19:50.915 INFO [stderr] su: No module specific data is present
Nov 17 18:19:51.868 INFO running `"docker" "inspect" "001fb566ca5d8acca56417932a4507badaf9a2bf67de7ebf8259d8d3664390f9"`
Nov 17 18:19:52.181 INFO running `"docker" "rm" "-f" "001fb566ca5d8acca56417932a4507badaf9a2bf67de7ebf8259d8d3664390f9"`
Nov 17 18:19:52.467 INFO [stdout] 001fb566ca5d8acca56417932a4507badaf9a2bf67de7ebf8259d8d3664390f9
Nov 17 18:19:52.471 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 17 18:19:52.893 INFO [stdout] 75987c4464821c9e7ca9a106f0a2acc8191be1eac7ed738401a1a77296250398
Nov 17 18:19:52.898 INFO running `"docker" "start" "-a" "75987c4464821c9e7ca9a106f0a2acc8191be1eac7ed738401a1a77296250398"`
Nov 17 18:19:54.077 INFO [stderr] usermod: no changes
Nov 17 18:19:54.303 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.20s
Nov 17 18:19:54.322 INFO [stderr]      Running /target/debug/deps/webrtc_sctp-5e4c6cd20caa50ed
Nov 17 18:19:54.322 INFO [stdout] 
Nov 17 18:19:54.322 INFO [stdout] running 79 tests
Nov 17 18:19:54.322 INFO [stdout] test packet::checksum::tests::test_checksum_compute ... ok
Nov 17 18:19:54.322 INFO [stdout] test packet::chunk::tests::test_data_chunk ... ok
Nov 17 18:19:54.322 INFO [stdout] test packet::chunk::tests::test_data_chunk_full ... ignored
Nov 17 18:19:54.323 INFO [stdout] test packet::chunk::tests::test_error_chunk ... ok
Nov 17 18:19:54.323 INFO [stdout] test packet::checksum::tests::test_checksum_read ... ok
Nov 17 18:19:54.324 INFO [stdout] test packet::checksum::tests::test_checksum_verify ... ok
Nov 17 18:19:54.324 INFO [stdout] test packet::chunk::tests::test_abort_chunk ... ok
Nov 17 18:19:54.324 INFO [stdout] test packet::chunk::tests::test_cookie_ack_chunk ... ok
Nov 17 18:19:54.324 INFO [stdout] test packet::checksum::tests::test_checksum_write ... ok
Nov 17 18:19:54.324 INFO [stdout] test packet::chunk::tests::test_abort_chunk_full ... ok
Nov 17 18:19:54.324 INFO [stdout] test packet::chunk::tests::test_cookie_echo_chunk ... ok
Nov 17 18:19:54.324 INFO [stdout] test packet::chunk::tests::test_init_ack_chunk_full ... ignored
Nov 17 18:19:54.324 INFO [stdout] test packet::chunk::tests::test_init_chunk_full ... ignored
Nov 17 18:19:54.327 INFO [stdout] test packet::chunk::tests::test_error_chunk_full ... ok
Nov 17 18:19:54.327 INFO [stdout] test packet::chunk::tests::test_sack_chunk_full ... ignored
Nov 17 18:19:54.327 INFO [stdout] test packet::chunk::tests::test_heartbeat_ack_chunk_full ... ok
Nov 17 18:19:54.327 INFO [stdout] test packet::chunk::tests::test_heartbeat_chunk ... ok
Nov 17 18:19:54.327 INFO [stdout] test packet::chunk::tests::test_heartbeat_chunk_full ... ok
Nov 17 18:19:54.327 INFO [stdout] test packet::chunk::tests::test_init_ack_chunk ... ok
Nov 17 18:19:54.327 INFO [stdout] test packet::chunk::tests::test_init_chunk ... ok
Nov 17 18:19:54.327 INFO [stdout] test packet::chunk::tests::test_heartbeat_ack_chunk ... ok
Nov 17 18:19:54.327 INFO [stdout] test packet::chunk::tests::test_sack_chunk ... ok
Nov 17 18:19:54.327 INFO [stdout] test packet::chunk::tests::test_shutdown_ack_chunk ... ok
Nov 17 18:19:54.327 INFO [stdout] test packet::chunk::tests::test_shutdown_chunk ... ok
Nov 17 18:19:54.327 INFO [stdout] test packet::chunk::tests::test_shutdown_chunk_full ... ok
Nov 17 18:19:54.327 INFO [stdout] test packet::chunk::tests::test_shutdown_complete_chunk ... ok
Nov 17 18:19:54.327 INFO [stdout] test packet::chunk::tests::test_shutdown_complete_chunk_full ... ok
Nov 17 18:19:54.327 INFO [stdout] test packet::error_cause::tests::test_cookie_received_while_shutting_down ... ok
Nov 17 18:19:54.327 INFO [stdout] test packet::error_cause::tests::test_invalid_mandatory_parameter ... ok
Nov 17 18:19:54.327 INFO [stdout] test packet::error_cause::tests::test_invalid_stream_identifier ... ok
Nov 17 18:19:54.327 INFO [stdout] test packet::error_cause::tests::test_no_user_data_full ... ok
Nov 17 18:19:54.327 INFO [stdout] test packet::error_cause::tests::test_no_user_data ... ok
Nov 17 18:19:54.327 INFO [stdout] test packet::error_cause::tests::test_invalid_stream_identifier_full ... ok
Nov 17 18:19:54.331 INFO [stdout] test packet::error_cause::tests::test_missing_mandatory_parameter ... ok
Nov 17 18:19:54.335 INFO [stdout] test packet::error_cause::tests::test_out_of_resource ... ok
Nov 17 18:19:54.335 INFO [stdout] test packet::error_cause::tests::test_restart_association_with_new_addresses ... ok
Nov 17 18:19:54.335 INFO [stdout] test packet::error_cause::tests::test_protocol_violation ... ok
Nov 17 18:19:54.335 INFO [stdout] test packet::error_cause::tests::test_unrecognized_chunk_type ... ok
Nov 17 18:19:54.335 INFO [stdout] test packet::error_cause::tests::test_unrecognized_parameters ... ok
Nov 17 18:19:54.335 INFO [stdout] test packet::error_cause::tests::test_stale_cookie_full ... ok
Nov 17 18:19:54.335 INFO [stdout] test packet::error_cause::tests::test_unrecognized_parameters_full ... ok
Nov 17 18:19:54.335 INFO [stdout] test packet::error_cause::tests::test_restart_association_with_new_addresses_full ... ok
Nov 17 18:19:54.359 INFO [stdout] test packet::error_cause::tests::test_stale_cookie ... ok
Nov 17 18:19:54.359 INFO [stdout] test packet::error_cause::tests::test_unresolvable_address_full ... ok
Nov 17 18:19:54.359 INFO [stdout] test packet::error_cause::tests::test_unresolvable_address ... ok
Nov 17 18:19:54.359 INFO [stdout] test packet::error_cause::tests::test_user_initiated_abort ... ok
Nov 17 18:19:54.387 INFO [stdout] test packet::error_cause::tests::test_unrecognized_chunk_type_full ... ok
Nov 17 18:19:54.391 INFO [stdout] test packet::parameter::tests::test_heartbeat_info ... ok
Nov 17 18:19:54.391 INFO [stdout] test packet::parameter::tests::test_forward_tsn_supported ... ok
Nov 17 18:19:54.399 INFO [stdout] test packet::parameter::tests::test_cookie_preservative_parameter ... ok
Nov 17 18:19:54.399 INFO [stdout] test packet::parameter::tests::test_host_name_address_parameter ... ok
Nov 17 18:19:54.435 INFO [stdout] test packet::parameter::tests::test_cookie_preservative_parameter_full ... ok
Nov 17 18:19:54.435 INFO [stdout] test packet::parameter::tests::test_ecn_capable ... ok
Nov 17 18:19:54.435 INFO [stdout] test packet::error_cause::tests::test_missing_mandatory_parameter_full ... ok
Nov 17 18:19:54.435 INFO [stdout] test packet::parameter::tests::test_host_name_address_parameter_full ... ok
Nov 17 18:19:54.455 INFO [stdout] test packet::parameter::tests::test_ipv4_address_full ... ok
Nov 17 18:19:54.455 INFO [stdout] test packet::parameter::tests::test_ipv6_address ... ok
Nov 17 18:19:54.467 INFO [stdout] test packet::parameter::tests::test_ipv4_address ... ok
Nov 17 18:19:54.467 INFO [stdout] test packet::parameter::tests::test_supported_address_types_full ... ok
Nov 17 18:19:54.467 INFO [stdout] test packet::parameter::tests::test_unrecognized_parameter ... ok
Nov 17 18:19:54.467 INFO [stdout] test packet::parameter::tests::test_supported_address_types ... ok
Nov 17 18:19:54.467 INFO [stdout] test packet::parameter::tests::test_state_cookie ... ok
Nov 17 18:19:54.467 INFO [stdout] test packet::parameter::tests::test_unrecognized_parameter_full ... ok
Nov 17 18:19:54.467 INFO [stdout] test packet::tests::test_packet_init ... ok
Nov 17 18:19:54.467 INFO [stdout] test packet::tests::test_packet_cookie_ack_and_sack ... ok
Nov 17 18:19:54.467 INFO [stdout] test stack::queue::tests::test_inverse_order ... ok
Nov 17 18:19:54.511 INFO [stdout] test packet::error_cause::tests::test_protocol_violation_full ... ok
Nov 17 18:19:54.535 INFO [stdout] test packet::error_cause::tests::test_user_initiated_abort_full ... ok
Nov 17 18:19:54.571 INFO [stdout] test packet::parameter::tests::test_heartbeat_info_full ... ok
Nov 17 18:19:54.573 INFO [stdout] test util::serial::tests::test_ops ... ok
Nov 17 18:19:54.579 INFO [stdout] test util::serial::tests::test_serial_compare ... ok
Nov 17 18:19:54.579 INFO [stdout] test util::serial::tests::test_serial_add ... ok
Nov 17 18:19:54.678 INFO [stdout] test stack::recvtracker::tests::test_recvtracker_rwnd_tracking ... ok
Nov 17 18:19:54.799 INFO [stdout] test util::tests::test_generate_test_data ... ok
Nov 17 18:19:55.283 INFO [stdout] test stack::recvtracker::tests::test_recvtracker_tsn_tracking ... ok
Nov 17 18:19:55.786 INFO [stdout] test stack::queue::tests::test_ordered_data_queue ... ok
Nov 17 18:19:55.935 INFO [stdout] test stack::queue::tests::test_unordered_data_queue ... ok
Nov 17 18:19:56.303 INFO [stdout] test util::buffer::tests::test_buffer ... ok
Nov 17 18:19:56.457 INFO [stdout] test stack::queue::tests::test_outgoing_data_queue ... ok
Nov 17 18:19:56.457 INFO [stdout] 
Nov 17 18:19:56.457 INFO [stdout] test result: ok. 75 passed; 0 failed; 4 ignored; 0 measured; 0 filtered out
Nov 17 18:19:56.457 INFO [stdout] 
Nov 17 18:19:56.459 INFO [stderr]      Running /target/debug/deps/test_simulation-ad6c37837dbcf6c0
Nov 17 18:19:56.469 INFO [stdout] 
Nov 17 18:19:56.469 INFO [stdout] running 10 tests
Nov 17 18:19:56.470 INFO [stdout] test test_many_associate_shutdown ... ignored
Nov 17 18:19:56.504 INFO [stdout] test test_simultaneous_shutdown ... ok
Nov 17 18:19:56.551 INFO [stdout] test test_data ... ok
Nov 17 18:19:56.551 INFO [stdout] test test_associate ... ok
Nov 17 18:19:56.571 INFO [stdout] test test_shutdown ... ok
Nov 17 18:19:56.664 INFO [stdout] test test_single_fragmented_message ... ok
Nov 17 18:19:56.767 INFO [stdout] test test_recv_timeout ... ok
Nov 17 18:19:56.769 INFO [stdout] test test_connect_timeout ... ok
Nov 17 18:19:59.514 INFO [stdout] re-sending chunk: DATA tsn=1574096412 stream_id=0 ssn=0 UBE=011 ppi=0
Nov 17 18:19:59.514 INFO [stdout] 	0000: 74 65 73 74 69 6e 67 31 32 33                   testing123
Nov 17 18:19:59.519 INFO [stdout] test test_retransmit ... ok
Nov 17 18:20:02.356 INFO [stdout] test test_many_fragmented_messages ... ok
Nov 17 18:20:02.356 INFO [stdout] 
Nov 17 18:20:02.356 INFO [stdout] test result: ok. 9 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out
Nov 17 18:20:02.356 INFO [stdout] 
Nov 17 18:20:02.357 INFO [stderr]    Doc-tests webrtc-sctp
Nov 17 18:20:07.811 INFO [stdout] 
Nov 17 18:20:07.811 INFO [stdout] running 0 tests
Nov 17 18:20:07.811 INFO [stdout] 
Nov 17 18:20:07.811 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 18:20:07.811 INFO [stdout] 
Nov 17 18:20:07.823 INFO [stderr] su: No module specific data is present
Nov 17 18:20:08.547 INFO running `"docker" "inspect" "75987c4464821c9e7ca9a106f0a2acc8191be1eac7ed738401a1a77296250398"`
Nov 17 18:20:08.805 INFO running `"docker" "rm" "-f" "75987c4464821c9e7ca9a106f0a2acc8191be1eac7ed738401a1a77296250398"`
Nov 17 18:20:08.995 INFO [stdout] 75987c4464821c9e7ca9a106f0a2acc8191be1eac7ed738401a1a77296250398