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

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

[startup+0 s]
/proc/loadavg: 1.33 1.14 1.05 2/59 22531
/proc/meminfo: memFree=467556/1022884 swapFree=0/0
[pid=22531] ppid=22530 vsize=3152 CPUtime=0
/proc/22531/stat : 22531 (runsolver) R 22530 1750 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 1 0 120863870 3227648 33 18446744073709551615 134512640 134586868 4287375424 4287373472 4152149040 0 0 16781316 24578 0 0 0 17 0 0 0 0 0 0
/proc/22531/statm: 788 33 0 19 0 73 0
Current StackSize limit: 8192 KiB


[startup+0.191019 s]
/proc/loadavg: 1.33 1.14 1.05 2/59 22531
/proc/meminfo: memFree=467556/1022884 swapFree=0/0
[pid=22531] ppid=22530 vsize=9168 CPUtime=0
/proc/22531/stat : 22531 (p2cudf-full-1.1) S 22530 22531 1750 0 -1 4202496 456 292 0 0 0 0 0 0 20 0 1 0 120863870 9388032 331 18446744073709551615 4194304 5129932 140737424330624 140737424328768 140702272205918 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/22531/statm: 2292 331 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.20037 s]
/proc/loadavg: 1.33 1.14 1.05 2/59 22531
/proc/meminfo: memFree=467556/1022884 swapFree=0/0
[pid=22531] ppid=22530 vsize=9168 CPUtime=0
/proc/22531/stat : 22531 (p2cudf-full-1.1) S 22530 22531 1750 0 -1 4202496 456 292 0 0 0 0 0 0 20 0 1 0 120863870 9388032 331 18446744073709551615 4194304 5129932 140737424330624 140737424328768 140702272205918 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/22531/statm: 2292 331 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.300279 s]
/proc/loadavg: 1.33 1.14 1.05 2/59 22531
/proc/meminfo: memFree=467556/1022884 swapFree=0/0
[pid=22531] ppid=22530 vsize=9168 CPUtime=0
/proc/22531/stat : 22531 (p2cudf-full-1.1) S 22530 22531 1750 0 -1 4202496 456 292 0 0 0 0 0 0 20 0 1 0 120863870 9388032 331 18446744073709551615 4194304 5129932 140737424330624 140737424328768 140702272205918 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/22531/statm: 2292 331 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.700226 s]
/proc/loadavg: 1.33 1.14 1.05 2/59 22531
/proc/meminfo: memFree=467556/1022884 swapFree=0/0
[pid=22531] ppid=22530 vsize=9168 CPUtime=0
/proc/22531/stat : 22531 (p2cudf-full-1.1) S 22530 22531 1750 0 -1 4202496 456 292 0 0 0 0 0 0 20 0 1 0 120863870 9388032 331 18446744073709551615 4194304 5129932 140737424330624 140737424328768 140702272205918 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/22531/statm: 2292 331 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+1.50074 s]
/proc/loadavg: 1.33 1.14 1.05 4/70 22543
/proc/meminfo: memFree=422944/1022884 swapFree=0/0
[pid=22531] ppid=22530 vsize=9168 CPUtime=0
/proc/22531/stat : 22531 (p2cudf-full-1.1) S 22530 22531 1750 0 -1 4202496 456 292 0 0 0 0 0 0 20 0 1 0 120863870 9388032 331 18446744073709551615 4194304 5129932 140737424330624 140737424328768 140702272205918 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/22531/statm: 2292 331 280 229 0 52 0
[pid=22534] ppid=22531 vsize=1067652 CPUtime=1.45
/proc/22534/stat : 22534 (java) S 22531 22531 1750 0 -1 4202496 32371 0 0 0 131 14 0 0 20 0 10 0 120863872 1093275648 29003 18446744073709551615 4194304 4228012 140734791862656 140734791853680 139807146970741 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22534/statm: 266913 29003 2348 9 0 254263 0
[pid=22534/tid=22535] ppid=22531 vsize=1067652 CPUtime=0.67
/proc/22534/task/22535/stat : 22535 (java) R 22531 22531 1750 0 -1 4202560 13939 0 0 0 58 9 0 0 20 0 10 0 120863873 1093275648 29003 18446744073709551615 4194304 4228012 140734791862656 139807153496736 139807051315628 0 4 0 16800975 0 0 0 -1 0 0 0 2 0 0
[pid=22534/tid=22536] ppid=22531 vsize=1067652 CPUtime=0
/proc/22534/task/22536/stat : 22536 (java) S 22531 22531 1750 0 -1 4202560 4 0 0 0 0 0 0 0 20 0 10 0 120863876 1093275648 29003 18446744073709551615 4194304 4228012 140734791862656 139807046143104 139807146985035 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22537] ppid=22531 vsize=1067652 CPUtime=0
/proc/22534/task/22537/stat : 22537 (java) S 22531 22531 1750 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 10 0 120863877 1093275648 29003 18446744073709551615 4194304 4228012 140734791862656 139807045089296 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22538] ppid=22531 vsize=1067652 CPUtime=0
/proc/22534/task/22538/stat : 22538 (java) S 22531 22531 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 10 0 120863877 1093275648 29003 18446744073709551615 4194304 4228012 140734791862656 139807044036512 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22539] ppid=22531 vsize=1067652 CPUtime=0
/proc/22534/task/22539/stat : 22539 (java) S 22531 22531 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 120863880 1093275648 29003 18446744073709551615 4194304 4228012 140734791862656 139807042984944 139807146992672 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22540] ppid=22531 vsize=1067652 CPUtime=0.36
/proc/22534/task/22540/stat : 22540 (java) R 22531 22531 1750 0 -1 4202560 9658 0 0 0 32 4 0 0 20 0 10 0 120863880 1093275648 29003 18446744073709551615 4194304 4228012 140734791862656 139807041917768 139807134313400 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22541] ppid=22531 vsize=1067652 CPUtime=0.39
/proc/22534/task/22541/stat : 22541 (java) R 22531 22531 1750 0 -1 4202560 7483 0 0 0 38 1 0 0 20 0 10 0 120863880 1093275648 29003 18446744073709551615 4194304 4228012 140734791862656 139807040867480 139807132815703 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22542] ppid=22531 vsize=1067652 CPUtime=0
/proc/22534/task/22542/stat : 22542 (java) S 22531 22531 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 120863880 1093275648 29003 18446744073709551615 4194304 4228012 140734791862656 139807039827152 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22543] ppid=22531 vsize=1067652 CPUtime=0
/proc/22534/task/22543/stat : 22543 (java) S 22531 22531 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 120863880 1093275648 29003 18446744073709551615 4194304 4228012 140734791862656 139807038774656 139807146985035 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 1.45
Current children cumulated vsize (KiB) 1076820

