Houdini crash at saving file Octane 2018.1.0.3 Tweet

[dotcom]

Hello JuanJGOn,


Me again, i'm sorry,
so i can see the render in the IPR : i've jumped from frames to frames by 30 frames steps and everything is ok.
Then i was on my way final render so i've tried everything i could but nothing can resolve my problem : houdini crash just at the saving file moment,
the renderer does its render but then at 97% it crash the app. > Denoiser ? MB ? i don't know/.
It happens for one image render or for a seq / with Mplay or without .

My two cents : denoiser : but it works in the IPR previews so that might not be that.
MB ? may be i've added a trail node to compute velocity but that might not be the process for octane.
All the computationnal CPU parts regarding geo are cached (53 go).
I have a shader with both a rgb attribute and a float attribut : new stuff
Let's try to find a solution without the file if possible cause 53 go is a bit too much for a transfer and without caching the geo would be like 10 mn of wait to be seen in the scene.

You will see several errors in the following log file :

Here they are :
05:57:26 ERROR: [materials] --------- Material SHOP node "" not found (not important i guess)
05:57:35 ERROR: [materials] --------- Material SHOP node "" not found (not important i guess)
05:57:36 ERROR: [rt vop] ------------ The Octane node has not been found in the linked node (??)

And here is the log file in all its glory :

Log started Thu Mar 7 05:57:18 2019
Octane Render for Houdini by Juanjo Gonzalez. Build 2018.1.0.3 (Build date: Jan 31 2019 00:31:38)
Octane API: 2018.1 RC3
HDK API: 17.0.459
Houdini host version: 17.0.483
System: GenuineIntel unknown, 3190 Mhz., 16 cores
OS: Windows 8 64-bit

