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/201108300820/p2cudf-user-1.13/978532fa-c730-11df-b070-00163e3d3b7c.cudf.dudf-real.log.runsolver ./p2cudf-user-1.13 /home/misc2010/data/2011/dudf-real//978532fa-c730-11df-b070-00163e3d3b7c.cudf /home/misc2010/tmp/201108300820/p2cudf-user-1.13/978532fa-c730-11df-b070-00163e3d3b7c.cudf.dudf-real.result +sum(installedsize) 

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


[startup+0 s]
/proc/loadavg: 0.85 0.97 0.99 1/35 14294
/proc/meminfo: memFree=935908/1048576 swapFree=0/0
[pid=14294] ppid=14293 vsize=3020 CPUtime=0
/proc/14294/stat : 14294 (runsolver) D 14293 14294 2160 34817 2160 4202560 72 0 0 0 0 0 0 0 25 0 1 0 57305777 3092480 93 1283457024 134512640 134586868 4292202080 18446744073709551615 4294960130 0 0 0 24578 18446744071564332000 0 0 17 0 0 0 0
/proc/14294/statm: 755 93 62 19 0 54 0

[startup+0.175121 s]
/proc/loadavg: 0.85 0.97 0.99 1/35 14294
/proc/meminfo: memFree=935908/1048576 swapFree=0/0
[pid=14294] ppid=14293 vsize=2568 CPUtime=0
/proc/14294/stat : 14294 (p2cudf-user-1.1) S 14293 14294 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 57305777 2629632 270 1283457024 134512640 135304128 4294574448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14294/statm: 642 270 230 194 0 29 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2568

[startup+0.207142 s]
/proc/loadavg: 0.85 0.97 0.99 1/35 14294
/proc/meminfo: memFree=935908/1048576 swapFree=0/0
[pid=14294] ppid=14293 vsize=2568 CPUtime=0
/proc/14294/stat : 14294 (p2cudf-user-1.1) S 14293 14294 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 57305777 2629632 270 1283457024 134512640 135304128 4294574448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14294/statm: 642 270 230 194 0 29 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2568

[startup+0.307152 s]
/proc/loadavg: 0.85 0.97 0.99 1/35 14294
/proc/meminfo: memFree=935908/1048576 swapFree=0/0
[pid=14294] ppid=14293 vsize=2568 CPUtime=0
/proc/14294/stat : 14294 (p2cudf-user-1.1) S 14293 14294 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 57305777 2629632 270 1283457024 134512640 135304128 4294574448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14294/statm: 642 270 230 194 0 29 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2568

[startup+0.707186 s]
/proc/loadavg: 0.85 0.97 0.99 1/35 14294
/proc/meminfo: memFree=935908/1048576 swapFree=0/0
[pid=14294] ppid=14293 vsize=2568 CPUtime=0
/proc/14294/stat : 14294 (p2cudf-user-1.1) S 14293 14294 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 57305777 2629632 270 1283457024 134512640 135304128 4294574448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14294/statm: 642 270 230 194 0 29 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2568

[startup+1.50667 s]
/proc/loadavg: 0.85 0.97 0.99 4/47 14317
/proc/meminfo: memFree=914300/1048576 swapFree=0/0
[pid=14294] ppid=14293 vsize=2568 CPUtime=0
/proc/14294/stat : 14294 (p2cudf-user-1.1) S 14293 14294 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 57305777 2629632 270 1283457024 134512640 135304128 4294574448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14294/statm: 642 270 230 194 0 29 0
[pid=14296] ppid=14294 vsize=2568 CPUtime=0.02
/proc/14296/stat : 14296 (p2cudf) S 14294 14294 2160 34817 2160 4202496 387 3014 0 1 0 0 2 0 25 0 1 0 57305778 2629632 279 1283457024 134512640 135304128 4290956848 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14296/statm: 642 279 239 194 0 29 0
[pid=14308] ppid=14296 vsize=890352 CPUtime=0.72
/proc/14308/stat : 14308 (java) S 14296 14294 2160 34817 2160 4202496 15230 0 110 0 66 6 0 0 21 0 10 0 57305781 911720448 12912 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/14308/statm: 222588 12912 1730 10 0 219679 0
[pid=14308/tid=14309] ppid=14296 vsize=890352 CPUtime=0.25
/proc/14308/task/14309/stat : 14309 (java) R 14296 14294 2160 34817 2160 4202560 3957 0 15 0 24 1 0 0 25 0 10 0 57305823 911720448 12912 1283457024 134512640 134550932 4288326208 18446744073709551615 4094848865 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=14308/tid=14310] ppid=14296 vsize=890352 CPUtime=0
/proc/14308/task/14310/stat : 14310 (java) S 14296 14294 2160 34817 2160 4202560 7 0 0 0 0 0 0 0 16 0 10 0 57305832 911720448 12912 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14311] ppid=14296 vsize=890352 CPUtime=0
/proc/14308/task/14311/stat : 14311 (java) S 14296 14294 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 24 0 10 0 57305833 911720448 12912 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14312] ppid=14296 vsize=890352 CPUtime=0
/proc/14308/task/14312/stat : 14312 (java) S 14296 14294 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 24 0 10 0 57305834 911720448 12912 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14313] ppid=14296 vsize=890352 CPUtime=0
/proc/14308/task/14313/stat : 14313 (java) S 14296 14294 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 24 0 10 0 57305843 911720448 12912 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14314] ppid=14296 vsize=890352 CPUtime=0.29
/proc/14308/task/14314/stat : 14314 (java) R 14296 14294 2160 34817 2160 4202560 6881 0 1 0 29 0 0 0 24 0 10 0 57305843 911720448 12912 1283457024 134512640 134550932 4288326208 18446744073709551615 4151973506 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=14308/tid=14315] ppid=14296 vsize=890352 CPUtime=0.16
/proc/14308/task/14315/stat : 14315 (java) R 14296 14294 2160 34817 2160 4202560 3398 0 8 0 13 3 0 0 25 0 10 0 57305843 911720448 12912 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=14308/tid=14316] ppid=14296 vsize=890352 CPUtime=0
/proc/14308/task/14316/stat : 14316 (java) S 14296 14294 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 57305843 911720448 12912 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14317] ppid=14296 vsize=890352 CPUtime=0
/proc/14308/task/14317/stat : 14317 (java) S 14296 14294 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 17 0 10 0 57305843 911720448 12912 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 0.74
Current children cumulated vsize (KiB) 895488

