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/rand152.cudf.user-upgrades.log.runsolver ./p2cudf-trendy-1.13 /home/misc2010/data/2011/user-upgrades/rand152.cudf /home/misc2010/tmp/201108241238/p2cudf-trendy-1.13/rand152.cudf.user-upgrades.result 

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


[startup+0 s]
/proc/loadavg: 1.10 1.06 1.01 6/36 5163
/proc/meminfo: memFree=537188/1048576 swapFree=0/0
[pid=5161] ppid=5160 vsize=2568 CPUtime=0
/proc/5161/stat : 5161 (p2cudf-trendy-1) S 5160 5161 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 18 0 1 0 1304478 2629632 271 1283457024 134512640 135304128 4289328320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5161/statm: 642 271 230 194 0 29 0
[pid=5162] ppid=5161 vsize=2572 CPUtime=0
/proc/5162/stat : 5162 (p2cudf) R 5161 5161 1511 34817 1511 4202496 347 0 0 0 0 0 0 0 25 0 1 0 1304478 2633728 272 1283457024 134512640 135304128 4290909744 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/5162/statm: 643 272 231 194 0 30 0
[pid=5163] ppid=5162 vsize=2572 CPUtime=0
/proc/5163/stat : 5163 (p2cudf) R 5162 5161 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 1 0 1304478 2633728 41 1283457024 134512640 135304128 4290909744 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/5163/statm: 643 41 0 194 0 30 0

[startup+0.196421 s]
/proc/loadavg: 1.10 1.06 1.01 6/36 5163
/proc/meminfo: memFree=537188/1048576 swapFree=0/0
[pid=5161] ppid=5160 vsize=2568 CPUtime=0
/proc/5161/stat : 5161 (p2cudf-trendy-1) S 5160 5161 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 18 0 1 0 1304478 2629632 271 1283457024 134512640 135304128 4289328320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5161/statm: 642 271 230 194 0 29 0
[pid=5162] ppid=5161 vsize=2576 CPUtime=0.02
/proc/5162/stat : 5162 (p2cudf) S 5161 5161 1511 34817 1511 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 1304478 2637824 281 1283457024 134512640 135304128 4290909744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5162/statm: 644 281 239 194 0 31 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5144

[startup+0.206415 s]
/proc/loadavg: 1.10 1.06 1.01 6/36 5163
/proc/meminfo: memFree=537188/1048576 swapFree=0/0
[pid=5161] ppid=5160 vsize=2568 CPUtime=0
/proc/5161/stat : 5161 (p2cudf-trendy-1) S 5160 5161 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 18 0 1 0 1304478 2629632 271 1283457024 134512640 135304128 4289328320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5161/statm: 642 271 230 194 0 29 0
[pid=5162] ppid=5161 vsize=2576 CPUtime=0.02
/proc/5162/stat : 5162 (p2cudf) S 5161 5161 1511 34817 1511 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 1304478 2637824 281 1283457024 134512640 135304128 4290909744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5162/statm: 644 281 239 194 0 31 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5144

[startup+0.306447 s]
/proc/loadavg: 1.10 1.06 1.01 6/36 5163
/proc/meminfo: memFree=537188/1048576 swapFree=0/0
[pid=5161] ppid=5160 vsize=2568 CPUtime=0
/proc/5161/stat : 5161 (p2cudf-trendy-1) S 5160 5161 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 18 0 1 0 1304478 2629632 271 1283457024 134512640 135304128 4289328320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5161/statm: 642 271 230 194 0 29 0
[pid=5162] ppid=5161 vsize=2576 CPUtime=0.02
/proc/5162/stat : 5162 (p2cudf) S 5161 5161 1511 34817 1511 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 1304478 2637824 281 1283457024 134512640 135304128 4290909744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5162/statm: 644 281 239 194 0 31 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5144

[startup+0.706547 s]
/proc/loadavg: 1.10 1.06 1.01 6/36 5163
/proc/meminfo: memFree=537188/1048576 swapFree=0/0
[pid=5161] ppid=5160 vsize=2568 CPUtime=0
/proc/5161/stat : 5161 (p2cudf-trendy-1) S 5160 5161 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 18 0 1 0 1304478 2629632 271 1283457024 134512640 135304128 4289328320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5161/statm: 642 271 230 194 0 29 0
[pid=5162] ppid=5161 vsize=2576 CPUtime=0.02
/proc/5162/stat : 5162 (p2cudf) S 5161 5161 1511 34817 1511 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 1304478 2637824 281 1283457024 134512640 135304128 4290909744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5162/statm: 644 281 239 194 0 31 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5144

