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: runsolver -s SIGUSR1 -M 1124 -C 300 -d 10 -w /tmp/misc2012/2012-09-02-22:42/full/p2cudf-full-1.15/dist-upgrade/real/cff22854-9512-11e0-8001-00163e1e087d.cudf.log.runsolver /home/competition/p2cudf-full-1.15/p2cudf-full-1.15 /home/competition/data/real/cff22854-9512-11e0-8001-00163e1e087d.cudf /tmp/misc2012/2012-09-02-22:42/full/p2cudf-full-1.15/dist-upgrade/real/cff22854-9512-11e0-8001-00163e1e087d.cudf.result -notuptodate(solution),-aligned(solution,source,sourceversion),-unsat_recommends(solution),-count(new) 

Enforcing CPUTime limit (soft limit, will send signal-name then SIGKILL): 300 seconds
Enforcing CPUTime limit (hard limit, will send SIGXCPU): 330 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

[startup+0 s]
/proc/loadavg: 1.00 1.04 1.00 2/59 14537
/proc/meminfo: memFree=589008/1022884 swapFree=0/0
[pid=14537] ppid=14536 vsize=3152 CPUtime=0
/proc/14537/stat : 14537 (runsolver) R 14536 1750 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 1 0 118380429 3227648 32 18446744073709551615 134512640 134586868 4290510464 4290508512 4151260208 0 0 16781316 24578 0 0 0 17 0 0 0 0 0 0
/proc/14537/statm: 788 32 0 19 0 73 0
Current StackSize limit: 8192 KiB


[startup+0.169084 s]
/proc/loadavg: 1.00 1.04 1.00 2/59 14537
/proc/meminfo: memFree=589008/1022884 swapFree=0/0
[pid=14537] ppid=14536 vsize=9172 CPUtime=0
/proc/14537/stat : 14537 (p2cudf-full-1.1) S 14536 14537 1750 0 -1 4202496 456 292 2 1 0 0 0 0 20 0 1 0 118380429 9392128 331 18446744073709551615 4194304 5129932 140736261625328 140736261623472 139790478513246 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/14537/statm: 2293 331 280 229 0 53 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9172

[startup+0.200357 s]
/proc/loadavg: 1.00 1.04 1.00 2/59 14537
/proc/meminfo: memFree=589008/1022884 swapFree=0/0
[pid=14537] ppid=14536 vsize=9172 CPUtime=0
/proc/14537/stat : 14537 (p2cudf-full-1.1) S 14536 14537 1750 0 -1 4202496 456 292 2 1 0 0 0 0 20 0 1 0 118380429 9392128 331 18446744073709551615 4194304 5129932 140736261625328 140736261623472 139790478513246 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/14537/statm: 2293 331 280 229 0 53 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9172

[startup+0.300301 s]
/proc/loadavg: 1.00 1.04 1.00 2/59 14537
/proc/meminfo: memFree=589008/1022884 swapFree=0/0
[pid=14537] ppid=14536 vsize=9172 CPUtime=0
/proc/14537/stat : 14537 (p2cudf-full-1.1) S 14536 14537 1750 0 -1 4202496 456 292 2 1 0 0 0 0 20 0 1 0 118380429 9392128 331 18446744073709551615 4194304 5129932 140736261625328 140736261623472 139790478513246 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/14537/statm: 2293 331 280 229 0 53 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9172

[startup+0.700251 s]
/proc/loadavg: 1.00 1.04 1.00 2/59 14537
/proc/meminfo: memFree=589008/1022884 swapFree=0/0
[pid=14537] ppid=14536 vsize=9172 CPUtime=0
/proc/14537/stat : 14537 (p2cudf-full-1.1) S 14536 14537 1750 0 -1 4202496 456 292 2 1 0 0 0 0 20 0 1 0 118380429 9392128 331 18446744073709551615 4194304 5129932 140736261625328 140736261623472 139790478513246 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/14537/statm: 2293 331 280 229 0 53 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9172

[startup+1.5007 s]
/proc/loadavg: 1.00 1.04 1.00 3/70 14549
/proc/meminfo: memFree=553696/1022884 swapFree=0/0
[pid=14537] ppid=14536 vsize=9172 CPUtime=0
/proc/14537/stat : 14537 (p2cudf-full-1.1) S 14536 14537 1750 0 -1 4202496 456 292 2 1 0 0 0 0 20 0 1 0 118380429 9392128 331 18446744073709551615 4194304 5129932 140736261625328 140736261623472 139790478513246 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/14537/statm: 2293 331 280 229 0 53 0
[pid=14540] ppid=14537 vsize=1049428 CPUtime=1.29
/proc/14540/stat : 14540 (java) S 14537 14537 1750 0 -1 4202496 27014 0 20 0 119 10 0 0 20 0 10 0 118380434 1074614272 24544 18446744073709551615 4194304 4228012 140733275046688 140733275037712 140087534935669 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 6 0 0
/proc/14540/statm: 262357 24544 2347 9 0 249707 0
[pid=14540/tid=14541] ppid=14537 vsize=1049428 CPUtime=0.6
/proc/14540/task/14541/stat : 14541 (java) R 14537 14537 1750 0 -1 4202560 11495 0 8 0 56 4 0 0 20 0 10 0 118380442 1074614272 24544 18446744073709551615 4194304 4228012 140733275046688 140087541461664 140087438985924 0 4 0 16800975 0 0 0 -1 0 0 0 10 0 0
[pid=14540/tid=14542] ppid=14537 vsize=1049428 CPUtime=0
/proc/14540/task/14542/stat : 14542 (java) S 14537 14537 1750 0 -1 4202560 4 0 0 0 0 0 0 0 20 0 10 0 118380449 1074614272 24544 18446744073709551615 4194304 4228012 140733275046688 140087434108032 140087534949963 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14543] ppid=14537 vsize=1049428 CPUtime=0
/proc/14540/task/14543/stat : 14543 (java) S 14537 14537 1750 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 10 0 118380450 1074614272 24544 18446744073709551615 4194304 4228012 140733275046688 140087433054224 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14544] ppid=14537 vsize=1049428 CPUtime=0
/proc/14540/task/14544/stat : 14544 (java) S 14537 14537 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 10 0 118380450 1074614272 24544 18446744073709551615 4194304 4228012 140733275046688 140087432001440 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14545] ppid=14537 vsize=1049428 CPUtime=0
/proc/14540/task/14545/stat : 14545 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 118380454 1074614272 24544 18446744073709551615 4194304 4228012 140733275046688 140087430949872 140087534957600 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14546] ppid=14537 vsize=1049428 CPUtime=0.32
/proc/14540/task/14546/stat : 14546 (java) R 14537 14537 1750 0 -1 4202560 7028 0 0 0 31 1 0 0 20 0 10 0 118380454 1074614272 24544 18446744073709551615 4194304 4228012 140733275046688 140087429882440 140087520605250 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14547] ppid=14537 vsize=1049428 CPUtime=0.33
/proc/14540/task/14547/stat : 14547 (java) R 14537 14537 1750 0 -1 4202560 7212 0 0 0 29 4 0 0 20 0 10 0 118380454 1074614272 24544 18446744073709551615 4194304 4228012 140733275046688 140087428829768 140087520601275 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14548] ppid=14537 vsize=1049428 CPUtime=0
/proc/14540/task/14548/stat : 14548 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 118380454 1074614272 24544 18446744073709551615 4194304 4228012 140733275046688 140087427792080 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14549] ppid=14537 vsize=1049428 CPUtime=0
/proc/14540/task/14549/stat : 14549 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 118380454 1074614272 24544 18446744073709551615 4194304 4228012 140733275046688 140087426739584 140087534949963 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 1.29
Current children cumulated vsize (KiB) 1058600

