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/201108311143/p2cudf-user-1.13/ca8f656c-db9e-11df-b9cf-00163e3d3b7c.cudf.dudf-real.log.runsolver ./p2cudf-user-1.13 /home/misc2010/data/2011/dudf-real//ca8f656c-db9e-11df-b9cf-00163e3d3b7c.cudf /home/misc2010/tmp/201108311143/p2cudf-user-1.13/ca8f656c-db9e-11df-b9cf-00163e3d3b7c.cudf.dudf-real.result -sum(installedsize) 

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


[startup+0 s]
/proc/loadavg: 0.99 1.00 1.00 5/36 1026
/proc/meminfo: memFree=629372/1048576 swapFree=0/0
[pid=1025] ppid=1024 vsize=2564 CPUtime=0
/proc/1025/stat : 1025 (p2cudf-user-1.1) R 1024 1025 19908 34817 19908 4202496 355 0 0 0 0 0 0 0 25 0 1 0 67491679 2625536 269 1283457024 134512640 135304128 4293873856 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/1025/statm: 641 269 230 194 0 28 0
[pid=1026] ppid=1025 vsize=2564 CPUtime=0
/proc/1026/stat : 1026 (p2cudf-user-1.1) R 1025 1025 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 1 0 67491679 2625536 39 1283457024 134512640 135304128 4293873856 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/1026/statm: 641 39 0 194 0 28 0

[startup+0.145593 s]
/proc/loadavg: 0.99 1.00 1.00 5/36 1026
/proc/meminfo: memFree=629372/1048576 swapFree=0/0
[pid=1025] ppid=1024 vsize=2564 CPUtime=0
/proc/1025/stat : 1025 (p2cudf-user-1.1) S 1024 1025 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 25 0 1 0 67491679 2625536 269 1283457024 134512640 135304128 4293873856 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1025/statm: 641 269 230 194 0 28 0
[pid=1026] ppid=1025 vsize=2576 CPUtime=0.03
/proc/1026/stat : 1026 (p2cudf) S 1025 1025 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 67491679 2637824 281 1283457024 134512640 135304128 4287814448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1026/statm: 644 281 239 194 0 31 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5140

[startup+0.205593 s]
/proc/loadavg: 0.99 1.00 1.00 5/36 1026
/proc/meminfo: memFree=629372/1048576 swapFree=0/0
[pid=1025] ppid=1024 vsize=2564 CPUtime=0
/proc/1025/stat : 1025 (p2cudf-user-1.1) S 1024 1025 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 25 0 1 0 67491679 2625536 269 1283457024 134512640 135304128 4293873856 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1025/statm: 641 269 230 194 0 28 0
[pid=1026] ppid=1025 vsize=2576 CPUtime=0.03
/proc/1026/stat : 1026 (p2cudf) S 1025 1025 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 67491679 2637824 281 1283457024 134512640 135304128 4287814448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1026/statm: 644 281 239 194 0 31 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5140

[startup+0.305601 s]
/proc/loadavg: 0.99 1.00 1.00 5/36 1026
/proc/meminfo: memFree=629372/1048576 swapFree=0/0
[pid=1025] ppid=1024 vsize=2564 CPUtime=0
/proc/1025/stat : 1025 (p2cudf-user-1.1) S 1024 1025 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 25 0 1 0 67491679 2625536 269 1283457024 134512640 135304128 4293873856 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1025/statm: 641 269 230 194 0 28 0
[pid=1026] ppid=1025 vsize=2576 CPUtime=0.03
/proc/1026/stat : 1026 (p2cudf) S 1025 1025 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 67491679 2637824 281 1283457024 134512640 135304128 4287814448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1026/statm: 644 281 239 194 0 31 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5140

[startup+0.705707 s]
/proc/loadavg: 0.99 1.00 1.00 5/36 1026
/proc/meminfo: memFree=629372/1048576 swapFree=0/0
[pid=1025] ppid=1024 vsize=2564 CPUtime=0
/proc/1025/stat : 1025 (p2cudf-user-1.1) S 1024 1025 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 25 0 1 0 67491679 2625536 269 1283457024 134512640 135304128 4293873856 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1025/statm: 641 269 230 194 0 28 0
[pid=1026] ppid=1025 vsize=2576 CPUtime=0.03
/proc/1026/stat : 1026 (p2cudf) S 1025 1025 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 67491679 2637824 281 1283457024 134512640 135304128 4287814448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1026/statm: 644 281 239 194 0 31 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5140