[startup+1.50678 s]
/proc/loadavg: 1.17 1.07 1.02 5/46 5184
/proc/meminfo: memFree=497852/1048576 swapFree=0/0
[pid=5161] ppid=5160 vsize=2568 CPUtime=0
/proc/5161/stat : 5161 (p2cudf-trendy-1) S 5160 5161 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 18 0 1 0 1304478 2629632 271 1283457024 134512640 135304128 4289328320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5161/statm: 642 271 230 194 0 29 0
[pid=5162] ppid=5161 vsize=2576 CPUtime=0.02
/proc/5162/stat : 5162 (p2cudf) S 5161 5161 1511 34817 1511 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 1304478 2637824 281 1283457024 134512640 135304128 4290909744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5162/statm: 644 281 239 194 0 31 0
[pid=5175] ppid=5162 vsize=880248 CPUtime=1.47
/proc/5175/stat : 5175 (java) S 5162 5161 1511 34817 1511 4202496 20996 0 1 0 144 3 0 0 25 0 10 0 1304482 901373952 18087 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5175/statm: 220062 18087 1724 10 0 217153 0
[pid=5175/tid=5176] ppid=5162 vsize=880248 CPUtime=0.77
/proc/5175/task/5176/stat : 5176 (java) R 5162 5161 1511 34817 1511 4202560 10778 0 1 0 75 2 0 0 25 0 10 0 1304482 901373952 18087 1283457024 134512640 134550932 4293322528 18446744073709551615 4148933856 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5175/tid=5177] ppid=5162 vsize=880248 CPUtime=0
/proc/5175/task/5177/stat : 5177 (java) S 5162 5161 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 17 0 10 0 1304484 901373952 18087 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 0 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5178] ppid=5162 vsize=880248 CPUtime=0
/proc/5175/task/5178/stat : 5178 (java) S 5162 5161 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 25 0 10 0 1304484 901373952 18087 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5179] ppid=5162 vsize=880248 CPUtime=0
/proc/5175/task/5179/stat : 5179 (java) S 5162 5161 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 10 0 1304484 901373952 18087 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5180] ppid=5162 vsize=880248 CPUtime=0
/proc/5175/task/5180/stat : 5180 (java) S 5162 5161 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 1304487 901373952 18087 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5181] ppid=5162 vsize=880248 CPUtime=0.56
/proc/5175/task/5181/stat : 5181 (java) R 5162 5161 1511 34817 1511 4202560 8542 0 0 0 56 0 0 0 22 0 10 0 1304487 901373952 18087 1283457024 134512640 134550932 4293322528 18446744073709551615 4149717845 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5175/tid=5182] ppid=5162 vsize=880248 CPUtime=0.11
/proc/5175/task/5182/stat : 5182 (java) S 5162 5161 1511 34817 1511 4202560 599 0 0 0 11 0 0 0 23 0 10 0 1304487 901373952 18087 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5183] ppid=5162 vsize=880248 CPUtime=0
/proc/5175/task/5183/stat : 5183 (java) S 5162 5161 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 10 0 1304487 901373952 18087 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5184] ppid=5162 vsize=880248 CPUtime=0
/proc/5175/task/5184/stat : 5184 (java) S 5162 5161 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 10 0 1304487 901373952 18087 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 1.49
Current children cumulated vsize (KiB) 885392

[startup+3.1072 s]
/proc/loadavg: 1.17 1.07 1.02 2/46 5184
/proc/meminfo: memFree=367900/1048576 swapFree=0/0
[pid=5161] ppid=5160 vsize=2568 CPUtime=0
/proc/5161/stat : 5161 (p2cudf-trendy-1) S 5160 5161 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 18 0 1 0 1304478 2629632 271 1283457024 134512640 135304128 4289328320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5161/statm: 642 271 230 194 0 29 0
[pid=5162] ppid=5161 vsize=2576 CPUtime=0.02
/proc/5162/stat : 5162 (p2cudf) S 5161 5161 1511 34817 1511 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 1304478 2637824 281 1283457024 134512640 135304128 4290909744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5162/statm: 644 281 239 194 0 31 0
[pid=5175] ppid=5162 vsize=879600 CPUtime=3.07
/proc/5175/stat : 5175 (java) S 5162 5161 1511 34817 1511 4202496 71010 0 1 0 278 29 0 0 25 0 10 0 1304482 900710400 67756 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5175/statm: 219900 67756 1743 10 0 216991 0
[pid=5175/tid=5176] ppid=5162 vsize=879600 CPUtime=1.88
/proc/5175/task/5176/stat : 5176 (java) R 5162 5161 1511 34817 1511 4202560 50090 0 1 0 165 23 0 0 25 0 10 0 1304482 900710400 67756 1283457024 134512640 134550932 4293322528 18446744073709551615 4094811336 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5175/tid=5177] ppid=5162 vsize=879600 CPUtime=0.22
/proc/5175/task/5177/stat : 5177 (java) S 5162 5161 1511 34817 1511 4202560 10470 0 0 0 18 4 0 0 16 0 10 0 1304484 900710400 67756 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 0 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5178] ppid=5162 vsize=879600 CPUtime=0
/proc/5175/task/5178/stat : 5178 (java) S 5162 5161 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 10 0 1304484 900710400 67756 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5179] ppid=5162 vsize=879600 CPUtime=0
/proc/5175/task/5179/stat : 5179 (java) S 5162 5161 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 10 0 1304484 900710400 67756 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5180] ppid=5162 vsize=879600 CPUtime=0
/proc/5175/task/5180/stat : 5180 (java) S 5162 5161 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 1304487 900710400 67756 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5181] ppid=5162 vsize=879600 CPUtime=0.81
/proc/5175/task/5181/stat : 5181 (java) S 5162 5161 1511 34817 1511 4202560 8777 0 0 0 81 0 0 0 15 0 10 0 1304487 900710400 67756 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5182] ppid=5162 vsize=879600 CPUtime=0.11
/proc/5175/task/5182/stat : 5182 (java) S 5162 5161 1511 34817 1511 4202560 599 0 0 0 11 0 0 0 23 0 10 0 1304487 900710400 67756 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5183] ppid=5162 vsize=879600 CPUtime=0
/proc/5175/task/5183/stat : 5183 (java) S 5162 5161 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 10 0 1304487 900710400 67756 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5184] ppid=5162 vsize=879600 CPUtime=0
/proc/5175/task/5184/stat : 5184 (java) S 5162 5161 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 10 0 1304487 900710400 67756 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 3.09
Current children cumulated vsize (KiB) 884744