[startup+3.1008 s]
/proc/loadavg: 1.16 1.07 1.01 4/70 14549
/proc/meminfo: memFree=458712/1022884 swapFree=0/0
[pid=14537] ppid=14536 vsize=9172 CPUtime=0
/proc/14537/stat : 14537 (p2cudf-full-1.1) S 14536 14537 1750 0 -1 4202496 456 292 2 1 0 0 0 0 20 0 1 0 118380429 9392128 331 18446744073709551615 4194304 5129932 140736261625328 140736261623472 139790478513246 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/14537/statm: 2293 331 280 229 0 53 0
[pid=14540] ppid=14537 vsize=1053644 CPUtime=2.86
/proc/14540/stat : 14540 (java) S 14537 14537 1750 0 -1 4202496 75183 0 20 0 259 27 0 0 20 0 10 0 118380434 1078931456 71106 18446744073709551615 4194304 4228012 140733275046688 140733275037712 140087534935669 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 6 0 0
/proc/14540/statm: 263411 71106 2367 9 0 250761 0
[pid=14540/tid=14541] ppid=14537 vsize=1053644 CPUtime=1.4
/proc/14540/task/14541/stat : 14541 (java) R 14537 14537 1750 0 -1 4202560 47404 0 8 0 123 17 0 0 20 0 10 0 118380442 1078931456 71106 18446744073709551615 4194304 4228012 140733275046688 140087541461696 140087439404722 0 4 0 16800975 0 0 0 -1 0 0 0 10 0 0
[pid=14540/tid=14542] ppid=14537 vsize=1053644 CPUtime=0.18
/proc/14540/task/14542/stat : 14542 (java) S 14537 14537 1750 0 -1 4202560 8807 0 0 0 16 2 0 0 20 0 10 0 118380449 1078931456 71106 18446744073709551615 4194304 4228012 140733275046688 140087434108032 140087534949963 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14543] ppid=14537 vsize=1053644 CPUtime=0
/proc/14540/task/14543/stat : 14543 (java) S 14537 14537 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 118380450 1078931456 71106 18446744073709551615 4194304 4228012 140733275046688 140087433054224 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14544] ppid=14537 vsize=1053644 CPUtime=0
/proc/14540/task/14544/stat : 14544 (java) S 14537 14537 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 10 0 118380450 1078931456 71106 18446744073709551615 4194304 4228012 140733275046688 140087432001440 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14545] ppid=14537 vsize=1053644 CPUtime=0
/proc/14540/task/14545/stat : 14545 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 118380454 1078931456 71106 18446744073709551615 4194304 4228012 140733275046688 140087430949872 140087534957600 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14546] ppid=14537 vsize=1053644 CPUtime=0.62
/proc/14540/task/14546/stat : 14546 (java) S 14537 14537 1750 0 -1 4202560 7961 0 0 0 60 2 0 0 20 0 10 0 118380454 1078931456 71106 18446744073709551615 4194304 4228012 140733275046688 140087429897232 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14547] ppid=14537 vsize=1053644 CPUtime=0.63
/proc/14540/task/14547/stat : 14547 (java) S 14537 14537 1750 0 -1 4202560 9733 0 0 0 58 5 0 0 20 0 10 0 118380454 1078931456 71106 18446744073709551615 4194304 4228012 140733275046688 140087428844560 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14548] ppid=14537 vsize=1053644 CPUtime=0
/proc/14540/task/14548/stat : 14548 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 118380454 1078931456 71106 18446744073709551615 4194304 4228012 140733275046688 140087427792080 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14549] ppid=14537 vsize=1053644 CPUtime=0
/proc/14540/task/14549/stat : 14549 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 118380454 1078931456 71106 18446744073709551615 4194304 4228012 140733275046688 140087426739584 140087534949963 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 2.86
Current children cumulated vsize (KiB) 1062816

[startup+6.30079 s]
/proc/loadavg: 1.16 1.07 1.01 2/70 14549
/proc/meminfo: memFree=168924/1022884 swapFree=0/0
[pid=14537] ppid=14536 vsize=9172 CPUtime=0
/proc/14537/stat : 14537 (p2cudf-full-1.1) S 14536 14537 1750 0 -1 4202496 456 292 2 1 0 0 0 0 20 0 1 0 118380429 9392128 331 18446744073709551615 4194304 5129932 140736261625328 140736261623472 139790478513246 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/14537/statm: 2293 331 280 229 0 53 0
[pid=14540] ppid=14537 vsize=1050856 CPUtime=6
/proc/14540/stat : 14540 (java) S 14537 14537 1750 0 -1 4202496 107057 0 20 0 561 39 0 0 20 0 10 0 118380434 1076076544 102088 18446744073709551615 4194304 4228012 140733275046688 140733275037712 140087534935669 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 6 0 0
/proc/14540/statm: 262714 102088 2371 9 0 250064 0
[pid=14540/tid=14541] ppid=14537 vsize=1050856 CPUtime=3.13
/proc/14540/task/14541/stat : 14541 (java) R 14537 14537 1750 0 -1 4202560 47473 0 8 0 295 18 0 0 20 0 10 0 118380442 1076076544 102088 18446744073709551615 4194304 4228012 140733275046688 140087541470408 140087439753472 0 4 0 16800975 0 0 0 -1 0 0 0 11 0 0
[pid=14540/tid=14542] ppid=14537 vsize=1050856 CPUtime=0.96
/proc/14540/task/14542/stat : 14542 (java) S 14537 14537 1750 0 -1 4202560 40489 0 0 0 83 13 0 0 20 0 10 0 118380449 1076076544 102088 18446744073709551615 4194304 4228012 140733275046688 140087434108032 140087534949963 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14543] ppid=14537 vsize=1050856 CPUtime=0
/proc/14540/task/14543/stat : 14543 (java) S 14537 14537 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 118380450 1076076544 102088 18446744073709551615 4194304 4228012 140733275046688 140087433054224 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14544] ppid=14537 vsize=1050856 CPUtime=0
/proc/14540/task/14544/stat : 14544 (java) S 14537 14537 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 10 0 118380450 1076076544 102088 18446744073709551615 4194304 4228012 140733275046688 140087432001440 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14545] ppid=14537 vsize=1050856 CPUtime=0
/proc/14540/task/14545/stat : 14545 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 118380454 1076076544 102088 18446744073709551615 4194304 4228012 140733275046688 140087430949872 140087534957600 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14546] ppid=14537 vsize=1050856 CPUtime=0.92
/proc/14540/task/14546/stat : 14546 (java) R 14537 14537 1750 0 -1 4202560 7989 0 0 0 90 2 0 0 20 0 10 0 118380454 1076076544 102088 18446744073709551615 4194304 4228012 140733275046688 140087429886504 140087520604038 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14547] ppid=14537 vsize=1050856 CPUtime=0.97
/proc/14540/task/14547/stat : 14547 (java) R 14537 14537 1750 0 -1 4202560 9828 0 0 0 91 6 0 0 20 0 10 0 118380454 1076076544 102088 18446744073709551615 4194304 4228012 140733275046688 140087428844304 140087518422513 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14548] ppid=14537 vsize=1050856 CPUtime=0
/proc/14540/task/14548/stat : 14548 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 118380454 1076076544 102088 18446744073709551615 4194304 4228012 140733275046688 140087427792080 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14549] ppid=14537 vsize=1050856 CPUtime=0
/proc/14540/task/14549/stat : 14549 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 118380454 1076076544 102088 18446744073709551615 4194304 4228012 140733275046688 140087426739584 140087534949963 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 6
Current children cumulated vsize (KiB) 1060028

