[INFO] fetching crate extended-notify 0.1.3...
[INFO] testing extended-notify-0.1.3 against 1.98.0-beta.8+cargoflags=--release for beta-release-1.99-3
[INFO] extracting crate extended-notify 0.1.3 into /workspace/builds/worker-1-tc1/source
[INFO] started tweaking crates.io crate extended-notify 0.1.3
[INFO] finished tweaking crates.io crate extended-notify 0.1.3
[INFO] tweaked toml for crates.io crate extended-notify 0.1.3 written to /workspace/builds/worker-1-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate extended-notify 0.1.3 on toolchain 1.98.0-beta.8
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.98.0-beta.8" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate extended-notify 0.1.3 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" "+1.98.0-beta.8" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded triomphe v0.1.15
[INFO] [stderr]   Downloaded tempfile v3.23.0
[INFO] [stderr]   Downloaded inotify-sys v0.1.5
[INFO] [stderr]   Downloaded fsevent-sys v4.1.0
[INFO] [stderr]   Downloaded notify-types v2.0.0
[INFO] [stderr]   Downloaded file-id v0.2.3
[INFO] [stderr]   Downloaded env_filter v0.1.4
[INFO] [stderr]   Downloaded futures-io v0.3.31
[INFO] [stderr]   Downloaded kqueue-sys v1.0.4
[INFO] [stderr]   Downloaded colorchoice v1.0.4
[INFO] [stderr]   Downloaded futures-sink v0.3.31
[INFO] [stderr]   Downloaded inotify v0.11.0
[INFO] [stderr]   Downloaded futures-executor v0.3.31
[INFO] [stderr]   Downloaded anstyle-parse v0.2.7
[INFO] [stderr]   Downloaded env_logger v0.11.8
[INFO] [stderr]   Downloaded derive_builder_core v0.20.2
[INFO] [stderr]   Downloaded kqueue v1.1.1
[INFO] [stderr]   Downloaded anstyle v1.0.13
[INFO] [stderr]   Downloaded notify-debouncer-full v0.6.0
[INFO] [stderr]   Downloaded anstream v0.6.21
[INFO] [stderr]   Downloaded derive_builder v0.20.2
[INFO] [stderr]   Downloaded notify v8.2.0
[INFO] [stderr]   Downloaded futures v0.3.31
[INFO] [stderr]   Downloaded portable-atomic-util v0.2.4
[INFO] [stderr]   Downloaded anyhow v1.0.100
[INFO] [stderr]   Downloaded jiff-static v0.2.16
[INFO] [stderr]   Downloaded arcstr v1.2.0
[INFO] [stderr]   Downloaded portable-atomic v1.11.1
[INFO] [stderr]   Downloaded libc v0.2.178
[INFO] [stderr]   Downloaded jiff v0.2.16
[INFO] [stderr]   Downloaded poolshark v0.2.6
[INFO] [stderr]   Downloaded poolshark_derive v0.1.1
[INFO] [stderr]   Downloaded derive_builder_macro v0.20.2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,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" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:8683fc1fc2eb5c9ac98e0d076ab094b2ffac7f99da555d2b6a2e27f346de2ec7" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 02087503145b12a2c91f35517a1e900e0ebaf84df8b70f559903133a2bc9c3b8
[INFO] running `Command { std: "docker" "start" "02087503145b12a2c91f35517a1e900e0ebaf84df8b70f559903133a2bc9c3b8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "02087503145b12a2c91f35517a1e900e0ebaf84df8b70f559903133a2bc9c3b8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-w" "/opt/rustwide/workdir" "--user" "0:0" "02087503145b12a2c91f35517a1e900e0ebaf84df8b70f559903133a2bc9c3b8" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.8" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "02087503145b12a2c91f35517a1e900e0ebaf84df8b70f559903133a2bc9c3b8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "02087503145b12a2c91f35517a1e900e0ebaf84df8b70f559903133a2bc9c3b8" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.8" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.103
[INFO] [stderr]    Compiling unicode-ident v1.0.22
[INFO] [stderr]    Compiling quote v1.0.42
[INFO] [stderr]    Compiling libc v0.2.178
[INFO] [stderr]    Compiling fnv v1.0.7
[INFO] [stderr]    Compiling futures-sink v0.3.31
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling futures-core v0.3.31
[INFO] [stderr]    Compiling pin-project-lite v0.2.16
[INFO] [stderr]    Compiling crossbeam-utils v0.8.21
[INFO] [stderr]    Compiling same-file v1.0.6
[INFO] [stderr]    Compiling futures-channel v0.3.31
[INFO] [stderr]    Compiling memchr v2.7.6
[INFO] [stderr]    Compiling pin-utils v0.1.0
[INFO] [stderr]    Compiling futures-io v0.3.31
[INFO] [stderr]    Compiling slab v0.4.11
[INFO] [stderr]    Compiling futures-task v0.3.31
[INFO] [stderr]    Compiling bitflags v2.10.0
[INFO] [stderr]    Compiling log v0.4.29
[INFO] [stderr]    Compiling walkdir v2.5.0
[INFO] [stderr]    Compiling anyhow v1.0.100
[INFO] [stderr]    Compiling notify-types v2.0.0
[INFO] [stderr]    Compiling hashbrown v0.16.1
[INFO] [stderr]    Compiling inotify-sys v0.1.5
[INFO] [stderr]    Compiling inotify v0.11.0
[INFO] [stderr]    Compiling syn v2.0.111
[INFO] [stderr]    Compiling mio v1.1.1
[INFO] [stderr]    Compiling triomphe v0.1.15
[INFO] [stderr]    Compiling crossbeam-queue v0.3.12
[INFO] [stderr]    Compiling fxhash v0.2.1
[INFO] [stderr]    Compiling file-id v0.2.3
[INFO] [stderr]    Compiling notify v8.2.0
[INFO] [stderr]    Compiling arcstr v1.2.0
[INFO] [stderr]    Compiling indexmap v2.12.1
[INFO] [stderr]    Compiling notify-debouncer-full v0.6.0
[INFO] [stderr]    Compiling darling_core v0.20.11
[INFO] [stderr]    Compiling futures-macro v0.3.31
[INFO] [stderr]    Compiling enumflags2_derive v0.7.12
[INFO] [stderr]    Compiling poolshark_derive v0.1.1
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling tokio-macros v2.6.0
[INFO] [stderr]    Compiling enumflags2 v0.7.12
[INFO] [stderr]    Compiling tokio v1.48.0
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling darling_macro v0.20.11
[INFO] [stderr]    Compiling darling v0.20.11
[INFO] [stderr]    Compiling derive_builder_core v0.20.2
[INFO] [stderr]    Compiling poolshark v0.2.6
[INFO] [stderr]    Compiling derive_builder_macro v0.20.2
[INFO] [stderr]    Compiling derive_builder v0.20.2
[INFO] [stderr]    Compiling futures-executor v0.3.31
[INFO] [stderr]    Compiling futures v0.3.31
[INFO] [stderr]    Compiling extended-notify v0.1.3 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 46.87s
[INFO] running `Command { std: "docker" "inspect" "02087503145b12a2c91f35517a1e900e0ebaf84df8b70f559903133a2bc9c3b8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "02087503145b12a2c91f35517a1e900e0ebaf84df8b70f559903133a2bc9c3b8" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.8" "test" "--frozen" "--no-run" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling log v0.4.29
[INFO] [stderr]    Compiling bitflags v2.10.0
[INFO] [stderr]    Compiling aho-corasick v1.1.4
[INFO] [stderr]    Compiling regex-syntax v0.8.8
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling utf8parse v0.2.2
[INFO] [stderr]    Compiling rustix v1.1.2
[INFO] [stderr]    Compiling anstyle-query v1.1.5
[INFO] [stderr]    Compiling anstyle-parse v0.2.7
[INFO] [stderr]    Compiling colorchoice v1.0.4
[INFO] [stderr]    Compiling anstyle v1.0.13
[INFO] [stderr]    Compiling inotify v0.11.0
[INFO] [stderr]    Compiling mio v1.1.1
[INFO] [stderr]    Compiling is_terminal_polyfill v1.70.2
[INFO] [stderr]    Compiling linux-raw-sys v0.11.0
[INFO] [stderr]    Compiling anstream v0.6.21
[INFO] [stderr]    Compiling once_cell v1.21.3
[INFO] [stderr]    Compiling notify v8.2.0
[INFO] [stderr]    Compiling fastrand v2.3.0
[INFO] [stderr]    Compiling jiff v0.2.16
[INFO] [stderr]    Compiling notify-debouncer-full v0.6.0
[INFO] [stderr]    Compiling regex-automata v0.4.13
[INFO] [stderr]    Compiling tempfile v3.23.0
[INFO] [stderr]    Compiling extended-notify v0.1.3 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling regex v1.12.2
[INFO] [stderr]    Compiling env_filter v0.1.4
[INFO] [stderr]    Compiling env_logger v0.11.8
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 1m 07s
[INFO] running `Command { std: "docker" "inspect" "02087503145b12a2c91f35517a1e900e0ebaf84df8b70f559903133a2bc9c3b8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "02087503145b12a2c91f35517a1e900e0ebaf84df8b70f559903133a2bc9c3b8" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.8" "test" "--frozen" "--release", kill_on_drop: false }`
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 0.17s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/deps/extended_notify-42ea535a1cd7880d)
[INFO] [stdout] 
[INFO] [stdout] running 18 tests
[INFO] [stdout] test test::dir_and_nonexistent_child ... ok
[INFO] [stdout] test test::delete_parent_directory ... ok
[INFO] [stdout] test test::delete_file ... ok
[INFO] [stdout] test test::multiple_watches_nonexistent ... ok
[INFO] [stdout] test test::atomic_file_replacement ... ok
[INFO] [stdout] test test::create_intermediate_dirs_slowly ... ok
[INFO] [stdout] test test::multiple_watches_same_file ... ok
[INFO] [stdout] test test::existing_file ... ok
[INFO] [stdout] test test::nonexistent_create ... ok
[INFO] [stdout] test test::nested_nonexistent ... ok
[INFO] [stdout] test test::pending_watch_survives_unrelated_siblings ... ok
[INFO] [stdout] test test::rename_parent_directory ... ok
[INFO] [stdout] test test::repeated_atomic_file_replacement ... ok
[INFO] [stdout] test test::rename_to_watched_path ... ok
[INFO] [stdout] test test::unwatch ... ok
[INFO] [stdout] test test::replace_file_with_directory ... ok
[INFO] [stdout] test test::rapid_create_delete_cycles ... ok
[INFO] [stdout] test test::pending_watch_rearms_on_ancestor_replacement ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- test::pending_watch_rearms_on_ancestor_replacement stdout ----
[INFO] [stdout] running in /tmp/.tmpfCqJ18
[INFO] [stdout] run step SetPollBatch { n: 0 }
[INFO] [stdout] run step CreateDir { path: "a" }
[INFO] [stdout] run step CreateDir { path: "a/b" }
[INFO] [stdout] run step Watch { name: "gp", path: "a", interest: BitFlags<Interest>(0b10000001, Established | Create) }
[INFO] [stdout] run step Watch { name: "w", path: "a/b/c", interest: BitFlags<Interest>(0b10000001, Established | Create) }
[INFO] [stdout] run step Drain
[INFO] [stdout] run step DeleteDir { path: "a/b" }
[INFO] [stdout] run step Sleep { ms: 400 }
[INFO] [stdout] run step CreateDir { path: "a/b" }
[INFO] [stdout] run step Drain
[INFO] [stdout] run step WriteFile { path: "a/b/c", content: "hi" }
[INFO] [stdout] run step AtLeast([Event { watch: "w", kind: BitFlags<Interest>(0b10000000, Create), path: "a/b/c" }])
[INFO] [stdout] Error: step 11 (AtLeast([Event { watch: "w", kind: BitFlags<Interest>(0b10000000, Create), path: "a/b/c" }])): timeout waiting for events: [Event { watch: "w", kind: BitFlags<Interest>(0b10000000, Create), path: "a/b/c" }]
[INFO] [stdout] pending events: []
[INFO] [stdout] pending errors: []
[INFO] [stdout] 
[INFO] [stdout] Stack backtrace:
[INFO] [stdout]    0: <anyhow::Error>::msg::<alloc::string::String>
[INFO] [stdout]    1: anyhow::__private::format_err
[INFO] [stdout]    2: extended_notify::test::run_test::{closure#0}::{closure#0}
[INFO] [stdout]    3: extended_notify::test::run_test::{closure#0}
[INFO] [stdout]    4: extended_notify::test::pending_watch_rearms_on_ancestor_replacement::{closure#0}
[INFO] [stdout]    5: <tokio::runtime::scheduler::current_thread::Context>::enter::<core::task::poll::Poll<core::result::Result<(), anyhow::Error>>, <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = core::result::Result<(), anyhow::Error>>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]    6: <tokio::runtime::context::scoped::Scoped<tokio::runtime::scheduler::Context>>::set::<<tokio::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = core::result::Result<(), anyhow::Error>>>>>::{closure#0}, core::option::Option<core::result::Result<(), anyhow::Error>>>::{closure#0}, (alloc::boxed::Box<tokio::runtime::scheduler::current_thread::Core>, core::option::Option<core::result::Result<(), anyhow::Error>>)>
[INFO] [stdout]    7: <tokio::runtime::runtime::Runtime>::block_on::<core::pin::Pin<&mut dyn core::future::future::Future<Output = core::result::Result<(), anyhow::Error>>>>
[INFO] [stdout]    8: extended_notify::test::pending_watch_rearms_on_ancestor_replacement
[INFO] [stdout]    9: <extended_notify::test::pending_watch_rearms_on_ancestor_replacement::{closure#0} as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   10: test::__rust_begin_short_backtrace::<core::result::Result<(), alloc::string::String>, fn() -> core::result::Result<(), alloc::string::String>>
[INFO] [stdout]   11: test::run_test::{closure#0}
[INFO] [stdout]   12: std::sys::backtrace::__rust_begin_short_backtrace::<test::run_test::{closure#1}, ()>
[INFO] [stdout]   13: <std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1} as core::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   14: <std::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   15: <unknown>
[INFO] [stdout]   16: clone
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     test::pending_watch_rearms_on_ancestor_replacement
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 17 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 9.09s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "02087503145b12a2c91f35517a1e900e0ebaf84df8b70f559903133a2bc9c3b8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "02087503145b12a2c91f35517a1e900e0ebaf84df8b70f559903133a2bc9c3b8", kill_on_drop: false }`
[INFO] [stdout] 02087503145b12a2c91f35517a1e900e0ebaf84df8b70f559903133a2bc9c3b8