[startup+3.10072 s]
/proc/loadavg: 1.33 1.14 1.05 4/70 22543
/proc/meminfo: memFree=317916/1022884 swapFree=0/0
[pid=22531] ppid=22530 vsize=9168 CPUtime=0
/proc/22531/stat : 22531 (p2cudf-full-1.1) S 22530 22531 1750 0 -1 4202496 456 292 0 0 0 0 0 0 20 0 1 0 120863870 9388032 331 18446744073709551615 4194304 5129932 140737424330624 140737424328768 140702272205918 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/22531/statm: 2292 331 280 229 0 52 0
[pid=22534] ppid=22531 vsize=1067212 CPUtime=3.02
/proc/22534/stat : 22534 (java) S 22531 22531 1750 0 -1 4202496 77058 0 0 0 270 32 0 0 20 0 10 0 120863872 1092825088 70916 18446744073709551615 4194304 4228012 140734791862656 140734791853680 139807146970741 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22534/statm: 266803 70916 2368 9 0 254153 0
[pid=22534/tid=22535] ppid=22531 vsize=1067212 CPUtime=1.5
/proc/22534/task/22535/stat : 22535 (java) R 22531 22531 1750 0 -1 4202560 47428 0 0 0 126 24 0 0 20 0 10 0 120863873 1092825088 70916 18446744073709551615 4194304 4228012 140734791862656 139807153496768 139807051578028 0 4 0 16800975 0 0 0 -1 0 0 0 2 0 0
[pid=22534/tid=22536] ppid=22531 vsize=1067212 CPUtime=0.16
/proc/22534/task/22536/stat : 22536 (java) S 22531 22531 1750 0 -1 4202560 7937 0 0 0 14 2 0 0 20 0 10 0 120863876 1092825088 70916 18446744073709551615 4194304 4228012 140734791862656 139807046143104 139807146985035 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22537] ppid=22531 vsize=1067212 CPUtime=0
/proc/22534/task/22537/stat : 22537 (java) S 22531 22531 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 120863877 1092825088 70916 18446744073709551615 4194304 4228012 140734791862656 139807045089296 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22538] ppid=22531 vsize=1067212 CPUtime=0
/proc/22534/task/22538/stat : 22538 (java) S 22531 22531 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 10 0 120863877 1092825088 70916 18446744073709551615 4194304 4228012 140734791862656 139807044036512 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22539] ppid=22531 vsize=1067212 CPUtime=0
/proc/22534/task/22539/stat : 22539 (java) S 22531 22531 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 120863880 1092825088 70916 18446744073709551615 4194304 4228012 140734791862656 139807042984944 139807146992672 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22540] ppid=22531 vsize=1067212 CPUtime=0.62
/proc/22534/task/22540/stat : 22540 (java) S 22531 22531 1750 0 -1 4202560 10821 0 0 0 58 4 0 0 20 0 10 0 120863880 1092825088 70916 18446744073709551615 4194304 4228012 140734791862656 139807041932304 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22541] ppid=22531 vsize=1067212 CPUtime=0.7
/proc/22534/task/22541/stat : 22541 (java) S 22531 22531 1750 0 -1 4202560 9582 0 0 0 69 1 0 0 20 0 10 0 120863880 1092825088 70916 18446744073709551615 4194304 4228012 140734791862656 139807040879632 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22542] ppid=22531 vsize=1067212 CPUtime=0
/proc/22534/task/22542/stat : 22542 (java) S 22531 22531 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 120863880 1092825088 70916 18446744073709551615 4194304 4228012 140734791862656 139807039827152 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22543] ppid=22531 vsize=1067212 CPUtime=0
/proc/22534/task/22543/stat : 22543 (java) S 22531 22531 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 120863880 1092825088 70916 18446744073709551615 4194304 4228012 140734791862656 139807038774656 139807146985035 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 3.02
Current children cumulated vsize (KiB) 1076380

[startup+6.30076 s]
/proc/loadavg: 1.30 1.13 1.05 2/70 22543
/proc/meminfo: memFree=22672/1022884 swapFree=0/0
[pid=22531] ppid=22530 vsize=9168 CPUtime=0
/proc/22531/stat : 22531 (p2cudf-full-1.1) S 22530 22531 1750 0 -1 4202496 456 292 0 0 0 0 0 0 20 0 1 0 120863870 9388032 331 18446744073709551615 4194304 5129932 140737424330624 140737424328768 140702272205918 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/22531/statm: 2292 331 280 229 0 52 0
[pid=22534] ppid=22531 vsize=1067212 CPUtime=6.16
/proc/22534/stat : 22534 (java) S 22531 22531 1750 0 -1 4202496 116528 0 0 0 568 48 0 0 20 0 10 0 120863872 1092825088 109716 18446744073709551615 4194304 4228012 140734791862656 140734791853680 139807146970741 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22534/statm: 266803 109716 2371 9 0 254153 0
[pid=22534/tid=22535] ppid=22531 vsize=1067212 CPUtime=3.24
/proc/22534/task/22535/stat : 22535 (java) R 22531 22531 1750 0 -1 4202560 47497 0 0 0 297 27 0 0 20 0 10 0 120863873 1092825088 109716 18446744073709551615 4194304 4228012 140734791862656 139807153505240 139807051773532 0 4 0 16800975 0 0 0 -1 0 0 0 3 0 0
[pid=22534/tid=22536] ppid=22531 vsize=1067212 CPUtime=1.07
/proc/22534/task/22536/stat : 22536 (java) S 22531 22531 1750 0 -1 4202560 45149 0 0 0 93 14 0 0 20 0 10 0 120863876 1092825088 109716 18446744073709551615 4194304 4228012 140734791862656 139807046143104 139807146985035 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22537] ppid=22531 vsize=1067212 CPUtime=0
/proc/22534/task/22537/stat : 22537 (java) S 22531 22531 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 120863877 1092825088 109716 18446744073709551615 4194304 4228012 140734791862656 139807045089296 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22538] ppid=22531 vsize=1067212 CPUtime=0
/proc/22534/task/22538/stat : 22538 (java) S 22531 22531 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 10 0 120863877 1092825088 109716 18446744073709551615 4194304 4228012 140734791862656 139807044036512 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22539] ppid=22531 vsize=1067212 CPUtime=0
/proc/22534/task/22539/stat : 22539 (java) S 22531 22531 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 120863880 1092825088 109716 18446744073709551615 4194304 4228012 140734791862656 139807042984944 139807146992672 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22540] ppid=22531 vsize=1067212 CPUtime=0.89
/proc/22534/task/22540/stat : 22540 (java) R 22531 22531 1750 0 -1 4202560 10863 0 0 0 85 4 0 0 20 0 10 0 120863880 1092825088 109716 18446744073709551615 4194304 4228012 140734791862656 139807041932048 139807129823284 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22541] ppid=22531 vsize=1067212 CPUtime=0.93
/proc/22534/task/22541/stat : 22541 (java) R 22531 22531 1750 0 -1 4202560 11729 0 0 0 91 2 0 0 20 0 10 0 120863880 1092825088 109716 18446744073709551615 4194304 4228012 140734791862656 139807040879376 139807130708574 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22542] ppid=22531 vsize=1067212 CPUtime=0
/proc/22534/task/22542/stat : 22542 (java) S 22531 22531 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 120863880 1092825088 109716 18446744073709551615 4194304 4228012 140734791862656 139807039827152 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22543] ppid=22531 vsize=1067212 CPUtime=0
/proc/22534/task/22543/stat : 22543 (java) S 22531 22531 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 120863880 1092825088 109716 18446744073709551615 4194304 4228012 140734791862656 139807038774656 139807146985035 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 6.16
Current children cumulated vsize (KiB) 1076380

