runsolver Copyright (C) 2010 Olivier ROUSSEL

This is runsolver version 3.2.9a (svn: 651)

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

command line: /home/misc2010/bin/runsolver -s SIGUSR1 -M 1124 -C 290 -d 10 -w /home/misc2010/tmp/201108241238/p2cudf-trendy-1.13/rand314.cudf.s-e-l-s.log.runsolver ./p2cudf-trendy-1.13 /home/misc2010/data/2011/incremental/s-e-l-s/rand314.cudf /home/misc2010/tmp/201108241238/p2cudf-trendy-1.13/rand314.cudf.s-e-l-s.result 

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


[startup+0 s]
/proc/loadavg: 0.85 0.97 0.99 2/33 6086
/proc/meminfo: memFree=726936/1048576 swapFree=0/0
[pid=6086] ppid=6085 vsize=3024 CPUtime=0
/proc/6086/stat : 6086 (runsolver) R 6085 6086 1511 34817 1511 4202560 73 0 0 0 0 0 0 0 25 0 1 0 1487984 3096576 94 1283457024 134512640 134586868 4292634400 18446744073709551615 4294960130 0 0 0 24578 0 0 0 17 0 0 0 0
/proc/6086/statm: 756 94 62 19 0 55 0

[startup+0.162463 s]
/proc/loadavg: 0.85 0.97 0.99 2/33 6086
/proc/meminfo: memFree=726936/1048576 swapFree=0/0
[pid=6086] ppid=6085 vsize=2572 CPUtime=0
/proc/6086/stat : 6086 (p2cudf-trendy-1) S 6085 6086 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 25 0 1 0 1487984 2633728 271 1283457024 134512640 135304128 4289369296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6086/statm: 643 271 230 194 0 30 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2572

[startup+0.206461 s]
/proc/loadavg: 0.85 0.97 0.99 2/33 6086
/proc/meminfo: memFree=726936/1048576 swapFree=0/0
[pid=6086] ppid=6085 vsize=2572 CPUtime=0
/proc/6086/stat : 6086 (p2cudf-trendy-1) S 6085 6086 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 25 0 1 0 1487984 2633728 271 1283457024 134512640 135304128 4289369296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6086/statm: 643 271 230 194 0 30 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2572

[startup+0.306488 s]
/proc/loadavg: 0.85 0.97 0.99 2/33 6086
/proc/meminfo: memFree=726936/1048576 swapFree=0/0
[pid=6086] ppid=6085 vsize=2572 CPUtime=0
/proc/6086/stat : 6086 (p2cudf-trendy-1) S 6085 6086 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 25 0 1 0 1487984 2633728 271 1283457024 134512640 135304128 4289369296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6086/statm: 643 271 230 194 0 30 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2572

[startup+0.706539 s]
/proc/loadavg: 0.85 0.97 0.99 2/33 6086
/proc/meminfo: memFree=726936/1048576 swapFree=0/0
[pid=6086] ppid=6085 vsize=2572 CPUtime=0
/proc/6086/stat : 6086 (p2cudf-trendy-1) S 6085 6086 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 25 0 1 0 1487984 2633728 271 1283457024 134512640 135304128 4289369296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6086/statm: 643 271 230 194 0 30 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2572

[startup+1.50677 s]
/proc/loadavg: 0.94 0.98 0.99 3/45 6109
/proc/meminfo: memFree=705204/1048576 swapFree=0/0
[pid=6086] ppid=6085 vsize=2572 CPUtime=0
/proc/6086/stat : 6086 (p2cudf-trendy-1) S 6085 6086 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 25 0 1 0 1487984 2633728 271 1283457024 134512640 135304128 4289369296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6086/statm: 643 271 230 194 0 30 0
[pid=6088] ppid=6086 vsize=2568 CPUtime=0.02
/proc/6088/stat : 6088 (p2cudf) S 6086 6086 1511 34817 1511 4202496 391 3015 0 1 0 0 2 0 25 0 1 0 1487985 2629632 280 1283457024 134512640 135304128 4289703184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6088/statm: 642 280 239 194 0 29 0
[pid=6100] ppid=6088 vsize=882020 CPUtime=0.84
/proc/6100/stat : 6100 (java) S 6088 6086 1511 34817 1511 4202496 13503 0 104 0 81 3 0 0 23 0 10 0 1487989 903188480 10986 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6100/statm: 220505 10986 1719 10 0 217596 0
[pid=6100/tid=6101] ppid=6088 vsize=882020 CPUtime=0.36
/proc/6100/task/6101/stat : 6101 (java) R 6088 6086 1511 34817 1511 4202560 3927 0 15 0 35 1 0 0 25 0 10 0 1488016 903188480 10986 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6100/tid=6102] ppid=6088 vsize=882020 CPUtime=0
/proc/6100/task/6102/stat : 6102 (java) S 6088 6086 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 19 0 10 0 1488026 903188480 10986 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 0 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6103] ppid=6088 vsize=882020 CPUtime=0
/proc/6100/task/6103/stat : 6103 (java) S 6088 6086 1511 34817 1511 4202560 7 0 1 0 0 0 0 0 25 0 10 0 1488027 903188480 10986 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6104] ppid=6088 vsize=882020 CPUtime=0
/proc/6100/task/6104/stat : 6104 (java) S 6088 6086 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 10 0 1488027 903188480 10986 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6105] ppid=6088 vsize=882020 CPUtime=0
/proc/6100/task/6105/stat : 6105 (java) S 6088 6086 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 1488036 903188480 10986 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6106] ppid=6088 vsize=882020 CPUtime=0.22
/proc/6100/task/6106/stat : 6106 (java) R 6088 6086 1511 34817 1511 4202560 1741 0 1 0 22 0 0 0 19 0 10 0 1488036 903188480 10986 1283457024 134512640 134550932 4290638992 18446744073709551615 4151213347 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6100/tid=6107] ppid=6088 vsize=882020 CPUtime=0.25
/proc/6100/task/6107/stat : 6107 (java) R 6088 6086 1511 34817 1511 4202560 6836 0 8 0 23 2 0 0 23 0 10 0 1488036 903188480 10986 1283457024 134512640 134550932 4290638992 18446744073709551615 4149675202 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6100/tid=6108] ppid=6088 vsize=882020 CPUtime=0
/proc/6100/task/6108/stat : 6108 (java) S 6088 6086 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 1488036 903188480 10986 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6109] ppid=6088 vsize=882020 CPUtime=0
/proc/6100/task/6109/stat : 6109 (java) S 6088 6086 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 16 0 10 0 1488036 903188480 10986 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 0.86
Current children cumulated vsize (KiB) 887160

