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/install/rand308.cudf.log.runsolver /home/competition/p2cudf-full-1.15/p2cudf-full-1.15 /home/competition/data/install/rand308.cudf /tmp/misc2012/2012-09-02-22:42/full/p2cudf-full-1.15/slowlink/install/rand308.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.01 1.04 1.00 2/59 5856
/proc/meminfo: memFree=607988/1022884 swapFree=0/0
[pid=5856] ppid=5855 vsize=1068 CPUtime=0
/proc/5856/stat : 5856 (p2cudf-full-1.1) D 5855 5856 1733 0 -1 4194304 75 0 0 0 0 0 0 0 20 0 1 0 120701257 1093632 1 18446744073709551615 0 0 140734793575370 4291382576 4151329840 0 0 16781316 0 0 0 0 17 0 0 0 0 0 0
/proc/5856/statm: 267 1 0 0 0 28 0

[startup+0.194275 s]
/proc/loadavg: 1.01 1.04 1.00 2/59 5856
/proc/meminfo: memFree=607988/1022884 swapFree=0/0
[pid=5856] ppid=5855 vsize=9168 CPUtime=0
/proc/5856/stat : 5856 (p2cudf-full-1.1) S 5855 5856 1733 0 -1 4202496 454 292 2 1 0 0 0 0 20 0 1 0 120701257 9388032 331 18446744073709551615 4194304 5129932 140734793570912 140734793569056 139890145813598 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/5856/statm: 2292 331 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.200315 s]
/proc/loadavg: 1.01 1.04 1.00 2/59 5856
/proc/meminfo: memFree=607988/1022884 swapFree=0/0
[pid=5856] ppid=5855 vsize=9168 CPUtime=0
/proc/5856/stat : 5856 (p2cudf-full-1.1) S 5855 5856 1733 0 -1 4202496 454 292 2 1 0 0 0 0 20 0 1 0 120701257 9388032 331 18446744073709551615 4194304 5129932 140734793570912 140734793569056 139890145813598 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/5856/statm: 2292 331 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.300305 s]
/proc/loadavg: 1.01 1.04 1.00 2/59 5856
/proc/meminfo: memFree=607988/1022884 swapFree=0/0
[pid=5856] ppid=5855 vsize=9168 CPUtime=0
/proc/5856/stat : 5856 (p2cudf-full-1.1) S 5855 5856 1733 0 -1 4202496 454 292 2 1 0 0 0 0 20 0 1 0 120701257 9388032 331 18446744073709551615 4194304 5129932 140734793570912 140734793569056 139890145813598 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/5856/statm: 2292 331 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.700277 s]
/proc/loadavg: 1.01 1.04 1.00 2/59 5856
/proc/meminfo: memFree=607988/1022884 swapFree=0/0
[pid=5856] ppid=5855 vsize=9168 CPUtime=0
/proc/5856/stat : 5856 (p2cudf-full-1.1) S 5855 5856 1733 0 -1 4202496 454 292 2 1 0 0 0 0 20 0 1 0 120701257 9388032 331 18446744073709551615 4194304 5129932 140734793570912 140734793569056 139890145813598 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/5856/statm: 2292 331 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+1.50073 s]
/proc/loadavg: 1.01 1.04 1.00 4/70 5868
/proc/meminfo: memFree=573916/1022884 swapFree=0/0
[pid=5856] ppid=5855 vsize=9168 CPUtime=0
/proc/5856/stat : 5856 (p2cudf-full-1.1) S 5855 5856 1733 0 -1 4202496 454 292 2 1 0 0 0 0 20 0 1 0 120701257 9388032 331 18446744073709551615 4194304 5129932 140734793570912 140734793569056 139890145813598 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/5856/statm: 2292 331 280 229 0 52 0
[pid=5859] ppid=5856 vsize=1041620 CPUtime=1.27
/proc/5859/stat : 5859 (java) S 5856 5856 1733 0 -1 4202496 24724 0 20 0 118 9 0 0 20 0 10 0 120701261 1066618880 22224 18446744073709551615 4194304 4228012 140733480623584 140733480614608 140648216055413 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 3 0 0
/proc/5859/statm: 260405 22224 2345 9 0 247755 0
[pid=5859/tid=5860] ppid=5856 vsize=1041620 CPUtime=0.63
/proc/5859/task/5860/stat : 5860 (java) R 5856 5856 1733 0 -1 4202560 11739 0 8 0 58 5 0 0 20 0 10 0 120701266 1066618880 22224 18446744073709551615 4194304 4228012 140733480623584 140648222581408 140648120080228 0 4 0 16800975 0 0 0 -1 0 0 0 14 0 0
[pid=5859/tid=5861] ppid=5856 vsize=1041620 CPUtime=0
/proc/5859/task/5861/stat : 5861 (java) S 5856 5856 1733 0 -1 4202560 3 0 0 0 0 0 0 0 20 0 10 0 120701274 1066618880 22224 18446744073709551615 4194304 4228012 140733480623584 140648115227776 140648216069707 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5862] ppid=5856 vsize=1041620 CPUtime=0
/proc/5859/task/5862/stat : 5862 (java) S 5856 5856 1733 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 10 0 120701275 1066618880 22224 18446744073709551615 4194304 4228012 140733480623584 140648114173968 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5863] ppid=5856 vsize=1041620 CPUtime=0
/proc/5859/task/5863/stat : 5863 (java) S 5856 5856 1733 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 10 0 120701275 1066618880 22224 18446744073709551615 4194304 4228012 140733480623584 140648113121184 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5864] ppid=5856 vsize=1041620 CPUtime=0
/proc/5859/task/5864/stat : 5864 (java) S 5856 5856 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 120701282 1066618880 22224 18446744073709551615 4194304 4228012 140733480623584 140648112069616 140648216077344 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5865] ppid=5856 vsize=1041620 CPUtime=0.32
/proc/5859/task/5865/stat : 5865 (java) R 5856 5856 1733 0 -1 4202560 6116 0 0 0 30 2 0 0 20 0 10 0 120701283 1066618880 22224 18446744073709551615 4194304 4228012 140733480623584 140648111001992 140648201726998 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5866] ppid=5856 vsize=1041620 CPUtime=0.31
/proc/5859/task/5866/stat : 5866 (java) R 5856 5856 1733 0 -1 4202560 5591 0 0 0 29 2 0 0 20 0 10 0 120701283 1066618880 22224 18446744073709551615 4194304 4228012 140733480623584 140648109948056 140648208633267 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5867] ppid=5856 vsize=1041620 CPUtime=0
/proc/5859/task/5867/stat : 5867 (java) S 5856 5856 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 120701283 1066618880 22224 18446744073709551615 4194304 4228012 140733480623584 140648108911824 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5868] ppid=5856 vsize=1041620 CPUtime=0
/proc/5859/task/5868/stat : 5868 (java) S 5856 5856 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 120701283 1066618880 22224 18446744073709551615 4194304 4228012 140733480623584 140648107859328 140648216069707 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 1.27
Current children cumulated vsize (KiB) 1050788

