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: /home/misc2010/bin/runsolver -s SIGUSR1 -M 1124 -C 290 -d 10 -w /home/misc2010/tmp/201109011757/gj-user-solver-1.0/5698a62c-c731-11df-9bb9-00163e3d3b7c.cudf.dudf-real.log.runsolver ./gj-user-solver-1.0 /home/misc2010/data/2011/dudf-real//5698a62c-c731-11df-9bb9-00163e3d3b7c.cudf /home/misc2010/tmp/201109011757/gj-user-solver-1.0/5698a62c-c731-11df-9bb9-00163e3d3b7c.cudf.dudf-real.result -sum(pin-priority-1),-sum(pin-priority-500),-sum(pin-priority-700),-notuptodate,-removed,-changed 

Enforcing CPUTime limit (soft limit, will send signal-name then SIGKILL): 290 seconds
Enforcing CPUTime limit (hard limit, will send SIGXCPU): 320 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.00 1.05 1.01 4/35 30221
/proc/meminfo: memFree=557364/1048576 swapFree=0/0
[pid=30219] ppid=30218 vsize=2568 CPUtime=0.01
/proc/30219/stat : 30219 (gj-user-solver-) S 30218 30219 22717 34817 22717 4202496 371 0 0 0 0 1 0 0 22 0 1 0 72724556 2629632 268 1283457024 134512640 135304128 4292042416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/30219/statm: 642 268 229 194 0 29 0
[pid=30220] ppid=30219 vsize=11356 CPUtime=0
/proc/30220/stat : 30220 (java) S 30219 30219 22717 34817 22717 4202496 918 0 0 0 0 0 0 0 22 0 2 0 72724556 11628544 651 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 0 0 0 18446744073709551615 0 0 17 0 0 0 0
/proc/30220/statm: 2839 651 285 10 0 1185 0
[pid=30220/tid=30221] ppid=30219 vsize=11356 CPUtime=0
/proc/30220/task/30221/stat : 30221 (java) R 30219 30219 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 25 0 2 0 72724556 11628544 651 1283457024 134512640 134550932 4291491216 18446744073709551615 4159757928 0 0 0 0 0 0 0 -1 0 0 0 0

[startup+0.121499 s]
/proc/loadavg: 1.00 1.05 1.01 4/35 30221
/proc/meminfo: memFree=557364/1048576 swapFree=0/0
[pid=30219] ppid=30218 vsize=2568 CPUtime=0.01
/proc/30219/stat : 30219 (gj-user-solver-) S 30218 30219 22717 34817 22717 4202496 371 0 0 0 0 1 0 0 22 0 1 0 72724556 2629632 268 1283457024 134512640 135304128 4292042416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/30219/statm: 642 268 229 194 0 29 0
[pid=30220] ppid=30219 vsize=410200 CPUtime=0.12
/proc/30220/stat : 30220 (java) S 30219 30219 22717 34817 22717 4202496 4116 0 1 0 12 0 0 0 22 0 9 0 72724556 420044800 3543 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30220/statm: 102550 3543 1946 10 0 96698 0
[pid=30220/tid=30221] ppid=30219 vsize=410200 CPUtime=0.11
/proc/30220/task/30221/stat : 30221 (java) R 30219 30219 22717 34817 22717 4202560 2916 0 1 0 11 0 0 0 25 0 9 0 72724556 420044800 3543 1283457024 134512640 134550932 4291491216 18446744073709551615 4115097918 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 0.13
Current children cumulated vsize (KiB) 412768

[startup+0.21151 s]
/proc/loadavg: 1.00 1.05 1.01 4/35 30221
/proc/meminfo: memFree=557364/1048576 swapFree=0/0
[pid=30219] ppid=30218 vsize=2568 CPUtime=0.01
/proc/30219/stat : 30219 (gj-user-solver-) S 30218 30219 22717 34817 22717 4202496 371 0 0 0 0 1 0 0 22 0 1 0 72724556 2629632 268 1283457024 134512640 135304128 4292042416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/30219/statm: 642 268 229 194 0 29 0
[pid=30220] ppid=30219 vsize=410200 CPUtime=0.2
/proc/30220/stat : 30220 (java) S 30219 30219 22717 34817 22717 4202496 4694 0 1 0 20 0 0 0 22 0 9 0 72724556 420044800 4121 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30220/statm: 102550 4121 1946 10 0 96698 0
[pid=30220/tid=30221] ppid=30219 vsize=410200 CPUtime=0.2
/proc/30220/task/30221/stat : 30221 (java) R 30219 30219 22717 34817 22717 4202560 3494 0 1 0 20 0 0 0 25 0 9 0 72724556 420044800 4121 1283457024 134512640 134550932 4291491216 18446744073709551615 4151859160 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 0.21
Current children cumulated vsize (KiB) 412768

[startup+0.311525 s]
/proc/loadavg: 1.00 1.05 1.01 4/35 30221
/proc/meminfo: memFree=557364/1048576 swapFree=0/0
[pid=30219] ppid=30218 vsize=2568 CPUtime=0.01
/proc/30219/stat : 30219 (gj-user-solver-) S 30218 30219 22717 34817 22717 4202496 371 0 0 0 0 1 0 0 22 0 1 0 72724556 2629632 268 1283457024 134512640 135304128 4292042416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/30219/statm: 642 268 229 194 0 29 0
[pid=30220] ppid=30219 vsize=410200 CPUtime=0.3
/proc/30220/stat : 30220 (java) S 30219 30219 22717 34817 22717 4202496 5309 0 1 0 30 0 0 0 22 0 9 0 72724556 420044800 4735 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30220/statm: 102550 4735 1952 10 0 96698 0
[pid=30220/tid=30221] ppid=30219 vsize=410200 CPUtime=0.28
/proc/30220/task/30221/stat : 30221 (java) R 30219 30219 22717 34817 22717 4202560 3529 0 1 0 28 0 0 0 25 0 9 0 72724556 420044800 4735 1283457024 134512640 134550932 4291491216 18446744073709551615 4115100561 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 0.31
Current children cumulated vsize (KiB) 412768

