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/upgrade/easy/rand18.cudf.log.runsolver /home/competition/p2cudf-full-1.15/p2cudf-full-1.15 /home/competition/data/upgrade/easy/rand18.cudf /tmp/misc2012/2012-09-02-22:42/full/p2cudf-full-1.15/dist-upgrade/upgrade/easy/rand18.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.01 1.06 1.01 2/59 14948
/proc/meminfo: memFree=723896/1022884 swapFree=0/0
[pid=14948] ppid=14947 vsize=3152 CPUtime=0
/proc/14948/stat : 14948 (runsolver) R 14947 1750 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 1 0 118620865 3227648 33 18446744073709551615 134512640 134586868 4289728928 4289726976 4151837744 0 0 16781316 24578 0 0 0 17 0 0 0 0 0 0
/proc/14948/statm: 788 33 0 19 0 73 0
Current StackSize limit: 8192 KiB


[startup+0.149996 s]
/proc/loadavg: 1.01 1.06 1.01 2/59 14948
/proc/meminfo: memFree=723896/1022884 swapFree=0/0
[pid=14948] ppid=14947 vsize=9168 CPUtime=0
/proc/14948/stat : 14948 (p2cudf-full-1.1) S 14947 14948 1750 0 -1 4202496 455 291 0 0 0 0 0 0 20 0 1 0 118620865 9388032 330 18446744073709551615 4194304 5129932 140736468356240 140736468354384 139751327761502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/14948/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.20037 s]
/proc/loadavg: 1.01 1.06 1.01 2/59 14948
/proc/meminfo: memFree=723896/1022884 swapFree=0/0
[pid=14948] ppid=14947 vsize=9168 CPUtime=0
/proc/14948/stat : 14948 (p2cudf-full-1.1) S 14947 14948 1750 0 -1 4202496 455 291 0 0 0 0 0 0 20 0 1 0 118620865 9388032 330 18446744073709551615 4194304 5129932 140736468356240 140736468354384 139751327761502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/14948/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.300329 s]
/proc/loadavg: 1.01 1.06 1.01 2/59 14948
/proc/meminfo: memFree=723896/1022884 swapFree=0/0
[pid=14948] ppid=14947 vsize=9168 CPUtime=0
/proc/14948/stat : 14948 (p2cudf-full-1.1) S 14947 14948 1750 0 -1 4202496 455 291 0 0 0 0 0 0 20 0 1 0 118620865 9388032 330 18446744073709551615 4194304 5129932 140736468356240 140736468354384 139751327761502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/14948/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.700219 s]
/proc/loadavg: 1.01 1.06 1.01 2/59 14948
/proc/meminfo: memFree=723896/1022884 swapFree=0/0
[pid=14948] ppid=14947 vsize=9168 CPUtime=0
/proc/14948/stat : 14948 (p2cudf-full-1.1) S 14947 14948 1750 0 -1 4202496 455 291 0 0 0 0 0 0 20 0 1 0 118620865 9388032 330 18446744073709551615 4194304 5129932 140736468356240 140736468354384 139751327761502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/14948/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+1.50077 s]
/proc/loadavg: 1.01 1.06 1.01 4/70 14960
/proc/meminfo: memFree=675564/1022884 swapFree=0/0
[pid=14948] ppid=14947 vsize=9168 CPUtime=0
/proc/14948/stat : 14948 (p2cudf-full-1.1) S 14947 14948 1750 0 -1 4202496 455 291 0 0 0 0 0 0 20 0 1 0 118620865 9388032 330 18446744073709551615 4194304 5129932 140736468356240 140736468354384 139751327761502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/14948/statm: 2292 330 280 229 0 52 0
[pid=14951] ppid=14948 vsize=1054292 CPUtime=1.46
/proc/14951/stat : 14951 (java) S 14948 14948 1750 0 -1 4202496 31297 0 0 0 131 15 0 0 20 0 10 0 118620866 1079595008 27720 18446744073709551615 4194304 4228012 140734374818000 140734374809024 140620433792629 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/14951/statm: 263573 27720 2347 9 0 250923 0
[pid=14951/tid=14952] ppid=14948 vsize=1054292 CPUtime=0.67
/proc/14951/task/14952/stat : 14952 (java) R 14948 14948 1750 0 -1 4202560 13746 0 0 0 60 7 0 0 20 0 10 0 118620867 1079595008 27720 18446744073709551615 4194304 4228012 140734374818000 140620440318624 140620338251308 0 4 0 16800975 0 0 0 -1 0 0 0 1 0 0
[pid=14951/tid=14953] ppid=14948 vsize=1054292 CPUtime=0
/proc/14951/task/14953/stat : 14953 (java) S 14948 14948 1750 0 -1 4202560 4 0 0 0 0 0 0 0 20 0 10 0 118620870 1079595008 27720 18446744073709551615 4194304 4228012 140734374818000 140620332964992 140620433806923 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14954] ppid=14948 vsize=1054292 CPUtime=0
/proc/14951/task/14954/stat : 14954 (java) S 14948 14948 1750 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 10 0 118620871 1079595008 27720 18446744073709551615 4194304 4228012 140734374818000 140620331911184 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14955] ppid=14948 vsize=1054292 CPUtime=0
/proc/14951/task/14955/stat : 14955 (java) S 14948 14948 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 10 0 118620871 1079595008 27720 18446744073709551615 4194304 4228012 140734374818000 140620330858400 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14956] ppid=14948 vsize=1054292 CPUtime=0
/proc/14951/task/14956/stat : 14956 (java) S 14948 14948 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 118620874 1079595008 27720 18446744073709551615 4194304 4228012 140734374818000 140620329806832 140620433814560 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14957] ppid=14948 vsize=1054292 CPUtime=0.39
/proc/14951/task/14957/stat : 14957 (java) R 14948 14948 1750 0 -1 4202560 8961 0 0 0 36 3 0 0 20 0 10 0 118620874 1079595008 27720 18446744073709551615 4194304 4228012 140734374818000 140620328739432 140620419484142 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14958] ppid=14948 vsize=1054292 CPUtime=0.37
/proc/14951/task/14958/stat : 14958 (java) R 14948 14948 1750 0 -1 4202560 7297 0 0 0 33 4 0 0 20 0 10 0 118620874 1079595008 27720 18446744073709551615 4194304 4228012 140734374818000 140620327689048 140620420480333 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14959] ppid=14948 vsize=1054292 CPUtime=0
/proc/14951/task/14959/stat : 14959 (java) S 14948 14948 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 118620874 1079595008 27720 18446744073709551615 4194304 4228012 140734374818000 140620326649040 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14960] ppid=14948 vsize=1054292 CPUtime=0
/proc/14951/task/14960/stat : 14960 (java) S 14948 14948 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 118620874 1079595008 27720 18446744073709551615 4194304 4228012 140734374818000 140620325596544 140620433806923 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 1.46
Current children cumulated vsize (KiB) 1063460

