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/rand314.cudf.s-e-l-s-s.log.runsolver ./p2cudf-trendy-1.13 /home/misc2010/data/2011/incremental/s-e-l-s-s//rand314.cudf /home/misc2010/tmp/201108241238/p2cudf-trendy-1.13/rand314.cudf.s-e-l-s-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 1.00 0.99 5/35 5832
/proc/meminfo: memFree=470724/1048576 swapFree=0/0
[pid=5830] ppid=5829 vsize=2572 CPUtime=0
/proc/5830/stat : 5830 (p2cudf-trendy-1) S 5829 5830 1511 34817 1511 4202496 375 0 0 0 0 0 0 0 18 0 1 0 1365459 2633728 271 1283457024 134512640 135304128 4291950400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5830/statm: 643 271 230 194 0 30 0
[pid=5831] ppid=5830 vsize=2568 CPUtime=0
/proc/5831/stat : 5831 (p2cudf) R 5830 5830 1511 34817 1511 4202496 345 0 0 0 0 0 0 0 25 0 1 0 1365459 2629632 271 1283457024 134512640 135304128 4294220128 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/5831/statm: 642 271 231 194 0 29 0
[pid=5832] ppid=5831 vsize=2568 CPUtime=0
/proc/5832/stat : 5832 (p2cudf) R 5831 5830 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 1 0 1365459 2629632 40 1283457024 134512640 135304128 4294220128 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/5832/statm: 642 40 0 194 0 29 0

[startup+0.125495 s]
/proc/loadavg: 0.85 1.00 0.99 5/35 5832
/proc/meminfo: memFree=470724/1048576 swapFree=0/0
[pid=5830] ppid=5829 vsize=2572 CPUtime=0
/proc/5830/stat : 5830 (p2cudf-trendy-1) S 5829 5830 1511 34817 1511 4202496 375 0 0 0 0 0 0 0 18 0 1 0 1365459 2633728 271 1283457024 134512640 135304128 4291950400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5830/statm: 643 271 230 194 0 30 0
[pid=5831] ppid=5830 vsize=2572 CPUtime=0.03
/proc/5831/stat : 5831 (p2cudf) S 5830 5830 1511 34817 1511 4202496 391 3019 0 1 0 0 2 1 25 0 1 0 1365459 2633728 280 1283457024 134512640 135304128 4294220128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5831/statm: 643 280 239 194 0 30 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5144

[startup+0.2055 s]
/proc/loadavg: 0.85 1.00 0.99 5/35 5832
/proc/meminfo: memFree=470724/1048576 swapFree=0/0
[pid=5830] ppid=5829 vsize=2572 CPUtime=0
/proc/5830/stat : 5830 (p2cudf-trendy-1) S 5829 5830 1511 34817 1511 4202496 375 0 0 0 0 0 0 0 18 0 1 0 1365459 2633728 271 1283457024 134512640 135304128 4291950400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5830/statm: 643 271 230 194 0 30 0
[pid=5831] ppid=5830 vsize=2572 CPUtime=0.03
/proc/5831/stat : 5831 (p2cudf) S 5830 5830 1511 34817 1511 4202496 391 3019 0 1 0 0 2 1 25 0 1 0 1365459 2633728 280 1283457024 134512640 135304128 4294220128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5831/statm: 643 280 239 194 0 30 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5144

[startup+0.305507 s]
/proc/loadavg: 0.85 1.00 0.99 5/35 5832
/proc/meminfo: memFree=470724/1048576 swapFree=0/0
[pid=5830] ppid=5829 vsize=2572 CPUtime=0
/proc/5830/stat : 5830 (p2cudf-trendy-1) S 5829 5830 1511 34817 1511 4202496 375 0 0 0 0 0 0 0 18 0 1 0 1365459 2633728 271 1283457024 134512640 135304128 4291950400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5830/statm: 643 271 230 194 0 30 0
[pid=5831] ppid=5830 vsize=2572 CPUtime=0.03
/proc/5831/stat : 5831 (p2cudf) S 5830 5830 1511 34817 1511 4202496 391 3019 0 1 0 0 2 1 25 0 1 0 1365459 2633728 280 1283457024 134512640 135304128 4294220128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5831/statm: 643 280 239 194 0 30 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5144

[startup+0.705563 s]
/proc/loadavg: 0.85 1.00 0.99 5/35 5832
/proc/meminfo: memFree=470724/1048576 swapFree=0/0
[pid=5830] ppid=5829 vsize=2572 CPUtime=0
/proc/5830/stat : 5830 (p2cudf-trendy-1) S 5829 5830 1511 34817 1511 4202496 375 0 0 0 0 0 0 0 18 0 1 0 1365459 2633728 271 1283457024 134512640 135304128 4291950400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5830/statm: 643 271 230 194 0 30 0
[pid=5831] ppid=5830 vsize=2572 CPUtime=0.03
/proc/5831/stat : 5831 (p2cudf) S 5830 5830 1511 34817 1511 4202496 391 3019 0 1 0 0 2 1 25 0 1 0 1365459 2633728 280 1283457024 134512640 135304128 4294220128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5831/statm: 643 280 239 194 0 30 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5144

