Arnold Render stuck at 100%

[rubtub1000]

Hi, 2019 Version of Maya will "finish" a render with the loading bar stuck at 100% and won't actually finish the render until a couple of hours later. This is a problem because visually the 100% is not what the finished render should look like despite it saying that. And I know the render isn't actually finished until the loading bar is gone and the pause button turns into a play button. Please help me resolve this- thank you!

[Christoph_Schaedl]

Take a look at the log.

And turn on the the Debug Verbosity Level.

[rubtub1000]

It worked twice and now it's doing the same thing, even on debug.

[Christoph_Schaedl]

The renderer doesnt do anything different with debug. 

It just writes more info in the log file. 

Take a look in the small white window that opens with maya.

What is the error message? 

[rubtub1000]

Initialized VP2.0 renderer {
Version : 2016.11.54.12. Feature Level 5.
Adapter : GeForce RTX 2080/PCIe/SSE2
Vendor ID: 4318. Device ID : 7815
Driver : .
API : OpenGL V.4.6.
Max texture size : 16384 * 16384.
Max tex coords : 32
Shader versions supported (Vertex: 5, Geometry: 5, Pixel 5).
Shader compiler profile : (Best card profile)
Active stereo support available : 0
GPU Memory Limit : 8192 MB.
CPU Memory Limit: 62159.3 MB.
MultiDraw consolidation: enabled
}
OpenCL evaluator is attempting to initialize OpenCL.
Detected 1 OpenCL Platforms:
0: NVIDIA Corporation. NVIDIA CUDA. OpenCL 1.2 CUDA 10.2.108.
Supported extensions: cl_khr_global_int32_base_atomics cl_khr_global_int32_extended_atomics cl_khr_local_int32_base_atomics cl_khr_local_int32_extended_atomics cl_khr_fp64 cl_khr_byte_addressable_store cl_khr_icd cl_khr_gl_sharing cl_nv_compiler_options cl_nv_device_attribute_query cl_nv_pragma_unroll cl_nv_d3d10_sharing cl_khr_d3d10_sharing cl_nv_d3d11_sharing cl_nv_copy_opts cl_nv_create_buffer cl_khr_int64_base_atomics cl_khr_int64_extended_atomics
OpenCL evaluator choosing OpenCL platform NVIDIA Corporation.
Choosing OpenCL Device GeForce RTX 2080. Device Type: GPU Device is available.

00:00:00 2251MB | log started Mon Feb 17 16:34:52 2020
00:00:00 2251MB | Arnold 5.2.2.0 [30b8ba14] windows icc-17.0.2 oiio-2.0.1 osl-1.10.1 vdb-4.0.0 clm-1.0.3.513 rlm-12.4.2 2018/12/04 22:02:04
00:00:00 2251MB | host application: MtoA 3.1.2 cd2a574d (master) Maya 2019
00:00:00 2251MB | running on DESKTOP-GA48RFL, pid=22296
00:00:00 2251MB | 1 x AMD Ryzen Threadripper 2990WX 32-Core Processor (32 cores, 64 logical) with 65430MB
00:00:00 2251MB | Nvidia driver version 441.66
00:00:00 2251MB | GPU 0: GeForce RTX 2080 @ 1815MHz (compute 7.5) with 8192MB (5602MB available)
00:00:00 2251MB |
00:00:00 2251MB | soft limit for open files raised from 2048 to 2048
00:00:00 2251MB |
00:00:00 2251MB | loading plugins from C:/solidangle/mtoadeploy/2019/shaders ...
00:00:00 2251MB | loading plugins from C:/solidangle/mtoadeploy/2019/procedurals ...
00:00:00 2251MB | loaded 122 plugins from 9 lib(s) in 0:00.02
00:00:00 2251MB | loading plugins from C:\solidangle\mtoadeploy\2019\bin\..\plugins ...
00:00:00 2251MB | loaded 5 plugins from 3 lib(s) in 0:00.00
00:00:00 2251MB |
00:00:00 2251MB | releasing resources
00:00:00 2250MB | Arnold shutdown
[mtoa] [translator polymesh] ShadingGroup room101:FrontColor MPlug not found
render terminating early: received abort signal
[mtoa] [translator polymesh] ShadingGroup room101:FrontColor MPlug not found
[color_manager] using color manager of type "color_manager_syncolor"
[color_manager] rendering color space is "scene-linear Rec 709/sRGB" with declared chromaticities:
r(0.6400, 0.3300) g(0.3000, 0.6000) b(0.1500, 0.0600) and w(0.3127, 0.3290)

rendering image at 4000 x 2000 (463 x 2000 region), -3 AA samples
AA samples max <disabled>
AA sample clamp <disabled>
diffuse samples 9 / depth 1
specular samples 9 / depth 1
transmission samples 9 / depth 8
volume indirect <disabled by depth>
total depth 10
bssrdf samples 9
transparency depth 10
initializing 1960 nodes ...
creating root object list ...
node initialization done in 0:00.00 (multithreaded)
updating 1960 nodes ...
scene bounds: (-2821.39233 -6.274683 -201.30304) -> (-2238.35522 225.093689 369.891327)
node update done in 0:00.00 (multithreaded)
[aov] parsing 2 output statements ...
[aov] registered driver: "arv_display" (driver_arv)
[aov] * "RGBA" of type RGBA filtered by "defaultArnoldFilter@gaussian_filter" (gaussian_filter)
[aov] * "object" of type POINTER filtered by "_renderViewDefault@closest_filter" (closest_filter)
[aov] done preparing 4 AOVs for 2 outputs to 1 driver (0 deep AOVs)
starting 63 bucket workers of size 64x64 ...
render done in 0:01.003
render done