[startup+3.10076 s]
/proc/loadavg: 1.01 1.06 1.01 4/70 14960
/proc/meminfo: memFree=581448/1022884 swapFree=0/0
[pid=14948] ppid=14947 vsize=9168 CPUtime=0
/proc/14948/stat : 14948 (p2cudf-full-1.1) S 14947 14948 1750 0 -1 4202496 455 291 0 0 0 0 0 0 20 0 1 0 118620865 9388032 330 18446744073709551615 4194304 5129932 140736468356240 140736468354384 139751327761502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/14948/statm: 2292 330 280 229 0 52 0
[pid=14951] ppid=14948 vsize=1053856 CPUtime=3.04
/proc/14951/stat : 14951 (java) S 14948 14948 1750 0 -1 4202496 74944 0 0 0 274 30 0 0 20 0 10 0 118620866 1079148544 69737 18446744073709551615 4194304 4228012 140734374818000 140734374809024 140620433792629 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/14951/statm: 263464 69737 2367 9 0 250814 0
[pid=14951/tid=14952] ppid=14948 vsize=1053856 CPUtime=1.57
/proc/14951/task/14952/stat : 14952 (java) R 14948 14948 1750 0 -1 4202560 47410 0 0 0 138 19 0 0 20 0 10 0 118620867 1079148544 69737 18446744073709551615 4194304 4228012 140734374818000 140620440318656 140620338124682 0 4 0 16800975 0 0 0 -1 0 0 0 1 0 0
[pid=14951/tid=14953] ppid=14948 vsize=1053856 CPUtime=0.18
/proc/14951/task/14953/stat : 14953 (java) S 14948 14948 1750 0 -1 4202560 8498 0 0 0 16 2 0 0 20 0 10 0 118620870 1079148544 69737 18446744073709551615 4194304 4228012 140734374818000 140620332964992 140620433806923 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14954] ppid=14948 vsize=1053856 CPUtime=0
/proc/14951/task/14954/stat : 14954 (java) S 14948 14948 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 118620871 1079148544 69737 18446744073709551615 4194304 4228012 140734374818000 140620331911184 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14955] ppid=14948 vsize=1053856 CPUtime=0
/proc/14951/task/14955/stat : 14955 (java) S 14948 14948 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 10 0 118620871 1079148544 69737 18446744073709551615 4194304 4228012 140734374818000 140620330858400 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14956] ppid=14948 vsize=1053856 CPUtime=0
/proc/14951/task/14956/stat : 14956 (java) S 14948 14948 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 118620874 1079148544 69737 18446744073709551615 4194304 4228012 140734374818000 140620329806832 140620433814560 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14957] ppid=14948 vsize=1053856 CPUtime=0.63
/proc/14951/task/14957/stat : 14957 (java) S 14948 14948 1750 0 -1 4202560 9843 0 0 0 59 4 0 0 20 0 10 0 118620874 1079148544 69737 18446744073709551615 4194304 4228012 140734374818000 140620328754192 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14958] ppid=14948 vsize=1053856 CPUtime=0.62
/proc/14951/task/14958/stat : 14958 (java) S 14948 14948 1750 0 -1 4202560 7900 0 0 0 58 4 0 0 20 0 10 0 118620874 1079148544 69737 18446744073709551615 4194304 4228012 140734374818000 140620327701520 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14959] ppid=14948 vsize=1053856 CPUtime=0
/proc/14951/task/14959/stat : 14959 (java) S 14948 14948 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 118620874 1079148544 69737 18446744073709551615 4194304 4228012 140734374818000 140620326649040 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14960] ppid=14948 vsize=1053856 CPUtime=0
/proc/14951/task/14960/stat : 14960 (java) S 14948 14948 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 118620874 1079148544 69737 18446744073709551615 4194304 4228012 140734374818000 140620325596544 140620433806923 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 3.04
Current children cumulated vsize (KiB) 1063024

[startup+6.30077 s]
/proc/loadavg: 1.01 1.06 1.01 2/70 14960
/proc/meminfo: memFree=292652/1022884 swapFree=0/0
[pid=14948] ppid=14947 vsize=9168 CPUtime=0
/proc/14948/stat : 14948 (p2cudf-full-1.1) S 14947 14948 1750 0 -1 4202496 455 291 0 0 0 0 0 0 20 0 1 0 118620865 9388032 330 18446744073709551615 4194304 5129932 140736468356240 140736468354384 139751327761502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/14948/statm: 2292 330 280 229 0 52 0
[pid=14951] ppid=14948 vsize=1041768 CPUtime=6.19
/proc/14951/stat : 14951 (java) S 14948 14948 1750 0 -1 4202496 116489 0 0 0 574 45 0 0 20 0 10 0 118620866 1066770432 106324 18446744073709551615 4194304 4228012 140734374818000 140734374809024 140620433792629 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/14951/statm: 260442 106324 2370 9 0 247792 0
[pid=14951/tid=14952] ppid=14948 vsize=1041768 CPUtime=3.23
/proc/14951/task/14952/stat : 14952 (java) R 14948 14948 1750 0 -1 4202560 47479 0 0 0 302 21 0 0 20 0 10 0 118620867 1066770432 106324 18446744073709551615 4194304 4228012 140734374818000 140620440327384 140620337788398 0 4 0 16800975 0 0 0 -1 0 0 0 1 0 0
[pid=14951/tid=14953] ppid=14948 vsize=1041768 CPUtime=1.12
/proc/14951/task/14953/stat : 14953 (java) S 14948 14948 1750 0 -1 4202560 47752 0 0 0 99 13 0 0 20 0 10 0 118620870 1066770432 106324 18446744073709551615 4194304 4228012 140734374818000 140620332964992 140620433806923 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14954] ppid=14948 vsize=1041768 CPUtime=0
/proc/14951/task/14954/stat : 14954 (java) S 14948 14948 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 118620871 1066770432 106324 18446744073709551615 4194304 4228012 140734374818000 140620331911184 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14955] ppid=14948 vsize=1041768 CPUtime=0
/proc/14951/task/14955/stat : 14955 (java) S 14948 14948 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 10 0 118620871 1066770432 106324 18446744073709551615 4194304 4228012 140734374818000 140620330858400 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14956] ppid=14948 vsize=1041768 CPUtime=0
/proc/14951/task/14956/stat : 14956 (java) S 14948 14948 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 118620874 1066770432 106324 18446744073709551615 4194304 4228012 140734374818000 140620329806832 140620433814560 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14957] ppid=14948 vsize=1041768 CPUtime=0.89
/proc/14951/task/14957/stat : 14957 (java) R 14948 14948 1750 0 -1 4202560 11996 0 0 0 84 5 0 0 20 0 10 0 118620874 1066770432 106324 18446744073709551615 4194304 4228012 140734374818000 140620328753936 140620416019425 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14958] ppid=14948 vsize=1041768 CPUtime=0.9
/proc/14951/task/14958/stat : 14958 (java) R 14948 14948 1750 0 -1 4202560 7969 0 0 0 86 4 0 0 20 0 10 0 118620874 1066770432 106324 18446744073709551615 4194304 4228012 140734374818000 140620327701264 140620419476352 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14959] ppid=14948 vsize=1041768 CPUtime=0
/proc/14951/task/14959/stat : 14959 (java) S 14948 14948 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 118620874 1066770432 106324 18446744073709551615 4194304 4228012 140734374818000 140620326649040 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14960] ppid=14948 vsize=1041768 CPUtime=0
/proc/14951/task/14960/stat : 14960 (java) S 14948 14948 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 118620874 1066770432 106324 18446744073709551615 4194304 4228012 140734374818000 140620325596544 140620433806923 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 6.19
Current children cumulated vsize (KiB) 1050936

[startup+12.7008 s]
/proc/loadavg: 1.01 1.06 1.01 2/71 14961
/proc/meminfo: memFree=248004/1022884 swapFree=0/0
[pid=14948] ppid=14947 vsize=9168 CPUtime=0
/proc/14948/stat : 14948 (p2cudf-full-1.1) S 14947 14948 1750 0 -1 4202496 455 291 0 0 0 0 0 0 20 0 1 0 118620865 9388032 330 18446744073709551615 4194304 5129932 140736468356240 140736468354384 139751327761502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/14948/statm: 2292 330 280 229 0 52 0
[pid=14951] ppid=14948 vsize=1045952 CPUtime=12.51
/proc/14951/stat : 14951 (java) S 14948 14948 1750 0 -1 4202496 128661 0 0 0 1201 50 0 0 20 0 11 0 118620866 1071054848 115623 18446744073709551615 4194304 4228012 140734374818000 140734374809024 140620433792629 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/14951/statm: 261488 115623 2381 9 0 248838 0
[pid=14951/tid=14952] ppid=14948 vsize=1045952 CPUtime=6.48
/proc/14951/task/14952/stat : 14952 (java) R 14948 14948 1750 0 -1 4202560 47799 0 0 0 626 22 0 0 20 0 11 0 118620867 1071054848 115623 18446744073709551615 4194304 4228012 140734374818000 140620440326152 140620339214640 0 4 0 16800975 0 0 0 -1 0 0 0 1 0 0
[pid=14951/tid=14953] ppid=14948 vsize=1045952 CPUtime=1.36
/proc/14951/task/14953/stat : 14953 (java) S 14948 14948 1750 0 -1 4202560 55005 0 0 0 120 16 0 0 20 0 11 0 118620870 1071054848 115623 18446744073709551615 4194304 4228012 140734374818000 140620332964992 140620433806923 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14954] ppid=14948 vsize=1045952 CPUtime=0
/proc/14951/task/14954/stat : 14954 (java) S 14948 14948 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 118620871 1071054848 115623 18446744073709551615 4194304 4228012 140734374818000 140620331911184 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14955] ppid=14948 vsize=1045952 CPUtime=0
/proc/14951/task/14955/stat : 14955 (java) S 14948 14948 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 118620871 1071054848 115623 18446744073709551615 4194304 4228012 140734374818000 140620330858400 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14956] ppid=14948 vsize=1045952 CPUtime=0
/proc/14951/task/14956/stat : 14956 (java) S 14948 14948 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 118620874 1071054848 115623 18446744073709551615 4194304 4228012 140734374818000 140620329806832 140620433814560 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14957] ppid=14948 vsize=1045952 CPUtime=2.32
/proc/14951/task/14957/stat : 14957 (java) S 14948 14948 1750 0 -1 4202560 15986 0 0 0 227 5 0 0 20 0 11 0 118620874 1071054848 115623 18446744073709551615 4194304 4228012 140734374818000 140620328754192 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14958] ppid=14948 vsize=1045952 CPUtime=2.28
/proc/14951/task/14958/stat : 14958 (java) S 14948 14948 1750 0 -1 4202560 8572 0 0 0 224 4 0 0 20 0 11 0 118620874 1071054848 115623 18446744073709551615 4194304 4228012 140734374818000 140620327701520 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14959] ppid=14948 vsize=1045952 CPUtime=0
/proc/14951/task/14959/stat : 14959 (java) S 14948 14948 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118620874 1071054848 115623 18446744073709551615 4194304 4228012 140734374818000 140620326649040 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14960] ppid=14948 vsize=1045952 CPUtime=0
/proc/14951/task/14960/stat : 14960 (java) S 14948 14948 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118620874 1071054848 115623 18446744073709551615 4194304 4228012 140734374818000 140620325596544 140620433806923 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14961] ppid=14948 vsize=1045952 CPUtime=0
/proc/14951/task/14961/stat : 14961 (java) S 14948 14948 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118621873 1071054848 115623 18446744073709551615 4194304 4228012 140734374818000 140620324398944 140620433806923 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 12.51
Current children cumulated vsize (KiB) 1055120

