[2021-01-29 19:27:12][1] Register OctaneLive
[2021-01-29 19:27:12][0] Loaded Octane DLL:Octane X Prime PR7 (Internal Build)  version:10000302  SDK:PR7
[2021-01-29 19:27:12][0] Octane X for Cinema 4D PR7  built for:230   C4D vers:23110
[2021-01-29 19:27:12][0] C4D:23110  comp:[Pandeli’s iMac]  OS:[OS X 64 BIT] macOS: Version 11.0.1 (Build 20B29)  versType:10
[2021-01-29 19:27:12][0] CPU:[GenuineIntel, stepping 9, model 14, instruction family 6]  speed:3.4 GHz  numOfCpu:4Ht
[2021-01-29 19:27:12][0] Plugins:[houdiniconfig addons advanced_render alembic archigrass bitmapfilter bpexchange browser bugslife_client c4d_viewport_render c4doctane-R23 ca ca2 cadexchange clothilde collada14 collada15 colorchoosergui compositing deltamush deployment dwg dwgobjects dynamics exchanges expressiontag fbx gltf goz hair i_skp interop io_obj metrics mkmodeler mocca model mograph motioncam motiontracker nbo nbp newman nodeeditor objects onlineupdater projectassetinspector python relaxuv sculpt sculptbrushes shader sketch sky sla spacemouse substance teamrender thinking_particles tpoperators usd uvviewport volumes xpressocore xtensions ]
[2021-01-29 19:27:12][1] LoadOslScripts()
[2021-01-29 19:27:12][0] Loaded 89 osl scripts from dir:/Applications/Maxon Cinema 4D R23/plugins/c4octane/res/osl_scripts
[2021-01-29 19:27:12][1] LoadCustomLuts()
[2021-01-29 19:27:13][1] <markMaterials>
[2021-01-29 19:27:13][1] <markMaterials>
[2021-01-29 19:27:15][1] <markMaterials>
[2021-01-29 19:27:15][1] <markMaterials>
[2021-01-29 19:27:47][1] initOctaneLive()
[2021-01-29 19:27:47][1] Init OctaneLive...[2021-01-29 19:27:49][1] Plugin initialized.[2021-01-29 19:27:49][1] Plugin activation...[2021-01-29 19:27:54][1] Plugin activation OK.[2021-01-29 19:27:54][1] Activation time=6.68 sec.
[2021-01-29 19:27:54][0] readDeviceSettings   E:0 P: T:0 D:
[2021-01-29 19:27:54][0] VRAM used/free/max:0Kb/4Gb/4Gb  Out-of-core used:0Kb  RAM used:22.139Gb total:32Gb  OpenGL free/total:0/0
[2021-01-29 19:27:54][1] Device:0  [AMD Radeon Pro 560]<Dis>[][0]  Memory used/free/total:0Kb/4Gb/4Gb  outOfCoreMem:0Kb  p2pBytesUsed:0  runtimeDataSize:0Kb
[2021-01-29 19:27:54][1] <markMaterials>
 [OK]
[2021-01-29 19:27:55][0] Opengl preview:[OctGlossy1] size:256*256 0x00007F89D52B18C0 baseMat:0x00007F89D52B18C0 curLink:0x0000000000000000
[2021-01-29 19:27:55][0] restoreDeviceStates status:2
[2021-01-29 19:27:55][0] setDevicesActivity  E:0 P: T:0 D:
[2021-01-29 19:27:55][0] save
[2021-01-29 19:27:55][1]   convert mat:[OctGlossy1]  tip:1029501
[2021-01-29 19:27:55][1] generate material:OctGlossy1[2021-01-29 19:27:55][4]     convertOctaneNodes owner: pinID:0 type:Gradient
[2021-01-29 19:27:55][4]   convert done in:5.158ms. 
[2021-01-29 19:27:55][4]   MakePreview:OctGlossy1[2021-01-29 19:27:55][0] AllDevicesOff
[2021-01-29 19:27:55][0] restoreDeviceStates status:2
[2021-01-29 19:27:55][0] setDevicesActivity  E:0 P: T:0 D:
[2021-01-29 19:27:55][0] save
 size=256*256 done in:3236.928ms.  [res:1]