[startup+1.5059 s]
/proc/loadavg: 1.07 1.02 1.01 5/47 1048
/proc/meminfo: memFree=588532/1048576 swapFree=0/0
[pid=1025] ppid=1024 vsize=2564 CPUtime=0
/proc/1025/stat : 1025 (p2cudf-user-1.1) S 1024 1025 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 25 0 1 0 67491679 2625536 269 1283457024 134512640 135304128 4293873856 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1025/statm: 641 269 230 194 0 28 0
[pid=1026] ppid=1025 vsize=2576 CPUtime=0.03
/proc/1026/stat : 1026 (p2cudf) S 1025 1025 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 67491679 2637824 281 1283457024 134512640 135304128 4287814448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1026/statm: 644 281 239 194 0 31 0
[pid=1039] ppid=1026 vsize=882248 CPUtime=1.47
/proc/1039/stat : 1039 (java) S 1026 1025 19908 34817 19908 4202496 21798 0 1 0 140 7 0 0 25 0 10 0 67491682 903421952 18733 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/1039/statm: 220562 18733 1734 10 0 217653 0
[pid=1039/tid=1040] ppid=1026 vsize=882248 CPUtime=0.77
/proc/1039/task/1040/stat : 1040 (java) R 1026 1025 19908 34817 19908 4202560 10836 0 1 0 75 2 0 0 25 0 10 0 67491683 903421952 18733 1283457024 134512640 134550932 4287795648 18446744073709551615 4152956378 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=1039/tid=1041] ppid=1026 vsize=882248 CPUtime=0
/proc/1039/task/1041/stat : 1041 (java) S 1026 1025 19908 34817 19908 4202560 7 0 0 0 0 0 0 0 17 0 10 0 67491685 903421952 18733 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 0 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1042] ppid=1026 vsize=882248 CPUtime=0
/proc/1039/task/1042/stat : 1042 (java) S 1026 1025 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 25 0 10 0 67491685 903421952 18733 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1043] ppid=1026 vsize=882248 CPUtime=0
/proc/1039/task/1043/stat : 1043 (java) S 1026 1025 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 10 0 67491685 903421952 18733 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1044] ppid=1026 vsize=882248 CPUtime=0
/proc/1039/task/1044/stat : 1044 (java) S 1026 1025 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 67491688 903421952 18733 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1045] ppid=1026 vsize=882248 CPUtime=0.55
/proc/1039/task/1045/stat : 1045 (java) R 1026 1025 19908 34817 19908 4202560 8437 0 0 0 51 4 0 0 22 0 10 0 67491688 903421952 18733 1283457024 134512640 134550932 4287795648 18446744073709551615 4150264868 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=1039/tid=1046] ppid=1026 vsize=882248 CPUtime=0.13
/proc/1039/task/1046/stat : 1046 (java) S 1026 1025 19908 34817 19908 4202560 1445 0 0 0 13 0 0 0 23 0 10 0 67491688 903421952 18733 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1047] ppid=1026 vsize=882248 CPUtime=0
/proc/1039/task/1047/stat : 1047 (java) S 1026 1025 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 10 0 67491688 903421952 18733 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1048] ppid=1026 vsize=882248 CPUtime=0
/proc/1039/task/1048/stat : 1048 (java) S 1026 1025 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 10 0 67491688 903421952 18733 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 1.5
Current children cumulated vsize (KiB) 887388

[startup+3.10633 s]
/proc/loadavg: 1.07 1.02 1.01 3/47 1048
/proc/meminfo: memFree=463788/1048576 swapFree=0/0
[pid=1025] ppid=1024 vsize=2564 CPUtime=0
/proc/1025/stat : 1025 (p2cudf-user-1.1) S 1024 1025 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 25 0 1 0 67491679 2625536 269 1283457024 134512640 135304128 4293873856 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1025/statm: 641 269 230 194 0 28 0
[pid=1026] ppid=1025 vsize=2576 CPUtime=0.03
/proc/1026/stat : 1026 (p2cudf) S 1025 1025 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 67491679 2637824 281 1283457024 134512640 135304128 4287814448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1026/statm: 644 281 239 194 0 31 0
[pid=1039] ppid=1026 vsize=882248 CPUtime=3.07
/proc/1039/stat : 1039 (java) S 1026 1025 19908 34817 19908 4202496 55943 0 1 0 291 16 0 0 25 0 10 0 67491682 903421952 52878 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/1039/statm: 220562 52878 1754 10 0 217653 0
[pid=1039/tid=1040] ppid=1026 vsize=882248 CPUtime=1.57
/proc/1039/task/1040/stat : 1040 (java) R 1026 1025 19908 34817 19908 4202560 44867 0 1 0 146 11 0 0 25 0 10 0 67491683 903421952 52878 1283457024 134512640 134550932 4287795648 18446744073709551615 4095381478 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=1039/tid=1041] ppid=1026 vsize=882248 CPUtime=0
/proc/1039/task/1041/stat : 1041 (java) S 1026 1025 19908 34817 19908 4202560 7 0 0 0 0 0 0 0 16 0 10 0 67491685 903421952 52878 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 0 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1042] ppid=1026 vsize=882248 CPUtime=0
/proc/1039/task/1042/stat : 1042 (java) S 1026 1025 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 25 0 10 0 67491685 903421952 52878 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1043] ppid=1026 vsize=882248 CPUtime=0
/proc/1039/task/1043/stat : 1043 (java) S 1026 1025 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 10 0 67491685 903421952 52878 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1044] ppid=1026 vsize=882248 CPUtime=0
/proc/1039/task/1044/stat : 1044 (java) S 1026 1025 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 67491688 903421952 52878 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1045] ppid=1026 vsize=882248 CPUtime=1.34
/proc/1039/task/1045/stat : 1045 (java) S 1026 1025 19908 34817 19908 4202560 8551 0 0 0 130 4 0 0 16 0 10 0 67491688 903421952 52878 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1046] ppid=1026 vsize=882248 CPUtime=0.14
/proc/1039/task/1046/stat : 1046 (java) S 1026 1025 19908 34817 19908 4202560 1445 0 0 0 14 0 0 0 22 0 10 0 67491688 903421952 52878 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1047] ppid=1026 vsize=882248 CPUtime=0
/proc/1039/task/1047/stat : 1047 (java) S 1026 1025 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 10 0 67491688 903421952 52878 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1048] ppid=1026 vsize=882248 CPUtime=0
/proc/1039/task/1048/stat : 1048 (java) S 1026 1025 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 10 0 67491688 903421952 52878 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 3.1
Current children cumulated vsize (KiB) 887388

