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/80cfe9a6-9b1b-11df-965e-00163e46d37a.cudf.dudf-real.log.runsolver ./p2cudf-user-1.13 /home/misc2010/data/2011/dudf-real//80cfe9a6-9b1b-11df-965e-00163e46d37a.cudf /home/misc2010/tmp/201108311143/p2cudf-user-1.13/80cfe9a6-9b1b-11df-965e-00163e46d37a.cudf.dudf-real.result -sum(installedsize) 

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


[startup+0 s]
/proc/loadavg: 0.99 1.00 0.99 5/38 31211
/proc/meminfo: memFree=657864/1048576 swapFree=0/0
[pid=31208] ppid=31207 vsize=2568 CPUtime=0
/proc/31208/stat : 31208 (p2cudf-user-1.1) S 31207 31208 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 66409906 2629632 270 1283457024 134512640 135304128 4288576448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31208/statm: 642 270 230 194 0 29 0
[pid=31209] ppid=31208 vsize=2568 CPUtime=0
/proc/31209/stat : 31209 (p2cudf) S 31208 31208 19908 34817 19908 4202496 352 0 0 0 0 0 0 0 18 0 1 0 66409906 2629632 271 1283457024 134512640 135304128 4292734944 18446744073709551615 4294960130 0 0 4 65536 18446744071564457842 0 0 17 0 0 0 0
/proc/31209/statm: 642 271 231 194 0 29 0
[pid=31210] ppid=31209 vsize=2568 CPUtime=0
/proc/31210/stat : 31210 (p2cudf) R 31209 31208 19908 34817 19908 4202560 94 0 0 0 0 0 0 0 25 0 1 0 66409906 2629632 119 1283457024 134512640 135304128 4292734944 18446744073709551615 4294960130 0 65538 0 65538 0 0 0 17 0 0 0 0
/proc/31210/statm: 642 119 77 194 0 29 0
[pid=31211] ppid=31210 vsize=2568 CPUtime=0
/proc/31211/stat : 31211 (p2cudf) R 31210 31208 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 1 0 66409906 2629632 42 1283457024 134512640 135304128 4292734944 18446744073709551615 4294960130 0 65538 0 65538 0 0 0 17 0 0 0 0
/proc/31211/statm: 642 42 0 194 0 29 0

[startup+0.185485 s]
/proc/loadavg: 0.99 1.00 0.99 5/38 31211
/proc/meminfo: memFree=657864/1048576 swapFree=0/0
[pid=31208] ppid=31207 vsize=2568 CPUtime=0
/proc/31208/stat : 31208 (p2cudf-user-1.1) S 31207 31208 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 66409906 2629632 270 1283457024 134512640 135304128 4288576448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31208/statm: 642 270 230 194 0 29 0
[pid=31209] ppid=31208 vsize=2576 CPUtime=0.02
/proc/31209/stat : 31209 (p2cudf) S 31208 31208 19908 34817 19908 4202496 392 3013 0 1 0 0 2 0 25 0 1 0 66409906 2637824 281 1283457024 134512640 135304128 4292734944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31209/statm: 644 281 239 194 0 31 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5144

[startup+0.205487 s]
/proc/loadavg: 0.99 1.00 0.99 5/38 31211
/proc/meminfo: memFree=657864/1048576 swapFree=0/0
[pid=31208] ppid=31207 vsize=2568 CPUtime=0
/proc/31208/stat : 31208 (p2cudf-user-1.1) S 31207 31208 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 66409906 2629632 270 1283457024 134512640 135304128 4288576448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31208/statm: 642 270 230 194 0 29 0
[pid=31209] ppid=31208 vsize=2576 CPUtime=0.02
/proc/31209/stat : 31209 (p2cudf) S 31208 31208 19908 34817 19908 4202496 392 3013 0 1 0 0 2 0 25 0 1 0 66409906 2637824 281 1283457024 134512640 135304128 4292734944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31209/statm: 644 281 239 194 0 31 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5144

[startup+0.305514 s]
/proc/loadavg: 0.99 1.00 0.99 5/38 31211
/proc/meminfo: memFree=657864/1048576 swapFree=0/0
[pid=31208] ppid=31207 vsize=2568 CPUtime=0
/proc/31208/stat : 31208 (p2cudf-user-1.1) S 31207 31208 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 66409906 2629632 270 1283457024 134512640 135304128 4288576448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31208/statm: 642 270 230 194 0 29 0
[pid=31209] ppid=31208 vsize=2576 CPUtime=0.02
/proc/31209/stat : 31209 (p2cudf) S 31208 31208 19908 34817 19908 4202496 392 3013 0 1 0 0 2 0 25 0 1 0 66409906 2637824 281 1283457024 134512640 135304128 4292734944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31209/statm: 644 281 239 194 0 31 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5144

[startup+0.705632 s]
/proc/loadavg: 0.99 1.00 0.99 5/38 31211
/proc/meminfo: memFree=657864/1048576 swapFree=0/0
[pid=31208] ppid=31207 vsize=2568 CPUtime=0
/proc/31208/stat : 31208 (p2cudf-user-1.1) S 31207 31208 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 66409906 2629632 270 1283457024 134512640 135304128 4288576448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31208/statm: 642 270 230 194 0 29 0
[pid=31209] ppid=31208 vsize=2576 CPUtime=0.02
/proc/31209/stat : 31209 (p2cudf) S 31208 31208 19908 34817 19908 4202496 392 3013 0 1 0 0 2 0 25 0 1 0 66409906 2637824 281 1283457024 134512640 135304128 4292734944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31209/statm: 644 281 239 194 0 31 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5144

