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/201012070034/p2cudf-trendy-1.9/huge3.cudf.cudf_set.log.runsolver ./p2cudf-trendy-1.9 /home/misc2010/data/2010/cudf_set//huge3.cudf /home/misc2010/tmp/201012070034/p2cudf-trendy-1.9/huge3.cudf.cudf_set.result 

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.20 1.05 1.01 5/42 9451
/proc/meminfo: memFree=804192/1048576 swapFree=2080288/2097144
[pid=9449] ppid=9448 vsize=2572 CPUtime=0
/proc/9449/stat : 9449 (p2cudf-trendy-1) S 9448 9449 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 18 0 1 0 878874231 2633728 273 1283457024 134512640 135304128 4291985248 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9449/statm: 643 273 233 194 0 29 0
[pid=9450] ppid=9449 vsize=2568 CPUtime=0
/proc/9450/stat : 9450 (p2cudf) R 9449 9449 4159 34819 4229 4202496 347 0 0 0 0 0 0 0 25 0 1 0 878874231 2629632 273 1283457024 134512640 135304128 4289920336 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/9450/statm: 642 273 234 194 0 28 0
[pid=9451] ppid=9450 vsize=2568 CPUtime=0
/proc/9451/stat : 9451 (p2cudf) R 9450 9449 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 1 0 878874231 2629632 39 1283457024 134512640 135304128 4289920336 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/9451/statm: 642 39 0 194 0 28 0

[startup+0.1584 s]
/proc/loadavg: 1.20 1.05 1.01 5/42 9451
/proc/meminfo: memFree=804192/1048576 swapFree=2080288/2097144
[pid=9449] ppid=9448 vsize=2572 CPUtime=0
/proc/9449/stat : 9449 (p2cudf-trendy-1) S 9448 9449 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 18 0 1 0 878874231 2633728 273 1283457024 134512640 135304128 4291985248 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9449/statm: 643 273 233 194 0 29 0
[pid=9450] ppid=9449 vsize=2572 CPUtime=0.02
/proc/9450/stat : 9450 (p2cudf) S 9449 9449 4159 34819 4229 4202496 391 2994 0 1 0 0 2 0 25 0 1 0 878874231 2633728 281 1283457024 134512640 135304128 4289920336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9450/statm: 643 281 241 194 0 29 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5144

[startup+0.208435 s]
/proc/loadavg: 1.20 1.05 1.01 5/42 9451
/proc/meminfo: memFree=804192/1048576 swapFree=2080288/2097144
[pid=9449] ppid=9448 vsize=2572 CPUtime=0
/proc/9449/stat : 9449 (p2cudf-trendy-1) S 9448 9449 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 18 0 1 0 878874231 2633728 273 1283457024 134512640 135304128 4291985248 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9449/statm: 643 273 233 194 0 29 0
[pid=9450] ppid=9449 vsize=2572 CPUtime=0.02
/proc/9450/stat : 9450 (p2cudf) S 9449 9449 4159 34819 4229 4202496 391 2994 0 1 0 0 2 0 25 0 1 0 878874231 2633728 281 1283457024 134512640 135304128 4289920336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9450/statm: 643 281 241 194 0 29 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5144

[startup+0.308459 s]
/proc/loadavg: 1.20 1.05 1.01 5/42 9451
/proc/meminfo: memFree=804192/1048576 swapFree=2080288/2097144
[pid=9449] ppid=9448 vsize=2572 CPUtime=0
/proc/9449/stat : 9449 (p2cudf-trendy-1) S 9448 9449 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 18 0 1 0 878874231 2633728 273 1283457024 134512640 135304128 4291985248 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9449/statm: 643 273 233 194 0 29 0
[pid=9450] ppid=9449 vsize=2572 CPUtime=0.02
/proc/9450/stat : 9450 (p2cudf) S 9449 9449 4159 34819 4229 4202496 391 2994 0 1 0 0 2 0 25 0 1 0 878874231 2633728 281 1283457024 134512640 135304128 4289920336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9450/statm: 643 281 241 194 0 29 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5144

[startup+0.708581 s]
/proc/loadavg: 1.20 1.05 1.01 5/42 9451
/proc/meminfo: memFree=804192/1048576 swapFree=2080288/2097144
[pid=9449] ppid=9448 vsize=2572 CPUtime=0
/proc/9449/stat : 9449 (p2cudf-trendy-1) S 9448 9449 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 18 0 1 0 878874231 2633728 273 1283457024 134512640 135304128 4291985248 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9449/statm: 643 273 233 194 0 29 0
[pid=9450] ppid=9449 vsize=2572 CPUtime=0.02
/proc/9450/stat : 9450 (p2cudf) S 9449 9449 4159 34819 4229 4202496 391 2994 0 1 0 0 2 0 25 0 1 0 878874231 2633728 281 1283457024 134512640 135304128 4289920336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9450/statm: 643 281 241 194 0 29 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5144