[startup+3.10075 s]
/proc/loadavg: 1.01 1.04 1.00 4/70 5868
/proc/meminfo: memFree=468888/1022884 swapFree=0/0
[pid=5856] ppid=5855 vsize=9168 CPUtime=0
/proc/5856/stat : 5856 (p2cudf-full-1.1) S 5855 5856 1733 0 -1 4202496 454 292 2 1 0 0 0 0 20 0 1 0 120701257 9388032 331 18446744073709551615 4194304 5129932 140734793570912 140734793569056 139890145813598 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/5856/statm: 2292 331 280 229 0 52 0
[pid=5859] ppid=5856 vsize=1051756 CPUtime=2.85
/proc/5859/stat : 5859 (java) S 5856 5856 1733 0 -1 4202496 76550 0 20 0 254 31 0 0 20 0 10 0 120701261 1076998144 71046 18446744073709551615 4194304 4228012 140733480623584 140733480614608 140648216055413 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 3 0 0
/proc/5859/statm: 262939 71046 2366 9 0 250289 0
[pid=5859/tid=5860] ppid=5856 vsize=1051756 CPUtime=1.36
/proc/5859/task/5860/stat : 5860 (java) R 5856 5856 1733 0 -1 4202560 47393 0 8 0 117 19 0 0 20 0 10 0 120701266 1076998144 71046 18446744073709551615 4194304 4228012 140733480623584 140648222581440 140648120053747 0 4 0 16800975 0 0 0 -1 0 0 0 15 0 0
[pid=5859/tid=5861] ppid=5856 vsize=1051756 CPUtime=0.15
/proc/5859/task/5861/stat : 5861 (java) S 5856 5856 1733 0 -1 4202560 7952 0 0 0 12 3 0 0 20 0 10 0 120701274 1076998144 71046 18446744073709551615 4194304 4228012 140733480623584 140648115227776 140648216069707 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5862] ppid=5856 vsize=1051756 CPUtime=0
/proc/5859/task/5862/stat : 5862 (java) S 5856 5856 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 120701275 1076998144 71046 18446744073709551615 4194304 4228012 140733480623584 140648114173968 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5863] ppid=5856 vsize=1051756 CPUtime=0
/proc/5859/task/5863/stat : 5863 (java) S 5856 5856 1733 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 10 0 120701275 1076998144 71046 18446744073709551615 4194304 4228012 140733480623584 140648113121184 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5864] ppid=5856 vsize=1051756 CPUtime=0
/proc/5859/task/5864/stat : 5864 (java) S 5856 5856 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 120701282 1076998144 71046 18446744073709551615 4194304 4228012 140733480623584 140648112069616 140648216077344 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5865] ppid=5856 vsize=1051756 CPUtime=0.64
/proc/5859/task/5865/stat : 5865 (java) S 5856 5856 1733 0 -1 4202560 11610 0 0 0 59 5 0 0 20 0 10 0 120701283 1076998144 71046 18446744073709551615 4194304 4228012 140733480623584 140648111016976 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5866] ppid=5856 vsize=1051756 CPUtime=0.66
/proc/5859/task/5866/stat : 5866 (java) S 5856 5856 1733 0 -1 4202560 8316 0 0 0 62 4 0 0 20 0 10 0 120701283 1076998144 71046 18446744073709551615 4194304 4228012 140733480623584 140648109964304 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5867] ppid=5856 vsize=1051756 CPUtime=0
/proc/5859/task/5867/stat : 5867 (java) S 5856 5856 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 120701283 1076998144 71046 18446744073709551615 4194304 4228012 140733480623584 140648108911824 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5868] ppid=5856 vsize=1051756 CPUtime=0
/proc/5859/task/5868/stat : 5868 (java) S 5856 5856 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 120701283 1076998144 71046 18446744073709551615 4194304 4228012 140733480623584 140648107859328 140648216069707 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 2.85
Current children cumulated vsize (KiB) 1060924

[startup+6.30075 s]
/proc/loadavg: 1.17 1.07 1.01 2/70 5868
/proc/meminfo: memFree=178852/1022884 swapFree=0/0
[pid=5856] ppid=5855 vsize=9168 CPUtime=0
/proc/5856/stat : 5856 (p2cudf-full-1.1) S 5855 5856 1733 0 -1 4202496 454 292 2 1 0 0 0 0 20 0 1 0 120701257 9388032 331 18446744073709551615 4194304 5129932 140734793570912 140734793569056 139890145813598 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/5856/statm: 2292 331 280 229 0 52 0
[pid=5859] ppid=5856 vsize=1048908 CPUtime=6
/proc/5859/stat : 5859 (java) S 5856 5856 1733 0 -1 4202496 121871 0 20 0 550 50 0 0 20 0 10 0 120701261 1074081792 115807 18446744073709551615 4194304 4228012 140733480623584 140733480614608 140648216055413 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 3 0 0
/proc/5859/statm: 262227 115807 2368 9 0 249577 0
[pid=5859/tid=5860] ppid=5856 vsize=1048908 CPUtime=3.32
/proc/5859/task/5860/stat : 5860 (java) R 5856 5856 1733 0 -1 4202560 47395 0 8 0 310 22 0 0 20 0 10 0 120701266 1074081792 115807 18446744073709551615 4194304 4228012 140733480623584 140648222581440 140648120652977 0 4 0 16800975 0 0 0 -1 0 0 0 16 0 0
[pid=5859/tid=5861] ppid=5856 vsize=1048908 CPUtime=1.27
/proc/5859/task/5861/stat : 5861 (java) S 5856 5856 1733 0 -1 4202560 53239 0 0 0 109 18 0 0 20 0 10 0 120701274 1074081792 115807 18446744073709551615 4194304 4228012 140733480623584 140648115227776 140648216069707 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5862] ppid=5856 vsize=1048908 CPUtime=0
/proc/5859/task/5862/stat : 5862 (java) S 5856 5856 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 120701275 1074081792 115807 18446744073709551615 4194304 4228012 140733480623584 140648114173968 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5863] ppid=5856 vsize=1048908 CPUtime=0
/proc/5859/task/5863/stat : 5863 (java) S 5856 5856 1733 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 10 0 120701275 1074081792 115807 18446744073709551615 4194304 4228012 140733480623584 140648113121184 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5864] ppid=5856 vsize=1048908 CPUtime=0
/proc/5859/task/5864/stat : 5864 (java) S 5856 5856 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 120701282 1074081792 115807 18446744073709551615 4194304 4228012 140733480623584 140648112069616 140648216077344 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5865] ppid=5856 vsize=1048908 CPUtime=0.69
/proc/5859/task/5865/stat : 5865 (java) S 5856 5856 1733 0 -1 4202560 11641 0 0 0 64 5 0 0 20 0 10 0 120701283 1074081792 115807 18446744073709551615 4194304 4228012 140733480623584 140648111016976 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5866] ppid=5856 vsize=1048908 CPUtime=0.69
/proc/5859/task/5866/stat : 5866 (java) S 5856 5856 1733 0 -1 4202560 8316 0 0 0 65 4 0 0 20 0 10 0 120701283 1074081792 115807 18446744073709551615 4194304 4228012 140733480623584 140648109964304 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5867] ppid=5856 vsize=1048908 CPUtime=0
/proc/5859/task/5867/stat : 5867 (java) S 5856 5856 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 120701283 1074081792 115807 18446744073709551615 4194304 4228012 140733480623584 140648108911824 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5868] ppid=5856 vsize=1048908 CPUtime=0
/proc/5859/task/5868/stat : 5868 (java) S 5856 5856 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 120701283 1074081792 115807 18446744073709551615 4194304 4228012 140733480623584 140648107859328 140648216069707 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 6
Current children cumulated vsize (KiB) 1058076