[startup+0.711602 s]
/proc/loadavg: 1.00 1.05 1.01 4/35 30221
/proc/meminfo: memFree=557364/1048576 swapFree=0/0
[pid=30219] ppid=30218 vsize=2568 CPUtime=0.01
/proc/30219/stat : 30219 (gj-user-solver-) S 30218 30219 22717 34817 22717 4202496 371 0 0 0 0 1 0 0 22 0 1 0 72724556 2629632 268 1283457024 134512640 135304128 4292042416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/30219/statm: 642 268 229 194 0 29 0
[pid=30220] ppid=30219 vsize=410752 CPUtime=0.7
/proc/30220/stat : 30220 (java) S 30219 30219 22717 34817 22717 4202496 12893 0 1 0 67 3 0 0 22 0 9 0 72724556 420610048 12133 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30220/statm: 102688 12133 2901 10 0 96836 0
[pid=30220/tid=30221] ppid=30219 vsize=410752 CPUtime=0.48
/proc/30220/task/30221/stat : 30221 (java) R 30219 30219 22717 34817 22717 4202560 4218 0 1 0 48 0 0 0 25 0 9 0 72724556 420610048 12133 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 0.71
Current children cumulated vsize (KiB) 413320

[startup+1.51171 s]
/proc/loadavg: 1.00 1.05 1.01 2/43 30229
/proc/meminfo: memFree=499504/1048576 swapFree=0/0
[pid=30219] ppid=30218 vsize=2568 CPUtime=0.01
/proc/30219/stat : 30219 (gj-user-solver-) S 30218 30219 22717 34817 22717 4202496 371 0 0 0 0 1 0 0 22 0 1 0 72724556 2629632 268 1283457024 134512640 135304128 4292042416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/30219/statm: 642 268 229 194 0 29 0
[pid=30220] ppid=30219 vsize=410752 CPUtime=1.5
/proc/30220/stat : 30220 (java) S 30219 30219 22717 34817 22717 4202496 27383 0 1 0 143 7 0 0 22 0 9 0 72724556 420610048 26623 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30220/statm: 102688 26623 2901 10 0 96836 0
[pid=30220/tid=30221] ppid=30219 vsize=410752 CPUtime=0.81
/proc/30220/task/30221/stat : 30221 (java) R 30219 30219 22717 34817 22717 4202560 6794 0 1 0 79 2 0 0 24 0 9 0 72724556 420610048 26623 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=30220/tid=30223] ppid=30219 vsize=410752 CPUtime=0.65
/proc/30220/task/30223/stat : 30223 (java) R 30219 30219 22717 34817 22717 4202560 19210 0 0 0 60 5 0 0 18 0 9 0 72724557 420610048 26623 1283457024 134512640 134550932 4291491216 18446744073709551615 4151136418 0 0 0 16800975 0 0 0 -1 0 0 0 0
[pid=30220/tid=30224] ppid=30219 vsize=410752 CPUtime=0
/proc/30220/task/30224/stat : 30224 (java) S 30219 30219 22717 34817 22717 4202560 15 0 0 0 0 0 0 0 20 0 9 0 72724557 420610048 26623 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30225] ppid=30219 vsize=410752 CPUtime=0
/proc/30220/task/30225/stat : 30225 (java) S 30219 30219 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 20 0 9 0 72724557 420610048 26623 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30226] ppid=30219 vsize=410752 CPUtime=0
/proc/30220/task/30226/stat : 30226 (java) S 30219 30219 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 9 0 72724558 420610048 26623 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30227] ppid=30219 vsize=410752 CPUtime=0.02
/proc/30220/task/30227/stat : 30227 (java) S 30219 30219 22717 34817 22717 4202560 440 0 0 0 2 0 0 0 19 0 9 0 72724558 420610048 26623 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30228] ppid=30219 vsize=410752 CPUtime=0
/proc/30220/task/30228/stat : 30228 (java) S 30219 30219 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 25 0 9 0 72724559 420610048 26623 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30229] ppid=30219 vsize=410752 CPUtime=0
/proc/30220/task/30229/stat : 30229 (java) R 30219 30219 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 15 0 9 0 72724559 420610048 26623 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 1.51
Current children cumulated vsize (KiB) 413320

