Dec 07 09:27:38.116 INFO testing jsonwebtoken-5.0.1 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 07 09:27:38.116 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 07 09:27:38.469 INFO [stdout] b3e1f83f537c0de9bd57d2d74dd11ec5f2cdb39a0643a99e743104ca042b7cd4
Dec 07 09:27:38.478 INFO running `"docker" "start" "-a" "b3e1f83f537c0de9bd57d2d74dd11ec5f2cdb39a0643a99e743104ca042b7cd4"`
Dec 07 09:27:39.634 INFO [stderr] usermod: no changes
Dec 07 09:27:39.784 INFO [stderr]    Compiling jsonwebtoken v5.0.1 (/source)
Dec 07 09:27:42.752 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.09s
Dec 07 09:27:42.758 INFO [stderr] su: No module specific data is present
Dec 07 09:27:43.487 INFO running `"docker" "inspect" "b3e1f83f537c0de9bd57d2d74dd11ec5f2cdb39a0643a99e743104ca042b7cd4"`
Dec 07 09:27:43.703 INFO running `"docker" "rm" "-f" "b3e1f83f537c0de9bd57d2d74dd11ec5f2cdb39a0643a99e743104ca042b7cd4"`
Dec 07 09:27:44.024 INFO [stdout] b3e1f83f537c0de9bd57d2d74dd11ec5f2cdb39a0643a99e743104ca042b7cd4
Dec 07 09:27:44.091 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 07 09:27:44.548 INFO [stdout] d6968236227dc5e6bf500fa400403d5b7899635b650650c74e7be7e42c9fa421
Dec 07 09:27:44.550 INFO running `"docker" "start" "-a" "d6968236227dc5e6bf500fa400403d5b7899635b650650c74e7be7e42c9fa421"`
Dec 07 09:27:45.536 INFO [stderr] usermod: no changes
Dec 07 09:27:45.664 INFO [stderr]    Compiling jsonwebtoken v5.0.1 (/source)
Dec 07 09:27:52.445 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.89s
Dec 07 09:27:52.452 INFO [stderr] su: No module specific data is present
Dec 07 09:27:53.122 INFO running `"docker" "inspect" "d6968236227dc5e6bf500fa400403d5b7899635b650650c74e7be7e42c9fa421"`
Dec 07 09:27:53.364 INFO running `"docker" "rm" "-f" "d6968236227dc5e6bf500fa400403d5b7899635b650650c74e7be7e42c9fa421"`
Dec 07 09:27:53.626 INFO [stdout] d6968236227dc5e6bf500fa400403d5b7899635b650650c74e7be7e42c9fa421
Dec 07 09:27:53.630 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 07 09:27:54.039 INFO [stdout] 269e71acf10c0f2cb558bc08fe14e54226d1095bae6f999617f157a1e17f702b
Dec 07 09:27:54.041 INFO running `"docker" "start" "-a" "269e71acf10c0f2cb558bc08fe14e54226d1095bae6f999617f157a1e17f702b"`
Dec 07 09:27:55.026 INFO [stderr] usermod: no changes
Dec 07 09:27:55.101 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.05s
Dec 07 09:27:55.107 INFO [stderr]      Running /target/debug/deps/jsonwebtoken-96e5c67418e4140d
Dec 07 09:27:55.110 INFO [stdout] 
Dec 07 09:27:55.110 INFO [stdout] running 21 tests
Dec 07 09:27:55.111 INFO [stdout] test validation::tests::aud_array_of_string_ok ... ok
Dec 07 09:27:55.111 INFO [stdout] test validation::tests::aud_correct_type_not_matching_fails ... ok
Dec 07 09:27:55.111 INFO [stdout] test validation::tests::aud_missing_fails ... ok
Dec 07 09:27:55.111 INFO [stdout] test validation::tests::aud_string_ok ... ok
Dec 07 09:27:55.111 INFO [stdout] test validation::tests::exp_in_future_ok ... ok
Dec 07 09:27:55.111 INFO [stdout] test validation::tests::exp_in_past_but_in_leeway_ok ... ok
Dec 07 09:27:55.111 INFO [stdout] test validation::tests::exp_in_past_fails ... ok
Dec 07 09:27:55.112 INFO [stdout] test validation::tests::aud_type_mismatch_fails ... ok
Dec 07 09:27:55.112 INFO [stdout] test validation::tests::iat_in_future_fails ... ok
Dec 07 09:27:55.112 INFO [stdout] test validation::tests::iat_in_future_but_in_leeway_ok ... ok
Dec 07 09:27:55.112 INFO [stdout] test validation::tests::iat_in_past_ok ... ok
Dec 07 09:27:55.112 INFO [stdout] test validation::tests::iss_missing_fails ... ok
Dec 07 09:27:55.112 INFO [stdout] test validation::tests::iss_not_matching_fails ... ok
Dec 07 09:27:55.112 INFO [stdout] test validation::tests::iss_ok ... ok
Dec 07 09:27:55.112 INFO [stdout] test validation::tests::nbf_in_past_ok ... ok
Dec 07 09:27:55.112 INFO [stdout] test validation::tests::sub_missing_fails ... ok
Dec 07 09:27:55.112 INFO [stdout] test validation::tests::sub_not_matching_fails ... ok
Dec 07 09:27:55.112 INFO [stdout] test validation::tests::validation_called_even_if_field_is_empty ... ok
Dec 07 09:27:55.116 INFO [stdout] test validation::tests::nbf_in_future_fails ... ok
Dec 07 09:27:55.117 INFO [stdout] test validation::tests::sub_ok ... ok
Dec 07 09:27:55.117 INFO [stdout] test validation::tests::nbf_in_future_but_in_leeway_ok ... ok
Dec 07 09:27:55.117 INFO [stdout] 
Dec 07 09:27:55.117 INFO [stdout] test result: ok. 21 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 09:27:55.117 INFO [stdout] 
Dec 07 09:27:55.125 INFO [stderr]      Running /target/debug/deps/lib-a8bcb9c8193fa14d
Dec 07 09:27:55.126 INFO [stdout] 
Dec 07 09:27:55.127 INFO [stdout] running 16 tests
Dec 07 09:27:55.127 INFO [stdout] test dangerous_unsafe_decode_token_wrong_algorithm ... ok
Dec 07 09:27:55.127 INFO [stdout] test dangerous_unsafe_decode_token_invalid_signature ... ok
Dec 07 09:27:55.127 INFO [stdout] test dangerous_unsafe_decode_token ... ok
Dec 07 09:27:55.128 INFO [stdout] test decode_header_only ... ok
Dec 07 09:27:55.128 INFO [stdout] test decode_token ... ok
Dec 07 09:27:55.128 INFO [stdout] test decode_token_with_bytes_secret ... ok
Dec 07 09:27:55.128 INFO [stdout] test generate_algorithm_enum_from_str ... ok
Dec 07 09:27:55.129 INFO [stdout] test encode_with_custom_header ... ok
Dec 07 09:27:55.129 INFO [stdout] test sign_hs256 ... ok
Dec 07 09:27:55.129 INFO [stdout] test does_validation_in_right_order ... ok
Dec 07 09:27:55.129 INFO [stdout] test round_trip_claim ... ok
Dec 07 09:27:55.132 INFO [stdout] test verify_hs256 ... ok
Dec 07 09:27:55.180 INFO [stdout] test decode_token_invalid_signature ... ok
Dec 07 09:27:55.180 INFO [stdout] test decode_token_missing_parts ... ok
Dec 07 09:27:55.182 INFO [stdout] test decode_token_wrong_algorithm ... ok
Dec 07 09:27:55.182 INFO [stdout] test dangerous_unsafe_decode_token_missing_parts ... ok
Dec 07 09:27:55.182 INFO [stdout] 
Dec 07 09:27:55.182 INFO [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 09:27:55.182 INFO [stdout] 
Dec 07 09:27:55.183 INFO [stderr]      Running /target/debug/deps/rsa-204769075b36568d
Dec 07 09:27:55.185 INFO [stdout] 
Dec 07 09:27:55.185 INFO [stdout] running 2 tests
Dec 07 09:27:55.187 INFO [stdout] test round_trip_sign_verification ... ok
Dec 07 09:27:55.187 INFO [stdout] test round_trip_claim ... ok
Dec 07 09:27:55.187 INFO [stdout] 
Dec 07 09:27:55.187 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 09:27:55.187 INFO [stdout] 
Dec 07 09:27:55.188 INFO [stderr]    Doc-tests jsonwebtoken
Dec 07 09:27:57.327 INFO [stdout] 
Dec 07 09:27:57.327 INFO [stdout] running 5 tests
Dec 07 09:27:57.327 INFO [stdout] test src/lib.rs - dangerous_unsafe_decode (line 126) ... ignored
Dec 07 09:27:57.327 INFO [stdout] test src/lib.rs - decode (line 88) ... ignored
Dec 07 09:27:57.327 INFO [stdout] test src/lib.rs - decode_header (line 156) ... ignored
Dec 07 09:27:57.327 INFO [stdout] test src/lib.rs - encode (line 43) ... ignored
Dec 07 09:28:01.316 INFO [stdout] test src/validation.rs - validation::Validation (line 14) ... ok
Dec 07 09:28:01.316 INFO [stdout] 
Dec 07 09:28:01.316 INFO [stdout] test result: ok. 1 passed; 0 failed; 4 ignored; 0 measured; 0 filtered out
Dec 07 09:28:01.316 INFO [stdout] 
Dec 07 09:28:01.332 INFO [stderr] su: No module specific data is present
Dec 07 09:28:01.865 INFO running `"docker" "inspect" "269e71acf10c0f2cb558bc08fe14e54226d1095bae6f999617f157a1e17f702b"`
Dec 07 09:28:02.184 INFO running `"docker" "rm" "-f" "269e71acf10c0f2cb558bc08fe14e54226d1095bae6f999617f157a1e17f702b"`
Dec 07 09:28:02.528 INFO [stdout] 269e71acf10c0f2cb558bc08fe14e54226d1095bae6f999617f157a1e17f702b