[startup+12.7008 s]
/proc/loadavg: 1.44 1.16 1.06 2/71 22544
/proc/meminfo: memFree=10640/1022884 swapFree=0/0
[pid=22531] ppid=22530 vsize=9168 CPUtime=0
/proc/22531/stat : 22531 (p2cudf-full-1.1) S 22530 22531 1750 0 -1 4202496 456 292 0 0 0 0 0 0 20 0 1 0 120863870 9388032 331 18446744073709551615 4194304 5129932 140737424330624 140737424328768 140702272205918 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/22531/statm: 2292 331 280 229 0 52 0
[pid=22534] ppid=22531 vsize=1068240 CPUtime=12.38
/proc/22534/stat : 22534 (java) S 22531 22531 1750 0 -1 4202496 128782 0 0 0 1182 56 0 0 20 0 11 0 120863872 1093877760 119694 18446744073709551615 4194304 4228012 140734791862656 140734791853680 139807146970741 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22534/statm: 267060 119694 2380 9 0 254410 0
[pid=22534/tid=22535] ppid=22531 vsize=1068240 CPUtime=6.59
/proc/22534/task/22535/stat : 22535 (java) R 22531 22531 1750 0 -1 4202560 47816 0 0 0 631 28 0 0 20 0 11 0 120863873 1093877760 119694 18446744073709551615 4194304 4228012 140734791862656 139807153504488 139807052172534 0 4 0 16800975 0 0 0 -1 0 0 0 3 0 0
[pid=22534/tid=22536] ppid=22531 vsize=1068240 CPUtime=1.33
/proc/22534/task/22536/stat : 22536 (java) S 22531 22531 1750 0 -1 4202560 52862 0 0 0 114 19 0 0 20 0 11 0 120863876 1093877760 119694 18446744073709551615 4194304 4228012 140734791862656 139807046143104 139807146985035 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22537] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22537/stat : 22537 (java) S 22531 22531 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120863877 1093877760 119694 18446744073709551615 4194304 4228012 140734791862656 139807045089296 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22538] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22538/stat : 22538 (java) S 22531 22531 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 120863877 1093877760 119694 18446744073709551615 4194304 4228012 140734791862656 139807044036512 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22539] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22539/stat : 22539 (java) S 22531 22531 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120863880 1093877760 119694 18446744073709551615 4194304 4228012 140734791862656 139807042984944 139807146992672 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22540] ppid=22531 vsize=1068240 CPUtime=2.16
/proc/22534/task/22540/stat : 22540 (java) S 22531 22531 1750 0 -1 4202560 11192 0 0 0 212 4 0 0 20 0 11 0 120863880 1093877760 119694 18446744073709551615 4194304 4228012 140734791862656 139807041932304 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22541] ppid=22531 vsize=1068240 CPUtime=2.29
/proc/22534/task/22541/stat : 22541 (java) S 22531 22531 1750 0 -1 4202560 15616 0 0 0 223 6 0 0 20 0 11 0 120863880 1093877760 119694 18446744073709551615 4194304 4228012 140734791862656 139807040879632 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22542] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22542/stat : 22542 (java) S 22531 22531 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120863880 1093877760 119694 18446744073709551615 4194304 4228012 140734791862656 139807039827152 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22543] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22543/stat : 22543 (java) S 22531 22531 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120863880 1093877760 119694 18446744073709551615 4194304 4228012 140734791862656 139807038774656 139807146985035 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22544] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22544/stat : 22544 (java) S 22531 22531 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120864827 1093877760 119694 18446744073709551615 4194304 4228012 140734791862656 139807037577056 139807146985035 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 12.38
Current children cumulated vsize (KiB) 1077408

[startup+25.5006 s]
/proc/loadavg: 1.34 1.16 1.06 2/71 22544
/proc/meminfo: memFree=10268/1022884 swapFree=0/0
[pid=22531] ppid=22530 vsize=9168 CPUtime=0
/proc/22531/stat : 22531 (p2cudf-full-1.1) S 22530 22531 1750 0 -1 4202496 456 292 0 0 0 0 0 0 20 0 1 0 120863870 9388032 331 18446744073709551615 4194304 5129932 140737424330624 140737424328768 140702272205918 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/22531/statm: 2292 331 280 229 0 52 0
[pid=22534] ppid=22531 vsize=1068240 CPUtime=24.96
/proc/22534/stat : 22534 (java) S 22531 22531 1750 0 -1 4202496 139271 0 0 0 2436 60 0 0 20 0 11 0 120863872 1093877760 130183 18446744073709551615 4194304 4228012 140734791862656 140734791853680 139807146970741 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22534/statm: 267060 130183 2392 9 0 254410 0
[pid=22534/tid=22535] ppid=22531 vsize=1068240 CPUtime=16.54
/proc/22534/task/22535/stat : 22535 (java) R 22531 22531 1750 0 -1 4202560 47818 0 0 0 1626 28 0 0 20 0 11 0 120863873 1093877760 130183 18446744073709551615 4194304 4228012 140734791862656 139807153504328 139807052339595 0 4 0 16800975 0 0 0 -1 0 0 0 3 0 0
[pid=22534/tid=22536] ppid=22531 vsize=1068240 CPUtime=3.8
/proc/22534/task/22536/stat : 22536 (java) S 22531 22531 1750 0 -1 4202560 63344 0 0 0 358 22 0 0 20 0 11 0 120863876 1093877760 130183 18446744073709551615 4194304 4228012 140734791862656 139807046143104 139807146985035 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22537] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22537/stat : 22537 (java) S 22531 22531 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120863877 1093877760 130183 18446744073709551615 4194304 4228012 140734791862656 139807045089296 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22538] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22538/stat : 22538 (java) S 22531 22531 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 120863877 1093877760 130183 18446744073709551615 4194304 4228012 140734791862656 139807044036512 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22539] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22539/stat : 22539 (java) S 22531 22531 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120863880 1093877760 130183 18446744073709551615 4194304 4228012 140734791862656 139807042984944 139807146992672 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22540] ppid=22531 vsize=1068240 CPUtime=2.22
/proc/22534/task/22540/stat : 22540 (java) S 22531 22531 1750 0 -1 4202560 11192 0 0 0 218 4 0 0 20 0 11 0 120863880 1093877760 130183 18446744073709551615 4194304 4228012 140734791862656 139807041932304 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22541] ppid=22531 vsize=1068240 CPUtime=2.36
/proc/22534/task/22541/stat : 22541 (java) S 22531 22531 1750 0 -1 4202560 15621 0 0 0 230 6 0 0 20 0 11 0 120863880 1093877760 130183 18446744073709551615 4194304 4228012 140734791862656 139807040879632 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22542] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22542/stat : 22542 (java) S 22531 22531 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120863880 1093877760 130183 18446744073709551615 4194304 4228012 140734791862656 139807039827152 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22543] ppid=22531 vsize=1068240 CPUtime=0.01
/proc/22534/task/22543/stat : 22543 (java) S 22531 22531 1750 0 -1 4202560 0 0 0 0 1 0 0 0 20 0 11 0 120863880 1093877760 130183 18446744073709551615 4194304 4228012 140734791862656 139807038774656 139807146985035 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22544] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22544/stat : 22544 (java) S 22531 22531 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120864827 1093877760 130183 18446744073709551615 4194304 4228012 140734791862656 139807037577056 139807146985035 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 24.96
Current children cumulated vsize (KiB) 1077408

