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/8afdd89e-51b8-11e0-acd7-00163e1e087d.cudf.dudf-real.log.runsolver ./p2cudf-user-1.13 /home/misc2010/data/2011/dudf-real//8afdd89e-51b8-11e0-acd7-00163e1e087d.cudf /home/misc2010/tmp/201108300820/p2cudf-user-1.13/8afdd89e-51b8-11e0-acd7-00163e1e087d.cudf.dudf-real.result +sum(installedsize) 

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


[startup+0 s]
/proc/loadavg: 0.85 0.97 0.99 1/33 13958
/proc/meminfo: memFree=941232/1048576 swapFree=0/0
[pid=13958] ppid=13957 vsize=3024 CPUtime=0
/proc/13958/stat : 13958 (runsolver) D 13957 13958 2160 34817 2160 4202560 73 0 0 0 0 0 0 0 25 0 1 0 57119050 3096576 94 1283457024 134512640 134586868 4289270672 18446744073709551615 4294960130 0 0 0 24578 18446744071564332000 0 0 17 0 0 0 0
/proc/13958/statm: 756 94 62 19 0 55 0

[startup+0.14036 s]
/proc/loadavg: 0.85 0.97 0.99 1/33 13958
/proc/meminfo: memFree=941232/1048576 swapFree=0/0
[pid=13958] ppid=13957 vsize=2568 CPUtime=0
/proc/13958/stat : 13958 (p2cudf-user-1.1) S 13957 13958 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 57119050 2629632 270 1283457024 134512640 135304128 4287972128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13958/statm: 642 270 230 194 0 29 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2568

[startup+0.204341 s]
/proc/loadavg: 0.85 0.97 0.99 1/33 13958
/proc/meminfo: memFree=941232/1048576 swapFree=0/0
[pid=13958] ppid=13957 vsize=2568 CPUtime=0
/proc/13958/stat : 13958 (p2cudf-user-1.1) S 13957 13958 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 57119050 2629632 270 1283457024 134512640 135304128 4287972128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13958/statm: 642 270 230 194 0 29 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2568

[startup+0.304369 s]
/proc/loadavg: 0.85 0.97 0.99 1/33 13958
/proc/meminfo: memFree=941232/1048576 swapFree=0/0
[pid=13958] ppid=13957 vsize=2568 CPUtime=0
/proc/13958/stat : 13958 (p2cudf-user-1.1) S 13957 13958 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 57119050 2629632 270 1283457024 134512640 135304128 4287972128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13958/statm: 642 270 230 194 0 29 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2568

[startup+0.704378 s]
/proc/loadavg: 0.85 0.97 0.99 1/33 13958
/proc/meminfo: memFree=941232/1048576 swapFree=0/0
[pid=13958] ppid=13957 vsize=2568 CPUtime=0
/proc/13958/stat : 13958 (p2cudf-user-1.1) S 13957 13958 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 57119050 2629632 270 1283457024 134512640 135304128 4287972128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13958/statm: 642 270 230 194 0 29 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2568

[startup+1.50902 s]
/proc/loadavg: 0.86 0.97 0.99 4/45 13981
/proc/meminfo: memFree=908076/1048576 swapFree=0/0
[pid=13958] ppid=13957 vsize=2568 CPUtime=0
/proc/13958/stat : 13958 (p2cudf-user-1.1) S 13957 13958 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 57119050 2629632 270 1283457024 134512640 135304128 4287972128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13958/statm: 642 270 230 194 0 29 0
[pid=13960] ppid=13958 vsize=2568 CPUtime=0.02
/proc/13960/stat : 13960 (p2cudf) S 13958 13958 2160 34817 2160 4202496 387 3015 0 1 0 0 2 0 25 0 1 0 57119051 2629632 279 1283457024 134512640 135304128 4290354576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13960/statm: 642 279 239 194 0 29 0
[pid=13972] ppid=13960 vsize=886884 CPUtime=0.88
/proc/13972/stat : 13972 (java) S 13960 13958 2160 34817 2160 4202496 16229 0 106 0 86 2 0 0 23 0 10 0 57119054 908169216 13785 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/13972/statm: 221721 13785 1728 10 0 218812 0
[pid=13972/tid=13973] ppid=13960 vsize=886884 CPUtime=0.35
/proc/13972/task/13973/stat : 13973 (java) R 13960 13958 2160 34817 2160 4202560 5592 0 15 0 34 1 0 0 25 0 10 0 57119081 908169216 13785 1283457024 134512640 134550932 4294383632 18446744073709551615 4149490912 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=13972/tid=13974] ppid=13960 vsize=886884 CPUtime=0
/proc/13972/task/13974/stat : 13974 (java) S 13960 13958 2160 34817 2160 4202560 7 0 0 0 0 0 0 0 18 0 10 0 57119090 908169216 13785 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13975] ppid=13960 vsize=886884 CPUtime=0
/proc/13972/task/13975/stat : 13975 (java) S 13960 13958 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 25 0 10 0 57119091 908169216 13785 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13976] ppid=13960 vsize=886884 CPUtime=0
/proc/13972/task/13976/stat : 13976 (java) S 13960 13958 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 10 0 57119091 908169216 13785 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13977] ppid=13960 vsize=886884 CPUtime=0
/proc/13972/task/13977/stat : 13977 (java) S 13960 13958 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 57119101 908169216 13785 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13978] ppid=13960 vsize=886884 CPUtime=0.3
/proc/13972/task/13978/stat : 13978 (java) R 13960 13958 2160 34817 2160 4202560 5648 0 1 0 29 1 0 0 22 0 10 0 57119101 908169216 13785 1283457024 134512640 134550932 4294383632 18446744073709551615 4152768141 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=13972/tid=13979] ppid=13960 vsize=886884 CPUtime=0.22
/proc/13972/task/13979/stat : 13979 (java) R 13960 13958 2160 34817 2160 4202560 3991 0 8 0 22 0 0 0 25 0 10 0 57119101 908169216 13785 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=13972/tid=13980] ppid=13960 vsize=886884 CPUtime=0
/proc/13972/task/13980/stat : 13980 (java) S 13960 13958 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 57119101 908169216 13785 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13981] ppid=13960 vsize=886884 CPUtime=0
/proc/13972/task/13981/stat : 13981 (java) S 13960 13958 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 16 0 10 0 57119101 908169216 13785 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 0.9
Current children cumulated vsize (KiB) 892020