[startup+1.50568 s]
/proc/loadavg: 0.85 1.00 0.99 5/45 5853
/proc/meminfo: memFree=410308/1048576 swapFree=0/0
[pid=5830] ppid=5829 vsize=2572 CPUtime=0
/proc/5830/stat : 5830 (p2cudf-trendy-1) S 5829 5830 1511 34817 1511 4202496 375 0 0 0 0 0 0 0 18 0 1 0 1365459 2633728 271 1283457024 134512640 135304128 4291950400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5830/statm: 643 271 230 194 0 30 0
[pid=5831] ppid=5830 vsize=2572 CPUtime=0.03
/proc/5831/stat : 5831 (p2cudf) S 5830 5830 1511 34817 1511 4202496 391 3019 0 1 0 0 2 1 25 0 1 0 1365459 2633728 280 1283457024 134512640 135304128 4294220128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5831/statm: 643 280 239 194 0 30 0
[pid=5844] ppid=5831 vsize=898392 CPUtime=1.48
/proc/5844/stat : 5844 (java) S 5831 5830 1511 34817 1511 4202496 25983 0 1 0 138 10 0 0 25 0 10 0 1365463 919953408 22021 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5844/statm: 224598 22021 1719 10 0 221689 0
[pid=5844/tid=5845] ppid=5831 vsize=898392 CPUtime=0.78
/proc/5844/task/5845/stat : 5845 (java) R 5831 5830 1511 34817 1511 4202560 11004 0 1 0 74 4 0 0 25 0 10 0 1365463 919953408 22021 1283457024 134512640 134550932 4287142192 18446744073709551615 4094725091 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5844/tid=5846] ppid=5831 vsize=898392 CPUtime=0
/proc/5844/task/5846/stat : 5846 (java) S 5831 5830 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 17 0 10 0 1365465 919953408 22021 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 0 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5847] ppid=5831 vsize=898392 CPUtime=0
/proc/5844/task/5847/stat : 5847 (java) S 5831 5830 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 25 0 10 0 1365465 919953408 22021 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5848] ppid=5831 vsize=898392 CPUtime=0
/proc/5844/task/5848/stat : 5848 (java) S 5831 5830 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 10 0 1365465 919953408 22021 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5849] ppid=5831 vsize=898392 CPUtime=0
/proc/5844/task/5849/stat : 5849 (java) S 5831 5830 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 1365468 919953408 22021 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5850] ppid=5831 vsize=898392 CPUtime=0.46
/proc/5844/task/5850/stat : 5850 (java) R 5831 5830 1511 34817 1511 4202560 9286 0 0 0 43 3 0 0 25 0 10 0 1365468 919953408 22021 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5844/tid=5851] ppid=5831 vsize=898392 CPUtime=0.21
/proc/5844/task/5851/stat : 5851 (java) S 5831 5830 1511 34817 1511 4202560 4613 0 0 0 19 2 0 0 22 0 10 0 1365468 919953408 22021 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5852] ppid=5831 vsize=898392 CPUtime=0
/proc/5844/task/5852/stat : 5852 (java) S 5831 5830 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 1365468 919953408 22021 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5853] ppid=5831 vsize=898392 CPUtime=0
/proc/5844/task/5853/stat : 5853 (java) S 5831 5830 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 10 0 1365468 919953408 22021 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 1.51
Current children cumulated vsize (KiB) 903536

[startup+3.10614 s]
/proc/loadavg: 1.02 1.03 1.01 2/45 5853
/proc/meminfo: memFree=305156/1048576 swapFree=0/0
[pid=5830] ppid=5829 vsize=2572 CPUtime=0
/proc/5830/stat : 5830 (p2cudf-trendy-1) S 5829 5830 1511 34817 1511 4202496 375 0 0 0 0 0 0 0 18 0 1 0 1365459 2633728 271 1283457024 134512640 135304128 4291950400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5830/statm: 643 271 230 194 0 30 0
[pid=5831] ppid=5830 vsize=2572 CPUtime=0.03
/proc/5831/stat : 5831 (p2cudf) S 5830 5830 1511 34817 1511 4202496 391 3019 0 1 0 0 2 1 25 0 1 0 1365459 2633728 280 1283457024 134512640 135304128 4294220128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5831/statm: 643 280 239 194 0 30 0
[pid=5844] ppid=5831 vsize=895964 CPUtime=3.07
/proc/5844/stat : 5844 (java) S 5831 5830 1511 34817 1511 4202496 78843 0 1 0 278 29 0 0 25 0 10 0 1365463 917467136 73746 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5844/statm: 223991 73746 1732 10 0 221082 0
[pid=5844/tid=5845] ppid=5831 vsize=895964 CPUtime=1.78
/proc/5844/task/5845/stat : 5845 (java) R 5831 5830 1511 34817 1511 4202560 50037 0 1 0 159 19 0 0 25 0 10 0 1365463 917467136 73746 1283457024 134512640 134550932 4287142192 18446744073709551615 4095205221 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5844/tid=5846] ppid=5831 vsize=895964 CPUtime=0.27
/proc/5844/task/5846/stat : 5846 (java) S 5831 5830 1511 34817 1511 4202560 12679 0 0 0 25 2 0 0 16 0 10 0 1365465 917467136 73746 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 0 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5847] ppid=5831 vsize=895964 CPUtime=0
/proc/5844/task/5847/stat : 5847 (java) S 5831 5830 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 10 0 1365465 917467136 73746 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5848] ppid=5831 vsize=895964 CPUtime=0
/proc/5844/task/5848/stat : 5848 (java) S 5831 5830 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 10 0 1365465 917467136 73746 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5849] ppid=5831 vsize=895964 CPUtime=0
/proc/5844/task/5849/stat : 5849 (java) S 5831 5830 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 1365468 917467136 73746 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5850] ppid=5831 vsize=895964 CPUtime=0.52
/proc/5844/task/5850/stat : 5850 (java) S 5831 5830 1511 34817 1511 4202560 9355 0 0 0 48 4 0 0 25 0 10 0 1365468 917467136 73746 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5851] ppid=5831 vsize=895964 CPUtime=0.47
/proc/5844/task/5851/stat : 5851 (java) S 5831 5830 1511 34817 1511 4202560 5695 0 0 0 44 3 0 0 15 0 10 0 1365468 917467136 73746 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5852] ppid=5831 vsize=895964 CPUtime=0
/proc/5844/task/5852/stat : 5852 (java) S 5831 5830 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 1365468 917467136 73746 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5853] ppid=5831 vsize=895964 CPUtime=0
/proc/5844/task/5853/stat : 5853 (java) S 5831 5830 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 10 0 1365468 917467136 73746 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 3.1
Current children cumulated vsize (KiB) 901108