-----------------------------------------------------------------------------------
scene creation time 0:02.74 machine utilization (4.83%)
plugin loading 0:00.02
unaccounted 0:02.72
-----------------------------------------------------------------------------------
frame time 0:01.02 machine utilization (96.85%)
rendering 0:01.00
pixel rendering 0:01.00
-----------------------------------------------------------------------------------
top session self-times by category
worker waiting 16:22:57.55 (67.32%)
AiLightsPrepare 2:26:37.83 (10.04%)
room101:pPlane3Shape 22:26.57 ( 1.54%)
pPlane5Shape 16:38.90 ( 1.14%)
room101:pPlane4Shape 15:31.09 ( 1.06%)
room101:pPlane6Shape 12:35.06 ( 0.86%)
test_01:couch001:Mesh13Component3_2skpF50A1sofa_red_aparador_2_1SOF____BANDEJA_DE_BRA_O1ModelShape 8:34.38 ( 0.59%)
room101:pPlane5Shape 8:04.02 ( 0.55%)
room101:Mesh11Group20Group_19_1bedroom1ModelShape 7:54.10 ( 0.54%)
surface closure 2:07:43.81 ( 8.75%)
white_wall 1:12:03.81 ( 4.94%)
room101:initialShadingGroup1 29:44.82 ( 2.04%)
test_01:couch 9:44.76 ( 0.67%)
BVH::intersect 1:30:15.78 ( 6.18%)
root 53:39.86 ( 3.68%)
polymesh::intersect 1:05:27.05 ( 4.48%)
polySurface1641Shape 9:32.99 ( 0.65%)
light_polySurface219Shape@mesh 8:04.89 ( 0.55%)
ray traversal+intersection 14:50.13 ( 1.02%)
-----------------------------------------------------------------------------------
top session self-times by node
worker waiting 16:22:57.55 (67.32%)
standard_surface:white_wall 1:25:22.31 ( 5.85%)
surface closure 1:12:03.81 ( 4.94%)
list_aggregate:root 53:39.87 ( 3.68%)
BVH::intersect 53:39.86 ( 3.68%)
lambert:room101:initialShadingGroup1 35:55.79 ( 2.46%)
surface closure 29:44.82 ( 2.04%)
polymesh:room101:pPlane3Shape 29:23.62 ( 2.01%)
AiLightsPrepare 22:26.57 ( 1.54%)
polymesh:room101:pPlane4Shape 22:06.64 ( 1.51%)
AiLightsPrepare 15:31.09 ( 1.06%)
-----------------------------------------------------------------------------------
peak CPU memory used 11816.56MB
at startup 2302.77MB
plugins 1.61MB
AOV samples 0.25MB
output buffers 5.91MB
node overhead 1.08MB
message passing 0.12MB
memory pools 41.55MB
geometry 60.05MB
polymesh 60.05MB
accel. structs 45.34MB
skydome importance map 7.63MB
mesh importance map 0.38MB
strings 12.00MB
texture cache 337.27MB
profiler 208.59MB
unaccounted 8792.00MB (note: interactive session)
-----------------------------------------------------------------------------------
ray counts ( /pixel, /sample) (% total) (avg. hits) (max hits)
camera 23162 ( 1.60, 1.00) ( 0.14%) ( 1.00) ( 2)
shadow 12672994 ( 874.00, 547.15) ( 77.27%) ( 0.89) ( 1)
volume_shadow 132 ( 0.01, 0.01) ( 0.00%) ( 1.00) ( 1)
diffuse_reflect 2497672 ( 172.25, 107.83) ( 15.23%) ( 0.91) ( 2)
specular_reflect 992350 ( 68.44, 42.84) ( 6.05%) ( 1.02) ( 2)
specular_transmit 215110 ( 14.84, 9.29) ( 1.31%) ( 0.39) ( 2)
total 16401420 (1131.13, 708.12) (100.00%) ( 0.89) ( 2)
by ray depth: 0 1 2 3 4 5 6 7 8 9
total 17.6% 66.9% 15.0% 0.5% 0.1% 0.0% 0.0% 0.0% 0.0% 0.0%
-----------------------------------------------------------------------------------
ray marching samples ( /ray ) (% total) (segments)
specular_transmit 66 ( 1.00) (100.00%) ( 1.00)
total 66 ( 1.00) (100.00%) ( 1.00)
-----------------------------------------------------------------------------------
shader calls ( /pixel, /sample) (% total)
primary 3665208 ( 252.77, 158.24) ( 96.23%)
background 143761 ( 9.91, 6.21) ( 3.77%)
total 3808969 ( 262.69, 164.45) (100.00%)
by ray depth: 0 1 2 3 4 5 6 7 8 9
total 0.8% 75.9% 21.7% 1.4% 0.2% 0.0% 0.0% 0.0% 0.0% 0.0%
-----------------------------------------------------------------------------------
geometry (% hit ) (instances) ( init mem, final mem)
lists 1 ( 0.0%) ( 0) ( 0.00, 0.00)
polymeshes 1851 (100.0%) ( 0) ( 128.47, 60.05)
-----------------------------------------------------------------------------------
geometric elements ( min) ( avg.) ( max)
polygons 1347516 ( 1) ( 728.0) ( 655574)
-----------------------------------------------------------------------------------
triangle tessellation ( min) ( avg.) ( max) (/ element) (% total)
polymeshes 1915600 ( 1) ( 1034.9) ( 1178142) ( 1.42) (100.00%)
unique triangles 1915600
CPU memory use 60.17MB
vertices 15.85MB
vertex indices 9.96MB
polygon base offsets 0.87MB
polygon IDs 0.79MB
triangulation 0.96MB
packed normals 3.74MB
normal indices 7.47MB
uv coords 7.09MB
uv coords idxs 8.93MB
uniform indices 2.93MB
userdata 0.07MB
-----------------------------------------------------------------------------------
acceleration structures: (% total)
list 1734 ( 93.63%)
bvh 118 ( 6.37%)
total 1852 (100.00%)
-----------------------------------------------------------------------------------
OpenImageIO Texture statistics
Options: gray_to_rgb=1 flip_t=0 max_tile_channels=6
Queries/batches :
texture : xxx-xxxxxxxx queries in xxx-xxxxxxxx batches
texture 3d : 0 queries in 0 batches
shadow : 0 queries in 0 batches
environment : 0 queries in 0 batches
Interpolations :
closest : 108
bilinear : xxx-xxxxxxxx
bicubic : 123724328
Average anisotropic probes : 1.03
Max anisotropy in the wild : 1e+06

