Dec 07 01:37:47.677 INFO testing rs_algo-0.1.7 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 07 01:37:47.677 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-4/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 07 01:37:48.090 INFO [stdout] cd12c4cf631c7649892b22812152c48280a0c4c96ddb810177a62b1ea0df4723
Dec 07 01:37:48.098 INFO running `"docker" "start" "-a" "cd12c4cf631c7649892b22812152c48280a0c4c96ddb810177a62b1ea0df4723"`
Dec 07 01:37:49.380 INFO [stderr] usermod: no changes
Dec 07 01:37:49.428 INFO [stderr]    Compiling rs_algo v0.1.7 (/source)
Dec 07 01:37:51.947 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.55s
Dec 07 01:37:51.952 INFO [stderr] su: No module specific data is present
Dec 07 01:37:52.902 INFO running `"docker" "inspect" "cd12c4cf631c7649892b22812152c48280a0c4c96ddb810177a62b1ea0df4723"`
Dec 07 01:37:53.232 INFO running `"docker" "rm" "-f" "cd12c4cf631c7649892b22812152c48280a0c4c96ddb810177a62b1ea0df4723"`
Dec 07 01:37:53.476 INFO [stdout] cd12c4cf631c7649892b22812152c48280a0c4c96ddb810177a62b1ea0df4723
Dec 07 01:37:53.484 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-4/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 07 01:37:53.775 INFO [stdout] 2d819c2b14957edbf595c44a50827d472ddc417cb791d0a0402c4011b1bd3202
Dec 07 01:37:53.777 INFO running `"docker" "start" "-a" "2d819c2b14957edbf595c44a50827d472ddc417cb791d0a0402c4011b1bd3202"`
Dec 07 01:37:54.681 INFO [stderr] usermod: no changes
Dec 07 01:37:54.756 INFO [stderr]    Compiling rs_algo v0.1.7 (/source)
Dec 07 01:37:57.517 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.80s
Dec 07 01:37:57.518 INFO [stderr] su: No module specific data is present
Dec 07 01:37:58.126 INFO running `"docker" "inspect" "2d819c2b14957edbf595c44a50827d472ddc417cb791d0a0402c4011b1bd3202"`
Dec 07 01:37:58.396 INFO running `"docker" "rm" "-f" "2d819c2b14957edbf595c44a50827d472ddc417cb791d0a0402c4011b1bd3202"`
Dec 07 01:37:58.689 INFO [stdout] 2d819c2b14957edbf595c44a50827d472ddc417cb791d0a0402c4011b1bd3202
Dec 07 01:37:58.700 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-4/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 07 01:37:58.965 INFO [stdout] 0a7c4ce7c5d57c4d65435356c4f2b21ba96f244e8664a6976fe115fc7d5a3989
Dec 07 01:37:58.967 INFO running `"docker" "start" "-a" "0a7c4ce7c5d57c4d65435356c4f2b21ba96f244e8664a6976fe115fc7d5a3989"`
Dec 07 01:38:00.640 INFO [stderr] usermod: no changes
Dec 07 01:38:00.704 INFO [stdout] 
Dec 07 01:38:00.704 INFO [stdout] running 26 tests
Dec 07 01:38:00.704 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.02s
Dec 07 01:38:00.704 INFO [stderr]      Running /target/debug/deps/rs_algo-d2925d140a86b3ae
Dec 07 01:38:00.712 INFO [stdout] test compare::subsequence::tests::lc_subsequence_test ... ok
Dec 07 01:38:00.712 INFO [stdout] test compare::subsequence::tests::lc_subsequence_one_test ... ok
Dec 07 01:38:00.712 INFO [stdout] test compare::subsequence::tests::lc_subsequence_empty_test ... ok
Dec 07 01:38:00.713 INFO [stdout] test compare::substring::tests::lc_substring_empty_test ... ok
Dec 07 01:38:00.713 INFO [stdout] test math::tests::factors_test ... ok
Dec 07 01:38:00.713 INFO [stdout] test compare::substring::tests::lc_substring_get_string_test ... ok
Dec 07 01:38:00.713 INFO [stdout] test math::tests::relative_prime_test ... ok
Dec 07 01:38:00.713 INFO [stdout] test math::tests::gcd_test ... ok
Dec 07 01:38:00.713 INFO [stdout] test sort::bubble::tests::bubble_sort_str ... ok
Dec 07 01:38:00.713 INFO [stdout] test compare::substring::tests::lc_substring_test ... ok
Dec 07 01:38:00.713 INFO [stdout] test sort::insertion::tests::insertion_sort ... ok
Dec 07 01:38:00.713 INFO [stdout] test sort::bubble::tests::bubble_sort ... ok
Dec 07 01:38:00.714 INFO [stdout] test sort::insertion::tests::insertion_sort_empty ... ok
Dec 07 01:38:00.714 INFO [stdout] test sort::insertion::tests::insertion_sort_str ... ok
Dec 07 01:38:00.714 INFO [stdout] test sort::merge::tests::merge_empty_array ... ok
Dec 07 01:38:00.714 INFO [stdout] test sort::merge::tests::merge_single_array ... ok
Dec 07 01:38:00.714 INFO [stdout] test sort::merge::tests::merge_str_array ... ok
Dec 07 01:38:00.714 INFO [stdout] test sort::quick::tests::quick_sort ... ok
Dec 07 01:38:00.714 INFO [stdout] test sort::quick::tests::quick_sort_empty ... ok
Dec 07 01:38:00.714 INFO [stdout] test sort::merge::tests::merge_test ... ok
Dec 07 01:38:00.714 INFO [stdout] test sort::quick::tests::quick_sort_single ... ok
Dec 07 01:38:00.714 INFO [stdout] test sort::quick::tests::quick_sort_str ... ok
Dec 07 01:38:00.714 INFO [stdout] test search::binary::test::binary_search_none ... ok
Dec 07 01:38:00.714 INFO [stdout] test search::binary::test::binary_search_index ... ok
Dec 07 01:38:00.715 INFO [stdout] test search::binary::test::binary_search ... ok
Dec 07 01:38:00.715 INFO [stdout] test sort::bubble::tests::bubble_sort_empty ... ok
Dec 07 01:38:00.715 INFO [stdout] 
Dec 07 01:38:00.715 INFO [stdout] test result: ok. 26 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 01:38:00.715 INFO [stdout] 
Dec 07 01:38:00.721 INFO [stderr]      Running /target/debug/deps/rs_algo-37aa523fbd3bf5d7
Dec 07 01:38:00.724 INFO [stdout] 
Dec 07 01:38:00.724 INFO [stdout] running 0 tests
Dec 07 01:38:00.724 INFO [stdout] 
Dec 07 01:38:00.724 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 01:38:00.724 INFO [stdout] 
Dec 07 01:38:00.724 INFO [stderr]    Doc-tests rs_algo
Dec 07 01:38:01.690 INFO [stdout] 
Dec 07 01:38:01.690 INFO [stdout] running 17 tests
Dec 07 01:38:08.832 INFO [stdout] test src/search/binary.rs - search::binary::index_of (line 10) ... ok
Dec 07 01:38:09.212 INFO [stdout] test src/compare/subsequence.rs - compare::subsequence::LCSubsequence (line 9) ... ok
Dec 07 01:38:09.693 INFO [stdout] test src/math/mod.rs - math::gcd (line 16) ... ok
Dec 07 01:38:09.892 INFO [stdout] test src/math/mod.rs - math::relatively_prime (line 49) ... ok
Dec 07 01:38:10.141 INFO [stdout] test src/math/mod.rs - math::factors (line 63) ... ok
Dec 07 01:38:10.143 INFO [stdout] test src/compare/subsequence.rs - compare::subsequence::LCSubsequence::fmt (line 29) ... ok
Dec 07 01:38:10.152 INFO [stdout] test src/compare/substring.rs - compare::substring::LCSubstring::fmt (line 31) ... ok
Dec 07 01:38:10.337 INFO [stdout] test src/compare/substring.rs - compare::substring::LCSubstring (line 8) ... ok
Dec 07 01:38:15.656 INFO [stdout] test src/search/binary.rs - search::binary::search (line 52) ... ok
Dec 07 01:38:16.260 INFO [stdout] test src/sort/bubble.rs - sort::bubble::sort_with_time (line 54) ... ok
Dec 07 01:38:16.680 INFO [stdout] test src/sort/bubble.rs - sort::bubble::sort (line 15) ... ok
Dec 07 01:38:16.896 INFO [stdout] test src/sort/quick.rs - sort::quick::sort (line 45) ... ok
Dec 07 01:38:17.326 INFO [stdout] test src/sort/insertion.rs - sort::insertion::sort (line 6) ... ok
Dec 07 01:38:17.392 INFO [stdout] test src/sort/merge.rs - sort::merge::sort (line 63) ... ok
Dec 07 01:38:17.720 INFO [stdout] test src/sort/merge.rs - sort::merge::sort_with_time (line 85) ... ok
Dec 07 01:38:17.721 INFO [stdout] test src/sort/insertion.rs - sort::insertion::sort_with_time (line 38) ... ok
Dec 07 01:38:18.634 INFO [stdout] test src/sort/quick.rs - sort::quick::sort_with_time (line 67) ... ok
Dec 07 01:38:18.634 INFO [stdout] 
Dec 07 01:38:18.634 INFO [stdout] test result: ok. 17 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 01:38:18.634 INFO [stdout] 
Dec 07 01:38:18.660 INFO [stderr] su: No module specific data is present
Dec 07 01:38:19.170 INFO running `"docker" "inspect" "0a7c4ce7c5d57c4d65435356c4f2b21ba96f244e8664a6976fe115fc7d5a3989"`
Dec 07 01:38:19.466 INFO running `"docker" "rm" "-f" "0a7c4ce7c5d57c4d65435356c4f2b21ba96f244e8664a6976fe115fc7d5a3989"`
Dec 07 01:38:19.760 INFO [stdout] 0a7c4ce7c5d57c4d65435356c4f2b21ba96f244e8664a6976fe115fc7d5a3989