[startup+12.7008 s]
/proc/loadavg: 1.15 1.07 1.01 3/70 5868
/proc/meminfo: memFree=18148/1022884 swapFree=0/0
[pid=5856] ppid=5855 vsize=9168 CPUtime=0
/proc/5856/stat : 5856 (p2cudf-full-1.1) S 5855 5856 1733 0 -1 4202496 454 292 2 1 0 0 0 0 20 0 1 0 120701257 9388032 331 18446744073709551615 4194304 5129932 140734793570912 140734793569056 139890145813598 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/5856/statm: 2292 331 280 229 0 52 0
[pid=5859] ppid=5856 vsize=1048908 CPUtime=12.27
/proc/5859/stat : 5859 (java) S 5856 5856 1733 0 -1 4202496 153153 0 20 0 1167 60 0 0 20 0 10 0 120701261 1074081792 147089 18446744073709551615 4194304 4228012 140733480623584 140733480614608 140648216055413 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 3 0 0
/proc/5859/statm: 262227 147089 2377 9 0 249577 0
[pid=5859/tid=5860] ppid=5856 vsize=1048908 CPUtime=6.16
/proc/5859/task/5860/stat : 5860 (java) R 5856 5856 1733 0 -1 4202560 47742 0 8 0 591 25 0 0 20 0 10 0 120701266 1074081792 147089 18446744073709551615 4194304 4228012 140733480623584 140648222589144 140648120068627 0 4 0 16800975 0 0 0 -1 0 0 0 16 0 0
[pid=5859/tid=5861] ppid=5856 vsize=1048908 CPUtime=2.18
/proc/5859/task/5861/stat : 5861 (java) S 5856 5856 1733 0 -1 4202560 83809 0 0 0 192 26 0 0 20 0 10 0 120701274 1074081792 147089 18446744073709551615 4194304 4228012 140733480623584 140648115227776 140648216069707 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5862] ppid=5856 vsize=1048908 CPUtime=0
/proc/5859/task/5862/stat : 5862 (java) S 5856 5856 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 120701275 1074081792 147089 18446744073709551615 4194304 4228012 140733480623584 140648114173968 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5863] ppid=5856 vsize=1048908 CPUtime=0
/proc/5859/task/5863/stat : 5863 (java) S 5856 5856 1733 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 10 0 120701275 1074081792 147089 18446744073709551615 4194304 4228012 140733480623584 140648113121184 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5864] ppid=5856 vsize=1048908 CPUtime=0
/proc/5859/task/5864/stat : 5864 (java) S 5856 5856 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 120701282 1074081792 147089 18446744073709551615 4194304 4228012 140733480623584 140648112069616 140648216077344 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5865] ppid=5856 vsize=1048908 CPUtime=1.95
/proc/5859/task/5865/stat : 5865 (java) S 5856 5856 1733 0 -1 4202560 11809 0 0 0 190 5 0 0 20 0 10 0 120701283 1074081792 147089 18446744073709551615 4194304 4228012 140733480623584 140648111016976 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5866] ppid=5856 vsize=1048908 CPUtime=1.95
/proc/5859/task/5866/stat : 5866 (java) R 5856 5856 1733 0 -1 4202560 8513 0 0 0 191 4 0 0 20 0 10 0 120701283 1074081792 147089 18446744073709551615 4194304 4228012 140733480623584 140648109964048 140648200337451 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5867] ppid=5856 vsize=1048908 CPUtime=0
/proc/5859/task/5867/stat : 5867 (java) S 5856 5856 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 120701283 1074081792 147089 18446744073709551615 4194304 4228012 140733480623584 140648108911824 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5868] ppid=5856 vsize=1048908 CPUtime=0
/proc/5859/task/5868/stat : 5868 (java) S 5856 5856 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 120701283 1074081792 147089 18446744073709551615 4194304 4228012 140733480623584 140648107859328 140648216069707 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 12.27
Current children cumulated vsize (KiB) 1058076

[startup+25.5009 s]
/proc/loadavg: 1.12 1.07 1.01 2/71 5869
/proc/meminfo: memFree=9924/1022884 swapFree=0/0
[pid=5856] ppid=5855 vsize=9168 CPUtime=0
/proc/5856/stat : 5856 (p2cudf-full-1.1) S 5855 5856 1733 0 -1 4202496 454 292 2 1 0 0 0 0 20 0 1 0 120701257 9388032 331 18446744073709551615 4194304 5129932 140734793570912 140734793569056 139890145813598 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/5856/statm: 2292 331 280 229 0 52 0
[pid=5859] ppid=5856 vsize=1049936 CPUtime=24.85
/proc/5859/stat : 5859 (java) S 5856 5856 1733 0 -1 4202496 160389 0 20 0 2420 65 0 0 20 0 11 0 120701261 1075134464 154325 18446744073709551615 4194304 4228012 140733480623584 140733480614608 140648216055413 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 3 0 0
/proc/5859/statm: 262484 154325 2393 9 0 249834 0
[pid=5859/tid=5860] ppid=5856 vsize=1049936 CPUtime=16.72
/proc/5859/task/5860/stat : 5860 (java) R 5856 5856 1733 0 -1 4202560 47782 0 8 0 1646 26 0 0 20 0 11 0 120701266 1075134464 154325 18446744073709551615 4194304 4228012 140733480623584 140648222589016 140648120605792 0 4 0 16800975 0 0 0 -1 0 0 0 16 0 0
[pid=5859/tid=5861] ppid=5856 vsize=1049936 CPUtime=3.32
/proc/5859/task/5861/stat : 5861 (java) S 5856 5856 1733 0 -1 4202560 90962 0 0 0 302 30 0 0 20 0 11 0 120701274 1075134464 154325 18446744073709551615 4194304 4228012 140733480623584 140648115227776 140648216069707 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5862] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5862/stat : 5862 (java) S 5856 5856 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120701275 1075134464 154325 18446744073709551615 4194304 4228012 140733480623584 140648114173968 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5863] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5863/stat : 5863 (java) S 5856 5856 1733 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120701275 1075134464 154325 18446744073709551615 4194304 4228012 140733480623584 140648113121184 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5864] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5864/stat : 5864 (java) S 5856 5856 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120701282 1075134464 154325 18446744073709551615 4194304 4228012 140733480623584 140648112069616 140648216077344 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5865] ppid=5856 vsize=1049936 CPUtime=2.39
/proc/5859/task/5865/stat : 5865 (java) S 5856 5856 1733 0 -1 4202560 11826 0 0 0 233 6 0 0 20 0 11 0 120701283 1075134464 154325 18446744073709551615 4194304 4228012 140733480623584 140648111016976 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5866] ppid=5856 vsize=1049936 CPUtime=2.39
/proc/5859/task/5866/stat : 5866 (java) S 5856 5856 1733 0 -1 4202560 8533 0 0 0 235 4 0 0 20 0 11 0 120701283 1075134464 154325 18446744073709551615 4194304 4228012 140733480623584 140648109964304 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5867] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5867/stat : 5867 (java) S 5856 5856 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120701283 1075134464 154325 18446744073709551615 4194304 4228012 140733480623584 140648108911824 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5868] ppid=5856 vsize=1049936 CPUtime=0.01
/proc/5859/task/5868/stat : 5868 (java) S 5856 5856 1733 0 -1 4202560 1 0 0 0 1 0 0 0 20 0 11 0 120701283 1075134464 154325 18446744073709551615 4194304 4228012 140733480623584 140648107859328 140648216069707 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5869] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5869/stat : 5869 (java) S 5856 5856 1733 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120702532 1075134464 154325 18446744073709551615 4194304 4228012 140733480623584 140648106653536 140648216069707 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 24.85
Current children cumulated vsize (KiB) 1059104

