runsolver Copyright (C) 2010 Olivier ROUSSEL

This is runsolver version 3.2.9a (svn: 651)

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

command line: runsolver -s SIGUSR1 -M 1124 -C 300 -d 10 -w /tmp/misc2012/2012-09-02-22:42/full/p2cudf-full-1.15/slowlink/install/rand242.cudf.log.runsolver /home/competition/p2cudf-full-1.15/p2cudf-full-1.15 /home/competition/data/install/rand242.cudf /tmp/misc2012/2012-09-02-22:42/full/p2cudf-full-1.15/slowlink/install/rand242.cudf.result -sum(changed,installedsize),-count(removed),-notuptodate(solution),-count(changed) 

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


[startup+0 s]
/proc/loadavg: 1.04 1.00 0.98 2/59 21957
/proc/meminfo: memFree=437396/1022884 swapFree=0/0
[pid=21957] ppid=21956 vsize=3152 CPUtime=0
/proc/21957/stat : 21957 (runsolver) D 21956 21957 1750 0 -1 4202560 74 0 0 0 0 0 0 0 20 0 1 0 120668157 3227648 96 18446744073709551615 134512640 134586868 4293176528 4293174576 4152173616 0 0 16781316 24578 0 0 0 17 0 0 0 0 0 0
/proc/21957/statm: 788 96 64 19 0 73 0

[startup+0.126637 s]
/proc/loadavg: 1.04 1.00 0.98 2/59 21957
/proc/meminfo: memFree=437396/1022884 swapFree=0/0
[pid=21957] ppid=21956 vsize=9168 CPUtime=0
/proc/21957/stat : 21957 (p2cudf-full-1.1) D 21956 21957 1750 0 -1 4202496 435 291 2 1 0 0 0 0 20 0 1 0 120668157 9388032 328 18446744073709551615 4194304 5129932 140737437717344 140737437715272 140473338945653 0 0 16781316 65536 0 0 0 17 0 0 0 10 0 0
/proc/21957/statm: 2292 328 278 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.200342 s]
/proc/loadavg: 1.04 1.00 0.98 2/59 21957
/proc/meminfo: memFree=437396/1022884 swapFree=0/0
[pid=21957] ppid=21956 vsize=9168 CPUtime=0
/proc/21957/stat : 21957 (p2cudf-full-1.1) S 21956 21957 1750 0 -1 4202496 452 291 2 1 0 0 0 0 20 0 1 0 120668157 9388032 330 18446744073709551615 4194304 5129932 140737437717344 140737437715488 140473338803294 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/21957/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.300357 s]
/proc/loadavg: 1.04 1.00 0.98 2/59 21957
/proc/meminfo: memFree=437396/1022884 swapFree=0/0
[pid=21957] ppid=21956 vsize=9168 CPUtime=0
/proc/21957/stat : 21957 (p2cudf-full-1.1) S 21956 21957 1750 0 -1 4202496 452 291 2 1 0 0 0 0 20 0 1 0 120668157 9388032 330 18446744073709551615 4194304 5129932 140737437717344 140737437715488 140473338803294 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/21957/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.700317 s]
/proc/loadavg: 1.04 1.00 0.98 2/59 21957
/proc/meminfo: memFree=437396/1022884 swapFree=0/0
[pid=21957] ppid=21956 vsize=9168 CPUtime=0
/proc/21957/stat : 21957 (p2cudf-full-1.1) S 21956 21957 1750 0 -1 4202496 452 291 2 1 0 0 0 0 20 0 1 0 120668157 9388032 330 18446744073709551615 4194304 5129932 140737437717344 140737437715488 140473338803294 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/21957/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+1.50065 s]
/proc/loadavg: 1.04 1.00 0.98 1/70 21969
/proc/meminfo: memFree=417592/1022884 swapFree=0/0
[pid=21957] ppid=21956 vsize=9168 CPUtime=0
/proc/21957/stat : 21957 (p2cudf-full-1.1) S 21956 21957 1750 0 -1 4202496 452 291 2 1 0 0 0 0 20 0 1 0 120668157 9388032 330 18446744073709551615 4194304 5129932 140737437717344 140737437715488 140473338803294 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/21957/statm: 2292 330 280 229 0 52 0
[pid=21960] ppid=21957 vsize=950312 CPUtime=0.12
/proc/21960/stat : 21960 (java) S 21957 21957 1750 0 -1 4202496 4074 0 98 0 11 1 0 0 20 0 10 0 120668170 973119488 3843 18446744073709551615 4194304 4228012 140734166799520 140734166790544 139941542063733 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 21 0 0
/proc/21960/statm: 237578 3843 1861 9 0 224935 0
[pid=21960/tid=21961] ppid=21957 vsize=950312 CPUtime=0.1
/proc/21960/task/21961/stat : 21961 (java) D 21957 21957 1750 0 -1 4202560 2800 0 58 0 9 1 0 0 20 0 10 0 120668192 973119488 3843 18446744073709551615 4194304 4228012 140734166799520 139941548594240 139941534943037 0 4 0 16800975 0 0 0 -1 0 0 0 102 0 0
[pid=21960/tid=21962] ppid=21957 vsize=950312 CPUtime=0
/proc/21960/task/21962/stat : 21962 (java) S 21957 21957 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 120668237 973119488 3843 18446744073709551615 4194304 4228012 140734166799520 139941441236096 139941542078027 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21963] ppid=21957 vsize=950312 CPUtime=0
/proc/21960/task/21963/stat : 21963 (java) S 21957 21957 1750 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 10 0 120668246 973119488 3843 18446744073709551615 4194304 4228012 140734166799520 139941440182288 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21964] ppid=21957 vsize=950312 CPUtime=0
/proc/21960/task/21964/stat : 21964 (java) S 21957 21957 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 10 0 120668246 973119488 3843 18446744073709551615 4194304 4228012 140734166799520 139941439129504 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21965] ppid=21957 vsize=950312 CPUtime=0
/proc/21960/task/21965/stat : 21965 (java) S 21957 21957 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 120668261 973119488 3843 18446744073709551615 4194304 4228012 140734166799520 139941438077936 139941542085664 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21966] ppid=21957 vsize=950312 CPUtime=0
/proc/21960/task/21966/stat : 21966 (java) S 21957 21957 1750 0 -1 4202560 25 0 1 0 0 0 0 0 20 0 10 0 120668261 973119488 3843 18446744073709551615 4194304 4228012 140734166799520 139941437025296 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21967] ppid=21957 vsize=950312 CPUtime=0
/proc/21960/task/21967/stat : 21967 (java) S 21957 21957 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 120668261 973119488 3843 18446744073709551615 4194304 4228012 140734166799520 139941435972624 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21968] ppid=21957 vsize=950312 CPUtime=0
/proc/21960/task/21968/stat : 21968 (java) S 21957 21957 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 120668262 973119488 3843 18446744073709551615 4194304 4228012 140734166799520 139941434920144 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21969] ppid=21957 vsize=950312 CPUtime=0
/proc/21960/task/21969/stat : 21969 (java) S 21957 21957 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 120668262 973119488 3843 18446744073709551615 4194304 4228012 140734166799520 139941433867648 139941542078027 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 0.12
Current children cumulated vsize (KiB) 959480