[startup+12.7008 s]
/proc/loadavg: 1.29 1.10 1.02 2/71 14550
/proc/meminfo: memFree=130600/1022884 swapFree=0/0
[pid=14537] ppid=14536 vsize=9172 CPUtime=0
/proc/14537/stat : 14537 (p2cudf-full-1.1) S 14536 14537 1750 0 -1 4202496 456 292 2 1 0 0 0 0 20 0 1 0 118380429 9392128 331 18446744073709551615 4194304 5129932 140736261625328 140736261623472 139790478513246 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/14537/statm: 2293 331 280 229 0 53 0
[pid=14540] ppid=14537 vsize=1051884 CPUtime=12.3
/proc/14540/stat : 14540 (java) S 14537 14537 1750 0 -1 4202496 122197 0 20 0 1184 46 0 0 20 0 11 0 118380434 1077129216 111544 18446744073709551615 4194304 4228012 140733275046688 140733275037712 140087534935669 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 6 0 0
/proc/14540/statm: 262971 111544 2381 9 0 250321 0
[pid=14540/tid=14541] ppid=14537 vsize=1051884 CPUtime=6.2
/proc/14540/task/14541/stat : 14541 (java) R 14537 14537 1750 0 -1 4202560 47794 0 8 0 602 18 0 0 20 0 11 0 118380442 1077129216 111544 18446744073709551615 4194304 4228012 140733275046688 140087541469128 140087439498463 0 4 0 16800975 0 0 0 -1 0 0 0 13 0 0
[pid=14540/tid=14542] ppid=14537 vsize=1051884 CPUtime=1.25
/proc/14540/task/14542/stat : 14542 (java) S 14537 14537 1750 0 -1 4202560 49445 0 0 0 108 17 0 0 20 0 11 0 118380449 1077129216 111544 18446744073709551615 4194304 4228012 140733275046688 140087434108032 140087534949963 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14543] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14543/stat : 14543 (java) S 14537 14537 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 118380450 1077129216 111544 18446744073709551615 4194304 4228012 140733275046688 140087433054224 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14544] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14544/stat : 14544 (java) S 14537 14537 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 118380450 1077129216 111544 18446744073709551615 4194304 4228012 140733275046688 140087432001440 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14545] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14545/stat : 14545 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118380454 1077129216 111544 18446744073709551615 4194304 4228012 140733275046688 140087430949872 140087534957600 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14546] ppid=14537 vsize=1051884 CPUtime=2.33
/proc/14540/task/14546/stat : 14546 (java) S 14537 14537 1750 0 -1 4202560 8062 0 0 0 230 3 0 0 20 0 11 0 118380454 1077129216 111544 18446744073709551615 4194304 4228012 140733275046688 140087429897232 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14547] ppid=14537 vsize=1051884 CPUtime=2.48
/proc/14540/task/14547/stat : 14547 (java) S 14537 14537 1750 0 -1 4202560 15612 0 0 0 240 8 0 0 20 0 11 0 118380454 1077129216 111544 18446744073709551615 4194304 4228012 140733275046688 140087428844560 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14548] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14548/stat : 14548 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118380454 1077129216 111544 18446744073709551615 4194304 4228012 140733275046688 140087427792080 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14549] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14549/stat : 14549 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118380454 1077129216 111544 18446744073709551615 4194304 4228012 140733275046688 140087426739584 140087534949963 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14550] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14550/stat : 14550 (java) S 14537 14537 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118381401 1077129216 111544 18446744073709551615 4194304 4228012 140733275046688 140087425541984 140087534949963 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 12.3
Current children cumulated vsize (KiB) 1061056

[startup+25.5009 s]
/proc/loadavg: 1.39 1.13 1.03 2/71 14550
/proc/meminfo: memFree=86704/1022884 swapFree=0/0
[pid=14537] ppid=14536 vsize=9172 CPUtime=0
/proc/14537/stat : 14537 (p2cudf-full-1.1) S 14536 14537 1750 0 -1 4202496 456 292 2 1 0 0 0 0 20 0 1 0 118380429 9392128 331 18446744073709551615 4194304 5129932 140736261625328 140736261623472 139790478513246 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/14537/statm: 2293 331 280 229 0 53 0
[pid=14540] ppid=14537 vsize=1051884 CPUtime=24.92
/proc/14540/stat : 14540 (java) S 14537 14537 1750 0 -1 4202496 133121 0 20 0 2442 50 0 0 20 0 11 0 118380434 1077129216 122468 18446744073709551615 4194304 4228012 140733275046688 140733275037712 140087534935669 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 6 0 0
/proc/14540/statm: 262971 122468 2393 9 0 250321 0
[pid=14540/tid=14541] ppid=14537 vsize=1051884 CPUtime=15.45
/proc/14540/task/14541/stat : 14541 (java) R 14537 14537 1750 0 -1 4202560 47796 0 8 0 1527 18 0 0 20 0 11 0 118380442 1077129216 122468 18446744073709551615 4194304 4228012 140733275046688 140087541469160 140087440100963 0 4 0 16800975 0 0 0 -1 0 0 0 13 0 0
[pid=14540/tid=14542] ppid=14537 vsize=1051884 CPUtime=4.15
/proc/14540/task/14542/stat : 14542 (java) S 14537 14537 1750 0 -1 4202560 60331 0 0 0 395 20 0 0 20 0 11 0 118380449 1077129216 122468 18446744073709551615 4194304 4228012 140733275046688 140087434108032 140087534949963 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14543] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14543/stat : 14543 (java) S 14537 14537 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 118380450 1077129216 122468 18446744073709551615 4194304 4228012 140733275046688 140087433054224 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14544] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14544/stat : 14544 (java) S 14537 14537 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 118380450 1077129216 122468 18446744073709551615 4194304 4228012 140733275046688 140087432001440 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14545] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14545/stat : 14545 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118380454 1077129216 122468 18446744073709551615 4194304 4228012 140733275046688 140087430949872 140087534957600 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14546] ppid=14537 vsize=1051884 CPUtime=2.71
/proc/14540/task/14546/stat : 14546 (java) S 14537 14537 1750 0 -1 4202560 8094 0 0 0 268 3 0 0 20 0 11 0 118380454 1077129216 122468 18446744073709551615 4194304 4228012 140733275046688 140087429897232 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14547] ppid=14537 vsize=1051884 CPUtime=2.56
/proc/14540/task/14547/stat : 14547 (java) S 14537 14537 1750 0 -1 4202560 15616 0 0 0 248 8 0 0 20 0 11 0 118380454 1077129216 122468 18446744073709551615 4194304 4228012 140733275046688 140087428844560 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14548] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14548/stat : 14548 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118380454 1077129216 122468 18446744073709551615 4194304 4228012 140733275046688 140087427792080 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14549] ppid=14537 vsize=1051884 CPUtime=0.01
/proc/14540/task/14549/stat : 14549 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 1 0 0 0 20 0 11 0 118380454 1077129216 122468 18446744073709551615 4194304 4228012 140733275046688 140087426739584 140087534949963 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14550] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14550/stat : 14550 (java) S 14537 14537 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118381401 1077129216 122468 18446744073709551615 4194304 4228012 140733275046688 140087425541984 140087534949963 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 24.92
Current children cumulated vsize (KiB) 1061056

