runsolver Copyright (C) 2010 Olivier ROUSSEL

This is runsolver version 3.2.9a (svn: 651)

This program is distributed in the hope that it will be useful,
but WITHOUT ANY WARRANTY; without even the implied warranty of
MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE.  See the
GNU General Public License for more details.

command line: /home/misc2010/bin/runsolver -s SIGUSR1 -M 1124 -C 290 -d 10 -w /home/misc2010/tmp/201108300820/p2cudf-user-1.13/rand437.cudf.user-upgrades.log.runsolver ./p2cudf-user-1.13 /home/misc2010/data/2011/user-upgrades/rand437.cudf /home/misc2010/tmp/201108300820/p2cudf-user-1.13/rand437.cudf.user-upgrades.result +sum(installedsize) 

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


[startup+0 s]
/proc/loadavg: 0.85 1.01 1.01 2/38 6835
/proc/meminfo: memFree=924284/1048576 swapFree=0/0
[pid=6835] ppid=6834 vsize=3024 CPUtime=0
/proc/6835/stat : 6835 (runsolver) D 6834 6835 2160 34817 2160 4202560 73 0 0 0 0 0 0 0 25 0 1 0 53294298 3096576 94 1283457024 134512640 134586868 4287951520 18446744073709551615 4294960130 0 0 0 24578 18446744071564332000 0 0 17 0 0 0 0
/proc/6835/statm: 756 94 62 19 0 55 0

[startup+0.133792 s]
/proc/loadavg: 0.85 1.01 1.01 2/38 6835
/proc/meminfo: memFree=924284/1048576 swapFree=0/0
[pid=6835] ppid=6834 vsize=2564 CPUtime=0
/proc/6835/stat : 6835 (p2cudf-user-1.1) S 6834 6835 2160 34817 2160 4202496 374 0 0 0 0 0 0 0 25 0 1 0 53294298 2625536 269 1283457024 134512640 135304128 4291157600 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6835/statm: 641 269 230 194 0 28 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2564

[startup+0.205825 s]
/proc/loadavg: 0.85 1.01 1.01 2/38 6835
/proc/meminfo: memFree=924284/1048576 swapFree=0/0
[pid=6835] ppid=6834 vsize=2564 CPUtime=0
/proc/6835/stat : 6835 (p2cudf-user-1.1) S 6834 6835 2160 34817 2160 4202496 374 0 0 0 0 0 0 0 25 0 1 0 53294298 2625536 269 1283457024 134512640 135304128 4291157600 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6835/statm: 641 269 230 194 0 28 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2564

[startup+0.305831 s]
/proc/loadavg: 0.85 1.01 1.01 2/38 6835
/proc/meminfo: memFree=924284/1048576 swapFree=0/0
[pid=6835] ppid=6834 vsize=2564 CPUtime=0
/proc/6835/stat : 6835 (p2cudf-user-1.1) S 6834 6835 2160 34817 2160 4202496 374 0 0 0 0 0 0 0 25 0 1 0 53294298 2625536 269 1283457024 134512640 135304128 4291157600 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6835/statm: 641 269 230 194 0 28 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2564

[startup+0.705838 s]
/proc/loadavg: 0.85 1.01 1.01 2/38 6835
/proc/meminfo: memFree=924284/1048576 swapFree=0/0
[pid=6835] ppid=6834 vsize=2564 CPUtime=0
/proc/6835/stat : 6835 (p2cudf-user-1.1) S 6834 6835 2160 34817 2160 4202496 374 0 0 0 0 0 0 0 25 0 1 0 53294298 2625536 269 1283457024 134512640 135304128 4291157600 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6835/statm: 641 269 230 194 0 28 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2564

[startup+1.51007 s]
/proc/loadavg: 0.86 1.01 1.01 3/50 6858
/proc/meminfo: memFree=902792/1048576 swapFree=0/0
[pid=6835] ppid=6834 vsize=2564 CPUtime=0
/proc/6835/stat : 6835 (p2cudf-user-1.1) S 6834 6835 2160 34817 2160 4202496 374 0 0 0 0 0 0 0 25 0 1 0 53294298 2625536 269 1283457024 134512640 135304128 4291157600 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6835/statm: 641 269 230 194 0 28 0
[pid=6837] ppid=6835 vsize=2568 CPUtime=0.02
/proc/6837/stat : 6837 (p2cudf) S 6835 6835 2160 34817 2160 4202496 389 3014 0 1 0 0 1 1 25 0 1 0 53294298 2629632 279 1283457024 134512640 135304128 4294062416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6837/statm: 642 279 239 194 0 29 0
[pid=6849] ppid=6837 vsize=890752 CPUtime=0.8
/proc/6849/stat : 6849 (java) S 6837 6835 2160 34817 2160 4202496 15009 0 105 0 76 4 0 0 23 0 10 0 53294301 912130048 12605 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6849/statm: 222688 12605 1725 10 0 219779 0
[pid=6849/tid=6850] ppid=6837 vsize=890752 CPUtime=0.29
/proc/6849/task/6850/stat : 6850 (java) R 6837 6835 2160 34817 2160 4202560 3724 0 15 0 28 1 0 0 25 0 10 0 53294327 912130048 12605 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6849/tid=6851] ppid=6837 vsize=890752 CPUtime=0
/proc/6849/task/6851/stat : 6851 (java) S 6837 6835 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 10 0 53294337 912130048 12605 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6852] ppid=6837 vsize=890752 CPUtime=0
/proc/6849/task/6852/stat : 6852 (java) S 6837 6835 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 25 0 10 0 53294337 912130048 12605 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6853] ppid=6837 vsize=890752 CPUtime=0
/proc/6849/task/6853/stat : 6853 (java) S 6837 6835 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 10 0 53294338 912130048 12605 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6854] ppid=6837 vsize=890752 CPUtime=0
/proc/6849/task/6854/stat : 6854 (java) S 6837 6835 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 53294353 912130048 12605 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6855] ppid=6837 vsize=890752 CPUtime=0.24
/proc/6849/task/6855/stat : 6855 (java) R 6837 6835 2160 34817 2160 4202560 5916 0 0 0 22 2 0 0 21 0 10 0 53294353 912130048 12605 1283457024 134512640 134550932 4289811424 18446744073709551615 4149809819 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6849/tid=6856] ppid=6837 vsize=890752 CPUtime=0.25
/proc/6849/task/6856/stat : 6856 (java) R 6837 6835 2160 34817 2160 4202560 4371 0 8 0 25 0 0 0 25 0 10 0 53294353 912130048 12605 1283457024 134512640 134550932 4289811424 18446744073709551615 4152192429 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6849/tid=6857] ppid=6837 vsize=890752 CPUtime=0
/proc/6849/task/6857/stat : 6857 (java) S 6837 6835 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 53294353 912130048 12605 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6858] ppid=6837 vsize=890752 CPUtime=0
/proc/6849/task/6858/stat : 6858 (java) S 6837 6835 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 16 0 10 0 53294353 912130048 12605 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 0.82
Current children cumulated vsize (KiB) 895884