OpenImageIO ImageCache statistics (000002373E167040) ver 2.0.1RC
Options: max_memory_MB=2048.0 max_open_files=5 autotile=0
autoscanline=1 automip=0 forcefloat=0 accept_untiled=1
accept_unmipped=1 deduplicate=1 unassociatedalpha=0
failure_retries=0
Images : 27 unique
ImageInputs : 435 created, 5 current, 8 peak
Total pixel data size of all images referenced : 800.9 MB
Total actual file size of all images referenced : 173.5 MB
Pixel data read : 649.4 MB
File I/O time : 1m 4.3s (0.5s average per thread, for 126 threads)
File open time only : 0.3s
ImageInput mutex locking time : 0.6s
Tiles: 15639 created, 7949 current, 7949 peak
total tile requests : xxx-xxxxxxxx
micro-cache misses : 127118769 (0.258164%)
main cache misses : 15639 (3.17611e-05%)
redundant reads: 245 tiles, 11.2 MB
Peak cache memory : 337.3 MB
Image file statistics:
opens tiles MB read --redundant-- I/O time res File
1 57 13451 630.5 ( 236 11.1) 1m 2.5s 10000x5000x3.f32 C:/Users/reb6s/Desktop/094_hdrmaps_com_free.tx MIP-COUNT[4663,1288,815,212,45,15,7,2,1,1,1,1,1,1]
2 27 97 1.5 0.1s 256x 512x4.u8 C:/Users/reb6s/Desktop/Spathiphyllum_Wallis_Leaf2.tx MIP-COUNT[32,8,2,1,1,1,1,1,1,1]
3 8 54 0.6 0.0s 256x 256x3.u8 C:/Users/reb6s/Desktop/_Wood_floor_dark_.tx MIP-COUNT[16,4,1,1,1,1,1,1,1]
4 2 14 0.2 ( 2 0.0) 0.0s 512x 512x3.u8 C:/Users/reb6s/Desktop/bump.tx MIP-COUNT[0,0,1,1,1,1,1,1,0,0]
5 38 382 4.5 ( 3 0.0) 0.2s 1260x 945x3.u8 C:/Users/reb6s/Desktop/concrete3.tx MIP-COUNT[126,38,15,6,2,1,1,1,1,1,1]
6 6 88 1.0 ( 1 0.0) 0.0s 600x 600x3.u8 C:/Users/reb6s/Desktop/couch001/_1.tx MIP-COUNT[32,25,9,4,1,1,1,2,1,1]
7 22 260 3.0 0.3s 1024x 708x3.u8 C:/Users/reb6s/Desktop/couch001/_76.tx MIP-COUNT[163,48,12,4,1,1,1,1,1,1,1]
8 17 35 0.4 0.1s 256x 256x3.u8 C:/Users/reb6s/Desktop/kitchen/Metal_Aluminum_Anodized.tx MIP-COUNT[13,4,1,1,1,1,1,1,1]
9 15 17 0.2 0.1s 128x 128x3.u8 C:/Users/reb6s/Desktop/kitchen/Metal_Rough.tx MIP-COUNT[4,1,1,1,1,1,1,1]
10 13 22 0.3 0.1s 128x 128x3.u8 C:/Users/reb6s/Desktop/kitchen/_CorrogateShiny_.tx MIP-COUNT[4,1,1,1,1,1,1,1]
11 2 0 0.0 0.0s 128x 128x3.u8 C:/Users/reb6s/Desktop/kitchen/_Metal_Corrogated_Shiny_1.tx DUPLICATES C:/Users/reb6s/Desktop/kitchen/_CorrogateShiny_.tx
12 16 23 0.3 ( 1 0.0) 0.1s 2443x1462x3.u8 C:/Users/reb6s/Desktop/kitchen/mineral_black.tx MIP-COUNT[0,0,0,2,4,2,1,1,1,1,2,1]
13 16 82 1.0 ( 2 0.0) 0.1s 210x 435x3.u8 C:/Users/reb6s/Desktop/kitchen/sofielundt.tx MIP-COUNT[24,10,2,1,1,1,1,1,1]
14 7 10 0.1 0.0s 550x 440x3.u8 C:/Users/reb6s/Desktop/kitchen/wenge.tx MIP-COUNT[0,0,0,0,0,1,1,1,1,1]
15 6 6 0.1 0.0s 256x 256x3.u8 C:/Users/reb6s/Desktop/misc1/Carpet_Loop_Pattern.tx MIP-COUNT[0,0,0,0,0,1,1,1,1]
16 12 18 0.2 0.0s 512x 512x3.u8 C:/Users/reb6s/Desktop/misc1/M_12___Default1.tx MIP-COUNT[0,0,0,1,1,1,1,1,1,1]
17 15 37 0.4 0.1s 512x 512x3.u8 C:/Users/reb6s/Desktop/misc1/Material1.tx MIP-COUNT[0,0,4,1,1,1,1,1,1,1]
18 11 18 0.2 0.0s 512x 512x3.u8 C:/Users/reb6s/Desktop/misc1/Material__1.tx MIP-COUNT[0,0,0,1,1,1,1,1,1,1]
19 2 2 0.0 0.0s 85x 128x3.u8 C:/Users/reb6s/Desktop/misc1/Metal_Corrogated_Shiny.tx MIP-COUNT[0,0,0,0,0,0,0,1]
20 2 0 0.0 0.0s 128x 128x3.u8 C:/Users/reb6s/Desktop/misc1/Metal_Corrogated_Shiny1_.tx DUPLICATES C:/Users/reb6s/Desktop/kitchen/_CorrogateShiny_.tx
21 3 4 0.0 0.0s 85x 128x3.u8 C:/Users/reb6s/Desktop/misc1/Metal_Corrogated_Shiny2_.tx MIP-COUNT[0,0,0,0,0,0,0,1]
22 33 120 1.4 0.1s 299x 542x3.u8 C:/Users/reb6s/Desktop/misc1/zrooftop.tx MIP-COUNT[45,15,6,2,1,1,1,1,1,1]
23 26 117 1.4 0.3s 771x 570x3.u8 C:/Users/reb6s/Desktop/misc2/M_044bois.tx MIP-COUNT[60,28,9,4,1,1,1,1,1,1]
24 12 19 0.2 0.0s 256x 256x3.u8 C:/Users/reb6s/Desktop/plant222/Groundcover_RiverRock_4inch.tx MIP-COUNT[1,4,1,1,1,1,1,1,1]
25 40 102 1.2 0.2s 1161x 963x3.u8 C:/Users/reb6s/Desktop/plant222/_1_2.tx MIP-COUNT[3,39,17,6,2,1,1,1,1,1,1]
26 19 38 0.4 0.0s 160x 159x3.u8 C:/Users/reb6s/Desktop/plant222/palmleaf1.tx MIP-COUNT[9,4,1,1,1,1,1,1]
27 8 14 0.2 0.0s 800x 578x3.u8 C:/Users/reb6s/Desktop/strrrrrrr/_2.tx MIP-COUNT[0,0,0,2,1,1,1,1,1,1]