[startup+51.1006 s]
/proc/loadavg: 1.26 1.12 1.03 2/71 14550
/proc/meminfo: memFree=59176/1022884 swapFree=0/0
[pid=14537] ppid=14536 vsize=9172 CPUtime=0
/proc/14537/stat : 14537 (p2cudf-full-1.1) S 14536 14537 1750 0 -1 4202496 456 292 2 1 0 0 0 0 20 0 1 0 118380429 9392128 331 18446744073709551615 4194304 5129932 140736261625328 140736261623472 139790478513246 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/14537/statm: 2293 331 280 229 0 53 0
[pid=14540] ppid=14537 vsize=1051884 CPUtime=50.21
/proc/14540/stat : 14540 (java) S 14537 14537 1750 0 -1 4202496 140004 0 20 0 4969 52 0 0 20 0 11 0 118380434 1077129216 129347 18446744073709551615 4194304 4228012 140733275046688 140733275037712 140087534935669 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 6 0 0
/proc/14540/statm: 262971 129347 2393 9 0 250321 0
[pid=14540/tid=14541] ppid=14537 vsize=1051884 CPUtime=37.51
/proc/14540/task/14541/stat : 14541 (java) R 14537 14537 1750 0 -1 4202560 47796 0 8 0 3733 18 0 0 20 0 11 0 118380442 1077129216 129347 18446744073709551615 4194304 4228012 140733275046688 140087541469160 140087440097251 0 4 0 16800975 0 0 0 -1 0 0 0 13 0 0
[pid=14540/tid=14542] ppid=14537 vsize=1051884 CPUtime=7.18
/proc/14540/task/14542/stat : 14542 (java) S 14537 14537 1750 0 -1 4202560 67193 0 0 0 696 22 0 0 20 0 11 0 118380449 1077129216 129347 18446744073709551615 4194304 4228012 140733275046688 140087434108032 140087534949963 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14543] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14543/stat : 14543 (java) S 14537 14537 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 118380450 1077129216 129347 18446744073709551615 4194304 4228012 140733275046688 140087433054224 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14544] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14544/stat : 14544 (java) S 14537 14537 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 118380450 1077129216 129347 18446744073709551615 4194304 4228012 140733275046688 140087432001440 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14545] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14545/stat : 14545 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118380454 1077129216 129347 18446744073709551615 4194304 4228012 140733275046688 140087430949872 140087534957600 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14546] ppid=14537 vsize=1051884 CPUtime=2.78
/proc/14540/task/14546/stat : 14546 (java) S 14537 14537 1750 0 -1 4202560 8103 0 0 0 275 3 0 0 20 0 11 0 118380454 1077129216 129347 18446744073709551615 4194304 4228012 140733275046688 140087429897232 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14547] ppid=14537 vsize=1051884 CPUtime=2.67
/proc/14540/task/14547/stat : 14547 (java) S 14537 14537 1750 0 -1 4202560 15625 0 0 0 259 8 0 0 20 0 11 0 118380454 1077129216 129347 18446744073709551615 4194304 4228012 140733275046688 140087428844560 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14548] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14548/stat : 14548 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118380454 1077129216 129347 18446744073709551615 4194304 4228012 140733275046688 140087427792080 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14549] ppid=14537 vsize=1051884 CPUtime=0.02
/proc/14540/task/14549/stat : 14549 (java) S 14537 14537 1750 0 -1 4202560 3 0 0 0 2 0 0 0 20 0 11 0 118380454 1077129216 129347 18446744073709551615 4194304 4228012 140733275046688 140087426739584 140087534949963 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14550] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14550/stat : 14550 (java) S 14537 14537 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118381401 1077129216 129347 18446744073709551615 4194304 4228012 140733275046688 140087425541984 140087534949963 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 50.21
Current children cumulated vsize (KiB) 1061056

[startup+102.301 s]
/proc/loadavg: 1.10 1.10 1.02 2/71 14550
/proc/meminfo: memFree=26068/1022884 swapFree=0/0
[pid=14537] ppid=14536 vsize=9172 CPUtime=0
/proc/14537/stat : 14537 (p2cudf-full-1.1) S 14536 14537 1750 0 -1 4202496 456 292 2 1 0 0 0 0 20 0 1 0 118380429 9392128 331 18446744073709551615 4194304 5129932 140736261625328 140736261623472 139790478513246 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/14537/statm: 2293 331 280 229 0 53 0
[pid=14540] ppid=14537 vsize=1051884 CPUtime=100.78
/proc/14540/stat : 14540 (java) S 14537 14537 1750 0 -1 4202496 148213 0 20 0 10025 53 0 0 20 0 11 0 118380434 1077129216 137552 18446744073709551615 4194304 4228012 140733275046688 140733275037712 140087534935669 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 6 0 0
/proc/14540/statm: 262971 137552 2393 9 0 250321 0
[pid=14540/tid=14541] ppid=14537 vsize=1051884 CPUtime=83.58
/proc/14540/task/14541/stat : 14541 (java) R 14537 14537 1750 0 -1 4202560 47796 0 8 0 8340 18 0 0 20 0 11 0 118380442 1077129216 137552 18446744073709551615 4194304 4228012 140733275046688 140087541469160 140087440129085 0 4 0 16800975 0 0 0 -1 0 0 0 13 0 0
[pid=14540/tid=14542] ppid=14537 vsize=1051884 CPUtime=11.65
/proc/14540/task/14542/stat : 14542 (java) S 14537 14537 1750 0 -1 4202560 75399 0 0 0 1142 23 0 0 20 0 11 0 118380449 1077129216 137552 18446744073709551615 4194304 4228012 140733275046688 140087434108032 140087534949963 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14543] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14543/stat : 14543 (java) S 14537 14537 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 118380450 1077129216 137552 18446744073709551615 4194304 4228012 140733275046688 140087433054224 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14544] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14544/stat : 14544 (java) S 14537 14537 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 118380450 1077129216 137552 18446744073709551615 4194304 4228012 140733275046688 140087432001440 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14545] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14545/stat : 14545 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118380454 1077129216 137552 18446744073709551615 4194304 4228012 140733275046688 140087430949872 140087534957600 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14546] ppid=14537 vsize=1051884 CPUtime=2.79
/proc/14540/task/14546/stat : 14546 (java) S 14537 14537 1750 0 -1 4202560 8103 0 0 0 276 3 0 0 20 0 11 0 118380454 1077129216 137552 18446744073709551615 4194304 4228012 140733275046688 140087429897232 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14547] ppid=14537 vsize=1051884 CPUtime=2.67
/proc/14540/task/14547/stat : 14547 (java) S 14537 14537 1750 0 -1 4202560 15625 0 0 0 259 8 0 0 20 0 11 0 118380454 1077129216 137552 18446744073709551615 4194304 4228012 140733275046688 140087428844560 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14548] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14548/stat : 14548 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118380454 1077129216 137552 18446744073709551615 4194304 4228012 140733275046688 140087427792080 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14549] ppid=14537 vsize=1051884 CPUtime=0.05
/proc/14540/task/14549/stat : 14549 (java) S 14537 14537 1750 0 -1 4202560 6 0 0 0 5 0 0 0 20 0 11 0 118380454 1077129216 137552 18446744073709551615 4194304 4228012 140733275046688 140087426739584 140087534949963 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14550] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14550/stat : 14550 (java) S 14537 14537 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118381401 1077129216 137552 18446744073709551615 4194304 4228012 140733275046688 140087425541984 140087534949963 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 100.78
Current children cumulated vsize (KiB) 1061056

