Nov 17 12:26:54.558 INFO testing RCasatta/ots-aggregator against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982 Nov 17 12:26:54.560 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-1/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 17 12:26:54.943 INFO [stdout] 745bac92ffea204bcf2191e4bb9a1a51b7dab8cae1acef8c671c20e587e9d4ae Nov 17 12:26:54.946 INFO running `"docker" "start" "-a" "745bac92ffea204bcf2191e4bb9a1a51b7dab8cae1acef8c671c20e587e9d4ae"` Nov 17 12:26:55.954 INFO [stderr] usermod: no changes Nov 17 12:26:56.220 INFO [stderr] Compiling iovec v0.1.2 Nov 17 12:26:56.239 INFO [stderr] Compiling memchr v2.0.1 Nov 17 12:26:56.239 INFO [stderr] Compiling num_cpus v1.8.0 Nov 17 12:26:56.239 INFO [stderr] Compiling time v0.1.39 Nov 17 12:26:56.239 INFO [stderr] Compiling atty v0.2.8 Nov 17 12:26:56.239 INFO [stderr] Compiling net2 v0.2.32 Nov 17 12:26:56.239 INFO [stderr] Compiling rand v0.3.22 Nov 17 12:26:56.239 INFO [stderr] Compiling openssl-sys v0.9.31 Nov 17 12:26:57.736 INFO [stderr] Compiling clap v2.31.1 Nov 17 12:26:58.188 INFO [stderr] Compiling aho-corasick v0.6.4 Nov 17 12:27:00.275 INFO [stderr] Compiling bytes v0.4.6 Nov 17 12:27:00.298 INFO [stderr] Compiling futures-cpupool v0.1.8 Nov 17 12:27:00.327 INFO [stderr] Compiling openssl v0.9.24 Nov 17 12:27:00.442 INFO [stderr] Compiling rust-crypto v0.2.36 Nov 17 12:27:00.507 INFO [stderr] Compiling mio v0.6.13 Nov 17 12:27:02.763 INFO [stderr] Compiling regex v0.2.10 Nov 17 12:27:05.118 INFO [stderr] Compiling tokio-io v0.1.5 Nov 17 12:27:10.384 INFO [stderr] Compiling tokio-core v0.1.12 Nov 17 12:27:10.385 INFO [stderr] Compiling tokio v0.1.1 Nov 17 12:27:15.431 INFO [stderr] Compiling native-tls v0.1.5 Nov 17 12:27:20.504 INFO [stderr] Compiling tokio-proto v0.1.1 Nov 17 12:27:20.504 INFO [stderr] Compiling tokio-tls v0.1.4 Nov 17 12:27:20.890 INFO [stderr] Compiling env_logger v0.4.3 Nov 17 12:27:26.248 INFO [stderr] Compiling env_logger v0.5.5 Nov 17 12:27:26.560 INFO [stderr] Compiling opentimestamps v0.1.2 Nov 17 12:27:26.818 INFO [stderr] Compiling hyper v0.11.22 Nov 17 12:27:35.670 INFO [stderr] Compiling hyper-tls v0.1.3 Nov 17 12:27:37.803 INFO [stderr] Compiling ots-aggregator v0.1.0 (/source) Nov 17 12:27:40.287 INFO [stderr] warning: a method with this name may be added to the standard library in the future Nov 17 12:27:40.287 INFO [stderr] --> src/merkle.rs:29:50 Nov 17 12:27:40.287 INFO [stderr] | Nov 17 12:27:40.287 INFO [stderr] 29 | digests_sha256.len(), now.elapsed().as_millis(), root); Nov 17 12:27:40.287 INFO [stderr] | ^^^^^^^^^ Nov 17 12:27:40.287 INFO [stderr] | Nov 17 12:27:40.287 INFO [stderr] = note: #[warn(unstable_name_collisions)] on by default Nov 17 12:27:40.287 INFO [stderr] = warning: once this method is added to the standard library, the ambiguity may cause an error or change in behavior! Nov 17 12:27:40.287 INFO [stderr] = note: for more information, see issue #48919 Nov 17 12:27:40.287 INFO [stderr] = help: call with fully qualified syntax `Millis::as_millis(...)` to keep using the current method Nov 17 12:27:40.287 INFO [stderr] = help: add #![feature(duration_as_u128)] to the crate attributes to enable `std::time::Duration::as_millis` Nov 17 12:27:40.287 INFO [stderr] Nov 17 12:27:40.303 INFO [stderr] warning: a method with this name may be added to the standard library in the future Nov 17 12:27:40.303 INFO [stderr] --> src/timer.rs:55:60 Nov 17 12:27:40.303 INFO [stderr] | Nov 17 12:27:40.303 INFO [stderr] 55 | res.status(), start.elapsed().as_millis()); Nov 17 12:27:40.303 INFO [stderr] | ^^^^^^^^^ Nov 17 12:27:40.303 INFO [stderr] | Nov 17 12:27:40.303 INFO [stderr] = warning: once this method is added to the standard library, the ambiguity may cause an error or change in behavior! Nov 17 12:27:40.303 INFO [stderr] = note: for more information, see issue #48919 Nov 17 12:27:40.303 INFO [stderr] = help: call with fully qualified syntax `Millis::as_millis(...)` to keep using the current method Nov 17 12:27:40.303 INFO [stderr] = help: add #![feature(duration_as_u128)] to the crate attributes to enable `std::time::Duration::as_millis` Nov 17 12:27:40.303 INFO [stderr] Nov 17 12:27:51.121 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 55.13s Nov 17 12:27:51.138 INFO [stderr] su: No module specific data is present Nov 17 12:27:52.062 INFO running `"docker" "inspect" "745bac92ffea204bcf2191e4bb9a1a51b7dab8cae1acef8c671c20e587e9d4ae"` Nov 17 12:27:52.299 INFO running `"docker" "rm" "-f" "745bac92ffea204bcf2191e4bb9a1a51b7dab8cae1acef8c671c20e587e9d4ae"` Nov 17 12:27:52.659 INFO [stdout] 745bac92ffea204bcf2191e4bb9a1a51b7dab8cae1acef8c671c20e587e9d4ae Nov 17 12:27:52.663 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-1/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 17 12:27:53.067 INFO [stdout] 493cbaf137d2f8f8e969fda9a5de2e1fb352705dccef2a80bef8b59d76f43cf4 Nov 17 12:27:53.070 INFO running `"docker" "start" "-a" "493cbaf137d2f8f8e969fda9a5de2e1fb352705dccef2a80bef8b59d76f43cf4"` Nov 17 12:27:54.271 INFO [stderr] usermod: no changes Nov 17 12:27:54.572 INFO [stderr] Compiling ots-aggregator v0.1.0 (/source) Nov 17 12:27:58.287 INFO [stderr] warning: unused imports: `Write`, `self` Nov 17 12:27:58.287 INFO [stderr] --> examples/load_testing.rs:6:15 Nov 17 12:27:58.287 INFO [stderr] | Nov 17 12:27:58.287 INFO [stderr] 6 | use std::io::{self, Write}; Nov 17 12:27:58.287 INFO [stderr] | ^^^^ ^^^^^ Nov 17 12:27:58.287 INFO [stderr] | Nov 17 12:27:58.287 INFO [stderr] = note: #[warn(unused_imports)] on by default Nov 17 12:27:58.287 INFO [stderr] Nov 17 12:27:58.395 INFO [stderr] warning: unused variable: `i` Nov 17 12:27:58.395 INFO [stderr] --> examples/load_testing.rs:38:9 Nov 17 12:27:58.395 INFO [stderr] | Nov 17 12:27:58.395 INFO [stderr] 38 | for i in 0..100 { Nov 17 12:27:58.395 INFO [stderr] | ^ help: consider using `_i` instead Nov 17 12:27:58.395 INFO [stderr] | Nov 17 12:27:58.395 INFO [stderr] = note: #[warn(unused_variables)] on by default Nov 17 12:27:58.395 INFO [stderr] Nov 17 12:27:58.431 INFO [stderr] warning: unused `std::result::Result` that must be used Nov 17 12:27:58.431 INFO [stderr] --> examples/load_testing.rs:22:9 Nov 17 12:27:58.431 INFO [stderr] | Nov 17 12:27:58.431 INFO [stderr] 22 | start(arg1); Nov 17 12:27:58.431 INFO [stderr] | ^^^^^^^^^^^^ Nov 17 12:27:58.431 INFO [stderr] | Nov 17 12:27:58.431 INFO [stderr] = note: #[warn(unused_must_use)] on by default Nov 17 12:27:58.431 INFO [stderr] = note: this `Result` may be an `Err` variant, which should be handled Nov 17 12:27:58.431 INFO [stderr] Nov 17 12:27:59.243 INFO [stderr] warning: unused import: `merkle::Sha256Hash` Nov 17 12:27:59.243 INFO [stderr] --> src/merkle.rs:121:9 Nov 17 12:27:59.243 INFO [stderr] | Nov 17 12:27:59.244 INFO [stderr] 121 | use merkle::Sha256Hash; Nov 17 12:27:59.244 INFO [stderr] | ^^^^^^^^^^^^^^^^^^ Nov 17 12:27:59.244 INFO [stderr] | Nov 17 12:27:59.244 INFO [stderr] = note: #[warn(unused_imports)] on by default Nov 17 12:27:59.244 INFO [stderr] Nov 17 12:27:59.779 INFO [stderr] warning: a method with this name may be added to the standard library in the future Nov 17 12:27:59.779 INFO [stderr] --> src/merkle.rs:29:50 Nov 17 12:27:59.780 INFO [stderr] | Nov 17 12:27:59.780 INFO [stderr] 29 | digests_sha256.len(), now.elapsed().as_millis(), root); Nov 17 12:27:59.780 INFO [stderr] | ^^^^^^^^^ Nov 17 12:27:59.780 INFO [stderr] | Nov 17 12:27:59.780 INFO [stderr] = note: #[warn(unstable_name_collisions)] on by default Nov 17 12:27:59.781 INFO [stderr] = warning: once this method is added to the standard library, the ambiguity may cause an error or change in behavior! Nov 17 12:27:59.781 INFO [stderr] = note: for more information, see issue #48919 Nov 17 12:27:59.781 INFO [stderr] = help: call with fully qualified syntax `Millis::as_millis(...)` to keep using the current method Nov 17 12:27:59.781 INFO [stderr] = help: add #![feature(duration_as_u128)] to the crate attributes to enable `std::time::Duration::as_millis` Nov 17 12:27:59.782 INFO [stderr] Nov 17 12:27:59.834 INFO [stderr] warning: a method with this name may be added to the standard library in the future Nov 17 12:27:59.835 INFO [stderr] --> src/timer.rs:55:60 Nov 17 12:27:59.835 INFO [stderr] | Nov 17 12:27:59.836 INFO [stderr] 55 | res.status(), start.elapsed().as_millis()); Nov 17 12:27:59.836 INFO [stderr] | ^^^^^^^^^ Nov 17 12:27:59.836 INFO [stderr] | Nov 17 12:27:59.836 INFO [stderr] = warning: once this method is added to the standard library, the ambiguity may cause an error or change in behavior! Nov 17 12:27:59.837 INFO [stderr] = note: for more information, see issue #48919 Nov 17 12:27:59.837 INFO [stderr] = help: call with fully qualified syntax `Millis::as_millis(...)` to keep using the current method Nov 17 12:27:59.837 INFO [stderr] = help: add #![feature(duration_as_u128)] to the crate attributes to enable `std::time::Duration::as_millis` Nov 17 12:27:59.838 INFO [stderr] Nov 17 12:28:06.423 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 12.11s Nov 17 12:28:06.434 INFO [stderr] su: No module specific data is present Nov 17 12:28:07.267 INFO running `"docker" "inspect" "493cbaf137d2f8f8e969fda9a5de2e1fb352705dccef2a80bef8b59d76f43cf4"` Nov 17 12:28:07.555 INFO running `"docker" "rm" "-f" "493cbaf137d2f8f8e969fda9a5de2e1fb352705dccef2a80bef8b59d76f43cf4"` Nov 17 12:28:07.815 INFO [stdout] 493cbaf137d2f8f8e969fda9a5de2e1fb352705dccef2a80bef8b59d76f43cf4 Nov 17 12:28:07.820 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-1/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 17 12:28:08.219 INFO [stdout] 0d51144c57dc74fa7a46765230040ddbf2d38165c805510b7befd4f7b5320bd5 Nov 17 12:28:08.222 INFO running `"docker" "start" "-a" "0d51144c57dc74fa7a46765230040ddbf2d38165c805510b7befd4f7b5320bd5"` Nov 17 12:28:09.430 INFO [stderr] usermod: no changes Nov 17 12:28:09.619 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.16s Nov 17 12:28:09.639 INFO [stderr] Running /target/debug/deps/ots_aggregator-42299b9a512b678c Nov 17 12:28:09.640 INFO [stdout] Nov 17 12:28:09.640 INFO [stdout] running 2 tests Nov 17 12:28:09.640 INFO [stdout] test merkle::tests::test_sha256 ... ok Nov 17 12:28:09.641 INFO [stdout] test merkle::tests::test_make ... ok Nov 17 12:28:09.641 INFO [stdout] Nov 17 12:28:09.641 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Nov 17 12:28:09.641 INFO [stdout] Nov 17 12:28:09.647 INFO [stderr] Running /target/debug/deps/aggregator-db17951b0a3381a2 Nov 17 12:28:09.647 INFO [stderr] Doc-tests ots-aggregator Nov 17 12:28:09.648 INFO [stdout] Nov 17 12:28:09.648 INFO [stdout] running 0 tests Nov 17 12:28:09.648 INFO [stdout] Nov 17 12:28:09.648 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Nov 17 12:28:09.648 INFO [stdout] Nov 17 12:28:14.059 INFO [stdout] Nov 17 12:28:14.060 INFO [stdout] running 0 tests Nov 17 12:28:14.060 INFO [stdout] Nov 17 12:28:14.060 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Nov 17 12:28:14.061 INFO [stdout] Nov 17 12:28:14.071 INFO [stderr] su: No module specific data is present Nov 17 12:28:15.139 INFO running `"docker" "inspect" "0d51144c57dc74fa7a46765230040ddbf2d38165c805510b7befd4f7b5320bd5"` Nov 17 12:28:15.373 INFO running `"docker" "rm" "-f" "0d51144c57dc74fa7a46765230040ddbf2d38165c805510b7befd4f7b5320bd5"` Nov 17 12:28:15.673 INFO [stdout] 0d51144c57dc74fa7a46765230040ddbf2d38165c805510b7befd4f7b5320bd5