[startup+3.1072 s]
/proc/loadavg: 0.94 0.98 0.99 2/45 6109
/proc/meminfo: memFree=631796/1048576 swapFree=0/0
[pid=6086] ppid=6085 vsize=2572 CPUtime=0
/proc/6086/stat : 6086 (p2cudf-trendy-1) S 6085 6086 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 25 0 1 0 1487984 2633728 271 1283457024 134512640 135304128 4289369296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6086/statm: 643 271 230 194 0 30 0
[pid=6088] ppid=6086 vsize=2568 CPUtime=0.02
/proc/6088/stat : 6088 (p2cudf) S 6086 6086 1511 34817 1511 4202496 391 3015 0 1 0 0 2 0 25 0 1 0 1487985 2629632 280 1283457024 134512640 135304128 4289703184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6088/statm: 642 280 239 194 0 29 0
[pid=6100] ppid=6088 vsize=879240 CPUtime=2.43
/proc/6100/stat : 6100 (java) S 6088 6086 1511 34817 1511 4202496 70368 0 104 0 220 23 0 0 23 0 10 0 1487989 900341760 66541 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6100/statm: 219810 66541 1730 10 0 216901 0
[pid=6100/tid=6101] ppid=6088 vsize=879240 CPUtime=1.3
/proc/6100/task/6101/stat : 6101 (java) R 6088 6086 1511 34817 1511 4202560 50038 0 15 0 112 18 0 0 25 0 10 0 1488016 900341760 66541 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6100/tid=6102] ppid=6088 vsize=879240 CPUtime=0.2
/proc/6100/task/6102/stat : 6102 (java) R 6088 6086 1511 34817 1511 4202560 9404 0 0 0 19 1 0 0 16 0 10 0 1488026 900341760 66541 1283457024 134512640 134550932 4290638992 18446744073709551615 4149529870 0 0 0 16800975 0 0 0 -1 0 0 0 0
[pid=6100/tid=6103] ppid=6088 vsize=879240 CPUtime=0
/proc/6100/task/6103/stat : 6103 (java) S 6088 6086 1511 34817 1511 4202560 7 0 1 0 0 0 0 0 25 0 10 0 1488027 900341760 66541 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6104] ppid=6088 vsize=879240 CPUtime=0
/proc/6100/task/6104/stat : 6104 (java) S 6088 6086 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 10 0 1488027 900341760 66541 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6105] ppid=6088 vsize=879240 CPUtime=0
/proc/6100/task/6105/stat : 6105 (java) S 6088 6086 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 1488036 900341760 66541 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6106] ppid=6088 vsize=879240 CPUtime=0.42
/proc/6100/task/6106/stat : 6106 (java) S 6088 6086 1511 34817 1511 4202560 2401 0 1 0 41 1 0 0 19 0 10 0 1488036 900341760 66541 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6107] ppid=6088 vsize=879240 CPUtime=0.49
/proc/6100/task/6107/stat : 6107 (java) S 6088 6086 1511 34817 1511 4202560 7532 0 8 0 47 2 0 0 19 0 10 0 1488036 900341760 66541 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6108] ppid=6088 vsize=879240 CPUtime=0
/proc/6100/task/6108/stat : 6108 (java) S 6088 6086 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 1488036 900341760 66541 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6109] ppid=6088 vsize=879240 CPUtime=0
/proc/6100/task/6109/stat : 6109 (java) S 6088 6086 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 10 0 1488036 900341760 66541 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 2.45
Current children cumulated vsize (KiB) 884380
heavy processes:

