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/upgrade/real/e0bd67a6-56d0-11df-b11f-00163e7a6f5e.cudf.log.runsolver /home/competition/p2cudf-full-1.15/p2cudf-full-1.15 /home/competition/data/real/e0bd67a6-56d0-11df-b11f-00163e7a6f5e.cudf /tmp/misc2012/2012-09-02-22:42/full/p2cudf-full-1.15/upgrade/real/e0bd67a6-56d0-11df-b11f-00163e7a6f5e.cudf.result -count(down),-notuptodate(solution),-aligned(solution,source,sourceversion),-unsat_recommends(solution),-count(new) 

Enforcing CPUTime limit (soft limit, will send signal-name then SIGKILL): 300 seconds
Enforcing CPUTime limit (hard limit, will send SIGXCPU): 330 seconds
Enforcing VSIZE limit (soft limit, will send signal-name then SIGKILL): 1150976 KiB
Enforcing VSIZE limit (hard limit, stack expansion will fail with SIGSEGV, brk() and mmap() will return ENOMEM): 1202176 KiB
Current StackSize limit: 8192 KiB


[startup+0 s]
/proc/loadavg: 1.04 1.06 0.96 2/57 16071
/proc/meminfo: memFree=611204/1022884 swapFree=0/0
[pid=16071] ppid=16070 vsize=9168 CPUtime=0
/proc/16071/stat : 16071 (p2cudf-full-1.1) S 16070 16071 32685 0 -1 4202496 425 0 0 0 0 0 0 0 20 0 1 0 39061269 9388032 326 18446744073709551615 4194304 5129932 140733238027920 140733238025592 139987191551776 0 0 16781316 65536 0 0 0 17 0 0 0 0 0 0
/proc/16071/statm: 2292 326 275 229 0 52 0

[startup+0.177089 s]
/proc/loadavg: 1.04 1.06 0.96 2/57 16071
/proc/meminfo: memFree=611204/1022884 swapFree=0/0
[pid=16071] ppid=16070 vsize=9172 CPUtime=0
/proc/16071/stat : 16071 (p2cudf-full-1.1) S 16070 16071 32685 0 -1 4202496 460 292 0 0 0 0 0 0 20 0 1 0 39061269 9392128 332 18446744073709551615 4194304 5129932 140733238027920 140733238026064 139987191407710 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/16071/statm: 2293 332 280 229 0 53 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9172

[startup+0.200406 s]
/proc/loadavg: 1.04 1.06 0.96 2/57 16071
/proc/meminfo: memFree=611204/1022884 swapFree=0/0
[pid=16071] ppid=16070 vsize=9172 CPUtime=0
/proc/16071/stat : 16071 (p2cudf-full-1.1) S 16070 16071 32685 0 -1 4202496 460 292 0 0 0 0 0 0 20 0 1 0 39061269 9392128 332 18446744073709551615 4194304 5129932 140733238027920 140733238026064 139987191407710 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/16071/statm: 2293 332 280 229 0 53 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9172

[startup+0.300348 s]
/proc/loadavg: 1.04 1.06 0.96 2/57 16071
/proc/meminfo: memFree=611204/1022884 swapFree=0/0
[pid=16071] ppid=16070 vsize=9172 CPUtime=0
/proc/16071/stat : 16071 (p2cudf-full-1.1) S 16070 16071 32685 0 -1 4202496 460 292 0 0 0 0 0 0 20 0 1 0 39061269 9392128 332 18446744073709551615 4194304 5129932 140733238027920 140733238026064 139987191407710 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/16071/statm: 2293 332 280 229 0 53 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9172

[startup+0.700231 s]
/proc/loadavg: 1.04 1.06 0.96 2/57 16071
/proc/meminfo: memFree=611204/1022884 swapFree=0/0
[pid=16071] ppid=16070 vsize=9172 CPUtime=0
/proc/16071/stat : 16071 (p2cudf-full-1.1) S 16070 16071 32685 0 -1 4202496 460 292 0 0 0 0 0 0 20 0 1 0 39061269 9392128 332 18446744073709551615 4194304 5129932 140733238027920 140733238026064 139987191407710 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/16071/statm: 2293 332 280 229 0 53 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9172

[startup+1.50076 s]
/proc/loadavg: 1.04 1.06 0.96 4/68 16083
/proc/meminfo: memFree=569080/1022884 swapFree=0/0
[pid=16071] ppid=16070 vsize=9172 CPUtime=0
/proc/16071/stat : 16071 (p2cudf-full-1.1) S 16070 16071 32685 0 -1 4202496 460 292 0 0 0 0 0 0 20 0 1 0 39061269 9392128 332 18446744073709551615 4194304 5129932 140733238027920 140733238026064 139987191407710 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/16071/statm: 2293 332 280 229 0 53 0
[pid=16074] ppid=16071 vsize=1048160 CPUtime=1.4
/proc/16074/stat : 16074 (java) S 16071 16071 32685 0 -1 4202496 28734 0 15 0 124 16 0 0 20 0 10 0 39061270 1073315840 25976 18446744073709551615 4194304 4228012 140735246122832 140735246113856 140093848546933 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 4 0 0
/proc/16074/statm: 262040 25976 2347 9 0 249390 0
[pid=16074/tid=16075] ppid=16071 vsize=1048160 CPUtime=0.66
/proc/16074/task/16075/stat : 16075 (java) R 16071 16071 32685 0 -1 4202560 12337 0 3 0 57 9 0 0 20 0 10 0 39061276 1073315840 25976 18446744073709551615 4194304 4228012 140735246122832 140093855072928 140093753000809 0 4 0 16800975 0 0 0 -1 0 0 0 3 0 0
[pid=16074/tid=16076] ppid=16071 vsize=1048160 CPUtime=0
/proc/16074/task/16076/stat : 16076 (java) S 16071 16071 32685 0 -1 4202560 4 0 0 0 0 0 0 0 20 0 10 0 39061280 1073315840 25976 18446744073709551615 4194304 4228012 140735246122832 140093747719296 140093848561227 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16077] ppid=16071 vsize=1048160 CPUtime=0
/proc/16074/task/16077/stat : 16077 (java) S 16071 16071 32685 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 10 0 39061281 1073315840 25976 18446744073709551615 4194304 4228012 140735246122832 140093746665488 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16078] ppid=16071 vsize=1048160 CPUtime=0
/proc/16074/task/16078/stat : 16078 (java) S 16071 16071 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 10 0 39061281 1073315840 25976 18446744073709551615 4194304 4228012 140735246122832 140093745612704 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16079] ppid=16071 vsize=1048160 CPUtime=0
/proc/16074/task/16079/stat : 16079 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 39061284 1073315840 25976 18446744073709551615 4194304 4228012 140735246122832 140093744561136 140093848568864 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16080] ppid=16071 vsize=1048160 CPUtime=0.36
/proc/16074/task/16080/stat : 16080 (java) R 16071 16071 32685 0 -1 4202560 6659 0 0 0 34 2 0 0 20 0 10 0 39061284 1073315840 25976 18446744073709551615 4194304 4228012 140735246122832 140093743496296 140093831403854 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16081] ppid=16071 vsize=1048160 CPUtime=0.35
/proc/16074/task/16081/stat : 16081 (java) R 16071 16071 32685 0 -1 4202560 8457 0 0 0 31 4 0 0 20 0 10 0 39061284 1073315840 25976 18446744073709551615 4194304 4228012 140735246122832 140093742441064 140093834219933 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16082] ppid=16071 vsize=1048160 CPUtime=0
/proc/16074/task/16082/stat : 16082 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 39061285 1073315840 25976 18446744073709551615 4194304 4228012 140735246122832 140093741403344 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16083] ppid=16071 vsize=1048160 CPUtime=0
/proc/16074/task/16083/stat : 16083 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 39061285 1073315840 25976 18446744073709551615 4194304 4228012 140735246122832 140093740350848 140093848561227 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) 1057332