[startup+3.1071 s]
/proc/loadavg: 0.85 0.97 0.99 3/47 14317
/proc/meminfo: memFree=855648/1048576 swapFree=0/0
[pid=14294] ppid=14293 vsize=2568 CPUtime=0
/proc/14294/stat : 14294 (p2cudf-user-1.1) S 14293 14294 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 57305777 2629632 270 1283457024 134512640 135304128 4294574448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14294/statm: 642 270 230 194 0 29 0
[pid=14296] ppid=14294 vsize=2568 CPUtime=0.02
/proc/14296/stat : 14296 (p2cudf) S 14294 14294 2160 34817 2160 4202496 387 3014 0 1 0 0 2 0 25 0 1 0 57305778 2629632 279 1283457024 134512640 135304128 4290956848 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14296/statm: 642 279 239 194 0 29 0
[pid=14308] ppid=14296 vsize=888188 CPUtime=2.31
/proc/14308/stat : 14308 (java) S 14296 14294 2160 34817 2160 4202496 58539 0 110 0 206 25 0 0 21 0 10 0 57305781 909504512 53620 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/14308/statm: 222047 53620 1745 10 0 219138 0
[pid=14308/tid=14309] ppid=14296 vsize=888188 CPUtime=1.22
/proc/14308/task/14309/stat : 14309 (java) R 14296 14294 2160 34817 2160 4202560 44296 0 15 0 104 18 0 0 25 0 10 0 57305823 909504512 53620 1283457024 134512640 134550932 4288326208 18446744073709551615 4094845306 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=14308/tid=14310] ppid=14296 vsize=888188 CPUtime=0
/proc/14308/task/14310/stat : 14310 (java) S 14296 14294 2160 34817 2160 4202560 7 0 0 0 0 0 0 0 15 0 10 0 57305832 909504512 53620 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14311] ppid=14296 vsize=888188 CPUtime=0
/proc/14308/task/14311/stat : 14311 (java) S 14296 14294 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 24 0 10 0 57305833 909504512 53620 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14312] ppid=14296 vsize=888188 CPUtime=0
/proc/14308/task/14312/stat : 14312 (java) S 14296 14294 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 24 0 10 0 57305834 909504512 53620 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14313] ppid=14296 vsize=888188 CPUtime=0
/proc/14308/task/14313/stat : 14313 (java) S 14296 14294 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 24 0 10 0 57305843 909504512 53620 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14314] ppid=14296 vsize=888188 CPUtime=0.74
/proc/14308/task/14314/stat : 14314 (java) S 14296 14294 2160 34817 2160 4202560 9151 0 1 0 72 2 0 0 24 0 10 0 57305843 909504512 53620 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14315] ppid=14296 vsize=888188 CPUtime=0.34
/proc/14308/task/14315/stat : 14315 (java) S 14296 14294 2160 34817 2160 4202560 4098 0 8 0 30 4 0 0 22 0 10 0 57305843 909504512 53620 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14316] ppid=14296 vsize=888188 CPUtime=0
/proc/14308/task/14316/stat : 14316 (java) S 14296 14294 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 57305843 909504512 53620 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14317] ppid=14296 vsize=888188 CPUtime=0
/proc/14308/task/14317/stat : 14317 (java) S 14296 14294 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 10 0 57305843 909504512 53620 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 2.33
Current children cumulated vsize (KiB) 893324
heavy processes:

[startup+6.30751 s]
/proc/loadavg: 0.86 0.97 0.99 2/47 14318
/proc/meminfo: memFree=644064/1048576 swapFree=0/0
[pid=14294] ppid=14293 vsize=2568 CPUtime=0
/proc/14294/stat : 14294 (p2cudf-user-1.1) S 14293 14294 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 57305777 2629632 270 1283457024 134512640 135304128 4294574448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14294/statm: 642 270 230 194 0 29 0
[pid=14296] ppid=14294 vsize=2568 CPUtime=0.02
/proc/14296/stat : 14296 (p2cudf) S 14294 14294 2160 34817 2160 4202496 387 3014 0 1 0 0 2 0 25 0 1 0 57305778 2629632 279 1283457024 134512640 135304128 4290956848 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14296/statm: 642 279 239 194 0 29 0
[pid=14308] ppid=14296 vsize=888928 CPUtime=5.37
/proc/14308/stat : 14308 (java) S 14296 14294 2160 34817 2160 4202496 79029 0 111 0 504 33 0 0 21 0 11 0 57305781 910262272 71993 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/14308/statm: 222232 71993 1777 10 0 219323 0
[pid=14308/tid=14309] ppid=14296 vsize=888928 CPUtime=2.39
/proc/14308/task/14309/stat : 14309 (java) R 14296 14294 2160 34817 2160 4202560 50273 0 15 0 219 20 0 0 25 0 11 0 57305823 910262272 71993 1283457024 134512640 134550932 4288326208 18446744073709551615 4095579079 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=14308/tid=14310] ppid=14296 vsize=888928 CPUtime=0.25
/proc/14308/task/14310/stat : 14310 (java) S 14296 14294 2160 34817 2160 4202560 12104 0 0 0 22 3 0 0 15 0 11 0 57305832 910262272 71993 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14311] ppid=14296 vsize=888928 CPUtime=0
/proc/14308/task/14311/stat : 14311 (java) S 14296 14294 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 57305833 910262272 71993 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14312] ppid=14296 vsize=888928 CPUtime=0
/proc/14308/task/14312/stat : 14312 (java) S 14296 14294 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 57305834 910262272 71993 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14313] ppid=14296 vsize=888928 CPUtime=0
/proc/14308/task/14313/stat : 14313 (java) S 14296 14294 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 24 0 11 0 57305843 910262272 71993 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14314] ppid=14296 vsize=888928 CPUtime=2.36
/proc/14308/task/14314/stat : 14314 (java) S 14296 14294 2160 34817 2160 4202560 11560 0 2 0 232 4 0 0 16 0 11 0 57305843 910262272 71993 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14315] ppid=14296 vsize=888928 CPUtime=0.34
/proc/14308/task/14315/stat : 14315 (java) S 14296 14294 2160 34817 2160 4202560 4098 0 8 0 30 4 0 0 22 0 11 0 57305843 910262272 71993 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14316] ppid=14296 vsize=888928 CPUtime=0
/proc/14308/task/14316/stat : 14316 (java) S 14296 14294 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57305843 910262272 71993 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14317] ppid=14296 vsize=888928 CPUtime=0
/proc/14308/task/14317/stat : 14317 (java) S 14296 14294 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 57305843 910262272 71993 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 5.39
Current children cumulated vsize (KiB) 894064

