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/201108241238/p2cudf-trendy-1.13/rand83.cudf.dudf-random.log.runsolver ./p2cudf-trendy-1.13 /home/misc2010/data/2011/dudf-random//rand83.cudf /home/misc2010/tmp/201108241238/p2cudf-trendy-1.13/rand83.cudf.dudf-random.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.42 1.18 1.11 6/36 24278
/proc/meminfo: memFree=303300/1048576 swapFree=0/0
[pid=24275] ppid=24274 vsize=2564 CPUtime=0
/proc/24275/stat : 24275 (p2cudf-trendy-1) S 24274 24275 1511 34817 1511 4202496 373 0 0 0 0 0 0 0 18 0 1 0 4718974 2625536 269 1283457024 134512640 135304128 4290198944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24275/statm: 641 269 230 194 0 28 0
[pid=24276] ppid=24275 vsize=2568 CPUtime=0
/proc/24276/stat : 24276 (p2cudf) S 24275 24275 1511 34817 1511 4202496 353 0 0 0 0 0 0 0 18 0 1 0 4718974 2629632 272 1283457024 134512640 135304128 4289340608 18446744073709551615 4294960130 0 0 4 65536 18446744071564457842 0 0 17 0 0 0 0
/proc/24276/statm: 642 272 231 194 0 29 0
[pid=24277] ppid=24276 vsize=2568 CPUtime=0
/proc/24277/stat : 24277 (p2cudf) R 24276 24275 1511 34817 1511 4202560 93 0 0 0 0 0 0 0 25 0 1 0 4718974 2629632 119 1283457024 134512640 135304128 4289340608 18446744073709551615 4294960130 0 65538 0 65538 0 0 0 17 0 0 0 0
/proc/24277/statm: 642 119 77 194 0 29 0
[pid=24278] ppid=24277 vsize=2568 CPUtime=0
/proc/24278/stat : 24278 (p2cudf) R 24277 24275 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 1 0 4718974 2629632 42 1283457024 134512640 135304128 4289340608 18446744073709551615 4294960130 0 65538 0 65538 0 0 0 17 0 0 0 0
/proc/24278/statm: 642 42 0 194 0 29 0

[startup+0.126236 s]
/proc/loadavg: 1.42 1.18 1.11 6/36 24278
/proc/meminfo: memFree=303300/1048576 swapFree=0/0
[pid=24275] ppid=24274 vsize=2564 CPUtime=0
/proc/24275/stat : 24275 (p2cudf-trendy-1) S 24274 24275 1511 34817 1511 4202496 373 0 0 0 0 0 0 0 18 0 1 0 4718974 2625536 269 1283457024 134512640 135304128 4290198944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24275/statm: 641 269 230 194 0 28 0
[pid=24276] ppid=24275 vsize=2572 CPUtime=0.02
/proc/24276/stat : 24276 (p2cudf) S 24275 24275 1511 34817 1511 4202496 393 3013 0 1 0 0 2 0 25 0 1 0 4718974 2633728 281 1283457024 134512640 135304128 4289340608 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24276/statm: 643 281 239 194 0 30 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5136

[startup+0.206241 s]
/proc/loadavg: 1.42 1.18 1.11 6/36 24278
/proc/meminfo: memFree=303300/1048576 swapFree=0/0
[pid=24275] ppid=24274 vsize=2564 CPUtime=0
/proc/24275/stat : 24275 (p2cudf-trendy-1) S 24274 24275 1511 34817 1511 4202496 373 0 0 0 0 0 0 0 18 0 1 0 4718974 2625536 269 1283457024 134512640 135304128 4290198944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24275/statm: 641 269 230 194 0 28 0
[pid=24276] ppid=24275 vsize=2572 CPUtime=0.02
/proc/24276/stat : 24276 (p2cudf) S 24275 24275 1511 34817 1511 4202496 393 3013 0 1 0 0 2 0 25 0 1 0 4718974 2633728 281 1283457024 134512640 135304128 4289340608 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24276/statm: 643 281 239 194 0 30 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5136

[startup+0.306272 s]
/proc/loadavg: 1.42 1.18 1.11 6/36 24278
/proc/meminfo: memFree=303300/1048576 swapFree=0/0
[pid=24275] ppid=24274 vsize=2564 CPUtime=0
/proc/24275/stat : 24275 (p2cudf-trendy-1) S 24274 24275 1511 34817 1511 4202496 373 0 0 0 0 0 0 0 18 0 1 0 4718974 2625536 269 1283457024 134512640 135304128 4290198944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24275/statm: 641 269 230 194 0 28 0
[pid=24276] ppid=24275 vsize=2572 CPUtime=0.02
/proc/24276/stat : 24276 (p2cudf) S 24275 24275 1511 34817 1511 4202496 393 3013 0 1 0 0 2 0 25 0 1 0 4718974 2633728 281 1283457024 134512640 135304128 4289340608 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24276/statm: 643 281 239 194 0 30 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5136