[startup+25.5009 s]
/proc/loadavg: 1.01 1.05 1.01 2/71 14961
/proc/meminfo: memFree=189972/1022884 swapFree=0/0
[pid=14948] ppid=14947 vsize=9168 CPUtime=0
/proc/14948/stat : 14948 (p2cudf-full-1.1) S 14947 14948 1750 0 -1 4202496 455 291 0 0 0 0 0 0 20 0 1 0 118620865 9388032 330 18446744073709551615 4194304 5129932 140736468356240 140736468354384 139751327761502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/14948/statm: 2292 330 280 229 0 52 0
[pid=14951] ppid=14948 vsize=1040536 CPUtime=25.12
/proc/14951/stat : 14951 (java) S 14948 14948 1750 0 -1 4202496 144150 0 0 0 2457 55 0 0 20 0 11 0 118620866 1065508864 130084 18446744073709551615 4194304 4228012 140734374818000 140734374809024 140620433792629 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/14951/statm: 260134 130084 2393 9 0 247484 0
[pid=14951/tid=14952] ppid=14948 vsize=1040536 CPUtime=17.16
/proc/14951/task/14952/stat : 14952 (java) R 14948 14948 1750 0 -1 4202560 47802 0 0 0 1693 23 0 0 20 0 11 0 118620867 1065508864 130084 18446744073709551615 4194304 4228012 140734374818000 140620440326120 140620339177584 0 4 0 16800975 0 0 0 -1 0 0 0 1 0 0
[pid=14951/tid=14953] ppid=14948 vsize=1040536 CPUtime=3.15
/proc/14951/task/14953/stat : 14953 (java) S 14948 14948 1750 0 -1 4202560 70488 0 0 0 295 20 0 0 20 0 11 0 118620870 1065508864 130084 18446744073709551615 4194304 4228012 140734374818000 140620332964992 140620433806923 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14954] ppid=14948 vsize=1040536 CPUtime=0
/proc/14951/task/14954/stat : 14954 (java) S 14948 14948 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 118620871 1065508864 130084 18446744073709551615 4194304 4228012 140734374818000 140620331911184 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14955] ppid=14948 vsize=1040536 CPUtime=0
/proc/14951/task/14955/stat : 14955 (java) S 14948 14948 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 118620871 1065508864 130084 18446744073709551615 4194304 4228012 140734374818000 140620330858400 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14956] ppid=14948 vsize=1040536 CPUtime=0
/proc/14951/task/14956/stat : 14956 (java) S 14948 14948 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 118620874 1065508864 130084 18446744073709551615 4194304 4228012 140734374818000 140620329806832 140620433814560 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14957] ppid=14948 vsize=1040536 CPUtime=2.4
/proc/14951/task/14957/stat : 14957 (java) S 14948 14948 1750 0 -1 4202560 15989 0 0 0 235 5 0 0 20 0 11 0 118620874 1065508864 130084 18446744073709551615 4194304 4228012 140734374818000 140620328754192 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14958] ppid=14948 vsize=1040536 CPUtime=2.35
/proc/14951/task/14958/stat : 14958 (java) S 14948 14948 1750 0 -1 4202560 8572 0 0 0 231 4 0 0 20 0 11 0 118620874 1065508864 130084 18446744073709551615 4194304 4228012 140734374818000 140620327701520 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14959] ppid=14948 vsize=1040536 CPUtime=0
/proc/14951/task/14959/stat : 14959 (java) S 14948 14948 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118620874 1065508864 130084 18446744073709551615 4194304 4228012 140734374818000 140620326649040 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14960] ppid=14948 vsize=1040536 CPUtime=0.02
/proc/14951/task/14960/stat : 14960 (java) S 14948 14948 1750 0 -1 4202560 0 0 0 0 1 1 0 0 20 0 11 0 118620874 1065508864 130084 18446744073709551615 4194304 4228012 140734374818000 140620325596544 140620433806923 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14961] ppid=14948 vsize=1040536 CPUtime=0
/proc/14951/task/14961/stat : 14961 (java) S 14948 14948 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118621873 1065508864 130084 18446744073709551615 4194304 4228012 140734374818000 140620324398944 140620433806923 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 25.12
Current children cumulated vsize (KiB) 1049704

[startup+51.1008 s]
/proc/loadavg: 1.00 1.05 1.01 2/71 14961
/proc/meminfo: memFree=154880/1022884 swapFree=0/0
[pid=14948] ppid=14947 vsize=9168 CPUtime=0
/proc/14948/stat : 14948 (p2cudf-full-1.1) S 14947 14948 1750 0 -1 4202496 455 291 0 0 0 0 0 0 20 0 1 0 118620865 9388032 330 18446744073709551615 4194304 5129932 140736468356240 140736468354384 139751327761502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/14948/statm: 2292 330 280 229 0 52 0
[pid=14951] ppid=14948 vsize=1040536 CPUtime=50.37
/proc/14951/stat : 14951 (java) S 14948 14948 1750 0 -1 4202496 152884 0 0 0 4981 56 0 0 20 0 11 0 118620866 1065508864 138814 18446744073709551615 4194304 4228012 140734374818000 140734374809024 140620433792629 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/14951/statm: 260134 138814 2393 9 0 247484 0
[pid=14951/tid=14952] ppid=14948 vsize=1040536 CPUtime=38.77
/proc/14951/task/14952/stat : 14952 (java) R 14948 14948 1750 0 -1 4202560 47802 0 0 0 3853 24 0 0 20 0 11 0 118620867 1065508864 138814 18446744073709551615 4194304 4228012 140734374818000 140620440326120 140620337791017 0 4 0 16800975 0 0 0 -1 0 0 0 1 0 0
[pid=14951/tid=14953] ppid=14948 vsize=1040536 CPUtime=6.65
/proc/14951/task/14953/stat : 14953 (java) S 14948 14948 1750 0 -1 4202560 79216 0 0 0 644 21 0 0 20 0 11 0 118620870 1065508864 138814 18446744073709551615 4194304 4228012 140734374818000 140620332964992 140620433806923 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14954] ppid=14948 vsize=1040536 CPUtime=0
/proc/14951/task/14954/stat : 14954 (java) S 14948 14948 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 118620871 1065508864 138814 18446744073709551615 4194304 4228012 140734374818000 140620331911184 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14955] ppid=14948 vsize=1040536 CPUtime=0
/proc/14951/task/14955/stat : 14955 (java) S 14948 14948 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 118620871 1065508864 138814 18446744073709551615 4194304 4228012 140734374818000 140620330858400 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14956] ppid=14948 vsize=1040536 CPUtime=0
/proc/14951/task/14956/stat : 14956 (java) S 14948 14948 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 118620874 1065508864 138814 18446744073709551615 4194304 4228012 140734374818000 140620329806832 140620433814560 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14957] ppid=14948 vsize=1040536 CPUtime=2.45
/proc/14951/task/14957/stat : 14957 (java) S 14948 14948 1750 0 -1 4202560 15991 0 0 0 240 5 0 0 20 0 11 0 118620874 1065508864 138814 18446744073709551615 4194304 4228012 140734374818000 140620328754192 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14958] ppid=14948 vsize=1040536 CPUtime=2.42
/proc/14951/task/14958/stat : 14958 (java) S 14948 14948 1750 0 -1 4202560 8573 0 0 0 238 4 0 0 20 0 11 0 118620874 1065508864 138814 18446744073709551615 4194304 4228012 140734374818000 140620327701520 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14959] ppid=14948 vsize=1040536 CPUtime=0
/proc/14951/task/14959/stat : 14959 (java) S 14948 14948 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118620874 1065508864 138814 18446744073709551615 4194304 4228012 140734374818000 140620326649040 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14960] ppid=14948 vsize=1040536 CPUtime=0.03
/proc/14951/task/14960/stat : 14960 (java) S 14948 14948 1750 0 -1 4202560 3 0 0 0 1 2 0 0 20 0 11 0 118620874 1065508864 138814 18446744073709551615 4194304 4228012 140734374818000 140620325596544 140620433806923 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14961] ppid=14948 vsize=1040536 CPUtime=0
/proc/14951/task/14961/stat : 14961 (java) S 14948 14948 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118621873 1065508864 138814 18446744073709551615 4194304 4228012 140734374818000 140620324398944 140620433806923 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 50.37
Current children cumulated vsize (KiB) 1049704