[startup+3.10078 s]
/proc/loadavg: 1.04 1.06 0.96 4/68 16083
/proc/meminfo: memFree=476452/1022884 swapFree=0/0
[pid=16071] ppid=16070 vsize=9172 CPUtime=0
/proc/16071/stat : 16071 (p2cudf-full-1.1) S 16070 16071 32685 0 -1 4202496 460 292 0 0 0 0 0 0 20 0 1 0 39061269 9392128 332 18446744073709551615 4194304 5129932 140733238027920 140733238026064 139987191407710 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/16071/statm: 2293 332 280 229 0 53 0
[pid=16074] ppid=16071 vsize=1048244 CPUtime=2.97
/proc/16074/stat : 16074 (java) S 16071 16071 32685 0 -1 4202496 74745 0 15 0 268 29 0 0 20 0 10 0 39061270 1073401856 70232 18446744073709551615 4194304 4228012 140735246122832 140735246113856 140093848546933 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 4 0 0
/proc/16074/statm: 262061 70232 2367 9 0 249411 0
[pid=16074/tid=16075] ppid=16071 vsize=1048244 CPUtime=1.54
/proc/16074/task/16075/stat : 16075 (java) R 16071 16071 32685 0 -1 4202560 47383 0 3 0 136 18 0 0 20 0 10 0 39061276 1073401856 70232 18446744073709551615 4194304 4228012 140735246122832 140093855072960 140093752951318 0 4 0 16800975 0 0 0 -1 0 0 0 3 0 0
[pid=16074/tid=16076] ppid=16071 vsize=1048244 CPUtime=0.18
/proc/16074/task/16076/stat : 16076 (java) S 16071 16071 32685 0 -1 4202560 8780 0 0 0 16 2 0 0 20 0 10 0 39061280 1073401856 70232 18446744073709551615 4194304 4228012 140735246122832 140093747719296 140093848561227 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16077] ppid=16071 vsize=1048244 CPUtime=0
/proc/16074/task/16077/stat : 16077 (java) S 16071 16071 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 39061281 1073401856 70232 18446744073709551615 4194304 4228012 140735246122832 140093746665488 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16078] ppid=16071 vsize=1048244 CPUtime=0
/proc/16074/task/16078/stat : 16078 (java) S 16071 16071 32685 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 10 0 39061281 1073401856 70232 18446744073709551615 4194304 4228012 140735246122832 140093745612704 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16079] ppid=16071 vsize=1048244 CPUtime=0
/proc/16074/task/16079/stat : 16079 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 39061284 1073401856 70232 18446744073709551615 4194304 4228012 140735246122832 140093744561136 140093848568864 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16080] ppid=16071 vsize=1048244 CPUtime=0.61
/proc/16074/task/16080/stat : 16080 (java) S 16071 16071 32685 0 -1 4202560 7350 0 0 0 59 2 0 0 20 0 10 0 39061284 1073401856 70232 18446744073709551615 4194304 4228012 140735246122832 140093743508496 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16081] ppid=16071 vsize=1048244 CPUtime=0.62
/proc/16074/task/16081/stat : 16081 (java) S 16071 16071 32685 0 -1 4202560 9952 0 0 0 56 6 0 0 20 0 10 0 39061284 1073401856 70232 18446744073709551615 4194304 4228012 140735246122832 140093742455824 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16082] ppid=16071 vsize=1048244 CPUtime=0
/proc/16074/task/16082/stat : 16082 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 39061285 1073401856 70232 18446744073709551615 4194304 4228012 140735246122832 140093741403344 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16083] ppid=16071 vsize=1048244 CPUtime=0
/proc/16074/task/16083/stat : 16083 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 39061285 1073401856 70232 18446744073709551615 4194304 4228012 140735246122832 140093740350848 140093848561227 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 2.97
Current children cumulated vsize (KiB) 1057416

[startup+6.30079 s]
/proc/loadavg: 1.20 1.09 0.97 4/68 16083
/proc/meminfo: memFree=265900/1022884 swapFree=0/0
[pid=16071] ppid=16070 vsize=9172 CPUtime=0
/proc/16071/stat : 16071 (p2cudf-full-1.1) S 16070 16071 32685 0 -1 4202496 460 292 0 0 0 0 0 0 20 0 1 0 39061269 9392128 332 18446744073709551615 4194304 5129932 140733238027920 140733238026064 139987191407710 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/16071/statm: 2293 332 280 229 0 53 0
[pid=16074] ppid=16071 vsize=1048244 CPUtime=6.13
/proc/16074/stat : 16074 (java) S 16071 16071 32685 0 -1 4202496 92849 0 15 0 572 41 0 0 20 0 10 0 39061270 1073401856 85287 18446744073709551615 4194304 4228012 140735246122832 140735246113856 140093848546933 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 4 0 0
/proc/16074/statm: 262061 85287 2375 9 0 249411 0
[pid=16074/tid=16075] ppid=16071 vsize=1048244 CPUtime=2.92
/proc/16074/task/16075/stat : 16075 (java) R 16071 16071 32685 0 -1 4202560 47689 0 3 0 271 21 0 0 20 0 10 0 39061276 1073401856 85287 18446744073709551615 4194304 4228012 140735246122832 140093855081080 140093752745949 0 4 0 16800975 0 0 0 -1 0 0 0 3 0 0
[pid=16074/tid=16076] ppid=16071 vsize=1048244 CPUtime=0.44
/proc/16074/task/16076/stat : 16076 (java) S 16071 16071 32685 0 -1 4202560 22861 0 0 0 36 8 0 0 20 0 10 0 39061280 1073401856 85287 18446744073709551615 4194304 4228012 140735246122832 140093747719296 140093848561227 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16077] ppid=16071 vsize=1048244 CPUtime=0
/proc/16074/task/16077/stat : 16077 (java) S 16071 16071 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 39061281 1073401856 85287 18446744073709551615 4194304 4228012 140735246122832 140093746665488 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16078] ppid=16071 vsize=1048244 CPUtime=0
/proc/16074/task/16078/stat : 16078 (java) S 16071 16071 32685 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 10 0 39061281 1073401856 85287 18446744073709551615 4194304 4228012 140735246122832 140093745612704 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16079] ppid=16071 vsize=1048244 CPUtime=0
/proc/16074/task/16079/stat : 16079 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 39061284 1073401856 85287 18446744073709551615 4194304 4228012 140735246122832 140093744561136 140093848568864 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16080] ppid=16071 vsize=1048244 CPUtime=1.33
/proc/16074/task/16080/stat : 16080 (java) R 16071 16071 32685 0 -1 4202560 7448 0 0 0 131 2 0 0 20 0 10 0 39061284 1073401856 85287 18446744073709551615 4194304 4228012 140735246122832 140093743508240 140093832406452 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16081] ppid=16071 vsize=1048244 CPUtime=1.42
/proc/16074/task/16081/stat : 16081 (java) R 16071 16071 32685 0 -1 4202560 13571 0 0 0 134 8 0 0 20 0 10 0 39061284 1073401856 85287 18446744073709551615 4194304 4228012 140735246122832 140093742443544 140093832851555 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16082] ppid=16071 vsize=1048244 CPUtime=0
/proc/16074/task/16082/stat : 16082 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 39061285 1073401856 85287 18446744073709551615 4194304 4228012 140735246122832 140093741403344 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16083] ppid=16071 vsize=1048244 CPUtime=0
/proc/16074/task/16083/stat : 16083 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 39061285 1073401856 85287 18446744073709551615 4194304 4228012 140735246122832 140093740350848 140093848561227 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) 1057416