[startup+3.11362 s]
/proc/loadavg: 0.86 0.97 0.99 2/45 13981
/proc/meminfo: memFree=810736/1048576 swapFree=0/0
[pid=13958] ppid=13957 vsize=2568 CPUtime=0
/proc/13958/stat : 13958 (p2cudf-user-1.1) S 13957 13958 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 57119050 2629632 270 1283457024 134512640 135304128 4287972128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13958/statm: 642 270 230 194 0 29 0
[pid=13960] ppid=13958 vsize=2568 CPUtime=0.02
/proc/13960/stat : 13960 (p2cudf) S 13958 13958 2160 34817 2160 4202496 387 3015 0 1 0 0 2 0 25 0 1 0 57119051 2629632 279 1283457024 134512640 135304128 4290354576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13960/statm: 642 279 239 194 0 29 0
[pid=13972] ppid=13960 vsize=885396 CPUtime=2.45
/proc/13972/stat : 13972 (java) S 13960 13958 2160 34817 2160 4202496 59774 0 106 0 221 24 0 0 23 0 10 0 57119054 906645504 56971 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/13972/statm: 221349 56971 1751 10 0 218440 0
[pid=13972/tid=13973] ppid=13960 vsize=885396 CPUtime=1.39
/proc/13972/task/13973/stat : 13973 (java) R 13960 13958 2160 34817 2160 4202560 48483 0 15 0 116 23 0 0 25 0 10 0 57119081 906645504 56971 1283457024 134512640 134550932 4294383632 18446744073709551615 4095941869 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=13972/tid=13974] ppid=13960 vsize=885396 CPUtime=0
/proc/13972/task/13974/stat : 13974 (java) S 13960 13958 2160 34817 2160 4202560 7 0 0 0 0 0 0 0 18 0 10 0 57119090 906645504 56971 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13975] ppid=13960 vsize=885396 CPUtime=0
/proc/13972/task/13975/stat : 13975 (java) S 13960 13958 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 25 0 10 0 57119091 906645504 56971 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13976] ppid=13960 vsize=885396 CPUtime=0
/proc/13972/task/13976/stat : 13976 (java) S 13960 13958 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 10 0 57119091 906645504 56971 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13977] ppid=13960 vsize=885396 CPUtime=0
/proc/13972/task/13977/stat : 13977 (java) S 13960 13958 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 57119101 906645504 56971 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13978] ppid=13960 vsize=885396 CPUtime=0.41
/proc/13972/task/13978/stat : 13978 (java) S 13960 13958 2160 34817 2160 4202560 6038 0 1 0 40 1 0 0 20 0 10 0 57119101 906645504 56971 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13979] ppid=13960 vsize=885396 CPUtime=0.64
/proc/13972/task/13979/stat : 13979 (java) S 13960 13958 2160 34817 2160 4202560 4255 0 8 0 64 0 0 0 18 0 10 0 57119101 906645504 56971 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13980] ppid=13960 vsize=885396 CPUtime=0
/proc/13972/task/13980/stat : 13980 (java) S 13960 13958 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 57119101 906645504 56971 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13981] ppid=13960 vsize=885396 CPUtime=0
/proc/13972/task/13981/stat : 13981 (java) S 13960 13958 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 10 0 57119101 906645504 56971 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 2.47
Current children cumulated vsize (KiB) 890532
heavy processes:

[startup+6.3117 s]
/proc/loadavg: 0.87 0.97 0.99 2/46 13982
/proc/meminfo: memFree=656000/1048576 swapFree=0/0
[pid=13958] ppid=13957 vsize=2568 CPUtime=0
/proc/13958/stat : 13958 (p2cudf-user-1.1) S 13957 13958 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 57119050 2629632 270 1283457024 134512640 135304128 4287972128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13958/statm: 642 270 230 194 0 29 0
[pid=13960] ppid=13958 vsize=2568 CPUtime=0.02
/proc/13960/stat : 13960 (p2cudf) S 13958 13958 2160 34817 2160 4202496 387 3015 0 1 0 0 2 0 25 0 1 0 57119051 2629632 279 1283457024 134512640 135304128 4290354576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13960/statm: 642 279 239 194 0 29 0
[pid=13972] ppid=13960 vsize=885720 CPUtime=5.5
/proc/13972/stat : 13972 (java) S 13960 13958 2160 34817 2160 4202496 73848 0 107 0 520 30 0 0 23 0 11 0 57119054 906977280 70346 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/13972/statm: 221430 70346 1781 10 0 218521 0
[pid=13972/tid=13973] ppid=13960 vsize=885720 CPUtime=3.11
/proc/13972/task/13973/stat : 13973 (java) R 13960 13958 2160 34817 2160 4202560 50275 0 15 0 286 25 0 0 25 0 11 0 57119081 906977280 70346 1283457024 134512640 134550932 4294383632 18446744073709551615 4096293307 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=13972/tid=13974] ppid=13960 vsize=885720 CPUtime=0.26
/proc/13972/task/13974/stat : 13974 (java) S 13960 13958 2160 34817 2160 4202560 11255 0 0 0 24 2 0 0 16 0 11 0 57119090 906977280 70346 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13975] ppid=13960 vsize=885720 CPUtime=0
/proc/13972/task/13975/stat : 13975 (java) S 13960 13958 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 57119091 906977280 70346 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13976] ppid=13960 vsize=885720 CPUtime=0
/proc/13972/task/13976/stat : 13976 (java) S 13960 13958 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 57119091 906977280 70346 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13977] ppid=13960 vsize=885720 CPUtime=0
/proc/13972/task/13977/stat : 13977 (java) S 13960 13958 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57119101 906977280 70346 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13978] ppid=13960 vsize=885720 CPUtime=0.42
/proc/13972/task/13978/stat : 13978 (java) S 13960 13958 2160 34817 2160 4202560 6038 0 1 0 41 1 0 0 18 0 11 0 57119101 906977280 70346 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13979] ppid=13960 vsize=885720 CPUtime=1.7
/proc/13972/task/13979/stat : 13979 (java) S 13960 13958 2160 34817 2160 4202560 5282 0 9 0 168 2 0 0 15 0 11 0 57119101 906977280 70346 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13980] ppid=13960 vsize=885720 CPUtime=0
/proc/13972/task/13980/stat : 13980 (java) S 13960 13958 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57119101 906977280 70346 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13981] ppid=13960 vsize=885720 CPUtime=0
/proc/13972/task/13981/stat : 13981 (java) S 13960 13958 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 57119101 906977280 70346 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13982] ppid=13960 vsize=885720 CPUtime=0
/proc/13972/task/13982/stat : 13982 (java) S 13960 13958 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 57119506 906977280 70346 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 5.52
Current children cumulated vsize (KiB) 890856

