Dec 13 22:49:21.047 INFO testing csperkins/orchard against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 13 22:49:21.048 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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"`
Dec 13 22:49:21.289 INFO [stdout] f13966748847e82a25311b2cf4a4dc8beb727f8023c93188faea65cf41cf8f34
Dec 13 22:49:21.295 INFO running `"docker" "start" "-a" "f13966748847e82a25311b2cf4a4dc8beb727f8023c93188faea65cf41cf8f34"`
Dec 13 22:49:21.855 INFO [stderr] usermod: no changes
Dec 13 22:49:22.026 INFO [stderr]    Compiling memchr v1.0.1
Dec 13 22:49:22.035 INFO [stderr]    Compiling unix_socket v0.5.0
Dec 13 22:49:22.035 INFO [stderr]    Compiling toml v0.4.5
Dec 13 22:49:22.679 INFO [stderr]    Compiling nom v3.2.0
Dec 13 22:49:23.655 INFO [stderr]    Compiling syslog v3.2.0
Dec 13 22:49:27.732 INFO [stderr]    Compiling config v0.6.0
Dec 13 22:49:30.031 INFO [stderr]    Compiling orchard v0.1.0 (/source)
Dec 13 22:49:31.255 INFO [stderr] warning: variant is never constructed: `NatReply`
Dec 13 22:49:31.255 INFO [stderr]   --> src/message.rs:73:5
Dec 13 22:49:31.255 INFO [stderr]    |
Dec 13 22:49:31.255 INFO [stderr] 73 | /     NatReply {
Dec 13 22:49:31.255 INFO [stderr] 74 | |         send_addr : IpAddr,
Dec 13 22:49:31.255 INFO [stderr] 75 | |         send_port : u16,
Dec 13 22:49:31.255 INFO [stderr] 76 | |         recv_addr : IpAddr,
Dec 13 22:49:31.255 INFO [stderr] 77 | |         recv_port : u16,
Dec 13 22:49:31.255 INFO [stderr] 78 | |     }
Dec 13 22:49:31.255 INFO [stderr]    | |_____^
Dec 13 22:49:31.255 INFO [stderr]    |
Dec 13 22:49:31.255 INFO [stderr]    = note: #[warn(dead_code)] on by default
Dec 13 22:49:31.255 INFO [stderr] 
Dec 13 22:49:31.255 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 13 22:49:31.255 INFO [stderr]   --> src/main.rs:60:5
Dec 13 22:49:31.255 INFO [stderr]    |
Dec 13 22:49:31.255 INFO [stderr] 60 |     socket.send_to(&msg.encode(), &dest);
Dec 13 22:49:31.255 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 22:49:31.255 INFO [stderr]    |
Dec 13 22:49:31.256 INFO [stderr]    = note: #[warn(unused_must_use)] on by default
Dec 13 22:49:31.256 INFO [stderr]    = note: this `Result` may be an `Err` variant, which should be handled
Dec 13 22:49:31.299 INFO [stderr] 
Dec 13 22:49:31.299 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 13 22:49:31.299 INFO [stderr]   --> src/main.rs:85:5
Dec 13 22:49:31.299 INFO [stderr]    |
Dec 13 22:49:31.299 INFO [stderr] 85 |     syslog.send(Severity::LOG_NOTICE, "orchard: starting");
Dec 13 22:49:31.299 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 22:49:31.299 INFO [stderr]    |
Dec 13 22:49:31.299 INFO [stderr]    = note: this `Result` may be an `Err` variant, which should be handled
Dec 13 22:49:31.299 INFO [stderr] 
Dec 13 22:49:31.299 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 13 22:49:31.299 INFO [stderr]    --> src/main.rs:108:17
Dec 13 22:49:31.299 INFO [stderr]     |
Dec 13 22:49:31.299 INFO [stderr] 108 |                 syslog.send(Severity::LOG_NOTICE, "orchard: timeout");
Dec 13 22:49:31.299 INFO [stderr]     |                 ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 22:49:31.299 INFO [stderr]     |
Dec 13 22:49:31.299 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Dec 13 22:49:31.299 INFO [stderr] 
Dec 13 22:49:31.299 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 13 22:49:31.299 INFO [stderr]    --> src/main.rs:118:29
Dec 13 22:49:31.299 INFO [stderr]     |
Dec 13 22:49:31.299 INFO [stderr] 118 |                             syslog.send(Severity::LOG_NOTICE, "orchard: got socket event");
Dec 13 22:49:31.299 INFO [stderr]     |                             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 22:49:31.299 INFO [stderr]     |
Dec 13 22:49:31.299 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Dec 13 22:49:31.299 INFO [stderr] 
Dec 13 22:49:31.299 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 13 22:49:31.299 INFO [stderr]    --> src/main.rs:122:29
Dec 13 22:49:31.299 INFO [stderr]     |
Dec 13 22:49:31.299 INFO [stderr] 122 |                             syslog.send(Severity::LOG_NOTICE, &format!("orchard: {:?}", res));
Dec 13 22:49:31.299 INFO [stderr]     |                             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 22:49:31.299 INFO [stderr]     |
Dec 13 22:49:31.299 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Dec 13 22:49:31.299 INFO [stderr] 
Dec 13 22:49:31.299 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 13 22:49:31.299 INFO [stderr]    --> src/main.rs:125:29
Dec 13 22:49:31.299 INFO [stderr]     |
Dec 13 22:49:31.299 INFO [stderr] 125 |                             syslog.send(Severity::LOG_NOTICE, "orchard: unexpected event token");
Dec 13 22:49:31.299 INFO [stderr]     |                             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 22:49:31.299 INFO [stderr]     |
Dec 13 22:49:31.299 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Dec 13 22:49:31.299 INFO [stderr] 
Dec 13 22:49:32.570 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 10.69s
Dec 13 22:49:32.578 INFO [stderr] su: No module specific data is present
Dec 13 22:49:32.838 INFO running `"docker" "inspect" "f13966748847e82a25311b2cf4a4dc8beb727f8023c93188faea65cf41cf8f34"`
Dec 13 22:49:32.910 INFO running `"docker" "rm" "-f" "f13966748847e82a25311b2cf4a4dc8beb727f8023c93188faea65cf41cf8f34"`
Dec 13 22:49:33.008 INFO [stdout] f13966748847e82a25311b2cf4a4dc8beb727f8023c93188faea65cf41cf8f34
Dec 13 22:49:33.012 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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"`
Dec 13 22:49:33.187 INFO [stdout] 0f4e6ec7caf66b3fd05c66bd3227da12e64863f79f077bb87c07171197c3b1a6
Dec 13 22:49:33.189 INFO running `"docker" "start" "-a" "0f4e6ec7caf66b3fd05c66bd3227da12e64863f79f077bb87c07171197c3b1a6"`
Dec 13 22:49:33.822 INFO [stderr] usermod: no changes
Dec 13 22:49:33.900 INFO [stderr]    Compiling orchard v0.1.0 (/source)
Dec 13 22:49:35.007 INFO [stderr] warning: variant is never constructed: `NatReply`
Dec 13 22:49:35.007 INFO [stderr]   --> src/message.rs:73:5
Dec 13 22:49:35.007 INFO [stderr]    |
Dec 13 22:49:35.007 INFO [stderr] 73 | /     NatReply {
Dec 13 22:49:35.007 INFO [stderr] 74 | |         send_addr : IpAddr,
Dec 13 22:49:35.007 INFO [stderr] 75 | |         send_port : u16,
Dec 13 22:49:35.007 INFO [stderr] 76 | |         recv_addr : IpAddr,
Dec 13 22:49:35.007 INFO [stderr] 77 | |         recv_port : u16,
Dec 13 22:49:35.007 INFO [stderr] 78 | |     }
Dec 13 22:49:35.007 INFO [stderr]    | |_____^
Dec 13 22:49:35.007 INFO [stderr]    |
Dec 13 22:49:35.007 INFO [stderr]    = note: #[warn(dead_code)] on by default
Dec 13 22:49:35.007 INFO [stderr] 
Dec 13 22:49:35.007 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 13 22:49:35.007 INFO [stderr]   --> src/main.rs:60:5
Dec 13 22:49:35.007 INFO [stderr]    |
Dec 13 22:49:35.007 INFO [stderr] 60 |     socket.send_to(&msg.encode(), &dest);
Dec 13 22:49:35.007 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 22:49:35.007 INFO [stderr]    |
Dec 13 22:49:35.007 INFO [stderr]    = note: #[warn(unused_must_use)] on by default
Dec 13 22:49:35.007 INFO [stderr]    = note: this `Result` may be an `Err` variant, which should be handled
Dec 13 22:49:35.007 INFO [stderr] 
Dec 13 22:49:35.007 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 13 22:49:35.007 INFO [stderr]   --> src/main.rs:85:5
Dec 13 22:49:35.007 INFO [stderr]    |
Dec 13 22:49:35.007 INFO [stderr] 85 |     syslog.send(Severity::LOG_NOTICE, "orchard: starting");
Dec 13 22:49:35.007 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 22:49:35.007 INFO [stderr]    |
Dec 13 22:49:35.007 INFO [stderr]    = note: this `Result` may be an `Err` variant, which should be handled
Dec 13 22:49:35.007 INFO [stderr] 
Dec 13 22:49:35.007 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 13 22:49:35.007 INFO [stderr]    --> src/main.rs:108:17
Dec 13 22:49:35.007 INFO [stderr]     |
Dec 13 22:49:35.007 INFO [stderr] 108 |                 syslog.send(Severity::LOG_NOTICE, "orchard: timeout");
Dec 13 22:49:35.007 INFO [stderr]     |                 ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 22:49:35.007 INFO [stderr]     |
Dec 13 22:49:35.007 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Dec 13 22:49:35.007 INFO [stderr] 
Dec 13 22:49:35.015 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 13 22:49:35.015 INFO [stderr]    --> src/main.rs:118:29
Dec 13 22:49:35.015 INFO [stderr]     |
Dec 13 22:49:35.015 INFO [stderr] 118 |                             syslog.send(Severity::LOG_NOTICE, "orchard: got socket event");
Dec 13 22:49:35.015 INFO [stderr]     |                             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 22:49:35.015 INFO [stderr]     |
Dec 13 22:49:35.015 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Dec 13 22:49:35.015 INFO [stderr] 
Dec 13 22:49:35.015 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 13 22:49:35.015 INFO [stderr]    --> src/main.rs:122:29
Dec 13 22:49:35.015 INFO [stderr]     |
Dec 13 22:49:35.015 INFO [stderr] 122 |                             syslog.send(Severity::LOG_NOTICE, &format!("orchard: {:?}", res));
Dec 13 22:49:35.015 INFO [stderr]     |                             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 22:49:35.015 INFO [stderr]     |
Dec 13 22:49:35.015 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Dec 13 22:49:35.015 INFO [stderr] 
Dec 13 22:49:35.015 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 13 22:49:35.015 INFO [stderr]    --> src/main.rs:125:29
Dec 13 22:49:35.015 INFO [stderr]     |
Dec 13 22:49:35.015 INFO [stderr] 125 |                             syslog.send(Severity::LOG_NOTICE, "orchard: unexpected event token");
Dec 13 22:49:35.015 INFO [stderr]     |                             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 22:49:35.015 INFO [stderr]     |
Dec 13 22:49:35.015 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Dec 13 22:49:35.015 INFO [stderr] 
Dec 13 22:49:35.232 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.39s
Dec 13 22:49:35.239 INFO [stderr] su: No module specific data is present
Dec 13 22:49:35.508 INFO running `"docker" "inspect" "0f4e6ec7caf66b3fd05c66bd3227da12e64863f79f077bb87c07171197c3b1a6"`
Dec 13 22:49:35.604 INFO running `"docker" "rm" "-f" "0f4e6ec7caf66b3fd05c66bd3227da12e64863f79f077bb87c07171197c3b1a6"`
Dec 13 22:49:35.690 INFO [stdout] 0f4e6ec7caf66b3fd05c66bd3227da12e64863f79f077bb87c07171197c3b1a6
Dec 13 22:49:35.692 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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"`
Dec 13 22:49:35.876 INFO [stdout] 5f941ad8f04ea0c2676f88deb13e82d22c98140e9b0765e09265d94847fd233b
Dec 13 22:49:35.880 INFO running `"docker" "start" "-a" "5f941ad8f04ea0c2676f88deb13e82d22c98140e9b0765e09265d94847fd233b"`
Dec 13 22:49:36.305 INFO [stderr] usermod: no changes
Dec 13 22:49:36.379 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.05s
Dec 13 22:49:36.383 INFO [stderr]      Running /target/debug/deps/orchard-d101de551d090f98
Dec 13 22:49:36.390 INFO [stdout] 
Dec 13 22:49:36.390 INFO [stdout] running 0 tests
Dec 13 22:49:36.390 INFO [stdout] 
Dec 13 22:49:36.390 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 22:49:36.390 INFO [stdout] 
Dec 13 22:49:36.394 INFO [stderr] su: No module specific data is present
Dec 13 22:49:36.613 INFO running `"docker" "inspect" "5f941ad8f04ea0c2676f88deb13e82d22c98140e9b0765e09265d94847fd233b"`
Dec 13 22:49:36.728 INFO running `"docker" "rm" "-f" "5f941ad8f04ea0c2676f88deb13e82d22c98140e9b0765e09265d94847fd233b"`
Dec 13 22:49:36.810 INFO [stdout] 5f941ad8f04ea0c2676f88deb13e82d22c98140e9b0765e09265d94847fd233b