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/201108241238/p2cudf-trendy-1.13/rand348.cudf.s-e-l-s.log.runsolver ./p2cudf-trendy-1.13 /home/misc2010/data/2011/incremental/s-e-l-s/rand348.cudf /home/misc2010/tmp/201108241238/p2cudf-trendy-1.13/rand348.cudf.s-e-l-s.result 

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 5/35 9824
/proc/meminfo: memFree=514060/1048576 swapFree=0/0
[pid=9822] ppid=9821 vsize=2564 CPUtime=0
/proc/9822/stat : 9822 (p2cudf-trendy-1) S 9821 9822 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 18 0 1 0 2308928 2625536 270 1283457024 134512640 135304128 4287683376 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9822/statm: 641 270 230 194 0 28 0
[pid=9823] ppid=9822 vsize=2564 CPUtime=0
/proc/9823/stat : 9823 (p2cudf) R 9822 9822 1511 34817 1511 4202496 344 0 0 0 0 0 0 0 25 0 1 0 2308928 2625536 270 1283457024 134512640 135304128 4293878032 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/9823/statm: 641 270 231 194 0 28 0
[pid=9824] ppid=9823 vsize=2564 CPUtime=0
/proc/9824/stat : 9824 (p2cudf) R 9823 9822 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 1 0 2308928 2625536 39 1283457024 134512640 135304128 4293878032 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/9824/statm: 641 39 0 194 0 28 0

[startup+0.175409 s]
/proc/loadavg: 0.85 0.98 0.99 5/35 9824
/proc/meminfo: memFree=514060/1048576 swapFree=0/0
[pid=9822] ppid=9821 vsize=2564 CPUtime=0
/proc/9822/stat : 9822 (p2cudf-trendy-1) S 9821 9822 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 18 0 1 0 2308928 2625536 270 1283457024 134512640 135304128 4287683376 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9822/statm: 641 270 230 194 0 28 0
[pid=9823] ppid=9822 vsize=2568 CPUtime=0.04
/proc/9823/stat : 9823 (p2cudf) S 9822 9822 1511 34817 1511 4202496 389 3016 0 1 0 0 2 2 25 0 1 0 2308928 2629632 279 1283457024 134512640 135304128 4293878032 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9823/statm: 642 279 239 194 0 29 0
Current children cumulated CPU time (s) 0.04
Current children cumulated vsize (KiB) 5132

[startup+0.20544 s]
/proc/loadavg: 0.85 0.98 0.99 5/35 9824
/proc/meminfo: memFree=514060/1048576 swapFree=0/0
[pid=9822] ppid=9821 vsize=2564 CPUtime=0
/proc/9822/stat : 9822 (p2cudf-trendy-1) S 9821 9822 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 18 0 1 0 2308928 2625536 270 1283457024 134512640 135304128 4287683376 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9822/statm: 641 270 230 194 0 28 0
[pid=9823] ppid=9822 vsize=2568 CPUtime=0.04
/proc/9823/stat : 9823 (p2cudf) S 9822 9822 1511 34817 1511 4202496 389 3016 0 1 0 0 2 2 25 0 1 0 2308928 2629632 279 1283457024 134512640 135304128 4293878032 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9823/statm: 642 279 239 194 0 29 0
Current children cumulated CPU time (s) 0.04
Current children cumulated vsize (KiB) 5132

[startup+0.305446 s]
/proc/loadavg: 0.85 0.98 0.99 5/35 9824
/proc/meminfo: memFree=514060/1048576 swapFree=0/0
[pid=9822] ppid=9821 vsize=2564 CPUtime=0
/proc/9822/stat : 9822 (p2cudf-trendy-1) S 9821 9822 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 18 0 1 0 2308928 2625536 270 1283457024 134512640 135304128 4287683376 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9822/statm: 641 270 230 194 0 28 0
[pid=9823] ppid=9822 vsize=2568 CPUtime=0.04
/proc/9823/stat : 9823 (p2cudf) S 9822 9822 1511 34817 1511 4202496 389 3016 0 1 0 0 2 2 25 0 1 0 2308928 2629632 279 1283457024 134512640 135304128 4293878032 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9823/statm: 642 279 239 194 0 29 0
Current children cumulated CPU time (s) 0.04
Current children cumulated vsize (KiB) 5132

[startup+0.705589 s]
/proc/loadavg: 0.85 0.98 0.99 5/35 9824
/proc/meminfo: memFree=514060/1048576 swapFree=0/0
[pid=9822] ppid=9821 vsize=2564 CPUtime=0
/proc/9822/stat : 9822 (p2cudf-trendy-1) S 9821 9822 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 18 0 1 0 2308928 2625536 270 1283457024 134512640 135304128 4287683376 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9822/statm: 641 270 230 194 0 28 0
[pid=9823] ppid=9822 vsize=2568 CPUtime=0.04
/proc/9823/stat : 9823 (p2cudf) S 9822 9822 1511 34817 1511 4202496 389 3016 0 1 0 0 2 2 25 0 1 0 2308928 2629632 279 1283457024 134512640 135304128 4293878032 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9823/statm: 642 279 239 194 0 29 0
Current children cumulated CPU time (s) 0.04
Current children cumulated vsize (KiB) 5132

