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/201108311143/p2cudf-user-1.13/e381ba7e-a192-11e0-8647-00163e1e087d.cudf.dudf-real.log.runsolver ./p2cudf-user-1.13 /home/misc2010/data/2011/dudf-real//e381ba7e-a192-11e0-8647-00163e1e087d.cudf /home/misc2010/tmp/201108311143/p2cudf-user-1.13/e381ba7e-a192-11e0-8647-00163e1e087d.cudf.dudf-real.result -sum(installedsize) 

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.08 1.02 1.01 5/36 3246
/proc/meminfo: memFree=398600/1048576 swapFree=0/0
[pid=3243] ppid=3242 vsize=2568 CPUtime=0
/proc/3243/stat : 3243 (p2cudf-user-1.1) S 3242 3243 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 68596534 2629632 270 1283457024 134512640 135304128 4288293744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3243/statm: 642 270 230 194 0 29 0
[pid=3244] ppid=3243 vsize=2564 CPUtime=0
/proc/3244/stat : 3244 (p2cudf) S 3243 3243 19908 34817 19908 4202496 352 0 0 0 0 0 0 0 18 0 1 0 68596535 2625536 271 1283457024 134512640 135304128 4289023056 18446744073709551615 4294960130 0 0 4 65536 18446744071564457842 0 0 17 0 0 0 0
/proc/3244/statm: 641 271 231 194 0 28 0
[pid=3245] ppid=3244 vsize=2564 CPUtime=0
/proc/3245/stat : 3245 (p2cudf) R 3244 3243 19908 34817 19908 4202560 94 0 0 0 0 0 0 0 25 0 1 0 68596535 2625536 118 1283457024 134512640 135304128 4289023056 18446744073709551615 4294960130 0 65538 0 65538 0 0 0 17 0 0 0 0
/proc/3245/statm: 641 118 77 194 0 28 0
[pid=3246] ppid=3245 vsize=2564 CPUtime=0
/proc/3246/stat : 3246 (p2cudf) R 3245 3243 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 1 0 68596535 2625536 41 1283457024 134512640 135304128 4289023056 18446744073709551615 4294960130 0 65538 0 65538 0 0 0 17 0 0 0 0
/proc/3246/statm: 641 41 0 194 0 28 0

[startup+0.145601 s]
/proc/loadavg: 1.08 1.02 1.01 5/36 3246
/proc/meminfo: memFree=398600/1048576 swapFree=0/0
[pid=3243] ppid=3242 vsize=2568 CPUtime=0
/proc/3243/stat : 3243 (p2cudf-user-1.1) S 3242 3243 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 68596534 2629632 270 1283457024 134512640 135304128 4288293744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3243/statm: 642 270 230 194 0 29 0
[pid=3244] ppid=3243 vsize=2572 CPUtime=0.03
/proc/3244/stat : 3244 (p2cudf) S 3243 3243 19908 34817 19908 4202496 393 3016 0 1 0 1 1 1 25 0 1 0 68596535 2633728 281 1283457024 134512640 135304128 4289023056 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3244/statm: 643 281 239 194 0 30 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5140

[startup+0.205603 s]
/proc/loadavg: 1.08 1.02 1.01 5/36 3246
/proc/meminfo: memFree=398600/1048576 swapFree=0/0
[pid=3243] ppid=3242 vsize=2568 CPUtime=0
/proc/3243/stat : 3243 (p2cudf-user-1.1) S 3242 3243 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 68596534 2629632 270 1283457024 134512640 135304128 4288293744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3243/statm: 642 270 230 194 0 29 0
[pid=3244] ppid=3243 vsize=2572 CPUtime=0.03
/proc/3244/stat : 3244 (p2cudf) S 3243 3243 19908 34817 19908 4202496 393 3016 0 1 0 1 1 1 25 0 1 0 68596535 2633728 281 1283457024 134512640 135304128 4289023056 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3244/statm: 643 281 239 194 0 30 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5140

[startup+0.305623 s]
/proc/loadavg: 1.08 1.02 1.01 5/36 3246
/proc/meminfo: memFree=398600/1048576 swapFree=0/0
[pid=3243] ppid=3242 vsize=2568 CPUtime=0
/proc/3243/stat : 3243 (p2cudf-user-1.1) S 3242 3243 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 68596534 2629632 270 1283457024 134512640 135304128 4288293744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3243/statm: 642 270 230 194 0 29 0
[pid=3244] ppid=3243 vsize=2572 CPUtime=0.03
/proc/3244/stat : 3244 (p2cudf) S 3243 3243 19908 34817 19908 4202496 393 3016 0 1 0 1 1 1 25 0 1 0 68596535 2633728 281 1283457024 134512640 135304128 4289023056 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3244/statm: 643 281 239 194 0 30 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5140

[startup+0.705721 s]
/proc/loadavg: 1.08 1.02 1.01 5/36 3246
/proc/meminfo: memFree=398600/1048576 swapFree=0/0
[pid=3243] ppid=3242 vsize=2568 CPUtime=0
/proc/3243/stat : 3243 (p2cudf-user-1.1) S 3242 3243 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 68596534 2629632 270 1283457024 134512640 135304128 4288293744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3243/statm: 642 270 230 194 0 29 0
[pid=3244] ppid=3243 vsize=2572 CPUtime=0.03
/proc/3244/stat : 3244 (p2cudf) S 3243 3243 19908 34817 19908 4202496 393 3016 0 1 0 1 1 1 25 0 1 0 68596535 2633728 281 1283457024 134512640 135304128 4289023056 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3244/statm: 643 281 239 194 0 30 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5140