[startup+6.31287 s]
/proc/loadavg: 0.94 0.98 0.99 2/45 6109
/proc/meminfo: memFree=385428/1048576 swapFree=0/0
[pid=6086] ppid=6085 vsize=2572 CPUtime=0
/proc/6086/stat : 6086 (p2cudf-trendy-1) S 6085 6086 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 25 0 1 0 1487984 2633728 271 1283457024 134512640 135304128 4289369296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6086/statm: 643 271 230 194 0 30 0
[pid=6088] ppid=6086 vsize=2568 CPUtime=0.02
/proc/6088/stat : 6088 (p2cudf) S 6086 6086 1511 34817 1511 4202496 391 3015 0 1 0 0 2 0 25 0 1 0 1487985 2629632 280 1283457024 134512640 135304128 4289703184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6088/statm: 642 280 239 194 0 29 0
[pid=6100] ppid=6088 vsize=879672 CPUtime=5.48
/proc/6100/stat : 6100 (java) S 6088 6086 1511 34817 1511 4202496 89642 0 105 0 517 31 0 0 23 0 10 0 1487989 900784128 84450 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6100/statm: 219918 84450 1764 10 0 217009 0
[pid=6100/tid=6101] ppid=6088 vsize=879672 CPUtime=2.62
/proc/6100/task/6101/stat : 6101 (java) R 6088 6086 1511 34817 1511 4202560 50260 0 15 0 244 18 0 0 25 0 10 0 1488016 900784128 84450 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6100/tid=6102] ppid=6088 vsize=879672 CPUtime=0.62
/proc/6100/task/6102/stat : 6102 (java) S 6088 6086 1511 34817 1511 4202560 26758 0 0 0 53 9 0 0 15 0 10 0 1488026 900784128 84450 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 0 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6103] ppid=6088 vsize=879672 CPUtime=0
/proc/6100/task/6103/stat : 6103 (java) S 6088 6086 1511 34817 1511 4202560 7 0 1 0 0 0 0 0 18 0 10 0 1488027 900784128 84450 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6104] ppid=6088 vsize=879672 CPUtime=0
/proc/6100/task/6104/stat : 6104 (java) S 6088 6086 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 10 0 1488027 900784128 84450 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6105] ppid=6088 vsize=879672 CPUtime=0
/proc/6100/task/6105/stat : 6105 (java) S 6088 6086 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 1488036 900784128 84450 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6106] ppid=6088 vsize=879672 CPUtime=0.42
/proc/6100/task/6106/stat : 6106 (java) S 6088 6086 1511 34817 1511 4202560 2401 0 1 0 41 1 0 0 19 0 10 0 1488036 900784128 84450 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6107] ppid=6088 vsize=879672 CPUtime=1.8
/proc/6100/task/6107/stat : 6107 (java) R 6088 6086 1511 34817 1511 4202560 9228 0 9 0 178 2 0 0 16 0 10 0 1488036 900784128 84450 1283457024 134512640 134550932 4290638992 18446744073709551615 4151323046 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6100/tid=6108] ppid=6088 vsize=879672 CPUtime=0
/proc/6100/task/6108/stat : 6108 (java) S 6088 6086 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 1488036 900784128 84450 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6109] ppid=6088 vsize=879672 CPUtime=0
/proc/6100/task/6109/stat : 6109 (java) S 6088 6086 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 10 0 1488036 900784128 84450 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 5.5
Current children cumulated vsize (KiB) 884812

[startup+12.705 s]
/proc/loadavg: 1.02 1.00 1.00 2/46 6110
/proc/meminfo: memFree=384440/1048576 swapFree=0/0
[pid=6086] ppid=6085 vsize=2572 CPUtime=0
/proc/6086/stat : 6086 (p2cudf-trendy-1) S 6085 6086 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 25 0 1 0 1487984 2633728 271 1283457024 134512640 135304128 4289369296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6086/statm: 643 271 230 194 0 30 0
[pid=6088] ppid=6086 vsize=2568 CPUtime=0.02
/proc/6088/stat : 6088 (p2cudf) S 6086 6086 1511 34817 1511 4202496 391 3015 0 1 0 0 2 0 25 0 1 0 1487985 2629632 280 1283457024 134512640 135304128 4289703184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6088/statm: 642 280 239 194 0 29 0
[pid=6100] ppid=6088 vsize=879996 CPUtime=11.85
/proc/6100/stat : 6100 (java) S 6088 6086 1511 34817 1511 4202496 89759 0 105 0 1154 31 0 0 23 0 11 0 1487989 901115904 84567 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6100/statm: 219999 84567 1784 10 0 217090 0
[pid=6100/tid=6101] ppid=6088 vsize=879996 CPUtime=8.33
/proc/6100/task/6101/stat : 6101 (java) R 6088 6086 1511 34817 1511 4202560 50280 0 15 0 815 18 0 0 25 0 11 0 1488016 901115904 84567 1283457024 134512640 134550932 4290638992 18446744073709551615 4095838627 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6100/tid=6102] ppid=6088 vsize=879996 CPUtime=0.62
/proc/6100/task/6102/stat : 6102 (java) S 6088 6086 1511 34817 1511 4202560 26758 0 0 0 53 9 0 0 16 0 11 0 1488026 901115904 84567 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 0 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6103] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6103/stat : 6103 (java) S 6088 6086 1511 34817 1511 4202560 7 0 1 0 0 0 0 0 18 0 11 0 1488027 901115904 84567 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6104] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6104/stat : 6104 (java) S 6088 6086 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1488027 901115904 84567 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6105] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6105/stat : 6105 (java) S 6088 6086 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1488036 901115904 84567 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6106] ppid=6088 vsize=879996 CPUtime=0.42
/proc/6100/task/6106/stat : 6106 (java) S 6088 6086 1511 34817 1511 4202560 2401 0 1 0 41 1 0 0 19 0 11 0 1488036 901115904 84567 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6107] ppid=6088 vsize=879996 CPUtime=2.46
/proc/6100/task/6107/stat : 6107 (java) S 6088 6086 1511 34817 1511 4202560 9321 0 9 0 244 2 0 0 15 0 11 0 1488036 901115904 84567 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6108] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6108/stat : 6108 (java) S 6088 6086 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1488036 901115904 84567 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6109] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6109/stat : 6109 (java) S 6088 6086 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1488036 901115904 84567 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6110] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6110/stat : 6110 (java) S 6088 6086 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 1488625 901115904 84567 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 11.87
Current children cumulated vsize (KiB) 885136