[startup+102.301 s]
/proc/loadavg: 1.00 1.04 1.00 2/71 14969
/proc/meminfo: memFree=107016/1022884 swapFree=0/0
[pid=14948] ppid=14947 vsize=9168 CPUtime=0
/proc/14948/stat : 14948 (p2cudf-full-1.1) S 14947 14948 1750 0 -1 4202496 455 291 0 0 0 0 0 0 20 0 1 0 118620865 9388032 330 18446744073709551615 4194304 5129932 140736468356240 140736468354384 139751327761502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/14948/statm: 2292 330 280 229 0 52 0
[pid=14951] ppid=14948 vsize=1040536 CPUtime=100.94
/proc/14951/stat : 14951 (java) S 14948 14948 1750 0 -1 4202496 164711 0 0 0 10035 59 0 0 20 0 11 0 118620866 1065508864 150637 18446744073709551615 4194304 4228012 140734374818000 140734374809024 140620433792629 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/14951/statm: 260134 150637 2393 9 0 247484 0
[pid=14951/tid=14952] ppid=14948 vsize=1040536 CPUtime=84.96
/proc/14951/task/14952/stat : 14952 (java) R 14948 14948 1750 0 -1 4202560 47802 0 0 0 8472 24 0 0 20 0 11 0 118620867 1065508864 150637 18446744073709551615 4194304 4228012 140734374818000 140620440326120 140620339242530 0 4 0 16800975 0 0 0 -1 0 0 0 4 0 0
[pid=14951/tid=14953] ppid=14948 vsize=1040536 CPUtime=10.98
/proc/14951/task/14953/stat : 14953 (java) S 14948 14948 1750 0 -1 4202560 91036 0 0 0 1074 24 0 0 20 0 11 0 118620870 1065508864 150637 18446744073709551615 4194304 4228012 140734374818000 140620332964992 140620433806923 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14954] ppid=14948 vsize=1040536 CPUtime=0
/proc/14951/task/14954/stat : 14954 (java) S 14948 14948 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 118620871 1065508864 150637 18446744073709551615 4194304 4228012 140734374818000 140620331911184 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14955] ppid=14948 vsize=1040536 CPUtime=0
/proc/14951/task/14955/stat : 14955 (java) S 14948 14948 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 118620871 1065508864 150637 18446744073709551615 4194304 4228012 140734374818000 140620330858400 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14956] ppid=14948 vsize=1040536 CPUtime=0
/proc/14951/task/14956/stat : 14956 (java) S 14948 14948 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 118620874 1065508864 150637 18446744073709551615 4194304 4228012 140734374818000 140620329806832 140620433814560 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14957] ppid=14948 vsize=1040536 CPUtime=2.48
/proc/14951/task/14957/stat : 14957 (java) S 14948 14948 1750 0 -1 4202560 15995 0 0 0 243 5 0 0 20 0 11 0 118620874 1065508864 150637 18446744073709551615 4194304 4228012 140734374818000 140620328754192 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14958] ppid=14948 vsize=1040536 CPUtime=2.42
/proc/14951/task/14958/stat : 14958 (java) S 14948 14948 1750 0 -1 4202560 8573 0 0 0 238 4 0 0 20 0 11 0 118620874 1065508864 150637 18446744073709551615 4194304 4228012 140734374818000 140620327701520 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14959] ppid=14948 vsize=1040536 CPUtime=0
/proc/14951/task/14959/stat : 14959 (java) S 14948 14948 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118620874 1065508864 150637 18446744073709551615 4194304 4228012 140734374818000 140620326649040 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14960] ppid=14948 vsize=1040536 CPUtime=0.05
/proc/14951/task/14960/stat : 14960 (java) S 14948 14948 1750 0 -1 4202560 6 0 0 0 2 3 0 0 20 0 11 0 118620874 1065508864 150637 18446744073709551615 4194304 4228012 140734374818000 140620325596544 140620433806923 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14961] ppid=14948 vsize=1040536 CPUtime=0
/proc/14951/task/14961/stat : 14961 (java) S 14948 14948 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118621873 1065508864 150637 18446744073709551615 4194304 4228012 140734374818000 140620324398944 140620433806923 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 100.94
Current children cumulated vsize (KiB) 1049704

[startup+162.301 s]
/proc/loadavg: 1.05 1.04 1.00 2/71 14969
/proc/meminfo: memFree=69444/1022884 swapFree=0/0
[pid=14948] ppid=14947 vsize=9168 CPUtime=0
/proc/14948/stat : 14948 (p2cudf-full-1.1) S 14947 14948 1750 0 -1 4202496 455 291 0 0 0 0 0 0 20 0 1 0 118620865 9388032 330 18446744073709551615 4194304 5129932 140736468356240 140736468354384 139751327761502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/14948/statm: 2292 330 280 229 0 52 0
[pid=14951] ppid=14948 vsize=1040536 CPUtime=160.33
/proc/14951/stat : 14951 (java) S 14948 14948 1750 0 -1 4202496 174093 0 0 0 15972 61 0 0 20 0 11 0 118620866 1065508864 160011 18446744073709551615 4194304 4228012 140734374818000 140734374809024 140620433792629 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/14951/statm: 260134 160011 2393 9 0 247484 0
[pid=14951/tid=14952] ppid=14948 vsize=1040536 CPUtime=141
/proc/14951/task/14952/stat : 14952 (java) R 14948 14948 1750 0 -1 4202560 47802 0 0 0 14076 24 0 0 20 0 11 0 118620867 1065508864 160011 18446744073709551615 4194304 4228012 140734374818000 140620440326120 140620339065043 0 4 0 16800975 0 0 0 -1 0 0 0 4 0 0
[pid=14951/tid=14953] ppid=14948 vsize=1040536 CPUtime=14.29
/proc/14951/task/14953/stat : 14953 (java) S 14948 14948 1750 0 -1 4202560 100412 0 0 0 1404 25 0 0 20 0 11 0 118620870 1065508864 160011 18446744073709551615 4194304 4228012 140734374818000 140620332964992 140620433806923 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14954] ppid=14948 vsize=1040536 CPUtime=0
/proc/14951/task/14954/stat : 14954 (java) S 14948 14948 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 118620871 1065508864 160011 18446744073709551615 4194304 4228012 140734374818000 140620331911184 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14955] ppid=14948 vsize=1040536 CPUtime=0
/proc/14951/task/14955/stat : 14955 (java) S 14948 14948 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 118620871 1065508864 160011 18446744073709551615 4194304 4228012 140734374818000 140620330858400 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14956] ppid=14948 vsize=1040536 CPUtime=0
/proc/14951/task/14956/stat : 14956 (java) S 14948 14948 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 118620874 1065508864 160011 18446744073709551615 4194304 4228012 140734374818000 140620329806832 140620433814560 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14957] ppid=14948 vsize=1040536 CPUtime=2.48
/proc/14951/task/14957/stat : 14957 (java) S 14948 14948 1750 0 -1 4202560 15995 0 0 0 243 5 0 0 20 0 11 0 118620874 1065508864 160011 18446744073709551615 4194304 4228012 140734374818000 140620328754192 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14958] ppid=14948 vsize=1040536 CPUtime=2.42
/proc/14951/task/14958/stat : 14958 (java) S 14948 14948 1750 0 -1 4202560 8573 0 0 0 238 4 0 0 20 0 11 0 118620874 1065508864 160011 18446744073709551615 4194304 4228012 140734374818000 140620327701520 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14959] ppid=14948 vsize=1040536 CPUtime=0
/proc/14951/task/14959/stat : 14959 (java) S 14948 14948 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118620874 1065508864 160011 18446744073709551615 4194304 4228012 140734374818000 140620326649040 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14960] ppid=14948 vsize=1040536 CPUtime=0.08
/proc/14951/task/14960/stat : 14960 (java) S 14948 14948 1750 0 -1 4202560 12 0 0 0 4 4 0 0 20 0 11 0 118620874 1065508864 160011 18446744073709551615 4194304 4228012 140734374818000 140620325596544 140620433806923 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14961] ppid=14948 vsize=1040536 CPUtime=0
/proc/14951/task/14961/stat : 14961 (java) S 14948 14948 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118621873 1065508864 160011 18446744073709551615 4194304 4228012 140734374818000 140620324398944 140620433806923 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 160.33
Current children cumulated vsize (KiB) 1049704