[startup+3.13032 s]
/proc/loadavg: 0.86 1.01 1.01 3/50 6858
/proc/meminfo: memFree=836576/1048576 swapFree=0/0
[pid=6835] ppid=6834 vsize=2564 CPUtime=0
/proc/6835/stat : 6835 (p2cudf-user-1.1) S 6834 6835 2160 34817 2160 4202496 374 0 0 0 0 0 0 0 25 0 1 0 53294298 2625536 269 1283457024 134512640 135304128 4291157600 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6835/statm: 641 269 230 194 0 28 0
[pid=6837] ppid=6835 vsize=2568 CPUtime=0.02
/proc/6837/stat : 6837 (p2cudf) S 6835 6835 2160 34817 2160 4202496 389 3014 0 1 0 0 1 1 25 0 1 0 53294298 2629632 279 1283457024 134512640 135304128 4294062416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6837/statm: 642 279 239 194 0 29 0
[pid=6849] ppid=6837 vsize=889152 CPUtime=2.41
/proc/6849/stat : 6849 (java) S 6837 6835 2160 34817 2160 4202496 63875 0 105 0 220 21 0 0 23 0 10 0 53294301 910491648 61100 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6849/statm: 222288 61100 1746 10 0 219379 0
[pid=6849/tid=6850] ppid=6837 vsize=889152 CPUtime=1.39
/proc/6849/task/6850/stat : 6850 (java) R 6837 6835 2160 34817 2160 4202560 50043 0 15 0 121 18 0 0 25 0 10 0 53294327 910491648 61100 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6849/tid=6851] ppid=6837 vsize=889152 CPUtime=0.05
/proc/6849/task/6851/stat : 6851 (java) R 6837 6835 2160 34817 2160 4202560 1717 0 0 0 5 0 0 0 15 0 10 0 53294337 910491648 61100 1283457024 134512640 134550932 4289811424 18446744073709551615 4149084536 0 0 0 16800975 0 0 0 -1 0 0 0 0
[pid=6849/tid=6852] ppid=6837 vsize=889152 CPUtime=0
/proc/6849/task/6852/stat : 6852 (java) S 6837 6835 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 25 0 10 0 53294337 910491648 61100 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6853] ppid=6837 vsize=889152 CPUtime=0
/proc/6849/task/6853/stat : 6853 (java) S 6837 6835 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 10 0 53294338 910491648 61100 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6854] ppid=6837 vsize=889152 CPUtime=0
/proc/6849/task/6854/stat : 6854 (java) S 6837 6835 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 53294353 910491648 61100 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6855] ppid=6837 vsize=889152 CPUtime=0.5
/proc/6849/task/6855/stat : 6855 (java) S 6837 6835 2160 34817 2160 4202560 6677 0 0 0 48 2 0 0 20 0 10 0 53294353 910491648 61100 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6856] ppid=6837 vsize=889152 CPUtime=0.44
/proc/6849/task/6856/stat : 6856 (java) S 6837 6835 2160 34817 2160 4202560 4446 0 8 0 44 0 0 0 20 0 10 0 53294353 910491648 61100 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6857] ppid=6837 vsize=889152 CPUtime=0
/proc/6849/task/6857/stat : 6857 (java) S 6837 6835 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 53294353 910491648 61100 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6858] ppid=6837 vsize=889152 CPUtime=0
/proc/6849/task/6858/stat : 6858 (java) R 6837 6835 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 10 0 53294353 910491648 61100 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 2.43
Current children cumulated vsize (KiB) 894284
heavy processes:

