CGRU / cgru

CGRU - AFANASY
http://cgru.info/
GNU Lesser General Public License v3.0
276 stars 111 forks source link

Natron #158

Closed ramellij closed 8 years ago

ramellij commented 8 years ago

Hi Timur,

I have problems trying to render a Natron project : my Workstation doesn't start rendering and every render nodes freeze at the middle of the first task group. I have those outputs :

for the Workstation :

Getting task output: Can't get file: c:/temp/afanasy\jobs\0\2.natron_test.ntp\tasks\0.6\output\3.txt No such file or directory Check task log. If there is 'update timeout' check firewall. Client should listen a port and server should be able to connect to it.

on every nodes :

Traceback (most recent call last): File "", line 2, in File "C:/Program Files/INRIA/Natron-2.0.0-RC3/Plugins/PySide/init.py", line 41, in _setupQtDirectories() File "C:/Program Files/INRIA/Natron-2.0.0-RC3/Plugins/PySide/init.py", line 9, in _setupQtDirectories from . import _utils ValueError: Attempted relative import in non-package

Do you know what it means? Do I need to refer to Natron's guys ? Thanks for your help JR

timurhai commented 8 years ago

Hi. I have not checked RC3, yet. Give me some time for it. For now you can run task command simple in a console. ( to request task command you can double-click task (to request job tasks you can double-click job))

cg-cnu commented 8 years ago

ValueError: Attempted relative import in non-package

Is already being reported at https://github.com/MrKepzie/Natron/issues/983, which is also a warning and don't stop the renders.

timurhai commented 8 years ago

Hi. I tried RC3 on windows and it works! I also noticed the same warning message in a tasks output, but there is no error: zero exit status and a good result (picture looks fine).

Where you saw that error output? Also where you saw "Getting task output: Can't get file:..."? Strange situation, if task was started and produced some output, server should save it to a file, but later it can't get it. If task was not really started, check firewall on a windows client machine. ( afanasy clients listen a port too, so client firewall can block task from server )

ramellij commented 8 years ago

On the first try I have this error for every node and workstation : "ValueError: Attempted relative import in non-package". It renders the first task correctly but doesn't jump to the next. Then I tryed to debug relanching all first node task and then I got "Getting task output: Can't get file:..." only for my workstation, my clients reacting as before.

ramellij commented 8 years ago

I reinstalled completly Afanasy and now I just have the first python warning and as before it renders my first task but can't jump to the next and in the afWatch it shows me some unrelated percentages (wich are freezed too) : capture

timurhai commented 8 years ago

It seems to be some other Afanasy error. Does it happen only if you are using Natron? (try other software, Blender for example) Try to see afrender and afserver logs, may be some error info there.

ramellij commented 8 years ago

It works for After Effect. And except "windows must die" I don't see specific info in logs ;)

ramellij commented 8 years ago

On server I have this : " ERROR Wed 11 Nov 14:12.33: AFCommon : writeFile: c:/temp/afanasy\jobs\0\3.test21\data.json No such file or directory " I cheked and the file is there. Testing on my laptop everything worked. Maybe I need to clean some temporary folders.

ramellij commented 8 years ago

OK My test with Natron was simply to read a sequence EXR and convert it in a JPG sequence. I tryed from PNG to JPG and it worked ! Maybe it's related to thumbnails...

timurhai commented 8 years ago

You can remove exr from this array: https://github.com/CGRU/cgru/blob/master/afanasy/config_default.json#L147

ps Remember, you should not modify that file (config_default.json), any overrides should be in cgru/config.json

ramellij commented 8 years ago

it changes nothing. I have this in render log : "AFERROR : TaskProcess : AssignProcessToJobObject failed with code = 5.

ramellij commented 8 years ago

and then in loop : "Warning : Task stopping time > 10 seconds. KILLING NOT TERMINATED TASK."

timurhai commented 8 years ago

Hi. Strange security politics: https://msdn.microsoft.com/en-us/library/windows/desktop/ms681382(v=vs.85).aspx It seems that afrender has not enough rights of AssignProcessToJobObject. This is needed to kill process with all its spawned childs by killing a job. Afrender kills task process on job stop(deletion), restart, or when parser parsed some error message. If you does not delete or restart job(task) and task has no error in the output this should not happen.

What is the entire afrender output from start to the first error?

btw, what OS(and version) are you using?

ramellij commented 8 years ago

I'm on windows 7 64 bit with your last release 2.0.7. The afrender log :

C:\cgru-windows\start\AFANASY>rem Name=Local Render...

C:\cgru-windows\start\AFANASY>rem Separator

C:\cgru-windows\start\AFANASY>call "C:\cgru-windows\start\AFANASY\render.cmd".. _setup.cmd

C:\cgru-windows\start\AFANASY>pushd "C:\cgru-windows\start\AFANASY\render.cmd". ._setup.cmd..

C:\cgru-windows\start\AFANASY>cd ..

C:\cgru-windows\start>call _setup.cmd

C:\cgru-windows\start>if not defined CGRU_LOCATION ( pushd _setup.cmd.. cd .. call setup.cmd popd ) CGRU_VERSION 2.0.7 Using CGRU Python: C:\cgru-windows\python Compilation date = 'Oct 16 2015 03:55:32' CGRU version = '2.0.7' Afanasy build revision = 'cb3f81872a907b2431a360d4b7f7cd977e553fa4' Python version = '3.4.1' Network Interfaces: {943567DA-897B-48CF-B324-14022A812495}: bc:ae:c5:17:e6:86 IPv6 Address: fe80::::::: IPv6 Address: fe80::::5149:c3c9:5bb3:8845 IPv6 Address: ff00::::::: IPv4 Address: 192.168.0.0 IPv4 Address: 192.168.0.40 IPv4 Address: 192.168.0.255 IPv4 Address: 224.0.0.0 IPv4 Address: 255.255.255.255 Windows Must Die: ImageMagick Studio library and utility programs Microsoft Visual C++ Runtime Library QuickTimeHelper-32.exe - Application Error Visual Studio Just-In-Time Debugger ON workstation-pc@workstation[0] Empty address Host: OS="windows 64" Capacity = 0, Max Tasks = 0, Power = 0

Resources: CPU = 3207 MHz x12 5% usr, 0% nice, 0% sys, 94% idle, 0% iow, 0% irq, 0% sirq load average: 0 0 0 Memory: 20471 Mb / 16180 Mb free Swap: 40940 Mb / 6291 Mb used Network: Recieved 18 Kb/sec, Send 112 Kb/sec IO: Read 0 Kb/sec, Write 0 Kb/sec, Busy = 0% HDD: 111 Gb / 12 Gb free Available addresses: IPv6 = '::' IP = '0.0.0.0' IPv6 is disabled by config. Using IPv4 addresses family. Listening 51001 port... Render registered. AFERROR: TaskProcess: AssignProcessToJobObject failed with code = 5.

