Dec 14 01:20:13.628 INFO testing birders/heliometer against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 14 01:20:13.628 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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:14.043 INFO [stdout] d627c70636c07cc01ff5f27d37511862c688bae2ae046fc4efa67b6b244fbd30
Dec 14 01:20:14.045 INFO running `"docker" "start" "-a" "d627c70636c07cc01ff5f27d37511862c688bae2ae046fc4efa67b6b244fbd30"`
Dec 14 01:20:17.087 INFO [stderr] usermod: no changes
Dec 14 01:20:17.220 INFO [stderr]    Compiling heliometer v0.5.10 (/source)
Dec 14 01:20:19.064 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.95s
Dec 14 01:20:19.074 INFO [stderr] su: No module specific data is present
Dec 14 01:20:20.300 INFO running `"docker" "inspect" "d627c70636c07cc01ff5f27d37511862c688bae2ae046fc4efa67b6b244fbd30"`
Dec 14 01:20:20.707 INFO running `"docker" "rm" "-f" "d627c70636c07cc01ff5f27d37511862c688bae2ae046fc4efa67b6b244fbd30"`
Dec 14 01:20:21.063 INFO [stdout] d627c70636c07cc01ff5f27d37511862c688bae2ae046fc4efa67b6b244fbd30
Dec 14 01:20:21.065 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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:21.598 INFO [stdout] 4a16c9fa61ddee4e74ce83f6266346e792f3d2862bfa7b9284128428add9f051
Dec 14 01:20:21.600 INFO running `"docker" "start" "-a" "4a16c9fa61ddee4e74ce83f6266346e792f3d2862bfa7b9284128428add9f051"`
Dec 14 01:20:24.112 INFO [stderr] usermod: no changes
Dec 14 01:20:24.355 INFO [stderr]    Compiling serde v1.0.48
Dec 14 01:20:24.404 INFO [stderr]    Compiling simplelog v0.5.1
Dec 14 01:20:24.412 INFO [stderr]    Compiling serde_derive v1.0.48
Dec 14 01:20:49.211 INFO [stderr]    Compiling serde_json v1.0.17
Dec 14 01:20:49.228 INFO [stderr]    Compiling semver v0.8.0
Dec 14 01:20:54.868 INFO [stderr]    Compiling cargo_metadata v0.3.3
Dec 14 01:20:54.868 INFO [stderr]    Compiling handlebars v0.31.0
Dec 14 01:20:59.871 INFO [stderr]    Compiling skeptic v0.13.2
Dec 14 01:21:08.574 INFO [stderr]    Compiling criterion v0.2.3
Dec 14 01:21:11.113 INFO [stderr]    Compiling assert_cli v0.5.4
Dec 14 01:21:24.287 INFO [stderr]    Compiling heliometer v0.5.10 (/source)
Dec 14 01:21:27.531 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 03s
Dec 14 01:21:27.542 INFO [stderr] su: No module specific data is present
Dec 14 01:21:28.107 INFO running `"docker" "inspect" "4a16c9fa61ddee4e74ce83f6266346e792f3d2862bfa7b9284128428add9f051"`
Dec 14 01:21:28.426 INFO running `"docker" "rm" "-f" "4a16c9fa61ddee4e74ce83f6266346e792f3d2862bfa7b9284128428add9f051"`
Dec 14 01:21:28.763 INFO [stdout] 4a16c9fa61ddee4e74ce83f6266346e792f3d2862bfa7b9284128428add9f051
Dec 14 01:21:28.769 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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:21:29.247 INFO [stdout] 52a837e0886e964304e7019db81207fac4eb0ec876d1b5c5c1975a3c28c4a6fc
Dec 14 01:21:29.252 INFO running `"docker" "start" "-a" "52a837e0886e964304e7019db81207fac4eb0ec876d1b5c5c1975a3c28c4a6fc"`
Dec 14 01:21:30.427 INFO [stderr] usermod: no changes
Dec 14 01:21:30.667 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.20s
Dec 14 01:21:30.678 INFO [stderr]      Running /target/debug/deps/heliometer-745adc3567aeda17
Dec 14 01:21:30.681 INFO [stderr]      Running /target/debug/deps/helio-affce092f0669edd
Dec 14 01:21:30.681 INFO [stdout] 
Dec 14 01:21:30.681 INFO [stdout] running 0 tests
Dec 14 01:21:30.681 INFO [stdout] 
Dec 14 01:21:30.681 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 01:21:30.681 INFO [stdout] 
Dec 14 01:21:30.684 INFO [stdout] 
Dec 14 01:21:30.684 INFO [stderr]      Running /target/debug/deps/tests-cc0f6aa00cf42603
Dec 14 01:21:30.684 INFO [stdout] running 0 tests
Dec 14 01:21:30.684 INFO [stdout] 
Dec 14 01:21:30.684 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 01:21:30.684 INFO [stdout] 
Dec 14 01:21:30.688 INFO [stdout] 
Dec 14 01:21:30.688 INFO [stdout] running 5 tests
Dec 14 01:21:30.691 INFO [stdout] test tests::overflow ... ok
Dec 14 01:21:30.691 INFO [stdout] test tests::other_program_check ... ok
Dec 14 01:21:30.967 INFO [stdout] test integration::without_args ... ok
Dec 14 01:21:30.979 INFO [stdout] test tests::unmatched_right_bracket ... ok
Dec 14 01:21:33.432 INFO [stdout] test tests::far_right ... ok
Dec 14 01:21:33.432 INFO [stdout] 
Dec 14 01:21:33.432 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 01:21:33.432 INFO [stdout] 
Dec 14 01:21:33.439 INFO [stderr]    Doc-tests heliometer
Dec 14 01:21:34.078 INFO [stdout] 
Dec 14 01:21:34.078 INFO [stdout] running 1 test
Dec 14 01:21:35.275 INFO [stdout] test src/lib.rs - execute (line 178) ... ok
Dec 14 01:21:35.275 INFO [stdout] 
Dec 14 01:21:35.275 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 01:21:35.275 INFO [stdout] 
Dec 14 01:21:35.285 INFO [stderr] su: No module specific data is present
Dec 14 01:21:35.963 INFO running `"docker" "inspect" "52a837e0886e964304e7019db81207fac4eb0ec876d1b5c5c1975a3c28c4a6fc"`
Dec 14 01:21:36.281 INFO running `"docker" "rm" "-f" "52a837e0886e964304e7019db81207fac4eb0ec876d1b5c5c1975a3c28c4a6fc"`
Dec 14 01:21:36.695 INFO [stdout] 52a837e0886e964304e7019db81207fac4eb0ec876d1b5c5c1975a3c28c4a6fc