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/rand434.cudf.dudf-random.log.runsolver ./p2cudf-user-1.13 /home/misc2010/data/2011/dudf-random//rand434.cudf /home/misc2010/tmp/201108311143/p2cudf-user-1.13/rand434.cudf.dudf-random.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.02 1.01 5/41 23170
/proc/meminfo: memFree=657952/1048576 swapFree=0/0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0
/proc/23167/stat : 23167 (p2cudf-user-1.1) S 23166 23167 19908 34817 19908 4202496 376 0 0 0 0 0 0 0 18 0 1 0 62353419 2633728 271 1283457024 134512640 135304128 4292224880 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 271 230 194 0 30 0
[pid=23168] ppid=23167 vsize=2568 CPUtime=0
/proc/23168/stat : 23168 (p2cudf) S 23167 23167 19908 34817 19908 4202496 354 0 0 0 0 0 0 0 18 0 1 0 62353419 2629632 272 1283457024 134512640 135304128 4292503520 18446744073709551615 4294960130 0 0 4 65536 18446744071564457842 0 0 17 0 0 0 0
/proc/23168/statm: 642 272 231 194 0 29 0
[pid=23169] ppid=23168 vsize=2568 CPUtime=0
/proc/23169/stat : 23169 (p2cudf) R 23168 23167 19908 34817 19908 4202560 94 0 0 0 0 0 0 0 25 0 1 0 62353419 2629632 119 1283457024 134512640 135304128 4292503520 18446744073709551615 4294960130 0 65538 0 65538 0 0 0 17 0 0 0 0
/proc/23169/statm: 642 119 77 194 0 29 0
[pid=23170] ppid=23169 vsize=2568 CPUtime=0
/proc/23170/stat : 23170 (p2cudf) R 23169 23167 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 1 0 62353419 2629632 42 1283457024 134512640 135304128 4292503520 18446744073709551615 4294960130 0 65538 0 65538 0 0 0 17 0 0 0 0
/proc/23170/statm: 642 42 0 194 0 29 0

[startup+0.175741 s]
/proc/loadavg: 1.07 1.02 1.01 5/41 23170
/proc/meminfo: memFree=657952/1048576 swapFree=0/0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0
/proc/23167/stat : 23167 (p2cudf-user-1.1) S 23166 23167 19908 34817 19908 4202496 376 0 0 0 0 0 0 0 18 0 1 0 62353419 2633728 271 1283457024 134512640 135304128 4292224880 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 271 230 194 0 30 0
[pid=23168] ppid=23167 vsize=2576 CPUtime=0.03
/proc/23168/stat : 23168 (p2cudf) S 23167 23167 19908 34817 19908 4202496 394 3016 0 1 0 1 2 0 25 0 1 0 62353419 2637824 282 1283457024 134512640 135304128 4292503520 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23168/statm: 644 282 239 194 0 31 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5148

[startup+0.205736 s]
/proc/loadavg: 1.07 1.02 1.01 5/41 23170
/proc/meminfo: memFree=657952/1048576 swapFree=0/0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0
/proc/23167/stat : 23167 (p2cudf-user-1.1) S 23166 23167 19908 34817 19908 4202496 376 0 0 0 0 0 0 0 18 0 1 0 62353419 2633728 271 1283457024 134512640 135304128 4292224880 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 271 230 194 0 30 0
[pid=23168] ppid=23167 vsize=2576 CPUtime=0.03
/proc/23168/stat : 23168 (p2cudf) S 23167 23167 19908 34817 19908 4202496 394 3016 0 1 0 1 2 0 25 0 1 0 62353419 2637824 282 1283457024 134512640 135304128 4292503520 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23168/statm: 644 282 239 194 0 31 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5148

[startup+0.305767 s]
/proc/loadavg: 1.07 1.02 1.01 5/41 23170
/proc/meminfo: memFree=657952/1048576 swapFree=0/0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0
/proc/23167/stat : 23167 (p2cudf-user-1.1) S 23166 23167 19908 34817 19908 4202496 376 0 0 0 0 0 0 0 18 0 1 0 62353419 2633728 271 1283457024 134512640 135304128 4292224880 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 271 230 194 0 30 0
[pid=23168] ppid=23167 vsize=2576 CPUtime=0.03
/proc/23168/stat : 23168 (p2cudf) S 23167 23167 19908 34817 19908 4202496 394 3016 0 1 0 1 2 0 25 0 1 0 62353419 2637824 282 1283457024 134512640 135304128 4292503520 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23168/statm: 644 282 239 194 0 31 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5148

[startup+0.705826 s]
/proc/loadavg: 1.07 1.02 1.01 5/41 23170
/proc/meminfo: memFree=657952/1048576 swapFree=0/0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0
/proc/23167/stat : 23167 (p2cudf-user-1.1) S 23166 23167 19908 34817 19908 4202496 376 0 0 0 0 0 0 0 18 0 1 0 62353419 2633728 271 1283457024 134512640 135304128 4292224880 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 271 230 194 0 30 0
[pid=23168] ppid=23167 vsize=2576 CPUtime=0.03
/proc/23168/stat : 23168 (p2cudf) S 23167 23167 19908 34817 19908 4202496 394 3016 0 1 0 1 2 0 25 0 1 0 62353419 2637824 282 1283457024 134512640 135304128 4292503520 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23168/statm: 644 282 239 194 0 31 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5148

