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/201108251442/p2cudf-paranoid-1.13/rand176.cudf.s-e-l-s-s.log.runsolver ./p2cudf-paranoid-1.13 /home/misc2010/data/2011/incremental/s-e-l-s-s//rand176.cudf /home/misc2010/tmp/201108251442/p2cudf-paranoid-1.13/rand176.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.84 0.69 0.32 5/35 5208
/proc/meminfo: memFree=292264/1048576 swapFree=0/0
[pid=5206] ppid=5205 vsize=2568 CPUtime=0
/proc/5206/stat : 5206 (p2cudf-paranoid) S 5205 5206 4778 34817 4778 4202496 376 0 0 0 0 0 0 0 23 0 1 0 9976501 2629632 271 1283457024 134512640 135304128 4290774544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5206/statm: 642 271 230 194 0 29 0
[pid=5207] ppid=5206 vsize=2568 CPUtime=0
/proc/5207/stat : 5207 (p2cudf) R 5206 5206 4778 34817 4778 4202496 347 0 0 0 0 0 0 0 25 0 1 0 9976501 2629632 272 1283457024 134512640 135304128 4292679680 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/5207/statm: 642 272 231 194 0 29 0
[pid=5208] ppid=5207 vsize=2568 CPUtime=0
/proc/5208/stat : 5208 (p2cudf) R 5207 5206 4778 34817 4778 4202560 0 0 0 0 0 0 0 0 25 0 1 0 9976502 2629632 41 1283457024 134512640 135304128 4292679680 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/5208/statm: 642 41 0 194 0 29 0

[startup+0.188677 s]
/proc/loadavg: 0.84 0.69 0.32 5/35 5208
/proc/meminfo: memFree=292264/1048576 swapFree=0/0
[pid=5206] ppid=5205 vsize=2568 CPUtime=0
/proc/5206/stat : 5206 (p2cudf-paranoid) S 5205 5206 4778 34817 4778 4202496 376 0 0 0 0 0 0 0 23 0 1 0 9976501 2629632 271 1283457024 134512640 135304128 4290774544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5206/statm: 642 271 230 194 0 29 0
[pid=5207] ppid=5206 vsize=2572 CPUtime=0.02
/proc/5207/stat : 5207 (p2cudf) S 5206 5206 4778 34817 4778 4202496 391 3017 0 1 0 0 2 0 25 0 1 0 9976501 2633728 281 1283457024 134512640 135304128 4292679680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5207/statm: 643 281 239 194 0 30 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5140

[startup+0.208685 s]
/proc/loadavg: 0.84 0.69 0.32 5/35 5208
/proc/meminfo: memFree=292264/1048576 swapFree=0/0
[pid=5206] ppid=5205 vsize=2568 CPUtime=0
/proc/5206/stat : 5206 (p2cudf-paranoid) S 5205 5206 4778 34817 4778 4202496 376 0 0 0 0 0 0 0 23 0 1 0 9976501 2629632 271 1283457024 134512640 135304128 4290774544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5206/statm: 642 271 230 194 0 29 0
[pid=5207] ppid=5206 vsize=2572 CPUtime=0.02
/proc/5207/stat : 5207 (p2cudf) S 5206 5206 4778 34817 4778 4202496 391 3017 0 1 0 0 2 0 25 0 1 0 9976501 2633728 281 1283457024 134512640 135304128 4292679680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5207/statm: 643 281 239 194 0 30 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5140

[startup+0.308707 s]
/proc/loadavg: 0.84 0.69 0.32 5/35 5208
/proc/meminfo: memFree=292264/1048576 swapFree=0/0
[pid=5206] ppid=5205 vsize=2568 CPUtime=0
/proc/5206/stat : 5206 (p2cudf-paranoid) S 5205 5206 4778 34817 4778 4202496 376 0 0 0 0 0 0 0 23 0 1 0 9976501 2629632 271 1283457024 134512640 135304128 4290774544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5206/statm: 642 271 230 194 0 29 0
[pid=5207] ppid=5206 vsize=2572 CPUtime=0.02
/proc/5207/stat : 5207 (p2cudf) S 5206 5206 4778 34817 4778 4202496 391 3017 0 1 0 0 2 0 25 0 1 0 9976501 2633728 281 1283457024 134512640 135304128 4292679680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5207/statm: 643 281 239 194 0 30 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5140

[startup+0.708795 s]
/proc/loadavg: 0.84 0.69 0.32 5/35 5208
/proc/meminfo: memFree=292264/1048576 swapFree=0/0
[pid=5206] ppid=5205 vsize=2568 CPUtime=0
/proc/5206/stat : 5206 (p2cudf-paranoid) S 5205 5206 4778 34817 4778 4202496 376 0 0 0 0 0 0 0 23 0 1 0 9976501 2629632 271 1283457024 134512640 135304128 4290774544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5206/statm: 642 271 230 194 0 29 0
[pid=5207] ppid=5206 vsize=2572 CPUtime=0.02
/proc/5207/stat : 5207 (p2cudf) S 5206 5206 4778 34817 4778 4202496 391 3017 0 1 0 0 2 0 25 0 1 0 9976501 2633728 281 1283457024 134512640 135304128 4292679680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5207/statm: 643 281 239 194 0 30 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5140

