Nov 18 16:22:00.941 INFO testing delay-queue-0.2.0 against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 18 16:22:00.942 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-1/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 18 16:22:01.359 INFO [stdout] 29fd8c17f5434424131b0ddc8aa75c5f3546ce056336ecc6dfc705886afb2e84
Nov 18 16:22:01.365 INFO running `"docker" "start" "-a" "29fd8c17f5434424131b0ddc8aa75c5f3546ce056336ecc6dfc705886afb2e84"`
Nov 18 16:22:02.082 INFO [stderr] usermod: no changes
Nov 18 16:22:02.119 INFO [stderr]    Compiling delay-queue v0.2.0 (/source)
Nov 18 16:22:02.566 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.46s
Nov 18 16:22:02.568 INFO [stderr] su: No module specific data is present
Nov 18 16:22:02.873 INFO running `"docker" "inspect" "29fd8c17f5434424131b0ddc8aa75c5f3546ce056336ecc6dfc705886afb2e84"`
Nov 18 16:22:02.945 INFO running `"docker" "rm" "-f" "29fd8c17f5434424131b0ddc8aa75c5f3546ce056336ecc6dfc705886afb2e84"`
Nov 18 16:22:03.078 INFO [stdout] 29fd8c17f5434424131b0ddc8aa75c5f3546ce056336ecc6dfc705886afb2e84
Nov 18 16:22:03.085 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-1/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 18 16:22:03.269 INFO [stdout] 42251e7315ba4269eaa4f530c5bb9b708ef1f37615a31d2e30bd0159c168370e
Nov 18 16:22:03.273 INFO running `"docker" "start" "-a" "42251e7315ba4269eaa4f530c5bb9b708ef1f37615a31d2e30bd0159c168370e"`
Nov 18 16:22:03.893 INFO [stderr] usermod: no changes
Nov 18 16:22:03.914 INFO [stderr]    Compiling pulse v0.5.3
Nov 18 16:22:05.065 INFO [stderr]    Compiling timebomb v0.1.2
Nov 18 16:22:05.575 INFO [stderr]    Compiling delay-queue v0.2.0 (/source)
Nov 18 16:22:08.123 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.23s
Nov 18 16:22:08.126 INFO [stderr] su: No module specific data is present
Nov 18 16:22:08.556 INFO running `"docker" "inspect" "42251e7315ba4269eaa4f530c5bb9b708ef1f37615a31d2e30bd0159c168370e"`
Nov 18 16:22:08.646 INFO running `"docker" "rm" "-f" "42251e7315ba4269eaa4f530c5bb9b708ef1f37615a31d2e30bd0159c168370e"`
Nov 18 16:22:08.764 INFO [stdout] 42251e7315ba4269eaa4f530c5bb9b708ef1f37615a31d2e30bd0159c168370e
Nov 18 16:22:08.767 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-1/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 18 16:22:08.958 INFO [stdout] 08c821d0af6b628757d0e5d775d5a8d2c76082c661d0874174bc22af383a1e0e
Nov 18 16:22:08.960 INFO running `"docker" "start" "-a" "08c821d0af6b628757d0e5d775d5a8d2c76082c661d0874174bc22af383a1e0e"`
Nov 18 16:22:09.344 INFO [stderr] usermod: no changes
Nov 18 16:22:09.387 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.02s
Nov 18 16:22:09.399 INFO [stderr]      Running /target/debug/deps/delay_queue-8e35aaffece77031
Nov 18 16:22:09.402 INFO [stdout] 
Nov 18 16:22:09.402 INFO [stdout] running 14 tests
Nov 18 16:22:09.403 INFO [stdout] test delay_queue::tests::entry_comparisons ... ok
Nov 18 16:22:09.404 INFO [stdout] test delay_queue::tests::is_empty ... ok
Nov 18 16:22:09.411 INFO [stdout] test delay_queue::tests::try_pop_for_zero_duration ... ok
Nov 18 16:22:09.427 INFO [stdout] test delay_queue::tests::push_higher_priority_while_waiting_to_try_pop ... ok
Nov 18 16:22:09.431 INFO [stdout] test delay_queue::tests::try_pop_until_now ... ok
Nov 18 16:22:09.431 INFO [stdout] test delayed::tests::compare_until ... ok
Nov 18 16:22:09.431 INFO [stdout] test delayed::tests::correct_value ... ok
Nov 18 16:22:09.447 INFO [stdout] test delay_queue::tests::push_pop_single_thread ... ok
Nov 18 16:22:09.447 INFO [stdout] test delay_queue::tests::push_pop_different_thread ... ok
Nov 18 16:22:09.504 INFO [stdout] test delay_queue::tests::push_higher_priority_while_waiting_to_pop ... ok
Nov 18 16:22:09.521 INFO [stdout] test delay_queue::tests::pop_before_push ... ok
Nov 18 16:22:09.521 INFO [stdout] test delay_queue::tests::try_pop_for ... ok
Nov 18 16:22:09.525 INFO [stdout] test delay_queue::tests::try_pop_until ... ok
Nov 18 16:22:09.541 INFO [stdout] test delay_queue::tests::pop_two_before_push ... ok
Nov 18 16:22:09.541 INFO [stdout] 
Nov 18 16:22:09.542 INFO [stdout] test result: ok. 14 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 16:22:09.542 INFO [stdout] 
Nov 18 16:22:09.543 INFO [stderr]    Doc-tests delay-queue
Nov 18 16:22:10.298 INFO [stdout] 
Nov 18 16:22:10.298 INFO [stdout] running 12 tests
Nov 18 16:22:13.142 INFO [stdout] test src/delay_queue.rs - delay_queue::DelayQueue<T>::try_pop_for (line 199) ... ok
Nov 18 16:22:13.333 INFO [stdout] test src/delay_queue.rs - delay_queue::DelayQueue<T>::try_pop_until (line 228) ... ok
Nov 18 16:22:13.563 INFO [stdout] test src/delay_queue.rs - delay_queue::DelayQueue (line 23) ... ok
Nov 18 16:22:13.575 INFO [stdout] test src/delay_queue.rs - delay_queue::DelayQueue<T>::clone (line 346) ... ok
Nov 18 16:22:14.251 INFO [stdout] test src/delay_queue.rs - delay_queue::DelayQueue<T>::is_empty (line 297) ... ok
Nov 18 16:22:14.367 INFO [stdout] test src/delay_queue.rs - delay_queue::DelayQueue<T>::pop (line 137) ... ok
Nov 18 16:22:14.824 INFO [stdout] test src/delay_queue.rs - delay_queue::DelayQueue<T>::new (line 64) ... ok
Nov 18 16:22:15.943 INFO [stdout] test src/delay_queue.rs - delay_queue::DelayQueue<T>::push (line 107) ... ok
Nov 18 16:22:16.915 INFO [stdout] test src/delay_queue.rs - delay_queue::DelayQueue<T>::with_capacity (line 87) ... ok
Nov 18 16:22:16.999 INFO [stdout] test src/delayed.rs - delayed::Delay<T>::until_instant (line 48) ... ok
Nov 18 16:22:17.207 INFO [stdout] test src/delayed.rs - delayed::Delay<T>::for_duration (line 65) ... ok
Nov 18 16:22:17.495 INFO [stdout] test src/delayed.rs - delayed::Delay (line 22) ... ok
Nov 18 16:22:17.495 INFO [stdout] 
Nov 18 16:22:17.495 INFO [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 16:22:17.496 INFO [stdout] 
Nov 18 16:22:17.546 INFO [stderr] su: No module specific data is present
Nov 18 16:22:17.885 INFO running `"docker" "inspect" "08c821d0af6b628757d0e5d775d5a8d2c76082c661d0874174bc22af383a1e0e"`
Nov 18 16:22:18.079 INFO running `"docker" "rm" "-f" "08c821d0af6b628757d0e5d775d5a8d2c76082c661d0874174bc22af383a1e0e"`
Nov 18 16:22:18.301 INFO [stdout] 08c821d0af6b628757d0e5d775d5a8d2c76082c661d0874174bc22af383a1e0e