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/201103021629/p2cudf-paranoid-1.12/rand992.cudf.heavy.log.runsolver ./p2cudf-paranoid-1.12 /home/misc2010/data/misc4/heavy//rand992.cudf /home/misc2010/tmp/201103021629/p2cudf-paranoid-1.12/rand992.cudf.heavy.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.00 1.01 1.00 5/36 27570 /proc/meminfo: memFree=339044/1048576 swapFree=0/0 [pid=27567] ppid=27566 vsize=2568 CPUtime=0 /proc/27567/stat : 27567 (p2cudf-paranoid) S 27566 27567 1684 34817 1684 4202496 376 0 0 0 0 0 0 0 18 0 1 0 68883803 2629632 271 1283457024 134512640 135304128 4288820304 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/27567/statm: 642 271 230 194 0 29 0 [pid=27568] ppid=27567 vsize=2568 CPUtime=0 /proc/27568/stat : 27568 (p2cudf) S 27567 27567 1684 34817 1684 4202496 352 0 0 0 0 0 0 0 18 0 1 0 68883803 2629632 270 1283457024 134512640 135304128 4289822032 18446744073709551615 4294960130 0 0 4 65536 18446744071564457842 0 0 17 0 0 0 0 /proc/27568/statm: 642 270 231 194 0 29 0 [pid=27569] ppid=27568 vsize=2568 CPUtime=0 /proc/27569/stat : 27569 (p2cudf) R 27568 27567 1684 34817 1684 4202560 94 0 0 0 0 0 0 0 25 0 1 0 68883803 2629632 118 1283457024 134512640 135304128 4289822032 18446744073709551615 4294960130 0 65538 0 65538 0 0 0 17 0 0 0 0 /proc/27569/statm: 642 118 77 194 0 29 0 [pid=27570] ppid=27569 vsize=2568 CPUtime=0 /proc/27570/stat : 27570 (p2cudf) R 27569 27567 1684 34817 1684 4202560 0 0 0 0 0 0 0 0 25 0 1 0 68883803 2629632 41 1283457024 134512640 135304128 4289822032 18446744073709551615 4294960130 0 65538 0 65538 0 0 0 17 0 0 0 0 /proc/27570/statm: 642 41 0 194 0 29 0 [startup+0.195973 s] /proc/loadavg: 1.00 1.01 1.00 5/36 27570 /proc/meminfo: memFree=339044/1048576 swapFree=0/0 [pid=27567] ppid=27566 vsize=2568 CPUtime=0 /proc/27567/stat : 27567 (p2cudf-paranoid) S 27566 27567 1684 34817 1684 4202496 376 0 0 0 0 0 0 0 18 0 1 0 68883803 2629632 271 1283457024 134512640 135304128 4288820304 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/27567/statm: 642 271 230 194 0 29 0 [pid=27568] ppid=27567 vsize=2572 CPUtime=0.03 /proc/27568/stat : 27568 (p2cudf) S 27567 27567 1684 34817 1684 4202496 389 3016 0 1 0 0 2 1 25 0 1 0 68883803 2633728 279 1283457024 134512640 135304128 4289822032 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/27568/statm: 643 279 239 194 0 30 0 Current children cumulated CPU time (s) 0.03 Current children cumulated vsize (KiB) 5140 [startup+0.205967 s] /proc/loadavg: 1.00 1.01 1.00 5/36 27570 /proc/meminfo: memFree=339044/1048576 swapFree=0/0 [pid=27567] ppid=27566 vsize=2568 CPUtime=0 /proc/27567/stat : 27567 (p2cudf-paranoid) S 27566 27567 1684 34817 1684 4202496 376 0 0 0 0 0 0 0 18 0 1 0 68883803 2629632 271 1283457024 134512640 135304128 4288820304 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/27567/statm: 642 271 230 194 0 29 0 [pid=27568] ppid=27567 vsize=2572 CPUtime=0.03 /proc/27568/stat : 27568 (p2cudf) S 27567 27567 1684 34817 1684 4202496 389 3016 0 1 0 0 2 1 25 0 1 0 68883803 2633728 279 1283457024 134512640 135304128 4289822032 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/27568/statm: 643 279 239 194 0 30 0 Current children cumulated CPU time (s) 0.03 Current children cumulated vsize (KiB) 5140 [startup+0.305989 s] /proc/loadavg: 1.00 1.01 1.00 5/36 27570 /proc/meminfo: memFree=339044/1048576 swapFree=0/0 [pid=27567] ppid=27566 vsize=2568 CPUtime=0 /proc/27567/stat : 27567 (p2cudf-paranoid) S 27566 27567 1684 34817 1684 4202496 376 0 0 0 0 0 0 0 18 0 1 0 68883803 2629632 271 1283457024 134512640 135304128 4288820304 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/27567/statm: 642 271 230 194 0 29 0 [pid=27568] ppid=27567 vsize=2572 CPUtime=0.03 /proc/27568/stat : 27568 (p2cudf) S 27567 27567 1684 34817 1684 4202496 389 3016 0 1 0 0 2 1 25 0 1 0 68883803 2633728 279 1283457024 134512640 135304128 4289822032 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/27568/statm: 643 279 239 194 0 30 0 Current children cumulated CPU time (s) 0.03 Current children cumulated vsize (KiB) 5140 [startup+0.706112 s] /proc/loadavg: 1.00 1.01 1.00 5/36 27570 /proc/meminfo: memFree=339044/1048576 swapFree=0/0 [pid=27567] ppid=27566 vsize=2568 CPUtime=0 /proc/27567/stat : 27567 (p2cudf-paranoid) S 27566 27567 1684 34817 1684 4202496 376 0 0 0 0 0 0 0 18 0 1 0 68883803 2629632 271 1283457024 134512640 135304128 4288820304 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/27567/statm: 642 271 230 194 0 29 0 [pid=27568] ppid=27567 vsize=2572 CPUtime=0.03 /proc/27568/stat : 27568 (p2cudf) S 27567 27567 1684 34817 1684 4202496 389 3016 0 1 0 0 2 1 25 0 1 0 68883803 2633728 279 1283457024 134512640 135304128 4289822032 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/27568/statm: 643 279 239 194 0 30 0 Current children cumulated CPU time (s) 0.03 Current children cumulated vsize (KiB) 5140 [startup+1.50633 s] /proc/loadavg: 1.16 1.04 1.01 4/45 27590 /proc/meminfo: memFree=280132/1048576 swapFree=0/0 [pid=27567] ppid=27566 vsize=2568 CPUtime=0 /proc/27567/stat : 27567 (p2cudf-paranoid) S 27566 27567 1684 34817 1684 4202496 376 0 0 0 0 0 0 0 18 0 1 0 68883803 2629632 271 1283457024 134512640 135304128 4288820304 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/27567/statm: 642 271 230 194 0 29 0 [pid=27568] ppid=27567 vsize=2572 CPUtime=0.03 /proc/27568/stat : 27568 (p2cudf) S 27567 27567 1684 34817 1684 4202496 389 3016 0 1 0 0 2 1 25 0 1 0 68883803 2633728 279 1283457024 134512640 135304128 4289822032 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/27568/statm: 643 279 239 194 0 30 0 [pid=27581] ppid=27568 vsize=888524 CPUtime=1.46 /proc/27581/stat : 27581 (java) S 27568 27567 1684 34817 1684 4202496 23265 0 1 0 142 4 0 0 25 0 10 0 68883807 909848576 19993 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/27581/statm: 222131 19993 1721 10 0 219222 0 [pid=27581/tid=27582] ppid=27568 vsize=888524 CPUtime=0.79 /proc/27581/task/27582/stat : 27582 (java) R 27568 27567 1684 34817 1684 4202560 11113 0 1 0 77 2 0 0 25 0 10 0 68883807 909848576 19993 1283457024 134512640 134550932 4292202032 18446744073709551615 4094950147 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=27581/tid=27583] ppid=27568 vsize=888524 CPUtime=0 /proc/27581/task/27583/stat : 27583 (java) S 27568 27567 1684 34817 1684 4202560 6 0 0 0 0 0 0 0 18 0 10 0 68883809 909848576 19993 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 0 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27584] ppid=27568 vsize=888524 CPUtime=0 /proc/27581/task/27584/stat : 27584 (java) S 27568 27567 1684 34817 1684 4202560 8 0 0 0 0 0 0 0 25 0 10 0 68883810 909848576 19993 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27585] ppid=27568 vsize=888524 CPUtime=0 /proc/27581/task/27585/stat : 27585 (java) S 27568 27567 1684 34817 1684 4202560 4 0 0 0 0 0 0 0 25 0 10 0 68883810 909848576 19993 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27586] ppid=27568 vsize=888524 CPUtime=0 /proc/27581/task/27586/stat : 27586 (java) S 27568 27567 1684 34817 1684 4202560 1 0 0 0 0 0 0 0 25 0 10 0 68883812 909848576 19993 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27587] ppid=27568 vsize=888524 CPUtime=0.48 /proc/27581/task/27587/stat : 27587 (java) R 27568 27567 1684 34817 1684 4202560 7897 0 0 0 46 2 0 0 25 0 10 0 68883812 909848576 19993 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=27581/tid=27588] ppid=27568 vsize=888524 CPUtime=0.18 /proc/27581/task/27588/stat : 27588 (java) R 27568 27567 1684 34817 1684 4202560 3177 0 0 0 18 0 0 0 18 0 10 0 68883812 909848576 19993 1283457024 134512640 134550932 4292202032 18446744073709551615 4148349555 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=27581/tid=27589] ppid=27568 vsize=888524 CPUtime=0 /proc/27581/task/27589/stat : 27589 (java) S 27568 27567 1684 34817 1684 4202560 1 0 0 0 0 0 0 0 25 0 10 0 68883812 909848576 19993 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27590] ppid=27568 vsize=888524 CPUtime=0 /proc/27581/task/27590/stat : 27590 (java) S 27568 27567 1684 34817 1684 4202560 1 0 0 0 0 0 0 0 15 0 10 0 68883812 909848576 19993 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 1.49 Current children cumulated vsize (KiB) 893664 [startup+3.11676 s] /proc/loadavg: 1.16 1.04 1.01 3/45 27590 /proc/meminfo: memFree=198044/1048576 swapFree=0/0 [pid=27567] ppid=27566 vsize=2568 CPUtime=0 /proc/27567/stat : 27567 (p2cudf-paranoid) S 27566 27567 1684 34817 1684 4202496 376 0 0 0 0 0 0 0 18 0 1 0 68883803 2629632 271 1283457024 134512640 135304128 4288820304 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/27567/statm: 642 271 230 194 0 29 0 [pid=27568] ppid=27567 vsize=2572 CPUtime=0.03 /proc/27568/stat : 27568 (p2cudf) S 27567 27567 1684 34817 1684 4202496 389 3016 0 1 0 0 2 1 25 0 1 0 68883803 2633728 279 1283457024 134512640 135304128 4289822032 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/27568/statm: 643 279 239 194 0 30 0 [pid=27581] ppid=27568 vsize=888448 CPUtime=3.07 /proc/27581/stat : 27581 (java) S 27568 27567 1684 34817 1684 4202496 62766 0 1 0 291 16 0 0 25 0 10 0 68883807 909770752 58397 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/27581/statm: 222112 58397 1744 10 0 219203 0 [pid=27581/tid=27582] ppid=27568 vsize=888448 CPUtime=1.59 /proc/27581/task/27582/stat : 27582 (java) R 27568 27567 1684 34817 1684 4202560 49145 0 1 0 146 13 0 0 25 0 10 0 68883807 909770752 58397 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=27581/tid=27583] ppid=27568 vsize=888448 CPUtime=0 /proc/27581/task/27583/stat : 27583 (java) S 27568 27567 1684 34817 1684 4202560 6 0 0 0 0 0 0 0 18 0 10 0 68883809 909770752 58397 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 0 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27584] ppid=27568 vsize=888448 CPUtime=0 /proc/27581/task/27584/stat : 27584 (java) S 27568 27567 1684 34817 1684 4202560 8 0 0 0 0 0 0 0 25 0 10 0 68883810 909770752 58397 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27585] ppid=27568 vsize=888448 CPUtime=0 /proc/27581/task/27585/stat : 27585 (java) S 27568 27567 1684 34817 1684 4202560 4 0 0 0 0 0 0 0 25 0 10 0 68883810 909770752 58397 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27586] ppid=27568 vsize=888448 CPUtime=0 /proc/27581/task/27586/stat : 27586 (java) S 27568 27567 1684 34817 1684 4202560 1 0 0 0 0 0 0 0 25 0 10 0 68883812 909770752 58397 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27587] ppid=27568 vsize=888448 CPUtime=0.8 /proc/27581/task/27587/stat : 27587 (java) R 27568 27567 1684 34817 1684 4202560 7963 0 0 0 78 2 0 0 21 0 10 0 68883812 909770752 58397 1283457024 134512640 134550932 4292202032 18446744073709551615 4151226627 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=27581/tid=27588] ppid=27568 vsize=888448 CPUtime=0.67 /proc/27581/task/27588/stat : 27588 (java) R 27568 27567 1684 34817 1684 4202560 4580 0 0 0 66 1 0 0 15 0 10 0 68883812 909770752 58397 1283457024 134512640 134550932 4292202032 18446744073709551615 4149689125 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=27581/tid=27589] ppid=27568 vsize=888448 CPUtime=0 /proc/27581/task/27589/stat : 27589 (java) S 27568 27567 1684 34817 1684 4202560 1 0 0 0 0 0 0 0 25 0 10 0 68883812 909770752 58397 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27590] ppid=27568 vsize=888448 CPUtime=0 /proc/27581/task/27590/stat : 27590 (java) S 27568 27567 1684 34817 1684 4202560 1 0 0 0 0 0 0 0 15 0 10 0 68883812 909770752 58397 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 3.1 Current children cumulated vsize (KiB) 893588 Solver just ended. Dumping a history of the last processes samples [startup+3.22678 s] /proc/loadavg: 1.16 1.04 1.01 3/45 27590 /proc/meminfo: memFree=198044/1048576 swapFree=0/0 [pid=27567] ppid=27566 vsize=2568 CPUtime=0 /proc/27567/stat : 27567 (p2cudf-paranoid) S 27566 27567 1684 34817 1684 4202496 376 0 0 0 0 0 0 0 18 0 1 0 68883803 2629632 271 1283457024 134512640 135304128 4288820304 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/27567/statm: 642 271 230 194 0 29 0 [pid=27568] ppid=27567 vsize=2572 CPUtime=0.03 /proc/27568/stat : 27568 (p2cudf) S 27567 27567 1684 34817 1684 4202496 389 3016 0 1 0 0 2 1 25 0 1 0 68883803 2633728 279 1283457024 134512640 135304128 4289822032 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/27568/statm: 643 279 239 194 0 30 0 [pid=27581] ppid=27568 vsize=888620 CPUtime=3.18 /proc/27581/stat : 27581 (java) S 27568 27567 1684 34817 1684 4202496 63201 0 1 0 302 16 0 0 25 0 10 0 68883807 909946880 58507 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/27581/statm: 222155 58507 1744 10 0 219246 0 [pid=27581/tid=27582] ppid=27568 vsize=888620 CPUtime=1.59 /proc/27581/task/27582/stat : 27582 (java) R 27568 27567 1684 34817 1684 4202560 49145 0 1 0 146 13 0 0 25 0 10 0 68883807 909946880 58507 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=27581/tid=27583] ppid=27568 vsize=888620 CPUtime=0 /proc/27581/task/27583/stat : 27583 (java) R 27568 27567 1684 34817 1684 4202560 6 0 0 0 0 0 0 0 18 0 10 0 68883809 909946880 58507 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 0 0 16800975 0 0 0 -1 0 0 0 0 [pid=27581/tid=27584] ppid=27568 vsize=888620 CPUtime=0 /proc/27581/task/27584/stat : 27584 (java) S 27568 27567 1684 34817 1684 4202560 8 0 0 0 0 0 0 0 25 0 10 0 68883810 909946880 58507 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27585] ppid=27568 vsize=888620 CPUtime=0 /proc/27581/task/27585/stat : 27585 (java) S 27568 27567 1684 34817 1684 4202560 4 0 0 0 0 0 0 0 25 0 10 0 68883810 909946880 58507 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27586] ppid=27568 vsize=888620 CPUtime=0 /proc/27581/task/27586/stat : 27586 (java) S 27568 27567 1684 34817 1684 4202560 1 0 0 0 0 0 0 0 25 0 10 0 68883812 909946880 58507 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27587] ppid=27568 vsize=888620 CPUtime=0.8 /proc/27581/task/27587/stat : 27587 (java) R 27568 27567 1684 34817 1684 4202560 7963 0 0 0 78 2 0 0 21 0 10 0 68883812 909946880 58507 1283457024 134512640 134550932 4292202032 18446744073709551615 4151226627 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=27581/tid=27588] ppid=27568 vsize=888620 CPUtime=0.78 /proc/27581/task/27588/stat : 27588 (java) R 27568 27567 1684 34817 1684 4202560 5015 0 0 0 77 1 0 0 16 0 10 0 68883812 909946880 58507 1283457024 134512640 134550932 4292202032 18446744073709551615 4149716262 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=27581/tid=27589] ppid=27568 vsize=888620 CPUtime=0 /proc/27581/task/27589/stat : 27589 (java) S 27568 27567 1684 34817 1684 4202560 1 0 0 0 0 0 0 0 25 0 10 0 68883812 909946880 58507 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27590] ppid=27568 vsize=888620 CPUtime=0 /proc/27581/task/27590/stat : 27590 (java) R 27568 27567 1684 34817 1684 4202560 1 0 0 0 0 0 0 0 15 0 10 0 68883812 909946880 58507 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 3.21 Current children cumulated vsize (KiB) 893760 [startup+4.80728 s] /proc/loadavg: 1.16 1.04 1.01 3/46 27591 /proc/meminfo: memFree=57924/1048576 swapFree=0/0 [pid=27567] ppid=27566 vsize=2568 CPUtime=0 /proc/27567/stat : 27567 (p2cudf-paranoid) S 27566 27567 1684 34817 1684 4202496 376 0 0 0 0 0 0 0 18 0 1 0 68883803 2629632 271 1283457024 134512640 135304128 4288820304 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/27567/statm: 642 271 230 194 0 29 0 [pid=27568] ppid=27567 vsize=2572 CPUtime=0.03 /proc/27568/stat : 27568 (p2cudf) S 27567 27567 1684 34817 1684 4202496 389 3016 0 1 0 0 2 1 25 0 1 0 68883803 2633728 279 1283457024 134512640 135304128 4289822032 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/27568/statm: 643 279 239 194 0 30 0 [pid=27581] ppid=27568 vsize=887648 CPUtime=4.76 /proc/27581/stat : 27581 (java) S 27568 27567 1684 34817 1684 4202496 76943 0 1 0 460 16 0 0 25 0 11 0 68883807 908951552 71870 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/27581/statm: 221912 71870 1770 10 0 219003 0 [pid=27581/tid=27582] ppid=27568 vsize=887648 CPUtime=2.13 /proc/27581/task/27582/stat : 27582 (java) R 27568 27567 1684 34817 1684 4202560 50258 0 1 0 200 13 0 0 25 0 11 0 68883807 908951552 71870 1283457024 134512640 134550932 4292202032 18446744073709551615 4095680663 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=27581/tid=27583] ppid=27568 vsize=887648 CPUtime=0.31 /proc/27581/task/27583/stat : 27583 (java) S 27568 27567 1684 34817 1684 4202560 12317 0 0 0 31 0 0 0 16 0 11 0 68883809 908951552 71870 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 0 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27584] ppid=27568 vsize=887648 CPUtime=0 /proc/27581/task/27584/stat : 27584 (java) S 27568 27567 1684 34817 1684 4202560 8 0 0 0 0 0 0 0 18 0 11 0 68883810 908951552 71870 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27585] ppid=27568 vsize=887648 CPUtime=0 /proc/27581/task/27585/stat : 27585 (java) S 27568 27567 1684 34817 1684 4202560 6 0 0 0 0 0 0 0 18 0 11 0 68883810 908951552 71870 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27586] ppid=27568 vsize=887648 CPUtime=0 /proc/27581/task/27586/stat : 27586 (java) S 27568 27567 1684 34817 1684 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68883812 908951552 71870 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27587] ppid=27568 vsize=887648 CPUtime=1.45 /proc/27581/task/27587/stat : 27587 (java) S 27568 27567 1684 34817 1684 4202560 8064 0 0 0 143 2 0 0 15 0 11 0 68883812 908951552 71870 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27588] ppid=27568 vsize=887648 CPUtime=0.86 /proc/27581/task/27588/stat : 27588 (java) S 27568 27567 1684 34817 1684 4202560 5226 0 0 0 85 1 0 0 16 0 11 0 68883812 908951552 71870 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27589] ppid=27568 vsize=887648 CPUtime=0 /proc/27581/task/27589/stat : 27589 (java) S 27568 27567 1684 34817 1684 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68883812 908951552 71870 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27590] ppid=27568 vsize=887648 CPUtime=0 /proc/27581/task/27590/stat : 27590 (java) S 27568 27567 1684 34817 1684 4202560 1 0 0 0 0 0 0 0 15 0 11 0 68883812 908951552 71870 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27591] ppid=27568 vsize=887648 CPUtime=0 /proc/27581/task/27591/stat : 27591 (java) S 27568 27567 1684 34817 1684 4202560 4 0 0 0 0 0 0 0 25 0 11 0 68884225 908951552 71870 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 4.79 Current children cumulated vsize (KiB) 892788 [startup+5.20593 s] /proc/loadavg: 1.16 1.04 1.01 3/46 27591 /proc/meminfo: memFree=57924/1048576 swapFree=0/0 [pid=27567] ppid=27566 vsize=2568 CPUtime=0 /proc/27567/stat : 27567 (p2cudf-paranoid) S 27566 27567 1684 34817 1684 4202496 376 0 0 0 0 0 0 0 18 0 1 0 68883803 2629632 271 1283457024 134512640 135304128 4288820304 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/27567/statm: 642 271 230 194 0 29 0 [pid=27568] ppid=27567 vsize=2572 CPUtime=0.03 /proc/27568/stat : 27568 (p2cudf) S 27567 27567 1684 34817 1684 4202496 389 3016 0 1 0 0 2 1 25 0 1 0 68883803 2633728 279 1283457024 134512640 135304128 4289822032 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/27568/statm: 643 279 239 194 0 30 0 [pid=27581] ppid=27568 vsize=887972 CPUtime=5.02 /proc/27581/stat : 27581 (java) S 27568 27567 1684 34817 1684 4202496 76972 0 1 0 485 17 0 0 25 0 12 0 68883807 909283328 71899 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/27581/statm: 221993 71899 1773 10 0 219084 0 [pid=27581/tid=27582] ppid=27568 vsize=887972 CPUtime=2.24 /proc/27581/task/27582/stat : 27582 (java) S 27568 27567 1684 34817 1684 4202560 50266 0 1 0 211 13 0 0 25 0 12 0 68883807 909283328 71899 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27583] ppid=27568 vsize=887972 CPUtime=0.31 /proc/27581/task/27583/stat : 27583 (java) S 27568 27567 1684 34817 1684 4202560 12317 0 0 0 31 0 0 0 16 0 12 0 68883809 909283328 71899 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 0 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27584] ppid=27568 vsize=887972 CPUtime=0 /proc/27581/task/27584/stat : 27584 (java) S 27568 27567 1684 34817 1684 4202560 8 0 0 0 0 0 0 0 18 0 12 0 68883810 909283328 71899 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27585] ppid=27568 vsize=887972 CPUtime=0 /proc/27581/task/27585/stat : 27585 (java) S 27568 27567 1684 34817 1684 4202560 6 0 0 0 0 0 0 0 18 0 12 0 68883810 909283328 71899 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27586] ppid=27568 vsize=887972 CPUtime=0 /proc/27581/task/27586/stat : 27586 (java) S 27568 27567 1684 34817 1684 4202560 1 0 0 0 0 0 0 0 25 0 12 0 68883812 909283328 71899 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27587] ppid=27568 vsize=887972 CPUtime=1.6 /proc/27581/task/27587/stat : 27587 (java) S 27568 27567 1684 34817 1684 4202560 8080 0 0 0 157 3 0 0 15 0 12 0 68883812 909283328 71899 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27588] ppid=27568 vsize=887972 CPUtime=0.86 /proc/27581/task/27588/stat : 27588 (java) S 27568 27567 1684 34817 1684 4202560 5226 0 0 0 85 1 0 0 16 0 12 0 68883812 909283328 71899 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27589] ppid=27568 vsize=887972 CPUtime=0 /proc/27581/task/27589/stat : 27589 (java) S 27568 27567 1684 34817 1684 4202560 1 0 0 0 0 0 0 0 25 0 12 0 68883812 909283328 71899 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27590] ppid=27568 vsize=887972 CPUtime=0 /proc/27581/task/27590/stat : 27590 (java) S 27568 27567 1684 34817 1684 4202560 1 0 0 0 0 0 0 0 15 0 12 0 68883812 909283328 71899 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27591] ppid=27568 vsize=887972 CPUtime=0 /proc/27581/task/27591/stat : 27591 (java) S 27568 27567 1684 34817 1684 4202560 4 0 0 0 0 0 0 0 25 0 12 0 68884225 909283328 71899 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 5.05 Current children cumulated vsize (KiB) 893112 [startup+5.60995 s] /proc/loadavg: 1.15 1.04 1.01 1/47 27592 /proc/meminfo: memFree=57544/1048576 swapFree=0/0 [pid=27567] ppid=27566 vsize=2568 CPUtime=0 /proc/27567/stat : 27567 (p2cudf-paranoid) S 27566 27567 1684 34817 1684 4202496 376 0 0 0 0 0 0 0 18 0 1 0 68883803 2629632 271 1283457024 134512640 135304128 4288820304 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/27567/statm: 642 271 230 194 0 29 0 [pid=27568] ppid=27567 vsize=2572 CPUtime=0.03 /proc/27568/stat : 27568 (p2cudf) S 27567 27567 1684 34817 1684 4202496 389 3016 0 1 0 0 2 1 25 0 1 0 68883803 2633728 279 1283457024 134512640 135304128 4289822032 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/27568/statm: 643 279 239 194 0 30 0 [pid=27581] ppid=27568 vsize=887972 CPUtime=5.05 /proc/27581/stat : 27581 (java) S 27568 27567 1684 34817 1684 4202496 76976 0 1 0 486 19 0 0 25 0 12 0 68883807 909283328 71903 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/27581/statm: 221993 71903 1774 10 0 219084 0 [pid=27581/tid=27582] ppid=27568 vsize=887972 CPUtime=2.24 /proc/27581/task/27582/stat : 27582 (java) S 27568 27567 1684 34817 1684 4202560 50266 0 1 0 211 13 0 0 25 0 12 0 68883807 909283328 71903 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27583] ppid=27568 vsize=887972 CPUtime=0.31 /proc/27581/task/27583/stat : 27583 (java) S 27568 27567 1684 34817 1684 4202560 12317 0 0 0 31 0 0 0 16 0 12 0 68883809 909283328 71903 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 0 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27584] ppid=27568 vsize=887972 CPUtime=0 /proc/27581/task/27584/stat : 27584 (java) S 27568 27567 1684 34817 1684 4202560 8 0 0 0 0 0 0 0 18 0 12 0 68883810 909283328 71903 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27585] ppid=27568 vsize=887972 CPUtime=0 /proc/27581/task/27585/stat : 27585 (java) S 27568 27567 1684 34817 1684 4202560 6 0 0 0 0 0 0 0 18 0 12 0 68883810 909283328 71903 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27586] ppid=27568 vsize=887972 CPUtime=0 /proc/27581/task/27586/stat : 27586 (java) S 27568 27567 1684 34817 1684 4202560 1 0 0 0 0 0 0 0 25 0 12 0 68883812 909283328 71903 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27587] ppid=27568 vsize=887972 CPUtime=1.61 /proc/27581/task/27587/stat : 27587 (java) S 27568 27567 1684 34817 1684 4202560 8083 0 0 0 158 3 0 0 15 0 12 0 68883812 909283328 71903 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27588] ppid=27568 vsize=887972 CPUtime=0.86 /proc/27581/task/27588/stat : 27588 (java) S 27568 27567 1684 34817 1684 4202560 5226 0 0 0 85 1 0 0 16 0 12 0 68883812 909283328 71903 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27589] ppid=27568 vsize=887972 CPUtime=0 /proc/27581/task/27589/stat : 27589 (java) S 27568 27567 1684 34817 1684 4202560 1 0 0 0 0 0 0 0 25 0 12 0 68883812 909283328 71903 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27590] ppid=27568 vsize=887972 CPUtime=0 /proc/27581/task/27590/stat : 27590 (java) S 27568 27567 1684 34817 1684 4202560 1 0 0 0 0 0 0 0 15 0 12 0 68883812 909283328 71903 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27591] ppid=27568 vsize=887972 CPUtime=0 /proc/27581/task/27591/stat : 27591 (java) S 27568 27567 1684 34817 1684 4202560 4 0 0 0 0 0 0 0 25 0 12 0 68884225 909283328 71903 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27592] ppid=27568 vsize=887972 CPUtime=0.02 /proc/27581/task/27592/stat : 27592 (java) R 27568 27567 1684 34817 1684 4202560 6 0 0 0 0 2 0 0 20 0 12 0 68884310 909283328 71903 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 5.08 Current children cumulated vsize (KiB) 893112 [startup+5.70606 s] /proc/loadavg: 1.15 1.04 1.01 1/47 27592 /proc/meminfo: memFree=57544/1048576 swapFree=0/0 [pid=27567] ppid=27566 vsize=2568 CPUtime=0 /proc/27567/stat : 27567 (p2cudf-paranoid) S 27566 27567 1684 34817 1684 4202496 376 0 0 0 0 0 0 0 18 0 1 0 68883803 2629632 271 1283457024 134512640 135304128 4288820304 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/27567/statm: 642 271 230 194 0 29 0 [pid=27568] ppid=27567 vsize=2572 CPUtime=0.03 /proc/27568/stat : 27568 (p2cudf) S 27567 27567 1684 34817 1684 4202496 389 3016 0 1 0 0 2 1 25 0 1 0 68883803 2633728 279 1283457024 134512640 135304128 4289822032 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/27568/statm: 643 279 239 194 0 30 0 [pid=27581] ppid=27568 vsize=887972 CPUtime=5.12 /proc/27581/stat : 27581 (java) S 27568 27567 1684 34817 1684 4202496 76980 0 1 0 493 19 0 0 25 0 11 0 68883807 909283328 71907 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/27581/statm: 221993 71907 1776 10 0 219084 0 [pid=27581/tid=27582] ppid=27568 vsize=887972 CPUtime=2.24 /proc/27581/task/27582/stat : 27582 (java) S 27568 27567 1684 34817 1684 4202560 50266 0 1 0 211 13 0 0 19 0 11 0 68883807 909283328 71907 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27583] ppid=27568 vsize=887972 CPUtime=0.31 /proc/27581/task/27583/stat : 27583 (java) S 27568 27567 1684 34817 1684 4202560 12317 0 0 0 31 0 0 0 16 0 11 0 68883809 909283328 71907 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 0 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27584] ppid=27568 vsize=887972 CPUtime=0 /proc/27581/task/27584/stat : 27584 (java) S 27568 27567 1684 34817 1684 4202560 8 0 0 0 0 0 0 0 18 0 11 0 68883810 909283328 71907 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27585] ppid=27568 vsize=887972 CPUtime=0 /proc/27581/task/27585/stat : 27585 (java) S 27568 27567 1684 34817 1684 4202560 6 0 0 0 0 0 0 0 18 0 11 0 68883810 909283328 71907 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27586] ppid=27568 vsize=887972 CPUtime=0 /proc/27581/task/27586/stat : 27586 (java) S 27568 27567 1684 34817 1684 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68883812 909283328 71907 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27587] ppid=27568 vsize=887972 CPUtime=1.64 /proc/27581/task/27587/stat : 27587 (java) S 27568 27567 1684 34817 1684 4202560 8085 0 0 0 161 3 0 0 15 0 11 0 68883812 909283328 71907 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27588] ppid=27568 vsize=887972 CPUtime=0.86 /proc/27581/task/27588/stat : 27588 (java) S 27568 27567 1684 34817 1684 4202560 5226 0 0 0 85 1 0 0 16 0 11 0 68883812 909283328 71907 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27589] ppid=27568 vsize=887972 CPUtime=0 /proc/27581/task/27589/stat : 27589 (java) S 27568 27567 1684 34817 1684 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68883812 909283328 71907 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27590] ppid=27568 vsize=887972 CPUtime=0 /proc/27581/task/27590/stat : 27590 (java) S 27568 27567 1684 34817 1684 4202560 1 0 0 0 0 0 0 0 15 0 11 0 68883812 909283328 71907 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 [pid=27581/tid=27591] ppid=27568 vsize=887972 CPUtime=0 /proc/27581/task/27591/stat : 27591 (java) S 27568 27567 1684 34817 1684 4202560 4 0 0 0 0 0 0 0 25 0 11 0 68884225 909283328 71907 1283457024 134512640 134550932 4292202032 18446744073709551615 4294960130 0 4 0 16800975 18446612132629315776 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 5.15 Current children cumulated vsize (KiB) 893112 Child status: 0 Real time (s): 5.74831 CPU time (s): 5.20032 CPU user time (s): 4.96431 CPU system time (s): 0.236014 CPU usage (%): 90.4669 Max. virtual memory (cumulated for all children) (KiB): 895144 getrusage(RUSAGE_CHILDREN,...) data: user time used= 4.96431 system time used= 0.236014 maximum resident set size= 0 integral shared memory size= 0 integral unshared data size= 0 integral unshared stack size= 0 page reclaims= 80785 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= 695 involuntary context switches= 682 runsolver used 0 second user time and 0 second system time The end