[startup+1.50585 s]
/proc/loadavg: 0.99 1.00 0.99 5/47 31231
/proc/meminfo: memFree=617924/1048576 swapFree=0/0
[pid=31208] ppid=31207 vsize=2568 CPUtime=0
/proc/31208/stat : 31208 (p2cudf-user-1.1) S 31207 31208 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 66409906 2629632 270 1283457024 134512640 135304128 4288576448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31208/statm: 642 270 230 194 0 29 0
[pid=31209] ppid=31208 vsize=2576 CPUtime=0.02
/proc/31209/stat : 31209 (p2cudf) S 31208 31208 19908 34817 19908 4202496 392 3013 0 1 0 0 2 0 25 0 1 0 66409906 2637824 281 1283457024 134512640 135304128 4292734944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31209/statm: 644 281 239 194 0 31 0
[pid=31222] ppid=31209 vsize=882312 CPUtime=1.46
/proc/31222/stat : 31222 (java) S 31209 31208 19908 34817 19908 4202496 21193 0 1 0 140 6 0 0 25 0 10 0 66409910 903487488 18129 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31222/statm: 220578 18129 1734 10 0 217669 0
[pid=31222/tid=31223] ppid=31209 vsize=882312 CPUtime=0.76
/proc/31222/task/31223/stat : 31223 (java) R 31209 31208 19908 34817 19908 4202560 10304 0 1 0 72 4 0 0 25 0 10 0 66409910 903487488 18129 1283457024 134512640 134550932 4287400288 18446744073709551615 4095039872 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31222/tid=31224] ppid=31209 vsize=882312 CPUtime=0
/proc/31222/task/31224/stat : 31224 (java) S 31209 31208 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 16 0 10 0 66409912 903487488 18129 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 0 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31225] ppid=31209 vsize=882312 CPUtime=0
/proc/31222/task/31225/stat : 31225 (java) S 31209 31208 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 25 0 10 0 66409912 903487488 18129 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31226] ppid=31209 vsize=882312 CPUtime=0
/proc/31222/task/31226/stat : 31226 (java) S 31209 31208 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 10 0 66409912 903487488 18129 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31227] ppid=31209 vsize=882312 CPUtime=0
/proc/31222/task/31227/stat : 31227 (java) S 31209 31208 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 66409915 903487488 18129 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31228] ppid=31209 vsize=882312 CPUtime=0.55
/proc/31222/task/31228/stat : 31228 (java) R 31209 31208 19908 34817 19908 4202560 9169 0 0 0 54 1 0 0 22 0 10 0 66409915 903487488 18129 1283457024 134512640 134550932 4287400288 18446744073709551615 4149648136 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31222/tid=31229] ppid=31209 vsize=882312 CPUtime=0.13
/proc/31222/task/31229/stat : 31229 (java) S 31209 31208 19908 34817 19908 4202560 643 0 0 0 12 1 0 0 23 0 10 0 66409915 903487488 18129 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31230] ppid=31209 vsize=882312 CPUtime=0
/proc/31222/task/31230/stat : 31230 (java) S 31209 31208 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 10 0 66409915 903487488 18129 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31231] ppid=31209 vsize=882312 CPUtime=0
/proc/31222/task/31231/stat : 31231 (java) S 31209 31208 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 10 0 66409915 903487488 18129 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 1.48
Current children cumulated vsize (KiB) 887456

[startup+3.10622 s]
/proc/loadavg: 0.99 1.00 0.99 2/47 31232
/proc/meminfo: memFree=480656/1048576 swapFree=0/0
[pid=31208] ppid=31207 vsize=2568 CPUtime=0
/proc/31208/stat : 31208 (p2cudf-user-1.1) S 31207 31208 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 66409906 2629632 270 1283457024 134512640 135304128 4288576448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31208/statm: 642 270 230 194 0 29 0
[pid=31209] ppid=31208 vsize=2576 CPUtime=0.02
/proc/31209/stat : 31209 (p2cudf) S 31208 31208 19908 34817 19908 4202496 392 3013 0 1 0 0 2 0 25 0 1 0 66409906 2637824 281 1283457024 134512640 135304128 4292734944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31209/statm: 644 281 239 194 0 31 0
[pid=31222] ppid=31209 vsize=882312 CPUtime=3.06
/proc/31222/stat : 31222 (java) S 31209 31208 19908 34817 19908 4202496 73192 0 1 0 280 26 0 0 25 0 10 0 66409910 903487488 70128 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31222/statm: 220578 70128 1753 10 0 217669 0
[pid=31222/tid=31223] ppid=31209 vsize=882312 CPUtime=1.63
/proc/31222/task/31223/stat : 31223 (java) R 31209 31208 19908 34817 19908 4202560 50087 0 1 0 147 16 0 0 25 0 10 0 66409910 903487488 70128 1283457024 134512640 134550932 4287400288 18446744073709551615 4095165408 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31222/tid=31224] ppid=31209 vsize=882312 CPUtime=0.27
/proc/31222/task/31224/stat : 31224 (java) S 31209 31208 19908 34817 19908 4202560 12150 0 0 0 22 5 0 0 16 0 10 0 66409912 903487488 70128 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 0 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31225] ppid=31209 vsize=882312 CPUtime=0
/proc/31222/task/31225/stat : 31225 (java) S 31209 31208 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 10 0 66409912 903487488 70128 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31226] ppid=31209 vsize=882312 CPUtime=0
/proc/31222/task/31226/stat : 31226 (java) S 31209 31208 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 10 0 66409912 903487488 70128 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31227] ppid=31209 vsize=882312 CPUtime=0
/proc/31222/task/31227/stat : 31227 (java) S 31209 31208 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 66409915 903487488 70128 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31228] ppid=31209 vsize=882312 CPUtime=1
/proc/31222/task/31228/stat : 31228 (java) S 31209 31208 19908 34817 19908 4202560 9238 0 0 0 98 2 0 0 15 0 10 0 66409915 903487488 70128 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31229] ppid=31209 vsize=882312 CPUtime=0.13
/proc/31222/task/31229/stat : 31229 (java) S 31209 31208 19908 34817 19908 4202560 643 0 0 0 12 1 0 0 23 0 10 0 66409915 903487488 70128 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31230] ppid=31209 vsize=882312 CPUtime=0
/proc/31222/task/31230/stat : 31230 (java) S 31209 31208 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 10 0 66409915 903487488 70128 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31231] ppid=31209 vsize=882312 CPUtime=0
/proc/31222/task/31231/stat : 31231 (java) S 31209 31208 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 10 0 66409915 903487488 70128 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 3.08
Current children cumulated vsize (KiB) 887456

