runsolver Copyright (C) 2010 Olivier ROUSSEL

This is runsolver version 3.2.9a (svn: 651)

This program is distributed in the hope that it will be useful,
but WITHOUT ANY WARRANTY; without even the implied warranty of
MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE.  See the
GNU General Public License for more details.

command line: /home/misc2010/bin/runsolver -s SIGUSR1 -M 1124 -C 290 -d 10 -w /home/misc2010/tmp/201108300820/p2cudf-user-1.13/ff4a1d84-d490-11df-9e6c-00163e3d3b7c.cudf.dudf-real.log.runsolver ./p2cudf-user-1.13 /home/misc2010/data/2011/dudf-real//ff4a1d84-d490-11df-9e6c-00163e3d3b7c.cudf /home/misc2010/tmp/201108300820/p2cudf-user-1.13/ff4a1d84-d490-11df-9e6c-00163e3d3b7c.cudf.dudf-real.result +sum(installedsize) 

Enforcing CPUTime limit (soft limit, will send signal-name then SIGKILL): 290 seconds
Enforcing CPUTime limit (hard limit, will send SIGXCPU): 320 seconds
Enforcing VSIZE limit (soft limit, will send signal-name then SIGKILL): 1150976 KiB
Enforcing VSIZE limit (hard limit, stack expansion will fail with SIGSEGV, brk() and mmap() will return ENOMEM): 1202176 KiB
Current StackSize limit: 8192 KiB


[startup+0 s]
/proc/loadavg: 0.85 0.98 0.99 1/33 19635
/proc/meminfo: memFree=933604/1048576 swapFree=0/0
[pid=19635] ppid=19634 vsize=3016 CPUtime=0
/proc/19635/stat : 19635 (runsolver) D 19634 19635 2160 34817 2160 4202560 72 0 0 0 0 0 0 0 25 0 1 0 60050718 3088384 93 1283457024 134512640 134586868 4289965120 18446744073709551615 4294960130 0 0 0 24578 18446744071564332000 0 0 17 0 0 0 0
/proc/19635/statm: 754 93 62 19 0 53 0

[startup+0.143876 s]
/proc/loadavg: 0.85 0.98 0.99 1/33 19635
/proc/meminfo: memFree=933604/1048576 swapFree=0/0
[pid=19635] ppid=19634 vsize=2572 CPUtime=0
/proc/19635/stat : 19635 (p2cudf-user-1.1) S 19634 19635 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 60050718 2633728 271 1283457024 134512640 135304128 4289156160 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19635/statm: 643 271 230 194 0 30 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2572

[startup+0.207895 s]
/proc/loadavg: 0.85 0.98 0.99 1/33 19635
/proc/meminfo: memFree=933604/1048576 swapFree=0/0
[pid=19635] ppid=19634 vsize=2572 CPUtime=0
/proc/19635/stat : 19635 (p2cudf-user-1.1) S 19634 19635 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 60050718 2633728 271 1283457024 134512640 135304128 4289156160 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19635/statm: 643 271 230 194 0 30 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2572

[startup+0.307902 s]
/proc/loadavg: 0.85 0.98 0.99 1/33 19635
/proc/meminfo: memFree=933604/1048576 swapFree=0/0
[pid=19635] ppid=19634 vsize=2572 CPUtime=0
/proc/19635/stat : 19635 (p2cudf-user-1.1) S 19634 19635 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 60050718 2633728 271 1283457024 134512640 135304128 4289156160 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19635/statm: 643 271 230 194 0 30 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2572

[startup+0.707906 s]
/proc/loadavg: 0.85 0.98 0.99 1/33 19635
/proc/meminfo: memFree=933604/1048576 swapFree=0/0
[pid=19635] ppid=19634 vsize=2572 CPUtime=0
/proc/19635/stat : 19635 (p2cudf-user-1.1) S 19634 19635 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 60050718 2633728 271 1283457024 134512640 135304128 4289156160 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19635/statm: 643 271 230 194 0 30 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2572

[startup+1.50506 s]
/proc/loadavg: 0.86 0.98 0.99 5/45 19658
/proc/meminfo: memFree=899332/1048576 swapFree=0/0
[pid=19635] ppid=19634 vsize=2572 CPUtime=0
/proc/19635/stat : 19635 (p2cudf-user-1.1) S 19634 19635 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 60050718 2633728 271 1283457024 134512640 135304128 4289156160 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19635/statm: 643 271 230 194 0 30 0
[pid=19637] ppid=19635 vsize=2572 CPUtime=0.01
/proc/19637/stat : 19637 (p2cudf) S 19635 19635 2160 34817 2160 4202496 390 3018 0 1 0 0 0 1 25 0 1 0 60050719 2633728 280 1283457024 134512640 135304128 4288601072 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19637/statm: 643 280 239 194 0 30 0
[pid=19649] ppid=19637 vsize=887372 CPUtime=0.86
/proc/19649/stat : 19649 (java) S 19637 19635 2160 34817 2160 4202496 16292 0 106 0 81 5 0 0 23 0 10 0 60050723 908668928 13785 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/19649/statm: 221843 13785 1728 10 0 218934 0
[pid=19649/tid=19650] ppid=19637 vsize=887372 CPUtime=0.26
/proc/19649/task/19650/stat : 19650 (java) R 19637 19635 2160 34817 2160 4202560 5338 0 15 0 25 1 0 0 25 0 10 0 60050748 908668928 13785 1283457024 134512640 134550932 4288207392 18446744073709551615 4094934995 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=19649/tid=19651] ppid=19637 vsize=887372 CPUtime=0
/proc/19649/task/19651/stat : 19651 (java) S 19637 19635 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 19 0 10 0 60050758 908668928 13785 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19652] ppid=19637 vsize=887372 CPUtime=0
/proc/19649/task/19652/stat : 19652 (java) S 19637 19635 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 25 0 10 0 60050759 908668928 13785 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19653] ppid=19637 vsize=887372 CPUtime=0
/proc/19649/task/19653/stat : 19653 (java) S 19637 19635 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 10 0 60050759 908668928 13785 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19654] ppid=19637 vsize=887372 CPUtime=0
/proc/19649/task/19654/stat : 19654 (java) S 19637 19635 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 60050769 908668928 13785 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19655] ppid=19637 vsize=887372 CPUtime=0.31
/proc/19649/task/19655/stat : 19655 (java) R 19637 19635 2160 34817 2160 4202560 3967 0 1 0 30 1 0 0 23 0 10 0 60050769 908668928 13785 1283457024 134512640 134550932 4288207392 18446744073709551615 4151608752 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=19649/tid=19656] ppid=19637 vsize=887372 CPUtime=0.27
/proc/19649/task/19656/stat : 19656 (java) R 19637 19635 2160 34817 2160 4202560 5990 0 7 0 25 2 0 0 25 0 10 0 60050769 908668928 13785 1283457024 134512640 134550932 4288207392 18446744073709551615 4149545736 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=19649/tid=19657] ppid=19637 vsize=887372 CPUtime=0
/proc/19649/task/19657/stat : 19657 (java) S 19637 19635 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 60050769 908668928 13785 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19658] ppid=19637 vsize=887372 CPUtime=0
/proc/19649/task/19658/stat : 19658 (java) S 19637 19635 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 16 0 10 0 60050769 908668928 13785 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 0.87
Current children cumulated vsize (KiB) 892516

