[INFO] cloning repository https://github.com/tigerfsh/rust-exercism
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/tigerfsh/rust-exercism" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Ftigerfsh%2Frust-exercism", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Ftigerfsh%2Frust-exercism'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 8a0421cf0fd6cc520657eee635ca0928aff79ab7
[INFO] testing tigerfsh/rust-exercism against try#bd7d74411512a3dd3b35d2f699c51dd2557c7e7e+cargoflags=-Zbuild-dir-new-layout for pr-149852-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Ftigerfsh%2Frust-exercism" "/workspace/builds/worker-2-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-2-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/tigerfsh/rust-exercism
[INFO] finished tweaking git repo https://github.com/tigerfsh/rust-exercism
[INFO] tweaked toml for git repo https://github.com/tigerfsh/rust-exercism written to /workspace/builds/worker-2-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/tigerfsh/rust-exercism on toolchain bd7d74411512a3dd3b35d2f699c51dd2557c7e7e
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+bd7d74411512a3dd3b35d2f699c51dd2557c7e7e" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/tigerfsh/rust-exercism already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+bd7d74411512a3dd3b35d2f699c51dd2557c7e7e" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+bd7d74411512a3dd3b35d2f699c51dd2557c7e7e" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 2886b33dbfcd8e8cf11c87139965a714e8df432ac56194a89e8213f6f1271944
[INFO] running `Command { std: "docker" "start" "-a" "2886b33dbfcd8e8cf11c87139965a714e8df432ac56194a89e8213f6f1271944", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "2886b33dbfcd8e8cf11c87139965a714e8df432ac56194a89e8213f6f1271944", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2886b33dbfcd8e8cf11c87139965a714e8df432ac56194a89e8213f6f1271944", kill_on_drop: false }`
[INFO] [stdout] 2886b33dbfcd8e8cf11c87139965a714e8df432ac56194a89e8213f6f1271944
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+bd7d74411512a3dd3b35d2f699c51dd2557c7e7e" "build" "--frozen" "--message-format=json" "-Zbuild-dir-new-layout", kill_on_drop: false }`
[INFO] [stdout] cf64034c6754587c78a35ba68535c45dda061a8d9b41a7525701ca619385c76d
[INFO] running `Command { std: "docker" "start" "-a" "cf64034c6754587c78a35ba68535c45dda061a8d9b41a7525701ca619385c76d", kill_on_drop: false }`
[INFO] [stderr]    Compiling deranged v0.5.3
[INFO] [stderr]    Compiling time-macros v0.2.24
[INFO] [stderr]    Compiling time v0.3.43
[INFO] [stderr]    Compiling my-example v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 2.47s
[INFO] running `Command { std: "docker" "inspect" "cf64034c6754587c78a35ba68535c45dda061a8d9b41a7525701ca619385c76d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "cf64034c6754587c78a35ba68535c45dda061a8d9b41a7525701ca619385c76d", kill_on_drop: false }`
[INFO] [stdout] cf64034c6754587c78a35ba68535c45dda061a8d9b41a7525701ca619385c76d
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+bd7d74411512a3dd3b35d2f699c51dd2557c7e7e" "test" "--frozen" "--no-run" "--message-format=json" "-Zbuild-dir-new-layout", kill_on_drop: false }`
[INFO] [stdout] 217a472a2b914a8c1bbfcc4247dd9bb7d0f700cf43a379691991f4d1502d88f1
[INFO] running `Command { std: "docker" "start" "-a" "217a472a2b914a8c1bbfcc4247dd9bb7d0f700cf43a379691991f4d1502d88f1", kill_on_drop: false }`
[INFO] [stderr]    Compiling my-example v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.03s
[INFO] running `Command { std: "docker" "inspect" "217a472a2b914a8c1bbfcc4247dd9bb7d0f700cf43a379691991f4d1502d88f1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "217a472a2b914a8c1bbfcc4247dd9bb7d0f700cf43a379691991f4d1502d88f1", kill_on_drop: false }`
[INFO] [stdout] 217a472a2b914a8c1bbfcc4247dd9bb7d0f700cf43a379691991f4d1502d88f1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+bd7d74411512a3dd3b35d2f699c51dd2557c7e7e" "test" "--frozen" "-Zbuild-dir-new-layout", kill_on_drop: false }`
[INFO] [stdout] f90fdedd3df228fe7d156da7637c35513a7dffcbd0bf171fbeb830d68c17f132
[INFO] running `Command { std: "docker" "start" "-a" "f90fdedd3df228fe7d156da7637c35513a7dffcbd0bf171fbeb830d68c17f132", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.02s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/my-example/d3c2fd471dcf409c/deps/my_example-d3c2fd471dcf409c)
[INFO] [stdout] 
[INFO] [stdout] running 89 tests
[INFO] [stdout] test abbreviate_tests::test_basic ... ok
[INFO] [stdout] test abbreviate_tests::test_hyphenated ... ok
[INFO] [stdout] test abbreviate_tests::test_mixed_case_and_punctuation ... ok
[INFO] [stdout] test abbreviate_tests::test_multiple_hyphens_and_spaces ... ok
[INFO] [stdout] test abbreviate_tests::test_leading_and_trailing_whitespace ... ok
[INFO] [stdout] test abbreviate_tests::test_upper_char_in_word ... ok
[INFO] [stdout] test anagram_tests::test_case_insensitive ... ok
[INFO] [stdout] test anagram_tests::test_multiple_anagrams ... ok
[INFO] [stdout] test anagram_tests::test_no_anagrams ... ok
[INFO] [stdout] test abbreviate_tests::test_single_word ... ok
[INFO] [stdout] test abbreviate_tests::test_punctuation ... ok
[INFO] [stdout] test anagram_tests::test_simple_anagram ... ok
[INFO] [stdout] test anagram_tests::test_same_word_not_anagram ... ok
[INFO] [stdout] test armstrong_tests::test_four_digits ... ok
[INFO] [stdout] test armstrong_tests::test_large_number ... ok
[INFO] [stdout] test armstrong_tests::test_two_digits ... ok
[INFO] [stdout] test clock_tests::test_add_minutes_large_negative ... ok
[INFO] [stdout] test armstrong_tests::test_single_digit ... ok
[INFO] [stdout] test clock_tests::test_add_minutes_negative ... ok
[INFO] [stdout] test clock_tests::test_new_large_negative_minutes ... ok
[INFO] [stdout] test clock_tests::test_add_minutes_multiple_days ... ok
[INFO] [stdout] test armstrong_tests::test_three_digits ... ok
[INFO] [stdout] test clock_tests::test_new_overflow_hours ... ok
[INFO] [stdout] test clock_tests::test_new_negative_minutes ... ok
[INFO] [stdout] test clock_tests::test_new_overflow_minutes ... ok
[INFO] [stdout] test clock_tests::test_new_to_string ... ok
[INFO] [stdout] test abbreviate_tests::test_empty_string ... ok
[INFO] [stdout] test collatz_tests::test_collatz_basic ... ok
[INFO] [stdout] test anagram_tests::test_unicode_anagram ... ok
[INFO] [stdout] test clock_tests::test_new_basic ... ok
[INFO] [stdout] test clock_tests::test_add_minutes_basic ... ok
[INFO] [stdout] test collatz_tests::test_collatz_large ... ok
[INFO] [stdout] test clock_tests::test_new_eq ... ok
[INFO] [stdout] test clock_tests::test_new_negative_hours ... ok
[INFO] [stdout] test collatz_tests::test_collatz_zero ... ok
[INFO] [stdout] test clock_tests::test_add_minutes_overflow_hour ... ok
[INFO] [stdout] test factors_tests::test_factors_of_1 ... ok
[INFO] [stdout] test factors_tests::test_factors_of_3 ... ok
[INFO] [stdout] test factors_tests::test_factors_of_4 ... ok
[INFO] [stdout] test factors_tests::test_factors_of_60 ... ok
[INFO] [stdout] test factors_tests::test_factors_of_large_composite ... ok
[INFO] [stdout] test factors_tests::test_factors_of_large_prime ... ok
[INFO] [stdout] test high_scores_tests::test_latest_score_empty ... ok
[INFO] [stdout] test high_scores_tests::test_latest_score ... ok
[INFO] [stdout] test high_scores_tests::test_personal_best ... ok
[INFO] [stdout] test high_scores_tests::test_personal_best_empty ... ok
[INFO] [stdout] test factors_tests::test_factors_of_6 ... ok
[INFO] [stdout] test high_scores_tests::test_personal_top_three ... ok
[INFO] [stdout] test high_scores_tests::test_personal_top_three_with_ties ... ok
[INFO] [stdout] test high_scores_tests::test_scores_with_one_element ... ok
[INFO] [stdout] test luhn_tests::test_is_valid ... ok
[INFO] [stdout] test high_scores_tests::test_personal_top_three_empty ... ok
[INFO] [stdout] test nth_prime_tests::test_first_prime ... ok
[INFO] [stdout] test nth_prime_tests::test_second_prime ... ok
[INFO] [stdout] test nth_prime_tests::test_sixth_prime ... ok
[INFO] [stdout] test nth_prime_tests::test_large_prime ... ok
[INFO] [stdout] test high_scores_tests::test_scores_with_duplicates ... ok
[INFO] [stdout] test high_scores_tests::test_scores_are_returned ... ok
[INFO] [stdout] test planet_tests::test_earth_years ... ok
[INFO] [stdout] test nth_prime_tests::test_tenth_prime ... ok
[INFO] [stdout] test planet_tests::test_mercury_years ... ok
[INFO] [stdout] test factors_tests::test_factors_of_2 ... ok
[INFO] [stdout] test raindrops_tests::test_divisible_by_3 ... ok
[INFO] [stdout] test raindrops_tests::test_divisible_by_3_5_7 ... ok
[INFO] [stdout] test raindrops_tests::test_divisible_by_3_and_5 ... ok
[INFO] [stdout] test raindrops_tests::test_divisible_by_3_and_7 ... ok
[INFO] [stdout] test raindrops_tests::test_divisible_by_5 ... ok
[INFO] [stdout] test raindrops_tests::test_divisible_by_5_and_7 ... ok
[INFO] [stdout] test raindrops_tests::test_zero ... ok
[INFO] [stdout] test sublist_tests::test_both_empty ... ok
[INFO] [stdout] test high_scores_tests::test_personal_top_three_less_than_three ... ok
[INFO] [stdout] test sublist_tests::test_equal_lists ... ok
[INFO] [stdout] test raindrops_tests::test_divisible_by_7 ... ok
[INFO] [stdout] test sublist_tests::test_empty_and_nonempty ... ok
[INFO] [stdout] test sublist_tests::test_no_overlap ... ok
[INFO] [stdout] test sublist_tests::test_repeated_elements ... ok
[INFO] [stdout] test sublist_tests::test_sublist_at_end ... ok
[INFO] [stdout] test sublist_tests::test_single_element_sublist ... ok
[INFO] [stdout] test sublist_tests::test_sublist_at_start ... ok
[INFO] [stdout] test sublist_tests::test_superlist ... ok
[INFO] [stdout] test sublist_tests::test_unequal_lists ... ok
[INFO] [stdout] test raindrops_tests::test_not_divisible_by_3_5_7 ... ok
[INFO] [stdout] test tests::test_add ... ok
[INFO] [stdout] test tests::test_after ... ok
[INFO] [stdout] test tests::test_after_v2 ... ok
[INFO] [stdout] test transform_tests::test_transform_basic ... ok
[INFO] [stdout] test transform_tests::test_transform_empty ... ok
[INFO] [stdout] test transform_tests::test_transform_mixed_case ... ok
[INFO] [stdout] test abbreviate_tests::test_all_lowercase ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 89 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/build/my-example/3743372727ce7d59/deps/my_example-3743372727ce7d59)
[INFO] [stdout] 
[INFO] [stderr]      Running tests/integration_test.rs (/opt/rustwide/target/debug/build/my-example/c58a54a43a54c71a/deps/integration_test-c58a54a43a54c71a)
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests my_example
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "f90fdedd3df228fe7d156da7637c35513a7dffcbd0bf171fbeb830d68c17f132", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f90fdedd3df228fe7d156da7637c35513a7dffcbd0bf171fbeb830d68c17f132", kill_on_drop: false }`
[INFO] [stdout] f90fdedd3df228fe7d156da7637c35513a7dffcbd0bf171fbeb830d68c17f132