[startup+3.10059 s]
/proc/loadavg: 1.04 1.00 0.98 4/70 21969
/proc/meminfo: memFree=390932/1022884 swapFree=0/0
[pid=21957] ppid=21956 vsize=9168 CPUtime=0
/proc/21957/stat : 21957 (p2cudf-full-1.1) S 21956 21957 1750 0 -1 4202496 452 291 2 1 0 0 0 0 20 0 1 0 120668157 9388032 330 18446744073709551615 4194304 5129932 140737437717344 140737437715488 140473338803294 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/21957/statm: 2292 330 280 229 0 52 0
[pid=21960] ppid=21957 vsize=1049636 CPUtime=1.51
/proc/21960/stat : 21960 (java) S 21957 21957 1750 0 -1 4202496 43916 0 110 0 135 16 0 0 20 0 10 0 120668170 1074827264 38620 18446744073709551615 4194304 4228012 140734166799520 140734166790544 139941542063733 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 21 0 0
/proc/21960/statm: 262409 38620 2350 9 0 249759 0
[pid=21960/tid=21961] ppid=21957 vsize=1049636 CPUtime=0.65
/proc/21960/task/21961/stat : 21961 (java) R 21957 21957 1750 0 -1 4202560 22942 0 60 0 57 8 0 0 20 0 10 0 120668192 1074827264 38620 18446744073709551615 4194304 4228012 140734166799520 139941548589760 139941525558699 0 4 0 16800975 0 0 0 -1 0 0 0 123 0 0
[pid=21960/tid=21962] ppid=21957 vsize=1049636 CPUtime=0
/proc/21960/task/21962/stat : 21962 (java) S 21957 21957 1750 0 -1 4202560 3 0 0 0 0 0 0 0 20 0 10 0 120668237 1074827264 38620 18446744073709551615 4194304 4228012 140734166799520 139941441236096 139941542078027 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21963] ppid=21957 vsize=1049636 CPUtime=0
/proc/21960/task/21963/stat : 21963 (java) S 21957 21957 1750 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 10 0 120668246 1074827264 38620 18446744073709551615 4194304 4228012 140734166799520 139941440182288 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21964] ppid=21957 vsize=1049636 CPUtime=0
/proc/21960/task/21964/stat : 21964 (java) S 21957 21957 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 10 0 120668246 1074827264 38620 18446744073709551615 4194304 4228012 140734166799520 139941439129504 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21965] ppid=21957 vsize=1049636 CPUtime=0
/proc/21960/task/21965/stat : 21965 (java) S 21957 21957 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 120668261 1074827264 38620 18446744073709551615 4194304 4228012 140734166799520 139941438077936 139941542085664 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21966] ppid=21957 vsize=1049636 CPUtime=0.43
/proc/21960/task/21966/stat : 21966 (java) R 21957 21957 1750 0 -1 4202560 10046 0 11 0 40 3 0 0 20 0 10 0 120668261 1074827264 38620 18446744073709551615 4194304 4228012 140734166799520 139941437025040 139941528224992 0 4 0 16800975 0 0 0 -1 0 0 0 10 0 0
[pid=21960/tid=21967] ppid=21957 vsize=1049636 CPUtime=0.4
/proc/21960/task/21967/stat : 21967 (java) R 21957 21957 1750 0 -1 4202560 9677 0 0 0 35 5 0 0 20 0 10 0 120668261 1074827264 38620 18446744073709551615 4194304 4228012 140734166799520 139941435972368 139941524916267 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21968] ppid=21957 vsize=1049636 CPUtime=0
/proc/21960/task/21968/stat : 21968 (java) S 21957 21957 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 120668262 1074827264 38620 18446744073709551615 4194304 4228012 140734166799520 139941434920144 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21969] ppid=21957 vsize=1049636 CPUtime=0
/proc/21960/task/21969/stat : 21969 (java) S 21957 21957 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 120668262 1074827264 38620 18446744073709551615 4194304 4228012 140734166799520 139941433867648 139941542078027 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 1.51
Current children cumulated vsize (KiB) 1058804
heavy processes:

[startup+6.30078 s]
/proc/loadavg: 1.19 1.03 0.99 2/70 21969
/proc/meminfo: memFree=10264/1022884 swapFree=0/0
[pid=21957] ppid=21956 vsize=9168 CPUtime=0
/proc/21957/stat : 21957 (p2cudf-full-1.1) S 21956 21957 1750 0 -1 4202496 452 291 2 1 0 0 0 0 20 0 1 0 120668157 9388032 330 18446744073709551615 4194304 5129932 140737437717344 140737437715488 140473338803294 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/21957/statm: 2292 330 280 229 0 52 0
[pid=21960] ppid=21957 vsize=1046784 CPUtime=4.45
/proc/21960/stat : 21960 (java) S 21957 21957 1750 0 -1 4202496 122723 0 111 0 408 37 0 0 20 0 10 0 120668170 1071906816 116721 18446744073709551615 4194304 4228012 140734166799520 140734166790544 139941542063733 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 21 0 0
/proc/21960/statm: 261696 116721 2371 9 0 249046 0
[pid=21960/tid=21961] ppid=21957 vsize=1046784 CPUtime=2.37
/proc/21960/task/21961/stat : 21961 (java) S 21957 21957 1750 0 -1 4202560 47370 0 60 0 221 16 0 0 20 0 10 0 120668192 1071906816 116721 18446744073709551615 4194304 4228012 140734166799520 139941548597776 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 130 0 0
[pid=21960/tid=21962] ppid=21957 vsize=1046784 CPUtime=1.08
/proc/21960/task/21962/stat : 21962 (java) R 21957 21957 1750 0 -1 4202560 54369 0 1 0 95 13 0 0 20 0 10 0 120668237 1071906816 116721 18446744073709551615 4194304 4228012 140734166799520 139941441235472 139941526187305 0 0 0 16800975 0 0 0 -1 0 0 0 2 0 0
[pid=21960/tid=21963] ppid=21957 vsize=1046784 CPUtime=0
/proc/21960/task/21963/stat : 21963 (java) S 21957 21957 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 120668246 1071906816 116721 18446744073709551615 4194304 4228012 140734166799520 139941440182288 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21964] ppid=21957 vsize=1046784 CPUtime=0
/proc/21960/task/21964/stat : 21964 (java) S 21957 21957 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 10 0 120668246 1071906816 116721 18446744073709551615 4194304 4228012 140734166799520 139941439129504 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21965] ppid=21957 vsize=1046784 CPUtime=0
/proc/21960/task/21965/stat : 21965 (java) S 21957 21957 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 120668261 1071906816 116721 18446744073709551615 4194304 4228012 140734166799520 139941438077936 139941542085664 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21966] ppid=21957 vsize=1046784 CPUtime=0.51
/proc/21960/task/21966/stat : 21966 (java) S 21957 21957 1750 0 -1 4202560 10055 0 11 0 48 3 0 0 20 0 10 0 120668261 1071906816 116721 18446744073709551615 4194304 4228012 140734166799520 139941437025296 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 10 0 0
[pid=21960/tid=21967] ppid=21957 vsize=1046784 CPUtime=0.46
/proc/21960/task/21967/stat : 21967 (java) S 21957 21957 1750 0 -1 4202560 9677 0 0 0 41 5 0 0 20 0 10 0 120668261 1071906816 116721 18446744073709551615 4194304 4228012 140734166799520 139941435972624 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21968] ppid=21957 vsize=1046784 CPUtime=0
/proc/21960/task/21968/stat : 21968 (java) S 21957 21957 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 120668262 1071906816 116721 18446744073709551615 4194304 4228012 140734166799520 139941434920144 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21969] ppid=21957 vsize=1046784 CPUtime=0
/proc/21960/task/21969/stat : 21969 (java) S 21957 21957 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 120668262 1071906816 116721 18446744073709551615 4194304 4228012 140734166799520 139941433867648 139941542078027 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 4.45
Current children cumulated vsize (KiB) 1055952
heavy processes:

