runsolver Copyright (C) 2010 Olivier ROUSSEL

This is runsolver version 3.2.9a (svn: 651)

This program is distributed in the hope that it will be useful,
but WITHOUT ANY WARRANTY; without even the implied warranty of
MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE.  See the
GNU General Public License for more details.

command line: runsolver -s SIGUSR1 -M 1124 -C 300 -d 10 -w /tmp/misc2012/2012-09-02-22:42/full/p2cudf-full-1.15/slowlink/upgrade/easy/rand929.cudf.log.runsolver /home/competition/p2cudf-full-1.15/p2cudf-full-1.15 /home/competition/data/upgrade/easy/rand929.cudf /tmp/misc2012/2012-09-02-22:42/full/p2cudf-full-1.15/slowlink/upgrade/easy/rand929.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

[startup+0 s]
/proc/loadavg: 1.05 1.08 1.07 2/60 29051
/proc/meminfo: memFree=575400/1022884 swapFree=0/0
[pid=29051] ppid=29050 vsize=3152 CPUtime=0
/proc/29051/stat : 29051 (runsolver) R 29050 32685 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 1 0 42716247 3227648 32 18446744073709551615 134512640 134586868 4290298768 4290296816 4151927856 0 0 16781316 24578 0 0 0 17 0 0 0 0 0 0
/proc/29051/statm: 788 32 0 19 0 73 0
Current StackSize limit: 8192 KiB


[startup+0.16505 s]
/proc/loadavg: 1.05 1.08 1.07 2/60 29051
/proc/meminfo: memFree=575400/1022884 swapFree=0/0
[pid=29051] ppid=29050 vsize=9168 CPUtime=0
/proc/29051/stat : 29051 (p2cudf-full-1.1) S 29050 29051 32685 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 42716247 9388032 330 18446744073709551615 4194304 5129932 140736581427744 140736581425888 140238474294366 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/29051/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.200302 s]
/proc/loadavg: 1.05 1.08 1.07 2/60 29051
/proc/meminfo: memFree=575400/1022884 swapFree=0/0
[pid=29051] ppid=29050 vsize=9168 CPUtime=0
/proc/29051/stat : 29051 (p2cudf-full-1.1) S 29050 29051 32685 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 42716247 9388032 330 18446744073709551615 4194304 5129932 140736581427744 140736581425888 140238474294366 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/29051/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.300302 s]
/proc/loadavg: 1.05 1.08 1.07 2/60 29051
/proc/meminfo: memFree=575400/1022884 swapFree=0/0
[pid=29051] ppid=29050 vsize=9168 CPUtime=0
/proc/29051/stat : 29051 (p2cudf-full-1.1) S 29050 29051 32685 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 42716247 9388032 330 18446744073709551615 4194304 5129932 140736581427744 140736581425888 140238474294366 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/29051/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.700208 s]
/proc/loadavg: 1.05 1.08 1.07 2/60 29051
/proc/meminfo: memFree=575400/1022884 swapFree=0/0
[pid=29051] ppid=29050 vsize=9168 CPUtime=0
/proc/29051/stat : 29051 (p2cudf-full-1.1) S 29050 29051 32685 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 42716247 9388032 330 18446744073709551615 4194304 5129932 140736581427744 140736581425888 140238474294366 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/29051/statm: 2292 330 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.05 1.08 1.07 4/71 29063
/proc/meminfo: memFree=522976/1022884 swapFree=0/0
[pid=29051] ppid=29050 vsize=9168 CPUtime=0
/proc/29051/stat : 29051 (p2cudf-full-1.1) S 29050 29051 32685 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 42716247 9388032 330 18446744073709551615 4194304 5129932 140736581427744 140736581425888 140238474294366 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/29051/statm: 2292 330 280 229 0 52 0
[pid=29054] ppid=29051 vsize=1050000 CPUtime=1.46
/proc/29054/stat : 29054 (java) S 29051 29051 32685 0 -1 4202496 34105 0 0 0 129 17 0 0 20 0 10 0 42716248 1075200000 30245 18446744073709551615 4194304 4228012 140734144603696 140734144594720 139809826856565 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/29054/statm: 262500 30245 2348 9 0 249850 0
[pid=29054/tid=29055] ppid=29051 vsize=1050000 CPUtime=0.66
/proc/29054/task/29055/stat : 29055 (java) R 29051 29051 32685 0 -1 4202560 14757 0 0 0 56 10 0 0 20 0 10 0 42716249 1075200000 30245 18446744073709551615 4194304 4228012 140734144603696 139809833382560 139809730881280 0 4 0 16800975 0 0 0 -1 0 0 0 2 0 0
[pid=29054/tid=29056] ppid=29051 vsize=1050000 CPUtime=0
/proc/29054/task/29056/stat : 29056 (java) S 29051 29051 32685 0 -1 4202560 4 0 0 0 0 0 0 0 20 0 10 0 42716251 1075200000 30245 18446744073709551615 4194304 4228012 140734144603696 139809726028928 139809826870859 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29057] ppid=29051 vsize=1050000 CPUtime=0
/proc/29054/task/29057/stat : 29057 (java) S 29051 29051 32685 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 10 0 42716252 1075200000 30245 18446744073709551615 4194304 4228012 140734144603696 139809724975120 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29058] ppid=29051 vsize=1050000 CPUtime=0
/proc/29054/task/29058/stat : 29058 (java) S 29051 29051 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 10 0 42716252 1075200000 30245 18446744073709551615 4194304 4228012 140734144603696 139809723922336 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29059] ppid=29051 vsize=1050000 CPUtime=0
/proc/29054/task/29059/stat : 29059 (java) S 29051 29051 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 42716256 1075200000 30245 18446744073709551615 4194304 4228012 140734144603696 139809722870768 139809826878496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29060] ppid=29051 vsize=1050000 CPUtime=0.4
/proc/29054/task/29060/stat : 29060 (java) R 29051 29051 32685 0 -1 4202560 9140 0 0 0 38 2 0 0 20 0 10 0 42716256 1075200000 30245 18446744073709551615 4194304 4228012 140734144603696 139809721805928 139809811160759 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29061] ppid=29051 vsize=1050000 CPUtime=0.35
/proc/29054/task/29061/stat : 29061 (java) R 29051 29051 32685 0 -1 4202560 8917 0 0 0 32 3 0 0 20 0 10 0 42716256 1075200000 30245 18446744073709551615 4194304 4228012 140734144603696 139809720750696 139809812524202 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29062] ppid=29051 vsize=1050000 CPUtime=0
/proc/29054/task/29062/stat : 29062 (java) S 29051 29051 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 42716256 1075200000 30245 18446744073709551615 4194304 4228012 140734144603696 139809719712976 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29063] ppid=29051 vsize=1050000 CPUtime=0
/proc/29054/task/29063/stat : 29063 (java) S 29051 29051 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 42716256 1075200000 30245 18446744073709551615 4194304 4228012 140734144603696 139809718660480 139809826870859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 1.46
Current children cumulated vsize (KiB) 1059168