[2021-01-29 19:27:58][1] Opengl preview:OctGlossy1  size:256*256  tm:3242.516 ms.[2021-01-29 19:27:58][0] Opengl preview:[OctGlossy1] size:256*256 0x00007F89D52B18C0 baseMat:0x00007F89D52B18C0 curLink:0x0000000000000000
[2021-01-29 19:27:58][1]   convert mat:[OctGlossy1]  tip:1029501
[2021-01-29 19:27:58][1] generate material:OctGlossy1[2021-01-29 19:27:58][4]     convertOctaneNodes owner: pinID:0 type:Gradient
[2021-01-29 19:27:58][4]   convert done in:4.389ms. 
[2021-01-29 19:27:58][4]   MakePreview:OctGlossy1[2021-01-29 19:27:58][0] AllDevicesOff
[2021-01-29 19:27:58][0] restoreDeviceStates status:2
[2021-01-29 19:27:58][0] setDevicesActivity  E:0 P: T:0 D:
[2021-01-29 19:27:58][0] save
 size=256*256 done in:3225.814ms.  [res:1]
[2021-01-29 19:28:01][1] Opengl preview:OctGlossy1  size:256*256  tm:3230.579 ms.[2021-01-29 19:28:01][1] <markMaterials>
[2021-01-29 19:28:18][1] checkNewVersions()
 [OK]
[2021-01-29 19:28:18][0] ------- VP START:0x00007F89E58BADC0 VPS:0x000070000235AAC8 -----------
[2021-01-29 19:28:18][1] initVpRender(....)
[2021-01-29 19:28:18][1] setInteractive(0)[OK] [2021-01-29 19:28:18][1] initOctaneLive()
[2021-01-29 19:28:18][0] **** RENDER FINISHED ****  stat=2
[2021-01-29 19:28:18][1] VpRenderFinished()
[2021-01-29 19:28:18][1] Render finished...[2021-01-29 19:28:18][1] ResetCaches [OK]
 [OK]
[2021-01-29 19:28:18][1] ResetAndInit 0
[2021-01-29 19:28:18][1] RESET PROJECT[2021-01-29 19:28:18][1] Init defaults[2021-01-29 19:28:18][1] ResetCaches [OK]
[2021-01-29 19:28:18][1] ResetAndInit [OK]

[2021-01-29 19:28:18][1] setResFromRndSettings 0x00007F89F005FBC0 [OK]
[2021-01-29 19:28:19][1] ApiUpdate Wait:0 Caller:needApiUpdate tm:39.725ms.  [OK]
 [OK]
[2021-01-29 19:28:24][0] ------- VP START:0x00007F89E58BADC0 VPS:0x000070000235AAC8 -----------
[2021-01-29 19:28:24][1] initVpRender(....)
[2021-01-29 19:28:24][1] setInteractive(0)[OK] [2021-01-29 19:28:24][1] initOctaneLive()
[2021-01-29 19:28:24][1] Starting render frame:184 [OK]
[2021-01-29 19:28:24][1] startVpRender(.....)
[2021-01-29 19:28:24][1] setInteractive(0)[OK] [2021-01-29 19:28:24][0]  
[2021-01-29 19:28:24][0] FRAME:184 fps:24
[2021-01-29 19:28:24][0] enableAllRenderDevices[2021-01-29 19:28:24][0] setDevicesActivity  E:0 P: T: D:0
[2021-01-29 19:28:24][0] FumeFx library initialisation error!
[2021-01-29 19:28:24][1] initOctaneLive()
[2021-01-29 19:28:24][1] Sending scene data.....[2021-01-29 19:28:24][0] --------------------------- EXPORT LOG ---------------------------
[2021-01-29 19:28:24][1] ResetAndInit 1
[2021-01-29 19:28:24][16]   LightCollector::clear() -> cnt=0 
[2021-01-29 19:28:24][1] RESET PROJECT[2021-01-29 19:28:24][1] Init defaults[2021-01-29 19:28:24][1] createOctaneDefaults [2021-01-29 19:28:24][1] ResetCaches[2021-01-29 19:28:24][16]   LightCollector::clear() -> cnt=0 
 [OK]
[2021-01-29 19:28:24][1] ResetAndInit [OK]

 [OK]
 [OK]