[startup+3.10406 s]
/proc/loadavg: 0.86 0.98 0.99 3/45 19658
/proc/meminfo: memFree=796784/1048576 swapFree=0/0
[pid=19635] ppid=19634 vsize=2572 CPUtime=0
/proc/19635/stat : 19635 (p2cudf-user-1.1) S 19634 19635 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 60050718 2633728 271 1283457024 134512640 135304128 4289156160 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19635/statm: 643 271 230 194 0 30 0
[pid=19637] ppid=19635 vsize=2572 CPUtime=0.01
/proc/19637/stat : 19637 (p2cudf) S 19635 19635 2160 34817 2160 4202496 390 3018 0 1 0 0 0 1 25 0 1 0 60050719 2633728 280 1283457024 134512640 135304128 4288601072 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19637/statm: 643 280 239 194 0 30 0
[pid=19649] ppid=19637 vsize=885468 CPUtime=2.45
/proc/19649/stat : 19649 (java) S 19637 19635 2160 34817 2160 4202496 73149 0 106 0 224 21 0 0 23 0 10 0 60050723 906719232 70346 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/19649/statm: 221367 70346 1747 10 0 218458 0
[pid=19649/tid=19650] ppid=19637 vsize=885468 CPUtime=1.37
/proc/19649/task/19650/stat : 19650 (java) R 19637 19635 2160 34817 2160 4202560 50048 0 15 0 121 16 0 0 25 0 10 0 60050748 906719232 70346 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=19649/tid=19651] ppid=19637 vsize=885468 CPUtime=0.25
/proc/19649/task/19651/stat : 19651 (java) S 19637 19635 2160 34817 2160 4202560 11926 0 0 0 24 1 0 0 16 0 10 0 60050758 906719232 70346 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19652] ppid=19637 vsize=885468 CPUtime=0
/proc/19649/task/19652/stat : 19652 (java) S 19637 19635 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 10 0 60050759 906719232 70346 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19653] ppid=19637 vsize=885468 CPUtime=0
/proc/19649/task/19653/stat : 19653 (java) S 19637 19635 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 10 0 60050759 906719232 70346 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19654] ppid=19637 vsize=885468 CPUtime=0
/proc/19649/task/19654/stat : 19654 (java) S 19637 19635 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 60050769 906719232 70346 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19655] ppid=19637 vsize=885468 CPUtime=0.42
/proc/19649/task/19655/stat : 19655 (java) S 19637 19635 2160 34817 2160 4202560 4151 0 1 0 41 1 0 0 22 0 10 0 60050769 906719232 70346 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19656] ppid=19637 vsize=885468 CPUtime=0.38
/proc/19649/task/19656/stat : 19656 (java) S 19637 19635 2160 34817 2160 4202560 6031 0 7 0 36 2 0 0 23 0 10 0 60050769 906719232 70346 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19657] ppid=19637 vsize=885468 CPUtime=0
/proc/19649/task/19657/stat : 19657 (java) S 19637 19635 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 60050769 906719232 70346 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19658] ppid=19637 vsize=885468 CPUtime=0
/proc/19649/task/19658/stat : 19658 (java) S 19637 19635 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 10 0 60050769 906719232 70346 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 2.46
Current children cumulated vsize (KiB) 890612
heavy processes:

[startup+6.30616 s]
/proc/loadavg: 0.87 0.98 0.99 2/46 19659
/proc/meminfo: memFree=645280/1048576 swapFree=0/0
[pid=19635] ppid=19634 vsize=2572 CPUtime=0
/proc/19635/stat : 19635 (p2cudf-user-1.1) S 19634 19635 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 60050718 2633728 271 1283457024 134512640 135304128 4289156160 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19635/statm: 643 271 230 194 0 30 0
[pid=19637] ppid=19635 vsize=2572 CPUtime=0.01
/proc/19637/stat : 19637 (p2cudf) S 19635 19635 2160 34817 2160 4202496 390 3018 0 1 0 0 0 1 25 0 1 0 60050719 2633728 280 1283457024 134512640 135304128 4288601072 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19637/statm: 643 280 239 194 0 30 0
[pid=19649] ppid=19637 vsize=885792 CPUtime=5.51
/proc/19649/stat : 19649 (java) S 19637 19635 2160 34817 2160 4202496 74600 0 107 0 528 23 0 0 23 0 11 0 60050723 907051008 71114 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/19649/statm: 221448 71114 1781 10 0 218539 0
[pid=19649/tid=19650] ppid=19637 vsize=885792 CPUtime=2.79
/proc/19649/task/19650/stat : 19650 (java) R 19637 19635 2160 34817 2160 4202560 50276 0 15 0 262 17 0 0 25 0 11 0 60050748 907051008 71114 1283457024 134512640 134550932 4288207392 18446744073709551615 4095684006 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=19649/tid=19651] ppid=19637 vsize=885792 CPUtime=0.25
/proc/19649/task/19651/stat : 19651 (java) S 19637 19635 2160 34817 2160 4202560 11926 0 0 0 24 1 0 0 15 0 11 0 60050758 907051008 71114 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19652] ppid=19637 vsize=885792 CPUtime=0
/proc/19649/task/19652/stat : 19652 (java) S 19637 19635 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 60050759 907051008 71114 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19653] ppid=19637 vsize=885792 CPUtime=0
/proc/19649/task/19653/stat : 19653 (java) S 19637 19635 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 60050759 907051008 71114 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19654] ppid=19637 vsize=885792 CPUtime=0
/proc/19649/task/19654/stat : 19654 (java) S 19637 19635 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 60050769 907051008 71114 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19655] ppid=19637 vsize=885792 CPUtime=0.42
/proc/19649/task/19655/stat : 19655 (java) S 19637 19635 2160 34817 2160 4202560 4151 0 1 0 41 1 0 0 22 0 11 0 60050769 907051008 71114 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19656] ppid=19637 vsize=885792 CPUtime=2.02
/proc/19649/task/19656/stat : 19656 (java) S 19637 19635 2160 34817 2160 4202560 7250 0 8 0 200 2 0 0 15 0 11 0 60050769 907051008 71114 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19657] ppid=19637 vsize=885792 CPUtime=0
/proc/19649/task/19657/stat : 19657 (java) S 19637 19635 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 60050769 907051008 71114 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19658] ppid=19637 vsize=885792 CPUtime=0
/proc/19649/task/19658/stat : 19658 (java) S 19637 19635 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 60050769 907051008 71114 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19659] ppid=19637 vsize=885792 CPUtime=0
/proc/19649/task/19659/stat : 19659 (java) S 19637 19635 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 60051209 907051008 71114 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 5.52
Current children cumulated vsize (KiB) 890936

