[INFO] cloning repository https://github.com/ShaoG-R/kestrel-timer
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/ShaoG-R/kestrel-timer" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FShaoG-R%2Fkestrel-timer", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FShaoG-R%2Fkestrel-timer'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 68908c6024623da985657d50a4b0fff4556768d5
[INFO] testing ShaoG-R/kestrel-timer against master#d933cf483edf1605142ac6899ff32536c0ad8b22 for pr-150933
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FShaoG-R%2Fkestrel-timer" "/workspace/builds/worker-2-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-2-tc1/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/ShaoG-R/kestrel-timer
[INFO] finished tweaking git repo https://github.com/ShaoG-R/kestrel-timer
[INFO] tweaked toml for git repo https://github.com/ShaoG-R/kestrel-timer written to /workspace/builds/worker-2-tc1/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/ShaoG-R/kestrel-timer on toolchain d933cf483edf1605142ac6899ff32536c0ad8b22
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+d933cf483edf1605142ac6899ff32536c0ad8b22" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/ShaoG-R/kestrel-timer 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" "+d933cf483edf1605142ac6899ff32536c0ad8b22" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded proc-macro2 v1.0.102
[INFO] [stderr]   Downloaded unicode-ident v1.0.20
[INFO] [stderr]   Downloaded rtrb v0.3.2
[INFO] [stderr]   Downloaded clap v4.5.50
[INFO] [stderr]   Downloaded smallring v0.1.3
[INFO] [stderr]   Downloaded lite-sync v0.1.7
[INFO] [stderr]   Downloaded clap_builder v4.5.50
[INFO] [stderr]   Downloaded deferred-map v0.3.1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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:cfa559dde23f44738f9990739aaa3487d8df3af37eb5df0572f7cf76004a604a" "/opt/rustwide/cargo-home/bin/cargo" "+d933cf483edf1605142ac6899ff32536c0ad8b22" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 40d86834290c5c81dc0aa9ba79fd2c5f6d3e6c75e4e6d88cd743e30040d9b935
[INFO] running `Command { std: "docker" "start" "-a" "40d86834290c5c81dc0aa9ba79fd2c5f6d3e6c75e4e6d88cd743e30040d9b935", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "40d86834290c5c81dc0aa9ba79fd2c5f6d3e6c75e4e6d88cd743e30040d9b935", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "40d86834290c5c81dc0aa9ba79fd2c5f6d3e6c75e4e6d88cd743e30040d9b935", kill_on_drop: false }`
[INFO] [stdout] 40d86834290c5c81dc0aa9ba79fd2c5f6d3e6c75e4e6d88cd743e30040d9b935
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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:cfa559dde23f44738f9990739aaa3487d8df3af37eb5df0572f7cf76004a604a" "/opt/rustwide/cargo-home/bin/cargo" "+d933cf483edf1605142ac6899ff32536c0ad8b22" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 7a188c73d5079117e3e0261929eb1ecb16568fcf5d9b32c5cc1972216d4d0476
[INFO] running `Command { std: "docker" "start" "-a" "7a188c73d5079117e3e0261929eb1ecb16568fcf5d9b32c5cc1972216d4d0476", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.102
[INFO] [stderr]    Compiling unicode-ident v1.0.20
[INFO] [stderr]    Compiling libc v0.2.177
[INFO] [stderr]    Compiling lock_api v0.4.14
[INFO] [stderr]    Compiling smallring v0.1.3
[INFO] [stderr]    Compiling deferred-map v0.3.1
[INFO] [stderr]    Compiling lite-sync v0.1.7
[INFO] [stderr]    Compiling quote v1.0.41
[INFO] [stderr]    Compiling syn v2.0.108
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling futures-macro v0.3.31
[INFO] [stderr]    Compiling tokio-macros v2.6.0
[INFO] [stderr]    Compiling tokio v1.48.0
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling futures-executor v0.3.31
[INFO] [stderr]    Compiling futures v0.3.31
[INFO] [stderr]    Compiling kestrel-timer v0.3.6 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 13.21s
[INFO] running `Command { std: "docker" "inspect" "7a188c73d5079117e3e0261929eb1ecb16568fcf5d9b32c5cc1972216d4d0476", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7a188c73d5079117e3e0261929eb1ecb16568fcf5d9b32c5cc1972216d4d0476", kill_on_drop: false }`
[INFO] [stdout] 7a188c73d5079117e3e0261929eb1ecb16568fcf5d9b32c5cc1972216d4d0476
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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:cfa559dde23f44738f9990739aaa3487d8df3af37eb5df0572f7cf76004a604a" "/opt/rustwide/cargo-home/bin/cargo" "+d933cf483edf1605142ac6899ff32536c0ad8b22" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 52b9fcb5edcb9a179eb7dd5132fc562f9673a5a775b05faf1ab3322fe7577313
[INFO] running `Command { std: "docker" "start" "-a" "52b9fcb5edcb9a179eb7dd5132fc562f9673a5a775b05faf1ab3322fe7577313", kill_on_drop: false }`
[INFO] [stderr]    Compiling zerocopy v0.8.27
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling clap_lex v0.7.6
[INFO] [stderr]    Compiling serde_json v1.0.145
[INFO] [stderr]    Compiling crossbeam-queue v0.3.12
[INFO] [stderr]    Compiling itertools v0.13.0
[INFO] [stderr]    Compiling zerocopy-derive v0.8.27
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling rtrb v0.3.2
[INFO] [stderr]    Compiling lite-sync v0.1.7
[INFO] [stderr]    Compiling clap_builder v4.5.50
[INFO] [stderr]    Compiling kestrel-timer v0.3.6 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling criterion-plot v0.6.0
[INFO] [stderr]    Compiling tinytemplate v1.2.1
[INFO] [stderr]    Compiling clap v4.5.50
[INFO] [stderr]    Compiling half v2.7.1
[INFO] [stderr]    Compiling ciborium-ll v0.2.2
[INFO] [stderr]    Compiling ciborium v0.2.2
[INFO] [stderr]    Compiling criterion v0.7.0
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 19.01s
[INFO] running `Command { std: "docker" "inspect" "52b9fcb5edcb9a179eb7dd5132fc562f9673a5a775b05faf1ab3322fe7577313", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "52b9fcb5edcb9a179eb7dd5132fc562f9673a5a775b05faf1ab3322fe7577313", kill_on_drop: false }`
[INFO] [stdout] 52b9fcb5edcb9a179eb7dd5132fc562f9673a5a775b05faf1ab3322fe7577313
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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:cfa559dde23f44738f9990739aaa3487d8df3af37eb5df0572f7cf76004a604a" "/opt/rustwide/cargo-home/bin/cargo" "+d933cf483edf1605142ac6899ff32536c0ad8b22" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 5dd0aa4596c993a68c3475dbcc097946f1549f337b9927074ec3c1de14b8428c
[INFO] running `Command { std: "docker" "start" "-a" "5dd0aa4596c993a68c3475dbcc097946f1549f337b9927074ec3c1de14b8428c", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.12s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/kestrel_timer-cd10a83fb668542a)
[INFO] [stdout] 
[INFO] [stdout] running 102 tests
[INFO] [stdout] test config::tests::test_batch_config_default ... ok
[INFO] [stdout] test config::tests::test_service_config_builder ... ok
[INFO] [stdout] test config::tests::test_wheel_config_builder ... ok
[INFO] [stdout] test config::tests::test_wheel_config_validation_zero_tick ... ok
[INFO] [stdout] test config::tests::test_timer_config_builder ... ok
[INFO] [stdout] test config::tests::test_wheel_config_default ... ok
[INFO] [stdout] test config::tests::test_timer_config_default ... ok
[INFO] [stdout] test config::tests::test_wheel_config_validation_invalid_slot_count ... ok
[INFO] [stdout] test integration_tests::test_batch_completion_reasons ... ok
[INFO] [stdout] test service::tests::test_shutdown ... ok
[INFO] [stdout] test service::tests::test_service_creation ... ok
[INFO] [stdout] test integration_tests::test_completion_reason_cancelled ... ok
[INFO] [stdout] test service::tests::test_take_receiver_twice ... ok
[INFO] [stdout] test tests::service::cancel_tests::test_cancel_batch_empty ... ok
[INFO] [stdout] test tests::service::cancel_tests::test_cancel_nonexistent_task ... ok
[INFO] [stdout] test tests::service::cancel_tests::test_cancel_task ... ok
[INFO] [stdout] test integration_tests::test_notify_only_timer_once ... ok
[INFO] [stdout] test service::tests::test_schedule_once_notify_direct ... ok
[INFO] [stdout] test service::tests::test_add_timer_handle_and_receive_timeout ... ok
[INFO] [stdout] test integration_tests::test_completion_reason_expired ... ok
[INFO] [stdout] test service::tests::test_task_timeout_cleans_up_task_sender ... ok
[INFO] [stdout] test integration_tests::test_completion_notification_once ... ok
[INFO] [stdout] test service::tests::test_schedule_once_direct ... ok
[INFO] [stdout] test integration_tests::test_basic_timer ... ok
[INFO] [stdout] test tests::service::postpone_tests::test_postpone_batch_empty ... ok
[INFO] [stdout] test tests::service::batch_tests::test_schedule_once_batch_direct ... ok
[INFO] [stdout] test tests::service::cancel_tests::test_cancel_batch_direct ... ok
[INFO] [stdout] test tests::service::cancel_tests::test_cancel_batch_partial ... ok
[INFO] [stdout] test tests::service::postpone_tests::test_postpone_nonexistent_task ... ok
[INFO] [stdout] test tests::service::cancel_tests::test_cancel_task_spawns_background_task ... ok
[INFO] [stdout] test tests::service::cancel_tests::test_cancelled_task_not_forwarded_to_timeout_rx ... ok
[INFO] [stdout] test integration_tests::test_batch_completion_notifications ... ok
[INFO] [stdout] test tests::service::cancel_tests::test_schedule_and_cancel_direct ... ok
[INFO] [stdout] test tests::service::periodic_tests::test_periodic_task_cancel_no_notification ... ok
[INFO] [stdout] test tests::service::postpone_tests::test_postpone ... ok
[INFO] [stdout] test tests::service::periodic_tests::test_periodic_task_basic ... ok
[INFO] [stdout] test integration_tests::test_timer_cancellation ... ok
[INFO] [stdout] test integration_tests::test_multiple_timers ... ok
[INFO] [stdout] test tests::service::postpone_tests::test_postpone_keeps_timeout_notification_valid ... ok
[INFO] [stdout] test tests::service::periodic_tests::test_periodic_task_batch_register ... ok
[INFO] [stdout] test tests::service::postpone_tests::test_postpone_batch ... ok
[INFO] [stdout] test tests::service::postpone_tests::test_postpone_batch_with_callbacks ... ok
[INFO] [stdout] test tests::service::periodic_tests::test_mixed_oneshot_and_periodic_tasks ... ok
[INFO] [stdout] test tests::service::postpone_tests::test_postpone_batch_without_callbacks ... ok
[INFO] [stdout] test tests::timer::periodic_tests::test_periodic_cancel_notification ... ok
[INFO] [stdout] test tests::timer::batch_tests::test_periodic_batch_postpone ... ok
[INFO] [stdout] test tests::timer::batch_tests::test_periodic_batch_cancel ... ok
[INFO] [stdout] test tests::wheel::advanced_tests::test_hierarchical_l1_to_l0_demotion ... ok
[INFO] [stdout] test tests::wheel::batch_tests::test_batch_cancel_small_threshold ... ok
[INFO] [stdout] test tests::wheel::batch_tests::test_batch_operations_same_slot ... ok
[INFO] [stdout] test tests::wheel::batch_tests::test_cancel_batch ... ok
[INFO] [stdout] test tests::wheel::batch_tests::test_empty_batch_operations ... ok
[INFO] [stdout] test tests::wheel::advanced_tests::test_multi_round_tasks ... ok
[INFO] [stdout] test tests::wheel::batch_tests::test_insert_batch ... ok
[INFO] [stdout] test tests::wheel::periodic_tests::test_mixed_oneshot_and_periodic_tasks ... ok
[INFO] [stdout] test tests::wheel::periodic_tests::test_periodic_task_basic ... ok
[INFO] [stdout] test tests::wheel::periodic_tests::test_periodic_task_batch_cancel ... ok
[INFO] [stdout] test tests::wheel::periodic_tests::test_periodic_task_batch_insert ... ok
[INFO] [stdout] test tests::wheel::periodic_tests::test_periodic_task_batch_postpone ... ok
[INFO] [stdout] test tests::wheel::periodic_tests::test_periodic_task_cancel ... ok
[INFO] [stdout] test tests::wheel::periodic_tests::test_periodic_task_cross_layer ... ok
[INFO] [stdout] test tests::wheel::periodic_tests::test_periodic_task_multiple_triggers ... ok
[INFO] [stdout] test tests::wheel::periodic_tests::test_periodic_task_postpone ... ok
[INFO] [stdout] test tests::wheel::periodic_tests::test_periodic_task_postpone_cross_layer ... ok
[INFO] [stdout] test tests::wheel::periodic_tests::test_periodic_task_postpone_with_callback ... ok
[INFO] [stdout] test tests::wheel::periodic_tests::test_periodic_task_with_initial_delay ... ok
[INFO] [stdout] test tests::wheel::postpone_tests::test_cancel_after_postpone ... ok
[INFO] [stdout] test tests::wheel::postpone_tests::test_cross_layer_postpone ... ok
[INFO] [stdout] test tests::wheel::postpone_tests::test_postpone_batch ... ok
[INFO] [stdout] test tests::wheel::postpone_tests::test_postpone_batch_partial ... ok
[INFO] [stdout] test tests::wheel::batch_tests::test_insert_batch_length_mismatch ... ok
[INFO] [stdout] test tests::timer::batch_tests::test_periodic_batch_register ... ok
[INFO] [stdout] test tests::wheel::postpone_tests::test_postpone_same_task_multiple_times ... ok
[INFO] [stdout] test tests::wheel::postpone_tests::test_postpone_nonexistent_task ... ok
[INFO] [stdout] test tests::wheel::postpone_tests::test_postpone_single_task ... ok
[INFO] [stdout] test tests::wheel::postpone_tests::test_postpone_with_new_callback ... ok
[INFO] [stdout] test timer::tests::test_timer_creation ... ok
[INFO] [stdout] test tests::timer::postpone_tests::test_postpone_keeps_completion_receiver_valid ... ok
[INFO] [stdout] test wheel::tests::test_delay_to_ticks ... ok
[INFO] [stdout] test wheel::tests::test_cross_layer_cancel ... ok
[INFO] [stdout] test wheel::tests::test_hierarchical_config_validation ... ok
[INFO] [stdout] test wheel::tests::test_advance_empty_slots ... ok
[INFO] [stdout] test tests::timer::cancel_tests::test_cancel_immediate ... ok
[INFO] [stdout] test tests::timer::postpone_tests::test_postpone_with_callback ... ok
[INFO] [stdout] test wheel::tests::test_hierarchical_wheel_creation ... ok
[INFO] [stdout] test wheel::tests::test_hierarchical_insert_and_advance ... ok
[INFO] [stdout] test wheel::tests::test_layer_determination ... ok
[INFO] [stdout] test wheel::tests::test_minimum_delay ... ok
[INFO] [stdout] test tests::timer::cancel_tests::test_cancel_timer ... ok
[INFO] [stdout] test wheel::tests::test_slot_boundary ... ok
[INFO] [stdout] test wheel::tests::test_task_id_uniqueness ... ok
[INFO] [stdout] test wheel::tests::test_wheel_creation ... ok
[INFO] [stdout] test wheel::tests::test_wheel_invalid_slot_count ... ok
[INFO] [stdout] test tests::timer::batch_tests::test_postpone_batch ... ok
[INFO] [stdout] test tests::timer::postpone_tests::test_postpone_timer ... ok
[INFO] [stdout] test tests::timer::periodic_tests::test_periodic_cancel ... ok
[INFO] [stdout] test tests::timer::batch_tests::test_postpone_batch_with_callbacks ... ok
[INFO] [stdout] test tests::timer::periodic_tests::test_periodic_basic ... ok
[INFO] [stdout] test tests::timer::periodic_tests::test_periodic_postpone_with_callback ... ok
[INFO] [stdout] test timer::tests::test_schedule_once ... ok
[INFO] [stdout] test tests::timer::periodic_tests::test_periodic_completion_receiver ... ok
[INFO] [stdout] test tests::timer::periodic_tests::test_periodic_postpone ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 102 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.49s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/integration_test.rs (/opt/rustwide/target/debug/deps/integration_test-1919d3257063ce75)
[INFO] [stdout] 
[INFO] [stdout] running 18 tests
[INFO] [stdout] test test_batch_cancel_no_wait ... ok
[INFO] [stdout] test test_batch_cancel ... ok
[INFO] [stdout] test test_memory_efficiency ... ok
[INFO] [stdout] test test_timer_precision ... ok
[INFO] [stdout] test test_postpone_with_new_callback ... ok
[INFO] [stdout] test test_batch_schedule ... ok
[INFO] [stdout] test test_service_isolation ... ok
[INFO] [stdout] test test_postpone_single_timer ... ok
[INFO] [stdout] test test_concurrent_operations ... ok
[INFO] [stdout] test test_batch_cancel_partial ... ok
[INFO] [stdout] test test_single_wheel_multiple_services ... ok
[INFO] [stdout] test test_postpone_with_service ... ok
[INFO] [stdout] test test_large_scale_timers ... ok
[INFO] [stdout] test test_postpone_multiple_times ... ok
[INFO] [stdout] test test_timer_with_different_delays ... ok
[INFO] [stdout] test test_multiple_services_concurrent_operations ... ok
[INFO] [stdout] test test_postpone_batch_with_callbacks ... ok
[INFO] [stdout] test test_batch_postpone ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 18 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.29s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests kestrel_timer
[INFO] [stdout] 
[INFO] [stdout] running 50 tests
[INFO] [stdout] test src/config.rs - config::BatchConfig (line 327) - compile ... ok
[INFO] [stdout] test src/config.rs - config::ServiceConfig (line 209) - compile ... ok
[INFO] [stdout] test src/config.rs - config::WheelConfig (line 19) - compile ... ok
[INFO] [stdout] test src/config.rs - config::TimerConfig (line 366) - compile ... ok
[INFO] [stdout] test src/lib.rs - (line 26) - compile ... ok
[INFO] [stdout] test src/service.rs - service::TimerService::allocate_handle (line 175) - compile ... ok
[INFO] [stdout] test src/service.rs - service::TimerService::allocate_handles (line 206) - compile ... ok
[INFO] [stdout] test src/service.rs - service::TimerService::cancel_batch (line 374) - compile ... ok
[INFO] [stdout] test src/service.rs - service::TimerService (line 96) - compile ... ok
[INFO] [stdout] test src/service.rs - service::TimerService::cancel_task (line 322) - compile ... ok
[INFO] [stdout] test src/service.rs - service::TimerService::postpone (line 449) - compile ... ok
[INFO] [stdout] test src/service.rs - service::TimerService::postpone_batch_with_callbacks (line 562) - compile ... ok
[INFO] [stdout] test src/service.rs - service::TimerService::postpone_batch (line 504) - compile ... ok
[INFO] [stdout] test src/service.rs - service::TimerService::register (line 632) - compile ... ok
[INFO] [stdout] test src/service.rs - service::TimerService::register_batch (line 710) - compile ... ok
[INFO] [stdout] test src/service.rs - service::TimerService::shutdown (line 796) - compile ... ok
[INFO] [stdout] test src/timer.rs - timer::TimerWheel::cancel (line 401) - compile ... ok
[INFO] [stdout] test src/timer.rs - timer::TimerWheel::register (line 246) - compile ... ok
[INFO] [stdout] test src/timer.rs - timer::TimerWheel::postpone_batch (line 611) - compile ... ok
[INFO] [stdout] test src/timer.rs - timer::TimerWheel::postpone_batch_with_callbacks (line 679) - compile ... ok
[INFO] [stdout] test src/timer.rs - timer::TimerWheel::postpone (line 520) - compile ... ok
[INFO] [stdout] test src/timer.rs - timer::TimerWheel::cancel_batch (line 453) - compile ... ok
[INFO] [stdout] test src/service.rs - service::TimerService::take_receiver (line 279) - compile ... ok
[INFO] [stdout] test src/task.rs - task::TimerCallback (line 139) ... ok
[INFO] [stdout] test src/timer.rs - timer::TimerWheel::shutdown (line 777) - compile ... ok
[INFO] [stdout] test src/task.rs - task::CallbackWrapper::new (line 207) ... ok
[INFO] [stdout] test src/timer.rs - timer::TimerWheel::create_service_with_config (line 180) - compile ... ok
[INFO] [stdout] test src/timer.rs - timer::TimerWheel::with_defaults (line 96) - compile ... ok
[INFO] [stdout] test src/timer.rs - timer::TimerWheel::register_batch (line 319) - compile ... ok
[INFO] [stdout] test src/timer.rs - timer::TimerWheel::create_service (line 125) - compile ... ok
[INFO] [stdout] test src/timer.rs - timer::TimerWheel::postpone (line 546) - compile ... ok
[INFO] [stdout] test src/timer.rs - timer::TimerWheel::new (line 41) - compile ... ok
[INFO] [stdout] test src/timer/handle.rs - timer::handle::BatchHandle::cancel_all (line 270) - compile ... ok
[INFO] [stdout] test src/timer/handle.rs - timer::handle::BatchHandle::postpone_each (line 417) - compile ... ok
[INFO] [stdout] test src/timer/handle.rs - timer::handle::BatchHandle::into_handles (line 302) - compile ... ok
[INFO] [stdout] test src/timer/handle.rs - timer::handle::BatchHandle::postpone_each_with_callbacks (line 465) - compile ... ok
[INFO] [stdout] test src/timer/handle.rs - timer::handle::BatchHandleWithCompletion::cancel_all (line 537) - compile ... ok
[INFO] [stdout] test src/timer/handle.rs - timer::handle::BatchHandleWithCompletion::into_handles (line 568) - compile ... ok
[INFO] [stdout] test src/timer/handle.rs - timer::handle::BatchHandleWithCompletion::into_parts (line 629) - compile ... ok
[INFO] [stdout] test src/timer/handle.rs - timer::handle::BatchHandleWithCompletion::postpone_all (line 682) - compile ... ok
[INFO] [stdout] test src/task.rs - task::CallbackWrapper (line 182) ... ok
[INFO] [stdout] test src/timer/handle.rs - timer::handle::BatchHandleWithCompletion::postpone_each (line 722) - compile ... ok
[INFO] [stdout] test src/timer/handle.rs - timer::handle::BatchHandleWithCompletion::postpone_each_with_callbacks (line 767) - compile ... ok
[INFO] [stdout] test src/timer/handle.rs - timer::handle::TimerHandle::cancel (line 35) - compile ... ok
[INFO] [stdout] test src/timer/handle.rs - timer::handle::TimerHandle::postpone (line 77) - compile ... ok
[INFO] [stdout] test src/timer/handle.rs - timer::handle::TimerHandleWithCompletion::cancel (line 136) - compile ... ok
[INFO] [stdout] test src/timer/handle.rs - timer::handle::TimerHandleWithCompletion::into_parts (line 206) - compile ... ok
[INFO] [stdout] test src/timer/handle.rs - timer::handle::TimerHandleWithCompletion::postpone (line 176) - compile ... ok
[INFO] [stdout] test src/timer/handle.rs - timer::handle::BatchHandleWithCompletion (line 804) - compile ... ok
[INFO] [stdout] test src/timer/handle.rs - timer::handle::BatchHandle::postpone_all (line 373) - compile ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 50 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 3.92s; merged doctests compilation took 3.89s
[INFO] running `Command { std: "docker" "inspect" "5dd0aa4596c993a68c3475dbcc097946f1549f337b9927074ec3c1de14b8428c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5dd0aa4596c993a68c3475dbcc097946f1549f337b9927074ec3c1de14b8428c", kill_on_drop: false }`
[INFO] [stdout] 5dd0aa4596c993a68c3475dbcc097946f1549f337b9927074ec3c1de14b8428c