[startup+6.30693 s]
/proc/loadavg: 0.99 1.00 0.99 2/48 31233
/proc/meminfo: memFree=382200/1048576 swapFree=0/0
[pid=31208] ppid=31207 vsize=2568 CPUtime=0
/proc/31208/stat : 31208 (p2cudf-user-1.1) S 31207 31208 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 66409906 2629632 270 1283457024 134512640 135304128 4288576448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31208/statm: 642 270 230 194 0 29 0
[pid=31209] ppid=31208 vsize=2576 CPUtime=0.02
/proc/31209/stat : 31209 (p2cudf) S 31208 31208 19908 34817 19908 4202496 392 3013 0 1 0 0 2 0 25 0 1 0 66409906 2637824 281 1283457024 134512640 135304128 4292734944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31209/statm: 644 281 239 194 0 31 0
[pid=31222] ppid=31209 vsize=882636 CPUtime=6.26
/proc/31222/stat : 31222 (java) S 31209 31208 19908 34817 19908 4202496 81310 0 1 0 596 30 0 0 25 0 11 0 66409910 903819264 78246 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31222/statm: 220659 78246 1781 10 0 217750 0
[pid=31222/tid=31223] ppid=31209 vsize=882636 CPUtime=3.52
/proc/31222/task/31223/stat : 31223 (java) R 31209 31208 19908 34817 19908 4202560 50272 0 1 0 336 16 0 0 25 0 11 0 66409910 903819264 78246 1283457024 134512640 134550932 4287400288 18446744073709551615 4095664152 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31222/tid=31224] ppid=31209 vsize=882636 CPUtime=0.56
/proc/31222/task/31224/stat : 31224 (java) S 31209 31208 19908 34817 19908 4202560 19917 0 0 0 47 9 0 0 16 0 11 0 66409912 903819264 78246 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 0 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31225] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31225/stat : 31225 (java) S 31209 31208 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 66409912 903819264 78246 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31226] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31226/stat : 31226 (java) S 31209 31208 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 66409912 903819264 78246 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31227] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31227/stat : 31227 (java) S 31209 31208 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66409915 903819264 78246 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31228] ppid=31209 vsize=882636 CPUtime=2.02
/proc/31222/task/31228/stat : 31228 (java) S 31209 31208 19908 34817 19908 4202560 9400 0 0 0 200 2 0 0 15 0 11 0 66409915 903819264 78246 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31229] ppid=31209 vsize=882636 CPUtime=0.13
/proc/31222/task/31229/stat : 31229 (java) S 31209 31208 19908 34817 19908 4202560 643 0 0 0 12 1 0 0 23 0 11 0 66409915 903819264 78246 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31230] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31230/stat : 31230 (java) S 31209 31208 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 66409915 903819264 78246 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31231] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31231/stat : 31231 (java) S 31209 31208 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 66409915 903819264 78246 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31233] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31233/stat : 31233 (java) S 31209 31208 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 66410308 903819264 78246 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 6.28
Current children cumulated vsize (KiB) 887780

[startup+12.7084 s]
/proc/loadavg: 0.99 1.00 0.99 2/48 31234
/proc/meminfo: memFree=347232/1048576 swapFree=0/0
[pid=31208] ppid=31207 vsize=2568 CPUtime=0
/proc/31208/stat : 31208 (p2cudf-user-1.1) S 31207 31208 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 66409906 2629632 270 1283457024 134512640 135304128 4288576448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31208/statm: 642 270 230 194 0 29 0
[pid=31209] ppid=31208 vsize=2576 CPUtime=0.02
/proc/31209/stat : 31209 (p2cudf) S 31208 31208 19908 34817 19908 4202496 392 3013 0 1 0 0 2 0 25 0 1 0 66409906 2637824 281 1283457024 134512640 135304128 4292734944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31209/statm: 644 281 239 194 0 31 0
[pid=31222] ppid=31209 vsize=882636 CPUtime=12.65
/proc/31222/stat : 31222 (java) S 31209 31208 19908 34817 19908 4202496 82218 0 1 0 1235 30 0 0 25 0 11 0 66409910 903819264 79154 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31222/statm: 220659 79154 1783 10 0 217750 0
[pid=31222/tid=31223] ppid=31209 vsize=882636 CPUtime=8.76
/proc/31222/task/31223/stat : 31223 (java) R 31209 31208 19908 34817 19908 4202560 50272 0 1 0 859 17 0 0 25 0 11 0 66409910 903819264 79154 1283457024 134512640 134550932 4287400288 18446744073709551615 4095556508 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31222/tid=31224] ppid=31209 vsize=882636 CPUtime=1.45
/proc/31222/task/31224/stat : 31224 (java) S 31209 31208 19908 34817 19908 4202560 20791 0 0 0 136 9 0 0 15 0 11 0 66409912 903819264 79154 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 0 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31225] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31225/stat : 31225 (java) S 31209 31208 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 66409912 903819264 79154 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31226] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31226/stat : 31226 (java) S 31209 31208 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 66409912 903819264 79154 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31227] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31227/stat : 31227 (java) S 31209 31208 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66409915 903819264 79154 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31228] ppid=31209 vsize=882636 CPUtime=2.29
/proc/31222/task/31228/stat : 31228 (java) S 31209 31208 19908 34817 19908 4202560 9434 0 0 0 227 2 0 0 15 0 11 0 66409915 903819264 79154 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31229] ppid=31209 vsize=882636 CPUtime=0.13
/proc/31222/task/31229/stat : 31229 (java) S 31209 31208 19908 34817 19908 4202560 643 0 0 0 12 1 0 0 23 0 11 0 66409915 903819264 79154 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31230] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31230/stat : 31230 (java) S 31209 31208 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 66409915 903819264 79154 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31231] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31231/stat : 31231 (java) R 31209 31208 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 66409915 903819264 79154 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31222/tid=31233] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31233/stat : 31233 (java) S 31209 31208 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 66410308 903819264 79154 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 12.67
Current children cumulated vsize (KiB) 887780