[startup+12.7008 s]
/proc/loadavg: 1.18 1.09 0.97 2/69 16084
/proc/meminfo: memFree=205752/1022884 swapFree=0/0
[pid=16071] ppid=16070 vsize=9172 CPUtime=0
/proc/16071/stat : 16071 (p2cudf-full-1.1) S 16070 16071 32685 0 -1 4202496 460 292 0 0 0 0 0 0 20 0 1 0 39061269 9392128 332 18446744073709551615 4194304 5129932 140733238027920 140733238026064 139987191407710 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/16071/statm: 2293 332 280 229 0 53 0
[pid=16074] ppid=16071 vsize=1046296 CPUtime=12.46
/proc/16074/stat : 16074 (java) S 16071 16071 32685 0 -1 4202496 109278 0 15 0 1196 50 0 0 20 0 11 0 39061270 1071407104 100295 18446744073709551615 4194304 4228012 140735246122832 140735246113856 140093848546933 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 4 0 0
/proc/16074/statm: 261574 100295 2392 9 0 248924 0
[pid=16074/tid=16075] ppid=16071 vsize=1046296 CPUtime=6.11
/proc/16074/task/16075/stat : 16075 (java) S 16071 16071 32685 0 -1 4202560 47779 0 3 0 589 22 0 0 20 0 11 0 39061276 1071407104 100295 18446744073709551615 4194304 4228012 140735246122832 140093855080224 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 3 0 0
[pid=16074/tid=16076] ppid=16071 vsize=1046296 CPUtime=1.8
/proc/16074/task/16076/stat : 16076 (java) R 16071 16071 32685 0 -1 4202560 38638 0 0 0 164 16 0 0 20 0 11 0 39061280 1071407104 100295 18446744073709551615 4194304 4228012 140735246122832 140093747718704 140093834361283 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16077] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16077/stat : 16077 (java) S 16071 16071 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 39061281 1071407104 100295 18446744073709551615 4194304 4228012 140735246122832 140093746665488 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16078] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16078/stat : 16078 (java) S 16071 16071 32685 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 39061281 1071407104 100295 18446744073709551615 4194304 4228012 140735246122832 140093745612704 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16079] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16079/stat : 16079 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 39061284 1071407104 100295 18446744073709551615 4194304 4228012 140735246122832 140093744561136 140093848568864 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16080] ppid=16071 vsize=1046296 CPUtime=2.26
/proc/16074/task/16080/stat : 16080 (java) S 16071 16071 32685 0 -1 4202560 7941 0 0 0 224 2 0 0 20 0 11 0 39061284 1071407104 100295 18446744073709551615 4194304 4228012 140735246122832 140093743508496 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16081] ppid=16071 vsize=1046296 CPUtime=2.27
/proc/16074/task/16081/stat : 16081 (java) S 16071 16071 32685 0 -1 4202560 13634 0 0 0 218 9 0 0 20 0 11 0 39061284 1071407104 100295 18446744073709551615 4194304 4228012 140735246122832 140093742455824 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16082] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16082/stat : 16082 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 39061285 1071407104 100295 18446744073709551615 4194304 4228012 140735246122832 140093741403344 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16083] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16083/stat : 16083 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 39061285 1071407104 100295 18446744073709551615 4194304 4228012 140735246122832 140093740350848 140093848561227 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16084] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16084/stat : 16084 (java) S 16071 16071 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 39062030 1071407104 100295 18446744073709551615 4194304 4228012 140735246122832 140093739149152 140093848561227 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 12.46
Current children cumulated vsize (KiB) 1055468

[startup+25.5009 s]
/proc/loadavg: 1.14 1.08 0.97 2/69 16084
/proc/meminfo: memFree=195212/1022884 swapFree=0/0
[pid=16071] ppid=16070 vsize=9172 CPUtime=0
/proc/16071/stat : 16071 (p2cudf-full-1.1) S 16070 16071 32685 0 -1 4202496 460 292 0 0 0 0 0 0 20 0 1 0 39061269 9392128 332 18446744073709551615 4194304 5129932 140733238027920 140733238026064 139987191407710 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/16071/statm: 2293 332 280 229 0 53 0
[pid=16074] ppid=16071 vsize=1046296 CPUtime=25.09
/proc/16074/stat : 16074 (java) S 16071 16071 32685 0 -1 4202496 111838 0 15 0 2458 51 0 0 20 0 11 0 39061270 1071407104 102855 18446744073709551615 4194304 4228012 140735246122832 140735246113856 140093848546933 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 4 0 0
/proc/16074/statm: 261574 102855 2392 9 0 248924 0
[pid=16074/tid=16075] ppid=16071 vsize=1046296 CPUtime=15.45
/proc/16074/task/16075/stat : 16075 (java) R 16071 16071 32685 0 -1 4202560 47779 0 3 0 1523 22 0 0 20 0 11 0 39061276 1071407104 102855 18446744073709551615 4194304 4228012 140735246122832 140093855080424 140093753815172 0 4 0 16800975 0 0 0 -1 0 0 0 5 0 0
[pid=16074/tid=16076] ppid=16071 vsize=1046296 CPUtime=4.95
/proc/16074/task/16076/stat : 16076 (java) S 16071 16071 32685 0 -1 4202560 41196 0 0 0 478 17 0 0 20 0 11 0 39061280 1071407104 102855 18446744073709551615 4194304 4228012 140735246122832 140093747719296 140093848561227 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16077] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16077/stat : 16077 (java) S 16071 16071 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 39061281 1071407104 102855 18446744073709551615 4194304 4228012 140735246122832 140093746665488 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16078] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16078/stat : 16078 (java) S 16071 16071 32685 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 39061281 1071407104 102855 18446744073709551615 4194304 4228012 140735246122832 140093745612704 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16079] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16079/stat : 16079 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 39061284 1071407104 102855 18446744073709551615 4194304 4228012 140735246122832 140093744561136 140093848568864 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16080] ppid=16071 vsize=1046296 CPUtime=2.33
/proc/16074/task/16080/stat : 16080 (java) S 16071 16071 32685 0 -1 4202560 7941 0 0 0 231 2 0 0 20 0 11 0 39061284 1071407104 102855 18446744073709551615 4194304 4228012 140735246122832 140093743508496 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16081] ppid=16071 vsize=1046296 CPUtime=2.33
/proc/16074/task/16081/stat : 16081 (java) S 16071 16071 32685 0 -1 4202560 13636 0 0 0 224 9 0 0 20 0 11 0 39061284 1071407104 102855 18446744073709551615 4194304 4228012 140735246122832 140093742455824 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16082] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16082/stat : 16082 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 39061285 1071407104 102855 18446744073709551615 4194304 4228012 140735246122832 140093741403344 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16083] ppid=16071 vsize=1046296 CPUtime=0.01
/proc/16074/task/16083/stat : 16083 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 1 0 0 0 20 0 11 0 39061285 1071407104 102855 18446744073709551615 4194304 4228012 140735246122832 140093740350848 140093848561227 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16084] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16084/stat : 16084 (java) S 16071 16071 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 39062030 1071407104 102855 18446744073709551615 4194304 4228012 140735246122832 140093739149152 140093848561227 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 25.09
Current children cumulated vsize (KiB) 1055468

