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/201108241238/gj-trendy-solver-1.0/rand315.cudf.s-e.log.runsolver ./gj-trendy-solver-1.0 /home/misc2010/data/2011/incremental/s-e/rand315.cudf /home/misc2010/tmp/201108241238/gj-trendy-solver-1.0/rand315.cudf.s-e.result 

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.11 1.06 1.01 5/35 8524
/proc/meminfo: memFree=529856/1048576 swapFree=0/0
[pid=8522] ppid=8521 vsize=2564 CPUtime=0
/proc/8522/stat : 8522 (gj-trendy-solve) S 8521 8522 1511 34817 1511 4202496 370 0 0 0 0 0 0 0 18 0 1 0 2111621 2625536 268 1283457024 134512640 135304128 4289695008 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8522/statm: 641 268 229 194 0 28 0
[pid=8523] ppid=8522 vsize=11360 CPUtime=0.01
/proc/8523/stat : 8523 (java) R 8522 8522 1511 34817 1511 4202496 918 0 0 0 0 1 0 0 25 0 2 0 2111621 11632640 651 1283457024 134512640 134550932 4289008544 18446744073709551615 4159123048 0 0 0 0 18446744073709551615 0 0 17 0 0 0 0
/proc/8523/statm: 2840 651 285 10 0 1186 0
[pid=8523/tid=8524] ppid=8522 vsize=11360 CPUtime=0
/proc/8523/task/8524/stat : 8524 (java) R 8522 8522 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 2 0 2111621 11632640 651 1283457024 134512640 134550932 4289008544 18446744073709551615 4159123048 0 0 0 0 0 0 0 -1 0 0 0 0

[startup+0.185388 s]
/proc/loadavg: 1.11 1.06 1.01 5/35 8524
/proc/meminfo: memFree=529856/1048576 swapFree=0/0
[pid=8522] ppid=8521 vsize=2564 CPUtime=0
/proc/8522/stat : 8522 (gj-trendy-solve) S 8521 8522 1511 34817 1511 4202496 370 0 0 0 0 0 0 0 18 0 1 0 2111621 2625536 268 1283457024 134512640 135304128 4289695008 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8522/statm: 641 268 229 194 0 28 0
[pid=8523] ppid=8522 vsize=410104 CPUtime=0.19
/proc/8523/stat : 8523 (java) S 8522 8522 1511 34817 1511 4202496 4255 0 1 0 17 2 0 0 25 0 9 0 2111621 419946496 3686 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/8523/statm: 102526 3686 1929 10 0 96674 0
[pid=8523/tid=8524] ppid=8522 vsize=410104 CPUtime=0.16
/proc/8523/task/8524/stat : 8524 (java) R 8522 8522 1511 34817 1511 4202560 3060 0 1 0 16 0 0 0 25 0 9 0 2111621 419946496 3686 1283457024 134512640 134550932 4289008544 18446744073709551615 4114481271 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 0.19
Current children cumulated vsize (KiB) 412668

[startup+0.205384 s]
/proc/loadavg: 1.11 1.06 1.01 5/35 8524
/proc/meminfo: memFree=529856/1048576 swapFree=0/0
[pid=8522] ppid=8521 vsize=2564 CPUtime=0
/proc/8522/stat : 8522 (gj-trendy-solve) S 8521 8522 1511 34817 1511 4202496 370 0 0 0 0 0 0 0 18 0 1 0 2111621 2625536 268 1283457024 134512640 135304128 4289695008 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8522/statm: 641 268 229 194 0 28 0
[pid=8523] ppid=8522 vsize=410104 CPUtime=0.21
/proc/8523/stat : 8523 (java) S 8522 8522 1511 34817 1511 4202496 4405 0 1 0 19 2 0 0 25 0 9 0 2111621 419946496 3836 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/8523/statm: 102526 3836 1929 10 0 96674 0
[pid=8523/tid=8524] ppid=8522 vsize=410104 CPUtime=0.18
/proc/8523/task/8524/stat : 8524 (java) R 8522 8522 1511 34817 1511 4202560 3210 0 1 0 18 0 0 0 25 0 9 0 2111621 419946496 3836 1283457024 134512640 134550932 4289008544 18446744073709551615 4114480078 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) 412668