Tot: 435 15030 649.4 ( 245 11.2) 1m 4.3s
2 were exact duplicates of other images
Broken or invalid files: 0
-----------------------------------------------------------------------------------
number of warnings, warning type:
1: [mtoa] [translator %s] ShadingGroup %s MPlug not found
-----------------------------------------------------------------------------------
performance warnings:
Scene creation was a significant amount of total time (73%). Consider optimizing this process first.
-----------------------------------------------------------------------------------
[color_manager] using color manager of type "color_manager_syncolor"
[color_manager] rendering color space is "scene-linear Rec 709/sRGB" with declared chromaticities:
r(0.6400, 0.3300) g(0.3000, 0.6000) b(0.1500, 0.0600) and w(0.3127, 0.3290)

rendering image at 4000 x 2000 (463 x 2000 region), 15 AA samples
AA samples max <disabled>
AA sample clamp <disabled>
diffuse samples 9 / depth 1
specular samples 9 / depth 1
transmission samples 9 / depth 8
volume indirect <disabled by depth>
total depth 10
bssrdf samples 9
transparency depth 10
initializing 1960 nodes ...
creating root object list ...
node initialization done in 0:00.00 (multithreaded)
updating 1960 nodes ...
scene bounds: (-2821.39233 -6.274683 -201.30304) -> (-2238.35522 225.093689 369.891327)
node update done in 0:00.00 (multithreaded)
[aov] parsing 2 output statements ...
[aov] registered driver: "arv_display" (driver_arv)
[aov] * "RGBA" of type RGBA filtered by "defaultArnoldFilter@gaussian_filter" (gaussian_filter)
[aov] * "object" of type POINTER filtered by "_renderViewDefault@closest_filter" (closest_filter)
[aov] done preparing 4 AOVs for 2 outputs to 1 driver (0 deep AOVs)
starting 63 bucket workers of size 64x64 ...
0% done (0/225 sample iterations)
5% done (12/225 sample iterations)
10% done (23/225 sample iterations)
15% done (34/225 sample iterations)
render done in 24:20.209
render done
[color_manager] using color manager of type "color_manager_syncolor"
[color_manager] rendering color space is "scene-linear Rec 709/sRGB" with declared chromaticities:
r(0.6400, 0.3300) g(0.3000, 0.6000) b(0.1500, 0.0600) and w(0.3127, 0.3290)

rendering image at 4000 x 2000 (254 x 2000 region), 15 AA samples
AA samples max <disabled>
AA sample clamp <disabled>
diffuse samples 9 / depth 1
specular samples 9 / depth 1
transmission samples 9 / depth 8
volume indirect <disabled by depth>
total depth 10
bssrdf samples 9
transparency depth 10
initializing 1960 nodes ...
creating root object list ...
node initialization done in 0:00.00 (multithreaded)
updating 1960 nodes ...
scene bounds: (-2821.39233 -6.274683 -201.30304) -> (-2238.35522 225.093689 369.891327)
node update done in 0:00.00 (multithreaded)
[aov] parsing 2 output statements ...
[aov] registered driver: "arv_display" (driver_arv)
[aov] * "RGBA" of type RGBA filtered by "defaultArnoldFilter@gaussian_filter" (gaussian_filter)
[aov] * "object" of type POINTER filtered by "_renderViewDefault@closest_filter" (closest_filter)
[aov] done preparing 4 AOVs for 2 outputs to 1 driver (0 deep AOVs)
starting 63 bucket workers of size 64x64 ...
0% done (0/225 sample iterations)
5% done (12/225 sample iterations)
10% done (23/225 sample iterations)
15% done (34/225 sample iterations)
20% done (45/225 sample iterations)
25% done (57/225 sample iterations)
30% done (68/225 sample iterations)
35% done (79/225 sample iterations)
40% done (90/225 sample iterations)
45% done (102/225 sample iterations)
50% done (113/225 sample iterations)
55% done (124/225 sample iterations)
60% done (135/225 sample iterations)
65% done (147/225 sample iterations)
70% done (158/225 sample iterations)
75% done (169/225 sample iterations)
render done in 1:28:45.004
render done
[color_manager] using color manager of type "color_manager_syncolor"
[color_manager] rendering color space is "scene-linear Rec 709/sRGB" with declared chromaticities:
r(0.6400, 0.3300) g(0.3000, 0.6000) b(0.1500, 0.0600) and w(0.3127, 0.3290)