[startup+6.30698 s]
/proc/loadavg: 1.02 1.03 1.01 3/45 5853
/proc/meminfo: memFree=121760/1048576 swapFree=0/0
[pid=5830] ppid=5829 vsize=2572 CPUtime=0
/proc/5830/stat : 5830 (p2cudf-trendy-1) S 5829 5830 1511 34817 1511 4202496 375 0 0 0 0 0 0 0 18 0 1 0 1365459 2633728 271 1283457024 134512640 135304128 4291950400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5830/statm: 643 271 230 194 0 30 0
[pid=5831] ppid=5830 vsize=2572 CPUtime=0.03
/proc/5831/stat : 5831 (p2cudf) S 5830 5830 1511 34817 1511 4202496 391 3019 0 1 0 0 2 1 25 0 1 0 1365459 2633728 280 1283457024 134512640 135304128 4294220128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5831/statm: 643 280 239 194 0 30 0
[pid=5844] ppid=5831 vsize=896184 CPUtime=6.26
/proc/5844/stat : 5844 (java) S 5831 5830 1511 34817 1511 4202496 96145 0 1 0 591 35 0 0 25 0 11 0 1365463 917692416 88756 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5844/statm: 224046 88756 1772 10 0 221137 0
[pid=5844/tid=5845] ppid=5831 vsize=896184 CPUtime=2.99
/proc/5844/task/5845/stat : 5845 (java) R 5831 5830 1511 34817 1511 4202560 50270 0 1 0 280 19 0 0 25 0 11 0 1365463 917692416 88756 1283457024 134512640 134550932 4287142192 18446744073709551615 4095773072 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5844/tid=5846] ppid=5831 vsize=896184 CPUtime=0.61
/proc/5844/task/5846/stat : 5846 (java) S 5831 5830 1511 34817 1511 4202560 27179 0 0 0 54 7 0 0 16 0 11 0 1365465 917692416 88756 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 0 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5847] ppid=5831 vsize=896184 CPUtime=0
/proc/5844/task/5847/stat : 5847 (java) S 5831 5830 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 1365465 917692416 88756 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5848] ppid=5831 vsize=896184 CPUtime=0
/proc/5844/task/5848/stat : 5848 (java) S 5831 5830 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1365465 917692416 88756 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5849] ppid=5831 vsize=896184 CPUtime=0
/proc/5844/task/5849/stat : 5849 (java) S 5831 5830 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1365468 917692416 88756 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5850] ppid=5831 vsize=896184 CPUtime=0.59
/proc/5844/task/5850/stat : 5850 (java) S 5831 5830 1511 34817 1511 4202560 9362 0 0 0 55 4 0 0 17 0 11 0 1365468 917692416 88756 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5851] ppid=5831 vsize=896184 CPUtime=2.04
/proc/5844/task/5851/stat : 5851 (java) S 5831 5830 1511 34817 1511 4202560 8253 0 0 0 200 4 0 0 16 0 11 0 1365468 917692416 88756 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5852] ppid=5831 vsize=896184 CPUtime=0
/proc/5844/task/5852/stat : 5852 (java) S 5831 5830 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1365468 917692416 88756 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5853] ppid=5831 vsize=896184 CPUtime=0
/proc/5844/task/5853/stat : 5853 (java) S 5831 5830 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1365468 917692416 88756 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 6.29
Current children cumulated vsize (KiB) 901328

[startup+12.7091 s]
/proc/loadavg: 1.09 1.05 1.01 2/46 5854
/proc/meminfo: memFree=98572/1048576 swapFree=0/0
[pid=5830] ppid=5829 vsize=2572 CPUtime=0
/proc/5830/stat : 5830 (p2cudf-trendy-1) S 5829 5830 1511 34817 1511 4202496 375 0 0 0 0 0 0 0 18 0 1 0 1365459 2633728 271 1283457024 134512640 135304128 4291950400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5830/statm: 643 271 230 194 0 30 0
[pid=5831] ppid=5830 vsize=2572 CPUtime=0.03
/proc/5831/stat : 5831 (p2cudf) S 5830 5830 1511 34817 1511 4202496 391 3019 0 1 0 0 2 1 25 0 1 0 1365459 2633728 280 1283457024 134512640 135304128 4294220128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5831/statm: 643 280 239 194 0 30 0
[pid=5844] ppid=5831 vsize=890824 CPUtime=12.66
/proc/5844/stat : 5844 (java) S 5831 5830 1511 34817 1511 4202496 103202 0 1 0 1230 36 0 0 25 0 11 0 1365463 912203776 94479 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5844/statm: 222706 94479 1782 10 0 219797 0
[pid=5844/tid=5845] ppid=5831 vsize=890824 CPUtime=8.68
/proc/5844/task/5845/stat : 5845 (java) R 5831 5830 1511 34817 1511 4202560 50279 0 1 0 849 19 0 0 25 0 11 0 1365463 912203776 94479 1283457024 134512640 134550932 4287142192 18446744073709551615 4095773099 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5844/tid=5846] ppid=5831 vsize=890824 CPUtime=0.92
/proc/5844/task/5846/stat : 5846 (java) S 5831 5830 1511 34817 1511 4202560 34160 0 0 0 84 8 0 0 16 0 11 0 1365465 912203776 94479 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 0 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5847] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5847/stat : 5847 (java) S 5831 5830 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 1365465 912203776 94479 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5848] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5848/stat : 5848 (java) S 5831 5830 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1365465 912203776 94479 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5849] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5849/stat : 5849 (java) S 5831 5830 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1365468 912203776 94479 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5850] ppid=5831 vsize=890824 CPUtime=0.59
/proc/5844/task/5850/stat : 5850 (java) S 5831 5830 1511 34817 1511 4202560 9362 0 0 0 55 4 0 0 17 0 11 0 1365468 912203776 94479 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5851] ppid=5831 vsize=890824 CPUtime=2.45
/proc/5844/task/5851/stat : 5851 (java) S 5831 5830 1511 34817 1511 4202560 8320 0 0 0 241 4 0 0 15 0 11 0 1365468 912203776 94479 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5852] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5852/stat : 5852 (java) S 5831 5830 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1365468 912203776 94479 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5853] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5853/stat : 5853 (java) S 5831 5830 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1365468 912203776 94479 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5854] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5854/stat : 5854 (java) S 5831 5830 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 1366065 912203776 94479 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 12.69
Current children cumulated vsize (KiB) 895968

