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/dd08e73e-d489-11df-b9cf-00163e3d3b7c.cudf.dudf-real.log.runsolver ./p2cudf-user-1.13 /home/misc2010/data/2011/dudf-real//dd08e73e-d489-11df-b9cf-00163e3d3b7c.cudf /home/misc2010/tmp/201108311143/p2cudf-user-1.13/dd08e73e-d489-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: 1.07 1.00 1.00 5/36 2563
/proc/meminfo: memFree=463540/1048576 swapFree=0/0
[pid=2560] ppid=2559 vsize=2568 CPUtime=0
/proc/2560/stat : 2560 (p2cudf-user-1.1) S 2559 2560 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 18 0 1 0 68246526 2629632 269 1283457024 134512640 135304128 4290903536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2560/statm: 642 269 230 194 0 29 0
[pid=2561] ppid=2560 vsize=2568 CPUtime=0
/proc/2561/stat : 2561 (p2cudf) S 2560 2560 19908 34817 19908 4202496 352 0 0 0 0 0 0 0 18 0 1 0 68246526 2629632 271 1283457024 134512640 135304128 4286577152 18446744073709551615 4294960130 0 0 4 65536 18446744071564457842 0 0 17 0 0 0 0
/proc/2561/statm: 642 271 231 194 0 29 0
[pid=2562] ppid=2561 vsize=2568 CPUtime=0
/proc/2562/stat : 2562 (p2cudf) R 2561 2560 19908 34817 19908 4202560 94 0 0 0 0 0 0 0 25 0 1 0 68246526 2629632 118 1283457024 134512640 135304128 4286577152 18446744073709551615 4294960130 0 65538 0 65538 0 0 0 17 0 0 0 0
/proc/2562/statm: 642 118 77 194 0 29 0
[pid=2563] ppid=2562 vsize=2568 CPUtime=0
/proc/2563/stat : 2563 (p2cudf) R 2562 2560 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 1 0 68246526 2629632 41 1283457024 134512640 135304128 4286577152 18446744073709551615 4294960130 0 65538 0 65538 0 0 0 17 0 0 0 0
/proc/2563/statm: 642 41 0 194 0 29 0

[startup+0.205211 s]
/proc/loadavg: 1.07 1.00 1.00 5/36 2563
/proc/meminfo: memFree=463540/1048576 swapFree=0/0
[pid=2560] ppid=2559 vsize=2568 CPUtime=0
/proc/2560/stat : 2560 (p2cudf-user-1.1) S 2559 2560 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 18 0 1 0 68246526 2629632 269 1283457024 134512640 135304128 4290903536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2560/statm: 642 269 230 194 0 29 0
[pid=2561] ppid=2560 vsize=2576 CPUtime=0.02
/proc/2561/stat : 2561 (p2cudf) S 2560 2560 19908 34817 19908 4202496 393 3016 0 1 0 0 2 0 25 0 1 0 68246526 2637824 281 1283457024 134512640 135304128 4286577152 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2561/statm: 644 281 239 194 0 31 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5144

[startup+0.305282 s]
/proc/loadavg: 1.07 1.00 1.00 5/36 2563
/proc/meminfo: memFree=463540/1048576 swapFree=0/0
[pid=2560] ppid=2559 vsize=2568 CPUtime=0
/proc/2560/stat : 2560 (p2cudf-user-1.1) S 2559 2560 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 18 0 1 0 68246526 2629632 269 1283457024 134512640 135304128 4290903536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2560/statm: 642 269 230 194 0 29 0
[pid=2561] ppid=2560 vsize=2576 CPUtime=0.02
/proc/2561/stat : 2561 (p2cudf) S 2560 2560 19908 34817 19908 4202496 393 3016 0 1 0 0 2 0 25 0 1 0 68246526 2637824 281 1283457024 134512640 135304128 4286577152 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2561/statm: 644 281 239 194 0 31 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5144

[startup+0.405265 s]
/proc/loadavg: 1.07 1.00 1.00 5/36 2563
/proc/meminfo: memFree=463540/1048576 swapFree=0/0
[pid=2560] ppid=2559 vsize=2568 CPUtime=0
/proc/2560/stat : 2560 (p2cudf-user-1.1) S 2559 2560 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 18 0 1 0 68246526 2629632 269 1283457024 134512640 135304128 4290903536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2560/statm: 642 269 230 194 0 29 0
[pid=2561] ppid=2560 vsize=2576 CPUtime=0.02
/proc/2561/stat : 2561 (p2cudf) S 2560 2560 19908 34817 19908 4202496 393 3016 0 1 0 0 2 0 25 0 1 0 68246526 2637824 281 1283457024 134512640 135304128 4286577152 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2561/statm: 644 281 239 194 0 31 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5144

[startup+0.705352 s]
/proc/loadavg: 1.07 1.00 1.00 5/36 2563
/proc/meminfo: memFree=463540/1048576 swapFree=0/0
[pid=2560] ppid=2559 vsize=2568 CPUtime=0
/proc/2560/stat : 2560 (p2cudf-user-1.1) S 2559 2560 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 18 0 1 0 68246526 2629632 269 1283457024 134512640 135304128 4290903536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2560/statm: 642 269 230 194 0 29 0
[pid=2561] ppid=2560 vsize=2576 CPUtime=0.02
/proc/2561/stat : 2561 (p2cudf) S 2560 2560 19908 34817 19908 4202496 393 3016 0 1 0 0 2 0 25 0 1 0 68246526 2637824 281 1283457024 134512640 135304128 4286577152 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2561/statm: 644 281 239 194 0 31 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5144