[startup+3.13199 s]
/proc/loadavg: 1.00 1.05 1.01 2/43 30229
/proc/meminfo: memFree=425476/1048576 swapFree=0/0
[pid=30219] ppid=30218 vsize=2568 CPUtime=0.01
/proc/30219/stat : 30219 (gj-user-solver-) S 30218 30219 22717 34817 22717 4202496 371 0 0 0 0 1 0 0 22 0 1 0 72724556 2629632 268 1283457024 134512640 135304128 4292042416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/30219/statm: 642 268 229 194 0 29 0
[pid=30220] ppid=30219 vsize=410884 CPUtime=3.12
/proc/30220/stat : 30220 (java) S 30219 30219 22717 34817 22717 4202496 48966 0 1 0 297 15 0 0 22 0 9 0 72724556 420745216 48206 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30220/statm: 102721 48206 2901 10 0 96869 0
[pid=30220/tid=30221] ppid=30219 vsize=410884 CPUtime=1.48
/proc/30220/task/30221/stat : 30221 (java) R 30219 30219 22717 34817 22717 4202560 14235 0 1 0 140 8 0 0 25 0 9 0 72724556 420745216 48206 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=30220/tid=30223] ppid=30219 vsize=410884 CPUtime=1.6
/proc/30220/task/30223/stat : 30223 (java) R 30219 30219 22717 34817 22717 4202560 33348 0 0 0 153 7 0 0 15 0 9 0 72724557 420745216 48206 1283457024 134512640 134550932 4291491216 18446744073709551615 4153470929 0 0 0 16800975 0 0 0 -1 0 0 0 0
[pid=30220/tid=30224] ppid=30219 vsize=410884 CPUtime=0
/proc/30220/task/30224/stat : 30224 (java) S 30219 30219 22717 34817 22717 4202560 15 0 0 0 0 0 0 0 20 0 9 0 72724557 420745216 48206 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30225] ppid=30219 vsize=410884 CPUtime=0
/proc/30220/task/30225/stat : 30225 (java) S 30219 30219 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 20 0 9 0 72724557 420745216 48206 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30226] ppid=30219 vsize=410884 CPUtime=0
/proc/30220/task/30226/stat : 30226 (java) S 30219 30219 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 9 0 72724558 420745216 48206 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30227] ppid=30219 vsize=410884 CPUtime=0.03
/proc/30220/task/30227/stat : 30227 (java) S 30219 30219 22717 34817 22717 4202560 444 0 0 0 3 0 0 0 15 0 9 0 72724558 420745216 48206 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30228] ppid=30219 vsize=410884 CPUtime=0
/proc/30220/task/30228/stat : 30228 (java) S 30219 30219 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 25 0 9 0 72724559 420745216 48206 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30229] ppid=30219 vsize=410884 CPUtime=0
/proc/30220/task/30229/stat : 30229 (java) R 30219 30219 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 15 0 9 0 72724559 420745216 48206 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 3.13
Current children cumulated vsize (KiB) 413452

[startup+6.30315 s]
/proc/loadavg: 1.00 1.05 1.01 3/43 30229
/proc/meminfo: memFree=293788/1048576 swapFree=0/0
[pid=30219] ppid=30218 vsize=2568 CPUtime=0.01
/proc/30219/stat : 30219 (gj-user-solver-) S 30218 30219 22717 34817 22717 4202496 371 0 0 0 0 1 0 0 22 0 1 0 72724556 2629632 268 1283457024 134512640 135304128 4292042416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/30219/statm: 642 268 229 194 0 29 0
[pid=30220] ppid=30219 vsize=411352 CPUtime=6.29
/proc/30220/stat : 30220 (java) S 30219 30219 22717 34817 22717 4202496 71211 0 1 0 610 19 0 0 22 0 10 0 72724556 421224448 70357 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30220/statm: 102838 70357 2918 10 0 96983 0
[pid=30220/tid=30221] ppid=30219 vsize=411352 CPUtime=2.89
/proc/30220/task/30221/stat : 30221 (java) R 30219 30219 22717 34817 22717 4202560 14500 0 1 0 280 9 0 0 25 0 10 0 72724556 421224448 70357 1283457024 134512640 134550932 4291491216 18446744073709551615 4115990564 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=30220/tid=30223] ppid=30219 vsize=411352 CPUtime=3.29
/proc/30220/task/30223/stat : 30223 (java) S 30219 30219 22717 34817 22717 4202560 55245 0 0 0 319 10 0 0 16 0 10 0 72724557 421224448 70357 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30224] ppid=30219 vsize=411352 CPUtime=0
/proc/30220/task/30224/stat : 30224 (java) S 30219 30219 22717 34817 22717 4202560 15 0 0 0 0 0 0 0 18 0 10 0 72724557 421224448 70357 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30225] ppid=30219 vsize=411352 CPUtime=0
/proc/30220/task/30225/stat : 30225 (java) S 30219 30219 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 18 0 10 0 72724557 421224448 70357 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30226] ppid=30219 vsize=411352 CPUtime=0
/proc/30220/task/30226/stat : 30226 (java) S 30219 30219 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 10 0 72724558 421224448 70357 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30227] ppid=30219 vsize=411352 CPUtime=0.1
/proc/30220/task/30227/stat : 30227 (java) S 30219 30219 22717 34817 22717 4202560 522 0 0 0 10 0 0 0 16 0 10 0 72724558 421224448 70357 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30228] ppid=30219 vsize=411352 CPUtime=0
/proc/30220/task/30228/stat : 30228 (java) S 30219 30219 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 25 0 10 0 72724559 421224448 70357 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30229] ppid=30219 vsize=411352 CPUtime=0
/proc/30220/task/30229/stat : 30229 (java) S 30219 30219 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 15 0 10 0 72724559 421224448 70357 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 6.3
Current children cumulated vsize (KiB) 413920