[startup+25.5129 s]
/proc/loadavg: 1.15 1.06 1.01 2/46 5854
/proc/meminfo: memFree=73400/1048576 swapFree=0/0
[pid=5830] ppid=5829 vsize=2572 CPUtime=0
/proc/5830/stat : 5830 (p2cudf-trendy-1) S 5829 5830 1511 34817 1511 4202496 375 0 0 0 0 0 0 0 18 0 1 0 1365459 2633728 271 1283457024 134512640 135304128 4291950400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5830/statm: 643 271 230 194 0 30 0
[pid=5831] ppid=5830 vsize=2572 CPUtime=0.03
/proc/5831/stat : 5831 (p2cudf) S 5830 5830 1511 34817 1511 4202496 391 3019 0 1 0 0 2 1 25 0 1 0 1365459 2633728 280 1283457024 134512640 135304128 4294220128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5831/statm: 643 280 239 194 0 30 0
[pid=5844] ppid=5831 vsize=890824 CPUtime=25.46
/proc/5844/stat : 5844 (java) S 5831 5830 1511 34817 1511 4202496 109453 0 1 0 2509 37 0 0 25 0 11 0 1365463 912203776 100730 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5844/statm: 222706 100730 1788 10 0 219797 0
[pid=5844/tid=5845] ppid=5831 vsize=890824 CPUtime=20.62
/proc/5844/task/5845/stat : 5845 (java) R 5831 5830 1511 34817 1511 4202560 50280 0 1 0 2043 19 0 0 25 0 11 0 1365463 912203776 100730 1283457024 134512640 134550932 4287142192 18446744073709551615 4095772740 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5844/tid=5846] ppid=5831 vsize=890824 CPUtime=1.36
/proc/5844/task/5846/stat : 5846 (java) S 5831 5830 1511 34817 1511 4202560 40399 0 0 0 127 9 0 0 15 0 11 0 1365465 912203776 100730 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 0 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5847] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5847/stat : 5847 (java) S 5831 5830 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 1365465 912203776 100730 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5848] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5848/stat : 5848 (java) S 5831 5830 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1365465 912203776 100730 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5849] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5849/stat : 5849 (java) S 5831 5830 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1365468 912203776 100730 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5850] ppid=5831 vsize=890824 CPUtime=0.59
/proc/5844/task/5850/stat : 5850 (java) S 5831 5830 1511 34817 1511 4202560 9362 0 0 0 55 4 0 0 17 0 11 0 1365468 912203776 100730 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5851] ppid=5831 vsize=890824 CPUtime=2.85
/proc/5844/task/5851/stat : 5851 (java) S 5831 5830 1511 34817 1511 4202560 8331 0 0 0 281 4 0 0 15 0 11 0 1365468 912203776 100730 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5852] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5852/stat : 5852 (java) S 5831 5830 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1365468 912203776 100730 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5853] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5853/stat : 5853 (java) S 5831 5830 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1365468 912203776 100730 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5854] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5854/stat : 5854 (java) S 5831 5830 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 1366065 912203776 100730 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 25.49
Current children cumulated vsize (KiB) 895968

[startup+51.109 s]
/proc/loadavg: 1.16 1.07 1.02 2/48 5856
/proc/meminfo: memFree=71268/1048576 swapFree=0/0
[pid=5830] ppid=5829 vsize=2572 CPUtime=0
/proc/5830/stat : 5830 (p2cudf-trendy-1) S 5829 5830 1511 34817 1511 4202496 375 0 0 0 0 0 0 0 18 0 1 0 1365459 2633728 271 1283457024 134512640 135304128 4291950400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5830/statm: 643 271 230 194 0 30 0
[pid=5831] ppid=5830 vsize=2572 CPUtime=0.03
/proc/5831/stat : 5831 (p2cudf) S 5830 5830 1511 34817 1511 4202496 391 3019 0 1 0 0 2 1 25 0 1 0 1365459 2633728 280 1283457024 134512640 135304128 4294220128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5831/statm: 643 280 239 194 0 30 0
[pid=5844] ppid=5831 vsize=890824 CPUtime=51.04
/proc/5844/stat : 5844 (java) S 5831 5830 1511 34817 1511 4202496 109930 0 1 0 5064 40 0 0 25 0 11 0 1365463 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5844/statm: 222706 101207 1788 10 0 219797 0
[pid=5844/tid=5845] ppid=5831 vsize=890824 CPUtime=44.36
/proc/5844/task/5845/stat : 5845 (java) R 5831 5830 1511 34817 1511 4202560 50281 0 1 0 4415 21 0 0 25 0 11 0 1365463 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4095773032 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5844/tid=5846] ppid=5831 vsize=890824 CPUtime=3.14
/proc/5844/task/5846/stat : 5846 (java) S 5831 5830 1511 34817 1511 4202560 40872 0 0 0 304 10 0 0 15 0 11 0 1365465 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 0 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5847] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5847/stat : 5847 (java) S 5831 5830 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 1365465 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5848] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5848/stat : 5848 (java) S 5831 5830 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1365465 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5849] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5849/stat : 5849 (java) S 5831 5830 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5850] ppid=5831 vsize=890824 CPUtime=0.59
/proc/5844/task/5850/stat : 5850 (java) S 5831 5830 1511 34817 1511 4202560 9362 0 0 0 55 4 0 0 17 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5851] ppid=5831 vsize=890824 CPUtime=2.92
/proc/5844/task/5851/stat : 5851 (java) S 5831 5830 1511 34817 1511 4202560 8334 0 0 0 288 4 0 0 16 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5852] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5852/stat : 5852 (java) S 5831 5830 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5853] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5853/stat : 5853 (java) S 5831 5830 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5854] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5854/stat : 5854 (java) S 5831 5830 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 1366065 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 51.07
Current children cumulated vsize (KiB) 895968