[startup+1.50739 s]
/proc/loadavg: 1.07 1.00 1.00 4/45 2583
/proc/meminfo: memFree=413556/1048576 swapFree=0/0
[pid=2560] ppid=2559 vsize=2568 CPUtime=0
/proc/2560/stat : 2560 (p2cudf-user-1.1) S 2559 2560 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 18 0 1 0 68246526 2629632 269 1283457024 134512640 135304128 4290903536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2560/statm: 642 269 230 194 0 29 0
[pid=2561] ppid=2560 vsize=2576 CPUtime=0.02
/proc/2561/stat : 2561 (p2cudf) S 2560 2560 19908 34817 19908 4202496 393 3016 0 1 0 0 2 0 25 0 1 0 68246526 2637824 281 1283457024 134512640 135304128 4286577152 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2561/statm: 644 281 239 194 0 31 0
[pid=2574] ppid=2561 vsize=886076 CPUtime=1.45
/proc/2574/stat : 2574 (java) S 2561 2560 19908 34817 19908 4202496 21423 0 1 0 137 8 0 0 25 0 10 0 68246530 907341824 18503 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/2574/statm: 221519 18503 1740 10 0 218610 0
[pid=2574/tid=2575] ppid=2561 vsize=886076 CPUtime=0.69
/proc/2574/task/2575/stat : 2575 (java) R 2561 2560 19908 34817 19908 4202560 9827 0 1 0 65 4 0 0 25 0 10 0 68246530 907341824 18503 1283457024 134512640 134550932 4286636208 18446744073709551615 4094961567 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=2574/tid=2576] ppid=2561 vsize=886076 CPUtime=0
/proc/2574/task/2576/stat : 2576 (java) S 2561 2560 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 10 0 68246532 907341824 18503 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2577] ppid=2561 vsize=886076 CPUtime=0
/proc/2574/task/2577/stat : 2577 (java) S 2561 2560 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 25 0 10 0 68246532 907341824 18503 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2578] ppid=2561 vsize=886076 CPUtime=0
/proc/2574/task/2578/stat : 2578 (java) S 2561 2560 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 10 0 68246532 907341824 18503 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2579] ppid=2561 vsize=886076 CPUtime=0
/proc/2574/task/2579/stat : 2579 (java) S 2561 2560 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 68246535 907341824 18503 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2580] ppid=2561 vsize=886076 CPUtime=0.47
/proc/2574/task/2580/stat : 2580 (java) R 2561 2560 19908 34817 19908 4202560 5084 0 0 0 45 2 0 0 25 0 10 0 68246535 907341824 18503 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=2574/tid=2581] ppid=2561 vsize=886076 CPUtime=0.28
/proc/2574/task/2581/stat : 2581 (java) R 2561 2560 19908 34817 19908 4202560 5433 0 0 0 26 2 0 0 22 0 10 0 68246535 907341824 18503 1283457024 134512640 134550932 4286636208 18446744073709551615 4149529458 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=2574/tid=2582] ppid=2561 vsize=886076 CPUtime=0
/proc/2574/task/2582/stat : 2582 (java) S 2561 2560 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 10 0 68246535 907341824 18503 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2583] ppid=2561 vsize=886076 CPUtime=0
/proc/2574/task/2583/stat : 2583 (java) S 2561 2560 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 10 0 68246535 907341824 18503 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 1.47
Current children cumulated vsize (KiB) 891220

[startup+3.11113 s]
/proc/loadavg: 1.07 1.00 1.00 2/45 2583
/proc/meminfo: memFree=289936/1048576 swapFree=0/0
[pid=2560] ppid=2559 vsize=2568 CPUtime=0
/proc/2560/stat : 2560 (p2cudf-user-1.1) S 2559 2560 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 18 0 1 0 68246526 2629632 269 1283457024 134512640 135304128 4290903536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2560/statm: 642 269 230 194 0 29 0
[pid=2561] ppid=2560 vsize=2576 CPUtime=0.02
/proc/2561/stat : 2561 (p2cudf) S 2560 2560 19908 34817 19908 4202496 393 3016 0 1 0 0 2 0 25 0 1 0 68246526 2637824 281 1283457024 134512640 135304128 4286577152 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2561/statm: 644 281 239 194 0 31 0
[pid=2574] ppid=2561 vsize=886076 CPUtime=3.05
/proc/2574/stat : 2574 (java) S 2561 2560 19908 34817 19908 4202496 74525 0 1 0 280 25 0 0 25 0 10 0 68246530 907341824 71605 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/2574/statm: 221519 71605 1753 10 0 218610 0
[pid=2574/tid=2575] ppid=2561 vsize=886076 CPUtime=1.6
/proc/2574/task/2575/stat : 2575 (java) R 2561 2560 19908 34817 19908 4202560 50087 0 1 0 144 16 0 0 25 0 10 0 68246530 907341824 71605 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=2574/tid=2576] ppid=2561 vsize=886076 CPUtime=0.31
/proc/2574/task/2576/stat : 2576 (java) S 2561 2560 19908 34817 19908 4202560 12784 0 0 0 27 4 0 0 16 0 10 0 68246532 907341824 71605 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2577] ppid=2561 vsize=886076 CPUtime=0
/proc/2574/task/2577/stat : 2577 (java) S 2561 2560 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 10 0 68246532 907341824 71605 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2578] ppid=2561 vsize=886076 CPUtime=0
/proc/2574/task/2578/stat : 2578 (java) S 2561 2560 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 10 0 68246532 907341824 71605 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2579] ppid=2561 vsize=886076 CPUtime=0
/proc/2574/task/2579/stat : 2579 (java) S 2561 2560 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 68246535 907341824 71605 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2580] ppid=2561 vsize=886076 CPUtime=0.47
/proc/2574/task/2580/stat : 2580 (java) S 2561 2560 19908 34817 19908 4202560 5084 0 0 0 45 2 0 0 24 0 10 0 68246535 907341824 71605 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2581] ppid=2561 vsize=886076 CPUtime=0.65
/proc/2574/task/2581/stat : 2581 (java) S 2561 2560 19908 34817 19908 4202560 5494 0 0 0 63 2 0 0 15 0 10 0 68246535 907341824 71605 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2582] ppid=2561 vsize=886076 CPUtime=0
/proc/2574/task/2582/stat : 2582 (java) S 2561 2560 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 10 0 68246535 907341824 71605 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2583] ppid=2561 vsize=886076 CPUtime=0
/proc/2574/task/2583/stat : 2583 (java) S 2561 2560 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 10 0 68246535 907341824 71605 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 3.07
Current children cumulated vsize (KiB) 891220