[startup+1.50582 s]
/proc/loadavg: 0.85 0.98 0.99 4/45 9845
/proc/meminfo: memFree=456000/1048576 swapFree=0/0
[pid=9822] ppid=9821 vsize=2564 CPUtime=0
/proc/9822/stat : 9822 (p2cudf-trendy-1) S 9821 9822 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 18 0 1 0 2308928 2625536 270 1283457024 134512640 135304128 4287683376 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9822/statm: 641 270 230 194 0 28 0
[pid=9823] ppid=9822 vsize=2568 CPUtime=0.04
/proc/9823/stat : 9823 (p2cudf) S 9822 9822 1511 34817 1511 4202496 389 3016 0 1 0 0 2 2 25 0 1 0 2308928 2629632 279 1283457024 134512640 135304128 4293878032 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9823/statm: 642 279 239 194 0 29 0
[pid=9836] ppid=9823 vsize=898444 CPUtime=1.46
/proc/9836/stat : 9836 (java) S 9823 9822 1511 34817 1511 4202496 25440 0 1 0 134 12 0 0 25 0 10 0 2308931 920006656 21797 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9836/statm: 224611 21797 1719 10 0 221702 0
[pid=9836/tid=9837] ppid=9823 vsize=898444 CPUtime=0.77
/proc/9836/task/9837/stat : 9837 (java) R 9823 9822 1511 34817 1511 4202560 10772 0 1 0 72 5 0 0 25 0 10 0 2308932 920006656 21797 1283457024 134512640 134550932 4292378160 18446744073709551615 4095394971 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9836/tid=9838] ppid=9823 vsize=898444 CPUtime=0
/proc/9836/task/9838/stat : 9838 (java) S 9823 9822 1511 34817 1511 4202560 7 0 0 0 0 0 0 0 15 0 10 0 2308934 920006656 21797 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 0 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9839] ppid=9823 vsize=898444 CPUtime=0
/proc/9836/task/9839/stat : 9839 (java) S 9823 9822 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 25 0 10 0 2308934 920006656 21797 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9840] ppid=9823 vsize=898444 CPUtime=0
/proc/9836/task/9840/stat : 9840 (java) S 9823 9822 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 10 0 2308934 920006656 21797 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9841] ppid=9823 vsize=898444 CPUtime=0
/proc/9836/task/9841/stat : 9841 (java) S 9823 9822 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 2308936 920006656 21797 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9842] ppid=9823 vsize=898444 CPUtime=0.46
/proc/9836/task/9842/stat : 9842 (java) R 9823 9822 1511 34817 1511 4202560 9067 0 0 0 43 3 0 0 25 0 10 0 2308937 920006656 21797 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9836/tid=9843] ppid=9823 vsize=898444 CPUtime=0.21
/proc/9836/task/9843/stat : 9843 (java) S 9823 9822 1511 34817 1511 4202560 4521 0 0 0 18 3 0 0 22 0 10 0 2308937 920006656 21797 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9844] ppid=9823 vsize=898444 CPUtime=0
/proc/9836/task/9844/stat : 9844 (java) S 9823 9822 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 2308937 920006656 21797 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9845] ppid=9823 vsize=898444 CPUtime=0
/proc/9836/task/9845/stat : 9845 (java) S 9823 9822 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 10 0 2308937 920006656 21797 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 1.5
Current children cumulated vsize (KiB) 903576

[startup+3.10618 s]
/proc/loadavg: 0.86 0.98 0.99 2/45 9845
/proc/meminfo: memFree=362008/1048576 swapFree=0/0
[pid=9822] ppid=9821 vsize=2564 CPUtime=0
/proc/9822/stat : 9822 (p2cudf-trendy-1) S 9821 9822 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 18 0 1 0 2308928 2625536 270 1283457024 134512640 135304128 4287683376 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9822/statm: 641 270 230 194 0 28 0
[pid=9823] ppid=9822 vsize=2568 CPUtime=0.04
/proc/9823/stat : 9823 (p2cudf) S 9822 9822 1511 34817 1511 4202496 389 3016 0 1 0 0 2 2 25 0 1 0 2308928 2629632 279 1283457024 134512640 135304128 4293878032 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9823/statm: 642 279 239 194 0 29 0
[pid=9836] ppid=9823 vsize=896396 CPUtime=3.05
/proc/9836/stat : 9836 (java) S 9823 9822 1511 34817 1511 4202496 78760 0 1 0 275 30 0 0 25 0 10 0 2308931 917909504 73982 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9836/statm: 224099 73982 1732 10 0 221190 0
[pid=9836/tid=9837] ppid=9823 vsize=896396 CPUtime=1.72
/proc/9836/task/9837/stat : 9837 (java) R 9823 9822 1511 34817 1511 4202560 50037 0 1 0 153 19 0 0 25 0 10 0 2308932 917909504 73982 1283457024 134512640 134550932 4292378160 18446744073709551615 4095424194 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9836/tid=9838] ppid=9823 vsize=896396 CPUtime=0.26
/proc/9836/task/9838/stat : 9838 (java) S 9823 9822 1511 34817 1511 4202560 12651 0 0 0 23 3 0 0 16 0 10 0 2308934 917909504 73982 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 0 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9839] ppid=9823 vsize=896396 CPUtime=0
/proc/9836/task/9839/stat : 9839 (java) S 9823 9822 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 10 0 2308934 917909504 73982 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9840] ppid=9823 vsize=896396 CPUtime=0
/proc/9836/task/9840/stat : 9840 (java) S 9823 9822 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 10 0 2308934 917909504 73982 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9841] ppid=9823 vsize=896396 CPUtime=0
/proc/9836/task/9841/stat : 9841 (java) S 9823 9822 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 2308936 917909504 73982 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9842] ppid=9823 vsize=896396 CPUtime=0.47
/proc/9836/task/9842/stat : 9842 (java) S 9823 9822 1511 34817 1511 4202560 9092 0 0 0 44 3 0 0 25 0 10 0 2308937 917909504 73982 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9843] ppid=9823 vsize=896396 CPUtime=0.58
/proc/9836/task/9843/stat : 9843 (java) S 9823 9822 1511 34817 1511 4202560 5904 0 0 0 54 4 0 0 15 0 10 0 2308937 917909504 73982 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9844] ppid=9823 vsize=896396 CPUtime=0
/proc/9836/task/9844/stat : 9844 (java) S 9823 9822 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 2308937 917909504 73982 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9845] ppid=9823 vsize=896396 CPUtime=0
/proc/9836/task/9845/stat : 9845 (java) S 9823 9822 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 10 0 2308937 917909504 73982 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 3.09
Current children cumulated vsize (KiB) 901528

