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/slowlink/upgrade/difficult/rand425.cudf.log.runsolver /home/competition/p2cudf-full-1.15/p2cudf-full-1.15 /home/competition/data/upgrade/difficult/rand425.cudf /tmp/misc2012/2012-09-02-22:42/full/p2cudf-full-1.15/slowlink/upgrade/difficult/rand425.cudf.result -sum(changed,installedsize),-count(removed),-notuptodate(solution),-count(changed) 

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
Current StackSize limit: 8192 KiB


[startup+0 s]
/proc/loadavg: 1.00 1.05 1.06 2/59 22860
/proc/meminfo: memFree=583512/1022884 swapFree=0/0
[pid=22860] ppid=22859 vsize=1068 CPUtime=0
/proc/22860/stat : 22860 (p2cudf-full-1.1) D 22859 22860 1750 0 -1 4194304 76 0 0 0 0 0 0 0 20 0 1 0 120956188 1093632 1 18446744073709551615 0 0 140733371476918 140734133632744 4151317552 0 0 16781316 0 0 0 0 17 0 0 0 0 0 0
/proc/22860/statm: 267 1 0 0 0 28 0

[startup+0.193404 s]
/proc/loadavg: 1.00 1.05 1.06 2/59 22860
/proc/meminfo: memFree=583512/1022884 swapFree=0/0
[pid=22860] ppid=22859 vsize=9168 CPUtime=0
/proc/22860/stat : 22860 (p2cudf-full-1.1) S 22859 22860 1750 0 -1 4202496 455 291 2 1 0 0 0 0 20 0 1 0 120956188 9388032 330 18446744073709551615 4194304 5129932 140733371473168 140733371471312 140141701170270 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/22860/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.200307 s]
/proc/loadavg: 1.00 1.05 1.06 2/59 22860
/proc/meminfo: memFree=583512/1022884 swapFree=0/0
[pid=22860] ppid=22859 vsize=9168 CPUtime=0
/proc/22860/stat : 22860 (p2cudf-full-1.1) S 22859 22860 1750 0 -1 4202496 455 291 2 1 0 0 0 0 20 0 1 0 120956188 9388032 330 18446744073709551615 4194304 5129932 140733371473168 140733371471312 140141701170270 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/22860/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.300291 s]
/proc/loadavg: 1.00 1.05 1.06 2/59 22860
/proc/meminfo: memFree=583512/1022884 swapFree=0/0
[pid=22860] ppid=22859 vsize=9168 CPUtime=0
/proc/22860/stat : 22860 (p2cudf-full-1.1) S 22859 22860 1750 0 -1 4202496 455 291 2 1 0 0 0 0 20 0 1 0 120956188 9388032 330 18446744073709551615 4194304 5129932 140733371473168 140733371471312 140141701170270 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/22860/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.70023 s]
/proc/loadavg: 1.00 1.05 1.06 2/59 22860
/proc/meminfo: memFree=583512/1022884 swapFree=0/0
[pid=22860] ppid=22859 vsize=9168 CPUtime=0
/proc/22860/stat : 22860 (p2cudf-full-1.1) S 22859 22860 1750 0 -1 4202496 455 291 2 1 0 0 0 0 20 0 1 0 120956188 9388032 330 18446744073709551615 4194304 5129932 140733371473168 140733371471312 140141701170270 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/22860/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+1.50076 s]
/proc/loadavg: 1.00 1.05 1.06 3/70 22872
/proc/meminfo: memFree=541752/1022884 swapFree=0/0
[pid=22860] ppid=22859 vsize=9168 CPUtime=0
/proc/22860/stat : 22860 (p2cudf-full-1.1) S 22859 22860 1750 0 -1 4202496 455 291 2 1 0 0 0 0 20 0 1 0 120956188 9388032 330 18446744073709551615 4194304 5129932 140733371473168 140733371471312 140141701170270 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/22860/statm: 2292 330 280 229 0 52 0
[pid=22863] ppid=22860 vsize=1047488 CPUtime=1.4
/proc/22863/stat : 22863 (java) S 22860 22860 1750 0 -1 4202496 30083 0 1 0 127 13 0 0 20 0 10 0 120956191 1072627712 26929 18446744073709551615 4194304 4228012 140735647362096 140735647353120 140260021886581 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22863/statm: 261872 26929 2349 9 0 249222 0
[pid=22863/tid=22864] ppid=22860 vsize=1047488 CPUtime=0.65
/proc/22863/task/22864/stat : 22864 (java) R 22860 22860 1750 0 -1 4202560 13103 0 1 0 59 6 0 0 20 0 10 0 120956192 1072627712 26929 18446744073709551615 4194304 4228012 140735647362096 140260028412576 140259926319568 0 4 0 16800975 0 0 0 -1 0 0 0 4 0 0
[pid=22863/tid=22865] ppid=22860 vsize=1047488 CPUtime=0
/proc/22863/task/22865/stat : 22865 (java) S 22860 22860 1750 0 -1 4202560 3 0 0 0 0 0 0 0 20 0 10 0 120956196 1072627712 26929 18446744073709551615 4194304 4228012 140735647362096 140259921058944 140260021900875 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22866] ppid=22860 vsize=1047488 CPUtime=0
/proc/22863/task/22866/stat : 22866 (java) S 22860 22860 1750 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 10 0 120956196 1072627712 26929 18446744073709551615 4194304 4228012 140735647362096 140259920005136 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22867] ppid=22860 vsize=1047488 CPUtime=0
/proc/22863/task/22867/stat : 22867 (java) S 22860 22860 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 10 0 120956196 1072627712 26929 18446744073709551615 4194304 4228012 140735647362096 140259918952352 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22868] ppid=22860 vsize=1047488 CPUtime=0
/proc/22863/task/22868/stat : 22868 (java) S 22860 22860 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 120956199 1072627712 26929 18446744073709551615 4194304 4228012 140735647362096 140259917900784 140260021908512 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22869] ppid=22860 vsize=1047488 CPUtime=0.37
/proc/22863/task/22869/stat : 22869 (java) R 22860 22860 1750 0 -1 4202560 7722 0 0 0 35 2 0 0 20 0 10 0 120956199 1072627712 26929 18446744073709551615 4194304 4228012 140735647362096 140259916833336 140260008405658 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22870] ppid=22860 vsize=1047488 CPUtime=0.36
/proc/22863/task/22870/stat : 22870 (java) R 22860 22860 1750 0 -1 4202560 7967 0 0 0 32 4 0 0 20 0 10 0 120956199 1072627712 26929 18446744073709551615 4194304 4228012 140735647362096 140259915780536 140260014464430 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22871] ppid=22860 vsize=1047488 CPUtime=0
/proc/22863/task/22871/stat : 22871 (java) S 22860 22860 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 120956199 1072627712 26929 18446744073709551615 4194304 4228012 140735647362096 140259914742992 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22872] ppid=22860 vsize=1047488 CPUtime=0
/proc/22863/task/22872/stat : 22872 (java) S 22860 22860 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 120956199 1072627712 26929 18446744073709551615 4194304 4228012 140735647362096 140259913690496 140260021900875 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 1.4
Current children cumulated vsize (KiB) 1056656