[startup+25.5131 s]
/proc/loadavg: 1.07 1.02 1.00 2/48 31235
/proc/meminfo: memFree=337808/1048576 swapFree=0/0
[pid=31208] ppid=31207 vsize=2568 CPUtime=0
/proc/31208/stat : 31208 (p2cudf-user-1.1) S 31207 31208 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 66409906 2629632 270 1283457024 134512640 135304128 4288576448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31208/statm: 642 270 230 194 0 29 0
[pid=31209] ppid=31208 vsize=2576 CPUtime=0.02
/proc/31209/stat : 31209 (p2cudf) S 31208 31208 19908 34817 19908 4202496 392 3013 0 1 0 0 2 0 25 0 1 0 66409906 2637824 281 1283457024 134512640 135304128 4292734944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31209/statm: 644 281 239 194 0 31 0
[pid=31222] ppid=31209 vsize=882636 CPUtime=25.42
/proc/31222/stat : 31222 (java) S 31209 31208 19908 34817 19908 4202496 84556 0 1 0 2512 30 0 0 25 0 11 0 66409910 903819264 81492 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31222/statm: 220659 81492 1783 10 0 217750 0
[pid=31222/tid=31223] ppid=31209 vsize=882636 CPUtime=20.17
/proc/31222/task/31223/stat : 31223 (java) R 31209 31208 19908 34817 19908 4202560 50272 0 1 0 2000 17 0 0 25 0 11 0 66409910 903819264 81492 1283457024 134512640 134550932 4287400288 18446744073709551615 4095177728 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31222/tid=31224] ppid=31209 vsize=882636 CPUtime=2.79
/proc/31222/task/31224/stat : 31224 (java) S 31209 31208 19908 34817 19908 4202560 23129 0 0 0 270 9 0 0 16 0 11 0 66409912 903819264 81492 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 0 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31225] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31225/stat : 31225 (java) S 31209 31208 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 66409912 903819264 81492 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31226] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31226/stat : 31226 (java) S 31209 31208 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 66409912 903819264 81492 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31227] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31227/stat : 31227 (java) S 31209 31208 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66409915 903819264 81492 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31228] ppid=31209 vsize=882636 CPUtime=2.3
/proc/31222/task/31228/stat : 31228 (java) S 31209 31208 19908 34817 19908 4202560 9434 0 0 0 228 2 0 0 16 0 11 0 66409915 903819264 81492 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31229] ppid=31209 vsize=882636 CPUtime=0.13
/proc/31222/task/31229/stat : 31229 (java) S 31209 31208 19908 34817 19908 4202560 643 0 0 0 12 1 0 0 23 0 11 0 66409915 903819264 81492 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31230] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31230/stat : 31230 (java) S 31209 31208 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 66409915 903819264 81492 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31231] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31231/stat : 31231 (java) S 31209 31208 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 66409915 903819264 81492 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31233] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31233/stat : 31233 (java) S 31209 31208 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 66410308 903819264 81492 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 25.44
Current children cumulated vsize (KiB) 887780

[startup+51.1142 s]
/proc/loadavg: 1.18 1.05 1.01 3/47 31236
/proc/meminfo: memFree=324060/1048576 swapFree=0/0
[pid=31208] ppid=31207 vsize=2568 CPUtime=0
/proc/31208/stat : 31208 (p2cudf-user-1.1) S 31207 31208 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 66409906 2629632 270 1283457024 134512640 135304128 4288576448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31208/statm: 642 270 230 194 0 29 0
[pid=31209] ppid=31208 vsize=2576 CPUtime=0.02
/proc/31209/stat : 31209 (p2cudf) S 31208 31208 19908 34817 19908 4202496 392 3013 0 1 0 0 2 0 25 0 1 0 66409906 2637824 281 1283457024 134512640 135304128 4292734944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31209/statm: 644 281 239 194 0 31 0
[pid=31222] ppid=31209 vsize=882636 CPUtime=50.99
/proc/31222/stat : 31222 (java) S 31209 31208 19908 34817 19908 4202496 88013 0 1 0 5069 30 0 0 25 0 11 0 66409910 903819264 84949 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31222/statm: 220659 84949 1783 10 0 217750 0
[pid=31222/tid=31223] ppid=31209 vsize=882636 CPUtime=44.06
/proc/31222/task/31223/stat : 31223 (java) R 31209 31208 19908 34817 19908 4202560 50272 0 1 0 4389 17 0 0 25 0 11 0 66409910 903819264 84949 1283457024 134512640 134550932 4287400288 18446744073709551615 4095613018 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31222/tid=31224] ppid=31209 vsize=882636 CPUtime=4.43
/proc/31222/task/31224/stat : 31224 (java) S 31209 31208 19908 34817 19908 4202560 26586 0 0 0 434 9 0 0 15 0 11 0 66409912 903819264 84949 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 0 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31225] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31225/stat : 31225 (java) S 31209 31208 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 66409912 903819264 84949 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31226] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31226/stat : 31226 (java) S 31209 31208 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 66409912 903819264 84949 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31227] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31227/stat : 31227 (java) S 31209 31208 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66409915 903819264 84949 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31228] ppid=31209 vsize=882636 CPUtime=2.34
/proc/31222/task/31228/stat : 31228 (java) S 31209 31208 19908 34817 19908 4202560 9434 0 0 0 232 2 0 0 15 0 11 0 66409915 903819264 84949 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31229] ppid=31209 vsize=882636 CPUtime=0.13
/proc/31222/task/31229/stat : 31229 (java) S 31209 31208 19908 34817 19908 4202560 643 0 0 0 12 1 0 0 23 0 11 0 66409915 903819264 84949 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31230] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31230/stat : 31230 (java) S 31209 31208 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 66409915 903819264 84949 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31231] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31231/stat : 31231 (java) R 31209 31208 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 66409915 903819264 84949 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31222/tid=31233] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31233/stat : 31233 (java) S 31209 31208 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 66410308 903819264 84949 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 51.01
Current children cumulated vsize (KiB) 887780