[startup+3.10076 s]
/proc/loadavg: 1.05 1.08 1.07 4/71 29063
/proc/meminfo: memFree=425388/1022884 swapFree=0/0
[pid=29051] ppid=29050 vsize=9168 CPUtime=0
/proc/29051/stat : 29051 (p2cudf-full-1.1) S 29050 29051 32685 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 42716247 9388032 330 18446744073709551615 4194304 5129932 140736581427744 140736581425888 140238474294366 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/29051/statm: 2292 330 280 229 0 52 0
[pid=29054] ppid=29051 vsize=1050208 CPUtime=3.04
/proc/29054/stat : 29054 (java) S 29051 29051 32685 0 -1 4202496 75889 0 0 0 271 33 0 0 20 0 10 0 42716248 1075412992 70736 18446744073709551615 4194304 4228012 140734144603696 140734144594720 139809826856565 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/29054/statm: 262552 70736 2368 9 0 249902 0
[pid=29054/tid=29055] ppid=29051 vsize=1050208 CPUtime=1.56
/proc/29054/task/29055/stat : 29055 (java) R 29051 29051 32685 0 -1 4202560 47404 0 0 0 132 24 0 0 20 0 10 0 42716249 1075412992 70736 18446744073709551615 4194304 4228012 140734144603696 139809833382592 139809731201416 0 4 0 16800975 0 0 0 -1 0 0 0 2 0 0
[pid=29054/tid=29056] ppid=29051 vsize=1050208 CPUtime=0.16
/proc/29054/task/29056/stat : 29056 (java) S 29051 29051 32685 0 -1 4202560 7936 0 0 0 14 2 0 0 20 0 10 0 42716251 1075412992 70736 18446744073709551615 4194304 4228012 140734144603696 139809726028928 139809826870859 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29057] ppid=29051 vsize=1050208 CPUtime=0
/proc/29054/task/29057/stat : 29057 (java) S 29051 29051 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 42716252 1075412992 70736 18446744073709551615 4194304 4228012 140734144603696 139809724975120 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29058] ppid=29051 vsize=1050208 CPUtime=0
/proc/29054/task/29058/stat : 29058 (java) S 29051 29051 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 10 0 42716252 1075412992 70736 18446744073709551615 4194304 4228012 140734144603696 139809723922336 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29059] ppid=29051 vsize=1050208 CPUtime=0
/proc/29054/task/29059/stat : 29059 (java) S 29051 29051 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 42716256 1075412992 70736 18446744073709551615 4194304 4228012 140734144603696 139809722870768 139809826878496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29060] ppid=29051 vsize=1050208 CPUtime=0.67
/proc/29054/task/29060/stat : 29060 (java) S 29051 29051 32685 0 -1 4202560 9586 0 0 0 65 2 0 0 20 0 10 0 42716256 1075412992 70736 18446744073709551615 4194304 4228012 140734144603696 139809721818128 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29061] ppid=29051 vsize=1050208 CPUtime=0.61
/proc/29054/task/29061/stat : 29061 (java) S 29051 29051 32685 0 -1 4202560 9672 0 0 0 57 4 0 0 20 0 10 0 42716256 1075412992 70736 18446744073709551615 4194304 4228012 140734144603696 139809720765456 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29062] ppid=29051 vsize=1050208 CPUtime=0
/proc/29054/task/29062/stat : 29062 (java) S 29051 29051 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 42716256 1075412992 70736 18446744073709551615 4194304 4228012 140734144603696 139809719712976 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29063] ppid=29051 vsize=1050208 CPUtime=0
/proc/29054/task/29063/stat : 29063 (java) S 29051 29051 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 42716256 1075412992 70736 18446744073709551615 4194304 4228012 140734144603696 139809718660480 139809826870859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 3.04
Current children cumulated vsize (KiB) 1059376

[startup+6.30076 s]
/proc/loadavg: 1.05 1.08 1.07 2/71 29063
/proc/meminfo: memFree=132004/1022884 swapFree=0/0
[pid=29051] ppid=29050 vsize=9168 CPUtime=0
/proc/29051/stat : 29051 (p2cudf-full-1.1) S 29050 29051 32685 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 42716247 9388032 330 18446744073709551615 4194304 5129932 140736581427744 140736581425888 140238474294366 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/29051/statm: 2292 330 280 229 0 52 0
[pid=29054] ppid=29051 vsize=1047316 CPUtime=6.13
/proc/29054/stat : 29054 (java) S 29051 29051 32685 0 -1 4202496 113317 0 0 0 566 47 0 0 20 0 10 0 42716248 1072451584 107780 18446744073709551615 4194304 4228012 140734144603696 140734144594720 139809826856565 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/29054/statm: 261829 107780 2371 9 0 249179 0
[pid=29054/tid=29055] ppid=29051 vsize=1047316 CPUtime=3.26
/proc/29054/task/29055/stat : 29055 (java) R 29051 29051 32685 0 -1 4202560 47471 0 0 0 300 26 0 0 20 0 10 0 42716249 1072451584 107780 18446744073709551615 4194304 4228012 140734144603696 139809833391064 139809810351555 0 4 0 16800975 0 0 0 -1 0 0 0 10 0 0
[pid=29054/tid=29056] ppid=29051 vsize=1047316 CPUtime=1.06
/proc/29054/task/29056/stat : 29056 (java) S 29051 29051 32685 0 -1 4202560 45148 0 0 0 92 14 0 0 20 0 10 0 42716251 1072451584 107780 18446744073709551615 4194304 4228012 140734144603696 139809726028928 139809826870859 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29057] ppid=29051 vsize=1047316 CPUtime=0
/proc/29054/task/29057/stat : 29057 (java) S 29051 29051 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 42716252 1072451584 107780 18446744073709551615 4194304 4228012 140734144603696 139809724975120 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29058] ppid=29051 vsize=1047316 CPUtime=0
/proc/29054/task/29058/stat : 29058 (java) S 29051 29051 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 10 0 42716252 1072451584 107780 18446744073709551615 4194304 4228012 140734144603696 139809723922336 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29059] ppid=29051 vsize=1047316 CPUtime=0
/proc/29054/task/29059/stat : 29059 (java) S 29051 29051 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 42716256 1072451584 107780 18446744073709551615 4194304 4228012 140734144603696 139809722870768 139809826878496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29060] ppid=29051 vsize=1047316 CPUtime=0.91
/proc/29054/task/29060/stat : 29060 (java) R 29051 29051 32685 0 -1 4202560 9603 0 0 0 89 2 0 0 20 0 10 0 42716256 1072451584 107780 18446744073709551615 4194304 4228012 140734144603696 139809721817872 139809812696375 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29061] ppid=29051 vsize=1047316 CPUtime=0.87
/proc/29054/task/29061/stat : 29061 (java) R 29051 29051 32685 0 -1 4202560 9804 0 0 0 83 4 0 0 20 0 10 0 42716256 1072451584 107780 18446744073709551615 4194304 4228012 140734144603696 139809720765200 139809812522062 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29062] ppid=29051 vsize=1047316 CPUtime=0
/proc/29054/task/29062/stat : 29062 (java) S 29051 29051 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 42716256 1072451584 107780 18446744073709551615 4194304 4228012 140734144603696 139809719712976 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29063] ppid=29051 vsize=1047316 CPUtime=0
/proc/29054/task/29063/stat : 29063 (java) S 29051 29051 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 42716256 1072451584 107780 18446744073709551615 4194304 4228012 140734144603696 139809718660480 139809826870859 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) 1056484