[startup+1.50879 s]
/proc/loadavg: 1.20 1.05 1.01 4/52 9472
/proc/meminfo: memFree=770808/1048576 swapFree=2080288/2097144
[pid=9449] ppid=9448 vsize=2572 CPUtime=0
/proc/9449/stat : 9449 (p2cudf-trendy-1) S 9448 9449 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 18 0 1 0 878874231 2633728 273 1283457024 134512640 135304128 4291985248 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9449/statm: 643 273 233 194 0 29 0
[pid=9450] ppid=9449 vsize=2572 CPUtime=0.02
/proc/9450/stat : 9450 (p2cudf) S 9449 9449 4159 34819 4229 4202496 391 2994 0 1 0 0 2 0 25 0 1 0 878874231 2633728 281 1283457024 134512640 135304128 4289920336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9450/statm: 643 281 241 194 0 29 0
[pid=9463] ppid=9450 vsize=874208 CPUtime=1.47
/proc/9463/stat : 9463 (java) S 9450 9449 4159 34819 4229 4202496 12909 0 1 0 138 9 0 0 25 0 10 0 878874235 895188992 11309 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9463/statm: 218552 11309 1740 10 0 215642 0
[pid=9463/tid=9464] ppid=9450 vsize=874208 CPUtime=0.79
/proc/9463/task/9464/stat : 9464 (java) R 9450 9449 4159 34819 4229 4202560 5609 0 1 0 75 4 0 0 25 0 10 0 878874235 895188992 11309 1283457024 134512640 134550932 4293052144 18446744073709551615 4095275588 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9463/tid=9465] ppid=9450 vsize=874208 CPUtime=0
/proc/9463/task/9465/stat : 9465 (java) S 9450 9449 4159 34819 4229 4202560 5 0 0 0 0 0 0 0 18 0 10 0 878874237 895188992 11309 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 0 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9466] ppid=9450 vsize=874208 CPUtime=0
/proc/9463/task/9466/stat : 9466 (java) S 9450 9449 4159 34819 4229 4202560 9 0 0 0 0 0 0 0 25 0 10 0 878874237 895188992 11309 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9467] ppid=9450 vsize=874208 CPUtime=0
/proc/9463/task/9467/stat : 9467 (java) S 9450 9449 4159 34819 4229 4202560 4 0 0 0 0 0 0 0 25 0 10 0 878874237 895188992 11309 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9468] ppid=9450 vsize=874208 CPUtime=0
/proc/9463/task/9468/stat : 9468 (java) S 9450 9449 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 10 0 878874240 895188992 11309 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9469] ppid=9450 vsize=874208 CPUtime=0.55
/proc/9463/task/9469/stat : 9469 (java) R 9450 9449 4159 34819 4229 4202560 5221 0 0 0 52 3 0 0 25 0 10 0 878874240 895188992 11309 1283457024 134512640 134550932 4293052144 18446744073709551615 4150112121 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9463/tid=9470] ppid=9450 vsize=874208 CPUtime=0.1
/proc/9463/task/9470/stat : 9470 (java) R 9450 9449 4159 34819 4229 4202560 967 0 0 0 10 0 0 0 23 0 10 0 878874240 895188992 11309 1283457024 134512640 134550932 4293052144 18446744073709551615 4150111341 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9463/tid=9471] ppid=9450 vsize=874208 CPUtime=0
/proc/9463/task/9471/stat : 9471 (java) S 9450 9449 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 10 0 878874240 895188992 11309 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9472] ppid=9450 vsize=874208 CPUtime=0
/proc/9463/task/9472/stat : 9472 (java) S 9450 9449 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 15 0 10 0 878874240 895188992 11309 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 1.49
Current children cumulated vsize (KiB) 879352

[startup+3.10912 s]
/proc/loadavg: 1.34 1.08 1.02 4/52 9472
/proc/meminfo: memFree=761756/1048576 swapFree=2080288/2097144
[pid=9449] ppid=9448 vsize=2572 CPUtime=0
/proc/9449/stat : 9449 (p2cudf-trendy-1) S 9448 9449 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 18 0 1 0 878874231 2633728 273 1283457024 134512640 135304128 4291985248 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9449/statm: 643 273 233 194 0 29 0
[pid=9450] ppid=9449 vsize=2572 CPUtime=0.02
/proc/9450/stat : 9450 (p2cudf) S 9449 9449 4159 34819 4229 4202496 391 2994 0 1 0 0 2 0 25 0 1 0 878874231 2633728 281 1283457024 134512640 135304128 4289920336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9450/statm: 643 281 241 194 0 29 0
[pid=9463] ppid=9450 vsize=877192 CPUtime=3.07
/proc/9463/stat : 9463 (java) S 9450 9449 4159 34819 4229 4202496 19842 0 1 0 296 11 0 0 25 0 10 0 878874235 898244608 15093 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9463/statm: 219298 15093 1764 10 0 216388 0
[pid=9463/tid=9464] ppid=9450 vsize=877192 CPUtime=1.45
/proc/9463/task/9464/stat : 9464 (java) R 9450 9449 4159 34819 4229 4202560 8383 0 1 0 139 6 0 0 25 0 10 0 878874235 898244608 15093 1283457024 134512640 134550932 4293052144 18446744073709551615 4095803316 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9463/tid=9465] ppid=9450 vsize=877192 CPUtime=0
/proc/9463/task/9465/stat : 9465 (java) S 9450 9449 4159 34819 4229 4202560 5 0 0 0 0 0 0 0 18 0 10 0 878874237 898244608 15093 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 0 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9466] ppid=9450 vsize=877192 CPUtime=0
/proc/9463/task/9466/stat : 9466 (java) S 9450 9449 4159 34819 4229 4202560 9 0 0 0 0 0 0 0 25 0 10 0 878874237 898244608 15093 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9467] ppid=9450 vsize=877192 CPUtime=0
/proc/9463/task/9467/stat : 9467 (java) S 9450 9449 4159 34819 4229 4202560 4 0 0 0 0 0 0 0 25 0 10 0 878874237 898244608 15093 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9468] ppid=9450 vsize=877192 CPUtime=0
/proc/9463/task/9468/stat : 9468 (java) S 9450 9449 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 10 0 878874240 898244608 15093 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9469] ppid=9450 vsize=877192 CPUtime=0.82
/proc/9463/task/9469/stat : 9469 (java) S 9450 9449 4159 34819 4229 4202560 6887 0 0 0 79 3 0 0 21 0 10 0 878874240 898244608 15093 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9470] ppid=9450 vsize=877192 CPUtime=0.77
/proc/9463/task/9470/stat : 9470 (java) R 9450 9449 4159 34819 4229 4202560 3460 0 0 0 77 0 0 0 25 0 10 0 878874240 898244608 15093 1283457024 134512640 134550932 4293052144 18446744073709551615 4152420739 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9463/tid=9471] ppid=9450 vsize=877192 CPUtime=0
/proc/9463/task/9471/stat : 9471 (java) S 9450 9449 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 10 0 878874240 898244608 15093 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9472] ppid=9450 vsize=877192 CPUtime=0
/proc/9463/task/9472/stat : 9472 (java) S 9450 9449 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 15 0 10 0 878874240 898244608 15093 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 3.09
Current children cumulated vsize (KiB) 882336

