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/201108300820/p2cudf-user-1.13/rand97.cudf.user-upgrades.log.runsolver ./p2cudf-user-1.13 /home/misc2010/data/2011/user-upgrades/rand97.cudf /home/misc2010/tmp/201108300820/p2cudf-user-1.13/rand97.cudf.user-upgrades.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: 0.85 0.98 0.99 1/33 12447
/proc/meminfo: memFree=927388/1048576 swapFree=0/0
[pid=12447] ppid=12446 vsize=3020 CPUtime=0
/proc/12447/stat : 12447 (runsolver) D 12446 12447 2160 34817 2160 4202560 72 0 0 0 0 0 0 0 25 0 1 0 56284998 3092480 94 1283457024 134512640 134586868 4292886352 18446744073709551615 4294960130 0 0 0 24578 18446744071564332000 0 0 17 0 0 0 0
/proc/12447/statm: 755 94 62 19 0 54 0

[startup+0.161856 s]
/proc/loadavg: 0.85 0.98 0.99 1/33 12447
/proc/meminfo: memFree=927388/1048576 swapFree=0/0
[pid=12447] ppid=12446 vsize=2568 CPUtime=0
/proc/12447/stat : 12447 (p2cudf-user-1.1) S 12446 12447 2160 34817 2160 4202496 376 0 0 0 0 0 0 0 25 0 1 0 56284998 2629632 271 1283457024 134512640 135304128 4288312240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12447/statm: 642 271 230 194 0 29 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2568

[startup+0.205873 s]
/proc/loadavg: 0.85 0.98 0.99 1/33 12447
/proc/meminfo: memFree=927388/1048576 swapFree=0/0
[pid=12447] ppid=12446 vsize=2568 CPUtime=0
/proc/12447/stat : 12447 (p2cudf-user-1.1) S 12446 12447 2160 34817 2160 4202496 376 0 0 0 0 0 0 0 25 0 1 0 56284998 2629632 271 1283457024 134512640 135304128 4288312240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12447/statm: 642 271 230 194 0 29 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2568

[startup+0.305839 s]
/proc/loadavg: 0.85 0.98 0.99 1/33 12447
/proc/meminfo: memFree=927388/1048576 swapFree=0/0
[pid=12447] ppid=12446 vsize=2568 CPUtime=0
/proc/12447/stat : 12447 (p2cudf-user-1.1) S 12446 12447 2160 34817 2160 4202496 376 0 0 0 0 0 0 0 25 0 1 0 56284998 2629632 271 1283457024 134512640 135304128 4288312240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12447/statm: 642 271 230 194 0 29 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2568

[startup+0.705889 s]
/proc/loadavg: 0.85 0.98 0.99 1/33 12447
/proc/meminfo: memFree=927388/1048576 swapFree=0/0
[pid=12447] ppid=12446 vsize=2568 CPUtime=0
/proc/12447/stat : 12447 (p2cudf-user-1.1) S 12446 12447 2160 34817 2160 4202496 376 0 0 0 0 0 0 0 25 0 1 0 56284998 2629632 271 1283457024 134512640 135304128 4288312240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12447/statm: 642 271 230 194 0 29 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2568

[startup+1.51016 s]
/proc/loadavg: 0.86 0.98 0.99 4/45 12470
/proc/meminfo: memFree=901688/1048576 swapFree=0/0
[pid=12447] ppid=12446 vsize=2568 CPUtime=0
/proc/12447/stat : 12447 (p2cudf-user-1.1) S 12446 12447 2160 34817 2160 4202496 376 0 0 0 0 0 0 0 25 0 1 0 56284998 2629632 271 1283457024 134512640 135304128 4288312240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12447/statm: 642 271 230 194 0 29 0
[pid=12449] ppid=12447 vsize=2572 CPUtime=0.02
/proc/12449/stat : 12449 (p2cudf) S 12447 12447 2160 34817 2160 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 56284999 2633728 281 1283457024 134512640 135304128 4288824400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12449/statm: 643 281 239 194 0 30 0
[pid=12461] ppid=12449 vsize=892464 CPUtime=0.8
/proc/12461/stat : 12461 (java) S 12449 12447 2160 34817 2160 4202496 17652 0 109 0 74 6 0 0 23 0 10 0 56285002 913883136 15254 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12461/statm: 223116 15254 1722 10 0 220207 0
[pid=12461/tid=12462] ppid=12449 vsize=892464 CPUtime=0.41
/proc/12461/task/12462/stat : 12462 (java) R 12449 12447 2160 34817 2160 4202560 6051 0 15 0 38 3 0 0 25 0 10 0 56285033 913883136 15254 1283457024 134512640 134550932 4291515776 18446744073709551615 4094919728 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12461/tid=12463] ppid=12449 vsize=892464 CPUtime=0
/proc/12461/task/12463/stat : 12463 (java) S 12449 12447 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 10 0 56285046 913883136 15254 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12464] ppid=12449 vsize=892464 CPUtime=0
/proc/12461/task/12464/stat : 12464 (java) S 12449 12447 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 25 0 10 0 56285046 913883136 15254 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12465] ppid=12449 vsize=892464 CPUtime=0
/proc/12461/task/12465/stat : 12465 (java) S 12449 12447 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 10 0 56285047 913883136 15254 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12466] ppid=12449 vsize=892464 CPUtime=0
/proc/12461/task/12466/stat : 12466 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 56285057 913883136 15254 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12467] ppid=12449 vsize=892464 CPUtime=0.27
/proc/12461/task/12467/stat : 12467 (java) R 12449 12447 2160 34817 2160 4202560 6705 0 0 0 26 1 0 0 23 0 10 0 56285057 913883136 15254 1283457024 134512640 134550932 4291515776 18446744073709551615 4151064452 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12461/tid=12468] ppid=12449 vsize=892464 CPUtime=0.1
/proc/12461/task/12468/stat : 12468 (java) R 12449 12447 2160 34817 2160 4202560 3903 0 8 0 9 1 0 0 25 0 10 0 56285057 913883136 15254 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12461/tid=12469] ppid=12449 vsize=892464 CPUtime=0
/proc/12461/task/12469/stat : 12469 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 56285057 913883136 15254 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12470] ppid=12449 vsize=892464 CPUtime=0
/proc/12461/task/12470/stat : 12470 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 17 0 10 0 56285057 913883136 15254 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 0.82
Current children cumulated vsize (KiB) 897604