[startup+12.7075 s]
/proc/loadavg: 0.96 1.00 0.99 2/46 19659
/proc/meminfo: memFree=595556/1048576 swapFree=0/0
[pid=19635] ppid=19634 vsize=2572 CPUtime=0
/proc/19635/stat : 19635 (p2cudf-user-1.1) S 19634 19635 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 60050718 2633728 271 1283457024 134512640 135304128 4289156160 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19635/statm: 643 271 230 194 0 30 0
[pid=19637] ppid=19635 vsize=2572 CPUtime=0.01
/proc/19637/stat : 19637 (p2cudf) S 19635 19635 2160 34817 2160 4202496 390 3018 0 1 0 0 0 1 25 0 1 0 60050719 2633728 280 1283457024 134512640 135304128 4288601072 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19637/statm: 643 280 239 194 0 30 0
[pid=19649] ppid=19637 vsize=884884 CPUtime=11.91
/proc/19649/stat : 19649 (java) S 19637 19635 2160 34817 2160 4202496 87130 0 107 0 1164 27 0 0 23 0 11 0 60050723 906121216 83449 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/19649/statm: 221221 83449 1787 10 0 218312 0
[pid=19649/tid=19650] ppid=19637 vsize=884884 CPUtime=8.62
/proc/19649/task/19650/stat : 19650 (java) R 19637 19635 2160 34817 2160 4202560 50277 0 15 0 845 17 0 0 25 0 11 0 60050748 906121216 83449 1283457024 134512640 134550932 4288207392 18446744073709551615 4095683947 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=19649/tid=19651] ppid=19637 vsize=884884 CPUtime=0.69
/proc/19649/task/19651/stat : 19651 (java) S 19637 19635 2160 34817 2160 4202560 24440 0 0 0 64 5 0 0 15 0 11 0 60050758 906121216 83449 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19652] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19652/stat : 19652 (java) S 19637 19635 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 60050759 906121216 83449 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19653] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19653/stat : 19653 (java) S 19637 19635 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 60050759 906121216 83449 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19654] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19654/stat : 19654 (java) S 19637 19635 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 60050769 906121216 83449 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19655] ppid=19637 vsize=884884 CPUtime=0.42
/proc/19649/task/19655/stat : 19655 (java) S 19637 19635 2160 34817 2160 4202560 4151 0 1 0 41 1 0 0 22 0 11 0 60050769 906121216 83449 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19656] ppid=19637 vsize=884884 CPUtime=2.14
/proc/19649/task/19656/stat : 19656 (java) S 19637 19635 2160 34817 2160 4202560 7265 0 8 0 212 2 0 0 16 0 11 0 60050769 906121216 83449 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19657] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19657/stat : 19657 (java) S 19637 19635 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 60050769 906121216 83449 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19658] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19658/stat : 19658 (java) S 19637 19635 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 60050769 906121216 83449 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19659] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19659/stat : 19659 (java) S 19637 19635 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 60051209 906121216 83449 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 11.92
Current children cumulated vsize (KiB) 890028

[startup+25.51 s]
/proc/loadavg: 0.97 1.00 0.99 2/46 19659
/proc/meminfo: memFree=585636/1048576 swapFree=0/0
[pid=19635] ppid=19634 vsize=2572 CPUtime=0
/proc/19635/stat : 19635 (p2cudf-user-1.1) S 19634 19635 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 60050718 2633728 271 1283457024 134512640 135304128 4289156160 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19635/statm: 643 271 230 194 0 30 0
[pid=19637] ppid=19635 vsize=2572 CPUtime=0.01
/proc/19637/stat : 19637 (p2cudf) S 19635 19635 2160 34817 2160 4202496 390 3018 0 1 0 0 0 1 25 0 1 0 60050719 2633728 280 1283457024 134512640 135304128 4288601072 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19637/statm: 643 280 239 194 0 30 0
[pid=19649] ppid=19637 vsize=884884 CPUtime=24.7
/proc/19649/stat : 19649 (java) S 19637 19635 2160 34817 2160 4202496 89589 0 107 0 2442 28 0 0 23 0 11 0 60050723 906121216 85908 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/19649/statm: 221221 85908 1787 10 0 218312 0
[pid=19649/tid=19650] ppid=19637 vsize=884884 CPUtime=20.83
/proc/19649/task/19650/stat : 19650 (java) R 19637 19635 2160 34817 2160 4202560 50277 0 15 0 2066 17 0 0 25 0 11 0 60050748 906121216 85908 1283457024 134512640 134550932 4288207392 18446744073709551615 4095778490 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=19649/tid=19651] ppid=19637 vsize=884884 CPUtime=1.24
/proc/19649/task/19651/stat : 19651 (java) S 19637 19635 2160 34817 2160 4202560 26893 0 0 0 118 6 0 0 15 0 11 0 60050758 906121216 85908 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19652] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19652/stat : 19652 (java) S 19637 19635 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 60050759 906121216 85908 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19653] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19653/stat : 19653 (java) S 19637 19635 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 60050759 906121216 85908 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19654] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19654/stat : 19654 (java) S 19637 19635 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 60050769 906121216 85908 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19655] ppid=19637 vsize=884884 CPUtime=0.42
/proc/19649/task/19655/stat : 19655 (java) S 19637 19635 2160 34817 2160 4202560 4151 0 1 0 41 1 0 0 22 0 11 0 60050769 906121216 85908 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19656] ppid=19637 vsize=884884 CPUtime=2.17
/proc/19649/task/19656/stat : 19656 (java) S 19637 19635 2160 34817 2160 4202560 7271 0 8 0 215 2 0 0 16 0 11 0 60050769 906121216 85908 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19657] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19657/stat : 19657 (java) S 19637 19635 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 60050769 906121216 85908 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19658] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19658/stat : 19658 (java) S 19637 19635 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 60050769 906121216 85908 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19659] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19659/stat : 19659 (java) S 19637 19635 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 60051209 906121216 85908 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 24.71
Current children cumulated vsize (KiB) 890028