[startup+6.30881 s]
/proc/loadavg: 1.06 1.00 1.00 2/46 2584
/proc/meminfo: memFree=181676/1048576 swapFree=0/0
[pid=2560] ppid=2559 vsize=2568 CPUtime=0
/proc/2560/stat : 2560 (p2cudf-user-1.1) S 2559 2560 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 18 0 1 0 68246526 2629632 269 1283457024 134512640 135304128 4290903536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2560/statm: 642 269 230 194 0 29 0
[pid=2561] ppid=2560 vsize=2576 CPUtime=0.02
/proc/2561/stat : 2561 (p2cudf) S 2560 2560 19908 34817 19908 4202496 393 3016 0 1 0 0 2 0 25 0 1 0 68246526 2637824 281 1283457024 134512640 135304128 4286577152 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2561/statm: 644 281 239 194 0 31 0
[pid=2574] ppid=2561 vsize=886400 CPUtime=6.25
/proc/2574/stat : 2574 (java) S 2561 2560 19908 34817 19908 4202496 74924 0 1 0 600 25 0 0 25 0 11 0 68246530 907673600 72004 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/2574/statm: 221600 72004 1778 10 0 218691 0
[pid=2574/tid=2575] ppid=2561 vsize=886400 CPUtime=3.38
/proc/2574/task/2575/stat : 2575 (java) R 2561 2560 19908 34817 19908 4202560 50274 0 1 0 322 16 0 0 25 0 11 0 68246530 907673600 72004 1283457024 134512640 134550932 4286636208 18446744073709551615 4095518504 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=2574/tid=2576] ppid=2561 vsize=886400 CPUtime=0.31
/proc/2574/task/2576/stat : 2576 (java) S 2561 2560 19908 34817 19908 4202560 12784 0 0 0 27 4 0 0 16 0 11 0 68246532 907673600 72004 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2577] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2577/stat : 2577 (java) S 2561 2560 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 68246532 907673600 72004 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2578] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2578/stat : 2578 (java) S 2561 2560 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 68246532 907673600 72004 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2579] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2579/stat : 2579 (java) S 2561 2560 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68246535 907673600 72004 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2580] ppid=2561 vsize=886400 CPUtime=0.47
/proc/2574/task/2580/stat : 2580 (java) S 2561 2560 19908 34817 19908 4202560 5084 0 0 0 45 2 0 0 24 0 11 0 68246535 907673600 72004 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2581] ppid=2561 vsize=886400 CPUtime=2.06
/proc/2574/task/2581/stat : 2581 (java) S 2561 2560 19908 34817 19908 4202560 5701 0 0 0 204 2 0 0 16 0 11 0 68246535 907673600 72004 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2582] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2582/stat : 2582 (java) S 2561 2560 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 68246535 907673600 72004 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2583] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2583/stat : 2583 (java) S 2561 2560 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 68246535 907673600 72004 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2584] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2584/stat : 2584 (java) S 2561 2560 19908 34817 19908 4202560 5 0 0 0 0 0 0 0 25 0 11 0 68246991 907673600 72004 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 6.27
Current children cumulated vsize (KiB) 891544

[startup+12.7305 s]
/proc/loadavg: 1.06 1.00 1.00 2/46 2584
/proc/meminfo: memFree=144848/1048576 swapFree=0/0
[pid=2560] ppid=2559 vsize=2568 CPUtime=0
/proc/2560/stat : 2560 (p2cudf-user-1.1) S 2559 2560 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 18 0 1 0 68246526 2629632 269 1283457024 134512640 135304128 4290903536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2560/statm: 642 269 230 194 0 29 0
[pid=2561] ppid=2560 vsize=2576 CPUtime=0.02
/proc/2561/stat : 2561 (p2cudf) S 2560 2560 19908 34817 19908 4202496 393 3016 0 1 0 0 2 0 25 0 1 0 68246526 2637824 281 1283457024 134512640 135304128 4286577152 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2561/statm: 644 281 239 194 0 31 0
[pid=2574] ppid=2561 vsize=886400 CPUtime=12.66
/proc/2574/stat : 2574 (java) S 2561 2560 19908 34817 19908 4202496 84085 0 1 0 1239 27 0 0 25 0 11 0 68246530 907673600 81165 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/2574/statm: 221600 81165 1786 10 0 218691 0
[pid=2574/tid=2575] ppid=2561 vsize=886400 CPUtime=9.17
/proc/2574/task/2575/stat : 2575 (java) R 2561 2560 19908 34817 19908 4202560 50276 0 1 0 901 16 0 0 25 0 11 0 68246530 907673600 81165 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=2574/tid=2576] ppid=2561 vsize=886400 CPUtime=0.83
/proc/2574/task/2576/stat : 2576 (java) R 2561 2560 19908 34817 19908 4202560 21923 0 0 0 77 6 0 0 15 0 11 0 68246532 907673600 81165 1283457024 134512640 134550932 4286636208 18446744073709551615 4151604336 0 0 0 16800975 0 0 0 -1 0 0 0 0
[pid=2574/tid=2577] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2577/stat : 2577 (java) S 2561 2560 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 68246532 907673600 81165 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2578] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2578/stat : 2578 (java) S 2561 2560 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 68246532 907673600 81165 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2579] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2579/stat : 2579 (java) S 2561 2560 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68246535 907673600 81165 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2580] ppid=2561 vsize=886400 CPUtime=0.47
/proc/2574/task/2580/stat : 2580 (java) S 2561 2560 19908 34817 19908 4202560 5084 0 0 0 45 2 0 0 24 0 11 0 68246535 907673600 81165 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2581] ppid=2561 vsize=886400 CPUtime=2.17
/proc/2574/task/2581/stat : 2581 (java) S 2561 2560 19908 34817 19908 4202560 5721 0 0 0 215 2 0 0 15 0 11 0 68246535 907673600 81165 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2582] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2582/stat : 2582 (java) S 2561 2560 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 68246535 907673600 81165 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2583] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2583/stat : 2583 (java) S 2561 2560 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 68246535 907673600 81165 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2584] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2584/stat : 2584 (java) S 2561 2560 19908 34817 19908 4202560 5 0 0 0 0 0 0 0 25 0 11 0 68246991 907673600 81165 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 12.68
Current children cumulated vsize (KiB) 891544