[startup+3.11057 s]
/proc/loadavg: 0.86 0.98 0.99 3/45 12470
/proc/meminfo: memFree=811292/1048576 swapFree=0/0
[pid=12447] ppid=12446 vsize=2568 CPUtime=0
/proc/12447/stat : 12447 (p2cudf-user-1.1) S 12446 12447 2160 34817 2160 4202496 376 0 0 0 0 0 0 0 25 0 1 0 56284998 2629632 271 1283457024 134512640 135304128 4288312240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12447/statm: 642 271 230 194 0 29 0
[pid=12449] ppid=12447 vsize=2572 CPUtime=0.02
/proc/12449/stat : 12449 (p2cudf) S 12447 12447 2160 34817 2160 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 56284999 2633728 281 1283457024 134512640 135304128 4288824400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12449/statm: 643 281 239 194 0 30 0
[pid=12461] ppid=12449 vsize=891060 CPUtime=2.4
/proc/12461/stat : 12461 (java) S 12449 12447 2160 34817 2160 4202496 68460 0 109 0 216 24 0 0 23 0 10 0 56285002 912445440 65240 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12461/statm: 222765 65240 1740 10 0 219856 0
[pid=12461/tid=12462] ppid=12449 vsize=891060 CPUtime=1.4
/proc/12461/task/12462/stat : 12462 (java) R 12449 12447 2160 34817 2160 4202560 50033 0 15 0 121 19 0 0 25 0 10 0 56285033 912445440 65240 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12461/tid=12463] ppid=12449 vsize=891060 CPUtime=0.13
/proc/12461/task/12463/stat : 12463 (java) R 12449 12447 2160 34817 2160 4202560 5505 0 0 0 12 1 0 0 16 0 10 0 56285046 912445440 65240 1283457024 134512640 134550932 4291515776 18446744073709551615 4148794845 0 0 0 16800975 0 0 0 -1 0 0 0 0
[pid=12461/tid=12464] ppid=12449 vsize=891060 CPUtime=0
/proc/12461/task/12464/stat : 12464 (java) S 12449 12447 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 25 0 10 0 56285046 912445440 65240 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12465] ppid=12449 vsize=891060 CPUtime=0
/proc/12461/task/12465/stat : 12465 (java) S 12449 12447 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 10 0 56285047 912445440 65240 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12466] ppid=12449 vsize=891060 CPUtime=0
/proc/12461/task/12466/stat : 12466 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 56285057 912445440 65240 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12467] ppid=12449 vsize=891060 CPUtime=0.48
/proc/12461/task/12467/stat : 12467 (java) S 12449 12447 2160 34817 2160 4202560 7105 0 0 0 46 2 0 0 18 0 10 0 56285057 912445440 65240 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12468] ppid=12449 vsize=891060 CPUtime=0.37
/proc/12461/task/12468/stat : 12468 (java) S 12449 12447 2160 34817 2160 4202560 4830 0 8 0 35 2 0 0 24 0 10 0 56285057 912445440 65240 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12469] ppid=12449 vsize=891060 CPUtime=0
/proc/12461/task/12469/stat : 12469 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 56285057 912445440 65240 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12470] ppid=12449 vsize=891060 CPUtime=0
/proc/12461/task/12470/stat : 12470 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 15 0 10 0 56285057 912445440 65240 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 2.42
Current children cumulated vsize (KiB) 896200
heavy processes:

[startup+6.3099 s]
/proc/loadavg: 0.95 1.00 0.99 2/46 12471
/proc/meminfo: memFree=640312/1048576 swapFree=0/0
[pid=12447] ppid=12446 vsize=2568 CPUtime=0
/proc/12447/stat : 12447 (p2cudf-user-1.1) S 12446 12447 2160 34817 2160 4202496 376 0 0 0 0 0 0 0 25 0 1 0 56284998 2629632 271 1283457024 134512640 135304128 4288312240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12447/statm: 642 271 230 194 0 29 0
[pid=12449] ppid=12447 vsize=2572 CPUtime=0.02
/proc/12449/stat : 12449 (p2cudf) S 12447 12447 2160 34817 2160 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 56284999 2633728 281 1283457024 134512640 135304128 4288824400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12449/statm: 643 281 239 194 0 30 0
[pid=12461] ppid=12449 vsize=890964 CPUtime=5.47
/proc/12461/stat : 12461 (java) S 12449 12447 2160 34817 2160 4202496 75616 0 109 0 520 27 0 0 23 0 11 0 56285002 912347136 70720 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12461/statm: 222741 70720 1774 10 0 219832 0
[pid=12461/tid=12462] ppid=12449 vsize=890964 CPUtime=2.96
/proc/12461/task/12462/stat : 12462 (java) R 12449 12447 2160 34817 2160 4202560 50270 0 15 0 277 19 0 0 25 0 11 0 56285033 912347136 70720 1283457024 134512640 134550932 4291515776 18446744073709551615 4095506752 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12461/tid=12463] ppid=12449 vsize=890964 CPUtime=0.23
/proc/12461/task/12463/stat : 12463 (java) S 12449 12447 2160 34817 2160 4202560 10623 0 0 0 21 2 0 0 15 0 11 0 56285046 912347136 70720 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12464] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12464/stat : 12464 (java) S 12449 12447 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 56285046 912347136 70720 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12465] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12465/stat : 12465 (java) S 12449 12447 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 56285047 912347136 70720 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12466] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12466/stat : 12466 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56285057 912347136 70720 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12467] ppid=12449 vsize=890964 CPUtime=0.48
/proc/12461/task/12467/stat : 12467 (java) S 12449 12447 2160 34817 2160 4202560 7105 0 0 0 46 2 0 0 18 0 11 0 56285057 912347136 70720 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12468] ppid=12449 vsize=890964 CPUtime=1.78
/proc/12461/task/12468/stat : 12468 (java) S 12449 12447 2160 34817 2160 4202560 6624 0 8 0 175 3 0 0 15 0 11 0 56285057 912347136 70720 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12469] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12469/stat : 12469 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56285057 912347136 70720 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12470] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12470/stat : 12470 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 15 0 11 0 56285057 912347136 70720 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12471] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12471/stat : 12471 (java) S 12449 12447 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 56285488 912347136 70720 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 5.49
Current children cumulated vsize (KiB) 896104

