Dec 06 18:01:05.007 INFO testing video-timecode-0.5.3 against try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468 for pr-56514
Dec 06 18:01:05.008 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-4/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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 06 18:01:05.224 INFO [stdout] 977802948acf5da3d600afc955e8c139e00a0ce9104c365dbc39556d66c85c8e
Dec 06 18:01:05.226 INFO running `"docker" "start" "-a" "977802948acf5da3d600afc955e8c139e00a0ce9104c365dbc39556d66c85c8e"`
Dec 06 18:01:05.992 INFO [stderr] usermod: no changes
Dec 06 18:01:06.040 INFO [stderr]    Compiling video-timecode v0.5.3 (/source)
Dec 06 18:01:06.570 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.55s
Dec 06 18:01:06.572 INFO [stderr] su: No module specific data is present
Dec 06 18:01:06.862 INFO running `"docker" "inspect" "977802948acf5da3d600afc955e8c139e00a0ce9104c365dbc39556d66c85c8e"`
Dec 06 18:01:06.947 INFO running `"docker" "rm" "-f" "977802948acf5da3d600afc955e8c139e00a0ce9104c365dbc39556d66c85c8e"`
Dec 06 18:01:07.026 INFO [stdout] 977802948acf5da3d600afc955e8c139e00a0ce9104c365dbc39556d66c85c8e
Dec 06 18:01:07.030 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-4/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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 06 18:01:07.201 INFO [stdout] 2062bc2cbe13ed542356dc1c7313415b92c65320a83615feadd4183be03709af
Dec 06 18:01:07.206 INFO running `"docker" "start" "-a" "2062bc2cbe13ed542356dc1c7313415b92c65320a83615feadd4183be03709af"`
Dec 06 18:01:07.549 INFO [stderr] usermod: no changes
Dec 06 18:01:07.580 INFO [stderr]    Compiling video-timecode v0.5.3 (/source)
Dec 06 18:01:09.163 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.59s
Dec 06 18:01:09.165 INFO [stderr] su: No module specific data is present
Dec 06 18:01:10.484 INFO running `"docker" "inspect" "2062bc2cbe13ed542356dc1c7313415b92c65320a83615feadd4183be03709af"`
Dec 06 18:01:10.614 INFO running `"docker" "rm" "-f" "2062bc2cbe13ed542356dc1c7313415b92c65320a83615feadd4183be03709af"`
Dec 06 18:01:10.843 INFO [stdout] 2062bc2cbe13ed542356dc1c7313415b92c65320a83615feadd4183be03709af
Dec 06 18:01:10.845 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-4/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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 06 18:01:11.143 INFO [stdout] d04d2ea02fe8de7d1a226078abc0e8d72232473c53d0cbfd20a1ba1e1de23d66
Dec 06 18:01:11.145 INFO running `"docker" "start" "-a" "d04d2ea02fe8de7d1a226078abc0e8d72232473c53d0cbfd20a1ba1e1de23d66"`
Dec 06 18:01:11.498 INFO [stderr] usermod: no changes
Dec 06 18:01:11.522 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.01s
Dec 06 18:01:11.522 INFO [stderr]      Running /target/debug/deps/video_timecode-66ca7c45e4bf3838
Dec 06 18:01:11.524 INFO [stdout] 
Dec 06 18:01:11.524 INFO [stdout] running 0 tests
Dec 06 18:01:11.524 INFO [stdout] 
Dec 06 18:01:11.524 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 18:01:11.524 INFO [stdout] 
Dec 06 18:01:11.524 INFO [stderr]      Running /target/debug/deps/video_timecode-0e62a601b45ca7c5
Dec 06 18:01:11.525 INFO [stdout] 
Dec 06 18:01:11.525 INFO [stdout] running 70 tests
Dec 06 18:01:11.526 INFO [stdout] test add_frames_1 ... ok
Dec 06 18:01:11.526 INFO [stdout] test add_assign_frames_negative_2997 ... ok
Dec 06 18:01:11.526 INFO [stdout] test add_assign_frames_500 ... ok
Dec 06 18:01:11.526 INFO [stdout] test add_assign_frames_1 ... ok
Dec 06 18:01:11.526 INFO [stdout] test add_assign_frames_negative_5994 ... ok
Dec 06 18:01:11.526 INFO [stdout] test add_frames_1000000_df ... ok
Dec 06 18:01:11.526 INFO [stdout] test add_frames_1000_df ... ok
Dec 06 18:01:11.526 INFO [stdout] test add_frames_500 ... ok
Dec 06 18:01:11.526 INFO [stdout] test add_timecode_1 ... ok
Dec 06 18:01:11.526 INFO [stdout] test dropped_timecode_2997 ... ok
Dec 06 18:01:11.526 INFO [stdout] test add_frames_negative_5994 ... ok
Dec 06 18:01:11.526 INFO [stdout] test add_timecode_1000000_df ... ok
Dec 06 18:01:11.526 INFO [stdout] test add_frames_negative_2997 ... ok
Dec 06 18:01:11.526 INFO [stdout] test format_df ... ok
Dec 06 18:01:11.526 INFO [stdout] test frame_number_2398_with_frames ... ok
Dec 06 18:01:11.526 INFO [stdout] test add_timecode_500 ... ok
Dec 06 18:01:11.526 INFO [stdout] test dropped_timecode_5994 ... ok
Dec 06 18:01:11.527 INFO [stdout] test add_timecode_1000_df ... ok
Dec 06 18:01:11.527 INFO [stdout] test format_ndf ... ok
Dec 06 18:01:11.527 INFO [stdout] test frame_number_2398_with_hours ... ok
Dec 06 18:01:11.527 INFO [stdout] test frame_number_2398_with_minutes ... ok
Dec 06 18:01:11.527 INFO [stdout] test frame_number_2398_with_seconds ... ok
Dec 06 18:01:11.527 INFO [stdout] test frame_number_24_with_frames ... ok
Dec 06 18:01:11.527 INFO [stdout] test frame_number_2398_zero ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_24_with_hours ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_24_with_minutes ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_24_with_seconds ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_25_with_frames ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_25_with_hours ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_25_with_minutes ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_2997_with_frames ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_2997_with_hours ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_2997_with_minutes ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_2997_with_seconds ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_2997_zero ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_30_with_frames ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_30_with_hours ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_30_with_minutes ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_30_with_seconds ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_30_zero ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_50_with_frames ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_50_with_hours ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_50_with_minutes ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_50_with_seconds ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_50_zero ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_5994_with_frames ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_5994_with_hours ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_5994_with_seconds ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_5994_zero ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_5994_with_minutes ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_60_with_frames ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_60_with_hours ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_25_with_seconds ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_60_with_seconds ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_25_zero ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_24_zero ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_60_with_minutes ... ok
Dec 06 18:01:11.528 INFO [stdout] test parse_0 ... ok
Dec 06 18:01:11.528 INFO [stdout] test frame_number_60_zero ... ok
Dec 06 18:01:11.529 INFO [stdout] test parse_0_df_for_ndf_frame_rate ... ok
Dec 06 18:01:11.529 INFO [stdout] test parse_0_df_all_semicolon ... ok
Dec 06 18:01:11.529 INFO [stdout] test parse_0_df_all_dot ... ok
Dec 06 18:01:11.529 INFO [stdout] test parse_0_df_mixed ... ok
Dec 06 18:01:11.529 INFO [stdout] test parse_0_df_one_semicolon ... ok
Dec 06 18:01:11.529 INFO [stdout] test sub_frames_500 ... ok
Dec 06 18:01:11.529 INFO [stdout] test subtract_frames_1 ... ok
Dec 06 18:01:11.529 INFO [stdout] test parse_0_df_one_dot ... ok
Dec 06 18:01:11.529 INFO [stdout] test parse_500 ... ok
Dec 06 18:01:11.529 INFO [stdout] test parse_1000000_df ... ok
Dec 06 18:01:11.532 INFO [stdout] test add_assign_frames_1000_df ... ok
Dec 06 18:01:11.532 INFO [stdout] 
Dec 06 18:01:11.532 INFO [stdout] test result: ok. 70 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 18:01:11.532 INFO [stdout] 
Dec 06 18:01:11.532 INFO [stderr]    Doc-tests video-timecode
Dec 06 18:01:11.972 INFO [stdout] 
Dec 06 18:01:11.972 INFO [stdout] running 10 tests
Dec 06 18:01:12.684 INFO [stdout] test src/lib.rs - Timecode<T> (line 429) ... ok
Dec 06 18:01:13.189 INFO [stdout] test src/lib.rs - Timecode<T> (line 465) ... ok
Dec 06 18:01:13.667 INFO [stdout] test src/lib.rs - Timecode<T> (line 412) ... ok
Dec 06 18:01:13.772 INFO [stdout] test src/lib.rs - Timecode<T> (line 139) ... ok
Dec 06 18:01:14.028 INFO [stdout] test src/lib.rs - Timecode<T>::Err (line 165) ... ok
Dec 06 18:01:14.028 INFO [stdout] test src/lib.rs - Timecode<T> (line 442) ... ok
Dec 06 18:01:14.145 INFO [stdout] test src/lib.rs - Timecode<T> (line 121) ... ok
Dec 06 18:01:14.264 INFO [stdout] test src/lib.rs - Timecode (line 39) ... ok
Dec 06 18:01:14.651 INFO [stdout] test src/lib.rs - Timecode<T>::new (line 77) ... ok
Dec 06 18:01:14.700 INFO [stdout] test src/lib.rs - Timecode<T>::Err (line 180) ... ok
Dec 06 18:01:14.700 INFO [stdout] 
Dec 06 18:01:14.700 INFO [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 18:01:14.700 INFO [stdout] 
Dec 06 18:01:14.721 INFO [stderr] su: No module specific data is present
Dec 06 18:01:15.028 INFO running `"docker" "inspect" "d04d2ea02fe8de7d1a226078abc0e8d72232473c53d0cbfd20a1ba1e1de23d66"`
Dec 06 18:01:15.105 INFO running `"docker" "rm" "-f" "d04d2ea02fe8de7d1a226078abc0e8d72232473c53d0cbfd20a1ba1e1de23d66"`
Dec 06 18:01:15.169 INFO [stdout] d04d2ea02fe8de7d1a226078abc0e8d72232473c53d0cbfd20a1ba1e1de23d66