[startup+12.7049 s]
/proc/loadavg: 1.08 1.06 1.02 2/44 30230
/proc/meminfo: memFree=287340/1048576 swapFree=0/0
[pid=30219] ppid=30218 vsize=2568 CPUtime=0.01
/proc/30219/stat : 30219 (gj-user-solver-) S 30218 30219 22717 34817 22717 4202496 371 0 0 0 0 1 0 0 22 0 1 0 72724556 2629632 268 1283457024 134512640 135304128 4292042416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/30219/statm: 642 268 229 194 0 29 0
[pid=30220] ppid=30219 vsize=411484 CPUtime=12.68
/proc/30220/stat : 30220 (java) S 30219 30219 22717 34817 22717 4202496 71397 0 1 0 1249 19 0 0 22 0 10 0 72724556 421359616 70543 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30220/statm: 102871 70543 2920 10 0 97016 0
[pid=30220/tid=30221] ppid=30219 vsize=411484 CPUtime=8.74
/proc/30220/task/30221/stat : 30221 (java) R 30219 30219 22717 34817 22717 4202560 14508 0 1 0 865 9 0 0 25 0 10 0 72724556 421359616 70543 1283457024 134512640 134550932 4291491216 18446744073709551615 4116119029 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=30220/tid=30223] ppid=30219 vsize=411484 CPUtime=3.79
/proc/30220/task/30223/stat : 30223 (java) S 30219 30219 22717 34817 22717 4202560 55388 0 0 0 369 10 0 0 16 0 10 0 72724557 421359616 70543 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30224] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30224/stat : 30224 (java) S 30219 30219 22717 34817 22717 4202560 15 0 0 0 0 0 0 0 18 0 10 0 72724557 421359616 70543 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30225] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30225/stat : 30225 (java) S 30219 30219 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 18 0 10 0 72724557 421359616 70543 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30226] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30226/stat : 30226 (java) S 30219 30219 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 10 0 72724558 421359616 70543 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30227] ppid=30219 vsize=411484 CPUtime=0.14
/proc/30220/task/30227/stat : 30227 (java) S 30219 30219 22717 34817 22717 4202560 557 0 0 0 14 0 0 0 16 0 10 0 72724558 421359616 70543 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30228] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30228/stat : 30228 (java) S 30219 30219 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 25 0 10 0 72724559 421359616 70543 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30229] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30229/stat : 30229 (java) S 30219 30219 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 15 0 10 0 72724559 421359616 70543 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30230] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30230/stat : 30230 (java) S 30219 30219 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 25 0 10 0 72725147 421359616 70543 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 12.69
Current children cumulated vsize (KiB) 414052

[startup+25.5088 s]
/proc/loadavg: 1.14 1.08 1.02 2/44 30230
/proc/meminfo: memFree=287340/1048576 swapFree=0/0
[pid=30219] ppid=30218 vsize=2568 CPUtime=0.01
/proc/30219/stat : 30219 (gj-user-solver-) S 30218 30219 22717 34817 22717 4202496 371 0 0 0 0 1 0 0 22 0 1 0 72724556 2629632 268 1283457024 134512640 135304128 4292042416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/30219/statm: 642 268 229 194 0 29 0
[pid=30220] ppid=30219 vsize=411484 CPUtime=25.48
/proc/30220/stat : 30220 (java) S 30219 30219 22717 34817 22717 4202496 71406 0 1 0 2529 19 0 0 22 0 10 0 72724556 421359616 70552 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30220/statm: 102871 70552 2922 10 0 97016 0
[pid=30220/tid=30221] ppid=30219 vsize=411484 CPUtime=21.02
/proc/30220/task/30221/stat : 30221 (java) R 30219 30219 22717 34817 22717 4202560 14508 0 1 0 2093 9 0 0 25 0 10 0 72724556 421359616 70552 1283457024 134512640 134550932 4291491216 18446744073709551615 4115942255 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=30220/tid=30223] ppid=30219 vsize=411484 CPUtime=4.3
/proc/30220/task/30223/stat : 30223 (java) S 30219 30219 22717 34817 22717 4202560 55390 0 0 0 420 10 0 0 16 0 10 0 72724557 421359616 70552 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30224] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30224/stat : 30224 (java) S 30219 30219 22717 34817 22717 4202560 15 0 0 0 0 0 0 0 18 0 10 0 72724557 421359616 70552 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30225] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30225/stat : 30225 (java) S 30219 30219 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 18 0 10 0 72724557 421359616 70552 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30226] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30226/stat : 30226 (java) S 30219 30219 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 10 0 72724558 421359616 70552 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30227] ppid=30219 vsize=411484 CPUtime=0.16
/proc/30220/task/30227/stat : 30227 (java) S 30219 30219 22717 34817 22717 4202560 564 0 0 0 16 0 0 0 15 0 10 0 72724558 421359616 70552 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30228] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30228/stat : 30228 (java) S 30219 30219 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 25 0 10 0 72724559 421359616 70552 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30229] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30229/stat : 30229 (java) R 30219 30219 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 15 0 10 0 72724559 421359616 70552 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=30220/tid=30230] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30230/stat : 30230 (java) S 30219 30219 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 25 0 10 0 72725147 421359616 70552 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 25.49
Current children cumulated vsize (KiB) 414052

[startup+51.1146 s]
/proc/loadavg: 1.09 1.07 1.02 2/44 30230
/proc/meminfo: memFree=287216/1048576 swapFree=0/0
[pid=30219] ppid=30218 vsize=2568 CPUtime=0.01
/proc/30219/stat : 30219 (gj-user-solver-) S 30218 30219 22717 34817 22717 4202496 371 0 0 0 0 1 0 0 22 0 1 0 72724556 2629632 268 1283457024 134512640 135304128 4292042416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/30219/statm: 642 268 229 194 0 29 0
[pid=30220] ppid=30219 vsize=411484 CPUtime=51.04
/proc/30220/stat : 30220 (java) S 30219 30219 22717 34817 22717 4202496 71409 0 1 0 5085 19 0 0 22 0 10 0 72724556 421359616 70555 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30220/statm: 102871 70555 2922 10 0 97016 0
[pid=30220/tid=30221] ppid=30219 vsize=411484 CPUtime=46.26
/proc/30220/task/30221/stat : 30221 (java) R 30219 30219 22717 34817 22717 4202560 14508 0 1 0 4617 9 0 0 25 0 10 0 72724556 421359616 70555 1283457024 134512640 134550932 4291491216 18446744073709551615 4116134409 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=30220/tid=30223] ppid=30219 vsize=411484 CPUtime=4.62
/proc/30220/task/30223/stat : 30223 (java) S 30219 30219 22717 34817 22717 4202560 55390 0 0 0 452 10 0 0 15 0 10 0 72724557 421359616 70555 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30224] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30224/stat : 30224 (java) S 30219 30219 22717 34817 22717 4202560 15 0 0 0 0 0 0 0 18 0 10 0 72724557 421359616 70555 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30225] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30225/stat : 30225 (java) S 30219 30219 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 18 0 10 0 72724557 421359616 70555 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30226] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30226/stat : 30226 (java) S 30219 30219 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 10 0 72724558 421359616 70555 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30227] ppid=30219 vsize=411484 CPUtime=0.16
/proc/30220/task/30227/stat : 30227 (java) S 30219 30219 22717 34817 22717 4202560 567 0 0 0 16 0 0 0 15 0 10 0 72724558 421359616 70555 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30228] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30228/stat : 30228 (java) S 30219 30219 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 25 0 10 0 72724559 421359616 70555 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30229] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30229/stat : 30229 (java) S 30219 30219 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 15 0 10 0 72724559 421359616 70555 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30230] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30230/stat : 30230 (java) S 30219 30219 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 25 0 10 0 72725147 421359616 70555 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 51.05
Current children cumulated vsize (KiB) 414052

