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/rand992.cudf.dudf-random.log.runsolver ./p2cudf-user-1.13 /home/misc2010/data/2011/dudf-random//rand992.cudf /home/misc2010/tmp/201108311143/p2cudf-user-1.13/rand992.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.02 1.03 1.00 3/35 29998
/proc/meminfo: memFree=581308/1048576 swapFree=0/0
[pid=29997] ppid=29996 vsize=2568 CPUtime=0
/proc/29997/stat : 29997 (p2cudf-user-1.1) R 29996 29997 19908 34817 19908 4202496 357 0 0 0 0 0 0 0 25 0 1 0 65737812 2629632 270 1283457024 134512640 135304128 4288334768 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/29997/statm: 642 270 230 194 0 29 0
[pid=29998] ppid=29997 vsize=2568 CPUtime=0
/proc/29998/stat : 29998 (p2cudf-user-1.1) R 29997 29997 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 1 0 65737812 2629632 40 1283457024 134512640 135304128 4288334768 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/29998/statm: 642 40 0 194 0 29 0

[startup+0.135604 s]
/proc/loadavg: 1.02 1.03 1.00 3/35 29998
/proc/meminfo: memFree=581308/1048576 swapFree=0/0
[pid=29997] ppid=29996 vsize=2568 CPUtime=0
/proc/29997/stat : 29997 (p2cudf-user-1.1) S 29996 29997 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 25 0 1 0 65737812 2629632 270 1283457024 134512640 135304128 4288334768 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29997/statm: 642 270 230 194 0 29 0
[pid=29998] ppid=29997 vsize=2580 CPUtime=0.03
/proc/29998/stat : 29998 (p2cudf) S 29997 29997 19908 34817 19908 4202496 394 3014 0 1 0 1 0 2 25 0 1 0 65737812 2641920 281 1283457024 134512640 135304128 4287074992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29998/statm: 645 281 239 194 0 32 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5148

[startup+0.205608 s]
/proc/loadavg: 1.02 1.03 1.00 3/35 29998
/proc/meminfo: memFree=581308/1048576 swapFree=0/0
[pid=29997] ppid=29996 vsize=2568 CPUtime=0
/proc/29997/stat : 29997 (p2cudf-user-1.1) S 29996 29997 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 25 0 1 0 65737812 2629632 270 1283457024 134512640 135304128 4288334768 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29997/statm: 642 270 230 194 0 29 0
[pid=29998] ppid=29997 vsize=2580 CPUtime=0.03
/proc/29998/stat : 29998 (p2cudf) S 29997 29997 19908 34817 19908 4202496 394 3014 0 1 0 1 0 2 25 0 1 0 65737812 2641920 281 1283457024 134512640 135304128 4287074992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29998/statm: 645 281 239 194 0 32 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5148

[startup+0.305624 s]
/proc/loadavg: 1.02 1.03 1.00 3/35 29998
/proc/meminfo: memFree=581308/1048576 swapFree=0/0
[pid=29997] ppid=29996 vsize=2568 CPUtime=0
/proc/29997/stat : 29997 (p2cudf-user-1.1) S 29996 29997 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 25 0 1 0 65737812 2629632 270 1283457024 134512640 135304128 4288334768 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29997/statm: 642 270 230 194 0 29 0
[pid=29998] ppid=29997 vsize=2580 CPUtime=0.03
/proc/29998/stat : 29998 (p2cudf) S 29997 29997 19908 34817 19908 4202496 394 3014 0 1 0 1 0 2 25 0 1 0 65737812 2641920 281 1283457024 134512640 135304128 4287074992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29998/statm: 645 281 239 194 0 32 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5148

[startup+0.705707 s]
/proc/loadavg: 1.02 1.03 1.00 3/35 29998
/proc/meminfo: memFree=581308/1048576 swapFree=0/0
[pid=29997] ppid=29996 vsize=2568 CPUtime=0
/proc/29997/stat : 29997 (p2cudf-user-1.1) S 29996 29997 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 25 0 1 0 65737812 2629632 270 1283457024 134512640 135304128 4288334768 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29997/statm: 642 270 230 194 0 29 0
[pid=29998] ppid=29997 vsize=2580 CPUtime=0.03
/proc/29998/stat : 29998 (p2cudf) S 29997 29997 19908 34817 19908 4202496 394 3014 0 1 0 1 0 2 25 0 1 0 65737812 2641920 281 1283457024 134512640 135304128 4287074992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29998/statm: 645 281 239 194 0 32 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5148

