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/eeee44ce-5407-11df-b11f-00163e7a6f5e.cudf.dudf-real.log.runsolver ./p2cudf-user-1.13 /home/misc2010/data/2011/dudf-real//eeee44ce-5407-11df-b11f-00163e7a6f5e.cudf /home/misc2010/tmp/201108300820/p2cudf-user-1.13/eeee44ce-5407-11df-b11f-00163e7a6f5e.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.01 1.01 1.00 3/35 18621
/proc/meminfo: memFree=910236/1048576 swapFree=0/0
[pid=18619] ppid=18618 vsize=2568 CPUtime=0
/proc/18619/stat : 18619 (p2cudf-user-1.1) S 18618 18619 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59664624 2629632 270 1283457024 134512640 135304128 4294697360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18619/statm: 642 270 230 194 0 29 0
[pid=18620] ppid=18619 vsize=2572 CPUtime=0
/proc/18620/stat : 18620 (p2cudf) R 18619 18619 2160 34817 2160 4202496 346 0 0 0 0 0 0 0 25 0 1 0 59664624 2633728 272 1283457024 134512640 135304128 4291442336 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/18620/statm: 643 272 231 194 0 30 0
[pid=18621] ppid=18620 vsize=2572 CPUtime=0
/proc/18621/stat : 18621 (p2cudf) R 18620 18619 2160 34817 2160 4202560 0 0 0 0 0 0 0 0 25 0 1 0 59664625 2633728 41 1283457024 134512640 135304128 4291442336 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/18621/statm: 643 41 0 194 0 30 0

[startup+0.16729 s]
/proc/loadavg: 1.01 1.01 1.00 3/35 18621
/proc/meminfo: memFree=910236/1048576 swapFree=0/0
[pid=18619] ppid=18618 vsize=2568 CPUtime=0
/proc/18619/stat : 18619 (p2cudf-user-1.1) S 18618 18619 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59664624 2629632 270 1283457024 134512640 135304128 4294697360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18619/statm: 642 270 230 194 0 29 0
[pid=18620] ppid=18619 vsize=2576 CPUtime=0.02
/proc/18620/stat : 18620 (p2cudf) S 18619 18619 2160 34817 2160 4202496 390 3016 0 1 0 0 0 2 25 0 1 0 59664624 2637824 281 1283457024 134512640 135304128 4291442336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18620/statm: 644 281 239 194 0 31 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5144

[startup+0.207286 s]
/proc/loadavg: 1.01 1.01 1.00 3/35 18621
/proc/meminfo: memFree=910236/1048576 swapFree=0/0
[pid=18619] ppid=18618 vsize=2568 CPUtime=0
/proc/18619/stat : 18619 (p2cudf-user-1.1) S 18618 18619 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59664624 2629632 270 1283457024 134512640 135304128 4294697360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18619/statm: 642 270 230 194 0 29 0
[pid=18620] ppid=18619 vsize=2576 CPUtime=0.02
/proc/18620/stat : 18620 (p2cudf) S 18619 18619 2160 34817 2160 4202496 390 3016 0 1 0 0 0 2 25 0 1 0 59664624 2637824 281 1283457024 134512640 135304128 4291442336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18620/statm: 644 281 239 194 0 31 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5144

[startup+0.307303 s]
/proc/loadavg: 1.01 1.01 1.00 3/35 18621
/proc/meminfo: memFree=910236/1048576 swapFree=0/0
[pid=18619] ppid=18618 vsize=2568 CPUtime=0
/proc/18619/stat : 18619 (p2cudf-user-1.1) S 18618 18619 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59664624 2629632 270 1283457024 134512640 135304128 4294697360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18619/statm: 642 270 230 194 0 29 0
[pid=18620] ppid=18619 vsize=2576 CPUtime=0.02
/proc/18620/stat : 18620 (p2cudf) S 18619 18619 2160 34817 2160 4202496 390 3016 0 1 0 0 0 2 25 0 1 0 59664624 2637824 281 1283457024 134512640 135304128 4291442336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18620/statm: 644 281 239 194 0 31 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5144

[startup+0.707385 s]
/proc/loadavg: 1.01 1.01 1.00 3/35 18621
/proc/meminfo: memFree=910236/1048576 swapFree=0/0
[pid=18619] ppid=18618 vsize=2568 CPUtime=0
/proc/18619/stat : 18619 (p2cudf-user-1.1) S 18618 18619 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59664624 2629632 270 1283457024 134512640 135304128 4294697360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18619/statm: 642 270 230 194 0 29 0
[pid=18620] ppid=18619 vsize=2576 CPUtime=0.02
/proc/18620/stat : 18620 (p2cudf) S 18619 18619 2160 34817 2160 4202496 390 3016 0 1 0 0 0 2 25 0 1 0 59664624 2637824 281 1283457024 134512640 135304128 4291442336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18620/statm: 644 281 239 194 0 31 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5144

