Dec 01 19:06:07.806 INFO testing dotboris/alt against 1.30.1 for beta-1.31-5
Dec 01 19:06:07.806 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-3/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/beta-1.31-5/1.30.1:/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 +1.30.1 build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 01 19:06:08.216 INFO [stdout] 6e5ee3d360dfbd1e4b1d2d7e1b76c9a331d3415c8035868e4a61c16a972307cf
Dec 01 19:06:08.219 INFO running `"docker" "start" "-a" "6e5ee3d360dfbd1e4b1d2d7e1b76c9a331d3415c8035868e4a61c16a972307cf"`
Dec 01 19:06:09.594 INFO [stderr] usermod: no changes
Dec 01 19:06:09.761 INFO [stderr]    Compiling serde v1.0.80
Dec 01 19:06:09.762 INFO [stderr]    Compiling tempfile v2.2.0
Dec 01 19:06:09.763 INFO [stderr]    Compiling syn v0.15.15
Dec 01 19:06:09.764 INFO [stderr]    Compiling console v0.6.2
Dec 01 19:06:13.039 INFO [stderr]    Compiling dialoguer v0.1.0
Dec 01 19:06:21.202 INFO [stderr]    Compiling serde_derive v1.0.80
Dec 01 19:06:42.156 INFO [stderr]    Compiling toml v0.4.8
Dec 01 19:06:48.428 INFO [stderr]    Compiling alt v1.0.2 (/source)
Dec 01 19:06:56.575 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 46.95s
Dec 01 19:06:56.583 INFO [stderr] su: No module specific data is present
Dec 01 19:06:57.304 INFO running `"docker" "inspect" "6e5ee3d360dfbd1e4b1d2d7e1b76c9a331d3415c8035868e4a61c16a972307cf"`
Dec 01 19:06:57.520 INFO running `"docker" "rm" "-f" "6e5ee3d360dfbd1e4b1d2d7e1b76c9a331d3415c8035868e4a61c16a972307cf"`
Dec 01 19:06:57.885 INFO [stdout] 6e5ee3d360dfbd1e4b1d2d7e1b76c9a331d3415c8035868e4a61c16a972307cf
Dec 01 19:06:57.889 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-3/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/beta-1.31-5/1.30.1:/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 +1.30.1 test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 01 19:06:58.384 INFO [stdout] 9ea29cba6adb1122781227737c8ef6f2f2bec9b4e02ec8f99fc9a668789b5efe
Dec 01 19:06:58.386 INFO running `"docker" "start" "-a" "9ea29cba6adb1122781227737c8ef6f2f2bec9b4e02ec8f99fc9a668789b5efe"`
Dec 01 19:06:59.670 INFO [stderr] usermod: no changes
Dec 01 19:06:59.889 INFO [stderr]    Compiling escargot v0.3.1
Dec 01 19:06:59.895 INFO [stderr]    Compiling predicates-core v1.0.0
Dec 01 19:06:59.895 INFO [stderr]    Compiling treeline v0.1.0
Dec 01 19:06:59.911 INFO [stderr]    Compiling serde_json v1.0.32
Dec 01 19:07:02.019 INFO [stderr]    Compiling predicates v1.0.0
Dec 01 19:07:02.019 INFO [stderr]    Compiling predicates-tree v1.0.0
Dec 01 19:07:10.767 INFO [stderr]    Compiling assert_cmd v0.10.1
Dec 01 19:07:12.867 INFO [stderr]    Compiling alt v1.0.2 (/source)
Dec 01 19:07:20.802 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 21.10s
Dec 01 19:07:20.823 INFO [stderr] su: No module specific data is present
Dec 01 19:07:21.516 INFO running `"docker" "inspect" "9ea29cba6adb1122781227737c8ef6f2f2bec9b4e02ec8f99fc9a668789b5efe"`
Dec 01 19:07:21.787 INFO running `"docker" "rm" "-f" "9ea29cba6adb1122781227737c8ef6f2f2bec9b4e02ec8f99fc9a668789b5efe"`
Dec 01 19:07:22.059 INFO [stdout] 9ea29cba6adb1122781227737c8ef6f2f2bec9b4e02ec8f99fc9a668789b5efe
Dec 01 19:07:22.067 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-3/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/beta-1.31-5/1.30.1:/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 +1.30.1 test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 01 19:07:22.503 INFO [stdout] a9552658f8ecdcc5a0cba48036ec618838001fb1a9675e4c09ebefb637bdad6d
Dec 01 19:07:22.511 INFO running `"docker" "start" "-a" "a9552658f8ecdcc5a0cba48036ec618838001fb1a9675e4c09ebefb637bdad6d"`
Dec 01 19:07:23.816 INFO [stderr] usermod: no changes
Dec 01 19:07:23.955 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.10s
Dec 01 19:07:23.971 INFO [stderr]      Running /target/debug/deps/alt-71755fb5b73341e6
Dec 01 19:07:23.973 INFO [stdout] 
Dec 01 19:07:23.973 INFO [stdout] running 23 tests
Dec 01 19:07:24.047 INFO [stdout] test config::tests::home_dir_should_read_alt_home_env ... ok
Dec 01 19:07:24.051 INFO [stdout] test def_file::tests::find_bin_returns_none_on_empty_defs ... ok
Dec 01 19:07:24.052 INFO [stdout] test def_file::tests::find_bin_returns_none_when_command_not_defined ... ok
Dec 01 19:07:24.053 INFO [stdout] test def_file::tests::find_bin_returns_path_when_command_and_version_defined ... ok
Dec 01 19:07:24.053 INFO [stdout] test config::tests::home_dir_should_default ... ok
Dec 01 19:07:24.054 INFO [stdout] test scan::homebrew::tests::test_parse_version_path_node ... ok
Dec 01 19:07:24.054 INFO [stdout] test scan::homebrew::tests::test_parse_version_path_php ... ok
Dec 01 19:07:24.055 INFO [stdout] test def_file::tests::find_bin_returns_none_when_version_not_defined ... ok
Dec 01 19:07:24.059 INFO [stdout] test scan::path_suffix::tests::command_with_version_suffix_and_dash_should_parse ... ok
Dec 01 19:07:24.060 INFO [stdout] test scan::path_suffix::tests::command_with_simple_number_suffix_should_parse ... ok
Dec 01 19:07:24.060 INFO [stdout] test scan::path_suffix::tests::command_only_should_not_parse ... ok
Dec 01 19:07:24.061 INFO [stdout] test scan::path_suffix::tests::command_with_version_suffix_should_parse ... ok
Dec 01 19:07:24.062 INFO [stdout] test shim::tests::test_absolute_alt_is_not_shim ... ok
Dec 01 19:07:24.062 INFO [stdout] test shim::tests::test_alt_command_is_not_shim ... ok
Dec 01 19:07:24.063 INFO [stdout] test shim::tests::test_get_command_absolute ... ok
Dec 01 19:07:24.063 INFO [stdout] test shim::tests::test_get_command_command ... ok
Dec 01 19:07:24.063 INFO [stdout] test shim::tests::test_get_command_relative ... ok
Dec 01 19:07:24.064 INFO [stdout] test shim::tests::test_relative_alt_is_not_shim ... ok
Dec 01 19:07:24.064 INFO [stdout] test shim::tests::test_non_alt_command_is_shim ... ok
Dec 01 19:07:24.065 INFO [stdout] test scan::path_suffix::tests::command_trailing_period_in_suffix_should_not_parse ... ok
Dec 01 19:07:24.065 INFO [stdout] test shim::tests::test_relative_non_alt_is_not_shim ... ok
Dec 01 19:07:24.066 INFO [stdout] test scan::path_suffix::tests::command_with_text_suffix_should_not_parse ... ok
Dec 01 19:07:24.075 INFO [stdout] test shim::tests::test_absolute_non_alt_is_not_shim ... ok
Dec 01 19:07:24.075 INFO [stdout] 
Dec 01 19:07:24.076 INFO [stdout] test result: ok. 23 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 01 19:07:24.076 INFO [stdout] 
Dec 01 19:07:24.077 INFO [stderr]      Running /target/debug/deps/integration_test-73f0876cef4318d6
Dec 01 19:07:24.080 INFO [stdout] 
Dec 01 19:07:24.080 INFO [stdout] running 5 tests
Dec 01 19:08:24.087 INFO [stdout] test system_with_no_use ... test system_with_no_use has been running for over 60 seconds
Dec 01 19:08:24.087 INFO [stdout] test use_with_subdir ... test use_with_subdir has been running for over 60 seconds
Dec 01 19:08:24.087 INFO [stdout] test reset_with_use_system ... test reset_with_use_system has been running for over 60 seconds
Dec 01 19:08:24.087 INFO [stdout] test use_with_subdir_overwrite ... test use_with_subdir_overwrite has been running for over 60 seconds
Dec 01 19:08:24.087 INFO [stdout] test def_and_use ... test def_and_use has been running for over 60 seconds
Dec 01 19:09:27.799 INFO [stdout] test def_and_use ... ok
Dec 01 19:09:27.860 INFO [stdout] test system_with_no_use ... ok
Dec 01 19:09:27.923 INFO [stdout] test use_with_subdir_overwrite ... ok
Dec 01 19:09:27.923 INFO [stdout] test use_with_subdir ... ok
Dec 01 19:09:28.007 INFO [stderr]      Running /target/debug/deps/test_env-98d8783ad1e42ed6
Dec 01 19:09:28.007 INFO [stdout] test reset_with_use_system ... ok
Dec 01 19:09:28.007 INFO [stdout] 
Dec 01 19:09:28.007 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 01 19:09:28.007 INFO [stdout] 
Dec 01 19:09:28.007 INFO [stdout] 
Dec 01 19:09:28.007 INFO [stdout] running 0 tests
Dec 01 19:09:28.007 INFO [stdout] 
Dec 01 19:09:28.007 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 01 19:09:28.007 INFO [stdout] 
Dec 01 19:09:28.008 INFO [stderr] su: No module specific data is present
Dec 01 19:09:28.755 INFO running `"docker" "inspect" "a9552658f8ecdcc5a0cba48036ec618838001fb1a9675e4c09ebefb637bdad6d"`
Dec 01 19:09:29.012 INFO running `"docker" "rm" "-f" "a9552658f8ecdcc5a0cba48036ec618838001fb1a9675e4c09ebefb637bdad6d"`
Dec 01 19:09:29.299 INFO [stdout] a9552658f8ecdcc5a0cba48036ec618838001fb1a9675e4c09ebefb637bdad6d