[startup+162.301 s]
/proc/loadavg: 1.10 1.09 1.02 2/71 14550
/proc/meminfo: memFree=10140/1022884 swapFree=0/0
[pid=14537] ppid=14536 vsize=9172 CPUtime=0
/proc/14537/stat : 14537 (p2cudf-full-1.1) S 14536 14537 1750 0 -1 4202496 456 292 2 1 0 0 0 0 20 0 1 0 118380429 9392128 331 18446744073709551615 4194304 5129932 140736261625328 140736261623472 139790478513246 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/14537/statm: 2293 331 280 229 0 53 0
[pid=14540] ppid=14537 vsize=1051884 CPUtime=159.93
/proc/14540/stat : 14540 (java) S 14537 14537 1750 0 -1 4202496 152836 0 20 0 15939 54 0 0 20 0 11 0 118380434 1077129216 142167 18446744073709551615 4194304 4228012 140733275046688 140733275037712 140087534935669 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 6 0 0
/proc/14540/statm: 262971 142167 2393 9 0 250321 0
[pid=14540/tid=14541] ppid=14537 vsize=1051884 CPUtime=139.08
/proc/14540/task/14541/stat : 14541 (java) R 14537 14537 1750 0 -1 4202560 47796 0 8 0 13890 18 0 0 20 0 11 0 118380442 1077129216 142167 18446744073709551615 4194304 4228012 140733275046688 140087541469160 140087439498674 0 4 0 16800975 0 0 0 -1 0 0 0 13 0 0
[pid=14540/tid=14542] ppid=14537 vsize=1051884 CPUtime=15.27
/proc/14540/task/14542/stat : 14542 (java) S 14537 14537 1750 0 -1 4202560 80016 0 0 0 1503 24 0 0 20 0 11 0 118380449 1077129216 142167 18446744073709551615 4194304 4228012 140733275046688 140087434108032 140087534949963 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14543] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14543/stat : 14543 (java) S 14537 14537 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 118380450 1077129216 142167 18446744073709551615 4194304 4228012 140733275046688 140087433054224 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14544] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14544/stat : 14544 (java) S 14537 14537 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 118380450 1077129216 142167 18446744073709551615 4194304 4228012 140733275046688 140087432001440 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14545] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14545/stat : 14545 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118380454 1077129216 142167 18446744073709551615 4194304 4228012 140733275046688 140087430949872 140087534957600 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14546] ppid=14537 vsize=1051884 CPUtime=2.79
/proc/14540/task/14546/stat : 14546 (java) S 14537 14537 1750 0 -1 4202560 8103 0 0 0 276 3 0 0 20 0 11 0 118380454 1077129216 142167 18446744073709551615 4194304 4228012 140733275046688 140087429897232 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14547] ppid=14537 vsize=1051884 CPUtime=2.67
/proc/14540/task/14547/stat : 14547 (java) S 14537 14537 1750 0 -1 4202560 15625 0 0 0 259 8 0 0 20 0 11 0 118380454 1077129216 142167 18446744073709551615 4194304 4228012 140733275046688 140087428844560 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14548] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14548/stat : 14548 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118380454 1077129216 142167 18446744073709551615 4194304 4228012 140733275046688 140087427792080 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14549] ppid=14537 vsize=1051884 CPUtime=0.08
/proc/14540/task/14549/stat : 14549 (java) S 14537 14537 1750 0 -1 4202560 12 0 0 0 8 0 0 0 20 0 11 0 118380454 1077129216 142167 18446744073709551615 4194304 4228012 140733275046688 140087426739584 140087534949963 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14550] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14550/stat : 14550 (java) S 14537 14537 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118381401 1077129216 142167 18446744073709551615 4194304 4228012 140733275046688 140087425541984 140087534949963 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 159.93
Current children cumulated vsize (KiB) 1061056

[startup+222.304 s]
/proc/loadavg: 1.04 1.07 1.02 2/71 14550
/proc/meminfo: memFree=9544/1022884 swapFree=0/0
[pid=14537] ppid=14536 vsize=9172 CPUtime=0
/proc/14537/stat : 14537 (p2cudf-full-1.1) S 14536 14537 1750 0 -1 4202496 456 292 2 1 0 0 0 0 20 0 1 0 118380429 9392128 331 18446744073709551615 4194304 5129932 140736261625328 140736261623472 139790478513246 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/14537/statm: 2293 331 280 229 0 53 0
[pid=14540] ppid=14537 vsize=1051884 CPUtime=219.28
/proc/14540/stat : 14540 (java) S 14537 14537 1750 0 -1 4202496 163677 0 20 0 21868 60 0 0 20 0 11 0 118380434 1077129216 153000 18446744073709551615 4194304 4228012 140733275046688 140733275037712 140087534935669 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 6 0 0
/proc/14540/statm: 262971 153000 2393 9 0 250321 0
[pid=14540/tid=14541] ppid=14537 vsize=1051884 CPUtime=195.01
/proc/14540/task/14541/stat : 14541 (java) R 14537 14537 1750 0 -1 4202560 47796 0 8 0 19482 19 0 0 20 0 11 0 118380442 1077129216 153000 18446744073709551615 4194304 4228012 140733275046688 140087541469352 140087439498780 0 4 0 16800975 0 0 0 -1 0 0 0 13 0 0
[pid=14540/tid=14542] ppid=14537 vsize=1051884 CPUtime=18.64
/proc/14540/task/14542/stat : 14542 (java) S 14537 14537 1750 0 -1 4202560 90851 0 0 0 1834 30 0 0 20 0 11 0 118380449 1077129216 153000 18446744073709551615 4194304 4228012 140733275046688 140087434108032 140087534949963 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14543] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14543/stat : 14543 (java) S 14537 14537 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 118380450 1077129216 153000 18446744073709551615 4194304 4228012 140733275046688 140087433054224 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14544] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14544/stat : 14544 (java) S 14537 14537 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 118380450 1077129216 153000 18446744073709551615 4194304 4228012 140733275046688 140087432001440 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14545] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14545/stat : 14545 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118380454 1077129216 153000 18446744073709551615 4194304 4228012 140733275046688 140087430949872 140087534957600 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14546] ppid=14537 vsize=1051884 CPUtime=2.79
/proc/14540/task/14546/stat : 14546 (java) S 14537 14537 1750 0 -1 4202560 8103 0 0 0 276 3 0 0 20 0 11 0 118380454 1077129216 153000 18446744073709551615 4194304 4228012 140733275046688 140087429897232 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14547] ppid=14537 vsize=1051884 CPUtime=2.69
/proc/14540/task/14547/stat : 14547 (java) S 14537 14537 1750 0 -1 4202560 15625 0 0 0 261 8 0 0 20 0 11 0 118380454 1077129216 153000 18446744073709551615 4194304 4228012 140733275046688 140087428844560 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14548] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14548/stat : 14548 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118380454 1077129216 153000 18446744073709551615 4194304 4228012 140733275046688 140087427792080 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14549] ppid=14537 vsize=1051884 CPUtime=0.11
/proc/14540/task/14549/stat : 14549 (java) S 14537 14537 1750 0 -1 4202560 18 0 0 0 11 0 0 0 20 0 11 0 118380454 1077129216 153000 18446744073709551615 4194304 4228012 140733275046688 140087426739584 140087534949963 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14550] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14550/stat : 14550 (java) S 14537 14537 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118381401 1077129216 153000 18446744073709551615 4194304 4228012 140733275046688 140087425541984 140087534949963 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 219.28
Current children cumulated vsize (KiB) 1061056