05:57:18 INFOR: [license] ----------- This Octane License is already active
05:57:18 INFOR: [system] ------------ Setting the GPUs device state and priority
05:57:18 INFOR: [driver] ------------ Initializing a Houdini driver for the Octane MPlay viewport
05:57:18 INFOR: [driver] ------------ MPlay lock file: C:/Users/PC/Documents/houdini17.0/.flipbook_lock.arnold
05:57:18 INFOR: [core] -------------- ROP node render, time 0.00
05:57:18 INFOR: [loader] ------------ Houdini camera path: /obj/cam2
05:57:19 INFOR: [core] -------------- Render layers disabled
05:57:19 INFOR: [loader] ------------ Houdini camera path: /obj/cam2
05:57:19 INFOR: [driver] ------------ Opening Houdini driver for the Octane viewport
05:57:19 INFOR: [driver] ------------ Diver size 1920 x 1080
05:57:25 INFOR: [loader] ------------ Loading scene
05:57:25 INFOR: [loader] ------------ Found a OBJ node: /obj/cam2
05:57:25 INFOR: [loader] ------------ Found a OBJ node: /obj/VIDEO_RENDER
05:57:25 INFOR: [loader] ------------ Render SOP for this node: /obj/VIDEO_RENDER/VIDEO_RENDER, name VIDEO_RENDER
05:57:25 INFOR: [loader] ------------ Found a OBJ node: /obj/CABLES_RENDER
05:57:25 INFOR: [loader] ------------ Render SOP for this node: /obj/CABLES_RENDER/CABLES_RENDER, name CABLES_RENDER
05:57:25 INFOR: [loader] ------------ Found a OBJ node: /obj/source_particles
05:57:25 INFOR: [loader] ------------ Render SOP for this node: /obj/source_particles/OUT_PARTICLES, name OUT_PARTICLES
05:57:25 INFOR: [loader] ------------ Found a OBJ node: /obj/octane_light1
05:57:25 INFOR: [loader] ------------ Render SOP for this node: /obj/octane_light1/switch3, name switch3
05:57:25 INFOR: [materials] --------- Building the materials list
05:57:25 INFOR: [materials] --------- Found 2 materials
05:57:25 INFOR: [materials] --------- Building the materials list
05:57:25 INFOR: [materials] --------- Found 2 materials
05:57:26 ERROR: [materials] --------- Material SHOP node "" not found
05:57:26 INFOR: [loader] ------------ Transformation matrix for MB step 0
05:57:26 INFOR: [loader] ------------ Transformation matrix for MB step 1
05:57:35 ERROR: [materials] --------- Material SHOP node "" not found
05:57:36 INFOR: [loader] ------------ Transformation matrix for MB step 0
05:57:36 INFOR: [loader] ------------ Transformation matrix for MB step 1
05:57:36 INFOR: [loader] ------------ Building the render target
05:57:36 ERROR: [rt vop] ------------ The Octane node has not been found in the linked node
05:57:36 INFOR: [loader] ------------ Loading the Houdini camera parameters
05:57:36 INFOR: [loader] ------------ Houdini camera path: /obj/cam2
05:57:36 INFOR: [loader] ------------ Houdini camera path: /obj/cam2
05:57:36 INFOR: [loader] ------------ Scene Loaded
05:57:36 INFOR: [loader] ------------ Setting the motion blur parameters
05:57:36 INFOR: [loader] ------------ Houdini camera path: /obj/cam2
05:57:36 INFOR: [preview image] ----- Set image callback
05:57:36 INFOR: [render] ------------ Render setup, set renderTarget and update
05:58:04 INFOR: [render progress] --- 1 percent, Samples 36 of 2500, R.Time 00:00:06, MSamples/Sec. 11.04
05:58:06 INFOR: [render progress] --- 2 percent, Samples 52 of 2500, R.Time 00:00:08, MSamples/Sec. 13.15
05:58:08 INFOR: [render progress] --- 3 percent, Samples 76 of 2500, R.Time 00:00:10, MSamples/Sec. 19.05
05:58:10 INFOR: [render progress] --- 4 percent, Samples 100 of 2500, R.Time 00:00:12, MSamples/Sec. 21.16
05:58:13 INFOR: [render progress] --- 5 percent, Samples 132 of 2500, R.Time 00:00:15, MSamples/Sec. 21.79
05:58:17 INFOR: [render progress] --- 6 percent, Samples 172 of 2500, R.Time 00:00:19, MSamples/Sec. 23.69
05:58:21 INFOR: [render progress] --- 8 percent, Samples 216 of 2500, R.Time 00:00:23, MSamples/Sec. 22.60
05:58:26 INFOR: [render progress] --- 10 percent, Samples 272 of 2500, R.Time 00:00:28, MSamples/Sec. 23.22
05:58:31 INFOR: [render progress] --- 13 percent, Samples 332 of 2500, R.Time 00:00:33, MSamples/Sec. 23.41
05:58:37 INFOR: [render progress] --- 16 percent, Samples 400 of 2500, R.Time 00:00:39, MSamples/Sec. 24.22
05:58:44 INFOR: [render progress] --- 18 percent, Samples 468 of 2500, R.Time 00:00:46, MSamples/Sec. 21.65
05:58:52 INFOR: [render progress] --- 22 percent, Samples 552 of 2500, R.Time 00:00:54, MSamples/Sec. 22.52
05:59:00 INFOR: [render progress] --- 25 percent, Samples 644 of 2500, R.Time 00:01:02, MSamples/Sec. 22.55
05:59:10 INFOR: [render progress] --- 29 percent, Samples 748 of 2500, R.Time 00:01:12, MSamples/Sec. 23.04
05:59:20 INFOR: [render progress] --- 34 percent, Samples 860 of 2500, R.Time 00:01:22, MSamples/Sec. 22.71
05:59:31 INFOR: [render progress] --- 39 percent, Samples 980 of 2500, R.Time 00:01:34, MSamples/Sec. 22.20
05:59:44 INFOR: [render progress] --- 44 percent, Samples 1112 of 2500, R.Time 00:01:46, MSamples/Sec. 22.97
05:59:57 INFOR: [render progress] --- 50 percent, Samples 1256 of 2500, R.Time 00:01:59, MSamples/Sec. 22.97
06:00:12 INFOR: [render progress] --- 56 percent, Samples 1412 of 2500, R.Time 00:02:14, MSamples/Sec. 21.55
06:00:27 INFOR: [render progress] --- 63 percent, Samples 1580 of 2500, R.Time 00:02:29, MSamples/Sec. 22.39
06:00:44 INFOR: [render progress] --- 70 percent, Samples 1760 of 2500, R.Time 00:02:46, MSamples/Sec. 22.09
06:01:01 INFOR: [render progress] --- 78 percent, Samples 1952 of 2500, R.Time 00:03:03, MSamples/Sec. 23.04
06:01:20 INFOR: [render progress] --- 86 percent, Samples 2156 of 2500, R.Time 00:03:22, MSamples/Sec. 23.21
06:01:40 INFOR: [render progress] --- 95 percent, Samples 2376 of 2500, R.Time 00:03:42, MSamples/Sec. 22.98
06:01:50 INFOR: [render progress] --- 100 percent, Samples 2500 of 2500, R.Time 00:03:52, MSamples/Sec. 0.00
06:01:51 INFOR: [render stats] ------ Objects: 2, Triangles: 13248012, Hairs: 0, Voxels: 0, Particles: 0
06:01:51 INFOR: [render stats] ------ Textures (8/16/32/64): 0 / 0 / 0 / 2
06:01:51 INFOR: [render stats] ------ GPU RAM (used/free/total): 4471 / 4557/ 11264 [MB]
06:01:51 INFOR: [render stats] ------ Sys RAM (used/free): 34054 / 130971, Total mem. used: 27215 [MB]
06:01:51 INFOR: [render stats] ------ Out-of-core RAM (used/max) 0 / 16384 [MB]
06:01:51 INFOR: [render stats] ------ Local GPUs: 4, Net GPUs: 0, Net memory: 0 [MB]
06:01:51 INFOR: [preview image] ----- Reset image callback
06:01:51 INFOR: [final image] ------- Get the final complete Octane image
06:01:51 INFOR: [final image] ------- Reading final HDRI image
06:01:51 INFOR: [save image] -------- Save image function enabled
06:01:51 INFOR: [save image] -------- Saving the "Denoised beauty" pass to the "E:/PERSO/VFX_SCHOOL/WEEK-1/week_1_01/render/week-1-exercise2-6.Octane_ROP1-6.0001" file