[startup+6.32712 s]
/proc/loadavg: 1.07 1.02 1.00 2/48 1049
/proc/meminfo: memFree=360992/1048576 swapFree=0/0
[pid=1025] ppid=1024 vsize=2564 CPUtime=0
/proc/1025/stat : 1025 (p2cudf-user-1.1) S 1024 1025 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 25 0 1 0 67491679 2625536 269 1283457024 134512640 135304128 4293873856 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1025/statm: 641 269 230 194 0 28 0
[pid=1026] ppid=1025 vsize=2576 CPUtime=0.03
/proc/1026/stat : 1026 (p2cudf) S 1025 1025 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 67491679 2637824 281 1283457024 134512640 135304128 4287814448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1026/statm: 644 281 239 194 0 31 0
[pid=1039] ppid=1026 vsize=882572 CPUtime=6.29
/proc/1039/stat : 1039 (java) S 1026 1025 19908 34817 19908 4202496 71879 0 1 0 609 20 0 0 25 0 11 0 67491682 903753728 68814 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/1039/statm: 220643 68814 1786 10 0 217734 0
[pid=1039/tid=1040] ppid=1026 vsize=882572 CPUtime=3.73
/proc/1039/task/1040/stat : 1040 (java) R 1026 1025 19908 34817 19908 4202560 50269 0 1 0 360 13 0 0 25 0 11 0 67491683 903753728 68814 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=1039/tid=1041] ppid=1026 vsize=882572 CPUtime=0.34
/proc/1039/task/1041/stat : 1041 (java) R 1026 1025 19908 34817 19908 4202560 10432 0 0 0 32 2 0 0 15 0 11 0 67491685 903753728 68814 1283457024 134512640 134550932 4287795648 18446744073709551615 4150300184 0 0 0 16800975 0 0 0 -1 0 0 0 0
[pid=1039/tid=1042] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1042/stat : 1042 (java) S 1026 1025 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 18 0 11 0 67491685 903753728 68814 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1043] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1043/stat : 1043 (java) S 1026 1025 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 67491685 903753728 68814 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1044] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1044/stat : 1044 (java) S 1026 1025 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 67491688 903753728 68814 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1045] ppid=1026 vsize=882572 CPUtime=2.05
/proc/1039/task/1045/stat : 1045 (java) S 1026 1025 19908 34817 19908 4202560 8654 0 0 0 201 4 0 0 16 0 11 0 67491688 903753728 68814 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1046] ppid=1026 vsize=882572 CPUtime=0.14
/proc/1039/task/1046/stat : 1046 (java) S 1026 1025 19908 34817 19908 4202560 1445 0 0 0 14 0 0 0 22 0 11 0 67491688 903753728 68814 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1047] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1047/stat : 1047 (java) S 1026 1025 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 67491688 903753728 68814 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1048] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1048/stat : 1048 (java) S 1026 1025 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 67491688 903753728 68814 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1049] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1049/stat : 1049 (java) S 1026 1025 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 67492067 903753728 68814 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 6.32
Current children cumulated vsize (KiB) 887712

[startup+12.7087 s]
/proc/loadavg: 1.06 1.02 1.00 3/48 1050
/proc/meminfo: memFree=317964/1048576 swapFree=0/0
[pid=1025] ppid=1024 vsize=2564 CPUtime=0
/proc/1025/stat : 1025 (p2cudf-user-1.1) S 1024 1025 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 25 0 1 0 67491679 2625536 269 1283457024 134512640 135304128 4293873856 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1025/statm: 641 269 230 194 0 28 0
[pid=1026] ppid=1025 vsize=2576 CPUtime=0.03
/proc/1026/stat : 1026 (p2cudf) S 1025 1025 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 67491679 2637824 281 1283457024 134512640 135304128 4287814448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1026/statm: 644 281 239 194 0 31 0
[pid=1039] ppid=1026 vsize=882572 CPUtime=12.66
/proc/1039/stat : 1039 (java) S 1026 1025 19908 34817 19908 4202496 82396 0 1 0 1242 24 0 0 25 0 11 0 67491682 903753728 79331 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/1039/statm: 220643 79331 1786 10 0 217734 0
[pid=1039/tid=1040] ppid=1026 vsize=882572 CPUtime=9.57
/proc/1039/task/1040/stat : 1040 (java) R 1026 1025 19908 34817 19908 4202560 50269 0 1 0 944 13 0 0 25 0 11 0 67491683 903753728 79331 1283457024 134512640 134550932 4287795648 18446744073709551615 4096300820 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=1039/tid=1041] ppid=1026 vsize=882572 CPUtime=0.81
/proc/1039/task/1041/stat : 1041 (java) S 1026 1025 19908 34817 19908 4202560 20943 0 0 0 76 5 0 0 15 0 11 0 67491685 903753728 79331 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 0 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1042] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1042/stat : 1042 (java) S 1026 1025 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 18 0 11 0 67491685 903753728 79331 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1043] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1043/stat : 1043 (java) S 1026 1025 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 67491685 903753728 79331 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1044] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1044/stat : 1044 (java) S 1026 1025 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 67491688 903753728 79331 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1045] ppid=1026 vsize=882572 CPUtime=2.11
/proc/1039/task/1045/stat : 1045 (java) S 1026 1025 19908 34817 19908 4202560 8660 0 0 0 207 4 0 0 16 0 11 0 67491688 903753728 79331 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1046] ppid=1026 vsize=882572 CPUtime=0.14
/proc/1039/task/1046/stat : 1046 (java) S 1026 1025 19908 34817 19908 4202560 1445 0 0 0 14 0 0 0 22 0 11 0 67491688 903753728 79331 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1047] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1047/stat : 1047 (java) S 1026 1025 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 67491688 903753728 79331 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1048] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1048/stat : 1048 (java) R 1026 1025 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 67491688 903753728 79331 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=1039/tid=1049] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1049/stat : 1049 (java) S 1026 1025 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 67492067 903753728 79331 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 12.69
Current children cumulated vsize (KiB) 887712