[startup+1.50589 s]
/proc/loadavg: 1.08 1.02 1.01 3/45 3266
/proc/meminfo: memFree=346260/1048576 swapFree=0/0
[pid=3243] ppid=3242 vsize=2568 CPUtime=0
/proc/3243/stat : 3243 (p2cudf-user-1.1) S 3242 3243 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 68596534 2629632 270 1283457024 134512640 135304128 4288293744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3243/statm: 642 270 230 194 0 29 0
[pid=3244] ppid=3243 vsize=2572 CPUtime=0.03
/proc/3244/stat : 3244 (p2cudf) S 3243 3243 19908 34817 19908 4202496 393 3016 0 1 0 1 1 1 25 0 1 0 68596535 2633728 281 1283457024 134512640 135304128 4289023056 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3244/statm: 643 281 239 194 0 30 0
[pid=3257] ppid=3244 vsize=884524 CPUtime=1.46
/proc/3257/stat : 3257 (java) S 3244 3243 19908 34817 19908 4202496 21879 0 1 0 140 6 0 0 25 0 10 0 68596538 905752576 18264 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/3257/statm: 221131 18264 1721 10 0 218222 0
[pid=3257/tid=3258] ppid=3244 vsize=884524 CPUtime=0.79
/proc/3257/task/3258/stat : 3258 (java) R 3244 3243 19908 34817 19908 4202560 10284 0 1 0 77 2 0 0 25 0 10 0 68596539 905752576 18264 1283457024 134512640 134550932 4287836624 18446744073709551615 4095196371 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=3257/tid=3259] ppid=3244 vsize=884524 CPUtime=0
/proc/3257/task/3259/stat : 3259 (java) S 3244 3243 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 16 0 10 0 68596540 905752576 18264 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3260] ppid=3244 vsize=884524 CPUtime=0
/proc/3257/task/3260/stat : 3260 (java) S 3244 3243 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 25 0 10 0 68596541 905752576 18264 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3261] ppid=3244 vsize=884524 CPUtime=0
/proc/3257/task/3261/stat : 3261 (java) S 3244 3243 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 10 0 68596541 905752576 18264 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3262] ppid=3244 vsize=884524 CPUtime=0
/proc/3257/task/3262/stat : 3262 (java) S 3244 3243 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 68596543 905752576 18264 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3263] ppid=3244 vsize=884524 CPUtime=0.45
/proc/3257/task/3263/stat : 3263 (java) R 3244 3243 19908 34817 19908 4202560 8496 0 0 0 43 2 0 0 25 0 10 0 68596543 905752576 18264 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=3257/tid=3264] ppid=3244 vsize=884524 CPUtime=0.21
/proc/3257/task/3264/stat : 3264 (java) R 3244 3243 19908 34817 19908 4202560 2018 0 0 0 20 1 0 0 18 0 10 0 68596543 905752576 18264 1283457024 134512640 134550932 4287836624 18446744073709551615 4152176310 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=3257/tid=3265] ppid=3244 vsize=884524 CPUtime=0
/proc/3257/task/3265/stat : 3265 (java) S 3244 3243 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 68596543 905752576 18264 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3266] ppid=3244 vsize=884524 CPUtime=0
/proc/3257/task/3266/stat : 3266 (java) S 3244 3243 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 10 0 68596543 905752576 18264 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 1.49
Current children cumulated vsize (KiB) 889664

[startup+3.10628 s]
/proc/loadavg: 1.08 1.02 1.01 3/45 3266
/proc/meminfo: memFree=263428/1048576 swapFree=0/0
[pid=3243] ppid=3242 vsize=2568 CPUtime=0
/proc/3243/stat : 3243 (p2cudf-user-1.1) S 3242 3243 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 68596534 2629632 270 1283457024 134512640 135304128 4288293744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3243/statm: 642 270 230 194 0 29 0
[pid=3244] ppid=3243 vsize=2572 CPUtime=0.03
/proc/3244/stat : 3244 (p2cudf) S 3243 3243 19908 34817 19908 4202496 393 3016 0 1 0 1 1 1 25 0 1 0 68596535 2633728 281 1283457024 134512640 135304128 4289023056 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3244/statm: 643 281 239 194 0 30 0
[pid=3257] ppid=3244 vsize=882140 CPUtime=3.06
/proc/3257/stat : 3257 (java) S 3244 3243 19908 34817 19908 4202496 75907 0 1 0 284 22 0 0 25 0 10 0 68596538 903311360 71325 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/3257/statm: 220535 71325 1753 10 0 217626 0
[pid=3257/tid=3258] ppid=3244 vsize=882140 CPUtime=1.67
/proc/3257/task/3258/stat : 3258 (java) R 3244 3243 19908 34817 19908 4202560 50088 0 1 0 153 14 0 0 25 0 10 0 68596539 903311360 71325 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=3257/tid=3259] ppid=3244 vsize=882140 CPUtime=0.29
/proc/3257/task/3259/stat : 3259 (java) S 3244 3243 19908 34817 19908 4202560 13359 0 0 0 25 4 0 0 16 0 10 0 68596540 903311360 71325 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3260] ppid=3244 vsize=882140 CPUtime=0
/proc/3257/task/3260/stat : 3260 (java) S 3244 3243 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 18 0 10 0 68596541 903311360 71325 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3261] ppid=3244 vsize=882140 CPUtime=0
/proc/3257/task/3261/stat : 3261 (java) S 3244 3243 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 10 0 68596541 903311360 71325 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3262] ppid=3244 vsize=882140 CPUtime=0
/proc/3257/task/3262/stat : 3262 (java) S 3244 3243 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 68596543 903311360 71325 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3263] ppid=3244 vsize=882140 CPUtime=0.65
/proc/3257/task/3263/stat : 3263 (java) R 3244 3243 19908 34817 19908 4202560 8566 0 0 0 63 2 0 0 17 0 10 0 68596543 903311360 71325 1283457024 134512640 134550932 4287836624 18446744073709551615 4147443866 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=3257/tid=3264] ppid=3244 vsize=882140 CPUtime=0.43
/proc/3257/task/3264/stat : 3264 (java) S 3244 3243 19908 34817 19908 4202560 2817 0 0 0 42 1 0 0 15 0 10 0 68596543 903311360 71325 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3265] ppid=3244 vsize=882140 CPUtime=0
/proc/3257/task/3265/stat : 3265 (java) S 3244 3243 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 68596543 903311360 71325 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3266] ppid=3244 vsize=882140 CPUtime=0
/proc/3257/task/3266/stat : 3266 (java) S 3244 3243 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 10 0 68596543 903311360 71325 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 3.09
Current children cumulated vsize (KiB) 887280

