Dec 07 12:51:00.084 INFO testing google-jwt-verify-0.1.0 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514 Dec 07 12:51:00.085 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-4/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 12:51:00.548 INFO [stdout] ac378ecb24809390662d41c647979bdc888abebb407c186997395d43020c8d25 Dec 07 12:51:00.552 INFO running `"docker" "start" "-a" "ac378ecb24809390662d41c647979bdc888abebb407c186997395d43020c8d25"` Dec 07 12:51:02.200 INFO [stderr] usermod: no changes Dec 07 12:51:02.631 INFO [stderr] Compiling google-jwt-verify v0.1.0 (/source) Dec 07 12:51:13.779 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 11.55s Dec 07 12:51:13.792 INFO [stderr] su: No module specific data is present Dec 07 12:51:14.718 INFO running `"docker" "inspect" "ac378ecb24809390662d41c647979bdc888abebb407c186997395d43020c8d25"` Dec 07 12:51:15.085 INFO running `"docker" "rm" "-f" "ac378ecb24809390662d41c647979bdc888abebb407c186997395d43020c8d25"` Dec 07 12:51:15.303 INFO [stdout] ac378ecb24809390662d41c647979bdc888abebb407c186997395d43020c8d25 Dec 07 12:51:15.308 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-4/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 12:51:15.641 INFO [stdout] da0037fd41d58263fcda83152357697f2606a02dded514c237d25873acb158ae Dec 07 12:51:15.648 INFO running `"docker" "start" "-a" "da0037fd41d58263fcda83152357697f2606a02dded514c237d25873acb158ae"` Dec 07 12:51:16.743 INFO [stderr] usermod: no changes Dec 07 12:51:17.020 INFO [stderr] Compiling google-jwt-verify v0.1.0 (/source) Dec 07 12:51:30.952 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 14.18s Dec 07 12:51:30.972 INFO [stderr] su: No module specific data is present Dec 07 12:51:32.070 INFO running `"docker" "inspect" "da0037fd41d58263fcda83152357697f2606a02dded514c237d25873acb158ae"` Dec 07 12:51:32.456 INFO running `"docker" "rm" "-f" "da0037fd41d58263fcda83152357697f2606a02dded514c237d25873acb158ae"` Dec 07 12:51:32.728 INFO [stdout] da0037fd41d58263fcda83152357697f2606a02dded514c237d25873acb158ae Dec 07 12:51:32.732 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-4/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 12:51:33.160 INFO [stdout] a5ece090748c918b0281979eecf9ac6a51505874de65735f5c5763fe8e131190 Dec 07 12:51:33.166 INFO running `"docker" "start" "-a" "a5ece090748c918b0281979eecf9ac6a51505874de65735f5c5763fe8e131190"` Dec 07 12:51:34.989 INFO [stderr] usermod: no changes Dec 07 12:51:35.327 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.32s Dec 07 12:51:35.335 INFO [stderr] Running /target/debug/deps/google_jwt_verify-b4293225a16ca803 Dec 07 12:51:35.343 INFO [stdout] Dec 07 12:51:35.343 INFO [stdout] running 5 tests Dec 07 12:51:35.348 INFO [stdout] test test::decode_keys ... ok Dec 07 12:51:35.352 INFO [stdout] test test::test_client ... ok Dec 07 12:51:35.356 INFO [stdout] test test::test_id_token ... ok Dec 07 12:51:35.356 INFO [stdout] test test::test_client_invalid_client_id ... ok Dec 07 12:51:35.536 INFO [stdout] test key_provider::test_google_provider ... FAILED Dec 07 12:51:35.536 INFO [stdout] Dec 07 12:51:35.536 INFO [stdout] failures: Dec 07 12:51:35.536 INFO [stdout] Dec 07 12:51:35.536 INFO [stdout] ---- key_provider::test_google_provider stdout ---- Dec 07 12:51:35.536 INFO [stdout] thread 'key_provider::test_google_provider' panicked at 'assertion failed: provider.get_key("test").is_ok()', src/key_provider.rs:60:5 Dec 07 12:51:35.536 INFO [stdout] stack backtrace: Dec 07 12:51:35.536 INFO [stdout] 0: 0x563168ad1d93 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h3c2ada0a2db8c5e7 Dec 07 12:51:35.536 INFO [stdout] at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Dec 07 12:51:35.536 INFO [stdout] 1: 0x563168acbf48 - std::sys_common::backtrace::_print::h95865c77318e98b7 Dec 07 12:51:35.536 INFO [stdout] at src/libstd/sys_common/backtrace.rs:71 Dec 07 12:51:35.536 INFO [stdout] 2: 0x563168ad0812 - std::panicking::default_hook::{{closure}}::hb3d1f299fcea42e5 Dec 07 12:51:35.536 INFO [stdout] at src/libstd/sys_common/backtrace.rs:59 Dec 07 12:51:35.536 INFO [stdout] at src/libstd/panicking.rs:211 Dec 07 12:51:35.536 INFO [stdout] 3: 0x563168ad04fc - std::panicking::default_hook::h4eae6f26f73244c8 Dec 07 12:51:35.536 INFO [stdout] at src/libstd/panicking.rs:221 Dec 07 12:51:35.536 INFO [stdout] 4: 0x563168ad0f20 - std::panicking::rust_panic_with_hook::h368d37fd53b59464 Dec 07 12:51:35.536 INFO [stdout] at src/libstd/panicking.rs:491 Dec 07 12:51:35.536 INFO [stdout] 5: 0x563168abb617 - std::panicking::begin_panic::hfecd8637e3e6a4b6 Dec 07 12:51:35.536 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:425 Dec 07 12:51:35.536 INFO [stdout] 6: 0x5631685e7692 - google_jwt_verify::key_provider::test_google_provider::h0eeec8817eead005 Dec 07 12:51:35.536 INFO [stdout] at src/key_provider.rs:60 Dec 07 12:51:35.536 INFO [stdout] 7: 0x5631685e75d9 - google_jwt_verify::key_provider::test_google_provider::{{closure}}::h140e763f7f683ae0 Dec 07 12:51:35.536 INFO [stdout] at src/key_provider.rs:58 Dec 07 12:51:35.536 INFO [stdout] 8: 0x5631685fd6fd - core::ops::function::FnOnce::call_once::h03cbdce901984e7b Dec 07 12:51:35.536 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libcore/ops/function.rs:238 Dec 07 12:51:35.536 INFO [stdout] 9: 0x563168610e5e - >::call_box::h994167e0fc25f327 Dec 07 12:51:35.536 INFO [stdout] at src/libtest/lib.rs:1471 Dec 07 12:51:35.536 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libcore/ops/function.rs:238 Dec 07 12:51:35.536 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:673 Dec 07 12:51:35.536 INFO [stdout] 10: 0x563168adff39 - __rust_maybe_catch_panic Dec 07 12:51:35.536 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 07 12:51:35.536 INFO [stdout] 11: 0x563168608d63 - std::sys_common::backtrace::__rust_begin_short_backtrace::h5d34cfb78512c8c3 Dec 07 12:51:35.536 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:289 Dec 07 12:51:35.536 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:398 Dec 07 12:51:35.536 INFO [stdout] at src/libtest/lib.rs:1426 Dec 07 12:51:35.536 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/sys_common/backtrace.rs:136 Dec 07 12:51:35.536 INFO [stdout] 12: 0x563168609c84 - std::panicking::try::do_call::h7a86b6211ebb5e72 Dec 07 12:51:35.536 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/thread/mod.rs:477 Dec 07 12:51:35.536 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:319 Dec 07 12:51:35.536 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:310 Dec 07 12:51:35.536 INFO [stdout] 13: 0x563168adff39 - __rust_maybe_catch_panic Dec 07 12:51:35.536 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 07 12:51:35.536 INFO [stdout] 14: 0x563168610d3c - >::call_box::h877dbe22cb3997f4 Dec 07 12:51:35.536 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:289 Dec 07 12:51:35.536 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:398 Dec 07 12:51:35.536 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/thread/mod.rs:476 Dec 07 12:51:35.536 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:673 Dec 07 12:51:35.536 INFO [stdout] 15: 0x563168ad3b5d - std::sys::unix::thread::Thread::new::thread_start::hea5f7f9c570dc4cd Dec 07 12:51:35.536 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:683 Dec 07 12:51:35.536 INFO [stdout] at src/libstd/sys_common/thread.rs:24 Dec 07 12:51:35.536 INFO [stdout] at src/libstd/sys/unix/thread.rs:90 Dec 07 12:51:35.536 INFO [stdout] 16: 0x7f34cd49d6b9 - start_thread Dec 07 12:51:35.536 INFO [stdout] 17: 0x7f34ccfbd41c - clone Dec 07 12:51:35.536 INFO [stdout] 18: 0x0 - Dec 07 12:51:35.536 INFO [stdout] Dec 07 12:51:35.536 INFO [stdout] Dec 07 12:51:35.536 INFO [stdout] failures: Dec 07 12:51:35.536 INFO [stdout] key_provider::test_google_provider Dec 07 12:51:35.536 INFO [stdout] Dec 07 12:51:35.536 INFO [stdout] test result: FAILED. 4 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out Dec 07 12:51:35.536 INFO [stdout] Dec 07 12:51:35.540 INFO [stderr] error: test failed, to rerun pass '--lib' Dec 07 12:51:35.553 INFO [stderr] su: No module specific data is present Dec 07 12:51:36.728 INFO running `"docker" "inspect" "a5ece090748c918b0281979eecf9ac6a51505874de65735f5c5763fe8e131190"` Dec 07 12:51:37.102 INFO running `"docker" "rm" "-f" "a5ece090748c918b0281979eecf9ac6a51505874de65735f5c5763fe8e131190"` Dec 07 12:51:37.447 INFO [stdout] a5ece090748c918b0281979eecf9ac6a51505874de65735f5c5763fe8e131190