[startup+6.30997 s]
/proc/loadavg: 1.34 1.08 1.02 3/53 9473
/proc/meminfo: memFree=734352/1048576 swapFree=2080288/2097144
[pid=9449] ppid=9448 vsize=2572 CPUtime=0
/proc/9449/stat : 9449 (p2cudf-trendy-1) S 9448 9449 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 18 0 1 0 878874231 2633728 273 1283457024 134512640 135304128 4291985248 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9449/statm: 643 273 233 194 0 29 0
[pid=9450] ppid=9449 vsize=2572 CPUtime=0.02
/proc/9450/stat : 9450 (p2cudf) S 9449 9449 4159 34819 4229 4202496 391 2994 0 1 0 0 2 0 25 0 1 0 878874231 2633728 281 1283457024 134512640 135304128 4289920336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9450/statm: 643 281 241 194 0 29 0
[pid=9463] ppid=9450 vsize=877516 CPUtime=6.26
/proc/9463/stat : 9463 (java) S 9450 9449 4159 34819 4229 4202496 29031 0 1 0 610 16 0 0 25 0 11 0 878874235 898576384 21521 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9463/statm: 219379 21521 1780 10 0 216469 0
[pid=9463/tid=9464] ppid=9450 vsize=877516 CPUtime=3.48
/proc/9463/task/9464/stat : 9464 (java) R 9450 9449 4159 34819 4229 4202560 13143 0 1 0 338 10 0 0 25 0 11 0 878874235 898576384 21521 1283457024 134512640 134550932 4293052144 18446744073709551615 4096168912 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9463/tid=9465] ppid=9450 vsize=877516 CPUtime=0.07
/proc/9463/task/9465/stat : 9465 (java) S 9450 9449 4159 34819 4229 4202560 1568 0 0 0 7 0 0 0 16 0 11 0 878874237 898576384 21521 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 0 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9466] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9466/stat : 9466 (java) S 9450 9449 4159 34819 4229 4202560 9 0 0 0 0 0 0 0 18 0 11 0 878874237 898576384 21521 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9467] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9467/stat : 9467 (java) S 9450 9449 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 18 0 11 0 878874237 898576384 21521 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9468] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9468/stat : 9468 (java) S 9450 9449 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 878874240 898576384 21521 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9469] ppid=9450 vsize=877516 CPUtime=1.01
/proc/9463/task/9469/stat : 9469 (java) S 9450 9449 4159 34819 4229 4202560 6907 0 0 0 98 3 0 0 15 0 11 0 878874240 898576384 21521 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9470] ppid=9450 vsize=877516 CPUtime=1.66
/proc/9463/task/9470/stat : 9470 (java) S 9450 9449 4159 34819 4229 4202560 6299 0 0 0 166 0 0 0 15 0 11 0 878874240 898576384 21521 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9471] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9471/stat : 9471 (java) S 9450 9449 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 11 0 878874240 898576384 21521 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9472] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9472/stat : 9472 (java) R 9450 9449 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 15 0 11 0 878874240 898576384 21521 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9463/tid=9473] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9473/stat : 9473 (java) S 9450 9449 4159 34819 4229 4202560 5 0 0 0 0 0 0 0 24 0 11 0 878874672 898576384 21521 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 6.28
Current children cumulated vsize (KiB) 882660

[startup+12.7116 s]
/proc/loadavg: 1.29 1.08 1.02 2/53 9473
/proc/meminfo: memFree=725680/1048576 swapFree=2080288/2097144
[pid=9449] ppid=9448 vsize=2572 CPUtime=0
/proc/9449/stat : 9449 (p2cudf-trendy-1) S 9448 9449 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 18 0 1 0 878874231 2633728 273 1283457024 134512640 135304128 4291985248 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9449/statm: 643 273 233 194 0 29 0
[pid=9450] ppid=9449 vsize=2572 CPUtime=0.02
/proc/9450/stat : 9450 (p2cudf) S 9449 9449 4159 34819 4229 4202496 391 2994 0 1 0 0 2 0 25 0 1 0 878874231 2633728 281 1283457024 134512640 135304128 4289920336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9450/statm: 643 281 241 194 0 29 0
[pid=9463] ppid=9450 vsize=877516 CPUtime=12.65
/proc/9463/stat : 9463 (java) S 9450 9449 4159 34819 4229 4202496 29320 0 1 0 1249 16 0 0 25 0 11 0 878874235 898576384 21810 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9463/statm: 219379 21810 1780 10 0 216469 0
[pid=9463/tid=9464] ppid=9450 vsize=877516 CPUtime=9.67
/proc/9463/task/9464/stat : 9464 (java) R 9450 9449 4159 34819 4229 4202560 13144 0 1 0 957 10 0 0 25 0 11 0 878874235 898576384 21810 1283457024 134512640 134550932 4293052144 18446744073709551615 4096308458 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9463/tid=9465] ppid=9450 vsize=877516 CPUtime=0.2
/proc/9463/task/9465/stat : 9465 (java) S 9450 9449 4159 34819 4229 4202560 1845 0 0 0 20 0 0 0 16 0 11 0 878874237 898576384 21810 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 0 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9466] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9466/stat : 9466 (java) S 9450 9449 4159 34819 4229 4202560 9 0 0 0 0 0 0 0 18 0 11 0 878874237 898576384 21810 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9467] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9467/stat : 9467 (java) S 9450 9449 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 18 0 11 0 878874237 898576384 21810 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9468] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9468/stat : 9468 (java) S 9450 9449 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 878874240 898576384 21810 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9469] ppid=9450 vsize=877516 CPUtime=1.01
/proc/9463/task/9469/stat : 9469 (java) S 9450 9449 4159 34819 4229 4202560 6907 0 0 0 98 3 0 0 15 0 11 0 878874240 898576384 21810 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9470] ppid=9450 vsize=877516 CPUtime=1.72
/proc/9463/task/9470/stat : 9470 (java) S 9450 9449 4159 34819 4229 4202560 6310 0 0 0 172 0 0 0 15 0 11 0 878874240 898576384 21810 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9471] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9471/stat : 9471 (java) S 9450 9449 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 11 0 878874240 898576384 21810 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9472] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9472/stat : 9472 (java) S 9450 9449 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 15 0 11 0 878874240 898576384 21810 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9473] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9473/stat : 9473 (java) S 9450 9449 4159 34819 4229 4202560 5 0 0 0 0 0 0 0 24 0 11 0 878874672 898576384 21810 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 12.67
Current children cumulated vsize (KiB) 882660