[startup+12.7112 s]
/proc/loadavg: 1.03 1.02 1.00 2/46 12471
/proc/meminfo: memFree=589232/1048576 swapFree=0/0
[pid=12447] ppid=12446 vsize=2568 CPUtime=0
/proc/12447/stat : 12447 (p2cudf-user-1.1) S 12446 12447 2160 34817 2160 4202496 376 0 0 0 0 0 0 0 25 0 1 0 56284998 2629632 271 1283457024 134512640 135304128 4288312240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12447/statm: 642 271 230 194 0 29 0
[pid=12449] ppid=12447 vsize=2572 CPUtime=0.02
/proc/12449/stat : 12449 (p2cudf) S 12447 12447 2160 34817 2160 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 56284999 2633728 281 1283457024 134512640 135304128 4288824400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12449/statm: 643 281 239 194 0 30 0
[pid=12461] ppid=12449 vsize=890964 CPUtime=11.87
/proc/12461/stat : 12461 (java) S 12449 12447 2160 34817 2160 4202496 88395 0 109 0 1157 30 0 0 23 0 11 0 56285002 912347136 83499 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12461/statm: 222741 83499 1783 10 0 219832 0
[pid=12461/tid=12462] ppid=12449 vsize=890964 CPUtime=8.01
/proc/12461/task/12462/stat : 12462 (java) R 12449 12447 2160 34817 2160 4202560 50271 0 15 0 782 19 0 0 25 0 11 0 56285033 912347136 83499 1283457024 134512640 134550932 4291515776 18446744073709551615 4095579882 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12461/tid=12463] ppid=12449 vsize=890964 CPUtime=1.41
/proc/12461/task/12463/stat : 12463 (java) S 12449 12447 2160 34817 2160 4202560 23371 0 0 0 136 5 0 0 16 0 11 0 56285046 912347136 83499 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12464] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12464/stat : 12464 (java) S 12449 12447 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 56285046 912347136 83499 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12465] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12465/stat : 12465 (java) S 12449 12447 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 56285047 912347136 83499 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12466] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12466/stat : 12466 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56285057 912347136 83499 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12467] ppid=12449 vsize=890964 CPUtime=0.48
/proc/12461/task/12467/stat : 12467 (java) S 12449 12447 2160 34817 2160 4202560 7105 0 0 0 46 2 0 0 18 0 11 0 56285057 912347136 83499 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12468] ppid=12449 vsize=890964 CPUtime=1.94
/proc/12461/task/12468/stat : 12468 (java) S 12449 12447 2160 34817 2160 4202560 6654 0 8 0 191 3 0 0 16 0 11 0 56285057 912347136 83499 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12469] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12469/stat : 12469 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56285057 912347136 83499 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12470] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12470/stat : 12470 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 15 0 11 0 56285057 912347136 83499 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12471] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12471/stat : 12471 (java) S 12449 12447 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 56285488 912347136 83499 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 11.89
Current children cumulated vsize (KiB) 896104

[startup+25.5038 s]
/proc/loadavg: 1.03 1.02 1.00 3/46 12471
/proc/meminfo: memFree=583776/1048576 swapFree=0/0
[pid=12447] ppid=12446 vsize=2568 CPUtime=0
/proc/12447/stat : 12447 (p2cudf-user-1.1) S 12446 12447 2160 34817 2160 4202496 376 0 0 0 0 0 0 0 25 0 1 0 56284998 2629632 271 1283457024 134512640 135304128 4288312240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12447/statm: 642 271 230 194 0 29 0
[pid=12449] ppid=12447 vsize=2572 CPUtime=0.02
/proc/12449/stat : 12449 (p2cudf) S 12447 12447 2160 34817 2160 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 56284999 2633728 281 1283457024 134512640 135304128 4288824400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12449/statm: 643 281 239 194 0 30 0
[pid=12461] ppid=12449 vsize=890964 CPUtime=24.66
/proc/12461/stat : 12461 (java) S 12449 12447 2160 34817 2160 4202496 89709 0 109 0 2436 30 0 0 23 0 11 0 56285002 912347136 84813 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12461/statm: 222741 84813 1783 10 0 219832 0
[pid=12461/tid=12462] ppid=12449 vsize=890964 CPUtime=19.5
/proc/12461/task/12462/stat : 12462 (java) R 12449 12447 2160 34817 2160 4202560 50271 0 15 0 1931 19 0 0 25 0 11 0 56285033 912347136 84813 1283457024 134512640 134550932 4291515776 18446744073709551615 4094906415 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12461/tid=12463] ppid=12449 vsize=890964 CPUtime=2.71
/proc/12461/task/12463/stat : 12463 (java) S 12449 12447 2160 34817 2160 4202560 24685 0 0 0 266 5 0 0 16 0 11 0 56285046 912347136 84813 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12464] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12464/stat : 12464 (java) S 12449 12447 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 56285046 912347136 84813 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12465] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12465/stat : 12465 (java) S 12449 12447 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 56285047 912347136 84813 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12466] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12466/stat : 12466 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56285057 912347136 84813 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12467] ppid=12449 vsize=890964 CPUtime=0.48
/proc/12461/task/12467/stat : 12467 (java) S 12449 12447 2160 34817 2160 4202560 7105 0 0 0 46 2 0 0 18 0 11 0 56285057 912347136 84813 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12468] ppid=12449 vsize=890964 CPUtime=1.94
/proc/12461/task/12468/stat : 12468 (java) S 12449 12447 2160 34817 2160 4202560 6654 0 8 0 191 3 0 0 16 0 11 0 56285057 912347136 84813 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12469] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12469/stat : 12469 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56285057 912347136 84813 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12470] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12470/stat : 12470 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 15 0 11 0 56285057 912347136 84813 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12471] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12471/stat : 12471 (java) S 12449 12447 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 56285488 912347136 84813 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 24.68
Current children cumulated vsize (KiB) 896104