[startup+222.304 s]
/proc/loadavg: 1.02 1.03 1.00 2/71 14969
/proc/meminfo: memFree=50224/1022884 swapFree=0/0
[pid=14948] ppid=14947 vsize=9168 CPUtime=0
/proc/14948/stat : 14948 (p2cudf-full-1.1) S 14947 14948 1750 0 -1 4202496 455 291 0 0 0 0 0 0 20 0 1 0 118620865 9388032 330 18446744073709551615 4194304 5129932 140736468356240 140736468354384 139751327761502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/14948/statm: 2292 330 280 229 0 52 0
[pid=14951] ppid=14948 vsize=1040536 CPUtime=219.72
/proc/14951/stat : 14951 (java) S 14948 14948 1750 0 -1 4202496 178894 0 0 0 21910 62 0 0 20 0 11 0 118620866 1065508864 164804 18446744073709551615 4194304 4228012 140734374818000 140734374809024 140620433792629 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/14951/statm: 260134 164804 2393 9 0 247484 0
[pid=14951/tid=14952] ppid=14948 vsize=1040536 CPUtime=197.52
/proc/14951/task/14952/stat : 14952 (java) R 14948 14948 1750 0 -1 4202560 47802 0 0 0 19728 24 0 0 20 0 11 0 118620867 1065508864 164804 18446744073709551615 4194304 4228012 140734374818000 140620440326120 140620339073150 0 4 0 16800975 0 0 0 -1 0 0 0 4 0 0
[pid=14951/tid=14953] ppid=14948 vsize=1040536 CPUtime=17.14
/proc/14951/task/14953/stat : 14953 (java) S 14948 14948 1750 0 -1 4202560 105207 0 0 0 1688 26 0 0 20 0 11 0 118620870 1065508864 164804 18446744073709551615 4194304 4228012 140734374818000 140620332964992 140620433806923 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14954] ppid=14948 vsize=1040536 CPUtime=0
/proc/14951/task/14954/stat : 14954 (java) S 14948 14948 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 118620871 1065508864 164804 18446744073709551615 4194304 4228012 140734374818000 140620331911184 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14955] ppid=14948 vsize=1040536 CPUtime=0
/proc/14951/task/14955/stat : 14955 (java) S 14948 14948 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 118620871 1065508864 164804 18446744073709551615 4194304 4228012 140734374818000 140620330858400 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14956] ppid=14948 vsize=1040536 CPUtime=0
/proc/14951/task/14956/stat : 14956 (java) S 14948 14948 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 118620874 1065508864 164804 18446744073709551615 4194304 4228012 140734374818000 140620329806832 140620433814560 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14957] ppid=14948 vsize=1040536 CPUtime=2.48
/proc/14951/task/14957/stat : 14957 (java) S 14948 14948 1750 0 -1 4202560 15995 0 0 0 243 5 0 0 20 0 11 0 118620874 1065508864 164804 18446744073709551615 4194304 4228012 140734374818000 140620328754192 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14958] ppid=14948 vsize=1040536 CPUtime=2.42
/proc/14951/task/14958/stat : 14958 (java) S 14948 14948 1750 0 -1 4202560 8573 0 0 0 238 4 0 0 20 0 11 0 118620874 1065508864 164804 18446744073709551615 4194304 4228012 140734374818000 140620327701520 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14959] ppid=14948 vsize=1040536 CPUtime=0
/proc/14951/task/14959/stat : 14959 (java) S 14948 14948 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118620874 1065508864 164804 18446744073709551615 4194304 4228012 140734374818000 140620326649040 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14960] ppid=14948 vsize=1040536 CPUtime=0.1
/proc/14951/task/14960/stat : 14960 (java) S 14948 14948 1750 0 -1 4202560 18 0 0 0 5 5 0 0 20 0 11 0 118620874 1065508864 164804 18446744073709551615 4194304 4228012 140734374818000 140620325596544 140620433806923 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14961] ppid=14948 vsize=1040536 CPUtime=0
/proc/14951/task/14961/stat : 14961 (java) S 14948 14948 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118621873 1065508864 164804 18446744073709551615 4194304 4228012 140734374818000 140620324398944 140620433806923 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 219.72
Current children cumulated vsize (KiB) 1049704

[startup+282.301 s]
/proc/loadavg: 1.00 1.02 1.00 2/71 14969
/proc/meminfo: memFree=9928/1022884 swapFree=0/0
[pid=14948] ppid=14947 vsize=9168 CPUtime=0
/proc/14948/stat : 14948 (p2cudf-full-1.1) S 14947 14948 1750 0 -1 4202496 455 291 0 0 0 0 0 0 20 0 1 0 118620865 9388032 330 18446744073709551615 4194304 5129932 140736468356240 140736468354384 139751327761502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/14948/statm: 2292 330 280 229 0 52 0
[pid=14951] ppid=14948 vsize=1051592 CPUtime=279.03
/proc/14951/stat : 14951 (java) S 14948 14948 1750 0 -1 4202496 212572 0 0 0 27830 73 0 0 20 0 11 0 118620866 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140734374809024 140620433792629 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/14951/statm: 262898 184633 2393 9 0 250248 0
[pid=14951/tid=14952] ppid=14948 vsize=1051592 CPUtime=252.2
/proc/14951/task/14952/stat : 14952 (java) R 14948 14948 1750 0 -1 4202560 47802 0 0 0 25196 24 0 0 20 0 11 0 118620867 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620440326120 140620339065060 0 4 0 16800975 0 0 0 -1 0 0 0 4 0 0
[pid=14951/tid=14953] ppid=14948 vsize=1051592 CPUtime=21.72
/proc/14951/task/14953/stat : 14953 (java) S 14948 14948 1750 0 -1 4202560 138876 0 0 0 2134 38 0 0 20 0 11 0 118620870 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620332964992 140620433806923 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14954] ppid=14948 vsize=1051592 CPUtime=0
/proc/14951/task/14954/stat : 14954 (java) S 14948 14948 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 118620871 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620331911184 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14955] ppid=14948 vsize=1051592 CPUtime=0
/proc/14951/task/14955/stat : 14955 (java) S 14948 14948 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 118620871 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620330858400 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14956] ppid=14948 vsize=1051592 CPUtime=0
/proc/14951/task/14956/stat : 14956 (java) S 14948 14948 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 118620874 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620329806832 140620433814560 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14957] ppid=14948 vsize=1051592 CPUtime=2.48
/proc/14951/task/14957/stat : 14957 (java) S 14948 14948 1750 0 -1 4202560 15995 0 0 0 243 5 0 0 20 0 11 0 118620874 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620328754192 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14958] ppid=14948 vsize=1051592 CPUtime=2.44
/proc/14951/task/14958/stat : 14958 (java) S 14948 14948 1750 0 -1 4202560 8576 0 0 0 240 4 0 0 20 0 11 0 118620874 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620327701520 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14959] ppid=14948 vsize=1051592 CPUtime=0
/proc/14951/task/14959/stat : 14959 (java) S 14948 14948 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118620874 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620326649040 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14960] ppid=14948 vsize=1051592 CPUtime=0.13
/proc/14951/task/14960/stat : 14960 (java) S 14948 14948 1750 0 -1 4202560 24 0 0 0 6 7 0 0 20 0 11 0 118620874 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620325596544 140620433806923 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14961] ppid=14948 vsize=1051592 CPUtime=0
/proc/14951/task/14961/stat : 14961 (java) S 14948 14948 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118621873 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620324398944 140620433806923 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 279.03
Current children cumulated vsize (KiB) 1060760

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