[startup+25.5034 s]
/proc/loadavg: 1.12 1.02 1.00 2/46 2584
/proc/meminfo: memFree=143360/1048576 swapFree=0/0
[pid=2560] ppid=2559 vsize=2568 CPUtime=0
/proc/2560/stat : 2560 (p2cudf-user-1.1) S 2559 2560 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 18 0 1 0 68246526 2629632 269 1283457024 134512640 135304128 4290903536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2560/statm: 642 269 230 194 0 29 0
[pid=2561] ppid=2560 vsize=2576 CPUtime=0.02
/proc/2561/stat : 2561 (p2cudf) S 2560 2560 19908 34817 19908 4202496 393 3016 0 1 0 0 2 0 25 0 1 0 68246526 2637824 281 1283457024 134512640 135304128 4286577152 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2561/statm: 644 281 239 194 0 31 0
[pid=2574] ppid=2561 vsize=886400 CPUtime=25.43
/proc/2574/stat : 2574 (java) S 2561 2560 19908 34817 19908 4202496 84436 0 1 0 2516 27 0 0 25 0 11 0 68246530 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/2574/statm: 221600 81516 1786 10 0 218691 0
[pid=2574/tid=2575] ppid=2561 vsize=886400 CPUtime=21.18
/proc/2574/task/2575/stat : 2575 (java) R 2561 2560 19908 34817 19908 4202560 50276 0 1 0 2102 16 0 0 25 0 11 0 68246530 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4095608155 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=2574/tid=2576] ppid=2561 vsize=886400 CPUtime=1.52
/proc/2574/task/2576/stat : 2576 (java) S 2561 2560 19908 34817 19908 4202560 22263 0 0 0 146 6 0 0 15 0 11 0 68246532 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2577] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2577/stat : 2577 (java) S 2561 2560 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 68246532 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2578] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2578/stat : 2578 (java) S 2561 2560 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 68246532 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2579] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2579/stat : 2579 (java) S 2561 2560 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68246535 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2580] ppid=2561 vsize=886400 CPUtime=0.47
/proc/2574/task/2580/stat : 2580 (java) S 2561 2560 19908 34817 19908 4202560 5084 0 0 0 45 2 0 0 24 0 11 0 68246535 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2581] ppid=2561 vsize=886400 CPUtime=2.23
/proc/2574/task/2581/stat : 2581 (java) S 2561 2560 19908 34817 19908 4202560 5732 0 0 0 221 2 0 0 15 0 11 0 68246535 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2582] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2582/stat : 2582 (java) S 2561 2560 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 68246535 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2583] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2583/stat : 2583 (java) S 2561 2560 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 68246535 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2584] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2584/stat : 2584 (java) S 2561 2560 19908 34817 19908 4202560 5 0 0 0 0 0 0 0 25 0 11 0 68246991 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 25.45
Current children cumulated vsize (KiB) 891544

[startup+51.1103 s]
/proc/loadavg: 1.08 1.01 1.00 2/48 2588
/proc/meminfo: memFree=143088/1048576 swapFree=0/0
[pid=2560] ppid=2559 vsize=2568 CPUtime=0
/proc/2560/stat : 2560 (p2cudf-user-1.1) S 2559 2560 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 18 0 1 0 68246526 2629632 269 1283457024 134512640 135304128 4290903536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2560/statm: 642 269 230 194 0 29 0
[pid=2561] ppid=2560 vsize=2576 CPUtime=0.02
/proc/2561/stat : 2561 (p2cudf) S 2560 2560 19908 34817 19908 4202496 393 3016 0 1 0 0 2 0 25 0 1 0 68246526 2637824 281 1283457024 134512640 135304128 4286577152 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2561/statm: 644 281 239 194 0 31 0
[pid=2574] ppid=2561 vsize=886400 CPUtime=51.03
/proc/2574/stat : 2574 (java) S 2561 2560 19908 34817 19908 4202496 84436 0 1 0 5075 28 0 0 25 0 11 0 68246530 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/2574/statm: 221600 81516 1786 10 0 218691 0
[pid=2574/tid=2575] ppid=2561 vsize=886400 CPUtime=45.71
/proc/2574/task/2575/stat : 2575 (java) R 2561 2560 19908 34817 19908 4202560 50276 0 1 0 4553 18 0 0 25 0 11 0 68246530 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4095618857 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=2574/tid=2576] ppid=2561 vsize=886400 CPUtime=2.59
/proc/2574/task/2576/stat : 2576 (java) S 2561 2560 19908 34817 19908 4202560 22263 0 0 0 253 6 0 0 15 0 11 0 68246532 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2577] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2577/stat : 2577 (java) S 2561 2560 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 68246532 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2578] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2578/stat : 2578 (java) S 2561 2560 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 68246532 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2579] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2579/stat : 2579 (java) S 2561 2560 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68246535 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2580] ppid=2561 vsize=886400 CPUtime=0.47
/proc/2574/task/2580/stat : 2580 (java) S 2561 2560 19908 34817 19908 4202560 5084 0 0 0 45 2 0 0 24 0 11 0 68246535 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2581] ppid=2561 vsize=886400 CPUtime=2.24
/proc/2574/task/2581/stat : 2581 (java) S 2561 2560 19908 34817 19908 4202560 5732 0 0 0 222 2 0 0 15 0 11 0 68246535 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2582] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2582/stat : 2582 (java) S 2561 2560 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 68246535 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2583] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2583/stat : 2583 (java) S 2561 2560 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 68246535 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2584] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2584/stat : 2584 (java) S 2561 2560 19908 34817 19908 4202560 5 0 0 0 0 0 0 0 25 0 11 0 68246991 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 51.05
Current children cumulated vsize (KiB) 891544