[startup+51.1086 s]
/proc/loadavg: 1.07 1.03 1.00 2/46 12471
/proc/meminfo: memFree=577328/1048576 swapFree=0/0
[pid=12447] ppid=12446 vsize=2568 CPUtime=0
/proc/12447/stat : 12447 (p2cudf-user-1.1) S 12446 12447 2160 34817 2160 4202496 376 0 0 0 0 0 0 0 25 0 1 0 56284998 2629632 271 1283457024 134512640 135304128 4288312240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12447/statm: 642 271 230 194 0 29 0
[pid=12449] ppid=12447 vsize=2572 CPUtime=0.02
/proc/12449/stat : 12449 (p2cudf) S 12447 12447 2160 34817 2160 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 56284999 2633728 281 1283457024 134512640 135304128 4288824400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12449/statm: 643 281 239 194 0 30 0
[pid=12461] ppid=12449 vsize=890964 CPUtime=50.24
/proc/12461/stat : 12461 (java) S 12449 12447 2160 34817 2160 4202496 91319 0 109 0 4993 31 0 0 23 0 11 0 56285002 912347136 86423 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12461/statm: 222741 86423 1783 10 0 219832 0
[pid=12461/tid=12462] ppid=12449 vsize=890964 CPUtime=42.97
/proc/12461/task/12462/stat : 12462 (java) R 12449 12447 2160 34817 2160 4202560 50271 0 15 0 4277 20 0 0 25 0 11 0 56285033 912347136 86423 1283457024 134512640 134550932 4291515776 18446744073709551615 4095577726 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12461/tid=12463] ppid=12449 vsize=890964 CPUtime=4.82
/proc/12461/task/12463/stat : 12463 (java) S 12449 12447 2160 34817 2160 4202560 26295 0 0 0 477 5 0 0 15 0 11 0 56285046 912347136 86423 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12464] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12464/stat : 12464 (java) S 12449 12447 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 56285046 912347136 86423 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12465] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12465/stat : 12465 (java) S 12449 12447 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 56285047 912347136 86423 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12466] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12466/stat : 12466 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56285057 912347136 86423 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12467] ppid=12449 vsize=890964 CPUtime=0.48
/proc/12461/task/12467/stat : 12467 (java) S 12449 12447 2160 34817 2160 4202560 7105 0 0 0 46 2 0 0 18 0 11 0 56285057 912347136 86423 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12468] ppid=12449 vsize=890964 CPUtime=1.94
/proc/12461/task/12468/stat : 12468 (java) S 12449 12447 2160 34817 2160 4202560 6654 0 8 0 191 3 0 0 16 0 11 0 56285057 912347136 86423 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12469] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12469/stat : 12469 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56285057 912347136 86423 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12470] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12470/stat : 12470 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 15 0 11 0 56285057 912347136 86423 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12471] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12471/stat : 12471 (java) S 12449 12447 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 56285488 912347136 86423 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 50.26
Current children cumulated vsize (KiB) 896104

[startup+102.31 s]
/proc/loadavg: 1.15 1.05 1.01 2/48 12473
/proc/meminfo: memFree=576436/1048576 swapFree=0/0
[pid=12447] ppid=12446 vsize=2568 CPUtime=0
/proc/12447/stat : 12447 (p2cudf-user-1.1) S 12446 12447 2160 34817 2160 4202496 376 0 0 0 0 0 0 0 25 0 1 0 56284998 2629632 271 1283457024 134512640 135304128 4288312240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12447/statm: 642 271 230 194 0 29 0
[pid=12449] ppid=12447 vsize=2572 CPUtime=0.02
/proc/12449/stat : 12449 (p2cudf) S 12447 12447 2160 34817 2160 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 56284999 2633728 281 1283457024 134512640 135304128 4288824400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12449/statm: 643 281 239 194 0 30 0
[pid=12461] ppid=12449 vsize=890964 CPUtime=101.41
/proc/12461/stat : 12461 (java) S 12449 12447 2160 34817 2160 4202496 91459 0 109 0 10109 32 0 0 23 0 11 0 56285002 912347136 86563 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12461/statm: 222741 86563 1783 10 0 219832 0
[pid=12461/tid=12462] ppid=12449 vsize=890964 CPUtime=89.65
/proc/12461/task/12462/stat : 12462 (java) R 12449 12447 2160 34817 2160 4202560 50271 0 15 0 8944 21 0 0 25 0 11 0 56285033 912347136 86563 1283457024 134512640 134550932 4291515776 18446744073709551615 4095645888 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12461/tid=12463] ppid=12449 vsize=890964 CPUtime=9.32
/proc/12461/task/12463/stat : 12463 (java) S 12449 12447 2160 34817 2160 4202560 26435 0 0 0 926 6 0 0 15 0 11 0 56285046 912347136 86563 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12464] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12464/stat : 12464 (java) S 12449 12447 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 56285046 912347136 86563 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12465] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12465/stat : 12465 (java) S 12449 12447 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 56285047 912347136 86563 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12466] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12466/stat : 12466 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56285057 912347136 86563 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12467] ppid=12449 vsize=890964 CPUtime=0.48
/proc/12461/task/12467/stat : 12467 (java) S 12449 12447 2160 34817 2160 4202560 7105 0 0 0 46 2 0 0 18 0 11 0 56285057 912347136 86563 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12468] ppid=12449 vsize=890964 CPUtime=1.94
/proc/12461/task/12468/stat : 12468 (java) S 12449 12447 2160 34817 2160 4202560 6654 0 8 0 191 3 0 0 16 0 11 0 56285057 912347136 86563 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12469] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12469/stat : 12469 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56285057 912347136 86563 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12470] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12470/stat : 12470 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 15 0 11 0 56285057 912347136 86563 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12471] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12471/stat : 12471 (java) S 12449 12447 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 56285488 912347136 86563 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 101.43
Current children cumulated vsize (KiB) 896104