[startup+6.30707 s]
/proc/loadavg: 0.86 0.98 0.99 2/45 9845
/proc/meminfo: memFree=165840/1048576 swapFree=0/0
[pid=9822] ppid=9821 vsize=2564 CPUtime=0
/proc/9822/stat : 9822 (p2cudf-trendy-1) S 9821 9822 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 18 0 1 0 2308928 2625536 270 1283457024 134512640 135304128 4287683376 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9822/statm: 641 270 230 194 0 28 0
[pid=9823] ppid=9822 vsize=2568 CPUtime=0.04
/proc/9823/stat : 9823 (p2cudf) S 9822 9822 1511 34817 1511 4202496 389 3016 0 1 0 0 2 2 25 0 1 0 2308928 2629632 279 1283457024 134512640 135304128 4293878032 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9823/statm: 642 279 239 194 0 29 0
[pid=9836] ppid=9823 vsize=896780 CPUtime=6.26
/proc/9836/stat : 9836 (java) S 9823 9822 1511 34817 1511 4202496 95708 0 1 0 590 36 0 0 25 0 11 0 2308931 918302720 88647 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9836/statm: 224195 88647 1771 10 0 221286 0
[pid=9836/tid=9837] ppid=9823 vsize=896780 CPUtime=2.94
/proc/9836/task/9837/stat : 9837 (java) R 9823 9822 1511 34817 1511 4202560 50270 0 1 0 274 20 0 0 25 0 11 0 2308932 918302720 88647 1283457024 134512640 134550932 4292378160 18446744073709551615 4096276258 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9836/tid=9838] ppid=9823 vsize=896780 CPUtime=0.6
/proc/9836/task/9838/stat : 9838 (java) S 9823 9822 1511 34817 1511 4202560 26796 0 0 0 53 7 0 0 16 0 11 0 2308934 918302720 88647 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 0 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9839] ppid=9823 vsize=896780 CPUtime=0
/proc/9836/task/9839/stat : 9839 (java) S 9823 9822 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 2308934 918302720 88647 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9840] ppid=9823 vsize=896780 CPUtime=0
/proc/9836/task/9840/stat : 9840 (java) S 9823 9822 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 2308934 918302720 88647 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9841] ppid=9823 vsize=896780 CPUtime=0
/proc/9836/task/9841/stat : 9841 (java) S 9823 9822 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 2308936 918302720 88647 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9842] ppid=9823 vsize=896780 CPUtime=0.47
/proc/9836/task/9842/stat : 9842 (java) S 9823 9822 1511 34817 1511 4202560 9092 0 0 0 44 3 0 0 25 0 11 0 2308937 918302720 88647 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9843] ppid=9823 vsize=896780 CPUtime=2.22
/proc/9836/task/9843/stat : 9843 (java) S 9823 9822 1511 34817 1511 4202560 8473 0 0 0 218 4 0 0 15 0 11 0 2308937 918302720 88647 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9844] ppid=9823 vsize=896780 CPUtime=0
/proc/9836/task/9844/stat : 9844 (java) S 9823 9822 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 2308937 918302720 88647 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9845] ppid=9823 vsize=896780 CPUtime=0
/proc/9836/task/9845/stat : 9845 (java) S 9823 9822 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 2308937 918302720 88647 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 6.3
Current children cumulated vsize (KiB) 901912

[startup+12.7092 s]
/proc/loadavg: 0.95 0.99 0.99 3/46 9846
/proc/meminfo: memFree=155176/1048576 swapFree=0/0
[pid=9822] ppid=9821 vsize=2564 CPUtime=0
/proc/9822/stat : 9822 (p2cudf-trendy-1) S 9821 9822 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 18 0 1 0 2308928 2625536 270 1283457024 134512640 135304128 4287683376 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9822/statm: 641 270 230 194 0 28 0
[pid=9823] ppid=9822 vsize=2568 CPUtime=0.04
/proc/9823/stat : 9823 (p2cudf) S 9822 9822 1511 34817 1511 4202496 389 3016 0 1 0 0 2 2 25 0 1 0 2308928 2629632 279 1283457024 134512640 135304128 4293878032 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9823/statm: 642 279 239 194 0 29 0
[pid=9836] ppid=9823 vsize=894856 CPUtime=12.66
/proc/9836/stat : 9836 (java) S 9823 9822 1511 34817 1511 4202496 101773 0 1 0 1228 38 0 0 25 0 11 0 2308931 916332544 94237 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9836/statm: 223714 94237 1784 10 0 220805 0
[pid=9836/tid=9837] ppid=9823 vsize=894856 CPUtime=8.38
/proc/9836/task/9837/stat : 9837 (java) R 9823 9822 1511 34817 1511 4202560 50280 0 1 0 818 20 0 0 25 0 11 0 2308932 916332544 94237 1283457024 134512640 134550932 4292378160 18446744073709551615 4096413485 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9836/tid=9838] ppid=9823 vsize=894856 CPUtime=0.86
/proc/9836/task/9838/stat : 9838 (java) S 9823 9822 1511 34817 1511 4202560 32760 0 0 0 76 10 0 0 16 0 11 0 2308934 916332544 94237 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 0 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9839] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9839/stat : 9839 (java) S 9823 9822 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 2308934 916332544 94237 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9840] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9840/stat : 9840 (java) S 9823 9822 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 2308934 916332544 94237 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9841] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9841/stat : 9841 (java) S 9823 9822 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 2308936 916332544 94237 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9842] ppid=9823 vsize=894856 CPUtime=0.47
/proc/9836/task/9842/stat : 9842 (java) S 9823 9822 1511 34817 1511 4202560 9092 0 0 0 44 3 0 0 25 0 11 0 2308937 916332544 94237 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9843] ppid=9823 vsize=894856 CPUtime=2.92
/proc/9836/task/9843/stat : 9843 (java) S 9823 9822 1511 34817 1511 4202560 8561 0 0 0 288 4 0 0 15 0 11 0 2308937 916332544 94237 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9844] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9844/stat : 9844 (java) S 9823 9822 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 2308937 916332544 94237 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9845] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9845/stat : 9845 (java) S 9823 9822 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 2308937 916332544 94237 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9846] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9846/stat : 9846 (java) S 9823 9822 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 2309531 916332544 94237 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 12.7
Current children cumulated vsize (KiB) 899988