[startup+25.5088 s]
/proc/loadavg: 1.02 1.00 1.00 2/48 6112
/proc/meminfo: memFree=335560/1048576 swapFree=0/0
[pid=6086] ppid=6085 vsize=2572 CPUtime=0
/proc/6086/stat : 6086 (p2cudf-trendy-1) S 6085 6086 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 25 0 1 0 1487984 2633728 271 1283457024 134512640 135304128 4289369296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6086/statm: 643 271 230 194 0 30 0
[pid=6088] ppid=6086 vsize=2568 CPUtime=0.02
/proc/6088/stat : 6088 (p2cudf) S 6086 6086 1511 34817 1511 4202496 391 3015 0 1 0 0 2 0 25 0 1 0 1487985 2629632 280 1283457024 134512640 135304128 4289703184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6088/statm: 642 280 239 194 0 29 0
[pid=6100] ppid=6088 vsize=879996 CPUtime=24.64
/proc/6100/stat : 6100 (java) S 6088 6086 1511 34817 1511 4202496 101916 0 105 0 2428 36 0 0 23 0 11 0 1487989 901115904 96724 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6100/statm: 219999 96724 1788 10 0 217090 0
[pid=6100/tid=6101] ppid=6088 vsize=879996 CPUtime=20.08
/proc/6100/task/6101/stat : 6101 (java) R 6088 6086 1511 34817 1511 4202560 50282 0 15 0 1989 19 0 0 25 0 11 0 1488016 901115904 96724 1283457024 134512640 134550932 4290638992 18446744073709551615 4096036032 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6100/tid=6102] ppid=6088 vsize=879996 CPUtime=1.3
/proc/6100/task/6102/stat : 6102 (java) S 6088 6086 1511 34817 1511 4202560 38903 0 0 0 118 12 0 0 16 0 11 0 1488026 901115904 96724 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 0 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6103] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6103/stat : 6103 (java) S 6088 6086 1511 34817 1511 4202560 7 0 1 0 0 0 0 0 18 0 11 0 1488027 901115904 96724 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6104] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6104/stat : 6104 (java) S 6088 6086 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1488027 901115904 96724 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6105] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6105/stat : 6105 (java) S 6088 6086 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1488036 901115904 96724 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6106] ppid=6088 vsize=879996 CPUtime=0.42
/proc/6100/task/6106/stat : 6106 (java) S 6088 6086 1511 34817 1511 4202560 2401 0 1 0 41 1 0 0 19 0 11 0 1488036 901115904 96724 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6107] ppid=6088 vsize=879996 CPUtime=2.81
/proc/6100/task/6107/stat : 6107 (java) S 6088 6086 1511 34817 1511 4202560 9331 0 9 0 279 2 0 0 15 0 11 0 1488036 901115904 96724 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6108] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6108/stat : 6108 (java) S 6088 6086 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1488036 901115904 96724 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6109] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6109/stat : 6109 (java) S 6088 6086 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1488036 901115904 96724 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6110] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6110/stat : 6110 (java) S 6088 6086 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 1488625 901115904 96724 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 24.66
Current children cumulated vsize (KiB) 885136

[startup+51.1146 s]
/proc/loadavg: 1.07 1.02 1.00 2/48 6115
/proc/meminfo: memFree=333328/1048576 swapFree=0/0
[pid=6086] ppid=6085 vsize=2572 CPUtime=0
/proc/6086/stat : 6086 (p2cudf-trendy-1) S 6085 6086 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 25 0 1 0 1487984 2633728 271 1283457024 134512640 135304128 4289369296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6086/statm: 643 271 230 194 0 30 0
[pid=6088] ppid=6086 vsize=2568 CPUtime=0.02
/proc/6088/stat : 6088 (p2cudf) S 6086 6086 1511 34817 1511 4202496 391 3015 0 1 0 0 2 0 25 0 1 0 1487985 2629632 280 1283457024 134512640 135304128 4289703184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6088/statm: 642 280 239 194 0 29 0
[pid=6100] ppid=6088 vsize=879996 CPUtime=50.23
/proc/6100/stat : 6100 (java) S 6088 6086 1511 34817 1511 4202496 102440 0 105 0 4987 36 0 0 23 0 11 0 1487989 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6100/statm: 219999 97248 1788 10 0 217090 0
[pid=6100/tid=6101] ppid=6088 vsize=879996 CPUtime=44.42
/proc/6100/task/6101/stat : 6101 (java) R 6088 6086 1511 34817 1511 4202560 50282 0 15 0 4423 19 0 0 25 0 11 0 1488016 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4096000104 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6100/tid=6102] ppid=6088 vsize=879996 CPUtime=2.53
/proc/6100/task/6102/stat : 6102 (java) S 6088 6086 1511 34817 1511 4202560 39427 0 0 0 241 12 0 0 15 0 11 0 1488026 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 0 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6103] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6103/stat : 6103 (java) S 6088 6086 1511 34817 1511 4202560 7 0 1 0 0 0 0 0 18 0 11 0 1488027 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6104] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6104/stat : 6104 (java) S 6088 6086 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1488027 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6105] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6105/stat : 6105 (java) S 6088 6086 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6106] ppid=6088 vsize=879996 CPUtime=0.42
/proc/6100/task/6106/stat : 6106 (java) S 6088 6086 1511 34817 1511 4202560 2401 0 1 0 41 1 0 0 19 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6107] ppid=6088 vsize=879996 CPUtime=2.83
/proc/6100/task/6107/stat : 6107 (java) S 6088 6086 1511 34817 1511 4202560 9331 0 9 0 281 2 0 0 15 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6108] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6108/stat : 6108 (java) S 6088 6086 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6109] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6109/stat : 6109 (java) S 6088 6086 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6110] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6110/stat : 6110 (java) S 6088 6086 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 1488625 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 50.25
Current children cumulated vsize (KiB) 885136