[startup+0.70636 s]
/proc/loadavg: 1.42 1.18 1.11 6/36 24278
/proc/meminfo: memFree=303300/1048576 swapFree=0/0
[pid=24275] ppid=24274 vsize=2564 CPUtime=0
/proc/24275/stat : 24275 (p2cudf-trendy-1) S 24274 24275 1511 34817 1511 4202496 373 0 0 0 0 0 0 0 18 0 1 0 4718974 2625536 269 1283457024 134512640 135304128 4290198944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24275/statm: 641 269 230 194 0 28 0
[pid=24276] ppid=24275 vsize=2572 CPUtime=0.02
/proc/24276/stat : 24276 (p2cudf) S 24275 24275 1511 34817 1511 4202496 393 3013 0 1 0 0 2 0 25 0 1 0 4718974 2633728 281 1283457024 134512640 135304128 4289340608 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24276/statm: 643 281 239 194 0 30 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5136

[startup+1.50657 s]
/proc/loadavg: 1.42 1.18 1.11 4/45 24298
/proc/meminfo: memFree=263512/1048576 swapFree=0/0
[pid=24275] ppid=24274 vsize=2564 CPUtime=0
/proc/24275/stat : 24275 (p2cudf-trendy-1) S 24274 24275 1511 34817 1511 4202496 373 0 0 0 0 0 0 0 18 0 1 0 4718974 2625536 269 1283457024 134512640 135304128 4290198944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24275/statm: 641 269 230 194 0 28 0
[pid=24276] ppid=24275 vsize=2572 CPUtime=0.02
/proc/24276/stat : 24276 (p2cudf) S 24275 24275 1511 34817 1511 4202496 393 3013 0 1 0 0 2 0 25 0 1 0 4718974 2633728 281 1283457024 134512640 135304128 4289340608 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24276/statm: 643 281 239 194 0 30 0
[pid=24289] ppid=24276 vsize=879300 CPUtime=1.47
/proc/24289/stat : 24289 (java) S 24276 24275 1511 34817 1511 4202496 21072 0 1 0 137 10 0 0 25 0 10 0 4718977 900403200 18177 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/24289/statm: 219825 18177 1724 10 0 216916 0
[pid=24289/tid=24290] ppid=24276 vsize=879300 CPUtime=0.77
/proc/24289/task/24290/stat : 24290 (java) R 24276 24275 1511 34817 1511 4202560 11049 0 1 0 73 4 0 0 25 0 10 0 4718978 900403200 18177 1283457024 134512640 134550932 4287572384 18446744073709551615 4095489441 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=24289/tid=24291] ppid=24276 vsize=879300 CPUtime=0
/proc/24289/task/24291/stat : 24291 (java) S 24276 24275 1511 34817 1511 4202560 7 0 0 0 0 0 0 0 17 0 10 0 4718979 900403200 18177 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 0 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24292] ppid=24276 vsize=879300 CPUtime=0
/proc/24289/task/24292/stat : 24292 (java) S 24276 24275 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 25 0 10 0 4718980 900403200 18177 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24293] ppid=24276 vsize=879300 CPUtime=0
/proc/24289/task/24293/stat : 24293 (java) S 24276 24275 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 10 0 4718980 900403200 18177 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24294] ppid=24276 vsize=879300 CPUtime=0
/proc/24289/task/24294/stat : 24294 (java) S 24276 24275 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 4718982 900403200 18177 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24295] ppid=24276 vsize=879300 CPUtime=0.55
/proc/24289/task/24295/stat : 24295 (java) R 24276 24275 1511 34817 1511 4202560 7744 0 0 0 51 4 0 0 22 0 10 0 4718982 900403200 18177 1283457024 134512640 134550932 4287572384 18446744073709551615 4148680213 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=24289/tid=24296] ppid=24276 vsize=879300 CPUtime=0.13
/proc/24289/task/24296/stat : 24296 (java) S 24276 24275 1511 34817 1511 4202560 1197 0 0 0 12 1 0 0 20 0 10 0 4718982 900403200 18177 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24297] ppid=24276 vsize=879300 CPUtime=0
/proc/24289/task/24297/stat : 24297 (java) S 24276 24275 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 4718982 900403200 18177 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24298] ppid=24276 vsize=879300 CPUtime=0
/proc/24289/task/24298/stat : 24298 (java) S 24276 24275 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 10 0 4718982 900403200 18177 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 1.49
Current children cumulated vsize (KiB) 884436

