Oct 15 09:47:19.476 INFO testing JoshMcguigan/timetrack against try#40d4795669493f1965de7c44029c69552134fe1f for rustdoc-test-static-cling-1
Oct 15 09:47:19.477 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-0/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-0/rustdoc-test-static-cling-1/try#40d4795669493f1965de7c44029c69552134fe1f:/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 +40d4795669493f1965de7c44029c69552134fe1f-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 15 09:47:20.030 INFO blam! 533b064d6730c7eb9399245a6f0cde4c3c6d02be0d163e63d1e73b487edd486c
Oct 15 09:47:20.032 INFO running `"docker" "start" "-a" "533b064d6730c7eb9399245a6f0cde4c3c6d02be0d163e63d1e73b487edd486c"`
Oct 15 09:47:22.470 INFO kablam! usermod: no changes
Oct 15 09:47:22.718 INFO kablam!    Compiling net2 v0.2.33
Oct 15 09:47:22.720 INFO kablam!    Compiling inotify v0.3.0
Oct 15 09:47:22.764 INFO kablam!    Compiling filetime v0.1.15
Oct 15 09:47:22.764 INFO kablam!    Compiling directories v1.0.1
Oct 15 09:47:22.765 INFO kablam!    Compiling nix v0.5.1
Oct 15 09:47:22.766 INFO kablam!    Compiling walkdir v2.2.0
Oct 15 09:47:22.767 INFO kablam!    Compiling toml v0.4.6
Oct 15 09:47:22.779 INFO kablam!    Compiling regex v1.0.4
Oct 15 09:47:30.568 INFO kablam!    Compiling miow v0.1.5
Oct 15 09:47:39.923 INFO kablam!    Compiling mio v0.5.1
Oct 15 09:47:48.927 INFO kablam!    Compiling notify v4.0.4
Oct 15 09:47:48.931 INFO kablam!    Compiling env_logger v0.5.13
Oct 15 09:47:56.356 INFO kablam!    Compiling timetrack v0.2.5 (/source)
Oct 15 09:47:58.001 INFO kablam! warning: unused import: `std::fs`
Oct 15 09:47:58.001 INFO kablam!  --> src/schedule/mod.rs:2:5
Oct 15 09:47:58.001 INFO kablam!   |
Oct 15 09:47:58.001 INFO kablam! 2 | use std::fs;
Oct 15 09:47:58.001 INFO kablam!   |     ^^^^^^^
Oct 15 09:47:58.001 INFO kablam!   |
Oct 15 09:47:58.001 INFO kablam!   = note: #[warn(unused_imports)] on by default
Oct 15 09:47:58.001 INFO kablam! 
Oct 15 09:47:58.001 INFO kablam! warning: unused import: `std::fs::OpenOptions`
Oct 15 09:47:58.001 INFO kablam!  --> src/schedule/mod.rs:3:5
Oct 15 09:47:58.001 INFO kablam!   |
Oct 15 09:47:58.001 INFO kablam! 3 | use std::fs::OpenOptions;
Oct 15 09:47:58.001 INFO kablam!   |     ^^^^^^^^^^^^^^^^^^^^
Oct 15 09:47:58.001 INFO kablam! 
Oct 15 09:47:58.001 INFO kablam! warning: unused import: `std::io::Write`
Oct 15 09:47:58.001 INFO kablam!  --> src/schedule/mod.rs:4:5
Oct 15 09:47:58.001 INFO kablam!   |
Oct 15 09:47:58.001 INFO kablam! 4 | use std::io::Write;
Oct 15 09:47:58.001 INFO kablam!   |     ^^^^^^^^^^^^^^
Oct 15 09:47:58.001 INFO kablam! 
Oct 15 09:47:58.364 INFO kablam! warning: function is never used: `get_plist_file_contents`
Oct 15 09:47:58.364 INFO kablam!   --> src/schedule/mod.rs:13:1
Oct 15 09:47:58.364 INFO kablam!    |
Oct 15 09:47:58.364 INFO kablam! 13 | fn get_plist_file_contents() -> String {
Oct 15 09:47:58.364 INFO kablam!    | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Oct 15 09:47:58.364 INFO kablam!    |
Oct 15 09:47:58.364 INFO kablam!    = note: #[warn(dead_code)] on by default
Oct 15 09:47:58.364 INFO kablam! 
Oct 15 09:47:58.364 INFO kablam! warning: function is never used: `get_plist_file_path`
Oct 15 09:47:58.364 INFO kablam!   --> src/schedule/mod.rs:35:1
Oct 15 09:47:58.364 INFO kablam!    |
Oct 15 09:47:58.364 INFO kablam! 35 | fn get_plist_file_path() -> PathBuf {
Oct 15 09:47:58.364 INFO kablam!    | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Oct 15 09:47:58.364 INFO kablam! 
Oct 15 09:48:07.320 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 44.83s
Oct 15 09:48:07.328 INFO kablam! su: No module specific data is present
Oct 15 09:48:08.242 INFO running `"docker" "rm" "-f" "533b064d6730c7eb9399245a6f0cde4c3c6d02be0d163e63d1e73b487edd486c"`
Oct 15 09:48:08.464 INFO blam! 533b064d6730c7eb9399245a6f0cde4c3c6d02be0d163e63d1e73b487edd486c
Oct 15 09:48:08.469 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-0/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-0/rustdoc-test-static-cling-1/try#40d4795669493f1965de7c44029c69552134fe1f:/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 +40d4795669493f1965de7c44029c69552134fe1f-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 15 09:48:08.795 INFO blam! 8e3364e7ca322ea7415f479bc3b5ecae3f0cbf0a6353dc7fce2759030df8ffb6
Oct 15 09:48:08.797 INFO running `"docker" "start" "-a" "8e3364e7ca322ea7415f479bc3b5ecae3f0cbf0a6353dc7fce2759030df8ffb6"`
Oct 15 09:48:10.035 INFO kablam! usermod: no changes
Oct 15 09:48:10.162 INFO kablam!    Compiling timetrack v0.2.5 (/source)
Oct 15 09:48:11.911 INFO kablam! warning: unused import: `std::fs`
Oct 15 09:48:11.911 INFO kablam!  --> src/schedule/mod.rs:2:5
Oct 15 09:48:11.912 INFO kablam!   |
Oct 15 09:48:11.912 INFO kablam! 2 | use std::fs;
Oct 15 09:48:11.912 INFO kablam!   |     ^^^^^^^
Oct 15 09:48:11.912 INFO kablam!   |
Oct 15 09:48:11.913 INFO kablam!   = note: #[warn(unused_imports)] on by default
Oct 15 09:48:11.913 INFO kablam! 
Oct 15 09:48:11.913 INFO kablam! warning: unused import: `std::fs::OpenOptions`
Oct 15 09:48:11.913 INFO kablam!  --> src/schedule/mod.rs:3:5
Oct 15 09:48:11.914 INFO kablam!   |
Oct 15 09:48:11.914 INFO kablam! 3 | use std::fs::OpenOptions;
Oct 15 09:48:11.914 INFO kablam!   |     ^^^^^^^^^^^^^^^^^^^^
Oct 15 09:48:11.915 INFO kablam! 
Oct 15 09:48:11.915 INFO kablam! warning: unused import: `std::io::Write`
Oct 15 09:48:11.915 INFO kablam!  --> src/schedule/mod.rs:4:5
Oct 15 09:48:11.915 INFO kablam!   |
Oct 15 09:48:11.916 INFO kablam! 4 | use std::io::Write;
Oct 15 09:48:11.916 INFO kablam!   |     ^^^^^^^^^^^^^^
Oct 15 09:48:11.916 INFO kablam! 
Oct 15 09:48:12.843 INFO kablam! warning: function is never used: `get_plist_file_contents`
Oct 15 09:48:12.843 INFO kablam!   --> src/schedule/mod.rs:13:1
Oct 15 09:48:12.843 INFO kablam!    |
Oct 15 09:48:12.843 INFO kablam! 13 | fn get_plist_file_contents() -> String {
Oct 15 09:48:12.843 INFO kablam!    | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Oct 15 09:48:12.843 INFO kablam!    |
Oct 15 09:48:12.843 INFO kablam!    = note: #[warn(dead_code)] on by default
Oct 15 09:48:12.843 INFO kablam! 
Oct 15 09:48:12.843 INFO kablam! warning: function is never used: `get_plist_file_path`
Oct 15 09:48:12.843 INFO kablam!   --> src/schedule/mod.rs:35:1
Oct 15 09:48:12.843 INFO kablam!    |
Oct 15 09:48:12.843 INFO kablam! 35 | fn get_plist_file_path() -> PathBuf {
Oct 15 09:48:12.843 INFO kablam!    | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Oct 15 09:48:12.843 INFO kablam! 
Oct 15 09:48:15.767 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 5.71s
Oct 15 09:48:15.787 INFO kablam! su: No module specific data is present
Oct 15 09:48:16.451 INFO running `"docker" "rm" "-f" "8e3364e7ca322ea7415f479bc3b5ecae3f0cbf0a6353dc7fce2759030df8ffb6"`
Oct 15 09:48:16.787 INFO blam! 8e3364e7ca322ea7415f479bc3b5ecae3f0cbf0a6353dc7fce2759030df8ffb6
Oct 15 09:48:16.792 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-0/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-0/rustdoc-test-static-cling-1/try#40d4795669493f1965de7c44029c69552134fe1f:/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 +40d4795669493f1965de7c44029c69552134fe1f-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 15 09:48:17.256 INFO blam! 107b690bbfc30fba50c0673451ebe9325eee3719d50bc92168cf0de2027abebe
Oct 15 09:48:17.263 INFO running `"docker" "start" "-a" "107b690bbfc30fba50c0673451ebe9325eee3719d50bc92168cf0de2027abebe"`
Oct 15 09:48:18.379 INFO kablam! usermod: no changes
Oct 15 09:48:18.507 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.10s
Oct 15 09:48:18.515 INFO kablam!      Running /target/debug/deps/timetrack-1cbedcb055fbd73a
Oct 15 09:48:18.539 INFO blam! 
Oct 15 09:48:18.539 INFO blam! running 26 tests
Oct 15 09:48:18.539 INFO blam! test calc::display::tests::to_hms_hour ... ok
Oct 15 09:48:18.539 INFO blam! test calc::display::tests::to_hms_hour_minute ... ok
Oct 15 09:48:18.539 INFO blam! test calc::display::tests::to_hms_hours ... ok
Oct 15 09:48:18.539 INFO blam! test calc::display::tests::to_hms_hours_minute ... ok
Oct 15 09:48:18.539 INFO blam! test calc::raw_log::tests::raw_logs_from_string ... ok
Oct 15 09:48:18.539 INFO blam! test calc::raw_log::tests::raw_log_display ... ok
Oct 15 09:48:18.539 INFO blam! test calc::display::tests::to_hms_string_zero ... ok
Oct 15 09:48:18.539 INFO blam! test calc::span::tests::get_last_timestamp_per_project_no_spans ... ok
Oct 15 09:48:18.539 INFO blam! test calc::span::tests::get_last_timestamp_per_project_several_spans ... ok
Oct 15 09:48:18.539 INFO blam! test calc::span::tests::get_vec_raw_logs_from_map_last_timestamp_per_project_empty ... ok
Oct 15 09:48:18.539 INFO blam! test calc::span::tests::get_vec_raw_logs_from_map_last_timestamp_per_project_several_projects ... ok
Oct 15 09:48:18.539 INFO blam! test calc::span::tests::raw_log_to_span_large_timegap ... ok
Oct 15 09:48:18.539 INFO blam! test calc::span::tests::raw_log_to_span_no_logs ... ok
Oct 15 09:48:18.539 INFO blam! test calc::display::tests::to_hms_minute ... ok
Oct 15 09:48:18.539 INFO blam! test calc::span::tests::raw_log_to_span_single_project ... ok
Oct 15 09:48:18.539 INFO blam! test calc::span::tests::raw_log_to_span_two_project ... ok
Oct 15 09:48:18.539 INFO blam! test calc::span::tests::raw_log_to_span_two_projects_interleaved ... ok
Oct 15 09:48:18.539 INFO blam! test calc::tests::calculate_project_total_time_single_project ... ok
Oct 15 09:48:18.539 INFO blam! test calc::tests::calculate_project_total_time_two_projects ... ok
Oct 15 09:48:18.539 INFO blam! test track::tests::extract_project_name_multiple_paths ... ok
Oct 15 09:48:18.539 INFO blam! test track::tests::extract_project_name_none ... ok
Oct 15 09:48:18.539 INFO blam! test track::tests::extract_project_name_some ... ok
Oct 15 09:48:18.544 INFO blam! test calc::raw_log::tests::raw_log_from_str ... ok
Oct 15 09:48:18.544 INFO blam! test calc::display::tests::to_hms_second ... ok
Oct 15 09:48:18.544 INFO blam! test calc::display::tests::to_hms_minutes ... ok
Oct 15 09:48:18.544 INFO blam! test calc::display::tests::to_hms_seconds ... ok
Oct 15 09:48:18.544 INFO blam! 
Oct 15 09:48:18.544 INFO blam! test result: ok. 26 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 15 09:48:18.544 INFO blam! 
Oct 15 09:48:18.551 INFO kablam!      Running /target/debug/deps/timetrack-08e183a9abe1389b
Oct 15 09:48:18.559 INFO kablam!      Running /target/debug/deps/integration-5bfd073bd381dedf
Oct 15 09:48:18.559 INFO blam! 
Oct 15 09:48:18.559 INFO blam! running 0 tests
Oct 15 09:48:18.559 INFO blam! 
Oct 15 09:48:18.559 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 15 09:48:18.559 INFO blam! 
Oct 15 09:48:18.571 INFO blam! 
Oct 15 09:48:18.571 INFO kablam!    Doc-tests timetrack
Oct 15 09:48:18.571 INFO blam! running 1 test
Oct 15 09:48:18.571 INFO blam! test integration ... ignored
Oct 15 09:48:18.571 INFO blam! 
Oct 15 09:48:18.571 INFO blam! test result: ok. 0 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out
Oct 15 09:48:18.571 INFO blam! 
Oct 15 09:48:20.903 INFO blam! 
Oct 15 09:48:20.903 INFO blam! running 0 tests
Oct 15 09:48:20.903 INFO blam! 
Oct 15 09:48:20.903 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 15 09:48:20.903 INFO blam! 
Oct 15 09:48:20.912 INFO kablam! su: No module specific data is present
Oct 15 09:48:21.848 INFO running `"docker" "rm" "-f" "107b690bbfc30fba50c0673451ebe9325eee3719d50bc92168cf0de2027abebe"`
Oct 15 09:48:22.183 INFO blam! 107b690bbfc30fba50c0673451ebe9325eee3719d50bc92168cf0de2027abebe