[startup+6.31598 s]
/proc/loadavg: 0.87 1.01 1.01 3/51 6859
/proc/meminfo: memFree=637696/1048576 swapFree=0/0
[pid=6835] ppid=6834 vsize=2564 CPUtime=0
/proc/6835/stat : 6835 (p2cudf-user-1.1) S 6834 6835 2160 34817 2160 4202496 374 0 0 0 0 0 0 0 25 0 1 0 53294298 2625536 269 1283457024 134512640 135304128 4291157600 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6835/statm: 641 269 230 194 0 28 0
[pid=6837] ppid=6835 vsize=2568 CPUtime=0.02
/proc/6837/stat : 6837 (p2cudf) S 6835 6835 2160 34817 2160 4202496 389 3014 0 1 0 0 1 1 25 0 1 0 53294298 2629632 279 1283457024 134512640 135304128 4294062416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6837/statm: 642 279 239 194 0 29 0
[pid=6849] ppid=6837 vsize=889476 CPUtime=5.42
/proc/6849/stat : 6849 (java) S 6837 6835 2160 34817 2160 4202496 73424 0 105 0 516 26 0 0 23 0 11 0 53294301 910823424 70649 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6849/statm: 222369 70649 1772 10 0 219460 0
[pid=6849/tid=6850] ppid=6837 vsize=889476 CPUtime=2.84
/proc/6849/task/6850/stat : 6850 (java) R 6837 6835 2160 34817 2160 4202560 50276 0 15 0 266 18 0 0 25 0 11 0 53294327 910823424 70649 1283457024 134512640 134550932 4289811424 18446744073709551615 4095811864 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6849/tid=6851] ppid=6837 vsize=889476 CPUtime=0.23
/proc/6849/task/6851/stat : 6851 (java) S 6837 6835 2160 34817 2160 4202560 10624 0 0 0 21 2 0 0 15 0 11 0 53294337 910823424 70649 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6852] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6852/stat : 6852 (java) S 6837 6835 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 53294337 910823424 70649 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6853] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6853/stat : 6853 (java) S 6837 6835 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 53294338 910823424 70649 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6854] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6854/stat : 6854 (java) S 6837 6835 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 53294353 910823424 70649 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6855] ppid=6837 vsize=889476 CPUtime=0.5
/proc/6849/task/6855/stat : 6855 (java) S 6837 6835 2160 34817 2160 4202560 6677 0 0 0 48 2 0 0 20 0 11 0 53294353 910823424 70649 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6856] ppid=6837 vsize=889476 CPUtime=1.82
/proc/6849/task/6856/stat : 6856 (java) S 6837 6835 2160 34817 2160 4202560 4848 0 8 0 180 2 0 0 15 0 11 0 53294353 910823424 70649 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6857] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6857/stat : 6857 (java) S 6837 6835 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 53294353 910823424 70649 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6858] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6858/stat : 6858 (java) S 6837 6835 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 53294353 910823424 70649 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6859] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6859/stat : 6859 (java) S 6837 6835 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 53294800 910823424 70649 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 5.44
Current children cumulated vsize (KiB) 894608

[startup+12.7076 s]
/proc/loadavg: 0.88 1.01 1.01 3/51 6860
/proc/meminfo: memFree=585120/1048576 swapFree=0/0
[pid=6835] ppid=6834 vsize=2564 CPUtime=0
/proc/6835/stat : 6835 (p2cudf-user-1.1) S 6834 6835 2160 34817 2160 4202496 374 0 0 0 0 0 0 0 25 0 1 0 53294298 2625536 269 1283457024 134512640 135304128 4291157600 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6835/statm: 641 269 230 194 0 28 0
[pid=6837] ppid=6835 vsize=2568 CPUtime=0.02
/proc/6837/stat : 6837 (p2cudf) S 6835 6835 2160 34817 2160 4202496 389 3014 0 1 0 0 1 1 25 0 1 0 53294298 2629632 279 1283457024 134512640 135304128 4294062416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6837/statm: 642 279 239 194 0 29 0
[pid=6849] ppid=6837 vsize=889476 CPUtime=11.81
/proc/6849/stat : 6849 (java) S 6837 6835 2160 34817 2160 4202496 86512 0 105 0 1150 31 0 0 23 0 11 0 53294301 910823424 83737 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6849/statm: 222369 83737 1783 10 0 219460 0
[pid=6849/tid=6850] ppid=6837 vsize=889476 CPUtime=7.84
/proc/6849/task/6850/stat : 6850 (java) R 6837 6835 2160 34817 2160 4202560 50277 0 15 0 766 18 0 0 25 0 11 0 53294327 910823424 83737 1283457024 134512640 134550932 4289811424 18446744073709551615 4095811848 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6849/tid=6851] ppid=6837 vsize=889476 CPUtime=1.43
/proc/6849/task/6851/stat : 6851 (java) S 6837 6835 2160 34817 2160 4202560 23677 0 0 0 136 7 0 0 16 0 11 0 53294337 910823424 83737 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6852] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6852/stat : 6852 (java) S 6837 6835 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 53294337 910823424 83737 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6853] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6853/stat : 6853 (java) S 6837 6835 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 53294338 910823424 83737 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6854] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6854/stat : 6854 (java) S 6837 6835 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 53294353 910823424 83737 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6855] ppid=6837 vsize=889476 CPUtime=0.5
/proc/6849/task/6855/stat : 6855 (java) S 6837 6835 2160 34817 2160 4202560 6677 0 0 0 48 2 0 0 20 0 11 0 53294353 910823424 83737 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6856] ppid=6837 vsize=889476 CPUtime=2
/proc/6849/task/6856/stat : 6856 (java) S 6837 6835 2160 34817 2160 4202560 4882 0 8 0 198 2 0 0 16 0 11 0 53294353 910823424 83737 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6857] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6857/stat : 6857 (java) S 6837 6835 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 53294353 910823424 83737 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6858] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6858/stat : 6858 (java) S 6837 6835 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 53294353 910823424 83737 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6859] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6859/stat : 6859 (java) S 6837 6835 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 53294800 910823424 83737 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 11.83
Current children cumulated vsize (KiB) 894608