[startup+3.10711 s]
/proc/loadavg: 1.42 1.18 1.11 2/45 24298
/proc/meminfo: memFree=131452/1048576 swapFree=0/0
[pid=24275] ppid=24274 vsize=2564 CPUtime=0
/proc/24275/stat : 24275 (p2cudf-trendy-1) S 24274 24275 1511 34817 1511 4202496 373 0 0 0 0 0 0 0 18 0 1 0 4718974 2625536 269 1283457024 134512640 135304128 4290198944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24275/statm: 641 269 230 194 0 28 0
[pid=24276] ppid=24275 vsize=2572 CPUtime=0.02
/proc/24276/stat : 24276 (p2cudf) S 24275 24275 1511 34817 1511 4202496 393 3013 0 1 0 0 2 0 25 0 1 0 4718974 2633728 281 1283457024 134512640 135304128 4289340608 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24276/statm: 643 281 239 194 0 30 0
[pid=24289] ppid=24276 vsize=879300 CPUtime=3.07
/proc/24289/stat : 24289 (java) S 24276 24275 1511 34817 1511 4202496 71312 0 1 0 274 33 0 0 25 0 10 0 4718977 900403200 68236 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/24289/statm: 219825 68236 1743 10 0 216916 0
[pid=24289/tid=24290] ppid=24276 vsize=879300 CPUtime=1.9
/proc/24289/task/24290/stat : 24290 (java) R 24276 24275 1511 34817 1511 4202560 50091 0 1 0 165 25 0 0 25 0 10 0 4718978 900403200 68236 1283457024 134512640 134550932 4287572384 18446744073709551615 4095193831 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=24289/tid=24291] ppid=24276 vsize=879300 CPUtime=0.23
/proc/24289/task/24291/stat : 24291 (java) S 24276 24275 1511 34817 1511 4202560 10976 0 0 0 21 2 0 0 16 0 10 0 4718979 900403200 68236 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 0 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24292] ppid=24276 vsize=879300 CPUtime=0
/proc/24289/task/24292/stat : 24292 (java) S 24276 24275 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 18 0 10 0 4718980 900403200 68236 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24293] ppid=24276 vsize=879300 CPUtime=0
/proc/24289/task/24293/stat : 24293 (java) S 24276 24275 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 10 0 4718980 900403200 68236 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24294] ppid=24276 vsize=879300 CPUtime=0
/proc/24289/task/24294/stat : 24294 (java) S 24276 24275 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 4718982 900403200 68236 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24295] ppid=24276 vsize=879300 CPUtime=0.79
/proc/24289/task/24295/stat : 24295 (java) S 24276 24275 1511 34817 1511 4202560 7971 0 0 0 75 4 0 0 16 0 10 0 4718982 900403200 68236 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24296] ppid=24276 vsize=879300 CPUtime=0.13
/proc/24289/task/24296/stat : 24296 (java) S 24276 24275 1511 34817 1511 4202560 1197 0 0 0 12 1 0 0 20 0 10 0 4718982 900403200 68236 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24297] ppid=24276 vsize=879300 CPUtime=0
/proc/24289/task/24297/stat : 24297 (java) S 24276 24275 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 4718982 900403200 68236 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24298] ppid=24276 vsize=879300 CPUtime=0
/proc/24289/task/24298/stat : 24298 (java) S 24276 24275 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 10 0 4718982 900403200 68236 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 3.09
Current children cumulated vsize (KiB) 884436