[startup+3.10082 s]
/proc/loadavg: 1.00 1.05 1.06 4/70 22872
/proc/meminfo: memFree=440940/1022884 swapFree=0/0
[pid=22860] ppid=22859 vsize=9168 CPUtime=0
/proc/22860/stat : 22860 (p2cudf-full-1.1) S 22859 22860 1750 0 -1 4202496 455 291 2 1 0 0 0 0 20 0 1 0 120956188 9388032 330 18446744073709551615 4194304 5129932 140733371473168 140733371471312 140141701170270 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/22860/statm: 2292 330 280 229 0 52 0
[pid=22863] ppid=22860 vsize=1049256 CPUtime=2.99
/proc/22863/stat : 22863 (java) S 22860 22860 1750 0 -1 4202496 76165 0 1 0 271 28 0 0 20 0 10 0 120956191 1074438144 70956 18446744073709551615 4194304 4228012 140735647362096 140735647353120 140260021886581 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22863/statm: 262314 70956 2369 9 0 249664 0
[pid=22863/tid=22864] ppid=22860 vsize=1049256 CPUtime=1.46
/proc/22863/task/22864/stat : 22864 (java) R 22860 22860 1750 0 -1 4202560 47430 0 1 0 128 18 0 0 20 0 10 0 120956192 1074438144 70956 18446744073709551615 4194304 4228012 140735647362096 140260028412608 140259926231573 0 4 0 16800975 0 0 0 -1 0 0 0 4 0 0
[pid=22863/tid=22865] ppid=22860 vsize=1049256 CPUtime=0.16
/proc/22863/task/22865/stat : 22865 (java) S 22860 22860 1750 0 -1 4202560 7952 0 0 0 13 3 0 0 20 0 10 0 120956196 1074438144 70956 18446744073709551615 4194304 4228012 140735647362096 140259921058944 140260021900875 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22866] ppid=22860 vsize=1049256 CPUtime=0
/proc/22863/task/22866/stat : 22866 (java) S 22860 22860 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 120956196 1074438144 70956 18446744073709551615 4194304 4228012 140735647362096 140259920005136 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22867] ppid=22860 vsize=1049256 CPUtime=0
/proc/22863/task/22867/stat : 22867 (java) S 22860 22860 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 10 0 120956196 1074438144 70956 18446744073709551615 4194304 4228012 140735647362096 140259918952352 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22868] ppid=22860 vsize=1049256 CPUtime=0
/proc/22863/task/22868/stat : 22868 (java) S 22860 22860 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 120956199 1074438144 70956 18446744073709551615 4194304 4228012 140735647362096 140259917900784 140260021908512 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22869] ppid=22860 vsize=1049256 CPUtime=0.66
/proc/22863/task/22869/stat : 22869 (java) S 22860 22860 1750 0 -1 4202560 9981 0 0 0 64 2 0 0 20 0 10 0 120956199 1074438144 70956 18446744073709551615 4194304 4228012 140735647362096 140259916848144 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22870] ppid=22860 vsize=1049256 CPUtime=0.68
/proc/22863/task/22870/stat : 22870 (java) S 22860 22860 1750 0 -1 4202560 9510 0 0 0 64 4 0 0 20 0 10 0 120956199 1074438144 70956 18446744073709551615 4194304 4228012 140735647362096 140259915795472 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22871] ppid=22860 vsize=1049256 CPUtime=0
/proc/22863/task/22871/stat : 22871 (java) S 22860 22860 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 120956199 1074438144 70956 18446744073709551615 4194304 4228012 140735647362096 140259914742992 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22872] ppid=22860 vsize=1049256 CPUtime=0
/proc/22863/task/22872/stat : 22872 (java) S 22860 22860 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 120956199 1074438144 70956 18446744073709551615 4194304 4228012 140735647362096 140259913690496 140260021900875 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 2.99
Current children cumulated vsize (KiB) 1058424

[startup+6.30076 s]
/proc/loadavg: 1.00 1.05 1.06 2/70 22872
/proc/meminfo: memFree=138380/1022884 swapFree=0/0
[pid=22860] ppid=22859 vsize=9168 CPUtime=0
/proc/22860/stat : 22860 (p2cudf-full-1.1) S 22859 22860 1750 0 -1 4202496 455 291 2 1 0 0 0 0 20 0 1 0 120956188 9388032 330 18446744073709551615 4194304 5129932 140733371473168 140733371471312 140141701170270 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/22860/statm: 2292 330 280 229 0 52 0
[pid=22863] ppid=22860 vsize=1049256 CPUtime=6.13
/proc/22863/stat : 22863 (java) S 22860 22860 1750 0 -1 4202496 121461 0 1 0 570 43 0 0 20 0 10 0 120956191 1074438144 116199 18446744073709551615 4194304 4228012 140735647362096 140735647353120 140260021886581 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22863/statm: 262314 116199 2370 9 0 249664 0
[pid=22863/tid=22864] ppid=22860 vsize=1049256 CPUtime=3.44
/proc/22863/task/22864/stat : 22864 (java) R 22860 22860 1750 0 -1 4202560 47433 0 1 0 324 20 0 0 20 0 10 0 120956192 1074438144 116199 18446744073709551615 4194304 4228012 140735647362096 140260028412608 140259926205968 0 4 0 16800975 0 0 0 -1 0 0 0 5 0 0
[pid=22863/tid=22865] ppid=22860 vsize=1049256 CPUtime=1.25
/proc/22863/task/22865/stat : 22865 (java) S 22860 22860 1750 0 -1 4202560 53239 0 0 0 110 15 0 0 20 0 10 0 120956196 1074438144 116199 18446744073709551615 4194304 4228012 140735647362096 140259921058944 140260021900875 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22866] ppid=22860 vsize=1049256 CPUtime=0
/proc/22863/task/22866/stat : 22866 (java) S 22860 22860 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 120956196 1074438144 116199 18446744073709551615 4194304 4228012 140735647362096 140259920005136 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22867] ppid=22860 vsize=1049256 CPUtime=0
/proc/22863/task/22867/stat : 22867 (java) S 22860 22860 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 10 0 120956196 1074438144 116199 18446744073709551615 4194304 4228012 140735647362096 140259918952352 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22868] ppid=22860 vsize=1049256 CPUtime=0
/proc/22863/task/22868/stat : 22868 (java) S 22860 22860 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 120956199 1074438144 116199 18446744073709551615 4194304 4228012 140735647362096 140259917900784 140260021908512 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22869] ppid=22860 vsize=1049256 CPUtime=0.69
/proc/22863/task/22869/stat : 22869 (java) S 22860 22860 1750 0 -1 4202560 9981 0 0 0 67 2 0 0 20 0 10 0 120956199 1074438144 116199 18446744073709551615 4194304 4228012 140735647362096 140259916848144 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22870] ppid=22860 vsize=1049256 CPUtime=0.72
/proc/22863/task/22870/stat : 22870 (java) S 22860 22860 1750 0 -1 4202560 9516 0 0 0 68 4 0 0 20 0 10 0 120956199 1074438144 116199 18446744073709551615 4194304 4228012 140735647362096 140259915795472 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22871] ppid=22860 vsize=1049256 CPUtime=0
/proc/22863/task/22871/stat : 22871 (java) S 22860 22860 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 120956199 1074438144 116199 18446744073709551615 4194304 4228012 140735647362096 140259914742992 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22872] ppid=22860 vsize=1049256 CPUtime=0
/proc/22863/task/22872/stat : 22872 (java) S 22860 22860 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 120956199 1074438144 116199 18446744073709551615 4194304 4228012 140735647362096 140259913690496 140260021900875 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 6.13
Current children cumulated vsize (KiB) 1058424

