Nov 01 20:21:42.294 INFO testing JoshMcguigan/timetrack against beta-2018-10-30 for beta-1.31-1
Nov 01 20:21:42.295 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-5/beta-2018-10-30:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/beta-1.31-1/beta-2018-10-30:/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 +beta-2018-10-30 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"`
Nov 01 20:21:42.652 INFO blam! 272c1243da600ae9f672e82e6e9f29f6faa09a02c81b18154ecd485165b8e0c2
Nov 01 20:21:42.655 INFO running `"docker" "start" "-a" "272c1243da600ae9f672e82e6e9f29f6faa09a02c81b18154ecd485165b8e0c2"`
Nov 01 20:21:44.023 INFO kablam! usermod: no changes
Nov 01 20:21:44.203 INFO kablam!    Compiling serde v1.0.72
Nov 01 20:21:44.231 INFO kablam!    Compiling inotify v0.3.0
Nov 01 20:21:44.231 INFO kablam!    Compiling directories v1.0.1
Nov 01 20:21:44.232 INFO kablam!    Compiling log v0.3.9
Nov 01 20:21:44.234 INFO kablam!    Compiling serde_derive v1.0.72
Nov 01 20:21:44.234 INFO kablam!    Compiling env_logger v0.5.13
Nov 01 20:21:47.811 INFO kablam!    Compiling mio v0.5.1
Nov 01 20:21:53.144 INFO kablam!    Compiling notify v4.0.4
Nov 01 20:22:10.131 INFO kablam!    Compiling toml v0.4.6
Nov 01 20:22:14.391 INFO kablam!    Compiling timetrack v0.2.5 (/source)
Nov 01 20:22:16.127 INFO kablam! warning: unused import: `std::fs`
Nov 01 20:22:16.127 INFO kablam!  --> src/schedule/mod.rs:2:5
Nov 01 20:22:16.127 INFO kablam!   |
Nov 01 20:22:16.128 INFO kablam! 2 | use std::fs;
Nov 01 20:22:16.128 INFO kablam!   |     ^^^^^^^
Nov 01 20:22:16.128 INFO kablam!   |
Nov 01 20:22:16.128 INFO kablam!   = note: #[warn(unused_imports)] on by default
Nov 01 20:22:16.128 INFO kablam! 
Nov 01 20:22:16.129 INFO kablam! warning: unused import: `std::fs::OpenOptions`
Nov 01 20:22:16.129 INFO kablam!  --> src/schedule/mod.rs:3:5
Nov 01 20:22:16.129 INFO kablam!   |
Nov 01 20:22:16.129 INFO kablam! 3 | use std::fs::OpenOptions;
Nov 01 20:22:16.129 INFO kablam!   |     ^^^^^^^^^^^^^^^^^^^^
Nov 01 20:22:16.129 INFO kablam! 
Nov 01 20:22:16.130 INFO kablam! warning: unused import: `std::io::Write`
Nov 01 20:22:16.130 INFO kablam!  --> src/schedule/mod.rs:4:5
Nov 01 20:22:16.130 INFO kablam!   |
Nov 01 20:22:16.130 INFO kablam! 4 | use std::io::Write;
Nov 01 20:22:16.130 INFO kablam!   |     ^^^^^^^^^^^^^^
Nov 01 20:22:16.131 INFO kablam! 
Nov 01 20:22:16.439 INFO kablam! warning: function is never used: `get_plist_file_contents`
Nov 01 20:22:16.439 INFO kablam!   --> src/schedule/mod.rs:13:1
Nov 01 20:22:16.439 INFO kablam!    |
Nov 01 20:22:16.439 INFO kablam! 13 | fn get_plist_file_contents() -> String {
Nov 01 20:22:16.439 INFO kablam!    | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 01 20:22:16.439 INFO kablam!    |
Nov 01 20:22:16.439 INFO kablam!    = note: #[warn(dead_code)] on by default
Nov 01 20:22:16.439 INFO kablam! 
Nov 01 20:22:16.439 INFO kablam! warning: function is never used: `get_plist_file_path`
Nov 01 20:22:16.439 INFO kablam!   --> src/schedule/mod.rs:35:1
Nov 01 20:22:16.439 INFO kablam!    |
Nov 01 20:22:16.439 INFO kablam! 35 | fn get_plist_file_path() -> PathBuf {
Nov 01 20:22:16.439 INFO kablam!    | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 01 20:22:16.439 INFO kablam! 
Nov 01 20:22:25.523 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 41.47s
Nov 01 20:22:25.533 INFO kablam! su: No module specific data is present
Nov 01 20:22:26.816 INFO running `"docker" "rm" "-f" "272c1243da600ae9f672e82e6e9f29f6faa09a02c81b18154ecd485165b8e0c2"`
Nov 01 20:22:27.019 INFO blam! 272c1243da600ae9f672e82e6e9f29f6faa09a02c81b18154ecd485165b8e0c2
Nov 01 20:22:27.023 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-5/beta-2018-10-30:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/beta-1.31-1/beta-2018-10-30:/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 +beta-2018-10-30 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"`
Nov 01 20:22:27.509 INFO blam! 77d9f7670f5fb398b30d5b5ce2ecc7827da068b684b26d4c685b84e9fde557c2
Nov 01 20:22:27.524 INFO running `"docker" "start" "-a" "77d9f7670f5fb398b30d5b5ce2ecc7827da068b684b26d4c685b84e9fde557c2"`
Nov 01 20:22:28.765 INFO kablam! usermod: no changes
Nov 01 20:22:28.939 INFO kablam!    Compiling timetrack v0.2.5 (/source)
Nov 01 20:22:32.798 INFO kablam! warning: unused import: `std::fs`
Nov 01 20:22:32.798 INFO kablam!  --> src/schedule/mod.rs:2:5
Nov 01 20:22:32.798 INFO kablam!   |
Nov 01 20:22:32.798 INFO kablam! 2 | use std::fs;
Nov 01 20:22:32.798 INFO kablam!   |     ^^^^^^^
Nov 01 20:22:32.798 INFO kablam!   |
Nov 01 20:22:32.798 INFO kablam!   = note: #[warn(unused_imports)] on by default
Nov 01 20:22:32.798 INFO kablam! 
Nov 01 20:22:32.798 INFO kablam! warning: unused import: `std::fs::OpenOptions`
Nov 01 20:22:32.798 INFO kablam!  --> src/schedule/mod.rs:3:5
Nov 01 20:22:32.798 INFO kablam!   |
Nov 01 20:22:32.798 INFO kablam! 3 | use std::fs::OpenOptions;
Nov 01 20:22:32.798 INFO kablam!   |     ^^^^^^^^^^^^^^^^^^^^
Nov 01 20:22:32.798 INFO kablam! 
Nov 01 20:22:32.798 INFO kablam! warning: unused import: `std::io::Write`
Nov 01 20:22:32.798 INFO kablam!  --> src/schedule/mod.rs:4:5
Nov 01 20:22:32.798 INFO kablam!   |
Nov 01 20:22:32.798 INFO kablam! 4 | use std::io::Write;
Nov 01 20:22:32.798 INFO kablam!   |     ^^^^^^^^^^^^^^
Nov 01 20:22:32.798 INFO kablam! 
Nov 01 20:22:34.523 INFO kablam! warning: function is never used: `get_plist_file_contents`
Nov 01 20:22:34.523 INFO kablam!   --> src/schedule/mod.rs:13:1
Nov 01 20:22:34.523 INFO kablam!    |
Nov 01 20:22:34.523 INFO kablam! 13 | fn get_plist_file_contents() -> String {
Nov 01 20:22:34.523 INFO kablam!    | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 01 20:22:34.523 INFO kablam!    |
Nov 01 20:22:34.523 INFO kablam!    = note: #[warn(dead_code)] on by default
Nov 01 20:22:34.523 INFO kablam! 
Nov 01 20:22:34.523 INFO kablam! warning: function is never used: `get_plist_file_path`
Nov 01 20:22:34.523 INFO kablam!   --> src/schedule/mod.rs:35:1
Nov 01 20:22:34.523 INFO kablam!    |
Nov 01 20:22:34.523 INFO kablam! 35 | fn get_plist_file_path() -> PathBuf {
Nov 01 20:22:34.523 INFO kablam!    | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 01 20:22:34.523 INFO kablam! 
Nov 01 20:22:37.099 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 8.29s
Nov 01 20:22:37.107 INFO kablam! su: No module specific data is present
Nov 01 20:22:38.394 INFO running `"docker" "rm" "-f" "77d9f7670f5fb398b30d5b5ce2ecc7827da068b684b26d4c685b84e9fde557c2"`
Nov 01 20:22:38.671 INFO blam! 77d9f7670f5fb398b30d5b5ce2ecc7827da068b684b26d4c685b84e9fde557c2
Nov 01 20:22:38.688 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-5/beta-2018-10-30:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/beta-1.31-1/beta-2018-10-30:/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 +beta-2018-10-30 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"`
Nov 01 20:22:39.350 INFO blam! 7915b026d93c1ceab7d055319eb44a1232d32b5cc759871a8d7bea708f30626c
Nov 01 20:22:39.350 INFO running `"docker" "start" "-a" "7915b026d93c1ceab7d055319eb44a1232d32b5cc759871a8d7bea708f30626c"`
Nov 01 20:22:40.427 INFO kablam! usermod: no changes
Nov 01 20:22:40.604 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.14s
Nov 01 20:22:40.607 INFO kablam!      Running /target/debug/deps/timetrack-3e6e371783e40b9b
Nov 01 20:22:40.615 INFO blam! 
Nov 01 20:22:40.615 INFO blam! running 26 tests
Nov 01 20:22:40.615 INFO blam! test calc::display::tests::to_hms_hour ... ok
Nov 01 20:22:40.616 INFO blam! test calc::display::tests::to_hms_hours ... ok
Nov 01 20:22:40.616 INFO blam! test calc::display::tests::to_hms_hour_minute ... ok
Nov 01 20:22:40.619 INFO blam! test calc::raw_log::tests::raw_log_display ... ok
Nov 01 20:22:40.623 INFO blam! test calc::display::tests::to_hms_hours_minute ... ok
Nov 01 20:22:40.624 INFO blam! test calc::display::tests::to_hms_string_zero ... ok
Nov 01 20:22:40.624 INFO blam! test calc::display::tests::to_hms_second ... ok
Nov 01 20:22:40.624 INFO blam! test calc::raw_log::tests::raw_log_from_str ... ok
Nov 01 20:22:40.624 INFO blam! test calc::display::tests::to_hms_minute ... ok
Nov 01 20:22:40.625 INFO blam! test calc::display::tests::to_hms_seconds ... ok
Nov 01 20:22:40.625 INFO blam! test calc::display::tests::to_hms_minutes ... ok
Nov 01 20:22:40.625 INFO blam! test calc::span::tests::raw_log_to_span_no_logs ... ok
Nov 01 20:22:40.626 INFO blam! test calc::span::tests::raw_log_to_span_large_timegap ... ok
Nov 01 20:22:40.626 INFO blam! test calc::span::tests::get_vec_raw_logs_from_map_last_timestamp_per_project_several_projects ... ok
Nov 01 20:22:40.626 INFO blam! test calc::span::tests::get_vec_raw_logs_from_map_last_timestamp_per_project_empty ... ok
Nov 01 20:22:40.626 INFO blam! test calc::span::tests::get_last_timestamp_per_project_no_spans ... ok
Nov 01 20:22:40.627 INFO blam! test calc::span::tests::raw_log_to_span_two_project ... ok
Nov 01 20:22:40.627 INFO blam! test calc::span::tests::raw_log_to_span_two_projects_interleaved ... ok
Nov 01 20:22:40.627 INFO blam! test calc::tests::calculate_project_total_time_single_project ... ok
Nov 01 20:22:40.627 INFO blam! test calc::tests::calculate_project_total_time_two_projects ... ok
Nov 01 20:22:40.628 INFO blam! test track::tests::extract_project_name_multiple_paths ... ok
Nov 01 20:22:40.628 INFO blam! test track::tests::extract_project_name_none ... ok
Nov 01 20:22:40.628 INFO blam! test track::tests::extract_project_name_some ... ok
Nov 01 20:22:40.628 INFO blam! test calc::span::tests::raw_log_to_span_single_project ... ok
Nov 01 20:22:40.629 INFO blam! test calc::span::tests::get_last_timestamp_per_project_several_spans ... ok
Nov 01 20:22:40.629 INFO blam! test calc::raw_log::tests::raw_logs_from_string ... ok
Nov 01 20:22:40.629 INFO blam! 
Nov 01 20:22:40.630 INFO blam! test result: ok. 26 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 01 20:22:40.630 INFO blam! 
Nov 01 20:22:40.635 INFO kablam!      Running /target/debug/deps/timetrack-d1f0929d1c5fd524
Nov 01 20:22:40.643 INFO kablam!      Running /target/debug/deps/integration-c1c24c53e0bd5f67
Nov 01 20:22:40.644 INFO blam! 
Nov 01 20:22:40.644 INFO blam! running 0 tests
Nov 01 20:22:40.644 INFO blam! 
Nov 01 20:22:40.645 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 01 20:22:40.645 INFO blam! 
Nov 01 20:22:40.651 INFO blam! 
Nov 01 20:22:40.656 INFO kablam!    Doc-tests timetrack
Nov 01 20:22:40.656 INFO blam! running 1 test
Nov 01 20:22:40.656 INFO blam! test integration ... ignored
Nov 01 20:22:40.657 INFO blam! 
Nov 01 20:22:40.657 INFO blam! test result: ok. 0 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out
Nov 01 20:22:40.657 INFO blam! 
Nov 01 20:22:43.790 INFO blam! 
Nov 01 20:22:43.790 INFO blam! running 0 tests
Nov 01 20:22:43.790 INFO blam! 
Nov 01 20:22:43.790 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 01 20:22:43.790 INFO blam! 
Nov 01 20:22:43.799 INFO kablam! su: No module specific data is present
Nov 01 20:22:44.806 INFO running `"docker" "rm" "-f" "7915b026d93c1ceab7d055319eb44a1232d32b5cc759871a8d7bea708f30626c"`
Nov 01 20:22:45.058 INFO blam! 7915b026d93c1ceab7d055319eb44a1232d32b5cc759871a8d7bea708f30626c
