Dec 05 10:22:47.426 INFO testing redhat-university-partnerships/keylime against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514 Dec 05 10:22:47.426 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 05 10:22:47.868 INFO [stdout] 36b1c005c7eaa7d4f55313ab0793e87c25011682d9e11bc20a82f5b67872fcda Dec 05 10:22:47.874 INFO running `"docker" "start" "-a" "36b1c005c7eaa7d4f55313ab0793e87c25011682d9e11bc20a82f5b67872fcda"` Dec 05 10:22:49.951 INFO [stderr] usermod: no changes Dec 05 10:22:50.384 INFO [stderr] Compiling syn v0.15.22 Dec 05 10:22:50.396 INFO [stderr] Compiling tempfile v3.0.5 Dec 05 10:22:50.404 INFO [stderr] Compiling pretty_env_logger v0.2.5 Dec 05 10:23:02.934 INFO [stderr] Compiling serde_derive v1.0.80 Dec 05 10:23:17.381 INFO [stderr] Compiling keylime_node v0.1.0 (/source) Dec 05 10:23:21.728 INFO [stderr] warning: static item is never used: `WORK_DIR` Dec 05 10:23:21.728 INFO [stderr] --> src/common.rs:23:1 Dec 05 10:23:21.728 INFO [stderr] | Dec 05 10:23:21.728 INFO [stderr] 23 | pub static WORK_DIR: &'static str = "/tmp"; Dec 05 10:23:21.728 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 05 10:23:21.728 INFO [stderr] | Dec 05 10:23:21.728 INFO [stderr] = note: #[warn(dead_code)] on by default Dec 05 10:23:21.728 INFO [stderr] Dec 05 10:23:21.728 INFO [stderr] warning: static item is never used: `SECURE_SIZE` Dec 05 10:23:21.728 INFO [stderr] --> src/common.rs:30:1 Dec 05 10:23:21.728 INFO [stderr] | Dec 05 10:23:21.728 INFO [stderr] 30 | pub static SECURE_SIZE: &'static str = "1m"; Dec 05 10:23:21.728 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 05 10:23:21.728 INFO [stderr] Dec 05 10:23:21.728 INFO [stderr] warning: static item is never used: `MOUNT_SECURE` Dec 05 10:23:21.728 INFO [stderr] --> src/common.rs:31:1 Dec 05 10:23:21.728 INFO [stderr] | Dec 05 10:23:21.728 INFO [stderr] 31 | pub static MOUNT_SECURE: bool = true; Dec 05 10:23:21.728 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 05 10:23:21.728 INFO [stderr] Dec 05 10:23:21.728 INFO [stderr] warning: function is never used: `chownroot` Dec 05 10:23:21.728 INFO [stderr] --> src/common.rs:121:1 Dec 05 10:23:21.728 INFO [stderr] | Dec 05 10:23:21.728 INFO [stderr] 121 | pub fn chownroot(path: String) -> Result { Dec 05 10:23:21.728 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 05 10:23:21.728 INFO [stderr] Dec 05 10:23:21.728 INFO [stderr] warning: function is never used: `kdf` Dec 05 10:23:21.728 INFO [stderr] --> src/crypto.rs:45:1 Dec 05 10:23:21.728 INFO [stderr] | Dec 05 10:23:21.728 INFO [stderr] 45 | / pub fn kdf( Dec 05 10:23:21.728 INFO [stderr] 46 | | input_password: String, Dec 05 10:23:21.728 INFO [stderr] 47 | | input_salt: String, Dec 05 10:23:21.728 INFO [stderr] 48 | | ) -> Result { Dec 05 10:23:21.728 INFO [stderr] ... | Dec 05 10:23:21.728 INFO [stderr] 63 | | Ok(to_hex_string(key.to_vec())) Dec 05 10:23:21.728 INFO [stderr] 64 | | } Dec 05 10:23:21.728 INFO [stderr] | |_^ Dec 05 10:23:21.728 INFO [stderr] Dec 05 10:23:21.728 INFO [stderr] warning: function is never used: `check_mount` Dec 05 10:23:21.728 INFO [stderr] --> src/secure_mount.rs:16:1 Dec 05 10:23:21.728 INFO [stderr] | Dec 05 10:23:21.728 INFO [stderr] 16 | fn check_mount(secure_dir: &str) -> bool { Dec 05 10:23:21.728 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 05 10:23:21.728 INFO [stderr] Dec 05 10:23:21.728 INFO [stderr] warning: function is never used: `mount` Dec 05 10:23:21.728 INFO [stderr] --> src/secure_mount.rs:55:1 Dec 05 10:23:21.728 INFO [stderr] | Dec 05 10:23:21.728 INFO [stderr] 55 | fn mount() -> Result { Dec 05 10:23:21.728 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 05 10:23:21.729 INFO [stderr] Dec 05 10:23:21.729 INFO [stderr] warning: function is never used: `is_deep_quote` Dec 05 10:23:21.729 INFO [stderr] --> src/tpm.rs:322:1 Dec 05 10:23:21.729 INFO [stderr] | Dec 05 10:23:21.729 INFO [stderr] 322 | pub fn is_deep_quote(quote: String) -> bool { Dec 05 10:23:21.729 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 05 10:23:21.729 INFO [stderr] Dec 05 10:23:28.581 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 38.61s Dec 05 10:23:28.598 INFO [stderr] su: No module specific data is present Dec 05 10:23:29.417 INFO running `"docker" "inspect" "36b1c005c7eaa7d4f55313ab0793e87c25011682d9e11bc20a82f5b67872fcda"` Dec 05 10:23:29.780 INFO running `"docker" "rm" "-f" "36b1c005c7eaa7d4f55313ab0793e87c25011682d9e11bc20a82f5b67872fcda"` Dec 05 10:23:30.112 INFO [stdout] 36b1c005c7eaa7d4f55313ab0793e87c25011682d9e11bc20a82f5b67872fcda Dec 05 10:23:30.120 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 05 10:23:30.576 INFO [stdout] 585754bec9214d4007952f2aa2b9e021fdfc7f4fa24fcdcf297bafbe8679c291 Dec 05 10:23:30.580 INFO running `"docker" "start" "-a" "585754bec9214d4007952f2aa2b9e021fdfc7f4fa24fcdcf297bafbe8679c291"` Dec 05 10:23:32.119 INFO [stderr] usermod: no changes Dec 05 10:23:32.468 INFO [stderr] Compiling keylime_node v0.1.0 (/source) Dec 05 10:23:34.961 INFO [stderr] warning: static item is never used: `WORK_DIR` Dec 05 10:23:34.961 INFO [stderr] --> src/common.rs:23:1 Dec 05 10:23:34.961 INFO [stderr] | Dec 05 10:23:34.961 INFO [stderr] 23 | pub static WORK_DIR: &'static str = "/tmp"; Dec 05 10:23:34.961 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 05 10:23:34.961 INFO [stderr] | Dec 05 10:23:34.961 INFO [stderr] = note: #[warn(dead_code)] on by default Dec 05 10:23:34.961 INFO [stderr] Dec 05 10:23:34.961 INFO [stderr] warning: static item is never used: `SECURE_SIZE` Dec 05 10:23:34.961 INFO [stderr] --> src/common.rs:30:1 Dec 05 10:23:34.961 INFO [stderr] | Dec 05 10:23:34.962 INFO [stderr] 30 | pub static SECURE_SIZE: &'static str = "1m"; Dec 05 10:23:34.962 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 05 10:23:34.962 INFO [stderr] Dec 05 10:23:34.962 INFO [stderr] warning: static item is never used: `MOUNT_SECURE` Dec 05 10:23:34.962 INFO [stderr] --> src/common.rs:31:1 Dec 05 10:23:34.962 INFO [stderr] | Dec 05 10:23:34.962 INFO [stderr] 31 | pub static MOUNT_SECURE: bool = true; Dec 05 10:23:34.962 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 05 10:23:34.962 INFO [stderr] Dec 05 10:23:34.962 INFO [stderr] warning: function is never used: `chownroot` Dec 05 10:23:34.962 INFO [stderr] --> src/common.rs:121:1 Dec 05 10:23:34.962 INFO [stderr] | Dec 05 10:23:34.962 INFO [stderr] 121 | pub fn chownroot(path: String) -> Result { Dec 05 10:23:34.962 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 05 10:23:34.962 INFO [stderr] Dec 05 10:23:34.962 INFO [stderr] warning: function is never used: `check_mount` Dec 05 10:23:34.962 INFO [stderr] --> src/secure_mount.rs:16:1 Dec 05 10:23:34.962 INFO [stderr] | Dec 05 10:23:34.962 INFO [stderr] 16 | fn check_mount(secure_dir: &str) -> bool { Dec 05 10:23:34.962 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 05 10:23:34.962 INFO [stderr] Dec 05 10:23:34.962 INFO [stderr] warning: function is never used: `mount` Dec 05 10:23:34.962 INFO [stderr] --> src/secure_mount.rs:55:1 Dec 05 10:23:34.962 INFO [stderr] | Dec 05 10:23:34.962 INFO [stderr] 55 | fn mount() -> Result { Dec 05 10:23:34.962 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 05 10:23:34.962 INFO [stderr] Dec 05 10:23:38.549 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 6.40s Dec 05 10:23:38.564 INFO [stderr] su: No module specific data is present Dec 05 10:23:40.237 INFO running `"docker" "inspect" "585754bec9214d4007952f2aa2b9e021fdfc7f4fa24fcdcf297bafbe8679c291"` Dec 05 10:23:40.582 INFO running `"docker" "rm" "-f" "585754bec9214d4007952f2aa2b9e021fdfc7f4fa24fcdcf297bafbe8679c291"` Dec 05 10:23:40.964 INFO [stdout] 585754bec9214d4007952f2aa2b9e021fdfc7f4fa24fcdcf297bafbe8679c291 Dec 05 10:23:40.970 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 05 10:23:41.534 INFO [stdout] 41bd8e65b57023dfa9ccaa7cdc8012d0bcf73f2a571cdca8e915ebe57a83866d Dec 05 10:23:41.536 INFO running `"docker" "start" "-a" "41bd8e65b57023dfa9ccaa7cdc8012d0bcf73f2a571cdca8e915ebe57a83866d"` Dec 05 10:23:43.463 INFO [stderr] usermod: no changes Dec 05 10:23:43.734 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.24s Dec 05 10:23:43.751 INFO [stderr] Running /target/debug/deps/keylime_node-67ccb831179c198a Dec 05 10:23:43.767 INFO [stdout] Dec 05 10:23:43.767 INFO [stdout] running 10 tests Dec 05 10:23:43.780 INFO [stdout] test tpm::tests::test_is_deep_quote ... ok Dec 05 10:23:43.781 INFO [stdout] test tests::test_read_in_file ... ok Dec 05 10:23:43.781 INFO [stdout] test tpm::tests::test_is_vtpm ... ok Dec 05 10:23:43.781 INFO [stdout] test tpm::tests::test_get_manufacturer ... ok Dec 05 10:23:43.781 INFO [stdout] test common::tests::test_get_restful_parameters ... ok Dec 05 10:23:43.782 INFO [stdout] test tpm::tests::test_read_file_output_path ... ok Dec 05 10:23:43.783 INFO [stdout] test tpm::tests::test_run_command ... ok Dec 05 10:23:43.832 INFO [stdout] test crypto::tests::test_kdf ... ok Dec 05 10:23:43.832 INFO [stdout] test crypto::tests::test_do_hmac ... ok Dec 05 10:23:44.060 INFO [stdout] test crypto::tests::test_hmac_verification ... ok Dec 05 10:23:44.060 INFO [stdout] Dec 05 10:23:44.060 INFO [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 05 10:23:44.060 INFO [stdout] Dec 05 10:23:44.074 INFO [stderr] su: No module specific data is present Dec 05 10:23:44.698 INFO running `"docker" "inspect" "41bd8e65b57023dfa9ccaa7cdc8012d0bcf73f2a571cdca8e915ebe57a83866d"` Dec 05 10:23:44.906 INFO running `"docker" "rm" "-f" "41bd8e65b57023dfa9ccaa7cdc8012d0bcf73f2a571cdca8e915ebe57a83866d"` Dec 05 10:23:45.348 INFO [stdout] 41bd8e65b57023dfa9ccaa7cdc8012d0bcf73f2a571cdca8e915ebe57a83866d