[startup+12.7009 s]
/proc/loadavg: 1.16 1.08 1.07 3/71 22873
/proc/meminfo: memFree=9900/1022884 swapFree=0/0
[pid=22860] ppid=22859 vsize=9168 CPUtime=0
/proc/22860/stat : 22860 (p2cudf-full-1.1) S 22859 22860 1750 0 -1 4202496 455 291 2 1 0 0 0 0 20 0 1 0 120956188 9388032 330 18446744073709551615 4194304 5129932 140733371473168 140733371471312 140141701170270 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/22860/statm: 2292 330 280 229 0 52 0
[pid=22863] ppid=22860 vsize=1050284 CPUtime=12.31
/proc/22863/stat : 22863 (java) S 22860 22860 1750 0 -1 4202496 153043 0 1 0 1174 57 0 0 20 0 11 0 120956191 1075490816 147781 18446744073709551615 4194304 4228012 140735647362096 140735647353120 140260021886581 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22863/statm: 262571 147781 2380 9 0 249921 0
[pid=22863/tid=22864] ppid=22860 vsize=1050284 CPUtime=6.26
/proc/22863/task/22864/stat : 22864 (java) R 22860 22860 1750 0 -1 4202560 47812 0 1 0 603 23 0 0 20 0 11 0 120956192 1075490816 147781 18446744073709551615 4194304 4228012 140735647362096 140260028419928 140259927043362 0 4 0 16800975 0 0 0 -1 0 0 0 9 0 0
[pid=22863/tid=22865] ppid=22860 vsize=1050284 CPUtime=2.15
/proc/22863/task/22865/stat : 22865 (java) S 22860 22860 1750 0 -1 4202560 84001 0 0 0 188 27 0 0 20 0 11 0 120956196 1075490816 147781 18446744073709551615 4194304 4228012 140735647362096 140259921058944 140260021900875 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22866] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22866/stat : 22866 (java) S 22860 22860 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120956196 1075490816 147781 18446744073709551615 4194304 4228012 140735647362096 140259920005136 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22867] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22867/stat : 22867 (java) S 22860 22860 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120956196 1075490816 147781 18446744073709551615 4194304 4228012 140735647362096 140259918952352 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22868] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22868/stat : 22868 (java) S 22860 22860 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120956199 1075490816 147781 18446744073709551615 4194304 4228012 140735647362096 140259917900784 140260021908512 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22869] ppid=22860 vsize=1050284 CPUtime=1.94
/proc/22863/task/22869/stat : 22869 (java) R 22860 22860 1750 0 -1 4202560 10113 0 0 0 192 2 0 0 20 0 11 0 120956199 1075490816 147781 18446744073709551615 4194304 4228012 140735647362096 140259916847888 140260006191045 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22870] ppid=22860 vsize=1050284 CPUtime=1.93
/proc/22863/task/22870/stat : 22870 (java) R 22860 22860 1750 0 -1 4202560 9819 0 0 0 189 4 0 0 20 0 11 0 120956199 1075490816 147781 18446744073709551615 4194304 4228012 140735647362096 140259915795216 140260006191133 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22871] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22871/stat : 22871 (java) S 22860 22860 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120956199 1075490816 147781 18446744073709551615 4194304 4228012 140735647362096 140259914742992 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22872] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22872/stat : 22872 (java) S 22860 22860 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120956199 1075490816 147781 18446744073709551615 4194304 4228012 140735647362096 140259913690496 140260021900875 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22873] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22873/stat : 22873 (java) S 22860 22860 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120957339 1075490816 147781 18446744073709551615 4194304 4228012 140735647362096 140259912492896 140260021900875 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 12.31
Current children cumulated vsize (KiB) 1059452

[startup+25.5008 s]
/proc/loadavg: 1.12 1.08 1.07 2/71 22873
/proc/meminfo: memFree=10028/1022884 swapFree=0/0
[pid=22860] ppid=22859 vsize=9168 CPUtime=0
/proc/22860/stat : 22860 (p2cudf-full-1.1) S 22859 22860 1750 0 -1 4202496 455 291 2 1 0 0 0 0 20 0 1 0 120956188 9388032 330 18446744073709551615 4194304 5129932 140733371473168 140733371471312 140141701170270 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/22860/statm: 2292 330 280 229 0 52 0
[pid=22863] ppid=22860 vsize=1050284 CPUtime=24.89
/proc/22863/stat : 22863 (java) S 22860 22860 1750 0 -1 4202496 160550 0 1 0 2428 61 0 0 20 0 11 0 120956191 1075490816 155288 18446744073709551615 4194304 4228012 140735647362096 140735647353120 140260021886581 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22863/statm: 262571 155288 2393 9 0 249921 0
[pid=22863/tid=22864] ppid=22860 vsize=1050284 CPUtime=15.79
/proc/22863/task/22864/stat : 22864 (java) R 22860 22860 1750 0 -1 4202560 47816 0 1 0 1556 23 0 0 20 0 11 0 120956192 1075490816 155288 18446744073709551615 4194304 4228012 140735647362096 140260028420056 140259926719821 0 4 0 16800975 0 0 0 -1 0 0 0 9 0 0
[pid=22863/tid=22865] ppid=22860 vsize=1050284 CPUtime=4.56
/proc/22863/task/22865/stat : 22865 (java) S 22860 22860 1750 0 -1 4202560 91435 0 0 0 426 30 0 0 20 0 11 0 120956196 1075490816 155288 18446744073709551615 4194304 4228012 140735647362096 140259921058944 140260021900875 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22866] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22866/stat : 22866 (java) S 22860 22860 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120956196 1075490816 155288 18446744073709551615 4194304 4228012 140735647362096 140259920005136 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22867] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22867/stat : 22867 (java) S 22860 22860 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120956196 1075490816 155288 18446744073709551615 4194304 4228012 140735647362096 140259918952352 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22868] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22868/stat : 22868 (java) S 22860 22860 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120956199 1075490816 155288 18446744073709551615 4194304 4228012 140735647362096 140259917900784 140260021908512 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22869] ppid=22860 vsize=1050284 CPUtime=2.41
/proc/22863/task/22869/stat : 22869 (java) S 22860 22860 1750 0 -1 4202560 10180 0 0 0 239 2 0 0 20 0 11 0 120956199 1075490816 155288 18446744073709551615 4194304 4228012 140735647362096 140259916848144 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22870] ppid=22860 vsize=1050284 CPUtime=2.06
/proc/22863/task/22870/stat : 22870 (java) S 22860 22860 1750 0 -1 4202560 9821 0 0 0 202 4 0 0 20 0 11 0 120956199 1075490816 155288 18446744073709551615 4194304 4228012 140735647362096 140259915795472 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22871] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22871/stat : 22871 (java) S 22860 22860 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120956199 1075490816 155288 18446744073709551615 4194304 4228012 140735647362096 140259914742992 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22872] ppid=22860 vsize=1050284 CPUtime=0.01
/proc/22863/task/22872/stat : 22872 (java) S 22860 22860 1750 0 -1 4202560 0 0 0 0 1 0 0 0 20 0 11 0 120956199 1075490816 155288 18446744073709551615 4194304 4228012 140735647362096 140259913690496 140260021900875 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22873] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22873/stat : 22873 (java) S 22860 22860 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120957339 1075490816 155288 18446744073709551615 4194304 4228012 140735647362096 140259912492896 140260021900875 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 24.89
Current children cumulated vsize (KiB) 1059452

