Oct 15 04:01:25.170 INFO testing anp/fomo against try#40d4795669493f1965de7c44029c69552134fe1f for rustdoc-test-static-cling-1 Oct 15 04:01:25.170 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-7/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-7/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 04:01:25.591 INFO blam! c29be0310b61da96d58dc00454fbe4bd69d34fc7eb0e2dcb8c303365da18194c Oct 15 04:01:25.597 INFO running `"docker" "start" "-a" "c29be0310b61da96d58dc00454fbe4bd69d34fc7eb0e2dcb8c303365da18194c"` Oct 15 04:01:26.786 INFO kablam! usermod: no changes Oct 15 04:01:27.015 INFO kablam! Compiling serde v0.9.6 Oct 15 04:01:27.019 INFO kablam! Compiling num-integer v0.1.33 Oct 15 04:01:27.019 INFO kablam! Compiling filetime v0.1.10 Oct 15 04:01:27.020 INFO kablam! Compiling inotify v0.3.0 Oct 15 04:01:27.020 INFO kablam! Compiling net2 v0.2.27 Oct 15 04:01:27.020 INFO kablam! Compiling thread_local v0.3.3 Oct 15 04:01:27.021 INFO kablam! Compiling aho-corasick v0.6.3 Oct 15 04:01:27.021 INFO kablam! Compiling clap v2.20.5 Oct 15 04:01:31.503 INFO kablam! Compiling serde_codegen_internals v0.13.0 Oct 15 04:01:32.207 INFO kablam! Compiling backtrace-sys v0.1.10 Oct 15 04:01:32.208 INFO kablam! Compiling num-iter v0.1.33 Oct 15 04:01:32.362 INFO kablam! Compiling miow v0.1.5 Oct 15 04:01:33.896 INFO kablam! Compiling regex v0.2.1 Oct 15 04:01:34.499 INFO kablam! Compiling backtrace v0.3.0 Oct 15 04:01:34.635 INFO kablam! Compiling num v0.1.36 Oct 15 04:01:34.653 INFO kablam! Compiling mio v0.5.1 Oct 15 04:01:40.460 INFO kablam! Compiling serde_derive v0.9.6 Oct 15 04:01:40.461 INFO kablam! Compiling error-chain v0.10.0 Oct 15 04:01:57.507 INFO kablam! Compiling env_logger v0.4.2 Oct 15 04:02:02.207 INFO kablam! Compiling serde_json v0.9.6 Oct 15 04:02:02.207 INFO kablam! Compiling chrono v0.3.0 Oct 15 04:02:12.423 INFO kablam! Compiling fomo v0.1.0 (/source) Oct 15 04:02:13.991 INFO kablam! warning: unused import: `DebouncedEvent` Oct 15 04:02:13.991 INFO kablam! --> src/notify/inotify/mod.rs:25:13 Oct 15 04:02:13.991 INFO kablam! | Oct 15 04:02:13.991 INFO kablam! 25 | use super::{DebouncedEvent, Error, Op, RawEvent, RecursiveMode, Result, Watcher, op}; Oct 15 04:02:13.991 INFO kablam! | ^^^^^^^^^^^^^^ Oct 15 04:02:13.991 INFO kablam! | Oct 15 04:02:13.991 INFO kablam! = note: #[warn(unused_imports)] on by default Oct 15 04:02:13.991 INFO kablam! Oct 15 04:02:14.068 INFO kablam! warning: use of deprecated item 'std::ascii::AsciiExt': use inherent methods instead Oct 15 04:02:14.068 INFO kablam! --> src/query.rs:1:5 Oct 15 04:02:14.068 INFO kablam! | Oct 15 04:02:14.069 INFO kablam! 1 | use std::ascii::AsciiExt; Oct 15 04:02:14.069 INFO kablam! | ^^^^^^^^^^^^^^^^^^^^ Oct 15 04:02:14.069 INFO kablam! | Oct 15 04:02:14.070 INFO kablam! = note: #[warn(deprecated)] on by default Oct 15 04:02:14.070 INFO kablam! Oct 15 04:02:14.827 INFO kablam! warning: unused import: `std::ascii::AsciiExt` Oct 15 04:02:14.827 INFO kablam! --> src/query.rs:1:5 Oct 15 04:02:14.827 INFO kablam! | Oct 15 04:02:14.827 INFO kablam! 1 | use std::ascii::AsciiExt; Oct 15 04:02:14.827 INFO kablam! | ^^^^^^^^^^^^^^^^^^^^ Oct 15 04:02:14.827 INFO kablam! Oct 15 04:02:25.991 INFO kablam! Finished dev [unoptimized + debuginfo] target(s) in 59.17s Oct 15 04:02:26.005 INFO kablam! su: No module specific data is present Oct 15 04:02:26.551 INFO running `"docker" "rm" "-f" "c29be0310b61da96d58dc00454fbe4bd69d34fc7eb0e2dcb8c303365da18194c"` Oct 15 04:02:26.847 INFO blam! c29be0310b61da96d58dc00454fbe4bd69d34fc7eb0e2dcb8c303365da18194c Oct 15 04:02:26.851 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-7/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-7/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 04:02:27.355 INFO blam! 7b19d257495b457c0732d181d6832274f9fb27f471629a3efdd5271ddf5c5b24 Oct 15 04:02:27.359 INFO running `"docker" "start" "-a" "7b19d257495b457c0732d181d6832274f9fb27f471629a3efdd5271ddf5c5b24"` Oct 15 04:02:28.415 INFO kablam! usermod: no changes Oct 15 04:02:28.571 INFO kablam! Compiling fomo v0.1.0 (/source) Oct 15 04:02:33.519 INFO kablam! warning: unused import: `DebouncedEvent` Oct 15 04:02:33.519 INFO kablam! --> src/notify/inotify/mod.rs:25:13 Oct 15 04:02:33.519 INFO kablam! | Oct 15 04:02:33.519 INFO kablam! 25 | use super::{DebouncedEvent, Error, Op, RawEvent, RecursiveMode, Result, Watcher, op}; Oct 15 04:02:33.519 INFO kablam! | ^^^^^^^^^^^^^^ Oct 15 04:02:33.519 INFO kablam! | Oct 15 04:02:33.519 INFO kablam! = note: #[warn(unused_imports)] on by default Oct 15 04:02:33.519 INFO kablam! Oct 15 04:02:33.731 INFO kablam! warning: unused macro definition Oct 15 04:02:33.732 INFO kablam! --> tests/utils/mod.rs:207:1 Oct 15 04:02:33.732 INFO kablam! | Oct 15 04:02:33.732 INFO kablam! 207 | / macro_rules! assert_eq_any { Oct 15 04:02:33.733 INFO kablam! 208 | | ($left:expr, $right1:expr, $right2:expr) => ({ Oct 15 04:02:33.733 INFO kablam! 209 | | match (&($left), &($right1), &($right2)) { Oct 15 04:02:33.733 INFO kablam! 210 | | (left_val, right1_val, right2_val) => { Oct 15 04:02:33.733 INFO kablam! ... | Oct 15 04:02:33.734 INFO kablam! 218 | | }) Oct 15 04:02:33.734 INFO kablam! 219 | | } Oct 15 04:02:33.734 INFO kablam! | |_^ Oct 15 04:02:33.735 INFO kablam! | Oct 15 04:02:33.737 INFO kablam! = note: #[warn(unused_macros)] on by default Oct 15 04:02:33.737 INFO kablam! Oct 15 04:02:33.945 INFO kablam! warning: use of deprecated item 'std::ascii::AsciiExt': use inherent methods instead Oct 15 04:02:33.945 INFO kablam! --> src/query.rs:1:5 Oct 15 04:02:33.945 INFO kablam! | Oct 15 04:02:33.945 INFO kablam! 1 | use std::ascii::AsciiExt; Oct 15 04:02:33.945 INFO kablam! | ^^^^^^^^^^^^^^^^^^^^ Oct 15 04:02:33.945 INFO kablam! | Oct 15 04:02:33.945 INFO kablam! = note: #[warn(deprecated)] on by default Oct 15 04:02:33.945 INFO kablam! Oct 15 04:02:34.755 INFO kablam! warning: unused macro definition Oct 15 04:02:34.755 INFO kablam! --> tests/utils/mod.rs:207:1 Oct 15 04:02:34.755 INFO kablam! | Oct 15 04:02:34.755 INFO kablam! 207 | / macro_rules! assert_eq_any { Oct 15 04:02:34.755 INFO kablam! 208 | | ($left:expr, $right1:expr, $right2:expr) => ({ Oct 15 04:02:34.755 INFO kablam! 209 | | match (&($left), &($right1), &($right2)) { Oct 15 04:02:34.755 INFO kablam! 210 | | (left_val, right1_val, right2_val) => { Oct 15 04:02:34.755 INFO kablam! ... | Oct 15 04:02:34.755 INFO kablam! 218 | | }) Oct 15 04:02:34.755 INFO kablam! 219 | | } Oct 15 04:02:34.755 INFO kablam! | |_^ Oct 15 04:02:34.755 INFO kablam! | Oct 15 04:02:34.755 INFO kablam! = note: #[warn(unused_macros)] on by default Oct 15 04:02:34.755 INFO kablam! Oct 15 04:02:34.755 INFO kablam! warning: unused import: `fomo::notify` Oct 15 04:02:34.755 INFO kablam! --> tests/notify.rs:6:5 Oct 15 04:02:34.755 INFO kablam! | Oct 15 04:02:34.755 INFO kablam! 6 | use fomo::notify; Oct 15 04:02:34.755 INFO kablam! | ^^^^^^^^^^^^ Oct 15 04:02:34.755 INFO kablam! | Oct 15 04:02:34.755 INFO kablam! = note: #[warn(unused_imports)] on by default Oct 15 04:02:34.755 INFO kablam! Oct 15 04:02:35.463 INFO kablam! warning: unused macro definition Oct 15 04:02:35.463 INFO kablam! --> tests/utils/mod.rs:207:1 Oct 15 04:02:35.463 INFO kablam! | Oct 15 04:02:35.463 INFO kablam! 207 | / macro_rules! assert_eq_any { Oct 15 04:02:35.463 INFO kablam! 208 | | ($left:expr, $right1:expr, $right2:expr) => ({ Oct 15 04:02:35.463 INFO kablam! 209 | | match (&($left), &($right1), &($right2)) { Oct 15 04:02:35.463 INFO kablam! 210 | | (left_val, right1_val, right2_val) => { Oct 15 04:02:35.463 INFO kablam! ... | Oct 15 04:02:35.463 INFO kablam! 218 | | }) Oct 15 04:02:35.463 INFO kablam! 219 | | } Oct 15 04:02:35.463 INFO kablam! | |_^ Oct 15 04:02:35.463 INFO kablam! | Oct 15 04:02:35.463 INFO kablam! = note: #[warn(unused_macros)] on by default Oct 15 04:02:35.463 INFO kablam! Oct 15 04:02:35.835 INFO kablam! warning: unused macro definition Oct 15 04:02:35.835 INFO kablam! --> tests/utils/mod.rs:207:1 Oct 15 04:02:35.835 INFO kablam! | Oct 15 04:02:35.835 INFO kablam! 207 | / macro_rules! assert_eq_any { Oct 15 04:02:35.835 INFO kablam! 208 | | ($left:expr, $right1:expr, $right2:expr) => ({ Oct 15 04:02:35.835 INFO kablam! 209 | | match (&($left), &($right1), &($right2)) { Oct 15 04:02:35.835 INFO kablam! 210 | | (left_val, right1_val, right2_val) => { Oct 15 04:02:35.835 INFO kablam! ... | Oct 15 04:02:35.835 INFO kablam! 218 | | }) Oct 15 04:02:35.835 INFO kablam! 219 | | } Oct 15 04:02:35.835 INFO kablam! | |_^ Oct 15 04:02:35.835 INFO kablam! | Oct 15 04:02:35.835 INFO kablam! = note: #[warn(unused_macros)] on by default Oct 15 04:02:35.835 INFO kablam! Oct 15 04:02:36.057 INFO kablam! warning: function is never used: `inflate_events` Oct 15 04:02:36.057 INFO kablam! --> tests/utils/mod.rs:49:1 Oct 15 04:02:36.057 INFO kablam! | Oct 15 04:02:36.057 INFO kablam! 49 | pub fn inflate_events(input: Vec<(PathBuf, Op, Option)>) -> Vec<(PathBuf, Op, Option)> { Oct 15 04:02:36.057 INFO kablam! | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Oct 15 04:02:36.057 INFO kablam! | Oct 15 04:02:36.057 INFO kablam! = note: #[warn(dead_code)] on by default Oct 15 04:02:36.057 INFO kablam! Oct 15 04:02:36.058 INFO kablam! warning: function is never used: `extract_cookies` Oct 15 04:02:36.058 INFO kablam! --> tests/utils/mod.rs:78:1 Oct 15 04:02:36.058 INFO kablam! | Oct 15 04:02:36.058 INFO kablam! 78 | pub fn extract_cookies(events: &[ (PathBuf, Op, Option) ]) -> Vec { Oct 15 04:02:36.063 INFO kablam! | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Oct 15 04:02:36.063 INFO kablam! Oct 15 04:02:36.063 INFO kablam! warning: function is never used: `sleep` Oct 15 04:02:36.063 INFO kablam! --> tests/utils/mod.rs:91:1 Oct 15 04:02:36.063 INFO kablam! | Oct 15 04:02:36.063 INFO kablam! 91 | pub fn sleep(duration: u64) { Oct 15 04:02:36.063 INFO kablam! | ^^^^^^^^^^^^^^^^^^^^^^^^^^^ Oct 15 04:02:36.063 INFO kablam! Oct 15 04:02:36.471 INFO kablam! warning: function is never used: `sleep` Oct 15 04:02:36.471 INFO kablam! --> tests/utils/mod.rs:91:1 Oct 15 04:02:36.471 INFO kablam! | Oct 15 04:02:36.471 INFO kablam! 91 | pub fn sleep(duration: u64) { Oct 15 04:02:36.471 INFO kablam! | ^^^^^^^^^^^^^^^^^^^^^^^^^^^ Oct 15 04:02:36.471 INFO kablam! | Oct 15 04:02:36.471 INFO kablam! = note: #[warn(dead_code)] on by default Oct 15 04:02:36.471 INFO kablam! Oct 15 04:02:38.895 INFO kablam! warning: unused import: `std::ascii::AsciiExt` Oct 15 04:02:38.896 INFO kablam! --> src/query.rs:1:5 Oct 15 04:02:38.896 INFO kablam! | Oct 15 04:02:38.896 INFO kablam! 1 | use std::ascii::AsciiExt; Oct 15 04:02:38.896 INFO kablam! | ^^^^^^^^^^^^^^^^^^^^ Oct 15 04:02:38.897 INFO kablam! Oct 15 04:02:44.303 INFO kablam! Finished dev [unoptimized + debuginfo] target(s) in 15.86s Oct 15 04:02:44.339 INFO kablam! su: No module specific data is present Oct 15 04:02:44.903 INFO running `"docker" "rm" "-f" "7b19d257495b457c0732d181d6832274f9fb27f471629a3efdd5271ddf5c5b24"` Oct 15 04:02:45.195 INFO blam! 7b19d257495b457c0732d181d6832274f9fb27f471629a3efdd5271ddf5c5b24 Oct 15 04:02:45.199 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-7/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-7/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 04:02:45.755 INFO blam! 615dcf2ba34fb689f77a9564e826797cc068e93ccc491bff79675d797fbee5d2 Oct 15 04:02:45.759 INFO running `"docker" "start" "-a" "615dcf2ba34fb689f77a9564e826797cc068e93ccc491bff79675d797fbee5d2"` Oct 15 04:02:46.767 INFO kablam! usermod: no changes Oct 15 04:02:46.977 INFO kablam! Finished dev [unoptimized + debuginfo] target(s) in 0.17s Oct 15 04:02:46.995 INFO kablam! Running /target/debug/deps/fomo-9f2ffb5d2e2c68c2 Oct 15 04:02:46.999 INFO blam! Oct 15 04:02:46.999 INFO blam! running 3 tests Oct 15 04:02:46.999 INFO blam! test notify::display_formatted_errors ... ok Oct 15 04:02:47.000 INFO blam! test fs_view::test::single_file_tmp_dir ... ok Oct 15 04:02:47.001 INFO blam! test fs_view::test::fixed_roundtrip ... ok Oct 15 04:02:47.001 INFO blam! Oct 15 04:02:47.001 INFO blam! test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Oct 15 04:02:47.001 INFO blam! Oct 15 04:02:47.008 INFO kablam! Running /target/debug/deps/fomo_bin-9676b92f6027e260 Oct 15 04:02:47.008 INFO blam! Oct 15 04:02:47.008 INFO blam! running 0 tests Oct 15 04:02:47.008 INFO blam! Oct 15 04:02:47.008 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Oct 15 04:02:47.008 INFO blam! Oct 15 04:02:47.011 INFO blam! Oct 15 04:02:47.012 INFO kablam! Running /target/debug/deps/debounce-8bff81f2501eccb6 Oct 15 04:02:47.012 INFO blam! running 36 tests Oct 15 04:02:49.151 INFO blam! test create_delete_file ... ok Oct 15 04:02:49.151 INFO blam! test create_modify_directory ... ok Oct 15 04:02:49.155 INFO blam! test create_rename_delete_file ... ok Oct 15 04:02:49.155 INFO blam! test create_file ... ok Oct 15 04:02:49.171 INFO blam! test create_directory ... ok Oct 15 04:02:49.171 INFO blam! test create_rename_delete_directory ... ok Oct 15 04:02:49.175 INFO blam! test create_rename_directory ... ok Oct 15 04:02:49.179 INFO blam! test create_delete_directory ... ok Oct 15 04:02:51.186 INFO blam! test create_rename_file ... ok Oct 15 04:02:51.246 INFO blam! test create_rename_overwrite_file ... ok Oct 15 04:02:51.254 INFO blam! test create_rename_overwrite_directory ... ok Oct 15 04:02:51.255 INFO blam! test delete_create_directory ... ok Oct 15 04:02:51.261 INFO blam! test create_rename_remove_create ... ok Oct 15 04:02:51.275 INFO blam! test delete_create_file ... ok Oct 15 04:02:51.303 INFO blam! test create_rename_write_create ... ok Oct 15 04:02:51.315 INFO blam! test create_write_modify_file ... ok Oct 15 04:02:53.228 INFO blam! test delete_directory ... ok Oct 15 04:02:53.228 INFO blam! test move_repeatedly ... ignored Oct 15 04:02:53.299 INFO blam! test delete_file ... ok Oct 15 04:02:53.327 INFO blam! test modify_delete_directory ... ok Oct 15 04:02:53.327 INFO blam! test modify_directory ... ok Oct 15 04:02:53.335 INFO blam! test modify_rename_directory ... ok Oct 15 04:02:53.335 INFO blam! test modify_file ... ok Oct 15 04:02:53.387 INFO blam! test modify_rename_file ... ok Oct 15 04:02:54.399 INFO blam! test move_out_sleep_move_in ... ok Oct 15 04:02:55.269 INFO blam! test rename_directory ... ok Oct 15 04:02:55.332 INFO blam! test rename_file ... ok Oct 15 04:02:55.379 INFO blam! test rename_rename_file ... ok Oct 15 04:02:55.379 INFO blam! test rename_rename_directory ... ok Oct 15 04:02:55.399 INFO blam! test rename_modify_file ... ok Oct 15 04:02:55.400 INFO blam! test rename_modify_directory ... ok Oct 15 04:02:55.478 INFO blam! test rename_write_file ... ok Oct 15 04:02:56.430 INFO blam! test write_delete_file ... ok Oct 15 04:02:57.307 INFO blam! test write_file ... ok Oct 15 04:02:57.431 INFO blam! test write_rename_file ... ok Oct 15 04:02:58.890 INFO blam! test write_long_file ... ok Oct 15 04:02:58.890 INFO blam! Oct 15 04:02:58.890 INFO blam! test result: ok. 35 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out Oct 15 04:02:58.890 INFO blam! Oct 15 04:02:58.899 INFO blam! Oct 15 04:02:58.899 INFO kablam! Running /target/debug/deps/event_path-466fd5b57aff6bdb Oct 15 04:02:58.899 INFO blam! running 5 tests Oct 15 04:02:59.063 INFO blam! test watch_absolute_directory ... ok Oct 15 04:02:59.063 INFO blam! test watch_canonicalized_directory ... ok Oct 15 04:02:59.079 INFO blam! test watch_absolute_file ... ok Oct 15 04:02:59.079 INFO blam! test watch_canonicalized_file ... ok Oct 15 04:02:59.191 INFO blam! test watch_relative ... ok Oct 15 04:02:59.191 INFO blam! Oct 15 04:02:59.192 INFO blam! test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Oct 15 04:02:59.192 INFO kablam! Running /target/debug/deps/fsevents-8dcbc109931aa36f Oct 15 04:02:59.192 INFO blam! Oct 15 04:02:59.197 INFO kablam! Running /target/debug/deps/notify-2075f25495b8ce70 Oct 15 04:02:59.197 INFO blam! Oct 15 04:02:59.197 INFO blam! running 0 tests Oct 15 04:02:59.197 INFO blam! Oct 15 04:02:59.198 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Oct 15 04:02:59.198 INFO blam! Oct 15 04:02:59.203 INFO blam! Oct 15 04:02:59.203 INFO blam! running 17 tests Oct 15 04:02:59.414 INFO blam! test create_directory ... ok Oct 15 04:02:59.415 INFO blam! test create_rename_overwrite_directory ... ok Oct 15 04:02:59.428 INFO blam! test delete_file ... ok Oct 15 04:02:59.431 INFO blam! test delete_directory ... ok Oct 15 04:02:59.433 INFO blam! test create_rename_overwrite_file ... ok Oct 15 04:02:59.433 INFO blam! test create_file ... ok Oct 15 04:02:59.433 INFO blam! test modify_directory ... ok Oct 15 04:02:59.434 INFO blam! test create_write_modify_file ... ok Oct 15 04:02:59.439 INFO blam! test test_inflate_events ... ok Oct 15 04:02:59.655 INFO blam! test rename_file ... ok Oct 15 04:02:59.656 INFO blam! test rename_rename_directory ... ok Oct 15 04:02:59.656 INFO blam! test modify_file ... ok Oct 15 04:02:59.671 INFO blam! test move_out_create_directory ... ok Oct 15 04:02:59.671 INFO blam! test rename_directory ... ok Oct 15 04:02:59.672 INFO blam! test move_out_create_file ... ok Oct 15 04:02:59.672 INFO blam! test rename_rename_file ... ok Oct 15 04:02:59.672 INFO blam! test write_file ... ok Oct 15 04:02:59.673 INFO blam! Oct 15 04:02:59.673 INFO blam! test result: ok. 17 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Oct 15 04:02:59.673 INFO blam! Oct 15 04:02:59.687 INFO kablam! Running /target/debug/deps/watcher-1cf3a8ea965763fc Oct 15 04:02:59.695 INFO blam! Oct 15 04:02:59.695 INFO blam! running 29 tests Oct 15 04:02:59.736 INFO blam! test new_poll ... ok Oct 15 04:02:59.747 INFO blam! test new_null ... ok Oct 15 04:02:59.747 INFO blam! test poll_watch_recursive_move ... ignored Oct 15 04:02:59.748 INFO blam! test poll_watch_recursive_move_in ... ignored Oct 15 04:02:59.748 INFO blam! test poll_watch_recursive_move_out ... ignored Oct 15 04:02:59.771 INFO blam! test new_recommended ... ok Oct 15 04:02:59.801 INFO blam! test new_inotify ... ok Oct 15 04:02:59.992 INFO blam! test self_delete_directory ... ok Oct 15 04:03:00.055 INFO blam! test self_delete_file ... ok Oct 15 04:03:00.075 INFO blam! test test_watcher_send ... ok Oct 15 04:03:00.075 INFO blam! test parent_rename_file ... ok Oct 15 04:03:00.091 INFO blam! test unwatch_directory ... ok Oct 15 04:03:00.099 INFO blam! test parent_rename_directory ... ok Oct 15 04:03:00.123 INFO blam! test test_watcher_sync ... ok Oct 15 04:03:00.135 INFO blam! test self_rename_directory ... ok Oct 15 04:03:00.164 INFO blam! test unwatch_nonexisting ... ok Oct 15 04:03:00.164 INFO blam! test unwatch_file ... ok Oct 15 04:03:00.275 INFO blam! test watch_file ... ok Oct 15 04:03:00.275 INFO blam! test watch_nonexisting ... ok Oct 15 04:03:00.309 INFO blam! test watch_nonrecursive ... ok Oct 15 04:03:00.325 INFO blam! test watch_recursive_create_directory ... ok Oct 15 04:03:00.343 INFO blam! test self_rename_file ... ok Oct 15 04:03:00.387 INFO blam! test watch_relative ... ok Oct 15 04:03:00.410 INFO blam! test watch_recursive_move_in ... ok Oct 15 04:03:00.463 INFO blam! test watch_recursive_move_out ... ok Oct 15 04:03:00.491 INFO blam! test watch_recursive_move ... FAILED Oct 15 04:03:00.907 INFO blam! test poll_watch_nonrecursive ... ok Oct 15 04:03:00.907 INFO blam! test poll_watch_file ... ok Oct 15 04:03:02.147 INFO blam! test poll_watch_recursive_create_directory ... ok Oct 15 04:03:02.147 INFO kablam! error: test failed, to rerun pass '--test watcher' Oct 15 04:03:02.148 INFO blam! Oct 15 04:03:02.148 INFO kablam! su: No module specific data is present Oct 15 04:03:02.148 INFO blam! failures: Oct 15 04:03:02.149 INFO blam! Oct 15 04:03:02.149 INFO blam! ---- watch_recursive_move stdout ---- Oct 15 04:03:02.149 INFO blam! thread 'watch_recursive_move' panicked at 'assertion failed: `(left == right)` Oct 15 04:03:02.149 INFO blam! left: `[("/tmp/temp_dir.vvMNYssgxqRQ/dir1a/file1", CREATE, None), ("/tmp/temp_dir.vvMNYssgxqRQ/dir1a/file1", CLOSE_WRITE, None), ("/tmp/temp_dir.vvMNYssgxqRQ/dir1a", RENAME, Some(9185017)), ("/tmp/temp_dir.vvMNYssgxqRQ/dir1b", RENAME, Some(9185017))]`, Oct 15 04:03:02.150 INFO blam! right: `[("/tmp/temp_dir.vvMNYssgxqRQ/dir1a/file1", CREATE, None), ("/tmp/temp_dir.vvMNYssgxqRQ/dir1a/file1", CLOSE_WRITE, None), ("/tmp/temp_dir.vvMNYssgxqRQ/dir1a", RENAME, Some(9185017)), ("/tmp/temp_dir.vvMNYssgxqRQ/dir1b", RENAME, Some(9185017)), ("/tmp/temp_dir.vvMNYssgxqRQ/dir1b/file2", CREATE, None), ("/tmp/temp_dir.vvMNYssgxqRQ/dir1b/file2", CLOSE_WRITE, None)]`', tests/watcher.rs:377:5 Oct 15 04:03:02.150 INFO blam! stack backtrace: Oct 15 04:03:02.150 INFO blam! 0: 0x5633b346453e - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h7fa1e90165a4b6b7 Oct 15 04:03:02.151 INFO blam! at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Oct 15 04:03:02.151 INFO blam! 1: 0x5633b346d936 - std::sys_common::backtrace::print::hce31971a380b167f Oct 15 04:03:02.151 INFO blam! at libstd/sys_common/backtrace.rs:71 Oct 15 04:03:02.151 INFO blam! at libstd/sys_common/backtrace.rs:59 Oct 15 04:03:02.152 INFO blam! 2: 0x5633b34684dd - std::panicking::default_hook::{{closure}}::h9590c1e09d0fb8eb Oct 15 04:03:02.152 INFO blam! at libstd/panicking.rs:211 Oct 15 04:03:02.152 INFO blam! 3: 0x5633b34681eb - std::panicking::default_hook::hb1838a6568eb05e3 Oct 15 04:03:02.152 INFO blam! at libstd/panicking.rs:221 Oct 15 04:03:02.153 INFO blam! 4: 0x5633b3468b8c - std::panicking::rust_panic_with_hook::h9ad880ee5fc38368 Oct 15 04:03:02.153 INFO blam! at libstd/panicking.rs:476 Oct 15 04:03:02.153 INFO blam! 5: 0x5633b3468749 - std::panicking::continue_panic_fmt::h16b21ef393998895 Oct 15 04:03:02.153 INFO blam! at libstd/panicking.rs:390 Oct 15 04:03:02.154 INFO blam! 6: 0x5633b34686ad - std::panicking::begin_panic_fmt::h70a4709fbb668068 Oct 15 04:03:02.154 INFO blam! at libstd/panicking.rs:345 Oct 15 04:03:02.154 INFO blam! 7: 0x5633b32fa0af - watcher::watch_recursive_move::h26dc6e9564b4565b Oct 15 04:03:02.154 INFO blam! at tests/watcher.rs:377 Oct 15 04:03:02.155 INFO blam! 8: 0x5633b32f9589 - watcher::watch_recursive_move::{{closure}}::hbcee4170edffbc1e Oct 15 04:03:02.155 INFO blam! at tests/watcher.rs:335 Oct 15 04:03:02.155 INFO blam! 9: 0x5633b3332ded - core::ops::function::FnOnce::call_once::h942095c81ad34055 Oct 15 04:03:02.156 INFO blam! at libcore/ops/function.rs:238 Oct 15 04:03:02.156 INFO blam! 10: 0x5633b333d9ae - >::call_box::hae226a42c8d94b19 Oct 15 04:03:02.156 INFO blam! at libtest/lib.rs:1468 Oct 15 04:03:02.157 INFO blam! at libcore/ops/function.rs:238 Oct 15 04:03:02.157 INFO blam! at liballoc/boxed.rs:672 Oct 15 04:03:02.157 INFO blam! 11: 0x5633b3478e59 - __rust_maybe_catch_panic Oct 15 04:03:02.157 INFO blam! at libpanic_unwind/lib.rs:102 Oct 15 04:03:02.158 INFO blam! 12: 0x5633b335e3dd - std::sys_common::backtrace::__rust_begin_short_backtrace::ha5325a24fd096595 Oct 15 04:03:02.158 INFO blam! at libstd/panicking.rs:289 Oct 15 04:03:02.158 INFO blam! at libstd/panic.rs:392 Oct 15 04:03:02.159 INFO blam! at libtest/lib.rs:1423 Oct 15 04:03:02.159 INFO blam! at libstd/sys_common/backtrace.rs:136 Oct 15 04:03:02.159 INFO blam! 13: 0x5633b335ef84 - std::panicking::try::do_call::h2c632c17829d0621 Oct 15 04:03:02.159 INFO blam! at libstd/thread/mod.rs:409 Oct 15 04:03:02.160 INFO blam! at libstd/panic.rs:313 Oct 15 04:03:02.160 INFO blam! at libstd/panicking.rs:310 Oct 15 04:03:02.160 INFO blam! 14: 0x5633b3478e59 - __rust_maybe_catch_panic Oct 15 04:03:02.160 INFO blam! at libpanic_unwind/lib.rs:102 Oct 15 04:03:02.161 INFO blam! 15: 0x5633b334c5c6 - >::call_box::h1a0832645645f090 Oct 15 04:03:02.161 INFO blam! at libstd/panicking.rs:289 Oct 15 04:03:02.161 INFO blam! at libstd/panic.rs:392 Oct 15 04:03:02.161 INFO blam! at libstd/thread/mod.rs:408 Oct 15 04:03:02.161 INFO blam! at liballoc/boxed.rs:672 Oct 15 04:03:02.161 INFO blam! 16: 0x5633b34668fa - std::sys_common::thread::start_thread::h49b8ca61f624f031 Oct 15 04:03:02.161 INFO blam! at liballoc/boxed.rs:682 Oct 15 04:03:02.161 INFO blam! at libstd/sys_common/thread.rs:24 Oct 15 04:03:02.161 INFO blam! 17: 0x5633b345a5d5 - std::sys::unix::thread::Thread::new::thread_start::hc999bd1fb8f071a1 Oct 15 04:03:02.161 INFO blam! at libstd/sys/unix/thread.rs:90 Oct 15 04:03:02.161 INFO blam! 18: 0x7f344e3e26b9 - start_thread Oct 15 04:03:02.161 INFO blam! 19: 0x7f344df0241c - clone Oct 15 04:03:02.161 INFO blam! 20: 0x0 - Oct 15 04:03:02.161 INFO blam! Oct 15 04:03:02.161 INFO blam! Oct 15 04:03:02.161 INFO blam! failures: Oct 15 04:03:02.161 INFO blam! watch_recursive_move Oct 15 04:03:02.161 INFO blam! Oct 15 04:03:02.161 INFO blam! test result: FAILED. 25 passed; 1 failed; 3 ignored; 0 measured; 0 filtered out Oct 15 04:03:02.161 INFO blam! Oct 15 04:03:02.791 INFO running `"docker" "rm" "-f" "615dcf2ba34fb689f77a9564e826797cc068e93ccc491bff79675d797fbee5d2"` Oct 15 04:03:03.056 INFO blam! 615dcf2ba34fb689f77a9564e826797cc068e93ccc491bff79675d797fbee5d2