[startup+282.301 s]
/proc/loadavg: 1.01 1.06 1.01 2/71 14550
/proc/meminfo: memFree=10092/1022884 swapFree=0/0
[pid=14537] ppid=14536 vsize=9172 CPUtime=0
/proc/14537/stat : 14537 (p2cudf-full-1.1) S 14536 14537 1750 0 -1 4202496 456 292 2 1 0 0 0 0 20 0 1 0 118380429 9392128 331 18446744073709551615 4194304 5129932 140736261625328 140736261623472 139790478513246 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/14537/statm: 2293 331 280 229 0 53 0
[pid=14540] ppid=14537 vsize=1051884 CPUtime=278.6
/proc/14540/stat : 14540 (java) S 14537 14537 1750 0 -1 4202496 169602 0 20 0 27799 61 0 0 20 0 11 0 118380434 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140733275037712 140087534935669 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 6 0 0
/proc/14540/statm: 262971 158910 2393 9 0 250321 0
[pid=14540/tid=14541] ppid=14537 vsize=1051884 CPUtime=251.46
/proc/14540/task/14541/stat : 14541 (java) R 14537 14537 1750 0 -1 4202560 47796 0 8 0 25127 19 0 0 20 0 11 0 118380442 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087541469160 140087439277802 0 4 0 16800975 0 0 0 -1 0 0 0 13 0 0
[pid=14540/tid=14542] ppid=14537 vsize=1051884 CPUtime=21.5
/proc/14540/task/14542/stat : 14542 (java) S 14537 14537 1750 0 -1 4202560 96766 0 0 0 2119 31 0 0 20 0 11 0 118380449 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087434108032 140087534949963 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14543] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14543/stat : 14543 (java) S 14537 14537 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 118380450 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087433054224 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14544] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14544/stat : 14544 (java) S 14537 14537 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 118380450 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087432001440 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14545] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14545/stat : 14545 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118380454 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087430949872 140087534957600 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14546] ppid=14537 vsize=1051884 CPUtime=2.79
/proc/14540/task/14546/stat : 14546 (java) S 14537 14537 1750 0 -1 4202560 8103 0 0 0 276 3 0 0 20 0 11 0 118380454 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087429897232 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14547] ppid=14537 vsize=1051884 CPUtime=2.69
/proc/14540/task/14547/stat : 14547 (java) S 14537 14537 1750 0 -1 4202560 15625 0 0 0 261 8 0 0 20 0 11 0 118380454 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087428844560 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14548] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14548/stat : 14548 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118380454 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087427792080 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14549] ppid=14537 vsize=1051884 CPUtime=0.14
/proc/14540/task/14549/stat : 14549 (java) S 14537 14537 1750 0 -1 4202560 28 0 0 0 14 0 0 0 20 0 11 0 118380454 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087426739584 140087534949963 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14550] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14550/stat : 14550 (java) S 14537 14537 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118381401 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087425541984 140087534949963 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 278.6
Current children cumulated vsize (KiB) 1061056

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

[startup+288.001 s]
/proc/loadavg: 1.01 1.06 1.01 2/71 14550
/proc/meminfo: memFree=10092/1022884 swapFree=0/0
[pid=14537] ppid=14536 vsize=9172 CPUtime=0
/proc/14537/stat : 14537 (p2cudf-full-1.1) S 14536 14537 1750 0 -1 4202496 456 292 2 1 0 0 0 0 20 0 1 0 118380429 9392128 331 18446744073709551615 4194304 5129932 140736261625328 140736261623472 139790478513246 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/14537/statm: 2293 331 280 229 0 53 0
[pid=14540] ppid=14537 vsize=1051884 CPUtime=284.25
/proc/14540/stat : 14540 (java) S 14537 14537 1750 0 -1 4202496 169602 0 20 0 28364 61 0 0 20 0 11 0 118380434 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140733275037712 140087534935669 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 6 0 0
/proc/14540/statm: 262971 158910 2393 9 0 250321 0
[pid=14540/tid=14541] ppid=14537 vsize=1051884 CPUtime=257.1
/proc/14540/task/14541/stat : 14541 (java) R 14537 14537 1750 0 -1 4202560 47796 0 8 0 25691 19 0 0 20 0 11 0 118380442 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087541469160 140087439752562 0 4 0 16800975 0 0 0 -1 0 0 0 13 0 0
[pid=14540/tid=14542] ppid=14537 vsize=1051884 CPUtime=21.5
/proc/14540/task/14542/stat : 14542 (java) S 14537 14537 1750 0 -1 4202560 96766 0 0 0 2119 31 0 0 20 0 11 0 118380449 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087434108032 140087534949963 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14543] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14543/stat : 14543 (java) S 14537 14537 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 118380450 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087433054224 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14544] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14544/stat : 14544 (java) S 14537 14537 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 118380450 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087432001440 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14545] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14545/stat : 14545 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118380454 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087430949872 140087534957600 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14546] ppid=14537 vsize=1051884 CPUtime=2.79
/proc/14540/task/14546/stat : 14546 (java) S 14537 14537 1750 0 -1 4202560 8103 0 0 0 276 3 0 0 20 0 11 0 118380454 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087429897232 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14547] ppid=14537 vsize=1051884 CPUtime=2.69
/proc/14540/task/14547/stat : 14547 (java) S 14537 14537 1750 0 -1 4202560 15625 0 0 0 261 8 0 0 20 0 11 0 118380454 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087428844560 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14548] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14548/stat : 14548 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118380454 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087427792080 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14549] ppid=14537 vsize=1051884 CPUtime=0.14
/proc/14540/task/14549/stat : 14549 (java) S 14537 14537 1750 0 -1 4202560 28 0 0 0 14 0 0 0 20 0 11 0 118380454 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087426739584 140087534949963 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14550] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14550/stat : 14550 (java) S 14537 14537 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118381401 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087425541984 140087534949963 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 284.25
Current children cumulated vsize (KiB) 1061056