[startup+1.50899 s]
/proc/loadavg: 0.84 0.69 0.32 4/45 5229
/proc/meminfo: memFree=241556/1048576 swapFree=0/0
[pid=5206] ppid=5205 vsize=2568 CPUtime=0
/proc/5206/stat : 5206 (p2cudf-paranoid) S 5205 5206 4778 34817 4778 4202496 376 0 0 0 0 0 0 0 23 0 1 0 9976501 2629632 271 1283457024 134512640 135304128 4290774544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5206/statm: 642 271 230 194 0 29 0
[pid=5207] ppid=5206 vsize=2572 CPUtime=0.02
/proc/5207/stat : 5207 (p2cudf) S 5206 5206 4778 34817 4778 4202496 391 3017 0 1 0 0 2 0 25 0 1 0 9976501 2633728 281 1283457024 134512640 135304128 4292679680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5207/statm: 643 281 239 194 0 30 0
[pid=5220] ppid=5207 vsize=886904 CPUtime=1.47
/proc/5220/stat : 5220 (java) S 5207 5206 4778 34817 4778 4202496 19837 0 1 0 136 11 0 0 25 0 10 0 9976505 908189696 16654 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5220/statm: 221726 16654 1719 10 0 218817 0
[pid=5220/tid=5221] ppid=5207 vsize=886904 CPUtime=0.79
/proc/5220/task/5221/stat : 5221 (java) R 5207 5206 4778 34817 4778 4202560 8166 0 1 0 74 5 0 0 25 0 10 0 9976505 908189696 16654 1283457024 134512640 134550932 4294922416 18446744073709551615 4095608546 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5220/tid=5222] ppid=5207 vsize=886904 CPUtime=0
/proc/5220/task/5222/stat : 5222 (java) S 5207 5206 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 15 0 10 0 9976507 908189696 16654 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 0 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5223] ppid=5207 vsize=886904 CPUtime=0
/proc/5220/task/5223/stat : 5223 (java) S 5207 5206 4778 34817 4778 4202560 9 0 0 0 0 0 0 0 25 0 10 0 9976507 908189696 16654 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5224] ppid=5207 vsize=886904 CPUtime=0
/proc/5220/task/5224/stat : 5224 (java) S 5207 5206 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 10 0 9976507 908189696 16654 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5225] ppid=5207 vsize=886904 CPUtime=0
/proc/5220/task/5225/stat : 5225 (java) S 5207 5206 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 9976510 908189696 16654 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5226] ppid=5207 vsize=886904 CPUtime=0.5
/proc/5220/task/5226/stat : 5226 (java) R 5207 5206 4778 34817 4778 4202560 9114 0 0 0 46 4 0 0 25 0 10 0 9976510 908189696 16654 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5220/tid=5227] ppid=5207 vsize=886904 CPUtime=0.15
/proc/5220/task/5227/stat : 5227 (java) S 5207 5206 4778 34817 4778 4202560 1477 0 0 0 15 0 0 0 24 0 10 0 9976510 908189696 16654 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5228] ppid=5207 vsize=886904 CPUtime=0
/proc/5220/task/5228/stat : 5228 (java) S 5207 5206 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 9976510 908189696 16654 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5229] ppid=5207 vsize=886904 CPUtime=0
/proc/5220/task/5229/stat : 5229 (java) S 5207 5206 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 10 0 9976510 908189696 16654 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 1.49
Current children cumulated vsize (KiB) 892044

[startup+3.10929 s]
/proc/loadavg: 0.93 0.72 0.33 5/45 5229
/proc/meminfo: memFree=191956/1048576 swapFree=0/0
[pid=5206] ppid=5205 vsize=2568 CPUtime=0
/proc/5206/stat : 5206 (p2cudf-paranoid) S 5205 5206 4778 34817 4778 4202496 376 0 0 0 0 0 0 0 23 0 1 0 9976501 2629632 271 1283457024 134512640 135304128 4290774544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5206/statm: 642 271 230 194 0 29 0
[pid=5207] ppid=5206 vsize=2572 CPUtime=0.02
/proc/5207/stat : 5207 (p2cudf) S 5206 5206 4778 34817 4778 4202496 391 3017 0 1 0 0 2 0 25 0 1 0 9976501 2633728 281 1283457024 134512640 135304128 4292679680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5207/statm: 643 281 239 194 0 30 0
[pid=5220] ppid=5207 vsize=892468 CPUtime=3.07
/proc/5220/stat : 5220 (java) S 5207 5206 4778 34817 4778 4202496 64204 0 1 0 275 32 0 0 25 0 10 0 9976505 913887232 57649 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5220/statm: 223117 57649 1734 10 0 220208 0
[pid=5220/tid=5221] ppid=5207 vsize=892468 CPUtime=1.74
/proc/5220/task/5221/stat : 5221 (java) R 5207 5206 4778 34817 4778 4202560 47157 0 1 0 150 24 0 0 25 0 10 0 9976505 913887232 57649 1283457024 134512640 134550932 4294922416 18446744073709551615 4095866878 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5220/tid=5222] ppid=5207 vsize=892468 CPUtime=0
/proc/5220/task/5222/stat : 5222 (java) S 5207 5206 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 15 0 10 0 9976507 913887232 57649 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 0 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5223] ppid=5207 vsize=892468 CPUtime=0
/proc/5220/task/5223/stat : 5223 (java) S 5207 5206 4778 34817 4778 4202560 9 0 0 0 0 0 0 0 25 0 10 0 9976507 913887232 57649 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5224] ppid=5207 vsize=892468 CPUtime=0
/proc/5220/task/5224/stat : 5224 (java) S 5207 5206 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 10 0 9976507 913887232 57649 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5225] ppid=5207 vsize=892468 CPUtime=0
/proc/5220/task/5225/stat : 5225 (java) S 5207 5206 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 9976510 913887232 57649 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5226] ppid=5207 vsize=892468 CPUtime=0.63
/proc/5220/task/5226/stat : 5226 (java) S 5207 5206 4778 34817 4778 4202560 9466 0 0 0 59 4 0 0 25 0 10 0 9976510 913887232 57649 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5227] ppid=5207 vsize=892468 CPUtime=0.68
/proc/5220/task/5227/stat : 5227 (java) S 5207 5206 4778 34817 4778 4202560 6501 0 0 0 66 2 0 0 19 0 10 0 9976510 913887232 57649 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5228] ppid=5207 vsize=892468 CPUtime=0
/proc/5220/task/5228/stat : 5228 (java) S 5207 5206 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 9976510 913887232 57649 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5229] ppid=5207 vsize=892468 CPUtime=0
/proc/5220/task/5229/stat : 5229 (java) R 5207 5206 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 10 0 9976510 913887232 57649 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 3.09
Current children cumulated vsize (KiB) 897608