[startup+102.311 s]
/proc/loadavg: 1.06 1.06 1.01 2/48 5862
/proc/meminfo: memFree=71144/1048576 swapFree=0/0
[pid=5830] ppid=5829 vsize=2572 CPUtime=0
/proc/5830/stat : 5830 (p2cudf-trendy-1) S 5829 5830 1511 34817 1511 4202496 375 0 0 0 0 0 0 0 18 0 1 0 1365459 2633728 271 1283457024 134512640 135304128 4291950400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5830/statm: 643 271 230 194 0 30 0
[pid=5831] ppid=5830 vsize=2572 CPUtime=0.03
/proc/5831/stat : 5831 (p2cudf) S 5830 5830 1511 34817 1511 4202496 391 3019 0 1 0 0 2 1 25 0 1 0 1365459 2633728 280 1283457024 134512640 135304128 4294220128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5831/statm: 643 280 239 194 0 30 0
[pid=5844] ppid=5831 vsize=890824 CPUtime=102.19
/proc/5844/stat : 5844 (java) S 5831 5830 1511 34817 1511 4202496 109930 0 1 0 10179 40 0 0 25 0 11 0 1365463 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5844/statm: 222706 101207 1788 10 0 219797 0
[pid=5844/tid=5845] ppid=5831 vsize=890824 CPUtime=94.25
/proc/5844/task/5845/stat : 5845 (java) R 5831 5830 1511 34817 1511 4202560 50281 0 1 0 9404 21 0 0 25 0 11 0 1365463 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4095785200 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5844/tid=5846] ppid=5831 vsize=890824 CPUtime=4.4
/proc/5844/task/5846/stat : 5846 (java) S 5831 5830 1511 34817 1511 4202560 40872 0 0 0 430 10 0 0 15 0 11 0 1365465 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 0 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5847] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5847/stat : 5847 (java) S 5831 5830 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 1365465 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5848] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5848/stat : 5848 (java) S 5831 5830 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1365465 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5849] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5849/stat : 5849 (java) S 5831 5830 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5850] ppid=5831 vsize=890824 CPUtime=0.59
/proc/5844/task/5850/stat : 5850 (java) S 5831 5830 1511 34817 1511 4202560 9362 0 0 0 55 4 0 0 17 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5851] ppid=5831 vsize=890824 CPUtime=2.92
/proc/5844/task/5851/stat : 5851 (java) S 5831 5830 1511 34817 1511 4202560 8334 0 0 0 288 4 0 0 15 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5852] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5852/stat : 5852 (java) S 5831 5830 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5853] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5853/stat : 5853 (java) S 5831 5830 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5854] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5854/stat : 5854 (java) S 5831 5830 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 1366065 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 102.22
Current children cumulated vsize (KiB) 895968

[startup+162.307 s]
/proc/loadavg: 1.02 1.04 1.01 2/47 5865
/proc/meminfo: memFree=71160/1048576 swapFree=0/0
[pid=5830] ppid=5829 vsize=2572 CPUtime=0
/proc/5830/stat : 5830 (p2cudf-trendy-1) S 5829 5830 1511 34817 1511 4202496 375 0 0 0 0 0 0 0 18 0 1 0 1365459 2633728 271 1283457024 134512640 135304128 4291950400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5830/statm: 643 271 230 194 0 30 0
[pid=5831] ppid=5830 vsize=2572 CPUtime=0.03
/proc/5831/stat : 5831 (p2cudf) S 5830 5830 1511 34817 1511 4202496 391 3019 0 1 0 0 2 1 25 0 1 0 1365459 2633728 280 1283457024 134512640 135304128 4294220128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5831/statm: 643 280 239 194 0 30 0
[pid=5844] ppid=5831 vsize=890824 CPUtime=162.12
/proc/5844/stat : 5844 (java) S 5831 5830 1511 34817 1511 4202496 109930 0 1 0 16172 40 0 0 25 0 11 0 1365463 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5844/statm: 222706 101207 1788 10 0 219797 0
[pid=5844/tid=5845] ppid=5831 vsize=890824 CPUtime=153.35
/proc/5844/task/5845/stat : 5845 (java) R 5831 5830 1511 34817 1511 4202560 50281 0 1 0 15314 21 0 0 25 0 11 0 1365463 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4094851274 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5844/tid=5846] ppid=5831 vsize=890824 CPUtime=5.23
/proc/5844/task/5846/stat : 5846 (java) S 5831 5830 1511 34817 1511 4202560 40872 0 0 0 513 10 0 0 15 0 11 0 1365465 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 0 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5847] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5847/stat : 5847 (java) S 5831 5830 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 1365465 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5848] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5848/stat : 5848 (java) S 5831 5830 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1365465 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5849] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5849/stat : 5849 (java) S 5831 5830 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5850] ppid=5831 vsize=890824 CPUtime=0.59
/proc/5844/task/5850/stat : 5850 (java) S 5831 5830 1511 34817 1511 4202560 9362 0 0 0 55 4 0 0 17 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5851] ppid=5831 vsize=890824 CPUtime=2.92
/proc/5844/task/5851/stat : 5851 (java) S 5831 5830 1511 34817 1511 4202560 8334 0 0 0 288 4 0 0 15 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5852] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5852/stat : 5852 (java) S 5831 5830 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5853] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5853/stat : 5853 (java) S 5831 5830 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5854] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5854/stat : 5854 (java) S 5831 5830 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 1366065 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 162.15
Current children cumulated vsize (KiB) 895968