[startup+102.311 s]
/proc/loadavg: 1.03 1.01 1.00 2/48 6120
/proc/meminfo: memFree=333204/1048576 swapFree=0/0
[pid=6086] ppid=6085 vsize=2572 CPUtime=0
/proc/6086/stat : 6086 (p2cudf-trendy-1) S 6085 6086 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 25 0 1 0 1487984 2633728 271 1283457024 134512640 135304128 4289369296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6086/statm: 643 271 230 194 0 30 0
[pid=6088] ppid=6086 vsize=2568 CPUtime=0.02
/proc/6088/stat : 6088 (p2cudf) S 6086 6086 1511 34817 1511 4202496 391 3015 0 1 0 0 2 0 25 0 1 0 1487985 2629632 280 1283457024 134512640 135304128 4289703184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6088/statm: 642 280 239 194 0 29 0
[pid=6100] ppid=6088 vsize=879996 CPUtime=101.34
/proc/6100/stat : 6100 (java) S 6088 6086 1511 34817 1511 4202496 102440 0 105 0 10097 37 0 0 23 0 11 0 1487989 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6100/statm: 219999 97248 1788 10 0 217090 0
[pid=6100/tid=6101] ppid=6088 vsize=879996 CPUtime=93.58
/proc/6100/task/6101/stat : 6101 (java) R 6088 6086 1511 34817 1511 4202560 50282 0 15 0 9338 20 0 0 25 0 11 0 1488016 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4095914888 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6100/tid=6102] ppid=6088 vsize=879996 CPUtime=4.43
/proc/6100/task/6102/stat : 6102 (java) S 6088 6086 1511 34817 1511 4202560 39427 0 0 0 431 12 0 0 16 0 11 0 1488026 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 0 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6103] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6103/stat : 6103 (java) S 6088 6086 1511 34817 1511 4202560 7 0 1 0 0 0 0 0 18 0 11 0 1488027 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6104] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6104/stat : 6104 (java) S 6088 6086 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1488027 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6105] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6105/stat : 6105 (java) S 6088 6086 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6106] ppid=6088 vsize=879996 CPUtime=0.42
/proc/6100/task/6106/stat : 6106 (java) S 6088 6086 1511 34817 1511 4202560 2401 0 1 0 41 1 0 0 19 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6107] ppid=6088 vsize=879996 CPUtime=2.88
/proc/6100/task/6107/stat : 6107 (java) S 6088 6086 1511 34817 1511 4202560 9331 0 9 0 286 2 0 0 16 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6108] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6108/stat : 6108 (java) S 6088 6086 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6109] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6109/stat : 6109 (java) S 6088 6086 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6110] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6110/stat : 6110 (java) S 6088 6086 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 1488625 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 101.36
Current children cumulated vsize (KiB) 885136

[startup+162.305 s]
/proc/loadavg: 1.01 1.00 1.00 2/47 6121
/proc/meminfo: memFree=333220/1048576 swapFree=0/0
[pid=6086] ppid=6085 vsize=2572 CPUtime=0
/proc/6086/stat : 6086 (p2cudf-trendy-1) S 6085 6086 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 25 0 1 0 1487984 2633728 271 1283457024 134512640 135304128 4289369296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6086/statm: 643 271 230 194 0 30 0
[pid=6088] ppid=6086 vsize=2568 CPUtime=0.02
/proc/6088/stat : 6088 (p2cudf) S 6086 6086 1511 34817 1511 4202496 391 3015 0 1 0 0 2 0 25 0 1 0 1487985 2629632 280 1283457024 134512640 135304128 4289703184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6088/statm: 642 280 239 194 0 29 0
[pid=6100] ppid=6088 vsize=879996 CPUtime=161.3
/proc/6100/stat : 6100 (java) S 6088 6086 1511 34817 1511 4202496 102440 0 105 0 16093 37 0 0 23 0 11 0 1487989 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6100/statm: 219999 97248 1788 10 0 217090 0
[pid=6100/tid=6101] ppid=6088 vsize=879996 CPUtime=152.8
/proc/6100/task/6101/stat : 6101 (java) R 6088 6086 1511 34817 1511 4202560 50282 0 15 0 15260 20 0 0 25 0 11 0 1488016 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4096024936 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6100/tid=6102] ppid=6088 vsize=879996 CPUtime=5.17
/proc/6100/task/6102/stat : 6102 (java) S 6088 6086 1511 34817 1511 4202560 39427 0 0 0 505 12 0 0 15 0 11 0 1488026 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 0 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6103] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6103/stat : 6103 (java) S 6088 6086 1511 34817 1511 4202560 7 0 1 0 0 0 0 0 18 0 11 0 1488027 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6104] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6104/stat : 6104 (java) S 6088 6086 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1488027 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6105] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6105/stat : 6105 (java) S 6088 6086 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6106] ppid=6088 vsize=879996 CPUtime=0.42
/proc/6100/task/6106/stat : 6106 (java) S 6088 6086 1511 34817 1511 4202560 2401 0 1 0 41 1 0 0 19 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6107] ppid=6088 vsize=879996 CPUtime=2.88
/proc/6100/task/6107/stat : 6107 (java) S 6088 6086 1511 34817 1511 4202560 9331 0 9 0 286 2 0 0 16 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6108] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6108/stat : 6108 (java) S 6088 6086 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6109] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6109/stat : 6109 (java) S 6088 6086 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6110] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6110/stat : 6110 (java) S 6088 6086 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 1488625 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 161.32
Current children cumulated vsize (KiB) 885136

