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/201012061533/p2cudf-paranoid-1.9/rand316.sarge-etch-lenny-squeeze-sid.cudf.sarge-etch-lenny-squeeze-sid.log.runsolver ./p2cudf-paranoid-1.9 /home/misc2010/data/icse/sarge-etch-lenny-squeeze-sid/rand316.sarge-etch-lenny-squeeze-sid.cudf /home/misc2010/tmp/201012061533/p2cudf-paranoid-1.9/rand316.sarge-etch-lenny-squeeze-sid.cudf.sarge-etch-lenny-squeeze-sid.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.11 1.16 1.10 1/45 11137 /proc/meminfo: memFree=890812/1048576 swapFree=2078740/2097144 [pid=11137] ppid=11136 vsize=3028 CPUtime=0 /proc/11137/stat : 11137 (runsolver) D 11136 11137 2059 34821 2220 4202560 73 0 0 0 0 0 0 0 25 0 1 0 875243319 3100672 94 1283457024 134512640 134586868 4289078064 18446744073709551615 4294960130 0 0 0 24578 18446744071564332000 0 0 17 0 0 0 0 /proc/11137/statm: 757 94 62 19 0 55 0 [startup+0.148367 s] /proc/loadavg: 1.11 1.16 1.10 1/45 11137 /proc/meminfo: memFree=890812/1048576 swapFree=2078740/2097144 [pid=11137] ppid=11136 vsize=2568 CPUtime=0 /proc/11137/stat : 11137 (p2cudf-paranoid) S 11136 11137 2059 34821 2220 4202496 376 0 0 0 0 0 0 0 25 0 1 0 875243319 2629632 272 1283457024 134512640 135304128 4292083456 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/11137/statm: 642 272 233 194 0 28 0 Current children cumulated CPU time (s) 0 Current children cumulated vsize (KiB) 2568 [startup+0.204408 s] /proc/loadavg: 1.11 1.16 1.10 1/45 11137 /proc/meminfo: memFree=890812/1048576 swapFree=2078740/2097144 [pid=11137] ppid=11136 vsize=2568 CPUtime=0 /proc/11137/stat : 11137 (p2cudf-paranoid) S 11136 11137 2059 34821 2220 4202496 376 0 0 0 0 0 0 0 25 0 1 0 875243319 2629632 272 1283457024 134512640 135304128 4292083456 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/11137/statm: 642 272 233 194 0 28 0 Current children cumulated CPU time (s) 0 Current children cumulated vsize (KiB) 2568 [startup+0.304387 s] /proc/loadavg: 1.11 1.16 1.10 1/45 11137 /proc/meminfo: memFree=890812/1048576 swapFree=2078740/2097144 [pid=11137] ppid=11136 vsize=2568 CPUtime=0 /proc/11137/stat : 11137 (p2cudf-paranoid) S 11136 11137 2059 34821 2220 4202496 376 0 0 0 0 0 0 0 25 0 1 0 875243319 2629632 272 1283457024 134512640 135304128 4292083456 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/11137/statm: 642 272 233 194 0 28 0 Current children cumulated CPU time (s) 0 Current children cumulated vsize (KiB) 2568 [startup+0.704719 s] /proc/loadavg: 1.11 1.16 1.10 1/45 11137 /proc/meminfo: memFree=890812/1048576 swapFree=2078740/2097144 [pid=11137] ppid=11136 vsize=2568 CPUtime=0 /proc/11137/stat : 11137 (p2cudf-paranoid) S 11136 11137 2059 34821 2220 4202496 376 0 0 0 0 0 0 0 25 0 1 0 875243319 2629632 272 1283457024 134512640 135304128 4292083456 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/11137/statm: 642 272 233 194 0 28 0 Current children cumulated CPU time (s) 0 Current children cumulated vsize (KiB) 2568 [startup+1.50658 s] /proc/loadavg: 1.11 1.16 1.10 1/57 11160 /proc/meminfo: memFree=867804/1048576 swapFree=2078740/2097144 [pid=11137] ppid=11136 vsize=2568 CPUtime=0 /proc/11137/stat : 11137 (p2cudf-paranoid) S 11136 11137 2059 34821 2220 4202496 376 0 0 0 0 0 0 0 25 0 1 0 875243319 2629632 272 1283457024 134512640 135304128 4292083456 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/11137/statm: 642 272 233 194 0 28 0 [pid=11139] ppid=11137 vsize=2580 CPUtime=0.01 /proc/11139/stat : 11139 (p2cudf) S 11137 11137 2059 34821 2220 4202496 393 2995 0 1 0 0 0 1 25 0 1 0 875243319 2641920 283 1283457024 134512640 135304128 4290059568 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/11139/statm: 645 283 241 194 0 31 0 [pid=11151] ppid=11139 vsize=873064 CPUtime=0.57 /proc/11151/stat : 11151 (java) S 11139 11137 2059 34821 2220 4202496 10589 0 107 0 56 1 0 0 23 0 10 0 875243323 894017536 9042 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/11151/statm: 218266 9042 1735 10 0 215356 0 [pid=11151/tid=11152] ppid=11139 vsize=873064 CPUtime=0.19 /proc/11151/task/11152/stat : 11152 (java) R 11139 11137 2059 34821 2220 4202560 4479 0 15 0 18 1 0 0 23 0 10 0 875243349 894017536 9042 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=11151/tid=11153] ppid=11139 vsize=873064 CPUtime=0 /proc/11151/task/11153/stat : 11153 (java) S 11139 11137 2059 34821 2220 4202560 6 0 0 0 0 0 0 0 18 0 10 0 875243357 894017536 9042 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 0 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11154] ppid=11139 vsize=873064 CPUtime=0 /proc/11151/task/11154/stat : 11154 (java) S 11139 11137 2059 34821 2220 4202560 5 0 1 0 0 0 0 0 25 0 10 0 875243358 894017536 9042 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11155] ppid=11139 vsize=873064 CPUtime=0 /proc/11151/task/11155/stat : 11155 (java) S 11139 11137 2059 34821 2220 4202560 7 0 0 0 0 0 0 0 25 0 10 0 875243358 894017536 9042 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11156] ppid=11139 vsize=873064 CPUtime=0 /proc/11151/task/11156/stat : 11156 (java) S 11139 11137 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 10 0 875243370 894017536 9042 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11157] ppid=11139 vsize=873064 CPUtime=0.12 /proc/11151/task/11157/stat : 11157 (java) R 11139 11137 2059 34821 2220 4202560 1797 0 3 0 12 0 0 0 17 0 10 0 875243370 894017536 9042 1283457024 134512640 134550932 4290499632 18446744073709551615 4149258719 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=11151/tid=11158] ppid=11139 vsize=873064 CPUtime=0.23 /proc/11151/task/11158/stat : 11158 (java) R 11139 11137 2059 34821 2220 4202560 3282 0 5 0 23 0 0 0 20 0 10 0 875243370 894017536 9042 1283457024 134512640 134550932 4290499632 18446744073709551615 4150115476 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=11151/tid=11159] ppid=11139 vsize=873064 CPUtime=0 /proc/11151/task/11159/stat : 11159 (java) S 11139 11137 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 10 0 875243370 894017536 9042 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11160] ppid=11139 vsize=873064 CPUtime=0 /proc/11151/task/11160/stat : 11160 (java) S 11139 11137 2059 34821 2220 4202560 2 0 0 0 0 0 0 0 16 0 10 0 875243370 894017536 9042 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 0.58 Current children cumulated vsize (KiB) 878212 [startup+3.10818 s] /proc/loadavg: 1.11 1.16 1.10 2/57 11160 /proc/meminfo: memFree=820948/1048576 swapFree=2078740/2097144 [pid=11137] ppid=11136 vsize=2568 CPUtime=0 /proc/11137/stat : 11137 (p2cudf-paranoid) S 11136 11137 2059 34821 2220 4202496 376 0 0 0 0 0 0 0 25 0 1 0 875243319 2629632 272 1283457024 134512640 135304128 4292083456 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/11137/statm: 642 272 233 194 0 28 0 [pid=11139] ppid=11137 vsize=2580 CPUtime=0.01 /proc/11139/stat : 11139 (p2cudf) S 11137 11137 2059 34821 2220 4202496 393 2995 0 1 0 0 0 1 25 0 1 0 875243319 2641920 283 1283457024 134512640 135304128 4290059568 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/11139/statm: 645 283 241 194 0 31 0 [pid=11151] ppid=11139 vsize=874940 CPUtime=2.06 /proc/11151/stat : 11151 (java) S 11139 11137 2059 34821 2220 4202496 52409 0 107 0 194 12 0 0 23 0 10 0 875243323 895938560 47748 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/11151/statm: 218735 47748 1742 10 0 215825 0 [pid=11151/tid=11152] ppid=11139 vsize=874940 CPUtime=0.96 /proc/11151/task/11152/stat : 11152 (java) R 11139 11137 2059 34821 2220 4202560 41893 0 15 0 85 11 0 0 25 0 10 0 875243349 895938560 47748 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=11151/tid=11153] ppid=11139 vsize=874940 CPUtime=0 /proc/11151/task/11153/stat : 11153 (java) S 11139 11137 2059 34821 2220 4202560 6 0 0 0 0 0 0 0 18 0 10 0 875243357 895938560 47748 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 0 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11154] ppid=11139 vsize=874940 CPUtime=0 /proc/11151/task/11154/stat : 11154 (java) S 11139 11137 2059 34821 2220 4202560 5 0 1 0 0 0 0 0 25 0 10 0 875243358 895938560 47748 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11155] ppid=11139 vsize=874940 CPUtime=0 /proc/11151/task/11155/stat : 11155 (java) S 11139 11137 2059 34821 2220 4202560 7 0 0 0 0 0 0 0 25 0 10 0 875243358 895938560 47748 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11156] ppid=11139 vsize=874940 CPUtime=0 /proc/11151/task/11156/stat : 11156 (java) S 11139 11137 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 10 0 875243370 895938560 47748 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11157] ppid=11139 vsize=874940 CPUtime=0.28 /proc/11151/task/11157/stat : 11157 (java) S 11139 11137 2059 34821 2220 4202560 2254 0 3 0 28 0 0 0 16 0 10 0 875243370 895938560 47748 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11158] ppid=11139 vsize=874940 CPUtime=0.79 /proc/11151/task/11158/stat : 11158 (java) S 11139 11137 2059 34821 2220 4202560 7231 0 5 0 79 0 0 0 15 0 10 0 875243370 895938560 47748 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11159] ppid=11139 vsize=874940 CPUtime=0 /proc/11151/task/11159/stat : 11159 (java) S 11139 11137 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 10 0 875243370 895938560 47748 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11160] ppid=11139 vsize=874940 CPUtime=0 /proc/11151/task/11160/stat : 11160 (java) S 11139 11137 2059 34821 2220 4202560 2 0 0 0 0 0 0 0 15 0 10 0 875243370 895938560 47748 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 2.07 Current children cumulated vsize (KiB) 880088 heavy processes: [startup+6.30271 s] /proc/loadavg: 1.10 1.16 1.10 2/57 11160 /proc/meminfo: memFree=585252/1048576 swapFree=2078740/2097144 [pid=11137] ppid=11136 vsize=2568 CPUtime=0 /proc/11137/stat : 11137 (p2cudf-paranoid) S 11136 11137 2059 34821 2220 4202496 376 0 0 0 0 0 0 0 25 0 1 0 875243319 2629632 272 1283457024 134512640 135304128 4292083456 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/11137/statm: 642 272 233 194 0 28 0 [pid=11139] ppid=11137 vsize=2580 CPUtime=0.01 /proc/11139/stat : 11139 (p2cudf) S 11137 11137 2059 34821 2220 4202496 393 2995 0 1 0 0 0 1 25 0 1 0 875243319 2641920 283 1283457024 134512640 135304128 4290059568 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/11139/statm: 645 283 241 194 0 31 0 [pid=11151] ppid=11139 vsize=874940 CPUtime=5.01 /proc/11151/stat : 11151 (java) S 11139 11137 2059 34821 2220 4202496 92322 0 108 0 476 25 0 0 23 0 10 0 875243323 895938560 84616 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/11151/statm: 218735 84616 1772 10 0 215825 0 [pid=11151/tid=11152] ppid=11139 vsize=874940 CPUtime=2.14 /proc/11151/task/11152/stat : 11152 (java) D 11139 11137 2059 34821 2220 4202560 50426 0 15 0 198 16 0 0 25 0 10 0 875243349 895938560 84616 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446744071564332000 0 0 -1 0 0 0 0 [pid=11151/tid=11153] ppid=11139 vsize=874940 CPUtime=0.65 /proc/11151/task/11153/stat : 11153 (java) S 11139 11137 2059 34821 2220 4202560 28195 0 0 0 59 6 0 0 16 0 10 0 875243357 895938560 84616 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 0 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11154] ppid=11139 vsize=874940 CPUtime=0 /proc/11151/task/11154/stat : 11154 (java) S 11139 11137 2059 34821 2220 4202560 5 0 1 0 0 0 0 0 18 0 10 0 875243358 895938560 84616 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11155] ppid=11139 vsize=874940 CPUtime=0 /proc/11151/task/11155/stat : 11155 (java) S 11139 11137 2059 34821 2220 4202560 9 0 0 0 0 0 0 0 18 0 10 0 875243358 895938560 84616 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11156] ppid=11139 vsize=874940 CPUtime=0 /proc/11151/task/11156/stat : 11156 (java) S 11139 11137 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 10 0 875243370 895938560 84616 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11157] ppid=11139 vsize=874940 CPUtime=0.28 /proc/11151/task/11157/stat : 11157 (java) S 11139 11137 2059 34821 2220 4202560 2254 0 3 0 28 0 0 0 16 0 10 0 875243370 895938560 84616 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11158] ppid=11139 vsize=874940 CPUtime=1.92 /proc/11151/task/11158/stat : 11158 (java) S 11139 11137 2059 34821 2220 4202560 10420 0 6 0 190 2 0 0 16 0 10 0 875243370 895938560 84616 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11159] ppid=11139 vsize=874940 CPUtime=0 /proc/11151/task/11159/stat : 11159 (java) S 11139 11137 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 10 0 875243370 895938560 84616 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11160] ppid=11139 vsize=874940 CPUtime=0 /proc/11151/task/11160/stat : 11160 (java) S 11139 11137 2059 34821 2220 4202560 2 0 0 0 0 0 0 0 15 0 10 0 875243370 895938560 84616 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 5.02 Current children cumulated vsize (KiB) 880088 heavy processes: Solver just ended. Dumping a history of the last processes samples [startup+7.80515 s] /proc/loadavg: 1.10 1.16 1.10 2/58 11164 /proc/meminfo: memFree=527096/1048576 swapFree=2078740/2097144 [pid=11137] ppid=11136 vsize=2568 CPUtime=0 /proc/11137/stat : 11137 (p2cudf-paranoid) S 11136 11137 2059 34821 2220 4202496 376 0 0 0 0 0 0 0 25 0 1 0 875243319 2629632 272 1283457024 134512640 135304128 4292083456 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/11137/statm: 642 272 233 194 0 28 0 [pid=11139] ppid=11137 vsize=2580 CPUtime=0.01 /proc/11139/stat : 11139 (p2cudf) S 11137 11137 2059 34821 2220 4202496 393 2995 0 1 0 0 0 1 25 0 1 0 875243319 2641920 283 1283457024 134512640 135304128 4290059568 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/11139/statm: 645 283 241 194 0 31 0 [pid=11151] ppid=11139 vsize=875588 CPUtime=6.51 /proc/11151/stat : 11151 (java) S 11139 11137 2059 34821 2220 4202496 92599 0 108 0 626 25 0 0 23 0 11 0 875243323 896602112 84678 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/11151/statm: 218897 84678 1793 10 0 215987 0 [pid=11151/tid=11152] ppid=11139 vsize=875588 CPUtime=3.08 /proc/11151/task/11152/stat : 11152 (java) R 11139 11137 2059 34821 2220 4202560 50439 0 15 0 292 16 0 0 25 0 11 0 875243349 896602112 84678 1283457024 134512640 134550932 4290499632 18446744073709551615 4096694821 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=11151/tid=11153] ppid=11139 vsize=875588 CPUtime=0.65 /proc/11151/task/11153/stat : 11153 (java) S 11139 11137 2059 34821 2220 4202560 28195 0 0 0 59 6 0 0 16 0 11 0 875243357 896602112 84678 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 0 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11154] ppid=11139 vsize=875588 CPUtime=0 /proc/11151/task/11154/stat : 11154 (java) S 11139 11137 2059 34821 2220 4202560 5 0 1 0 0 0 0 0 18 0 11 0 875243358 896602112 84678 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11155] ppid=11139 vsize=875588 CPUtime=0 /proc/11151/task/11155/stat : 11155 (java) S 11139 11137 2059 34821 2220 4202560 9 0 0 0 0 0 0 0 18 0 11 0 875243358 896602112 84678 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11156] ppid=11139 vsize=875588 CPUtime=0 /proc/11151/task/11156/stat : 11156 (java) S 11139 11137 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 11 0 875243370 896602112 84678 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11157] ppid=11139 vsize=875588 CPUtime=0.28 /proc/11151/task/11157/stat : 11157 (java) S 11139 11137 2059 34821 2220 4202560 2254 0 3 0 28 0 0 0 16 0 11 0 875243370 896602112 84678 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11158] ppid=11139 vsize=875588 CPUtime=2.47 /proc/11151/task/11158/stat : 11158 (java) S 11139 11137 2059 34821 2220 4202560 10676 0 6 0 245 2 0 0 16 0 11 0 875243370 896602112 84678 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11159] ppid=11139 vsize=875588 CPUtime=0 /proc/11151/task/11159/stat : 11159 (java) S 11139 11137 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 11 0 875243370 896602112 84678 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11160] ppid=11139 vsize=875588 CPUtime=0 /proc/11151/task/11160/stat : 11160 (java) S 11139 11137 2059 34821 2220 4202560 2 0 0 0 0 0 0 0 15 0 11 0 875243370 896602112 84678 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 6.52 Current children cumulated vsize (KiB) 880736 [startup+8.60534 s] /proc/loadavg: 1.10 1.16 1.10 3/58 11171 /proc/meminfo: memFree=527072/1048576 swapFree=2078740/2097144 [pid=11137] ppid=11136 vsize=2568 CPUtime=0 /proc/11137/stat : 11137 (p2cudf-paranoid) S 11136 11137 2059 34821 2220 4202496 376 0 0 0 0 0 0 0 25 0 1 0 875243319 2629632 272 1283457024 134512640 135304128 4292083456 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/11137/statm: 642 272 233 194 0 28 0 [pid=11139] ppid=11137 vsize=2580 CPUtime=0.01 /proc/11139/stat : 11139 (p2cudf) S 11137 11137 2059 34821 2220 4202496 393 2995 0 1 0 0 0 1 25 0 1 0 875243319 2641920 283 1283457024 134512640 135304128 4290059568 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/11139/statm: 645 283 241 194 0 31 0 [pid=11151] ppid=11139 vsize=876236 CPUtime=7.31 /proc/11151/stat : 11151 (java) S 11139 11137 2059 34821 2220 4202496 92621 0 108 0 705 26 0 0 23 0 11 0 875243323 897265664 84700 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/11151/statm: 219059 84700 1793 10 0 216149 0 [pid=11151/tid=11152] ppid=11139 vsize=876236 CPUtime=3.7 /proc/11151/task/11152/stat : 11152 (java) R 11139 11137 2059 34821 2220 4202560 50441 0 15 0 354 16 0 0 25 0 11 0 875243349 897265664 84700 1283457024 134512640 134550932 4290499632 18446744073709551615 4096518185 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=11151/tid=11153] ppid=11139 vsize=876236 CPUtime=0.65 /proc/11151/task/11153/stat : 11153 (java) S 11139 11137 2059 34821 2220 4202560 28195 0 0 0 59 6 0 0 16 0 11 0 875243357 897265664 84700 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 0 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11154] ppid=11139 vsize=876236 CPUtime=0 /proc/11151/task/11154/stat : 11154 (java) S 11139 11137 2059 34821 2220 4202560 5 0 1 0 0 0 0 0 18 0 11 0 875243358 897265664 84700 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11155] ppid=11139 vsize=876236 CPUtime=0 /proc/11151/task/11155/stat : 11155 (java) S 11139 11137 2059 34821 2220 4202560 9 0 0 0 0 0 0 0 18 0 11 0 875243358 897265664 84700 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11156] ppid=11139 vsize=876236 CPUtime=0 /proc/11151/task/11156/stat : 11156 (java) S 11139 11137 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 11 0 875243370 897265664 84700 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11157] ppid=11139 vsize=876236 CPUtime=0.28 /proc/11151/task/11157/stat : 11157 (java) S 11139 11137 2059 34821 2220 4202560 2254 0 3 0 28 0 0 0 16 0 11 0 875243370 897265664 84700 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11158] ppid=11139 vsize=876236 CPUtime=2.65 /proc/11151/task/11158/stat : 11158 (java) S 11139 11137 2059 34821 2220 4202560 10690 0 6 0 262 3 0 0 15 0 11 0 875243370 897265664 84700 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11159] ppid=11139 vsize=876236 CPUtime=0 /proc/11151/task/11159/stat : 11159 (java) S 11139 11137 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 11 0 875243370 897265664 84700 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11160] ppid=11139 vsize=876236 CPUtime=0 /proc/11151/task/11160/stat : 11160 (java) S 11139 11137 2059 34821 2220 4202560 2 0 0 0 0 0 0 0 15 0 11 0 875243370 897265664 84700 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11171] ppid=11139 vsize=876236 CPUtime=0 /proc/11151/task/11171/stat : 11171 (java) R 11139 11137 2059 34821 2220 4202560 2 0 0 0 0 0 0 0 25 0 11 0 875244174 897265664 84700 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 7.32 Current children cumulated vsize (KiB) 881384 [startup+9.00491 s] /proc/loadavg: 1.10 1.16 1.10 3/58 11171 /proc/meminfo: memFree=527072/1048576 swapFree=2078740/2097144 [pid=11137] ppid=11136 vsize=2568 CPUtime=0 /proc/11137/stat : 11137 (p2cudf-paranoid) S 11136 11137 2059 34821 2220 4202496 376 0 0 0 0 0 0 0 25 0 1 0 875243319 2629632 272 1283457024 134512640 135304128 4292083456 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/11137/statm: 642 272 233 194 0 28 0 [pid=11139] ppid=11137 vsize=2580 CPUtime=0.01 /proc/11139/stat : 11139 (p2cudf) S 11137 11137 2059 34821 2220 4202496 393 2995 0 1 0 0 0 1 25 0 1 0 875243319 2641920 283 1283457024 134512640 135304128 4290059568 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/11139/statm: 645 283 241 194 0 31 0 [pid=11151] ppid=11139 vsize=876236 CPUtime=7.43 /proc/11151/stat : 11151 (java) S 11139 11137 2059 34821 2220 4202496 92631 0 108 0 717 26 0 0 23 0 11 0 875243323 897265664 84710 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/11151/statm: 219059 84710 1793 10 0 216149 0 [pid=11151/tid=11152] ppid=11139 vsize=876236 CPUtime=3.8 /proc/11151/task/11152/stat : 11152 (java) S 11139 11137 2059 34821 2220 4202560 50448 0 15 0 364 16 0 0 25 0 11 0 875243349 897265664 84710 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11153] ppid=11139 vsize=876236 CPUtime=0.65 /proc/11151/task/11153/stat : 11153 (java) S 11139 11137 2059 34821 2220 4202560 28195 0 0 0 59 6 0 0 16 0 11 0 875243357 897265664 84710 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 0 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11154] ppid=11139 vsize=876236 CPUtime=0 /proc/11151/task/11154/stat : 11154 (java) S 11139 11137 2059 34821 2220 4202560 5 0 1 0 0 0 0 0 18 0 11 0 875243358 897265664 84710 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11155] ppid=11139 vsize=876236 CPUtime=0 /proc/11151/task/11155/stat : 11155 (java) S 11139 11137 2059 34821 2220 4202560 9 0 0 0 0 0 0 0 18 0 11 0 875243358 897265664 84710 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11156] ppid=11139 vsize=876236 CPUtime=0 /proc/11151/task/11156/stat : 11156 (java) S 11139 11137 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 11 0 875243370 897265664 84710 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11157] ppid=11139 vsize=876236 CPUtime=0.28 /proc/11151/task/11157/stat : 11157 (java) S 11139 11137 2059 34821 2220 4202560 2254 0 3 0 28 0 0 0 16 0 11 0 875243370 897265664 84710 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11158] ppid=11139 vsize=876236 CPUtime=2.67 /proc/11151/task/11158/stat : 11158 (java) S 11139 11137 2059 34821 2220 4202560 10690 0 6 0 264 3 0 0 15 0 11 0 875243370 897265664 84710 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11159] ppid=11139 vsize=876236 CPUtime=0 /proc/11151/task/11159/stat : 11159 (java) S 11139 11137 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 11 0 875243370 897265664 84710 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11160] ppid=11139 vsize=876236 CPUtime=0 /proc/11151/task/11160/stat : 11160 (java) S 11139 11137 2059 34821 2220 4202560 2 0 0 0 0 0 0 0 15 0 11 0 875243370 897265664 84710 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 7.44 Current children cumulated vsize (KiB) 881384 [startup+9.20497 s] /proc/loadavg: 1.10 1.16 1.10 3/58 11171 /proc/meminfo: memFree=527072/1048576 swapFree=2078740/2097144 [pid=11137] ppid=11136 vsize=2568 CPUtime=0 /proc/11137/stat : 11137 (p2cudf-paranoid) S 11136 11137 2059 34821 2220 4202496 376 0 0 0 0 0 0 0 25 0 1 0 875243319 2629632 272 1283457024 134512640 135304128 4292083456 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/11137/statm: 642 272 233 194 0 28 0 [pid=11139] ppid=11137 vsize=2580 CPUtime=0.01 /proc/11139/stat : 11139 (p2cudf) S 11137 11137 2059 34821 2220 4202496 393 2995 0 1 0 0 0 1 25 0 1 0 875243319 2641920 283 1283457024 134512640 135304128 4290059568 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/11139/statm: 645 283 241 194 0 31 0 [pid=11151] ppid=11139 vsize=876236 CPUtime=7.43 /proc/11151/stat : 11151 (java) S 11139 11137 2059 34821 2220 4202496 92631 0 108 0 717 26 0 0 23 0 11 0 875243323 897265664 84710 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/11151/statm: 219059 84710 1793 10 0 216149 0 [pid=11151/tid=11152] ppid=11139 vsize=876236 CPUtime=3.8 /proc/11151/task/11152/stat : 11152 (java) S 11139 11137 2059 34821 2220 4202560 50448 0 15 0 364 16 0 0 25 0 11 0 875243349 897265664 84710 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11153] ppid=11139 vsize=876236 CPUtime=0.65 /proc/11151/task/11153/stat : 11153 (java) S 11139 11137 2059 34821 2220 4202560 28195 0 0 0 59 6 0 0 16 0 11 0 875243357 897265664 84710 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 0 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11154] ppid=11139 vsize=876236 CPUtime=0 /proc/11151/task/11154/stat : 11154 (java) S 11139 11137 2059 34821 2220 4202560 5 0 1 0 0 0 0 0 18 0 11 0 875243358 897265664 84710 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11155] ppid=11139 vsize=876236 CPUtime=0 /proc/11151/task/11155/stat : 11155 (java) S 11139 11137 2059 34821 2220 4202560 9 0 0 0 0 0 0 0 18 0 11 0 875243358 897265664 84710 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11156] ppid=11139 vsize=876236 CPUtime=0 /proc/11151/task/11156/stat : 11156 (java) S 11139 11137 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 11 0 875243370 897265664 84710 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11157] ppid=11139 vsize=876236 CPUtime=0.28 /proc/11151/task/11157/stat : 11157 (java) S 11139 11137 2059 34821 2220 4202560 2254 0 3 0 28 0 0 0 16 0 11 0 875243370 897265664 84710 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11158] ppid=11139 vsize=876236 CPUtime=2.67 /proc/11151/task/11158/stat : 11158 (java) S 11139 11137 2059 34821 2220 4202560 10690 0 6 0 264 3 0 0 15 0 11 0 875243370 897265664 84710 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11159] ppid=11139 vsize=876236 CPUtime=0 /proc/11151/task/11159/stat : 11159 (java) S 11139 11137 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 11 0 875243370 897265664 84710 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11160] ppid=11139 vsize=876236 CPUtime=0 /proc/11151/task/11160/stat : 11160 (java) S 11139 11137 2059 34821 2220 4202560 2 0 0 0 0 0 0 0 15 0 11 0 875243370 897265664 84710 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 7.44 Current children cumulated vsize (KiB) 881384 [startup+9.30497 s] /proc/loadavg: 1.10 1.16 1.10 3/58 11171 /proc/meminfo: memFree=527072/1048576 swapFree=2078740/2097144 [pid=11137] ppid=11136 vsize=2568 CPUtime=0 /proc/11137/stat : 11137 (p2cudf-paranoid) S 11136 11137 2059 34821 2220 4202496 376 0 0 0 0 0 0 0 25 0 1 0 875243319 2629632 272 1283457024 134512640 135304128 4292083456 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/11137/statm: 642 272 233 194 0 28 0 [pid=11139] ppid=11137 vsize=2580 CPUtime=0.01 /proc/11139/stat : 11139 (p2cudf) S 11137 11137 2059 34821 2220 4202496 393 2995 0 1 0 0 0 1 25 0 1 0 875243319 2641920 283 1283457024 134512640 135304128 4290059568 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/11139/statm: 645 283 241 194 0 31 0 [pid=11151] ppid=11139 vsize=876236 CPUtime=7.5 /proc/11151/stat : 11151 (java) S 11139 11137 2059 34821 2220 4202496 92632 0 108 0 722 28 0 0 23 0 10 0 875243323 897265664 84711 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/11151/statm: 219059 84711 1793 10 0 216149 0 [pid=11151/tid=11152] ppid=11139 vsize=876236 CPUtime=3.8 /proc/11151/task/11152/stat : 11152 (java) S 11139 11137 2059 34821 2220 4202560 50448 0 15 0 364 16 0 0 20 0 10 0 875243349 897265664 84711 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11153] ppid=11139 vsize=876236 CPUtime=0.65 /proc/11151/task/11153/stat : 11153 (java) S 11139 11137 2059 34821 2220 4202560 28195 0 0 0 59 6 0 0 16 0 10 0 875243357 897265664 84711 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 0 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11154] ppid=11139 vsize=876236 CPUtime=0 /proc/11151/task/11154/stat : 11154 (java) S 11139 11137 2059 34821 2220 4202560 5 0 1 0 0 0 0 0 18 0 10 0 875243358 897265664 84711 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11155] ppid=11139 vsize=876236 CPUtime=0 /proc/11151/task/11155/stat : 11155 (java) S 11139 11137 2059 34821 2220 4202560 9 0 0 0 0 0 0 0 18 0 10 0 875243358 897265664 84711 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11156] ppid=11139 vsize=876236 CPUtime=0 /proc/11151/task/11156/stat : 11156 (java) S 11139 11137 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 10 0 875243370 897265664 84711 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11157] ppid=11139 vsize=876236 CPUtime=0.28 /proc/11151/task/11157/stat : 11157 (java) S 11139 11137 2059 34821 2220 4202560 2254 0 3 0 28 0 0 0 16 0 10 0 875243370 897265664 84711 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11158] ppid=11139 vsize=876236 CPUtime=2.69 /proc/11151/task/11158/stat : 11158 (java) S 11139 11137 2059 34821 2220 4202560 10690 0 6 0 266 3 0 0 15 0 10 0 875243370 897265664 84711 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11159] ppid=11139 vsize=876236 CPUtime=0 /proc/11151/task/11159/stat : 11159 (java) S 11139 11137 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 10 0 875243370 897265664 84711 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 [pid=11151/tid=11160] ppid=11139 vsize=876236 CPUtime=0 /proc/11151/task/11160/stat : 11160 (java) S 11139 11137 2059 34821 2220 4202560 2 0 0 0 0 0 0 0 15 0 10 0 875243370 897265664 84711 1283457024 134512640 134550932 4290499632 18446744073709551615 4294960130 0 4 0 16800975 18446612132680193024 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 7.51 Current children cumulated vsize (KiB) 881384 Child status: 0 Real time (s): 9.35007 CPU time (s): 7.55247 CPU user time (s): 7.22845 CPU system time (s): 0.32402 CPU usage (%): 80.7745 Max. virtual memory (cumulated for all children) (KiB): 885592 getrusage(RUSAGE_CHILDREN,...) data: user time used= 7.22845 system time used= 0.32402 maximum resident set size= 0 integral shared memory size= 0 integral unshared data size= 0 integral unshared stack size= 0 page reclaims= 96420 page faults= 109 swaps= 0 block input operations= 0 block output operations= 0 messages sent= 0 messages received= 0 signals received= 0 voluntary context switches= 1740 involuntary context switches= 1173 runsolver used 0.008 second user time and 0 second system time The end