[startup+25.5318 s]
/proc/loadavg: 1.05 1.02 1.00 2/48 1051
/proc/meminfo: memFree=303084/1048576 swapFree=0/0
[pid=1025] ppid=1024 vsize=2564 CPUtime=0
/proc/1025/stat : 1025 (p2cudf-user-1.1) S 1024 1025 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 25 0 1 0 67491679 2625536 269 1283457024 134512640 135304128 4293873856 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1025/statm: 641 269 230 194 0 28 0
[pid=1026] ppid=1025 vsize=2576 CPUtime=0.03
/proc/1026/stat : 1026 (p2cudf) S 1025 1025 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 67491679 2637824 281 1283457024 134512640 135304128 4287814448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1026/statm: 644 281 239 194 0 31 0
[pid=1039] ppid=1026 vsize=882572 CPUtime=25.48
/proc/1039/stat : 1039 (java) S 1026 1025 19908 34817 19908 4202496 86085 0 1 0 2522 26 0 0 25 0 11 0 67491682 903753728 83020 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/1039/statm: 220643 83020 1788 10 0 217734 0
[pid=1039/tid=1040] ppid=1026 vsize=882572 CPUtime=21.65
/proc/1039/task/1040/stat : 1040 (java) R 1026 1025 19908 34817 19908 4202560 50269 0 1 0 2151 14 0 0 25 0 11 0 67491683 903753728 83020 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=1039/tid=1041] ppid=1026 vsize=882572 CPUtime=1.48
/proc/1039/task/1041/stat : 1041 (java) R 1026 1025 19908 34817 19908 4202560 24622 0 0 0 142 6 0 0 15 0 11 0 67491685 903753728 83020 1283457024 134512640 134550932 4287795648 18446744073709551615 4150313656 0 0 0 16800975 0 0 0 -1 0 0 0 0
[pid=1039/tid=1042] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1042/stat : 1042 (java) S 1026 1025 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 18 0 11 0 67491685 903753728 83020 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1043] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1043/stat : 1043 (java) S 1026 1025 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 67491685 903753728 83020 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1044] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1044/stat : 1044 (java) S 1026 1025 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 67491688 903753728 83020 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1045] ppid=1026 vsize=882572 CPUtime=2.17
/proc/1039/task/1045/stat : 1045 (java) S 1026 1025 19908 34817 19908 4202560 8670 0 0 0 213 4 0 0 16 0 11 0 67491688 903753728 83020 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1046] ppid=1026 vsize=882572 CPUtime=0.14
/proc/1039/task/1046/stat : 1046 (java) S 1026 1025 19908 34817 19908 4202560 1445 0 0 0 14 0 0 0 22 0 11 0 67491688 903753728 83020 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1047] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1047/stat : 1047 (java) S 1026 1025 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 67491688 903753728 83020 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1048] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1048/stat : 1048 (java) S 1026 1025 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 67491688 903753728 83020 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1049] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1049/stat : 1049 (java) S 1026 1025 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 67492067 903753728 83020 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 25.51
Current children cumulated vsize (KiB) 887712

[startup+51.1128 s]
/proc/loadavg: 1.03 1.02 1.00 3/48 1054
/proc/meminfo: memFree=276548/1048576 swapFree=0/0
[pid=1025] ppid=1024 vsize=2564 CPUtime=0
/proc/1025/stat : 1025 (p2cudf-user-1.1) S 1024 1025 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 25 0 1 0 67491679 2625536 269 1283457024 134512640 135304128 4293873856 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1025/statm: 641 269 230 194 0 28 0
[pid=1026] ppid=1025 vsize=2576 CPUtime=0.03
/proc/1026/stat : 1026 (p2cudf) S 1025 1025 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 67491679 2637824 281 1283457024 134512640 135304128 4287814448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1026/statm: 644 281 239 194 0 31 0
[pid=1039] ppid=1026 vsize=882572 CPUtime=50.98
/proc/1039/stat : 1039 (java) S 1026 1025 19908 34817 19908 4202496 92685 0 1 0 5070 28 0 0 25 0 11 0 67491682 903753728 89620 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/1039/statm: 220643 89620 1788 10 0 217734 0
[pid=1039/tid=1040] ppid=1026 vsize=882572 CPUtime=46.37
/proc/1039/task/1040/stat : 1040 (java) R 1026 1025 19908 34817 19908 4202560 50269 0 1 0 4623 14 0 0 25 0 11 0 67491683 903753728 89620 1283457024 134512640 134550932 4287795648 18446744073709551615 4096285373 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=1039/tid=1041] ppid=1026 vsize=882572 CPUtime=2.26
/proc/1039/task/1041/stat : 1041 (java) S 1026 1025 19908 34817 19908 4202560 31222 0 0 0 218 8 0 0 15 0 11 0 67491685 903753728 89620 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 0 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1042] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1042/stat : 1042 (java) S 1026 1025 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 18 0 11 0 67491685 903753728 89620 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1043] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1043/stat : 1043 (java) S 1026 1025 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 67491685 903753728 89620 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1044] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1044/stat : 1044 (java) S 1026 1025 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 67491688 903753728 89620 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1045] ppid=1026 vsize=882572 CPUtime=2.17
/proc/1039/task/1045/stat : 1045 (java) S 1026 1025 19908 34817 19908 4202560 8670 0 0 0 213 4 0 0 16 0 11 0 67491688 903753728 89620 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1046] ppid=1026 vsize=882572 CPUtime=0.14
/proc/1039/task/1046/stat : 1046 (java) S 1026 1025 19908 34817 19908 4202560 1445 0 0 0 14 0 0 0 22 0 11 0 67491688 903753728 89620 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1047] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1047/stat : 1047 (java) S 1026 1025 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 67491688 903753728 89620 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1048] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1048/stat : 1048 (java) S 1026 1025 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 67491688 903753728 89620 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1049] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1049/stat : 1049 (java) S 1026 1025 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 67492067 903753728 89620 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 51.01
Current children cumulated vsize (KiB) 887712