[startup+102.312 s]
/proc/loadavg: 1.04 1.06 1.02 2/44 30230
/proc/meminfo: memFree=287092/1048576 swapFree=0/0
[pid=30219] ppid=30218 vsize=2568 CPUtime=0.01
/proc/30219/stat : 30219 (gj-user-solver-) S 30218 30219 22717 34817 22717 4202496 371 0 0 0 0 1 0 0 22 0 1 0 72724556 2629632 268 1283457024 134512640 135304128 4292042416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/30219/statm: 642 268 229 194 0 29 0
[pid=30220] ppid=30219 vsize=411484 CPUtime=102.2
/proc/30220/stat : 30220 (java) S 30219 30219 22717 34817 22717 4202496 71414 0 1 0 10201 19 0 0 22 0 10 0 72724556 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30220/statm: 102871 70560 2922 10 0 97016 0
[pid=30220/tid=30221] ppid=30219 vsize=411484 CPUtime=97.02
/proc/30220/task/30221/stat : 30221 (java) R 30219 30219 22717 34817 22717 4202560 14508 0 1 0 9693 9 0 0 25 0 10 0 72724556 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4116134442 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=30220/tid=30223] ppid=30219 vsize=411484 CPUtime=5.02
/proc/30220/task/30223/stat : 30223 (java) S 30219 30219 22717 34817 22717 4202560 55390 0 0 0 492 10 0 0 15 0 10 0 72724557 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30224] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30224/stat : 30224 (java) S 30219 30219 22717 34817 22717 4202560 15 0 0 0 0 0 0 0 18 0 10 0 72724557 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30225] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30225/stat : 30225 (java) S 30219 30219 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 18 0 10 0 72724557 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30226] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30226/stat : 30226 (java) S 30219 30219 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 10 0 72724558 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30227] ppid=30219 vsize=411484 CPUtime=0.16
/proc/30220/task/30227/stat : 30227 (java) S 30219 30219 22717 34817 22717 4202560 572 0 0 0 16 0 0 0 15 0 10 0 72724558 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30228] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30228/stat : 30228 (java) S 30219 30219 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 25 0 10 0 72724559 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30229] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30229/stat : 30229 (java) S 30219 30219 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 15 0 10 0 72724559 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30230] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30230/stat : 30230 (java) S 30219 30219 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 25 0 10 0 72725147 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 102.21
Current children cumulated vsize (KiB) 414052

[startup+162.306 s]
/proc/loadavg: 1.01 1.04 1.01 2/44 30230
/proc/meminfo: memFree=287092/1048576 swapFree=0/0
[pid=30219] ppid=30218 vsize=2568 CPUtime=0.01
/proc/30219/stat : 30219 (gj-user-solver-) S 30218 30219 22717 34817 22717 4202496 371 0 0 0 0 1 0 0 22 0 1 0 72724556 2629632 268 1283457024 134512640 135304128 4292042416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/30219/statm: 642 268 229 194 0 29 0
[pid=30220] ppid=30219 vsize=411484 CPUtime=162.13
/proc/30220/stat : 30220 (java) S 30219 30219 22717 34817 22717 4202496 71414 0 1 0 16193 20 0 0 22 0 10 0 72724556 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30220/statm: 102871 70560 2922 10 0 97016 0
[pid=30220/tid=30221] ppid=30219 vsize=411484 CPUtime=156.52
/proc/30220/task/30221/stat : 30221 (java) R 30219 30219 22717 34817 22717 4202560 14508 0 1 0 15642 10 0 0 25 0 10 0 72724556 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4116149445 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=30220/tid=30223] ppid=30219 vsize=411484 CPUtime=5.44
/proc/30220/task/30223/stat : 30223 (java) S 30219 30219 22717 34817 22717 4202560 55390 0 0 0 534 10 0 0 16 0 10 0 72724557 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30224] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30224/stat : 30224 (java) S 30219 30219 22717 34817 22717 4202560 15 0 0 0 0 0 0 0 18 0 10 0 72724557 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30225] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30225/stat : 30225 (java) S 30219 30219 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 18 0 10 0 72724557 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30226] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30226/stat : 30226 (java) S 30219 30219 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 10 0 72724558 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30227] ppid=30219 vsize=411484 CPUtime=0.16
/proc/30220/task/30227/stat : 30227 (java) S 30219 30219 22717 34817 22717 4202560 572 0 0 0 16 0 0 0 15 0 10 0 72724558 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30228] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30228/stat : 30228 (java) S 30219 30219 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 25 0 10 0 72724559 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30229] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30229/stat : 30229 (java) S 30219 30219 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 15 0 10 0 72724559 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30230] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30230/stat : 30230 (java) S 30219 30219 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 25 0 10 0 72725147 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 162.14
Current children cumulated vsize (KiB) 414052