rendering image at 4000 x 2000 (505 x 2000 region), 15 AA samples
AA samples max <disabled>
AA sample clamp <disabled>
diffuse samples 9 / depth 1
specular samples 9 / depth 1
transmission samples 9 / depth 8
volume indirect <disabled by depth>
total depth 10
bssrdf samples 9
transparency depth 10
initializing 1960 nodes ...
creating root object list ...
node initialization done in 0:00.00 (multithreaded)
updating 1960 nodes ...
scene bounds: (-2821.39233 -6.274683 -201.30304) -> (-2238.35522 225.093689 369.891327)
node update done in 0:00.00 (multithreaded)
[aov] parsing 2 output statements ...
[aov] registered driver: "arv_display" (driver_arv)
[aov] * "RGBA" of type RGBA filtered by "defaultArnoldFilter@gaussian_filter" (gaussian_filter)
[aov] * "object" of type POINTER filtered by "_renderViewDefault@closest_filter" (closest_filter)
[aov] done preparing 4 AOVs for 2 outputs to 1 driver (0 deep AOVs)
starting 63 bucket workers of size 64x64 ...
0% done (0/225 sample iterations)
5% done (12/225 sample iterations)
10% done (23/225 sample iterations)
15% done (34/225 sample iterations)
render done in 26:25.306
render done
[color_manager] using color manager of type "color_manager_syncolor"
[color_manager] rendering color space is "scene-linear Rec 709/sRGB" with declared chromaticities:
r(0.6400, 0.3300) g(0.3000, 0.6000) b(0.1500, 0.0600) and w(0.3127, 0.3290)

rendering image at 4000 x 2000 (611 x 2000 region), 15 AA samples
AA samples max <disabled>
AA sample clamp <disabled>
diffuse samples 9 / depth 1
specular samples 9 / depth 1
transmission samples 9 / depth 8
volume indirect <disabled by depth>
total depth 10
bssrdf samples 9
transparency depth 10
initializing 1960 nodes ...
creating root object list ...
node initialization done in 0:00.00 (multithreaded)
updating 1960 nodes ...
scene bounds: (-2821.39233 -6.274683 -201.30304) -> (-2238.35522 225.093689 369.891327)
node update done in 0:00.00 (multithreaded)
[aov] parsing 2 output statements ...
[aov] registered driver: "arv_display" (driver_arv)
[aov] * "RGBA" of type RGBA filtered by "defaultArnoldFilter@gaussian_filter" (gaussian_filter)
[aov] * "object" of type POINTER filtered by "_renderViewDefault@closest_filter" (closest_filter)
[aov] done preparing 4 AOVs for 2 outputs to 1 driver (0 deep AOVs)
starting 63 bucket workers of size 64x64 ...
0% done (0/225 sample iterations)
5% done (12/225 sample iterations)
10% done (23/225 sample iterations)
15% done (34/225 sample iterations)
20% done (45/225 sample iterations)
25% done (57/225 sample iterations)
30% done (68/225 sample iterations)
35% done (79/225 sample iterations)
40% done (90/225 sample iterations)
45% done (102/225 sample iterations)
50% done (113/225 sample iterations)
55% done (124/225 sample iterations)
60% done (135/225 sample iterations)
65% done (147/225 sample iterations)
70% done (158/225 sample iterations)
75% done (169/225 sample iterations)
80% done (180/225 sample iterations)
85% done (192/225 sample iterations)
90% done (203/225 sample iterations)
95% done (214/225 sample iterations)
render done in 3:37:31.095
render done

