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/201108251442/p2cudf-paranoid-1.13/rand519.cudf.s-e-l-s-s.log.runsolver ./p2cudf-paranoid-1.13 /home/misc2010/data/2011/incremental/s-e-l-s-s//rand519.cudf /home/misc2010/tmp/201108251442/p2cudf-paranoid-1.13/rand519.cudf.s-e-l-s-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 1.03 1.05 5/36 10982
/proc/meminfo: memFree=276632/1048576 swapFree=0/0
[pid=10979] ppid=10978 vsize=2564 CPUtime=0
/proc/10979/stat : 10979 (p2cudf-paranoid) S 10978 10979 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 18 0 1 0 10475083 2625536 270 1283457024 134512640 135304128 4288015216 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10979/statm: 641 270 230 194 0 28 0
[pid=10980] ppid=10979 vsize=2568 CPUtime=0
/proc/10980/stat : 10980 (p2cudf) S 10979 10979 4778 34817 4778 4202496 354 0 0 0 0 0 0 0 18 0 1 0 10475083 2629632 272 1283457024 134512640 135304128 4291110528 18446744073709551615 4294960130 0 0 4 65536 18446744071564457842 0 0 17 0 0 0 0
/proc/10980/statm: 642 272 231 194 0 29 0
[pid=10981] ppid=10980 vsize=2568 CPUtime=0
/proc/10981/stat : 10981 (p2cudf) R 10980 10979 4778 34817 4778 4202560 94 0 0 0 0 0 0 0 25 0 1 0 10475083 2629632 119 1283457024 134512640 135304128 4291110528 18446744073709551615 4294960130 0 65538 0 65538 0 0 0 17 0 0 0 0
/proc/10981/statm: 642 119 77 194 0 29 0
[pid=10982] ppid=10981 vsize=2568 CPUtime=0
/proc/10982/stat : 10982 (p2cudf) R 10981 10979 4778 34817 4778 4202560 0 0 0 0 0 0 0 0 25 0 1 0 10475083 2629632 42 1283457024 134512640 135304128 4291110528 18446744073709551615 4294960130 0 65538 0 65538 0 0 0 17 0 0 0 0
/proc/10982/statm: 642 42 0 194 0 29 0

[startup+0.145396 s]
/proc/loadavg: 0.85 1.03 1.05 5/36 10982
/proc/meminfo: memFree=276632/1048576 swapFree=0/0
[pid=10979] ppid=10978 vsize=2564 CPUtime=0
/proc/10979/stat : 10979 (p2cudf-paranoid) S 10978 10979 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 18 0 1 0 10475083 2625536 270 1283457024 134512640 135304128 4288015216 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10979/statm: 641 270 230 194 0 28 0
[pid=10980] ppid=10979 vsize=2572 CPUtime=0.02
/proc/10980/stat : 10980 (p2cudf) S 10979 10979 4778 34817 4778 4202496 390 3015 0 1 0 0 2 0 25 0 1 0 10475083 2633728 281 1283457024 134512640 135304128 4291110528 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10980/statm: 643 281 239 194 0 30 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5136

[startup+0.205394 s]
/proc/loadavg: 0.85 1.03 1.05 5/36 10982
/proc/meminfo: memFree=276632/1048576 swapFree=0/0
[pid=10979] ppid=10978 vsize=2564 CPUtime=0
/proc/10979/stat : 10979 (p2cudf-paranoid) S 10978 10979 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 18 0 1 0 10475083 2625536 270 1283457024 134512640 135304128 4288015216 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10979/statm: 641 270 230 194 0 28 0
[pid=10980] ppid=10979 vsize=2572 CPUtime=0.02
/proc/10980/stat : 10980 (p2cudf) S 10979 10979 4778 34817 4778 4202496 390 3015 0 1 0 0 2 0 25 0 1 0 10475083 2633728 281 1283457024 134512640 135304128 4291110528 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10980/statm: 643 281 239 194 0 30 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5136

[startup+0.305433 s]
/proc/loadavg: 0.85 1.03 1.05 5/36 10982
/proc/meminfo: memFree=276632/1048576 swapFree=0/0
[pid=10979] ppid=10978 vsize=2564 CPUtime=0
/proc/10979/stat : 10979 (p2cudf-paranoid) S 10978 10979 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 18 0 1 0 10475083 2625536 270 1283457024 134512640 135304128 4288015216 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10979/statm: 641 270 230 194 0 28 0
[pid=10980] ppid=10979 vsize=2572 CPUtime=0.02
/proc/10980/stat : 10980 (p2cudf) S 10979 10979 4778 34817 4778 4202496 390 3015 0 1 0 0 2 0 25 0 1 0 10475083 2633728 281 1283457024 134512640 135304128 4291110528 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10980/statm: 643 281 239 194 0 30 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5136

[startup+0.705542 s]
/proc/loadavg: 0.85 1.03 1.05 5/36 10982
/proc/meminfo: memFree=276632/1048576 swapFree=0/0
[pid=10979] ppid=10978 vsize=2564 CPUtime=0
/proc/10979/stat : 10979 (p2cudf-paranoid) S 10978 10979 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 18 0 1 0 10475083 2625536 270 1283457024 134512640 135304128 4288015216 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10979/statm: 641 270 230 194 0 28 0
[pid=10980] ppid=10979 vsize=2572 CPUtime=0.02
/proc/10980/stat : 10980 (p2cudf) S 10979 10979 4778 34817 4778 4202496 390 3015 0 1 0 0 2 0 25 0 1 0 10475083 2633728 281 1283457024 134512640 135304128 4291110528 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10980/statm: 643 281 239 194 0 30 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5136

