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/56ae4afa-0b33-11df-8a2b-00163e1d94dc.cudf.debian-dudf.log.runsolver ./p2cudf-trendy-1.9 /home/misc2010/data/2010/debian-dudf//56ae4afa-0b33-11df-8a2b-00163e1d94dc.cudf /home/misc2010/tmp/201012070034/p2cudf-trendy-1.9/56ae4afa-0b33-11df-8a2b-00163e1d94dc.cudf.debian-dudf.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.18 1.08 1.05 5/50 24281
/proc/meminfo: memFree=558496/1048576 swapFree=2075140/2097144
[pid=24277] ppid=24276 vsize=2568 CPUtime=0
/proc/24277/stat : 24277 (p2cudf-trendy-1) S 24276 24277 4159 34819 4229 4202496 375 0 0 0 0 0 0 0 25 0 1 0 882357850 2629632 272 1283457024 134512640 135304128 4292230992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24277/statm: 642 272 233 194 0 28 0
[pid=24278] ppid=24277 vsize=2572 CPUtime=0
/proc/24278/stat : 24278 (p2cudf) S 24277 24277 4159 34819 4229 4202496 355 0 0 0 0 0 0 0 25 0 1 0 882357850 2633728 274 1283457024 134512640 135304128 4288781312 18446744073709551615 4294960130 0 0 4 65536 18446744071564457842 0 0 17 0 0 0 0
/proc/24278/statm: 643 274 234 194 0 29 0
[pid=24279] ppid=24278 vsize=2572 CPUtime=0
/proc/24279/stat : 24279 (p2cudf) R 24278 24277 4159 34819 4229 4202560 115 0 0 0 0 0 0 0 25 0 1 0 882357850 2633728 123 1283457024 134512640 135304128 4288781312 18446744073709551615 4294960130 0 65538 0 65538 0 0 0 17 0 0 0 0
/proc/24279/statm: 643 123 82 194 0 29 0
[pid=24280] ppid=24279 vsize=188 CPUtime=0.01
/proc/24280/stat : 24280 (java) R 24279 24277 4159 34819 4229 4194304 299 0 0 0 0 1 0 0 25 0 1 0 882357850 192512 33 1283457024 134512640 134550932 4292104016 18446744073709551615 4159798500 0 0 0 0 0 0 0 17 0 0 0 0
/proc/24280/statm: 47 33 24 10 0 7 0
[pid=24281] ppid=24279 vsize=2572 CPUtime=0
/proc/24281/stat : 24281 (p2cudf) R 24279 24277 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 1 0 882357850 2633728 41 1283457024 134512640 135304128 4288781312 18446744073709551615 4294960130 0 65538 0 65538 0 0 0 17 0 0 0 0
/proc/24281/statm: 643 41 0 194 0 29 0

[startup+0.169114 s]
/proc/loadavg: 1.18 1.08 1.05 5/50 24281
/proc/meminfo: memFree=558496/1048576 swapFree=2075140/2097144
[pid=24277] ppid=24276 vsize=2568 CPUtime=0
/proc/24277/stat : 24277 (p2cudf-trendy-1) S 24276 24277 4159 34819 4229 4202496 375 0 0 0 0 0 0 0 25 0 1 0 882357850 2629632 272 1283457024 134512640 135304128 4292230992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24277/statm: 642 272 233 194 0 28 0
[pid=24278] ppid=24277 vsize=2576 CPUtime=0.04
/proc/24278/stat : 24278 (p2cudf) S 24277 24277 4159 34819 4229 4202496 393 3000 0 1 0 0 2 2 25 0 1 0 882357850 2637824 282 1283457024 134512640 135304128 4288781312 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24278/statm: 644 282 241 194 0 30 0
Current children cumulated CPU time (s) 0.04
Current children cumulated vsize (KiB) 5144

[startup+0.20912 s]
/proc/loadavg: 1.18 1.08 1.05 5/50 24281
/proc/meminfo: memFree=558496/1048576 swapFree=2075140/2097144
[pid=24277] ppid=24276 vsize=2568 CPUtime=0
/proc/24277/stat : 24277 (p2cudf-trendy-1) S 24276 24277 4159 34819 4229 4202496 375 0 0 0 0 0 0 0 25 0 1 0 882357850 2629632 272 1283457024 134512640 135304128 4292230992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24277/statm: 642 272 233 194 0 28 0
[pid=24278] ppid=24277 vsize=2576 CPUtime=0.04
/proc/24278/stat : 24278 (p2cudf) S 24277 24277 4159 34819 4229 4202496 393 3000 0 1 0 0 2 2 25 0 1 0 882357850 2637824 282 1283457024 134512640 135304128 4288781312 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24278/statm: 644 282 241 194 0 30 0
Current children cumulated CPU time (s) 0.04
Current children cumulated vsize (KiB) 5144

[startup+0.309164 s]
/proc/loadavg: 1.18 1.08 1.05 5/50 24281
/proc/meminfo: memFree=558496/1048576 swapFree=2075140/2097144
[pid=24277] ppid=24276 vsize=2568 CPUtime=0
/proc/24277/stat : 24277 (p2cudf-trendy-1) S 24276 24277 4159 34819 4229 4202496 375 0 0 0 0 0 0 0 25 0 1 0 882357850 2629632 272 1283457024 134512640 135304128 4292230992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24277/statm: 642 272 233 194 0 28 0
[pid=24278] ppid=24277 vsize=2576 CPUtime=0.04
/proc/24278/stat : 24278 (p2cudf) S 24277 24277 4159 34819 4229 4202496 393 3000 0 1 0 0 2 2 25 0 1 0 882357850 2637824 282 1283457024 134512640 135304128 4288781312 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24278/statm: 644 282 241 194 0 30 0
Current children cumulated CPU time (s) 0.04
Current children cumulated vsize (KiB) 5144