[startup+162.304 s]
/proc/loadavg: 1.12 1.06 1.01 2/48 12479
/proc/meminfo: memFree=573460/1048576 swapFree=0/0
[pid=12447] ppid=12446 vsize=2568 CPUtime=0
/proc/12447/stat : 12447 (p2cudf-user-1.1) S 12446 12447 2160 34817 2160 4202496 376 0 0 0 0 0 0 0 25 0 1 0 56284998 2629632 271 1283457024 134512640 135304128 4288312240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12447/statm: 642 271 230 194 0 29 0
[pid=12449] ppid=12447 vsize=2572 CPUtime=0.02
/proc/12449/stat : 12449 (p2cudf) S 12447 12447 2160 34817 2160 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 56284999 2633728 281 1283457024 134512640 135304128 4288824400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12449/statm: 643 281 239 194 0 30 0
[pid=12461] ppid=12449 vsize=890964 CPUtime=161.35
/proc/12461/stat : 12461 (java) S 12449 12447 2160 34817 2160 4202496 92166 0 109 0 16103 32 0 0 23 0 11 0 56285002 912347136 87270 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12461/statm: 222741 87270 1783 10 0 219832 0
[pid=12461/tid=12462] ppid=12449 vsize=890964 CPUtime=144.81
/proc/12461/task/12462/stat : 12462 (java) R 12449 12447 2160 34817 2160 4202560 50271 0 15 0 14460 21 0 0 25 0 11 0 56285033 912347136 87270 1283457024 134512640 134550932 4291515776 18446744073709551615 4095646272 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12461/tid=12463] ppid=12449 vsize=890964 CPUtime=14.1
/proc/12461/task/12463/stat : 12463 (java) S 12449 12447 2160 34817 2160 4202560 27142 0 0 0 1404 6 0 0 15 0 11 0 56285046 912347136 87270 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12464] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12464/stat : 12464 (java) S 12449 12447 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 56285046 912347136 87270 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12465] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12465/stat : 12465 (java) S 12449 12447 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 56285047 912347136 87270 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12466] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12466/stat : 12466 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56285057 912347136 87270 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12467] ppid=12449 vsize=890964 CPUtime=0.48
/proc/12461/task/12467/stat : 12467 (java) S 12449 12447 2160 34817 2160 4202560 7105 0 0 0 46 2 0 0 18 0 11 0 56285057 912347136 87270 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12468] ppid=12449 vsize=890964 CPUtime=1.94
/proc/12461/task/12468/stat : 12468 (java) S 12449 12447 2160 34817 2160 4202560 6654 0 8 0 191 3 0 0 16 0 11 0 56285057 912347136 87270 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12469] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12469/stat : 12469 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56285057 912347136 87270 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12470] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12470/stat : 12470 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 15 0 11 0 56285057 912347136 87270 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12471] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12471/stat : 12471 (java) S 12449 12447 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 56285488 912347136 87270 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 161.37
Current children cumulated vsize (KiB) 896104

[startup+222.31 s]
/proc/loadavg: 1.08 1.06 1.01 2/47 12482
/proc/meminfo: memFree=573352/1048576 swapFree=0/0
[pid=12447] ppid=12446 vsize=2568 CPUtime=0
/proc/12447/stat : 12447 (p2cudf-user-1.1) S 12446 12447 2160 34817 2160 4202496 376 0 0 0 0 0 0 0 25 0 1 0 56284998 2629632 271 1283457024 134512640 135304128 4288312240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12447/statm: 642 271 230 194 0 29 0
[pid=12449] ppid=12447 vsize=2572 CPUtime=0.02
/proc/12449/stat : 12449 (p2cudf) S 12447 12447 2160 34817 2160 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 56284999 2633728 281 1283457024 134512640 135304128 4288824400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12449/statm: 643 281 239 194 0 30 0
[pid=12461] ppid=12449 vsize=890964 CPUtime=221.3
/proc/12461/stat : 12461 (java) S 12449 12447 2160 34817 2160 4202496 92179 0 109 0 22095 35 0 0 23 0 11 0 56285002 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12461/statm: 222741 87283 1783 10 0 219832 0
[pid=12461/tid=12462] ppid=12449 vsize=890964 CPUtime=199.61
/proc/12461/task/12462/stat : 12462 (java) R 12449 12447 2160 34817 2160 4202560 50271 0 15 0 19938 23 0 0 25 0 11 0 56285033 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4095645856 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12461/tid=12463] ppid=12449 vsize=890964 CPUtime=19.21
/proc/12461/task/12463/stat : 12463 (java) S 12449 12447 2160 34817 2160 4202560 27142 0 0 0 1915 6 0 0 15 0 11 0 56285046 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12464] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12464/stat : 12464 (java) S 12449 12447 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 56285046 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12465] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12465/stat : 12465 (java) S 12449 12447 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 56285047 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12466] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12466/stat : 12466 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56285057 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12467] ppid=12449 vsize=890964 CPUtime=0.48
/proc/12461/task/12467/stat : 12467 (java) S 12449 12447 2160 34817 2160 4202560 7105 0 0 0 46 2 0 0 18 0 11 0 56285057 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12468] ppid=12449 vsize=890964 CPUtime=1.97
/proc/12461/task/12468/stat : 12468 (java) S 12449 12447 2160 34817 2160 4202560 6667 0 8 0 194 3 0 0 15 0 11 0 56285057 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12469] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12469/stat : 12469 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56285057 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12470] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12470/stat : 12470 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 15 0 11 0 56285057 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12471] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12471/stat : 12471 (java) S 12449 12447 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 56285488 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 221.32
Current children cumulated vsize (KiB) 896104