[startup+51.1008 s]
/proc/loadavg: 1.08 1.07 1.07 2/71 22873
/proc/meminfo: memFree=10028/1022884 swapFree=0/0
[pid=22860] ppid=22859 vsize=9168 CPUtime=0
/proc/22860/stat : 22860 (p2cudf-full-1.1) S 22859 22860 1750 0 -1 4202496 455 291 2 1 0 0 0 0 20 0 1 0 120956188 9388032 330 18446744073709551615 4194304 5129932 140733371473168 140733371471312 140141701170270 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/22860/statm: 2292 330 280 229 0 52 0
[pid=22863] ppid=22860 vsize=1050284 CPUtime=50.13
/proc/22863/stat : 22863 (java) S 22860 22860 1750 0 -1 4202496 161518 0 1 0 4951 62 0 0 20 0 11 0 120956191 1075490816 156252 18446744073709551615 4194304 4228012 140735647362096 140735647353120 140260021886581 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22863/statm: 262571 156252 2393 9 0 249921 0
[pid=22863/tid=22864] ppid=22860 vsize=1050284 CPUtime=36.11
/proc/22863/task/22864/stat : 22864 (java) R 22860 22860 1750 0 -1 4202560 47816 0 1 0 3588 23 0 0 20 0 11 0 120956192 1075490816 156252 18446744073709551615 4194304 4228012 140735647362096 140260028420056 140259926720207 0 4 0 16800975 0 0 0 -1 0 0 0 9 0 0
[pid=22863/tid=22865] ppid=22860 vsize=1050284 CPUtime=9.42
/proc/22863/task/22865/stat : 22865 (java) S 22860 22860 1750 0 -1 4202560 92400 0 0 0 911 31 0 0 20 0 11 0 120956196 1075490816 156252 18446744073709551615 4194304 4228012 140735647362096 140259921058944 140260021900875 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22866] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22866/stat : 22866 (java) S 22860 22860 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120956196 1075490816 156252 18446744073709551615 4194304 4228012 140735647362096 140259920005136 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22867] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22867/stat : 22867 (java) S 22860 22860 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120956196 1075490816 156252 18446744073709551615 4194304 4228012 140735647362096 140259918952352 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22868] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22868/stat : 22868 (java) S 22860 22860 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120956199 1075490816 156252 18446744073709551615 4194304 4228012 140735647362096 140259917900784 140260021908512 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22869] ppid=22860 vsize=1050284 CPUtime=2.44
/proc/22863/task/22869/stat : 22869 (java) S 22860 22860 1750 0 -1 4202560 10180 0 0 0 242 2 0 0 20 0 11 0 120956199 1075490816 156252 18446744073709551615 4194304 4228012 140735647362096 140259916848144 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22870] ppid=22860 vsize=1050284 CPUtime=2.1
/proc/22863/task/22870/stat : 22870 (java) S 22860 22860 1750 0 -1 4202560 9821 0 0 0 206 4 0 0 20 0 11 0 120956199 1075490816 156252 18446744073709551615 4194304 4228012 140735647362096 140259915795472 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22871] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22871/stat : 22871 (java) S 22860 22860 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120956199 1075490816 156252 18446744073709551615 4194304 4228012 140735647362096 140259914742992 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22872] ppid=22860 vsize=1050284 CPUtime=0.02
/proc/22863/task/22872/stat : 22872 (java) S 22860 22860 1750 0 -1 4202560 3 0 0 0 2 0 0 0 20 0 11 0 120956199 1075490816 156252 18446744073709551615 4194304 4228012 140735647362096 140259913690496 140260021900875 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22873] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22873/stat : 22873 (java) S 22860 22860 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120957339 1075490816 156252 18446744073709551615 4194304 4228012 140735647362096 140259912492896 140260021900875 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 50.13
Current children cumulated vsize (KiB) 1059452

[startup+102.301 s]
/proc/loadavg: 1.03 1.06 1.06 2/71 22873
/proc/meminfo: memFree=10152/1022884 swapFree=0/0
[pid=22860] ppid=22859 vsize=9168 CPUtime=0
/proc/22860/stat : 22860 (p2cudf-full-1.1) S 22859 22860 1750 0 -1 4202496 455 291 2 1 0 0 0 0 20 0 1 0 120956188 9388032 330 18446744073709551615 4194304 5129932 140733371473168 140733371471312 140141701170270 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/22860/statm: 2292 330 280 229 0 52 0
[pid=22863] ppid=22860 vsize=1050284 CPUtime=100.63
/proc/22863/stat : 22863 (java) S 22860 22860 1750 0 -1 4202496 162433 0 1 0 10001 62 0 0 20 0 11 0 120956191 1075490816 157163 18446744073709551615 4194304 4228012 140735647362096 140735647353120 140260021886581 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22863/statm: 262571 157163 2393 9 0 249921 0
[pid=22863/tid=22864] ppid=22860 vsize=1050284 CPUtime=81.83
/proc/22863/task/22864/stat : 22864 (java) R 22860 22860 1750 0 -1 4202560 47816 0 1 0 8160 23 0 0 20 0 11 0 120956192 1075490816 157163 18446744073709551615 4194304 4228012 140735647362096 140260028420056 140259927076383 0 4 0 16800975 0 0 0 -1 0 0 0 9 0 0
[pid=22863/tid=22865] ppid=22860 vsize=1050284 CPUtime=14.17
/proc/22863/task/22865/stat : 22865 (java) S 22860 22860 1750 0 -1 4202560 93312 0 0 0 1386 31 0 0 20 0 11 0 120956196 1075490816 157163 18446744073709551615 4194304 4228012 140735647362096 140259921058944 140260021900875 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22866] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22866/stat : 22866 (java) S 22860 22860 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120956196 1075490816 157163 18446744073709551615 4194304 4228012 140735647362096 140259920005136 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22867] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22867/stat : 22867 (java) S 22860 22860 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120956196 1075490816 157163 18446744073709551615 4194304 4228012 140735647362096 140259918952352 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22868] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22868/stat : 22868 (java) S 22860 22860 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120956199 1075490816 157163 18446744073709551615 4194304 4228012 140735647362096 140259917900784 140260021908512 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22869] ppid=22860 vsize=1050284 CPUtime=2.44
/proc/22863/task/22869/stat : 22869 (java) S 22860 22860 1750 0 -1 4202560 10180 0 0 0 242 2 0 0 20 0 11 0 120956199 1075490816 157163 18446744073709551615 4194304 4228012 140735647362096 140259916848144 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22870] ppid=22860 vsize=1050284 CPUtime=2.1
/proc/22863/task/22870/stat : 22870 (java) S 22860 22860 1750 0 -1 4202560 9821 0 0 0 206 4 0 0 20 0 11 0 120956199 1075490816 157163 18446744073709551615 4194304 4228012 140735647362096 140259915795472 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22871] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22871/stat : 22871 (java) S 22860 22860 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120956199 1075490816 157163 18446744073709551615 4194304 4228012 140735647362096 140259914742992 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22872] ppid=22860 vsize=1050284 CPUtime=0.05
/proc/22863/task/22872/stat : 22872 (java) S 22860 22860 1750 0 -1 4202560 6 0 0 0 5 0 0 0 20 0 11 0 120956199 1075490816 157163 18446744073709551615 4194304 4228012 140735647362096 140259913690496 140260021900875 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22873] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22873/stat : 22873 (java) S 22860 22860 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120957339 1075490816 157163 18446744073709551615 4194304 4228012 140735647362096 140259912492896 140260021900875 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 100.63
Current children cumulated vsize (KiB) 1059452