[startup+51.1064 s]
/proc/loadavg: 1.05 1.01 1.00 2/46 19659
/proc/meminfo: memFree=573732/1048576 swapFree=0/0
[pid=19635] ppid=19634 vsize=2572 CPUtime=0
/proc/19635/stat : 19635 (p2cudf-user-1.1) S 19634 19635 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 60050718 2633728 271 1283457024 134512640 135304128 4289156160 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19635/statm: 643 271 230 194 0 30 0
[pid=19637] ppid=19635 vsize=2572 CPUtime=0.01
/proc/19637/stat : 19637 (p2cudf) S 19635 19635 2160 34817 2160 4202496 390 3018 0 1 0 0 0 1 25 0 1 0 60050719 2633728 280 1283457024 134512640 135304128 4288601072 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19637/statm: 643 280 239 194 0 30 0
[pid=19649] ppid=19637 vsize=884884 CPUtime=50.28
/proc/19649/stat : 19649 (java) S 19637 19635 2160 34817 2160 4202496 92545 0 107 0 4999 29 0 0 23 0 11 0 60050723 906121216 88864 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/19649/statm: 221221 88864 1787 10 0 218312 0
[pid=19649/tid=19650] ppid=19637 vsize=884884 CPUtime=45.18
/proc/19649/task/19650/stat : 19650 (java) R 19637 19635 2160 34817 2160 4202560 50277 0 15 0 4501 17 0 0 25 0 11 0 60050748 906121216 88864 1283457024 134512640 134550932 4288207392 18446744073709551615 4095605888 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=19649/tid=19651] ppid=19637 vsize=884884 CPUtime=2.42
/proc/19649/task/19651/stat : 19651 (java) S 19637 19635 2160 34817 2160 4202560 29840 0 0 0 235 7 0 0 15 0 11 0 60050758 906121216 88864 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19652] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19652/stat : 19652 (java) S 19637 19635 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 60050759 906121216 88864 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19653] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19653/stat : 19653 (java) S 19637 19635 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 60050759 906121216 88864 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19654] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19654/stat : 19654 (java) S 19637 19635 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 60050769 906121216 88864 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19655] ppid=19637 vsize=884884 CPUtime=0.42
/proc/19649/task/19655/stat : 19655 (java) S 19637 19635 2160 34817 2160 4202560 4151 0 1 0 41 1 0 0 22 0 11 0 60050769 906121216 88864 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19656] ppid=19637 vsize=884884 CPUtime=2.22
/proc/19649/task/19656/stat : 19656 (java) S 19637 19635 2160 34817 2160 4202560 7280 0 8 0 220 2 0 0 16 0 11 0 60050769 906121216 88864 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19657] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19657/stat : 19657 (java) S 19637 19635 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 60050769 906121216 88864 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19658] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19658/stat : 19658 (java) S 19637 19635 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 60050769 906121216 88864 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19659] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19659/stat : 19659 (java) S 19637 19635 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 60051209 906121216 88864 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 50.29
Current children cumulated vsize (KiB) 890028

[startup+102.31 s]
/proc/loadavg: 1.02 1.01 1.00 2/46 19659
/proc/meminfo: memFree=556124/1048576 swapFree=0/0
[pid=19635] ppid=19634 vsize=2572 CPUtime=0
/proc/19635/stat : 19635 (p2cudf-user-1.1) S 19634 19635 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 60050718 2633728 271 1283457024 134512640 135304128 4289156160 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19635/statm: 643 271 230 194 0 30 0
[pid=19637] ppid=19635 vsize=2572 CPUtime=0.01
/proc/19637/stat : 19637 (p2cudf) S 19635 19635 2160 34817 2160 4202496 390 3018 0 1 0 0 0 1 25 0 1 0 60050719 2633728 280 1283457024 134512640 135304128 4288601072 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19637/statm: 643 280 239 194 0 30 0
[pid=19649] ppid=19637 vsize=884884 CPUtime=101.4
/proc/19649/stat : 19649 (java) S 19637 19635 2160 34817 2160 4202496 96903 0 107 0 10109 31 0 0 23 0 11 0 60050723 906121216 93222 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/19649/statm: 221221 93222 1787 10 0 218312 0
[pid=19649/tid=19650] ppid=19637 vsize=884884 CPUtime=95.1
/proc/19649/task/19650/stat : 19650 (java) R 19637 19635 2160 34817 2160 4202560 50277 0 15 0 9493 17 0 0 25 0 11 0 60050748 906121216 93222 1283457024 134512640 134550932 4288207392 18446744073709551615 4095778490 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=19649/tid=19651] ppid=19637 vsize=884884 CPUtime=3.63
/proc/19649/task/19651/stat : 19651 (java) S 19637 19635 2160 34817 2160 4202560 34198 0 0 0 354 9 0 0 15 0 11 0 60050758 906121216 93222 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19652] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19652/stat : 19652 (java) S 19637 19635 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 60050759 906121216 93222 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19653] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19653/stat : 19653 (java) S 19637 19635 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 60050759 906121216 93222 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19654] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19654/stat : 19654 (java) S 19637 19635 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 60050769 906121216 93222 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19655] ppid=19637 vsize=884884 CPUtime=0.42
/proc/19649/task/19655/stat : 19655 (java) S 19637 19635 2160 34817 2160 4202560 4151 0 1 0 41 1 0 0 22 0 11 0 60050769 906121216 93222 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19656] ppid=19637 vsize=884884 CPUtime=2.22
/proc/19649/task/19656/stat : 19656 (java) S 19637 19635 2160 34817 2160 4202560 7280 0 8 0 220 2 0 0 16 0 11 0 60050769 906121216 93222 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19657] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19657/stat : 19657 (java) S 19637 19635 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 60050769 906121216 93222 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19658] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19658/stat : 19658 (java) S 19637 19635 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 60050769 906121216 93222 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19659] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19659/stat : 19659 (java) S 19637 19635 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 60051209 906121216 93222 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 101.41
Current children cumulated vsize (KiB) 890028