[startup+51.1009 s]
/proc/loadavg: 1.09 1.08 0.97 2/69 16084
/proc/meminfo: memFree=182440/1022884 swapFree=0/0
[pid=16071] ppid=16070 vsize=9172 CPUtime=0
/proc/16071/stat : 16071 (p2cudf-full-1.1) S 16070 16071 32685 0 -1 4202496 460 292 0 0 0 0 0 0 20 0 1 0 39061269 9392128 332 18446744073709551615 4194304 5129932 140733238027920 140733238026064 139987191407710 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/16071/statm: 2293 332 280 229 0 53 0
[pid=16074] ppid=16071 vsize=1046296 CPUtime=50.4
/proc/16074/stat : 16074 (java) S 16071 16071 32685 0 -1 4202496 115024 0 15 0 4988 52 0 0 20 0 11 0 39061270 1071407104 106037 18446744073709551615 4194304 4228012 140735246122832 140735246113856 140093848546933 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 4 0 0
/proc/16074/statm: 261574 106037 2392 9 0 248924 0
[pid=16074/tid=16075] ppid=16071 vsize=1046296 CPUtime=36.57
/proc/16074/task/16075/stat : 16075 (java) S 16071 16071 32685 0 -1 4202560 47779 0 3 0 3635 22 0 0 20 0 11 0 39061276 1071407104 106037 18446744073709551615 4194304 4228012 140735246122832 140093855080224 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 5 0 0
[pid=16074/tid=16076] ppid=16071 vsize=1046296 CPUtime=9.06
/proc/16074/task/16076/stat : 16076 (java) R 16071 16071 32685 0 -1 4202560 44379 0 0 0 888 18 0 0 20 0 11 0 39061280 1071407104 106037 18446744073709551615 4194304 4228012 140735246122832 140093747718256 140093835410512 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16077] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16077/stat : 16077 (java) S 16071 16071 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 39061281 1071407104 106037 18446744073709551615 4194304 4228012 140735246122832 140093746665488 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16078] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16078/stat : 16078 (java) S 16071 16071 32685 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 39061281 1071407104 106037 18446744073709551615 4194304 4228012 140735246122832 140093745612704 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16079] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16079/stat : 16079 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 39061284 1071407104 106037 18446744073709551615 4194304 4228012 140735246122832 140093744561136 140093848568864 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16080] ppid=16071 vsize=1046296 CPUtime=2.33
/proc/16074/task/16080/stat : 16080 (java) S 16071 16071 32685 0 -1 4202560 7941 0 0 0 231 2 0 0 20 0 11 0 39061284 1071407104 106037 18446744073709551615 4194304 4228012 140735246122832 140093743508496 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16081] ppid=16071 vsize=1046296 CPUtime=2.4
/proc/16074/task/16081/stat : 16081 (java) S 16071 16071 32685 0 -1 4202560 13636 0 0 0 231 9 0 0 20 0 11 0 39061284 1071407104 106037 18446744073709551615 4194304 4228012 140735246122832 140093742455824 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16082] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16082/stat : 16082 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 39061285 1071407104 106037 18446744073709551615 4194304 4228012 140735246122832 140093741403344 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16083] ppid=16071 vsize=1046296 CPUtime=0.02
/proc/16074/task/16083/stat : 16083 (java) S 16071 16071 32685 0 -1 4202560 3 0 0 0 2 0 0 0 20 0 11 0 39061285 1071407104 106037 18446744073709551615 4194304 4228012 140735246122832 140093740350848 140093848561227 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16084] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16084/stat : 16084 (java) S 16071 16071 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 39062030 1071407104 106037 18446744073709551615 4194304 4228012 140735246122832 140093739149152 140093848561227 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 50.4
Current children cumulated vsize (KiB) 1055468

[startup+102.301 s]
/proc/loadavg: 1.04 1.06 0.97 2/69 16084
/proc/meminfo: memFree=168056/1022884 swapFree=0/0
[pid=16071] ppid=16070 vsize=9172 CPUtime=0
/proc/16071/stat : 16071 (p2cudf-full-1.1) S 16070 16071 32685 0 -1 4202496 460 292 0 0 0 0 0 0 20 0 1 0 39061269 9392128 332 18446744073709551615 4194304 5129932 140733238027920 140733238026064 139987191407710 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/16071/statm: 2293 332 280 229 0 53 0
[pid=16074] ppid=16071 vsize=1046296 CPUtime=101.01
/proc/16074/stat : 16074 (java) S 16071 16071 32685 0 -1 4202496 118578 0 15 0 10048 53 0 0 20 0 11 0 39061270 1071407104 109587 18446744073709551615 4194304 4228012 140735246122832 140735246113856 140093848546933 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 4 0 0
/proc/16074/statm: 261574 109587 2392 9 0 248924 0
[pid=16074/tid=16075] ppid=16071 vsize=1046296 CPUtime=81.84
/proc/16074/task/16075/stat : 16075 (java) R 16071 16071 32685 0 -1 4202560 47779 0 3 0 8162 22 0 0 20 0 11 0 39061276 1071407104 109587 18446744073709551615 4194304 4228012 140735246122832 140093855080424 140093753429962 0 4 0 16800975 0 0 0 -1 0 0 0 5 0 0
[pid=16074/tid=16076] ppid=16071 vsize=1046296 CPUtime=14.33
/proc/16074/task/16076/stat : 16076 (java) S 16071 16071 32685 0 -1 4202560 47932 0 0 0 1414 19 0 0 20 0 11 0 39061280 1071407104 109587 18446744073709551615 4194304 4228012 140735246122832 140093747719296 140093848561227 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16077] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16077/stat : 16077 (java) S 16071 16071 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 39061281 1071407104 109587 18446744073709551615 4194304 4228012 140735246122832 140093746665488 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16078] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16078/stat : 16078 (java) S 16071 16071 32685 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 39061281 1071407104 109587 18446744073709551615 4194304 4228012 140735246122832 140093745612704 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16079] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16079/stat : 16079 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 39061284 1071407104 109587 18446744073709551615 4194304 4228012 140735246122832 140093744561136 140093848568864 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16080] ppid=16071 vsize=1046296 CPUtime=2.36
/proc/16074/task/16080/stat : 16080 (java) S 16071 16071 32685 0 -1 4202560 7941 0 0 0 234 2 0 0 20 0 11 0 39061284 1071407104 109587 18446744073709551615 4194304 4228012 140735246122832 140093743508496 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16081] ppid=16071 vsize=1046296 CPUtime=2.4
/proc/16074/task/16081/stat : 16081 (java) S 16071 16071 32685 0 -1 4202560 13636 0 0 0 231 9 0 0 20 0 11 0 39061284 1071407104 109587 18446744073709551615 4194304 4228012 140735246122832 140093742455824 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16082] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16082/stat : 16082 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 39061285 1071407104 109587 18446744073709551615 4194304 4228012 140735246122832 140093741403344 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16083] ppid=16071 vsize=1046296 CPUtime=0.06
/proc/16074/task/16083/stat : 16083 (java) S 16071 16071 32685 0 -1 4202560 4 0 0 0 6 0 0 0 20 0 11 0 39061285 1071407104 109587 18446744073709551615 4194304 4228012 140735246122832 140093740350848 140093848561227 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16084] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16084/stat : 16084 (java) S 16071 16071 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 39062030 1071407104 109587 18446744073709551615 4194304 4228012 140735246122832 140093739149152 140093848561227 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 101.01
Current children cumulated vsize (KiB) 1055468

