diff --git a/testsuite/test_0023/ref/reference.log b/testsuite/test_0023/ref/reference.log index 76590a6c3f..97cfec89e7 100644 --- a/testsuite/test_0023/ref/reference.log +++ b/testsuite/test_0023/ref/reference.log @@ -1,215 +1,216 @@ -00:00:00 86MB | log started Wed Nov 10 12:48:06 2021 -00:00:00 86MB | Arnold 7.0.0.0 [a2efae47] windows clang-10.0.1 oiio-2.3.2 osl-1.12.0 vdb-7.1.1 clm-2.0.0.235 rlm-14.1.3 optix-6.6.0 2021/10/04 11:55:50 -00:00:00 86MB | running on REMS4QL1726, pid=1288 -00:00:00 86MB | 2 x Intel(R) Xeon(R) Gold 5218 CPU @ 2.30GHz (32 cores, 64 logical) with 65154MB -00:00:00 89MB | NVIDIA driver version 442.50 (Optix 60600) -00:00:00 89MB | GPU 0: Quadro RTX 4000 @ 1545MHz (compute 7.5) with 8192MB (6627MB available) (NVLink:0) -00:00:00 89MB | Windows 10 (version 10.0, build 19041) -00:00:00 89MB | soft limit for open files is set at 2048 -00:00:00 89MB | -00:00:00 106MB | [color_manager_ocio] default ocio.config found in C:\arnold\sdk\latest\bin\..\ocio\configs\arnold\config.ocio -00:00:00 106MB | loading plugins from C:\arnold\arnold-usd\build\windows_x86_64\msvc_opt\usd-0.20.11_arnold-7.0.0.0\procedural ... -00:00:00 110MB | usd_proc.dll: usd uses Arnold 7.0.0.0 -00:00:00 110MB | loaded 1 plugins from 1 lib(s) in 0:00.08 -00:00:00 110MB | loading plugins from C:\arnold\sdk\latest\bin\..\plugins ... -00:00:00 110MB | alembic_proc.dll: alembic uses Arnold 7.0.0.0 -00:00:00 110MB | cryptomatte.dll: cryptomatte uses Arnold 7.0.0.0 -00:00:00 110MB | cryptomatte.dll: cryptomatte_filter uses Arnold 7.0.0.0 -00:00:00 110MB | cryptomatte.dll: cryptomatte_manifest_driver uses Arnold 7.0.0.0 -00:00:00 110MB | skipping already loaded plugin: C:\arnold\sdk\latest\bin\..\plugins\usd_proc.dll ... -00:00:00 110MB | loaded 4 plugins from 2 lib(s) in 0:00.01 -00:00:00 110MB | [color_manager_ocio] default ocio.config found in C:\arnold\sdk\latest\bin\..\ocio\configs\arnold\config.ocio -00:00:00 126MB | [kick] command: C:\arnold\sdk\latest\bin\kick test.ass -dw -r 160 120 -sm lambert -bs 16 -o testrender.tif -set driver_tiff.dither false -nocrashpopup -dp -v 6 -00:00:00 126MB | loading plugins from . ... -00:00:00 126MB | no plugins loaded -00:00:00 128MB | [metadata] loading metadata file: test.ass -00:00:00 129MB | [ass] loading test.ass ... -00:00:00 129MB | [ass] read 1762 bytes, 6 nodes in 0:00.00 -00:00:00 129MB | [kick] applying 2 attr value overrides -00:00:00 129MB | -00:00:00 129MB | authorizing with default license managers: rlm, network, user ... -00:00:02 134MB WARNING | rendering with watermarks because of failed authorization: -00:00:02 134MB | [rlm] error initializing license system: -00:00:02 134MB | [rlm] * Can't read license data (-102)No such file or directory (errno: 2) -00:00:02 134MB | [clm.v1] license server was not set (51) -00:00:02 134MB | [clm.v2] SERVICE (7): login requires GUI mode -00:00:02 134MB | environment variables: -00:00:02 134MB | ARNOLD_LICENSE_ORDER = (not set) -00:00:02 134MB | ARNOLD_LICENSE_MANAGER = (not set) -00:00:02 134MB | [rlm] solidangle_LICENSE = (not set) -00:00:02 134MB | [rlm] RLM_LICENSE = (not set) -00:00:02 134MB | [clm] ADSKFLEX_LICENSE_FILE = (not set) -00:00:02 134MB | [clm] LM_LICENSE_FILE = (not set) -00:00:02 134MB | -00:00:02 135MB | [color_manager] using color manager of type "color_manager_ocio" -00:00:02 136MB | [color_manager_ocio] using config file C:\arnold\sdk\latest\bin\..\ocio\configs\arnold\config.ocio -00:00:02 136MB | [color_manager] rendering color space is "ACEScg" -00:00:02 150MB | -00:00:02 150MB | there are 1 light and 2 objects: -00:00:02 150MB | 1 persp_camera -00:00:02 150MB | 1 skydome_light -00:00:02 150MB | 2 utility -00:00:02 150MB | 1 driver_tiff -00:00:02 150MB | 1 gaussian_filter -00:00:02 150MB | 2 list_aggregate -00:00:02 150MB | 2 color_manager_ocio -00:00:02 150MB | 1 usd -00:00:02 150MB | -00:00:02 150MB | rendering image at 160 x 120, 3 AA samples -00:00:02 150MB | AA samples max -00:00:02 150MB | AA sample clamp -00:00:02 150MB | diffuse samples 2 / depth 1 -00:00:02 150MB | specular samples 2 / depth 1 -00:00:02 150MB | transmission samples 2 / depth 8 -00:00:02 150MB | volume indirect -00:00:02 150MB | total depth 10 -00:00:02 150MB | bssrdf samples 2 -00:00:02 150MB | transparency depth 10 -00:00:02 150MB | initializing 9 nodes ... -00:00:03 198MB WARNING | ==== Initializing Usd Reader for procedural usd -00:00:03 203MB | Object /Rocks/Instances (type: PointInstancer) -00:00:03 203MB | Object /Rocks/Instances/Prototypes/Rock_0/mesh_0 (type: Mesh) -00:00:03 205MB | [proc] usd: loaded 503 nodes (501 objects, 2 shaders) -00:00:03 209MB | creating root object list ... -00:00:03 209MB | node initialization done in 0:00.50 (multithreaded) -00:00:03 209MB | updating 513 nodes ... -00:00:03 209MB | dome: skydome_light using 1 sample, 2 volume samples -00:00:03 209MB | scene bounds: (-5.27365208 -5.33104181 -9.12546635) -> (5.32951689 5.33451986 -4.99782372) -00:00:03 209MB | node update done in 0:00.00 (multithreaded) -00:00:03 209MB | [aov] parsing 1 output statements ... -00:00:03 209MB | [aov] registered driver: "mydriver" (driver_tiff) -00:00:03 209MB | [aov] * "RGBA" of type RGBA filtered by "myfilter" (gaussian_filter) -00:00:03 209MB | [aov] done preparing 2 AOVs for 1 output to 1 driver (0 deep AOVs) -00:00:03 210MB | starting 64 bucket workers of size 16x16 ... -00:00:03 217MB | [accel] procedural bvh4_motion done - 0:00.00 - 501 prims, 2 keys -00:00:03 228MB | [accel] polymesh bvh4 done - 0:00.00 (wall time) - 288 prims, 1 key -00:00:03 235MB | 0% done - 89 rays/pixel -00:00:03 240MB | 5% done - 37 rays/pixel -00:00:03 244MB | 10% done - 12 rays/pixel -00:00:03 247MB | 15% done - 18 rays/pixel -00:00:03 248MB | 20% done - 21 rays/pixel -00:00:03 250MB | 25% done - 24 rays/pixel -00:00:03 251MB | 30% done - 17 rays/pixel -00:00:03 251MB | 35% done - 8 rays/pixel -00:00:03 252MB | 40% done - 21 rays/pixel -00:00:03 254MB | 45% done - 18 rays/pixel -00:00:03 261MB | 50% done - 163 rays/pixel -00:00:03 263MB | 55% done - 73 rays/pixel -00:00:03 264MB | 60% done - 24 rays/pixel -00:00:03 265MB | 65% done - 39 rays/pixel -00:00:03 266MB | 70% done - 31 rays/pixel -00:00:03 269MB | 75% done - 63 rays/pixel -00:00:03 271MB | 80% done - 74 rays/pixel -00:00:03 272MB | 85% done - 18 rays/pixel -00:00:03 273MB | 90% done - 14 rays/pixel -00:00:03 274MB | 95% done - 44 rays/pixel -00:00:03 275MB | 100% done - 14 rays/pixel -00:00:03 275MB | render done in 0:00.053 -00:00:03 275MB | [driver_tiff] writing file `testrender.tif' -00:00:03 276MB | render done -00:00:03 276MB | -00:00:03 276MB | ----------------------------------------------------------------------------------- -00:00:03 276MB | scene creation time 0:00.16 machine utilization (0.00%) -00:00:03 276MB | unaccounted 0:00.16 -00:00:03 276MB | ----------------------------------------------------------------------------------- -00:00:03 276MB | frame time 0:03.04 machine utilization (14.47%) -00:00:03 276MB | node init 0:00.50 -00:00:03 276MB | rendering 0:00.05 -00:00:03 276MB | pixel rendering 0:00.04 -00:00:03 276MB | unaccounted 0:02.48 -00:00:03 276MB | ----------------------------------------------------------------------------------- -00:00:03 276MB | top session self-times by category -00:00:03 276MB | InitializeNodes 0:00.46 (88.08%) -00:00:03 276MB | BVH_motion::intersect (usd) 0:00.01 ( 2.53%) -00:00:03 276MB | node_init (usd) 0:00.00 ( 1.47%) -00:00:03 276MB | polymesh::intersect 0:00.00 ( 1.42%) -00:00:03 276MB | surface closure (_default_arnold_shader) 0:00.00 ( 1.24%) -00:00:03 276MB | BVH::intersect 0:00.00 ( 0.93%) -00:00:03 276MB | ----------------------------------------------------------------------------------- -00:00:03 276MB | top session self-times by node -00:00:03 276MB | InitializeNodes 0:00.46 (88.08%) -00:00:03 276MB | usd 0:00.02 ( 4.00%) -00:00:03 276MB | BVH_motion::intersect 0:00.01 ( 2.53%) -00:00:03 276MB | node_init 0:00.00 ( 1.47%) -00:00:03 276MB | standard_surface:_default_arnold_shader 0:00.01 ( 2.34%) -00:00:03 276MB | surface closure 0:00.00 ( 1.24%) -00:00:03 276MB | sampleNextBatch 0:00.00 ( 0.64%) -00:00:03 276MB | accumulateBucketSamples 0:00.00 ( 0.49%) -00:00:03 276MB | TraceCameraRay 0:00.00 ( 0.44%) -00:00:03 276MB | ----------------------------------------------------------------------------------- -00:00:03 276MB | peak CPU memory used 276.50MB -00:00:03 276MB | at startup 89.14MB -00:00:03 276MB | AOV samples 3.04MB -00:00:03 276MB | output buffers 0.33MB -00:00:03 276MB | framebuffers 0.31MB -00:00:03 276MB | node overhead 0.20MB -00:00:03 276MB | instance overhead 0.16MB -00:00:03 276MB | message passing 0.13MB -00:00:03 276MB | memory pools 75.55MB -00:00:03 276MB | geometry 0.01MB -00:00:03 276MB | polymesh 0.01MB -00:00:03 276MB | accel structs 0.08MB -00:00:03 276MB | strings 24.25MB -00:00:03 276MB | profiler 0.05MB -00:00:03 276MB | unaccounted 83.25MB -00:00:03 276MB | ----------------------------------------------------------------------------------- -00:00:03 276MB | ray counts ( /pixel, /sample) (% total) (avg. hits) (max hits) -00:00:03 276MB | camera 192800 ( 10.04, 1.00) ( 26.63%) ( 0.14) ( 1) -00:00:03 276MB | shadow 295752 ( 15.40, 1.53) ( 40.85%) ( 0.27) ( 1) -00:00:03 276MB | diffuse_reflect 130620 ( 6.80, 0.68) ( 18.04%) ( 0.25) ( 1) -00:00:03 276MB | specular_reflect 104879 ( 5.46, 0.54) ( 14.49%) ( 0.28) ( 1) -00:00:03 276MB | total 724051 ( 37.71, 3.76) (100.00%) ( 0.23) ( 1) -00:00:03 276MB | by ray depth: 0 1 2 -00:00:03 276MB | total 55.4% 39.6% 5.0% -00:00:03 276MB | ----------------------------------------------------------------------------------- -00:00:03 276MB | shader calls ( /pixel, /sample) (% total) -00:00:03 276MB | primary 174848 ( 9.11, 0.91) (100.00%) -00:00:03 276MB | total 174848 ( 9.11, 0.91) (100.00%) -00:00:03 276MB | by ray depth: 0 1 2 -00:00:03 276MB | total 30.4% 59.1% 10.5% -00:00:03 276MB | ----------------------------------------------------------------------------------- -00:00:03 276MB | geometry (% hit ) (instances) ( init mem, final mem) -00:00:03 276MB | lists 1 (100.0%) ( 0) ( 0.00, 0.00) -00:00:03 276MB | procs 1 (100.0%) ( 0) ( 0.00, 0.00) -00:00:03 276MB | polymeshes 1 (100.0%) ( 500) ( 0.00, 0.01) -00:00:03 276MB | ----------------------------------------------------------------------------------- -00:00:03 276MB | geometric elements ( min) ( avg.) ( max) -00:00:03 276MB | objects (procs) 501 ( 501) ( 501.0) ( 501) -00:00:03 276MB | polygons 288 ( 288) ( 288.0) ( 288) -00:00:03 276MB | ----------------------------------------------------------------------------------- -00:00:03 276MB | triangle tessellation ( min) ( avg.) ( max) (/ element) (% total) -00:00:03 276MB | polymeshes 528 ( 528) ( 528.0) ( 528) ( 1.83) (100.00%) -00:00:03 276MB | unique triangles 528 -00:00:03 276MB | visible triangles 264000 -00:00:03 276MB | CPU memory use 0.01MB -00:00:03 276MB | vertices 0.00MB -00:00:03 276MB | vertex indices 0.00MB -00:00:03 276MB | packed normals 0.00MB -00:00:03 276MB | normal indices 0.00MB -00:00:03 276MB | uniform indices 0.00MB -00:00:03 276MB | largest polymeshes by triangle count -00:00:03 276MB | 528 tris -- /Rocks/Instances/Prototypes/Rock_0/mesh_0 -00:00:03 276MB | ----------------------------------------------------------------------------------- -00:00:03 276MB | acceleration structures: (% total) -00:00:03 276MB | list 1 ( 33.33%) -00:00:03 276MB | bvh 1 ( 33.33%) -00:00:03 276MB | bvh motion (2 keys) 1 ( 33.33%) -00:00:03 276MB | total 3 (100.00%) -00:00:03 276MB | ----------------------------------------------------------------------------------- -00:00:03 276MB | number of warnings, warning type: -00:00:03 276MB | 1: ==== Initializing Usd Reader for procedural usd -00:00:03 276MB | 1: rendering with watermarks because of failed authorization: -00:00:03 276MB | ----------------------------------------------------------------------------------- -00:00:03 276MB | performance warnings: -00:00:03 276MB WARNING | Rendering CPU utilization was only 14%. Your render may be bound by a single threaded process or I/O. -00:00:03 276MB | ----------------------------------------------------------------------------------- -00:00:03 276MB | -00:00:03 276MB | releasing resources -00:00:03 188MB | -00:00:03 188MB | releasing resources -00:00:03 167MB | unloading 3 plugins -00:00:03 167MB | closing usd_proc.dll ... -00:00:03 167MB | closing alembic_proc.dll ... -00:00:03 167MB | closing cryptomatte.dll ... -00:00:03 167MB | unloading plugins done -00:00:03 167MB | Arnold shutdown +00:00:00 94MB | log started Mon Jan 23 15:07:29 2023 +00:00:00 94MB | Arnold 7.2.0.0 [f99ccc6f] windows x86_64 clang-10.0.1 oiio-2.4.1 osl-1.12.0 vdb-7.1.1 adlsdk-7.4.2.47 clmhub-3.1.1.43 rlm-14.2.5 optix-6.6.0 2023/01/13 17:16:45 +00:00:00 94MB | running on REMS4QL1726, pid=72844 +00:00:00 94MB | 2 x Intel(R) Xeon(R) Gold 5218 CPU @ 2.30GHz (32 cores, 64 logical) with 65154MB +00:00:00 106MB | NVIDIA driver version 511.65 (Optix 60802) +00:00:00 106MB | GPU 0: Quadro RTX 4000 @ 1545MHz (compute 7.5) with 8191MB (5229MB available) (NVLink:0) +00:00:00 106MB | Windows 10 (version 10.0, build 19044) +00:00:00 106MB | soft limit for open files is set at 2048 +00:00:00 106MB | +00:00:00 124MB | [color_manager_ocio] default ocio.config found in C:\arnold\sdk\latest\bin\../ocio/configs/arnold/config.ocio +00:00:00 124MB | loading plugins from C:\arnold\arnold-usd\build\windows_x86_64\msvc_opt\usd-0.22.8_arnold-7.2.0.0\procedural ... +00:00:00 131MB | usd_proc.dll: usd uses Arnold 7.2.0.0 +00:00:00 131MB | loaded 1 plugins from 1 lib(s) in 0:00.09 +00:00:00 131MB | loading plugins from C:\arnold\sdk\latest\bin\..\plugins ... +00:00:00 131MB | alembic_proc.dll: alembic uses Arnold 7.2.0.0 +00:00:00 131MB | cryptomatte.dll: cryptomatte uses Arnold 7.2.0.0 +00:00:00 131MB | cryptomatte.dll: cryptomatte_filter uses Arnold 7.2.0.0 +00:00:00 131MB | cryptomatte.dll: cryptomatte_manifest_driver uses Arnold 7.2.0.0 +00:00:00 131MB | skipping already loaded plugin: C:\arnold\sdk\latest\bin\..\plugins\usd_proc.dll ... +00:00:00 131MB | loaded 4 plugins from 2 lib(s) in 0:00.00 +00:00:00 131MB | [color_manager_ocio] default ocio.config found in C:\arnold\sdk\latest\bin\../ocio/configs/arnold/config.ocio +00:00:00 148MB | [kick] command: C:\arnold\sdk\latest\bin\kick test.ass -dw -r 160 120 -sm lambert -bs 16 -o testrender.tif -set driver_tiff.dither false -nocrashpopup -dp -v 6 +00:00:00 148MB | loading plugins from . ... +00:00:00 148MB | no plugins loaded +00:00:00 148MB | [metadata] loading metadata file: test.ass +00:00:00 148MB | [ass] loading test.ass ... +00:00:00 149MB | [ass] read 1762 bytes, 6 nodes in 0:00.00 +00:00:00 149MB | [kick] applying 2 attr value overrides +00:00:00 149MB | +00:00:00 149MB | authorizing with license manager: network ... +00:00:00 149MB WARNING | rendering with watermarks because of failed authorization: +00:00:00 149MB | [clm.v1] license server was not set (51) +00:00:00 149MB | environment variables: +00:00:00 149MB | ARNOLD_LICENSE_ORDER = (not set) +00:00:00 149MB | ARNOLD_LICENSE_MANAGER = (not set) +00:00:00 149MB | [rlm] solidangle_LICENSE = (not set) +00:00:00 149MB | [rlm] RLM_LICENSE = (not set) +00:00:00 149MB | [clm] ADSKFLEX_LICENSE_FILE = (not set) +00:00:00 149MB | [clm] LM_LICENSE_FILE = (not set) +00:00:00 149MB | +00:00:00 150MB | [color_manager] using color manager of type "color_manager_ocio" +00:00:00 151MB | [color_manager_ocio] using config file C:\arnold\sdk\latest\bin\../ocio/configs/arnold/config.ocio +00:00:00 151MB | [color_manager] rendering color space is "ACEScg" +00:00:00 165MB | +00:00:00 165MB | there are 1 light and 2 objects: +00:00:00 165MB | 1 persp_camera +00:00:00 165MB | 1 skydome_light +00:00:00 165MB | 2 utility +00:00:00 165MB | 1 driver_tiff +00:00:00 165MB | 1 gaussian_filter +00:00:00 165MB | 2 list_aggregate +00:00:00 165MB | 2 color_manager_ocio +00:00:00 165MB | 1 usd +00:00:00 165MB | +00:00:00 165MB | rendering image at 160 x 120, 3 AA samples +00:00:00 165MB | AA samples max +00:00:00 165MB | AA sample clamp +00:00:00 165MB | diffuse samples 2 / depth 1 +00:00:00 165MB | specular samples 2 / depth 1 +00:00:00 165MB | transmission samples 2 / depth 8 +00:00:00 165MB | volume indirect +00:00:00 165MB | total depth 10 +00:00:00 165MB | bssrdf samples 2 +00:00:00 165MB | transparency depth 10 +00:00:00 165MB | initializing 9 nodes +00:00:00 224MB WARNING | ==== Initializing Usd Reader for procedural usd +00:00:00 229MB | Object /Rocks/Instances (type: PointInstancer) +00:00:00 229MB | Object /Rocks/Instances/Prototypes/Rock_0/mesh_0 (type: Mesh) +00:00:00 231MB | [proc] usd: loaded 4 nodes (2 objects, 2 shaders) +00:00:00 231MB | [instancer] /Rocks/Instances: creating 500 instances +00:00:00 231MB | [proc] /Rocks/Instances: loaded 500 nodes (500 objects, 0 shaders) +00:00:00 235MB | creating root object list ... +00:00:00 235MB | node initialization done in 0:00.45 (multithreaded) +00:00:00 235MB | updating 514 nodes +00:00:00 236MB | dome: skydome_light using 1 sample, 2 volume samples +00:00:00 236MB | scene bounds: (-5.27363539 -5.33109903 -9.12547398) -> (5.32954884 5.33463573 -4.99795008) +00:00:00 236MB | node update done in 0:00.00 (multithreaded) +00:00:00 236MB | [aov] parsing 1 output statements ... +00:00:00 236MB | [aov] registered driver: "mydriver" (driver_tiff) +00:00:00 236MB | [aov] * "RGBA" of type RGBA filtered by "myfilter" (gaussian_filter) +00:00:00 236MB | [aov] done preparing 2 AOVs for 1 output to 1 driver (0 deep AOVs) +00:00:00 237MB | starting 64 bucket workers of size 16x16 ... +00:00:00 247MB | [accel] procedural bvh4 done - 0:00.00 (wall time) - 2 prims, 1 key +00:00:00 251MB | 0% done - 79 rays/pixel +00:00:00 251MB | 5% done - 12 rays/pixel +00:00:00 251MB | 10% done - 6 rays/pixel +00:00:00 254MB | [accel] procedural bvh4_motion done - 0:00.00 - 500 prims, 2 keys +00:00:00 256MB | 15% done - 19 rays/pixel +00:00:00 257MB | 20% done - 5 rays/pixel +00:00:00 257MB | 25% done - 4 rays/pixel +00:00:00 258MB | 30% done - 10 rays/pixel +00:00:00 260MB | [accel] polymesh bvh4 done - 0:00.00 (wall time) - 288 prims, 1 key +00:00:00 276MB | 35% done - 12 rays/pixel +00:00:00 279MB | 40% done - 46 rays/pixel +00:00:00 280MB | 45% done - 26 rays/pixel +00:00:00 287MB | 50% done - 160 rays/pixel +00:00:00 289MB | 55% done - 54 rays/pixel +00:00:00 292MB | 60% done - 77 rays/pixel +00:00:00 294MB | 65% done - 54 rays/pixel +00:00:00 296MB | 70% done - 50 rays/pixel +00:00:00 297MB | 75% done - 28 rays/pixel +00:00:00 299MB | 80% done - 58 rays/pixel +00:00:00 300MB | 85% done - 34 rays/pixel +00:00:00 302MB | 90% done - 39 rays/pixel +00:00:00 302MB | 95% done - 12 rays/pixel +00:00:00 303MB | 100% done - 36 rays/pixel +00:00:00 303MB | render done in 0:00.058 +00:00:00 303MB | [driver_tiff] writing file `testrender.tif' +00:00:00 304MB | render done +00:00:00 304MB | +00:00:00 304MB | ----------------------------------------------------------------------------------- +00:00:00 305MB | scene creation time 0:00.15 machine utilization (0.16%) +00:00:00 305MB | unaccounted 0:00.14 +00:00:00 305MB | ----------------------------------------------------------------------------------- +00:00:00 305MB | frame time 0:00.56 machine utilization (74.24%) +00:00:00 305MB | node init 0:00.45 +00:00:00 305MB | driver init/close 0:00.01 +00:00:00 305MB | rendering 0:00.05 +00:00:00 305MB | pixel rendering 0:00.05 +00:00:00 305MB | unaccounted 0:00.03 +00:00:00 305MB | ----------------------------------------------------------------------------------- +00:00:00 305MB | top session self-times by category +00:00:00 305MB | InitializeNodes 0:00.41 (84.88%) +00:00:00 305MB | BVH_motion::intersect (/Rocks/Instances) 0:00.01 ( 2.73%) +00:00:00 305MB | thread blocked 0:00.00 ( 1.98%) +00:00:00 305MB | BVH::intersect 0:00.00 ( 1.91%) +00:00:00 305MB | usd 0:00.00 ( 0.86%) +00:00:00 305MB | polymesh::intersect 0:00.00 ( 1.51%) +00:00:00 305MB | node_init 0:00.00 ( 1.50%) +00:00:00 305MB | usd 0:00.00 ( 1.36%) +00:00:00 305MB | ----------------------------------------------------------------------------------- +00:00:00 305MB | top session self-times by node +00:00:00 305MB | InitializeNodes 0:00.41 (84.88%) +00:00:00 305MB | instancer:/Rocks/Instances 0:00.01 ( 2.83%) +00:00:00 305MB | BVH_motion::intersect 0:00.01 ( 2.73%) +00:00:00 305MB | standard_surface:_default_arnold_shader 0:00.01 ( 2.41%) +00:00:00 305MB | surface closure 0:00.00 ( 1.05%) +00:00:00 305MB | usd 0:00.01 ( 2.26%) +00:00:00 305MB | node_init 0:00.00 ( 1.36%) +00:00:00 305MB | BVH::intersect 0:00.00 ( 0.86%) +00:00:00 305MB | accumulateBucketSamples 0:00.00 ( 0.81%) +00:00:00 305MB | RenderBucket 0:00.00 ( 0.51%) +00:00:00 305MB | ----------------------------------------------------------------------------------- +00:00:00 305MB | peak CPU memory used 304.96MB +00:00:00 305MB | at startup 106.46MB +00:00:00 305MB | AOV samples 2.91MB +00:00:00 305MB | output buffers 0.33MB +00:00:00 305MB | framebuffers 0.31MB +00:00:00 305MB | node overhead 0.20MB +00:00:00 305MB | instance overhead 0.16MB +00:00:00 305MB | message passing 0.13MB +00:00:00 305MB | memory pools 76.05MB +00:00:00 305MB | geometry 0.01MB +00:00:00 305MB | polymesh 0.01MB +00:00:00 305MB | accel structs 0.09MB +00:00:00 305MB | strings 24.25MB +00:00:00 305MB | profiler 0.06MB +00:00:00 305MB | unaccounted 94.00MB +00:00:00 305MB | ----------------------------------------------------------------------------------- +00:00:00 305MB | ray counts ( /pixel, /sample) (% total) (avg. hits) (max hits) +00:00:00 305MB | camera 192800 ( 10.04, 1.00) ( 26.63%) ( 0.14) ( 1) +00:00:00 305MB | shadow 295649 ( 15.40, 1.53) ( 40.84%) ( 0.27) ( 1) +00:00:00 305MB | diffuse_reflect 130596 ( 6.80, 0.68) ( 18.04%) ( 0.25) ( 1) +00:00:00 305MB | specular_reflect 104862 ( 5.46, 0.54) ( 14.49%) ( 0.27) ( 1) +00:00:00 305MB | total 723907 ( 37.70, 3.75) (100.00%) ( 0.23) ( 1) +00:00:00 305MB | by ray depth: 0 1 2 +00:00:00 305MB | total 55.4% 39.6% 5.0% +00:00:00 305MB | ----------------------------------------------------------------------------------- +00:00:00 305MB | shader calls ( /pixel, /sample) (% total) +00:00:00 305MB | primary 174802 ( 9.10, 0.91) (100.00%) +00:00:00 305MB | total 174802 ( 9.10, 0.91) (100.00%) +00:00:00 305MB | by ray depth: 0 1 2 +00:00:00 305MB | total 30.4% 59.1% 10.5% +00:00:00 305MB | ----------------------------------------------------------------------------------- +00:00:00 305MB | geometry (% hit ) (instances) ( init mem, final mem) +00:00:00 305MB | lists 1 (100.0%) ( 0) ( 0.00, 0.00) +00:00:00 305MB | procs 2 (100.0%) ( 0) ( 0.00, 0.00) +00:00:00 305MB | polymeshes 1 (100.0%) ( 500) ( 0.00, 0.01) +00:00:00 305MB | ----------------------------------------------------------------------------------- +00:00:00 305MB | geometric elements ( min) ( avg.) ( max) +00:00:00 305MB | objects (procs) 502 ( 2) ( 251.0) ( 500) +00:00:00 305MB | polygons 288 ( 288) ( 288.0) ( 288) +00:00:00 305MB | ----------------------------------------------------------------------------------- +00:00:00 305MB | triangle tessellation ( min) ( avg.) ( max) (/ element) (% total) +00:00:00 305MB | polymeshes 528 ( 528) ( 528.0) ( 528) ( 1.83) (100.00%) +00:00:00 305MB | unique triangles 528 +00:00:00 305MB | visible triangles 264000 +00:00:00 305MB | CPU memory use 0.01MB +00:00:00 305MB | vertices 0.00MB +00:00:00 305MB | vertex indices 0.00MB +00:00:00 305MB | packed normals 0.00MB +00:00:00 305MB | normal indices 0.00MB +00:00:00 305MB | uniform indices 0.00MB +00:00:00 305MB | largest polymeshes by triangle count +00:00:00 305MB | 528 tris -- /Rocks/Instances/Prototypes/Rock_0/mesh_0 +00:00:00 305MB | ----------------------------------------------------------------------------------- +00:00:00 305MB | acceleration structures: (% total) +00:00:00 305MB | list 1 ( 25.00%) +00:00:00 305MB | bvh 2 ( 50.00%) +00:00:00 305MB | bvh motion (2 keys) 1 ( 25.00%) +00:00:00 305MB | total 4 (100.00%) +00:00:00 305MB | ----------------------------------------------------------------------------------- +00:00:00 305MB | number of warnings, warning type: +00:00:00 305MB | 1: %s +00:00:00 305MB | 1: rendering with watermarks because of failed authorization: +00:00:00 305MB | ----------------------------------------------------------------------------------- +00:00:00 305MB | +00:00:00 305MB | releasing resources +00:00:00 216MB | +00:00:00 216MB | releasing resources +00:00:00 195MB | unloading 3 plugins +00:00:00 195MB | closing usd_proc.dll ... +00:00:00 195MB | closing alembic_proc.dll ... +00:00:00 195MB | closing cryptomatte.dll ... +00:00:00 195MB | unloading plugins done +00:00:00 195MB | Arnold shutdown diff --git a/testsuite/test_0023/ref/reference.tif b/testsuite/test_0023/ref/reference.tif index a448bbf660..c2e42f2200 100644 Binary files a/testsuite/test_0023/ref/reference.tif and b/testsuite/test_0023/ref/reference.tif differ diff --git a/testsuite/test_0024/ref/reference.log b/testsuite/test_0024/ref/reference.log index 872c96d648..6d589f88dc 100644 --- a/testsuite/test_0024/ref/reference.log +++ b/testsuite/test_0024/ref/reference.log @@ -1,280 +1,219 @@ -00:00:00 86MB | log started Wed Nov 10 12:48:27 2021 -00:00:00 86MB | Arnold 7.0.0.0 [a2efae47] windows clang-10.0.1 oiio-2.3.2 osl-1.12.0 vdb-7.1.1 clm-2.0.0.235 rlm-14.1.3 optix-6.6.0 2021/10/04 11:55:50 -00:00:00 86MB | running on REMS4QL1726, pid=14280 -00:00:00 86MB | 2 x Intel(R) Xeon(R) Gold 5218 CPU @ 2.30GHz (32 cores, 64 logical) with 65154MB -00:00:00 89MB | NVIDIA driver version 442.50 (Optix 60600) -00:00:00 89MB | GPU 0: Quadro RTX 4000 @ 1545MHz (compute 7.5) with 8192MB (6627MB available) (NVLink:0) -00:00:00 89MB | Windows 10 (version 10.0, build 19041) -00:00:00 89MB | soft limit for open files is set at 2048 -00:00:00 89MB | -00:00:00 107MB | [color_manager_ocio] default ocio.config found in C:\arnold\sdk\latest\bin\..\ocio\configs\arnold\config.ocio -00:00:00 107MB | loading plugins from C:\arnold\arnold-usd\build\windows_x86_64\msvc_opt\usd-0.20.11_arnold-7.0.0.0\procedural ... -00:00:00 110MB | usd_proc.dll: usd uses Arnold 7.0.0.0 -00:00:00 110MB | loaded 1 plugins from 1 lib(s) in 0:00.09 -00:00:00 110MB | loading plugins from C:\arnold\sdk\latest\bin\..\plugins ... -00:00:00 110MB | alembic_proc.dll: alembic uses Arnold 7.0.0.0 -00:00:00 110MB | cryptomatte.dll: cryptomatte uses Arnold 7.0.0.0 -00:00:00 110MB | cryptomatte.dll: cryptomatte_filter uses Arnold 7.0.0.0 -00:00:00 110MB | cryptomatte.dll: cryptomatte_manifest_driver uses Arnold 7.0.0.0 -00:00:00 110MB | skipping already loaded plugin: C:\arnold\sdk\latest\bin\..\plugins\usd_proc.dll ... -00:00:00 110MB | loaded 4 plugins from 2 lib(s) in 0:00.01 -00:00:00 110MB | [color_manager_ocio] default ocio.config found in C:\arnold\sdk\latest\bin\..\ocio\configs\arnold\config.ocio -00:00:00 126MB | [kick] command: C:\arnold\sdk\latest\bin\kick test.ass -dw -r 160 120 -sm lambert -bs 16 -o testrender.tif -set driver_tiff.dither false -nocrashpopup -dp -v 6 -00:00:00 126MB | loading plugins from . ... -00:00:00 126MB | no plugins loaded -00:00:00 128MB | [metadata] loading metadata file: test.ass -00:00:00 128MB | [ass] loading test.ass ... -00:00:00 129MB | [ass] read 1762 bytes, 6 nodes in 0:00.00 -00:00:00 129MB | [kick] applying 2 attr value overrides -00:00:00 129MB | -00:00:00 129MB | authorizing with default license managers: rlm, network, user ... -00:00:01 135MB WARNING | rendering with watermarks because of failed authorization: -00:00:01 135MB | [rlm] error initializing license system: -00:00:01 135MB | [rlm] * Can't read license data (-102)No such file or directory (errno: 2) -00:00:01 135MB | [clm.v1] license server was not set (51) -00:00:01 135MB | [clm.v2] SERVICE (7): login requires GUI mode -00:00:01 135MB | environment variables: -00:00:01 135MB | ARNOLD_LICENSE_ORDER = (not set) -00:00:01 135MB | ARNOLD_LICENSE_MANAGER = (not set) -00:00:01 135MB | [rlm] solidangle_LICENSE = (not set) -00:00:01 135MB | [rlm] RLM_LICENSE = (not set) -00:00:01 135MB | [clm] ADSKFLEX_LICENSE_FILE = (not set) -00:00:01 135MB | [clm] LM_LICENSE_FILE = (not set) -00:00:01 135MB | -00:00:01 135MB | [color_manager] using color manager of type "color_manager_ocio" -00:00:01 136MB | [color_manager_ocio] using config file C:\arnold\sdk\latest\bin\..\ocio\configs\arnold\config.ocio -00:00:01 136MB | [color_manager] rendering color space is "ACEScg" -00:00:01 150MB | -00:00:01 150MB | there are 1 light and 2 objects: -00:00:01 150MB | 1 persp_camera -00:00:01 150MB | 1 skydome_light -00:00:01 150MB | 2 utility -00:00:01 150MB | 1 driver_tiff -00:00:01 150MB | 1 gaussian_filter -00:00:01 150MB | 2 list_aggregate -00:00:01 150MB | 2 color_manager_ocio -00:00:01 150MB | 1 usd -00:00:01 150MB | -00:00:01 150MB | rendering image at 160 x 120, 3 AA samples -00:00:01 150MB | AA samples max -00:00:01 150MB | AA sample clamp -00:00:01 150MB | diffuse samples 2 / depth 1 -00:00:01 150MB | specular samples 2 / depth 1 -00:00:01 150MB | transmission samples 2 / depth 8 -00:00:01 150MB | volume indirect -00:00:01 150MB | total depth 10 -00:00:01 150MB | bssrdf samples 2 -00:00:01 150MB | transparency depth 10 -00:00:01 150MB | initializing 9 nodes ... -00:00:02 198MB WARNING | ==== Initializing Usd Reader for procedural usd -00:00:02 204MB | Object /Rocks/Instances (type: PointInstancer) -00:00:02 204MB | Object /Rocks/Instances/Prototypes/Rock_0/mesh_0 (type: Mesh) -00:00:02 205MB | [proc] usd: loaded 504 nodes (502 objects, 2 shaders) -00:00:03 206MB | [proc] /Rocks/Instances/Prototypes/Rock_0: loaded 3 nodes (1 objects, 2 shaders) -00:00:03 211MB | creating root object list ... -00:00:03 211MB | node initialization done in 0:01.05 (multithreaded) -00:00:03 211MB | updating 517 nodes ... -00:00:03 211MB | dome: skydome_light using 1 sample, 2 volume samples -00:00:03 211MB | scene bounds: (-5.27365208 -5.33104181 -9.12546635) -> (5.32951689 5.33451986 -4.99782372) -00:00:03 211MB | node update done in 0:00.00 (multithreaded) -00:00:03 211MB | [aov] parsing 1 output statements ... -00:00:03 211MB | [aov] registered driver: "mydriver" (driver_tiff) -00:00:03 211MB | [aov] * "RGBA" of type RGBA filtered by "myfilter" (gaussian_filter) -00:00:03 211MB | [aov] done preparing 2 AOVs for 1 output to 1 driver (0 deep AOVs) -00:00:03 212MB | starting 64 bucket workers of size 16x16 ... -00:00:03 219MB | [accel] procedural bvh4_motion done - 0:00.00 - 502 prims, 2 keys -00:00:03 230MB | [accel] polymesh bvh4 done - 0:00.00 (wall time) - 288 prims, 1 key -00:00:03 238MB | 0% done - 217 rays/pixel -00:00:03 243MB | 5% done - 32 rays/pixel -00:00:03 247MB | 10% done - 8 rays/pixel -00:00:03 249MB | 15% done - 18 rays/pixel -00:00:03 250MB | 20% done - 19 rays/pixel -00:00:03 252MB | 25% done - 26 rays/pixel -00:00:03 253MB | 30% done - 25 rays/pixel -00:00:03 253MB | 35% done - 8 rays/pixel -00:00:03 255MB | 40% done - 33 rays/pixel -00:00:03 256MB | 45% done - 8 rays/pixel -00:00:03 261MB | 50% done - 133 rays/pixel -00:00:03 264MB | 55% done - 91 rays/pixel -00:00:03 265MB | 60% done - 25 rays/pixel -00:00:03 267MB | 65% done - 35 rays/pixel -00:00:03 268MB | 70% done - 26 rays/pixel -00:00:03 271MB | 75% done - 64 rays/pixel -00:00:03 273MB | 80% done - 74 rays/pixel -00:00:03 274MB | 85% done - 27 rays/pixel -00:00:03 276MB | 90% done - 32 rays/pixel -00:00:03 277MB | 95% done - 27 rays/pixel -00:00:03 277MB | 100% done - 18 rays/pixel -00:00:03 277MB | render done in 0:00.056 -00:00:03 277MB | [driver_tiff] writing file `testrender.tif' -00:00:03 278MB | render done -00:00:03 278MB | -00:00:03 278MB | ----------------------------------------------------------------------------------- -00:00:03 278MB | scene creation time 0:00.17 machine utilization (0.14%) -00:00:03 278MB | unaccounted 0:00.17 -00:00:03 278MB | ----------------------------------------------------------------------------------- -00:00:03 278MB | frame time 0:02.91 machine utilization (23.47%) -00:00:03 278MB | node init 0:01.05 -00:00:03 278MB | rendering 0:00.05 -00:00:03 278MB | pixel rendering 0:00.05 -00:00:03 278MB | unaccounted 0:01.79 -00:00:03 278MB | ----------------------------------------------------------------------------------- -00:00:03 278MB | top session self-times by category -00:00:03 278MB | node_init 0:00.55 (51.09%) -00:00:03 278MB | /Rocks/Instances_457 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_395 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_416 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_423 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_438 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_396 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_440 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_441 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_435 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_426 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_398 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances/Prototypes/Rock_0 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_434 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_408 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_407 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_442 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_443 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_422 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_402 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_406 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_420 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_401 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_436 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_415 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_456 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_399 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_419 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_452 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_446 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_425 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_411 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_432 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_427 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_410 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_439 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_455 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_447 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_409 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_444 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_405 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_417 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_404 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_431 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_448 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_445 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_433 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_424 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_397 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_437 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_428 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_418 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_394 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_421 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_449 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_414 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_403 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_400 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_450 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_429 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_454 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_430 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_451 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_453 0:00.00 ( 0.79%) -00:00:03 278MB | /Rocks/Instances_413 0:00.00 ( 0.79%) -00:00:03 278MB | usd 0:00.00 ( 0.72%) -00:00:03 278MB | InitializeNodes 0:00.46 (43.17%) -00:00:03 278MB | RenderBucket 0:00.01 ( 1.57%) -00:00:03 278MB | BVH_motion::intersect (usd) 0:00.01 ( 1.14%) -00:00:03 278MB | polymesh::intersect (/Rocks/Instances/Prototypes/Rock_0/mesh_0) 0:00.00 ( 0.47%) -00:00:03 278MB | BVH::intersect (/Rocks/Instances/Prototypes/Rock_0/mesh_0) 0:00.00 ( 0.42%) -00:00:03 278MB | ----------------------------------------------------------------------------------- -00:00:03 278MB | top session self-times by node -00:00:03 278MB | InitializeNodes 0:00.46 (43.17%) -00:00:03 278MB | usd 0:00.02 ( 1.86%) -00:00:03 278MB | BVH_motion::intersect 0:00.01 ( 1.14%) -00:00:03 278MB | node_init 0:00.00 ( 0.72%) -00:00:03 278MB | RenderBucket 0:00.01 ( 1.57%) -00:00:03 278MB | polymesh:/Rocks/Instances/Prototypes/Rock_0/mesh_0 0:00.01 ( 0.97%) -00:00:03 278MB | usd:/Rocks/Instances_403 (node_init) 0:00.00 ( 0.79%) -00:00:03 278MB | usd:/Rocks/Instances_400 (node_init) 0:00.00 ( 0.79%) -00:00:03 278MB | ----------------------------------------------------------------------------------- -00:00:03 278MB | peak CPU memory used 278.88MB -00:00:03 278MB | at startup 89.38MB -00:00:03 278MB | AOV samples 3.04MB -00:00:03 278MB | output buffers 0.33MB -00:00:03 278MB | framebuffers 0.31MB -00:00:03 278MB | node overhead 0.31MB -00:00:03 278MB | instance overhead 0.20MB -00:00:03 278MB | message passing 0.13MB -00:00:03 278MB | memory pools 76.55MB -00:00:03 278MB | geometry 0.01MB -00:00:03 278MB | polymesh 0.01MB -00:00:03 278MB | accel structs 0.08MB -00:00:03 278MB | strings 24.25MB -00:00:03 278MB | profiler 0.04MB -00:00:03 278MB | unaccounted 84.25MB -00:00:03 278MB | ----------------------------------------------------------------------------------- -00:00:03 278MB | ray counts ( /pixel, /sample) (% total) (avg. hits) (max hits) -00:00:03 278MB | camera 192800 ( 10.04, 1.00) ( 26.63%) ( 0.14) ( 1) -00:00:03 278MB | shadow 295749 ( 15.40, 1.53) ( 40.85%) ( 0.27) ( 1) -00:00:03 278MB | diffuse_reflect 130619 ( 6.80, 0.68) ( 18.04%) ( 0.25) ( 1) -00:00:03 278MB | specular_reflect 104879 ( 5.46, 0.54) ( 14.49%) ( 0.28) ( 1) -00:00:03 278MB | total 724047 ( 37.71, 3.76) (100.00%) ( 0.23) ( 1) -00:00:03 278MB | by ray depth: 0 1 2 -00:00:03 278MB | total 55.4% 39.6% 5.0% -00:00:03 278MB | ----------------------------------------------------------------------------------- -00:00:03 278MB | shader calls ( /pixel, /sample) (% total) -00:00:03 278MB | primary 174844 ( 9.11, 0.91) (100.00%) -00:00:03 278MB | total 174844 ( 9.11, 0.91) (100.00%) -00:00:03 278MB | by ray depth: 0 1 2 -00:00:03 278MB | total 30.4% 59.1% 10.5% -00:00:03 278MB | ----------------------------------------------------------------------------------- -00:00:03 278MB | geometry (% hit ) (instances) ( init mem, final mem) -00:00:03 278MB | lists 1 (100.0%) ( 0) ( 0.00, 0.00) -00:00:03 278MB | procs 2 (100.0%) ( 500) ( 0.00, 0.00) -00:00:03 278MB | polymeshes 2 ( 50.0%) ( 0) ( 0.01, 0.01) -00:00:03 278MB | ----------------------------------------------------------------------------------- -00:00:03 278MB | geometric elements ( min) ( avg.) ( max) -00:00:03 278MB | objects (procs) 503 ( 1) ( 251.5) ( 502) -00:00:03 278MB | polygons 576 ( 288) ( 288.0) ( 288) -00:00:03 278MB | ----------------------------------------------------------------------------------- -00:00:03 278MB | triangle tessellation ( min) ( avg.) ( max) (/ element) (% total) -00:00:03 278MB | polymeshes 528 ( 528) ( 528.0) ( 528) ( 1.83) (100.00%) -00:00:03 278MB | unique triangles 528 -00:00:03 278MB | visible triangles 264000 -00:00:03 278MB | CPU memory use 0.01MB -00:00:03 278MB | vertices 0.00MB -00:00:03 278MB | vertex indices 0.00MB -00:00:03 278MB | packed normals 0.00MB -00:00:03 278MB | normal indices 0.00MB -00:00:03 278MB | uniform indices 0.00MB -00:00:03 278MB | largest polymeshes by triangle count -00:00:03 278MB | 528 tris -- /Rocks/Instances/Prototypes/Rock_0/mesh_0 -00:00:03 278MB | ----------------------------------------------------------------------------------- -00:00:03 278MB | acceleration structures: (% total) -00:00:03 278MB | list 2 ( 50.00%) -00:00:03 278MB | bvh 1 ( 25.00%) -00:00:03 278MB | bvh motion (2 keys) 1 ( 25.00%) -00:00:03 278MB | total 4 (100.00%) -00:00:03 279MB | ----------------------------------------------------------------------------------- -00:00:03 279MB | number of warnings, warning type: -00:00:03 279MB | 1: ==== Initializing Usd Reader for procedural usd -00:00:03 279MB | 1: rendering with watermarks because of failed authorization: -00:00:03 279MB | ----------------------------------------------------------------------------------- -00:00:03 279MB | performance warnings: -00:00:03 279MB WARNING | Rendering CPU utilization was only 23%. Your render may be bound by a single threaded process or I/O. -00:00:03 279MB | ----------------------------------------------------------------------------------- -00:00:03 278MB | -00:00:03 278MB | releasing resources -00:00:03 191MB | -00:00:03 191MB | releasing resources -00:00:03 171MB | unloading 3 plugins -00:00:03 171MB | closing usd_proc.dll ... -00:00:03 171MB | closing alembic_proc.dll ... -00:00:03 171MB | closing cryptomatte.dll ... -00:00:03 171MB | unloading plugins done -00:00:03 171MB | Arnold shutdown +00:00:00 95MB | log started Mon Jan 23 15:07:08 2023 +00:00:00 95MB | Arnold 7.2.0.0 [f99ccc6f] windows x86_64 clang-10.0.1 oiio-2.4.1 osl-1.12.0 vdb-7.1.1 adlsdk-7.4.2.47 clmhub-3.1.1.43 rlm-14.2.5 optix-6.6.0 2023/01/13 17:16:45 +00:00:00 95MB | running on REMS4QL1726, pid=73716 +00:00:00 95MB | 2 x Intel(R) Xeon(R) Gold 5218 CPU @ 2.30GHz (32 cores, 64 logical) with 65154MB +00:00:00 107MB | NVIDIA driver version 511.65 (Optix 60802) +00:00:00 107MB | GPU 0: Quadro RTX 4000 @ 1545MHz (compute 7.5) with 8191MB (5229MB available) (NVLink:0) +00:00:00 107MB | Windows 10 (version 10.0, build 19044) +00:00:00 107MB | soft limit for open files is set at 2048 +00:00:00 107MB | +00:00:00 125MB | [color_manager_ocio] default ocio.config found in C:\arnold\sdk\latest\bin\../ocio/configs/arnold/config.ocio +00:00:00 125MB | loading plugins from C:\arnold\arnold-usd\build\windows_x86_64\msvc_opt\usd-0.22.8_arnold-7.2.0.0\procedural ... +00:00:00 132MB | usd_proc.dll: usd uses Arnold 7.2.0.0 +00:00:00 132MB | loaded 1 plugins from 1 lib(s) in 0:00.13 +00:00:00 132MB | loading plugins from C:\arnold\sdk\latest\bin\..\plugins ... +00:00:00 132MB | alembic_proc.dll: alembic uses Arnold 7.2.0.0 +00:00:00 132MB | cryptomatte.dll: cryptomatte uses Arnold 7.2.0.0 +00:00:00 132MB | cryptomatte.dll: cryptomatte_filter uses Arnold 7.2.0.0 +00:00:00 132MB | cryptomatte.dll: cryptomatte_manifest_driver uses Arnold 7.2.0.0 +00:00:00 132MB | skipping already loaded plugin: C:\arnold\sdk\latest\bin\..\plugins\usd_proc.dll ... +00:00:00 132MB | loaded 4 plugins from 2 lib(s) in 0:00.01 +00:00:00 132MB | [color_manager_ocio] default ocio.config found in C:\arnold\sdk\latest\bin\../ocio/configs/arnold/config.ocio +00:00:00 148MB | [kick] command: C:\arnold\sdk\latest\bin\kick test.ass -dw -r 160 120 -sm lambert -bs 16 -o testrender.tif -set driver_tiff.dither false -nocrashpopup -dp -v 6 +00:00:00 148MB | loading plugins from . ... +00:00:00 148MB | no plugins loaded +00:00:00 148MB | [metadata] loading metadata file: test.ass +00:00:00 149MB | [ass] loading test.ass ... +00:00:00 150MB | [ass] read 1762 bytes, 6 nodes in 0:00.00 +00:00:00 150MB | [kick] applying 2 attr value overrides +00:00:00 150MB | +00:00:00 150MB | authorizing with license manager: network ... +00:00:00 150MB WARNING | rendering with watermarks because of failed authorization: +00:00:00 150MB | [clm.v1] license server was not set (51) +00:00:00 150MB | environment variables: +00:00:00 150MB | ARNOLD_LICENSE_ORDER = (not set) +00:00:00 150MB | ARNOLD_LICENSE_MANAGER = (not set) +00:00:00 150MB | [rlm] solidangle_LICENSE = (not set) +00:00:00 150MB | [rlm] RLM_LICENSE = (not set) +00:00:00 150MB | [clm] ADSKFLEX_LICENSE_FILE = (not set) +00:00:00 150MB | [clm] LM_LICENSE_FILE = (not set) +00:00:00 150MB | +00:00:00 150MB | [color_manager] using color manager of type "color_manager_ocio" +00:00:00 151MB | [color_manager_ocio] using config file C:\arnold\sdk\latest\bin\../ocio/configs/arnold/config.ocio +00:00:00 152MB | [color_manager] rendering color space is "ACEScg" +00:00:00 165MB | +00:00:00 165MB | there are 1 light and 2 objects: +00:00:00 165MB | 1 persp_camera +00:00:00 165MB | 1 skydome_light +00:00:00 165MB | 2 utility +00:00:00 165MB | 1 driver_tiff +00:00:00 165MB | 1 gaussian_filter +00:00:00 165MB | 2 list_aggregate +00:00:00 165MB | 2 color_manager_ocio +00:00:00 165MB | 1 usd +00:00:00 165MB | +00:00:00 165MB | rendering image at 160 x 120, 3 AA samples +00:00:00 165MB | AA samples max +00:00:00 165MB | AA sample clamp +00:00:00 165MB | diffuse samples 2 / depth 1 +00:00:00 165MB | specular samples 2 / depth 1 +00:00:00 165MB | transmission samples 2 / depth 8 +00:00:00 165MB | volume indirect +00:00:00 165MB | total depth 10 +00:00:00 165MB | bssrdf samples 2 +00:00:00 165MB | transparency depth 10 +00:00:00 165MB | initializing 9 nodes +00:00:00 224MB WARNING | ==== Initializing Usd Reader for procedural usd +00:00:00 230MB | Object /Rocks/Instances (type: PointInstancer) +00:00:00 230MB | Object /Rocks/Instances/Prototypes/Rock_0/mesh_0 (type: Mesh) +00:00:00 231MB | [proc] usd: loaded 5 nodes (3 objects, 2 shaders) +00:00:00 232MB | [instancer] /Rocks/Instances: creating 500 instances +00:00:00 232MB | [proc] /Rocks/Instances/Prototypes/Rock_0: loaded 3 nodes (1 objects, 2 shaders) +00:00:00 233MB | [proc] /Rocks/Instances: loaded 500 nodes (500 objects, 0 shaders) +00:00:00 237MB | creating root object list ... +00:00:00 237MB | node initialization done in 0:00.46 (multithreaded) +00:00:00 237MB | updating 518 nodes +00:00:00 237MB | dome: skydome_light using 1 sample, 2 volume samples +00:00:00 237MB | scene bounds: (-5.27363539 -5.33109903 -9.12547398) -> (5.32954884 5.33463573 -4.99795008) +00:00:00 237MB | node update done in 0:00.00 (multithreaded) +00:00:00 237MB | [aov] parsing 1 output statements ... +00:00:00 237MB | [aov] registered driver: "mydriver" (driver_tiff) +00:00:00 237MB | [aov] * "RGBA" of type RGBA filtered by "myfilter" (gaussian_filter) +00:00:00 237MB | [aov] done preparing 2 AOVs for 1 output to 1 driver (0 deep AOVs) +00:00:00 238MB | starting 64 bucket workers of size 16x16 ... +00:00:00 245MB | [accel] procedural bvh4 done - 0:00.00 (wall time) - 3 prims, 1 key +00:00:00 251MB | 0% done - 48 rays/pixel +00:00:00 256MB | [accel] procedural bvh4_motion done - 0:00.00 - 500 prims, 2 keys +00:00:00 257MB | 5% done - 28 rays/pixel +00:00:00 258MB | 10% done - 11 rays/pixel +00:00:00 259MB | [accel] polymesh bvh4 done - 0:00.00 (wall time) - 288 prims, 1 key +00:00:00 268MB | 15% done - 11 rays/pixel +00:00:00 268MB | 20% done - 44 rays/pixel +00:00:00 275MB | 25% done - 1 rays/pixel +00:00:00 279MB | 30% done - 23 rays/pixel +00:00:00 279MB | 35% done - 16 rays/pixel +00:00:00 280MB | 40% done - 2 rays/pixel +00:00:00 287MB | 45% done - 96 rays/pixel +00:00:00 290MB | 50% done - 71 rays/pixel +00:00:00 294MB | 55% done - 86 rays/pixel +00:00:00 296MB | 60% done - 70 rays/pixel +00:00:00 297MB | 65% done - 17 rays/pixel +00:00:00 302MB | 70% done - 117 rays/pixel +00:00:00 303MB | 75% done - 39 rays/pixel +00:00:00 303MB | 80% done - 21 rays/pixel +00:00:00 305MB | 85% done - 49 rays/pixel +00:00:00 305MB | 90% done - 17 rays/pixel +00:00:00 305MB | 95% done - 7 rays/pixel +00:00:00 306MB | 100% done - 18 rays/pixel +00:00:00 306MB | render done in 0:00.060 +00:00:00 306MB | [driver_tiff] writing file `testrender.tif' +00:00:00 307MB | render done +00:00:00 307MB | +00:00:00 307MB | ----------------------------------------------------------------------------------- +00:00:00 307MB | scene creation time 0:00.19 machine utilization (0.00%) +00:00:00 307MB | unaccounted 0:00.18 +00:00:00 307MB | ----------------------------------------------------------------------------------- +00:00:00 307MB | frame time 0:00.57 machine utilization (68.79%) +00:00:00 307MB | node init 0:00.46 +00:00:00 307MB | driver init/close 0:00.01 +00:00:00 307MB | rendering 0:00.06 +00:00:00 307MB | pixel rendering 0:00.05 +00:00:00 307MB | unaccounted 0:00.03 +00:00:00 307MB | ----------------------------------------------------------------------------------- +00:00:00 307MB | top session self-times by category +00:00:00 307MB | InitializeNodes 0:00.43 (84.90%) +00:00:00 307MB | AiMalloc 0:00.02 ( 3.87%) +00:00:00 307MB | BVH_motion::intersect (/Rocks/Instances) 0:00.00 ( 1.90%) +00:00:00 307MB | BVH::intersect 0:00.00 ( 1.85%) +00:00:00 307MB | /Rocks/Instances/Prototypes/Rock_0/mesh_0 0:00.00 ( 1.12%) +00:00:00 307MB | usd 0:00.00 ( 0.72%) +00:00:00 307MB | node_init 0:00.00 ( 1.41%) +00:00:00 307MB | usd 0:00.00 ( 1.36%) +00:00:00 307MB | surface closure (_default_arnold_shader) 0:00.00 ( 1.18%) +00:00:00 307MB | ----------------------------------------------------------------------------------- +00:00:00 307MB | top session self-times by node +00:00:00 307MB | InitializeNodes 0:00.43 (84.90%) +00:00:00 307MB | AiMalloc 0:00.01 ( 2.91%) +00:00:00 307MB | standard_surface:_default_arnold_shader 0:00.01 ( 2.37%) +00:00:00 307MB | surface closure 0:00.00 ( 1.18%) +00:00:00 307MB | polymesh:/Rocks/Instances/Prototypes/Rock_0/mesh_0 0:00.01 ( 2.26%) +00:00:00 307MB | BVH::intersect 0:00.00 ( 1.12%) +00:00:00 307MB | polymesh::intersect 0:00.00 ( 1.09%) +00:00:00 307MB | usd 0:00.01 ( 2.09%) +00:00:00 307MB | node_init 0:00.00 ( 1.36%) +00:00:00 307MB | BVH::intersect 0:00.00 ( 0.72%) +00:00:00 307MB | instancer:/Rocks/Instances (BVH_motion::intersect) 0:00.00 ( 1.90%) +00:00:00 307MB | ----------------------------------------------------------------------------------- +00:00:00 307MB | peak CPU memory used 307.40MB +00:00:00 307MB | at startup 107.41MB +00:00:00 307MB | AOV samples 2.91MB +00:00:00 307MB | output buffers 0.33MB +00:00:00 307MB | framebuffers 0.31MB +00:00:00 307MB | node overhead 0.31MB +00:00:00 307MB | instance overhead 0.20MB +00:00:00 307MB | message passing 0.13MB +00:00:00 307MB | memory pools 76.55MB +00:00:00 307MB | geometry 0.01MB +00:00:00 307MB | polymesh 0.01MB +00:00:00 307MB | accel structs 0.09MB +00:00:00 307MB | strings 24.25MB +00:00:00 307MB | profiler 0.04MB +00:00:00 307MB | unaccounted 94.85MB +00:00:00 307MB | ----------------------------------------------------------------------------------- +00:00:00 307MB | ray counts ( /pixel, /sample) (% total) (avg. hits) (max hits) +00:00:00 307MB | camera 192800 ( 10.04, 1.00) ( 26.63%) ( 0.14) ( 1) +00:00:00 307MB | shadow 295647 ( 15.40, 1.53) ( 40.84%) ( 0.27) ( 1) +00:00:00 307MB | diffuse_reflect 130596 ( 6.80, 0.68) ( 18.04%) ( 0.25) ( 1) +00:00:00 307MB | specular_reflect 104862 ( 5.46, 0.54) ( 14.49%) ( 0.27) ( 1) +00:00:00 307MB | total 723905 ( 37.70, 3.75) (100.00%) ( 0.23) ( 1) +00:00:00 307MB | by ray depth: 0 1 2 +00:00:00 307MB | total 55.4% 39.6% 5.0% +00:00:00 307MB | ----------------------------------------------------------------------------------- +00:00:00 307MB | shader calls ( /pixel, /sample) (% total) +00:00:00 307MB | primary 174798 ( 9.10, 0.91) (100.00%) +00:00:00 307MB | total 174798 ( 9.10, 0.91) (100.00%) +00:00:00 307MB | by ray depth: 0 1 2 +00:00:00 307MB | total 30.4% 59.1% 10.5% +00:00:00 307MB | ----------------------------------------------------------------------------------- +00:00:00 307MB | geometry (% hit ) (instances) ( init mem, final mem) +00:00:00 307MB | lists 1 (100.0%) ( 0) ( 0.00, 0.00) +00:00:00 307MB | procs 3 (100.0%) ( 500) ( 0.00, 0.00) +00:00:00 307MB | polymeshes 2 ( 50.0%) ( 0) ( 0.01, 0.01) +00:00:00 307MB | ----------------------------------------------------------------------------------- +00:00:00 307MB | geometric elements ( min) ( avg.) ( max) +00:00:00 307MB | objects (procs) 504 ( 1) ( 168.0) ( 500) +00:00:00 307MB | polygons 576 ( 288) ( 288.0) ( 288) +00:00:00 307MB | ----------------------------------------------------------------------------------- +00:00:00 307MB | triangle tessellation ( min) ( avg.) ( max) (/ element) (% total) +00:00:00 307MB | polymeshes 528 ( 528) ( 528.0) ( 528) ( 1.83) (100.00%) +00:00:00 307MB | unique triangles 528 +00:00:00 307MB | visible triangles 264000 +00:00:00 307MB | CPU memory use 0.01MB +00:00:00 307MB | vertices 0.00MB +00:00:00 307MB | vertex indices 0.00MB +00:00:00 307MB | packed normals 0.00MB +00:00:00 307MB | normal indices 0.00MB +00:00:00 307MB | uniform indices 0.00MB +00:00:00 307MB | largest polymeshes by triangle count +00:00:00 307MB | 528 tris -- /Rocks/Instances/Prototypes/Rock_0/mesh_0 +00:00:00 307MB | ----------------------------------------------------------------------------------- +00:00:00 307MB | acceleration structures: (% total) +00:00:00 307MB | list 2 ( 40.00%) +00:00:00 307MB | bvh 2 ( 40.00%) +00:00:00 307MB | bvh motion (2 keys) 1 ( 20.00%) +00:00:00 307MB | total 5 (100.00%) +00:00:00 307MB | ----------------------------------------------------------------------------------- +00:00:00 307MB | number of warnings, warning type: +00:00:00 307MB | 1: %s +00:00:00 307MB | 1: rendering with watermarks because of failed authorization: +00:00:00 307MB | ----------------------------------------------------------------------------------- +00:00:00 307MB | +00:00:00 307MB | releasing resources +00:00:00 223MB | +00:00:00 223MB | releasing resources +00:00:00 196MB | unloading 3 plugins +00:00:00 196MB | closing usd_proc.dll ... +00:00:00 196MB | closing alembic_proc.dll ... +00:00:00 196MB | closing cryptomatte.dll ... +00:00:00 196MB | unloading plugins done +00:00:00 196MB | Arnold shutdown diff --git a/testsuite/test_0024/ref/reference.tif b/testsuite/test_0024/ref/reference.tif index 9b14924455..4b0abacc3f 100644 Binary files a/testsuite/test_0024/ref/reference.tif and b/testsuite/test_0024/ref/reference.tif differ diff --git a/testsuite/test_0038/ref/reference.log b/testsuite/test_0038/ref/reference.log index eba4ef9c94..9f8a6b0cd7 100644 --- a/testsuite/test_0038/ref/reference.log +++ b/testsuite/test_0038/ref/reference.log @@ -1,157 +1,166 @@ -00:00:00 72MB | log started Fri Feb 26 18:32:00 2021 -00:00:00 72MB | Arnold 6.2.0.1 [903992ac] windows clang-10.0.1 oiio-2.2.1 osl-1.11.6 vdb-7.1.1 clm-2.0.0.235 rlm-12.4.2 optix-6.6.0 2021/02/09 10:40:42 -00:00:00 72MB | running on REMS4QL1726, pid=22928 -00:00:00 72MB | 2 x Intel(R) Xeon(R) Gold 5218 CPU @ 2.30GHz (32 cores, 64 logical) with 65154MB -00:00:00 72MB | NVIDIA driver version 442.50 (Optix 60600) -00:00:00 72MB | GPU 0: Quadro RTX 4000 @ 1545MHz (compute 7.5) with 8192MB (6550MB available) (NVLink:0) -00:00:00 72MB | Windows 10 (version 10.0, build 19041) -00:00:00 72MB | soft limit for open files raised from 512 to 2048 -00:00:00 72MB | -00:00:00 72MB | loading plugins from C:\arnold\arnold-usd\build\windows_x86_64\msvc_opt\usd-0.20.11_arnold-6.2.0.1\procedural ... -00:00:00 77MB | usd_proc.dll: usd uses Arnold 6.2.0.1 -00:00:00 77MB | loaded 1 plugins from 1 lib(s) in 0:00.08 -00:00:00 77MB | loading plugins from C:\arnold\sdk\6.2.0.1\bin\..\plugins ... -00:00:00 77MB | alembic_proc.dll: alembic uses Arnold 6.2.0.1 -00:00:00 77MB | cryptomatte.dll: cryptomatte uses Arnold 6.2.0.1 -00:00:00 77MB | cryptomatte.dll: cryptomatte_filter uses Arnold 6.2.0.1 -00:00:00 77MB | cryptomatte.dll: cryptomatte_manifest_driver uses Arnold 6.2.0.1 -00:00:00 77MB | skipping already loaded plugin: C:\arnold\sdk\6.2.0.1\bin\..\plugins\usd_proc.dll ... -00:00:00 77MB | loaded 4 plugins from 2 lib(s) in 0:00.00 -00:00:00 78MB | [metadata] loading metadata file: scene.ass -00:00:00 78MB | [ass] loading scene.ass ... -00:00:00 79MB | [ass] read 1629 bytes, 6 nodes in 0:00.00 -00:00:00 79MB ERROR | [ass] can't read in usd_proc.ass: No such file or directory -00:00:00 108MB | -00:00:00 108MB | authorizing with default license managers: rlm, network, user ... -00:00:02 113MB | [network] authorized for "87287ARNOL_2020_0F" in 0:02.38 -00:00:02 113MB | [network] expiration date: permanent, in use: 1/100 -00:00:02 113MB | -00:00:02 114MB | [color_manager] no color manager is active -00:00:02 114MB | [color_manager] rendering color space is "linear" with declared chromaticities: -00:00:02 114MB | r(0.6400, 0.3300) g(0.3000, 0.6000) b(0.1500, 0.0600) and w(0.3127, 0.3290) -00:00:02 128MB | -00:00:02 128MB | there are 1 light and 3 objects: -00:00:02 128MB | 1 persp_camera -00:00:02 128MB | 1 distant_light -00:00:02 128MB | 1 utility -00:00:02 128MB | 1 lambert -00:00:02 128MB | 1 driver_tiff -00:00:02 128MB | 1 gaussian_filter -00:00:02 128MB | 1 polymesh -00:00:02 128MB | 1 box -00:00:02 128MB | 1 list_aggregate -00:00:02 128MB | -00:00:02 128MB | rendering image at 160 x 120, 3 AA samples -00:00:02 128MB | AA samples max -00:00:02 128MB | AA sample clamp -00:00:02 128MB | diffuse samples 2 / depth 1 -00:00:02 128MB | specular samples 2 / depth 1 -00:00:02 128MB | transmission samples 2 / depth 8 -00:00:02 128MB | volume indirect -00:00:02 128MB | total depth 10 -00:00:02 128MB | bssrdf samples 2 -00:00:02 128MB | transparency depth 10 -00:00:02 128MB | initializing 10 nodes ... -00:00:03 147MB | creating root object list ... -00:00:03 147MB | node initialization done in 0:00.33 (multithreaded) -00:00:03 147MB | updating 11 nodes ... -00:00:03 147MB | /directionalLight1/directionalLightShape1: distant_light using 1 sample, 2 volume samples -00:00:03 147MB | scene bounds: (-2.11302805 -1 -2.2288413) -> (1.6560998 1 1.53670919) -00:00:03 147MB | node update done in 0:00.11 (multithreaded) -00:00:03 147MB | [aov] parsing 1 output statements ... -00:00:03 147MB | [aov] registered driver: "defaultArnoldDriver@driver_tiff.RGBA" (driver_tiff) -00:00:03 147MB | [aov] * "RGBA" of type RGBA filtered by "defaultArnoldFilter@gaussian_filter" (gaussian_filter) -00:00:03 147MB | [aov] done preparing 2 AOVs for 1 output to 1 driver (0 deep AOVs) -00:00:03 148MB | starting 64 bucket workers of size 64x64 ... -00:00:03 156MB | [accel] list_aggregate bvh4 done - 0:00.07 (wall time) - 2 prims, 1 key -00:00:03 157MB | [accel] polymesh bvh4 done - 0:00.00 (wall time) - 400 prims, 1 key -00:00:03 157MB | 10% done - 18 rays/pixel -00:00:03 157MB | 20% done - 43 rays/pixel -00:00:03 157MB | 35% done - 14 rays/pixel -00:00:03 157MB | 55% done - 0 rays/pixel -00:00:03 158MB | 75% done - 2 rays/pixel -00:00:03 158MB | 100% done - 1 rays/pixel -00:00:03 158MB | render done in 0:00.399 -00:00:03 158MB | [driver_tiff] writing file `testrender.tif' -00:00:03 158MB | render done -00:00:03 158MB | -00:00:03 158MB | ----------------------------------------------------------------------------------- -00:00:03 158MB | scene creation time 0:00.16 machine utilization (5.90%) -00:00:03 158MB | plugin loading 0:00.08 -00:00:03 158MB | unaccounted 0:00.06 -00:00:03 158MB | ----------------------------------------------------------------------------------- -00:00:03 158MB | frame time 0:03.30 machine utilization (2.26%) -00:00:03 158MB | node init 0:00.44 -00:00:03 158MB | driver init/close 0:00.03 -00:00:03 158MB | rendering 0:00.39 -00:00:03 158MB | accel building 0:00.05 -00:00:03 158MB | pixel rendering 0:00.34 -00:00:03 158MB | unaccounted 0:02.41 -00:00:03 158MB | ----------------------------------------------------------------------------------- -00:00:03 158MB | top session self-times by category -00:00:03 158MB | ----------------------------------------------------------------------------------- -00:00:03 158MB | top session self-times by node -00:00:03 158MB | ----------------------------------------------------------------------------------- -00:00:03 158MB | peak CPU memory used 164.37MB -00:00:03 158MB | at startup 68.62MB -00:00:03 158MB | plugins 5.26MB -00:00:03 158MB | AOV samples 3.93MB -00:00:03 158MB | output buffers 0.54MB -00:00:03 158MB | framebuffers 0.47MB -00:00:03 158MB | node overhead 0.01MB -00:00:03 158MB | message passing 0.13MB -00:00:03 158MB | memory pools 42.05MB -00:00:03 158MB | geometry 0.01MB -00:00:03 158MB | polymesh 0.01MB -00:00:03 158MB | accel structs 0.03MB -00:00:03 158MB | strings 24.25MB -00:00:03 158MB | unaccounted 19.08MB -00:00:03 158MB | ----------------------------------------------------------------------------------- -00:00:03 158MB | ray counts ( /pixel, /sample) (% total) (avg. hits) (max hits) -00:00:03 158MB | camera 178252 ( 9.28, 1.00) (100.00%) ( 0.69) ( 1) -00:00:03 158MB | total 178252 ( 9.28, 1.00) (100.00%) ( 0.69) ( 1) -00:00:03 158MB | by ray depth: 0 -00:00:03 158MB | total 100.0% -00:00:03 158MB | ----------------------------------------------------------------------------------- -00:00:03 158MB | shader calls ( /pixel, /sample) (% total) -00:00:03 158MB | primary 122794 ( 6.40, 0.69) (100.00%) -00:00:03 158MB | total 122794 ( 6.40, 0.69) (100.00%) -00:00:03 158MB | by ray depth: 0 -00:00:03 158MB | total 100.0% -00:00:03 158MB | ----------------------------------------------------------------------------------- -00:00:03 158MB | geometry (% hit ) (instances) ( init mem, final mem) -00:00:03 158MB | lists 1 (100.0%) ( 0) ( 0.00, 0.00) -00:00:03 158MB | polymeshes 1 (100.0%) ( 0) ( 0.01, 0.01) -00:00:03 158MB | simple 1 (100.0%) ( 0) ( 0.00, 0.00) -00:00:03 158MB | ----------------------------------------------------------------------------------- -00:00:03 158MB | geometric elements ( min) ( avg.) ( max) -00:00:03 158MB | polygons 400 ( 400) ( 400.0) ( 400) -00:00:03 158MB | ----------------------------------------------------------------------------------- -00:00:03 158MB | triangle tessellation ( min) ( avg.) ( max) (/ element) (% total) -00:00:03 158MB | polymeshes 760 ( 760) ( 760.0) ( 760) ( 1.90) (100.00%) -00:00:03 158MB | unique triangles 760 -00:00:03 158MB | CPU memory use 0.01MB -00:00:03 158MB | vertices 0.00MB -00:00:03 158MB | vertex indices 0.00MB -00:00:03 158MB | uniform indices 0.00MB -00:00:03 158MB | largest polymeshes by triangle count -00:00:03 158MB | 760 tris -- /pSphere1/pSphereShape1 -00:00:03 158MB | ----------------------------------------------------------------------------------- -00:00:03 158MB | acceleration structures: (% total) -00:00:03 158MB | bvh 2 (100.00%) -00:00:03 158MB | total 2 (100.00%) -00:00:03 158MB | ----------------------------------------------------------------------------------- -00:00:03 158MB | number of errors, error type: -00:00:03 158MB | 1: %s%s: %s -00:00:03 158MB | ----------------------------------------------------------------------------------- -00:00:03 158MB | performance warnings: -00:00:03 158MB WARNING | Rendering CPU utilization was only 2%. Your render may be bound by a single threaded process or I/O. -00:00:03 158MB | ----------------------------------------------------------------------------------- -00:00:03 158MB | -00:00:03 158MB | releasing resources -00:00:03 118MB | unloading 3 plugins -00:00:03 118MB | closing usd_proc.dll ... -00:00:03 118MB | closing alembic_proc.dll ... -00:00:03 118MB | closing cryptomatte.dll ... -00:00:03 118MB | unloading plugins done -00:00:03 118MB | Arnold shutdown +00:00:00 116MB | log started Mon Jan 23 15:06:27 2023 +00:00:00 116MB | Arnold 7.2.0.0 [f99ccc6f] windows x86_64 clang-10.0.1 oiio-2.4.1 osl-1.12.0 vdb-7.1.1 adlsdk-7.4.2.47 clmhub-3.1.1.43 rlm-14.2.5 optix-6.6.0 2023/01/13 17:16:45 +00:00:00 116MB | running on REMS4QL1726, pid=90488 +00:00:00 116MB | 2 x Intel(R) Xeon(R) Gold 5218 CPU @ 2.30GHz (32 cores, 64 logical) with 65154MB +00:00:00 116MB | NVIDIA driver version 511.65 (Optix 60802) +00:00:00 116MB | GPU 0: Quadro RTX 4000 @ 1545MHz (compute 7.5) with 8191MB (5229MB available) (NVLink:0) +00:00:00 116MB | Windows 10 (version 10.0, build 19044) +00:00:00 116MB | soft limit for open files changed from 512 to 2048 +00:00:00 116MB | +00:00:00 116MB | [color_manager_ocio] default ocio.config found in C:\arnold\sdk\latest\bin\../ocio/configs/arnold/config.ocio +00:00:00 116MB | loading plugins from C:\arnold\arnold-usd\build\windows_x86_64\msvc_opt\usd-0.22.8_arnold-7.2.0.0\procedural ... +00:00:00 122MB | usd_proc.dll: usd uses Arnold 7.2.0.0 +00:00:00 123MB | loaded 1 plugins from 1 lib(s) in 0:00.10 +00:00:00 123MB | loading plugins from C:\arnold\sdk\latest\bin\..\plugins ... +00:00:00 123MB | alembic_proc.dll: alembic uses Arnold 7.2.0.0 +00:00:00 123MB | cryptomatte.dll: cryptomatte uses Arnold 7.2.0.0 +00:00:00 123MB | cryptomatte.dll: cryptomatte_filter uses Arnold 7.2.0.0 +00:00:00 123MB | cryptomatte.dll: cryptomatte_manifest_driver uses Arnold 7.2.0.0 +00:00:00 123MB | skipping already loaded plugin: C:\arnold\sdk\latest\bin\..\plugins\usd_proc.dll ... +00:00:00 123MB | loaded 4 plugins from 2 lib(s) in 0:00.00 +00:00:00 145MB | [color_manager_ocio] default ocio.config found in C:\arnold\sdk\latest\bin\../ocio/configs/arnold/config.ocio +00:00:00 130MB | [metadata] loading metadata file: scene.ass +00:00:00 131MB | [ass] loading scene.ass ... +00:00:00 132MB | [ass] read 1629 bytes, 6 nodes in 0:00.00 +00:00:00 132MB ERROR | [ass] can't read in usd_proc.ass: No such file or directory +00:00:00 167MB | +00:00:00 167MB | authorizing with license manager: network ... +00:00:00 167MB WARNING | rendering with watermarks because of failed authorization: +00:00:00 167MB | [clm.v1] license server was not set (51) +00:00:00 167MB | environment variables: +00:00:00 167MB | ARNOLD_LICENSE_ORDER = (not set) +00:00:00 167MB | ARNOLD_LICENSE_MANAGER = (not set) +00:00:00 167MB | [rlm] solidangle_LICENSE = (not set) +00:00:00 167MB | [rlm] RLM_LICENSE = (not set) +00:00:00 167MB | [clm] ADSKFLEX_LICENSE_FILE = (not set) +00:00:00 167MB | [clm] LM_LICENSE_FILE = (not set) +00:00:00 167MB | +00:00:00 167MB | [color_manager] using color manager of type "color_manager_ocio" +00:00:00 168MB | [color_manager_ocio] using config file C:\arnold\sdk\latest\bin\../ocio/configs/arnold/config.ocio +00:00:00 168MB | [color_manager] rendering color space is "ACEScg" +00:00:00 182MB | +00:00:00 182MB | there are 1 light and 3 objects: +00:00:00 182MB | 1 persp_camera +00:00:00 182MB | 1 distant_light +00:00:00 182MB | 1 utility +00:00:00 182MB | 1 lambert +00:00:00 182MB | 1 driver_tiff +00:00:00 182MB | 1 gaussian_filter +00:00:00 182MB | 1 polymesh +00:00:00 182MB | 1 box +00:00:00 182MB | 1 list_aggregate +00:00:00 182MB | 1 color_manager_ocio +00:00:00 182MB | +00:00:00 182MB | rendering image at 160 x 120, 3 AA samples +00:00:00 182MB | AA samples max +00:00:00 182MB | AA sample clamp +00:00:00 182MB | diffuse samples 2 / depth 1 +00:00:00 182MB | specular samples 2 / depth 1 +00:00:00 182MB | transmission samples 2 / depth 8 +00:00:00 182MB | volume indirect +00:00:00 182MB | total depth 10 +00:00:00 182MB | bssrdf samples 2 +00:00:00 182MB | transparency depth 10 +00:00:00 182MB | initializing 11 nodes +00:00:00 182MB | creating root object list ... +00:00:00 182MB | node initialization done in 0:00.00 (multithreaded) +00:00:00 182MB | updating 12 nodes +00:00:00 183MB | /directionalLight1/directionalLightShape1: distant_light using 1 sample, 2 volume samples +00:00:00 183MB | scene bounds: (-2.11302805 -1 -2.2288413) -> (1.6560998 1 1.53670919) +00:00:00 183MB | node update done in 0:00.00 (multithreaded) +00:00:00 183MB | [aov] parsing 1 output statements ... +00:00:00 183MB | [aov] registered driver: "defaultArnoldDriver@driver_tiff.RGBA" (driver_tiff) +00:00:00 183MB | [aov] * "RGBA" of type RGBA filtered by "defaultArnoldFilter@gaussian_filter" (gaussian_filter) +00:00:00 183MB | [aov] done preparing 2 AOVs for 1 output to 1 driver (0 deep AOVs) +00:00:00 186MB | starting 64 bucket workers of size 64x64 ... +00:00:00 194MB | [accel] list_aggregate bvh4 done - 0:00.00 (wall time) - 2 prims, 1 key +00:00:00 195MB | [accel] polymesh bvh4 done - 0:00.00 (wall time) - 400 prims, 1 key +00:00:00 234MB | 10% done - 47 rays/pixel +00:00:00 247MB | 20% done - 23 rays/pixel +00:00:00 248MB | 35% done - 7 rays/pixel +00:00:00 248MB | 60% done - 1 rays/pixel +00:00:00 248MB | 75% done - 1 rays/pixel +00:00:00 248MB | 100% done - 2 rays/pixel +00:00:00 248MB | render done in 0:00.065 +00:00:00 248MB | [driver_tiff] writing file `testrender.tif' +00:00:00 249MB | render done +00:00:00 249MB | +00:00:00 249MB | ----------------------------------------------------------------------------------- +00:00:00 249MB | scene creation time 0:00.50 machine utilization (3.55%) +00:00:00 249MB | plugin loading 0:00.11 +00:00:00 249MB | unaccounted 0:00.39 +00:00:00 249MB | ----------------------------------------------------------------------------------- +00:00:00 249MB | frame time 0:00.12 machine utilization (32.86%) +00:00:00 249MB | driver init/close 0:00.01 +00:00:00 249MB | rendering 0:00.06 +00:00:00 249MB | pixel rendering 0:00.06 +00:00:00 249MB | unaccounted 0:00.03 +00:00:00 249MB | ----------------------------------------------------------------------------------- +00:00:00 249MB | top session self-times by category +00:00:00 249MB | ----------------------------------------------------------------------------------- +00:00:00 249MB | top session self-times by node +00:00:00 249MB | ----------------------------------------------------------------------------------- +00:00:00 249MB | peak CPU memory used 249.71MB +00:00:00 249MB | at startup 65.74MB +00:00:00 249MB | plugins 6.60MB +00:00:00 249MB | AOV samples 3.02MB +00:00:00 249MB | output buffers 0.45MB +00:00:00 249MB | framebuffers 0.38MB +00:00:00 249MB | node overhead 0.00MB +00:00:00 249MB | message passing 0.13MB +00:00:00 249MB | memory pools 63.55MB +00:00:00 249MB | geometry 0.01MB +00:00:00 249MB | polymesh 0.01MB +00:00:00 249MB | accel structs 0.03MB +00:00:00 249MB | strings 24.25MB +00:00:00 249MB | unaccounted 85.56MB +00:00:00 249MB | ----------------------------------------------------------------------------------- +00:00:00 249MB | ray counts ( /pixel, /sample) (% total) (avg. hits) (max hits) +00:00:00 249MB | camera 178252 ( 9.28, 1.00) (100.00%) ( 0.69) ( 1) +00:00:00 249MB | total 178252 ( 9.28, 1.00) (100.00%) ( 0.69) ( 1) +00:00:00 249MB | by ray depth: 0 +00:00:00 249MB | total 100.0% +00:00:00 249MB | ----------------------------------------------------------------------------------- +00:00:00 249MB | shader calls ( /pixel, /sample) (% total) +00:00:00 249MB | primary 122794 ( 6.40, 0.69) (100.00%) +00:00:00 249MB | total 122794 ( 6.40, 0.69) (100.00%) +00:00:00 249MB | by ray depth: 0 +00:00:00 249MB | total 100.0% +00:00:00 249MB | ----------------------------------------------------------------------------------- +00:00:00 249MB | geometry (% hit ) (instances) ( init mem, final mem) +00:00:00 249MB | lists 1 (100.0%) ( 0) ( 0.00, 0.00) +00:00:00 249MB | polymeshes 1 (100.0%) ( 0) ( 0.01, 0.01) +00:00:00 249MB | simple 1 (100.0%) ( 0) ( 0.00, 0.00) +00:00:00 249MB | ----------------------------------------------------------------------------------- +00:00:00 249MB | geometric elements ( min) ( avg.) ( max) +00:00:00 249MB | polygons 400 ( 400) ( 400.0) ( 400) +00:00:00 249MB | ----------------------------------------------------------------------------------- +00:00:00 249MB | triangle tessellation ( min) ( avg.) ( max) (/ element) (% total) +00:00:00 249MB | polymeshes 760 ( 760) ( 760.0) ( 760) ( 1.90) (100.00%) +00:00:00 249MB | unique triangles 760 +00:00:00 249MB | CPU memory use 0.01MB +00:00:00 249MB | vertices 0.00MB +00:00:00 249MB | vertex indices 0.00MB +00:00:00 249MB | packed normals 0.00MB +00:00:00 249MB | normal indices 0.00MB +00:00:00 249MB | uniform indices 0.00MB +00:00:00 249MB | largest polymeshes by triangle count +00:00:00 249MB | 760 tris -- /pSphere1/pSphereShape1 +00:00:00 249MB | ----------------------------------------------------------------------------------- +00:00:00 249MB | acceleration structures: (% total) +00:00:00 249MB | bvh 2 (100.00%) +00:00:00 249MB | total 2 (100.00%) +00:00:00 249MB | ----------------------------------------------------------------------------------- +00:00:00 249MB | number of errors, error type: +00:00:00 249MB | 1: %s%s: %s +00:00:00 249MB | number of warnings, warning type: +00:00:00 249MB | 1: rendering with watermarks because of failed authorization: +00:00:00 249MB | ----------------------------------------------------------------------------------- +00:00:00 249MB | +00:00:00 249MB | releasing resources +00:00:00 186MB | unloading 3 plugins +00:00:00 186MB | closing usd_proc.dll ... +00:00:00 186MB | closing alembic_proc.dll ... +00:00:00 186MB | closing cryptomatte.dll ... +00:00:00 186MB | unloading plugins done +00:00:00 186MB | Arnold shutdown diff --git a/testsuite/test_0038/ref/reference.tif b/testsuite/test_0038/ref/reference.tif index 89245966ad..98cd6d0d78 100644 Binary files a/testsuite/test_0038/ref/reference.tif and b/testsuite/test_0038/ref/reference.tif differ diff --git a/testsuite/test_0142/ref/reference.log b/testsuite/test_0142/ref/reference.log index 68fc5e736e..5765054a85 100644 --- a/testsuite/test_0142/ref/reference.log +++ b/testsuite/test_0142/ref/reference.log @@ -1,151 +1,161 @@ -00:00:00 72MB | log started Fri Feb 26 18:31:35 2021 -00:00:00 72MB | Arnold 6.2.0.1 [903992ac] windows clang-10.0.1 oiio-2.2.1 osl-1.11.6 vdb-7.1.1 clm-2.0.0.235 rlm-12.4.2 optix-6.6.0 2021/02/09 10:40:42 -00:00:00 72MB | running on REMS4QL1726, pid=24280 -00:00:00 72MB | 2 x Intel(R) Xeon(R) Gold 5218 CPU @ 2.30GHz (32 cores, 64 logical) with 65154MB -00:00:00 72MB | NVIDIA driver version 442.50 (Optix 60600) -00:00:00 72MB | GPU 0: Quadro RTX 4000 @ 1545MHz (compute 7.5) with 8192MB (6593MB available) (NVLink:0) -00:00:00 72MB | Windows 10 (version 10.0, build 19041) -00:00:00 72MB | soft limit for open files raised from 512 to 2048 -00:00:00 72MB | -00:00:00 72MB | loading plugins from C:\arnold\arnold-usd\build\windows_x86_64\msvc_opt\usd-0.20.11_arnold-6.2.0.1\procedural ... -00:00:00 77MB | usd_proc.dll: usd uses Arnold 6.2.0.1 -00:00:00 77MB | loaded 1 plugins from 1 lib(s) in 0:00.08 -00:00:00 77MB | loading plugins from C:\arnold\sdk\6.2.0.1\bin\..\plugins ... -00:00:00 77MB | alembic_proc.dll: alembic uses Arnold 6.2.0.1 -00:00:00 77MB | cryptomatte.dll: cryptomatte uses Arnold 6.2.0.1 -00:00:00 77MB | cryptomatte.dll: cryptomatte_filter uses Arnold 6.2.0.1 -00:00:00 77MB | cryptomatte.dll: cryptomatte_manifest_driver uses Arnold 6.2.0.1 -00:00:00 77MB | skipping already loaded plugin: C:\arnold\sdk\6.2.0.1\bin\..\plugins\usd_proc.dll ... -00:00:00 77MB | loaded 4 plugins from 2 lib(s) in 0:00.00 -00:00:00 77MB | [metadata] loading metadata file: scene.ass -00:00:00 78MB | [ass] loading scene.ass ... -00:00:00 79MB | [ass] read 1629 bytes, 6 nodes in 0:00.02 -00:00:00 108MB | -00:00:00 108MB | authorizing with default license managers: rlm, network, user ... -00:00:02 113MB | [network] authorized for "87287ARNOL_2020_0F" in 0:01.61 -00:00:02 113MB | [network] expiration date: permanent, in use: 1/100 -00:00:02 113MB | -00:00:02 126MB | [color_manager] no color manager is active -00:00:02 127MB | [color_manager] rendering color space is "linear" with declared chromaticities: -00:00:02 127MB | r(0.6400, 0.3300) g(0.3000, 0.6000) b(0.1500, 0.0600) and w(0.3127, 0.3290) -00:00:02 149MB | -00:00:02 149MB | there are 1 light and 2 objects: -00:00:02 149MB | 1 persp_camera -00:00:02 149MB | 1 distant_light -00:00:02 149MB | 1 utility -00:00:02 149MB | 1 lambert -00:00:02 149MB | 1 driver_tiff -00:00:02 149MB | 1 gaussian_filter -00:00:02 149MB | 1 polymesh -00:00:02 149MB | 1 list_aggregate -00:00:02 149MB | -00:00:02 149MB | rendering image at 160 x 120, 3 AA samples -00:00:02 149MB | AA samples max -00:00:02 149MB | AA sample clamp -00:00:02 149MB | diffuse samples 2 / depth 1 -00:00:02 149MB | specular samples 2 / depth 1 -00:00:02 149MB | transmission samples 2 / depth 8 -00:00:02 149MB | volume indirect -00:00:02 149MB | total depth 10 -00:00:02 149MB | bssrdf samples 2 -00:00:02 149MB | transparency depth 10 -00:00:02 149MB | initializing 9 nodes ... -00:00:02 149MB | creating root object list ... -00:00:02 149MB | node initialization done in 0:00.01 (multithreaded) -00:00:02 149MB | updating 10 nodes ... -00:00:02 149MB | /directionalLight1/directionalLightShape1: distant_light using 1 sample, 2 volume samples -00:00:02 149MB | scene bounds: (-0.5 -0.5 -0.5) -> (0.5 0.5 0.5) -00:00:02 149MB | node update done in 0:00.00 (multithreaded) -00:00:02 149MB | [aov] parsing 1 output statements ... -00:00:02 149MB | [aov] registered driver: "defaultArnoldDriver@driver_tiff.RGBA" (driver_tiff) -00:00:02 149MB | [aov] * "RGBA" of type RGBA filtered by "defaultArnoldFilter@gaussian_filter" (gaussian_filter) -00:00:02 149MB | [aov] done preparing 2 AOVs for 1 output to 1 driver (0 deep AOVs) -00:00:02 150MB | starting 64 bucket workers of size 64x64 ... -00:00:02 155MB | [accel] polymesh bvh4 done - 0:00.00 (wall time) - 6 prims, 1 key -00:00:02 158MB | 10% done - 42 rays/pixel -00:00:02 158MB | 30% done - 5 rays/pixel -00:00:02 158MB | 50% done - 0 rays/pixel -00:00:02 158MB | 70% done - 12 rays/pixel -00:00:02 158MB | 80% done - 7 rays/pixel -00:00:02 158MB | 100% done - 5 rays/pixel -00:00:02 158MB | render done in 0:00.314 -00:00:02 158MB | [driver_tiff] writing file `testrender.tif' -00:00:02 159MB | render done -00:00:02 159MB | -00:00:02 159MB | ----------------------------------------------------------------------------------- -00:00:02 159MB | scene creation time 0:00.19 machine utilization (0.88%) -00:00:02 159MB | plugin loading 0:00.09 -00:00:02 159MB | ass parsing 0:00.02 -00:00:02 159MB | unaccounted 0:00.07 -00:00:02 159MB | ----------------------------------------------------------------------------------- -00:00:02 159MB | frame time 0:02.11 machine utilization (7.05%) -00:00:02 159MB | node init 0:00.01 -00:00:02 159MB | driver init/close 0:00.01 -00:00:02 159MB | rendering 0:00.31 -00:00:02 159MB | pixel rendering 0:00.31 -00:00:02 159MB | unaccounted 0:01.76 -00:00:02 159MB | ----------------------------------------------------------------------------------- -00:00:02 159MB | top session self-times by category -00:00:02 159MB | ----------------------------------------------------------------------------------- -00:00:02 159MB | top session self-times by node -00:00:02 159MB | ----------------------------------------------------------------------------------- -00:00:02 159MB | peak CPU memory used 162.91MB -00:00:02 159MB | at startup 68.58MB -00:00:02 159MB | plugins 5.25MB -00:00:02 159MB | AOV samples 3.93MB -00:00:02 159MB | output buffers 0.54MB -00:00:02 159MB | framebuffers 0.47MB -00:00:02 159MB | node overhead 0.01MB -00:00:02 159MB | message passing 0.13MB -00:00:02 159MB | memory pools 42.05MB -00:00:02 159MB | geometry 0.00MB -00:00:02 159MB | polymesh 0.00MB -00:00:02 159MB | accel structs 0.00MB -00:00:02 159MB | strings 24.25MB -00:00:02 159MB | unaccounted 17.71MB -00:00:02 159MB | ----------------------------------------------------------------------------------- -00:00:02 159MB | ray counts ( /pixel, /sample) (% total) (avg. hits) (max hits) -00:00:02 159MB | camera 178252 ( 9.28, 1.00) (100.00%) ( 0.14) ( 1) -00:00:02 159MB | total 178252 ( 9.28, 1.00) (100.00%) ( 0.14) ( 1) -00:00:02 159MB | by ray depth: 0 -00:00:02 159MB | total 100.0% -00:00:02 159MB | ----------------------------------------------------------------------------------- -00:00:02 159MB | shader calls ( /pixel, /sample) (% total) -00:00:02 159MB | primary 24692 ( 1.29, 0.14) (100.00%) -00:00:02 159MB | total 24692 ( 1.29, 0.14) (100.00%) -00:00:02 159MB | by ray depth: 0 -00:00:02 159MB | total 100.0% -00:00:02 159MB | ----------------------------------------------------------------------------------- -00:00:02 159MB | geometry (% hit ) (instances) ( init mem, final mem) -00:00:02 159MB | lists 1 (100.0%) ( 0) ( 0.00, 0.00) -00:00:02 159MB | polymeshes 1 (100.0%) ( 0) ( 0.00, 0.00) -00:00:02 159MB | ----------------------------------------------------------------------------------- -00:00:02 159MB | geometric elements ( min) ( avg.) ( max) -00:00:02 159MB | polygons 6 ( 6) ( 6.0) ( 6) -00:00:02 159MB | ----------------------------------------------------------------------------------- -00:00:02 159MB | triangle tessellation ( min) ( avg.) ( max) (/ element) (% total) -00:00:02 159MB | polymeshes 12 ( 12) ( 12.0) ( 12) ( 2.00) (100.00%) -00:00:02 159MB | unique triangles 12 -00:00:02 159MB | CPU memory use 0.00MB -00:00:02 159MB | vertices 0.00MB -00:00:02 159MB | vertex indices 0.00MB -00:00:02 159MB | uniform indices 0.00MB -00:00:02 159MB | largest polymeshes by triangle count -00:00:02 159MB | 12 tris -- /pCube1/pCubeShape1 -00:00:02 159MB | ----------------------------------------------------------------------------------- -00:00:02 159MB | acceleration structures: (% total) -00:00:02 159MB | list 1 ( 50.00%) -00:00:02 159MB | bvh 1 ( 50.00%) -00:00:02 159MB | total 2 (100.00%) -00:00:02 159MB | ----------------------------------------------------------------------------------- -00:00:02 159MB | performance warnings: -00:00:02 159MB WARNING | Rendering CPU utilization was only 7%. Your render may be bound by a single threaded process or I/O. -00:00:02 159MB | ----------------------------------------------------------------------------------- -00:00:02 159MB | -00:00:02 159MB | releasing resources -00:00:02 118MB | unloading 3 plugins -00:00:02 118MB | closing usd_proc.dll ... -00:00:02 118MB | closing alembic_proc.dll ... -00:00:02 118MB | closing cryptomatte.dll ... -00:00:02 118MB | unloading plugins done -00:00:02 118MB | Arnold shutdown +00:00:00 116MB | log started Mon Jan 23 15:05:20 2023 +00:00:00 116MB | Arnold 7.2.0.0 [f99ccc6f] windows x86_64 clang-10.0.1 oiio-2.4.1 osl-1.12.0 vdb-7.1.1 adlsdk-7.4.2.47 clmhub-3.1.1.43 rlm-14.2.5 optix-6.6.0 2023/01/13 17:16:45 +00:00:00 116MB | running on REMS4QL1726, pid=78004 +00:00:00 116MB | 2 x Intel(R) Xeon(R) Gold 5218 CPU @ 2.30GHz (32 cores, 64 logical) with 65154MB +00:00:00 116MB | NVIDIA driver version 511.65 (Optix 60802) +00:00:00 116MB | GPU 0: Quadro RTX 4000 @ 1545MHz (compute 7.5) with 8191MB (5011MB available) (NVLink:0) +00:00:00 116MB | Windows 10 (version 10.0, build 19044) +00:00:00 116MB | soft limit for open files changed from 512 to 2048 +00:00:00 116MB | +00:00:00 116MB | [color_manager_ocio] default ocio.config found in C:\arnold\sdk\latest\bin\../ocio/configs/arnold/config.ocio +00:00:00 116MB | loading plugins from C:\arnold\arnold-usd\build\windows_x86_64\msvc_opt\usd-0.22.8_arnold-7.2.0.0\procedural ... +00:00:00 123MB | usd_proc.dll: usd uses Arnold 7.2.0.0 +00:00:00 123MB | loaded 1 plugins from 1 lib(s) in 0:00.09 +00:00:00 123MB | loading plugins from C:\arnold\sdk\latest\bin\..\plugins ... +00:00:00 123MB | alembic_proc.dll: alembic uses Arnold 7.2.0.0 +00:00:00 123MB | cryptomatte.dll: cryptomatte uses Arnold 7.2.0.0 +00:00:00 123MB | cryptomatte.dll: cryptomatte_filter uses Arnold 7.2.0.0 +00:00:00 123MB | cryptomatte.dll: cryptomatte_manifest_driver uses Arnold 7.2.0.0 +00:00:00 123MB | skipping already loaded plugin: C:\arnold\sdk\latest\bin\..\plugins\usd_proc.dll ... +00:00:00 123MB | loaded 4 plugins from 2 lib(s) in 0:00.00 +00:00:00 130MB | [metadata] loading metadata file: scene.ass +00:00:00 131MB | [ass] loading scene.ass ... +00:00:00 132MB | [ass] read 1629 bytes, 6 nodes in 0:00.00 +00:00:00 132MB | [color_manager_ocio] default ocio.config found in C:\arnold\sdk\latest\bin\../ocio/configs/arnold/config.ocio +00:00:00 167MB | +00:00:00 167MB | authorizing with license manager: network ... +00:00:00 167MB WARNING | rendering with watermarks because of failed authorization: +00:00:00 167MB | [clm.v1] license server was not set (51) +00:00:00 167MB | environment variables: +00:00:00 167MB | ARNOLD_LICENSE_ORDER = (not set) +00:00:00 167MB | ARNOLD_LICENSE_MANAGER = (not set) +00:00:00 167MB | [rlm] solidangle_LICENSE = (not set) +00:00:00 167MB | [rlm] RLM_LICENSE = (not set) +00:00:00 167MB | [clm] ADSKFLEX_LICENSE_FILE = (not set) +00:00:00 167MB | [clm] LM_LICENSE_FILE = (not set) +00:00:00 167MB | +00:00:00 167MB | [color_manager] using color manager of type "color_manager_ocio" +00:00:00 168MB | [color_manager_ocio] using config file C:\arnold\sdk\latest\bin\../ocio/configs/arnold/config.ocio +00:00:00 168MB | [color_manager] rendering color space is "ACEScg" +00:00:00 182MB | +00:00:00 182MB | there are 1 light and 2 objects: +00:00:00 182MB | 1 persp_camera +00:00:00 182MB | 1 distant_light +00:00:00 182MB | 1 utility +00:00:00 182MB | 1 lambert +00:00:00 182MB | 1 driver_tiff +00:00:00 182MB | 1 gaussian_filter +00:00:00 182MB | 1 polymesh +00:00:00 182MB | 1 list_aggregate +00:00:00 182MB | 1 color_manager_ocio +00:00:00 182MB | +00:00:00 182MB | rendering image at 160 x 120, 3 AA samples +00:00:00 182MB | AA samples max +00:00:00 182MB | AA sample clamp +00:00:00 182MB | diffuse samples 2 / depth 1 +00:00:00 182MB | specular samples 2 / depth 1 +00:00:00 182MB | transmission samples 2 / depth 8 +00:00:00 182MB | volume indirect +00:00:00 182MB | total depth 10 +00:00:00 182MB | bssrdf samples 2 +00:00:00 182MB | transparency depth 10 +00:00:00 182MB | initializing 10 nodes +00:00:00 182MB | creating root object list ... +00:00:00 182MB | node initialization done in 0:00.00 (multithreaded) +00:00:00 182MB | updating 11 nodes +00:00:00 182MB | /directionalLight1/directionalLightShape1: distant_light using 1 sample, 2 volume samples +00:00:00 182MB | scene bounds: (-0.5 -0.5 -0.5) -> (0.5 0.5 0.5) +00:00:00 182MB | node update done in 0:00.00 (multithreaded) +00:00:00 183MB | [aov] parsing 1 output statements ... +00:00:00 183MB | [aov] registered driver: "defaultArnoldDriver@driver_tiff.RGBA" (driver_tiff) +00:00:00 183MB | [aov] * "RGBA" of type RGBA filtered by "defaultArnoldFilter@gaussian_filter" (gaussian_filter) +00:00:00 183MB | [aov] done preparing 2 AOVs for 1 output to 1 driver (0 deep AOVs) +00:00:00 186MB | starting 64 bucket workers of size 64x64 ... +00:00:00 193MB | [accel] polymesh bvh4 done - 0:00.00 (wall time) - 6 prims, 1 key +00:00:00 199MB | 5% done - 31 rays/pixel +00:00:00 231MB | 20% done - 31 rays/pixel +00:00:00 242MB | 35% done - 12 rays/pixel +00:00:00 243MB | 60% done - 0 rays/pixel +00:00:00 247MB | 75% done - 4 rays/pixel +00:00:00 248MB | 100% done - 0 rays/pixel +00:00:00 248MB | render done in 0:00.068 +00:00:00 248MB | [driver_tiff] writing file `testrender.tif' +00:00:00 249MB | render done +00:00:00 249MB | +00:00:00 249MB | ----------------------------------------------------------------------------------- +00:00:00 249MB | scene creation time 0:00.42 machine utilization (3.36%) +00:00:00 249MB | plugin loading 0:00.10 +00:00:00 249MB | unaccounted 0:00.31 +00:00:00 249MB | ----------------------------------------------------------------------------------- +00:00:00 249MB | frame time 0:00.11 machine utilization (27.14%) +00:00:00 249MB | driver init/close 0:00.01 +00:00:00 249MB | rendering 0:00.06 +00:00:00 249MB | pixel rendering 0:00.06 +00:00:00 249MB | unaccounted 0:00.03 +00:00:00 249MB | ----------------------------------------------------------------------------------- +00:00:00 249MB | top session self-times by category +00:00:00 249MB | ----------------------------------------------------------------------------------- +00:00:00 249MB | top session self-times by node +00:00:00 249MB | ----------------------------------------------------------------------------------- +00:00:00 249MB | peak CPU memory used 249.34MB +00:00:00 249MB | at startup 65.85MB +00:00:00 249MB | plugins 6.49MB +00:00:00 249MB | AOV samples 3.02MB +00:00:00 249MB | output buffers 0.45MB +00:00:00 249MB | framebuffers 0.38MB +00:00:00 249MB | node overhead 0.00MB +00:00:00 249MB | message passing 0.13MB +00:00:00 249MB | memory pools 51.55MB +00:00:00 249MB | geometry 0.00MB +00:00:00 249MB | polymesh 0.00MB +00:00:00 249MB | accel structs 0.00MB +00:00:00 249MB | strings 24.25MB +00:00:00 249MB | unaccounted 97.21MB +00:00:00 249MB | ----------------------------------------------------------------------------------- +00:00:00 249MB | ray counts ( /pixel, /sample) (% total) (avg. hits) (max hits) +00:00:00 249MB | camera 178252 ( 9.28, 1.00) (100.00%) ( 0.14) ( 1) +00:00:00 249MB | total 178252 ( 9.28, 1.00) (100.00%) ( 0.14) ( 1) +00:00:00 249MB | by ray depth: 0 +00:00:00 249MB | total 100.0% +00:00:00 249MB | ----------------------------------------------------------------------------------- +00:00:00 249MB | shader calls ( /pixel, /sample) (% total) +00:00:00 249MB | primary 24692 ( 1.29, 0.14) (100.00%) +00:00:00 249MB | total 24692 ( 1.29, 0.14) (100.00%) +00:00:00 249MB | by ray depth: 0 +00:00:00 249MB | total 100.0% +00:00:00 249MB | ----------------------------------------------------------------------------------- +00:00:00 249MB | geometry (% hit ) (instances) ( init mem, final mem) +00:00:00 249MB | lists 1 (100.0%) ( 0) ( 0.00, 0.00) +00:00:00 249MB | polymeshes 1 (100.0%) ( 0) ( 0.00, 0.00) +00:00:00 249MB | ----------------------------------------------------------------------------------- +00:00:00 249MB | geometric elements ( min) ( avg.) ( max) +00:00:00 249MB | polygons 6 ( 6) ( 6.0) ( 6) +00:00:00 249MB | ----------------------------------------------------------------------------------- +00:00:00 249MB | triangle tessellation ( min) ( avg.) ( max) (/ element) (% total) +00:00:00 249MB | polymeshes 12 ( 12) ( 12.0) ( 12) ( 2.00) (100.00%) +00:00:00 249MB | unique triangles 12 +00:00:00 249MB | CPU memory use 0.00MB +00:00:00 249MB | vertices 0.00MB +00:00:00 249MB | vertex indices 0.00MB +00:00:00 249MB | packed normals 0.00MB +00:00:00 249MB | normal indices 0.00MB +00:00:00 249MB | uniform indices 0.00MB +00:00:00 249MB | largest polymeshes by triangle count +00:00:00 249MB | 12 tris -- /pCube1/pCubeShape1 +00:00:00 249MB | ----------------------------------------------------------------------------------- +00:00:00 249MB | acceleration structures: (% total) +00:00:00 249MB | list 1 ( 50.00%) +00:00:00 249MB | bvh 1 ( 50.00%) +00:00:00 249MB | total 2 (100.00%) +00:00:00 249MB | ----------------------------------------------------------------------------------- +00:00:00 249MB | number of warnings, warning type: +00:00:00 249MB | 1: rendering with watermarks because of failed authorization: +00:00:00 249MB | ----------------------------------------------------------------------------------- +00:00:00 249MB | +00:00:00 249MB | releasing resources +00:00:00 186MB | unloading 3 plugins +00:00:00 186MB | closing usd_proc.dll ... +00:00:00 186MB | closing alembic_proc.dll ... +00:00:00 186MB | closing cryptomatte.dll ... +00:00:00 186MB | unloading plugins done +00:00:00 186MB | Arnold shutdown diff --git a/testsuite/test_0142/ref/reference.tif b/testsuite/test_0142/ref/reference.tif index b5f71f8ba5..dec6e4f2cb 100644 Binary files a/testsuite/test_0142/ref/reference.tif and b/testsuite/test_0142/ref/reference.tif differ diff --git a/testsuite/test_0161/ref/reference.log b/testsuite/test_0161/ref/reference.log index 6ab0ff7610..a52b0c8d23 100644 --- a/testsuite/test_0161/ref/reference.log +++ b/testsuite/test_0161/ref/reference.log @@ -1,158 +1,171 @@ -00:00:00 72MB | log started Thu Mar 4 18:57:52 2021 -00:00:00 72MB | Arnold 6.2.0.1 [903992ac] windows clang-10.0.1 oiio-2.2.1 osl-1.11.6 vdb-7.1.1 clm-2.0.0.235 rlm-12.4.2 optix-6.6.0 2021/02/09 10:40:42 -00:00:00 72MB | running on REMS4QL1726, pid=26500 -00:00:00 72MB | 2 x Intel(R) Xeon(R) Gold 5218 CPU @ 2.30GHz (32 cores, 64 logical) with 65154MB -00:00:00 72MB | NVIDIA driver version 442.50 (Optix 60600) -00:00:00 72MB | GPU 0: Quadro RTX 4000 @ 1545MHz (compute 7.5) with 8192MB (6141MB available) (NVLink:0) -00:00:00 72MB | Windows 10 (version 10.0, build 19041) -00:00:00 72MB | soft limit for open files raised from 512 to 2048 -00:00:00 72MB | -00:00:00 72MB | loading plugins from C:\arnold\arnold-usd\build\windows_x86_64\msvc_opt\usd-0.20.11_arnold-6.2.0.1\procedural ... -00:00:00 77MB | usd_proc.dll: usd uses Arnold 6.2.0.1 -00:00:00 77MB | loaded 1 plugins from 1 lib(s) in 0:00.10 -00:00:00 77MB | loading plugins from C:\arnold\sdk\6.2.0.1\bin\..\plugins ... -00:00:00 77MB | alembic_proc.dll: alembic uses Arnold 6.2.0.1 -00:00:00 77MB | cryptomatte.dll: cryptomatte uses Arnold 6.2.0.1 -00:00:00 77MB | cryptomatte.dll: cryptomatte_filter uses Arnold 6.2.0.1 -00:00:00 77MB | cryptomatte.dll: cryptomatte_manifest_driver uses Arnold 6.2.0.1 -00:00:00 77MB | skipping already loaded plugin: C:\arnold\sdk\6.2.0.1\bin\..\plugins\usd_proc.dll ... -00:00:00 77MB | loaded 4 plugins from 2 lib(s) in 0:00.01 -00:00:00 77MB | [metadata] loading metadata file: scene.ass -00:00:00 78MB | [ass] loading scene.ass ... -00:00:00 79MB | [ass] read 12216 bytes, 7 nodes in 0:00.00 -00:00:00 109MB | -00:00:00 109MB | authorizing with default license managers: rlm, network, user ... -00:00:02 114MB | [network] authorized for "87287ARNOL_2020_0F" in 0:01.71 -00:00:02 114MB | [network] expiration date: permanent, in use: 1/100 -00:00:02 114MB | -00:00:02 132MB | [color_manager] no color manager is active -00:00:02 132MB | [color_manager] rendering color space is "linear" with declared chromaticities: -00:00:02 132MB | r(0.6400, 0.3300) g(0.3000, 0.6000) b(0.1500, 0.0600) and w(0.3127, 0.3290) -00:00:02 147MB | -00:00:02 147MB | there are 1 light and 4 objects: -00:00:02 147MB | 1 persp_camera -00:00:02 147MB | 1 skydome_light -00:00:02 147MB | 1 utility -00:00:02 147MB | 1 lambert -00:00:02 147MB | 1 driver_tiff -00:00:02 147MB | 1 gaussian_filter -00:00:02 147MB | 3 polymesh -00:00:02 147MB | 1 list_aggregate -00:00:02 147MB | -00:00:02 147MB | rendering image at 160 x 120, 3 AA samples -00:00:02 147MB | AA samples max -00:00:02 147MB | AA sample clamp -00:00:02 147MB | diffuse samples 2 / depth 1 -00:00:02 147MB | specular samples 2 / depth 1 -00:00:02 147MB | transmission samples 2 / depth 8 -00:00:02 147MB | volume indirect -00:00:02 147MB | total depth 10 -00:00:02 147MB | bssrdf samples 2 -00:00:02 147MB | transparency depth 10 -00:00:02 147MB | initializing 11 nodes ... -00:00:02 147MB | creating root object list ... -00:00:02 147MB | node initialization done in 0:00.00 (multithreaded) -00:00:02 147MB | updating 12 nodes ... -00:00:02 147MB | /aiSkyDomeLight1/aiSkyDomeLightShape1: skydome_light using 1 sample, 2 volume samples -00:00:02 147MB | scene bounds: (-8.60338497 -0.5 -8.60338497) -> (8.60338497 0.5 10.5) -00:00:02 147MB | node update done in 0:00.00 (multithreaded) -00:00:02 147MB | [aov] parsing 1 output statements ... -00:00:02 147MB | [aov] registered driver: "mydriver" (driver_tiff) -00:00:02 147MB | [aov] * "RGBA" of type RGBA filtered by "myfilter" (gaussian_filter) -00:00:02 147MB | [aov] done preparing 2 AOVs for 1 output to 1 driver (0 deep AOVs) -00:00:02 148MB | starting 64 bucket workers of size 64x64 ... -00:00:02 157MB | [accel] list_aggregate bvh4 done - 0:00.00 (wall time) - 3 prims, 1 key -00:00:02 160MB | [accel] polymesh bvh4 done - 0:00.00 (wall time) - 100 prims, 1 key -00:00:02 159MB | [accel] polymesh bvh4 done - 0:00.00 (wall time) - 6 prims, 1 key -00:00:02 159MB | [accel] polymesh bvh4 done - 0:00.00 (wall time) - 6 prims, 1 key -00:00:02 160MB | 5% done - 233 rays/pixel -00:00:02 160MB | 20% done - 19 rays/pixel -00:00:02 160MB | 35% done - 25 rays/pixel -00:00:02 160MB | 55% done - 19 rays/pixel -00:00:02 160MB | 75% done - 22 rays/pixel -00:00:02 160MB | 100% done - 0 rays/pixel -00:00:02 160MB | render done in 0:00.072 -00:00:02 160MB | [driver_tiff] writing file `testrender.tif' -00:00:02 161MB | render done -00:00:02 161MB | -00:00:02 161MB | ----------------------------------------------------------------------------------- -00:00:02 161MB | scene creation time 0:00.20 machine utilization (6.42%) -00:00:02 161MB | plugin loading 0:00.11 -00:00:02 161MB | unaccounted 0:00.08 -00:00:02 161MB | ----------------------------------------------------------------------------------- -00:00:02 161MB | frame time 0:01.86 machine utilization (4.12%) -00:00:02 161MB | driver init/close 0:00.01 -00:00:02 161MB | rendering 0:00.07 -00:00:02 161MB | pixel rendering 0:00.07 -00:00:02 161MB | unaccounted 0:01.77 -00:00:02 161MB | ----------------------------------------------------------------------------------- -00:00:02 161MB | top session self-times by category -00:00:02 161MB | ----------------------------------------------------------------------------------- -00:00:02 161MB | top session self-times by node -00:00:02 161MB | ----------------------------------------------------------------------------------- -00:00:02 161MB | peak CPU memory used 161.13MB -00:00:02 161MB | at startup 68.56MB -00:00:02 161MB | plugins 5.16MB -00:00:02 161MB | AOV samples 3.93MB -00:00:02 161MB | output buffers 0.54MB -00:00:02 161MB | framebuffers 0.47MB -00:00:02 161MB | node overhead 0.01MB -00:00:02 161MB | message passing 0.13MB -00:00:02 161MB | memory pools 42.05MB -00:00:02 161MB | geometry 0.00MB -00:00:02 161MB | polymesh 0.00MB -00:00:02 161MB | accel structs 0.02MB -00:00:02 161MB | strings 24.25MB -00:00:02 161MB | unaccounted 16.01MB -00:00:02 161MB | ----------------------------------------------------------------------------------- -00:00:02 161MB | ray counts ( /pixel, /sample) (% total) (avg. hits) (max hits) -00:00:02 161MB | camera 178252 ( 9.28, 1.00) ( 25.41%) ( 0.38) ( 1) -00:00:02 161MB | shadow 261588 ( 13.62, 1.47) ( 37.29%) ( 0.00) ( 1) -00:00:02 161MB | diffuse_reflect 261588 ( 13.62, 1.47) ( 37.29%) ( 0.00) ( 1) -00:00:02 161MB | total 701428 ( 36.53, 3.94) (100.00%) ( 0.10) ( 1) -00:00:02 161MB | by ray depth: 0 1 -00:00:02 161MB | total 62.7% 37.3% -00:00:02 161MB | ----------------------------------------------------------------------------------- -00:00:02 161MB | shader calls ( /pixel, /sample) (% total) -00:00:02 161MB | primary 68454 ( 3.57, 0.38) (100.00%) -00:00:02 161MB | total 68454 ( 3.57, 0.38) (100.00%) -00:00:02 161MB | by ray depth: 0 1 -00:00:02 161MB | total 99.6% 0.4% -00:00:02 161MB | ----------------------------------------------------------------------------------- -00:00:02 161MB | geometry (% hit ) (instances) ( init mem, final mem) -00:00:02 161MB | lists 1 (100.0%) ( 0) ( 0.00, 0.00) -00:00:02 161MB | polymeshes 3 (100.0%) ( 0) ( 0.01, 0.00) -00:00:02 161MB | ----------------------------------------------------------------------------------- -00:00:02 161MB | geometric elements ( min) ( avg.) ( max) -00:00:02 161MB | polygons 112 ( 6) ( 37.3) ( 100) -00:00:02 161MB | ----------------------------------------------------------------------------------- -00:00:02 161MB | triangle tessellation ( min) ( avg.) ( max) (/ element) (% total) -00:00:02 161MB | polymeshes 224 ( 12) ( 74.7) ( 200) ( 2.00) (100.00%) -00:00:02 161MB | unique triangles 224 -00:00:02 161MB | CPU memory use 0.00MB -00:00:02 161MB | vertices 0.00MB -00:00:02 161MB | vertex indices 0.00MB -00:00:02 161MB | uv coords 0.00MB -00:00:02 161MB | uv coords idxs 0.00MB -00:00:02 161MB | uniform indices 0.00MB -00:00:02 161MB | userdata 0.00MB -00:00:02 161MB | largest polymeshes by triangle count -00:00:02 161MB | 200 tris -- /pPlane1/pPlaneShape1 -00:00:02 161MB | 12 tris -- /pCube1/pCubeShape1 -00:00:02 161MB | 12 tris -- -00:00:02 161MB | ----------------------------------------------------------------------------------- -00:00:02 161MB | acceleration structures: (% total) -00:00:02 161MB | bvh 4 (100.00%) -00:00:02 161MB | total 4 (100.00%) -00:00:02 161MB | ----------------------------------------------------------------------------------- -00:00:02 161MB | performance warnings: -00:00:02 161MB WARNING | Rendering CPU utilization was only 4%. Your render may be bound by a single threaded process or I/O. -00:00:02 161MB | ----------------------------------------------------------------------------------- -00:00:02 161MB | -00:00:02 161MB | releasing resources -00:00:02 120MB | unloading 3 plugins -00:00:02 120MB | closing usd_proc.dll ... -00:00:02 120MB | closing alembic_proc.dll ... -00:00:02 120MB | closing cryptomatte.dll ... -00:00:02 120MB | unloading plugins done -00:00:02 120MB | Arnold shutdown +00:00:00 116MB | log started Mon Jan 23 15:04:42 2023 +00:00:00 116MB | Arnold 7.2.0.0 [f99ccc6f] windows x86_64 clang-10.0.1 oiio-2.4.1 osl-1.12.0 vdb-7.1.1 adlsdk-7.4.2.47 clmhub-3.1.1.43 rlm-14.2.5 optix-6.6.0 2023/01/13 17:16:45 +00:00:00 116MB | running on REMS4QL1726, pid=91344 +00:00:00 116MB | 2 x Intel(R) Xeon(R) Gold 5218 CPU @ 2.30GHz (32 cores, 64 logical) with 65154MB +00:00:00 116MB | NVIDIA driver version 511.65 (Optix 60802) +00:00:00 116MB | GPU 0: Quadro RTX 4000 @ 1545MHz (compute 7.5) with 8191MB (5010MB available) (NVLink:0) +00:00:00 116MB | Windows 10 (version 10.0, build 19044) +00:00:00 116MB | soft limit for open files changed from 512 to 2048 +00:00:00 116MB | +00:00:00 116MB | [color_manager_ocio] default ocio.config found in C:\arnold\sdk\latest\bin\../ocio/configs/arnold/config.ocio +00:00:00 116MB | loading plugins from C:\arnold\arnold-usd\build\windows_x86_64\msvc_opt\usd-0.22.8_arnold-7.2.0.0\procedural ... +00:00:00 122MB | usd_proc.dll: usd uses Arnold 7.2.0.0 +00:00:00 123MB | loaded 1 plugins from 1 lib(s) in 0:00.09 +00:00:00 123MB | loading plugins from C:\arnold\sdk\latest\bin\..\plugins ... +00:00:00 123MB | alembic_proc.dll: alembic uses Arnold 7.2.0.0 +00:00:00 123MB | cryptomatte.dll: cryptomatte uses Arnold 7.2.0.0 +00:00:00 123MB | cryptomatte.dll: cryptomatte_filter uses Arnold 7.2.0.0 +00:00:00 123MB | cryptomatte.dll: cryptomatte_manifest_driver uses Arnold 7.2.0.0 +00:00:00 123MB | skipping already loaded plugin: C:\arnold\sdk\latest\bin\..\plugins\usd_proc.dll ... +00:00:00 123MB | loaded 4 plugins from 2 lib(s) in 0:00.00 +00:00:00 130MB | [metadata] loading metadata file: scene.ass +00:00:00 131MB | [ass] loading scene.ass ... +00:00:00 131MB | [ass] read 12461 bytes, 7 nodes in 0:00.00 +00:00:00 131MB | [color_manager_ocio] default ocio.config found in C:\arnold\sdk\latest\bin\../ocio/configs/arnold/config.ocio +00:00:00 167MB | [color_manager_ocio] default ocio.config found in C:\arnold\sdk\latest\bin\../ocio/configs/arnold/config.ocio +00:00:00 168MB | +00:00:00 168MB | authorizing with license manager: network ... +00:00:00 168MB WARNING | rendering with watermarks because of failed authorization: +00:00:00 168MB | [clm.v1] license server was not set (51) +00:00:00 168MB | environment variables: +00:00:00 168MB | ARNOLD_LICENSE_ORDER = (not set) +00:00:00 168MB | ARNOLD_LICENSE_MANAGER = (not set) +00:00:00 168MB | [rlm] solidangle_LICENSE = (not set) +00:00:00 168MB | [rlm] RLM_LICENSE = (not set) +00:00:00 168MB | [clm] ADSKFLEX_LICENSE_FILE = (not set) +00:00:00 168MB | [clm] LM_LICENSE_FILE = (not set) +00:00:00 168MB | +00:00:00 168MB | [color_manager] using color manager of type "color_manager_ocio" +00:00:00 169MB | [color_manager_ocio] using config file C:\arnold\sdk\latest\bin\../ocio/configs/arnold/config.ocio +00:00:00 169MB | [color_manager] rendering color space is "ACEScg" +00:00:00 183MB | +00:00:00 183MB | there are 1 light and 4 objects: +00:00:00 183MB | 1 persp_camera +00:00:00 183MB | 1 skydome_light +00:00:00 183MB | 1 utility +00:00:00 183MB | 1 lambert +00:00:00 183MB | 1 driver_tiff +00:00:00 183MB | 1 gaussian_filter +00:00:00 183MB | 3 polymesh +00:00:00 183MB | 1 list_aggregate +00:00:00 183MB | 1 color_manager_ocio +00:00:00 183MB | +00:00:00 183MB | rendering image at 160 x 120, 3 AA samples +00:00:00 183MB | AA samples max +00:00:00 183MB | AA sample clamp +00:00:00 183MB | diffuse samples 2 / depth 1 +00:00:00 183MB | specular samples 2 / depth 1 +00:00:00 183MB | transmission samples 2 / depth 8 +00:00:00 183MB | volume indirect +00:00:00 183MB | total depth 10 +00:00:00 183MB | bssrdf samples 2 +00:00:00 183MB | transparency depth 10 +00:00:00 183MB | initializing 12 nodes +00:00:00 183MB | creating root object list ... +00:00:00 183MB | node initialization done in 0:00.00 (multithreaded) +00:00:00 183MB | updating 13 nodes +00:00:00 183MB | /aiSkyDomeLight1/aiSkyDomeLightShape1: skydome_light using 1 sample, 2 volume samples +00:00:00 183MB | scene bounds: (-8.60338497 -0.5 -8.60338497) -> (8.60338497 0.5 10.5) +00:00:00 183MB | node update done in 0:00.00 (multithreaded) +00:00:00 183MB | [aov] parsing 1 output statements ... +00:00:00 184MB | [aov] registered driver: "mydriver" (driver_tiff) +00:00:00 184MB | [aov] * "RGBA" of type RGBA filtered by "myfilter" (gaussian_filter) +00:00:00 184MB | [aov] done preparing 2 AOVs for 1 output to 1 driver (0 deep AOVs) +00:00:00 188MB | starting 64 bucket workers of size 64x64 ... +00:00:00 206MB | [accel] list_aggregate bvh4 done - 0:00.00 (wall time) - 3 prims, 1 key +00:00:00 222MB | [accel] polymesh bvh4 done - 0:00.00 (wall time) - 100 prims, 1 key +00:00:00 228MB | [accel] polymesh bvh4 done - 0:00.00 (wall time) - 6 prims, 1 key +00:00:00 229MB | [accel] polymesh bvh4 done - 0:00.00 (wall time) - 6 prims, 1 key +00:00:00 248MB | 5% done - 141 rays/pixel +00:00:00 268MB | 20% done - 144 rays/pixel +00:00:00 271MB | 35% done - 33 rays/pixel +00:00:00 271MB | 60% done - 0 rays/pixel +00:00:00 271MB | 75% done - 0 rays/pixel +00:00:00 272MB | 100% done - 8 rays/pixel +00:00:00 272MB | render done in 0:00.076 +00:00:00 272MB | [driver_tiff] writing file `testrender.tif' +00:00:00 273MB | render done +00:00:00 273MB | +00:00:00 273MB | ----------------------------------------------------------------------------------- +00:00:00 273MB | scene creation time 0:00.45 machine utilization (3.45%) +00:00:00 273MB | plugin loading 0:00.10 +00:00:00 273MB | unaccounted 0:00.34 +00:00:00 273MB | ----------------------------------------------------------------------------------- +00:00:00 273MB | frame time 0:00.11 machine utilization (38.29%) +00:00:00 273MB | driver init/close 0:00.01 +00:00:00 273MB | rendering 0:00.07 +00:00:00 273MB | pixel rendering 0:00.07 +00:00:00 273MB | unaccounted 0:00.02 +00:00:00 273MB | ----------------------------------------------------------------------------------- +00:00:00 273MB | top session self-times by category +00:00:00 273MB | ----------------------------------------------------------------------------------- +00:00:00 273MB | top session self-times by node +00:00:00 273MB | ----------------------------------------------------------------------------------- +00:00:00 273MB | peak CPU memory used 273.50MB +00:00:00 273MB | at startup 65.75MB +00:00:00 273MB | plugins 6.62MB +00:00:00 273MB | AOV samples 3.02MB +00:00:00 273MB | output buffers 0.45MB +00:00:00 273MB | framebuffers 0.38MB +00:00:00 273MB | node overhead 0.01MB +00:00:00 273MB | message passing 0.13MB +00:00:00 273MB | memory pools 73.55MB +00:00:00 273MB | geometry 0.00MB +00:00:00 273MB | polymesh 0.00MB +00:00:00 273MB | accel structs 0.02MB +00:00:00 273MB | strings 24.25MB +00:00:00 273MB | unaccounted 99.33MB +00:00:00 273MB | ----------------------------------------------------------------------------------- +00:00:00 273MB | ray counts ( /pixel, /sample) (% total) (avg. hits) (max hits) +00:00:00 273MB | camera 178252 ( 9.28, 1.00) ( 25.41%) ( 0.38) ( 1) +00:00:00 273MB | shadow 261588 ( 13.62, 1.47) ( 37.29%) ( 0.00) ( 1) +00:00:00 273MB | diffuse_reflect 261588 ( 13.62, 1.47) ( 37.29%) ( 0.00) ( 1) +00:00:00 273MB | total 701428 ( 36.53, 3.94) (100.00%) ( 0.10) ( 1) +00:00:00 273MB | by ray depth: 0 1 +00:00:00 273MB | total 62.7% 37.3% +00:00:00 273MB | ----------------------------------------------------------------------------------- +00:00:00 273MB | shader calls ( /pixel, /sample) (% total) +00:00:00 273MB | primary 68454 ( 3.57, 0.38) (100.00%) +00:00:00 273MB | total 68454 ( 3.57, 0.38) (100.00%) +00:00:00 273MB | by ray depth: 0 1 +00:00:00 273MB | total 99.6% 0.4% +00:00:00 273MB | ----------------------------------------------------------------------------------- +00:00:00 273MB | geometry (% hit ) (instances) ( init mem, final mem) +00:00:00 273MB | lists 1 (100.0%) ( 0) ( 0.00, 0.00) +00:00:00 273MB | polymeshes 3 (100.0%) ( 0) ( 0.00, 0.00) +00:00:00 273MB | ----------------------------------------------------------------------------------- +00:00:00 273MB | geometric elements ( min) ( avg.) ( max) +00:00:00 273MB | polygons 112 ( 6) ( 37.3) ( 100) +00:00:00 273MB | ----------------------------------------------------------------------------------- +00:00:00 273MB | triangle tessellation ( min) ( avg.) ( max) (/ element) (% total) +00:00:00 273MB | polymeshes 224 ( 12) ( 74.7) ( 200) ( 2.00) (100.00%) +00:00:00 273MB | unique triangles 224 +00:00:00 273MB | CPU memory use 0.00MB +00:00:00 273MB | vertices 0.00MB +00:00:00 273MB | vertex indices 0.00MB +00:00:00 273MB | packed normals 0.00MB +00:00:00 273MB | normal indices 0.00MB +00:00:00 273MB | uv coords 0.00MB +00:00:00 273MB | uv coords idxs 0.00MB +00:00:00 273MB | uniform indices 0.00MB +00:00:00 273MB | userdata 0.00MB +00:00:00 273MB | largest polymeshes by triangle count +00:00:00 273MB | 200 tris -- /pPlane1/pPlaneShape1 +00:00:00 273MB | 12 tris -- /pCube1/pCubeShape1 +00:00:00 273MB | 12 tris -- +00:00:00 273MB | ----------------------------------------------------------------------------------- +00:00:00 273MB | acceleration structures: (% total) +00:00:00 273MB | bvh 4 (100.00%) +00:00:00 273MB | total 4 (100.00%) +00:00:00 273MB | ----------------------------------------------------------------------------------- +00:00:00 273MB | number of warnings, warning type: +00:00:00 273MB | 1: rendering with watermarks because of failed authorization: +00:00:00 273MB | ----------------------------------------------------------------------------------- +00:00:00 273MB | +00:00:00 273MB | releasing resources +00:00:00 189MB | unloading 3 plugins +00:00:00 189MB | closing usd_proc.dll ... +00:00:00 189MB | closing alembic_proc.dll ... +00:00:00 189MB | closing cryptomatte.dll ... +00:00:00 189MB | unloading plugins done +00:00:00 189MB | Arnold shutdown diff --git a/testsuite/test_0161/ref/reference.tif b/testsuite/test_0161/ref/reference.tif index 4b75d67585..d1dd782bd1 100644 Binary files a/testsuite/test_0161/ref/reference.tif and b/testsuite/test_0161/ref/reference.tif differ diff --git a/testsuite/test_0168/ref/reference.log b/testsuite/test_0168/ref/reference.log index 25e8d9fe56..5952ca0234 100644 --- a/testsuite/test_0168/ref/reference.log +++ b/testsuite/test_0168/ref/reference.log @@ -1,148 +1,162 @@ -00:00:00 72MB | log started Tue Mar 9 12:25:40 2021 -00:00:00 72MB | Arnold 6.2.0.1 [903992ac] windows clang-10.0.1 oiio-2.2.1 osl-1.11.6 vdb-7.1.1 clm-2.0.0.235 rlm-12.4.2 optix-6.6.0 2021/02/09 10:40:42 -00:00:00 72MB | running on REMS4QL1726, pid=18292 -00:00:00 72MB | 2 x Intel(R) Xeon(R) Gold 5218 CPU @ 2.30GHz (32 cores, 64 logical) with 65154MB -00:00:00 72MB | NVIDIA driver version 442.50 (Optix 60600) -00:00:00 72MB | GPU 0: Quadro RTX 4000 @ 1545MHz (compute 7.5) with 8192MB (7184MB available) (NVLink:0) -00:00:00 72MB | Windows 10 (version 10.0, build 19041) -00:00:00 72MB | soft limit for open files raised from 512 to 2048 -00:00:00 72MB | -00:00:00 72MB | loading plugins from C:\arnold\arnold-usd\build\windows_x86_64\msvc_opt\usd-0.20.11_arnold-6.2.0.1\procedural ... -00:00:00 77MB | usd_proc.dll: usd uses Arnold 6.2.0.1 -00:00:00 77MB | loaded 1 plugins from 1 lib(s) in 0:00.10 -00:00:00 77MB | loading plugins from C:\arnold\sdk\6.2.0.1\bin\..\plugins ... -00:00:00 77MB | alembic_proc.dll: alembic uses Arnold 6.2.0.1 -00:00:00 77MB | cryptomatte.dll: cryptomatte uses Arnold 6.2.0.1 -00:00:00 77MB | cryptomatte.dll: cryptomatte_filter uses Arnold 6.2.0.1 -00:00:00 77MB | cryptomatte.dll: cryptomatte_manifest_driver uses Arnold 6.2.0.1 -00:00:00 77MB | skipping already loaded plugin: C:\arnold\sdk\6.2.0.1\bin\..\plugins\usd_proc.dll ... -00:00:00 77MB | loaded 4 plugins from 2 lib(s) in 0:00.01 -00:00:00 77MB | [metadata] loading metadata file: scene.ass -00:00:00 78MB | [ass] loading scene.ass ... -00:00:00 78MB | [ass] read 1435 bytes, 4 nodes in 0:00.00 -00:00:00 108MB | -00:00:00 108MB | authorizing with default license managers: rlm, network, user ... -00:00:02 113MB | [network] authorized for "87287ARNOL_2020_0F" in 0:01.67 -00:00:02 113MB | [network] expiration date: permanent, in use: 1/100 -00:00:02 113MB | -00:00:02 132MB | [color_manager] no color manager is active -00:00:02 132MB | [color_manager] rendering color space is "linear" with declared chromaticities: -00:00:02 132MB | r(0.6400, 0.3300) g(0.3000, 0.6000) b(0.1500, 0.0600) and w(0.3127, 0.3290) -00:00:02 146MB | -00:00:02 146MB | there are 0 lights and 2 objects: -00:00:02 146MB | 1 persp_camera -00:00:02 146MB | 1 utility -00:00:02 146MB | 1 driver_tiff -00:00:02 146MB | 1 gaussian_filter -00:00:02 146MB | 1 polymesh -00:00:02 146MB | 1 list_aggregate -00:00:02 146MB | -00:00:02 146MB | rendering image at 160 x 120, 3 AA samples -00:00:02 146MB | AA samples max -00:00:02 146MB | AA sample clamp -00:00:02 146MB | diffuse samples 2 / depth 1 -00:00:02 146MB | specular samples 2 / depth 1 -00:00:02 146MB | transmission samples 2 / depth 8 -00:00:02 146MB | volume indirect -00:00:02 146MB | total depth 10 -00:00:02 146MB | bssrdf samples 2 -00:00:02 146MB | transparency depth 10 -00:00:02 146MB | initializing 7 nodes ... -00:00:02 147MB | creating root object list ... -00:00:02 147MB | node initialization done in 0:00.00 (multithreaded) -00:00:02 147MB | updating 8 nodes ... -00:00:02 147MB | scene bounds: (-5.15929317 -3.00272703 -4.38875484) -> (5.15929317 7.84687805 4.38875484) -00:00:02 147MB | node update done in 0:00.00 (multithreaded) -00:00:02 147MB | [aov] parsing 1 output statements ... -00:00:02 147MB | [aov] registered driver: "mydriver" (driver_tiff) -00:00:02 147MB | [aov] * "RGBA" of type RGBA filtered by "myfilter" (gaussian_filter) -00:00:02 147MB | [aov] done preparing 2 AOVs for 1 output to 1 driver (0 deep AOVs) -00:00:02 148MB | starting 64 bucket workers of size 64x64 ... -00:00:02 156MB | [accel] polymesh bvh4 done - 0:00.00 (wall time) - 36 prims, 1 key -00:00:02 156MB | 10% done - 62 rays/pixel -00:00:02 156MB | 20% done - 4 rays/pixel -00:00:02 156MB | 35% done - 10 rays/pixel -00:00:02 157MB | 55% done - 1 rays/pixel -00:00:02 157MB | 75% done - 0 rays/pixel -00:00:02 157MB | 100% done - 1 rays/pixel -00:00:02 157MB | render done in 0:00.061 -00:00:02 157MB | [driver_tiff] writing file `testrender.tif' -00:00:02 157MB | render done -00:00:02 157MB | -00:00:02 157MB | ----------------------------------------------------------------------------------- -00:00:02 157MB | scene creation time 0:00.20 machine utilization (3.67%) -00:00:02 157MB | plugin loading 0:00.11 -00:00:02 157MB | unaccounted 0:00.08 -00:00:02 157MB | ----------------------------------------------------------------------------------- -00:00:02 157MB | frame time 0:01.80 machine utilization (3.22%) -00:00:02 157MB | rendering 0:00.06 -00:00:02 157MB | pixel rendering 0:00.06 -00:00:02 157MB | unaccounted 0:01.72 -00:00:02 157MB | ----------------------------------------------------------------------------------- -00:00:02 157MB | top session self-times by category -00:00:02 157MB | ----------------------------------------------------------------------------------- -00:00:02 157MB | top session self-times by node -00:00:02 157MB | ----------------------------------------------------------------------------------- -00:00:02 157MB | peak CPU memory used 157.45MB -00:00:02 157MB | at startup 68.50MB -00:00:02 157MB | plugins 5.12MB -00:00:02 157MB | AOV samples 3.93MB -00:00:02 157MB | output buffers 0.54MB -00:00:02 157MB | framebuffers 0.47MB -00:00:02 157MB | node overhead 0.01MB -00:00:02 157MB | message passing 0.13MB -00:00:02 157MB | memory pools 42.05MB -00:00:02 157MB | geometry 0.00MB -00:00:02 157MB | polymesh 0.00MB -00:00:02 157MB | accel structs 0.01MB -00:00:02 157MB | strings 24.25MB -00:00:02 157MB | unaccounted 12.45MB -00:00:02 157MB | ----------------------------------------------------------------------------------- -00:00:02 157MB | ray counts ( /pixel, /sample) (% total) (avg. hits) (max hits) -00:00:02 157MB | camera 178252 ( 9.28, 1.00) (100.00%) ( 0.16) ( 1) -00:00:02 157MB | total 178252 ( 9.28, 1.00) (100.00%) ( 0.16) ( 1) -00:00:02 157MB | by ray depth: 0 -00:00:02 157MB | total 100.0% -00:00:02 157MB | ----------------------------------------------------------------------------------- -00:00:02 157MB | shader calls ( /pixel, /sample) (% total) -00:00:02 157MB | primary 28688 ( 1.49, 0.16) (100.00%) -00:00:02 157MB | total 28688 ( 1.49, 0.16) (100.00%) -00:00:02 157MB | by ray depth: 0 -00:00:02 157MB | total 100.0% -00:00:02 157MB | ----------------------------------------------------------------------------------- -00:00:02 157MB | geometry (% hit ) (instances) ( init mem, final mem) -00:00:02 157MB | lists 1 (100.0%) ( 0) ( 0.00, 0.00) -00:00:02 157MB | polymeshes 1 (100.0%) ( 0) ( 0.00, 0.00) -00:00:02 157MB | ----------------------------------------------------------------------------------- -00:00:02 157MB | geometric elements ( min) ( avg.) ( max) -00:00:02 157MB | polygons 12 ( 12) ( 12.0) ( 12) -00:00:02 157MB | ----------------------------------------------------------------------------------- -00:00:02 157MB | triangle tessellation ( min) ( avg.) ( max) (/ element) (% total) -00:00:02 157MB | polymeshes 36 ( 36) ( 36.0) ( 36) ( 3.00) (100.00%) -00:00:02 157MB | unique triangles 36 -00:00:02 157MB | CPU memory use 0.00MB -00:00:02 157MB | vertices 0.00MB -00:00:02 157MB | vertex indices 0.00MB -00:00:02 157MB | polygon base offsets 0.00MB -00:00:02 157MB | polygon IDs 0.00MB -00:00:02 157MB | triangulation 0.00MB -00:00:02 157MB | uniform indices 0.00MB -00:00:02 157MB | largest polymeshes by triangle count -00:00:02 157MB | 36 tris -- /_proxy/mesh_0 -00:00:02 157MB | ----------------------------------------------------------------------------------- -00:00:02 157MB | acceleration structures: (% total) -00:00:02 157MB | list 1 ( 50.00%) -00:00:02 157MB | bvh 1 ( 50.00%) -00:00:02 157MB | total 2 (100.00%) -00:00:02 157MB | ----------------------------------------------------------------------------------- -00:00:02 157MB | performance warnings: -00:00:02 157MB WARNING | Rendering CPU utilization was only 3%. Your render may be bound by a single threaded process or I/O. -00:00:02 157MB | ----------------------------------------------------------------------------------- -00:00:02 157MB | -00:00:02 157MB | releasing resources -00:00:02 117MB | unloading 3 plugins -00:00:02 117MB | closing usd_proc.dll ... -00:00:02 117MB | closing alembic_proc.dll ... -00:00:02 117MB | closing cryptomatte.dll ... -00:00:02 117MB | unloading plugins done -00:00:02 117MB | Arnold shutdown +00:00:00 116MB | log started Mon Jan 23 15:00:10 2023 +00:00:00 116MB | Arnold 7.2.0.0 [f99ccc6f] windows x86_64 clang-10.0.1 oiio-2.4.1 osl-1.12.0 vdb-7.1.1 adlsdk-7.4.2.47 clmhub-3.1.1.43 rlm-14.2.5 optix-6.6.0 2023/01/13 17:16:45 +00:00:00 116MB | running on REMS4QL1726, pid=63572 +00:00:00 116MB | 2 x Intel(R) Xeon(R) Gold 5218 CPU @ 2.30GHz (32 cores, 64 logical) with 65154MB +00:00:00 116MB | NVIDIA driver version 511.65 (Optix 60802) +00:00:00 116MB | GPU 0: Quadro RTX 4000 @ 1545MHz (compute 7.5) with 8191MB (5427MB available) (NVLink:0) +00:00:00 116MB | Windows 10 (version 10.0, build 19044) +00:00:00 116MB | soft limit for open files changed from 512 to 2048 +00:00:00 116MB | +00:00:00 116MB | [color_manager_ocio] default ocio.config found in C:\arnold\sdk\latest\bin\../ocio/configs/arnold/config.ocio +00:00:00 116MB | loading plugins from C:\arnold\arnold-usd\build\windows_x86_64\msvc_opt\usd-0.22.8_arnold-7.2.0.0\procedural ... +00:00:00 122MB | usd_proc.dll: usd uses Arnold 7.2.0.0 +00:00:00 123MB | loaded 1 plugins from 1 lib(s) in 0:00.10 +00:00:00 123MB | loading plugins from C:\arnold\sdk\latest\bin\..\plugins ... +00:00:00 123MB | alembic_proc.dll: alembic uses Arnold 7.2.0.0 +00:00:00 123MB | cryptomatte.dll: cryptomatte uses Arnold 7.2.0.0 +00:00:00 123MB | cryptomatte.dll: cryptomatte_filter uses Arnold 7.2.0.0 +00:00:00 123MB | cryptomatte.dll: cryptomatte_manifest_driver uses Arnold 7.2.0.0 +00:00:00 123MB | skipping already loaded plugin: C:\arnold\sdk\latest\bin\..\plugins\usd_proc.dll ... +00:00:00 123MB | loaded 4 plugins from 2 lib(s) in 0:00.00 +00:00:00 146MB | [color_manager_ocio] default ocio.config found in C:\arnold\sdk\latest\bin\../ocio/configs/arnold/config.ocio +00:00:00 131MB | [metadata] loading metadata file: scene.ass +00:00:00 131MB | [ass] loading scene.ass ... +00:00:00 132MB | [ass] read 1435 bytes, 4 nodes in 0:00.00 +00:00:00 168MB | [ass] writing scene to C:/arnold/test.ass (mask=0xFFFF) ... +00:00:00 168MB | [ass] wrote 1794 bytes, 5 nodes in 0:00.00 +00:00:00 168MB | +00:00:00 168MB | authorizing with license manager: network ... +00:00:00 168MB WARNING | rendering with watermarks because of failed authorization: +00:00:00 168MB | [clm.v1] license server was not set (51) +00:00:00 168MB | environment variables: +00:00:00 168MB | ARNOLD_LICENSE_ORDER = (not set) +00:00:00 168MB | ARNOLD_LICENSE_MANAGER = (not set) +00:00:00 168MB | [rlm] solidangle_LICENSE = (not set) +00:00:00 168MB | [rlm] RLM_LICENSE = (not set) +00:00:00 168MB | [clm] ADSKFLEX_LICENSE_FILE = (not set) +00:00:00 168MB | [clm] LM_LICENSE_FILE = (not set) +00:00:00 168MB | +00:00:00 168MB | [color_manager] using color manager of type "color_manager_ocio" +00:00:00 169MB | [color_manager_ocio] using config file C:\arnold\sdk\latest\bin\../ocio/configs/arnold/config.ocio +00:00:00 169MB | [color_manager] rendering color space is "ACEScg" +00:00:00 183MB | +00:00:00 183MB | there are 0 lights and 2 objects: +00:00:00 183MB | 1 persp_camera +00:00:00 183MB | 1 utility +00:00:00 183MB | 1 driver_tiff +00:00:00 183MB | 1 gaussian_filter +00:00:00 183MB | 1 polymesh +00:00:00 183MB | 1 list_aggregate +00:00:00 183MB | 1 color_manager_ocio +00:00:00 183MB | +00:00:00 183MB | rendering image at 160 x 120, 3 AA samples +00:00:00 183MB | AA samples max +00:00:00 183MB | AA sample clamp +00:00:00 183MB | diffuse samples 2 / depth 1 +00:00:00 183MB | specular samples 2 / depth 1 +00:00:00 183MB | transmission samples 2 / depth 8 +00:00:00 183MB | volume indirect +00:00:00 183MB | total depth 10 +00:00:00 183MB | bssrdf samples 2 +00:00:00 183MB | transparency depth 10 +00:00:00 183MB | initializing 8 nodes +00:00:00 183MB | creating root object list ... +00:00:00 183MB | node initialization done in 0:00.00 (multithreaded) +00:00:00 183MB | updating 9 nodes +00:00:00 184MB | scene bounds: (-5.15929317 -3.00272703 -4.38875484) -> (5.15929317 7.84687805 4.38875484) +00:00:00 184MB | node update done in 0:00.00 (multithreaded) +00:00:00 184MB | [aov] parsing 1 output statements ... +00:00:00 184MB | [aov] registered driver: "mydriver" (driver_tiff) +00:00:00 184MB | [aov] * "RGBA" of type RGBA filtered by "myfilter" (gaussian_filter) +00:00:00 184MB | [aov] done preparing 2 AOVs for 1 output to 1 driver (0 deep AOVs) +00:00:00 186MB | starting 64 bucket workers of size 64x64 ... +00:00:00 202MB | [accel] polymesh bvh4 done - 0:00.00 (wall time) - 36 prims, 1 key +00:00:00 229MB | 20% done - 31 rays/pixel +00:00:00 235MB | 30% done - 2 rays/pixel +00:00:00 235MB | 40% done - 5 rays/pixel +00:00:00 246MB | 60% done - 9 rays/pixel +00:00:00 248MB | 80% done - 2 rays/pixel +00:00:00 248MB | 100% done - 0 rays/pixel +00:00:00 248MB | render done in 0:00.066 +00:00:00 248MB | [driver_tiff] writing file `testrender.tif' +00:00:00 250MB | render done +00:00:00 250MB | +00:00:00 250MB | ----------------------------------------------------------------------------------- +00:00:00 250MB | scene creation time 0:00.44 machine utilization (3.26%) +00:00:00 250MB | plugin loading 0:00.11 +00:00:00 250MB | unaccounted 0:00.33 +00:00:00 250MB | ----------------------------------------------------------------------------------- +00:00:00 250MB | frame time 0:00.10 machine utilization (37.75%) +00:00:00 250MB | rendering 0:00.06 +00:00:00 250MB | pixel rendering 0:00.06 +00:00:00 250MB | unaccounted 0:00.02 +00:00:00 250MB | ----------------------------------------------------------------------------------- +00:00:00 250MB | top session self-times by category +00:00:00 250MB | ----------------------------------------------------------------------------------- +00:00:00 250MB | top session self-times by node +00:00:00 250MB | ----------------------------------------------------------------------------------- +00:00:00 250MB | peak CPU memory used 250.08MB +00:00:00 250MB | at startup 65.71MB +00:00:00 250MB | plugins 6.59MB +00:00:00 250MB | AOV samples 3.02MB +00:00:00 250MB | output buffers 0.45MB +00:00:00 250MB | framebuffers 0.38MB +00:00:00 250MB | node overhead 0.00MB +00:00:00 250MB | message passing 0.13MB +00:00:00 250MB | memory pools 50.55MB +00:00:00 250MB | geometry 0.00MB +00:00:00 250MB | polymesh 0.00MB +00:00:00 250MB | accel structs 0.01MB +00:00:00 250MB | strings 24.25MB +00:00:00 250MB | unaccounted 98.99MB +00:00:00 250MB | ----------------------------------------------------------------------------------- +00:00:00 250MB | ray counts ( /pixel, /sample) (% total) (avg. hits) (max hits) +00:00:00 250MB | camera 178252 ( 9.28, 1.00) (100.00%) ( 0.16) ( 1) +00:00:00 250MB | total 178252 ( 9.28, 1.00) (100.00%) ( 0.16) ( 1) +00:00:00 250MB | by ray depth: 0 +00:00:00 250MB | total 100.0% +00:00:00 250MB | ----------------------------------------------------------------------------------- +00:00:00 250MB | shader calls ( /pixel, /sample) (% total) +00:00:00 250MB | primary 28688 ( 1.49, 0.16) (100.00%) +00:00:00 250MB | total 28688 ( 1.49, 0.16) (100.00%) +00:00:00 250MB | by ray depth: 0 +00:00:00 250MB | total 100.0% +00:00:00 250MB | ----------------------------------------------------------------------------------- +00:00:00 250MB | geometry (% hit ) (instances) ( init mem, final mem) +00:00:00 250MB | lists 1 (100.0%) ( 0) ( 0.00, 0.00) +00:00:00 250MB | polymeshes 1 (100.0%) ( 0) ( 0.00, 0.00) +00:00:00 250MB | ----------------------------------------------------------------------------------- +00:00:00 250MB | geometric elements ( min) ( avg.) ( max) +00:00:00 250MB | polygons 12 ( 12) ( 12.0) ( 12) +00:00:00 250MB | ----------------------------------------------------------------------------------- +00:00:00 250MB | triangle tessellation ( min) ( avg.) ( max) (/ element) (% total) +00:00:00 250MB | polymeshes 36 ( 36) ( 36.0) ( 36) ( 3.00) (100.00%) +00:00:00 250MB | unique triangles 36 +00:00:00 250MB | CPU memory use 0.00MB +00:00:00 250MB | vertices 0.00MB +00:00:00 250MB | vertex indices 0.00MB +00:00:00 250MB | polygon base offsets 0.00MB +00:00:00 250MB | polygon IDs 0.00MB +00:00:00 250MB | triangulation 0.00MB +00:00:00 250MB | packed normals 0.00MB +00:00:00 250MB | normal indices 0.00MB +00:00:00 250MB | uniform indices 0.00MB +00:00:00 250MB | largest polymeshes by triangle count +00:00:00 250MB | 36 tris -- /_proxy/mesh_0 +00:00:00 250MB | ----------------------------------------------------------------------------------- +00:00:00 250MB | acceleration structures: (% total) +00:00:00 250MB | list 1 ( 50.00%) +00:00:00 250MB | bvh 1 ( 50.00%) +00:00:00 250MB | total 2 (100.00%) +00:00:00 250MB | ----------------------------------------------------------------------------------- +00:00:00 250MB | number of warnings, warning type: +00:00:00 250MB | 1: rendering with watermarks because of failed authorization: +00:00:00 250MB | ----------------------------------------------------------------------------------- +00:00:00 250MB | +00:00:00 250MB | releasing resources +00:00:00 187MB | unloading 3 plugins +00:00:00 187MB | closing usd_proc.dll ... +00:00:00 187MB | closing alembic_proc.dll ... +00:00:00 187MB | closing cryptomatte.dll ... +00:00:00 187MB | unloading plugins done +00:00:00 187MB | Arnold shutdown diff --git a/testsuite/test_0168/ref/reference.tif b/testsuite/test_0168/ref/reference.tif index b1d506c9e0..476ca8ac5e 100644 Binary files a/testsuite/test_0168/ref/reference.tif and b/testsuite/test_0168/ref/reference.tif differ diff --git a/testsuite/test_0231/ref/reference.log b/testsuite/test_0231/ref/reference.log index 87a8ebcc85..05ea2425ad 100644 --- a/testsuite/test_0231/ref/reference.log +++ b/testsuite/test_0231/ref/reference.log @@ -1,269 +1,252 @@ -00:00:00 94MB | log started Tue May 24 16:30:56 2022 -00:00:00 94MB | Arnold 7.1.2.0 [5db60dc3] windows clang-10.0.1 oiio-2.4.0 osl-1.12.0 vdb-7.1.1 adlsdk-6.3.1.44 clmhub-2.0.0.235 rlm-14.1.3 optix-6.6.0 2022/05/18 09:40:32 -00:00:00 94MB | running on REMS4QL1726, pid=30120 +00:00:00 94MB | log started Mon Jan 23 14:26:32 2023 +00:00:00 94MB | Arnold 7.2.0.0 [f99ccc6f] windows x86_64 clang-10.0.1 oiio-2.4.1 osl-1.12.0 vdb-7.1.1 adlsdk-7.4.2.47 clmhub-3.1.1.43 rlm-14.2.5 optix-6.6.0 2023/01/13 17:16:45 +00:00:00 94MB | running on REMS4QL1726, pid=30248 00:00:00 94MB | 2 x Intel(R) Xeon(R) Gold 5218 CPU @ 2.30GHz (32 cores, 64 logical) with 65154MB -00:00:00 97MB | NVIDIA driver version 472.39 (Optix 60801) -00:00:00 97MB | GPU 0: Quadro RTX 4000 @ 1545MHz (compute 7.5) with 8192MB (6390MB available) (NVLink:0) -00:00:00 97MB | Windows 10 (version 10.0, build 19044) -00:00:00 97MB | soft limit for open files is set at 2048 -00:00:00 97MB | -00:00:00 115MB | [color_manager_ocio] default ocio.config found in C:\arnold\sdk\latest\bin\../ocio/configs/arnold/config.ocio -00:00:00 115MB | loading plugins from C:\arnold\arnold-usd\build\windows_x86_64\msvc_opt\usd-0.21.8_arnold-7.1.2.0\procedural ... -00:00:00 118MB | usd_proc.dll: usd uses Arnold 7.1.2.0 -00:00:00 118MB | loaded 1 plugins from 1 lib(s) in 0:00.09 -00:00:00 118MB | loading plugins from C:\arnold\sdk\latest\bin\..\plugins ... -00:00:00 119MB | alembic_proc.dll: alembic uses Arnold 7.1.2.0 -00:00:00 119MB | cryptomatte.dll: cryptomatte uses Arnold 7.1.2.0 -00:00:00 119MB | cryptomatte.dll: cryptomatte_filter uses Arnold 7.1.2.0 -00:00:00 119MB | cryptomatte.dll: cryptomatte_manifest_driver uses Arnold 7.1.2.0 -00:00:00 119MB | skipping already loaded plugin: C:\arnold\sdk\latest\bin\..\plugins\usd_proc.dll ... -00:00:00 119MB | loaded 4 plugins from 2 lib(s) in 0:00.01 -00:00:00 119MB | [color_manager_ocio] default ocio.config found in C:\arnold\sdk\latest\bin\../ocio/configs/arnold/config.ocio -00:00:00 135MB | [kick] command: C:\arnold\sdk\latest\bin\kick test_resaved.ass -dw -r 160 120 -sm lambert -bs 16 -o testrender.tif -set driver_tiff.dither false -nocrashpopup -dp -v 6 -00:00:00 135MB | loading plugins from . ... -00:00:00 135MB | no plugins loaded -00:00:00 140MB | [metadata] loading metadata file: test_resaved.ass -00:00:00 141MB | [ass] loading test_resaved.ass ... -00:00:00 141MB | [ass] read 35644 bytes, 20 nodes in 0:00.00 -00:00:00 141MB | [kick] applying 2 attr value overrides -00:00:00 141MB | -00:00:00 141MB | authorizing with default license managers: rlm, network, user ... -00:00:07 146MB WARNING | rendering with watermarks because of failed authorization: -00:00:07 146MB | [rlm] error initializing license system: -00:00:07 146MB | [rlm] * Can't read license data (-102)No such file or directory (errno: 2) -00:00:07 146MB | [clm.v1] license server was not set (51) -00:00:07 146MB | [clm.v2] SERVICE (14): entitlement expired -00:00:07 146MB | environment variables: -00:00:07 146MB | ARNOLD_LICENSE_ORDER = (not set) -00:00:07 146MB | ARNOLD_LICENSE_MANAGER = (not set) -00:00:07 146MB | [rlm] solidangle_LICENSE = (not set) -00:00:07 146MB | [rlm] RLM_LICENSE = (not set) -00:00:07 146MB | [clm] ADSKFLEX_LICENSE_FILE = (not set) -00:00:07 146MB | [clm] LM_LICENSE_FILE = (not set) -00:00:07 146MB | -00:00:07 146MB | [color_manager] using color manager of type "color_manager_ocio" -00:00:07 147MB | [color_manager_ocio] using config file C:\arnold\sdk\latest\bin\../ocio/configs/arnold/config.ocio -00:00:07 147MB | [color_manager] rendering color space is "ACEScg" -00:00:07 161MB | -00:00:07 161MB | there are 1 light and 10 objects: -00:00:07 161MB | 1 persp_camera -00:00:07 161MB | 1 skydome_light -00:00:07 161MB | 2 utility -00:00:07 161MB | 3 standard_surface -00:00:07 161MB | 2 ramp_rgb -00:00:07 161MB | 2 user_data_float -00:00:07 161MB | 1 user_data_rgb -00:00:07 161MB | 1 driver_tiff -00:00:07 161MB | 1 gaussian_filter -00:00:07 161MB | 3 polymesh -00:00:07 161MB | 2 list_aggregate -00:00:07 161MB | 3 instancer -00:00:07 161MB | 2 color_manager_ocio -00:00:07 161MB | 3 usd -00:00:07 161MB | -00:00:07 161MB | rendering image at 160 x 120, 1 AA sample -00:00:07 161MB | AA samples max -00:00:07 161MB | AA sample clamp -00:00:07 161MB | diffuse -00:00:07 161MB | specular -00:00:07 161MB | transmission samples 2 / depth 2 -00:00:07 161MB | volume indirect -00:00:07 161MB | total depth 10 -00:00:07 161MB | bssrdf samples 2 -00:00:07 161MB | transparency depth 10 -00:00:07 161MB | initializing 25 nodes ... -00:00:07 161MB | [instancer] /instances_rbg: processing per instance parameter 'instance_mycolor' -00:00:07 161MB | [instancer] /instances_rbg: creating 42 instances -ReadArray nsides - converting from array to this -ReadArray vlist -sssssssame data -00:00:07 192MB | [proc] /instances_rbg/Prototypes/torus1: loaded 1 nodes (1 objects, 0 shaders) -00:00:07 192MB | [proc] /instances_rbg: loaded 42 nodes (42 objects, 0 shaders) -00:00:07 192MB | [instancer] /instances_float32: processing per instance parameter 'instance_myfloat' -00:00:07 192MB | [instancer] /instances_float32: creating 42 instances -ReadArray nsides - converting from array to this -ReadArray vlist -sssssssame data -00:00:07 192MB | [proc] /instances_float32/Prototypes/torus1: loaded 1 nodes (1 objects, 0 shaders) -00:00:07 192MB | [proc] /instances_float32: loaded 42 nodes (42 objects, 0 shaders) -00:00:07 192MB | [instancer] /instances_float64: processing per instance parameter 'instance_myfloat' -00:00:07 192MB | [instancer] /instances_float64: creating 42 instances -ReadArray nsides - converting from array to this -ReadArray vlist -sssssssame data -00:00:07 192MB | [proc] /instances_float64/Prototypes/torus1: loaded 1 nodes (1 objects, 0 shaders) -00:00:07 192MB | [proc] /instances_float64: loaded 42 nodes (42 objects, 0 shaders) -00:00:07 194MB | creating root object list ... -00:00:07 194MB | the following procedurals were initialized serially: -00:00:07 195MB | instancer (3 instances) -00:00:07 195MB | node initialization done in 0:00.12 (multithreaded) -00:00:07 195MB | updating 155 nodes ... -00:00:07 199MB | /lights/domelight1: skydome_light using 1 sample, 2 volume samples -00:00:07 200MB | scene bounds: (-4.14066219 -1.15236509 -1.14070487) -> (4.14066219 1.15236509 1.14080429) -00:00:07 200MB | node update done in 0:00.00 (multithreaded) -00:00:07 203MB | [aov] parsing 1 output statements ... -00:00:07 204MB | [aov] registered driver: "kick_driver" (driver_tiff) -00:00:07 204MB | [aov] * "RGBA" of type RGBA filtered by "kick_filter" (gaussian_filter) -00:00:07 204MB | [aov] done preparing 2 AOVs for 1 output to 1 driver (0 deep AOVs) -00:00:07 206MB | starting 64 bucket workers of size 16x16 ... -00:00:07 209MB | 0% done - 2 rays/pixel -00:00:07 215MB | [accel] list_aggregate bvh4 done - 0:00.00 (wall time) - 3 prims, 1 key -00:00:07 219MB | 5% done - 3 rays/pixel -00:00:07 219MB | [accel] procedural bvh4 done - 0:00.00 (wall time) - 42 prims, 1 key -00:00:07 231MB | [accel] procedural bvh4 done - 0:00.00 (wall time) - 42 prims, 1 key -00:00:07 232MB | [accel] procedural bvh4 done - 0:00.00 (wall time) - 42 prims, 1 key -00:00:07 234MB | 10% done - 2 rays/pixel -00:00:07 233MB | [accel] polymesh bvh4 done - 0:00.00 (wall time) - 288 prims, 1 key -00:00:07 233MB | [accel] polymesh bvh4 done - 0:00.00 (wall time) - 288 prims, 1 key -00:00:07 239MB | [accel] polymesh bvh4 done - 0:00.00 (wall time) - 288 prims, 1 key -00:00:07 239MB | 15% done - 6 rays/pixel -00:00:07 246MB | 20% done - 7 rays/pixel -00:00:07 251MB | 25% done - 6 rays/pixel -00:00:07 253MB | 30% done - 6 rays/pixel -00:00:07 253MB | 35% done - 2 rays/pixel -00:00:07 254MB | 40% done - 1 rays/pixel -00:00:07 254MB | 45% done - 2 rays/pixel -00:00:07 255MB | 50% done - 2 rays/pixel -00:00:07 255MB | 55% done - 1 rays/pixel -00:00:07 255MB | 60% done - 2 rays/pixel -00:00:07 256MB | 65% done - 0 rays/pixel -00:00:07 256MB | 70% done - 0 rays/pixel -00:00:07 256MB | 75% done - 0 rays/pixel -00:00:07 256MB | 80% done - 0 rays/pixel -00:00:07 256MB | 85% done - 0 rays/pixel -00:00:07 256MB | 90% done - 0 rays/pixel -00:00:07 256MB | 95% done - 0 rays/pixel -00:00:07 256MB | 100% done - 0 rays/pixel -00:00:07 256MB | render done in 0:00.025 -00:00:07 256MB | [driver_tiff] writing file `testrender.tif' -00:00:07 257MB | render done -00:00:07 258MB | -00:00:07 258MB | ----------------------------------------------------------------------------------- -00:00:07 258MB | scene creation time 0:00.25 machine utilization (0.19%) -00:00:07 258MB | unaccounted 0:00.25 -00:00:07 258MB | ----------------------------------------------------------------------------------- -00:00:07 258MB | frame time 0:06.92 machine utilization (0.50%) -00:00:07 258MB | node init 0:00.12 -00:00:07 258MB | rendering 0:00.02 -00:00:07 258MB | pixel rendering 0:00.02 -00:00:07 258MB | unaccounted 0:06.76 -00:00:07 258MB | ----------------------------------------------------------------------------------- -00:00:07 258MB | top session self-times by category -00:00:07 258MB | thread blocked 0:00.00 (34.29%) -00:00:07 258MB | node_init 0:00.00 (12.59%) -00:00:07 258MB | /instances_rbg/Prototypes/torus1 0:00.00 ( 7.77%) -00:00:07 258MB | /instances_float32/Prototypes/torus1 0:00.00 ( 3.17%) -00:00:07 258MB | /instances_float64/Prototypes/torus1 0:00.00 ( 1.64%) -00:00:07 258MB | Plugin loader 0:00.00 (11.26%) -00:00:07 258MB | AiSceneLoad 0:00.00 (11.14%) -00:00:07 258MB | AiMalloc 0:00.00 ( 4.90%) -00:00:07 258MB | TraceCameraRay 0:00.00 ( 4.90%) -00:00:07 258MB | accumulateBucketSamples 0:00.00 ( 4.90%) -00:00:07 258MB | AiMsgDebug 0:00.00 ( 3.27%) -00:00:07 258MB | BVH::build 0:00.00 ( 3.27%) -00:00:07 258MB | ----------------------------------------------------------------------------------- -00:00:07 258MB | top session self-times by node -00:00:07 258MB | Plugin loader 0:00.00 (11.26%) -00:00:07 258MB | AiSceneLoad 0:00.00 (11.14%) -00:00:07 258MB | polymesh:/instances_float32/Prototypes/torus1/mesh_0 0:00.00 ( 9.80%) -00:00:07 258MB | thread blocked 0:00.00 ( 8.16%) -00:00:07 258MB | BVH::build 0:00.00 ( 1.63%) -00:00:07 258MB | instancer:/instances_rbg 0:00.00 ( 8.16%) -00:00:07 258MB | thread blocked 0:00.00 ( 6.53%) -00:00:07 258MB | AiMsgDebug 0:00.00 ( 1.63%) -00:00:07 258MB | instancer:/instances_float64 0:00.00 ( 8.16%) -00:00:07 258MB | thread blocked 0:00.00 ( 6.53%) -00:00:07 258MB | AiMsgDebug 0:00.00 ( 1.63%) -00:00:07 258MB | thread blocked 0:00.00 ( 8.16%) -00:00:07 258MB | usd:/instances_rbg/Prototypes/torus1 (node_init) 0:00.00 ( 7.77%) -00:00:07 258MB | polymesh:/instances_rbg/Prototypes/torus1/mesh_0 0:00.00 ( 6.53%) -00:00:07 258MB | thread blocked 0:00.00 ( 4.90%) -00:00:07 258MB | BVH::build 0:00.00 ( 1.63%) -00:00:07 258MB | TraceCameraRay 0:00.00 ( 4.90%) -00:00:07 258MB | accumulateBucketSamples 0:00.00 ( 4.90%) -00:00:07 258MB | usd:/instances_float64/Prototypes/torus1 0:00.00 ( 3.28%) -00:00:07 258MB | node_init 0:00.00 ( 1.64%) -00:00:07 258MB | AiMalloc 0:00.00 ( 1.63%) -00:00:07 258MB | AiMalloc 0:00.00 ( 3.27%) -00:00:07 258MB | usd:/instances_float32/Prototypes/torus1 (node_init) 0:00.00 ( 3.17%) -00:00:07 258MB | driver_tiff:kick_driver 0:00.00 ( 3.06%) -00:00:07 258MB | driver_close 0:00.00 ( 1.54%) -00:00:07 258MB | driver_open 0:00.00 ( 1.53%) -00:00:07 258MB | ----------------------------------------------------------------------------------- -00:00:07 258MB | peak CPU memory used 258.07MB -00:00:07 258MB | at startup 97.40MB -00:00:07 258MB | AOV samples 0.64MB -00:00:07 258MB | output buffers 0.32MB -00:00:07 258MB | framebuffers 0.31MB -00:00:07 258MB | node overhead 0.10MB -00:00:07 258MB | instance overhead 0.05MB -00:00:07 258MB | message passing 0.13MB -00:00:07 258MB | memory pools 48.55MB -00:00:07 258MB | geometry 0.04MB -00:00:07 258MB | polymesh 0.03MB -00:00:07 258MB | accel structs 0.08MB -00:00:07 258MB | strings 24.25MB -00:00:07 258MB | profiler 0.01MB -00:00:07 258MB | unaccounted 86.20MB -00:00:07 258MB | ----------------------------------------------------------------------------------- -00:00:07 258MB | ray counts ( /pixel, /sample) (% total) (avg. hits) (max hits) -00:00:07 258MB | camera 24160 ( 1.26, 1.00) ( 62.20%) ( 0.08) ( 1) -00:00:07 258MB | shadow 14680 ( 0.76, 0.61) ( 37.80%) ( 0.29) ( 1) -00:00:07 258MB | total 38840 ( 2.02, 1.61) (100.00%) ( 0.16) ( 1) -00:00:07 258MB | by ray depth: 0 -00:00:07 258MB | total 100.0% -00:00:07 258MB | ----------------------------------------------------------------------------------- -00:00:07 258MB | shader calls ( /pixel, /sample) (% total) -00:00:07 258MB | primary 4918 ( 0.26, 0.20) (100.00%) -00:00:07 258MB | total 4918 ( 0.26, 0.20) (100.00%) -00:00:07 258MB | by ray depth: 0 -00:00:07 258MB | total 100.0% -00:00:07 258MB | ----------------------------------------------------------------------------------- -00:00:07 258MB | geometry (% hit ) (instances) ( init mem, final mem) -00:00:07 258MB | lists 1 (100.0%) ( 0) ( 0.00, 0.00) -00:00:07 258MB | procs 6 (100.0%) ( 126) ( 0.00, 0.00) -00:00:07 258MB | polymeshes 6 ( 50.0%) ( 0) ( 0.03, 0.03) -00:00:07 258MB | ----------------------------------------------------------------------------------- -00:00:07 258MB | geometric elements ( min) ( avg.) ( max) -00:00:07 258MB | objects (procs) 129 ( 1) ( 21.5) ( 42) -00:00:07 258MB | polygons 1728 ( 288) ( 288.0) ( 288) -00:00:07 258MB | ----------------------------------------------------------------------------------- -00:00:07 258MB | triangle tessellation ( min) ( avg.) ( max) (/ element) (% total) -00:00:07 258MB | polymeshes 1728 ( 576) ( 576.0) ( 576) ( 2.00) (100.00%) -00:00:07 258MB | unique triangles 1728 -00:00:07 258MB | visible triangles 72576 -00:00:07 258MB | CPU memory use 0.02MB -00:00:07 258MB | vertices 0.01MB -00:00:07 258MB | vertex indices 0.00MB -00:00:07 258MB | packed normals 0.00MB -00:00:07 258MB | normal indices 0.00MB -00:00:07 258MB | uniform indices 0.00MB -00:00:07 258MB | largest polymeshes by triangle count -00:00:07 258MB | 576 tris -- /instances_float32/Prototypes/torus1/mesh_0 -00:00:07 258MB | 576 tris -- /instances_float64/Prototypes/torus1/mesh_0 -00:00:07 258MB | 576 tris -- /instances_rbg/Prototypes/torus1/mesh_0 -00:00:07 258MB | ----------------------------------------------------------------------------------- -00:00:07 258MB | acceleration structures: (% total) -00:00:07 258MB | list 3 ( 30.00%) -00:00:07 258MB | bvh 7 ( 70.00%) -00:00:07 258MB | total 10 (100.00%) -00:00:07 258MB | ----------------------------------------------------------------------------------- -00:00:07 258MB | number of warnings, warning type: -00:00:07 258MB | 1: rendering with watermarks because of failed authorization: -00:00:07 258MB | ----------------------------------------------------------------------------------- -00:00:07 258MB | performance warnings: -00:00:07 258MB WARNING | Rendering CPU utilization was only 1%. Your render may be bound by a single threaded process or I/O. -00:00:07 258MB | ----------------------------------------------------------------------------------- -00:00:07 258MB | -00:00:07 258MB | releasing resources -00:00:07 199MB | -00:00:07 199MB | releasing resources -00:00:07 178MB | unloading 3 plugins -00:00:07 178MB | closing usd_proc.dll ... -00:00:07 178MB | closing alembic_proc.dll ... -00:00:07 178MB | closing cryptomatte.dll ... -00:00:07 178MB | unloading plugins done -00:00:07 178MB | Arnold shutdown +00:00:00 106MB | NVIDIA driver version 511.65 (Optix 60802) +00:00:00 107MB | GPU 0: Quadro RTX 4000 @ 1545MHz (compute 7.5) with 8191MB (5052MB available) (NVLink:0) +00:00:00 107MB | Windows 10 (version 10.0, build 19044) +00:00:00 107MB | soft limit for open files is set at 2048 +00:00:00 107MB | +00:00:00 125MB | [color_manager_ocio] default ocio.config found in C:\arnold\sdk\latest\bin\../ocio/configs/arnold/config.ocio +00:00:00 125MB | loading plugins from C:\arnold\arnold-usd\build\windows_x86_64\msvc_opt\usd-0.22.8_arnold-7.2.0.0\procedural ... +00:00:00 132MB | usd_proc.dll: usd uses Arnold 7.2.0.0 +00:00:00 132MB | loaded 1 plugins from 1 lib(s) in 0:00.10 +00:00:00 132MB | loading plugins from C:\arnold\sdk\latest\bin\..\plugins ... +00:00:00 132MB | alembic_proc.dll: alembic uses Arnold 7.2.0.0 +00:00:00 132MB | cryptomatte.dll: cryptomatte uses Arnold 7.2.0.0 +00:00:00 132MB | cryptomatte.dll: cryptomatte_filter uses Arnold 7.2.0.0 +00:00:00 132MB | cryptomatte.dll: cryptomatte_manifest_driver uses Arnold 7.2.0.0 +00:00:00 132MB | skipping already loaded plugin: C:\arnold\sdk\latest\bin\..\plugins\usd_proc.dll ... +00:00:00 132MB | loaded 4 plugins from 2 lib(s) in 0:00.00 +00:00:00 132MB | [color_manager_ocio] default ocio.config found in C:\arnold\sdk\latest\bin\../ocio/configs/arnold/config.ocio +00:00:00 148MB | [kick] command: C:\arnold\sdk\latest\bin\kick test.usda -dw -r 160 120 -sm lambert -bs 16 -o testrender.tif -set driver_tiff.dither false -nocrashpopup -dp -v 6 +00:00:00 148MB | loading plugins from . ... +00:00:00 148MB | no plugins loaded +00:00:00 187MB WARNING | USD arnold attribute ramp1c not recognized in ramp_rgb for /instances_float32/Prototypes/materials/arnold_materialbuilder1/ramp_rgb1 +00:00:00 187MB WARNING | USD arnold attribute ramp1interp not recognized in ramp_rgb for /instances_float32/Prototypes/materials/arnold_materialbuilder1/ramp_rgb1 +00:00:00 187MB WARNING | USD arnold attribute ramp1pos not recognized in ramp_rgb for /instances_float32/Prototypes/materials/arnold_materialbuilder1/ramp_rgb1 +00:00:00 187MB WARNING | USD arnold attribute ramp2c not recognized in ramp_rgb for /instances_float32/Prototypes/materials/arnold_materialbuilder1/ramp_rgb1 +00:00:00 187MB WARNING | USD arnold attribute ramp2interp not recognized in ramp_rgb for /instances_float32/Prototypes/materials/arnold_materialbuilder1/ramp_rgb1 +00:00:00 187MB | [kick] applying 2 attr value overrides +00:00:00 188MB | +00:00:00 188MB | authorizing with license manager: network ... +00:00:00 188MB WARNING | rendering with watermarks because of failed authorization: +00:00:00 188MB | [clm.v1] license server was not set (51) +00:00:00 188MB | environment variables: +00:00:00 188MB | ARNOLD_LICENSE_ORDER = (not set) +00:00:00 188MB | ARNOLD_LICENSE_MANAGER = (not set) +00:00:00 188MB | [rlm] solidangle_LICENSE = (not set) +00:00:00 188MB | [rlm] RLM_LICENSE = (not set) +00:00:00 188MB | [clm] ADSKFLEX_LICENSE_FILE = (not set) +00:00:00 188MB | [clm] LM_LICENSE_FILE = (not set) +00:00:00 188MB | +00:00:00 189MB | [color_manager] using color manager of type "color_manager_ocio" +00:00:00 189MB | [color_manager_ocio] using config file C:\arnold\sdk\latest\bin\../ocio/configs/arnold/config.ocio +00:00:00 190MB | [color_manager] rendering color space is "ACEScg" +00:00:00 203MB | +00:00:00 203MB | there are 1 light and 10 objects: +00:00:00 203MB | 1 persp_camera +00:00:00 203MB | 1 skydome_light +00:00:00 203MB | 2 utility +00:00:00 203MB | 3 standard_surface +00:00:00 203MB | 2 ramp_rgb +00:00:00 203MB | 2 user_data_float +00:00:00 203MB | 1 user_data_rgb +00:00:00 203MB | 1 driver_tiff +00:00:00 203MB | 1 gaussian_filter +00:00:00 203MB | 3 polymesh +00:00:00 203MB | 2 list_aggregate +00:00:00 203MB | 3 instancer +00:00:00 203MB | 2 color_manager_ocio +00:00:00 203MB | 3 usd +00:00:00 203MB | +00:00:00 203MB | rendering image at 160 x 120, 1 AA sample +00:00:00 203MB | AA samples max +00:00:00 203MB | AA sample clamp +00:00:00 203MB | diffuse +00:00:00 203MB | specular +00:00:00 203MB | transmission samples 2 / depth 2 +00:00:00 203MB | volume indirect +00:00:00 203MB | total depth 10 +00:00:00 203MB | bssrdf samples 2 +00:00:00 203MB | transparency depth 10 +00:00:00 203MB | initializing 25 nodes +00:00:00 203MB | [instancer] /instances_float32: processing per instance parameter 'instance_myfloat' +00:00:00 203MB | [instancer] /instances_float32: creating 42 instances +00:00:00 204MB | [proc] /instances_float32/Prototypes/torus1: loaded 1 nodes (1 objects, 0 shaders) +00:00:00 204MB | [proc] /instances_float32: loaded 42 nodes (42 objects, 0 shaders) +00:00:00 204MB | [instancer] /instances_rbg: processing per instance parameter 'instance_mycolor' +00:00:00 204MB | [instancer] /instances_rbg: creating 42 instances +00:00:00 204MB | [proc] /instances_rbg/Prototypes/torus1: loaded 1 nodes (1 objects, 0 shaders) +00:00:00 204MB | [proc] /instances_rbg: loaded 42 nodes (42 objects, 0 shaders) +00:00:00 204MB | [instancer] /instances_float64: processing per instance parameter 'instance_myfloat' +00:00:00 204MB | [instancer] /instances_float64: creating 42 instances +00:00:00 204MB | [proc] /instances_float64/Prototypes/torus1: loaded 1 nodes (1 objects, 0 shaders) +00:00:00 204MB | [proc] /instances_float64: loaded 42 nodes (42 objects, 0 shaders) +00:00:00 204MB | creating root object list ... +00:00:00 204MB | the following procedurals were initialized serially: +00:00:00 204MB | instancer (3 instances) +00:00:00 204MB | node initialization done in 0:00.01 (multithreaded) +00:00:00 204MB | updating 155 nodes +00:00:00 204MB | /lights/domelight1: skydome_light using 1 sample, 2 volume samples +00:00:00 205MB | scene bounds: (-4.14088345 -1.15243959 -1.14074349) -> (4.14088345 1.15243959 1.1407522) +00:00:00 205MB | node update done in 0:00.00 (multithreaded) +00:00:00 205MB | [aov] parsing 1 output statements ... +00:00:00 205MB | [aov] registered driver: "kick_driver" (driver_tiff) +00:00:00 205MB | [aov] * "RGBA" of type RGBA filtered by "kick_filter" (gaussian_filter) +00:00:00 205MB | [aov] done preparing 2 AOVs for 1 output to 1 driver (0 deep AOVs) +00:00:00 206MB | starting 64 bucket workers of size 16x16 ... +00:00:00 206MB | [accel] list_aggregate bvh4 done - 0:00.00 (wall time) - 3 prims, 1 key +00:00:00 206MB | [accel] procedural bvh4 done - 0:00.00 (wall time) - 42 prims, 1 key +00:00:00 206MB | [accel] polymesh bvh4 done - 0:00.00 (wall time) - 288 prims, 1 key +00:00:00 206MB | [accel] procedural bvh4 done - 0:00.00 (wall time) - 42 prims, 1 key +00:00:00 207MB | [accel] polymesh bvh4 done - 0:00.00 (wall time) - 288 prims, 1 key +00:00:00 207MB | [accel] procedural bvh4 done - 0:00.00 (wall time) - 42 prims, 1 key +00:00:00 207MB | [accel] polymesh bvh4 done - 0:00.00 (wall time) - 288 prims, 1 key +00:00:00 207MB | 0% done - 7 rays/pixel +00:00:00 208MB | 5% done - 5 rays/pixel +00:00:00 216MB | 10% done - 4 rays/pixel +00:00:00 225MB | 15% done - 2 rays/pixel +00:00:00 231MB | 20% done - 4 rays/pixel +00:00:00 237MB | 25% done - 4 rays/pixel +00:00:00 248MB | 30% done - 7 rays/pixel +00:00:00 249MB | 35% done - 2 rays/pixel +00:00:00 249MB | 40% done - 2 rays/pixel +00:00:00 249MB | 45% done - 1 rays/pixel +00:00:00 250MB | 50% done - 1 rays/pixel +00:00:00 250MB | 55% done - 1 rays/pixel +00:00:00 250MB | 60% done - 2 rays/pixel +00:00:00 250MB | 65% done - 0 rays/pixel +00:00:00 250MB | 70% done - 2 rays/pixel +00:00:00 250MB | 75% done - 0 rays/pixel +00:00:00 250MB | 80% done - 1 rays/pixel +00:00:00 250MB | 85% done - 0 rays/pixel +00:00:00 251MB | 90% done - 0 rays/pixel +00:00:00 251MB | 95% done - 1 rays/pixel +00:00:00 251MB | 100% done - 0 rays/pixel +00:00:00 251MB | render done in 0:00.033 +00:00:00 251MB | [driver_tiff] writing file `testrender.tif' +00:00:00 254MB | render done +00:00:00 254MB | +00:00:00 254MB | ----------------------------------------------------------------------------------- +00:00:00 254MB | scene creation time 0:00.26 machine utilization (7.44%) +00:00:00 254MB | unaccounted 0:00.26 +00:00:00 254MB | ----------------------------------------------------------------------------------- +00:00:00 254MB | frame time 0:00.09 machine utilization (3.95%) +00:00:00 254MB | node init 0:00.01 +00:00:00 254MB | rendering 0:00.03 +00:00:00 254MB | pixel rendering 0:00.03 +00:00:00 254MB | unaccounted 0:00.03 +00:00:00 254MB | ----------------------------------------------------------------------------------- +00:00:00 254MB | top session self-times by category +00:00:00 254MB | thread blocked 0:00.00 (20.75%) +00:00:00 254MB | Plugin loader 0:00.00 (15.63%) +00:00:00 254MB | AiSceneLoad 0:00.00 (13.34%) +00:00:00 254MB | RenderBucket 0:00.00 ( 9.22%) +00:00:00 254MB | AiMalloc 0:00.00 ( 6.92%) +00:00:00 254MB | accumulateBucketSamples 0:00.00 ( 6.92%) +00:00:00 254MB | AiMakeRay 0:00.00 ( 4.61%) +00:00:00 254MB | polymesh::intersect (/instances_float64/Prototypes/torus1/mesh_0) 0:00.00 ( 4.61%) +00:00:00 254MB | ray traversal+intersection 0:00.00 ( 4.50%) +00:00:00 254MB | TraceCameraRay 0:00.00 ( 2.31%) +00:00:00 254MB | BVH::intersect 0:00.00 ( 2.31%) +00:00:00 254MB | /instances_rbg 0:00.00 ( 2.31%) +00:00:00 254MB | AtString 0:00.00 ( 2.30%) +00:00:00 254MB | AtRenderSession::Setup 0:00.00 ( 2.29%) +00:00:00 254MB | node_update (ai_default_color_manager_ocio) 0:00.00 ( 2.16%) +00:00:00 254MB | initializeAllNodes 0:00.00 ( 2.14%) +00:00:00 254MB | ----------------------------------------------------------------------------------- +00:00:00 254MB | top session self-times by node +00:00:00 254MB | thread blocked 0:00.00 (20.75%) +00:00:00 254MB | Plugin loader 0:00.00 (15.63%) +00:00:00 254MB | AiSceneLoad 0:00.00 (13.34%) +00:00:00 254MB | RenderBucket 0:00.00 ( 9.22%) +00:00:00 254MB | AiMalloc 0:00.00 ( 6.92%) +00:00:00 254MB | accumulateBucketSamples 0:00.00 ( 6.92%) +00:00:00 254MB | standard_surface:/instances_float64/Prototypes/materials/arnold_materialbuilder1/standard_surface1 0:00.00 ( 4.61%) +00:00:00 254MB | AiMakeRay 0:00.00 ( 2.31%) +00:00:00 254MB | ray traversal+intersection 0:00.00 ( 2.31%) +00:00:00 254MB | polymesh:/instances_float64/Prototypes/torus1/mesh_0 0:00.00 ( 4.61%) +00:00:00 254MB | polymesh::intersect 0:00.00 ( 4.61%) +00:00:00 254MB | TraceCameraRay 0:00.00 ( 2.31%) +00:00:00 254MB | standard_surface:/instances_rbg/Prototypes/materials/arnold_materialbuilder1/standard_surface1 0:00.00 ( 2.31%) +00:00:00 254MB | AiMakeRay 0:00.00 ( 2.31%) +00:00:00 254MB | instancer:/instances_rbg (BVH::intersect) 0:00.00 ( 2.31%) +00:00:00 254MB | AtString 0:00.00 ( 2.30%) +00:00:00 254MB | AtRenderSession::Setup 0:00.00 ( 2.29%) +00:00:00 254MB | ray traversal+intersection 0:00.00 ( 2.20%) +00:00:00 254MB | color_manager_ocio:ai_default_color_manager_ocio (node_update) 0:00.00 ( 2.16%) +00:00:00 254MB | initializeAllNodes 0:00.00 ( 2.14%) +00:00:00 254MB | ----------------------------------------------------------------------------------- +00:00:00 254MB | peak CPU memory used 254.20MB +00:00:00 254MB | at startup 107.02MB +00:00:00 254MB | AOV samples 0.34MB +00:00:00 254MB | output buffers 0.20MB +00:00:00 254MB | framebuffers 0.31MB +00:00:00 254MB | node overhead 0.10MB +00:00:00 254MB | instance overhead 0.05MB +00:00:00 254MB | message passing 0.07MB +00:00:00 254MB | memory pools 30.55MB +00:00:00 254MB | geometry 0.04MB +00:00:00 254MB | polymesh 0.03MB +00:00:00 254MB | accel structs 0.08MB +00:00:00 254MB | strings 24.25MB +00:00:00 254MB | profiler 0.00MB +00:00:00 254MB | unaccounted 91.17MB +00:00:00 254MB | ----------------------------------------------------------------------------------- +00:00:00 254MB | ray counts ( /pixel, /sample) (% total) (avg. hits) (max hits) +00:00:00 254MB | camera 24160 ( 1.26, 1.00) ( 62.20%) ( 0.08) ( 1) +00:00:00 254MB | shadow 14680 ( 0.76, 0.61) ( 37.80%) ( 0.29) ( 1) +00:00:00 254MB | total 38840 ( 2.02, 1.61) (100.00%) ( 0.16) ( 1) +00:00:00 254MB | by ray depth: 0 +00:00:00 254MB | total 100.0% +00:00:00 254MB | ----------------------------------------------------------------------------------- +00:00:00 254MB | shader calls ( /pixel, /sample) (% total) +00:00:00 254MB | primary 4918 ( 0.26, 0.20) (100.00%) +00:00:00 254MB | total 4918 ( 0.26, 0.20) (100.00%) +00:00:00 254MB | by ray depth: 0 +00:00:00 254MB | total 100.0% +00:00:00 254MB | ----------------------------------------------------------------------------------- +00:00:00 254MB | geometry (% hit ) (instances) ( init mem, final mem) +00:00:00 254MB | lists 1 (100.0%) ( 0) ( 0.00, 0.00) +00:00:00 254MB | procs 6 (100.0%) ( 126) ( 0.00, 0.00) +00:00:00 254MB | polymeshes 6 ( 50.0%) ( 0) ( 0.03, 0.03) +00:00:00 254MB | ----------------------------------------------------------------------------------- +00:00:00 254MB | geometric elements ( min) ( avg.) ( max) +00:00:00 254MB | objects (procs) 129 ( 1) ( 21.5) ( 42) +00:00:00 254MB | polygons 1728 ( 288) ( 288.0) ( 288) +00:00:00 254MB | ----------------------------------------------------------------------------------- +00:00:00 254MB | triangle tessellation ( min) ( avg.) ( max) (/ element) (% total) +00:00:00 254MB | polymeshes 1728 ( 576) ( 576.0) ( 576) ( 2.00) (100.00%) +00:00:00 254MB | unique triangles 1728 +00:00:00 254MB | visible triangles 72576 +00:00:00 254MB | CPU memory use 0.02MB +00:00:00 254MB | vertices 0.01MB +00:00:00 254MB | vertex indices 0.00MB +00:00:00 254MB | packed normals 0.00MB +00:00:00 254MB | normal indices 0.00MB +00:00:00 254MB | uniform indices 0.00MB +00:00:00 254MB | largest polymeshes by triangle count +00:00:00 254MB | 576 tris -- /instances_float32/Prototypes/torus1/mesh_0 +00:00:00 254MB | 576 tris -- /instances_rbg/Prototypes/torus1/mesh_0 +00:00:00 254MB | 576 tris -- /instances_float64/Prototypes/torus1/mesh_0 +00:00:00 254MB | ----------------------------------------------------------------------------------- +00:00:00 254MB | acceleration structures: (% total) +00:00:00 254MB | list 3 ( 30.00%) +00:00:00 254MB | bvh 7 ( 70.00%) +00:00:00 254MB | total 10 (100.00%) +00:00:00 254MB | ----------------------------------------------------------------------------------- +00:00:00 254MB | number of warnings, warning type: +00:00:00 254MB | 12: USD arnold attribute %s not recognized in %s for %s +00:00:00 254MB | 1: rendering with watermarks because of failed authorization: +00:00:00 254MB | ----------------------------------------------------------------------------------- +00:00:00 254MB | +00:00:00 254MB | releasing resources +00:00:00 211MB | +00:00:00 211MB | releasing resources +00:00:00 190MB | unloading 3 plugins +00:00:00 190MB | closing usd_proc.dll ... +00:00:00 190MB | closing alembic_proc.dll ... +00:00:00 190MB | closing cryptomatte.dll ... +00:00:00 190MB | unloading plugins done +00:00:00 190MB | Arnold shutdown diff --git a/testsuite/test_0231/ref/reference.tif b/testsuite/test_0231/ref/reference.tif index 17aeefe073..de9a7e14f3 100644 Binary files a/testsuite/test_0231/ref/reference.tif and b/testsuite/test_0231/ref/reference.tif differ diff --git a/testsuite/test_1245/data/test.usda b/testsuite/test_1245/data/test.usda index 2b7030c19c..731c72afc5 100644 --- a/testsuite/test_1245/data/test.usda +++ b/testsuite/test_1245/data/test.usda @@ -13,7 +13,6 @@ def ArnoldOptions "options" int arnold:AA_samples = 3 int arnold:AA_seed = 0 string arnold:camera = "/persp/perspShape" - string arnold:color_manager = "defaultColorMgtGlobals" int arnold:GI_diffuse_depth = 1 int arnold:GI_specular_depth = 1 int arnold:GI_transmission_depth = 8 @@ -50,13 +49,6 @@ def "defaultArnoldDriver" } } -def ArnoldColorManagerOcio "defaultColorMgtGlobals" -{ - string arnold:color_space_linear = "ACEScg" - string arnold:config = "C:/Program Files/Autodesk/Maya2023/resources/OCIO-configs/Maya2022-default/config.ocio" - string arnold:name = "defaultColorMgtGlobals" -} - def Xform "persp" { def Camera "perspShape" diff --git a/testsuite/test_1334/data/test.usda b/testsuite/test_1334/data/test.usda index 9a337911ff..7e3403e727 100644 --- a/testsuite/test_1334/data/test.usda +++ b/testsuite/test_1334/data/test.usda @@ -13,7 +13,6 @@ def ArnoldOptions "options" int arnold:AA_samples = 3 int arnold:AA_seed = 0 string arnold:camera = "/persp/perspShape" - string arnold:color_manager = "defaultColorMgtGlobals" int arnold:GI_diffuse_depth = 1 int arnold:GI_specular_depth = 1 int arnold:GI_transmission_depth = 8 @@ -51,13 +50,6 @@ def "defaultArnoldDriver" } } -def ArnoldColorManagerOcio "defaultColorMgtGlobals" -{ - string arnold:color_space_linear = "ACEScg" - string arnold:config = "C:/Program Files/Autodesk/Maya2023/resources/OCIO-configs/Maya2022-default/config.ocio" - string arnold:name = "defaultColorMgtGlobals" -} - def Xform "persp" { def Camera "perspShape" diff --git a/testsuite/test_1366/data/test.usda b/testsuite/test_1366/data/test.usda index 1479ab5bcf..dcf673fc9d 100644 --- a/testsuite/test_1366/data/test.usda +++ b/testsuite/test_1366/data/test.usda @@ -27,6 +27,8 @@ def Mesh "pSphere1" ( interpolation = "faceVarying" ) int[] primvars:st:indices = [0, 1, 22, 21, 1, 2, 23, 22, 2, 3, 24, 23, 3, 4, 25, 24, 4, 5, 26, 25, 5, 6, 27, 26, 6, 7, 28, 27, 7, 8, 29, 28, 8, 9, 30, 29, 9, 10, 31, 30, 10, 11, 32, 31, 11, 12, 33, 32, 12, 13, 34, 33, 13, 14, 35, 34, 14, 15, 36, 35, 15, 16, 37, 36, 16, 17, 38, 37, 17, 18, 39, 38, 18, 19, 40, 39, 19, 20, 41, 40, 21, 22, 43, 42, 22, 23, 44, 43, 23, 24, 45, 44, 24, 25, 46, 45, 25, 26, 47, 46, 26, 27, 48, 47, 27, 28, 49, 48, 28, 29, 50, 49, 29, 30, 51, 50, 30, 31, 52, 51, 31, 32, 53, 52, 32, 33, 54, 53, 33, 34, 55, 54, 34, 35, 56, 55, 35, 36, 57, 56, 36, 37, 58, 57, 37, 38, 59, 58, 38, 39, 60, 59, 39, 40, 61, 60, 40, 41, 62, 61, 42, 43, 64, 63, 43, 44, 65, 64, 44, 45, 66, 65, 45, 46, 67, 66, 46, 47, 68, 67, 47, 48, 69, 68, 48, 49, 70, 69, 49, 50, 71, 70, 50, 51, 72, 71, 51, 52, 73, 72, 52, 53, 74, 73, 53, 54, 75, 74, 54, 55, 76, 75, 55, 56, 77, 76, 56, 57, 78, 77, 57, 58, 79, 78, 58, 59, 80, 79, 59, 60, 81, 80, 60, 61, 82, 81, 61, 62, 83, 82, 63, 64, 85, 84, 64, 65, 86, 85, 65, 66, 87, 86, 66, 67, 88, 87, 67, 68, 89, 88, 68, 69, 90, 89, 69, 70, 91, 90, 70, 71, 92, 91, 71, 72, 93, 92, 72, 73, 94, 93, 73, 74, 95, 94, 74, 75, 96, 95, 75, 76, 97, 96, 76, 77, 98, 97, 77, 78, 99, 98, 78, 79, 100, 99, 79, 80, 101, 100, 80, 81, 102, 101, 81, 82, 103, 102, 82, 83, 104, 103, 84, 85, 106, 105, 85, 86, 107, 106, 86, 87, 108, 107, 87, 88, 109, 108, 88, 89, 110, 109, 89, 90, 111, 110, 90, 91, 112, 111, 91, 92, 113, 112, 92, 93, 114, 113, 93, 94, 115, 114, 94, 95, 116, 115, 95, 96, 117, 116, 96, 97, 118, 117, 97, 98, 119, 118, 98, 99, 120, 119, 99, 100, 121, 120, 100, 101, 122, 121, 101, 102, 123, 122, 102, 103, 124, 123, 103, 104, 125, 124, 105, 106, 127, 126, 106, 107, 128, 127, 107, 108, 129, 128, 108, 109, 130, 129, 109, 110, 131, 130, 110, 111, 132, 131, 111, 112, 133, 132, 112, 113, 134, 133, 113, 114, 135, 134, 114, 115, 136, 135, 115, 116, 137, 136, 116, 117, 138, 137, 117, 118, 139, 138, 118, 119, 140, 139, 119, 120, 141, 140, 120, 121, 142, 141, 121, 122, 143, 142, 122, 123, 144, 143, 123, 124, 145, 144, 124, 125, 146, 145, 126, 127, 148, 147, 127, 128, 149, 148, 128, 129, 150, 149, 129, 130, 151, 150, 130, 131, 152, 151, 131, 132, 153, 152, 132, 133, 154, 153, 133, 134, 155, 154, 134, 135, 156, 155, 135, 136, 157, 156, 136, 137, 158, 157, 137, 138, 159, 158, 138, 139, 160, 159, 139, 140, 161, 160, 140, 141, 162, 161, 141, 142, 163, 162, 142, 143, 164, 163, 143, 144, 165, 164, 144, 145, 166, 165, 145, 146, 167, 166, 147, 148, 169, 168, 148, 149, 170, 169, 149, 150, 171, 170, 150, 151, 172, 171, 151, 152, 173, 172, 152, 153, 174, 173, 153, 154, 175, 174, 154, 155, 176, 175, 155, 156, 177, 176, 156, 157, 178, 177, 157, 158, 179, 178, 158, 159, 180, 179, 159, 160, 181, 180, 160, 161, 182, 181, 161, 162, 183, 182, 162, 163, 184, 183, 163, 164, 185, 184, 164, 165, 186, 185, 165, 166, 187, 186, 166, 167, 188, 187, 168, 169, 190, 189, 169, 170, 191, 190, 170, 171, 192, 191, 171, 172, 193, 192, 172, 173, 194, 193, 173, 174, 195, 194, 174, 175, 196, 195, 175, 176, 197, 196, 176, 177, 198, 197, 177, 178, 199, 198, 178, 179, 200, 199, 179, 180, 201, 200, 180, 181, 202, 201, 181, 182, 203, 202, 182, 183, 204, 203, 183, 184, 205, 204, 184, 185, 206, 205, 185, 186, 207, 206, 186, 187, 208, 207, 187, 188, 209, 208, 189, 190, 211, 210, 190, 191, 212, 211, 191, 192, 213, 212, 192, 193, 214, 213, 193, 194, 215, 214, 194, 195, 216, 215, 195, 196, 217, 216, 196, 197, 218, 217, 197, 198, 219, 218, 198, 199, 220, 219, 199, 200, 221, 220, 200, 201, 222, 221, 201, 202, 223, 222, 202, 203, 224, 223, 203, 204, 225, 224, 204, 205, 226, 225, 205, 206, 227, 226, 206, 207, 228, 227, 207, 208, 229, 228, 208, 209, 230, 229, 210, 211, 232, 231, 211, 212, 233, 232, 212, 213, 234, 233, 213, 214, 235, 234, 214, 215, 236, 235, 215, 216, 237, 236, 216, 217, 238, 237, 217, 218, 239, 238, 218, 219, 240, 239, 219, 220, 241, 240, 220, 221, 242, 241, 221, 222, 243, 242, 222, 223, 244, 243, 223, 224, 245, 244, 224, 225, 246, 245, 225, 226, 247, 246, 226, 227, 248, 247, 227, 228, 249, 248, 228, 229, 250, 249, 229, 230, 251, 250, 231, 232, 253, 252, 232, 233, 254, 253, 233, 234, 255, 254, 234, 235, 256, 255, 235, 236, 257, 256, 236, 237, 258, 257, 237, 238, 259, 258, 238, 239, 260, 259, 239, 240, 261, 260, 240, 241, 262, 261, 241, 242, 263, 262, 242, 243, 264, 263, 243, 244, 265, 264, 244, 245, 266, 265, 245, 246, 267, 266, 246, 247, 268, 267, 247, 248, 269, 268, 248, 249, 270, 269, 249, 250, 271, 270, 250, 251, 272, 271, 252, 253, 274, 273, 253, 254, 275, 274, 254, 255, 276, 275, 255, 256, 277, 276, 256, 257, 278, 277, 257, 258, 279, 278, 258, 259, 280, 279, 259, 260, 281, 280, 260, 261, 282, 281, 261, 262, 283, 282, 262, 263, 284, 283, 263, 264, 285, 284, 264, 265, 286, 285, 265, 266, 287, 286, 266, 267, 288, 287, 267, 268, 289, 288, 268, 269, 290, 289, 269, 270, 291, 290, 270, 271, 292, 291, 271, 272, 293, 292, 273, 274, 295, 294, 274, 275, 296, 295, 275, 276, 297, 296, 276, 277, 298, 297, 277, 278, 299, 298, 278, 279, 300, 299, 279, 280, 301, 300, 280, 281, 302, 301, 281, 282, 303, 302, 282, 283, 304, 303, 283, 284, 305, 304, 284, 285, 306, 305, 285, 286, 307, 306, 286, 287, 308, 307, 287, 288, 309, 308, 288, 289, 310, 309, 289, 290, 311, 310, 290, 291, 312, 311, 291, 292, 313, 312, 292, 293, 314, 313, 294, 295, 316, 315, 295, 296, 317, 316, 296, 297, 318, 317, 297, 298, 319, 318, 298, 299, 320, 319, 299, 300, 321, 320, 300, 301, 322, 321, 301, 302, 323, 322, 302, 303, 324, 323, 303, 304, 325, 324, 304, 305, 326, 325, 305, 306, 327, 326, 306, 307, 328, 327, 307, 308, 329, 328, 308, 309, 330, 329, 309, 310, 331, 330, 310, 311, 332, 331, 311, 312, 333, 332, 312, 313, 334, 333, 313, 314, 335, 334, 315, 316, 337, 336, 316, 317, 338, 337, 317, 318, 339, 338, 318, 319, 340, 339, 319, 320, 341, 340, 320, 321, 342, 341, 321, 322, 343, 342, 322, 323, 344, 343, 323, 324, 345, 344, 324, 325, 346, 345, 325, 326, 347, 346, 326, 327, 348, 347, 327, 328, 349, 348, 328, 329, 350, 349, 329, 330, 351, 350, 330, 331, 352, 351, 331, 332, 353, 352, 332, 333, 354, 353, 333, 334, 355, 354, 334, 335, 356, 355, 336, 337, 358, 357, 337, 338, 359, 358, 338, 339, 360, 359, 339, 340, 361, 360, 340, 341, 362, 361, 341, 342, 363, 362, 342, 343, 364, 363, 343, 344, 365, 364, 344, 345, 366, 365, 345, 346, 367, 366, 346, 347, 368, 367, 347, 348, 369, 368, 348, 349, 370, 369, 349, 350, 371, 370, 350, 351, 372, 371, 351, 352, 373, 372, 352, 353, 374, 373, 353, 354, 375, 374, 354, 355, 376, 375, 355, 356, 377, 376, 357, 358, 379, 378, 358, 359, 380, 379, 359, 360, 381, 380, 360, 361, 382, 381, 361, 362, 383, 382, 362, 363, 384, 383, 363, 364, 385, 384, 364, 365, 386, 385, 365, 366, 387, 386, 366, 367, 388, 387, 367, 368, 389, 388, 368, 369, 390, 389, 369, 370, 391, 390, 370, 371, 392, 391, 371, 372, 393, 392, 372, 373, 394, 393, 373, 374, 395, 394, 374, 375, 396, 395, 375, 376, 397, 396, 376, 377, 398, 397, 1, 0, 399, 2, 1, 400, 3, 2, 401, 4, 3, 402, 5, 4, 403, 6, 5, 404, 7, 6, 405, 8, 7, 406, 9, 8, 407, 10, 9, 408, 11, 10, 409, 12, 11, 410, 13, 12, 411, 14, 13, 412, 15, 14, 413, 16, 15, 414, 17, 16, 415, 18, 17, 416, 19, 18, 417, 20, 19, 418, 378, 379, 419, 379, 380, 420, 380, 381, 421, 381, 382, 422, 382, 383, 423, 383, 384, 424, 384, 385, 425, 385, 386, 426, 386, 387, 427, 387, 388, 428, 388, 389, 429, 389, 390, 430, 390, 391, 431, 391, 392, 432, 392, 393, 433, 393, 394, 434, 394, 395, 435, 395, 396, 436, 396, 397, 437, 397, 398, 438] + + float primvars:arnold:disp_padding = 3 } def Scope "mtl" @@ -56,7 +58,7 @@ def Scope "mtl" { uniform token info:id = "ND_displacement_float" float inputs:displacement.connect = - float inputs:scale = 10 + float inputs:scale = 3 token outputs:out uniform float2 ui:nodegraph:node:pos = (-0.7439889, -0.39084333) } @@ -204,6 +206,7 @@ def DomeLight "DomeLight1" { color3f inputs:color = (0.7, 0.7, 0.7) asset inputs:texture:file = @@ + float primvars:arnold:camera = 0 } def Camera "persp1" ( @@ -213,8 +216,8 @@ def Camera "persp1" ( float2 clippingRange = (0.1, 10000) float focalLength = 35 float focusDistance = 5 - float horizontalAperture = 35.999928 - float verticalAperture = 23.999952 + float horizontalAperture = 30 + float verticalAperture = 20 float3 xformOp:rotateXYZ = (-27.938353, 45, -5.172681e-14) double3 xformOp:translate = (5.509993726141645, 4.132495294606208, 5.509993726141615) uniform token[] xformOpOrder = ["xformOp:translate", "xformOp:rotateXYZ"] diff --git a/testsuite/test_1366/ref/reference.log b/testsuite/test_1366/ref/reference.log index 694e523097..9645d573b7 100644 --- a/testsuite/test_1366/ref/reference.log +++ b/testsuite/test_1366/ref/reference.log @@ -1,329 +1,324 @@ -00:00:00 91MB | log started Thu Dec 8 08:39:34 2022 -00:00:00 91MB | Arnold 7.1.5.0 [c2b74326] windows x86_64 clang-10.0.1 oiio-2.4.1 osl-1.12.0 vdb-7.1.1 adlsdk-7.4.2.47 clmhub-3.1.1.43 rlm-14.2.5 optix-6.6.0 2022/11/30 09:32:52 -00:00:00 91MB | running on REMS4QL1726, pid=60616 -00:00:00 91MB | 2 x Intel(R) Xeon(R) Gold 5218 CPU @ 2.30GHz (32 cores, 64 logical) with 65154MB -00:00:00 103MB | NVIDIA driver version 511.65 (Optix 60802) -00:00:00 103MB | GPU 0: Quadro RTX 4000 @ 1545MHz (compute 7.5) with 8191MB (5893MB available) (NVLink:0) -00:00:00 103MB | Windows 10 (version 10.0, build 19044) -00:00:00 103MB | soft limit for open files is set at 2048 -00:00:00 103MB | -00:00:00 121MB | [color_manager_ocio] default ocio.config found in C:\arnold\sdk\latest\bin\../ocio/configs/arnold/config.ocio -00:00:00 121MB | loading plugins from C:\arnold\arnold-usd\build\windows_x86_64\msvc_opt\usd-0.22.8_arnold-7.1.5.0\procedural ... -00:00:00 127MB | usd_proc.dll: usd uses Arnold 7.1.5.0 -00:00:00 127MB | loaded 1 plugins from 1 lib(s) in 0:00.09 -00:00:00 127MB | loading plugins from C:\arnold\sdk\latest\bin\..\plugins ... -00:00:00 127MB | alembic_proc.dll: alembic uses Arnold 7.1.5.0 -00:00:00 127MB | cryptomatte.dll: cryptomatte uses Arnold 7.1.5.0 -00:00:00 127MB | cryptomatte.dll: cryptomatte_filter uses Arnold 7.1.5.0 -00:00:00 127MB | cryptomatte.dll: cryptomatte_manifest_driver uses Arnold 7.1.5.0 -00:00:00 127MB | skipping already loaded plugin: C:\arnold\sdk\latest\bin\..\plugins\usd_proc.dll ... -00:00:00 127MB | loaded 4 plugins from 2 lib(s) in 0:00.00 -00:00:00 127MB | [color_manager_ocio] default ocio.config found in C:\arnold\sdk\latest\bin\../ocio/configs/arnold/config.ocio -00:00:00 144MB | [kick] command: C:\arnold\sdk\latest\bin\kick test_resaved.ass -dw -r 160 120 -sm lambert -bs 16 -o testrender.tif -set driver_tiff.dither false -nocrashpopup -dp -v 6 -00:00:00 144MB | loading plugins from . ... -00:00:00 144MB | no plugins loaded -00:00:00 146MB | [metadata] loading metadata file: test_resaved.ass -00:00:00 147MB | [ass] loading test_resaved.ass ... -00:00:00 147MB | PATH -IC:\arnold\sdk\latest\bin\../materialx/stdlib/genosl/include -00:00:00 151MB | PATH -IC:\arnold\sdk\latest\bin\../materialx/stdlib/genosl/include -00:00:00 152MB | PATH -IC:\arnold\sdk\latest\bin\../materialx/stdlib/genosl/include -00:00:00 152MB | PATH -IC:\arnold\sdk\latest\bin\../materialx/stdlib/genosl/include -00:00:00 152MB | PATH -IC:\arnold\sdk\latest\bin\../materialx/stdlib/genosl/include -00:00:00 152MB | [ass] read 27105 bytes, 18 nodes in 0:00.07 -00:00:00 152MB | [kick] applying 2 attr value overrides -00:00:00 152MB | -00:00:00 152MB | authorizing with license manager: network ... -00:00:00 152MB WARNING | rendering with watermarks because of failed authorization: -00:00:00 152MB | [clm.v1] license server was not set (51) -00:00:00 152MB | environment variables: -00:00:00 152MB | ARNOLD_LICENSE_ORDER = (not set) -00:00:00 152MB | ARNOLD_LICENSE_MANAGER = (not set) -00:00:00 152MB | [rlm] solidangle_LICENSE = (not set) -00:00:00 152MB | [rlm] RLM_LICENSE = (not set) -00:00:00 152MB | [clm] ADSKFLEX_LICENSE_FILE = (not set) -00:00:00 152MB | [clm] LM_LICENSE_FILE = (not set) -00:00:00 152MB | -00:00:00 153MB | [color_manager] using color manager of type "color_manager_ocio" -00:00:00 153MB | [color_manager_ocio] using config file C:\arnold\sdk\latest\bin\../ocio/configs/arnold/config.ocio -00:00:00 154MB | [color_manager] rendering color space is "ACEScg" -00:00:00 167MB | -00:00:00 167MB | there are 1 light and 2 objects: -00:00:00 167MB | 1 persp_camera -00:00:00 167MB | 1 skydome_light -00:00:00 167MB | 1 image -00:00:00 167MB | 2 utility -00:00:00 167MB | 3 standard_surface -00:00:00 167MB | 1 rgba_to_float -00:00:00 167MB | 1 shuffle -00:00:00 167MB | 1 driver_tiff -00:00:00 167MB | 1 gaussian_filter -00:00:00 167MB | 1 polymesh -00:00:00 167MB | 2 list_aggregate -00:00:00 167MB | 2 color_manager_ocio -00:00:00 167MB | -00:00:00 167MB | rendering image at 160 x 120, 1 AA sample -00:00:00 167MB | AA samples max -00:00:00 167MB | AA sample clamp -00:00:00 167MB | diffuse -00:00:00 167MB | specular -00:00:00 167MB | transmission samples 2 / depth 2 -00:00:00 167MB | volume indirect -00:00:00 167MB | total depth 10 -00:00:00 167MB | bssrdf samples 2 -00:00:00 167MB | transparency depth 10 -00:00:00 167MB | initializing 23 nodes -00:00:00 168MB | creating root object list ... -00:00:00 168MB | node initialization done in 0:00.00 (multithreaded) -00:00:00 168MB | updating 24 nodes -00:00:00 168MB | /DomeLight1: skydome_light using 1 sample, 2 volume samples -00:00:00 168MB | scene bounds: (-1.00000024 -1 -1.00000048) -> (1 1 1.00000012) -00:00:00 168MB | node update done in 0:00.00 (multithreaded) -00:00:00 168MB | [aov] parsing 1 output statements ... -00:00:00 168MB | [aov] registered driver: "kick_driver" (driver_tiff) -00:00:00 168MB | [aov] * "RGBA" of type RGBA filtered by "kick_filter" (gaussian_filter) -00:00:00 168MB | [aov] done preparing 2 AOVs for 1 output to 1 driver (0 deep AOVs) -00:00:00 171MB | starting 64 bucket workers of size 16x16 ... -00:00:00 175MB | [osl] Loaded "osl_shader_0x13a117a9980" (took 0.00s) -00:00:00 175MB | [osl] Loaded "osl_shader_0x13a117a9a60" (took 0.00s) -00:00:00 175MB | [osl] Loaded "osl_shader_0x13a117a9c20" (took 0.00s) -00:00:00 185MB | 0% done - 3 rays/pixel -00:00:00 187MB | 5% done - 2 rays/pixel -00:00:00 189MB | 10% done - 2 rays/pixel -00:00:00 190MB | 15% done - 1 rays/pixel -00:00:00 190MB | 20% done - 1 rays/pixel -00:00:00 192MB | 25% done - 2 rays/pixel -00:00:00 194MB | 30% done - 2 rays/pixel -00:00:00 195MB | 35% done - 1 rays/pixel -00:00:00 195MB | 40% done - 1 rays/pixel -00:00:00 199MB | 45% done - 2 rays/pixel -00:00:00 199MB | 50% done - 1 rays/pixel -00:00:00 200MB | 55% done - 2 rays/pixel -00:00:00 201MB | 60% done - 1 rays/pixel -00:00:00 203MB | 65% done - 2 rays/pixel -00:00:00 203MB | 70% done - 1 rays/pixel -00:00:00 206MB | 75% done - 1 rays/pixel -00:00:00 207MB | 80% done - 0 rays/pixel -00:00:00 218MB | [maketx] maketx: no update required for "C:/arnold/arnold-usd/build/windows_x86_64/msvc_opt/usd-0.22.8_arnold-7.1.5.0/testsuite/test_1226/chessboard-pil.tx" -00:00:00 218MB | [accel] polymesh bvh4 done - 0:00.00 (wall time) - 400 prims, 1 key -00:00:00 218MB | [osl] Loaded "osl_shader_0x13a117a9d00" (took 0.00s) -00:00:00 221MB WARNING | [disp] /pSphere1: padding is at least 10x smaller than it should be! given disp_padding: 0, recommended: 9.79482841 -00:00:00 221MB | [disp] /pSphere1: displacement done - 382 vertices - 0:00.10 (wall time) -00:00:00 225MB | 85% done - 6 rays/pixel -00:00:00 230MB | 90% done - 14 rays/pixel -00:00:00 232MB | 95% done - 3 rays/pixel -00:00:00 233MB | 100% done - 0 rays/pixel -00:00:00 233MB | render done in 0:00.193 -00:00:00 233MB | [driver_tiff] writing file `testrender.tif' -00:00:00 234MB | render done -00:00:00 234MB | -00:00:00 234MB | ----------------------------------------------------------------------------------- -00:00:00 234MB | scene creation time 0:00.28 machine utilization (0.35%) -00:00:00 234MB | ass parsing 0:00.07 -00:00:00 234MB | unaccounted 0:00.20 -00:00:00 234MB | ----------------------------------------------------------------------------------- -00:00:00 234MB | frame time 0:00.24 machine utilization (8.95%) -00:00:00 234MB | driver init/close 0:00.01 -00:00:00 234MB | rendering 0:00.19 -00:00:00 234MB | displacement 0:00.09 -00:00:00 234MB | threads blocked 0:00.05 -00:00:00 234MB | pixel rendering 0:00.09 -00:00:00 234MB | unaccounted 0:00.03 -00:00:00 234MB | ----------------------------------------------------------------------------------- -00:00:00 234MB | top session self-times by category -00:00:00 234MB | displacement (/pSphere1) 0:00.05 (33.48%) -00:00:00 234MB | osl 0:00.04 (27.38%) -00:00:00 234MB | /mtl/float_displacement/displacement1 0:00.02 (14.13%) -00:00:00 234MB | /mtl/float_displacement/combine31 0:00.02 (13.25%) -00:00:00 234MB | thread blocked 0:00.02 (15.89%) -00:00:00 234MB | TextureResolveUseExistingTx 0:00.01 ( 6.58%) -00:00:00 234MB | polymesh::intersect (/pSphere1) 0:00.00 ( 5.71%) -00:00:00 234MB | TextureAutoTxFlags 0:00.00 ( 5.63%) -00:00:00 234MB | ----------------------------------------------------------------------------------- -00:00:00 234MB | top session self-times by node -00:00:00 234MB | polymesh:/pSphere1 0:00.07 (46.11%) -00:00:00 234MB | displacement 0:00.05 (33.48%) -00:00:00 234MB | thread blocked 0:00.00 ( 6.34%) -00:00:00 234MB | polymesh::intersect 0:00.00 ( 5.71%) -00:00:00 234MB | osl:/mtl/float_displacement/displacement1 0:00.04 (30.42%) -00:00:00 234MB | thread blocked 0:00.01 ( 9.55%) -00:00:00 234MB | TextureAutoTxFlags 0:00.00 ( 5.02%) -00:00:00 234MB | TextureOSL 0:00.00 ( 0.78%) -00:00:00 234MB | TextureResolveUseExistingTx 0:00.00 ( 0.63%) -00:00:00 234MB | osl:/mtl/float_displacement/combine31 0:00.03 (19.82%) -00:00:00 234MB | TextureResolveUseExistingTx 0:00.00 ( 5.95%) -00:00:00 234MB | TextureAutoTxFlags 0:00.00 ( 0.62%) -00:00:00 234MB | Plugin loader 0:00.00 ( 1.17%) -00:00:00 234MB | loadFile 0:00.00 ( 0.69%) -00:00:00 234MB | ADP 0:00.00 ( 0.50%) -00:00:00 234MB | ----------------------------------------------------------------------------------- -00:00:00 234MB | peak CPU memory used 234.56MB -00:00:00 234MB | at startup 103.91MB -00:00:00 234MB | AOV samples 0.30MB -00:00:00 234MB | output buffers 0.19MB -00:00:00 234MB | framebuffers 0.31MB -00:00:00 234MB | node overhead 0.02MB -00:00:00 234MB | message passing 0.13MB -00:00:00 234MB | memory pools 54.05MB -00:00:00 234MB | geometry 0.01MB -00:00:00 234MB | polymesh 0.01MB -00:00:00 234MB | accel structs 0.01MB -00:00:00 234MB | strings 24.25MB -00:00:00 234MB | texture cache 0.08MB -00:00:00 234MB | profiler 0.04MB -00:00:00 234MB | unaccounted 51.27MB -00:00:00 234MB | ----------------------------------------------------------------------------------- -00:00:00 234MB | ray counts ( /pixel, /sample) (% total) (avg. hits) (max hits) -00:00:00 234MB | camera 24160 ( 1.26, 1.00) ( 54.82%) ( 0.11) ( 1) -00:00:00 234MB | shadow 19912 ( 1.04, 0.82) ( 45.18%) ( 0.02) ( 1) -00:00:00 234MB | total 44072 ( 2.30, 1.82) (100.00%) ( 0.07) ( 1) -00:00:00 234MB | by ray depth: 0 -00:00:00 234MB | total 100.0% -00:00:00 234MB | ----------------------------------------------------------------------------------- -00:00:00 234MB | shader calls ( /pixel, /sample) (% total) -00:00:00 234MB | primary 5192 ( 0.27, 0.21) (100.00%) -00:00:00 234MB | total 5192 ( 0.27, 0.21) (100.00%) -00:00:00 234MB | by ray depth: 0 -00:00:00 234MB | total 100.0% -00:00:00 234MB | ----------------------------------------------------------------------------------- -00:00:00 234MB | displacement -00:00:00 234MB | meshes 1 -00:00:00 234MB | shader calls 477 -00:00:00 234MB | ----------------------------------------------------------------------------------- -00:00:00 234MB | geometry (% hit ) (instances) ( init mem, final mem) -00:00:00 234MB | lists 1 (100.0%) ( 0) ( 0.00, 0.00) -00:00:00 234MB | polymeshes 1 (100.0%) ( 0) ( 0.01, 0.01) -00:00:00 234MB | ----------------------------------------------------------------------------------- -00:00:00 234MB | geometric elements ( min) ( avg.) ( max) -00:00:00 234MB | polygons 400 ( 400) ( 400.0) ( 400) -00:00:00 234MB | ----------------------------------------------------------------------------------- -00:00:00 234MB | triangle tessellation ( min) ( avg.) ( max) (/ element) (% total) -00:00:00 234MB | polymeshes 760 ( 760) ( 760.0) ( 760) ( 1.90) (100.00%) -00:00:00 234MB | unique triangles 760 -00:00:00 234MB | CPU memory use 0.01MB -00:00:00 234MB | vertices 0.00MB -00:00:00 234MB | vertex indices 0.00MB -00:00:00 234MB | packed normals 0.00MB -00:00:00 234MB | normal indices 0.00MB -00:00:00 234MB | uv coords 0.00MB -00:00:00 234MB | uv coords idxs 0.00MB -00:00:00 234MB | uniform indices 0.00MB -00:00:00 234MB | userdata 0.00MB -00:00:00 234MB | largest polymeshes by triangle count -00:00:00 234MB | 760 tris -- /pSphere1 -00:00:00 234MB | ----------------------------------------------------------------------------------- -00:00:00 234MB | acceleration structures: (% total) -00:00:00 234MB | list 1 ( 50.00%) -00:00:00 234MB | bvh 1 ( 50.00%) -00:00:00 234MB | total 2 (100.00%) -00:00:00 234MB | ----------------------------------------------------------------------------------- -00:00:00 234MB | OSL ShadingSystem statistics (0000013A1B980870) ver 1.12.0, LLVM 10.0.1 -00:00:00 234MB | Options: optimize=2 llvm_optimize=1 debug=0 profile=0 llvm_debug=0 -00:00:00 234MB | llvm_debug_layers=0 llvm_debug_ops=0 llvm_target_host=1 -00:00:00 234MB | llvm_output_bitcode=0 llvm_dumpasm=0 llvm_prune_ir_strategy= -00:00:00 234MB | lazylayers=1 lazyglobals=1 lazyunconnected=1 lazyerror=1 -00:00:00 234MB | lazy_userdata=0 userdata_isconnected=0 clearmemory=0 -00:00:00 234MB | debugnan=0 debug_uninit=0 lockgeom_default=1 strict_messages=1 -00:00:00 234MB | error_repeats=0 range_checking=1 greedyjit=0 countlayerexecs=0 -00:00:00 234MB | opt_simplify_param=1 opt_constant_fold=1 opt_stale_assign=1 -00:00:00 234MB | opt_elide_useless_ops=1 opt_elide_unconnected_outputs=1 -00:00:00 234MB | opt_peephole=1 opt_coalesce_temps=1 opt_assign=1 opt_mix=1 -00:00:00 234MB | opt_merge_instances=1 opt_merge_instances_with_userdata=1 -00:00:00 234MB | opt_fold_getattribute=1 opt_middleman=1 opt_texture_handle=1 -00:00:00 234MB | opt_seed_bblock_aliases=1 llvm_jit_fma=0 llvm_jit_aggressive=0 -00:00:00 234MB | vector_width=4 opt_passes=10 no_noise=0 no_pointcloud=0 -00:00:00 234MB | force_derivs=0 allow_shader_replacement=0 exec_repeat=1 -00:00:00 234MB | opt_warnings=0 gpu_opt_error=0 -00:00:00 234MB | Shaders: -00:00:00 234MB | Requested: 6 -00:00:00 234MB | Loaded: 4 -00:00:00 234MB | Masters: 4 -00:00:00 234MB | Instances: 6 requested, 6 peak, 6 current -00:00:00 234MB | Time loading masters: 0.00s -00:00:00 234MB | Shading groups: 2 -00:00:00 234MB | Total instances in all groups: 6 -00:00:00 234MB | Avg instances per group: 3.0 -00:00:00 234MB | Shading contexts: 128 requested, 128 peak, 128 current -00:00:00 234MB | Compiled 2 groups, 6 instances -00:00:00 234MB | Merged 0 instances (0 initial, 0 after opt) in 0.00s -00:00:00 234MB | After optimization, 2 empty instances (33%) -00:00:00 234MB | After optimization, 0 empty groups (0%) -00:00:00 234MB | Optimized 107 ops to 15 (-86.0%) -00:00:00 234MB | Optimized 126 symbols to 38 (-69.8%) -00:00:00 234MB | Constant connections eliminated: 4 -00:00:00 234MB | Global connections eliminated: 0 -00:00:00 234MB | Middlemen eliminated: 0 -00:00:00 234MB | Derivatives needed on 6 / 38 symbols (15.8%) -00:00:00 234MB | Runtime optimization cost: 2.69s -00:00:00 234MB | locking: 2.59s -00:00:00 234MB | runtime specialization: 0.00s -00:00:00 234MB | LLVM setup: 0.01s -00:00:00 234MB | LLVM IR gen: 0.02s -00:00:00 234MB | LLVM optimize: 0.03s -00:00:00 234MB | LLVM JIT: 0.03s -00:00:00 234MB | Texture calls compiled: 2 (2 used handles) -00:00:00 234MB | Regex's compiled: 0 -00:00:00 234MB | Largest generated function local memory size: 0 KB -00:00:00 234MB | Number of get_userdata calls: 0 -00:00:00 234MB | Memory total: 42 KB requested, 32 KB peak, 21 KB current -00:00:00 234MB | Master memory: 15 KB requested, 15 KB peak, 15 KB current -00:00:00 234MB | Master ops: 4 KB requested, 4 KB peak, 4 KB current -00:00:00 234MB | Master args: 656 B requested, 656 B peak, 656 B current -00:00:00 234MB | Master syms: 8 KB requested, 8 KB peak, 8 KB current -00:00:00 234MB | Master defaults: 164 B requested, 164 B peak, 164 B current -00:00:00 234MB | Master consts: 104 B requested, 104 B peak, 104 B current -00:00:00 234MB | Instance memory: 27 KB requested, 17 KB peak, 5 KB current -00:00:00 234MB | Instance syms: 25 KB requested, 15 KB peak, 3 KB current -00:00:00 234MB | Instance param values: 268 B requested, 268 B peak, 268 B current -00:00:00 234MB | Instance connections: 264 B requested, 264 B peak, 264 B current -00:00:00 234MB | LLVM JIT memory: 0 B -00:00:00 234MB | ----------------------------------------------------------------------------------- -00:00:00 234MB | OpenImageIO Texture statistics -00:00:00 234MB | Options: gray_to_rgb=true flip_t=false max_tile_channels=6 -00:00:00 234MB | Queries/batches : -00:00:00 234MB | texture : 3073 queries in 3073 batches -00:00:00 234MB | texture 3d : 0 queries in 0 batches -00:00:00 234MB | shadow : 0 queries in 0 batches -00:00:00 234MB | environment : 0 queries in 0 batches -00:00:00 234MB | gettextureinfo : 0 queries -00:00:00 234MB | Interpolations : -00:00:00 234MB | closest : 0 -00:00:00 234MB | bilinear : 856 -00:00:00 234MB | bicubic : 6160 -00:00:00 234MB | Average anisotropic probes : 2.01 -00:00:00 234MB | Max anisotropy in the wild : 1e+06 -00:00:00 234MB | -00:00:00 234MB | OpenImageIO ImageCache statistics (0000013A0FB9E000) ver 2.4.1.1dev -00:00:00 234MB | Options: max_memory_MB=4096.0 max_open_files=1536 autotile=0 -00:00:00 234MB | autoscanline=true automip=true forcefloat=false -00:00:00 234MB | accept_untiled=true accept_unmipped=true deduplicate=true -00:00:00 234MB | unassociatedalpha=false failure_retries=0 openexr:core=0 -00:00:00 234MB | Images : 1 unique -00:00:00 234MB | ImageInputs : 1 created, 1 current, 1 peak -00:00:00 234MB | Total pixel data size of all images referenced : 52 KB -00:00:00 234MB | Total actual file size of all images referenced : 15 KB -00:00:00 234MB | Pixel data read : 84 KB -00:00:00 234MB | File I/O time : 0.0s (0.0s average per thread, for 64 threads) -00:00:00 234MB | File open time only : 0.0s -00:00:00 234MB | ImageInput mutex locking time : 0.2s -00:00:00 234MB | Tiles: 56 created, 21 current, 23 peak -00:00:00 234MB | total tile requests : 9549 -00:00:00 234MB | micro-cache misses : 220 (2.3%) -00:00:00 234MB | main cache misses : 56 (0.6%) -00:00:00 234MB | redundant reads: 0 tiles, 0 B -00:00:00 234MB | Peak cache memory : 84 KB -00:00:00 234MB | Broken or invalid files: 0 -00:00:00 234MB | ----------------------------------------------------------------------------------- -00:00:00 234MB | number of warnings, warning type: -00:00:00 234MB | 1: [disp] %s: padding is at least %.3gx smaller than it should be! given disp_padding: %.9g, recommended: %.9g -00:00:00 234MB | 1: rendering with watermarks because of failed authorization: -00:00:00 234MB | ----------------------------------------------------------------------------------- -00:00:00 234MB | -00:00:00 234MB | releasing resources -00:00:00 188MB | -00:00:00 188MB | releasing resources -00:00:00 165MB | unloading 3 plugins -00:00:00 165MB | closing usd_proc.dll ... -00:00:00 161MB | closing alembic_proc.dll ... -00:00:00 161MB | closing cryptomatte.dll ... -00:00:00 161MB | unloading plugins done -00:00:00 161MB | Arnold shutdown +00:00:00 94MB | log started Mon Jan 23 15:21:17 2023 +00:00:00 94MB | Arnold 7.2.0.0 [f99ccc6f] windows x86_64 clang-10.0.1 oiio-2.4.1 osl-1.12.0 vdb-7.1.1 adlsdk-7.4.2.47 clmhub-3.1.1.43 rlm-14.2.5 optix-6.6.0 2023/01/13 17:16:45 +00:00:00 94MB | running on REMS4QL1726, pid=80408 +00:00:00 94MB | 2 x Intel(R) Xeon(R) Gold 5218 CPU @ 2.30GHz (32 cores, 64 logical) with 65154MB +00:00:00 106MB | NVIDIA driver version 511.65 (Optix 60802) +00:00:00 106MB | GPU 0: Quadro RTX 4000 @ 1545MHz (compute 7.5) with 8191MB (5523MB available) (NVLink:0) +00:00:00 106MB | Windows 10 (version 10.0, build 19044) +00:00:00 106MB | soft limit for open files is set at 2048 +00:00:00 106MB | +00:00:00 124MB | [color_manager_ocio] default ocio.config found in C:\arnold\sdk\latest\bin\../ocio/configs/arnold/config.ocio +00:00:00 124MB | loading plugins from C:\arnold\arnold-usd\build\windows_x86_64\msvc_opt\usd-0.22.8_arnold-7.2.0.0\procedural ... +00:00:00 131MB | usd_proc.dll: usd uses Arnold 7.2.0.0 +00:00:00 131MB | loaded 1 plugins from 1 lib(s) in 0:00.10 +00:00:00 131MB | loading plugins from C:\arnold\sdk\latest\bin\..\plugins ... +00:00:00 132MB | alembic_proc.dll: alembic uses Arnold 7.2.0.0 +00:00:00 132MB | cryptomatte.dll: cryptomatte uses Arnold 7.2.0.0 +00:00:00 132MB | cryptomatte.dll: cryptomatte_filter uses Arnold 7.2.0.0 +00:00:00 132MB | cryptomatte.dll: cryptomatte_manifest_driver uses Arnold 7.2.0.0 +00:00:00 132MB | skipping already loaded plugin: C:\arnold\sdk\latest\bin\..\plugins\usd_proc.dll ... +00:00:00 132MB | loaded 4 plugins from 2 lib(s) in 0:00.00 +00:00:00 132MB | [color_manager_ocio] default ocio.config found in C:\arnold\sdk\latest\bin\../ocio/configs/arnold/config.ocio +00:00:00 148MB | [kick] command: C:\arnold\sdk\latest\bin\kick test.usda -dw -r 160 120 -sm lambert -bs 16 -o testrender.tif -set driver_tiff.dither false -nocrashpopup -dp -v 6 +00:00:00 148MB | loading plugins from . ... +00:00:00 148MB | no plugins loaded +00:00:00 233MB | PATH -IC:\arnold\sdk\latest\bin\../materialx/stdlib/genosl/include +00:00:00 199MB | PATH -IC:\arnold\sdk\latest\bin\../materialx/stdlib/genosl/include +00:00:00 200MB | PATH -IC:\arnold\sdk\latest\bin\../materialx/stdlib/genosl/include +00:00:00 201MB | PATH -IC:\arnold\sdk\latest\bin\../materialx/stdlib/genosl/include +00:00:00 201MB | PATH -IC:\arnold\sdk\latest\bin\../materialx/stdlib/genosl/include +00:00:00 201MB | [kick] applying 2 attr value overrides +00:00:00 201MB | +00:00:00 201MB | authorizing with license manager: network ... +00:00:00 202MB WARNING | rendering with watermarks because of failed authorization: +00:00:00 202MB | [clm.v1] license server was not set (51) +00:00:00 202MB | environment variables: +00:00:00 202MB | ARNOLD_LICENSE_ORDER = (not set) +00:00:00 202MB | ARNOLD_LICENSE_MANAGER = (not set) +00:00:00 202MB | [rlm] solidangle_LICENSE = (not set) +00:00:00 202MB | [rlm] RLM_LICENSE = (not set) +00:00:00 202MB | [clm] ADSKFLEX_LICENSE_FILE = (not set) +00:00:00 202MB | [clm] LM_LICENSE_FILE = (not set) +00:00:00 202MB | +00:00:00 202MB | [color_manager] using color manager of type "color_manager_ocio" +00:00:00 203MB | [color_manager_ocio] using config file C:\arnold\sdk\latest\bin\../ocio/configs/arnold/config.ocio +00:00:00 203MB | [color_manager] rendering color space is "ACEScg" +00:00:00 216MB | +00:00:00 216MB | there are 1 light and 2 objects: +00:00:00 216MB | 1 persp_camera +00:00:00 216MB | 1 skydome_light +00:00:00 216MB | 1 image +00:00:00 216MB | 2 utility +00:00:00 216MB | 3 standard_surface +00:00:00 216MB | 1 rgba_to_float +00:00:00 216MB | 1 shuffle +00:00:00 216MB | 1 driver_tiff +00:00:00 216MB | 1 gaussian_filter +00:00:00 216MB | 1 polymesh +00:00:00 216MB | 2 list_aggregate +00:00:00 216MB | 2 color_manager_ocio +00:00:00 216MB | +00:00:00 216MB | rendering image at 160 x 120, 1 AA sample +00:00:00 216MB | AA samples max +00:00:00 216MB | AA sample clamp +00:00:00 216MB | diffuse +00:00:00 216MB | specular +00:00:00 216MB | transmission samples 2 / depth 2 +00:00:00 216MB | volume indirect +00:00:00 216MB | total depth 10 +00:00:00 216MB | bssrdf samples 2 +00:00:00 216MB | transparency depth 10 +00:00:00 216MB | initializing 23 nodes +00:00:00 217MB | creating root object list ... +00:00:00 217MB | node initialization done in 0:00.00 (multithreaded) +00:00:00 217MB | updating 24 nodes +00:00:00 217MB | /DomeLight1: skydome_light using 1 sample, 2 volume samples +00:00:00 217MB | scene bounds: (-4 -4 -4.00000048) -> (4 4 4) +00:00:00 217MB | node update done in 0:00.00 (multithreaded) +00:00:00 218MB | [aov] parsing 1 output statements ... +00:00:00 218MB | [aov] registered driver: "kick_driver" (driver_tiff) +00:00:00 218MB | [aov] * "RGBA" of type RGBA filtered by "kick_filter" (gaussian_filter) +00:00:00 218MB | [aov] done preparing 2 AOVs for 1 output to 1 driver (0 deep AOVs) +00:00:00 220MB | starting 64 bucket workers of size 16x16 ... +00:00:00 224MB | [osl] Loaded "osl_shader_0x1f3f6a97000" (took 0.00s) +00:00:00 224MB | [osl] Loaded "osl_shader_0x1f3f6c17000" (took 0.00s) +00:00:00 224MB | [osl] Loaded "osl_shader_0x1f3f6c171c0" (took 0.00s) +00:00:00 255MB | [maketx] maketx: no update required for "C:/arnold/arnold-usd/build/windows_x86_64/msvc_opt/usd-0.22.8_arnold-7.2.0.0/testsuite/test_1366/chessboard-pil__ACEScg_autotx.tx" +00:00:00 258MB | [accel] polymesh bvh4 done - 0:00.00 (wall time) - 400 prims, 1 key +00:00:00 260MB | [osl] Loaded "osl_shader_0x1f3f6ac7000" (took 0.00s) +00:00:00 266MB | [disp] /pSphere1: displacement done - 382 vertices - 0:00.09 (wall time) +00:00:00 266MB | 0% done - 6 rays/pixel +00:00:00 274MB | 5% done - 6 rays/pixel +00:00:00 274MB | 10% done - 1 rays/pixel +00:00:00 274MB | 15% done - 1 rays/pixel +00:00:00 274MB | 20% done - 3 rays/pixel +00:00:00 274MB | 25% done - 1 rays/pixel +00:00:00 274MB | 30% done - 1 rays/pixel +00:00:00 275MB | 35% done - 0 rays/pixel +00:00:00 275MB | 40% done - 1 rays/pixel +00:00:00 275MB | 45% done - 0 rays/pixel +00:00:00 275MB | 50% done - 0 rays/pixel +00:00:00 275MB | 55% done - 0 rays/pixel +00:00:00 286MB | 60% done - 16 rays/pixel +00:00:00 291MB | 65% done - 24 rays/pixel +00:00:00 292MB | 70% done - 8 rays/pixel +00:00:00 293MB | 75% done - 4 rays/pixel +00:00:00 293MB | 80% done - 6 rays/pixel +00:00:00 294MB | 85% done - 4 rays/pixel +00:00:00 294MB | 90% done - 0 rays/pixel +00:00:00 294MB | 95% done - 0 rays/pixel +00:00:00 294MB | 100% done - 0 rays/pixel +00:00:00 294MB | render done in 0:00.167 +00:00:00 294MB | [driver_tiff] writing file `testrender.tif' +00:00:00 296MB | render done +00:00:00 296MB | +00:00:00 296MB | ----------------------------------------------------------------------------------- +00:00:00 296MB | scene creation time 0:00.43 machine utilization (7.94%) +00:00:00 296MB | unaccounted 0:00.43 +00:00:00 296MB | ----------------------------------------------------------------------------------- +00:00:00 296MB | frame time 0:00.22 machine utilization (8.90%) +00:00:00 296MB | driver init/close 0:00.01 +00:00:00 296MB | rendering 0:00.16 +00:00:00 296MB | displacement 0:00.09 +00:00:00 296MB | threads blocked 0:00.04 +00:00:00 296MB | pixel rendering 0:00.07 +00:00:00 296MB | unaccounted 0:00.04 +00:00:00 296MB | ----------------------------------------------------------------------------------- +00:00:00 296MB | top session self-times by category +00:00:00 296MB | osl 0:00.05 (28.59%) +00:00:00 296MB | /mtl/float_displacement/combine31 0:00.03 (17.75%) +00:00:00 296MB | /mtl/float_displacement/displacement1 0:00.01 (10.84%) +00:00:00 296MB | displacement (/pSphere1) 0:00.04 (25.51%) +00:00:00 296MB | thread blocked 0:00.02 (14.84%) +00:00:00 296MB | TextureResolveUseExistingTx 0:00.01 ( 9.50%) +00:00:00 296MB | RenderBucket 0:00.01 ( 6.58%) +00:00:00 296MB | AiMaterialxGetOslShaderCode 0:00.00 ( 4.75%) +00:00:00 296MB | polymesh::intersect (/pSphere1) 0:00.00 ( 2.60%) +00:00:00 296MB | AiSceneLoad 0:00.00 ( 2.43%) +00:00:00 296MB | ----------------------------------------------------------------------------------- +00:00:00 296MB | top session self-times by node +00:00:00 296MB | polymesh:/pSphere1 0:00.05 (32.80%) +00:00:00 296MB | displacement 0:00.04 (25.51%) +00:00:00 296MB | thread blocked 0:00.00 ( 3.88%) +00:00:00 296MB | polymesh::intersect 0:00.00 ( 2.60%) +00:00:00 296MB | BVH::intersect 0:00.00 ( 0.55%) +00:00:00 296MB | osl:/mtl/float_displacement/displacement1 0:00.04 (23.72%) +00:00:00 296MB | thread blocked 0:00.01 ( 8.12%) +00:00:00 296MB | TextureResolveUseExistingTx 0:00.00 ( 4.23%) +00:00:00 296MB | osl:/mtl/float_displacement/combine31 0:00.04 (23.15%) +00:00:00 296MB | TextureResolveUseExistingTx 0:00.00 ( 5.27%) +00:00:00 296MB | RenderBucket 0:00.01 ( 6.58%) +00:00:00 296MB | AiMaterialxGetOslShaderCode 0:00.00 ( 4.75%) +00:00:00 296MB | thread blocked 0:00.00 ( 2.83%) +00:00:00 296MB | AiSceneLoad 0:00.00 ( 2.43%) +00:00:00 296MB | ----------------------------------------------------------------------------------- +00:00:00 296MB | peak CPU memory used 296.34MB +00:00:00 296MB | at startup 106.80MB +00:00:00 296MB | AOV samples 0.68MB +00:00:00 296MB | output buffers 0.33MB +00:00:00 296MB | framebuffers 0.31MB +00:00:00 296MB | node overhead 0.02MB +00:00:00 296MB | message passing 0.13MB +00:00:00 296MB | memory pools 59.55MB +00:00:00 296MB | geometry 0.01MB +00:00:00 296MB | polymesh 0.01MB +00:00:00 296MB | accel structs 0.01MB +00:00:00 296MB | strings 24.25MB +00:00:00 296MB | texture cache 0.09MB +00:00:00 296MB | profiler 0.04MB +00:00:00 296MB | unaccounted 104.12MB +00:00:00 296MB | ----------------------------------------------------------------------------------- +00:00:00 296MB | ray counts ( /pixel, /sample) (% total) (avg. hits) (max hits) +00:00:00 296MB | camera 24160 ( 1.26, 1.00) ( 33.84%) ( 0.27) ( 1) +00:00:00 296MB | shadow 47234 ( 2.46, 1.96) ( 66.16%) ( 0.75) ( 1) +00:00:00 296MB | total 71394 ( 3.72, 2.96) (100.00%) ( 0.59) ( 1) +00:00:00 296MB | by ray depth: 0 +00:00:00 296MB | total 100.0% +00:00:00 296MB | ----------------------------------------------------------------------------------- +00:00:00 296MB | shader calls ( /pixel, /sample) (% total) +00:00:00 296MB | primary 12954 ( 0.67, 0.54) (100.00%) +00:00:00 296MB | total 12954 ( 0.67, 0.54) (100.00%) +00:00:00 296MB | by ray depth: 0 +00:00:00 296MB | total 100.0% +00:00:00 296MB | ----------------------------------------------------------------------------------- +00:00:00 296MB | displacement +00:00:00 296MB | meshes 1 +00:00:00 296MB | shader calls 477 +00:00:00 296MB | ----------------------------------------------------------------------------------- +00:00:00 296MB | geometry (% hit ) (instances) ( init mem, final mem) +00:00:00 296MB | lists 1 (100.0%) ( 0) ( 0.00, 0.00) +00:00:00 296MB | polymeshes 1 (100.0%) ( 0) ( 0.01, 0.01) +00:00:00 296MB | ----------------------------------------------------------------------------------- +00:00:00 296MB | geometric elements ( min) ( avg.) ( max) +00:00:00 296MB | polygons 400 ( 400) ( 400.0) ( 400) +00:00:00 296MB | ----------------------------------------------------------------------------------- +00:00:00 296MB | triangle tessellation ( min) ( avg.) ( max) (/ element) (% total) +00:00:00 296MB | polymeshes 760 ( 760) ( 760.0) ( 760) ( 1.90) (100.00%) +00:00:00 296MB | unique triangles 760 +00:00:00 296MB | CPU memory use 0.01MB +00:00:00 296MB | vertices 0.00MB +00:00:00 296MB | vertex indices 0.00MB +00:00:00 296MB | packed normals 0.00MB +00:00:00 296MB | normal indices 0.00MB +00:00:00 296MB | uv coords 0.00MB +00:00:00 296MB | uv coords idxs 0.00MB +00:00:00 296MB | uniform indices 0.00MB +00:00:00 296MB | userdata 0.00MB +00:00:00 296MB | largest polymeshes by triangle count +00:00:00 296MB | 760 tris -- /pSphere1 +00:00:00 296MB | ----------------------------------------------------------------------------------- +00:00:00 296MB | acceleration structures: (% total) +00:00:00 296MB | list 1 ( 50.00%) +00:00:00 296MB | bvh 1 ( 50.00%) +00:00:00 296MB | total 2 (100.00%) +00:00:00 296MB | ----------------------------------------------------------------------------------- +00:00:00 296MB | OSL ShadingSystem statistics (000001F3F7C2A050) ver 1.12.0, LLVM 10.0.1 +00:00:00 296MB | Options: optimize=2 llvm_optimize=1 debug=0 profile=0 llvm_debug=0 +00:00:00 296MB | llvm_debug_layers=0 llvm_debug_ops=0 llvm_target_host=1 +00:00:00 296MB | llvm_output_bitcode=0 llvm_dumpasm=0 llvm_prune_ir_strategy= +00:00:00 296MB | lazylayers=1 lazyglobals=1 lazyunconnected=1 lazyerror=1 +00:00:00 296MB | lazy_userdata=0 userdata_isconnected=0 clearmemory=0 +00:00:00 296MB | debugnan=0 debug_uninit=0 lockgeom_default=1 strict_messages=1 +00:00:00 296MB | error_repeats=0 range_checking=1 greedyjit=0 countlayerexecs=0 +00:00:00 296MB | opt_simplify_param=1 opt_constant_fold=1 opt_stale_assign=1 +00:00:00 296MB | opt_elide_useless_ops=1 opt_elide_unconnected_outputs=1 +00:00:00 296MB | opt_peephole=1 opt_coalesce_temps=1 opt_assign=1 opt_mix=1 +00:00:00 296MB | opt_merge_instances=1 opt_merge_instances_with_userdata=1 +00:00:00 296MB | opt_fold_getattribute=1 opt_middleman=1 opt_texture_handle=1 +00:00:00 296MB | opt_seed_bblock_aliases=1 llvm_jit_fma=0 llvm_jit_aggressive=0 +00:00:00 296MB | vector_width=4 opt_passes=10 no_noise=0 no_pointcloud=0 +00:00:00 296MB | force_derivs=0 allow_shader_replacement=0 exec_repeat=1 +00:00:00 296MB | opt_warnings=0 gpu_opt_error=0 +00:00:00 296MB | Shaders: +00:00:00 296MB | Requested: 6 +00:00:00 296MB | Loaded: 4 +00:00:00 296MB | Masters: 4 +00:00:00 296MB | Instances: 6 requested, 6 peak, 6 current +00:00:00 296MB | Time loading masters: 0.00s +00:00:00 296MB | Shading groups: 2 +00:00:00 296MB | Total instances in all groups: 6 +00:00:00 296MB | Avg instances per group: 3.0 +00:00:00 296MB | Shading contexts: 128 requested, 128 peak, 128 current +00:00:00 296MB | Compiled 2 groups, 6 instances +00:00:00 296MB | Merged 0 instances (0 initial, 0 after opt) in 0.00s +00:00:00 296MB | After optimization, 2 empty instances (33%) +00:00:00 296MB | After optimization, 0 empty groups (0%) +00:00:00 296MB | Optimized 107 ops to 15 (-86.0%) +00:00:00 296MB | Optimized 126 symbols to 38 (-69.8%) +00:00:00 296MB | Constant connections eliminated: 4 +00:00:00 296MB | Global connections eliminated: 0 +00:00:00 296MB | Middlemen eliminated: 0 +00:00:00 296MB | Derivatives needed on 6 / 38 symbols (15.8%) +00:00:00 296MB | Runtime optimization cost: 2.98s +00:00:00 296MB | locking: 2.91s +00:00:00 296MB | runtime specialization: 0.00s +00:00:00 296MB | LLVM setup: 0.01s +00:00:00 296MB | LLVM IR gen: 0.02s +00:00:00 296MB | LLVM optimize: 0.02s +00:00:00 296MB | LLVM JIT: 0.02s +00:00:00 296MB | Texture calls compiled: 2 (2 used handles) +00:00:00 296MB | Regex's compiled: 0 +00:00:00 296MB | Largest generated function local memory size: 0 KB +00:00:00 296MB | Number of get_userdata calls: 0 +00:00:00 296MB | Memory total: 42 KB requested, 32 KB peak, 21 KB current +00:00:00 296MB | Master memory: 15 KB requested, 15 KB peak, 15 KB current +00:00:00 296MB | Master ops: 4 KB requested, 4 KB peak, 4 KB current +00:00:00 296MB | Master args: 656 B requested, 656 B peak, 656 B current +00:00:00 296MB | Master syms: 8 KB requested, 8 KB peak, 8 KB current +00:00:00 296MB | Master defaults: 164 B requested, 164 B peak, 164 B current +00:00:00 296MB | Master consts: 104 B requested, 104 B peak, 104 B current +00:00:00 296MB | Instance memory: 27 KB requested, 17 KB peak, 5 KB current +00:00:00 296MB | Instance syms: 25 KB requested, 15 KB peak, 3 KB current +00:00:00 296MB | Instance param values: 268 B requested, 268 B peak, 268 B current +00:00:00 296MB | Instance connections: 264 B requested, 264 B peak, 264 B current +00:00:00 296MB | LLVM JIT memory: 0 B +00:00:00 296MB | ----------------------------------------------------------------------------------- +00:00:00 296MB | OpenImageIO Texture statistics +00:00:00 296MB | Options: gray_to_rgb=true flip_t=false max_tile_channels=6 +00:00:00 296MB | Queries/batches : +00:00:00 296MB | texture : 6954 queries in 6954 batches +00:00:00 296MB | texture 3d : 0 queries in 0 batches +00:00:00 296MB | shadow : 0 queries in 0 batches +00:00:00 296MB | environment : 0 queries in 0 batches +00:00:00 296MB | gettextureinfo : 0 queries +00:00:00 296MB | Interpolations : +00:00:00 296MB | closest : 0 +00:00:00 296MB | bilinear : 2087 +00:00:00 296MB | bicubic : 28087 +00:00:00 296MB | Average anisotropic probes : 3.94 +00:00:00 296MB | Max anisotropy in the wild : 1e+06 +00:00:00 296MB | +00:00:00 296MB | OpenImageIO ImageCache statistics (000001F3B74BDFC0) ver 2.4.1.1dev +00:00:00 296MB | Options: max_memory_MB=4096.0 max_open_files=1536 autotile=0 +00:00:00 296MB | autoscanline=true automip=true forcefloat=false +00:00:00 296MB | accept_untiled=true accept_unmipped=true deduplicate=true +00:00:00 296MB | unassociatedalpha=false failure_retries=0 openexr:core=0 +00:00:00 296MB | Images : 1 unique +00:00:00 296MB | ImageInputs : 1 created, 1 current, 1 peak +00:00:00 296MB | Total pixel data size of all images referenced : 52 KB +00:00:00 296MB | Total actual file size of all images referenced : 17 KB +00:00:00 296MB | Pixel data read : 96 KB +00:00:00 296MB | File I/O time : 0.0s (0.0s average per thread, for 64 threads) +00:00:00 296MB | File open time only : 0.0s +00:00:00 296MB | ImageInput mutex locking time : 0.1s +00:00:00 296MB | Tiles: 60 created, 24 current, 29 peak +00:00:00 296MB | total tile requests : 46253 +00:00:00 296MB | micro-cache misses : 552 (1.2%) +00:00:00 296MB | main cache misses : 60 (0.1%) +00:00:00 296MB | redundant reads: 0 tiles, 0 B +00:00:00 296MB | Peak cache memory : 96 KB +00:00:00 296MB | Broken or invalid files: 0 +00:00:00 296MB | ----------------------------------------------------------------------------------- +00:00:00 296MB | number of warnings, warning type: +00:00:00 296MB | 1: rendering with watermarks because of failed authorization: +00:00:00 296MB | ----------------------------------------------------------------------------------- +00:00:00 296MB | +00:00:00 296MB | releasing resources +00:00:00 237MB | +00:00:00 237MB | releasing resources +00:00:00 214MB | unloading 3 plugins +00:00:00 214MB | closing usd_proc.dll ... +00:00:00 214MB | closing alembic_proc.dll ... +00:00:00 214MB | closing cryptomatte.dll ... +00:00:00 214MB | unloading plugins done +00:00:00 214MB | Arnold shutdown diff --git a/testsuite/test_1366/ref/reference.tif b/testsuite/test_1366/ref/reference.tif index f2bc5ba4b9..aa49f2a089 100644 Binary files a/testsuite/test_1366/ref/reference.tif and b/testsuite/test_1366/ref/reference.tif differ