Dec 14 14:00:50.577 INFO testing webrtc-sctp-0.0.0 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 14 14:00:50.577 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 14 14:00:50.955 INFO [stdout] a3c939914e1607923d3323a7f5f43c2f40c56ba067a61dd10bb614569593afda
Dec 14 14:00:50.967 INFO running `"docker" "start" "-a" "a3c939914e1607923d3323a7f5f43c2f40c56ba067a61dd10bb614569593afda"`
Dec 14 14:00:52.111 INFO [stderr] usermod: no changes
Dec 14 14:00:52.431 INFO [stderr]    Compiling tokio-timer v0.1.2
Dec 14 14:00:52.463 INFO [stderr]    Compiling nom v4.1.1
Dec 14 14:00:52.463 INFO [stderr]    Compiling blake2 v0.7.1
Dec 14 14:00:58.235 INFO [stderr]    Compiling webrtc-sctp v0.0.0 (/source)
Dec 14 14:01:10.868 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 18.74s
Dec 14 14:01:10.884 INFO [stderr] su: No module specific data is present
Dec 14 14:01:11.755 INFO running `"docker" "inspect" "a3c939914e1607923d3323a7f5f43c2f40c56ba067a61dd10bb614569593afda"`
Dec 14 14:01:12.123 INFO running `"docker" "rm" "-f" "a3c939914e1607923d3323a7f5f43c2f40c56ba067a61dd10bb614569593afda"`
Dec 14 14:01:12.499 INFO [stdout] a3c939914e1607923d3323a7f5f43c2f40c56ba067a61dd10bb614569593afda
Dec 14 14:01:12.507 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 14 14:01:12.928 INFO [stdout] 43fcf94309b97fe810b5cb4a46571781c5ec1355717c34b4c567c6f7ed672f38
Dec 14 14:01:12.935 INFO running `"docker" "start" "-a" "43fcf94309b97fe810b5cb4a46571781c5ec1355717c34b4c567c6f7ed672f38"`
Dec 14 14:01:14.015 INFO [stderr] usermod: no changes
Dec 14 14:01:14.303 INFO [stderr]    Compiling webrtc-sctp v0.0.0 (/source)
Dec 14 14:01:40.162 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 26.12s
Dec 14 14:01:40.173 INFO [stderr] su: No module specific data is present
Dec 14 14:01:40.623 INFO running `"docker" "inspect" "43fcf94309b97fe810b5cb4a46571781c5ec1355717c34b4c567c6f7ed672f38"`
Dec 14 14:01:41.003 INFO running `"docker" "rm" "-f" "43fcf94309b97fe810b5cb4a46571781c5ec1355717c34b4c567c6f7ed672f38"`
Dec 14 14:01:41.369 INFO [stdout] 43fcf94309b97fe810b5cb4a46571781c5ec1355717c34b4c567c6f7ed672f38
Dec 14 14:01:41.377 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 14 14:01:41.784 INFO [stdout] db9ea0dc4ac54dd77dc335be5e484c54f9dd9cf823357f88fcb9238e269add71
Dec 14 14:01:41.788 INFO running `"docker" "start" "-a" "db9ea0dc4ac54dd77dc335be5e484c54f9dd9cf823357f88fcb9238e269add71"`
Dec 14 14:01:43.287 INFO [stderr] usermod: no changes
Dec 14 14:01:43.555 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.24s
Dec 14 14:01:43.567 INFO [stderr]      Running /target/debug/deps/webrtc_sctp-9e62f35538937158
Dec 14 14:01:43.579 INFO [stdout] 
Dec 14 14:01:43.579 INFO [stdout] running 79 tests
Dec 14 14:01:43.579 INFO [stdout] test packet::chunk::tests::test_cookie_echo_chunk ... ok
Dec 14 14:01:43.579 INFO [stdout] test packet::chunk::tests::test_cookie_ack_chunk ... ok
Dec 14 14:01:43.579 INFO [stdout] test packet::chunk::tests::test_data_chunk_full ... ignored
Dec 14 14:01:43.579 INFO [stdout] test packet::chunk::tests::test_abort_chunk_full ... ok
Dec 14 14:01:43.579 INFO [stdout] test packet::chunk::tests::test_abort_chunk ... ok
Dec 14 14:01:43.579 INFO [stdout] test packet::checksum::tests::test_checksum_write ... ok
Dec 14 14:01:43.579 INFO [stdout] test packet::chunk::tests::test_data_chunk ... ok
Dec 14 14:01:43.579 INFO [stdout] test packet::chunk::tests::test_error_chunk ... ok
Dec 14 14:01:43.579 INFO [stdout] test packet::checksum::tests::test_checksum_read ... ok
Dec 14 14:01:43.579 INFO [stdout] test packet::chunk::tests::test_error_chunk_full ... ok
Dec 14 14:01:43.579 INFO [stdout] test packet::chunk::tests::test_init_ack_chunk_full ... ignored
Dec 14 14:01:43.579 INFO [stdout] test packet::chunk::tests::test_heartbeat_ack_chunk ... ok
Dec 14 14:01:43.579 INFO [stdout] test packet::chunk::tests::test_init_chunk_full ... ignored
Dec 14 14:01:43.579 INFO [stdout] test packet::chunk::tests::test_heartbeat_ack_chunk_full ... ok
Dec 14 14:01:43.579 INFO [stdout] test packet::chunk::tests::test_sack_chunk_full ... ignored
Dec 14 14:01:43.579 INFO [stdout] test packet::chunk::tests::test_heartbeat_chunk ... ok
Dec 14 14:01:43.579 INFO [stdout] test packet::chunk::tests::test_heartbeat_chunk_full ... ok
Dec 14 14:01:43.579 INFO [stdout] test packet::checksum::tests::test_checksum_compute ... ok
Dec 14 14:01:43.579 INFO [stdout] test packet::chunk::tests::test_init_ack_chunk ... ok
Dec 14 14:01:43.579 INFO [stdout] test packet::chunk::tests::test_init_chunk ... ok
Dec 14 14:01:43.583 INFO [stdout] test packet::checksum::tests::test_checksum_verify ... ok
Dec 14 14:01:43.584 INFO [stdout] test packet::chunk::tests::test_sack_chunk ... ok
Dec 14 14:01:43.584 INFO [stdout] test packet::chunk::tests::test_shutdown_ack_chunk ... ok
Dec 14 14:01:43.584 INFO [stdout] test packet::chunk::tests::test_shutdown_chunk ... ok
Dec 14 14:01:43.584 INFO [stdout] test packet::chunk::tests::test_shutdown_chunk_full ... ok
Dec 14 14:01:43.584 INFO [stdout] test packet::chunk::tests::test_shutdown_complete_chunk ... ok
Dec 14 14:01:43.584 INFO [stdout] test packet::error_cause::tests::test_invalid_mandatory_parameter ... ok
Dec 14 14:01:43.584 INFO [stdout] test packet::chunk::tests::test_shutdown_complete_chunk_full ... ok
Dec 14 14:01:43.584 INFO [stdout] test packet::error_cause::tests::test_invalid_stream_identifier ... ok
Dec 14 14:01:43.584 INFO [stdout] test packet::error_cause::tests::test_invalid_stream_identifier_full ... ok
Dec 14 14:01:43.584 INFO [stdout] test packet::error_cause::tests::test_missing_mandatory_parameter ... ok
Dec 14 14:01:43.587 INFO [stdout] test packet::error_cause::tests::test_no_user_data ... ok
Dec 14 14:01:43.587 INFO [stdout] test packet::error_cause::tests::test_cookie_received_while_shutting_down ... ok
Dec 14 14:01:43.587 INFO [stdout] test packet::error_cause::tests::test_no_user_data_full ... ok
Dec 14 14:01:43.587 INFO [stdout] test packet::error_cause::tests::test_out_of_resource ... ok
Dec 14 14:01:43.587 INFO [stdout] test packet::error_cause::tests::test_protocol_violation ... ok
Dec 14 14:01:43.603 INFO [stdout] test packet::error_cause::tests::test_stale_cookie ... ok
Dec 14 14:01:43.603 INFO [stdout] test packet::error_cause::tests::test_unrecognized_chunk_type ... ok
Dec 14 14:01:43.603 INFO [stdout] test packet::error_cause::tests::test_stale_cookie_full ... ok
Dec 14 14:01:43.603 INFO [stdout] test packet::error_cause::tests::test_restart_association_with_new_addresses_full ... ok
Dec 14 14:01:43.603 INFO [stdout] test packet::error_cause::tests::test_unrecognized_parameters ... ok
Dec 14 14:01:43.603 INFO [stdout] test packet::error_cause::tests::test_restart_association_with_new_addresses ... ok
Dec 14 14:01:43.603 INFO [stdout] test packet::error_cause::tests::test_unrecognized_parameters_full ... ok
Dec 14 14:01:43.603 INFO [stdout] test packet::error_cause::tests::test_unresolvable_address ... ok
Dec 14 14:01:43.611 INFO [stdout] test packet::error_cause::tests::test_user_initiated_abort ... ok
Dec 14 14:01:43.611 INFO [stdout] test packet::error_cause::tests::test_unresolvable_address_full ... ok
Dec 14 14:01:43.611 INFO [stdout] test packet::parameter::tests::test_cookie_preservative_parameter ... ok
Dec 14 14:01:43.611 INFO [stdout] test packet::parameter::tests::test_cookie_preservative_parameter_full ... ok
Dec 14 14:01:43.623 INFO [stdout] test packet::parameter::tests::test_ecn_capable ... ok
Dec 14 14:01:43.623 INFO [stdout] test packet::parameter::tests::test_forward_tsn_supported ... ok
Dec 14 14:01:43.623 INFO [stdout] test packet::parameter::tests::test_heartbeat_info ... ok
Dec 14 14:01:43.628 INFO [stdout] test packet::parameter::tests::test_ipv4_address ... ok
Dec 14 14:01:43.635 INFO [stdout] test packet::parameter::tests::test_ipv4_address_full ... ok
Dec 14 14:01:43.639 INFO [stdout] test packet::parameter::tests::test_host_name_address_parameter_full ... ok
Dec 14 14:01:43.639 INFO [stdout] test packet::parameter::tests::test_host_name_address_parameter ... ok
Dec 14 14:01:43.651 INFO [stdout] test packet::parameter::tests::test_state_cookie ... ok
Dec 14 14:01:43.651 INFO [stdout] test packet::parameter::tests::test_supported_address_types ... ok
Dec 14 14:01:43.651 INFO [stdout] test packet::parameter::tests::test_ipv6_address ... ok
Dec 14 14:01:43.707 INFO [stdout] test packet::parameter::tests::test_unrecognized_parameter ... ok
Dec 14 14:01:43.707 INFO [stdout] test packet::parameter::tests::test_unrecognized_parameter_full ... ok
Dec 14 14:01:43.707 INFO [stdout] test packet::error_cause::tests::test_user_initiated_abort_full ... ok
Dec 14 14:01:43.707 INFO [stdout] test packet::parameter::tests::test_supported_address_types_full ... ok
Dec 14 14:01:43.714 INFO [stdout] test packet::tests::test_packet_init ... ok
Dec 14 14:01:43.714 INFO [stdout] test packet::tests::test_packet_cookie_ack_and_sack ... ok
Dec 14 14:01:43.714 INFO [stdout] test stack::queue::tests::test_inverse_order ... ok
Dec 14 14:01:43.735 INFO [stdout] test packet::error_cause::tests::test_protocol_violation_full ... ok
Dec 14 14:01:43.787 INFO [stdout] test packet::error_cause::tests::test_unrecognized_chunk_type_full ... ok
Dec 14 14:01:43.788 INFO [stdout] test packet::error_cause::tests::test_missing_mandatory_parameter_full ... ok
Dec 14 14:01:43.788 INFO [stdout] test util::serial::tests::test_ops ... ok
Dec 14 14:01:43.812 INFO [stdout] test util::serial::tests::test_serial_add ... ok
Dec 14 14:01:43.827 INFO [stdout] test util::serial::tests::test_serial_compare ... ok
Dec 14 14:01:43.827 INFO [stdout] test packet::parameter::tests::test_heartbeat_info_full ... ok
Dec 14 14:01:43.980 INFO [stdout] test stack::recvtracker::tests::test_recvtracker_rwnd_tracking ... ok
Dec 14 14:01:44.084 INFO [stdout] test util::tests::test_generate_test_data ... ok
Dec 14 14:01:44.554 INFO [stdout] test stack::recvtracker::tests::test_recvtracker_tsn_tracking ... ok
Dec 14 14:01:45.143 INFO [stdout] test stack::queue::tests::test_unordered_data_queue ... ok
Dec 14 14:01:45.555 INFO [stdout] test stack::queue::tests::test_ordered_data_queue ... ok
Dec 14 14:01:45.654 INFO [stdout] test util::buffer::tests::test_buffer ... ok
Dec 14 14:01:45.942 INFO [stdout] test stack::queue::tests::test_outgoing_data_queue ... ok
Dec 14 14:01:45.942 INFO [stdout] 
Dec 14 14:01:45.942 INFO [stdout] test result: ok. 75 passed; 0 failed; 4 ignored; 0 measured; 0 filtered out
Dec 14 14:01:45.942 INFO [stdout] 
Dec 14 14:01:45.945 INFO [stderr]      Running /target/debug/deps/test_simulation-e6d0af3c830011f9
Dec 14 14:01:45.949 INFO [stdout] 
Dec 14 14:01:45.949 INFO [stdout] running 10 tests
Dec 14 14:01:45.981 INFO [stdout] test test_many_associate_shutdown ... ignored
Dec 14 14:01:46.065 INFO [stdout] test test_shutdown ... ok
Dec 14 14:01:46.203 INFO [stdout] test test_simultaneous_shutdown ... ok
Dec 14 14:01:46.322 INFO [stdout] test test_recv_timeout ... ok
Dec 14 14:01:46.340 INFO [stdout] test test_associate ... ok
Dec 14 14:01:46.363 INFO [stdout] test test_data ... ok
Dec 14 14:01:46.455 INFO [stdout] test test_single_fragmented_message ... ok
Dec 14 14:01:46.514 INFO [stdout] test test_connect_timeout ... ok
Dec 14 14:01:49.274 INFO [stdout] re-sending chunk: DATA tsn=3957102621 stream_id=0 ssn=0 UBE=011 ppi=0
Dec 14 14:01:49.274 INFO [stdout] 	0000: 74 65 73 74 69 6e 67 31 32 33                   testing123
Dec 14 14:01:49.277 INFO [stdout] test test_retransmit ... ok
Dec 14 14:01:52.836 INFO [stdout] test test_many_fragmented_messages ... ok
Dec 14 14:01:52.836 INFO [stdout] 
Dec 14 14:01:52.836 INFO [stdout] test result: ok. 9 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out
Dec 14 14:01:52.836 INFO [stdout] 
Dec 14 14:01:52.839 INFO [stderr]    Doc-tests webrtc-sctp
Dec 14 14:02:00.265 INFO [stdout] 
Dec 14 14:02:00.265 INFO [stdout] running 0 tests
Dec 14 14:02:00.265 INFO [stdout] 
Dec 14 14:02:00.267 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 14:02:00.267 INFO [stdout] 
Dec 14 14:02:00.279 INFO [stderr] su: No module specific data is present
Dec 14 14:02:01.160 INFO running `"docker" "inspect" "db9ea0dc4ac54dd77dc335be5e484c54f9dd9cf823357f88fcb9238e269add71"`
Dec 14 14:02:01.391 INFO running `"docker" "rm" "-f" "db9ea0dc4ac54dd77dc335be5e484c54f9dd9cf823357f88fcb9238e269add71"`
Dec 14 14:02:01.690 INFO [stdout] db9ea0dc4ac54dd77dc335be5e484c54f9dd9cf823357f88fcb9238e269add71