[startup+1.50589 s]
/proc/loadavg: 1.02 1.03 1.00 5/46 30020
/proc/meminfo: memFree=532656/1048576 swapFree=0/0
[pid=29997] ppid=29996 vsize=2568 CPUtime=0
/proc/29997/stat : 29997 (p2cudf-user-1.1) S 29996 29997 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 25 0 1 0 65737812 2629632 270 1283457024 134512640 135304128 4288334768 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29997/statm: 642 270 230 194 0 29 0
[pid=29998] ppid=29997 vsize=2580 CPUtime=0.03
/proc/29998/stat : 29998 (p2cudf) S 29997 29997 19908 34817 19908 4202496 394 3014 0 1 0 1 0 2 25 0 1 0 65737812 2641920 281 1283457024 134512640 135304128 4287074992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29998/statm: 645 281 239 194 0 32 0
[pid=30011] ppid=29998 vsize=893652 CPUtime=1.46
/proc/30011/stat : 30011 (java) S 29998 29997 19908 34817 19908 4202496 22032 0 1 0 138 8 0 0 25 0 10 0 65737815 915099648 18384 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30011/statm: 223413 18384 1721 10 0 220504 0
[pid=30011/tid=30012] ppid=29998 vsize=893652 CPUtime=0.79
/proc/30011/task/30012/stat : 30012 (java) R 29998 29997 19908 34817 19908 4202560 8169 0 1 0 77 2 0 0 25 0 10 0 65737816 915099648 18384 1283457024 134512640 134550932 4290415728 18446744073709551615 4095036173 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=30011/tid=30013] ppid=29998 vsize=893652 CPUtime=0
/proc/30011/task/30013/stat : 30013 (java) S 29998 29997 19908 34817 19908 4202560 7 0 0 0 0 0 0 0 16 0 10 0 65737817 915099648 18384 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 0 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30014] ppid=29998 vsize=893652 CPUtime=0
/proc/30011/task/30014/stat : 30014 (java) S 29998 29997 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 25 0 10 0 65737818 915099648 18384 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30015] ppid=29998 vsize=893652 CPUtime=0
/proc/30011/task/30015/stat : 30015 (java) S 29998 29997 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 10 0 65737818 915099648 18384 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30016] ppid=29998 vsize=893652 CPUtime=0
/proc/30011/task/30016/stat : 30016 (java) S 29998 29997 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 65737820 915099648 18384 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30017] ppid=29998 vsize=893652 CPUtime=0.38
/proc/30011/task/30017/stat : 30017 (java) R 29998 29997 19908 34817 19908 4202560 6108 0 0 0 34 4 0 0 21 0 10 0 65737820 915099648 18384 1283457024 134512640 134550932 4290415728 18446744073709551615 4152427811 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=30011/tid=30018] ppid=29998 vsize=893652 CPUtime=0.27
/proc/30011/task/30018/stat : 30018 (java) R 29998 29997 19908 34817 19908 4202560 6674 0 0 0 26 1 0 0 25 0 10 0 65737820 915099648 18384 1283457024 134512640 134550932 4290415728 18446744073709551615 4152428449 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=30011/tid=30019] ppid=29998 vsize=893652 CPUtime=0
/proc/30011/task/30019/stat : 30019 (java) S 29998 29997 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 65737820 915099648 18384 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30020] ppid=29998 vsize=893652 CPUtime=0
/proc/30011/task/30020/stat : 30020 (java) S 29998 29997 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 10 0 65737820 915099648 18384 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 1.49
Current children cumulated vsize (KiB) 898800

[startup+3.10681 s]
/proc/loadavg: 1.02 1.03 1.00 2/46 30020
/proc/meminfo: memFree=438292/1048576 swapFree=0/0
[pid=29997] ppid=29996 vsize=2568 CPUtime=0
/proc/29997/stat : 29997 (p2cudf-user-1.1) S 29996 29997 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 25 0 1 0 65737812 2629632 270 1283457024 134512640 135304128 4288334768 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29997/statm: 642 270 230 194 0 29 0
[pid=29998] ppid=29997 vsize=2580 CPUtime=0.03
/proc/29998/stat : 29998 (p2cudf) S 29997 29997 19908 34817 19908 4202496 394 3014 0 1 0 1 0 2 25 0 1 0 65737812 2641920 281 1283457024 134512640 135304128 4287074992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29998/statm: 645 281 239 194 0 32 0
[pid=30011] ppid=29998 vsize=891056 CPUtime=3.06
/proc/30011/stat : 30011 (java) S 29998 29997 19908 34817 19908 4202496 75666 0 1 0 273 33 0 0 25 0 10 0 65737815 912441344 71285 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30011/statm: 222764 71285 1742 10 0 219855 0
[pid=30011/tid=30012] ppid=29998 vsize=891056 CPUtime=1.8
/proc/30011/task/30012/stat : 30012 (java) R 29998 29997 19908 34817 19908 4202560 50034 0 1 0 160 20 0 0 25 0 10 0 65737816 912441344 71285 1283457024 134512640 134550932 4290415728 18446744073709551615 4095339340 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=30011/tid=30013] ppid=29998 vsize=891056 CPUtime=0.24
/proc/30011/task/30013/stat : 30013 (java) S 29998 29997 19908 34817 19908 4202560 11179 0 0 0 20 4 0 0 16 0 10 0 65737817 912441344 71285 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 0 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30014] ppid=29998 vsize=891056 CPUtime=0
/proc/30011/task/30014/stat : 30014 (java) S 29998 29997 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 10 0 65737818 912441344 71285 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30015] ppid=29998 vsize=891056 CPUtime=0
/proc/30011/task/30015/stat : 30015 (java) S 29998 29997 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 10 0 65737818 912441344 71285 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30016] ppid=29998 vsize=891056 CPUtime=0
/proc/30011/task/30016/stat : 30016 (java) S 29998 29997 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 65737820 912441344 71285 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30017] ppid=29998 vsize=891056 CPUtime=0.65
/proc/30011/task/30017/stat : 30017 (java) S 29998 29997 19908 34817 19908 4202560 6343 0 0 0 59 6 0 0 15 0 10 0 65737820 912441344 71285 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30018] ppid=29998 vsize=891056 CPUtime=0.36
/proc/30011/task/30018/stat : 30018 (java) S 29998 29997 19908 34817 19908 4202560 7033 0 0 0 34 2 0 0 25 0 10 0 65737820 912441344 71285 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30019] ppid=29998 vsize=891056 CPUtime=0
/proc/30011/task/30019/stat : 30019 (java) S 29998 29997 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 65737820 912441344 71285 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30020] ppid=29998 vsize=891056 CPUtime=0
/proc/30011/task/30020/stat : 30020 (java) S 29998 29997 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 10 0 65737820 912441344 71285 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 3.09
Current children cumulated vsize (KiB) 896204

