Dec 15 07:04:30.257 INFO testing jsonwebtoken-5.0.1 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 15 07:04:30.257 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 07:04:30.655 INFO [stdout] 1c2906891e4b9dfaf6de0b183526516000da3de1a9b9679f3a56f6d6c5064d7b
Dec 15 07:04:30.657 INFO running `"docker" "start" "-a" "1c2906891e4b9dfaf6de0b183526516000da3de1a9b9679f3a56f6d6c5064d7b"`
Dec 15 07:04:31.747 INFO [stderr] usermod: no changes
Dec 15 07:04:31.907 INFO [stderr]    Compiling jsonwebtoken v5.0.1 (/source)
Dec 15 07:04:34.399 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.62s
Dec 15 07:04:34.402 INFO [stderr] su: No module specific data is present
Dec 15 07:04:34.763 INFO running `"docker" "inspect" "1c2906891e4b9dfaf6de0b183526516000da3de1a9b9679f3a56f6d6c5064d7b"`
Dec 15 07:04:34.887 INFO running `"docker" "rm" "-f" "1c2906891e4b9dfaf6de0b183526516000da3de1a9b9679f3a56f6d6c5064d7b"`
Dec 15 07:04:34.996 INFO [stdout] 1c2906891e4b9dfaf6de0b183526516000da3de1a9b9679f3a56f6d6c5064d7b
Dec 15 07:04:35.001 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 07:04:35.257 INFO [stdout] 4a1cf0869ccca17a0946e399f36345c0d07a74f8a5642853856e462d35382560
Dec 15 07:04:35.260 INFO running `"docker" "start" "-a" "4a1cf0869ccca17a0946e399f36345c0d07a74f8a5642853856e462d35382560"`
Dec 15 07:04:36.283 INFO [stderr] usermod: no changes
Dec 15 07:04:36.399 INFO [stderr]    Compiling jsonwebtoken v5.0.1 (/source)
Dec 15 07:04:47.407 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 11.09s
Dec 15 07:04:47.407 INFO [stderr] su: No module specific data is present
Dec 15 07:04:48.036 INFO running `"docker" "inspect" "4a1cf0869ccca17a0946e399f36345c0d07a74f8a5642853856e462d35382560"`
Dec 15 07:04:48.332 INFO running `"docker" "rm" "-f" "4a1cf0869ccca17a0946e399f36345c0d07a74f8a5642853856e462d35382560"`
Dec 15 07:04:48.626 INFO [stdout] 4a1cf0869ccca17a0946e399f36345c0d07a74f8a5642853856e462d35382560
Dec 15 07:04:48.629 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 07:04:49.180 INFO [stdout] f2eb7d5795e2acd9adfc31edf821d111b3fd5004357e2092b9f69c7b1710f3ed
Dec 15 07:04:49.183 INFO running `"docker" "start" "-a" "f2eb7d5795e2acd9adfc31edf821d111b3fd5004357e2092b9f69c7b1710f3ed"`
Dec 15 07:04:50.970 INFO [stderr] usermod: no changes
Dec 15 07:04:51.115 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.11s
Dec 15 07:04:51.115 INFO [stderr]      Running /target/debug/deps/jsonwebtoken-f4b2527dcb062d3a
Dec 15 07:04:51.119 INFO [stdout] 
Dec 15 07:04:51.119 INFO [stdout] running 21 tests
Dec 15 07:04:51.119 INFO [stdout] test validation::tests::aud_missing_fails ... ok
Dec 15 07:04:51.119 INFO [stdout] test validation::tests::exp_in_past_fails ... ok
Dec 15 07:04:51.119 INFO [stdout] test validation::tests::aud_string_ok ... ok
Dec 15 07:04:51.119 INFO [stdout] test validation::tests::aud_type_mismatch_fails ... ok
Dec 15 07:04:51.119 INFO [stdout] test validation::tests::exp_in_future_ok ... ok
Dec 15 07:04:51.119 INFO [stdout] test validation::tests::exp_in_past_but_in_leeway_ok ... ok
Dec 15 07:04:51.119 INFO [stdout] test validation::tests::aud_array_of_string_ok ... ok
Dec 15 07:04:51.119 INFO [stdout] test validation::tests::iat_in_future_but_in_leeway_ok ... ok
Dec 15 07:04:51.119 INFO [stdout] test validation::tests::iat_in_future_fails ... ok
Dec 15 07:04:51.119 INFO [stdout] test validation::tests::iat_in_past_ok ... ok
Dec 15 07:04:51.119 INFO [stdout] test validation::tests::iss_missing_fails ... ok
Dec 15 07:04:51.119 INFO [stdout] test validation::tests::iss_not_matching_fails ... ok
Dec 15 07:04:51.119 INFO [stdout] test validation::tests::iss_ok ... ok
Dec 15 07:04:51.119 INFO [stdout] test validation::tests::nbf_in_future_but_in_leeway_ok ... ok
Dec 15 07:04:51.119 INFO [stdout] test validation::tests::nbf_in_future_fails ... ok
Dec 15 07:04:51.119 INFO [stdout] test validation::tests::nbf_in_past_ok ... ok
Dec 15 07:04:51.119 INFO [stdout] test validation::tests::sub_missing_fails ... ok
Dec 15 07:04:51.119 INFO [stdout] test validation::tests::sub_not_matching_fails ... ok
Dec 15 07:04:51.119 INFO [stdout] test validation::tests::sub_ok ... ok
Dec 15 07:04:51.119 INFO [stdout] test validation::tests::validation_called_even_if_field_is_empty ... ok
Dec 15 07:04:51.130 INFO [stdout] test validation::tests::aud_correct_type_not_matching_fails ... ok
Dec 15 07:04:51.130 INFO [stdout] 
Dec 15 07:04:51.130 INFO [stdout] test result: ok. 21 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 07:04:51.130 INFO [stdout] 
Dec 15 07:04:51.135 INFO [stdout] 
Dec 15 07:04:51.135 INFO [stderr]      Running /target/debug/deps/lib-95cbe369b1c87c09
Dec 15 07:04:51.135 INFO [stdout] running 16 tests
Dec 15 07:04:51.135 INFO [stdout] test dangerous_unsafe_decode_token_wrong_algorithm ... ok
Dec 15 07:04:51.135 INFO [stdout] test decode_header_only ... ok
Dec 15 07:04:51.135 INFO [stdout] test decode_token ... ok
Dec 15 07:04:51.135 INFO [stdout] test dangerous_unsafe_decode_token_invalid_signature ... ok
Dec 15 07:04:51.135 INFO [stdout] test dangerous_unsafe_decode_token ... ok
Dec 15 07:04:51.135 INFO [stdout] test does_validation_in_right_order ... ok
Dec 15 07:04:51.135 INFO [stdout] test generate_algorithm_enum_from_str ... ok
Dec 15 07:04:51.135 INFO [stdout] test decode_token_with_bytes_secret ... ok
Dec 15 07:04:51.143 INFO [stdout] test encode_with_custom_header ... ok
Dec 15 07:04:51.143 INFO [stdout] test round_trip_claim ... ok
Dec 15 07:04:51.143 INFO [stdout] test sign_hs256 ... ok
Dec 15 07:04:51.143 INFO [stdout] test verify_hs256 ... ok
Dec 15 07:04:51.291 INFO [stdout] test decode_token_missing_parts ... ok
Dec 15 07:04:51.291 INFO [stdout] test decode_token_invalid_signature ... ok
Dec 15 07:04:51.291 INFO [stdout] test decode_token_wrong_algorithm ... ok
Dec 15 07:04:51.291 INFO [stdout] test dangerous_unsafe_decode_token_missing_parts ... ok
Dec 15 07:04:51.291 INFO [stdout] 
Dec 15 07:04:51.291 INFO [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 07:04:51.291 INFO [stdout] 
Dec 15 07:04:51.291 INFO [stdout] 
Dec 15 07:04:51.291 INFO [stdout] running 2 tests
Dec 15 07:04:51.291 INFO [stdout] test round_trip_sign_verification ... ok
Dec 15 07:04:51.291 INFO [stderr]      Running /target/debug/deps/rsa-0cc6f42cb531e841
Dec 15 07:04:51.299 INFO [stdout] test round_trip_claim ... ok
Dec 15 07:04:51.299 INFO [stderr]    Doc-tests jsonwebtoken
Dec 15 07:04:51.299 INFO [stdout] 
Dec 15 07:04:51.299 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 07:04:51.299 INFO [stdout] 
Dec 15 07:04:54.047 INFO [stdout] 
Dec 15 07:04:54.047 INFO [stdout] running 5 tests
Dec 15 07:04:54.047 INFO [stdout] test src/lib.rs - dangerous_unsafe_decode (line 126) ... ignored
Dec 15 07:04:54.047 INFO [stdout] test src/lib.rs - decode (line 88) ... ignored
Dec 15 07:04:54.047 INFO [stdout] test src/lib.rs - decode_header (line 156) ... ignored
Dec 15 07:04:54.047 INFO [stdout] test src/lib.rs - encode (line 43) ... ignored
Dec 15 07:04:58.322 INFO [stdout] test src/validation.rs - validation::Validation (line 14) ... ok
Dec 15 07:04:58.322 INFO [stdout] 
Dec 15 07:04:58.322 INFO [stdout] test result: ok. 1 passed; 0 failed; 4 ignored; 0 measured; 0 filtered out
Dec 15 07:04:58.322 INFO [stdout] 
Dec 15 07:04:58.336 INFO [stderr] su: No module specific data is present
Dec 15 07:04:58.825 INFO running `"docker" "inspect" "f2eb7d5795e2acd9adfc31edf821d111b3fd5004357e2092b9f69c7b1710f3ed"`
Dec 15 07:04:59.011 INFO running `"docker" "rm" "-f" "f2eb7d5795e2acd9adfc31edf821d111b3fd5004357e2092b9f69c7b1710f3ed"`
Dec 15 07:04:59.158 INFO [stdout] f2eb7d5795e2acd9adfc31edf821d111b3fd5004357e2092b9f69c7b1710f3ed