[startup+6.30699 s]
/proc/loadavg: 1.07 1.02 1.00 3/46 3267
/proc/meminfo: memFree=116976/1048576 swapFree=0/0
[pid=3243] ppid=3242 vsize=2568 CPUtime=0
/proc/3243/stat : 3243 (p2cudf-user-1.1) S 3242 3243 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 68596534 2629632 270 1283457024 134512640 135304128 4288293744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3243/statm: 642 270 230 194 0 29 0
[pid=3244] ppid=3243 vsize=2572 CPUtime=0.03
/proc/3244/stat : 3244 (p2cudf) S 3243 3243 19908 34817 19908 4202496 393 3016 0 1 0 1 1 1 25 0 1 0 68596535 2633728 281 1283457024 134512640 135304128 4289023056 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3244/statm: 643 281 239 194 0 30 0
[pid=3257] ppid=3244 vsize=882356 CPUtime=6.26
/proc/3257/stat : 3257 (java) S 3244 3243 19908 34817 19908 4202496 85373 0 1 0 602 24 0 0 25 0 11 0 68596538 903532544 79180 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/3257/statm: 220589 79180 1781 10 0 217680 0
[pid=3257/tid=3258] ppid=3244 vsize=882356 CPUtime=3.5
/proc/3257/task/3258/stat : 3258 (java) R 3244 3243 19908 34817 19908 4202560 50274 0 1 0 335 15 0 0 25 0 11 0 68596539 903532544 79180 1283457024 134512640 134550932 4287836624 18446744073709551615 4095780144 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=3257/tid=3259] ppid=3244 vsize=882356 CPUtime=0.59
/proc/3257/task/3259/stat : 3259 (java) S 3244 3243 19908 34817 19908 4202560 20843 0 0 0 54 5 0 0 16 0 11 0 68596540 903532544 79180 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3260] ppid=3244 vsize=882356 CPUtime=0
/proc/3257/task/3260/stat : 3260 (java) S 3244 3243 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 18 0 11 0 68596541 903532544 79180 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3261] ppid=3244 vsize=882356 CPUtime=0
/proc/3257/task/3261/stat : 3261 (java) S 3244 3243 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 68596541 903532544 79180 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3262] ppid=3244 vsize=882356 CPUtime=0
/proc/3257/task/3262/stat : 3262 (java) S 3244 3243 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68596543 903532544 79180 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3263] ppid=3244 vsize=882356 CPUtime=1.72
/proc/3257/task/3263/stat : 3263 (java) S 3244 3243 19908 34817 19908 4202560 10358 0 0 0 170 2 0 0 16 0 11 0 68596543 903532544 79180 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3264] ppid=3244 vsize=882356 CPUtime=0.43
/proc/3257/task/3264/stat : 3264 (java) S 3244 3243 19908 34817 19908 4202560 2817 0 0 0 42 1 0 0 15 0 11 0 68596543 903532544 79180 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3265] ppid=3244 vsize=882356 CPUtime=0
/proc/3257/task/3265/stat : 3265 (java) S 3244 3243 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68596543 903532544 79180 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3266] ppid=3244 vsize=882356 CPUtime=0
/proc/3257/task/3266/stat : 3266 (java) S 3244 3243 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 68596543 903532544 79180 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3267] ppid=3244 vsize=882356 CPUtime=0
/proc/3257/task/3267/stat : 3267 (java) S 3244 3243 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 68596947 903532544 79180 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 6.29
Current children cumulated vsize (KiB) 887496

[startup+12.7087 s]
/proc/loadavg: 1.15 1.03 1.01 2/46 3267
/proc/meminfo: memFree=87348/1048576 swapFree=0/0
[pid=3243] ppid=3242 vsize=2568 CPUtime=0
/proc/3243/stat : 3243 (p2cudf-user-1.1) S 3242 3243 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 68596534 2629632 270 1283457024 134512640 135304128 4288293744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3243/statm: 642 270 230 194 0 29 0
[pid=3244] ppid=3243 vsize=2572 CPUtime=0.03
/proc/3244/stat : 3244 (p2cudf) S 3243 3243 19908 34817 19908 4202496 393 3016 0 1 0 1 1 1 25 0 1 0 68596535 2633728 281 1283457024 134512640 135304128 4289023056 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3244/statm: 643 281 239 194 0 30 0
[pid=3257] ppid=3244 vsize=880948 CPUtime=12.65
/proc/3257/stat : 3257 (java) S 3244 3243 19908 34817 19908 4202496 85857 0 1 0 1241 24 0 0 25 0 11 0 68596538 902090752 79312 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/3257/statm: 220237 79312 1783 10 0 217328 0
[pid=3257/tid=3258] ppid=3244 vsize=880948 CPUtime=8.84
/proc/3257/task/3258/stat : 3258 (java) R 3244 3243 19908 34817 19908 4202560 50274 0 1 0 869 15 0 0 25 0 11 0 68596539 902090752 79312 1283457024 134512640 134550932 4287836624 18446744073709551615 4095735968 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=3257/tid=3259] ppid=3244 vsize=880948 CPUtime=1.54
/proc/3257/task/3259/stat : 3259 (java) S 3244 3243 19908 34817 19908 4202560 21310 0 0 0 149 5 0 0 16 0 11 0 68596540 902090752 79312 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3260] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3260/stat : 3260 (java) S 3244 3243 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 18 0 11 0 68596541 902090752 79312 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3261] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3261/stat : 3261 (java) S 3244 3243 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 68596541 902090752 79312 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3262] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3262/stat : 3262 (java) S 3244 3243 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68596543 902090752 79312 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3263] ppid=3244 vsize=880948 CPUtime=1.82
/proc/3257/task/3263/stat : 3263 (java) S 3244 3243 19908 34817 19908 4202560 10375 0 0 0 180 2 0 0 16 0 11 0 68596543 902090752 79312 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3264] ppid=3244 vsize=880948 CPUtime=0.43
/proc/3257/task/3264/stat : 3264 (java) S 3244 3243 19908 34817 19908 4202560 2817 0 0 0 42 1 0 0 15 0 11 0 68596543 902090752 79312 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3265] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3265/stat : 3265 (java) S 3244 3243 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68596543 902090752 79312 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3266] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3266/stat : 3266 (java) S 3244 3243 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 68596543 902090752 79312 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3267] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3267/stat : 3267 (java) S 3244 3243 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 68596947 902090752 79312 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 12.68
Current children cumulated vsize (KiB) 886088