[startup+25.5224 s]
/proc/loadavg: 1.03 1.01 1.00 2/46 9846
/proc/meminfo: memFree=117852/1048576 swapFree=0/0
[pid=9822] ppid=9821 vsize=2564 CPUtime=0
/proc/9822/stat : 9822 (p2cudf-trendy-1) S 9821 9822 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 18 0 1 0 2308928 2625536 270 1283457024 134512640 135304128 4287683376 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9822/statm: 641 270 230 194 0 28 0
[pid=9823] ppid=9822 vsize=2568 CPUtime=0.04
/proc/9823/stat : 9823 (p2cudf) S 9822 9822 1511 34817 1511 4202496 389 3016 0 1 0 0 2 2 25 0 1 0 2308928 2629632 279 1283457024 134512640 135304128 4293878032 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9823/statm: 642 279 239 194 0 29 0
[pid=9836] ppid=9823 vsize=894856 CPUtime=25.46
/proc/9836/stat : 9836 (java) S 9823 9822 1511 34817 1511 4202496 108021 0 1 0 2506 40 0 0 25 0 11 0 2308931 916332544 100485 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9836/statm: 223714 100485 1788 10 0 220805 0
[pid=9836/tid=9837] ppid=9823 vsize=894856 CPUtime=20.21
/proc/9836/task/9837/stat : 9837 (java) R 9823 9822 1511 34817 1511 4202560 50281 0 1 0 2001 20 0 0 25 0 11 0 2308932 916332544 100485 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9836/tid=9838] ppid=9823 vsize=894856 CPUtime=1.72
/proc/9836/task/9838/stat : 9838 (java) R 9823 9822 1511 34817 1511 4202560 39002 0 0 0 160 12 0 0 15 0 11 0 2308934 916332544 100485 1283457024 134512640 134550932 4292378160 18446744073709551615 4147713422 0 0 0 16800975 0 0 0 -1 0 0 0 0
[pid=9836/tid=9839] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9839/stat : 9839 (java) S 9823 9822 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 2308934 916332544 100485 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9840] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9840/stat : 9840 (java) S 9823 9822 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 2308934 916332544 100485 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9841] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9841/stat : 9841 (java) S 9823 9822 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 2308936 916332544 100485 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9842] ppid=9823 vsize=894856 CPUtime=0.47
/proc/9836/task/9842/stat : 9842 (java) S 9823 9822 1511 34817 1511 4202560 9092 0 0 0 44 3 0 0 25 0 11 0 2308937 916332544 100485 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9843] ppid=9823 vsize=894856 CPUtime=3.03
/proc/9836/task/9843/stat : 9843 (java) S 9823 9822 1511 34817 1511 4202560 8566 0 0 0 299 4 0 0 15 0 11 0 2308937 916332544 100485 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9844] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9844/stat : 9844 (java) S 9823 9822 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 2308937 916332544 100485 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9845] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9845/stat : 9845 (java) S 9823 9822 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 2308937 916332544 100485 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9846] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9846/stat : 9846 (java) S 9823 9822 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 2309531 916332544 100485 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 25.5
Current children cumulated vsize (KiB) 899988

[startup+51.1281 s]
/proc/loadavg: 1.02 1.01 1.00 2/46 9846
/proc/meminfo: memFree=116860/1048576 swapFree=0/0
[pid=9822] ppid=9821 vsize=2564 CPUtime=0
/proc/9822/stat : 9822 (p2cudf-trendy-1) S 9821 9822 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 18 0 1 0 2308928 2625536 270 1283457024 134512640 135304128 4287683376 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9822/statm: 641 270 230 194 0 28 0
[pid=9823] ppid=9822 vsize=2568 CPUtime=0.04
/proc/9823/stat : 9823 (p2cudf) S 9822 9822 1511 34817 1511 4202496 389 3016 0 1 0 0 2 2 25 0 1 0 2308928 2629632 279 1283457024 134512640 135304128 4293878032 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9823/statm: 642 279 239 194 0 29 0
[pid=9836] ppid=9823 vsize=894856 CPUtime=51.05
/proc/9836/stat : 9836 (java) S 9823 9822 1511 34817 1511 4202496 108248 0 1 0 5065 40 0 0 25 0 11 0 2308931 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9836/statm: 223714 100712 1788 10 0 220805 0
[pid=9836/tid=9837] ppid=9823 vsize=894856 CPUtime=44.05
/proc/9836/task/9837/stat : 9837 (java) R 9823 9822 1511 34817 1511 4202560 50281 0 1 0 4385 20 0 0 25 0 11 0 2308932 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9836/tid=9838] ppid=9823 vsize=894856 CPUtime=3.44
/proc/9836/task/9838/stat : 9838 (java) R 9823 9822 1511 34817 1511 4202560 39229 0 0 0 332 12 0 0 15 0 11 0 2308934 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4150042160 0 0 0 16800975 0 0 0 -1 0 0 0 0
[pid=9836/tid=9839] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9839/stat : 9839 (java) S 9823 9822 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 2308934 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9840] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9840/stat : 9840 (java) S 9823 9822 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 2308934 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9841] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9841/stat : 9841 (java) S 9823 9822 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 2308936 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9842] ppid=9823 vsize=894856 CPUtime=0.47
/proc/9836/task/9842/stat : 9842 (java) S 9823 9822 1511 34817 1511 4202560 9092 0 0 0 44 3 0 0 25 0 11 0 2308937 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9843] ppid=9823 vsize=894856 CPUtime=3.07
/proc/9836/task/9843/stat : 9843 (java) S 9823 9822 1511 34817 1511 4202560 8566 0 0 0 303 4 0 0 15 0 11 0 2308937 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9844] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9844/stat : 9844 (java) S 9823 9822 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 2308937 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9845] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9845/stat : 9845 (java) S 9823 9822 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 2308937 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9846] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9846/stat : 9846 (java) S 9823 9822 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 2309531 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 51.09
Current children cumulated vsize (KiB) 899988

