Dec 14 22:44:08.802 INFO testing roughenough-1.1.1 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550 Dec 14 22:44:08.802 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-5/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 14 22:44:09.287 INFO [stdout] 50bbd479cfd0e6557c452faafcc467cf204c5c9edae286107261852ff00c27d3 Dec 14 22:44:09.289 INFO running `"docker" "start" "-a" "50bbd479cfd0e6557c452faafcc467cf204c5c9edae286107261852ff00c27d3"` Dec 14 22:44:10.510 INFO [stderr] usermod: no changes Dec 14 22:44:10.810 INFO [stderr] Compiling simple_logger v0.5.0 Dec 14 22:44:10.810 INFO [stderr] Compiling ctrlc v3.1.1 Dec 14 22:44:12.523 INFO [stderr] Compiling roughenough v1.1.1 (/source) Dec 14 22:44:25.218 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 14.68s Dec 14 22:44:25.237 INFO [stderr] su: No module specific data is present Dec 14 22:44:25.925 INFO running `"docker" "inspect" "50bbd479cfd0e6557c452faafcc467cf204c5c9edae286107261852ff00c27d3"` Dec 14 22:44:26.148 INFO running `"docker" "rm" "-f" "50bbd479cfd0e6557c452faafcc467cf204c5c9edae286107261852ff00c27d3"` Dec 14 22:44:26.335 INFO [stdout] 50bbd479cfd0e6557c452faafcc467cf204c5c9edae286107261852ff00c27d3 Dec 14 22:44:26.340 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-5/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 14 22:44:26.717 INFO [stdout] e8a4aeafe82f59e03499bb3dbd69beecb90721f7701eea26eba4e7134069c048 Dec 14 22:44:26.720 INFO running `"docker" "start" "-a" "e8a4aeafe82f59e03499bb3dbd69beecb90721f7701eea26eba4e7134069c048"` Dec 14 22:44:27.643 INFO [stderr] usermod: no changes Dec 14 22:44:27.997 INFO [stderr] Compiling roughenough v1.1.1 (/source) Dec 14 22:44:34.902 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 7.23s Dec 14 22:44:34.927 INFO [stderr] su: No module specific data is present Dec 14 22:44:35.830 INFO running `"docker" "inspect" "e8a4aeafe82f59e03499bb3dbd69beecb90721f7701eea26eba4e7134069c048"` Dec 14 22:44:36.120 INFO running `"docker" "rm" "-f" "e8a4aeafe82f59e03499bb3dbd69beecb90721f7701eea26eba4e7134069c048"` Dec 14 22:44:36.415 INFO [stdout] e8a4aeafe82f59e03499bb3dbd69beecb90721f7701eea26eba4e7134069c048 Dec 14 22:44:36.420 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-5/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 14 22:44:36.755 INFO [stdout] e13bc20afac2cbd092965cb31037cce748f244b86e972b814532f0c032c0e864 Dec 14 22:44:36.757 INFO running `"docker" "start" "-a" "e13bc20afac2cbd092965cb31037cce748f244b86e972b814532f0c032c0e864"` Dec 14 22:44:37.854 INFO [stderr] usermod: no changes Dec 14 22:44:38.141 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.26s Dec 14 22:44:38.165 INFO [stderr] Running /target/debug/deps/roughenough-ff87690e6a9e35f4 Dec 14 22:44:38.178 INFO [stdout] Dec 14 22:44:38.178 INFO [stdout] running 23 tests Dec 14 22:44:38.178 INFO [stdout] test kms::envelope::test::invalid_dek_length_detected ... ok Dec 14 22:44:38.178 INFO [stdout] test kms::envelope::test::invalid_nonce_length_detected ... ok Dec 14 22:44:38.178 INFO [stdout] test merkle::test::power_of_two ... ok Dec 14 22:44:38.182 INFO [stdout] test kms::envelope::test::decryption_reject_input_too_short ... ok Dec 14 22:44:38.182 INFO [stdout] test message::test::empty_message_size ... ok Dec 14 22:44:38.182 INFO [stdout] test merkle::test::not_power_of_two ... ok Dec 14 22:44:38.182 INFO [stdout] test message::test::empty_message_encoding ... ok Dec 14 22:44:38.188 INFO [stdout] test key::test::convert_from_string ... ok Dec 14 22:44:38.189 INFO [stdout] test kms::envelope::test::modified_ciphertext_is_detected ... ok Dec 14 22:44:38.189 INFO [stdout] test kms::envelope::test::encrypt_decrypt_round_trip ... ok Dec 14 22:44:38.189 INFO [stdout] test message::test::two_field_message_encoding ... ok Dec 14 22:44:38.189 INFO [stdout] test message::test::two_field_message_size ... ok Dec 14 22:44:38.189 INFO [stdout] test message::test::single_field_message_size ... ok Dec 14 22:44:38.189 INFO [stdout] test sign::test::sign_verify_round_trip ... ok Dec 14 22:44:38.190 INFO [stdout] test sign::test::sign_ed25519_empty_message ... ok Dec 14 22:44:38.193 INFO [stdout] test sign::test::sign_ed25519_message ... ok Dec 14 22:44:38.194 INFO [stdout] test sign::test::verify_ed25519_sig ... ok Dec 14 22:44:38.198 INFO [stdout] test sign::test::verify_ed25519_sig_on_empty_message ... ok Dec 14 22:44:38.199 INFO [stdout] test message::test::from_bytes_zero_tags ... ok Dec 14 22:44:38.199 INFO [stdout] test message::test::retrieve_message_values ... ok Dec 14 22:44:38.199 INFO [stdout] test message::test::single_field_message_encoding ... ok Dec 14 22:44:38.255 INFO [stdout] test message::test::from_bytes_offset_past_end_of_message ... ok Dec 14 22:44:38.255 INFO [stdout] test message::test::from_bytes_too_few_bytes_for_tags ... ok Dec 14 22:44:38.255 INFO [stdout] Dec 14 22:44:38.255 INFO [stdout] test result: ok. 23 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 14 22:44:38.255 INFO [stdout] Dec 14 22:44:38.256 INFO [stderr] Running /target/debug/deps/roughenough_client-45eb87572df60dd1 Dec 14 22:44:38.267 INFO [stderr] Running /target/debug/deps/roughenough_kms-8e409f066c479d46 Dec 14 22:44:38.267 INFO [stdout] Dec 14 22:44:38.267 INFO [stdout] running 0 tests Dec 14 22:44:38.267 INFO [stdout] Dec 14 22:44:38.267 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 14 22:44:38.267 INFO [stdout] Dec 14 22:44:38.269 INFO [stdout] Dec 14 22:44:38.269 INFO [stdout] running 0 tests Dec 14 22:44:38.269 INFO [stdout] Dec 14 22:44:38.269 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 14 22:44:38.269 INFO [stdout] Dec 14 22:44:38.271 INFO [stderr] Running /target/debug/deps/roughenough_server-ffd4c8dc70b3a052 Dec 14 22:44:38.279 INFO [stdout] Dec 14 22:44:38.279 INFO [stdout] running 0 tests Dec 14 22:44:38.279 INFO [stdout] Dec 14 22:44:38.279 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 14 22:44:38.279 INFO [stdout] Dec 14 22:44:38.280 INFO [stderr] Doc-tests roughenough Dec 14 22:44:40.539 INFO [stdout] Dec 14 22:44:40.539 INFO [stdout] running 0 tests Dec 14 22:44:40.539 INFO [stdout] Dec 14 22:44:40.539 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 14 22:44:40.539 INFO [stdout] Dec 14 22:44:40.551 INFO [stderr] su: No module specific data is present Dec 14 22:44:41.384 INFO running `"docker" "inspect" "e13bc20afac2cbd092965cb31037cce748f244b86e972b814532f0c032c0e864"` Dec 14 22:44:41.608 INFO running `"docker" "rm" "-f" "e13bc20afac2cbd092965cb31037cce748f244b86e972b814532f0c032c0e864"` Dec 14 22:44:41.927 INFO [stdout] e13bc20afac2cbd092965cb31037cce748f244b86e972b814532f0c032c0e864