[startup+25.5103 s]
/proc/loadavg: 0.90 1.00 1.00 2/50 6860
/proc/meminfo: memFree=581292/1048576 swapFree=0/0
[pid=6835] ppid=6834 vsize=2564 CPUtime=0
/proc/6835/stat : 6835 (p2cudf-user-1.1) S 6834 6835 2160 34817 2160 4202496 374 0 0 0 0 0 0 0 25 0 1 0 53294298 2625536 269 1283457024 134512640 135304128 4291157600 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6835/statm: 641 269 230 194 0 28 0
[pid=6837] ppid=6835 vsize=2568 CPUtime=0.02
/proc/6837/stat : 6837 (p2cudf) S 6835 6835 2160 34817 2160 4202496 389 3014 0 1 0 0 1 1 25 0 1 0 53294298 2629632 279 1283457024 134512640 135304128 4294062416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6837/statm: 642 279 239 194 0 29 0
[pid=6849] ppid=6837 vsize=889476 CPUtime=24.6
/proc/6849/stat : 6849 (java) S 6837 6835 2160 34817 2160 4202496 87482 0 105 0 2429 31 0 0 23 0 11 0 53294301 910823424 84707 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6849/statm: 222369 84707 1783 10 0 219460 0
[pid=6849/tid=6850] ppid=6837 vsize=889476 CPUtime=19.32
/proc/6849/task/6850/stat : 6850 (java) R 6837 6835 2160 34817 2160 4202560 50277 0 15 0 1914 18 0 0 25 0 11 0 53294327 910823424 84707 1283457024 134512640 134550932 4289811424 18446744073709551615 4095883948 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6849/tid=6851] ppid=6837 vsize=889476 CPUtime=2.75
/proc/6849/task/6851/stat : 6851 (java) S 6837 6835 2160 34817 2160 4202560 24647 0 0 0 268 7 0 0 16 0 11 0 53294337 910823424 84707 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6852] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6852/stat : 6852 (java) S 6837 6835 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 53294337 910823424 84707 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6853] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6853/stat : 6853 (java) S 6837 6835 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 53294338 910823424 84707 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6854] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6854/stat : 6854 (java) S 6837 6835 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 53294353 910823424 84707 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6855] ppid=6837 vsize=889476 CPUtime=0.5
/proc/6849/task/6855/stat : 6855 (java) S 6837 6835 2160 34817 2160 4202560 6677 0 0 0 48 2 0 0 20 0 11 0 53294353 910823424 84707 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6856] ppid=6837 vsize=889476 CPUtime=2
/proc/6849/task/6856/stat : 6856 (java) S 6837 6835 2160 34817 2160 4202560 4882 0 8 0 198 2 0 0 16 0 11 0 53294353 910823424 84707 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6857] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6857/stat : 6857 (java) S 6837 6835 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 53294353 910823424 84707 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6858] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6858/stat : 6858 (java) R 6837 6835 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 53294353 910823424 84707 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6849/tid=6859] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6859/stat : 6859 (java) S 6837 6835 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 53294800 910823424 84707 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 24.62
Current children cumulated vsize (KiB) 894608

[startup+51.1057 s]
/proc/loadavg: 0.94 1.00 1.00 2/50 6860
/proc/meminfo: memFree=577820/1048576 swapFree=0/0
[pid=6835] ppid=6834 vsize=2564 CPUtime=0
/proc/6835/stat : 6835 (p2cudf-user-1.1) S 6834 6835 2160 34817 2160 4202496 374 0 0 0 0 0 0 0 25 0 1 0 53294298 2625536 269 1283457024 134512640 135304128 4291157600 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6835/statm: 641 269 230 194 0 28 0
[pid=6837] ppid=6835 vsize=2568 CPUtime=0.02
/proc/6837/stat : 6837 (p2cudf) S 6835 6835 2160 34817 2160 4202496 389 3014 0 1 0 0 1 1 25 0 1 0 53294298 2629632 279 1283457024 134512640 135304128 4294062416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6837/statm: 642 279 239 194 0 29 0
[pid=6849] ppid=6837 vsize=889476 CPUtime=50.17
/proc/6849/stat : 6849 (java) S 6837 6835 2160 34817 2160 4202496 88327 0 105 0 4986 31 0 0 23 0 11 0 53294301 910823424 85552 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6849/statm: 222369 85552 1783 10 0 219460 0
[pid=6849/tid=6850] ppid=6837 vsize=889476 CPUtime=42.73
/proc/6849/task/6850/stat : 6850 (java) R 6837 6835 2160 34817 2160 4202560 50277 0 15 0 4255 18 0 0 25 0 11 0 53294327 910823424 85552 1283457024 134512640 134550932 4289811424 18446744073709551615 4095899037 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6849/tid=6851] ppid=6837 vsize=889476 CPUtime=4.9
/proc/6849/task/6851/stat : 6851 (java) S 6837 6835 2160 34817 2160 4202560 25492 0 0 0 483 7 0 0 15 0 11 0 53294337 910823424 85552 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6852] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6852/stat : 6852 (java) S 6837 6835 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 53294337 910823424 85552 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6853] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6853/stat : 6853 (java) S 6837 6835 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 53294338 910823424 85552 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6854] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6854/stat : 6854 (java) S 6837 6835 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 53294353 910823424 85552 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6855] ppid=6837 vsize=889476 CPUtime=0.5
/proc/6849/task/6855/stat : 6855 (java) S 6837 6835 2160 34817 2160 4202560 6677 0 0 0 48 2 0 0 20 0 11 0 53294353 910823424 85552 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6856] ppid=6837 vsize=889476 CPUtime=2
/proc/6849/task/6856/stat : 6856 (java) S 6837 6835 2160 34817 2160 4202560 4882 0 8 0 198 2 0 0 16 0 11 0 53294353 910823424 85552 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6857] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6857/stat : 6857 (java) S 6837 6835 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 53294353 910823424 85552 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6858] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6858/stat : 6858 (java) S 6837 6835 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 53294353 910823424 85552 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6859] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6859/stat : 6859 (java) S 6837 6835 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 53294800 910823424 85552 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 50.19
Current children cumulated vsize (KiB) 894608

