Nov 18 08:12:04.879 INFO testing jsonwebtoken-5.0.1 against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 18 08:12:04.881 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 18 08:12:05.391 INFO [stdout] c7c433cdbb624d45c1493841cdfa8cbd3dda348091eb7904a6e2283dd0962574
Nov 18 08:12:05.397 INFO running `"docker" "start" "-a" "c7c433cdbb624d45c1493841cdfa8cbd3dda348091eb7904a6e2283dd0962574"`
Nov 18 08:12:06.186 INFO [stderr] usermod: no changes
Nov 18 08:12:06.297 INFO [stderr]    Compiling jsonwebtoken v5.0.1 (/source)
Nov 18 08:12:08.878 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.66s
Nov 18 08:12:08.884 INFO [stderr] su: No module specific data is present
Nov 18 08:12:09.717 INFO running `"docker" "inspect" "c7c433cdbb624d45c1493841cdfa8cbd3dda348091eb7904a6e2283dd0962574"`
Nov 18 08:12:10.009 INFO running `"docker" "rm" "-f" "c7c433cdbb624d45c1493841cdfa8cbd3dda348091eb7904a6e2283dd0962574"`
Nov 18 08:12:10.327 INFO [stdout] c7c433cdbb624d45c1493841cdfa8cbd3dda348091eb7904a6e2283dd0962574
Nov 18 08:12:10.335 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 18 08:12:10.853 INFO [stdout] d042080cfcad820c32ccc6c569d3133b735deb5500ecd3628d5e345b41473ee1
Nov 18 08:12:10.853 INFO running `"docker" "start" "-a" "d042080cfcad820c32ccc6c569d3133b735deb5500ecd3628d5e345b41473ee1"`
Nov 18 08:12:11.786 INFO [stderr] usermod: no changes
Nov 18 08:12:11.869 INFO [stderr]    Compiling jsonwebtoken v5.0.1 (/source)
Nov 18 08:12:19.854 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 8.04s
Nov 18 08:12:19.869 INFO [stderr] su: No module specific data is present
Nov 18 08:12:20.347 INFO running `"docker" "inspect" "d042080cfcad820c32ccc6c569d3133b735deb5500ecd3628d5e345b41473ee1"`
Nov 18 08:12:20.574 INFO running `"docker" "rm" "-f" "d042080cfcad820c32ccc6c569d3133b735deb5500ecd3628d5e345b41473ee1"`
Nov 18 08:12:20.717 INFO [stdout] d042080cfcad820c32ccc6c569d3133b735deb5500ecd3628d5e345b41473ee1
Nov 18 08:12:20.719 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 18 08:12:21.054 INFO [stdout] 90db528e558565219f4f0a47a956a5e2bb0858b2c36e8aec94dfebf086060a2e
Nov 18 08:12:21.057 INFO running `"docker" "start" "-a" "90db528e558565219f4f0a47a956a5e2bb0858b2c36e8aec94dfebf086060a2e"`
Nov 18 08:12:21.746 INFO [stderr] usermod: no changes
Nov 18 08:12:21.831 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.06s
Nov 18 08:12:21.844 INFO [stderr]      Running /target/debug/deps/jsonwebtoken-263aeaeaa8c38988
Nov 18 08:12:21.859 INFO [stdout] 
Nov 18 08:12:21.859 INFO [stdout] running 21 tests
Nov 18 08:12:21.863 INFO [stdout] test validation::tests::aud_type_mismatch_fails ... ok
Nov 18 08:12:21.864 INFO [stdout] test validation::tests::aud_missing_fails ... ok
Nov 18 08:12:21.864 INFO [stdout] test validation::tests::aud_correct_type_not_matching_fails ... ok
Nov 18 08:12:21.864 INFO [stdout] test validation::tests::aud_string_ok ... ok
Nov 18 08:12:21.864 INFO [stdout] test validation::tests::exp_in_future_ok ... ok
Nov 18 08:12:21.864 INFO [stdout] test validation::tests::aud_array_of_string_ok ... ok
Nov 18 08:12:21.864 INFO [stdout] test validation::tests::exp_in_past_but_in_leeway_ok ... ok
Nov 18 08:12:21.864 INFO [stdout] test validation::tests::exp_in_past_fails ... ok
Nov 18 08:12:21.879 INFO [stdout] test validation::tests::iat_in_future_fails ... ok
Nov 18 08:12:21.879 INFO [stdout] test validation::tests::iat_in_past_ok ... ok
Nov 18 08:12:21.879 INFO [stdout] test validation::tests::nbf_in_future_but_in_leeway_ok ... ok
Nov 18 08:12:21.879 INFO [stdout] test validation::tests::nbf_in_future_fails ... ok
Nov 18 08:12:21.879 INFO [stdout] test validation::tests::iss_missing_fails ... ok
Nov 18 08:12:21.879 INFO [stdout] test validation::tests::iss_not_matching_fails ... ok
Nov 18 08:12:21.879 INFO [stdout] test validation::tests::iss_ok ... ok
Nov 18 08:12:21.879 INFO [stdout] test validation::tests::iat_in_future_but_in_leeway_ok ... ok
Nov 18 08:12:21.879 INFO [stdout] test validation::tests::sub_missing_fails ... ok
Nov 18 08:12:21.879 INFO [stdout] test validation::tests::validation_called_even_if_field_is_empty ... ok
Nov 18 08:12:21.891 INFO [stdout] test validation::tests::sub_not_matching_fails ... ok
Nov 18 08:12:21.891 INFO [stdout] test validation::tests::nbf_in_past_ok ... ok
Nov 18 08:12:21.891 INFO [stdout] test validation::tests::sub_ok ... ok
Nov 18 08:12:21.891 INFO [stdout] 
Nov 18 08:12:21.891 INFO [stdout] test result: ok. 21 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 08:12:21.891 INFO [stdout] 
Nov 18 08:12:21.891 INFO [stdout] 
Nov 18 08:12:21.891 INFO [stdout] running 16 tests
Nov 18 08:12:21.891 INFO [stdout] test dangerous_unsafe_decode_token ... ok
Nov 18 08:12:21.891 INFO [stderr]      Running /target/debug/deps/lib-958ab6d71a35b0cf
Nov 18 08:12:21.899 INFO [stdout] test decode_token ... ok
Nov 18 08:12:21.899 INFO [stdout] test dangerous_unsafe_decode_token_wrong_algorithm ... ok
Nov 18 08:12:21.899 INFO [stdout] test decode_token_with_bytes_secret ... ok
Nov 18 08:12:21.899 INFO [stdout] test dangerous_unsafe_decode_token_invalid_signature ... ok
Nov 18 08:12:21.899 INFO [stdout] test decode_header_only ... ok
Nov 18 08:12:21.900 INFO [stdout] test does_validation_in_right_order ... ok
Nov 18 08:12:21.900 INFO [stdout] test generate_algorithm_enum_from_str ... ok
Nov 18 08:12:21.900 INFO [stdout] test round_trip_claim ... ok
Nov 18 08:12:21.900 INFO [stdout] test encode_with_custom_header ... ok
Nov 18 08:12:21.900 INFO [stdout] test sign_hs256 ... ok
Nov 18 08:12:21.911 INFO [stdout] test verify_hs256 ... ok
Nov 18 08:12:21.947 INFO [stdout] test dangerous_unsafe_decode_token_missing_parts ... ok
Nov 18 08:12:21.947 INFO [stdout] test decode_token_invalid_signature ... ok
Nov 18 08:12:21.947 INFO [stdout] test decode_token_wrong_algorithm ... ok
Nov 18 08:12:21.947 INFO [stdout] test decode_token_missing_parts ... ok
Nov 18 08:12:21.947 INFO [stdout] 
Nov 18 08:12:21.947 INFO [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 08:12:21.947 INFO [stdout] 
Nov 18 08:12:21.949 INFO [stderr]      Running /target/debug/deps/rsa-2fc24b524ae63a5a
Nov 18 08:12:21.951 INFO [stdout] 
Nov 18 08:12:21.951 INFO [stdout] running 2 tests
Nov 18 08:12:21.955 INFO [stdout] test round_trip_sign_verification ... ok
Nov 18 08:12:21.955 INFO [stdout] test round_trip_claim ... ok
Nov 18 08:12:21.955 INFO [stdout] 
Nov 18 08:12:21.955 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 08:12:21.955 INFO [stdout] 
Nov 18 08:12:21.959 INFO [stderr]    Doc-tests jsonwebtoken
Nov 18 08:12:23.900 INFO [stdout] 
Nov 18 08:12:23.900 INFO [stdout] running 5 tests
Nov 18 08:12:23.900 INFO [stdout] test src/lib.rs - dangerous_unsafe_decode (line 126) ... ignored
Nov 18 08:12:23.901 INFO [stdout] test src/lib.rs - decode (line 88) ... ignored
Nov 18 08:12:23.902 INFO [stdout] test src/lib.rs - decode_header (line 156) ... ignored
Nov 18 08:12:23.902 INFO [stdout] test src/lib.rs - encode (line 43) ... ignored
Nov 18 08:12:27.396 INFO [stdout] test src/validation.rs - validation::Validation (line 14) ... ok
Nov 18 08:12:27.396 INFO [stdout] 
Nov 18 08:12:27.397 INFO [stdout] test result: ok. 1 passed; 0 failed; 4 ignored; 0 measured; 0 filtered out
Nov 18 08:12:27.397 INFO [stdout] 
Nov 18 08:12:27.409 INFO [stderr] su: No module specific data is present
Nov 18 08:12:27.729 INFO running `"docker" "inspect" "90db528e558565219f4f0a47a956a5e2bb0858b2c36e8aec94dfebf086060a2e"`
Nov 18 08:12:27.949 INFO running `"docker" "rm" "-f" "90db528e558565219f4f0a47a956a5e2bb0858b2c36e8aec94dfebf086060a2e"`
Nov 18 08:12:28.179 INFO [stdout] 90db528e558565219f4f0a47a956a5e2bb0858b2c36e8aec94dfebf086060a2e