[startup+0.7093 s]
/proc/loadavg: 1.18 1.08 1.05 5/50 24281
/proc/meminfo: memFree=558496/1048576 swapFree=2075140/2097144
[pid=24277] ppid=24276 vsize=2568 CPUtime=0
/proc/24277/stat : 24277 (p2cudf-trendy-1) S 24276 24277 4159 34819 4229 4202496 375 0 0 0 0 0 0 0 25 0 1 0 882357850 2629632 272 1283457024 134512640 135304128 4292230992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24277/statm: 642 272 233 194 0 28 0
[pid=24278] ppid=24277 vsize=2576 CPUtime=0.04
/proc/24278/stat : 24278 (p2cudf) S 24277 24277 4159 34819 4229 4202496 393 3000 0 1 0 0 2 2 25 0 1 0 882357850 2637824 282 1283457024 134512640 135304128 4288781312 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24278/statm: 644 282 241 194 0 30 0
Current children cumulated CPU time (s) 0.04
Current children cumulated vsize (KiB) 5144

[startup+1.50951 s]
/proc/loadavg: 1.18 1.08 1.05 5/58 24300
/proc/meminfo: memFree=517456/1048576 swapFree=2075140/2097144
[pid=24277] ppid=24276 vsize=2568 CPUtime=0
/proc/24277/stat : 24277 (p2cudf-trendy-1) S 24276 24277 4159 34819 4229 4202496 375 0 0 0 0 0 0 0 25 0 1 0 882357850 2629632 272 1283457024 134512640 135304128 4292230992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24277/statm: 642 272 233 194 0 28 0
[pid=24278] ppid=24277 vsize=2576 CPUtime=0.04
/proc/24278/stat : 24278 (p2cudf) S 24277 24277 4159 34819 4229 4202496 393 3000 0 1 0 0 2 2 25 0 1 0 882357850 2637824 282 1283457024 134512640 135304128 4288781312 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24278/statm: 644 282 241 194 0 30 0
[pid=24291] ppid=24278 vsize=876832 CPUtime=1.41
/proc/24291/stat : 24291 (java) S 24278 24277 4159 34819 4229 4202496 18754 0 1 0 134 7 0 0 25 0 10 0 882357859 897875968 15867 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/24291/statm: 219208 15867 1729 10 0 216298 0
[pid=24291/tid=24292] ppid=24278 vsize=876832 CPUtime=0.8
/proc/24291/task/24292/stat : 24292 (java) R 24278 24277 4159 34819 4229 4202560 9788 0 1 0 75 5 0 0 25 0 10 0 882357860 897875968 15867 1283457024 134512640 134550932 4294193088 18446744073709551615 4095200739 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=24291/tid=24293] ppid=24278 vsize=876832 CPUtime=0
/proc/24291/task/24293/stat : 24293 (java) S 24278 24277 4159 34819 4229 4202560 5 0 0 0 0 0 0 0 18 0 10 0 882357861 897875968 15867 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24294] ppid=24278 vsize=876832 CPUtime=0
/proc/24291/task/24294/stat : 24294 (java) S 24278 24277 4159 34819 4229 4202560 9 0 0 0 0 0 0 0 25 0 10 0 882357862 897875968 15867 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24295] ppid=24278 vsize=876832 CPUtime=0
/proc/24291/task/24295/stat : 24295 (java) S 24278 24277 4159 34819 4229 4202560 4 0 0 0 0 0 0 0 25 0 10 0 882357862 897875968 15867 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24296] ppid=24278 vsize=876832 CPUtime=0
/proc/24291/task/24296/stat : 24296 (java) S 24278 24277 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 10 0 882357864 897875968 15867 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24297] ppid=24278 vsize=876832 CPUtime=0.47
/proc/24291/task/24297/stat : 24297 (java) R 24278 24277 4159 34819 4229 4202560 6473 0 0 0 46 1 0 0 25 0 10 0 882357864 897875968 15867 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=24291/tid=24298] ppid=24278 vsize=876832 CPUtime=0.13
/proc/24291/task/24298/stat : 24298 (java) R 24278 24277 4159 34819 4229 4202560 1377 0 0 0 13 0 0 0 21 0 10 0 882357864 897875968 15867 1283457024 134512640 134550932 4294193088 18446744073709551615 4149637303 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=24291/tid=24299] ppid=24278 vsize=876832 CPUtime=0
/proc/24291/task/24299/stat : 24299 (java) S 24278 24277 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 10 0 882357864 897875968 15867 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24300] ppid=24278 vsize=876832 CPUtime=0
/proc/24291/task/24300/stat : 24300 (java) S 24278 24277 4159 34819 4229 4202560 2 0 0 0 0 0 0 0 15 0 10 0 882357864 897875968 15867 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 1.45
Current children cumulated vsize (KiB) 881976

[startup+3.10982 s]
/proc/loadavg: 1.18 1.08 1.05 3/58 24300
/proc/meminfo: memFree=460540/1048576 swapFree=2075140/2097144
[pid=24277] ppid=24276 vsize=2568 CPUtime=0
/proc/24277/stat : 24277 (p2cudf-trendy-1) S 24276 24277 4159 34819 4229 4202496 375 0 0 0 0 0 0 0 25 0 1 0 882357850 2629632 272 1283457024 134512640 135304128 4292230992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24277/statm: 642 272 233 194 0 28 0
[pid=24278] ppid=24277 vsize=2576 CPUtime=0.04
/proc/24278/stat : 24278 (p2cudf) S 24277 24277 4159 34819 4229 4202496 393 3000 0 1 0 0 2 2 25 0 1 0 882357850 2637824 282 1283457024 134512640 135304128 4288781312 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24278/statm: 644 282 241 194 0 30 0
[pid=24291] ppid=24278 vsize=878376 CPUtime=3.01
/proc/24291/stat : 24291 (java) S 24278 24277 4159 34819 4229 4202496 50749 0 1 0 278 23 0 0 25 0 10 0 882357859 899457024 44897 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/24291/statm: 219594 44897 1732 10 0 216684 0
[pid=24291/tid=24292] ppid=24278 vsize=878376 CPUtime=1.58
/proc/24291/task/24292/stat : 24292 (java) R 24278 24277 4159 34819 4229 4202560 37883 0 1 0 142 16 0 0 25 0 10 0 882357860 899457024 44897 1283457024 134512640 134550932 4294193088 18446744073709551615 4095200684 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=24291/tid=24293] ppid=24278 vsize=878376 CPUtime=0
/proc/24291/task/24293/stat : 24293 (java) S 24278 24277 4159 34819 4229 4202560 5 0 0 0 0 0 0 0 18 0 10 0 882357861 899457024 44897 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24294] ppid=24278 vsize=878376 CPUtime=0
/proc/24291/task/24294/stat : 24294 (java) S 24278 24277 4159 34819 4229 4202560 9 0 0 0 0 0 0 0 25 0 10 0 882357862 899457024 44897 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24295] ppid=24278 vsize=878376 CPUtime=0
/proc/24291/task/24295/stat : 24295 (java) S 24278 24277 4159 34819 4229 4202560 4 0 0 0 0 0 0 0 25 0 10 0 882357862 899457024 44897 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24296] ppid=24278 vsize=878376 CPUtime=0
/proc/24291/task/24296/stat : 24296 (java) S 24278 24277 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 10 0 882357864 899457024 44897 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24297] ppid=24278 vsize=878376 CPUtime=0.9
/proc/24291/task/24297/stat : 24297 (java) S 24278 24277 4159 34819 4229 4202560 8754 0 0 0 85 5 0 0 25 0 10 0 882357864 899457024 44897 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24298] ppid=24278 vsize=878376 CPUtime=0.51
/proc/24291/task/24298/stat : 24298 (java) S 24278 24277 4159 34819 4229 4202560 2996 0 0 0 50 1 0 0 15 0 10 0 882357864 899457024 44897 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24299] ppid=24278 vsize=878376 CPUtime=0
/proc/24291/task/24299/stat : 24299 (java) S 24278 24277 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 10 0 882357864 899457024 44897 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24300] ppid=24278 vsize=878376 CPUtime=0
/proc/24291/task/24300/stat : 24300 (java) S 24278 24277 4159 34819 4229 4202560 2 0 0 0 0 0 0 0 15 0 10 0 882357864 899457024 44897 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 3.05
Current children cumulated vsize (KiB) 883520

