I’ve run into a curious problem where, when running Deadline 3.1.0.35390 as a service, the Deadline Slave service times out waiting for a connection from 3ds Max on one of my render slaves. The test job renders fine when running Deadline Slave as an application, or when Deadline Slave is running as a service and 32-bit rendering is forced, but when running as a service and rendering 64-bit, it times out. The interesting thing is that another machine with the identical setup renders fine, which is making it hard to track down the problem (the machine in question is a RenderBoxx run Windows XP 64-bit SP2.
On the good machine, I’ve noticed that when the slave sees the render job, the deadlineslave.exe process launches the 3dsmax.exe process and both begin using CPU and RAM, while on the bad slave, deadlineslave.exe launches 3dsmax.exe, but neither process uses any more of the CPU or RAM and just stays in the same state. It seems like there’s some miscommunication going on, but I can’t tell if it’s on the Deadline side or the 3ds Max side. Any help would be appreciated.
I’ve included the relevant log from the failing slave below.
Cheers,
Eric
–
2009-05-11 09:27:13: BEGIN - ARCH-BOXX-01\ek23
2009-05-11 09:27:13: Start-up
2009-05-11 09:27:13: 2009-05-11 09:27:13
2009-05-11 09:27:13: Deadline Slave 3.1 [v3.1.0.35390 R]
2009-05-11 09:27:14: slave initialization beginning.
2009-05-11 09:27:14: Repository time: 05/11/2009 09:27:15
2009-05-11 09:27:14: Slave ‘Arch-boxx-01’ has stalled, house cleaning in progress
2009-05-11 09:27:16: could not find associated job class though.
2009-05-11 09:27:16: Info Thread - Created.
2009-05-11 09:27:45:
2009-05-11 09:27:46: Scheduler Thread - Plugin loaded in 0.17 seconds.
2009-05-11 09:27:46: Constructor: 3dsmax
2009-05-11 09:27:47: 0: Task timeout is disabled.
2009-05-11 09:27:47: 0: Loaded job: Untitled (003_050_003_1072a3fc)
2009-05-11 09:27:47: 0: INFO: StartJob: initializing script plugin 3dsmax
2009-05-11 09:27:49: 0: INFO: About: 3dsmax Plugin for Deadline
2009-05-11 09:27:49: 0: INFO: Start Job called - starting up 3dsmax plugin
2009-05-11 09:27:49: 0: INFO: Rendering with 3dsmax version: 2009
2009-05-11 09:27:49: 0: INFO: Build of 3dsmax to force: 64bit
2009-05-11 09:27:49: 0: INFO: Rendering with executable: C:\Program Files\Autodesk\3ds Max 2009\3dsmax.exe
2009-05-11 09:27:49: 0: INFO: Fail on existing 3dsmax process: 0
2009-05-11 09:27:49: 0: INFO: Load 3dsmax timeout: 1000 seconds
2009-05-11 09:27:49: 0: INFO: Start job timeout: 1000 seconds
2009-05-11 09:27:49: 0: INFO: Progress update timeout: 8000 seconds
2009-05-11 09:27:49: 0: INFO: Progress update timout disabled: 0
2009-05-11 09:27:49: 0: INFO: Slave mode enabled: 1
2009-05-11 09:27:49: 0: INFO: Silent mode enabled: 0
2009-05-11 09:27:49: 0: INFO: Local rendering enabled: 1
2009-05-11 09:27:49: 0: INFO: Strict 3dsmax check enabled: 1
2009-05-11 09:27:49: 0: INFO: Verifying installation of 3dsmax 2009 at C:\Program Files\Autodesk\3ds Max 2009
2009-05-11 09:27:49: 0: INFO: Version of core.dll: 11.0.0.57
2009-05-11 09:27:49: 0: INFO: Ensuring 3dsmax install is valid
2009-05-11 09:27:49: 0: INFO: Running 3dsmaxcmd workaround
2009-05-11 09:27:50: 0: INFO: 3dsmaxcmd.exe returned: P5/11/2009 9:27:49 AM; Error opening scene file: “C:\Program Files\Autodesk\3ds Max 2009”
2009-05-11 09:27:50: 0: INFO: 3dsmax start up file: C:\Documents and Settings\ek23\Local Settings\Application Data\Frantic Films\Deadline\slave\plugins\deadlineStartupMax2009.max
2009-05-11 09:27:50: 0: INFO: Using user profiles: 1
2009-05-11 09:27:50: 0: INFO: Using 3dsmax ini file: C:\Documents and Settings\ek23\Local Settings\Application Data\Autodesk\3dsmax\2009 - 64bit\enu\3dsmax.ini
2009-05-11 09:27:50: 0: INFO: Network log file: C:\Documents and Settings\ek23\Local Settings\Application Data\Autodesk\3dsmax\2009 - 64bit\enu\Network\Max.log
2009-05-11 09:27:50: 0: INFO: Plugin ini file: C:\Program Files\Autodesk\3ds Max 2009\plugin.ini
2009-05-11 09:27:50: 0: INFO: Not including user profile plugin ini because it does not exist: C:\Documents and Settings\ek23\Local Settings\Application Data\Autodesk\3dsmax\2009 - 64bit\enu\plugin.ini
2009-05-11 09:27:50: 0: INFO: Lightning connection plugin: C:\Documents and Settings\ek23\Local Settings\Application Data\Frantic Films\Deadline\slave\plugins\lightning64Max2009.dlx
2009-05-11 09:27:50: 0: INFO: 3dsmax socket connection port: 4736
2009-05-11 09:27:50: 0: INFO: Creating startup script: C:\Documents and Settings\ek23\Local Settings\Temp\lightning_startup.ms
2009-05-11 09:27:50: 0: INFO: Copying C:\Documents and Settings\ek23\Local Settings\Application Data\Frantic Films\Deadline\slave\plugins\lightning64Max2009.dlx to C:\Documents and Settings\ek23\Local Settings\Application Data\Frantic Films\Deadline\temp\lightning\lightning.dlx
2009-05-11 09:27:50: 0: INFO: Starting monitored managed process 3dsmaxProcess
2009-05-11 09:27:50: 0: INFO: Ignoring popup windows with titles matching regex “.Brazil Console.”
2009-05-11 09:27:50: 0: INFO: Ignoring popup windows with titles matching regex “.MSP Acceleration.”
2009-05-11 09:27:50: 0: INFO: Ignoring popup windows with titles matching regex “.FumeFX:.”
2009-05-11 09:27:50: 0: INFO: Ignoring popup windows with titles matching regex “.FumeFX Dynamics:.”
2009-05-11 09:27:50: 0: INFO: Ignoring popup windows with titles matching regex “.Maxwell Translation Window.”
2009-05-11 09:27:50: 0: INFO: Handling popup windows with titles matching regex “.VRay authorization.” by pressing “Cancel”
2009-05-11 09:27:50: 0: INFO: Handling popup windows with titles matching regex “.V-Ray warning.” by pressing “OK”
2009-05-11 09:27:50: 0: INFO: Handling popup windows with titles matching regex “.File Load: Units Mismatch.” by pressing “Adopt the File’s Unit Scale?;OK”
2009-05-11 09:27:50: 0: INFO: Handling popup windows with titles matching regex “.Frame Rate Change.” by pressing “OK”
2009-05-11 09:27:50: 0: INFO: Handling popup windows with titles matching regex “.MAXScript Auto-load Script Error.” by pressing “OK”
2009-05-11 09:27:50: 0: INFO: Handling popup windows with titles matching regex “.Render history settings.” by pressing “OK;No”
2009-05-11 09:27:50: 0: INFO: Handling popup windows with titles matching regex “.Warning - the software has encountered a problem.” by pressing “Don’t show me this error again;Continue”
2009-05-11 09:27:50: 0: INFO: Handling popup windows with titles matching regex “.Frantic Films FPS Watchdog.” by pressing “OK”
2009-05-11 09:27:50: 0: INFO: Handling popup windows with titles matching regex “.Missing Dlls.” by pressing “Cancel”
2009-05-11 09:27:50: 0: INFO: Handling popup windows with titles matching regex “Brazil r/s Rio Warning” by pressing “OK”
2009-05-11 09:27:50: 0: INFO: Handling popup windows with titles matching regex “3D Studio MAX” by pressing “OK”
2009-05-11 09:27:50: 0: INFO: Stdout Handling Enabled: False
2009-05-11 09:27:50: 0: INFO: Popup Handling Enabled: True
2009-05-11 09:27:50: 0: INFO: Using Process Tree: True
2009-05-11 09:27:50: 0: INFO: Hiding DOS Window: False
2009-05-11 09:27:50: 0: INFO: Creating New Console: False
2009-05-11 09:27:50: 0: INFO: Render Executable: “C:\Program Files\Autodesk\3ds Max 2009\3dsmax.exe”
2009-05-11 09:27:50: 0: INFO: Render Argument: -p “C:\DOCUME~1\ek23\LOCALS~1\Temp\dl.ini” -q -s “C:\Documents and Settings\ek23\Local Settings\Application Data\Frantic Films\Deadline\slave\plugins\deadlineStartupMax2009.max”
2009-05-11 09:27:50: 0: INFO: Startup Directory: “C:\Program Files\Autodesk\3ds Max 2009”
2009-05-11 09:27:50: 0: INFO: Process Priority: BelowNormal
2009-05-11 09:27:50: 0: INFO: Process is now running
2009-05-11 09:27:50: 0: INFO: Waiting for connection from 3dsmax
2009-05-11 09:29:23: Info Thread - Cancelling task because task filename “\arch-render\DeadlineRepository\jobs\003_050_003_1072a3fc\Rendering\003_050_003_1072a3fc_00000_1-10.Arch-boxx-01” could not be found, it was likely requeued
2009-05-11 09:29:23: sending cancel task command to plugin
2009-05-11 09:29:24: 0: In the process of canceling current task: ignoring exception thrown by PluginLoader
2009-05-11 09:29:36: Scheduler Thread - In the process of canceling current tasks: ignoring exception thrown by render thread 0
2009-05-11 09:30:06: