Dec 15 16:01:10.197 INFO testing elp-2.0.0 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 15 16:01:10.197 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 16:01:10.819 INFO [stdout] 9996a44c954781d160361ae9445b8a5734ed81bc7077d49fc69f3ce958199e0d
Dec 15 16:01:10.821 INFO running `"docker" "start" "-a" "9996a44c954781d160361ae9445b8a5734ed81bc7077d49fc69f3ce958199e0d"`
Dec 15 16:01:12.091 INFO [stderr] usermod: no changes
Dec 15 16:01:12.231 INFO [stderr]    Compiling elp v2.0.0 (/source)
Dec 15 16:01:13.609 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.48s
Dec 15 16:01:13.613 INFO [stderr] su: No module specific data is present
Dec 15 16:01:13.920 INFO running `"docker" "inspect" "9996a44c954781d160361ae9445b8a5734ed81bc7077d49fc69f3ce958199e0d"`
Dec 15 16:01:14.028 INFO running `"docker" "rm" "-f" "9996a44c954781d160361ae9445b8a5734ed81bc7077d49fc69f3ce958199e0d"`
Dec 15 16:01:14.126 INFO [stdout] 9996a44c954781d160361ae9445b8a5734ed81bc7077d49fc69f3ce958199e0d
Dec 15 16:01:14.128 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 16:01:14.328 INFO [stdout] 06460a5029e8ce1c00385ae0127159a84e04fd40cd6db4ccd9ff8975a5c78b03
Dec 15 16:01:14.330 INFO running `"docker" "start" "-a" "06460a5029e8ce1c00385ae0127159a84e04fd40cd6db4ccd9ff8975a5c78b03"`
Dec 15 16:01:14.919 INFO [stderr] usermod: no changes
Dec 15 16:01:14.987 INFO [stderr]    Compiling elp v2.0.0 (/source)
Dec 15 16:01:17.519 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.57s
Dec 15 16:01:17.519 INFO [stderr] su: No module specific data is present
Dec 15 16:01:18.080 INFO running `"docker" "inspect" "06460a5029e8ce1c00385ae0127159a84e04fd40cd6db4ccd9ff8975a5c78b03"`
Dec 15 16:01:18.304 INFO running `"docker" "rm" "-f" "06460a5029e8ce1c00385ae0127159a84e04fd40cd6db4ccd9ff8975a5c78b03"`
Dec 15 16:01:18.596 INFO [stdout] 06460a5029e8ce1c00385ae0127159a84e04fd40cd6db4ccd9ff8975a5c78b03
Dec 15 16:01:18.601 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 16:01:18.967 INFO [stdout] 8156a080e398341fe922ed93d82032afdfaee589ba6877089ad598b4d25cbd9c
Dec 15 16:01:18.973 INFO running `"docker" "start" "-a" "8156a080e398341fe922ed93d82032afdfaee589ba6877089ad598b4d25cbd9c"`
Dec 15 16:01:20.115 INFO [stderr] usermod: no changes
Dec 15 16:01:20.255 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.08s
Dec 15 16:01:20.255 INFO [stderr]      Running /target/debug/deps/elp-339f299f86f4ec06
Dec 15 16:01:20.267 INFO [stdout] 
Dec 15 16:01:20.267 INFO [stdout] running 31 tests
Dec 15 16:01:20.267 INFO [stdout] test parse_record_tests::returns_a_malformed_record_error_for_records_short_on_values ... ok
Dec 15 16:01:20.267 INFO [stdout] test parse_record_tests::returns_a_parsing_error_referencing_the_client_address_when_the_client_address_is_malformed ... ok
Dec 15 16:01:20.267 INFO [stdout] test parse_record_tests::returns_a_parsing_error_when_the_backend_status_code_is_malformed ... ok
Dec 15 16:01:20.267 INFO [stdout] test parse_record_tests::returns_a_parsing_error_when_the_backend_processing_time_is_malformed ... ok
Dec 15 16:01:20.267 INFO [stdout] test parse_record_tests::returns_a_parsing_error_referencing_the_received_bytes_when_the_received_bytes_is_malformed ... ok
Dec 15 16:01:20.267 INFO [stdout] test parse_record_tests::returns_a_parsing_error_when_the_backend_address_is_malformed ... ok
Dec 15 16:01:20.267 INFO [stdout] test parse_record_tests::returns_a_parsing_error_when_the_response_processing_time_is_malformed ... ok
Dec 15 16:01:20.267 INFO [stdout] test parse_record_tests::returns_a_record_with_the_backend_address ... ok
Dec 15 16:01:20.267 INFO [stdout] test parse_record_tests::returns_a_record_with_the_backend_processing_time ... ok
Dec 15 16:01:20.267 INFO [stdout] test parse_record_tests::returns_a_record_with_the_backend_status_code ... ok
Dec 15 16:01:20.267 INFO [stdout] test parse_record_tests::returns_a_record_with_the_client_address ... ok
Dec 15 16:01:20.267 INFO [stdout] test parse_record_tests::returns_a_record_with_the_elb_name ... ok
Dec 15 16:01:20.267 INFO [stdout] test parse_record_tests::returns_a_record_with_the_elb_status_code ... ok
Dec 15 16:01:20.267 INFO [stdout] test parse_record_tests::returns_a_record_with_the_received_bytes ... ok
Dec 15 16:01:20.267 INFO [stdout] test parse_record_tests::returns_a_record_with_the_request_http_version ... ok
Dec 15 16:01:20.267 INFO [stdout] test parse_record_tests::returns_a_record_with_the_request_method ... ok
Dec 15 16:01:20.267 INFO [stdout] test parse_record_tests::returns_a_record_with_the_request_processing_time ... ok
Dec 15 16:01:20.267 INFO [stdout] test parse_record_tests::returns_a_record_with_the_request_url ... ok
Dec 15 16:01:20.267 INFO [stdout] test parse_record_tests::returns_a_record_with_the_response_processing_time ... ok
Dec 15 16:01:20.267 INFO [stdout] test parse_record_tests::returns_a_record_with_the_sent_bytes ... ok
Dec 15 16:01:20.267 INFO [stdout] test parse_record_tests::returns_a_record_with_the_ssl_cipher_set_to_a_not_available_symbol_when_it_is_not_present ... ok
Dec 15 16:01:20.267 INFO [stdout] test parse_record_tests::returns_a_record_with_the_ssl_cipher_when_it_is_present ... ok
Dec 15 16:01:20.267 INFO [stdout] test parse_record_tests::returns_a_record_with_the_ssl_protocol_set_to_a_not_available_symbol_when_it_is_not_present ... ok
Dec 15 16:01:20.267 INFO [stdout] test parse_record_tests::returns_a_record_with_the_ssl_protocol_when_it_is_present ... ok
Dec 15 16:01:20.267 INFO [stdout] test parse_record_tests::returns_a_record_with_the_timestamp ... ok
Dec 15 16:01:20.267 INFO [stdout] test parse_record_tests::returns_a_record_with_the_user_agent_set_to_a_not_available_symbol_when_it_is_not_present ... ok
Dec 15 16:01:20.267 INFO [stdout] test parse_record_tests::returns_a_record_with_the_user_agent_when_it_is_present ... ok
Dec 15 16:01:20.279 INFO [stdout] test parse_record_tests::returns_a_parsing_error_when_the_elb_status_code_is_malformed ... ok
Dec 15 16:01:20.279 INFO [stdout] test parse_record_tests::returns_a_parsing_error_when_the_request_processing_time_is_malformed ... ok
Dec 15 16:01:20.279 INFO [stdout] test parse_record_tests::returns_a_parsing_error_referencing_the_sent_bytes_when_the_sent_bytes_is_malformed ... ok
Dec 15 16:01:20.279 INFO [stdout] test parse_record_tests::returns_a_parsing_error_referencing_the_timestamp_when_the_timestamp_is_malformed ... ok
Dec 15 16:01:20.279 INFO [stdout] 
Dec 15 16:01:20.279 INFO [stdout] test result: ok. 31 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 16:01:20.279 INFO [stdout] 
Dec 15 16:01:20.279 INFO [stderr]    Doc-tests elp
Dec 15 16:01:22.570 INFO [stdout] 
Dec 15 16:01:22.570 INFO [stdout] running 0 tests
Dec 15 16:01:22.570 INFO [stdout] 
Dec 15 16:01:22.570 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 16:01:22.570 INFO [stdout] 
Dec 15 16:01:22.579 INFO [stderr] su: No module specific data is present
Dec 15 16:01:23.247 INFO running `"docker" "inspect" "8156a080e398341fe922ed93d82032afdfaee589ba6877089ad598b4d25cbd9c"`
Dec 15 16:01:23.543 INFO running `"docker" "rm" "-f" "8156a080e398341fe922ed93d82032afdfaee589ba6877089ad598b4d25cbd9c"`
Dec 15 16:01:23.843 INFO [stdout] 8156a080e398341fe922ed93d82032afdfaee589ba6877089ad598b4d25cbd9c