[2021-01-29 19:28:24][1] create InfoChannelKernel
[2021-01-29 19:28:24][1] use active CameraImager
[2021-01-29 19:28:24][1] use active InfoChannelKernel
[2021-01-29 19:28:24][1] applyICParams:0x00007F89EFDADCE0
[2021-01-29 19:28:24][1] ApplyCImager enDenoise:0
[2021-01-29 19:28:24][1] Creating materials.....[2021-01-29 19:28:24][1] ******* createMaterials *******
[2021-01-29 19:28:24][1] Create Materials....[2021-01-29 19:28:24][0] Multi-threaded material conversion, thread count=2
[2021-01-29 19:28:24][1]   convert mat:[OctGlossy1]  tip:1029501
[2021-01-29 19:28:24][1] generate material:OctGlossy1[2021-01-29 19:28:24][4]     convertOctaneNodes owner: pinID:0 type:Gradient
[2021-01-29 19:28:24][4]   convert done in:0.646ms. 
[2021-01-29 19:28:24][0] Export materials time= 2.581 ms
[2021-01-29 19:28:24][1] Collecting objects.....[2021-01-29 19:28:24][0] Collect objects time= 0.164 ms
[2021-01-29 19:28:24][1] Creating meshes.....[2021-01-29 19:28:24][1] SINGLE MESH COLLECTING cnt:1 tricnt:1672704 vtxCnt:1672706[2021-01-29 19:28:25][0]   >> MESHNO:[0] geoSlot:1 cnt:1 Mesh:0x00007F89EFE33040
[2021-01-29 19:28:25][0] Mesh creation time = 523.06 ms.
[2021-01-29 19:28:25][2]  Env.Update()  SUN=0x0000000000000000 SKY:0x0000000000000000  envNode:0x0000000000000000  mainNG=0x0000000000000000
[2021-01-29 19:28:25][2] ENV CALC=3 force=0 updated=3
[2021-01-29 19:28:25][2]  Env.Update()  SUN=0x0000000000000000 SKY:0x0000000000000000  envNode:0x0000000000000000  mainNG=0x0000000000000000
[2021-01-29 19:28:25][1] ImageObject::reload()
[2021-01-29 19:28:25][1] ImageObject::reload()
[2021-01-29 19:28:25][1] updateCamera()
[2021-01-29 19:28:25][1] ApplyCImager enDenoise:0
[2021-01-29 19:28:26][1] Update started[2021-01-29 19:28:26][1] Total export Time = 2010.541 ms
[2021-01-29 19:28:26][1] Total export Time = 2010.541 ms[2021-01-29 19:28:26][1] setRRegionFromRndSettings 0x00007F89E58BB128 ret=0
[2021-01-29 19:28:26][1] ApiUpdate Wait:1 Caller:SendAndStartRender tm:0.192ms.  [OK]
[2021-01-29 19:28:26][1] LVL:0 1  1
[2021-01-29 19:28:27][1] LVL:0 1  1
[2021-01-29 19:28:27][1] LVL:0 1  1
[2021-01-29 19:28:27][1] LVL:0 1  1
[2021-01-29 19:28:27][1] LVL:0 1  1
[2021-01-29 19:28:27][1] LVL:0 1  1
[2021-01-29 19:28:27][1] LVL:0 1  1
[2021-01-29 19:28:27][1] LVL:0 1  1
[2021-01-29 19:28:27][1] LVL:0 1  1
[2021-01-29 19:28:27][1] LVL:1 1  1
[2021-01-29 19:28:27][0]  MB:0/0  ST/MOV:0/0  Nodes:11  Tris:3.345m  DispTris:0  Hairs:0  Meshes:1
[2021-01-29 19:28:27][0]  Textures Grey8/16:0/0  Rgb32/64:0/0
[2021-01-29 19:28:27][0] VRAM used/free/max:1.027Gb/2.973Gb/4Gb  Out-of-core used:357Mb  RAM used:25.219Gb total:32Gb  OpenGL free/total:0/0
[2021-01-29 19:28:27][1] Device:0  [AMD Radeon Pro 560]<En>[T][0]  Memory used/free/total:1.027Gb/2.973Gb/4Gb  outOfCoreMem:357Mb  p2pBytesUsed:0  runtimeDataSize:966Mb
[2021-01-29 19:28:27][1] Render progress  cspp/maxspp:1/228
[2021-01-29 19:28:27][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:28:27][1] Render progress  cspp/maxspp:3/228
[2021-01-29 19:28:27][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:28:28][1] Render progress  cspp/maxspp:5/228
[2021-01-29 19:28:28][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:28:28][1] Render progress  cspp/maxspp:9/228
[2021-01-29 19:28:28][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:28:28][1] Render progress  cspp/maxspp:17/228
[2021-01-29 19:28:28][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:28:29][1] Render progress  cspp/maxspp:27/228
[2021-01-29 19:28:29][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:28:30][1] Render progress  cspp/maxspp:53/228
[2021-01-29 19:28:30][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:28:31][1] Render progress  cspp/maxspp:81/228
[2021-01-29 19:28:31][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:28:33][1] Render progress  cspp/maxspp:112/228
[2021-01-29 19:28:33][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:28:34][1] Render progress  cspp/maxspp:145/228
[2021-01-29 19:28:34][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:28:36][1] Render progress  cspp/maxspp:176/228
[2021-01-29 19:28:36][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:28:38][1] Render progress  cspp/maxspp:209/228
[2021-01-29 19:28:38][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:28:39][1] Render progress  cspp/maxspp:228/228
[2021-01-29 19:28:39][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:28:39][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:28:39][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:28:39][1] Process Octane Passes -> en:1 ext:.tif bits:257 saveML:0
[2021-01-29 19:28:39][1] Create imageState:0x00007F89125F80C0
[2021-01-29 19:28:39][1] StoreAllRenderPasses:0x00007F89125F80C0  passCnt:1 
[2021-01-29 19:28:39][0] Tonemapping the all passes tm:79.954
[2021-01-29 19:28:39][1] Alloc multiBmp:0x00007F8911CA8D40
[2021-01-29 19:28:39][0] stored passes in:0 cores=1
[2021-01-29 19:28:39][0] Displaying passes in tm=0
[2021-01-29 19:28:39][1] freeRenderImages:0x00007F89125F80C0 multiBmp:0x00007F8911CA8D40
[2021-01-29 19:28:39][0] Passes saved in:0sec. 
[2021-01-29 19:28:39][1] Delete imageState:0x00007F89125F80C0
[2021-01-29 19:28:39][1] freeRenderImages:0x00007F89125F80C0 multiBmp:0x00007F8911CA8D40
[2021-01-29 19:28:39][0] **** RENDER FINISHED ****  stat=6
[2021-01-29 19:28:39][1] VpRenderFinished()
[2021-01-29 19:28:39][1] Render finished...[2021-01-29 19:28:39][1] ResetCaches [OK]
 [OK]