[startup+0.311231 s]
/proc/loadavg: 1.11 1.06 1.01 5/35 8524
/proc/meminfo: memFree=529856/1048576 swapFree=0/0
[pid=8522] ppid=8521 vsize=2564 CPUtime=0
/proc/8522/stat : 8522 (gj-trendy-solve) S 8521 8522 1511 34817 1511 4202496 370 0 0 0 0 0 0 0 18 0 1 0 2111621 2625536 268 1283457024 134512640 135304128 4289695008 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8522/statm: 641 268 229 194 0 28 0
[pid=8523] ppid=8522 vsize=410248 CPUtime=0.31
/proc/8523/stat : 8523 (java) S 8522 8522 1511 34817 1511 4202496 6114 0 1 0 29 2 0 0 25 0 9 0 2111621 420093952 5544 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/8523/statm: 102562 5544 1938 10 0 96710 0
[pid=8523/tid=8524] ppid=8522 vsize=410248 CPUtime=0.24
/proc/8523/task/8524/stat : 8524 (java) R 8522 8522 1511 34817 1511 4202560 3503 0 1 0 24 0 0 0 25 0 9 0 2111621 420093952 5544 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 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) 412812

[startup+0.705485 s]
/proc/loadavg: 1.11 1.06 1.01 5/35 8524
/proc/meminfo: memFree=529856/1048576 swapFree=0/0
[pid=8522] ppid=8521 vsize=2564 CPUtime=0
/proc/8522/stat : 8522 (gj-trendy-solve) S 8521 8522 1511 34817 1511 4202496 370 0 0 0 0 0 0 0 18 0 1 0 2111621 2625536 268 1283457024 134512640 135304128 4289695008 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8522/statm: 641 268 229 194 0 28 0
[pid=8523] ppid=8522 vsize=410684 CPUtime=0.71
/proc/8523/stat : 8523 (java) S 8522 8522 1511 34817 1511 4202496 12864 0 1 0 67 4 0 0 25 0 9 0 2111621 420540416 12110 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/8523/statm: 102671 12110 2895 10 0 96819 0
[pid=8523/tid=8524] ppid=8522 vsize=410684 CPUtime=0.43
/proc/8523/task/8524/stat : 8524 (java) R 8522 8522 1511 34817 1511 4202560 4191 0 1 0 42 1 0 0 25 0 9 0 2111621 420540416 12110 1283457024 134512640 134550932 4289008544 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) 413248

[startup+1.50564 s]
/proc/loadavg: 1.26 1.09 1.02 2/43 8532
/proc/meminfo: memFree=471996/1048576 swapFree=0/0
[pid=8522] ppid=8521 vsize=2564 CPUtime=0
/proc/8522/stat : 8522 (gj-trendy-solve) S 8521 8522 1511 34817 1511 4202496 370 0 0 0 0 0 0 0 18 0 1 0 2111621 2625536 268 1283457024 134512640 135304128 4289695008 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8522/statm: 641 268 229 194 0 28 0
[pid=8523] ppid=8522 vsize=410816 CPUtime=1.51
/proc/8523/stat : 8523 (java) S 8522 8522 1511 34817 1511 4202496 27758 0 1 0 141 10 0 0 25 0 9 0 2111621 420675584 27004 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/8523/statm: 102704 27004 2896 10 0 96852 0
[pid=8523/tid=8524] ppid=8522 vsize=410816 CPUtime=0.75
/proc/8523/task/8524/stat : 8524 (java) R 8522 8522 1511 34817 1511 4202560 6735 0 1 0 71 4 0 0 25 0 9 0 2111621 420675584 27004 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=8523/tid=8526] ppid=8522 vsize=410816 CPUtime=0.71
/proc/8523/task/8526/stat : 8526 (java) R 8522 8522 1511 34817 1511 4202560 19655 0 0 0 67 4 0 0 19 0 9 0 2111622 420675584 27004 1283457024 134512640 134550932 4289008544 18446744073709551615 4152219623 0 0 0 16800975 0 0 0 -1 0 0 0 0
[pid=8523/tid=8527] ppid=8522 vsize=410816 CPUtime=0
/proc/8523/task/8527/stat : 8527 (java) S 8522 8522 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 21 0 9 0 2111622 420675584 27004 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8528] ppid=8522 vsize=410816 CPUtime=0
/proc/8523/task/8528/stat : 8528 (java) S 8522 8522 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 21 0 9 0 2111622 420675584 27004 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8529] ppid=8522 vsize=410816 CPUtime=0
/proc/8523/task/8529/stat : 8529 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 9 0 2111623 420675584 27004 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8530] ppid=8522 vsize=410816 CPUtime=0.02
/proc/8523/task/8530/stat : 8530 (java) S 8522 8522 1511 34817 1511 4202560 427 0 0 0 2 0 0 0 17 0 9 0 2111623 420675584 27004 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8531] ppid=8522 vsize=410816 CPUtime=0
/proc/8523/task/8531/stat : 8531 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 9 0 2111623 420675584 27004 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8532] ppid=8522 vsize=410816 CPUtime=0
/proc/8523/task/8532/stat : 8532 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 9 0 2111623 420675584 27004 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 1.51
Current children cumulated vsize (KiB) 413380