[startup+288.001 s]
/proc/loadavg: 1.00 1.02 1.00 2/71 14969
/proc/meminfo: memFree=9804/1022884 swapFree=0/0
[pid=14948] ppid=14947 vsize=9168 CPUtime=0
/proc/14948/stat : 14948 (p2cudf-full-1.1) S 14947 14948 1750 0 -1 4202496 455 291 0 0 0 0 0 0 20 0 1 0 118620865 9388032 330 18446744073709551615 4194304 5129932 140736468356240 140736468354384 139751327761502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/14948/statm: 2292 330 280 229 0 52 0
[pid=14951] ppid=14948 vsize=1051592 CPUtime=284.67
/proc/14951/stat : 14951 (java) S 14948 14948 1750 0 -1 4202496 212572 0 0 0 28394 73 0 0 20 0 11 0 118620866 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140734374809024 140620433792629 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/14951/statm: 262898 184633 2393 9 0 250248 0
[pid=14951/tid=14952] ppid=14948 vsize=1051592 CPUtime=257.84
/proc/14951/task/14952/stat : 14952 (java) R 14948 14948 1750 0 -1 4202560 47802 0 0 0 25760 24 0 0 20 0 11 0 118620867 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620440326120 140620337790970 0 4 0 16800975 0 0 0 -1 0 0 0 4 0 0
[pid=14951/tid=14953] ppid=14948 vsize=1051592 CPUtime=21.72
/proc/14951/task/14953/stat : 14953 (java) S 14948 14948 1750 0 -1 4202560 138876 0 0 0 2134 38 0 0 20 0 11 0 118620870 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620332964992 140620433806923 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14954] ppid=14948 vsize=1051592 CPUtime=0
/proc/14951/task/14954/stat : 14954 (java) S 14948 14948 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 118620871 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620331911184 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14955] ppid=14948 vsize=1051592 CPUtime=0
/proc/14951/task/14955/stat : 14955 (java) S 14948 14948 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 118620871 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620330858400 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14956] ppid=14948 vsize=1051592 CPUtime=0
/proc/14951/task/14956/stat : 14956 (java) S 14948 14948 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 118620874 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620329806832 140620433814560 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14957] ppid=14948 vsize=1051592 CPUtime=2.48
/proc/14951/task/14957/stat : 14957 (java) S 14948 14948 1750 0 -1 4202560 15995 0 0 0 243 5 0 0 20 0 11 0 118620874 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620328754192 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14958] ppid=14948 vsize=1051592 CPUtime=2.44
/proc/14951/task/14958/stat : 14958 (java) S 14948 14948 1750 0 -1 4202560 8576 0 0 0 240 4 0 0 20 0 11 0 118620874 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620327701520 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14959] ppid=14948 vsize=1051592 CPUtime=0
/proc/14951/task/14959/stat : 14959 (java) S 14948 14948 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118620874 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620326649040 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14960] ppid=14948 vsize=1051592 CPUtime=0.14
/proc/14951/task/14960/stat : 14960 (java) S 14948 14948 1750 0 -1 4202560 24 0 0 0 7 7 0 0 20 0 11 0 118620874 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620325596544 140620433806923 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14961] ppid=14948 vsize=1051592 CPUtime=0
/proc/14951/task/14961/stat : 14961 (java) S 14948 14948 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118621873 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620324398944 140620433806923 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 284.67
Current children cumulated vsize (KiB) 1060760

[startup+291.201 s]
/proc/loadavg: 1.00 1.02 1.00 2/71 14969
/proc/meminfo: memFree=9804/1022884 swapFree=0/0
[pid=14948] ppid=14947 vsize=9168 CPUtime=0
/proc/14948/stat : 14948 (p2cudf-full-1.1) S 14947 14948 1750 0 -1 4202496 455 291 0 0 0 0 0 0 20 0 1 0 118620865 9388032 330 18446744073709551615 4194304 5129932 140736468356240 140736468354384 139751327761502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/14948/statm: 2292 330 280 229 0 52 0
[pid=14951] ppid=14948 vsize=1051592 CPUtime=287.83
/proc/14951/stat : 14951 (java) S 14948 14948 1750 0 -1 4202496 212572 0 0 0 28710 73 0 0 20 0 11 0 118620866 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140734374809024 140620433792629 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/14951/statm: 262898 184633 2393 9 0 250248 0
[pid=14951/tid=14952] ppid=14948 vsize=1051592 CPUtime=261.01
/proc/14951/task/14952/stat : 14952 (java) R 14948 14948 1750 0 -1 4202560 47802 0 0 0 26077 24 0 0 20 0 11 0 118620867 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620440326120 140620339065432 0 4 0 16800975 0 0 0 -1 0 0 0 4 0 0
[pid=14951/tid=14953] ppid=14948 vsize=1051592 CPUtime=21.72
/proc/14951/task/14953/stat : 14953 (java) S 14948 14948 1750 0 -1 4202560 138876 0 0 0 2134 38 0 0 20 0 11 0 118620870 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620332964992 140620433806923 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14954] ppid=14948 vsize=1051592 CPUtime=0
/proc/14951/task/14954/stat : 14954 (java) S 14948 14948 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 118620871 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620331911184 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14955] ppid=14948 vsize=1051592 CPUtime=0
/proc/14951/task/14955/stat : 14955 (java) S 14948 14948 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 118620871 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620330858400 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14956] ppid=14948 vsize=1051592 CPUtime=0
/proc/14951/task/14956/stat : 14956 (java) S 14948 14948 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 118620874 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620329806832 140620433814560 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14957] ppid=14948 vsize=1051592 CPUtime=2.48
/proc/14951/task/14957/stat : 14957 (java) S 14948 14948 1750 0 -1 4202560 15995 0 0 0 243 5 0 0 20 0 11 0 118620874 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620328754192 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14958] ppid=14948 vsize=1051592 CPUtime=2.44
/proc/14951/task/14958/stat : 14958 (java) S 14948 14948 1750 0 -1 4202560 8576 0 0 0 240 4 0 0 20 0 11 0 118620874 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620327701520 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14959] ppid=14948 vsize=1051592 CPUtime=0
/proc/14951/task/14959/stat : 14959 (java) S 14948 14948 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118620874 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620326649040 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14960] ppid=14948 vsize=1051592 CPUtime=0.14
/proc/14951/task/14960/stat : 14960 (java) S 14948 14948 1750 0 -1 4202560 24 0 0 0 7 7 0 0 20 0 11 0 118620874 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620325596544 140620433806923 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14961] ppid=14948 vsize=1051592 CPUtime=0
/proc/14951/task/14961/stat : 14961 (java) S 14948 14948 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118621873 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620324398944 140620433806923 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 287.83
Current children cumulated vsize (KiB) 1060760

