Dec 06 10:27:12.121 INFO testing RCasatta/ots-aggregator against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 06 10:27:12.122 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-1/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 06 10:27:12.309 INFO [stdout] b6f73ceb7324d16704c86e2c6c1d6195117c1f71705d0cc0fc2a6bb991cb5558
Dec 06 10:27:12.314 INFO running `"docker" "start" "-a" "b6f73ceb7324d16704c86e2c6c1d6195117c1f71705d0cc0fc2a6bb991cb5558"`
Dec 06 10:27:12.697 INFO [stderr] usermod: no changes
Dec 06 10:27:12.840 INFO [stderr]    Compiling libc v0.2.38
Dec 06 10:27:12.840 INFO [stderr]    Compiling termcolor v0.3.5
Dec 06 10:27:13.939 INFO [stderr]    Compiling iovec v0.1.2
Dec 06 10:27:13.939 INFO [stderr]    Compiling net2 v0.2.32
Dec 06 10:27:13.940 INFO [stderr]    Compiling openssl-sys v0.9.31
Dec 06 10:27:13.941 INFO [stderr]    Compiling memchr v2.0.1
Dec 06 10:27:13.941 INFO [stderr]    Compiling rand v0.4.2
Dec 06 10:27:13.941 INFO [stderr]    Compiling num_cpus v1.8.0
Dec 06 10:27:13.942 INFO [stderr]    Compiling time v0.1.39
Dec 06 10:27:13.942 INFO [stderr]    Compiling atty v0.2.8
Dec 06 10:27:14.750 INFO [stderr]    Compiling clap v2.31.1
Dec 06 10:27:17.341 INFO [stderr]    Compiling bytes v0.4.6
Dec 06 10:27:17.341 INFO [stderr]    Compiling aho-corasick v0.6.4
Dec 06 10:27:17.356 INFO [stderr]    Compiling mio v0.6.13
Dec 06 10:27:17.368 INFO [stderr]    Compiling futures-cpupool v0.1.8
Dec 06 10:27:20.004 INFO [stderr]    Compiling openssl v0.9.24
Dec 06 10:27:21.443 INFO [stderr]    Compiling rand v0.3.22
Dec 06 10:27:21.633 INFO [stderr]    Compiling regex v0.2.10
Dec 06 10:27:22.284 INFO [stderr]    Compiling rust-crypto v0.2.36
Dec 06 10:27:22.688 INFO [stderr]    Compiling tokio-io v0.1.5
Dec 06 10:27:26.116 INFO [stderr]    Compiling tokio-core v0.1.12
Dec 06 10:27:26.116 INFO [stderr]    Compiling tokio v0.1.1
Dec 06 10:27:42.216 INFO [stderr]    Compiling tokio-proto v0.1.1
Dec 06 10:27:42.264 INFO [stderr]    Compiling env_logger v0.4.3
Dec 06 10:27:42.688 INFO [stderr]    Compiling env_logger v0.5.5
Dec 06 10:27:43.160 INFO [stderr]    Compiling native-tls v0.1.5
Dec 06 10:27:45.436 INFO [stderr]    Compiling tokio-tls v0.1.4
Dec 06 10:27:45.488 INFO [stderr]    Compiling opentimestamps v0.1.2
Dec 06 10:27:48.321 INFO [stderr]    Compiling hyper v0.11.22
Dec 06 10:27:57.241 INFO [stderr]    Compiling hyper-tls v0.1.3
Dec 06 10:27:58.687 INFO [stderr]    Compiling ots-aggregator v0.1.0 (/source)
Dec 06 10:28:00.208 INFO [stderr] warning: a method with this name may be added to the standard library in the future
Dec 06 10:28:00.208 INFO [stderr]   --> src/merkle.rs:29:50
Dec 06 10:28:00.208 INFO [stderr]    |
Dec 06 10:28:00.208 INFO [stderr] 29 |              digests_sha256.len(), now.elapsed().as_millis(), root);
Dec 06 10:28:00.208 INFO [stderr]    |                                                  ^^^^^^^^^
Dec 06 10:28:00.208 INFO [stderr]    |
Dec 06 10:28:00.208 INFO [stderr]    = note: #[warn(unstable_name_collisions)] on by default
Dec 06 10:28:00.208 INFO [stderr]    = warning: once this method is added to the standard library, the ambiguity may cause an error or change in behavior!
Dec 06 10:28:00.208 INFO [stderr]    = note: for more information, see issue #48919 <https://github.com/rust-lang/rust/issues/48919>
Dec 06 10:28:00.208 INFO [stderr]    = help: call with fully qualified syntax `Millis::as_millis(...)` to keep using the current method
Dec 06 10:28:00.208 INFO [stderr]    = help: add #![feature(duration_as_u128)] to the crate attributes to enable `std::time::Duration::as_millis`
Dec 06 10:28:00.208 INFO [stderr] 
Dec 06 10:28:00.224 INFO [stderr] warning: a method with this name may be added to the standard library in the future
Dec 06 10:28:00.224 INFO [stderr]   --> src/timer.rs:55:60
Dec 06 10:28:00.228 INFO [stderr]    |
Dec 06 10:28:00.228 INFO [stderr] 55 |                              res.status(), start.elapsed().as_millis());
Dec 06 10:28:00.228 INFO [stderr]    |                                                            ^^^^^^^^^
Dec 06 10:28:00.228 INFO [stderr]    |
Dec 06 10:28:00.228 INFO [stderr]    = warning: once this method is added to the standard library, the ambiguity may cause an error or change in behavior!
Dec 06 10:28:00.228 INFO [stderr]    = note: for more information, see issue #48919 <https://github.com/rust-lang/rust/issues/48919>
Dec 06 10:28:00.228 INFO [stderr]    = help: call with fully qualified syntax `Millis::as_millis(...)` to keep using the current method
Dec 06 10:28:00.228 INFO [stderr]    = help: add #![feature(duration_as_u128)] to the crate attributes to enable `std::time::Duration::as_millis`
Dec 06 10:28:00.228 INFO [stderr] 
Dec 06 10:28:09.525 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 56.81s
Dec 06 10:28:09.537 INFO [stderr] su: No module specific data is present
Dec 06 10:28:10.286 INFO running `"docker" "inspect" "b6f73ceb7324d16704c86e2c6c1d6195117c1f71705d0cc0fc2a6bb991cb5558"`
Dec 06 10:28:10.526 INFO running `"docker" "rm" "-f" "b6f73ceb7324d16704c86e2c6c1d6195117c1f71705d0cc0fc2a6bb991cb5558"`
Dec 06 10:28:10.801 INFO [stdout] b6f73ceb7324d16704c86e2c6c1d6195117c1f71705d0cc0fc2a6bb991cb5558
Dec 06 10:28:10.808 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-1/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 06 10:28:11.096 INFO [stdout] b5884ae65abf4420e000accb7d208ca1c5b306d9ad43715fb3fb38c4c551ef0e
Dec 06 10:28:11.104 INFO running `"docker" "start" "-a" "b5884ae65abf4420e000accb7d208ca1c5b306d9ad43715fb3fb38c4c551ef0e"`
Dec 06 10:28:11.525 INFO [stderr] usermod: no changes
Dec 06 10:28:11.685 INFO [stderr]    Compiling ots-aggregator v0.1.0 (/source)
Dec 06 10:28:13.056 INFO [stderr] warning: unused imports: `Write`, `self`
Dec 06 10:28:13.056 INFO [stderr]  --> examples/load_testing.rs:6:15
Dec 06 10:28:13.056 INFO [stderr]   |
Dec 06 10:28:13.056 INFO [stderr] 6 | use std::io::{self, Write};
Dec 06 10:28:13.056 INFO [stderr]   |               ^^^^  ^^^^^
Dec 06 10:28:13.056 INFO [stderr]   |
Dec 06 10:28:13.056 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Dec 06 10:28:13.056 INFO [stderr] 
Dec 06 10:28:13.196 INFO [stderr] warning: unused variable: `i`
Dec 06 10:28:13.196 INFO [stderr]   --> examples/load_testing.rs:38:9
Dec 06 10:28:13.196 INFO [stderr]    |
Dec 06 10:28:13.196 INFO [stderr] 38 |     for i in 0..100 {
Dec 06 10:28:13.196 INFO [stderr]    |         ^ help: consider using `_i` instead
Dec 06 10:28:13.196 INFO [stderr]    |
Dec 06 10:28:13.196 INFO [stderr]    = note: #[warn(unused_variables)] on by default
Dec 06 10:28:13.196 INFO [stderr] 
Dec 06 10:28:13.256 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 06 10:28:13.257 INFO [stderr]   --> examples/load_testing.rs:22:9
Dec 06 10:28:13.257 INFO [stderr]    |
Dec 06 10:28:13.257 INFO [stderr] 22 |         start(arg1);
Dec 06 10:28:13.257 INFO [stderr]    |         ^^^^^^^^^^^^
Dec 06 10:28:13.257 INFO [stderr]    |
Dec 06 10:28:13.257 INFO [stderr]    = note: #[warn(unused_must_use)] on by default
Dec 06 10:28:13.257 INFO [stderr]    = note: this `Result` may be an `Err` variant, which should be handled
Dec 06 10:28:13.257 INFO [stderr] 
Dec 06 10:28:13.520 INFO [stderr] warning: unused import: `merkle::Sha256Hash`
Dec 06 10:28:13.520 INFO [stderr]    --> src/merkle.rs:121:9
Dec 06 10:28:13.520 INFO [stderr]     |
Dec 06 10:28:13.520 INFO [stderr] 121 |     use merkle::Sha256Hash;
Dec 06 10:28:13.520 INFO [stderr]     |         ^^^^^^^^^^^^^^^^^^
Dec 06 10:28:13.520 INFO [stderr]     |
Dec 06 10:28:13.520 INFO [stderr]     = note: #[warn(unused_imports)] on by default
Dec 06 10:28:13.520 INFO [stderr] 
Dec 06 10:28:13.656 INFO [stderr] warning: a method with this name may be added to the standard library in the future
Dec 06 10:28:13.656 INFO [stderr]   --> src/merkle.rs:29:50
Dec 06 10:28:13.656 INFO [stderr]    |
Dec 06 10:28:13.656 INFO [stderr] 29 |              digests_sha256.len(), now.elapsed().as_millis(), root);
Dec 06 10:28:13.656 INFO [stderr]    |                                                  ^^^^^^^^^
Dec 06 10:28:13.656 INFO [stderr]    |
Dec 06 10:28:13.656 INFO [stderr]    = note: #[warn(unstable_name_collisions)] on by default
Dec 06 10:28:13.656 INFO [stderr]    = warning: once this method is added to the standard library, the ambiguity may cause an error or change in behavior!
Dec 06 10:28:13.656 INFO [stderr]    = note: for more information, see issue #48919 <https://github.com/rust-lang/rust/issues/48919>
Dec 06 10:28:13.656 INFO [stderr]    = help: call with fully qualified syntax `Millis::as_millis(...)` to keep using the current method
Dec 06 10:28:13.656 INFO [stderr]    = help: add #![feature(duration_as_u128)] to the crate attributes to enable `std::time::Duration::as_millis`
Dec 06 10:28:13.656 INFO [stderr] 
Dec 06 10:28:13.688 INFO [stderr] warning: a method with this name may be added to the standard library in the future
Dec 06 10:28:13.688 INFO [stderr]   --> src/timer.rs:55:60
Dec 06 10:28:13.688 INFO [stderr]    |
Dec 06 10:28:13.688 INFO [stderr] 55 |                              res.status(), start.elapsed().as_millis());
Dec 06 10:28:13.688 INFO [stderr]    |                                                            ^^^^^^^^^
Dec 06 10:28:13.688 INFO [stderr]    |
Dec 06 10:28:13.693 INFO [stderr]    = warning: once this method is added to the standard library, the ambiguity may cause an error or change in behavior!
Dec 06 10:28:13.693 INFO [stderr]    = note: for more information, see issue #48919 <https://github.com/rust-lang/rust/issues/48919>
Dec 06 10:28:13.693 INFO [stderr]    = help: call with fully qualified syntax `Millis::as_millis(...)` to keep using the current method
Dec 06 10:28:13.693 INFO [stderr]    = help: add #![feature(duration_as_u128)] to the crate attributes to enable `std::time::Duration::as_millis`
Dec 06 10:28:13.693 INFO [stderr] 
Dec 06 10:28:18.288 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.74s
Dec 06 10:28:18.300 INFO [stderr] su: No module specific data is present
Dec 06 10:28:18.828 INFO running `"docker" "inspect" "b5884ae65abf4420e000accb7d208ca1c5b306d9ad43715fb3fb38c4c551ef0e"`
Dec 06 10:28:18.941 INFO running `"docker" "rm" "-f" "b5884ae65abf4420e000accb7d208ca1c5b306d9ad43715fb3fb38c4c551ef0e"`
Dec 06 10:28:19.071 INFO [stdout] b5884ae65abf4420e000accb7d208ca1c5b306d9ad43715fb3fb38c4c551ef0e
Dec 06 10:28:19.074 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-1/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 06 10:28:19.289 INFO [stdout] f0814e104fd7f28e9d82ed66cc03a9baf80f3ad848cfe673f4ffb51602630ec5
Dec 06 10:28:19.297 INFO running `"docker" "start" "-a" "f0814e104fd7f28e9d82ed66cc03a9baf80f3ad848cfe673f4ffb51602630ec5"`
Dec 06 10:28:20.017 INFO [stderr] usermod: no changes
Dec 06 10:28:20.156 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.12s
Dec 06 10:28:20.176 INFO [stderr]      Running /target/debug/deps/ots_aggregator-b80290af56df3118
Dec 06 10:28:20.181 INFO [stdout] 
Dec 06 10:28:20.181 INFO [stdout] running 2 tests
Dec 06 10:28:20.181 INFO [stdout] test merkle::tests::test_sha256 ... ok
Dec 06 10:28:20.181 INFO [stdout] test merkle::tests::test_make ... ok
Dec 06 10:28:20.181 INFO [stdout] 
Dec 06 10:28:20.181 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 10:28:20.181 INFO [stdout] 
Dec 06 10:28:20.183 INFO [stderr]      Running /target/debug/deps/aggregator-134bf3393165ac9a
Dec 06 10:28:20.183 INFO [stdout] 
Dec 06 10:28:20.183 INFO [stdout] running 0 tests
Dec 06 10:28:20.183 INFO [stdout] 
Dec 06 10:28:20.184 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 10:28:20.184 INFO [stdout] 
Dec 06 10:28:20.188 INFO [stderr]    Doc-tests ots-aggregator
Dec 06 10:28:22.298 INFO [stdout] 
Dec 06 10:28:22.298 INFO [stdout] running 0 tests
Dec 06 10:28:22.298 INFO [stdout] 
Dec 06 10:28:22.298 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 10:28:22.298 INFO [stdout] 
Dec 06 10:28:22.308 INFO [stderr] su: No module specific data is present
Dec 06 10:28:22.550 INFO running `"docker" "inspect" "f0814e104fd7f28e9d82ed66cc03a9baf80f3ad848cfe673f4ffb51602630ec5"`
Dec 06 10:28:22.640 INFO running `"docker" "rm" "-f" "f0814e104fd7f28e9d82ed66cc03a9baf80f3ad848cfe673f4ffb51602630ec5"`
Dec 06 10:28:22.776 INFO [stdout] f0814e104fd7f28e9d82ed66cc03a9baf80f3ad848cfe673f4ffb51602630ec5