[startup+1.50585 s]
/proc/loadavg: 1.02 1.07 1.06 5/45 11002
/proc/meminfo: memFree=219332/1048576 swapFree=0/0
[pid=10979] ppid=10978 vsize=2564 CPUtime=0
/proc/10979/stat : 10979 (p2cudf-paranoid) S 10978 10979 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 18 0 1 0 10475083 2625536 270 1283457024 134512640 135304128 4288015216 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10979/statm: 641 270 230 194 0 28 0
[pid=10980] ppid=10979 vsize=2572 CPUtime=0.02
/proc/10980/stat : 10980 (p2cudf) S 10979 10979 4778 34817 4778 4202496 390 3015 0 1 0 0 2 0 25 0 1 0 10475083 2633728 281 1283457024 134512640 135304128 4291110528 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10980/statm: 643 281 239 194 0 30 0
[pid=10993] ppid=10980 vsize=898484 CPUtime=1.47
/proc/10993/stat : 10993 (java) S 10980 10979 4778 34817 4778 4202496 25288 0 1 0 140 7 0 0 25 0 10 0 10475086 920047616 21662 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/10993/statm: 224621 21662 1719 10 0 221712 0
[pid=10993/tid=10994] ppid=10980 vsize=898484 CPUtime=0.79
/proc/10993/task/10994/stat : 10994 (java) R 10980 10979 4778 34817 4778 4202560 10678 0 1 0 74 5 0 0 25 0 10 0 10475087 920047616 21662 1283457024 134512640 134550932 4292251184 18446744073709551615 4094944926 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=10993/tid=10995] ppid=10980 vsize=898484 CPUtime=0
/proc/10993/task/10995/stat : 10995 (java) S 10980 10979 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 17 0 10 0 10475089 920047616 21662 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 0 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10996] ppid=10980 vsize=898484 CPUtime=0
/proc/10993/task/10996/stat : 10996 (java) S 10980 10979 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 25 0 10 0 10475089 920047616 21662 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10997] ppid=10980 vsize=898484 CPUtime=0
/proc/10993/task/10997/stat : 10997 (java) S 10980 10979 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 10 0 10475089 920047616 21662 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10998] ppid=10980 vsize=898484 CPUtime=0
/proc/10993/task/10998/stat : 10998 (java) S 10980 10979 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 10475092 920047616 21662 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10999] ppid=10980 vsize=898484 CPUtime=0.44
/proc/10993/task/10999/stat : 10999 (java) R 10980 10979 4778 34817 4778 4202560 8909 0 0 0 44 0 0 0 25 0 10 0 10475092 920047616 21662 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=10993/tid=11000] ppid=10980 vsize=898484 CPUtime=0.2
/proc/10993/task/11000/stat : 11000 (java) S 10980 10979 4778 34817 4778 4202560 4621 0 0 0 20 0 0 0 22 0 10 0 10475092 920047616 21662 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11001] ppid=10980 vsize=898484 CPUtime=0
/proc/10993/task/11001/stat : 11001 (java) S 10980 10979 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 10475092 920047616 21662 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11002] ppid=10980 vsize=898484 CPUtime=0
/proc/10993/task/11002/stat : 11002 (java) S 10980 10979 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 10 0 10475092 920047616 21662 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 1.49
Current children cumulated vsize (KiB) 903620

[startup+3.10635 s]
/proc/loadavg: 1.02 1.07 1.06 3/45 11002
/proc/meminfo: memFree=119636/1048576 swapFree=0/0
[pid=10979] ppid=10978 vsize=2564 CPUtime=0
/proc/10979/stat : 10979 (p2cudf-paranoid) S 10978 10979 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 18 0 1 0 10475083 2625536 270 1283457024 134512640 135304128 4288015216 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10979/statm: 641 270 230 194 0 28 0
[pid=10980] ppid=10979 vsize=2572 CPUtime=0.02
/proc/10980/stat : 10980 (p2cudf) S 10979 10979 4778 34817 4778 4202496 390 3015 0 1 0 0 2 0 25 0 1 0 10475083 2633728 281 1283457024 134512640 135304128 4291110528 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10980/statm: 643 281 239 194 0 30 0
[pid=10993] ppid=10980 vsize=896064 CPUtime=3.06
/proc/10993/stat : 10993 (java) S 10980 10979 4778 34817 4778 4202496 79165 0 1 0 279 27 0 0 25 0 10 0 10475086 917569536 74417 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/10993/statm: 224016 74417 1732 10 0 221107 0
[pid=10993/tid=10994] ppid=10980 vsize=896064 CPUtime=1.73
/proc/10993/task/10994/stat : 10994 (java) R 10980 10979 4778 34817 4778 4202560 50038 0 1 0 153 20 0 0 25 0 10 0 10475087 917569536 74417 1283457024 134512640 134550932 4292251184 18446744073709551615 4095234976 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=10993/tid=10995] ppid=10980 vsize=896064 CPUtime=0.28
/proc/10993/task/10995/stat : 10995 (java) S 10980 10979 4778 34817 4778 4202560 13318 0 0 0 26 2 0 0 16 0 10 0 10475089 917569536 74417 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 0 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10996] ppid=10980 vsize=896064 CPUtime=0.01
/proc/10993/task/10996/stat : 10996 (java) S 10980 10979 4778 34817 4778 4202560 8 0 0 0 0 1 0 0 18 0 10 0 10475089 917569536 74417 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10997] ppid=10980 vsize=896064 CPUtime=0
/proc/10993/task/10997/stat : 10997 (java) S 10980 10979 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 10 0 10475089 917569536 74417 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10998] ppid=10980 vsize=896064 CPUtime=0
/proc/10993/task/10998/stat : 10998 (java) S 10980 10979 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 10475092 917569536 74417 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10999] ppid=10980 vsize=896064 CPUtime=0.6
/proc/10993/task/10999/stat : 10999 (java) S 10980 10979 4778 34817 4778 4202560 9023 0 0 0 58 2 0 0 18 0 10 0 10475092 917569536 74417 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11000] ppid=10980 vsize=896064 CPUtime=0.43
/proc/10993/task/11000/stat : 11000 (java) S 10980 10979 4778 34817 4778 4202560 5710 0 0 0 42 1 0 0 17 0 10 0 10475092 917569536 74417 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11001] ppid=10980 vsize=896064 CPUtime=0
/proc/10993/task/11001/stat : 11001 (java) S 10980 10979 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 10475092 917569536 74417 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11002] ppid=10980 vsize=896064 CPUtime=0
/proc/10993/task/11002/stat : 11002 (java) S 10980 10979 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 10 0 10475092 917569536 74417 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 3.08
Current children cumulated vsize (KiB) 901200