[startup+12.7009 s]
/proc/loadavg: 1.18 1.03 0.99 4/71 21970
/proc/meminfo: memFree=9308/1022884 swapFree=0/0
[pid=21957] ppid=21956 vsize=9168 CPUtime=0
/proc/21957/stat : 21957 (p2cudf-full-1.1) S 21956 21957 1750 0 -1 4202496 452 291 2 1 0 0 0 0 20 0 1 0 120668157 9388032 330 18446744073709551615 4194304 5129932 140737437717344 140737437715488 140473338803294 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/21957/statm: 2292 330 280 229 0 52 0
[pid=21960] ppid=21957 vsize=1047812 CPUtime=10.28
/proc/21960/stat : 21960 (java) S 21957 21957 1750 0 -1 4202496 152767 0 115 0 978 50 0 0 20 0 11 0 120668170 1072959488 146759 18446744073709551615 4194304 4228012 140734166799520 140734166790544 139941542063733 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 21 0 0
/proc/21960/statm: 261953 146759 2379 9 0 249303 0
[pid=21960/tid=21961] ppid=21957 vsize=1047812 CPUtime=4.95
/proc/21960/task/21961/stat : 21961 (java) R 21957 21957 1750 0 -1 4202560 47731 0 61 0 477 18 0 0 20 0 11 0 120668192 1072959488 146759 18446744073709551615 4194304 4228012 140734166799520 139941548597768 139941446084137 0 4 0 16800975 0 0 0 -1 0 0 0 162 0 0
[pid=21960/tid=21962] ppid=21957 vsize=1047812 CPUtime=1.89
/proc/21960/task/21962/stat : 21962 (java) S 21957 21957 1750 0 -1 4202560 83771 0 2 0 166 23 0 0 20 0 11 0 120668237 1072959488 146759 18446744073709551615 4194304 4228012 140734166799520 139941441236096 139941542078027 0 0 0 16800975 0 0 0 -1 0 0 0 15 0 0
[pid=21960/tid=21963] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21963/stat : 21963 (java) S 21957 21957 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120668246 1072959488 146759 18446744073709551615 4194304 4228012 140734166799520 139941440182288 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21964] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21964/stat : 21964 (java) S 21957 21957 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120668246 1072959488 146759 18446744073709551615 4194304 4228012 140734166799520 139941439129504 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21965] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21965/stat : 21965 (java) S 21957 21957 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120668261 1072959488 146759 18446744073709551615 4194304 4228012 140734166799520 139941438077936 139941542085664 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21966] ppid=21957 vsize=1047812 CPUtime=1.71
/proc/21960/task/21966/stat : 21966 (java) S 21957 21957 1750 0 -1 4202560 10190 0 13 0 167 4 0 0 20 0 11 0 120668261 1072959488 146759 18446744073709551615 4194304 4228012 140734166799520 139941437025296 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 14 0 0
[pid=21960/tid=21967] ppid=21957 vsize=1047812 CPUtime=1.7
/proc/21960/task/21967/stat : 21967 (java) S 21957 21957 1750 0 -1 4202560 9810 0 0 0 165 5 0 0 20 0 11 0 120668261 1072959488 146759 18446744073709551615 4194304 4228012 140734166799520 139941435972624 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21968] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21968/stat : 21968 (java) S 21957 21957 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120668262 1072959488 146759 18446744073709551615 4194304 4228012 140734166799520 139941434920144 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21969] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21969/stat : 21969 (java) S 21957 21957 1750 0 -1 4202560 7 0 0 0 0 0 0 0 20 0 11 0 120668262 1072959488 146759 18446744073709551615 4194304 4228012 140734166799520 139941433867648 139941542078027 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21970] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21970/stat : 21970 (java) S 21957 21957 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120669353 1072959488 146759 18446744073709551615 4194304 4228012 140734166799520 139941432670048 139941542078027 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 10.28
Current children cumulated vsize (KiB) 1056980

[startup+25.5009 s]
/proc/loadavg: 1.27 1.06 1.00 2/71 21970
/proc/meminfo: memFree=10052/1022884 swapFree=0/0
[pid=21957] ppid=21956 vsize=9168 CPUtime=0
/proc/21957/stat : 21957 (p2cudf-full-1.1) S 21956 21957 1750 0 -1 4202496 452 291 2 1 0 0 0 0 20 0 1 0 120668157 9388032 330 18446744073709551615 4194304 5129932 140737437717344 140737437715488 140473338803294 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/21957/statm: 2292 330 280 229 0 52 0
[pid=21960] ppid=21957 vsize=1047812 CPUtime=22.8
/proc/21960/stat : 21960 (java) S 21957 21957 1750 0 -1 4202496 161037 0 121 0 2227 53 0 0 20 0 11 0 120668170 1072959488 155035 18446744073709551615 4194304 4228012 140734166799520 140734166790544 139941542063733 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 21 0 0
/proc/21960/statm: 261953 155035 2393 9 0 249303 0
[pid=21960/tid=21961] ppid=21957 vsize=1047812 CPUtime=14.54
/proc/21960/task/21961/stat : 21961 (java) R 21957 21957 1750 0 -1 4202560 47754 0 61 0 1436 18 0 0 20 0 11 0 120668192 1072959488 155035 18446744073709551615 4194304 4228012 140734166799520 139941548597224 139941446904366 0 4 0 16800975 0 0 0 -1 0 0 0 163 0 0
[pid=21960/tid=21962] ppid=21957 vsize=1047812 CPUtime=4.3
/proc/21960/task/21962/stat : 21962 (java) S 21957 21957 1750 0 -1 4202560 92001 0 7 0 405 25 0 0 20 0 11 0 120668237 1072959488 155035 18446744073709551615 4194304 4228012 140734166799520 139941441236096 139941542078027 0 0 0 16800975 0 0 0 -1 0 0 0 22 0 0
[pid=21960/tid=21963] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21963/stat : 21963 (java) S 21957 21957 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120668246 1072959488 155035 18446744073709551615 4194304 4228012 140734166799520 139941440182288 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21964] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21964/stat : 21964 (java) S 21957 21957 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120668246 1072959488 155035 18446744073709551615 4194304 4228012 140734166799520 139941439129504 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21965] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21965/stat : 21965 (java) S 21957 21957 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120668261 1072959488 155035 18446744073709551615 4194304 4228012 140734166799520 139941438077936 139941542085664 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21966] ppid=21957 vsize=1047812 CPUtime=1.98
/proc/21960/task/21966/stat : 21966 (java) S 21957 21957 1750 0 -1 4202560 10200 0 14 0 194 4 0 0 20 0 11 0 120668261 1072959488 155035 18446744073709551615 4194304 4228012 140734166799520 139941437025296 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 16 0 0
[pid=21960/tid=21967] ppid=21957 vsize=1047812 CPUtime=1.94
/proc/21960/task/21967/stat : 21967 (java) S 21957 21957 1750 0 -1 4202560 9817 0 0 0 188 6 0 0 20 0 11 0 120668261 1072959488 155035 18446744073709551615 4194304 4228012 140734166799520 139941435972624 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21968] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21968/stat : 21968 (java) S 21957 21957 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120668262 1072959488 155035 18446744073709551615 4194304 4228012 140734166799520 139941434920144 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21969] ppid=21957 vsize=1047812 CPUtime=0.01
/proc/21960/task/21969/stat : 21969 (java) S 21957 21957 1750 0 -1 4202560 7 0 0 0 1 0 0 0 20 0 11 0 120668262 1072959488 155035 18446744073709551615 4194304 4228012 140734166799520 139941433867648 139941542078027 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21970] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21970/stat : 21970 (java) S 21957 21957 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120669353 1072959488 155035 18446744073709551615 4194304 4228012 140734166799520 139941432670048 139941542078027 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 22.8
Current children cumulated vsize (KiB) 1056980

