Dec 05 21:31:02.734 INFO testing huxi/rusty_ulid against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 05 21:31:02.734 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-3/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 05 21:31:02.899 INFO [stdout] b07b99c652ecb6ed6ab66dc507181197040b7ab7ff4d7117123df00fcdcb5a1e
Dec 05 21:31:02.901 INFO running `"docker" "start" "-a" "b07b99c652ecb6ed6ab66dc507181197040b7ab7ff4d7117123df00fcdcb5a1e"`
Dec 05 21:31:03.506 INFO [stderr] usermod: no changes
Dec 05 21:31:03.752 INFO [stderr]    Compiling rusty_ulid v0.6.1 (/source)
Dec 05 21:31:06.430 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.89s
Dec 05 21:31:06.439 INFO [stderr] su: No module specific data is present
Dec 05 21:31:07.314 INFO running `"docker" "inspect" "b07b99c652ecb6ed6ab66dc507181197040b7ab7ff4d7117123df00fcdcb5a1e"`
Dec 05 21:31:07.645 INFO running `"docker" "rm" "-f" "b07b99c652ecb6ed6ab66dc507181197040b7ab7ff4d7117123df00fcdcb5a1e"`
Dec 05 21:31:07.836 INFO [stdout] b07b99c652ecb6ed6ab66dc507181197040b7ab7ff4d7117123df00fcdcb5a1e
Dec 05 21:31:07.842 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-3/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 05 21:31:08.057 INFO [stdout] 732ba10a792d45bf992a0ccf17ee19a70ca3575e3b28a1fc20a99d787490af52
Dec 05 21:31:08.059 INFO running `"docker" "start" "-a" "732ba10a792d45bf992a0ccf17ee19a70ca3575e3b28a1fc20a99d787490af52"`
Dec 05 21:31:08.910 INFO [stderr] usermod: no changes
Dec 05 21:31:09.121 INFO [stderr]    Compiling criterion-plot v0.2.5
Dec 05 21:31:09.125 INFO [stderr]    Compiling simplelog v0.5.3
Dec 05 21:31:09.126 INFO [stderr]    Compiling handlebars v0.32.4
Dec 05 21:31:16.546 INFO [stderr]    Compiling criterion v0.2.5
Dec 05 21:31:26.339 INFO [stderr]    Compiling rusty_ulid v0.6.1 (/source)
Dec 05 21:31:28.544 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 19.61s
Dec 05 21:31:28.560 INFO [stderr] su: No module specific data is present
Dec 05 21:31:28.941 INFO running `"docker" "inspect" "732ba10a792d45bf992a0ccf17ee19a70ca3575e3b28a1fc20a99d787490af52"`
Dec 05 21:31:29.032 INFO running `"docker" "rm" "-f" "732ba10a792d45bf992a0ccf17ee19a70ca3575e3b28a1fc20a99d787490af52"`
Dec 05 21:31:29.107 INFO [stdout] 732ba10a792d45bf992a0ccf17ee19a70ca3575e3b28a1fc20a99d787490af52
Dec 05 21:31:29.108 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-3/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 05 21:31:29.286 INFO [stdout] d1c928b12feb4392ab1e856c5c386cab4f9e615d07c51db8154def3f200d39a5
Dec 05 21:31:29.288 INFO running `"docker" "start" "-a" "d1c928b12feb4392ab1e856c5c386cab4f9e615d07c51db8154def3f200d39a5"`
Dec 05 21:31:29.662 INFO [stderr] usermod: no changes
Dec 05 21:31:29.804 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.12s
Dec 05 21:31:29.820 INFO [stderr]      Running /target/debug/deps/rusty_ulid-5b9d7dd82eccdb33
Dec 05 21:31:29.824 INFO [stdout] 
Dec 05 21:31:29.824 INFO [stdout] running 21 tests
Dec 05 21:31:29.836 INFO [stdout] test crockford::tests::append_crockford_u64_tuple_test_cases ... ok
Dec 05 21:31:29.836 INFO [stdout] test crockford::tests::parse_crockford_u128_test_cases ... ok
Dec 05 21:31:29.836 INFO [stdout] test crockford::tests::decoding_error_display_trait ... ok
Dec 05 21:31:29.836 INFO [stdout] test crockford::tests::parse_crockford_u64_tuple_test_cases ... ok
Dec 05 21:31:29.836 INFO [stdout] test tests::eq_cmp_sanity_checks ... ok
Dec 05 21:31:29.836 INFO [stdout] test crockford::tests::append_crockford_u128_test_cases ... ok
Dec 05 21:31:29.836 INFO [stdout] test crockford::tests::decoding_error_causes ... ok
Dec 05 21:31:29.836 INFO [stdout] test tests::from_str_failure_invalid_unicode ... ok
Dec 05 21:31:29.836 INFO [stdout] test tests::from_str_failure_too_long ... ok
Dec 05 21:31:29.846 INFO [stdout] test tests::from_string_to_string_special_cases ... ok
Dec 05 21:31:29.846 INFO [stdout] test tests::hash_sanity_checks ... ok
Dec 05 21:31:29.846 INFO [stdout] test tests::from_str_failure_overflow ... ok
Dec 05 21:31:29.846 INFO [stdout] test tests::from_str_failure_too_short ... ok
Dec 05 21:31:29.846 INFO [stdout] test tests::fn_quickstart ... ok
Dec 05 21:31:29.846 INFO [stdout] test tests::from_string_to_string ... ok
Dec 05 21:31:29.846 INFO [stdout] test tests::parse_quickstart ... ok
Dec 05 21:31:29.860 INFO [stdout] test crockford::tests::description_returns_deprecation_message ... ok
Dec 05 21:31:29.864 INFO [stdout] test tests::test_from_timestamp_with_rng ... ok
Dec 05 21:31:29.864 INFO [stdout] test tests::increment ... ok
Dec 05 21:31:29.876 INFO [stdout] test tests::quickstart ... ok
Dec 05 21:31:29.943 INFO [stdout] test tests::y10889_bug ... ok
Dec 05 21:31:29.943 INFO [stdout] 
Dec 05 21:31:29.943 INFO [stdout] test result: ok. 21 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 21:31:29.943 INFO [stdout] 
Dec 05 21:31:29.952 INFO [stderr]      Running /target/debug/deps/rusty_ulid-1434865377b3f2fd
Dec 05 21:31:29.956 INFO [stdout] 
Dec 05 21:31:29.956 INFO [stdout] running 17 tests
Dec 05 21:31:29.956 INFO [stdout] test crockford::tests::append_crockford_u64_tuple_test_cases ... ok
Dec 05 21:31:29.956 INFO [stdout] test crockford::tests::append_crockford_u128_test_cases ... ok
Dec 05 21:31:29.956 INFO [stdout] test tests::help_short_returns_no_error ... ok
Dec 05 21:31:29.956 INFO [stdout] test tests::help_long_returns_no_error ... ok
Dec 05 21:31:29.956 INFO [stdout] test crockford::tests::parse_crockford_u128_test_cases ... ok
Dec 05 21:31:29.956 INFO [stdout] test crockford::tests::parse_crockford_u64_tuple_test_cases ... ok
Dec 05 21:31:29.956 INFO [stdout] test crockford::tests::decoding_error_display_trait ... ok
Dec 05 21:31:29.956 INFO [stdout] test crockford::tests::description_returns_deprecation_message ... ok
Dec 05 21:31:29.956 INFO [stdout] test tests::verbose_short_returns_no_error ... ok
Dec 05 21:31:29.962 INFO [stdout] test tests::version_long_returns_no_error ... ok
Dec 05 21:31:29.962 INFO [stdout] test tests::verbose_long_returns_no_error ... ok
Dec 05 21:31:29.962 INFO [stdout] test tests::version_short_returns_no_error ... ok
Dec 05 21:31:29.965 INFO [stdout] test tests::invalid_value_returns_error ... ok
Dec 05 21:31:29.965 INFO [stderr]    Doc-tests rusty_ulid
Dec 05 21:31:29.965 INFO [stdout] test tests::no_args_return_no_error ... ok
Dec 05 21:31:29.965 INFO [stdout] test tests::valid_values_return_no_error ... ok
Dec 05 21:31:29.965 INFO [stdout] test tests::valid_verbose_values_return_no_error ... ok
Dec 05 21:31:29.965 INFO [stdout] test crockford::tests::decoding_error_causes ... ok
Dec 05 21:31:29.965 INFO [stdout] 
Dec 05 21:31:29.965 INFO [stdout] test result: ok. 17 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 21:31:29.965 INFO [stdout] 
Dec 05 21:31:31.040 INFO [stdout] 
Dec 05 21:31:31.040 INFO [stdout] running 51 tests
Dec 05 21:31:35.164 INFO [stdout] test src/crockford.rs - crockford::append_crockford_u64_tuple (line 346) ... ok
Dec 05 21:31:35.608 INFO [stdout] test src/crockford.rs - crockford::append_crockford_u128 (line 167) ... ok
Dec 05 21:31:35.955 INFO [stdout] test src/crockford.rs - crockford::append_crockford_u64_tuple (line 339) ... ok
Dec 05 21:31:35.959 INFO [stdout] test src/crockford.rs - crockford::append_crockford_u64_tuple (line 353) ... ok
Dec 05 21:31:36.320 INFO [stdout] test src/crockford.rs - crockford::append_crockford_u128 (line 160) ... ok
Dec 05 21:31:36.696 INFO [stdout] test src/crockford.rs - crockford::append_crockford_u128 (line 174) ... ok
Dec 05 21:31:36.700 INFO [stdout] test src/crockford.rs - crockford::append_crockford_u128 (line 153) ... ok
Dec 05 21:31:36.818 INFO [stdout] test src/crockford.rs - crockford::append_crockford_u64_tuple (line 332) ... ok
Dec 05 21:31:39.072 INFO [stdout] test src/crockford.rs - crockford::parse_crockford_u128 (line 276) ... ok
Dec 05 21:31:39.241 INFO [stdout] test src/crockford.rs - crockford::parse_crockford_u64_tuple (line 406) ... ok
Dec 05 21:31:39.241 INFO [stdout] test src/crockford.rs - crockford::parse_crockford_u128 (line 214) ... ok
Dec 05 21:31:39.352 INFO [stdout] test src/crockford.rs - crockford::parse_crockford_u128 (line 224) ... ok
Dec 05 21:31:39.663 INFO [stdout] test src/crockford.rs - crockford::parse_crockford_u128 (line 247) ... ok
Dec 05 21:31:39.743 INFO [stdout] test src/crockford.rs - crockford::parse_crockford_u128 (line 254) ... ok
Dec 05 21:31:40.240 INFO [stdout] test src/crockford.rs - crockford::parse_crockford_u64_tuple (line 396) ... ok
Dec 05 21:31:40.256 INFO [stdout] test src/crockford.rs - crockford::parse_crockford_u128 (line 263) ... ok
Dec 05 21:31:41.296 INFO [stdout] test src/crockford.rs - crockford::parse_crockford_u64_tuple (line 436) ... ok
Dec 05 21:31:41.484 INFO [stdout] test src/crockford.rs - crockford::parse_crockford_u64_tuple (line 445) ... ok
Dec 05 21:31:41.623 INFO [stdout] test src/lib.rs - (u64, u64)::from (line 735) ... ok
Dec 05 21:31:41.704 INFO [stdout] test src/crockford.rs - crockford::parse_crockford_u64_tuple (line 429) ... ok
Dec 05 21:31:41.708 INFO [stdout] test src/crockford.rs - crockford::parse_crockford_u64_tuple (line 458) ... ok
Dec 05 21:31:41.894 INFO [stdout] test src/lib.rs - (u64, u64)::from (line 746) ... ok
Dec 05 21:31:42.644 INFO [stdout] test src/lib.rs - Ulid::datetime (line 486) ... ok
Dec 05 21:31:43.312 INFO [stdout] test src/lib.rs - Ulid::from (line 595) ... ok
Dec 05 21:31:44.727 INFO [stdout] test src/lib.rs - Ulid::from (line 609) ... ok
Dec 05 21:31:44.964 INFO [stdout] test src/lib.rs - Ulid::from (line 706) ... ok
Dec 05 21:31:45.022 INFO [stdout] test src/lib.rs - Ulid::from (line 764) ... ok
Dec 05 21:31:45.320 INFO [stdout] test src/lib.rs - Ulid::from (line 775) ... ok
Dec 05 21:31:45.404 INFO [stdout] test src/lib.rs - Ulid::from (line 717) ... ok
Dec 05 21:31:45.676 INFO [stdout] test src/lib.rs - Ulid::from_timestamp_with_rng (line 295) ... ok
Dec 05 21:31:45.924 INFO [stdout] test src/lib.rs - Ulid::generate (line 219) ... ok
Dec 05 21:31:46.376 INFO [stdout] test src/lib.rs - Ulid::increment (line 518) ... ok
Dec 05 21:31:48.636 INFO [stdout] test src/lib.rs - Ulid::next_monotonic_from_timestamp_with_rng (line 347) ... ok
Dec 05 21:31:48.669 INFO [stdout] test src/lib.rs - Ulid::increment (line 525) ... ok
Dec 05 21:31:48.775 INFO [stdout] test src/lib.rs - Ulid::next_strictly_monotonic (line 269) ... ok
Dec 05 21:31:48.891 INFO [stdout] test src/lib.rs - Ulid::increment (line 532) ... ok
Dec 05 21:31:49.196 INFO [stdout] test src/lib.rs - Ulid::next_monotonic (line 244) ... ok
Dec 05 21:31:49.449 INFO [stdout] test src/lib.rs - Ulid::next_monotonic_from_timestamp_with_rng (line 335) ... ok
Dec 05 21:31:49.480 INFO [stdout] test src/lib.rs - Ulid::next_strictly_monotonic_from_timestamp_with_rng (line 398) ... ok
Dec 05 21:31:49.549 INFO [stdout] test src/lib.rs - Ulid::next_monotonic_from_timestamp_with_rng (line 359) ... ok
Dec 05 21:31:51.292 INFO [stdout] test src/lib.rs - Ulid::next_strictly_monotonic_from_timestamp_with_rng (line 422) ... ok
Dec 05 21:31:51.684 INFO [stdout] test src/lib.rs - Ulid::timestamp (line 461) ... ok
Dec 05 21:31:51.684 INFO [stdout] test src/lib.rs - Ulid::to_string (line 562) ... ok
Dec 05 21:31:52.068 INFO [stdout] test src/lib.rs - [u8; 16]::from (line 651) ... ok
Dec 05 21:31:52.508 INFO [stdout] test src/lib.rs - Ulid::next_strictly_monotonic_from_timestamp_with_rng (line 410) ... ok
Dec 05 21:31:53.056 INFO [stdout] test src/lib.rs - [u8; 16]::from (line 665) ... ok
Dec 05 21:31:53.264 INFO [stdout] test src/lib.rs - generate_ulid_bytes (line 197) ... ok
Dec 05 21:31:53.288 INFO [stdout] test src/lib.rs - Ulid::to_string (line 556) ... ok
Dec 05 21:31:54.282 INFO [stdout] test src/lib.rs - generate_ulid_string (line 181) ... ok
Dec 05 21:31:54.359 INFO [stdout] test src/lib.rs - u128::from (line 805) ... ok
Dec 05 21:31:54.435 INFO [stdout] test src/lib.rs - u128::from (line 794) ... ok
Dec 05 21:31:54.435 INFO [stdout] 
Dec 05 21:31:54.435 INFO [stdout] test result: ok. 51 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 21:31:54.435 INFO [stdout] 
Dec 05 21:31:54.476 INFO [stderr] su: No module specific data is present
Dec 05 21:31:54.822 INFO running `"docker" "inspect" "d1c928b12feb4392ab1e856c5c386cab4f9e615d07c51db8154def3f200d39a5"`
Dec 05 21:31:54.892 INFO running `"docker" "rm" "-f" "d1c928b12feb4392ab1e856c5c386cab4f9e615d07c51db8154def3f200d39a5"`
Dec 05 21:31:55.034 INFO [stdout] d1c928b12feb4392ab1e856c5c386cab4f9e615d07c51db8154def3f200d39a5