[startup+1.50755 s]
/proc/loadavg: 1.17 1.05 1.01 4/45 18642
/proc/meminfo: memFree=859132/1048576 swapFree=0/0
[pid=18619] ppid=18618 vsize=2568 CPUtime=0
/proc/18619/stat : 18619 (p2cudf-user-1.1) S 18618 18619 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59664624 2629632 270 1283457024 134512640 135304128 4294697360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18619/statm: 642 270 230 194 0 29 0
[pid=18620] ppid=18619 vsize=2576 CPUtime=0.02
/proc/18620/stat : 18620 (p2cudf) S 18619 18619 2160 34817 2160 4202496 390 3016 0 1 0 0 0 2 25 0 1 0 59664624 2637824 281 1283457024 134512640 135304128 4291442336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18620/statm: 644 281 239 194 0 31 0
[pid=18633] ppid=18620 vsize=886124 CPUtime=1.48
/proc/18633/stat : 18633 (java) S 18620 18619 2160 34817 2160 4202496 21854 0 1 0 136 12 0 0 25 0 10 0 59664628 907390976 19103 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/18633/statm: 221531 19103 1740 10 0 218622 0
[pid=18633/tid=18634] ppid=18620 vsize=886124 CPUtime=0.67
/proc/18633/task/18634/stat : 18634 (java) R 18620 18619 2160 34817 2160 4202560 10308 0 1 0 61 6 0 0 25 0 10 0 59664628 907390976 19103 1283457024 134512640 134550932 4288125456 18446744073709551615 4095225536 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18633/tid=18635] ppid=18620 vsize=886124 CPUtime=0
/proc/18633/task/18635/stat : 18635 (java) S 18620 18619 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 10 0 59664630 907390976 19103 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18636] ppid=18620 vsize=886124 CPUtime=0
/proc/18633/task/18636/stat : 18636 (java) S 18620 18619 2160 34817 2160 4202560 8 0 0 0 0 0 0 0 25 0 10 0 59664630 907390976 19103 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18637] ppid=18620 vsize=886124 CPUtime=0
/proc/18633/task/18637/stat : 18637 (java) S 18620 18619 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 10 0 59664630 907390976 19103 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18638] ppid=18620 vsize=886124 CPUtime=0
/proc/18633/task/18638/stat : 18638 (java) S 18620 18619 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 59664633 907390976 19103 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18639] ppid=18620 vsize=886124 CPUtime=0.51
/proc/18633/task/18639/stat : 18639 (java) R 18620 18619 2160 34817 2160 4202560 5094 0 0 0 49 2 0 0 25 0 10 0 59664633 907390976 19103 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18633/tid=18640] ppid=18620 vsize=886124 CPUtime=0.27
/proc/18633/task/18640/stat : 18640 (java) R 18620 18619 2160 34817 2160 4202560 5372 0 0 0 25 2 0 0 22 0 10 0 59664633 907390976 19103 1283457024 134512640 134550932 4288125456 18446744073709551615 4149790392 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18633/tid=18641] ppid=18620 vsize=886124 CPUtime=0
/proc/18633/task/18641/stat : 18641 (java) S 18620 18619 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 59664633 907390976 19103 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18642] ppid=18620 vsize=886124 CPUtime=0
/proc/18633/task/18642/stat : 18642 (java) S 18620 18619 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 10 0 59664633 907390976 19103 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 1.5
Current children cumulated vsize (KiB) 891268

[startup+3.10788 s]
/proc/loadavg: 1.17 1.05 1.01 3/47 18644
/proc/meminfo: memFree=756436/1048576 swapFree=0/0
[pid=18619] ppid=18618 vsize=2568 CPUtime=0
/proc/18619/stat : 18619 (p2cudf-user-1.1) S 18618 18619 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59664624 2629632 270 1283457024 134512640 135304128 4294697360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18619/statm: 642 270 230 194 0 29 0
[pid=18620] ppid=18619 vsize=2576 CPUtime=0.02
/proc/18620/stat : 18620 (p2cudf) S 18619 18619 2160 34817 2160 4202496 390 3016 0 1 0 0 0 2 25 0 1 0 59664624 2637824 281 1283457024 134512640 135304128 4291442336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18620/statm: 644 281 239 194 0 31 0
[pid=18633] ppid=18620 vsize=886124 CPUtime=3.07
/proc/18633/stat : 18633 (java) S 18620 18619 2160 34817 2160 4202496 48040 0 1 0 290 17 0 0 25 0 10 0 59664628 907390976 45289 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/18633/statm: 221531 45289 1754 10 0 218622 0
[pid=18633/tid=18634] ppid=18620 vsize=886124 CPUtime=1.25
/proc/18633/task/18634/stat : 18634 (java) R 18620 18619 2160 34817 2160 4202560 36332 0 1 0 114 11 0 0 25 0 10 0 59664628 907390976 45289 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18633/tid=18635] ppid=18620 vsize=886124 CPUtime=0
/proc/18633/task/18635/stat : 18635 (java) S 18620 18619 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 17 0 10 0 59664630 907390976 45289 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18636] ppid=18620 vsize=886124 CPUtime=0
/proc/18633/task/18636/stat : 18636 (java) S 18620 18619 2160 34817 2160 4202560 8 0 0 0 0 0 0 0 25 0 10 0 59664630 907390976 45289 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18637] ppid=18620 vsize=886124 CPUtime=0
/proc/18633/task/18637/stat : 18637 (java) S 18620 18619 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 10 0 59664630 907390976 45289 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18638] ppid=18620 vsize=886124 CPUtime=0
/proc/18633/task/18638/stat : 18638 (java) S 18620 18619 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 59664633 907390976 45289 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18639] ppid=18620 vsize=886124 CPUtime=1.26
/proc/18633/task/18639/stat : 18639 (java) R 18620 18619 2160 34817 2160 4202560 5206 0 0 0 124 2 0 0 18 0 10 0 59664633 907390976 45289 1283457024 134512640 134550932 4288125456 18446744073709551615 4147045457 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18633/tid=18640] ppid=18620 vsize=886124 CPUtime=0.52
/proc/18633/task/18640/stat : 18640 (java) R 18620 18619 2160 34817 2160 4202560 5422 0 0 0 50 2 0 0 19 0 10 0 59664633 907390976 45289 1283457024 134512640 134550932 4288125456 18446744073709551615 4149778511 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18633/tid=18641] ppid=18620 vsize=886124 CPUtime=0
/proc/18633/task/18641/stat : 18641 (java) S 18620 18619 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 59664633 907390976 45289 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18642] ppid=18620 vsize=886124 CPUtime=0
/proc/18633/task/18642/stat : 18642 (java) S 18620 18619 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 10 0 59664633 907390976 45289 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 3.09
Current children cumulated vsize (KiB) 891268