[startup+12.7008 s]
/proc/loadavg: 1.20 1.11 1.08 2/72 29064
/proc/meminfo: memFree=91944/1022884 swapFree=0/0
[pid=29051] ppid=29050 vsize=9168 CPUtime=0
/proc/29051/stat : 29051 (p2cudf-full-1.1) S 29050 29051 32685 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 42716247 9388032 330 18446744073709551615 4194304 5129932 140736581427744 140736581425888 140238474294366 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/29051/statm: 2292 330 280 229 0 52 0
[pid=29054] ppid=29051 vsize=1048344 CPUtime=12.45
/proc/29054/stat : 29054 (java) S 29051 29051 32685 0 -1 4202496 124419 0 0 0 1193 52 0 0 20 0 11 0 42716248 1073504256 117498 18446744073709551615 4194304 4228012 140734144603696 140734144594720 139809826856565 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/29054/statm: 262086 117498 2380 9 0 249436 0
[pid=29054/tid=29055] ppid=29051 vsize=1048344 CPUtime=7.29
/proc/29054/task/29055/stat : 29055 (java) R 29051 29051 32685 0 -1 4202560 47791 0 0 0 703 26 0 0 20 0 11 0 42716249 1073504256 117498 18446744073709551615 4194304 4228012 140734144603696 139809833390312 139809732091049 0 4 0 16800975 0 0 0 -1 0 0 0 10 0 0
[pid=29054/tid=29056] ppid=29051 vsize=1048344 CPUtime=1.29
/proc/29054/task/29056/stat : 29056 (java) S 29051 29051 32685 0 -1 4202560 52861 0 0 0 112 17 0 0 20 0 11 0 42716251 1073504256 117498 18446744073709551615 4194304 4228012 140734144603696 139809726028928 139809826870859 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29057] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29057/stat : 29057 (java) S 29051 29051 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 42716252 1073504256 117498 18446744073709551615 4194304 4228012 140734144603696 139809724975120 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29058] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29058/stat : 29058 (java) S 29051 29051 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 42716252 1073504256 117498 18446744073709551615 4194304 4228012 140734144603696 139809723922336 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29059] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29059/stat : 29059 (java) S 29051 29051 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 42716256 1073504256 117498 18446744073709551615 4194304 4228012 140734144603696 139809722870768 139809826878496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29060] ppid=29051 vsize=1048344 CPUtime=2.03
/proc/29054/task/29060/stat : 29060 (java) S 29051 29051 32685 0 -1 4202560 11087 0 0 0 200 3 0 0 20 0 11 0 42716256 1073504256 117498 18446744073709551615 4194304 4228012 140734144603696 139809721818128 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29061] ppid=29051 vsize=1048344 CPUtime=1.8
/proc/29054/task/29061/stat : 29061 (java) S 29051 29051 32685 0 -1 4202560 11383 0 0 0 176 4 0 0 20 0 11 0 42716256 1073504256 117498 18446744073709551615 4194304 4228012 140734144603696 139809720765456 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29062] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29062/stat : 29062 (java) S 29051 29051 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 42716256 1073504256 117498 18446744073709551615 4194304 4228012 140734144603696 139809719712976 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29063] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29063/stat : 29063 (java) S 29051 29051 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 42716256 1073504256 117498 18446744073709551615 4194304 4228012 140734144603696 139809718660480 139809826870859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29064] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29064/stat : 29064 (java) S 29051 29051 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 42717124 1073504256 117498 18446744073709551615 4194304 4228012 140734144603696 139809717458784 139809826870859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 12.45
Current children cumulated vsize (KiB) 1057512

[startup+25.5008 s]
/proc/loadavg: 1.16 1.10 1.08 2/72 29064
/proc/meminfo: memFree=52388/1022884 swapFree=0/0
[pid=29051] ppid=29050 vsize=9168 CPUtime=0
/proc/29051/stat : 29051 (p2cudf-full-1.1) S 29050 29051 32685 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 42716247 9388032 330 18446744073709551615 4194304 5129932 140736581427744 140736581425888 140238474294366 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/29051/statm: 2292 330 280 229 0 52 0
[pid=29054] ppid=29051 vsize=1048344 CPUtime=25.1
/proc/29054/stat : 29054 (java) S 29051 29051 32685 0 -1 4202496 134314 0 0 0 2454 56 0 0 20 0 11 0 42716248 1073504256 127393 18446744073709551615 4194304 4228012 140734144603696 140734144594720 139809826856565 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/29054/statm: 262086 127393 2392 9 0 249436 0
[pid=29054/tid=29055] ppid=29051 vsize=1048344 CPUtime=17.89
/proc/29054/task/29055/stat : 29055 (java) R 29051 29051 32685 0 -1 4202560 47792 0 0 0 1763 26 0 0 20 0 11 0 42716249 1073504256 127393 18446744073709551615 4194304 4228012 140734144603696 139809833388216 139809732091891 0 4 0 16800975 0 0 0 -1 0 0 0 10 0 0
[pid=29054/tid=29056] ppid=29051 vsize=1048344 CPUtime=2.98
/proc/29054/task/29056/stat : 29056 (java) S 29051 29051 32685 0 -1 4202560 62721 0 0 0 276 22 0 0 20 0 11 0 42716251 1073504256 127393 18446744073709551615 4194304 4228012 140734144603696 139809726028928 139809826870859 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29057] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29057/stat : 29057 (java) S 29051 29051 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 42716252 1073504256 127393 18446744073709551615 4194304 4228012 140734144603696 139809724975120 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29058] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29058/stat : 29058 (java) S 29051 29051 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 42716252 1073504256 127393 18446744073709551615 4194304 4228012 140734144603696 139809723922336 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29059] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29059/stat : 29059 (java) S 29051 29051 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 42716256 1073504256 127393 18446744073709551615 4194304 4228012 140734144603696 139809722870768 139809826878496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29060] ppid=29051 vsize=1048344 CPUtime=2.35
/proc/29054/task/29060/stat : 29060 (java) S 29051 29051 32685 0 -1 4202560 11121 0 0 0 232 3 0 0 20 0 11 0 42716256 1073504256 127393 18446744073709551615 4194304 4228012 140734144603696 139809721818128 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29061] ppid=29051 vsize=1048344 CPUtime=1.83
/proc/29054/task/29061/stat : 29061 (java) S 29051 29051 32685 0 -1 4202560 11383 0 0 0 179 4 0 0 20 0 11 0 42716256 1073504256 127393 18446744073709551615 4194304 4228012 140734144603696 139809720765456 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29062] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29062/stat : 29062 (java) S 29051 29051 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 42716256 1073504256 127393 18446744073709551615 4194304 4228012 140734144603696 139809719712976 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29063] ppid=29051 vsize=1048344 CPUtime=0.01
/proc/29054/task/29063/stat : 29063 (java) S 29051 29051 32685 0 -1 4202560 0 0 0 0 1 0 0 0 20 0 11 0 42716256 1073504256 127393 18446744073709551615 4194304 4228012 140734144603696 139809718660480 139809826870859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29064] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29064/stat : 29064 (java) S 29051 29051 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 42717124 1073504256 127393 18446744073709551615 4194304 4228012 140734144603696 139809717458784 139809826870859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 25.1
Current children cumulated vsize (KiB) 1057512