[startup+51.1006 s]
/proc/loadavg: 1.29 1.16 1.06 2/71 22544
/proc/meminfo: memFree=9152/1022884 swapFree=0/0
[pid=22531] ppid=22530 vsize=9168 CPUtime=0
/proc/22531/stat : 22531 (p2cudf-full-1.1) S 22530 22531 1750 0 -1 4202496 456 292 0 0 0 0 0 0 20 0 1 0 120863870 9388032 331 18446744073709551615 4194304 5129932 140737424330624 140737424328768 140702272205918 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/22531/statm: 2292 331 280 229 0 52 0
[pid=22534] ppid=22531 vsize=1068240 CPUtime=50.3
/proc/22534/stat : 22534 (java) S 22531 22531 1750 0 -1 4202496 141199 0 0 0 4970 60 0 0 20 0 11 0 120863872 1093877760 132107 18446744073709551615 4194304 4228012 140734791862656 140734791853680 139807146970741 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22534/statm: 267060 132107 2392 9 0 254410 0
[pid=22534/tid=22535] ppid=22531 vsize=1068240 CPUtime=39.3
/proc/22534/task/22535/stat : 22535 (java) R 22531 22531 1750 0 -1 4202560 47818 0 0 0 3902 28 0 0 20 0 11 0 120863873 1093877760 132107 18446744073709551615 4194304 4228012 140734791862656 139807153504328 139807051568812 0 4 0 16800975 0 0 0 -1 0 0 0 3 0 0
[pid=22534/tid=22536] ppid=22531 vsize=1068240 CPUtime=6.33
/proc/22534/task/22536/stat : 22536 (java) S 22531 22531 1750 0 -1 4202560 65269 0 0 0 611 22 0 0 20 0 11 0 120863876 1093877760 132107 18446744073709551615 4194304 4228012 140734791862656 139807046143104 139807146985035 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22537] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22537/stat : 22537 (java) S 22531 22531 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120863877 1093877760 132107 18446744073709551615 4194304 4228012 140734791862656 139807045089296 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22538] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22538/stat : 22538 (java) S 22531 22531 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 120863877 1093877760 132107 18446744073709551615 4194304 4228012 140734791862656 139807044036512 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22539] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22539/stat : 22539 (java) S 22531 22531 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120863880 1093877760 132107 18446744073709551615 4194304 4228012 140734791862656 139807042984944 139807146992672 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22540] ppid=22531 vsize=1068240 CPUtime=2.24
/proc/22534/task/22540/stat : 22540 (java) S 22531 22531 1750 0 -1 4202560 11192 0 0 0 220 4 0 0 20 0 11 0 120863880 1093877760 132107 18446744073709551615 4194304 4228012 140734791862656 139807041932304 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22541] ppid=22531 vsize=1068240 CPUtime=2.38
/proc/22534/task/22541/stat : 22541 (java) S 22531 22531 1750 0 -1 4202560 15621 0 0 0 232 6 0 0 20 0 11 0 120863880 1093877760 132107 18446744073709551615 4194304 4228012 140734791862656 139807040879632 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22542] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22542/stat : 22542 (java) S 22531 22531 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120863880 1093877760 132107 18446744073709551615 4194304 4228012 140734791862656 139807039827152 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22543] ppid=22531 vsize=1068240 CPUtime=0.02
/proc/22534/task/22543/stat : 22543 (java) S 22531 22531 1750 0 -1 4202560 3 0 0 0 2 0 0 0 20 0 11 0 120863880 1093877760 132107 18446744073709551615 4194304 4228012 140734791862656 139807038774656 139807146985035 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22544] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22544/stat : 22544 (java) S 22531 22531 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120864827 1093877760 132107 18446744073709551615 4194304 4228012 140734791862656 139807037577056 139807146985035 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 50.3
Current children cumulated vsize (KiB) 1077408

[startup+102.301 s]
/proc/loadavg: 1.12 1.13 1.06 2/71 22544
/proc/meminfo: memFree=9896/1022884 swapFree=0/0
[pid=22531] ppid=22530 vsize=9168 CPUtime=0
/proc/22531/stat : 22531 (p2cudf-full-1.1) S 22530 22531 1750 0 -1 4202496 456 292 0 0 0 0 0 0 20 0 1 0 120863870 9388032 331 18446744073709551615 4194304 5129932 140737424330624 140737424328768 140702272205918 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/22531/statm: 2292 331 280 229 0 52 0
[pid=22534] ppid=22531 vsize=1068240 CPUtime=100.99
/proc/22534/stat : 22534 (java) S 22531 22531 1750 0 -1 4202496 144624 0 0 0 10039 60 0 0 20 0 11 0 120863872 1093877760 135524 18446744073709551615 4194304 4228012 140734791862656 140734791853680 139807146970741 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22534/statm: 267060 135524 2392 9 0 254410 0
[pid=22534/tid=22535] ppid=22531 vsize=1068240 CPUtime=87
/proc/22534/task/22535/stat : 22535 (java) R 22531 22531 1750 0 -1 4202560 47818 0 0 0 8672 28 0 0 20 0 11 0 120863873 1093877760 135524 18446744073709551615 4194304 4228012 140734791862656 139807153504328 139807052257710 0 4 0 16800975 0 0 0 -1 0 0 0 3 0 0
[pid=22534/tid=22536] ppid=22531 vsize=1068240 CPUtime=9.3
/proc/22534/task/22536/stat : 22536 (java) S 22531 22531 1750 0 -1 4202560 68688 0 0 0 908 22 0 0 20 0 11 0 120863876 1093877760 135524 18446744073709551615 4194304 4228012 140734791862656 139807046143104 139807146985035 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22537] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22537/stat : 22537 (java) S 22531 22531 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120863877 1093877760 135524 18446744073709551615 4194304 4228012 140734791862656 139807045089296 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22538] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22538/stat : 22538 (java) S 22531 22531 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 120863877 1093877760 135524 18446744073709551615 4194304 4228012 140734791862656 139807044036512 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22539] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22539/stat : 22539 (java) S 22531 22531 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120863880 1093877760 135524 18446744073709551615 4194304 4228012 140734791862656 139807042984944 139807146992672 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22540] ppid=22531 vsize=1068240 CPUtime=2.24
/proc/22534/task/22540/stat : 22540 (java) S 22531 22531 1750 0 -1 4202560 11192 0 0 0 220 4 0 0 20 0 11 0 120863880 1093877760 135524 18446744073709551615 4194304 4228012 140734791862656 139807041932304 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22541] ppid=22531 vsize=1068240 CPUtime=2.38
/proc/22534/task/22541/stat : 22541 (java) S 22531 22531 1750 0 -1 4202560 15621 0 0 0 232 6 0 0 20 0 11 0 120863880 1093877760 135524 18446744073709551615 4194304 4228012 140734791862656 139807040879632 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22542] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22542/stat : 22542 (java) S 22531 22531 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120863880 1093877760 135524 18446744073709551615 4194304 4228012 140734791862656 139807039827152 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22543] ppid=22531 vsize=1068240 CPUtime=0.04
/proc/22534/task/22543/stat : 22543 (java) S 22531 22531 1750 0 -1 4202560 9 0 0 0 4 0 0 0 20 0 11 0 120863880 1093877760 135524 18446744073709551615 4194304 4228012 140734791862656 139807038774656 139807146985035 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22544] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22544/stat : 22544 (java) S 22531 22531 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120864827 1093877760 135524 18446744073709551615 4194304 4228012 140734791862656 139807037577056 139807146985035 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 100.99
Current children cumulated vsize (KiB) 1077408