[startup+51.1008 s]
/proc/loadavg: 1.08 1.06 1.01 2/71 5869
/proc/meminfo: memFree=10052/1022884 swapFree=0/0
[pid=5856] ppid=5855 vsize=9168 CPUtime=0
/proc/5856/stat : 5856 (p2cudf-full-1.1) S 5855 5856 1733 0 -1 4202496 454 292 2 1 0 0 0 0 20 0 1 0 120701257 9388032 331 18446744073709551615 4194304 5129932 140734793570912 140734793569056 139890145813598 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/5856/statm: 2292 331 280 229 0 52 0
[pid=5859] ppid=5856 vsize=1049936 CPUtime=50.02
/proc/5859/stat : 5859 (java) S 5856 5856 1733 0 -1 4202496 162438 0 20 0 4935 67 0 0 20 0 11 0 120701261 1075134464 156370 18446744073709551615 4194304 4228012 140733480623584 140733480614608 140648216055413 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 3 0 0
/proc/5859/statm: 262484 156370 2393 9 0 249834 0
[pid=5859/tid=5860] ppid=5856 vsize=1049936 CPUtime=40.72
/proc/5859/task/5860/stat : 5860 (java) R 5856 5856 1733 0 -1 4202560 47783 0 8 0 4046 26 0 0 20 0 11 0 120701266 1075134464 156370 18446744073709551615 4194304 4228012 140733480623584 140648222589032 140648120606316 0 4 0 16800975 0 0 0 -1 0 0 0 16 0 0
[pid=5859/tid=5861] ppid=5856 vsize=1049936 CPUtime=4.42
/proc/5859/task/5861/stat : 5861 (java) S 5856 5856 1733 0 -1 4202560 93007 0 0 0 411 31 0 0 20 0 11 0 120701274 1075134464 156370 18446744073709551615 4194304 4228012 140733480623584 140648115227776 140648216069707 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5862] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5862/stat : 5862 (java) S 5856 5856 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120701275 1075134464 156370 18446744073709551615 4194304 4228012 140733480623584 140648114173968 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5863] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5863/stat : 5863 (java) S 5856 5856 1733 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120701275 1075134464 156370 18446744073709551615 4194304 4228012 140733480623584 140648113121184 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5864] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5864/stat : 5864 (java) S 5856 5856 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120701282 1075134464 156370 18446744073709551615 4194304 4228012 140733480623584 140648112069616 140648216077344 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5865] ppid=5856 vsize=1049936 CPUtime=2.4
/proc/5859/task/5865/stat : 5865 (java) S 5856 5856 1733 0 -1 4202560 11826 0 0 0 234 6 0 0 20 0 11 0 120701283 1075134464 156370 18446744073709551615 4194304 4228012 140733480623584 140648111016976 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5866] ppid=5856 vsize=1049936 CPUtime=2.43
/proc/5859/task/5866/stat : 5866 (java) S 5856 5856 1733 0 -1 4202560 8533 0 0 0 239 4 0 0 20 0 11 0 120701283 1075134464 156370 18446744073709551615 4194304 4228012 140733480623584 140648109964304 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5867] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5867/stat : 5867 (java) S 5856 5856 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120701283 1075134464 156370 18446744073709551615 4194304 4228012 140733480623584 140648108911824 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5868] ppid=5856 vsize=1049936 CPUtime=0.02
/proc/5859/task/5868/stat : 5868 (java) S 5856 5856 1733 0 -1 4202560 4 0 0 0 2 0 0 0 20 0 11 0 120701283 1075134464 156370 18446744073709551615 4194304 4228012 140733480623584 140648107859328 140648216069707 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5869] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5869/stat : 5869 (java) S 5856 5856 1733 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120702532 1075134464 156370 18446744073709551615 4194304 4228012 140733480623584 140648106653536 140648216069707 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 50.02
Current children cumulated vsize (KiB) 1059104

[startup+102.301 s]
/proc/loadavg: 1.28 1.12 1.03 2/71 6120
/proc/meminfo: memFree=21388/1022884 swapFree=0/0
[pid=5856] ppid=5855 vsize=9168 CPUtime=0
/proc/5856/stat : 5856 (p2cudf-full-1.1) S 5855 5856 1733 0 -1 4202496 454 292 2 1 0 0 0 0 20 0 1 0 120701257 9388032 331 18446744073709551615 4194304 5129932 140734793570912 140734793569056 139890145813598 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/5856/statm: 2292 331 280 229 0 52 0
[pid=5859] ppid=5856 vsize=1049936 CPUtime=91.98
/proc/5859/stat : 5859 (java) S 5856 5856 1733 0 -1 4202496 164600 0 20 0 9129 69 0 0 20 0 11 0 120701261 1075134464 158524 18446744073709551615 4194304 4228012 140733480623584 140733480614608 140648216055413 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 3 0 0
/proc/5859/statm: 262484 158524 2393 9 0 249834 0
[pid=5859/tid=5860] ppid=5856 vsize=1049936 CPUtime=80.23
/proc/5859/task/5860/stat : 5860 (java) R 5856 5856 1733 0 -1 4202560 47783 0 8 0 7996 27 0 0 20 0 11 0 120701266 1075134464 158524 18446744073709551615 4194304 4228012 140733480623584 140648222588888 140648120605792 0 4 0 16800975 0 0 0 -1 0 0 0 16 0 0
[pid=5859/tid=5861] ppid=5856 vsize=1049936 CPUtime=6.79
/proc/5859/task/5861/stat : 5861 (java) S 5856 5856 1733 0 -1 4202560 95163 0 0 0 647 32 0 0 20 0 11 0 120701274 1075134464 158524 18446744073709551615 4194304 4228012 140733480623584 140648115227776 140648216069707 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5862] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5862/stat : 5862 (java) S 5856 5856 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120701275 1075134464 158524 18446744073709551615 4194304 4228012 140733480623584 140648114173968 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5863] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5863/stat : 5863 (java) S 5856 5856 1733 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120701275 1075134464 158524 18446744073709551615 4194304 4228012 140733480623584 140648113121184 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5864] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5864/stat : 5864 (java) S 5856 5856 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120701282 1075134464 158524 18446744073709551615 4194304 4228012 140733480623584 140648112069616 140648216077344 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5865] ppid=5856 vsize=1049936 CPUtime=2.44
/proc/5859/task/5865/stat : 5865 (java) S 5856 5856 1733 0 -1 4202560 11826 0 0 0 238 6 0 0 20 0 11 0 120701283 1075134464 158524 18446744073709551615 4194304 4228012 140733480623584 140648111016976 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5866] ppid=5856 vsize=1049936 CPUtime=2.45
/proc/5859/task/5866/stat : 5866 (java) S 5856 5856 1733 0 -1 4202560 8533 0 0 0 241 4 0 0 20 0 11 0 120701283 1075134464 158524 18446744073709551615 4194304 4228012 140733480623584 140648109964304 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5867] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5867/stat : 5867 (java) S 5856 5856 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120701283 1075134464 158524 18446744073709551615 4194304 4228012 140733480623584 140648108911824 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5868] ppid=5856 vsize=1049936 CPUtime=0.05
/proc/5859/task/5868/stat : 5868 (java) S 5856 5856 1733 0 -1 4202560 10 0 0 0 5 0 0 0 20 0 11 0 120701283 1075134464 158524 18446744073709551615 4194304 4228012 140733480623584 140648107859328 140648216069707 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5869] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5869/stat : 5869 (java) S 5856 5856 1733 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120702532 1075134464 158524 18446744073709551615 4194304 4228012 140733480623584 140648106653536 140648216069707 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 91.98
Current children cumulated vsize (KiB) 1059104