[startup+102.305 s]
/proc/loadavg: 1.01 1.01 1.00 2/47 1054
/proc/meminfo: memFree=265404/1048576 swapFree=0/0
[pid=1025] ppid=1024 vsize=2564 CPUtime=0
/proc/1025/stat : 1025 (p2cudf-user-1.1) S 1024 1025 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 25 0 1 0 67491679 2625536 269 1283457024 134512640 135304128 4293873856 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1025/statm: 641 269 230 194 0 28 0
[pid=1026] ppid=1025 vsize=2576 CPUtime=0.03
/proc/1026/stat : 1026 (p2cudf) S 1025 1025 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 67491679 2637824 281 1283457024 134512640 135304128 4287814448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1026/statm: 644 281 239 194 0 31 0
[pid=1039] ppid=1026 vsize=882572 CPUtime=102.14
/proc/1039/stat : 1039 (java) S 1026 1025 19908 34817 19908 4202496 95462 0 1 0 10184 30 0 0 25 0 11 0 67491682 903753728 92397 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/1039/statm: 220643 92397 1788 10 0 217734 0
[pid=1039/tid=1040] ppid=1026 vsize=882572 CPUtime=96.2
/proc/1039/task/1040/stat : 1040 (java) R 1026 1025 19908 34817 19908 4202560 50269 0 1 0 9604 16 0 0 25 0 11 0 67491683 903753728 92397 1283457024 134512640 134550932 4287795648 18446744073709551615 4096285373 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=1039/tid=1041] ppid=1026 vsize=882572 CPUtime=3.6
/proc/1039/task/1041/stat : 1041 (java) S 1026 1025 19908 34817 19908 4202560 33999 0 0 0 351 9 0 0 15 0 11 0 67491685 903753728 92397 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 0 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1042] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1042/stat : 1042 (java) S 1026 1025 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 18 0 11 0 67491685 903753728 92397 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1043] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1043/stat : 1043 (java) S 1026 1025 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 67491685 903753728 92397 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1044] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1044/stat : 1044 (java) S 1026 1025 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 67491688 903753728 92397 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1045] ppid=1026 vsize=882572 CPUtime=2.17
/proc/1039/task/1045/stat : 1045 (java) S 1026 1025 19908 34817 19908 4202560 8670 0 0 0 213 4 0 0 16 0 11 0 67491688 903753728 92397 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1046] ppid=1026 vsize=882572 CPUtime=0.14
/proc/1039/task/1046/stat : 1046 (java) S 1026 1025 19908 34817 19908 4202560 1445 0 0 0 14 0 0 0 22 0 11 0 67491688 903753728 92397 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1047] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1047/stat : 1047 (java) S 1026 1025 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 67491688 903753728 92397 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1048] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1048/stat : 1048 (java) S 1026 1025 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 67491688 903753728 92397 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1049] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1049/stat : 1049 (java) S 1026 1025 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 67492067 903753728 92397 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 102.17
Current children cumulated vsize (KiB) 887712

[startup+162.308 s]
/proc/loadavg: 1.00 1.01 1.00 2/46 1054
/proc/meminfo: memFree=238752/1048576 swapFree=0/0
[pid=1025] ppid=1024 vsize=2564 CPUtime=0
/proc/1025/stat : 1025 (p2cudf-user-1.1) S 1024 1025 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 25 0 1 0 67491679 2625536 269 1283457024 134512640 135304128 4293873856 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1025/statm: 641 269 230 194 0 28 0
[pid=1026] ppid=1025 vsize=2576 CPUtime=0.03
/proc/1026/stat : 1026 (p2cudf) S 1025 1025 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 67491679 2637824 281 1283457024 134512640 135304128 4287814448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1026/statm: 644 281 239 194 0 31 0
[pid=1039] ppid=1026 vsize=882572 CPUtime=162.11
/proc/1039/stat : 1039 (java) S 1026 1025 19908 34817 19908 4202496 102079 0 1 0 16178 33 0 0 25 0 11 0 67491682 903753728 99014 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/1039/statm: 220643 99014 1788 10 0 217734 0
[pid=1039/tid=1040] ppid=1026 vsize=882572 CPUtime=154.96
/proc/1039/task/1040/stat : 1040 (java) R 1026 1025 19908 34817 19908 4202560 50269 0 1 0 15480 16 0 0 25 0 11 0 67491683 903753728 99014 1283457024 134512640 134550932 4287795648 18446744073709551615 4096310733 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=1039/tid=1041] ppid=1026 vsize=882572 CPUtime=4.81
/proc/1039/task/1041/stat : 1041 (java) S 1026 1025 19908 34817 19908 4202560 40616 0 0 0 469 12 0 0 15 0 11 0 67491685 903753728 99014 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 0 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1042] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1042/stat : 1042 (java) S 1026 1025 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 18 0 11 0 67491685 903753728 99014 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1043] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1043/stat : 1043 (java) S 1026 1025 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 67491685 903753728 99014 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1044] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1044/stat : 1044 (java) S 1026 1025 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 67491688 903753728 99014 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1045] ppid=1026 vsize=882572 CPUtime=2.18
/proc/1039/task/1045/stat : 1045 (java) S 1026 1025 19908 34817 19908 4202560 8670 0 0 0 214 4 0 0 15 0 11 0 67491688 903753728 99014 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1046] ppid=1026 vsize=882572 CPUtime=0.14
/proc/1039/task/1046/stat : 1046 (java) S 1026 1025 19908 34817 19908 4202560 1445 0 0 0 14 0 0 0 22 0 11 0 67491688 903753728 99014 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1047] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1047/stat : 1047 (java) S 1026 1025 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 67491688 903753728 99014 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1048] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1048/stat : 1048 (java) S 1026 1025 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 67491688 903753728 99014 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1049] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1049/stat : 1049 (java) S 1026 1025 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 67492067 903753728 99014 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 162.14
Current children cumulated vsize (KiB) 887712