[2021-01-29 19:28:39][1] ResetAndInit 0
[2021-01-29 19:28:39][1] RESET PROJECT[2021-01-29 19:28:39][1] Init defaults[2021-01-29 19:28:39][1] ResetCaches [OK]
[2021-01-29 19:28:39][1] ResetAndInit [OK]

[2021-01-29 19:28:46][1] <markMaterials>
[2021-01-29 19:28:51][4] OctaneMat Init:0x00007F89D52B0EC0  OctGlossy1  ID:0 time:19446900 doc:
 [OK]
[2021-01-29 19:28:52][0] ------- VP START:0x00007F89D4F97FC0 VPS:0x000070000454C8A0 -----------
[2021-01-29 19:28:52][1] initVpRender(....)
[2021-01-29 19:28:52][1] setInteractive(0)[OK] [2021-01-29 19:28:52][1] initOctaneLive()
[2021-01-29 19:28:53][1] Starting render frame:0 [OK]
 [OK]
[2021-01-29 19:28:53][1] startVpRender(.....)
[2021-01-29 19:28:53][1] setInteractive(0)[OK] [2021-01-29 19:28:53][0]  
[2021-01-29 19:28:53][0] FRAME:0 fps:24
[2021-01-29 19:28:53][0] enableAllRenderDevices[2021-01-29 19:28:53][0] setDevicesActivity  E:0 P: T: D:0
[2021-01-29 19:28:53][1] initOctaneLive()
[2021-01-29 19:28:53][1] Sending scene data.....[2021-01-29 19:28:53][0] --------------------------- EXPORT LOG ---------------------------
[2021-01-29 19:28:53][1] ResetAndInit 1
[2021-01-29 19:28:53][16]   LightCollector::clear() -> cnt=0 
[2021-01-29 19:28:53][1] RESET PROJECT[2021-01-29 19:28:53][1] Init defaults[2021-01-29 19:28:53][1] createOctaneDefaults [2021-01-29 19:28:53][1] ResetCaches[2021-01-29 19:28:53][16]   LightCollector::clear() -> cnt=0 
 [OK]
[2021-01-29 19:28:53][1] ResetAndInit [OK]

 [OK]
 [OK]
