AWS Thinkbox Discussion Forums

RenderPluginException error when submitting through After Effects

I get a RenderPluginException error when submitting through the After Effects submissions script, and my renders are unable to complete.

However, if I submit a comp through Deadline, it renders fine.

Am I doing something wrong?

Here’s a full error log:

=======================================================
Error
=======================================================
Error: There were 1 or more errors with the output
   at Deadline.Plugins.PluginWrapper.RenderTasks(Task task, String& outMessage, AbortLevel& abortLevel)

=======================================================
Type
=======================================================
RenderPluginException

=======================================================
Stack Trace
=======================================================
   at Deadline.Plugins.SandboxedPlugin.d(DeadlineMessage bgt, CancellationToken bgu)
   at Deadline.Plugins.SandboxedPlugin.RenderTask(Task task, CancellationToken cancellationToken)
   at Deadline.Slaves.SlaveRenderThread.c(TaskLogWriter ajy, CancellationToken ajz)

=======================================================
Log
=======================================================
2023-09-14 14:04:41:  0: Loading Job's Plugin timeout is Disabled
2023-09-14 14:04:41:  0: SandboxedPlugin: Render Job As User disabled, running as current user 'admin25'
2023-09-14 14:04:44:  0: Executing plugin command of type 'Initialize Plugin'
2023-09-14 14:04:44:  0: INFO: Executing plugin script '/Users/Shared/Thinkbox/Deadline10/workers/gfx-render-02/plugins/65037391390baeb7c5b68558/AfterEffects.py'
2023-09-14 14:04:44:  0: INFO: Plugin execution sandbox using Python version 3
2023-09-14 14:04:44:  0: INFO: Fail Without Finished Message set to: False
2023-09-14 14:04:44:  0: INFO: Fail on Existing After Effects process: False
2023-09-14 14:04:44:  0: INFO: About: After Effects Plugin for Deadline
2023-09-14 14:04:44:  0: INFO: The job's environment will be merged with the current environment before rendering
2023-09-14 14:04:44:  0: Done executing plugin command of type 'Initialize Plugin'
2023-09-14 14:04:44:  0: Start Job timeout is disabled.
2023-09-14 14:04:44:  0: Task timeout is disabled.
2023-09-14 14:04:44:  0: Loaded job: s (65037391390baeb7c5b68558)
2023-09-14 14:04:45:  0: Executing plugin command of type 'Start Job'
2023-09-14 14:04:45:  0: DEBUG: S3BackedCache Client is not installed.
2023-09-14 14:04:45:  0: INFO: Executing global asset transfer preload script '/Users/Shared/Thinkbox/Deadline10/workers/gfx-render-02/plugins/65037391390baeb7c5b68558/GlobalAssetTransferPreLoad.py'
2023-09-14 14:04:45:  0: INFO: Looking for legacy (pre-10.0.26) AWS Portal File Transfer...
2023-09-14 14:04:45:  0: INFO: No legacy (pre-10.0.26) File Transfer controller is available for this platform (darwin).
2023-09-14 14:04:45:  0: INFO: Could not find legacy (pre-10.0.26) AWS Portal File Transfer.
2023-09-14 14:04:45:  0: INFO: Legacy (pre-10.0.26) AWS Portal File Transfer is not installed on the system.
2023-09-14 14:04:45:  0: Done executing plugin command of type 'Start Job'
2023-09-14 14:04:45:  0: Plugin rendering frame(s): 0-94
2023-09-14 14:04:45:  0: Executing plugin command of type 'Render Task'
2023-09-14 14:04:45:  0: INFO: Attempting to create "/Users/admin25/Documents/ae_render_only_node.txt" to force After Effects to run in Render Engine mode
2023-09-14 14:04:45:  0: INFO: Stdout Redirection Enabled: True
2023-09-14 14:04:45:  0: INFO: Asynchronous Stdout Enabled: False
2023-09-14 14:04:45:  0: INFO: Stdout Handling Enabled: True
2023-09-14 14:04:45:  0: INFO: Popup Handling Enabled: True
2023-09-14 14:04:45:  0: INFO: QT Popup Handling Enabled: False
2023-09-14 14:04:45:  0: INFO: WindowsForms10.Window.8.app.* Popup Handling Enabled: False
2023-09-14 14:04:45:  0: INFO: Using Process Tree: True
2023-09-14 14:04:45:  0: INFO: Hiding DOS Window: True
2023-09-14 14:04:45:  0: INFO: Creating New Console: False
2023-09-14 14:04:45:  0: INFO: Running as user: admin25
2023-09-14 14:04:45:  0: INFO: Executable: "/Applications/Adobe After Effects 2023/aerender"
2023-09-14 14:04:45:  0: INFO: Argument: -project "/Users/Shared/Thinkbox/Deadline10/workers/gfx-render-02/jobsData/65037391390baeb7c5b68558/JFC_TestRenders_4K_GFX_01.aep" -comp "s" -s 0 -e 94 -mem_usage 95 95 -mp -v ERRORS_AND_PROGRESS -close DO_NOT_SAVE_CHANGES -sound OFF
2023-09-14 14:04:45:  0: INFO: Full Command: "/Applications/Adobe After Effects 2023/aerender" -project "/Users/Shared/Thinkbox/Deadline10/workers/gfx-render-02/jobsData/65037391390baeb7c5b68558/JFC_TestRenders_4K_GFX_01.aep" -comp "s" -s 0 -e 94 -mem_usage 95 95 -mp -v ERRORS_AND_PROGRESS -close DO_NOT_SAVE_CHANGES -sound OFF
2023-09-14 14:04:45:  0: INFO: Startup Directory: "/Applications/Adobe After Effects 2023"
2023-09-14 14:04:45:  0: INFO: Process Priority: BelowNormal
2023-09-14 14:04:45:  0: INFO: Process Affinity: default
2023-09-14 14:04:45:  0: INFO: Process is now running
2023-09-14 14:04:50:  0: STDOUT: WARNING:After Effects warning: Project has missing fonts.
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  9/14/23 2:04:51 PM PDT: Starting composition “s”.
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Render Settings: Best Settings
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Quality: Best
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Resolution: Full
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Size: 4200 x 2363
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Proxy Use: Use No Proxies
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Effects: Current Settings
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Disk Cache: Read Only
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Color Depth: Current Settings
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Frame Blending: On for Checked Layers
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Field Render: Off
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Pulldown: Off
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Motion Blur: On for Checked Layers
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Solos: Current Settings
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Time Span: Custom
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Start: 0:00:00:00
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  End: 0:00:03:22
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Duration: 0:00:03:23
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Frame Rate: 23.976 (comp)
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Guide Layers: All Off
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Skip Existing Files: Off
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Output Module: H.264 - Match Render Settings - 15 Mbps
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Output To: /Users/Shared/Thinkbox/Deadline10/workers/gfx-render-02/z.mov
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Format: QuickTime
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Output Info: Apple ProRes 4444
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Include: -
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Output Audio: Off
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Channels: RGB
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Depth: Millions of Colors
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Color: Premultiplied
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Resize: -
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Crop: -
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Final Size: 4200 x 2363
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Profile: -
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  Post-Render Action: None
2023-09-14 14:04:51:  0: STDOUT: PROGRESS:  
2023-09-14 14:05:24:  0: STDOUT: PROGRESS:  0:00:00:00 (1): 32 Seconds
2023-09-14 14:05:25:  0: STDOUT: PROGRESS:  0:00:00:01 (2): 1 Seconds
2023-09-14 14:05:25:  0: STDOUT: PROGRESS:  0:00:00:02 (3): 1 Seconds
2023-09-14 14:05:26:  0: STDOUT: PROGRESS:  0:00:00:03 (4): 0 Seconds
2023-09-14 14:05:58:  0: STDOUT: PROGRESS:  0:00:00:04 (5): 32 Seconds
2023-09-14 14:05:58:  0: STDOUT: PROGRESS:  0:00:00:05 (6): 0 Seconds
2023-09-14 14:05:59:  0: STDOUT: PROGRESS:  0:00:00:06 (7): 1 Seconds
2023-09-14 14:06:00:  0: STDOUT: PROGRESS:  0:00:00:07 (8): 1 Seconds
2023-09-14 14:06:00:  0: STDOUT: PROGRESS:  0:00:00:08 (9): 0 Seconds
2023-09-14 14:06:40:  0: STDOUT: PROGRESS:  0:00:00:09 (10): 40 Seconds
2023-09-14 14:06:40:  0: STDOUT: PROGRESS:  0:00:00:10 (11): 0 Seconds
2023-09-14 14:06:41:  0: STDOUT: PROGRESS:  0:00:00:11 (12): 1 Seconds
2023-09-14 14:06:42:  0: STDOUT: PROGRESS:  0:00:00:12 (13): 1 Seconds
2023-09-14 14:06:42:  0: STDOUT: PROGRESS:  0:00:00:13 (14): 0 Seconds
2023-09-14 14:06:42:  0: STDOUT: PROGRESS:  0:00:00:14 (15): 1 Seconds
2023-09-14 14:07:22:  0: STDOUT: PROGRESS:  0:00:00:15 (16): 39 Seconds
2023-09-14 14:07:22:  0: STDOUT: PROGRESS:  0:00:00:16 (17): 0 Seconds
2023-09-14 14:07:23:  0: STDOUT: PROGRESS:  0:00:00:17 (18): 2 Seconds
2023-09-14 14:07:24:  0: STDOUT: PROGRESS:  0:00:00:18 (19): 0 Seconds
2023-09-14 14:07:24:  0: STDOUT: PROGRESS:  0:00:00:19 (20): 0 Seconds
2023-09-14 14:07:25:  0: STDOUT: PROGRESS:  0:00:00:20 (21): 1 Seconds
2023-09-14 14:07:57:  0: STDOUT: PROGRESS:  0:00:00:21 (22): 32 Seconds
2023-09-14 14:07:58:  0: STDOUT: PROGRESS:  0:00:00:22 (23): 1 Seconds
2023-09-14 14:07:58:  0: STDOUT: PROGRESS:  0:00:00:23 (24): 1 Seconds
2023-09-14 14:07:59:  0: STDOUT: PROGRESS:  0:00:01:00 (25): 0 Seconds
2023-09-14 14:07:59:  0: STDOUT: PROGRESS:  0:00:01:01 (26): 0 Seconds
2023-09-14 14:08:33:  0: STDOUT: PROGRESS:  0:00:01:02 (27): 34 Seconds
2023-09-14 14:08:34:  0: STDOUT: PROGRESS:  0:00:01:03 (28): 1 Seconds
2023-09-14 14:08:34:  0: STDOUT: PROGRESS:  0:00:01:04 (29): 0 Seconds
2023-09-14 14:08:34:  0: STDOUT: PROGRESS:  0:00:01:05 (30): 1 Seconds
2023-09-14 14:08:35:  0: STDOUT: PROGRESS:  0:00:01:06 (31): 0 Seconds
2023-09-14 14:09:01:  0: STDOUT: PROGRESS:  0:00:01:07 (32): 26 Seconds
2023-09-14 14:09:02:  0: STDOUT: PROGRESS:  0:00:01:08 (33): 1 Seconds
2023-09-14 14:09:02:  0: STDOUT: PROGRESS:  0:00:01:09 (34): 0 Seconds
2023-09-14 14:09:03:  0: STDOUT: PROGRESS:  0:00:01:10 (35): 1 Seconds
2023-09-14 14:09:30:  0: STDOUT: PROGRESS:  0:00:01:11 (36): 27 Seconds
2023-09-14 14:09:30:  0: STDOUT: PROGRESS:  0:00:01:12 (37): 0 Seconds
2023-09-14 14:09:30:  0: STDOUT: PROGRESS:  0:00:01:13 (38): 0 Seconds
2023-09-14 14:09:31:  0: STDOUT: PROGRESS:  0:00:01:14 (39): 1 Seconds
2023-09-14 14:09:58:  0: STDOUT: PROGRESS:  0:00:01:15 (40): 27 Seconds
2023-09-14 14:09:58:  0: STDOUT: PROGRESS:  0:00:01:16 (41): 0 Seconds
2023-09-14 14:09:59:  0: STDOUT: PROGRESS:  0:00:01:17 (42): 1 Seconds
2023-09-14 14:09:59:  0: STDOUT: PROGRESS:  0:00:01:18 (43): 1 Seconds
2023-09-14 14:10:33:  0: STDOUT: PROGRESS:  0:00:01:19 (44): 33 Seconds
2023-09-14 14:10:33:  0: STDOUT: PROGRESS:  0:00:01:20 (45): 0 Seconds
2023-09-14 14:10:34:  0: STDOUT: PROGRESS:  0:00:01:21 (46): 1 Seconds
2023-09-14 14:10:34:  0: STDOUT: PROGRESS:  0:00:01:22 (47): 0 Seconds
2023-09-14 14:10:35:  0: STDOUT: PROGRESS:  0:00:01:23 (48): 1 Seconds
2023-09-14 14:11:00:  0: STDOUT: PROGRESS:  0:00:02:00 (49): 26 Seconds
2023-09-14 14:11:01:  0: STDOUT: PROGRESS:  0:00:02:01 (50): 0 Seconds
2023-09-14 14:11:02:  0: STDOUT: PROGRESS:  0:00:02:02 (51): 1 Seconds
2023-09-14 14:11:02:  0: STDOUT: PROGRESS:  0:00:02:03 (52): 1 Seconds
2023-09-14 14:11:29:  0: STDOUT: PROGRESS:  0:00:02:04 (53): 26 Seconds
2023-09-14 14:11:29:  0: STDOUT: PROGRESS:  0:00:02:05 (54): 0 Seconds
2023-09-14 14:11:30:  0: STDOUT: PROGRESS:  0:00:02:06 (55): 1 Seconds
2023-09-14 14:11:30:  0: STDOUT: PROGRESS:  0:00:02:07 (56): 1 Seconds
2023-09-14 14:12:03:  0: STDOUT: PROGRESS:  0:00:02:08 (57): 32 Seconds
2023-09-14 14:12:03:  0: STDOUT: PROGRESS:  0:00:02:09 (58): 0 Seconds
2023-09-14 14:12:04:  0: STDOUT: PROGRESS:  0:00:02:10 (59): 1 Seconds
2023-09-14 14:12:05:  0: STDOUT: PROGRESS:  0:00:02:11 (60): 1 Seconds
2023-09-14 14:12:05:  0: STDOUT: PROGRESS:  0:00:02:12 (61): 0 Seconds
2023-09-14 14:12:38:  0: STDOUT: PROGRESS:  0:00:02:13 (62): 34 Seconds
2023-09-14 14:12:39:  0: STDOUT: PROGRESS:  0:00:02:14 (63): 0 Seconds
2023-09-14 14:12:40:  0: STDOUT: PROGRESS:  0:00:02:15 (64): 1 Seconds
2023-09-14 14:12:40:  0: STDOUT: PROGRESS:  0:00:02:16 (65): 0 Seconds
2023-09-14 14:12:41:  0: STDOUT: PROGRESS:  0:00:02:17 (66): 1 Seconds
2023-09-14 14:13:07:  0: STDOUT: PROGRESS:  0:00:02:18 (67): 26 Seconds
2023-09-14 14:13:07:  0: STDOUT: PROGRESS:  0:00:02:19 (68): 0 Seconds
2023-09-14 14:13:08:  0: STDOUT: PROGRESS:  0:00:02:20 (69): 1 Seconds
2023-09-14 14:13:09:  0: STDOUT: PROGRESS:  0:00:02:21 (70): 1 Seconds
2023-09-14 14:13:35:  0: STDOUT: PROGRESS:  0:00:02:22 (71): 26 Seconds
2023-09-14 14:13:36:  0: STDOUT: PROGRESS:  0:00:02:23 (72): 1 Seconds
2023-09-14 14:13:37:  0: STDOUT: PROGRESS:  0:00:03:00 (73): 1 Seconds
2023-09-14 14:13:37:  0: STDOUT: PROGRESS:  0:00:03:01 (74): 0 Seconds
2023-09-14 14:14:03:  0: STDOUT: PROGRESS:  0:00:03:02 (75): 26 Seconds
2023-09-14 14:14:04:  0: STDOUT: PROGRESS:  0:00:03:03 (76): 1 Seconds
2023-09-14 14:14:05:  0: STDOUT: PROGRESS:  0:00:03:04 (77): 1 Seconds
2023-09-14 14:14:05:  0: STDOUT: PROGRESS:  0:00:03:05 (78): 1 Seconds
2023-09-14 14:14:38:  0: STDOUT: PROGRESS:  0:00:03:06 (79): 33 Seconds
2023-09-14 14:14:39:  0: STDOUT: PROGRESS:  0:00:03:07 (80): 0 Seconds
2023-09-14 14:14:40:  0: STDOUT: PROGRESS:  0:00:03:08 (81): 1 Seconds
2023-09-14 14:14:41:  0: STDOUT: PROGRESS:  0:00:03:09 (82): 1 Seconds
2023-09-14 14:14:41:  0: STDOUT: PROGRESS:  0:00:03:10 (83): 0 Seconds
2023-09-14 14:15:13:  0: STDOUT: PROGRESS:  0:00:03:11 (84): 32 Seconds
2023-09-14 14:15:15:  0: STDOUT: PROGRESS:  0:00:03:12 (85): 2 Seconds
2023-09-14 14:15:16:  0: STDOUT: PROGRESS:  0:00:03:13 (86): 1 Seconds
2023-09-14 14:15:16:  0: STDOUT: PROGRESS:  0:00:03:14 (87): 1 Seconds
2023-09-14 14:15:17:  0: STDOUT: PROGRESS:  0:00:03:15 (88): 0 Seconds
2023-09-14 14:15:56:  0: STDOUT: PROGRESS:  0:00:03:16 (89): 39 Seconds
2023-09-14 14:15:56:  0: STDOUT: PROGRESS:  0:00:03:17 (90): 0 Seconds
2023-09-14 14:15:57:  0: STDOUT: PROGRESS:  0:00:03:18 (91): 2 Seconds
2023-09-14 14:15:58:  0: STDOUT: PROGRESS:  0:00:03:19 (92): 0 Seconds
2023-09-14 14:15:58:  0: STDOUT: PROGRESS:  0:00:03:20 (93): 0 Seconds
2023-09-14 14:15:58:  0: STDOUT: PROGRESS:  0:00:03:21 (94): 0 Seconds
2023-09-14 14:15:58:  0: STDOUT: PROGRESS:  0:00:03:22 (95): 0 Seconds
2023-09-14 14:15:58:  0: STDOUT: PROGRESS:  9/14/23 2:15:58 PM PDT: Finished composition “s”.
2023-09-14 14:15:58:  0: STDOUT: PROGRESS:  Total Time Elapsed: 11 Min, 8 Sec
2023-09-14 14:16:02:  0: INFO: Submitted from After Effects version: 23.6x62
2023-09-14 14:16:02:  0: STDOUT: aerender version 23.6x62
2023-09-14 14:16:02:  0: STDOUT: PROGRESS: Launching After Effects...
2023-09-14 14:16:02:  0: INFO: Process exit code: 0
2023-09-14 14:16:02:  0: INFO: Checking for file "/Users/admin25/Documents/ae_render_only_node.txt"
2023-09-14 14:16:02:  0: INFO: Attempting to delete "/Users/admin25/Documents/ae_render_only_node.txt" to allow After Effects to run in the workstation environment
2023-09-14 14:16:02:  0: INFO: Checking file size of "/Volumes/04-Local-Media/Matthew/test_render/z.mov"
2023-09-14 14:16:02:  0: INFO:     z.mov does not exist
2023-09-14 14:16:02:  0: Done executing plugin command of type 'Render Task'

