Nov 17 18:23:53.652 INFO testing web-push-0.4.0 against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 17 18:23:53.652 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-3/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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:23:53.895 INFO [stdout] d98a32e71a68437d22dcb1e648bf220b6132e38669d1c49d516989611b5571a2
Nov 17 18:23:53.903 INFO running `"docker" "start" "-a" "d98a32e71a68437d22dcb1e648bf220b6132e38669d1c49d516989611b5571a2"`
Nov 17 18:23:54.827 INFO [stderr] usermod: no changes
Nov 17 18:23:55.155 INFO [stderr]    Compiling base64 v0.7.0
Nov 17 18:23:55.193 INFO [stderr]    Compiling h2 v0.1.13
Nov 17 18:23:55.196 INFO [stderr]    Compiling tokio-tls v0.1.4
Nov 17 18:24:06.244 INFO [stderr]    Compiling hyper v0.12.14
Nov 17 18:24:17.072 INFO [stderr]    Compiling hyper-tls v0.2.1
Nov 17 18:24:20.759 INFO [stderr]    Compiling web-push v0.4.0 (/source)
Nov 17 18:24:35.073 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 40.22s
Nov 17 18:24:35.091 INFO [stderr] su: No module specific data is present
Nov 17 18:24:36.783 INFO running `"docker" "inspect" "d98a32e71a68437d22dcb1e648bf220b6132e38669d1c49d516989611b5571a2"`
Nov 17 18:24:37.106 INFO running `"docker" "rm" "-f" "d98a32e71a68437d22dcb1e648bf220b6132e38669d1c49d516989611b5571a2"`
Nov 17 18:24:37.377 INFO [stdout] d98a32e71a68437d22dcb1e648bf220b6132e38669d1c49d516989611b5571a2
Nov 17 18:24:37.379 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-3/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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:24:37.907 INFO [stdout] 9dd50a6f18508c10e982e1bcd07700da172cedd371466da4c57af20de56e86da
Nov 17 18:24:37.910 INFO running `"docker" "start" "-a" "9dd50a6f18508c10e982e1bcd07700da172cedd371466da4c57af20de56e86da"`
Nov 17 18:24:39.518 INFO [stderr] usermod: no changes
Nov 17 18:24:39.900 INFO [stderr]    Compiling web-push v0.4.0 (/source)
Nov 17 18:24:56.029 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 16.47s
Nov 17 18:24:56.056 INFO [stderr] su: No module specific data is present
Nov 17 18:24:57.079 INFO running `"docker" "inspect" "9dd50a6f18508c10e982e1bcd07700da172cedd371466da4c57af20de56e86da"`
Nov 17 18:24:57.527 INFO running `"docker" "rm" "-f" "9dd50a6f18508c10e982e1bcd07700da172cedd371466da4c57af20de56e86da"`
Nov 17 18:24:57.907 INFO [stdout] 9dd50a6f18508c10e982e1bcd07700da172cedd371466da4c57af20de56e86da
Nov 17 18:24:57.914 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-3/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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:24:58.328 INFO [stdout] 823787009e3fa0af8f2f1e10af11a56556c975bf5ebf8c6fc42383cb604a0672
Nov 17 18:24:58.330 INFO running `"docker" "start" "-a" "823787009e3fa0af8f2f1e10af11a56556c975bf5ebf8c6fc42383cb604a0672"`
Nov 17 18:24:59.601 INFO [stderr] usermod: no changes
Nov 17 18:24:59.897 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.26s
Nov 17 18:24:59.908 INFO [stderr]      Running /target/debug/deps/web_push-87f89269e21f34fd
Nov 17 18:24:59.914 INFO [stdout] 
Nov 17 18:24:59.914 INFO [stdout] running 32 tests
Nov 17 18:24:59.920 INFO [stdout] test http_ece::tests::test_aes128gcm ... ok
Nov 17 18:24:59.921 INFO [stdout] test http_ece::tests::test_front_pad ... ok
Nov 17 18:24:59.921 INFO [stdout] test http_ece::tests::test_aesgcm ... ok
Nov 17 18:24:59.921 INFO [stdout] test services::autopush::tests::parses_a_bad_request_response_with_body_correctly ... ok
Nov 17 18:24:59.922 INFO [stdout] test services::autopush::tests::parses_a_gone_response_correctly ... ok
Nov 17 18:24:59.922 INFO [stdout] test services::autopush::tests::builds_a_correct_request_with_payload ... ok
Nov 17 18:24:59.922 INFO [stdout] test services::autopush::tests::parses_a_bad_request_response_with_no_body_correctly ... ok
Nov 17 18:24:59.923 INFO [stdout] test services::autopush::tests::parses_a_server_error_response_correctly ... ok
Nov 17 18:24:59.923 INFO [stdout] test http_ece::tests::test_headers_without_vapid ... ok
Nov 17 18:24:59.923 INFO [stdout] test services::autopush::tests::parses_a_successful_response_correctly ... ok
Nov 17 18:24:59.924 INFO [stdout] test http_ece::tests::test_payload_too_big ... ok
Nov 17 18:24:59.924 INFO [stdout] test services::autopush::tests::parses_a_not_found_response_correctly ... ok
Nov 17 18:24:59.927 INFO [stdout] test services::autopush::tests::parses_a_payload_too_large_response_correctly ... ok
Nov 17 18:24:59.927 INFO [stdout] test services::autopush::tests::builds_a_correct_request_with_empty_payload ... ok
Nov 17 18:24:59.928 INFO [stdout] test services::autopush::tests::parses_an_unauthorized_response_correctly ... ok
Nov 17 18:24:59.928 INFO [stdout] test http_ece::tests::test_headers_with_vapid ... ok
Nov 17 18:24:59.943 INFO [stdout] test services::firebase::tests::builds_a_correct_request_with_empty_payload ... ok
Nov 17 18:24:59.959 INFO [stdout] test services::firebase::tests::parses_a_invalid_registration_response_correctly ... ok
Nov 17 18:24:59.975 INFO [stdout] test services::firebase::tests::parses_a_not_registered_response_correctly ... ok
Nov 17 18:24:59.975 INFO [stdout] test services::firebase::tests::parses_a_successful_response_correctly ... ok
Nov 17 18:24:59.975 INFO [stdout] test services::firebase::tests::parses_a_missing_registration_response_correctly ... ok
Nov 17 18:24:59.975 INFO [stdout] test services::firebase::tests::builds_a_correct_request_with_a_payload ... ok
Nov 17 18:24:59.975 INFO [stdout] test services::firebase::tests::parses_a_message_too_big_response_correctly ... ok
Nov 17 18:24:59.975 INFO [stdout] test services::firebase::tests::parses_an_internal_server_error_response_correctly ... ok
Nov 17 18:24:59.975 INFO [stdout] test services::firebase::tests::parses_an_invalid_data_key_response_correctly ... ok
Nov 17 18:24:59.975 INFO [stdout] test vapid::signer::tests::test_vapid_signature_aesgcm_format ... ok
Nov 17 18:24:59.975 INFO [stdout] test services::firebase::tests::parses_an_invalid_package_name_response_correctly ... ok
Nov 17 18:24:59.975 INFO [stdout] test services::firebase::tests::parses_an_invalid_ttl_response_correctly ... ok
Nov 17 18:24:59.975 INFO [stdout] test services::firebase::tests::parses_an_unavailable_response_correctly ... ok
Nov 17 18:24:59.986 INFO [stdout] test vapid::key::tests::test_public_key_derivation ... ok
Nov 17 18:25:00.023 INFO [stdout] test vapid::builder::tests::test_builder_from_der ... ok
Nov 17 18:25:00.023 INFO [stdout] test vapid::builder::tests::test_builder_from_pem ... ok
Nov 17 18:25:00.023 INFO [stdout] 
Nov 17 18:25:00.023 INFO [stdout] test result: ok. 32 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 18:25:00.023 INFO [stdout] 
Nov 17 18:25:00.035 INFO [stderr]    Doc-tests web-push
Nov 17 18:25:07.280 INFO [stdout] 
Nov 17 18:25:07.281 INFO [stdout] running 2 tests
Nov 17 18:25:17.952 INFO [stdout] test src/vapid/builder.rs - vapid::builder::VapidSignatureBuilder (line 46) ... ok
Nov 17 18:25:18.671 INFO [stdout] test src/lib.rs -  (line 9) ... ok
Nov 17 18:25:18.671 INFO [stdout] 
Nov 17 18:25:18.671 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 18:25:18.671 INFO [stdout] 
Nov 17 18:25:18.688 INFO [stderr] su: No module specific data is present
Nov 17 18:25:19.268 INFO running `"docker" "inspect" "823787009e3fa0af8f2f1e10af11a56556c975bf5ebf8c6fc42383cb604a0672"`
Nov 17 18:25:19.479 INFO running `"docker" "rm" "-f" "823787009e3fa0af8f2f1e10af11a56556c975bf5ebf8c6fc42383cb604a0672"`
Nov 17 18:25:19.701 INFO [stdout] 823787009e3fa0af8f2f1e10af11a56556c975bf5ebf8c6fc42383cb604a0672