[2021-01-29 19:28:53][1] create InfoChannelKernel
[2021-01-29 19:28:53][1] use active CameraImager
[2021-01-29 19:28:53][1] use active InfoChannelKernel
[2021-01-29 19:28:53][1] applyICParams:0x00007F890FE37ED0
[2021-01-29 19:28:53][1] ApplyCImager enDenoise:0
[2021-01-29 19:28:53][1] Creating materials.....[2021-01-29 19:28:53][1] ******* createMaterials *******
[2021-01-29 19:28:53][1] Create Materials....[2021-01-29 19:28:53][0] Multi-threaded material conversion, thread count=2
[2021-01-29 19:28:53][1]   convert mat:[OctGlossy1]  tip:1029501
[2021-01-29 19:28:53][1] generate material:OctGlossy1[2021-01-29 19:28:53][4]     convertOctaneNodes owner: pinID:0 type:Gradient
[2021-01-29 19:28:53][4]   convert done in:1.021ms. 
[2021-01-29 19:28:53][0] Export materials time= 2.435 ms
[2021-01-29 19:28:53][1] Collecting objects.....[2021-01-29 19:28:53][0] Collect objects time= 0.184 ms
[2021-01-29 19:28:53][1] Creating meshes.....[2021-01-29 19:28:53][1] SINGLE MESH COLLECTING cnt:1 tricnt:1672704 vtxCnt:1672706[2021-01-29 19:28:54][0]   >> MESHNO:[0] geoSlot:1 cnt:1 Mesh:0x00007F890FD59650
[2021-01-29 19:28:54][0] Mesh creation time = 341.124 ms.
[2021-01-29 19:28:54][2]  Env.Update()  SUN=0x0000000000000000 SKY:0x0000000000000000  envNode:0x0000000000000000  mainNG=0x0000000000000000
[2021-01-29 19:28:54][2] ENV CALC=3 force=0 updated=3
[2021-01-29 19:28:54][2]  Env.Update()  SUN=0x0000000000000000 SKY:0x0000000000000000  envNode:0x0000000000000000  mainNG=0x0000000000000000
[2021-01-29 19:28:54][1] ImageObject::reload()
[2021-01-29 19:28:54][1] ImageObject::reload()
[2021-01-29 19:28:54][1] updateCamera()
[2021-01-29 19:28:54][1] ApplyCImager enDenoise:0
[2021-01-29 19:28:55][1] Update started[2021-01-29 19:28:55][1] Total export Time = 1597.543 ms
[2021-01-29 19:28:55][1] Total export Time = 1597.543 ms[2021-01-29 19:28:55][1] setRRegionFromRndSettings 0x00007F89D4F98328 ret=0
[2021-01-29 19:28:55][1] ApiUpdate Wait:1 Caller:SendAndStartRender tm:0.271ms.  [OK]
[2021-01-29 19:28:55][1] LVL:0 4  1
[2021-01-29 19:28:55][1] LVL:0 4  1
[2021-01-29 19:28:55][1] LVL:0 4  1
[2021-01-29 19:28:55][1] LVL:0 4  1
[2021-01-29 19:28:55][1] LVL:4 4  1
[2021-01-29 19:28:55][0]  MB:0/0  ST/MOV:0/0  Nodes:11  Tris:3.345m  DispTris:0  Hairs:0  Meshes:1
[2021-01-29 19:28:55][0]  Textures Grey8/16:0/0  Rgb32/64:0/0
[2021-01-29 19:28:55][0] VRAM used/free/max:1.028Gb/2.972Gb/4Gb  Out-of-core used:357Mb  RAM used:26.338Gb total:32Gb  OpenGL free/total:0/0
[2021-01-29 19:28:55][1] Device:0  [AMD Radeon Pro 560]<En>[T][0]  Memory used/free/total:1.028Gb/2.972Gb/4Gb  outOfCoreMem:357Mb  p2pBytesUsed:0  runtimeDataSize:966Mb
[2021-01-29 19:28:55][1] Render progress  cspp/maxspp:1/228
[2021-01-29 19:28:55][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:28:56][1] Render progress  cspp/maxspp:4/228
[2021-01-29 19:28:56][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:28:56][1] Render progress  cspp/maxspp:6/228
[2021-01-29 19:28:56][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:28:56][1] Render progress  cspp/maxspp:9/228
[2021-01-29 19:28:56][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:28:56][1] Render progress  cspp/maxspp:13/228
[2021-01-29 19:28:56][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:28:57][1] Render progress  cspp/maxspp:18/228
[2021-01-29 19:28:57][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:28:57][1] Render progress  cspp/maxspp:22/228
[2021-01-29 19:28:57][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:28:58][1] Render progress  cspp/maxspp:27/228
[2021-01-29 19:28:58][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:28:59][1] Render progress  cspp/maxspp:40/228
[2021-01-29 19:28:59][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:29:00][1] Render progress  cspp/maxspp:54/228
[2021-01-29 19:29:00][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:29:02][1] Render progress  cspp/maxspp:81/228
[2021-01-29 19:29:02][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:29:04][1] Render progress  cspp/maxspp:113/228
[2021-01-29 19:29:04][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:29:07][1] Render progress  cspp/maxspp:161/228
[2021-01-29 19:29:07][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:29:10][1] Render progress  cspp/maxspp:209/228
[2021-01-29 19:29:10][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:29:11][1] Render progress  cspp/maxspp:228/228
[2021-01-29 19:29:11][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:29:12][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:29:12][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:29:12][1] Process Octane Passes -> en:1 ext:.tif bits:257 saveML:0
[2021-01-29 19:29:12][1] Create imageState:0x00007F89D5D6A4C0
[2021-01-29 19:29:12][1] StoreAllRenderPasses:0x00007F89D5D6A4C0  passCnt:1 
[2021-01-29 19:29:12][0] Tonemapping the all passes tm:115.204
[2021-01-29 19:29:12][1] Alloc multiBmp:0x00007F89D54EA540
[2021-01-29 19:29:12][0] stored passes in:0 cores=1
[2021-01-29 19:29:12][0] Displaying passes in tm=0
[2021-01-29 19:29:12][1] freeRenderImages:0x00007F89D5D6A4C0 multiBmp:0x00007F89D54EA540
[2021-01-29 19:29:12][0] Passes saved in:0sec. 
[2021-01-29 19:29:12][1] Delete imageState:0x00007F89D5D6A4C0
[2021-01-29 19:29:12][1] freeRenderImages:0x00007F89D5D6A4C0 multiBmp:0x00007F89D54EA540
[2021-01-29 19:29:13][1] Starting render frame:1 [OK]
 [OK]