[startup+6.31084 s]
/proc/loadavg: 1.25 1.09 1.06 3/58 24300
/proc/meminfo: memFree=283096/1048576 swapFree=2075140/2097144
[pid=24277] ppid=24276 vsize=2568 CPUtime=0
/proc/24277/stat : 24277 (p2cudf-trendy-1) S 24276 24277 4159 34819 4229 4202496 375 0 0 0 0 0 0 0 25 0 1 0 882357850 2629632 272 1283457024 134512640 135304128 4292230992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24277/statm: 642 272 233 194 0 28 0
[pid=24278] ppid=24277 vsize=2576 CPUtime=0.04
/proc/24278/stat : 24278 (p2cudf) S 24277 24277 4159 34819 4229 4202496 393 3000 0 1 0 0 2 2 25 0 1 0 882357850 2637824 282 1283457024 134512640 135304128 4288781312 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24278/statm: 644 282 241 194 0 30 0
[pid=24291] ppid=24278 vsize=877732 CPUtime=6.21
/proc/24291/stat : 24291 (java) S 24278 24277 4159 34819 4229 4202496 90900 0 1 0 582 39 0 0 25 0 10 0 882357859 898797568 82873 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/24291/statm: 219433 82873 1766 10 0 216523 0
[pid=24291/tid=24292] ppid=24278 vsize=877732 CPUtime=2.77
/proc/24291/task/24292/stat : 24292 (java) R 24278 24277 4159 34819 4229 4202560 50412 0 1 0 255 22 0 0 25 0 10 0 882357860 898797568 82873 1283457024 134512640 134550932 4294193088 18446744073709551615 4095778790 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=24291/tid=24293] ppid=24278 vsize=877732 CPUtime=0.58
/proc/24291/task/24293/stat : 24293 (java) S 24278 24277 4159 34819 4229 4202560 25488 0 0 0 49 9 0 0 16 0 10 0 882357861 898797568 82873 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24294] ppid=24278 vsize=877732 CPUtime=0
/proc/24291/task/24294/stat : 24294 (java) S 24278 24277 4159 34819 4229 4202560 10 0 0 0 0 0 0 0 18 0 10 0 882357862 898797568 82873 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24295] ppid=24278 vsize=877732 CPUtime=0
/proc/24291/task/24295/stat : 24295 (java) S 24278 24277 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 18 0 10 0 882357862 898797568 82873 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24296] ppid=24278 vsize=877732 CPUtime=0
/proc/24291/task/24296/stat : 24296 (java) S 24278 24277 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 10 0 882357864 898797568 82873 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24297] ppid=24278 vsize=877732 CPUtime=2.32
/proc/24291/task/24297/stat : 24297 (java) S 24278 24277 4159 34819 4229 4202560 10890 0 0 0 226 6 0 0 15 0 10 0 882357864 898797568 82873 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24298] ppid=24278 vsize=877732 CPUtime=0.51
/proc/24291/task/24298/stat : 24298 (java) S 24278 24277 4159 34819 4229 4202560 2996 0 0 0 50 1 0 0 15 0 10 0 882357864 898797568 82873 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24299] ppid=24278 vsize=877732 CPUtime=0
/proc/24291/task/24299/stat : 24299 (java) S 24278 24277 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 10 0 882357864 898797568 82873 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24300] ppid=24278 vsize=877732 CPUtime=0
/proc/24291/task/24300/stat : 24300 (java) S 24278 24277 4159 34819 4229 4202560 2 0 0 0 0 0 0 0 15 0 10 0 882357864 898797568 82873 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 6.25
Current children cumulated vsize (KiB) 882876

