[INFO] crate rusty_ulid 0.9.1 is already in cache
[INFO] testing rusty_ulid-0.9.1 against beta-2019-09-28 for beta-1.39-1
[INFO] extracting crate rusty_ulid 0.9.1 into work/builds/worker-11/source
[INFO] validating manifest of crates.io crate rusty_ulid 0.9.1 on toolchain beta-2019-09-28
[INFO] running `"/big/crater/work/cargo-home/bin/cargo" "+beta-2019-09-28" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] started tweaking crates.io crate rusty_ulid 0.9.1
[INFO] finished tweaking crates.io crate rusty_ulid 0.9.1
[INFO] tweaked toml for crates.io crate rusty_ulid 0.9.1 written to work/builds/worker-11/source/Cargo.toml
[INFO] crate crates.io crate rusty_ulid 0.9.1 already has a lockfile, it will not be regenerated
[INFO] running `"/big/crater/work/cargo-home/bin/cargo" "+beta-2019-09-28" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] running `"docker" "create" "-v" "/big/crater/work/builds/worker-11/target:/opt/rustwide/target:rw,Z" "-v" "/big/crater/work/builds/worker-11/source:/opt/rustwide/workdir:ro,Z" "-v" "/big/crater/work/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/big/crater/work/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2019-09-28" "build" "--frozen"`
[INFO] [stdout] 2b7dd40dcd33412bef58a8c3863087409fc6df8b84e0fb03dc0314e3ff96fc0b
[INFO] running `"docker" "start" "-a" "2b7dd40dcd33412bef58a8c3863087409fc6df8b84e0fb03dc0314e3ff96fc0b"`
[INFO] [stderr]    Compiling getrandom v0.1.9
[INFO] [stderr]    Compiling doc-comment v0.3.1
[INFO] [stderr]    Compiling serde v1.0.99
[INFO] [stderr]    Compiling num-integer v0.1.41
[INFO] [stderr]    Compiling chrono v0.4.7
[INFO] [stderr]    Compiling rand_core v0.5.0
[INFO] [stderr]    Compiling rand_chacha v0.2.1
[INFO] [stderr]    Compiling rand v0.7.0
[INFO] [stderr]    Compiling rusty_ulid v0.9.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 9.36s
[INFO] running `"docker" "inspect" "2b7dd40dcd33412bef58a8c3863087409fc6df8b84e0fb03dc0314e3ff96fc0b"`
[INFO] running `"docker" "rm" "-f" "2b7dd40dcd33412bef58a8c3863087409fc6df8b84e0fb03dc0314e3ff96fc0b"`
[INFO] [stdout] 2b7dd40dcd33412bef58a8c3863087409fc6df8b84e0fb03dc0314e3ff96fc0b
[INFO] running `"docker" "create" "-v" "/big/crater/work/builds/worker-11/target:/opt/rustwide/target:rw,Z" "-v" "/big/crater/work/builds/worker-11/source:/opt/rustwide/workdir:ro,Z" "-v" "/big/crater/work/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/big/crater/work/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2019-09-28" "test" "--frozen" "--no-run"`
[INFO] [stdout] b9618883ea00abc39a0523e4ae6f88153bf23e973bc35988e857a79f6ce8eab7
[INFO] running `"docker" "start" "-a" "b9618883ea00abc39a0523e4ae6f88153bf23e973bc35988e857a79f6ce8eab7"`
[INFO] [stderr]    Compiling syn v1.0.2
[INFO] [stderr]    Compiling serde_test v1.0.99
[INFO] [stderr]    Compiling quote v1.0.1
[INFO] [stderr]    Compiling bstr v0.2.7
[INFO] [stderr]    Compiling serde_json v1.0.40
[INFO] [stderr]    Compiling clap v2.33.0
[INFO] [stderr]    Compiling csv v1.1.1
[INFO] [stderr]    Compiling tinytemplate v1.0.2
[INFO] [stderr]    Compiling serde_derive v1.0.99
[INFO] [stderr]    Compiling criterion v0.2.11
[INFO] [stderr]    Compiling rusty_ulid v0.9.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 42.39s
[INFO] running `"docker" "inspect" "b9618883ea00abc39a0523e4ae6f88153bf23e973bc35988e857a79f6ce8eab7"`
[INFO] running `"docker" "rm" "-f" "b9618883ea00abc39a0523e4ae6f88153bf23e973bc35988e857a79f6ce8eab7"`
[INFO] [stdout] b9618883ea00abc39a0523e4ae6f88153bf23e973bc35988e857a79f6ce8eab7
[INFO] running `"docker" "create" "-v" "/big/crater/work/builds/worker-11/target:/opt/rustwide/target:rw,Z" "-v" "/big/crater/work/builds/worker-11/source:/opt/rustwide/workdir:ro,Z" "-v" "/big/crater/work/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/big/crater/work/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2019-09-28" "test" "--frozen"`
[INFO] [stdout] 150275e9519d68f0cb7bc208aadac3618f9612ef73d2a8cd7c28013704b6ab8c
[INFO] running `"docker" "start" "-a" "150275e9519d68f0cb7bc208aadac3618f9612ef73d2a8cd7c28013704b6ab8c"`
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.45s
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/rusty_ulid-42f61db77f58b224
[INFO] [stdout] 
[INFO] [stdout] running 22 tests
[INFO] [stdout] test crockford::tests::append_crockford_u128_test_cases ... ok
[INFO] [stdout] test crockford::tests::decoding_error_sources ... ok
[INFO] [stdout] test crockford::tests::description_returns_deprecation_message ... ok
[INFO] [stdout] test crockford::tests::parse_crockford_u64_tuple_test_cases ... ok
[INFO] [stdout] test crockford::tests::decoding_error_display_trait ... ok
[INFO] [stdout] test serde_tests::test_serde_compact ... ok
[INFO] [stdout] test serde_tests::test_de_compact_error ... ok
[INFO] [stdout] test serde_tests::test_serde_readable ... ok
[INFO] [stdout] test tests::from_str_failure_invalid_unicode ... ok
[INFO] [stdout] test tests::from_str_failure_too_short ... ok
[INFO] [stdout] test tests::hash_sanity_checks ... ok
[INFO] [stdout] test tests::from_str_failure_too_long ... ok
[INFO] [stdout] test tests::eq_cmp_sanity_checks ... ok
[INFO] [stdout] test crockford::tests::parse_crockford_u128_test_cases ... ok
[INFO] [stdout] test serde_tests::test_de_readable_error ... ok
[INFO] [stdout] test tests::from_str_failure_overflow ... ok
[INFO] [stdout] test tests::from_string_to_string ... ok
[INFO] [stdout] test crockford::tests::append_crockford_u64_tuple_test_cases ... ok
[INFO] [stdout] test tests::from_string_to_string_special_cases ... ok
[INFO] [stdout] test tests::test_from_timestamp_with_rng ... ok
[INFO] [stdout] test tests::increment ... ok
[INFO] [stdout] test tests::y10889_bug ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 22 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/rusty_ulid-623cef1f1da5572c
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test tests::help_short_returns_no_error ... ok
[INFO] [stdout] test tests::help_long_returns_no_error ... ok
[INFO] [stdout] test tests::invalid_value_returns_error ... ok
[INFO] [stdout] test tests::valid_values_return_no_error ... ok
[INFO] [stdout] test tests::no_args_return_no_error ... ok
[INFO] [stdout] test tests::version_long_returns_no_error ... ok
[INFO] [stdout] test tests::version_short_returns_no_error ... ok
[INFO] [stdout] test tests::valid_verbose_values_return_no_error ... ok
[INFO] [stdout] test tests::verbose_short_returns_no_error ... ok
[INFO] [stdout] test tests::verbose_long_returns_no_error ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests rusty_ulid
[INFO] [stdout] 
[INFO] [stdout] running 57 tests
[INFO] [stdout] test src/crockford.rs - crockford::parse_crockford_u128 (line 241) ... ok
[INFO] [stdout] test src/crockford.rs - crockford::append_crockford_u64_tuple (line 349) ... ok
[INFO] [stdout] test src/crockford.rs - crockford::append_crockford_u128 (line 168) ... ok
[INFO] [stdout] test src/crockford.rs - crockford::append_crockford_u64_tuple (line 331) ... ok
[INFO] [stdout] test src/crockford.rs - crockford::parse_crockford_u128 (line 233) ... ok
[INFO] [stdout] test <::doc_comment::doc_comment macros> - doc_tests::readme (line 29) ... ok
[INFO] [stdout] test src/crockford.rs - crockford::append_crockford_u64_tuple (line 340) ... ok
[INFO] [stdout] test src/crockford.rs - crockford::append_crockford_u128 (line 161) ... ok
[INFO] [stdout] test src/crockford.rs - crockford::parse_crockford_u128 (line 218) ... ok
[INFO] [stdout] test <::doc_comment::doc_comment macros> - doc_tests::readme (line 42) ... ok
[INFO] [stdout] test src/crockford.rs - crockford::parse_crockford_u128 (line 208) ... ok
[INFO] [stdout] test src/crockford.rs - crockford::append_crockford_u128 (line 154) ... ok
[INFO] [stdout] test <::doc_comment::doc_comment macros> - doc_tests::readme (line 58) ... ok
[INFO] [stdout] test src/crockford.rs - crockford::append_crockford_u64_tuple (line 322) ... ok
[INFO] [stdout] test src/crockford.rs - crockford::parse_crockford_u128 (line 266) ... ok
[INFO] [stdout] test src/crockford.rs - crockford::parse_crockford_u64_tuple (line 420) ... ok
[INFO] [stdout] test src/crockford.rs - crockford::parse_crockford_u128 (line 251) ... ok
[INFO] [stdout] test src/crockford.rs - crockford::parse_crockford_u64_tuple (line 394) ... ok
[INFO] [stdout] test src/crockford.rs - crockford::append_crockford_u128 (line 147) ... ok
[INFO] [stdout] test src/crockford.rs - crockford::parse_crockford_u64_tuple (line 428) ... ok
[INFO] [stdout] test src/crockford.rs - crockford::parse_crockford_u64_tuple (line 405) ... ok
[INFO] [stdout] test src/crockford.rs - crockford::parse_crockford_u64_tuple (line 453) ... ok
[INFO] [stdout] test src/lib.rs - Ulid::from (line 778) ... ok
[INFO] [stdout] test src/lib.rs - Ulid::datetime (line 472) ... ok
[INFO] [stdout] test src/lib.rs - (u64, u64)::from (line 747) ... ok
[INFO] [stdout] test src/lib.rs - (u64, u64)::from (line 735) ... ok
[INFO] [stdout] test src/lib.rs - Ulid::from (line 766) ... ok
[INFO] [stdout] test src/lib.rs - Ulid::from (line 604) ... ok
[INFO] [stdout] test src/lib.rs - Ulid::from (line 704) ... ok
[INFO] [stdout] test src/lib.rs - Ulid::from (line 716) ... ok
[INFO] [stdout] test src/crockford.rs - crockford::parse_crockford_u64_tuple (line 438) ... ok
[INFO] [stdout] test src/lib.rs - Ulid::increment (line 498) ... ok
[INFO] [stdout] test src/lib.rs - Ulid::from_timestamp_with_rng (line 309) ... ok
[INFO] [stdout] test src/lib.rs - Ulid::from (line 589) ... ok
[INFO] [stdout] test src/lib.rs - Ulid::increment (line 507) ... ok
[INFO] [stdout] test src/lib.rs - Ulid::generate (line 227) ... ok
[INFO] [stdout] test src/lib.rs - Ulid::next_monotonic_from_timestamp_with_rng (line 346) ... ok
[INFO] [stdout] test src/lib.rs - Ulid::increment (line 516) ... ok
[INFO] [stdout] test src/lib.rs - Ulid::next_monotonic_from_timestamp_with_rng (line 364) ... ok
[INFO] [stdout] test src/lib.rs - Ulid::next_strictly_monotonic (line 281) ... ok
[INFO] [stdout] test src/lib.rs - Ulid::next_monotonic (line 254) ... ok
[INFO] [stdout] test src/lib.rs - Ulid::next_strictly_monotonic_from_timestamp_with_rng (line 409) ... ok
[INFO] [stdout] test src/lib.rs - Ulid::next_strictly_monotonic_from_timestamp_with_rng (line 400) ... ok
[INFO] [stdout] test src/lib.rs - Ulid::to_string (line 550) ... ok
[INFO] [stdout] test src/lib.rs - Ulid::next_monotonic_from_timestamp_with_rng (line 355) ... ok
[INFO] [stdout] test src/lib.rs - Ulid::timestamp (line 454) ... ok
[INFO] [stdout] test src/lib.rs - Ulid::to_string (line 542) ... ok
[INFO] [stdout] test src/lib.rs - [u8; 16]::from (line 662) ... ok
[INFO] [stdout] test src/lib.rs - Ulid::next_strictly_monotonic_from_timestamp_with_rng (line 418) ... ok
[INFO] [stdout] test src/lib.rs - [u8; 16]::from (line 647) ... ok
[INFO] [stdout] test src/lib.rs - Ulid::try_from (line 834) ... ok
[INFO] [stdout] test src/lib.rs - Ulid::try_from (line 860) ... ok
[INFO] [stdout] test src/lib.rs - Ulid::try_from (line 871) ... ok
[INFO] [stdout] test src/lib.rs - generate_ulid_string (line 187) ... ok
[INFO] [stdout] test src/lib.rs - generate_ulid_bytes (line 204) ... ok
[INFO] [stdout] test src/lib.rs - u128::from (line 810) ... ok
[INFO] [stdout] test src/lib.rs - u128::from (line 798) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 57 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] running `"docker" "inspect" "150275e9519d68f0cb7bc208aadac3618f9612ef73d2a8cd7c28013704b6ab8c"`
[INFO] running `"docker" "rm" "-f" "150275e9519d68f0cb7bc208aadac3618f9612ef73d2a8cd7c28013704b6ab8c"`
[INFO] [stdout] 150275e9519d68f0cb7bc208aadac3618f9612ef73d2a8cd7c28013704b6ab8c