[startup+222.311 s]
/proc/loadavg: 1.04 1.02 1.00 2/46 1054
/proc/meminfo: memFree=213704/1048576 swapFree=0/0
[pid=1025] ppid=1024 vsize=2564 CPUtime=0
/proc/1025/stat : 1025 (p2cudf-user-1.1) S 1024 1025 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 25 0 1 0 67491679 2625536 269 1283457024 134512640 135304128 4293873856 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1025/statm: 641 269 230 194 0 28 0
[pid=1026] ppid=1025 vsize=2576 CPUtime=0.03
/proc/1026/stat : 1026 (p2cudf) S 1025 1025 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 67491679 2637824 281 1283457024 134512640 135304128 4287814448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1026/statm: 644 281 239 194 0 31 0
[pid=1039] ppid=1026 vsize=882572 CPUtime=222.07
/proc/1039/stat : 1039 (java) S 1026 1025 19908 34817 19908 4202496 108330 0 1 0 22172 35 0 0 25 0 11 0 67491682 903753728 105265 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/1039/statm: 220643 105265 1788 10 0 217734 0
[pid=1039/tid=1040] ppid=1026 vsize=882572 CPUtime=213.62
/proc/1039/task/1040/stat : 1040 (java) R 1026 1025 19908 34817 19908 4202560 50269 0 1 0 21346 16 0 0 25 0 11 0 67491683 903753728 105265 1283457024 134512640 134550932 4287795648 18446744073709551615 4096300830 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=1039/tid=1041] ppid=1026 vsize=882572 CPUtime=6.1
/proc/1039/task/1041/stat : 1041 (java) S 1026 1025 19908 34817 19908 4202560 46867 0 0 0 596 14 0 0 15 0 11 0 67491685 903753728 105265 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 0 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1042] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1042/stat : 1042 (java) S 1026 1025 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 18 0 11 0 67491685 903753728 105265 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1043] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1043/stat : 1043 (java) S 1026 1025 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 67491685 903753728 105265 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1044] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1044/stat : 1044 (java) S 1026 1025 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 67491688 903753728 105265 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1045] ppid=1026 vsize=882572 CPUtime=2.18
/proc/1039/task/1045/stat : 1045 (java) S 1026 1025 19908 34817 19908 4202560 8670 0 0 0 214 4 0 0 15 0 11 0 67491688 903753728 105265 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1046] ppid=1026 vsize=882572 CPUtime=0.14
/proc/1039/task/1046/stat : 1046 (java) S 1026 1025 19908 34817 19908 4202560 1445 0 0 0 14 0 0 0 22 0 11 0 67491688 903753728 105265 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1047] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1047/stat : 1047 (java) S 1026 1025 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 67491688 903753728 105265 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1048] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1048/stat : 1048 (java) S 1026 1025 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 67491688 903753728 105265 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1049] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1049/stat : 1049 (java) S 1026 1025 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 67492067 903753728 105265 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 222.1
Current children cumulated vsize (KiB) 887712

[startup+282.307 s]
/proc/loadavg: 1.01 1.01 1.00 2/46 1054
/proc/meminfo: memFree=211348/1048576 swapFree=0/0
[pid=1025] ppid=1024 vsize=2564 CPUtime=0
/proc/1025/stat : 1025 (p2cudf-user-1.1) S 1024 1025 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 25 0 1 0 67491679 2625536 269 1283457024 134512640 135304128 4293873856 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1025/statm: 641 269 230 194 0 28 0
[pid=1026] ppid=1025 vsize=2576 CPUtime=0.03
/proc/1026/stat : 1026 (p2cudf) S 1025 1025 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 67491679 2637824 281 1283457024 134512640 135304128 4287814448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1026/statm: 644 281 239 194 0 31 0
[pid=1039] ppid=1026 vsize=882572 CPUtime=282.03
/proc/1039/stat : 1039 (java) S 1026 1025 19908 34817 19908 4202496 108905 0 1 0 28168 35 0 0 25 0 11 0 67491682 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/1039/statm: 220643 105840 1788 10 0 217734 0
[pid=1039/tid=1040] ppid=1026 vsize=882572 CPUtime=272.52
/proc/1039/task/1040/stat : 1040 (java) R 1026 1025 19908 34817 19908 4202560 50269 0 1 0 27236 16 0 0 25 0 11 0 67491683 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4096300968 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=1039/tid=1041] ppid=1026 vsize=882572 CPUtime=7.16
/proc/1039/task/1041/stat : 1041 (java) S 1026 1025 19908 34817 19908 4202560 47442 0 0 0 702 14 0 0 16 0 11 0 67491685 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 0 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1042] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1042/stat : 1042 (java) S 1026 1025 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 18 0 11 0 67491685 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1043] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1043/stat : 1043 (java) S 1026 1025 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 67491685 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1044] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1044/stat : 1044 (java) S 1026 1025 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 67491688 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1045] ppid=1026 vsize=882572 CPUtime=2.18
/proc/1039/task/1045/stat : 1045 (java) S 1026 1025 19908 34817 19908 4202560 8670 0 0 0 214 4 0 0 15 0 11 0 67491688 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1046] ppid=1026 vsize=882572 CPUtime=0.14
/proc/1039/task/1046/stat : 1046 (java) S 1026 1025 19908 34817 19908 4202560 1445 0 0 0 14 0 0 0 22 0 11 0 67491688 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1047] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1047/stat : 1047 (java) S 1026 1025 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 67491688 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1048] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1048/stat : 1048 (java) S 1026 1025 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 67491688 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1049] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1049/stat : 1049 (java) S 1026 1025 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 67492067 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 282.06
Current children cumulated vsize (KiB) 887712

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