[startup+102.309 s]
/proc/loadavg: 1.00 1.00 1.00 3/46 9846
/proc/meminfo: memFree=116736/1048576 swapFree=0/0
[pid=9822] ppid=9821 vsize=2564 CPUtime=0
/proc/9822/stat : 9822 (p2cudf-trendy-1) S 9821 9822 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 18 0 1 0 2308928 2625536 270 1283457024 134512640 135304128 4287683376 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9822/statm: 641 270 230 194 0 28 0
[pid=9823] ppid=9822 vsize=2568 CPUtime=0.04
/proc/9823/stat : 9823 (p2cudf) S 9822 9822 1511 34817 1511 4202496 389 3016 0 1 0 0 2 2 25 0 1 0 2308928 2629632 279 1283457024 134512640 135304128 4293878032 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9823/statm: 642 279 239 194 0 29 0
[pid=9836] ppid=9823 vsize=894856 CPUtime=102.21
/proc/9836/stat : 9836 (java) S 9823 9822 1511 34817 1511 4202496 108248 0 1 0 10181 40 0 0 25 0 11 0 2308931 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9836/statm: 223714 100712 1788 10 0 220805 0
[pid=9836/tid=9837] ppid=9823 vsize=894856 CPUtime=92.91
/proc/9836/task/9837/stat : 9837 (java) R 9823 9822 1511 34817 1511 4202560 50281 0 1 0 9271 20 0 0 25 0 11 0 2308932 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4096369373 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9836/tid=9838] ppid=9823 vsize=894856 CPUtime=5.71
/proc/9836/task/9838/stat : 9838 (java) S 9823 9822 1511 34817 1511 4202560 39229 0 0 0 559 12 0 0 15 0 11 0 2308934 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 0 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9839] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9839/stat : 9839 (java) S 9823 9822 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 2308934 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9840] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9840/stat : 9840 (java) S 9823 9822 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 2308934 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9841] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9841/stat : 9841 (java) S 9823 9822 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 2308936 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9842] ppid=9823 vsize=894856 CPUtime=0.47
/proc/9836/task/9842/stat : 9842 (java) S 9823 9822 1511 34817 1511 4202560 9092 0 0 0 44 3 0 0 25 0 11 0 2308937 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9843] ppid=9823 vsize=894856 CPUtime=3.09
/proc/9836/task/9843/stat : 9843 (java) S 9823 9822 1511 34817 1511 4202560 8566 0 0 0 305 4 0 0 15 0 11 0 2308937 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9844] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9844/stat : 9844 (java) S 9823 9822 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 2308937 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9845] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9845/stat : 9845 (java) S 9823 9822 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 2308937 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9846] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9846/stat : 9846 (java) S 9823 9822 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 2309531 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 102.25
Current children cumulated vsize (KiB) 899988

[startup+162.312 s]
/proc/loadavg: 1.15 1.04 1.01 3/46 9846
/proc/meminfo: memFree=116612/1048576 swapFree=0/0
[pid=9822] ppid=9821 vsize=2564 CPUtime=0
/proc/9822/stat : 9822 (p2cudf-trendy-1) S 9821 9822 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 18 0 1 0 2308928 2625536 270 1283457024 134512640 135304128 4287683376 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9822/statm: 641 270 230 194 0 28 0
[pid=9823] ppid=9822 vsize=2568 CPUtime=0.04
/proc/9823/stat : 9823 (p2cudf) S 9822 9822 1511 34817 1511 4202496 389 3016 0 1 0 0 2 2 25 0 1 0 2308928 2629632 279 1283457024 134512640 135304128 4293878032 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9823/statm: 642 279 239 194 0 29 0
[pid=9836] ppid=9823 vsize=894856 CPUtime=162.17
/proc/9836/stat : 9836 (java) S 9823 9822 1511 34817 1511 4202496 108248 0 1 0 16175 42 0 0 25 0 11 0 2308931 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9836/statm: 223714 100712 1788 10 0 220805 0
[pid=9836/tid=9837] ppid=9823 vsize=894856 CPUtime=150.18
/proc/9836/task/9837/stat : 9837 (java) R 9823 9822 1511 34817 1511 4202560 50281 0 1 0 14996 22 0 0 25 0 11 0 2308932 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4096413477 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9836/tid=9838] ppid=9823 vsize=894856 CPUtime=8.4
/proc/9836/task/9838/stat : 9838 (java) S 9823 9822 1511 34817 1511 4202560 39229 0 0 0 828 12 0 0 15 0 11 0 2308934 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 0 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9839] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9839/stat : 9839 (java) S 9823 9822 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 2308934 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9840] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9840/stat : 9840 (java) S 9823 9822 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 2308934 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9841] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9841/stat : 9841 (java) S 9823 9822 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 2308936 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9842] ppid=9823 vsize=894856 CPUtime=0.47
/proc/9836/task/9842/stat : 9842 (java) S 9823 9822 1511 34817 1511 4202560 9092 0 0 0 44 3 0 0 25 0 11 0 2308937 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9843] ppid=9823 vsize=894856 CPUtime=3.09
/proc/9836/task/9843/stat : 9843 (java) S 9823 9822 1511 34817 1511 4202560 8566 0 0 0 305 4 0 0 15 0 11 0 2308937 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9844] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9844/stat : 9844 (java) S 9823 9822 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 2308937 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9845] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9845/stat : 9845 (java) S 9823 9822 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 2308937 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9846] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9846/stat : 9846 (java) S 9823 9822 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 2309531 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 162.21
Current children cumulated vsize (KiB) 899988