[startup+222.31 s]
/proc/loadavg: 1.00 1.00 1.00 3/47 6125
/proc/meminfo: memFree=332668/1048576 swapFree=0/0
[pid=6086] ppid=6085 vsize=2572 CPUtime=0
/proc/6086/stat : 6086 (p2cudf-trendy-1) S 6085 6086 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 25 0 1 0 1487984 2633728 271 1283457024 134512640 135304128 4289369296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6086/statm: 643 271 230 194 0 30 0
[pid=6088] ppid=6086 vsize=2568 CPUtime=0.02
/proc/6088/stat : 6088 (p2cudf) S 6086 6086 1511 34817 1511 4202496 391 3015 0 1 0 0 2 0 25 0 1 0 1487985 2629632 280 1283457024 134512640 135304128 4289703184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6088/statm: 642 280 239 194 0 29 0
[pid=6100] ppid=6088 vsize=879996 CPUtime=221.23
/proc/6100/stat : 6100 (java) S 6088 6086 1511 34817 1511 4202496 102440 0 105 0 22086 37 0 0 23 0 11 0 1487989 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6100/statm: 219999 97248 1788 10 0 217090 0
[pid=6100/tid=6101] ppid=6088 vsize=879996 CPUtime=211.95
/proc/6100/task/6101/stat : 6101 (java) R 6088 6086 1511 34817 1511 4202560 50282 0 15 0 21175 20 0 0 25 0 11 0 1488016 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4095956920 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6100/tid=6102] ppid=6088 vsize=879996 CPUtime=5.96
/proc/6100/task/6102/stat : 6102 (java) S 6088 6086 1511 34817 1511 4202560 39427 0 0 0 584 12 0 0 15 0 11 0 1488026 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 0 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6103] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6103/stat : 6103 (java) S 6088 6086 1511 34817 1511 4202560 7 0 1 0 0 0 0 0 18 0 11 0 1488027 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6104] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6104/stat : 6104 (java) S 6088 6086 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1488027 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6105] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6105/stat : 6105 (java) S 6088 6086 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6106] ppid=6088 vsize=879996 CPUtime=0.42
/proc/6100/task/6106/stat : 6106 (java) S 6088 6086 1511 34817 1511 4202560 2401 0 1 0 41 1 0 0 19 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6107] ppid=6088 vsize=879996 CPUtime=2.88
/proc/6100/task/6107/stat : 6107 (java) S 6088 6086 1511 34817 1511 4202560 9331 0 9 0 286 2 0 0 15 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6108] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6108/stat : 6108 (java) S 6088 6086 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6109] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6109/stat : 6109 (java) S 6088 6086 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6110] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6110/stat : 6110 (java) S 6088 6086 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 1488625 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 221.25
Current children cumulated vsize (KiB) 885136

[startup+282.306 s]
/proc/loadavg: 1.00 1.00 1.00 2/46 6125
/proc/meminfo: memFree=332676/1048576 swapFree=0/0
[pid=6086] ppid=6085 vsize=2572 CPUtime=0
/proc/6086/stat : 6086 (p2cudf-trendy-1) S 6085 6086 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 25 0 1 0 1487984 2633728 271 1283457024 134512640 135304128 4289369296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6086/statm: 643 271 230 194 0 30 0
[pid=6088] ppid=6086 vsize=2568 CPUtime=0.02
/proc/6088/stat : 6088 (p2cudf) S 6086 6086 1511 34817 1511 4202496 391 3015 0 1 0 0 2 0 25 0 1 0 1487985 2629632 280 1283457024 134512640 135304128 4289703184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6088/statm: 642 280 239 194 0 29 0
[pid=6100] ppid=6088 vsize=879996 CPUtime=281.2
/proc/6100/stat : 6100 (java) S 6088 6086 1511 34817 1511 4202496 102440 0 105 0 28082 38 0 0 23 0 11 0 1487989 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6100/statm: 219999 97248 1788 10 0 217090 0
[pid=6100/tid=6101] ppid=6088 vsize=879996 CPUtime=270.77
/proc/6100/task/6101/stat : 6101 (java) R 6088 6086 1511 34817 1511 4202560 50282 0 15 0 27055 22 0 0 25 0 11 0 1488016 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4095914900 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6100/tid=6102] ppid=6088 vsize=879996 CPUtime=7.1
/proc/6100/task/6102/stat : 6102 (java) S 6088 6086 1511 34817 1511 4202560 39427 0 0 0 698 12 0 0 15 0 11 0 1488026 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 0 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6103] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6103/stat : 6103 (java) S 6088 6086 1511 34817 1511 4202560 7 0 1 0 0 0 0 0 18 0 11 0 1488027 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6104] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6104/stat : 6104 (java) S 6088 6086 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1488027 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6105] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6105/stat : 6105 (java) S 6088 6086 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6106] ppid=6088 vsize=879996 CPUtime=0.42
/proc/6100/task/6106/stat : 6106 (java) S 6088 6086 1511 34817 1511 4202560 2401 0 1 0 41 1 0 0 19 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6107] ppid=6088 vsize=879996 CPUtime=2.88
/proc/6100/task/6107/stat : 6107 (java) S 6088 6086 1511 34817 1511 4202560 9331 0 9 0 286 2 0 0 15 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6108] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6108/stat : 6108 (java) S 6088 6086 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6109] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6109/stat : 6109 (java) S 6088 6086 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6110] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6110/stat : 6110 (java) S 6088 6086 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 1488625 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 281.22
Current children cumulated vsize (KiB) 885136

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

