Dec 05 23:09:23.326 INFO testing fuchsnj/google-jwt-verify against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514 Dec 05 23:09:23.326 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-1/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 05 23:09:23.808 INFO [stdout] d6891e9b1e982acbfe0ace09857183dcffd5b10c8d9e258c2df3b0b95744b25a Dec 05 23:09:23.814 INFO running `"docker" "start" "-a" "d6891e9b1e982acbfe0ace09857183dcffd5b10c8d9e258c2df3b0b95744b25a"` Dec 05 23:09:24.988 INFO [stderr] usermod: no changes Dec 05 23:09:25.301 INFO [stderr] Compiling openssl v0.10.7 Dec 05 23:09:25.301 INFO [stderr] Compiling serde v1.0.55 Dec 05 23:09:25.316 INFO [stderr] Compiling time v0.1.40 Dec 05 23:09:25.316 INFO [stderr] Compiling net2 v0.2.32 Dec 05 23:09:25.316 INFO [stderr] Compiling openssl-sys v0.9.30 Dec 05 23:09:25.320 INFO [stderr] Compiling bytes v0.4.7 Dec 05 23:09:25.320 INFO [stderr] Compiling futures-cpupool v0.1.8 Dec 05 23:09:25.320 INFO [stderr] Compiling want v0.0.4 Dec 05 23:09:31.538 INFO [stderr] Compiling uuid v0.5.1 Dec 05 23:09:31.560 INFO [stderr] Compiling mio v0.6.14 Dec 05 23:09:32.266 INFO [stderr] Compiling syn v0.13.10 Dec 05 23:09:32.269 INFO [stderr] Compiling tokio-threadpool v0.1.3 Dec 05 23:09:32.285 INFO [stderr] Compiling libflate v0.1.14 Dec 05 23:09:32.720 INFO [stderr] Compiling phf_generator v0.7.22 Dec 05 23:09:33.805 INFO [stderr] Compiling tokio-io v0.1.6 Dec 05 23:09:34.271 INFO [stderr] Compiling phf_codegen v0.7.22 Dec 05 23:09:36.050 INFO [stderr] Compiling mime_guess v2.0.0-alpha.4 Dec 05 23:09:45.392 INFO [stderr] Compiling openssl v0.9.24 Dec 05 23:09:45.404 INFO [stderr] Compiling tokio-fs v0.1.0 Dec 05 23:09:45.414 INFO [stderr] Compiling tokio-reactor v0.1.1 Dec 05 23:09:55.078 INFO [stderr] Compiling tokio-tcp v0.1.0 Dec 05 23:09:55.082 INFO [stderr] Compiling tokio-udp v0.1.0 Dec 05 23:09:56.296 INFO [stderr] Compiling serde_derive v1.0.55 Dec 05 23:09:56.708 INFO [stderr] Compiling tokio v0.1.6 Dec 05 23:10:01.307 INFO [stderr] Compiling native-tls v0.1.5 Dec 05 23:10:01.374 INFO [stderr] Compiling tokio-core v0.1.17 Dec 05 23:10:04.780 INFO [stderr] Compiling tokio-proto v0.1.1 Dec 05 23:10:04.780 INFO [stderr] Compiling tokio-tls v0.1.4 Dec 05 23:10:04.884 INFO [stderr] Compiling serde_json v1.0.17 Dec 05 23:10:04.884 INFO [stderr] Compiling serde_urlencoded v0.5.2 Dec 05 23:10:08.788 INFO [stderr] Compiling hyper v0.11.27 Dec 05 23:10:21.393 INFO [stderr] Compiling hyper-tls v0.1.3 Dec 05 23:10:22.369 INFO [stderr] Compiling reqwest v0.8.5 Dec 05 23:10:29.424 INFO [stderr] Compiling google-jwt-verify v0.1.0 (/source) Dec 05 23:10:32.054 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 1m 07s Dec 05 23:10:32.070 INFO [stderr] su: No module specific data is present Dec 05 23:10:32.990 INFO running `"docker" "inspect" "d6891e9b1e982acbfe0ace09857183dcffd5b10c8d9e258c2df3b0b95744b25a"` Dec 05 23:10:33.428 INFO running `"docker" "rm" "-f" "d6891e9b1e982acbfe0ace09857183dcffd5b10c8d9e258c2df3b0b95744b25a"` Dec 05 23:10:33.765 INFO [stdout] d6891e9b1e982acbfe0ace09857183dcffd5b10c8d9e258c2df3b0b95744b25a Dec 05 23:10:33.770 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-1/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 05 23:10:34.250 INFO [stdout] 35c49f5e9453fc73c35333699563663ce6e036e1d60cb00c26a37504995267fb Dec 05 23:10:34.252 INFO running `"docker" "start" "-a" "35c49f5e9453fc73c35333699563663ce6e036e1d60cb00c26a37504995267fb"` Dec 05 23:10:35.764 INFO [stderr] usermod: no changes Dec 05 23:10:35.980 INFO [stderr] Compiling google-jwt-verify v0.1.0 (/source) Dec 05 23:10:41.484 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 5.69s Dec 05 23:10:41.500 INFO [stderr] su: No module specific data is present Dec 05 23:10:42.184 INFO running `"docker" "inspect" "35c49f5e9453fc73c35333699563663ce6e036e1d60cb00c26a37504995267fb"` Dec 05 23:10:42.422 INFO running `"docker" "rm" "-f" "35c49f5e9453fc73c35333699563663ce6e036e1d60cb00c26a37504995267fb"` Dec 05 23:10:42.772 INFO [stdout] 35c49f5e9453fc73c35333699563663ce6e036e1d60cb00c26a37504995267fb Dec 05 23:10:42.776 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-1/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 05 23:10:43.233 INFO [stdout] 2ad450d56e4dd34b294564b8aa3582ae06727c96e673b407159f6f5e3dbdcdd9 Dec 05 23:10:43.235 INFO running `"docker" "start" "-a" "2ad450d56e4dd34b294564b8aa3582ae06727c96e673b407159f6f5e3dbdcdd9"` Dec 05 23:10:45.359 INFO [stderr] usermod: no changes Dec 05 23:10:45.586 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.19s Dec 05 23:10:45.603 INFO [stderr] Running /target/debug/deps/google_jwt_verify-966fc9bbb5aab338 Dec 05 23:10:45.611 INFO [stdout] Dec 05 23:10:45.611 INFO [stdout] running 5 tests Dec 05 23:10:45.632 INFO [stdout] test test::decode_keys ... ok Dec 05 23:10:45.636 INFO [stdout] test test::test_client_invalid_client_id ... ok Dec 05 23:10:45.636 INFO [stdout] test test::test_client ... ok Dec 05 23:10:45.637 INFO [stdout] test test::test_id_token ... ok Dec 05 23:10:45.806 INFO [stdout] test key_provider::test_google_provider ... FAILED Dec 05 23:10:45.806 INFO [stdout] Dec 05 23:10:45.806 INFO [stdout] failures: Dec 05 23:10:45.806 INFO [stdout] Dec 05 23:10:45.806 INFO [stdout] ---- key_provider::test_google_provider stdout ---- Dec 05 23:10:45.806 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 05 23:10:45.806 INFO [stdout] stack backtrace: Dec 05 23:10:45.806 INFO [stdout] 0: 0x560970b43183 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h3c2ada0a2db8c5e7 Dec 05 23:10:45.806 INFO [stdout] at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Dec 05 23:10:45.806 INFO [stdout] 1: 0x560970b3d318 - std::sys_common::backtrace::_print::h95865c77318e98b7 Dec 05 23:10:45.806 INFO [stdout] at src/libstd/sys_common/backtrace.rs:71 Dec 05 23:10:45.806 INFO [stdout] 2: 0x560970b41c02 - std::panicking::default_hook::{{closure}}::hb3d1f299fcea42e5 Dec 05 23:10:45.806 INFO [stdout] at src/libstd/sys_common/backtrace.rs:59 Dec 05 23:10:45.806 INFO [stdout] at src/libstd/panicking.rs:211 Dec 05 23:10:45.806 INFO [stdout] 3: 0x560970b418ec - std::panicking::default_hook::h4eae6f26f73244c8 Dec 05 23:10:45.806 INFO [stdout] at src/libstd/panicking.rs:221 Dec 05 23:10:45.806 INFO [stdout] 4: 0x560970b42310 - std::panicking::rust_panic_with_hook::h368d37fd53b59464 Dec 05 23:10:45.806 INFO [stdout] at src/libstd/panicking.rs:491 Dec 05 23:10:45.806 INFO [stdout] 5: 0x5609708f1dc7 - std::panicking::begin_panic::h8b9c458b340321de Dec 05 23:10:45.806 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:425 Dec 05 23:10:45.806 INFO [stdout] 6: 0x5609706c03b2 - google_jwt_verify::key_provider::test_google_provider::h2ec643e6d5cca972 Dec 05 23:10:45.806 INFO [stdout] at src/key_provider.rs:60 Dec 05 23:10:45.806 INFO [stdout] 7: 0x5609706c02f9 - google_jwt_verify::key_provider::test_google_provider::{{closure}}::h0bf1c4b3ba88ea9b Dec 05 23:10:45.806 INFO [stdout] at src/key_provider.rs:58 Dec 05 23:10:45.806 INFO [stdout] 8: 0x5609706d6d7d - core::ops::function::FnOnce::call_once::h951e3d47459ad8be Dec 05 23:10:45.806 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libcore/ops/function.rs:238 Dec 05 23:10:45.806 INFO [stdout] 9: 0x5609706e8f6e - >::call_box::h994167e0fc25f327 Dec 05 23:10:45.806 INFO [stdout] at src/libtest/lib.rs:1471 Dec 05 23:10:45.806 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libcore/ops/function.rs:238 Dec 05 23:10:45.806 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:673 Dec 05 23:10:45.806 INFO [stdout] 10: 0x560970b51019 - __rust_maybe_catch_panic Dec 05 23:10:45.806 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 05 23:10:45.806 INFO [stdout] 11: 0x5609706e0e73 - std::sys_common::backtrace::__rust_begin_short_backtrace::h5d34cfb78512c8c3 Dec 05 23:10:45.806 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:289 Dec 05 23:10:45.806 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:398 Dec 05 23:10:45.806 INFO [stdout] at src/libtest/lib.rs:1426 Dec 05 23:10:45.806 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/sys_common/backtrace.rs:136 Dec 05 23:10:45.806 INFO [stdout] 12: 0x5609706e1d94 - std::panicking::try::do_call::h7a86b6211ebb5e72 Dec 05 23:10:45.806 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/thread/mod.rs:477 Dec 05 23:10:45.806 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:319 Dec 05 23:10:45.806 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:310 Dec 05 23:10:45.806 INFO [stdout] 13: 0x560970b51019 - __rust_maybe_catch_panic Dec 05 23:10:45.806 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 05 23:10:45.806 INFO [stdout] 14: 0x5609706e8e4c - >::call_box::h877dbe22cb3997f4 Dec 05 23:10:45.806 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:289 Dec 05 23:10:45.806 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:398 Dec 05 23:10:45.806 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/thread/mod.rs:476 Dec 05 23:10:45.806 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:673 Dec 05 23:10:45.806 INFO [stdout] 15: 0x560970b44f3d - std::sys::unix::thread::Thread::new::thread_start::hea5f7f9c570dc4cd Dec 05 23:10:45.806 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:683 Dec 05 23:10:45.806 INFO [stdout] at src/libstd/sys_common/thread.rs:24 Dec 05 23:10:45.806 INFO [stdout] at src/libstd/sys/unix/thread.rs:90 Dec 05 23:10:45.806 INFO [stdout] 16: 0x7fb4a34af6b9 - start_thread Dec 05 23:10:45.806 INFO [stdout] 17: 0x7fb4a2fcf41c - clone Dec 05 23:10:45.806 INFO [stdout] 18: 0x0 - Dec 05 23:10:45.806 INFO [stdout] Dec 05 23:10:45.806 INFO [stdout] Dec 05 23:10:45.806 INFO [stdout] failures: Dec 05 23:10:45.806 INFO [stdout] key_provider::test_google_provider Dec 05 23:10:45.806 INFO [stdout] Dec 05 23:10:45.806 INFO [stdout] test result: FAILED. 4 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out Dec 05 23:10:45.806 INFO [stdout] Dec 05 23:10:45.811 INFO [stderr] error: test failed, to rerun pass '--lib' Dec 05 23:10:45.814 INFO [stderr] su: No module specific data is present Dec 05 23:10:46.733 INFO running `"docker" "inspect" "2ad450d56e4dd34b294564b8aa3582ae06727c96e673b407159f6f5e3dbdcdd9"` Dec 05 23:10:46.950 INFO running `"docker" "rm" "-f" "2ad450d56e4dd34b294564b8aa3582ae06727c96e673b407159f6f5e3dbdcdd9"` Dec 05 23:10:47.263 INFO [stdout] 2ad450d56e4dd34b294564b8aa3582ae06727c96e673b407159f6f5e3dbdcdd9