[startup+222.306 s]
/proc/loadavg: 1.09 1.05 1.01 2/46 9846
/proc/meminfo: memFree=116612/1048576 swapFree=0/0
[pid=9822] ppid=9821 vsize=2564 CPUtime=0
/proc/9822/stat : 9822 (p2cudf-trendy-1) S 9821 9822 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 18 0 1 0 2308928 2625536 270 1283457024 134512640 135304128 4287683376 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9822/statm: 641 270 230 194 0 28 0
[pid=9823] ppid=9822 vsize=2568 CPUtime=0.04
/proc/9823/stat : 9823 (p2cudf) S 9822 9822 1511 34817 1511 4202496 389 3016 0 1 0 0 2 2 25 0 1 0 2308928 2629632 279 1283457024 134512640 135304128 4293878032 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9823/statm: 642 279 239 194 0 29 0
[pid=9836] ppid=9823 vsize=894856 CPUtime=222.1
/proc/9836/stat : 9836 (java) S 9823 9822 1511 34817 1511 4202496 108248 0 1 0 22168 42 0 0 25 0 11 0 2308931 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9836/statm: 223714 100712 1788 10 0 220805 0
[pid=9836/tid=9837] ppid=9823 vsize=894856 CPUtime=208.53
/proc/9836/task/9837/stat : 9837 (java) R 9823 9822 1511 34817 1511 4202560 50281 0 1 0 20831 22 0 0 25 0 11 0 2308932 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4096308946 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9836/tid=9838] ppid=9823 vsize=894856 CPUtime=9.98
/proc/9836/task/9838/stat : 9838 (java) S 9823 9822 1511 34817 1511 4202560 39229 0 0 0 986 12 0 0 15 0 11 0 2308934 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 0 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9839] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9839/stat : 9839 (java) S 9823 9822 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 2308934 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9840] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9840/stat : 9840 (java) S 9823 9822 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 2308934 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9841] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9841/stat : 9841 (java) S 9823 9822 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 2308936 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9842] ppid=9823 vsize=894856 CPUtime=0.47
/proc/9836/task/9842/stat : 9842 (java) S 9823 9822 1511 34817 1511 4202560 9092 0 0 0 44 3 0 0 25 0 11 0 2308937 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9843] ppid=9823 vsize=894856 CPUtime=3.09
/proc/9836/task/9843/stat : 9843 (java) S 9823 9822 1511 34817 1511 4202560 8566 0 0 0 305 4 0 0 15 0 11 0 2308937 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9844] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9844/stat : 9844 (java) S 9823 9822 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 2308937 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9845] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9845/stat : 9845 (java) S 9823 9822 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 2308937 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9846] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9846/stat : 9846 (java) S 9823 9822 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 2309531 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 222.14
Current children cumulated vsize (KiB) 899988

[startup+282.303 s]
/proc/loadavg: 1.03 1.04 1.00 2/48 9852
/proc/meminfo: memFree=116464/1048576 swapFree=0/0
[pid=9822] ppid=9821 vsize=2564 CPUtime=0
/proc/9822/stat : 9822 (p2cudf-trendy-1) S 9821 9822 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 18 0 1 0 2308928 2625536 270 1283457024 134512640 135304128 4287683376 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9822/statm: 641 270 230 194 0 28 0
[pid=9823] ppid=9822 vsize=2568 CPUtime=0.04
/proc/9823/stat : 9823 (p2cudf) S 9822 9822 1511 34817 1511 4202496 389 3016 0 1 0 0 2 2 25 0 1 0 2308928 2629632 279 1283457024 134512640 135304128 4293878032 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9823/statm: 642 279 239 194 0 29 0
[pid=9836] ppid=9823 vsize=894856 CPUtime=282
/proc/9836/stat : 9836 (java) S 9823 9822 1511 34817 1511 4202496 108248 0 1 0 28158 42 0 0 25 0 11 0 2308931 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9836/statm: 223714 100712 1788 10 0 220805 0
[pid=9836/tid=9837] ppid=9823 vsize=894856 CPUtime=265.32
/proc/9836/task/9837/stat : 9837 (java) R 9823 9822 1511 34817 1511 4202560 50281 0 1 0 26510 22 0 0 25 0 11 0 2308932 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4096204561 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9836/tid=9838] ppid=9823 vsize=894856 CPUtime=13.1
/proc/9836/task/9838/stat : 9838 (java) S 9823 9822 1511 34817 1511 4202560 39229 0 0 0 1298 12 0 0 15 0 11 0 2308934 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 0 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9839] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9839/stat : 9839 (java) S 9823 9822 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 2308934 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9840] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9840/stat : 9840 (java) S 9823 9822 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 2308934 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9841] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9841/stat : 9841 (java) S 9823 9822 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 2308936 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9842] ppid=9823 vsize=894856 CPUtime=0.47
/proc/9836/task/9842/stat : 9842 (java) S 9823 9822 1511 34817 1511 4202560 9092 0 0 0 44 3 0 0 25 0 11 0 2308937 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9843] ppid=9823 vsize=894856 CPUtime=3.09
/proc/9836/task/9843/stat : 9843 (java) S 9823 9822 1511 34817 1511 4202560 8566 0 0 0 305 4 0 0 15 0 11 0 2308937 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9844] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9844/stat : 9844 (java) S 9823 9822 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 2308937 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9845] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9845/stat : 9845 (java) S 9823 9822 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 2308937 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9846] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9846/stat : 9846 (java) S 9823 9822 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 2309531 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 282.04
Current children cumulated vsize (KiB) 899988

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