[startup+25.5049 s]
/proc/loadavg: 1.25 1.08 1.02 2/53 9473
/proc/meminfo: memFree=724564/1048576 swapFree=2080288/2097144
[pid=9449] ppid=9448 vsize=2572 CPUtime=0
/proc/9449/stat : 9449 (p2cudf-trendy-1) S 9448 9449 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 18 0 1 0 878874231 2633728 273 1283457024 134512640 135304128 4291985248 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9449/statm: 643 273 233 194 0 29 0
[pid=9450] ppid=9449 vsize=2572 CPUtime=0.02
/proc/9450/stat : 9450 (p2cudf) S 9449 9449 4159 34819 4229 4202496 391 2994 0 1 0 0 2 0 25 0 1 0 878874231 2633728 281 1283457024 134512640 135304128 4289920336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9450/statm: 643 281 241 194 0 29 0
[pid=9463] ppid=9450 vsize=877516 CPUtime=25.42
/proc/9463/stat : 9463 (java) S 9450 9449 4159 34819 4229 4202496 29607 0 1 0 2526 16 0 0 25 0 11 0 878874235 898576384 22097 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9463/statm: 219379 22097 1780 10 0 216469 0
[pid=9463/tid=9464] ppid=9450 vsize=877516 CPUtime=22.31
/proc/9463/task/9464/stat : 9464 (java) R 9450 9449 4159 34819 4229 4202560 13144 0 1 0 2221 10 0 0 25 0 11 0 878874235 898576384 22097 1283457024 134512640 134550932 4293052144 18446744073709551615 4096169049 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9463/tid=9465] ppid=9450 vsize=877516 CPUtime=0.32
/proc/9463/task/9465/stat : 9465 (java) S 9450 9449 4159 34819 4229 4202560 2132 0 0 0 32 0 0 0 15 0 11 0 878874237 898576384 22097 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 0 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9466] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9466/stat : 9466 (java) S 9450 9449 4159 34819 4229 4202560 9 0 0 0 0 0 0 0 18 0 11 0 878874237 898576384 22097 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9467] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9467/stat : 9467 (java) S 9450 9449 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 18 0 11 0 878874237 898576384 22097 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9468] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9468/stat : 9468 (java) S 9450 9449 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 878874240 898576384 22097 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9469] ppid=9450 vsize=877516 CPUtime=1.01
/proc/9463/task/9469/stat : 9469 (java) S 9450 9449 4159 34819 4229 4202560 6907 0 0 0 98 3 0 0 15 0 11 0 878874240 898576384 22097 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9470] ppid=9450 vsize=877516 CPUtime=1.73
/proc/9463/task/9470/stat : 9470 (java) S 9450 9449 4159 34819 4229 4202560 6310 0 0 0 173 0 0 0 15 0 11 0 878874240 898576384 22097 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9471] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9471/stat : 9471 (java) S 9450 9449 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 11 0 878874240 898576384 22097 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9472] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9472/stat : 9472 (java) S 9450 9449 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 15 0 11 0 878874240 898576384 22097 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9473] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9473/stat : 9473 (java) S 9450 9449 4159 34819 4229 4202560 5 0 0 0 0 0 0 0 24 0 11 0 878874672 898576384 22097 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 25.44
Current children cumulated vsize (KiB) 882660

[startup+51.1124 s]
/proc/loadavg: 1.16 1.07 1.02 3/53 9473
/proc/meminfo: memFree=723572/1048576 swapFree=2080288/2097144
[pid=9449] ppid=9448 vsize=2572 CPUtime=0
/proc/9449/stat : 9449 (p2cudf-trendy-1) S 9448 9449 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 18 0 1 0 878874231 2633728 273 1283457024 134512640 135304128 4291985248 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9449/statm: 643 273 233 194 0 29 0
[pid=9450] ppid=9449 vsize=2572 CPUtime=0.02
/proc/9450/stat : 9450 (p2cudf) S 9449 9449 4159 34819 4229 4202496 391 2994 0 1 0 0 2 0 25 0 1 0 878874231 2633728 281 1283457024 134512640 135304128 4289920336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9450/statm: 643 281 241 194 0 29 0
[pid=9463] ppid=9450 vsize=877516 CPUtime=50.99
/proc/9463/stat : 9463 (java) S 9450 9449 4159 34819 4229 4202496 29864 0 1 0 5083 16 0 0 25 0 11 0 878874235 898576384 22354 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9463/statm: 219379 22354 1780 10 0 216469 0
[pid=9463/tid=9464] ppid=9450 vsize=877516 CPUtime=47.64
/proc/9463/task/9464/stat : 9464 (java) R 9450 9449 4159 34819 4229 4202560 13144 0 1 0 4754 10 0 0 25 0 11 0 878874235 898576384 22354 1283457024 134512640 134550932 4293052144 18446744073709551615 4096167798 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9463/tid=9465] ppid=9450 vsize=877516 CPUtime=0.56
/proc/9463/task/9465/stat : 9465 (java) S 9450 9449 4159 34819 4229 4202560 2389 0 0 0 56 0 0 0 15 0 11 0 878874237 898576384 22354 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 0 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9466] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9466/stat : 9466 (java) S 9450 9449 4159 34819 4229 4202560 9 0 0 0 0 0 0 0 18 0 11 0 878874237 898576384 22354 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9467] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9467/stat : 9467 (java) S 9450 9449 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 18 0 11 0 878874237 898576384 22354 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9468] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9468/stat : 9468 (java) S 9450 9449 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 878874240 898576384 22354 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9469] ppid=9450 vsize=877516 CPUtime=1.01
/proc/9463/task/9469/stat : 9469 (java) S 9450 9449 4159 34819 4229 4202560 6907 0 0 0 98 3 0 0 15 0 11 0 878874240 898576384 22354 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9470] ppid=9450 vsize=877516 CPUtime=1.73
/proc/9463/task/9470/stat : 9470 (java) S 9450 9449 4159 34819 4229 4202560 6310 0 0 0 173 0 0 0 15 0 11 0 878874240 898576384 22354 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9471] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9471/stat : 9471 (java) S 9450 9449 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 11 0 878874240 898576384 22354 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9472] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9472/stat : 9472 (java) S 9450 9449 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 15 0 11 0 878874240 898576384 22354 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9473] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9473/stat : 9473 (java) S 9450 9449 4159 34819 4229 4202560 5 0 0 0 0 0 0 0 24 0 11 0 878874672 898576384 22354 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 51.01
Current children cumulated vsize (KiB) 882660

[startup+102.313 s]
/proc/loadavg: 1.06 1.06 1.02 2/53 9473
/proc/meminfo: memFree=722456/1048576 swapFree=2080288/2097144
[pid=9449] ppid=9448 vsize=2572 CPUtime=0
/proc/9449/stat : 9449 (p2cudf-trendy-1) S 9448 9449 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 18 0 1 0 878874231 2633728 273 1283457024 134512640 135304128 4291985248 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9449/statm: 643 273 233 194 0 29 0
[pid=9450] ppid=9449 vsize=2572 CPUtime=0.02
/proc/9450/stat : 9450 (p2cudf) S 9449 9449 4159 34819 4229 4202496 391 2994 0 1 0 0 2 0 25 0 1 0 878874231 2633728 281 1283457024 134512640 135304128 4289920336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9450/statm: 643 281 241 194 0 29 0
[pid=9463] ppid=9450 vsize=877516 CPUtime=102.09
/proc/9463/stat : 9463 (java) S 9450 9449 4159 34819 4229 4202496 30119 0 1 0 10192 17 0 0 25 0 11 0 878874235 898576384 22609 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9463/statm: 219379 22609 1780 10 0 216469 0
[pid=9463/tid=9464] ppid=9450 vsize=877516 CPUtime=98.45
/proc/9463/task/9464/stat : 9464 (java) R 9450 9449 4159 34819 4229 4202560 13144 0 1 0 9834 11 0 0 25 0 11 0 878874235 898576384 22609 1283457024 134512640 134550932 4293052144 18446744073709551615 4096168948 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9463/tid=9465] ppid=9450 vsize=877516 CPUtime=0.85
/proc/9463/task/9465/stat : 9465 (java) S 9450 9449 4159 34819 4229 4202560 2644 0 0 0 85 0 0 0 16 0 11 0 878874237 898576384 22609 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 0 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9466] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9466/stat : 9466 (java) S 9450 9449 4159 34819 4229 4202560 9 0 0 0 0 0 0 0 18 0 11 0 878874237 898576384 22609 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9467] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9467/stat : 9467 (java) S 9450 9449 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 18 0 11 0 878874237 898576384 22609 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9468] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9468/stat : 9468 (java) S 9450 9449 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 878874240 898576384 22609 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9469] ppid=9450 vsize=877516 CPUtime=1.01
/proc/9463/task/9469/stat : 9469 (java) S 9450 9449 4159 34819 4229 4202560 6907 0 0 0 98 3 0 0 15 0 11 0 878874240 898576384 22609 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9470] ppid=9450 vsize=877516 CPUtime=1.73
/proc/9463/task/9470/stat : 9470 (java) S 9450 9449 4159 34819 4229 4202560 6310 0 0 0 173 0 0 0 15 0 11 0 878874240 898576384 22609 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9471] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9471/stat : 9471 (java) S 9450 9449 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 11 0 878874240 898576384 22609 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9472] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9472/stat : 9472 (java) S 9450 9449 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 15 0 11 0 878874240 898576384 22609 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9473] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9473/stat : 9473 (java) S 9450 9449 4159 34819 4229 4202560 5 0 0 0 0 0 0 0 24 0 11 0 878874672 898576384 22609 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 102.11
Current children cumulated vsize (KiB) 882660