[startup+1.506 s]
/proc/loadavg: 1.07 1.02 1.01 3/50 23190
/proc/meminfo: memFree=612308/1048576 swapFree=0/0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0
/proc/23167/stat : 23167 (p2cudf-user-1.1) S 23166 23167 19908 34817 19908 4202496 376 0 0 0 0 0 0 0 18 0 1 0 62353419 2633728 271 1283457024 134512640 135304128 4292224880 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 271 230 194 0 30 0
[pid=23168] ppid=23167 vsize=2576 CPUtime=0.03
/proc/23168/stat : 23168 (p2cudf) S 23167 23167 19908 34817 19908 4202496 394 3016 0 1 0 1 2 0 25 0 1 0 62353419 2637824 282 1283457024 134512640 135304128 4292503520 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23168/statm: 644 282 239 194 0 31 0
[pid=23181] ppid=23168 vsize=891356 CPUtime=1.46
/proc/23181/stat : 23181 (java) S 23168 23167 19908 34817 19908 4202496 23193 0 1 0 132 14 0 0 25 0 10 0 62353423 912748544 19778 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23181/statm: 222839 19778 1726 10 0 219930 0
[pid=23181/tid=23182] ppid=23168 vsize=891356 CPUtime=0.8
/proc/23181/task/23182/stat : 23182 (java) R 23168 23167 19908 34817 19908 4202560 10537 0 1 0 76 4 0 0 25 0 10 0 62353423 912748544 19778 1283457024 134512640 134550932 4292484720 18446744073709551615 4094977066 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23181/tid=23183] ppid=23168 vsize=891356 CPUtime=0
/proc/23181/task/23183/stat : 23183 (java) S 23168 23167 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 10 0 62353425 912748544 19778 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 0 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23184] ppid=23168 vsize=891356 CPUtime=0
/proc/23181/task/23184/stat : 23184 (java) S 23168 23167 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 25 0 10 0 62353425 912748544 19778 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23185] ppid=23168 vsize=891356 CPUtime=0
/proc/23181/task/23185/stat : 23185 (java) S 23168 23167 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 10 0 62353425 912748544 19778 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23186] ppid=23168 vsize=891356 CPUtime=0
/proc/23181/task/23186/stat : 23186 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 62353428 912748544 19778 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23187] ppid=23168 vsize=891356 CPUtime=0.39
/proc/23181/task/23187/stat : 23187 (java) R 23168 23167 19908 34817 19908 4202560 5798 0 0 0 36 3 0 0 25 0 10 0 62353428 912748544 19778 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23181/tid=23188] ppid=23168 vsize=891356 CPUtime=0.26
/proc/23181/task/23188/stat : 23188 (java) R 23168 23167 19908 34817 19908 4202560 5780 0 0 0 20 6 0 0 18 0 10 0 62353428 912748544 19778 1283457024 134512640 134550932 4292484720 18446744073709551615 4149609718 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23181/tid=23189] ppid=23168 vsize=891356 CPUtime=0
/proc/23181/task/23189/stat : 23189 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 62353428 912748544 19778 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23190] ppid=23168 vsize=891356 CPUtime=0
/proc/23181/task/23190/stat : 23190 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 10 0 62353428 912748544 19778 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 1.49
Current children cumulated vsize (KiB) 896504

[startup+3.11638 s]
/proc/loadavg: 1.07 1.02 1.01 3/50 23191
/proc/meminfo: memFree=506784/1048576 swapFree=0/0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0
/proc/23167/stat : 23167 (p2cudf-user-1.1) S 23166 23167 19908 34817 19908 4202496 376 0 0 0 0 0 0 0 18 0 1 0 62353419 2633728 271 1283457024 134512640 135304128 4292224880 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 271 230 194 0 30 0
[pid=23168] ppid=23167 vsize=2576 CPUtime=0.03
/proc/23168/stat : 23168 (p2cudf) S 23167 23167 19908 34817 19908 4202496 394 3016 0 1 0 1 2 0 25 0 1 0 62353419 2637824 282 1283457024 134512640 135304128 4292503520 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23168/statm: 644 282 239 194 0 31 0
[pid=23181] ppid=23168 vsize=887524 CPUtime=3.07
/proc/23181/stat : 23181 (java) S 23168 23167 19908 34817 19908 4202496 56344 0 1 0 280 27 0 0 25 0 10 0 62353423 908824576 51923 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23181/statm: 221881 51923 1754 10 0 218972 0
[pid=23181/tid=23182] ppid=23168 vsize=887524 CPUtime=1.7
/proc/23181/task/23182/stat : 23182 (java) R 23168 23167 19908 34817 19908 4202560 42707 0 1 0 153 17 0 0 25 0 10 0 62353423 908824576 51923 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23181/tid=23183] ppid=23168 vsize=887524 CPUtime=0
/proc/23181/task/23183/stat : 23183 (java) S 23168 23167 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 10 0 62353425 908824576 51923 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 0 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23184] ppid=23168 vsize=887524 CPUtime=0
/proc/23181/task/23184/stat : 23184 (java) S 23168 23167 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 25 0 10 0 62353425 908824576 51923 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23185] ppid=23168 vsize=887524 CPUtime=0
/proc/23181/task/23185/stat : 23185 (java) S 23168 23167 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 10 0 62353425 908824576 51923 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23186] ppid=23168 vsize=887524 CPUtime=0
/proc/23181/task/23186/stat : 23186 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 62353428 908824576 51923 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23187] ppid=23168 vsize=887524 CPUtime=0.72
/proc/23181/task/23187/stat : 23187 (java) R 23168 23167 19908 34817 19908 4202560 6237 0 0 0 69 3 0 0 24 0 10 0 62353428 908824576 51923 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23181/tid=23188] ppid=23168 vsize=887524 CPUtime=0.64
/proc/23181/task/23188/stat : 23188 (java) R 23168 23167 19908 34817 19908 4202560 6322 0 0 0 58 6 0 0 15 0 10 0 62353428 908824576 51923 1283457024 134512640 134550932 4292484720 18446744073709551615 4147494255 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23181/tid=23189] ppid=23168 vsize=887524 CPUtime=0
/proc/23181/task/23189/stat : 23189 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 62353428 908824576 51923 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23190] ppid=23168 vsize=887524 CPUtime=0
/proc/23181/task/23190/stat : 23190 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 10 0 62353428 908824576 51923 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 3.1
Current children cumulated vsize (KiB) 892672