[startup+25.512 s]
/proc/loadavg: 1.11 1.03 1.01 2/46 3267
/proc/meminfo: memFree=84620/1048576 swapFree=0/0
[pid=3243] ppid=3242 vsize=2568 CPUtime=0
/proc/3243/stat : 3243 (p2cudf-user-1.1) S 3242 3243 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 68596534 2629632 270 1283457024 134512640 135304128 4288293744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3243/statm: 642 270 230 194 0 29 0
[pid=3244] ppid=3243 vsize=2572 CPUtime=0.03
/proc/3244/stat : 3244 (p2cudf) S 3243 3243 19908 34817 19908 4202496 393 3016 0 1 0 1 1 1 25 0 1 0 68596535 2633728 281 1283457024 134512640 135304128 4289023056 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3244/statm: 643 281 239 194 0 30 0
[pid=3257] ppid=3244 vsize=880948 CPUtime=25.44
/proc/3257/stat : 3257 (java) S 3244 3243 19908 34817 19908 4202496 86549 0 1 0 2520 24 0 0 25 0 11 0 68596538 902090752 80004 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/3257/statm: 220237 80004 1783 10 0 217328 0
[pid=3257/tid=3258] ppid=3244 vsize=880948 CPUtime=20.25
/proc/3257/task/3258/stat : 3258 (java) R 3244 3243 19908 34817 19908 4202560 50274 0 1 0 2010 15 0 0 25 0 11 0 68596539 902090752 80004 1283457024 134512640 134550932 4287836624 18446744073709551615 4095788563 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=3257/tid=3259] ppid=3244 vsize=880948 CPUtime=2.93
/proc/3257/task/3259/stat : 3259 (java) S 3244 3243 19908 34817 19908 4202560 22002 0 0 0 287 6 0 0 16 0 11 0 68596540 902090752 80004 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3260] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3260/stat : 3260 (java) S 3244 3243 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 18 0 11 0 68596541 902090752 80004 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3261] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3261/stat : 3261 (java) S 3244 3243 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 68596541 902090752 80004 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3262] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3262/stat : 3262 (java) S 3244 3243 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68596543 902090752 80004 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3263] ppid=3244 vsize=880948 CPUtime=1.82
/proc/3257/task/3263/stat : 3263 (java) S 3244 3243 19908 34817 19908 4202560 10375 0 0 0 180 2 0 0 16 0 11 0 68596543 902090752 80004 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3264] ppid=3244 vsize=880948 CPUtime=0.43
/proc/3257/task/3264/stat : 3264 (java) S 3244 3243 19908 34817 19908 4202560 2817 0 0 0 42 1 0 0 15 0 11 0 68596543 902090752 80004 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3265] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3265/stat : 3265 (java) S 3244 3243 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68596543 902090752 80004 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3266] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3266/stat : 3266 (java) S 3244 3243 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 68596543 902090752 80004 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3267] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3267/stat : 3267 (java) S 3244 3243 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 68596947 902090752 80004 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 25.47
Current children cumulated vsize (KiB) 886088

[startup+51.1074 s]
/proc/loadavg: 1.07 1.03 1.01 2/46 3267
/proc/meminfo: memFree=80652/1048576 swapFree=0/0
[pid=3243] ppid=3242 vsize=2568 CPUtime=0
/proc/3243/stat : 3243 (p2cudf-user-1.1) S 3242 3243 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 68596534 2629632 270 1283457024 134512640 135304128 4288293744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3243/statm: 642 270 230 194 0 29 0
[pid=3244] ppid=3243 vsize=2572 CPUtime=0.03
/proc/3244/stat : 3244 (p2cudf) S 3243 3243 19908 34817 19908 4202496 393 3016 0 1 0 1 1 1 25 0 1 0 68596535 2633728 281 1283457024 134512640 135304128 4289023056 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3244/statm: 643 281 239 194 0 30 0
[pid=3257] ppid=3244 vsize=880948 CPUtime=51.02
/proc/3257/stat : 3257 (java) S 3244 3243 19908 34817 19908 4202496 87495 0 1 0 5076 26 0 0 25 0 11 0 68596538 902090752 80950 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/3257/statm: 220237 80950 1783 10 0 217328 0
[pid=3257/tid=3258] ppid=3244 vsize=880948 CPUtime=43.92
/proc/3257/task/3258/stat : 3258 (java) R 3244 3243 19908 34817 19908 4202560 50274 0 1 0 4376 16 0 0 25 0 11 0 68596539 902090752 80950 1283457024 134512640 134550932 4287836624 18446744073709551615 4095747756 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=3257/tid=3259] ppid=3244 vsize=880948 CPUtime=4.82
/proc/3257/task/3259/stat : 3259 (java) S 3244 3243 19908 34817 19908 4202560 22948 0 0 0 476 6 0 0 16 0 11 0 68596540 902090752 80950 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3260] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3260/stat : 3260 (java) S 3244 3243 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 18 0 11 0 68596541 902090752 80950 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3261] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3261/stat : 3261 (java) S 3244 3243 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 68596541 902090752 80950 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3262] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3262/stat : 3262 (java) S 3244 3243 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68596543 902090752 80950 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3263] ppid=3244 vsize=880948 CPUtime=1.82
/proc/3257/task/3263/stat : 3263 (java) S 3244 3243 19908 34817 19908 4202560 10375 0 0 0 180 2 0 0 16 0 11 0 68596543 902090752 80950 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3264] ppid=3244 vsize=880948 CPUtime=0.43
/proc/3257/task/3264/stat : 3264 (java) S 3244 3243 19908 34817 19908 4202560 2817 0 0 0 42 1 0 0 15 0 11 0 68596543 902090752 80950 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3265] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3265/stat : 3265 (java) S 3244 3243 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68596543 902090752 80950 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3266] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3266/stat : 3266 (java) S 3244 3243 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 68596543 902090752 80950 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3267] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3267/stat : 3267 (java) S 3244 3243 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 68596947 902090752 80950 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 51.05
Current children cumulated vsize (KiB) 886088

