Nov 17 04:27:05.748 INFO testing dotboris/alt against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 17 04:27:05.750 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-1/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 17 04:27:06.367 INFO [stdout] 81a9e92b679fa6a36a72d406ae4a596e23a9d2fa21aab35c94acd2189dffd398
Nov 17 04:27:06.375 INFO running `"docker" "start" "-a" "81a9e92b679fa6a36a72d406ae4a596e23a9d2fa21aab35c94acd2189dffd398"`
Nov 17 04:27:07.492 INFO [stderr] usermod: no changes
Nov 17 04:27:07.664 INFO [stderr]    Compiling tempfile v2.2.0
Nov 17 04:27:07.664 INFO [stderr]    Compiling syn v0.15.15
Nov 17 04:27:07.687 INFO [stderr]    Compiling console v0.6.2
Nov 17 04:27:10.555 INFO [stderr]    Compiling dialoguer v0.1.0
Nov 17 04:27:16.865 INFO [stderr]    Compiling serde_derive v1.0.80
Nov 17 04:27:27.803 INFO [stderr]    Compiling serde v1.0.80
Nov 17 04:27:39.011 INFO [stderr]    Compiling toml v0.4.8
Nov 17 04:27:45.869 INFO [stderr]    Compiling alt v1.0.2 (/source)
Nov 17 04:27:52.996 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 45.48s
Nov 17 04:27:53.009 INFO [stderr] su: No module specific data is present
Nov 17 04:27:53.773 INFO running `"docker" "inspect" "81a9e92b679fa6a36a72d406ae4a596e23a9d2fa21aab35c94acd2189dffd398"`
Nov 17 04:27:54.105 INFO running `"docker" "rm" "-f" "81a9e92b679fa6a36a72d406ae4a596e23a9d2fa21aab35c94acd2189dffd398"`
Nov 17 04:27:54.459 INFO [stdout] 81a9e92b679fa6a36a72d406ae4a596e23a9d2fa21aab35c94acd2189dffd398
Nov 17 04:27:54.466 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-1/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 17 04:27:54.995 INFO [stdout] 620412b0240307b65f2865d947161ae420583f56fa310a234b06686995073105
Nov 17 04:27:54.997 INFO running `"docker" "start" "-a" "620412b0240307b65f2865d947161ae420583f56fa310a234b06686995073105"`
Nov 17 04:27:56.441 INFO [stderr] usermod: no changes
Nov 17 04:27:56.619 INFO [stderr]    Compiling escargot v0.3.1
Nov 17 04:27:56.619 INFO [stderr]    Compiling treeline v0.1.0
Nov 17 04:27:56.623 INFO [stderr]    Compiling predicates-core v1.0.0
Nov 17 04:27:56.630 INFO [stderr]    Compiling serde_json v1.0.32
Nov 17 04:27:58.160 INFO [stderr]    Compiling predicates v1.0.0
Nov 17 04:27:58.259 INFO [stderr]    Compiling predicates-tree v1.0.0
Nov 17 04:28:06.523 INFO [stderr]    Compiling assert_cmd v0.10.1
Nov 17 04:28:08.375 INFO [stderr]    Compiling alt v1.0.2 (/source)
Nov 17 04:28:14.471 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 18.01s
Nov 17 04:28:14.487 INFO [stderr] su: No module specific data is present
Nov 17 04:28:15.183 INFO running `"docker" "inspect" "620412b0240307b65f2865d947161ae420583f56fa310a234b06686995073105"`
Nov 17 04:28:15.517 INFO running `"docker" "rm" "-f" "620412b0240307b65f2865d947161ae420583f56fa310a234b06686995073105"`
Nov 17 04:28:15.859 INFO [stdout] 620412b0240307b65f2865d947161ae420583f56fa310a234b06686995073105
Nov 17 04:28:15.868 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-1/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 17 04:28:16.412 INFO [stdout] a7b19ee1b40edac9107523ec161beaf24cbc8e21c2990c194fd510395d25bff6
Nov 17 04:28:16.415 INFO running `"docker" "start" "-a" "a7b19ee1b40edac9107523ec161beaf24cbc8e21c2990c194fd510395d25bff6"`
Nov 17 04:28:18.091 INFO [stderr] usermod: no changes
Nov 17 04:28:18.355 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.24s
Nov 17 04:28:18.380 INFO [stderr]      Running /target/debug/deps/alt-d189bef833ba0ec1
Nov 17 04:28:18.392 INFO [stdout] 
Nov 17 04:28:18.392 INFO [stdout] running 23 tests
Nov 17 04:28:18.439 INFO [stdout] test config::tests::home_dir_should_default ... ok
Nov 17 04:28:18.440 INFO [stdout] test config::tests::home_dir_should_read_alt_home_env ... ok
Nov 17 04:28:18.440 INFO [stdout] test def_file::tests::find_bin_returns_none_when_command_not_defined ... ok
Nov 17 04:28:18.441 INFO [stdout] test def_file::tests::find_bin_returns_none_on_empty_defs ... ok
Nov 17 04:28:18.447 INFO [stdout] test scan::homebrew::tests::test_parse_version_path_php ... ok
Nov 17 04:28:18.463 INFO [stdout] test def_file::tests::find_bin_returns_none_when_version_not_defined ... ok
Nov 17 04:28:18.463 INFO [stdout] test scan::homebrew::tests::test_parse_version_path_node ... ok
Nov 17 04:28:18.464 INFO [stdout] test def_file::tests::find_bin_returns_path_when_command_and_version_defined ... ok
Nov 17 04:28:18.466 INFO [stdout] test scan::path_suffix::tests::command_only_should_not_parse ... ok
Nov 17 04:28:18.466 INFO [stdout] test shim::tests::test_alt_command_is_not_shim ... ok
Nov 17 04:28:18.466 INFO [stdout] test scan::path_suffix::tests::command_trailing_period_in_suffix_should_not_parse ... ok
Nov 17 04:28:18.467 INFO [stdout] test scan::path_suffix::tests::command_with_version_suffix_should_parse ... ok
Nov 17 04:28:18.467 INFO [stdout] test shim::tests::test_absolute_alt_is_not_shim ... ok
Nov 17 04:28:18.467 INFO [stdout] test shim::tests::test_get_command_absolute ... ok
Nov 17 04:28:18.468 INFO [stdout] test shim::tests::test_absolute_non_alt_is_not_shim ... ok
Nov 17 04:28:18.468 INFO [stdout] test scan::path_suffix::tests::command_with_simple_number_suffix_should_parse ... ok
Nov 17 04:28:18.468 INFO [stdout] test scan::path_suffix::tests::command_with_text_suffix_should_not_parse ... ok
Nov 17 04:28:18.468 INFO [stdout] test shim::tests::test_get_command_command ... ok
Nov 17 04:28:18.469 INFO [stdout] test shim::tests::test_non_alt_command_is_shim ... ok
Nov 17 04:28:18.469 INFO [stdout] test shim::tests::test_relative_alt_is_not_shim ... ok
Nov 17 04:28:18.469 INFO [stdout] test shim::tests::test_get_command_relative ... ok
Nov 17 04:28:18.470 INFO [stdout] test scan::path_suffix::tests::command_with_version_suffix_and_dash_should_parse ... ok
Nov 17 04:28:18.479 INFO [stdout] test shim::tests::test_relative_non_alt_is_not_shim ... ok
Nov 17 04:28:18.479 INFO [stdout] 
Nov 17 04:28:18.479 INFO [stdout] test result: ok. 23 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 04:28:18.479 INFO [stdout] 
Nov 17 04:28:18.483 INFO [stderr]      Running /target/debug/deps/integration_test-00022ef5f33fbc7e
Nov 17 04:28:18.485 INFO [stdout] 
Nov 17 04:28:18.485 INFO [stdout] running 5 tests
Nov 17 04:29:18.487 INFO [stdout] test def_and_use ... test def_and_use has been running for over 60 seconds
Nov 17 04:29:18.487 INFO [stdout] test system_with_no_use ... test system_with_no_use has been running for over 60 seconds
Nov 17 04:29:18.487 INFO [stdout] test reset_with_use_system ... test reset_with_use_system has been running for over 60 seconds
Nov 17 04:29:18.487 INFO [stdout] test use_with_subdir_overwrite ... test use_with_subdir_overwrite has been running for over 60 seconds
Nov 17 04:29:18.487 INFO [stdout] test use_with_subdir ... test use_with_subdir has been running for over 60 seconds
Nov 17 04:30:15.078 INFO [stdout] test reset_with_use_system ... ok
Nov 17 04:30:15.211 INFO [stdout] test use_with_subdir ... ok
Nov 17 04:30:15.219 INFO [stdout] test system_with_no_use ... ok
Nov 17 04:30:15.343 INFO [stdout] test use_with_subdir_overwrite ... ok
Nov 17 04:30:15.347 INFO [stdout] test def_and_use ... ok
Nov 17 04:30:15.347 INFO [stdout] 
Nov 17 04:30:15.348 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 04:30:15.348 INFO [stdout] 
Nov 17 04:30:15.350 INFO [stderr]      Running /target/debug/deps/test_env-57e4765dd4b8ef52
Nov 17 04:30:15.353 INFO [stdout] 
Nov 17 04:30:15.353 INFO [stdout] running 0 tests
Nov 17 04:30:15.353 INFO [stdout] 
Nov 17 04:30:15.353 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 04:30:15.354 INFO [stdout] 
Nov 17 04:30:15.356 INFO [stderr] su: No module specific data is present
Nov 17 04:30:16.095 INFO running `"docker" "inspect" "a7b19ee1b40edac9107523ec161beaf24cbc8e21c2990c194fd510395d25bff6"`
Nov 17 04:30:16.383 INFO running `"docker" "rm" "-f" "a7b19ee1b40edac9107523ec161beaf24cbc8e21c2990c194fd510395d25bff6"`
Nov 17 04:30:16.758 INFO [stdout] a7b19ee1b40edac9107523ec161beaf24cbc8e21c2990c194fd510395d25bff6