Dec 14 14:38:32.360 INFO testing video-timecode-0.5.3 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 14 14:38:32.360 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-3/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/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 14:38:32.630 INFO [stdout] 192b898c8725bddd6f6c426d9a9def24e04cea34b89f38baa71c7995c7fc62af
Dec 14 14:38:32.632 INFO running `"docker" "start" "-a" "192b898c8725bddd6f6c426d9a9def24e04cea34b89f38baa71c7995c7fc62af"`
Dec 14 14:38:33.184 INFO [stderr] usermod: no changes
Dec 14 14:38:33.206 INFO [stderr]    Compiling video-timecode v0.5.3 (/source)
Dec 14 14:38:33.903 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.70s
Dec 14 14:38:33.903 INFO [stderr] su: No module specific data is present
Dec 14 14:38:34.511 INFO running `"docker" "inspect" "192b898c8725bddd6f6c426d9a9def24e04cea34b89f38baa71c7995c7fc62af"`
Dec 14 14:38:34.794 INFO running `"docker" "rm" "-f" "192b898c8725bddd6f6c426d9a9def24e04cea34b89f38baa71c7995c7fc62af"`
Dec 14 14:38:35.130 INFO [stdout] 192b898c8725bddd6f6c426d9a9def24e04cea34b89f38baa71c7995c7fc62af
Dec 14 14:38:35.136 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-3/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/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 14:38:35.611 INFO [stdout] 8b753cc0892e62d89c5cbc38056fd94dfd176e6bc5c05e215c706089b0540ed7
Dec 14 14:38:35.611 INFO running `"docker" "start" "-a" "8b753cc0892e62d89c5cbc38056fd94dfd176e6bc5c05e215c706089b0540ed7"`
Dec 14 14:38:36.481 INFO [stderr] usermod: no changes
Dec 14 14:38:36.535 INFO [stderr]    Compiling video-timecode v0.5.3 (/source)
Dec 14 14:38:38.637 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.12s
Dec 14 14:38:38.639 INFO [stderr] su: No module specific data is present
Dec 14 14:38:38.992 INFO running `"docker" "inspect" "8b753cc0892e62d89c5cbc38056fd94dfd176e6bc5c05e215c706089b0540ed7"`
Dec 14 14:38:39.075 INFO running `"docker" "rm" "-f" "8b753cc0892e62d89c5cbc38056fd94dfd176e6bc5c05e215c706089b0540ed7"`
Dec 14 14:38:39.240 INFO [stdout] 8b753cc0892e62d89c5cbc38056fd94dfd176e6bc5c05e215c706089b0540ed7
Dec 14 14:38:39.244 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-3/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/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 14:38:39.429 INFO [stdout] c564a7bfc94f6361a282fa1a76671dce75545b7aae448a01b3264137b3ead349
Dec 14 14:38:39.432 INFO running `"docker" "start" "-a" "c564a7bfc94f6361a282fa1a76671dce75545b7aae448a01b3264137b3ead349"`
Dec 14 14:38:40.195 INFO [stderr] usermod: no changes
Dec 14 14:38:40.228 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.01s
Dec 14 14:38:40.229 INFO [stderr]      Running /target/debug/deps/video_timecode-06b9346d979b1d83
Dec 14 14:38:40.230 INFO [stdout] 
Dec 14 14:38:40.230 INFO [stdout] running 0 tests
Dec 14 14:38:40.230 INFO [stdout] 
Dec 14 14:38:40.230 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 14:38:40.230 INFO [stdout] 
Dec 14 14:38:40.230 INFO [stderr]      Running /target/debug/deps/video_timecode-2ecd1a4ded9cf941
Dec 14 14:38:40.232 INFO [stdout] 
Dec 14 14:38:40.232 INFO [stdout] running 70 tests
Dec 14 14:38:40.233 INFO [stdout] test add_assign_frames_negative_5994 ... ok
Dec 14 14:38:40.233 INFO [stdout] test add_assign_frames_negative_2997 ... ok
Dec 14 14:38:40.233 INFO [stdout] test add_assign_frames_500 ... ok
Dec 14 14:38:40.233 INFO [stdout] test add_frames_500 ... ok
Dec 14 14:38:40.233 INFO [stdout] test add_assign_frames_1000_df ... ok
Dec 14 14:38:40.233 INFO [stdout] test add_frames_negative_2997 ... ok
Dec 14 14:38:40.233 INFO [stdout] test add_assign_frames_1 ... ok
Dec 14 14:38:40.233 INFO [stdout] test add_frames_negative_5994 ... ok
Dec 14 14:38:40.233 INFO [stdout] test add_timecode_1 ... ok
Dec 14 14:38:40.234 INFO [stdout] test add_timecode_1000000_df ... ok
Dec 14 14:38:40.234 INFO [stdout] test add_timecode_1000_df ... ok
Dec 14 14:38:40.234 INFO [stdout] test add_timecode_500 ... ok
Dec 14 14:38:40.234 INFO [stdout] test dropped_timecode_2997 ... ok
Dec 14 14:38:40.234 INFO [stdout] test dropped_timecode_5994 ... ok
Dec 14 14:38:40.234 INFO [stdout] test format_df ... ok
Dec 14 14:38:40.234 INFO [stdout] test format_ndf ... ok
Dec 14 14:38:40.234 INFO [stdout] test frame_number_2398_with_frames ... ok
Dec 14 14:38:40.234 INFO [stdout] test frame_number_2398_with_hours ... ok
Dec 14 14:38:40.234 INFO [stdout] test frame_number_2398_with_minutes ... ok
Dec 14 14:38:40.234 INFO [stdout] test frame_number_2398_with_seconds ... ok
Dec 14 14:38:40.234 INFO [stdout] test frame_number_2398_zero ... ok
Dec 14 14:38:40.234 INFO [stdout] test frame_number_24_with_frames ... ok
Dec 14 14:38:40.234 INFO [stdout] test frame_number_24_with_hours ... ok
Dec 14 14:38:40.234 INFO [stdout] test frame_number_24_with_minutes ... ok
Dec 14 14:38:40.234 INFO [stdout] test frame_number_24_with_seconds ... ok
Dec 14 14:38:40.234 INFO [stdout] test frame_number_24_zero ... ok
Dec 14 14:38:40.234 INFO [stdout] test frame_number_25_with_frames ... ok
Dec 14 14:38:40.234 INFO [stdout] test frame_number_25_with_hours ... ok
Dec 14 14:38:40.234 INFO [stdout] test frame_number_25_with_minutes ... ok
Dec 14 14:38:40.234 INFO [stdout] test frame_number_2997_with_frames ... ok
Dec 14 14:38:40.234 INFO [stdout] test frame_number_25_with_seconds ... ok
Dec 14 14:38:40.234 INFO [stdout] test frame_number_25_zero ... ok
Dec 14 14:38:40.234 INFO [stdout] test add_frames_1000000_df ... ok
Dec 14 14:38:40.234 INFO [stdout] test add_frames_1000_df ... ok
Dec 14 14:38:40.234 INFO [stdout] test add_frames_1 ... ok
Dec 14 14:38:40.234 INFO [stdout] test frame_number_2997_with_hours ... ok
Dec 14 14:38:40.234 INFO [stdout] test frame_number_2997_with_minutes ... ok
Dec 14 14:38:40.234 INFO [stdout] test frame_number_2997_zero ... ok
Dec 14 14:38:40.234 INFO [stdout] test frame_number_30_with_frames ... ok
Dec 14 14:38:40.234 INFO [stdout] test frame_number_30_with_hours ... ok
Dec 14 14:38:40.235 INFO [stdout] test frame_number_2997_with_seconds ... ok
Dec 14 14:38:40.235 INFO [stdout] test frame_number_30_with_seconds ... ok
Dec 14 14:38:40.235 INFO [stdout] test frame_number_50_with_frames ... ok
Dec 14 14:38:40.235 INFO [stdout] test frame_number_30_zero ... ok
Dec 14 14:38:40.235 INFO [stdout] test frame_number_50_with_hours ... ok
Dec 14 14:38:40.236 INFO [stdout] test frame_number_30_with_minutes ... ok
Dec 14 14:38:40.236 INFO [stdout] test frame_number_50_with_seconds ... ok
Dec 14 14:38:40.236 INFO [stdout] test frame_number_50_zero ... ok
Dec 14 14:38:40.236 INFO [stdout] test frame_number_5994_with_frames ... ok
Dec 14 14:38:40.236 INFO [stdout] test frame_number_5994_with_hours ... ok
Dec 14 14:38:40.236 INFO [stdout] test frame_number_5994_with_minutes ... ok
Dec 14 14:38:40.236 INFO [stdout] test frame_number_5994_with_seconds ... ok
Dec 14 14:38:40.236 INFO [stdout] test frame_number_5994_zero ... ok
Dec 14 14:38:40.236 INFO [stdout] test frame_number_60_with_frames ... ok
Dec 14 14:38:40.236 INFO [stdout] test frame_number_60_with_hours ... ok
Dec 14 14:38:40.236 INFO [stdout] test frame_number_60_with_minutes ... ok
Dec 14 14:38:40.236 INFO [stdout] test frame_number_60_with_seconds ... ok
Dec 14 14:38:40.236 INFO [stdout] test parse_0 ... ok
Dec 14 14:38:40.236 INFO [stdout] test parse_0_df_all_dot ... ok
Dec 14 14:38:40.236 INFO [stdout] test parse_0_df_all_semicolon ... ok
Dec 14 14:38:40.236 INFO [stdout] test parse_0_df_for_ndf_frame_rate ... ok
Dec 14 14:38:40.236 INFO [stdout] test parse_0_df_mixed ... ok
Dec 14 14:38:40.236 INFO [stdout] test parse_0_df_one_semicolon ... ok
Dec 14 14:38:40.236 INFO [stdout] test parse_1000000_df ... ok
Dec 14 14:38:40.236 INFO [stdout] test parse_500 ... ok
Dec 14 14:38:40.236 INFO [stdout] test frame_number_50_with_minutes ... ok
Dec 14 14:38:40.236 INFO [stdout] test sub_frames_500 ... ok
Dec 14 14:38:40.236 INFO [stdout] test subtract_frames_1 ... ok
Dec 14 14:38:40.237 INFO [stdout] test frame_number_60_zero ... ok
Dec 14 14:38:40.237 INFO [stdout] test parse_0_df_one_dot ... ok
Dec 14 14:38:40.237 INFO [stderr]    Doc-tests video-timecode
Dec 14 14:38:40.237 INFO [stdout] 
Dec 14 14:38:40.237 INFO [stdout] test result: ok. 70 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 14:38:40.237 INFO [stdout] 
Dec 14 14:38:41.011 INFO [stdout] 
Dec 14 14:38:41.011 INFO [stdout] running 10 tests
Dec 14 14:38:42.849 INFO [stdout] test src/lib.rs - Timecode (line 39) ... ok
Dec 14 14:38:42.964 INFO [stdout] test src/lib.rs - Timecode<T> (line 429) ... ok
Dec 14 14:38:43.291 INFO [stdout] test src/lib.rs - Timecode<T> (line 139) ... ok
Dec 14 14:38:43.293 INFO [stdout] test src/lib.rs - Timecode<T> (line 121) ... ok
Dec 14 14:38:43.383 INFO [stdout] test src/lib.rs - Timecode<T>::Err (line 165) ... ok
Dec 14 14:38:43.491 INFO [stdout] test src/lib.rs - Timecode<T> (line 442) ... ok
Dec 14 14:38:43.595 INFO [stdout] test src/lib.rs - Timecode<T> (line 412) ... ok
Dec 14 14:38:43.627 INFO [stdout] test src/lib.rs - Timecode<T> (line 465) ... ok
Dec 14 14:38:44.605 INFO [stdout] test src/lib.rs - Timecode<T>::new (line 77) ... ok
Dec 14 14:38:44.619 INFO [stdout] test src/lib.rs - Timecode<T>::Err (line 180) ... ok
Dec 14 14:38:44.619 INFO [stdout] 
Dec 14 14:38:44.619 INFO [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 14:38:44.619 INFO [stdout] 
Dec 14 14:38:44.639 INFO [stderr] su: No module specific data is present
Dec 14 14:38:45.138 INFO running `"docker" "inspect" "c564a7bfc94f6361a282fa1a76671dce75545b7aae448a01b3264137b3ead349"`
Dec 14 14:38:45.415 INFO running `"docker" "rm" "-f" "c564a7bfc94f6361a282fa1a76671dce75545b7aae448a01b3264137b3ead349"`
Dec 14 14:38:45.703 INFO [stdout] c564a7bfc94f6361a282fa1a76671dce75545b7aae448a01b3264137b3ead349