[startup+6.30721 s]
/proc/loadavg: 1.02 1.07 1.06 4/46 11003
/proc/meminfo: memFree=5508/1048576 swapFree=0/0
[pid=10979] ppid=10978 vsize=2564 CPUtime=0
/proc/10979/stat : 10979 (p2cudf-paranoid) S 10978 10979 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 18 0 1 0 10475083 2625536 270 1283457024 134512640 135304128 4288015216 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10979/statm: 641 270 230 194 0 28 0
[pid=10980] ppid=10979 vsize=2572 CPUtime=0.02
/proc/10980/stat : 10980 (p2cudf) S 10979 10979 4778 34817 4778 4202496 390 3015 0 1 0 0 2 0 25 0 1 0 10475083 2633728 281 1283457024 134512640 135304128 4291110528 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10980/statm: 643 281 239 194 0 30 0
[pid=10993] ppid=10980 vsize=896680 CPUtime=6.24
/proc/10993/stat : 10993 (java) S 10980 10979 4778 34817 4778 4202496 96597 0 1 0 592 32 0 0 25 0 11 0 10475086 918200320 89626 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/10993/statm: 224170 89626 1777 10 0 221261 0
[pid=10993/tid=10994] ppid=10980 vsize=896680 CPUtime=3.24
/proc/10993/task/10994/stat : 10994 (java) R 10980 10979 4778 34817 4778 4202560 50277 0 1 0 304 20 0 0 25 0 11 0 10475087 918200320 89626 1283457024 134512640 134550932 4292251184 18446744073709551615 4096025224 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=10993/tid=10995] ppid=10980 vsize=896680 CPUtime=0.64
/proc/10993/task/10995/stat : 10995 (java) S 10980 10979 4778 34817 4778 4202560 28001 0 0 0 56 8 0 0 16 0 11 0 10475089 918200320 89626 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 0 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10996] ppid=10980 vsize=896680 CPUtime=0.01
/proc/10993/task/10996/stat : 10996 (java) S 10980 10979 4778 34817 4778 4202560 8 0 0 0 0 1 0 0 18 0 11 0 10475089 918200320 89626 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10997] ppid=10980 vsize=896680 CPUtime=0
/proc/10993/task/10997/stat : 10997 (java) S 10980 10979 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 10475089 918200320 89626 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10998] ppid=10980 vsize=896680 CPUtime=0
/proc/10993/task/10998/stat : 10998 (java) S 10980 10979 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10475092 918200320 89626 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10999] ppid=10980 vsize=896680 CPUtime=1.92
/proc/10993/task/10999/stat : 10999 (java) S 10980 10979 4778 34817 4778 4202560 11529 0 0 0 190 2 0 0 15 0 11 0 10475092 918200320 89626 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11000] ppid=10980 vsize=896680 CPUtime=0.43
/proc/10993/task/11000/stat : 11000 (java) S 10980 10979 4778 34817 4778 4202560 5710 0 0 0 42 1 0 0 17 0 11 0 10475092 918200320 89626 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11001] ppid=10980 vsize=896680 CPUtime=0
/proc/10993/task/11001/stat : 11001 (java) S 10980 10979 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10475092 918200320 89626 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11002] ppid=10980 vsize=896680 CPUtime=0
/proc/10993/task/11002/stat : 11002 (java) S 10980 10979 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 10475092 918200320 89626 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11003] ppid=10980 vsize=896680 CPUtime=0
/proc/10993/task/11003/stat : 11003 (java) S 10980 10979 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 24 0 11 0 10475614 918200320 89626 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 6.26
Current children cumulated vsize (KiB) 901816

[startup+12.7092 s]
/proc/loadavg: 1.02 1.06 1.06 2/46 11003
/proc/meminfo: memFree=6508/1048576 swapFree=0/0
[pid=10979] ppid=10978 vsize=2564 CPUtime=0
/proc/10979/stat : 10979 (p2cudf-paranoid) S 10978 10979 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 18 0 1 0 10475083 2625536 270 1283457024 134512640 135304128 4288015216 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10979/statm: 641 270 230 194 0 28 0
[pid=10980] ppid=10979 vsize=2572 CPUtime=0.02
/proc/10980/stat : 10980 (p2cudf) S 10979 10979 4778 34817 4778 4202496 390 3015 0 1 0 0 2 0 25 0 1 0 10475083 2633728 281 1283457024 134512640 135304128 4291110528 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10980/statm: 643 281 239 194 0 30 0
[pid=10993] ppid=10980 vsize=894808 CPUtime=12.64
/proc/10993/stat : 10993 (java) S 10980 10979 4778 34817 4778 4202496 96647 0 1 0 1232 32 0 0 25 0 11 0 10475086 916283392 89240 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/10993/statm: 223702 89240 1782 10 0 220793 0
[pid=10993/tid=10994] ppid=10980 vsize=894808 CPUtime=9.24
/proc/10993/task/10994/stat : 10994 (java) R 10980 10979 4778 34817 4778 4202560 50280 0 1 0 904 20 0 0 25 0 11 0 10475087 916283392 89240 1283457024 134512640 134550932 4292251184 18446744073709551615 4095930364 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=10993/tid=10995] ppid=10980 vsize=894808 CPUtime=0.64
/proc/10993/task/10995/stat : 10995 (java) S 10980 10979 4778 34817 4778 4202560 28001 0 0 0 56 8 0 0 15 0 11 0 10475089 916283392 89240 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 0 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10996] ppid=10980 vsize=894808 CPUtime=0.01
/proc/10993/task/10996/stat : 10996 (java) S 10980 10979 4778 34817 4778 4202560 8 0 0 0 0 1 0 0 18 0 11 0 10475089 916283392 89240 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10997] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/10997/stat : 10997 (java) S 10980 10979 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 10475089 916283392 89240 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10998] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/10998/stat : 10998 (java) S 10980 10979 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10475092 916283392 89240 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10999] ppid=10980 vsize=894808 CPUtime=2.31
/proc/10993/task/10999/stat : 10999 (java) S 10980 10979 4778 34817 4778 4202560 11576 0 0 0 229 2 0 0 15 0 11 0 10475092 916283392 89240 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11000] ppid=10980 vsize=894808 CPUtime=0.43
/proc/10993/task/11000/stat : 11000 (java) S 10980 10979 4778 34817 4778 4202560 5710 0 0 0 42 1 0 0 17 0 11 0 10475092 916283392 89240 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11001] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/11001/stat : 11001 (java) S 10980 10979 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10475092 916283392 89240 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11002] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/11002/stat : 11002 (java) S 10980 10979 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 10475092 916283392 89240 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11003] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/11003/stat : 11003 (java) S 10980 10979 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 24 0 11 0 10475614 916283392 89240 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 12.66
Current children cumulated vsize (KiB) 899944