[startup+12.7054 s]
/proc/loadavg: 0.87 0.97 0.99 2/48 14319
/proc/meminfo: memFree=591616/1048576 swapFree=0/0
[pid=14294] ppid=14293 vsize=2568 CPUtime=0
/proc/14294/stat : 14294 (p2cudf-user-1.1) S 14293 14294 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 57305777 2629632 270 1283457024 134512640 135304128 4294574448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14294/statm: 642 270 230 194 0 29 0
[pid=14296] ppid=14294 vsize=2568 CPUtime=0.02
/proc/14296/stat : 14296 (p2cudf) S 14294 14294 2160 34817 2160 4202496 387 3014 0 1 0 0 2 0 25 0 1 0 57305778 2629632 279 1283457024 134512640 135304128 4290956848 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14296/statm: 642 279 239 194 0 29 0
[pid=14308] ppid=14296 vsize=884480 CPUtime=11.76
/proc/14308/stat : 14308 (java) S 14296 14294 2160 34817 2160 4202496 93156 0 111 0 1139 37 0 0 21 0 11 0 57305781 905707520 85081 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/14308/statm: 221120 85081 1787 10 0 218211 0
[pid=14308/tid=14309] ppid=14296 vsize=884480 CPUtime=7.9
/proc/14308/task/14309/stat : 14309 (java) R 14296 14294 2160 34817 2160 4202560 50276 0 15 0 770 20 0 0 25 0 11 0 57305823 905707520 85081 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=14308/tid=14310] ppid=14296 vsize=884480 CPUtime=0.56
/proc/14308/task/14310/stat : 14310 (java) S 14296 14294 2160 34817 2160 4202560 26126 0 0 0 48 8 0 0 15 0 11 0 57305832 905707520 85081 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14311] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14311/stat : 14311 (java) S 14296 14294 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 57305833 905707520 85081 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14312] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14312/stat : 14312 (java) S 14296 14294 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 57305834 905707520 85081 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14313] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14313/stat : 14313 (java) S 14296 14294 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 24 0 11 0 57305843 905707520 85081 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14314] ppid=14296 vsize=884480 CPUtime=2.94
/proc/14308/task/14314/stat : 14314 (java) R 14296 14294 2160 34817 2160 4202560 11662 0 2 0 290 4 0 0 16 0 11 0 57305843 905707520 85081 1283457024 134512640 134550932 4288326208 18446744073709551615 4151839149 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=14308/tid=14315] ppid=14296 vsize=884480 CPUtime=0.34
/proc/14308/task/14315/stat : 14315 (java) S 14296 14294 2160 34817 2160 4202560 4098 0 8 0 30 4 0 0 22 0 11 0 57305843 905707520 85081 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14316] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14316/stat : 14316 (java) S 14296 14294 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57305843 905707520 85081 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14317] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14317/stat : 14317 (java) S 14296 14294 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 57305843 905707520 85081 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14319] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14319/stat : 14319 (java) S 14296 14294 2160 34817 2160 4202560 5 0 0 0 0 0 0 0 25 0 11 0 57306349 905707520 85081 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 11.78
Current children cumulated vsize (KiB) 889616

[startup+25.5086 s]
/proc/loadavg: 0.90 0.97 0.99 2/47 14323
/proc/meminfo: memFree=566272/1048576 swapFree=0/0
[pid=14294] ppid=14293 vsize=2568 CPUtime=0
/proc/14294/stat : 14294 (p2cudf-user-1.1) S 14293 14294 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 57305777 2629632 270 1283457024 134512640 135304128 4294574448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14294/statm: 642 270 230 194 0 29 0
[pid=14296] ppid=14294 vsize=2568 CPUtime=0.02
/proc/14296/stat : 14296 (p2cudf) S 14294 14294 2160 34817 2160 4202496 387 3014 0 1 0 0 2 0 25 0 1 0 57305778 2629632 279 1283457024 134512640 135304128 4290956848 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14296/statm: 642 279 239 194 0 29 0
[pid=14308] ppid=14296 vsize=884480 CPUtime=24.55
/proc/14308/stat : 14308 (java) S 14296 14294 2160 34817 2160 4202496 99277 0 111 0 2416 39 0 0 21 0 11 0 57305781 905707520 91202 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/14308/statm: 221120 91202 1787 10 0 218211 0
[pid=14308/tid=14309] ppid=14296 vsize=884480 CPUtime=20.09
/proc/14308/task/14309/stat : 14309 (java) R 14296 14294 2160 34817 2160 4202560 50276 0 15 0 1989 20 0 0 25 0 11 0 57305823 905707520 91202 1283457024 134512640 134550932 4288326208 18446744073709551615 4094959994 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=14308/tid=14310] ppid=14296 vsize=884480 CPUtime=1.08
/proc/14308/task/14310/stat : 14310 (java) S 14296 14294 2160 34817 2160 4202560 32216 0 0 0 98 10 0 0 15 0 11 0 57305832 905707520 91202 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14311] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14311/stat : 14311 (java) S 14296 14294 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 57305833 905707520 91202 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14312] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14312/stat : 14312 (java) S 14296 14294 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 57305834 905707520 91202 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14313] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14313/stat : 14313 (java) S 14296 14294 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 24 0 11 0 57305843 905707520 91202 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14314] ppid=14296 vsize=884480 CPUtime=3.03
/proc/14308/task/14314/stat : 14314 (java) S 14296 14294 2160 34817 2160 4202560 11693 0 2 0 299 4 0 0 15 0 11 0 57305843 905707520 91202 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14315] ppid=14296 vsize=884480 CPUtime=0.34
/proc/14308/task/14315/stat : 14315 (java) S 14296 14294 2160 34817 2160 4202560 4098 0 8 0 30 4 0 0 22 0 11 0 57305843 905707520 91202 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14316] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14316/stat : 14316 (java) S 14296 14294 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57305843 905707520 91202 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14317] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14317/stat : 14317 (java) R 14296 14294 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 57305843 905707520 91202 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=14308/tid=14319] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14319/stat : 14319 (java) S 14296 14294 2160 34817 2160 4202560 5 0 0 0 0 0 0 0 25 0 11 0 57306349 905707520 91202 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 24.57
Current children cumulated vsize (KiB) 889616