[startup+102.307 s]
/proc/loadavg: 1.18 1.05 1.01 2/49 6860
/proc/meminfo: memFree=576984/1048576 swapFree=0/0
[pid=6835] ppid=6834 vsize=2564 CPUtime=0
/proc/6835/stat : 6835 (p2cudf-user-1.1) S 6834 6835 2160 34817 2160 4202496 374 0 0 0 0 0 0 0 25 0 1 0 53294298 2625536 269 1283457024 134512640 135304128 4291157600 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6835/statm: 641 269 230 194 0 28 0
[pid=6837] ppid=6835 vsize=2568 CPUtime=0.02
/proc/6837/stat : 6837 (p2cudf) S 6835 6835 2160 34817 2160 4202496 389 3014 0 1 0 0 1 1 25 0 1 0 53294298 2629632 279 1283457024 134512640 135304128 4294062416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6837/statm: 642 279 239 194 0 29 0
[pid=6849] ppid=6837 vsize=889476 CPUtime=101.33
/proc/6849/stat : 6849 (java) S 6837 6835 2160 34817 2160 4202496 88327 0 105 0 10102 31 0 0 23 0 11 0 53294301 910823424 85552 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6849/statm: 222369 85552 1783 10 0 219460 0
[pid=6849/tid=6850] ppid=6837 vsize=889476 CPUtime=89.65
/proc/6849/task/6850/stat : 6850 (java) R 6837 6835 2160 34817 2160 4202560 50277 0 15 0 8947 18 0 0 25 0 11 0 53294327 910823424 85552 1283457024 134512640 134550932 4289811424 18446744073709551615 4095812416 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6849/tid=6851] ppid=6837 vsize=889476 CPUtime=9.14
/proc/6849/task/6851/stat : 6851 (java) S 6837 6835 2160 34817 2160 4202560 25492 0 0 0 907 7 0 0 15 0 11 0 53294337 910823424 85552 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6852] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6852/stat : 6852 (java) S 6837 6835 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 53294337 910823424 85552 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6853] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6853/stat : 6853 (java) S 6837 6835 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 53294338 910823424 85552 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6854] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6854/stat : 6854 (java) S 6837 6835 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 53294353 910823424 85552 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6855] ppid=6837 vsize=889476 CPUtime=0.5
/proc/6849/task/6855/stat : 6855 (java) S 6837 6835 2160 34817 2160 4202560 6677 0 0 0 48 2 0 0 20 0 11 0 53294353 910823424 85552 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6856] ppid=6837 vsize=889476 CPUtime=2
/proc/6849/task/6856/stat : 6856 (java) S 6837 6835 2160 34817 2160 4202560 4882 0 8 0 198 2 0 0 16 0 11 0 53294353 910823424 85552 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6857] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6857/stat : 6857 (java) S 6837 6835 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 53294353 910823424 85552 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6858] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6858/stat : 6858 (java) S 6837 6835 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 53294353 910823424 85552 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6859] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6859/stat : 6859 (java) S 6837 6835 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 53294800 910823424 85552 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 101.35
Current children cumulated vsize (KiB) 894608

[startup+162.31 s]
/proc/loadavg: 1.15 1.05 1.01 2/49 6860
/proc/meminfo: memFree=575372/1048576 swapFree=0/0
[pid=6835] ppid=6834 vsize=2564 CPUtime=0
/proc/6835/stat : 6835 (p2cudf-user-1.1) S 6834 6835 2160 34817 2160 4202496 374 0 0 0 0 0 0 0 25 0 1 0 53294298 2625536 269 1283457024 134512640 135304128 4291157600 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6835/statm: 641 269 230 194 0 28 0
[pid=6837] ppid=6835 vsize=2568 CPUtime=0.02
/proc/6837/stat : 6837 (p2cudf) S 6835 6835 2160 34817 2160 4202496 389 3014 0 1 0 0 1 1 25 0 1 0 53294298 2629632 279 1283457024 134512640 135304128 4294062416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6837/statm: 642 279 239 194 0 29 0
[pid=6849] ppid=6837 vsize=889476 CPUtime=161.21
/proc/6849/stat : 6849 (java) S 6837 6835 2160 34817 2160 4202496 88687 0 105 0 16089 32 0 0 23 0 11 0 53294301 910823424 85912 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6849/statm: 222369 85912 1783 10 0 219460 0
[pid=6849/tid=6850] ppid=6837 vsize=889476 CPUtime=144.74
/proc/6849/task/6850/stat : 6850 (java) R 6837 6835 2160 34817 2160 4202560 50277 0 15 0 14456 18 0 0 25 0 11 0 53294327 910823424 85912 1283457024 134512640 134550932 4289811424 18446744073709551615 4095886164 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6849/tid=6851] ppid=6837 vsize=889476 CPUtime=13.93
/proc/6849/task/6851/stat : 6851 (java) S 6837 6835 2160 34817 2160 4202560 25852 0 0 0 1385 8 0 0 15 0 11 0 53294337 910823424 85912 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6852] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6852/stat : 6852 (java) S 6837 6835 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 53294337 910823424 85912 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6853] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6853/stat : 6853 (java) S 6837 6835 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 53294338 910823424 85912 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6854] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6854/stat : 6854 (java) S 6837 6835 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 53294353 910823424 85912 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6855] ppid=6837 vsize=889476 CPUtime=0.5
/proc/6849/task/6855/stat : 6855 (java) S 6837 6835 2160 34817 2160 4202560 6677 0 0 0 48 2 0 0 20 0 11 0 53294353 910823424 85912 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6856] ppid=6837 vsize=889476 CPUtime=2
/proc/6849/task/6856/stat : 6856 (java) S 6837 6835 2160 34817 2160 4202560 4882 0 8 0 198 2 0 0 16 0 11 0 53294353 910823424 85912 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6857] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6857/stat : 6857 (java) S 6837 6835 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 53294353 910823424 85912 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6858] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6858/stat : 6858 (java) S 6837 6835 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 53294353 910823424 85912 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6859] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6859/stat : 6859 (java) S 6837 6835 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 53294800 910823424 85912 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 161.23
Current children cumulated vsize (KiB) 894608