[startup+12.7029 s]
/proc/loadavg: 0.88 0.97 0.99 2/46 13982
/proc/meminfo: memFree=617072/1048576 swapFree=0/0
[pid=13958] ppid=13957 vsize=2568 CPUtime=0
/proc/13958/stat : 13958 (p2cudf-user-1.1) S 13957 13958 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 57119050 2629632 270 1283457024 134512640 135304128 4287972128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13958/statm: 642 270 230 194 0 29 0
[pid=13960] ppid=13958 vsize=2568 CPUtime=0.02
/proc/13960/stat : 13960 (p2cudf) S 13958 13958 2160 34817 2160 4202496 387 3015 0 1 0 0 2 0 25 0 1 0 57119051 2629632 279 1283457024 134512640 135304128 4290354576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13960/statm: 642 279 239 194 0 29 0
[pid=13972] ppid=13960 vsize=881360 CPUtime=11.89
/proc/13972/stat : 13972 (java) S 13960 13958 2160 34817 2160 4202496 84535 0 107 0 1158 31 0 0 23 0 11 0 57119054 902512640 80013 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/13972/statm: 220340 80013 1786 10 0 217431 0
[pid=13972/tid=13973] ppid=13960 vsize=881360 CPUtime=8.69
/proc/13972/task/13973/stat : 13973 (java) R 13960 13958 2160 34817 2160 4202560 50276 0 15 0 844 25 0 0 25 0 11 0 57119081 902512640 80013 1283457024 134512640 134550932 4294383632 18446744073709551615 4096300005 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=13972/tid=13974] ppid=13960 vsize=881360 CPUtime=0.95
/proc/13972/task/13974/stat : 13974 (java) S 13960 13958 2160 34817 2160 4202560 21920 0 0 0 92 3 0 0 15 0 11 0 57119090 902512640 80013 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13975] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13975/stat : 13975 (java) S 13960 13958 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 57119091 902512640 80013 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13976] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13976/stat : 13976 (java) S 13960 13958 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 57119091 902512640 80013 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13977] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13977/stat : 13977 (java) S 13960 13958 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57119101 902512640 80013 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13978] ppid=13960 vsize=881360 CPUtime=0.42
/proc/13972/task/13978/stat : 13978 (java) S 13960 13958 2160 34817 2160 4202560 6038 0 1 0 41 1 0 0 18 0 11 0 57119101 902512640 80013 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13979] ppid=13960 vsize=881360 CPUtime=1.82
/proc/13972/task/13979/stat : 13979 (java) S 13960 13958 2160 34817 2160 4202560 5303 0 9 0 180 2 0 0 15 0 11 0 57119101 902512640 80013 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13980] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13980/stat : 13980 (java) S 13960 13958 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57119101 902512640 80013 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13981] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13981/stat : 13981 (java) S 13960 13958 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 57119101 902512640 80013 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13982] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13982/stat : 13982 (java) S 13960 13958 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 57119506 902512640 80013 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 11.91
Current children cumulated vsize (KiB) 886496

[startup+25.5073 s]
/proc/loadavg: 0.98 0.99 0.99 2/46 13982
/proc/meminfo: memFree=608888/1048576 swapFree=0/0
[pid=13958] ppid=13957 vsize=2568 CPUtime=0
/proc/13958/stat : 13958 (p2cudf-user-1.1) S 13957 13958 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 57119050 2629632 270 1283457024 134512640 135304128 4287972128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13958/statm: 642 270 230 194 0 29 0
[pid=13960] ppid=13958 vsize=2568 CPUtime=0.02
/proc/13960/stat : 13960 (p2cudf) S 13958 13958 2160 34817 2160 4202496 387 3015 0 1 0 0 2 0 25 0 1 0 57119051 2629632 279 1283457024 134512640 135304128 4290354576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13960/statm: 642 279 239 194 0 29 0
[pid=13972] ppid=13960 vsize=881360 CPUtime=24.69
/proc/13972/stat : 13972 (java) S 13960 13958 2160 34817 2160 4202496 86559 0 107 0 2436 33 0 0 23 0 11 0 57119054 902512640 82037 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/13972/statm: 220340 82037 1788 10 0 217431 0
[pid=13972/tid=13973] ppid=13960 vsize=881360 CPUtime=20.57
/proc/13972/task/13973/stat : 13973 (java) R 13960 13958 2160 34817 2160 4202560 50276 0 15 0 2032 25 0 0 25 0 11 0 57119081 902512640 82037 1283457024 134512640 134550932 4294383632 18446744073709551615 4096237857 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=13972/tid=13974] ppid=13960 vsize=881360 CPUtime=1.8
/proc/13972/task/13974/stat : 13974 (java) S 13960 13958 2160 34817 2160 4202560 23931 0 0 0 175 5 0 0 15 0 11 0 57119090 902512640 82037 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13975] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13975/stat : 13975 (java) S 13960 13958 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 57119091 902512640 82037 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13976] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13976/stat : 13976 (java) S 13960 13958 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 57119091 902512640 82037 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13977] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13977/stat : 13977 (java) S 13960 13958 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57119101 902512640 82037 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13978] ppid=13960 vsize=881360 CPUtime=0.42
/proc/13972/task/13978/stat : 13978 (java) S 13960 13958 2160 34817 2160 4202560 6038 0 1 0 41 1 0 0 18 0 11 0 57119101 902512640 82037 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13979] ppid=13960 vsize=881360 CPUtime=1.88
/proc/13972/task/13979/stat : 13979 (java) S 13960 13958 2160 34817 2160 4202560 5316 0 9 0 186 2 0 0 15 0 11 0 57119101 902512640 82037 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13980] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13980/stat : 13980 (java) S 13960 13958 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57119101 902512640 82037 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13981] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13981/stat : 13981 (java) S 13960 13958 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 57119101 902512640 82037 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13982] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13982/stat : 13982 (java) S 13960 13958 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 57119506 902512640 82037 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 24.71
Current children cumulated vsize (KiB) 886496

