[INFO] updating cached repository dotboris/alt
[INFO] running `"git" "fetch" "--all"`
[INFO] [stdout] Fetching origin
[INFO] [stderr] From git://github.com/dotboris/alt
[INFO] [stderr]  * branch            HEAD       -> FETCH_HEAD
[INFO] running `"git" "clone" "work/cache/sources/gh/dotboris/alt" "work/ex/beta-1.38-1/sources/1.37.0/gh/dotboris/alt"`
[INFO] [stderr] Cloning into 'work/ex/beta-1.38-1/sources/1.37.0/gh/dotboris/alt'...
[INFO] [stderr] done.
[INFO] running `"git" "clone" "work/cache/sources/gh/dotboris/alt" "work/ex/beta-1.38-1/sources/beta-2019-08-13/gh/dotboris/alt"`
[INFO] [stderr] Cloning into 'work/ex/beta-1.38-1/sources/beta-2019-08-13/gh/dotboris/alt'...
[INFO] [stderr] done.
[INFO] running `"git" "rev-parse" "HEAD"`
[INFO] [stdout] d24bfbafb2f5f5f1978074f47692cb2ef18389b7
[INFO] sha for GitHub repo dotboris/alt: d24bfbafb2f5f5f1978074f47692cb2ef18389b7
[INFO] validating manifest of dotboris/alt on toolchain 1.37.0
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+1.37.0" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] validating manifest of dotboris/alt on toolchain beta-2019-08-13
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+beta-2019-08-13" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] started frobbing dotboris/alt
[INFO] finished frobbing dotboris/alt
[INFO] frobbed toml for dotboris/alt written to work/ex/beta-1.38-1/sources/1.37.0/gh/dotboris/alt/Cargo.toml
[INFO] started frobbing dotboris/alt
[INFO] finished frobbing dotboris/alt
[INFO] frobbed toml for dotboris/alt written to work/ex/beta-1.38-1/sources/beta-2019-08-13/gh/dotboris/alt/Cargo.toml
[INFO] crate dotboris/alt already has a lockfile, it will not be regenerated
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+1.37.0" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+beta-2019-08-13" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] testing dotboris/alt against beta-2019-08-13 for beta-1.38-1
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.38-1/worker-5/beta-2019-08-13:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.38-1/sources/beta-2019-08-13/gh/dotboris/alt:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+beta-2019-08-13" "build" "--frozen"`
[INFO] [stdout] e415508f5644ec7b72d12d3045bc911d0184946c171ca1b3f045c13d24d95710
[INFO] running `"docker" "start" "-a" "e415508f5644ec7b72d12d3045bc911d0184946c171ca1b3f045c13d24d95710"`
[INFO] [stderr]    Compiling serde v1.0.80
[INFO] [stderr]    Compiling glob v0.3.0
[INFO] [stderr]    Compiling rand_os v0.1.1
[INFO] [stderr]    Compiling termios v0.3.1
[INFO] [stderr]    Compiling clicolors-control v1.0.0
[INFO] [stderr]    Compiling regex-syntax v0.6.6
[INFO] [stderr]    Compiling clap v2.33.0
[INFO] [stderr]    Compiling syn v0.15.15
[INFO] [stderr]    Compiling rand v0.6.4
[INFO] [stderr]    Compiling tempfile v3.0.8
[INFO] [stderr]    Compiling regex v1.1.6
[INFO] [stderr]    Compiling serde_derive v1.0.80
[INFO] [stderr]    Compiling console v0.7.5
[INFO] [stderr]    Compiling alt v1.0.4 (/opt/crater/workdir)
[INFO] [stderr]    Compiling dialoguer v0.4.0
[INFO] [stderr]    Compiling toml v0.5.1
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 57.78s
[INFO] running `"docker" "inspect" "e415508f5644ec7b72d12d3045bc911d0184946c171ca1b3f045c13d24d95710"`
[INFO] running `"docker" "rm" "-f" "e415508f5644ec7b72d12d3045bc911d0184946c171ca1b3f045c13d24d95710"`
[INFO] [stdout] e415508f5644ec7b72d12d3045bc911d0184946c171ca1b3f045c13d24d95710
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.38-1/worker-5/beta-2019-08-13:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.38-1/sources/beta-2019-08-13/gh/dotboris/alt:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+beta-2019-08-13" "test" "--frozen" "--no-run"`
[INFO] [stdout] 4064850b11b8e10760dbe5c5fbcd8767a263027b7433fe8c7dda4a3c193c8277
[INFO] running `"docker" "start" "-a" "4064850b11b8e10760dbe5c5fbcd8767a263027b7433fe8c7dda4a3c193c8277"`
[INFO] [stderr]    Compiling escargot v0.4.0
[INFO] [stderr]    Compiling escargot v0.5.0
[INFO] [stderr]    Compiling predicates v1.0.0
[INFO] [stderr]    Compiling serde_json v1.0.32
[INFO] [stderr]    Compiling assert_cmd v0.11.1
[INFO] [stderr]    Compiling alt v1.0.4 (/opt/crater/workdir)
[INFO] [stderr] warning: static variable `env_mutex` should have an upper case name
[INFO] [stderr]   --> src/config.rs:34:20
[INFO] [stderr]    |
[INFO] [stderr] 34 |         static ref env_mutex: Mutex<()> = Mutex::new(());
[INFO] [stderr]    |                    ^^^^^^^^^ help: convert the identifier to upper case: `ENV_MUTEX`
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(non_upper_case_globals)]` on by default
[INFO] [stderr] 
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 21.60s
[INFO] running `"docker" "inspect" "4064850b11b8e10760dbe5c5fbcd8767a263027b7433fe8c7dda4a3c193c8277"`
[INFO] running `"docker" "rm" "-f" "4064850b11b8e10760dbe5c5fbcd8767a263027b7433fe8c7dda4a3c193c8277"`
[INFO] [stdout] 4064850b11b8e10760dbe5c5fbcd8767a263027b7433fe8c7dda4a3c193c8277
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.38-1/worker-5/beta-2019-08-13:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.38-1/sources/beta-2019-08-13/gh/dotboris/alt:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+beta-2019-08-13" "test" "--frozen"`
[INFO] [stdout] bc87d8b864baabb6499d3b109a80c1b1560f696de24208fa3bb9d9d6801a978d
[INFO] running `"docker" "start" "-a" "bc87d8b864baabb6499d3b109a80c1b1560f696de24208fa3bb9d9d6801a978d"`
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.08s
[INFO] [stderr]      Running /opt/crater/target/debug/deps/alt-0f752bfd18cbf07e
[INFO] [stdout] 
[INFO] [stdout] running 23 tests
[INFO] [stdout] test config::tests::home_dir_should_default ... ok
[INFO] [stdout] test config::tests::home_dir_should_read_alt_home_env ... ok
[INFO] [stdout] test def_file::tests::find_bin_returns_none_on_empty_defs ... ok
[INFO] [stdout] test def_file::tests::find_bin_returns_none_when_command_not_defined ... ok
[INFO] [stdout] test def_file::tests::find_bin_returns_path_when_command_and_version_defined ... ok
[INFO] [stdout] test scan::homebrew::tests::test_parse_version_path_php ... ok
[INFO] [stdout] test def_file::tests::find_bin_returns_none_when_version_not_defined ... ok
[INFO] [stdout] test scan::homebrew::tests::test_parse_version_path_node ... ok
[INFO] [stdout] test shim::tests::test_absolute_alt_is_not_shim ... ok
[INFO] [stdout] test shim::tests::test_absolute_non_alt_is_not_shim ... ok
[INFO] [stdout] test scan::path_suffix::tests::command_with_text_suffix_should_not_parse ... ok
[INFO] [stdout] test scan::path_suffix::tests::command_with_version_suffix_and_dash_should_parse ... ok
[INFO] [stdout] test scan::path_suffix::tests::command_with_version_suffix_should_parse ... ok
[INFO] [stdout] test scan::path_suffix::tests::command_trailing_period_in_suffix_should_not_parse ... ok
[INFO] [stdout] test scan::path_suffix::tests::command_only_should_not_parse ... ok
[INFO] [stdout] test shim::tests::test_relative_alt_is_not_shim ... ok
[INFO] [stdout] test scan::path_suffix::tests::command_with_simple_number_suffix_should_parse ... ok
[INFO] [stdout] test shim::tests::test_relative_non_alt_is_not_shim ... ok
[INFO] [stdout] test shim::tests::test_get_command_relative ... ok
[INFO] [stdout] test shim::tests::test_non_alt_command_is_shim ... ok
[INFO] [stdout] test shim::tests::test_get_command_command ... ok
[INFO] [stdout] test shim::tests::test_get_command_absolute ... ok
[INFO] [stdout] test shim::tests::test_alt_command_is_not_shim ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 23 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/crater/target/debug/deps/integration_test-c13c02d85d078f2c
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test reset_with_use_system ... test reset_with_use_system has been running for over 60 seconds
[INFO] [stdout] test use_with_subdir_overwrite ... test use_with_subdir_overwrite has been running for over 60 seconds
[INFO] [stdout] test system_with_no_use ... test system_with_no_use has been running for over 60 seconds
[INFO] [stdout] test use_with_subdir ... test use_with_subdir has been running for over 60 seconds
[INFO] [stdout] test def_and_use ... test def_and_use has been running for over 60 seconds
[INFO] [stdout] test reset_with_use_system ... ok
[INFO] [stdout] test def_and_use ... ok
[INFO] [stdout] test use_with_subdir ... ok
[INFO] [stdout] test use_with_subdir_overwrite ... ok
[INFO] [stdout] test system_with_no_use ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/crater/target/debug/deps/test_env-698960e686eee184
[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
[INFO] [stdout] 
[INFO] running `"docker" "inspect" "bc87d8b864baabb6499d3b109a80c1b1560f696de24208fa3bb9d9d6801a978d"`
[INFO] running `"docker" "rm" "-f" "bc87d8b864baabb6499d3b109a80c1b1560f696de24208fa3bb9d9d6801a978d"`
[INFO] [stdout] bc87d8b864baabb6499d3b109a80c1b1560f696de24208fa3bb9d9d6801a978d