-----------------------------------------------------------------------------------
scene creation time 0:02.74 machine utilization (4.83%)
plugin loading 0:00.02
unaccounted 0:02.72
-----------------------------------------------------------------------------------
frame time 3:37:32.44 machine utilization (99.32%)
rendering 3:37:31.09
output driver 0:00.16
pixel rendering 3:37:30.93 (225 sample iterations @ min: 0:55.725, avg: 0:58.004, max: 1:00.021)
unaccounted 0:01.33
-----------------------------------------------------------------------------------
top session self-times by category
worker waiting 16:24:54.17 (54.16%)
AiLightsPrepare 4:08:26.47 (13.66%)
room101:pPlane3Shape 34:07.57 ( 1.88%)
pPlane5Shape 25:47.42 ( 1.42%)
room101:pPlane4Shape 22:03.15 ( 1.21%)
room101:pPlane6Shape 20:38.43 ( 1.13%)
room101:pPlane5Shape 20:13.18 ( 1.11%)
room101:Mesh11Group20Group_19_1bedroom1ModelShape 14:00.55 ( 0.77%)
test_01:couch001:Mesh13Component3_2skpF50A1sofa_red_aparador_2_1SOF____BANDEJA_DE_BRA_O1ModelShape 11:37.56 ( 0.64%)
room101:pCube1Shape 9:30.79 ( 0.52%)
surface closure 3:42:19.66 (12.23%)
white_wall 1:52:07.92 ( 6.17%)
room101:initialShadingGroup1 52:25.05 ( 2.88%)
room101:foam 12:06.10 ( 0.67%)
test_01:couch 11:55.75 ( 0.66%)
window 9:42.80 ( 0.53%)
BVH::intersect 2:39:13.49 ( 8.76%)
root 1:34:33.46 ( 5.20%)
polymesh::intersect 1:58:47.03 ( 6.53%)
polySurface1641Shape 20:47.45 ( 1.14%)
light_polySurface219Shape@mesh 13:26.80 ( 0.74%)
ray traversal+intersection 25:44.53 ( 1.42%)
-----------------------------------------------------------------------------------
top session self-times by node
worker waiting 16:24:54.17 (54.16%)
standard_surface:white_wall 2:13:57.13 ( 7.37%)
surface closure 1:52:07.92 ( 6.17%)
list_aggregate:root 1:34:33.47 ( 5.20%)
BVH::intersect 1:34:33.46 ( 5.20%)
lambert:room101:initialShadingGroup1 1:02:57.96 ( 3.46%)
surface closure 52:25.05 ( 2.88%)
polymesh:room101:pPlane3Shape 45:39.24 ( 2.51%)
AiLightsPrepare 34:07.57 ( 1.88%)
polymesh:pPlane5Shape 33:04.31 ( 1.82%)
AiLightsPrepare 25:47.42 ( 1.42%)
-----------------------------------------------------------------------------------
peak CPU memory used 16240.46MB
at startup 2302.77MB
plugins 1.61MB
AOV samples 2649.87MB
output buffers 5.91MB
node overhead 1.08MB
message passing 0.12MB
memory pools 41.55MB
geometry 60.05MB
polymesh 60.05MB
accel. structs 45.34MB
skydome importance map 7.63MB
mesh importance map 0.56MB
strings 12.00MB
texture cache 420.77MB
profiler 344.62MB
unaccounted 10346.57MB (note: interactive session)
-----------------------------------------------------------------------------------
ray counts ( /pixel, /sample) (% total) (avg. hits) (max hits)
camera 283101008 ( 1.03, 1.00) ( 0.14%) ( 1.01) ( 4)
shadow 150993356105 ( 549.17, 533.36) ( 75.43%) ( 0.87) ( 1)
volume_shadow 9483473 ( 0.03, 0.03) ( 0.00%) ( 1.00) ( 1)
diffuse_reflect xxx-xxxxxxxx ( 99.85, 96.98) ( 13.71%) ( 0.90) ( 4)
specular_reflect xxx-xxxxxxxx ( 48.29, 46.90) ( 6.63%) ( 0.99) ( 4)
specular_transmit 8107267358 ( 29.49, 28.64) ( 4.05%) ( 0.35) ( 4)
bssrdf 63453507 ( 0.23, 0.22) ( 0.03%) ( 1.66) ( 11)
total 200188127498 ( 728.09, 707.13) (100.00%) ( 0.86) ( 11)
by ray depth: 0 1 2 3 4 5 6 7 8 9 10+
total 16.1% 65.3% 18.0% 0.5% 0.0% 0.0% 0.0% 0.0% 0.0% 0.0% 0.0%
-----------------------------------------------------------------------------------
ray marching samples ( /ray ) (% total) (segments)
shadow 40 ( 1.00) ( 0.00%) ( 1.00)
volume_shadow 106 ( 1.00) ( 0.00%) ( 1.00)
diffuse_reflect 58003 ( 1.00) ( 1.22%) ( 1.00)
specular_transmit 4700285 ( 1.00) ( 98.78%) ( 1.00)
total 4758434 ( 1.00) (100.00%) ( 1.00)
-----------------------------------------------------------------------------------
shader calls ( /pixel, /sample) (% total)
primary xxx-xxxxxxxx ( 163.29, 158.59) ( 88.92%)
background 5595373020 ( 20.35, 19.76) ( 11.08%)
total xxx-xxxxxxxx ( 183.64, 178.35) (100.00%)
by ray depth: 0 1 2 3 4 5 6 7 8 9 10+
total 0.6% 73.4% 24.4% 1.4% 0.1% 0.0% 0.0% 0.0% 0.0% 0.0% 0.0%
sss lookups 31113939 ( 0.11, 0.11)
-----------------------------------------------------------------------------------
geometry (% hit ) (instances) ( init mem, final mem)
lists 1 ( 0.0%) ( 0) ( 0.00, 0.00)
polymeshes 1851 (100.0%) ( 0) ( 128.47, 60.05)
-----------------------------------------------------------------------------------
geometric elements ( min) ( avg.) ( max)
polygons 1347516 ( 1) ( 728.0) ( 655574)
-----------------------------------------------------------------------------------
triangle tessellation ( min) ( avg.) ( max) (/ element) (% total)
polymeshes 1915600 ( 1) ( 1034.9) ( 1178142) ( 1.42) (100.00%)
unique triangles 1915600
CPU memory use 60.17MB
vertices 15.85MB
vertex indices 9.96MB
polygon base offsets 0.87MB
polygon IDs 0.79MB
triangulation 0.96MB
packed normals 3.74MB
normal indices 7.47MB
uv coords 7.09MB
uv coords idxs 8.93MB
uniform indices 2.93MB
userdata 0.07MB
-----------------------------------------------------------------------------------
acceleration structures: (% total)
list 1734 ( 93.63%)
bvh 118 ( 6.37%)
total 1852 (100.00%)
-----------------------------------------------------------------------------------
OpenImageIO Texture statistics
Options: gray_to_rgb=1 flip_t=0 max_tile_channels=6
Queries/batches :
texture : xxx-xxxxxxxx queries in xxx-xxxxxxxx batches
texture 3d : 0 queries in 0 batches
shadow : 0 queries in 0 batches
environment : 0 queries in 0 batches
Interpolations :
closest : 108
bilinear : xxx-xxxxxxxx
bicubic : 200565624
Average anisotropic probes : 1.01
Max anisotropy in the wild : 1e+06