[startup+6.31631 s]
/proc/loadavg: 1.02 1.03 1.00 3/46 30021
/proc/meminfo: memFree=247456/1048576 swapFree=0/0
[pid=29997] ppid=29996 vsize=2568 CPUtime=0
/proc/29997/stat : 29997 (p2cudf-user-1.1) S 29996 29997 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 25 0 1 0 65737812 2629632 270 1283457024 134512640 135304128 4288334768 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29997/statm: 642 270 230 194 0 29 0
[pid=29998] ppid=29997 vsize=2580 CPUtime=0.03
/proc/29998/stat : 29998 (p2cudf) S 29997 29997 19908 34817 19908 4202496 394 3014 0 1 0 1 0 2 25 0 1 0 65737812 2641920 281 1283457024 134512640 135304128 4287074992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29998/statm: 645 281 239 194 0 32 0
[pid=30011] ppid=29998 vsize=891760 CPUtime=6.26
/proc/30011/stat : 30011 (java) S 29998 29997 19908 34817 19908 4202496 91453 0 1 0 587 39 0 0 25 0 11 0 65737815 913162240 84988 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30011/statm: 222940 84988 1781 10 0 220031 0
[pid=30011/tid=30012] ppid=29998 vsize=891760 CPUtime=3.05
/proc/30011/task/30012/stat : 30012 (java) R 29998 29997 19908 34817 19908 4202560 50276 0 1 0 285 20 0 0 25 0 11 0 65737816 913162240 84988 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=30011/tid=30013] ppid=29998 vsize=891760 CPUtime=0.54
/proc/30011/task/30013/stat : 30013 (java) S 29998 29997 19908 34817 19908 4202560 24366 0 0 0 45 9 0 0 16 0 11 0 65737817 913162240 84988 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 0 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30014] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30014/stat : 30014 (java) S 29998 29997 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 65737818 913162240 84988 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30015] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30015/stat : 30015 (java) S 29998 29997 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 65737818 913162240 84988 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30016] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30016/stat : 30016 (java) S 29998 29997 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 65737820 913162240 84988 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30017] ppid=29998 vsize=891760 CPUtime=2.28
/proc/30011/task/30017/stat : 30017 (java) S 29998 29997 19908 34817 19908 4202560 8697 0 0 0 222 6 0 0 15 0 11 0 65737820 913162240 84988 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30018] ppid=29998 vsize=891760 CPUtime=0.36
/proc/30011/task/30018/stat : 30018 (java) S 29998 29997 19908 34817 19908 4202560 7033 0 0 0 34 2 0 0 25 0 11 0 65737820 913162240 84988 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30019] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30019/stat : 30019 (java) S 29998 29997 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 65737820 913162240 84988 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30020] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30020/stat : 30020 (java) S 29998 29997 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 65737820 913162240 84988 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30021] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30021/stat : 30021 (java) S 29998 29997 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 65738347 913162240 84988 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 6.29
Current children cumulated vsize (KiB) 896908

[startup+12.709 s]
/proc/loadavg: 1.10 1.04 1.01 2/46 30021
/proc/meminfo: memFree=216464/1048576 swapFree=0/0
[pid=29997] ppid=29996 vsize=2568 CPUtime=0
/proc/29997/stat : 29997 (p2cudf-user-1.1) S 29996 29997 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 25 0 1 0 65737812 2629632 270 1283457024 134512640 135304128 4288334768 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29997/statm: 642 270 230 194 0 29 0
[pid=29998] ppid=29997 vsize=2580 CPUtime=0.03
/proc/29998/stat : 29998 (p2cudf) S 29997 29997 19908 34817 19908 4202496 394 3014 0 1 0 1 0 2 25 0 1 0 65737812 2641920 281 1283457024 134512640 135304128 4287074992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29998/statm: 645 281 239 194 0 32 0
[pid=30011] ppid=29998 vsize=891760 CPUtime=12.66
/proc/30011/stat : 30011 (java) S 29998 29997 19908 34817 19908 4202496 99110 0 1 0 1227 39 0 0 25 0 11 0 65737815 913162240 92645 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30011/statm: 222940 92645 1786 10 0 220031 0
[pid=30011/tid=30012] ppid=29998 vsize=891760 CPUtime=8.72
/proc/30011/task/30012/stat : 30012 (java) R 29998 29997 19908 34817 19908 4202560 50278 0 1 0 852 20 0 0 25 0 11 0 65737816 913162240 92645 1283457024 134512640 134550932 4290415728 18446744073709551615 4096078808 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=30011/tid=30013] ppid=29998 vsize=891760 CPUtime=1.15
/proc/30011/task/30013/stat : 30013 (java) S 29998 29997 19908 34817 19908 4202560 32001 0 0 0 106 9 0 0 15 0 11 0 65737817 913162240 92645 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 0 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30014] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30014/stat : 30014 (java) S 29998 29997 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 65737818 913162240 92645 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30015] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30015/stat : 30015 (java) S 29998 29997 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 65737818 913162240 92645 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30016] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30016/stat : 30016 (java) S 29998 29997 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 65737820 913162240 92645 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30017] ppid=29998 vsize=891760 CPUtime=2.4
/proc/30011/task/30017/stat : 30017 (java) S 29998 29997 19908 34817 19908 4202560 8717 0 0 0 234 6 0 0 15 0 11 0 65737820 913162240 92645 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30018] ppid=29998 vsize=891760 CPUtime=0.36
/proc/30011/task/30018/stat : 30018 (java) S 29998 29997 19908 34817 19908 4202560 7033 0 0 0 34 2 0 0 25 0 11 0 65737820 913162240 92645 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30019] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30019/stat : 30019 (java) S 29998 29997 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 65737820 913162240 92645 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30020] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30020/stat : 30020 (java) S 29998 29997 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 65737820 913162240 92645 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30021] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30021/stat : 30021 (java) S 29998 29997 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 65738347 913162240 92645 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 12.69
Current children cumulated vsize (KiB) 896908