[startup+51.1009 s]
/proc/loadavg: 1.10 1.09 1.08 2/72 29064
/proc/meminfo: memFree=46932/1022884 swapFree=0/0
[pid=29051] ppid=29050 vsize=9168 CPUtime=0
/proc/29051/stat : 29051 (p2cudf-full-1.1) S 29050 29051 32685 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 42716247 9388032 330 18446744073709551615 4194304 5129932 140736581427744 140736581425888 140238474294366 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/29051/statm: 2292 330 280 229 0 52 0
[pid=29054] ppid=29051 vsize=1048344 CPUtime=50.41
/proc/29054/stat : 29054 (java) S 29051 29051 32685 0 -1 4202496 135645 0 0 0 4984 57 0 0 20 0 11 0 42716248 1073504256 128720 18446744073709551615 4194304 4228012 140734144603696 140734144594720 139809826856565 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/29054/statm: 262086 128720 2392 9 0 249436 0
[pid=29054/tid=29055] ppid=29051 vsize=1048344 CPUtime=40.6
/proc/29054/task/29055/stat : 29055 (java) R 29051 29051 32685 0 -1 4202560 47792 0 0 0 4034 26 0 0 20 0 11 0 42716249 1073504256 128720 18446744073709551615 4194304 4228012 140734144603696 139809833390056 139809731821784 0 4 0 16800975 0 0 0 -1 0 0 0 10 0 0
[pid=29054/tid=29056] ppid=29051 vsize=1048344 CPUtime=5.5
/proc/29054/task/29056/stat : 29056 (java) S 29051 29051 32685 0 -1 4202560 64049 0 0 0 528 22 0 0 20 0 11 0 42716251 1073504256 128720 18446744073709551615 4194304 4228012 140734144603696 139809726028928 139809826870859 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29057] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29057/stat : 29057 (java) S 29051 29051 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 42716252 1073504256 128720 18446744073709551615 4194304 4228012 140734144603696 139809724975120 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29058] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29058/stat : 29058 (java) S 29051 29051 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 42716252 1073504256 128720 18446744073709551615 4194304 4228012 140734144603696 139809723922336 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29059] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29059/stat : 29059 (java) S 29051 29051 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 42716256 1073504256 128720 18446744073709551615 4194304 4228012 140734144603696 139809722870768 139809826878496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29060] ppid=29051 vsize=1048344 CPUtime=2.38
/proc/29054/task/29060/stat : 29060 (java) S 29051 29051 32685 0 -1 4202560 11121 0 0 0 235 3 0 0 20 0 11 0 42716256 1073504256 128720 18446744073709551615 4194304 4228012 140734144603696 139809721818128 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29061] ppid=29051 vsize=1048344 CPUtime=1.86
/proc/29054/task/29061/stat : 29061 (java) S 29051 29051 32685 0 -1 4202560 11383 0 0 0 182 4 0 0 20 0 11 0 42716256 1073504256 128720 18446744073709551615 4194304 4228012 140734144603696 139809720765456 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29062] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29062/stat : 29062 (java) S 29051 29051 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 42716256 1073504256 128720 18446744073709551615 4194304 4228012 140734144603696 139809719712976 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29063] ppid=29051 vsize=1048344 CPUtime=0.02
/proc/29054/task/29063/stat : 29063 (java) S 29051 29051 32685 0 -1 4202560 3 0 0 0 2 0 0 0 20 0 11 0 42716256 1073504256 128720 18446744073709551615 4194304 4228012 140734144603696 139809718660480 139809826870859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29064] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29064/stat : 29064 (java) S 29051 29051 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 42717124 1073504256 128720 18446744073709551615 4194304 4228012 140734144603696 139809717458784 139809826870859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 50.41
Current children cumulated vsize (KiB) 1057512

[startup+102.301 s]
/proc/loadavg: 1.04 1.08 1.07 2/72 29064
/proc/meminfo: memFree=35524/1022884 swapFree=0/0
[pid=29051] ppid=29050 vsize=9168 CPUtime=0
/proc/29051/stat : 29051 (p2cudf-full-1.1) S 29050 29051 32685 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 42716247 9388032 330 18446744073709551615 4194304 5129932 140736581427744 140736581425888 140238474294366 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/29051/statm: 2292 330 280 229 0 52 0
[pid=29054] ppid=29051 vsize=1048344 CPUtime=101.05
/proc/29054/stat : 29054 (java) S 29051 29051 32685 0 -1 4202496 138466 0 0 0 10047 58 0 0 20 0 11 0 42716248 1073504256 131534 18446744073709551615 4194304 4228012 140734144603696 140734144594720 139809826856565 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/29054/statm: 262086 131534 2392 9 0 249436 0
[pid=29054/tid=29055] ppid=29051 vsize=1048344 CPUtime=86.74
/proc/29054/task/29055/stat : 29055 (java) R 29051 29051 32685 0 -1 4202560 47792 0 0 0 8648 26 0 0 20 0 11 0 42716249 1073504256 131534 18446744073709551615 4194304 4228012 140734144603696 139809833390056 139809731858156 0 4 0 16800975 0 0 0 -1 0 0 0 10 0 0
[pid=29054/tid=29056] ppid=29051 vsize=1048344 CPUtime=9.96
/proc/29054/task/29056/stat : 29056 (java) S 29051 29051 32685 0 -1 4202560 66864 0 0 0 973 23 0 0 20 0 11 0 42716251 1073504256 131534 18446744073709551615 4194304 4228012 140734144603696 139809726028928 139809826870859 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29057] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29057/stat : 29057 (java) S 29051 29051 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 42716252 1073504256 131534 18446744073709551615 4194304 4228012 140734144603696 139809724975120 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29058] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29058/stat : 29058 (java) S 29051 29051 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 42716252 1073504256 131534 18446744073709551615 4194304 4228012 140734144603696 139809723922336 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29059] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29059/stat : 29059 (java) S 29051 29051 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 42716256 1073504256 131534 18446744073709551615 4194304 4228012 140734144603696 139809722870768 139809826878496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29060] ppid=29051 vsize=1048344 CPUtime=2.39
/proc/29054/task/29060/stat : 29060 (java) S 29051 29051 32685 0 -1 4202560 11121 0 0 0 236 3 0 0 20 0 11 0 42716256 1073504256 131534 18446744073709551615 4194304 4228012 140734144603696 139809721818128 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29061] ppid=29051 vsize=1048344 CPUtime=1.86
/proc/29054/task/29061/stat : 29061 (java) S 29051 29051 32685 0 -1 4202560 11383 0 0 0 182 4 0 0 20 0 11 0 42716256 1073504256 131534 18446744073709551615 4194304 4228012 140734144603696 139809720765456 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29062] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29062/stat : 29062 (java) S 29051 29051 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 42716256 1073504256 131534 18446744073709551615 4194304 4228012 140734144603696 139809719712976 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29063] ppid=29051 vsize=1048344 CPUtime=0.05
/proc/29054/task/29063/stat : 29063 (java) S 29051 29051 32685 0 -1 4202560 9 0 0 0 5 0 0 0 20 0 11 0 42716256 1073504256 131534 18446744073709551615 4194304 4228012 140734144603696 139809718660480 139809826870859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29064] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29064/stat : 29064 (java) S 29051 29051 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 42717124 1073504256 131534 18446744073709551615 4194304 4228012 140734144603696 139809717458784 139809826870859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 101.05
Current children cumulated vsize (KiB) 1057512