[startup+6.30791 s]
/proc/loadavg: 1.39 1.18 1.11 2/45 24298
/proc/meminfo: memFree=5808/1048576 swapFree=0/0
[pid=24275] ppid=24274 vsize=2564 CPUtime=0
/proc/24275/stat : 24275 (p2cudf-trendy-1) S 24274 24275 1511 34817 1511 4202496 373 0 0 0 0 0 0 0 18 0 1 0 4718974 2625536 269 1283457024 134512640 135304128 4290198944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24275/statm: 641 269 230 194 0 28 0
[pid=24276] ppid=24275 vsize=2572 CPUtime=0.02
/proc/24276/stat : 24276 (p2cudf) S 24275 24275 1511 34817 1511 4202496 393 3013 0 1 0 0 2 0 25 0 1 0 4718974 2633728 281 1283457024 134512640 135304128 4289340608 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24276/statm: 643 281 239 194 0 30 0
[pid=24289] ppid=24276 vsize=879624 CPUtime=6.26
/proc/24289/stat : 24289 (java) S 24276 24275 1511 34817 1511 4202496 85310 0 1 0 589 37 0 0 25 0 11 0 4718977 900734976 82234 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/24289/statm: 219906 82234 1779 10 0 216997 0
[pid=24289/tid=24290] ppid=24276 vsize=879624 CPUtime=3.43
/proc/24289/task/24290/stat : 24290 (java) R 24276 24275 1511 34817 1511 4202560 50271 0 1 0 317 26 0 0 25 0 11 0 4718978 900734976 82234 1283457024 134512640 134550932 4287572384 18446744073709551615 4096183480 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=24289/tid=24291] ppid=24276 vsize=879624 CPUtime=0.53
/proc/24289/task/24291/stat : 24291 (java) S 24276 24275 1511 34817 1511 4202560 24564 0 0 0 49 4 0 0 16 0 11 0 4718979 900734976 82234 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 0 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24292] ppid=24276 vsize=879624 CPUtime=0
/proc/24289/task/24292/stat : 24292 (java) S 24276 24275 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 18 0 11 0 4718980 900734976 82234 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24293] ppid=24276 vsize=879624 CPUtime=0
/proc/24289/task/24293/stat : 24293 (java) S 24276 24275 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 4718980 900734976 82234 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24294] ppid=24276 vsize=879624 CPUtime=0
/proc/24289/task/24294/stat : 24294 (java) S 24276 24275 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 4718982 900734976 82234 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24295] ppid=24276 vsize=879624 CPUtime=2.14
/proc/24289/task/24295/stat : 24295 (java) S 24276 24275 1511 34817 1511 4202560 8197 0 0 0 210 4 0 0 15 0 11 0 4718982 900734976 82234 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24296] ppid=24276 vsize=879624 CPUtime=0.13
/proc/24289/task/24296/stat : 24296 (java) S 24276 24275 1511 34817 1511 4202560 1197 0 0 0 12 1 0 0 20 0 11 0 4718982 900734976 82234 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24297] ppid=24276 vsize=879624 CPUtime=0
/proc/24289/task/24297/stat : 24297 (java) S 24276 24275 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 4718982 900734976 82234 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24298] ppid=24276 vsize=879624 CPUtime=0
/proc/24289/task/24298/stat : 24298 (java) S 24276 24275 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 4718982 900734976 82234 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 6.28
Current children cumulated vsize (KiB) 884760

[startup+12.7096 s]
/proc/loadavg: 1.36 1.17 1.11 3/46 24299
/proc/meminfo: memFree=9280/1048576 swapFree=0/0
[pid=24275] ppid=24274 vsize=2564 CPUtime=0
/proc/24275/stat : 24275 (p2cudf-trendy-1) S 24274 24275 1511 34817 1511 4202496 373 0 0 0 0 0 0 0 18 0 1 0 4718974 2625536 269 1283457024 134512640 135304128 4290198944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24275/statm: 641 269 230 194 0 28 0
[pid=24276] ppid=24275 vsize=2572 CPUtime=0.02
/proc/24276/stat : 24276 (p2cudf) S 24275 24275 1511 34817 1511 4202496 393 3013 0 1 0 0 2 0 25 0 1 0 4718974 2633728 281 1283457024 134512640 135304128 4289340608 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24276/statm: 643 281 239 194 0 30 0
[pid=24289] ppid=24276 vsize=875232 CPUtime=12.65
/proc/24289/stat : 24289 (java) S 24276 24275 1511 34817 1511 4202496 85356 0 1 0 1228 37 0 0 25 0 11 0 4718977 896237568 81199 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/24289/statm: 218808 81199 1782 10 0 215899 0
[pid=24289/tid=24290] ppid=24276 vsize=875232 CPUtime=9.44
/proc/24289/task/24290/stat : 24290 (java) R 24276 24275 1511 34817 1511 4202560 50279 0 1 0 918 26 0 0 25 0 11 0 4718978 896237568 81199 1283457024 134512640 134550932 4287572384 18446744073709551615 4096144394 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=24289/tid=24291] ppid=24276 vsize=875232 CPUtime=0.53
/proc/24289/task/24291/stat : 24291 (java) S 24276 24275 1511 34817 1511 4202560 24564 0 0 0 49 4 0 0 15 0 11 0 4718979 896237568 81199 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 0 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24292] ppid=24276 vsize=875232 CPUtime=0
/proc/24289/task/24292/stat : 24292 (java) S 24276 24275 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 18 0 11 0 4718980 896237568 81199 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24293] ppid=24276 vsize=875232 CPUtime=0
/proc/24289/task/24293/stat : 24293 (java) S 24276 24275 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 4718980 896237568 81199 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24294] ppid=24276 vsize=875232 CPUtime=0
/proc/24289/task/24294/stat : 24294 (java) S 24276 24275 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 4718982 896237568 81199 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24295] ppid=24276 vsize=875232 CPUtime=2.52
/proc/24289/task/24295/stat : 24295 (java) S 24276 24275 1511 34817 1511 4202560 8235 0 0 0 248 4 0 0 15 0 11 0 4718982 896237568 81199 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24296] ppid=24276 vsize=875232 CPUtime=0.13
/proc/24289/task/24296/stat : 24296 (java) S 24276 24275 1511 34817 1511 4202560 1197 0 0 0 12 1 0 0 20 0 11 0 4718982 896237568 81199 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24297] ppid=24276 vsize=875232 CPUtime=0
/proc/24289/task/24297/stat : 24297 (java) S 24276 24275 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 4718982 896237568 81199 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24298] ppid=24276 vsize=875232 CPUtime=0
/proc/24289/task/24298/stat : 24298 (java) S 24276 24275 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 4718982 896237568 81199 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24299] ppid=24276 vsize=875232 CPUtime=0
/proc/24289/task/24299/stat : 24299 (java) S 24276 24275 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 4719515 896237568 81199 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 12.67
Current children cumulated vsize (KiB) 880368

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