[startup+294.401 s]
/proc/loadavg: 1.00 1.02 1.00 2/71 14969
/proc/meminfo: memFree=9680/1022884 swapFree=0/0
[pid=14948] ppid=14947 vsize=9168 CPUtime=0
/proc/14948/stat : 14948 (p2cudf-full-1.1) S 14947 14948 1750 0 -1 4202496 455 291 0 0 0 0 0 0 20 0 1 0 118620865 9388032 330 18446744073709551615 4194304 5129932 140736468356240 140736468354384 139751327761502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/14948/statm: 2292 330 280 229 0 52 0
[pid=14951] ppid=14948 vsize=1051592 CPUtime=291
/proc/14951/stat : 14951 (java) S 14948 14948 1750 0 -1 4202496 212572 0 0 0 29027 73 0 0 20 0 11 0 118620866 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140734374809024 140620433792629 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/14951/statm: 262898 184633 2393 9 0 250248 0
[pid=14951/tid=14952] ppid=14948 vsize=1051592 CPUtime=264.17
/proc/14951/task/14952/stat : 14952 (java) R 14948 14948 1750 0 -1 4202560 47802 0 0 0 26393 24 0 0 20 0 11 0 118620867 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620440326120 140620339223856 0 4 0 16800975 0 0 0 -1 0 0 0 4 0 0
[pid=14951/tid=14953] ppid=14948 vsize=1051592 CPUtime=21.72
/proc/14951/task/14953/stat : 14953 (java) S 14948 14948 1750 0 -1 4202560 138876 0 0 0 2134 38 0 0 20 0 11 0 118620870 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620332964992 140620433806923 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14954] ppid=14948 vsize=1051592 CPUtime=0
/proc/14951/task/14954/stat : 14954 (java) S 14948 14948 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 118620871 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620331911184 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14955] ppid=14948 vsize=1051592 CPUtime=0
/proc/14951/task/14955/stat : 14955 (java) S 14948 14948 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 118620871 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620330858400 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14956] ppid=14948 vsize=1051592 CPUtime=0
/proc/14951/task/14956/stat : 14956 (java) S 14948 14948 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 118620874 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620329806832 140620433814560 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14957] ppid=14948 vsize=1051592 CPUtime=2.48
/proc/14951/task/14957/stat : 14957 (java) S 14948 14948 1750 0 -1 4202560 15995 0 0 0 243 5 0 0 20 0 11 0 118620874 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620328754192 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14958] ppid=14948 vsize=1051592 CPUtime=2.44
/proc/14951/task/14958/stat : 14958 (java) S 14948 14948 1750 0 -1 4202560 8576 0 0 0 240 4 0 0 20 0 11 0 118620874 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620327701520 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14959] ppid=14948 vsize=1051592 CPUtime=0
/proc/14951/task/14959/stat : 14959 (java) S 14948 14948 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118620874 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620326649040 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14960] ppid=14948 vsize=1051592 CPUtime=0.14
/proc/14951/task/14960/stat : 14960 (java) S 14948 14948 1750 0 -1 4202560 24 0 0 0 7 7 0 0 20 0 11 0 118620874 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620325596544 140620433806923 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14961] ppid=14948 vsize=1051592 CPUtime=0
/proc/14951/task/14961/stat : 14961 (java) S 14948 14948 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118621873 1076830208 184633 18446744073709551615 4194304 4228012 140734374818000 140620324398944 140620433806923 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 291
Current children cumulated vsize (KiB) 1060760

[startup+295.201 s]
/proc/loadavg: 1.00 1.02 1.00 2/71 14969
/proc/meminfo: memFree=9680/1022884 swapFree=0/0
[pid=14948] ppid=14947 vsize=9168 CPUtime=0
/proc/14948/stat : 14948 (p2cudf-full-1.1) S 14947 14948 1750 0 -1 4202496 455 291 0 0 0 0 0 0 20 0 1 0 118620865 9388032 330 18446744073709551615 4194304 5129932 140736468356240 140736468354384 139751327761502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/14948/statm: 2292 330 280 229 0 52 0
[pid=14951] ppid=14948 vsize=1040504 CPUtime=291.8
/proc/14951/stat : 14951 (java) S 14948 14948 1750 0 -1 4202496 212572 0 0 0 29106 74 0 0 20 0 11 0 118620866 1065476096 181865 18446744073709551615 4194304 4228012 140734374818000 140734374809024 140620433792629 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/14951/statm: 260126 181865 2393 9 0 247476 0
[pid=14951/tid=14952] ppid=14948 vsize=1040504 CPUtime=264.86
/proc/14951/task/14952/stat : 14952 (java) S 14948 14948 1750 0 -1 4202560 47802 0 0 0 26462 24 0 0 20 0 11 0 118620867 1065476096 181865 18446744073709551615 4194304 4228012 140734374818000 140620440326432 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 4 0 0
[pid=14951/tid=14953] ppid=14948 vsize=1040504 CPUtime=21.82
/proc/14951/task/14953/stat : 14953 (java) R 14948 14948 1750 0 -1 4202560 138876 0 0 0 2144 38 0 0 20 0 11 0 118620870 1065476096 181865 18446744073709551615 4194304 4228012 140734374818000 140620332963656 140620418155005 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14954] ppid=14948 vsize=1040504 CPUtime=0
/proc/14951/task/14954/stat : 14954 (java) S 14948 14948 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 118620871 1065476096 181865 18446744073709551615 4194304 4228012 140734374818000 140620331911184 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14955] ppid=14948 vsize=1040504 CPUtime=0
/proc/14951/task/14955/stat : 14955 (java) S 14948 14948 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 118620871 1065476096 181865 18446744073709551615 4194304 4228012 140734374818000 140620330858400 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14956] ppid=14948 vsize=1040504 CPUtime=0
/proc/14951/task/14956/stat : 14956 (java) S 14948 14948 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 118620874 1065476096 181865 18446744073709551615 4194304 4228012 140734374818000 140620329806832 140620433814560 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14957] ppid=14948 vsize=1040504 CPUtime=2.49
/proc/14951/task/14957/stat : 14957 (java) S 14948 14948 1750 0 -1 4202560 15995 0 0 0 244 5 0 0 20 0 11 0 118620874 1065476096 181865 18446744073709551615 4194304 4228012 140734374818000 140620328738320 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14958] ppid=14948 vsize=1040504 CPUtime=2.44
/proc/14951/task/14958/stat : 14958 (java) S 14948 14948 1750 0 -1 4202560 8576 0 0 0 240 4 0 0 20 0 11 0 118620874 1065476096 181865 18446744073709551615 4194304 4228012 140734374818000 140620327701520 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14959] ppid=14948 vsize=1040504 CPUtime=0
/proc/14951/task/14959/stat : 14959 (java) S 14948 14948 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118620874 1065476096 181865 18446744073709551615 4194304 4228012 140734374818000 140620326649040 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14960] ppid=14948 vsize=1040504 CPUtime=0.14
/proc/14951/task/14960/stat : 14960 (java) S 14948 14948 1750 0 -1 4202560 24 0 0 0 7 7 0 0 20 0 11 0 118620874 1065476096 181865 18446744073709551615 4194304 4228012 140734374818000 140620325596544 140620433806923 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14961] ppid=14948 vsize=1040504 CPUtime=0
/proc/14951/task/14961/stat : 14961 (java) S 14948 14948 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118621873 1065476096 181865 18446744073709551615 4194304 4228012 140734374818000 140620324398928 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 291.8
Current children cumulated vsize (KiB) 1049672

