Mon Aug 19 22:28:31 2019: Sub-job Computing digest starting Mon Aug 19 22:28:31 2019: Check /Volumes/POHL_4TB/amos_ol/tergum/english/AMOS ENG_en.srt yes answer yes Thu Aug 22 04:21:21 2019: Check /Volumes/POHL_4TB/amos_ol/tergum/english/AMOS ENG_en.srt yes answer yes Thu Aug 22 04:21:35 2019: Probing with "/Applications/Video/DCP-o-matic 2.app/Contents/MacOS/ffprobe" "/Volumes/POHL_4TB/amos_ol/Exports/POHL (US) DCP Master v7 24p 51.mov" 2> "/Volumes/POHL_4TB/amos_ol/Exports/US DCP/POHL-DCPv7/ffprobe.log" Thu Aug 22 04:21:36 2019: Sub-job Computing digest starting Thu Aug 22 04:21:36 2019: WARNING: No codec found for stream 2 Thu Aug 22 04:21:36 2019: Video length obtained from header as 107578 frames Thu Aug 22 04:21:40 2019: WARNING: No codec found for stream 2 Thu Aug 22 04:21:40 2019: New graph for 1920x1080, pixel format 74 Thu Aug 22 04:21:41 2019: FFmpeg: Warning: data is not aligned! This can lead to a speedloss Thu Aug 22 04:21:41 2019: Check /Volumes/POHL_4TB/amos_ol/Exports/POHL (US) DCP Master v7 24p 51.mov yes answer yes Thu Aug 22 04:21:41 2019: WARNING: No codec found for stream 2 Thu Aug 22 04:21:41 2019: New graph for 1920x1080, pixel format 74 Thu Aug 22 04:22:50 2019: WARNING: No codec found for stream 2 Thu Aug 22 04:22:51 2019: WARNING: No codec found for stream 2 Fri Aug 23 03:27:15 2019: WARNING: No codec found for stream 2 Fri Aug 23 03:27:15 2019: WARNING: No codec found for stream 2 Fri Aug 23 03:27:15 2019: New graph for 1920x1080, pixel format 74 Fri Aug 23 03:27:15 2019: FFmpeg: Warning: data is not aligned! This can lead to a speedloss Fri Aug 23 03:27:15 2019: Check /Volumes/POHL_4TB/amos_ol/Exports/POHL (US) DCP Master v7 24p 51.mov yes answer yes Fri Aug 23 03:27:25 2019: WARNING: No codec found for stream 2 Fri Aug 23 03:27:25 2019: WARNING: No codec found for stream 2 Fri Aug 23 03:42:16 2019: DCP-o-matic 2.12.15 git a75aaf6175 using libavcodec 57.66.103, libavfilter 6.67.100, libavformat 57.57.100, libavutil 55.40.100, libswscale 4.3.101, ImageMagick 6.7.7-10 2018-03-13 Q16 http://www.imagemagick.org, libssh 0.7.3/openssl/zlib, libdcp 1.5.5 git 513cfbd993 Fri Aug 23 03:42:16 2019: Host name MacPro.local Fri Aug 23 03:42:16 2019: DCP-o-matic built in optimised mode. Fri Aug 23 03:42:16 2019: libdcp built in optimised mode. Fri Aug 23 03:42:16 2019: Built for 64-bit Fri Aug 23 03:42:16 2019: CPU: Intel(R) Xeon(R) CPU X5550 @ 2.67GHz, 16 processors Fri Aug 23 03:42:16 2019: Content: POHL (US) DCP Master v7 24p 51.mov cbc890390fb9f3c919d923cc96c2916682080478206 0 - video: length 107578 frames, size 1920x1080, sample aspect ratio 1 - audio: stream channels 6 rate 48000 ffmpeg: audio id 2 subtitle none filters Fri Aug 23 03:42:16 2019: DCP video rate 24 fps Fri Aug 23 03:42:16 2019: 16 threads Fri Aug 23 03:42:16 2019: J2K bandwidth 100000000 Fri Aug 23 03:42:16 2019: WARNING: No codec found for stream 2 Fri Aug 23 03:42:17 2019: Transcode job starting Fri Aug 23 03:42:17 2019: Sub-job Checking existing image data starting Fri Aug 23 03:42:17 2019: Could not open existing asset at /Volumes/POHL_4TB/amos_ol/Exports/US DCP/POHL-DCPv7/video/185_2K_8dba8191ae0945214e9ea8c3546be8bb_24_100000000_P_S_0_430312000.mxf (errno=2) Fri Aug 23 03:42:17 2019: Sub-job Encoding starting Fri Aug 23 03:42:17 2019: New graph for 1920x1080, pixel format 74 Fri Aug 23 08:16:42 2019: Clearing queue of 23 Fri Aug 23 08:16:44 2019: Terminating encoder threads Fri Aug 23 08:16:44 2019: Terminating thread 1 of 16 Fri Aug 23 08:16:44 2019: Thread terminated Fri Aug 23 08:16:44 2019: Terminating thread 2 of 16 Fri Aug 23 08:16:44 2019: Thread terminated Fri Aug 23 08:16:44 2019: Terminating thread 3 of 16 Fri Aug 23 08:16:44 2019: Thread terminated Fri Aug 23 08:16:44 2019: Terminating thread 4 of 16 Fri Aug 23 08:16:44 2019: Thread terminated Fri Aug 23 08:16:44 2019: Terminating thread 5 of 16 Fri Aug 23 08:16:44 2019: Thread terminated Fri Aug 23 08:16:44 2019: Terminating thread 6 of 16 Fri Aug 23 08:16:44 2019: Thread terminated Fri Aug 23 08:16:44 2019: Terminating thread 7 of 16 Fri Aug 23 08:16:44 2019: Thread terminated Fri Aug 23 08:16:44 2019: Terminating thread 8 of 16 Fri Aug 23 08:16:44 2019: Thread terminated Fri Aug 23 08:16:44 2019: Terminating thread 9 of 16 Fri Aug 23 08:16:44 2019: Thread terminated Fri Aug 23 08:16:44 2019: Terminating thread 10 of 16 Fri Aug 23 08:16:44 2019: Thread terminated Fri Aug 23 08:16:44 2019: Terminating thread 11 of 16 Fri Aug 23 08:16:44 2019: Thread terminated Fri Aug 23 08:16:44 2019: Terminating thread 12 of 16 Fri Aug 23 08:16:44 2019: Thread terminated Fri Aug 23 08:16:44 2019: Terminating thread 13 of 16 Fri Aug 23 08:16:44 2019: Thread terminated Fri Aug 23 08:16:44 2019: Terminating thread 14 of 16 Fri Aug 23 08:16:44 2019: Thread terminated Fri Aug 23 08:16:44 2019: Terminating thread 15 of 16 Fri Aug 23 08:16:44 2019: Thread terminated Fri Aug 23 08:16:44 2019: Terminating thread 16 of 16 Fri Aug 23 08:16:44 2019: Thread terminated Fri Aug 23 08:16:44 2019: Mopping up 0 Fri Aug 23 08:16:44 2019: Terminating writer thread Fri Aug 23 08:16:44 2019: Finishing ReelWriters Fri Aug 23 08:16:46 2019: WARNING: Hard-link failed; copying instead Fri Aug 23 08:37:31 2019: Writing XML Fri Aug 23 08:37:31 2019: Sub-job Computing digests starting Fri Aug 23 08:44:59 2019: create_reel for 0-430312000; 0 of 1 Fri Aug 23 08:45:00 2019: Wrote 103614 FULL, 0 FAKE, 3964 REPEAT, 0 pushed to disk Fri Aug 23 08:45:00 2019: Transcode job completed successfully: 5 fps Tue Sep 3 16:23:44 2019: ERROR: Error in job: Could not open /Volumes/POHL_4TB/amos_ol/Exports/POHL (US) DCP Master v7 24p 51.mov (DCP-o-matic could not open the file /Volumes/POHL_4TB/amos_ol/Exports/POHL (US) DCP Master v7 24p 51.mov (boost::filesystem::last_write_time: No such file or directory: "/Volumes/POHL_4TB/amos_ol/Exports/POHL (US) DCP Master v7 24p 51.mov"). Perhaps it does not exist or is in an unexpected format.) Tue Sep 3 17:29:29 2019: Sub-job Computing digest starting Tue Sep 3 17:29:29 2019: WARNING: No codec found for stream 2 Tue Sep 3 17:29:29 2019: Video length obtained from header as 107578 frames Tue Sep 3 17:29:32 2019: WARNING: No codec found for stream 2 Tue Sep 3 17:29:32 2019: New graph for 1920x1080, pixel format 66 Tue Sep 3 17:29:32 2019: FFmpeg: Warning: data is not aligned! This can lead to a speed loss Tue Sep 3 18:45:50 2019: WARNING: No codec found for stream 2 Tue Sep 3 18:45:50 2019: WARNING: No codec found for stream 2 Tue Sep 3 18:46:06 2019: DCP-o-matic 2.14.10 git 3c7d19089d using libavcodec 58.42.100, libavfilter 7.46.101, libavformat 58.24.100, libavutil 56.24.101, libswscale 5.4.100, libssh 0.7.3/openssl/zlib, libdcp 1.6.8 git c6d1877472 Tue Sep 3 18:46:06 2019: Host name MacPro.local Tue Sep 3 18:46:06 2019: DCP-o-matic built in optimised mode. Tue Sep 3 18:46:06 2019: libdcp built in optimised mode. Tue Sep 3 18:46:06 2019: Built for 64-bit Tue Sep 3 18:46:06 2019: CPU: Intel(R) Xeon(R) CPU X5550 @ 2.67GHz, 16 processors Tue Sep 3 18:46:06 2019: Content: POHL (US) DCP Master v7 24p subs 51.mov cbc890390fb9f3c919d923cc96c2916682080478206 0 24 - video: length 107578 frames, size 1920x1080, sample aspect ratio 1 - audio: stream channels 6 rate 48000 ffmpeg: audio id 2 subtitle none filters Tue Sep 3 18:46:06 2019: DCP video rate 24 fps Tue Sep 3 18:46:06 2019: 14 threads Tue Sep 3 18:46:06 2019: J2K bandwidth 100000000 Tue Sep 3 18:46:06 2019: WARNING: No codec found for stream 2 Tue Sep 3 18:46:06 2019: Transcode job starting Tue Sep 3 18:46:06 2019: Sub-job Checking existing image data starting Tue Sep 3 18:46:06 2019: Opened existing asset at /Volumes/POHL_4TB/amos_ol/Exports/US DCP/POHL-DCPv7/video/185_2K_8dba8191ae0945214e9ea8c3546be8bb_24_100000000_P_S_0_430312000.mxf Tue Sep 3 18:46:06 2019: The last FI is 107577; info file is 5163744, info size 48 Tue Sep 3 18:46:06 2019: Checking existing picture frame 107577 Tue Sep 3 18:46:06 2019: Read 1338 bytes of asset data; wanted 1338 Tue Sep 3 18:46:06 2019: Hash 9fc3bf29f9dc69057140ecf07eeeba40 vs 9fc3bf29f9dc69057140ecf07eeeba40 Tue Sep 3 18:46:06 2019: Proceeding with first nonexistant frame 107578 Tue Sep 3 18:46:06 2019: Sub-job Encoding starting Tue Sep 3 18:46:06 2019: New graph for 1920x1080, pixel format 66 Tue Sep 3 19:30:09 2019: Clearing queue of 0 Tue Sep 3 19:30:09 2019: Terminating encoder threads Tue Sep 3 19:30:09 2019: Terminating thread 1 of 14 Tue Sep 3 19:30:09 2019: Thread terminated Tue Sep 3 19:30:09 2019: Terminating thread 2 of 14 Tue Sep 3 19:30:09 2019: Thread terminated Tue Sep 3 19:30:09 2019: Terminating thread 3 of 14 Tue Sep 3 19:30:09 2019: Thread terminated Tue Sep 3 19:30:09 2019: Terminating thread 4 of 14 Tue Sep 3 19:30:09 2019: Thread terminated Tue Sep 3 19:30:09 2019: Terminating thread 5 of 14 Tue Sep 3 19:30:09 2019: Thread terminated Tue Sep 3 19:30:09 2019: Terminating thread 6 of 14 Tue Sep 3 19:30:09 2019: Thread terminated Tue Sep 3 19:30:09 2019: Terminating thread 7 of 14 Tue Sep 3 19:30:09 2019: Thread terminated Tue Sep 3 19:30:09 2019: Terminating thread 8 of 14 Tue Sep 3 19:30:09 2019: Thread terminated Tue Sep 3 19:30:09 2019: Terminating thread 9 of 14 Tue Sep 3 19:30:09 2019: Thread terminated Tue Sep 3 19:30:09 2019: Terminating thread 10 of 14 Tue Sep 3 19:30:09 2019: Thread terminated Tue Sep 3 19:30:09 2019: Terminating thread 11 of 14 Tue Sep 3 19:30:09 2019: Thread terminated Tue Sep 3 19:30:09 2019: Terminating thread 12 of 14 Tue Sep 3 19:30:09 2019: Thread terminated Tue Sep 3 19:30:09 2019: Terminating thread 13 of 14 Tue Sep 3 19:30:09 2019: Thread terminated Tue Sep 3 19:30:09 2019: Terminating thread 14 of 14 Tue Sep 3 19:30:09 2019: Thread terminated Tue Sep 3 19:30:09 2019: Mopping up 0 Tue Sep 3 19:30:09 2019: Terminating writer thread Tue Sep 3 19:30:09 2019: Finishing ReelWriters Tue Sep 3 19:30:09 2019: WARNING: Hard-link failed; copying instead Tue Sep 3 19:56:05 2019: Writing XML Tue Sep 3 19:56:05 2019: Sub-job Computing digests starting Tue Sep 3 20:03:50 2019: create_reel for 0-430312000; 0 of 1 Tue Sep 3 20:03:50 2019: Wrote 1 FULL, 107577 FAKE, 0 REPEAT, 0 pushed to disk Tue Sep 3 20:03:50 2019: Transcode job completed successfully: 23 fps