[startup+6.30845 s]
/proc/loadavg: 1.17 1.05 1.01 3/48 18645
/proc/meminfo: memFree=679928/1048576 swapFree=0/0
[pid=18619] ppid=18618 vsize=2568 CPUtime=0
/proc/18619/stat : 18619 (p2cudf-user-1.1) S 18618 18619 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59664624 2629632 270 1283457024 134512640 135304128 4294697360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18619/statm: 642 270 230 194 0 29 0
[pid=18620] ppid=18619 vsize=2576 CPUtime=0.02
/proc/18620/stat : 18620 (p2cudf) S 18619 18619 2160 34817 2160 4202496 390 3016 0 1 0 0 0 2 25 0 1 0 59664624 2637824 281 1283457024 134512640 135304128 4291442336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18620/statm: 644 281 239 194 0 31 0
[pid=18633] ppid=18620 vsize=886448 CPUtime=6.27
/proc/18633/stat : 18633 (java) S 18620 18619 2160 34817 2160 4202496 68935 0 1 0 600 27 0 0 25 0 11 0 59664628 907722752 66184 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/18633/statm: 221612 66184 1781 10 0 218703 0
[pid=18633/tid=18634] ppid=18620 vsize=886448 CPUtime=3.38
/proc/18633/task/18634/stat : 18634 (java) R 18620 18619 2160 34817 2160 4202560 47818 0 1 0 320 18 0 0 25 0 11 0 59664628 907722752 66184 1283457024 134512640 134550932 4288125456 18446744073709551615 4095834124 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18633/tid=18635] ppid=18620 vsize=886448 CPUtime=0.32
/proc/18633/task/18635/stat : 18635 (java) S 18620 18619 2160 34817 2160 4202560 9291 0 0 0 30 2 0 0 16 0 11 0 59664630 907722752 66184 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18636] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18636/stat : 18636 (java) S 18620 18619 2160 34817 2160 4202560 9 0 0 0 0 0 0 0 18 0 11 0 59664630 907722752 66184 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18637] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18637/stat : 18637 (java) S 18620 18619 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 59664630 907722752 66184 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18638] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18638/stat : 18638 (java) S 18620 18619 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59664633 907722752 66184 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18639] ppid=18620 vsize=886448 CPUtime=1.26
/proc/18633/task/18639/stat : 18639 (java) S 18620 18619 2160 34817 2160 4202560 5228 0 0 0 124 2 0 0 18 0 11 0 59664633 907722752 66184 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18640] ppid=18620 vsize=886448 CPUtime=1.26
/proc/18633/task/18640/stat : 18640 (java) S 18620 18619 2160 34817 2160 4202560 5517 0 0 0 124 2 0 0 15 0 11 0 59664633 907722752 66184 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18641] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18641/stat : 18641 (java) S 18620 18619 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59664633 907722752 66184 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18642] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18642/stat : 18642 (java) R 18620 18619 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 59664633 907722752 66184 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18633/tid=18645] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18645/stat : 18645 (java) S 18620 18619 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 59665003 907722752 66184 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 6.29
Current children cumulated vsize (KiB) 891592

[startup+12.7107 s]
/proc/loadavg: 1.14 1.04 1.01 2/48 18646
/proc/meminfo: memFree=639008/1048576 swapFree=0/0
[pid=18619] ppid=18618 vsize=2568 CPUtime=0
/proc/18619/stat : 18619 (p2cudf-user-1.1) S 18618 18619 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59664624 2629632 270 1283457024 134512640 135304128 4294697360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18619/statm: 642 270 230 194 0 29 0
[pid=18620] ppid=18619 vsize=2576 CPUtime=0.02
/proc/18620/stat : 18620 (p2cudf) S 18619 18619 2160 34817 2160 4202496 390 3016 0 1 0 0 0 2 25 0 1 0 59664624 2637824 281 1283457024 134512640 135304128 4291442336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18620/statm: 644 281 239 194 0 31 0
[pid=18633] ppid=18620 vsize=886448 CPUtime=12.67
/proc/18633/stat : 18633 (java) S 18620 18619 2160 34817 2160 4202496 71977 0 1 0 1240 27 0 0 25 0 11 0 59664628 907722752 69226 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/18633/statm: 221612 69226 1783 10 0 218703 0
[pid=18633/tid=18634] ppid=18620 vsize=886448 CPUtime=9.02
/proc/18633/task/18634/stat : 18634 (java) R 18620 18619 2160 34817 2160 4202560 47818 0 1 0 884 18 0 0 25 0 11 0 59664628 907722752 69226 1283457024 134512640 134550932 4288125456 18446744073709551615 4095962288 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18633/tid=18635] ppid=18620 vsize=886448 CPUtime=0.92
/proc/18633/task/18635/stat : 18635 (java) S 18620 18619 2160 34817 2160 4202560 12311 0 0 0 90 2 0 0 16 0 11 0 59664630 907722752 69226 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18636] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18636/stat : 18636 (java) S 18620 18619 2160 34817 2160 4202560 9 0 0 0 0 0 0 0 18 0 11 0 59664630 907722752 69226 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18637] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18637/stat : 18637 (java) S 18620 18619 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 59664630 907722752 69226 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18638] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18638/stat : 18638 (java) S 18620 18619 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59664633 907722752 69226 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18639] ppid=18620 vsize=886448 CPUtime=1.26
/proc/18633/task/18639/stat : 18639 (java) S 18620 18619 2160 34817 2160 4202560 5228 0 0 0 124 2 0 0 18 0 11 0 59664633 907722752 69226 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18640] ppid=18620 vsize=886448 CPUtime=1.42
/proc/18633/task/18640/stat : 18640 (java) S 18620 18619 2160 34817 2160 4202560 5539 0 0 0 140 2 0 0 15 0 11 0 59664633 907722752 69226 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18641] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18641/stat : 18641 (java) S 18620 18619 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59664633 907722752 69226 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18642] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18642/stat : 18642 (java) S 18620 18619 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 59664633 907722752 69226 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18645] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18645/stat : 18645 (java) S 18620 18619 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 59665003 907722752 69226 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 12.69
Current children cumulated vsize (KiB) 891592