[startup+6.30716 s]
/proc/loadavg: 1.07 1.02 1.00 3/51 23192
/proc/meminfo: memFree=437460/1048576 swapFree=0/0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0
/proc/23167/stat : 23167 (p2cudf-user-1.1) S 23166 23167 19908 34817 19908 4202496 376 0 0 0 0 0 0 0 18 0 1 0 62353419 2633728 271 1283457024 134512640 135304128 4292224880 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 271 230 194 0 30 0
[pid=23168] ppid=23167 vsize=2576 CPUtime=0.03
/proc/23168/stat : 23168 (p2cudf) S 23167 23167 19908 34817 19908 4202496 394 3016 0 1 0 1 2 0 25 0 1 0 62353419 2637824 282 1283457024 134512640 135304128 4292503520 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23168/statm: 644 282 239 194 0 31 0
[pid=23181] ppid=23168 vsize=887400 CPUtime=6.26
/proc/23181/stat : 23181 (java) S 23168 23167 19908 34817 19908 4202496 72145 0 1 0 592 34 0 0 25 0 11 0 62353423 908697600 66716 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23181/statm: 221850 66716 1781 10 0 218941 0
[pid=23181/tid=23182] ppid=23168 vsize=887400 CPUtime=3.49
/proc/23181/task/23182/stat : 23182 (java) R 23168 23167 19908 34817 19908 4202560 47294 0 1 0 328 21 0 0 25 0 11 0 62353423 908697600 66716 1283457024 134512640 134550932 4292484720 18446744073709551615 4095597730 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23181/tid=23183] ppid=23168 vsize=887400 CPUtime=0.34
/proc/23181/task/23183/stat : 23183 (java) S 23168 23167 19908 34817 19908 4202560 10131 0 0 0 32 2 0 0 16 0 11 0 62353425 908697600 66716 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 0 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23184] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23184/stat : 23184 (java) S 23168 23167 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 62353425 908697600 66716 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23185] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23185/stat : 23185 (java) S 23168 23167 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 62353425 908697600 66716 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23186] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23186/stat : 23186 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62353428 908697600 66716 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23187] ppid=23168 vsize=887400 CPUtime=1.19
/proc/23181/task/23187/stat : 23187 (java) S 23168 23167 19908 34817 19908 4202560 6295 0 0 0 116 3 0 0 15 0 11 0 62353428 908697600 66716 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23188] ppid=23168 vsize=887400 CPUtime=1.22
/proc/23181/task/23188/stat : 23188 (java) S 23168 23167 19908 34817 19908 4202560 7346 0 0 0 116 6 0 0 15 0 11 0 62353428 908697600 66716 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23189] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23189/stat : 23189 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62353428 908697600 66716 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23190] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23190/stat : 23190 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 62353428 908697600 66716 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23192] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23192/stat : 23192 (java) S 23168 23167 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 62353792 908697600 66716 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 6.29
Current children cumulated vsize (KiB) 892548

[startup+12.7086 s]
/proc/loadavg: 1.06 1.02 1.00 2/51 23193
/proc/meminfo: memFree=395548/1048576 swapFree=0/0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0
/proc/23167/stat : 23167 (p2cudf-user-1.1) S 23166 23167 19908 34817 19908 4202496 376 0 0 0 0 0 0 0 18 0 1 0 62353419 2633728 271 1283457024 134512640 135304128 4292224880 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 271 230 194 0 30 0
[pid=23168] ppid=23167 vsize=2576 CPUtime=0.03
/proc/23168/stat : 23168 (p2cudf) S 23167 23167 19908 34817 19908 4202496 394 3016 0 1 0 1 2 0 25 0 1 0 62353419 2637824 282 1283457024 134512640 135304128 4292503520 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23168/statm: 644 282 239 194 0 31 0
[pid=23181] ppid=23168 vsize=887400 CPUtime=12.66
/proc/23181/stat : 23181 (java) S 23168 23167 19908 34817 19908 4202496 72542 0 1 0 1232 34 0 0 25 0 11 0 62353423 908697600 67113 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23181/statm: 221850 67113 1783 10 0 218941 0
[pid=23181/tid=23182] ppid=23168 vsize=887400 CPUtime=9.12
/proc/23181/task/23182/stat : 23182 (java) R 23168 23167 19908 34817 19908 4202560 47294 0 1 0 891 21 0 0 25 0 11 0 62353423 908697600 67113 1283457024 134512640 134550932 4292484720 18446744073709551615 4095599236 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23181/tid=23183] ppid=23168 vsize=887400 CPUtime=0.99
/proc/23181/task/23183/stat : 23183 (java) S 23168 23167 19908 34817 19908 4202560 10511 0 0 0 97 2 0 0 16 0 11 0 62353425 908697600 67113 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 0 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23184] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23184/stat : 23184 (java) S 23168 23167 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 62353425 908697600 67113 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23185] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23185/stat : 23185 (java) S 23168 23167 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 62353425 908697600 67113 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23186] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23186/stat : 23186 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62353428 908697600 67113 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23187] ppid=23168 vsize=887400 CPUtime=1.29
/proc/23181/task/23187/stat : 23187 (java) S 23168 23167 19908 34817 19908 4202560 6312 0 0 0 126 3 0 0 16 0 11 0 62353428 908697600 67113 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23188] ppid=23168 vsize=887400 CPUtime=1.22
/proc/23181/task/23188/stat : 23188 (java) S 23168 23167 19908 34817 19908 4202560 7346 0 0 0 116 6 0 0 15 0 11 0 62353428 908697600 67113 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23189] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23189/stat : 23189 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62353428 908697600 67113 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23190] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23190/stat : 23190 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 62353428 908697600 67113 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23192] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23192/stat : 23192 (java) S 23168 23167 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 62353792 908697600 67113 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 12.69
Current children cumulated vsize (KiB) 892548