[startup+162.301 s]
/proc/loadavg: 1.01 1.05 0.97 2/69 16084
/proc/meminfo: memFree=143256/1022884 swapFree=0/0
[pid=16071] ppid=16070 vsize=9172 CPUtime=0
/proc/16071/stat : 16071 (p2cudf-full-1.1) S 16070 16071 32685 0 -1 4202496 460 292 0 0 0 0 0 0 20 0 1 0 39061269 9392128 332 18446744073709551615 4194304 5129932 140733238027920 140733238026064 139987191407710 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/16071/statm: 2293 332 280 229 0 53 0
[pid=16074] ppid=16071 vsize=1046296 CPUtime=160.39
/proc/16074/stat : 16074 (java) S 16071 16071 32685 0 -1 4202496 124755 0 15 0 15985 54 0 0 20 0 11 0 39061270 1071407104 115756 18446744073709551615 4194304 4228012 140735246122832 140735246113856 140093848546933 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 4 0 0
/proc/16074/statm: 261574 115756 2392 9 0 248924 0
[pid=16074/tid=16075] ppid=16071 vsize=1046296 CPUtime=136.27
/proc/16074/task/16075/stat : 16075 (java) R 16071 16071 32685 0 -1 4202560 47779 0 3 0 13605 22 0 0 20 0 11 0 39061276 1071407104 115756 18446744073709551615 4194304 4228012 140735246122832 140093855080424 140093753809682 0 4 0 16800975 0 0 0 -1 0 0 0 8 0 0
[pid=16074/tid=16076] ppid=16071 vsize=1046296 CPUtime=19.26
/proc/16074/task/16076/stat : 16076 (java) S 16071 16071 32685 0 -1 4202560 54103 0 0 0 1906 20 0 0 20 0 11 0 39061280 1071407104 115756 18446744073709551615 4194304 4228012 140735246122832 140093747719296 140093848561227 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16077] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16077/stat : 16077 (java) S 16071 16071 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 39061281 1071407104 115756 18446744073709551615 4194304 4228012 140735246122832 140093746665488 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16078] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16078/stat : 16078 (java) S 16071 16071 32685 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 39061281 1071407104 115756 18446744073709551615 4194304 4228012 140735246122832 140093745612704 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16079] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16079/stat : 16079 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 39061284 1071407104 115756 18446744073709551615 4194304 4228012 140735246122832 140093744561136 140093848568864 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16080] ppid=16071 vsize=1046296 CPUtime=2.36
/proc/16074/task/16080/stat : 16080 (java) S 16071 16071 32685 0 -1 4202560 7941 0 0 0 234 2 0 0 20 0 11 0 39061284 1071407104 115756 18446744073709551615 4194304 4228012 140735246122832 140093743508496 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16081] ppid=16071 vsize=1046296 CPUtime=2.4
/proc/16074/task/16081/stat : 16081 (java) S 16071 16071 32685 0 -1 4202560 13636 0 0 0 231 9 0 0 20 0 11 0 39061284 1071407104 115756 18446744073709551615 4194304 4228012 140735246122832 140093742455824 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16082] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16082/stat : 16082 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 39061285 1071407104 115756 18446744073709551615 4194304 4228012 140735246122832 140093741403344 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16083] ppid=16071 vsize=1046296 CPUtime=0.08
/proc/16074/task/16083/stat : 16083 (java) S 16071 16071 32685 0 -1 4202560 10 0 0 0 8 0 0 0 20 0 11 0 39061285 1071407104 115756 18446744073709551615 4194304 4228012 140735246122832 140093740350848 140093848561227 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16084] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16084/stat : 16084 (java) S 16071 16071 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 39062030 1071407104 115756 18446744073709551615 4194304 4228012 140735246122832 140093739149152 140093848561227 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 160.39
Current children cumulated vsize (KiB) 1055468

[startup+222.309 s]
/proc/loadavg: 1.00 1.04 0.97 2/69 16084
/proc/meminfo: memFree=118456/1022884 swapFree=0/0
[pid=16071] ppid=16070 vsize=9172 CPUtime=0
/proc/16071/stat : 16071 (p2cudf-full-1.1) S 16070 16071 32685 0 -1 4202496 460 292 0 0 0 0 0 0 20 0 1 0 39061269 9392128 332 18446744073709551615 4194304 5129932 140733238027920 140733238026064 139987191407710 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/16071/statm: 2293 332 280 229 0 53 0
[pid=16074] ppid=16071 vsize=1046296 CPUtime=219.73
/proc/16074/stat : 16074 (java) S 16071 16071 32685 0 -1 4202496 130906 0 15 0 21917 56 0 0 20 0 11 0 39061270 1071407104 121899 18446744073709551615 4194304 4228012 140735246122832 140735246113856 140093848546933 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 4 0 0
/proc/16074/statm: 261574 121899 2392 9 0 248924 0
[pid=16074/tid=16075] ppid=16071 vsize=1046296 CPUtime=191.71
/proc/16074/task/16075/stat : 16075 (java) R 16071 16071 32685 0 -1 4202560 47779 0 3 0 19149 22 0 0 20 0 11 0 39061276 1071407104 121899 18446744073709551615 4194304 4228012 140735246122832 140093855080424 140093753429706 0 4 0 16800975 0 0 0 -1 0 0 0 9 0 0
[pid=16074/tid=16076] ppid=16071 vsize=1046296 CPUtime=23.1
/proc/16074/task/16076/stat : 16076 (java) S 16071 16071 32685 0 -1 4202560 60248 0 0 0 2288 22 0 0 20 0 11 0 39061280 1071407104 121899 18446744073709551615 4194304 4228012 140735246122832 140093747719296 140093848561227 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16077] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16077/stat : 16077 (java) S 16071 16071 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 39061281 1071407104 121899 18446744073709551615 4194304 4228012 140735246122832 140093746665488 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16078] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16078/stat : 16078 (java) S 16071 16071 32685 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 39061281 1071407104 121899 18446744073709551615 4194304 4228012 140735246122832 140093745612704 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16079] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16079/stat : 16079 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 39061284 1071407104 121899 18446744073709551615 4194304 4228012 140735246122832 140093744561136 140093848568864 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16080] ppid=16071 vsize=1046296 CPUtime=2.36
/proc/16074/task/16080/stat : 16080 (java) S 16071 16071 32685 0 -1 4202560 7941 0 0 0 234 2 0 0 20 0 11 0 39061284 1071407104 121899 18446744073709551615 4194304 4228012 140735246122832 140093743508496 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16081] ppid=16071 vsize=1046296 CPUtime=2.41
/proc/16074/task/16081/stat : 16081 (java) S 16071 16071 32685 0 -1 4202560 13636 0 0 0 232 9 0 0 20 0 11 0 39061284 1071407104 121899 18446744073709551615 4194304 4228012 140735246122832 140093742455824 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16082] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16082/stat : 16082 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 39061285 1071407104 121899 18446744073709551615 4194304 4228012 140735246122832 140093741403344 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16083] ppid=16071 vsize=1046296 CPUtime=0.12
/proc/16074/task/16083/stat : 16083 (java) S 16071 16071 32685 0 -1 4202560 16 0 0 0 12 0 0 0 20 0 11 0 39061285 1071407104 121899 18446744073709551615 4194304 4228012 140735246122832 140093740350848 140093848561227 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16084] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16084/stat : 16084 (java) S 16071 16071 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 39062030 1071407104 121899 18446744073709551615 4194304 4228012 140735246122832 140093739149152 140093848561227 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 219.73
Current children cumulated vsize (KiB) 1055468