[startup+102.304 s]
/proc/loadavg: 1.03 1.01 1.00 2/48 2593
/proc/meminfo: memFree=142964/1048576 swapFree=0/0
[pid=2560] ppid=2559 vsize=2568 CPUtime=0
/proc/2560/stat : 2560 (p2cudf-user-1.1) S 2559 2560 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 18 0 1 0 68246526 2629632 269 1283457024 134512640 135304128 4290903536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2560/statm: 642 269 230 194 0 29 0
[pid=2561] ppid=2560 vsize=2576 CPUtime=0.02
/proc/2561/stat : 2561 (p2cudf) S 2560 2560 19908 34817 19908 4202496 393 3016 0 1 0 0 2 0 25 0 1 0 68246526 2637824 281 1283457024 134512640 135304128 4286577152 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2561/statm: 644 281 239 194 0 31 0
[pid=2574] ppid=2561 vsize=886400 CPUtime=102.17
/proc/2574/stat : 2574 (java) S 2561 2560 19908 34817 19908 4202496 84436 0 1 0 10189 28 0 0 25 0 11 0 68246530 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/2574/statm: 221600 81516 1786 10 0 218691 0
[pid=2574/tid=2575] ppid=2561 vsize=886400 CPUtime=95.31
/proc/2574/task/2575/stat : 2575 (java) R 2561 2560 19908 34817 19908 4202560 50276 0 1 0 9513 18 0 0 25 0 11 0 68246530 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4095703688 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=2574/tid=2576] ppid=2561 vsize=886400 CPUtime=4.13
/proc/2574/task/2576/stat : 2576 (java) S 2561 2560 19908 34817 19908 4202560 22263 0 0 0 407 6 0 0 15 0 11 0 68246532 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2577] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2577/stat : 2577 (java) S 2561 2560 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 68246532 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2578] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2578/stat : 2578 (java) S 2561 2560 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 68246532 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2579] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2579/stat : 2579 (java) S 2561 2560 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68246535 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2580] ppid=2561 vsize=886400 CPUtime=0.47
/proc/2574/task/2580/stat : 2580 (java) S 2561 2560 19908 34817 19908 4202560 5084 0 0 0 45 2 0 0 24 0 11 0 68246535 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2581] ppid=2561 vsize=886400 CPUtime=2.24
/proc/2574/task/2581/stat : 2581 (java) S 2561 2560 19908 34817 19908 4202560 5732 0 0 0 222 2 0 0 15 0 11 0 68246535 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2582] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2582/stat : 2582 (java) S 2561 2560 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 68246535 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2583] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2583/stat : 2583 (java) S 2561 2560 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 68246535 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2584] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2584/stat : 2584 (java) S 2561 2560 19908 34817 19908 4202560 5 0 0 0 0 0 0 0 25 0 11 0 68246991 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 102.19
Current children cumulated vsize (KiB) 891544

[startup+162.309 s]
/proc/loadavg: 1.05 1.02 1.00 2/47 2595
/proc/meminfo: memFree=142980/1048576 swapFree=0/0
[pid=2560] ppid=2559 vsize=2568 CPUtime=0
/proc/2560/stat : 2560 (p2cudf-user-1.1) S 2559 2560 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 18 0 1 0 68246526 2629632 269 1283457024 134512640 135304128 4290903536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2560/statm: 642 269 230 194 0 29 0
[pid=2561] ppid=2560 vsize=2576 CPUtime=0.02
/proc/2561/stat : 2561 (p2cudf) S 2560 2560 19908 34817 19908 4202496 393 3016 0 1 0 0 2 0 25 0 1 0 68246526 2637824 281 1283457024 134512640 135304128 4286577152 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2561/statm: 644 281 239 194 0 31 0
[pid=2574] ppid=2561 vsize=886400 CPUtime=162.12
/proc/2574/stat : 2574 (java) S 2561 2560 19908 34817 19908 4202496 84436 0 1 0 16182 30 0 0 25 0 11 0 68246530 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/2574/statm: 221600 81516 1786 10 0 218691 0
[pid=2574/tid=2575] ppid=2561 vsize=886400 CPUtime=153.64
/proc/2574/task/2575/stat : 2575 (java) R 2561 2560 19908 34817 19908 4202560 50276 0 1 0 15345 19 0 0 25 0 11 0 68246530 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4095703671 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=2574/tid=2576] ppid=2561 vsize=886400 CPUtime=5.74
/proc/2574/task/2576/stat : 2576 (java) S 2561 2560 19908 34817 19908 4202560 22263 0 0 0 568 6 0 0 15 0 11 0 68246532 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2577] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2577/stat : 2577 (java) S 2561 2560 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 68246532 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2578] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2578/stat : 2578 (java) S 2561 2560 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 68246532 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2579] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2579/stat : 2579 (java) S 2561 2560 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68246535 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2580] ppid=2561 vsize=886400 CPUtime=0.47
/proc/2574/task/2580/stat : 2580 (java) S 2561 2560 19908 34817 19908 4202560 5084 0 0 0 45 2 0 0 24 0 11 0 68246535 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2581] ppid=2561 vsize=886400 CPUtime=2.24
/proc/2574/task/2581/stat : 2581 (java) S 2561 2560 19908 34817 19908 4202560 5732 0 0 0 222 2 0 0 15 0 11 0 68246535 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2582] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2582/stat : 2582 (java) S 2561 2560 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 68246535 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2583] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2583/stat : 2583 (java) S 2561 2560 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 68246535 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2584] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2584/stat : 2584 (java) S 2561 2560 19908 34817 19908 4202560 5 0 0 0 0 0 0 0 25 0 11 0 68246991 907673600 81516 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 162.14
Current children cumulated vsize (KiB) 891544

