Hey guys,
I have a weird issue with local rendering since I updated all my systems to the the newest version of Deadline (8.0.13.3). I was on 8.0.6.5 before I installed the update. Just to give you as much information as possible I also did the following things as part of our “between-years-upgrade”:
-updated windows on the server and all clients
-deinstalled the obsolete 2015 version of After Effects (using 2015.3 and 2017 only now) on all my nodes
-deleted and old unused mongoDB from version 7
-found an old autostart database7 entry, which I disabled as well
My first rendertest with all render nodes didn’t produce any output on the server. The folder was just empty. I submitted out of AE via the script. I checked ‘Include Output File Path’ and ‘Enable Local Rendering’ and set the ‘Frames per Task’ to 10.
Submitting the same project file without the ‘Enabel Local Rendering’ option is working fine. Frames are rendered and written on the server.
I checked the slaves local data folder, when I tried the local rendering option the second time and I could see the frames being rendered locally but not being copied to the network location.
Please find the log below:
[code]=======================================================
Log
2016-12-28 12:19:56: BEGIN - BLADE-3D-127\render
2016-12-28 12:19:56: 0: Executing plugin command of type ‘Initialize Plugin’
2016-12-28 12:19:56: 0: INFO: Executing plugin script ‘D:\SlaveLocalData\blade-3d-127\plugins\58639fce65464325645a3a18\AfterEffects.py’
2016-12-28 12:19:57: 0: INFO: Fail on Existing After Effects process: 0
2016-12-28 12:19:57: 0: INFO: About: After Effects Plugin for Deadline
2016-12-28 12:19:57: 0: INFO: The job’s environment will be merged with the current environment before rendering
2016-12-28 12:19:57: 0: Done executing plugin command of type ‘Initialize Plugin’
2016-12-28 12:19:57: 0: Start Job timeout is disabled.
2016-12-28 12:19:57: 0: Task timeout is disabled.
2016-12-28 12:19:57: 0: Loaded job: CC2017_FL.aep - Desktop (58639fce65464325645a3a18)
2016-12-28 12:19:57: 0: Executing plugin command of type ‘Start Job’
2016-12-28 12:19:57: 0: Done executing plugin command of type ‘Start Job’
2016-12-28 12:19:57: 0: Plugin rendering frame(s): 2-3
2016-12-28 12:19:57: 0: Executing plugin command of type ‘Render Task’
2016-12-28 12:19:57: 0: INFO: Attempting to create “C:\Users\render\Documents\ae_force_english.txt” to force After Effects to run in English
2016-12-28 12:19:57: 0: INFO: Stdout Redirection Enabled: True
2016-12-28 12:19:57: 0: INFO: Stdout Handling Enabled: True
2016-12-28 12:19:57: 0: INFO: Popup Handling Enabled: True
2016-12-28 12:19:57: 0: INFO: QT Popup Handling Enabled: False
2016-12-28 12:19:57: 0: INFO: WindowsForms10.Window.8.app.* Popup Handling Enabled: False
2016-12-28 12:19:57: 0: INFO: Using Process Tree: True
2016-12-28 12:19:57: 0: INFO: Hiding DOS Window: True
2016-12-28 12:19:57: 0: INFO: Creating New Console: False
2016-12-28 12:19:57: 0: INFO: Running as user: render
2016-12-28 12:19:57: 0: INFO: Executable: “C:\Program Files\Adobe\Adobe After Effects CC 2017\Support Files\aerender.exe”
2016-12-28 12:19:57: 0: INFO: Rendering to local drive, will copy files and folders to final location after render is complete
2016-12-28 12:19:57: 0: INFO: Argument: -project “\nyx\san200\nyx_projekte_temp_RENDERTESTS\CC2107\CC2017_FL.aep” -comp “Desktop” -s 2 -e 3 -output “D:\SlaveLocalData\blade-3d-127\jobsData\58639fce65464325645a3a18\AfterEffectsOutput_tempFbntu0\CC2017_FL_[#####].tif” -close DO_NOT_SAVE_CHANGES
2016-12-28 12:19:57: 0: INFO: Full Command: “C:\Program Files\Adobe\Adobe After Effects CC 2017\Support Files\aerender.exe” -project “\nyx\san200\nyx_projekte_temp_RENDERTESTS\CC2107\CC2017_FL.aep” -comp “Desktop” -s 2 -e 3 -output “D:\SlaveLocalData\blade-3d-127\jobsData\58639fce65464325645a3a18\AfterEffectsOutput_tempFbntu0\CC2017_FL_[#####].tif” -close DO_NOT_SAVE_CHANGES
2016-12-28 12:19:57: 0: INFO: Startup Directory: “C:\Program Files\Adobe\Adobe After Effects CC 2017\Support Files”
2016-12-28 12:19:57: 0: INFO: Process Priority: BelowNormal
2016-12-28 12:19:57: 0: INFO: Process Affinity: default
2016-12-28 12:19:57: 0: INFO: Process is now running
2016-12-28 12:19:58: 0: STDOUT: has video RAM(MB): 8
2016-12-28 12:19:58: 0: STDOUT: e[1me[0mOptiX has 1 devices available for use.
2016-12-28 12:19:58: 0: STDOUT: e[1me[31me[1m[ERROR] e[0mNVAPI error (C:\code\rtsdk\adobe-ae\cc13.1\src\Util\DriverInfo.cpp:309):
2016-12-28 12:19:58: 0: STDOUT: e[1me[0mNon-default knobs:
2016-12-28 12:19:58: 0: STDOUT: e[1me[0m
2016-12-28 12:19:58: 0: STDOUT: e[1me[31me[1m[ERROR] e[0mNVAPI error (C:\code\rtsdk\adobe-ae\cc13.1\src\Util\DriverInfo.cpp:78):
2016-12-28 12:19:58: 0: STDOUT: e[1me[32me[1m[LOG 4] e[0mCPU fallback enabled
2016-12-28 12:19:58: 0: STDOUT: e[1me[0mNon-default knobs:
2016-12-28 12:19:58: 0: STDOUT: e[1me[0m
2016-12-28 12:19:58: 0: STDOUT: e[1me[31me[1m[ERROR] e[0mNVAPI error (C:\code\rtsdk\adobe-ae\cc13.1\src\Util\DriverInfo.cpp:78):
2016-12-28 12:20:04: 0: STDOUT: aerender version 14.0.1x5
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: 28.12.2016 12:20:04: Starting composition Desktop.
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Render Settings: Best Settings
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Quality: Best
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Resolution: Full
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Size: 1920 x 1080
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Proxy Use: Use No Proxies
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Effects: Current Settings
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Disk Cache: Read Only
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Color Depth: Current Settings
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Frame Blending: On for Checked Layers
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Field Render: Off
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Pulldown: Off
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Motion Blur: On for Checked Layers
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Solos: Current Settings
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Time Span: Custom
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Start: 00002
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: End: 00003
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Duration: 00002
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Frame Rate: 25,00 (comp)
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Guide Layers: All Off
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Skip Existing Files: Off
2016-12-28 12:20:04: 0: STDOUT: PROGRESS:
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Output Module: Lossless
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Output To: D:\SlaveLocalData\blade-3d-127\jobsData\58639fce65464325645a3a18\AfterEffectsOutput_tempFbntu0\CC2017_FL_[#####].tif
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Format: TIFF Sequence
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Output Info: -
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Start Frame: 2
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Output Audio: -
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Channels: RGB
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Depth: Millions of Colors
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Color: Premultiplied
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Resize: -
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Crop: -
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Final Size: 1920 x 1080
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Profile: -
2016-12-28 12:20:04: 0: STDOUT: PROGRESS: Post-Render Action: None
2016-12-28 12:20:04: 0: STDOUT: PROGRESS:
2016-12-28 12:20:05: 0: STDOUT: PROGRESS: 00002 (1): 0 Seconds
2016-12-28 12:20:05: 0: STDOUT: PROGRESS: 00003 (2): 1 Seconds
2016-12-28 12:20:06: 0: Done executing plugin command of type ‘Render Task’
=======================================================
Details
Date: 12/28/2016 12:20:08
Frames: 2-3
Job Submit Date: 12/28/2016 12:19:41
Job User: av-storm
Average RAM Usage: 0 (0%)
Peak RAM Usage: 0 (0%)
Average CPU Usage: 0%
Peak CPU Usage: 0%
Used CPU Clocks (x10^6 cycles): 0
Total CPU Clocks (x10^6 cycles): 0
=======================================================
Slave Information
Slave Name: blade-3d-127
Version: v8.0.13.3 Release (2c55876a9)
Operating System: Windows 7 Professional (SP1)
Running As Service: No
Machine User: render
IP Address: 10.40.30.127
MAC Address: 0C:C4:7A:12:0D:E0
CPU Architecture: x64
CPUs: 24
CPU Usage: 0%
Memory Usage: 2.7 GB / 32.0 GB (8%)
Free Disk Space: 705.667 GB (42.339 GB on C:, 663.327 GB on D:)
Video Card: Standard-VGA-Grafikkarte[/code]
Next thing I tried is to leave the ‘Enable Local Rendering’ option enabled and set the ‘Frames per Task’ to 1.
This actually worked too. Frames were rendered locally and copied to the network location.
Please find the log below:
[code]=======================================================
Log
2016-12-28 12:14:56: BEGIN - BLADE-2D-109\render
2016-12-28 12:14:56: 0: Executing plugin command of type ‘Initialize Plugin’
2016-12-28 12:14:56: 0: INFO: Executing plugin script ‘D:\SlaveLocalData\blade-2d-109\plugins\58639ea465464306c4d6a658\AfterEffects.py’
2016-12-28 12:14:59: 0: INFO: Fail on Existing After Effects process: 0
2016-12-28 12:14:59: 0: INFO: About: After Effects Plugin for Deadline
2016-12-28 12:14:59: 0: INFO: The job’s environment will be merged with the current environment before rendering
2016-12-28 12:14:59: 0: Done executing plugin command of type ‘Initialize Plugin’
2016-12-28 12:14:59: 0: Start Job timeout is disabled.
2016-12-28 12:14:59: 0: Task timeout is disabled.
2016-12-28 12:14:59: 0: Loaded job: CC2017_FL.aep - Desktop (58639ea465464306c4d6a658)
2016-12-28 12:14:59: 0: Executing plugin command of type ‘Start Job’
2016-12-28 12:14:59: 0: Done executing plugin command of type ‘Start Job’
2016-12-28 12:14:59: 0: Plugin rendering frame(s): 0
2016-12-28 12:14:59: 0: Executing plugin command of type ‘Render Task’
2016-12-28 12:14:59: 0: INFO: Attempting to create “C:\Users\render\Documents\ae_force_english.txt” to force After Effects to run in English
2016-12-28 12:14:59: 0: INFO: Stdout Redirection Enabled: True
2016-12-28 12:14:59: 0: INFO: Stdout Handling Enabled: True
2016-12-28 12:14:59: 0: INFO: Popup Handling Enabled: True
2016-12-28 12:14:59: 0: INFO: QT Popup Handling Enabled: False
2016-12-28 12:14:59: 0: INFO: WindowsForms10.Window.8.app.* Popup Handling Enabled: False
2016-12-28 12:14:59: 0: INFO: Using Process Tree: True
2016-12-28 12:14:59: 0: INFO: Hiding DOS Window: True
2016-12-28 12:14:59: 0: INFO: Creating New Console: False
2016-12-28 12:14:59: 0: INFO: Running as user: render
2016-12-28 12:14:59: 0: INFO: Executable: “C:\Program Files\Adobe\Adobe After Effects CC 2017\Support Files\aerender.exe”
2016-12-28 12:14:59: 0: INFO: Rendering to local drive, will copy files and folders to final location after render is complete
2016-12-28 12:14:59: 0: INFO: Argument: -project “\nyx\san200\nyx_projekte_temp_RENDERTESTS\CC2107\CC2017_FL.aep” -comp “Desktop” -s 0 -e 0 -output “D:\SlaveLocalData\blade-2d-109\jobsData\58639ea465464306c4d6a658\AfterEffectsOutput_tempQbO0n0\CC2017_FL_[#####].tif” -close DO_NOT_SAVE_CHANGES
2016-12-28 12:14:59: 0: INFO: Full Command: “C:\Program Files\Adobe\Adobe After Effects CC 2017\Support Files\aerender.exe” -project “\nyx\san200\nyx_projekte_temp_RENDERTESTS\CC2107\CC2017_FL.aep” -comp “Desktop” -s 0 -e 0 -output “D:\SlaveLocalData\blade-2d-109\jobsData\58639ea465464306c4d6a658\AfterEffectsOutput_tempQbO0n0\CC2017_FL_[#####].tif” -close DO_NOT_SAVE_CHANGES
2016-12-28 12:14:59: 0: INFO: Startup Directory: “C:\Program Files\Adobe\Adobe After Effects CC 2017\Support Files”
2016-12-28 12:14:59: 0: INFO: Process Priority: BelowNormal
2016-12-28 12:14:59: 0: INFO: Process Affinity: default
2016-12-28 12:14:59: 0: INFO: Process is now running
2016-12-28 12:15:00: 0: STDOUT: has video RAM(MB): 8
2016-12-28 12:15:00: 0: STDOUT: e[1me[0mOptiX has 1 devices available for use.
2016-12-28 12:15:00: 0: STDOUT: e[1me[31me[1m[ERROR] e[0mNVAPI error (C:\code\rtsdk\adobe-ae\cc13.1\src\Util\DriverInfo.cpp:309):
2016-12-28 12:15:00: 0: STDOUT: e[1me[0mNon-default knobs:
2016-12-28 12:15:00: 0: STDOUT: e[1me[0m
2016-12-28 12:15:00: 0: STDOUT: e[1me[31me[1m[ERROR] e[0mNVAPI error (C:\code\rtsdk\adobe-ae\cc13.1\src\Util\DriverInfo.cpp:78):
2016-12-28 12:15:00: 0: STDOUT: e[1me[32me[1m[LOG 4] e[0mCPU fallback enabled
2016-12-28 12:15:00: 0: STDOUT: e[1me[0mNon-default knobs:
2016-12-28 12:15:00: 0: STDOUT: e[1me[0m
2016-12-28 12:15:00: 0: STDOUT: e[1me[31me[1m[ERROR] e[0mNVAPI error (C:\code\rtsdk\adobe-ae\cc13.1\src\Util\DriverInfo.cpp:78):
2016-12-28 12:15:10: 0: STDOUT: aerender version 14.0.1x5
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: 28.12.2016 12:15:10: Starting composition Desktop.
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Render Settings: Best Settings
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Quality: Best
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Resolution: Full
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Size: 1920 x 1080
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Proxy Use: Use No Proxies
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Effects: Current Settings
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Disk Cache: Read Only
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Color Depth: Current Settings
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Frame Blending: On for Checked Layers
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Field Render: Off
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Pulldown: Off
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Motion Blur: On for Checked Layers
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Solos: Current Settings
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Time Span: Custom
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Start: 00000
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: End: 00000
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Duration: 00001
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Frame Rate: 25,00 (comp)
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Guide Layers: All Off
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Skip Existing Files: Off
2016-12-28 12:15:10: 0: STDOUT: PROGRESS:
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Output Module: Lossless
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Output To: D:\SlaveLocalData\blade-2d-109\jobsData\58639ea465464306c4d6a658\AfterEffectsOutput_tempQbO0n0\CC2017_FL_[#####].tif
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Format: TIFF Sequence
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Output Info: -
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Start Frame: 0
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Output Audio: -
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Channels: RGB
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Depth: Millions of Colors
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Color: Premultiplied
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Resize: -
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Crop: -
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Final Size: 1920 x 1080
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Profile: -
2016-12-28 12:15:10: 0: STDOUT: PROGRESS: Post-Render Action: None
2016-12-28 12:15:10: 0: STDOUT: PROGRESS:
2016-12-28 12:15:11: 0: STDOUT: PROGRESS: 00000 (1): 0 Seconds
2016-12-28 12:15:11: 0: STDOUT: e[1me[32me[1m[LOG 4] e[0mCPU fallback enabled
2016-12-28 12:15:11: 0: STDOUT: LoadLibrary “n” failed!
2016-12-28 12:15:11: 0: STDOUT: LoadLibrary “n” failed!
2016-12-28 12:15:11: 0: STDOUT: LoadLibrary “n” failed!
2016-12-28 12:15:11: 0: STDOUT: LoadLibrary “n” failed!
2016-12-28 12:15:12: 0: INFO: Process exit code: 0
2016-12-28 12:15:12: 0: INFO: Moving output files and folders from D:\SlaveLocalData\blade-2d-109\jobsData\58639ea465464306c4d6a658\AfterEffectsOutput_tempQbO0n0 to \nyx\san200\nyx_projekte_temp_RENDERTESTS\CC2017_OUTPUT\CC2017_FL
2016-12-28 12:15:12: 0: INFO: Moving file D:\SlaveLocalData\blade-2d-109\jobsData\58639ea465464306c4d6a658\AfterEffectsOutput_tempQbO0n0\CC2017_FL_00000.tif to \nyx\san200\nyx_projekte_temp_RENDERTESTS\CC2017_OUTPUT\CC2017_FL\CC2017_FL_00000.tif
2016-12-28 12:15:12: 0: Done executing plugin command of type ‘Render Task’
=======================================================
Details
Date: 12/28/2016 12:15:13
Frames: 0
Job Submit Date: 12/28/2016 12:14:42
Job User: av-storm
Average RAM Usage: 223800752 (2%)
Peak RAM Usage: 322293760 (2%)
Average CPU Usage: 7%
Peak CPU Usage: 18%
Used CPU Clocks (x10^6 cycles): 6554
Total CPU Clocks (x10^6 cycles): 93626
=======================================================
Slave Information
Slave Name: blade-2d-109
Version: v8.0.13.3 Release (2c55876a9)
Operating System: Windows 7 Professional (SP1)
Running As Service: No
Machine User: render
IP Address: 10.40.30.109
MAC Address: 00:25:90:D7:6C:CC
CPU Architecture: x64
CPUs: 4
CPU Usage: 20%
Memory Usage: 2.0 GB / 16.0 GB (12%)
Free Disk Space: 551.415 GB (39.867 GB on C:, 511.548 GB on D:)
Video Card: Standard-VGA-Grafikkarte[/code]
It seems that Deadline ‘forgets’ to move the frames to the network location when rendering locally.
I submitted the project via the Monitor and checked the ‘Local Rendering’ option as well. This works as well. Frames are rendered to the network location. Weird thing here is that the frames doesn’t seem to be saved locally and copied to the network. It just renders directly to the network location.
I’m a little confused by now and tried to find someone with a similar problem in the forum (read almost all entries which are related to After Effects) but unfortunately couldn’t find anything helpful.
I tried to downgrade to 8.0.12.4 which didn’t make a difference. Same problem.
After Effects 2015.3 and 2017 have the same problem. I don’t want to downgrade everything to the old Deadline version since this update also made a lot of things better, so I hope someone has an idea what could cause this behaviour.
If you need any further information let me know.
Thanks in advance.
Christian