[startup+3.10602 s]
/proc/loadavg: 1.26 1.09 1.02 3/43 8532
/proc/meminfo: memFree=401068/1048576 swapFree=0/0
[pid=8522] ppid=8521 vsize=2564 CPUtime=0
/proc/8522/stat : 8522 (gj-trendy-solve) S 8521 8522 1511 34817 1511 4202496 370 0 0 0 0 0 0 0 18 0 1 0 2111621 2625536 268 1283457024 134512640 135304128 4289695008 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8522/statm: 641 268 229 194 0 28 0
[pid=8523] ppid=8522 vsize=411152 CPUtime=3.1
/proc/8523/stat : 8523 (java) S 8522 8522 1511 34817 1511 4202496 39375 0 1 0 298 12 0 0 25 0 10 0 2111621 421019648 38539 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/8523/statm: 102788 38539 2921 10 0 96933 0
[pid=8523/tid=8524] ppid=8522 vsize=411152 CPUtime=1.82
/proc/8523/task/8524/stat : 8524 (java) R 8522 8522 1511 34817 1511 4202560 9721 0 1 0 177 5 0 0 25 0 10 0 2111621 421019648 38539 1283457024 134512640 134550932 4289008544 18446744073709551615 4115312555 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=8523/tid=8526] ppid=8522 vsize=411152 CPUtime=1.15
/proc/8523/task/8526/stat : 8526 (java) S 8522 8522 1511 34817 1511 4202560 28189 0 0 0 110 5 0 0 16 0 10 0 2111622 421019648 38539 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 0 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8527] ppid=8522 vsize=411152 CPUtime=0
/proc/8523/task/8527/stat : 8527 (java) S 8522 8522 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 18 0 10 0 2111622 421019648 38539 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8528] ppid=8522 vsize=411152 CPUtime=0
/proc/8523/task/8528/stat : 8528 (java) S 8522 8522 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 18 0 10 0 2111622 421019648 38539 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8529] ppid=8522 vsize=411152 CPUtime=0
/proc/8523/task/8529/stat : 8529 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 2111623 421019648 38539 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8530] ppid=8522 vsize=411152 CPUtime=0.11
/proc/8523/task/8530/stat : 8530 (java) S 8522 8522 1511 34817 1511 4202560 519 0 0 0 11 0 0 0 15 0 10 0 2111623 421019648 38539 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8531] ppid=8522 vsize=411152 CPUtime=0
/proc/8523/task/8531/stat : 8531 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 2111623 421019648 38539 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8532] ppid=8522 vsize=411152 CPUtime=0
/proc/8523/task/8532/stat : 8532 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 10 0 2111623 421019648 38539 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 3.1
Current children cumulated vsize (KiB) 413716

[startup+6.30679 s]
/proc/loadavg: 1.24 1.09 1.02 2/44 8533
/proc/meminfo: memFree=382584/1048576 swapFree=0/0
[pid=8522] ppid=8521 vsize=2564 CPUtime=0
/proc/8522/stat : 8522 (gj-trendy-solve) S 8521 8522 1511 34817 1511 4202496 370 0 0 0 0 0 0 0 18 0 1 0 2111621 2625536 268 1283457024 134512640 135304128 4289695008 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8522/statm: 641 268 229 194 0 28 0
[pid=8523] ppid=8522 vsize=411284 CPUtime=6.3
/proc/8523/stat : 8523 (java) S 8522 8522 1511 34817 1511 4202496 40784 0 1 0 616 14 0 0 25 0 10 0 2111621 421154816 39939 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/8523/statm: 102821 39939 2915 10 0 96966 0
[pid=8523/tid=8524] ppid=8522 vsize=411284 CPUtime=4.77
/proc/8523/task/8524/stat : 8524 (java) R 8522 8522 1511 34817 1511 4202560 9722 0 1 0 472 5 0 0 25 0 10 0 2111621 421154816 39939 1283457024 134512640 134550932 4289008544 18446744073709551615 4115276132 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=8523/tid=8526] ppid=8522 vsize=411284 CPUtime=1.38
/proc/8523/task/8526/stat : 8526 (java) S 8522 8522 1511 34817 1511 4202560 29588 0 0 0 130 8 0 0 16 0 10 0 2111622 421154816 39939 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 0 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8527] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8527/stat : 8527 (java) S 8522 8522 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 18 0 10 0 2111622 421154816 39939 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8528] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8528/stat : 8528 (java) S 8522 8522 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 18 0 10 0 2111622 421154816 39939 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8529] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8529/stat : 8529 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 2111623 421154816 39939 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8530] ppid=8522 vsize=411284 CPUtime=0.13
/proc/8523/task/8530/stat : 8530 (java) S 8522 8522 1511 34817 1511 4202560 528 0 0 0 13 0 0 0 15 0 10 0 2111623 421154816 39939 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8531] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8531/stat : 8531 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 2111623 421154816 39939 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8532] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8532/stat : 8532 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 10 0 2111623 421154816 39939 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8533] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8533/stat : 8533 (java) S 8522 8522 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 25 0 10 0 2111866 421154816 39939 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 6.3
Current children cumulated vsize (KiB) 413848