[startup+102.312 s]
/proc/loadavg: 1.11 1.04 1.01 3/46 3267
/proc/meminfo: memFree=80528/1048576 swapFree=0/0
[pid=3243] ppid=3242 vsize=2568 CPUtime=0
/proc/3243/stat : 3243 (p2cudf-user-1.1) S 3242 3243 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 68596534 2629632 270 1283457024 134512640 135304128 4288293744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3243/statm: 642 270 230 194 0 29 0
[pid=3244] ppid=3243 vsize=2572 CPUtime=0.03
/proc/3244/stat : 3244 (p2cudf) S 3243 3243 19908 34817 19908 4202496 393 3016 0 1 0 1 1 1 25 0 1 0 68596535 2633728 281 1283457024 134512640 135304128 4289023056 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3244/statm: 643 281 239 194 0 30 0
[pid=3257] ppid=3244 vsize=880948 CPUtime=102.15
/proc/3257/stat : 3257 (java) S 3244 3243 19908 34817 19908 4202496 87495 0 1 0 10187 28 0 0 25 0 11 0 68596538 902090752 80950 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/3257/statm: 220237 80950 1783 10 0 217328 0
[pid=3257/tid=3258] ppid=3244 vsize=880948 CPUtime=91.46
/proc/3257/task/3258/stat : 3258 (java) R 3244 3243 19908 34817 19908 4202560 50274 0 1 0 9128 18 0 0 25 0 11 0 68596539 902090752 80950 1283457024 134512640 134550932 4287836624 18446744073709551615 4095766347 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=3257/tid=3259] ppid=3244 vsize=880948 CPUtime=8.41
/proc/3257/task/3259/stat : 3259 (java) S 3244 3243 19908 34817 19908 4202560 22948 0 0 0 835 6 0 0 15 0 11 0 68596540 902090752 80950 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3260] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3260/stat : 3260 (java) S 3244 3243 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 18 0 11 0 68596541 902090752 80950 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3261] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3261/stat : 3261 (java) S 3244 3243 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 68596541 902090752 80950 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3262] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3262/stat : 3262 (java) S 3244 3243 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68596543 902090752 80950 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3263] ppid=3244 vsize=880948 CPUtime=1.84
/proc/3257/task/3263/stat : 3263 (java) S 3244 3243 19908 34817 19908 4202560 10375 0 0 0 182 2 0 0 15 0 11 0 68596543 902090752 80950 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3264] ppid=3244 vsize=880948 CPUtime=0.43
/proc/3257/task/3264/stat : 3264 (java) S 3244 3243 19908 34817 19908 4202560 2817 0 0 0 42 1 0 0 15 0 11 0 68596543 902090752 80950 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3265] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3265/stat : 3265 (java) S 3244 3243 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68596543 902090752 80950 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3266] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3266/stat : 3266 (java) S 3244 3243 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 68596543 902090752 80950 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3267] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3267/stat : 3267 (java) S 3244 3243 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 68596947 902090752 80950 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 102.18
Current children cumulated vsize (KiB) 886088

[startup+162.312 s]
/proc/loadavg: 1.09 1.04 1.01 4/48 3273
/proc/meminfo: memFree=79388/1048576 swapFree=0/0
[pid=3243] ppid=3242 vsize=2568 CPUtime=0
/proc/3243/stat : 3243 (p2cudf-user-1.1) S 3242 3243 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 68596534 2629632 270 1283457024 134512640 135304128 4288293744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3243/statm: 642 270 230 194 0 29 0
[pid=3244] ppid=3243 vsize=2572 CPUtime=0.03
/proc/3244/stat : 3244 (p2cudf) S 3243 3243 19908 34817 19908 4202496 393 3016 0 1 0 1 1 1 25 0 1 0 68596535 2633728 281 1283457024 134512640 135304128 4289023056 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3244/statm: 643 281 239 194 0 30 0
[pid=3257] ppid=3244 vsize=880948 CPUtime=162.08
/proc/3257/stat : 3257 (java) S 3244 3243 19908 34817 19908 4202496 87706 0 1 0 16180 28 0 0 25 0 11 0 68596538 902090752 81161 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/3257/statm: 220237 81161 1783 10 0 217328 0
[pid=3257/tid=3258] ppid=3244 vsize=880948 CPUtime=146.88
/proc/3257/task/3258/stat : 3258 (java) R 3244 3243 19908 34817 19908 4202560 50274 0 1 0 14670 18 0 0 25 0 11 0 68596539 902090752 81161 1283457024 134512640 134550932 4287836624 18446744073709551615 4095747243 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=3257/tid=3259] ppid=3244 vsize=880948 CPUtime=12.91
/proc/3257/task/3259/stat : 3259 (java) S 3244 3243 19908 34817 19908 4202560 23159 0 0 0 1285 6 0 0 16 0 11 0 68596540 902090752 81161 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3260] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3260/stat : 3260 (java) S 3244 3243 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 18 0 11 0 68596541 902090752 81161 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3261] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3261/stat : 3261 (java) S 3244 3243 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 68596541 902090752 81161 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3262] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3262/stat : 3262 (java) S 3244 3243 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68596543 902090752 81161 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3263] ppid=3244 vsize=880948 CPUtime=1.84
/proc/3257/task/3263/stat : 3263 (java) S 3244 3243 19908 34817 19908 4202560 10375 0 0 0 182 2 0 0 15 0 11 0 68596543 902090752 81161 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3264] ppid=3244 vsize=880948 CPUtime=0.43
/proc/3257/task/3264/stat : 3264 (java) S 3244 3243 19908 34817 19908 4202560 2817 0 0 0 42 1 0 0 15 0 11 0 68596543 902090752 81161 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3265] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3265/stat : 3265 (java) S 3244 3243 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68596543 902090752 81161 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3266] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3266/stat : 3266 (java) R 3244 3243 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 68596543 902090752 81161 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=3257/tid=3267] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3267/stat : 3267 (java) S 3244 3243 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 68596947 902090752 81161 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 162.11
Current children cumulated vsize (KiB) 886088