[startup+6.30802 s]
/proc/loadavg: 1.17 1.07 1.02 2/47 5185
/proc/meminfo: memFree=211172/1048576 swapFree=0/0
[pid=5161] ppid=5160 vsize=2568 CPUtime=0
/proc/5161/stat : 5161 (p2cudf-trendy-1) S 5160 5161 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 18 0 1 0 1304478 2629632 271 1283457024 134512640 135304128 4289328320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5161/statm: 642 271 230 194 0 29 0
[pid=5162] ppid=5161 vsize=2576 CPUtime=0.02
/proc/5162/stat : 5162 (p2cudf) S 5161 5161 1511 34817 1511 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 1304478 2637824 281 1283457024 134512640 135304128 4290909744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5162/statm: 644 281 239 194 0 31 0
[pid=5175] ppid=5162 vsize=879924 CPUtime=6.26
/proc/5175/stat : 5175 (java) S 5162 5161 1511 34817 1511 4202496 86875 0 1 0 594 32 0 0 25 0 11 0 1304482 901042176 83067 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5175/statm: 219981 83067 1779 10 0 217072 0
[pid=5175/tid=5176] ppid=5162 vsize=879924 CPUtime=3.3
/proc/5175/task/5176/stat : 5176 (java) R 5162 5161 1511 34817 1511 4202560 50284 0 1 0 306 24 0 0 25 0 11 0 1304482 901042176 83067 1283457024 134512640 134550932 4293322528 18446744073709551615 4095769702 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5175/tid=5177] ppid=5162 vsize=879924 CPUtime=0.57
/proc/5175/task/5177/stat : 5177 (java) S 5162 5161 1511 34817 1511 4202560 25327 0 0 0 51 6 0 0 16 0 11 0 1304484 901042176 83067 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 0 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5178] ppid=5162 vsize=879924 CPUtime=0
/proc/5175/task/5178/stat : 5178 (java) S 5162 5161 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 1304484 901042176 83067 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5179] ppid=5162 vsize=879924 CPUtime=0
/proc/5175/task/5179/stat : 5179 (java) S 5162 5161 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1304484 901042176 83067 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5180] ppid=5162 vsize=879924 CPUtime=0
/proc/5175/task/5180/stat : 5180 (java) S 5162 5161 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1304487 901042176 83067 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5181] ppid=5162 vsize=879924 CPUtime=2.24
/proc/5175/task/5181/stat : 5181 (java) S 5162 5161 1511 34817 1511 4202560 9587 0 0 0 224 0 0 0 16 0 11 0 1304487 901042176 83067 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5182] ppid=5162 vsize=879924 CPUtime=0.11
/proc/5175/task/5182/stat : 5182 (java) S 5162 5161 1511 34817 1511 4202560 599 0 0 0 11 0 0 0 23 0 11 0 1304487 901042176 83067 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5183] ppid=5162 vsize=879924 CPUtime=0
/proc/5175/task/5183/stat : 5183 (java) S 5162 5161 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 11 0 1304487 901042176 83067 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5184] ppid=5162 vsize=879924 CPUtime=0
/proc/5175/task/5184/stat : 5184 (java) S 5162 5161 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 11 0 1304487 901042176 83067 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5185] ppid=5162 vsize=879924 CPUtime=0
/proc/5175/task/5185/stat : 5185 (java) S 5162 5161 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 1304992 901042176 83067 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 6.28
Current children cumulated vsize (KiB) 885068

[startup+12.7096 s]
/proc/loadavg: 1.14 1.07 1.02 2/46 5185
/proc/meminfo: memFree=186752/1048576 swapFree=0/0
[pid=5161] ppid=5160 vsize=2568 CPUtime=0
/proc/5161/stat : 5161 (p2cudf-trendy-1) S 5160 5161 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 18 0 1 0 1304478 2629632 271 1283457024 134512640 135304128 4289328320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5161/statm: 642 271 230 194 0 29 0
[pid=5162] ppid=5161 vsize=2576 CPUtime=0.02
/proc/5162/stat : 5162 (p2cudf) S 5161 5161 1511 34817 1511 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 1304478 2637824 281 1283457024 134512640 135304128 4290909744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5162/statm: 644 281 239 194 0 31 0
[pid=5175] ppid=5162 vsize=879064 CPUtime=12.66
/proc/5175/stat : 5175 (java) S 5162 5161 1511 34817 1511 4202496 93103 0 1 0 1230 36 0 0 25 0 11 0 1304482 900161536 89112 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5175/statm: 219766 89112 1788 10 0 216857 0
[pid=5175/tid=5176] ppid=5162 vsize=879064 CPUtime=9.03
/proc/5175/task/5176/stat : 5176 (java) R 5162 5161 1511 34817 1511 4202560 50287 0 1 0 878 25 0 0 25 0 11 0 1304482 900161536 89112 1283457024 134512640 134550932 4293322528 18446744073709551615 4095945156 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5175/tid=5177] ppid=5162 vsize=879064 CPUtime=0.89
/proc/5175/task/5177/stat : 5177 (java) S 5162 5161 1511 34817 1511 4202560 31505 0 0 0 80 9 0 0 15 0 11 0 1304484 900161536 89112 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 0 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5178] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5178/stat : 5178 (java) S 5162 5161 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 1304484 900161536 89112 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5179] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5179/stat : 5179 (java) S 5162 5161 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1304484 900161536 89112 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5180] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5180/stat : 5180 (java) S 5162 5161 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1304487 900161536 89112 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5181] ppid=5162 vsize=879064 CPUtime=2.58
/proc/5175/task/5181/stat : 5181 (java) S 5162 5161 1511 34817 1511 4202560 9634 0 0 0 258 0 0 0 16 0 11 0 1304487 900161536 89112 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5182] ppid=5162 vsize=879064 CPUtime=0.11
/proc/5175/task/5182/stat : 5182 (java) S 5162 5161 1511 34817 1511 4202560 599 0 0 0 11 0 0 0 23 0 11 0 1304487 900161536 89112 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5183] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5183/stat : 5183 (java) S 5162 5161 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 11 0 1304487 900161536 89112 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5184] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5184/stat : 5184 (java) S 5162 5161 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 11 0 1304487 900161536 89112 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5185] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5185/stat : 5185 (java) S 5162 5161 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 1304992 900161536 89112 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 12.68
Current children cumulated vsize (KiB) 884208