[startup+282.313 s]
/proc/loadavg: 1.21 1.09 1.02 2/46 12482
/proc/meminfo: memFree=573360/1048576 swapFree=0/0
[pid=12447] ppid=12446 vsize=2568 CPUtime=0
/proc/12447/stat : 12447 (p2cudf-user-1.1) S 12446 12447 2160 34817 2160 4202496 376 0 0 0 0 0 0 0 25 0 1 0 56284998 2629632 271 1283457024 134512640 135304128 4288312240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12447/statm: 642 271 230 194 0 29 0
[pid=12449] ppid=12447 vsize=2572 CPUtime=0.02
/proc/12449/stat : 12449 (p2cudf) S 12447 12447 2160 34817 2160 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 56284999 2633728 281 1283457024 134512640 135304128 4288824400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12449/statm: 643 281 239 194 0 30 0
[pid=12461] ppid=12449 vsize=890964 CPUtime=281.26
/proc/12461/stat : 12461 (java) S 12449 12447 2160 34817 2160 4202496 92179 0 109 0 28090 36 0 0 23 0 11 0 56285002 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12461/statm: 222741 87283 1783 10 0 219832 0
[pid=12461/tid=12462] ppid=12449 vsize=890964 CPUtime=254.48
/proc/12461/task/12462/stat : 12462 (java) R 12449 12447 2160 34817 2160 4202560 50271 0 15 0 25425 23 0 0 25 0 11 0 56285033 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4095636111 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12461/tid=12463] ppid=12449 vsize=890964 CPUtime=24.29
/proc/12461/task/12463/stat : 12463 (java) S 12449 12447 2160 34817 2160 4202560 27142 0 0 0 2423 6 0 0 15 0 11 0 56285046 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12464] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12464/stat : 12464 (java) S 12449 12447 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 56285046 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12465] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12465/stat : 12465 (java) S 12449 12447 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 56285047 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12466] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12466/stat : 12466 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56285057 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12467] ppid=12449 vsize=890964 CPUtime=0.48
/proc/12461/task/12467/stat : 12467 (java) S 12449 12447 2160 34817 2160 4202560 7105 0 0 0 46 2 0 0 18 0 11 0 56285057 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12468] ppid=12449 vsize=890964 CPUtime=1.97
/proc/12461/task/12468/stat : 12468 (java) S 12449 12447 2160 34817 2160 4202560 6667 0 8 0 194 3 0 0 15 0 11 0 56285057 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12469] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12469/stat : 12469 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56285057 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12470] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12470/stat : 12470 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 15 0 11 0 56285057 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12471] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12471/stat : 12471 (java) S 12449 12447 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 56285488 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 281.28
Current children cumulated vsize (KiB) 896104

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

[startup+283.014 s]
/proc/loadavg: 1.21 1.09 1.02 2/46 12482
/proc/meminfo: memFree=573360/1048576 swapFree=0/0
[pid=12447] ppid=12446 vsize=2568 CPUtime=0
/proc/12447/stat : 12447 (p2cudf-user-1.1) S 12446 12447 2160 34817 2160 4202496 376 0 0 0 0 0 0 0 25 0 1 0 56284998 2629632 271 1283457024 134512640 135304128 4288312240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12447/statm: 642 271 230 194 0 29 0
[pid=12449] ppid=12447 vsize=2572 CPUtime=0.02
/proc/12449/stat : 12449 (p2cudf) S 12447 12447 2160 34817 2160 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 56284999 2633728 281 1283457024 134512640 135304128 4288824400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12449/statm: 643 281 239 194 0 30 0
[pid=12461] ppid=12449 vsize=890964 CPUtime=281.96
/proc/12461/stat : 12461 (java) S 12449 12447 2160 34817 2160 4202496 92179 0 109 0 28160 36 0 0 23 0 11 0 56285002 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12461/statm: 222741 87283 1783 10 0 219832 0
[pid=12461/tid=12462] ppid=12449 vsize=890964 CPUtime=255.18
/proc/12461/task/12462/stat : 12462 (java) R 12449 12447 2160 34817 2160 4202560 50271 0 15 0 25495 23 0 0 25 0 11 0 56285033 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4095506188 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12461/tid=12463] ppid=12449 vsize=890964 CPUtime=24.29
/proc/12461/task/12463/stat : 12463 (java) S 12449 12447 2160 34817 2160 4202560 27142 0 0 0 2423 6 0 0 15 0 11 0 56285046 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12464] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12464/stat : 12464 (java) S 12449 12447 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 56285046 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12465] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12465/stat : 12465 (java) S 12449 12447 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 56285047 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12466] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12466/stat : 12466 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56285057 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12467] ppid=12449 vsize=890964 CPUtime=0.48
/proc/12461/task/12467/stat : 12467 (java) S 12449 12447 2160 34817 2160 4202560 7105 0 0 0 46 2 0 0 18 0 11 0 56285057 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12468] ppid=12449 vsize=890964 CPUtime=1.97
/proc/12461/task/12468/stat : 12468 (java) S 12449 12447 2160 34817 2160 4202560 6667 0 8 0 194 3 0 0 15 0 11 0 56285057 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12469] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12469/stat : 12469 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56285057 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12470] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12470/stat : 12470 (java) R 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 15 0 11 0 56285057 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12461/tid=12471] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12471/stat : 12471 (java) S 12449 12447 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 56285488 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 281.98
Current children cumulated vsize (KiB) 896104