[startup+51.113 s]
/proc/loadavg: 0.99 0.99 0.99 2/46 13982
/proc/meminfo: memFree=596612/1048576 swapFree=0/0
[pid=13958] ppid=13957 vsize=2568 CPUtime=0
/proc/13958/stat : 13958 (p2cudf-user-1.1) S 13957 13958 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 57119050 2629632 270 1283457024 134512640 135304128 4287972128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13958/statm: 642 270 230 194 0 29 0
[pid=13960] ppid=13958 vsize=2568 CPUtime=0.02
/proc/13960/stat : 13960 (p2cudf) S 13958 13958 2160 34817 2160 4202496 387 3015 0 1 0 0 2 0 25 0 1 0 57119051 2629632 279 1283457024 134512640 135304128 4290354576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13960/statm: 642 279 239 194 0 29 0
[pid=13972] ppid=13960 vsize=881360 CPUtime=50.27
/proc/13972/stat : 13972 (java) S 13960 13958 2160 34817 2160 4202496 89607 0 107 0 4994 33 0 0 23 0 11 0 57119054 902512640 85085 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/13972/statm: 220340 85085 1788 10 0 217431 0
[pid=13972/tid=13973] ppid=13960 vsize=881360 CPUtime=45.01
/proc/13972/task/13973/stat : 13973 (java) R 13960 13958 2160 34817 2160 4202560 50276 0 15 0 4476 25 0 0 25 0 11 0 57119081 902512640 85085 1283457024 134512640 134550932 4294383632 18446744073709551615 4096376264 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=13972/tid=13974] ppid=13960 vsize=881360 CPUtime=2.92
/proc/13972/task/13974/stat : 13974 (java) S 13960 13958 2160 34817 2160 4202560 26979 0 0 0 287 5 0 0 15 0 11 0 57119090 902512640 85085 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13975] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13975/stat : 13975 (java) S 13960 13958 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 57119091 902512640 85085 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13976] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13976/stat : 13976 (java) S 13960 13958 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 57119091 902512640 85085 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13977] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13977/stat : 13977 (java) S 13960 13958 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57119101 902512640 85085 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13978] ppid=13960 vsize=881360 CPUtime=0.42
/proc/13972/task/13978/stat : 13978 (java) S 13960 13958 2160 34817 2160 4202560 6038 0 1 0 41 1 0 0 18 0 11 0 57119101 902512640 85085 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13979] ppid=13960 vsize=881360 CPUtime=1.91
/proc/13972/task/13979/stat : 13979 (java) S 13960 13958 2160 34817 2160 4202560 5316 0 9 0 189 2 0 0 15 0 11 0 57119101 902512640 85085 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13980] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13980/stat : 13980 (java) S 13960 13958 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57119101 902512640 85085 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13981] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13981/stat : 13981 (java) S 13960 13958 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 57119101 902512640 85085 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13982] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13982/stat : 13982 (java) S 13960 13958 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 57119506 902512640 85085 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 50.29
Current children cumulated vsize (KiB) 886496

[startup+102.314 s]
/proc/loadavg: 0.99 0.99 0.99 2/46 13982
/proc/meminfo: memFree=575532/1048576 swapFree=0/0
[pid=13958] ppid=13957 vsize=2568 CPUtime=0
/proc/13958/stat : 13958 (p2cudf-user-1.1) S 13957 13958 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 57119050 2629632 270 1283457024 134512640 135304128 4287972128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13958/statm: 642 270 230 194 0 29 0
[pid=13960] ppid=13958 vsize=2568 CPUtime=0.02
/proc/13960/stat : 13960 (p2cudf) S 13958 13958 2160 34817 2160 4202496 387 3015 0 1 0 0 2 0 25 0 1 0 57119051 2629632 279 1283457024 134512640 135304128 4290354576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13960/statm: 642 279 239 194 0 29 0
[pid=13972] ppid=13960 vsize=881360 CPUtime=101.44
/proc/13972/stat : 13972 (java) S 13960 13958 2160 34817 2160 4202496 94844 0 107 0 10106 38 0 0 23 0 11 0 57119054 902512640 90322 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/13972/statm: 220340 90322 1788 10 0 217431 0
[pid=13972/tid=13973] ppid=13960 vsize=881360 CPUtime=94.61
/proc/13972/task/13973/stat : 13973 (java) R 13960 13958 2160 34817 2160 4202560 50276 0 15 0 9436 25 0 0 25 0 11 0 57119081 902512640 90322 1283457024 134512640 134550932 4294383632 18446744073709551615 4096343974 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=13972/tid=13974] ppid=13960 vsize=881360 CPUtime=4.47
/proc/13972/task/13974/stat : 13974 (java) S 13960 13958 2160 34817 2160 4202560 32216 0 0 0 438 9 0 0 15 0 11 0 57119090 902512640 90322 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13975] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13975/stat : 13975 (java) S 13960 13958 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 57119091 902512640 90322 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13976] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13976/stat : 13976 (java) S 13960 13958 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 57119091 902512640 90322 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13977] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13977/stat : 13977 (java) S 13960 13958 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57119101 902512640 90322 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13978] ppid=13960 vsize=881360 CPUtime=0.42
/proc/13972/task/13978/stat : 13978 (java) S 13960 13958 2160 34817 2160 4202560 6038 0 1 0 41 1 0 0 18 0 11 0 57119101 902512640 90322 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13979] ppid=13960 vsize=881360 CPUtime=1.91
/proc/13972/task/13979/stat : 13979 (java) S 13960 13958 2160 34817 2160 4202560 5316 0 9 0 189 2 0 0 15 0 11 0 57119101 902512640 90322 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13980] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13980/stat : 13980 (java) S 13960 13958 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57119101 902512640 90322 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13981] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13981/stat : 13981 (java) S 13960 13958 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 57119101 902512640 90322 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13982] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13982/stat : 13982 (java) S 13960 13958 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 57119506 902512640 90322 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 101.46
Current children cumulated vsize (KiB) 886496