[startup+25.5126 s]
/proc/loadavg: 1.12 1.07 1.01 2/46 5185
/proc/meminfo: memFree=185884/1048576 swapFree=0/0
[pid=5161] ppid=5160 vsize=2568 CPUtime=0
/proc/5161/stat : 5161 (p2cudf-trendy-1) S 5160 5161 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 18 0 1 0 1304478 2629632 271 1283457024 134512640 135304128 4289328320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5161/statm: 642 271 230 194 0 29 0
[pid=5162] ppid=5161 vsize=2576 CPUtime=0.02
/proc/5162/stat : 5162 (p2cudf) S 5161 5161 1511 34817 1511 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 1304478 2637824 281 1283457024 134512640 135304128 4290909744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5162/statm: 644 281 239 194 0 31 0
[pid=5175] ppid=5162 vsize=879064 CPUtime=25.45
/proc/5175/stat : 5175 (java) S 5162 5161 1511 34817 1511 4202496 93301 0 1 0 2509 36 0 0 25 0 11 0 1304482 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5175/statm: 219766 89310 1788 10 0 216857 0
[pid=5175/tid=5176] ppid=5162 vsize=879064 CPUtime=20.84
/proc/5175/task/5176/stat : 5176 (java) R 5162 5161 1511 34817 1511 4202560 50287 0 1 0 2059 25 0 0 25 0 11 0 1304482 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4095748480 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5175/tid=5177] ppid=5162 vsize=879064 CPUtime=1.82
/proc/5175/task/5177/stat : 5177 (java) S 5162 5161 1511 34817 1511 4202560 31702 0 0 0 173 9 0 0 15 0 11 0 1304484 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 0 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5178] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5178/stat : 5178 (java) S 5162 5161 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 1304484 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5179] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5179/stat : 5179 (java) S 5162 5161 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1304484 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5180] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5180/stat : 5180 (java) S 5162 5161 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5181] ppid=5162 vsize=879064 CPUtime=2.64
/proc/5175/task/5181/stat : 5181 (java) S 5162 5161 1511 34817 1511 4202560 9635 0 0 0 264 0 0 0 16 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5182] ppid=5162 vsize=879064 CPUtime=0.11
/proc/5175/task/5182/stat : 5182 (java) S 5162 5161 1511 34817 1511 4202560 599 0 0 0 11 0 0 0 23 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5183] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5183/stat : 5183 (java) S 5162 5161 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5184] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5184/stat : 5184 (java) S 5162 5161 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5185] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5185/stat : 5185 (java) S 5162 5161 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 1304992 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 25.47
Current children cumulated vsize (KiB) 884208

[startup+51.1109 s]
/proc/loadavg: 1.08 1.06 1.01 2/46 5185
/proc/meminfo: memFree=185884/1048576 swapFree=0/0
[pid=5161] ppid=5160 vsize=2568 CPUtime=0
/proc/5161/stat : 5161 (p2cudf-trendy-1) S 5160 5161 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 18 0 1 0 1304478 2629632 271 1283457024 134512640 135304128 4289328320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5161/statm: 642 271 230 194 0 29 0
[pid=5162] ppid=5161 vsize=2576 CPUtime=0.02
/proc/5162/stat : 5162 (p2cudf) S 5161 5161 1511 34817 1511 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 1304478 2637824 281 1283457024 134512640 135304128 4290909744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5162/statm: 644 281 239 194 0 31 0
[pid=5175] ppid=5162 vsize=879064 CPUtime=51.03
/proc/5175/stat : 5175 (java) S 5162 5161 1511 34817 1511 4202496 93301 0 1 0 5067 36 0 0 25 0 11 0 1304482 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5175/statm: 219766 89310 1788 10 0 216857 0
[pid=5175/tid=5176] ppid=5162 vsize=879064 CPUtime=44.97
/proc/5175/task/5176/stat : 5176 (java) R 5162 5161 1511 34817 1511 4202560 50287 0 1 0 4472 25 0 0 25 0 11 0 1304482 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4094992220 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5175/tid=5177] ppid=5162 vsize=879064 CPUtime=3.26
/proc/5175/task/5177/stat : 5177 (java) S 5162 5161 1511 34817 1511 4202560 31702 0 0 0 317 9 0 0 15 0 11 0 1304484 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 0 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5178] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5178/stat : 5178 (java) S 5162 5161 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 1304484 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5179] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5179/stat : 5179 (java) S 5162 5161 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1304484 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5180] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5180/stat : 5180 (java) S 5162 5161 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5181] ppid=5162 vsize=879064 CPUtime=2.65
/proc/5175/task/5181/stat : 5181 (java) S 5162 5161 1511 34817 1511 4202560 9635 0 0 0 265 0 0 0 15 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5182] ppid=5162 vsize=879064 CPUtime=0.11
/proc/5175/task/5182/stat : 5182 (java) S 5162 5161 1511 34817 1511 4202560 599 0 0 0 11 0 0 0 23 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5183] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5183/stat : 5183 (java) S 5162 5161 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5184] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5184/stat : 5184 (java) S 5162 5161 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5185] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5185/stat : 5185 (java) S 5162 5161 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 1304992 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 51.05
Current children cumulated vsize (KiB) 884208

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