[startup+282.301 s]
/proc/loadavg: 1.00 1.03 0.97 2/69 16084
/proc/meminfo: memFree=116596/1022884 swapFree=0/0
[pid=16071] ppid=16070 vsize=9172 CPUtime=0
/proc/16071/stat : 16071 (p2cudf-full-1.1) S 16070 16071 32685 0 -1 4202496 460 292 0 0 0 0 0 0 20 0 1 0 39061269 9392128 332 18446744073709551615 4194304 5129932 140733238027920 140733238026064 139987191407710 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/16071/statm: 2293 332 280 229 0 53 0
[pid=16074] ppid=16071 vsize=1046296 CPUtime=279.18
/proc/16074/stat : 16074 (java) S 16071 16071 32685 0 -1 4202496 131318 0 15 0 27862 56 0 0 20 0 11 0 39061270 1071407104 122303 18446744073709551615 4194304 4228012 140735246122832 140735246113856 140093848546933 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 4 0 0
/proc/16074/statm: 261574 122303 2392 9 0 248924 0
[pid=16074/tid=16075] ppid=16071 vsize=1046296 CPUtime=247.83
/proc/16074/task/16075/stat : 16075 (java) R 16071 16071 32685 0 -1 4202560 47779 0 3 0 24761 22 0 0 20 0 11 0 39061276 1071407104 122303 18446744073709551615 4194304 4228012 140735246122832 140093855080424 140093753788808 0 4 0 16800975 0 0 0 -1 0 0 0 9 0 0
[pid=16074/tid=16076] ppid=16071 vsize=1046296 CPUtime=26.41
/proc/16074/task/16076/stat : 16076 (java) S 16071 16071 32685 0 -1 4202560 60654 0 0 0 2619 22 0 0 20 0 11 0 39061280 1071407104 122303 18446744073709551615 4194304 4228012 140735246122832 140093747719296 140093848561227 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16077] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16077/stat : 16077 (java) S 16071 16071 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 39061281 1071407104 122303 18446744073709551615 4194304 4228012 140735246122832 140093746665488 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16078] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16078/stat : 16078 (java) S 16071 16071 32685 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 39061281 1071407104 122303 18446744073709551615 4194304 4228012 140735246122832 140093745612704 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16079] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16079/stat : 16079 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 39061284 1071407104 122303 18446744073709551615 4194304 4228012 140735246122832 140093744561136 140093848568864 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16080] ppid=16071 vsize=1046296 CPUtime=2.36
/proc/16074/task/16080/stat : 16080 (java) S 16071 16071 32685 0 -1 4202560 7941 0 0 0 234 2 0 0 20 0 11 0 39061284 1071407104 122303 18446744073709551615 4194304 4228012 140735246122832 140093743508496 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16081] ppid=16071 vsize=1046296 CPUtime=2.41
/proc/16074/task/16081/stat : 16081 (java) S 16071 16071 32685 0 -1 4202560 13636 0 0 0 232 9 0 0 20 0 11 0 39061284 1071407104 122303 18446744073709551615 4194304 4228012 140735246122832 140093742455824 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16082] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16082/stat : 16082 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 39061285 1071407104 122303 18446744073709551615 4194304 4228012 140735246122832 140093741403344 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16083] ppid=16071 vsize=1046296 CPUtime=0.15
/proc/16074/task/16083/stat : 16083 (java) S 16071 16071 32685 0 -1 4202560 22 0 0 0 15 0 0 0 20 0 11 0 39061285 1071407104 122303 18446744073709551615 4194304 4228012 140735246122832 140093740350848 140093848561227 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16084] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16084/stat : 16084 (java) S 16071 16071 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 39062030 1071407104 122303 18446744073709551615 4194304 4228012 140735246122832 140093739149152 140093848561227 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 279.18
Current children cumulated vsize (KiB) 1055468

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

[startup+288.001 s]
/proc/loadavg: 1.00 1.03 0.97 2/69 16084
/proc/meminfo: memFree=116100/1022884 swapFree=0/0
[pid=16071] ppid=16070 vsize=9172 CPUtime=0
/proc/16071/stat : 16071 (p2cudf-full-1.1) S 16070 16071 32685 0 -1 4202496 460 292 0 0 0 0 0 0 20 0 1 0 39061269 9392128 332 18446744073709551615 4194304 5129932 140733238027920 140733238026064 139987191407710 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/16071/statm: 2293 332 280 229 0 53 0
[pid=16074] ppid=16071 vsize=1046296 CPUtime=284.84
/proc/16074/stat : 16074 (java) S 16071 16071 32685 0 -1 4202496 131437 0 15 0 28427 57 0 0 20 0 11 0 39061270 1071407104 122422 18446744073709551615 4194304 4228012 140735246122832 140735246113856 140093848546933 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 4 0 0
/proc/16074/statm: 261574 122422 2392 9 0 248924 0
[pid=16074/tid=16075] ppid=16071 vsize=1046296 CPUtime=253.11
/proc/16074/task/16075/stat : 16075 (java) R 16071 16071 32685 0 -1 4202560 47779 0 3 0 25289 22 0 0 20 0 11 0 39061276 1071407104 122422 18446744073709551615 4194304 4228012 140735246122832 140093855080424 140093753815261 0 4 0 16800975 0 0 0 -1 0 0 0 9 0 0
[pid=16074/tid=16076] ppid=16071 vsize=1046296 CPUtime=26.77
/proc/16074/task/16076/stat : 16076 (java) S 16071 16071 32685 0 -1 4202560 60773 0 0 0 2655 22 0 0 20 0 11 0 39061280 1071407104 122422 18446744073709551615 4194304 4228012 140735246122832 140093747719296 140093848561227 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16077] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16077/stat : 16077 (java) S 16071 16071 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 39061281 1071407104 122422 18446744073709551615 4194304 4228012 140735246122832 140093746665488 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16078] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16078/stat : 16078 (java) S 16071 16071 32685 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 39061281 1071407104 122422 18446744073709551615 4194304 4228012 140735246122832 140093745612704 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16079] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16079/stat : 16079 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 39061284 1071407104 122422 18446744073709551615 4194304 4228012 140735246122832 140093744561136 140093848568864 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16080] ppid=16071 vsize=1046296 CPUtime=2.36
/proc/16074/task/16080/stat : 16080 (java) S 16071 16071 32685 0 -1 4202560 7941 0 0 0 234 2 0 0 20 0 11 0 39061284 1071407104 122422 18446744073709551615 4194304 4228012 140735246122832 140093743508496 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16081] ppid=16071 vsize=1046296 CPUtime=2.41
/proc/16074/task/16081/stat : 16081 (java) S 16071 16071 32685 0 -1 4202560 13636 0 0 0 232 9 0 0 20 0 11 0 39061284 1071407104 122422 18446744073709551615 4194304 4228012 140735246122832 140093742455824 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16082] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16082/stat : 16082 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 39061285 1071407104 122422 18446744073709551615 4194304 4228012 140735246122832 140093741403344 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16083] ppid=16071 vsize=1046296 CPUtime=0.15
/proc/16074/task/16083/stat : 16083 (java) S 16071 16071 32685 0 -1 4202560 22 0 0 0 15 0 0 0 20 0 11 0 39061285 1071407104 122422 18446744073709551615 4194304 4228012 140735246122832 140093740350848 140093848561227 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16084] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16084/stat : 16084 (java) S 16071 16071 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 39062030 1071407104 122422 18446744073709551615 4194304 4228012 140735246122832 140093739149152 140093848561227 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 284.84
Current children cumulated vsize (KiB) 1055468