[startup+25.5116 s]
/proc/loadavg: 1.05 1.02 1.00 2/51 23194
/proc/meminfo: memFree=393068/1048576 swapFree=0/0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0
/proc/23167/stat : 23167 (p2cudf-user-1.1) S 23166 23167 19908 34817 19908 4202496 376 0 0 0 0 0 0 0 18 0 1 0 62353419 2633728 271 1283457024 134512640 135304128 4292224880 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 271 230 194 0 30 0
[pid=23168] ppid=23167 vsize=2576 CPUtime=0.03
/proc/23168/stat : 23168 (p2cudf) S 23167 23167 19908 34817 19908 4202496 394 3016 0 1 0 1 2 0 25 0 1 0 62353419 2637824 282 1283457024 134512640 135304128 4292503520 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23168/statm: 644 282 239 194 0 31 0
[pid=23181] ppid=23168 vsize=887400 CPUtime=25.45
/proc/23181/stat : 23181 (java) S 23168 23167 19908 34817 19908 4202496 73146 0 1 0 2511 34 0 0 25 0 11 0 62353423 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23181/statm: 221850 67717 1783 10 0 218941 0
[pid=23181/tid=23182] ppid=23168 vsize=887400 CPUtime=20.95
/proc/23181/task/23182/stat : 23182 (java) R 23168 23167 19908 34817 19908 4202560 47294 0 1 0 2073 22 0 0 25 0 11 0 62353423 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4095577986 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23181/tid=23183] ppid=23168 vsize=887400 CPUtime=1.96
/proc/23181/task/23183/stat : 23183 (java) S 23168 23167 19908 34817 19908 4202560 11115 0 0 0 194 2 0 0 15 0 11 0 62353425 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 0 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23184] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23184/stat : 23184 (java) S 23168 23167 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 62353425 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23185] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23185/stat : 23185 (java) S 23168 23167 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 62353425 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23186] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23186/stat : 23186 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23187] ppid=23168 vsize=887400 CPUtime=1.29
/proc/23181/task/23187/stat : 23187 (java) S 23168 23167 19908 34817 19908 4202560 6312 0 0 0 126 3 0 0 15 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23188] ppid=23168 vsize=887400 CPUtime=1.22
/proc/23181/task/23188/stat : 23188 (java) S 23168 23167 19908 34817 19908 4202560 7346 0 0 0 116 6 0 0 15 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23189] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23189/stat : 23189 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23190] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23190/stat : 23190 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23192] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23192/stat : 23192 (java) S 23168 23167 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 62353792 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 25.48
Current children cumulated vsize (KiB) 892548

[startup+51.1071 s]
/proc/loadavg: 1.10 1.03 1.01 3/51 23196
/proc/meminfo: memFree=392944/1048576 swapFree=0/0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0
/proc/23167/stat : 23167 (p2cudf-user-1.1) S 23166 23167 19908 34817 19908 4202496 376 0 0 0 0 0 0 0 18 0 1 0 62353419 2633728 271 1283457024 134512640 135304128 4292224880 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 271 230 194 0 30 0
[pid=23168] ppid=23167 vsize=2576 CPUtime=0.03
/proc/23168/stat : 23168 (p2cudf) S 23167 23167 19908 34817 19908 4202496 394 3016 0 1 0 1 2 0 25 0 1 0 62353419 2637824 282 1283457024 134512640 135304128 4292503520 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23168/statm: 644 282 239 194 0 31 0
[pid=23181] ppid=23168 vsize=887400 CPUtime=51.03
/proc/23181/stat : 23181 (java) S 23168 23167 19908 34817 19908 4202496 73146 0 1 0 5069 34 0 0 25 0 11 0 62353423 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23181/statm: 221850 67717 1783 10 0 218941 0
[pid=23181/tid=23182] ppid=23168 vsize=887400 CPUtime=44.62
/proc/23181/task/23182/stat : 23182 (java) R 23168 23167 19908 34817 19908 4202560 47294 0 1 0 4440 22 0 0 25 0 11 0 62353423 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4095575169 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23181/tid=23183] ppid=23168 vsize=887400 CPUtime=3.88
/proc/23181/task/23183/stat : 23183 (java) S 23168 23167 19908 34817 19908 4202560 11115 0 0 0 386 2 0 0 16 0 11 0 62353425 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 0 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23184] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23184/stat : 23184 (java) S 23168 23167 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 62353425 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23185] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23185/stat : 23185 (java) S 23168 23167 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 62353425 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23186] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23186/stat : 23186 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23187] ppid=23168 vsize=887400 CPUtime=1.29
/proc/23181/task/23187/stat : 23187 (java) S 23168 23167 19908 34817 19908 4202560 6312 0 0 0 126 3 0 0 15 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23188] ppid=23168 vsize=887400 CPUtime=1.22
/proc/23181/task/23188/stat : 23188 (java) S 23168 23167 19908 34817 19908 4202560 7346 0 0 0 116 6 0 0 15 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23189] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23189/stat : 23189 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23190] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23190/stat : 23190 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23192] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23192/stat : 23192 (java) S 23168 23167 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 62353792 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 51.06
Current children cumulated vsize (KiB) 892548

[startup+102.309 s]
/proc/loadavg: 1.09 1.04 1.01 2/50 23200
/proc/meminfo: memFree=392836/1048576 swapFree=0/0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0
/proc/23167/stat : 23167 (p2cudf-user-1.1) S 23166 23167 19908 34817 19908 4202496 376 0 0 0 0 0 0 0 18 0 1 0 62353419 2633728 271 1283457024 134512640 135304128 4292224880 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 271 230 194 0 30 0
[pid=23168] ppid=23167 vsize=2576 CPUtime=0.03
/proc/23168/stat : 23168 (p2cudf) S 23167 23167 19908 34817 19908 4202496 394 3016 0 1 0 1 2 0 25 0 1 0 62353419 2637824 282 1283457024 134512640 135304128 4292503520 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23168/statm: 644 282 239 194 0 31 0
[pid=23181] ppid=23168 vsize=887400 CPUtime=102.2
/proc/23181/stat : 23181 (java) S 23168 23167 19908 34817 19908 4202496 73146 0 1 0 10186 34 0 0 25 0 11 0 62353423 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23181/statm: 221850 67717 1783 10 0 218941 0
[pid=23181/tid=23182] ppid=23168 vsize=887400 CPUtime=92.42
/proc/23181/task/23182/stat : 23182 (java) R 23168 23167 19908 34817 19908 4202560 47294 0 1 0 9220 22 0 0 25 0 11 0 62353423 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4095562416 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23181/tid=23183] ppid=23168 vsize=887400 CPUtime=7.24
/proc/23181/task/23183/stat : 23183 (java) S 23168 23167 19908 34817 19908 4202560 11115 0 0 0 722 2 0 0 16 0 11 0 62353425 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 0 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23184] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23184/stat : 23184 (java) S 23168 23167 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 62353425 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23185] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23185/stat : 23185 (java) S 23168 23167 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 62353425 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23186] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23186/stat : 23186 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23187] ppid=23168 vsize=887400 CPUtime=1.29
/proc/23181/task/23187/stat : 23187 (java) S 23168 23167 19908 34817 19908 4202560 6312 0 0 0 126 3 0 0 15 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23188] ppid=23168 vsize=887400 CPUtime=1.22
/proc/23181/task/23188/stat : 23188 (java) S 23168 23167 19908 34817 19908 4202560 7346 0 0 0 116 6 0 0 15 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23189] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23189/stat : 23189 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23190] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23190/stat : 23190 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23192] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23192/stat : 23192 (java) S 23168 23167 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 62353792 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 102.23
Current children cumulated vsize (KiB) 892548

