Nov 16 15:41:50.523 INFO testing rinon/icfp2017 against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 16 15:41:50.523 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-0/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/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 16 15:41:50.840 INFO [stdout] 12ded9e80196defc50bad7abe95e409e019673cefcc388e4ffaa413835274f5d
Nov 16 15:41:50.842 INFO running `"docker" "start" "-a" "12ded9e80196defc50bad7abe95e409e019673cefcc388e4ffaa413835274f5d"`
Nov 16 15:41:51.359 INFO [stderr] usermod: no changes
Nov 16 15:41:51.447 INFO [stderr]    Compiling serde_bytes v0.10.1
Nov 16 15:41:51.448 INFO [stderr]    Compiling bincode v0.8.0
Nov 16 15:41:51.455 INFO [stderr]    Compiling serde_derive v1.0.11
Nov 16 15:41:57.594 INFO [stderr]    Compiling punter v0.1.0 (/source)
Nov 16 15:41:59.275 INFO [stderr] warning: variable `iterations` is assigned to, but never used
Nov 16 15:41:59.275 INFO [stderr]    --> src/punter.rs:315:17
Nov 16 15:41:59.275 INFO [stderr]     |
Nov 16 15:41:59.275 INFO [stderr] 315 |         let mut iterations = 0;
Nov 16 15:41:59.275 INFO [stderr]     |                 ^^^^^^^^^^
Nov 16 15:41:59.275 INFO [stderr]     |
Nov 16 15:41:59.275 INFO [stderr]     = note: #[warn(unused_variables)] on by default
Nov 16 15:41:59.275 INFO [stderr]     = note: consider using `_iterations` instead
Nov 16 15:41:59.275 INFO [stderr] 
Nov 16 15:42:01.855 INFO [stderr] warning: unused variable: `handshake`
Nov 16 15:42:01.855 INFO [stderr]   --> src/bin/punter.rs:53:13
Nov 16 15:42:01.855 INFO [stderr]    |
Nov 16 15:42:01.855 INFO [stderr] 53 |         let handshake: protocol::HandshakeS = self.recv_message(reader)
Nov 16 15:42:01.855 INFO [stderr]    |             ^^^^^^^^^ help: consider using `_handshake` instead
Nov 16 15:42:01.855 INFO [stderr]    |
Nov 16 15:42:01.855 INFO [stderr]    = note: #[warn(unused_variables)] on by default
Nov 16 15:42:01.855 INFO [stderr] 
Nov 16 15:42:01.855 INFO [stderr] warning: unused variable: `stop`
Nov 16 15:42:01.855 INFO [stderr]    --> src/bin/punter.rs:104:40
Nov 16 15:42:01.855 INFO [stderr]     |
Nov 16 15:42:01.855 INFO [stderr] 104 |                 protocol::OfflineStop {stop, state}
Nov 16 15:42:01.855 INFO [stderr]     |                                        ^^^^ help: try ignoring the field: `stop: _`
Nov 16 15:42:01.855 INFO [stderr] 
Nov 16 15:42:01.855 INFO [stderr] warning: unused variable: `state`
Nov 16 15:42:01.855 INFO [stderr]    --> src/bin/punter.rs:104:46
Nov 16 15:42:01.855 INFO [stderr]     |
Nov 16 15:42:01.855 INFO [stderr] 104 |                 protocol::OfflineStop {stop, state}
Nov 16 15:42:01.855 INFO [stderr]     |                                              ^^^^^ help: try ignoring the field: `state: _`
Nov 16 15:42:01.855 INFO [stderr] 
Nov 16 15:42:06.937 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 15.56s
Nov 16 15:42:06.952 INFO [stderr] su: No module specific data is present
Nov 16 15:42:07.502 INFO running `"docker" "inspect" "12ded9e80196defc50bad7abe95e409e019673cefcc388e4ffaa413835274f5d"`
Nov 16 15:42:07.608 INFO running `"docker" "rm" "-f" "12ded9e80196defc50bad7abe95e409e019673cefcc388e4ffaa413835274f5d"`
Nov 16 15:42:07.762 INFO [stdout] 12ded9e80196defc50bad7abe95e409e019673cefcc388e4ffaa413835274f5d
Nov 16 15:42:07.764 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-0/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/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 16 15:42:08.075 INFO [stdout] 3fb52162af4a23e048102ede2dfba8d909d40a6a113ca19d5520adfeab6a2e7e
Nov 16 15:42:08.079 INFO running `"docker" "start" "-a" "3fb52162af4a23e048102ede2dfba8d909d40a6a113ca19d5520adfeab6a2e7e"`
Nov 16 15:42:08.534 INFO [stderr] usermod: no changes
Nov 16 15:42:08.607 INFO [stderr]    Compiling punter v0.1.0 (/source)
Nov 16 15:42:09.175 INFO [stderr] warning: unused variable: `handshake`
Nov 16 15:42:09.175 INFO [stderr]   --> src/bin/punter.rs:53:13
Nov 16 15:42:09.175 INFO [stderr]    |
Nov 16 15:42:09.175 INFO [stderr] 53 |         let handshake: protocol::HandshakeS = self.recv_message(reader)
Nov 16 15:42:09.175 INFO [stderr]    |             ^^^^^^^^^ help: consider using `_handshake` instead
Nov 16 15:42:09.175 INFO [stderr]    |
Nov 16 15:42:09.175 INFO [stderr]    = note: #[warn(unused_variables)] on by default
Nov 16 15:42:09.175 INFO [stderr] 
Nov 16 15:42:09.175 INFO [stderr] warning: unused variable: `stop`
Nov 16 15:42:09.175 INFO [stderr]    --> src/bin/punter.rs:104:40
Nov 16 15:42:09.175 INFO [stderr]     |
Nov 16 15:42:09.175 INFO [stderr] 104 |                 protocol::OfflineStop {stop, state}
Nov 16 15:42:09.175 INFO [stderr]     |                                        ^^^^ help: try ignoring the field: `stop: _`
Nov 16 15:42:09.175 INFO [stderr] 
Nov 16 15:42:09.175 INFO [stderr] warning: unused variable: `state`
Nov 16 15:42:09.175 INFO [stderr]    --> src/bin/punter.rs:104:46
Nov 16 15:42:09.175 INFO [stderr]     |
Nov 16 15:42:09.175 INFO [stderr] 104 |                 protocol::OfflineStop {stop, state}
Nov 16 15:42:09.175 INFO [stderr]     |                                              ^^^^^ help: try ignoring the field: `state: _`
Nov 16 15:42:09.175 INFO [stderr] 
Nov 16 15:42:10.265 INFO [stderr] warning: variable `iterations` is assigned to, but never used
Nov 16 15:42:10.265 INFO [stderr]    --> src/punter.rs:315:17
Nov 16 15:42:10.265 INFO [stderr]     |
Nov 16 15:42:10.265 INFO [stderr] 315 |         let mut iterations = 0;
Nov 16 15:42:10.265 INFO [stderr]     |                 ^^^^^^^^^^
Nov 16 15:42:10.265 INFO [stderr]     |
Nov 16 15:42:10.265 INFO [stderr]     = note: #[warn(unused_variables)] on by default
Nov 16 15:42:10.265 INFO [stderr]     = note: consider using `_iterations` instead
Nov 16 15:42:10.265 INFO [stderr] 
Nov 16 15:42:11.135 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.56s
Nov 16 15:42:11.135 INFO [stderr] su: No module specific data is present
Nov 16 15:42:12.279 INFO running `"docker" "inspect" "3fb52162af4a23e048102ede2dfba8d909d40a6a113ca19d5520adfeab6a2e7e"`
Nov 16 15:42:12.622 INFO running `"docker" "rm" "-f" "3fb52162af4a23e048102ede2dfba8d909d40a6a113ca19d5520adfeab6a2e7e"`
Nov 16 15:42:12.895 INFO [stdout] 3fb52162af4a23e048102ede2dfba8d909d40a6a113ca19d5520adfeab6a2e7e
Nov 16 15:42:12.903 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-0/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/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 16 15:42:13.367 INFO [stdout] 139e3ec85a6de9d3f55fd1f6d1b2c495bccf33848597563ffe662b2cd2db76d9
Nov 16 15:42:13.373 INFO running `"docker" "start" "-a" "139e3ec85a6de9d3f55fd1f6d1b2c495bccf33848597563ffe662b2cd2db76d9"`
Nov 16 15:42:14.551 INFO [stderr] usermod: no changes
Nov 16 15:42:14.651 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.05s
Nov 16 15:42:14.665 INFO [stderr]      Running /target/debug/deps/punter-90bf4a1aea3e286f
Nov 16 15:42:14.667 INFO [stdout] 
Nov 16 15:42:14.667 INFO [stdout] running 0 tests
Nov 16 15:42:14.667 INFO [stdout] 
Nov 16 15:42:14.668 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 15:42:14.668 INFO [stdout] 
Nov 16 15:42:14.675 INFO [stdout] 
Nov 16 15:42:14.675 INFO [stderr]      Running /target/debug/deps/dummy-0f0480b2dfc8f1f4
Nov 16 15:42:14.675 INFO [stdout] running 0 tests
Nov 16 15:42:14.675 INFO [stderr]      Running /target/debug/deps/online-30bbea34a80ccc06
Nov 16 15:42:14.675 INFO [stdout] 
Nov 16 15:42:14.675 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 15:42:14.675 INFO [stdout] 
Nov 16 15:42:14.679 INFO [stdout] 
Nov 16 15:42:14.679 INFO [stderr]      Running /target/debug/deps/punter-f808d55b6d5eb1b4
Nov 16 15:42:14.679 INFO [stdout] running 0 tests
Nov 16 15:42:14.679 INFO [stdout] 
Nov 16 15:42:14.679 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 15:42:14.679 INFO [stdout] 
Nov 16 15:42:14.687 INFO [stdout] 
Nov 16 15:42:14.687 INFO [stderr]    Doc-tests punter
Nov 16 15:42:14.687 INFO [stdout] running 0 tests
Nov 16 15:42:14.687 INFO [stdout] 
Nov 16 15:42:14.687 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 15:42:14.687 INFO [stdout] 
Nov 16 15:42:15.231 INFO [stdout] 
Nov 16 15:42:15.232 INFO [stdout] running 0 tests
Nov 16 15:42:15.238 INFO [stdout] 
Nov 16 15:42:15.239 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 15:42:15.239 INFO [stdout] 
Nov 16 15:42:15.242 INFO [stderr] su: No module specific data is present
Nov 16 15:42:15.727 INFO running `"docker" "inspect" "139e3ec85a6de9d3f55fd1f6d1b2c495bccf33848597563ffe662b2cd2db76d9"`
Nov 16 15:42:15.812 INFO running `"docker" "rm" "-f" "139e3ec85a6de9d3f55fd1f6d1b2c495bccf33848597563ffe662b2cd2db76d9"`
Nov 16 15:42:15.918 INFO [stdout] 139e3ec85a6de9d3f55fd1f6d1b2c495bccf33848597563ffe662b2cd2db76d9