Dec 06 23:38:34.208 INFO testing secure-session-0.3.1 against try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468 for pr-56514
Dec 06 23:38:34.208 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 23:38:34.396 INFO [stdout] bcc94d707e654caec53af2234536c0fbe2010ef9a3b30dab5fb9452b9f59c68a
Dec 06 23:38:34.402 INFO running `"docker" "start" "-a" "bcc94d707e654caec53af2234536c0fbe2010ef9a3b30dab5fb9452b9f59c68a"`
Dec 06 23:38:35.059 INFO [stderr] usermod: no changes
Dec 06 23:38:35.324 INFO [stderr]    Compiling cookie v0.10.1
Dec 06 23:38:37.152 INFO [stderr]    Compiling secure-session v0.3.1 (/source)
Dec 06 23:38:40.388 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 5.30s
Dec 06 23:38:40.404 INFO [stderr] su: No module specific data is present
Dec 06 23:38:41.216 INFO running `"docker" "inspect" "bcc94d707e654caec53af2234536c0fbe2010ef9a3b30dab5fb9452b9f59c68a"`
Dec 06 23:38:41.472 INFO running `"docker" "rm" "-f" "bcc94d707e654caec53af2234536c0fbe2010ef9a3b30dab5fb9452b9f59c68a"`
Dec 06 23:38:41.777 INFO [stdout] bcc94d707e654caec53af2234536c0fbe2010ef9a3b30dab5fb9452b9f59c68a
Dec 06 23:38:41.782 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 23:38:42.361 INFO [stdout] 826440760d1bf422b3d133f5297edb1f8a7d90d9352cd172fede1167ffe15c5e
Dec 06 23:38:42.363 INFO running `"docker" "start" "-a" "826440760d1bf422b3d133f5297edb1f8a7d90d9352cd172fede1167ffe15c5e"`
Dec 06 23:38:43.876 INFO [stderr] usermod: no changes
Dec 06 23:38:44.051 INFO [stderr]    Compiling iron-test v0.6.0
Dec 06 23:38:47.160 INFO [stderr]    Compiling secure-session v0.3.1 (/source)
Dec 06 23:38:54.748 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 10.83s
Dec 06 23:38:54.756 INFO [stderr] su: No module specific data is present
Dec 06 23:38:55.153 INFO running `"docker" "inspect" "826440760d1bf422b3d133f5297edb1f8a7d90d9352cd172fede1167ffe15c5e"`
Dec 06 23:38:55.290 INFO running `"docker" "rm" "-f" "826440760d1bf422b3d133f5297edb1f8a7d90d9352cd172fede1167ffe15c5e"`
Dec 06 23:38:55.404 INFO [stdout] 826440760d1bf422b3d133f5297edb1f8a7d90d9352cd172fede1167ffe15c5e
Dec 06 23:38:55.406 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 23:38:55.699 INFO [stdout] 24143abd0c9b43ec1d9b165764e26c5aab91dc5e7394d191e6e4be5c490be90c
Dec 06 23:38:55.702 INFO running `"docker" "start" "-a" "24143abd0c9b43ec1d9b165764e26c5aab91dc5e7394d191e6e4be5c490be90c"`
Dec 06 23:38:56.221 INFO [stderr] usermod: no changes
Dec 06 23:38:56.377 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.13s
Dec 06 23:38:56.381 INFO [stderr]      Running /target/debug/deps/secure_session-58d3d5df9b1ab4b3
Dec 06 23:38:56.386 INFO [stdout] 
Dec 06 23:38:56.386 INFO [stdout] running 19 tests
Dec 06 23:38:56.387 INFO [stdout] test session::tests::aesgcm::serde_bad_data_end ... ok
Dec 06 23:38:56.391 INFO [stdout] test middleware::tests::aesgcm::sessions_expire ... ok
Dec 06 23:38:56.391 INFO [stdout] test middleware::tests::multisession_and_rotation ... ok
Dec 06 23:38:56.391 INFO [stdout] test middleware::tests::chacha20poly1305::sessions_expire ... ok
Dec 06 23:38:56.391 INFO [stdout] test middleware::tests::chacha20poly1305::no_expiry ... ok
Dec 06 23:38:56.391 INFO [stdout] test middleware::tests::aesgcm::no_expiry ... ok
Dec 06 23:38:56.392 INFO [stdout] test session::tests::aesgcm::serde_happy_path ... ok
Dec 06 23:38:56.392 INFO [stdout] test session::tests::chacha20poly1305::serde_bad_data_end ... ok
Dec 06 23:38:56.392 INFO [stdout] test session::tests::multi::aesgcm_then_aesgcm::no_previous ... ok
Dec 06 23:38:56.393 INFO [stdout] test session::tests::aesgcm::serde_bad_data_start ... ok
Dec 06 23:38:56.393 INFO [stdout] test session::tests::chacha20poly1305::serde_bad_data_start ... ok
Dec 06 23:38:56.393 INFO [stdout] test session::tests::multi::aesgcm_then_chacha20poly1305::aesgcm_then_chacha20poly1305 ... ok
Dec 06 23:38:56.393 INFO [stdout] test session::tests::multi::aesgcm_then_aesgcm::aesgcm_then_aesgcm ... ok
Dec 06 23:38:56.394 INFO [stdout] test session::tests::chacha20poly1305::serde_happy_path ... ok
Dec 06 23:38:56.394 INFO [stdout] test session::tests::multi::aesgcm_then_chacha20poly1305::no_previous ... ok
Dec 06 23:38:56.397 INFO [stdout] test session::tests::multi::chacha20poly1305_then_chacha20poly1305::no_previous ... ok
Dec 06 23:38:56.397 INFO [stdout] test session::tests::multi::chacha20poly1305_then_chacha20poly1305::chacha20poly1305_then_chacha20poly1305 ... ok
Dec 06 23:38:56.397 INFO [stdout] test session::tests::multi::chacha20poly1305_then_aesgcm::chacha20poly1305_then_aesgcm ... ok
Dec 06 23:38:56.397 INFO [stdout] test session::tests::multi::chacha20poly1305_then_aesgcm::no_previous ... ok
Dec 06 23:38:56.397 INFO [stdout] 
Dec 06 23:38:56.397 INFO [stdout] test result: ok. 19 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 23:38:56.397 INFO [stdout] 
Dec 06 23:38:56.398 INFO [stderr]    Doc-tests secure_session
Dec 06 23:39:00.792 INFO [stdout] 
Dec 06 23:39:00.792 INFO [stdout] running 1 test
Dec 06 23:39:07.353 INFO [stdout] test src/lib.rs -  (line 8) ... ok
Dec 06 23:39:07.353 INFO [stdout] 
Dec 06 23:39:07.353 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 23:39:07.353 INFO [stdout] 
Dec 06 23:39:07.366 INFO [stderr] su: No module specific data is present
Dec 06 23:39:07.726 INFO running `"docker" "inspect" "24143abd0c9b43ec1d9b165764e26c5aab91dc5e7394d191e6e4be5c490be90c"`
Dec 06 23:39:07.836 INFO running `"docker" "rm" "-f" "24143abd0c9b43ec1d9b165764e26c5aab91dc5e7394d191e6e4be5c490be90c"`
Dec 06 23:39:07.972 INFO [stdout] 24143abd0c9b43ec1d9b165764e26c5aab91dc5e7394d191e6e4be5c490be90c