[startup+51.1046 s]
/proc/loadavg: 0.93 0.97 0.99 2/47 14323
/proc/meminfo: memFree=559956/1048576 swapFree=0/0
[pid=14294] ppid=14293 vsize=2568 CPUtime=0
/proc/14294/stat : 14294 (p2cudf-user-1.1) S 14293 14294 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 57305777 2629632 270 1283457024 134512640 135304128 4294574448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14294/statm: 642 270 230 194 0 29 0
[pid=14296] ppid=14294 vsize=2568 CPUtime=0.02
/proc/14296/stat : 14296 (p2cudf) S 14294 14294 2160 34817 2160 4202496 387 3014 0 1 0 0 2 0 25 0 1 0 57305778 2629632 279 1283457024 134512640 135304128 4290956848 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14296/statm: 642 279 239 194 0 29 0
[pid=14308] ppid=14296 vsize=884480 CPUtime=50.12
/proc/14308/stat : 14308 (java) S 14296 14294 2160 34817 2160 4202496 100921 0 111 0 4973 39 0 0 21 0 11 0 57305781 905707520 92846 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/14308/statm: 221120 92846 1787 10 0 218211 0
[pid=14308/tid=14309] ppid=14296 vsize=884480 CPUtime=44.74
/proc/14308/task/14309/stat : 14309 (java) R 14296 14294 2160 34817 2160 4202560 50276 0 15 0 4454 20 0 0 25 0 11 0 57305823 905707520 92846 1283457024 134512640 134550932 4288326208 18446744073709551615 4095806753 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=14308/tid=14310] ppid=14296 vsize=884480 CPUtime=1.9
/proc/14308/task/14310/stat : 14310 (java) S 14296 14294 2160 34817 2160 4202560 33848 0 0 0 180 10 0 0 15 0 11 0 57305832 905707520 92846 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14311] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14311/stat : 14311 (java) S 14296 14294 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 57305833 905707520 92846 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14312] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14312/stat : 14312 (java) S 14296 14294 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 57305834 905707520 92846 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14313] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14313/stat : 14313 (java) S 14296 14294 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 24 0 11 0 57305843 905707520 92846 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14314] ppid=14296 vsize=884480 CPUtime=3.12
/proc/14308/task/14314/stat : 14314 (java) S 14296 14294 2160 34817 2160 4202560 11705 0 2 0 308 4 0 0 16 0 11 0 57305843 905707520 92846 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14315] ppid=14296 vsize=884480 CPUtime=0.34
/proc/14308/task/14315/stat : 14315 (java) S 14296 14294 2160 34817 2160 4202560 4098 0 8 0 30 4 0 0 22 0 11 0 57305843 905707520 92846 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14316] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14316/stat : 14316 (java) S 14296 14294 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57305843 905707520 92846 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14317] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14317/stat : 14317 (java) S 14296 14294 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 57305843 905707520 92846 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14319] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14319/stat : 14319 (java) S 14296 14294 2160 34817 2160 4202560 5 0 0 0 0 0 0 0 25 0 11 0 57306349 905707520 92846 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 50.14
Current children cumulated vsize (KiB) 889616

[startup+102.315 s]
/proc/loadavg: 0.97 0.97 0.99 2/46 14323
/proc/meminfo: memFree=541984/1048576 swapFree=0/0
[pid=14294] ppid=14293 vsize=2568 CPUtime=0
/proc/14294/stat : 14294 (p2cudf-user-1.1) S 14293 14294 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 57305777 2629632 270 1283457024 134512640 135304128 4294574448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14294/statm: 642 270 230 194 0 29 0
[pid=14296] ppid=14294 vsize=2568 CPUtime=0.02
/proc/14296/stat : 14296 (p2cudf) S 14294 14294 2160 34817 2160 4202496 387 3014 0 1 0 0 2 0 25 0 1 0 57305778 2629632 279 1283457024 134512640 135304128 4290956848 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14296/statm: 642 279 239 194 0 29 0
[pid=14308] ppid=14296 vsize=884480 CPUtime=101.29
/proc/14308/stat : 14308 (java) S 14296 14294 2160 34817 2160 4202496 105388 0 111 0 10089 40 0 0 21 0 11 0 57305781 905707520 97313 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/14308/statm: 221120 97313 1787 10 0 218211 0
[pid=14308/tid=14309] ppid=14296 vsize=884480 CPUtime=94.86
/proc/14308/task/14309/stat : 14309 (java) R 14296 14294 2160 34817 2160 4202560 50276 0 15 0 9466 20 0 0 25 0 11 0 57305823 905707520 97313 1283457024 134512640 134550932 4288326208 18446744073709551615 4095708066 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=14308/tid=14310] ppid=14296 vsize=884480 CPUtime=2.95
/proc/14308/task/14310/stat : 14310 (java) S 14296 14294 2160 34817 2160 4202560 38315 0 0 0 284 11 0 0 15 0 11 0 57305832 905707520 97313 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14311] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14311/stat : 14311 (java) S 14296 14294 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 57305833 905707520 97313 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14312] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14312/stat : 14312 (java) S 14296 14294 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 57305834 905707520 97313 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14313] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14313/stat : 14313 (java) S 14296 14294 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 24 0 11 0 57305843 905707520 97313 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14314] ppid=14296 vsize=884480 CPUtime=3.12
/proc/14308/task/14314/stat : 14314 (java) S 14296 14294 2160 34817 2160 4202560 11705 0 2 0 308 4 0 0 16 0 11 0 57305843 905707520 97313 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14315] ppid=14296 vsize=884480 CPUtime=0.34
/proc/14308/task/14315/stat : 14315 (java) S 14296 14294 2160 34817 2160 4202560 4098 0 8 0 30 4 0 0 22 0 11 0 57305843 905707520 97313 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14316] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14316/stat : 14316 (java) S 14296 14294 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57305843 905707520 97313 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14317] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14317/stat : 14317 (java) S 14296 14294 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 57305843 905707520 97313 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14319] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14319/stat : 14319 (java) S 14296 14294 2160 34817 2160 4202560 5 0 0 0 0 0 0 0 25 0 11 0 57306349 905707520 97313 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 101.31
Current children cumulated vsize (KiB) 889616