[startup+222.305 s]
/proc/loadavg: 1.01 1.03 1.00 2/46 5865
/proc/meminfo: memFree=71168/1048576 swapFree=0/0
[pid=5830] ppid=5829 vsize=2572 CPUtime=0
/proc/5830/stat : 5830 (p2cudf-trendy-1) S 5829 5830 1511 34817 1511 4202496 375 0 0 0 0 0 0 0 18 0 1 0 1365459 2633728 271 1283457024 134512640 135304128 4291950400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5830/statm: 643 271 230 194 0 30 0
[pid=5831] ppid=5830 vsize=2572 CPUtime=0.03
/proc/5831/stat : 5831 (p2cudf) S 5830 5830 1511 34817 1511 4202496 391 3019 0 1 0 0 2 1 25 0 1 0 1365459 2633728 280 1283457024 134512640 135304128 4294220128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5831/statm: 643 280 239 194 0 30 0
[pid=5844] ppid=5831 vsize=890824 CPUtime=222.06
/proc/5844/stat : 5844 (java) S 5831 5830 1511 34817 1511 4202496 109930 0 1 0 22166 40 0 0 25 0 11 0 1365463 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5844/statm: 222706 101207 1788 10 0 219797 0
[pid=5844/tid=5845] ppid=5831 vsize=890824 CPUtime=212.04
/proc/5844/task/5845/stat : 5845 (java) R 5831 5830 1511 34817 1511 4202560 50281 0 1 0 21183 21 0 0 25 0 11 0 1365463 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4095923061 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5844/tid=5846] ppid=5831 vsize=890824 CPUtime=6.48
/proc/5844/task/5846/stat : 5846 (java) S 5831 5830 1511 34817 1511 4202560 40872 0 0 0 638 10 0 0 16 0 11 0 1365465 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 0 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5847] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5847/stat : 5847 (java) S 5831 5830 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 1365465 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5848] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5848/stat : 5848 (java) S 5831 5830 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1365465 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5849] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5849/stat : 5849 (java) S 5831 5830 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5850] ppid=5831 vsize=890824 CPUtime=0.59
/proc/5844/task/5850/stat : 5850 (java) S 5831 5830 1511 34817 1511 4202560 9362 0 0 0 55 4 0 0 17 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5851] ppid=5831 vsize=890824 CPUtime=2.92
/proc/5844/task/5851/stat : 5851 (java) S 5831 5830 1511 34817 1511 4202560 8334 0 0 0 288 4 0 0 15 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5852] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5852/stat : 5852 (java) S 5831 5830 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5853] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5853/stat : 5853 (java) S 5831 5830 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5854] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5854/stat : 5854 (java) S 5831 5830 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 1366065 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 222.09
Current children cumulated vsize (KiB) 895968

[startup+282.31 s]
/proc/loadavg: 1.00 1.02 1.00 2/46 5865
/proc/meminfo: memFree=71168/1048576 swapFree=0/0
[pid=5830] ppid=5829 vsize=2572 CPUtime=0
/proc/5830/stat : 5830 (p2cudf-trendy-1) S 5829 5830 1511 34817 1511 4202496 375 0 0 0 0 0 0 0 18 0 1 0 1365459 2633728 271 1283457024 134512640 135304128 4291950400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5830/statm: 643 271 230 194 0 30 0
[pid=5831] ppid=5830 vsize=2572 CPUtime=0.03
/proc/5831/stat : 5831 (p2cudf) S 5830 5830 1511 34817 1511 4202496 391 3019 0 1 0 0 2 1 25 0 1 0 1365459 2633728 280 1283457024 134512640 135304128 4294220128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5831/statm: 643 280 239 194 0 30 0
[pid=5844] ppid=5831 vsize=890824 CPUtime=282.03
/proc/5844/stat : 5844 (java) S 5831 5830 1511 34817 1511 4202496 109930 0 1 0 28161 42 0 0 25 0 11 0 1365463 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5844/statm: 222706 101207 1788 10 0 219797 0
[pid=5844/tid=5845] ppid=5831 vsize=890824 CPUtime=271.18
/proc/5844/task/5845/stat : 5845 (java) R 5831 5830 1511 34817 1511 4202560 50281 0 1 0 27096 22 0 0 25 0 11 0 1365463 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4094708946 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5844/tid=5846] ppid=5831 vsize=890824 CPUtime=7.3
/proc/5844/task/5846/stat : 5846 (java) S 5831 5830 1511 34817 1511 4202560 40872 0 0 0 720 10 0 0 15 0 11 0 1365465 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 0 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5847] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5847/stat : 5847 (java) S 5831 5830 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 1365465 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5848] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5848/stat : 5848 (java) S 5831 5830 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1365465 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5849] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5849/stat : 5849 (java) S 5831 5830 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5850] ppid=5831 vsize=890824 CPUtime=0.59
/proc/5844/task/5850/stat : 5850 (java) S 5831 5830 1511 34817 1511 4202560 9362 0 0 0 55 4 0 0 17 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5851] ppid=5831 vsize=890824 CPUtime=2.92
/proc/5844/task/5851/stat : 5851 (java) S 5831 5830 1511 34817 1511 4202560 8334 0 0 0 288 4 0 0 15 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5852] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5852/stat : 5852 (java) S 5831 5830 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5853] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5853/stat : 5853 (java) S 5831 5830 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5854] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5854/stat : 5854 (java) S 5831 5830 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 1366065 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 282.06
Current children cumulated vsize (KiB) 895968

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

