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/rand97.cudf.user-upgrades.log.runsolver ./p2cudf-paranoid-1.13 /home/misc2010/data/2011/user-upgrades/rand97.cudf /home/misc2010/tmp/201108251442/p2cudf-paranoid-1.13/rand97.cudf.user-upgrades.result Enforcing CPUTime limit (soft limit, will send signal-name then SIGKILL): 290 seconds Enforcing CPUTime limit (hard limit, will send SIGXCPU): 320 seconds Enforcing VSIZE limit (soft limit, will send signal-name then SIGKILL): 1150976 KiB Enforcing VSIZE limit (hard limit, stack expansion will fail with SIGSEGV, brk() and mmap() will return ENOMEM): 1202176 KiB Current StackSize limit: 8192 KiB [startup+0 s] /proc/loadavg: 1.21 1.35 1.27 5/35 24522 /proc/meminfo: memFree=275864/1048576 swapFree=0/0 [pid=24520] ppid=24519 vsize=2568 CPUtime=0 /proc/24520/stat : 24520 (p2cudf-paranoid) S 24519 24520 4778 34817 4778 4202496 375 0 0 0 0 0 0 0 18 0 1 0 11189879 2629632 270 1283457024 134512640 135304128 4292566992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/24520/statm: 642 270 230 194 0 29 0 [pid=24521] ppid=24520 vsize=2568 CPUtime=0 /proc/24521/stat : 24521 (p2cudf) R 24520 24520 4778 34817 4778 4202496 345 0 0 0 0 0 0 0 25 0 1 0 11189879 2629632 271 1283457024 134512640 135304128 4293449920 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0 /proc/24521/statm: 642 271 231 194 0 29 0 [pid=24522] ppid=24521 vsize=2568 CPUtime=0 /proc/24522/stat : 24522 (p2cudf) R 24521 24520 4778 34817 4778 4202560 0 0 0 0 0 0 0 0 25 0 1 0 11189879 2629632 40 1283457024 134512640 135304128 4293449920 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0 /proc/24522/statm: 642 40 0 194 0 29 0 [startup+0.185783 s] /proc/loadavg: 1.21 1.35 1.27 5/35 24522 /proc/meminfo: memFree=275864/1048576 swapFree=0/0 [pid=24520] ppid=24519 vsize=2568 CPUtime=0 /proc/24520/stat : 24520 (p2cudf-paranoid) S 24519 24520 4778 34817 4778 4202496 375 0 0 0 0 0 0 0 18 0 1 0 11189879 2629632 270 1283457024 134512640 135304128 4292566992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/24520/statm: 642 270 230 194 0 29 0 [pid=24521] ppid=24520 vsize=2572 CPUtime=0.02 /proc/24521/stat : 24521 (p2cudf) S 24520 24520 4778 34817 4778 4202496 390 3017 0 1 0 0 0 2 25 0 1 0 11189879 2633728 280 1283457024 134512640 135304128 4293449920 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/24521/statm: 643 280 239 194 0 30 0 Current children cumulated CPU time (s) 0.02 Current children cumulated vsize (KiB) 5140 [startup+0.205776 s] /proc/loadavg: 1.21 1.35 1.27 5/35 24522 /proc/meminfo: memFree=275864/1048576 swapFree=0/0 [pid=24520] ppid=24519 vsize=2568 CPUtime=0 /proc/24520/stat : 24520 (p2cudf-paranoid) S 24519 24520 4778 34817 4778 4202496 375 0 0 0 0 0 0 0 18 0 1 0 11189879 2629632 270 1283457024 134512640 135304128 4292566992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/24520/statm: 642 270 230 194 0 29 0 [pid=24521] ppid=24520 vsize=2572 CPUtime=0.02 /proc/24521/stat : 24521 (p2cudf) S 24520 24520 4778 34817 4778 4202496 390 3017 0 1 0 0 0 2 25 0 1 0 11189879 2633728 280 1283457024 134512640 135304128 4293449920 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/24521/statm: 643 280 239 194 0 30 0 Current children cumulated CPU time (s) 0.02 Current children cumulated vsize (KiB) 5140 [startup+0.305798 s] /proc/loadavg: 1.21 1.35 1.27 5/35 24522 /proc/meminfo: memFree=275864/1048576 swapFree=0/0 [pid=24520] ppid=24519 vsize=2568 CPUtime=0 /proc/24520/stat : 24520 (p2cudf-paranoid) S 24519 24520 4778 34817 4778 4202496 375 0 0 0 0 0 0 0 18 0 1 0 11189879 2629632 270 1283457024 134512640 135304128 4292566992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/24520/statm: 642 270 230 194 0 29 0 [pid=24521] ppid=24520 vsize=2572 CPUtime=0.02 /proc/24521/stat : 24521 (p2cudf) S 24520 24520 4778 34817 4778 4202496 390 3017 0 1 0 0 0 2 25 0 1 0 11189879 2633728 280 1283457024 134512640 135304128 4293449920 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/24521/statm: 643 280 239 194 0 30 0 Current children cumulated CPU time (s) 0.02 Current children cumulated vsize (KiB) 5140 [startup+0.706181 s] /proc/loadavg: 1.21 1.35 1.27 5/35 24522 /proc/meminfo: memFree=275864/1048576 swapFree=0/0 [pid=24520] ppid=24519 vsize=2568 CPUtime=0 /proc/24520/stat : 24520 (p2cudf-paranoid) S 24519 24520 4778 34817 4778 4202496 375 0 0 0 0 0 0 0 18 0 1 0 11189879 2629632 270 1283457024 134512640 135304128 4292566992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/24520/statm: 642 270 230 194 0 29 0 [pid=24521] ppid=24520 vsize=2572 CPUtime=0.02 /proc/24521/stat : 24521 (p2cudf) S 24520 24520 4778 34817 4778 4202496 390 3017 0 1 0 0 0 2 25 0 1 0 11189879 2633728 280 1283457024 134512640 135304128 4293449920 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/24521/statm: 643 280 239 194 0 30 0 Current children cumulated CPU time (s) 0.02 Current children cumulated vsize (KiB) 5140 [startup+1.50643 s] /proc/loadavg: 1.21 1.35 1.27 4/45 24543 /proc/meminfo: memFree=218300/1048576 swapFree=0/0 [pid=24520] ppid=24519 vsize=2568 CPUtime=0 /proc/24520/stat : 24520 (p2cudf-paranoid) S 24519 24520 4778 34817 4778 4202496 375 0 0 0 0 0 0 0 18 0 1 0 11189879 2629632 270 1283457024 134512640 135304128 4292566992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/24520/statm: 642 270 230 194 0 29 0 [pid=24521] ppid=24520 vsize=2572 CPUtime=0.02 /proc/24521/stat : 24521 (p2cudf) S 24520 24520 4778 34817 4778 4202496 390 3017 0 1 0 0 0 2 25 0 1 0 11189879 2633728 280 1283457024 134512640 135304128 4293449920 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/24521/statm: 643 280 239 194 0 30 0 [pid=24534] ppid=24521 vsize=890788 CPUtime=1.47 /proc/24534/stat : 24534 (java) S 24521 24520 4778 34817 4778 4202496 21399 0 1 0 140 7 0 0 25 0 10 0 11189882 912166912 18236 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/24534/statm: 222697 18236 1724 10 0 219788 0 [pid=24534/tid=24535] ppid=24521 vsize=890788 CPUtime=0.6 /proc/24534/task/24535/stat : 24535 (java) R 24521 24520 4778 34817 4778 4202560 8634 0 1 0 57 3 0 0 25 0 10 0 11189883 912166912 18236 1283457024 134512640 134550932 4293297968 18446744073709551615 4094770056 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=24534/tid=24536] ppid=24521 vsize=890788 CPUtime=0 /proc/24534/task/24536/stat : 24536 (java) S 24521 24520 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 17 0 10 0 11189884 912166912 18236 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24537] ppid=24521 vsize=890788 CPUtime=0 /proc/24534/task/24537/stat : 24537 (java) S 24521 24520 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 25 0 10 0 11189885 912166912 18236 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24538] ppid=24521 vsize=890788 CPUtime=0 /proc/24534/task/24538/stat : 24538 (java) S 24521 24520 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 10 0 11189885 912166912 18236 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24539] ppid=24521 vsize=890788 CPUtime=0 /proc/24534/task/24539/stat : 24539 (java) S 24521 24520 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 11189887 912166912 18236 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24540] ppid=24521 vsize=890788 CPUtime=0.35 /proc/24534/task/24540/stat : 24540 (java) R 24521 24520 4778 34817 4778 4202560 5150 0 0 0 33 2 0 0 25 0 10 0 11189887 912166912 18236 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=24534/tid=24541] ppid=24521 vsize=890788 CPUtime=0.5 /proc/24534/task/24541/stat : 24541 (java) S 24521 24520 4778 34817 4778 4202560 6538 0 0 0 49 1 0 0 23 0 10 0 11189887 912166912 18236 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24542] ppid=24521 vsize=890788 CPUtime=0 /proc/24534/task/24542/stat : 24542 (java) S 24521 24520 4778 34817 4778 4202560 0 0 0 0 0 0 0 0 25 0 10 0 11189887 912166912 18236 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24543] ppid=24521 vsize=890788 CPUtime=0 /proc/24534/task/24543/stat : 24543 (java) S 24521 24520 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 15 0 10 0 11189887 912166912 18236 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 1.49 Current children cumulated vsize (KiB) 895928 [startup+3.10697 s] /proc/loadavg: 1.21 1.35 1.27 2/45 24543 /proc/meminfo: memFree=115752/1048576 swapFree=0/0 [pid=24520] ppid=24519 vsize=2568 CPUtime=0 /proc/24520/stat : 24520 (p2cudf-paranoid) S 24519 24520 4778 34817 4778 4202496 375 0 0 0 0 0 0 0 18 0 1 0 11189879 2629632 270 1283457024 134512640 135304128 4292566992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/24520/statm: 642 270 230 194 0 29 0 [pid=24521] ppid=24520 vsize=2572 CPUtime=0.02 /proc/24521/stat : 24521 (p2cudf) S 24520 24520 4778 34817 4778 4202496 390 3017 0 1 0 0 0 2 25 0 1 0 11189879 2633728 280 1283457024 134512640 135304128 4293449920 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/24521/statm: 643 280 239 194 0 30 0 [pid=24534] ppid=24521 vsize=889960 CPUtime=3.07 /proc/24534/stat : 24534 (java) S 24521 24520 4778 34817 4778 4202496 73702 0 1 0 279 28 0 0 25 0 10 0 11189882 911319040 70464 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/24534/statm: 222490 70464 1743 10 0 219581 0 [pid=24534/tid=24535] ppid=24521 vsize=889960 CPUtime=1.74 /proc/24534/task/24535/stat : 24535 (java) R 24521 24520 4778 34817 4778 4202560 50091 0 1 0 151 23 0 0 25 0 10 0 11189883 911319040 70464 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=24534/tid=24536] ppid=24521 vsize=889960 CPUtime=0.21 /proc/24534/task/24536/stat : 24536 (java) S 24521 24520 4778 34817 4778 4202560 10771 0 0 0 21 0 0 0 16 0 10 0 11189884 911319040 70464 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24537] ppid=24521 vsize=889960 CPUtime=0 /proc/24534/task/24537/stat : 24537 (java) S 24521 24520 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 18 0 10 0 11189885 911319040 70464 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24538] ppid=24521 vsize=889960 CPUtime=0 /proc/24534/task/24538/stat : 24538 (java) S 24521 24520 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 10 0 11189885 911319040 70464 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24539] ppid=24521 vsize=889960 CPUtime=0 /proc/24534/task/24539/stat : 24539 (java) S 24521 24520 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 11189887 911319040 70464 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24540] ppid=24521 vsize=889960 CPUtime=0.4 /proc/24534/task/24540/stat : 24540 (java) S 24521 24520 4778 34817 4778 4202560 5187 0 0 0 38 2 0 0 23 0 10 0 11189887 911319040 70464 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24541] ppid=24521 vsize=889960 CPUtime=0.69 /proc/24534/task/24541/stat : 24541 (java) R 24521 24520 4778 34817 4778 4202560 6580 0 0 0 68 1 0 0 16 0 10 0 11189887 911319040 70464 1283457024 134512640 134550932 4293297968 18446744073709551615 4149628006 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=24534/tid=24542] ppid=24521 vsize=889960 CPUtime=0 /proc/24534/task/24542/stat : 24542 (java) S 24521 24520 4778 34817 4778 4202560 0 0 0 0 0 0 0 0 25 0 10 0 11189887 911319040 70464 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24543] ppid=24521 vsize=889960 CPUtime=0 /proc/24534/task/24543/stat : 24543 (java) S 24521 24520 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 15 0 10 0 11189887 911319040 70464 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 3.09 Current children cumulated vsize (KiB) 895100 Solver just ended. Dumping a history of the last processes samples [startup+3.207 s] /proc/loadavg: 1.21 1.35 1.27 2/45 24543 /proc/meminfo: memFree=115752/1048576 swapFree=0/0 [pid=24520] ppid=24519 vsize=2568 CPUtime=0 /proc/24520/stat : 24520 (p2cudf-paranoid) S 24519 24520 4778 34817 4778 4202496 375 0 0 0 0 0 0 0 18 0 1 0 11189879 2629632 270 1283457024 134512640 135304128 4292566992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/24520/statm: 642 270 230 194 0 29 0 [pid=24521] ppid=24520 vsize=2572 CPUtime=0.02 /proc/24521/stat : 24521 (p2cudf) S 24520 24520 4778 34817 4778 4202496 390 3017 0 1 0 0 0 2 25 0 1 0 11189879 2633728 280 1283457024 134512640 135304128 4293449920 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/24521/statm: 643 280 239 194 0 30 0 [pid=24534] ppid=24521 vsize=889960 CPUtime=3.17 /proc/24534/stat : 24534 (java) S 24521 24520 4778 34817 4778 4202496 73706 0 1 0 289 28 0 0 25 0 10 0 11189882 911319040 70468 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/24534/statm: 222490 70468 1743 10 0 219581 0 [pid=24534/tid=24535] ppid=24521 vsize=889960 CPUtime=1.76 /proc/24534/task/24535/stat : 24535 (java) R 24521 24520 4778 34817 4778 4202560 50093 0 1 0 153 23 0 0 25 0 10 0 11189883 911319040 70468 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=24534/tid=24536] ppid=24521 vsize=889960 CPUtime=0.21 /proc/24534/task/24536/stat : 24536 (java) S 24521 24520 4778 34817 4778 4202560 10771 0 0 0 21 0 0 0 16 0 10 0 11189884 911319040 70468 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24537] ppid=24521 vsize=889960 CPUtime=0 /proc/24534/task/24537/stat : 24537 (java) S 24521 24520 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 18 0 10 0 11189885 911319040 70468 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24538] ppid=24521 vsize=889960 CPUtime=0 /proc/24534/task/24538/stat : 24538 (java) S 24521 24520 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 10 0 11189885 911319040 70468 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24539] ppid=24521 vsize=889960 CPUtime=0 /proc/24534/task/24539/stat : 24539 (java) S 24521 24520 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 11189887 911319040 70468 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24540] ppid=24521 vsize=889960 CPUtime=0.4 /proc/24534/task/24540/stat : 24540 (java) S 24521 24520 4778 34817 4778 4202560 5187 0 0 0 38 2 0 0 23 0 10 0 11189887 911319040 70468 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24541] ppid=24521 vsize=889960 CPUtime=0.77 /proc/24534/task/24541/stat : 24541 (java) R 24521 24520 4778 34817 4778 4202560 6582 0 0 0 76 1 0 0 16 0 10 0 11189887 911319040 70468 1283457024 134512640 134550932 4293297968 18446744073709551615 4149621311 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=24534/tid=24542] ppid=24521 vsize=889960 CPUtime=0 /proc/24534/task/24542/stat : 24542 (java) S 24521 24520 4778 34817 4778 4202560 0 0 0 0 0 0 0 0 25 0 10 0 11189887 911319040 70468 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24543] ppid=24521 vsize=889960 CPUtime=0 /proc/24534/task/24543/stat : 24543 (java) S 24521 24520 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 15 0 10 0 11189887 911319040 70468 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 3.19 Current children cumulated vsize (KiB) 895100 [startup+4.00726 s] /proc/loadavg: 1.27 1.36 1.27 3/45 24543 /proc/meminfo: memFree=6000/1048576 swapFree=0/0 [pid=24520] ppid=24519 vsize=2568 CPUtime=0 /proc/24520/stat : 24520 (p2cudf-paranoid) S 24519 24520 4778 34817 4778 4202496 375 0 0 0 0 0 0 0 18 0 1 0 11189879 2629632 270 1283457024 134512640 135304128 4292566992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/24520/statm: 642 270 230 194 0 29 0 [pid=24521] ppid=24520 vsize=2572 CPUtime=0.02 /proc/24521/stat : 24521 (p2cudf) S 24520 24520 4778 34817 4778 4202496 390 3017 0 1 0 0 0 2 25 0 1 0 11189879 2633728 280 1283457024 134512640 135304128 4293449920 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/24521/statm: 643 280 239 194 0 30 0 [pid=24534] ppid=24521 vsize=889960 CPUtime=3.97 /proc/24534/stat : 24534 (java) S 24521 24520 4778 34817 4778 4202496 74663 0 1 0 368 29 0 0 25 0 10 0 11189882 911319040 70869 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/24534/statm: 222490 70869 1746 10 0 219581 0 [pid=24534/tid=24535] ppid=24521 vsize=889960 CPUtime=1.87 /proc/24534/task/24535/stat : 24535 (java) R 24521 24520 4778 34817 4778 4202560 50226 0 1 0 163 24 0 0 25 0 10 0 11189883 911319040 70869 1283457024 134512640 134550932 4293297968 18446744073709551615 4094737578 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=24534/tid=24536] ppid=24521 vsize=889960 CPUtime=0.21 /proc/24534/task/24536/stat : 24536 (java) S 24521 24520 4778 34817 4778 4202560 10771 0 0 0 21 0 0 0 15 0 10 0 11189884 911319040 70869 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24537] ppid=24521 vsize=889960 CPUtime=0 /proc/24534/task/24537/stat : 24537 (java) S 24521 24520 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 18 0 10 0 11189885 911319040 70869 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24538] ppid=24521 vsize=889960 CPUtime=0 /proc/24534/task/24538/stat : 24538 (java) S 24521 24520 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 10 0 11189885 911319040 70869 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24539] ppid=24521 vsize=889960 CPUtime=0 /proc/24534/task/24539/stat : 24539 (java) S 24521 24520 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 11189887 911319040 70869 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24540] ppid=24521 vsize=889960 CPUtime=0.4 /proc/24534/task/24540/stat : 24540 (java) S 24521 24520 4778 34817 4778 4202560 5187 0 0 0 38 2 0 0 23 0 10 0 11189887 911319040 70869 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24541] ppid=24521 vsize=889960 CPUtime=1.46 /proc/24534/task/24541/stat : 24541 (java) S 24521 24520 4778 34817 4778 4202560 7406 0 0 0 145 1 0 0 16 0 10 0 11189887 911319040 70869 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24542] ppid=24521 vsize=889960 CPUtime=0 /proc/24534/task/24542/stat : 24542 (java) S 24521 24520 4778 34817 4778 4202560 0 0 0 0 0 0 0 0 25 0 10 0 11189887 911319040 70869 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24543] ppid=24521 vsize=889960 CPUtime=0 /proc/24534/task/24543/stat : 24543 (java) S 24521 24520 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 15 0 10 0 11189887 911319040 70869 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 3.99 Current children cumulated vsize (KiB) 895100 [startup+4.70598 s] /proc/loadavg: 1.27 1.36 1.27 2/45 24543 /proc/meminfo: memFree=6232/1048576 swapFree=0/0 [pid=24520] ppid=24519 vsize=2568 CPUtime=0 /proc/24520/stat : 24520 (p2cudf-paranoid) S 24519 24520 4778 34817 4778 4202496 375 0 0 0 0 0 0 0 18 0 1 0 11189879 2629632 270 1283457024 134512640 135304128 4292566992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/24520/statm: 642 270 230 194 0 29 0 [pid=24521] ppid=24520 vsize=2572 CPUtime=0.02 /proc/24521/stat : 24521 (p2cudf) S 24520 24520 4778 34817 4778 4202496 390 3017 0 1 0 0 0 2 25 0 1 0 11189879 2633728 280 1283457024 134512640 135304128 4293449920 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/24521/statm: 643 280 239 194 0 30 0 [pid=24534] ppid=24521 vsize=890608 CPUtime=4.51 /proc/24534/stat : 24534 (java) S 24521 24520 4778 34817 4778 4202496 74771 0 1 0 422 29 0 0 25 0 11 0 11189882 911982592 70977 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/24534/statm: 222652 70977 1761 10 0 219743 0 [pid=24534/tid=24535] ppid=24521 vsize=890608 CPUtime=2.09 /proc/24534/task/24535/stat : 24535 (java) S 24521 24520 4778 34817 4778 4202560 50283 0 1 0 185 24 0 0 25 0 11 0 11189883 911982592 70977 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24536] ppid=24521 vsize=890608 CPUtime=0.21 /proc/24534/task/24536/stat : 24536 (java) S 24521 24520 4778 34817 4778 4202560 10771 0 0 0 21 0 0 0 16 0 11 0 11189884 911982592 70977 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24537] ppid=24521 vsize=890608 CPUtime=0 /proc/24534/task/24537/stat : 24537 (java) S 24521 24520 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 18 0 11 0 11189885 911982592 70977 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24538] ppid=24521 vsize=890608 CPUtime=0 /proc/24534/task/24538/stat : 24538 (java) S 24521 24520 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 11189885 911982592 70977 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24539] ppid=24521 vsize=890608 CPUtime=0 /proc/24534/task/24539/stat : 24539 (java) S 24521 24520 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 11189887 911982592 70977 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24540] ppid=24521 vsize=890608 CPUtime=0.4 /proc/24534/task/24540/stat : 24540 (java) S 24521 24520 4778 34817 4778 4202560 5187 0 0 0 38 2 0 0 23 0 11 0 11189887 911982592 70977 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24541] ppid=24521 vsize=890608 CPUtime=1.77 /proc/24534/task/24541/stat : 24541 (java) S 24521 24520 4778 34817 4778 4202560 7447 0 0 0 176 1 0 0 15 0 11 0 11189887 911982592 70977 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24542] ppid=24521 vsize=890608 CPUtime=0 /proc/24534/task/24542/stat : 24542 (java) S 24521 24520 4778 34817 4778 4202560 0 0 0 0 0 0 0 0 25 0 11 0 11189887 911982592 70977 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24543] ppid=24521 vsize=890608 CPUtime=0 /proc/24534/task/24543/stat : 24543 (java) S 24521 24520 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 15 0 11 0 11189887 911982592 70977 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 4.53 Current children cumulated vsize (KiB) 895748 [startup+5.10996 s] /proc/loadavg: 1.27 1.36 1.27 2/45 24543 /proc/meminfo: memFree=6232/1048576 swapFree=0/0 [pid=24520] ppid=24519 vsize=2568 CPUtime=0 /proc/24520/stat : 24520 (p2cudf-paranoid) S 24519 24520 4778 34817 4778 4202496 375 0 0 0 0 0 0 0 18 0 1 0 11189879 2629632 270 1283457024 134512640 135304128 4292566992 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/24520/statm: 642 270 230 194 0 29 0 [pid=24521] ppid=24520 vsize=2572 CPUtime=0.02 /proc/24521/stat : 24521 (p2cudf) S 24520 24520 4778 34817 4778 4202496 390 3017 0 1 0 0 0 2 25 0 1 0 11189879 2633728 280 1283457024 134512640 135304128 4293449920 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/24521/statm: 643 280 239 194 0 30 0 [pid=24534] ppid=24521 vsize=890608 CPUtime=4.57 /proc/24534/stat : 24534 (java) S 24521 24520 4778 34817 4778 4202496 74775 0 1 0 427 30 0 0 25 0 11 0 11189882 911982592 70981 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/24534/statm: 222652 70981 1762 10 0 219743 0 [pid=24534/tid=24535] ppid=24521 vsize=890608 CPUtime=2.09 /proc/24534/task/24535/stat : 24535 (java) S 24521 24520 4778 34817 4778 4202560 50283 0 1 0 185 24 0 0 25 0 11 0 11189883 911982592 70981 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24536] ppid=24521 vsize=890608 CPUtime=0.21 /proc/24534/task/24536/stat : 24536 (java) S 24521 24520 4778 34817 4778 4202560 10771 0 0 0 21 0 0 0 15 0 11 0 11189884 911982592 70981 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24537] ppid=24521 vsize=890608 CPUtime=0 /proc/24534/task/24537/stat : 24537 (java) S 24521 24520 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 18 0 11 0 11189885 911982592 70981 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24538] ppid=24521 vsize=890608 CPUtime=0 /proc/24534/task/24538/stat : 24538 (java) S 24521 24520 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 11189885 911982592 70981 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24539] ppid=24521 vsize=890608 CPUtime=0 /proc/24534/task/24539/stat : 24539 (java) S 24521 24520 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 11189887 911982592 70981 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24540] ppid=24521 vsize=890608 CPUtime=0.4 /proc/24534/task/24540/stat : 24540 (java) S 24521 24520 4778 34817 4778 4202560 5187 0 0 0 38 2 0 0 23 0 11 0 11189887 911982592 70981 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24541] ppid=24521 vsize=890608 CPUtime=1.79 /proc/24534/task/24541/stat : 24541 (java) S 24521 24520 4778 34817 4778 4202560 7450 0 0 0 178 1 0 0 16 0 11 0 11189887 911982592 70981 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24542] ppid=24521 vsize=890608 CPUtime=0 /proc/24534/task/24542/stat : 24542 (java) S 24521 24520 4778 34817 4778 4202560 0 0 0 0 0 0 0 0 25 0 11 0 11189887 911982592 70981 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=24534/tid=24543] ppid=24521 vsize=890608 CPUtime=0 /proc/24534/task/24543/stat : 24543 (java) R 24521 24520 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 15 0 11 0 11189887 911982592 70981 1283457024 134512640 134550932 4293297968 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 4.59 Current children cumulated vsize (KiB) 895748 Child status: 0 Real time (s): 5.18835 CPU time (s): 4.62429 CPU user time (s): 4.28027 CPU system time (s): 0.344021 CPU usage (%): 89.1282 Max. virtual memory (cumulated for all children) (KiB): 899192 getrusage(RUSAGE_CHILDREN,...) data: user time used= 4.28027 system time used= 0.344021 maximum resident set size= 0 integral shared memory size= 0 integral unshared data size= 0 integral unshared stack size= 0 page reclaims= 78582 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= 570 involuntary context switches= 554 runsolver used 0 second user time and 0 second system time The end