Dec 13 06:20:04.656 INFO testing redhat-university-partnerships/keylime against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 13 06:20:04.656 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 13 06:20:05.251 INFO [stdout] 87931233b621a7e1c5ebb84b666efea5abdd213352e9c923347e275749c54545
Dec 13 06:20:05.253 INFO running `"docker" "start" "-a" "87931233b621a7e1c5ebb84b666efea5abdd213352e9c923347e275749c54545"`
Dec 13 06:20:06.910 INFO [stderr] usermod: no changes
Dec 13 06:20:07.383 INFO [stderr]    Compiling openssl-sys v0.9.39
Dec 13 06:20:07.383 INFO [stderr]    Compiling want v0.0.6
Dec 13 06:20:07.427 INFO [stderr]    Compiling mio v0.6.16
Dec 13 06:20:07.431 INFO [stderr]    Compiling chrono v0.4.6
Dec 13 06:20:07.439 INFO [stderr]    Compiling flate2 v1.0.6
Dec 13 06:20:07.528 INFO [stderr]    Compiling tokio-io v0.1.10
Dec 13 06:20:07.552 INFO [stderr]    Compiling serde_derive v1.0.82
Dec 13 06:20:07.553 INFO [stderr]    Compiling env_logger v0.5.13
Dec 13 06:20:11.095 INFO [stderr]    Compiling tokio-threadpool v0.1.9
Dec 13 06:20:18.485 INFO [stderr]    Compiling tempfile v3.0.5
Dec 13 06:20:18.672 INFO [stderr]    Compiling tokio-codec v0.1.1
Dec 13 06:20:21.143 INFO [stderr]    Compiling h2 v0.1.14
Dec 13 06:20:30.204 INFO [stderr]    Compiling mio-uds v0.6.7
Dec 13 06:20:30.220 INFO [stderr]    Compiling tokio-reactor v0.1.7
Dec 13 06:20:30.222 INFO [stderr]    Compiling pretty_env_logger v0.2.5
Dec 13 06:20:30.488 INFO [stderr]    Compiling openssl v0.10.15
Dec 13 06:20:30.579 INFO [stderr]    Compiling tokio-fs v0.1.4
Dec 13 06:20:41.241 INFO [stderr]    Compiling tokio-udp v0.1.3
Dec 13 06:20:41.242 INFO [stderr]    Compiling tokio-tcp v0.1.2
Dec 13 06:20:41.248 INFO [stderr]    Compiling tokio-uds v0.2.4
Dec 13 06:20:45.779 INFO [stderr]    Compiling tokio v0.1.13
Dec 13 06:20:54.383 INFO [stderr]    Compiling hyper v0.12.18
Dec 13 06:21:03.501 INFO [stderr]    Compiling keylime_node v0.1.0 (/source)
Dec 13 06:21:06.195 INFO [stderr] warning: static item is never used: `WORK_DIR`
Dec 13 06:21:06.195 INFO [stderr]   --> src/common.rs:23:1
Dec 13 06:21:06.195 INFO [stderr]    |
Dec 13 06:21:06.195 INFO [stderr] 23 | pub static WORK_DIR: &'static str = "/tmp";
Dec 13 06:21:06.195 INFO [stderr]    | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 06:21:06.195 INFO [stderr]    |
Dec 13 06:21:06.195 INFO [stderr]    = note: #[warn(dead_code)] on by default
Dec 13 06:21:06.195 INFO [stderr] 
Dec 13 06:21:06.195 INFO [stderr] warning: static item is never used: `SECURE_SIZE`
Dec 13 06:21:06.195 INFO [stderr]   --> src/common.rs:30:1
Dec 13 06:21:06.195 INFO [stderr]    |
Dec 13 06:21:06.195 INFO [stderr] 30 | pub static SECURE_SIZE: &'static str = "1m";
Dec 13 06:21:06.195 INFO [stderr]    | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 06:21:06.195 INFO [stderr] 
Dec 13 06:21:06.195 INFO [stderr] warning: static item is never used: `MOUNT_SECURE`
Dec 13 06:21:06.195 INFO [stderr]   --> src/common.rs:31:1
Dec 13 06:21:06.195 INFO [stderr]    |
Dec 13 06:21:06.195 INFO [stderr] 31 | pub static MOUNT_SECURE: bool = true;
Dec 13 06:21:06.195 INFO [stderr]    | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 06:21:06.195 INFO [stderr] 
Dec 13 06:21:06.195 INFO [stderr] warning: function is never used: `chownroot`
Dec 13 06:21:06.195 INFO [stderr]    --> src/common.rs:121:1
Dec 13 06:21:06.195 INFO [stderr]     |
Dec 13 06:21:06.195 INFO [stderr] 121 | pub fn chownroot(path: String) -> Result<String, i32> {
Dec 13 06:21:06.195 INFO [stderr]     | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 06:21:06.195 INFO [stderr] 
Dec 13 06:21:06.195 INFO [stderr] warning: function is never used: `kdf`
Dec 13 06:21:06.195 INFO [stderr]   --> src/crypto.rs:45:1
Dec 13 06:21:06.195 INFO [stderr]    |
Dec 13 06:21:06.195 INFO [stderr] 45 | / pub fn kdf(
Dec 13 06:21:06.195 INFO [stderr] 46 | |     input_password: String,
Dec 13 06:21:06.195 INFO [stderr] 47 | |     input_salt: String,
Dec 13 06:21:06.195 INFO [stderr] 48 | | ) -> Result<String, ErrorStack> {
Dec 13 06:21:06.195 INFO [stderr] ...  |
Dec 13 06:21:06.195 INFO [stderr] 63 | |     Ok(to_hex_string(key.to_vec()))
Dec 13 06:21:06.195 INFO [stderr] 64 | | }
Dec 13 06:21:06.195 INFO [stderr]    | |_^
Dec 13 06:21:06.195 INFO [stderr] 
Dec 13 06:21:06.195 INFO [stderr] warning: function is never used: `check_mount`
Dec 13 06:21:06.195 INFO [stderr]   --> src/secure_mount.rs:16:1
Dec 13 06:21:06.195 INFO [stderr]    |
Dec 13 06:21:06.195 INFO [stderr] 16 | fn check_mount(secure_dir: &str) -> bool {
Dec 13 06:21:06.195 INFO [stderr]    | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 06:21:06.195 INFO [stderr] 
Dec 13 06:21:06.195 INFO [stderr] warning: function is never used: `mount`
Dec 13 06:21:06.195 INFO [stderr]   --> src/secure_mount.rs:55:1
Dec 13 06:21:06.195 INFO [stderr]    |
Dec 13 06:21:06.196 INFO [stderr] 55 | fn mount() -> Result<String, i32> {
Dec 13 06:21:06.196 INFO [stderr]    | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 06:21:06.196 INFO [stderr] 
Dec 13 06:21:06.196 INFO [stderr] warning: function is never used: `is_deep_quote`
Dec 13 06:21:06.196 INFO [stderr]    --> src/tpm.rs:322:1
Dec 13 06:21:06.196 INFO [stderr]     |
Dec 13 06:21:06.196 INFO [stderr] 322 | pub fn is_deep_quote(quote: String) -> bool {
Dec 13 06:21:06.196 INFO [stderr]     | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 06:21:06.196 INFO [stderr] 
Dec 13 06:21:15.380 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 08s
Dec 13 06:21:15.394 INFO [stderr] su: No module specific data is present
Dec 13 06:21:17.099 INFO running `"docker" "inspect" "87931233b621a7e1c5ebb84b666efea5abdd213352e9c923347e275749c54545"`
Dec 13 06:21:17.461 INFO running `"docker" "rm" "-f" "87931233b621a7e1c5ebb84b666efea5abdd213352e9c923347e275749c54545"`
Dec 13 06:21:17.726 INFO [stdout] 87931233b621a7e1c5ebb84b666efea5abdd213352e9c923347e275749c54545
Dec 13 06:21:17.733 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 13 06:21:18.288 INFO [stdout] 32311156f8c4e16b4efc176f7c43aca0fff7418f099a958bd01797fee376b5a6
Dec 13 06:21:18.290 INFO running `"docker" "start" "-a" "32311156f8c4e16b4efc176f7c43aca0fff7418f099a958bd01797fee376b5a6"`
Dec 13 06:21:20.242 INFO [stderr] usermod: no changes
Dec 13 06:21:20.571 INFO [stderr]    Compiling keylime_node v0.1.0 (/source)
Dec 13 06:21:22.934 INFO [stderr] warning: static item is never used: `WORK_DIR`
Dec 13 06:21:22.934 INFO [stderr]   --> src/common.rs:23:1
Dec 13 06:21:22.934 INFO [stderr]    |
Dec 13 06:21:22.934 INFO [stderr] 23 | pub static WORK_DIR: &'static str = "/tmp";
Dec 13 06:21:22.935 INFO [stderr]    | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 06:21:22.935 INFO [stderr]    |
Dec 13 06:21:22.935 INFO [stderr]    = note: #[warn(dead_code)] on by default
Dec 13 06:21:22.935 INFO [stderr] 
Dec 13 06:21:22.935 INFO [stderr] warning: static item is never used: `SECURE_SIZE`
Dec 13 06:21:22.936 INFO [stderr]   --> src/common.rs:30:1
Dec 13 06:21:22.936 INFO [stderr]    |
Dec 13 06:21:22.936 INFO [stderr] 30 | pub static SECURE_SIZE: &'static str = "1m";
Dec 13 06:21:22.936 INFO [stderr]    | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 06:21:22.936 INFO [stderr] 
Dec 13 06:21:22.936 INFO [stderr] warning: static item is never used: `MOUNT_SECURE`
Dec 13 06:21:22.937 INFO [stderr]   --> src/common.rs:31:1
Dec 13 06:21:22.937 INFO [stderr]    |
Dec 13 06:21:22.937 INFO [stderr] 31 | pub static MOUNT_SECURE: bool = true;
Dec 13 06:21:22.937 INFO [stderr]    | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 06:21:22.937 INFO [stderr] 
Dec 13 06:21:22.937 INFO [stderr] warning: function is never used: `chownroot`
Dec 13 06:21:22.937 INFO [stderr]    --> src/common.rs:121:1
Dec 13 06:21:22.937 INFO [stderr]     |
Dec 13 06:21:22.937 INFO [stderr] 121 | pub fn chownroot(path: String) -> Result<String, i32> {
Dec 13 06:21:22.937 INFO [stderr]     | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 06:21:22.937 INFO [stderr] 
Dec 13 06:21:22.937 INFO [stderr] warning: function is never used: `check_mount`
Dec 13 06:21:22.938 INFO [stderr]   --> src/secure_mount.rs:16:1
Dec 13 06:21:22.938 INFO [stderr]    |
Dec 13 06:21:22.938 INFO [stderr] 16 | fn check_mount(secure_dir: &str) -> bool {
Dec 13 06:21:22.938 INFO [stderr]    | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 06:21:22.938 INFO [stderr] 
Dec 13 06:21:22.938 INFO [stderr] warning: function is never used: `mount`
Dec 13 06:21:22.938 INFO [stderr]   --> src/secure_mount.rs:55:1
Dec 13 06:21:22.938 INFO [stderr]    |
Dec 13 06:21:22.938 INFO [stderr] 55 | fn mount() -> Result<String, i32> {
Dec 13 06:21:22.938 INFO [stderr]    | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 06:21:22.938 INFO [stderr] 
Dec 13 06:21:26.647 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.39s
Dec 13 06:21:26.662 INFO [stderr] su: No module specific data is present
Dec 13 06:21:27.958 INFO running `"docker" "inspect" "32311156f8c4e16b4efc176f7c43aca0fff7418f099a958bd01797fee376b5a6"`
Dec 13 06:21:28.278 INFO running `"docker" "rm" "-f" "32311156f8c4e16b4efc176f7c43aca0fff7418f099a958bd01797fee376b5a6"`
Dec 13 06:21:28.667 INFO [stdout] 32311156f8c4e16b4efc176f7c43aca0fff7418f099a958bd01797fee376b5a6
Dec 13 06:21:28.674 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 13 06:21:29.163 INFO [stdout] ec8b38d68049becab8a6d51e5c2c4931a16a29fede72f5b4bbab3caf24778e3f
Dec 13 06:21:29.171 INFO running `"docker" "start" "-a" "ec8b38d68049becab8a6d51e5c2c4931a16a29fede72f5b4bbab3caf24778e3f"`
Dec 13 06:21:30.535 INFO [stderr] usermod: no changes
Dec 13 06:21:30.819 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.25s
Dec 13 06:21:30.823 INFO [stderr]      Running /target/debug/deps/keylime_node-84d2a3314156d834
Dec 13 06:21:30.831 INFO [stdout] 
Dec 13 06:21:30.831 INFO [stdout] running 10 tests
Dec 13 06:21:30.831 INFO [stdout] test tpm::tests::test_is_deep_quote ... ok
Dec 13 06:21:30.831 INFO [stdout] test tpm::tests::test_is_vtpm ... ok
Dec 13 06:21:30.831 INFO [stdout] test tpm::tests::test_get_manufacturer ... ok
Dec 13 06:21:30.831 INFO [stdout] test tests::test_read_in_file ... ok
Dec 13 06:21:30.831 INFO [stdout] test tpm::tests::test_read_file_output_path ... ok
Dec 13 06:21:30.831 INFO [stdout] test tpm::tests::test_run_command ... ok
Dec 13 06:21:30.831 INFO [stdout] test common::tests::test_get_restful_parameters ... ok
Dec 13 06:21:30.851 INFO [stdout] test crypto::tests::test_do_hmac ... ok
Dec 13 06:21:30.863 INFO [stdout] test crypto::tests::test_kdf ... ok
Dec 13 06:21:30.979 INFO [stderr] su: No module specific data is present
Dec 13 06:21:30.979 INFO [stdout] test crypto::tests::test_hmac_verification ... ok
Dec 13 06:21:30.979 INFO [stdout] 
Dec 13 06:21:30.979 INFO [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 06:21:30.979 INFO [stdout] 
Dec 13 06:21:32.015 INFO running `"docker" "inspect" "ec8b38d68049becab8a6d51e5c2c4931a16a29fede72f5b4bbab3caf24778e3f"`
Dec 13 06:21:32.325 INFO running `"docker" "rm" "-f" "ec8b38d68049becab8a6d51e5c2c4931a16a29fede72f5b4bbab3caf24778e3f"`
Dec 13 06:21:32.639 INFO [stdout] ec8b38d68049becab8a6d51e5c2c4931a16a29fede72f5b4bbab3caf24778e3f