[startup+284.811 s]
/proc/loadavg: 1.00 1.02 1.00 2/46 5865
/proc/meminfo: memFree=71168/1048576 swapFree=0/0
[pid=5830] ppid=5829 vsize=2572 CPUtime=0
/proc/5830/stat : 5830 (p2cudf-trendy-1) S 5829 5830 1511 34817 1511 4202496 375 0 0 0 0 0 0 0 18 0 1 0 1365459 2633728 271 1283457024 134512640 135304128 4291950400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5830/statm: 643 271 230 194 0 30 0
[pid=5831] ppid=5830 vsize=2572 CPUtime=0.03
/proc/5831/stat : 5831 (p2cudf) S 5830 5830 1511 34817 1511 4202496 391 3019 0 1 0 0 2 1 25 0 1 0 1365459 2633728 280 1283457024 134512640 135304128 4294220128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5831/statm: 643 280 239 194 0 30 0
[pid=5844] ppid=5831 vsize=890824 CPUtime=284.53
/proc/5844/stat : 5844 (java) S 5831 5830 1511 34817 1511 4202496 109930 0 1 0 28411 42 0 0 25 0 11 0 1365463 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5844/statm: 222706 101207 1788 10 0 219797 0
[pid=5844/tid=5845] ppid=5831 vsize=890824 CPUtime=273.68
/proc/5844/task/5845/stat : 5845 (java) R 5831 5830 1511 34817 1511 4202560 50281 0 1 0 27346 22 0 0 25 0 11 0 1365463 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4095922887 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5844/tid=5846] ppid=5831 vsize=890824 CPUtime=7.3
/proc/5844/task/5846/stat : 5846 (java) S 5831 5830 1511 34817 1511 4202560 40872 0 0 0 720 10 0 0 15 0 11 0 1365465 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 0 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5847] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5847/stat : 5847 (java) S 5831 5830 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 1365465 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5848] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5848/stat : 5848 (java) S 5831 5830 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1365465 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5849] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5849/stat : 5849 (java) S 5831 5830 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5850] ppid=5831 vsize=890824 CPUtime=0.59
/proc/5844/task/5850/stat : 5850 (java) S 5831 5830 1511 34817 1511 4202560 9362 0 0 0 55 4 0 0 17 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5851] ppid=5831 vsize=890824 CPUtime=2.92
/proc/5844/task/5851/stat : 5851 (java) S 5831 5830 1511 34817 1511 4202560 8334 0 0 0 288 4 0 0 15 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5852] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5852/stat : 5852 (java) S 5831 5830 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5853] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5853/stat : 5853 (java) R 5831 5830 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5844/tid=5854] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5854/stat : 5854 (java) S 5831 5830 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 1366065 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 284.56
Current children cumulated vsize (KiB) 895968

[startup+285.611 s]
/proc/loadavg: 1.00 1.02 1.00 2/46 5865
/proc/meminfo: memFree=71168/1048576 swapFree=0/0
[pid=5830] ppid=5829 vsize=2572 CPUtime=0
/proc/5830/stat : 5830 (p2cudf-trendy-1) S 5829 5830 1511 34817 1511 4202496 375 0 0 0 0 0 0 0 18 0 1 0 1365459 2633728 271 1283457024 134512640 135304128 4291950400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5830/statm: 643 271 230 194 0 30 0
[pid=5831] ppid=5830 vsize=2572 CPUtime=0.03
/proc/5831/stat : 5831 (p2cudf) S 5830 5830 1511 34817 1511 4202496 391 3019 0 1 0 0 2 1 25 0 1 0 1365459 2633728 280 1283457024 134512640 135304128 4294220128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5831/statm: 643 280 239 194 0 30 0
[pid=5844] ppid=5831 vsize=890824 CPUtime=285.32
/proc/5844/stat : 5844 (java) S 5831 5830 1511 34817 1511 4202496 109930 0 1 0 28490 42 0 0 25 0 11 0 1365463 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5844/statm: 222706 101207 1788 10 0 219797 0
[pid=5844/tid=5845] ppid=5831 vsize=890824 CPUtime=274.47
/proc/5844/task/5845/stat : 5845 (java) R 5831 5830 1511 34817 1511 4202560 50281 0 1 0 27425 22 0 0 25 0 11 0 1365463 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4095785216 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5844/tid=5846] ppid=5831 vsize=890824 CPUtime=7.3
/proc/5844/task/5846/stat : 5846 (java) S 5831 5830 1511 34817 1511 4202560 40872 0 0 0 720 10 0 0 15 0 11 0 1365465 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 0 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5847] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5847/stat : 5847 (java) S 5831 5830 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 1365465 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5848] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5848/stat : 5848 (java) S 5831 5830 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1365465 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5849] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5849/stat : 5849 (java) S 5831 5830 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5850] ppid=5831 vsize=890824 CPUtime=0.59
/proc/5844/task/5850/stat : 5850 (java) S 5831 5830 1511 34817 1511 4202560 9362 0 0 0 55 4 0 0 17 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5851] ppid=5831 vsize=890824 CPUtime=2.92
/proc/5844/task/5851/stat : 5851 (java) S 5831 5830 1511 34817 1511 4202560 8334 0 0 0 288 4 0 0 15 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5852] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5852/stat : 5852 (java) S 5831 5830 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5853] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5853/stat : 5853 (java) S 5831 5830 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1365468 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5854] ppid=5831 vsize=890824 CPUtime=0
/proc/5844/task/5854/stat : 5854 (java) S 5831 5830 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 1366065 912203776 101207 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 285.35
Current children cumulated vsize (KiB) 895968