[startup+25.5119 s]
/proc/loadavg: 1.01 1.06 1.06 3/48 11006
/proc/meminfo: memFree=5492/1048576 swapFree=0/0
[pid=10979] ppid=10978 vsize=2564 CPUtime=0
/proc/10979/stat : 10979 (p2cudf-paranoid) S 10978 10979 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 18 0 1 0 10475083 2625536 270 1283457024 134512640 135304128 4288015216 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10979/statm: 641 270 230 194 0 28 0
[pid=10980] ppid=10979 vsize=2572 CPUtime=0.02
/proc/10980/stat : 10980 (p2cudf) S 10979 10979 4778 34817 4778 4202496 390 3015 0 1 0 0 2 0 25 0 1 0 10475083 2633728 281 1283457024 134512640 135304128 4291110528 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10980/statm: 643 281 239 194 0 30 0
[pid=10993] ppid=10980 vsize=894808 CPUtime=25.41
/proc/10993/stat : 10993 (java) S 10980 10979 4778 34817 4778 4202496 105779 0 1 0 2506 35 0 0 25 0 11 0 10475086 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/10993/statm: 223702 98372 1787 10 0 220793 0
[pid=10993/tid=10994] ppid=10980 vsize=894808 CPUtime=20.7
/proc/10993/task/10994/stat : 10994 (java) R 10980 10979 4778 34817 4778 4202560 50281 0 1 0 2050 20 0 0 25 0 11 0 10475087 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4095968947 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=10993/tid=10995] ppid=10980 vsize=894808 CPUtime=1.86
/proc/10993/task/10995/stat : 10995 (java) S 10980 10979 4778 34817 4778 4202560 37117 0 0 0 176 10 0 0 16 0 11 0 10475089 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 0 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10996] ppid=10980 vsize=894808 CPUtime=0.01
/proc/10993/task/10996/stat : 10996 (java) S 10980 10979 4778 34817 4778 4202560 8 0 0 0 0 1 0 0 18 0 11 0 10475089 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10997] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/10997/stat : 10997 (java) S 10980 10979 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 10475089 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10998] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/10998/stat : 10998 (java) S 10980 10979 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10999] ppid=10980 vsize=894808 CPUtime=2.4
/proc/10993/task/10999/stat : 10999 (java) S 10980 10979 4778 34817 4778 4202560 11591 0 0 0 238 2 0 0 15 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11000] ppid=10980 vsize=894808 CPUtime=0.43
/proc/10993/task/11000/stat : 11000 (java) S 10980 10979 4778 34817 4778 4202560 5710 0 0 0 42 1 0 0 17 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11001] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/11001/stat : 11001 (java) S 10980 10979 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11002] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/11002/stat : 11002 (java) S 10980 10979 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11003] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/11003/stat : 11003 (java) S 10980 10979 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 24 0 11 0 10475614 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 25.43
Current children cumulated vsize (KiB) 899944

[startup+51.1082 s]
/proc/loadavg: 1.01 1.05 1.06 2/48 11008
/proc/meminfo: memFree=5368/1048576 swapFree=0/0
[pid=10979] ppid=10978 vsize=2564 CPUtime=0
/proc/10979/stat : 10979 (p2cudf-paranoid) S 10978 10979 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 18 0 1 0 10475083 2625536 270 1283457024 134512640 135304128 4288015216 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10979/statm: 641 270 230 194 0 28 0
[pid=10980] ppid=10979 vsize=2572 CPUtime=0.02
/proc/10980/stat : 10980 (p2cudf) S 10979 10979 4778 34817 4778 4202496 390 3015 0 1 0 0 2 0 25 0 1 0 10475083 2633728 281 1283457024 134512640 135304128 4291110528 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10980/statm: 643 281 239 194 0 30 0
[pid=10993] ppid=10980 vsize=894808 CPUtime=50.98
/proc/10993/stat : 10993 (java) S 10980 10979 4778 34817 4778 4202496 105779 0 1 0 5063 35 0 0 25 0 11 0 10475086 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/10993/statm: 223702 98372 1787 10 0 220793 0
[pid=10993/tid=10994] ppid=10980 vsize=894808 CPUtime=45.01
/proc/10993/task/10994/stat : 10994 (java) R 10980 10979 4778 34817 4778 4202560 50281 0 1 0 4481 20 0 0 25 0 11 0 10475087 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4095975825 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=10993/tid=10995] ppid=10980 vsize=894808 CPUtime=3.07
/proc/10993/task/10995/stat : 10995 (java) S 10980 10979 4778 34817 4778 4202560 37117 0 0 0 297 10 0 0 15 0 11 0 10475089 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 0 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10996] ppid=10980 vsize=894808 CPUtime=0.01
/proc/10993/task/10996/stat : 10996 (java) S 10980 10979 4778 34817 4778 4202560 8 0 0 0 0 1 0 0 18 0 11 0 10475089 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10997] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/10997/stat : 10997 (java) S 10980 10979 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 10475089 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10998] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/10998/stat : 10998 (java) S 10980 10979 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10999] ppid=10980 vsize=894808 CPUtime=2.44
/proc/10993/task/10999/stat : 10999 (java) S 10980 10979 4778 34817 4778 4202560 11591 0 0 0 242 2 0 0 15 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11000] ppid=10980 vsize=894808 CPUtime=0.43
/proc/10993/task/11000/stat : 11000 (java) S 10980 10979 4778 34817 4778 4202560 5710 0 0 0 42 1 0 0 17 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11001] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/11001/stat : 11001 (java) S 10980 10979 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11002] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/11002/stat : 11002 (java) S 10980 10979 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11003] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/11003/stat : 11003 (java) S 10980 10979 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 24 0 11 0 10475614 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 51
Current children cumulated vsize (KiB) 899944