[startup+12.7132 s]
/proc/loadavg: 1.47 1.14 1.07 3/59 24303
/proc/meminfo: memFree=206208/1048576 swapFree=2075140/2097144
[pid=24277] ppid=24276 vsize=2568 CPUtime=0
/proc/24277/stat : 24277 (p2cudf-trendy-1) S 24276 24277 4159 34819 4229 4202496 375 0 0 0 0 0 0 0 25 0 1 0 882357850 2629632 272 1283457024 134512640 135304128 4292230992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24277/statm: 642 272 233 194 0 28 0
[pid=24278] ppid=24277 vsize=2576 CPUtime=0.04
/proc/24278/stat : 24278 (p2cudf) S 24277 24277 4159 34819 4229 4202496 393 3000 0 1 0 0 2 2 25 0 1 0 882357850 2637824 282 1283457024 134512640 135304128 4288781312 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24278/statm: 644 282 241 194 0 30 0
[pid=24291] ppid=24278 vsize=878056 CPUtime=12.61
/proc/24291/stat : 24291 (java) S 24278 24277 4159 34819 4229 4202496 97824 0 1 0 1219 42 0 0 25 0 11 0 882357859 899129344 89797 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/24291/statm: 219514 89797 1792 10 0 216604 0
[pid=24291/tid=24292] ppid=24278 vsize=878056 CPUtime=7.8
/proc/24291/task/24292/stat : 24292 (java) R 24278 24277 4159 34819 4229 4202560 50473 0 1 0 758 22 0 0 25 0 11 0 882357860 899129344 89797 1283457024 134512640 134550932 4294193088 18446744073709551615 4096243801 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=24291/tid=24293] ppid=24278 vsize=878056 CPUtime=0.84
/proc/24291/task/24293/stat : 24293 (java) S 24278 24277 4159 34819 4229 4202560 32201 0 0 0 74 10 0 0 16 0 11 0 882357861 899129344 89797 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24294] ppid=24278 vsize=878056 CPUtime=0
/proc/24291/task/24294/stat : 24294 (java) S 24278 24277 4159 34819 4229 4202560 10 0 0 0 0 0 0 0 18 0 11 0 882357862 899129344 89797 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24295] ppid=24278 vsize=878056 CPUtime=0
/proc/24291/task/24295/stat : 24295 (java) S 24278 24277 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 18 0 11 0 882357862 899129344 89797 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24296] ppid=24278 vsize=878056 CPUtime=0
/proc/24291/task/24296/stat : 24296 (java) S 24278 24277 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 882357864 899129344 89797 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24297] ppid=24278 vsize=878056 CPUtime=3.42
/proc/24291/task/24297/stat : 24297 (java) S 24278 24277 4159 34819 4229 4202560 11036 0 0 0 335 7 0 0 15 0 11 0 882357864 899129344 89797 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24298] ppid=24278 vsize=878056 CPUtime=0.51
/proc/24291/task/24298/stat : 24298 (java) S 24278 24277 4159 34819 4229 4202560 2996 0 0 0 50 1 0 0 15 0 11 0 882357864 899129344 89797 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24299] ppid=24278 vsize=878056 CPUtime=0
/proc/24291/task/24299/stat : 24299 (java) S 24278 24277 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 882357864 899129344 89797 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24300] ppid=24278 vsize=878056 CPUtime=0
/proc/24291/task/24300/stat : 24300 (java) R 24278 24277 4159 34819 4229 4202560 2 0 0 0 0 0 0 0 15 0 11 0 882357864 899129344 89797 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 12.65
Current children cumulated vsize (KiB) 883200

[startup+25.5074 s]
/proc/loadavg: 1.44 1.15 1.08 2/59 24318
/proc/meminfo: memFree=177316/1048576 swapFree=2075140/2097144
[pid=24277] ppid=24276 vsize=2568 CPUtime=0
/proc/24277/stat : 24277 (p2cudf-trendy-1) S 24276 24277 4159 34819 4229 4202496 375 0 0 0 0 0 0 0 25 0 1 0 882357850 2629632 272 1283457024 134512640 135304128 4292230992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24277/statm: 642 272 233 194 0 28 0
[pid=24278] ppid=24277 vsize=2576 CPUtime=0.04
/proc/24278/stat : 24278 (p2cudf) S 24277 24277 4159 34819 4229 4202496 393 3000 0 1 0 0 2 2 25 0 1 0 882357850 2637824 282 1283457024 134512640 135304128 4288781312 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24278/statm: 644 282 241 194 0 30 0
[pid=24291] ppid=24278 vsize=879028 CPUtime=25.4
/proc/24291/stat : 24291 (java) S 24278 24277 4159 34819 4229 4202496 104958 0 1 0 2496 44 0 0 25 0 11 0 882357859 900124672 96931 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/24291/statm: 219757 96931 1792 10 0 216847 0
[pid=24291/tid=24292] ppid=24278 vsize=879028 CPUtime=19.88
/proc/24291/task/24292/stat : 24292 (java) R 24278 24277 4159 34819 4229 4202560 50478 0 1 0 1966 22 0 0 25 0 11 0 882357860 900124672 96931 1283457024 134512640 134550932 4294193088 18446744073709551615 4096261683 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=24291/tid=24293] ppid=24278 vsize=879028 CPUtime=1.3
/proc/24291/task/24293/stat : 24293 (java) S 24278 24277 4159 34819 4229 4202560 39316 0 0 0 118 12 0 0 15 0 11 0 882357861 900124672 96931 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24294] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24294/stat : 24294 (java) S 24278 24277 4159 34819 4229 4202560 10 0 0 0 0 0 0 0 18 0 11 0 882357862 900124672 96931 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24295] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24295/stat : 24295 (java) S 24278 24277 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 18 0 11 0 882357862 900124672 96931 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24296] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24296/stat : 24296 (java) S 24278 24277 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 882357864 900124672 96931 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24297] ppid=24278 vsize=879028 CPUtime=3.67
/proc/24291/task/24297/stat : 24297 (java) S 24278 24277 4159 34819 4229 4202560 11038 0 0 0 360 7 0 0 15 0 11 0 882357864 900124672 96931 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24298] ppid=24278 vsize=879028 CPUtime=0.51
/proc/24291/task/24298/stat : 24298 (java) S 24278 24277 4159 34819 4229 4202560 2996 0 0 0 50 1 0 0 15 0 11 0 882357864 900124672 96931 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24299] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24299/stat : 24299 (java) S 24278 24277 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 882357864 900124672 96931 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24300] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24300/stat : 24300 (java) S 24278 24277 4159 34819 4229 4202560 2 0 0 0 0 0 0 0 15 0 11 0 882357864 900124672 96931 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24318] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24318/stat : 24318 (java) S 24278 24277 4159 34819 4229 4202560 4 0 0 0 0 0 0 0 24 0 11 0 882360249 900124672 96931 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 25.44
Current children cumulated vsize (KiB) 884172

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