[startup+102.313 s]
/proc/loadavg: 1.08 1.04 1.00 2/46 31236
/proc/meminfo: memFree=317868/1048576 swapFree=0/0
[pid=31208] ppid=31207 vsize=2568 CPUtime=0
/proc/31208/stat : 31208 (p2cudf-user-1.1) S 31207 31208 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 66409906 2629632 270 1283457024 134512640 135304128 4288576448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31208/statm: 642 270 230 194 0 29 0
[pid=31209] ppid=31208 vsize=2576 CPUtime=0.02
/proc/31209/stat : 31209 (p2cudf) S 31208 31208 19908 34817 19908 4202496 392 3013 0 1 0 0 2 0 25 0 1 0 66409906 2637824 281 1283457024 134512640 135304128 4292734944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31209/statm: 644 281 239 194 0 31 0
[pid=31222] ppid=31209 vsize=882636 CPUtime=102.07
/proc/31222/stat : 31222 (java) S 31209 31208 19908 34817 19908 4202496 89501 0 1 0 10177 30 0 0 25 0 11 0 66409910 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31222/statm: 220659 86437 1783 10 0 217750 0
[pid=31222/tid=31223] ppid=31209 vsize=882636 CPUtime=92.26
/proc/31222/task/31223/stat : 31223 (java) R 31209 31208 19908 34817 19908 4202560 50272 0 1 0 9209 17 0 0 25 0 11 0 66409910 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4095609630 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31222/tid=31224] ppid=31209 vsize=882636 CPUtime=7.31
/proc/31222/task/31224/stat : 31224 (java) S 31209 31208 19908 34817 19908 4202560 28074 0 0 0 722 9 0 0 16 0 11 0 66409912 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 0 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31225] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31225/stat : 31225 (java) S 31209 31208 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 66409912 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31226] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31226/stat : 31226 (java) S 31209 31208 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 66409912 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31227] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31227/stat : 31227 (java) S 31209 31208 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66409915 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31228] ppid=31209 vsize=882636 CPUtime=2.34
/proc/31222/task/31228/stat : 31228 (java) S 31209 31208 19908 34817 19908 4202560 9434 0 0 0 232 2 0 0 15 0 11 0 66409915 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31229] ppid=31209 vsize=882636 CPUtime=0.13
/proc/31222/task/31229/stat : 31229 (java) S 31209 31208 19908 34817 19908 4202560 643 0 0 0 12 1 0 0 23 0 11 0 66409915 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31230] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31230/stat : 31230 (java) S 31209 31208 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 66409915 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31231] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31231/stat : 31231 (java) S 31209 31208 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 66409915 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31233] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31233/stat : 31233 (java) S 31209 31208 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 66410308 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 102.09
Current children cumulated vsize (KiB) 887780

[startup+162.307 s]
/proc/loadavg: 1.03 1.03 1.00 2/46 31236
/proc/meminfo: memFree=317744/1048576 swapFree=0/0
[pid=31208] ppid=31207 vsize=2568 CPUtime=0
/proc/31208/stat : 31208 (p2cudf-user-1.1) S 31207 31208 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 66409906 2629632 270 1283457024 134512640 135304128 4288576448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31208/statm: 642 270 230 194 0 29 0
[pid=31209] ppid=31208 vsize=2576 CPUtime=0.02
/proc/31209/stat : 31209 (p2cudf) S 31208 31208 19908 34817 19908 4202496 392 3013 0 1 0 0 2 0 25 0 1 0 66409906 2637824 281 1283457024 134512640 135304128 4292734944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31209/statm: 644 281 239 194 0 31 0
[pid=31222] ppid=31209 vsize=882636 CPUtime=162
/proc/31222/stat : 31222 (java) S 31209 31208 19908 34817 19908 4202496 89501 0 1 0 16168 32 0 0 25 0 11 0 66409910 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31222/statm: 220659 86437 1783 10 0 217750 0
[pid=31222/tid=31223] ppid=31209 vsize=882636 CPUtime=149.01
/proc/31222/task/31223/stat : 31223 (java) R 31209 31208 19908 34817 19908 4202560 50272 0 1 0 14883 18 0 0 25 0 11 0 66409910 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4095559764 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31222/tid=31224] ppid=31209 vsize=882636 CPUtime=10.46
/proc/31222/task/31224/stat : 31224 (java) S 31209 31208 19908 34817 19908 4202560 28074 0 0 0 1037 9 0 0 15 0 11 0 66409912 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 0 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31225] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31225/stat : 31225 (java) S 31209 31208 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 66409912 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31226] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31226/stat : 31226 (java) S 31209 31208 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 66409912 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31227] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31227/stat : 31227 (java) S 31209 31208 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66409915 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31228] ppid=31209 vsize=882636 CPUtime=2.36
/proc/31222/task/31228/stat : 31228 (java) S 31209 31208 19908 34817 19908 4202560 9434 0 0 0 234 2 0 0 16 0 11 0 66409915 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31229] ppid=31209 vsize=882636 CPUtime=0.13
/proc/31222/task/31229/stat : 31229 (java) S 31209 31208 19908 34817 19908 4202560 643 0 0 0 12 1 0 0 23 0 11 0 66409915 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31230] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31230/stat : 31230 (java) S 31209 31208 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 66409915 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31231] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31231/stat : 31231 (java) S 31209 31208 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 66409915 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31233] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31233/stat : 31233 (java) S 31209 31208 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 66410308 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 162.02
Current children cumulated vsize (KiB) 887780