[startup+25.5117 s]
/proc/loadavg: 1.22 1.07 1.01 2/46 30021
/proc/meminfo: memFree=214356/1048576 swapFree=0/0
[pid=29997] ppid=29996 vsize=2568 CPUtime=0
/proc/29997/stat : 29997 (p2cudf-user-1.1) S 29996 29997 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 25 0 1 0 65737812 2629632 270 1283457024 134512640 135304128 4288334768 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29997/statm: 642 270 230 194 0 29 0
[pid=29998] ppid=29997 vsize=2580 CPUtime=0.03
/proc/29998/stat : 29998 (p2cudf) S 29997 29997 19908 34817 19908 4202496 394 3014 0 1 0 1 0 2 25 0 1 0 65737812 2641920 281 1283457024 134512640 135304128 4287074992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29998/statm: 645 281 239 194 0 32 0
[pid=30011] ppid=29998 vsize=891760 CPUtime=25.45
/proc/30011/stat : 30011 (java) S 29998 29997 19908 34817 19908 4202496 99608 0 1 0 2506 39 0 0 25 0 11 0 65737815 913162240 93143 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30011/statm: 222940 93143 1786 10 0 220031 0
[pid=30011/tid=30012] ppid=29998 vsize=891760 CPUtime=20.28
/proc/30011/task/30012/stat : 30012 (java) R 29998 29997 19908 34817 19908 4202560 50278 0 1 0 2008 20 0 0 25 0 11 0 65737816 913162240 93143 1283457024 134512640 134550932 4290415728 18446744073709551615 4095999340 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=30011/tid=30013] ppid=29998 vsize=891760 CPUtime=2.33
/proc/30011/task/30013/stat : 30013 (java) S 29998 29997 19908 34817 19908 4202560 32490 0 0 0 224 9 0 0 15 0 11 0 65737817 913162240 93143 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 0 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30014] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30014/stat : 30014 (java) S 29998 29997 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 65737818 913162240 93143 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30015] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30015/stat : 30015 (java) S 29998 29997 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 65737818 913162240 93143 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30016] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30016/stat : 30016 (java) S 29998 29997 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 65737820 913162240 93143 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30017] ppid=29998 vsize=891760 CPUtime=2.46
/proc/30011/task/30017/stat : 30017 (java) S 29998 29997 19908 34817 19908 4202560 8726 0 0 0 240 6 0 0 16 0 11 0 65737820 913162240 93143 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30018] ppid=29998 vsize=891760 CPUtime=0.36
/proc/30011/task/30018/stat : 30018 (java) S 29998 29997 19908 34817 19908 4202560 7033 0 0 0 34 2 0 0 25 0 11 0 65737820 913162240 93143 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30019] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30019/stat : 30019 (java) S 29998 29997 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 65737820 913162240 93143 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30020] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30020/stat : 30020 (java) S 29998 29997 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 65737820 913162240 93143 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30021] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30021/stat : 30021 (java) S 29998 29997 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 65738347 913162240 93143 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 25.48
Current children cumulated vsize (KiB) 896908

[startup+51.1074 s]
/proc/loadavg: 1.15 1.07 1.01 2/46 30021
/proc/meminfo: memFree=212868/1048576 swapFree=0/0
[pid=29997] ppid=29996 vsize=2568 CPUtime=0
/proc/29997/stat : 29997 (p2cudf-user-1.1) S 29996 29997 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 25 0 1 0 65737812 2629632 270 1283457024 134512640 135304128 4288334768 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29997/statm: 642 270 230 194 0 29 0
[pid=29998] ppid=29997 vsize=2580 CPUtime=0.03
/proc/29998/stat : 29998 (p2cudf) S 29997 29997 19908 34817 19908 4202496 394 3014 0 1 0 1 0 2 25 0 1 0 65737812 2641920 281 1283457024 134512640 135304128 4287074992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29998/statm: 645 281 239 194 0 32 0
[pid=30011] ppid=29998 vsize=891760 CPUtime=51.04
/proc/30011/stat : 30011 (java) S 29998 29997 19908 34817 19908 4202496 99977 0 1 0 5065 39 0 0 25 0 11 0 65737815 913162240 93512 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30011/statm: 222940 93512 1786 10 0 220031 0
[pid=30011/tid=30012] ppid=29998 vsize=891760 CPUtime=44.43
/proc/30011/task/30012/stat : 30012 (java) R 29998 29997 19908 34817 19908 4202560 50278 0 1 0 4423 20 0 0 25 0 11 0 65737816 913162240 93512 1283457024 134512640 134550932 4290415728 18446744073709551615 4096230584 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=30011/tid=30013] ppid=29998 vsize=891760 CPUtime=3.75
/proc/30011/task/30013/stat : 30013 (java) S 29998 29997 19908 34817 19908 4202560 32859 0 0 0 366 9 0 0 15 0 11 0 65737817 913162240 93512 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 0 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30014] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30014/stat : 30014 (java) S 29998 29997 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 65737818 913162240 93512 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30015] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30015/stat : 30015 (java) S 29998 29997 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 65737818 913162240 93512 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30016] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30016/stat : 30016 (java) S 29998 29997 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 65737820 913162240 93512 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30017] ppid=29998 vsize=891760 CPUtime=2.47
/proc/30011/task/30017/stat : 30017 (java) S 29998 29997 19908 34817 19908 4202560 8726 0 0 0 241 6 0 0 15 0 11 0 65737820 913162240 93512 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30018] ppid=29998 vsize=891760 CPUtime=0.36
/proc/30011/task/30018/stat : 30018 (java) S 29998 29997 19908 34817 19908 4202560 7033 0 0 0 34 2 0 0 25 0 11 0 65737820 913162240 93512 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30019] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30019/stat : 30019 (java) S 29998 29997 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 65737820 913162240 93512 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30020] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30020/stat : 30020 (java) S 29998 29997 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 65737820 913162240 93512 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30021] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30021/stat : 30021 (java) S 29998 29997 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 65738347 913162240 93512 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 51.07
Current children cumulated vsize (KiB) 896908