[startup+12.7086 s]
/proc/loadavg: 1.22 1.09 1.02 4/44 8533
/proc/meminfo: memFree=382468/1048576 swapFree=0/0
[pid=8522] ppid=8521 vsize=2564 CPUtime=0
/proc/8522/stat : 8522 (gj-trendy-solve) S 8521 8522 1511 34817 1511 4202496 370 0 0 0 0 0 0 0 18 0 1 0 2111621 2625536 268 1283457024 134512640 135304128 4289695008 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8522/statm: 641 268 229 194 0 28 0
[pid=8523] ppid=8522 vsize=411284 CPUtime=12.69
/proc/8523/stat : 8523 (java) S 8522 8522 1511 34817 1511 4202496 40785 0 1 0 1255 14 0 0 25 0 10 0 2111621 421154816 39940 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/8523/statm: 102821 39940 2915 10 0 96966 0
[pid=8523/tid=8524] ppid=8522 vsize=411284 CPUtime=10.9
/proc/8523/task/8524/stat : 8524 (java) R 8522 8522 1511 34817 1511 4202560 9722 0 1 0 1085 5 0 0 25 0 10 0 2111621 421154816 39940 1283457024 134512640 134550932 4289008544 18446744073709551615 4114859564 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=8523/tid=8526] ppid=8522 vsize=411284 CPUtime=1.64
/proc/8523/task/8526/stat : 8526 (java) S 8522 8522 1511 34817 1511 4202560 29588 0 0 0 156 8 0 0 16 0 10 0 2111622 421154816 39940 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 0 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8527] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8527/stat : 8527 (java) S 8522 8522 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 18 0 10 0 2111622 421154816 39940 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8528] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8528/stat : 8528 (java) S 8522 8522 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 18 0 10 0 2111622 421154816 39940 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8529] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8529/stat : 8529 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 2111623 421154816 39940 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8530] ppid=8522 vsize=411284 CPUtime=0.13
/proc/8523/task/8530/stat : 8530 (java) S 8522 8522 1511 34817 1511 4202560 529 0 0 0 13 0 0 0 15 0 10 0 2111623 421154816 39940 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8531] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8531/stat : 8531 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 2111623 421154816 39940 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8532] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8532/stat : 8532 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 10 0 2111623 421154816 39940 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8533] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8533/stat : 8533 (java) S 8522 8522 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 25 0 10 0 2111866 421154816 39940 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 12.69
Current children cumulated vsize (KiB) 413848

[startup+25.5126 s]
/proc/loadavg: 1.17 1.08 1.02 3/44 8533
/proc/meminfo: memFree=382468/1048576 swapFree=0/0
[pid=8522] ppid=8521 vsize=2564 CPUtime=0
/proc/8522/stat : 8522 (gj-trendy-solve) S 8521 8522 1511 34817 1511 4202496 370 0 0 0 0 0 0 0 18 0 1 0 2111621 2625536 268 1283457024 134512640 135304128 4289695008 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8522/statm: 641 268 229 194 0 28 0
[pid=8523] ppid=8522 vsize=411284 CPUtime=25.47
/proc/8523/stat : 8523 (java) S 8522 8522 1511 34817 1511 4202496 40785 0 1 0 2533 14 0 0 25 0 10 0 2111621 421154816 39892 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/8523/statm: 102821 39892 2915 10 0 96966 0
[pid=8523/tid=8524] ppid=8522 vsize=411284 CPUtime=23.41
/proc/8523/task/8524/stat : 8524 (java) R 8522 8522 1511 34817 1511 4202560 9722 0 1 0 2336 5 0 0 25 0 10 0 2111621 421154816 39892 1283457024 134512640 134550932 4289008544 18446744073709551615 4115440557 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=8523/tid=8526] ppid=8522 vsize=411284 CPUtime=1.92
/proc/8523/task/8526/stat : 8526 (java) S 8522 8522 1511 34817 1511 4202560 29588 0 0 0 184 8 0 0 15 0 10 0 2111622 421154816 39892 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 0 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8527] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8527/stat : 8527 (java) S 8522 8522 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 18 0 10 0 2111622 421154816 39892 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8528] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8528/stat : 8528 (java) S 8522 8522 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 18 0 10 0 2111622 421154816 39892 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8529] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8529/stat : 8529 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 2111623 421154816 39892 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8530] ppid=8522 vsize=411284 CPUtime=0.13
/proc/8523/task/8530/stat : 8530 (java) S 8522 8522 1511 34817 1511 4202560 529 0 0 0 13 0 0 0 15 0 10 0 2111623 421154816 39892 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8531] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8531/stat : 8531 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 2111623 421154816 39892 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8532] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8532/stat : 8532 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 10 0 2111623 421154816 39892 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8533] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8533/stat : 8533 (java) S 8522 8522 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 25 0 10 0 2111866 421154816 39892 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 25.47
Current children cumulated vsize (KiB) 413848