[startup+296.005 s]
/proc/loadavg: 1.00 1.02 1.00 1/71 14970
/proc/meminfo: memFree=9556/1022884 swapFree=0/0
[pid=14948] ppid=14947 vsize=9168 CPUtime=0
/proc/14948/stat : 14948 (p2cudf-full-1.1) S 14947 14948 1750 0 -1 4202496 455 291 0 0 0 0 0 0 20 0 1 0 118620865 9388032 330 18446744073709551615 4194304 5129932 140736468356240 140736468354384 139751327761502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/14948/statm: 2292 330 280 229 0 52 0
[pid=14951] ppid=14948 vsize=1052752 CPUtime=292.43
/proc/14951/stat : 14951 (java) S 14948 14948 1750 0 -1 4202496 215382 0 0 0 29167 76 0 0 20 0 11 0 118620866 1078018048 184673 18446744073709551615 4194304 4228012 140734374818000 140734374809024 140620433792629 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/14951/statm: 263188 184673 2393 9 0 250538 0
[pid=14951/tid=14952] ppid=14948 vsize=1052752 CPUtime=264.88
/proc/14951/task/14952/stat : 14952 (java) S 14948 14948 1750 0 -1 4202560 47806 0 0 0 26464 24 0 0 20 0 11 0 118620867 1078018048 184673 18446744073709551615 4194304 4228012 140734374818000 140620440327088 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 4 0 0
[pid=14951/tid=14953] ppid=14948 vsize=1052752 CPUtime=22.42
/proc/14951/task/14953/stat : 14953 (java) S 14948 14948 1750 0 -1 4202560 141669 0 0 0 2201 41 0 0 20 0 11 0 118620870 1078018048 184673 18446744073709551615 4194304 4228012 140734374818000 140620332964992 140620433806923 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14954] ppid=14948 vsize=1052752 CPUtime=0
/proc/14951/task/14954/stat : 14954 (java) S 14948 14948 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 118620871 1078018048 184673 18446744073709551615 4194304 4228012 140734374818000 140620331911184 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14955] ppid=14948 vsize=1052752 CPUtime=0
/proc/14951/task/14955/stat : 14955 (java) S 14948 14948 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 118620871 1078018048 184673 18446744073709551615 4194304 4228012 140734374818000 140620330858400 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14956] ppid=14948 vsize=1052752 CPUtime=0
/proc/14951/task/14956/stat : 14956 (java) S 14948 14948 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 118620874 1078018048 184673 18446744073709551615 4194304 4228012 140734374818000 140620329806832 140620433814560 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14957] ppid=14948 vsize=1052752 CPUtime=2.49
/proc/14951/task/14957/stat : 14957 (java) S 14948 14948 1750 0 -1 4202560 15995 0 0 0 244 5 0 0 20 0 11 0 118620874 1078018048 184673 18446744073709551615 4194304 4228012 140734374818000 140620328754192 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14958] ppid=14948 vsize=1052752 CPUtime=2.46
/proc/14951/task/14958/stat : 14958 (java) S 14948 14948 1750 0 -1 4202560 8583 0 0 0 242 4 0 0 20 0 11 0 118620874 1078018048 184673 18446744073709551615 4194304 4228012 140734374818000 140620327701520 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14959] ppid=14948 vsize=1052752 CPUtime=0
/proc/14951/task/14959/stat : 14959 (java) S 14948 14948 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118620874 1078018048 184673 18446744073709551615 4194304 4228012 140734374818000 140620326649040 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14960] ppid=14948 vsize=1052752 CPUtime=0.14
/proc/14951/task/14960/stat : 14960 (java) S 14948 14948 1750 0 -1 4202560 24 0 0 0 7 7 0 0 20 0 11 0 118620874 1078018048 184673 18446744073709551615 4194304 4228012 140734374818000 140620325596544 140620433806923 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14970] ppid=14948 vsize=1052752 CPUtime=0
/proc/14951/task/14970/stat : 14970 (java) S 14948 14948 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118650449 1078018048 184673 18446744073709551615 4194304 4228012 140734374818000 140620323346608 140620433806923 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 292.43
Current children cumulated vsize (KiB) 1061920

[startup+296.401 s]
/proc/loadavg: 1.00 1.02 1.00 1/71 14970
/proc/meminfo: memFree=9556/1022884 swapFree=0/0
[pid=14948] ppid=14947 vsize=9168 CPUtime=0
/proc/14948/stat : 14948 (p2cudf-full-1.1) S 14947 14948 1750 0 -1 4202496 455 291 0 0 0 0 0 0 20 0 1 0 118620865 9388032 330 18446744073709551615 4194304 5129932 140736468356240 140736468354384 139751327761502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/14948/statm: 2292 330 280 229 0 52 0
[pid=14951] ppid=14948 vsize=1052752 CPUtime=292.49
/proc/14951/stat : 14951 (java) S 14948 14948 1750 0 -1 4202496 215384 0 0 0 29171 78 0 0 20 0 11 0 118620866 1078018048 184675 18446744073709551615 4194304 4228012 140734374818000 140734374809024 140620433792629 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/14951/statm: 263188 184675 2393 9 0 250538 0
[pid=14951/tid=14952] ppid=14948 vsize=1052752 CPUtime=264.88
/proc/14951/task/14952/stat : 14952 (java) S 14948 14948 1750 0 -1 4202560 47806 0 0 0 26464 24 0 0 20 0 11 0 118620867 1078018048 184675 18446744073709551615 4194304 4228012 140734374818000 140620440327088 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 4 0 0
[pid=14951/tid=14953] ppid=14948 vsize=1052752 CPUtime=22.42
/proc/14951/task/14953/stat : 14953 (java) S 14948 14948 1750 0 -1 4202560 141669 0 0 0 2201 41 0 0 20 0 11 0 118620870 1078018048 184675 18446744073709551615 4194304 4228012 140734374818000 140620332964992 140620433806923 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14954] ppid=14948 vsize=1052752 CPUtime=0
/proc/14951/task/14954/stat : 14954 (java) S 14948 14948 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 118620871 1078018048 184675 18446744073709551615 4194304 4228012 140734374818000 140620331911184 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14955] ppid=14948 vsize=1052752 CPUtime=0
/proc/14951/task/14955/stat : 14955 (java) S 14948 14948 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 118620871 1078018048 184675 18446744073709551615 4194304 4228012 140734374818000 140620330858400 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14956] ppid=14948 vsize=1052752 CPUtime=0
/proc/14951/task/14956/stat : 14956 (java) S 14948 14948 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 118620874 1078018048 184675 18446744073709551615 4194304 4228012 140734374818000 140620329806832 140620433814560 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14957] ppid=14948 vsize=1052752 CPUtime=2.49
/proc/14951/task/14957/stat : 14957 (java) S 14948 14948 1750 0 -1 4202560 15995 0 0 0 244 5 0 0 20 0 11 0 118620874 1078018048 184675 18446744073709551615 4194304 4228012 140734374818000 140620328754192 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14958] ppid=14948 vsize=1052752 CPUtime=2.46
/proc/14951/task/14958/stat : 14958 (java) S 14948 14948 1750 0 -1 4202560 8583 0 0 0 242 4 0 0 20 0 11 0 118620874 1078018048 184675 18446744073709551615 4194304 4228012 140734374818000 140620327701520 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14959] ppid=14948 vsize=1052752 CPUtime=0
/proc/14951/task/14959/stat : 14959 (java) S 14948 14948 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118620874 1078018048 184675 18446744073709551615 4194304 4228012 140734374818000 140620326649040 140620433806036 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14960] ppid=14948 vsize=1052752 CPUtime=0.14
/proc/14951/task/14960/stat : 14960 (java) S 14948 14948 1750 0 -1 4202560 24 0 0 0 7 7 0 0 20 0 11 0 118620874 1078018048 184675 18446744073709551615 4194304 4228012 140734374818000 140620325596544 140620433806923 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=14951/tid=14970] ppid=14948 vsize=1052752 CPUtime=0.05
/proc/14951/task/14970/stat : 14970 (java) R 14948 14948 1750 0 -1 4202560 8 0 0 0 3 2 0 0 20 0 11 0 118650449 1078018048 184675 18446744073709551615 4194304 4228012 140734374818000 140620323337408 140620337748415 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 292.49
Current children cumulated vsize (KiB) 1061920

[startup+296.52 s]
/proc/loadavg: 1.00 1.02 1.00 1/71 14970
/proc/meminfo: memFree=9556/1022884 swapFree=0/0
[pid=14948] ppid=14947 vsize=9168 CPUtime=0
/proc/14948/stat : 14948 (p2cudf-full-1.1) S 14947 14948 1750 0 -1 4202496 455 291 0 0 0 0 0 0 20 0 1 0 118620865 9388032 330 18446744073709551615 4194304 5129932 140736468356240 140736468354384 139751327761502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/14948/statm: 2292 330 280 229 0 52 0
[pid=14951] ppid=14948 vsize=0 CPUtime=292.61
/proc/14951/stat : 14951 (java) Z 14948 14948 1750 0 -1 4203532 215395 0 0 0 29179 82 0 0 20 0 2 0 118620866 0 0 18446744073709551615 0 0 0 0 0 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/14951/statm: 0 0 0 0 0 0 0
[pid=14951/tid=14970] ppid=14948 vsize=0 CPUtime=0.16
/proc/14951/task/14970/stat : 14970 (java) R 14948 14948 1750 0 -1 4203588 9 0 0 0 8 8 0 0 20 0 2 0 118650449 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) 292.61
Current children cumulated vsize (KiB) 9168

Child status: 0
Real time (s): 296.521
CPU time (s): 292.622
CPU user time (s): 291.794
CPU system time (s): 0.828051
CPU usage (%): 98.6851
Max. virtual memory (cumulated for all children) (KiB): 1064020

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 291.794
system time used= 0.828051
maximum resident set size= 738736
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 216154
page faults= 0
swaps= 0
block input operations= 42368
block output operations= 504
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 7287
involuntary context switches= 41827

runsolver used 0.952059 second user time and 1.69611 second system time

The end