[startup+291.201 s]
/proc/loadavg: 1.00 1.03 0.97 2/69 16084
/proc/meminfo: memFree=116100/1022884 swapFree=0/0
[pid=16071] ppid=16070 vsize=9172 CPUtime=0
/proc/16071/stat : 16071 (p2cudf-full-1.1) S 16070 16071 32685 0 -1 4202496 460 292 0 0 0 0 0 0 20 0 1 0 39061269 9392128 332 18446744073709551615 4194304 5129932 140733238027920 140733238026064 139987191407710 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/16071/statm: 2293 332 280 229 0 53 0
[pid=16074] ppid=16071 vsize=1046296 CPUtime=288.01
/proc/16074/stat : 16074 (java) S 16071 16071 32685 0 -1 4202496 131437 0 15 0 28744 57 0 0 20 0 11 0 39061270 1071407104 122422 18446744073709551615 4194304 4228012 140735246122832 140735246113856 140093848546933 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 4 0 0
/proc/16074/statm: 261574 122422 2392 9 0 248924 0
[pid=16074/tid=16075] ppid=16071 vsize=1046296 CPUtime=256.29
/proc/16074/task/16075/stat : 16075 (java) R 16071 16071 32685 0 -1 4202560 47779 0 3 0 25607 22 0 0 20 0 11 0 39061276 1071407104 122422 18446744073709551615 4194304 4228012 140735246122832 140093855080424 140093752746850 0 4 0 16800975 0 0 0 -1 0 0 0 9 0 0
[pid=16074/tid=16076] ppid=16071 vsize=1046296 CPUtime=26.77
/proc/16074/task/16076/stat : 16076 (java) S 16071 16071 32685 0 -1 4202560 60773 0 0 0 2655 22 0 0 20 0 11 0 39061280 1071407104 122422 18446744073709551615 4194304 4228012 140735246122832 140093747719296 140093848561227 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16077] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16077/stat : 16077 (java) S 16071 16071 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 39061281 1071407104 122422 18446744073709551615 4194304 4228012 140735246122832 140093746665488 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16078] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16078/stat : 16078 (java) S 16071 16071 32685 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 39061281 1071407104 122422 18446744073709551615 4194304 4228012 140735246122832 140093745612704 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16079] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16079/stat : 16079 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 39061284 1071407104 122422 18446744073709551615 4194304 4228012 140735246122832 140093744561136 140093848568864 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16080] ppid=16071 vsize=1046296 CPUtime=2.36
/proc/16074/task/16080/stat : 16080 (java) S 16071 16071 32685 0 -1 4202560 7941 0 0 0 234 2 0 0 20 0 11 0 39061284 1071407104 122422 18446744073709551615 4194304 4228012 140735246122832 140093743508496 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16081] ppid=16071 vsize=1046296 CPUtime=2.41
/proc/16074/task/16081/stat : 16081 (java) S 16071 16071 32685 0 -1 4202560 13636 0 0 0 232 9 0 0 20 0 11 0 39061284 1071407104 122422 18446744073709551615 4194304 4228012 140735246122832 140093742455824 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16082] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16082/stat : 16082 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 39061285 1071407104 122422 18446744073709551615 4194304 4228012 140735246122832 140093741403344 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16083] ppid=16071 vsize=1046296 CPUtime=0.15
/proc/16074/task/16083/stat : 16083 (java) S 16071 16071 32685 0 -1 4202560 22 0 0 0 15 0 0 0 20 0 11 0 39061285 1071407104 122422 18446744073709551615 4194304 4228012 140735246122832 140093740350848 140093848561227 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16084] ppid=16071 vsize=1046296 CPUtime=0
/proc/16074/task/16084/stat : 16084 (java) S 16071 16071 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 39062030 1071407104 122422 18446744073709551615 4194304 4228012 140735246122832 140093739149152 140093848561227 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 288.01
Current children cumulated vsize (KiB) 1055468

[startup+292.801 s]
/proc/loadavg: 1.00 1.03 0.97 2/69 16084
/proc/meminfo: memFree=114364/1022884 swapFree=0/0
[pid=16071] ppid=16070 vsize=9172 CPUtime=0
/proc/16071/stat : 16071 (p2cudf-full-1.1) S 16070 16071 32685 0 -1 4202496 460 292 0 0 0 0 0 0 20 0 1 0 39061269 9392128 332 18446744073709551615 4194304 5129932 140733238027920 140733238026064 139987191407710 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/16071/statm: 2293 332 280 229 0 53 0
[pid=16074] ppid=16071 vsize=1047324 CPUtime=289.44
/proc/16074/stat : 16074 (java) S 16071 16071 32685 0 -1 4202496 131877 0 15 0 28887 57 0 0 20 0 11 0 39061270 1072459776 122860 18446744073709551615 4194304 4228012 140735246122832 140735246113856 140093848546933 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 4 0 0
/proc/16074/statm: 261831 122860 2392 9 0 249181 0
[pid=16074/tid=16075] ppid=16071 vsize=1047324 CPUtime=257.38
/proc/16074/task/16075/stat : 16075 (java) S 16071 16071 32685 0 -1 4202560 47785 0 3 0 25716 22 0 0 20 0 11 0 39061276 1072459776 122860 18446744073709551615 4194304 4228012 140735246122832 140093855081392 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 9 0 0
[pid=16074/tid=16076] ppid=16071 vsize=1047324 CPUtime=27.09
/proc/16074/task/16076/stat : 16076 (java) S 16071 16071 32685 0 -1 4202560 61201 0 0 0 2687 22 0 0 20 0 11 0 39061280 1072459776 122860 18446744073709551615 4194304 4228012 140735246122832 140093747719296 140093848561227 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16077] ppid=16071 vsize=1047324 CPUtime=0
/proc/16074/task/16077/stat : 16077 (java) S 16071 16071 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 39061281 1072459776 122860 18446744073709551615 4194304 4228012 140735246122832 140093746665488 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16078] ppid=16071 vsize=1047324 CPUtime=0
/proc/16074/task/16078/stat : 16078 (java) S 16071 16071 32685 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 39061281 1072459776 122860 18446744073709551615 4194304 4228012 140735246122832 140093745612704 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16079] ppid=16071 vsize=1047324 CPUtime=0
/proc/16074/task/16079/stat : 16079 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 39061284 1072459776 122860 18446744073709551615 4194304 4228012 140735246122832 140093744561136 140093848568864 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16080] ppid=16071 vsize=1047324 CPUtime=2.37
/proc/16074/task/16080/stat : 16080 (java) S 16071 16071 32685 0 -1 4202560 7941 0 0 0 235 2 0 0 20 0 11 0 39061284 1072459776 122860 18446744073709551615 4194304 4228012 140735246122832 140093743508496 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16081] ppid=16071 vsize=1047324 CPUtime=2.41
/proc/16074/task/16081/stat : 16081 (java) S 16071 16071 32685 0 -1 4202560 13636 0 0 0 232 9 0 0 20 0 11 0 39061284 1072459776 122860 18446744073709551615 4194304 4228012 140735246122832 140093742455824 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16082] ppid=16071 vsize=1047324 CPUtime=0
/proc/16074/task/16082/stat : 16082 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 39061285 1072459776 122860 18446744073709551615 4194304 4228012 140735246122832 140093741403344 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16083] ppid=16071 vsize=1047324 CPUtime=0.15
/proc/16074/task/16083/stat : 16083 (java) S 16071 16071 32685 0 -1 4202560 22 0 0 0 15 0 0 0 20 0 11 0 39061285 1072459776 122860 18446744073709551615 4194304 4228012 140735246122832 140093740350848 140093848561227 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 289.44
Current children cumulated vsize (KiB) 1056496

