Dec 06 23:44:46.688 INFO testing scram-0.4.0 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 06 23:44:46.689 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 23:44:47.026 INFO [stdout] d048c0d498b73e7f4f2026cff13611a825c0fce23fc4c67214c312fd88943533
Dec 06 23:44:47.028 INFO running `"docker" "start" "-a" "d048c0d498b73e7f4f2026cff13611a825c0fce23fc4c67214c312fd88943533"`
Dec 06 23:44:48.420 INFO [stderr] usermod: no changes
Dec 06 23:44:48.532 INFO [stderr]    Compiling scram v0.4.0 (/source)
Dec 06 23:44:50.500 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.03s
Dec 06 23:44:50.500 INFO [stderr] su: No module specific data is present
Dec 06 23:44:51.092 INFO running `"docker" "inspect" "d048c0d498b73e7f4f2026cff13611a825c0fce23fc4c67214c312fd88943533"`
Dec 06 23:44:51.298 INFO running `"docker" "rm" "-f" "d048c0d498b73e7f4f2026cff13611a825c0fce23fc4c67214c312fd88943533"`
Dec 06 23:44:51.566 INFO [stdout] d048c0d498b73e7f4f2026cff13611a825c0fce23fc4c67214c312fd88943533
Dec 06 23:44:51.572 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 23:44:52.027 INFO [stdout] 6a0b32623c422b31d657ac5362ccf4bb6c698b0e8b022952b93673a80adbaf9c
Dec 06 23:44:52.071 INFO running `"docker" "start" "-a" "6a0b32623c422b31d657ac5362ccf4bb6c698b0e8b022952b93673a80adbaf9c"`
Dec 06 23:44:53.172 INFO [stderr] usermod: no changes
Dec 06 23:44:53.231 INFO [stderr]    Compiling scram v0.4.0 (/source)
Dec 06 23:44:55.956 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.75s
Dec 06 23:44:55.960 INFO [stderr] su: No module specific data is present
Dec 06 23:44:56.436 INFO running `"docker" "inspect" "6a0b32623c422b31d657ac5362ccf4bb6c698b0e8b022952b93673a80adbaf9c"`
Dec 06 23:44:56.670 INFO running `"docker" "rm" "-f" "6a0b32623c422b31d657ac5362ccf4bb6c698b0e8b022952b93673a80adbaf9c"`
Dec 06 23:44:56.965 INFO [stdout] 6a0b32623c422b31d657ac5362ccf4bb6c698b0e8b022952b93673a80adbaf9c
Dec 06 23:44:56.974 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 23:44:57.483 INFO [stdout] 2ae5be6ce3d12a6e7635d1ae11392ec63811c08bbb5d8f84be76d44de8773d14
Dec 06 23:44:57.485 INFO running `"docker" "start" "-a" "2ae5be6ce3d12a6e7635d1ae11392ec63811c08bbb5d8f84be76d44de8773d14"`
Dec 06 23:44:58.595 INFO [stderr] usermod: no changes
Dec 06 23:44:58.680 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.04s
Dec 06 23:44:58.696 INFO [stderr]      Running /target/debug/deps/scram-1c8dc7dcd1b485ce
Dec 06 23:44:58.704 INFO [stdout] 
Dec 06 23:44:58.704 INFO [stdout] running 5 tests
Dec 06 23:44:58.704 INFO [stdout] test server::tests::test_parse_client_first_invalid_data ... ok
Dec 06 23:44:58.704 INFO [stdout] test server::tests::test_parse_client_first_missing_fields ... ok
Dec 06 23:44:58.704 INFO [stdout] test server::tests::test_parse_client_first_success ... ok
Dec 06 23:44:58.704 INFO [stdout] test server::tests::test_parse_client_final_success ... ok
Dec 06 23:44:58.704 INFO [stdout] test server::tests::test_parse_client_final_missing_fields ... ok
Dec 06 23:44:58.704 INFO [stdout] 
Dec 06 23:44:58.704 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 23:44:58.704 INFO [stdout] 
Dec 06 23:44:58.704 INFO [stderr]      Running /target/debug/deps/client_server-1afa47590288213e
Dec 06 23:44:58.712 INFO [stdout] 
Dec 06 23:44:58.712 INFO [stdout] running 8 tests
Dec 06 23:44:59.299 INFO [stdout] test test_empty_username ... ok
Dec 06 23:44:59.321 INFO [stdout] test test_invalid_user ... ok
Dec 06 23:44:59.327 INFO [stdout] test test_simple_success ... ok
Dec 06 23:44:59.345 INFO [stdout] test test_authorize_fail ... ok
Dec 06 23:44:59.371 INFO [stdout] test test_bad_password ... ok
Dec 06 23:44:59.388 INFO [stdout] test test_authorize_non_existent ... ok
Dec 06 23:44:59.388 INFO [stderr]    Doc-tests scram
Dec 06 23:44:59.388 INFO [stdout] test test_empty_password ... ok
Dec 06 23:44:59.388 INFO [stdout] test test_authorize_different ... ok
Dec 06 23:44:59.388 INFO [stdout] 
Dec 06 23:44:59.388 INFO [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 23:44:59.388 INFO [stdout] 
Dec 06 23:45:01.065 INFO [stdout] 
Dec 06 23:45:01.065 INFO [stdout] running 2 tests
Dec 06 23:45:03.512 INFO [stdout] test src/lib.rs -  (line 28) ... ok
Dec 06 23:45:03.820 INFO [stdout] test src/lib.rs -  (line 81) ... ok
Dec 06 23:45:03.820 INFO [stdout] 
Dec 06 23:45:03.820 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 23:45:03.820 INFO [stdout] 
Dec 06 23:45:03.830 INFO [stderr] su: No module specific data is present
Dec 06 23:45:04.698 INFO running `"docker" "inspect" "2ae5be6ce3d12a6e7635d1ae11392ec63811c08bbb5d8f84be76d44de8773d14"`
Dec 06 23:45:04.962 INFO running `"docker" "rm" "-f" "2ae5be6ce3d12a6e7635d1ae11392ec63811c08bbb5d8f84be76d44de8773d14"`
Dec 06 23:45:05.328 INFO [stdout] 2ae5be6ce3d12a6e7635d1ae11392ec63811c08bbb5d8f84be76d44de8773d14