[startup+25.6075 s]
/proc/loadavg: 1.44 1.15 1.08 2/59 24318
/proc/meminfo: memFree=177316/1048576 swapFree=2075140/2097144
[pid=24277] ppid=24276 vsize=2568 CPUtime=0
/proc/24277/stat : 24277 (p2cudf-trendy-1) S 24276 24277 4159 34819 4229 4202496 375 0 0 0 0 0 0 0 25 0 1 0 882357850 2629632 272 1283457024 134512640 135304128 4292230992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24277/statm: 642 272 233 194 0 28 0
[pid=24278] ppid=24277 vsize=2576 CPUtime=0.04
/proc/24278/stat : 24278 (p2cudf) S 24277 24277 4159 34819 4229 4202496 393 3000 0 1 0 0 2 2 25 0 1 0 882357850 2637824 282 1283457024 134512640 135304128 4288781312 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24278/statm: 644 282 241 194 0 30 0
[pid=24291] ppid=24278 vsize=879028 CPUtime=25.5
/proc/24291/stat : 24291 (java) S 24278 24277 4159 34819 4229 4202496 104958 0 1 0 2506 44 0 0 25 0 11 0 882357859 900124672 96931 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/24291/statm: 219757 96931 1792 10 0 216847 0
[pid=24291/tid=24292] ppid=24278 vsize=879028 CPUtime=19.98
/proc/24291/task/24292/stat : 24292 (java) R 24278 24277 4159 34819 4229 4202560 50478 0 1 0 1976 22 0 0 25 0 11 0 882357860 900124672 96931 1283457024 134512640 134550932 4294193088 18446744073709551615 4096264471 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=24291/tid=24293] ppid=24278 vsize=879028 CPUtime=1.3
/proc/24291/task/24293/stat : 24293 (java) S 24278 24277 4159 34819 4229 4202560 39316 0 0 0 118 12 0 0 15 0 11 0 882357861 900124672 96931 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24294] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24294/stat : 24294 (java) S 24278 24277 4159 34819 4229 4202560 10 0 0 0 0 0 0 0 18 0 11 0 882357862 900124672 96931 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24295] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24295/stat : 24295 (java) S 24278 24277 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 18 0 11 0 882357862 900124672 96931 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24296] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24296/stat : 24296 (java) S 24278 24277 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 882357864 900124672 96931 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24297] ppid=24278 vsize=879028 CPUtime=3.67
/proc/24291/task/24297/stat : 24297 (java) S 24278 24277 4159 34819 4229 4202560 11038 0 0 0 360 7 0 0 15 0 11 0 882357864 900124672 96931 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24298] ppid=24278 vsize=879028 CPUtime=0.51
/proc/24291/task/24298/stat : 24298 (java) S 24278 24277 4159 34819 4229 4202560 2996 0 0 0 50 1 0 0 15 0 11 0 882357864 900124672 96931 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24299] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24299/stat : 24299 (java) S 24278 24277 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 882357864 900124672 96931 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24300] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24300/stat : 24300 (java) S 24278 24277 4159 34819 4229 4202560 2 0 0 0 0 0 0 0 15 0 11 0 882357864 900124672 96931 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24318] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24318/stat : 24318 (java) S 24278 24277 4159 34819 4229 4202560 4 0 0 0 0 0 0 0 24 0 11 0 882360249 900124672 96931 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 25.54
Current children cumulated vsize (KiB) 884172

[startup+32.0088 s]
/proc/loadavg: 1.40 1.15 1.08 3/59 24323
/proc/meminfo: memFree=176200/1048576 swapFree=2075140/2097144
[pid=24277] ppid=24276 vsize=2568 CPUtime=0
/proc/24277/stat : 24277 (p2cudf-trendy-1) S 24276 24277 4159 34819 4229 4202496 375 0 0 0 0 0 0 0 25 0 1 0 882357850 2629632 272 1283457024 134512640 135304128 4292230992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24277/statm: 642 272 233 194 0 28 0
[pid=24278] ppid=24277 vsize=2576 CPUtime=0.04
/proc/24278/stat : 24278 (p2cudf) S 24277 24277 4159 34819 4229 4202496 393 3000 0 1 0 0 2 2 25 0 1 0 882357850 2637824 282 1283457024 134512640 135304128 4288781312 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24278/statm: 644 282 241 194 0 30 0
[pid=24291] ppid=24278 vsize=879028 CPUtime=31.9
/proc/24291/stat : 24291 (java) S 24278 24277 4159 34819 4229 4202496 105209 0 1 0 3146 44 0 0 25 0 11 0 882357859 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/24291/statm: 219757 97182 1793 10 0 216847 0
[pid=24291/tid=24292] ppid=24278 vsize=879028 CPUtime=25.94
/proc/24291/task/24292/stat : 24292 (java) R 24278 24277 4159 34819 4229 4202560 50478 0 1 0 2572 22 0 0 25 0 11 0 882357860 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4096243909 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=24291/tid=24293] ppid=24278 vsize=879028 CPUtime=1.7
/proc/24291/task/24293/stat : 24293 (java) S 24278 24277 4159 34819 4229 4202560 39566 0 0 0 158 12 0 0 16 0 11 0 882357861 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24294] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24294/stat : 24294 (java) S 24278 24277 4159 34819 4229 4202560 10 0 0 0 0 0 0 0 18 0 11 0 882357862 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24295] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24295/stat : 24295 (java) S 24278 24277 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 15 0 11 0 882357862 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24296] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24296/stat : 24296 (java) S 24278 24277 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 882357864 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24297] ppid=24278 vsize=879028 CPUtime=3.7
/proc/24291/task/24297/stat : 24297 (java) S 24278 24277 4159 34819 4229 4202560 11039 0 0 0 363 7 0 0 16 0 11 0 882357864 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24298] ppid=24278 vsize=879028 CPUtime=0.51
/proc/24291/task/24298/stat : 24298 (java) S 24278 24277 4159 34819 4229 4202560 2996 0 0 0 50 1 0 0 15 0 11 0 882357864 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24299] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24299/stat : 24299 (java) S 24278 24277 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 882357864 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24300] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24300/stat : 24300 (java) R 24278 24277 4159 34819 4229 4202560 2 0 0 0 0 0 0 0 15 0 11 0 882357864 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=24291/tid=24323] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24323/stat : 24323 (java) S 24278 24277 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 11 0 882361014 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 31.94
Current children cumulated vsize (KiB) 884172