[startup+6.31026 s]
/proc/loadavg: 0.93 0.72 0.33 3/45 5229
/proc/meminfo: memFree=5896/1048576 swapFree=0/0
[pid=5206] ppid=5205 vsize=2568 CPUtime=0
/proc/5206/stat : 5206 (p2cudf-paranoid) S 5205 5206 4778 34817 4778 4202496 376 0 0 0 0 0 0 0 23 0 1 0 9976501 2629632 271 1283457024 134512640 135304128 4290774544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5206/statm: 642 271 230 194 0 29 0
[pid=5207] ppid=5206 vsize=2572 CPUtime=0.02
/proc/5207/stat : 5207 (p2cudf) S 5206 5206 4778 34817 4778 4202496 391 3017 0 1 0 0 2 0 25 0 1 0 9976501 2633728 281 1283457024 134512640 135304128 4292679680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5207/statm: 643 281 239 194 0 30 0
[pid=5220] ppid=5207 vsize=893188 CPUtime=6.23
/proc/5220/stat : 5220 (java) S 5207 5206 4778 34817 4778 4202496 96786 0 1 0 578 45 0 0 25 0 11 0 9976505 914624512 88947 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5220/statm: 223297 88947 1772 10 0 220388 0
[pid=5220/tid=5221] ppid=5207 vsize=893188 CPUtime=3.01
/proc/5220/task/5221/stat : 5221 (java) R 5207 5206 4778 34817 4778 4202560 50269 0 1 0 275 26 0 0 25 0 11 0 9976505 914624512 88947 1283457024 134512640 134550932 4294922416 18446744073709551615 4096566508 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5220/tid=5222] ppid=5207 vsize=893188 CPUtime=0.61
/proc/5220/task/5222/stat : 5222 (java) S 5207 5206 4778 34817 4778 4202560 27983 0 0 0 52 9 0 0 16 0 11 0 9976507 914624512 88947 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 0 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5223] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5223/stat : 5223 (java) S 5207 5206 4778 34817 4778 4202560 9 0 0 0 0 0 0 0 18 0 11 0 9976507 914624512 88947 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5224] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5224/stat : 5224 (java) S 5207 5206 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 9976507 914624512 88947 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5225] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5225/stat : 5225 (java) S 5207 5206 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 9976510 914624512 88947 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5226] ppid=5207 vsize=893188 CPUtime=0.63
/proc/5220/task/5226/stat : 5226 (java) S 5207 5206 4778 34817 4778 4202560 9466 0 0 0 59 4 0 0 25 0 11 0 9976510 914624512 88947 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5227] ppid=5207 vsize=893188 CPUtime=1.93
/proc/5220/task/5227/stat : 5227 (java) S 5207 5206 4778 34817 4778 4202560 7988 0 0 0 191 2 0 0 15 0 11 0 9976510 914624512 88947 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5228] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5228/stat : 5228 (java) S 5207 5206 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 9976510 914624512 88947 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5229] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5229/stat : 5229 (java) S 5207 5206 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 9976510 914624512 88947 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 6.25
Current children cumulated vsize (KiB) 898328

[startup+12.7117 s]
/proc/loadavg: 0.94 0.72 0.34 2/46 5230
/proc/meminfo: memFree=5152/1048576 swapFree=0/0
[pid=5206] ppid=5205 vsize=2568 CPUtime=0
/proc/5206/stat : 5206 (p2cudf-paranoid) S 5205 5206 4778 34817 4778 4202496 376 0 0 0 0 0 0 0 23 0 1 0 9976501 2629632 271 1283457024 134512640 135304128 4290774544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5206/statm: 642 271 230 194 0 29 0
[pid=5207] ppid=5206 vsize=2572 CPUtime=0.02
/proc/5207/stat : 5207 (p2cudf) S 5206 5206 4778 34817 4778 4202496 391 3017 0 1 0 0 2 0 25 0 1 0 9976501 2633728 281 1283457024 134512640 135304128 4292679680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5207/statm: 643 281 239 194 0 30 0
[pid=5220] ppid=5207 vsize=893188 CPUtime=12.63
/proc/5220/stat : 5220 (java) S 5207 5206 4778 34817 4778 4202496 96866 0 1 0 1218 45 0 0 25 0 11 0 9976505 914624512 89027 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5220/statm: 223297 89027 1783 10 0 220388 0
[pid=5220/tid=5221] ppid=5207 vsize=893188 CPUtime=8.9
/proc/5220/task/5221/stat : 5221 (java) R 5207 5206 4778 34817 4778 4202560 50279 0 1 0 864 26 0 0 25 0 11 0 9976505 914624512 89027 1283457024 134512640 134550932 4294922416 18446744073709551615 4096614288 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5220/tid=5222] ppid=5207 vsize=893188 CPUtime=0.61
/proc/5220/task/5222/stat : 5222 (java) S 5207 5206 4778 34817 4778 4202560 27983 0 0 0 52 9 0 0 15 0 11 0 9976507 914624512 89027 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 0 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5223] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5223/stat : 5223 (java) S 5207 5206 4778 34817 4778 4202560 9 0 0 0 0 0 0 0 18 0 11 0 9976507 914624512 89027 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5224] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5224/stat : 5224 (java) S 5207 5206 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 9976507 914624512 89027 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5225] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5225/stat : 5225 (java) S 5207 5206 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 9976510 914624512 89027 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5226] ppid=5207 vsize=893188 CPUtime=0.63
/proc/5220/task/5226/stat : 5226 (java) S 5207 5206 4778 34817 4778 4202560 9466 0 0 0 59 4 0 0 25 0 11 0 9976510 914624512 89027 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5227] ppid=5207 vsize=893188 CPUtime=2.43
/proc/5220/task/5227/stat : 5227 (java) S 5207 5206 4778 34817 4778 4202560 8058 0 0 0 241 2 0 0 15 0 11 0 9976510 914624512 89027 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5228] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5228/stat : 5228 (java) S 5207 5206 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 9976510 914624512 89027 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5229] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5229/stat : 5229 (java) S 5207 5206 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 9976510 914624512 89027 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5230] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5230/stat : 5230 (java) S 5207 5206 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 11 0 9977091 914624512 89027 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 12.65
Current children cumulated vsize (KiB) 898328

