Dec 15 17:17:09.038 INFO testing delay-queue-0.2.0 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 15 17:17:09.038 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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"`
Dec 15 17:17:09.299 INFO [stdout] bfc7420e99f4280e92c64893ccbce59689589d3c41714dffb2f380f4b1c8b31d
Dec 15 17:17:09.301 INFO running `"docker" "start" "-a" "bfc7420e99f4280e92c64893ccbce59689589d3c41714dffb2f380f4b1c8b31d"`
Dec 15 17:17:09.860 INFO [stderr] usermod: no changes
Dec 15 17:17:09.921 INFO [stderr]    Compiling delay-queue v0.2.0 (/source)
Dec 15 17:17:10.471 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.59s
Dec 15 17:17:10.473 INFO [stderr] su: No module specific data is present
Dec 15 17:17:10.879 INFO running `"docker" "inspect" "bfc7420e99f4280e92c64893ccbce59689589d3c41714dffb2f380f4b1c8b31d"`
Dec 15 17:17:11.013 INFO running `"docker" "rm" "-f" "bfc7420e99f4280e92c64893ccbce59689589d3c41714dffb2f380f4b1c8b31d"`
Dec 15 17:17:11.206 INFO [stdout] bfc7420e99f4280e92c64893ccbce59689589d3c41714dffb2f380f4b1c8b31d
Dec 15 17:17:11.209 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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"`
Dec 15 17:17:11.495 INFO [stdout] 5068a8890fed2a5b98c1f44fad43d180c4616d8a95de84654e93f15896ddede9
Dec 15 17:17:11.497 INFO running `"docker" "start" "-a" "5068a8890fed2a5b98c1f44fad43d180c4616d8a95de84654e93f15896ddede9"`
Dec 15 17:17:12.607 INFO [stderr] usermod: no changes
Dec 15 17:17:12.648 INFO [stderr]    Compiling pulse v0.5.3
Dec 15 17:17:13.871 INFO [stderr]    Compiling timebomb v0.1.2
Dec 15 17:17:14.737 INFO [stderr]    Compiling delay-queue v0.2.0 (/source)
Dec 15 17:17:18.542 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 5.91s
Dec 15 17:17:18.543 INFO [stderr] su: No module specific data is present
Dec 15 17:17:19.049 INFO running `"docker" "inspect" "5068a8890fed2a5b98c1f44fad43d180c4616d8a95de84654e93f15896ddede9"`
Dec 15 17:17:19.307 INFO running `"docker" "rm" "-f" "5068a8890fed2a5b98c1f44fad43d180c4616d8a95de84654e93f15896ddede9"`
Dec 15 17:17:19.551 INFO [stdout] 5068a8890fed2a5b98c1f44fad43d180c4616d8a95de84654e93f15896ddede9
Dec 15 17:17:19.557 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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"`
Dec 15 17:17:20.144 INFO [stdout] 992102bf5c0941760192f7c922cdca6bdd48706aacf8e80b91dd12bcda2b9276
Dec 15 17:17:20.147 INFO running `"docker" "start" "-a" "992102bf5c0941760192f7c922cdca6bdd48706aacf8e80b91dd12bcda2b9276"`
Dec 15 17:17:21.954 INFO [stderr] usermod: no changes
Dec 15 17:17:22.015 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.03s
Dec 15 17:17:22.025 INFO [stderr]      Running /target/debug/deps/delay_queue-a33683f6033631c5
Dec 15 17:17:22.025 INFO [stdout] 
Dec 15 17:17:22.025 INFO [stdout] running 14 tests
Dec 15 17:17:22.026 INFO [stdout] test delay_queue::tests::entry_comparisons ... ok
Dec 15 17:17:22.031 INFO [stdout] test delay_queue::tests::is_empty ... ok
Dec 15 17:17:22.031 INFO [stdout] test delay_queue::tests::try_pop_for_zero_duration ... ok
Dec 15 17:17:22.051 INFO [stdout] test delay_queue::tests::push_higher_priority_while_waiting_to_try_pop ... ok
Dec 15 17:17:22.051 INFO [stdout] test delay_queue::tests::try_pop_until_now ... ok
Dec 15 17:17:22.051 INFO [stdout] test delayed::tests::compare_until ... ok
Dec 15 17:17:22.051 INFO [stdout] test delayed::tests::correct_value ... ok
Dec 15 17:17:22.079 INFO [stdout] test delay_queue::tests::push_pop_different_thread ... ok
Dec 15 17:17:22.079 INFO [stdout] test delay_queue::tests::push_pop_single_thread ... ok
Dec 15 17:17:22.127 INFO [stdout] test delay_queue::tests::push_higher_priority_while_waiting_to_pop ... ok
Dec 15 17:17:22.137 INFO [stdout] test delay_queue::tests::pop_before_push ... ok
Dec 15 17:17:22.139 INFO [stdout] test delay_queue::tests::try_pop_for ... ok
Dec 15 17:17:22.139 INFO [stdout] test delay_queue::tests::try_pop_until ... ok
Dec 15 17:17:22.157 INFO [stdout] test delay_queue::tests::pop_two_before_push ... ok
Dec 15 17:17:22.157 INFO [stdout] 
Dec 15 17:17:22.157 INFO [stdout] test result: ok. 14 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 17:17:22.157 INFO [stdout] 
Dec 15 17:17:22.163 INFO [stderr]    Doc-tests delay-queue
Dec 15 17:17:23.250 INFO [stdout] 
Dec 15 17:17:23.250 INFO [stdout] running 12 tests
Dec 15 17:17:26.694 INFO [stdout] test src/delay_queue.rs - delay_queue::DelayQueue<T>::try_pop_until (line 228) ... ok
Dec 15 17:17:27.663 INFO [stdout] test src/delay_queue.rs - delay_queue::DelayQueue (line 23) ... ok
Dec 15 17:17:28.083 INFO [stdout] test src/delay_queue.rs - delay_queue::DelayQueue<T>::new (line 64) ... ok
Dec 15 17:17:28.707 INFO [stdout] test src/delay_queue.rs - delay_queue::DelayQueue<T>::pop (line 137) ... ok
Dec 15 17:17:28.715 INFO [stdout] test src/delay_queue.rs - delay_queue::DelayQueue<T>::try_pop_for (line 199) ... ok
Dec 15 17:17:29.015 INFO [stdout] test src/delay_queue.rs - delay_queue::DelayQueue<T>::clone (line 346) ... ok
Dec 15 17:17:29.126 INFO [stdout] test src/delay_queue.rs - delay_queue::DelayQueue<T>::push (line 107) ... ok
Dec 15 17:17:30.071 INFO [stdout] test src/delay_queue.rs - delay_queue::DelayQueue<T>::is_empty (line 297) ... ok
Dec 15 17:17:31.450 INFO [stdout] test src/delay_queue.rs - delay_queue::DelayQueue<T>::with_capacity (line 87) ... ok
Dec 15 17:17:31.467 INFO [stdout] test src/delayed.rs - delayed::Delay (line 22) ... ok
Dec 15 17:17:31.765 INFO [stdout] test src/delayed.rs - delayed::Delay<T>::until_instant (line 48) ... ok
Dec 15 17:17:31.877 INFO [stdout] test src/delayed.rs - delayed::Delay<T>::for_duration (line 65) ... ok
Dec 15 17:17:31.877 INFO [stdout] 
Dec 15 17:17:31.877 INFO [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 17:17:31.877 INFO [stdout] 
Dec 15 17:17:31.894 INFO [stderr] su: No module specific data is present
Dec 15 17:17:32.236 INFO running `"docker" "inspect" "992102bf5c0941760192f7c922cdca6bdd48706aacf8e80b91dd12bcda2b9276"`
Dec 15 17:17:32.352 INFO running `"docker" "rm" "-f" "992102bf5c0941760192f7c922cdca6bdd48706aacf8e80b91dd12bcda2b9276"`
Dec 15 17:17:32.478 INFO [stdout] 992102bf5c0941760192f7c922cdca6bdd48706aacf8e80b91dd12bcda2b9276