Dec 06 19:40:10.011 INFO testing tokkit-0.15.3 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 06 19:40:10.011 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/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 06 19:40:10.334 INFO [stdout] ce82955f6e8d1a89ecea62d001ce50885705aaf443b6f1186b66245dd4af2eeb
Dec 06 19:40:10.338 INFO running `"docker" "start" "-a" "ce82955f6e8d1a89ecea62d001ce50885705aaf443b6f1186b66245dd4af2eeb"`
Dec 06 19:40:11.421 INFO [stderr] usermod: no changes
Dec 06 19:40:11.884 INFO [stderr]    Compiling backoff v0.1.2
Dec 06 19:40:12.648 INFO [stderr]    Compiling tokkit v0.15.3 (/source)
Dec 06 19:40:23.824 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 12.37s
Dec 06 19:40:23.847 INFO [stderr] su: No module specific data is present
Dec 06 19:40:24.771 INFO running `"docker" "inspect" "ce82955f6e8d1a89ecea62d001ce50885705aaf443b6f1186b66245dd4af2eeb"`
Dec 06 19:40:25.038 INFO running `"docker" "rm" "-f" "ce82955f6e8d1a89ecea62d001ce50885705aaf443b6f1186b66245dd4af2eeb"`
Dec 06 19:40:25.420 INFO [stdout] ce82955f6e8d1a89ecea62d001ce50885705aaf443b6f1186b66245dd4af2eeb
Dec 06 19:40:25.428 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/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 06 19:40:25.876 INFO [stdout] d59c8fff2bf5ddc4f82803b4ae1a5fc0efe1802022f085e540d3dc302da200c8
Dec 06 19:40:25.877 INFO running `"docker" "start" "-a" "d59c8fff2bf5ddc4f82803b4ae1a5fc0efe1802022f085e540d3dc302da200c8"`
Dec 06 19:40:27.536 INFO [stderr] usermod: no changes
Dec 06 19:40:27.924 INFO [stderr]    Compiling tokkit v0.15.3 (/source)
Dec 06 19:40:41.864 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 14.30s
Dec 06 19:40:41.885 INFO [stderr] su: No module specific data is present
Dec 06 19:40:43.003 INFO running `"docker" "inspect" "d59c8fff2bf5ddc4f82803b4ae1a5fc0efe1802022f085e540d3dc302da200c8"`
Dec 06 19:40:43.364 INFO running `"docker" "rm" "-f" "d59c8fff2bf5ddc4f82803b4ae1a5fc0efe1802022f085e540d3dc302da200c8"`
Dec 06 19:40:43.812 INFO [stdout] d59c8fff2bf5ddc4f82803b4ae1a5fc0efe1802022f085e540d3dc302da200c8
Dec 06 19:40:43.820 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/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 06 19:40:44.271 INFO [stdout] e70437fa81fcdd7d37da72994e607e8f78b56b73975a3aa3243e09a44df9244f
Dec 06 19:40:44.273 INFO running `"docker" "start" "-a" "e70437fa81fcdd7d37da72994e607e8f78b56b73975a3aa3243e09a44df9244f"`
Dec 06 19:40:46.623 INFO [stderr] usermod: no changes
Dec 06 19:40:46.945 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.30s
Dec 06 19:40:46.954 INFO [stderr]      Running /target/debug/deps/tokkit-32c6929361a896cc
Dec 06 19:40:46.957 INFO [stdout] 
Dec 06 19:40:46.957 INFO [stdout] running 19 tests
Dec 06 19:40:46.958 INFO [stdout] test token_manager::internals::token_updater::refresh_tests::clock_test ... ok
Dec 06 19:40:46.958 INFO [stdout] test token_manager::internals::request_scheduler::test::scheduler_workflow ... ok
Dec 06 19:40:46.958 INFO [stdout] test token_manager::internals::request_scheduler::test::scheduler_sends_initial_refresh_while_nothing_happens ... ok
Dec 06 19:40:46.958 INFO [stdout] test token_manager::internals::request_scheduler::test::initial_state_is_correct ... ok
Dec 06 19:40:46.958 INFO [stdout] test token_manager::internals::request_scheduler::test::clock_test ... ok
Dec 06 19:40:46.958 INFO [stdout] test token_manager::internals::token_updater::refresh_tests::does_initialize_token_twice_when_time_did_not_increase ... ok
Dec 06 19:40:46.959 INFO [stdout] test token_manager::internals::token_updater::refresh_tests::initial_state_is_correct ... ok
Dec 06 19:40:46.959 INFO [stdout] test token_manager::internals::token_updater::refresh_tests::refreshes_initilalizing_token ... ok
Dec 06 19:40:46.959 INFO [stdout] test token_manager::internals::token_updater::refresh_tests::initializes_token_when_time_did_not_increase ... ok
Dec 06 19:40:46.960 INFO [stdout] test token_manager::internals::token_updater::refresh_tests::refreshes_error_token ... ok
Dec 06 19:40:46.977 INFO [stdout] test token_manager::internals::token_updater::refresh_tests::refreshes_ok_pending_token ... ok
Dec 06 19:40:46.977 INFO [stdout] test parsers::amazon_token_info ... ok
Dec 06 19:40:46.984 INFO [stdout] test token_manager::internals::token_updater::refresh_tests::refreshes_error_pending_token ... ok
Dec 06 19:40:46.992 INFO [stdout] test parsers::google_v3_token_info_multiple_scopes_whitespaces ... ok
Dec 06 19:40:46.993 INFO [stdout] test token_manager::token_provider::credentials::parsers::test::application_user_credentials_parser ... ok
Dec 06 19:40:46.993 INFO [stdout] test token_manager::internals::token_updater::refresh_tests::initializes_token_when_time_increased ... ok
Dec 06 19:40:46.996 INFO [stdout] test token_manager::token_provider::credentials::parsers::test::user_credentials_parser ... ok
Dec 06 19:40:46.997 INFO [stdout] test token_manager::token_provider::credentials::parsers::test::default_client_credentials_parser ... ok
Dec 06 19:40:47.004 INFO [stdout] test parsers::google_v3_token_info_multiple_scopes ... ok
Dec 06 19:40:47.004 INFO [stdout] 
Dec 06 19:40:47.005 INFO [stdout] test result: ok. 19 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 19:40:47.005 INFO [stdout] 
Dec 06 19:40:47.008 INFO [stderr]    Doc-tests tokkit
Dec 06 19:40:59.360 INFO [stdout] 
Dec 06 19:40:59.360 INFO [stdout] running 4 tests
Dec 06 19:41:22.452 INFO [stdout] test src/lib.rs -  (line 34) ... ok
Dec 06 19:41:29.615 INFO [stdout] test src/parsers.rs - parsers::PlanBTokenInfoParser (line 123) ... ok
Dec 06 19:41:29.857 INFO [stdout] test src/parsers.rs - parsers::AmazonTokenInfoParser (line 217) ... ok
Dec 06 19:41:32.544 INFO [stdout] test src/parsers.rs - parsers::GoogleV3TokenInfoParser (line 167) ... ok
Dec 06 19:41:32.544 INFO [stdout] 
Dec 06 19:41:32.544 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 19:41:32.544 INFO [stdout] 
Dec 06 19:41:32.572 INFO [stderr] su: No module specific data is present
Dec 06 19:41:33.338 INFO running `"docker" "inspect" "e70437fa81fcdd7d37da72994e607e8f78b56b73975a3aa3243e09a44df9244f"`
Dec 06 19:41:33.656 INFO running `"docker" "rm" "-f" "e70437fa81fcdd7d37da72994e607e8f78b56b73975a3aa3243e09a44df9244f"`
Dec 06 19:41:34.034 INFO [stdout] e70437fa81fcdd7d37da72994e607e8f78b56b73975a3aa3243e09a44df9244f