Nov 17 08:06:41.209 INFO testing birders/heliometer against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 17 08:06:41.210 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 08:06:41.755 INFO [stdout] ab9b8838dcbd7eed07f6e6d5ac3927e99a9ada67d427c7818d741a4071cf2172
Nov 17 08:06:41.758 INFO running `"docker" "start" "-a" "ab9b8838dcbd7eed07f6e6d5ac3927e99a9ada67d427c7818d741a4071cf2172"`
Nov 17 08:06:44.407 INFO [stderr] usermod: no changes
Nov 17 08:06:44.545 INFO [stderr]    Compiling heliometer v0.5.10 (/source)
Nov 17 08:06:46.383 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.95s
Nov 17 08:06:46.395 INFO [stderr] su: No module specific data is present
Nov 17 08:06:47.357 INFO running `"docker" "inspect" "ab9b8838dcbd7eed07f6e6d5ac3927e99a9ada67d427c7818d741a4071cf2172"`
Nov 17 08:06:47.752 INFO running `"docker" "rm" "-f" "ab9b8838dcbd7eed07f6e6d5ac3927e99a9ada67d427c7818d741a4071cf2172"`
Nov 17 08:06:48.143 INFO [stdout] ab9b8838dcbd7eed07f6e6d5ac3927e99a9ada67d427c7818d741a4071cf2172
Nov 17 08:06:48.151 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 08:06:48.707 INFO [stdout] 86f480b880dbb88fd38738963d2027eb711c1ece4b7b26a12aaf3df9e0e1e3ed
Nov 17 08:06:48.715 INFO running `"docker" "start" "-a" "86f480b880dbb88fd38738963d2027eb711c1ece4b7b26a12aaf3df9e0e1e3ed"`
Nov 17 08:06:50.322 INFO [stderr] usermod: no changes
Nov 17 08:06:50.643 INFO [stderr]    Compiling serde v1.0.48
Nov 17 08:06:50.647 INFO [stderr]    Compiling criterion-stats v0.2.3
Nov 17 08:06:50.647 INFO [stderr]    Compiling itertools-num v0.1.1
Nov 17 08:06:50.647 INFO [stderr]    Compiling criterion-plot v0.2.3
Nov 17 08:06:50.647 INFO [stderr]    Compiling simplelog v0.5.1
Nov 17 08:06:50.647 INFO [stderr]    Compiling serde_derive v1.0.48
Nov 17 08:06:50.647 INFO [stderr]    Compiling error-chain v0.11.0
Nov 17 08:07:15.339 INFO [stderr]    Compiling semver v0.8.0
Nov 17 08:07:15.340 INFO [stderr]    Compiling serde_json v1.0.17
Nov 17 08:07:20.607 INFO [stderr]    Compiling cargo_metadata v0.3.3
Nov 17 08:07:20.608 INFO [stderr]    Compiling handlebars v0.31.0
Nov 17 08:07:25.431 INFO [stderr]    Compiling skeptic v0.13.2
Nov 17 08:07:32.760 INFO [stderr]    Compiling criterion v0.2.3
Nov 17 08:07:34.503 INFO [stderr]    Compiling assert_cli v0.5.4
Nov 17 08:07:46.783 INFO [stderr]    Compiling heliometer v0.5.10 (/source)
Nov 17 08:07:49.799 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 59.44s
Nov 17 08:07:49.810 INFO [stderr] su: No module specific data is present
Nov 17 08:07:50.527 INFO running `"docker" "inspect" "86f480b880dbb88fd38738963d2027eb711c1ece4b7b26a12aaf3df9e0e1e3ed"`
Nov 17 08:07:50.799 INFO running `"docker" "rm" "-f" "86f480b880dbb88fd38738963d2027eb711c1ece4b7b26a12aaf3df9e0e1e3ed"`
Nov 17 08:07:51.075 INFO [stdout] 86f480b880dbb88fd38738963d2027eb711c1ece4b7b26a12aaf3df9e0e1e3ed
Nov 17 08:07:51.078 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 08:07:51.560 INFO [stdout] f033cddf6a417c9fb8d36449bc1a510117ce82fa214d6742dc1967a2f714adaa
Nov 17 08:07:51.565 INFO running `"docker" "start" "-a" "f033cddf6a417c9fb8d36449bc1a510117ce82fa214d6742dc1967a2f714adaa"`
Nov 17 08:07:52.593 INFO [stderr] usermod: no changes
Nov 17 08:07:52.837 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.20s
Nov 17 08:07:52.850 INFO [stderr]      Running /target/debug/deps/heliometer-0c4cdcf5e0a1d977
Nov 17 08:07:52.850 INFO [stdout] 
Nov 17 08:07:52.850 INFO [stderr]      Running /target/debug/deps/helio-e7b870b58b5ca381
Nov 17 08:07:52.850 INFO [stdout] running 0 tests
Nov 17 08:07:52.850 INFO [stdout] 
Nov 17 08:07:52.850 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 08:07:52.850 INFO [stdout] 
Nov 17 08:07:52.850 INFO [stdout] 
Nov 17 08:07:52.850 INFO [stdout] running 0 tests
Nov 17 08:07:52.850 INFO [stdout] 
Nov 17 08:07:52.850 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 08:07:52.850 INFO [stdout] 
Nov 17 08:07:52.859 INFO [stdout] 
Nov 17 08:07:52.859 INFO [stderr]      Running /target/debug/deps/tests-c5a208aa78f65cb5
Nov 17 08:07:52.859 INFO [stdout] running 5 tests
Nov 17 08:07:52.875 INFO [stdout] test tests::overflow ... ok
Nov 17 08:07:52.899 INFO [stdout] test tests::other_program_check ... ok
Nov 17 08:07:52.987 INFO [stdout] test tests::unmatched_right_bracket ... ok
Nov 17 08:07:53.191 INFO [stdout] test integration::without_args ... ok
Nov 17 08:07:55.187 INFO [stdout] test tests::far_right ... ok
Nov 17 08:07:55.188 INFO [stdout] 
Nov 17 08:07:55.188 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 08:07:55.188 INFO [stdout] 
Nov 17 08:07:55.188 INFO [stderr]    Doc-tests heliometer
Nov 17 08:07:55.819 INFO [stdout] 
Nov 17 08:07:55.819 INFO [stdout] running 1 test
Nov 17 08:07:56.894 INFO [stdout] test src/lib.rs - execute (line 178) ... ok
Nov 17 08:07:56.895 INFO [stdout] 
Nov 17 08:07:56.895 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 08:07:56.895 INFO [stdout] 
Nov 17 08:07:56.912 INFO [stderr] su: No module specific data is present
Nov 17 08:07:57.623 INFO running `"docker" "inspect" "f033cddf6a417c9fb8d36449bc1a510117ce82fa214d6742dc1967a2f714adaa"`
Nov 17 08:07:58.017 INFO running `"docker" "rm" "-f" "f033cddf6a417c9fb8d36449bc1a510117ce82fa214d6742dc1967a2f714adaa"`
Nov 17 08:07:58.341 INFO [stdout] f033cddf6a417c9fb8d36449bc1a510117ce82fa214d6742dc1967a2f714adaa