[INFO] fetching crate gitwatch-rs 0.1.1... [INFO] testing gitwatch-rs-0.1.1 against master#cdb45c87e2cd43495379f7e867e3cc15dcee9f93 for pr-145838-1 [INFO] extracting crate gitwatch-rs 0.1.1 into /workspace/builds/worker-6-tc1/source [INFO] removed /workspace/builds/worker-6-tc1/source/.cargo/config.toml [INFO] removed /workspace/builds/worker-6-tc1/source/rust-toolchain.toml [INFO] started tweaking crates.io crate gitwatch-rs 0.1.1 [INFO] removed 0 missing tests [INFO] finished tweaking crates.io crate gitwatch-rs 0.1.1 [INFO] tweaked toml for crates.io crate gitwatch-rs 0.1.1 written to /workspace/builds/worker-6-tc1/source/Cargo.toml [INFO] validating manifest of crates.io crate gitwatch-rs 0.1.1 on toolchain cdb45c87e2cd43495379f7e867e3cc15dcee9f93 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] crate crates.io crate gitwatch-rs 0.1.1 already has a lockfile, it will not be regenerated [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 5eb5f6ccc2e2a08c87add992756714a89d576dff44278b32f776eb14a2a696e9 [INFO] running `Command { std: "docker" "start" "-a" "5eb5f6ccc2e2a08c87add992756714a89d576dff44278b32f776eb14a2a696e9", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "5eb5f6ccc2e2a08c87add992756714a89d576dff44278b32f776eb14a2a696e9", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "5eb5f6ccc2e2a08c87add992756714a89d576dff44278b32f776eb14a2a696e9", kill_on_drop: false }` [INFO] [stdout] 5eb5f6ccc2e2a08c87add992756714a89d576dff44278b32f776eb14a2a696e9 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] e47d6a968e56a4045c2afcab4b256a418fc98c74dbfa04bfaac5ea97dbcd1e8a [INFO] running `Command { std: "docker" "start" "-a" "e47d6a968e56a4045c2afcab4b256a418fc98c74dbfa04bfaac5ea97dbcd1e8a", kill_on_drop: false }` [INFO] [stderr] Compiling syn v2.0.104 [INFO] [stderr] Compiling libc v0.2.174 [INFO] [stderr] Compiling log v0.4.27 [INFO] [stderr] Compiling crossbeam-utils v0.8.21 [INFO] [stderr] Compiling proc-macro2-diagnostics v0.10.1 [INFO] [stderr] Compiling aho-corasick v1.1.3 [INFO] [stderr] Compiling anstyle v1.0.11 [INFO] [stderr] Compiling same-file v1.0.6 [INFO] [stderr] Compiling colorchoice v1.0.4 [INFO] [stderr] Compiling percent-encoding v2.3.1 [INFO] [stderr] Compiling anstyle-parse v0.2.7 [INFO] [stderr] Compiling anstyle-query v1.1.3 [INFO] [stderr] Compiling option-ext v0.2.0 [INFO] [stderr] Compiling yansi v1.0.1 [INFO] [stderr] Compiling uncased v0.9.10 [INFO] [stderr] Compiling clap_lex v0.7.5 [INFO] [stderr] Compiling walkdir v2.5.0 [INFO] [stderr] Compiling form_urlencoded v1.2.1 [INFO] [stderr] Compiling hashbrown v0.15.4 [INFO] [stderr] Compiling bstr v1.12.0 [INFO] [stderr] Compiling figment v0.10.19 [INFO] [stderr] Compiling notify-types v2.0.0 [INFO] [stderr] Compiling unsafe-libyaml v0.2.11 [INFO] [stderr] Compiling anyhow v1.0.98 [INFO] [stderr] Compiling inlinable_string v0.1.15 [INFO] [stderr] Compiling anstream v0.6.19 [INFO] [stderr] Compiling colored v2.2.0 [INFO] [stderr] Compiling file-id v0.2.2 [INFO] [stderr] Compiling clap_builder v4.5.42 [INFO] [stderr] Compiling paris v1.5.15 [INFO] [stderr] Compiling indoc v2.0.6 [INFO] [stderr] Compiling fern v0.7.1 [INFO] [stderr] Compiling crossbeam-epoch v0.9.18 [INFO] [stderr] Compiling crossbeam-deque v0.8.6 [INFO] [stderr] Compiling jobserver v0.1.33 [INFO] [stderr] Compiling dirs-sys v0.5.0 [INFO] [stderr] Compiling inotify-sys v0.1.5 [INFO] [stderr] Compiling mio v1.0.4 [INFO] [stderr] Compiling terminal-prompt v0.2.3 [INFO] [stderr] Compiling cc v1.2.29 [INFO] [stderr] Compiling inotify v0.11.0 [INFO] [stderr] Compiling regex-automata v0.4.9 [INFO] [stderr] Compiling dirs v6.0.0 [INFO] [stderr] Compiling shellexpand v3.1.1 [INFO] [stderr] Compiling notify v8.1.0 [INFO] [stderr] Compiling indexmap v2.10.0 [INFO] [stderr] Compiling notify-debouncer-full v0.5.0 [INFO] [stderr] Compiling openssl-sys v0.9.109 [INFO] [stderr] Compiling libz-sys v1.1.22 [INFO] [stderr] Compiling libssh2-sys v0.3.1 [INFO] [stderr] Compiling libgit2-sys v0.18.2+1.9.1 [INFO] [stderr] Compiling globset v0.4.16 [INFO] [stderr] Compiling regex v1.11.1 [INFO] [stderr] Compiling ignore v0.4.23 [INFO] [stderr] Compiling synstructure v0.13.2 [INFO] [stderr] Compiling zerofrom-derive v0.1.6 [INFO] [stderr] Compiling yoke-derive v0.8.0 [INFO] [stderr] Compiling zerovec-derive v0.11.1 [INFO] [stderr] Compiling displaydoc v0.2.5 [INFO] [stderr] Compiling serde_derive v1.0.219 [INFO] [stderr] Compiling clap_derive v4.5.41 [INFO] [stderr] Compiling pear_codegen v0.2.9 [INFO] [stderr] Compiling pear v0.2.9 [INFO] [stderr] Compiling zerofrom v0.1.6 [INFO] [stderr] Compiling yoke v0.8.0 [INFO] [stderr] Compiling zerovec v0.11.2 [INFO] [stderr] Compiling zerotrie v0.2.2 [INFO] [stderr] Compiling clap v4.5.42 [INFO] [stderr] Compiling clap_complete v4.5.55 [INFO] [stderr] Compiling serde v1.0.219 [INFO] [stderr] Compiling tinystr v0.8.1 [INFO] [stderr] Compiling potential_utf v0.1.2 [INFO] [stderr] Compiling icu_locale_core v2.0.0 [INFO] [stderr] Compiling icu_collections v2.0.0 [INFO] [stderr] Compiling icu_provider v2.0.0 [INFO] [stderr] Compiling icu_normalizer v2.0.0 [INFO] [stderr] Compiling icu_properties v2.0.1 [INFO] [stderr] Compiling idna_adapter v1.2.1 [INFO] [stderr] Compiling idna v1.0.3 [INFO] [stderr] Compiling url v2.5.4 [INFO] [stderr] Compiling serde_yaml v0.9.34+deprecated [INFO] [stderr] Compiling serde_regex v1.1.0 [INFO] [stderr] Compiling git2 v0.20.2 [INFO] [stderr] Compiling auth-git2 v0.5.8 [INFO] [stderr] Compiling gitwatch-rs v0.1.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 53.53s [INFO] running `Command { std: "docker" "inspect" "e47d6a968e56a4045c2afcab4b256a418fc98c74dbfa04bfaac5ea97dbcd1e8a", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "e47d6a968e56a4045c2afcab4b256a418fc98c74dbfa04bfaac5ea97dbcd1e8a", kill_on_drop: false }` [INFO] [stdout] e47d6a968e56a4045c2afcab4b256a418fc98c74dbfa04bfaac5ea97dbcd1e8a [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] e3a34747f747d2e68e78502fa775bfb048edef0cf1ae041418d0433a71a63369 [INFO] running `Command { std: "docker" "start" "-a" "e3a34747f747d2e68e78502fa775bfb048edef0cf1ae041418d0433a71a63369", kill_on_drop: false }` [INFO] [stderr] Compiling bitflags v2.9.1 [INFO] [stderr] Compiling regex-automata v0.4.9 [INFO] [stderr] Compiling getrandom v0.3.3 [INFO] [stderr] Compiling predicates-core v1.0.9 [INFO] [stderr] Compiling doc-comment v0.3.3 [INFO] [stderr] Compiling rustix v1.0.7 [INFO] [stderr] Compiling float-cmp v0.10.0 [INFO] [stderr] Compiling termtree v0.5.1 [INFO] [stderr] Compiling assert_cmd v2.0.17 [INFO] [stderr] Compiling difflib v0.4.0 [INFO] [stderr] Compiling normalize-line-endings v0.3.0 [INFO] [stderr] Compiling wait-timeout v0.2.1 [INFO] [stderr] Compiling testresult v0.4.1 [INFO] [stderr] Compiling inotify v0.11.0 [INFO] [stderr] Compiling git2 v0.20.2 [INFO] [stderr] Compiling predicates-tree v1.0.12 [INFO] [stderr] Compiling rand_core v0.9.3 [INFO] [stderr] Compiling rand_chacha v0.9.0 [INFO] [stderr] Compiling notify v8.1.0 [INFO] [stderr] Compiling rand v0.9.2 [INFO] [stderr] Compiling notify-debouncer-full v0.5.0 [INFO] [stderr] Compiling tempfile v3.20.0 [INFO] [stderr] Compiling auth-git2 v0.5.8 [INFO] [stderr] Compiling bstr v1.12.0 [INFO] [stderr] Compiling regex v1.11.1 [INFO] [stderr] Compiling serde_regex v1.1.0 [INFO] [stderr] Compiling predicates v3.1.3 [INFO] [stderr] Compiling globset v0.4.16 [INFO] [stderr] Compiling ignore v0.4.23 [INFO] [stderr] Compiling gitwatch-rs v0.1.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 18.35s [INFO] running `Command { std: "docker" "inspect" "e3a34747f747d2e68e78502fa775bfb048edef0cf1ae041418d0433a71a63369", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "e3a34747f747d2e68e78502fa775bfb048edef0cf1ae041418d0433a71a63369", kill_on_drop: false }` [INFO] [stdout] e3a34747f747d2e68e78502fa775bfb048edef0cf1ae041418d0433a71a63369 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 599fc9a3fee0c0a74f6646d4b487eda3f17e80f280a835df9fab3a8ad0e8f82e [INFO] running `Command { std: "docker" "start" "-a" "599fc9a3fee0c0a74f6646d4b487eda3f17e80f280a835df9fab3a8ad0e8f82e", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.19s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/gitwatch_rs-e3af676664cbffba) [INFO] [stdout] [INFO] [stdout] running 34 tests [INFO] [stdout] test cli::tests::test_loglevel_conversion ... ok [INFO] [stdout] test app_config::tests::test_config_validation ... ok [INFO] [stdout] test app_config::tests::test_relative_paths ... ok [INFO] [stdout] test app_config::tests::test_absolute_paths ... ok [INFO] [stdout] test app_config::tests::test_config_from_cli_invalid ... ok [INFO] [stdout] test commit_message::tests::test_nonexistent_script ... ok [INFO] [stdout] test config_file::tests::test_load_empty_config ... ok [INFO] [stdout] test config_file::tests::test_load_invalid_config ... ok [INFO] [stdout] test app_config::tests::test_config_precedence_cli_only ... ok [INFO] [stdout] test app_config::tests::test_config_partial_file ... ok [INFO] [stdout] test config_file::tests::test_load_config_file ... ok [INFO] [stderr] [debug] Using git repository '/tmp/.tmpo0ScLz' [INFO] [stderr] [debug] Path test.temp ignored via --ignore-regex [INFO] [stderr] [debug] Path subdir/another.temp ignored via --ignore-regex [INFO] [stdout] test filter::tests::test_path_absolute_error ... ok [INFO] [stdout] test filter::tests::test_strip_prefix_error ... ok [INFO] [stdout] test app_config::tests::test_config_precedence_with_file ... ok [INFO] [stdout] test app_config::tests::test_config_from_cli ... ok [INFO] [stderr] [trace] Received notify events { events [DebouncedEvent { event: Event { kind: Any, paths: ["test1.txt"], attr:tracker: None, attr:flag: None, attr:info: None, attr:source: None }, time: Instant { tv_sec: 147793, tv_nsec: 903907191 } }, DebouncedEvent { event: Event { kind: Any, paths: ["test1.txt"], attr:tracker: None, attr:flag: None, attr:info: None, attr:source: None }, time: Instant { tv_sec: 147793, tv_nsec: 903908041 } }, DebouncedEvent { event: Event { kind: Any, paths: ["test1.txt"], attr:tracker: None, attr:flag: None, attr:info: None, attr:source: None }, time: Instant { tv_sec: 147793, tv_nsec: 903908571 } }] } [INFO] [stdout] test filter::tests::test_ignore_regex ... ok [INFO] [stdout] test watcher::tests::test_all_paths_ignored ... ok [INFO] [stdout] test util::tests::test_normalize_path ... ok [INFO] [stderr] [trace] registering event source with poller: token=Token(0), interests=READABLE [INFO] [stderr] [trace] registering event source with poller: token=Token(0), interests=READABLE [INFO] [stderr] [trace] adding inotify watch: /tmp/.tmptG3joV [INFO] [stderr] [trace] registering event source with poller: token=Token(0), interests=READABLE [INFO] [stdout] Watching for changes... [INFO] [stdout] test filter::tests::test_gitignore ... ok [INFO] [stderr] [trace] adding inotify watch: /tmp/.tmpQ4KodJ [INFO] [stdout] Watching for changes... [INFO] [stdout] test watcher::tests::test_watcher_notify_error ... ok [INFO] [stderr] [debug] Executing commit message script '/tmp/.tmpz3qq0e/test_script.sh' [INFO] [stderr] [debug] Executing commit message script '/tmp/.tmpsqy8CQ/test_script.sh' [INFO] [stderr] [debug] Executing commit message script '/tmp/.tmpy8h6kh/test_script.sh' [INFO] [stdout] test commit_message::tests::test_script_execution_failure ... ok [INFO] [stderr] [debug] Generated commit message: 'Test commit message' [INFO] [stdout] test commit_message::tests::test_successful_script_execution ... ok [INFO] [stdout] test commit_message::tests::test_empty_output ... ok [INFO] [stderr] [debug] Executing commit message script '/tmp/.tmpaUJHOm/test_script.sh' [INFO] [stderr] [debug] Generated commit message: '/tmp/.tmpaUJHOm' [INFO] [stdout] test commit_message::tests::test_working_directory ... ok [INFO] [stderr] [debug] Executing commit message script '/tmp/.tmpNNKvHx/test_script.sh' [INFO] [stdout] test commit_message::tests::test_whitespace_only_output ... ok [INFO] [stderr] [trace] inotify event: Event { wd: WatchDescriptor { id: 1, fd: (Weak) }, mask: EventMask(CREATE), cookie: 0, name: Some("test.txt") } [INFO] [stderr] [trace] raw event: Event { kind: Create(File), paths: ["/tmp/.tmptG3joV/test.txt"], attr:tracker: None, attr:flag: None, attr:info: None, attr:source: None } [INFO] [stderr] [trace] Received notify events { events [DebouncedEvent { event: Event { kind: Create(File), paths: ["/tmp/.tmptG3joV/test.txt"], attr:tracker: None, attr:flag: None, attr:info: None, attr:source: None }, time: Instant { tv_sec: 147794, tv_nsec: 7245060 } }] } [INFO] [stderr] [warn] Failed to commit changes. Retrying... (1/2). [INFO] [stderr] Error: Mock callback error [INFO] [stderr] [INFO] [stderr] Stack backtrace: [INFO] [stderr] 0: anyhow::error::::msg [INFO] [stderr] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/anyhow-1.0.98/src/backtrace.rs:27:14 [INFO] [stderr] 1: anyhow::__private::format_err [INFO] [stderr] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/anyhow-1.0.98/src/lib.rs:694:13 [INFO] [stderr] 2: gitwatch_rs::watcher::tests::test_watcher_callback_error::{{closure}}::{{closure}} [INFO] [stderr] at /opt/rustwide/workdir/src/watcher.rs:178:21 [INFO] [stderr] 3: core::ops::function::impls:: for &F>::call [INFO] [stderr] at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/core/src/ops/function.rs:266:22 [INFO] [stderr] 4: gitwatch_rs::watcher::FileWatcher::handle_events [INFO] [stderr] at /opt/rustwide/workdir/src/watcher.rs:96:23 [INFO] [stderr] 5: gitwatch_rs::watcher::FileWatcher::watch [INFO] [stderr] at /opt/rustwide/workdir/src/watcher.rs:60:46 [INFO] [stderr] 6: gitwatch_rs::watcher::tests::test_watcher_callback_error::{{closure}} [INFO] [stderr] at /opt/rustwide/workdir/src/watcher.rs:174:21 [INFO] [stderr] 7: std::sys::backtrace::__rust_begin_short_backtrace [INFO] [stderr] at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/sys/backtrace.rs:158:18 [INFO] [stderr] 8: std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}} [INFO] [stderr] at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/thread/mod.rs:559:17 [INFO] [stderr] 9: as core::ops::function::FnOnce<()>>::call_once [INFO] [stderr] at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stderr] 10: std::panicking::catch_unwind::do_call [INFO] [stderr] at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/panicking.rs:590:40 [INFO] [stderr] 11: __rust_try [INFO] [stderr] 12: std::panicking::catch_unwind [INFO] [stderr] at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/panicking.rs:553:19 [INFO] [stderr] 13: std::panic::catch_unwind [INFO] [stderr] at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/panic.rs:359:14 [INFO] [stderr] 14: std::thread::Builder::spawn_unchecked_::{{closure}} [INFO] [stderr] at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/thread/mod.rs:557:30 [INFO] [stderr] 15: core::ops::function::FnOnce::call_once{{vtable.shim}} [INFO] [stderr] at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/core/src/ops/function.rs:253:5 [INFO] [stderr] 16: as core::ops::function::FnOnce>::call_once [INFO] [stderr] at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/alloc/src/boxed.rs:1985:9 [INFO] [stderr] 17: std::sys::pal::unix::thread::Thread::new::thread_start [INFO] [stderr] at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/sys/pal/unix/thread.rs:118:17 [INFO] [stderr] 18: [INFO] [stderr] 19: clone [INFO] [stderr] [trace] inotify event: Event { wd: WatchDescriptor { id: 1, fd: (Weak) }, mask: EventMask(CREATE), cookie: 0, name: Some("test.txt") } [INFO] [stderr] [trace] inotify event: Event { wd: WatchDescriptor { id: 1, fd: (Weak) }, mask: EventMask(OPEN), cookie: 0, name: Some("test.txt") } [INFO] [stdout] test repo::tests::test_empty_repo ... ok [INFO] [stdout] test app::tests::test_watch_false ... ok [INFO] [stdout] test repo::tests::test_invalid_remote ... ok [INFO] [stdout] test repo::tests::test_invalid_commit_message_script ... ok [INFO] [stderr] [debug] Using git repository '/tmp/.tmpXsNxK3' [INFO] [stdout] test app::tests::test_commit_on_start ... ok [INFO] [stderr] [debug] Using git repository '/tmp/.tmpvJlANT' [INFO] [stderr] [trace] raw event: Event { kind: Access(Open(Any)), paths: ["/tmp/.tmptG3joV/test.txt"], attr:tracker: None, attr:flag: None, attr:info: None, attr:source: None } [INFO] [stderr] [trace] inotify event: Event { wd: WatchDescriptor { id: 1, fd: (Weak) }, mask: EventMask(MODIFY), cookie: 0, name: Some("test.txt") } [INFO] [stdout] test repo::tests::test_ignore_regex ... ok [INFO] [stderr] [trace] raw event: Event { kind: Modify(Data(Any)), paths: ["/tmp/.tmptG3joV/test.txt"], attr:tracker: None, attr:flag: None, attr:info: None, attr:source: None } [INFO] [stderr] [trace] inotify event: Event { wd: WatchDescriptor { id: 1, fd: (Weak) }, mask: EventMask(CLOSE_WRITE), cookie: 0, name: Some("test.txt") } [INFO] [stderr] [trace] raw event: Event { kind: Access(Close(Write)), paths: ["/tmp/.tmptG3joV/test.txt"], attr:tracker: None, attr:flag: None, attr:info: None, attr:source: None } [INFO] [stderr] [debug] Repository has uncommitted changes) [INFO] [stderr] [debug] Modified files: [INFO] [stderr] [debug] foo.txt [INFO] [stderr] [warn] Watch is disabled [INFO] [stderr] [debug] Using git repository '/tmp/.tmplJXBAG' [INFO] [stderr] [debug] Using git repository '/tmp/.tmptxmdW6' [INFO] [stderr] [debug] Index is empty [INFO] [stderr] [debug] Using git repository '/tmp/.tmpnGpKCo' [INFO] [stderr] [debug] Repository has uncommitted changes) [INFO] [stderr] [debug] Modified files: [INFO] [stderr] [debug] foo.txt [INFO] [stderr] [debug] Using git repository '/tmp/.tmph0An9e' [INFO] [stderr] [trace] raw event: Event { kind: Create(File), paths: ["/tmp/.tmpQ4KodJ/test.txt"], attr:tracker: None, attr:flag: None, attr:info: None, attr:source: None } [INFO] [stderr] [trace] inotify event: Event { wd: WatchDescriptor { id: 1, fd: (Weak) }, mask: EventMask(OPEN), cookie: 0, name: Some("test.txt") } [INFO] [stdout] test repo::tests::test_commit_and_push ... ok [INFO] [stderr] [trace] raw event: Event { kind: Access(Open(Any)), paths: ["/tmp/.tmpQ4KodJ/test.txt"], attr:tracker: None, attr:flag: None, attr:info: None, attr:source: None } [INFO] [stderr] [trace] inotify event: Event { wd: WatchDescriptor { id: 1, fd: (Weak) }, mask: EventMask(MODIFY), cookie: 0, name: Some("test.txt") } [INFO] [stderr] [trace] raw event: Event { kind: Modify(Data(Any)), paths: ["/tmp/.tmpQ4KodJ/test.txt"], attr:tracker: None, attr:flag: None, attr:info: None, attr:source: None } [INFO] [stderr] [trace] inotify event: Event { wd: WatchDescriptor { id: 1, fd: (Weak) }, mask: EventMask(CLOSE_WRITE), cookie: 0, name: Some("test.txt") } [INFO] [stderr] [trace] raw event: Event { kind: Access(Close(Write)), paths: ["/tmp/.tmpQ4KodJ/test.txt"], attr:tracker: None, attr:flag: None, attr:info: None, attr:source: None } [INFO] [stderr] [debug] Pushing to remote origin [INFO] [stderr] [trace] Pushing refspec: HEAD:refs/heads/master [INFO] [stderr] [warn] Failed to commit changes. Retrying... (2/2). [INFO] [stderr] Error: Mock callback error [INFO] [stderr] [INFO] [stderr] Stack backtrace: [INFO] [stderr] 0: anyhow::error::::msg [INFO] [stderr] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/anyhow-1.0.98/src/backtrace.rs:27:14 [INFO] [stderr] 1: anyhow::__private::format_err [INFO] [stderr] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/anyhow-1.0.98/src/lib.rs:694:13 [INFO] [stderr] 2: gitwatch_rs::watcher::tests::test_watcher_callback_error::{{closure}}::{{closure}} [INFO] [stderr] at /opt/rustwide/workdir/src/watcher.rs:178:21 [INFO] [stderr] 3: core::ops::function::impls:: for &F>::call [INFO] [stderr] at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/core/src/ops/function.rs:266:22 [INFO] [stderr] 4: gitwatch_rs::watcher::FileWatcher::handle_events [INFO] [stderr] at /opt/rustwide/workdir/src/watcher.rs:96:23 [INFO] [stderr] 5: gitwatch_rs::watcher::FileWatcher::watch [INFO] [stderr] at /opt/rustwide/workdir/src/watcher.rs:60:46 [INFO] [stderr] 6: gitwatch_rs::watcher::tests::test_watcher_callback_error::{{closure}} [INFO] [stderr] at /opt/rustwide/workdir/src/watcher.rs:174:21 [INFO] [stderr] 7: std::sys::backtrace::__rust_begin_short_backtrace [INFO] [stderr] at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/sys/backtrace.rs:158:18 [INFO] [stderr] 8: std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}} [INFO] [stderr] at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/thread/mod.rs:559:17 [INFO] [stderr] 9: as core::ops::function::FnOnce<()>>::call_once [INFO] [stderr] at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stderr] 10: std::panicking::catch_unwind::do_call [INFO] [stderr] at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/panicking.rs:590:40 [INFO] [stderr] 11: __rust_try [INFO] [stderr] 12: std::panicking::catch_unwind [INFO] [stderr] at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/panicking.rs:553:19 [INFO] [stderr] 13: std::panic::catch_unwind [INFO] [stderr] at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/panic.rs:359:14 [INFO] [stderr] 14: std::thread::Builder::spawn_unchecked_::{{closure}} [INFO] [stderr] at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/thread/mod.rs:557:30 [INFO] [stderr] 15: core::ops::function::FnOnce::call_once{{vtable.shim}} [INFO] [stderr] at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/core/src/ops/function.rs:253:5 [INFO] [stderr] 16: as core::ops::function::FnOnce>::call_once [INFO] [stderr] at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/alloc/src/boxed.rs:1985:9 [INFO] [stderr] 17: std::sys::pal::unix::thread::Thread::new::thread_start [INFO] [stderr] at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/sys/pal/unix/thread.rs:118:17 [INFO] [stderr] 18: [INFO] [stderr] 19: clone [INFO] [stderr] [trace] Received notify events { events [DebouncedEvent { event: Event { kind: Create(File), paths: ["/tmp/.tmpQ4KodJ/test.txt"], attr:tracker: None, attr:flag: None, attr:info: None, attr:source: None }, time: Instant { tv_sec: 147794, tv_nsec: 112087359 } }, DebouncedEvent { event: Event { kind: Access(Open(Any)), paths: ["/tmp/.tmpQ4KodJ/test.txt"], attr:tracker: None, attr:flag: None, attr:info: None, attr:source: None }, time: Instant { tv_sec: 147794, tv_nsec: 112238539 } }, DebouncedEvent { event: Event { kind: Access(Close(Write)), paths: ["/tmp/.tmpQ4KodJ/test.txt"], attr:tracker: None, attr:flag: None, attr:info: None, attr:source: None }, time: Instant { tv_sec: 147794, tv_nsec: 112447359 } }] } [INFO] [stderr] [error] All retry attempts failed: Mock callback error [INFO] [stdout] test watcher::tests::test_watcher_callback_error ... ok [INFO] [stderr] [debug] Received shutdown signal [INFO] [stdout] test watcher::tests::test_watcher_shutdown ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 34 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 5.19s [INFO] [stdout] [INFO] [stderr] Running unittests src/main.rs (/opt/rustwide/target/debug/deps/gitwatch-bc13c6756f472371) [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stdout] test tests::test_main_error_handling ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s [INFO] [stdout] [INFO] [stderr] Running tests/integration_tests.rs (/opt/rustwide/target/debug/deps/integration_tests-36e8e259b848d3c4) [INFO] [stdout] [INFO] [stdout] running 13 tests [INFO] [stdout] test test_main_invalid_path ... ok [INFO] [stdout] test test_invalid_command ... ok [INFO] [stdout] test test_completion_command ... ok [INFO] [stderr] [debug] Using git repository '/tmp/.tmpZJimR4' [INFO] [stdout] Opened repo '.tmpZJimR4' at commit '[31db9e2] Initial commit' [INFO] [stderr] [debug] Using git repository '/tmp/.tmprohz8G' [INFO] [stdout] Opened repo '.tmprohz8G' at commit '[31db9e2] Initial commit' [INFO] [stderr] [debug] Using git repository '/tmp/.tmpdxr38X' [INFO] [stdout] Opened repo '.tmpdxr38X' at commit '[31db9e2] Initial commit' [INFO] [stdout] Watching for changes... [INFO] [stderr] [debug] Using git repository '/tmp/.tmpVZvu9n' [INFO] [stdout] Opened repo '.tmpVZvu9n' at commit '[31db9e2] Initial commit' [INFO] [stdout] Commit message: [INFO] [stdout] test commit message [INFO] [stdout] Staged files: [INFO] [stdout] foo.txt [INFO] [stdout]  [INFO] [stderr] [warn] Changes will not be commited (dry-run enabled)! [INFO] [stderr] [warn] Watch is disabled [INFO] [stderr] [debug] Using git repository '/tmp/.tmpn5xIKc' [INFO] [stdout] Opened repo '.tmpn5xIKc' at commit '[31db9e2] Initial commit' [INFO] [stderr] [debug] Repository has uncommitted changes) [INFO] [stderr] [debug] Modified files: [INFO] [stderr] [debug] commit-message-script.sh [INFO] [stdout] Opened repo '.tmpTZOQyV' at commit '[31db9e2] Initial commit' [INFO] [stderr] [debug] Using git repository '/tmp/.tmpTZOQyV' [INFO] [stderr] [debug] Executing commit message script '/tmp/.tmpn5xIKc/commit-message-script.sh' [INFO] [stderr] [debug] Generated commit message: 'generated commit message' [INFO] [stderr] [debug] Using git repository '/tmp/.tmpWzkGZG' [INFO] [stdout] test test_dry_run ... ok [INFO] [stdout] Created commit: b9df3c9 'test commit message' [INFO] [stdout] Opened repo '.tmpWzkGZG' at commit '[31db9e2] Initial commit' [INFO] [stderr] [debug] Using git repository '/tmp/.tmph7dPdu' [INFO] [stdout] Created commit: 320d674 'generated commit message' [INFO] [stderr] [warn] Watch is disabled [INFO] [stderr] [warn] Watch is disabled [INFO] [stderr] [debug] Using git repository '/tmp/.tmpmNGZZh' [INFO] [stdout] Opened repo '.tmph7dPdu' at commit '[31db9e2] Initial commit' [INFO] [stdout] Opened repo '.tmpmNGZZh' at commit '[31db9e2] Initial commit' [INFO] [stderr] [debug] Pushing to remote origin [INFO] [stdout] Created commit: b9df3c9 'test commit message' [INFO] [stderr] [debug] Working tree clean [INFO] [stderr] [debug] Working tree clean [INFO] [stdout] Created commit: b9df3c9 'test commit message' [INFO] [stdout] Watching for changes... [INFO] [stdout] test test_commit_on_start ... ok [INFO] [stdout] Watching for changes... [INFO] [stdout] Watching for changes... [INFO] [stdout] test test_commit_message_script ... ok [INFO] [stdout] Created commit: b9df3c9 'test commit message' [INFO] [stderr] [debug] Pushing to remote origin [INFO] [stdout] Pushed changes to origin [INFO] [stderr] [warn] Watch is disabled [INFO] [stdout] test test_push_invalid_remote ... ok [INFO] [stdout] test test_push ... ok [INFO] [stdout] test test_main_valid_args ... ok [INFO] [stderr] [debug] Detected changes: [INFO] [stderr] foo.txt [INFO] [stdout] Created commit: 51762f5 'test commit message' [INFO] [stderr] [debug] Received shutdown signal [INFO] [stderr] [debug] Received shutdown signal [INFO] [stderr] [debug] Received shutdown signal [INFO] [stdout] test test_watch ... ok [INFO] [stdout] test test_gitignore ... ok [INFO] [stdout] test test_ignore_regex ... ok [INFO] [stderr] [debug] Detected changes: [INFO] [stderr] foo.txt [INFO] [stdout] Created commit: 9f906d1 'test commit message' [INFO] [stderr] [debug] Received shutdown signal [INFO] [stdout] test test_debounce ... ok [INFO] [stderr] Doc-tests gitwatch_rs [INFO] [stdout] [INFO] [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.59s [INFO] [stdout] [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; finished in 0.00s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "599fc9a3fee0c0a74f6646d4b487eda3f17e80f280a835df9fab3a8ad0e8f82e", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "599fc9a3fee0c0a74f6646d4b487eda3f17e80f280a835df9fab3a8ad0e8f82e", kill_on_drop: false }` [INFO] [stdout] 599fc9a3fee0c0a74f6646d4b487eda3f17e80f280a835df9fab3a8ad0e8f82e