[startup+162.312 s]
/proc/loadavg: 1.02 1.05 1.01 3/53 9473
/proc/meminfo: memFree=721588/1048576 swapFree=2080288/2097144
[pid=9449] ppid=9448 vsize=2572 CPUtime=0
/proc/9449/stat : 9449 (p2cudf-trendy-1) S 9448 9449 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 18 0 1 0 878874231 2633728 273 1283457024 134512640 135304128 4291985248 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9449/statm: 643 273 233 194 0 29 0
[pid=9450] ppid=9449 vsize=2572 CPUtime=0.02
/proc/9450/stat : 9450 (p2cudf) S 9449 9449 4159 34819 4229 4202496 391 2994 0 1 0 0 2 0 25 0 1 0 878874231 2633728 281 1283457024 134512640 135304128 4289920336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9450/statm: 643 281 241 194 0 29 0
[pid=9463] ppid=9450 vsize=877516 CPUtime=162.02
/proc/9463/stat : 9463 (java) S 9450 9449 4159 34819 4229 4202496 30237 0 1 0 16185 17 0 0 25 0 11 0 878874235 898576384 22727 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9463/statm: 219379 22727 1780 10 0 216469 0
[pid=9463/tid=9464] ppid=9450 vsize=877516 CPUtime=158.1
/proc/9463/task/9464/stat : 9464 (java) R 9450 9449 4159 34819 4229 4202560 13144 0 1 0 15799 11 0 0 25 0 11 0 878874235 898576384 22727 1283457024 134512640 134550932 4293052144 18446744073709551615 4096169004 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9463/tid=9465] ppid=9450 vsize=877516 CPUtime=1.14
/proc/9463/task/9465/stat : 9465 (java) S 9450 9449 4159 34819 4229 4202560 2762 0 0 0 114 0 0 0 15 0 11 0 878874237 898576384 22727 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 0 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9466] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9466/stat : 9466 (java) S 9450 9449 4159 34819 4229 4202560 9 0 0 0 0 0 0 0 18 0 11 0 878874237 898576384 22727 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9467] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9467/stat : 9467 (java) S 9450 9449 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 18 0 11 0 878874237 898576384 22727 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9468] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9468/stat : 9468 (java) S 9450 9449 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 878874240 898576384 22727 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9469] ppid=9450 vsize=877516 CPUtime=1.01
/proc/9463/task/9469/stat : 9469 (java) S 9450 9449 4159 34819 4229 4202560 6907 0 0 0 98 3 0 0 15 0 11 0 878874240 898576384 22727 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9470] ppid=9450 vsize=877516 CPUtime=1.73
/proc/9463/task/9470/stat : 9470 (java) S 9450 9449 4159 34819 4229 4202560 6310 0 0 0 173 0 0 0 15 0 11 0 878874240 898576384 22727 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9471] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9471/stat : 9471 (java) S 9450 9449 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 11 0 878874240 898576384 22727 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9472] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9472/stat : 9472 (java) R 9450 9449 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 15 0 11 0 878874240 898576384 22727 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9463/tid=9473] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9473/stat : 9473 (java) S 9450 9449 4159 34819 4229 4202560 5 0 0 0 0 0 0 0 24 0 11 0 878874672 898576384 22727 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 162.04
Current children cumulated vsize (KiB) 882660

[startup+222.31 s]
/proc/loadavg: 1.01 1.03 1.00 3/53 9473
/proc/meminfo: memFree=721216/1048576 swapFree=2080288/2097144
[pid=9449] ppid=9448 vsize=2572 CPUtime=0
/proc/9449/stat : 9449 (p2cudf-trendy-1) S 9448 9449 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 18 0 1 0 878874231 2633728 273 1283457024 134512640 135304128 4291985248 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9449/statm: 643 273 233 194 0 29 0
[pid=9450] ppid=9449 vsize=2572 CPUtime=0.02
/proc/9450/stat : 9450 (p2cudf) S 9449 9449 4159 34819 4229 4202496 391 2994 0 1 0 0 2 0 25 0 1 0 878874231 2633728 281 1283457024 134512640 135304128 4289920336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9450/statm: 643 281 241 194 0 29 0
[pid=9463] ppid=9450 vsize=877516 CPUtime=221.95
/proc/9463/stat : 9463 (java) S 9450 9449 4159 34819 4229 4202496 30348 0 1 0 22178 17 0 0 25 0 11 0 878874235 898576384 22838 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9463/statm: 219379 22838 1780 10 0 216469 0
[pid=9463/tid=9464] ppid=9450 vsize=877516 CPUtime=217.71
/proc/9463/task/9464/stat : 9464 (java) R 9450 9449 4159 34819 4229 4202560 13144 0 1 0 21760 11 0 0 25 0 11 0 878874235 898576384 22838 1283457024 134512640 134550932 4293052144 18446744073709551615 4096167864 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9463/tid=9465] ppid=9450 vsize=877516 CPUtime=1.45
/proc/9463/task/9465/stat : 9465 (java) S 9450 9449 4159 34819 4229 4202560 2873 0 0 0 145 0 0 0 15 0 11 0 878874237 898576384 22838 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 0 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9466] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9466/stat : 9466 (java) S 9450 9449 4159 34819 4229 4202560 9 0 0 0 0 0 0 0 18 0 11 0 878874237 898576384 22838 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9467] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9467/stat : 9467 (java) S 9450 9449 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 18 0 11 0 878874237 898576384 22838 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9468] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9468/stat : 9468 (java) S 9450 9449 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 878874240 898576384 22838 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9469] ppid=9450 vsize=877516 CPUtime=1.01
/proc/9463/task/9469/stat : 9469 (java) S 9450 9449 4159 34819 4229 4202560 6907 0 0 0 98 3 0 0 15 0 11 0 878874240 898576384 22838 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9470] ppid=9450 vsize=877516 CPUtime=1.73
/proc/9463/task/9470/stat : 9470 (java) S 9450 9449 4159 34819 4229 4202560 6310 0 0 0 173 0 0 0 15 0 11 0 878874240 898576384 22838 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9471] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9471/stat : 9471 (java) S 9450 9449 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 11 0 878874240 898576384 22838 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9472] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9472/stat : 9472 (java) S 9450 9449 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 15 0 11 0 878874240 898576384 22838 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9473] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9473/stat : 9473 (java) S 9450 9449 4159 34819 4229 4202560 5 0 0 0 0 0 0 0 24 0 11 0 878874672 898576384 22838 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 221.97
Current children cumulated vsize (KiB) 882660