[startup+162.306 s]
/proc/loadavg: 1.03 1.03 1.00 2/49 23200
/proc/meminfo: memFree=392844/1048576 swapFree=0/0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0
/proc/23167/stat : 23167 (p2cudf-user-1.1) S 23166 23167 19908 34817 19908 4202496 376 0 0 0 0 0 0 0 18 0 1 0 62353419 2633728 271 1283457024 134512640 135304128 4292224880 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 271 230 194 0 30 0
[pid=23168] ppid=23167 vsize=2576 CPUtime=0.03
/proc/23168/stat : 23168 (p2cudf) S 23167 23167 19908 34817 19908 4202496 394 3016 0 1 0 1 2 0 25 0 1 0 62353419 2637824 282 1283457024 134512640 135304128 4292503520 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23168/statm: 644 282 239 194 0 31 0
[pid=23181] ppid=23168 vsize=887400 CPUtime=162.12
/proc/23181/stat : 23181 (java) S 23168 23167 19908 34817 19908 4202496 73146 0 1 0 16177 35 0 0 25 0 11 0 62353423 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23181/statm: 221850 67717 1783 10 0 218941 0
[pid=23181/tid=23182] ppid=23168 vsize=887400 CPUtime=148.34
/proc/23181/task/23182/stat : 23182 (java) R 23168 23167 19908 34817 19908 4202560 47294 0 1 0 14811 23 0 0 25 0 11 0 62353423 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4095570900 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23181/tid=23183] ppid=23168 vsize=887400 CPUtime=11.22
/proc/23181/task/23183/stat : 23183 (java) S 23168 23167 19908 34817 19908 4202560 11115 0 0 0 1120 2 0 0 15 0 11 0 62353425 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 0 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23184] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23184/stat : 23184 (java) S 23168 23167 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 62353425 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23185] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23185/stat : 23185 (java) S 23168 23167 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 62353425 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23186] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23186/stat : 23186 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23187] ppid=23168 vsize=887400 CPUtime=1.31
/proc/23181/task/23187/stat : 23187 (java) S 23168 23167 19908 34817 19908 4202560 6312 0 0 0 128 3 0 0 15 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23188] ppid=23168 vsize=887400 CPUtime=1.22
/proc/23181/task/23188/stat : 23188 (java) S 23168 23167 19908 34817 19908 4202560 7346 0 0 0 116 6 0 0 15 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23189] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23189/stat : 23189 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23190] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23190/stat : 23190 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23192] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23192/stat : 23192 (java) S 23168 23167 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 62353792 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 162.15
Current children cumulated vsize (KiB) 892548

[startup+222.309 s]
/proc/loadavg: 1.01 1.02 1.00 2/49 23200
/proc/meminfo: memFree=392720/1048576 swapFree=0/0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0
/proc/23167/stat : 23167 (p2cudf-user-1.1) S 23166 23167 19908 34817 19908 4202496 376 0 0 0 0 0 0 0 18 0 1 0 62353419 2633728 271 1283457024 134512640 135304128 4292224880 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 271 230 194 0 30 0
[pid=23168] ppid=23167 vsize=2576 CPUtime=0.03
/proc/23168/stat : 23168 (p2cudf) S 23167 23167 19908 34817 19908 4202496 394 3016 0 1 0 1 2 0 25 0 1 0 62353419 2637824 282 1283457024 134512640 135304128 4292503520 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23168/statm: 644 282 239 194 0 31 0
[pid=23181] ppid=23168 vsize=887400 CPUtime=222.06
/proc/23181/stat : 23181 (java) S 23168 23167 19908 34817 19908 4202496 73146 0 1 0 22171 35 0 0 25 0 11 0 62353423 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23181/statm: 221850 67717 1783 10 0 218941 0
[pid=23181/tid=23182] ppid=23168 vsize=887400 CPUtime=204.15
/proc/23181/task/23182/stat : 23182 (java) R 23168 23167 19908 34817 19908 4202560 47294 0 1 0 20392 23 0 0 25 0 11 0 62353423 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4095575119 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23181/tid=23183] ppid=23168 vsize=887400 CPUtime=15.36
/proc/23181/task/23183/stat : 23183 (java) S 23168 23167 19908 34817 19908 4202560 11115 0 0 0 1534 2 0 0 15 0 11 0 62353425 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 0 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23184] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23184/stat : 23184 (java) S 23168 23167 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 62353425 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23185] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23185/stat : 23185 (java) S 23168 23167 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 62353425 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23186] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23186/stat : 23186 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23187] ppid=23168 vsize=887400 CPUtime=1.31
/proc/23181/task/23187/stat : 23187 (java) S 23168 23167 19908 34817 19908 4202560 6312 0 0 0 128 3 0 0 15 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23188] ppid=23168 vsize=887400 CPUtime=1.22
/proc/23181/task/23188/stat : 23188 (java) S 23168 23167 19908 34817 19908 4202560 7346 0 0 0 116 6 0 0 15 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23189] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23189/stat : 23189 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23190] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23190/stat : 23190 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23192] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23192/stat : 23192 (java) S 23168 23167 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 62353792 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 222.09
Current children cumulated vsize (KiB) 892548

