Nov 17 10:12:29.288 INFO testing advancedtelematic/ota-plus-tools against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 17 10:12:29.289 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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 17 10:12:29.689 INFO [stdout] b1340de2c207d2c430ac73b949fcf6790550fad8c5e2e026cdbfabaaa6d8bb16
Nov 17 10:12:29.692 INFO running `"docker" "start" "-a" "b1340de2c207d2c430ac73b949fcf6790550fad8c5e2e026cdbfabaaa6d8bb16"`
Nov 17 10:12:31.170 INFO [stderr] usermod: no changes
Nov 17 10:12:31.607 INFO [stderr]    Compiling data-encoding v2.0.0-rc.2
Nov 17 10:12:31.609 INFO [stderr]    Compiling subtle v0.2.0
Nov 17 10:12:31.609 INFO [stderr]    Compiling derp v0.0.10
Nov 17 10:12:31.609 INFO [stderr]    Compiling uuid v0.5.1
Nov 17 10:12:31.611 INFO [stderr]    Compiling rayon v0.7.1
Nov 17 10:12:31.612 INFO [stderr]    Compiling serde_urlencoded v0.5.1
Nov 17 10:12:31.613 INFO [stderr]    Compiling chrono v0.4.0
Nov 17 10:12:31.616 INFO [stderr]    Compiling error-chain v0.10.0
Nov 17 10:12:37.079 INFO [stderr]    Compiling pem v0.4.1
Nov 17 10:12:38.747 INFO [stderr]    Compiling reqwest v0.7.3
Nov 17 10:12:38.767 INFO [stderr]    Compiling curve25519-dalek v0.10.0
Nov 17 10:12:45.952 INFO [stderr]    Compiling ring v0.11.0
Nov 17 10:13:07.839 INFO [stderr]    Compiling ota-plus v0.0.1 (/source)
Nov 17 10:13:25.970 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.
Nov 17 10:13:25.970 INFO [stderr]   --> src/bin/ota_plus.rs:75:21
Nov 17 10:13:25.970 INFO [stderr]    |
Nov 17 10:13:25.970 INFO [stderr] 75 |         .or_else(|| env::home_dir().map(|path| path.join(".ota-plus")))
Nov 17 10:13:25.971 INFO [stderr]    |                     ^^^^^^^^^^^^^
Nov 17 10:13:25.971 INFO [stderr]    |
Nov 17 10:13:25.971 INFO [stderr]    = note: #[warn(deprecated)] on by default
Nov 17 10:13:25.971 INFO [stderr] 
Nov 17 10:13:36.864 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 05s
Nov 17 10:13:36.884 INFO [stderr] su: No module specific data is present
Nov 17 10:13:37.647 INFO running `"docker" "inspect" "b1340de2c207d2c430ac73b949fcf6790550fad8c5e2e026cdbfabaaa6d8bb16"`
Nov 17 10:13:37.949 INFO running `"docker" "rm" "-f" "b1340de2c207d2c430ac73b949fcf6790550fad8c5e2e026cdbfabaaa6d8bb16"`
Nov 17 10:13:38.314 INFO [stdout] b1340de2c207d2c430ac73b949fcf6790550fad8c5e2e026cdbfabaaa6d8bb16
Nov 17 10:13:38.316 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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 17 10:13:38.749 INFO [stdout] a17e1e05abd27f06d2cc5332e7cfce02ba2b834c2c15fe19a014ea0275374cbc
Nov 17 10:13:38.753 INFO running `"docker" "start" "-a" "a17e1e05abd27f06d2cc5332e7cfce02ba2b834c2c15fe19a014ea0275374cbc"`
Nov 17 10:13:40.086 INFO [stderr] usermod: no changes
Nov 17 10:13:40.411 INFO [stderr]    Compiling ota-plus v0.0.1 (/source)
Nov 17 10:13:47.619 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.
Nov 17 10:13:47.619 INFO [stderr]   --> src/bin/ota_plus.rs:75:21
Nov 17 10:13:47.619 INFO [stderr]    |
Nov 17 10:13:47.619 INFO [stderr] 75 |         .or_else(|| env::home_dir().map(|path| path.join(".ota-plus")))
Nov 17 10:13:47.619 INFO [stderr]    |                     ^^^^^^^^^^^^^
Nov 17 10:13:47.619 INFO [stderr]    |
Nov 17 10:13:47.619 INFO [stderr]    = note: #[warn(deprecated)] on by default
Nov 17 10:13:47.619 INFO [stderr] 
Nov 17 10:14:03.275 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 23.16s
Nov 17 10:14:03.297 INFO [stderr] su: No module specific data is present
Nov 17 10:14:04.555 INFO running `"docker" "inspect" "a17e1e05abd27f06d2cc5332e7cfce02ba2b834c2c15fe19a014ea0275374cbc"`
Nov 17 10:14:04.813 INFO running `"docker" "rm" "-f" "a17e1e05abd27f06d2cc5332e7cfce02ba2b834c2c15fe19a014ea0275374cbc"`
Nov 17 10:14:05.101 INFO [stdout] a17e1e05abd27f06d2cc5332e7cfce02ba2b834c2c15fe19a014ea0275374cbc
Nov 17 10:14:05.106 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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 17 10:14:05.513 INFO [stdout] 0a6300146c652c63c689dab856d281006b667791553e722ee9e8f60425fbc460
Nov 17 10:14:05.516 INFO running `"docker" "start" "-a" "0a6300146c652c63c689dab856d281006b667791553e722ee9e8f60425fbc460"`
Nov 17 10:14:06.163 INFO [stderr] usermod: no changes
Nov 17 10:14:06.365 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.19s
Nov 17 10:14:06.378 INFO [stderr]      Running /target/debug/deps/ota_plus-ce0ff05193528ec8
Nov 17 10:14:06.391 INFO [stdout] 
Nov 17 10:14:06.391 INFO [stdout] running 12 tests
Nov 17 10:14:06.399 INFO [stdout] test crypto::test::extract_pkcs1_from_rsa_4096_pkcs8 ... ok
Nov 17 10:14:06.399 INFO [stdout] test crypto::test::extract_pkcs1_from_rsa_2048_pkcs8 ... ok
Nov 17 10:14:06.400 INFO [stdout] test crypto::test::ed25519_as_public_key ... ok
Nov 17 10:14:06.400 INFO [stdout] test interchange::cjson::test::write_arr ... ok
Nov 17 10:14:06.400 INFO [stdout] test interchange::cjson::test::write_obj ... ok
Nov 17 10:14:06.401 INFO [stdout] test crypto::test::test_rsa_spki_to_pkcs1 ... ok
Nov 17 10:14:06.401 INFO [stdout] test crypto::test::test_pkcs8_wrap_rsa ... ok
Nov 17 10:14:06.401 INFO [stdout] test crypto::test::rsa_as_public_key ... ok
Nov 17 10:14:06.402 INFO [stdout] test interchange::cjson::test::write_str ... ok
Nov 17 10:14:06.427 INFO [stdout] test crypto::test::rsa_from_pkcs1 ... ok
Nov 17 10:14:07.206 INFO [stdout] test crypto::test::new_rsa_key ... ok
Nov 17 10:14:07.315 INFO [stdout] test crypto::test::ring_to_bouncy_castle_conversion ... ok
Nov 17 10:14:07.315 INFO [stdout] 
Nov 17 10:14:07.315 INFO [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 10:14:07.315 INFO [stdout] 
Nov 17 10:14:07.317 INFO [stderr]      Running /target/debug/deps/ota_plus-48acecac4f89012f
Nov 17 10:14:07.320 INFO [stdout] 
Nov 17 10:14:07.320 INFO [stdout] running 5 tests
Nov 17 10:14:07.323 INFO [stdout] test test::check_parser ... ok
Nov 17 10:14:07.325 INFO [stdout] test test::init ... ok
Nov 17 10:14:07.330 INFO [stdout] test test::tuf_root_init ... ok
Nov 17 10:14:07.333 INFO [stdout] test test::tuf_key_gen_ed25519 ... ok
Nov 17 10:14:07.859 INFO [stdout] test test::tuf_key_gen_rsa ... ok
Nov 17 10:14:07.860 INFO [stdout] 
Nov 17 10:14:07.860 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 10:14:07.860 INFO [stdout] 
Nov 17 10:14:07.861 INFO [stderr]    Doc-tests ota_plus
Nov 17 10:14:13.737 INFO [stdout] 
Nov 17 10:14:13.737 INFO [stdout] running 9 tests
Nov 17 10:14:51.131 INFO [stdout] test src/interchange/mod.rs - interchange::Json::deserialize (line 101) ... ok
Nov 17 10:15:01.736 INFO [stdout] test src/interchange/mod.rs - interchange::Json::extension (line 76) ... FAILED
Nov 17 10:15:02.639 INFO [stdout] test src/interchange/mod.rs - interchange::Json::canonicalize (line 88) ... ok
Nov 17 10:15:03.566 INFO [stdout] test src/interchange/mod.rs - interchange::Json::from_reader (line 179) ... ok
Nov 17 10:15:03.916 INFO [stderr] su: No module specific data is present
Nov 17 10:15:04.775 INFO running `"docker" "inspect" "0a6300146c652c63c689dab856d281006b667791553e722ee9e8f60425fbc460"`
Nov 17 10:15:05.055 INFO running `"docker" "rm" "-f" "0a6300146c652c63c689dab856d281006b667791553e722ee9e8f60425fbc460"`
Nov 17 10:15:05.399 INFO [stdout] 0a6300146c652c63c689dab856d281006b667791553e722ee9e8f60425fbc460