[startup+162.304 s]
/proc/loadavg: 1.00 1.00 1.00 2/48 19661
/proc/meminfo: memFree=548908/1048576 swapFree=0/0
[pid=19635] ppid=19634 vsize=2572 CPUtime=0
/proc/19635/stat : 19635 (p2cudf-user-1.1) S 19634 19635 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 60050718 2633728 271 1283457024 134512640 135304128 4289156160 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19635/statm: 643 271 230 194 0 30 0
[pid=19637] ppid=19635 vsize=2572 CPUtime=0.01
/proc/19637/stat : 19637 (p2cudf) S 19635 19635 2160 34817 2160 4202496 390 3018 0 1 0 0 0 1 25 0 1 0 60050719 2633728 280 1283457024 134512640 135304128 4288601072 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19637/statm: 643 280 239 194 0 30 0
[pid=19649] ppid=19637 vsize=884884 CPUtime=161.36
/proc/19649/stat : 19649 (java) S 19637 19635 2160 34817 2160 4202496 98661 0 107 0 16104 32 0 0 23 0 11 0 60050723 906121216 94980 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/19649/statm: 221221 94980 1787 10 0 218312 0
[pid=19649/tid=19650] ppid=19637 vsize=884884 CPUtime=153.52
/proc/19649/task/19650/stat : 19650 (java) R 19637 19635 2160 34817 2160 4202560 50277 0 15 0 15334 18 0 0 25 0 11 0 60050748 906121216 94980 1283457024 134512640 134550932 4288207392 18446744073709551615 4095600620 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=19649/tid=19651] ppid=19637 vsize=884884 CPUtime=5.17
/proc/19649/task/19651/stat : 19651 (java) S 19637 19635 2160 34817 2160 4202560 35956 0 0 0 508 9 0 0 15 0 11 0 60050758 906121216 94980 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19652] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19652/stat : 19652 (java) S 19637 19635 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 60050759 906121216 94980 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19653] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19653/stat : 19653 (java) S 19637 19635 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 60050759 906121216 94980 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19654] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19654/stat : 19654 (java) S 19637 19635 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 60050769 906121216 94980 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19655] ppid=19637 vsize=884884 CPUtime=0.42
/proc/19649/task/19655/stat : 19655 (java) S 19637 19635 2160 34817 2160 4202560 4151 0 1 0 41 1 0 0 22 0 11 0 60050769 906121216 94980 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19656] ppid=19637 vsize=884884 CPUtime=2.22
/proc/19649/task/19656/stat : 19656 (java) S 19637 19635 2160 34817 2160 4202560 7280 0 8 0 220 2 0 0 16 0 11 0 60050769 906121216 94980 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19657] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19657/stat : 19657 (java) S 19637 19635 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 60050769 906121216 94980 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19658] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19658/stat : 19658 (java) S 19637 19635 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 60050769 906121216 94980 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19659] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19659/stat : 19659 (java) S 19637 19635 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 60051209 906121216 94980 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 161.37
Current children cumulated vsize (KiB) 890028

[startup+222.306 s]
/proc/loadavg: 1.00 1.00 1.00 2/48 19667
/proc/meminfo: memFree=526960/1048576 swapFree=0/0
[pid=19635] ppid=19634 vsize=2572 CPUtime=0
/proc/19635/stat : 19635 (p2cudf-user-1.1) S 19634 19635 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 60050718 2633728 271 1283457024 134512640 135304128 4289156160 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19635/statm: 643 271 230 194 0 30 0
[pid=19637] ppid=19635 vsize=2572 CPUtime=0.01
/proc/19637/stat : 19637 (p2cudf) S 19635 19635 2160 34817 2160 4202496 390 3018 0 1 0 0 0 1 25 0 1 0 60050719 2633728 280 1283457024 134512640 135304128 4288601072 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19637/statm: 643 280 239 194 0 30 0
[pid=19649] ppid=19637 vsize=884884 CPUtime=221.31
/proc/19649/stat : 19649 (java) S 19637 19635 2160 34817 2160 4202496 104125 0 107 0 22098 33 0 0 23 0 11 0 60050723 906121216 100444 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/19649/statm: 221221 100444 1787 10 0 218312 0
[pid=19649/tid=19650] ppid=19637 vsize=884884 CPUtime=212.56
/proc/19649/task/19650/stat : 19650 (java) R 19637 19635 2160 34817 2160 4202560 50277 0 15 0 21238 18 0 0 25 0 11 0 60050748 906121216 100444 1283457024 134512640 134550932 4288207392 18446744073709551615 4095778128 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=19649/tid=19651] ppid=19637 vsize=884884 CPUtime=6.08
/proc/19649/task/19651/stat : 19651 (java) S 19637 19635 2160 34817 2160 4202560 41420 0 0 0 598 10 0 0 15 0 11 0 60050758 906121216 100444 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19652] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19652/stat : 19652 (java) S 19637 19635 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 60050759 906121216 100444 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19653] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19653/stat : 19653 (java) S 19637 19635 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 60050759 906121216 100444 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19654] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19654/stat : 19654 (java) S 19637 19635 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 60050769 906121216 100444 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19655] ppid=19637 vsize=884884 CPUtime=0.42
/proc/19649/task/19655/stat : 19655 (java) S 19637 19635 2160 34817 2160 4202560 4151 0 1 0 41 1 0 0 22 0 11 0 60050769 906121216 100444 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19656] ppid=19637 vsize=884884 CPUtime=2.22
/proc/19649/task/19656/stat : 19656 (java) S 19637 19635 2160 34817 2160 4202560 7280 0 8 0 220 2 0 0 16 0 11 0 60050769 906121216 100444 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19657] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19657/stat : 19657 (java) S 19637 19635 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 60050769 906121216 100444 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19658] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19658/stat : 19658 (java) S 19637 19635 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 60050769 906121216 100444 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19659] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19659/stat : 19659 (java) S 19637 19635 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 60051209 906121216 100444 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 221.32
Current children cumulated vsize (KiB) 890028