[startup+162.316 s]
/proc/loadavg: 0.99 0.99 0.99 2/46 13982
/proc/meminfo: memFree=572928/1048576 swapFree=0/0
[pid=13958] ppid=13957 vsize=2568 CPUtime=0
/proc/13958/stat : 13958 (p2cudf-user-1.1) S 13957 13958 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 57119050 2629632 270 1283457024 134512640 135304128 4287972128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13958/statm: 642 270 230 194 0 29 0
[pid=13960] ppid=13958 vsize=2568 CPUtime=0.02
/proc/13960/stat : 13960 (p2cudf) S 13958 13958 2160 34817 2160 4202496 387 3015 0 1 0 0 2 0 25 0 1 0 57119051 2629632 279 1283457024 134512640 135304128 4290354576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13960/statm: 642 279 239 194 0 29 0
[pid=13972] ppid=13960 vsize=881360 CPUtime=161.39
/proc/13972/stat : 13972 (java) S 13960 13958 2160 34817 2160 4202496 95460 0 107 0 16101 38 0 0 23 0 11 0 57119054 902512640 90938 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/13972/statm: 220340 90938 1788 10 0 217431 0
[pid=13972/tid=13973] ppid=13960 vsize=881360 CPUtime=153.16
/proc/13972/task/13973/stat : 13973 (java) R 13960 13958 2160 34817 2160 4202560 50276 0 15 0 15290 26 0 0 25 0 11 0 57119081 902512640 90938 1283457024 134512640 134550932 4294383632 18446744073709551615 4096293259 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=13972/tid=13974] ppid=13960 vsize=881360 CPUtime=5.89
/proc/13972/task/13974/stat : 13974 (java) S 13960 13958 2160 34817 2160 4202560 32832 0 0 0 580 9 0 0 15 0 11 0 57119090 902512640 90938 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13975] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13975/stat : 13975 (java) S 13960 13958 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 57119091 902512640 90938 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13976] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13976/stat : 13976 (java) S 13960 13958 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 57119091 902512640 90938 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13977] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13977/stat : 13977 (java) S 13960 13958 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57119101 902512640 90938 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13978] ppid=13960 vsize=881360 CPUtime=0.42
/proc/13972/task/13978/stat : 13978 (java) S 13960 13958 2160 34817 2160 4202560 6038 0 1 0 41 1 0 0 18 0 11 0 57119101 902512640 90938 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13979] ppid=13960 vsize=881360 CPUtime=1.91
/proc/13972/task/13979/stat : 13979 (java) S 13960 13958 2160 34817 2160 4202560 5316 0 9 0 189 2 0 0 15 0 11 0 57119101 902512640 90938 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13980] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13980/stat : 13980 (java) S 13960 13958 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57119101 902512640 90938 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13981] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13981/stat : 13981 (java) S 13960 13958 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 57119101 902512640 90938 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13982] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13982/stat : 13982 (java) S 13960 13958 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 57119506 902512640 90938 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 161.41
Current children cumulated vsize (KiB) 886496

[startup+222.308 s]
/proc/loadavg: 0.99 0.99 0.99 2/48 13987
/proc/meminfo: memFree=547236/1048576 swapFree=0/0
[pid=13958] ppid=13957 vsize=2568 CPUtime=0
/proc/13958/stat : 13958 (p2cudf-user-1.1) S 13957 13958 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 57119050 2629632 270 1283457024 134512640 135304128 4287972128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13958/statm: 642 270 230 194 0 29 0
[pid=13960] ppid=13958 vsize=2568 CPUtime=0.02
/proc/13960/stat : 13960 (p2cudf) S 13958 13958 2160 34817 2160 4202496 387 3015 0 1 0 0 2 0 25 0 1 0 57119051 2629632 279 1283457024 134512640 135304128 4290354576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13960/statm: 642 279 239 194 0 29 0
[pid=13972] ppid=13960 vsize=881360 CPUtime=221.34
/proc/13972/stat : 13972 (java) S 13960 13958 2160 34817 2160 4202496 101826 0 107 0 22092 42 0 0 23 0 11 0 57119054 902512640 97304 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/13972/statm: 220340 97304 1788 10 0 217431 0
[pid=13972/tid=13973] ppid=13960 vsize=881360 CPUtime=211.89
/proc/13972/task/13973/stat : 13973 (java) R 13960 13958 2160 34817 2160 4202560 50276 0 15 0 21163 26 0 0 25 0 11 0 57119081 902512640 97304 1283457024 134512640 134550932 4294383632 18446744073709551615 4096337964 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=13972/tid=13974] ppid=13960 vsize=881360 CPUtime=7.1
/proc/13972/task/13974/stat : 13974 (java) S 13960 13958 2160 34817 2160 4202560 39198 0 0 0 698 12 0 0 15 0 11 0 57119090 902512640 97304 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13975] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13975/stat : 13975 (java) S 13960 13958 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 57119091 902512640 97304 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13976] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13976/stat : 13976 (java) S 13960 13958 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 57119091 902512640 97304 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13977] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13977/stat : 13977 (java) S 13960 13958 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57119101 902512640 97304 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13978] ppid=13960 vsize=881360 CPUtime=0.42
/proc/13972/task/13978/stat : 13978 (java) S 13960 13958 2160 34817 2160 4202560 6038 0 1 0 41 1 0 0 18 0 11 0 57119101 902512640 97304 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13979] ppid=13960 vsize=881360 CPUtime=1.91
/proc/13972/task/13979/stat : 13979 (java) S 13960 13958 2160 34817 2160 4202560 5316 0 9 0 189 2 0 0 15 0 11 0 57119101 902512640 97304 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13980] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13980/stat : 13980 (java) S 13960 13958 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57119101 902512640 97304 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13981] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13981/stat : 13981 (java) R 13960 13958 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 57119101 902512640 97304 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=13972/tid=13982] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13982/stat : 13982 (java) S 13960 13958 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 57119506 902512640 97304 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 221.36
Current children cumulated vsize (KiB) 886496