[startup+222.313 s]
/proc/loadavg: 1.02 1.01 1.00 2/46 2595
/proc/meminfo: memFree=142740/1048576 swapFree=0/0
[pid=2560] ppid=2559 vsize=2568 CPUtime=0
/proc/2560/stat : 2560 (p2cudf-user-1.1) S 2559 2560 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 18 0 1 0 68246526 2629632 269 1283457024 134512640 135304128 4290903536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2560/statm: 642 269 230 194 0 29 0
[pid=2561] ppid=2560 vsize=2576 CPUtime=0.02
/proc/2561/stat : 2561 (p2cudf) S 2560 2560 19908 34817 19908 4202496 393 3016 0 1 0 0 2 0 25 0 1 0 68246526 2637824 281 1283457024 134512640 135304128 4286577152 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2561/statm: 644 281 239 194 0 31 0
[pid=2574] ppid=2561 vsize=886400 CPUtime=222.06
/proc/2574/stat : 2574 (java) S 2561 2560 19908 34817 19908 4202496 84495 0 1 0 22176 30 0 0 25 0 11 0 68246530 907673600 81575 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/2574/statm: 221600 81575 1786 10 0 218691 0
[pid=2574/tid=2575] ppid=2561 vsize=886400 CPUtime=212.81
/proc/2574/task/2575/stat : 2575 (java) R 2561 2560 19908 34817 19908 4202560 50276 0 1 0 21262 19 0 0 25 0 11 0 68246530 907673600 81575 1283457024 134512640 134550932 4286636208 18446744073709551615 4095608168 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=2574/tid=2576] ppid=2561 vsize=886400 CPUtime=6.52
/proc/2574/task/2576/stat : 2576 (java) S 2561 2560 19908 34817 19908 4202560 22322 0 0 0 646 6 0 0 15 0 11 0 68246532 907673600 81575 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2577] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2577/stat : 2577 (java) S 2561 2560 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 68246532 907673600 81575 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2578] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2578/stat : 2578 (java) S 2561 2560 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 68246532 907673600 81575 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2579] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2579/stat : 2579 (java) S 2561 2560 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68246535 907673600 81575 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2580] ppid=2561 vsize=886400 CPUtime=0.47
/proc/2574/task/2580/stat : 2580 (java) S 2561 2560 19908 34817 19908 4202560 5084 0 0 0 45 2 0 0 24 0 11 0 68246535 907673600 81575 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2581] ppid=2561 vsize=886400 CPUtime=2.24
/proc/2574/task/2581/stat : 2581 (java) S 2561 2560 19908 34817 19908 4202560 5732 0 0 0 222 2 0 0 15 0 11 0 68246535 907673600 81575 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2582] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2582/stat : 2582 (java) S 2561 2560 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 68246535 907673600 81575 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2583] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2583/stat : 2583 (java) R 2561 2560 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 68246535 907673600 81575 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=2574/tid=2584] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2584/stat : 2584 (java) S 2561 2560 19908 34817 19908 4202560 5 0 0 0 0 0 0 0 25 0 11 0 68246991 907673600 81575 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 222.08
Current children cumulated vsize (KiB) 891544

[startup+282.312 s]
/proc/loadavg: 1.00 1.01 1.00 2/46 2595
/proc/meminfo: memFree=140012/1048576 swapFree=0/0
[pid=2560] ppid=2559 vsize=2568 CPUtime=0
/proc/2560/stat : 2560 (p2cudf-user-1.1) S 2559 2560 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 18 0 1 0 68246526 2629632 269 1283457024 134512640 135304128 4290903536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2560/statm: 642 269 230 194 0 29 0
[pid=2561] ppid=2560 vsize=2576 CPUtime=0.02
/proc/2561/stat : 2561 (p2cudf) S 2560 2560 19908 34817 19908 4202496 393 3016 0 1 0 0 2 0 25 0 1 0 68246526 2637824 281 1283457024 134512640 135304128 4286577152 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2561/statm: 644 281 239 194 0 31 0
[pid=2574] ppid=2561 vsize=886400 CPUtime=282.03
/proc/2574/stat : 2574 (java) S 2561 2560 19908 34817 19908 4202496 85199 0 1 0 28173 30 0 0 25 0 11 0 68246530 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/2574/statm: 221600 82279 1786 10 0 218691 0
[pid=2574/tid=2575] ppid=2561 vsize=886400 CPUtime=271.69
/proc/2574/task/2575/stat : 2575 (java) R 2561 2560 19908 34817 19908 4202560 50276 0 1 0 27150 19 0 0 25 0 11 0 68246530 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4094914983 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=2574/tid=2576] ppid=2561 vsize=886400 CPUtime=7.6
/proc/2574/task/2576/stat : 2576 (java) S 2561 2560 19908 34817 19908 4202560 23026 0 0 0 754 6 0 0 15 0 11 0 68246532 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2577] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2577/stat : 2577 (java) S 2561 2560 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 68246532 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2578] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2578/stat : 2578 (java) S 2561 2560 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 68246532 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2579] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2579/stat : 2579 (java) S 2561 2560 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68246535 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2580] ppid=2561 vsize=886400 CPUtime=0.47
/proc/2574/task/2580/stat : 2580 (java) S 2561 2560 19908 34817 19908 4202560 5084 0 0 0 45 2 0 0 24 0 11 0 68246535 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2581] ppid=2561 vsize=886400 CPUtime=2.24
/proc/2574/task/2581/stat : 2581 (java) S 2561 2560 19908 34817 19908 4202560 5732 0 0 0 222 2 0 0 15 0 11 0 68246535 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2582] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2582/stat : 2582 (java) S 2561 2560 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 68246535 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2583] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2583/stat : 2583 (java) S 2561 2560 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 68246535 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2584] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2584/stat : 2584 (java) S 2561 2560 19908 34817 19908 4202560 5 0 0 0 0 0 0 0 25 0 11 0 68246991 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 282.05
Current children cumulated vsize (KiB) 891544

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