[startup+51.1077 s]
/proc/loadavg: 1.11 1.08 1.02 2/44 8533
/proc/meminfo: memFree=382468/1048576 swapFree=0/0
[pid=8522] ppid=8521 vsize=2564 CPUtime=0
/proc/8522/stat : 8522 (gj-trendy-solve) S 8521 8522 1511 34817 1511 4202496 370 0 0 0 0 0 0 0 18 0 1 0 2111621 2625536 268 1283457024 134512640 135304128 4289695008 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8522/statm: 641 268 229 194 0 28 0
[pid=8523] ppid=8522 vsize=411284 CPUtime=51.04
/proc/8523/stat : 8523 (java) S 8522 8522 1511 34817 1511 4202496 40785 0 1 0 5088 16 0 0 25 0 10 0 2111621 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/8523/statm: 102821 39764 2915 10 0 96966 0
[pid=8523/tid=8524] ppid=8522 vsize=411284 CPUtime=48.33
/proc/8523/task/8524/stat : 8524 (java) R 8522 8522 1511 34817 1511 4202560 9722 0 1 0 4827 6 0 0 25 0 10 0 2111621 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4115253926 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=8523/tid=8526] ppid=8522 vsize=411284 CPUtime=2.55
/proc/8523/task/8526/stat : 8526 (java) S 8522 8522 1511 34817 1511 4202560 29588 0 0 0 247 8 0 0 16 0 10 0 2111622 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 0 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8527] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8527/stat : 8527 (java) S 8522 8522 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 18 0 10 0 2111622 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8528] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8528/stat : 8528 (java) S 8522 8522 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 18 0 10 0 2111622 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8529] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8529/stat : 8529 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 2111623 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8530] ppid=8522 vsize=411284 CPUtime=0.13
/proc/8523/task/8530/stat : 8530 (java) S 8522 8522 1511 34817 1511 4202560 529 0 0 0 13 0 0 0 15 0 10 0 2111623 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8531] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8531/stat : 8531 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 2111623 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8532] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8532/stat : 8532 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 10 0 2111623 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8533] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8533/stat : 8533 (java) S 8522 8522 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 25 0 10 0 2111866 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 51.04
Current children cumulated vsize (KiB) 413848

[startup+102.308 s]
/proc/loadavg: 1.05 1.06 1.01 2/44 8533
/proc/meminfo: memFree=382468/1048576 swapFree=0/0
[pid=8522] ppid=8521 vsize=2564 CPUtime=0
/proc/8522/stat : 8522 (gj-trendy-solve) S 8521 8522 1511 34817 1511 4202496 370 0 0 0 0 0 0 0 18 0 1 0 2111621 2625536 268 1283457024 134512640 135304128 4289695008 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8522/statm: 641 268 229 194 0 28 0
[pid=8523] ppid=8522 vsize=411284 CPUtime=102.22
/proc/8523/stat : 8523 (java) S 8522 8522 1511 34817 1511 4202496 40785 0 1 0 10206 16 0 0 25 0 10 0 2111621 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/8523/statm: 102821 39764 2915 10 0 96966 0
[pid=8523/tid=8524] ppid=8522 vsize=411284 CPUtime=98.85
/proc/8523/task/8524/stat : 8524 (java) R 8522 8522 1511 34817 1511 4202560 9722 0 1 0 9879 6 0 0 25 0 10 0 2111621 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4115247844 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=8523/tid=8526] ppid=8522 vsize=411284 CPUtime=3.21
/proc/8523/task/8526/stat : 8526 (java) S 8522 8522 1511 34817 1511 4202560 29588 0 0 0 313 8 0 0 15 0 10 0 2111622 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 0 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8527] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8527/stat : 8527 (java) S 8522 8522 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 18 0 10 0 2111622 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8528] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8528/stat : 8528 (java) S 8522 8522 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 18 0 10 0 2111622 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8529] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8529/stat : 8529 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 2111623 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8530] ppid=8522 vsize=411284 CPUtime=0.13
/proc/8523/task/8530/stat : 8530 (java) S 8522 8522 1511 34817 1511 4202560 529 0 0 0 13 0 0 0 15 0 10 0 2111623 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8531] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8531/stat : 8531 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 2111623 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8532] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8532/stat : 8532 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 10 0 2111623 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8533] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8533/stat : 8533 (java) S 8522 8522 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 25 0 10 0 2111866 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 102.22
Current children cumulated vsize (KiB) 413848

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