[startup+63.9138 s]
/proc/loadavg: 1.06 1.06 1.01 2/46 5185
/proc/meminfo: memFree=185884/1048576 swapFree=0/0
[pid=5161] ppid=5160 vsize=2568 CPUtime=0
/proc/5161/stat : 5161 (p2cudf-trendy-1) S 5160 5161 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 18 0 1 0 1304478 2629632 271 1283457024 134512640 135304128 4289328320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5161/statm: 642 271 230 194 0 29 0
[pid=5162] ppid=5161 vsize=2576 CPUtime=0.02
/proc/5162/stat : 5162 (p2cudf) S 5161 5161 1511 34817 1511 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 1304478 2637824 281 1283457024 134512640 135304128 4290909744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5162/statm: 644 281 239 194 0 31 0
[pid=5175] ppid=5162 vsize=879064 CPUtime=63.82
/proc/5175/stat : 5175 (java) S 5162 5161 1511 34817 1511 4202496 93301 0 1 0 6346 36 0 0 25 0 11 0 1304482 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5175/statm: 219766 89310 1788 10 0 216857 0
[pid=5175/tid=5176] ppid=5162 vsize=879064 CPUtime=57.48
/proc/5175/task/5176/stat : 5176 (java) R 5162 5161 1511 34817 1511 4202560 50287 0 1 0 5723 25 0 0 25 0 11 0 1304482 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4095802117 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5175/tid=5177] ppid=5162 vsize=879064 CPUtime=3.54
/proc/5175/task/5177/stat : 5177 (java) S 5162 5161 1511 34817 1511 4202560 31702 0 0 0 345 9 0 0 15 0 11 0 1304484 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 0 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5178] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5178/stat : 5178 (java) S 5162 5161 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 1304484 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5179] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5179/stat : 5179 (java) S 5162 5161 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1304484 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5180] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5180/stat : 5180 (java) S 5162 5161 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5181] ppid=5162 vsize=879064 CPUtime=2.65
/proc/5175/task/5181/stat : 5181 (java) S 5162 5161 1511 34817 1511 4202560 9635 0 0 0 265 0 0 0 15 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5182] ppid=5162 vsize=879064 CPUtime=0.11
/proc/5175/task/5182/stat : 5182 (java) S 5162 5161 1511 34817 1511 4202560 599 0 0 0 11 0 0 0 23 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5183] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5183/stat : 5183 (java) S 5162 5161 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5184] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5184/stat : 5184 (java) S 5162 5161 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5185] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5185/stat : 5185 (java) S 5162 5161 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 1304992 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 63.84
Current children cumulated vsize (KiB) 884208

[startup+70.3153 s]
/proc/loadavg: 1.14 1.07 1.02 2/46 5185
/proc/meminfo: memFree=185884/1048576 swapFree=0/0
[pid=5161] ppid=5160 vsize=2568 CPUtime=0
/proc/5161/stat : 5161 (p2cudf-trendy-1) S 5160 5161 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 18 0 1 0 1304478 2629632 271 1283457024 134512640 135304128 4289328320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5161/statm: 642 271 230 194 0 29 0
[pid=5162] ppid=5161 vsize=2576 CPUtime=0.02
/proc/5162/stat : 5162 (p2cudf) S 5161 5161 1511 34817 1511 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 1304478 2637824 281 1283457024 134512640 135304128 4290909744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5162/statm: 644 281 239 194 0 31 0
[pid=5175] ppid=5162 vsize=879064 CPUtime=70.22
/proc/5175/stat : 5175 (java) S 5162 5161 1511 34817 1511 4202496 93301 0 1 0 6985 37 0 0 25 0 11 0 1304482 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5175/statm: 219766 89310 1788 10 0 216857 0
[pid=5175/tid=5176] ppid=5162 vsize=879064 CPUtime=63.59
/proc/5175/task/5176/stat : 5176 (java) R 5162 5161 1511 34817 1511 4202560 50287 0 1 0 6333 26 0 0 25 0 11 0 1304482 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4095754697 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5175/tid=5177] ppid=5162 vsize=879064 CPUtime=3.83
/proc/5175/task/5177/stat : 5177 (java) S 5162 5161 1511 34817 1511 4202560 31702 0 0 0 374 9 0 0 15 0 11 0 1304484 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 0 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5178] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5178/stat : 5178 (java) S 5162 5161 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 1304484 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5179] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5179/stat : 5179 (java) S 5162 5161 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1304484 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5180] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5180/stat : 5180 (java) S 5162 5161 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5181] ppid=5162 vsize=879064 CPUtime=2.65
/proc/5175/task/5181/stat : 5181 (java) S 5162 5161 1511 34817 1511 4202560 9635 0 0 0 265 0 0 0 15 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5182] ppid=5162 vsize=879064 CPUtime=0.11
/proc/5175/task/5182/stat : 5182 (java) S 5162 5161 1511 34817 1511 4202560 599 0 0 0 11 0 0 0 23 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5183] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5183/stat : 5183 (java) S 5162 5161 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5184] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5184/stat : 5184 (java) S 5162 5161 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5185] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5185/stat : 5185 (java) S 5162 5161 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 1304992 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 70.24
Current children cumulated vsize (KiB) 884208