[startup+162.31 s]
/proc/loadavg: 0.99 0.97 0.99 3/46 14323
/proc/meminfo: memFree=522392/1048576 swapFree=0/0
[pid=14294] ppid=14293 vsize=2568 CPUtime=0
/proc/14294/stat : 14294 (p2cudf-user-1.1) S 14293 14294 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 57305777 2629632 270 1283457024 134512640 135304128 4294574448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14294/statm: 642 270 230 194 0 29 0
[pid=14296] ppid=14294 vsize=2568 CPUtime=0.02
/proc/14296/stat : 14296 (p2cudf) S 14294 14294 2160 34817 2160 4202496 387 3014 0 1 0 0 2 0 25 0 1 0 57305778 2629632 279 1283457024 134512640 135304128 4290956848 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14296/statm: 642 279 239 194 0 29 0
[pid=14308] ppid=14296 vsize=884480 CPUtime=161.25
/proc/14308/stat : 14308 (java) S 14296 14294 2160 34817 2160 4202496 110266 0 111 0 16083 42 0 0 21 0 11 0 57305781 905707520 102191 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/14308/statm: 221120 102191 1787 10 0 218211 0
[pid=14308/tid=14309] ppid=14296 vsize=884480 CPUtime=154
/proc/14308/task/14309/stat : 14309 (java) R 14296 14294 2160 34817 2160 4202560 50276 0 15 0 15380 20 0 0 25 0 11 0 57305823 905707520 102191 1283457024 134512640 134550932 4288326208 18446744073709551615 4095762873 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=14308/tid=14310] ppid=14296 vsize=884480 CPUtime=3.77
/proc/14308/task/14310/stat : 14310 (java) S 14296 14294 2160 34817 2160 4202560 43193 0 0 0 364 13 0 0 15 0 11 0 57305832 905707520 102191 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14311] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14311/stat : 14311 (java) S 14296 14294 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 57305833 905707520 102191 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14312] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14312/stat : 14312 (java) S 14296 14294 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 57305834 905707520 102191 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14313] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14313/stat : 14313 (java) S 14296 14294 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 24 0 11 0 57305843 905707520 102191 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14314] ppid=14296 vsize=884480 CPUtime=3.12
/proc/14308/task/14314/stat : 14314 (java) S 14296 14294 2160 34817 2160 4202560 11705 0 2 0 308 4 0 0 16 0 11 0 57305843 905707520 102191 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14315] ppid=14296 vsize=884480 CPUtime=0.34
/proc/14308/task/14315/stat : 14315 (java) S 14296 14294 2160 34817 2160 4202560 4098 0 8 0 30 4 0 0 22 0 11 0 57305843 905707520 102191 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14316] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14316/stat : 14316 (java) S 14296 14294 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57305843 905707520 102191 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14317] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14317/stat : 14317 (java) R 14296 14294 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 57305843 905707520 102191 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=14308/tid=14319] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14319/stat : 14319 (java) S 14296 14294 2160 34817 2160 4202560 5 0 0 0 0 0 0 0 25 0 11 0 57306349 905707520 102191 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 161.27
Current children cumulated vsize (KiB) 889616

[startup+222.305 s]
/proc/loadavg: 0.99 0.97 0.99 2/46 14323
/proc/meminfo: memFree=507016/1048576 swapFree=0/0
[pid=14294] ppid=14293 vsize=2568 CPUtime=0
/proc/14294/stat : 14294 (p2cudf-user-1.1) S 14293 14294 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 57305777 2629632 270 1283457024 134512640 135304128 4294574448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14294/statm: 642 270 230 194 0 29 0
[pid=14296] ppid=14294 vsize=2568 CPUtime=0.02
/proc/14296/stat : 14296 (p2cudf) S 14294 14294 2160 34817 2160 4202496 387 3014 0 1 0 0 2 0 25 0 1 0 57305778 2629632 279 1283457024 134512640 135304128 4290956848 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14296/statm: 642 279 239 194 0 29 0
[pid=14308] ppid=14296 vsize=884480 CPUtime=221.17
/proc/14308/stat : 14308 (java) S 14296 14294 2160 34817 2160 4202496 114094 0 111 0 22072 45 0 0 21 0 11 0 57305781 905707520 106019 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/14308/statm: 221120 106019 1787 10 0 218211 0
[pid=14308/tid=14309] ppid=14296 vsize=884480 CPUtime=213.39
/proc/14308/task/14309/stat : 14309 (java) R 14296 14294 2160 34817 2160 4202560 50276 0 15 0 21318 21 0 0 25 0 11 0 57305823 905707520 106019 1283457024 134512640 134550932 4288326208 18446744073709551615 4095762852 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=14308/tid=14310] ppid=14296 vsize=884480 CPUtime=4.31
/proc/14308/task/14310/stat : 14310 (java) S 14296 14294 2160 34817 2160 4202560 47021 0 0 0 416 15 0 0 15 0 11 0 57305832 905707520 106019 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14311] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14311/stat : 14311 (java) S 14296 14294 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 57305833 905707520 106019 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14312] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14312/stat : 14312 (java) S 14296 14294 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 57305834 905707520 106019 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14313] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14313/stat : 14313 (java) S 14296 14294 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 24 0 11 0 57305843 905707520 106019 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14314] ppid=14296 vsize=884480 CPUtime=3.12
/proc/14308/task/14314/stat : 14314 (java) S 14296 14294 2160 34817 2160 4202560 11705 0 2 0 308 4 0 0 15 0 11 0 57305843 905707520 106019 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14315] ppid=14296 vsize=884480 CPUtime=0.34
/proc/14308/task/14315/stat : 14315 (java) S 14296 14294 2160 34817 2160 4202560 4098 0 8 0 30 4 0 0 22 0 11 0 57305843 905707520 106019 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14316] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14316/stat : 14316 (java) S 14296 14294 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57305843 905707520 106019 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14317] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14317/stat : 14317 (java) S 14296 14294 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 57305843 905707520 106019 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14319] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14319/stat : 14319 (java) S 14296 14294 2160 34817 2160 4202560 5 0 0 0 0 0 0 0 25 0 11 0 57306349 905707520 106019 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 221.19
Current children cumulated vsize (KiB) 889616