[startup+291.201 s]
/proc/loadavg: 1.01 1.06 1.01 2/71 14550
/proc/meminfo: memFree=10092/1022884 swapFree=0/0
[pid=14537] ppid=14536 vsize=9172 CPUtime=0
/proc/14537/stat : 14537 (p2cudf-full-1.1) S 14536 14537 1750 0 -1 4202496 456 292 2 1 0 0 0 0 20 0 1 0 118380429 9392128 331 18446744073709551615 4194304 5129932 140736261625328 140736261623472 139790478513246 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/14537/statm: 2293 331 280 229 0 53 0
[pid=14540] ppid=14537 vsize=1051884 CPUtime=287.41
/proc/14540/stat : 14540 (java) S 14537 14537 1750 0 -1 4202496 169602 0 20 0 28680 61 0 0 20 0 11 0 118380434 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140733275037712 140087534935669 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 6 0 0
/proc/14540/statm: 262971 158910 2393 9 0 250321 0
[pid=14540/tid=14541] ppid=14537 vsize=1051884 CPUtime=259.75
/proc/14540/task/14541/stat : 14541 (java) R 14537 14537 1750 0 -1 4202560 47796 0 8 0 25956 19 0 0 20 0 11 0 118380442 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087541469160 140087439868615 0 4 0 16800975 0 0 0 -1 0 0 0 13 0 0
[pid=14540/tid=14542] ppid=14537 vsize=1051884 CPUtime=22.01
/proc/14540/task/14542/stat : 14542 (java) S 14537 14537 1750 0 -1 4202560 96766 0 0 0 2170 31 0 0 20 0 11 0 118380449 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087434108032 140087534949963 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14543] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14543/stat : 14543 (java) S 14537 14537 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 118380450 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087433054224 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14544] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14544/stat : 14544 (java) S 14537 14537 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 118380450 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087432001440 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14545] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14545/stat : 14545 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118380454 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087430949872 140087534957600 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14546] ppid=14537 vsize=1051884 CPUtime=2.79
/proc/14540/task/14546/stat : 14546 (java) S 14537 14537 1750 0 -1 4202560 8103 0 0 0 276 3 0 0 20 0 11 0 118380454 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087429897232 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14547] ppid=14537 vsize=1051884 CPUtime=2.69
/proc/14540/task/14547/stat : 14547 (java) S 14537 14537 1750 0 -1 4202560 15625 0 0 0 261 8 0 0 20 0 11 0 118380454 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087428844560 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14548] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14548/stat : 14548 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118380454 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087427792080 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14549] ppid=14537 vsize=1051884 CPUtime=0.14
/proc/14540/task/14549/stat : 14549 (java) S 14537 14537 1750 0 -1 4202560 28 0 0 0 14 0 0 0 20 0 11 0 118380454 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087426739584 140087534949963 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14550] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14550/stat : 14550 (java) S 14537 14537 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118381401 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087425541984 140087534949963 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 287.41
Current children cumulated vsize (KiB) 1061056

[startup+292.801 s]
/proc/loadavg: 1.01 1.05 1.01 2/71 14550
/proc/meminfo: memFree=10092/1022884 swapFree=0/0
[pid=14537] ppid=14536 vsize=9172 CPUtime=0
/proc/14537/stat : 14537 (p2cudf-full-1.1) S 14536 14537 1750 0 -1 4202496 456 292 2 1 0 0 0 0 20 0 1 0 118380429 9392128 331 18446744073709551615 4194304 5129932 140736261625328 140736261623472 139790478513246 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/14537/statm: 2293 331 280 229 0 53 0
[pid=14540] ppid=14537 vsize=1051884 CPUtime=289
/proc/14540/stat : 14540 (java) S 14537 14537 1750 0 -1 4202496 169602 0 20 0 28839 61 0 0 20 0 11 0 118380434 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140733275037712 140087534935669 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 6 0 0
/proc/14540/statm: 262971 158910 2393 9 0 250321 0
[pid=14540/tid=14541] ppid=14537 vsize=1051884 CPUtime=261.33
/proc/14540/task/14541/stat : 14541 (java) R 14537 14537 1750 0 -1 4202560 47796 0 8 0 26114 19 0 0 20 0 11 0 118380442 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087541469160 140087439483869 0 4 0 16800975 0 0 0 -1 0 0 0 13 0 0
[pid=14540/tid=14542] ppid=14537 vsize=1051884 CPUtime=22.01
/proc/14540/task/14542/stat : 14542 (java) S 14537 14537 1750 0 -1 4202560 96766 0 0 0 2170 31 0 0 20 0 11 0 118380449 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087434108032 140087534949963 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14543] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14543/stat : 14543 (java) S 14537 14537 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 118380450 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087433054224 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14544] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14544/stat : 14544 (java) S 14537 14537 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 118380450 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087432001440 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14545] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14545/stat : 14545 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118380454 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087430949872 140087534957600 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14546] ppid=14537 vsize=1051884 CPUtime=2.79
/proc/14540/task/14546/stat : 14546 (java) S 14537 14537 1750 0 -1 4202560 8103 0 0 0 276 3 0 0 20 0 11 0 118380454 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087429897232 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14547] ppid=14537 vsize=1051884 CPUtime=2.69
/proc/14540/task/14547/stat : 14547 (java) S 14537 14537 1750 0 -1 4202560 15625 0 0 0 261 8 0 0 20 0 11 0 118380454 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087428844560 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14548] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14548/stat : 14548 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118380454 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087427792080 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14549] ppid=14537 vsize=1051884 CPUtime=0.14
/proc/14540/task/14549/stat : 14549 (java) S 14537 14537 1750 0 -1 4202560 28 0 0 0 14 0 0 0 20 0 11 0 118380454 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087426739584 140087534949963 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14550] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14550/stat : 14550 (java) S 14537 14537 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118381401 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087425541984 140087534949963 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 289
Current children cumulated vsize (KiB) 1061056

[startup+294.401 s]
/proc/loadavg: 1.01 1.05 1.01 2/71 14550
/proc/meminfo: memFree=10092/1022884 swapFree=0/0
[pid=14537] ppid=14536 vsize=9172 CPUtime=0
/proc/14537/stat : 14537 (p2cudf-full-1.1) S 14536 14537 1750 0 -1 4202496 456 292 2 1 0 0 0 0 20 0 1 0 118380429 9392128 331 18446744073709551615 4194304 5129932 140736261625328 140736261623472 139790478513246 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/14537/statm: 2293 331 280 229 0 53 0
[pid=14540] ppid=14537 vsize=1051884 CPUtime=290.58
/proc/14540/stat : 14540 (java) S 14537 14537 1750 0 -1 4202496 169602 0 20 0 28997 61 0 0 20 0 11 0 118380434 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140733275037712 140087534935669 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 6 0 0
/proc/14540/statm: 262971 158910 2393 9 0 250321 0
[pid=14540/tid=14541] ppid=14537 vsize=1051884 CPUtime=262.92
/proc/14540/task/14541/stat : 14541 (java) R 14537 14537 1750 0 -1 4202560 47796 0 8 0 26273 19 0 0 20 0 11 0 118380442 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087541469160 140087440100987 0 4 0 16800975 0 0 0 -1 0 0 0 13 0 0
[pid=14540/tid=14542] ppid=14537 vsize=1051884 CPUtime=22.01
/proc/14540/task/14542/stat : 14542 (java) S 14537 14537 1750 0 -1 4202560 96766 0 0 0 2170 31 0 0 20 0 11 0 118380449 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087434108032 140087534949963 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14543] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14543/stat : 14543 (java) S 14537 14537 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 118380450 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087433054224 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14544] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14544/stat : 14544 (java) S 14537 14537 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 118380450 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087432001440 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14545] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14545/stat : 14545 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118380454 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087430949872 140087534957600 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14546] ppid=14537 vsize=1051884 CPUtime=2.79
/proc/14540/task/14546/stat : 14546 (java) S 14537 14537 1750 0 -1 4202560 8103 0 0 0 276 3 0 0 20 0 11 0 118380454 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087429897232 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14547] ppid=14537 vsize=1051884 CPUtime=2.69
/proc/14540/task/14547/stat : 14547 (java) S 14537 14537 1750 0 -1 4202560 15625 0 0 0 261 8 0 0 20 0 11 0 118380454 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087428844560 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14548] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14548/stat : 14548 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118380454 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087427792080 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14549] ppid=14537 vsize=1051884 CPUtime=0.14
/proc/14540/task/14549/stat : 14549 (java) S 14537 14537 1750 0 -1 4202560 28 0 0 0 14 0 0 0 20 0 11 0 118380454 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087426739584 140087534949963 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14550] ppid=14537 vsize=1051884 CPUtime=0
/proc/14540/task/14550/stat : 14550 (java) S 14537 14537 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118381401 1077129216 158910 18446744073709551615 4194304 4228012 140733275046688 140087425541984 140087534949963 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 290.58
Current children cumulated vsize (KiB) 1061056