[startup+286.407 s]
/proc/loadavg: 1.00 1.02 1.00 3/46 5865
/proc/meminfo: memFree=71168/1048576 swapFree=0/0
[pid=5830] ppid=5829 vsize=2572 CPUtime=0
/proc/5830/stat : 5830 (p2cudf-trendy-1) S 5829 5830 1511 34817 1511 4202496 375 0 0 0 0 0 0 0 18 0 1 0 1365459 2633728 271 1283457024 134512640 135304128 4291950400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5830/statm: 643 271 230 194 0 30 0
[pid=5831] ppid=5830 vsize=2572 CPUtime=0.03
/proc/5831/stat : 5831 (p2cudf) S 5830 5830 1511 34817 1511 4202496 391 3019 0 1 0 0 2 1 25 0 1 0 1365459 2633728 280 1283457024 134512640 135304128 4294220128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5831/statm: 643 280 239 194 0 30 0
[pid=5844] ppid=5831 vsize=891148 CPUtime=285.84
/proc/5844/stat : 5844 (java) S 5831 5830 1511 34817 1511 4202496 109944 0 1 0 28542 42 0 0 25 0 11 0 1365463 912535552 101221 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5844/statm: 222787 101221 1789 10 0 219878 0
[pid=5844/tid=5845] ppid=5831 vsize=891148 CPUtime=274.94
/proc/5844/task/5845/stat : 5845 (java) S 5831 5830 1511 34817 1511 4202560 50289 0 1 0 27472 22 0 0 25 0 11 0 1365463 912535552 101221 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5846] ppid=5831 vsize=891148 CPUtime=7.3
/proc/5844/task/5846/stat : 5846 (java) S 5831 5830 1511 34817 1511 4202560 40872 0 0 0 720 10 0 0 16 0 11 0 1365465 912535552 101221 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 0 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5847] ppid=5831 vsize=891148 CPUtime=0
/proc/5844/task/5847/stat : 5847 (java) S 5831 5830 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 1365465 912535552 101221 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5848] ppid=5831 vsize=891148 CPUtime=0
/proc/5844/task/5848/stat : 5848 (java) S 5831 5830 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1365465 912535552 101221 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5849] ppid=5831 vsize=891148 CPUtime=0
/proc/5844/task/5849/stat : 5849 (java) S 5831 5830 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1365468 912535552 101221 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5850] ppid=5831 vsize=891148 CPUtime=0.59
/proc/5844/task/5850/stat : 5850 (java) S 5831 5830 1511 34817 1511 4202560 9362 0 0 0 55 4 0 0 17 0 11 0 1365468 912535552 101221 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5851] ppid=5831 vsize=891148 CPUtime=2.96
/proc/5844/task/5851/stat : 5851 (java) S 5831 5830 1511 34817 1511 4202560 8334 0 0 0 292 4 0 0 15 0 11 0 1365468 912535552 101221 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5852] ppid=5831 vsize=891148 CPUtime=0
/proc/5844/task/5852/stat : 5852 (java) S 5831 5830 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1365468 912535552 101221 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5853] ppid=5831 vsize=891148 CPUtime=0
/proc/5844/task/5853/stat : 5853 (java) S 5831 5830 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1365468 912535552 101221 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 285.87
Current children cumulated vsize (KiB) 896292

[startup+286.803 s]
/proc/loadavg: 1.00 1.02 1.00 3/46 5865
/proc/meminfo: memFree=71168/1048576 swapFree=0/0
[pid=5830] ppid=5829 vsize=2572 CPUtime=0
/proc/5830/stat : 5830 (p2cudf-trendy-1) S 5829 5830 1511 34817 1511 4202496 375 0 0 0 0 0 0 0 18 0 1 0 1365459 2633728 271 1283457024 134512640 135304128 4291950400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5830/statm: 643 271 230 194 0 30 0
[pid=5831] ppid=5830 vsize=2572 CPUtime=0.03
/proc/5831/stat : 5831 (p2cudf) S 5830 5830 1511 34817 1511 4202496 391 3019 0 1 0 0 2 1 25 0 1 0 1365459 2633728 280 1283457024 134512640 135304128 4294220128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5831/statm: 643 280 239 194 0 30 0
[pid=5844] ppid=5831 vsize=891148 CPUtime=285.97
/proc/5844/stat : 5844 (java) S 5831 5830 1511 34817 1511 4202496 109946 0 1 0 28552 45 0 0 25 0 10 0 1365463 912535552 101223 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5844/statm: 222787 101223 1789 10 0 219878 0
[pid=5844/tid=5845] ppid=5831 vsize=891148 CPUtime=274.94
/proc/5844/task/5845/stat : 5845 (java) S 5831 5830 1511 34817 1511 4202560 50289 0 1 0 27472 22 0 0 19 0 10 0 1365463 912535552 101223 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5846] ppid=5831 vsize=891148 CPUtime=7.3
/proc/5844/task/5846/stat : 5846 (java) S 5831 5830 1511 34817 1511 4202560 40872 0 0 0 720 10 0 0 16 0 10 0 1365465 912535552 101223 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 0 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5847] ppid=5831 vsize=891148 CPUtime=0
/proc/5844/task/5847/stat : 5847 (java) S 5831 5830 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 10 0 1365465 912535552 101223 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5848] ppid=5831 vsize=891148 CPUtime=0
/proc/5844/task/5848/stat : 5848 (java) S 5831 5830 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 10 0 1365465 912535552 101223 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5849] ppid=5831 vsize=891148 CPUtime=0
/proc/5844/task/5849/stat : 5849 (java) S 5831 5830 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 1365468 912535552 101223 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5850] ppid=5831 vsize=891148 CPUtime=0.59
/proc/5844/task/5850/stat : 5850 (java) S 5831 5830 1511 34817 1511 4202560 9362 0 0 0 55 4 0 0 17 0 10 0 1365468 912535552 101223 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5851] ppid=5831 vsize=891148 CPUtime=3.01
/proc/5844/task/5851/stat : 5851 (java) S 5831 5830 1511 34817 1511 4202560 8334 0 0 0 297 4 0 0 16 0 10 0 1365468 912535552 101223 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5852] ppid=5831 vsize=891148 CPUtime=0
/proc/5844/task/5852/stat : 5852 (java) S 5831 5830 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 1365468 912535552 101223 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
[pid=5844/tid=5853] ppid=5831 vsize=891148 CPUtime=0
/proc/5844/task/5853/stat : 5853 (java) S 5831 5830 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 10 0 1365468 912535552 101223 1283457024 134512640 134550932 4287142192 18446744073709551615 4294960130 0 4 0 16800975 18446612133275972032 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 286
Current children cumulated vsize (KiB) 896292

Child status: 0
Real time (s): 286.841
CPU time (s): 286.026
CPU user time (s): 285.546
CPU system time (s): 0.48003
CPU usage (%): 99.7157
Max. virtual memory (cumulated for all children) (KiB): 904376

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 285.546
system time used= 0.48003
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 113757
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= 6189
involuntary context switches= 8944

runsolver used 0 second user time and 0.008 second system time

The end