Nov 02 01:39:40.267 INFO testing tuf-0.3.0-alpha3 against beta-2018-10-30 for beta-1.31-1
Nov 02 01:39:40.269 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-5/beta-2018-10-30:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/beta-1.31-1/beta-2018-10-30:/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 +beta-2018-10-30 build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 02 01:39:40.727 INFO blam! c3741ec45ce70297d6b45d9a006a2d81bbe51bc1d038a6690441c7daf389011a
Nov 02 01:39:40.730 INFO running `"docker" "start" "-a" "c3741ec45ce70297d6b45d9a006a2d81bbe51bc1d038a6690441c7daf389011a"`
Nov 02 01:39:42.590 INFO kablam! usermod: no changes
Nov 02 01:39:42.861 INFO kablam!    Compiling derp v0.0.4
Nov 02 01:39:42.869 INFO kablam!    Compiling tempfile v2.2.0
Nov 02 01:39:42.871 INFO kablam!    Compiling rayon v0.7.1
Nov 02 01:39:47.767 INFO kablam!    Compiling ring v0.11.0
Nov 02 01:39:57.812 INFO kablam!    Compiling tuf v0.3.0-alpha3 (/source)
Nov 02 01:40:05.839 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 23.22s
Nov 02 01:40:05.855 INFO kablam! su: No module specific data is present
Nov 02 01:40:06.611 INFO running `"docker" "rm" "-f" "c3741ec45ce70297d6b45d9a006a2d81bbe51bc1d038a6690441c7daf389011a"`
Nov 02 01:40:06.882 INFO blam! c3741ec45ce70297d6b45d9a006a2d81bbe51bc1d038a6690441c7daf389011a
Nov 02 01:40:06.893 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-5/beta-2018-10-30:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/beta-1.31-1/beta-2018-10-30:/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 +beta-2018-10-30 test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 02 01:40:07.496 INFO blam! a5d55a533d8313c5fcdc9402c2bf7e15b314730f530167d3648bc620ce2e5323
Nov 02 01:40:07.503 INFO running `"docker" "start" "-a" "a5d55a533d8313c5fcdc9402c2bf7e15b314730f530167d3648bc620ce2e5323"`
Nov 02 01:40:09.397 INFO kablam! usermod: no changes
Nov 02 01:40:09.615 INFO kablam!    Compiling maplit v0.1.6
Nov 02 01:40:10.193 INFO kablam!    Compiling tuf v0.3.0-alpha3 (/source)
Nov 02 01:40:33.295 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 23.87s
Nov 02 01:40:33.309 INFO kablam! su: No module specific data is present
Nov 02 01:40:34.683 INFO running `"docker" "rm" "-f" "a5d55a533d8313c5fcdc9402c2bf7e15b314730f530167d3648bc620ce2e5323"`
Nov 02 01:40:34.955 INFO blam! a5d55a533d8313c5fcdc9402c2bf7e15b314730f530167d3648bc620ce2e5323
Nov 02 01:40:34.959 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-5/beta-2018-10-30:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/beta-1.31-1/beta-2018-10-30:/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 +beta-2018-10-30 test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 02 01:40:35.307 INFO blam! e7424ed701a1c6b924178453d10dbf4a1d7a807778cc34f3fd980ba06987b1c9
Nov 02 01:40:35.308 INFO running `"docker" "start" "-a" "e7424ed701a1c6b924178453d10dbf4a1d7a807778cc34f3fd980ba06987b1c9"`
Nov 02 01:40:36.349 INFO kablam! usermod: no changes
Nov 02 01:40:36.527 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.15s
Nov 02 01:40:36.539 INFO kablam!      Running /target/debug/deps/tuf-51e9be6c78f388a4
Nov 02 01:40:36.543 INFO blam! 
Nov 02 01:40:36.543 INFO blam! running 68 tests
Nov 02 01:40:36.564 INFO blam! test crypto::test::ed25519_read_pkcs8_and_sign ... ok
Nov 02 01:40:36.564 INFO blam! test crypto::test::extract_pkcs1_from_rsa_2048_pkcs8 ... ok
Nov 02 01:40:36.564 INFO blam! test crypto::test::extract_pkcs1_from_rsa_4096_pkcs8 ... ok
Nov 02 01:40:36.564 INFO blam! test crypto::test::parse_rsa_2048_spki ... ok
Nov 02 01:40:36.583 INFO blam! test crypto::test::parse_rsa_4096_spki ... ok
Nov 02 01:40:36.583 INFO blam! test client::test::root_chain_update ... ok
Nov 02 01:40:36.599 INFO blam! test crypto::test::serde_rsa_public_key ... ok
Nov 02 01:40:36.607 INFO blam! test crypto::test::serde_ed25519_public_key ... ok
Nov 02 01:40:36.607 INFO blam! test crypto::test::serde_key_id ... ok
Nov 02 01:40:36.608 INFO blam! test interchange::cjson::test::write_str ... ok
Nov 02 01:40:36.608 INFO blam! test crypto::test::serde_signature ... ok
Nov 02 01:40:36.608 INFO blam! test interchange::cjson::test::write_arr ... ok
Nov 02 01:40:36.609 INFO blam! test interchange::cjson::test::write_obj ... ok
Nov 02 01:40:36.609 INFO blam! test metadata::test::deserialize_json_delegation_bad_threshold ... ok
Nov 02 01:40:36.619 INFO blam! test crypto::test::serde_signature_value ... ok
Nov 02 01:40:36.619 INFO blam! test metadata::test::deserialize_json_delegation_duplicate_paths ... ok
Nov 02 01:40:36.620 INFO blam! test metadata::test::deserialize_json_delegations_duplicated_roles ... ok
Nov 02 01:40:36.620 INFO blam! test metadata::test::deserialize_json_delegations_duplicate_keys ... ok
Nov 02 01:40:36.620 INFO blam! test metadata::test::deserialize_json_delegation_duplicate_key_ids ... ok
Nov 02 01:40:36.620 INFO blam! test metadata::test::deserialize_json_role_definition_duplicate_key_ids ... ok
Nov 02 01:40:36.621 INFO blam! test metadata::test::deserialize_json_delegations_no_roles ... ok
Nov 02 01:40:36.621 INFO blam! test metadata::test::deserialize_json_root_bad_type ... ok
Nov 02 01:40:36.639 INFO blam! test metadata::test::deserialize_json_root_duplicate_keys ... ok
Nov 02 01:40:36.639 INFO blam! test metadata::test::deserialize_json_snapshot_illegal_version ... ok
Nov 02 01:40:36.639 INFO blam! test metadata::test::deserialize_json_role_definition_illegal_threshold ... ok
Nov 02 01:40:36.639 INFO blam! test metadata::test::deserialize_json_snapshot_bad_type ... ok
Nov 02 01:40:36.639 INFO blam! test metadata::test::deserialize_json_delegations_no_keys ... ok
Nov 02 01:40:36.639 INFO blam! test metadata::test::deserialize_json_timestamp_bad_type ... ok
Nov 02 01:40:36.639 INFO blam! test metadata::test::deserialize_json_targets_bad_type ... ok
Nov 02 01:40:36.639 INFO blam! test metadata::test::deserialize_json_targets_illegal_version ... ok
Nov 02 01:40:36.639 INFO blam! test metadata::test::deserialize_json_root_illegal_version ... ok
Nov 02 01:40:36.639 INFO blam! test metadata::test::serde_metadata_path ... ok
Nov 02 01:40:36.639 INFO blam! test metadata::test::serde_snapshot_metadata ... ok
Nov 02 01:40:36.647 INFO blam! test metadata::test::serde_root_metadata ... ok
Nov 02 01:40:36.647 INFO blam! test metadata::test::serde_signed_metadata ... ok
Nov 02 01:40:36.647 INFO blam! test metadata::test::serde_role_definition ... ok
Nov 02 01:40:36.647 INFO blam! test metadata::test::serde_target_description ... ok
Nov 02 01:40:36.647 INFO blam! test metadata::test::deserialize_json_timestamp_illegal_version ... ok
Nov 02 01:40:36.647 INFO blam! test metadata::test::serde_timestamp_metadata ... ok
Nov 02 01:40:36.647 INFO blam! test repository::test::ephemeral_repo_targets ... ok
Nov 02 01:40:36.653 INFO blam! test metadata::test::path_matches_chain ... ok
Nov 02 01:40:36.653 INFO blam! test repository::test::file_system_repo_targets ... ok
Nov 02 01:40:36.667 INFO blam! test metadata::test::serde_target_path ... ok
Nov 02 01:40:36.667 INFO blam! test metadata::test::serde_targets_metadata ... ok
Nov 02 01:40:36.667 INFO blam! test metadata::test::serde_targets_with_delegations_metadata ... ok
Nov 02 01:40:36.674 INFO blam! test tuf::test::bad_targets_update_wrong_key ... ok
Nov 02 01:40:36.677 INFO blam! test tuf::test::bad_timestamp_update_wrong_key ... ok
Nov 02 01:40:36.677 INFO blam! test tuf::test::bad_snapshot_update_wrong_key ... ok
Nov 02 01:40:36.677 INFO blam! test tuf::test::bad_snapshot_update_wrong_version ... ok
Nov 02 01:40:36.714 INFO blam! test tuf::test::no_cross_sign_root_rotation ... ok
Nov 02 01:40:36.714 INFO blam! test tuf::test::bad_targets_update_wrong_version ... ok
Nov 02 01:40:36.714 INFO blam! test tuf::test::good_root_rotation ... ok
Nov 02 01:40:36.714 INFO blam! test tuf::test::good_targets_update ... ok
Nov 02 01:40:36.715 INFO blam! test tuf::test::good_snapshot_update ... ok
Nov 02 01:40:36.715 INFO blam! test util::test::invalid_read_above_max_size ... ok
Nov 02 01:40:36.759 INFO blam! test crypto::test::rsa_2048_read_pkcs8_and_sign ... ok
Nov 02 01:40:36.759 INFO blam! test util::test::invalid_read_bad_hash ... ok
Nov 02 01:40:36.775 INFO blam! test util::test::valid_read_below_max_size ... ok
Nov 02 01:40:36.775 INFO blam! test tuf::test::root_pinned_failure ... ok
Nov 02 01:40:36.775 INFO blam! test tuf::test::good_timestamp_update ... ok
Nov 02 01:40:36.775 INFO blam! test tuf::test::root_pinned_success ... ok
Nov 02 01:40:36.775 INFO blam! test util::test::valid_read ... ok
Nov 02 01:40:36.775 INFO blam! test util::test::invalid_read_above_max_size_large_data ... ok
Nov 02 01:40:36.775 INFO blam! test util::test::invalid_read_bad_hash_large_data ... ok
Nov 02 01:40:36.775 INFO blam! test util::test::valid_read_large_data ... ok
Nov 02 01:40:36.796 INFO blam! test util::test::valid_read_good_hash_large_data ... ok
Nov 02 01:40:36.815 INFO blam! test util::test::valid_read_good_hash ... ok
Nov 02 01:40:36.920 INFO blam! test crypto::test::rsa_4096_read_pkcs8_and_sign ... ok
Nov 02 01:40:36.920 INFO kablam!      Running /target/debug/deps/integration-c3abd442800855fb
Nov 02 01:40:36.920 INFO blam! 
Nov 02 01:40:36.920 INFO blam! test result: ok. 68 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 02 01:40:36.920 INFO blam! 
Nov 02 01:40:36.922 INFO blam! 
Nov 02 01:40:36.922 INFO blam! running 2 tests
Nov 02 01:40:36.944 INFO blam! test simple_delegation ... ok
Nov 02 01:40:36.947 INFO blam! test nested_delegation ... ok
Nov 02 01:40:36.947 INFO blam! 
Nov 02 01:40:36.947 INFO blam! test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 02 01:40:36.947 INFO blam! 
Nov 02 01:40:36.959 INFO kablam!      Running /target/debug/deps/simple_example-774b017680af1c34
Nov 02 01:40:36.967 INFO blam! 
Nov 02 01:40:36.967 INFO blam! running 2 tests
Nov 02 01:40:36.979 INFO blam! test with_translator ... ok
Nov 02 01:40:36.987 INFO blam! test without_translator ... ok
Nov 02 01:40:36.987 INFO blam! 
Nov 02 01:40:36.987 INFO blam! test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 02 01:40:36.987 INFO blam! 
Nov 02 01:40:36.995 INFO kablam!    Doc-tests tuf
Nov 02 01:40:41.399 INFO blam! 
Nov 02 01:40:41.399 INFO blam! running 24 tests
Nov 02 01:40:48.599 INFO blam! test src/crypto.rs - crypto::PrivateKey::from_pkcs8 (line 355) ... ok
Nov 02 01:41:12.095 INFO blam! test src/client.rs - client (line 5) ... ok
Nov 02 01:41:18.731 INFO blam! test src/client.rs - client::PathTranslator (line 68) ... ok
Nov 02 01:41:19.131 INFO blam! test src/interchange/mod.rs - interchange::Json::deserialize (line 244) ... ok
Nov 02 01:41:20.599 INFO blam! test src/interchange/mod.rs - interchange::Json::canonicalize (line 232) ... ok
Nov 02 01:41:20.865 INFO blam! test src/interchange/mod.rs - interchange::Json::extension (line 224) ... ok
Nov 02 01:41:22.687 INFO blam! test src/client.rs - client::Config (line 628) ... ok
Nov 02 01:41:22.779 INFO blam! test src/interchange/mod.rs - interchange::Json::from_reader (line 319) ... ok
Nov 02 01:41:23.754 INFO blam! test src/crypto.rs - crypto::hash_preference (line 37) ... ok
Nov 02 01:41:43.415 INFO blam! test src/interchange/mod.rs - interchange::Json::serialize (line 273) ... ok
Nov 02 01:41:58.411 INFO blam! test src/metadata.rs - metadata::MetadataPath (line 677) ... ok
Nov 02 01:42:01.467 INFO blam! test src/interchange/mod.rs - interchange::Json::to_writer (line 302) ... ok
Nov 02 01:42:04.299 INFO blam! test src/metadata.rs - metadata::MetadataPath::components (line 728) ... ok
Nov 02 01:42:05.528 INFO blam! test src/metadata.rs - metadata::MetadataPath::from_role (line 710) ... ok
Nov 02 01:42:07.991 INFO blam! test src/metadata.rs - metadata::Role::fuzzy_matches_path (line 159) ... ok
Nov 02 01:42:08.512 INFO blam! test src/metadata.rs - metadata::MetadataPath::new (line 692) ... ok
Nov 02 01:42:12.363 INFO blam! test src/metadata.rs - metadata::SignedMetadata<D, M>::add_signature (line 287) ... ok
Nov 02 01:42:30.895 INFO blam! test src/metadata.rs - metadata::SignedMetadata<D, M>::new (line 244) ... ok
Nov 02 01:42:39.553 INFO blam! test src/metadata.rs - metadata::SignedMetadata<D, M>::verify (line 375) ... ok
Nov 02 01:42:43.715 INFO blam! test src/metadata.rs - metadata::TargetDescription::from_reader (line 1162) ... ok
Nov 02 01:42:44.165 INFO blam! test src/metadata.rs - metadata::TargetPath::components (line 1120) ... ok
Nov 02 01:42:44.685 INFO blam! test src/metadata.rs - metadata::VirtualTargetPath::components (line 1022) ... ok
Nov 02 01:42:44.951 INFO blam! test src/metadata.rs - metadata::VirtualTargetPath::is_child (line 1033) ... ok
Nov 02 01:42:45.233 INFO blam! test src/metadata.rs - metadata::VirtualTargetPath::new (line 1003) ... ok
Nov 02 01:42:45.234 INFO blam! 
Nov 02 01:42:45.235 INFO blam! test result: ok. 24 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 02 01:42:45.235 INFO blam! 
Nov 02 01:42:45.259 INFO kablam! su: No module specific data is present
Nov 02 01:42:47.891 INFO running `"docker" "rm" "-f" "e7424ed701a1c6b924178453d10dbf4a1d7a807778cc34f3fd980ba06987b1c9"`
Nov 02 01:42:48.147 INFO blam! e7424ed701a1c6b924178453d10dbf4a1d7a807778cc34f3fd980ba06987b1c9