[startup+76.707 s]
/proc/loadavg: 1.12 1.07 1.01 2/46 5185
/proc/meminfo: memFree=185884/1048576 swapFree=0/0
[pid=5161] ppid=5160 vsize=2568 CPUtime=0
/proc/5161/stat : 5161 (p2cudf-trendy-1) S 5160 5161 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 18 0 1 0 1304478 2629632 271 1283457024 134512640 135304128 4289328320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5161/statm: 642 271 230 194 0 29 0
[pid=5162] ppid=5161 vsize=2576 CPUtime=0.02
/proc/5162/stat : 5162 (p2cudf) S 5161 5161 1511 34817 1511 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 1304478 2637824 281 1283457024 134512640 135304128 4290909744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5162/statm: 644 281 239 194 0 31 0
[pid=5175] ppid=5162 vsize=879064 CPUtime=76.61
/proc/5175/stat : 5175 (java) S 5162 5161 1511 34817 1511 4202496 93301 0 1 0 7624 37 0 0 25 0 11 0 1304482 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5175/statm: 219766 89310 1788 10 0 216857 0
[pid=5175/tid=5176] ppid=5162 vsize=879064 CPUtime=69.68
/proc/5175/task/5176/stat : 5176 (java) R 5162 5161 1511 34817 1511 4202560 50287 0 1 0 6942 26 0 0 25 0 11 0 1304482 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4095748483 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5175/tid=5177] ppid=5162 vsize=879064 CPUtime=4.13
/proc/5175/task/5177/stat : 5177 (java) S 5162 5161 1511 34817 1511 4202560 31702 0 0 0 404 9 0 0 15 0 11 0 1304484 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 0 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5178] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5178/stat : 5178 (java) S 5162 5161 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 1304484 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5179] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5179/stat : 5179 (java) S 5162 5161 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1304484 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5180] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5180/stat : 5180 (java) S 5162 5161 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5181] ppid=5162 vsize=879064 CPUtime=2.65
/proc/5175/task/5181/stat : 5181 (java) S 5162 5161 1511 34817 1511 4202560 9635 0 0 0 265 0 0 0 15 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5182] ppid=5162 vsize=879064 CPUtime=0.11
/proc/5175/task/5182/stat : 5182 (java) S 5162 5161 1511 34817 1511 4202560 599 0 0 0 11 0 0 0 23 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5183] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5183/stat : 5183 (java) S 5162 5161 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5184] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5184/stat : 5184 (java) S 5162 5161 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5185] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5185/stat : 5185 (java) S 5162 5161 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 1304992 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 76.63
Current children cumulated vsize (KiB) 884208

[startup+78.3074 s]
/proc/loadavg: 1.11 1.07 1.01 2/46 5185
/proc/meminfo: memFree=185884/1048576 swapFree=0/0
[pid=5161] ppid=5160 vsize=2568 CPUtime=0
/proc/5161/stat : 5161 (p2cudf-trendy-1) S 5160 5161 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 18 0 1 0 1304478 2629632 271 1283457024 134512640 135304128 4289328320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5161/statm: 642 271 230 194 0 29 0
[pid=5162] ppid=5161 vsize=2576 CPUtime=0.02
/proc/5162/stat : 5162 (p2cudf) S 5161 5161 1511 34817 1511 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 1304478 2637824 281 1283457024 134512640 135304128 4290909744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5162/statm: 644 281 239 194 0 31 0
[pid=5175] ppid=5162 vsize=879064 CPUtime=78.21
/proc/5175/stat : 5175 (java) S 5162 5161 1511 34817 1511 4202496 93301 0 1 0 7784 37 0 0 25 0 11 0 1304482 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5175/statm: 219766 89310 1788 10 0 216857 0
[pid=5175/tid=5176] ppid=5162 vsize=879064 CPUtime=71.28
/proc/5175/task/5176/stat : 5176 (java) R 5162 5161 1511 34817 1511 4202560 50287 0 1 0 7102 26 0 0 25 0 11 0 1304482 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4095810660 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5175/tid=5177] ppid=5162 vsize=879064 CPUtime=4.13
/proc/5175/task/5177/stat : 5177 (java) S 5162 5161 1511 34817 1511 4202560 31702 0 0 0 404 9 0 0 15 0 11 0 1304484 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 0 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5178] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5178/stat : 5178 (java) S 5162 5161 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 1304484 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5179] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5179/stat : 5179 (java) S 5162 5161 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1304484 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5180] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5180/stat : 5180 (java) S 5162 5161 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5181] ppid=5162 vsize=879064 CPUtime=2.65
/proc/5175/task/5181/stat : 5181 (java) S 5162 5161 1511 34817 1511 4202560 9635 0 0 0 265 0 0 0 15 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5182] ppid=5162 vsize=879064 CPUtime=0.11
/proc/5175/task/5182/stat : 5182 (java) S 5162 5161 1511 34817 1511 4202560 599 0 0 0 11 0 0 0 23 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5183] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5183/stat : 5183 (java) S 5162 5161 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5184] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5184/stat : 5184 (java) S 5162 5161 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5185] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5185/stat : 5185 (java) S 5162 5161 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 1304992 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 78.23
Current children cumulated vsize (KiB) 884208

[startup+79.1077 s]
/proc/loadavg: 1.11 1.07 1.01 2/46 5185
/proc/meminfo: memFree=185884/1048576 swapFree=0/0
[pid=5161] ppid=5160 vsize=2568 CPUtime=0
/proc/5161/stat : 5161 (p2cudf-trendy-1) S 5160 5161 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 18 0 1 0 1304478 2629632 271 1283457024 134512640 135304128 4289328320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5161/statm: 642 271 230 194 0 29 0
[pid=5162] ppid=5161 vsize=2576 CPUtime=0.02
/proc/5162/stat : 5162 (p2cudf) S 5161 5161 1511 34817 1511 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 1304478 2637824 281 1283457024 134512640 135304128 4290909744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5162/statm: 644 281 239 194 0 31 0
[pid=5175] ppid=5162 vsize=879064 CPUtime=79.01
/proc/5175/stat : 5175 (java) S 5162 5161 1511 34817 1511 4202496 93301 0 1 0 7864 37 0 0 25 0 11 0 1304482 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5175/statm: 219766 89310 1788 10 0 216857 0
[pid=5175/tid=5176] ppid=5162 vsize=879064 CPUtime=72.08
/proc/5175/task/5176/stat : 5176 (java) R 5162 5161 1511 34817 1511 4202560 50287 0 1 0 7182 26 0 0 25 0 11 0 1304482 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4095748300 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5175/tid=5177] ppid=5162 vsize=879064 CPUtime=4.13
/proc/5175/task/5177/stat : 5177 (java) S 5162 5161 1511 34817 1511 4202560 31702 0 0 0 404 9 0 0 15 0 11 0 1304484 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 0 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5178] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5178/stat : 5178 (java) S 5162 5161 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 1304484 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5179] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5179/stat : 5179 (java) S 5162 5161 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1304484 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5180] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5180/stat : 5180 (java) S 5162 5161 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5181] ppid=5162 vsize=879064 CPUtime=2.65
/proc/5175/task/5181/stat : 5181 (java) S 5162 5161 1511 34817 1511 4202560 9635 0 0 0 265 0 0 0 15 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5182] ppid=5162 vsize=879064 CPUtime=0.11
/proc/5175/task/5182/stat : 5182 (java) S 5162 5161 1511 34817 1511 4202560 599 0 0 0 11 0 0 0 23 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5183] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5183/stat : 5183 (java) S 5162 5161 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5184] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5184/stat : 5184 (java) S 5162 5161 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 11 0 1304487 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5185] ppid=5162 vsize=879064 CPUtime=0
/proc/5175/task/5185/stat : 5185 (java) S 5162 5161 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 1304992 900161536 89310 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 79.03
Current children cumulated vsize (KiB) 884208