[startup+162.301 s]
/proc/loadavg: 1.16 1.11 1.03 2/71 6120
/proc/meminfo: memFree=11964/1022884 swapFree=0/0
[pid=5856] ppid=5855 vsize=9168 CPUtime=0
/proc/5856/stat : 5856 (p2cudf-full-1.1) S 5855 5856 1733 0 -1 4202496 454 292 2 1 0 0 0 0 20 0 1 0 120701257 9388032 331 18446744073709551615 4194304 5129932 140734793570912 140734793569056 139890145813598 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/5856/statm: 2292 331 280 229 0 52 0
[pid=5859] ppid=5856 vsize=1049936 CPUtime=151.29
/proc/5859/stat : 5859 (java) S 5856 5856 1733 0 -1 4202496 167068 0 20 0 15059 70 0 0 20 0 11 0 120701261 1075134464 160984 18446744073709551615 4194304 4228012 140733480623584 140733480614608 140648216055413 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 3 0 0
/proc/5859/statm: 262484 160984 2393 9 0 249834 0
[pid=5859/tid=5860] ppid=5856 vsize=1049936 CPUtime=136.29
/proc/5859/task/5860/stat : 5860 (java) R 5856 5856 1733 0 -1 4202560 47783 0 8 0 13602 27 0 0 20 0 11 0 120701266 1075134464 160984 18446744073709551615 4194304 4228012 140733480623584 140648222588888 140648120606316 0 4 0 16800975 0 0 0 -1 0 0 0 16 0 0
[pid=5859/tid=5861] ppid=5856 vsize=1049936 CPUtime=10.01
/proc/5859/task/5861/stat : 5861 (java) S 5856 5856 1733 0 -1 4202560 97625 0 0 0 968 33 0 0 20 0 11 0 120701274 1075134464 160984 18446744073709551615 4194304 4228012 140733480623584 140648115227776 140648216069707 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5862] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5862/stat : 5862 (java) S 5856 5856 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120701275 1075134464 160984 18446744073709551615 4194304 4228012 140733480623584 140648114173968 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5863] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5863/stat : 5863 (java) S 5856 5856 1733 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120701275 1075134464 160984 18446744073709551615 4194304 4228012 140733480623584 140648113121184 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5864] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5864/stat : 5864 (java) S 5856 5856 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120701282 1075134464 160984 18446744073709551615 4194304 4228012 140733480623584 140648112069616 140648216077344 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5865] ppid=5856 vsize=1049936 CPUtime=2.44
/proc/5859/task/5865/stat : 5865 (java) S 5856 5856 1733 0 -1 4202560 11826 0 0 0 238 6 0 0 20 0 11 0 120701283 1075134464 160984 18446744073709551615 4194304 4228012 140733480623584 140648111016976 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5866] ppid=5856 vsize=1049936 CPUtime=2.45
/proc/5859/task/5866/stat : 5866 (java) S 5856 5856 1733 0 -1 4202560 8533 0 0 0 241 4 0 0 20 0 11 0 120701283 1075134464 160984 18446744073709551615 4194304 4228012 140733480623584 140648109964304 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5867] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5867/stat : 5867 (java) S 5856 5856 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120701283 1075134464 160984 18446744073709551615 4194304 4228012 140733480623584 140648108911824 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5868] ppid=5856 vsize=1049936 CPUtime=0.08
/proc/5859/task/5868/stat : 5868 (java) S 5856 5856 1733 0 -1 4202560 16 0 0 0 8 0 0 0 20 0 11 0 120701283 1075134464 160984 18446744073709551615 4194304 4228012 140733480623584 140648107859328 140648216069707 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5869] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5869/stat : 5869 (java) S 5856 5856 1733 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120702532 1075134464 160984 18446744073709551615 4194304 4228012 140733480623584 140648106653536 140648216069707 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 151.29
Current children cumulated vsize (KiB) 1059104

[startup+222.304 s]
/proc/loadavg: 1.06 1.09 1.02 2/71 6120
/proc/meminfo: memFree=10104/1022884 swapFree=0/0
[pid=5856] ppid=5855 vsize=9168 CPUtime=0
/proc/5856/stat : 5856 (p2cudf-full-1.1) S 5855 5856 1733 0 -1 4202496 454 292 2 1 0 0 0 0 20 0 1 0 120701257 9388032 331 18446744073709551615 4194304 5129932 140734793570912 140734793569056 139890145813598 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/5856/statm: 2292 331 280 229 0 52 0
[pid=5859] ppid=5856 vsize=1049936 CPUtime=210.66
/proc/5859/stat : 5859 (java) S 5856 5856 1733 0 -1 4202496 168298 0 20 0 20996 70 0 0 20 0 11 0 120701261 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140733480614608 140648216055413 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 3 0 0
/proc/5859/statm: 262484 162207 2393 9 0 249834 0
[pid=5859/tid=5860] ppid=5856 vsize=1049936 CPUtime=192.66
/proc/5859/task/5860/stat : 5860 (java) R 5856 5856 1733 0 -1 4202560 47783 0 8 0 19239 27 0 0 20 0 11 0 120701266 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648222588888 140648120605792 0 4 0 16800975 0 0 0 -1 0 0 0 16 0 0
[pid=5859/tid=5861] ppid=5856 vsize=1049936 CPUtime=12.97
/proc/5859/task/5861/stat : 5861 (java) S 5856 5856 1733 0 -1 4202560 98849 0 0 0 1264 33 0 0 20 0 11 0 120701274 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648115227776 140648216069707 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5862] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5862/stat : 5862 (java) S 5856 5856 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120701275 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648114173968 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5863] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5863/stat : 5863 (java) S 5856 5856 1733 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120701275 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648113121184 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5864] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5864/stat : 5864 (java) S 5856 5856 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120701282 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648112069616 140648216077344 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5865] ppid=5856 vsize=1049936 CPUtime=2.45
/proc/5859/task/5865/stat : 5865 (java) S 5856 5856 1733 0 -1 4202560 11826 0 0 0 239 6 0 0 20 0 11 0 120701283 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648111016976 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5866] ppid=5856 vsize=1049936 CPUtime=2.45
/proc/5859/task/5866/stat : 5866 (java) S 5856 5856 1733 0 -1 4202560 8533 0 0 0 241 4 0 0 20 0 11 0 120701283 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648109964304 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5867] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5867/stat : 5867 (java) S 5856 5856 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120701283 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648108911824 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5868] ppid=5856 vsize=1049936 CPUtime=0.11
/proc/5859/task/5868/stat : 5868 (java) S 5856 5856 1733 0 -1 4202560 22 0 0 0 11 0 0 0 20 0 11 0 120701283 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648107859328 140648216069707 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5869] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5869/stat : 5869 (java) S 5856 5856 1733 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120702532 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648106653536 140648216069707 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 210.66
Current children cumulated vsize (KiB) 1059104

[startup+282.301 s]
/proc/loadavg: 1.02 1.07 1.02 2/71 6120
/proc/meminfo: memFree=9980/1022884 swapFree=0/0
[pid=5856] ppid=5855 vsize=9168 CPUtime=0
/proc/5856/stat : 5856 (p2cudf-full-1.1) S 5855 5856 1733 0 -1 4202496 454 292 2 1 0 0 0 0 20 0 1 0 120701257 9388032 331 18446744073709551615 4194304 5129932 140734793570912 140734793569056 139890145813598 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/5856/statm: 2292 331 280 229 0 52 0
[pid=5859] ppid=5856 vsize=1049936 CPUtime=270.04
/proc/5859/stat : 5859 (java) S 5856 5856 1733 0 -1 4202496 168306 0 20 0 26934 70 0 0 20 0 11 0 120701261 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140733480614608 140648216055413 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 3 0 0
/proc/5859/statm: 262484 162207 2393 9 0 249834 0
[pid=5859/tid=5860] ppid=5856 vsize=1049936 CPUtime=249.81
/proc/5859/task/5860/stat : 5860 (java) R 5856 5856 1733 0 -1 4202560 47783 0 8 0 24954 27 0 0 20 0 11 0 120701266 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648222588888 140648120606314 0 4 0 16800975 0 0 0 -1 0 0 0 16 0 0
[pid=5859/tid=5861] ppid=5856 vsize=1049936 CPUtime=15.15
/proc/5859/task/5861/stat : 5861 (java) S 5856 5856 1733 0 -1 4202560 98851 0 0 0 1482 33 0 0 20 0 11 0 120701274 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648115227776 140648216069707 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5862] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5862/stat : 5862 (java) S 5856 5856 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120701275 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648114173968 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5863] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5863/stat : 5863 (java) S 5856 5856 1733 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120701275 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648113121184 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5864] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5864/stat : 5864 (java) S 5856 5856 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120701282 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648112069616 140648216077344 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5865] ppid=5856 vsize=1049936 CPUtime=2.45
/proc/5859/task/5865/stat : 5865 (java) S 5856 5856 1733 0 -1 4202560 11826 0 0 0 239 6 0 0 20 0 11 0 120701283 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648111016976 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5866] ppid=5856 vsize=1049936 CPUtime=2.46
/proc/5859/task/5866/stat : 5866 (java) S 5856 5856 1733 0 -1 4202560 8533 0 0 0 242 4 0 0 20 0 11 0 120701283 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648109964304 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5867] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5867/stat : 5867 (java) S 5856 5856 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120701283 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648108911824 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5868] ppid=5856 vsize=1049936 CPUtime=0.14
/proc/5859/task/5868/stat : 5868 (java) S 5856 5856 1733 0 -1 4202560 28 0 0 0 14 0 0 0 20 0 11 0 120701283 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648107859328 140648216069707 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5869] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5869/stat : 5869 (java) S 5856 5856 1733 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120702532 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648106653536 140648216069707 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 270.04
Current children cumulated vsize (KiB) 1059104

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