[startup+282.311 s]
/proc/loadavg: 0.99 0.99 0.99 3/48 13993
/proc/meminfo: memFree=544260/1048576 swapFree=0/0
[pid=13958] ppid=13957 vsize=2568 CPUtime=0
/proc/13958/stat : 13958 (p2cudf-user-1.1) S 13957 13958 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 57119050 2629632 270 1283457024 134512640 135304128 4287972128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13958/statm: 642 270 230 194 0 29 0
[pid=13960] ppid=13958 vsize=2568 CPUtime=0.02
/proc/13960/stat : 13960 (p2cudf) S 13958 13958 2160 34817 2160 4202496 387 3015 0 1 0 0 2 0 25 0 1 0 57119051 2629632 279 1283457024 134512640 135304128 4290354576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13960/statm: 642 279 239 194 0 29 0
[pid=13972] ppid=13960 vsize=881360 CPUtime=281.28
/proc/13972/stat : 13972 (java) S 13960 13958 2160 34817 2160 4202496 102537 0 107 0 28086 42 0 0 23 0 11 0 57119054 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/13972/statm: 220340 98015 1788 10 0 217431 0
[pid=13972/tid=13973] ppid=13960 vsize=881360 CPUtime=270.62
/proc/13972/task/13973/stat : 13973 (java) R 13960 13958 2160 34817 2160 4202560 50276 0 15 0 27036 26 0 0 25 0 11 0 57119081 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4096306306 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=13972/tid=13974] ppid=13960 vsize=881360 CPUtime=8.31
/proc/13972/task/13974/stat : 13974 (java) S 13960 13958 2160 34817 2160 4202560 39909 0 0 0 819 12 0 0 15 0 11 0 57119090 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13975] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13975/stat : 13975 (java) S 13960 13958 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 57119091 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13976] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13976/stat : 13976 (java) S 13960 13958 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 57119091 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13977] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13977/stat : 13977 (java) S 13960 13958 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57119101 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13978] ppid=13960 vsize=881360 CPUtime=0.42
/proc/13972/task/13978/stat : 13978 (java) S 13960 13958 2160 34817 2160 4202560 6038 0 1 0 41 1 0 0 18 0 11 0 57119101 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13979] ppid=13960 vsize=881360 CPUtime=1.91
/proc/13972/task/13979/stat : 13979 (java) S 13960 13958 2160 34817 2160 4202560 5316 0 9 0 189 2 0 0 15 0 11 0 57119101 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13980] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13980/stat : 13980 (java) S 13960 13958 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57119101 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13981] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13981/stat : 13981 (java) S 13960 13958 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 57119101 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13982] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13982/stat : 13982 (java) S 13960 13958 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 57119506 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 281.3
Current children cumulated vsize (KiB) 886496

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

[startup+283.211 s]
/proc/loadavg: 0.99 0.99 0.99 2/48 13993
/proc/meminfo: memFree=544260/1048576 swapFree=0/0
[pid=13958] ppid=13957 vsize=2568 CPUtime=0
/proc/13958/stat : 13958 (p2cudf-user-1.1) S 13957 13958 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 57119050 2629632 270 1283457024 134512640 135304128 4287972128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13958/statm: 642 270 230 194 0 29 0
[pid=13960] ppid=13958 vsize=2568 CPUtime=0.02
/proc/13960/stat : 13960 (p2cudf) S 13958 13958 2160 34817 2160 4202496 387 3015 0 1 0 0 2 0 25 0 1 0 57119051 2629632 279 1283457024 134512640 135304128 4290354576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13960/statm: 642 279 239 194 0 29 0
[pid=13972] ppid=13960 vsize=881360 CPUtime=282.18
/proc/13972/stat : 13972 (java) S 13960 13958 2160 34817 2160 4202496 102537 0 107 0 28176 42 0 0 23 0 11 0 57119054 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/13972/statm: 220340 98015 1788 10 0 217431 0
[pid=13972/tid=13973] ppid=13960 vsize=881360 CPUtime=271.52
/proc/13972/task/13973/stat : 13973 (java) R 13960 13958 2160 34817 2160 4202560 50276 0 15 0 27126 26 0 0 25 0 11 0 57119081 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4096293354 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=13972/tid=13974] ppid=13960 vsize=881360 CPUtime=8.31
/proc/13972/task/13974/stat : 13974 (java) S 13960 13958 2160 34817 2160 4202560 39909 0 0 0 819 12 0 0 15 0 11 0 57119090 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13975] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13975/stat : 13975 (java) S 13960 13958 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 57119091 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13976] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13976/stat : 13976 (java) S 13960 13958 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 57119091 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13977] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13977/stat : 13977 (java) S 13960 13958 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57119101 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13978] ppid=13960 vsize=881360 CPUtime=0.42
/proc/13972/task/13978/stat : 13978 (java) S 13960 13958 2160 34817 2160 4202560 6038 0 1 0 41 1 0 0 18 0 11 0 57119101 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13979] ppid=13960 vsize=881360 CPUtime=1.91
/proc/13972/task/13979/stat : 13979 (java) S 13960 13958 2160 34817 2160 4202560 5316 0 9 0 189 2 0 0 15 0 11 0 57119101 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13980] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13980/stat : 13980 (java) S 13960 13958 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57119101 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13981] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13981/stat : 13981 (java) S 13960 13958 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 57119101 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13982] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13982/stat : 13982 (java) S 13960 13958 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 57119506 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 282.2
Current children cumulated vsize (KiB) 886496