[2021-01-29 19:29:13][1] startVpRender(.....)
[2021-01-29 19:29:13][1] setInteractive(0)[OK] [2021-01-29 19:29:13][0]  
[2021-01-29 19:29:13][0] FRAME:1 fps:24
[2021-01-29 19:29:13][1] initOctaneLive()
[2021-01-29 19:29:13][1] Sending scene data.....[2021-01-29 19:29:13][0] --------------------------- EXPORT LOG ---------------------------
[2021-01-29 19:29:13][1] ResetAndInit 1
[2021-01-29 19:29:13][16]   LightCollector::clear() -> cnt=0 
[2021-01-29 19:29:13][1] RESET PROJECT[2021-01-29 19:29:13][1] Init defaults[2021-01-29 19:29:13][1] createOctaneDefaults [2021-01-29 19:29:13][1] ResetCaches[2021-01-29 19:29:13][16]   LightCollector::clear() -> cnt=0 
 [OK]
[2021-01-29 19:29:13][1] ResetAndInit [OK]

 [OK]
 [OK]
[2021-01-29 19:29:13][1] create InfoChannelKernel
[2021-01-29 19:29:13][1] use active CameraImager
[2021-01-29 19:29:13][1] use active InfoChannelKernel
[2021-01-29 19:29:13][1] applyICParams:0x00007F89CCAA9140
[2021-01-29 19:29:13][1] ApplyCImager enDenoise:0
[2021-01-29 19:29:13][1] Creating materials.....[2021-01-29 19:29:13][1] ******* createMaterials *******
[2021-01-29 19:29:13][1] Create Materials....[2021-01-29 19:29:13][0] Multi-threaded material conversion, thread count=2
[2021-01-29 19:29:13][1]   convert mat:[OctGlossy1]  tip:1029501
[2021-01-29 19:29:13][1] generate material:OctGlossy1[2021-01-29 19:29:13][4]     convertOctaneNodes owner: pinID:0 type:Gradient
[2021-01-29 19:29:13][4]   convert done in:0.447ms. 
[2021-01-29 19:29:13][0] Export materials time= 1.294 ms
[2021-01-29 19:29:13][1] Collecting objects.....[2021-01-29 19:29:13][0] Collect objects time= 0.15 ms
[2021-01-29 19:29:13][1] Creating meshes.....[2021-01-29 19:29:13][1] SINGLE MESH COLLECTING cnt:1 tricnt:1672704 vtxCnt:1672706[2021-01-29 19:29:13][0]   >> MESHNO:[0] geoSlot:1 cnt:1 Mesh:0x00007F89FFCA99E0
[2021-01-29 19:29:13][0] Mesh creation time = 321.73 ms.
[2021-01-29 19:29:13][2]  Env.Update()  SUN=0x0000000000000000 SKY:0x0000000000000000  envNode:0x0000000000000000  mainNG=0x0000000000000000
[2021-01-29 19:29:13][2] ENV CALC=3 force=0 updated=3
[2021-01-29 19:29:13][2]  Env.Update()  SUN=0x0000000000000000 SKY:0x0000000000000000  envNode:0x0000000000000000  mainNG=0x0000000000000000
[2021-01-29 19:29:13][1] ImageObject::reload()
[2021-01-29 19:29:13][1] ImageObject::reload()
[2021-01-29 19:29:13][1] updateCamera()
[2021-01-29 19:29:13][1] ApplyCImager enDenoise:0
[2021-01-29 19:29:15][1] Update started[2021-01-29 19:29:15][1] Total export Time = 1609.584 ms
[2021-01-29 19:29:15][1] Total export Time = 1609.584 ms[2021-01-29 19:29:15][1] setRRegionFromRndSettings 0x00007F89D4F98328 ret=0
[2021-01-29 19:29:15][1] ApiUpdate Wait:1 Caller:SendAndStartRender tm:0.416ms.  [OK]
[2021-01-29 19:29:15][1] LVL:0 6  1
[2021-01-29 19:29:15][1] LVL:0 6  1
[2021-01-29 19:29:15][1] LVL:0 6  1
[2021-01-29 19:29:15][1] LVL:0 6  1
[2021-01-29 19:29:15][1] LVL:6 6  1
[2021-01-29 19:29:15][0]  MB:0/0  ST/MOV:0/0  Nodes:11  Tris:3.345m  DispTris:0  Hairs:0  Meshes:1
[2021-01-29 19:29:15][0]  Textures Grey8/16:0/0  Rgb32/64:0/0
[2021-01-29 19:29:15][0] VRAM used/free/max:1.028Gb/2.972Gb/4Gb  Out-of-core used:357Mb  RAM used:27.157Gb total:32Gb  OpenGL free/total:0/0
[2021-01-29 19:29:15][1] Device:0  [AMD Radeon Pro 560]<En>[T][0]  Memory used/free/total:1.028Gb/2.972Gb/4Gb  outOfCoreMem:357Mb  p2pBytesUsed:0  runtimeDataSize:966Mb
[2021-01-29 19:29:15][1] Render progress  cspp/maxspp:1/228
[2021-01-29 19:29:15][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:29:15][1] Render progress  cspp/maxspp:4/228
[2021-01-29 19:29:15][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:29:16][1] Render progress  cspp/maxspp:9/228
[2021-01-29 19:29:16][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:29:16][1] Render progress  cspp/maxspp:13/228
[2021-01-29 19:29:16][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:29:17][1] Render progress  cspp/maxspp:18/228
[2021-01-29 19:29:17][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:29:17][1] Render progress  cspp/maxspp:22/228
[2021-01-29 19:29:17][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:29:17][1] Render progress  cspp/maxspp:27/228
[2021-01-29 19:29:17][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:29:18][1] Render progress  cspp/maxspp:40/228
[2021-01-29 19:29:18][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:29:19][1] Render progress  cspp/maxspp:54/228
[2021-01-29 19:29:19][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:29:21][1] renderBreak
[2021-01-29 19:29:21][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:29:21][1] copyBuffer type:2 cc:0 isRP:0 tm:0sec. 
[2021-01-29 19:29:21][0] **** RENDER FINISHED ****  stat=6
[2021-01-29 19:29:21][1] VpRenderFinished()
[2021-01-29 19:29:21][1] Render finished...[2021-01-29 19:29:21][1] ResetCaches [OK]
 [OK]