[startup+162.301 s]
/proc/loadavg: 1.04 1.10 1.05 2/71 22544
/proc/meminfo: memFree=10268/1022884 swapFree=0/0
[pid=22531] ppid=22530 vsize=9168 CPUtime=0
/proc/22531/stat : 22531 (p2cudf-full-1.1) S 22530 22531 1750 0 -1 4202496 456 292 0 0 0 0 0 0 20 0 1 0 120863870 9388032 331 18446744073709551615 4194304 5129932 140737424330624 140737424328768 140702272205918 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/22531/statm: 2292 331 280 229 0 52 0
[pid=22534] ppid=22531 vsize=1068240 CPUtime=160.37
/proc/22534/stat : 22534 (java) S 22531 22531 1750 0 -1 4202496 151983 0 0 0 15975 62 0 0 20 0 11 0 120863872 1093877760 142876 18446744073709551615 4194304 4228012 140734791862656 140734791853680 139807146970741 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22534/statm: 267060 142876 2392 9 0 254410 0
[pid=22534/tid=22535] ppid=22531 vsize=1068240 CPUtime=143.28
/proc/22534/task/22535/stat : 22535 (java) R 22531 22531 1750 0 -1 4202560 47818 0 0 0 14300 28 0 0 20 0 11 0 120863873 1093877760 142876 18446744073709551615 4194304 4228012 140734791862656 139807153504328 139807052244108 0 4 0 16800975 0 0 0 -1 0 0 0 3 0 0
[pid=22534/tid=22536] ppid=22531 vsize=1068240 CPUtime=12.36
/proc/22534/task/22536/stat : 22536 (java) S 22531 22531 1750 0 -1 4202560 76041 0 0 0 1212 24 0 0 20 0 11 0 120863876 1093877760 142876 18446744073709551615 4194304 4228012 140734791862656 139807046143104 139807146985035 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22537] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22537/stat : 22537 (java) S 22531 22531 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120863877 1093877760 142876 18446744073709551615 4194304 4228012 140734791862656 139807045089296 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22538] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22538/stat : 22538 (java) S 22531 22531 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 120863877 1093877760 142876 18446744073709551615 4194304 4228012 140734791862656 139807044036512 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22539] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22539/stat : 22539 (java) S 22531 22531 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120863880 1093877760 142876 18446744073709551615 4194304 4228012 140734791862656 139807042984944 139807146992672 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22540] ppid=22531 vsize=1068240 CPUtime=2.26
/proc/22534/task/22540/stat : 22540 (java) S 22531 22531 1750 0 -1 4202560 11192 0 0 0 222 4 0 0 20 0 11 0 120863880 1093877760 142876 18446744073709551615 4194304 4228012 140734791862656 139807041932304 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22541] ppid=22531 vsize=1068240 CPUtime=2.38
/proc/22534/task/22541/stat : 22541 (java) S 22531 22531 1750 0 -1 4202560 15621 0 0 0 232 6 0 0 20 0 11 0 120863880 1093877760 142876 18446744073709551615 4194304 4228012 140734791862656 139807040879632 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22542] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22542/stat : 22542 (java) S 22531 22531 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120863880 1093877760 142876 18446744073709551615 4194304 4228012 140734791862656 139807039827152 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22543] ppid=22531 vsize=1068240 CPUtime=0.07
/proc/22534/task/22543/stat : 22543 (java) S 22531 22531 1750 0 -1 4202560 15 0 0 0 7 0 0 0 20 0 11 0 120863880 1093877760 142876 18446744073709551615 4194304 4228012 140734791862656 139807038774656 139807146985035 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22544] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22544/stat : 22544 (java) S 22531 22531 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120864827 1093877760 142876 18446744073709551615 4194304 4228012 140734791862656 139807037577056 139807146985035 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 160.37
Current children cumulated vsize (KiB) 1077408

[startup+222.304 s]
/proc/loadavg: 1.01 1.08 1.04 2/72 22620
/proc/meminfo: memFree=15724/1022884 swapFree=0/0
[pid=22531] ppid=22530 vsize=9168 CPUtime=0
/proc/22531/stat : 22531 (p2cudf-full-1.1) S 22530 22531 1750 0 -1 4202496 456 292 0 0 0 0 0 0 20 0 1 0 120863870 9388032 331 18446744073709551615 4194304 5129932 140737424330624 140737424328768 140702272205918 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/22531/statm: 2292 331 280 229 0 52 0
[pid=22534] ppid=22531 vsize=1068240 CPUtime=218.81
/proc/22534/stat : 22534 (java) S 22531 22531 1750 0 -1 4202496 151992 0 0 0 21819 62 0 0 20 0 11 0 120863872 1093877760 142873 18446744073709551615 4194304 4228012 140734791862656 140734791853680 139807146970741 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22534/statm: 267060 142873 2389 9 0 254410 0
[pid=22534/tid=22535] ppid=22531 vsize=1068240 CPUtime=199.13
/proc/22534/task/22535/stat : 22535 (java) R 22531 22531 1750 0 -1 4202560 47818 0 0 0 19885 28 0 0 20 0 11 0 120863873 1093877760 142873 18446744073709551615 4194304 4228012 140734791862656 139807153504328 139807052339834 0 4 0 16800975 0 0 0 -1 0 0 0 3 0 0
[pid=22534/tid=22536] ppid=22531 vsize=1068240 CPUtime=14.92
/proc/22534/task/22536/stat : 22536 (java) S 22531 22531 1750 0 -1 4202560 76044 0 0 0 1468 24 0 0 20 0 11 0 120863876 1093877760 142873 18446744073709551615 4194304 4228012 140734791862656 139807046143104 139807146985035 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22537] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22537/stat : 22537 (java) S 22531 22531 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120863877 1093877760 142873 18446744073709551615 4194304 4228012 140734791862656 139807045089296 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22538] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22538/stat : 22538 (java) S 22531 22531 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 120863877 1093877760 142873 18446744073709551615 4194304 4228012 140734791862656 139807044036512 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22539] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22539/stat : 22539 (java) S 22531 22531 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120863880 1093877760 142873 18446744073709551615 4194304 4228012 140734791862656 139807042984944 139807146992672 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22540] ppid=22531 vsize=1068240 CPUtime=2.26
/proc/22534/task/22540/stat : 22540 (java) S 22531 22531 1750 0 -1 4202560 11192 0 0 0 222 4 0 0 20 0 11 0 120863880 1093877760 142873 18446744073709551615 4194304 4228012 140734791862656 139807041932304 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22541] ppid=22531 vsize=1068240 CPUtime=2.38
/proc/22534/task/22541/stat : 22541 (java) S 22531 22531 1750 0 -1 4202560 15621 0 0 0 232 6 0 0 20 0 11 0 120863880 1093877760 142873 18446744073709551615 4194304 4228012 140734791862656 139807040879632 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22542] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22542/stat : 22542 (java) S 22531 22531 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120863880 1093877760 142873 18446744073709551615 4194304 4228012 140734791862656 139807039827152 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22543] ppid=22531 vsize=1068240 CPUtime=0.1
/proc/22534/task/22543/stat : 22543 (java) S 22531 22531 1750 0 -1 4202560 21 0 0 0 10 0 0 0 20 0 11 0 120863880 1093877760 142873 18446744073709551615 4194304 4228012 140734791862656 139807038774656 139807146985035 0 4 0 16800975 0 0 0 -1 0 0 0 2 0 0
[pid=22534/tid=22544] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22544/stat : 22544 (java) S 22531 22531 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120864827 1093877760 142873 18446744073709551615 4194304 4228012 140734791862656 139807037577056 139807146985035 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 218.81
Current children cumulated vsize (KiB) 1077408