[startup+222.313 s]
/proc/loadavg: 1.00 1.03 1.00 2/46 30236
/proc/meminfo: memFree=286820/1048576 swapFree=0/0
[pid=30219] ppid=30218 vsize=2568 CPUtime=0.01
/proc/30219/stat : 30219 (gj-user-solver-) S 30218 30219 22717 34817 22717 4202496 371 0 0 0 0 1 0 0 22 0 1 0 72724556 2629632 268 1283457024 134512640 135304128 4292042416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/30219/statm: 642 268 229 194 0 29 0
[pid=30220] ppid=30219 vsize=411484 CPUtime=222.01
/proc/30220/stat : 30220 (java) S 30219 30219 22717 34817 22717 4202496 71414 0 1 0 22179 22 0 0 22 0 10 0 72724556 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30220/statm: 102871 70560 2922 10 0 97016 0
[pid=30220/tid=30221] ppid=30219 vsize=411484 CPUtime=215.96
/proc/30220/task/30221/stat : 30221 (java) R 30219 30219 22717 34817 22717 4202560 14508 0 1 0 21584 12 0 0 25 0 10 0 72724556 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4116134409 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=30220/tid=30223] ppid=30219 vsize=411484 CPUtime=5.88
/proc/30220/task/30223/stat : 30223 (java) R 30219 30219 22717 34817 22717 4202560 55390 0 0 0 578 10 0 0 15 0 10 0 72724557 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 0 0 16800975 0 0 0 -1 0 0 0 0
[pid=30220/tid=30224] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30224/stat : 30224 (java) S 30219 30219 22717 34817 22717 4202560 15 0 0 0 0 0 0 0 18 0 10 0 72724557 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30225] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30225/stat : 30225 (java) S 30219 30219 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 18 0 10 0 72724557 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30226] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30226/stat : 30226 (java) S 30219 30219 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 10 0 72724558 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30227] ppid=30219 vsize=411484 CPUtime=0.16
/proc/30220/task/30227/stat : 30227 (java) S 30219 30219 22717 34817 22717 4202560 572 0 0 0 16 0 0 0 15 0 10 0 72724558 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30228] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30228/stat : 30228 (java) S 30219 30219 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 25 0 10 0 72724559 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30229] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30229/stat : 30229 (java) S 30219 30219 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 15 0 10 0 72724559 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30230] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30230/stat : 30230 (java) S 30219 30219 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 25 0 10 0 72725147 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 222.02
Current children cumulated vsize (KiB) 414052

[startup+282.309 s]
/proc/loadavg: 1.00 1.02 1.00 2/45 30241
/proc/meminfo: memFree=286836/1048576 swapFree=0/0
[pid=30219] ppid=30218 vsize=2568 CPUtime=0.01
/proc/30219/stat : 30219 (gj-user-solver-) S 30218 30219 22717 34817 22717 4202496 371 0 0 0 0 1 0 0 22 0 1 0 72724556 2629632 268 1283457024 134512640 135304128 4292042416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/30219/statm: 642 268 229 194 0 29 0
[pid=30220] ppid=30219 vsize=411484 CPUtime=281.93
/proc/30220/stat : 30220 (java) S 30219 30219 22717 34817 22717 4202496 71414 0 1 0 28171 22 0 0 22 0 10 0 72724556 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30220/statm: 102871 70560 2922 10 0 97016 0
[pid=30220/tid=30221] ppid=30219 vsize=411484 CPUtime=275.52
/proc/30220/task/30221/stat : 30221 (java) R 30219 30219 22717 34817 22717 4202560 14508 0 1 0 27540 12 0 0 25 0 10 0 72724556 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4116149432 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=30220/tid=30223] ppid=30219 vsize=411484 CPUtime=6.23
/proc/30220/task/30223/stat : 30223 (java) S 30219 30219 22717 34817 22717 4202560 55390 0 0 0 613 10 0 0 15 0 10 0 72724557 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30224] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30224/stat : 30224 (java) S 30219 30219 22717 34817 22717 4202560 15 0 0 0 0 0 0 0 18 0 10 0 72724557 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30225] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30225/stat : 30225 (java) S 30219 30219 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 18 0 10 0 72724557 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30226] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30226/stat : 30226 (java) S 30219 30219 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 10 0 72724558 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30227] ppid=30219 vsize=411484 CPUtime=0.16
/proc/30220/task/30227/stat : 30227 (java) S 30219 30219 22717 34817 22717 4202560 572 0 0 0 16 0 0 0 15 0 10 0 72724558 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30228] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30228/stat : 30228 (java) S 30219 30219 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 25 0 10 0 72724559 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30229] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30229/stat : 30229 (java) S 30219 30219 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 15 0 10 0 72724559 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30230] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30230/stat : 30230 (java) S 30219 30219 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 25 0 10 0 72725147 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 281.94
Current children cumulated vsize (KiB) 414052

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