[startup+51.1006 s]
/proc/loadavg: 1.18 1.06 1.00 2/71 21970
/proc/meminfo: memFree=9680/1022884 swapFree=0/0
[pid=21957] ppid=21956 vsize=9168 CPUtime=0
/proc/21957/stat : 21957 (p2cudf-full-1.1) S 21956 21957 1750 0 -1 4202496 452 291 2 1 0 0 0 0 20 0 1 0 120668157 9388032 330 18446744073709551615 4194304 5129932 140737437717344 140737437715488 140473338803294 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/21957/statm: 2292 330 280 229 0 52 0
[pid=21960] ppid=21957 vsize=1047812 CPUtime=48.07
/proc/21960/stat : 21960 (java) S 21957 21957 1750 0 -1 4202496 161557 0 121 0 4753 54 0 0 20 0 11 0 120668170 1072959488 155551 18446744073709551615 4194304 4228012 140734166799520 140734166790544 139941542063733 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 21 0 0
/proc/21960/statm: 261953 155551 2393 9 0 249303 0
[pid=21960/tid=21961] ppid=21957 vsize=1047812 CPUtime=35.76
/proc/21960/task/21961/stat : 21961 (java) R 21957 21957 1750 0 -1 4202560 47754 0 61 0 3558 18 0 0 20 0 11 0 120668192 1072959488 155551 18446744073709551615 4194304 4228012 140734166799520 139941548597224 139941446577692 0 4 0 16800975 0 0 0 -1 0 0 0 163 0 0
[pid=21960/tid=21962] ppid=21957 vsize=1047812 CPUtime=8.26
/proc/21960/task/21962/stat : 21962 (java) S 21957 21957 1750 0 -1 4202560 92518 0 7 0 800 26 0 0 20 0 11 0 120668237 1072959488 155551 18446744073709551615 4194304 4228012 140734166799520 139941441236096 139941542078027 0 0 0 16800975 0 0 0 -1 0 0 0 22 0 0
[pid=21960/tid=21963] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21963/stat : 21963 (java) S 21957 21957 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120668246 1072959488 155551 18446744073709551615 4194304 4228012 140734166799520 139941440182288 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21964] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21964/stat : 21964 (java) S 21957 21957 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120668246 1072959488 155551 18446744073709551615 4194304 4228012 140734166799520 139941439129504 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21965] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21965/stat : 21965 (java) S 21957 21957 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120668261 1072959488 155551 18446744073709551615 4194304 4228012 140734166799520 139941438077936 139941542085664 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21966] ppid=21957 vsize=1047812 CPUtime=2.02
/proc/21960/task/21966/stat : 21966 (java) S 21957 21957 1750 0 -1 4202560 10200 0 14 0 198 4 0 0 20 0 11 0 120668261 1072959488 155551 18446744073709551615 4194304 4228012 140734166799520 139941437025296 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 16 0 0
[pid=21960/tid=21967] ppid=21957 vsize=1047812 CPUtime=1.98
/proc/21960/task/21967/stat : 21967 (java) S 21957 21957 1750 0 -1 4202560 9817 0 0 0 192 6 0 0 20 0 11 0 120668261 1072959488 155551 18446744073709551615 4194304 4228012 140734166799520 139941435972624 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21968] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21968/stat : 21968 (java) S 21957 21957 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120668262 1072959488 155551 18446744073709551615 4194304 4228012 140734166799520 139941434920144 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21969] ppid=21957 vsize=1047812 CPUtime=0.02
/proc/21960/task/21969/stat : 21969 (java) S 21957 21957 1750 0 -1 4202560 10 0 0 0 2 0 0 0 20 0 11 0 120668262 1072959488 155551 18446744073709551615 4194304 4228012 140734166799520 139941433867648 139941542078027 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21970] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21970/stat : 21970 (java) S 21957 21957 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120669353 1072959488 155551 18446744073709551615 4194304 4228012 140734166799520 139941432670048 139941542078027 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 48.07
Current children cumulated vsize (KiB) 1056980

[startup+102.301 s]
/proc/loadavg: 1.08 1.05 1.00 2/71 21970
/proc/meminfo: memFree=9184/1022884 swapFree=0/0
[pid=21957] ppid=21956 vsize=9168 CPUtime=0
/proc/21957/stat : 21957 (p2cudf-full-1.1) S 21956 21957 1750 0 -1 4202496 452 291 2 1 0 0 0 0 20 0 1 0 120668157 9388032 330 18446744073709551615 4194304 5129932 140737437717344 140737437715488 140473338803294 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/21957/statm: 2292 330 280 229 0 52 0
[pid=21960] ppid=21957 vsize=1047812 CPUtime=98.73
/proc/21960/stat : 21960 (java) S 21957 21957 1750 0 -1 4202496 162903 0 121 0 9819 54 0 0 20 0 11 0 120668170 1072959488 156893 18446744073709551615 4194304 4228012 140734166799520 140734166790544 139941542063733 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 21 0 0
/proc/21960/statm: 261953 156893 2393 9 0 249303 0
[pid=21960/tid=21961] ppid=21957 vsize=1047812 CPUtime=81.73
/proc/21960/task/21961/stat : 21961 (java) R 21957 21957 1750 0 -1 4202560 47754 0 61 0 8155 18 0 0 20 0 11 0 120668192 1072959488 156893 18446744073709551615 4194304 4228012 140734166799520 139941548597224 139941447401800 0 4 0 16800975 0 0 0 -1 0 0 0 163 0 0
[pid=21960/tid=21962] ppid=21957 vsize=1047812 CPUtime=12.92
/proc/21960/task/21962/stat : 21962 (java) S 21957 21957 1750 0 -1 4202560 93861 0 7 0 1266 26 0 0 20 0 11 0 120668237 1072959488 156893 18446744073709551615 4194304 4228012 140734166799520 139941441236096 139941542078027 0 0 0 16800975 0 0 0 -1 0 0 0 22 0 0
[pid=21960/tid=21963] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21963/stat : 21963 (java) S 21957 21957 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120668246 1072959488 156893 18446744073709551615 4194304 4228012 140734166799520 139941440182288 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21964] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21964/stat : 21964 (java) S 21957 21957 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120668246 1072959488 156893 18446744073709551615 4194304 4228012 140734166799520 139941439129504 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21965] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21965/stat : 21965 (java) S 21957 21957 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120668261 1072959488 156893 18446744073709551615 4194304 4228012 140734166799520 139941438077936 139941542085664 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21966] ppid=21957 vsize=1047812 CPUtime=2.02
/proc/21960/task/21966/stat : 21966 (java) S 21957 21957 1750 0 -1 4202560 10200 0 14 0 198 4 0 0 20 0 11 0 120668261 1072959488 156893 18446744073709551615 4194304 4228012 140734166799520 139941437025296 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 16 0 0
[pid=21960/tid=21967] ppid=21957 vsize=1047812 CPUtime=1.99
/proc/21960/task/21967/stat : 21967 (java) S 21957 21957 1750 0 -1 4202560 9817 0 0 0 193 6 0 0 20 0 11 0 120668261 1072959488 156893 18446744073709551615 4194304 4228012 140734166799520 139941435972624 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21968] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21968/stat : 21968 (java) S 21957 21957 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120668262 1072959488 156893 18446744073709551615 4194304 4228012 140734166799520 139941434920144 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21969] ppid=21957 vsize=1047812 CPUtime=0.05
/proc/21960/task/21969/stat : 21969 (java) S 21957 21957 1750 0 -1 4202560 13 0 0 0 5 0 0 0 20 0 11 0 120668262 1072959488 156893 18446744073709551615 4194304 4228012 140734166799520 139941433867648 139941542078027 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21970] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21970/stat : 21970 (java) S 21957 21957 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120669353 1072959488 156893 18446744073709551615 4194304 4228012 140734166799520 139941432670048 139941542078027 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 98.73
Current children cumulated vsize (KiB) 1056980

