Dec 05 14:54:01.510 INFO testing mcpherrinm/roughtime.rs against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 05 14:54:01.510 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 05 14:54:01.973 INFO [stdout] cc5c603b42498813686d6aefcac4718d27313514673459101de63e05a48d4517
Dec 05 14:54:01.975 INFO running `"docker" "start" "-a" "cc5c603b42498813686d6aefcac4718d27313514673459101de63e05a48d4517"`
Dec 05 14:54:03.565 INFO [stderr] usermod: no changes
Dec 05 14:54:03.696 INFO [stderr]    Compiling libc v0.2.16
Dec 05 14:54:03.696 INFO [stderr]    Compiling untrusted v0.3.1
Dec 05 14:54:04.864 INFO [stderr]    Compiling time v0.1.35
Dec 05 14:54:04.864 INFO [stderr]    Compiling rand v0.3.14
Dec 05 14:54:07.110 INFO [stderr]    Compiling roughtime v0.1.0 (/source)
Dec 05 14:54:07.496 INFO [stderr] warning: unused variable: `src`
Dec 05 14:54:07.496 INFO [stderr]    --> src/main.rs:237:15
Dec 05 14:54:07.496 INFO [stderr]     |
Dec 05 14:54:07.496 INFO [stderr] 237 |     let (amt, src) = socket.recv_from(&mut inb).unwrap();
Dec 05 14:54:07.496 INFO [stderr]     |               ^^^ help: consider using `_src` instead
Dec 05 14:54:07.496 INFO [stderr]     |
Dec 05 14:54:07.496 INFO [stderr]     = note: #[warn(unused_variables)] on by default
Dec 05 14:54:07.496 INFO [stderr] 
Dec 05 14:54:07.517 INFO [stderr] warning: variable does not need to be mutable
Dec 05 14:54:07.517 INFO [stderr]    --> src/main.rs:234:9
Dec 05 14:54:07.517 INFO [stderr]     |
Dec 05 14:54:07.517 INFO [stderr] 234 |     let mut socket = UdpSocket::bind("0.0.0.0:0").unwrap();
Dec 05 14:54:07.517 INFO [stderr]     |         ----^^^^^^
Dec 05 14:54:07.517 INFO [stderr]     |         |
Dec 05 14:54:07.517 INFO [stderr]     |         help: remove this `mut`
Dec 05 14:54:07.517 INFO [stderr]     |
Dec 05 14:54:07.517 INFO [stderr]     = note: #[warn(unused_mut)] on by default
Dec 05 14:54:07.517 INFO [stderr] 
Dec 05 14:54:07.519 INFO [stderr] warning: constant item is never used: `DELE`
Dec 05 14:54:07.519 INFO [stderr]    --> src/main.rs:157:5
Dec 05 14:54:07.519 INFO [stderr]     |
Dec 05 14:54:07.519 INFO [stderr] 157 |     pub const DELE: u32 = 0x454c4544;
Dec 05 14:54:07.519 INFO [stderr]     |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 05 14:54:07.519 INFO [stderr]     |
Dec 05 14:54:07.519 INFO [stderr]     = note: #[warn(dead_code)] on by default
Dec 05 14:54:07.519 INFO [stderr] 
Dec 05 14:54:07.519 INFO [stderr] warning: constant item is never used: `MINT`
Dec 05 14:54:07.519 INFO [stderr]    --> src/main.rs:158:5
Dec 05 14:54:07.519 INFO [stderr]     |
Dec 05 14:54:07.519 INFO [stderr] 158 |     pub const MINT: u32 = 0x544e494d;
Dec 05 14:54:07.519 INFO [stderr]     |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 05 14:54:07.519 INFO [stderr] 
Dec 05 14:54:07.519 INFO [stderr] warning: constant item is never used: `MAXT`
Dec 05 14:54:07.519 INFO [stderr]    --> src/main.rs:159:5
Dec 05 14:54:07.519 INFO [stderr]     |
Dec 05 14:54:07.519 INFO [stderr] 159 |     pub const MAXT: u32 = 0x5458414d;
Dec 05 14:54:07.519 INFO [stderr]     |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 05 14:54:07.519 INFO [stderr] 
Dec 05 14:54:07.519 INFO [stderr] warning: constant item is never used: `PUBK`
Dec 05 14:54:07.519 INFO [stderr]    --> src/main.rs:160:5
Dec 05 14:54:07.519 INFO [stderr]     |
Dec 05 14:54:07.519 INFO [stderr] 160 |     pub const PUBK: u32 = 0x4b425550;
Dec 05 14:54:07.519 INFO [stderr]     |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 05 14:54:07.519 INFO [stderr] 
Dec 05 14:54:07.524 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 05 14:54:07.524 INFO [stderr]    --> src/main.rs:235:5
Dec 05 14:54:07.524 INFO [stderr]     |
Dec 05 14:54:07.524 INFO [stderr] 235 |     socket.send_to(&new_req(), "roughtime.sandbox.google.com:2002");
Dec 05 14:54:07.524 INFO [stderr]     |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 05 14:54:07.524 INFO [stderr]     |
Dec 05 14:54:07.524 INFO [stderr]     = note: #[warn(unused_must_use)] on by default
Dec 05 14:54:07.524 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Dec 05 14:54:07.524 INFO [stderr] 
Dec 05 14:54:07.524 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 05 14:54:07.524 INFO [stderr]    --> src/main.rs:238:5
Dec 05 14:54:07.524 INFO [stderr]     |
Dec 05 14:54:07.524 INFO [stderr] 238 |     std::io::stderr().write(&inb[..amt]);
Dec 05 14:54:07.524 INFO [stderr]     |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 05 14:54:07.524 INFO [stderr]     |
Dec 05 14:54:07.524 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Dec 05 14:54:07.524 INFO [stderr] 
Dec 05 14:54:08.692 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 5.09s
Dec 05 14:54:08.696 INFO [stderr] su: No module specific data is present
Dec 05 14:54:09.972 INFO running `"docker" "inspect" "cc5c603b42498813686d6aefcac4718d27313514673459101de63e05a48d4517"`
Dec 05 14:54:10.262 INFO running `"docker" "rm" "-f" "cc5c603b42498813686d6aefcac4718d27313514673459101de63e05a48d4517"`
Dec 05 14:54:10.544 INFO [stdout] cc5c603b42498813686d6aefcac4718d27313514673459101de63e05a48d4517
Dec 05 14:54:10.552 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 05 14:54:10.954 INFO [stdout] 10104f1f9b9b966cf9f7aec3238c6bd564056b7e2a86e0e55938c7dba89fb61f
Dec 05 14:54:10.960 INFO running `"docker" "start" "-a" "10104f1f9b9b966cf9f7aec3238c6bd564056b7e2a86e0e55938c7dba89fb61f"`
Dec 05 14:54:12.204 INFO [stderr] usermod: no changes
Dec 05 14:54:12.265 INFO [stderr]    Compiling roughtime v0.1.0 (/source)
Dec 05 14:54:12.732 INFO [stderr] warning: unused variable: `src`
Dec 05 14:54:12.732 INFO [stderr]    --> src/main.rs:237:15
Dec 05 14:54:12.732 INFO [stderr]     |
Dec 05 14:54:12.732 INFO [stderr] 237 |     let (amt, src) = socket.recv_from(&mut inb).unwrap();
Dec 05 14:54:12.732 INFO [stderr]     |               ^^^ help: consider using `_src` instead
Dec 05 14:54:12.732 INFO [stderr]     |
Dec 05 14:54:12.732 INFO [stderr]     = note: #[warn(unused_variables)] on by default
Dec 05 14:54:12.732 INFO [stderr] 
Dec 05 14:54:12.756 INFO [stderr] warning: variable does not need to be mutable
Dec 05 14:54:12.756 INFO [stderr]    --> src/main.rs:234:9
Dec 05 14:54:12.756 INFO [stderr]     |
Dec 05 14:54:12.756 INFO [stderr] 234 |     let mut socket = UdpSocket::bind("0.0.0.0:0").unwrap();
Dec 05 14:54:12.756 INFO [stderr]     |         ----^^^^^^
Dec 05 14:54:12.756 INFO [stderr]     |         |
Dec 05 14:54:12.756 INFO [stderr]     |         help: remove this `mut`
Dec 05 14:54:12.756 INFO [stderr]     |
Dec 05 14:54:12.756 INFO [stderr]     = note: #[warn(unused_mut)] on by default
Dec 05 14:54:12.756 INFO [stderr] 
Dec 05 14:54:12.768 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 05 14:54:12.768 INFO [stderr]    --> src/main.rs:235:5
Dec 05 14:54:12.768 INFO [stderr]     |
Dec 05 14:54:12.768 INFO [stderr] 235 |     socket.send_to(&new_req(), "roughtime.sandbox.google.com:2002");
Dec 05 14:54:12.768 INFO [stderr]     |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 05 14:54:12.768 INFO [stderr]     |
Dec 05 14:54:12.768 INFO [stderr]     = note: #[warn(unused_must_use)] on by default
Dec 05 14:54:12.768 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Dec 05 14:54:12.768 INFO [stderr] 
Dec 05 14:54:12.768 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 05 14:54:12.768 INFO [stderr]    --> src/main.rs:238:5
Dec 05 14:54:12.768 INFO [stderr]     |
Dec 05 14:54:12.768 INFO [stderr] 238 |     std::io::stderr().write(&inb[..amt]);
Dec 05 14:54:12.768 INFO [stderr]     |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 05 14:54:12.768 INFO [stderr]     |
Dec 05 14:54:12.768 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Dec 05 14:54:12.768 INFO [stderr] 
Dec 05 14:54:13.744 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.51s
Dec 05 14:54:13.749 INFO [stderr] su: No module specific data is present
Dec 05 14:54:14.330 INFO running `"docker" "inspect" "10104f1f9b9b966cf9f7aec3238c6bd564056b7e2a86e0e55938c7dba89fb61f"`
Dec 05 14:54:14.668 INFO running `"docker" "rm" "-f" "10104f1f9b9b966cf9f7aec3238c6bd564056b7e2a86e0e55938c7dba89fb61f"`
Dec 05 14:54:15.063 INFO [stdout] 10104f1f9b9b966cf9f7aec3238c6bd564056b7e2a86e0e55938c7dba89fb61f
Dec 05 14:54:15.066 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 05 14:54:15.320 INFO [stdout] 830e90586f7b792a7bf973ffeb74aadd7049ddf63fc1a3a6d650749d9f43bab2
Dec 05 14:54:15.324 INFO running `"docker" "start" "-a" "830e90586f7b792a7bf973ffeb74aadd7049ddf63fc1a3a6d650749d9f43bab2"`
Dec 05 14:54:16.315 INFO [stderr] usermod: no changes
Dec 05 14:54:16.380 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.04s
Dec 05 14:54:16.388 INFO [stderr]      Running /target/debug/deps/roughtime-ce738ae788d8bdcd
Dec 05 14:54:16.400 INFO [stdout] 
Dec 05 14:54:16.400 INFO [stdout] running 3 tests
Dec 05 14:54:16.400 INFO [stdout] test test_append_u8 ... ok
Dec 05 14:54:16.404 INFO [stdout] test test_message_roundtrip ... ok
Dec 05 14:54:16.404 INFO [stderr] su: No module specific data is present
Dec 05 14:54:16.404 INFO [stdout] test test_tag ... ok
Dec 05 14:54:16.404 INFO [stdout] 
Dec 05 14:54:16.404 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 14:54:16.404 INFO [stdout] 
Dec 05 14:54:17.134 INFO running `"docker" "inspect" "830e90586f7b792a7bf973ffeb74aadd7049ddf63fc1a3a6d650749d9f43bab2"`
Dec 05 14:54:17.372 INFO running `"docker" "rm" "-f" "830e90586f7b792a7bf973ffeb74aadd7049ddf63fc1a3a6d650749d9f43bab2"`
Dec 05 14:54:17.656 INFO [stdout] 830e90586f7b792a7bf973ffeb74aadd7049ddf63fc1a3a6d650749d9f43bab2