[startup+35.2099 s]
/proc/loadavg: 1.37 1.14 1.08 2/59 24323
/proc/meminfo: memFree=176200/1048576 swapFree=2075140/2097144
[pid=24277] ppid=24276 vsize=2568 CPUtime=0
/proc/24277/stat : 24277 (p2cudf-trendy-1) S 24276 24277 4159 34819 4229 4202496 375 0 0 0 0 0 0 0 25 0 1 0 882357850 2629632 272 1283457024 134512640 135304128 4292230992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24277/statm: 642 272 233 194 0 28 0
[pid=24278] ppid=24277 vsize=2576 CPUtime=0.04
/proc/24278/stat : 24278 (p2cudf) S 24277 24277 4159 34819 4229 4202496 393 3000 0 1 0 0 2 2 25 0 1 0 882357850 2637824 282 1283457024 134512640 135304128 4288781312 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24278/statm: 644 282 241 194 0 30 0
[pid=24291] ppid=24278 vsize=879028 CPUtime=35.06
/proc/24291/stat : 24291 (java) S 24278 24277 4159 34819 4229 4202496 105209 0 1 0 3462 44 0 0 25 0 11 0 882357859 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/24291/statm: 219757 97182 1793 10 0 216847 0
[pid=24291/tid=24292] ppid=24278 vsize=879028 CPUtime=29.09
/proc/24291/task/24292/stat : 24292 (java) R 24278 24277 4159 34819 4229 4202560 50478 0 1 0 2887 22 0 0 25 0 11 0 882357860 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4096299948 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=24291/tid=24293] ppid=24278 vsize=879028 CPUtime=1.7
/proc/24291/task/24293/stat : 24293 (java) S 24278 24277 4159 34819 4229 4202560 39566 0 0 0 158 12 0 0 15 0 11 0 882357861 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24294] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24294/stat : 24294 (java) S 24278 24277 4159 34819 4229 4202560 10 0 0 0 0 0 0 0 18 0 11 0 882357862 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24295] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24295/stat : 24295 (java) S 24278 24277 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 15 0 11 0 882357862 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24296] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24296/stat : 24296 (java) S 24278 24277 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 882357864 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24297] ppid=24278 vsize=879028 CPUtime=3.71
/proc/24291/task/24297/stat : 24297 (java) S 24278 24277 4159 34819 4229 4202560 11039 0 0 0 364 7 0 0 16 0 11 0 882357864 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24298] ppid=24278 vsize=879028 CPUtime=0.51
/proc/24291/task/24298/stat : 24298 (java) S 24278 24277 4159 34819 4229 4202560 2996 0 0 0 50 1 0 0 15 0 11 0 882357864 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24299] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24299/stat : 24299 (java) S 24278 24277 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 882357864 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24300] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24300/stat : 24300 (java) S 24278 24277 4159 34819 4229 4202560 2 0 0 0 0 0 0 0 15 0 11 0 882357864 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24323] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24323/stat : 24323 (java) S 24278 24277 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 11 0 882361014 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 35.1
Current children cumulated vsize (KiB) 884172

[startup+38.4123 s]
/proc/loadavg: 1.37 1.14 1.08 3/59 24323
/proc/meminfo: memFree=176200/1048576 swapFree=2075140/2097144
[pid=24277] ppid=24276 vsize=2568 CPUtime=0
/proc/24277/stat : 24277 (p2cudf-trendy-1) S 24276 24277 4159 34819 4229 4202496 375 0 0 0 0 0 0 0 25 0 1 0 882357850 2629632 272 1283457024 134512640 135304128 4292230992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24277/statm: 642 272 233 194 0 28 0
[pid=24278] ppid=24277 vsize=2576 CPUtime=0.04
/proc/24278/stat : 24278 (p2cudf) S 24277 24277 4159 34819 4229 4202496 393 3000 0 1 0 0 2 2 25 0 1 0 882357850 2637824 282 1283457024 134512640 135304128 4288781312 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24278/statm: 644 282 241 194 0 30 0
[pid=24291] ppid=24278 vsize=879028 CPUtime=38.24
/proc/24291/stat : 24291 (java) S 24278 24277 4159 34819 4229 4202496 105209 0 1 0 3780 44 0 0 25 0 11 0 882357859 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/24291/statm: 219757 97182 1793 10 0 216847 0
[pid=24291/tid=24292] ppid=24278 vsize=879028 CPUtime=32.27
/proc/24291/task/24292/stat : 24292 (java) R 24278 24277 4159 34819 4229 4202560 50478 0 1 0 3205 22 0 0 25 0 11 0 882357860 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4096261300 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=24291/tid=24293] ppid=24278 vsize=879028 CPUtime=1.7
/proc/24291/task/24293/stat : 24293 (java) S 24278 24277 4159 34819 4229 4202560 39566 0 0 0 158 12 0 0 15 0 11 0 882357861 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24294] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24294/stat : 24294 (java) S 24278 24277 4159 34819 4229 4202560 10 0 0 0 0 0 0 0 18 0 11 0 882357862 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24295] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24295/stat : 24295 (java) S 24278 24277 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 15 0 11 0 882357862 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24296] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24296/stat : 24296 (java) S 24278 24277 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 882357864 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24297] ppid=24278 vsize=879028 CPUtime=3.71
/proc/24291/task/24297/stat : 24297 (java) S 24278 24277 4159 34819 4229 4202560 11039 0 0 0 364 7 0 0 16 0 11 0 882357864 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24298] ppid=24278 vsize=879028 CPUtime=0.51
/proc/24291/task/24298/stat : 24298 (java) S 24278 24277 4159 34819 4229 4202560 2996 0 0 0 50 1 0 0 15 0 11 0 882357864 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24299] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24299/stat : 24299 (java) S 24278 24277 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 882357864 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24300] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24300/stat : 24300 (java) S 24278 24277 4159 34819 4229 4202560 2 0 0 0 0 0 0 0 15 0 11 0 882357864 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24323] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24323/stat : 24323 (java) S 24278 24277 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 11 0 882361014 900124672 97182 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 38.28
Current children cumulated vsize (KiB) 884172