[startup+162.301 s]
/proc/loadavg: 1.07 1.05 1.00 2/71 21970
/proc/meminfo: memFree=10248/1022884 swapFree=0/0
[pid=21957] ppid=21956 vsize=9168 CPUtime=0
/proc/21957/stat : 21957 (p2cudf-full-1.1) S 21956 21957 1750 0 -1 4202496 452 291 2 1 0 0 0 0 20 0 1 0 120668157 9388032 330 18446744073709551615 4194304 5129932 140737437717344 140737437715488 140473338803294 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/21957/statm: 2292 330 280 229 0 52 0
[pid=21960] ppid=21957 vsize=1047812 CPUtime=158.1
/proc/21960/stat : 21960 (java) S 21957 21957 1750 0 -1 4202496 168890 0 121 0 15755 55 0 0 20 0 11 0 120668170 1072959488 162872 18446744073709551615 4194304 4228012 140734166799520 140734166790544 139941542063733 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 21 0 0
/proc/21960/statm: 261953 162872 2393 9 0 249303 0
[pid=21960/tid=21961] ppid=21957 vsize=1047812 CPUtime=137.97
/proc/21960/task/21961/stat : 21961 (java) R 21957 21957 1750 0 -1 4202560 47754 0 61 0 13779 18 0 0 20 0 11 0 120668192 1072959488 162872 18446744073709551615 4194304 4228012 140734166799520 139941548597224 139941446593879 0 4 0 16800975 0 0 0 -1 0 0 0 163 0 0
[pid=21960/tid=21962] ppid=21957 vsize=1047812 CPUtime=16.01
/proc/21960/task/21962/stat : 21962 (java) S 21957 21957 1750 0 -1 4202560 99842 0 7 0 1575 26 0 0 20 0 11 0 120668237 1072959488 162872 18446744073709551615 4194304 4228012 140734166799520 139941441236096 139941542078027 0 0 0 16800975 0 0 0 -1 0 0 0 22 0 0
[pid=21960/tid=21963] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21963/stat : 21963 (java) S 21957 21957 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120668246 1072959488 162872 18446744073709551615 4194304 4228012 140734166799520 139941440182288 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21964] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21964/stat : 21964 (java) S 21957 21957 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120668246 1072959488 162872 18446744073709551615 4194304 4228012 140734166799520 139941439129504 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21965] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21965/stat : 21965 (java) S 21957 21957 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120668261 1072959488 162872 18446744073709551615 4194304 4228012 140734166799520 139941438077936 139941542085664 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21966] ppid=21957 vsize=1047812 CPUtime=2.02
/proc/21960/task/21966/stat : 21966 (java) S 21957 21957 1750 0 -1 4202560 10200 0 14 0 198 4 0 0 20 0 11 0 120668261 1072959488 162872 18446744073709551615 4194304 4228012 140734166799520 139941437025296 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 16 0 0
[pid=21960/tid=21967] ppid=21957 vsize=1047812 CPUtime=1.99
/proc/21960/task/21967/stat : 21967 (java) S 21957 21957 1750 0 -1 4202560 9817 0 0 0 193 6 0 0 20 0 11 0 120668261 1072959488 162872 18446744073709551615 4194304 4228012 140734166799520 139941435972624 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21968] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21968/stat : 21968 (java) S 21957 21957 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120668262 1072959488 162872 18446744073709551615 4194304 4228012 140734166799520 139941434920144 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21969] ppid=21957 vsize=1047812 CPUtime=0.08
/proc/21960/task/21969/stat : 21969 (java) S 21957 21957 1750 0 -1 4202560 19 0 0 0 8 0 0 0 20 0 11 0 120668262 1072959488 162872 18446744073709551615 4194304 4228012 140734166799520 139941433867648 139941542078027 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21970] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21970/stat : 21970 (java) S 21957 21957 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120669353 1072959488 162872 18446744073709551615 4194304 4228012 140734166799520 139941432670048 139941542078027 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 158.1
Current children cumulated vsize (KiB) 1056980

[startup+222.304 s]
/proc/loadavg: 1.02 1.04 1.00 2/71 21970
/proc/meminfo: memFree=10248/1022884 swapFree=0/0
[pid=21957] ppid=21956 vsize=9168 CPUtime=0
/proc/21957/stat : 21957 (p2cudf-full-1.1) S 21956 21957 1750 0 -1 4202496 452 291 2 1 0 0 0 0 20 0 1 0 120668157 9388032 330 18446744073709551615 4194304 5129932 140737437717344 140737437715488 140473338803294 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/21957/statm: 2292 330 280 229 0 52 0
[pid=21960] ppid=21957 vsize=1047812 CPUtime=217.5
/proc/21960/stat : 21960 (java) S 21957 21957 1750 0 -1 4202496 168897 0 121 0 21695 55 0 0 20 0 11 0 120668170 1072959488 162872 18446744073709551615 4194304 4228012 140734166799520 140734166790544 139941542063733 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 21 0 0
/proc/21960/statm: 261953 162872 2393 9 0 249303 0
[pid=21960/tid=21961] ppid=21957 vsize=1047812 CPUtime=195.07
/proc/21960/task/21961/stat : 21961 (java) R 21957 21957 1750 0 -1 4202560 47754 0 61 0 19489 18 0 0 20 0 11 0 120668192 1072959488 162872 18446744073709551615 4194304 4228012 140734166799520 139941548597224 139941447425473 0 4 0 16800975 0 0 0 -1 0 0 0 163 0 0
[pid=21960/tid=21962] ppid=21957 vsize=1047812 CPUtime=18.3
/proc/21960/task/21962/stat : 21962 (java) S 21957 21957 1750 0 -1 4202560 99843 0 7 0 1803 27 0 0 20 0 11 0 120668237 1072959488 162872 18446744073709551615 4194304 4228012 140734166799520 139941441236096 139941542078027 0 0 0 16800975 0 0 0 -1 0 0 0 22 0 0
[pid=21960/tid=21963] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21963/stat : 21963 (java) S 21957 21957 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120668246 1072959488 162872 18446744073709551615 4194304 4228012 140734166799520 139941440182288 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21964] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21964/stat : 21964 (java) S 21957 21957 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120668246 1072959488 162872 18446744073709551615 4194304 4228012 140734166799520 139941439129504 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21965] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21965/stat : 21965 (java) S 21957 21957 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120668261 1072959488 162872 18446744073709551615 4194304 4228012 140734166799520 139941438077936 139941542085664 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21966] ppid=21957 vsize=1047812 CPUtime=2.02
/proc/21960/task/21966/stat : 21966 (java) S 21957 21957 1750 0 -1 4202560 10200 0 14 0 198 4 0 0 20 0 11 0 120668261 1072959488 162872 18446744073709551615 4194304 4228012 140734166799520 139941437025296 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 16 0 0
[pid=21960/tid=21967] ppid=21957 vsize=1047812 CPUtime=1.99
/proc/21960/task/21967/stat : 21967 (java) S 21957 21957 1750 0 -1 4202560 9817 0 0 0 193 6 0 0 20 0 11 0 120668261 1072959488 162872 18446744073709551615 4194304 4228012 140734166799520 139941435972624 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21968] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21968/stat : 21968 (java) S 21957 21957 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120668262 1072959488 162872 18446744073709551615 4194304 4228012 140734166799520 139941434920144 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21969] ppid=21957 vsize=1047812 CPUtime=0.1
/proc/21960/task/21969/stat : 21969 (java) S 21957 21957 1750 0 -1 4202560 25 0 0 0 10 0 0 0 20 0 11 0 120668262 1072959488 162872 18446744073709551615 4194304 4228012 140734166799520 139941433867648 139941542078027 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21970] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21970/stat : 21970 (java) S 21957 21957 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120669353 1072959488 162872 18446744073709551615 4194304 4228012 140734166799520 139941432670048 139941542078027 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 217.5
Current children cumulated vsize (KiB) 1056980

