Oct 11 15:52:46.711 INFO testing oauth2-2.0.0-alpha.2 against master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513 for rustdoc-test-static-cling Oct 11 15:52:46.711 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt build --frozen Oct 11 15:52:46.711 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-0/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-0/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,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" "CMD=cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt build --frozen" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-m" "1536M" "--network" "none" "crater"` Oct 11 15:52:47.114 INFO blam! 7b6ebb9cd1690a8f5878f9c5d96adecd7ce2c7af3340078b48d09f776911c60e Oct 11 15:52:47.118 INFO running `"docker" "start" "-a" "7b6ebb9cd1690a8f5878f9c5d96adecd7ce2c7af3340078b48d09f776911c60e"` Oct 11 15:52:48.196 INFO kablam! usermod: no changes Oct 11 15:52:48.384 INFO kablam! Compiling oauth2 v2.0.0-alpha.2 (/source) Oct 11 15:52:51.554 INFO kablam! Finished dev [unoptimized + debuginfo] target(s) in 3.34s Oct 11 15:52:51.570 INFO kablam! su: No module specific data is present Oct 11 15:52:52.188 INFO running `"docker" "rm" "-f" "7b6ebb9cd1690a8f5878f9c5d96adecd7ce2c7af3340078b48d09f776911c60e"` Oct 11 15:52:52.424 INFO blam! 7b6ebb9cd1690a8f5878f9c5d96adecd7ce2c7af3340078b48d09f776911c60e Oct 11 15:52:52.426 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen --no-run Oct 11 15:52:52.426 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-0/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-0/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,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" "CMD=cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen --no-run" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-m" "1536M" "--network" "none" "crater"` Oct 11 15:52:52.707 INFO blam! 70c8ed367466283dd1049228d15c8bf50ca7e512795cf5730b3603a998654e29 Oct 11 15:52:52.710 INFO running `"docker" "start" "-a" "70c8ed367466283dd1049228d15c8bf50ca7e512795cf5730b3603a998654e29"` Oct 11 15:52:53.188 INFO kablam! usermod: no changes Oct 11 15:52:53.296 INFO kablam! Compiling http-muncher v0.3.2 Oct 11 15:52:53.917 INFO kablam! Compiling mockito v0.8.2 Oct 11 15:52:55.672 INFO kablam! Compiling oauth2 v2.0.0-alpha.2 (/source) Oct 11 15:53:06.411 INFO kablam! Finished dev [unoptimized + debuginfo] target(s) in 13.20s Oct 11 15:53:06.422 INFO kablam! su: No module specific data is present Oct 11 15:53:07.064 INFO running `"docker" "rm" "-f" "70c8ed367466283dd1049228d15c8bf50ca7e512795cf5730b3603a998654e29"` Oct 11 15:53:07.392 INFO blam! 70c8ed367466283dd1049228d15c8bf50ca7e512795cf5730b3603a998654e29 Oct 11 15:53:07.397 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen Oct 11 15:53:07.398 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-0/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-0/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,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" "CMD=cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-m" "1536M" "--network" "none" "crater"` Oct 11 15:53:07.852 INFO blam! c26839ccc44730baa8ef7e891d2933f0c28d84bfef6a11d07becbfe8a54bf286 Oct 11 15:53:07.868 INFO running `"docker" "start" "-a" "c26839ccc44730baa8ef7e891d2933f0c28d84bfef6a11d07becbfe8a54bf286"` Oct 11 15:53:09.944 INFO kablam! usermod: no changes Oct 11 15:53:10.128 INFO kablam! Finished dev [unoptimized + debuginfo] target(s) in 0.14s Oct 11 15:53:10.150 INFO kablam! Running /target/debug/deps/oauth2-253df8fa1dd70aa5 Oct 11 15:53:10.150 INFO blam! Oct 11 15:53:10.150 INFO kablam! Running /target/debug/deps/lib-3c763c481d749dae Oct 11 15:53:10.150 INFO blam! running 0 tests Oct 11 15:53:10.150 INFO blam! Oct 11 15:53:10.150 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Oct 11 15:53:10.150 INFO blam! Oct 11 15:53:10.248 INFO blam! Oct 11 15:53:10.248 INFO blam! running 28 tests Oct 11 15:53:10.252 INFO blam! test test_authorize_url_implicit_insecure ... ok Oct 11 15:53:10.252 INFO blam! test test_authorize_random ... ok Oct 11 15:53:10.252 INFO blam! test test_authorize_url_with_extension_response_type ... ok Oct 11 15:53:10.264 INFO blam! test test_authorize_url_implicit ... ok Oct 11 15:53:10.265 INFO blam! test test_authorize_url_with_param ... ok Oct 11 15:53:10.272 INFO blam! test test_authorize_url_with_scopes ... ok Oct 11 15:53:10.273 INFO blam! test test_authorize_url_insecure ... ok Oct 11 15:53:10.280 INFO blam! test test_authorize_url ... ok Oct 11 15:53:10.285 INFO blam! test test_authorize_url_with_redirect_url ... ok Oct 11 15:53:10.300 INFO blam! test test_exchange_code_successful_with_complete_json_response ... ok Oct 11 15:53:10.308 INFO blam! test test_exchange_code_successful_with_basic_auth ... ok Oct 11 15:53:10.308 INFO blam! test test_exchange_code_successful_with_redirect_url ... ok Oct 11 15:53:10.392 INFO blam! test test_exchange_client_credentials_with_body_auth_and_scope ... ok Oct 11 15:53:10.392 INFO blam! test test_exchange_client_credentials_with_basic_auth ... ok Oct 11 15:53:10.400 INFO blam! test test_exchange_code_with_invalid_token_type ... ok Oct 11 15:53:10.400 INFO blam! test test_exchange_code_with_json_parse_error ... ok Oct 11 15:53:10.408 INFO blam! test test_exchange_password_with_json_response ... ok Oct 11 15:53:10.408 INFO blam! test test_exchange_code_with_simple_json_error ... ok Oct 11 15:53:10.408 INFO blam! test test_exchange_code_with_unexpected_content_type ... ok Oct 11 15:53:10.437 INFO blam! test test_exchange_code_successful_with_minimal_json_response ... FAILED Oct 11 15:53:10.438 INFO blam! test test_exchange_refresh_token_with_basic_auth ... FAILED Oct 11 15:53:10.438 INFO blam! test test_exchange_refresh_token_with_json_response ... FAILED Oct 11 15:53:10.438 INFO blam! test test_exchange_code_fails_gracefully_on_transport_error ... ok Oct 11 15:53:10.438 INFO blam! test test_exchange_code_with_400_status_code ... FAILED Oct 11 15:53:10.438 INFO blam! test test_extension_successful_with_minimal_json_response ... ok Oct 11 15:53:10.438 INFO blam! test test_extension_successful_with_complete_json_response ... ok Oct 11 15:53:10.438 INFO blam! test test_extension_with_simple_json_error ... ok Oct 11 15:53:10.438 INFO blam! test test_secret_redaction ... ok Oct 11 15:53:10.438 INFO blam! Oct 11 15:53:10.438 INFO blam! failures: Oct 11 15:53:10.438 INFO blam! Oct 11 15:53:10.438 INFO blam! ---- test_exchange_code_successful_with_minimal_json_response stdout ---- Oct 11 15:53:10.438 INFO blam! thread 'test_exchange_code_successful_with_minimal_json_response' panicked at 'called `Result::unwrap()` on an `Err` value: ServerResponse(ErrorResponse { error: invalid_request, error_description: Some("Expired code."), error_uri: None })', libcore/result.rs:1009:5 Oct 11 15:53:10.438 INFO blam! stack backtrace: Oct 11 15:53:10.438 INFO blam! 0: 0x55c071c33d2e - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h52ace5b3d4e95617 Oct 11 15:53:10.438 INFO blam! at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Oct 11 15:53:10.438 INFO blam! 1: 0x55c071c3d4f6 - std::sys_common::backtrace::print::h6cfc8a66009c1cc9 Oct 11 15:53:10.438 INFO blam! at libstd/sys_common/backtrace.rs:71 Oct 11 15:53:10.438 INFO blam! at libstd/sys_common/backtrace.rs:59 Oct 11 15:53:10.438 INFO blam! 2: 0x55c071c3803d - std::panicking::default_hook::{{closure}}::h47bedf778bf88480 Oct 11 15:53:10.438 INFO blam! at libstd/panicking.rs:211 Oct 11 15:53:10.438 INFO blam! 3: 0x55c071c37d4b - std::panicking::default_hook::h1ef46fa7cd894809 Oct 11 15:53:10.438 INFO blam! at libstd/panicking.rs:221 Oct 11 15:53:10.438 INFO blam! 4: 0x55c071c386ec - std::panicking::rust_panic_with_hook::h05510fde8841c579 Oct 11 15:53:10.438 INFO blam! at libstd/panicking.rs:476 Oct 11 15:53:10.438 INFO blam! 5: 0x55c071c382a9 - std::panicking::continue_panic_fmt::h6e11f50e47f94b00 Oct 11 15:53:10.438 INFO blam! at libstd/panicking.rs:390 Oct 11 15:53:10.438 INFO blam! 6: 0x55c071c381a5 - rust_begin_unwind Oct 11 15:53:10.438 INFO blam! at libstd/panicking.rs:325 Oct 11 15:53:10.438 INFO blam! 7: 0x55c071c7cc2b - core::panicking::panic_fmt::hf99aac1e278ac2e5 Oct 11 15:53:10.438 INFO blam! at libcore/panicking.rs:77 Oct 11 15:53:10.438 INFO blam! 8: 0x55c0718e8eb3 - core::result::unwrap_failed::h25c40fa4f9680b82 Oct 11 15:53:10.438 INFO blam! at libcore/macros.rs:26 Oct 11 15:53:10.438 INFO blam! 9: 0x55c0718e6b43 - >::unwrap::h861dded04c3f588e Oct 11 15:53:10.438 INFO blam! at libcore/result.rs:808 Oct 11 15:53:10.438 INFO blam! 10: 0x55c0718bc759 - lib::test_exchange_code_successful_with_minimal_json_response::hc3008ab92f1d3afb Oct 11 15:53:10.438 INFO blam! at tests/lib.rs:205 Oct 11 15:53:10.438 INFO blam! 11: 0x55c0718bc279 - lib::test_exchange_code_successful_with_minimal_json_response::{{closure}}::h6343e25ace3effe0 Oct 11 15:53:10.438 INFO blam! at tests/lib.rs:187 Oct 11 15:53:10.438 INFO blam! 12: 0x55c0719264cd - core::ops::function::FnOnce::call_once::h979677f0b637017b Oct 11 15:53:10.438 INFO blam! at libcore/ops/function.rs:238 Oct 11 15:53:10.438 INFO blam! 13: 0x55c07193025e - >::call_box::h95b7cb918af67b5d Oct 11 15:53:10.438 INFO blam! at libtest/lib.rs:1468 Oct 11 15:53:10.438 INFO blam! at libcore/ops/function.rs:238 Oct 11 15:53:10.438 INFO blam! at liballoc/boxed.rs:672 Oct 11 15:53:10.438 INFO blam! 14: 0x55c071c486c9 - __rust_maybe_catch_panic Oct 11 15:53:10.438 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 15:53:10.438 INFO blam! 15: 0x55c071950dad - std::sys_common::backtrace::__rust_begin_short_backtrace::he1120aab928e481f Oct 11 15:53:10.438 INFO blam! at libstd/panicking.rs:289 Oct 11 15:53:10.438 INFO blam! at libstd/panic.rs:392 Oct 11 15:53:10.438 INFO blam! at libtest/lib.rs:1423 Oct 11 15:53:10.438 INFO blam! at libstd/sys_common/backtrace.rs:136 Oct 11 15:53:10.438 INFO blam! 16: 0x55c0719519b4 - std::panicking::try::do_call::ha990a345054c2d63 Oct 11 15:53:10.438 INFO blam! at libstd/thread/mod.rs:409 Oct 11 15:53:10.438 INFO blam! at libstd/panic.rs:313 Oct 11 15:53:10.438 INFO blam! at libstd/panicking.rs:310 Oct 11 15:53:10.438 INFO blam! 17: 0x55c071c486c9 - __rust_maybe_catch_panic Oct 11 15:53:10.438 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 15:53:10.438 INFO blam! 18: 0x55c07193ef76 - >::call_box::h96125cb29a9ba44b Oct 11 15:53:10.438 INFO blam! at libstd/panicking.rs:289 Oct 11 15:53:10.438 INFO blam! at libstd/panic.rs:392 Oct 11 15:53:10.438 INFO blam! at libstd/thread/mod.rs:408 Oct 11 15:53:10.438 INFO blam! at liballoc/boxed.rs:672 Oct 11 15:53:10.438 INFO blam! 19: 0x55c071c3626a - std::sys_common::thread::start_thread::h97c4c5d82028f6b1 Oct 11 15:53:10.438 INFO blam! at liballoc/boxed.rs:682 Oct 11 15:53:10.438 INFO blam! at libstd/sys_common/thread.rs:24 Oct 11 15:53:10.438 INFO blam! 20: 0x55c071c28a95 - std::sys::unix::thread::Thread::new::thread_start::he7d65efc4dd16886 Oct 11 15:53:10.438 INFO blam! at libstd/sys/unix/thread.rs:90 Oct 11 15:53:10.438 INFO blam! 21: 0x7f9a309596b9 - start_thread Oct 11 15:53:10.438 INFO blam! 22: 0x7f9a3047941c - clone Oct 11 15:53:10.438 INFO blam! 23: 0x0 - Oct 11 15:53:10.438 INFO blam! Oct 11 15:53:10.438 INFO blam! ---- test_exchange_refresh_token_with_basic_auth stdout ---- Oct 11 15:53:10.438 INFO blam! thread 'test_exchange_refresh_token_with_basic_auth' panicked at 'assertion failed: `(left == right)` Oct 11 15:53:10.438 INFO blam! left: `1`, Oct 11 15:53:10.438 INFO blam! right: `0`: Oct 11 15:53:10.438 INFO blam! Expected 1 request(s) to: Oct 11 15:53:10.438 INFO blam! Oct 11 15:53:10.438 INFO blam! POST /token Oct 11 15:53:10.438 INFO blam! accept: application/json Oct 11 15:53:10.438 INFO blam! authorization: Basic YWFhOmJiYg== Oct 11 15:53:10.438 INFO blam! grant_type=refresh_token&refresh_token=ccc Oct 11 15:53:10.438 INFO blam! Oct 11 15:53:10.438 INFO blam! ...but received 0 Oct 11 15:53:10.438 INFO blam! Oct 11 15:53:10.438 INFO blam! ', /cargo-home/registry/src/github.com-1ecc6299db9ec823/mockito-0.8.2/src/lib.rs:634:44 Oct 11 15:53:10.438 INFO blam! stack backtrace: Oct 11 15:53:10.439 INFO blam! 0: 0x55c071c33d2e - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h52ace5b3d4e95617 Oct 11 15:53:10.439 INFO blam! at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Oct 11 15:53:10.439 INFO blam! 1: 0x55c071c3d4f6 - std::sys_common::backtrace::print::h6cfc8a66009c1cc9 Oct 11 15:53:10.439 INFO blam! at libstd/sys_common/backtrace.rs:71 Oct 11 15:53:10.439 INFO blam! at libstd/sys_common/backtrace.rs:59 Oct 11 15:53:10.439 INFO blam! 2: 0x55c071c3803d - std::panicking::default_hook::{{closure}}::h47bedf778bf88480 Oct 11 15:53:10.439 INFO blam! at libstd/panicking.rs:211 Oct 11 15:53:10.439 INFO blam! 3: 0x55c071c37d4b - std::panicking::default_hook::h1ef46fa7cd894809 Oct 11 15:53:10.439 INFO blam! at libstd/panicking.rs:221 Oct 11 15:53:10.439 INFO blam! 4: 0x55c071c386ec - std::panicking::rust_panic_with_hook::h05510fde8841c579 Oct 11 15:53:10.439 INFO blam! at libstd/panicking.rs:476 Oct 11 15:53:10.439 INFO blam! 5: 0x55c071c382a9 - std::panicking::continue_panic_fmt::h6e11f50e47f94b00 Oct 11 15:53:10.439 INFO blam! at libstd/panicking.rs:390 Oct 11 15:53:10.439 INFO blam! 6: 0x55c071c3820d - std::panicking::begin_panic_fmt::h0063f49bf5a35411 Oct 11 15:53:10.439 INFO blam! at libstd/panicking.rs:345 Oct 11 15:53:10.439 INFO blam! 7: 0x55c071a89085 - mockito::Mock::assert::h42e34bc91afa96a3 Oct 11 15:53:10.439 INFO blam! at /cargo-home/registry/src/github.com-1ecc6299db9ec823/mockito-0.8.2/src/lib.rs:634 Oct 11 15:53:10.439 INFO blam! 8: 0x55c0718c0330 - lib::test_exchange_refresh_token_with_basic_auth::hc12cf749cd437743 Oct 11 15:53:10.439 INFO blam! at tests/lib.rs:353 Oct 11 15:53:10.439 INFO blam! 9: 0x55c0718c00e9 - lib::test_exchange_refresh_token_with_basic_auth::{{closure}}::ha7f6a4e34f526eca Oct 11 15:53:10.439 INFO blam! at tests/lib.rs:338 Oct 11 15:53:10.439 INFO blam! 10: 0x55c071925fbd - core::ops::function::FnOnce::call_once::h2c0d00074810ed6f Oct 11 15:53:10.439 INFO blam! at libcore/ops/function.rs:238 Oct 11 15:53:10.439 INFO blam! 11: 0x55c07193025e - >::call_box::h95b7cb918af67b5d Oct 11 15:53:10.439 INFO blam! at libtest/lib.rs:1468 Oct 11 15:53:10.439 INFO blam! at libcore/ops/function.rs:238 Oct 11 15:53:10.439 INFO blam! at liballoc/boxed.rs:672 Oct 11 15:53:10.439 INFO blam! 12: 0x55c071c486c9 - __rust_maybe_catch_panic Oct 11 15:53:10.439 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 15:53:10.439 INFO blam! 13: 0x55c071950dad - std::sys_common::backtrace::__rust_begin_short_backtrace::he1120aab928e481f Oct 11 15:53:10.439 INFO blam! at libstd/panicking.rs:289 Oct 11 15:53:10.439 INFO blam! at libstd/panic.rs:392 Oct 11 15:53:10.439 INFO blam! at libtest/lib.rs:1423 Oct 11 15:53:10.439 INFO blam! at libstd/sys_common/backtrace.rs:136 Oct 11 15:53:10.439 INFO blam! 14: 0x55c0719519b4 - std::panicking::try::do_call::ha990a345054c2d63 Oct 11 15:53:10.439 INFO blam! at libstd/thread/mod.rs:409 Oct 11 15:53:10.439 INFO blam! at libstd/panic.rs:313 Oct 11 15:53:10.439 INFO blam! at libstd/panicking.rs:310 Oct 11 15:53:10.439 INFO blam! 15: 0x55c071c486c9 - __rust_maybe_catch_panic Oct 11 15:53:10.439 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 15:53:10.439 INFO blam! 16: 0x55c07193ef76 - >::call_box::h96125cb29a9ba44b Oct 11 15:53:10.439 INFO blam! at libstd/panicking.rs:289 Oct 11 15:53:10.439 INFO blam! at libstd/panic.rs:392 Oct 11 15:53:10.439 INFO blam! at libstd/thread/mod.rs:408 Oct 11 15:53:10.439 INFO blam! at liballoc/boxed.rs:672 Oct 11 15:53:10.439 INFO blam! 17: 0x55c071c3626a - std::sys_common::thread::start_thread::h97c4c5d82028f6b1 Oct 11 15:53:10.439 INFO blam! at liballoc/boxed.rs:682 Oct 11 15:53:10.439 INFO blam! at libstd/sys_common/thread.rs:24 Oct 11 15:53:10.439 INFO blam! 18: 0x55c071c28a95 - std::sys::unix::thread::Thread::new::thread_start::he7d65efc4dd16886 Oct 11 15:53:10.439 INFO blam! at libstd/sys/unix/thread.rs:90 Oct 11 15:53:10.439 INFO blam! 19: 0x7f9a309596b9 - start_thread Oct 11 15:53:10.439 INFO blam! 20: 0x7f9a3047941c - clone Oct 11 15:53:10.439 INFO blam! 21: 0x0 - Oct 11 15:53:10.439 INFO blam! Oct 11 15:53:10.439 INFO blam! ---- test_exchange_refresh_token_with_json_response stdout ---- Oct 11 15:53:10.439 INFO blam! thread 'test_exchange_refresh_token_with_json_response' panicked at 'assertion failed: `(left == right)` Oct 11 15:53:10.439 INFO blam! left: `1`, Oct 11 15:53:10.439 INFO blam! right: `2`: Oct 11 15:53:10.439 INFO blam! Expected 1 request(s) to: Oct 11 15:53:10.439 INFO blam! Oct 11 15:53:10.439 INFO blam! POST /token Oct 11 15:53:10.439 INFO blam! accept: application/json Oct 11 15:53:10.439 INFO blam! authorization: Basic YWFhOmJiYg== Oct 11 15:53:10.439 INFO blam! grant_type=refresh_token&refresh_token=ccc Oct 11 15:53:10.439 INFO blam! Oct 11 15:53:10.439 INFO blam! ...but received 2 Oct 11 15:53:10.439 INFO blam! Oct 11 15:53:10.439 INFO blam! ', /cargo-home/registry/src/github.com-1ecc6299db9ec823/mockito-0.8.2/src/lib.rs:634:44 Oct 11 15:53:10.439 INFO blam! stack backtrace: Oct 11 15:53:10.439 INFO blam! 0: 0x55c071c33d2e - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h52ace5b3d4e95617 Oct 11 15:53:10.439 INFO blam! at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Oct 11 15:53:10.439 INFO blam! 1: 0x55c071c3d4f6 - std::sys_common::backtrace::print::h6cfc8a66009c1cc9 Oct 11 15:53:10.439 INFO blam! at libstd/sys_common/backtrace.rs:71 Oct 11 15:53:10.439 INFO blam! at libstd/sys_common/backtrace.rs:59 Oct 11 15:53:10.439 INFO blam! 2: 0x55c071c3803d - std::panicking::default_hook::{{closure}}::h47bedf778bf88480 Oct 11 15:53:10.439 INFO blam! at libstd/panicking.rs:211 Oct 11 15:53:10.439 INFO blam! 3: 0x55c071c37d4b - std::panicking::default_hook::h1ef46fa7cd894809 Oct 11 15:53:10.439 INFO blam! at libstd/panicking.rs:221 Oct 11 15:53:10.439 INFO blam! 4: 0x55c071c386ec - std::panicking::rust_panic_with_hook::h05510fde8841c579 Oct 11 15:53:10.439 INFO blam! at libstd/panicking.rs:476 Oct 11 15:53:10.439 INFO blam! 5: 0x55c071c382a9 - std::panicking::continue_panic_fmt::h6e11f50e47f94b00 Oct 11 15:53:10.439 INFO blam! at libstd/panicking.rs:390 Oct 11 15:53:10.439 INFO blam! 6: 0x55c071c3820d - std::panicking::begin_panic_fmt::h0063f49bf5a35411 Oct 11 15:53:10.439 INFO blam! at libstd/panicking.rs:345 Oct 11 15:53:10.439 INFO blam! 7: 0x55c071a89085 - mockito::Mock::assert::h42e34bc91afa96a3 Oct 11 15:53:10.439 INFO blam! at /cargo-home/registry/src/github.com-1ecc6299db9ec823/mockito-0.8.2/src/lib.rs:634 Oct 11 15:53:10.439 INFO blam! 8: 0x55c0718c105c - lib::test_exchange_refresh_token_with_json_response::h44e688d94e905cb2 Oct 11 15:53:10.440 INFO blam! at tests/lib.rs:386 Oct 11 15:53:10.440 INFO blam! 9: 0x55c0718c0df9 - lib::test_exchange_refresh_token_with_json_response::{{closure}}::h61cc987efae1ecd6 Oct 11 15:53:10.440 INFO blam! at tests/lib.rs:369 Oct 11 15:53:10.440 INFO blam! 10: 0x55c0719268fd - core::ops::function::FnOnce::call_once::hf86514b6f224c147 Oct 11 15:53:10.440 INFO blam! at libcore/ops/function.rs:238 Oct 11 15:53:10.440 INFO blam! 11: 0x55c07193025e - >::call_box::h95b7cb918af67b5d Oct 11 15:53:10.440 INFO blam! at libtest/lib.rs:1468 Oct 11 15:53:10.440 INFO blam! at libcore/ops/function.rs:238 Oct 11 15:53:10.440 INFO blam! at liballoc/boxed.rs:672 Oct 11 15:53:10.440 INFO blam! 12: 0x55c071c486c9 - __rust_maybe_catch_panic Oct 11 15:53:10.440 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 15:53:10.440 INFO blam! 13: 0x55c071950dad - std::sys_common::backtrace::__rust_begin_short_backtrace::he1120aab928e481f Oct 11 15:53:10.440 INFO blam! at libstd/panicking.rs:289 Oct 11 15:53:10.440 INFO blam! at libstd/panic.rs:392 Oct 11 15:53:10.440 INFO blam! at libtest/lib.rs:1423 Oct 11 15:53:10.440 INFO blam! at libstd/sys_common/backtrace.rs:136 Oct 11 15:53:10.440 INFO blam! 14: 0x55c0719519b4 - std::panicking::try::do_call::ha990a345054c2d63 Oct 11 15:53:10.440 INFO blam! at libstd/thread/mod.rs:409 Oct 11 15:53:10.440 INFO blam! at libstd/panic.rs:313 Oct 11 15:53:10.440 INFO blam! at libstd/panicking.rs:310 Oct 11 15:53:10.440 INFO blam! 15: 0x55c071c486c9 - __rust_maybe_catch_panic Oct 11 15:53:10.440 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 15:53:10.440 INFO blam! 16: 0x55c07193ef76 - >::call_box::h96125cb29a9ba44b Oct 11 15:53:10.440 INFO blam! at libstd/panicking.rs:289 Oct 11 15:53:10.440 INFO blam! at libstd/panic.rs:392 Oct 11 15:53:10.440 INFO blam! at libstd/thread/mod.rs:408 Oct 11 15:53:10.440 INFO blam! at liballoc/boxed.rs:672 Oct 11 15:53:10.440 INFO blam! 17: 0x55c071c3626a - std::sys_common::thread::start_thread::h97c4c5d82028f6b1 Oct 11 15:53:10.440 INFO blam! at liballoc/boxed.rs:682 Oct 11 15:53:10.440 INFO blam! at libstd/sys_common/thread.rs:24 Oct 11 15:53:10.440 INFO blam! 18: 0x55c071c28a95 - std::sys::unix::thread::Thread::new::thread_start::he7d65efc4dd16886 Oct 11 15:53:10.451 INFO blam! at libstd/sys/unix/thread.rs:90 Oct 11 15:53:10.451 INFO blam! 19: 0x7f9a309596b9 - start_thread Oct 11 15:53:10.451 INFO blam! 20: 0x7f9a3047941c - clone Oct 11 15:53:10.451 INFO blam! 21: 0x0 - Oct 11 15:53:10.451 INFO blam! Oct 11 15:53:10.451 INFO blam! ---- test_exchange_code_with_400_status_code stdout ---- Oct 11 15:53:10.451 INFO blam! thread 'test_exchange_code_with_400_status_code' panicked at 'assertion failed: `(left == right)` Oct 11 15:53:10.451 INFO blam! left: `1`, Oct 11 15:53:10.451 INFO blam! right: `2`: Oct 11 15:53:10.451 INFO blam! Expected 1 request(s) to: Oct 11 15:53:10.451 INFO blam! Oct 11 15:53:10.451 INFO blam! POST /token Oct 11 15:53:10.451 INFO blam! accept: application/json Oct 11 15:53:10.451 INFO blam! authorization: Basic YWFhOmJiYg== Oct 11 15:53:10.451 INFO blam! grant_type=authorization_code&code=ccc Oct 11 15:53:10.451 INFO blam! Oct 11 15:53:10.451 INFO blam! ...but received 2 Oct 11 15:53:10.451 INFO blam! Oct 11 15:53:10.451 INFO blam! ', /cargo-home/registry/src/github.com-1ecc6299db9ec823/mockito-0.8.2/src/lib.rs:634:44 Oct 11 15:53:10.451 INFO blam! stack backtrace: Oct 11 15:53:10.452 INFO blam! 0: 0x55c071c33d2e - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h52ace5b3d4e95617 Oct 11 15:53:10.452 INFO blam! at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Oct 11 15:53:10.452 INFO blam! 1: 0x55c071c3d4f6 - std::sys_common::backtrace::print::h6cfc8a66009c1cc9 Oct 11 15:53:10.452 INFO blam! at libstd/sys_common/backtrace.rs:71 Oct 11 15:53:10.452 INFO blam! at libstd/sys_common/backtrace.rs:59 Oct 11 15:53:10.452 INFO blam! 2: 0x55c071c3803d - std::panicking::default_hook::{{closure}}::h47bedf778bf88480 Oct 11 15:53:10.452 INFO blam! at libstd/panicking.rs:211 Oct 11 15:53:10.452 INFO blam! 3: 0x55c071c37d4b - std::panicking::default_hook::h1ef46fa7cd894809 Oct 11 15:53:10.452 INFO blam! at libstd/panicking.rs:221 Oct 11 15:53:10.452 INFO blam! 4: 0x55c071c386ec - std::panicking::rust_panic_with_hook::h05510fde8841c579 Oct 11 15:53:10.452 INFO blam! at libstd/panicking.rs:476 Oct 11 15:53:10.452 INFO blam! 5: 0x55c071c382a9 - std::panicking::continue_panic_fmt::h6e11f50e47f94b00 Oct 11 15:53:10.452 INFO blam! at libstd/panicking.rs:390 Oct 11 15:53:10.452 INFO blam! 6: 0x55c071c3820d - std::panicking::begin_panic_fmt::h0063f49bf5a35411 Oct 11 15:53:10.452 INFO blam! at libstd/panicking.rs:345 Oct 11 15:53:10.452 INFO blam! 7: 0x55c071a89085 - mockito::Mock::assert::h42e34bc91afa96a3 Oct 11 15:53:10.452 INFO blam! at /cargo-home/registry/src/github.com-1ecc6299db9ec823/mockito-0.8.2/src/lib.rs:634 Oct 11 15:53:10.452 INFO blam! 8: 0x55c0718c88c0 - lib::test_exchange_code_with_400_status_code::h110c1bf1bdcdb2c1 Oct 11 15:53:10.452 INFO blam! at tests/lib.rs:694 Oct 11 15:53:10.452 INFO blam! 9: 0x55c0718c8639 - lib::test_exchange_code_with_400_status_code::{{closure}}::h6928b3d155708a38 Oct 11 15:53:10.452 INFO blam! at tests/lib.rs:680 Oct 11 15:53:10.452 INFO blam! 10: 0x55c0719268bd - core::ops::function::FnOnce::call_once::hdfc9d99d93b48907 Oct 11 15:53:10.452 INFO blam! at libcore/ops/function.rs:238 Oct 11 15:53:10.452 INFO blam! 11: 0x55c07193025e - >::call_box::h95b7cb918af67b5d Oct 11 15:53:10.452 INFO blam! at libtest/lib.rs:1468 Oct 11 15:53:10.452 INFO blam! at libcore/ops/function.rs:238 Oct 11 15:53:10.452 INFO blam! at liballoc/boxed.rs:672 Oct 11 15:53:10.452 INFO blam! 12: 0x55c071c486c9 - __rust_maybe_catch_panic Oct 11 15:53:10.452 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 15:53:10.452 INFO blam! 13: 0x55c071950dad - std::sys_common::backtrace::__rust_begin_short_backtrace::he1120aab928e481f Oct 11 15:53:10.452 INFO blam! at libstd/panicking.rs:289 Oct 11 15:53:10.452 INFO blam! at libstd/panic.rs:392 Oct 11 15:53:10.452 INFO blam! at libtest/lib.rs:1423 Oct 11 15:53:10.452 INFO blam! at libstd/sys_common/backtrace.rs:136 Oct 11 15:53:10.452 INFO blam! 14: 0x55c0719519b4 - std::panicking::try::do_call::ha990a345054c2d63 Oct 11 15:53:10.452 INFO blam! at libstd/thread/mod.rs:409 Oct 11 15:53:10.452 INFO blam! at libstd/panic.rs:313 Oct 11 15:53:10.452 INFO blam! at libstd/panicking.rs:310 Oct 11 15:53:10.452 INFO blam! 15: 0x55c071c486c9 - __rust_maybe_catch_panic Oct 11 15:53:10.452 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 15:53:10.452 INFO blam! 16: 0x55c07193ef76 - >::call_box::h96125cb29a9ba44b Oct 11 15:53:10.452 INFO blam! at libstd/panicking.rs:289 Oct 11 15:53:10.452 INFO blam! at libstd/panic.rs:392 Oct 11 15:53:10.452 INFO blam! at libstd/thread/mod.rs:408 Oct 11 15:53:10.452 INFO blam! at liballoc/boxed.rs:672 Oct 11 15:53:10.452 INFO blam! 17: 0x55c071c3626a - std::sys_common::thread::start_thread::h97c4c5d82028f6b1 Oct 11 15:53:10.452 INFO blam! at liballoc/boxed.rs:682 Oct 11 15:53:10.452 INFO blam! at libstd/sys_common/thread.rs:24 Oct 11 15:53:10.452 INFO blam! 18: 0x55c071c28a95 - std::sys::unix::thread::Thread::new::thread_start::he7d65efc4dd16886 Oct 11 15:53:10.452 INFO blam! at libstd/sys/unix/thread.rs:90 Oct 11 15:53:10.452 INFO blam! 19: 0x7f9a309596b9 - start_thread Oct 11 15:53:10.452 INFO blam! 20: 0x7f9a3047941c - clone Oct 11 15:53:10.452 INFO blam! 21: 0x0 - Oct 11 15:53:10.452 INFO blam! Oct 11 15:53:10.452 INFO blam! Oct 11 15:53:10.452 INFO blam! failures: Oct 11 15:53:10.452 INFO blam! test_exchange_code_successful_with_minimal_json_response Oct 11 15:53:10.452 INFO blam! test_exchange_code_with_400_status_code Oct 11 15:53:10.452 INFO blam! test_exchange_refresh_token_with_basic_auth Oct 11 15:53:10.452 INFO blam! test_exchange_refresh_token_with_json_response Oct 11 15:53:10.452 INFO blam! Oct 11 15:53:10.452 INFO blam! test result: FAILED. 24 passed; 4 failed; 0 ignored; 0 measured; 0 filtered out Oct 11 15:53:10.452 INFO blam! Oct 11 15:53:10.457 INFO kablam! error: test failed, to rerun pass '--test lib' Oct 11 15:53:10.464 INFO kablam! su: No module specific data is present Oct 11 15:53:11.082 INFO running `"docker" "rm" "-f" "c26839ccc44730baa8ef7e891d2933f0c28d84bfef6a11d07becbfe8a54bf286"` Oct 11 15:53:11.536 INFO blam! c26839ccc44730baa8ef7e891d2933f0c28d84bfef6a11d07becbfe8a54bf286