[startup+102.308 s]
/proc/loadavg: 1.07 1.06 1.06 2/48 11013
/proc/meminfo: memFree=5244/1048576 swapFree=0/0
[pid=10979] ppid=10978 vsize=2564 CPUtime=0
/proc/10979/stat : 10979 (p2cudf-paranoid) S 10978 10979 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 18 0 1 0 10475083 2625536 270 1283457024 134512640 135304128 4288015216 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10979/statm: 641 270 230 194 0 28 0
[pid=10980] ppid=10979 vsize=2572 CPUtime=0.02
/proc/10980/stat : 10980 (p2cudf) S 10979 10979 4778 34817 4778 4202496 390 3015 0 1 0 0 2 0 25 0 1 0 10475083 2633728 281 1283457024 134512640 135304128 4291110528 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10980/statm: 643 281 239 194 0 30 0
[pid=10993] ppid=10980 vsize=894808 CPUtime=102.15
/proc/10993/stat : 10993 (java) S 10980 10979 4778 34817 4778 4202496 105779 0 1 0 10180 35 0 0 25 0 11 0 10475086 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/10993/statm: 223702 98372 1787 10 0 220793 0
[pid=10993/tid=10994] ppid=10980 vsize=894808 CPUtime=93.9
/proc/10993/task/10994/stat : 10994 (java) R 10980 10979 4778 34817 4778 4202560 50281 0 1 0 9370 20 0 0 25 0 11 0 10475087 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4095930744 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=10993/tid=10995] ppid=10980 vsize=894808 CPUtime=5.34
/proc/10993/task/10995/stat : 10995 (java) S 10980 10979 4778 34817 4778 4202560 37117 0 0 0 524 10 0 0 15 0 11 0 10475089 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 0 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10996] ppid=10980 vsize=894808 CPUtime=0.01
/proc/10993/task/10996/stat : 10996 (java) S 10980 10979 4778 34817 4778 4202560 8 0 0 0 0 1 0 0 18 0 11 0 10475089 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10997] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/10997/stat : 10997 (java) S 10980 10979 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 10475089 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10998] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/10998/stat : 10998 (java) S 10980 10979 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10999] ppid=10980 vsize=894808 CPUtime=2.45
/proc/10993/task/10999/stat : 10999 (java) S 10980 10979 4778 34817 4778 4202560 11591 0 0 0 243 2 0 0 15 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11000] ppid=10980 vsize=894808 CPUtime=0.43
/proc/10993/task/11000/stat : 11000 (java) S 10980 10979 4778 34817 4778 4202560 5710 0 0 0 42 1 0 0 17 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11001] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/11001/stat : 11001 (java) S 10980 10979 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11002] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/11002/stat : 11002 (java) S 10980 10979 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11003] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/11003/stat : 11003 (java) S 10980 10979 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 24 0 11 0 10475614 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 102.17
Current children cumulated vsize (KiB) 899944

[startup+162.311 s]
/proc/loadavg: 1.03 1.05 1.05 2/47 11014
/proc/meminfo: memFree=5260/1048576 swapFree=0/0
[pid=10979] ppid=10978 vsize=2564 CPUtime=0
/proc/10979/stat : 10979 (p2cudf-paranoid) S 10978 10979 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 18 0 1 0 10475083 2625536 270 1283457024 134512640 135304128 4288015216 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10979/statm: 641 270 230 194 0 28 0
[pid=10980] ppid=10979 vsize=2572 CPUtime=0.02
/proc/10980/stat : 10980 (p2cudf) S 10979 10979 4778 34817 4778 4202496 390 3015 0 1 0 0 2 0 25 0 1 0 10475083 2633728 281 1283457024 134512640 135304128 4291110528 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10980/statm: 643 281 239 194 0 30 0
[pid=10993] ppid=10980 vsize=894808 CPUtime=162.11
/proc/10993/stat : 10993 (java) S 10980 10979 4778 34817 4778 4202496 105779 0 1 0 16174 37 0 0 25 0 11 0 10475086 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/10993/statm: 223702 98372 1787 10 0 220793 0
[pid=10993/tid=10994] ppid=10980 vsize=894808 CPUtime=151.24
/proc/10993/task/10994/stat : 10994 (java) R 10980 10979 4778 34817 4778 4202560 50281 0 1 0 15102 22 0 0 25 0 11 0 10475087 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4095969187 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=10993/tid=10995] ppid=10980 vsize=894808 CPUtime=7.96
/proc/10993/task/10995/stat : 10995 (java) S 10980 10979 4778 34817 4778 4202560 37117 0 0 0 786 10 0 0 15 0 11 0 10475089 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 0 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10996] ppid=10980 vsize=894808 CPUtime=0.01
/proc/10993/task/10996/stat : 10996 (java) S 10980 10979 4778 34817 4778 4202560 8 0 0 0 0 1 0 0 18 0 11 0 10475089 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10997] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/10997/stat : 10997 (java) S 10980 10979 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 10475089 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10998] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/10998/stat : 10998 (java) S 10980 10979 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10999] ppid=10980 vsize=894808 CPUtime=2.45
/proc/10993/task/10999/stat : 10999 (java) S 10980 10979 4778 34817 4778 4202560 11591 0 0 0 243 2 0 0 15 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11000] ppid=10980 vsize=894808 CPUtime=0.43
/proc/10993/task/11000/stat : 11000 (java) S 10980 10979 4778 34817 4778 4202560 5710 0 0 0 42 1 0 0 17 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11001] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/11001/stat : 11001 (java) S 10980 10979 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11002] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/11002/stat : 11002 (java) S 10980 10979 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11003] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/11003/stat : 11003 (java) S 10980 10979 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 24 0 11 0 10475614 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 162.13
Current children cumulated vsize (KiB) 899944