[startup+162.301 s]
/proc/loadavg: 1.01 1.06 1.07 2/72 29064
/proc/meminfo: memFree=30812/1022884 swapFree=0/0
[pid=29051] ppid=29050 vsize=9168 CPUtime=0
/proc/29051/stat : 29051 (p2cudf-full-1.1) S 29050 29051 32685 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 42716247 9388032 330 18446744073709551615 4194304 5129932 140736581427744 140736581425888 140238474294366 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/29051/statm: 2292 330 280 229 0 52 0
[pid=29054] ppid=29051 vsize=1048344 CPUtime=160.55
/proc/29054/stat : 29054 (java) S 29051 29051 32685 0 -1 4202496 139613 0 0 0 15997 58 0 0 20 0 11 0 42716248 1073504256 132676 18446744073709551615 4194304 4228012 140734144603696 140734144594720 139809826856565 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/29054/statm: 262086 132676 2392 9 0 249436 0
[pid=29054/tid=29055] ppid=29051 vsize=1048344 CPUtime=143.71
/proc/29054/task/29055/stat : 29055 (java) R 29051 29051 32685 0 -1 4202560 47792 0 0 0 14345 26 0 0 20 0 11 0 42716249 1073504256 132676 18446744073709551615 4194304 4228012 140734144603696 139809833390056 139809731985791 0 4 0 16800975 0 0 0 -1 0 0 0 10 0 0
[pid=29054/tid=29056] ppid=29051 vsize=1048344 CPUtime=12.47
/proc/29054/task/29056/stat : 29056 (java) S 29051 29051 32685 0 -1 4202560 68008 0 0 0 1223 24 0 0 20 0 11 0 42716251 1073504256 132676 18446744073709551615 4194304 4228012 140734144603696 139809726028928 139809826870859 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29057] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29057/stat : 29057 (java) S 29051 29051 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 42716252 1073504256 132676 18446744073709551615 4194304 4228012 140734144603696 139809724975120 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29058] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29058/stat : 29058 (java) S 29051 29051 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 42716252 1073504256 132676 18446744073709551615 4194304 4228012 140734144603696 139809723922336 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29059] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29059/stat : 29059 (java) S 29051 29051 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 42716256 1073504256 132676 18446744073709551615 4194304 4228012 140734144603696 139809722870768 139809826878496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29060] ppid=29051 vsize=1048344 CPUtime=2.39
/proc/29054/task/29060/stat : 29060 (java) S 29051 29051 32685 0 -1 4202560 11121 0 0 0 236 3 0 0 20 0 11 0 42716256 1073504256 132676 18446744073709551615 4194304 4228012 140734144603696 139809721818128 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29061] ppid=29051 vsize=1048344 CPUtime=1.87
/proc/29054/task/29061/stat : 29061 (java) S 29051 29051 32685 0 -1 4202560 11383 0 0 0 183 4 0 0 20 0 11 0 42716256 1073504256 132676 18446744073709551615 4194304 4228012 140734144603696 139809720765456 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29062] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29062/stat : 29062 (java) S 29051 29051 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 42716256 1073504256 132676 18446744073709551615 4194304 4228012 140734144603696 139809719712976 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29063] ppid=29051 vsize=1048344 CPUtime=0.08
/proc/29054/task/29063/stat : 29063 (java) S 29051 29051 32685 0 -1 4202560 12 0 0 0 8 0 0 0 20 0 11 0 42716256 1073504256 132676 18446744073709551615 4194304 4228012 140734144603696 139809718660480 139809826870859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29064] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29064/stat : 29064 (java) S 29051 29051 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 42717124 1073504256 132676 18446744073709551615 4194304 4228012 140734144603696 139809717458784 139809826870859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 160.55
Current children cumulated vsize (KiB) 1057512

[startup+222.304 s]
/proc/loadavg: 1.00 1.05 1.06 2/72 29064
/proc/meminfo: memFree=18536/1022884 swapFree=0/0
[pid=29051] ppid=29050 vsize=9168 CPUtime=0
/proc/29051/stat : 29051 (p2cudf-full-1.1) S 29050 29051 32685 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 42716247 9388032 330 18446744073709551615 4194304 5129932 140736581427744 140736581425888 140238474294366 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/29051/statm: 2292 330 280 229 0 52 0
[pid=29054] ppid=29051 vsize=1048344 CPUtime=220.07
/proc/29054/stat : 29054 (java) S 29051 29051 32685 0 -1 4202496 142648 0 0 0 21947 60 0 0 20 0 11 0 42716248 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 140734144594720 139809826856565 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/29054/statm: 262086 135703 2392 9 0 249436 0
[pid=29054/tid=29055] ppid=29051 vsize=1048344 CPUtime=198.62
/proc/29054/task/29055/stat : 29055 (java) R 29051 29051 32685 0 -1 4202560 47794 0 0 0 19836 26 0 0 20 0 11 0 42716249 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809833390056 139809731385229 0 4 0 16800975 0 0 0 -1 0 0 0 10 0 0
[pid=29054/tid=29056] ppid=29051 vsize=1048344 CPUtime=16.96
/proc/29054/task/29056/stat : 29056 (java) S 29051 29051 32685 0 -1 4202560 71035 0 0 0 1671 25 0 0 20 0 11 0 42716251 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809726028928 139809826870859 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29057] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29057/stat : 29057 (java) S 29051 29051 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 42716252 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809724975120 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29058] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29058/stat : 29058 (java) S 29051 29051 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 42716252 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809723922336 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29059] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29059/stat : 29059 (java) S 29051 29051 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 42716256 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809722870768 139809826878496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29060] ppid=29051 vsize=1048344 CPUtime=2.42
/proc/29054/task/29060/stat : 29060 (java) S 29051 29051 32685 0 -1 4202560 11121 0 0 0 239 3 0 0 20 0 11 0 42716256 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809721818128 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29061] ppid=29051 vsize=1048344 CPUtime=1.91
/proc/29054/task/29061/stat : 29061 (java) S 29051 29051 32685 0 -1 4202560 11383 0 0 0 187 4 0 0 20 0 11 0 42716256 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809720765456 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29062] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29062/stat : 29062 (java) S 29051 29051 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 42716256 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809719712976 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29063] ppid=29051 vsize=1048344 CPUtime=0.11
/proc/29054/task/29063/stat : 29063 (java) S 29051 29051 32685 0 -1 4202560 18 0 0 0 11 0 0 0 20 0 11 0 42716256 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809718660480 139809826870859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29064] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29064/stat : 29064 (java) S 29051 29051 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 42717124 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809717458784 139809826870859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 220.07
Current children cumulated vsize (KiB) 1057512

