Oct 16 16:19:42.775 INFO testing butlerd-0.1.2 against master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513 for rustdoc-test-static-cling-1
Oct 16 16:19:42.777 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-1/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-1/rustdoc-test-static-cling-1/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/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 +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-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"`
Oct 16 16:19:43.107 INFO blam! bba351a74d92f92b5ef1aa17c3ea57fe44786cbc9a42a4a1a48498e061e5d3d1
Oct 16 16:19:43.107 INFO running `"docker" "start" "-a" "bba351a74d92f92b5ef1aa17c3ea57fe44786cbc9a42a4a1a48498e061e5d3d1"`
Oct 16 16:19:44.069 INFO kablam! usermod: no changes
Oct 16 16:19:44.390 INFO kablam!    Compiling butlerd v0.1.2 (/source)
Oct 16 16:19:52.471 INFO kablam! 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.
Oct 16 16:19:52.471 INFO kablam!    --> src/lib.rs:678:25
Oct 16 16:19:52.471 INFO kablam!     |
Oct 16 16:19:52.471 INFO kablam! 678 |     return String::from(env::home_dir().unwrap().to_str().unwrap());
Oct 16 16:19:52.471 INFO kablam!     |                         ^^^^^^^^^^^^^
Oct 16 16:19:52.471 INFO kablam!     |
Oct 16 16:19:52.471 INFO kablam!     = note: #[warn(deprecated)] on by default
Oct 16 16:19:52.471 INFO kablam! 
Oct 16 16:19:52.472 INFO kablam! warning: use of deprecated item 'std::thread::sleep_ms': replaced by `std::thread::sleep`
Oct 16 16:19:52.472 INFO kablam!    --> src/lib.rs:100:17
Oct 16 16:19:52.473 INFO kablam!     |
Oct 16 16:19:52.473 INFO kablam! 100 |                 ::std::thread::sleep_ms(250);
Oct 16 16:19:52.473 INFO kablam!     |                 ^^^^^^^^^^^^^^^^^^^^^^^
Oct 16 16:19:52.473 INFO kablam! 
Oct 16 16:19:52.474 INFO kablam! warning: use of deprecated item 'std::thread::sleep_ms': replaced by `std::thread::sleep`
Oct 16 16:19:52.474 INFO kablam!    --> src/lib.rs:546:13
Oct 16 16:19:52.474 INFO kablam!     |
Oct 16 16:19:52.474 INFO kablam! 546 |             ::std::thread::sleep_ms(1000);
Oct 16 16:19:52.474 INFO kablam!     |             ^^^^^^^^^^^^^^^^^^^^^^^
Oct 16 16:19:52.474 INFO kablam! 
Oct 16 16:19:54.295 INFO kablam! warning: value assigned to `file` is never read
Oct 16 16:19:54.295 INFO kablam!   --> src/lib.rs:64:13
Oct 16 16:19:54.295 INFO kablam!    |
Oct 16 16:19:54.295 INFO kablam! 64 |             file = fs::File::create(log_path).unwrap();
Oct 16 16:19:54.295 INFO kablam!    |             ^^^^
Oct 16 16:19:54.295 INFO kablam!    |
Oct 16 16:19:54.295 INFO kablam!    = note: #[warn(unused_assignments)] on by default
Oct 16 16:19:54.295 INFO kablam! 
Oct 16 16:19:54.298 INFO kablam! warning: value assigned to `b` is never read
Oct 16 16:19:54.298 INFO kablam!    --> src/lib.rs:652:17
Oct 16 16:19:54.298 INFO kablam!     |
Oct 16 16:19:54.298 INFO kablam! 652 |         let mut b = String::new();
Oct 16 16:19:54.298 INFO kablam!     |                 ^
Oct 16 16:19:54.298 INFO kablam! 
Oct 16 16:19:54.298 INFO kablam! warning: value assigned to `b` is never read
Oct 16 16:19:54.298 INFO kablam!    --> src/lib.rs:666:17
Oct 16 16:19:54.298 INFO kablam!     |
Oct 16 16:19:54.298 INFO kablam! 666 |         let mut b = String::new();
Oct 16 16:19:54.298 INFO kablam!     |                 ^
Oct 16 16:19:54.298 INFO kablam! 
Oct 16 16:19:54.846 INFO kablam! warning: variant `i386` should have a camel case name such as `I386`
Oct 16 16:19:54.846 INFO kablam!    --> src/Responses.rs:100:5
Oct 16 16:19:54.846 INFO kablam!     |
Oct 16 16:19:54.846 INFO kablam! 100 |     i386,
Oct 16 16:19:54.846 INFO kablam!     |     ^^^^
Oct 16 16:19:54.846 INFO kablam!     |
Oct 16 16:19:54.846 INFO kablam!     = note: #[warn(non_camel_case_types)] on by default
Oct 16 16:19:54.846 INFO kablam! 
Oct 16 16:19:54.886 INFO kablam! warning: unused `hyper::client::ResponseFuture` which must be used
Oct 16 16:19:54.886 INFO kablam!    --> src/lib.rs:543:9
Oct 16 16:19:54.886 INFO kablam!     |
Oct 16 16:19:54.886 INFO kablam! 543 |         self.hclient.request(request);
Oct 16 16:19:54.886 INFO kablam!     |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Oct 16 16:19:54.886 INFO kablam!     |
Oct 16 16:19:54.886 INFO kablam!     = note: #[warn(unused_must_use)] on by default
Oct 16 16:19:54.886 INFO kablam!     = note: futures do nothing unless polled
Oct 16 16:19:54.886 INFO kablam! 
Oct 16 16:20:02.923 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 18.82s
Oct 16 16:20:02.939 INFO kablam! su: No module specific data is present
Oct 16 16:20:03.707 INFO running `"docker" "rm" "-f" "bba351a74d92f92b5ef1aa17c3ea57fe44786cbc9a42a4a1a48498e061e5d3d1"`
Oct 16 16:20:03.910 INFO blam! bba351a74d92f92b5ef1aa17c3ea57fe44786cbc9a42a4a1a48498e061e5d3d1
Oct 16 16:20:03.927 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-1/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-1/rustdoc-test-static-cling-1/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/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 +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-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"`
Oct 16 16:20:04.485 INFO blam! 743bc6544f21d170d22bd36a886d5ab768190b61409b7e22d62eb1402e8f19d8
Oct 16 16:20:04.487 INFO running `"docker" "start" "-a" "743bc6544f21d170d22bd36a886d5ab768190b61409b7e22d62eb1402e8f19d8"`
Oct 16 16:20:06.434 INFO kablam! usermod: no changes
Oct 16 16:20:06.707 INFO kablam!    Compiling butlerd v0.1.2 (/source)
Oct 16 16:20:16.311 INFO kablam! 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.
Oct 16 16:20:16.311 INFO kablam!    --> src/lib.rs:678:25
Oct 16 16:20:16.311 INFO kablam!     |
Oct 16 16:20:16.311 INFO kablam! 678 |     return String::from(env::home_dir().unwrap().to_str().unwrap());
Oct 16 16:20:16.311 INFO kablam!     |                         ^^^^^^^^^^^^^
Oct 16 16:20:16.311 INFO kablam!     |
Oct 16 16:20:16.311 INFO kablam!     = note: #[warn(deprecated)] on by default
Oct 16 16:20:16.311 INFO kablam! 
Oct 16 16:20:16.311 INFO kablam! warning: use of deprecated item 'std::thread::sleep_ms': replaced by `std::thread::sleep`
Oct 16 16:20:16.311 INFO kablam!    --> src/lib.rs:100:17
Oct 16 16:20:16.311 INFO kablam!     |
Oct 16 16:20:16.311 INFO kablam! 100 |                 ::std::thread::sleep_ms(250);
Oct 16 16:20:16.311 INFO kablam!     |                 ^^^^^^^^^^^^^^^^^^^^^^^
Oct 16 16:20:16.311 INFO kablam! 
Oct 16 16:20:16.311 INFO kablam! warning: use of deprecated item 'std::thread::sleep_ms': replaced by `std::thread::sleep`
Oct 16 16:20:16.311 INFO kablam!    --> src/lib.rs:546:13
Oct 16 16:20:16.311 INFO kablam!     |
Oct 16 16:20:16.311 INFO kablam! 546 |             ::std::thread::sleep_ms(1000);
Oct 16 16:20:16.311 INFO kablam!     |             ^^^^^^^^^^^^^^^^^^^^^^^
Oct 16 16:20:16.311 INFO kablam! 
Oct 16 16:20:16.527 INFO kablam! warning: unused `std::result::Result` which must be used
Oct 16 16:20:16.527 INFO kablam!   --> tests/lib.rs:52:13
Oct 16 16:20:16.527 INFO kablam!    |
Oct 16 16:20:16.527 INFO kablam! 52 |             but.login_api_key(&key.unwrap().into_string().unwrap());
Oct 16 16:20:16.527 INFO kablam!    |             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Oct 16 16:20:16.527 INFO kablam!    |
Oct 16 16:20:16.527 INFO kablam!    = note: #[warn(unused_must_use)] on by default
Oct 16 16:20:16.527 INFO kablam!    = note: this `Result` may be an `Err` variant, which should be handled
Oct 16 16:20:16.527 INFO kablam! 
Oct 16 16:20:16.527 INFO kablam! warning: unused `std::result::Result` which must be used
Oct 16 16:20:16.527 INFO kablam!    --> tests/lib.rs:151:9
Oct 16 16:20:16.527 INFO kablam!     |
Oct 16 16:20:16.527 INFO kablam! 151 |         but.check_update(vec!["e97cd944-386d-4c6c-b1e9-76a3175f4ca9".to_string()]);
Oct 16 16:20:16.527 INFO kablam!     |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Oct 16 16:20:16.527 INFO kablam!     |
Oct 16 16:20:16.527 INFO kablam!     = note: this `Result` may be an `Err` variant, which should be handled
Oct 16 16:20:16.527 INFO kablam! 
Oct 16 16:20:18.785 INFO kablam! warning: value assigned to `file` is never read
Oct 16 16:20:18.785 INFO kablam!   --> src/lib.rs:64:13
Oct 16 16:20:18.785 INFO kablam!    |
Oct 16 16:20:18.785 INFO kablam! 64 |             file = fs::File::create(log_path).unwrap();
Oct 16 16:20:18.785 INFO kablam!    |             ^^^^
Oct 16 16:20:18.785 INFO kablam!    |
Oct 16 16:20:18.785 INFO kablam!    = note: #[warn(unused_assignments)] on by default
Oct 16 16:20:18.785 INFO kablam! 
Oct 16 16:20:18.785 INFO kablam! warning: value assigned to `b` is never read
Oct 16 16:20:18.785 INFO kablam!    --> src/lib.rs:652:17
Oct 16 16:20:18.785 INFO kablam!     |
Oct 16 16:20:18.786 INFO kablam! 652 |         let mut b = String::new();
Oct 16 16:20:18.786 INFO kablam!     |                 ^
Oct 16 16:20:18.786 INFO kablam! 
Oct 16 16:20:18.786 INFO kablam! warning: value assigned to `b` is never read
Oct 16 16:20:18.786 INFO kablam!    --> src/lib.rs:666:17
Oct 16 16:20:18.786 INFO kablam!     |
Oct 16 16:20:18.786 INFO kablam! 666 |         let mut b = String::new();
Oct 16 16:20:18.786 INFO kablam!     |                 ^
Oct 16 16:20:18.786 INFO kablam! 
Oct 16 16:20:19.495 INFO kablam! warning: variant `i386` should have a camel case name such as `I386`
Oct 16 16:20:19.496 INFO kablam!    --> src/Responses.rs:100:5
Oct 16 16:20:19.497 INFO kablam!     |
Oct 16 16:20:19.497 INFO kablam! 100 |     i386,
Oct 16 16:20:19.498 INFO kablam!     |     ^^^^
Oct 16 16:20:19.498 INFO kablam!     |
Oct 16 16:20:19.499 INFO kablam!     = note: #[warn(non_camel_case_types)] on by default
Oct 16 16:20:19.499 INFO kablam! 
Oct 16 16:20:19.576 INFO kablam! warning: unused `hyper::client::ResponseFuture` which must be used
Oct 16 16:20:19.577 INFO kablam!    --> src/lib.rs:543:9
Oct 16 16:20:19.578 INFO kablam!     |
Oct 16 16:20:19.578 INFO kablam! 543 |         self.hclient.request(request);
Oct 16 16:20:19.579 INFO kablam!     |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Oct 16 16:20:19.579 INFO kablam!     |
Oct 16 16:20:19.579 INFO kablam!     = note: #[warn(unused_must_use)] on by default
Oct 16 16:20:19.580 INFO kablam!     = note: futures do nothing unless polled
Oct 16 16:20:19.580 INFO kablam! 
Oct 16 16:20:23.604 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 17.13s
Oct 16 16:20:23.631 INFO kablam! su: No module specific data is present
Oct 16 16:20:24.330 INFO running `"docker" "rm" "-f" "743bc6544f21d170d22bd36a886d5ab768190b61409b7e22d62eb1402e8f19d8"`
Oct 16 16:20:24.580 INFO blam! 743bc6544f21d170d22bd36a886d5ab768190b61409b7e22d62eb1402e8f19d8
Oct 16 16:20:24.591 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-1/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-1/rustdoc-test-static-cling-1/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/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 +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-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"`
Oct 16 16:20:25.114 INFO blam! 3fb661a79b6fbcc44dc21edfed71941f6bb080579d4bc5c1ada5344b26ab2e0a
Oct 16 16:20:25.117 INFO running `"docker" "start" "-a" "3fb661a79b6fbcc44dc21edfed71941f6bb080579d4bc5c1ada5344b26ab2e0a"`
Oct 16 16:20:26.095 INFO kablam! usermod: no changes
Oct 16 16:20:26.315 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.19s
Oct 16 16:20:26.337 INFO kablam!      Running /target/debug/deps/butlerd-297ee2d787142d7c
Oct 16 16:20:26.347 INFO kablam!      Running /target/debug/deps/lib-95ee8d2181e623dd
Oct 16 16:20:26.347 INFO blam! 
Oct 16 16:20:26.347 INFO blam! running 0 tests
Oct 16 16:20:26.347 INFO blam! 
Oct 16 16:20:26.347 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 16 16:20:26.347 INFO blam! 
Oct 16 16:20:26.351 INFO blam! 
Oct 16 16:20:26.351 INFO blam! running 20 tests
Oct 16 16:20:26.359 INFO kablam! sh: 1: butler: not found
Oct 16 16:20:26.371 INFO kablam! sh: 1: butler: not found
Oct 16 16:20:26.371 INFO kablam! sh: 1: butler: not found
Oct 16 16:20:26.372 INFO kablam! sh: 1: butler: not found
Oct 16 16:20:26.379 INFO kablam! sh: 1: butler: not found
Oct 16 16:20:26.379 INFO kablam! sh: 1: butler: not found
Oct 16 16:20:26.383 INFO kablam! sh: 1: butler: not found
Oct 16 16:20:26.383 INFO kablam! sh: 1: butler: not found
Oct 16 16:21:26.349 INFO blam! test check_sale_none ... test check_sale_none has been running for over 60 seconds
Oct 16 16:21:26.349 INFO blam! test check_updates ... test check_updates has been running for over 60 seconds
Oct 16 16:21:26.349 INFO blam! test expireall ... test expireall has been running for over 60 seconds
Oct 16 16:21:26.349 INFO blam! test commons ... test commons has been running for over 60 seconds
Oct 16 16:21:26.351 INFO blam! test fetch_uploads ... test fetch_uploads has been running for over 60 seconds
Oct 16 16:21:26.351 INFO blam! test fetch_cave ... test fetch_cave has been running for over 60 seconds
Oct 16 16:21:26.351 INFO blam! test fetch_game ... test fetch_game has been running for over 60 seconds
Oct 16 16:21:26.351 INFO blam! test fetch_version ... test fetch_version has been running for over 60 seconds
Oct 16 16:26:26.320 INFO error running command: process killed after not generating output for  300s
Oct 16 16:26:26.320 INFO running `"docker" "rm" "-f" "3fb661a79b6fbcc44dc21edfed71941f6bb080579d4bc5c1ada5344b26ab2e0a"`
Oct 16 16:26:26.708 INFO blam! 3fb661a79b6fbcc44dc21edfed71941f6bb080579d4bc5c1ada5344b26ab2e0a