[startup+222.307 s]
/proc/loadavg: 1.01 1.04 1.05 2/46 11014
/proc/meminfo: memFree=5268/1048576 swapFree=0/0
[pid=10979] ppid=10978 vsize=2564 CPUtime=0
/proc/10979/stat : 10979 (p2cudf-paranoid) S 10978 10979 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 18 0 1 0 10475083 2625536 270 1283457024 134512640 135304128 4288015216 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10979/statm: 641 270 230 194 0 28 0
[pid=10980] ppid=10979 vsize=2572 CPUtime=0.02
/proc/10980/stat : 10980 (p2cudf) S 10979 10979 4778 34817 4778 4202496 390 3015 0 1 0 0 2 0 25 0 1 0 10475083 2633728 281 1283457024 134512640 135304128 4291110528 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10980/statm: 643 281 239 194 0 30 0
[pid=10993] ppid=10980 vsize=894808 CPUtime=222.02
/proc/10993/stat : 10993 (java) S 10980 10979 4778 34817 4778 4202496 105779 0 1 0 22164 38 0 0 25 0 11 0 10475086 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/10993/statm: 223702 98372 1787 10 0 220793 0
[pid=10993/tid=10994] ppid=10980 vsize=894808 CPUtime=209.99
/proc/10993/task/10994/stat : 10994 (java) R 10980 10979 4778 34817 4778 4202560 50281 0 1 0 20976 23 0 0 25 0 11 0 10475087 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4096016285 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=10993/tid=10995] ppid=10980 vsize=894808 CPUtime=9.12
/proc/10993/task/10995/stat : 10995 (java) S 10980 10979 4778 34817 4778 4202560 37117 0 0 0 902 10 0 0 15 0 11 0 10475089 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 0 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10996] ppid=10980 vsize=894808 CPUtime=0.01
/proc/10993/task/10996/stat : 10996 (java) S 10980 10979 4778 34817 4778 4202560 8 0 0 0 0 1 0 0 18 0 11 0 10475089 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10997] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/10997/stat : 10997 (java) S 10980 10979 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 10475089 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10998] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/10998/stat : 10998 (java) S 10980 10979 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10999] ppid=10980 vsize=894808 CPUtime=2.45
/proc/10993/task/10999/stat : 10999 (java) S 10980 10979 4778 34817 4778 4202560 11591 0 0 0 243 2 0 0 15 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11000] ppid=10980 vsize=894808 CPUtime=0.43
/proc/10993/task/11000/stat : 11000 (java) S 10980 10979 4778 34817 4778 4202560 5710 0 0 0 42 1 0 0 17 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11001] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/11001/stat : 11001 (java) S 10980 10979 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11002] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/11002/stat : 11002 (java) S 10980 10979 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11003] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/11003/stat : 11003 (java) S 10980 10979 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 24 0 11 0 10475614 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 222.04
Current children cumulated vsize (KiB) 899944

[startup+282.311 s]
/proc/loadavg: 1.00 1.03 1.04 2/46 11014
/proc/meminfo: memFree=5268/1048576 swapFree=0/0
[pid=10979] ppid=10978 vsize=2564 CPUtime=0
/proc/10979/stat : 10979 (p2cudf-paranoid) S 10978 10979 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 18 0 1 0 10475083 2625536 270 1283457024 134512640 135304128 4288015216 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10979/statm: 641 270 230 194 0 28 0
[pid=10980] ppid=10979 vsize=2572 CPUtime=0.02
/proc/10980/stat : 10980 (p2cudf) S 10979 10979 4778 34817 4778 4202496 390 3015 0 1 0 0 2 0 25 0 1 0 10475083 2633728 281 1283457024 134512640 135304128 4291110528 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10980/statm: 643 281 239 194 0 30 0
[pid=10993] ppid=10980 vsize=894808 CPUtime=281.96
/proc/10993/stat : 10993 (java) S 10980 10979 4778 34817 4778 4202496 105779 0 1 0 28158 38 0 0 25 0 11 0 10475086 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/10993/statm: 223702 98372 1787 10 0 220793 0
[pid=10993/tid=10994] ppid=10980 vsize=894808 CPUtime=268.41
/proc/10993/task/10994/stat : 10994 (java) R 10980 10979 4778 34817 4778 4202560 50281 0 1 0 26818 23 0 0 25 0 11 0 10475087 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4095975757 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=10993/tid=10995] ppid=10980 vsize=894808 CPUtime=10.65
/proc/10993/task/10995/stat : 10995 (java) S 10980 10979 4778 34817 4778 4202560 37117 0 0 0 1055 10 0 0 15 0 11 0 10475089 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 0 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10996] ppid=10980 vsize=894808 CPUtime=0.01
/proc/10993/task/10996/stat : 10996 (java) S 10980 10979 4778 34817 4778 4202560 8 0 0 0 0 1 0 0 18 0 11 0 10475089 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10997] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/10997/stat : 10997 (java) S 10980 10979 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 10475089 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10998] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/10998/stat : 10998 (java) S 10980 10979 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10999] ppid=10980 vsize=894808 CPUtime=2.45
/proc/10993/task/10999/stat : 10999 (java) S 10980 10979 4778 34817 4778 4202560 11591 0 0 0 243 2 0 0 15 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11000] ppid=10980 vsize=894808 CPUtime=0.43
/proc/10993/task/11000/stat : 11000 (java) S 10980 10979 4778 34817 4778 4202560 5710 0 0 0 42 1 0 0 17 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11001] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/11001/stat : 11001 (java) S 10980 10979 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11002] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/11002/stat : 11002 (java) S 10980 10979 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11003] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/11003/stat : 11003 (java) S 10980 10979 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 24 0 11 0 10475614 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 281.98
Current children cumulated vsize (KiB) 899944

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