[startup+25.5143 s]
/proc/loadavg: 1.12 1.04 1.01 2/48 18647
/proc/meminfo: memFree=629956/1048576 swapFree=0/0
[pid=18619] ppid=18618 vsize=2568 CPUtime=0
/proc/18619/stat : 18619 (p2cudf-user-1.1) S 18618 18619 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59664624 2629632 270 1283457024 134512640 135304128 4294697360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18619/statm: 642 270 230 194 0 29 0
[pid=18620] ppid=18619 vsize=2576 CPUtime=0.02
/proc/18620/stat : 18620 (p2cudf) S 18619 18619 2160 34817 2160 4202496 390 3016 0 1 0 0 0 2 25 0 1 0 59664624 2637824 281 1283457024 134512640 135304128 4291442336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18620/statm: 644 281 239 194 0 31 0
[pid=18633] ppid=18620 vsize=886448 CPUtime=25.45
/proc/18633/stat : 18633 (java) S 18620 18619 2160 34817 2160 4202496 74219 0 1 0 2518 27 0 0 25 0 11 0 59664628 907722752 71468 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/18633/statm: 221612 71468 1783 10 0 218703 0
[pid=18633/tid=18634] ppid=18620 vsize=886448 CPUtime=20.87
/proc/18633/task/18634/stat : 18634 (java) R 18620 18619 2160 34817 2160 4202560 47818 0 1 0 2069 18 0 0 25 0 11 0 59664628 907722752 71468 1283457024 134512640 134550932 4288125456 18446744073709551615 4095861840 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18633/tid=18635] ppid=18620 vsize=886448 CPUtime=1.84
/proc/18633/task/18635/stat : 18635 (java) S 18620 18619 2160 34817 2160 4202560 14550 0 0 0 182 2 0 0 15 0 11 0 59664630 907722752 71468 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18636] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18636/stat : 18636 (java) S 18620 18619 2160 34817 2160 4202560 9 0 0 0 0 0 0 0 18 0 11 0 59664630 907722752 71468 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18637] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18637/stat : 18637 (java) S 18620 18619 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 59664630 907722752 71468 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18638] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18638/stat : 18638 (java) S 18620 18619 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59664633 907722752 71468 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18639] ppid=18620 vsize=886448 CPUtime=1.26
/proc/18633/task/18639/stat : 18639 (java) S 18620 18619 2160 34817 2160 4202560 5228 0 0 0 124 2 0 0 18 0 11 0 59664633 907722752 71468 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18640] ppid=18620 vsize=886448 CPUtime=1.43
/proc/18633/task/18640/stat : 18640 (java) S 18620 18619 2160 34817 2160 4202560 5542 0 0 0 141 2 0 0 15 0 11 0 59664633 907722752 71468 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18641] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18641/stat : 18641 (java) S 18620 18619 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59664633 907722752 71468 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18642] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18642/stat : 18642 (java) S 18620 18619 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 59664633 907722752 71468 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18645] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18645/stat : 18645 (java) S 18620 18619 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 59665003 907722752 71468 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 25.47
Current children cumulated vsize (KiB) 891592

[startup+51.11 s]
/proc/loadavg: 1.08 1.04 1.01 2/48 18649
/proc/meminfo: memFree=618052/1048576 swapFree=0/0
[pid=18619] ppid=18618 vsize=2568 CPUtime=0
/proc/18619/stat : 18619 (p2cudf-user-1.1) S 18618 18619 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59664624 2629632 270 1283457024 134512640 135304128 4294697360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18619/statm: 642 270 230 194 0 29 0
[pid=18620] ppid=18619 vsize=2576 CPUtime=0.02
/proc/18620/stat : 18620 (p2cudf) S 18619 18619 2160 34817 2160 4202496 390 3016 0 1 0 0 0 2 25 0 1 0 59664624 2637824 281 1283457024 134512640 135304128 4291442336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18620/statm: 644 281 239 194 0 31 0
[pid=18633] ppid=18620 vsize=886448 CPUtime=51.04
/proc/18633/stat : 18633 (java) S 18620 18619 2160 34817 2160 4202496 77195 0 1 0 5077 27 0 0 25 0 11 0 59664628 907722752 74444 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/18633/statm: 221612 74444 1783 10 0 218703 0
[pid=18633/tid=18634] ppid=18620 vsize=886448 CPUtime=45.19
/proc/18633/task/18634/stat : 18634 (java) R 18620 18619 2160 34817 2160 4202560 47818 0 1 0 4501 18 0 0 25 0 11 0 59664628 907722752 74444 1283457024 134512640 134550932 4288125456 18446744073709551615 4095856836 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18633/tid=18635] ppid=18620 vsize=886448 CPUtime=3.11
/proc/18633/task/18635/stat : 18635 (java) S 18620 18619 2160 34817 2160 4202560 17526 0 0 0 309 2 0 0 16 0 11 0 59664630 907722752 74444 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18636] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18636/stat : 18636 (java) S 18620 18619 2160 34817 2160 4202560 9 0 0 0 0 0 0 0 18 0 11 0 59664630 907722752 74444 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18637] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18637/stat : 18637 (java) S 18620 18619 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 59664630 907722752 74444 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18638] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18638/stat : 18638 (java) S 18620 18619 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59664633 907722752 74444 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18639] ppid=18620 vsize=886448 CPUtime=1.26
/proc/18633/task/18639/stat : 18639 (java) S 18620 18619 2160 34817 2160 4202560 5228 0 0 0 124 2 0 0 18 0 11 0 59664633 907722752 74444 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18640] ppid=18620 vsize=886448 CPUtime=1.43
/proc/18633/task/18640/stat : 18640 (java) S 18620 18619 2160 34817 2160 4202560 5542 0 0 0 141 2 0 0 15 0 11 0 59664633 907722752 74444 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18641] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18641/stat : 18641 (java) S 18620 18619 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59664633 907722752 74444 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18642] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18642/stat : 18642 (java) S 18620 18619 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 59664633 907722752 74444 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18645] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18645/stat : 18645 (java) S 18620 18619 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 59665003 907722752 74444 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 51.06
Current children cumulated vsize (KiB) 891592