[startup+222.312 s]
/proc/loadavg: 1.10 1.06 1.01 2/49 6864
/proc/meminfo: memFree=573952/1048576 swapFree=0/0
[pid=6835] ppid=6834 vsize=2564 CPUtime=0
/proc/6835/stat : 6835 (p2cudf-user-1.1) S 6834 6835 2160 34817 2160 4202496 374 0 0 0 0 0 0 0 25 0 1 0 53294298 2625536 269 1283457024 134512640 135304128 4291157600 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6835/statm: 641 269 230 194 0 28 0
[pid=6837] ppid=6835 vsize=2568 CPUtime=0.02
/proc/6837/stat : 6837 (p2cudf) S 6835 6835 2160 34817 2160 4202496 389 3014 0 1 0 0 1 1 25 0 1 0 53294298 2629632 279 1283457024 134512640 135304128 4294062416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6837/statm: 642 279 239 194 0 29 0
[pid=6849] ppid=6837 vsize=889476 CPUtime=221.16
/proc/6849/stat : 6849 (java) S 6837 6835 2160 34817 2160 4202496 88963 0 105 0 22084 32 0 0 23 0 11 0 53294301 910823424 86188 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6849/statm: 222369 86188 1783 10 0 219460 0
[pid=6849/tid=6850] ppid=6837 vsize=889476 CPUtime=199.31
/proc/6849/task/6850/stat : 6850 (java) R 6837 6835 2160 34817 2160 4202560 50277 0 15 0 19913 18 0 0 25 0 11 0 53294327 910823424 86188 1283457024 134512640 134550932 4289811424 18446744073709551615 4095898940 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6849/tid=6851] ppid=6837 vsize=889476 CPUtime=19.3
/proc/6849/task/6851/stat : 6851 (java) S 6837 6835 2160 34817 2160 4202560 26128 0 0 0 1922 8 0 0 16 0 11 0 53294337 910823424 86188 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6852] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6852/stat : 6852 (java) S 6837 6835 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 53294337 910823424 86188 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6853] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6853/stat : 6853 (java) S 6837 6835 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 53294338 910823424 86188 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6854] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6854/stat : 6854 (java) S 6837 6835 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 53294353 910823424 86188 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6855] ppid=6837 vsize=889476 CPUtime=0.5
/proc/6849/task/6855/stat : 6855 (java) S 6837 6835 2160 34817 2160 4202560 6677 0 0 0 48 2 0 0 20 0 11 0 53294353 910823424 86188 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6856] ppid=6837 vsize=889476 CPUtime=2.02
/proc/6849/task/6856/stat : 6856 (java) S 6837 6835 2160 34817 2160 4202560 4882 0 8 0 200 2 0 0 15 0 11 0 53294353 910823424 86188 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6857] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6857/stat : 6857 (java) S 6837 6835 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 53294353 910823424 86188 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6858] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6858/stat : 6858 (java) S 6837 6835 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 53294353 910823424 86188 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6859] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6859/stat : 6859 (java) S 6837 6835 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 53294800 910823424 86188 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 221.18
Current children cumulated vsize (KiB) 894608

[startup+282.305 s]
/proc/loadavg: 1.07 1.06 1.01 2/49 6864
/proc/meminfo: memFree=572216/1048576 swapFree=0/0
[pid=6835] ppid=6834 vsize=2564 CPUtime=0
/proc/6835/stat : 6835 (p2cudf-user-1.1) S 6834 6835 2160 34817 2160 4202496 374 0 0 0 0 0 0 0 25 0 1 0 53294298 2625536 269 1283457024 134512640 135304128 4291157600 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6835/statm: 641 269 230 194 0 28 0
[pid=6837] ppid=6835 vsize=2568 CPUtime=0.02
/proc/6837/stat : 6837 (p2cudf) S 6835 6835 2160 34817 2160 4202496 389 3014 0 1 0 0 1 1 25 0 1 0 53294298 2629632 279 1283457024 134512640 135304128 4294062416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6837/statm: 642 279 239 194 0 29 0
[pid=6849] ppid=6837 vsize=889476 CPUtime=281.14
/proc/6849/stat : 6849 (java) S 6837 6835 2160 34817 2160 4202496 89374 0 105 0 28079 35 0 0 23 0 11 0 53294301 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6849/statm: 222369 86599 1783 10 0 219460 0
[pid=6849/tid=6850] ppid=6837 vsize=889476 CPUtime=254.5
/proc/6849/task/6850/stat : 6850 (java) R 6837 6835 2160 34817 2160 4202560 50277 0 15 0 25429 21 0 0 25 0 11 0 53294327 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4095899157 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6849/tid=6851] ppid=6837 vsize=889476 CPUtime=24.08
/proc/6849/task/6851/stat : 6851 (java) S 6837 6835 2160 34817 2160 4202560 26539 0 0 0 2400 8 0 0 15 0 11 0 53294337 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6852] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6852/stat : 6852 (java) S 6837 6835 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 53294337 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6853] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6853/stat : 6853 (java) S 6837 6835 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 53294338 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6854] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6854/stat : 6854 (java) S 6837 6835 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 53294353 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6855] ppid=6837 vsize=889476 CPUtime=0.5
/proc/6849/task/6855/stat : 6855 (java) S 6837 6835 2160 34817 2160 4202560 6677 0 0 0 48 2 0 0 20 0 11 0 53294353 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6856] ppid=6837 vsize=889476 CPUtime=2.02
/proc/6849/task/6856/stat : 6856 (java) S 6837 6835 2160 34817 2160 4202560 4882 0 8 0 200 2 0 0 15 0 11 0 53294353 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6857] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6857/stat : 6857 (java) S 6837 6835 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 53294353 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6858] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6858/stat : 6858 (java) S 6837 6835 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 53294353 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6859] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6859/stat : 6859 (java) S 6837 6835 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 53294800 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 281.16
Current children cumulated vsize (KiB) 894608

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