OpenImageIO ImageCache statistics (000002373E167040) ver 2.0.1RC
Options: max_memory_MB=2048.0 max_open_files=5 autotile=0
autoscanline=1 automip=0 forcefloat=0 accept_untiled=1
accept_unmipped=1 deduplicate=1 unassociatedalpha=0
failure_retries=0
Images : 27 unique
ImageInputs : 449 created, 5 current, 8 peak
Total pixel data size of all images referenced : 800.9 MB
Total actual file size of all images referenced : 173.5 MB
Pixel data read : 732.9 MB
File I/O time : 1m 7.7s (0.5s average per thread, for 126 threads)
File open time only : 0.3s
ImageInput mutex locking time : 0.6s
Tiles: 17473 created, 9783 current, 9783 peak
total tile requests : xxx-xxxxxxxx
micro-cache misses : 1234240977 (1.42167%)
main cache misses : 17473 (2.01264e-05%)
redundant reads: 245 tiles, 11.2 MB
Peak cache memory : 420.8 MB
Image file statistics:
opens tiles MB read --redundant-- I/O time res File
1 57 15214 713.2 ( 236 11.1) 1m 5.6s 10000x5000x3.f32 C:/Users/reb6s/Desktop/094_hdrmaps_com_free.tx MIP-COUNT[5956,1756,815,212,47,15,7,2,1,1,1,1,1,1]
2 27 97 1.5 0.1s 256x 512x4.u8 C:/Users/reb6s/Desktop/Spathiphyllum_Wallis_Leaf2.tx MIP-COUNT[32,8,2,1,1,1,1,1,1,1]
3 8 54 0.6 0.0s 256x 256x3.u8 C:/Users/reb6s/Desktop/_Wood_floor_dark_.tx MIP-COUNT[16,4,1,1,1,1,1,1,1]
4 2 14 0.2 ( 2 0.0) 0.0s 512x 512x3.u8 C:/Users/reb6s/Desktop/bump.tx MIP-COUNT[0,0,1,1,1,1,1,1,0,0]
5 39 385 4.5 ( 3 0.0) 0.2s 1260x 945x3.u8 C:/Users/reb6s/Desktop/concrete3.tx MIP-COUNT[128,39,15,6,2,1,1,1,1,1,1]
6 6 90 1.1 ( 1 0.0) 0.0s 600x 600x3.u8 C:/Users/reb6s/Desktop/couch001/_1.tx MIP-COUNT[34,25,9,4,1,1,1,2,1,1]
7 22 260 3.0 0.3s 1024x 708x3.u8 C:/Users/reb6s/Desktop/couch001/_76.tx MIP-COUNT[163,48,12,4,1,1,1,1,1,1,1]
8 18 36 0.4 0.1s 256x 256x3.u8 C:/Users/reb6s/Desktop/kitchen/Metal_Aluminum_Anodized.tx MIP-COUNT[14,4,1,1,1,1,1,1,1]
9 15 17 0.2 0.1s 128x 128x3.u8 C:/Users/reb6s/Desktop/kitchen/Metal_Rough.tx MIP-COUNT[4,1,1,1,1,1,1,1]
10 13 22 0.3 0.1s 128x 128x3.u8 C:/Users/reb6s/Desktop/kitchen/_CorrogateShiny_.tx MIP-COUNT[4,1,1,1,1,1,1,1]
11 2 0 0.0 0.0s 128x 128x3.u8 C:/Users/reb6s/Desktop/kitchen/_Metal_Corrogated_Shiny_1.tx DUPLICATES C:/Users/reb6s/Desktop/kitchen/_CorrogateShiny_.tx
12 17 29 0.3 ( 1 0.0) 0.1s 2443x1462x3.u8 C:/Users/reb6s/Desktop/kitchen/mineral_black.tx MIP-COUNT[0,0,0,6,6,2,1,1,1,1,2,1]
13 16 82 1.0 ( 2 0.0) 0.1s 210x 435x3.u8 C:/Users/reb6s/Desktop/kitchen/sofielundt.tx MIP-COUNT[24,10,2,1,1,1,1,1,1]
14 8 11 0.1 0.0s 550x 440x3.u8 C:/Users/reb6s/Desktop/kitchen/wenge.tx MIP-COUNT[0,0,0,0,1,1,1,1,1,1]
15 7 7 0.1 0.0s 256x 256x3.u8 C:/Users/reb6s/Desktop/misc1/Carpet_Loop_Pattern.tx MIP-COUNT[0,0,0,0,1,1,1,1,1]
16 13 20 0.2 0.0s 512x 512x3.u8 C:/Users/reb6s/Desktop/misc1/M_12___Default1.tx MIP-COUNT[0,0,2,1,1,1,1,1,1,1]
17 17 48 0.6 0.1s 512x 512x3.u8 C:/Users/reb6s/Desktop/misc1/Material1.tx MIP-COUNT[0,11,4,1,1,1,1,1,1,1]
18 12 19 0.2 0.0s 512x 512x3.u8 C:/Users/reb6s/Desktop/misc1/Material__1.tx MIP-COUNT[0,0,1,1,1,1,1,1,1,1]
19 3 6 0.1 0.0s 85x 128x3.u8 C:/Users/reb6s/Desktop/misc1/Metal_Corrogated_Shiny.tx MIP-COUNT[0,0,0,1,1,1,1,1]
20 2 0 0.0 0.0s 128x 128x3.u8 C:/Users/reb6s/Desktop/misc1/Metal_Corrogated_Shiny1_.tx DUPLICATES C:/Users/reb6s/Desktop/kitchen/_CorrogateShiny_.tx
21 4 7 0.1 0.0s 85x 128x3.u8 C:/Users/reb6s/Desktop/misc1/Metal_Corrogated_Shiny2_.tx MIP-COUNT[0,0,0,0,1,1,1,1]
22 33 120 1.4 0.1s 299x 542x3.u8 C:/Users/reb6s/Desktop/misc1/zrooftop.tx MIP-COUNT[45,15,6,2,1,1,1,1,1,1]
23 27 123 1.4 0.3s 771x 570x3.u8 C:/Users/reb6s/Desktop/misc2/M_044bois.tx MIP-COUNT[66,28,9,4,1,1,1,1,1,1]
24 13 22 0.3 0.1s 256x 256x3.u8 C:/Users/reb6s/Desktop/plant222/Groundcover_RiverRock_4inch.tx MIP-COUNT[4,4,1,1,1,1,1,1,1]
25 41 129 1.5 0.2s 1161x 963x3.u8 C:/Users/reb6s/Desktop/plant222/_1_2.tx MIP-COUNT[7,62,17,6,2,1,1,1,1,1,1]
26 19 38 0.4 0.0s 160x 159x3.u8 C:/Users/reb6s/Desktop/plant222/palmleaf1.tx MIP-COUNT[9,4,1,1,1,1,1,1]
27 8 14 0.2 0.0s 800x 578x3.u8 C:/Users/reb6s/Desktop/strrrrrrr/_2.tx MIP-COUNT[0,0,0,2,1,1,1,1,1,1]