[startup+284.704 s]
/proc/loadavg: 1.03 1.04 1.00 2/48 9853
/proc/meminfo: memFree=116464/1048576 swapFree=0/0
[pid=9822] ppid=9821 vsize=2564 CPUtime=0
/proc/9822/stat : 9822 (p2cudf-trendy-1) S 9821 9822 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 18 0 1 0 2308928 2625536 270 1283457024 134512640 135304128 4287683376 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9822/statm: 641 270 230 194 0 28 0
[pid=9823] ppid=9822 vsize=2568 CPUtime=0.04
/proc/9823/stat : 9823 (p2cudf) S 9822 9822 1511 34817 1511 4202496 389 3016 0 1 0 0 2 2 25 0 1 0 2308928 2629632 279 1283457024 134512640 135304128 4293878032 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9823/statm: 642 279 239 194 0 29 0
[pid=9836] ppid=9823 vsize=894856 CPUtime=284.4
/proc/9836/stat : 9836 (java) S 9823 9822 1511 34817 1511 4202496 108248 0 1 0 28398 42 0 0 25 0 11 0 2308931 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9836/statm: 223714 100712 1788 10 0 220805 0
[pid=9836/tid=9837] ppid=9823 vsize=894856 CPUtime=267.72
/proc/9836/task/9837/stat : 9837 (java) R 9823 9822 1511 34817 1511 4202560 50281 0 1 0 26750 22 0 0 25 0 11 0 2308932 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4096266044 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9836/tid=9838] ppid=9823 vsize=894856 CPUtime=13.1
/proc/9836/task/9838/stat : 9838 (java) S 9823 9822 1511 34817 1511 4202560 39229 0 0 0 1298 12 0 0 15 0 11 0 2308934 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 0 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9839] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9839/stat : 9839 (java) S 9823 9822 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 2308934 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9840] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9840/stat : 9840 (java) S 9823 9822 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 2308934 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9841] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9841/stat : 9841 (java) S 9823 9822 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 2308936 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9842] ppid=9823 vsize=894856 CPUtime=0.47
/proc/9836/task/9842/stat : 9842 (java) S 9823 9822 1511 34817 1511 4202560 9092 0 0 0 44 3 0 0 25 0 11 0 2308937 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9843] ppid=9823 vsize=894856 CPUtime=3.09
/proc/9836/task/9843/stat : 9843 (java) S 9823 9822 1511 34817 1511 4202560 8566 0 0 0 305 4 0 0 15 0 11 0 2308937 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9844] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9844/stat : 9844 (java) S 9823 9822 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 2308937 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9845] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9845/stat : 9845 (java) S 9823 9822 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 2308937 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9846] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9846/stat : 9846 (java) S 9823 9822 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 2309531 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 284.44
Current children cumulated vsize (KiB) 899988

[startup+285.504 s]
/proc/loadavg: 1.03 1.04 1.00 2/48 9853
/proc/meminfo: memFree=116464/1048576 swapFree=0/0
[pid=9822] ppid=9821 vsize=2564 CPUtime=0
/proc/9822/stat : 9822 (p2cudf-trendy-1) S 9821 9822 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 18 0 1 0 2308928 2625536 270 1283457024 134512640 135304128 4287683376 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9822/statm: 641 270 230 194 0 28 0
[pid=9823] ppid=9822 vsize=2568 CPUtime=0.04
/proc/9823/stat : 9823 (p2cudf) S 9822 9822 1511 34817 1511 4202496 389 3016 0 1 0 0 2 2 25 0 1 0 2308928 2629632 279 1283457024 134512640 135304128 4293878032 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9823/statm: 642 279 239 194 0 29 0
[pid=9836] ppid=9823 vsize=894856 CPUtime=285.2
/proc/9836/stat : 9836 (java) S 9823 9822 1511 34817 1511 4202496 108248 0 1 0 28478 42 0 0 25 0 11 0 2308931 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9836/statm: 223714 100712 1788 10 0 220805 0
[pid=9836/tid=9837] ppid=9823 vsize=894856 CPUtime=268.12
/proc/9836/task/9837/stat : 9837 (java) R 9823 9822 1511 34817 1511 4202560 50281 0 1 0 26790 22 0 0 25 0 11 0 2308932 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4095376211 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9836/tid=9838] ppid=9823 vsize=894856 CPUtime=13.5
/proc/9836/task/9838/stat : 9838 (java) S 9823 9822 1511 34817 1511 4202560 39229 0 0 0 1338 12 0 0 16 0 11 0 2308934 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 0 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9839] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9839/stat : 9839 (java) S 9823 9822 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 2308934 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9840] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9840/stat : 9840 (java) S 9823 9822 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 2308934 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9841] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9841/stat : 9841 (java) S 9823 9822 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 2308936 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9842] ppid=9823 vsize=894856 CPUtime=0.47
/proc/9836/task/9842/stat : 9842 (java) S 9823 9822 1511 34817 1511 4202560 9092 0 0 0 44 3 0 0 25 0 11 0 2308937 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9843] ppid=9823 vsize=894856 CPUtime=3.09
/proc/9836/task/9843/stat : 9843 (java) S 9823 9822 1511 34817 1511 4202560 8566 0 0 0 305 4 0 0 15 0 11 0 2308937 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9844] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9844/stat : 9844 (java) S 9823 9822 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 2308937 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9845] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9845/stat : 9845 (java) S 9823 9822 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 2308937 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9846] ppid=9823 vsize=894856 CPUtime=0
/proc/9836/task/9846/stat : 9846 (java) S 9823 9822 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 2309531 916332544 100712 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 285.24
Current children cumulated vsize (KiB) 899988