[startup+282.301 s]
/proc/loadavg: 1.31 1.18 1.08 2/71 22797
/proc/meminfo: memFree=62684/1022884 swapFree=0/0
[pid=22531] ppid=22530 vsize=9168 CPUtime=0
/proc/22531/stat : 22531 (p2cudf-full-1.1) S 22530 22531 1750 0 -1 4202496 456 292 0 0 0 0 0 0 20 0 1 0 120863870 9388032 331 18446744073709551615 4194304 5129932 140737424330624 140737424328768 140702272205918 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/22531/statm: 2292 331 280 229 0 52 0
[pid=22534] ppid=22531 vsize=1068240 CPUtime=271.73
/proc/22534/stat : 22534 (java) S 22531 22531 1750 0 -1 4202496 152373 0 0 0 27110 63 0 0 20 0 11 0 120863872 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 140734791853680 139807146970741 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22534/statm: 267060 142821 1964 9 0 254410 0
[pid=22534/tid=22535] ppid=22531 vsize=1068240 CPUtime=250.44
/proc/22534/task/22535/stat : 22535 (java) R 22531 22531 1750 0 -1 4202560 47818 0 0 0 25016 28 0 0 20 0 11 0 120863873 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807153504328 139807052284488 0 4 0 16800975 0 0 0 -1 0 0 0 3 0 0
[pid=22534/tid=22536] ppid=22531 vsize=1068240 CPUtime=16.5
/proc/22534/task/22536/stat : 22536 (java) S 22531 22531 1750 0 -1 4202560 76419 0 0 0 1626 24 0 0 20 0 11 0 120863876 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807046143104 139807146985035 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22537] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22537/stat : 22537 (java) S 22531 22531 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120863877 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807045089296 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22538] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22538/stat : 22538 (java) S 22531 22531 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 120863877 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807044036512 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22539] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22539/stat : 22539 (java) S 22531 22531 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120863880 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807042984944 139807146992672 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22540] ppid=22531 vsize=1068240 CPUtime=2.26
/proc/22534/task/22540/stat : 22540 (java) S 22531 22531 1750 0 -1 4202560 11192 0 0 0 222 4 0 0 20 0 11 0 120863880 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807041932304 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22541] ppid=22531 vsize=1068240 CPUtime=2.38
/proc/22534/task/22541/stat : 22541 (java) S 22531 22531 1750 0 -1 4202560 15621 0 0 0 232 6 0 0 20 0 11 0 120863880 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807040879632 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22542] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22542/stat : 22542 (java) S 22531 22531 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120863880 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807039827152 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22543] ppid=22531 vsize=1068240 CPUtime=0.12
/proc/22534/task/22543/stat : 22543 (java) S 22531 22531 1750 0 -1 4202560 27 0 0 0 12 0 0 0 20 0 11 0 120863880 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807038774656 139807146985035 0 4 0 16800975 0 0 0 -1 0 0 0 2 0 0
[pid=22534/tid=22544] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22544/stat : 22544 (java) S 22531 22531 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120864827 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807037577056 139807146985035 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 271.73
Current children cumulated vsize (KiB) 1077408

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

[startup+288.001 s]
/proc/loadavg: 1.28 1.18 1.08 2/71 22797
/proc/meminfo: memFree=62684/1022884 swapFree=0/0
[pid=22531] ppid=22530 vsize=9168 CPUtime=0
/proc/22531/stat : 22531 (p2cudf-full-1.1) S 22530 22531 1750 0 -1 4202496 456 292 0 0 0 0 0 0 20 0 1 0 120863870 9388032 331 18446744073709551615 4194304 5129932 140737424330624 140737424328768 140702272205918 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/22531/statm: 2292 331 280 229 0 52 0
[pid=22534] ppid=22531 vsize=1068240 CPUtime=277.38
/proc/22534/stat : 22534 (java) S 22531 22531 1750 0 -1 4202496 152373 0 0 0 27675 63 0 0 20 0 11 0 120863872 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 140734791853680 139807146970741 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22534/statm: 267060 142821 1964 9 0 254410 0
[pid=22534/tid=22535] ppid=22531 vsize=1068240 CPUtime=256.08
/proc/22534/task/22535/stat : 22535 (java) R 22531 22531 1750 0 -1 4202560 47818 0 0 0 25580 28 0 0 20 0 11 0 120863873 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807153504328 139807052330599 0 4 0 16800975 0 0 0 -1 0 0 0 3 0 0
[pid=22534/tid=22536] ppid=22531 vsize=1068240 CPUtime=16.5
/proc/22534/task/22536/stat : 22536 (java) S 22531 22531 1750 0 -1 4202560 76419 0 0 0 1626 24 0 0 20 0 11 0 120863876 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807046143104 139807146985035 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22537] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22537/stat : 22537 (java) S 22531 22531 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120863877 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807045089296 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22538] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22538/stat : 22538 (java) S 22531 22531 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 120863877 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807044036512 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22539] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22539/stat : 22539 (java) S 22531 22531 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120863880 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807042984944 139807146992672 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22540] ppid=22531 vsize=1068240 CPUtime=2.26
/proc/22534/task/22540/stat : 22540 (java) S 22531 22531 1750 0 -1 4202560 11192 0 0 0 222 4 0 0 20 0 11 0 120863880 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807041932304 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22541] ppid=22531 vsize=1068240 CPUtime=2.38
/proc/22534/task/22541/stat : 22541 (java) S 22531 22531 1750 0 -1 4202560 15621 0 0 0 232 6 0 0 20 0 11 0 120863880 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807040879632 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22542] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22542/stat : 22542 (java) S 22531 22531 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120863880 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807039827152 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22543] ppid=22531 vsize=1068240 CPUtime=0.12
/proc/22534/task/22543/stat : 22543 (java) S 22531 22531 1750 0 -1 4202560 27 0 0 0 12 0 0 0 20 0 11 0 120863880 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807038774656 139807146985035 0 4 0 16800975 0 0 0 -1 0 0 0 2 0 0
[pid=22534/tid=22544] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22544/stat : 22544 (java) S 22531 22531 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120864827 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807037577056 139807146985035 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 277.38
Current children cumulated vsize (KiB) 1077408