[startup+79.9026 s]
/proc/loadavg: 1.11 1.07 1.01 2/46 5185
/proc/meminfo: memFree=185884/1048576 swapFree=0/0
[pid=5161] ppid=5160 vsize=2568 CPUtime=0
/proc/5161/stat : 5161 (p2cudf-trendy-1) S 5160 5161 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 18 0 1 0 1304478 2629632 271 1283457024 134512640 135304128 4289328320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5161/statm: 642 271 230 194 0 29 0
[pid=5162] ppid=5161 vsize=2576 CPUtime=0.02
/proc/5162/stat : 5162 (p2cudf) S 5161 5161 1511 34817 1511 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 1304478 2637824 281 1283457024 134512640 135304128 4290909744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5162/statm: 644 281 239 194 0 31 0
[pid=5175] ppid=5162 vsize=879388 CPUtime=79.73
/proc/5175/stat : 5175 (java) S 5162 5161 1511 34817 1511 4202496 93314 0 1 0 7936 37 0 0 25 0 11 0 1304482 900493312 89323 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5175/statm: 219847 89323 1789 10 0 216938 0
[pid=5175/tid=5176] ppid=5162 vsize=879388 CPUtime=72.76
/proc/5175/task/5176/stat : 5176 (java) S 5162 5161 1511 34817 1511 4202560 50294 0 1 0 7250 26 0 0 25 0 11 0 1304482 900493312 89323 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5177] ppid=5162 vsize=879388 CPUtime=4.13
/proc/5175/task/5177/stat : 5177 (java) S 5162 5161 1511 34817 1511 4202560 31702 0 0 0 404 9 0 0 16 0 11 0 1304484 900493312 89323 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 0 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5178] ppid=5162 vsize=879388 CPUtime=0
/proc/5175/task/5178/stat : 5178 (java) S 5162 5161 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 1304484 900493312 89323 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5179] ppid=5162 vsize=879388 CPUtime=0
/proc/5175/task/5179/stat : 5179 (java) S 5162 5161 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1304484 900493312 89323 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5180] ppid=5162 vsize=879388 CPUtime=0
/proc/5175/task/5180/stat : 5180 (java) S 5162 5161 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1304487 900493312 89323 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5181] ppid=5162 vsize=879388 CPUtime=2.69
/proc/5175/task/5181/stat : 5181 (java) S 5162 5161 1511 34817 1511 4202560 9635 0 0 0 269 0 0 0 15 0 11 0 1304487 900493312 89323 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5182] ppid=5162 vsize=879388 CPUtime=0.11
/proc/5175/task/5182/stat : 5182 (java) S 5162 5161 1511 34817 1511 4202560 599 0 0 0 11 0 0 0 23 0 11 0 1304487 900493312 89323 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5183] ppid=5162 vsize=879388 CPUtime=0
/proc/5175/task/5183/stat : 5183 (java) S 5162 5161 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 11 0 1304487 900493312 89323 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5184] ppid=5162 vsize=879388 CPUtime=0
/proc/5175/task/5184/stat : 5184 (java) S 5162 5161 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 11 0 1304487 900493312 89323 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 79.75
Current children cumulated vsize (KiB) 884532