Started PID=4656: [natron:1000] workstation: test[Write1][frame 1-10] convert -identify "\workstation-pc\renderfarm\test\rendus_test_0001.jpg" -thum bnail "100x100^" -gravity center -extent 100x100 -colorspace sRGB "c:\temp\afana sy\tasks\2.0.0_1\rendus_test_0001.jpg.jpg" \workstation-pc\renderfarm\test\rendus_test_0001.jpg JPEG 1920x1080 1920x1080+0 +0 8-bit sRGB 389KB 0.062u 0:00.062 convert -identify "\workstation-pc\renderfarm\test\rendus_test_0001.jpg" -thum bnail "100x100^" -gravity center -extent 100x100 -colorspace sRGB "c:\temp\afana sy\tasks\2.0.0_1\rendus_test_0001.jpg.jpg" \workstation-pc\renderfarm\test\rendus_test_0001.jpg JPEG 1920x1080 1920x1080+0 +0 8-bit sRGB 389KB 0.062u 0:00.062 convert -identify "\workstation-pc\renderfarm\test\rendus_test_0001.jpg" -thum bnail "100x100^" -gravity center -extent 100x100 -colorspace sRGB "c:\temp\afana sy\tasks\2.0.0_1\rendus_test_0001.jpg.jpg" \workstation-pc\renderfarm\test\rendus_test_0001.jpg JPEG 1920x1080 1920x1080+0 +0 8-bit sRGB 389KB 0.062u 0:00.063 convert -identify "\workstation-pc\renderfarm\test\rendus_test_0001.jpg" -thum bnail "100x100^" -gravity center -extent 100x100 -colorspace sRGB "c:\temp\afana sy\tasks\2.0.0_1\rendus_test_0001.jpg.jpg" \workstation-pc\renderfarm\test\rendus_test_0001.jpg JPEG 1920x1080 1920x1080+0 +0 8-bit sRGB 389KB 0.062u 0:00.063 convert -identify "\workstation-pc\renderfarm\test\rendus_test_0001.jpg" -thum bnail "100x100^" -gravity center -extent 100x100 -colorspace sRGB "c:\temp\afana sy\tasks\2.0.0_1\rendus_test_0001.jpg.jpg" \workstation-pc\renderfarm\test\rendus_test_0001.jpg JPEG 1920x1080 1920x1080+0 +0 8-bit sRGB 389KB 0.047u 0:00.062 convert -identify "\workstation-pc\renderfarm\test\rendus_test_0001.jpg" -thum bnail "100x100^" -gravity center -extent 100x100 -colorspace sRGB "c:\temp\afana sy\tasks\2.0.0_1\rendus_test_0001.jpg.jpg" \workstation-pc\renderfarm\test\rendus_test_0001.jpg JPEG 1920x1080 1920x1080+0 +0 8-bit sRGB 389KB 0.062u 0:00.075 convert -identify "\workstation-pc\renderfarm\test\rendus_test_0001.jpg" -thum bnail "100x100^" -gravity center -extent 100x100 -colorspace sRGB "c:\temp\afana sy\tasks\2.0.0_1\rendus_test_0001.jpg.jpg" \workstation-pc\renderfarm\test\rendus_test_0001.jpg JPEG 1920x1080 1920x1080+0 +0 8-bit sRGB 389KB 0.078u 0:00.071 convert -identify "\workstation-pc\renderfarm\test\rendus_test_0001.jpg" -thum bnail "100x100^" -gravity center -extent 100x100 -colorspace sRGB "c:\temp\afana sy\tasks\2.0.0_1\rendus_test_0001.jpg.jpg" \workstation-pc\renderfarm\test\rendus_test_0001.jpg JPEG 1920x1080 1920x1080+0 +0 8-bit sRGB 389KB 0.062u 0:00.062 convert -identify "\workstation-pc\renderfarm\test\rendus_test_0001.jpg" -thum bnail "100x100^" -gravity center -extent 100x100 -colorspace sRGB "c:\temp\afana sy\tasks\2.0.0_1\rendus_test_0001.jpg.jpg" \workstation-pc\renderfarm\test\rendus_test_0001.jpg JPEG 1920x1080 1920x1080+0 +0 8-bit sRGB 389KB 0.062u 0:00.062

timurhai commented 8 years ago

Hi. And where is the error? Can you reproduce the error with the minimum movements? ( and afserver and afrender are win7-64 ? )

timurhai commented 8 years ago

"AssignProcessToJobObject":

ramellij commented 8 years ago

Everynodes have the same OS. I get same result launching as admin but without the error mentionned above.

timurhai commented 8 years ago

hm, i don`t see any error in your latest log. Can you reproduce the error with the minimum movements (from afrender restart) ? ( and provide full afrender log )

now i don`t know what is the error we are looking for:

What "reproduce the error with the minimum movements" is:

Task log is afserver movements log, it should be like

Thu 12 Nov 12:26.51 : SESSION #1: Starting on "compname"
Thu 12 Nov 12:27.03 : Finished success.
ramellij commented 8 years ago

Ok The test is made only with my workstation : afserver and afrender run as administrator A simple Natron project to convert exr in jpg (again it works for png to jpg)

from afserver :

C:\cgru-windows\start\AFANASY>rem Name=Server... C:\cgru-windows\start\AFANASY>rem Separator C:\cgru-windows\start\AFANASY>call C:\cgru-windows\start\AFANASY_afserver.cmd. ._setup.cmd C:\cgru-windows\start\AFANASY>pushd C:\cgru-windows\start\AFANASY_afserver.cmd\ .._setup.cmd.. C:\cgru-windows\start\AFANASY>cd .. C:\cgru-windows\start>call _setup.cmd C:\cgru-windows\start>if not defined CGRU_LOCATION ( pushd _setup.cmd.. cd .. call setup.cmd popd ) CGRU_VERSION 2.0.7 Using CGRU Python: C:\cgru-windows\python Compilation date = 'Oct 16 2015 03:55:32' CGRU version = '2.0.7' Afanasy build revision = 'cb3f81872a907b2431a360d4b7f7cd977e553fa4' Python version = '3.4.1' Database connection "AFDB_update" is not working. AFERROR: AFDB_upTables: Database connect failed: could not connect to server: Co nnection refused (0x0000274D/10061) Is the server running on host "localhost" (::1) and accepting TCP/IP connections on port 5432? could not connect to server: Connection refused (0x0000274D/10061) Is the server running on host "localhost" (127.0.0.1) and accepting TCP/IP connections on port 5432? Getting renders from store... 6 renders found. Render offline registered - "workstation-pc". Render offline registered - "creature-rn-01". Render offline registered - "creature-rn-04". Render offline registered - "creature-rn-06". Render offline registered - "creature-rn-03". Render offline registered - "creature-rn-05". 6 renders registered. Getting users from store... 2 users found. 2 users registered from store. Getting jobs from store... 2 jobs found. System job retrieved from store. Thu 12 Nov 11:07.10: Job registered: "afanasy"[1]: afadmin[0] - 17178 bytes. 2 jobs registered from store. Thu 12 Nov 11:07.10: Job registered: "test"[2]: workstation@workstation-pc[0] - 14340 bytes. Available addresses: IPv6 = '::' IP = '0.0.0.0' IPv6 is disabled by config. Using IPv4 addresses family. Listening 51000 port... Thu 12 Nov 11:07.13: Render: ON workstation-pc@workstation[ 1] 192.168.0.40:51002 Thu 12 Nov 11:07.17: Monitor registered: workstation@workstation-pc:51001[1] v'2 .0.7' 192.168.0.40:51001 Thu 12 Nov 11:08.03: Job registered: "test-1"[3]: workstation@workstation-pc[1]

  • 14324 bytes. Thu 12 Nov 11:08.14: Deleting a job: "test"[2]: workstation@workstation-pc[0] - 14530 bytes.

from afrender :

