Nov 18 18:54:39.447 INFO testing cancellation-0.1.0 against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 18 18:54:39.449 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 18:54:39.801 INFO [stdout] 610b9167e213c65c4821aead990d3240c882ba5bbf3a9363ca7d8ee66b63fa88
Nov 18 18:54:39.805 INFO running `"docker" "start" "-a" "610b9167e213c65c4821aead990d3240c882ba5bbf3a9363ca7d8ee66b63fa88"`
Nov 18 18:54:41.187 INFO [stderr] usermod: no changes
Nov 18 18:54:41.236 INFO [stderr]    Compiling cancellation v0.1.0 (/source)
Nov 18 18:54:42.240 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.02s
Nov 18 18:54:42.243 INFO [stderr] su: No module specific data is present
Nov 18 18:54:42.869 INFO running `"docker" "inspect" "610b9167e213c65c4821aead990d3240c882ba5bbf3a9363ca7d8ee66b63fa88"`
Nov 18 18:54:43.125 INFO running `"docker" "rm" "-f" "610b9167e213c65c4821aead990d3240c882ba5bbf3a9363ca7d8ee66b63fa88"`
Nov 18 18:54:43.384 INFO [stdout] 610b9167e213c65c4821aead990d3240c882ba5bbf3a9363ca7d8ee66b63fa88
Nov 18 18:54:43.392 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 18:54:43.911 INFO [stdout] 2471955069b0d16c6598e4768ea0086dc137eeae94e2a0ca910332b8e8b3c982
Nov 18 18:54:43.917 INFO running `"docker" "start" "-a" "2471955069b0d16c6598e4768ea0086dc137eeae94e2a0ca910332b8e8b3c982"`
Nov 18 18:54:44.991 INFO [stderr] usermod: no changes
Nov 18 18:54:45.061 INFO [stderr]    Compiling cancellation v0.1.0 (/source)
Nov 18 18:54:46.595 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.57s
Nov 18 18:54:46.595 INFO [stderr] su: No module specific data is present
Nov 18 18:54:47.685 INFO running `"docker" "inspect" "2471955069b0d16c6598e4768ea0086dc137eeae94e2a0ca910332b8e8b3c982"`
Nov 18 18:54:47.935 INFO running `"docker" "rm" "-f" "2471955069b0d16c6598e4768ea0086dc137eeae94e2a0ca910332b8e8b3c982"`
Nov 18 18:54:48.283 INFO [stdout] 2471955069b0d16c6598e4768ea0086dc137eeae94e2a0ca910332b8e8b3c982
Nov 18 18:54:48.290 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 18:54:48.763 INFO [stdout] 6f6363d9408163520167e3ac2812f2283afbe4a7e95e513f9294d37b6d45110e
Nov 18 18:54:48.767 INFO running `"docker" "start" "-a" "6f6363d9408163520167e3ac2812f2283afbe4a7e95e513f9294d37b6d45110e"`
Nov 18 18:54:49.742 INFO [stderr] usermod: no changes
Nov 18 18:54:49.811 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.05s
Nov 18 18:54:49.812 INFO [stderr]      Running /target/debug/deps/cancellation-659279e86c6f3b8f
Nov 18 18:54:49.816 INFO [stdout] 
Nov 18 18:54:49.816 INFO [stdout] running 7 tests
Nov 18 18:54:49.816 INFO [stdout] test test::cancel ... ok
Nov 18 18:54:49.816 INFO [stdout] test test::cancel_in_recursive_run ... ok
Nov 18 18:54:49.816 INFO [stdout] test test::run_already_canceled ... ok
Nov 18 18:54:49.816 INFO [stdout] test test::recursive_run_already_canceled ... ok
Nov 18 18:54:49.816 INFO [stdout] test test::on_cancel_is_not_called_after_end_of_run ... ok
Nov 18 18:54:49.816 INFO [stdout] test test::none_not_canceled ... ok
Nov 18 18:54:49.818 INFO [stdout] test test::none_run ... ok
Nov 18 18:54:49.818 INFO [stdout] 
Nov 18 18:54:49.818 INFO [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 18:54:49.818 INFO [stdout] 
Nov 18 18:54:49.820 INFO [stderr]    Doc-tests cancellation
Nov 18 18:54:50.943 INFO [stdout] 
Nov 18 18:54:50.943 INFO [stdout] running 2 tests
Nov 18 18:54:53.307 INFO [stdout] test lib.rs -  (line 58) ... ok
Nov 18 18:54:55.215 INFO [stdout] test lib.rs -  (line 33) ... ok
Nov 18 18:54:55.215 INFO [stdout] 
Nov 18 18:54:55.216 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 18:54:55.216 INFO [stdout] 
Nov 18 18:54:55.221 INFO [stderr] su: No module specific data is present
Nov 18 18:54:55.931 INFO running `"docker" "inspect" "6f6363d9408163520167e3ac2812f2283afbe4a7e95e513f9294d37b6d45110e"`
Nov 18 18:54:56.335 INFO running `"docker" "rm" "-f" "6f6363d9408163520167e3ac2812f2283afbe4a7e95e513f9294d37b6d45110e"`
Nov 18 18:54:56.587 INFO [stdout] 6f6363d9408163520167e3ac2812f2283afbe4a7e95e513f9294d37b6d45110e