[startup+15.8102 s]
/proc/loadavg: 1.33 1.17 1.11 3/46 24299
/proc/meminfo: memFree=9280/1048576 swapFree=0/0
[pid=24275] ppid=24274 vsize=2564 CPUtime=0
/proc/24275/stat : 24275 (p2cudf-trendy-1) S 24274 24275 1511 34817 1511 4202496 373 0 0 0 0 0 0 0 18 0 1 0 4718974 2625536 269 1283457024 134512640 135304128 4290198944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24275/statm: 641 269 230 194 0 28 0
[pid=24276] ppid=24275 vsize=2572 CPUtime=0.02
/proc/24276/stat : 24276 (p2cudf) S 24275 24275 1511 34817 1511 4202496 393 3013 0 1 0 0 2 0 25 0 1 0 4718974 2633728 281 1283457024 134512640 135304128 4289340608 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24276/statm: 643 281 239 194 0 30 0
[pid=24289] ppid=24276 vsize=875232 CPUtime=15.74
/proc/24289/stat : 24289 (java) S 24276 24275 1511 34817 1511 4202496 85369 0 1 0 1537 37 0 0 25 0 11 0 4718977 896237568 81212 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/24289/statm: 218808 81212 1784 10 0 215899 0
[pid=24289/tid=24290] ppid=24276 vsize=875232 CPUtime=12.41
/proc/24289/task/24290/stat : 24290 (java) R 24276 24275 1511 34817 1511 4202560 50280 0 1 0 1215 26 0 0 25 0 11 0 4718978 896237568 81212 1283457024 134512640 134550932 4287572384 18446744073709551615 4096137733 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=24289/tid=24291] ppid=24276 vsize=875232 CPUtime=0.53
/proc/24289/task/24291/stat : 24291 (java) S 24276 24275 1511 34817 1511 4202560 24564 0 0 0 49 4 0 0 15 0 11 0 4718979 896237568 81212 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 0 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24292] ppid=24276 vsize=875232 CPUtime=0
/proc/24289/task/24292/stat : 24292 (java) S 24276 24275 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 18 0 11 0 4718980 896237568 81212 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24293] ppid=24276 vsize=875232 CPUtime=0
/proc/24289/task/24293/stat : 24293 (java) S 24276 24275 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 4718980 896237568 81212 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24294] ppid=24276 vsize=875232 CPUtime=0
/proc/24289/task/24294/stat : 24294 (java) S 24276 24275 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 4718982 896237568 81212 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24295] ppid=24276 vsize=875232 CPUtime=2.64
/proc/24289/task/24295/stat : 24295 (java) S 24276 24275 1511 34817 1511 4202560 8247 0 0 0 260 4 0 0 15 0 11 0 4718982 896237568 81212 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24296] ppid=24276 vsize=875232 CPUtime=0.13
/proc/24289/task/24296/stat : 24296 (java) S 24276 24275 1511 34817 1511 4202560 1197 0 0 0 12 1 0 0 20 0 11 0 4718982 896237568 81212 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24297] ppid=24276 vsize=875232 CPUtime=0
/proc/24289/task/24297/stat : 24297 (java) S 24276 24275 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 4718982 896237568 81212 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24298] ppid=24276 vsize=875232 CPUtime=0
/proc/24289/task/24298/stat : 24298 (java) R 24276 24275 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 4718982 896237568 81212 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=24289/tid=24299] ppid=24276 vsize=875232 CPUtime=0
/proc/24289/task/24299/stat : 24299 (java) S 24276 24275 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 4719515 896237568 81212 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 15.76
Current children cumulated vsize (KiB) 880368