[startup+80.3067 s]
/proc/loadavg: 1.11 1.07 1.01 1/46 5186
/proc/meminfo: memFree=185760/1048576 swapFree=0/0
[pid=5161] ppid=5160 vsize=2568 CPUtime=0
/proc/5161/stat : 5161 (p2cudf-trendy-1) S 5160 5161 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 18 0 1 0 1304478 2629632 271 1283457024 134512640 135304128 4289328320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5161/statm: 642 271 230 194 0 29 0
[pid=5162] ppid=5161 vsize=2576 CPUtime=0.02
/proc/5162/stat : 5162 (p2cudf) S 5161 5161 1511 34817 1511 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 1304478 2637824 281 1283457024 134512640 135304128 4290909744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5162/statm: 644 281 239 194 0 31 0
[pid=5175] ppid=5162 vsize=879388 CPUtime=79.73
/proc/5175/stat : 5175 (java) S 5162 5161 1511 34817 1511 4202496 93314 0 1 0 7936 37 0 0 25 0 11 0 1304482 900493312 89323 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5175/statm: 219847 89323 1789 10 0 216938 0
[pid=5175/tid=5176] ppid=5162 vsize=879388 CPUtime=72.76
/proc/5175/task/5176/stat : 5176 (java) S 5162 5161 1511 34817 1511 4202560 50294 0 1 0 7250 26 0 0 25 0 11 0 1304482 900493312 89323 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5177] ppid=5162 vsize=879388 CPUtime=4.13
/proc/5175/task/5177/stat : 5177 (java) S 5162 5161 1511 34817 1511 4202560 31702 0 0 0 404 9 0 0 16 0 11 0 1304484 900493312 89323 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 0 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5178] ppid=5162 vsize=879388 CPUtime=0
/proc/5175/task/5178/stat : 5178 (java) S 5162 5161 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 1304484 900493312 89323 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5179] ppid=5162 vsize=879388 CPUtime=0
/proc/5175/task/5179/stat : 5179 (java) S 5162 5161 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1304484 900493312 89323 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5180] ppid=5162 vsize=879388 CPUtime=0
/proc/5175/task/5180/stat : 5180 (java) S 5162 5161 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1304487 900493312 89323 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5181] ppid=5162 vsize=879388 CPUtime=2.69
/proc/5175/task/5181/stat : 5181 (java) S 5162 5161 1511 34817 1511 4202560 9635 0 0 0 269 0 0 0 15 0 11 0 1304487 900493312 89323 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5182] ppid=5162 vsize=879388 CPUtime=0.11
/proc/5175/task/5182/stat : 5182 (java) S 5162 5161 1511 34817 1511 4202560 599 0 0 0 11 0 0 0 23 0 11 0 1304487 900493312 89323 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5183] ppid=5162 vsize=879388 CPUtime=0
/proc/5175/task/5183/stat : 5183 (java) S 5162 5161 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 11 0 1304487 900493312 89323 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5184] ppid=5162 vsize=879388 CPUtime=0
/proc/5175/task/5184/stat : 5184 (java) S 5162 5161 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 11 0 1304487 900493312 89323 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5186] ppid=5162 vsize=879388 CPUtime=0
/proc/5175/task/5186/stat : 5186 (java) S 5162 5161 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 25 0 11 0 1312461 900493312 89323 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 79.75
Current children cumulated vsize (KiB) 884532

[startup+80.4066 s]
/proc/loadavg: 1.11 1.07 1.01 1/46 5186
/proc/meminfo: memFree=185760/1048576 swapFree=0/0
[pid=5161] ppid=5160 vsize=2568 CPUtime=0
/proc/5161/stat : 5161 (p2cudf-trendy-1) S 5160 5161 1511 34817 1511 4202496 376 0 0 0 0 0 0 0 18 0 1 0 1304478 2629632 271 1283457024 134512640 135304128 4289328320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5161/statm: 642 271 230 194 0 29 0
[pid=5162] ppid=5161 vsize=2576 CPUtime=0.02
/proc/5162/stat : 5162 (p2cudf) S 5161 5161 1511 34817 1511 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 1304478 2637824 281 1283457024 134512640 135304128 4290909744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5162/statm: 644 281 239 194 0 31 0
[pid=5175] ppid=5162 vsize=879388 CPUtime=79.78
/proc/5175/stat : 5175 (java) S 5162 5161 1511 34817 1511 4202496 93316 0 1 0 7940 38 0 0 25 0 10 0 1304482 900493312 89325 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5175/statm: 219847 89325 1789 10 0 216938 0
[pid=5175/tid=5176] ppid=5162 vsize=879388 CPUtime=72.76
/proc/5175/task/5176/stat : 5176 (java) S 5162 5161 1511 34817 1511 4202560 50294 0 1 0 7250 26 0 0 20 0 10 0 1304482 900493312 89325 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5177] ppid=5162 vsize=879388 CPUtime=4.13
/proc/5175/task/5177/stat : 5177 (java) S 5162 5161 1511 34817 1511 4202560 31702 0 0 0 404 9 0 0 16 0 10 0 1304484 900493312 89325 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 0 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5178] ppid=5162 vsize=879388 CPUtime=0
/proc/5175/task/5178/stat : 5178 (java) S 5162 5161 1511 34817 1511 4202560 9 0 0 0 0 0 0 0 18 0 10 0 1304484 900493312 89325 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5179] ppid=5162 vsize=879388 CPUtime=0
/proc/5175/task/5179/stat : 5179 (java) S 5162 5161 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 10 0 1304484 900493312 89325 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5180] ppid=5162 vsize=879388 CPUtime=0
/proc/5175/task/5180/stat : 5180 (java) S 5162 5161 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 1304487 900493312 89325 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5181] ppid=5162 vsize=879388 CPUtime=2.7
/proc/5175/task/5181/stat : 5181 (java) S 5162 5161 1511 34817 1511 4202560 9635 0 0 0 270 0 0 0 16 0 10 0 1304487 900493312 89325 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5182] ppid=5162 vsize=879388 CPUtime=0.11
/proc/5175/task/5182/stat : 5182 (java) S 5162 5161 1511 34817 1511 4202560 599 0 0 0 11 0 0 0 23 0 10 0 1304487 900493312 89325 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5183] ppid=5162 vsize=879388 CPUtime=0
/proc/5175/task/5183/stat : 5183 (java) S 5162 5161 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 10 0 1304487 900493312 89325 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 18446612133275974720 0 0 -1 0 0 0 0
[pid=5175/tid=5184] ppid=5162 vsize=879388 CPUtime=0
/proc/5175/task/5184/stat : 5184 (java) R 5162 5161 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 10 0 1304487 900493312 89325 1283457024 134512640 134550932 4293322528 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 79.8
Current children cumulated vsize (KiB) 884532

Child status: 0
Real time (s): 80.4268
CPU time (s): 79.837
CPU user time (s): 79.437
CPU system time (s): 0.400025
CPU usage (%): 99.2666
Max. virtual memory (cumulated for all children) (KiB): 885492

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 79.437
system time used= 0.400025
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 97124
page faults= 2
swaps= 0
block input operations= 0
block output operations= 0
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 2323
involuntary context switches= 3040

runsolver used 0 second user time and 0 second system time

The end