[2021-01-29 19:29:21][1] ResetAndInit 0
[2021-01-29 19:29:21][1] RESET PROJECT[2021-01-29 19:29:21][1] Init defaults[2021-01-29 19:29:21][1] ResetCaches [OK]
[2021-01-29 19:29:21][1] ResetAndInit [OK]

[2021-01-29 19:29:21][1] setResFromRndSettings 0x00007F89F005FBC0 [OK]
[2021-01-29 19:29:21][1] ApiUpdate Wait:0 Caller:needApiUpdate tm:40.338ms.  [OK]
[2021-01-29 19:29:31][0] restoreDeviceStates status:7
[2021-01-29 19:29:31][0] setDevicesActivity  E:0 P: T:0 D:
[2021-01-29 19:29:31][0] save
 [OK]
 [OK]
[2021-01-29 19:29:34][1] >> ProcessUpdate(flags=C cAsyn=0 dDelay=1
[2021-01-29 19:29:34][1] >> ProcessUpdate end res:0
[2021-01-29 19:29:34][1] ApiUpdate Wait:0 Caller:needApiUpdate tm:40.323ms.  [OK]
[2021-01-29 19:29:35][1] >> ProcessUpdate(flags=C cAsyn=0 dDelay=1
[2021-01-29 19:29:35][1] >> ProcessUpdate end res:0
[2021-01-29 19:29:35][1] ApiUpdate Wait:0 Caller:needApiUpdate tm:40.365ms.  [OK]
[2021-01-29 19:29:38][1] >> ProcessUpdate(flags=C cAsyn=0 dDelay=1
[2021-01-29 19:29:38][1] >> ProcessUpdate end res:0
[2021-01-29 19:29:38][1] >> ProcessUpdate(flags=C cAsyn=0 dDelay=1
[2021-01-29 19:29:38][1] >> ProcessUpdate end res:0
[2021-01-29 19:29:38][1] ApiUpdate Wait:0 Caller:needApiUpdate tm:40.548ms.  [OK]
[2021-01-29 19:29:38][1] >> ProcessUpdate(flags=C cAsyn=0 dDelay=1
[2021-01-29 19:29:38][1] >> ProcessUpdate end res:0
[2021-01-29 19:29:38][1] >> ProcessUpdate(flags=C cAsyn=0 dDelay=1
[2021-01-29 19:29:38][1] >> ProcessUpdate end res:0
[2021-01-29 19:29:38][1] >> ProcessUpdate(flags=C cAsyn=0 dDelay=1
[2021-01-29 19:29:38][1] >> ProcessUpdate end res:0
[2021-01-29 19:29:38][1] >> ProcessUpdate(flags=C cAsyn=0 dDelay=1
[2021-01-29 19:29:38][1] >> ProcessUpdate end res:0
[2021-01-29 19:29:38][1] ApiUpdate Wait:0 Caller:needApiUpdate[2021-01-29 19:29:38][1] >> ProcessUpdate(flags=C cAsyn=0 dDelay=1
 tm:39.296ms.  [OK]
[2021-01-29 19:29:38][1] >> ProcessUpdate end res:0
[2021-01-29 19:29:38][1] >> ProcessUpdate(flags=C cAsyn=0 dDelay=1
[2021-01-29 19:29:38][1] >> ProcessUpdate end res:0
[2021-01-29 19:29:38][1] ApiUpdate Wait:0 Caller:needApiUpdate tm:0.318ms.  [OK]
[2021-01-29 19:29:39][1] >> ProcessUpdate(flags=C cAsyn=0 dDelay=1
[2021-01-29 19:29:39][1] >> ProcessUpdate end res:0
[2021-01-29 19:29:39][1] >> ProcessUpdate(flags=C cAsyn=0 dDelay=1
[2021-01-29 19:29:39][1] >> ProcessUpdate end res:0
[2021-01-29 19:29:39][1] ApiUpdate Wait:0 Caller:needApiUpdate tm:40.373ms.  [OK]
[2021-01-29 19:29:40][1] >> ProcessUpdate(flags=C cAsyn=0 dDelay=1
[2021-01-29 19:29:40][1] >> ProcessUpdate end res:0
[2021-01-29 19:29:40][1] >> ProcessUpdate(flags=C cAsyn=0 dDelay=1
[2021-01-29 19:29:40][1] >> ProcessUpdate end res:0
[2021-01-29 19:29:40][1] ApiUpdate Wait:0 Caller:needApiUpdate tm:29.492ms.  [OK]
[2021-01-29 19:29:40][1] >> ProcessUpdate(flags=C cAsyn=0 dDelay=1
[2021-01-29 19:29:40][1] >> ProcessUpdate end res:0
[2021-01-29 19:29:40][1] >> ProcessUpdate(flags=C cAsyn=0 dDelay=1
[2021-01-29 19:29:40][1] >> ProcessUpdate end res:0
[2021-01-29 19:29:40][1] ApiUpdate Wait:0 Caller:needApiUpdate tm:31.409ms.  [OK]
[2021-01-29 19:29:40][1] >> ProcessUpdate(flags=C cAsyn=0 dDelay=1
[2021-01-29 19:29:40][1] >> ProcessUpdate end res:0
[2021-01-29 19:29:40][1] >> ProcessUpdate(flags=C cAsyn=0 dDelay=1
[2021-01-29 19:29:40][1] >> ProcessUpdate end res:0
[2021-01-29 19:29:40][1] ApiUpdate Wait:0 Caller:needApiUpdate tm:29.443ms.  [OK]