[startup+102.408 s]
/proc/loadavg: 1.05 1.06 1.01 2/44 8533
/proc/meminfo: memFree=382468/1048576 swapFree=0/0
[pid=8522] ppid=8521 vsize=2564 CPUtime=0
/proc/8522/stat : 8522 (gj-trendy-solve) S 8521 8522 1511 34817 1511 4202496 370 0 0 0 0 0 0 0 18 0 1 0 2111621 2625536 268 1283457024 134512640 135304128 4289695008 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8522/statm: 641 268 229 194 0 28 0
[pid=8523] ppid=8522 vsize=411284 CPUtime=102.32
/proc/8523/stat : 8523 (java) S 8522 8522 1511 34817 1511 4202496 40785 0 1 0 10216 16 0 0 25 0 10 0 2111621 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/8523/statm: 102821 39764 2915 10 0 96966 0
[pid=8523/tid=8524] ppid=8522 vsize=411284 CPUtime=98.95
/proc/8523/task/8524/stat : 8524 (java) R 8522 8522 1511 34817 1511 4202560 9722 0 1 0 9889 6 0 0 25 0 10 0 2111621 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4115349770 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=8523/tid=8526] ppid=8522 vsize=411284 CPUtime=3.21
/proc/8523/task/8526/stat : 8526 (java) S 8522 8522 1511 34817 1511 4202560 29588 0 0 0 313 8 0 0 15 0 10 0 2111622 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 0 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8527] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8527/stat : 8527 (java) S 8522 8522 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 18 0 10 0 2111622 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8528] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8528/stat : 8528 (java) S 8522 8522 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 18 0 10 0 2111622 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8529] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8529/stat : 8529 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 2111623 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8530] ppid=8522 vsize=411284 CPUtime=0.13
/proc/8523/task/8530/stat : 8530 (java) S 8522 8522 1511 34817 1511 4202560 529 0 0 0 13 0 0 0 15 0 10 0 2111623 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8531] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8531/stat : 8531 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 2111623 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8532] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8532/stat : 8532 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 10 0 2111623 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8533] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8533/stat : 8533 (java) S 8522 8522 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 25 0 10 0 2111866 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 102.32
Current children cumulated vsize (KiB) 413848

[startup+108.809 s]
/proc/loadavg: 1.04 1.06 1.01 2/44 8533
/proc/meminfo: memFree=382468/1048576 swapFree=0/0
[pid=8522] ppid=8521 vsize=2564 CPUtime=0
/proc/8522/stat : 8522 (gj-trendy-solve) S 8521 8522 1511 34817 1511 4202496 370 0 0 0 0 0 0 0 18 0 1 0 2111621 2625536 268 1283457024 134512640 135304128 4289695008 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8522/statm: 641 268 229 194 0 28 0
[pid=8523] ppid=8522 vsize=411284 CPUtime=108.71
/proc/8523/stat : 8523 (java) S 8522 8522 1511 34817 1511 4202496 40785 0 1 0 10855 16 0 0 25 0 10 0 2111621 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/8523/statm: 102821 39764 2915 10 0 96966 0
[pid=8523/tid=8524] ppid=8522 vsize=411284 CPUtime=105.2
/proc/8523/task/8524/stat : 8524 (java) R 8522 8522 1511 34817 1511 4202560 9722 0 1 0 10514 6 0 0 25 0 10 0 2111621 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4115283076 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=8523/tid=8526] ppid=8522 vsize=411284 CPUtime=3.35
/proc/8523/task/8526/stat : 8526 (java) S 8522 8522 1511 34817 1511 4202560 29588 0 0 0 327 8 0 0 15 0 10 0 2111622 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 0 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8527] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8527/stat : 8527 (java) S 8522 8522 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 18 0 10 0 2111622 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8528] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8528/stat : 8528 (java) S 8522 8522 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 18 0 10 0 2111622 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8529] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8529/stat : 8529 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 2111623 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8530] ppid=8522 vsize=411284 CPUtime=0.13
/proc/8523/task/8530/stat : 8530 (java) S 8522 8522 1511 34817 1511 4202560 529 0 0 0 13 0 0 0 15 0 10 0 2111623 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8531] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8531/stat : 8531 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 2111623 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8532] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8532/stat : 8532 (java) R 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 10 0 2111623 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=8523/tid=8533] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8533/stat : 8533 (java) S 8522 8522 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 25 0 10 0 2111866 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 108.71
Current children cumulated vsize (KiB) 413848