[startup+284.014 s]
/proc/loadavg: 0.99 0.99 0.99 2/48 13993
/proc/meminfo: memFree=544260/1048576 swapFree=0/0
[pid=13958] ppid=13957 vsize=2568 CPUtime=0
/proc/13958/stat : 13958 (p2cudf-user-1.1) S 13957 13958 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 57119050 2629632 270 1283457024 134512640 135304128 4287972128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13958/statm: 642 270 230 194 0 29 0
[pid=13960] ppid=13958 vsize=2568 CPUtime=0.02
/proc/13960/stat : 13960 (p2cudf) S 13958 13958 2160 34817 2160 4202496 387 3015 0 1 0 0 2 0 25 0 1 0 57119051 2629632 279 1283457024 134512640 135304128 4290354576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13960/statm: 642 279 239 194 0 29 0
[pid=13972] ppid=13960 vsize=881360 CPUtime=282.98
/proc/13972/stat : 13972 (java) S 13960 13958 2160 34817 2160 4202496 102537 0 107 0 28256 42 0 0 23 0 11 0 57119054 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/13972/statm: 220340 98015 1788 10 0 217431 0
[pid=13972/tid=13973] ppid=13960 vsize=881360 CPUtime=272.32
/proc/13972/task/13973/stat : 13973 (java) R 13960 13958 2160 34817 2160 4202560 50276 0 15 0 27206 26 0 0 25 0 11 0 57119081 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4095855124 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=13972/tid=13974] ppid=13960 vsize=881360 CPUtime=8.31
/proc/13972/task/13974/stat : 13974 (java) S 13960 13958 2160 34817 2160 4202560 39909 0 0 0 819 12 0 0 15 0 11 0 57119090 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13975] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13975/stat : 13975 (java) S 13960 13958 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 57119091 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13976] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13976/stat : 13976 (java) S 13960 13958 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 57119091 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13977] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13977/stat : 13977 (java) S 13960 13958 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57119101 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13978] ppid=13960 vsize=881360 CPUtime=0.42
/proc/13972/task/13978/stat : 13978 (java) S 13960 13958 2160 34817 2160 4202560 6038 0 1 0 41 1 0 0 18 0 11 0 57119101 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13979] ppid=13960 vsize=881360 CPUtime=1.91
/proc/13972/task/13979/stat : 13979 (java) S 13960 13958 2160 34817 2160 4202560 5316 0 9 0 189 2 0 0 15 0 11 0 57119101 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13980] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13980/stat : 13980 (java) S 13960 13958 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57119101 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13981] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13981/stat : 13981 (java) R 13960 13958 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 57119101 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=13972/tid=13982] ppid=13960 vsize=881360 CPUtime=0
/proc/13972/task/13982/stat : 13982 (java) S 13960 13958 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 57119506 902512640 98015 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283
Current children cumulated vsize (KiB) 886496

[startup+284.806 s]
/proc/loadavg: 0.99 0.99 0.99 2/48 13993
/proc/meminfo: memFree=544260/1048576 swapFree=0/0
[pid=13958] ppid=13957 vsize=2568 CPUtime=0
/proc/13958/stat : 13958 (p2cudf-user-1.1) S 13957 13958 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 57119050 2629632 270 1283457024 134512640 135304128 4287972128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13958/statm: 642 270 230 194 0 29 0
[pid=13960] ppid=13958 vsize=2568 CPUtime=0.02
/proc/13960/stat : 13960 (p2cudf) S 13958 13958 2160 34817 2160 4202496 387 3015 0 1 0 0 2 0 25 0 1 0 57119051 2629632 279 1283457024 134512640 135304128 4290354576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13960/statm: 642 279 239 194 0 29 0
[pid=13972] ppid=13960 vsize=881684 CPUtime=283.55
/proc/13972/stat : 13972 (java) S 13960 13958 2160 34817 2160 4202496 102550 0 107 0 28313 42 0 0 23 0 11 0 57119054 902844416 98028 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/13972/statm: 220421 98028 1789 10 0 217512 0
[pid=13972/tid=13973] ppid=13960 vsize=881684 CPUtime=272.88
/proc/13972/task/13973/stat : 13973 (java) S 13960 13958 2160 34817 2160 4202560 50284 0 15 0 27262 26 0 0 25 0 11 0 57119081 902844416 98028 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13974] ppid=13960 vsize=881684 CPUtime=8.31
/proc/13972/task/13974/stat : 13974 (java) S 13960 13958 2160 34817 2160 4202560 39909 0 0 0 819 12 0 0 16 0 11 0 57119090 902844416 98028 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13975] ppid=13960 vsize=881684 CPUtime=0
/proc/13972/task/13975/stat : 13975 (java) S 13960 13958 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 57119091 902844416 98028 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13976] ppid=13960 vsize=881684 CPUtime=0
/proc/13972/task/13976/stat : 13976 (java) S 13960 13958 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 57119091 902844416 98028 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13977] ppid=13960 vsize=881684 CPUtime=0
/proc/13972/task/13977/stat : 13977 (java) S 13960 13958 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57119101 902844416 98028 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13978] ppid=13960 vsize=881684 CPUtime=0.42
/proc/13972/task/13978/stat : 13978 (java) S 13960 13958 2160 34817 2160 4202560 6038 0 1 0 41 1 0 0 18 0 11 0 57119101 902844416 98028 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13979] ppid=13960 vsize=881684 CPUtime=1.93
/proc/13972/task/13979/stat : 13979 (java) S 13960 13958 2160 34817 2160 4202560 5316 0 9 0 191 2 0 0 15 0 11 0 57119101 902844416 98028 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13980] ppid=13960 vsize=881684 CPUtime=0
/proc/13972/task/13980/stat : 13980 (java) S 13960 13958 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57119101 902844416 98028 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13981] ppid=13960 vsize=881684 CPUtime=0
/proc/13972/task/13981/stat : 13981 (java) S 13960 13958 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 57119101 902844416 98028 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.57
Current children cumulated vsize (KiB) 886820

