I have a worker which has worked fine in the past but now it gives a deadline plugin error on every job it attempts. I have been trying to find info on the error message but could not find a solution.
Anyone knows what is happening and what I can do to fix it?
log;
=======================================================
Error
=======================================================
The Deadline Plugin was not properly initialized. Application plugins must explicitly call `super().__init__()` in the Python constructor: `def __init__()`.
=======================================================
Type
=======================================================
RenderPluginException
=======================================================
Stack Trace
=======================================================
at Deadline.Plugins.SandboxedPlugin.d(DeadlineMessage bgq, CancellationToken bgr)
at Deadline.Plugins.SandboxedPlugin.Initialize(Job job, CancellationToken cancellationToken)
at Deadline.Slaves.SlaveRenderThread.e(String ajx, Job ajy, CancellationToken ajz)
at Deadline.Slaves.SlaveRenderThread.b(TaskLogWriter ajt, CancellationToken aju)
=======================================================
Log
=======================================================
2023-10-26 11:41:26: 0: Loading Job's Plugin timeout is Disabled
2023-10-26 11:41:26: 0: SandboxedPlugin: Render Job As User disabled, running as current user 'Simeon'
2023-10-26 11:41:27: 0: Executing plugin command of type 'Initialize Plugin'
2023-10-26 11:41:27: 0: INFO: Executing plugin script 'C:\ProgramData\Thinkbox\Deadline10\workers\MB3D-08\plugins\653a3311e17f941601e2be0a\AfterEffects.py'
2023-10-26 11:41:27: 0: INFO: Plugin execution sandbox using Python version 3
2023-10-26 11:41:27: 0: Encountered an error while executing plugin command of type 'Initialize Plugin'
2023-10-26 11:41:27: 0: Unhandled exception. System.NullReferenceException: Object reference not set to an instance of an object.
2023-10-26 11:41:27: 0: at Deadline.Plugins.DeadlinePlugin.CancelTask()
2023-10-26 11:41:27: 0: at Deadline.Plugins.PluginWrapper.CancelTask()
2023-10-26 11:41:27: 0: at Deadline.Slaves.CommandListener.e(String aio)
2023-10-26 11:41:27: 0: at Deadline.Slaves.CommandListener.d(Object ain)
2023-10-26 11:41:27: 0: at Deadline.Slaves.CommandListener.b(DeadlineMessage ail, Exception aim)
2023-10-26 11:41:27: 0: at Deadline.Net.DeadlineMessageUtils.a.a(IAsyncResult bhp)
2023-10-26 11:41:27: 0: at System.Threading.Tasks.TaskToApm.TaskAsyncResult.InvokeCallback()
2023-10-26 11:41:27: 0: at System.Threading.Tasks.AwaitTaskContinuation.<>c.<.cctor>b__17_0(Object state)
2023-10-26 11:41:27: 0: at System.Threading.ExecutionContext.RunInternal(ExecutionContext executionContext, ContextCallback callback, Object state)
2023-10-26 11:41:27: 0: --- End of stack trace from previous location ---
2023-10-26 11:41:27: 0: at System.Threading.ExecutionContext.RunInternal(ExecutionContext executionContext, ContextCallback callback, Object state)
2023-10-26 11:41:27: 0: at System.Threading.Tasks.AwaitTaskContinuation.RunCallback(ContextCallback callback, Object state, Task& currentTask)
2023-10-26 11:41:27: 0: --- End of stack trace from previous location ---
2023-10-26 11:41:27: 0: at System.Threading.Tasks.Task.<>c.<ThrowAsync>b__128_1(Object state)
2023-10-26 11:41:27: 0: at System.Threading.QueueUserWorkItemCallbackDefaultContext.Execute()
2023-10-26 11:41:27: 0: at System.Threading.ThreadPoolWorkQueue.Dispatch()
2023-10-26 11:41:27: 0: at System.Threading.PortableThreadPool.WorkerThread.WorkerThreadStart()
2023-10-26 11:41:27: 0: at System.Threading.Thread.StartCallback()
=======================================================
Details
=======================================================
Date: 10/26/2023 11:41:31
Frames: 350-399
Elapsed Time: 00:00:00:05
Job Submit Date: 10/26/2023 11:36:17
Job User: simeon
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
=======================================================
Worker Information
=======================================================
Worker Name: MB3D-08
Version: v10.3.0.13 Release (7883f0093)
Operating System: Windows 10 Home
Running As Service: No
Machine User: Simeon
IP Address: 2a02:a210:2044:2d80:805e:3bb6:a953:9ac2
MAC Address: A8:5E:45:57:70:4E
CPU Architecture: x64
CPUs: 64
CPU Usage: 2%
Memory Usage: 18.0 GB / 127.9 GB (14%)
Free Disk Space: 141.756 GB
Video Card: NVIDIA GeForce GTX 1080 Ti
I found out that this worker had a newer version than the rest of the nodes and the repository.
I rolled it back to 10.2.1 which the rest has too. But sadly the errors are not done yetā¦
log;
ļ»æ=======================================================
Error
=======================================================
FailRenderException : aerender Error: After Effects error: Unable to call "openFast" because of parameter 1. Path is not valid. Path: "T:\AfterEffects\deadlineRSC_test.aep"
at Deadline.Plugins.DeadlinePlugin.FailRender(String message) (Python.Runtime.PythonException)
File "C:\ProgramData\Thinkbox\Deadline10\workers\MB3D-08\plugins\653a3311e17f941601e2be0a\AfterEffects.py", line 575, in HandleStdoutError
self.FailAERender( self.GetRegexMatch(0) )
File "C:\ProgramData\Thinkbox\Deadline10\workers\MB3D-08\plugins\653a3311e17f941601e2be0a\AfterEffects.py", line 496, in FailAERender
self.FailRender( message )
at Python.Runtime.Dispatcher.Dispatch(ArrayList args)
at __FranticX_Processes_ManagedProcess_StdoutHandlerDelegateDispatcher.Invoke()
at FranticX.Processes.ManagedProcess.RegexHandlerCallback.CallFunction()
at FranticX.Processes.ManagedProcess.e(String dl, Boolean dm)
at FranticX.Processes.ManagedProcess.Execute(Boolean waitForExit)
at Deadline.Plugins.DeadlinePlugin.DoRenderTasks()
at Deadline.Plugins.PluginWrapper.RenderTasks(Task task, String& outMessage, AbortLevel& abortLevel)
at Deadline.Plugins.PluginWrapper.RenderTasks(Task task, String& outMessage, AbortLevel& abortLevel)
=======================================================
Type
=======================================================
RenderPluginException
=======================================================
Stack Trace
=======================================================
at Deadline.Plugins.SandboxedPlugin.d(DeadlineMessage bgq, CancellationToken bgr)
at Deadline.Plugins.SandboxedPlugin.RenderTask(Task task, CancellationToken cancellationToken)
at Deadline.Slaves.SlaveRenderThread.c(TaskLogWriter ajv, CancellationToken ajw)
=======================================================
Log
=======================================================
2023-10-26 16:03:14: 0: Loading Job's Plugin timeout is Disabled
2023-10-26 16:03:14: 0: SandboxedPlugin: Render Job As User disabled, running as current user 'Simeon'
2023-10-26 16:03:15: 0: Executing plugin command of type 'Initialize Plugin'
2023-10-26 16:03:15: 0: INFO: Executing plugin script 'C:\ProgramData\Thinkbox\Deadline10\workers\MB3D-08\plugins\653a3311e17f941601e2be0a\AfterEffects.py'
2023-10-26 16:03:15: 0: INFO: Plugin execution sandbox using Python version 3
2023-10-26 16:03:15: 0: INFO: Fail Without Finished Message set to: False
2023-10-26 16:03:15: 0: INFO: Fail on Existing After Effects process: False
2023-10-26 16:03:15: 0: INFO: About: After Effects Plugin for Deadline
2023-10-26 16:03:15: 0: INFO: The job's environment will be merged with the current environment before rendering
2023-10-26 16:03:15: 0: Done executing plugin command of type 'Initialize Plugin'
2023-10-26 16:03:15: 0: Start Job timeout is disabled.
2023-10-26 16:03:15: 0: Task timeout is disabled.
2023-10-26 16:03:15: 0: Loaded job: deadlineRSC_test.aep - Comp 1 (653a3311e17f941601e2be0a)
2023-10-26 16:03:16: 0: Executing plugin command of type 'Start Job'
2023-10-26 16:03:16: 0: DEBUG: S3BackedCache Client is not installed.
2023-10-26 16:03:16: 0: INFO: Executing global asset transfer preload script 'C:\ProgramData\Thinkbox\Deadline10\workers\MB3D-08\plugins\653a3311e17f941601e2be0a\GlobalAssetTransferPreLoad.py'
2023-10-26 16:03:16: 0: INFO: Looking for legacy (pre-10.0.26) AWS Portal File Transfer...
2023-10-26 16:03:16: 0: INFO: Looking for legacy (pre-10.0.26) File Transfer controller in C:/Program Files/Thinkbox/S3BackedCache/bin/task.py...
2023-10-26 16:03:16: 0: INFO: Could not find legacy (pre-10.0.26) AWS Portal File Transfer.
2023-10-26 16:03:16: 0: INFO: Legacy (pre-10.0.26) AWS Portal File Transfer is not installed on the system.
2023-10-26 16:03:16: 0: Done executing plugin command of type 'Start Job'
2023-10-26 16:03:16: 0: Plugin rendering frame(s): 200-249
2023-10-26 16:03:16: 0: Executing plugin command of type 'Render Task'
2023-10-26 16:03:16: 0: INFO: Attempting to create "C:\Users\Simeon\Documents\ae_render_only_node.txt" to force After Effects to run in Render Engine mode
2023-10-26 16:03:16: 0: INFO: Stdout Redirection Enabled: True
2023-10-26 16:03:16: 0: INFO: Stdout Handling Enabled: True
2023-10-26 16:03:16: 0: INFO: Popup Handling Enabled: True
2023-10-26 16:03:16: 0: INFO: QT Popup Handling Enabled: False
2023-10-26 16:03:16: 0: INFO: WindowsForms10.Window.8.app.* Popup Handling Enabled: False
2023-10-26 16:03:16: 0: INFO: Using Process Tree: True
2023-10-26 16:03:16: 0: INFO: Hiding DOS Window: True
2023-10-26 16:03:16: 0: INFO: Creating New Console: False
2023-10-26 16:03:16: 0: INFO: Running as user: Simeon
2023-10-26 16:03:16: 0: INFO: Executable: "C:\Program Files\Adobe\Adobe After Effects 2022\Support Files\aerender.exe"
2023-10-26 16:03:16: 0: INFO: Argument: -project "T:\AfterEffects\deadlineRSC_test.aep" -comp "Comp 1" -s 200 -e 249 -v ERRORS_AND_PROGRESS -close DO_NOT_SAVE_CHANGES -sound OFF
2023-10-26 16:03:16: 0: INFO: Full Command: "C:\Program Files\Adobe\Adobe After Effects 2022\Support Files\aerender.exe" -project "T:\AfterEffects\deadlineRSC_test.aep" -comp "Comp 1" -s 200 -e 249 -v ERRORS_AND_PROGRESS -close DO_NOT_SAVE_CHANGES -sound OFF
2023-10-26 16:03:16: 0: INFO: Startup Directory: "C:\Program Files\Adobe\Adobe After Effects 2022\Support Files"
2023-10-26 16:03:16: 0: INFO: Process Priority: BelowNormal
2023-10-26 16:03:16: 0: INFO: Process Affinity: default
2023-10-26 16:03:16: 0: INFO: Process is now running
2023-10-26 16:03:16: 0: INFO: Submitted from After Effects version: 22.6.5x2
2023-10-26 16:03:16: 0: STDOUT: aerender version 22.6.5x2
2023-10-26 16:04:25: 0: STDOUT: PROGRESS: Launching After Effects...
2023-10-26 16:04:25: 0: INFO: Checking for file "C:\Users\Simeon\Documents\ae_render_only_node.txt"
2023-10-26 16:04:25: 0: INFO: Attempting to delete "C:\Users\Simeon\Documents\ae_render_only_node.txt" to allow After Effects to run in the workstation environment
2023-10-26 16:04:25: 0: Done executing plugin command of type 'Render Task'
=======================================================
Details
=======================================================
Date: 10/26/2023 16:04:29
Frames: 200-249
Elapsed Time: 00:00:01:16
Job Submit Date: 10/26/2023 11:36:17
Job User: simeon
Average RAM Usage: 28181716992 (21%)
Peak RAM Usage: 28383428608 (21%)
Average CPU Usage: 6%
Peak CPU Usage: 10%
Used CPU Clocks (x10^6 cycles): 1021695
Total CPU Clocks (x10^6 cycles): 17028239
=======================================================
Worker Information
=======================================================
Worker Name: MB3D-08
Version: v10.2.1.1 Release (094cbe890)
Operating System: Windows 10 Home
Running As Service: Yes
Machine User: Simeon
IP Address: 2a02:a210:2044:2d80:805e:3bb6:a953:9ac2
MAC Address: A8:5E:45:57:70:4E
CPU Architecture: x64
CPUs: 64
CPU Usage: 6%
Memory Usage: 26.1 GB / 127.9 GB (20%)
Free Disk Space: 138.407 GB
Video Card: NVIDIA GeForce GTX 1080 Ti
Thank you for your reply. Sadly the post you mentioned is not of much help as it is not regarding a corrupt project file. Other than that I am missing directions on what I could do.
Please share the logs from isolation test. If it breaks the same way outside of Deadline on the render node then there is something wrong with AE. If not we need to check with the simple scene file if it breaks inside Deadline.
I have updated bot the repositoy and all clients to the latest version. Alle nodes work except this same one node (which is also running the RCS). I cant seem to get it to work. I checked the AE documentation, the deadline documentationā¦ But no luck yet.
I keep geting unable to call āOpenFastā because of parameter 1ā¦
How can I test this outside of deadline like you asked? that is still unclear to me.
I would be beyond joyful if someone has the golden tip for me. What can I do to resolve this?
hereās the latest log;
=======================================================
Error
=======================================================
aerender Error: After Effects error: Unable to call "openFast" because of parameter 1. Path is not valid. Path: "T:\AfterEffects\deadlineRSC_test_2023.aep"
at Deadline.Plugins.PluginWrapper.RenderTasks(Task task, String& outMessage, AbortLevel& abortLevel)
=======================================================
Type
=======================================================
RenderPluginException
=======================================================
Stack Trace
=======================================================
at Deadline.Plugins.SandboxedPlugin.d(DeadlineMessage bgq, CancellationToken bgr)
at Deadline.Plugins.SandboxedPlugin.RenderTask(Task task, CancellationToken cancellationToken)
at Deadline.Slaves.SlaveRenderThread.c(TaskLogWriter ajv, CancellationToken ajw)
=======================================================
Log
=======================================================
2023-11-23 16:41:14: 0: Loading Job's Plugin timeout is Disabled
2023-11-23 16:41:14: 0: SandboxedPlugin: Render Job As User disabled, running as current user 'Simeon'
2023-11-23 16:41:16: 0: Executing plugin command of type 'Initialize Plugin'
2023-11-23 16:41:16: 0: INFO: Executing plugin script 'C:\ProgramData\Thinkbox\Deadline10\workers\MB3D-08\plugins\655f6e6a2d19c7413a63c9a4\AfterEffects.py'
2023-11-23 16:41:16: 0: INFO: Plugin execution sandbox using Python version 3
2023-11-23 16:41:16: 0: INFO: Fail Without Finished Message set to: False
2023-11-23 16:41:16: 0: INFO: Fail on Existing After Effects process: False
2023-11-23 16:41:16: 0: INFO: About: After Effects Plugin for Deadline
2023-11-23 16:41:16: 0: INFO: The job's environment will be merged with the current environment before rendering
2023-11-23 16:41:16: 0: Done executing plugin command of type 'Initialize Plugin'
2023-11-23 16:41:16: 0: Start Job timeout is disabled.
2023-11-23 16:41:16: 0: Task timeout is disabled.
2023-11-23 16:41:16: 0: Loaded job: deadlineRSC_test_2023.aep - Comp 1 (655f6e6a2d19c7413a63c9a4)
2023-11-23 16:41:17: 0: Executing plugin command of type 'Start Job'
2023-11-23 16:41:17: 0: DEBUG: S3BackedCache Client is not installed.
2023-11-23 16:41:17: 0: INFO: Executing global asset transfer preload script 'C:\ProgramData\Thinkbox\Deadline10\workers\MB3D-08\plugins\655f6e6a2d19c7413a63c9a4\GlobalAssetTransferPreLoad.py'
2023-11-23 16:41:17: 0: INFO: Looking for legacy (pre-10.0.26) AWS Portal File Transfer...
2023-11-23 16:41:17: 0: INFO: Looking for legacy (pre-10.0.26) File Transfer controller in C:/Program Files/Thinkbox/S3BackedCache/bin/task.py...
2023-11-23 16:41:17: 0: INFO: Could not find legacy (pre-10.0.26) AWS Portal File Transfer.
2023-11-23 16:41:17: 0: INFO: Legacy (pre-10.0.26) AWS Portal File Transfer is not installed on the system.
2023-11-23 16:41:17: 0: Done executing plugin command of type 'Start Job'
2023-11-23 16:41:17: 0: Plugin rendering frame(s): 0-9
2023-11-23 16:41:17: 0: Executing plugin command of type 'Render Task'
2023-11-23 16:41:17: 0: INFO: Attempting to create "C:\Users\Simeon\Documents\ae_render_only_node.txt" to force After Effects to run in Render Engine mode
2023-11-23 16:41:17: 0: INFO: Stdout Redirection Enabled: True
2023-11-23 16:41:17: 0: INFO: Stdout Handling Enabled: True
2023-11-23 16:41:17: 0: INFO: Popup Handling Enabled: True
2023-11-23 16:41:17: 0: INFO: QT Popup Handling Enabled: False
2023-11-23 16:41:17: 0: INFO: WindowsForms10.Window.8.app.* Popup Handling Enabled: False
2023-11-23 16:41:17: 0: INFO: Using Process Tree: True
2023-11-23 16:41:17: 0: INFO: Hiding DOS Window: True
2023-11-23 16:41:17: 0: INFO: Creating New Console: False
2023-11-23 16:41:17: 0: INFO: Running as user: Simeon
2023-11-23 16:41:17: 0: INFO: Executable: "C:\Program Files\Adobe\Adobe After Effects 2023\Support Files\aerender.exe"
2023-11-23 16:41:17: 0: INFO: Argument: -project "T:\AfterEffects\deadlineRSC_test_2023.aep" -comp "Comp 1" -s 0 -e 9 -v ERRORS_AND_PROGRESS -close DO_NOT_SAVE_CHANGES -sound OFF
2023-11-23 16:41:17: 0: INFO: Full Command: "C:\Program Files\Adobe\Adobe After Effects 2023\Support Files\aerender.exe" -project "T:\AfterEffects\deadlineRSC_test_2023.aep" -comp "Comp 1" -s 0 -e 9 -v ERRORS_AND_PROGRESS -close DO_NOT_SAVE_CHANGES -sound OFF
2023-11-23 16:41:17: 0: INFO: Startup Directory: "C:\Program Files\Adobe\Adobe After Effects 2023\Support Files"
2023-11-23 16:41:17: 0: INFO: Process Priority: BelowNormal
2023-11-23 16:41:17: 0: INFO: Process Affinity: default
2023-11-23 16:41:17: 0: INFO: Process is now running
2023-11-23 16:41:17: 0: INFO: Submitted from After Effects version: 23.6.2x5
2023-11-23 16:41:17: 0: STDOUT: aerender version 23.6.2x5
2023-11-23 16:41:24: 0: STDOUT: PROGRESS: Launching After Effects...
2023-11-23 16:41:24: 0: INFO: Checking for file "C:\Users\Simeon\Documents\ae_render_only_node.txt"
2023-11-23 16:41:24: 0: INFO: Attempting to delete "C:\Users\Simeon\Documents\ae_render_only_node.txt" to allow After Effects to run in the workstation environment
2023-11-23 16:41:24: 0: STDOUT: aerender Error: After Effects error: Unable to call "openFast" because of parameter 1. Path is not valid. Path: "T:\AfterEffects\deadlineRSC_test_2023.aep"
2023-11-23 16:41:24: 0: Done executing plugin command of type 'Render Task'
=======================================================
Details
=======================================================
Date: 11/23/2023 16:41:28
Frames: 0-9
Elapsed Time: 00:00:00:13
Job Submit Date: 11/23/2023 16:23:22
Job User: simeon
Average RAM Usage: 20746805248 (16%)
Peak RAM Usage: 20746805248 (16%)
Average CPU Usage: 96%
Peak CPU Usage: 98%
Used CPU Clocks (x10^6 cycles): 2276753
Total CPU Clocks (x10^6 cycles): 2371617
=======================================================
Worker Information
=======================================================
Worker Name: MB3D-08
Version: v10.3.0.15 Release (76d003b0a)
Operating System: Windows 10 Home
Running As Service: No
Machine User: Simeon
IP Address: 2a02:a210:2044:2d80:1f87:6801:ec27:b8c5
MAC Address: 08:BF:B8:56:06:C3
CPU Architecture: x64
CPUs: 64
CPU Usage: 98%
Memory Usage: 19.3 GB / 127.9 GB (15%)
Free Disk Space: 367.610 GB
Video Card: NVIDIA GeForce GTX 1080 Ti
To run this command outside of Deadline, youāre going to find the line starting with āFull Commandā from that log. Hereās the one from your posted log:
Run that on the affected machine and see how it behaves. If it succeeds my guess would be that the T:\ drive isnāt mounted for the Simeon user, and itās not set up in the Monitor under Tools ā Configure Repository Options ā Mapped Drives so Deadline isnāt able to do it.
First of all; YOU ARE A HERO!!!
Mapping the drives in the repository options fixed the issue! Thank you so much! I have been trying for weeks!!
Second; It is the weirdest thingā¦ yesterday I tried to render the project with the arrender in CMD commandline and it rendered just fine, now I am getting the same openFast param. 1 error there is CMD. But whateverā¦ Deadline works and that is what counts! Thanks again!
Thank you so much! I have been trying for weeks!!