[startup+25.5147 s]
/proc/loadavg: 0.95 0.73 0.34 3/46 5230
/proc/meminfo: memFree=5908/1048576 swapFree=0/0
[pid=5206] ppid=5205 vsize=2568 CPUtime=0
/proc/5206/stat : 5206 (p2cudf-paranoid) S 5205 5206 4778 34817 4778 4202496 376 0 0 0 0 0 0 0 23 0 1 0 9976501 2629632 271 1283457024 134512640 135304128 4290774544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5206/statm: 642 271 230 194 0 29 0
[pid=5207] ppid=5206 vsize=2572 CPUtime=0.02
/proc/5207/stat : 5207 (p2cudf) S 5206 5206 4778 34817 4778 4202496 391 3017 0 1 0 0 2 0 25 0 1 0 9976501 2633728 281 1283457024 134512640 135304128 4292679680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5207/statm: 643 281 239 194 0 30 0
[pid=5220] ppid=5207 vsize=893188 CPUtime=25.42
/proc/5220/stat : 5220 (java) S 5207 5206 4778 34817 4778 4202496 105664 0 1 0 2493 49 0 0 25 0 11 0 9976505 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5220/statm: 223297 97825 1788 10 0 220388 0
[pid=5220/tid=5221] ppid=5207 vsize=893188 CPUtime=20.35
/proc/5220/task/5221/stat : 5221 (java) R 5207 5206 4778 34817 4778 4202560 50280 0 1 0 2007 28 0 0 25 0 11 0 9976505 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4096694599 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5220/tid=5222] ppid=5207 vsize=893188 CPUtime=1.84
/proc/5220/task/5222/stat : 5222 (java) S 5207 5206 4778 34817 4778 4202560 36761 0 0 0 172 12 0 0 16 0 11 0 9976507 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 0 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5223] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5223/stat : 5223 (java) S 5207 5206 4778 34817 4778 4202560 9 0 0 0 0 0 0 0 18 0 11 0 9976507 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5224] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5224/stat : 5224 (java) S 5207 5206 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 9976507 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5225] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5225/stat : 5225 (java) S 5207 5206 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5226] ppid=5207 vsize=893188 CPUtime=0.63
/proc/5220/task/5226/stat : 5226 (java) S 5207 5206 4778 34817 4778 4202560 9466 0 0 0 59 4 0 0 25 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5227] ppid=5207 vsize=893188 CPUtime=2.56
/proc/5220/task/5227/stat : 5227 (java) S 5207 5206 4778 34817 4778 4202560 8077 0 0 0 254 2 0 0 15 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5228] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5228/stat : 5228 (java) S 5207 5206 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5229] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5229/stat : 5229 (java) S 5207 5206 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5230] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5230/stat : 5230 (java) S 5207 5206 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 11 0 9977091 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 25.44
Current children cumulated vsize (KiB) 898328

[startup+51.1099 s]
/proc/loadavg: 1.05 0.77 0.37 3/46 5230
/proc/meminfo: memFree=5932/1048576 swapFree=0/0
[pid=5206] ppid=5205 vsize=2568 CPUtime=0
/proc/5206/stat : 5206 (p2cudf-paranoid) S 5205 5206 4778 34817 4778 4202496 376 0 0 0 0 0 0 0 23 0 1 0 9976501 2629632 271 1283457024 134512640 135304128 4290774544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5206/statm: 642 271 230 194 0 29 0
[pid=5207] ppid=5206 vsize=2572 CPUtime=0.02
/proc/5207/stat : 5207 (p2cudf) S 5206 5206 4778 34817 4778 4202496 391 3017 0 1 0 0 2 0 25 0 1 0 9976501 2633728 281 1283457024 134512640 135304128 4292679680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5207/statm: 643 281 239 194 0 30 0
[pid=5220] ppid=5207 vsize=893188 CPUtime=51
/proc/5220/stat : 5220 (java) S 5207 5206 4778 34817 4778 4202496 105664 0 1 0 5051 49 0 0 25 0 11 0 9976505 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5220/statm: 223297 97825 1788 10 0 220388 0
[pid=5220/tid=5221] ppid=5207 vsize=893188 CPUtime=44.3
/proc/5220/task/5221/stat : 5221 (java) R 5207 5206 4778 34817 4778 4202560 50280 0 1 0 4402 28 0 0 25 0 11 0 9976505 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4096613918 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5220/tid=5222] ppid=5207 vsize=893188 CPUtime=3.42
/proc/5220/task/5222/stat : 5222 (java) S 5207 5206 4778 34817 4778 4202560 36761 0 0 0 330 12 0 0 16 0 11 0 9976507 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 0 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5223] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5223/stat : 5223 (java) S 5207 5206 4778 34817 4778 4202560 9 0 0 0 0 0 0 0 18 0 11 0 9976507 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5224] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5224/stat : 5224 (java) S 5207 5206 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 9976507 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5225] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5225/stat : 5225 (java) S 5207 5206 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5226] ppid=5207 vsize=893188 CPUtime=0.63
/proc/5220/task/5226/stat : 5226 (java) S 5207 5206 4778 34817 4778 4202560 9466 0 0 0 59 4 0 0 25 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5227] ppid=5207 vsize=893188 CPUtime=2.6
/proc/5220/task/5227/stat : 5227 (java) S 5207 5206 4778 34817 4778 4202560 8077 0 0 0 258 2 0 0 15 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5228] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5228/stat : 5228 (java) S 5207 5206 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5229] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5229/stat : 5229 (java) S 5207 5206 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5230] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5230/stat : 5230 (java) S 5207 5206 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 11 0 9977091 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 51.02
Current children cumulated vsize (KiB) 898328

[startup+102.313 s]
/proc/loadavg: 1.02 0.81 0.40 2/46 5230
/proc/meminfo: memFree=5808/1048576 swapFree=0/0
[pid=5206] ppid=5205 vsize=2568 CPUtime=0
/proc/5206/stat : 5206 (p2cudf-paranoid) S 5205 5206 4778 34817 4778 4202496 376 0 0 0 0 0 0 0 23 0 1 0 9976501 2629632 271 1283457024 134512640 135304128 4290774544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5206/statm: 642 271 230 194 0 29 0
[pid=5207] ppid=5206 vsize=2572 CPUtime=0.02
/proc/5207/stat : 5207 (p2cudf) S 5206 5206 4778 34817 4778 4202496 391 3017 0 1 0 0 2 0 25 0 1 0 9976501 2633728 281 1283457024 134512640 135304128 4292679680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5207/statm: 643 281 239 194 0 30 0
[pid=5220] ppid=5207 vsize=893188 CPUtime=102.14
/proc/5220/stat : 5220 (java) S 5207 5206 4778 34817 4778 4202496 105664 0 1 0 10164 50 0 0 25 0 11 0 9976505 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5220/statm: 223297 97825 1788 10 0 220388 0
[pid=5220/tid=5221] ppid=5207 vsize=893188 CPUtime=92.46
/proc/5220/task/5221/stat : 5221 (java) R 5207 5206 4778 34817 4778 4202560 50280 0 1 0 9218 28 0 0 25 0 11 0 9976505 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4096692139 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5220/tid=5222] ppid=5207 vsize=893188 CPUtime=6.41
/proc/5220/task/5222/stat : 5222 (java) S 5207 5206 4778 34817 4778 4202560 36761 0 0 0 628 13 0 0 16 0 11 0 9976507 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 0 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5223] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5223/stat : 5223 (java) S 5207 5206 4778 34817 4778 4202560 9 0 0 0 0 0 0 0 18 0 11 0 9976507 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5224] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5224/stat : 5224 (java) S 5207 5206 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 9976507 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5225] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5225/stat : 5225 (java) S 5207 5206 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5226] ppid=5207 vsize=893188 CPUtime=0.63
/proc/5220/task/5226/stat : 5226 (java) S 5207 5206 4778 34817 4778 4202560 9466 0 0 0 59 4 0 0 25 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5227] ppid=5207 vsize=893188 CPUtime=2.6
/proc/5220/task/5227/stat : 5227 (java) S 5207 5206 4778 34817 4778 4202560 8077 0 0 0 258 2 0 0 15 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5228] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5228/stat : 5228 (java) S 5207 5206 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5229] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5229/stat : 5229 (java) S 5207 5206 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5230] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5230/stat : 5230 (java) S 5207 5206 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 11 0 9977091 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 102.16
Current children cumulated vsize (KiB) 898328