[startup+291.201 s]
/proc/loadavg: 1.26 1.17 1.08 2/71 22797
/proc/meminfo: memFree=62684/1022884 swapFree=0/0
[pid=22531] ppid=22530 vsize=9168 CPUtime=0
/proc/22531/stat : 22531 (p2cudf-full-1.1) S 22530 22531 1750 0 -1 4202496 456 292 0 0 0 0 0 0 20 0 1 0 120863870 9388032 331 18446744073709551615 4194304 5129932 140737424330624 140737424328768 140702272205918 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/22531/statm: 2292 331 280 229 0 52 0
[pid=22534] ppid=22531 vsize=1068240 CPUtime=280.54
/proc/22534/stat : 22534 (java) S 22531 22531 1750 0 -1 4202496 152373 0 0 0 27991 63 0 0 20 0 11 0 120863872 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 140734791853680 139807146970741 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22534/statm: 267060 142821 1964 9 0 254410 0
[pid=22534/tid=22535] ppid=22531 vsize=1068240 CPUtime=259.24
/proc/22534/task/22535/stat : 22535 (java) R 22531 22531 1750 0 -1 4202560 47818 0 0 0 25896 28 0 0 20 0 11 0 120863873 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807153504328 139807052172522 0 4 0 16800975 0 0 0 -1 0 0 0 3 0 0
[pid=22534/tid=22536] ppid=22531 vsize=1068240 CPUtime=16.5
/proc/22534/task/22536/stat : 22536 (java) S 22531 22531 1750 0 -1 4202560 76419 0 0 0 1626 24 0 0 20 0 11 0 120863876 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807046143104 139807146985035 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22537] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22537/stat : 22537 (java) S 22531 22531 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120863877 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807045089296 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22538] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22538/stat : 22538 (java) S 22531 22531 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 120863877 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807044036512 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22539] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22539/stat : 22539 (java) S 22531 22531 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120863880 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807042984944 139807146992672 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22540] ppid=22531 vsize=1068240 CPUtime=2.26
/proc/22534/task/22540/stat : 22540 (java) S 22531 22531 1750 0 -1 4202560 11192 0 0 0 222 4 0 0 20 0 11 0 120863880 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807041932304 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22541] ppid=22531 vsize=1068240 CPUtime=2.38
/proc/22534/task/22541/stat : 22541 (java) S 22531 22531 1750 0 -1 4202560 15621 0 0 0 232 6 0 0 20 0 11 0 120863880 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807040879632 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22542] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22542/stat : 22542 (java) S 22531 22531 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120863880 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807039827152 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22543] ppid=22531 vsize=1068240 CPUtime=0.13
/proc/22534/task/22543/stat : 22543 (java) S 22531 22531 1750 0 -1 4202560 27 0 0 0 13 0 0 0 20 0 11 0 120863880 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807038774656 139807146985035 0 4 0 16800975 0 0 0 -1 0 0 0 2 0 0
[pid=22534/tid=22544] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22544/stat : 22544 (java) S 22531 22531 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120864827 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807037577056 139807146985035 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 280.54
Current children cumulated vsize (KiB) 1077408

[startup+292.801 s]
/proc/loadavg: 1.26 1.17 1.08 2/71 22797
/proc/meminfo: memFree=62684/1022884 swapFree=0/0
[pid=22531] ppid=22530 vsize=9168 CPUtime=0
/proc/22531/stat : 22531 (p2cudf-full-1.1) S 22530 22531 1750 0 -1 4202496 456 292 0 0 0 0 0 0 20 0 1 0 120863870 9388032 331 18446744073709551615 4194304 5129932 140737424330624 140737424328768 140702272205918 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/22531/statm: 2292 331 280 229 0 52 0
[pid=22534] ppid=22531 vsize=1068240 CPUtime=282.13
/proc/22534/stat : 22534 (java) S 22531 22531 1750 0 -1 4202496 152373 0 0 0 28150 63 0 0 20 0 11 0 120863872 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 140734791853680 139807146970741 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22534/statm: 267060 142821 1964 9 0 254410 0
[pid=22534/tid=22535] ppid=22531 vsize=1068240 CPUtime=260.52
/proc/22534/task/22535/stat : 22535 (java) S 22531 22531 1750 0 -1 4202560 47818 0 0 0 26024 28 0 0 20 0 11 0 120863873 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807153504128 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 3 0 0
[pid=22534/tid=22536] ppid=22531 vsize=1068240 CPUtime=16.8
/proc/22534/task/22536/stat : 22536 (java) R 22531 22531 1750 0 -1 4202560 76419 0 0 0 1656 24 0 0 20 0 11 0 120863876 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807046142064 139807133834723 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22537] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22537/stat : 22537 (java) S 22531 22531 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120863877 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807045089296 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22538] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22538/stat : 22538 (java) S 22531 22531 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 120863877 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807044036512 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22539] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22539/stat : 22539 (java) S 22531 22531 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120863880 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807042984944 139807146992672 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22540] ppid=22531 vsize=1068240 CPUtime=2.26
/proc/22534/task/22540/stat : 22540 (java) S 22531 22531 1750 0 -1 4202560 11192 0 0 0 222 4 0 0 20 0 11 0 120863880 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807041932304 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22541] ppid=22531 vsize=1068240 CPUtime=2.38
/proc/22534/task/22541/stat : 22541 (java) S 22531 22531 1750 0 -1 4202560 15621 0 0 0 232 6 0 0 20 0 11 0 120863880 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807040879632 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22542] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22542/stat : 22542 (java) S 22531 22531 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120863880 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807039827152 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22543] ppid=22531 vsize=1068240 CPUtime=0.13
/proc/22534/task/22543/stat : 22543 (java) S 22531 22531 1750 0 -1 4202560 27 0 0 0 13 0 0 0 20 0 11 0 120863880 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807038774656 139807146985035 0 4 0 16800975 0 0 0 -1 0 0 0 2 0 0
[pid=22534/tid=22544] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22544/stat : 22544 (java) S 22531 22531 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120864827 1093877760 142821 18446744073709551615 4194304 4228012 140734791862656 139807037577056 139807146985035 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 282.13
Current children cumulated vsize (KiB) 1077408

[startup+294.401 s]
/proc/loadavg: 1.24 1.17 1.08 2/71 22797
/proc/meminfo: memFree=61940/1022884 swapFree=0/0
[pid=22531] ppid=22530 vsize=9168 CPUtime=0
/proc/22531/stat : 22531 (p2cudf-full-1.1) S 22530 22531 1750 0 -1 4202496 456 292 0 0 0 0 0 0 20 0 1 0 120863870 9388032 331 18446744073709551615 4194304 5129932 140737424330624 140737424328768 140702272205918 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/22531/statm: 2292 331 280 229 0 52 0
[pid=22534] ppid=22531 vsize=1068240 CPUtime=283.71
/proc/22534/stat : 22534 (java) S 22531 22531 1750 0 -1 4202496 152646 0 0 0 28308 63 0 0 20 0 11 0 120863872 1093877760 143094 18446744073709551615 4194304 4228012 140734791862656 140734791853680 139807146970741 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22534/statm: 267060 143094 1964 9 0 254410 0
[pid=22534/tid=22535] ppid=22531 vsize=1068240 CPUtime=261.91
/proc/22534/task/22535/stat : 22535 (java) R 22531 22531 1750 0 -1 4202560 47818 0 0 0 26163 28 0 0 20 0 11 0 120863873 1093877760 143094 18446744073709551615 4194304 4228012 140734791862656 139807153504328 139807052309634 0 4 0 16800975 0 0 0 -1 0 0 0 3 0 0
[pid=22534/tid=22536] ppid=22531 vsize=1068240 CPUtime=17
/proc/22534/task/22536/stat : 22536 (java) S 22531 22531 1750 0 -1 4202560 76692 0 0 0 1676 24 0 0 20 0 11 0 120863876 1093877760 143094 18446744073709551615 4194304 4228012 140734791862656 139807046143104 139807146985035 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22537] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22537/stat : 22537 (java) S 22531 22531 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120863877 1093877760 143094 18446744073709551615 4194304 4228012 140734791862656 139807045089296 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22538] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22538/stat : 22538 (java) S 22531 22531 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 120863877 1093877760 143094 18446744073709551615 4194304 4228012 140734791862656 139807044036512 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22539] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22539/stat : 22539 (java) S 22531 22531 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120863880 1093877760 143094 18446744073709551615 4194304 4228012 140734791862656 139807042984944 139807146992672 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22540] ppid=22531 vsize=1068240 CPUtime=2.26
/proc/22534/task/22540/stat : 22540 (java) S 22531 22531 1750 0 -1 4202560 11192 0 0 0 222 4 0 0 20 0 11 0 120863880 1093877760 143094 18446744073709551615 4194304 4228012 140734791862656 139807041932304 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22541] ppid=22531 vsize=1068240 CPUtime=2.38
/proc/22534/task/22541/stat : 22541 (java) S 22531 22531 1750 0 -1 4202560 15621 0 0 0 232 6 0 0 20 0 11 0 120863880 1093877760 143094 18446744073709551615 4194304 4228012 140734791862656 139807040879632 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22542] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22542/stat : 22542 (java) S 22531 22531 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120863880 1093877760 143094 18446744073709551615 4194304 4228012 140734791862656 139807039827152 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22543] ppid=22531 vsize=1068240 CPUtime=0.13
/proc/22534/task/22543/stat : 22543 (java) S 22531 22531 1750 0 -1 4202560 27 0 0 0 13 0 0 0 20 0 11 0 120863880 1093877760 143094 18446744073709551615 4194304 4228012 140734791862656 139807038774656 139807146985035 0 4 0 16800975 0 0 0 -1 0 0 0 2 0 0
[pid=22534/tid=22544] ppid=22531 vsize=1068240 CPUtime=0
/proc/22534/task/22544/stat : 22544 (java) S 22531 22531 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120864827 1093877760 143094 18446744073709551615 4194304 4228012 140734791862656 139807037577056 139807146985035 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 283.71
Current children cumulated vsize (KiB) 1077408