[startup+110.409 s]
/proc/loadavg: 1.04 1.06 1.01 3/44 8533
/proc/meminfo: memFree=382468/1048576 swapFree=0/0
[pid=8522] ppid=8521 vsize=2564 CPUtime=0
/proc/8522/stat : 8522 (gj-trendy-solve) S 8521 8522 1511 34817 1511 4202496 370 0 0 0 0 0 0 0 18 0 1 0 2111621 2625536 268 1283457024 134512640 135304128 4289695008 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8522/statm: 641 268 229 194 0 28 0
[pid=8523] ppid=8522 vsize=411284 CPUtime=110.31
/proc/8523/stat : 8523 (java) S 8522 8522 1511 34817 1511 4202496 40785 0 1 0 11015 16 0 0 25 0 10 0 2111621 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/8523/statm: 102821 39764 2915 10 0 96966 0
[pid=8523/tid=8524] ppid=8522 vsize=411284 CPUtime=106.8
/proc/8523/task/8524/stat : 8524 (java) R 8522 8522 1511 34817 1511 4202560 9722 0 1 0 10674 6 0 0 25 0 10 0 2111621 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4115296202 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=8523/tid=8526] ppid=8522 vsize=411284 CPUtime=3.35
/proc/8523/task/8526/stat : 8526 (java) S 8522 8522 1511 34817 1511 4202560 29588 0 0 0 327 8 0 0 15 0 10 0 2111622 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 0 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8527] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8527/stat : 8527 (java) S 8522 8522 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 18 0 10 0 2111622 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8528] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8528/stat : 8528 (java) S 8522 8522 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 18 0 10 0 2111622 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8529] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8529/stat : 8529 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 2111623 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8530] ppid=8522 vsize=411284 CPUtime=0.13
/proc/8523/task/8530/stat : 8530 (java) S 8522 8522 1511 34817 1511 4202560 529 0 0 0 13 0 0 0 15 0 10 0 2111623 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8531] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8531/stat : 8531 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 2111623 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8532] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8532/stat : 8532 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 10 0 2111623 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8533] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8533/stat : 8533 (java) S 8522 8522 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 25 0 10 0 2111866 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 110.31
Current children cumulated vsize (KiB) 413848

[startup+112.01 s]
/proc/loadavg: 1.04 1.06 1.01 2/44 8533
/proc/meminfo: memFree=382468/1048576 swapFree=0/0
[pid=8522] ppid=8521 vsize=2564 CPUtime=0
/proc/8522/stat : 8522 (gj-trendy-solve) S 8521 8522 1511 34817 1511 4202496 370 0 0 0 0 0 0 0 18 0 1 0 2111621 2625536 268 1283457024 134512640 135304128 4289695008 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8522/statm: 641 268 229 194 0 28 0
[pid=8523] ppid=8522 vsize=411284 CPUtime=111.91
/proc/8523/stat : 8523 (java) S 8522 8522 1511 34817 1511 4202496 40785 0 1 0 11175 16 0 0 25 0 10 0 2111621 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/8523/statm: 102821 39764 2915 10 0 96966 0
[pid=8523/tid=8524] ppid=8522 vsize=411284 CPUtime=108.4
/proc/8523/task/8524/stat : 8524 (java) R 8522 8522 1511 34817 1511 4202560 9722 0 1 0 10834 6 0 0 25 0 10 0 2111621 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4115260808 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=8523/tid=8526] ppid=8522 vsize=411284 CPUtime=3.35
/proc/8523/task/8526/stat : 8526 (java) S 8522 8522 1511 34817 1511 4202560 29588 0 0 0 327 8 0 0 15 0 10 0 2111622 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 0 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8527] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8527/stat : 8527 (java) S 8522 8522 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 18 0 10 0 2111622 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8528] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8528/stat : 8528 (java) S 8522 8522 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 18 0 10 0 2111622 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8529] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8529/stat : 8529 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 2111623 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8530] ppid=8522 vsize=411284 CPUtime=0.13
/proc/8523/task/8530/stat : 8530 (java) S 8522 8522 1511 34817 1511 4202560 529 0 0 0 13 0 0 0 15 0 10 0 2111623 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8531] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8531/stat : 8531 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 2111623 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8532] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8532/stat : 8532 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 10 0 2111623 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8533] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8533/stat : 8533 (java) S 8522 8522 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 25 0 10 0 2111866 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 111.91
Current children cumulated vsize (KiB) 413848

