Dec 14 15:32:04.639 INFO testing tztail-1.2.0 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 14 15:32:04.639 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 15:32:04.829 INFO [stdout] c282a4d4cd15f5afb630f7d39712fa09eb97e4d3ffd36a19fb014d67a3718922
Dec 14 15:32:04.831 INFO running `"docker" "start" "-a" "c282a4d4cd15f5afb630f7d39712fa09eb97e4d3ffd36a19fb014d67a3718922"`
Dec 14 15:32:05.231 INFO [stderr] usermod: no changes
Dec 14 15:32:05.352 INFO [stderr]    Compiling term_size v0.3.1
Dec 14 15:32:05.352 INFO [stderr]    Compiling parse-zoneinfo v0.2.0
Dec 14 15:32:05.831 INFO [stderr]    Compiling textwrap v0.10.0
Dec 14 15:32:07.012 INFO [stderr]    Compiling clap v2.32.0
Dec 14 15:32:09.135 INFO [stderr]    Compiling chrono-tz v0.5.0
Dec 14 15:32:29.520 INFO [stderr]    Compiling tztail v1.2.0 (/source)
Dec 14 15:32:32.784 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 27.54s
Dec 14 15:32:32.791 INFO [stderr] su: No module specific data is present
Dec 14 15:32:33.081 INFO running `"docker" "inspect" "c282a4d4cd15f5afb630f7d39712fa09eb97e4d3ffd36a19fb014d67a3718922"`
Dec 14 15:32:33.201 INFO running `"docker" "rm" "-f" "c282a4d4cd15f5afb630f7d39712fa09eb97e4d3ffd36a19fb014d67a3718922"`
Dec 14 15:32:33.338 INFO [stdout] c282a4d4cd15f5afb630f7d39712fa09eb97e4d3ffd36a19fb014d67a3718922
Dec 14 15:32:33.347 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 15:32:33.599 INFO [stdout] d2689641dba8ccd58fa987bdc5ff8b7fef82f94fc6f524e52d8259884906e97d
Dec 14 15:32:33.607 INFO running `"docker" "start" "-a" "d2689641dba8ccd58fa987bdc5ff8b7fef82f94fc6f524e52d8259884906e97d"`
Dec 14 15:32:34.098 INFO [stderr] usermod: no changes
Dec 14 15:32:34.206 INFO [stderr]    Compiling escargot v0.3.1
Dec 14 15:32:34.208 INFO [stderr]    Compiling predicates v1.0.0
Dec 14 15:32:34.211 INFO [stderr]    Compiling serde_json v1.0.33
Dec 14 15:32:41.415 INFO [stderr]    Compiling assert_cmd v0.10.2
Dec 14 15:32:43.409 INFO [stderr]    Compiling tztail v1.2.0 (/source)
Dec 14 15:32:47.358 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 13.24s
Dec 14 15:32:47.366 INFO [stderr] su: No module specific data is present
Dec 14 15:32:47.750 INFO running `"docker" "inspect" "d2689641dba8ccd58fa987bdc5ff8b7fef82f94fc6f524e52d8259884906e97d"`
Dec 14 15:32:47.950 INFO running `"docker" "rm" "-f" "d2689641dba8ccd58fa987bdc5ff8b7fef82f94fc6f524e52d8259884906e97d"`
Dec 14 15:32:48.181 INFO [stdout] d2689641dba8ccd58fa987bdc5ff8b7fef82f94fc6f524e52d8259884906e97d
Dec 14 15:32:48.183 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 15:32:48.519 INFO [stdout] 2f779da5c8b5720ec7fc795b673903eff1340506c14bd121e173b7fc4439a7ef
Dec 14 15:32:48.520 INFO running `"docker" "start" "-a" "2f779da5c8b5720ec7fc795b673903eff1340506c14bd121e173b7fc4439a7ef"`
Dec 14 15:32:49.381 INFO [stderr] usermod: no changes
Dec 14 15:32:49.491 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.09s
Dec 14 15:32:49.505 INFO [stderr]      Running /target/debug/deps/tztail-cf640ae2839a465f
Dec 14 15:32:49.509 INFO [stdout] 
Dec 14 15:32:49.509 INFO [stdout] running 4 tests
Dec 14 15:32:49.559 INFO [stdout] test format::format_tests::test_new ... ok
Dec 14 15:32:49.640 INFO [stdout] test format::format_tests::test_new_with_timezone ... ok
Dec 14 15:32:50.312 INFO [stdout] test converter::converter_tests::test_new ... ok
Dec 14 15:32:50.742 INFO [stdout] test converter::converter_tests::test_convert ... ok
Dec 14 15:32:50.742 INFO [stdout] 
Dec 14 15:32:50.742 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 15:32:50.742 INFO [stdout] 
Dec 14 15:32:50.747 INFO [stderr]      Running /target/debug/deps/integration_tests-aa7ab5b571d160e7
Dec 14 15:32:50.747 INFO [stdout] 
Dec 14 15:32:50.747 INFO [stdout] running 5 tests
Dec 14 15:32:50.892 INFO [stdout] test test_custom_format ... ok
Dec 14 15:32:50.931 INFO [stdout] test test_default_utc ... ok
Dec 14 15:32:51.104 INFO [stdout] test test_target_timezone ... ok
Dec 14 15:32:51.187 INFO [stdout] test test_read_from_file ... ok
Dec 14 15:32:51.214 INFO [stdout] test test_stdin ... ok
Dec 14 15:32:51.214 INFO [stdout] 
Dec 14 15:32:51.214 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 15:32:51.214 INFO [stdout] 
Dec 14 15:32:51.217 INFO [stderr] su: No module specific data is present
Dec 14 15:32:51.589 INFO running `"docker" "inspect" "2f779da5c8b5720ec7fc795b673903eff1340506c14bd121e173b7fc4439a7ef"`
Dec 14 15:32:51.778 INFO running `"docker" "rm" "-f" "2f779da5c8b5720ec7fc795b673903eff1340506c14bd121e173b7fc4439a7ef"`
Dec 14 15:32:51.916 INFO [stdout] 2f779da5c8b5720ec7fc795b673903eff1340506c14bd121e173b7fc4439a7ef