[startup+282.311 s]
/proc/loadavg: 1.11 1.06 1.01 3/49 23200
/proc/meminfo: memFree=392720/1048576 swapFree=0/0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0
/proc/23167/stat : 23167 (p2cudf-user-1.1) S 23166 23167 19908 34817 19908 4202496 376 0 0 0 0 0 0 0 18 0 1 0 62353419 2633728 271 1283457024 134512640 135304128 4292224880 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 271 230 194 0 30 0
[pid=23168] ppid=23167 vsize=2576 CPUtime=0.03
/proc/23168/stat : 23168 (p2cudf) S 23167 23167 19908 34817 19908 4202496 394 3016 0 1 0 1 2 0 25 0 1 0 62353419 2637824 282 1283457024 134512640 135304128 4292503520 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23168/statm: 644 282 239 194 0 31 0
[pid=23181] ppid=23168 vsize=887400 CPUtime=282.01
/proc/23181/stat : 23181 (java) S 23168 23167 19908 34817 19908 4202496 73146 0 1 0 28164 37 0 0 25 0 11 0 62353423 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23181/statm: 221850 67717 1783 10 0 218941 0
[pid=23181/tid=23182] ppid=23168 vsize=887400 CPUtime=259.95
/proc/23181/task/23182/stat : 23182 (java) R 23168 23167 19908 34817 19908 4202560 47294 0 1 0 25971 24 0 0 25 0 11 0 62353423 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4095570693 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23181/tid=23183] ppid=23168 vsize=887400 CPUtime=19.51
/proc/23181/task/23183/stat : 23183 (java) S 23168 23167 19908 34817 19908 4202560 11115 0 0 0 1948 3 0 0 16 0 11 0 62353425 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 0 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23184] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23184/stat : 23184 (java) S 23168 23167 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 62353425 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23185] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23185/stat : 23185 (java) S 23168 23167 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 62353425 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23186] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23186/stat : 23186 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23187] ppid=23168 vsize=887400 CPUtime=1.31
/proc/23181/task/23187/stat : 23187 (java) S 23168 23167 19908 34817 19908 4202560 6312 0 0 0 128 3 0 0 15 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23188] ppid=23168 vsize=887400 CPUtime=1.22
/proc/23181/task/23188/stat : 23188 (java) S 23168 23167 19908 34817 19908 4202560 7346 0 0 0 116 6 0 0 15 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23189] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23189/stat : 23189 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23190] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23190/stat : 23190 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23192] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23192/stat : 23192 (java) S 23168 23167 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 62353792 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 282.04
Current children cumulated vsize (KiB) 892548

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

[startup+282.911 s]
/proc/loadavg: 1.11 1.06 1.01 2/49 23200
/proc/meminfo: memFree=392720/1048576 swapFree=0/0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0
/proc/23167/stat : 23167 (p2cudf-user-1.1) S 23166 23167 19908 34817 19908 4202496 376 0 0 0 0 0 0 0 18 0 1 0 62353419 2633728 271 1283457024 134512640 135304128 4292224880 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 271 230 194 0 30 0
[pid=23168] ppid=23167 vsize=2576 CPUtime=0.03
/proc/23168/stat : 23168 (p2cudf) S 23167 23167 19908 34817 19908 4202496 394 3016 0 1 0 1 2 0 25 0 1 0 62353419 2637824 282 1283457024 134512640 135304128 4292503520 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23168/statm: 644 282 239 194 0 31 0
[pid=23181] ppid=23168 vsize=887400 CPUtime=282.61
/proc/23181/stat : 23181 (java) S 23168 23167 19908 34817 19908 4202496 73146 0 1 0 28224 37 0 0 25 0 11 0 62353423 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23181/statm: 221850 67717 1783 10 0 218941 0
[pid=23181/tid=23182] ppid=23168 vsize=887400 CPUtime=260.55
/proc/23181/task/23182/stat : 23182 (java) R 23168 23167 19908 34817 19908 4202560 47294 0 1 0 26031 24 0 0 25 0 11 0 62353423 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4095570990 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23181/tid=23183] ppid=23168 vsize=887400 CPUtime=19.51
/proc/23181/task/23183/stat : 23183 (java) S 23168 23167 19908 34817 19908 4202560 11115 0 0 0 1948 3 0 0 16 0 11 0 62353425 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 0 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23184] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23184/stat : 23184 (java) S 23168 23167 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 62353425 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23185] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23185/stat : 23185 (java) S 23168 23167 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 62353425 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23186] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23186/stat : 23186 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23187] ppid=23168 vsize=887400 CPUtime=1.31
/proc/23181/task/23187/stat : 23187 (java) S 23168 23167 19908 34817 19908 4202560 6312 0 0 0 128 3 0 0 15 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23188] ppid=23168 vsize=887400 CPUtime=1.22
/proc/23181/task/23188/stat : 23188 (java) S 23168 23167 19908 34817 19908 4202560 7346 0 0 0 116 6 0 0 15 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23189] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23189/stat : 23189 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23190] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23190/stat : 23190 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23192] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23192/stat : 23192 (java) S 23168 23167 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 62353792 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 282.64
Current children cumulated vsize (KiB) 892548