[startup+112.41 s]
/proc/loadavg: 1.04 1.06 1.01 2/44 8533
/proc/meminfo: memFree=382468/1048576 swapFree=0/0
[pid=8522] ppid=8521 vsize=2564 CPUtime=0
/proc/8522/stat : 8522 (gj-trendy-solve) S 8521 8522 1511 34817 1511 4202496 370 0 0 0 0 0 0 0 18 0 1 0 2111621 2625536 268 1283457024 134512640 135304128 4289695008 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8522/statm: 641 268 229 194 0 28 0
[pid=8523] ppid=8522 vsize=411284 CPUtime=112.31
/proc/8523/stat : 8523 (java) S 8522 8522 1511 34817 1511 4202496 40785 0 1 0 11215 16 0 0 25 0 10 0 2111621 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/8523/statm: 102821 39764 2915 10 0 96966 0
[pid=8523/tid=8524] ppid=8522 vsize=411284 CPUtime=108.8
/proc/8523/task/8524/stat : 8524 (java) R 8522 8522 1511 34817 1511 4202560 9722 0 1 0 10874 6 0 0 25 0 10 0 2111621 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4114859552 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=8523/tid=8526] ppid=8522 vsize=411284 CPUtime=3.35
/proc/8523/task/8526/stat : 8526 (java) S 8522 8522 1511 34817 1511 4202560 29588 0 0 0 327 8 0 0 15 0 10 0 2111622 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 0 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8527] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8527/stat : 8527 (java) S 8522 8522 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 18 0 10 0 2111622 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8528] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8528/stat : 8528 (java) S 8522 8522 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 18 0 10 0 2111622 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8529] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8529/stat : 8529 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 2111623 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8530] ppid=8522 vsize=411284 CPUtime=0.13
/proc/8523/task/8530/stat : 8530 (java) S 8522 8522 1511 34817 1511 4202560 529 0 0 0 13 0 0 0 15 0 10 0 2111623 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8531] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8531/stat : 8531 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 2111623 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8532] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8532/stat : 8532 (java) R 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 10 0 2111623 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=8523/tid=8533] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8533/stat : 8533 (java) S 8522 8522 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 25 0 10 0 2111866 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 112.31
Current children cumulated vsize (KiB) 413848

[startup+112.61 s]
/proc/loadavg: 1.04 1.06 1.01 2/44 8533
/proc/meminfo: memFree=382468/1048576 swapFree=0/0
[pid=8522] ppid=8521 vsize=2564 CPUtime=0
/proc/8522/stat : 8522 (gj-trendy-solve) S 8521 8522 1511 34817 1511 4202496 370 0 0 0 0 0 0 0 18 0 1 0 2111621 2625536 268 1283457024 134512640 135304128 4289695008 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8522/statm: 641 268 229 194 0 28 0
[pid=8523] ppid=8522 vsize=411284 CPUtime=112.51
/proc/8523/stat : 8523 (java) S 8522 8522 1511 34817 1511 4202496 40785 0 1 0 11235 16 0 0 25 0 10 0 2111621 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/8523/statm: 102821 39764 2915 10 0 96966 0
[pid=8523/tid=8524] ppid=8522 vsize=411284 CPUtime=109
/proc/8523/task/8524/stat : 8524 (java) R 8522 8522 1511 34817 1511 4202560 9722 0 1 0 10894 6 0 0 25 0 10 0 2111621 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4115395717 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=8523/tid=8526] ppid=8522 vsize=411284 CPUtime=3.35
/proc/8523/task/8526/stat : 8526 (java) S 8522 8522 1511 34817 1511 4202560 29588 0 0 0 327 8 0 0 15 0 10 0 2111622 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 0 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8527] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8527/stat : 8527 (java) S 8522 8522 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 18 0 10 0 2111622 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8528] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8528/stat : 8528 (java) S 8522 8522 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 18 0 10 0 2111622 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8529] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8529/stat : 8529 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 2111623 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8530] ppid=8522 vsize=411284 CPUtime=0.13
/proc/8523/task/8530/stat : 8530 (java) S 8522 8522 1511 34817 1511 4202560 529 0 0 0 13 0 0 0 15 0 10 0 2111623 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8531] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8531/stat : 8531 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 2111623 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8532] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8532/stat : 8532 (java) S 8522 8522 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 10 0 2111623 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
[pid=8523/tid=8533] ppid=8522 vsize=411284 CPUtime=0
/proc/8523/task/8533/stat : 8533 (java) S 8522 8522 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 25 0 10 0 2111866 421154816 39764 1283457024 134512640 134550932 4289008544 18446744073709551615 4294960130 0 4 0 16800975 18446612133160794944 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 112.51
Current children cumulated vsize (KiB) 413848

Child status: 0
Real time (s): 112.655
CPU time (s): 112.543
CPU user time (s): 112.367
CPU system time (s): 0.176011
CPU usage (%): 99.9007
Max. virtual memory (cumulated for all children) (KiB): 413848

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 112.367
system time used= 0.176011
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 41171
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= 2777
involuntary context switches= 3830

runsolver used 0 second user time and 0 second system time

The end