[startup+162.301 s]
/proc/loadavg: 1.01 1.04 1.06 2/71 22873
/proc/meminfo: memFree=9284/1022884 swapFree=0/0
[pid=22860] ppid=22859 vsize=9168 CPUtime=0
/proc/22860/stat : 22860 (p2cudf-full-1.1) S 22859 22860 1750 0 -1 4202496 455 291 2 1 0 0 0 0 20 0 1 0 120956188 9388032 330 18446744073709551615 4194304 5129932 140733371473168 140733371471312 140141701170270 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/22860/statm: 2292 330 280 229 0 52 0
[pid=22863] ppid=22860 vsize=1050284 CPUtime=159.86
/proc/22863/stat : 22863 (java) S 22860 22860 1750 0 -1 4202496 164637 0 1 0 15923 63 0 0 20 0 11 0 120956191 1075490816 159359 18446744073709551615 4194304 4228012 140735647362096 140735647353120 140260021886581 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22863/statm: 262571 159359 2393 9 0 249921 0
[pid=22863/tid=22864] ppid=22860 vsize=1050284 CPUtime=135.66
/proc/22863/task/22864/stat : 22864 (java) R 22860 22860 1750 0 -1 4202560 47816 0 1 0 13543 23 0 0 20 0 11 0 120956192 1075490816 159359 18446744073709551615 4194304 4228012 140735647362096 140260028420056 140259927200646 0 4 0 16800975 0 0 0 -1 0 0 0 9 0 0
[pid=22863/tid=22865] ppid=22860 vsize=1050284 CPUtime=19.54
/proc/22863/task/22865/stat : 22865 (java) S 22860 22860 1750 0 -1 4202560 95510 0 0 0 1922 32 0 0 20 0 11 0 120956196 1075490816 159359 18446744073709551615 4194304 4228012 140735647362096 140259921058944 140260021900875 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22866] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22866/stat : 22866 (java) S 22860 22860 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120956196 1075490816 159359 18446744073709551615 4194304 4228012 140735647362096 140259920005136 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22867] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22867/stat : 22867 (java) S 22860 22860 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120956196 1075490816 159359 18446744073709551615 4194304 4228012 140735647362096 140259918952352 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22868] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22868/stat : 22868 (java) S 22860 22860 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120956199 1075490816 159359 18446744073709551615 4194304 4228012 140735647362096 140259917900784 140260021908512 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22869] ppid=22860 vsize=1050284 CPUtime=2.44
/proc/22863/task/22869/stat : 22869 (java) S 22860 22860 1750 0 -1 4202560 10180 0 0 0 242 2 0 0 20 0 11 0 120956199 1075490816 159359 18446744073709551615 4194304 4228012 140735647362096 140259916848144 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22870] ppid=22860 vsize=1050284 CPUtime=2.1
/proc/22863/task/22870/stat : 22870 (java) S 22860 22860 1750 0 -1 4202560 9821 0 0 0 206 4 0 0 20 0 11 0 120956199 1075490816 159359 18446744073709551615 4194304 4228012 140735647362096 140259915795472 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22871] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22871/stat : 22871 (java) S 22860 22860 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120956199 1075490816 159359 18446744073709551615 4194304 4228012 140735647362096 140259914742992 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22872] ppid=22860 vsize=1050284 CPUtime=0.08
/proc/22863/task/22872/stat : 22872 (java) S 22860 22860 1750 0 -1 4202560 12 0 0 0 8 0 0 0 20 0 11 0 120956199 1075490816 159359 18446744073709551615 4194304 4228012 140735647362096 140259913690496 140260021900875 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22873] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22873/stat : 22873 (java) S 22860 22860 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120957339 1075490816 159359 18446744073709551615 4194304 4228012 140735647362096 140259912492896 140260021900875 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 159.86
Current children cumulated vsize (KiB) 1059452

[startup+222.306 s]
/proc/loadavg: 1.00 1.03 1.05 2/71 22881
/proc/meminfo: memFree=10272/1022884 swapFree=0/0
[pid=22860] ppid=22859 vsize=9168 CPUtime=0
/proc/22860/stat : 22860 (p2cudf-full-1.1) S 22859 22860 1750 0 -1 4202496 455 291 2 1 0 0 0 0 20 0 1 0 120956188 9388032 330 18446744073709551615 4194304 5129932 140733371473168 140733371471312 140141701170270 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/22860/statm: 2292 330 280 229 0 52 0
[pid=22863] ppid=22860 vsize=1050284 CPUtime=219.19
/proc/22863/stat : 22863 (java) S 22860 22860 1750 0 -1 4202496 167403 0 1 0 21855 64 0 0 20 0 11 0 120956191 1075490816 162117 18446744073709551615 4194304 4228012 140735647362096 140735647353120 140260021886581 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22863/statm: 262571 162117 2393 9 0 249921 0
[pid=22863/tid=22864] ppid=22860 vsize=1050284 CPUtime=190.52
/proc/22863/task/22864/stat : 22864 (java) R 22860 22860 1750 0 -1 4202560 47816 0 1 0 19029 23 0 0 20 0 11 0 120956192 1075490816 162117 18446744073709551615 4194304 4228012 140735647362096 140260028420056 140259927055797 0 4 0 16800975 0 0 0 -1 0 0 0 9 0 0
[pid=22863/tid=22865] ppid=22860 vsize=1050284 CPUtime=23.99
/proc/22863/task/22865/stat : 22865 (java) S 22860 22860 1750 0 -1 4202560 98270 0 0 0 2365 34 0 0 20 0 11 0 120956196 1075490816 162117 18446744073709551615 4194304 4228012 140735647362096 140259921058944 140260021900875 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22866] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22866/stat : 22866 (java) S 22860 22860 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120956196 1075490816 162117 18446744073709551615 4194304 4228012 140735647362096 140259920005136 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22867] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22867/stat : 22867 (java) S 22860 22860 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120956196 1075490816 162117 18446744073709551615 4194304 4228012 140735647362096 140259918952352 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22868] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22868/stat : 22868 (java) S 22860 22860 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120956199 1075490816 162117 18446744073709551615 4194304 4228012 140735647362096 140259917900784 140260021908512 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22869] ppid=22860 vsize=1050284 CPUtime=2.44
/proc/22863/task/22869/stat : 22869 (java) S 22860 22860 1750 0 -1 4202560 10180 0 0 0 242 2 0 0 20 0 11 0 120956199 1075490816 162117 18446744073709551615 4194304 4228012 140735647362096 140259916848144 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22870] ppid=22860 vsize=1050284 CPUtime=2.1
/proc/22863/task/22870/stat : 22870 (java) S 22860 22860 1750 0 -1 4202560 9821 0 0 0 206 4 0 0 20 0 11 0 120956199 1075490816 162117 18446744073709551615 4194304 4228012 140735647362096 140259915795472 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22871] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22871/stat : 22871 (java) S 22860 22860 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120956199 1075490816 162117 18446744073709551615 4194304 4228012 140735647362096 140259914742992 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22872] ppid=22860 vsize=1050284 CPUtime=0.1
/proc/22863/task/22872/stat : 22872 (java) S 22860 22860 1750 0 -1 4202560 18 0 0 0 10 0 0 0 20 0 11 0 120956199 1075490816 162117 18446744073709551615 4194304 4228012 140735647362096 140259913690496 140260021900875 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22873] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22873/stat : 22873 (java) S 22860 22860 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120957339 1075490816 162117 18446744073709551615 4194304 4228012 140735647362096 140259912492896 140260021900875 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 219.19
Current children cumulated vsize (KiB) 1059452

