Nov 18 08:00:50.761 INFO testing keybob-0.3.1 against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 18 08:00:50.761 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-6/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 18 08:00:50.976 INFO [stdout] e375431da4eacbe882ca4c925eec8b578c76d743ec5a31d1ea1f17225d669c7c
Nov 18 08:00:50.976 INFO running `"docker" "start" "-a" "e375431da4eacbe882ca4c925eec8b578c76d743ec5a31d1ea1f17225d669c7c"`
Nov 18 08:00:51.509 INFO [stderr] usermod: no changes
Nov 18 08:00:51.633 INFO [stderr]    Compiling blake2 v0.7.1
Nov 18 08:00:51.634 INFO [stderr]    Compiling pbkdf2 v0.2.3
Nov 18 08:00:53.305 INFO [stderr]    Compiling keybob v0.3.1 (/source)
Nov 18 08:00:54.857 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.31s
Nov 18 08:00:54.866 INFO [stderr] su: No module specific data is present
Nov 18 08:00:55.341 INFO running `"docker" "inspect" "e375431da4eacbe882ca4c925eec8b578c76d743ec5a31d1ea1f17225d669c7c"`
Nov 18 08:00:55.597 INFO running `"docker" "rm" "-f" "e375431da4eacbe882ca4c925eec8b578c76d743ec5a31d1ea1f17225d669c7c"`
Nov 18 08:00:55.844 INFO [stdout] e375431da4eacbe882ca4c925eec8b578c76d743ec5a31d1ea1f17225d669c7c
Nov 18 08:00:55.846 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-6/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 18 08:00:56.267 INFO [stdout] 2b2716765f6b23c0f97255a0a7c649ac321f531511ded2f14f010eca7ddfad4e
Nov 18 08:00:56.276 INFO running `"docker" "start" "-a" "2b2716765f6b23c0f97255a0a7c649ac321f531511ded2f14f010eca7ddfad4e"`
Nov 18 08:00:56.899 INFO [stderr] usermod: no changes
Nov 18 08:00:57.039 INFO [stderr]    Compiling subtle v0.3.0
Nov 18 08:00:57.039 INFO [stderr]    Compiling dbl v0.1.0
Nov 18 08:00:57.039 INFO [stderr]    Compiling aes-soft v0.1.0
Nov 18 08:00:57.399 INFO [stderr]    Compiling cmac v0.1.0
Nov 18 08:00:57.399 INFO [stderr]    Compiling pmac v0.1.0
Nov 18 08:00:58.330 INFO [stderr]    Compiling aes v0.1.0
Nov 18 08:00:58.643 INFO [stderr]    Compiling miscreant v0.4.0-beta2
Nov 18 08:01:00.319 INFO [stderr]    Compiling keybob v0.3.1 (/source)
Nov 18 08:01:08.222 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 11.30s
Nov 18 08:01:08.227 INFO [stderr] su: No module specific data is present
Nov 18 08:01:08.782 INFO running `"docker" "inspect" "2b2716765f6b23c0f97255a0a7c649ac321f531511ded2f14f010eca7ddfad4e"`
Nov 18 08:01:09.066 INFO running `"docker" "rm" "-f" "2b2716765f6b23c0f97255a0a7c649ac321f531511ded2f14f010eca7ddfad4e"`
Nov 18 08:01:09.311 INFO [stdout] 2b2716765f6b23c0f97255a0a7c649ac321f531511ded2f14f010eca7ddfad4e
Nov 18 08:01:09.319 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-6/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 18 08:01:09.699 INFO [stdout] 21553a64e92cc70146f70834537091571729c62788705ec14c7e6f9c093dad62
Nov 18 08:01:09.701 INFO running `"docker" "start" "-a" "21553a64e92cc70146f70834537091571729c62788705ec14c7e6f9c093dad62"`
Nov 18 08:01:10.647 INFO [stderr] usermod: no changes
Nov 18 08:01:10.843 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.16s
Nov 18 08:01:10.859 INFO [stderr]      Running /target/debug/deps/keybob-bf92835c72263835
Nov 18 08:01:10.871 INFO [stderr]      Running /target/debug/deps/basic-4c3c8e803a587e90
Nov 18 08:01:10.871 INFO [stdout] 
Nov 18 08:01:10.871 INFO [stdout] running 0 tests
Nov 18 08:01:10.871 INFO [stdout] 
Nov 18 08:01:10.871 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 08:01:10.871 INFO [stdout] 
Nov 18 08:01:10.883 INFO [stdout] 
Nov 18 08:01:10.883 INFO [stdout] running 6 tests
Nov 18 08:01:10.891 INFO [stdout] test derivation::basic_128 ... ok
Nov 18 08:01:10.895 INFO [stdout] test derivation::basic_256 ... ok
Nov 18 08:01:10.895 INFO [stdout] test derivation::colliding_pw_128 ... ok
Nov 18 08:01:10.897 INFO [stdout] test workflow::miscreant ... ok
Nov 18 08:01:10.903 INFO [stdout] test derivation::colliding_pw_256 ... ok
Nov 18 08:01:10.903 INFO [stderr]      Running /target/debug/deps/serialize-5ff0009348739a85
Nov 18 08:01:10.903 INFO [stdout] test workflow::printers ... ok
Nov 18 08:01:10.903 INFO [stdout] 
Nov 18 08:01:10.903 INFO [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 08:01:10.903 INFO [stdout] 
Nov 18 08:01:10.904 INFO [stdout] 
Nov 18 08:01:10.904 INFO [stdout] running 5 tests
Nov 18 08:01:10.928 INFO [stdout] test bincode ... ok
Nov 18 08:01:10.928 INFO [stderr]    Doc-tests keybob
Nov 18 08:01:10.928 INFO [stdout] test messagepack ... ok
Nov 18 08:01:10.928 INFO [stdout] test cbor ... ok
Nov 18 08:01:10.928 INFO [stdout] test toml ... ok
Nov 18 08:01:10.929 INFO [stdout] test json ... ok
Nov 18 08:01:10.929 INFO [stdout] 
Nov 18 08:01:10.929 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 08:01:10.929 INFO [stdout] 
Nov 18 08:01:13.467 INFO [stdout] 
Nov 18 08:01:13.467 INFO [stdout] running 2 tests
Nov 18 08:01:17.747 INFO [stdout] test src/lib.rs -  (line 10) ... ok
Nov 18 08:01:18.538 INFO [stdout] test src/lib.rs -  (line 18) ... ok
Nov 18 08:01:18.538 INFO [stdout] 
Nov 18 08:01:18.538 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 08:01:18.538 INFO [stdout] 
Nov 18 08:01:18.575 INFO [stderr] su: No module specific data is present
Nov 18 08:01:19.034 INFO running `"docker" "inspect" "21553a64e92cc70146f70834537091571729c62788705ec14c7e6f9c093dad62"`
Nov 18 08:01:19.191 INFO running `"docker" "rm" "-f" "21553a64e92cc70146f70834537091571729c62788705ec14c7e6f9c093dad62"`
Nov 18 08:01:19.304 INFO [stdout] 21553a64e92cc70146f70834537091571729c62788705ec14c7e6f9c093dad62