[startup+282.301 s]
/proc/loadavg: 1.06 1.04 1.00 2/71 21970
/proc/meminfo: memFree=10248/1022884 swapFree=0/0
[pid=21957] ppid=21956 vsize=9168 CPUtime=0
/proc/21957/stat : 21957 (p2cudf-full-1.1) S 21956 21957 1750 0 -1 4202496 452 291 2 1 0 0 0 0 20 0 1 0 120668157 9388032 330 18446744073709551615 4194304 5129932 140737437717344 140737437715488 140473338803294 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/21957/statm: 2292 330 280 229 0 52 0
[pid=21960] ppid=21957 vsize=1047812 CPUtime=276.81
/proc/21960/stat : 21960 (java) S 21957 21957 1750 0 -1 4202496 168951 0 121 0 27626 55 0 0 20 0 11 0 120668170 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 140734166790544 139941542063733 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 21 0 0
/proc/21960/statm: 261953 162917 2393 9 0 249303 0
[pid=21960/tid=21961] ppid=21957 vsize=1047812 CPUtime=250.21
/proc/21960/task/21961/stat : 21961 (java) R 21957 21957 1750 0 -1 4202560 47754 0 61 0 25003 18 0 0 20 0 11 0 120668192 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941548597224 139941447459763 0 4 0 16800975 0 0 0 -1 0 0 0 163 0 0
[pid=21960/tid=21962] ppid=21957 vsize=1047812 CPUtime=22.41
/proc/21960/task/21962/stat : 21962 (java) S 21957 21957 1750 0 -1 4202560 99891 0 7 0 2214 27 0 0 20 0 11 0 120668237 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941441236096 139941542078027 0 0 0 16800975 0 0 0 -1 0 0 0 22 0 0
[pid=21960/tid=21963] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21963/stat : 21963 (java) S 21957 21957 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120668246 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941440182288 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21964] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21964/stat : 21964 (java) S 21957 21957 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120668246 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941439129504 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21965] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21965/stat : 21965 (java) S 21957 21957 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120668261 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941438077936 139941542085664 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21966] ppid=21957 vsize=1047812 CPUtime=2.04
/proc/21960/task/21966/stat : 21966 (java) S 21957 21957 1750 0 -1 4202560 10200 0 14 0 200 4 0 0 20 0 11 0 120668261 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941437025296 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 16 0 0
[pid=21960/tid=21967] ppid=21957 vsize=1047812 CPUtime=1.99
/proc/21960/task/21967/stat : 21967 (java) S 21957 21957 1750 0 -1 4202560 9817 0 0 0 193 6 0 0 20 0 11 0 120668261 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941435972624 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21968] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21968/stat : 21968 (java) S 21957 21957 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120668262 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941434920144 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21969] ppid=21957 vsize=1047812 CPUtime=0.13
/proc/21960/task/21969/stat : 21969 (java) S 21957 21957 1750 0 -1 4202560 31 0 0 0 13 0 0 0 20 0 11 0 120668262 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941433867648 139941542078027 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21970] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21970/stat : 21970 (java) S 21957 21957 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120669353 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941432670048 139941542078027 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 276.81
Current children cumulated vsize (KiB) 1056980

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

[startup+288.001 s]
/proc/loadavg: 1.05 1.04 1.00 2/71 21970
/proc/meminfo: memFree=10248/1022884 swapFree=0/0
[pid=21957] ppid=21956 vsize=9168 CPUtime=0
/proc/21957/stat : 21957 (p2cudf-full-1.1) S 21956 21957 1750 0 -1 4202496 452 291 2 1 0 0 0 0 20 0 1 0 120668157 9388032 330 18446744073709551615 4194304 5129932 140737437717344 140737437715488 140473338803294 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/21957/statm: 2292 330 280 229 0 52 0
[pid=21960] ppid=21957 vsize=1047812 CPUtime=282.43
/proc/21960/stat : 21960 (java) S 21957 21957 1750 0 -1 4202496 168951 0 121 0 28188 55 0 0 20 0 11 0 120668170 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 140734166790544 139941542063733 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 21 0 0
/proc/21960/statm: 261953 162917 2393 9 0 249303 0
[pid=21960/tid=21961] ppid=21957 vsize=1047812 CPUtime=255.83
/proc/21960/task/21961/stat : 21961 (java) R 21957 21957 1750 0 -1 4202560 47754 0 61 0 25565 18 0 0 20 0 11 0 120668192 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941548597224 139941447035124 0 4 0 16800975 0 0 0 -1 0 0 0 163 0 0
[pid=21960/tid=21962] ppid=21957 vsize=1047812 CPUtime=22.41
/proc/21960/task/21962/stat : 21962 (java) S 21957 21957 1750 0 -1 4202560 99891 0 7 0 2214 27 0 0 20 0 11 0 120668237 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941441236096 139941542078027 0 0 0 16800975 0 0 0 -1 0 0 0 22 0 0
[pid=21960/tid=21963] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21963/stat : 21963 (java) S 21957 21957 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120668246 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941440182288 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21964] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21964/stat : 21964 (java) S 21957 21957 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120668246 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941439129504 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21965] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21965/stat : 21965 (java) S 21957 21957 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120668261 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941438077936 139941542085664 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21966] ppid=21957 vsize=1047812 CPUtime=2.04
/proc/21960/task/21966/stat : 21966 (java) S 21957 21957 1750 0 -1 4202560 10200 0 14 0 200 4 0 0 20 0 11 0 120668261 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941437025296 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 16 0 0
[pid=21960/tid=21967] ppid=21957 vsize=1047812 CPUtime=1.99
/proc/21960/task/21967/stat : 21967 (java) S 21957 21957 1750 0 -1 4202560 9817 0 0 0 193 6 0 0 20 0 11 0 120668261 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941435972624 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21968] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21968/stat : 21968 (java) S 21957 21957 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120668262 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941434920144 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21969] ppid=21957 vsize=1047812 CPUtime=0.13
/proc/21960/task/21969/stat : 21969 (java) S 21957 21957 1750 0 -1 4202560 31 0 0 0 13 0 0 0 20 0 11 0 120668262 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941433867648 139941542078027 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21970] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21970/stat : 21970 (java) S 21957 21957 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120669353 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941432670048 139941542078027 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 282.43
Current children cumulated vsize (KiB) 1056980