[startup+222.304 s]
/proc/loadavg: 1.08 1.05 1.01 2/46 31236
/proc/meminfo: memFree=317744/1048576 swapFree=0/0
[pid=31208] ppid=31207 vsize=2568 CPUtime=0
/proc/31208/stat : 31208 (p2cudf-user-1.1) S 31207 31208 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 66409906 2629632 270 1283457024 134512640 135304128 4288576448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31208/statm: 642 270 230 194 0 29 0
[pid=31209] ppid=31208 vsize=2576 CPUtime=0.02
/proc/31209/stat : 31209 (p2cudf) S 31208 31208 19908 34817 19908 4202496 392 3013 0 1 0 0 2 0 25 0 1 0 66409906 2637824 281 1283457024 134512640 135304128 4292734944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31209/statm: 644 281 239 194 0 31 0
[pid=31222] ppid=31209 vsize=882636 CPUtime=221.87
/proc/31222/stat : 31222 (java) S 31209 31208 19908 34817 19908 4202496 89501 0 1 0 22155 32 0 0 25 0 11 0 66409910 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31222/statm: 220659 86437 1783 10 0 217750 0
[pid=31222/tid=31223] ppid=31209 vsize=882636 CPUtime=205.76
/proc/31222/task/31223/stat : 31223 (java) R 31209 31208 19908 34817 19908 4202560 50272 0 1 0 20557 19 0 0 25 0 11 0 66409910 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4095609572 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31222/tid=31224] ppid=31209 vsize=882636 CPUtime=13.59
/proc/31222/task/31224/stat : 31224 (java) S 31209 31208 19908 34817 19908 4202560 28074 0 0 0 1350 9 0 0 15 0 11 0 66409912 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 0 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31225] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31225/stat : 31225 (java) S 31209 31208 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 66409912 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31226] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31226/stat : 31226 (java) S 31209 31208 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 66409912 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31227] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31227/stat : 31227 (java) S 31209 31208 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66409915 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31228] ppid=31209 vsize=882636 CPUtime=2.36
/proc/31222/task/31228/stat : 31228 (java) S 31209 31208 19908 34817 19908 4202560 9434 0 0 0 234 2 0 0 16 0 11 0 66409915 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31229] ppid=31209 vsize=882636 CPUtime=0.13
/proc/31222/task/31229/stat : 31229 (java) S 31209 31208 19908 34817 19908 4202560 643 0 0 0 12 1 0 0 23 0 11 0 66409915 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31230] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31230/stat : 31230 (java) S 31209 31208 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 66409915 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31231] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31231/stat : 31231 (java) S 31209 31208 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 66409915 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31233] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31233/stat : 31233 (java) S 31209 31208 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 66410308 903819264 86437 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 221.89
Current children cumulated vsize (KiB) 887780

[startup+282.308 s]
/proc/loadavg: 1.11 1.05 1.01 3/46 31236
/proc/meminfo: memFree=314892/1048576 swapFree=0/0
[pid=31208] ppid=31207 vsize=2568 CPUtime=0
/proc/31208/stat : 31208 (p2cudf-user-1.1) S 31207 31208 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 66409906 2629632 270 1283457024 134512640 135304128 4288576448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31208/statm: 642 270 230 194 0 29 0
[pid=31209] ppid=31208 vsize=2576 CPUtime=0.02
/proc/31209/stat : 31209 (p2cudf) S 31208 31208 19908 34817 19908 4202496 392 3013 0 1 0 0 2 0 25 0 1 0 66409906 2637824 281 1283457024 134512640 135304128 4292734944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31209/statm: 644 281 239 194 0 31 0
[pid=31222] ppid=31209 vsize=882636 CPUtime=281.79
/proc/31222/stat : 31222 (java) S 31209 31208 19908 34817 19908 4202496 90206 0 1 0 28147 32 0 0 25 0 11 0 66409910 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31222/statm: 220659 87142 1783 10 0 217750 0
[pid=31222/tid=31223] ppid=31209 vsize=882636 CPUtime=262.25
/proc/31222/task/31223/stat : 31223 (java) R 31209 31208 19908 34817 19908 4202560 50272 0 1 0 26206 19 0 0 25 0 11 0 66409910 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4095609656 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31222/tid=31224] ppid=31209 vsize=882636 CPUtime=16.99
/proc/31222/task/31224/stat : 31224 (java) S 31209 31208 19908 34817 19908 4202560 28779 0 0 0 1690 9 0 0 16 0 11 0 66409912 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 0 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31225] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31225/stat : 31225 (java) S 31209 31208 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 66409912 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31226] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31226/stat : 31226 (java) S 31209 31208 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 66409912 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31227] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31227/stat : 31227 (java) S 31209 31208 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66409915 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31228] ppid=31209 vsize=882636 CPUtime=2.39
/proc/31222/task/31228/stat : 31228 (java) S 31209 31208 19908 34817 19908 4202560 9434 0 0 0 237 2 0 0 15 0 11 0 66409915 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31229] ppid=31209 vsize=882636 CPUtime=0.13
/proc/31222/task/31229/stat : 31229 (java) S 31209 31208 19908 34817 19908 4202560 643 0 0 0 12 1 0 0 23 0 11 0 66409915 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31230] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31230/stat : 31230 (java) S 31209 31208 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 66409915 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31231] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31231/stat : 31231 (java) S 31209 31208 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 66409915 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31233] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31233/stat : 31233 (java) S 31209 31208 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 66410308 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 281.81
Current children cumulated vsize (KiB) 887780

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

[startup+283.008 s]
/proc/loadavg: 1.10 1.05 1.01 3/46 31236
/proc/meminfo: memFree=314768/1048576 swapFree=0/0
[pid=31208] ppid=31207 vsize=2568 CPUtime=0
/proc/31208/stat : 31208 (p2cudf-user-1.1) S 31207 31208 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 66409906 2629632 270 1283457024 134512640 135304128 4288576448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31208/statm: 642 270 230 194 0 29 0
[pid=31209] ppid=31208 vsize=2576 CPUtime=0.02
/proc/31209/stat : 31209 (p2cudf) S 31208 31208 19908 34817 19908 4202496 392 3013 0 1 0 0 2 0 25 0 1 0 66409906 2637824 281 1283457024 134512640 135304128 4292734944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31209/statm: 644 281 239 194 0 31 0
[pid=31222] ppid=31209 vsize=882636 CPUtime=282.49
/proc/31222/stat : 31222 (java) S 31209 31208 19908 34817 19908 4202496 90206 0 1 0 28217 32 0 0 25 0 11 0 66409910 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31222/statm: 220659 87142 1783 10 0 217750 0
[pid=31222/tid=31223] ppid=31209 vsize=882636 CPUtime=262.95
/proc/31222/task/31223/stat : 31223 (java) R 31209 31208 19908 34817 19908 4202560 50272 0 1 0 26276 19 0 0 25 0 11 0 66409910 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4095609638 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31222/tid=31224] ppid=31209 vsize=882636 CPUtime=16.99
/proc/31222/task/31224/stat : 31224 (java) S 31209 31208 19908 34817 19908 4202560 28779 0 0 0 1690 9 0 0 15 0 11 0 66409912 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 0 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31225] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31225/stat : 31225 (java) S 31209 31208 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 66409912 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31226] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31226/stat : 31226 (java) S 31209 31208 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 66409912 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31227] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31227/stat : 31227 (java) S 31209 31208 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66409915 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31228] ppid=31209 vsize=882636 CPUtime=2.39
/proc/31222/task/31228/stat : 31228 (java) S 31209 31208 19908 34817 19908 4202560 9434 0 0 0 237 2 0 0 15 0 11 0 66409915 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31229] ppid=31209 vsize=882636 CPUtime=0.13
/proc/31222/task/31229/stat : 31229 (java) S 31209 31208 19908 34817 19908 4202560 643 0 0 0 12 1 0 0 23 0 11 0 66409915 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31230] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31230/stat : 31230 (java) S 31209 31208 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 66409915 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31231] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31231/stat : 31231 (java) S 31209 31208 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 66409915 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31233] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31233/stat : 31233 (java) S 31209 31208 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 66410308 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 282.51
Current children cumulated vsize (KiB) 887780