[startup+284.614 s]
/proc/loadavg: 1.21 1.09 1.02 2/46 12482
/proc/meminfo: memFree=573360/1048576 swapFree=0/0
[pid=12447] ppid=12446 vsize=2568 CPUtime=0
/proc/12447/stat : 12447 (p2cudf-user-1.1) S 12446 12447 2160 34817 2160 4202496 376 0 0 0 0 0 0 0 25 0 1 0 56284998 2629632 271 1283457024 134512640 135304128 4288312240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12447/statm: 642 271 230 194 0 29 0
[pid=12449] ppid=12447 vsize=2572 CPUtime=0.02
/proc/12449/stat : 12449 (p2cudf) S 12447 12447 2160 34817 2160 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 56284999 2633728 281 1283457024 134512640 135304128 4288824400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12449/statm: 643 281 239 194 0 30 0
[pid=12461] ppid=12449 vsize=890964 CPUtime=283.56
/proc/12461/stat : 12461 (java) S 12449 12447 2160 34817 2160 4202496 92179 0 109 0 28320 36 0 0 23 0 11 0 56285002 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12461/statm: 222741 87283 1783 10 0 219832 0
[pid=12461/tid=12462] ppid=12449 vsize=890964 CPUtime=256.53
/proc/12461/task/12462/stat : 12462 (java) R 12449 12447 2160 34817 2160 4202560 50271 0 15 0 25630 23 0 0 25 0 11 0 56285033 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4095602395 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12461/tid=12463] ppid=12449 vsize=890964 CPUtime=24.55
/proc/12461/task/12463/stat : 12463 (java) S 12449 12447 2160 34817 2160 4202560 27142 0 0 0 2449 6 0 0 15 0 11 0 56285046 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12464] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12464/stat : 12464 (java) S 12449 12447 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 56285046 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12465] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12465/stat : 12465 (java) S 12449 12447 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 56285047 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12466] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12466/stat : 12466 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56285057 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12467] ppid=12449 vsize=890964 CPUtime=0.48
/proc/12461/task/12467/stat : 12467 (java) S 12449 12447 2160 34817 2160 4202560 7105 0 0 0 46 2 0 0 18 0 11 0 56285057 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12468] ppid=12449 vsize=890964 CPUtime=1.97
/proc/12461/task/12468/stat : 12468 (java) S 12449 12447 2160 34817 2160 4202560 6667 0 8 0 194 3 0 0 15 0 11 0 56285057 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12469] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12469/stat : 12469 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56285057 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12470] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12470/stat : 12470 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 15 0 11 0 56285057 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12471] ppid=12449 vsize=890964 CPUtime=0
/proc/12461/task/12471/stat : 12471 (java) S 12449 12447 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 56285488 912347136 87283 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.58
Current children cumulated vsize (KiB) 896104

[startup+285.008 s]
/proc/loadavg: 1.21 1.09 1.02 2/46 12482
/proc/meminfo: memFree=573360/1048576 swapFree=0/0
[pid=12447] ppid=12446 vsize=2568 CPUtime=0
/proc/12447/stat : 12447 (p2cudf-user-1.1) S 12446 12447 2160 34817 2160 4202496 376 0 0 0 0 0 0 0 25 0 1 0 56284998 2629632 271 1283457024 134512640 135304128 4288312240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12447/statm: 642 271 230 194 0 29 0
[pid=12449] ppid=12447 vsize=2572 CPUtime=0.02
/proc/12449/stat : 12449 (p2cudf) S 12447 12447 2160 34817 2160 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 56284999 2633728 281 1283457024 134512640 135304128 4288824400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12449/statm: 643 281 239 194 0 30 0
[pid=12461] ppid=12449 vsize=891288 CPUtime=283.88
/proc/12461/stat : 12461 (java) S 12449 12447 2160 34817 2160 4202496 92192 0 109 0 28352 36 0 0 23 0 11 0 56285002 912678912 87296 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12461/statm: 222822 87296 1784 10 0 219913 0
[pid=12461/tid=12462] ppid=12449 vsize=891288 CPUtime=256.83
/proc/12461/task/12462/stat : 12462 (java) S 12449 12447 2160 34817 2160 4202560 50278 0 15 0 25659 24 0 0 25 0 11 0 56285033 912678912 87296 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12463] ppid=12449 vsize=891288 CPUtime=24.55
/proc/12461/task/12463/stat : 12463 (java) S 12449 12447 2160 34817 2160 4202560 27142 0 0 0 2449 6 0 0 16 0 11 0 56285046 912678912 87296 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12464] ppid=12449 vsize=891288 CPUtime=0
/proc/12461/task/12464/stat : 12464 (java) S 12449 12447 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 56285046 912678912 87296 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12465] ppid=12449 vsize=891288 CPUtime=0
/proc/12461/task/12465/stat : 12465 (java) S 12449 12447 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 56285047 912678912 87296 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12466] ppid=12449 vsize=891288 CPUtime=0
/proc/12461/task/12466/stat : 12466 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56285057 912678912 87296 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12467] ppid=12449 vsize=891288 CPUtime=0.48
/proc/12461/task/12467/stat : 12467 (java) S 12449 12447 2160 34817 2160 4202560 7105 0 0 0 46 2 0 0 18 0 11 0 56285057 912678912 87296 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12468] ppid=12449 vsize=891288 CPUtime=1.99
/proc/12461/task/12468/stat : 12468 (java) S 12449 12447 2160 34817 2160 4202560 6667 0 8 0 196 3 0 0 15 0 11 0 56285057 912678912 87296 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12469] ppid=12449 vsize=891288 CPUtime=0
/proc/12461/task/12469/stat : 12469 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56285057 912678912 87296 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12470] ppid=12449 vsize=891288 CPUtime=0
/proc/12461/task/12470/stat : 12470 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 15 0 11 0 56285057 912678912 87296 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.9
Current children cumulated vsize (KiB) 896428