[startup+295.201 s]
/proc/loadavg: 1.01 1.05 1.01 1/71 14551
/proc/meminfo: memFree=10092/1022884 swapFree=0/0
[pid=14537] ppid=14536 vsize=9172 CPUtime=0
/proc/14537/stat : 14537 (p2cudf-full-1.1) S 14536 14537 1750 0 -1 4202496 456 292 2 1 0 0 0 0 20 0 1 0 118380429 9392128 331 18446744073709551615 4194304 5129932 140736261625328 140736261623472 139790478513246 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/14537/statm: 2293 331 280 229 0 53 0
[pid=14540] ppid=14537 vsize=1052912 CPUtime=290.93
/proc/14540/stat : 14540 (java) S 14537 14537 1750 0 -1 4202496 169615 0 20 0 29032 61 0 0 20 0 11 0 118380434 1078181888 158921 18446744073709551615 4194304 4228012 140733275046688 140733275037712 140087534935669 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 6 0 0
/proc/14540/statm: 263228 158921 2393 9 0 250578 0
[pid=14540/tid=14541] ppid=14537 vsize=1052912 CPUtime=263.25
/proc/14540/task/14541/stat : 14541 (java) S 14537 14537 1750 0 -1 4202560 47803 0 8 0 26306 19 0 0 20 0 11 0 118380442 1078181888 158921 18446744073709551615 4194304 4228012 140733275046688 140087541470128 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 13 0 0
[pid=14540/tid=14542] ppid=14537 vsize=1052912 CPUtime=22.01
/proc/14540/task/14542/stat : 14542 (java) S 14537 14537 1750 0 -1 4202560 96766 0 0 0 2170 31 0 0 20 0 11 0 118380449 1078181888 158921 18446744073709551615 4194304 4228012 140733275046688 140087434108032 140087534949963 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14543] ppid=14537 vsize=1052912 CPUtime=0
/proc/14540/task/14543/stat : 14543 (java) S 14537 14537 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 118380450 1078181888 158921 18446744073709551615 4194304 4228012 140733275046688 140087433054224 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14544] ppid=14537 vsize=1052912 CPUtime=0
/proc/14540/task/14544/stat : 14544 (java) S 14537 14537 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 118380450 1078181888 158921 18446744073709551615 4194304 4228012 140733275046688 140087432001440 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14545] ppid=14537 vsize=1052912 CPUtime=0
/proc/14540/task/14545/stat : 14545 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118380454 1078181888 158921 18446744073709551615 4194304 4228012 140733275046688 140087430949872 140087534957600 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14546] ppid=14537 vsize=1052912 CPUtime=2.8
/proc/14540/task/14546/stat : 14546 (java) S 14537 14537 1750 0 -1 4202560 8103 0 0 0 277 3 0 0 20 0 11 0 118380454 1078181888 158921 18446744073709551615 4194304 4228012 140733275046688 140087429897232 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14547] ppid=14537 vsize=1052912 CPUtime=2.69
/proc/14540/task/14547/stat : 14547 (java) S 14537 14537 1750 0 -1 4202560 15625 0 0 0 261 8 0 0 20 0 11 0 118380454 1078181888 158921 18446744073709551615 4194304 4228012 140733275046688 140087428844560 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14548] ppid=14537 vsize=1052912 CPUtime=0
/proc/14540/task/14548/stat : 14548 (java) S 14537 14537 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118380454 1078181888 158921 18446744073709551615 4194304 4228012 140733275046688 140087427792080 140087534949076 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14549] ppid=14537 vsize=1052912 CPUtime=0.14
/proc/14540/task/14549/stat : 14549 (java) S 14537 14537 1750 0 -1 4202560 28 0 0 0 14 0 0 0 20 0 11 0 118380454 1078181888 158921 18446744073709551615 4194304 4228012 140733275046688 140087426739584 140087534949963 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14540/tid=14551] ppid=14537 vsize=1052912 CPUtime=0
/proc/14540/task/14551/stat : 14551 (java) S 14537 14537 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118409905 1078181888 158921 18446744073709551615 4194304 4228012 140733275046688 140087424489648 140087534949963 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 290.93
Current children cumulated vsize (KiB) 1062084

[startup+295.607 s]
/proc/loadavg: 1.01 1.05 1.01 1/71 14551
/proc/meminfo: memFree=10092/1022884 swapFree=0/0
[pid=14537] ppid=14536 vsize=9172 CPUtime=0
/proc/14537/stat : 14537 (p2cudf-full-1.1) S 14536 14537 1750 0 -1 4202496 456 292 2 1 0 0 0 0 20 0 1 0 118380429 9392128 331 18446744073709551615 4194304 5129932 140736261625328 140736261623472 139790478513246 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/14537/statm: 2293 331 280 229 0 53 0
[pid=14540] ppid=14537 vsize=0 CPUtime=291.27
/proc/14540/stat : 14540 (java) Z 14537 14537 1750 0 -1 4203532 169635 0 20 0 29051 76 0 0 20 0 2 0 118380434 0 0 18446744073709551615 0 0 0 0 0 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 6 0 0
/proc/14540/statm: 0 0 0 0 0 0 0
[pid=14540/tid=14551] ppid=14537 vsize=0 CPUtime=0.24
/proc/14540/task/14551/stat : 14551 (java) R 14537 14537 1750 0 -1 4203588 9 0 0 0 8 16 0 0 20 0 2 0 118409905 0 0 18446744073709551615 0 0 0 0 0 0 4 0 16800975 18446744073709551615 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 291.27
Current children cumulated vsize (KiB) 9172

Child status: 0
Real time (s): 295.608
CPU time (s): 291.29
CPU user time (s): 290.522
CPU system time (s): 0.768048
CPU usage (%): 98.5394
Max. virtual memory (cumulated for all children) (KiB): 1062816

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 290.522
system time used= 0.768048
maximum resident set size= 635756
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 170395
page faults= 23
swaps= 0
block input operations= 39456
block output operations= 736
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 7256
involuntary context switches= 41813

runsolver used 0.928058 second user time and 1.93612 second system time

The end