[startup+283.007 s]
/proc/loadavg: 1.01 1.01 1.00 2/46 1054
/proc/meminfo: memFree=211348/1048576 swapFree=0/0
[pid=1025] ppid=1024 vsize=2564 CPUtime=0
/proc/1025/stat : 1025 (p2cudf-user-1.1) S 1024 1025 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 25 0 1 0 67491679 2625536 269 1283457024 134512640 135304128 4293873856 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1025/statm: 641 269 230 194 0 28 0
[pid=1026] ppid=1025 vsize=2576 CPUtime=0.03
/proc/1026/stat : 1026 (p2cudf) S 1025 1025 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 67491679 2637824 281 1283457024 134512640 135304128 4287814448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1026/statm: 644 281 239 194 0 31 0
[pid=1039] ppid=1026 vsize=882572 CPUtime=282.73
/proc/1039/stat : 1039 (java) S 1026 1025 19908 34817 19908 4202496 108905 0 1 0 28238 35 0 0 25 0 11 0 67491682 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/1039/statm: 220643 105840 1788 10 0 217734 0
[pid=1039/tid=1040] ppid=1026 vsize=882572 CPUtime=273.22
/proc/1039/task/1040/stat : 1040 (java) R 1026 1025 19908 34817 19908 4202560 50269 0 1 0 27306 16 0 0 25 0 11 0 67491683 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4096297041 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=1039/tid=1041] ppid=1026 vsize=882572 CPUtime=7.16
/proc/1039/task/1041/stat : 1041 (java) S 1026 1025 19908 34817 19908 4202560 47442 0 0 0 702 14 0 0 15 0 11 0 67491685 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 0 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1042] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1042/stat : 1042 (java) S 1026 1025 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 18 0 11 0 67491685 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1043] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1043/stat : 1043 (java) S 1026 1025 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 67491685 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1044] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1044/stat : 1044 (java) S 1026 1025 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 67491688 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1045] ppid=1026 vsize=882572 CPUtime=2.18
/proc/1039/task/1045/stat : 1045 (java) S 1026 1025 19908 34817 19908 4202560 8670 0 0 0 214 4 0 0 15 0 11 0 67491688 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1046] ppid=1026 vsize=882572 CPUtime=0.14
/proc/1039/task/1046/stat : 1046 (java) S 1026 1025 19908 34817 19908 4202560 1445 0 0 0 14 0 0 0 22 0 11 0 67491688 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1047] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1047/stat : 1047 (java) S 1026 1025 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 67491688 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1048] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1048/stat : 1048 (java) S 1026 1025 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 67491688 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1049] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1049/stat : 1049 (java) S 1026 1025 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 67492067 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 282.76
Current children cumulated vsize (KiB) 887712

[startup+283.807 s]
/proc/loadavg: 1.01 1.01 1.00 2/46 1054
/proc/meminfo: memFree=211348/1048576 swapFree=0/0
[pid=1025] ppid=1024 vsize=2564 CPUtime=0
/proc/1025/stat : 1025 (p2cudf-user-1.1) S 1024 1025 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 25 0 1 0 67491679 2625536 269 1283457024 134512640 135304128 4293873856 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1025/statm: 641 269 230 194 0 28 0
[pid=1026] ppid=1025 vsize=2576 CPUtime=0.03
/proc/1026/stat : 1026 (p2cudf) S 1025 1025 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 67491679 2637824 281 1283457024 134512640 135304128 4287814448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1026/statm: 644 281 239 194 0 31 0
[pid=1039] ppid=1026 vsize=882572 CPUtime=283.53
/proc/1039/stat : 1039 (java) S 1026 1025 19908 34817 19908 4202496 108905 0 1 0 28318 35 0 0 25 0 11 0 67491682 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/1039/statm: 220643 105840 1788 10 0 217734 0
[pid=1039/tid=1040] ppid=1026 vsize=882572 CPUtime=274.02
/proc/1039/task/1040/stat : 1040 (java) R 1026 1025 19908 34817 19908 4202560 50269 0 1 0 27386 16 0 0 25 0 11 0 67491683 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4096233907 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=1039/tid=1041] ppid=1026 vsize=882572 CPUtime=7.16
/proc/1039/task/1041/stat : 1041 (java) S 1026 1025 19908 34817 19908 4202560 47442 0 0 0 702 14 0 0 15 0 11 0 67491685 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 0 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1042] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1042/stat : 1042 (java) S 1026 1025 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 18 0 11 0 67491685 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1043] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1043/stat : 1043 (java) S 1026 1025 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 67491685 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1044] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1044/stat : 1044 (java) S 1026 1025 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 67491688 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1045] ppid=1026 vsize=882572 CPUtime=2.18
/proc/1039/task/1045/stat : 1045 (java) S 1026 1025 19908 34817 19908 4202560 8670 0 0 0 214 4 0 0 15 0 11 0 67491688 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1046] ppid=1026 vsize=882572 CPUtime=0.14
/proc/1039/task/1046/stat : 1046 (java) S 1026 1025 19908 34817 19908 4202560 1445 0 0 0 14 0 0 0 22 0 11 0 67491688 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1047] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1047/stat : 1047 (java) S 1026 1025 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 67491688 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1048] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1048/stat : 1048 (java) S 1026 1025 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 67491688 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1049] ppid=1026 vsize=882572 CPUtime=0
/proc/1039/task/1049/stat : 1049 (java) S 1026 1025 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 67492067 903753728 105840 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.56
Current children cumulated vsize (KiB) 887712