[startup+285.214 s]
/proc/loadavg: 0.99 0.99 0.99 1/48 13994
/proc/meminfo: memFree=544200/1048576 swapFree=0/0
[pid=13958] ppid=13957 vsize=2568 CPUtime=0
/proc/13958/stat : 13958 (p2cudf-user-1.1) S 13957 13958 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 57119050 2629632 270 1283457024 134512640 135304128 4287972128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13958/statm: 642 270 230 194 0 29 0
[pid=13960] ppid=13958 vsize=2568 CPUtime=0.02
/proc/13960/stat : 13960 (p2cudf) S 13958 13958 2160 34817 2160 4202496 387 3015 0 1 0 0 2 0 25 0 1 0 57119051 2629632 279 1283457024 134512640 135304128 4290354576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13960/statm: 642 279 239 194 0 29 0
[pid=13972] ppid=13960 vsize=881684 CPUtime=283.65
/proc/13972/stat : 13972 (java) S 13960 13958 2160 34817 2160 4202496 102552 0 107 0 28320 45 0 0 23 0 11 0 57119054 902844416 98030 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/13972/statm: 220421 98030 1789 10 0 217512 0
[pid=13972/tid=13973] ppid=13960 vsize=881684 CPUtime=272.88
/proc/13972/task/13973/stat : 13973 (java) S 13960 13958 2160 34817 2160 4202560 50284 0 15 0 27262 26 0 0 25 0 11 0 57119081 902844416 98030 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13974] ppid=13960 vsize=881684 CPUtime=8.31
/proc/13972/task/13974/stat : 13974 (java) S 13960 13958 2160 34817 2160 4202560 39909 0 0 0 819 12 0 0 16 0 11 0 57119090 902844416 98030 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13975] ppid=13960 vsize=881684 CPUtime=0
/proc/13972/task/13975/stat : 13975 (java) S 13960 13958 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 57119091 902844416 98030 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13976] ppid=13960 vsize=881684 CPUtime=0
/proc/13972/task/13976/stat : 13976 (java) S 13960 13958 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 57119091 902844416 98030 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13977] ppid=13960 vsize=881684 CPUtime=0
/proc/13972/task/13977/stat : 13977 (java) S 13960 13958 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57119101 902844416 98030 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13978] ppid=13960 vsize=881684 CPUtime=0.42
/proc/13972/task/13978/stat : 13978 (java) S 13960 13958 2160 34817 2160 4202560 6038 0 1 0 41 1 0 0 18 0 11 0 57119101 902844416 98030 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13979] ppid=13960 vsize=881684 CPUtime=1.94
/proc/13972/task/13979/stat : 13979 (java) S 13960 13958 2160 34817 2160 4202560 5316 0 9 0 192 2 0 0 15 0 11 0 57119101 902844416 98030 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13980] ppid=13960 vsize=881684 CPUtime=0
/proc/13972/task/13980/stat : 13980 (java) S 13960 13958 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57119101 902844416 98030 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13981] ppid=13960 vsize=881684 CPUtime=0
/proc/13972/task/13981/stat : 13981 (java) S 13960 13958 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 57119101 902844416 98030 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13994] ppid=13960 vsize=881684 CPUtime=0.07
/proc/13972/task/13994/stat : 13994 (java) R 13960 13958 2160 34817 2160 4202560 6 0 0 0 5 2 0 0 20 0 11 0 57147512 902844416 98030 1283457024 134512640 134550932 4294383632 18446744073709551615 4095400246 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.67
Current children cumulated vsize (KiB) 886820

[startup+285.314 s]
/proc/loadavg: 0.99 0.99 0.99 1/48 13994
/proc/meminfo: memFree=544200/1048576 swapFree=0/0
[pid=13958] ppid=13957 vsize=2568 CPUtime=0
/proc/13958/stat : 13958 (p2cudf-user-1.1) S 13957 13958 2160 34817 2160 4202496 375 0 0 0 0 0 0 0 25 0 1 0 57119050 2629632 270 1283457024 134512640 135304128 4287972128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13958/statm: 642 270 230 194 0 29 0
[pid=13960] ppid=13958 vsize=2568 CPUtime=0.02
/proc/13960/stat : 13960 (p2cudf) S 13958 13958 2160 34817 2160 4202496 387 3015 0 1 0 0 2 0 25 0 1 0 57119051 2629632 279 1283457024 134512640 135304128 4290354576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/13960/statm: 642 279 239 194 0 29 0
[pid=13972] ppid=13960 vsize=881684 CPUtime=283.75
/proc/13972/stat : 13972 (java) S 13960 13958 2160 34817 2160 4202496 102552 0 107 0 28326 49 0 0 23 0 11 0 57119054 902844416 98030 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/13972/statm: 220421 98030 1789 10 0 217512 0
[pid=13972/tid=13973] ppid=13960 vsize=881684 CPUtime=272.88
/proc/13972/task/13973/stat : 13973 (java) S 13960 13958 2160 34817 2160 4202560 50284 0 15 0 27262 26 0 0 25 0 11 0 57119081 902844416 98030 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13974] ppid=13960 vsize=881684 CPUtime=8.31
/proc/13972/task/13974/stat : 13974 (java) S 13960 13958 2160 34817 2160 4202560 39909 0 0 0 819 12 0 0 16 0 11 0 57119090 902844416 98030 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13975] ppid=13960 vsize=881684 CPUtime=0
/proc/13972/task/13975/stat : 13975 (java) S 13960 13958 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 57119091 902844416 98030 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13976] ppid=13960 vsize=881684 CPUtime=0
/proc/13972/task/13976/stat : 13976 (java) S 13960 13958 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 57119091 902844416 98030 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13977] ppid=13960 vsize=881684 CPUtime=0
/proc/13972/task/13977/stat : 13977 (java) S 13960 13958 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57119101 902844416 98030 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13978] ppid=13960 vsize=881684 CPUtime=0.42
/proc/13972/task/13978/stat : 13978 (java) S 13960 13958 2160 34817 2160 4202560 6038 0 1 0 41 1 0 0 18 0 11 0 57119101 902844416 98030 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13979] ppid=13960 vsize=881684 CPUtime=1.98
/proc/13972/task/13979/stat : 13979 (java) S 13960 13958 2160 34817 2160 4202560 5316 0 9 0 196 2 0 0 15 0 11 0 57119101 902844416 98030 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13980] ppid=13960 vsize=881684 CPUtime=0
/proc/13972/task/13980/stat : 13980 (java) S 13960 13958 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 57119101 902844416 98030 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13981] ppid=13960 vsize=881684 CPUtime=0
/proc/13972/task/13981/stat : 13981 (java) S 13960 13958 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 57119101 902844416 98030 1283457024 134512640 134550932 4294383632 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=13972/tid=13994] ppid=13960 vsize=881684 CPUtime=0.13
/proc/13972/task/13994/stat : 13994 (java) R 13960 13958 2160 34817 2160 4202560 6 0 0 0 7 6 0 0 20 0 11 0 57147512 902844416 98030 1283457024 134512640 134550932 4294383632 18446744073709551615 4095395886 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.77
Current children cumulated vsize (KiB) 886820

Child status: 0
Real time (s): 285.373
CPU time (s): 283.806
CPU user time (s): 283.282
CPU system time (s): 0.524032
CPU usage (%): 99.4509
Max. virtual memory (cumulated for all children) (KiB): 892020

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 283.282
system time used= 0.524032
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 106352
page faults= 108
swaps= 0
block input operations= 0
block output operations= 0
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 6425
involuntary context switches= 8703

runsolver used 0.004 second user time and 0.004 second system time

The end