[startup+283.212 s]
/proc/loadavg: 1.00 1.01 1.00 2/46 2595
/proc/meminfo: memFree=140012/1048576 swapFree=0/0
[pid=2560] ppid=2559 vsize=2568 CPUtime=0
/proc/2560/stat : 2560 (p2cudf-user-1.1) S 2559 2560 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 18 0 1 0 68246526 2629632 269 1283457024 134512640 135304128 4290903536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2560/statm: 642 269 230 194 0 29 0
[pid=2561] ppid=2560 vsize=2576 CPUtime=0.02
/proc/2561/stat : 2561 (p2cudf) S 2560 2560 19908 34817 19908 4202496 393 3016 0 1 0 0 2 0 25 0 1 0 68246526 2637824 281 1283457024 134512640 135304128 4286577152 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2561/statm: 644 281 239 194 0 31 0
[pid=2574] ppid=2561 vsize=886400 CPUtime=282.93
/proc/2574/stat : 2574 (java) S 2561 2560 19908 34817 19908 4202496 85199 0 1 0 28263 30 0 0 25 0 11 0 68246530 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/2574/statm: 221600 82279 1786 10 0 218691 0
[pid=2574/tid=2575] ppid=2561 vsize=886400 CPUtime=272.59
/proc/2574/task/2575/stat : 2575 (java) R 2561 2560 19908 34817 19908 4202560 50276 0 1 0 27240 19 0 0 25 0 11 0 68246530 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4095703671 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=2574/tid=2576] ppid=2561 vsize=886400 CPUtime=7.6
/proc/2574/task/2576/stat : 2576 (java) S 2561 2560 19908 34817 19908 4202560 23026 0 0 0 754 6 0 0 15 0 11 0 68246532 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2577] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2577/stat : 2577 (java) S 2561 2560 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 68246532 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2578] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2578/stat : 2578 (java) S 2561 2560 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 68246532 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2579] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2579/stat : 2579 (java) S 2561 2560 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68246535 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2580] ppid=2561 vsize=886400 CPUtime=0.47
/proc/2574/task/2580/stat : 2580 (java) S 2561 2560 19908 34817 19908 4202560 5084 0 0 0 45 2 0 0 24 0 11 0 68246535 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2581] ppid=2561 vsize=886400 CPUtime=2.24
/proc/2574/task/2581/stat : 2581 (java) S 2561 2560 19908 34817 19908 4202560 5732 0 0 0 222 2 0 0 15 0 11 0 68246535 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2582] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2582/stat : 2582 (java) S 2561 2560 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 68246535 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2583] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2583/stat : 2583 (java) S 2561 2560 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 68246535 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2584] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2584/stat : 2584 (java) S 2561 2560 19908 34817 19908 4202560 5 0 0 0 0 0 0 0 25 0 11 0 68246991 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 282.95
Current children cumulated vsize (KiB) 891544

[startup+284.012 s]
/proc/loadavg: 1.00 1.01 1.00 2/46 2595
/proc/meminfo: memFree=140012/1048576 swapFree=0/0
[pid=2560] ppid=2559 vsize=2568 CPUtime=0
/proc/2560/stat : 2560 (p2cudf-user-1.1) S 2559 2560 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 18 0 1 0 68246526 2629632 269 1283457024 134512640 135304128 4290903536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2560/statm: 642 269 230 194 0 29 0
[pid=2561] ppid=2560 vsize=2576 CPUtime=0.02
/proc/2561/stat : 2561 (p2cudf) S 2560 2560 19908 34817 19908 4202496 393 3016 0 1 0 0 2 0 25 0 1 0 68246526 2637824 281 1283457024 134512640 135304128 4286577152 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2561/statm: 644 281 239 194 0 31 0
[pid=2574] ppid=2561 vsize=886400 CPUtime=283.73
/proc/2574/stat : 2574 (java) S 2561 2560 19908 34817 19908 4202496 85199 0 1 0 28343 30 0 0 25 0 11 0 68246530 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/2574/statm: 221600 82279 1786 10 0 218691 0
[pid=2574/tid=2575] ppid=2561 vsize=886400 CPUtime=273.39
/proc/2574/task/2575/stat : 2575 (java) R 2561 2560 19908 34817 19908 4202560 50276 0 1 0 27320 19 0 0 25 0 11 0 68246530 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4095563333 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=2574/tid=2576] ppid=2561 vsize=886400 CPUtime=7.6
/proc/2574/task/2576/stat : 2576 (java) S 2561 2560 19908 34817 19908 4202560 23026 0 0 0 754 6 0 0 15 0 11 0 68246532 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2577] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2577/stat : 2577 (java) S 2561 2560 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 68246532 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2578] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2578/stat : 2578 (java) S 2561 2560 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 68246532 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2579] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2579/stat : 2579 (java) S 2561 2560 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68246535 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2580] ppid=2561 vsize=886400 CPUtime=0.47
/proc/2574/task/2580/stat : 2580 (java) S 2561 2560 19908 34817 19908 4202560 5084 0 0 0 45 2 0 0 24 0 11 0 68246535 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2581] ppid=2561 vsize=886400 CPUtime=2.24
/proc/2574/task/2581/stat : 2581 (java) S 2561 2560 19908 34817 19908 4202560 5732 0 0 0 222 2 0 0 15 0 11 0 68246535 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2582] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2582/stat : 2582 (java) S 2561 2560 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 68246535 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2583] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2583/stat : 2583 (java) S 2561 2560 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 68246535 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2584] ppid=2561 vsize=886400 CPUtime=0
/proc/2574/task/2584/stat : 2584 (java) S 2561 2560 19908 34817 19908 4202560 5 0 0 0 0 0 0 0 25 0 11 0 68246991 907673600 82279 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.75
Current children cumulated vsize (KiB) 891544