[startup+288.001 s]
/proc/loadavg: 1.02 1.07 1.02 2/71 6120
/proc/meminfo: memFree=9980/1022884 swapFree=0/0
[pid=5856] ppid=5855 vsize=9168 CPUtime=0
/proc/5856/stat : 5856 (p2cudf-full-1.1) S 5855 5856 1733 0 -1 4202496 454 292 2 1 0 0 0 0 20 0 1 0 120701257 9388032 331 18446744073709551615 4194304 5129932 140734793570912 140734793569056 139890145813598 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/5856/statm: 2292 331 280 229 0 52 0
[pid=5859] ppid=5856 vsize=1049936 CPUtime=275.68
/proc/5859/stat : 5859 (java) S 5856 5856 1733 0 -1 4202496 168306 0 20 0 27498 70 0 0 20 0 11 0 120701261 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140733480614608 140648216055413 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 3 0 0
/proc/5859/statm: 262484 162207 2393 9 0 249834 0
[pid=5859/tid=5860] ppid=5856 vsize=1049936 CPUtime=255.45
/proc/5859/task/5860/stat : 5860 (java) R 5856 5856 1733 0 -1 4202560 47783 0 8 0 25518 27 0 0 20 0 11 0 120701266 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648222588888 140648121239705 0 4 0 16800975 0 0 0 -1 0 0 0 16 0 0
[pid=5859/tid=5861] ppid=5856 vsize=1049936 CPUtime=15.15
/proc/5859/task/5861/stat : 5861 (java) S 5856 5856 1733 0 -1 4202560 98851 0 0 0 1482 33 0 0 20 0 11 0 120701274 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648115227776 140648216069707 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5862] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5862/stat : 5862 (java) S 5856 5856 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120701275 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648114173968 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5863] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5863/stat : 5863 (java) S 5856 5856 1733 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120701275 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648113121184 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5864] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5864/stat : 5864 (java) S 5856 5856 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120701282 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648112069616 140648216077344 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5865] ppid=5856 vsize=1049936 CPUtime=2.45
/proc/5859/task/5865/stat : 5865 (java) S 5856 5856 1733 0 -1 4202560 11826 0 0 0 239 6 0 0 20 0 11 0 120701283 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648111016976 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5866] ppid=5856 vsize=1049936 CPUtime=2.46
/proc/5859/task/5866/stat : 5866 (java) S 5856 5856 1733 0 -1 4202560 8533 0 0 0 242 4 0 0 20 0 11 0 120701283 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648109964304 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5867] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5867/stat : 5867 (java) S 5856 5856 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120701283 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648108911824 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5868] ppid=5856 vsize=1049936 CPUtime=0.14
/proc/5859/task/5868/stat : 5868 (java) S 5856 5856 1733 0 -1 4202560 28 0 0 0 14 0 0 0 20 0 11 0 120701283 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648107859328 140648216069707 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5869] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5869/stat : 5869 (java) S 5856 5856 1733 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120702532 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648106653536 140648216069707 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 275.68
Current children cumulated vsize (KiB) 1059104

[startup+294.401 s]
/proc/loadavg: 1.01 1.07 1.01 2/71 6120
/proc/meminfo: memFree=9980/1022884 swapFree=0/0
[pid=5856] ppid=5855 vsize=9168 CPUtime=0
/proc/5856/stat : 5856 (p2cudf-full-1.1) S 5855 5856 1733 0 -1 4202496 454 292 2 1 0 0 0 0 20 0 1 0 120701257 9388032 331 18446744073709551615 4194304 5129932 140734793570912 140734793569056 139890145813598 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/5856/statm: 2292 331 280 229 0 52 0
[pid=5859] ppid=5856 vsize=1049936 CPUtime=282.02
/proc/5859/stat : 5859 (java) S 5856 5856 1733 0 -1 4202496 168307 0 20 0 28132 70 0 0 20 0 11 0 120701261 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140733480614608 140648216055413 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 3 0 0
/proc/5859/statm: 262484 162207 2393 9 0 249834 0
[pid=5859/tid=5860] ppid=5856 vsize=1049936 CPUtime=261.03
/proc/5859/task/5860/stat : 5860 (java) R 5856 5856 1733 0 -1 4202560 47783 0 8 0 26076 27 0 0 20 0 11 0 120701266 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648222588888 140648120380708 0 4 0 16800975 0 0 0 -1 0 0 0 16 0 0
[pid=5859/tid=5861] ppid=5856 vsize=1049936 CPUtime=15.9
/proc/5859/task/5861/stat : 5861 (java) S 5856 5856 1733 0 -1 4202560 98852 0 0 0 1557 33 0 0 20 0 11 0 120701274 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648115227776 140648216069707 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5862] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5862/stat : 5862 (java) S 5856 5856 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120701275 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648114173968 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5863] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5863/stat : 5863 (java) S 5856 5856 1733 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120701275 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648113121184 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5864] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5864/stat : 5864 (java) S 5856 5856 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120701282 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648112069616 140648216077344 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5865] ppid=5856 vsize=1049936 CPUtime=2.45
/proc/5859/task/5865/stat : 5865 (java) S 5856 5856 1733 0 -1 4202560 11826 0 0 0 239 6 0 0 20 0 11 0 120701283 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648111016976 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5866] ppid=5856 vsize=1049936 CPUtime=2.46
/proc/5859/task/5866/stat : 5866 (java) S 5856 5856 1733 0 -1 4202560 8533 0 0 0 242 4 0 0 20 0 11 0 120701283 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648109964304 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5867] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5867/stat : 5867 (java) S 5856 5856 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120701283 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648108911824 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5868] ppid=5856 vsize=1049936 CPUtime=0.14
/proc/5859/task/5868/stat : 5868 (java) S 5856 5856 1733 0 -1 4202560 28 0 0 0 14 0 0 0 20 0 11 0 120701283 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648107859328 140648216069707 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5869] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5869/stat : 5869 (java) S 5856 5856 1733 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120702532 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648106653536 140648216069707 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 282.02
Current children cumulated vsize (KiB) 1059104