[startup+284.611 s]
/proc/loadavg: 1.00 1.03 1.04 2/46 11014
/proc/meminfo: memFree=5268/1048576 swapFree=0/0
[pid=10979] ppid=10978 vsize=2564 CPUtime=0
/proc/10979/stat : 10979 (p2cudf-paranoid) S 10978 10979 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 18 0 1 0 10475083 2625536 270 1283457024 134512640 135304128 4288015216 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10979/statm: 641 270 230 194 0 28 0
[pid=10980] ppid=10979 vsize=2572 CPUtime=0.02
/proc/10980/stat : 10980 (p2cudf) S 10979 10979 4778 34817 4778 4202496 390 3015 0 1 0 0 2 0 25 0 1 0 10475083 2633728 281 1283457024 134512640 135304128 4291110528 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10980/statm: 643 281 239 194 0 30 0
[pid=10993] ppid=10980 vsize=894808 CPUtime=284.26
/proc/10993/stat : 10993 (java) S 10980 10979 4778 34817 4778 4202496 105779 0 1 0 28388 38 0 0 25 0 11 0 10475086 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/10993/statm: 223702 98372 1787 10 0 220793 0
[pid=10993/tid=10994] ppid=10980 vsize=894808 CPUtime=270.71
/proc/10993/task/10994/stat : 10994 (java) R 10980 10979 4778 34817 4778 4202560 50281 0 1 0 27048 23 0 0 25 0 11 0 10475087 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4096016285 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=10993/tid=10995] ppid=10980 vsize=894808 CPUtime=10.65
/proc/10993/task/10995/stat : 10995 (java) S 10980 10979 4778 34817 4778 4202560 37117 0 0 0 1055 10 0 0 15 0 11 0 10475089 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 0 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10996] ppid=10980 vsize=894808 CPUtime=0.01
/proc/10993/task/10996/stat : 10996 (java) S 10980 10979 4778 34817 4778 4202560 8 0 0 0 0 1 0 0 18 0 11 0 10475089 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10997] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/10997/stat : 10997 (java) S 10980 10979 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 10475089 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10998] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/10998/stat : 10998 (java) S 10980 10979 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10999] ppid=10980 vsize=894808 CPUtime=2.45
/proc/10993/task/10999/stat : 10999 (java) S 10980 10979 4778 34817 4778 4202560 11591 0 0 0 243 2 0 0 15 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11000] ppid=10980 vsize=894808 CPUtime=0.43
/proc/10993/task/11000/stat : 11000 (java) S 10980 10979 4778 34817 4778 4202560 5710 0 0 0 42 1 0 0 17 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11001] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/11001/stat : 11001 (java) S 10980 10979 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11002] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/11002/stat : 11002 (java) S 10980 10979 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 10475092 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11003] ppid=10980 vsize=894808 CPUtime=0
/proc/10993/task/11003/stat : 11003 (java) S 10980 10979 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 24 0 11 0 10475614 916283392 98372 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 284.28
Current children cumulated vsize (KiB) 899944

[startup+285.407 s]
/proc/loadavg: 1.00 1.03 1.04 2/46 11014
/proc/meminfo: memFree=5268/1048576 swapFree=0/0
[pid=10979] ppid=10978 vsize=2564 CPUtime=0
/proc/10979/stat : 10979 (p2cudf-paranoid) S 10978 10979 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 18 0 1 0 10475083 2625536 270 1283457024 134512640 135304128 4288015216 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10979/statm: 641 270 230 194 0 28 0
[pid=10980] ppid=10979 vsize=2572 CPUtime=0.02
/proc/10980/stat : 10980 (p2cudf) S 10979 10979 4778 34817 4778 4202496 390 3015 0 1 0 0 2 0 25 0 1 0 10475083 2633728 281 1283457024 134512640 135304128 4291110528 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10980/statm: 643 281 239 194 0 30 0
[pid=10993] ppid=10980 vsize=895132 CPUtime=285.04
/proc/10993/stat : 10993 (java) S 10980 10979 4778 34817 4778 4202496 105793 0 1 0 28466 38 0 0 25 0 11 0 10475086 916615168 98386 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/10993/statm: 223783 98386 1788 10 0 220874 0
[pid=10993/tid=10994] ppid=10980 vsize=895132 CPUtime=271.42
/proc/10993/task/10994/stat : 10994 (java) S 10980 10979 4778 34817 4778 4202560 50289 0 1 0 27119 23 0 0 25 0 11 0 10475087 916615168 98386 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10995] ppid=10980 vsize=895132 CPUtime=10.65
/proc/10993/task/10995/stat : 10995 (java) S 10980 10979 4778 34817 4778 4202560 37117 0 0 0 1055 10 0 0 16 0 11 0 10475089 916615168 98386 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 0 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10996] ppid=10980 vsize=895132 CPUtime=0.01
/proc/10993/task/10996/stat : 10996 (java) S 10980 10979 4778 34817 4778 4202560 8 0 0 0 0 1 0 0 18 0 11 0 10475089 916615168 98386 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10997] ppid=10980 vsize=895132 CPUtime=0
/proc/10993/task/10997/stat : 10997 (java) S 10980 10979 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 10475089 916615168 98386 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10998] ppid=10980 vsize=895132 CPUtime=0
/proc/10993/task/10998/stat : 10998 (java) S 10980 10979 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10475092 916615168 98386 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10999] ppid=10980 vsize=895132 CPUtime=2.51
/proc/10993/task/10999/stat : 10999 (java) S 10980 10979 4778 34817 4778 4202560 11591 0 0 0 249 2 0 0 15 0 11 0 10475092 916615168 98386 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11000] ppid=10980 vsize=895132 CPUtime=0.43
/proc/10993/task/11000/stat : 11000 (java) S 10980 10979 4778 34817 4778 4202560 5710 0 0 0 42 1 0 0 17 0 11 0 10475092 916615168 98386 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11001] ppid=10980 vsize=895132 CPUtime=0
/proc/10993/task/11001/stat : 11001 (java) S 10980 10979 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10475092 916615168 98386 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11002] ppid=10980 vsize=895132 CPUtime=0
/proc/10993/task/11002/stat : 11002 (java) S 10980 10979 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 10475092 916615168 98386 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 285.06
Current children cumulated vsize (KiB) 900268