[startup+284.807 s]
/proc/loadavg: 1.00 1.01 1.00 2/46 2595
/proc/meminfo: memFree=140012/1048576 swapFree=0/0
[pid=2560] ppid=2559 vsize=2568 CPUtime=0
/proc/2560/stat : 2560 (p2cudf-user-1.1) S 2559 2560 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 18 0 1 0 68246526 2629632 269 1283457024 134512640 135304128 4290903536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2560/statm: 642 269 230 194 0 29 0
[pid=2561] ppid=2560 vsize=2576 CPUtime=0.02
/proc/2561/stat : 2561 (p2cudf) S 2560 2560 19908 34817 19908 4202496 393 3016 0 1 0 0 2 0 25 0 1 0 68246526 2637824 281 1283457024 134512640 135304128 4286577152 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2561/statm: 644 281 239 194 0 31 0
[pid=2574] ppid=2561 vsize=886724 CPUtime=284.41
/proc/2574/stat : 2574 (java) S 2561 2560 19908 34817 19908 4202496 85211 0 1 0 28411 30 0 0 25 0 11 0 68246530 908005376 82291 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/2574/statm: 221681 82291 1787 10 0 218772 0
[pid=2574/tid=2575] ppid=2561 vsize=886724 CPUtime=274.04
/proc/2574/task/2575/stat : 2575 (java) S 2561 2560 19908 34817 19908 4202560 50283 0 1 0 27385 19 0 0 25 0 11 0 68246530 908005376 82291 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2576] ppid=2561 vsize=886724 CPUtime=7.6
/proc/2574/task/2576/stat : 2576 (java) S 2561 2560 19908 34817 19908 4202560 23026 0 0 0 754 6 0 0 16 0 11 0 68246532 908005376 82291 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2577] ppid=2561 vsize=886724 CPUtime=0
/proc/2574/task/2577/stat : 2577 (java) S 2561 2560 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 68246532 908005376 82291 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2578] ppid=2561 vsize=886724 CPUtime=0
/proc/2574/task/2578/stat : 2578 (java) S 2561 2560 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 68246532 908005376 82291 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2579] ppid=2561 vsize=886724 CPUtime=0
/proc/2574/task/2579/stat : 2579 (java) S 2561 2560 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68246535 908005376 82291 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2580] ppid=2561 vsize=886724 CPUtime=0.47
/proc/2574/task/2580/stat : 2580 (java) S 2561 2560 19908 34817 19908 4202560 5084 0 0 0 45 2 0 0 24 0 11 0 68246535 908005376 82291 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2581] ppid=2561 vsize=886724 CPUtime=2.27
/proc/2574/task/2581/stat : 2581 (java) S 2561 2560 19908 34817 19908 4202560 5732 0 0 0 225 2 0 0 15 0 11 0 68246535 908005376 82291 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2582] ppid=2561 vsize=886724 CPUtime=0
/proc/2574/task/2582/stat : 2582 (java) S 2561 2560 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 68246535 908005376 82291 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2583] ppid=2561 vsize=886724 CPUtime=0
/proc/2574/task/2583/stat : 2583 (java) S 2561 2560 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 68246535 908005376 82291 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 284.43
Current children cumulated vsize (KiB) 891868

[startup+285.207 s]
/proc/loadavg: 1.00 1.01 1.00 1/46 2596
/proc/meminfo: memFree=139888/1048576 swapFree=0/0
[pid=2560] ppid=2559 vsize=2568 CPUtime=0
/proc/2560/stat : 2560 (p2cudf-user-1.1) S 2559 2560 19908 34817 19908 4202496 373 0 0 0 0 0 0 0 18 0 1 0 68246526 2629632 269 1283457024 134512640 135304128 4290903536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2560/statm: 642 269 230 194 0 29 0
[pid=2561] ppid=2560 vsize=2576 CPUtime=0.02
/proc/2561/stat : 2561 (p2cudf) S 2560 2560 19908 34817 19908 4202496 393 3016 0 1 0 0 2 0 25 0 1 0 68246526 2637824 281 1283457024 134512640 135304128 4286577152 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/2561/statm: 644 281 239 194 0 31 0
[pid=2574] ppid=2561 vsize=886724 CPUtime=284.41
/proc/2574/stat : 2574 (java) S 2561 2560 19908 34817 19908 4202496 85211 0 1 0 28411 30 0 0 25 0 11 0 68246530 908005376 82291 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/2574/statm: 221681 82291 1787 10 0 218772 0
[pid=2574/tid=2575] ppid=2561 vsize=886724 CPUtime=274.04
/proc/2574/task/2575/stat : 2575 (java) S 2561 2560 19908 34817 19908 4202560 50283 0 1 0 27385 19 0 0 25 0 11 0 68246530 908005376 82291 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2576] ppid=2561 vsize=886724 CPUtime=7.6
/proc/2574/task/2576/stat : 2576 (java) S 2561 2560 19908 34817 19908 4202560 23026 0 0 0 754 6 0 0 16 0 11 0 68246532 908005376 82291 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2577] ppid=2561 vsize=886724 CPUtime=0
/proc/2574/task/2577/stat : 2577 (java) S 2561 2560 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 68246532 908005376 82291 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2578] ppid=2561 vsize=886724 CPUtime=0
/proc/2574/task/2578/stat : 2578 (java) S 2561 2560 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 68246532 908005376 82291 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2579] ppid=2561 vsize=886724 CPUtime=0
/proc/2574/task/2579/stat : 2579 (java) S 2561 2560 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68246535 908005376 82291 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2580] ppid=2561 vsize=886724 CPUtime=0.47
/proc/2574/task/2580/stat : 2580 (java) S 2561 2560 19908 34817 19908 4202560 5084 0 0 0 45 2 0 0 24 0 11 0 68246535 908005376 82291 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2581] ppid=2561 vsize=886724 CPUtime=2.27
/proc/2574/task/2581/stat : 2581 (java) S 2561 2560 19908 34817 19908 4202560 5732 0 0 0 225 2 0 0 15 0 11 0 68246535 908005376 82291 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2582] ppid=2561 vsize=886724 CPUtime=0
/proc/2574/task/2582/stat : 2582 (java) S 2561 2560 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 68246535 908005376 82291 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2583] ppid=2561 vsize=886724 CPUtime=0
/proc/2574/task/2583/stat : 2583 (java) S 2561 2560 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 68246535 908005376 82291 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=2574/tid=2596] ppid=2561 vsize=886724 CPUtime=0
/proc/2574/task/2596/stat : 2596 (java) R 2561 2560 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 20 0 11 0 68274996 908005376 82291 1283457024 134512640 134550932 4286636208 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 284.43
Current children cumulated vsize (KiB) 891868

Child status: 0
Real time (s): 285.31
CPU time (s): 284.486
CPU user time (s): 284.158
CPU system time (s): 0.32802
CPU usage (%): 99.7112
Max. virtual memory (cumulated for all children) (KiB): 891868

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 284.158
system time used= 0.32802
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 89017
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= 5919
involuntary context switches= 8627

runsolver used 0 second user time and 0.012 second system time

The end