[startup+283.809 s]
/proc/loadavg: 1.10 1.05 1.01 2/46 31236
/proc/meminfo: memFree=314768/1048576 swapFree=0/0
[pid=31208] ppid=31207 vsize=2568 CPUtime=0
/proc/31208/stat : 31208 (p2cudf-user-1.1) S 31207 31208 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 66409906 2629632 270 1283457024 134512640 135304128 4288576448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31208/statm: 642 270 230 194 0 29 0
[pid=31209] ppid=31208 vsize=2576 CPUtime=0.02
/proc/31209/stat : 31209 (p2cudf) S 31208 31208 19908 34817 19908 4202496 392 3013 0 1 0 0 2 0 25 0 1 0 66409906 2637824 281 1283457024 134512640 135304128 4292734944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31209/statm: 644 281 239 194 0 31 0
[pid=31222] ppid=31209 vsize=882636 CPUtime=283.29
/proc/31222/stat : 31222 (java) S 31209 31208 19908 34817 19908 4202496 90206 0 1 0 28297 32 0 0 25 0 11 0 66409910 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31222/statm: 220659 87142 1783 10 0 217750 0
[pid=31222/tid=31223] ppid=31209 vsize=882636 CPUtime=263.75
/proc/31222/task/31223/stat : 31223 (java) R 31209 31208 19908 34817 19908 4202560 50272 0 1 0 26356 19 0 0 25 0 11 0 66409910 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4095612612 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31222/tid=31224] ppid=31209 vsize=882636 CPUtime=16.99
/proc/31222/task/31224/stat : 31224 (java) S 31209 31208 19908 34817 19908 4202560 28779 0 0 0 1690 9 0 0 15 0 11 0 66409912 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 0 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31225] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31225/stat : 31225 (java) S 31209 31208 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 66409912 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31226] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31226/stat : 31226 (java) S 31209 31208 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 66409912 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31227] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31227/stat : 31227 (java) S 31209 31208 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66409915 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31228] ppid=31209 vsize=882636 CPUtime=2.39
/proc/31222/task/31228/stat : 31228 (java) S 31209 31208 19908 34817 19908 4202560 9434 0 0 0 237 2 0 0 15 0 11 0 66409915 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31229] ppid=31209 vsize=882636 CPUtime=0.13
/proc/31222/task/31229/stat : 31229 (java) S 31209 31208 19908 34817 19908 4202560 643 0 0 0 12 1 0 0 23 0 11 0 66409915 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31230] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31230/stat : 31230 (java) S 31209 31208 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 66409915 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31231] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31231/stat : 31231 (java) S 31209 31208 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 66409915 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31233] ppid=31209 vsize=882636 CPUtime=0
/proc/31222/task/31233/stat : 31233 (java) S 31209 31208 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 66410308 903819264 87142 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.31
Current children cumulated vsize (KiB) 887780

[startup+284.207 s]
/proc/loadavg: 1.10 1.05 1.01 2/46 31236
/proc/meminfo: memFree=314768/1048576 swapFree=0/0
[pid=31208] ppid=31207 vsize=2568 CPUtime=0
/proc/31208/stat : 31208 (p2cudf-user-1.1) S 31207 31208 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 66409906 2629632 270 1283457024 134512640 135304128 4288576448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31208/statm: 642 270 230 194 0 29 0
[pid=31209] ppid=31208 vsize=2576 CPUtime=0.02
/proc/31209/stat : 31209 (p2cudf) S 31208 31208 19908 34817 19908 4202496 392 3013 0 1 0 0 2 0 25 0 1 0 66409906 2637824 281 1283457024 134512640 135304128 4292734944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31209/statm: 644 281 239 194 0 31 0
[pid=31222] ppid=31209 vsize=882960 CPUtime=283.53
/proc/31222/stat : 31222 (java) S 31209 31208 19908 34817 19908 4202496 90220 0 1 0 28321 32 0 0 25 0 11 0 66409910 904151040 87156 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31222/statm: 220740 87156 1784 10 0 217831 0
[pid=31222/tid=31223] ppid=31209 vsize=882960 CPUtime=263.98
/proc/31222/task/31223/stat : 31223 (java) S 31209 31208 19908 34817 19908 4202560 50280 0 1 0 26379 19 0 0 25 0 11 0 66409910 904151040 87156 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31224] ppid=31209 vsize=882960 CPUtime=16.99
/proc/31222/task/31224/stat : 31224 (java) S 31209 31208 19908 34817 19908 4202560 28779 0 0 0 1690 9 0 0 16 0 11 0 66409912 904151040 87156 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 0 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31225] ppid=31209 vsize=882960 CPUtime=0
/proc/31222/task/31225/stat : 31225 (java) S 31209 31208 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 66409912 904151040 87156 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31226] ppid=31209 vsize=882960 CPUtime=0
/proc/31222/task/31226/stat : 31226 (java) S 31209 31208 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 66409912 904151040 87156 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31227] ppid=31209 vsize=882960 CPUtime=0
/proc/31222/task/31227/stat : 31227 (java) S 31209 31208 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66409915 904151040 87156 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31228] ppid=31209 vsize=882960 CPUtime=2.4
/proc/31222/task/31228/stat : 31228 (java) S 31209 31208 19908 34817 19908 4202560 9434 0 0 0 238 2 0 0 15 0 11 0 66409915 904151040 87156 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31229] ppid=31209 vsize=882960 CPUtime=0.13
/proc/31222/task/31229/stat : 31229 (java) S 31209 31208 19908 34817 19908 4202560 643 0 0 0 12 1 0 0 23 0 11 0 66409915 904151040 87156 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31230] ppid=31209 vsize=882960 CPUtime=0
/proc/31222/task/31230/stat : 31230 (java) S 31209 31208 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 66409915 904151040 87156 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31231] ppid=31209 vsize=882960 CPUtime=0
/proc/31222/task/31231/stat : 31231 (java) S 31209 31208 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 66409915 904151040 87156 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.55
Current children cumulated vsize (KiB) 888104