[startup+282.307 s]
/proc/loadavg: 1.00 1.03 1.00 2/53 9473
/proc/meminfo: memFree=720968/1048576 swapFree=2080288/2097144
[pid=9449] ppid=9448 vsize=2572 CPUtime=0
/proc/9449/stat : 9449 (p2cudf-trendy-1) S 9448 9449 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 18 0 1 0 878874231 2633728 273 1283457024 134512640 135304128 4291985248 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9449/statm: 643 273 233 194 0 29 0
[pid=9450] ppid=9449 vsize=2572 CPUtime=0.02
/proc/9450/stat : 9450 (p2cudf) S 9449 9449 4159 34819 4229 4202496 391 2994 0 1 0 0 2 0 25 0 1 0 878874231 2633728 281 1283457024 134512640 135304128 4289920336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9450/statm: 643 281 241 194 0 29 0
[pid=9463] ppid=9450 vsize=877516 CPUtime=281.91
/proc/9463/stat : 9463 (java) S 9450 9449 4159 34819 4229 4202496 30438 0 1 0 28173 18 0 0 25 0 11 0 878874235 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9463/statm: 219379 22928 1780 10 0 216469 0
[pid=9463/tid=9464] ppid=9450 vsize=877516 CPUtime=277.34
/proc/9463/task/9464/stat : 9464 (java) R 9450 9449 4159 34819 4229 4202560 13144 0 1 0 27722 12 0 0 25 0 11 0 878874235 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4096308458 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9463/tid=9465] ppid=9450 vsize=877516 CPUtime=1.78
/proc/9463/task/9465/stat : 9465 (java) S 9450 9449 4159 34819 4229 4202560 2963 0 0 0 178 0 0 0 15 0 11 0 878874237 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 0 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9466] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9466/stat : 9466 (java) S 9450 9449 4159 34819 4229 4202560 9 0 0 0 0 0 0 0 18 0 11 0 878874237 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9467] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9467/stat : 9467 (java) S 9450 9449 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 18 0 11 0 878874237 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9468] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9468/stat : 9468 (java) S 9450 9449 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 878874240 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9469] ppid=9450 vsize=877516 CPUtime=1.01
/proc/9463/task/9469/stat : 9469 (java) S 9450 9449 4159 34819 4229 4202560 6907 0 0 0 98 3 0 0 15 0 11 0 878874240 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9470] ppid=9450 vsize=877516 CPUtime=1.73
/proc/9463/task/9470/stat : 9470 (java) S 9450 9449 4159 34819 4229 4202560 6310 0 0 0 173 0 0 0 15 0 11 0 878874240 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9471] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9471/stat : 9471 (java) S 9450 9449 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 11 0 878874240 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9472] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9472/stat : 9472 (java) S 9450 9449 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 15 0 11 0 878874240 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9473] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9473/stat : 9473 (java) S 9450 9449 4159 34819 4229 4202560 5 0 0 0 0 0 0 0 24 0 11 0 878874672 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 281.93
Current children cumulated vsize (KiB) 882660

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

[startup+283.207 s]
/proc/loadavg: 1.00 1.03 1.00 2/53 9473
/proc/meminfo: memFree=720968/1048576 swapFree=2080288/2097144
[pid=9449] ppid=9448 vsize=2572 CPUtime=0
/proc/9449/stat : 9449 (p2cudf-trendy-1) S 9448 9449 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 18 0 1 0 878874231 2633728 273 1283457024 134512640 135304128 4291985248 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9449/statm: 643 273 233 194 0 29 0
[pid=9450] ppid=9449 vsize=2572 CPUtime=0.02
/proc/9450/stat : 9450 (p2cudf) S 9449 9449 4159 34819 4229 4202496 391 2994 0 1 0 0 2 0 25 0 1 0 878874231 2633728 281 1283457024 134512640 135304128 4289920336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9450/statm: 643 281 241 194 0 29 0
[pid=9463] ppid=9450 vsize=877516 CPUtime=282.81
/proc/9463/stat : 9463 (java) S 9450 9449 4159 34819 4229 4202496 30438 0 1 0 28263 18 0 0 25 0 11 0 878874235 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9463/statm: 219379 22928 1780 10 0 216469 0
[pid=9463/tid=9464] ppid=9450 vsize=877516 CPUtime=278.24
/proc/9463/task/9464/stat : 9464 (java) R 9450 9449 4159 34819 4229 4202560 13144 0 1 0 27812 12 0 0 25 0 11 0 878874235 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4096356660 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9463/tid=9465] ppid=9450 vsize=877516 CPUtime=1.78
/proc/9463/task/9465/stat : 9465 (java) S 9450 9449 4159 34819 4229 4202560 2963 0 0 0 178 0 0 0 15 0 11 0 878874237 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 0 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9466] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9466/stat : 9466 (java) S 9450 9449 4159 34819 4229 4202560 9 0 0 0 0 0 0 0 18 0 11 0 878874237 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9467] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9467/stat : 9467 (java) S 9450 9449 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 18 0 11 0 878874237 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9468] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9468/stat : 9468 (java) S 9450 9449 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 878874240 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9469] ppid=9450 vsize=877516 CPUtime=1.01
/proc/9463/task/9469/stat : 9469 (java) S 9450 9449 4159 34819 4229 4202560 6907 0 0 0 98 3 0 0 15 0 11 0 878874240 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9470] ppid=9450 vsize=877516 CPUtime=1.73
/proc/9463/task/9470/stat : 9470 (java) S 9450 9449 4159 34819 4229 4202560 6310 0 0 0 173 0 0 0 15 0 11 0 878874240 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9471] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9471/stat : 9471 (java) S 9450 9449 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 11 0 878874240 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9472] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9472/stat : 9472 (java) S 9450 9449 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 15 0 11 0 878874240 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9473] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9473/stat : 9473 (java) S 9450 9449 4159 34819 4229 4202560 5 0 0 0 0 0 0 0 24 0 11 0 878874672 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 282.83
Current children cumulated vsize (KiB) 882660