[startup+102.311 s]
/proc/loadavg: 1.03 1.03 1.00 2/47 18654
/proc/meminfo: memFree=590416/1048576 swapFree=0/0
[pid=18619] ppid=18618 vsize=2568 CPUtime=0
/proc/18619/stat : 18619 (p2cudf-user-1.1) S 18618 18619 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59664624 2629632 270 1283457024 134512640 135304128 4294697360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18619/statm: 642 270 230 194 0 29 0
[pid=18620] ppid=18619 vsize=2576 CPUtime=0.02
/proc/18620/stat : 18620 (p2cudf) S 18619 18619 2160 34817 2160 4202496 390 3016 0 1 0 0 0 2 25 0 1 0 59664624 2637824 281 1283457024 134512640 135304128 4291442336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18620/statm: 644 281 239 194 0 31 0
[pid=18633] ppid=18620 vsize=886448 CPUtime=102.21
/proc/18633/stat : 18633 (java) S 18620 18619 2160 34817 2160 4202496 84032 0 1 0 10194 27 0 0 25 0 11 0 59664628 907722752 81281 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/18633/statm: 221612 81281 1783 10 0 218703 0
[pid=18633/tid=18634] ppid=18620 vsize=886448 CPUtime=94.33
/proc/18633/task/18634/stat : 18634 (java) R 18620 18619 2160 34817 2160 4202560 47818 0 1 0 9415 18 0 0 25 0 11 0 59664628 907722752 81281 1283457024 134512640 134550932 4288125456 18446744073709551615 4095862324 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18633/tid=18635] ppid=18620 vsize=886448 CPUtime=5.14
/proc/18633/task/18635/stat : 18635 (java) S 18620 18619 2160 34817 2160 4202560 24363 0 0 0 512 2 0 0 16 0 11 0 59664630 907722752 81281 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18636] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18636/stat : 18636 (java) S 18620 18619 2160 34817 2160 4202560 9 0 0 0 0 0 0 0 18 0 11 0 59664630 907722752 81281 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18637] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18637/stat : 18637 (java) S 18620 18619 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 59664630 907722752 81281 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18638] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18638/stat : 18638 (java) S 18620 18619 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59664633 907722752 81281 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18639] ppid=18620 vsize=886448 CPUtime=1.26
/proc/18633/task/18639/stat : 18639 (java) S 18620 18619 2160 34817 2160 4202560 5228 0 0 0 124 2 0 0 18 0 11 0 59664633 907722752 81281 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18640] ppid=18620 vsize=886448 CPUtime=1.43
/proc/18633/task/18640/stat : 18640 (java) S 18620 18619 2160 34817 2160 4202560 5542 0 0 0 141 2 0 0 15 0 11 0 59664633 907722752 81281 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18641] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18641/stat : 18641 (java) S 18620 18619 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59664633 907722752 81281 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18642] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18642/stat : 18642 (java) S 18620 18619 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 59664633 907722752 81281 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18645] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18645/stat : 18645 (java) S 18620 18619 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 59665003 907722752 81281 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 102.23
Current children cumulated vsize (KiB) 891592

[startup+162.306 s]
/proc/loadavg: 1.01 1.02 1.00 2/47 18654
/proc/meminfo: memFree=590416/1048576 swapFree=0/0
[pid=18619] ppid=18618 vsize=2568 CPUtime=0
/proc/18619/stat : 18619 (p2cudf-user-1.1) S 18618 18619 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59664624 2629632 270 1283457024 134512640 135304128 4294697360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18619/statm: 642 270 230 194 0 29 0
[pid=18620] ppid=18619 vsize=2576 CPUtime=0.02
/proc/18620/stat : 18620 (p2cudf) S 18619 18619 2160 34817 2160 4202496 390 3016 0 1 0 0 0 2 25 0 1 0 59664624 2637824 281 1283457024 134512640 135304128 4291442336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18620/statm: 644 281 239 194 0 31 0
[pid=18633] ppid=18620 vsize=886448 CPUtime=162.17
/proc/18633/stat : 18633 (java) S 18620 18619 2160 34817 2160 4202496 84032 0 1 0 16189 28 0 0 25 0 11 0 59664628 907722752 81281 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/18633/statm: 221612 81281 1783 10 0 218703 0
[pid=18633/tid=18634] ppid=18620 vsize=886448 CPUtime=151.77
/proc/18633/task/18634/stat : 18634 (java) R 18620 18619 2160 34817 2160 4202560 47818 0 1 0 15159 18 0 0 25 0 11 0 59664628 907722752 81281 1283457024 134512640 134550932 4288125456 18446744073709551615 4095834095 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18633/tid=18635] ppid=18620 vsize=886448 CPUtime=7.68
/proc/18633/task/18635/stat : 18635 (java) S 18620 18619 2160 34817 2160 4202560 24363 0 0 0 764 4 0 0 15 0 11 0 59664630 907722752 81281 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18636] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18636/stat : 18636 (java) S 18620 18619 2160 34817 2160 4202560 9 0 0 0 0 0 0 0 18 0 11 0 59664630 907722752 81281 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18637] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18637/stat : 18637 (java) S 18620 18619 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 59664630 907722752 81281 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18638] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18638/stat : 18638 (java) S 18620 18619 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59664633 907722752 81281 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18639] ppid=18620 vsize=886448 CPUtime=1.26
/proc/18633/task/18639/stat : 18639 (java) S 18620 18619 2160 34817 2160 4202560 5228 0 0 0 124 2 0 0 18 0 11 0 59664633 907722752 81281 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18640] ppid=18620 vsize=886448 CPUtime=1.43
/proc/18633/task/18640/stat : 18640 (java) S 18620 18619 2160 34817 2160 4202560 5542 0 0 0 141 2 0 0 15 0 11 0 59664633 907722752 81281 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18641] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18641/stat : 18641 (java) S 18620 18619 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59664633 907722752 81281 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18642] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18642/stat : 18642 (java) S 18620 18619 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 59664633 907722752 81281 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18645] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18645/stat : 18645 (java) S 18620 18619 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 59665003 907722752 81281 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 162.19
Current children cumulated vsize (KiB) 891592

