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/e381ba7e-a192-11e0-8647-00163e1e087d.cudf.dudf-real.log.runsolver ./gj-user-solver-1.0 /home/misc2010/data/2011/dudf-real//e381ba7e-a192-11e0-8647-00163e1e087d.cudf /home/misc2010/tmp/201109011757/gj-user-solver-1.0/e381ba7e-a192-11e0-8647-00163e1e087d.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: 0.85 0.97 0.99 3/35 3919 /proc/meminfo: memFree=240888/1048576 swapFree=0/0 [pid=3917] ppid=3916 vsize=2568 CPUtime=0 /proc/3917/stat : 3917 (gj-user-solver-) S 3916 3917 22717 34817 22717 4202496 371 0 0 0 0 0 0 0 24 0 1 0 73691392 2629632 269 1283457024 134512640 135304128 4286673296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/3917/statm: 642 269 229 194 0 29 0 [pid=3918] ppid=3917 vsize=11356 CPUtime=0.01 /proc/3918/stat : 3918 (java) S 3917 3917 22717 34817 22717 4202496 917 0 0 0 0 1 0 0 24 0 2 0 73691392 11628544 651 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 0 0 0 18446744073709551615 0 0 17 0 0 0 0 /proc/3918/statm: 2839 651 285 10 0 1185 0 [pid=3918/tid=3919] ppid=3917 vsize=11356 CPUtime=0 /proc/3918/task/3919/stat : 3919 (java) R 3917 3917 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 25 0 2 0 73691393 11628544 651 1283457024 134512640 134550932 4293152544 18446744073709551615 4159250024 0 0 0 0 0 0 0 -1 0 0 0 0 [startup+0.1769 s] /proc/loadavg: 0.85 0.97 0.99 3/35 3919 /proc/meminfo: memFree=240888/1048576 swapFree=0/0 [pid=3917] ppid=3916 vsize=2568 CPUtime=0 /proc/3917/stat : 3917 (gj-user-solver-) S 3916 3917 22717 34817 22717 4202496 371 0 0 0 0 0 0 0 24 0 1 0 73691392 2629632 269 1283457024 134512640 135304128 4286673296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/3917/statm: 642 269 229 194 0 29 0 [pid=3918] ppid=3917 vsize=410068 CPUtime=0.17 /proc/3918/stat : 3918 (java) S 3917 3917 22717 34817 22717 4202496 4174 0 1 0 14 3 0 0 24 0 9 0 73691392 419909632 3602 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/3918/statm: 102517 3602 1946 10 0 96665 0 [pid=3918/tid=3919] ppid=3917 vsize=410068 CPUtime=0.16 /proc/3918/task/3919/stat : 3919 (java) R 3917 3917 22717 34817 22717 4202560 2973 0 1 0 14 2 0 0 25 0 9 0 73691393 419909632 3602 1283457024 134512640 134550932 4293152544 18446744073709551615 4114608154 0 4 0 16800975 0 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 0.17 Current children cumulated vsize (KiB) 412636 [startup+0.206916 s] /proc/loadavg: 0.85 0.97 0.99 3/35 3919 /proc/meminfo: memFree=240888/1048576 swapFree=0/0 [pid=3917] ppid=3916 vsize=2568 CPUtime=0 /proc/3917/stat : 3917 (gj-user-solver-) S 3916 3917 22717 34817 22717 4202496 371 0 0 0 0 0 0 0 24 0 1 0 73691392 2629632 269 1283457024 134512640 135304128 4286673296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/3917/statm: 642 269 229 194 0 29 0 [pid=3918] ppid=3917 vsize=410068 CPUtime=0.21 /proc/3918/stat : 3918 (java) S 3917 3917 22717 34817 22717 4202496 4366 0 1 0 18 3 0 0 24 0 9 0 73691392 419909632 3794 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/3918/statm: 102517 3794 1946 10 0 96665 0 [pid=3918/tid=3919] ppid=3917 vsize=410068 CPUtime=0.19 /proc/3918/task/3919/stat : 3919 (java) R 3917 3917 22717 34817 22717 4202560 3165 0 1 0 17 2 0 0 25 0 9 0 73691393 419909632 3794 1283457024 134512640 134550932 4293152544 18446744073709551615 4150630491 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) 412636 [startup+0.306936 s] /proc/loadavg: 0.85 0.97 0.99 3/35 3919 /proc/meminfo: memFree=240888/1048576 swapFree=0/0 [pid=3917] ppid=3916 vsize=2568 CPUtime=0 /proc/3917/stat : 3917 (gj-user-solver-) S 3916 3917 22717 34817 22717 4202496 371 0 0 0 0 0 0 0 24 0 1 0 73691392 2629632 269 1283457024 134512640 135304128 4286673296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/3917/statm: 642 269 229 194 0 29 0 [pid=3918] ppid=3917 vsize=410376 CPUtime=0.31 /proc/3918/stat : 3918 (java) S 3917 3917 22717 34817 22717 4202496 5419 0 1 0 27 4 0 0 24 0 9 0 73691392 420225024 4846 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/3918/statm: 102594 4846 1957 10 0 96742 0 [pid=3918/tid=3919] ppid=3917 vsize=410376 CPUtime=0.26 /proc/3918/task/3919/stat : 3919 (java) R 3917 3917 22717 34817 22717 4202560 3527 0 1 0 24 2 0 0 25 0 9 0 73691393 420225024 4846 1283457024 134512640 134550932 4293152544 18446744073709551615 4115020929 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) 412944 [startup+0.707027 s] /proc/loadavg: 0.85 0.97 0.99 3/35 3919 /proc/meminfo: memFree=240888/1048576 swapFree=0/0 [pid=3917] ppid=3916 vsize=2568 CPUtime=0 /proc/3917/stat : 3917 (gj-user-solver-) S 3916 3917 22717 34817 22717 4202496 371 0 0 0 0 0 0 0 24 0 1 0 73691392 2629632 269 1283457024 134512640 135304128 4286673296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/3917/statm: 642 269 229 194 0 29 0 [pid=3918] ppid=3917 vsize=410784 CPUtime=0.7 /proc/3918/stat : 3918 (java) S 3917 3917 22717 34817 22717 4202496 12896 0 1 0 62 8 0 0 24 0 9 0 73691392 420642816 12137 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/3918/statm: 102696 12137 2901 10 0 96844 0 [pid=3918/tid=3919] ppid=3917 vsize=410784 CPUtime=0.45 /proc/3918/task/3919/stat : 3919 (java) R 3917 3917 22717 34817 22717 4202560 4215 0 1 0 40 5 0 0 25 0 9 0 73691393 420642816 12137 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 0.7 Current children cumulated vsize (KiB) 413352 [startup+1.50721 s] /proc/loadavg: 0.85 0.97 0.99 3/43 3927 /proc/meminfo: memFree=182880/1048576 swapFree=0/0 [pid=3917] ppid=3916 vsize=2568 CPUtime=0 /proc/3917/stat : 3917 (gj-user-solver-) S 3916 3917 22717 34817 22717 4202496 371 0 0 0 0 0 0 0 24 0 1 0 73691392 2629632 269 1283457024 134512640 135304128 4286673296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/3917/statm: 642 269 229 194 0 29 0 [pid=3918] ppid=3917 vsize=410784 CPUtime=1.51 /proc/3918/stat : 3918 (java) S 3917 3917 22717 34817 22717 4202496 27158 0 1 0 141 10 0 0 24 0 9 0 73691392 420642816 26399 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/3918/statm: 102696 26399 2901 10 0 96844 0 [pid=3918/tid=3919] ppid=3917 vsize=410784 CPUtime=0.81 /proc/3918/task/3919/stat : 3919 (java) R 3917 3917 22717 34817 22717 4202560 6791 0 1 0 75 6 0 0 25 0 9 0 73691393 420642816 26399 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=3918/tid=3921] ppid=3917 vsize=410784 CPUtime=0.65 /proc/3918/task/3921/stat : 3921 (java) R 3917 3917 22717 34817 22717 4202560 18984 0 0 0 63 2 0 0 19 0 9 0 73691394 420642816 26399 1283457024 134512640 134550932 4293152544 18446744073709551615 4150855608 0 0 0 16800975 0 0 0 -1 0 0 0 0 [pid=3918/tid=3922] ppid=3917 vsize=410784 CPUtime=0 /proc/3918/task/3922/stat : 3922 (java) S 3917 3917 22717 34817 22717 4202560 16 0 0 0 0 0 0 0 20 0 9 0 73691394 420642816 26399 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3923] ppid=3917 vsize=410784 CPUtime=0 /proc/3918/task/3923/stat : 3923 (java) S 3917 3917 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 21 0 9 0 73691394 420642816 26399 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3924] ppid=3917 vsize=410784 CPUtime=0 /proc/3918/task/3924/stat : 3924 (java) S 3917 3917 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 9 0 73691395 420642816 26399 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3925] ppid=3917 vsize=410784 CPUtime=0.02 /proc/3918/task/3925/stat : 3925 (java) S 3917 3917 22717 34817 22717 4202560 443 0 0 0 2 0 0 0 18 0 9 0 73691395 420642816 26399 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3926] ppid=3917 vsize=410784 CPUtime=0 /proc/3918/task/3926/stat : 3926 (java) S 3917 3917 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 9 0 73691395 420642816 26399 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3927] ppid=3917 vsize=410784 CPUtime=0 /proc/3918/task/3927/stat : 3927 (java) S 3917 3917 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 15 0 9 0 73691395 420642816 26399 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 1.51 Current children cumulated vsize (KiB) 413352 [startup+3.1076 s] /proc/loadavg: 0.86 0.97 0.99 2/43 3927 /proc/meminfo: memFree=108728/1048576 swapFree=0/0 [pid=3917] ppid=3916 vsize=2568 CPUtime=0 /proc/3917/stat : 3917 (gj-user-solver-) S 3916 3917 22717 34817 22717 4202496 371 0 0 0 0 0 0 0 24 0 1 0 73691392 2629632 269 1283457024 134512640 135304128 4286673296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/3917/statm: 642 269 229 194 0 29 0 [pid=3918] ppid=3917 vsize=410916 CPUtime=3.1 /proc/3918/stat : 3918 (java) S 3917 3917 22717 34817 22717 4202496 47441 0 1 0 293 17 0 0 24 0 9 0 73691392 420777984 46676 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/3918/statm: 102729 46676 2902 10 0 96877 0 [pid=3918/tid=3919] ppid=3917 vsize=410916 CPUtime=1.47 /proc/3918/task/3919/stat : 3919 (java) R 3917 3917 22717 34817 22717 4202560 12818 0 1 0 137 10 0 0 25 0 9 0 73691393 420777984 46676 1283457024 134512640 134550932 4293152544 18446744073709551615 4115132449 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=3918/tid=3921] ppid=3917 vsize=410916 CPUtime=1.58 /proc/3918/task/3921/stat : 3921 (java) S 3917 3917 22717 34817 22717 4202560 33218 0 0 0 154 4 0 0 16 0 9 0 73691394 420777984 46676 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 0 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3922] ppid=3917 vsize=410916 CPUtime=0 /proc/3918/task/3922/stat : 3922 (java) S 3917 3917 22717 34817 22717 4202560 16 0 0 0 0 0 0 0 20 0 9 0 73691394 420777984 46676 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3923] ppid=3917 vsize=410916 CPUtime=0 /proc/3918/task/3923/stat : 3923 (java) S 3917 3917 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 21 0 9 0 73691394 420777984 46676 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3924] ppid=3917 vsize=410916 CPUtime=0 /proc/3918/task/3924/stat : 3924 (java) S 3917 3917 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 9 0 73691395 420777984 46676 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3925] ppid=3917 vsize=410916 CPUtime=0.02 /proc/3918/task/3925/stat : 3925 (java) S 3917 3917 22717 34817 22717 4202560 465 0 0 0 2 0 0 0 15 0 9 0 73691395 420777984 46676 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3926] ppid=3917 vsize=410916 CPUtime=0 /proc/3918/task/3926/stat : 3926 (java) S 3917 3917 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 9 0 73691395 420777984 46676 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3927] ppid=3917 vsize=410916 CPUtime=0 /proc/3918/task/3927/stat : 3927 (java) S 3917 3917 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 15 0 9 0 73691395 420777984 46676 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 3.1 Current children cumulated vsize (KiB) 413484 [startup+6.30871 s] /proc/loadavg: 0.86 0.97 0.99 2/44 3928 /proc/meminfo: memFree=5580/1048576 swapFree=0/0 [pid=3917] ppid=3916 vsize=2568 CPUtime=0 /proc/3917/stat : 3917 (gj-user-solver-) S 3916 3917 22717 34817 22717 4202496 371 0 0 0 0 0 0 0 24 0 1 0 73691392 2629632 269 1283457024 134512640 135304128 4286673296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/3917/statm: 642 269 229 194 0 29 0 [pid=3918] ppid=3917 vsize=411252 CPUtime=6.3 /proc/3918/stat : 3918 (java) S 3917 3917 22717 34817 22717 4202496 63456 0 1 0 609 21 0 0 24 0 10 0 73691392 421122048 62612 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/3918/statm: 102813 62612 2927 10 0 96958 0 [pid=3918/tid=3919] ppid=3917 vsize=411252 CPUtime=4.22 /proc/3918/task/3919/stat : 3919 (java) R 3917 3917 22717 34817 22717 4202560 14503 0 1 0 412 10 0 0 25 0 10 0 73691393 421122048 62612 1283457024 134512640 134550932 4293152544 18446744073709551615 4115553541 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=3918/tid=3921] ppid=3917 vsize=411252 CPUtime=1.95 /proc/3918/task/3921/stat : 3921 (java) S 3917 3917 22717 34817 22717 4202560 47467 0 0 0 186 9 0 0 16 0 10 0 73691394 421122048 62612 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 0 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3922] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3922/stat : 3922 (java) S 3917 3917 22717 34817 22717 4202560 16 0 0 0 0 0 0 0 18 0 10 0 73691394 421122048 62612 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3923] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3923/stat : 3923 (java) S 3917 3917 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 18 0 10 0 73691394 421122048 62612 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3924] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3924/stat : 3924 (java) S 3917 3917 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 10 0 73691395 421122048 62612 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3925] ppid=3917 vsize=411252 CPUtime=0.1 /proc/3918/task/3925/stat : 3925 (java) S 3917 3917 22717 34817 22717 4202560 541 0 0 0 10 0 0 0 15 0 10 0 73691395 421122048 62612 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3926] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3926/stat : 3926 (java) S 3917 3917 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 10 0 73691395 421122048 62612 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3927] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3927/stat : 3927 (java) S 3917 3917 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 15 0 10 0 73691395 421122048 62612 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3928] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3928/stat : 3928 (java) S 3917 3917 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 25 0 10 0 73691783 421122048 62612 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 6.3 Current children cumulated vsize (KiB) 413820 [startup+12.7104 s] /proc/loadavg: 0.87 0.97 0.99 2/44 3928 /proc/meminfo: memFree=5456/1048576 swapFree=0/0 [pid=3917] ppid=3916 vsize=2568 CPUtime=0 /proc/3917/stat : 3917 (gj-user-solver-) S 3916 3917 22717 34817 22717 4202496 371 0 0 0 0 0 0 0 24 0 1 0 73691392 2629632 269 1283457024 134512640 135304128 4286673296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/3917/statm: 642 269 229 194 0 29 0 [pid=3918] ppid=3917 vsize=411252 CPUtime=12.69 /proc/3918/stat : 3918 (java) S 3917 3917 22717 34817 22717 4202496 65362 0 1 0 1248 21 0 0 24 0 10 0 73691392 421122048 64509 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/3918/statm: 102813 64509 2921 10 0 96958 0 [pid=3918/tid=3919] ppid=3917 vsize=411252 CPUtime=10.32 /proc/3918/task/3919/stat : 3919 (java) R 3917 3917 22717 34817 22717 4202560 14504 0 1 0 1022 10 0 0 25 0 10 0 73691393 421122048 64509 1283457024 134512640 134550932 4293152544 18446744073709551615 4115453588 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=3918/tid=3921] ppid=3917 vsize=411252 CPUtime=2.25 /proc/3918/task/3921/stat : 3921 (java) S 3917 3917 22717 34817 22717 4202560 49369 0 0 0 216 9 0 0 15 0 10 0 73691394 421122048 64509 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 0 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3922] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3922/stat : 3922 (java) S 3917 3917 22717 34817 22717 4202560 16 0 0 0 0 0 0 0 18 0 10 0 73691394 421122048 64509 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3923] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3923/stat : 3923 (java) S 3917 3917 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 18 0 10 0 73691394 421122048 64509 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3924] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3924/stat : 3924 (java) S 3917 3917 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 10 0 73691395 421122048 64509 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3925] ppid=3917 vsize=411252 CPUtime=0.1 /proc/3918/task/3925/stat : 3925 (java) S 3917 3917 22717 34817 22717 4202560 544 0 0 0 10 0 0 0 16 0 10 0 73691395 421122048 64509 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3926] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3926/stat : 3926 (java) S 3917 3917 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 10 0 73691395 421122048 64509 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3927] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3927/stat : 3927 (java) S 3917 3917 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 15 0 10 0 73691395 421122048 64509 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3928] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3928/stat : 3928 (java) S 3917 3917 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 25 0 10 0 73691783 421122048 64509 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 12.69 Current children cumulated vsize (KiB) 413820 [startup+25.5028 s] /proc/loadavg: 0.90 0.97 0.99 2/44 3928 /proc/meminfo: memFree=15500/1048576 swapFree=0/0 [pid=3917] ppid=3916 vsize=2568 CPUtime=0 /proc/3917/stat : 3917 (gj-user-solver-) S 3916 3917 22717 34817 22717 4202496 371 0 0 0 0 0 0 0 24 0 1 0 73691392 2629632 269 1283457024 134512640 135304128 4286673296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/3917/statm: 642 269 229 194 0 29 0 [pid=3918] ppid=3917 vsize=411252 CPUtime=25.48 /proc/3918/stat : 3918 (java) S 3917 3917 22717 34817 22717 4202496 65366 0 1 0 2527 21 0 0 24 0 10 0 73691392 421122048 61859 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/3918/statm: 102813 61859 2921 10 0 96958 0 [pid=3918/tid=3919] ppid=3917 vsize=411252 CPUtime=22.69 /proc/3918/task/3919/stat : 3919 (java) R 3917 3917 22717 34817 22717 4202560 14504 0 1 0 2259 10 0 0 25 0 10 0 73691393 421122048 61859 1283457024 134512640 134550932 4293152544 18446744073709551615 4150271426 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=3918/tid=3921] ppid=3917 vsize=411252 CPUtime=2.67 /proc/3918/task/3921/stat : 3921 (java) S 3917 3917 22717 34817 22717 4202560 49369 0 0 0 258 9 0 0 15 0 10 0 73691394 421122048 61859 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 0 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3922] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3922/stat : 3922 (java) S 3917 3917 22717 34817 22717 4202560 16 0 0 0 0 0 0 0 18 0 10 0 73691394 421122048 61859 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3923] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3923/stat : 3923 (java) S 3917 3917 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 18 0 10 0 73691394 421122048 61859 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3924] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3924/stat : 3924 (java) S 3917 3917 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 10 0 73691395 421122048 61859 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3925] ppid=3917 vsize=411252 CPUtime=0.1 /proc/3918/task/3925/stat : 3925 (java) S 3917 3917 22717 34817 22717 4202560 548 0 0 0 10 0 0 0 15 0 10 0 73691395 421122048 61859 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3926] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3926/stat : 3926 (java) S 3917 3917 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 10 0 73691395 421122048 61859 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3927] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3927/stat : 3927 (java) S 3917 3917 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 15 0 10 0 73691395 421122048 61859 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3928] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3928/stat : 3928 (java) S 3917 3917 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 25 0 10 0 73691783 421122048 61859 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 25.48 Current children cumulated vsize (KiB) 413820 [startup+51.1086 s] /proc/loadavg: 0.93 0.97 0.99 2/44 3928 /proc/meminfo: memFree=40176/1048576 swapFree=0/0 [pid=3917] ppid=3916 vsize=2568 CPUtime=0 /proc/3917/stat : 3917 (gj-user-solver-) S 3916 3917 22717 34817 22717 4202496 371 0 0 0 0 0 0 0 24 0 1 0 73691392 2629632 269 1283457024 134512640 135304128 4286673296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/3917/statm: 642 269 229 194 0 29 0 [pid=3918] ppid=3917 vsize=411252 CPUtime=51.07 /proc/3918/stat : 3918 (java) S 3917 3917 22717 34817 22717 4202496 65366 0 1 0 5085 22 0 0 24 0 10 0 73691392 421122048 55719 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/3918/statm: 102813 55719 2921 10 0 96958 0 [pid=3918/tid=3919] ppid=3917 vsize=411252 CPUtime=47.85 /proc/3918/task/3919/stat : 3919 (java) R 3917 3917 22717 34817 22717 4202560 14504 0 1 0 4774 11 0 0 25 0 10 0 73691393 421122048 55719 1283457024 134512640 134550932 4293152544 18446744073709551615 4115464662 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=3918/tid=3921] ppid=3917 vsize=411252 CPUtime=3.09 /proc/3918/task/3921/stat : 3921 (java) S 3917 3917 22717 34817 22717 4202560 49369 0 0 0 300 9 0 0 15 0 10 0 73691394 421122048 55719 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 0 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3922] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3922/stat : 3922 (java) S 3917 3917 22717 34817 22717 4202560 16 0 0 0 0 0 0 0 18 0 10 0 73691394 421122048 55719 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3923] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3923/stat : 3923 (java) S 3917 3917 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 18 0 10 0 73691394 421122048 55719 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3924] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3924/stat : 3924 (java) S 3917 3917 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 10 0 73691395 421122048 55719 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3925] ppid=3917 vsize=411252 CPUtime=0.1 /proc/3918/task/3925/stat : 3925 (java) S 3917 3917 22717 34817 22717 4202560 548 0 0 0 10 0 0 0 15 0 10 0 73691395 421122048 55719 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3926] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3926/stat : 3926 (java) S 3917 3917 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 10 0 73691395 421122048 55719 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3927] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3927/stat : 3927 (java) S 3917 3917 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 15 0 10 0 73691395 421122048 55719 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3928] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3928/stat : 3928 (java) S 3917 3917 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 25 0 10 0 73691783 421122048 55719 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 51.07 Current children cumulated vsize (KiB) 413820 Solver just ended. Dumping a history of the last processes samples [startup+76.7145 s] /proc/loadavg: 0.95 0.97 0.99 3/44 3928 /proc/meminfo: memFree=40176/1048576 swapFree=0/0 [pid=3917] ppid=3916 vsize=2568 CPUtime=0 /proc/3917/stat : 3917 (gj-user-solver-) S 3916 3917 22717 34817 22717 4202496 371 0 0 0 0 0 0 0 24 0 1 0 73691392 2629632 269 1283457024 134512640 135304128 4286673296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/3917/statm: 642 269 229 194 0 29 0 [pid=3918] ppid=3917 vsize=411252 CPUtime=76.65 /proc/3918/stat : 3918 (java) S 3917 3917 22717 34817 22717 4202496 65367 0 1 0 7643 22 0 0 24 0 10 0 73691392 421122048 55720 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/3918/statm: 102813 55720 2921 10 0 96958 0 [pid=3918/tid=3919] ppid=3917 vsize=411252 CPUtime=73 /proc/3918/task/3919/stat : 3919 (java) R 3917 3917 22717 34817 22717 4202560 14504 0 1 0 7289 11 0 0 25 0 10 0 73691393 421122048 55720 1283457024 134512640 134550932 4293152544 18446744073709551615 4115553541 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=3918/tid=3921] ppid=3917 vsize=411252 CPUtime=3.52 /proc/3918/task/3921/stat : 3921 (java) S 3917 3917 22717 34817 22717 4202560 49369 0 0 0 343 9 0 0 15 0 10 0 73691394 421122048 55720 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 0 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3922] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3922/stat : 3922 (java) S 3917 3917 22717 34817 22717 4202560 16 0 0 0 0 0 0 0 15 0 10 0 73691394 421122048 55720 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3923] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3923/stat : 3923 (java) S 3917 3917 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 18 0 10 0 73691394 421122048 55720 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3924] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3924/stat : 3924 (java) S 3917 3917 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 10 0 73691395 421122048 55720 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3925] ppid=3917 vsize=411252 CPUtime=0.1 /proc/3918/task/3925/stat : 3925 (java) S 3917 3917 22717 34817 22717 4202560 549 0 0 0 10 0 0 0 15 0 10 0 73691395 421122048 55720 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3926] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3926/stat : 3926 (java) S 3917 3917 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 10 0 73691395 421122048 55720 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3927] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3927/stat : 3927 (java) R 3917 3917 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 15 0 10 0 73691395 421122048 55720 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=3918/tid=3928] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3928/stat : 3928 (java) S 3917 3917 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 25 0 10 0 73691783 421122048 55720 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 76.65 Current children cumulated vsize (KiB) 413820 [startup+89.5089 s] /proc/loadavg: 0.96 0.97 0.99 2/44 3928 /proc/meminfo: memFree=40176/1048576 swapFree=0/0 [pid=3917] ppid=3916 vsize=2568 CPUtime=0 /proc/3917/stat : 3917 (gj-user-solver-) S 3916 3917 22717 34817 22717 4202496 371 0 0 0 0 0 0 0 24 0 1 0 73691392 2629632 269 1283457024 134512640 135304128 4286673296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/3917/statm: 642 269 229 194 0 29 0 [pid=3918] ppid=3917 vsize=411252 CPUtime=89.39 /proc/3918/stat : 3918 (java) S 3917 3917 22717 34817 22717 4202496 65370 0 1 0 8917 22 0 0 24 0 10 0 73691392 421122048 55723 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/3918/statm: 102813 55723 2921 10 0 96958 0 [pid=3918/tid=3919] ppid=3917 vsize=411252 CPUtime=85.66 /proc/3918/task/3919/stat : 3919 (java) R 3917 3917 22717 34817 22717 4202560 14504 0 1 0 8555 11 0 0 25 0 10 0 73691393 421122048 55723 1283457024 134512640 134550932 4293152544 18446744073709551615 4115547145 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=3918/tid=3921] ppid=3917 vsize=411252 CPUtime=3.61 /proc/3918/task/3921/stat : 3921 (java) S 3917 3917 22717 34817 22717 4202560 49369 0 0 0 352 9 0 0 16 0 10 0 73691394 421122048 55723 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 0 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3922] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3922/stat : 3922 (java) S 3917 3917 22717 34817 22717 4202560 16 0 0 0 0 0 0 0 15 0 10 0 73691394 421122048 55723 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3923] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3923/stat : 3923 (java) S 3917 3917 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 18 0 10 0 73691394 421122048 55723 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3924] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3924/stat : 3924 (java) S 3917 3917 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 10 0 73691395 421122048 55723 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3925] ppid=3917 vsize=411252 CPUtime=0.1 /proc/3918/task/3925/stat : 3925 (java) S 3917 3917 22717 34817 22717 4202560 552 0 0 0 10 0 0 0 15 0 10 0 73691395 421122048 55723 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3926] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3926/stat : 3926 (java) S 3917 3917 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 10 0 73691395 421122048 55723 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3927] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3927/stat : 3927 (java) S 3917 3917 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 15 0 10 0 73691395 421122048 55723 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3928] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3928/stat : 3928 (java) S 3917 3917 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 25 0 10 0 73691783 421122048 55723 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 89.39 Current children cumulated vsize (KiB) 413820 [startup+95.9107 s] /proc/loadavg: 0.97 0.97 0.99 2/44 3928 /proc/meminfo: memFree=40176/1048576 swapFree=0/0 [pid=3917] ppid=3916 vsize=2568 CPUtime=0 /proc/3917/stat : 3917 (gj-user-solver-) S 3916 3917 22717 34817 22717 4202496 371 0 0 0 0 0 0 0 24 0 1 0 73691392 2629632 269 1283457024 134512640 135304128 4286673296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/3917/statm: 642 269 229 194 0 29 0 [pid=3918] ppid=3917 vsize=411252 CPUtime=95.78 /proc/3918/stat : 3918 (java) S 3917 3917 22717 34817 22717 4202496 65376 0 1 0 9556 22 0 0 24 0 10 0 73691392 421122048 55729 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/3918/statm: 102813 55729 2921 10 0 96958 0 [pid=3918/tid=3919] ppid=3917 vsize=411252 CPUtime=91.93 /proc/3918/task/3919/stat : 3919 (java) R 3917 3917 22717 34817 22717 4202560 14504 0 1 0 9182 11 0 0 25 0 10 0 73691393 421122048 55729 1283457024 134512640 134550932 4293152544 18446744073709551615 4115547331 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=3918/tid=3921] ppid=3917 vsize=411252 CPUtime=3.71 /proc/3918/task/3921/stat : 3921 (java) S 3917 3917 22717 34817 22717 4202560 49369 0 0 0 362 9 0 0 16 0 10 0 73691394 421122048 55729 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 0 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3922] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3922/stat : 3922 (java) S 3917 3917 22717 34817 22717 4202560 16 0 0 0 0 0 0 0 15 0 10 0 73691394 421122048 55729 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3923] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3923/stat : 3923 (java) S 3917 3917 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 18 0 10 0 73691394 421122048 55729 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3924] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3924/stat : 3924 (java) S 3917 3917 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 10 0 73691395 421122048 55729 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3925] ppid=3917 vsize=411252 CPUtime=0.11 /proc/3918/task/3925/stat : 3925 (java) S 3917 3917 22717 34817 22717 4202560 558 0 0 0 11 0 0 0 16 0 10 0 73691395 421122048 55729 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3926] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3926/stat : 3926 (java) S 3917 3917 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 10 0 73691395 421122048 55729 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3927] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3927/stat : 3927 (java) S 3917 3917 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 15 0 10 0 73691395 421122048 55729 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3928] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3928/stat : 3928 (java) S 3917 3917 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 25 0 10 0 73691783 421122048 55729 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 95.78 Current children cumulated vsize (KiB) 413820 [startup+99.1117 s] /proc/loadavg: 0.97 0.97 0.99 2/44 3928 /proc/meminfo: memFree=40176/1048576 swapFree=0/0 [pid=3917] ppid=3916 vsize=2568 CPUtime=0 /proc/3917/stat : 3917 (gj-user-solver-) S 3916 3917 22717 34817 22717 4202496 371 0 0 0 0 0 0 0 24 0 1 0 73691392 2629632 269 1283457024 134512640 135304128 4286673296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/3917/statm: 642 269 229 194 0 29 0 [pid=3918] ppid=3917 vsize=411252 CPUtime=98.98 /proc/3918/stat : 3918 (java) S 3917 3917 22717 34817 22717 4202496 65380 0 1 0 9876 22 0 0 24 0 10 0 73691392 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/3918/statm: 102813 55733 2921 10 0 96958 0 [pid=3918/tid=3919] ppid=3917 vsize=411252 CPUtime=95.09 /proc/3918/task/3919/stat : 3919 (java) R 3917 3917 22717 34817 22717 4202560 14504 0 1 0 9498 11 0 0 25 0 10 0 73691393 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4115547168 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=3918/tid=3921] ppid=3917 vsize=411252 CPUtime=3.75 /proc/3918/task/3921/stat : 3921 (java) S 3917 3917 22717 34817 22717 4202560 49369 0 0 0 366 9 0 0 16 0 10 0 73691394 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 0 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3922] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3922/stat : 3922 (java) S 3917 3917 22717 34817 22717 4202560 16 0 0 0 0 0 0 0 15 0 10 0 73691394 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3923] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3923/stat : 3923 (java) S 3917 3917 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 18 0 10 0 73691394 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3924] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3924/stat : 3924 (java) S 3917 3917 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 10 0 73691395 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3925] ppid=3917 vsize=411252 CPUtime=0.12 /proc/3918/task/3925/stat : 3925 (java) S 3917 3917 22717 34817 22717 4202560 562 0 0 0 12 0 0 0 15 0 10 0 73691395 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3926] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3926/stat : 3926 (java) S 3917 3917 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 10 0 73691395 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3927] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3927/stat : 3927 (java) S 3917 3917 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 15 0 10 0 73691395 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3928] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3928/stat : 3928 (java) S 3917 3917 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 25 0 10 0 73691783 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 98.98 Current children cumulated vsize (KiB) 413820 [startup+100.712 s] /proc/loadavg: 0.97 0.97 0.99 2/44 3928 /proc/meminfo: memFree=40176/1048576 swapFree=0/0 [pid=3917] ppid=3916 vsize=2568 CPUtime=0 /proc/3917/stat : 3917 (gj-user-solver-) S 3916 3917 22717 34817 22717 4202496 371 0 0 0 0 0 0 0 24 0 1 0 73691392 2629632 269 1283457024 134512640 135304128 4286673296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/3917/statm: 642 269 229 194 0 29 0 [pid=3918] ppid=3917 vsize=411252 CPUtime=100.58 /proc/3918/stat : 3918 (java) S 3917 3917 22717 34817 22717 4202496 65380 0 1 0 10036 22 0 0 24 0 10 0 73691392 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/3918/statm: 102813 55733 2921 10 0 96958 0 [pid=3918/tid=3919] ppid=3917 vsize=411252 CPUtime=96.66 /proc/3918/task/3919/stat : 3919 (java) R 3917 3917 22717 34817 22717 4202560 14504 0 1 0 9655 11 0 0 25 0 10 0 73691393 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4114581787 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=3918/tid=3921] ppid=3917 vsize=411252 CPUtime=3.77 /proc/3918/task/3921/stat : 3921 (java) S 3917 3917 22717 34817 22717 4202560 49369 0 0 0 368 9 0 0 16 0 10 0 73691394 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 0 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3922] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3922/stat : 3922 (java) S 3917 3917 22717 34817 22717 4202560 16 0 0 0 0 0 0 0 15 0 10 0 73691394 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3923] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3923/stat : 3923 (java) S 3917 3917 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 18 0 10 0 73691394 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3924] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3924/stat : 3924 (java) S 3917 3917 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 10 0 73691395 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3925] ppid=3917 vsize=411252 CPUtime=0.12 /proc/3918/task/3925/stat : 3925 (java) S 3917 3917 22717 34817 22717 4202560 562 0 0 0 12 0 0 0 15 0 10 0 73691395 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3926] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3926/stat : 3926 (java) S 3917 3917 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 10 0 73691395 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3927] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3927/stat : 3927 (java) S 3917 3917 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 15 0 10 0 73691395 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3928] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3928/stat : 3928 (java) S 3917 3917 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 25 0 10 0 73691783 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 100.58 Current children cumulated vsize (KiB) 413820 [startup+101.112 s] /proc/loadavg: 0.97 0.97 0.99 2/44 3928 /proc/meminfo: memFree=40176/1048576 swapFree=0/0 [pid=3917] ppid=3916 vsize=2568 CPUtime=0 /proc/3917/stat : 3917 (gj-user-solver-) S 3916 3917 22717 34817 22717 4202496 371 0 0 0 0 0 0 0 24 0 1 0 73691392 2629632 269 1283457024 134512640 135304128 4286673296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/3917/statm: 642 269 229 194 0 29 0 [pid=3918] ppid=3917 vsize=411252 CPUtime=100.98 /proc/3918/stat : 3918 (java) S 3917 3917 22717 34817 22717 4202496 65380 0 1 0 10076 22 0 0 24 0 10 0 73691392 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/3918/statm: 102813 55733 2921 10 0 96958 0 [pid=3918/tid=3919] ppid=3917 vsize=411252 CPUtime=97.06 /proc/3918/task/3919/stat : 3919 (java) R 3917 3917 22717 34817 22717 4202560 14504 0 1 0 9695 11 0 0 25 0 10 0 73691393 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4115558852 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=3918/tid=3921] ppid=3917 vsize=411252 CPUtime=3.77 /proc/3918/task/3921/stat : 3921 (java) S 3917 3917 22717 34817 22717 4202560 49369 0 0 0 368 9 0 0 16 0 10 0 73691394 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 0 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3922] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3922/stat : 3922 (java) S 3917 3917 22717 34817 22717 4202560 16 0 0 0 0 0 0 0 15 0 10 0 73691394 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3923] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3923/stat : 3923 (java) S 3917 3917 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 18 0 10 0 73691394 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3924] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3924/stat : 3924 (java) S 3917 3917 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 10 0 73691395 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3925] ppid=3917 vsize=411252 CPUtime=0.12 /proc/3918/task/3925/stat : 3925 (java) S 3917 3917 22717 34817 22717 4202560 562 0 0 0 12 0 0 0 15 0 10 0 73691395 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3926] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3926/stat : 3926 (java) S 3917 3917 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 10 0 73691395 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3927] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3927/stat : 3927 (java) S 3917 3917 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 15 0 10 0 73691395 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3928] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3928/stat : 3928 (java) S 3917 3917 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 25 0 10 0 73691783 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 100.98 Current children cumulated vsize (KiB) 413820 [startup+101.312 s] /proc/loadavg: 0.97 0.97 0.99 2/44 3928 /proc/meminfo: memFree=40176/1048576 swapFree=0/0 [pid=3917] ppid=3916 vsize=2568 CPUtime=0 /proc/3917/stat : 3917 (gj-user-solver-) S 3916 3917 22717 34817 22717 4202496 371 0 0 0 0 0 0 0 24 0 1 0 73691392 2629632 269 1283457024 134512640 135304128 4286673296 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/3917/statm: 642 269 229 194 0 29 0 [pid=3918] ppid=3917 vsize=411252 CPUtime=101.18 /proc/3918/stat : 3918 (java) S 3917 3917 22717 34817 22717 4202496 65380 0 1 0 10096 22 0 0 24 0 10 0 73691392 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/3918/statm: 102813 55733 2921 10 0 96958 0 [pid=3918/tid=3919] ppid=3917 vsize=411252 CPUtime=97.26 /proc/3918/task/3919/stat : 3919 (java) R 3917 3917 22717 34817 22717 4202560 14504 0 1 0 9715 11 0 0 25 0 10 0 73691393 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4115456132 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=3918/tid=3921] ppid=3917 vsize=411252 CPUtime=3.77 /proc/3918/task/3921/stat : 3921 (java) S 3917 3917 22717 34817 22717 4202560 49369 0 0 0 368 9 0 0 16 0 10 0 73691394 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 0 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3922] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3922/stat : 3922 (java) S 3917 3917 22717 34817 22717 4202560 16 0 0 0 0 0 0 0 15 0 10 0 73691394 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3923] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3923/stat : 3923 (java) S 3917 3917 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 18 0 10 0 73691394 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3924] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3924/stat : 3924 (java) S 3917 3917 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 10 0 73691395 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3925] ppid=3917 vsize=411252 CPUtime=0.12 /proc/3918/task/3925/stat : 3925 (java) S 3917 3917 22717 34817 22717 4202560 562 0 0 0 12 0 0 0 15 0 10 0 73691395 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3926] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3926/stat : 3926 (java) S 3917 3917 22717 34817 22717 4202560 1 0 0 0 0 0 0 0 25 0 10 0 73691395 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3927] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3927/stat : 3927 (java) S 3917 3917 22717 34817 22717 4202560 0 0 0 0 0 0 0 0 15 0 10 0 73691395 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 [pid=3918/tid=3928] ppid=3917 vsize=411252 CPUtime=0 /proc/3918/task/3928/stat : 3928 (java) S 3917 3917 22717 34817 22717 4202560 5 0 0 0 0 0 0 0 25 0 10 0 73691783 421122048 55733 1283457024 134512640 134550932 4293152544 18446744073709551615 4294960130 0 4 0 16800975 18446612132933239744 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 101.18 Current children cumulated vsize (KiB) 413820 Child status: 0 Real time (s): 101.39 CPU time (s): 101.218 CPU user time (s): 100.982 CPU system time (s): 0.236014 CPU usage (%): 99.8307 Max. virtual memory (cumulated for all children) (KiB): 413820 getrusage(RUSAGE_CHILDREN,...) data: user time used= 100.982 system time used= 0.236014 maximum resident set size= 0 integral shared memory size= 0 integral unshared data size= 0 integral unshared stack size= 0 page reclaims= 65768 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= 2883 involuntary context switches= 4182 runsolver used 0 second user time and 0 second system time The end