[INFO] crate scram 0.4.0 is already in cache
[INFO] extracting crate scram 0.4.0 into work/ex/beta-1.37-6/sources/1.36.0/reg/scram/0.4.0
[INFO] extracting crate scram 0.4.0 into work/ex/beta-1.37-6/sources/beta-2019-07-23/reg/scram/0.4.0
[INFO] validating manifest of scram-0.4.0 on toolchain 1.36.0
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+1.36.0" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] validating manifest of scram-0.4.0 on toolchain beta-2019-07-23
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+beta-2019-07-23" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] started frobbing scram-0.4.0
[INFO] finished frobbing scram-0.4.0
[INFO] frobbed toml for scram-0.4.0 written to work/ex/beta-1.37-6/sources/1.36.0/reg/scram/0.4.0/Cargo.toml
[INFO] started frobbing scram-0.4.0
[INFO] finished frobbing scram-0.4.0
[INFO] frobbed toml for scram-0.4.0 written to work/ex/beta-1.37-6/sources/beta-2019-07-23/reg/scram/0.4.0/Cargo.toml
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+1.36.0" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update"`
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+beta-2019-07-23" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update"`
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+1.36.0" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+beta-2019-07-23" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] testing scram-0.4.0 against 1.36.0 for beta-1.37-6
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.37-6/worker-0/1.36.0:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.37-6/sources/1.36.0/reg/scram/0.4.0:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+1.36.0" "build" "--frozen"`
[INFO] [stdout] ff1b9fc643d5501b80622484f0c70215ffcda49969892a234d20ee4019b99e02
[INFO] running `"docker" "start" "-a" "ff1b9fc643d5501b80622484f0c70215ffcda49969892a234d20ee4019b99e02"`
[INFO] [stderr]     Blocking waiting for file lock on package cache lock
[INFO] [stderr]    Compiling scram v0.4.0 (/opt/crater/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.54s
[INFO] running `"docker" "inspect" "ff1b9fc643d5501b80622484f0c70215ffcda49969892a234d20ee4019b99e02"`
[INFO] running `"docker" "rm" "-f" "ff1b9fc643d5501b80622484f0c70215ffcda49969892a234d20ee4019b99e02"`
[INFO] [stdout] ff1b9fc643d5501b80622484f0c70215ffcda49969892a234d20ee4019b99e02
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.37-6/worker-0/1.36.0:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.37-6/sources/1.36.0/reg/scram/0.4.0:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+1.36.0" "test" "--frozen" "--no-run"`
[INFO] [stdout] 35027658f50b009dbc5c9e23b355787fb762a6fd59327314c723a24e1ba9b392
[INFO] running `"docker" "start" "-a" "35027658f50b009dbc5c9e23b355787fb762a6fd59327314c723a24e1ba9b392"`
[INFO] [stderr]    Compiling scram v0.4.0 (/opt/crater/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.62s
[INFO] running `"docker" "inspect" "35027658f50b009dbc5c9e23b355787fb762a6fd59327314c723a24e1ba9b392"`
[INFO] running `"docker" "rm" "-f" "35027658f50b009dbc5c9e23b355787fb762a6fd59327314c723a24e1ba9b392"`
[INFO] [stdout] 35027658f50b009dbc5c9e23b355787fb762a6fd59327314c723a24e1ba9b392
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.37-6/worker-0/1.36.0:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.37-6/sources/1.36.0/reg/scram/0.4.0:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+1.36.0" "test" "--frozen"`
[INFO] [stdout] 1c95a1dacbcbf8b794caf1c66b8b1635459b484de066fa48ad311ee1f46899f0
[INFO] running `"docker" "start" "-a" "1c95a1dacbcbf8b794caf1c66b8b1635459b484de066fa48ad311ee1f46899f0"`
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.03s
[INFO] [stderr]      Running /opt/crater/target/debug/deps/scram-78d4b84e23528a57
[INFO] [stderr]      Running /opt/crater/target/debug/deps/client_server-85a4609f583da805
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test server::tests::test_parse_client_first_invalid_data ... ok
[INFO] [stdout] test server::tests::test_parse_client_final_success ... ok
[INFO] [stdout] test server::tests::test_parse_client_first_missing_fields ... ok
[INFO] [stdout] test server::tests::test_parse_client_final_missing_fields ... ok
[INFO] [stdout] test server::tests::test_parse_client_first_success ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test test_invalid_user ... ok
[INFO] [stdout] test test_empty_password ... ok
[INFO] [stdout] test test_empty_username ... ok
[INFO] [stdout] test test_simple_success ... ok
[INFO] [stdout] test test_authorize_fail ... ok
[INFO] [stdout] test test_authorize_different ... ok
[INFO] [stdout] test test_bad_password ... ok
[INFO] [stdout] test test_authorize_non_existent ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests scram
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test src/lib.rs -  (line 81) ... ok
[INFO] [stdout] test src/lib.rs -  (line 28) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] running `"docker" "inspect" "1c95a1dacbcbf8b794caf1c66b8b1635459b484de066fa48ad311ee1f46899f0"`
[INFO] running `"docker" "rm" "-f" "1c95a1dacbcbf8b794caf1c66b8b1635459b484de066fa48ad311ee1f46899f0"`
[INFO] [stdout] 1c95a1dacbcbf8b794caf1c66b8b1635459b484de066fa48ad311ee1f46899f0