[startup+222.31 s]
/proc/loadavg: 1.00 1.02 1.00 2/46 18654
/proc/meminfo: memFree=584968/1048576 swapFree=0/0
[pid=18619] ppid=18618 vsize=2568 CPUtime=0
/proc/18619/stat : 18619 (p2cudf-user-1.1) S 18618 18619 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59664624 2629632 270 1283457024 134512640 135304128 4294697360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18619/statm: 642 270 230 194 0 29 0
[pid=18620] ppid=18619 vsize=2576 CPUtime=0.02
/proc/18620/stat : 18620 (p2cudf) S 18619 18619 2160 34817 2160 4202496 390 3016 0 1 0 0 0 2 25 0 1 0 59664624 2637824 281 1283457024 134512640 135304128 4291442336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18620/statm: 644 281 239 194 0 31 0
[pid=18633] ppid=18620 vsize=886448 CPUtime=222.16
/proc/18633/stat : 18633 (java) S 18620 18619 2160 34817 2160 4202496 85392 0 1 0 22186 30 0 0 25 0 11 0 59664628 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/18633/statm: 221612 82641 1783 10 0 218703 0
[pid=18633/tid=18634] ppid=18620 vsize=886448 CPUtime=209.5
/proc/18633/task/18634/stat : 18634 (java) R 18620 18619 2160 34817 2160 4202560 47818 0 1 0 20932 18 0 0 25 0 11 0 59664628 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4095023306 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18633/tid=18635] ppid=18620 vsize=886448 CPUtime=9.93
/proc/18633/task/18635/stat : 18635 (java) S 18620 18619 2160 34817 2160 4202560 25723 0 0 0 988 5 0 0 16 0 11 0 59664630 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18636] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18636/stat : 18636 (java) S 18620 18619 2160 34817 2160 4202560 9 0 0 0 0 0 0 0 18 0 11 0 59664630 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18637] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18637/stat : 18637 (java) S 18620 18619 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 59664630 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18638] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18638/stat : 18638 (java) S 18620 18619 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59664633 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18639] ppid=18620 vsize=886448 CPUtime=1.26
/proc/18633/task/18639/stat : 18639 (java) S 18620 18619 2160 34817 2160 4202560 5228 0 0 0 124 2 0 0 18 0 11 0 59664633 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18640] ppid=18620 vsize=886448 CPUtime=1.43
/proc/18633/task/18640/stat : 18640 (java) S 18620 18619 2160 34817 2160 4202560 5542 0 0 0 141 2 0 0 15 0 11 0 59664633 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18641] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18641/stat : 18641 (java) S 18620 18619 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59664633 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18642] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18642/stat : 18642 (java) S 18620 18619 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 59664633 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18645] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18645/stat : 18645 (java) S 18620 18619 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 59665003 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 222.18
Current children cumulated vsize (KiB) 891592

[startup+282.314 s]
/proc/loadavg: 1.00 1.01 1.00 2/46 18654
/proc/meminfo: memFree=584968/1048576 swapFree=0/0
[pid=18619] ppid=18618 vsize=2568 CPUtime=0
/proc/18619/stat : 18619 (p2cudf-user-1.1) S 18618 18619 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59664624 2629632 270 1283457024 134512640 135304128 4294697360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18619/statm: 642 270 230 194 0 29 0
[pid=18620] ppid=18619 vsize=2576 CPUtime=0.02
/proc/18620/stat : 18620 (p2cudf) S 18619 18619 2160 34817 2160 4202496 390 3016 0 1 0 0 0 2 25 0 1 0 59664624 2637824 281 1283457024 134512640 135304128 4291442336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18620/statm: 644 281 239 194 0 31 0
[pid=18633] ppid=18620 vsize=886448 CPUtime=282.12
/proc/18633/stat : 18633 (java) S 18620 18619 2160 34817 2160 4202496 85392 0 1 0 28182 30 0 0 25 0 11 0 59664628 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/18633/statm: 221612 82641 1783 10 0 218703 0
[pid=18633/tid=18634] ppid=18620 vsize=886448 CPUtime=266.82
/proc/18633/task/18634/stat : 18634 (java) R 18620 18619 2160 34817 2160 4202560 47818 0 1 0 26664 18 0 0 25 0 11 0 59664628 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4095779890 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18633/tid=18635] ppid=18620 vsize=886448 CPUtime=12.53
/proc/18633/task/18635/stat : 18635 (java) S 18620 18619 2160 34817 2160 4202560 25723 0 0 0 1248 5 0 0 16 0 11 0 59664630 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18636] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18636/stat : 18636 (java) S 18620 18619 2160 34817 2160 4202560 9 0 0 0 0 0 0 0 18 0 11 0 59664630 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18637] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18637/stat : 18637 (java) S 18620 18619 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 59664630 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18638] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18638/stat : 18638 (java) S 18620 18619 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59664633 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18639] ppid=18620 vsize=886448 CPUtime=1.26
/proc/18633/task/18639/stat : 18639 (java) S 18620 18619 2160 34817 2160 4202560 5228 0 0 0 124 2 0 0 18 0 11 0 59664633 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18640] ppid=18620 vsize=886448 CPUtime=1.46
/proc/18633/task/18640/stat : 18640 (java) S 18620 18619 2160 34817 2160 4202560 5542 0 0 0 144 2 0 0 15 0 11 0 59664633 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18641] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18641/stat : 18641 (java) S 18620 18619 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59664633 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18642] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18642/stat : 18642 (java) R 18620 18619 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 59664633 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18633/tid=18645] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18645/stat : 18645 (java) S 18620 18619 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 59665003 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 282.14
Current children cumulated vsize (KiB) 891592

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