=======================================================
Details
=======================================================
Date: 09/14/2023 14:16:06
Frames: 0-94
Elapsed Time: 00:00:11:28
Job Submit Date: 09/14/2023 13:56:49
Job User: mbc
Average RAM Usage: 2487310848 (8%)
Peak RAM Usage: 4182147072 (13%)
Average CPU Usage: 70%
Peak CPU Usage: 100%
Used CPU Clocks (x10^6 cycles): 11421921
Total CPU Clocks (x10^6 cycles): 16317031

=======================================================
Worker Information
=======================================================
Worker Name: gfx-render-02
Version: v10.3.0.10 Release (ac90e7082)
Operating System: macOS 13.5.2
Machine User: admin25
IP Address: 10.0.1.66
MAC Address: 9C:76:0E:34:89:99
CPU Architecture: x86_64
CPUs: 10
CPU Usage: 81%
Memory Usage: 2.5 GB / 32.0 GB (7%)
Free Disk Space: 303.276 GB 
Video Card: Apple M1 Max

Hello @mcwsc
Thanks for reaching out. May be it is a permissions issue. To troubleshoot it login into gfx-render-02 as user ‘admin25’. then run below command through terminal:
"/Applications/Adobe After Effects 2023/aerender" -project "/Users/Shared/Thinkbox/Deadline10/workers/gfx-render-02/jobsData/65037391390baeb7c5b68558/JFC_TestRenders_4K_GFX_01.aep" -comp "s" -s 0 -e 94 -mem_usage 95 95 -mp -v ERRORS_AND_PROGRESS -close DO_NOT_SAVE_CHANGES -sound OFF

Does it through an error.

It seems like that is tried to check the file size but the file was moved somewhere?

There is an option in the submission to Delete Files Under Minimum File Size are you setting that to true? Check here for more details: After Effects — Deadline 10.3.0.10 documentation uncheck that option and try again. Probably it is rendering the blank output.

Thank you - the problem was in fact Delete Files Under Minimum File Size. Unchecking that has the After Effects script working fine.

1 Like
Privacy | Site terms | Cookie preferences