Been working on this for 18hrs non stop time to have some sleep but no renders
Thank you JuanJo,,
++

[juanjgon]

Hmm, this seems a crash in the Octane native saving functions. What are you saving options in the Octane ROP node, Output tab? Does your user have permissions to write to this folder? If you want to send me the .hip file without any additional assets or cache files I could take a look at it here.

Thanks,
-Juanjo

[dotcom]

Here are screenshots of the rop output.

i've been making a copy of the render target_dl1 by alt clic and drag to have a copy of those params but the rop is fully connected to the rendertarget.
i can save files from the houdini mplay in the render folder

I've just tried to render on C: same thing happens (crash) with this last info :
5096: Fatal error: Segmentation fault.

i keep on investigating.
++

[dotcom]

i've made a simple scene to be sure : it renders and saves image,
i keep on investigating in the file with problem by deleting render target and outdriver, then re create it from scratch from the octane shelf /

[dotcom]

Wookay,

something is weird,

i've done a render (YES!) one image ... DL 640-320 defaults params

so i did another one replicating the exact same params as the final rendertarget and output params with the exception of downsizing the samples : CRASH /
> this is it /


So i did another try and unchecked MB, denoising, Ai lights, adaptive sampling and it RENDERS /

So crash occurs from one of those : MB, denoising, Ai lights, adaptive sampling i'm going to check them one by one again and render to see where it comes from exactly,
then i'll send you my file.

++

[dotcom]

Tests :

adaptive sampling : render

ai lights : render

denoising : renders

MB : lets go :

i have different option to check

enable MB : render
enable MB + camera MB : render
enable MB + camera MB + objects MB : i think i i've catched the devil guy so i added an attrib delete node set to "v" to all the geo for render : render


so there is no velocity attribute for octane to render motion blur geometry at all so how will the renderer knows the pos difference between frame A and B ?
i've added this trail node just for that reason : to have Octane being aware of the computed velocity at geometry level /
Does it have to be a prim attribute or vertex ? right now it'a a point attribute.

Thank yo uvery much JuanJo ,

++

[dotcom]

i'm sorry it crashes again for no reason, it rendered i saw it rendered an image. i closed the file just opened it again and now it crashes again,
restart computer /.
i'm beginning to loose my enthousiasm.

[dotcom]

ok,

restartedcomputer,

render crash
unchecked all motion blur : crash,

i'm out of idea it was rendering just 10 mns agos with same settings.
Time for fresh air.

[juanjgon]

From your log, the crash happens after the rendering has finished, so it only can be related to the image saving functions. Can you please disable the "Asynchronous file save" option in the Output tab and try again?

Thanks,
-Juanjo

[dotcom]

i've done it : still crash.
what else can i try ?

++