[startup+222.306 s]
/proc/loadavg: 1.12 1.06 1.01 2/48 3279
/proc/meminfo: memFree=79140/1048576 swapFree=0/0
[pid=3243] ppid=3242 vsize=2568 CPUtime=0
/proc/3243/stat : 3243 (p2cudf-user-1.1) S 3242 3243 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 68596534 2629632 270 1283457024 134512640 135304128 4288293744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3243/statm: 642 270 230 194 0 29 0
[pid=3244] ppid=3243 vsize=2572 CPUtime=0.03
/proc/3244/stat : 3244 (p2cudf) S 3243 3243 19908 34817 19908 4202496 393 3016 0 1 0 1 1 1 25 0 1 0 68596535 2633728 281 1283457024 134512640 135304128 4289023056 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3244/statm: 643 281 239 194 0 30 0
[pid=3257] ppid=3244 vsize=880948 CPUtime=222.02
/proc/3257/stat : 3257 (java) S 3244 3243 19908 34817 19908 4202496 87746 0 1 0 22174 28 0 0 25 0 11 0 68596538 902090752 81201 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/3257/statm: 220237 81201 1783 10 0 217328 0
[pid=3257/tid=3258] ppid=3244 vsize=880948 CPUtime=202.75
/proc/3257/task/3258/stat : 3258 (java) R 3244 3243 19908 34817 19908 4202560 50274 0 1 0 20257 18 0 0 25 0 11 0 68596539 902090752 81201 1283457024 134512640 134550932 4287836624 18446744073709551615 4095731426 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=3257/tid=3259] ppid=3244 vsize=880948 CPUtime=16.96
/proc/3257/task/3259/stat : 3259 (java) S 3244 3243 19908 34817 19908 4202560 23199 0 0 0 1690 6 0 0 16 0 11 0 68596540 902090752 81201 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3260] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3260/stat : 3260 (java) S 3244 3243 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 18 0 11 0 68596541 902090752 81201 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3261] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3261/stat : 3261 (java) S 3244 3243 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 68596541 902090752 81201 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3262] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3262/stat : 3262 (java) S 3244 3243 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68596543 902090752 81201 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3263] ppid=3244 vsize=880948 CPUtime=1.86
/proc/3257/task/3263/stat : 3263 (java) S 3244 3243 19908 34817 19908 4202560 10375 0 0 0 184 2 0 0 15 0 11 0 68596543 902090752 81201 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3264] ppid=3244 vsize=880948 CPUtime=0.43
/proc/3257/task/3264/stat : 3264 (java) S 3244 3243 19908 34817 19908 4202560 2817 0 0 0 42 1 0 0 15 0 11 0 68596543 902090752 81201 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3265] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3265/stat : 3265 (java) S 3244 3243 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68596543 902090752 81201 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3266] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3266/stat : 3266 (java) S 3244 3243 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 68596543 902090752 81201 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3267] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3267/stat : 3267 (java) S 3244 3243 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 68596947 902090752 81201 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 222.05
Current children cumulated vsize (KiB) 886088

[startup+282.329 s]
/proc/loadavg: 1.12 1.06 1.01 2/47 3280
/proc/meminfo: memFree=78164/1048576 swapFree=0/0
[pid=3243] ppid=3242 vsize=2568 CPUtime=0
/proc/3243/stat : 3243 (p2cudf-user-1.1) S 3242 3243 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 68596534 2629632 270 1283457024 134512640 135304128 4288293744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3243/statm: 642 270 230 194 0 29 0
[pid=3244] ppid=3243 vsize=2572 CPUtime=0.03
/proc/3244/stat : 3244 (p2cudf) S 3243 3243 19908 34817 19908 4202496 393 3016 0 1 0 1 1 1 25 0 1 0 68596535 2633728 281 1283457024 134512640 135304128 4289023056 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3244/statm: 643 281 239 194 0 30 0
[pid=3257] ppid=3244 vsize=880948 CPUtime=282
/proc/3257/stat : 3257 (java) S 3244 3243 19908 34817 19908 4202496 88001 0 1 0 28172 28 0 0 25 0 11 0 68596538 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/3257/statm: 220237 81456 1783 10 0 217328 0
[pid=3257/tid=3258] ppid=3244 vsize=880948 CPUtime=258.81
/proc/3257/task/3258/stat : 3258 (java) R 3244 3243 19908 34817 19908 4202560 50274 0 1 0 25863 18 0 0 25 0 11 0 68596539 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=3257/tid=3259] ppid=3244 vsize=880948 CPUtime=20.88
/proc/3257/task/3259/stat : 3259 (java) R 3244 3243 19908 34817 19908 4202560 23454 0 0 0 2082 6 0 0 15 0 11 0 68596540 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4148997759 0 0 0 16800975 0 0 0 -1 0 0 0 0
[pid=3257/tid=3260] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3260/stat : 3260 (java) S 3244 3243 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 18 0 11 0 68596541 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3261] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3261/stat : 3261 (java) S 3244 3243 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 68596541 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3262] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3262/stat : 3262 (java) S 3244 3243 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68596543 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3263] ppid=3244 vsize=880948 CPUtime=1.86
/proc/3257/task/3263/stat : 3263 (java) S 3244 3243 19908 34817 19908 4202560 10375 0 0 0 184 2 0 0 15 0 11 0 68596543 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3264] ppid=3244 vsize=880948 CPUtime=0.43
/proc/3257/task/3264/stat : 3264 (java) S 3244 3243 19908 34817 19908 4202560 2817 0 0 0 42 1 0 0 15 0 11 0 68596543 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3265] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3265/stat : 3265 (java) S 3244 3243 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68596543 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3266] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3266/stat : 3266 (java) S 3244 3243 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 68596543 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3267] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3267/stat : 3267 (java) S 3244 3243 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 68596947 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 282.03
Current children cumulated vsize (KiB) 886088

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