[startup+293.201 s]
/proc/loadavg: 1.00 1.03 0.97 2/69 16084
/proc/meminfo: memFree=114364/1022884 swapFree=0/0
[pid=16071] ppid=16070 vsize=9172 CPUtime=0
/proc/16071/stat : 16071 (p2cudf-full-1.1) S 16070 16071 32685 0 -1 4202496 460 292 0 0 0 0 0 0 20 0 1 0 39061269 9392128 332 18446744073709551615 4194304 5129932 140733238027920 140733238026064 139987191407710 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/16071/statm: 2293 332 280 229 0 53 0
[pid=16074] ppid=16071 vsize=1047324 CPUtime=289.5
/proc/16074/stat : 16074 (java) S 16071 16071 32685 0 -1 4202496 131880 0 15 0 28892 58 0 0 20 0 11 0 39061270 1072459776 122863 18446744073709551615 4194304 4228012 140735246122832 140735246113856 140093848546933 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 4 0 0
/proc/16074/statm: 261831 122863 2392 9 0 249181 0
[pid=16074/tid=16075] ppid=16071 vsize=1047324 CPUtime=257.38
/proc/16074/task/16075/stat : 16075 (java) S 16071 16071 32685 0 -1 4202560 47785 0 3 0 25716 22 0 0 20 0 11 0 39061276 1072459776 122863 18446744073709551615 4194304 4228012 140735246122832 140093855081392 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 9 0 0
[pid=16074/tid=16076] ppid=16071 vsize=1047324 CPUtime=27.09
/proc/16074/task/16076/stat : 16076 (java) S 16071 16071 32685 0 -1 4202560 61201 0 0 0 2687 22 0 0 20 0 11 0 39061280 1072459776 122863 18446744073709551615 4194304 4228012 140735246122832 140093747719296 140093848561227 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16077] ppid=16071 vsize=1047324 CPUtime=0
/proc/16074/task/16077/stat : 16077 (java) S 16071 16071 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 39061281 1072459776 122863 18446744073709551615 4194304 4228012 140735246122832 140093746665488 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16078] ppid=16071 vsize=1047324 CPUtime=0
/proc/16074/task/16078/stat : 16078 (java) S 16071 16071 32685 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 39061281 1072459776 122863 18446744073709551615 4194304 4228012 140735246122832 140093745612704 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16079] ppid=16071 vsize=1047324 CPUtime=0
/proc/16074/task/16079/stat : 16079 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 39061284 1072459776 122863 18446744073709551615 4194304 4228012 140735246122832 140093744561136 140093848568864 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16080] ppid=16071 vsize=1047324 CPUtime=2.37
/proc/16074/task/16080/stat : 16080 (java) S 16071 16071 32685 0 -1 4202560 7941 0 0 0 235 2 0 0 20 0 11 0 39061284 1072459776 122863 18446744073709551615 4194304 4228012 140735246122832 140093743508496 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16081] ppid=16071 vsize=1047324 CPUtime=2.41
/proc/16074/task/16081/stat : 16081 (java) S 16071 16071 32685 0 -1 4202560 13636 0 0 0 232 9 0 0 20 0 11 0 39061284 1072459776 122863 18446744073709551615 4194304 4228012 140735246122832 140093742455824 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16082] ppid=16071 vsize=1047324 CPUtime=0
/proc/16074/task/16082/stat : 16082 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 39061285 1072459776 122863 18446744073709551615 4194304 4228012 140735246122832 140093741403344 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16083] ppid=16071 vsize=1047324 CPUtime=0.15
/proc/16074/task/16083/stat : 16083 (java) S 16071 16071 32685 0 -1 4202560 22 0 0 0 15 0 0 0 20 0 11 0 39061285 1072459776 122863 18446744073709551615 4194304 4228012 140735246122832 140093740350848 140093848561227 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 289.5
Current children cumulated vsize (KiB) 1056496

[startup+293.401 s]
/proc/loadavg: 1.00 1.03 0.97 2/69 16084
/proc/meminfo: memFree=114364/1022884 swapFree=0/0
[pid=16071] ppid=16070 vsize=9172 CPUtime=0
/proc/16071/stat : 16071 (p2cudf-full-1.1) S 16070 16071 32685 0 -1 4202496 460 292 0 0 0 0 0 0 20 0 1 0 39061269 9392128 332 18446744073709551615 4194304 5129932 140733238027920 140733238026064 139987191407710 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/16071/statm: 2293 332 280 229 0 53 0
[pid=16074] ppid=16071 vsize=1047324 CPUtime=289.69
/proc/16074/stat : 16074 (java) S 16071 16071 32685 0 -1 4202496 131890 0 15 0 28907 62 0 0 20 0 9 0 39061270 1072459776 122871 18446744073709551615 4194304 4228012 140735246122832 140735246113856 140093848546933 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 4 0 0
/proc/16074/statm: 261831 122871 2393 9 0 249181 0
[pid=16074/tid=16075] ppid=16071 vsize=1047324 CPUtime=257.38
/proc/16074/task/16075/stat : 16075 (java) S 16071 16071 32685 0 -1 4202560 47787 0 3 0 25716 22 0 0 20 0 9 0 39061276 1072459776 122871 18446744073709551615 4194304 4228012 140735246122832 140093855081648 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 9 0 0
[pid=16074/tid=16076] ppid=16071 vsize=1047324 CPUtime=27.09
/proc/16074/task/16076/stat : 16076 (java) S 16071 16071 32685 0 -1 4202560 61201 0 0 0 2687 22 0 0 20 0 9 0 39061280 1072459776 122871 18446744073709551615 4194304 4228012 140735246122832 140093747718880 140093848561227 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16077] ppid=16071 vsize=1047324 CPUtime=0
/proc/16074/task/16077/stat : 16077 (java) S 16071 16071 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 9 0 39061281 1072459776 122871 18446744073709551615 4194304 4228012 140735246122832 140093746665488 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16078] ppid=16071 vsize=1047324 CPUtime=0
/proc/16074/task/16078/stat : 16078 (java) S 16071 16071 32685 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 9 0 39061281 1072459776 122871 18446744073709551615 4194304 4228012 140735246122832 140093745612704 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16080] ppid=16071 vsize=1047324 CPUtime=2.41
/proc/16074/task/16080/stat : 16080 (java) S 16071 16071 32685 0 -1 4202560 7942 0 0 0 239 2 0 0 20 0 9 0 39061284 1072459776 122871 18446744073709551615 4194304 4228012 140735246122832 140093743495520 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16081] ppid=16071 vsize=1047324 CPUtime=2.46
/proc/16074/task/16081/stat : 16081 (java) S 16071 16071 32685 0 -1 4202560 13636 0 0 0 237 9 0 0 20 0 9 0 39061284 1072459776 122871 18446744073709551615 4194304 4228012 140735246122832 140093742455824 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=16074/tid=16082] ppid=16071 vsize=1047324 CPUtime=0
/proc/16074/task/16082/stat : 16082 (java) S 16071 16071 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 9 0 39061285 1072459776 122871 18446744073709551615 4194304 4228012 140735246122832 140093741403344 140093848560340 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 289.69
Current children cumulated vsize (KiB) 1056496

Child status: 0
Real time (s): 293.468
CPU time (s): 289.77
CPU user time (s): 289.098
CPU system time (s): 0.672042
CPU usage (%): 98.7399
Max. virtual memory (cumulated for all children) (KiB): 1059728

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 289.098
system time used= 0.672042
maximum resident set size= 491496
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 132657
page faults= 15
swaps= 0
block input operations= 24320
block output operations= 608
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 7351
involuntary context switches= 13011

runsolver used 0.940058 second user time and 2.11613 second system time

The end