[startup+19.0113 s]
/proc/loadavg: 1.30 1.17 1.11 3/46 24299
/proc/meminfo: memFree=9280/1048576 swapFree=0/0
[pid=24275] ppid=24274 vsize=2564 CPUtime=0
/proc/24275/stat : 24275 (p2cudf-trendy-1) S 24274 24275 1511 34817 1511 4202496 373 0 0 0 0 0 0 0 18 0 1 0 4718974 2625536 269 1283457024 134512640 135304128 4290198944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24275/statm: 641 269 230 194 0 28 0
[pid=24276] ppid=24275 vsize=2572 CPUtime=0.02
/proc/24276/stat : 24276 (p2cudf) S 24275 24275 1511 34817 1511 4202496 393 3013 0 1 0 0 2 0 25 0 1 0 4718974 2633728 281 1283457024 134512640 135304128 4289340608 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24276/statm: 643 281 239 194 0 30 0
[pid=24289] ppid=24276 vsize=875232 CPUtime=18.94
/proc/24289/stat : 24289 (java) S 24276 24275 1511 34817 1511 4202496 85371 0 1 0 1857 37 0 0 25 0 11 0 4718977 896237568 81214 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/24289/statm: 218808 81214 1784 10 0 215899 0
[pid=24289/tid=24290] ppid=24276 vsize=875232 CPUtime=15.59
/proc/24289/task/24290/stat : 24290 (java) R 24276 24275 1511 34817 1511 4202560 50280 0 1 0 1533 26 0 0 25 0 11 0 4718978 896237568 81214 1283457024 134512640 134550932 4287572384 18446744073709551615 4096141064 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=24289/tid=24291] ppid=24276 vsize=875232 CPUtime=0.53
/proc/24289/task/24291/stat : 24291 (java) S 24276 24275 1511 34817 1511 4202560 24564 0 0 0 49 4 0 0 15 0 11 0 4718979 896237568 81214 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 0 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24292] ppid=24276 vsize=875232 CPUtime=0
/proc/24289/task/24292/stat : 24292 (java) S 24276 24275 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 18 0 11 0 4718980 896237568 81214 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24293] ppid=24276 vsize=875232 CPUtime=0
/proc/24289/task/24293/stat : 24293 (java) S 24276 24275 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 4718980 896237568 81214 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24294] ppid=24276 vsize=875232 CPUtime=0
/proc/24289/task/24294/stat : 24294 (java) S 24276 24275 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 4718982 896237568 81214 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24295] ppid=24276 vsize=875232 CPUtime=2.66
/proc/24289/task/24295/stat : 24295 (java) S 24276 24275 1511 34817 1511 4202560 8249 0 0 0 262 4 0 0 15 0 11 0 4718982 896237568 81214 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24296] ppid=24276 vsize=875232 CPUtime=0.13
/proc/24289/task/24296/stat : 24296 (java) S 24276 24275 1511 34817 1511 4202560 1197 0 0 0 12 1 0 0 20 0 11 0 4718982 896237568 81214 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24297] ppid=24276 vsize=875232 CPUtime=0
/proc/24289/task/24297/stat : 24297 (java) S 24276 24275 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 4718982 896237568 81214 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24298] ppid=24276 vsize=875232 CPUtime=0
/proc/24289/task/24298/stat : 24298 (java) S 24276 24275 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 4718982 896237568 81214 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24299] ppid=24276 vsize=875232 CPUtime=0
/proc/24289/task/24299/stat : 24299 (java) S 24276 24275 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 4719515 896237568 81214 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 18.96
Current children cumulated vsize (KiB) 880368

