Dec 06 19:40:09.451 INFO testing tokkit-0.15.3 against try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468 for pr-56514
Dec 06 19:40:09.451 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-1/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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 06 19:40:09.896 INFO [stdout] 000411f1c3de91077e29aa8910bab34966e2a98117c4e2fbad8532cbf027ce8b
Dec 06 19:40:09.896 INFO running `"docker" "start" "-a" "000411f1c3de91077e29aa8910bab34966e2a98117c4e2fbad8532cbf027ce8b"`
Dec 06 19:40:11.183 INFO [stderr] usermod: no changes
Dec 06 19:40:11.557 INFO [stderr]    Compiling backoff v0.1.2
Dec 06 19:40:11.596 INFO [stderr]    Compiling reqwest v0.9.5
Dec 06 19:40:27.516 INFO [stderr]    Compiling tokkit v0.15.3 (/source)
Dec 06 19:40:36.556 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 25.35s
Dec 06 19:40:36.572 INFO [stderr] su: No module specific data is present
Dec 06 19:40:37.625 INFO running `"docker" "inspect" "000411f1c3de91077e29aa8910bab34966e2a98117c4e2fbad8532cbf027ce8b"`
Dec 06 19:40:37.976 INFO running `"docker" "rm" "-f" "000411f1c3de91077e29aa8910bab34966e2a98117c4e2fbad8532cbf027ce8b"`
Dec 06 19:40:38.368 INFO [stdout] 000411f1c3de91077e29aa8910bab34966e2a98117c4e2fbad8532cbf027ce8b
Dec 06 19:40:38.376 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-1/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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 06 19:40:38.832 INFO [stdout] 8381d9d84e34ac73e300e6c9c0bf7a43ed378ee9be78b7293221ff71a224834a
Dec 06 19:40:38.834 INFO running `"docker" "start" "-a" "8381d9d84e34ac73e300e6c9c0bf7a43ed378ee9be78b7293221ff71a224834a"`
Dec 06 19:40:41.184 INFO [stderr] usermod: no changes
Dec 06 19:40:41.526 INFO [stderr]    Compiling tokkit v0.15.3 (/source)
Dec 06 19:40:55.477 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 14.27s
Dec 06 19:40:55.493 INFO [stderr] su: No module specific data is present
Dec 06 19:40:56.867 INFO running `"docker" "inspect" "8381d9d84e34ac73e300e6c9c0bf7a43ed378ee9be78b7293221ff71a224834a"`
Dec 06 19:40:57.220 INFO running `"docker" "rm" "-f" "8381d9d84e34ac73e300e6c9c0bf7a43ed378ee9be78b7293221ff71a224834a"`
Dec 06 19:40:57.596 INFO [stdout] 8381d9d84e34ac73e300e6c9c0bf7a43ed378ee9be78b7293221ff71a224834a
Dec 06 19:40:57.602 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-1/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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 06 19:40:58.206 INFO [stdout] 6276e32934f532787c778ce8cb09f1c1f866eeb7398c7ee54b3c85b29374fd6e
Dec 06 19:40:58.207 INFO running `"docker" "start" "-a" "6276e32934f532787c778ce8cb09f1c1f866eeb7398c7ee54b3c85b29374fd6e"`
Dec 06 19:41:00.271 INFO [stderr] usermod: no changes
Dec 06 19:41:00.612 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.32s
Dec 06 19:41:00.624 INFO [stderr]      Running /target/debug/deps/tokkit-c60e64215d944ea0
Dec 06 19:41:00.624 INFO [stdout] 
Dec 06 19:41:00.624 INFO [stdout] running 19 tests
Dec 06 19:41:00.644 INFO [stdout] test parsers::amazon_token_info ... ok
Dec 06 19:41:00.652 INFO [stdout] test parsers::google_v3_token_info_multiple_scopes ... ok
Dec 06 19:41:00.652 INFO [stdout] test token_manager::internals::request_scheduler::test::clock_test ... ok
Dec 06 19:41:00.652 INFO [stdout] test token_manager::internals::token_updater::refresh_tests::clock_test ... ok
Dec 06 19:41:00.652 INFO [stdout] test token_manager::internals::request_scheduler::test::initial_state_is_correct ... ok
Dec 06 19:41:00.652 INFO [stdout] test parsers::google_v3_token_info_multiple_scopes_whitespaces ... ok
Dec 06 19:41:00.668 INFO [stdout] test token_manager::internals::request_scheduler::test::scheduler_sends_initial_refresh_while_nothing_happens ... ok
Dec 06 19:41:00.668 INFO [stdout] test token_manager::internals::token_updater::refresh_tests::initializes_token_when_time_increased ... ok
Dec 06 19:41:00.668 INFO [stdout] test token_manager::internals::request_scheduler::test::scheduler_workflow ... ok
Dec 06 19:41:00.668 INFO [stdout] test token_manager::internals::token_updater::refresh_tests::initial_state_is_correct ... ok
Dec 06 19:41:00.668 INFO [stdout] test token_manager::internals::token_updater::refresh_tests::does_initialize_token_twice_when_time_did_not_increase ... ok
Dec 06 19:41:00.668 INFO [stdout] test token_manager::internals::token_updater::refresh_tests::refreshes_error_pending_token ... ok
Dec 06 19:41:00.668 INFO [stdout] test token_manager::internals::token_updater::refresh_tests::initializes_token_when_time_did_not_increase ... ok
Dec 06 19:41:00.676 INFO [stdout] test token_manager::internals::token_updater::refresh_tests::refreshes_initilalizing_token ... ok
Dec 06 19:41:00.676 INFO [stdout] test token_manager::internals::token_updater::refresh_tests::refreshes_ok_pending_token ... ok
Dec 06 19:41:00.676 INFO [stdout] test token_manager::token_provider::credentials::parsers::test::default_client_credentials_parser ... ok
Dec 06 19:41:00.676 INFO [stdout] test token_manager::token_provider::credentials::parsers::test::application_user_credentials_parser ... ok
Dec 06 19:41:00.676 INFO [stdout] test token_manager::internals::token_updater::refresh_tests::refreshes_error_token ... ok
Dec 06 19:41:00.680 INFO [stdout] test token_manager::token_provider::credentials::parsers::test::user_credentials_parser ... ok
Dec 06 19:41:00.680 INFO [stdout] 
Dec 06 19:41:00.680 INFO [stdout] test result: ok. 19 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 19:41:00.680 INFO [stdout] 
Dec 06 19:41:00.680 INFO [stderr]    Doc-tests tokkit
Dec 06 19:41:13.189 INFO [stdout] 
Dec 06 19:41:13.189 INFO [stdout] running 4 tests
Dec 06 19:41:35.406 INFO [stdout] test src/lib.rs -  (line 34) ... ok
Dec 06 19:41:41.230 INFO [stdout] test src/parsers.rs - parsers::AmazonTokenInfoParser (line 217) ... ok
Dec 06 19:41:41.276 INFO [stdout] test src/parsers.rs - parsers::PlanBTokenInfoParser (line 123) ... ok
Dec 06 19:41:42.279 INFO [stdout] test src/parsers.rs - parsers::GoogleV3TokenInfoParser (line 167) ... ok
Dec 06 19:41:42.279 INFO [stdout] 
Dec 06 19:41:42.279 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 19:41:42.279 INFO [stdout] 
Dec 06 19:41:42.314 INFO [stderr] su: No module specific data is present
Dec 06 19:41:42.834 INFO running `"docker" "inspect" "6276e32934f532787c778ce8cb09f1c1f866eeb7398c7ee54b3c85b29374fd6e"`
Dec 06 19:41:43.056 INFO running `"docker" "rm" "-f" "6276e32934f532787c778ce8cb09f1c1f866eeb7398c7ee54b3c85b29374fd6e"`
Dec 06 19:41:43.296 INFO [stdout] 6276e32934f532787c778ce8cb09f1c1f866eeb7398c7ee54b3c85b29374fd6e