Nov 18 16:22:00.877 INFO testing delay-queue-0.2.0 against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 18 16:22:00.878 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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.189 INFO [stdout] cb0fa7713ce11841c7ffe98587c4325ab84ba2b198c89682f85795f06f6c305d
Nov 18 16:22:01.189 INFO running `"docker" "start" "-a" "cb0fa7713ce11841c7ffe98587c4325ab84ba2b198c89682f85795f06f6c305d"`
Nov 18 16:22:02.091 INFO [stderr] usermod: no changes
Nov 18 16:22:02.126 INFO [stderr]    Compiling delay-queue v0.2.0 (/source)
Nov 18 16:22:02.635 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.53s
Nov 18 16:22:02.639 INFO [stderr] su: No module specific data is present
Nov 18 16:22:02.952 INFO running `"docker" "inspect" "cb0fa7713ce11841c7ffe98587c4325ab84ba2b198c89682f85795f06f6c305d"`
Nov 18 16:22:03.111 INFO running `"docker" "rm" "-f" "cb0fa7713ce11841c7ffe98587c4325ab84ba2b198c89682f85795f06f6c305d"`
Nov 18 16:22:03.244 INFO [stdout] cb0fa7713ce11841c7ffe98587c4325ab84ba2b198c89682f85795f06f6c305d
Nov 18 16:22:03.249 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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.459 INFO [stdout] 8fba1ced8567badac209406e1289013e7227a280e0b178c4d572df2d0ebe79c5
Nov 18 16:22:03.461 INFO running `"docker" "start" "-a" "8fba1ced8567badac209406e1289013e7227a280e0b178c4d572df2d0ebe79c5"`
Nov 18 16:22:04.056 INFO [stderr] usermod: no changes
Nov 18 16:22:04.104 INFO [stderr]    Compiling pulse v0.5.3
Nov 18 16:22:05.133 INFO [stderr]    Compiling timebomb v0.1.2
Nov 18 16:22:05.791 INFO [stderr]    Compiling delay-queue v0.2.0 (/source)
Nov 18 16:22:08.055 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.98s
Nov 18 16:22:08.059 INFO [stderr] su: No module specific data is present
Nov 18 16:22:08.313 INFO running `"docker" "inspect" "8fba1ced8567badac209406e1289013e7227a280e0b178c4d572df2d0ebe79c5"`
Nov 18 16:22:08.461 INFO running `"docker" "rm" "-f" "8fba1ced8567badac209406e1289013e7227a280e0b178c4d572df2d0ebe79c5"`
Nov 18 16:22:08.647 INFO [stdout] 8fba1ced8567badac209406e1289013e7227a280e0b178c4d572df2d0ebe79c5
Nov 18 16:22:08.652 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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.815 INFO [stdout] 8043df5cd40c5f11a6fce6edbeab17dd2636a090fbc60c0cc8d80332e0388a0a
Nov 18 16:22:08.816 INFO running `"docker" "start" "-a" "8043df5cd40c5f11a6fce6edbeab17dd2636a090fbc60c0cc8d80332e0388a0a"`
Nov 18 16:22:09.263 INFO [stderr] usermod: no changes
Nov 18 16:22:09.311 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.02s
Nov 18 16:22:09.324 INFO [stderr]      Running /target/debug/deps/delay_queue-61039a0607391ce7
Nov 18 16:22:09.328 INFO [stdout] 
Nov 18 16:22:09.328 INFO [stdout] running 14 tests
Nov 18 16:22:09.329 INFO [stdout] test delay_queue::tests::entry_comparisons ... ok
Nov 18 16:22:09.332 INFO [stdout] test delay_queue::tests::is_empty ... ok
Nov 18 16:22:09.335 INFO [stdout] test delay_queue::tests::try_pop_for_zero_duration ... ok
Nov 18 16:22:09.353 INFO [stdout] test delay_queue::tests::push_higher_priority_while_waiting_to_try_pop ... ok
Nov 18 16:22:09.364 INFO [stdout] test delay_queue::tests::try_pop_until_now ... ok
Nov 18 16:22:09.364 INFO [stdout] test delayed::tests::compare_until ... ok
Nov 18 16:22:09.364 INFO [stdout] test delayed::tests::correct_value ... ok
Nov 18 16:22:09.376 INFO [stdout] test delay_queue::tests::push_pop_different_thread ... ok
Nov 18 16:22:09.387 INFO [stdout] test delay_queue::tests::push_pop_single_thread ... ok
Nov 18 16:22:09.435 INFO [stdout] test delay_queue::tests::push_higher_priority_while_waiting_to_pop ... ok
Nov 18 16:22:09.440 INFO [stdout] test delay_queue::tests::try_pop_for ... ok
Nov 18 16:22:09.443 INFO [stdout] test delay_queue::tests::pop_before_push ... ok
Nov 18 16:22:09.445 INFO [stdout] test delay_queue::tests::try_pop_until ... ok
Nov 18 16:22:09.462 INFO [stdout] test delay_queue::tests::pop_two_before_push ... ok
Nov 18 16:22:09.462 INFO [stdout] 
Nov 18 16:22:09.462 INFO [stdout] test result: ok. 14 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 16:22:09.462 INFO [stdout] 
Nov 18 16:22:09.462 INFO [stderr]    Doc-tests delay-queue
Nov 18 16:22:10.206 INFO [stdout] 
Nov 18 16:22:10.206 INFO [stdout] running 12 tests
Nov 18 16:22:13.367 INFO [stdout] test src/delay_queue.rs - delay_queue::DelayQueue<T>::new (line 64) ... ok
Nov 18 16:22:13.587 INFO [stdout] test src/delay_queue.rs - delay_queue::DelayQueue<T>::try_pop_for (line 199) ... ok
Nov 18 16:22:13.999 INFO [stdout] test src/delay_queue.rs - delay_queue::DelayQueue (line 23) ... ok
Nov 18 16:22:14.076 INFO [stdout] test src/delay_queue.rs - delay_queue::DelayQueue<T>::try_pop_until (line 228) ... ok
Nov 18 16:22:14.299 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>::clone (line 346) ... ok
Nov 18 16:22:14.935 INFO [stdout] test src/delay_queue.rs - delay_queue::DelayQueue<T>::pop (line 137) ... ok
Nov 18 16:22:15.867 INFO [stdout] test src/delay_queue.rs - delay_queue::DelayQueue<T>::push (line 107) ... ok
Nov 18 16:22:17.099 INFO [stdout] test src/delayed.rs - delayed::Delay<T>::until_instant (line 48) ... ok
Nov 18 16:22:17.228 INFO [stdout] test src/delay_queue.rs - delay_queue::DelayQueue<T>::with_capacity (line 87) ... ok
Nov 18 16:22:17.455 INFO [stdout] test src/delayed.rs - delayed::Delay<T>::for_duration (line 65) ... ok
Nov 18 16:22:17.595 INFO [stdout] test src/delayed.rs - delayed::Delay (line 22) ... ok
Nov 18 16:22:17.595 INFO [stdout] 
Nov 18 16:22:17.595 INFO [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 16:22:17.595 INFO [stdout] 
Nov 18 16:22:17.616 INFO [stderr] su: No module specific data is present
Nov 18 16:22:17.961 INFO running `"docker" "inspect" "8043df5cd40c5f11a6fce6edbeab17dd2636a090fbc60c0cc8d80332e0388a0a"`
Nov 18 16:22:18.201 INFO running `"docker" "rm" "-f" "8043df5cd40c5f11a6fce6edbeab17dd2636a090fbc60c0cc8d80332e0388a0a"`
Nov 18 16:22:18.338 INFO [stdout] 8043df5cd40c5f11a6fce6edbeab17dd2636a090fbc60c0cc8d80332e0388a0a