[startup+162.308 s]
/proc/loadavg: 1.00 0.84 0.43 2/46 5230
/proc/meminfo: memFree=5560/1048576 swapFree=0/0
[pid=5206] ppid=5205 vsize=2568 CPUtime=0
/proc/5206/stat : 5206 (p2cudf-paranoid) S 5205 5206 4778 34817 4778 4202496 376 0 0 0 0 0 0 0 23 0 1 0 9976501 2629632 271 1283457024 134512640 135304128 4290774544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5206/statm: 642 271 230 194 0 29 0
[pid=5207] ppid=5206 vsize=2572 CPUtime=0.02
/proc/5207/stat : 5207 (p2cudf) S 5206 5206 4778 34817 4778 4202496 391 3017 0 1 0 0 2 0 25 0 1 0 9976501 2633728 281 1283457024 134512640 135304128 4292679680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5207/statm: 643 281 239 194 0 30 0
[pid=5220] ppid=5207 vsize=893188 CPUtime=162.11
/proc/5220/stat : 5220 (java) S 5207 5206 4778 34817 4778 4202496 105664 0 1 0 16161 50 0 0 25 0 11 0 9976505 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5220/statm: 223297 97825 1788 10 0 220388 0
[pid=5220/tid=5221] ppid=5207 vsize=893188 CPUtime=149.04
/proc/5220/task/5221/stat : 5221 (java) R 5207 5206 4778 34817 4778 4202560 50280 0 1 0 14876 28 0 0 25 0 11 0 9976505 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4096596200 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5220/tid=5222] ppid=5207 vsize=893188 CPUtime=9.77
/proc/5220/task/5222/stat : 5222 (java) S 5207 5206 4778 34817 4778 4202560 36761 0 0 0 964 13 0 0 15 0 11 0 9976507 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 0 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5223] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5223/stat : 5223 (java) S 5207 5206 4778 34817 4778 4202560 9 0 0 0 0 0 0 0 18 0 11 0 9976507 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5224] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5224/stat : 5224 (java) S 5207 5206 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 9976507 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5225] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5225/stat : 5225 (java) S 5207 5206 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5226] ppid=5207 vsize=893188 CPUtime=0.63
/proc/5220/task/5226/stat : 5226 (java) S 5207 5206 4778 34817 4778 4202560 9466 0 0 0 59 4 0 0 25 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5227] ppid=5207 vsize=893188 CPUtime=2.62
/proc/5220/task/5227/stat : 5227 (java) S 5207 5206 4778 34817 4778 4202560 8077 0 0 0 260 2 0 0 15 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5228] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5228/stat : 5228 (java) S 5207 5206 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5229] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5229/stat : 5229 (java) S 5207 5206 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5230] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5230/stat : 5230 (java) S 5207 5206 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 11 0 9977091 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 162.13
Current children cumulated vsize (KiB) 898328

[startup+222.304 s]
/proc/loadavg: 1.03 0.88 0.47 2/48 5235
/proc/meminfo: memFree=5412/1048576 swapFree=0/0
[pid=5206] ppid=5205 vsize=2568 CPUtime=0
/proc/5206/stat : 5206 (p2cudf-paranoid) S 5205 5206 4778 34817 4778 4202496 376 0 0 0 0 0 0 0 23 0 1 0 9976501 2629632 271 1283457024 134512640 135304128 4290774544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5206/statm: 642 271 230 194 0 29 0
[pid=5207] ppid=5206 vsize=2572 CPUtime=0.02
/proc/5207/stat : 5207 (p2cudf) S 5206 5206 4778 34817 4778 4202496 391 3017 0 1 0 0 2 0 25 0 1 0 9976501 2633728 281 1283457024 134512640 135304128 4292679680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5207/statm: 643 281 239 194 0 30 0
[pid=5220] ppid=5207 vsize=893188 CPUtime=222.06
/proc/5220/stat : 5220 (java) S 5207 5206 4778 34817 4778 4202496 105664 0 1 0 22154 52 0 0 25 0 11 0 9976505 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5220/statm: 223297 97825 1788 10 0 220388 0
[pid=5220/tid=5221] ppid=5207 vsize=893188 CPUtime=206.79
/proc/5220/task/5221/stat : 5221 (java) R 5207 5206 4778 34817 4778 4202560 50280 0 1 0 20649 30 0 0 25 0 11 0 9976505 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4095720202 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5220/tid=5222] ppid=5207 vsize=893188 CPUtime=11.99
/proc/5220/task/5222/stat : 5222 (java) S 5207 5206 4778 34817 4778 4202560 36761 0 0 0 1186 13 0 0 16 0 11 0 9976507 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 0 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5223] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5223/stat : 5223 (java) S 5207 5206 4778 34817 4778 4202560 9 0 0 0 0 0 0 0 18 0 11 0 9976507 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5224] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5224/stat : 5224 (java) S 5207 5206 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 9976507 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5225] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5225/stat : 5225 (java) S 5207 5206 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5226] ppid=5207 vsize=893188 CPUtime=0.63
/proc/5220/task/5226/stat : 5226 (java) S 5207 5206 4778 34817 4778 4202560 9466 0 0 0 59 4 0 0 25 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5227] ppid=5207 vsize=893188 CPUtime=2.62
/proc/5220/task/5227/stat : 5227 (java) S 5207 5206 4778 34817 4778 4202560 8077 0 0 0 260 2 0 0 15 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5228] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5228/stat : 5228 (java) S 5207 5206 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5229] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5229/stat : 5229 (java) S 5207 5206 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5230] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5230/stat : 5230 (java) S 5207 5206 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 11 0 9977091 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 222.08
Current children cumulated vsize (KiB) 898328