[startup+286.307 s]
/proc/loadavg: 1.03 1.04 1.00 2/48 9853
/proc/meminfo: memFree=116464/1048576 swapFree=0/0
[pid=9822] ppid=9821 vsize=2564 CPUtime=0
/proc/9822/stat : 9822 (p2cudf-trendy-1) S 9821 9822 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 18 0 1 0 2308928 2625536 270 1283457024 134512640 135304128 4287683376 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9822/statm: 641 270 230 194 0 28 0
[pid=9823] ppid=9822 vsize=2568 CPUtime=0.04
/proc/9823/stat : 9823 (p2cudf) S 9822 9822 1511 34817 1511 4202496 389 3016 0 1 0 0 2 2 25 0 1 0 2308928 2629632 279 1283457024 134512640 135304128 4293878032 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9823/statm: 642 279 239 194 0 29 0
[pid=9836] ppid=9823 vsize=895180 CPUtime=285.79
/proc/9836/stat : 9836 (java) S 9823 9822 1511 34817 1511 4202496 108261 0 1 0 28537 42 0 0 25 0 11 0 2308931 916664320 100725 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9836/statm: 223795 100725 1789 10 0 220886 0
[pid=9836/tid=9837] ppid=9823 vsize=895180 CPUtime=268.65
/proc/9836/task/9837/stat : 9837 (java) S 9823 9822 1511 34817 1511 4202560 50289 0 1 0 26843 22 0 0 25 0 11 0 2308932 916664320 100725 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9838] ppid=9823 vsize=895180 CPUtime=13.5
/proc/9836/task/9838/stat : 9838 (java) S 9823 9822 1511 34817 1511 4202560 39229 0 0 0 1338 12 0 0 16 0 11 0 2308934 916664320 100725 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 0 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9839] ppid=9823 vsize=895180 CPUtime=0
/proc/9836/task/9839/stat : 9839 (java) S 9823 9822 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 2308934 916664320 100725 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9840] ppid=9823 vsize=895180 CPUtime=0
/proc/9836/task/9840/stat : 9840 (java) S 9823 9822 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 2308934 916664320 100725 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9841] ppid=9823 vsize=895180 CPUtime=0
/proc/9836/task/9841/stat : 9841 (java) S 9823 9822 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 2308936 916664320 100725 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9842] ppid=9823 vsize=895180 CPUtime=0.47
/proc/9836/task/9842/stat : 9842 (java) S 9823 9822 1511 34817 1511 4202560 9092 0 0 0 44 3 0 0 25 0 11 0 2308937 916664320 100725 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9843] ppid=9823 vsize=895180 CPUtime=3.15
/proc/9836/task/9843/stat : 9843 (java) S 9823 9822 1511 34817 1511 4202560 8566 0 0 0 311 4 0 0 15 0 11 0 2308937 916664320 100725 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9844] ppid=9823 vsize=895180 CPUtime=0
/proc/9836/task/9844/stat : 9844 (java) S 9823 9822 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 2308937 916664320 100725 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 18446612133173262528 0 0 -1 0 0 0 0
[pid=9836/tid=9845] ppid=9823 vsize=895180 CPUtime=0
/proc/9836/task/9845/stat : 9845 (java) R 9823 9822 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 2308937 916664320 100725 1283457024 134512640 134550932 4292378160 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 285.83
Current children cumulated vsize (KiB) 900312

[startup+286.707 s]
/proc/loadavg: 1.03 1.04 1.00 2/48 9853
/proc/meminfo: memFree=116464/1048576 swapFree=0/0
[pid=9822] ppid=9821 vsize=2564 CPUtime=0
/proc/9822/stat : 9822 (p2cudf-trendy-1) S 9821 9822 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 18 0 1 0 2308928 2625536 270 1283457024 134512640 135304128 4287683376 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9822/statm: 641 270 230 194 0 28 0
[pid=9823] ppid=9822 vsize=2568 CPUtime=0.04
/proc/9823/stat : 9823 (p2cudf) S 9822 9822 1511 34817 1511 4202496 389 3016 0 1 0 0 2 2 25 0 1 0 2308928 2629632 279 1283457024 134512640 135304128 4293878032 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9823/statm: 642 279 239 194 0 29 0
[pid=9836] ppid=9823 vsize=0 CPUtime=285.88
/proc/9836/stat : 9836 (java) Z 9823 9822 1511 34817 1511 4203532 108267 0 1 0 28544 44 0 0 18 0 2 0 2308931 0 0 1283457024 0 0 0 0 0 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9836/statm: 0 0 0 0 0 0 0
[pid=9836/tid=9837] ppid=9823 vsize=0 CPUtime=268.66
/proc/9836/task/9837/stat : 9837 (java) R 9823 9822 1511 34817 1511 4203588 50289 0 1 0 26843 23 0 0 19 0 2 0 2308932 0 0 1283457024 0 0 0 0 0 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 285.92
Current children cumulated vsize (KiB) 5132

Child status: 0
Real time (s): 286.724
CPU time (s): 285.942
CPU user time (s): 285.47
CPU system time (s): 0.472029
CPU usage (%): 99.7272
Max. virtual memory (cumulated for all children) (KiB): 906672

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 285.47
system time used= 0.472029
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 112067
page faults= 2
swaps= 0
block input operations= 0
block output operations= 0
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 6215
involuntary context switches= 8916

runsolver used 0 second user time and 0 second system time

The end