C:\cgru-windows\start\AFANASY>rem Name=Local Render... C:\cgru-windows\start\AFANASY>rem Separator C:\cgru-windows\start\AFANASY>call "C:\cgru-windows\start\AFANASY\render.cmd".. _setup.cmd C:\cgru-windows\start\AFANASY>pushd "C:\cgru-windows\start\AFANASY\render.cmd". ._setup.cmd.. C:\cgru-windows\start\AFANASY>cd .. C:\cgru-windows\start>call _setup.cmd C:\cgru-windows\start>if not defined CGRU_LOCATION ( pushd _setup.cmd.. cd .. call setup.cmd popd ) CGRU_VERSION 2.0.7 Using CGRU Python: C:\cgru-windows\python Compilation date = 'Oct 16 2015 03:55:32' CGRU version = '2.0.7' Afanasy build revision = 'cb3f81872a907b2431a360d4b7f7cd977e553fa4' Python version = '3.4.1' Network Interfaces: {943567DA-897B-48CF-B324-14022A812495}: bc:ae:c5:17:e6:86 IPv6 Address: fe80::::::: IPv6 Address: fe80::::5149:c3c9:5bb3:8845 IPv6 Address: ff00::::::: IPv4 Address: 192.168.0.0 IPv4 Address: 192.168.0.40 IPv4 Address: 192.168.0.255 IPv4 Address: 224.0.0.0 IPv4 Address: 255.255.255.255 Windows Must Die: ImageMagick Studio library and utility programs Microsoft Visual C++ Runtime Library QuickTimeHelper-32.exe - Application Error Visual Studio Just-In-Time Debugger ON workstation-pc@workstation[0] Empty address Host: OS="windows 64" Capacity = 0, Max Tasks = 0, Power = 0 Resources: CPU = 3207 MHz x12 5% usr, 0% nice, 0% sys, 94% idle, 0% iow, 0% irq, 0% sirq load average: 0 0 0 Memory: 20471 Mb / 16180 Mb free Swap: 40940 Mb / 6291 Mb used Network: Recieved 18 Kb/sec, Send 112 Kb/sec IO: Read 0 Kb/sec, Write 0 Kb/sec, Busy = 0% HDD: 111 Gb / 12 Gb free Available addresses: IPv6 = '::' IP = '0.0.0.0' IPv6 is disabled by config. Using IPv4 addresses family. Listening 51001 port... Render registered. AFERROR: TaskProcess: AssignProcessToJobObject failed with code = 5.

Started PID=4656: [natron:1000] workstation: test[Write1][frame 1-10] convert -identify "\workstation-pc\renderfarm\test\rendus_test_0001.jpg" -thum bnail "100x100^" -gravity center -extent 100x100 -colorspace sRGB "c:\temp\afana sy\tasks\2.0.0_1\rendus_test_0001.jpg.jpg" \workstation-pc\renderfarm\test\rendus_test_0001.jpg JPEG 1920x1080 1920x1080+0 +0 8-bit sRGB 389KB 0.062u 0:00.062 convert -identify "\workstation-pc\renderfarm\test\rendus_test_0001.jpg" -thum bnail "100x100^" -gravity center -extent 100x100 -colorspace sRGB "c:\temp\afana sy\tasks\2.0.0_1\rendus_test_0001.jpg.jpg" \workstation-pc\renderfarm\test\rendus_test_0001.jpg JPEG 1920x1080 1920x1080+0 +0 8-bit sRGB 389KB 0.062u 0:00.062 convert -identify "\workstation-pc\renderfarm\test\rendus_test_0001.jpg" -thum bnail "100x100^" -gravity center -extent 100x100 -colorspace sRGB "c:\temp\afana sy\tasks\2.0.0_1\rendus_test_0001.jpg.jpg" \workstation-pc\renderfarm\test\rendus_test_0001.jpg JPEG 1920x1080 1920x1080+0 +0 8-bit sRGB 389KB 0.062u 0:00.063 convert -identify "\workstation-pc\renderfarm\test\rendus_test_0001.jpg" -thum bnail "100x100^" -gravity center -extent 100x100 -colorspace sRGB "c:\temp\afana sy\tasks\2.0.0_1\rendus_test_0001.jpg.jpg" \workstation-pc\renderfarm\test\rendus_test_0001.jpg JPEG 1920x1080 1920x1080+0 +0 8-bit sRGB 389KB 0.062u 0:00.063 convert -identify "\workstation-pc\renderfarm\test\rendus_test_0001.jpg" -thum bnail "100x100^" -gravity center -extent 100x100 -colorspace sRGB "c:\temp\afana sy\tasks\2.0.0_1\rendus_test_0001.jpg.jpg" \workstation-pc\renderfarm\test\rendus_test_0001.jpg JPEG 1920x1080 1920x1080+0 +0 8-bit sRGB 389KB 0.047u 0:00.062 convert -identify "\workstation-pc\renderfarm\test\rendus_test_0001.jpg" -thum bnail "100x100^" -gravity center -extent 100x100 -colorspace sRGB "c:\temp\afana sy\tasks\2.0.0_1\rendus_test_0001.jpg.jpg" \workstation-pc\renderfarm\test\rendus_test_0001.jpg JPEG 1920x1080 1920x1080+0 +0 8-bit sRGB 389KB 0.062u 0:00.075 convert -identify "\workstation-pc\renderfarm\test\rendus_test_0001.jpg" -thum bnail "100x100^" -gravity center -extent 100x100 -colorspace sRGB "c:\temp\afana sy\tasks\2.0.0_1\rendus_test_0001.jpg.jpg" \workstation-pc\renderfarm\test\rendus_test_0001.jpg JPEG 1920x1080 1920x1080+0 +0 8-bit sRGB 389KB 0.078u 0:00.071 convert -identify "\workstation-pc\renderfarm\test\rendus_test_0001.jpg" -thum bnail "100x100^" -gravity center -extent 100x100 -colorspace sRGB "c:\temp\afana sy\tasks\2.0.0_1\rendus_test_0001.jpg.jpg" \workstation-pc\renderfarm\test\rendus_test_0001.jpg JPEG 1920x1080 1920x1080+0 +0 8-bit sRGB 389KB 0.062u 0:00.062 convert -identify "\workstation-pc\renderfarm\test\rendus_test_0001.jpg" -thum bnail "100x100^" -gravity center -extent 100x100 -colorspace sRGB "c:\temp\afana sy\tasks\2.0.0_1\rendus_test_0001.jpg.jpg" \workstation-pc\renderfarm\test\rendus_test_0001.jpg JPEG 1920x1080 1920x1080+0 +0 8-bit sRGB 389KB 0.062u 0:00.062

The task log :

Thu 12 Nov 11:08.04 : SESSION #1: Starting on "workstation-pc"

the output task :

COMPUTERNAME=WORKSTATION-PC Natron Version 2.0.0 Copyright (C) 2015 the Natron developers Use the --help or -h option to print usage. Restoring the image cache... Restoring user settings... xml error : not well-formed (invalid token) (4) init.py script loaded Loading PyPlugs... "Afanasy1"[0] Rendering started Frame rendered: 1 (10.0%) Time elapsed for frame: 0.89 sec(s) Time remaining: 8 sec(s) Frame rendered: 3 (20.0%) Time elapsed for frame: 1.17 sec(s) Time remaining: 4 sec(s) Frame rendered: 2 (30.0%) Time elapsed for frame: 1.20 sec(s) Time remaining: 3 sec(s) Frame rendered: 5 (40.0%) Time elapsed for frame: 1.58 sec(s) Time remaining: 2 sec(s) Frame rendered: 4 (50.0%) Time elapsed for frame: 1.77 sec(s) Time remaining: 2 sec(s) Frame rendered: 6 (60.0%) Time elapsed for frame: 2.03 sec(s) Time remaining: 1 sec(s) Frame rendered: 7 (70.0%) Time elapsed for frame: 2.61 sec(s) Time remaining: 1 sec(s) Frame rendered: 8 (80.0%) Time elapsed for frame: 1.21 sec(s) Time remaining: 0 sec(s) Frame rendered: 9 (90.0%) Time elapsed for frame: 1.46 sec(s) Time remaining: 0 sec(s) Frame rendered: 10 (100.0%) Time elapsed for frame: 1.52 sec(s) Time remaining: 0 sec(s) Rendering finished "Afanasy1"[0] Traceback (most recent call last): File "", line 2, in File "C:/Program Files/INRIA/Natron-2.0.0-RC3/Plugins/PySide/init.py", line 41, in _setupQtDirectories() File "C:/Program Files/INRIA/Natron-2.0.0-RC3/Plugins/PySide/init.py", line 9, in _setupQtDirectories from . import _utils ValueError: Attempted relative import in non-package Traceback (most recent call last): File "", line 2, in ImportError: No module named py