[startup+285.807 s]
/proc/loadavg: 0.92 1.01 1.04 2/46 11015
/proc/meminfo: memFree=5144/1048576 swapFree=0/0
[pid=10979] ppid=10978 vsize=2564 CPUtime=0
/proc/10979/stat : 10979 (p2cudf-paranoid) S 10978 10979 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 18 0 1 0 10475083 2625536 270 1283457024 134512640 135304128 4288015216 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10979/statm: 641 270 230 194 0 28 0
[pid=10980] ppid=10979 vsize=2572 CPUtime=0.02
/proc/10980/stat : 10980 (p2cudf) S 10979 10979 4778 34817 4778 4202496 390 3015 0 1 0 0 2 0 25 0 1 0 10475083 2633728 281 1283457024 134512640 135304128 4291110528 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10980/statm: 643 281 239 194 0 30 0
[pid=10993] ppid=10980 vsize=895132 CPUtime=285.04
/proc/10993/stat : 10993 (java) S 10980 10979 4778 34817 4778 4202496 105793 0 1 0 28466 38 0 0 25 0 11 0 10475086 916615168 98386 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/10993/statm: 223783 98386 1788 10 0 220874 0
[pid=10993/tid=10994] ppid=10980 vsize=895132 CPUtime=271.42
/proc/10993/task/10994/stat : 10994 (java) S 10980 10979 4778 34817 4778 4202560 50289 0 1 0 27119 23 0 0 25 0 11 0 10475087 916615168 98386 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10995] ppid=10980 vsize=895132 CPUtime=10.65
/proc/10993/task/10995/stat : 10995 (java) S 10980 10979 4778 34817 4778 4202560 37117 0 0 0 1055 10 0 0 16 0 11 0 10475089 916615168 98386 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 0 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10996] ppid=10980 vsize=895132 CPUtime=0.01
/proc/10993/task/10996/stat : 10996 (java) S 10980 10979 4778 34817 4778 4202560 8 0 0 0 0 1 0 0 18 0 11 0 10475089 916615168 98386 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10997] ppid=10980 vsize=895132 CPUtime=0
/proc/10993/task/10997/stat : 10997 (java) S 10980 10979 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 10475089 916615168 98386 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10998] ppid=10980 vsize=895132 CPUtime=0
/proc/10993/task/10998/stat : 10998 (java) S 10980 10979 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10475092 916615168 98386 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10999] ppid=10980 vsize=895132 CPUtime=2.51
/proc/10993/task/10999/stat : 10999 (java) S 10980 10979 4778 34817 4778 4202560 11591 0 0 0 249 2 0 0 15 0 11 0 10475092 916615168 98386 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11000] ppid=10980 vsize=895132 CPUtime=0.43
/proc/10993/task/11000/stat : 11000 (java) S 10980 10979 4778 34817 4778 4202560 5710 0 0 0 42 1 0 0 17 0 11 0 10475092 916615168 98386 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11001] ppid=10980 vsize=895132 CPUtime=0
/proc/10993/task/11001/stat : 11001 (java) S 10980 10979 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10475092 916615168 98386 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11002] ppid=10980 vsize=895132 CPUtime=0
/proc/10993/task/11002/stat : 11002 (java) R 10980 10979 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 10475092 916615168 98386 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=10993/tid=11015] ppid=10980 vsize=895132 CPUtime=0
/proc/10993/task/11015/stat : 11015 (java) S 10980 10979 4778 34817 4778 4202560 5 0 0 0 0 0 0 0 25 0 11 0 10503621 916615168 98386 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 285.06
Current children cumulated vsize (KiB) 900268

[startup+286.003 s]
/proc/loadavg: 0.92 1.01 1.04 2/46 11015
/proc/meminfo: memFree=5144/1048576 swapFree=0/0
[pid=10979] ppid=10978 vsize=2564 CPUtime=0
/proc/10979/stat : 10979 (p2cudf-paranoid) S 10978 10979 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 18 0 1 0 10475083 2625536 270 1283457024 134512640 135304128 4288015216 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10979/statm: 641 270 230 194 0 28 0
[pid=10980] ppid=10979 vsize=2572 CPUtime=0.02
/proc/10980/stat : 10980 (p2cudf) S 10979 10979 4778 34817 4778 4202496 390 3015 0 1 0 0 2 0 25 0 1 0 10475083 2633728 281 1283457024 134512640 135304128 4291110528 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/10980/statm: 643 281 239 194 0 30 0
[pid=10993] ppid=10980 vsize=895132 CPUtime=285.13
/proc/10993/stat : 10993 (java) S 10980 10979 4778 34817 4778 4202496 105795 0 1 0 28473 40 0 0 25 0 10 0 10475086 916615168 98388 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/10993/statm: 223783 98388 1788 10 0 220874 0
[pid=10993/tid=10994] ppid=10980 vsize=895132 CPUtime=271.42
/proc/10993/task/10994/stat : 10994 (java) S 10980 10979 4778 34817 4778 4202560 50289 0 1 0 27119 23 0 0 20 0 10 0 10475087 916615168 98388 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10995] ppid=10980 vsize=895132 CPUtime=10.65
/proc/10993/task/10995/stat : 10995 (java) S 10980 10979 4778 34817 4778 4202560 37117 0 0 0 1055 10 0 0 16 0 10 0 10475089 916615168 98388 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 0 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10996] ppid=10980 vsize=895132 CPUtime=0.01
/proc/10993/task/10996/stat : 10996 (java) S 10980 10979 4778 34817 4778 4202560 8 0 0 0 0 1 0 0 18 0 10 0 10475089 916615168 98388 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10997] ppid=10980 vsize=895132 CPUtime=0
/proc/10993/task/10997/stat : 10997 (java) S 10980 10979 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 10 0 10475089 916615168 98388 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10998] ppid=10980 vsize=895132 CPUtime=0
/proc/10993/task/10998/stat : 10998 (java) S 10980 10979 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 10475092 916615168 98388 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=10999] ppid=10980 vsize=895132 CPUtime=2.54
/proc/10993/task/10999/stat : 10999 (java) S 10980 10979 4778 34817 4778 4202560 11591 0 0 0 252 2 0 0 15 0 10 0 10475092 916615168 98388 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11000] ppid=10980 vsize=895132 CPUtime=0.43
/proc/10993/task/11000/stat : 11000 (java) S 10980 10979 4778 34817 4778 4202560 5710 0 0 0 42 1 0 0 17 0 10 0 10475092 916615168 98388 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11001] ppid=10980 vsize=895132 CPUtime=0
/proc/10993/task/11001/stat : 11001 (java) S 10980 10979 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 10475092 916615168 98388 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
[pid=10993/tid=11002] ppid=10980 vsize=895132 CPUtime=0
/proc/10993/task/11002/stat : 11002 (java) S 10980 10979 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 10 0 10475092 916615168 98388 1283457024 134512640 134550932 4292251184 18446744073709551615 4294960130 0 4 0 16800975 18446612133155120448 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 285.15
Current children cumulated vsize (KiB) 900268

Child status: 0
Real time (s): 286.072
CPU time (s): 285.202
CPU user time (s): 284.766
CPU system time (s): 0.436027
CPU usage (%): 99.6957
Max. virtual memory (cumulated for all children) (KiB): 904652

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 284.766
system time used= 0.436027
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 109601
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= 5993
involuntary context switches= 8751

runsolver used 0 second user time and 0.012 second system time

The end