[startup+282.309 s]
/proc/loadavg: 0.99 0.97 0.99 3/46 14323
/proc/meminfo: memFree=499204/1048576 swapFree=0/0
[pid=14294] ppid=14293 vsize=2568 CPUtime=0
/proc/14294/stat : 14294 (p2cudf-user-1.1) S 14293 14294 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 57305777 2629632 270 1283457024 134512640 135304128 4294574448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14294/statm: 642 270 230 194 0 29 0
[pid=14296] ppid=14294 vsize=2568 CPUtime=0.02
/proc/14296/stat : 14296 (p2cudf) S 14294 14294 2160 34817 2160 4202496 387 3014 0 1 0 0 2 0 25 0 1 0 57305778 2629632 279 1283457024 134512640 135304128 4290956848 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14296/statm: 642 279 239 194 0 29 0
[pid=14308] ppid=14296 vsize=884480 CPUtime=281.14
/proc/14308/stat : 14308 (java) S 14296 14294 2160 34817 2160 4202496 116037 0 111 0 28068 46 0 0 21 0 11 0 57305781 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/14308/statm: 221120 107962 1787 10 0 218211 0
[pid=14308/tid=14309] ppid=14296 vsize=884480 CPUtime=272.5
/proc/14308/task/14309/stat : 14309 (java) R 14296 14294 2160 34817 2160 4202560 50276 0 15 0 27229 21 0 0 25 0 11 0 57305823 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4095762786 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=14308/tid=14310] ppid=14296 vsize=884480 CPUtime=5.15
/proc/14308/task/14310/stat : 14310 (java) S 14296 14294 2160 34817 2160 4202560 48964 0 0 0 499 16 0 0 15 0 11 0 57305832 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14311] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14311/stat : 14311 (java) S 14296 14294 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 57305833 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14312] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14312/stat : 14312 (java) S 14296 14294 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 57305834 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14313] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14313/stat : 14313 (java) S 14296 14294 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 24 0 11 0 57305843 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14314] ppid=14296 vsize=884480 CPUtime=3.14
/proc/14308/task/14314/stat : 14314 (java) S 14296 14294 2160 34817 2160 4202560 11705 0 2 0 310 4 0 0 15 0 11 0 57305843 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14315] ppid=14296 vsize=884480 CPUtime=0.34
/proc/14308/task/14315/stat : 14315 (java) S 14296 14294 2160 34817 2160 4202560 4098 0 8 0 30 4 0 0 22 0 11 0 57305843 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14316] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14316/stat : 14316 (java) S 14296 14294 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57305843 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14317] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14317/stat : 14317 (java) S 14296 14294 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 57305843 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14319] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14319/stat : 14319 (java) S 14296 14294 2160 34817 2160 4202560 5 0 0 0 0 0 0 0 25 0 11 0 57306349 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 281.16
Current children cumulated vsize (KiB) 889616

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

[startup+284.81 s]
/proc/loadavg: 0.99 0.97 0.99 2/46 14323
/proc/meminfo: memFree=499204/1048576 swapFree=0/0
[pid=14294] ppid=14293 vsize=2568 CPUtime=0
/proc/14294/stat : 14294 (p2cudf-user-1.1) S 14293 14294 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 57305777 2629632 270 1283457024 134512640 135304128 4294574448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14294/statm: 642 270 230 194 0 29 0
[pid=14296] ppid=14294 vsize=2568 CPUtime=0.02
/proc/14296/stat : 14296 (p2cudf) S 14294 14294 2160 34817 2160 4202496 387 3014 0 1 0 0 2 0 25 0 1 0 57305778 2629632 279 1283457024 134512640 135304128 4290956848 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14296/statm: 642 279 239 194 0 29 0
[pid=14308] ppid=14296 vsize=884480 CPUtime=283.64
/proc/14308/stat : 14308 (java) S 14296 14294 2160 34817 2160 4202496 116037 0 111 0 28318 46 0 0 21 0 11 0 57305781 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/14308/statm: 221120 107962 1787 10 0 218211 0
[pid=14308/tid=14309] ppid=14296 vsize=884480 CPUtime=275
/proc/14308/task/14309/stat : 14309 (java) R 14296 14294 2160 34817 2160 4202560 50276 0 15 0 27479 21 0 0 25 0 11 0 57305823 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4094960106 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=14308/tid=14310] ppid=14296 vsize=884480 CPUtime=5.15
/proc/14308/task/14310/stat : 14310 (java) S 14296 14294 2160 34817 2160 4202560 48964 0 0 0 499 16 0 0 15 0 11 0 57305832 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14311] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14311/stat : 14311 (java) S 14296 14294 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 57305833 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14312] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14312/stat : 14312 (java) S 14296 14294 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 57305834 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14313] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14313/stat : 14313 (java) S 14296 14294 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 24 0 11 0 57305843 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14314] ppid=14296 vsize=884480 CPUtime=3.14
/proc/14308/task/14314/stat : 14314 (java) S 14296 14294 2160 34817 2160 4202560 11705 0 2 0 310 4 0 0 15 0 11 0 57305843 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14315] ppid=14296 vsize=884480 CPUtime=0.34
/proc/14308/task/14315/stat : 14315 (java) S 14296 14294 2160 34817 2160 4202560 4098 0 8 0 30 4 0 0 22 0 11 0 57305843 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14316] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14316/stat : 14316 (java) S 14296 14294 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57305843 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14317] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14317/stat : 14317 (java) S 14296 14294 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 57305843 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14319] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14319/stat : 14319 (java) S 14296 14294 2160 34817 2160 4202560 5 0 0 0 0 0 0 0 25 0 11 0 57306349 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.66
Current children cumulated vsize (KiB) 889616