[startup+284.806 s]
/proc/loadavg: 1.00 1.00 1.00 2/46 6125
/proc/meminfo: memFree=332676/1048576 swapFree=0/0
[pid=6086] ppid=6085 vsize=2572 CPUtime=0
/proc/6086/stat : 6086 (p2cudf-trendy-1) S 6085 6086 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 25 0 1 0 1487984 2633728 271 1283457024 134512640 135304128 4289369296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6086/statm: 643 271 230 194 0 30 0
[pid=6088] ppid=6086 vsize=2568 CPUtime=0.02
/proc/6088/stat : 6088 (p2cudf) S 6086 6086 1511 34817 1511 4202496 391 3015 0 1 0 0 2 0 25 0 1 0 1487985 2629632 280 1283457024 134512640 135304128 4289703184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6088/statm: 642 280 239 194 0 29 0
[pid=6100] ppid=6088 vsize=879996 CPUtime=283.7
/proc/6100/stat : 6100 (java) S 6088 6086 1511 34817 1511 4202496 102440 0 105 0 28332 38 0 0 23 0 11 0 1487989 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6100/statm: 219999 97248 1788 10 0 217090 0
[pid=6100/tid=6101] ppid=6088 vsize=879996 CPUtime=273.27
/proc/6100/task/6101/stat : 6101 (java) R 6088 6086 1511 34817 1511 4202560 50282 0 15 0 27305 22 0 0 25 0 11 0 1488016 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4095956940 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6100/tid=6102] ppid=6088 vsize=879996 CPUtime=7.1
/proc/6100/task/6102/stat : 6102 (java) S 6088 6086 1511 34817 1511 4202560 39427 0 0 0 698 12 0 0 15 0 11 0 1488026 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 0 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6103] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6103/stat : 6103 (java) S 6088 6086 1511 34817 1511 4202560 7 0 1 0 0 0 0 0 18 0 11 0 1488027 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6104] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6104/stat : 6104 (java) S 6088 6086 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1488027 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6105] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6105/stat : 6105 (java) S 6088 6086 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6106] ppid=6088 vsize=879996 CPUtime=0.42
/proc/6100/task/6106/stat : 6106 (java) S 6088 6086 1511 34817 1511 4202560 2401 0 1 0 41 1 0 0 19 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6107] ppid=6088 vsize=879996 CPUtime=2.88
/proc/6100/task/6107/stat : 6107 (java) S 6088 6086 1511 34817 1511 4202560 9331 0 9 0 286 2 0 0 15 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6108] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6108/stat : 6108 (java) S 6088 6086 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6109] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6109/stat : 6109 (java) S 6088 6086 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6110] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6110/stat : 6110 (java) S 6088 6086 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 1488625 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.72
Current children cumulated vsize (KiB) 885136

[startup+286.407 s]
/proc/loadavg: 1.00 1.00 1.00 2/46 6125
/proc/meminfo: memFree=332676/1048576 swapFree=0/0
[pid=6086] ppid=6085 vsize=2572 CPUtime=0
/proc/6086/stat : 6086 (p2cudf-trendy-1) S 6085 6086 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 25 0 1 0 1487984 2633728 271 1283457024 134512640 135304128 4289369296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6086/statm: 643 271 230 194 0 30 0
[pid=6088] ppid=6086 vsize=2568 CPUtime=0.02
/proc/6088/stat : 6088 (p2cudf) S 6086 6086 1511 34817 1511 4202496 391 3015 0 1 0 0 2 0 25 0 1 0 1487985 2629632 280 1283457024 134512640 135304128 4289703184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6088/statm: 642 280 239 194 0 29 0
[pid=6100] ppid=6088 vsize=879996 CPUtime=285.29
/proc/6100/stat : 6100 (java) S 6088 6086 1511 34817 1511 4202496 102440 0 105 0 28491 38 0 0 23 0 11 0 1487989 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6100/statm: 219999 97248 1788 10 0 217090 0
[pid=6100/tid=6101] ppid=6088 vsize=879996 CPUtime=274.87
/proc/6100/task/6101/stat : 6101 (java) R 6088 6086 1511 34817 1511 4202560 50282 0 15 0 27465 22 0 0 25 0 11 0 1488016 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4095947571 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6100/tid=6102] ppid=6088 vsize=879996 CPUtime=7.1
/proc/6100/task/6102/stat : 6102 (java) S 6088 6086 1511 34817 1511 4202560 39427 0 0 0 698 12 0 0 15 0 11 0 1488026 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 0 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6103] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6103/stat : 6103 (java) S 6088 6086 1511 34817 1511 4202560 7 0 1 0 0 0 0 0 18 0 11 0 1488027 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6104] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6104/stat : 6104 (java) S 6088 6086 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1488027 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6105] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6105/stat : 6105 (java) S 6088 6086 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6106] ppid=6088 vsize=879996 CPUtime=0.42
/proc/6100/task/6106/stat : 6106 (java) S 6088 6086 1511 34817 1511 4202560 2401 0 1 0 41 1 0 0 19 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6107] ppid=6088 vsize=879996 CPUtime=2.88
/proc/6100/task/6107/stat : 6107 (java) S 6088 6086 1511 34817 1511 4202560 9331 0 9 0 286 2 0 0 15 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6108] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6108/stat : 6108 (java) S 6088 6086 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6109] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6109/stat : 6109 (java) S 6088 6086 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1488036 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6110] ppid=6088 vsize=879996 CPUtime=0
/proc/6100/task/6110/stat : 6110 (java) S 6088 6086 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 1488625 901115904 97248 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 285.31
Current children cumulated vsize (KiB) 885136

