Nov 18 19:10:26.308 INFO testing build-plan-0.1.1 against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 18 19:10:26.308 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 19:10:26.471 INFO [stdout] 6511c72c8eebff95dd079dcf60c0b9c99b5cecd1b553043d17657fbba7d11fe3
Nov 18 19:10:26.473 INFO running `"docker" "start" "-a" "6511c72c8eebff95dd079dcf60c0b9c99b5cecd1b553043d17657fbba7d11fe3"`
Nov 18 19:10:26.807 INFO [stderr] usermod: no changes
Nov 18 19:10:26.864 INFO [stderr]    Compiling build-plan v0.1.1 (/source)
Nov 18 19:10:28.093 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.27s
Nov 18 19:10:28.098 INFO [stderr] su: No module specific data is present
Nov 18 19:10:28.395 INFO running `"docker" "inspect" "6511c72c8eebff95dd079dcf60c0b9c99b5cecd1b553043d17657fbba7d11fe3"`
Nov 18 19:10:28.480 INFO running `"docker" "rm" "-f" "6511c72c8eebff95dd079dcf60c0b9c99b5cecd1b553043d17657fbba7d11fe3"`
Nov 18 19:10:28.564 INFO [stdout] 6511c72c8eebff95dd079dcf60c0b9c99b5cecd1b553043d17657fbba7d11fe3
Nov 18 19:10:28.566 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 19:10:28.748 INFO [stdout] 6082ea394c6a6d28088ea3a18916d0ec0c723fc532b53cacce34f2549bdb65ce
Nov 18 19:10:28.750 INFO running `"docker" "start" "-a" "6082ea394c6a6d28088ea3a18916d0ec0c723fc532b53cacce34f2549bdb65ce"`
Nov 18 19:10:29.105 INFO [stderr] usermod: no changes
Nov 18 19:10:29.157 INFO [stderr]    Compiling build-plan v0.1.1 (/source)
Nov 18 19:10:32.585 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.46s
Nov 18 19:10:32.589 INFO [stderr] su: No module specific data is present
Nov 18 19:10:33.236 INFO running `"docker" "inspect" "6082ea394c6a6d28088ea3a18916d0ec0c723fc532b53cacce34f2549bdb65ce"`
Nov 18 19:10:33.437 INFO running `"docker" "rm" "-f" "6082ea394c6a6d28088ea3a18916d0ec0c723fc532b53cacce34f2549bdb65ce"`
Nov 18 19:10:33.651 INFO [stdout] 6082ea394c6a6d28088ea3a18916d0ec0c723fc532b53cacce34f2549bdb65ce
Nov 18 19:10:33.658 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 19:10:33.952 INFO [stdout] ff618365c330ed9ed56ed174fdb742baa7ada01f3a91dfadc02788c39a8fe532
Nov 18 19:10:33.954 INFO running `"docker" "start" "-a" "ff618365c330ed9ed56ed174fdb742baa7ada01f3a91dfadc02788c39a8fe532"`
Nov 18 19:10:35.112 INFO [stderr] usermod: no changes
Nov 18 19:10:35.213 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.06s
Nov 18 19:10:35.227 INFO [stderr]      Running /target/debug/deps/build_plan-25b1a0d77ba3dfaf
Nov 18 19:10:35.227 INFO [stdout] 
Nov 18 19:10:35.228 INFO [stdout] running 0 tests
Nov 18 19:10:35.228 INFO [stdout] 
Nov 18 19:10:35.228 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 19:10:35.228 INFO [stdout] 
Nov 18 19:10:35.235 INFO [stderr]      Running /target/debug/deps/integration-f7d9142ab026fb9a
Nov 18 19:10:35.238 INFO [stdout] 
Nov 18 19:10:35.238 INFO [stdout] running 1 test
Nov 18 19:10:35.383 INFO [stdout] test reflect ... ok
Nov 18 19:10:35.383 INFO [stderr]    Doc-tests build-plan
Nov 18 19:10:35.383 INFO [stdout] 
Nov 18 19:10:35.383 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 19:10:35.383 INFO [stdout] 
Nov 18 19:10:36.563 INFO [stdout] 
Nov 18 19:10:36.563 INFO [stdout] running 0 tests
Nov 18 19:10:36.563 INFO [stdout] 
Nov 18 19:10:36.563 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 19:10:36.563 INFO [stdout] 
Nov 18 19:10:36.575 INFO [stderr] su: No module specific data is present
Nov 18 19:10:37.651 INFO running `"docker" "inspect" "ff618365c330ed9ed56ed174fdb742baa7ada01f3a91dfadc02788c39a8fe532"`
Nov 18 19:10:38.011 INFO running `"docker" "rm" "-f" "ff618365c330ed9ed56ed174fdb742baa7ada01f3a91dfadc02788c39a8fe532"`
Nov 18 19:10:38.283 INFO [stdout] ff618365c330ed9ed56ed174fdb742baa7ada01f3a91dfadc02788c39a8fe532