[startup+283.214 s]
/proc/loadavg: 1.00 1.01 1.00 2/46 18654
/proc/meminfo: memFree=584968/1048576 swapFree=0/0
[pid=18619] ppid=18618 vsize=2568 CPUtime=0
/proc/18619/stat : 18619 (p2cudf-user-1.1) S 18618 18619 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59664624 2629632 270 1283457024 134512640 135304128 4294697360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18619/statm: 642 270 230 194 0 29 0
[pid=18620] ppid=18619 vsize=2576 CPUtime=0.02
/proc/18620/stat : 18620 (p2cudf) S 18619 18619 2160 34817 2160 4202496 390 3016 0 1 0 0 0 2 25 0 1 0 59664624 2637824 281 1283457024 134512640 135304128 4291442336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18620/statm: 644 281 239 194 0 31 0
[pid=18633] ppid=18620 vsize=886448 CPUtime=283.02
/proc/18633/stat : 18633 (java) S 18620 18619 2160 34817 2160 4202496 85392 0 1 0 28272 30 0 0 25 0 11 0 59664628 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/18633/statm: 221612 82641 1783 10 0 218703 0
[pid=18633/tid=18634] ppid=18620 vsize=886448 CPUtime=267.72
/proc/18633/task/18634/stat : 18634 (java) R 18620 18619 2160 34817 2160 4202560 47818 0 1 0 26754 18 0 0 25 0 11 0 59664628 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4095856992 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18633/tid=18635] ppid=18620 vsize=886448 CPUtime=12.53
/proc/18633/task/18635/stat : 18635 (java) S 18620 18619 2160 34817 2160 4202560 25723 0 0 0 1248 5 0 0 16 0 11 0 59664630 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18636] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18636/stat : 18636 (java) S 18620 18619 2160 34817 2160 4202560 9 0 0 0 0 0 0 0 18 0 11 0 59664630 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18637] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18637/stat : 18637 (java) S 18620 18619 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 59664630 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18638] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18638/stat : 18638 (java) S 18620 18619 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59664633 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18639] ppid=18620 vsize=886448 CPUtime=1.26
/proc/18633/task/18639/stat : 18639 (java) S 18620 18619 2160 34817 2160 4202560 5228 0 0 0 124 2 0 0 18 0 11 0 59664633 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18640] ppid=18620 vsize=886448 CPUtime=1.46
/proc/18633/task/18640/stat : 18640 (java) S 18620 18619 2160 34817 2160 4202560 5542 0 0 0 144 2 0 0 15 0 11 0 59664633 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18641] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18641/stat : 18641 (java) S 18620 18619 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59664633 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18642] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18642/stat : 18642 (java) R 18620 18619 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 59664633 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18633/tid=18645] ppid=18620 vsize=886448 CPUtime=0
/proc/18633/task/18645/stat : 18645 (java) S 18620 18619 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 59665003 907722752 82641 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.04
Current children cumulated vsize (KiB) 891592

[startup+284.006 s]
/proc/loadavg: 1.00 1.01 1.00 3/46 18654
/proc/meminfo: memFree=584844/1048576 swapFree=0/0
[pid=18619] ppid=18618 vsize=2568 CPUtime=0
/proc/18619/stat : 18619 (p2cudf-user-1.1) S 18618 18619 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59664624 2629632 270 1283457024 134512640 135304128 4294697360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18619/statm: 642 270 230 194 0 29 0
[pid=18620] ppid=18619 vsize=2576 CPUtime=0.02
/proc/18620/stat : 18620 (p2cudf) S 18619 18619 2160 34817 2160 4202496 390 3016 0 1 0 0 0 2 25 0 1 0 59664624 2637824 281 1283457024 134512640 135304128 4291442336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18620/statm: 644 281 239 194 0 31 0
[pid=18633] ppid=18620 vsize=886772 CPUtime=283.62
/proc/18633/stat : 18633 (java) S 18620 18619 2160 34817 2160 4202496 85405 0 1 0 28332 30 0 0 25 0 11 0 59664628 908054528 82654 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/18633/statm: 221693 82654 1784 10 0 218784 0
[pid=18633/tid=18634] ppid=18620 vsize=886772 CPUtime=268.32
/proc/18633/task/18634/stat : 18634 (java) S 18620 18619 2160 34817 2160 4202560 47825 0 1 0 26814 18 0 0 25 0 11 0 59664628 908054528 82654 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18635] ppid=18620 vsize=886772 CPUtime=12.53
/proc/18633/task/18635/stat : 18635 (java) S 18620 18619 2160 34817 2160 4202560 25723 0 0 0 1248 5 0 0 16 0 11 0 59664630 908054528 82654 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18636] ppid=18620 vsize=886772 CPUtime=0
/proc/18633/task/18636/stat : 18636 (java) S 18620 18619 2160 34817 2160 4202560 9 0 0 0 0 0 0 0 18 0 11 0 59664630 908054528 82654 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18637] ppid=18620 vsize=886772 CPUtime=0
/proc/18633/task/18637/stat : 18637 (java) S 18620 18619 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 59664630 908054528 82654 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18638] ppid=18620 vsize=886772 CPUtime=0
/proc/18633/task/18638/stat : 18638 (java) S 18620 18619 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59664633 908054528 82654 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18639] ppid=18620 vsize=886772 CPUtime=1.26
/proc/18633/task/18639/stat : 18639 (java) S 18620 18619 2160 34817 2160 4202560 5228 0 0 0 124 2 0 0 18 0 11 0 59664633 908054528 82654 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18640] ppid=18620 vsize=886772 CPUtime=1.48
/proc/18633/task/18640/stat : 18640 (java) S 18620 18619 2160 34817 2160 4202560 5542 0 0 0 146 2 0 0 15 0 11 0 59664633 908054528 82654 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18641] ppid=18620 vsize=886772 CPUtime=0
/proc/18633/task/18641/stat : 18641 (java) S 18620 18619 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59664633 908054528 82654 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18642] ppid=18620 vsize=886772 CPUtime=0
/proc/18633/task/18642/stat : 18642 (java) S 18620 18619 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 59664633 908054528 82654 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.64
Current children cumulated vsize (KiB) 891916