the task info :

frame 1-10 natron[natron]:1000 frames(1,10,10): Command: natron -b -w "Write1" 1-10 "//workstation-pc/renderfarm/test/test.150812110803781.ntp" Working Directory: C:\Users\WORKSTATION Files: //workstation-pc/renderfarm/test/rendus_test_0001.jpg

timurhai commented 8 years ago

After this output, task just "hangs"? What will happen later?

ramellij commented 8 years ago

job log :

Thu 12 Nov 11:08.03 : Initialized. Thu 12 Nov 11:08.04 : Started.

task log:

Thu 12 Nov 11:08.04 : SESSION #1: Starting on "workstation-pc" Thu 12 Nov 11:24.51 : Job stopped by workstation@workstation-pc Is running.

Ant then nothing : the percentage bar freeze in the middle, the task clock keeps running. The job is done but the next task don't begin.

timurhai commented 8 years ago

Try to open "Tools -> Terminal" from keeper and launch a command from task info:

natron -b -w "Write1" 1-10 "//workstation-pc/renderfarm/test/test.150812110803781.ntp"
ramellij commented 8 years ago

I have this :

Microsoft Windows [version 6.1.7601] Copyright (c) 2009 Microsoft Corporation. Tous droits réservés. C:\cgru-windows>natron -b -w "Write1" 1-10 "//workstation-pc/renderfarm/test/tes t.150812110803781.ntp" COMPUTERNAME=WORKSTATION-PC Natron Version 2.0.0 Copyright (C) 2015 the Natron developers

Use the --help or -h option to print usage.<<< Restoring the image cache... Restoring user settings... xml error : not well-formed (invalid token) (4) init.py script loaded Loading PyPlugs... Traceback (most recent call last): File "", line 2, in File "C:/Program Files/INRIA/Natron-2.0.0-RC3/Plugins/PySide/init.py", lin e 41, in _setupQtDirectories() File "C:/Program Files/INRIA/Natron-2.0.0-RC3/Plugins/PySide/init.py", lin e 9, in _setupQtDirectories from . import _utils ValueError: Attempted relative import in non-package Traceback (most recent call last): File "", line 2, in ImportError: No module named py "Afanasy1"[0] Rendering started Frame rendered: 1 (10.0%) Time elapsed for frame: 0.88 sec(s) Time remaining: 8 sec(s) Frame rendered: 3 (20.0%) Time elapsed for frame: 1.15 sec(s) Time remaining: 4 sec(s) Frame rendered: 2 (30.0%) Time elapsed for frame: 1.22 sec(s) Time remaining: 3 sec(s) Frame rendered: 4 (40.0%) Time elapsed for frame: 1.81 sec(s) Time remaining: 2 sec(s) Frame rendered: 5 (50.0%) Time elapsed for frame: 1.88 sec(s) Time remaining: 1 sec(s) Frame rendered: 6 (60.0%) Time elapsed for frame: 2.19 sec(s) Time remaining: 1 sec(s) Frame rendered: 7 (70.0%) Time elapsed for frame: 2.60 sec(s) Time remaining: 1 sec(s) Frame rendered: 9 (80.0%) Time elapsed for frame: 1.61 sec(s) Time remaining: 0 sec(s) Frame rendered: 8 (90.0%) Time elapsed for frame: 1.69 sec(s) Time remaining: 0 sec(s) Frame rendered: 10 (100.0%) Time elapsed for frame: 2.14 sec(s) Time remaining: 0 sec(s) Rendering finished "Afanasy1"[0]

timurhai commented 8 years ago

So, it works? If yes, try to remove "jpg" extension from thumbnails. I see a bug, that afrender tries to generate thumbnail several time while task is still running. Then try Afanasy again.

ramellij commented 8 years ago

from the beginning it rendered all frames in my first task, the problem is it never jumped to the next. The percentage bar was always wrong. I removed exr, jpg and jpeg extensions from thumbnails in a new config.json AND in the default config to test and there is no change.

timurhai commented 8 years ago

No change? The output is the same? Afrender still tries to generate thumbnails?

timurhai commented 8 years ago

Such Afrender output tells that it is generating a thumbnail:

convert -identify "\workstation-pc\renderfarm\test\rendus_test_0001.jpg" -thumbnail "100x100^" -gravity center -extent 100x100 -colorspace sRGB "c:\temp\afanasy\tasks\2.0.0_1\rendus_test_0001.jpg.jpg"

ramellij commented 8 years ago

same outputs... I know Natron's guys have made a big change in the EXR reader to improve its speed. Could it be related. Can I try without thumbnails ?

timurhai commented 8 years ago

This line in a config without exr and jpg should disable thumbnails: "af_thumbnail_extensions":["exr","dpx","jpg","jpeg","png","tif","tiff","tga"], Where is your config.json is located? And what is in there? Can you try keeper "Show Info..." action to test your config files?

ramellij commented 8 years ago

Python: PySide = <module 'PySide' from 'C:\cgru-windows\python\lib\site-packages\PySide\init.py'> sys.prefix = C:\cgru-windows\python Executable = python Version = 3.4.1 (v3.4.1:c0e311e010fc, May 18 2014, 10:45:13) [MSC v.1600 64 bit (AMD64)]

