00:00:00 (0000.00) | Log started Sun Sep 22 11:51:41 2019 00:00:00 (0000.00) | Octane Render for Lightwave by Juanjo González. Build 2019.01.0.5 (Build date: Sep 20 2019 17:53:39) 00:00:00 (0000.08) | Compiled for LightWave 2019.0 (build 3114) 00:00:00 (0000.08) | Compiled using the Octane API 2019.1 00:00:00 (0000.08) | Running on LightWave 2019.1 (build: 3131) 00:00:00 (0000.08) | Running on Octane DLL 6000100 00:00:00 (0000.08) | System: GenuineIntel Genuine Intel(R) CPU @ 2.10GHz, 2099 Mhz., 48 cores 00:00:00 (0000.08) | OS: Windows 7 64-bit 00:00:00 (0000.08) | 00:00:00 (0000.08) | Init rendering from frame 0 to 0 step 1 00:00:00 (0000.08) | Range rendering disabled for F9 still images 00:00:00 (0000.08) | Init preview window 00:00:00 (0000.09) | >>> Draw preview window progress bar 00:00:00 (0000.09) | Enter inside the main rendering function 00:00:00 (0000.09) | Render layers disabled 00:00:00 (0000.09) | 00:00:00 (0000.09) | ()() RENDERING FRAME 0 00:00:00 (0000.12) | ()()() Evaluating scene for frame 0 00:00:00 (0000.12) | 00:00:00 (0000.12) | Init scene 00:00:00 (0000.12) | >>> Refresh preview window 00:00:00 (0000.12) | >>> Draw preview window progress bar 00:00:00 (0000.15) | >>> Refresh preview window done 00:00:00 (0000.15) | Init the root geometryGroup 00:00:00 (0000.15) | 00:00:00 (0000.15) | Processing the motion blur data 00:00:00 (0000.15) | Get the scene motion blur settings 00:00:00 (0000.15) | Motion blur disabled, computing only one time sample 00:00:00 (0000.15) | Processing time sample 1 of 1, time: 0.000000 00:00:00 (0000.15) | Get camera motion blur data 00:00:00 (0000.15) | * position: 1.262049 1.504955 3.599132 00:00:00 (0000.15) | * target: -33.093868 -12.412363 -89.277023 00:00:00 (0000.15) | * fov: 58.109208 00:00:00 (0000.15) | Get Objects motion blur data 00:00:00 (0000.15) | Object Ded_moroz_001:Main Layer transformation matrix: 00:00:00 (0000.15) | 1.000000 0.000000 -0.000000 0.000000 00:00:00 (0000.15) | 0.000000 1.000000 0.000000 0.000000 00:00:00 (0000.15) | -0.000000 -0.000000 1.000000 -0.000000 00:00:00 (0000.15) | Object Ground transformation matrix: 00:00:00 (0000.15) | 1.000000 0.000000 -0.000000 0.000000 00:00:00 (0000.15) | 0.000000 1.000000 0.000000 0.000000 00:00:00 (0000.15) | -0.000000 -0.000000 1.000000 -0.000000 00:00:00 (0000.15) | Object Ded_moroz_001 transformation matrix: 00:00:00 (0000.15) | 1.000000 0.000000 -0.000000 0.000000 00:00:00 (0000.15) | 0.000000 1.000000 0.000000 0.000000 00:00:00 (0000.15) | -0.000000 -0.000000 1.000000 -0.000000 00:00:00 (0000.15) | Get vertex deformations motion blur data 00:00:00 (0000.15) | Get Lights motion blur data 00:00:00 (0000.15) | Light Light transformation matrix: 00:00:00 (0000.15) | 0.707107 0.405580 -0.579228 -2.000000 00:00:00 (0000.15) | 0.000000 0.819152 0.573576 2.000000 00:00:00 (0000.15) | 0.707107 -0.405580 0.579228 2.000000 00:00:00 (0000.15) | Motion blur data ready 00:00:00 (0000.15) | 00:00:00 (0000.15) | Processing objects list from LW scene. FIRST PASS 00:00:00 (0000.15) | Number of LW objects: 3 00:00:00 (0000.15) | 00:00:00 (0000.15) | -> Reading scene UV Maps list 00:00:00 (0000.15) | --> Detected 1 UVMaps in scene 00:00:00 (0000.15) | ---> Add map1 UVMap to maps list 00:00:00 (0000.15) | 00:00:00 (0000.15) | Processing object: 10000000, name: Ded_moroz_001:Main Layer 00:00:00 (0000.15) | Searching if FiberFX is available in this object 00:00:00 (0000.15) | >>> Processing the number of valid polygons 00:00:00 (0000.15) | >>> This object has 6257 of 6257 valid polygons 00:00:00 (0000.15) | >>> Refresh preview window 00:00:00 (0000.15) | >>> Draw preview window progress bar 00:00:00 (0000.15) | >>> Refresh preview window done 00:00:00 (0000.15) | >>> Adding a new mesh to Octane 00:00:00 (0000.15) | >>> Mesh points: 6654, valid polygons: 6257 00:00:00 (0000.15) | ----> Searching UV maps in this object 00:00:00 (0000.15) | ----> Found map1 UV map in this object 00:00:00 (0000.15) | ----> We found 1 UV maps in this object 00:00:00 (0000.15) | [profile] Function "LWOctane_getVMap" over "" execution time: 0.003 seconds 00:00:00 (0000.15) | >>> Processing vertex per poly array 00:00:00 (0000.15) | [profile] Function "LWOctane_getVertsPerPoly" over "" execution time: 0.001 seconds 00:00:00 (0000.15) | >>> Processing vertex list 00:00:00 (0000.15) | [profile] Function "LWOctane_addVertex" over "" execution time: 0.000 seconds 00:00:00 (0000.15) | +++ Searching object materials 00:00:00 (0000.15) | +++ Found 16 materials inside Ded_moroz_001:Main Layer 00:00:00 (0000.15) | +++ Material 0 ID: Beard 00:00:00 (0000.15) | +++ Material 1 ID: Belt 00:00:00 (0000.15) | +++ Material 2 ID: Coat 00:00:00 (0000.15) | +++ Material 3 ID: Coat_fur 00:00:00 (0000.15) | +++ Material 4 ID: Coat_top 00:00:00 (0000.15) | +++ Material 5 ID: Eyes 00:00:00 (0000.15) | +++ Material 6 ID: Head 00:00:00 (0000.15) | +++ Material 7 ID: Santa_Claus:Santa_Claus_10 00:00:00 (0000.15) | +++ Material 8 ID: Santa_Claus:Santa_Claus_11 00:00:00 (0000.15) | +++ Material 9 ID: Santa_Claus:Santa_Claus_2 00:00:00 (0000.15) | +++ Material 10 ID: Santa_Claus:Santa_Claus_6 00:00:00 (0000.15) | +++ Material 11 ID: Santa_Claus:Santa_Claus_7 00:00:00 (0000.15) | +++ Material 12 ID: Santa_Claus:Santa_Claus_8 00:00:00 (0000.15) | +++ Material 13 ID: Santa_Claus:Santa_Claus_9 00:00:00 (0000.15) | +++ Material 14 ID: Valenki 00:00:00 (0000.15) | +++ Material 15 ID: Varezhki 00:00:00 (0000.15) | +++ Searching in the object materials for UVMAP nodes 00:00:00 (0000.15) | >>> Searching UVMAP node inside surface Beard 00:00:00 (0000.15) | >>> This material doesn't have a valid UVMAP node 00:00:00 (0000.15) | >>> Searching UVMAP node inside surface Belt 00:00:00 (0000.15) | >>> This material doesn't have a valid UVMAP node 00:00:00 (0000.15) | >>> Searching UVMAP node inside surface Coat 00:00:00 (0000.15) | >>> This material doesn't have a valid UVMAP node 00:00:00 (0000.15) | >>> Searching UVMAP node inside surface Coat_fur 00:00:00 (0000.15) | >>> This material doesn't have a valid UVMAP node 00:00:00 (0000.15) | >>> Searching UVMAP node inside surface Coat_top 00:00:00 (0000.15) | >>> This material doesn't have a valid UVMAP node 00:00:00 (0000.15) | >>> Searching UVMAP node inside surface Eyes 00:00:00 (0000.15) | >>> This material doesn't have a valid UVMAP node 00:00:00 (0000.15) | >>> Searching UVMAP node inside surface Head 00:00:00 (0000.15) | >>> This material doesn't have a valid UVMAP node 00:00:00 (0000.15) | >>> Searching UVMAP node inside surface Santa_Claus:Santa_Claus_10 00:00:00 (0000.15) | >>> This material doesn't have a valid UVMAP node 00:00:00 (0000.15) | >>> Searching UVMAP node inside surface Santa_Claus:Santa_Claus_11 00:00:00 (0000.15) | >>> This material doesn't have a valid UVMAP node 00:00:00 (0000.15) | >>> Searching UVMAP node inside surface Santa_Claus:Santa_Claus_2 00:00:00 (0000.15) | >>> This material doesn't have a valid UVMAP node 00:00:00 (0000.15) | >>> Searching UVMAP node inside surface Santa_Claus:Santa_Claus_6 00:00:00 (0000.15) | >>> This material doesn't have a valid UVMAP node 00:00:00 (0000.15) | >>> Searching UVMAP node inside surface Santa_Claus:Santa_Claus_7 00:00:00 (0000.15) | >>> This material doesn't have a valid UVMAP node 00:00:00 (0000.15) | >>> Searching UVMAP node inside surface Santa_Claus:Santa_Claus_8 00:00:00 (0000.15) | >>> This material doesn't have a valid UVMAP node 00:00:00 (0000.15) | >>> Searching UVMAP node inside surface Santa_Claus:Santa_Claus_9 00:00:00 (0000.15) | >>> This material doesn't have a valid UVMAP node 00:00:00 (0000.15) | >>> Searching UVMAP node inside surface Valenki 00:00:00 (0000.15) | >>> This material doesn't have a valid UVMAP node 00:00:00 (0000.15) | >>> Searching UVMAP node inside surface Varezhki 00:00:00 (0000.15) | >>> This material doesn't have a valid UVMAP node 00:00:00 (0000.15) | >>> Processing polygon data 00:00:00 (0000.18) | [profile] Function "LWOctane_addPolData" over "" execution time: 0.023 seconds 00:00:00 (0000.18) | >>> Processing vertex attributes list 00:00:00 (0000.18) | [profile] Function "LWOctane_addVertexAttributes" over "" execution time: 0.001 seconds 00:00:00 (0000.18) | >>> Adding the mesh OpenSubD parameters 00:00:00 (0000.18) | Subdivision level: 2 00:00:00 (0000.18) | Subdivision sharpness: 0.000000 00:00:00 (0000.18) | Boundary interpolation: 2 00:00:00 (0000.18) | Subdivision scheme: 0 00:00:00 (0000.18) | Use Adaptive subdivision: 0 00:00:00 (0000.18) | >>> Mesh added, evaluating it 00:00:00 (0000.18) | [profile] Function "LWOctane_addMesh" over "" execution time: 0.031 seconds 00:00:00 (0000.18) | >>> Refresh preview window 00:00:00 (0000.18) | >>> Draw preview window progress bar 00:00:00 (0000.18) | >>> Refresh preview window done 00:00:00 (0000.18) | +++ Processing object materials 00:00:00 (0000.18) | Object properties plugin found, return disable override flag 00:00:00 (0000.18) | > Filtering 16 materials in 6257 polygons 00:00:00 (0000.18) | > Filtering 16 materials in 0 hairs 00:00:00 (0000.18) | Used materials in this object: 16 00:00:00 (0000.18) | +++ Processing material Beard 00:00:00 (0000.18) | +++ This material has a valid Octane nodal shading tree, processing it ... 00:00:00 (0000.18) | --> Procesing a new DiffuseMaterial node 00:00:00 (0000.18) | +++ Processing material Belt 00:00:00 (0000.18) | +++ This material has a valid Octane nodal shading tree, processing it ... 00:00:00 (0000.18) | --> Procesing a new GlossyMaterial node 00:00:00 (0000.18) | +++ Processing material Coat 00:00:00 (0000.18) | +++ This material has a valid Octane nodal shading tree, processing it ... 00:00:00 (0000.18) | --> Procesing a new GlossyMaterial node 00:00:00 (0000.18) | +++ Processing material Coat_fur 00:00:00 (0000.18) | +++ This material has a valid Octane nodal shading tree, processing it ... 00:00:00 (0000.18) | --> Procesing a new GlossyMaterial node 00:00:00 (0000.18) | +++ Processing material Coat_top 00:00:00 (0000.18) | +++ This material has a valid Octane nodal shading tree, processing it ... 00:00:00 (0000.18) | --> Procesing a new GlossyMaterial node 00:00:00 (0000.18) | +++ Processing material Eyes 00:00:00 (0000.18) | +++ This material has a valid Octane nodal shading tree, processing it ... 00:00:00 (0000.18) | --> Procesing a new MixMaterial node 00:00:00 (0000.18) | --> Procesing a new DiffuseMaterial node 00:00:00 (0000.18) | --> Procesing a new ImageTexture node 00:00:00 (0000.18) | --> Filename: G:\Freelance\Ded Moroz\Images\HumanEye_01IceBlueC_w.jpg 00:00:00 (0000.20) | --> Procesing a new ColorCorrectTexture node 00:00:00 (0000.20) | --> Using a existing ImageTexture node 00:00:00 (0000.20) | --> Procesing a new GlossyMaterial node 00:00:00 (0000.20) | --> Using a existing ColorCorrectTexture node 00:00:00 (0000.20) | +++ Processing material Head 00:00:00 (0000.20) | +++ This material has a valid Octane nodal shading tree, processing it ... 00:00:00 (0000.20) | --> Procesing a new GlossyMaterial node 00:00:00 (0000.20) | +++ Processing material Santa_Claus:Santa_Claus_10 00:00:00 (0000.20) | +++ This material has a valid Octane nodal shading tree, processing it ... 00:00:00 (0000.20) | --> Procesing a new GlossyMaterial node 00:00:00 (0000.20) | +++ Processing material Santa_Claus:Santa_Claus_11 00:00:00 (0000.20) | +++ This material has a valid Octane nodal shading tree, processing it ... 00:00:00 (0000.20) | --> Procesing a new GlossyMaterial node 00:00:00 (0000.20) | +++ Processing material Santa_Claus:Santa_Claus_2 00:00:00 (0000.20) | +++ This material has a valid Octane nodal shading tree, processing it ... 00:00:00 (0000.20) | --> Procesing a new DiffuseMaterial node 00:00:00 (0000.20) | +++ Processing material Santa_Claus:Santa_Claus_6 00:00:00 (0000.20) | +++ This material has a valid Octane nodal shading tree, processing it ... 00:00:00 (0000.20) | --> Procesing a new GlossyMaterial node 00:00:00 (0000.20) | +++ Processing material Santa_Claus:Santa_Claus_7 00:00:00 (0000.20) | +++ This material has a valid Octane nodal shading tree, processing it ... 00:00:00 (0000.20) | --> Procesing a new GlossyMaterial node 00:00:00 (0000.20) | +++ Processing material Santa_Claus:Santa_Claus_8 00:00:00 (0000.20) | +++ This material has a valid Octane nodal shading tree, processing it ... 00:00:00 (0000.20) | --> Procesing a new GlossyMaterial node 00:00:00 (0000.20) | +++ Processing material Santa_Claus:Santa_Claus_9 00:00:00 (0000.20) | +++ This material has a valid Octane nodal shading tree, processing it ... 00:00:00 (0000.20) | --> Procesing a new GlossyMaterial node 00:00:00 (0000.20) | +++ Processing material Valenki 00:00:00 (0000.20) | +++ This material has a valid Octane nodal shading tree, processing it ... 00:00:00 (0000.20) | --> Procesing a new DiffuseMaterial node 00:00:00 (0000.20) | +++ Processing material Varezhki 00:00:00 (0000.20) | +++ This material has a valid Octane nodal shading tree, processing it ... 00:00:00 (0000.20) | --> Procesing a new GlossyMaterial node 00:00:00 (0000.20) | +++ End of materials processing 00:00:00 (0000.20) | Searching FiberFX hair materials 00:00:00 (0000.20) | +++ Processing object layer maps functions 00:00:00 (0000.20) | --> Get object global dissolve value: 0.000000, state 0 00:00:00 (0000.20) | [profile] Function "LWOctane_addGeom" over "Ded_moroz_001:Main Layer" execution time: 0.053 seconds 00:00:00 (0000.20) | 00:00:00 (0000.20) | Processing object: 10000003, name: Ground 00:00:00 (0000.20) | Searching if FiberFX is available in this object 00:00:00 (0000.20) | >>> Processing the number of valid polygons 00:00:00 (0000.20) | >>> This object has 625 of 625 valid polygons 00:00:00 (0000.20) | >>> Refresh preview window 00:00:00 (0000.20) | >>> Draw preview window progress bar 00:00:00 (0000.20) | >>> Refresh preview window done 00:00:00 (0000.20) | >>> Adding a new mesh to Octane 00:00:00 (0000.20) | >>> Mesh points: 676, valid polygons: 625 00:00:00 (0000.20) | ----> Searching UV maps in this object 00:00:00 (0000.20) | ----> No UV maps found in this object 00:00:00 (0000.20) | [profile] Function "LWOctane_getVMap" over "" execution time: 0.000 seconds 00:00:00 (0000.20) | >>> Processing vertex per poly array 00:00:00 (0000.20) | [profile] Function "LWOctane_getVertsPerPoly" over "" execution time: 0.000 seconds 00:00:00 (0000.20) | >>> Processing vertex list 00:00:00 (0000.20) | [profile] Function "LWOctane_addVertex" over "" execution time: 0.000 seconds 00:00:00 (0000.20) | +++ Searching object materials 00:00:00 (0000.20) | +++ Found 1 materials inside Ground 00:00:00 (0000.20) | +++ Material 0 ID: Default 00:00:00 (0000.20) | +++ Searching in the object materials for UVMAP nodes 00:00:00 (0000.20) | >>> Searching UVMAP node inside surface Default 00:00:00 (0000.20) | >>> This material doesn't have a valid UVMAP node 00:00:00 (0000.20) | >>> Processing polygon data 00:00:00 (0000.20) | [profile] Function "LWOctane_addPolData" over "" execution time: 0.001 seconds 00:00:00 (0000.20) | >>> Processing vertex attributes list 00:00:00 (0000.20) | [profile] Function "LWOctane_addVertexAttributes" over "" execution time: 0.000 seconds 00:00:00 (0000.20) | >>> Mesh added, evaluating it 00:00:00 (0000.20) | [profile] Function "LWOctane_addMesh" over "" execution time: 0.001 seconds 00:00:00 (0000.20) | >>> Refresh preview window 00:00:00 (0000.20) | >>> Draw preview window progress bar 00:00:00 (0000.20) | >>> Refresh preview window done 00:00:00 (0000.20) | +++ Processing object materials 00:00:00 (0000.20) | > Filtering 1 materials in 625 polygons 00:00:00 (0000.20) | > Filtering 1 materials in 0 hairs 00:00:00 (0000.20) | Used materials in this object: 1 00:00:00 (0000.20) | +++ Processing material Default 00:00:00 (0000.20) | +++ This material has a valid Octane nodal shading tree, processing it ... 00:00:00 (0000.20) | --> Procesing a new GlossyMaterial node 00:00:00 (0000.20) | +++ End of materials processing 00:00:00 (0000.20) | Searching FiberFX hair materials 00:00:00 (0000.20) | +++ Processing object layer maps functions 00:00:00 (0000.20) | --> Get object global dissolve value: 0.000000, state 0 00:00:00 (0000.20) | [profile] Function "LWOctane_addGeom" over "Ground" execution time: 0.003 seconds 00:00:00 (0000.20) | 00:00:00 (0000.20) | Processing object: 10000001, name: Ded_moroz_001 00:00:00 (0000.20) | Searching if FiberFX is available in this object 00:00:00 (0000.20) | Object is a Null, without FFX hair data. Bypassing it. 00:00:00 (0000.20) | [profile] Function "LWOctane_addGeom" over "Ded_moroz_001" execution time: 0.001 seconds 00:00:00 (0000.20) | >>> Refresh preview window 00:00:00 (0000.20) | >>> Draw preview window progress bar 00:00:00 (0000.20) | >>> Refresh preview window done 00:00:00 (0000.20) | 00:00:00 (0000.20) | Processing objects list from LW scene. SECOND PASS 00:00:00 (0000.20) | Second pass check for object 10000000 00:00:00 (0000.20) | Object Ded_moroz_001:Main Layer has the native Lightwave instancer plugin with 0 instances 00:00:00 (0000.20) | Processing instances ... 00:00:00 (0000.20) | Second pass check for object 10000000 ok. 00:00:00 (0000.20) | Second pass check for object 10000003 00:00:00 (0000.20) | Object Ground has the native Lightwave instancer plugin with 0 instances 00:00:00 (0000.20) | Processing instances ... 00:00:00 (0000.20) | Second pass check for object 10000003 ok. 00:00:00 (0000.20) | Second pass check for object 10000001 00:00:00 (0000.20) | Object Ded_moroz_001 has the native Lightwave instancer plugin with 0 instances 00:00:00 (0000.20) | Processing instances ... 00:00:00 (0000.20) | Second pass check for object 10000001 ok. 00:00:00 (0000.20) | Setting the objects geometry group to the scene root geometry group, index 0 00:00:00 (0000.20) | Setting the instances geometry group to the scene root geometry group, index 2 00:00:00 (0000.20) | -> Releasing scene UV Maps list 00:00:00 (0000.20) | Objects processing end ok 00:00:00 (0000.20) | 00:00:00 (0000.20) | 00:00:00 (0000.20) | Processing Octane lights from LW scene. 00:00:00 (0000.20) | >>> Refresh preview window 00:00:00 (0000.20) | >>> Draw preview window progress bar 00:00:00 (0000.21) | >>> Refresh preview window done 00:00:00 (0000.21) | Number of LW lighs in scene: 1 00:00:00 (0000.21) | 00:00:00 (0000.21) | Reading light info - name: Light 00:00:00 (0000.21) | Light Light, type distant, not supported by Octante currently 00:00:00 (0000.21) | 00:00:00 (0000.21) | Setting the lights geometry group to the scene root geometry group, index 1 00:00:00 (0000.21) | Lights processing end ok 00:00:00 (0000.21) | 00:00:00 (0000.21) | Init the renderTarget 00:00:00 (0000.21) | Setting the root geometryGroup to the renderTarget 00:00:00 (0000.21) | Setting the default render target nodes 00:00:00 (0000.21) | Evaluating render target nodal editor 00:00:00 (0000.21) | + Processing the ThinLensCamera node 00:00:00 (0000.21) | + Processing the TextureEnvironment node 00:00:00 (0000.21) | + Processing the Imager node 00:00:00 (0000.21) | + Processing the PathTracing node 00:00:00 (0000.21) * OCTANE API MSG: Tried to access pin via an invalid ID P_AI_LIGHT_STRENGTH (385) 00:00:00 (0000.21) * OCTANE API MSG: Tried to access null node pin 00:00:00 (0000.21) * OCTANE API MSG: Can't write float to static pin 'unknown' (P_UNKNOWN, type PT_UNKNOWN) of node '' (NT_UNKNOWN, 000007FED3019090) 00:00:00 (0000.21) | + Processing the PortProcessing node 00:00:00 (0000.21) | + Processing the RenderPasses node 00:00:00 (0000.21) * OCTANE API MSG: Tried to access pin via an invalid ID P_RENDER_PASS_LAYER_COLOR_SHADOWS (164) 00:00:00 (0000.21) * OCTANE API MSG: Tried to access null node pin 00:00:00 (0000.21) * OCTANE API MSG: Can't write bool to static pin 'unknown' (P_UNKNOWN, type PT_UNKNOWN) of node '' (NT_UNKNOWN, 000007FED3019090) 00:00:00 (0000.21) | Render target nodal editor evaluated succesfully 00:00:00 (0000.21) | Get or update scene camera 00:00:00 (0000.21) | Camera type is THINLENS_CAMERA 00:00:00 (0000.21) | Removing the old camera motion blur data 00:00:00 (0000.21) | Removing the old objects motion blur data 00:00:00 (0000.21) | Removing the old objects deformations motion blur data 00:00:00 (0000.21) | Removing the old lights motion blur data 00:00:00 (0000.21) | 00:00:00 (0000.21) | Scene loaded 00:00:00 (0000.21) | Render resolution: 1920 x 1080 00:00:00 (0000.21) | 00:00:00 (0000.21) | ()()() RENDERING ... 00:00:00 (0000.21) | ... set image callback ... 00:00:00 (0000.21) | 00:00:00 (0000.21) | Render scene, set renderTarget and update 00:00:00 (0000.21) | >>> Refresh preview window 00:00:00 (0000.21) | >>> Draw preview window progress bar 00:00:00 (0000.21) | >>> Refresh preview window done 00:00:00 (0000.21) | ... first update 00:00:00 (0000.21) | ... setRenderPriority 00:00:00 (0000.21) | ... RenderPriority set to 0 00:00:00 (0000.21) | ... set Motion Blur parameters 00:00:00 (0000.21) | ... setRenderTargetNode 00:00:01 (0001.02) | ... second update 00:00:01 (0001.02) | ... isRenderingPaused 00:00:01 (0001.02) | >>> Refresh preview window 00:00:01 (0001.02) | >>> Draw preview window progress bar 00:00:01 (0001.02) | >>> Refresh preview window done 00:00:01 (0001.02) | Render setup Ok. 00:00:01 (0001.02) | 00:00:01 (0001.02) | [profile] Function "LWOctane_renderScene" over "" execution time: 0.811 seconds 00:00:01 (0001.02) | <> Mem Used/Free/Total: 1114 / 6101 / 8192 00:00:01 (0001.02) | <> Triangles/DisplaceTris/Hairs/Objects/Voxels rendered: 199666 / 0 / 0 / 2 / 0 00:00:01 (0001.02) | <> Textures RGB32/RGB64/GREY8/GREY16 used: 1 / 0 / 0 / 0 00:00:01 (0001.02) | 00:00:01 (0001.02) | ... Init rendering ... 00:00:04 (0004.05) | >>> processing image callback 00:00:04 (0004.05) | Reading preview image 00:00:04 (0004.05) | ... Get sampling information 00:00:04 (0004.05) | ... Statistics: 1 of 300 samples, 0 sec, 4.00 Ms/sec 00:00:04 (0004.05) | ... Get buffers resolution 00:00:04 (0004.05) | ... Resolution: 1920 1080 00:00:04 (0004.05) | ... Check compositing 00:00:04 (0004.05) | ... Compositing 0 00:00:04 (0004.05) | ... Reading frame buffer 00:00:04 (0004.17) | Reading preview image successfully 00:00:04 (0004.17) | [profile] Function "GetPreviewImage" over "" execution time: 0.123 seconds 00:00:04 (0004.17) | >>> Refresh preview window 00:00:04 (0004.17) | >>> Refresh preview window done 00:00:04 (0004.19) | >>> Draw preview window information 00:00:04 (0004.19) | >>> Draw preview window status 00:00:04 (0004.19) | >>> Draw preview window progress bar 00:00:04 (0004.19) | >>> Draw preview image 00:00:04 (0004.19) | >>> Draw preview image finished. Releaseing mutex 00:00:04 (0004.33) | >>> processing image callback 00:00:04 (0004.33) | Reading preview image 00:00:04 (0004.33) | ... Get sampling information 00:00:04 (0004.33) | ... Statistics: 8 of 300 samples, 0 sec, 8.97 Ms/sec 00:00:04 (0004.33) | ... Get buffers resolution 00:00:04 (0004.33) | ... Resolution: 1920 1080 00:00:04 (0004.33) | ... Check compositing 00:00:04 (0004.33) | ... Compositing 0 00:00:04 (0004.33) | ... Reading frame buffer 00:00:04 (0004.43) | Reading preview image successfully 00:00:04 (0004.43) | [profile] Function "GetPreviewImage" over "" execution time: 0.095 seconds 00:00:04 (0004.43) | >>> Refresh preview window 00:00:04 (0004.43) | >>> Refresh preview window done 00:00:04 (0004.44) | >>> Draw preview window information 00:00:04 (0004.44) | >>> Draw preview window status 00:00:04 (0004.44) | >>> Draw preview window progress bar 00:00:04 (0004.44) | >>> Draw preview image 00:00:04 (0004.44) | >>> Draw preview image finished. Releaseing mutex 00:00:04 (0004.54) | >>> processing image callback 00:00:04 (0004.54) | Reading preview image 00:00:04 (0004.54) | ... Get sampling information 00:00:04 (0004.54) | ... Statistics: 16 of 300 samples, 0 sec, 11.98 Ms/sec 00:00:04 (0004.54) | ... Get buffers resolution 00:00:04 (0004.54) | ... Resolution: 1920 1080 00:00:04 (0004.54) | ... Check compositing 00:00:04 (0004.54) | ... Compositing 0 00:00:04 (0004.54) | ... Reading frame buffer 00:00:04 (0004.64) | Reading preview image successfully 00:00:04 (0004.64) | [profile] Function "GetPreviewImage" over "" execution time: 0.096 seconds 00:00:04 (0004.64) | >>> Refresh preview window 00:00:04 (0004.64) | >>> Refresh preview window done 00:00:04 (0004.64) | >>> Draw preview window information 00:00:04 (0004.64) | >>> Draw preview window status 00:00:04 (0004.65) | >>> Draw preview window progress bar 00:00:04 (0004.65) | >>> Draw preview image 00:00:04 (0004.65) | >>> Draw preview image finished. Releaseing mutex 00:00:04 (0004.84) | >>> processing image callback 00:00:04 (0004.84) | Reading preview image 00:00:04 (0004.84) | ... Get sampling information 00:00:04 (0004.84) | ... Statistics: 64 of 300 samples, 1 sec, 32.80 Ms/sec 00:00:04 (0004.84) | ... Get buffers resolution 00:00:04 (0004.84) | ... Resolution: 1920 1080 00:00:04 (0004.84) | ... Check compositing 00:00:04 (0004.84) | ... Compositing 0 00:00:04 (0004.84) | ... Reading frame buffer 00:00:04 (0004.93) | Reading preview image successfully 00:00:04 (0004.93) | [profile] Function "GetPreviewImage" over "" execution time: 0.097 seconds 00:00:04 (0004.93) | >>> Refresh preview window 00:00:04 (0004.93) | >>> Refresh preview window done 00:00:04 (0004.95) | >>> Draw preview window information 00:00:04 (0004.95) | >>> Draw preview window status 00:00:04 (0004.95) | >>> Draw preview window progress bar 00:00:04 (0004.96) | >>> Draw preview image 00:00:04 (0004.96) | >>> Draw preview image finished. Releaseing mutex 00:00:04 (0004.99) | >>> processing image callback 00:00:04 (0004.99) | Reading preview image 00:00:04 (0004.99) | ... Get sampling information 00:00:04 (0004.99) | ... Statistics: 96 of 300 samples, 1 sec, 43.54 Ms/sec 00:00:04 (0004.99) | ... Get buffers resolution 00:00:04 (0004.99) | ... Resolution: 1920 1080 00:00:04 (0004.99) | ... Check compositing 00:00:04 (0004.99) | ... Compositing 0 00:00:04 (0004.99) | ... Reading frame buffer 00:00:05 (0005.11) | Reading preview image successfully 00:00:05 (0005.11) | [profile] Function "GetPreviewImage" over "" execution time: 0.129 seconds 00:00:05 (0005.11) | >>> Refresh preview window 00:00:05 (0005.11) | >>> Refresh preview window done 00:00:05 (0005.12) | >>> Draw preview window information 00:00:05 (0005.12) | >>> Draw preview window status 00:00:05 (0005.13) | >>> Draw preview window progress bar 00:00:05 (0005.13) | >>> Draw preview image 00:00:05 (0005.13) | >>> Draw preview image finished. Releaseing mutex 00:00:05 (0005.17) | >>> processing image callback 00:00:05 (0005.17) | Reading preview image 00:00:05 (0005.17) | ... Get sampling information 00:00:05 (0005.17) | ... Statistics: 128 of 300 samples, 1 sec, 49.96 Ms/sec 00:00:05 (0005.17) | ... Get buffers resolution 00:00:05 (0005.17) | ... Resolution: 1920 1080 00:00:05 (0005.17) | ... Check compositing 00:00:05 (0005.17) | ... Compositing 0 00:00:05 (0005.17) | ... Reading frame buffer 00:00:05 (0005.30) | Reading preview image successfully 00:00:05 (0005.30) | [profile] Function "GetPreviewImage" over "" execution time: 0.128 seconds 00:00:05 (0005.30) | >>> Refresh preview window 00:00:05 (0005.30) | >>> Refresh preview window done 00:00:05 (0005.31) | >>> Draw preview window information 00:00:05 (0005.31) | >>> Draw preview window status 00:00:05 (0005.32) | >>> Draw preview window progress bar 00:00:05 (0005.32) | >>> Draw preview image 00:00:05 (0005.32) | >>> Draw preview image finished. Releaseing mutex 00:00:05 (0005.37) | >>> processing image callback 00:00:05 (0005.37) | Reading preview image 00:00:05 (0005.37) | ... Get sampling information 00:00:05 (0005.37) | ... Statistics: 160 of 300 samples, 1 sec, 54.00 Ms/sec 00:00:05 (0005.37) | ... Get buffers resolution 00:00:05 (0005.37) | ... Resolution: 1920 1080 00:00:05 (0005.37) | ... Check compositing 00:00:05 (0005.37) | ... Compositing 0 00:00:05 (0005.37) | ... Reading frame buffer 00:00:05 (0005.49) | Reading preview image successfully 00:00:05 (0005.49) | [profile] Function "GetPreviewImage" over "" execution time: 0.122 seconds 00:00:05 (0005.49) | >>> Refresh preview window 00:00:05 (0005.49) | >>> Refresh preview window done 00:00:05 (0005.50) | >>> Draw preview window information 00:00:05 (0005.50) | >>> Draw preview window status 00:00:05 (0005.50) | >>> Draw preview window progress bar 00:00:05 (0005.51) | >>> Draw preview image 00:00:05 (0005.51) | >>> Draw preview image finished. Releaseing mutex 00:00:05 (0005.67) | >>> processing image callback 00:00:05 (0005.67) | Reading preview image 00:00:05 (0005.67) | ... Get sampling information 00:00:05 (0005.67) | ... Statistics: 224 of 300 samples, 1 sec, 63.11 Ms/sec 00:00:05 (0005.67) | ... Get buffers resolution 00:00:05 (0005.67) | ... Resolution: 1920 1080 00:00:05 (0005.67) | ... Check compositing 00:00:05 (0005.67) | ... Compositing 0 00:00:05 (0005.67) | ... Reading frame buffer 00:00:05 (0005.80) | Reading preview image successfully 00:00:05 (0005.80) | [profile] Function "GetPreviewImage" over "" execution time: 0.129 seconds 00:00:05 (0005.80) | >>> Refresh preview window 00:00:05 (0005.80) | >>> Refresh preview window done 00:00:05 (0005.81) | >>> Draw preview window information 00:00:05 (0005.81) | >>> Draw preview window status 00:00:05 (0005.81) | >>> Draw preview window progress bar 00:00:05 (0005.82) | >>> Draw preview image 00:00:05 (0005.82) | >>> Draw preview image finished. Releaseing mutex 00:00:05 (0005.90) | >>> processing image callback 00:00:05 (0005.90) | Reading preview image 00:00:05 (0005.90) | ... Get sampling information 00:00:05 (0005.90) | ... Statistics: 256 of 300 samples, 2 sec, 0.00 Ms/sec 00:00:05 (0005.90) | ... Get buffers resolution 00:00:05 (0005.90) | ... Resolution: 1920 1080 00:00:05 (0005.90) | ... Check compositing 00:00:05 (0005.90) | ... Compositing 0 00:00:05 (0005.90) | ... Reading frame buffer 00:00:06 (0006.03) | Reading preview image successfully 00:00:06 (0006.03) | [profile] Function "GetPreviewImage" over "" execution time: 0.136 seconds 00:00:06 (0006.03) | >>> Refresh preview window 00:00:06 (0006.03) | >>> Refresh preview window done 00:00:06 (0006.04) | >>> Draw preview window information 00:00:06 (0006.04) | >>> Draw preview window status 00:00:06 (0006.04) | >>> Draw preview window progress bar 00:00:06 (0006.04) | >>> Draw preview image 00:00:06 (0006.04) | >>> Draw preview image finished. Releaseing mutex 00:00:10 (0010.87) * OCTANE API MSG: Up-sampling error: CUDA_ERROR_ILLEGAL_ADDRESS: an illegal memory access was encountered 00:00:10 (0010.87) * OCTANE API MSG: CUDA error 700 on device 0: an illegal memory access was encountered 00:00:10 (0010.87) * OCTANE API MSG: -> failed to copy pitched memory from device 00:00:10 (0010.87) | 00:00:10 (0010.87) | ++++++++++++++++++++++ 00:00:10 (0010.87) | +++ RENDER FAILURE +++ processing the failure callback 00:00:10 (0010.87) | ++++++++++++++++++++++ 00:00:10 (0010.87) | 00:00:10 (0010.87) | 00:00:10 (0010.87) | Aborting rendering detected 00:00:10 (0010.87) | >>> Refresh preview window 00:00:10 (0010.87) | >>> Draw preview window information 00:00:10 (0010.89) | >>> Draw preview window status 00:00:10 (0010.89) | >>> Draw preview window progress bar 00:00:10 (0010.90) | >>> Draw preview image 00:00:10 (0010.90) | >>> Draw preview image finished. Releaseing mutex 00:00:10 (0010.90) | >>> Draw preview window information 00:00:10 (0010.90) | >>> Refresh preview window done 00:00:10 (0010.90) | >>> Draw preview window status 00:00:10 (0010.90) | >>> Draw preview window progress bar 00:00:10 (0010.90) | >>> Draw preview image 00:00:10 (0010.90) | >>> Draw preview image finished. Releaseing mutex 00:00:10 (0010.90) | ... Finish Rendering ... 00:00:10 (0010.90) | 00:00:10 (0010.90) | ... reset image callback ... 00:00:10 (0010.90) | ... wait for the getPreviewImage function ... 00:00:10 (0010.95) * OCTANE API MSG: CUDA error 700 on device 1: an illegal memory access was encountered 00:00:10 (0010.95) * OCTANE API MSG: -> failed to wait for event 00:00:10 (0010.95) * OCTANE API MSG: CUDA error 700 on device 1: an illegal memory access was encountered 00:00:10 (0010.95) * OCTANE API MSG: -> failed to copy memory to device. 00:00:10 (0010.95) * OCTANE API MSG: CUDA error 700 on device 1: an illegal memory access was encountered 00:00:10 (0010.95) * OCTANE API MSG: -> failed to copy memory to device. 00:00:10 (0010.95) * OCTANE API MSG: CUDA error 700 on device 1: an illegal memory access was encountered 00:00:10 (0010.95) * OCTANE API MSG: -> failed to copy memory to device. 00:00:11 (0011.00) | Close and free scene, free buffer: 1, reset scene: 1 00:00:11 (0011.00) | ... freeBuffers 00:00:11 (0011.01) | ... setRenderTargetNode(NULL) 00:00:11 (0011.03) | ... update() 00:00:11 (0011.03) | ... getRootNodeGraph()->clear() 00:00:11 (0011.03) | >>> Refresh preview window 00:00:11 (0011.04) | >>> Draw preview window progress bar 00:00:11 (0011.04) | >>> Refresh preview window done 00:00:11 (0011.04) | Scene closed 00:00:11 (0011.04) | 00:00:11 (0011.04) | Close preview window 00:00:11 (0011.04) | 00:00:11 (0011.04) | Octane Render for Lightwave, end of log system