[startup+284.007 s]
/proc/loadavg: 1.00 1.03 1.00 2/53 9473
/proc/meminfo: memFree=720968/1048576 swapFree=2080288/2097144
[pid=9449] ppid=9448 vsize=2572 CPUtime=0
/proc/9449/stat : 9449 (p2cudf-trendy-1) S 9448 9449 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 18 0 1 0 878874231 2633728 273 1283457024 134512640 135304128 4291985248 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9449/statm: 643 273 233 194 0 29 0
[pid=9450] ppid=9449 vsize=2572 CPUtime=0.02
/proc/9450/stat : 9450 (p2cudf) S 9449 9449 4159 34819 4229 4202496 391 2994 0 1 0 0 2 0 25 0 1 0 878874231 2633728 281 1283457024 134512640 135304128 4289920336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9450/statm: 643 281 241 194 0 29 0
[pid=9463] ppid=9450 vsize=877516 CPUtime=283.61
/proc/9463/stat : 9463 (java) S 9450 9449 4159 34819 4229 4202496 30438 0 1 0 28343 18 0 0 25 0 11 0 878874235 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9463/statm: 219379 22928 1780 10 0 216469 0
[pid=9463/tid=9464] ppid=9450 vsize=877516 CPUtime=279.04
/proc/9463/task/9464/stat : 9464 (java) R 9450 9449 4159 34819 4229 4202560 13144 0 1 0 27892 12 0 0 25 0 11 0 878874235 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4096205075 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9463/tid=9465] ppid=9450 vsize=877516 CPUtime=1.78
/proc/9463/task/9465/stat : 9465 (java) S 9450 9449 4159 34819 4229 4202560 2963 0 0 0 178 0 0 0 15 0 11 0 878874237 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 0 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9466] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9466/stat : 9466 (java) S 9450 9449 4159 34819 4229 4202560 9 0 0 0 0 0 0 0 18 0 11 0 878874237 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9467] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9467/stat : 9467 (java) S 9450 9449 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 18 0 11 0 878874237 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9468] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9468/stat : 9468 (java) S 9450 9449 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 878874240 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9469] ppid=9450 vsize=877516 CPUtime=1.01
/proc/9463/task/9469/stat : 9469 (java) S 9450 9449 4159 34819 4229 4202560 6907 0 0 0 98 3 0 0 15 0 11 0 878874240 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9470] ppid=9450 vsize=877516 CPUtime=1.73
/proc/9463/task/9470/stat : 9470 (java) S 9450 9449 4159 34819 4229 4202560 6310 0 0 0 173 0 0 0 15 0 11 0 878874240 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9471] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9471/stat : 9471 (java) S 9450 9449 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 11 0 878874240 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9472] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9472/stat : 9472 (java) S 9450 9449 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 15 0 11 0 878874240 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9473] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9473/stat : 9473 (java) S 9450 9449 4159 34819 4229 4202560 5 0 0 0 0 0 0 0 24 0 11 0 878874672 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.63
Current children cumulated vsize (KiB) 882660

[startup+284.407 s]
/proc/loadavg: 1.00 1.03 1.00 2/53 9473
/proc/meminfo: memFree=720968/1048576 swapFree=2080288/2097144
[pid=9449] ppid=9448 vsize=2572 CPUtime=0
/proc/9449/stat : 9449 (p2cudf-trendy-1) S 9448 9449 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 18 0 1 0 878874231 2633728 273 1283457024 134512640 135304128 4291985248 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9449/statm: 643 273 233 194 0 29 0
[pid=9450] ppid=9449 vsize=2572 CPUtime=0.02
/proc/9450/stat : 9450 (p2cudf) S 9449 9449 4159 34819 4229 4202496 391 2994 0 1 0 0 2 0 25 0 1 0 878874231 2633728 281 1283457024 134512640 135304128 4289920336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9450/statm: 643 281 241 194 0 29 0
[pid=9463] ppid=9450 vsize=877516 CPUtime=284.01
/proc/9463/stat : 9463 (java) S 9450 9449 4159 34819 4229 4202496 30438 0 1 0 28383 18 0 0 25 0 11 0 878874235 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9463/statm: 219379 22928 1780 10 0 216469 0
[pid=9463/tid=9464] ppid=9450 vsize=877516 CPUtime=279.44
/proc/9463/task/9464/stat : 9464 (java) R 9450 9449 4159 34819 4229 4202560 13144 0 1 0 27932 12 0 0 25 0 11 0 878874235 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4096168843 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9463/tid=9465] ppid=9450 vsize=877516 CPUtime=1.78
/proc/9463/task/9465/stat : 9465 (java) S 9450 9449 4159 34819 4229 4202560 2963 0 0 0 178 0 0 0 15 0 11 0 878874237 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 0 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9466] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9466/stat : 9466 (java) S 9450 9449 4159 34819 4229 4202560 9 0 0 0 0 0 0 0 18 0 11 0 878874237 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9467] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9467/stat : 9467 (java) S 9450 9449 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 18 0 11 0 878874237 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9468] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9468/stat : 9468 (java) S 9450 9449 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 878874240 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9469] ppid=9450 vsize=877516 CPUtime=1.01
/proc/9463/task/9469/stat : 9469 (java) S 9450 9449 4159 34819 4229 4202560 6907 0 0 0 98 3 0 0 15 0 11 0 878874240 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9470] ppid=9450 vsize=877516 CPUtime=1.73
/proc/9463/task/9470/stat : 9470 (java) S 9450 9449 4159 34819 4229 4202560 6310 0 0 0 173 0 0 0 15 0 11 0 878874240 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9471] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9471/stat : 9471 (java) S 9450 9449 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 11 0 878874240 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9472] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9472/stat : 9472 (java) S 9450 9449 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 15 0 11 0 878874240 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9473] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9473/stat : 9473 (java) S 9450 9449 4159 34819 4229 4202560 5 0 0 0 0 0 0 0 24 0 11 0 878874672 898576384 22928 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 284.03
Current children cumulated vsize (KiB) 882660