[startup+286.804 s]
/proc/loadavg: 1.00 1.00 1.00 2/46 6125
/proc/meminfo: memFree=332676/1048576 swapFree=0/0
[pid=6086] ppid=6085 vsize=2572 CPUtime=0
/proc/6086/stat : 6086 (p2cudf-trendy-1) S 6085 6086 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 25 0 1 0 1487984 2633728 271 1283457024 134512640 135304128 4289369296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6086/statm: 643 271 230 194 0 30 0
[pid=6088] ppid=6086 vsize=2568 CPUtime=0.02
/proc/6088/stat : 6088 (p2cudf) S 6086 6086 1511 34817 1511 4202496 391 3015 0 1 0 0 2 0 25 0 1 0 1487985 2629632 280 1283457024 134512640 135304128 4289703184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6088/statm: 642 280 239 194 0 29 0
[pid=6100] ppid=6088 vsize=880320 CPUtime=285.37
/proc/6100/stat : 6100 (java) S 6088 6086 1511 34817 1511 4202496 102454 0 105 0 28499 38 0 0 23 0 11 0 1487989 901447680 97262 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6100/statm: 220080 97262 1789 10 0 217171 0
[pid=6100/tid=6101] ppid=6088 vsize=880320 CPUtime=274.9
/proc/6100/task/6101/stat : 6101 (java) S 6088 6086 1511 34817 1511 4202560 50290 0 15 0 27468 22 0 0 25 0 11 0 1488016 901447680 97262 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6102] ppid=6088 vsize=880320 CPUtime=7.1
/proc/6100/task/6102/stat : 6102 (java) S 6088 6086 1511 34817 1511 4202560 39427 0 0 0 698 12 0 0 16 0 11 0 1488026 901447680 97262 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 0 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6103] ppid=6088 vsize=880320 CPUtime=0
/proc/6100/task/6103/stat : 6103 (java) S 6088 6086 1511 34817 1511 4202560 7 0 1 0 0 0 0 0 18 0 11 0 1488027 901447680 97262 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6104] ppid=6088 vsize=880320 CPUtime=0
/proc/6100/task/6104/stat : 6104 (java) S 6088 6086 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1488027 901447680 97262 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6105] ppid=6088 vsize=880320 CPUtime=0
/proc/6100/task/6105/stat : 6105 (java) S 6088 6086 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1488036 901447680 97262 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6106] ppid=6088 vsize=880320 CPUtime=0.42
/proc/6100/task/6106/stat : 6106 (java) S 6088 6086 1511 34817 1511 4202560 2401 0 1 0 41 1 0 0 19 0 11 0 1488036 901447680 97262 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6107] ppid=6088 vsize=880320 CPUtime=2.93
/proc/6100/task/6107/stat : 6107 (java) S 6088 6086 1511 34817 1511 4202560 9331 0 9 0 291 2 0 0 15 0 11 0 1488036 901447680 97262 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6108] ppid=6088 vsize=880320 CPUtime=0
/proc/6100/task/6108/stat : 6108 (java) S 6088 6086 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1488036 901447680 97262 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=6100/tid=6109] ppid=6088 vsize=880320 CPUtime=0
/proc/6100/task/6109/stat : 6109 (java) S 6088 6086 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1488036 901447680 97262 1283457024 134512640 134550932 4290638992 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 285.39
Current children cumulated vsize (KiB) 885460

[startup+287.207 s]
/proc/loadavg: 1.00 1.00 1.00 3/46 6126
/proc/meminfo: memFree=332676/1048576 swapFree=0/0
[pid=6086] ppid=6085 vsize=2572 CPUtime=0
/proc/6086/stat : 6086 (p2cudf-trendy-1) S 6085 6086 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 25 0 1 0 1487984 2633728 271 1283457024 134512640 135304128 4289369296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6086/statm: 643 271 230 194 0 30 0
[pid=6088] ppid=6086 vsize=2568 CPUtime=0.02
/proc/6088/stat : 6088 (p2cudf) S 6086 6086 1511 34817 1511 4202496 391 3015 0 1 0 0 2 0 25 0 1 0 1487985 2629632 280 1283457024 134512640 135304128 4289703184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6088/statm: 642 280 239 194 0 29 0
[pid=6100] ppid=6088 vsize=0 CPUtime=285.51
/proc/6100/stat : 6100 (java) R 6088 6086 1511 34817 1511 4203524 102458 0 105 0 28509 42 0 0 18 0 1 0 1487989 0 0 1283457024 0 0 0 0 0 0 0 0 16800975 0 0 0 17 0 0 0 0
/proc/6100/statm: 0 0 0 0 0 0 0
Current children cumulated CPU time (s) 285.53
Current children cumulated vsize (KiB) 5140

Child status: 0
Real time (s): 287.219
CPU time (s): 285.558
CPU user time (s): 285.118
CPU system time (s): 0.440027
CPU usage (%): 99.4215
Max. virtual memory (cumulated for all children) (KiB): 887712

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 285.118
system time used= 0.440027
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 106259
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= 6677
involuntary context switches= 8941

runsolver used 0 second user time and 0 second system time

The end