[startup+20.6117 s]
/proc/loadavg: 1.30 1.17 1.11 4/46 24299
/proc/meminfo: memFree=9280/1048576 swapFree=0/0
[pid=24275] ppid=24274 vsize=2564 CPUtime=0
/proc/24275/stat : 24275 (p2cudf-trendy-1) S 24274 24275 1511 34817 1511 4202496 373 0 0 0 0 0 0 0 18 0 1 0 4718974 2625536 269 1283457024 134512640 135304128 4290198944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24275/statm: 641 269 230 194 0 28 0
[pid=24276] ppid=24275 vsize=2572 CPUtime=0.02
/proc/24276/stat : 24276 (p2cudf) S 24275 24275 1511 34817 1511 4202496 393 3013 0 1 0 0 2 0 25 0 1 0 4718974 2633728 281 1283457024 134512640 135304128 4289340608 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24276/statm: 643 281 239 194 0 30 0
[pid=24289] ppid=24276 vsize=875232 CPUtime=20.52
/proc/24289/stat : 24289 (java) S 24276 24275 1511 34817 1511 4202496 94605 0 1 0 2012 40 0 0 25 0 11 0 4718977 896237568 90448 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/24289/statm: 218808 90448 1788 10 0 215899 0
[pid=24289/tid=24290] ppid=24276 vsize=875232 CPUtime=16.34
/proc/24289/task/24290/stat : 24290 (java) R 24276 24275 1511 34817 1511 4202560 50281 0 1 0 1608 26 0 0 25 0 11 0 4718978 896237568 90448 1283457024 134512640 134550932 4287572384 18446744073709551615 4096137652 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=24289/tid=24291] ppid=24276 vsize=875232 CPUtime=0.98
/proc/24289/task/24291/stat : 24291 (java) S 24276 24275 1511 34817 1511 4202560 33751 0 0 0 91 7 0 0 16 0 11 0 4718979 896237568 90448 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 0 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24292] ppid=24276 vsize=875232 CPUtime=0
/proc/24289/task/24292/stat : 24292 (java) S 24276 24275 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 18 0 11 0 4718980 896237568 90448 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24293] ppid=24276 vsize=875232 CPUtime=0
/proc/24289/task/24293/stat : 24293 (java) S 24276 24275 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 4718980 896237568 90448 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24294] ppid=24276 vsize=875232 CPUtime=0
/proc/24289/task/24294/stat : 24294 (java) S 24276 24275 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 4718982 896237568 90448 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24295] ppid=24276 vsize=875232 CPUtime=3.04
/proc/24289/task/24295/stat : 24295 (java) S 24276 24275 1511 34817 1511 4202560 8295 0 0 0 300 4 0 0 16 0 11 0 4718982 896237568 90448 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24296] ppid=24276 vsize=875232 CPUtime=0.13
/proc/24289/task/24296/stat : 24296 (java) S 24276 24275 1511 34817 1511 4202560 1197 0 0 0 12 1 0 0 20 0 11 0 4718982 896237568 90448 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24297] ppid=24276 vsize=875232 CPUtime=0
/proc/24289/task/24297/stat : 24297 (java) S 24276 24275 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 4718982 896237568 90448 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24298] ppid=24276 vsize=875232 CPUtime=0
/proc/24289/task/24298/stat : 24298 (java) S 24276 24275 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 4718982 896237568 90448 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24299] ppid=24276 vsize=875232 CPUtime=0
/proc/24289/task/24299/stat : 24299 (java) S 24276 24275 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 4719515 896237568 90448 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 20.54
Current children cumulated vsize (KiB) 880368

[startup+21.4062 s]
/proc/loadavg: 1.30 1.17 1.11 2/46 24299
/proc/meminfo: memFree=5700/1048576 swapFree=0/0
[pid=24275] ppid=24274 vsize=2564 CPUtime=0
/proc/24275/stat : 24275 (p2cudf-trendy-1) S 24274 24275 1511 34817 1511 4202496 373 0 0 0 0 0 0 0 18 0 1 0 4718974 2625536 269 1283457024 134512640 135304128 4290198944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24275/statm: 641 269 230 194 0 28 0
[pid=24276] ppid=24275 vsize=2572 CPUtime=0.02
/proc/24276/stat : 24276 (p2cudf) S 24275 24275 1511 34817 1511 4202496 393 3013 0 1 0 0 2 0 25 0 1 0 4718974 2633728 281 1283457024 134512640 135304128 4289340608 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24276/statm: 643 281 239 194 0 30 0
[pid=24289] ppid=24276 vsize=875556 CPUtime=20.83
/proc/24289/stat : 24289 (java) S 24276 24275 1511 34817 1511 4202496 94618 0 1 0 2043 40 0 0 25 0 11 0 4718977 896569344 90461 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/24289/statm: 218889 90461 1789 10 0 215980 0
[pid=24289/tid=24290] ppid=24276 vsize=875556 CPUtime=16.6
/proc/24289/task/24290/stat : 24290 (java) S 24276 24275 1511 34817 1511 4202560 50289 0 1 0 1634 26 0 0 25 0 11 0 4718978 896569344 90461 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24291] ppid=24276 vsize=875556 CPUtime=0.98
/proc/24289/task/24291/stat : 24291 (java) S 24276 24275 1511 34817 1511 4202560 33751 0 0 0 91 7 0 0 16 0 11 0 4718979 896569344 90461 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 0 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24292] ppid=24276 vsize=875556 CPUtime=0
/proc/24289/task/24292/stat : 24292 (java) S 24276 24275 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 18 0 11 0 4718980 896569344 90461 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24293] ppid=24276 vsize=875556 CPUtime=0
/proc/24289/task/24293/stat : 24293 (java) S 24276 24275 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 4718980 896569344 90461 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24294] ppid=24276 vsize=875556 CPUtime=0
/proc/24289/task/24294/stat : 24294 (java) S 24276 24275 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 4718982 896569344 90461 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24295] ppid=24276 vsize=875556 CPUtime=3.08
/proc/24289/task/24295/stat : 24295 (java) S 24276 24275 1511 34817 1511 4202560 8295 0 0 0 304 4 0 0 16 0 11 0 4718982 896569344 90461 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24296] ppid=24276 vsize=875556 CPUtime=0.13
/proc/24289/task/24296/stat : 24296 (java) S 24276 24275 1511 34817 1511 4202560 1197 0 0 0 12 1 0 0 20 0 11 0 4718982 896569344 90461 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24297] ppid=24276 vsize=875556 CPUtime=0
/proc/24289/task/24297/stat : 24297 (java) S 24276 24275 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 4718982 896569344 90461 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24298] ppid=24276 vsize=875556 CPUtime=0
/proc/24289/task/24298/stat : 24298 (java) S 24276 24275 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 4718982 896569344 90461 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 20.85
Current children cumulated vsize (KiB) 880692