[startup+284.61 s]
/proc/loadavg: 1.00 1.02 1.00 2/45 30241
/proc/meminfo: memFree=286836/1048576 swapFree=0/0
[pid=30219] ppid=30218 vsize=2568 CPUtime=0.01
/proc/30219/stat : 30219 (gj-user-solver-) S 30218 30219 22717 34817 22717 4202496 371 0 0 0 0 1 0 0 22 0 1 0 72724556 2629632 268 1283457024 134512640 135304128 4292042416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/30219/statm: 642 268 229 194 0 29 0
[pid=30220] ppid=30219 vsize=411484 CPUtime=284.23
/proc/30220/stat : 30220 (java) S 30219 30219 22717 34817 22717 4202496 71414 0 1 0 28401 22 0 0 22 0 10 0 72724556 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30220/statm: 102871 70560 2922 10 0 97016 0
[pid=30220/tid=30221] ppid=30219 vsize=411484 CPUtime=277.81
/proc/30220/task/30221/stat : 30221 (java) R 30219 30219 22717 34817 22717 4202560 14508 0 1 0 27769 12 0 0 25 0 10 0 72724556 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4116134422 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=30220/tid=30223] ppid=30219 vsize=411484 CPUtime=6.24
/proc/30220/task/30223/stat : 30223 (java) S 30219 30219 22717 34817 22717 4202560 55390 0 0 0 614 10 0 0 15 0 10 0 72724557 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30224] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30224/stat : 30224 (java) S 30219 30219 22717 34817 22717 4202560 15 0 0 0 0 0 0 0 18 0 10 0 72724557 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30225] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30225/stat : 30225 (java) S 30219 30219 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 18 0 10 0 72724557 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30226] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30226/stat : 30226 (java) S 30219 30219 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 10 0 72724558 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30227] ppid=30219 vsize=411484 CPUtime=0.16
/proc/30220/task/30227/stat : 30227 (java) S 30219 30219 22717 34817 22717 4202560 572 0 0 0 16 0 0 0 15 0 10 0 72724558 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30228] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30228/stat : 30228 (java) S 30219 30219 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 25 0 10 0 72724559 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30229] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30229/stat : 30229 (java) S 30219 30219 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 15 0 10 0 72724559 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30230] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30230/stat : 30230 (java) S 30219 30219 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 25 0 10 0 72725147 421359616 70560 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 284.24
Current children cumulated vsize (KiB) 414052

[startup+286.21 s]
/proc/loadavg: 1.00 1.02 1.00 2/44 30241
/proc/meminfo: memFree=286844/1048576 swapFree=0/0
[pid=30219] ppid=30218 vsize=2568 CPUtime=0.01
/proc/30219/stat : 30219 (gj-user-solver-) S 30218 30219 22717 34817 22717 4202496 371 0 0 0 0 1 0 0 22 0 1 0 72724556 2629632 268 1283457024 134512640 135304128 4292042416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/30219/statm: 642 268 229 194 0 29 0
[pid=30220] ppid=30219 vsize=411484 CPUtime=285.82
/proc/30220/stat : 30220 (java) S 30219 30219 22717 34817 22717 4202496 71415 0 1 0 28559 23 0 0 22 0 9 0 72724556 421359616 70561 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30220/statm: 102871 70561 2923 10 0 97016 0
[pid=30220/tid=30221] ppid=30219 vsize=411484 CPUtime=279.39
/proc/30220/task/30221/stat : 30221 (java) R 30219 30219 22717 34817 22717 4202560 14508 0 1 0 27926 13 0 0 25 0 9 0 72724556 421359616 70561 1283457024 134512640 134550932 4291491216 18446744073709551615 4116149445 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=30220/tid=30223] ppid=30219 vsize=411484 CPUtime=6.26
/proc/30220/task/30223/stat : 30223 (java) S 30219 30219 22717 34817 22717 4202560 55390 0 0 0 616 10 0 0 15 0 9 0 72724557 421359616 70561 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30224] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30224/stat : 30224 (java) S 30219 30219 22717 34817 22717 4202560 15 0 0 0 0 0 0 0 18 0 9 0 72724557 421359616 70561 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30225] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30225/stat : 30225 (java) S 30219 30219 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 18 0 9 0 72724557 421359616 70561 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30226] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30226/stat : 30226 (java) S 30219 30219 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 9 0 72724558 421359616 70561 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30227] ppid=30219 vsize=411484 CPUtime=0.16
/proc/30220/task/30227/stat : 30227 (java) S 30219 30219 22717 34817 22717 4202560 572 0 0 0 16 0 0 0 15 0 9 0 72724558 421359616 70561 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30228] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30228/stat : 30228 (java) S 30219 30219 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 25 0 9 0 72724559 421359616 70561 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30229] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30229/stat : 30229 (java) S 30219 30219 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 15 0 9 0 72724559 421359616 70561 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 285.83
Current children cumulated vsize (KiB) 414052

[startup+286.61 s]
/proc/loadavg: 1.00 1.02 1.00 2/44 30241
/proc/meminfo: memFree=286844/1048576 swapFree=0/0
[pid=30219] ppid=30218 vsize=2568 CPUtime=0.01
/proc/30219/stat : 30219 (gj-user-solver-) S 30218 30219 22717 34817 22717 4202496 371 0 0 0 0 1 0 0 22 0 1 0 72724556 2629632 268 1283457024 134512640 135304128 4292042416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/30219/statm: 642 268 229 194 0 29 0
[pid=30220] ppid=30219 vsize=411484 CPUtime=286.22
/proc/30220/stat : 30220 (java) S 30219 30219 22717 34817 22717 4202496 71415 0 1 0 28599 23 0 0 22 0 9 0 72724556 421359616 70561 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30220/statm: 102871 70561 2923 10 0 97016 0
[pid=30220/tid=30221] ppid=30219 vsize=411484 CPUtime=279.79
/proc/30220/task/30221/stat : 30221 (java) R 30219 30219 22717 34817 22717 4202560 14508 0 1 0 27966 13 0 0 25 0 9 0 72724556 421359616 70561 1283457024 134512640 134550932 4291491216 18446744073709551615 4116113073 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=30220/tid=30223] ppid=30219 vsize=411484 CPUtime=6.26
/proc/30220/task/30223/stat : 30223 (java) S 30219 30219 22717 34817 22717 4202560 55390 0 0 0 616 10 0 0 15 0 9 0 72724557 421359616 70561 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30224] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30224/stat : 30224 (java) S 30219 30219 22717 34817 22717 4202560 15 0 0 0 0 0 0 0 18 0 9 0 72724557 421359616 70561 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30225] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30225/stat : 30225 (java) S 30219 30219 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 18 0 9 0 72724557 421359616 70561 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30226] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30226/stat : 30226 (java) S 30219 30219 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 9 0 72724558 421359616 70561 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30227] ppid=30219 vsize=411484 CPUtime=0.16
/proc/30220/task/30227/stat : 30227 (java) S 30219 30219 22717 34817 22717 4202560 572 0 0 0 16 0 0 0 15 0 9 0 72724558 421359616 70561 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30228] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30228/stat : 30228 (java) S 30219 30219 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 25 0 9 0 72724559 421359616 70561 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30229] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30229/stat : 30229 (java) S 30219 30219 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 15 0 9 0 72724559 421359616 70561 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 286.23
Current children cumulated vsize (KiB) 414052