Tot: 449 16864 732.9 ( 245 11.2) 1m 7.7s
2 were exact duplicates of other images
Broken or invalid files: 0
-----------------------------------------------------------------------------------
number of warnings, warning type:
1: Scene creation was a significant amount of total time (%.00f%%). Consider optimizing this process first.
1: [mtoa] [translator %s] ShadingGroup %s MPlug not found
-----------------------------------------------------------------------------------
[color_manager] using color manager of type "color_manager_syncolor"
[color_manager] rendering color space is "scene-linear Rec 709/sRGB" with declared chromaticities:
r(0.6400, 0.3300) g(0.3000, 0.6000) b(0.1500, 0.0600) and w(0.3127, 0.3290)

rendering image at 4000 x 2000 (495 x 2000 region), 15 AA samples
AA samples max <disabled>
AA sample clamp <disabled>
diffuse samples 9 / depth 1
specular samples 9 / depth 1
transmission samples 9 / depth 8
volume indirect <disabled by depth>
total depth 10
bssrdf samples 9
transparency depth 10
initializing 1960 nodes ...
creating root object list ...
node initialization done in 0:00.00 (multithreaded)
updating 1960 nodes ...
scene bounds: (-2821.39233 -6.274683 -201.30304) -> (-2238.35522 225.093689 369.891327)
node update done in 0:00.00 (multithreaded)
[aov] parsing 2 output statements ...
[aov] registered driver: "arv_display" (driver_arv)
[aov] * "RGBA" of type RGBA filtered by "defaultArnoldFilter@gaussian_filter" (gaussian_filter)
[aov] * "object" of type POINTER filtered by "_renderViewDefault@closest_filter" (closest_filter)
[aov] done preparing 4 AOVs for 2 outputs to 1 driver (0 deep AOVs)
starting 63 bucket workers of size 64x64 ...
0% done (0/225 sample iterations)
5% done (12/225 sample iterations)
10% done (23/225 sample iterations)
15% done (34/225 sample iterations)
20% done (45/225 sample iterations)
25% done (57/225 sample iterations)
30% done (68/225 sample iterations)
render done in 1:02:03.814
render done
[color_manager] using color manager of type "color_manager_syncolor"
[color_manager] rendering color space is "scene-linear Rec 709/sRGB" with declared chromaticities:
r(0.6400, 0.3300) g(0.3000, 0.6000) b(0.1500, 0.0600) and w(0.3127, 0.3290)

rendering image at 4000 x 2000 (589 x 2000 region), 15 AA samples
AA samples max <disabled>
AA sample clamp <disabled>
diffuse samples 9 / depth 1
specular samples 9 / depth 1
transmission samples 9 / depth 8
volume indirect <disabled by depth>
total depth 10
bssrdf samples 9
transparency depth 10
initializing 1960 nodes ...
creating root object list ...
node initialization done in 0:00.00 (multithreaded)
updating 1960 nodes ...
scene bounds: (-2821.39233 -6.274683 -201.30304) -> (-2238.35522 225.093689 369.891327)
node update done in 0:00.00 (multithreaded)
[aov] parsing 2 output statements ...
[aov] registered driver: "arv_display" (driver_arv)
[aov] * "RGBA" of type RGBA filtered by "defaultArnoldFilter@gaussian_filter" (gaussian_filter)
[aov] * "object" of type POINTER filtered by "_renderViewDefault@closest_filter" (closest_filter)
[aov] done preparing 4 AOVs for 2 outputs to 1 driver (0 deep AOVs)
starting 63 bucket workers of size 64x64 ...
0% done (0/225 sample iterations)
5% done (12/225 sample iterations)
10% done (23/225 sample iterations)
15% done (34/225 sample iterations)
20% done (45/225 sample iterations)
25% done (57/225 sample iterations)
30% done (68/225 sample iterations)
35% done (79/225 sample iterations)
40% done (90/225 sample iterations)
45% done (102/225 sample iterations)
50% done (113/225 sample iterations)
55% done (124/225 sample iterations)
60% done (135/225 sample iterations)
render done in 1:33:10.275
render done
[color_manager] using color manager of type "color_manager_syncolor"
[color_manager] rendering color space is "scene-linear Rec 709/sRGB" with declared chromaticities:
r(0.6400, 0.3300) g(0.3000, 0.6000) b(0.1500, 0.0600) and w(0.3127, 0.3290)

rendering image at 4000 x 2000 (981 x 2000 region), 15 AA samples
AA samples max <disabled>
AA sample clamp <disabled>
diffuse samples 9 / depth 1
specular samples 9 / depth 1
transmission samples 9 / depth 8
volume indirect <disabled by depth>
total depth 10
bssrdf samples 9
transparency depth 10
initializing 1960 nodes ...
creating root object list ...
node initialization done in 0:00.00 (multithreaded)
updating 1960 nodes ...
scene bounds: (-2821.39233 -6.274683 -201.30304) -> (-2238.35522 225.093689 369.891327)
node update done in 0:00.00 (multithreaded)
[aov] parsing 2 output statements ...
[aov] registered driver: "arv_display" (driver_arv)
[aov] * "RGBA" of type RGBA filtered by "defaultArnoldFilter@gaussian_filter" (gaussian_filter)
[aov] * "object" of type POINTER filtered by "_renderViewDefault@closest_filter" (closest_filter)
[aov] done preparing 4 AOVs for 2 outputs to 1 driver (0 deep AOVs)
starting 63 bucket workers of size 64x64 ...
0% done (0/225 sample iterations)