[startup+283.106 s]
/proc/loadavg: 1.07 1.06 1.01 2/49 6864
/proc/meminfo: memFree=572216/1048576 swapFree=0/0
[pid=6835] ppid=6834 vsize=2564 CPUtime=0
/proc/6835/stat : 6835 (p2cudf-user-1.1) S 6834 6835 2160 34817 2160 4202496 374 0 0 0 0 0 0 0 25 0 1 0 53294298 2625536 269 1283457024 134512640 135304128 4291157600 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6835/statm: 641 269 230 194 0 28 0
[pid=6837] ppid=6835 vsize=2568 CPUtime=0.02
/proc/6837/stat : 6837 (p2cudf) S 6835 6835 2160 34817 2160 4202496 389 3014 0 1 0 0 1 1 25 0 1 0 53294298 2629632 279 1283457024 134512640 135304128 4294062416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6837/statm: 642 279 239 194 0 29 0
[pid=6849] ppid=6837 vsize=889476 CPUtime=281.94
/proc/6849/stat : 6849 (java) S 6837 6835 2160 34817 2160 4202496 89374 0 105 0 28159 35 0 0 23 0 11 0 53294301 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6849/statm: 222369 86599 1783 10 0 219460 0
[pid=6849/tid=6850] ppid=6837 vsize=889476 CPUtime=255.3
/proc/6849/task/6850/stat : 6850 (java) R 6837 6835 2160 34817 2160 4202560 50277 0 15 0 25509 21 0 0 25 0 11 0 53294327 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4095902654 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6849/tid=6851] ppid=6837 vsize=889476 CPUtime=24.08
/proc/6849/task/6851/stat : 6851 (java) S 6837 6835 2160 34817 2160 4202560 26539 0 0 0 2400 8 0 0 15 0 11 0 53294337 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6852] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6852/stat : 6852 (java) S 6837 6835 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 53294337 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6853] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6853/stat : 6853 (java) S 6837 6835 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 53294338 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6854] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6854/stat : 6854 (java) S 6837 6835 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 53294353 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6855] ppid=6837 vsize=889476 CPUtime=0.5
/proc/6849/task/6855/stat : 6855 (java) S 6837 6835 2160 34817 2160 4202560 6677 0 0 0 48 2 0 0 20 0 11 0 53294353 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6856] ppid=6837 vsize=889476 CPUtime=2.02
/proc/6849/task/6856/stat : 6856 (java) S 6837 6835 2160 34817 2160 4202560 4882 0 8 0 200 2 0 0 15 0 11 0 53294353 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6857] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6857/stat : 6857 (java) S 6837 6835 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 53294353 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6858] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6858/stat : 6858 (java) S 6837 6835 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 53294353 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6859] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6859/stat : 6859 (java) S 6837 6835 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 53294800 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 281.96
Current children cumulated vsize (KiB) 894608

[startup+284.716 s]
/proc/loadavg: 1.07 1.06 1.01 2/49 6864
/proc/meminfo: memFree=572216/1048576 swapFree=0/0
[pid=6835] ppid=6834 vsize=2564 CPUtime=0
/proc/6835/stat : 6835 (p2cudf-user-1.1) S 6834 6835 2160 34817 2160 4202496 374 0 0 0 0 0 0 0 25 0 1 0 53294298 2625536 269 1283457024 134512640 135304128 4291157600 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6835/statm: 641 269 230 194 0 28 0
[pid=6837] ppid=6835 vsize=2568 CPUtime=0.02
/proc/6837/stat : 6837 (p2cudf) S 6835 6835 2160 34817 2160 4202496 389 3014 0 1 0 0 1 1 25 0 1 0 53294298 2629632 279 1283457024 134512640 135304128 4294062416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6837/statm: 642 279 239 194 0 29 0
[pid=6849] ppid=6837 vsize=889476 CPUtime=283.55
/proc/6849/stat : 6849 (java) S 6837 6835 2160 34817 2160 4202496 89374 0 105 0 28320 35 0 0 23 0 11 0 53294301 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6849/statm: 222369 86599 1783 10 0 219460 0
[pid=6849/tid=6850] ppid=6837 vsize=889476 CPUtime=256.64
/proc/6849/task/6850/stat : 6850 (java) R 6837 6835 2160 34817 2160 4202560 50277 0 15 0 25643 21 0 0 25 0 11 0 53294327 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4095898972 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6849/tid=6851] ppid=6837 vsize=889476 CPUtime=24.35
/proc/6849/task/6851/stat : 6851 (java) S 6837 6835 2160 34817 2160 4202560 26539 0 0 0 2427 8 0 0 16 0 11 0 53294337 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6852] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6852/stat : 6852 (java) S 6837 6835 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 53294337 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6853] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6853/stat : 6853 (java) S 6837 6835 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 53294338 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6854] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6854/stat : 6854 (java) S 6837 6835 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 53294353 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6855] ppid=6837 vsize=889476 CPUtime=0.5
/proc/6849/task/6855/stat : 6855 (java) S 6837 6835 2160 34817 2160 4202560 6677 0 0 0 48 2 0 0 20 0 11 0 53294353 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6856] ppid=6837 vsize=889476 CPUtime=2.02
/proc/6849/task/6856/stat : 6856 (java) S 6837 6835 2160 34817 2160 4202560 4882 0 8 0 200 2 0 0 15 0 11 0 53294353 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6857] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6857/stat : 6857 (java) S 6837 6835 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 53294353 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6858] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6858/stat : 6858 (java) R 6837 6835 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 53294353 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6849/tid=6859] ppid=6837 vsize=889476 CPUtime=0
/proc/6849/task/6859/stat : 6859 (java) S 6837 6835 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 53294800 910823424 86599 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.57
Current children cumulated vsize (KiB) 894608