[startup+284.41 s]
/proc/loadavg: 1.00 1.01 1.00 3/46 18654
/proc/meminfo: memFree=584844/1048576 swapFree=0/0
[pid=18619] ppid=18618 vsize=2568 CPUtime=0
/proc/18619/stat : 18619 (p2cudf-user-1.1) S 18618 18619 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59664624 2629632 270 1283457024 134512640 135304128 4294697360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18619/statm: 642 270 230 194 0 29 0
[pid=18620] ppid=18619 vsize=2576 CPUtime=0.02
/proc/18620/stat : 18620 (p2cudf) S 18619 18619 2160 34817 2160 4202496 390 3016 0 1 0 0 0 2 25 0 1 0 59664624 2637824 281 1283457024 134512640 135304128 4291442336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18620/statm: 644 281 239 194 0 31 0
[pid=18633] ppid=18620 vsize=886772 CPUtime=283.7
/proc/18633/stat : 18633 (java) S 18620 18619 2160 34817 2160 4202496 85408 0 1 0 28338 32 0 0 25 0 11 0 59664628 908054528 82657 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/18633/statm: 221693 82657 1785 10 0 218784 0
[pid=18633/tid=18634] ppid=18620 vsize=886772 CPUtime=268.32
/proc/18633/task/18634/stat : 18634 (java) S 18620 18619 2160 34817 2160 4202560 47825 0 1 0 26814 18 0 0 25 0 11 0 59664628 908054528 82657 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18635] ppid=18620 vsize=886772 CPUtime=12.53
/proc/18633/task/18635/stat : 18635 (java) S 18620 18619 2160 34817 2160 4202560 25723 0 0 0 1248 5 0 0 16 0 11 0 59664630 908054528 82657 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18636] ppid=18620 vsize=886772 CPUtime=0
/proc/18633/task/18636/stat : 18636 (java) S 18620 18619 2160 34817 2160 4202560 9 0 0 0 0 0 0 0 18 0 11 0 59664630 908054528 82657 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18637] ppid=18620 vsize=886772 CPUtime=0
/proc/18633/task/18637/stat : 18637 (java) S 18620 18619 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 59664630 908054528 82657 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18638] ppid=18620 vsize=886772 CPUtime=0
/proc/18633/task/18638/stat : 18638 (java) S 18620 18619 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59664633 908054528 82657 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18639] ppid=18620 vsize=886772 CPUtime=1.26
/proc/18633/task/18639/stat : 18639 (java) S 18620 18619 2160 34817 2160 4202560 5228 0 0 0 124 2 0 0 18 0 11 0 59664633 908054528 82657 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18640] ppid=18620 vsize=886772 CPUtime=1.5
/proc/18633/task/18640/stat : 18640 (java) S 18620 18619 2160 34817 2160 4202560 5543 0 0 0 148 2 0 0 15 0 11 0 59664633 908054528 82657 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18641] ppid=18620 vsize=886772 CPUtime=0
/proc/18633/task/18641/stat : 18641 (java) S 18620 18619 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59664633 908054528 82657 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18642] ppid=18620 vsize=886772 CPUtime=0
/proc/18633/task/18642/stat : 18642 (java) S 18620 18619 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 59664633 908054528 82657 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.72
Current children cumulated vsize (KiB) 891916

[startup+284.506 s]
/proc/loadavg: 1.00 1.01 1.00 3/46 18654
/proc/meminfo: memFree=584844/1048576 swapFree=0/0
[pid=18619] ppid=18618 vsize=2568 CPUtime=0
/proc/18619/stat : 18619 (p2cudf-user-1.1) S 18618 18619 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59664624 2629632 270 1283457024 134512640 135304128 4294697360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18619/statm: 642 270 230 194 0 29 0
[pid=18620] ppid=18619 vsize=2576 CPUtime=0.02
/proc/18620/stat : 18620 (p2cudf) S 18619 18619 2160 34817 2160 4202496 390 3016 0 1 0 0 0 2 25 0 1 0 59664624 2637824 281 1283457024 134512640 135304128 4291442336 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18620/statm: 644 281 239 194 0 31 0
[pid=18633] ppid=18620 vsize=886772 CPUtime=283.76
/proc/18633/stat : 18633 (java) S 18620 18619 2160 34817 2160 4202496 85408 0 1 0 28342 34 0 0 25 0 10 0 59664628 908054528 82657 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/18633/statm: 221693 82657 1785 10 0 218784 0
[pid=18633/tid=18634] ppid=18620 vsize=886772 CPUtime=268.32
/proc/18633/task/18634/stat : 18634 (java) S 18620 18619 2160 34817 2160 4202560 47825 0 1 0 26814 18 0 0 19 0 10 0 59664628 908054528 82657 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18635] ppid=18620 vsize=886772 CPUtime=12.53
/proc/18633/task/18635/stat : 18635 (java) S 18620 18619 2160 34817 2160 4202560 25723 0 0 0 1248 5 0 0 16 0 10 0 59664630 908054528 82657 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18636] ppid=18620 vsize=886772 CPUtime=0
/proc/18633/task/18636/stat : 18636 (java) S 18620 18619 2160 34817 2160 4202560 9 0 0 0 0 0 0 0 18 0 10 0 59664630 908054528 82657 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18637] ppid=18620 vsize=886772 CPUtime=0
/proc/18633/task/18637/stat : 18637 (java) S 18620 18619 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 10 0 59664630 908054528 82657 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18638] ppid=18620 vsize=886772 CPUtime=0
/proc/18633/task/18638/stat : 18638 (java) S 18620 18619 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 59664633 908054528 82657 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18639] ppid=18620 vsize=886772 CPUtime=1.26
/proc/18633/task/18639/stat : 18639 (java) S 18620 18619 2160 34817 2160 4202560 5228 0 0 0 124 2 0 0 18 0 10 0 59664633 908054528 82657 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18640] ppid=18620 vsize=886772 CPUtime=1.53
/proc/18633/task/18640/stat : 18640 (java) S 18620 18619 2160 34817 2160 4202560 5543 0 0 0 151 2 0 0 16 0 10 0 59664633 908054528 82657 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18641] ppid=18620 vsize=886772 CPUtime=0
/proc/18633/task/18641/stat : 18641 (java) S 18620 18619 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 59664633 908054528 82657 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=18633/tid=18642] ppid=18620 vsize=886772 CPUtime=0
/proc/18633/task/18642/stat : 18642 (java) R 18620 18619 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 10 0 59664633 908054528 82657 1283457024 134512640 134550932 4288125456 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.78
Current children cumulated vsize (KiB) 891916

Child status: 0
Real time (s): 284.526
CPU time (s): 283.822
CPU user time (s): 283.442
CPU system time (s): 0.380023
CPU usage (%): 99.7523
Max. virtual memory (cumulated for all children) (KiB): 891916

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 283.442
system time used= 0.380023
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 89215
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= 6049
involuntary context switches= 8991

runsolver used 0 second user time and 0 second system time

The end