[startup+21.6103 s]
/proc/loadavg: 1.30 1.17 1.11 2/46 24299
/proc/meminfo: memFree=5700/1048576 swapFree=0/0
[pid=24275] ppid=24274 vsize=2564 CPUtime=0
/proc/24275/stat : 24275 (p2cudf-trendy-1) S 24274 24275 1511 34817 1511 4202496 373 0 0 0 0 0 0 0 18 0 1 0 4718974 2625536 269 1283457024 134512640 135304128 4290198944 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24275/statm: 641 269 230 194 0 28 0
[pid=24276] ppid=24275 vsize=2572 CPUtime=0.02
/proc/24276/stat : 24276 (p2cudf) S 24275 24275 1511 34817 1511 4202496 393 3013 0 1 0 0 2 0 25 0 1 0 4718974 2633728 281 1283457024 134512640 135304128 4289340608 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24276/statm: 643 281 239 194 0 30 0
[pid=24289] ppid=24276 vsize=875556 CPUtime=21.01
/proc/24289/stat : 24289 (java) S 24276 24275 1511 34817 1511 4202496 94619 0 1 0 2058 43 0 0 25 0 11 0 4718977 896569344 90462 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/24289/statm: 218889 90462 1789 10 0 215980 0
[pid=24289/tid=24290] ppid=24276 vsize=875556 CPUtime=16.6
/proc/24289/task/24290/stat : 24290 (java) S 24276 24275 1511 34817 1511 4202560 50289 0 1 0 1634 26 0 0 25 0 11 0 4718978 896569344 90462 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24291] ppid=24276 vsize=875556 CPUtime=0.98
/proc/24289/task/24291/stat : 24291 (java) S 24276 24275 1511 34817 1511 4202560 33751 0 0 0 91 7 0 0 16 0 11 0 4718979 896569344 90462 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 0 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24292] ppid=24276 vsize=875556 CPUtime=0
/proc/24289/task/24292/stat : 24292 (java) S 24276 24275 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 18 0 11 0 4718980 896569344 90462 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24293] ppid=24276 vsize=875556 CPUtime=0
/proc/24289/task/24293/stat : 24293 (java) S 24276 24275 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 4718980 896569344 90462 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24294] ppid=24276 vsize=875556 CPUtime=0
/proc/24289/task/24294/stat : 24294 (java) S 24276 24275 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 4718982 896569344 90462 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24295] ppid=24276 vsize=875556 CPUtime=3.15
/proc/24289/task/24295/stat : 24295 (java) S 24276 24275 1511 34817 1511 4202560 8295 0 0 0 311 4 0 0 15 0 11 0 4718982 896569344 90462 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24296] ppid=24276 vsize=875556 CPUtime=0.13
/proc/24289/task/24296/stat : 24296 (java) S 24276 24275 1511 34817 1511 4202560 1197 0 0 0 12 1 0 0 20 0 11 0 4718982 896569344 90462 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24297] ppid=24276 vsize=875556 CPUtime=0
/proc/24289/task/24297/stat : 24297 (java) S 24276 24275 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 4718982 896569344 90462 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
[pid=24289/tid=24298] ppid=24276 vsize=875556 CPUtime=0
/proc/24289/task/24298/stat : 24298 (java) S 24276 24275 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 4718982 896569344 90462 1283457024 134512640 134550932 4287572384 18446744073709551615 4294960130 0 4 0 16800975 18446612132974983872 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 21.03
Current children cumulated vsize (KiB) 880692

Child status: 0
Real time (s): 21.6522
CPU time (s): 21.0653
CPU user time (s): 20.6093
CPU system time (s): 0.456028
CPU usage (%): 97.2895
Max. virtual memory (cumulated for all children) (KiB): 884760

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 20.6093
system time used= 0.456028
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 98418
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= 1322
involuntary context switches= 1478

runsolver used 0 second user time and 0 second system time

The end