[startup+285.508 s]
/proc/loadavg: 1.07 1.06 1.01 2/49 6864
/proc/meminfo: memFree=572216/1048576 swapFree=0/0
[pid=6835] ppid=6834 vsize=2564 CPUtime=0
/proc/6835/stat : 6835 (p2cudf-user-1.1) S 6834 6835 2160 34817 2160 4202496 374 0 0 0 0 0 0 0 25 0 1 0 53294298 2625536 269 1283457024 134512640 135304128 4291157600 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6835/statm: 641 269 230 194 0 28 0
[pid=6837] ppid=6835 vsize=2568 CPUtime=0.02
/proc/6837/stat : 6837 (p2cudf) S 6835 6835 2160 34817 2160 4202496 389 3014 0 1 0 0 1 1 25 0 1 0 53294298 2629632 279 1283457024 134512640 135304128 4294062416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6837/statm: 642 279 239 194 0 29 0
[pid=6849] ppid=6837 vsize=889800 CPUtime=283.88
/proc/6849/stat : 6849 (java) S 6837 6835 2160 34817 2160 4202496 89387 0 105 0 28353 35 0 0 23 0 11 0 53294301 911155200 86612 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6849/statm: 222450 86612 1784 10 0 219541 0
[pid=6849/tid=6850] ppid=6837 vsize=889800 CPUtime=256.95
/proc/6849/task/6850/stat : 6850 (java) S 6837 6835 2160 34817 2160 4202560 50284 0 15 0 25674 21 0 0 25 0 11 0 53294327 911155200 86612 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6851] ppid=6837 vsize=889800 CPUtime=24.35
/proc/6849/task/6851/stat : 6851 (java) S 6837 6835 2160 34817 2160 4202560 26539 0 0 0 2427 8 0 0 16 0 11 0 53294337 911155200 86612 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6852] ppid=6837 vsize=889800 CPUtime=0
/proc/6849/task/6852/stat : 6852 (java) S 6837 6835 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 53294337 911155200 86612 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6853] ppid=6837 vsize=889800 CPUtime=0
/proc/6849/task/6853/stat : 6853 (java) S 6837 6835 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 53294338 911155200 86612 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6854] ppid=6837 vsize=889800 CPUtime=0
/proc/6849/task/6854/stat : 6854 (java) S 6837 6835 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 53294353 911155200 86612 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6855] ppid=6837 vsize=889800 CPUtime=0.5
/proc/6849/task/6855/stat : 6855 (java) S 6837 6835 2160 34817 2160 4202560 6677 0 0 0 48 2 0 0 20 0 11 0 53294353 911155200 86612 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6856] ppid=6837 vsize=889800 CPUtime=2.04
/proc/6849/task/6856/stat : 6856 (java) S 6837 6835 2160 34817 2160 4202560 4882 0 8 0 202 2 0 0 15 0 11 0 53294353 911155200 86612 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6857] ppid=6837 vsize=889800 CPUtime=0
/proc/6849/task/6857/stat : 6857 (java) S 6837 6835 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 53294353 911155200 86612 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=6849/tid=6858] ppid=6837 vsize=889800 CPUtime=0
/proc/6849/task/6858/stat : 6858 (java) S 6837 6835 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 53294353 911155200 86612 1283457024 134512640 134550932 4289811424 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.9
Current children cumulated vsize (KiB) 894932

[startup+285.716 s]
/proc/loadavg: 1.07 1.06 1.01 2/49 6864
/proc/meminfo: memFree=572216/1048576 swapFree=0/0
[pid=6835] ppid=6834 vsize=2564 CPUtime=0
/proc/6835/stat : 6835 (p2cudf-user-1.1) S 6834 6835 2160 34817 2160 4202496 374 0 0 0 0 0 0 0 25 0 1 0 53294298 2625536 269 1283457024 134512640 135304128 4291157600 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6835/statm: 641 269 230 194 0 28 0
[pid=6837] ppid=6835 vsize=2568 CPUtime=284
/proc/6837/stat : 6837 (p2cudf) R 6835 6835 2160 34817 2160 4202496 390 92408 0 106 0 0 28358 42 18 0 1 0 53294298 2629632 279 1283457024 134512640 135304128 4294062416 18446744073709551615 4159415760 0 65536 4 65538 0 0 0 17 0 0 0 0
/proc/6837/statm: 642 279 239 194 0 29 0
Current children cumulated CPU time (s) 284
Current children cumulated vsize (KiB) 5132

Child status: 0
Real time (s): 285.716
CPU time (s): 284.014
CPU user time (s): 283.59
CPU system time (s): 0.424026
CPU usage (%): 99.4041
Max. virtual memory (cumulated for all children) (KiB): 897008

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 283.59
system time used= 0.424026
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 93191
page faults= 106
swaps= 0
block input operations= 0
block output operations= 0
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 6578
involuntary context switches= 8975

runsolver used 0 second user time and 0.004 second system time

The end