This post was last modified: 2020-01-19, 13:09 by
Gunther.
Edit Reason: put log in code wrapper.
Support request from Matt Coda, Vive Media, Charleston, EMail: matt@vive-media.com
License for: LRTimelapse 5, License type: professional, Payment reference: 4GT87415V4872650T, Valid until: Unlimited for LRT 5.x
Code:
[2020-01-18 18:08:27] INFO: Log file was created at /Users/vivemedia/LRTimelapse/LRTimelapse.log
[2020-01-18 18:08:27] DEBUG: Loading properties from /Users/vivemedia/Library/Application Support/LRTimelapse/user.props
[2020-01-18 18:08:27] INFO: LRTimelapse 5.3.3 (2019-11-28) Build 602
[2020-01-18 18:08:27] INFO: (c) 2020 Gunther Wegner
[2020-01-18 18:08:27] INFO: https://lrtimelapse.com
[2020-01-18 18:08:27] INFO: Java version: 11.0.3 (64bit) from AdoptOpenJDK
[2020-01-18 18:08:27] INFO: Running on: Mac OS X locale: en_US
[2020-01-18 18:08:27] INFO: Found 16 processor cores.
[2020-01-18 18:08:27] INFO: Java runtime: 64 bit
[2020-01-18 18:08:27] INFO: ------------------------------------
[2020-01-18 18:08:27] INFO: Licensed to: Matt Coda, Vive Media, Charleston - Professional License.
[2020-01-18 18:08:27] DEBUG: Registered Tiff-Reader: com.sun.imageio.plugins.tiff.TIFFImageReader@4eb386df
[2020-01-18 18:08:27] DEBUG: Registered Tiff-Reader: com.twelvemonkeys.imageio.plugins.tiff.TIFFImageReader@77d67cf3
[2020-01-18 18:08:28] DEBUG: Launched worker with 16 threads.
[2020-01-18 18:08:28] DEBUG: Initializing directory chooser
[2020-01-18 18:08:28] DEBUG: Start path: /Volumes/GRAIDEC/Ecuadortimelapse/Footage/Mindo/CloudforestSunriseOne
[2020-01-18 18:08:30] DEBUG: Launched worker with 16 threads.
[2020-01-18 18:08:30] DEBUG: Launching ExifTool: /usr/local/bin/exiftool
[2020-01-18 18:08:30] INFO: ExifTool: 11.38
[2020-01-18 18:08:30] DEBUG: Exif Tool available.
[2020-01-18 18:08:30] DEBUG: DNG Converter available.
[2020-01-18 18:08:30] DEBUG: MPEG Encoder available.
[2020-01-18 18:08:30] INFO: Detected 1 screen:
[2020-01-18 18:08:30] INFO: Screen 1: 2560 1440
[2020-01-18 18:08:31] DEBUG: Using temp-dir: /var/folders/5w/79qqw20150n_m_7j4j71_1lm0000gn/T/lrt_7528987445232496155
[2020-01-18 18:08:31] INFO: Done (dirchooser)...
[2020-01-18 18:08:31] INFO: Latest Version of LRTimelapse: 5.3.3 (2019-11-28), installed Version: 5.3.3 (2019-11-28)
[2020-01-18 18:08:31] DEBUG: Using DNG Converter: /Applications/Adobe DNG Converter.app/Contents/MacOS/Adobe DNG Converter
[2020-01-18 18:08:32] DEBUG: Latest Version of Adobe DNG Converter: 12.1.0 (12010000) Installed Version: 12.1 (12010000)
[2020-01-18 18:09:09] INFO: --- Loading directory: /Volumes/GRAIDEC/Ecuadortimelapse/Footage/Mindo/CloudforestSunriseOne
[2020-01-18 18:09:09] DEBUG: Loading sequence properties from /Volumes/GRAIDEC/Ecuadortimelapse/Footage/Mindo/CloudforestSunriseOne/.lrt/lrtsequence.properties
[2020-01-18 18:09:13] DEBUG: Memory: [max|10144] [used|721] [free|9423]
[2020-01-18 18:09:13] DEBUG: Figuring out the workflow status of the sequence.
[2020-01-18 18:09:13] DEBUG: Buffer size for ExifTool: 100
[2020-01-18 18:09:13] DEBUG: Sequence shot in auto mode
[2020-01-18 18:09:13] DEBUG: Timestamp Data complete!
[2020-01-18 18:09:13] DEBUG: Sequence processed with LRT 5.3.3, Build 602
[2020-01-18 18:09:43] DEBUG: Done loading previews.
[2020-01-18 18:09:43] DEBUG: Memory: [max|10144] [used|840] [free|9304]
[2020-01-18 18:10:36] DEBUG: Run into DNG Converter timeout.
[2020-01-18 18:10:36] ERROR: Error creating visual preview for MindoSunriseOne10044.ARW
[2020-01-18 18:10:36] WARN: Error loading visual preview for: MindoSunriseOne10044.ARW tried 1 times.
[2020-01-18 18:10:37] DEBUG: Run into DNG Converter timeout.
[2020-01-18 18:10:37] ERROR: Error creating visual preview for MindoSunriseOne10033.ARW
[2020-01-18 18:10:37] WARN: Error loading visual preview for: MindoSunriseOne10033.ARW tried 1 times.
[2020-01-18 18:10:37] DEBUG: Run into DNG Converter timeout.
[2020-01-18 18:10:37] ERROR: Error creating visual preview for MindoSunriseOne10048.ARW
[2020-01-18 18:10:37] WARN: Error loading visual preview for: MindoSunriseOne10048.ARW tried 1 times.
[2020-01-18 18:10:38] DEBUG: Run into DNG Converter timeout.
[2020-01-18 18:10:38] ERROR: Error creating visual preview for MindoSunriseOne10031.ARW
[2020-01-18 18:10:38] WARN: Error loading visual preview for: MindoSunriseOne10031.ARW tried 1 times.
[2020-01-18 18:10:38] DEBUG: Run into DNG Converter timeout.
[2020-01-18 18:10:38] ERROR: Error creating visual preview for MindoSunriseOne10037.ARW
[2020-01-18 18:10:38] WARN: Error loading visual preview for: MindoSunriseOne10037.ARW tried 1 times.
[2020-01-18 18:10:38] DEBUG: Run into DNG Converter timeout.
[2020-01-18 18:10:38] ERROR: Error creating visual preview for MindoSunriseOne10018.ARW
[2020-01-18 18:10:38] WARN: Error loading visual preview for: MindoSunriseOne10018.ARW tried 1 times.
[2020-01-18 18:10:38] DEBUG: Run into DNG Converter timeout.
[2020-01-18 18:10:38] ERROR: Error creating visual preview for MindoSunriseOne10029.ARW
[2020-01-18 18:10:38] WARN: Error loading visual preview for: MindoSunriseOne10029.ARW tried 1 times.
[2020-01-18 18:10:38] DEBUG: Run into DNG Converter timeout.
[2020-01-18 18:10:38] ERROR: Error creating visual preview for MindoSunriseOne10036.ARW
[2020-01-18 18:10:38] WARN: Error loading visual preview for: MindoSunriseOne10036.ARW tried 1 times.
[2020-01-18 18:10:38] DEBUG: Run into DNG Converter timeout.
[2020-01-18 18:10:38] ERROR: Error creating visual preview for MindoSunriseOne10040.ARW
[2020-01-18 18:10:38] WARN: Error loading visual preview for: MindoSunriseOne10040.ARW tried 1 times.
[2020-01-18 18:10:39] DEBUG: Run into DNG Converter timeout.
[2020-01-18 18:10:39] ERROR: Error creating visual preview for MindoSunriseOne10041.ARW
[2020-01-18 18:10:39] WARN: Error loading visual preview for: MindoSunriseOne10041.ARW tried 1 times.
[2020-01-18 18:10:39] DEBUG: Run into DNG Converter timeout.
[2020-01-18 18:10:39] ERROR: Error creating visual preview for MindoSunriseOne10023.ARW
[2020-01-18 18:10:39] WARN: Error loading visual preview for: MindoSunriseOne10023.ARW tried 1 times.
[2020-01-18 18:10:39] DEBUG: Run into DNG Converter timeout.
[2020-01-18 18:10:39] ERROR: Error creating visual preview for MindoSunriseOne10038.ARW
[2020-01-18 18:10:39] WARN: Error loading visual preview for: MindoSunriseOne10038.ARW tried 1 times.
[2020-01-18 18:10:39] DEBUG: Run into DNG Converter timeout.
[2020-01-18 18:10:39] ERROR: Error creating visual preview for MindoSunriseOne10051.ARW
[2020-01-18 18:10:39] WARN: Error loading visual preview for: MindoSunriseOne10051.ARW tried 1 times.
[2020-01-18 18:10:39] DEBUG: Run into DNG Converter timeout.
[2020-01-18 18:10:39] ERROR: Error creating visual preview for MindoSunriseOne10059.ARW
[2020-01-18 18:10:39] WARN: Error loading visual preview for: MindoSunriseOne10059.ARW tried 1 times.
[2020-01-18 18:10:43] DEBUG: Run into DNG Converter timeout.
[2020-01-18 18:10:43] ERROR: Error creating visual preview for MindoSunriseOne10058.ARW
[2020-01-18 18:10:43] WARN: Error loading visual preview for: MindoSunriseOne10058.ARW tried 1 times.
Here is a copy of the logfile. This time it got through about 35 properly done and then started to endlessly fail. Lowering the amount of threads does solve the problem, but only partially. Lowering it to 10 threads (from 16) about half of the DNG converter instances still are 'not responding' when I view my Activity Monitor. It results in the visual preview creation going incredibly slowly.
This problem does not arrise when I am working off files stored on the computer or on any of my 2TB SSDs. But when files are on a 8TB, 16TB, or 20TB G-technology Raid (in Raid 0 or Raid 1) the DNG Converter stops working as it should. Everything has full disk access, and I've removed their access and then re-given both programs access. Doing that seems to help, but then it starts to time out again after 30-50 visual previews created.