[startup+286.81 s]
/proc/loadavg: 1.00 1.02 1.00 2/44 30241
/proc/meminfo: memFree=286844/1048576 swapFree=0/0
[pid=30219] ppid=30218 vsize=2568 CPUtime=0.01
/proc/30219/stat : 30219 (gj-user-solver-) S 30218 30219 22717 34817 22717 4202496 371 0 0 0 0 1 0 0 22 0 1 0 72724556 2629632 268 1283457024 134512640 135304128 4292042416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/30219/statm: 642 268 229 194 0 29 0
[pid=30220] ppid=30219 vsize=411484 CPUtime=286.42
/proc/30220/stat : 30220 (java) S 30219 30219 22717 34817 22717 4202496 71415 0 1 0 28619 23 0 0 22 0 9 0 72724556 421359616 70561 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30220/statm: 102871 70561 2923 10 0 97016 0
[pid=30220/tid=30221] ppid=30219 vsize=411484 CPUtime=279.99
/proc/30220/task/30221/stat : 30221 (java) R 30219 30219 22717 34817 22717 4202560 14508 0 1 0 27986 13 0 0 25 0 9 0 72724556 421359616 70561 1283457024 134512640 134550932 4291491216 18446744073709551615 4116149439 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=30220/tid=30223] ppid=30219 vsize=411484 CPUtime=6.26
/proc/30220/task/30223/stat : 30223 (java) S 30219 30219 22717 34817 22717 4202560 55390 0 0 0 616 10 0 0 15 0 9 0 72724557 421359616 70561 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 0 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30224] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30224/stat : 30224 (java) S 30219 30219 22717 34817 22717 4202560 15 0 0 0 0 0 0 0 18 0 9 0 72724557 421359616 70561 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30225] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30225/stat : 30225 (java) S 30219 30219 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 18 0 9 0 72724557 421359616 70561 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30226] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30226/stat : 30226 (java) S 30219 30219 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 9 0 72724558 421359616 70561 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30227] ppid=30219 vsize=411484 CPUtime=0.16
/proc/30220/task/30227/stat : 30227 (java) S 30219 30219 22717 34817 22717 4202560 572 0 0 0 16 0 0 0 15 0 9 0 72724558 421359616 70561 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30228] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30228/stat : 30228 (java) S 30219 30219 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 25 0 9 0 72724559 421359616 70561 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
[pid=30220/tid=30229] ppid=30219 vsize=411484 CPUtime=0
/proc/30220/task/30229/stat : 30229 (java) S 30219 30219 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 15 0 9 0 72724559 421359616 70561 1283457024 134512640 134550932 4291491216 18446744073709551615 4294960130 0 4 0 16800975 18446612133395358784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 286.43
Current children cumulated vsize (KiB) 414052

[startup+286.905 s]
/proc/loadavg: 1.00 1.02 1.00 2/37 30242
/proc/meminfo: memFree=290308/1048576 swapFree=0/0
[pid=30219] ppid=30218 vsize=2568 CPUtime=0.01
/proc/30219/stat : 30219 (gj-user-solver-) S 30218 30219 22717 34817 22717 4202496 371 0 0 0 0 1 0 0 22 0 1 0 72724556 2629632 268 1283457024 134512640 135304128 4292042416 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/30219/statm: 642 268 229 194 0 29 0
[pid=30220] ppid=30219 vsize=0 CPUtime=286.5
/proc/30220/stat : 30220 (java) Z 30219 30219 22717 34817 22717 4202508 71419 0 1 0 28627 23 0 0 18 0 2 0 72724556 0 0 1283457024 0 0 0 0 0 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/30220/statm: 0 0 0 0 0 0 0
[pid=30220/tid=30228] ppid=30219 vsize=0 CPUtime=0
/proc/30220/task/30228/stat : 30228 (java) R 30219 30219 22717 34817 22717 4203588 0 0 0 0 0 0 0 0 18 0 2 0 72724559 0 0 1283457024 0 0 0 0 0 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 286.51
Current children cumulated vsize (KiB) 2568

Child status: 0
Real time (s): 286.92
CPU time (s): 286.53
CPU user time (s): 286.274
CPU system time (s): 0.256016
CPU usage (%): 99.8642
Max. virtual memory (cumulated for all children) (KiB): 414052

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 286.274
system time used= 0.256016
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 71801
page faults= 1
swaps= 0
block input operations= 0
block output operations= 0
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 6791
involuntary context switches= 10016

runsolver used 0 second user time and 0 second system time

The end