Variables: AF_ROOT = C:\cgru-windows\afanasy CGRU_KEEPER_CMD = "C:\cgru-windows\python\pythonw.exe" "C:\cgru-windows\utilities\keeper\keeper.py" CGRU_LOCATION = C:\cgru-windows CGRU_PYTHONEXE = python CGRU_UPDATE_CMD - undefined CGRU_VERSION = 2.0.7 HOME = C:\Users\WORKSTATION\AppData\Roaming HOME_CGRU = C:\Users\WORKSTATION\AppData\Roaming\cgru HOSTNAME = workstation-pc OS_linux = {'open_folder_cmd': 'nautilus "@PATH@"'} OS_unix = {'af_rendercmds_admin': ['xterm -e "ssh @ARG@; read -s -n 1"', 'xterm -e "ssh @ARG@ \"@ASK@\"; read -s -n 1"'], 'af_render_cmd_shutdown': 'shutdown -P 1 afrequest', 'af_render_cmd_reboot': 'reboot', 'af_render_cmd_wolsleep': 'wolsleep', 'af_tempdirectory': '/var/tmp/afanasy', 'cmd_shell': '/bin/sh -c', 'af_rendercmds': ['vncviewer @ARG@', 'xterm -e "ping @ARG@; read -s -n 1"', 'xterm -e "ping @IP@; read -s -n 1"']} OS_windows = {'': 'But will replace with specified slashes, if unix slashes not forced (for Nuke, for example).', '-pathsmap': [['//server/projects/', '/mnt/prj/']], 'af_render_cmd_shutdown': 'shutdown /s', 'open_folder_cmd': 'start @PATH@', 'af_render_cmd_reboot': 'shutdown /r', 'af_render_cmd_wolsleep': 'cmd.exe /c wolsleep', 'af_tempdirectory': 'c:/temp/afanasy', 'cmd_shell': 'cmd.exe /c', 'af_render_windowsmustdie': ['ImageMagick Studio library and utility programs', 'Microsoft Visual C++ Runtime Library', 'QuickTimeHelper-32.exe - Application Error', 'Visual Studio Just-In-Time Debugger'], 'af_rendercmds': ['vncviewer @ARG@', 'start ping /t @ARG@', 'start ping /t @IP@']} USERNAME = workstation af_client_dispatch_so_rcvtimeo_sec = 8 af_client_dispatch_so_sndtimeo_sec = 8 af_client_dispatch_tcp_nodelay = 0 af_clientport = 51001 af_cmdprefix = af_db_conninfo = host=localhost dbname=afanasy user=afadmin password=AfPassword af_db_stringexprlen = 4096 af_db_stringnamelen = 512 af_db_stringquotes = $$ af_digest_file = .htdigest af_errors_avoid_host = 3 af_errors_forgivetime = 18000 af_iptrust = ['.', '127.0.0.1', '192.168.', ':', '0:0:0:0:0:0:0:1', 'FC00:_', 'FD00:'] af_ipv6_disable = 1 af_maxrunningtasks = -1 af_monitor_connectretries = 3 af_monitor_render_idle_bar_max = 3600 af_monitor_updateperiod = 10 af_monitor_waitforbyteswritten = 8000 af_monitor_waitforconnected = 8000 af_monitor_waitforreadyread = 8000 af_monitor_zombietime = 40 af_node_log_lines_max = 100 af_perm_user_mod_his_priority = True af_perm_user_mod_job_priority = True af_priority = 99 af_render_cmd_reboot = shutdown /r af_render_cmd_shutdown = shutdown /s af_render_cmd_wolsleep = cmd.exe /c wolsleep af_render_cmd_wolwake = wolwake af_render_connectretries = 3 af_render_default_capacity = 1000 af_render_default_maxtasks = 5 af_render_exec = afrender af_render_hddspace_path = / af_render_iostat_device = af_render_nice = 10 af_render_update_sec = 5 af_render_updatetaskperiod = 1 af_render_windowsmustdie = ['ImageMagick Studio library and utility programs', 'Microsoft Visual C++ Runtime Library', 'QuickTimeHelper-32.exe - Application Error', 'Visual Studio Just-In-Time Debugger'] af_render_zombietime = 60 af_rendercmds = ['afanasy @ARG@'] af_serve_tasks_speed = -1 af_server_accept_so_rcvtimeo_sec = 2 af_server_accept_so_sndtimeo_sec = 2 af_server_dispatch_so_rcvtimeo_sec = 2 af_server_dispatch_so_sndtimeo_sec = 2 af_server_dispatch_tcp_nodelay = 1 af_servername = 192.168.0.40 af_serverport = 51000 af_sysjob_events_service = events af_sysjob_postcmd_service = postcmd af_sysjob_tasklife = 1800 af_sysjob_tasksmax = 1000 af_sysjob_wol_service = wakeonlan af_task_default_capacity = 1000 af_task_default_service = generic af_task_error_retries = 3 af_task_errors_same_host = 3 af_task_log_linesmax = 100 af_task_update_timeout = 15 af_tempdirectory = c:/temp/afanasy af_thumbnail_cmd = convert -identify "%(image)s" %(pre_args)s -thumbnail "100x100^" -gravity center -extent 100x100 -colorspace sRGB "%(thumbnail)s" af_thumbnail_extensions = ['dpx', 'png', 'tif', 'tiff', 'tga'] af_watch_connectretries = 3 af_watch_refreshinterval = 5 af_watch_waitforbyteswritten = 8000 af_watch_waitforconnected = 8000 af_watch_waitforreadyread = 8000 cmd_shell = cmd.exe /c company = CGRU config_file_home = C:\Users\WORKSTATION\AppData\Roaming\cgru\config.json docs_host = cgru.info editor = notepad "%s" email_send_cmd = emailsend email_sender_address_host = cgru.info email_smtp_server = localhost filenames = ['C:\cgru-windows\config_default.json', 'C:\cgru-windows\afanasy/config_default.json', 'C:\cgru-windows\config.json', 'C:\Users\WORKSTATION\AppData\Roaming\cgru\config.json'] filenamesizemax = 250 icons_path - undefined include = ['afanasy/config_default.json', 'config.json'] keeper_port = 50999 keeper_refresh = 36 menu_path - undefined open_folder_cmd = start @PATH@ platform = ['windows'] platforms = ['linux', 'mac', 'windows'] previewcmds = ['djv_view "@ARG@"'] projects_root = ['/mnt/prj/', '/projects/', '/cgru/rules_root/'] pswd_god = b673f9b4ebccc7d600874716537d4ff5 pswd_visor = 1832116180fdc61b64fd978401e462e9 realm = CGRU rules_url = http://localhost/cgru/#/ timeformat = %a %d %b %H:%M.%S tray_icon - undefined

AFANASY Environment: AF_ROOT = C:\cgru-windows\afanasy AF_RENDER_CMD - undefined AF_WATCH_CMD - undefined

Python Environment: PYTHONHOME = C:\cgru-windows\python PYTHONPATH = C:\cgru-windows\afanasy\python;C:\cgru-windows\lib\python CGRU_PYTHON = C:\cgru-windows\lib\python AF_PYTHON = C:\cgru-windows\afanasy\python

System Environment: PATH = C:\cgru-windows\python;C:\cgru-windows\afanasy\bin;C:\cgru-windows\software_setup\bin;C:\cgru-windows\bin;C:\Program Files (x86)\Python 3.5\Scripts\;C:\Program Files (x86)\Python 3.5\;C:\ProgramData\Oracle\Java\javapath;C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\Windows\system32;C:\Windows;C:\Windows\System32\Wbem;C:\Windows\System32\WindowsPowerShell\v1.0\;C:\Program Files\Common Files\Autodesk Shared\;C:\Program Files (x86)\CMake\bin;C:\Program Files (x86)\TeamViewer;C:\Program Files\djv-1.1.0-Windows-64\bin;C:\Program Files (x86)\TeamViewer;C:\Program Files (x86)\UltraVNC;C:\Program Files\Autodesk\Maya2016\vray\bin;C:\Program Files\Adobe\Adobe After Effects CS6\Support Files;C:\Program Files (x86)\QuickTime\QTSystem\;C:\Program Files\Chaos Group\V-Ray\Maya 2016 for x64\bin;C:\Program Files\Autodesk\Maya2016\bin;C:\PSTools;C:\Python34;C:\Program Files (x86)\AnyDesk\AnyDesk.exe;C:\Program Files (x86)\Aquila Technology\WakeOnLAN;C:\Program Files (x86)\Python 3.5;C:\Program Files\INRIA\Natron-2.0.0-RC3\bin PWD = C:\Users\WORKSTATION