[startup+282.301 s]
/proc/loadavg: 1.00 1.02 1.05 2/71 22881
/proc/meminfo: memFree=10024/1022884 swapFree=0/0
[pid=22860] ppid=22859 vsize=9168 CPUtime=0
/proc/22860/stat : 22860 (p2cudf-full-1.1) S 22859 22860 1750 0 -1 4202496 455 291 2 1 0 0 0 0 20 0 1 0 120956188 9388032 330 18446744073709551615 4194304 5129932 140733371473168 140733371471312 140141701170270 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/22860/statm: 2292 330 280 229 0 52 0
[pid=22863] ppid=22860 vsize=1050284 CPUtime=278.58
/proc/22863/stat : 22863 (java) S 22860 22860 1750 0 -1 4202496 168453 0 1 0 27793 65 0 0 20 0 11 0 120956191 1075490816 163160 18446744073709551615 4194304 4228012 140735647362096 140735647353120 140260021886581 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22863/statm: 262571 163160 2393 9 0 249921 0
[pid=22863/tid=22864] ppid=22860 vsize=1050284 CPUtime=246.91
/proc/22863/task/22864/stat : 22864 (java) R 22860 22860 1750 0 -1 4202560 47816 0 1 0 24668 23 0 0 20 0 11 0 120956192 1075490816 163160 18446744073709551615 4194304 4228012 140735647362096 140260028420056 140259927055301 0 4 0 16800975 0 0 0 -1 0 0 0 9 0 0
[pid=22863/tid=22865] ppid=22860 vsize=1050284 CPUtime=26.94
/proc/22863/task/22865/stat : 22865 (java) S 22860 22860 1750 0 -1 4202560 99314 0 0 0 2660 34 0 0 20 0 11 0 120956196 1075490816 163160 18446744073709551615 4194304 4228012 140735647362096 140259921058944 140260021900875 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22866] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22866/stat : 22866 (java) S 22860 22860 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120956196 1075490816 163160 18446744073709551615 4194304 4228012 140735647362096 140259920005136 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22867] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22867/stat : 22867 (java) S 22860 22860 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120956196 1075490816 163160 18446744073709551615 4194304 4228012 140735647362096 140259918952352 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22868] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22868/stat : 22868 (java) S 22860 22860 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120956199 1075490816 163160 18446744073709551615 4194304 4228012 140735647362096 140259917900784 140260021908512 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22869] ppid=22860 vsize=1050284 CPUtime=2.46
/proc/22863/task/22869/stat : 22869 (java) S 22860 22860 1750 0 -1 4202560 10180 0 0 0 244 2 0 0 20 0 11 0 120956199 1075490816 163160 18446744073709551615 4194304 4228012 140735647362096 140259916848144 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22870] ppid=22860 vsize=1050284 CPUtime=2.1
/proc/22863/task/22870/stat : 22870 (java) S 22860 22860 1750 0 -1 4202560 9821 0 0 0 206 4 0 0 20 0 11 0 120956199 1075490816 163160 18446744073709551615 4194304 4228012 140735647362096 140259915795472 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22871] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22871/stat : 22871 (java) S 22860 22860 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120956199 1075490816 163160 18446744073709551615 4194304 4228012 140735647362096 140259914742992 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22872] ppid=22860 vsize=1050284 CPUtime=0.13
/proc/22863/task/22872/stat : 22872 (java) S 22860 22860 1750 0 -1 4202560 24 0 0 0 13 0 0 0 20 0 11 0 120956199 1075490816 163160 18446744073709551615 4194304 4228012 140735647362096 140259913690496 140260021900875 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22873] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22873/stat : 22873 (java) S 22860 22860 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120957339 1075490816 163160 18446744073709551615 4194304 4228012 140735647362096 140259912492896 140260021900875 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 278.58
Current children cumulated vsize (KiB) 1059452

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

[startup+288.001 s]
/proc/loadavg: 1.00 1.02 1.04 2/71 22881
/proc/meminfo: memFree=10024/1022884 swapFree=0/0
[pid=22860] ppid=22859 vsize=9168 CPUtime=0
/proc/22860/stat : 22860 (p2cudf-full-1.1) S 22859 22860 1750 0 -1 4202496 455 291 2 1 0 0 0 0 20 0 1 0 120956188 9388032 330 18446744073709551615 4194304 5129932 140733371473168 140733371471312 140141701170270 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/22860/statm: 2292 330 280 229 0 52 0
[pid=22863] ppid=22860 vsize=1050284 CPUtime=284.23
/proc/22863/stat : 22863 (java) S 22860 22860 1750 0 -1 4202496 168454 0 1 0 28358 65 0 0 20 0 11 0 120956191 1075490816 163160 18446744073709551615 4194304 4228012 140735647362096 140735647353120 140260021886581 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22863/statm: 262571 163160 2393 9 0 249921 0
[pid=22863/tid=22864] ppid=22860 vsize=1050284 CPUtime=252.26
/proc/22863/task/22864/stat : 22864 (java) S 22860 22860 1750 0 -1 4202560 47816 0 1 0 25203 23 0 0 20 0 11 0 120956192 1075490816 163160 18446744073709551615 4194304 4228012 140735647362096 140260028419856 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 9 0 0
[pid=22863/tid=22865] ppid=22860 vsize=1050284 CPUtime=27.22
/proc/22863/task/22865/stat : 22865 (java) R 22860 22860 1750 0 -1 4202560 99315 0 0 0 2688 34 0 0 20 0 11 0 120956196 1075490816 163160 18446744073709551615 4194304 4228012 140735647362096 140259921058352 140260006248843 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22866] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22866/stat : 22866 (java) S 22860 22860 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120956196 1075490816 163160 18446744073709551615 4194304 4228012 140735647362096 140259920005136 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22867] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22867/stat : 22867 (java) S 22860 22860 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120956196 1075490816 163160 18446744073709551615 4194304 4228012 140735647362096 140259918952352 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22868] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22868/stat : 22868 (java) S 22860 22860 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120956199 1075490816 163160 18446744073709551615 4194304 4228012 140735647362096 140259917900784 140260021908512 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22869] ppid=22860 vsize=1050284 CPUtime=2.46
/proc/22863/task/22869/stat : 22869 (java) S 22860 22860 1750 0 -1 4202560 10180 0 0 0 244 2 0 0 20 0 11 0 120956199 1075490816 163160 18446744073709551615 4194304 4228012 140735647362096 140259916848144 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22870] ppid=22860 vsize=1050284 CPUtime=2.1
/proc/22863/task/22870/stat : 22870 (java) S 22860 22860 1750 0 -1 4202560 9821 0 0 0 206 4 0 0 20 0 11 0 120956199 1075490816 163160 18446744073709551615 4194304 4228012 140735647362096 140259915795472 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22871] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22871/stat : 22871 (java) S 22860 22860 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120956199 1075490816 163160 18446744073709551615 4194304 4228012 140735647362096 140259914742992 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22872] ppid=22860 vsize=1050284 CPUtime=0.13
/proc/22863/task/22872/stat : 22872 (java) S 22860 22860 1750 0 -1 4202560 24 0 0 0 13 0 0 0 20 0 11 0 120956199 1075490816 163160 18446744073709551615 4194304 4228012 140735647362096 140259913690496 140260021900875 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22873] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22873/stat : 22873 (java) S 22860 22860 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120957339 1075490816 163160 18446744073709551615 4194304 4228012 140735647362096 140259912492896 140260021900875 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 284.23
Current children cumulated vsize (KiB) 1059452

[startup+291.201 s]
/proc/loadavg: 1.00 1.02 1.04 2/71 22881
/proc/meminfo: memFree=10148/1022884 swapFree=0/0
[pid=22860] ppid=22859 vsize=9168 CPUtime=0
/proc/22860/stat : 22860 (p2cudf-full-1.1) S 22859 22860 1750 0 -1 4202496 455 291 2 1 0 0 0 0 20 0 1 0 120956188 9388032 330 18446744073709551615 4194304 5129932 140733371473168 140733371471312 140141701170270 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/22860/statm: 2292 330 280 229 0 52 0
[pid=22863] ppid=22860 vsize=1050284 CPUtime=287.39
/proc/22863/stat : 22863 (java) S 22860 22860 1750 0 -1 4202496 168905 0 1 0 28674 65 0 0 20 0 11 0 120956191 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140735647353120 140260021886581 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22863/statm: 262571 163611 2393 9 0 249921 0
[pid=22863/tid=22864] ppid=22860 vsize=1050284 CPUtime=254.98
/proc/22863/task/22864/stat : 22864 (java) R 22860 22860 1750 0 -1 4202560 47816 0 1 0 25475 23 0 0 20 0 11 0 120956192 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140260028420056 140259926719924 0 4 0 16800975 0 0 0 -1 0 0 0 9 0 0
[pid=22863/tid=22865] ppid=22860 vsize=1050284 CPUtime=27.67
/proc/22863/task/22865/stat : 22865 (java) S 22860 22860 1750 0 -1 4202560 99766 0 0 0 2733 34 0 0 20 0 11 0 120956196 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140259921058944 140260021900875 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22866] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22866/stat : 22866 (java) S 22860 22860 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120956196 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140259920005136 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22867] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22867/stat : 22867 (java) S 22860 22860 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120956196 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140259918952352 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22868] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22868/stat : 22868 (java) S 22860 22860 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120956199 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140259917900784 140260021908512 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22869] ppid=22860 vsize=1050284 CPUtime=2.46
/proc/22863/task/22869/stat : 22869 (java) S 22860 22860 1750 0 -1 4202560 10180 0 0 0 244 2 0 0 20 0 11 0 120956199 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140259916848144 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22870] ppid=22860 vsize=1050284 CPUtime=2.1
/proc/22863/task/22870/stat : 22870 (java) S 22860 22860 1750 0 -1 4202560 9821 0 0 0 206 4 0 0 20 0 11 0 120956199 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140259915795472 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22871] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22871/stat : 22871 (java) S 22860 22860 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120956199 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140259914742992 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22872] ppid=22860 vsize=1050284 CPUtime=0.13
/proc/22863/task/22872/stat : 22872 (java) S 22860 22860 1750 0 -1 4202560 24 0 0 0 13 0 0 0 20 0 11 0 120956199 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140259913690496 140260021900875 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22873] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22873/stat : 22873 (java) S 22860 22860 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120957339 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140259912492896 140260021900875 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 287.39
Current children cumulated vsize (KiB) 1059452