[startup+40.0128 s]
/proc/loadavg: 1.34 1.14 1.08 2/59 24323
/proc/meminfo: memFree=176200/1048576 swapFree=2075140/2097144
[pid=24277] ppid=24276 vsize=2568 CPUtime=0
/proc/24277/stat : 24277 (p2cudf-trendy-1) S 24276 24277 4159 34819 4229 4202496 375 0 0 0 0 0 0 0 25 0 1 0 882357850 2629632 272 1283457024 134512640 135304128 4292230992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24277/statm: 642 272 233 194 0 28 0
[pid=24278] ppid=24277 vsize=2576 CPUtime=0.04
/proc/24278/stat : 24278 (p2cudf) S 24277 24277 4159 34819 4229 4202496 393 3000 0 1 0 0 2 2 25 0 1 0 882357850 2637824 282 1283457024 134512640 135304128 4288781312 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24278/statm: 644 282 241 194 0 30 0
[pid=24291] ppid=24278 vsize=879028 CPUtime=39.84
/proc/24291/stat : 24291 (java) S 24278 24277 4159 34819 4229 4202496 105214 0 1 0 3939 45 0 0 25 0 11 0 882357859 900124672 97187 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/24291/statm: 219757 97187 1793 10 0 216847 0
[pid=24291/tid=24292] ppid=24278 vsize=879028 CPUtime=33.76
/proc/24291/task/24292/stat : 24292 (java) R 24278 24277 4159 34819 4229 4202560 50479 0 1 0 3353 23 0 0 25 0 11 0 882357860 900124672 97187 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=24291/tid=24293] ppid=24278 vsize=879028 CPUtime=1.7
/proc/24291/task/24293/stat : 24293 (java) S 24278 24277 4159 34819 4229 4202560 39566 0 0 0 158 12 0 0 16 0 11 0 882357861 900124672 97187 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24294] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24294/stat : 24294 (java) S 24278 24277 4159 34819 4229 4202560 10 0 0 0 0 0 0 0 18 0 11 0 882357862 900124672 97187 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24295] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24295/stat : 24295 (java) S 24278 24277 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 15 0 11 0 882357862 900124672 97187 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24296] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24296/stat : 24296 (java) S 24278 24277 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 882357864 900124672 97187 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24297] ppid=24278 vsize=879028 CPUtime=3.82
/proc/24291/task/24297/stat : 24297 (java) R 24278 24277 4159 34819 4229 4202560 11043 0 0 0 375 7 0 0 16 0 11 0 882357864 900124672 97187 1283457024 134512640 134550932 4294193088 18446744073709551615 4148418244 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=24291/tid=24298] ppid=24278 vsize=879028 CPUtime=0.51
/proc/24291/task/24298/stat : 24298 (java) S 24278 24277 4159 34819 4229 4202560 2996 0 0 0 50 1 0 0 15 0 11 0 882357864 900124672 97187 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24299] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24299/stat : 24299 (java) S 24278 24277 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 882357864 900124672 97187 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24300] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24300/stat : 24300 (java) S 24278 24277 4159 34819 4229 4202560 2 0 0 0 0 0 0 0 15 0 11 0 882357864 900124672 97187 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 39.88
Current children cumulated vsize (KiB) 884172

[startup+40.4076 s]
/proc/loadavg: 1.34 1.14 1.08 2/59 24323
/proc/meminfo: memFree=176200/1048576 swapFree=2075140/2097144
[pid=24277] ppid=24276 vsize=2568 CPUtime=0
/proc/24277/stat : 24277 (p2cudf-trendy-1) S 24276 24277 4159 34819 4229 4202496 375 0 0 0 0 0 0 0 25 0 1 0 882357850 2629632 272 1283457024 134512640 135304128 4292230992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24277/statm: 642 272 233 194 0 28 0
[pid=24278] ppid=24277 vsize=2576 CPUtime=0.04
/proc/24278/stat : 24278 (p2cudf) S 24277 24277 4159 34819 4229 4202496 393 3000 0 1 0 0 2 2 25 0 1 0 882357850 2637824 282 1283457024 134512640 135304128 4288781312 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24278/statm: 644 282 241 194 0 30 0
[pid=24291] ppid=24278 vsize=879028 CPUtime=39.86
/proc/24291/stat : 24291 (java) S 24278 24277 4159 34819 4229 4202496 105221 0 1 0 3941 45 0 0 25 0 11 0 882357859 900124672 97194 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/24291/statm: 219757 97194 1793 10 0 216847 0
[pid=24291/tid=24292] ppid=24278 vsize=879028 CPUtime=33.78
/proc/24291/task/24292/stat : 24292 (java) S 24278 24277 4159 34819 4229 4202560 50484 0 1 0 3355 23 0 0 25 0 11 0 882357860 900124672 97194 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24293] ppid=24278 vsize=879028 CPUtime=1.7
/proc/24291/task/24293/stat : 24293 (java) S 24278 24277 4159 34819 4229 4202560 39566 0 0 0 158 12 0 0 15 0 11 0 882357861 900124672 97194 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24294] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24294/stat : 24294 (java) S 24278 24277 4159 34819 4229 4202560 10 0 0 0 0 0 0 0 18 0 11 0 882357862 900124672 97194 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24295] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24295/stat : 24295 (java) S 24278 24277 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 15 0 11 0 882357862 900124672 97194 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24296] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24296/stat : 24296 (java) S 24278 24277 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 882357864 900124672 97194 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24297] ppid=24278 vsize=879028 CPUtime=3.83
/proc/24291/task/24297/stat : 24297 (java) S 24278 24277 4159 34819 4229 4202560 11045 0 0 0 376 7 0 0 16 0 11 0 882357864 900124672 97194 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24298] ppid=24278 vsize=879028 CPUtime=0.51
/proc/24291/task/24298/stat : 24298 (java) S 24278 24277 4159 34819 4229 4202560 2996 0 0 0 50 1 0 0 15 0 11 0 882357864 900124672 97194 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24299] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24299/stat : 24299 (java) S 24278 24277 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 882357864 900124672 97194 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24300] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24300/stat : 24300 (java) S 24278 24277 4159 34819 4229 4202560 2 0 0 0 0 0 0 0 15 0 11 0 882357864 900124672 97194 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 39.9
Current children cumulated vsize (KiB) 884172