[startup+294.401 s]
/proc/loadavg: 1.04 1.04 1.00 2/71 21970
/proc/meminfo: memFree=10248/1022884 swapFree=0/0
[pid=21957] ppid=21956 vsize=9168 CPUtime=0
/proc/21957/stat : 21957 (p2cudf-full-1.1) S 21956 21957 1750 0 -1 4202496 452 291 2 1 0 0 0 0 20 0 1 0 120668157 9388032 330 18446744073709551615 4194304 5129932 140737437717344 140737437715488 140473338803294 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/21957/statm: 2292 330 280 229 0 52 0
[pid=21960] ppid=21957 vsize=1047812 CPUtime=288.74
/proc/21960/stat : 21960 (java) S 21957 21957 1750 0 -1 4202496 168951 0 121 0 28819 55 0 0 20 0 11 0 120668170 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 140734166790544 139941542063733 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 21 0 0
/proc/21960/statm: 261953 162917 2393 9 0 249303 0
[pid=21960/tid=21961] ppid=21957 vsize=1047812 CPUtime=262.14
/proc/21960/task/21961/stat : 21961 (java) R 21957 21957 1750 0 -1 4202560 47754 0 61 0 26196 18 0 0 20 0 11 0 120668192 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941548597224 139941447466548 0 4 0 16800975 0 0 0 -1 0 0 0 163 0 0
[pid=21960/tid=21962] ppid=21957 vsize=1047812 CPUtime=22.41
/proc/21960/task/21962/stat : 21962 (java) S 21957 21957 1750 0 -1 4202560 99891 0 7 0 2214 27 0 0 20 0 11 0 120668237 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941441236096 139941542078027 0 0 0 16800975 0 0 0 -1 0 0 0 22 0 0
[pid=21960/tid=21963] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21963/stat : 21963 (java) S 21957 21957 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120668246 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941440182288 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21964] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21964/stat : 21964 (java) S 21957 21957 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120668246 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941439129504 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21965] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21965/stat : 21965 (java) S 21957 21957 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120668261 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941438077936 139941542085664 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21966] ppid=21957 vsize=1047812 CPUtime=2.04
/proc/21960/task/21966/stat : 21966 (java) S 21957 21957 1750 0 -1 4202560 10200 0 14 0 200 4 0 0 20 0 11 0 120668261 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941437025296 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 16 0 0
[pid=21960/tid=21967] ppid=21957 vsize=1047812 CPUtime=1.99
/proc/21960/task/21967/stat : 21967 (java) S 21957 21957 1750 0 -1 4202560 9817 0 0 0 193 6 0 0 20 0 11 0 120668261 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941435972624 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21968] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21968/stat : 21968 (java) S 21957 21957 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120668262 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941434920144 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21969] ppid=21957 vsize=1047812 CPUtime=0.14
/proc/21960/task/21969/stat : 21969 (java) S 21957 21957 1750 0 -1 4202560 31 0 0 0 14 0 0 0 20 0 11 0 120668262 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941433867648 139941542078027 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21970] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21970/stat : 21970 (java) S 21957 21957 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120669353 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941432670048 139941542078027 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 288.74
Current children cumulated vsize (KiB) 1056980

[startup+296.006 s]
/proc/loadavg: 1.04 1.04 1.00 2/71 21970
/proc/meminfo: memFree=10248/1022884 swapFree=0/0
[pid=21957] ppid=21956 vsize=9168 CPUtime=0
/proc/21957/stat : 21957 (p2cudf-full-1.1) S 21956 21957 1750 0 -1 4202496 452 291 2 1 0 0 0 0 20 0 1 0 120668157 9388032 330 18446744073709551615 4194304 5129932 140737437717344 140737437715488 140473338803294 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/21957/statm: 2292 330 280 229 0 52 0
[pid=21960] ppid=21957 vsize=1047812 CPUtime=290.32
/proc/21960/stat : 21960 (java) S 21957 21957 1750 0 -1 4202496 168951 0 121 0 28977 55 0 0 20 0 11 0 120668170 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 140734166790544 139941542063733 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 21 0 0
/proc/21960/statm: 261953 162917 2393 9 0 249303 0
[pid=21960/tid=21961] ppid=21957 vsize=1047812 CPUtime=263.72
/proc/21960/task/21961/stat : 21961 (java) R 21957 21957 1750 0 -1 4202560 47754 0 61 0 26354 18 0 0 20 0 11 0 120668192 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941548597224 139941446904351 0 4 0 16800975 0 0 0 -1 0 0 0 163 0 0
[pid=21960/tid=21962] ppid=21957 vsize=1047812 CPUtime=22.41
/proc/21960/task/21962/stat : 21962 (java) S 21957 21957 1750 0 -1 4202560 99891 0 7 0 2214 27 0 0 20 0 11 0 120668237 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941441236096 139941542078027 0 0 0 16800975 0 0 0 -1 0 0 0 22 0 0
[pid=21960/tid=21963] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21963/stat : 21963 (java) S 21957 21957 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120668246 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941440182288 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21964] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21964/stat : 21964 (java) S 21957 21957 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120668246 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941439129504 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21965] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21965/stat : 21965 (java) S 21957 21957 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120668261 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941438077936 139941542085664 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21966] ppid=21957 vsize=1047812 CPUtime=2.04
/proc/21960/task/21966/stat : 21966 (java) S 21957 21957 1750 0 -1 4202560 10200 0 14 0 200 4 0 0 20 0 11 0 120668261 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941437025296 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 16 0 0
[pid=21960/tid=21967] ppid=21957 vsize=1047812 CPUtime=1.99
/proc/21960/task/21967/stat : 21967 (java) S 21957 21957 1750 0 -1 4202560 9817 0 0 0 193 6 0 0 20 0 11 0 120668261 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941435972624 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21968] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21968/stat : 21968 (java) S 21957 21957 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120668262 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941434920144 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21969] ppid=21957 vsize=1047812 CPUtime=0.14
/proc/21960/task/21969/stat : 21969 (java) S 21957 21957 1750 0 -1 4202560 31 0 0 0 14 0 0 0 20 0 11 0 120668262 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941433867648 139941542078027 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21970] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21970/stat : 21970 (java) S 21957 21957 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120669353 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941432670048 139941542078027 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 290.32
Current children cumulated vsize (KiB) 1056980