[startup+284.618 s]
/proc/loadavg: 1.10 1.05 1.01 2/46 31236
/proc/meminfo: memFree=314768/1048576 swapFree=0/0
[pid=31208] ppid=31207 vsize=2568 CPUtime=0
/proc/31208/stat : 31208 (p2cudf-user-1.1) S 31207 31208 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 66409906 2629632 270 1283457024 134512640 135304128 4288576448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31208/statm: 642 270 230 194 0 29 0
[pid=31209] ppid=31208 vsize=2576 CPUtime=0.02
/proc/31209/stat : 31209 (p2cudf) S 31208 31208 19908 34817 19908 4202496 392 3013 0 1 0 0 2 0 25 0 1 0 66409906 2637824 281 1283457024 134512640 135304128 4292734944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31209/statm: 644 281 239 194 0 31 0
[pid=31222] ppid=31209 vsize=882960 CPUtime=283.59
/proc/31222/stat : 31222 (java) S 31209 31208 19908 34817 19908 4202496 90221 0 1 0 28325 34 0 0 25 0 11 0 66409910 904151040 87157 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31222/statm: 220740 87157 1784 10 0 217831 0
[pid=31222/tid=31223] ppid=31209 vsize=882960 CPUtime=263.98
/proc/31222/task/31223/stat : 31223 (java) S 31209 31208 19908 34817 19908 4202560 50280 0 1 0 26379 19 0 0 25 0 11 0 66409910 904151040 87157 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31224] ppid=31209 vsize=882960 CPUtime=16.99
/proc/31222/task/31224/stat : 31224 (java) S 31209 31208 19908 34817 19908 4202560 28779 0 0 0 1690 9 0 0 16 0 11 0 66409912 904151040 87157 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 0 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31225] ppid=31209 vsize=882960 CPUtime=0
/proc/31222/task/31225/stat : 31225 (java) S 31209 31208 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 66409912 904151040 87157 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31226] ppid=31209 vsize=882960 CPUtime=0
/proc/31222/task/31226/stat : 31226 (java) S 31209 31208 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 66409912 904151040 87157 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31227] ppid=31209 vsize=882960 CPUtime=0
/proc/31222/task/31227/stat : 31227 (java) S 31209 31208 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66409915 904151040 87157 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31228] ppid=31209 vsize=882960 CPUtime=2.42
/proc/31222/task/31228/stat : 31228 (java) S 31209 31208 19908 34817 19908 4202560 9434 0 0 0 240 2 0 0 15 0 11 0 66409915 904151040 87157 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31229] ppid=31209 vsize=882960 CPUtime=0.13
/proc/31222/task/31229/stat : 31229 (java) S 31209 31208 19908 34817 19908 4202560 643 0 0 0 12 1 0 0 23 0 11 0 66409915 904151040 87157 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31230] ppid=31209 vsize=882960 CPUtime=0
/proc/31222/task/31230/stat : 31230 (java) S 31209 31208 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 11 0 66409915 904151040 87157 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
[pid=31222/tid=31231] ppid=31209 vsize=882960 CPUtime=0
/proc/31222/task/31231/stat : 31231 (java) S 31209 31208 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 66409915 904151040 87157 1283457024 134512640 134550932 4287400288 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.61
Current children cumulated vsize (KiB) 888104

[startup+284.707 s]
/proc/loadavg: 1.10 1.05 1.01 2/37 31237
/proc/meminfo: memFree=635936/1048576 swapFree=0/0
[pid=31208] ppid=31207 vsize=2568 CPUtime=0
/proc/31208/stat : 31208 (p2cudf-user-1.1) S 31207 31208 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 66409906 2629632 270 1283457024 134512640 135304128 4288576448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31208/statm: 642 270 230 194 0 29 0
[pid=31209] ppid=31208 vsize=2576 CPUtime=0.02
/proc/31209/stat : 31209 (p2cudf) S 31208 31208 19908 34817 19908 4202496 392 3013 0 1 0 0 2 0 25 0 1 0 66409906 2637824 281 1283457024 134512640 135304128 4292734944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31209/statm: 644 281 239 194 0 31 0
[pid=31222] ppid=31209 vsize=0 CPUtime=283.63
/proc/31222/stat : 31222 (java) Z 31209 31208 19908 34817 19908 4203532 90226 0 1 0 28327 36 0 0 18 0 2 0 66409910 0 0 1283457024 0 0 0 0 0 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31222/statm: 0 0 0 0 0 0 0
[pid=31222/tid=31223] ppid=31209 vsize=0 CPUtime=264
/proc/31222/task/31223/stat : 31223 (java) R 31209 31208 19908 34817 19908 4203588 50280 0 1 0 26379 21 0 0 19 0 2 0 66409910 0 0 1283457024 0 0 0 0 0 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.65
Current children cumulated vsize (KiB) 5144

Child status: 0
Real time (s): 284.711
CPU time (s): 283.662
CPU user time (s): 283.294
CPU system time (s): 0.368023
CPU usage (%): 99.6315
Max. virtual memory (cumulated for all children) (KiB): 888104

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 283.294
system time used= 0.368023
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 94025
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= 8765

runsolver used 0.012 second user time and 0 second system time

The end