[startup+282.309 s]
/proc/loadavg: 1.00 1.00 1.00 3/47 19670
/proc/meminfo: memFree=522016/1048576 swapFree=0/0
[pid=19635] ppid=19634 vsize=2572 CPUtime=0
/proc/19635/stat : 19635 (p2cudf-user-1.1) S 19634 19635 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 60050718 2633728 271 1283457024 134512640 135304128 4289156160 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19635/statm: 643 271 230 194 0 30 0
[pid=19637] ppid=19635 vsize=2572 CPUtime=0.01
/proc/19637/stat : 19637 (p2cudf) S 19635 19635 2160 34817 2160 4202496 390 3018 0 1 0 0 0 1 25 0 1 0 60050719 2633728 280 1283457024 134512640 135304128 4288601072 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19637/statm: 643 280 239 194 0 30 0
[pid=19649] ppid=19637 vsize=884884 CPUtime=281.25
/proc/19649/stat : 19649 (java) S 19637 19635 2160 34817 2160 4202496 110103 0 107 0 28087 38 0 0 23 0 11 0 60050723 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/19649/statm: 221221 106422 1787 10 0 218312 0
[pid=19649/tid=19650] ppid=19637 vsize=884884 CPUtime=271.23
/proc/19649/task/19650/stat : 19650 (java) R 19637 19635 2160 34817 2160 4202560 50277 0 15 0 27102 21 0 0 25 0 11 0 60050748 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4095667275 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=19649/tid=19651] ppid=19637 vsize=884884 CPUtime=7.35
/proc/19649/task/19651/stat : 19651 (java) S 19637 19635 2160 34817 2160 4202560 47398 0 0 0 723 12 0 0 16 0 11 0 60050758 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19652] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19652/stat : 19652 (java) S 19637 19635 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 60050759 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19653] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19653/stat : 19653 (java) S 19637 19635 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 60050759 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19654] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19654/stat : 19654 (java) S 19637 19635 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 60050769 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19655] ppid=19637 vsize=884884 CPUtime=0.42
/proc/19649/task/19655/stat : 19655 (java) S 19637 19635 2160 34817 2160 4202560 4151 0 1 0 41 1 0 0 22 0 11 0 60050769 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19656] ppid=19637 vsize=884884 CPUtime=2.22
/proc/19649/task/19656/stat : 19656 (java) S 19637 19635 2160 34817 2160 4202560 7280 0 8 0 220 2 0 0 16 0 11 0 60050769 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19657] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19657/stat : 19657 (java) S 19637 19635 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 60050769 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19658] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19658/stat : 19658 (java) S 19637 19635 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 60050769 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19659] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19659/stat : 19659 (java) S 19637 19635 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 60051209 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 281.26
Current children cumulated vsize (KiB) 890028

Solver just ended. Dumping a history of the last processes samples

[startup+283.209 s]
/proc/loadavg: 1.00 1.00 1.00 2/47 19670
/proc/meminfo: memFree=503044/1048576 swapFree=0/0
[pid=19635] ppid=19634 vsize=2572 CPUtime=0
/proc/19635/stat : 19635 (p2cudf-user-1.1) S 19634 19635 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 60050718 2633728 271 1283457024 134512640 135304128 4289156160 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19635/statm: 643 271 230 194 0 30 0
[pid=19637] ppid=19635 vsize=2572 CPUtime=0.01
/proc/19637/stat : 19637 (p2cudf) S 19635 19635 2160 34817 2160 4202496 390 3018 0 1 0 0 0 1 25 0 1 0 60050719 2633728 280 1283457024 134512640 135304128 4288601072 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19637/statm: 643 280 239 194 0 30 0
[pid=19649] ppid=19637 vsize=884884 CPUtime=282.15
/proc/19649/stat : 19649 (java) S 19637 19635 2160 34817 2160 4202496 110103 0 107 0 28177 38 0 0 23 0 11 0 60050723 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/19649/statm: 221221 106422 1787 10 0 218312 0
[pid=19649/tid=19650] ppid=19637 vsize=884884 CPUtime=272.13
/proc/19649/task/19650/stat : 19650 (java) R 19637 19635 2160 34817 2160 4202560 50277 0 15 0 27192 21 0 0 25 0 11 0 60050748 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4095778186 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=19649/tid=19651] ppid=19637 vsize=884884 CPUtime=7.35
/proc/19649/task/19651/stat : 19651 (java) S 19637 19635 2160 34817 2160 4202560 47398 0 0 0 723 12 0 0 15 0 11 0 60050758 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19652] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19652/stat : 19652 (java) S 19637 19635 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 60050759 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19653] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19653/stat : 19653 (java) S 19637 19635 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 60050759 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19654] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19654/stat : 19654 (java) S 19637 19635 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 60050769 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19655] ppid=19637 vsize=884884 CPUtime=0.42
/proc/19649/task/19655/stat : 19655 (java) S 19637 19635 2160 34817 2160 4202560 4151 0 1 0 41 1 0 0 22 0 11 0 60050769 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19656] ppid=19637 vsize=884884 CPUtime=2.22
/proc/19649/task/19656/stat : 19656 (java) S 19637 19635 2160 34817 2160 4202560 7280 0 8 0 220 2 0 0 16 0 11 0 60050769 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19657] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19657/stat : 19657 (java) S 19637 19635 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 60050769 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19658] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19658/stat : 19658 (java) S 19637 19635 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 60050769 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19659] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19659/stat : 19659 (java) S 19637 19635 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 60051209 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 282.16
Current children cumulated vsize (KiB) 890028

