[INFO] crate butlerd 0.1.2 is already in cache
[INFO] extracting crate butlerd 0.1.2 into work/ex/beta-1.38-1/sources/1.37.0/reg/butlerd/0.1.2
[INFO] extracting crate butlerd 0.1.2 into work/ex/beta-1.38-1/sources/beta-2019-08-13/reg/butlerd/0.1.2
[INFO] validating manifest of butlerd-0.1.2 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 butlerd-0.1.2 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 butlerd-0.1.2
[INFO] finished frobbing butlerd-0.1.2
[INFO] frobbed toml for butlerd-0.1.2 written to work/ex/beta-1.38-1/sources/1.37.0/reg/butlerd/0.1.2/Cargo.toml
[INFO] started frobbing butlerd-0.1.2
[INFO] finished frobbing butlerd-0.1.2
[INFO] frobbed toml for butlerd-0.1.2 written to work/ex/beta-1.38-1/sources/beta-2019-08-13/reg/butlerd/0.1.2/Cargo.toml
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+1.37.0" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update"`
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+beta-2019-08-13" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update"`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+1.37.0" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+beta-2019-08-13" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] testing butlerd-0.1.2 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-7/beta-2019-08-13:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.38-1/sources/beta-2019-08-13/reg/butlerd/0.1.2:/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] 24cf0fa63b2bf0f64fd3b1e60be89240a9d251a85cb6b92c2b8ebdeecbec0a94
[INFO] running `"docker" "start" "-a" "24cf0fa63b2bf0f64fd3b1e60be89240a9d251a85cb6b92c2b8ebdeecbec0a94"`
[INFO] [stderr]    Compiling uuid v0.7.4
[INFO] [stderr]    Compiling tokio-reactor v0.1.9
[INFO] [stderr]    Compiling tokio-threadpool v0.1.15
[INFO] [stderr]    Compiling tokio-tcp v0.1.3
[INFO] [stderr]    Compiling tokio v0.1.22
[INFO] [stderr]    Compiling hyper v0.12.33
[INFO] [stderr]    Compiling hyper-tls v0.3.2
[INFO] [stderr]    Compiling reqwest v0.9.20
[INFO] [stderr]    Compiling butlerd v0.1.2 (/opt/crater/workdir)
[INFO] [stderr] warning: variant `i386` should have an upper camel case name
[INFO] [stderr]    --> src/Responses.rs:100:5
[INFO] [stderr]     |
[INFO] [stderr] 100 |     i386,
[INFO] [stderr]     |     ^^^^ help: convert the identifier to upper camel case: `I386`
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(non_camel_case_types)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated item 'std::env::home_dir': This function's behavior is unexpected and probably not what you want. Consider using the home_dir function from https://crates.io/crates/dirs instead.
[INFO] [stderr]    --> src/lib.rs:678:25
[INFO] [stderr]     |
[INFO] [stderr] 678 |     return String::from(env::home_dir().unwrap().to_str().unwrap());
[INFO] [stderr]     |                         ^^^^^^^^^^^^^
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(deprecated)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated item 'std::thread::sleep_ms': replaced by `std::thread::sleep`
[INFO] [stderr]    --> src/lib.rs:100:17
[INFO] [stderr]     |
[INFO] [stderr] 100 |                 ::std::thread::sleep_ms(250);
[INFO] [stderr]     |                 ^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated item 'std::thread::sleep_ms': replaced by `std::thread::sleep`
[INFO] [stderr]    --> src/lib.rs:546:13
[INFO] [stderr]     |
[INFO] [stderr] 546 |             ::std::thread::sleep_ms(1000);
[INFO] [stderr]     |             ^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: value assigned to `file` is never read
[INFO] [stderr]   --> src/lib.rs:64:13
[INFO] [stderr]    |
[INFO] [stderr] 64 |             file = fs::File::create(log_path).unwrap();
[INFO] [stderr]    |             ^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(unused_assignments)]` on by default
[INFO] [stderr]    = help: maybe it is overwritten before being read?
[INFO] [stderr] 
[INFO] [stderr] warning: value assigned to `b` is never read
[INFO] [stderr]    --> src/lib.rs:652:17
[INFO] [stderr]     |
[INFO] [stderr] 652 |         let mut b = String::new();
[INFO] [stderr]     |                 ^
[INFO] [stderr]     |
[INFO] [stderr]     = help: maybe it is overwritten before being read?
[INFO] [stderr] 
[INFO] [stderr] warning: value assigned to `b` is never read
[INFO] [stderr]    --> src/lib.rs:666:17
[INFO] [stderr]     |
[INFO] [stderr] 666 |         let mut b = String::new();
[INFO] [stderr]     |                 ^
[INFO] [stderr]     |
[INFO] [stderr]     = help: maybe it is overwritten before being read?
[INFO] [stderr] 
[INFO] [stderr] warning: unused `hyper::client::ResponseFuture` that must be used
[INFO] [stderr]    --> src/lib.rs:543:9
[INFO] [stderr]     |
[INFO] [stderr] 543 |         self.hclient.request(request);
[INFO] [stderr]     |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(unused_must_use)]` on by default
[INFO] [stderr]     = note: futures do nothing unless polled
[INFO] [stderr] 
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 33.23s
[INFO] running `"docker" "inspect" "24cf0fa63b2bf0f64fd3b1e60be89240a9d251a85cb6b92c2b8ebdeecbec0a94"`
[INFO] running `"docker" "rm" "-f" "24cf0fa63b2bf0f64fd3b1e60be89240a9d251a85cb6b92c2b8ebdeecbec0a94"`
[INFO] [stdout] 24cf0fa63b2bf0f64fd3b1e60be89240a9d251a85cb6b92c2b8ebdeecbec0a94
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.38-1/worker-7/beta-2019-08-13:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.38-1/sources/beta-2019-08-13/reg/butlerd/0.1.2:/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] 9b12523e9b2b0a149888843321d5fddef05b1a086aabd7920d6894a40c0ccb13
[INFO] running `"docker" "start" "-a" "9b12523e9b2b0a149888843321d5fddef05b1a086aabd7920d6894a40c0ccb13"`
[INFO] [stderr]    Compiling butlerd v0.1.2 (/opt/crater/workdir)
[INFO] [stderr] warning: constant `b` should have an upper case name
[INFO] [stderr]   --> tests/lib.rs:12:22
[INFO] [stderr]    |
[INFO] [stderr] 12 | thread_local!(static b : Butler = Butler::new().unwrap());
[INFO] [stderr]    |                      ^ help: convert the identifier to upper case: `B`
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(non_upper_case_globals)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: unused `std::result::Result` that must be used
[INFO] [stderr]   --> tests/lib.rs:52:13
[INFO] [stderr]    |
[INFO] [stderr] 52 |             but.login_api_key(&key.unwrap().into_string().unwrap());
[INFO] [stderr]    |             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(unused_must_use)]` on by default
[INFO] [stderr]    = note: this `Result` may be an `Err` variant, which should be handled
[INFO] [stderr] 
[INFO] [stderr] warning: unused `std::result::Result` that must be used
[INFO] [stderr]    --> tests/lib.rs:151:9
[INFO] [stderr]     |
[INFO] [stderr] 151 |         but.check_update(vec!["e97cd944-386d-4c6c-b1e9-76a3175f4ca9".to_string()]);
[INFO] [stderr]     |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr]     |
[INFO] [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
[INFO] [stderr] 
[INFO] [stderr] warning: variant `i386` should have an upper camel case name
[INFO] [stderr]    --> src/Responses.rs:100:5
[INFO] [stderr]     |
[INFO] [stderr] 100 |     i386,
[INFO] [stderr]     |     ^^^^ help: convert the identifier to upper camel case: `I386`
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(non_camel_case_types)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated item 'std::env::home_dir': This function's behavior is unexpected and probably not what you want. Consider using the home_dir function from https://crates.io/crates/dirs instead.
[INFO] [stderr]    --> src/lib.rs:678:25
[INFO] [stderr]     |
[INFO] [stderr] 678 |     return String::from(env::home_dir().unwrap().to_str().unwrap());
[INFO] [stderr]     |                         ^^^^^^^^^^^^^
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(deprecated)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated item 'std::thread::sleep_ms': replaced by `std::thread::sleep`
[INFO] [stderr]    --> src/lib.rs:100:17
[INFO] [stderr]     |
[INFO] [stderr] 100 |                 ::std::thread::sleep_ms(250);
[INFO] [stderr]     |                 ^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated item 'std::thread::sleep_ms': replaced by `std::thread::sleep`
[INFO] [stderr]    --> src/lib.rs:546:13
[INFO] [stderr]     |
[INFO] [stderr] 546 |             ::std::thread::sleep_ms(1000);
[INFO] [stderr]     |             ^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: value assigned to `file` is never read
[INFO] [stderr]   --> src/lib.rs:64:13
[INFO] [stderr]    |
[INFO] [stderr] 64 |             file = fs::File::create(log_path).unwrap();
[INFO] [stderr]    |             ^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(unused_assignments)]` on by default
[INFO] [stderr]    = help: maybe it is overwritten before being read?
[INFO] [stderr] 
[INFO] [stderr] warning: value assigned to `b` is never read
[INFO] [stderr]    --> src/lib.rs:652:17
[INFO] [stderr]     |
[INFO] [stderr] 652 |         let mut b = String::new();
[INFO] [stderr]     |                 ^
[INFO] [stderr]     |
[INFO] [stderr]     = help: maybe it is overwritten before being read?
[INFO] [stderr] 
[INFO] [stderr] warning: value assigned to `b` is never read
[INFO] [stderr]    --> src/lib.rs:666:17
[INFO] [stderr]     |
[INFO] [stderr] 666 |         let mut b = String::new();
[INFO] [stderr]     |                 ^
[INFO] [stderr]     |
[INFO] [stderr]     = help: maybe it is overwritten before being read?
[INFO] [stderr] 
[INFO] [stderr] warning: unused `hyper::client::ResponseFuture` that must be used
[INFO] [stderr]    --> src/lib.rs:543:9
[INFO] [stderr]     |
[INFO] [stderr] 543 |         self.hclient.request(request);
[INFO] [stderr]     |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(unused_must_use)]` on by default
[INFO] [stderr]     = note: futures do nothing unless polled
[INFO] [stderr] 
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 8.13s
[INFO] running `"docker" "inspect" "9b12523e9b2b0a149888843321d5fddef05b1a086aabd7920d6894a40c0ccb13"`
[INFO] running `"docker" "rm" "-f" "9b12523e9b2b0a149888843321d5fddef05b1a086aabd7920d6894a40c0ccb13"`
[INFO] [stdout] 9b12523e9b2b0a149888843321d5fddef05b1a086aabd7920d6894a40c0ccb13
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.38-1/worker-7/beta-2019-08-13:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.38-1/sources/beta-2019-08-13/reg/butlerd/0.1.2:/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] de12bd43b6a3697fa9c60ee34b9373415a808075eb51913edac00dff891b19eb
[INFO] running `"docker" "start" "-a" "de12bd43b6a3697fa9c60ee34b9373415a808075eb51913edac00dff891b19eb"`
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.14s
[INFO] [stderr]      Running /opt/crater/target/debug/deps/butlerd-7408be3df3b1d7fe
[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] [stderr]      Running /opt/crater/target/debug/deps/lib-5991a46254a0068b
[INFO] [stdout] 
[INFO] [stdout] running 20 tests
[INFO] [stderr] sh: 1: butler: not found
[INFO] [stderr] sh: 1: butler: not found
[INFO] [stderr] sh: 1: butler: not found
[INFO] [stderr] sh: 1: butler: not found
[INFO] [stderr] sh: 1: butler: not found
[INFO] [stderr] sh: 1: butler: not found
[INFO] [stderr] sh: 1: butler: not found
[INFO] [stderr] sh: 1: butler: not found
[INFO] [stdout] test check_sale_none ... test check_sale_none has been running for over 60 seconds
[INFO] [stdout] test check_updates ... test check_updates has been running for over 60 seconds
[INFO] [stdout] test expireall ... test expireall has been running for over 60 seconds
[INFO] [stdout] test commons ... test commons has been running for over 60 seconds
[INFO] [stdout] test fetch_cave ... test fetch_cave has been running for over 60 seconds
[INFO] [stdout] test fetch_game ... test fetch_game has been running for over 60 seconds
[INFO] [stdout] test fetch_version ... test fetch_version has been running for over 60 seconds
[INFO] [stdout] test fetch_uploads ... test fetch_uploads has been running for over 60 seconds
[ERROR] error running command: no output for 300 seconds
[INFO] running `"docker" "inspect" "de12bd43b6a3697fa9c60ee34b9373415a808075eb51913edac00dff891b19eb"`
[INFO] running `"docker" "rm" "-f" "de12bd43b6a3697fa9c60ee34b9373415a808075eb51913edac00dff891b19eb"`
[INFO] [stdout] de12bd43b6a3697fa9c60ee34b9373415a808075eb51913edac00dff891b19eb