[startup+102.31 s]
/proc/loadavg: 1.14 1.07 1.01 2/46 30021
/proc/meminfo: memFree=205800/1048576 swapFree=0/0
[pid=29997] ppid=29996 vsize=2568 CPUtime=0
/proc/29997/stat : 29997 (p2cudf-user-1.1) S 29996 29997 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 25 0 1 0 65737812 2629632 270 1283457024 134512640 135304128 4288334768 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29997/statm: 642 270 230 194 0 29 0
[pid=29998] ppid=29997 vsize=2580 CPUtime=0.03
/proc/29998/stat : 29998 (p2cudf) S 29997 29997 19908 34817 19908 4202496 394 3014 0 1 0 1 0 2 25 0 1 0 65737812 2641920 281 1283457024 134512640 135304128 4287074992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29998/statm: 645 281 239 194 0 32 0
[pid=30011] ppid=29998 vsize=891760 CPUtime=102.22
/proc/30011/stat : 30011 (java) S 29998 29997 19908 34817 19908 4202496 101693 0 1 0 10182 40 0 0 25 0 11 0 65737815 913162240 95228 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30011/statm: 222940 95228 1786 10 0 220031 0
[pid=30011/tid=30012] ppid=29998 vsize=891760 CPUtime=93.58
/proc/30011/task/30012/stat : 30012 (java) R 29998 29997 19908 34817 19908 4202560 50278 0 1 0 9338 20 0 0 25 0 11 0 65737816 913162240 95228 1283457024 134512640 134550932 4290415728 18446744073709551615 4096088286 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=30011/tid=30013] ppid=29998 vsize=891760 CPUtime=5.78
/proc/30011/task/30013/stat : 30013 (java) S 29998 29997 19908 34817 19908 4202560 34575 0 0 0 568 10 0 0 15 0 11 0 65737817 913162240 95228 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 0 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30014] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30014/stat : 30014 (java) S 29998 29997 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 65737818 913162240 95228 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30015] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30015/stat : 30015 (java) S 29998 29997 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 65737818 913162240 95228 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30016] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30016/stat : 30016 (java) S 29998 29997 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 65737820 913162240 95228 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30017] ppid=29998 vsize=891760 CPUtime=2.47
/proc/30011/task/30017/stat : 30017 (java) S 29998 29997 19908 34817 19908 4202560 8726 0 0 0 241 6 0 0 15 0 11 0 65737820 913162240 95228 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30018] ppid=29998 vsize=891760 CPUtime=0.36
/proc/30011/task/30018/stat : 30018 (java) S 29998 29997 19908 34817 19908 4202560 7033 0 0 0 34 2 0 0 25 0 11 0 65737820 913162240 95228 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30019] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30019/stat : 30019 (java) S 29998 29997 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 65737820 913162240 95228 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30020] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30020/stat : 30020 (java) S 29998 29997 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 65737820 913162240 95228 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30021] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30021/stat : 30021 (java) S 29998 29997 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 65738347 913162240 95228 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 102.25
Current children cumulated vsize (KiB) 896908

[startup+162.314 s]
/proc/loadavg: 1.13 1.07 1.01 2/46 30021
/proc/meminfo: memFree=205056/1048576 swapFree=0/0
[pid=29997] ppid=29996 vsize=2568 CPUtime=0
/proc/29997/stat : 29997 (p2cudf-user-1.1) S 29996 29997 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 25 0 1 0 65737812 2629632 270 1283457024 134512640 135304128 4288334768 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29997/statm: 642 270 230 194 0 29 0
[pid=29998] ppid=29997 vsize=2580 CPUtime=0.03
/proc/29998/stat : 29998 (p2cudf) S 29997 29997 19908 34817 19908 4202496 394 3014 0 1 0 1 0 2 25 0 1 0 65737812 2641920 281 1283457024 134512640 135304128 4287074992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29998/statm: 645 281 239 194 0 32 0
[pid=30011] ppid=29998 vsize=891760 CPUtime=162.2
/proc/30011/stat : 30011 (java) S 29998 29997 19908 34817 19908 4202496 101856 0 1 0 16179 41 0 0 25 0 11 0 65737815 913162240 95391 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30011/statm: 222940 95391 1786 10 0 220031 0
[pid=30011/tid=30012] ppid=29998 vsize=891760 CPUtime=151.8
/proc/30011/task/30012/stat : 30012 (java) R 29998 29997 19908 34817 19908 4202560 50278 0 1 0 15158 22 0 0 25 0 11 0 65737816 913162240 95391 1283457024 134512640 134550932 4290415728 18446744073709551615 4096106891 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=30011/tid=30013] ppid=29998 vsize=891760 CPUtime=7.56
/proc/30011/task/30013/stat : 30013 (java) S 29998 29997 19908 34817 19908 4202560 34738 0 0 0 746 10 0 0 15 0 11 0 65737817 913162240 95391 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 0 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30014] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30014/stat : 30014 (java) S 29998 29997 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 65737818 913162240 95391 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30015] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30015/stat : 30015 (java) S 29998 29997 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 65737818 913162240 95391 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30016] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30016/stat : 30016 (java) S 29998 29997 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 65737820 913162240 95391 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30017] ppid=29998 vsize=891760 CPUtime=2.47
/proc/30011/task/30017/stat : 30017 (java) S 29998 29997 19908 34817 19908 4202560 8726 0 0 0 241 6 0 0 15 0 11 0 65737820 913162240 95391 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30018] ppid=29998 vsize=891760 CPUtime=0.36
/proc/30011/task/30018/stat : 30018 (java) S 29998 29997 19908 34817 19908 4202560 7033 0 0 0 34 2 0 0 25 0 11 0 65737820 913162240 95391 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30019] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30019/stat : 30019 (java) S 29998 29997 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 65737820 913162240 95391 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30020] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30020/stat : 30020 (java) S 29998 29997 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 65737820 913162240 95391 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30021] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30021/stat : 30021 (java) S 29998 29997 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 65738347 913162240 95391 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 162.23
Current children cumulated vsize (KiB) 896908

[startup+222.307 s]
/proc/loadavg: 1.05 1.06 1.01 2/46 30021
/proc/meminfo: memFree=202204/1048576 swapFree=0/0
[pid=29997] ppid=29996 vsize=2568 CPUtime=0
/proc/29997/stat : 29997 (p2cudf-user-1.1) S 29996 29997 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 25 0 1 0 65737812 2629632 270 1283457024 134512640 135304128 4288334768 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29997/statm: 642 270 230 194 0 29 0
[pid=29998] ppid=29997 vsize=2580 CPUtime=0.03
/proc/29998/stat : 29998 (p2cudf) S 29997 29997 19908 34817 19908 4202496 394 3014 0 1 0 1 0 2 25 0 1 0 65737812 2641920 281 1283457024 134512640 135304128 4287074992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29998/statm: 645 281 239 194 0 32 0
[pid=30011] ppid=29998 vsize=891760 CPUtime=222.14
/proc/30011/stat : 30011 (java) S 29998 29997 19908 34817 19908 4202496 102560 0 1 0 22171 43 0 0 25 0 11 0 65737815 913162240 96095 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30011/statm: 222940 96095 1786 10 0 220031 0
[pid=30011/tid=30012] ppid=29998 vsize=891760 CPUtime=210.22
/proc/30011/task/30012/stat : 30012 (java) R 29998 29997 19908 34817 19908 4202560 50278 0 1 0 21000 22 0 0 25 0 11 0 65737816 913162240 96095 1283457024 134512640 134550932 4290415728 18446744073709551615 4095959546 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=30011/tid=30013] ppid=29998 vsize=891760 CPUtime=9.06
/proc/30011/task/30013/stat : 30013 (java) S 29998 29997 19908 34817 19908 4202560 35442 0 0 0 895 11 0 0 15 0 11 0 65737817 913162240 96095 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 0 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30014] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30014/stat : 30014 (java) S 29998 29997 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 65737818 913162240 96095 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30015] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30015/stat : 30015 (java) S 29998 29997 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 65737818 913162240 96095 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30016] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30016/stat : 30016 (java) S 29998 29997 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 65737820 913162240 96095 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30017] ppid=29998 vsize=891760 CPUtime=2.47
/proc/30011/task/30017/stat : 30017 (java) S 29998 29997 19908 34817 19908 4202560 8726 0 0 0 241 6 0 0 15 0 11 0 65737820 913162240 96095 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30018] ppid=29998 vsize=891760 CPUtime=0.36
/proc/30011/task/30018/stat : 30018 (java) S 29998 29997 19908 34817 19908 4202560 7033 0 0 0 34 2 0 0 25 0 11 0 65737820 913162240 96095 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30019] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30019/stat : 30019 (java) S 29998 29997 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 65737820 913162240 96095 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30020] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30020/stat : 30020 (java) S 29998 29997 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 65737820 913162240 96095 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30021] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30021/stat : 30021 (java) S 29998 29997 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 65738347 913162240 96095 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 222.17
Current children cumulated vsize (KiB) 896908