[startup+284.81 s]
/proc/loadavg: 1.00 1.00 1.00 2/47 19670
/proc/meminfo: memFree=503044/1048576 swapFree=0/0
[pid=19635] ppid=19634 vsize=2572 CPUtime=0
/proc/19635/stat : 19635 (p2cudf-user-1.1) S 19634 19635 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 60050718 2633728 271 1283457024 134512640 135304128 4289156160 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19635/statm: 643 271 230 194 0 30 0
[pid=19637] ppid=19635 vsize=2572 CPUtime=0.01
/proc/19637/stat : 19637 (p2cudf) S 19635 19635 2160 34817 2160 4202496 390 3018 0 1 0 0 0 1 25 0 1 0 60050719 2633728 280 1283457024 134512640 135304128 4288601072 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19637/statm: 643 280 239 194 0 30 0
[pid=19649] ppid=19637 vsize=884884 CPUtime=283.75
/proc/19649/stat : 19649 (java) S 19637 19635 2160 34817 2160 4202496 110103 0 107 0 28337 38 0 0 23 0 11 0 60050723 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/19649/statm: 221221 106422 1787 10 0 218312 0
[pid=19649/tid=19650] ppid=19637 vsize=884884 CPUtime=273.73
/proc/19649/task/19650/stat : 19650 (java) R 19637 19635 2160 34817 2160 4202560 50277 0 15 0 27352 21 0 0 25 0 11 0 60050748 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4095683932 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=19649/tid=19651] ppid=19637 vsize=884884 CPUtime=7.35
/proc/19649/task/19651/stat : 19651 (java) S 19637 19635 2160 34817 2160 4202560 47398 0 0 0 723 12 0 0 15 0 11 0 60050758 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19652] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19652/stat : 19652 (java) S 19637 19635 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 60050759 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19653] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19653/stat : 19653 (java) S 19637 19635 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 60050759 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19654] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19654/stat : 19654 (java) S 19637 19635 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 60050769 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19655] ppid=19637 vsize=884884 CPUtime=0.42
/proc/19649/task/19655/stat : 19655 (java) S 19637 19635 2160 34817 2160 4202560 4151 0 1 0 41 1 0 0 22 0 11 0 60050769 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19656] ppid=19637 vsize=884884 CPUtime=2.22
/proc/19649/task/19656/stat : 19656 (java) S 19637 19635 2160 34817 2160 4202560 7280 0 8 0 220 2 0 0 16 0 11 0 60050769 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19657] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19657/stat : 19657 (java) S 19637 19635 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 60050769 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19658] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19658/stat : 19658 (java) S 19637 19635 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 60050769 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19659] ppid=19637 vsize=884884 CPUtime=0
/proc/19649/task/19659/stat : 19659 (java) S 19637 19635 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 60051209 906121216 106422 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.76
Current children cumulated vsize (KiB) 890028

[startup+285.206 s]
/proc/loadavg: 1.00 1.00 1.00 2/47 19670
/proc/meminfo: memFree=503044/1048576 swapFree=0/0
[pid=19635] ppid=19634 vsize=2572 CPUtime=0
/proc/19635/stat : 19635 (p2cudf-user-1.1) S 19634 19635 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 60050718 2633728 271 1283457024 134512640 135304128 4289156160 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19635/statm: 643 271 230 194 0 30 0
[pid=19637] ppid=19635 vsize=2572 CPUtime=0.01
/proc/19637/stat : 19637 (p2cudf) S 19635 19635 2160 34817 2160 4202496 390 3018 0 1 0 0 0 1 25 0 1 0 60050719 2633728 280 1283457024 134512640 135304128 4288601072 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19637/statm: 643 280 239 194 0 30 0
[pid=19649] ppid=19637 vsize=885208 CPUtime=283.91
/proc/19649/stat : 19649 (java) S 19637 19635 2160 34817 2160 4202496 110117 0 107 0 28353 38 0 0 23 0 11 0 60050723 906452992 106436 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/19649/statm: 221302 106436 1788 10 0 218393 0
[pid=19649/tid=19650] ppid=19637 vsize=885208 CPUtime=273.85
/proc/19649/task/19650/stat : 19650 (java) S 19637 19635 2160 34817 2160 4202560 50285 0 15 0 27364 21 0 0 25 0 11 0 60050748 906452992 106436 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19651] ppid=19637 vsize=885208 CPUtime=7.35
/proc/19649/task/19651/stat : 19651 (java) S 19637 19635 2160 34817 2160 4202560 47398 0 0 0 723 12 0 0 16 0 11 0 60050758 906452992 106436 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19652] ppid=19637 vsize=885208 CPUtime=0
/proc/19649/task/19652/stat : 19652 (java) S 19637 19635 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 60050759 906452992 106436 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19653] ppid=19637 vsize=885208 CPUtime=0
/proc/19649/task/19653/stat : 19653 (java) S 19637 19635 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 60050759 906452992 106436 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19654] ppid=19637 vsize=885208 CPUtime=0
/proc/19649/task/19654/stat : 19654 (java) S 19637 19635 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 60050769 906452992 106436 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19655] ppid=19637 vsize=885208 CPUtime=0.42
/proc/19649/task/19655/stat : 19655 (java) S 19637 19635 2160 34817 2160 4202560 4151 0 1 0 41 1 0 0 22 0 11 0 60050769 906452992 106436 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19656] ppid=19637 vsize=885208 CPUtime=2.25
/proc/19649/task/19656/stat : 19656 (java) S 19637 19635 2160 34817 2160 4202560 7280 0 8 0 223 2 0 0 15 0 11 0 60050769 906452992 106436 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19657] ppid=19637 vsize=885208 CPUtime=0
/proc/19649/task/19657/stat : 19657 (java) S 19637 19635 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 60050769 906452992 106436 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19658] ppid=19637 vsize=885208 CPUtime=0
/proc/19649/task/19658/stat : 19658 (java) S 19637 19635 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 60050769 906452992 106436 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.92
Current children cumulated vsize (KiB) 890352