[startup+282.308 s]
/proc/loadavg: 1.01 0.90 0.50 2/48 5241
/proc/meminfo: memFree=5412/1048576 swapFree=0/0
[pid=5206] ppid=5205 vsize=2568 CPUtime=0
/proc/5206/stat : 5206 (p2cudf-paranoid) S 5205 5206 4778 34817 4778 4202496 376 0 0 0 0 0 0 0 23 0 1 0 9976501 2629632 271 1283457024 134512640 135304128 4290774544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5206/statm: 642 271 230 194 0 29 0
[pid=5207] ppid=5206 vsize=2572 CPUtime=0.02
/proc/5207/stat : 5207 (p2cudf) S 5206 5206 4778 34817 4778 4202496 391 3017 0 1 0 0 2 0 25 0 1 0 9976501 2633728 281 1283457024 134512640 135304128 4292679680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5207/statm: 643 281 239 194 0 30 0
[pid=5220] ppid=5207 vsize=893188 CPUtime=282.05
/proc/5220/stat : 5220 (java) S 5207 5206 4778 34817 4778 4202496 105664 0 1 0 28153 52 0 0 25 0 11 0 9976505 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5220/statm: 223297 97825 1788 10 0 220388 0
[pid=5220/tid=5221] ppid=5207 vsize=893188 CPUtime=264.88
/proc/5220/task/5221/stat : 5221 (java) R 5207 5206 4778 34817 4778 4202560 50280 0 1 0 26458 30 0 0 25 0 11 0 9976505 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4096646250 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5220/tid=5222] ppid=5207 vsize=893188 CPUtime=13.87
/proc/5220/task/5222/stat : 5222 (java) S 5207 5206 4778 34817 4778 4202560 36761 0 0 0 1374 13 0 0 15 0 11 0 9976507 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 0 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5223] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5223/stat : 5223 (java) S 5207 5206 4778 34817 4778 4202560 9 0 0 0 0 0 0 0 18 0 11 0 9976507 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5224] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5224/stat : 5224 (java) S 5207 5206 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 9976507 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5225] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5225/stat : 5225 (java) S 5207 5206 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5226] ppid=5207 vsize=893188 CPUtime=0.63
/proc/5220/task/5226/stat : 5226 (java) S 5207 5206 4778 34817 4778 4202560 9466 0 0 0 59 4 0 0 25 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5227] ppid=5207 vsize=893188 CPUtime=2.62
/proc/5220/task/5227/stat : 5227 (java) S 5207 5206 4778 34817 4778 4202560 8077 0 0 0 260 2 0 0 15 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5228] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5228/stat : 5228 (java) S 5207 5206 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5229] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5229/stat : 5229 (java) S 5207 5206 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5230] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5230/stat : 5230 (java) S 5207 5206 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 11 0 9977091 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 282.07
Current children cumulated vsize (KiB) 898328

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

[startup+284.809 s]
/proc/loadavg: 1.01 0.90 0.50 2/48 5241
/proc/meminfo: memFree=5412/1048576 swapFree=0/0
[pid=5206] ppid=5205 vsize=2568 CPUtime=0
/proc/5206/stat : 5206 (p2cudf-paranoid) S 5205 5206 4778 34817 4778 4202496 376 0 0 0 0 0 0 0 23 0 1 0 9976501 2629632 271 1283457024 134512640 135304128 4290774544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5206/statm: 642 271 230 194 0 29 0
[pid=5207] ppid=5206 vsize=2572 CPUtime=0.02
/proc/5207/stat : 5207 (p2cudf) S 5206 5206 4778 34817 4778 4202496 391 3017 0 1 0 0 2 0 25 0 1 0 9976501 2633728 281 1283457024 134512640 135304128 4292679680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5207/statm: 643 281 239 194 0 30 0
[pid=5220] ppid=5207 vsize=893188 CPUtime=284.55
/proc/5220/stat : 5220 (java) S 5207 5206 4778 34817 4778 4202496 105664 0 1 0 28402 53 0 0 25 0 11 0 9976505 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5220/statm: 223297 97825 1788 10 0 220388 0
[pid=5220/tid=5221] ppid=5207 vsize=893188 CPUtime=267.39
/proc/5220/task/5221/stat : 5221 (java) R 5207 5206 4778 34817 4778 4202560 50280 0 1 0 26708 31 0 0 25 0 11 0 9976505 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4096595091 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5220/tid=5222] ppid=5207 vsize=893188 CPUtime=13.87
/proc/5220/task/5222/stat : 5222 (java) S 5207 5206 4778 34817 4778 4202560 36761 0 0 0 1374 13 0 0 15 0 11 0 9976507 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 0 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5223] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5223/stat : 5223 (java) S 5207 5206 4778 34817 4778 4202560 9 0 0 0 0 0 0 0 18 0 11 0 9976507 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5224] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5224/stat : 5224 (java) S 5207 5206 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 9976507 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5225] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5225/stat : 5225 (java) S 5207 5206 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5226] ppid=5207 vsize=893188 CPUtime=0.63
/proc/5220/task/5226/stat : 5226 (java) S 5207 5206 4778 34817 4778 4202560 9466 0 0 0 59 4 0 0 25 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5227] ppid=5207 vsize=893188 CPUtime=2.62
/proc/5220/task/5227/stat : 5227 (java) S 5207 5206 4778 34817 4778 4202560 8077 0 0 0 260 2 0 0 15 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5228] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5228/stat : 5228 (java) S 5207 5206 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5229] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5229/stat : 5229 (java) S 5207 5206 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5230] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5230/stat : 5230 (java) S 5207 5206 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 11 0 9977091 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 284.57
Current children cumulated vsize (KiB) 898328