[startup+40.6077 s]
/proc/loadavg: 1.34 1.14 1.08 2/59 24323
/proc/meminfo: memFree=176200/1048576 swapFree=2075140/2097144
[pid=24277] ppid=24276 vsize=2568 CPUtime=0
/proc/24277/stat : 24277 (p2cudf-trendy-1) S 24276 24277 4159 34819 4229 4202496 375 0 0 0 0 0 0 0 25 0 1 0 882357850 2629632 272 1283457024 134512640 135304128 4292230992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24277/statm: 642 272 233 194 0 28 0
[pid=24278] ppid=24277 vsize=2576 CPUtime=0.04
/proc/24278/stat : 24278 (p2cudf) S 24277 24277 4159 34819 4229 4202496 393 3000 0 1 0 0 2 2 25 0 1 0 882357850 2637824 282 1283457024 134512640 135304128 4288781312 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24278/statm: 644 282 241 194 0 30 0
[pid=24291] ppid=24278 vsize=879028 CPUtime=39.92
/proc/24291/stat : 24291 (java) S 24278 24277 4159 34819 4229 4202496 105223 0 1 0 3945 47 0 0 25 0 11 0 882357859 900124672 97196 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/24291/statm: 219757 97196 1793 10 0 216847 0
[pid=24291/tid=24292] ppid=24278 vsize=879028 CPUtime=33.78
/proc/24291/task/24292/stat : 24292 (java) S 24278 24277 4159 34819 4229 4202560 50484 0 1 0 3355 23 0 0 25 0 11 0 882357860 900124672 97196 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24293] ppid=24278 vsize=879028 CPUtime=1.7
/proc/24291/task/24293/stat : 24293 (java) S 24278 24277 4159 34819 4229 4202560 39566 0 0 0 158 12 0 0 15 0 11 0 882357861 900124672 97196 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24294] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24294/stat : 24294 (java) S 24278 24277 4159 34819 4229 4202560 10 0 0 0 0 0 0 0 18 0 11 0 882357862 900124672 97196 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24295] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24295/stat : 24295 (java) S 24278 24277 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 15 0 11 0 882357862 900124672 97196 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24296] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24296/stat : 24296 (java) S 24278 24277 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 882357864 900124672 97196 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24297] ppid=24278 vsize=879028 CPUtime=3.84
/proc/24291/task/24297/stat : 24297 (java) S 24278 24277 4159 34819 4229 4202560 11045 0 0 0 377 7 0 0 15 0 11 0 882357864 900124672 97196 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24298] ppid=24278 vsize=879028 CPUtime=0.51
/proc/24291/task/24298/stat : 24298 (java) S 24278 24277 4159 34819 4229 4202560 2996 0 0 0 50 1 0 0 15 0 11 0 882357864 900124672 97196 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24299] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24299/stat : 24299 (java) S 24278 24277 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 882357864 900124672 97196 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24300] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24300/stat : 24300 (java) S 24278 24277 4159 34819 4229 4202560 2 0 0 0 0 0 0 0 15 0 11 0 882357864 900124672 97196 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 39.96
Current children cumulated vsize (KiB) 884172

[startup+40.7094 s]
/proc/loadavg: 1.34 1.14 1.08 2/59 24325
/proc/meminfo: memFree=176200/1048576 swapFree=2075140/2097144
[pid=24277] ppid=24276 vsize=2568 CPUtime=0
/proc/24277/stat : 24277 (p2cudf-trendy-1) S 24276 24277 4159 34819 4229 4202496 375 0 0 0 0 0 0 0 25 0 1 0 882357850 2629632 272 1283457024 134512640 135304128 4292230992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24277/statm: 642 272 233 194 0 28 0
[pid=24278] ppid=24277 vsize=2576 CPUtime=0.04
/proc/24278/stat : 24278 (p2cudf) S 24277 24277 4159 34819 4229 4202496 393 3000 0 1 0 0 2 2 25 0 1 0 882357850 2637824 282 1283457024 134512640 135304128 4288781312 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/24278/statm: 644 282 241 194 0 30 0
[pid=24291] ppid=24278 vsize=879028 CPUtime=40.02
/proc/24291/stat : 24291 (java) S 24278 24277 4159 34819 4229 4202496 105228 0 1 0 3953 49 0 0 25 0 11 0 882357859 900124672 97201 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/24291/statm: 219757 97201 1793 10 0 216847 0
[pid=24291/tid=24292] ppid=24278 vsize=879028 CPUtime=33.78
/proc/24291/task/24292/stat : 24292 (java) S 24278 24277 4159 34819 4229 4202560 50484 0 1 0 3355 23 0 0 25 0 11 0 882357860 900124672 97201 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24293] ppid=24278 vsize=879028 CPUtime=1.7
/proc/24291/task/24293/stat : 24293 (java) S 24278 24277 4159 34819 4229 4202560 39566 0 0 0 158 12 0 0 15 0 11 0 882357861 900124672 97201 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24294] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24294/stat : 24294 (java) S 24278 24277 4159 34819 4229 4202560 10 0 0 0 0 0 0 0 18 0 11 0 882357862 900124672 97201 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24295] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24295/stat : 24295 (java) S 24278 24277 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 15 0 11 0 882357862 900124672 97201 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24296] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24296/stat : 24296 (java) S 24278 24277 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 882357864 900124672 97201 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24297] ppid=24278 vsize=879028 CPUtime=3.89
/proc/24291/task/24297/stat : 24297 (java) S 24278 24277 4159 34819 4229 4202560 11050 0 0 0 382 7 0 0 15 0 11 0 882357864 900124672 97201 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24298] ppid=24278 vsize=879028 CPUtime=0.51
/proc/24291/task/24298/stat : 24298 (java) S 24278 24277 4159 34819 4229 4202560 2996 0 0 0 50 1 0 0 15 0 11 0 882357864 900124672 97201 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24299] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24299/stat : 24299 (java) S 24278 24277 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 25 0 11 0 882357864 900124672 97201 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24300] ppid=24278 vsize=879028 CPUtime=0
/proc/24291/task/24300/stat : 24300 (java) S 24278 24277 4159 34819 4229 4202560 2 0 0 0 0 0 0 0 15 0 11 0 882357864 900124672 97201 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=24291/tid=24325] ppid=24278 vsize=879028 CPUtime=0.1
/proc/24291/task/24325/stat : 24325 (java) R 24278 24277 4159 34819 4229 4202560 2 0 0 0 6 4 0 0 20 0 11 0 882361854 900124672 97201 1283457024 134512640 134550932 4294193088 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 40.06
Current children cumulated vsize (KiB) 884172

Child status: 0
Real time (s): 40.7784
CPU time (s): 40.1065
CPU user time (s): 39.5625
CPU system time (s): 0.544034
CPU usage (%): 98.3524
Max. virtual memory (cumulated for all children) (KiB): 885760

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 39.5625
system time used= 0.544034
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 109017
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= 2298
involuntary context switches= 2619

runsolver used 0 second user time and 0 second system time

The end