[startup+285.608 s]
/proc/loadavg: 1.00 1.00 1.00 2/47 19670
/proc/meminfo: memFree=503044/1048576 swapFree=0/0
[pid=19635] ppid=19634 vsize=2572 CPUtime=0
/proc/19635/stat : 19635 (p2cudf-user-1.1) S 19634 19635 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 60050718 2633728 271 1283457024 134512640 135304128 4289156160 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19635/statm: 643 271 230 194 0 30 0
[pid=19637] ppid=19635 vsize=2572 CPUtime=0.01
/proc/19637/stat : 19637 (p2cudf) S 19635 19635 2160 34817 2160 4202496 390 3018 0 1 0 0 0 1 25 0 1 0 60050719 2633728 280 1283457024 134512640 135304128 4288601072 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19637/statm: 643 280 239 194 0 30 0
[pid=19649] ppid=19637 vsize=885208 CPUtime=284.02
/proc/19649/stat : 19649 (java) S 19637 19635 2160 34817 2160 4202496 110119 0 107 0 28362 40 0 0 23 0 11 0 60050723 906452992 106438 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/19649/statm: 221302 106438 1788 10 0 218393 0
[pid=19649/tid=19650] ppid=19637 vsize=885208 CPUtime=273.85
/proc/19649/task/19650/stat : 19650 (java) S 19637 19635 2160 34817 2160 4202560 50285 0 15 0 27364 21 0 0 25 0 11 0 60050748 906452992 106438 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19651] ppid=19637 vsize=885208 CPUtime=7.35
/proc/19649/task/19651/stat : 19651 (java) S 19637 19635 2160 34817 2160 4202560 47398 0 0 0 723 12 0 0 16 0 11 0 60050758 906452992 106438 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19652] ppid=19637 vsize=885208 CPUtime=0
/proc/19649/task/19652/stat : 19652 (java) S 19637 19635 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 60050759 906452992 106438 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19653] ppid=19637 vsize=885208 CPUtime=0
/proc/19649/task/19653/stat : 19653 (java) S 19637 19635 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 60050759 906452992 106438 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19654] ppid=19637 vsize=885208 CPUtime=0
/proc/19649/task/19654/stat : 19654 (java) S 19637 19635 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 60050769 906452992 106438 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19655] ppid=19637 vsize=885208 CPUtime=0.42
/proc/19649/task/19655/stat : 19655 (java) S 19637 19635 2160 34817 2160 4202560 4151 0 1 0 41 1 0 0 22 0 11 0 60050769 906452992 106438 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19656] ppid=19637 vsize=885208 CPUtime=2.28
/proc/19649/task/19656/stat : 19656 (java) S 19637 19635 2160 34817 2160 4202560 7280 0 8 0 226 2 0 0 15 0 11 0 60050769 906452992 106438 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19657] ppid=19637 vsize=885208 CPUtime=0
/proc/19649/task/19657/stat : 19657 (java) S 19637 19635 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 60050769 906452992 106438 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19658] ppid=19637 vsize=885208 CPUtime=0
/proc/19649/task/19658/stat : 19658 (java) S 19637 19635 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 60050769 906452992 106438 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 284.03
Current children cumulated vsize (KiB) 890352

[startup+285.708 s]
/proc/loadavg: 1.00 1.00 1.00 2/47 19670
/proc/meminfo: memFree=503044/1048576 swapFree=0/0
[pid=19635] ppid=19634 vsize=2572 CPUtime=0
/proc/19635/stat : 19635 (p2cudf-user-1.1) S 19634 19635 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 60050718 2633728 271 1283457024 134512640 135304128 4289156160 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19635/statm: 643 271 230 194 0 30 0
[pid=19637] ppid=19635 vsize=2572 CPUtime=0.01
/proc/19637/stat : 19637 (p2cudf) S 19635 19635 2160 34817 2160 4202496 390 3018 0 1 0 0 0 1 25 0 1 0 60050719 2633728 280 1283457024 134512640 135304128 4288601072 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/19637/statm: 643 280 239 194 0 30 0
[pid=19649] ppid=19637 vsize=885208 CPUtime=284.12
/proc/19649/stat : 19649 (java) S 19637 19635 2160 34817 2160 4202496 110119 0 107 0 28368 44 0 0 23 0 11 0 60050723 906452992 106438 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/19649/statm: 221302 106438 1788 10 0 218393 0
[pid=19649/tid=19650] ppid=19637 vsize=885208 CPUtime=273.85
/proc/19649/task/19650/stat : 19650 (java) S 19637 19635 2160 34817 2160 4202560 50285 0 15 0 27364 21 0 0 25 0 11 0 60050748 906452992 106438 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19651] ppid=19637 vsize=885208 CPUtime=7.35
/proc/19649/task/19651/stat : 19651 (java) S 19637 19635 2160 34817 2160 4202560 47398 0 0 0 723 12 0 0 16 0 11 0 60050758 906452992 106438 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19652] ppid=19637 vsize=885208 CPUtime=0
/proc/19649/task/19652/stat : 19652 (java) S 19637 19635 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 60050759 906452992 106438 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19653] ppid=19637 vsize=885208 CPUtime=0
/proc/19649/task/19653/stat : 19653 (java) S 19637 19635 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 60050759 906452992 106438 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19654] ppid=19637 vsize=885208 CPUtime=0
/proc/19649/task/19654/stat : 19654 (java) S 19637 19635 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 60050769 906452992 106438 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19655] ppid=19637 vsize=885208 CPUtime=0.42
/proc/19649/task/19655/stat : 19655 (java) S 19637 19635 2160 34817 2160 4202560 4151 0 1 0 41 1 0 0 22 0 11 0 60050769 906452992 106438 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19656] ppid=19637 vsize=885208 CPUtime=2.32
/proc/19649/task/19656/stat : 19656 (java) S 19637 19635 2160 34817 2160 4202560 7280 0 8 0 230 2 0 0 16 0 11 0 60050769 906452992 106438 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19657] ppid=19637 vsize=885208 CPUtime=0
/proc/19649/task/19657/stat : 19657 (java) S 19637 19635 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 60050769 906452992 106438 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=19649/tid=19658] ppid=19637 vsize=885208 CPUtime=0
/proc/19649/task/19658/stat : 19658 (java) S 19637 19635 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 60050769 906452992 106438 1283457024 134512640 134550932 4288207392 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 284.13
Current children cumulated vsize (KiB) 890352

Child status: 0
Real time (s): 285.779
CPU time (s): 284.194
CPU user time (s): 283.706
CPU system time (s): 0.48803
CPU usage (%): 99.4454
Max. virtual memory (cumulated for all children) (KiB): 892516

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 283.706
system time used= 0.48803
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 113926
page faults= 108
swaps= 0
block input operations= 0
block output operations= 0
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 6477
involuntary context switches= 8819

runsolver used 0.004 second user time and 0 second system time

The end