C:\cgru-windows\config_default.json: OS_linux = {'open_folder_cmd': 'nautilus "@PATH@"'} OS_unix = {'af_rendercmds_admin': ['xterm -e "ssh @ARG@; read -s -n 1"', 'xterm -e "ssh @ARG@ \"@ASK@\"; read -s -n 1"'], 'af_render_cmd_shutdown': 'shutdown -P 1 afrequest', 'af_render_cmd_reboot': 'reboot', 'af_render_cmd_wolsleep': 'wolsleep', 'af_tempdirectory': '/var/tmp/afanasy', 'cmd_shell': '/bin/sh -c', 'af_rendercmds': ['vncviewer @ARG@', 'xterm -e "ping @ARG@; read -s -n 1"', 'xterm -e "ping @IP@; read -s -n 1"']} OS_windows = {'': 'But will replace with specified slashes, if unix slashes not forced (for Nuke, for example).', '-pathsmap': [['//server/projects/', '/mnt/prj/']], 'af_render_cmd_shutdown': 'shutdown /s', 'open_folder_cmd': 'start @PATH@', 'af_render_cmd_reboot': 'shutdown /r', 'af_render_cmd_wolsleep': 'cmd.exe /c wolsleep', 'af_tempdirectory': 'c:/temp/afanasy', 'cmd_shell': 'cmd.exe /c', 'af_render_windowsmustdie': ['ImageMagick Studio library and utility programs', 'Microsoft Visual C++ Runtime Library', 'QuickTimeHelper-32.exe - Application Error', 'Visual Studio Just-In-Time Debugger'], 'af_rendercmds': ['vncviewer @ARG@', 'start ping /t @ARG@', 'start ping /t @IP@']} af_client_dispatch_so_rcvtimeo_sec = 8 af_client_dispatch_so_sndtimeo_sec = 8 af_client_dispatch_tcp_nodelay = 0 af_clientport = 51001 af_cmdprefix = af_db_conninfo = host=localhost dbname=afanasy user=afadmin password=AfPassword af_db_stringexprlen = 4096 af_db_stringnamelen = 512 af_db_stringquotes = $$ af_digest_file = .htdigest af_errors_avoid_host = 3 af_errors_forgivetime = 18000 af_iptrust = ['.', '127.0.0.1', '192.168.', ':', '0:0:0:0:0:0:0:1', 'FC00:_', 'FD00:'] af_ipv6_disable = 1 af_maxrunningtasks = -1 af_monitor_connectretries = 3 af_monitor_render_idle_bar_max = 3600 af_monitor_updateperiod = 10 af_monitor_waitforbyteswritten = 8000 af_monitor_waitforconnected = 8000 af_monitor_waitforreadyread = 8000 af_monitor_zombietime = 40 af_node_log_lines_max = 100 af_perm_user_mod_his_priority = True af_perm_user_mod_job_priority = True af_priority = 99 af_render_cmd_reboot = shutdown /r af_render_cmd_shutdown = shutdown /s af_render_cmd_wolsleep = cmd.exe /c wolsleep af_render_cmd_wolwake = wolwake af_render_connectretries = 3 af_render_default_capacity = 1000 af_render_default_maxtasks = 5 af_render_exec = afrender af_render_hddspace_path = / af_render_iostat_device = af_render_nice = 10 af_render_update_sec = 5 af_render_updatetaskperiod = 1 af_render_windowsmustdie = ['ImageMagick Studio library and utility programs', 'Microsoft Visual C++ Runtime Library', 'QuickTimeHelper-32.exe - Application Error', 'Visual Studio Just-In-Time Debugger'] af_render_zombietime = 60 af_rendercmds = ['afanasy @ARG@'] af_serve_tasks_speed = -1 af_server_accept_so_rcvtimeo_sec = 2 af_server_accept_so_sndtimeo_sec = 2 af_server_dispatch_so_rcvtimeo_sec = 2 af_server_dispatch_so_sndtimeo_sec = 2 af_server_dispatch_tcp_nodelay = 1 af_servername = 192.168.0.40 af_serverport = 51000 af_sysjob_events_service = events af_sysjob_postcmd_service = postcmd af_sysjob_tasklife = 1800 af_sysjob_tasksmax = 1000 af_sysjob_wol_service = wakeonlan af_task_default_capacity = 1000 af_task_default_service = generic af_task_error_retries = 3 af_task_errors_same_host = 3 af_task_log_linesmax = 100 af_task_update_timeout = 15 af_tempdirectory = c:/temp/afanasy af_thumbnail_cmd = convert -identify "%(image)s" %(pre_args)s -thumbnail "100x100^" -gravity center -extent 100x100 -colorspace sRGB "%(thumbnail)s" af_thumbnail_extensions = ['dpx', 'png', 'tif', 'tiff', 'tga'] af_watch_connectretries = 3 af_watch_refreshinterval = 5 af_watch_waitforbyteswritten = 8000 af_watch_waitforconnected = 8000 af_watch_waitforreadyread = 8000 cmd_shell = cmd.exe /c docs_host = cgru.info email_send_cmd = emailsend email_sender_address_host = cgru.info email_smtp_server = localhost filenamesizemax = 250 include = ['afanasy/config_default.json', 'config.json'] keeper_port = 50999 open_folder_cmd = start @PATH@ platforms = ['linux', 'mac', 'windows'] previewcmds = ['djv_view "@ARG@"'] projects_root = ['/mnt/prj/', '/projects/', '/cgru/rules_root/'] pswd_god = b673f9b4ebccc7d600874716537d4ff5 pswd_visor = 1832116180fdc61b64fd978401e462e9 realm = CGRU rules_url = http://localhost/cgru/#/ timeformat = %a %d %b %H:%M.%S

C:\cgru-windows\afanasy/config_default.json: OS_unix = {'': '', 'af_rendercmds_admin': ['xterm -e "ssh @ARG@; read -s -n 1"', 'xterm -e "ssh @ARG@ \"@ASK@\"; read -s -n 1"'], 'af_render_cmd_shutdown': 'shutdown -P 1 afrequest', 'af_render_cmd_wolsleep': 'wolsleep', 'af_render_cmd_reboot': 'reboot', 'af_tempdirectory': '/var/tmp/afanasy', 'af_rendercmds': ['vncviewer @ARG@', 'xterm -e "ping @ARG@; read -s -n 1"', 'xterm -e "ping @IP@; read -s -n 1"']} OS_windows = {'af_render_windowsmustdie': ['ImageMagick Studio library and utility programs', 'Microsoft Visual C++ Runtime Library', 'QuickTimeHelper-32.exe - Application Error', 'Visual Studio Just-In-Time Debugger'], 'af_render_cmd_shutdown': 'shutdown /s', 'af_render_cmd_wolsleep': 'cmd.exe /c wolsleep', 'af_render_cmd_reboot': 'shutdown /r', 'af_tempdirectory': 'c:/temp/afanasy', 'af_rendercmds': ['vncviewer @ARG@', 'start ping /t @ARG@', 'start ping /t @IP@']} af_client_dispatch_so_rcvtimeo_sec = 8 af_client_dispatch_so_sndtimeo_sec = 8 af_client_dispatch_tcp_nodelay = 0 af_clientport = 51001 af_cmdprefix = af_db_conninfo = host=localhost dbname=afanasy user=afadmin password=AfPassword af_db_stringexprlen = 4096 af_db_stringnamelen = 512 af_db_stringquotes = $$ af_digest_file = .htdigest af_errors_avoid_host = 3 af_errors_forgivetime = 18000 af_iptrust = ['.', '127.0.0.1', '192.168.', ':', '0:0:0:0:0:0:0:1', 'FC00:_', 'FD00:'] af_ipv6_disable = 1 af_maxrunningtasks = -1 af_monitor_connectretries = 3 af_monitor_render_idle_bar_max = 3600 af_monitor_updateperiod = 10 af_monitor_waitforbyteswritten = 8000 af_monitor_waitforconnected = 8000 af_monitor_waitforreadyread = 8000 af_monitor_zombietime = 40 af_node_log_lines_max = 100 af_perm_user_mod_his_priority = True af_perm_user_mod_job_priority = True af_priority = 99 af_render_cmd_reboot = shutdown /r af_render_cmd_shutdown = shutdown /s af_render_cmd_wolsleep = cmd.exe /c wolsleep af_render_cmd_wolwake = wolwake af_render_connectretries = 3 af_render_default_capacity = 1000 af_render_default_maxtasks = 5 af_render_exec = afrender af_render_hddspace_path = / af_render_iostat_device = af_render_nice = 10 af_render_update_sec = 5 af_render_updatetaskperiod = 1 af_render_windowsmustdie = ['ImageMagick Studio library and utility programs', 'Microsoft Visual C++ Runtime Library', 'QuickTimeHelper-32.exe - Application Error', 'Visual Studio Just-In-Time Debugger'] af_render_zombietime = 60 af_rendercmds = ['vncviewer @ARG@', 'start ping /t @ARG@', 'start ping /t @IP@'] af_serve_tasks_speed = -1 af_server_accept_so_rcvtimeo_sec = 2 af_server_accept_so_sndtimeo_sec = 2 af_server_dispatch_so_rcvtimeo_sec = 2 af_server_dispatch_so_sndtimeo_sec = 2 af_server_dispatch_tcp_nodelay = 1 af_servername = 127.0.0.1 af_serverport = 51000 af_sysjob_events_service = events af_sysjob_postcmd_service = postcmd af_sysjob_tasklife = 1800 af_sysjob_tasksmax = 1000 af_sysjob_wol_service = wakeonlan af_task_default_capacity = 1000 af_task_default_service = generic af_task_error_retries = 3 af_task_errors_same_host = 3 af_task_log_linesmax = 100 af_task_update_timeout = 15 af_tempdirectory = c:/temp/afanasy af_thumbnail_cmd = convert -identify "%(image)s" %(pre_args)s -thumbnail "100x100^" -gravity center -extent 100x100 -colorspace sRGB "%(thumbnail)s" af_thumbnail_extensions = ['dpx', 'png', 'tif', 'tiff', 'tga'] af_watch_connectretries = 3 af_watch_refreshinterval = 5 af_watch_waitforbyteswritten = 8000 af_watch_waitforconnected = 8000 af_watch_waitforreadyread = 8000

