Dec 14 03:55:32.161 INFO testing advancedtelematic/ota-plus-tools against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 14 03:55:32.161 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 14 03:55:32.561 INFO [stdout] 99bd2573d6176410db4821942bdbd5803566476d38f09513bc273d790dddf5d4
Dec 14 03:55:32.564 INFO running `"docker" "start" "-a" "99bd2573d6176410db4821942bdbd5803566476d38f09513bc273d790dddf5d4"`
Dec 14 03:55:33.535 INFO [stderr] usermod: no changes
Dec 14 03:55:33.835 INFO [stderr]    Compiling data-encoding v2.0.0-rc.2
Dec 14 03:55:33.835 INFO [stderr]    Compiling subtle v0.2.0
Dec 14 03:55:33.835 INFO [stderr]    Compiling derp v0.0.10
Dec 14 03:55:33.835 INFO [stderr]    Compiling futures-cpupool v0.1.5
Dec 14 03:55:33.835 INFO [stderr]    Compiling uuid v0.5.1
Dec 14 03:55:33.835 INFO [stderr]    Compiling backtrace-sys v0.1.12
Dec 14 03:55:33.835 INFO [stderr]    Compiling tokio-io v0.1.3
Dec 14 03:55:33.835 INFO [stderr]    Compiling rayon v0.7.1
Dec 14 03:55:35.061 INFO [stderr]    Compiling openssl v0.9.17
Dec 14 03:55:38.799 INFO [stderr]    Compiling backtrace v0.3.3
Dec 14 03:55:38.827 INFO [stderr]    Compiling serde_urlencoded v0.5.1
Dec 14 03:55:38.963 INFO [stderr]    Compiling chrono v0.4.0
Dec 14 03:55:39.193 INFO [stderr]    Compiling env_logger v0.4.3
Dec 14 03:55:39.303 INFO [stderr]    Compiling tokio-core v0.1.9
Dec 14 03:55:46.120 INFO [stderr]    Compiling curve25519-dalek v0.10.0
Dec 14 03:55:46.122 INFO [stderr]    Compiling ring v0.11.0
Dec 14 03:55:46.147 INFO [stderr]    Compiling error-chain v0.10.0
Dec 14 03:56:01.537 INFO [stderr]    Compiling pem v0.4.1
Dec 14 03:56:02.100 INFO [stderr]    Compiling tokio-proto v0.1.1
Dec 14 03:56:02.348 INFO [stderr]    Compiling native-tls v0.1.4
Dec 14 03:56:06.513 INFO [stderr]    Compiling tokio-tls v0.1.3
Dec 14 03:56:11.280 INFO [stderr]    Compiling hyper v0.11.2
Dec 14 03:56:20.519 INFO [stderr]    Compiling hyper-tls v0.1.2
Dec 14 03:56:22.819 INFO [stderr]    Compiling reqwest v0.7.3
Dec 14 03:56:29.329 INFO [stderr]    Compiling ota-plus v0.0.1 (/source)
Dec 14 03:56:46.899 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 14 03:56:46.899 INFO [stderr]   --> src/bin/ota_plus.rs:75:21
Dec 14 03:56:46.899 INFO [stderr]    |
Dec 14 03:56:46.899 INFO [stderr] 75 |         .or_else(|| env::home_dir().map(|path| path.join(".ota-plus")))
Dec 14 03:56:46.899 INFO [stderr]    |                     ^^^^^^^^^^^^^
Dec 14 03:56:46.899 INFO [stderr]    |
Dec 14 03:56:46.899 INFO [stderr]    = note: #[warn(deprecated)] on by default
Dec 14 03:56:46.899 INFO [stderr] 
Dec 14 03:56:58.063 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 24s
Dec 14 03:56:58.083 INFO [stderr] su: No module specific data is present
Dec 14 03:56:58.952 INFO running `"docker" "inspect" "99bd2573d6176410db4821942bdbd5803566476d38f09513bc273d790dddf5d4"`
Dec 14 03:56:59.080 INFO running `"docker" "rm" "-f" "99bd2573d6176410db4821942bdbd5803566476d38f09513bc273d790dddf5d4"`
Dec 14 03:56:59.389 INFO [stdout] 99bd2573d6176410db4821942bdbd5803566476d38f09513bc273d790dddf5d4
Dec 14 03:56:59.391 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 14 03:56:59.623 INFO [stdout] cfdffb718e2006e0c55e8f8d4aec517945cfe9046410ec2b2c26907697198faf
Dec 14 03:56:59.628 INFO running `"docker" "start" "-a" "cfdffb718e2006e0c55e8f8d4aec517945cfe9046410ec2b2c26907697198faf"`
Dec 14 03:57:00.611 INFO [stderr] usermod: no changes
Dec 14 03:57:00.847 INFO [stderr]    Compiling ota-plus v0.0.1 (/source)
Dec 14 03:57:06.523 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 14 03:57:06.523 INFO [stderr]   --> src/bin/ota_plus.rs:75:21
Dec 14 03:57:06.523 INFO [stderr]    |
Dec 14 03:57:06.523 INFO [stderr] 75 |         .or_else(|| env::home_dir().map(|path| path.join(".ota-plus")))
Dec 14 03:57:06.523 INFO [stderr]    |                     ^^^^^^^^^^^^^
Dec 14 03:57:06.523 INFO [stderr]    |
Dec 14 03:57:06.523 INFO [stderr]    = note: #[warn(deprecated)] on by default
Dec 14 03:57:06.523 INFO [stderr] 
Dec 14 03:57:20.619 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 19.97s
Dec 14 03:57:20.635 INFO [stderr] su: No module specific data is present
Dec 14 03:57:21.404 INFO running `"docker" "inspect" "cfdffb718e2006e0c55e8f8d4aec517945cfe9046410ec2b2c26907697198faf"`
Dec 14 03:57:21.683 INFO running `"docker" "rm" "-f" "cfdffb718e2006e0c55e8f8d4aec517945cfe9046410ec2b2c26907697198faf"`
Dec 14 03:57:22.003 INFO [stdout] cfdffb718e2006e0c55e8f8d4aec517945cfe9046410ec2b2c26907697198faf
Dec 14 03:57:22.011 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 14 03:57:22.656 INFO [stdout] 9ad382c17e673574b8d15776a72a1a5d0761dcf1a94a381aafb834430dab97a1
Dec 14 03:57:22.658 INFO running `"docker" "start" "-a" "9ad382c17e673574b8d15776a72a1a5d0761dcf1a94a381aafb834430dab97a1"`
Dec 14 03:57:24.238 INFO [stderr] usermod: no changes
Dec 14 03:57:24.535 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.27s
Dec 14 03:57:24.551 INFO [stderr]      Running /target/debug/deps/ota_plus-310d59d48abc8665
Dec 14 03:57:24.573 INFO [stdout] 
Dec 14 03:57:24.573 INFO [stdout] running 12 tests
Dec 14 03:57:24.573 INFO [stdout] test crypto::test::extract_pkcs1_from_rsa_2048_pkcs8 ... ok
Dec 14 03:57:24.573 INFO [stdout] test crypto::test::ed25519_as_public_key ... ok
Dec 14 03:57:24.573 INFO [stdout] test crypto::test::test_pkcs8_wrap_rsa ... ok
Dec 14 03:57:24.573 INFO [stdout] test crypto::test::extract_pkcs1_from_rsa_4096_pkcs8 ... ok
Dec 14 03:57:24.579 INFO [stdout] test interchange::cjson::test::write_obj ... ok
Dec 14 03:57:24.579 INFO [stdout] test interchange::cjson::test::write_str ... ok
Dec 14 03:57:24.635 INFO [stdout] test crypto::test::test_rsa_spki_to_pkcs1 ... ok
Dec 14 03:57:24.635 INFO [stdout] test interchange::cjson::test::write_arr ... ok
Dec 14 03:57:24.635 INFO [stdout] test crypto::test::rsa_as_public_key ... ok
Dec 14 03:57:24.635 INFO [stdout] test crypto::test::rsa_from_pkcs1 ... ok
Dec 14 03:57:25.477 INFO [stdout] test crypto::test::new_rsa_key ... ok
Dec 14 03:57:25.996 INFO [stdout] test crypto::test::ring_to_bouncy_castle_conversion ... ok
Dec 14 03:57:25.996 INFO [stderr]      Running /target/debug/deps/ota_plus-eb0837bd832d2077
Dec 14 03:57:25.996 INFO [stdout] 
Dec 14 03:57:25.996 INFO [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 03:57:25.996 INFO [stdout] 
Dec 14 03:57:26.011 INFO [stdout] 
Dec 14 03:57:26.011 INFO [stdout] running 5 tests
Dec 14 03:57:26.011 INFO [stdout] test test::check_parser ... ok
Dec 14 03:57:26.011 INFO [stdout] test test::init ... ok
Dec 14 03:57:26.015 INFO [stdout] test test::tuf_root_init ... ok
Dec 14 03:57:26.035 INFO [stdout] test test::tuf_key_gen_ed25519 ... ok
Dec 14 03:57:26.728 INFO [stdout] test test::tuf_key_gen_rsa ... ok
Dec 14 03:57:26.728 INFO [stderr]    Doc-tests ota_plus
Dec 14 03:57:26.728 INFO [stdout] 
Dec 14 03:57:26.729 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 03:57:26.729 INFO [stdout] 
Dec 14 03:57:33.495 INFO [stdout] 
Dec 14 03:57:33.495 INFO [stdout] running 9 tests
Dec 14 03:58:16.091 INFO [stdout] test src/interchange/mod.rs - interchange::Json::canonicalize (line 88) ... ok
Dec 14 03:58:16.647 INFO [stdout] test src/interchange/mod.rs - interchange::Json::serialize (line 131) ... FAILED
Dec 14 03:58:17.663 INFO [stdout] test src/interchange/mod.rs - interchange::Json::extension (line 76) ... ok
Dec 14 03:58:22.828 INFO [stdout] test src/interchange/mod.rs - interchange::Json::to_writer (line 161) ... ok
Dec 14 03:58:23.771 INFO [stdout] test src/tuf.rs - tuf::TargetDescription::from_reader (line 457) ... ok
Dec 14 03:58:26.601 INFO [stdout] test src/tuf.rs - tuf::TargetPath::components (line 343) ... ok
Dec 14 03:58:26.647 INFO [stdout] test src/interchange/mod.rs - interchange::Json::from_reader (line 179) ... ok
Dec 14 03:58:26.814 INFO [stderr] su: No module specific data is present
Dec 14 03:58:27.666 INFO running `"docker" "inspect" "9ad382c17e673574b8d15776a72a1a5d0761dcf1a94a381aafb834430dab97a1"`
Dec 14 03:58:27.972 INFO running `"docker" "rm" "-f" "9ad382c17e673574b8d15776a72a1a5d0761dcf1a94a381aafb834430dab97a1"`
Dec 14 03:58:28.307 INFO [stdout] 9ad382c17e673574b8d15776a72a1a5d0761dcf1a94a381aafb834430dab97a1