[startup+285.61 s]
/proc/loadavg: 0.99 0.97 0.99 3/46 14323
/proc/meminfo: memFree=499204/1048576 swapFree=0/0
[pid=14294] ppid=14293 vsize=2568 CPUtime=0
/proc/14294/stat : 14294 (p2cudf-user-1.1) S 14293 14294 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 57305777 2629632 270 1283457024 134512640 135304128 4294574448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14294/statm: 642 270 230 194 0 29 0
[pid=14296] ppid=14294 vsize=2568 CPUtime=0.02
/proc/14296/stat : 14296 (p2cudf) S 14294 14294 2160 34817 2160 4202496 387 3014 0 1 0 0 2 0 25 0 1 0 57305778 2629632 279 1283457024 134512640 135304128 4290956848 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14296/statm: 642 279 239 194 0 29 0
[pid=14308] ppid=14296 vsize=884480 CPUtime=284.44
/proc/14308/stat : 14308 (java) S 14296 14294 2160 34817 2160 4202496 116037 0 111 0 28398 46 0 0 21 0 11 0 57305781 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/14308/statm: 221120 107962 1787 10 0 218211 0
[pid=14308/tid=14309] ppid=14296 vsize=884480 CPUtime=275.79
/proc/14308/task/14309/stat : 14309 (java) R 14296 14294 2160 34817 2160 4202560 50276 0 15 0 27558 21 0 0 25 0 11 0 57305823 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4095807124 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=14308/tid=14310] ppid=14296 vsize=884480 CPUtime=5.15
/proc/14308/task/14310/stat : 14310 (java) S 14296 14294 2160 34817 2160 4202560 48964 0 0 0 499 16 0 0 15 0 11 0 57305832 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14311] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14311/stat : 14311 (java) S 14296 14294 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 57305833 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14312] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14312/stat : 14312 (java) S 14296 14294 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 57305834 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14313] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14313/stat : 14313 (java) S 14296 14294 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 24 0 11 0 57305843 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14314] ppid=14296 vsize=884480 CPUtime=3.14
/proc/14308/task/14314/stat : 14314 (java) S 14296 14294 2160 34817 2160 4202560 11705 0 2 0 310 4 0 0 15 0 11 0 57305843 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14315] ppid=14296 vsize=884480 CPUtime=0.34
/proc/14308/task/14315/stat : 14315 (java) S 14296 14294 2160 34817 2160 4202560 4098 0 8 0 30 4 0 0 22 0 11 0 57305843 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14316] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14316/stat : 14316 (java) S 14296 14294 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57305843 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14317] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14317/stat : 14317 (java) S 14296 14294 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 57305843 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14319] ppid=14296 vsize=884480 CPUtime=0
/proc/14308/task/14319/stat : 14319 (java) S 14296 14294 2160 34817 2160 4202560 5 0 0 0 0 0 0 0 25 0 11 0 57306349 905707520 107962 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 284.46
Current children cumulated vsize (KiB) 889616

[startup+286.005 s]
/proc/loadavg: 0.99 0.97 0.99 1/46 14324
/proc/meminfo: memFree=499020/1048576 swapFree=0/0
[pid=14294] ppid=14293 vsize=2568 CPUtime=0
/proc/14294/stat : 14294 (p2cudf-user-1.1) S 14293 14294 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 57305777 2629632 270 1283457024 134512640 135304128 4294574448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14294/statm: 642 270 230 194 0 29 0
[pid=14296] ppid=14294 vsize=2568 CPUtime=0.02
/proc/14296/stat : 14296 (p2cudf) S 14294 14294 2160 34817 2160 4202496 387 3014 0 1 0 0 2 0 25 0 1 0 57305778 2629632 279 1283457024 134512640 135304128 4290956848 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14296/statm: 642 279 239 194 0 29 0
[pid=14308] ppid=14296 vsize=884804 CPUtime=284.6
/proc/14308/stat : 14308 (java) S 14296 14294 2160 34817 2160 4202496 116050 0 111 0 28414 46 0 0 21 0 11 0 57305781 906039296 107975 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/14308/statm: 221201 107975 1788 10 0 218292 0
[pid=14308/tid=14309] ppid=14296 vsize=884804 CPUtime=275.93
/proc/14308/task/14309/stat : 14309 (java) S 14296 14294 2160 34817 2160 4202560 50284 0 15 0 27572 21 0 0 25 0 11 0 57305823 906039296 107975 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14310] ppid=14296 vsize=884804 CPUtime=5.15
/proc/14308/task/14310/stat : 14310 (java) S 14296 14294 2160 34817 2160 4202560 48964 0 0 0 499 16 0 0 16 0 11 0 57305832 906039296 107975 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14311] ppid=14296 vsize=884804 CPUtime=0
/proc/14308/task/14311/stat : 14311 (java) S 14296 14294 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 57305833 906039296 107975 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14312] ppid=14296 vsize=884804 CPUtime=0
/proc/14308/task/14312/stat : 14312 (java) S 14296 14294 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 57305834 906039296 107975 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14313] ppid=14296 vsize=884804 CPUtime=0
/proc/14308/task/14313/stat : 14313 (java) S 14296 14294 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 24 0 11 0 57305843 906039296 107975 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14314] ppid=14296 vsize=884804 CPUtime=3.17
/proc/14308/task/14314/stat : 14314 (java) S 14296 14294 2160 34817 2160 4202560 11705 0 2 0 313 4 0 0 15 0 11 0 57305843 906039296 107975 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14315] ppid=14296 vsize=884804 CPUtime=0.34
/proc/14308/task/14315/stat : 14315 (java) S 14296 14294 2160 34817 2160 4202560 4098 0 8 0 30 4 0 0 22 0 11 0 57305843 906039296 107975 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14316] ppid=14296 vsize=884804 CPUtime=0
/proc/14308/task/14316/stat : 14316 (java) S 14296 14294 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57305843 906039296 107975 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14317] ppid=14296 vsize=884804 CPUtime=0
/proc/14308/task/14317/stat : 14317 (java) S 14296 14294 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 57305843 906039296 107975 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14324] ppid=14296 vsize=884804 CPUtime=0
/proc/14308/task/14324/stat : 14324 (java) S 14296 14294 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 57334358 906039296 107975 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 284.62
Current children cumulated vsize (KiB) 889940

