Dec 13 17:16:11.180 INFO testing huxi/rusty_ulid against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 13 17:16:11.180 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 13 17:16:11.759 INFO [stdout] aa02301a83a9bf34f68a0179e82a8747d4ab3672c1e97d04edb8d2d37a0e84d6
Dec 13 17:16:11.765 INFO running `"docker" "start" "-a" "aa02301a83a9bf34f68a0179e82a8747d4ab3672c1e97d04edb8d2d37a0e84d6"`
Dec 13 17:16:13.559 INFO [stderr] usermod: no changes
Dec 13 17:16:13.787 INFO [stderr]    Compiling rusty_ulid v0.7.0 (/source)
Dec 13 17:16:17.044 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.45s
Dec 13 17:16:17.053 INFO [stderr] su: No module specific data is present
Dec 13 17:16:18.178 INFO running `"docker" "inspect" "aa02301a83a9bf34f68a0179e82a8747d4ab3672c1e97d04edb8d2d37a0e84d6"`
Dec 13 17:16:18.397 INFO running `"docker" "rm" "-f" "aa02301a83a9bf34f68a0179e82a8747d4ab3672c1e97d04edb8d2d37a0e84d6"`
Dec 13 17:16:18.768 INFO [stdout] aa02301a83a9bf34f68a0179e82a8747d4ab3672c1e97d04edb8d2d37a0e84d6
Dec 13 17:16:18.775 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 13 17:16:19.205 INFO [stdout] 2753b2ade25398f8d82e4e92e9b936affc7e4c6abc6bb30c274f1add7eead2ae
Dec 13 17:16:19.207 INFO running `"docker" "start" "-a" "2753b2ade25398f8d82e4e92e9b936affc7e4c6abc6bb30c274f1add7eead2ae"`
Dec 13 17:16:20.183 INFO [stderr] usermod: no changes
Dec 13 17:16:20.477 INFO [stderr]    Compiling criterion-plot v0.2.5
Dec 13 17:16:20.479 INFO [stderr]    Compiling itertools-num v0.1.3
Dec 13 17:16:20.499 INFO [stderr]    Compiling criterion-stats v0.2.5
Dec 13 17:16:20.502 INFO [stderr]    Compiling simplelog v0.5.3
Dec 13 17:16:20.504 INFO [stderr]    Compiling handlebars v0.32.4
Dec 13 17:16:33.462 INFO [stderr]    Compiling criterion v0.2.5
Dec 13 17:16:42.175 INFO [stderr]    Compiling rusty_ulid v0.7.0 (/source)
Dec 13 17:16:44.415 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 24.21s
Dec 13 17:16:44.430 INFO [stderr] su: No module specific data is present
Dec 13 17:16:44.991 INFO running `"docker" "inspect" "2753b2ade25398f8d82e4e92e9b936affc7e4c6abc6bb30c274f1add7eead2ae"`
Dec 13 17:16:45.245 INFO running `"docker" "rm" "-f" "2753b2ade25398f8d82e4e92e9b936affc7e4c6abc6bb30c274f1add7eead2ae"`
Dec 13 17:16:45.546 INFO [stdout] 2753b2ade25398f8d82e4e92e9b936affc7e4c6abc6bb30c274f1add7eead2ae
Dec 13 17:16:45.547 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 13 17:16:45.959 INFO [stdout] 445015c2b63a9a611b8c16e462283004d3e4333008aa709727d34e600cfe54d7
Dec 13 17:16:45.967 INFO running `"docker" "start" "-a" "445015c2b63a9a611b8c16e462283004d3e4333008aa709727d34e600cfe54d7"`
Dec 13 17:16:46.811 INFO [stderr] usermod: no changes
Dec 13 17:16:46.926 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.09s
Dec 13 17:16:46.930 INFO [stderr]      Running /target/debug/deps/rusty_ulid-dc0df24c60ed8191
Dec 13 17:16:46.935 INFO [stdout] 
Dec 13 17:16:46.935 INFO [stdout] running 21 tests
Dec 13 17:16:46.936 INFO [stdout] test crockford::tests::decoding_error_causes ... ok
Dec 13 17:16:46.936 INFO [stdout] test crockford::tests::decoding_error_display_trait ... ok
Dec 13 17:16:46.936 INFO [stdout] test crockford::tests::append_crockford_u64_tuple_test_cases ... ok
Dec 13 17:16:46.936 INFO [stdout] test crockford::tests::append_crockford_u128_test_cases ... ok
Dec 13 17:16:46.936 INFO [stdout] test crockford::tests::description_returns_deprecation_message ... ok
Dec 13 17:16:46.936 INFO [stdout] test crockford::tests::parse_crockford_u64_tuple_test_cases ... ok
Dec 13 17:16:46.936 INFO [stdout] test crockford::tests::parse_crockford_u128_test_cases ... ok
Dec 13 17:16:46.936 INFO [stdout] test tests::eq_cmp_sanity_checks ... ok
Dec 13 17:16:46.936 INFO [stdout] test tests::from_str_failure_invalid_unicode ... ok
Dec 13 17:16:46.936 INFO [stdout] test tests::hash_sanity_checks ... ok
Dec 13 17:16:46.936 INFO [stdout] test tests::from_str_failure_overflow ... ok
Dec 13 17:16:46.936 INFO [stdout] test tests::from_string_to_string_special_cases ... ok
Dec 13 17:16:46.937 INFO [stdout] test tests::increment ... ok
Dec 13 17:16:46.937 INFO [stdout] test tests::parse_quickstart ... ok
Dec 13 17:16:46.937 INFO [stdout] test tests::from_str_failure_too_short ... ok
Dec 13 17:16:46.937 INFO [stdout] test tests::from_string_to_string ... ok
Dec 13 17:16:46.937 INFO [stdout] test tests::test_from_timestamp_with_rng ... ok
Dec 13 17:16:46.939 INFO [stdout] test tests::quickstart ... ok
Dec 13 17:16:46.939 INFO [stdout] test tests::fn_quickstart ... ok
Dec 13 17:16:46.939 INFO [stdout] test tests::from_str_failure_too_long ... ok
Dec 13 17:16:46.971 INFO [stdout] test tests::y10889_bug ... ok
Dec 13 17:16:46.981 INFO [stdout] 
Dec 13 17:16:46.981 INFO [stdout] test result: ok. 21 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 17:16:46.981 INFO [stdout] 
Dec 13 17:16:46.981 INFO [stderr]      Running /target/debug/deps/rusty_ulid-6c276f57dd20bf6e
Dec 13 17:16:46.983 INFO [stdout] 
Dec 13 17:16:46.983 INFO [stdout] running 10 tests
Dec 13 17:16:46.983 INFO [stdout] test tests::help_long_returns_no_error ... ok
Dec 13 17:16:46.983 INFO [stdout] test tests::help_short_returns_no_error ... ok
Dec 13 17:16:46.984 INFO [stdout] test tests::invalid_value_returns_error ... ok
Dec 13 17:16:46.984 INFO [stdout] test tests::valid_values_return_no_error ... ok
Dec 13 17:16:46.984 INFO [stdout] test tests::valid_verbose_values_return_no_error ... ok
Dec 13 17:16:46.984 INFO [stdout] test tests::no_args_return_no_error ... ok
Dec 13 17:16:46.984 INFO [stdout] test tests::version_long_returns_no_error ... ok
Dec 13 17:16:46.984 INFO [stdout] test tests::version_short_returns_no_error ... ok
Dec 13 17:16:46.985 INFO [stdout] test tests::verbose_long_returns_no_error ... ok
Dec 13 17:16:46.985 INFO [stdout] test tests::verbose_short_returns_no_error ... ok
Dec 13 17:16:46.985 INFO [stdout] 
Dec 13 17:16:46.985 INFO [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 17:16:46.985 INFO [stdout] 
Dec 13 17:16:46.986 INFO [stderr]    Doc-tests rusty_ulid
Dec 13 17:16:48.050 INFO [stdout] 
Dec 13 17:16:48.050 INFO [stdout] running 51 tests
Dec 13 17:16:50.999 INFO [stdout] test src/crockford.rs - crockford::append_crockford_u128 (line 161) ... ok
Dec 13 17:16:51.351 INFO [stdout] test src/crockford.rs - crockford::append_crockford_u64_tuple (line 335) ... ok
Dec 13 17:16:51.367 INFO [stdout] test src/crockford.rs - crockford::append_crockford_u64_tuple (line 344) ... ok
Dec 13 17:16:51.823 INFO [stdout] test src/crockford.rs - crockford::append_crockford_u64_tuple (line 326) ... ok
Dec 13 17:16:51.959 INFO [stdout] test src/crockford.rs - crockford::append_crockford_u128 (line 147) ... ok
Dec 13 17:16:51.977 INFO [stdout] test src/crockford.rs - crockford::append_crockford_u128 (line 154) ... ok
Dec 13 17:16:51.978 INFO [stdout] test src/crockford.rs - crockford::append_crockford_u64_tuple (line 353) ... ok
Dec 13 17:16:52.063 INFO [stdout] test src/crockford.rs - crockford::append_crockford_u128 (line 168) ... ok
Dec 13 17:16:56.367 INFO [stdout] test src/crockford.rs - crockford::parse_crockford_u128 (line 237) ... ok
Dec 13 17:16:56.607 INFO [stdout] test src/crockford.rs - crockford::parse_crockford_u128 (line 208) ... ok
Dec 13 17:16:56.923 INFO [stdout] test src/crockford.rs - crockford::parse_crockford_u128 (line 218) ... ok
Dec 13 17:16:57.184 INFO [stdout] test src/crockford.rs - crockford::parse_crockford_u128 (line 270) ... ok
Dec 13 17:16:57.691 INFO [stdout] test src/crockford.rs - crockford::parse_crockford_u64_tuple (line 398) ... ok
Dec 13 17:16:58.646 INFO [stdout] test src/crockford.rs - crockford::parse_crockford_u64_tuple (line 409) ... ok
Dec 13 17:16:59.019 INFO [stdout] test src/crockford.rs - crockford::parse_crockford_u128 (line 255) ... ok
Dec 13 17:17:00.339 INFO [stdout] test src/crockford.rs - crockford::parse_crockford_u128 (line 245) ... ok
Dec 13 17:17:02.751 INFO [stdout] test src/crockford.rs - crockford::parse_crockford_u64_tuple (line 461) ... ok
Dec 13 17:17:04.011 INFO [stdout] test src/crockford.rs - crockford::parse_crockford_u64_tuple (line 428) ... ok
Dec 13 17:17:05.803 INFO [stdout] test src/lib.rs - (u64, u64)::from (line 722) ... ok
Dec 13 17:17:05.987 INFO [stdout] test src/crockford.rs - crockford::parse_crockford_u64_tuple (line 446) ... ok
Dec 13 17:17:06.410 INFO [stdout] test src/lib.rs - Ulid::datetime (line 460) ... ok
Dec 13 17:17:06.411 INFO [stdout] test src/crockford.rs - crockford::parse_crockford_u64_tuple (line 436) ... ok
Dec 13 17:17:06.911 INFO [stdout] test src/lib.rs - (u64, u64)::from (line 734) ... ok
Dec 13 17:17:07.324 INFO [stdout] test src/lib.rs - Ulid::from (line 576) ... ok
Dec 13 17:17:08.695 INFO [stdout] test src/lib.rs - Ulid::from (line 591) ... ok
Dec 13 17:17:09.747 INFO [stdout] test src/lib.rs - Ulid::from (line 691) ... ok
Dec 13 17:17:10.232 INFO [stdout] test src/lib.rs - Ulid::from (line 703) ... ok
Dec 13 17:17:12.019 INFO [stdout] test src/lib.rs - Ulid::increment (line 489) ... ok
Dec 13 17:17:12.647 INFO [stdout] test src/lib.rs - Ulid::from (line 765) ... ok
Dec 13 17:17:13.195 INFO [stdout] test src/lib.rs - Ulid::from_timestamp_with_rng (line 296) ... ok
Dec 13 17:17:13.855 INFO [stdout] test src/lib.rs - Ulid::generate (line 217) ... ok
Dec 13 17:17:14.135 INFO [stdout] test src/lib.rs - Ulid::from (line 753) ... ok
Dec 13 17:17:14.991 INFO [stdout] test src/lib.rs - Ulid::increment (line 498) ... ok
Dec 13 17:17:16.971 INFO [stdout] test src/lib.rs - Ulid::next_monotonic (line 243) ... ok
Dec 13 17:17:18.283 INFO [stdout] test src/lib.rs - Ulid::next_monotonic_from_timestamp_with_rng (line 332) ... ok
Dec 13 17:17:18.611 INFO [stdout] test src/lib.rs - Ulid::increment (line 507) ... ok
Dec 13 17:17:20.571 INFO [stdout] test src/lib.rs - Ulid::next_monotonic_from_timestamp_with_rng (line 350) ... ok
Dec 13 17:17:20.763 INFO [stdout] test src/lib.rs - Ulid::next_monotonic_from_timestamp_with_rng (line 341) ... ok
Dec 13 17:17:21.583 INFO [stdout] test src/lib.rs - Ulid::next_strictly_monotonic_from_timestamp_with_rng (line 385) ... ok
Dec 13 17:17:22.575 INFO [stdout] test src/lib.rs - Ulid::next_strictly_monotonic (line 269) ... ok
Dec 13 17:17:23.939 INFO [stdout] test src/lib.rs - Ulid::next_strictly_monotonic_from_timestamp_with_rng (line 394) ... ok
Dec 13 17:17:24.468 INFO [stdout] test src/lib.rs - Ulid::timestamp (line 438) ... ok
Dec 13 17:17:25.193 INFO [stdout] test src/lib.rs - Ulid::next_strictly_monotonic_from_timestamp_with_rng (line 403) ... ok
Dec 13 17:17:25.417 INFO [stdout] test src/lib.rs - Ulid::to_string (line 533) ... ok
Dec 13 17:17:26.645 INFO [stdout] test src/lib.rs - [u8; 16]::from (line 634) ... ok
Dec 13 17:17:26.791 INFO [stdout] test src/lib.rs - Ulid::to_string (line 541) ... ok
Dec 13 17:17:26.866 INFO [stdout] test src/lib.rs - generate_ulid_bytes (line 195) ... ok
Dec 13 17:17:27.008 INFO [stdout] test src/lib.rs - [u8; 16]::from (line 649) ... ok
Dec 13 17:17:27.913 INFO [stdout] test src/lib.rs - generate_ulid_string (line 179) ... ok
Dec 13 17:17:27.931 INFO [stdout] test src/lib.rs - u128::from (line 785) ... ok
Dec 13 17:17:28.421 INFO [stdout] test src/lib.rs - u128::from (line 797) ... ok
Dec 13 17:17:28.421 INFO [stdout] 
Dec 13 17:17:28.421 INFO [stdout] test result: ok. 51 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 17:17:28.421 INFO [stdout] 
Dec 13 17:17:28.453 INFO [stderr] su: No module specific data is present
Dec 13 17:17:28.914 INFO running `"docker" "inspect" "445015c2b63a9a611b8c16e462283004d3e4333008aa709727d34e600cfe54d7"`
Dec 13 17:17:29.147 INFO running `"docker" "rm" "-f" "445015c2b63a9a611b8c16e462283004d3e4333008aa709727d34e600cfe54d7"`
Dec 13 17:17:29.446 INFO [stdout] 445015c2b63a9a611b8c16e462283004d3e4333008aa709727d34e600cfe54d7