C:\cgru-windows\config.json: af_rendercmds = ['afanasy @ARG@'] af_servername = 192.168.0.40 af_thumbnail_extensions = ['dpx', 'png', 'tif', 'tiff', 'tga'] previewcmds = ['djv_view "@ARG@"'] pswd_god = b673f9b4ebccc7d600874716537d4ff5

C:\Users\WORKSTATION\AppData\Roaming\cgru\config.json: af_servername = 192.168.0.40

timurhai commented 8 years ago

It seems that everything is OK. btw, You should restart afrender on a config change, it loads config files only once, have you?

ramellij commented 8 years ago

yes I have

timurhai commented 8 years ago

Very strange ) But! I have just fixed a bug, that afrender tries to generate thumbnails, while task is running. You can try a new version: http://rules.cgru.info/#/downloads/testing

ramellij commented 8 years ago

same results

ramellij commented 8 years ago

task output :

C:\cgru-windows\start\AFANASY>rem Name=Local Render... C:\cgru-windows\start\AFANASY>rem Separator C:\cgru-windows\start\AFANASY>call C:\cgru-windows\start\AFANASY\render.cmd.._ setup.cmd C:\cgru-windows\start\AFANASY>pushd C:\cgru-windows\start\AFANASY\render.cmd..\ _setup.cmd.. C:\cgru-windows\start\AFANASY>cd .. C:\cgru-windows\start>call _setup.cmd C:\cgru-windows\start>if not defined CGRU_LOCATION ( pushd _setup.cmd.. cd .. call setup.cmd popd ) CGRU_VERSION 2.0.8 Using CGRU Python: C:\cgru-windows\python Compilation date = 'Nov 12 2015 02:49:43' CGRU version = '2.0.8' Afanasy build revision = '8a841da8d2012cf08143ffc06bdde9df6e3d949b' Python version = '3.4.1' Network Interfaces: {943567DA-897B-48CF-B324-14022A812495}: bc:ae:c5:17:e6:86 IPv6 Address: fe80::::::: IPv6 Address: fe80::::5149:c3c9:5bb3:8845 IPv6 Address: ff00::::::: IPv4 Address: 192.168.0.0 IPv4 Address: 192.168.0.40 IPv4 Address: 192.168.0.255 IPv4 Address: 224.0.0.0 IPv4 Address: 255.255.255.255 Windows Must Die: ImageMagick Studio library and utility programs Microsoft Visual C++ Runtime Library QuickTimeHelper-32.exe - Application Error Visual Studio Just-In-Time Debugger ON workstation-pc@workstation[0] Empty address Host: OS="windows 64" Capacity = 0, Max Tasks = 0, Power = 0 Resources: CPU = 3207 MHz x12 2% usr, 0% nice, 3% sys, 94% idle, 0% iow, 0% irq, 0% sirq load average: 0 0 0 Memory: 20471 Mb / 14014 Mb free Swap: 40940 Mb / 9045 Mb used Network: Recieved 37 Kb/sec, Send 196 Kb/sec IO: Read 0 Kb/sec, Write 0 Kb/sec, Busy = 0% HDD: 111 Gb / 10 Gb free Available addresses: IPv6 = '::' IP = '0.0.0.0' IPv6 is disabled by config. Using IPv4 addresses family. Listening 51001 port... Render registered. Started PID=6920: [natron:1000] workstation: test-1[Write1][frame 1-10] Finished PID=6920: Exit Code=1 Status=1 Started PID=10520: [natron:1000] workstation: test-1[Write1][frame 1-10] Finished PID=10520: Exit Code=1 Status=1 Started PID=9772: [natron:1000] workstation: test-1[Write1][frame 1-10] Finished PID=9772: Exit Code=1 Status=1 Started PID=10984: [natron:1000] workstation: test-1[Write1][frame 1-10] Finished PID=10984: Exit Code=1 Status=1 Started PID=10496: [natron:1000] workstation: test-1[Write1][frame 11-20] Finished PID=10496: Exit Code=1 Status=1 Started PID=8208: [natron:1000] workstation: test-1[Write1][frame 11-20] Finished PID=8208: Exit Code=1 Status=1 Started PID=10712: [postcmd:1000] workstation: test-1[post_commands][deletefiles ] Finished PID=10712: Exit Code=1 Status=1 Started PID=4340: [postcmd:1000] workstation: test-1[post_commands][deletefiles] Finished PID=4340: Exit Code=1 Status=1 Started PID=9092: [postcmd:1000] workstation: test-1[post_commands][deletefiles] Finished PID=9092: Exit Code=1 Status=1 Started PID=7528: [natron:1000] workstation: test_natron[Write1][frame 1-10]

timurhai commented 8 years ago

Afrender output is completely different. It does not try to generate any thumbnails. And process is finished with a non-zero exit status. What are task log and output?

ramellij commented 8 years ago

task log

Thu 12 Nov 12:36.05 : SESSION #1: Starting on "workstation-pc"

task output

COMPUTERNAME=WORKSTATION-PC Natron Version 2.0.0 Copyright (C) 2015 the Natron developers