[startup+283.711 s]
/proc/loadavg: 1.11 1.06 1.01 2/49 23200
/proc/meminfo: memFree=392720/1048576 swapFree=0/0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0
/proc/23167/stat : 23167 (p2cudf-user-1.1) S 23166 23167 19908 34817 19908 4202496 376 0 0 0 0 0 0 0 18 0 1 0 62353419 2633728 271 1283457024 134512640 135304128 4292224880 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 271 230 194 0 30 0
[pid=23168] ppid=23167 vsize=2576 CPUtime=0.03
/proc/23168/stat : 23168 (p2cudf) S 23167 23167 19908 34817 19908 4202496 394 3016 0 1 0 1 2 0 25 0 1 0 62353419 2637824 282 1283457024 134512640 135304128 4292503520 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23168/statm: 644 282 239 194 0 31 0
[pid=23181] ppid=23168 vsize=887400 CPUtime=283.41
/proc/23181/stat : 23181 (java) S 23168 23167 19908 34817 19908 4202496 73146 0 1 0 28304 37 0 0 25 0 11 0 62353423 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23181/statm: 221850 67717 1783 10 0 218941 0
[pid=23181/tid=23182] ppid=23168 vsize=887400 CPUtime=261.35
/proc/23181/task/23182/stat : 23182 (java) R 23168 23167 19908 34817 19908 4202560 47294 0 1 0 26111 24 0 0 25 0 11 0 62353423 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4094881657 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23181/tid=23183] ppid=23168 vsize=887400 CPUtime=19.51
/proc/23181/task/23183/stat : 23183 (java) S 23168 23167 19908 34817 19908 4202560 11115 0 0 0 1948 3 0 0 15 0 11 0 62353425 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 0 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23184] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23184/stat : 23184 (java) S 23168 23167 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 62353425 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23185] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23185/stat : 23185 (java) S 23168 23167 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 62353425 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23186] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23186/stat : 23186 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23187] ppid=23168 vsize=887400 CPUtime=1.31
/proc/23181/task/23187/stat : 23187 (java) S 23168 23167 19908 34817 19908 4202560 6312 0 0 0 128 3 0 0 15 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23188] ppid=23168 vsize=887400 CPUtime=1.22
/proc/23181/task/23188/stat : 23188 (java) S 23168 23167 19908 34817 19908 4202560 7346 0 0 0 116 6 0 0 15 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23189] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23189/stat : 23189 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23190] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23190/stat : 23190 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 62353428 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23192] ppid=23168 vsize=887400 CPUtime=0
/proc/23181/task/23192/stat : 23192 (java) S 23168 23167 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 62353792 908697600 67717 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.44
Current children cumulated vsize (KiB) 892548

[startup+284.107 s]
/proc/loadavg: 1.11 1.06 1.01 2/49 23200
/proc/meminfo: memFree=392720/1048576 swapFree=0/0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0
/proc/23167/stat : 23167 (p2cudf-user-1.1) S 23166 23167 19908 34817 19908 4202496 376 0 0 0 0 0 0 0 18 0 1 0 62353419 2633728 271 1283457024 134512640 135304128 4292224880 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 271 230 194 0 30 0
[pid=23168] ppid=23167 vsize=2576 CPUtime=0.03
/proc/23168/stat : 23168 (p2cudf) S 23167 23167 19908 34817 19908 4202496 394 3016 0 1 0 1 2 0 25 0 1 0 62353419 2637824 282 1283457024 134512640 135304128 4292503520 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23168/statm: 644 282 239 194 0 31 0
[pid=23181] ppid=23168 vsize=887724 CPUtime=283.54
/proc/23181/stat : 23181 (java) S 23168 23167 19908 34817 19908 4202496 73159 0 1 0 28317 37 0 0 25 0 11 0 62353423 909029376 67730 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23181/statm: 221931 67730 1784 10 0 219022 0
[pid=23181/tid=23182] ppid=23168 vsize=887724 CPUtime=261.46
/proc/23181/task/23182/stat : 23182 (java) S 23168 23167 19908 34817 19908 4202560 47301 0 1 0 26122 24 0 0 25 0 11 0 62353423 909029376 67730 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23183] ppid=23168 vsize=887724 CPUtime=19.51
/proc/23181/task/23183/stat : 23183 (java) S 23168 23167 19908 34817 19908 4202560 11115 0 0 0 1948 3 0 0 16 0 11 0 62353425 909029376 67730 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 0 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23184] ppid=23168 vsize=887724 CPUtime=0
/proc/23181/task/23184/stat : 23184 (java) S 23168 23167 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 62353425 909029376 67730 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23185] ppid=23168 vsize=887724 CPUtime=0
/proc/23181/task/23185/stat : 23185 (java) S 23168 23167 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 62353425 909029376 67730 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23186] ppid=23168 vsize=887724 CPUtime=0
/proc/23181/task/23186/stat : 23186 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62353428 909029376 67730 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23187] ppid=23168 vsize=887724 CPUtime=1.33
/proc/23181/task/23187/stat : 23187 (java) S 23168 23167 19908 34817 19908 4202560 6312 0 0 0 130 3 0 0 15 0 11 0 62353428 909029376 67730 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23188] ppid=23168 vsize=887724 CPUtime=1.22
/proc/23181/task/23188/stat : 23188 (java) S 23168 23167 19908 34817 19908 4202560 7346 0 0 0 116 6 0 0 15 0 11 0 62353428 909029376 67730 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23189] ppid=23168 vsize=887724 CPUtime=0
/proc/23181/task/23189/stat : 23189 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62353428 909029376 67730 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23190] ppid=23168 vsize=887724 CPUtime=0
/proc/23181/task/23190/stat : 23190 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 62353428 909029376 67730 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.57
Current children cumulated vsize (KiB) 892872