[startup+296.801 s]
/proc/loadavg: 1.04 1.04 1.00 2/71 21970
/proc/meminfo: memFree=10248/1022884 swapFree=0/0
[pid=21957] ppid=21956 vsize=9168 CPUtime=0
/proc/21957/stat : 21957 (p2cudf-full-1.1) S 21956 21957 1750 0 -1 4202496 452 291 2 1 0 0 0 0 20 0 1 0 120668157 9388032 330 18446744073709551615 4194304 5129932 140737437717344 140737437715488 140473338803294 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/21957/statm: 2292 330 280 229 0 52 0
[pid=21960] ppid=21957 vsize=1047812 CPUtime=291.11
/proc/21960/stat : 21960 (java) S 21957 21957 1750 0 -1 4202496 168951 0 121 0 29056 55 0 0 20 0 11 0 120668170 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 140734166790544 139941542063733 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 21 0 0
/proc/21960/statm: 261953 162917 2393 9 0 249303 0
[pid=21960/tid=21961] ppid=21957 vsize=1047812 CPUtime=264.5
/proc/21960/task/21961/stat : 21961 (java) R 21957 21957 1750 0 -1 4202560 47754 0 61 0 26432 18 0 0 20 0 11 0 120668192 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941548597224 139941447460240 0 4 0 16800975 0 0 0 -1 0 0 0 163 0 0
[pid=21960/tid=21962] ppid=21957 vsize=1047812 CPUtime=22.41
/proc/21960/task/21962/stat : 21962 (java) S 21957 21957 1750 0 -1 4202560 99891 0 7 0 2214 27 0 0 20 0 11 0 120668237 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941441236096 139941542078027 0 0 0 16800975 0 0 0 -1 0 0 0 22 0 0
[pid=21960/tid=21963] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21963/stat : 21963 (java) S 21957 21957 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120668246 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941440182288 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21964] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21964/stat : 21964 (java) S 21957 21957 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120668246 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941439129504 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21965] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21965/stat : 21965 (java) S 21957 21957 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120668261 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941438077936 139941542085664 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21966] ppid=21957 vsize=1047812 CPUtime=2.04
/proc/21960/task/21966/stat : 21966 (java) S 21957 21957 1750 0 -1 4202560 10200 0 14 0 200 4 0 0 20 0 11 0 120668261 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941437025296 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 16 0 0
[pid=21960/tid=21967] ppid=21957 vsize=1047812 CPUtime=1.99
/proc/21960/task/21967/stat : 21967 (java) S 21957 21957 1750 0 -1 4202560 9817 0 0 0 193 6 0 0 20 0 11 0 120668261 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941435972624 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21968] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21968/stat : 21968 (java) S 21957 21957 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120668262 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941434920144 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21969] ppid=21957 vsize=1047812 CPUtime=0.14
/proc/21960/task/21969/stat : 21969 (java) S 21957 21957 1750 0 -1 4202560 31 0 0 0 14 0 0 0 20 0 11 0 120668262 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941433867648 139941542078027 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21970] ppid=21957 vsize=1047812 CPUtime=0
/proc/21960/task/21970/stat : 21970 (java) S 21957 21957 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120669353 1072959488 162917 18446744073709551615 4194304 4228012 140734166799520 139941432670048 139941542078027 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 291.11
Current children cumulated vsize (KiB) 1056980

[startup+297.601 s]
/proc/loadavg: 1.04 1.04 1.00 3/71 21970
/proc/meminfo: memFree=10248/1022884 swapFree=0/0
[pid=21957] ppid=21956 vsize=9168 CPUtime=0
/proc/21957/stat : 21957 (p2cudf-full-1.1) S 21956 21957 1750 0 -1 4202496 452 291 2 1 0 0 0 0 20 0 1 0 120668157 9388032 330 18446744073709551615 4194304 5129932 140737437717344 140737437715488 140473338803294 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/21957/statm: 2292 330 280 229 0 52 0
[pid=21960] ppid=21957 vsize=1048840 CPUtime=291.39
/proc/21960/stat : 21960 (java) S 21957 21957 1750 0 -1 4202496 168965 0 121 0 29084 55 0 0 20 0 11 0 120668170 1074012160 162929 18446744073709551615 4194304 4228012 140734166799520 140734166790544 139941542063733 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 21 0 0
/proc/21960/statm: 262210 162929 2393 9 0 249560 0
[pid=21960/tid=21961] ppid=21957 vsize=1048840 CPUtime=264.71
/proc/21960/task/21961/stat : 21961 (java) S 21957 21957 1750 0 -1 4202560 47762 0 61 0 26453 18 0 0 20 0 11 0 120668192 1074012160 162929 18446744073709551615 4194304 4228012 140734166799520 139941548598192 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 165 0 0
[pid=21960/tid=21962] ppid=21957 vsize=1048840 CPUtime=22.41
/proc/21960/task/21962/stat : 21962 (java) S 21957 21957 1750 0 -1 4202560 99891 0 7 0 2214 27 0 0 20 0 11 0 120668237 1074012160 162929 18446744073709551615 4194304 4228012 140734166799520 139941441236096 139941542078027 0 0 0 16800975 0 0 0 -1 0 0 0 22 0 0
[pid=21960/tid=21963] ppid=21957 vsize=1048840 CPUtime=0
/proc/21960/task/21963/stat : 21963 (java) S 21957 21957 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120668246 1074012160 162929 18446744073709551615 4194304 4228012 140734166799520 139941440182288 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21964] ppid=21957 vsize=1048840 CPUtime=0
/proc/21960/task/21964/stat : 21964 (java) S 21957 21957 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120668246 1074012160 162929 18446744073709551615 4194304 4228012 140734166799520 139941439129504 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21965] ppid=21957 vsize=1048840 CPUtime=0
/proc/21960/task/21965/stat : 21965 (java) S 21957 21957 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120668261 1074012160 162929 18446744073709551615 4194304 4228012 140734166799520 139941438077936 139941542085664 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21966] ppid=21957 vsize=1048840 CPUtime=2.06
/proc/21960/task/21966/stat : 21966 (java) S 21957 21957 1750 0 -1 4202560 10200 0 14 0 202 4 0 0 20 0 11 0 120668261 1074012160 162929 18446744073709551615 4194304 4228012 140734166799520 139941437025128 139941542087916 0 4 0 16800975 0 0 0 -1 0 0 0 16 0 0
[pid=21960/tid=21967] ppid=21957 vsize=1048840 CPUtime=2.01
/proc/21960/task/21967/stat : 21967 (java) R 21957 21957 1750 0 -1 4202560 9817 0 0 0 195 6 0 0 20 0 11 0 120668261 1074012160 162929 18446744073709551615 4194304 4228012 140734166799520 139941435972368 139941525779912 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21968] ppid=21957 vsize=1048840 CPUtime=0
/proc/21960/task/21968/stat : 21968 (java) S 21957 21957 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120668262 1074012160 162929 18446744073709551615 4194304 4228012 140734166799520 139941434920144 139941542077140 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=21960/tid=21969] ppid=21957 vsize=1048840 CPUtime=0.14
/proc/21960/task/21969/stat : 21969 (java) S 21957 21957 1750 0 -1 4202560 31 0 0 0 14 0 0 0 20 0 11 0 120668262 1074012160 162929 18446744073709551615 4194304 4228012 140734166799520 139941433867648 139941542078027 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 291.39
Current children cumulated vsize (KiB) 1058008

[startup+297.801 s]
/proc/loadavg: 1.04 1.04 1.00 3/71 21970
/proc/meminfo: memFree=10248/1022884 swapFree=0/0
[pid=21957] ppid=21956 vsize=9168 CPUtime=0
/proc/21957/stat : 21957 (p2cudf-full-1.1) S 21956 21957 1750 0 -1 4202496 452 291 2 1 0 0 0 0 20 0 1 0 120668157 9388032 330 18446744073709551615 4194304 5129932 140737437717344 140737437715488 140473338803294 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/21957/statm: 2292 330 280 229 0 52 0
[pid=21960] ppid=21957 vsize=0 CPUtime=291.56
/proc/21960/stat : 21960 (java) Z 21957 21957 1750 0 -1 4203532 168977 0 122 0 29092 64 0 0 20 0 2 0 120668170 0 0 18446744073709551615 0 0 0 0 0 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 21 0 0
/proc/21960/statm: 0 0 0 0 0 0 0
Current children cumulated CPU time (s) 291.56
Current children cumulated vsize (KiB) 9168

Child status: 0
Real time (s): 297.802
CPU time (s): 291.578
CPU user time (s): 290.93
CPU system time (s): 0.64804
CPU usage (%): 97.9101
Max. virtual memory (cumulated for all children) (KiB): 1059276

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 290.93
system time used= 0.64804
maximum resident set size= 651760
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 169733
page faults= 125
swaps= 0
block input operations= 103648
block output operations= 616
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 8137
involuntary context switches= 41538

runsolver used 0.956059 second user time and 1.72011 second system time

The end