[startup+282.301 s]
/proc/loadavg: 1.00 1.04 1.06 2/72 29064
/proc/meminfo: memFree=18536/1022884 swapFree=0/0
[pid=29051] ppid=29050 vsize=9168 CPUtime=0
/proc/29051/stat : 29051 (p2cudf-full-1.1) S 29050 29051 32685 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 42716247 9388032 330 18446744073709551615 4194304 5129932 140736581427744 140736581425888 140238474294366 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/29051/statm: 2292 330 280 229 0 52 0
[pid=29054] ppid=29051 vsize=1048344 CPUtime=279.58
/proc/29054/stat : 29054 (java) S 29051 29051 32685 0 -1 4202496 142656 0 0 0 27898 60 0 0 20 0 11 0 42716248 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 140734144594720 139809826856565 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/29054/statm: 262086 135703 2392 9 0 249436 0
[pid=29054/tid=29055] ppid=29051 vsize=1048344 CPUtime=253.65
/proc/29054/task/29055/stat : 29055 (java) R 29051 29051 32685 0 -1 4202560 47794 0 0 0 25339 26 0 0 20 0 11 0 42716249 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809833390056 139809732091708 0 4 0 16800975 0 0 0 -1 0 0 0 10 0 0
[pid=29054/tid=29056] ppid=29051 vsize=1048344 CPUtime=21.41
/proc/29054/task/29056/stat : 29056 (java) S 29051 29051 32685 0 -1 4202560 71037 0 0 0 2116 25 0 0 20 0 11 0 42716251 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809726028928 139809826870859 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29057] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29057/stat : 29057 (java) S 29051 29051 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 42716252 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809724975120 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29058] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29058/stat : 29058 (java) S 29051 29051 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 42716252 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809723922336 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29059] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29059/stat : 29059 (java) S 29051 29051 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 42716256 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809722870768 139809826878496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29060] ppid=29051 vsize=1048344 CPUtime=2.42
/proc/29054/task/29060/stat : 29060 (java) S 29051 29051 32685 0 -1 4202560 11121 0 0 0 239 3 0 0 20 0 11 0 42716256 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809721818128 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29061] ppid=29051 vsize=1048344 CPUtime=1.91
/proc/29054/task/29061/stat : 29061 (java) S 29051 29051 32685 0 -1 4202560 11383 0 0 0 187 4 0 0 20 0 11 0 42716256 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809720765456 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29062] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29062/stat : 29062 (java) S 29051 29051 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 42716256 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809719712976 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29063] ppid=29051 vsize=1048344 CPUtime=0.14
/proc/29054/task/29063/stat : 29063 (java) S 29051 29051 32685 0 -1 4202560 24 0 0 0 14 0 0 0 20 0 11 0 42716256 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809718660480 139809826870859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29064] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29064/stat : 29064 (java) S 29051 29051 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 42717124 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809717458784 139809826870859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 279.58
Current children cumulated vsize (KiB) 1057512

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

[startup+288.001 s]
/proc/loadavg: 1.00 1.04 1.06 2/72 29064
/proc/meminfo: memFree=18536/1022884 swapFree=0/0
[pid=29051] ppid=29050 vsize=9168 CPUtime=0
/proc/29051/stat : 29051 (p2cudf-full-1.1) S 29050 29051 32685 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 42716247 9388032 330 18446744073709551615 4194304 5129932 140736581427744 140736581425888 140238474294366 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/29051/statm: 2292 330 280 229 0 52 0
[pid=29054] ppid=29051 vsize=1048344 CPUtime=285.23
/proc/29054/stat : 29054 (java) S 29051 29051 32685 0 -1 4202496 142656 0 0 0 28463 60 0 0 20 0 11 0 42716248 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 140734144594720 139809826856565 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/29054/statm: 262086 135703 2392 9 0 249436 0
[pid=29054/tid=29055] ppid=29051 vsize=1048344 CPUtime=258.78
/proc/29054/task/29055/stat : 29055 (java) R 29051 29051 32685 0 -1 4202560 47794 0 0 0 25852 26 0 0 20 0 11 0 42716249 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809833390056 139809731454252 0 4 0 16800975 0 0 0 -1 0 0 0 10 0 0
[pid=29054/tid=29056] ppid=29051 vsize=1048344 CPUtime=21.93
/proc/29054/task/29056/stat : 29056 (java) S 29051 29051 32685 0 -1 4202560 71037 0 0 0 2168 25 0 0 20 0 11 0 42716251 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809726028928 139809826870859 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29057] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29057/stat : 29057 (java) S 29051 29051 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 42716252 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809724975120 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29058] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29058/stat : 29058 (java) S 29051 29051 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 42716252 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809723922336 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29059] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29059/stat : 29059 (java) S 29051 29051 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 42716256 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809722870768 139809826878496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29060] ppid=29051 vsize=1048344 CPUtime=2.42
/proc/29054/task/29060/stat : 29060 (java) S 29051 29051 32685 0 -1 4202560 11121 0 0 0 239 3 0 0 20 0 11 0 42716256 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809721818128 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29061] ppid=29051 vsize=1048344 CPUtime=1.91
/proc/29054/task/29061/stat : 29061 (java) S 29051 29051 32685 0 -1 4202560 11383 0 0 0 187 4 0 0 20 0 11 0 42716256 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809720765456 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29062] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29062/stat : 29062 (java) S 29051 29051 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 42716256 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809719712976 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29063] ppid=29051 vsize=1048344 CPUtime=0.14
/proc/29054/task/29063/stat : 29063 (java) S 29051 29051 32685 0 -1 4202560 24 0 0 0 14 0 0 0 20 0 11 0 42716256 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809718660480 139809826870859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29064] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29064/stat : 29064 (java) S 29051 29051 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 42717124 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809717458784 139809826870859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 285.23
Current children cumulated vsize (KiB) 1057512

[startup+291.201 s]
/proc/loadavg: 1.00 1.03 1.06 2/72 29064
/proc/meminfo: memFree=18536/1022884 swapFree=0/0
[pid=29051] ppid=29050 vsize=9168 CPUtime=0
/proc/29051/stat : 29051 (p2cudf-full-1.1) S 29050 29051 32685 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 42716247 9388032 330 18446744073709551615 4194304 5129932 140736581427744 140736581425888 140238474294366 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/29051/statm: 2292 330 280 229 0 52 0
[pid=29054] ppid=29051 vsize=1048344 CPUtime=288.4
/proc/29054/stat : 29054 (java) S 29051 29051 32685 0 -1 4202496 142656 0 0 0 28780 60 0 0 20 0 11 0 42716248 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 140734144594720 139809826856565 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/29054/statm: 262086 135703 2392 9 0 249436 0
[pid=29054/tid=29055] ppid=29051 vsize=1048344 CPUtime=261.96
/proc/29054/task/29055/stat : 29055 (java) R 29051 29051 32685 0 -1 4202560 47794 0 0 0 26170 26 0 0 20 0 11 0 42716249 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809833390056 139809731862143 0 4 0 16800975 0 0 0 -1 0 0 0 10 0 0
[pid=29054/tid=29056] ppid=29051 vsize=1048344 CPUtime=21.93
/proc/29054/task/29056/stat : 29056 (java) S 29051 29051 32685 0 -1 4202560 71037 0 0 0 2168 25 0 0 20 0 11 0 42716251 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809726028928 139809826870859 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29057] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29057/stat : 29057 (java) S 29051 29051 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 42716252 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809724975120 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29058] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29058/stat : 29058 (java) S 29051 29051 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 42716252 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809723922336 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29059] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29059/stat : 29059 (java) S 29051 29051 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 42716256 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809722870768 139809826878496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29060] ppid=29051 vsize=1048344 CPUtime=2.42
/proc/29054/task/29060/stat : 29060 (java) S 29051 29051 32685 0 -1 4202560 11121 0 0 0 239 3 0 0 20 0 11 0 42716256 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809721818128 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29061] ppid=29051 vsize=1048344 CPUtime=1.91
/proc/29054/task/29061/stat : 29061 (java) S 29051 29051 32685 0 -1 4202560 11383 0 0 0 187 4 0 0 20 0 11 0 42716256 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809720765456 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29062] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29062/stat : 29062 (java) S 29051 29051 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 42716256 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809719712976 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29063] ppid=29051 vsize=1048344 CPUtime=0.14
/proc/29054/task/29063/stat : 29063 (java) S 29051 29051 32685 0 -1 4202560 24 0 0 0 14 0 0 0 20 0 11 0 42716256 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809718660480 139809826870859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29064] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29064/stat : 29064 (java) S 29051 29051 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 42717124 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809717458784 139809826870859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 288.4
Current children cumulated vsize (KiB) 1057512