[startup+286.405 s]
/proc/loadavg: 0.99 0.97 0.99 1/46 14324
/proc/meminfo: memFree=499020/1048576 swapFree=0/0
[pid=14294] ppid=14293 vsize=2568 CPUtime=0
/proc/14294/stat : 14294 (p2cudf-user-1.1) S 14293 14294 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 57305777 2629632 270 1283457024 134512640 135304128 4294574448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14294/statm: 642 270 230 194 0 29 0
[pid=14296] ppid=14294 vsize=2568 CPUtime=0.02
/proc/14296/stat : 14296 (p2cudf) S 14294 14294 2160 34817 2160 4202496 387 3014 0 1 0 0 2 0 25 0 1 0 57305778 2629632 279 1283457024 134512640 135304128 4290956848 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14296/statm: 642 279 239 194 0 29 0
[pid=14308] ppid=14296 vsize=884804 CPUtime=284.7
/proc/14308/stat : 14308 (java) S 14296 14294 2160 34817 2160 4202496 116052 0 111 0 28422 48 0 0 21 0 11 0 57305781 906039296 107977 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/14308/statm: 221201 107977 1788 10 0 218292 0
[pid=14308/tid=14309] ppid=14296 vsize=884804 CPUtime=275.93
/proc/14308/task/14309/stat : 14309 (java) S 14296 14294 2160 34817 2160 4202560 50284 0 15 0 27572 21 0 0 25 0 11 0 57305823 906039296 107977 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14310] ppid=14296 vsize=884804 CPUtime=5.15
/proc/14308/task/14310/stat : 14310 (java) S 14296 14294 2160 34817 2160 4202560 48964 0 0 0 499 16 0 0 16 0 11 0 57305832 906039296 107977 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14311] ppid=14296 vsize=884804 CPUtime=0
/proc/14308/task/14311/stat : 14311 (java) S 14296 14294 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 57305833 906039296 107977 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14312] ppid=14296 vsize=884804 CPUtime=0
/proc/14308/task/14312/stat : 14312 (java) S 14296 14294 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 57305834 906039296 107977 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14313] ppid=14296 vsize=884804 CPUtime=0
/proc/14308/task/14313/stat : 14313 (java) S 14296 14294 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 24 0 11 0 57305843 906039296 107977 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14314] ppid=14296 vsize=884804 CPUtime=3.19
/proc/14308/task/14314/stat : 14314 (java) S 14296 14294 2160 34817 2160 4202560 11705 0 2 0 315 4 0 0 15 0 11 0 57305843 906039296 107977 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14315] ppid=14296 vsize=884804 CPUtime=0.34
/proc/14308/task/14315/stat : 14315 (java) S 14296 14294 2160 34817 2160 4202560 4098 0 8 0 30 4 0 0 22 0 11 0 57305843 906039296 107977 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14316] ppid=14296 vsize=884804 CPUtime=0
/proc/14308/task/14316/stat : 14316 (java) S 14296 14294 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57305843 906039296 107977 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14317] ppid=14296 vsize=884804 CPUtime=0
/proc/14308/task/14317/stat : 14317 (java) S 14296 14294 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 57305843 906039296 107977 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14324] ppid=14296 vsize=884804 CPUtime=0.08
/proc/14308/task/14324/stat : 14324 (java) R 14296 14294 2160 34817 2160 4202560 6 0 0 0 6 2 0 0 21 0 11 0 57334358 906039296 107977 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 284.72
Current children cumulated vsize (KiB) 889940

[startup+286.505 s]
/proc/loadavg: 0.99 0.97 0.99 1/46 14324
/proc/meminfo: memFree=499020/1048576 swapFree=0/0
[pid=14294] ppid=14293 vsize=2568 CPUtime=0
/proc/14294/stat : 14294 (p2cudf-user-1.1) S 14293 14294 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 57305777 2629632 270 1283457024 134512640 135304128 4294574448 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14294/statm: 642 270 230 194 0 29 0
[pid=14296] ppid=14294 vsize=2568 CPUtime=0.02
/proc/14296/stat : 14296 (p2cudf) S 14294 14294 2160 34817 2160 4202496 387 3014 0 1 0 0 2 0 25 0 1 0 57305778 2629632 279 1283457024 134512640 135304128 4290956848 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/14296/statm: 642 279 239 194 0 29 0
[pid=14308] ppid=14296 vsize=884804 CPUtime=284.8
/proc/14308/stat : 14308 (java) S 14296 14294 2160 34817 2160 4202496 116052 0 111 0 28431 49 0 0 21 0 11 0 57305781 906039296 107977 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/14308/statm: 221201 107977 1788 10 0 218292 0
[pid=14308/tid=14309] ppid=14296 vsize=884804 CPUtime=275.93
/proc/14308/task/14309/stat : 14309 (java) S 14296 14294 2160 34817 2160 4202560 50284 0 15 0 27572 21 0 0 25 0 11 0 57305823 906039296 107977 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14310] ppid=14296 vsize=884804 CPUtime=5.15
/proc/14308/task/14310/stat : 14310 (java) S 14296 14294 2160 34817 2160 4202560 48964 0 0 0 499 16 0 0 16 0 11 0 57305832 906039296 107977 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14311] ppid=14296 vsize=884804 CPUtime=0
/proc/14308/task/14311/stat : 14311 (java) S 14296 14294 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 57305833 906039296 107977 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14312] ppid=14296 vsize=884804 CPUtime=0
/proc/14308/task/14312/stat : 14312 (java) S 14296 14294 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 57305834 906039296 107977 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14313] ppid=14296 vsize=884804 CPUtime=0
/proc/14308/task/14313/stat : 14313 (java) S 14296 14294 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 24 0 11 0 57305843 906039296 107977 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14314] ppid=14296 vsize=884804 CPUtime=3.23
/proc/14308/task/14314/stat : 14314 (java) S 14296 14294 2160 34817 2160 4202560 11705 0 2 0 319 4 0 0 15 0 11 0 57305843 906039296 107977 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14315] ppid=14296 vsize=884804 CPUtime=0.34
/proc/14308/task/14315/stat : 14315 (java) S 14296 14294 2160 34817 2160 4202560 4098 0 8 0 30 4 0 0 22 0 11 0 57305843 906039296 107977 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14316] ppid=14296 vsize=884804 CPUtime=0
/proc/14308/task/14316/stat : 14316 (java) S 14296 14294 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57305843 906039296 107977 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14317] ppid=14296 vsize=884804 CPUtime=0
/proc/14308/task/14317/stat : 14317 (java) S 14296 14294 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 57305843 906039296 107977 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=14308/tid=14324] ppid=14296 vsize=884804 CPUtime=0.12
/proc/14308/task/14324/stat : 14324 (java) R 14296 14294 2160 34817 2160 4202560 6 0 0 0 10 2 0 0 21 0 11 0 57334358 906039296 107977 1283457024 134512640 134550932 4288326208 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 284.82
Current children cumulated vsize (KiB) 889940

Child status: 0
Real time (s): 286.566
CPU time (s): 284.898
CPU user time (s): 284.346
CPU system time (s): 0.552034
CPU usage (%): 99.4177
Max. virtual memory (cumulated for all children) (KiB): 897020

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 284.346
system time used= 0.552034
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 119850
page faults= 112
swaps= 0
block input operations= 0
block output operations= 0
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 6515
involuntary context switches= 8695

runsolver used 0 second user time and 0 second system time

The end