[startup+284.307 s]
/proc/loadavg: 1.11 1.06 1.01 2/49 23200
/proc/meminfo: memFree=392720/1048576 swapFree=0/0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0
/proc/23167/stat : 23167 (p2cudf-user-1.1) S 23166 23167 19908 34817 19908 4202496 376 0 0 0 0 0 0 0 18 0 1 0 62353419 2633728 271 1283457024 134512640 135304128 4292224880 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 271 230 194 0 30 0
[pid=23168] ppid=23167 vsize=2576 CPUtime=0.03
/proc/23168/stat : 23168 (p2cudf) S 23167 23167 19908 34817 19908 4202496 394 3016 0 1 0 1 2 0 25 0 1 0 62353419 2637824 282 1283457024 134512640 135304128 4292503520 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23168/statm: 644 282 239 194 0 31 0
[pid=23181] ppid=23168 vsize=887724 CPUtime=283.54
/proc/23181/stat : 23181 (java) S 23168 23167 19908 34817 19908 4202496 73159 0 1 0 28317 37 0 0 25 0 11 0 62353423 909029376 67730 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23181/statm: 221931 67730 1784 10 0 219022 0
[pid=23181/tid=23182] ppid=23168 vsize=887724 CPUtime=261.46
/proc/23181/task/23182/stat : 23182 (java) S 23168 23167 19908 34817 19908 4202560 47301 0 1 0 26122 24 0 0 25 0 11 0 62353423 909029376 67730 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23183] ppid=23168 vsize=887724 CPUtime=19.51
/proc/23181/task/23183/stat : 23183 (java) S 23168 23167 19908 34817 19908 4202560 11115 0 0 0 1948 3 0 0 16 0 11 0 62353425 909029376 67730 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 0 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23184] ppid=23168 vsize=887724 CPUtime=0
/proc/23181/task/23184/stat : 23184 (java) S 23168 23167 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 62353425 909029376 67730 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23185] ppid=23168 vsize=887724 CPUtime=0
/proc/23181/task/23185/stat : 23185 (java) S 23168 23167 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 62353425 909029376 67730 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23186] ppid=23168 vsize=887724 CPUtime=0
/proc/23181/task/23186/stat : 23186 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62353428 909029376 67730 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23187] ppid=23168 vsize=887724 CPUtime=1.33
/proc/23181/task/23187/stat : 23187 (java) S 23168 23167 19908 34817 19908 4202560 6312 0 0 0 130 3 0 0 15 0 11 0 62353428 909029376 67730 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23188] ppid=23168 vsize=887724 CPUtime=1.22
/proc/23181/task/23188/stat : 23188 (java) S 23168 23167 19908 34817 19908 4202560 7346 0 0 0 116 6 0 0 15 0 11 0 62353428 909029376 67730 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23189] ppid=23168 vsize=887724 CPUtime=0
/proc/23181/task/23189/stat : 23189 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62353428 909029376 67730 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23190] ppid=23168 vsize=887724 CPUtime=0
/proc/23181/task/23190/stat : 23190 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 11 0 62353428 909029376 67730 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.57
Current children cumulated vsize (KiB) 892872

[startup+284.407 s]
/proc/loadavg: 1.11 1.06 1.01 2/49 23200
/proc/meminfo: memFree=392720/1048576 swapFree=0/0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0
/proc/23167/stat : 23167 (p2cudf-user-1.1) S 23166 23167 19908 34817 19908 4202496 376 0 0 0 0 0 0 0 18 0 1 0 62353419 2633728 271 1283457024 134512640 135304128 4292224880 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 271 230 194 0 30 0
[pid=23168] ppid=23167 vsize=2576 CPUtime=0.03
/proc/23168/stat : 23168 (p2cudf) S 23167 23167 19908 34817 19908 4202496 394 3016 0 1 0 1 2 0 25 0 1 0 62353419 2637824 282 1283457024 134512640 135304128 4292503520 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23168/statm: 644 282 239 194 0 31 0
[pid=23181] ppid=23168 vsize=887724 CPUtime=283.55
/proc/23181/stat : 23181 (java) S 23168 23167 19908 34817 19908 4202496 73159 0 1 0 28317 38 0 0 25 0 10 0 62353423 909029376 67730 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23181/statm: 221931 67730 1784 10 0 219022 0
[pid=23181/tid=23182] ppid=23168 vsize=887724 CPUtime=261.46
/proc/23181/task/23182/stat : 23182 (java) S 23168 23167 19908 34817 19908 4202560 47301 0 1 0 26122 24 0 0 20 0 10 0 62353423 909029376 67730 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23183] ppid=23168 vsize=887724 CPUtime=19.51
/proc/23181/task/23183/stat : 23183 (java) S 23168 23167 19908 34817 19908 4202560 11115 0 0 0 1948 3 0 0 16 0 10 0 62353425 909029376 67730 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 0 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23184] ppid=23168 vsize=887724 CPUtime=0
/proc/23181/task/23184/stat : 23184 (java) S 23168 23167 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 10 0 62353425 909029376 67730 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23185] ppid=23168 vsize=887724 CPUtime=0
/proc/23181/task/23185/stat : 23185 (java) S 23168 23167 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 10 0 62353425 909029376 67730 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23186] ppid=23168 vsize=887724 CPUtime=0
/proc/23181/task/23186/stat : 23186 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 62353428 909029376 67730 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23187] ppid=23168 vsize=887724 CPUtime=1.33
/proc/23181/task/23187/stat : 23187 (java) S 23168 23167 19908 34817 19908 4202560 6312 0 0 0 130 3 0 0 15 0 10 0 62353428 909029376 67730 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23188] ppid=23168 vsize=887724 CPUtime=1.22
/proc/23181/task/23188/stat : 23188 (java) S 23168 23167 19908 34817 19908 4202560 7346 0 0 0 116 6 0 0 15 0 10 0 62353428 909029376 67730 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23189] ppid=23168 vsize=887724 CPUtime=0
/proc/23181/task/23189/stat : 23189 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 62353428 909029376 67730 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
[pid=23181/tid=23190] ppid=23168 vsize=887724 CPUtime=0
/proc/23181/task/23190/stat : 23190 (java) S 23168 23167 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 15 0 10 0 62353428 909029376 67730 1283457024 134512640 134550932 4292484720 18446744073709551615 4294960130 0 4 0 16800975 18446612133002274752 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.58
Current children cumulated vsize (KiB) 892872

Child status: 0
Real time (s): 284.437
CPU time (s): 283.622
CPU user time (s): 283.198
CPU system time (s): 0.424026
CPU usage (%): 99.7134
Max. virtual memory (cumulated for all children) (KiB): 896504

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 283.198
system time used= 0.424026
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 76970
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= 6067
involuntary context switches= 8900

runsolver used 0 second user time and 0 second system time

The end