[startup+294.401 s]
/proc/loadavg: 1.00 1.02 1.04 2/71 22881
/proc/meminfo: memFree=10148/1022884 swapFree=0/0
[pid=22860] ppid=22859 vsize=9168 CPUtime=0
/proc/22860/stat : 22860 (p2cudf-full-1.1) S 22859 22860 1750 0 -1 4202496 455 291 2 1 0 0 0 0 20 0 1 0 120956188 9388032 330 18446744073709551615 4194304 5129932 140733371473168 140733371471312 140141701170270 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/22860/statm: 2292 330 280 229 0 52 0
[pid=22863] ppid=22860 vsize=1050284 CPUtime=290.56
/proc/22863/stat : 22863 (java) S 22860 22860 1750 0 -1 4202496 168905 0 1 0 28991 65 0 0 20 0 11 0 120956191 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140735647353120 140260021886581 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22863/statm: 262571 163611 2393 9 0 249921 0
[pid=22863/tid=22864] ppid=22860 vsize=1050284 CPUtime=258.15
/proc/22863/task/22864/stat : 22864 (java) R 22860 22860 1750 0 -1 4202560 47816 0 1 0 25792 23 0 0 20 0 11 0 120956192 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140260028420056 140259926086438 0 4 0 16800975 0 0 0 -1 0 0 0 9 0 0
[pid=22863/tid=22865] ppid=22860 vsize=1050284 CPUtime=27.67
/proc/22863/task/22865/stat : 22865 (java) S 22860 22860 1750 0 -1 4202560 99766 0 0 0 2733 34 0 0 20 0 11 0 120956196 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140259921058944 140260021900875 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22866] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22866/stat : 22866 (java) S 22860 22860 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120956196 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140259920005136 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22867] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22867/stat : 22867 (java) S 22860 22860 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120956196 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140259918952352 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22868] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22868/stat : 22868 (java) S 22860 22860 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120956199 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140259917900784 140260021908512 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22869] ppid=22860 vsize=1050284 CPUtime=2.46
/proc/22863/task/22869/stat : 22869 (java) S 22860 22860 1750 0 -1 4202560 10180 0 0 0 244 2 0 0 20 0 11 0 120956199 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140259916848144 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22870] ppid=22860 vsize=1050284 CPUtime=2.1
/proc/22863/task/22870/stat : 22870 (java) S 22860 22860 1750 0 -1 4202560 9821 0 0 0 206 4 0 0 20 0 11 0 120956199 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140259915795472 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22871] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22871/stat : 22871 (java) S 22860 22860 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120956199 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140259914742992 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22872] ppid=22860 vsize=1050284 CPUtime=0.13
/proc/22863/task/22872/stat : 22872 (java) S 22860 22860 1750 0 -1 4202560 24 0 0 0 13 0 0 0 20 0 11 0 120956199 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140259913690496 140260021900875 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22873] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22873/stat : 22873 (java) S 22860 22860 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120957339 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140259912492896 140260021900875 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 290.56
Current children cumulated vsize (KiB) 1059452

[startup+296.008 s]
/proc/loadavg: 1.00 1.02 1.04 2/71 22881
/proc/meminfo: memFree=10148/1022884 swapFree=0/0
[pid=22860] ppid=22859 vsize=9168 CPUtime=0
/proc/22860/stat : 22860 (p2cudf-full-1.1) S 22859 22860 1750 0 -1 4202496 455 291 2 1 0 0 0 0 20 0 1 0 120956188 9388032 330 18446744073709551615 4194304 5129932 140733371473168 140733371471312 140141701170270 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/22860/statm: 2292 330 280 229 0 52 0
[pid=22863] ppid=22860 vsize=1050284 CPUtime=292.15
/proc/22863/stat : 22863 (java) S 22860 22860 1750 0 -1 4202496 168905 0 1 0 29150 65 0 0 20 0 11 0 120956191 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140735647353120 140260021886581 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22863/statm: 262571 163611 2393 9 0 249921 0
[pid=22863/tid=22864] ppid=22860 vsize=1050284 CPUtime=259.74
/proc/22863/task/22864/stat : 22864 (java) R 22860 22860 1750 0 -1 4202560 47816 0 1 0 25951 23 0 0 20 0 11 0 120956192 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140260028420056 140259927055391 0 4 0 16800975 0 0 0 -1 0 0 0 9 0 0
[pid=22863/tid=22865] ppid=22860 vsize=1050284 CPUtime=27.67
/proc/22863/task/22865/stat : 22865 (java) S 22860 22860 1750 0 -1 4202560 99766 0 0 0 2733 34 0 0 20 0 11 0 120956196 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140259921058944 140260021900875 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22866] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22866/stat : 22866 (java) S 22860 22860 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120956196 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140259920005136 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22867] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22867/stat : 22867 (java) S 22860 22860 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120956196 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140259918952352 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22868] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22868/stat : 22868 (java) S 22860 22860 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120956199 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140259917900784 140260021908512 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22869] ppid=22860 vsize=1050284 CPUtime=2.46
/proc/22863/task/22869/stat : 22869 (java) S 22860 22860 1750 0 -1 4202560 10180 0 0 0 244 2 0 0 20 0 11 0 120956199 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140259916848144 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22870] ppid=22860 vsize=1050284 CPUtime=2.1
/proc/22863/task/22870/stat : 22870 (java) S 22860 22860 1750 0 -1 4202560 9821 0 0 0 206 4 0 0 20 0 11 0 120956199 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140259915795472 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22871] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22871/stat : 22871 (java) S 22860 22860 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120956199 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140259914742992 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22872] ppid=22860 vsize=1050284 CPUtime=0.13
/proc/22863/task/22872/stat : 22872 (java) S 22860 22860 1750 0 -1 4202560 24 0 0 0 13 0 0 0 20 0 11 0 120956199 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140259913690496 140260021900875 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22873] ppid=22860 vsize=1050284 CPUtime=0
/proc/22863/task/22873/stat : 22873 (java) S 22860 22860 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120957339 1075490816 163611 18446744073709551615 4194304 4228012 140735647362096 140259912492896 140260021900875 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 292.15
Current children cumulated vsize (KiB) 1059452