[startup+282.31 s]
/proc/loadavg: 1.09 1.06 1.01 2/48 30026
/proc/meminfo: memFree=198212/1048576 swapFree=0/0
[pid=29997] ppid=29996 vsize=2568 CPUtime=0
/proc/29997/stat : 29997 (p2cudf-user-1.1) S 29996 29997 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 25 0 1 0 65737812 2629632 270 1283457024 134512640 135304128 4288334768 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29997/statm: 642 270 230 194 0 29 0
[pid=29998] ppid=29997 vsize=2580 CPUtime=0.03
/proc/29998/stat : 29998 (p2cudf) S 29997 29997 19908 34817 19908 4202496 394 3014 0 1 0 1 0 2 25 0 1 0 65737812 2641920 281 1283457024 134512640 135304128 4287074992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29998/statm: 645 281 239 194 0 32 0
[pid=30011] ppid=29998 vsize=891760 CPUtime=282.1
/proc/30011/stat : 30011 (java) S 29998 29997 19908 34817 19908 4202496 103502 0 1 0 28167 43 0 0 25 0 11 0 65737815 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30011/statm: 222940 97037 1786 10 0 220031 0
[pid=30011/tid=30012] ppid=29998 vsize=891760 CPUtime=268.96
/proc/30011/task/30012/stat : 30012 (java) R 29998 29997 19908 34817 19908 4202560 50278 0 1 0 26874 22 0 0 25 0 11 0 65737816 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4095999444 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=30011/tid=30013] ppid=29998 vsize=891760 CPUtime=10.29
/proc/30011/task/30013/stat : 30013 (java) S 29998 29997 19908 34817 19908 4202560 36384 0 0 0 1018 11 0 0 15 0 11 0 65737817 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 0 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30014] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30014/stat : 30014 (java) S 29998 29997 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 65737818 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30015] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30015/stat : 30015 (java) S 29998 29997 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 65737818 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30016] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30016/stat : 30016 (java) S 29998 29997 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 65737820 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30017] ppid=29998 vsize=891760 CPUtime=2.47
/proc/30011/task/30017/stat : 30017 (java) S 29998 29997 19908 34817 19908 4202560 8726 0 0 0 241 6 0 0 15 0 11 0 65737820 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30018] ppid=29998 vsize=891760 CPUtime=0.36
/proc/30011/task/30018/stat : 30018 (java) S 29998 29997 19908 34817 19908 4202560 7033 0 0 0 34 2 0 0 25 0 11 0 65737820 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30019] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30019/stat : 30019 (java) S 29998 29997 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 65737820 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30020] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30020/stat : 30020 (java) S 29998 29997 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 65737820 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30021] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30021/stat : 30021 (java) S 29998 29997 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 65738347 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 282.13
Current children cumulated vsize (KiB) 896908

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

[startup+283.11 s]
/proc/loadavg: 1.09 1.06 1.01 2/48 30026
/proc/meminfo: memFree=198212/1048576 swapFree=0/0
[pid=29997] ppid=29996 vsize=2568 CPUtime=0
/proc/29997/stat : 29997 (p2cudf-user-1.1) S 29996 29997 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 25 0 1 0 65737812 2629632 270 1283457024 134512640 135304128 4288334768 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29997/statm: 642 270 230 194 0 29 0
[pid=29998] ppid=29997 vsize=2580 CPUtime=0.03
/proc/29998/stat : 29998 (p2cudf) S 29997 29997 19908 34817 19908 4202496 394 3014 0 1 0 1 0 2 25 0 1 0 65737812 2641920 281 1283457024 134512640 135304128 4287074992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29998/statm: 645 281 239 194 0 32 0
[pid=30011] ppid=29998 vsize=891760 CPUtime=282.9
/proc/30011/stat : 30011 (java) S 29998 29997 19908 34817 19908 4202496 103502 0 1 0 28247 43 0 0 25 0 11 0 65737815 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30011/statm: 222940 97037 1786 10 0 220031 0
[pid=30011/tid=30012] ppid=29998 vsize=891760 CPUtime=269.76
/proc/30011/task/30012/stat : 30012 (java) R 29998 29997 19908 34817 19908 4202560 50278 0 1 0 26954 22 0 0 25 0 11 0 65737816 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4095980260 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=30011/tid=30013] ppid=29998 vsize=891760 CPUtime=10.29
/proc/30011/task/30013/stat : 30013 (java) S 29998 29997 19908 34817 19908 4202560 36384 0 0 0 1018 11 0 0 15 0 11 0 65737817 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 0 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30014] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30014/stat : 30014 (java) S 29998 29997 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 65737818 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30015] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30015/stat : 30015 (java) S 29998 29997 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 65737818 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30016] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30016/stat : 30016 (java) S 29998 29997 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 65737820 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30017] ppid=29998 vsize=891760 CPUtime=2.47
/proc/30011/task/30017/stat : 30017 (java) S 29998 29997 19908 34817 19908 4202560 8726 0 0 0 241 6 0 0 15 0 11 0 65737820 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30018] ppid=29998 vsize=891760 CPUtime=0.36
/proc/30011/task/30018/stat : 30018 (java) S 29998 29997 19908 34817 19908 4202560 7033 0 0 0 34 2 0 0 25 0 11 0 65737820 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30019] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30019/stat : 30019 (java) S 29998 29997 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 65737820 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30020] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30020/stat : 30020 (java) S 29998 29997 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 65737820 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30021] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30021/stat : 30021 (java) S 29998 29997 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 65738347 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 282.93
Current children cumulated vsize (KiB) 896908