[startup+285.408 s]
/proc/loadavg: 1.21 1.09 1.02 2/46 12482
/proc/meminfo: memFree=573360/1048576 swapFree=0/0
[pid=12447] ppid=12446 vsize=2568 CPUtime=0
/proc/12447/stat : 12447 (p2cudf-user-1.1) S 12446 12447 2160 34817 2160 4202496 376 0 0 0 0 0 0 0 25 0 1 0 56284998 2629632 271 1283457024 134512640 135304128 4288312240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12447/statm: 642 271 230 194 0 29 0
[pid=12449] ppid=12447 vsize=2572 CPUtime=0.02
/proc/12449/stat : 12449 (p2cudf) S 12447 12447 2160 34817 2160 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 56284999 2633728 281 1283457024 134512640 135304128 4288824400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12449/statm: 643 281 239 194 0 30 0
[pid=12461] ppid=12449 vsize=891288 CPUtime=283.88
/proc/12461/stat : 12461 (java) S 12449 12447 2160 34817 2160 4202496 92192 0 109 0 28352 36 0 0 23 0 11 0 56285002 912678912 87296 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12461/statm: 222822 87296 1784 10 0 219913 0
[pid=12461/tid=12462] ppid=12449 vsize=891288 CPUtime=256.83
/proc/12461/task/12462/stat : 12462 (java) S 12449 12447 2160 34817 2160 4202560 50278 0 15 0 25659 24 0 0 25 0 11 0 56285033 912678912 87296 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12463] ppid=12449 vsize=891288 CPUtime=24.55
/proc/12461/task/12463/stat : 12463 (java) S 12449 12447 2160 34817 2160 4202560 27142 0 0 0 2449 6 0 0 16 0 11 0 56285046 912678912 87296 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12464] ppid=12449 vsize=891288 CPUtime=0
/proc/12461/task/12464/stat : 12464 (java) S 12449 12447 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 56285046 912678912 87296 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12465] ppid=12449 vsize=891288 CPUtime=0
/proc/12461/task/12465/stat : 12465 (java) S 12449 12447 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 56285047 912678912 87296 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12466] ppid=12449 vsize=891288 CPUtime=0
/proc/12461/task/12466/stat : 12466 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56285057 912678912 87296 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12467] ppid=12449 vsize=891288 CPUtime=0.48
/proc/12461/task/12467/stat : 12467 (java) S 12449 12447 2160 34817 2160 4202560 7105 0 0 0 46 2 0 0 18 0 11 0 56285057 912678912 87296 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12468] ppid=12449 vsize=891288 CPUtime=1.99
/proc/12461/task/12468/stat : 12468 (java) S 12449 12447 2160 34817 2160 4202560 6667 0 8 0 196 3 0 0 15 0 11 0 56285057 912678912 87296 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12469] ppid=12449 vsize=891288 CPUtime=0
/proc/12461/task/12469/stat : 12469 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56285057 912678912 87296 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12470] ppid=12449 vsize=891288 CPUtime=0
/proc/12461/task/12470/stat : 12470 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 15 0 11 0 56285057 912678912 87296 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.9
Current children cumulated vsize (KiB) 896428

[startup+285.508 s]
/proc/loadavg: 1.21 1.09 1.02 2/46 12482
/proc/meminfo: memFree=573360/1048576 swapFree=0/0
[pid=12447] ppid=12446 vsize=2568 CPUtime=0
/proc/12447/stat : 12447 (p2cudf-user-1.1) S 12446 12447 2160 34817 2160 4202496 376 0 0 0 0 0 0 0 25 0 1 0 56284998 2629632 271 1283457024 134512640 135304128 4288312240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12447/statm: 642 271 230 194 0 29 0
[pid=12449] ppid=12447 vsize=2572 CPUtime=0.02
/proc/12449/stat : 12449 (p2cudf) S 12447 12447 2160 34817 2160 4202496 393 3015 0 1 0 0 2 0 25 0 1 0 56284999 2633728 281 1283457024 134512640 135304128 4288824400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12449/statm: 643 281 239 194 0 30 0
[pid=12461] ppid=12449 vsize=891288 CPUtime=283.93
/proc/12461/stat : 12461 (java) S 12449 12447 2160 34817 2160 4202496 92193 0 109 0 28356 37 0 0 23 0 11 0 56285002 912678912 87297 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12461/statm: 222822 87297 1784 10 0 219913 0
[pid=12461/tid=12462] ppid=12449 vsize=891288 CPUtime=256.83
/proc/12461/task/12462/stat : 12462 (java) S 12449 12447 2160 34817 2160 4202560 50278 0 15 0 25659 24 0 0 25 0 11 0 56285033 912678912 87297 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12463] ppid=12449 vsize=891288 CPUtime=24.55
/proc/12461/task/12463/stat : 12463 (java) S 12449 12447 2160 34817 2160 4202560 27142 0 0 0 2449 6 0 0 16 0 11 0 56285046 912678912 87297 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12464] ppid=12449 vsize=891288 CPUtime=0
/proc/12461/task/12464/stat : 12464 (java) S 12449 12447 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 56285046 912678912 87297 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12465] ppid=12449 vsize=891288 CPUtime=0
/proc/12461/task/12465/stat : 12465 (java) S 12449 12447 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 56285047 912678912 87297 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12466] ppid=12449 vsize=891288 CPUtime=0
/proc/12461/task/12466/stat : 12466 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56285057 912678912 87297 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12467] ppid=12449 vsize=891288 CPUtime=0.48
/proc/12461/task/12467/stat : 12467 (java) S 12449 12447 2160 34817 2160 4202560 7105 0 0 0 46 2 0 0 18 0 11 0 56285057 912678912 87297 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12468] ppid=12449 vsize=891288 CPUtime=1.99
/proc/12461/task/12468/stat : 12468 (java) S 12449 12447 2160 34817 2160 4202560 6667 0 8 0 196 3 0 0 15 0 11 0 56285057 912678912 87297 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12469] ppid=12449 vsize=891288 CPUtime=0
/proc/12461/task/12469/stat : 12469 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56285057 912678912 87297 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=12461/tid=12470] ppid=12449 vsize=891288 CPUtime=0
/proc/12461/task/12470/stat : 12470 (java) S 12449 12447 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 15 0 11 0 56285057 912678912 87297 1283457024 134512640 134550932 4291515776 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.95
Current children cumulated vsize (KiB) 896428

Child status: 0
Real time (s): 285.564
CPU time (s): 284.01
CPU user time (s): 283.606
CPU system time (s): 0.404025
CPU usage (%): 99.4556
Max. virtual memory (cumulated for all children) (KiB): 899396

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 283.606
system time used= 0.404025
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 96001
page faults= 110
swaps= 0
block input operations= 0
block output operations= 0
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 6535
involuntary context switches= 8919

runsolver used 0 second user time and 0.012 second system time

The end