[startup+283.109 s]
/proc/loadavg: 1.11 1.06 1.01 2/47 3280
/proc/meminfo: memFree=78164/1048576 swapFree=0/0
[pid=3243] ppid=3242 vsize=2568 CPUtime=0
/proc/3243/stat : 3243 (p2cudf-user-1.1) S 3242 3243 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 68596534 2629632 270 1283457024 134512640 135304128 4288293744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3243/statm: 642 270 230 194 0 29 0
[pid=3244] ppid=3243 vsize=2572 CPUtime=0.03
/proc/3244/stat : 3244 (p2cudf) S 3243 3243 19908 34817 19908 4202496 393 3016 0 1 0 1 1 1 25 0 1 0 68596535 2633728 281 1283457024 134512640 135304128 4289023056 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3244/statm: 643 281 239 194 0 30 0
[pid=3257] ppid=3244 vsize=880948 CPUtime=282.78
/proc/3257/stat : 3257 (java) S 3244 3243 19908 34817 19908 4202496 88001 0 1 0 28250 28 0 0 25 0 11 0 68596538 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/3257/statm: 220237 81456 1783 10 0 217328 0
[pid=3257/tid=3258] ppid=3244 vsize=880948 CPUtime=259.46
/proc/3257/task/3258/stat : 3258 (java) R 3244 3243 19908 34817 19908 4202560 50274 0 1 0 25928 18 0 0 25 0 11 0 68596539 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4095715936 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=3257/tid=3259] ppid=3244 vsize=880948 CPUtime=21
/proc/3257/task/3259/stat : 3259 (java) S 3244 3243 19908 34817 19908 4202560 23454 0 0 0 2094 6 0 0 16 0 11 0 68596540 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3260] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3260/stat : 3260 (java) S 3244 3243 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 18 0 11 0 68596541 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3261] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3261/stat : 3261 (java) S 3244 3243 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 68596541 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3262] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3262/stat : 3262 (java) S 3244 3243 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68596543 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3263] ppid=3244 vsize=880948 CPUtime=1.86
/proc/3257/task/3263/stat : 3263 (java) S 3244 3243 19908 34817 19908 4202560 10375 0 0 0 184 2 0 0 15 0 11 0 68596543 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3264] ppid=3244 vsize=880948 CPUtime=0.43
/proc/3257/task/3264/stat : 3264 (java) S 3244 3243 19908 34817 19908 4202560 2817 0 0 0 42 1 0 0 15 0 11 0 68596543 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3265] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3265/stat : 3265 (java) S 3244 3243 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68596543 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3266] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3266/stat : 3266 (java) S 3244 3243 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 68596543 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3267] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3267/stat : 3267 (java) S 3244 3243 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 68596947 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 282.81
Current children cumulated vsize (KiB) 886088

[startup+283.909 s]
/proc/loadavg: 1.11 1.06 1.01 2/47 3280
/proc/meminfo: memFree=78164/1048576 swapFree=0/0
[pid=3243] ppid=3242 vsize=2568 CPUtime=0
/proc/3243/stat : 3243 (p2cudf-user-1.1) S 3242 3243 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 68596534 2629632 270 1283457024 134512640 135304128 4288293744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3243/statm: 642 270 230 194 0 29 0
[pid=3244] ppid=3243 vsize=2572 CPUtime=0.03
/proc/3244/stat : 3244 (p2cudf) S 3243 3243 19908 34817 19908 4202496 393 3016 0 1 0 1 1 1 25 0 1 0 68596535 2633728 281 1283457024 134512640 135304128 4289023056 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3244/statm: 643 281 239 194 0 30 0
[pid=3257] ppid=3244 vsize=880948 CPUtime=283.58
/proc/3257/stat : 3257 (java) S 3244 3243 19908 34817 19908 4202496 88001 0 1 0 28330 28 0 0 25 0 11 0 68596538 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/3257/statm: 220237 81456 1783 10 0 217328 0
[pid=3257/tid=3258] ppid=3244 vsize=880948 CPUtime=260.26
/proc/3257/task/3258/stat : 3258 (java) R 3244 3243 19908 34817 19908 4202560 50274 0 1 0 26008 18 0 0 25 0 11 0 68596539 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4095717504 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=3257/tid=3259] ppid=3244 vsize=880948 CPUtime=21
/proc/3257/task/3259/stat : 3259 (java) S 3244 3243 19908 34817 19908 4202560 23454 0 0 0 2094 6 0 0 15 0 11 0 68596540 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3260] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3260/stat : 3260 (java) S 3244 3243 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 18 0 11 0 68596541 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3261] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3261/stat : 3261 (java) S 3244 3243 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 68596541 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3262] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3262/stat : 3262 (java) S 3244 3243 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68596543 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3263] ppid=3244 vsize=880948 CPUtime=1.86
/proc/3257/task/3263/stat : 3263 (java) S 3244 3243 19908 34817 19908 4202560 10375 0 0 0 184 2 0 0 15 0 11 0 68596543 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3264] ppid=3244 vsize=880948 CPUtime=0.43
/proc/3257/task/3264/stat : 3264 (java) S 3244 3243 19908 34817 19908 4202560 2817 0 0 0 42 1 0 0 15 0 11 0 68596543 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3265] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3265/stat : 3265 (java) S 3244 3243 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68596543 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3266] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3266/stat : 3266 (java) S 3244 3243 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 68596543 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3267] ppid=3244 vsize=880948 CPUtime=0
/proc/3257/task/3267/stat : 3267 (java) S 3244 3243 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 68596947 902090752 81456 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.61
Current children cumulated vsize (KiB) 886088