[startup+284.207 s]
/proc/loadavg: 1.01 1.01 1.00 2/46 1054
/proc/meminfo: memFree=211348/1048576 swapFree=0/0
[pid=1025] ppid=1024 vsize=2564 CPUtime=0
/proc/1025/stat : 1025 (p2cudf-user-1.1) S 1024 1025 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 25 0 1 0 67491679 2625536 269 1283457024 134512640 135304128 4293873856 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1025/statm: 641 269 230 194 0 28 0
[pid=1026] ppid=1025 vsize=2576 CPUtime=0.03
/proc/1026/stat : 1026 (p2cudf) S 1025 1025 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 67491679 2637824 281 1283457024 134512640 135304128 4287814448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1026/statm: 644 281 239 194 0 31 0
[pid=1039] ppid=1026 vsize=882896 CPUtime=283.65
/proc/1039/stat : 1039 (java) S 1026 1025 19908 34817 19908 4202496 108917 0 1 0 28330 35 0 0 25 0 11 0 67491682 904085504 105852 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/1039/statm: 220724 105852 1789 10 0 217815 0
[pid=1039/tid=1040] ppid=1026 vsize=882896 CPUtime=274.13
/proc/1039/task/1040/stat : 1040 (java) S 1026 1025 19908 34817 19908 4202560 50276 0 1 0 27397 16 0 0 25 0 11 0 67491683 904085504 105852 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1041] ppid=1026 vsize=882896 CPUtime=7.16
/proc/1039/task/1041/stat : 1041 (java) S 1026 1025 19908 34817 19908 4202560 47442 0 0 0 702 14 0 0 16 0 11 0 67491685 904085504 105852 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 0 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1042] ppid=1026 vsize=882896 CPUtime=0
/proc/1039/task/1042/stat : 1042 (java) S 1026 1025 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 18 0 11 0 67491685 904085504 105852 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1043] ppid=1026 vsize=882896 CPUtime=0
/proc/1039/task/1043/stat : 1043 (java) S 1026 1025 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 67491685 904085504 105852 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1044] ppid=1026 vsize=882896 CPUtime=0
/proc/1039/task/1044/stat : 1044 (java) S 1026 1025 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 67491688 904085504 105852 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1045] ppid=1026 vsize=882896 CPUtime=2.19
/proc/1039/task/1045/stat : 1045 (java) S 1026 1025 19908 34817 19908 4202560 8670 0 0 0 215 4 0 0 15 0 11 0 67491688 904085504 105852 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1046] ppid=1026 vsize=882896 CPUtime=0.14
/proc/1039/task/1046/stat : 1046 (java) S 1026 1025 19908 34817 19908 4202560 1445 0 0 0 14 0 0 0 22 0 11 0 67491688 904085504 105852 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1047] ppid=1026 vsize=882896 CPUtime=0
/proc/1039/task/1047/stat : 1047 (java) S 1026 1025 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 67491688 904085504 105852 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1048] ppid=1026 vsize=882896 CPUtime=0
/proc/1039/task/1048/stat : 1048 (java) S 1026 1025 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 67491688 904085504 105852 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.68
Current children cumulated vsize (KiB) 888036

[startup+284.607 s]
/proc/loadavg: 1.01 1.01 1.00 2/46 1054
/proc/meminfo: memFree=211348/1048576 swapFree=0/0
[pid=1025] ppid=1024 vsize=2564 CPUtime=0
/proc/1025/stat : 1025 (p2cudf-user-1.1) S 1024 1025 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 25 0 1 0 67491679 2625536 269 1283457024 134512640 135304128 4293873856 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1025/statm: 641 269 230 194 0 28 0
[pid=1026] ppid=1025 vsize=2576 CPUtime=0.03
/proc/1026/stat : 1026 (p2cudf) S 1025 1025 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 67491679 2637824 281 1283457024 134512640 135304128 4287814448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/1026/statm: 644 281 239 194 0 31 0
[pid=1039] ppid=1026 vsize=882896 CPUtime=283.81
/proc/1039/stat : 1039 (java) S 1026 1025 19908 34817 19908 4202496 108919 0 1 0 28341 40 0 0 25 0 10 0 67491682 904085504 105854 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/1039/statm: 220724 105854 1789 10 0 217815 0
[pid=1039/tid=1040] ppid=1026 vsize=882896 CPUtime=274.13
/proc/1039/task/1040/stat : 1040 (java) S 1026 1025 19908 34817 19908 4202560 50276 0 1 0 27397 16 0 0 19 0 10 0 67491683 904085504 105854 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1041] ppid=1026 vsize=882896 CPUtime=7.16
/proc/1039/task/1041/stat : 1041 (java) S 1026 1025 19908 34817 19908 4202560 47442 0 0 0 702 14 0 0 16 0 10 0 67491685 904085504 105854 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 0 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1042] ppid=1026 vsize=882896 CPUtime=0
/proc/1039/task/1042/stat : 1042 (java) S 1026 1025 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 18 0 10 0 67491685 904085504 105854 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1043] ppid=1026 vsize=882896 CPUtime=0
/proc/1039/task/1043/stat : 1043 (java) S 1026 1025 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 10 0 67491685 904085504 105854 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1044] ppid=1026 vsize=882896 CPUtime=0
/proc/1039/task/1044/stat : 1044 (java) S 1026 1025 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 67491688 904085504 105854 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1045] ppid=1026 vsize=882896 CPUtime=2.27
/proc/1039/task/1045/stat : 1045 (java) S 1026 1025 19908 34817 19908 4202560 8670 0 0 0 223 4 0 0 16 0 10 0 67491688 904085504 105854 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1046] ppid=1026 vsize=882896 CPUtime=0.14
/proc/1039/task/1046/stat : 1046 (java) S 1026 1025 19908 34817 19908 4202560 1445 0 0 0 14 0 0 0 22 0 10 0 67491688 904085504 105854 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1047] ppid=1026 vsize=882896 CPUtime=0
/proc/1039/task/1047/stat : 1047 (java) S 1026 1025 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 10 0 67491688 904085504 105854 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
[pid=1039/tid=1048] ppid=1026 vsize=882896 CPUtime=0
/proc/1039/task/1048/stat : 1048 (java) S 1026 1025 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 10 0 67491688 904085504 105854 1283457024 134512640 134550932 4287795648 18446744073709551615 4294960130 0 4 0 16800975 18446612132933240640 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.84
Current children cumulated vsize (KiB) 888036

Child status: 0
Real time (s): 284.657
CPU time (s): 283.87
CPU user time (s): 283.43
CPU system time (s): 0.440027
CPU usage (%): 99.7235
Max. virtual memory (cumulated for all children) (KiB): 888036

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 283.43
system time used= 0.440027
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 112722
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= 5900
involuntary context switches= 8647

runsolver used 0 second user time and 0.008 second system time

The end