[startup+292.801 s]
/proc/loadavg: 1.00 1.03 1.06 2/72 29064
/proc/meminfo: memFree=18536/1022884 swapFree=0/0
[pid=29051] ppid=29050 vsize=9168 CPUtime=0
/proc/29051/stat : 29051 (p2cudf-full-1.1) S 29050 29051 32685 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 42716247 9388032 330 18446744073709551615 4194304 5129932 140736581427744 140736581425888 140238474294366 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/29051/statm: 2292 330 280 229 0 52 0
[pid=29054] ppid=29051 vsize=1048344 CPUtime=289.99
/proc/29054/stat : 29054 (java) S 29051 29051 32685 0 -1 4202496 142656 0 0 0 28939 60 0 0 20 0 11 0 42716248 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 140734144594720 139809826856565 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/29054/statm: 262086 135703 2392 9 0 249436 0
[pid=29054/tid=29055] ppid=29051 vsize=1048344 CPUtime=263.54
/proc/29054/task/29055/stat : 29055 (java) R 29051 29051 32685 0 -1 4202560 47794 0 0 0 26328 26 0 0 20 0 11 0 42716249 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809833390056 139809731862387 0 4 0 16800975 0 0 0 -1 0 0 0 10 0 0
[pid=29054/tid=29056] ppid=29051 vsize=1048344 CPUtime=21.93
/proc/29054/task/29056/stat : 29056 (java) S 29051 29051 32685 0 -1 4202560 71037 0 0 0 2168 25 0 0 20 0 11 0 42716251 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809726028928 139809826870859 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29057] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29057/stat : 29057 (java) S 29051 29051 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 42716252 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809724975120 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29058] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29058/stat : 29058 (java) S 29051 29051 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 42716252 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809723922336 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29059] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29059/stat : 29059 (java) S 29051 29051 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 42716256 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809722870768 139809826878496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29060] ppid=29051 vsize=1048344 CPUtime=2.42
/proc/29054/task/29060/stat : 29060 (java) S 29051 29051 32685 0 -1 4202560 11121 0 0 0 239 3 0 0 20 0 11 0 42716256 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809721818128 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29061] ppid=29051 vsize=1048344 CPUtime=1.91
/proc/29054/task/29061/stat : 29061 (java) S 29051 29051 32685 0 -1 4202560 11383 0 0 0 187 4 0 0 20 0 11 0 42716256 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809720765456 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29062] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29062/stat : 29062 (java) S 29051 29051 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 42716256 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809719712976 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29063] ppid=29051 vsize=1048344 CPUtime=0.14
/proc/29054/task/29063/stat : 29063 (java) S 29051 29051 32685 0 -1 4202560 24 0 0 0 14 0 0 0 20 0 11 0 42716256 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809718660480 139809826870859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29064] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29064/stat : 29064 (java) S 29051 29051 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 42717124 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809717458784 139809826870859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 289.99
Current children cumulated vsize (KiB) 1057512

[startup+293.601 s]
/proc/loadavg: 1.00 1.03 1.06 2/72 29064
/proc/meminfo: memFree=18536/1022884 swapFree=0/0
[pid=29051] ppid=29050 vsize=9168 CPUtime=0
/proc/29051/stat : 29051 (p2cudf-full-1.1) S 29050 29051 32685 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 42716247 9388032 330 18446744073709551615 4194304 5129932 140736581427744 140736581425888 140238474294366 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/29051/statm: 2292 330 280 229 0 52 0
[pid=29054] ppid=29051 vsize=1048344 CPUtime=290.78
/proc/29054/stat : 29054 (java) S 29051 29051 32685 0 -1 4202496 142656 0 0 0 29018 60 0 0 20 0 11 0 42716248 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 140734144594720 139809826856565 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/29054/statm: 262086 135703 2392 9 0 249436 0
[pid=29054/tid=29055] ppid=29051 vsize=1048344 CPUtime=264.34
/proc/29054/task/29055/stat : 29055 (java) R 29051 29051 32685 0 -1 4202560 47794 0 0 0 26408 26 0 0 20 0 11 0 42716249 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809833390056 139809732091592 0 4 0 16800975 0 0 0 -1 0 0 0 10 0 0
[pid=29054/tid=29056] ppid=29051 vsize=1048344 CPUtime=21.93
/proc/29054/task/29056/stat : 29056 (java) S 29051 29051 32685 0 -1 4202560 71037 0 0 0 2168 25 0 0 20 0 11 0 42716251 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809726028928 139809826870859 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29057] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29057/stat : 29057 (java) S 29051 29051 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 42716252 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809724975120 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29058] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29058/stat : 29058 (java) S 29051 29051 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 42716252 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809723922336 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29059] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29059/stat : 29059 (java) S 29051 29051 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 42716256 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809722870768 139809826878496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29060] ppid=29051 vsize=1048344 CPUtime=2.42
/proc/29054/task/29060/stat : 29060 (java) S 29051 29051 32685 0 -1 4202560 11121 0 0 0 239 3 0 0 20 0 11 0 42716256 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809721818128 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29061] ppid=29051 vsize=1048344 CPUtime=1.91
/proc/29054/task/29061/stat : 29061 (java) S 29051 29051 32685 0 -1 4202560 11383 0 0 0 187 4 0 0 20 0 11 0 42716256 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809720765456 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29062] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29062/stat : 29062 (java) S 29051 29051 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 42716256 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809719712976 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29063] ppid=29051 vsize=1048344 CPUtime=0.14
/proc/29054/task/29063/stat : 29063 (java) S 29051 29051 32685 0 -1 4202560 24 0 0 0 14 0 0 0 20 0 11 0 42716256 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809718660480 139809826870859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29064] ppid=29051 vsize=1048344 CPUtime=0
/proc/29054/task/29064/stat : 29064 (java) S 29051 29051 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 42717124 1073504256 135703 18446744073709551615 4194304 4228012 140734144603696 139809717458784 139809826870859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 290.78
Current children cumulated vsize (KiB) 1057512