[startup+284.807 s]
/proc/loadavg: 1.00 1.03 1.00 2/53 9473
/proc/meminfo: memFree=720968/1048576 swapFree=2080288/2097144
[pid=9449] ppid=9448 vsize=2572 CPUtime=0
/proc/9449/stat : 9449 (p2cudf-trendy-1) S 9448 9449 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 18 0 1 0 878874231 2633728 273 1283457024 134512640 135304128 4291985248 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9449/statm: 643 273 233 194 0 29 0
[pid=9450] ppid=9449 vsize=2572 CPUtime=0.02
/proc/9450/stat : 9450 (p2cudf) S 9449 9449 4159 34819 4229 4202496 391 2994 0 1 0 0 2 0 25 0 1 0 878874231 2633728 281 1283457024 134512640 135304128 4289920336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9450/statm: 643 281 241 194 0 29 0
[pid=9463] ppid=9450 vsize=877516 CPUtime=284.02
/proc/9463/stat : 9463 (java) S 9450 9449 4159 34819 4229 4202496 30439 0 1 0 28384 18 0 0 25 0 11 0 878874235 898576384 22929 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9463/statm: 219379 22929 1780 10 0 216469 0
[pid=9463/tid=9464] ppid=9450 vsize=877516 CPUtime=279.45
/proc/9463/task/9464/stat : 9464 (java) S 9450 9449 4159 34819 4229 4202560 13145 0 1 0 27933 12 0 0 25 0 11 0 878874235 898576384 22929 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9465] ppid=9450 vsize=877516 CPUtime=1.78
/proc/9463/task/9465/stat : 9465 (java) S 9450 9449 4159 34819 4229 4202560 2963 0 0 0 178 0 0 0 15 0 11 0 878874237 898576384 22929 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 0 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9466] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9466/stat : 9466 (java) S 9450 9449 4159 34819 4229 4202560 9 0 0 0 0 0 0 0 18 0 11 0 878874237 898576384 22929 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9467] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9467/stat : 9467 (java) S 9450 9449 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 18 0 11 0 878874237 898576384 22929 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9468] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9468/stat : 9468 (java) S 9450 9449 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 878874240 898576384 22929 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9469] ppid=9450 vsize=877516 CPUtime=1.01
/proc/9463/task/9469/stat : 9469 (java) S 9450 9449 4159 34819 4229 4202560 6907 0 0 0 98 3 0 0 15 0 11 0 878874240 898576384 22929 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9470] ppid=9450 vsize=877516 CPUtime=1.73
/proc/9463/task/9470/stat : 9470 (java) S 9450 9449 4159 34819 4229 4202560 6310 0 0 0 173 0 0 0 15 0 11 0 878874240 898576384 22929 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9471] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9471/stat : 9471 (java) S 9450 9449 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 11 0 878874240 898576384 22929 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9472] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9472/stat : 9472 (java) S 9450 9449 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 15 0 11 0 878874240 898576384 22929 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 284.04
Current children cumulated vsize (KiB) 882660

[startup+284.907 s]
/proc/loadavg: 1.00 1.03 1.00 1/53 9474
/proc/meminfo: memFree=720968/1048576 swapFree=2080288/2097144
[pid=9449] ppid=9448 vsize=2572 CPUtime=0
/proc/9449/stat : 9449 (p2cudf-trendy-1) S 9448 9449 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 18 0 1 0 878874231 2633728 273 1283457024 134512640 135304128 4291985248 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9449/statm: 643 273 233 194 0 29 0
[pid=9450] ppid=9449 vsize=2572 CPUtime=0.02
/proc/9450/stat : 9450 (p2cudf) S 9449 9449 4159 34819 4229 4202496 391 2994 0 1 0 0 2 0 25 0 1 0 878874231 2633728 281 1283457024 134512640 135304128 4289920336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9450/statm: 643 281 241 194 0 29 0
[pid=9463] ppid=9450 vsize=877516 CPUtime=284.02
/proc/9463/stat : 9463 (java) S 9450 9449 4159 34819 4229 4202496 30439 0 1 0 28384 18 0 0 25 0 11 0 878874235 898576384 22929 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9463/statm: 219379 22929 1780 10 0 216469 0
[pid=9463/tid=9464] ppid=9450 vsize=877516 CPUtime=279.45
/proc/9463/task/9464/stat : 9464 (java) S 9450 9449 4159 34819 4229 4202560 13145 0 1 0 27933 12 0 0 25 0 11 0 878874235 898576384 22929 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9465] ppid=9450 vsize=877516 CPUtime=1.78
/proc/9463/task/9465/stat : 9465 (java) S 9450 9449 4159 34819 4229 4202560 2963 0 0 0 178 0 0 0 15 0 11 0 878874237 898576384 22929 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 0 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9466] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9466/stat : 9466 (java) S 9450 9449 4159 34819 4229 4202560 9 0 0 0 0 0 0 0 18 0 11 0 878874237 898576384 22929 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9467] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9467/stat : 9467 (java) S 9450 9449 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 18 0 11 0 878874237 898576384 22929 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9468] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9468/stat : 9468 (java) S 9450 9449 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 878874240 898576384 22929 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9469] ppid=9450 vsize=877516 CPUtime=1.01
/proc/9463/task/9469/stat : 9469 (java) S 9450 9449 4159 34819 4229 4202560 6907 0 0 0 98 3 0 0 15 0 11 0 878874240 898576384 22929 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9470] ppid=9450 vsize=877516 CPUtime=1.73
/proc/9463/task/9470/stat : 9470 (java) S 9450 9449 4159 34819 4229 4202560 6310 0 0 0 173 0 0 0 15 0 11 0 878874240 898576384 22929 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9471] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9471/stat : 9471 (java) S 9450 9449 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 11 0 878874240 898576384 22929 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9472] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9472/stat : 9472 (java) S 9450 9449 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 15 0 11 0 878874240 898576384 22929 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
[pid=9463/tid=9474] ppid=9450 vsize=877516 CPUtime=0
/proc/9463/task/9474/stat : 9474 (java) S 9450 9449 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 11 0 878902673 898576384 22929 1283457024 134512640 134550932 4293052144 18446744073709551615 4294960130 0 4 0 16800975 18446612132844133376 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 284.04
Current children cumulated vsize (KiB) 882660

Child status: 0
Real time (s): 284.991
CPU time (s): 284.058
CPU user time (s): 283.866
CPU system time (s): 0.192012
CPU usage (%): 99.6725
Max. virtual memory (cumulated for all children) (KiB): 885136

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 283.866
system time used= 0.192012
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 34223
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= 5665
involuntary context switches= 8576

runsolver used 0 second user time and 0.024001 second system time

The end