[startup+296.801 s]
/proc/loadavg: 1.00 1.02 1.04 2/71 22881
/proc/meminfo: memFree=10148/1022884 swapFree=0/0
[pid=22860] ppid=22859 vsize=9168 CPUtime=0
/proc/22860/stat : 22860 (p2cudf-full-1.1) S 22859 22860 1750 0 -1 4202496 455 291 2 1 0 0 0 0 20 0 1 0 120956188 9388032 330 18446744073709551615 4194304 5129932 140733371473168 140733371471312 140141701170270 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/22860/statm: 2292 330 280 229 0 52 0
[pid=22863] ppid=22860 vsize=1051312 CPUtime=292.7
/proc/22863/stat : 22863 (java) S 22860 22860 1750 0 -1 4202496 168920 0 1 0 29205 65 0 0 20 0 11 0 120956191 1076543488 163624 18446744073709551615 4194304 4228012 140735647362096 140735647353120 140260021886581 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22863/statm: 262828 163624 2393 9 0 250178 0
[pid=22863/tid=22864] ppid=22860 vsize=1051312 CPUtime=260.27
/proc/22863/task/22864/stat : 22864 (java) S 22860 22860 1750 0 -1 4202560 47825 0 1 0 26004 23 0 0 20 0 11 0 120956192 1076543488 163624 18446744073709551615 4194304 4228012 140735647362096 140260028421040 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 9 0 0
[pid=22863/tid=22865] ppid=22860 vsize=1051312 CPUtime=27.67
/proc/22863/task/22865/stat : 22865 (java) S 22860 22860 1750 0 -1 4202560 99766 0 0 0 2733 34 0 0 20 0 11 0 120956196 1076543488 163624 18446744073709551615 4194304 4228012 140735647362096 140259921058944 140260021900875 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22866] ppid=22860 vsize=1051312 CPUtime=0
/proc/22863/task/22866/stat : 22866 (java) S 22860 22860 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120956196 1076543488 163624 18446744073709551615 4194304 4228012 140735647362096 140259920005136 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22867] ppid=22860 vsize=1051312 CPUtime=0
/proc/22863/task/22867/stat : 22867 (java) S 22860 22860 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120956196 1076543488 163624 18446744073709551615 4194304 4228012 140735647362096 140259918952352 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22868] ppid=22860 vsize=1051312 CPUtime=0
/proc/22863/task/22868/stat : 22868 (java) S 22860 22860 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120956199 1076543488 163624 18446744073709551615 4194304 4228012 140735647362096 140259917900784 140260021908512 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22869] ppid=22860 vsize=1051312 CPUtime=2.47
/proc/22863/task/22869/stat : 22869 (java) S 22860 22860 1750 0 -1 4202560 10180 0 0 0 245 2 0 0 20 0 11 0 120956199 1076543488 163624 18446744073709551615 4194304 4228012 140735647362096 140259916848144 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22870] ppid=22860 vsize=1051312 CPUtime=2.12
/proc/22863/task/22870/stat : 22870 (java) S 22860 22860 1750 0 -1 4202560 9821 0 0 0 208 4 0 0 20 0 11 0 120956199 1076543488 163624 18446744073709551615 4194304 4228012 140735647362096 140259915795472 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22871] ppid=22860 vsize=1051312 CPUtime=0
/proc/22863/task/22871/stat : 22871 (java) S 22860 22860 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120956199 1076543488 163624 18446744073709551615 4194304 4228012 140735647362096 140259914742992 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22872] ppid=22860 vsize=1051312 CPUtime=0.13
/proc/22863/task/22872/stat : 22872 (java) S 22860 22860 1750 0 -1 4202560 24 0 0 0 13 0 0 0 20 0 11 0 120956199 1076543488 163624 18446744073709551615 4194304 4228012 140735647362096 140259913690496 140260021900875 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 292.7
Current children cumulated vsize (KiB) 1060480

[startup+297.201 s]
/proc/loadavg: 1.00 1.02 1.04 1/71 22882
/proc/meminfo: memFree=10024/1022884 swapFree=0/0
[pid=22860] ppid=22859 vsize=9168 CPUtime=0
/proc/22860/stat : 22860 (p2cudf-full-1.1) S 22859 22860 1750 0 -1 4202496 455 291 2 1 0 0 0 0 20 0 1 0 120956188 9388032 330 18446744073709551615 4194304 5129932 140733371473168 140733371471312 140141701170270 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/22860/statm: 2292 330 280 229 0 52 0
[pid=22863] ppid=22860 vsize=1051312 CPUtime=292.84
/proc/22863/stat : 22863 (java) S 22860 22860 1750 0 -1 4202496 168922 0 1 0 29215 69 0 0 20 0 11 0 120956191 1076543488 163626 18446744073709551615 4194304 4228012 140735647362096 140735647353120 140260021886581 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22863/statm: 262828 163626 2393 9 0 250178 0
[pid=22863/tid=22864] ppid=22860 vsize=1051312 CPUtime=260.27
/proc/22863/task/22864/stat : 22864 (java) S 22860 22860 1750 0 -1 4202560 47825 0 1 0 26004 23 0 0 20 0 11 0 120956192 1076543488 163626 18446744073709551615 4194304 4228012 140735647362096 140260028421040 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 9 0 0
[pid=22863/tid=22865] ppid=22860 vsize=1051312 CPUtime=27.67
/proc/22863/task/22865/stat : 22865 (java) S 22860 22860 1750 0 -1 4202560 99766 0 0 0 2733 34 0 0 20 0 11 0 120956196 1076543488 163626 18446744073709551615 4194304 4228012 140735647362096 140259921058944 140260021900875 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22866] ppid=22860 vsize=1051312 CPUtime=0
/proc/22863/task/22866/stat : 22866 (java) S 22860 22860 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120956196 1076543488 163626 18446744073709551615 4194304 4228012 140735647362096 140259920005136 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22867] ppid=22860 vsize=1051312 CPUtime=0
/proc/22863/task/22867/stat : 22867 (java) S 22860 22860 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120956196 1076543488 163626 18446744073709551615 4194304 4228012 140735647362096 140259918952352 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22868] ppid=22860 vsize=1051312 CPUtime=0
/proc/22863/task/22868/stat : 22868 (java) S 22860 22860 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120956199 1076543488 163626 18446744073709551615 4194304 4228012 140735647362096 140259917900784 140260021908512 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22869] ppid=22860 vsize=1051312 CPUtime=2.48
/proc/22863/task/22869/stat : 22869 (java) S 22860 22860 1750 0 -1 4202560 10180 0 0 0 246 2 0 0 20 0 11 0 120956199 1076543488 163626 18446744073709551615 4194304 4228012 140735647362096 140259916848144 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22870] ppid=22860 vsize=1051312 CPUtime=2.13
/proc/22863/task/22870/stat : 22870 (java) S 22860 22860 1750 0 -1 4202560 9821 0 0 0 209 4 0 0 20 0 11 0 120956199 1076543488 163626 18446744073709551615 4194304 4228012 140735647362096 140259915795472 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22871] ppid=22860 vsize=1051312 CPUtime=0
/proc/22863/task/22871/stat : 22871 (java) S 22860 22860 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120956199 1076543488 163626 18446744073709551615 4194304 4228012 140735647362096 140259914742992 140260021899988 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22872] ppid=22860 vsize=1051312 CPUtime=0.13
/proc/22863/task/22872/stat : 22872 (java) S 22860 22860 1750 0 -1 4202560 24 0 0 0 13 0 0 0 20 0 11 0 120956199 1076543488 163626 18446744073709551615 4194304 4228012 140735647362096 140259913690496 140260021900875 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22863/tid=22882] ppid=22860 vsize=1051312 CPUtime=0.1
/proc/22863/task/22882/stat : 22882 (java) R 22860 22860 1750 0 -1 4202560 8 0 0 0 6 4 0 0 20 0 11 0 120985844 1076543488 163626 18446744073709551615 4194304 4228012 140735647362096 140259911431472 140259925927777 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 292.84
Current children cumulated vsize (KiB) 1060480

Child status: 0
Real time (s): 297.263
CPU time (s): 292.914
CPU user time (s): 292.178
CPU system time (s): 0.736046
CPU usage (%): 98.5372
Max. virtual memory (cumulated for all children) (KiB): 1063420

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 292.178
system time used= 0.736046
maximum resident set size= 654540
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 169692
page faults= 4
swaps= 0
block input operations= 68776
block output operations= 560
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 7297
involuntary context switches= 41718

runsolver used 0.908056 second user time and 1.98812 second system time

The end