[startup+294.001 s]
/proc/loadavg: 1.00 1.03 1.06 2/72 29064
/proc/meminfo: memFree=18536/1022884 swapFree=0/0
[pid=29051] ppid=29050 vsize=9168 CPUtime=0
/proc/29051/stat : 29051 (p2cudf-full-1.1) S 29050 29051 32685 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 42716247 9388032 330 18446744073709551615 4194304 5129932 140736581427744 140736581425888 140238474294366 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/29051/statm: 2292 330 280 229 0 52 0
[pid=29054] ppid=29051 vsize=1049372 CPUtime=291.01
/proc/29054/stat : 29054 (java) S 29051 29051 32685 0 -1 4202496 142671 0 0 0 29041 60 0 0 20 0 11 0 42716248 1074556928 135716 18446744073709551615 4194304 4228012 140734144603696 140734144594720 139809826856565 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/29054/statm: 262343 135716 2392 9 0 249693 0
[pid=29054/tid=29055] ppid=29051 vsize=1049372 CPUtime=264.54
/proc/29054/task/29055/stat : 29055 (java) S 29051 29051 32685 0 -1 4202560 47803 0 0 0 26428 26 0 0 20 0 11 0 42716249 1074556928 135716 18446744073709551615 4194304 4228012 140734144603696 139809833391024 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 10 0 0
[pid=29054/tid=29056] ppid=29051 vsize=1049372 CPUtime=21.93
/proc/29054/task/29056/stat : 29056 (java) S 29051 29051 32685 0 -1 4202560 71037 0 0 0 2168 25 0 0 20 0 11 0 42716251 1074556928 135716 18446744073709551615 4194304 4228012 140734144603696 139809726028928 139809826870859 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29057] ppid=29051 vsize=1049372 CPUtime=0
/proc/29054/task/29057/stat : 29057 (java) S 29051 29051 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 42716252 1074556928 135716 18446744073709551615 4194304 4228012 140734144603696 139809724975120 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29058] ppid=29051 vsize=1049372 CPUtime=0
/proc/29054/task/29058/stat : 29058 (java) S 29051 29051 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 42716252 1074556928 135716 18446744073709551615 4194304 4228012 140734144603696 139809723922336 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29059] ppid=29051 vsize=1049372 CPUtime=0
/proc/29054/task/29059/stat : 29059 (java) S 29051 29051 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 42716256 1074556928 135716 18446744073709551615 4194304 4228012 140734144603696 139809722870768 139809826878496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29060] ppid=29051 vsize=1049372 CPUtime=2.45
/proc/29054/task/29060/stat : 29060 (java) S 29051 29051 32685 0 -1 4202560 11121 0 0 0 242 3 0 0 20 0 11 0 42716256 1074556928 135716 18446744073709551615 4194304 4228012 140734144603696 139809721818128 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29061] ppid=29051 vsize=1049372 CPUtime=1.91
/proc/29054/task/29061/stat : 29061 (java) S 29051 29051 32685 0 -1 4202560 11383 0 0 0 187 4 0 0 20 0 11 0 42716256 1074556928 135716 18446744073709551615 4194304 4228012 140734144603696 139809720765456 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29062] ppid=29051 vsize=1049372 CPUtime=0
/proc/29054/task/29062/stat : 29062 (java) S 29051 29051 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 42716256 1074556928 135716 18446744073709551615 4194304 4228012 140734144603696 139809719712976 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29063] ppid=29051 vsize=1049372 CPUtime=0.14
/proc/29054/task/29063/stat : 29063 (java) S 29051 29051 32685 0 -1 4202560 24 0 0 0 14 0 0 0 20 0 11 0 42716256 1074556928 135716 18446744073709551615 4194304 4228012 140734144603696 139809718660480 139809826870859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 291.01
Current children cumulated vsize (KiB) 1058540

[startup+294.401 s]
/proc/loadavg: 1.00 1.03 1.06 2/72 29064
/proc/meminfo: memFree=18536/1022884 swapFree=0/0
[pid=29051] ppid=29050 vsize=9168 CPUtime=0
/proc/29051/stat : 29051 (p2cudf-full-1.1) S 29050 29051 32685 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 42716247 9388032 330 18446744073709551615 4194304 5129932 140736581427744 140736581425888 140238474294366 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/29051/statm: 2292 330 280 229 0 52 0
[pid=29054] ppid=29051 vsize=1049372 CPUtime=291.07
/proc/29054/stat : 29054 (java) S 29051 29051 32685 0 -1 4202496 142673 0 0 0 29045 62 0 0 20 0 11 0 42716248 1074556928 135718 18446744073709551615 4194304 4228012 140734144603696 140734144594720 139809826856565 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/29054/statm: 262343 135718 2392 9 0 249693 0
[pid=29054/tid=29055] ppid=29051 vsize=1049372 CPUtime=264.54
/proc/29054/task/29055/stat : 29055 (java) S 29051 29051 32685 0 -1 4202560 47803 0 0 0 26428 26 0 0 20 0 11 0 42716249 1074556928 135718 18446744073709551615 4194304 4228012 140734144603696 139809833391024 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 10 0 0
[pid=29054/tid=29056] ppid=29051 vsize=1049372 CPUtime=21.93
/proc/29054/task/29056/stat : 29056 (java) S 29051 29051 32685 0 -1 4202560 71037 0 0 0 2168 25 0 0 20 0 11 0 42716251 1074556928 135718 18446744073709551615 4194304 4228012 140734144603696 139809726028928 139809826870859 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29057] ppid=29051 vsize=1049372 CPUtime=0
/proc/29054/task/29057/stat : 29057 (java) S 29051 29051 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 42716252 1074556928 135718 18446744073709551615 4194304 4228012 140734144603696 139809724975120 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29058] ppid=29051 vsize=1049372 CPUtime=0
/proc/29054/task/29058/stat : 29058 (java) S 29051 29051 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 42716252 1074556928 135718 18446744073709551615 4194304 4228012 140734144603696 139809723922336 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29059] ppid=29051 vsize=1049372 CPUtime=0
/proc/29054/task/29059/stat : 29059 (java) S 29051 29051 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 42716256 1074556928 135718 18446744073709551615 4194304 4228012 140734144603696 139809722870768 139809826878496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29060] ppid=29051 vsize=1049372 CPUtime=2.45
/proc/29054/task/29060/stat : 29060 (java) S 29051 29051 32685 0 -1 4202560 11121 0 0 0 242 3 0 0 20 0 11 0 42716256 1074556928 135718 18446744073709551615 4194304 4228012 140734144603696 139809721817960 139809826880748 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29061] ppid=29051 vsize=1049372 CPUtime=1.92
/proc/29054/task/29061/stat : 29061 (java) R 29051 29051 32685 0 -1 4202560 11383 0 0 0 188 4 0 0 20 0 11 0 42716256 1074556928 135718 18446744073709551615 4194304 4228012 140734144603696 139809720765200 139809812429211 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29062] ppid=29051 vsize=1049372 CPUtime=0
/proc/29054/task/29062/stat : 29062 (java) S 29051 29051 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 42716256 1074556928 135718 18446744073709551615 4194304 4228012 140734144603696 139809719712976 139809826869972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=29054/tid=29063] ppid=29051 vsize=1049372 CPUtime=0.14
/proc/29054/task/29063/stat : 29063 (java) S 29051 29051 32685 0 -1 4202560 24 0 0 0 14 0 0 0 20 0 11 0 42716256 1074556928 135718 18446744073709551615 4194304 4228012 140734144603696 139809718660480 139809826870859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 291.07
Current children cumulated vsize (KiB) 1058540

[startup+294.501 s]
/proc/loadavg: 1.00 1.03 1.06 2/72 29064
/proc/meminfo: memFree=18536/1022884 swapFree=0/0
[pid=29051] ppid=29050 vsize=9168 CPUtime=0
/proc/29051/stat : 29051 (p2cudf-full-1.1) S 29050 29051 32685 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 42716247 9388032 330 18446744073709551615 4194304 5129932 140736581427744 140736581425888 140238474294366 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/29051/statm: 2292 330 280 229 0 52 0
[pid=29054] ppid=29051 vsize=0 CPUtime=291.17
/proc/29054/stat : 29054 (java) Z 29051 29051 32685 0 -1 4203532 142684 0 0 0 29049 68 0 0 20 0 2 0 42716248 0 0 18446744073709551615 0 0 0 0 0 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/29054/statm: 0 0 0 0 0 0 0
Current children cumulated CPU time (s) 291.17
Current children cumulated vsize (KiB) 9168

Child status: 0
Real time (s): 294.509
CPU time (s): 291.198
CPU user time (s): 290.502
CPU system time (s): 0.696043
CPU usage (%): 98.8757
Max. virtual memory (cumulated for all children) (KiB): 1059848

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 290.502
system time used= 0.696043
maximum resident set size= 542908
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 143444
page faults= 0
swaps= 0
block input operations= 42368
block output operations= 536
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 7205
involuntary context switches= 12855

runsolver used 0.744046 second user time and 1.97212 second system time

The end