[startup+284.307 s]
/proc/loadavg: 1.11 1.06 1.01 2/47 3280
/proc/meminfo: memFree=78164/1048576 swapFree=0/0
[pid=3243] ppid=3242 vsize=2568 CPUtime=0
/proc/3243/stat : 3243 (p2cudf-user-1.1) S 3242 3243 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 68596534 2629632 270 1283457024 134512640 135304128 4288293744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3243/statm: 642 270 230 194 0 29 0
[pid=3244] ppid=3243 vsize=2572 CPUtime=0.03
/proc/3244/stat : 3244 (p2cudf) S 3243 3243 19908 34817 19908 4202496 393 3016 0 1 0 1 1 1 25 0 1 0 68596535 2633728 281 1283457024 134512640 135304128 4289023056 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3244/statm: 643 281 239 194 0 30 0
[pid=3257] ppid=3244 vsize=881272 CPUtime=283.82
/proc/3257/stat : 3257 (java) S 3244 3243 19908 34817 19908 4202496 88015 0 1 0 28354 28 0 0 25 0 11 0 68596538 902422528 81470 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/3257/statm: 220318 81470 1784 10 0 217409 0
[pid=3257/tid=3258] ppid=3244 vsize=881272 CPUtime=260.49
/proc/3257/task/3258/stat : 3258 (java) S 3244 3243 19908 34817 19908 4202560 50282 0 1 0 26031 18 0 0 25 0 11 0 68596539 902422528 81470 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3259] ppid=3244 vsize=881272 CPUtime=21
/proc/3257/task/3259/stat : 3259 (java) S 3244 3243 19908 34817 19908 4202560 23454 0 0 0 2094 6 0 0 16 0 11 0 68596540 902422528 81470 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3260] ppid=3244 vsize=881272 CPUtime=0
/proc/3257/task/3260/stat : 3260 (java) S 3244 3243 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 18 0 11 0 68596541 902422528 81470 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3261] ppid=3244 vsize=881272 CPUtime=0
/proc/3257/task/3261/stat : 3261 (java) S 3244 3243 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 68596541 902422528 81470 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3262] ppid=3244 vsize=881272 CPUtime=0
/proc/3257/task/3262/stat : 3262 (java) S 3244 3243 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68596543 902422528 81470 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3263] ppid=3244 vsize=881272 CPUtime=1.88
/proc/3257/task/3263/stat : 3263 (java) S 3244 3243 19908 34817 19908 4202560 10375 0 0 0 186 2 0 0 15 0 11 0 68596543 902422528 81470 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3264] ppid=3244 vsize=881272 CPUtime=0.43
/proc/3257/task/3264/stat : 3264 (java) S 3244 3243 19908 34817 19908 4202560 2817 0 0 0 42 1 0 0 15 0 11 0 68596543 902422528 81470 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3265] ppid=3244 vsize=881272 CPUtime=0
/proc/3257/task/3265/stat : 3265 (java) S 3244 3243 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 68596543 902422528 81470 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3266] ppid=3244 vsize=881272 CPUtime=0
/proc/3257/task/3266/stat : 3266 (java) S 3244 3243 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 68596543 902422528 81470 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.85
Current children cumulated vsize (KiB) 886412

[startup+284.707 s]
/proc/loadavg: 1.11 1.06 1.01 2/47 3280
/proc/meminfo: memFree=78164/1048576 swapFree=0/0
[pid=3243] ppid=3242 vsize=2568 CPUtime=0
/proc/3243/stat : 3243 (p2cudf-user-1.1) S 3242 3243 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 68596534 2629632 270 1283457024 134512640 135304128 4288293744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3243/statm: 642 270 230 194 0 29 0
[pid=3244] ppid=3243 vsize=2572 CPUtime=0.03
/proc/3244/stat : 3244 (p2cudf) S 3243 3243 19908 34817 19908 4202496 393 3016 0 1 0 1 1 1 25 0 1 0 68596535 2633728 281 1283457024 134512640 135304128 4289023056 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/3244/statm: 643 281 239 194 0 30 0
[pid=3257] ppid=3244 vsize=881272 CPUtime=283.84
/proc/3257/stat : 3257 (java) S 3244 3243 19908 34817 19908 4202496 88015 0 1 0 28356 28 0 0 25 0 10 0 68596538 902422528 81470 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/3257/statm: 220318 81470 1784 10 0 217409 0
[pid=3257/tid=3258] ppid=3244 vsize=881272 CPUtime=260.49
/proc/3257/task/3258/stat : 3258 (java) S 3244 3243 19908 34817 19908 4202560 50282 0 1 0 26031 18 0 0 20 0 10 0 68596539 902422528 81470 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3259] ppid=3244 vsize=881272 CPUtime=21
/proc/3257/task/3259/stat : 3259 (java) S 3244 3243 19908 34817 19908 4202560 23454 0 0 0 2094 6 0 0 16 0 10 0 68596540 902422528 81470 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3260] ppid=3244 vsize=881272 CPUtime=0
/proc/3257/task/3260/stat : 3260 (java) S 3244 3243 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 18 0 10 0 68596541 902422528 81470 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3261] ppid=3244 vsize=881272 CPUtime=0
/proc/3257/task/3261/stat : 3261 (java) S 3244 3243 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 10 0 68596541 902422528 81470 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3262] ppid=3244 vsize=881272 CPUtime=0
/proc/3257/task/3262/stat : 3262 (java) S 3244 3243 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 68596543 902422528 81470 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3263] ppid=3244 vsize=881272 CPUtime=1.88
/proc/3257/task/3263/stat : 3263 (java) S 3244 3243 19908 34817 19908 4202560 10375 0 0 0 186 2 0 0 15 0 10 0 68596543 902422528 81470 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3264] ppid=3244 vsize=881272 CPUtime=0.43
/proc/3257/task/3264/stat : 3264 (java) S 3244 3243 19908 34817 19908 4202560 2817 0 0 0 42 1 0 0 15 0 10 0 68596543 902422528 81470 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3265] ppid=3244 vsize=881272 CPUtime=0
/proc/3257/task/3265/stat : 3265 (java) S 3244 3243 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 68596543 902422528 81470 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=3257/tid=3266] ppid=3244 vsize=881272 CPUtime=0
/proc/3257/task/3266/stat : 3266 (java) S 3244 3243 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 10 0 68596543 902422528 81470 1283457024 134512640 134550932 4287836624 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.87
Current children cumulated vsize (KiB) 886412

Child status: 0
Real time (s): 284.757
CPU time (s): 283.906
CPU user time (s): 283.574
CPU system time (s): 0.33202
CPU usage (%): 99.7011
Max. virtual memory (cumulated for all children) (KiB): 891300

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 283.574
system time used= 0.33202
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 91823
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= 6039
involuntary context switches= 8909

runsolver used 0 second user time and 0.012 second system time

The end