[startup+285.609 s]
/proc/loadavg: 1.01 0.90 0.50 2/48 5241
/proc/meminfo: memFree=5412/1048576 swapFree=0/0
[pid=5206] ppid=5205 vsize=2568 CPUtime=0
/proc/5206/stat : 5206 (p2cudf-paranoid) S 5205 5206 4778 34817 4778 4202496 376 0 0 0 0 0 0 0 23 0 1 0 9976501 2629632 271 1283457024 134512640 135304128 4290774544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5206/statm: 642 271 230 194 0 29 0
[pid=5207] ppid=5206 vsize=2572 CPUtime=0.02
/proc/5207/stat : 5207 (p2cudf) S 5206 5206 4778 34817 4778 4202496 391 3017 0 1 0 0 2 0 25 0 1 0 9976501 2633728 281 1283457024 134512640 135304128 4292679680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5207/statm: 643 281 239 194 0 30 0
[pid=5220] ppid=5207 vsize=893188 CPUtime=285.35
/proc/5220/stat : 5220 (java) S 5207 5206 4778 34817 4778 4202496 105664 0 1 0 28482 53 0 0 25 0 11 0 9976505 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5220/statm: 223297 97825 1788 10 0 220388 0
[pid=5220/tid=5221] ppid=5207 vsize=893188 CPUtime=268.19
/proc/5220/task/5221/stat : 5221 (java) R 5207 5206 4778 34817 4778 4202560 50280 0 1 0 26788 31 0 0 25 0 11 0 9976505 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4096621457 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5220/tid=5222] ppid=5207 vsize=893188 CPUtime=13.87
/proc/5220/task/5222/stat : 5222 (java) S 5207 5206 4778 34817 4778 4202560 36761 0 0 0 1374 13 0 0 15 0 11 0 9976507 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 0 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5223] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5223/stat : 5223 (java) S 5207 5206 4778 34817 4778 4202560 9 0 0 0 0 0 0 0 18 0 11 0 9976507 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5224] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5224/stat : 5224 (java) S 5207 5206 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 9976507 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5225] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5225/stat : 5225 (java) S 5207 5206 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5226] ppid=5207 vsize=893188 CPUtime=0.63
/proc/5220/task/5226/stat : 5226 (java) S 5207 5206 4778 34817 4778 4202560 9466 0 0 0 59 4 0 0 25 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5227] ppid=5207 vsize=893188 CPUtime=2.62
/proc/5220/task/5227/stat : 5227 (java) S 5207 5206 4778 34817 4778 4202560 8077 0 0 0 260 2 0 0 15 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5228] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5228/stat : 5228 (java) S 5207 5206 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5229] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5229/stat : 5229 (java) S 5207 5206 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 9976510 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5230] ppid=5207 vsize=893188 CPUtime=0
/proc/5220/task/5230/stat : 5230 (java) S 5207 5206 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 11 0 9977091 914624512 97825 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 285.37
Current children cumulated vsize (KiB) 898328

[startup+286.002 s]
/proc/loadavg: 1.01 0.90 0.50 1/48 5242
/proc/meminfo: memFree=5288/1048576 swapFree=0/0
[pid=5206] ppid=5205 vsize=2568 CPUtime=0
/proc/5206/stat : 5206 (p2cudf-paranoid) S 5205 5206 4778 34817 4778 4202496 376 0 0 0 0 0 0 0 23 0 1 0 9976501 2629632 271 1283457024 134512640 135304128 4290774544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5206/statm: 642 271 230 194 0 29 0
[pid=5207] ppid=5206 vsize=2572 CPUtime=0.02
/proc/5207/stat : 5207 (p2cudf) S 5206 5206 4778 34817 4778 4202496 391 3017 0 1 0 0 2 0 25 0 1 0 9976501 2633728 281 1283457024 134512640 135304128 4292679680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5207/statm: 643 281 239 194 0 30 0
[pid=5220] ppid=5207 vsize=893512 CPUtime=285.69
/proc/5220/stat : 5220 (java) S 5207 5206 4778 34817 4778 4202496 105677 0 1 0 28516 53 0 0 25 0 11 0 9976505 914956288 97838 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5220/statm: 223378 97838 1789 10 0 220469 0
[pid=5220/tid=5221] ppid=5207 vsize=893512 CPUtime=268.49
/proc/5220/task/5221/stat : 5221 (java) S 5207 5206 4778 34817 4778 4202560 50288 0 1 0 26818 31 0 0 25 0 11 0 9976505 914956288 97838 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5222] ppid=5207 vsize=893512 CPUtime=13.87
/proc/5220/task/5222/stat : 5222 (java) S 5207 5206 4778 34817 4778 4202560 36761 0 0 0 1374 13 0 0 16 0 11 0 9976507 914956288 97838 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 0 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5223] ppid=5207 vsize=893512 CPUtime=0
/proc/5220/task/5223/stat : 5223 (java) S 5207 5206 4778 34817 4778 4202560 9 0 0 0 0 0 0 0 18 0 11 0 9976507 914956288 97838 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5224] ppid=5207 vsize=893512 CPUtime=0
/proc/5220/task/5224/stat : 5224 (java) S 5207 5206 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 9976507 914956288 97838 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5225] ppid=5207 vsize=893512 CPUtime=0
/proc/5220/task/5225/stat : 5225 (java) S 5207 5206 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 9976510 914956288 97838 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5226] ppid=5207 vsize=893512 CPUtime=0.63
/proc/5220/task/5226/stat : 5226 (java) S 5207 5206 4778 34817 4778 4202560 9466 0 0 0 59 4 0 0 25 0 11 0 9976510 914956288 97838 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5227] ppid=5207 vsize=893512 CPUtime=2.66
/proc/5220/task/5227/stat : 5227 (java) S 5207 5206 4778 34817 4778 4202560 8077 0 0 0 264 2 0 0 15 0 11 0 9976510 914956288 97838 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5228] ppid=5207 vsize=893512 CPUtime=0
/proc/5220/task/5228/stat : 5228 (java) S 5207 5206 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 9976510 914956288 97838 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5229] ppid=5207 vsize=893512 CPUtime=0
/proc/5220/task/5229/stat : 5229 (java) S 5207 5206 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 9976510 914956288 97838 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5242] ppid=5207 vsize=893512 CPUtime=0
/proc/5220/task/5242/stat : 5242 (java) S 5207 5206 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 11 0 10005096 914956288 97838 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 285.71
Current children cumulated vsize (KiB) 898652