[startup+284.711 s]
/proc/loadavg: 1.08 1.06 1.01 2/48 30026
/proc/meminfo: memFree=198212/1048576 swapFree=0/0
[pid=29997] ppid=29996 vsize=2568 CPUtime=0
/proc/29997/stat : 29997 (p2cudf-user-1.1) S 29996 29997 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 25 0 1 0 65737812 2629632 270 1283457024 134512640 135304128 4288334768 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29997/statm: 642 270 230 194 0 29 0
[pid=29998] ppid=29997 vsize=2580 CPUtime=0.03
/proc/29998/stat : 29998 (p2cudf) S 29997 29997 19908 34817 19908 4202496 394 3014 0 1 0 1 0 2 25 0 1 0 65737812 2641920 281 1283457024 134512640 135304128 4287074992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29998/statm: 645 281 239 194 0 32 0
[pid=30011] ppid=29998 vsize=891760 CPUtime=284.5
/proc/30011/stat : 30011 (java) S 29998 29997 19908 34817 19908 4202496 103502 0 1 0 28407 43 0 0 25 0 11 0 65737815 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30011/statm: 222940 97037 1786 10 0 220031 0
[pid=30011/tid=30012] ppid=29998 vsize=891760 CPUtime=271.36
/proc/30011/task/30012/stat : 30012 (java) R 29998 29997 19908 34817 19908 4202560 50278 0 1 0 27114 22 0 0 25 0 11 0 65737816 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4096106778 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=30011/tid=30013] ppid=29998 vsize=891760 CPUtime=10.29
/proc/30011/task/30013/stat : 30013 (java) S 29998 29997 19908 34817 19908 4202560 36384 0 0 0 1018 11 0 0 15 0 11 0 65737817 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 0 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30014] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30014/stat : 30014 (java) S 29998 29997 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 65737818 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30015] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30015/stat : 30015 (java) S 29998 29997 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 65737818 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30016] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30016/stat : 30016 (java) S 29998 29997 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 65737820 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30017] ppid=29998 vsize=891760 CPUtime=2.47
/proc/30011/task/30017/stat : 30017 (java) S 29998 29997 19908 34817 19908 4202560 8726 0 0 0 241 6 0 0 15 0 11 0 65737820 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30018] ppid=29998 vsize=891760 CPUtime=0.36
/proc/30011/task/30018/stat : 30018 (java) S 29998 29997 19908 34817 19908 4202560 7033 0 0 0 34 2 0 0 25 0 11 0 65737820 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30019] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30019/stat : 30019 (java) S 29998 29997 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 65737820 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30020] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30020/stat : 30020 (java) S 29998 29997 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 65737820 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30021] ppid=29998 vsize=891760 CPUtime=0
/proc/30011/task/30021/stat : 30021 (java) S 29998 29997 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 65738347 913162240 97037 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 284.53
Current children cumulated vsize (KiB) 896908

[startup+285.503 s]
/proc/loadavg: 1.08 1.06 1.01 2/48 30026
/proc/meminfo: memFree=198212/1048576 swapFree=0/0
[pid=29997] ppid=29996 vsize=2568 CPUtime=0
/proc/29997/stat : 29997 (p2cudf-user-1.1) S 29996 29997 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 25 0 1 0 65737812 2629632 270 1283457024 134512640 135304128 4288334768 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29997/statm: 642 270 230 194 0 29 0
[pid=29998] ppid=29997 vsize=2580 CPUtime=0.03
/proc/29998/stat : 29998 (p2cudf) S 29997 29997 19908 34817 19908 4202496 394 3014 0 1 0 1 0 2 25 0 1 0 65737812 2641920 281 1283457024 134512640 135304128 4287074992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29998/statm: 645 281 239 194 0 32 0
[pid=30011] ppid=29998 vsize=892084 CPUtime=285.19
/proc/30011/stat : 30011 (java) S 29998 29997 19908 34817 19908 4202496 103514 0 1 0 28476 43 0 0 25 0 11 0 65737815 913494016 97049 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30011/statm: 223021 97049 1787 10 0 220112 0
[pid=30011/tid=30012] ppid=29998 vsize=892084 CPUtime=272
/proc/30011/task/30012/stat : 30012 (java) S 29998 29997 19908 34817 19908 4202560 50285 0 1 0 27178 22 0 0 25 0 11 0 65737816 913494016 97049 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30013] ppid=29998 vsize=892084 CPUtime=10.29
/proc/30011/task/30013/stat : 30013 (java) S 29998 29997 19908 34817 19908 4202560 36384 0 0 0 1018 11 0 0 16 0 11 0 65737817 913494016 97049 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 0 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30014] ppid=29998 vsize=892084 CPUtime=0
/proc/30011/task/30014/stat : 30014 (java) S 29998 29997 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 65737818 913494016 97049 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30015] ppid=29998 vsize=892084 CPUtime=0
/proc/30011/task/30015/stat : 30015 (java) S 29998 29997 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 65737818 913494016 97049 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30016] ppid=29998 vsize=892084 CPUtime=0
/proc/30011/task/30016/stat : 30016 (java) S 29998 29997 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 65737820 913494016 97049 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30017] ppid=29998 vsize=892084 CPUtime=2.51
/proc/30011/task/30017/stat : 30017 (java) S 29998 29997 19908 34817 19908 4202560 8726 0 0 0 245 6 0 0 15 0 11 0 65737820 913494016 97049 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30018] ppid=29998 vsize=892084 CPUtime=0.36
/proc/30011/task/30018/stat : 30018 (java) S 29998 29997 19908 34817 19908 4202560 7033 0 0 0 34 2 0 0 25 0 11 0 65737820 913494016 97049 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30019] ppid=29998 vsize=892084 CPUtime=0
/proc/30011/task/30019/stat : 30019 (java) S 29998 29997 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 65737820 913494016 97049 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30020] ppid=29998 vsize=892084 CPUtime=0
/proc/30011/task/30020/stat : 30020 (java) S 29998 29997 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 65737820 913494016 97049 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 285.22
Current children cumulated vsize (KiB) 897232

