Dec 14 01:20:52.379 INFO testing birders/heliometer against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 14 01:20:52.379 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 14 01:20:52.747 INFO [stdout] e6a5cb68fa07cb9fcd4bf4c3b2ddf5b764792705160920115f799e29fbb051bc
Dec 14 01:20:52.752 INFO running `"docker" "start" "-a" "e6a5cb68fa07cb9fcd4bf4c3b2ddf5b764792705160920115f799e29fbb051bc"`
Dec 14 01:20:54.518 INFO [stderr] usermod: no changes
Dec 14 01:20:54.659 INFO [stderr]    Compiling heliometer v0.5.10 (/source)
Dec 14 01:20:56.631 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.08s
Dec 14 01:20:56.647 INFO [stderr] su: No module specific data is present
Dec 14 01:20:58.250 INFO running `"docker" "inspect" "e6a5cb68fa07cb9fcd4bf4c3b2ddf5b764792705160920115f799e29fbb051bc"`
Dec 14 01:20:58.521 INFO running `"docker" "rm" "-f" "e6a5cb68fa07cb9fcd4bf4c3b2ddf5b764792705160920115f799e29fbb051bc"`
Dec 14 01:20:58.895 INFO [stdout] e6a5cb68fa07cb9fcd4bf4c3b2ddf5b764792705160920115f799e29fbb051bc
Dec 14 01:20:58.897 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 14 01:20:59.311 INFO [stdout] 86693cfa6e8f0e45d277ce8a80f7359f9638df829e2108dc0ebaa7d44133ce37
Dec 14 01:20:59.317 INFO running `"docker" "start" "-a" "86693cfa6e8f0e45d277ce8a80f7359f9638df829e2108dc0ebaa7d44133ce37"`
Dec 14 01:21:00.993 INFO [stderr] usermod: no changes
Dec 14 01:21:01.243 INFO [stderr]    Compiling serde v1.0.48
Dec 14 01:21:01.288 INFO [stderr]    Compiling regex v0.2.11
Dec 14 01:21:01.288 INFO [stderr]    Compiling simplelog v0.5.1
Dec 14 01:21:01.288 INFO [stderr]    Compiling backtrace v0.3.7
Dec 14 01:21:01.288 INFO [stderr]    Compiling serde_derive v1.0.48
Dec 14 01:21:06.223 INFO [stderr]    Compiling error-chain v0.11.0
Dec 14 01:21:06.223 INFO [stderr]    Compiling failure v0.1.1
Dec 14 01:21:29.831 INFO [stderr]    Compiling serde_json v1.0.17
Dec 14 01:21:29.831 INFO [stderr]    Compiling semver v0.8.0
Dec 14 01:21:34.644 INFO [stderr]    Compiling cargo_metadata v0.3.3
Dec 14 01:21:34.644 INFO [stderr]    Compiling handlebars v0.31.0
Dec 14 01:21:38.142 INFO [stderr]    Compiling skeptic v0.13.2
Dec 14 01:21:44.947 INFO [stderr]    Compiling criterion v0.2.3
Dec 14 01:21:45.979 INFO [stderr]    Compiling assert_cli v0.5.4
Dec 14 01:21:59.923 INFO [stderr]    Compiling heliometer v0.5.10 (/source)
Dec 14 01:22:02.693 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 01s
Dec 14 01:22:02.711 INFO [stderr] su: No module specific data is present
Dec 14 01:22:03.402 INFO running `"docker" "inspect" "86693cfa6e8f0e45d277ce8a80f7359f9638df829e2108dc0ebaa7d44133ce37"`
Dec 14 01:22:03.709 INFO running `"docker" "rm" "-f" "86693cfa6e8f0e45d277ce8a80f7359f9638df829e2108dc0ebaa7d44133ce37"`
Dec 14 01:22:04.047 INFO [stdout] 86693cfa6e8f0e45d277ce8a80f7359f9638df829e2108dc0ebaa7d44133ce37
Dec 14 01:22:04.049 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 14 01:22:04.492 INFO [stdout] 30bbd09a0075481a599a83e54b888028e9a0a05a47e83f4dbed64e60e0ccd1bf
Dec 14 01:22:04.499 INFO running `"docker" "start" "-a" "30bbd09a0075481a599a83e54b888028e9a0a05a47e83f4dbed64e60e0ccd1bf"`
Dec 14 01:22:05.641 INFO [stderr] usermod: no changes
Dec 14 01:22:05.907 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.24s
Dec 14 01:22:05.927 INFO [stderr]      Running /target/debug/deps/heliometer-c35a4f0204d6c3cd
Dec 14 01:22:05.931 INFO [stdout] 
Dec 14 01:22:05.931 INFO [stdout] running 0 tests
Dec 14 01:22:05.931 INFO [stdout] 
Dec 14 01:22:05.931 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 01:22:05.931 INFO [stdout] 
Dec 14 01:22:05.934 INFO [stderr]      Running /target/debug/deps/helio-c0346b6aaf9a7c6f
Dec 14 01:22:05.943 INFO [stdout] 
Dec 14 01:22:05.943 INFO [stdout] running 0 tests
Dec 14 01:22:05.943 INFO [stdout] 
Dec 14 01:22:05.943 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 01:22:05.943 INFO [stdout] 
Dec 14 01:22:05.946 INFO [stderr]      Running /target/debug/deps/tests-362f4ce8f1403191
Dec 14 01:22:05.951 INFO [stdout] 
Dec 14 01:22:05.951 INFO [stdout] running 5 tests
Dec 14 01:22:05.959 INFO [stdout] test tests::overflow ... ok
Dec 14 01:22:05.959 INFO [stdout] test tests::other_program_check ... ok
Dec 14 01:22:06.121 INFO [stdout] test tests::unmatched_right_bracket ... ok
Dec 14 01:22:06.150 INFO [stdout] test integration::without_args ... ok
Dec 14 01:22:08.410 INFO [stdout] test tests::far_right ... ok
Dec 14 01:22:08.410 INFO [stdout] 
Dec 14 01:22:08.410 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 01:22:08.410 INFO [stdout] 
Dec 14 01:22:08.413 INFO [stderr]    Doc-tests heliometer
Dec 14 01:22:09.292 INFO [stdout] 
Dec 14 01:22:09.292 INFO [stdout] running 1 test
Dec 14 01:22:10.481 INFO [stdout] test src/lib.rs - execute (line 178) ... ok
Dec 14 01:22:10.481 INFO [stdout] 
Dec 14 01:22:10.481 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 01:22:10.481 INFO [stdout] 
Dec 14 01:22:10.500 INFO [stderr] su: No module specific data is present
Dec 14 01:22:11.304 INFO running `"docker" "inspect" "30bbd09a0075481a599a83e54b888028e9a0a05a47e83f4dbed64e60e0ccd1bf"`
Dec 14 01:22:11.616 INFO running `"docker" "rm" "-f" "30bbd09a0075481a599a83e54b888028e9a0a05a47e83f4dbed64e60e0ccd1bf"`
Dec 14 01:22:11.862 INFO [stdout] 30bbd09a0075481a599a83e54b888028e9a0a05a47e83f4dbed64e60e0ccd1bf