[startup+295.201 s]
/proc/loadavg: 1.24 1.17 1.08 1/71 22798
/proc/meminfo: memFree=61816/1022884 swapFree=0/0
[pid=22531] ppid=22530 vsize=9168 CPUtime=0
/proc/22531/stat : 22531 (p2cudf-full-1.1) S 22530 22531 1750 0 -1 4202496 456 292 0 0 0 0 0 0 20 0 1 0 120863870 9388032 331 18446744073709551615 4194304 5129932 140737424330624 140737424328768 140702272205918 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/22531/statm: 2292 331 280 229 0 52 0
[pid=22534] ppid=22531 vsize=1069268 CPUtime=283.94
/proc/22534/stat : 22534 (java) S 22531 22531 1750 0 -1 4202496 152662 0 1 0 28331 63 0 0 20 0 11 0 120863872 1094930432 143109 18446744073709551615 4194304 4228012 140734791862656 140734791853680 139807146970741 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22534/statm: 267317 143109 1965 9 0 254667 0
[pid=22534/tid=22535] ppid=22531 vsize=1069268 CPUtime=262.11
/proc/22534/task/22535/stat : 22535 (java) S 22531 22531 1750 0 -1 4202560 47827 0 1 0 26183 28 0 0 20 0 11 0 120863873 1094930432 143109 18446744073709551615 4194304 4228012 140734791862656 139807153505200 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 10 0 0
[pid=22534/tid=22536] ppid=22531 vsize=1069268 CPUtime=17
/proc/22534/task/22536/stat : 22536 (java) S 22531 22531 1750 0 -1 4202560 76692 0 0 0 1676 24 0 0 20 0 11 0 120863876 1094930432 143109 18446744073709551615 4194304 4228012 140734791862656 139807046143104 139807146985035 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22537] ppid=22531 vsize=1069268 CPUtime=0
/proc/22534/task/22537/stat : 22537 (java) S 22531 22531 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120863877 1094930432 143109 18446744073709551615 4194304 4228012 140734791862656 139807045089296 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22538] ppid=22531 vsize=1069268 CPUtime=0
/proc/22534/task/22538/stat : 22538 (java) S 22531 22531 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 120863877 1094930432 143109 18446744073709551615 4194304 4228012 140734791862656 139807044036512 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22539] ppid=22531 vsize=1069268 CPUtime=0
/proc/22534/task/22539/stat : 22539 (java) S 22531 22531 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120863880 1094930432 143109 18446744073709551615 4194304 4228012 140734791862656 139807042984944 139807146992672 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22540] ppid=22531 vsize=1069268 CPUtime=2.28
/proc/22534/task/22540/stat : 22540 (java) S 22531 22531 1750 0 -1 4202560 11192 0 0 0 224 4 0 0 20 0 11 0 120863880 1094930432 143109 18446744073709551615 4194304 4228012 140734791862656 139807041932304 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22541] ppid=22531 vsize=1069268 CPUtime=2.39
/proc/22534/task/22541/stat : 22541 (java) S 22531 22531 1750 0 -1 4202560 15621 0 0 0 233 6 0 0 20 0 11 0 120863880 1094930432 143109 18446744073709551615 4194304 4228012 140734791862656 139807040879632 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22542] ppid=22531 vsize=1069268 CPUtime=0
/proc/22534/task/22542/stat : 22542 (java) S 22531 22531 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120863880 1094930432 143109 18446744073709551615 4194304 4228012 140734791862656 139807039827152 139807146984148 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22534/tid=22543] ppid=22531 vsize=1069268 CPUtime=0.13
/proc/22534/task/22543/stat : 22543 (java) S 22531 22531 1750 0 -1 4202560 27 0 0 0 13 0 0 0 20 0 11 0 120863880 1094930432 143109 18446744073709551615 4194304 4228012 140734791862656 139807038774656 139807146985035 0 4 0 16800975 0 0 0 -1 0 0 0 2 0 0
[pid=22534/tid=22798] ppid=22531 vsize=1069268 CPUtime=0.01
/proc/22534/task/22798/stat : 22798 (java) R 22531 22531 1750 0 -1 4202560 7 0 0 0 1 0 0 0 20 0 11 0 120893339 1094930432 143109 18446744073709551615 4194304 4228012 140734791862656 139807036515632 139807051012934 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 283.94
Current children cumulated vsize (KiB) 1078436

[startup+295.403 s]
/proc/loadavg: 1.24 1.17 1.08 1/71 22798
/proc/meminfo: memFree=61816/1022884 swapFree=0/0
[pid=22531] ppid=22530 vsize=9168 CPUtime=0
/proc/22531/stat : 22531 (p2cudf-full-1.1) S 22530 22531 1750 0 -1 4202496 456 292 0 0 0 0 0 0 20 0 1 0 120863870 9388032 331 18446744073709551615 4194304 5129932 140737424330624 140737424328768 140702272205918 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/22531/statm: 2292 331 280 229 0 52 0
[pid=22534] ppid=22531 vsize=0 CPUtime=284.1
/proc/22534/stat : 22534 (java) Z 22531 22531 1750 0 -1 4203532 152675 0 2 0 28340 70 0 0 20 0 2 0 120863872 0 0 18446744073709551615 0 0 0 0 0 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22534/statm: 0 0 0 0 0 0 0
[pid=22534/tid=22535] ppid=22531 vsize=0 CPUtime=262.18
/proc/22534/task/22535/stat : 22535 (java) R 22531 22531 1750 0 -1 4203588 47830 0 1 0 26184 34 0 0 20 0 2 0 120863873 0 0 18446744073709551615 0 0 0 0 0 0 4 0 16800975 18446744073709551615 0 0 -1 0 0 0 10 0 0
Current children cumulated CPU time (s) 284.1
Current children cumulated vsize (KiB) 9168

Child status: 0
Real time (s): 295.434
CPU time (s): 284.142
CPU user time (s): 283.418
CPU system time (s): 0.724045
CPU usage (%): 96.1776
Max. virtual memory (cumulated for all children) (KiB): 1081540

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 283.418
system time used= 0.724045
maximum resident set size= 572476
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 153436
page faults= 2
swaps= 0
block input operations= 42704
block output operations= 608
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 7202
involuntary context switches= 44803

runsolver used 0.728045 second user time and 1.76811 second system time

The end