[startup+296.004 s]
/proc/loadavg: 1.01 1.07 1.01 2/71 6120
/proc/meminfo: memFree=9980/1022884 swapFree=0/0
[pid=5856] ppid=5855 vsize=9168 CPUtime=0
/proc/5856/stat : 5856 (p2cudf-full-1.1) S 5855 5856 1733 0 -1 4202496 454 292 2 1 0 0 0 0 20 0 1 0 120701257 9388032 331 18446744073709551615 4194304 5129932 140734793570912 140734793569056 139890145813598 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/5856/statm: 2292 331 280 229 0 52 0
[pid=5859] ppid=5856 vsize=1049936 CPUtime=283.6
/proc/5859/stat : 5859 (java) S 5856 5856 1733 0 -1 4202496 168307 0 20 0 28290 70 0 0 20 0 11 0 120701261 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140733480614608 140648216055413 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 3 0 0
/proc/5859/statm: 262484 162207 2393 9 0 249834 0
[pid=5859/tid=5860] ppid=5856 vsize=1049936 CPUtime=262.62
/proc/5859/task/5860/stat : 5860 (java) R 5856 5856 1733 0 -1 4202560 47783 0 8 0 26235 27 0 0 20 0 11 0 120701266 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648222588888 140648120606304 0 4 0 16800975 0 0 0 -1 0 0 0 16 0 0
[pid=5859/tid=5861] ppid=5856 vsize=1049936 CPUtime=15.9
/proc/5859/task/5861/stat : 5861 (java) S 5856 5856 1733 0 -1 4202560 98852 0 0 0 1557 33 0 0 20 0 11 0 120701274 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648115227776 140648216069707 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5862] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5862/stat : 5862 (java) S 5856 5856 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120701275 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648114173968 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5863] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5863/stat : 5863 (java) S 5856 5856 1733 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120701275 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648113121184 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5864] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5864/stat : 5864 (java) S 5856 5856 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120701282 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648112069616 140648216077344 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5865] ppid=5856 vsize=1049936 CPUtime=2.45
/proc/5859/task/5865/stat : 5865 (java) S 5856 5856 1733 0 -1 4202560 11826 0 0 0 239 6 0 0 20 0 11 0 120701283 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648111016976 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5866] ppid=5856 vsize=1049936 CPUtime=2.46
/proc/5859/task/5866/stat : 5866 (java) S 5856 5856 1733 0 -1 4202560 8533 0 0 0 242 4 0 0 20 0 11 0 120701283 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648109964304 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5867] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5867/stat : 5867 (java) S 5856 5856 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120701283 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648108911824 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5868] ppid=5856 vsize=1049936 CPUtime=0.14
/proc/5859/task/5868/stat : 5868 (java) S 5856 5856 1733 0 -1 4202560 28 0 0 0 14 0 0 0 20 0 11 0 120701283 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648107859328 140648216069707 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5869] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5869/stat : 5869 (java) S 5856 5856 1733 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120702532 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648106653536 140648216069707 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 283.6
Current children cumulated vsize (KiB) 1059104

[startup+297.601 s]
/proc/loadavg: 1.01 1.07 1.01 2/71 6120
/proc/meminfo: memFree=9980/1022884 swapFree=0/0
[pid=5856] ppid=5855 vsize=9168 CPUtime=0
/proc/5856/stat : 5856 (p2cudf-full-1.1) S 5855 5856 1733 0 -1 4202496 454 292 2 1 0 0 0 0 20 0 1 0 120701257 9388032 331 18446744073709551615 4194304 5129932 140734793570912 140734793569056 139890145813598 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/5856/statm: 2292 331 280 229 0 52 0
[pid=5859] ppid=5856 vsize=1049936 CPUtime=285.18
/proc/5859/stat : 5859 (java) S 5856 5856 1733 0 -1 4202496 168307 0 20 0 28448 70 0 0 20 0 11 0 120701261 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140733480614608 140648216055413 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 3 0 0
/proc/5859/statm: 262484 162207 2393 9 0 249834 0
[pid=5859/tid=5860] ppid=5856 vsize=1049936 CPUtime=264.2
/proc/5859/task/5860/stat : 5860 (java) R 5856 5856 1733 0 -1 4202560 47783 0 8 0 26393 27 0 0 20 0 11 0 120701266 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648222588888 140648120605792 0 4 0 16800975 0 0 0 -1 0 0 0 16 0 0
[pid=5859/tid=5861] ppid=5856 vsize=1049936 CPUtime=15.9
/proc/5859/task/5861/stat : 5861 (java) S 5856 5856 1733 0 -1 4202560 98852 0 0 0 1557 33 0 0 20 0 11 0 120701274 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648115227776 140648216069707 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5862] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5862/stat : 5862 (java) S 5856 5856 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120701275 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648114173968 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5863] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5863/stat : 5863 (java) S 5856 5856 1733 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120701275 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648113121184 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5864] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5864/stat : 5864 (java) S 5856 5856 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120701282 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648112069616 140648216077344 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5865] ppid=5856 vsize=1049936 CPUtime=2.45
/proc/5859/task/5865/stat : 5865 (java) S 5856 5856 1733 0 -1 4202560 11826 0 0 0 239 6 0 0 20 0 11 0 120701283 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648111016976 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5866] ppid=5856 vsize=1049936 CPUtime=2.46
/proc/5859/task/5866/stat : 5866 (java) S 5856 5856 1733 0 -1 4202560 8533 0 0 0 242 4 0 0 20 0 11 0 120701283 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648109964304 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5867] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5867/stat : 5867 (java) S 5856 5856 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120701283 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648108911824 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5868] ppid=5856 vsize=1049936 CPUtime=0.15
/proc/5859/task/5868/stat : 5868 (java) S 5856 5856 1733 0 -1 4202560 28 0 0 0 15 0 0 0 20 0 11 0 120701283 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648107859328 140648216069707 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5869] ppid=5856 vsize=1049936 CPUtime=0
/proc/5859/task/5869/stat : 5869 (java) S 5856 5856 1733 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120702532 1075134464 162207 18446744073709551615 4194304 4228012 140733480623584 140648106653536 140648216069707 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 285.18
Current children cumulated vsize (KiB) 1059104

[startup+298.001 s]
/proc/loadavg: 1.01 1.07 1.01 2/71 6120
/proc/meminfo: memFree=9980/1022884 swapFree=0/0
[pid=5856] ppid=5855 vsize=9168 CPUtime=0
/proc/5856/stat : 5856 (p2cudf-full-1.1) S 5855 5856 1733 0 -1 4202496 454 292 2 1 0 0 0 0 20 0 1 0 120701257 9388032 331 18446744073709551615 4194304 5129932 140734793570912 140734793569056 139890145813598 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/5856/statm: 2292 331 280 229 0 52 0
[pid=5859] ppid=5856 vsize=1050964 CPUtime=285.4
/proc/5859/stat : 5859 (java) S 5856 5856 1733 0 -1 4202496 168321 0 20 0 28470 70 0 0 20 0 11 0 120701261 1076187136 162219 18446744073709551615 4194304 4228012 140733480623584 140733480614608 140648216055413 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 3 0 0
/proc/5859/statm: 262741 162219 2393 9 0 250091 0
[pid=5859/tid=5860] ppid=5856 vsize=1050964 CPUtime=264.37
/proc/5859/task/5860/stat : 5860 (java) S 5856 5856 1733 0 -1 4202560 47791 0 8 0 26410 27 0 0 20 0 11 0 120701266 1076187136 162219 18446744073709551615 4194304 4228012 140733480623584 140648222589872 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 16 0 0
[pid=5859/tid=5861] ppid=5856 vsize=1050964 CPUtime=15.9
/proc/5859/task/5861/stat : 5861 (java) S 5856 5856 1733 0 -1 4202560 98852 0 0 0 1557 33 0 0 20 0 11 0 120701274 1076187136 162219 18446744073709551615 4194304 4228012 140733480623584 140648115227776 140648216069707 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5862] ppid=5856 vsize=1050964 CPUtime=0
/proc/5859/task/5862/stat : 5862 (java) S 5856 5856 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120701275 1076187136 162219 18446744073709551615 4194304 4228012 140733480623584 140648114173968 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5863] ppid=5856 vsize=1050964 CPUtime=0
/proc/5859/task/5863/stat : 5863 (java) S 5856 5856 1733 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120701275 1076187136 162219 18446744073709551615 4194304 4228012 140733480623584 140648113121184 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5864] ppid=5856 vsize=1050964 CPUtime=0
/proc/5859/task/5864/stat : 5864 (java) S 5856 5856 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120701282 1076187136 162219 18446744073709551615 4194304 4228012 140733480623584 140648112069616 140648216077344 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5865] ppid=5856 vsize=1050964 CPUtime=2.48
/proc/5859/task/5865/stat : 5865 (java) S 5856 5856 1733 0 -1 4202560 11826 0 0 0 242 6 0 0 20 0 11 0 120701283 1076187136 162219 18446744073709551615 4194304 4228012 140733480623584 140648111016976 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5866] ppid=5856 vsize=1050964 CPUtime=2.48
/proc/5859/task/5866/stat : 5866 (java) S 5856 5856 1733 0 -1 4202560 8533 0 0 0 244 4 0 0 20 0 11 0 120701283 1076187136 162219 18446744073709551615 4194304 4228012 140733480623584 140648109964304 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5867] ppid=5856 vsize=1050964 CPUtime=0
/proc/5859/task/5867/stat : 5867 (java) S 5856 5856 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120701283 1076187136 162219 18446744073709551615 4194304 4228012 140733480623584 140648108911824 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5868] ppid=5856 vsize=1050964 CPUtime=0.15
/proc/5859/task/5868/stat : 5868 (java) S 5856 5856 1733 0 -1 4202560 28 0 0 0 15 0 0 0 20 0 11 0 120701283 1076187136 162219 18446744073709551615 4194304 4228012 140733480623584 140648107859328 140648216069707 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 285.4
Current children cumulated vsize (KiB) 1060132