Use the --help or -h option to print usage.<<< Restoring the image cache... Restoring user settings... xml error : not well-formed (invalid token) (4) init.py script loaded Loading PyPlugs... "Afanasy1"[0] Rendering started Frame rendered: 1 (10.0%) Time elapsed for frame: 0.87 sec(s) Time remaining: 8 sec(s) Frame rendered: 3 (20.0%) Time elapsed for frame: 1.21 sec(s) Time remaining: 4 sec(s) Frame rendered: 2 (30.0%) Time elapsed for frame: 1.24 sec(s) Time remaining: 3 sec(s) Frame rendered: 4 (40.0%) Time elapsed for frame: 1.88 sec(s) Time remaining: 2 sec(s) Frame rendered: 6 (50.0%) Time elapsed for frame: 1.94 sec(s) Time remaining: 1 sec(s) Frame rendered: 5 (60.0%) Time elapsed for frame: 2.73 sec(s) Time remaining: 1 sec(s) Frame rendered: 7 (70.0%) Time elapsed for frame: 2.75 sec(s) Time remaining: 1 sec(s) Frame rendered: 8 (80.0%) Time elapsed for frame: 1.61 sec(s) Time remaining: 0 sec(s) Frame rendered: 10 (90.0%) Time elapsed for frame: 1.55 sec(s) Time remaining: 0 sec(s) Frame rendered: 9 (100.0%) Time elapsed for frame: 1.88 sec(s) Time remaining: 0 sec(s) Rendering finished "Afanasy1"[0] Traceback (most recent call last): File "", line 2, in File "C:/Program Files/INRIA/Natron-2.0.0-RC3/Plugins/PySide/init.py", line 41, in _setupQtDirectories() File "C:/Program Files/INRIA/Natron-2.0.0-RC3/Plugins/PySide/init.py", line 9, in _setupQtDirectories from . import _utils ValueError: Attempted relative import in non-package Traceback (most recent call last): File "", line 2, in ImportError: No module named py

timurhai commented 8 years ago

Started PID=6920: [natron:1000] workstation: test-1[Write1][frame 1-10] Finished PID=6920: Exit Code=1 Status=1 Started PID=10520: [natron:1000] workstation: test-1[Write1][frame 1-10] Finished PID=10520: Exit Code=1 Status=1 Started PID=9772: [natron:1000] workstation: test-1[Write1][frame 1-10] Finished PID=9772: Exit Code=1 Status=1 Started PID=10984: [natron:1000] workstation: test-1[Write1][frame 1-10] Finished PID=10984: Exit Code=1 Status=1 Started PID=10496: [natron:1000] workstation: test-1[Write1][frame 11-20] Finished PID=10496: Exit Code=1 Status=1 Started PID=8208: [natron:1000] workstation: test-1[Write1][frame 11-20] Finished PID=8208: Exit Code=1 Status=1

this render output says that task "frame 1-10" was started 4 times, and task "frame 11-20" 2 times, but task log Thu 12 Nov 12:36.05 : SESSION #1: Starting on "workstation-pc" says that it was started only once and still running Are you sure that render log and task log&ouput are from the same situation?

Now i do not understand what is going on. Try an example from CGRU (cgru/examples/natron) You can run it directly from keeper "Software -> Examples -> Natron"

ramellij commented 8 years ago

Yes the previous render log and task log&ouput are from the same situation. your example renders correctly

timurhai commented 8 years ago

Try to change project, we should know what project effects cause this error. For example, read png and save jpg, or something.

Every time server ask task to start/stop or task has finished itself(error or success), server make a new line in the task log.

ramellij commented 8 years ago

there are no effect in my comp : just a reader for a EXR sequence and a writer to export in jpg

After restart everything : afrender output :

C:\cgru-windows\start\AFANASY>rem Name=Local Render... C:\cgru-windows\start\AFANASY>rem Separator C:\cgru-windows\start\AFANASY>call "C:\cgru-windows\start\AFANASY\render.cmd".. _setup.cmd C:\cgru-windows\start\AFANASY>pushd "C:\cgru-windows\start\AFANASY\render.cmd". ._setup.cmd.. C:\cgru-windows\start\AFANASY>cd .. C:\cgru-windows\start>call _setup.cmd C:\cgru-windows\start>if not defined CGRU_LOCATION ( pushd _setup.cmd.. cd .. call setup.cmd popd ) CGRU_VERSION 2.0.8 Using CGRU Python: C:\cgru-windows\python Compilation date = 'Nov 12 2015 02:49:43' CGRU version = '2.0.8' Afanasy build revision = '8a841da8d2012cf08143ffc06bdde9df6e3d949b' Python version = '3.4.1' Network Interfaces: {943567DA-897B-48CF-B324-14022A812495}: bc:ae:c5:17:e6:86 IPv6 Address: fe80::::::: IPv6 Address: fe80::::5149:c3c9:5bb3:8845 IPv6 Address: ff00::::::: IPv4 Address: 192.168.0.0 IPv4 Address: 192.168.0.40 IPv4 Address: 192.168.0.255 IPv4 Address: 224.0.0.0 IPv4 Address: 255.255.255.255 Windows Must Die: ImageMagick Studio library and utility programs Microsoft Visual C++ Runtime Library QuickTimeHelper-32.exe - Application Error Visual Studio Just-In-Time Debugger ON workstation-pc@workstation[0] Empty address Host: OS="windows 64" Capacity = 0, Max Tasks = 0, Power = 0 Resources: CPU = 3207 MHz x12 1% usr, 0% nice, 1% sys, 97% idle, 0% iow, 0% irq, 0% sirq load average: 0 0 0 Memory: 20471 Mb / 13696 Mb free Swap: 40940 Mb / 9565 Mb used Network: Recieved 37 Kb/sec, Send 103 Kb/sec IO: Read 0 Kb/sec, Write 0 Kb/sec, Busy = 0% HDD: 111 Gb / 10 Gb free Available addresses: IPv6 = '::' IP = '0.0.0.0' IPv6 is disabled by config. Using IPv4 addresses family. Listening 51001 port... Render registered. Started PID=11248: [natron:1000] workstation: test_natron[Write1][frame 1-10]

This is what I have : capture

timurhai commented 8 years ago

hm, try to read some png instead of exr

ramellij commented 8 years ago

with png it works perfect :

Started PID=3868: [natron:1000] workstation: test_natron[Write1][frame 1-10] Finished PID=3868: Exit Code=0 Status=0 Started PID=8968: [natron:1000] workstation: test_natron[Write1][frame 11-20] Finished PID=8968: Exit Code=0 Status=0 Started PID=6072: [natron:1000] workstation: test_natron[Write1][frame 21-30] Finished PID=6072: Exit Code=0 Status=0 Started PID=8448: [natron:1000] workstation: test_natron[Write1][frame 31-40] Finished PID=8448: Exit Code=0 Status=0

timurhai commented 8 years ago

hm, i should try to read exr's too (give me some time, right now i can't test), but if image file type plays such role, probably it is some Natron bug.

ramellij commented 8 years ago

yes of course

timurhai commented 8 years ago

Also you can try to enable thumbnails back, one bug with its early generation already fixed in 2.0.8

ip commented 8 years ago

please include @ip in quotes :smile:

ramellij commented 8 years ago

Hi Timur, Just to say that I'm testing Fusion too and I got same result as Natron : trying to load EXR and save it in JPG it renders the first task in loop. And when I use PNG instead of EXR it works. There is definitely something going wrong with EXR.

timurhai commented 8 years ago

Hi. What does it mean that it "renders first task in loop"? You should provide task log. "Loop" means that 1st task was started, finished error, restarted, finished error, restarted, finished error ... Until host appears in an error host list or task error retries limit reached? This means that task process finished with a non zero exit status. This means some error. May be it even printed in the task output.

Afanasy just run commands, no matter what that command do natron or fusion, read pngs or exrs. So if it does not generate thumbnails, it does no nothing about any result file type, exr or not.

I just tried natron to read exr and save jpg, task does not finishes at all for me, and even no matter whether i read exr or png, only if there is no reader in the project, command can finish.

So, natron command does not finishes. Fusion - some error - see task output.

When you tried run afanasy task command in windows terminal, command finishes? For me - not. Afanasy (afrender) waits for process finish, of course.

timurhai commented 8 years ago

Just created EXR read issue: https://github.com/MrKepzie/Natron/issues/1026