[startup+285.907 s]
/proc/loadavg: 1.08 1.06 1.01 1/48 30028
/proc/meminfo: memFree=198212/1048576 swapFree=0/0
[pid=29997] ppid=29996 vsize=2568 CPUtime=0
/proc/29997/stat : 29997 (p2cudf-user-1.1) S 29996 29997 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 25 0 1 0 65737812 2629632 270 1283457024 134512640 135304128 4288334768 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29997/statm: 642 270 230 194 0 29 0
[pid=29998] ppid=29997 vsize=2580 CPUtime=0.03
/proc/29998/stat : 29998 (p2cudf) S 29997 29997 19908 34817 19908 4202496 394 3014 0 1 0 1 0 2 25 0 1 0 65737812 2641920 281 1283457024 134512640 135304128 4287074992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29998/statm: 645 281 239 194 0 32 0
[pid=30011] ppid=29998 vsize=892084 CPUtime=285.19
/proc/30011/stat : 30011 (java) S 29998 29997 19908 34817 19908 4202496 103514 0 1 0 28476 43 0 0 25 0 11 0 65737815 913494016 97049 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30011/statm: 223021 97049 1787 10 0 220112 0
[pid=30011/tid=30012] ppid=29998 vsize=892084 CPUtime=272
/proc/30011/task/30012/stat : 30012 (java) S 29998 29997 19908 34817 19908 4202560 50285 0 1 0 27178 22 0 0 25 0 11 0 65737816 913494016 97049 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30013] ppid=29998 vsize=892084 CPUtime=10.29
/proc/30011/task/30013/stat : 30013 (java) S 29998 29997 19908 34817 19908 4202560 36384 0 0 0 1018 11 0 0 16 0 11 0 65737817 913494016 97049 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 0 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30014] ppid=29998 vsize=892084 CPUtime=0
/proc/30011/task/30014/stat : 30014 (java) S 29998 29997 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 65737818 913494016 97049 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30015] ppid=29998 vsize=892084 CPUtime=0
/proc/30011/task/30015/stat : 30015 (java) S 29998 29997 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 65737818 913494016 97049 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30016] ppid=29998 vsize=892084 CPUtime=0
/proc/30011/task/30016/stat : 30016 (java) S 29998 29997 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 65737820 913494016 97049 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30017] ppid=29998 vsize=892084 CPUtime=2.51
/proc/30011/task/30017/stat : 30017 (java) S 29998 29997 19908 34817 19908 4202560 8726 0 0 0 245 6 0 0 15 0 11 0 65737820 913494016 97049 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30018] ppid=29998 vsize=892084 CPUtime=0.36
/proc/30011/task/30018/stat : 30018 (java) S 29998 29997 19908 34817 19908 4202560 7033 0 0 0 34 2 0 0 25 0 11 0 65737820 913494016 97049 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30019] ppid=29998 vsize=892084 CPUtime=0
/proc/30011/task/30019/stat : 30019 (java) S 29998 29997 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 65737820 913494016 97049 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30020] ppid=29998 vsize=892084 CPUtime=0
/proc/30011/task/30020/stat : 30020 (java) S 29998 29997 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 65737820 913494016 97049 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
[pid=30011/tid=30027] ppid=29998 vsize=892084 CPUtime=0
/proc/30011/task/30027/stat : 30027 (java) S 29998 29997 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 21 0 11 0 65766353 913494016 97049 1283457024 134512640 134550932 4290415728 18446744073709551615 4294960130 0 4 0 16800975 18446612132933238848 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 285.22
Current children cumulated vsize (KiB) 897232

[startup+286.01 s]
/proc/loadavg: 1.08 1.06 1.01 1/48 30028
/proc/meminfo: memFree=198212/1048576 swapFree=0/0
[pid=29997] ppid=29996 vsize=2568 CPUtime=0
/proc/29997/stat : 29997 (p2cudf-user-1.1) S 29996 29997 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 25 0 1 0 65737812 2629632 270 1283457024 134512640 135304128 4288334768 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29997/statm: 642 270 230 194 0 29 0
[pid=29998] ppid=29997 vsize=2580 CPUtime=0.03
/proc/29998/stat : 29998 (p2cudf) S 29997 29997 19908 34817 19908 4202496 394 3014 0 1 0 1 0 2 25 0 1 0 65737812 2641920 281 1283457024 134512640 135304128 4287074992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29998/statm: 645 281 239 194 0 32 0
[pid=30011] ppid=29998 vsize=0 CPUtime=285.24
/proc/30011/stat : 30011 (java) Z 29998 29997 19908 34817 19908 4203532 103519 0 1 0 28479 45 0 0 18 0 2 0 65737815 0 0 1283457024 0 0 0 0 0 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30011/statm: 0 0 0 0 0 0 0
[pid=30011/tid=30012] ppid=29998 vsize=0 CPUtime=272.01
/proc/30011/task/30012/stat : 30012 (java) R 29998 29997 19908 34817 19908 4203588 50285 0 1 0 27178 23 0 0 20 0 2 0 65737816 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) 285.27
Current children cumulated vsize (KiB) 5148

Child status: 0
Real time (s): 286.024
CPU time (s): 285.302
CPU user time (s): 284.802
CPU system time (s): 0.500031
CPU usage (%): 99.7476
Max. virtual memory (cumulated for all children) (KiB): 899744

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 284.802
system time used= 0.500031
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 107321
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= 5923
involuntary context switches= 8796

runsolver used 0 second user time and 0 second system time

The end