[startup+298.401 s]
/proc/loadavg: 1.01 1.07 1.01 1/71 6121
/proc/meminfo: memFree=9980/1022884 swapFree=0/0
[pid=5856] ppid=5855 vsize=9168 CPUtime=0
/proc/5856/stat : 5856 (p2cudf-full-1.1) S 5855 5856 1733 0 -1 4202496 454 292 2 1 0 0 0 0 20 0 1 0 120701257 9388032 331 18446744073709551615 4194304 5129932 140734793570912 140734793569056 139890145813598 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/5856/statm: 2292 331 280 229 0 52 0
[pid=5859] ppid=5856 vsize=1050964 CPUtime=285.48
/proc/5859/stat : 5859 (java) S 5856 5856 1733 0 -1 4202496 168323 0 20 0 28476 72 0 0 20 0 11 0 120701261 1076187136 162221 18446744073709551615 4194304 4228012 140733480623584 140733480614608 140648216055413 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 3 0 0
/proc/5859/statm: 262741 162221 2393 9 0 250091 0
[pid=5859/tid=5860] ppid=5856 vsize=1050964 CPUtime=264.37
/proc/5859/task/5860/stat : 5860 (java) S 5856 5856 1733 0 -1 4202560 47791 0 8 0 26410 27 0 0 20 0 11 0 120701266 1076187136 162221 18446744073709551615 4194304 4228012 140733480623584 140648222589872 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 16 0 0
[pid=5859/tid=5861] ppid=5856 vsize=1050964 CPUtime=15.9
/proc/5859/task/5861/stat : 5861 (java) S 5856 5856 1733 0 -1 4202560 98852 0 0 0 1557 33 0 0 20 0 11 0 120701274 1076187136 162221 18446744073709551615 4194304 4228012 140733480623584 140648115227776 140648216069707 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5862] ppid=5856 vsize=1050964 CPUtime=0
/proc/5859/task/5862/stat : 5862 (java) S 5856 5856 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120701275 1076187136 162221 18446744073709551615 4194304 4228012 140733480623584 140648114173968 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5863] ppid=5856 vsize=1050964 CPUtime=0
/proc/5859/task/5863/stat : 5863 (java) S 5856 5856 1733 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120701275 1076187136 162221 18446744073709551615 4194304 4228012 140733480623584 140648113121184 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5864] ppid=5856 vsize=1050964 CPUtime=0
/proc/5859/task/5864/stat : 5864 (java) S 5856 5856 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120701282 1076187136 162221 18446744073709551615 4194304 4228012 140733480623584 140648112069616 140648216077344 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5865] ppid=5856 vsize=1050964 CPUtime=2.48
/proc/5859/task/5865/stat : 5865 (java) S 5856 5856 1733 0 -1 4202560 11826 0 0 0 242 6 0 0 20 0 11 0 120701283 1076187136 162221 18446744073709551615 4194304 4228012 140733480623584 140648111016976 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5866] ppid=5856 vsize=1050964 CPUtime=2.49
/proc/5859/task/5866/stat : 5866 (java) S 5856 5856 1733 0 -1 4202560 8533 0 0 0 245 4 0 0 20 0 11 0 120701283 1076187136 162221 18446744073709551615 4194304 4228012 140733480623584 140648109964304 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5867] ppid=5856 vsize=1050964 CPUtime=0
/proc/5859/task/5867/stat : 5867 (java) S 5856 5856 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120701283 1076187136 162221 18446744073709551615 4194304 4228012 140733480623584 140648108911824 140648216068820 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=5868] ppid=5856 vsize=1050964 CPUtime=0.15
/proc/5859/task/5868/stat : 5868 (java) S 5856 5856 1733 0 -1 4202560 28 0 0 0 15 0 0 0 20 0 11 0 120701283 1076187136 162221 18446744073709551615 4194304 4228012 140733480623584 140648107859328 140648216069707 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=5859/tid=6121] ppid=5856 vsize=1050964 CPUtime=0.06
/proc/5859/task/6121/stat : 6121 (java) R 5856 5856 1733 0 -1 4202560 8 0 0 0 4 2 0 0 20 0 11 0 120731039 1076187136 162221 18446744073709551615 4194304 4228012 140733480623584 140648105592112 140648120051363 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 285.48
Current children cumulated vsize (KiB) 1060132

[startup+298.501 s]
/proc/loadavg: 1.01 1.07 1.01 1/71 6121
/proc/meminfo: memFree=9980/1022884 swapFree=0/0
[pid=5856] ppid=5855 vsize=9168 CPUtime=0
/proc/5856/stat : 5856 (p2cudf-full-1.1) S 5855 5856 1733 0 -1 4202496 454 292 2 1 0 0 0 0 20 0 1 0 120701257 9388032 331 18446744073709551615 4194304 5129932 140734793570912 140734793569056 139890145813598 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/5856/statm: 2292 331 280 229 0 52 0
[pid=5859] ppid=5856 vsize=0 CPUtime=285.59
/proc/5859/stat : 5859 (java) Z 5856 5856 1733 0 -1 4203532 168334 0 20 0 28485 74 0 0 20 0 2 0 120701261 0 0 18446744073709551615 0 0 0 0 0 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 3 0 0
/proc/5859/statm: 0 0 0 0 0 0 0
[pid=5859/tid=6121] ppid=5856 vsize=0 CPUtime=0.16
/proc/5859/task/6121/stat : 6121 (java) R 5856 5856 1733 0 -1 4203588 9 0 0 0 11 5 0 0 20 0 2 0 120731039 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) 285.59
Current children cumulated vsize (KiB) 9168

Child status: 0
Real time (s): 298.536
CPU time (s): 285.634
CPU user time (s): 284.862
CPU system time (s): 0.772048
CPU usage (%): 95.678
Max. virtual memory (cumulated for all children) (KiB): 1062124

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 284.862
system time used= 0.772048
maximum resident set size= 648920
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 169093
page faults= 23
swaps= 0
block input operations= 71032
block output operations= 624
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 7269
involuntary context switches= 44112

runsolver used 0.820051 second user time and 1.98412 second system time

The end