Dec 06 07:52:45.070 INFO testing advancedtelematic/ota-plus-tools against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 06 07:52:45.070 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/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 06 07:52:45.428 INFO [stdout] ff3fda86498a07ded9988ddb6e9692e04cd7d6d54ba804c78973c6204013f675
Dec 06 07:52:45.433 INFO running `"docker" "start" "-a" "ff3fda86498a07ded9988ddb6e9692e04cd7d6d54ba804c78973c6204013f675"`
Dec 06 07:52:46.293 INFO [stderr] usermod: no changes
Dec 06 07:52:46.653 INFO [stderr]    Compiling data-encoding v2.0.0-rc.2
Dec 06 07:52:46.653 INFO [stderr]    Compiling subtle v0.2.0
Dec 06 07:52:46.653 INFO [stderr]    Compiling serde_json v1.0.2
Dec 06 07:52:46.653 INFO [stderr]    Compiling toml v0.4.5
Dec 06 07:52:46.653 INFO [stderr]    Compiling derp v0.0.10
Dec 06 07:52:46.668 INFO [stderr]    Compiling uuid v0.5.1
Dec 06 07:52:46.679 INFO [stderr]    Compiling rayon-core v1.2.1
Dec 06 07:52:46.679 INFO [stderr]    Compiling clap v2.26.0
Dec 06 07:52:49.717 INFO [stderr]    Compiling generic-array v0.8.3
Dec 06 07:52:49.776 INFO [stderr]    Compiling serde_urlencoded v0.5.1
Dec 06 07:52:55.860 INFO [stderr]    Compiling env_logger v0.4.3
Dec 06 07:52:55.872 INFO [stderr]    Compiling chrono v0.4.0
Dec 06 07:52:55.884 INFO [stderr]    Compiling error-chain v0.10.0
Dec 06 07:53:05.291 INFO [stderr]    Compiling digest v0.6.2
Dec 06 07:53:05.302 INFO [stderr]    Compiling rayon v0.7.1
Dec 06 07:53:05.322 INFO [stderr]    Compiling pem v0.4.1
Dec 06 07:53:05.914 INFO [stderr]    Compiling reqwest v0.7.3
Dec 06 07:53:06.418 INFO [stderr]    Compiling curve25519-dalek v0.10.0
Dec 06 07:53:13.060 INFO [stderr]    Compiling ring v0.11.0
Dec 06 07:53:34.763 INFO [stderr]    Compiling ota-plus v0.0.1 (/source)
Dec 06 07:53:47.816 INFO [stderr] warning: use of deprecated item 'std::env::home_dir': This function's behavior is unexpected and probably not what you want. Consider using the home_dir function from https://crates.io/crates/dirs instead.
Dec 06 07:53:47.816 INFO [stderr]   --> src/bin/ota_plus.rs:75:21
Dec 06 07:53:47.816 INFO [stderr]    |
Dec 06 07:53:47.816 INFO [stderr] 75 |         .or_else(|| env::home_dir().map(|path| path.join(".ota-plus")))
Dec 06 07:53:47.816 INFO [stderr]    |                     ^^^^^^^^^^^^^
Dec 06 07:53:47.816 INFO [stderr]    |
Dec 06 07:53:47.816 INFO [stderr]    = note: #[warn(deprecated)] on by default
Dec 06 07:53:47.816 INFO [stderr] 
Dec 06 07:53:55.833 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 09s
Dec 06 07:53:55.857 INFO [stderr] su: No module specific data is present
Dec 06 07:53:57.460 INFO running `"docker" "inspect" "ff3fda86498a07ded9988ddb6e9692e04cd7d6d54ba804c78973c6204013f675"`
Dec 06 07:53:57.700 INFO running `"docker" "rm" "-f" "ff3fda86498a07ded9988ddb6e9692e04cd7d6d54ba804c78973c6204013f675"`
Dec 06 07:53:58.004 INFO [stdout] ff3fda86498a07ded9988ddb6e9692e04cd7d6d54ba804c78973c6204013f675
Dec 06 07:53:58.008 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/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 06 07:53:58.328 INFO [stdout] 5df757b2b66685897036922dc6f18c350cd8d708f14ed5cec934286e5cd2984a
Dec 06 07:53:58.332 INFO running `"docker" "start" "-a" "5df757b2b66685897036922dc6f18c350cd8d708f14ed5cec934286e5cd2984a"`
Dec 06 07:53:59.075 INFO [stderr] usermod: no changes
Dec 06 07:53:59.376 INFO [stderr]    Compiling ota-plus v0.0.1 (/source)
Dec 06 07:54:04.984 INFO [stderr] warning: use of deprecated item 'std::env::home_dir': This function's behavior is unexpected and probably not what you want. Consider using the home_dir function from https://crates.io/crates/dirs instead.
Dec 06 07:54:04.984 INFO [stderr]   --> src/bin/ota_plus.rs:75:21
Dec 06 07:54:04.984 INFO [stderr]    |
Dec 06 07:54:04.984 INFO [stderr] 75 |         .or_else(|| env::home_dir().map(|path| path.join(".ota-plus")))
Dec 06 07:54:04.984 INFO [stderr]    |                     ^^^^^^^^^^^^^
Dec 06 07:54:04.984 INFO [stderr]    |
Dec 06 07:54:04.984 INFO [stderr]    = note: #[warn(deprecated)] on by default
Dec 06 07:54:04.984 INFO [stderr] 
Dec 06 07:54:15.081 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 15.97s
Dec 06 07:54:15.113 INFO [stderr] su: No module specific data is present
Dec 06 07:54:15.853 INFO running `"docker" "inspect" "5df757b2b66685897036922dc6f18c350cd8d708f14ed5cec934286e5cd2984a"`
Dec 06 07:54:16.096 INFO running `"docker" "rm" "-f" "5df757b2b66685897036922dc6f18c350cd8d708f14ed5cec934286e5cd2984a"`
Dec 06 07:54:16.412 INFO [stdout] 5df757b2b66685897036922dc6f18c350cd8d708f14ed5cec934286e5cd2984a
Dec 06 07:54:16.418 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/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 06 07:54:16.808 INFO [stdout] 2b062ba8b141f0298f2821b58a8280f05856ccc4177c6462ab7f1a3d7b89a4a5
Dec 06 07:54:16.812 INFO running `"docker" "start" "-a" "2b062ba8b141f0298f2821b58a8280f05856ccc4177c6462ab7f1a3d7b89a4a5"`
Dec 06 07:54:17.264 INFO [stderr] usermod: no changes
Dec 06 07:54:17.472 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.18s
Dec 06 07:54:17.480 INFO [stderr]      Running /target/debug/deps/ota_plus-2075905aabf38688
Dec 06 07:54:17.484 INFO [stdout] 
Dec 06 07:54:17.484 INFO [stdout] running 12 tests
Dec 06 07:54:17.485 INFO [stdout] test crypto::test::extract_pkcs1_from_rsa_2048_pkcs8 ... ok
Dec 06 07:54:17.485 INFO [stdout] test crypto::test::extract_pkcs1_from_rsa_4096_pkcs8 ... ok
Dec 06 07:54:17.486 INFO [stdout] test crypto::test::ed25519_as_public_key ... ok
Dec 06 07:54:17.486 INFO [stdout] test crypto::test::test_pkcs8_wrap_rsa ... ok
Dec 06 07:54:17.486 INFO [stdout] test interchange::cjson::test::write_arr ... ok
Dec 06 07:54:17.491 INFO [stdout] test crypto::test::rsa_as_public_key ... ok
Dec 06 07:54:17.492 INFO [stdout] test crypto::test::test_rsa_spki_to_pkcs1 ... ok
Dec 06 07:54:17.497 INFO [stdout] test interchange::cjson::test::write_str ... ok
Dec 06 07:54:17.516 INFO [stdout] test crypto::test::rsa_from_pkcs1 ... ok
Dec 06 07:54:17.519 INFO [stdout] test interchange::cjson::test::write_obj ... ok
Dec 06 07:54:18.341 INFO [stdout] test crypto::test::ring_to_bouncy_castle_conversion ... ok
Dec 06 07:54:18.738 INFO [stdout] test crypto::test::new_rsa_key ... ok
Dec 06 07:54:18.738 INFO [stdout] 
Dec 06 07:54:18.738 INFO [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 07:54:18.738 INFO [stdout] 
Dec 06 07:54:18.738 INFO [stderr]      Running /target/debug/deps/ota_plus-3b6385c5ebd88be2
Dec 06 07:54:18.742 INFO [stdout] 
Dec 06 07:54:18.742 INFO [stdout] running 5 tests
Dec 06 07:54:18.746 INFO [stdout] test test::check_parser ... ok
Dec 06 07:54:18.747 INFO [stdout] test test::init ... ok
Dec 06 07:54:18.749 INFO [stdout] test test::tuf_key_gen_ed25519 ... ok
Dec 06 07:54:18.756 INFO [stdout] test test::tuf_root_init ... ok
Dec 06 07:54:19.181 INFO [stdout] test test::tuf_key_gen_rsa ... ok
Dec 06 07:54:19.181 INFO [stdout] 
Dec 06 07:54:19.181 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 07:54:19.181 INFO [stdout] 
Dec 06 07:54:19.182 INFO [stderr]    Doc-tests ota_plus
Dec 06 07:54:24.928 INFO [stdout] 
Dec 06 07:54:24.928 INFO [stdout] running 9 tests
Dec 06 07:54:52.954 INFO [stdout] test src/interchange/mod.rs - interchange::Json::to_writer (line 161) ... ok
Dec 06 07:54:58.136 INFO [stdout] test src/tuf.rs - tuf::TargetPath::components (line 343) ... ok
Dec 06 07:54:58.943 INFO [stdout] test src/interchange/mod.rs - interchange::Json::deserialize (line 101) ... ok
Dec 06 07:55:01.636 INFO [stdout] test src/interchange/mod.rs - interchange::Json::extension (line 76) ... ok
Dec 06 07:55:02.664 INFO [stdout] test src/interchange/mod.rs - interchange::Json::canonicalize (line 88) ... ok
Dec 06 07:55:02.983 INFO [stdout] test src/tuf.rs - tuf::TargetDescription::from_reader (line 457) ... ok
Dec 06 07:55:03.080 INFO [stdout] test src/interchange/mod.rs - interchange::Json::from_reader (line 179) ... ok
Dec 06 07:55:03.656 INFO [stdout] test src/interchange/mod.rs - interchange::Json::serialize (line 131) ... ok
Dec 06 07:55:09.636 INFO [stdout] test src/tuf.rs - tuf::TargetPath::is_child (line 355) ... ok
Dec 06 07:55:09.636 INFO [stdout] 
Dec 06 07:55:09.636 INFO [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 07:55:09.636 INFO [stdout] 
Dec 06 07:55:09.692 INFO [stderr] su: No module specific data is present
Dec 06 07:55:10.336 INFO running `"docker" "inspect" "2b062ba8b141f0298f2821b58a8280f05856ccc4177c6462ab7f1a3d7b89a4a5"`
Dec 06 07:55:10.602 INFO running `"docker" "rm" "-f" "2b062ba8b141f0298f2821b58a8280f05856ccc4177c6462ab7f1a3d7b89a4a5"`
Dec 06 07:55:10.908 INFO [stdout] 2b062ba8b141f0298f2821b58a8280f05856ccc4177c6462ab7f1a3d7b89a4a5