[startup+286.406 s]
/proc/loadavg: 1.01 0.90 0.50 1/48 5242
/proc/meminfo: memFree=5288/1048576 swapFree=0/0
[pid=5206] ppid=5205 vsize=2568 CPUtime=0
/proc/5206/stat : 5206 (p2cudf-paranoid) S 5205 5206 4778 34817 4778 4202496 376 0 0 0 0 0 0 0 23 0 1 0 9976501 2629632 271 1283457024 134512640 135304128 4290774544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5206/statm: 642 271 230 194 0 29 0
[pid=5207] ppid=5206 vsize=2572 CPUtime=0.02
/proc/5207/stat : 5207 (p2cudf) S 5206 5206 4778 34817 4778 4202496 391 3017 0 1 0 0 2 0 25 0 1 0 9976501 2633728 281 1283457024 134512640 135304128 4292679680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5207/statm: 643 281 239 194 0 30 0
[pid=5220] ppid=5207 vsize=893512 CPUtime=285.69
/proc/5220/stat : 5220 (java) S 5207 5206 4778 34817 4778 4202496 105677 0 1 0 28516 53 0 0 25 0 11 0 9976505 914956288 97838 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5220/statm: 223378 97838 1789 10 0 220469 0
[pid=5220/tid=5221] ppid=5207 vsize=893512 CPUtime=268.49
/proc/5220/task/5221/stat : 5221 (java) S 5207 5206 4778 34817 4778 4202560 50288 0 1 0 26818 31 0 0 25 0 11 0 9976505 914956288 97838 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5222] ppid=5207 vsize=893512 CPUtime=13.87
/proc/5220/task/5222/stat : 5222 (java) S 5207 5206 4778 34817 4778 4202560 36761 0 0 0 1374 13 0 0 16 0 11 0 9976507 914956288 97838 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 0 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5223] ppid=5207 vsize=893512 CPUtime=0
/proc/5220/task/5223/stat : 5223 (java) S 5207 5206 4778 34817 4778 4202560 9 0 0 0 0 0 0 0 18 0 11 0 9976507 914956288 97838 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5224] ppid=5207 vsize=893512 CPUtime=0
/proc/5220/task/5224/stat : 5224 (java) S 5207 5206 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 9976507 914956288 97838 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5225] ppid=5207 vsize=893512 CPUtime=0
/proc/5220/task/5225/stat : 5225 (java) S 5207 5206 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 9976510 914956288 97838 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5226] ppid=5207 vsize=893512 CPUtime=0.63
/proc/5220/task/5226/stat : 5226 (java) S 5207 5206 4778 34817 4778 4202560 9466 0 0 0 59 4 0 0 25 0 11 0 9976510 914956288 97838 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5227] ppid=5207 vsize=893512 CPUtime=2.66
/proc/5220/task/5227/stat : 5227 (java) S 5207 5206 4778 34817 4778 4202560 8077 0 0 0 264 2 0 0 15 0 11 0 9976510 914956288 97838 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5228] ppid=5207 vsize=893512 CPUtime=0
/proc/5220/task/5228/stat : 5228 (java) S 5207 5206 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 9976510 914956288 97838 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5229] ppid=5207 vsize=893512 CPUtime=0
/proc/5220/task/5229/stat : 5229 (java) S 5207 5206 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 9976510 914956288 97838 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5242] ppid=5207 vsize=893512 CPUtime=0
/proc/5220/task/5242/stat : 5242 (java) S 5207 5206 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 11 0 10005096 914956288 97838 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 285.71
Current children cumulated vsize (KiB) 898652

[startup+286.51 s]
/proc/loadavg: 1.01 0.90 0.50 1/48 5242
/proc/meminfo: memFree=5288/1048576 swapFree=0/0
[pid=5206] ppid=5205 vsize=2568 CPUtime=0
/proc/5206/stat : 5206 (p2cudf-paranoid) S 5205 5206 4778 34817 4778 4202496 376 0 0 0 0 0 0 0 23 0 1 0 9976501 2629632 271 1283457024 134512640 135304128 4290774544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5206/statm: 642 271 230 194 0 29 0
[pid=5207] ppid=5206 vsize=2572 CPUtime=0.02
/proc/5207/stat : 5207 (p2cudf) S 5206 5206 4778 34817 4778 4202496 391 3017 0 1 0 0 2 0 25 0 1 0 9976501 2633728 281 1283457024 134512640 135304128 4292679680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5207/statm: 643 281 239 194 0 30 0
[pid=5220] ppid=5207 vsize=893512 CPUtime=285.74
/proc/5220/stat : 5220 (java) S 5207 5206 4778 34817 4778 4202496 105678 0 1 0 28520 54 0 0 25 0 11 0 9976505 914956288 97839 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5220/statm: 223378 97839 1789 10 0 220469 0
[pid=5220/tid=5221] ppid=5207 vsize=893512 CPUtime=268.49
/proc/5220/task/5221/stat : 5221 (java) S 5207 5206 4778 34817 4778 4202560 50288 0 1 0 26818 31 0 0 25 0 11 0 9976505 914956288 97839 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5222] ppid=5207 vsize=893512 CPUtime=13.87
/proc/5220/task/5222/stat : 5222 (java) S 5207 5206 4778 34817 4778 4202560 36761 0 0 0 1374 13 0 0 16 0 11 0 9976507 914956288 97839 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 0 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5223] ppid=5207 vsize=893512 CPUtime=0
/proc/5220/task/5223/stat : 5223 (java) S 5207 5206 4778 34817 4778 4202560 9 0 0 0 0 0 0 0 18 0 11 0 9976507 914956288 97839 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5224] ppid=5207 vsize=893512 CPUtime=0
/proc/5220/task/5224/stat : 5224 (java) S 5207 5206 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 9976507 914956288 97839 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5225] ppid=5207 vsize=893512 CPUtime=0
/proc/5220/task/5225/stat : 5225 (java) S 5207 5206 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 9976510 914956288 97839 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5226] ppid=5207 vsize=893512 CPUtime=0.63
/proc/5220/task/5226/stat : 5226 (java) S 5207 5206 4778 34817 4778 4202560 9466 0 0 0 59 4 0 0 25 0 11 0 9976510 914956288 97839 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5227] ppid=5207 vsize=893512 CPUtime=2.66
/proc/5220/task/5227/stat : 5227 (java) S 5207 5206 4778 34817 4778 4202560 8077 0 0 0 264 2 0 0 15 0 11 0 9976510 914956288 97839 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5228] ppid=5207 vsize=893512 CPUtime=0
/proc/5220/task/5228/stat : 5228 (java) S 5207 5206 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 9976510 914956288 97839 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5229] ppid=5207 vsize=893512 CPUtime=0
/proc/5220/task/5229/stat : 5229 (java) S 5207 5206 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 9976510 914956288 97839 1283457024 134512640 134550932 4294922416 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=5220/tid=5242] ppid=5207 vsize=893512 CPUtime=0.04
/proc/5220/task/5242/stat : 5242 (java) R 5207 5206 4778 34817 4778 4202560 5 0 0 0 4 0 0 0 20 0 11 0 10005096 914956288 97839 1283457024 134512640 134550932 4294922416 18446744073709551615 4095586788 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 285.76
Current children cumulated vsize (KiB) 898652

Child status: 0
Real time (s): 286.607
CPU time (s): 285.862
CPU user time (s): 285.27
CPU system time (s): 0.592037
CPU usage (%): 99.74
Max. virtual memory (cumulated for all children) (KiB): 902868

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 285.27
system time used= 0.592037
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 109489
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= 6017
involuntary context switches= 8914

runsolver used 0 second user time and 0.008 second system time

The end